Autor Thema: lepresenced und G-Tags - nach einiger Zeit nur noch absent/unreachable  (Gelesen 38873 mal)

Offline PatrickR

  • Developer
  • Sr. Member
  • ****
  • Beiträge: 867
Hi!

Moin Patrick,
nachdem gestern auch der legacymode bei mir versagt hat hab ich wieder auf den standardmode gewechselt und LOG_DEBUG eingeschaltet. Lief ne Weile ganz gut, dann sporadische Aussetzer bis zum Totalausfall, auch nach reboot nur noch absent  :( Nach manuellem Stop und Start wieder sporadisch present. Die 3 G-Tags sind maximal 3 Meter vom Raspi entfernt, auch wenn die RSSI Werte was anderes vermuten lassen. Im Anhang Auszüge aus dem SYSLOG.
Hilf mir mal bitte etwas: Um welche MAC-Adressen geht es und wann waren sie "abwesend" obwohl sie hätten erreichbar sein sollen?

  • Hast Du irgendein Batterieskript/-modul laufen?
  • Hast Du die G-Tags in irgendeiner App hinzugefügt oder auf sonst mit irgendwas verbunden?

Führe mal bitte Folgendes aus:
dpkg -l|egrep -i '(blue|hci)';ps aux|grep [l]epresenced

Patrick
lepresenced - Tracking von Bluetooth-LE-Tags (Gigaset G-Tag) mittels PRESENCE

"Programming today is a race between software engineers striving to build bigger and better idiot-proof programs, and the universe trying to produce bigger and better idiots. So far, the universe is winning." - Rich Cook

Offline arthur_dent_2015

  • Full Member
  • ***
  • Beiträge: 258
Moin Patrick,
meine G-Tags haben die folgenden Adressen:
7C:2F:80:AD:BA:56
7C:2F:80:AD:BA:A8
7C:2F:80:AD:BA:72
Alle 3 hätten über die ganze Zeit erreichbar sein sollen. Batteriescript oder Modul habe ich nicht laufen, wäre aber noch interessant... G-Tags sind an kein anderes Gerät gekoppelt oder mit einer App verbunden.

root@raspberrypi1:/home/pi# dpkg -l|egrep -i '(blue|hci)';ps aux|grep [l]epresenced           
ii  blueman                               1.99~alpha1-1+deb8u1                      armhf        Graphical bluetooth manager
ii  bluetooth                             5.23-2+rpi2                               all          Bluetooth support
ii  bluez                                 5.23-2+rpi2                               armhf        Bluetooth tools and daemons
ii  bluez-firmware                        1.2-3+rpi2                                all          Firmware for Bluetooth devices
ii  bluez-hcidump                         5.23-2+rpi2                               armhf        Analyses Bluetooth HCI packets
ii  bluez-obexd                           5.23-2+rpi2                               armhf        bluez obex daemon
ii  bluez-tools                           0.2.0~20140808-3                          armhf        Set of tools to manage Bluetooth devices for linux
ii  lepresenced                           0.82-1                                    all          lepresenced to detect the presence of Bluetooth LE devices
ii  libbluetooth3:armhf                   5.23-2+rpi2                               armhf        Library to use the BlueZ Linux Bluetooth stack
ii  pi-bluetooth                          0.1.3                                     armhf        Raspberry Pi 3 bluetooth
ii  pulseaudio-module-bluetooth           5.0-13                                    armhf        Bluetooth module for PulseAudio sound server
root       798  0.2  1.1  32464 11264 ?        Ssl  03:55   1:12 /usr/bin/perl /usr/sbin/lepresenced --daemon --device hci0 --listenaddress 0.0.0.0 --listenport 5333 --loglevel LOG_DEBUG

Ich hoffe das hilft Dir weiter...
Gruß
Arthur

Offline PatrickR

  • Developer
  • Sr. Member
  • ****
  • Beiträge: 867
root@raspberrypi1:/home/pi# dpkg -l|egrep -i '(blue|hci)';ps aux|grep [l]epresenced           
ii  blueman                               1.99~alpha1-1+deb8u1                      armhf        Graphical bluetooth manager
ii  bluetooth                             5.23-2+rpi2                               all          Bluetooth support
ii  bluez                                 5.23-2+rpi2                               armhf        Bluetooth tools and daemons
ii  bluez-firmware                        1.2-3+rpi2                                all          Firmware for Bluetooth devices
ii  bluez-hcidump                         5.23-2+rpi2                               armhf        Analyses Bluetooth HCI packets
ii  bluez-obexd                           5.23-2+rpi2                               armhf        bluez obex daemon
ii  bluez-tools                           0.2.0~20140808-3                          armhf        Set of tools to manage Bluetooth devices for linux
ii  lepresenced                           0.82-1                                    all          lepresenced to detect the presence of Bluetooth LE devices
ii  libbluetooth3:armhf                   5.23-2+rpi2                               armhf        Library to use the BlueZ Linux Bluetooth stack
ii  pi-bluetooth                          0.1.3                                     armhf        Raspberry Pi 3 bluetooth
ii  pulseaudio-module-bluetooth           5.0-13                                    armhf        Bluetooth module for PulseAudio sound server
root       798  0.2  1.1  32464 11264 ?        Ssl  03:55   1:12 /usr/bin/perl /usr/sbin/lepresenced --daemon --device hci0 --listenaddress 0.0.0.0 --listenport 5333 --loglevel LOG_DEBUG

Hi!

Nutzt Du Bluetooth auf dem Pi auch für andere Zwecke? Falls nein deinstalliere mal bitte folgende Pakete:

blueman
bluez-obexd
pulseaudio-module-bluetooth

Wenn ich mich richtig erinnere gab es in der Vergangenheit schon Ärger mit blueman.

Patrick
lepresenced - Tracking von Bluetooth-LE-Tags (Gigaset G-Tag) mittels PRESENCE

"Programming today is a race between software engineers striving to build bigger and better idiot-proof programs, and the universe trying to produce bigger and better idiots. So far, the universe is winning." - Rich Cook

Offline arthur_dent_2015

  • Full Member
  • ***
  • Beiträge: 258
Hi Patrick,
Pakete sind deinstalliert, leider kein Erfolg :(  hcitool auf der command line findet die Tag's auf Anhieb.. Ein Tag liegt jetzt direkt auf dem PI....
Im Anhang ein aktueller Auszug aus dem SYSLOG.
Gruß
Arthur

Offline PatrickR

  • Developer
  • Sr. Member
  • ****
  • Beiträge: 867
Hi!

Pakete sind deinstalliert, leider kein Erfolg :(  hcitool auf der command line findet die Tag's auf Anhieb.. Ein Tag liegt jetzt direkt auf dem PI....
Im Anhang ein aktueller Auszug aus dem SYSLOG.

Aug 27 11:39:59 raspberrypi1 systemd[1]: Started LSB: lepresenced - presenced for Bluetooth LE devices..
Aug 27 11:39:59 raspberrypi1 lepresenced[800]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
Aug 27 11:39:59 raspberrypi1 lepresenced[800]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
Aug 27 11:39:59 raspberrypi1 lepresenced[800]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
Aug 27 11:40:00 raspberrypi1 lepresenced[800]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
Aug 27 11:40:00 raspberrypi1 lepresenced[800]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
Aug 27 11:40:00 raspberrypi1 lepresenced[800]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
Aug 27 11:40:01 raspberrypi1 lepresenced[800]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
Aug 27 11:40:01 raspberrypi1 lepresenced[800]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
Aug 27 11:40:01 raspberrypi1 lepresenced[800]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
Aug 27 11:40:02 raspberrypi1 lepresenced[800]: [tid:1] main::bluetooth_scan_thread: Received 'LE Scan ...'.
Das "no such device" ist schon sehr komisch. Ich hatte das auch schon mal in der Vergangenheit beim Entwickeln (im normalen Betrieb nicht), wenn ich Linux zu sehr geärgert hatte. Von selbst wie bei Dir ging es aber nicht weg sondern erst durch einen Reboot.

Hinzu kommt, dass Beacons ankommen aber wirklich nur ganz vereinzelt:
Aug 27 11:45:00 raspberrypi1 lepresenced[800]: [tid:0] main::stats_task: Active clients: 5, known devices: 3 (min/max age: 59/60)
Aug 27 11:50:01 raspberrypi1 lepresenced[800]: [tid:0] main::stats_task: Active clients: 5, known devices: 3 (min/max age: 360/361)
Aug 27 11:55:00 raspberrypi1 lepresenced[800]: [tid:0] main::cleanup_task: Cleanup finished, deleted 0 devices in 0 seconds.
Aug 27 11:55:02 raspberrypi1 lepresenced[800]: [tid:0] main::stats_task: Active clients: 5, known devices: 3 (min/max age: 661/662)
Aug 27 12:00:03 raspberrypi1 lepresenced[800]: [tid:0] main::stats_task: Active clients: 5, known devices: 3 (min/max age: 962/963)
Aug 27 12:05:04 raspberrypi1 lepresenced[800]: [tid:0] main::stats_task: Active clients: 5, known devices: 3 (min/max age: 1263/1264)
Aug 27 12:10:01 raspberrypi1 lepresenced[800]: [tid:0] main::cleanup_task: Cleanup finished, deleted 0 devices in 0 seconds.
Aug 27 12:10:05 raspberrypi1 lepresenced[800]: [tid:0] main::stats_task: Active clients: 5, known devices: 3 (min/max age: 1564/1565)
Aug 27 12:15:06 raspberrypi1 lepresenced[800]: [tid:0] main::stats_task: Active clients: 5, known devices: 3 (min/max age: 1865/1866)
Aug 27 12:20:07 raspberrypi1 lepresenced[800]: [tid:0] main::stats_task: Active clients: 5, known devices: 3 (min/max age: 203/204)
Aug 27 12:25:02 raspberrypi1 lepresenced[800]: [tid:0] main::cleanup_task: Cleanup finished, deleted 0 devices in 0 seconds.
Aug 27 12:25:08 raspberrypi1 lepresenced[800]: [tid:0] main::stats_task: Active clients: 5, known devices: 3 (min/max age: 504/505)
Aug 27 12:30:09 raspberrypi1 lepresenced[800]: [tid:0] main::stats_task: Active clients: 5, known devices: 3 (min/max age: 805/806)
Aug 27 12:35:10 raspberrypi1 lepresenced[800]: [tid:0] main::stats_task: Active clients: 5, known devices: 3 (min/max age: 1106/1107)
Aug 27 12:40:03 raspberrypi1 lepresenced[800]: [tid:0] main::cleanup_task: Cleanup finished, deleted 0 devices in 0 seconds.
Aug 27 12:40:11 raspberrypi1 lepresenced[800]: [tid:0] main::stats_task: Active clients: 5, known devices: 3 (min/max age: 1407/1408)
Aug 27 12:45:12 raspberrypi1 lepresenced[800]: [tid:0] main::stats_task: Active clients: 5, known devices: 3 (min/max age: 1708/1709)
Aug 27 12:50:13 raspberrypi1 lepresenced[800]: [tid:0] main::stats_task: Active clients: 5, known devices: 3 (min/max age: 2009/2010)
Aug 27 12:55:04 raspberrypi1 lepresenced[800]: [tid:0] main::cleanup_task: Deleting device 7c:2f:80:ad:ba:72.
Aug 27 12:55:04 raspberrypi1 lepresenced[800]: [tid:0] main::cleanup_task: Deleting device 7c:2f:80:ad:ba:56.
Aug 27 12:55:04 raspberrypi1 lepresenced[800]: [tid:0] main::cleanup_task: Deleting device 7c:2f:80:ad:ba:a8.
Aug 27 12:55:04 raspberrypi1 lepresenced[800]: [tid:0] main::cleanup_task: Cleanup finished, deleted 3 devices in 0 seconds.
Aug 27 12:55:14 raspberrypi1 lepresenced[800]: [tid:0] main::stats_task: Active clients: 5, known devices: 0 (min/max age: %/%)
Aug 27 13:00:15 raspberrypi1 lepresenced[800]: [tid:0] main::stats_task: Active clients: 5, known devices: 0 (min/max age: %/%)
Aug 27 13:05:16 raspberrypi1 lepresenced[800]: [tid:0] main::stats_task: Active clients: 5, known devices: 0 (min/max age: %/%)
Aug 27 13:10:05 raspberrypi1 lepresenced[800]: [tid:0] main::cleanup_task: Cleanup finished, deleted 0 devices in 0 seconds.
Aug 27 13:10:17 raspberrypi1 lepresenced[800]: [tid:0] main::stats_task: Active clients: 5, known devices: 0 (min/max age: %/%)
Aug 27 13:15:18 raspberrypi1 lepresenced[800]: [tid:0] main::stats_task: Active clients: 5, known devices: 0 (min/max age: %/%)
Aug 27 13:20:19 raspberrypi1 lepresenced[800]: [tid:0] main::stats_task: Active clients: 5, known devices: 0 (min/max age: %/%)
Aug 27 13:25:06 raspberrypi1 lepresenced[800]: [tid:0] main::cleanup_task: Cleanup finished, deleted 0 devices in 0 seconds.
Aug 27 13:25:20 raspberrypi1 lepresenced[800]: [tid:0] main::stats_task: Active clients: 5, known devices: 0 (min/max age: %/%)
Die angegebenen Ages, z. B. 2009/2010 sind das jeweilige Alter in Sekunden, an dem das letzte Beacon empfangen wurde. Wenn man sich im Klaren darüber ist, dass G-Tags normalerweise im Abstand von 1-2 Sekunden senden, ist das /etwas/ lange. Richtig wäre ein min age von 0-2 Sekunden.

Ich würde gerne noch weitere Pakete/Dienste ausschließen, die uns dazwischenfunken könnten, daher bitte auch folgende Pakete deinstallieren:
bluetooth
bluez-tools
pulseaudio-module-bluetooth
Danach bitte den Pi durchbooten (wichtig).

Übrig bleiben sollten (nur) folgende Pakete:
root@rpi-test:~# dpkg -l|egrep -i '(blue|hci)'
ii  bluez                            5.23-2+rpi2                      armhf        Bluetooth tools and daemons
ii  bluez-firmware                   1.2-3+rpi1                       all          Firmware for Bluetooth devices
ii  bluez-hcidump                    5.23-2+b1                        armhf        Analyses Bluetooth HCI packets
ii  lepresenced                      0.82-1                           all          lepresenced to detect the presence of Bluetooth LE devices
ii  pi-bluetooth                     0.1.3                            armhf        Raspberry Pi 3 bluetooth

Sorry, aber so eine richtige Idee habe ich nicht und die Ferndiagnose macht es nicht einfacher.

Patrick
lepresenced - Tracking von Bluetooth-LE-Tags (Gigaset G-Tag) mittels PRESENCE

"Programming today is a race between software engineers striving to build bigger and better idiot-proof programs, and the universe trying to produce bigger and better idiots. So far, the universe is winning." - Rich Cook

stiefl

  • Gast
Bei mir scheints derzeit wieder einwandfrei zu funktionieren. Heute wurden Die G-Tags sofort erkannt. Bei mir war wohl wirklich das BleTagBattery der Fehlergrund. Ich werd das noch weiter beobachten und hab mir jetzt mal einen zusätzlichen Bluetooth-Dongle für die Batterieüberwachung bestellt.

Offline Gasmast3r

  • Full Member
  • ***
  • Beiträge: 491
Hy nur ein Dongle sollte da nicht helfen würde da ein zero-w nehmen

stiefl

  • Gast
Mit welcher Begründung? Laut dem Thread https://forum.fhem.de/index.php/topic,68104.0/all.html sollte das ja einwandfrei funktionieren!?

Offline Fixel2012

  • Hero Member
  • *****
  • Beiträge: 1218
Mit welcher Begründung? Laut dem Thread https://forum.fhem.de/index.php/topic,68104.0/all.html sollte das ja einwandfrei funktionieren!?

Das kann ich bestätigen, bei mir funktioniert es einwandfrei.
Fhem 5.8 auf Raspi 3, HMLAN und 868MHz CUL mit einigen Komponenten, Z-Wave Rollladenaktoren, Tablet UI, 433 MHz CUL mit Baumarktsteckdosen und Temp Sensoren, Amazon Echo, Echo Dot, 2x SONOS  play1, 1x SONOS Connect AMP,  presence, HUE, Lightify

Offline Gasmast3r

  • Full Member
  • ***
  • Beiträge: 491
Ok war mir so das es nicht geht, gut das man immer wieder was lernen kann ;)

stiefl

  • Gast
Ich werd's bald Testen und berichten  ;)

Offline arthur_dent_2015

  • Full Member
  • ***
  • Beiträge: 258
Moin Patrick,
ich habe alle überflüssigen Pakete deinstalliert, Erfolg = 0. Scan Zeiten mal hoch gesetzt, ebenso wenig Erfolg :( Dann hab ich den Stick von meinen RPI 2 mal an den 3er gehängt und hci1 in lepresenced eingetragen. Siehe da, kaum noch absent Meldungen und die RSSI Werte sind auch realistischer :) Fazit: Die BT Hardware vom RPI 3 taugt nix, ich werde wohl in neue Sticks investieren müssen :(
Danke & Gruß
Arthur

Offline Lucky2k12

  • Full Member
  • ***
  • Beiträge: 339
Ich habe/hatte auch wechselnde Stabilität, v.a. in den letzten Wochen, mit dem Raspi3 / internen BT.
heute hab ich mal die pi-firmware aktualisiert und nach einem restart des lepresenced gings dann plötzlich wieder.

Da scheint auch noch was beim startup (evtl. Timing)  nicht zu stimmen, weil ich erst restarten muss.
Ich habe von wheezy auf jesse aktualisiert und bin mir nicht ganz sicher mit den /etc/init.d und /etc/systemd Geschichten.
Vielleicht könnt ihr mir da auf die Sprünge helfen, wo welche startup-scripts liegen müssen.

Danke+Gruß Lucky2k12
HP T610, HM, Jeelink, LGW, mapleCUL868+434

stiefl

  • Gast
@Patrick: Jetzt wirds bei mir leider wieder seltsam....  :o

Hab soeben den neuen Bluetooth-Dongle https://www.amazon.de/gp/product/B014RHH57M/ref=oh_aui_detailpage_o00_s00?ie=UTF8&psc=1 eingesteckt. Nach einem Neustart wird dieser als hci0 erkannt und das interner BT vom Raspi 3 wird zu hci1. Soweit sogut. Das heißt, lepresenced verwendet nun den Dongle - wollt ich eh so testen.
Nun ist es aber so, dass nach dem Neustart der G-Tag gefunden wird und ab der 2. Abfrage auf absent hüpft und dann auch so bleibt - bis zum nächsten Neustart. Auszug aus dem Log:

Aug 29 17:39:10 raspberrypi lepresenced[521]: [tid:0] main: Version 0.82 started (device: hci0, listen addr: 0.0.0.0, listen port: 5333, daemonize: 0, legacy mode: 0, rssi threshold: 10, log level: 7, debug: 1).
Aug 29 17:39:10 raspberrypi lepresenced[503]: Starting the process: lepresenced[tid:0] main: Version 0.82 started (device: hci0, listen addr: 0.0.0.0, listen port: 5333, daemonize: 0, legacy mode: 0, rssi threshold: 10, log level: 7, debug: 1).
Aug 29 17:39:10 raspberrypi lepresenced[521]: [tid:0] main::sanity_check: hciconfig found at '/bin/hciconfig'.
Aug 29 17:39:10 raspberrypi lepresenced[503]: [tid:0] main::sanity_check: hciconfig found at '/bin/hciconfig'.
Aug 29 17:39:10 raspberrypi lepresenced[521]: [tid:0] main::sanity_check: hcitool found at '/usr/bin/hcitool'.
Aug 29 17:39:10 raspberrypi lepresenced[503]: [tid:0] main::sanity_check: hcitool found at '/usr/bin/hcitool'.
Aug 29 17:39:10 raspberrypi lepresenced[521]: [tid:0] main::sanity_check: hcidump found at '/usr/bin/hcidump'.
Aug 29 17:39:10 raspberrypi lepresenced[503]: [tid:0] main::sanity_check: hcidump found at '/usr/bin/hcidump'.
Aug 29 17:39:10 raspberrypi avahi-daemon[436]: Server startup complete. Host name is raspberrypi.local. Local service cookie is 3115011158.
Aug 29 17:39:10 raspberrypi lepresenced[521]: [tid:1] main::bluetooth_scan_thread: Received 'LE Scan ...'.
Aug 29 17:39:10 raspberrypi systemd[1]: Started LSB: FHEM server.
Aug 29 17:39:13 raspberrypi kernel: [   10.138827] Bluetooth: HCI UART driver ver 2.3
Aug 29 17:39:13 raspberrypi kernel: [   10.138836] Bluetooth: HCI UART protocol H4 registered
Aug 29 17:39:13 raspberrypi kernel: [   10.138841] Bluetooth: HCI UART protocol Three-wire (H5) registered
Aug 29 17:39:13 raspberrypi kernel: [   10.139003] Bluetooth: HCI UART protocol Broadcom registered
Aug 29 17:39:13 raspberrypi btuart[445]: bcm43xx_init
Aug 29 17:39:13 raspberrypi btuart[445]: Flash firmware /lib/firmware/BCM43430A1.hcd
Aug 29 17:39:13 raspberrypi btuart[445]: Set Controller UART speed to 921600 bit/s
Aug 29 17:39:13 raspberrypi btuart[445]: Device setup complete
Aug 29 17:39:13 raspberrypi systemd[1]: Started Configure Bluetooth Modems connected by UART.
Aug 29 17:39:13 raspberrypi systemd[1]: Starting Bluetooth service...
Aug 29 17:39:13 raspberrypi systemd[1]: Starting Load/Save RF Kill Switch Status of rfkill2...
Aug 29 17:39:13 raspberrypi systemd[1]: Started Load/Save RF Kill Switch Status of rfkill2.
Aug 29 17:39:13 raspberrypi bluetoothd[657]: Bluetooth daemon 5.23
Aug 29 17:39:13 raspberrypi systemd[1]: Started Bluetooth service.
Aug 29 17:39:13 raspberrypi systemd[1]: Starting Bluetooth.
Aug 29 17:39:13 raspberrypi systemd[1]: Reached target Bluetooth.
Aug 29 17:39:13 raspberrypi bluetoothd[657]: Starting SDP server
Aug 29 17:39:13 raspberrypi kernel: [   10.311388] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Aug 29 17:39:13 raspberrypi kernel: [   10.311397] Bluetooth: BNEP filters: protocol multicast
Aug 29 17:39:13 raspberrypi kernel: [   10.311415] Bluetooth: BNEP socket layer initialized
Aug 29 17:39:13 raspberrypi bluetoothd[657]: Bluetooth management interface 1.14 initialized
Aug 29 17:39:13 raspberrypi dbus[446]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service'
Aug 29 17:39:13 raspberrypi bluetoothd[657]: Sap driver initialization failed.
Aug 29 17:39:13 raspberrypi bluetoothd[657]: sap-server: Operation not permitted (1)
Aug 29 17:39:13 raspberrypi bluetoothd[657]: Sap driver initialization failed.
Aug 29 17:39:13 raspberrypi bluetoothd[657]: sap-server: Operation not permitted (1)
Aug 29 17:39:13 raspberrypi systemd[1]: Starting Hostname Service...
Aug 29 17:39:13 raspberrypi systemd-hostnamed[661]: Warning: nss-myhostname is not installed. Changing the local hostname might make it unresolveable. Please install nss-myhostname!
Aug 29 17:39:13 raspberrypi dbus[446]: [system] Successfully activated service 'org.freedesktop.hostname1'
Aug 29 17:39:13 raspberrypi systemd[1]: Started Hostname Service.
Aug 29 17:39:14 raspberrypi dhcpcd[435]: wlan0: leased 192.168.252.150 for 43200 seconds
Aug 29 17:39:14 raspberrypi avahi-daemon[436]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.252.150.
Aug 29 17:39:14 raspberrypi avahi-daemon[436]: New relevant interface wlan0.IPv4 for mDNS.
Aug 29 17:39:14 raspberrypi avahi-daemon[436]: Registering new address record for 192.168.252.150 on wlan0.IPv4.
Aug 29 17:39:14 raspberrypi dhcpcd[435]: wlan0: adding route to 192.168.252.0/24
Aug 29 17:39:14 raspberrypi dhcpcd[435]: wlan0: adding default route via 192.168.252.254
Aug 29 17:39:14 raspberrypi dhcpcd[435]: forked to background, child pid 749
Aug 29 17:39:14 raspberrypi systemd[1]: Started dhcpcd on all interfaces.
Aug 29 17:39:14 raspberrypi systemd[1]: Starting Network.
Aug 29 17:39:14 raspberrypi systemd[1]: Reached target Network.
Aug 29 17:39:14 raspberrypi systemd[1]: Starting OpenBSD Secure Shell server...
Aug 29 17:39:14 raspberrypi systemd[1]: Started OpenBSD Secure Shell server.
Aug 29 17:39:14 raspberrypi systemd[1]: Starting /etc/rc.local Compatibility...
Aug 29 17:39:14 raspberrypi systemd[1]: Starting Permit User Sessions...
Aug 29 17:39:14 raspberrypi systemd[1]: Starting Network is Online.
Aug 29 17:39:14 raspberrypi systemd[1]: Reached target Network is Online.
Aug 29 17:39:14 raspberrypi systemd[1]: Starting LSB: Start NTP daemon...
Aug 29 17:39:14 raspberrypi systemd[1]: Started /etc/rc.local Compatibility.
Aug 29 17:39:14 raspberrypi systemd[1]: Started Permit User Sessions.
Aug 29 17:39:14 raspberrypi systemd[1]: Starting Terminate Plymouth Boot Screen...
Aug 29 17:39:14 raspberrypi systemd[1]: Starting Hold until boot process finishes up...
Aug 29 17:39:14 raspberrypi systemd[1]: Received SIGRTMIN+21 from PID 263 (plymouthd).
Aug 29 17:39:14 raspberrypi ntp[754]: Starting NTP server: ntpderror: unexpectedly disconnected from boot status daemon
Aug 29 17:39:14 raspberrypi systemd[1]: Started Terminate Plymouth Boot Screen.
Aug 29 17:39:14 raspberrypi systemd[1]: Started Hold until boot process finishes up.
Aug 29 17:39:15 raspberrypi systemd[1]: Starting Getty on tty1...
Aug 29 17:39:15 raspberrypi systemd[1]: Started Getty on tty1.
Aug 29 17:39:15 raspberrypi systemd[1]: Starting Login Prompts.
Aug 29 17:39:15 raspberrypi systemd[1]: Reached target Login Prompts.
Aug 29 17:39:15 raspberrypi ntpd[768]: ntpd 4.2.6p5@1.2349-o Mon Jul 25 22:35:28 UTC 2016 (1)
Aug 29 17:39:15 raspberrypi ntp[754]: .
Aug 29 17:39:15 raspberrypi ntpd[771]: proto: precision = 0.520 usec
Aug 29 17:39:15 raspberrypi ntpd[771]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123
Aug 29 17:39:15 raspberrypi systemd[1]: Started LSB: Start NTP daemon.
Aug 29 17:39:15 raspberrypi ntpd[771]: Listen and drop on 1 v6wildcard :: UDP 123
Aug 29 17:39:15 raspberrypi ntpd[771]: Listen normally on 2 lo 127.0.0.1 UDP 123
Aug 29 17:39:15 raspberrypi ntpd[771]: Listen normally on 3 wlan0 192.168.252.150 UDP 123
Aug 29 17:39:15 raspberrypi ntpd[771]: Listen normally on 4 wlan0 fe80::ffca:ed7e:16ea:d574 UDP 123
Aug 29 17:39:15 raspberrypi ntpd[771]: Listen normally on 5 lo ::1 UDP 123
Aug 29 17:39:15 raspberrypi ntpd[771]: peers refreshed
Aug 29 17:39:15 raspberrypi ntpd[771]: Listening on routing socket on fd #22 for interface updates
Aug 29 17:39:21 raspberrypi lepresenced[503]: Known devices (1):
Aug 29 17:39:21 raspberrypi lepresenced[503]: mac: 7c:2f:80:97:38:42, ages:  8/ 8, rssi: -70, name: Gigaset G-tag
Aug 29 17:39:30 raspberrypi systemd[1]: Time has been changed
Aug 29 17:39:31 raspberrypi dhcpcd[749]: wlan0: no IPv6 Routers available
Aug 29 17:39:32 raspberrypi lepresenced[503]: Known devices (1):
Aug 29 17:39:32 raspberrypi lepresenced[503]: mac: 7c:2f:80:97:38:42, ages: 19/19, rssi: -70, name: Gigaset G-tag
Aug 29 17:39:37 raspberrypi lepresenced[521]: [tid:0] main: Connection from 127.0.0.1:35034. Connected clients: 1.
Aug 29 17:39:37 raspberrypi lepresenced[503]: [tid:0] main: Connection from 127.0.0.1:35034. Connected clients: 1.
Aug 29 17:39:38 raspberrypi lepresenced[521]: [tid:0] main: Connection from 127.0.0.1:35036. Connected clients: 2.
Aug 29 17:39:38 raspberrypi lepresenced[521]: [tid:0] main::handle_command: Received query for mac address 7c:2f:80:97:38:42, interval: 25. Adding client 127.0.0.1:35034 to clients list.
Aug 29 17:39:38 raspberrypi lepresenced[521]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, ages: 25/25, max age: 25, rssi: -70, result: present.
Aug 29 17:39:38 raspberrypi lepresenced[503]: [tid:0] main: Connection from 127.0.0.1:35036. Connected clients: 2.
Aug 29 17:39:38 raspberrypi lepresenced[503]: [tid:0] main::handle_command: Received query for mac address 7c:2f:80:97:38:42, interval: 25. Adding client 127.0.0.1:35034 to clients list.
Aug 29 17:39:38 raspberrypi lepresenced[503]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, ages: 25/25, max age: 25, rssi: -70, result: present.
Aug 29 17:39:38 raspberrypi lepresenced[521]: [tid:0] main::handle_command: Received query for mac address 7c:2f:80:97:38:38, interval: 25. Adding client 127.0.0.1:35036 to clients list.
Aug 29 17:39:38 raspberrypi lepresenced[521]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:39:38 raspberrypi lepresenced[503]: [tid:0] main::handle_command: Received query for mac address 7c:2f:80:97:38:38, interval: 25. Adding client 127.0.0.1:35036 to clients list.
Aug 29 17:39:38 raspberrypi lepresenced[503]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:39:43 raspberrypi lepresenced[503]: Known devices (1):
Aug 29 17:39:43 raspberrypi lepresenced[503]: mac: 7c:2f:80:97:38:42, ages: 30/30, rssi: -70, name: Gigaset G-tag
Aug 29 17:39:44 raspberrypi lepresenced[521]: [tid:0] main::handle_command: Received query update for mac address 7c:2f:80:97:38:42, interval: 60 by client 127.0.0.1:35034.
Aug 29 17:39:44 raspberrypi lepresenced[521]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, ages: 31/31, max age: 60, rssi: -70, result: present.
Aug 29 17:39:44 raspberrypi lepresenced[503]: [tid:0] main::handle_command: Received query update for mac address 7c:2f:80:97:38:42, interval: 60 by client 127.0.0.1:35034.
Aug 29 17:39:44 raspberrypi lepresenced[503]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, ages: 31/31, max age: 60, rssi: -70, result: present.
Aug 29 17:39:54 raspberrypi lepresenced[503]: Known devices (1):
Aug 29 17:39:54 raspberrypi lepresenced[503]: mac: 7c:2f:80:97:38:42, ages: 41/41, rssi: -70, name: Gigaset G-tag
Aug 29 17:40:03 raspberrypi lepresenced[521]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:40:03 raspberrypi lepresenced[503]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:40:05 raspberrypi lepresenced[503]: Known devices (1):
Aug 29 17:40:05 raspberrypi lepresenced[503]: mac: 7c:2f:80:97:38:42, ages: 52/52, rssi: -70, name: Gigaset G-tag
Aug 29 17:40:16 raspberrypi lepresenced[503]: Known devices (1):
Aug 29 17:40:16 raspberrypi lepresenced[503]: mac: 7c:2f:80:97:38:42, ages: 63/63, rssi: -70, name: Gigaset G-tag
Aug 29 17:40:27 raspberrypi lepresenced[503]: Known devices (1):
Aug 29 17:40:27 raspberrypi lepresenced[503]: mac: 7c:2f:80:97:38:42, ages: 74/74, rssi: -70, name: Gigaset G-tag
Aug 29 17:40:28 raspberrypi lepresenced[521]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:40:28 raspberrypi lepresenced[503]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:40:38 raspberrypi lepresenced[503]: Known devices (1):
Aug 29 17:40:38 raspberrypi lepresenced[503]: mac: 7c:2f:80:97:38:42, ages: 85/85, rssi: -70, name: Gigaset G-tag
Aug 29 17:40:44 raspberrypi lepresenced[521]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, max age: 60, result: absence.
Aug 29 17:40:44 raspberrypi lepresenced[503]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, max age: 60, result: absence.
Aug 29 17:40:44 raspberrypi lepresenced[521]: [tid:0] main::handle_command: Received query update for mac address 7c:2f:80:97:38:42, interval: 25 by client 127.0.0.1:35034.
Aug 29 17:40:44 raspberrypi lepresenced[521]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, max age: 25, result: absence.
Aug 29 17:40:44 raspberrypi lepresenced[503]: [tid:0] main::handle_command: Received query update for mac address 7c:2f:80:97:38:42, interval: 25 by client 127.0.0.1:35034.
Aug 29 17:40:44 raspberrypi lepresenced[503]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, max age: 25, result: absence.
Aug 29 17:40:49 raspberrypi lepresenced[503]: Known devices (1):
Aug 29 17:40:49 raspberrypi lepresenced[503]: mac: 7c:2f:80:97:38:42, ages: 96/96, rssi: -70, name: Gigaset G-tag
Aug 29 17:40:53 raspberrypi lepresenced[521]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:40:53 raspberrypi lepresenced[503]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:41:00 raspberrypi lepresenced[503]: Known devices (1):
Aug 29 17:41:00 raspberrypi lepresenced[503]: mac: 7c:2f:80:97:38:42, ages: 107/107, rssi: -70, name: Gigaset G-tag
Aug 29 17:41:09 raspberrypi lepresenced[521]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, max age: 25, result: absence.
Aug 29 17:41:09 raspberrypi lepresenced[503]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, max age: 25, result: absence.
Aug 29 17:41:11 raspberrypi lepresenced[503]: Known devices (1):
Aug 29 17:41:11 raspberrypi lepresenced[503]: mac: 7c:2f:80:97:38:42, ages: 118/118, rssi: -70, name: Gigaset G-tag
Aug 29 17:41:18 raspberrypi lepresenced[521]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:41:18 raspberrypi lepresenced[503]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:41:22 raspberrypi lepresenced[503]: Known devices (1):
Aug 29 17:41:22 raspberrypi lepresenced[503]: mac: 7c:2f:80:97:38:42, ages: 129/129, rssi: -70, name: Gigaset G-tag
Aug 29 17:41:33 raspberrypi lepresenced[503]: Known devices (1):
Aug 29 17:41:33 raspberrypi lepresenced[503]: mac: 7c:2f:80:97:38:42, ages: 140/140, rssi: -70, name: Gigaset G-tag
Aug 29 17:41:34 raspberrypi lepresenced[521]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, max age: 25, result: absence.
Aug 29 17:41:34 raspberrypi lepresenced[503]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, max age: 25, result: absence.
Aug 29 17:41:43 raspberrypi lepresenced[521]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:41:43 raspberrypi lepresenced[503]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:41:44 raspberrypi lepresenced[503]: Known devices (1):
Aug 29 17:41:44 raspberrypi lepresenced[503]: mac: 7c:2f:80:97:38:42, ages: 151/151, rssi: -70, name: Gigaset G-tag
Aug 29 17:41:55 raspberrypi lepresenced[503]: Known devices (1):
Aug 29 17:41:55 raspberrypi lepresenced[503]: mac: 7c:2f:80:97:38:42, ages: 162/162, rssi: -70, name: Gigaset G-tag
Aug 29 17:41:59 raspberrypi lepresenced[521]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, max age: 25, result: absence.
Aug 29 17:41:59 raspberrypi lepresenced[503]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, max age: 25, result: absence.
Aug 29 17:42:06 raspberrypi lepresenced[503]: Known devices (1):
Aug 29 17:42:06 raspberrypi lepresenced[503]: mac: 7c:2f:80:97:38:42, ages: 173/173, rssi: -70, name: Gigaset G-tag
Aug 29 17:42:08 raspberrypi lepresenced[521]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:42:08 raspberrypi lepresenced[503]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:42:17 raspberrypi lepresenced[503]: Known devices (1):
Aug 29 17:42:17 raspberrypi lepresenced[503]: mac: 7c:2f:80:97:38:42, ages: 184/184, rssi: -70, name: Gigaset G-tag
Aug 29 17:42:24 raspberrypi lepresenced[521]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, max age: 25, result: absence.
Aug 29 17:42:24 raspberrypi lepresenced[503]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, max age: 25, result: absence.
Aug 29 17:42:24 raspberrypi rsyslogd-2007: action 'action 19' suspended, next retry is Tue Aug 29 17:42:54 2017 [try http://www.rsyslog.com/e/2007 ]
Aug 29 17:42:28 raspberrypi lepresenced[503]: Known devices (1):
Aug 29 17:42:28 raspberrypi lepresenced[503]: mac: 7c:2f:80:97:38:42, ages: 195/195, rssi: -70, name: Gigaset G-tag
Aug 29 17:42:33 raspberrypi lepresenced[521]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:42:33 raspberrypi lepresenced[503]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:42:39 raspberrypi lepresenced[503]: Known devices (1):
Aug 29 17:42:39 raspberrypi lepresenced[503]: mac: 7c:2f:80:97:38:42, ages: 206/206, rssi: -70, name: Gigaset G-tag
Aug 29 17:42:49 raspberrypi lepresenced[521]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, max age: 25, result: absence.
Aug 29 17:42:49 raspberrypi lepresenced[503]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, max age: 25, result: absence.
Aug 29 17:42:50 raspberrypi lepresenced[503]: Known devices (1):
Aug 29 17:42:50 raspberrypi lepresenced[503]: mac: 7c:2f:80:97:38:42, ages: 217/217, rssi: -70, name: Gigaset G-tag
Aug 29 17:42:58 raspberrypi lepresenced[521]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:42:58 raspberrypi rsyslogd-2007: action 'action 19' suspended, next retry is Tue Aug 29 17:43:28 2017 [try http://www.rsyslog.com/e/2007 ]
Aug 29 17:42:58 raspberrypi lepresenced[503]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:43:01 raspberrypi lepresenced[503]: Known devices (1):
Aug 29 17:43:01 raspberrypi lepresenced[503]: mac: 7c:2f:80:97:38:42, ages: 228/228, rssi: -70, name: Gigaset G-tag

So siehts aus, wenn ich im Startscript das Device auf hci1 ändere:

Aug 29 17:49:18 raspberrypi lepresenced[532]: [tid:0] main: Version 0.82 started (device: hci1, listen addr: 0.0.0.0, listen port: 5333, daemonize: 0, legacy mode: 0, rssi threshold: 10, log level: 7, debug: 1).
Aug 29 17:49:18 raspberrypi lepresenced[507]: Starting the process: lepresenced[tid:0] main: Version 0.82 started (device: hci1, listen addr: 0.0.0.0, listen port: 5333, daemonize: 0, legacy mode: 0, rssi threshold: 10, log level: 7, debug: 1).
Aug 29 17:49:18 raspberrypi lepresenced[532]: [tid:0] main::sanity_check: hciconfig found at '/bin/hciconfig'.
Aug 29 17:49:18 raspberrypi lepresenced[507]: [tid:0] main::sanity_check: hciconfig found at '/bin/hciconfig'.
Aug 29 17:49:18 raspberrypi lepresenced[532]: [tid:0] main::sanity_check: hcitool found at '/usr/bin/hcitool'.
Aug 29 17:49:18 raspberrypi lepresenced[507]: [tid:0] main::sanity_check: hcitool found at '/usr/bin/hcitool'.
Aug 29 17:49:18 raspberrypi lepresenced[532]: [tid:0] main::sanity_check: hcidump found at '/usr/bin/hcidump'.
Aug 29 17:49:18 raspberrypi lepresenced[507]: [tid:0] main::sanity_check: hcidump found at '/usr/bin/hcidump'.
Aug 29 17:49:18 raspberrypi lepresenced[532]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
Aug 29 17:49:18 raspberrypi lepresenced[532]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
Aug 29 17:49:18 raspberrypi avahi-daemon[437]: Server startup complete. Host name is raspberrypi.local. Local service cookie is 4123406327.
Aug 29 17:49:18 raspberrypi lepresenced[532]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
Aug 29 17:49:18 raspberrypi dhcpcd[436]: wlan0: soliciting an IPv6 router
Aug 29 17:49:18 raspberrypi systemd[1]: Started LSB: FHEM server.
Aug 29 17:49:18 raspberrypi dhcpcd[436]: wlan0: rebinding lease of 192.168.252.150
Aug 29 17:49:19 raspberrypi lepresenced[507]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
Aug 29 17:49:19 raspberrypi lepresenced[507]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
Aug 29 17:49:19 raspberrypi lepresenced[532]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
Aug 29 17:49:19 raspberrypi lepresenced[532]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
Aug 29 17:49:19 raspberrypi lepresenced[507]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
Aug 29 17:49:19 raspberrypi lepresenced[532]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
Aug 29 17:49:20 raspberrypi lepresenced[507]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
Aug 29 17:49:20 raspberrypi lepresenced[507]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
Aug 29 17:49:20 raspberrypi lepresenced[532]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
Aug 29 17:49:20 raspberrypi lepresenced[532]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
Aug 29 17:49:20 raspberrypi lepresenced[507]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
Aug 29 17:49:20 raspberrypi lepresenced[532]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
Aug 29 17:49:21 raspberrypi lepresenced[507]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
Aug 29 17:49:21 raspberrypi lepresenced[507]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
Aug 29 17:49:21 raspberrypi lepresenced[532]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
Aug 29 17:49:21 raspberrypi lepresenced[532]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
Aug 29 17:49:21 raspberrypi lepresenced[507]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
Aug 29 17:49:21 raspberrypi lepresenced[532]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
Aug 29 17:49:21 raspberrypi kernel: [   10.129015] Bluetooth: HCI UART driver ver 2.3
Aug 29 17:49:21 raspberrypi kernel: [   10.129028] Bluetooth: HCI UART protocol H4 registered
Aug 29 17:49:21 raspberrypi kernel: [   10.129033] Bluetooth: HCI UART protocol Three-wire (H5) registered
Aug 29 17:49:21 raspberrypi kernel: [   10.129200] Bluetooth: HCI UART protocol Broadcom registered
Aug 29 17:49:21 raspberrypi btuart[444]: bcm43xx_init
Aug 29 17:49:21 raspberrypi btuart[444]: Flash firmware /lib/firmware/BCM43430A1.hcd
Aug 29 17:49:21 raspberrypi btuart[444]: Set Controller UART speed to 921600 bit/s
Aug 29 17:49:21 raspberrypi btuart[444]: Device setup complete
Aug 29 17:49:21 raspberrypi systemd[1]: Started Configure Bluetooth Modems connected by UART.
Aug 29 17:49:21 raspberrypi systemd[1]: Starting Bluetooth service...
Aug 29 17:49:21 raspberrypi systemd[1]: Starting Load/Save RF Kill Switch Status of rfkill2...
Aug 29 17:49:21 raspberrypi systemd[1]: Started Load/Save RF Kill Switch Status of rfkill2.
Aug 29 17:49:21 raspberrypi bluetoothd[662]: Bluetooth daemon 5.23
Aug 29 17:49:21 raspberrypi systemd[1]: Started Bluetooth service.
Aug 29 17:49:21 raspberrypi systemd[1]: Starting Bluetooth.
Aug 29 17:49:21 raspberrypi systemd[1]: Reached target Bluetooth.
Aug 29 17:49:21 raspberrypi bluetoothd[662]: Starting SDP server
Aug 29 17:49:21 raspberrypi kernel: [   10.295095] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Aug 29 17:49:21 raspberrypi kernel: [   10.295105] Bluetooth: BNEP filters: protocol multicast
Aug 29 17:49:21 raspberrypi kernel: [   10.295122] Bluetooth: BNEP socket layer initialized
Aug 29 17:49:21 raspberrypi bluetoothd[662]: Bluetooth management interface 1.14 initialized
Aug 29 17:49:21 raspberrypi dbus[445]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service'
Aug 29 17:49:21 raspberrypi bluetoothd[662]: Sap driver initialization failed.
Aug 29 17:49:21 raspberrypi bluetoothd[662]: sap-server: Operation not permitted (1)
Aug 29 17:49:21 raspberrypi systemd[1]: Starting Hostname Service...
Aug 29 17:49:21 raspberrypi bluetoothd[662]: Sap driver initialization failed.
Aug 29 17:49:21 raspberrypi bluetoothd[662]: sap-server: Operation not permitted (1)
Aug 29 17:49:21 raspberrypi systemd-hostnamed[666]: Warning: nss-myhostname is not installed. Changing the local hostname might make it unresolveable. Please install nss-myhostname!
Aug 29 17:49:21 raspberrypi dbus[445]: [system] Successfully activated service 'org.freedesktop.hostname1'
Aug 29 17:49:21 raspberrypi systemd[1]: Started Hostname Service.
Aug 29 17:49:22 raspberrypi lepresenced[507]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
Aug 29 17:49:22 raspberrypi lepresenced[507]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
Aug 29 17:49:22 raspberrypi lepresenced[532]: [tid:1] main::bluetooth_scan_thread: Received 'LE Scan ...'.
Aug 29 17:49:22 raspberrypi lepresenced[507]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
Aug 29 17:49:23 raspberrypi dhcpcd[436]: wlan0: leased 192.168.252.150 for 43200 seconds
Aug 29 17:49:23 raspberrypi avahi-daemon[437]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.252.150.
Aug 29 17:49:23 raspberrypi avahi-daemon[437]: New relevant interface wlan0.IPv4 for mDNS.
Aug 29 17:49:23 raspberrypi dhcpcd[436]: wlan0: adding route to 192.168.252.0/24
Aug 29 17:49:23 raspberrypi avahi-daemon[437]: Registering new address record for 192.168.252.150 on wlan0.IPv4.
Aug 29 17:49:23 raspberrypi dhcpcd[436]: wlan0: adding default route via 192.168.252.254
Aug 29 17:49:23 raspberrypi dhcpcd[436]: forked to background, child pid 755
Aug 29 17:49:23 raspberrypi systemd[1]: Started dhcpcd on all interfaces.
Aug 29 17:49:23 raspberrypi systemd[1]: Starting Network.
Aug 29 17:49:23 raspberrypi systemd[1]: Reached target Network.
Aug 29 17:49:23 raspberrypi systemd[1]: Starting OpenBSD Secure Shell server...
Aug 29 17:49:23 raspberrypi systemd[1]: Started OpenBSD Secure Shell server.
Aug 29 17:49:23 raspberrypi systemd[1]: Starting /etc/rc.local Compatibility...
Aug 29 17:49:23 raspberrypi systemd[1]: Starting Permit User Sessions...
Aug 29 17:49:23 raspberrypi systemd[1]: Starting Network is Online.
Aug 29 17:49:23 raspberrypi systemd[1]: Reached target Network is Online.
Aug 29 17:49:23 raspberrypi systemd[1]: Starting LSB: Start NTP daemon...
Aug 29 17:49:23 raspberrypi systemd[1]: Started /etc/rc.local Compatibility.
Aug 29 17:49:23 raspberrypi systemd[1]: Started Permit User Sessions.
Aug 29 17:49:23 raspberrypi systemd[1]: Starting Terminate Plymouth Boot Screen...
Aug 29 17:49:23 raspberrypi systemd[1]: Starting Hold until boot process finishes up...
Aug 29 17:49:23 raspberrypi systemd[1]: Received SIGRTMIN+21 from PID 260 (plymouthd).
Aug 29 17:49:23 raspberrypi systemd[1]: Started Terminate Plymouth Boot Screen.
Aug 29 17:49:23 raspberrypi systemd[1]: Started Hold until boot process finishes up.
Aug 29 17:49:23 raspberrypi systemd[1]: Starting Getty on tty1...
Aug 29 17:49:23 raspberrypi systemd[1]: Started Getty on tty1.
Aug 29 17:49:23 raspberrypi systemd[1]: Starting Login Prompts.
Aug 29 17:49:23 raspberrypi systemd[1]: Reached target Login Prompts.
Aug 29 17:49:23 raspberrypi ntpd[772]: ntpd 4.2.6p5@1.2349-o Mon Jul 25 22:35:28 UTC 2016 (1)
Aug 29 17:49:23 raspberrypi ntp[759]: Starting NTP server: ntpd.
Aug 29 17:49:23 raspberrypi ntpd[777]: proto: precision = 0.520 usec
Aug 29 17:49:23 raspberrypi ntpd[777]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123
Aug 29 17:49:23 raspberrypi systemd[1]: Started LSB: Start NTP daemon.
Aug 29 17:49:23 raspberrypi ntpd[777]: Listen and drop on 1 v6wildcard :: UDP 123
Aug 29 17:49:23 raspberrypi ntpd[777]: Listen normally on 2 lo 127.0.0.1 UDP 123
Aug 29 17:49:23 raspberrypi ntpd[777]: Listen normally on 3 wlan0 192.168.252.150 UDP 123
Aug 29 17:49:23 raspberrypi ntpd[777]: Listen normally on 4 wlan0 fe80::ffca:ed7e:16ea:d574 UDP 123
Aug 29 17:49:23 raspberrypi ntpd[777]: Listen normally on 5 lo ::1 UDP 123
Aug 29 17:49:23 raspberrypi ntpd[777]: peers refreshed
Aug 29 17:49:23 raspberrypi ntpd[777]: Listening on routing socket on fd #22 for interface updates
Aug 29 17:49:26 raspberrypi kernel: [   14.984534] Bluetooth: hci1 advertising data length corrected
Aug 29 17:49:27 raspberrypi kernel: [   15.992243] Bluetooth: hci1 advertising data length corrected
Aug 29 17:49:28 raspberrypi kernel: [   16.995564] Bluetooth: hci1 advertising data length corrected
Aug 29 17:49:29 raspberrypi lepresenced[507]: Known devices (1):
Aug 29 17:49:29 raspberrypi lepresenced[507]: mac: 7c:2f:80:97:38:42, ages:  1/ 2, rssi: -70, name: Gigaset G-tag
Aug 29 17:49:29 raspberrypi kernel: [   18.002612] Bluetooth: hci1 advertising data length corrected
Aug 29 17:49:30 raspberrypi kernel: [   19.008303] Bluetooth: hci1 advertising data length corrected
Aug 29 17:49:39 raspberrypi systemd[1]: Time has been changed
Aug 29 17:49:39 raspberrypi dhcpcd[755]: wlan0: no IPv6 Routers available
Aug 29 17:49:40 raspberrypi lepresenced[507]: Known devices (1):
Aug 29 17:49:40 raspberrypi lepresenced[507]: mac: 7c:2f:80:97:38:42, ages: 10/10, rssi: -69, name: Gigaset G-tag
Aug 29 17:49:40 raspberrypi kernel: [   21.009619] Bluetooth: hci1 advertising data length corrected
Aug 29 17:49:41 raspberrypi kernel: [   22.015130] Bluetooth: hci1 advertising data length corrected
Aug 29 17:49:42 raspberrypi kernel: [   23.014982] Bluetooth: hci1 advertising data length corrected
Aug 29 17:49:43 raspberrypi kernel: [   24.024515] Bluetooth: hci1 advertising data length corrected
Aug 29 17:49:44 raspberrypi kernel: [   25.031929] Bluetooth: hci1 advertising data length corrected
Aug 29 17:49:46 raspberrypi kernel: [   27.038948] Bluetooth: hci1 advertising data length corrected
Aug 29 17:49:46 raspberrypi lepresenced[532]: [tid:0] main: Connection from 127.0.0.1:44478. Connected clients: 1.
Aug 29 17:49:46 raspberrypi lepresenced[507]: [tid:0] main: Connection from 127.0.0.1:44478. Connected clients: 1.
Aug 29 17:49:47 raspberrypi lepresenced[532]: [tid:0] main: Connection from 127.0.0.1:44480. Connected clients: 2.
Aug 29 17:49:47 raspberrypi lepresenced[532]: [tid:0] main::handle_command: Received query for mac address 7c:2f:80:97:38:42, interval: 25. Adding client 127.0.0.1:44478 to clients list.
Aug 29 17:49:47 raspberrypi lepresenced[532]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, ages: 1/1, max age: 25, rssi: -70, result: present.
Aug 29 17:49:47 raspberrypi lepresenced[507]: [tid:0] main: Connection from 127.0.0.1:44480. Connected clients: 2.
Aug 29 17:49:47 raspberrypi lepresenced[507]: [tid:0] main::handle_command: Received query for mac address 7c:2f:80:97:38:42, interval: 25. Adding client 127.0.0.1:44478 to clients list.
Aug 29 17:49:47 raspberrypi lepresenced[507]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, ages: 1/1, max age: 25, rssi: -70, result: present.
Aug 29 17:49:47 raspberrypi kernel: [   28.043324] Bluetooth: hci1: Frame reassembly failed (-84)
Aug 29 17:49:47 raspberrypi lepresenced[532]: [tid:0] main::handle_command: Received query for mac address 7c:2f:80:97:38:38, interval: 25. Adding client 127.0.0.1:44480 to clients list.
Aug 29 17:49:47 raspberrypi lepresenced[532]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:49:47 raspberrypi lepresenced[507]: [tid:0] main::handle_command: Received query for mac address 7c:2f:80:97:38:38, interval: 25. Adding client 127.0.0.1:44480 to clients list.
Aug 29 17:49:47 raspberrypi lepresenced[507]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:49:48 raspberrypi kernel: [   29.047570] Bluetooth: hci1: Frame reassembly failed (-84)
Aug 29 17:49:49 raspberrypi kernel: [   30.060110] Bluetooth: hci1: Frame reassembly failed (-84)
Aug 29 17:49:50 raspberrypi kernel: [   31.068588] Bluetooth: hci1: Frame reassembly failed (-84)
Aug 29 17:49:51 raspberrypi lepresenced[507]: Known devices (1):
Aug 29 17:49:51 raspberrypi lepresenced[507]: mac: 7c:2f:80:97:38:42, ages:  5/ 5, rssi: -70, name: Gigaset G-tag
Aug 29 17:49:52 raspberrypi kernel: [   33.078703] Bluetooth: hci1: Frame reassembly failed (-84)
Aug 29 17:49:54 raspberrypi lepresenced[532]: [tid:0] main::handle_command: Received query update for mac address 7c:2f:80:97:38:42, interval: 60 by client 127.0.0.1:44478.
Aug 29 17:49:54 raspberrypi lepresenced[532]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, ages: 8/8, max age: 60, rssi: -70, result: present.
Aug 29 17:49:54 raspberrypi lepresenced[507]: [tid:0] main::handle_command: Received query update for mac address 7c:2f:80:97:38:42, interval: 60 by client 127.0.0.1:44478.
Aug 29 17:49:54 raspberrypi lepresenced[507]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, ages: 8/8, max age: 60, rssi: -70, result: present.
Aug 29 17:49:54 raspberrypi kernel: [   35.092532] Bluetooth: hci1 advertising data length corrected
Aug 29 17:49:55 raspberrypi kernel: [   36.097201] Bluetooth: hci1 advertising data length corrected
Aug 29 17:49:56 raspberrypi kernel: [   37.105062] Bluetooth: hci1 advertising data length corrected
Aug 29 17:49:57 raspberrypi kernel: [   38.109756] Bluetooth: hci1 advertising data length corrected
Aug 29 17:49:59 raspberrypi kernel: [   40.119185] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:00 raspberrypi kernel: [   41.126268] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:01 raspberrypi kernel: [   42.124884] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:02 raspberrypi lepresenced[507]: Known devices (1):
Aug 29 17:50:02 raspberrypi lepresenced[507]: mac: 7c:2f:80:97:38:42, ages:  1/ 1, rssi: -72, name: Gigaset G-tag
Aug 29 17:50:02 raspberrypi kernel: [   43.134261] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:03 raspberrypi kernel: [   44.136190] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:04 raspberrypi kernel: [   45.142118] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:05 raspberrypi kernel: [   46.144418] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:06 raspberrypi kernel: [   47.152360] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:07 raspberrypi kernel: [   48.158223] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:09 raspberrypi kernel: [   50.168402] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:10 raspberrypi kernel: [   51.175708] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:11 raspberrypi kernel: [   52.175305] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:12 raspberrypi lepresenced[532]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:50:12 raspberrypi lepresenced[507]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:50:12 raspberrypi kernel: [   53.177021] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:13 raspberrypi lepresenced[507]: Known devices (1):
Aug 29 17:50:13 raspberrypi lepresenced[507]: mac: 7c:2f:80:97:38:42, ages:  1/ 2, rssi: -71, name: Gigaset G-tag
Aug 29 17:50:14 raspberrypi kernel: [   55.181955] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:15 raspberrypi kernel: [   56.189666] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:16 raspberrypi kernel: [   57.197224] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:17 raspberrypi kernel: [   58.202372] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:18 raspberrypi kernel: [   59.205713] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:19 raspberrypi kernel: [   60.207079] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:20 raspberrypi kernel: [   61.213459] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:21 raspberrypi kernel: [   62.222403] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:22 raspberrypi kernel: [   63.235725] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:23 raspberrypi kernel: [   64.236408] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:24 raspberrypi lepresenced[507]: Known devices (1):
Aug 29 17:50:24 raspberrypi lepresenced[507]: mac: 7c:2f:80:97:38:42, ages:  1/ 2, rssi: -72, name: Gigaset G-tag
Aug 29 17:50:24 raspberrypi kernel: [   65.245995] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:25 raspberrypi kernel: [   66.247064] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:26 raspberrypi kernel: [   67.259143] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:27 raspberrypi kernel: [   68.265329] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:29 raspberrypi kernel: [   70.278066] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:30 raspberrypi kernel: [   71.284459] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:31 raspberrypi kernel: [   72.287083] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:33 raspberrypi kernel: [   74.292457] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:35 raspberrypi lepresenced[507]: Known devices (1):
Aug 29 17:50:35 raspberrypi lepresenced[507]: mac: 7c:2f:80:97:38:42, ages:  2/ 2, rssi: -71, name: Gigaset G-tag
Aug 29 17:50:35 raspberrypi kernel: [   76.304568] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:36 raspberrypi kernel: [   77.308382] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:37 raspberrypi lepresenced[532]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:50:37 raspberrypi lepresenced[507]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:50:37 raspberrypi kernel: [   78.312054] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:38 raspberrypi kernel: [   79.318332] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:39 raspberrypi kernel: [   80.325883] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:40 raspberrypi kernel: [   81.328973] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:41 raspberrypi kernel: [   82.336225] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:43 raspberrypi kernel: [   84.342224] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:44 raspberrypi kernel: [   85.343457] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:45 raspberrypi kernel: [   86.342979] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:46 raspberrypi lepresenced[507]: Known devices (1):
Aug 29 17:50:46 raspberrypi lepresenced[507]: mac: 7c:2f:80:97:38:42, ages:  1/ 2, rssi: -72, name: Gigaset G-tag
Aug 29 17:50:46 raspberrypi kernel: [   87.347251] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:47 raspberrypi kernel: [   88.352088] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:48 raspberrypi kernel: [   89.363921] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:49 raspberrypi kernel: [   90.367131] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:50 raspberrypi kernel: [   91.371744] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:52 raspberrypi kernel: [   93.377687] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:53 raspberrypi kernel: [   94.386525] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:54 raspberrypi lepresenced[532]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, ages: 1/2, max age: 60, rssi: -71, result: present.
Aug 29 17:50:54 raspberrypi lepresenced[507]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, ages: 1/2, max age: 60, rssi: -71, result: present.
Aug 29 17:50:54 raspberrypi kernel: [   95.399708] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:55 raspberrypi kernel: [   96.402271] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:56 raspberrypi kernel: [   97.410062] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:57 raspberrypi lepresenced[507]: Known devices (1):
Aug 29 17:50:57 raspberrypi lepresenced[507]: mac: 7c:2f:80:97:38:42, ages:  1/ 2, rssi: -73, name: Gigaset G-tag
Aug 29 17:50:57 raspberrypi kernel: [   98.412861] Bluetooth: hci1 advertising data length corrected
Aug 29 17:50:59 raspberrypi kernel: [  100.429162] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:00 raspberrypi kernel: [  101.432708] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:01 raspberrypi kernel: [  102.443371] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:02 raspberrypi lepresenced[532]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:51:02 raspberrypi lepresenced[507]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:51:02 raspberrypi kernel: [  103.448161] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:03 raspberrypi kernel: [  104.452675] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:04 raspberrypi kernel: [  105.453369] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:05 raspberrypi kernel: [  106.456082] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:07 raspberrypi kernel: [  108.467687] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:08 raspberrypi lepresenced[507]: Known devices (1):
Aug 29 17:51:08 raspberrypi lepresenced[507]: mac: 7c:2f:80:97:38:42, ages:  1/ 1, rssi: -69, name: Gigaset G-tag
Aug 29 17:51:09 raspberrypi kernel: [  110.476169] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:11 raspberrypi kernel: [  112.491798] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:13 raspberrypi kernel: [  114.502329] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:14 raspberrypi kernel: [  115.503221] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:15 raspberrypi kernel: [  116.507195] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:16 raspberrypi kernel: [  117.508963] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:17 raspberrypi kernel: [  118.508562] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:18 raspberrypi kernel: [  119.514211] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:19 raspberrypi lepresenced[507]: Known devices (1):
Aug 29 17:51:19 raspberrypi lepresenced[507]: mac: 7c:2f:80:97:38:42, ages:  1/ 1, rssi: -72, name: Gigaset G-tag
Aug 29 17:51:19 raspberrypi kernel: [  120.517671] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:20 raspberrypi kernel: [  121.529649] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:21 raspberrypi kernel: [  122.534585] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:22 raspberrypi kernel: [  123.537184] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:23 raspberrypi kernel: [  124.534265] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:24 raspberrypi kernel: [  125.544915] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:25 raspberrypi kernel: [  126.553422] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:26 raspberrypi kernel: [  127.561868] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:27 raspberrypi lepresenced[532]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:51:27 raspberrypi lepresenced[507]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:51:27 raspberrypi kernel: [  128.567186] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:28 raspberrypi kernel: [  129.572155] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:29 raspberrypi kernel: [  130.577732] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:30 raspberrypi lepresenced[507]: Known devices (1):
Aug 29 17:51:30 raspberrypi lepresenced[507]: mac: 7c:2f:80:97:38:42, ages:  1/ 2, rssi: -68, name: Gigaset G-tag
Aug 29 17:51:30 raspberrypi kernel: [  131.585364] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:31 raspberrypi kernel: [  132.595975] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:32 raspberrypi kernel: [  133.597932] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:33 raspberrypi kernel: [  134.608890] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:34 raspberrypi kernel: [  135.615295] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:35 raspberrypi kernel: [  136.618042] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:36 raspberrypi kernel: [  137.618905] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:37 raspberrypi kernel: [  138.623530] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:38 raspberrypi kernel: [  139.627249] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:39 raspberrypi kernel: [  140.635358] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:40 raspberrypi kernel: [  141.634895] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:41 raspberrypi lepresenced[507]: Known devices (1):
Aug 29 17:51:41 raspberrypi lepresenced[507]: mac: 7c:2f:80:97:38:42, ages:  1/ 1, rssi: -68, name: Gigaset G-tag
Aug 29 17:51:41 raspberrypi kernel: [  142.643129] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:42 raspberrypi kernel: [  143.644873] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:44 raspberrypi kernel: [  144.657253] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:45 raspberrypi kernel: [  145.655515] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:46 raspberrypi kernel: [  146.667524] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:47 raspberrypi kernel: [  147.668512] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:48 raspberrypi kernel: [  148.674126] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:50 raspberrypi kernel: [  150.675586] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:51 raspberrypi kernel: [  151.679746] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:52 raspberrypi kernel: [  152.684403] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:52 raspberrypi lepresenced[532]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:51:52 raspberrypi lepresenced[507]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:51:52 raspberrypi lepresenced[507]: Known devices (1):
Aug 29 17:51:52 raspberrypi rsyslogd-2007: action 'action 19' suspended, next retry is Tue Aug 29 17:52:22 2017 [try http://www.rsyslog.com/e/2007 ]
Aug 29 17:51:52 raspberrypi lepresenced[507]: mac: 7c:2f:80:97:38:42, ages:  0/ 1, rssi: -72, name: Gigaset G-tag
Aug 29 17:51:53 raspberrypi kernel: [  153.691866] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:54 raspberrypi kernel: [  154.699759] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:54 raspberrypi lepresenced[532]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, ages: 0/0, max age: 60, rssi: -70, result: present.
Aug 29 17:51:54 raspberrypi lepresenced[507]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:42, ages: 0/0, max age: 60, rssi: -70, result: present.
Aug 29 17:51:56 raspberrypi kernel: [  156.699846] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:58 raspberrypi kernel: [  158.719421] Bluetooth: hci1 advertising data length corrected
Aug 29 17:51:59 raspberrypi kernel: [  159.728151] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:00 raspberrypi kernel: [  160.735187] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:01 raspberrypi kernel: [  161.738549] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:02 raspberrypi kernel: [  162.745338] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:03 raspberrypi kernel: [  163.752721] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:03 raspberrypi lepresenced[507]: Known devices (1):
Aug 29 17:52:03 raspberrypi lepresenced[507]: mac: 7c:2f:80:97:38:42, ages:  0/ 1, rssi: -72, name: Gigaset G-tag
Aug 29 17:52:05 raspberrypi kernel: [  165.765082] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:07 raspberrypi kernel: [  167.780188] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:09 raspberrypi kernel: [  169.785605] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:10 raspberrypi kernel: [  170.788485] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:11 raspberrypi kernel: [  171.793188] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:12 raspberrypi kernel: [  172.799830] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:13 raspberrypi kernel: [  173.799777] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:14 raspberrypi kernel: [  174.808021] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:14 raspberrypi lepresenced[507]: Known devices (1):
Aug 29 17:52:14 raspberrypi lepresenced[507]: mac: 7c:2f:80:97:38:42, ages:  0/ 1, rssi: -69, name: Gigaset G-tag
Aug 29 17:52:15 raspberrypi kernel: [  175.812163] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:17 raspberrypi kernel: [  177.822395] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:17 raspberrypi lepresenced[532]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:52:17 raspberrypi lepresenced[507]: [tid:0] main: Sending update for mac address 7c:2f:80:97:38:38, max age: 25, result: absence.
Aug 29 17:52:19 raspberrypi kernel: [  179.835575] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:20 raspberrypi kernel: [  180.839760] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:21 raspberrypi kernel: [  181.836684] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:22 raspberrypi kernel: [  182.842363] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:23 raspberrypi kernel: [  183.841823] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:24 raspberrypi kernel: [  184.850012] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:25 raspberrypi lepresenced[507]: Known devices (1):
Aug 29 17:52:25 raspberrypi rsyslogd-2007: action 'action 19' suspended, next retry is Tue Aug 29 17:52:55 2017 [try http://www.rsyslog.com/e/2007 ]
Aug 29 17:52:25 raspberrypi lepresenced[507]: mac: 7c:2f:80:97:38:42, ages:  0/ 1, rssi: -70, name: Gigaset G-tag
Aug 29 17:52:25 raspberrypi kernel: [  185.857813] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:26 raspberrypi kernel: [  186.867520] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:27 raspberrypi kernel: [  187.865792] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:28 raspberrypi kernel: [  188.867556] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:29 raspberrypi kernel: [  189.873899] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:30 raspberrypi kernel: [  190.886977] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:31 raspberrypi kernel: [  191.895494] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:32 raspberrypi kernel: [  192.900451] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:33 raspberrypi kernel: [  193.905367] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:35 raspberrypi kernel: [  195.918213] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:36 raspberrypi lepresenced[507]: Known devices (1):
Aug 29 17:52:36 raspberrypi lepresenced[507]: mac: 7c:2f:80:97:38:42, ages:  1/ 3, rssi: -74, name: Gigaset G-tag
Aug 29 17:52:36 raspberrypi kernel: [  196.924488] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:37 raspberrypi kernel: [  197.932835] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:38 raspberrypi kernel: [  198.937402] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:39 raspberrypi kernel: [  199.948504] Bluetooth: hci1 advertising data length corrected
Aug 29 17:52:41 raspberrypi kernel: [  201.954776] Bluetooth: hci1 advertising data length corrected

Schaut für mich so aus als würde lepresenced vor den BT-Devices (oder zumindest vor einem) geladen werden und da dann drüber stolpern!?

Offline PatrickR

  • Developer
  • Sr. Member
  • ****
  • Beiträge: 867
Hi!

Schaut für mich so aus als würde lepresenced vor den BT-Devices (oder zumindest vor einem) geladen werden und da dann drüber stolpern!?

In der Tat wird lepresenced etwas früh gestartet. Teste doch mal bitte, was passiert, wenn Du lepresenced später manuell neustartest.

Ich schaue mir so lange an, wie ich bei dem systemd-Gedöhns sauber einen späteren Start hinbekomme und überlege mir eine Strafe für Leute, die das "advertising data length corrected" nicht rausfiltern :)

Patrick
lepresenced - Tracking von Bluetooth-LE-Tags (Gigaset G-Tag) mittels PRESENCE

"Programming today is a race between software engineers striving to build bigger and better idiot-proof programs, and the universe trying to produce bigger and better idiots. So far, the universe is winning." - Rich Cook

 

decade-submarginal