test: modul zu integration von homebridge geräten in fhem

[justme1968]

dann war 100 zu groß. wenn du noch nicht genug hast versuch mal 10.

[andasquared]

mit 10 funktioniert es.

opened:     18:29:29
nexttoken: 19:07:25

passiert beim nexttoken genau das gleiche wie bei einem set Homebridge reconnect?

ist das dann zu oft?
.. weil du vorher meintest, zu knapp hintereinander sollte die Authentifizierung nicht gemacht werden

[justme1968]

das schaut nach einer halben stunde aus. wenn es damit ok ist ist es gut.

[andasquared]

sorry, jetzt komm ich wieder mit einer Rückmeldung 

der Tokenrefresh passiert jetzt alle ca. 30 Minuten.
allerdings bleibt es so nach einer Zeit auch stecken und das Device geht auf disconnected.

hier ein Auszug aus den Logs beim Abbruch.
(hab die Logs abgeschnitten, weil hier viel zu viel drinnen steht)

Code Auswählen Erweitern


2021.03.26 08:51:44 4: HomeBridge: posting data to http://127.0.0.1:8581/api/auth/login
2021.03.26 08:51:44 5: HomeBridge: HttpAnswer: HTTP/1.1 201 Created
Content-Security-Policy: default-src 'self';script-src 'self' 'unsafe-inline' 'unsafe-eval
X-DNS-Prefetch-Control: off
Expect-CT: max-age=0
X-Download-Options: noopen
X-Content-Type-Options: nosniff
X-Permitted-Cross-Domain-Policies: none
Referrer-Policy: no-referrer
X-XSS-Protection: 0
vary: Origin
access-control-allow-origin: false
content-type: application/json; charset=utf-8
content-length: 367
Date: Fri, 26 Mar 2021 07:51:44 GMT
Connection: close
2021.03.26 08:51:44 4: HomeBridge: Got Cookie: io=r9QPD8s47f-wW9XnAAAH
2021.03.26 08:51:44 4: HomeBridge: received {"access_token":"eyJhbGciOiJIUzI1NiIsInR5cCI6I
2021.03.26 08:51:44 3: HomeBridge: got token
2021.03.26 08:51:44 4: HomeBridge: token valid, next token refresh at: 09:29:44
2021.03.26 08:51:44 4: HomeBridge: fetching data from http://127.0.0.1:8581/socket.io/?tok
2021.03.26 08:51:44 2: HttpUtils url=http://127.0.0.1:8581/socket.io/?token=eyJhbGciOiJIUz
2021.03.26 08:51:44 1: IP: 127.0.0.1 -> 127.0.0.1
2021.03.26 08:51:44 2: HttpUtils request header:
GET /socket.io/?token=eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6ImZoZW0iLCJuYW1
Host: 127.0.0.1:8581
User-Agent: fhem
Accept-Encoding: gzip,deflate
Authorization: Bearer eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6ImZoZW0iLCJuYW1
Cookie: io=r9QPD8s47f-wW9XnAAAH

2021.03.26 08:51:44 1: http://127.0.0.1:8581/socket.io/?token=eyJhbGciOiJIUzI1NiIsInR5cCI6
2021.03.26 08:51:44 2: HttpUtils http://127.0.0.1:8581/socket.io/?token=eyJhbGciOiJIUzI1Ni
2021.03.26 08:51:44 2: HttpUtils response header:
HTTP/1.1 200 OK
Content-Type: text/plain; charset=UTF-8
Content-Length: 103
Access-Control-Allow-Origin: *
Set-Cookie: io=Md-A_SvZ5ke7TFZqAAAI; Path=/; HttpOnly; SameSite=Strict
Date: Fri, 26 Mar 2021 07:51:44 GMT
Connection: close
2021.03.26 08:51:44 5: HomeBridge: HttpAnswer: HTTP/1.1 200 OK
Content-Type: text/plain; charset=UTF-8
Content-Length: 103
Access-Control-Allow-Origin: *
Set-Cookie: io=Md-A_SvZ5ke7TFZqAAAI; Path=/; HttpOnly; SameSite=Strict
Date: Fri, 26 Mar 2021 07:51:44 GMT
Connection: close
2021.03.26 08:51:44 4: HomeBridge: Got Cookie: io=Md-A_SvZ5ke7TFZqAAAI
2021.03.26 08:51:44 4: HomeBridge: received 96:0{"sid":"Md-A_SvZ5ke7TFZqAAAI","upgrades":[
2021.03.26 08:51:44 4: HomeBridge: posting data to http://127.0.0.1:8581/socket.io/?token=
2021.03.26 08:51:44 2: HttpUtils url=http://127.0.0.1:8581/socket.io/?token=eyJhbGciOiJIUz
2021.03.26 08:51:44 1: IP: 127.0.0.1 -> 127.0.0.1
2021.03.26 08:51:44 4: HomeBridge: posting data to http://127.0.0.1:8581/socket.io/?token=
2021.03.26 08:51:44 2: HttpUtils url=http://127.0.0.1:8581/socket.io/?token=eyJhbGciOiJIUz
2021.03.26 08:51:44 1: IP: 127.0.0.1 -> 127.0.0.1
2021.03.26 08:51:44 2: HttpUtils request header:
POST /socket.io/?token=eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6ImZoZW0iLCJuYW
Host: 127.0.0.1:8581
User-Agent: fhem
Accept-Encoding: gzip,deflate
Authorization: Bearer eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6ImZoZW0iLCJuYW1
Cookie: io=Md-A_SvZ5ke7TFZqAAAI
Content-Length: 332
Content-Type: application/x-www-form-urlencoded

2021.03.26 08:51:44 2: HttpUtils request header:
POST /socket.io/?token=eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6ImZoZW0iLCJuYW
Host: 127.0.0.1:8581
User-Agent: fhem
Accept-Encoding: gzip,deflate
Authorization: Bearer eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6ImZoZW0iLCJuYW1
Cookie: io=Md-A_SvZ5ke7TFZqAAAI
Content-Length: 327
Content-Type: application/x-www-form-urlencoded

2021.03.26 08:51:44 1: http://127.0.0.1:8581/socket.io/?token=eyJhbGciOiJIUzI1NiIsInR5cCI6
2021.03.26 08:51:44 2: HttpUtils http://127.0.0.1:8581/socket.io/?token=eyJhbGciOiJIUzI1Ni
2021.03.26 08:51:44 2: HttpUtils response header:
HTTP/1.1 200 OK
Content-Type: text/html
Content-Length: 2
Access-Control-Allow-Origin: *
Set-Cookie: io=Md-A_SvZ5ke7TFZqAAAI; Path=/; HttpOnly; SameSite=Strict
Date: Fri, 26 Mar 2021 07:51:44 GMT
Connection: close
2021.03.26 08:51:44 5: HomeBridge: HttpAnswer: HTTP/1.1 200 OK
Content-Type: text/html
Content-Length: 2
Access-Control-Allow-Origin: *
Set-Cookie: io=Md-A_SvZ5ke7TFZqAAAI; Path=/; HttpOnly; SameSite=Strict
Date: Fri, 26 Mar 2021 07:51:44 GMT
Connection: close
2021.03.26 08:51:44 4: HomeBridge: Got Cookie: io=Md-A_SvZ5ke7TFZqAAAI
2021.03.26 08:51:44 4: HomeBridge: received ok
2021.03.26 08:51:44 2: parseHttpAnswer: unhandled key socket.io:step2b
2021.03.26 08:51:44 1: http://127.0.0.1:8581/socket.io/?token=eyJhbGciOiJIUzI1NiIsInR5cCI6
2021.03.26 08:51:44 2: HttpUtils http://127.0.0.1:8581/socket.io/?token=eyJhbGciOiJIUzI1Ni
2021.03.26 08:51:44 2: HttpUtils response header:
HTTP/1.1 200 OK
Content-Type: text/html
Content-Length: 2
Access-Control-Allow-Origin: *
Set-Cookie: io=Md-A_SvZ5ke7TFZqAAAI; Path=/; HttpOnly; SameSite=Strict
Date: Fri, 26 Mar 2021 07:51:44 GMT
Connection: close
2021.03.26 08:51:44 5: HomeBridge: HttpAnswer: HTTP/1.1 200 OK
Content-Type: text/html
Content-Length: 2
Access-Control-Allow-Origin: *
Set-Cookie: io=Md-A_SvZ5ke7TFZqAAAI; Path=/; HttpOnly; SameSite=Strict
Date: Fri, 26 Mar 2021 07:51:44 GMT
Connection: close
2021.03.26 08:51:44 4: HomeBridge: Got Cookie: io=Md-A_SvZ5ke7TFZqAAAI
2021.03.26 08:51:44 4: HomeBridge: received ok
2021.03.26 08:51:44 4: HomeBridge: fetching data from http://127.0.0.1:8581/socket.io/?tok
2021.03.26 08:51:44 2: HttpUtils url=http://127.0.0.1:8581/socket.io/?token=eyJhbGciOiJIUz
2021.03.26 08:51:44 1: IP: 127.0.0.1 -> 127.0.0.1
2021.03.26 08:51:44 2: HttpUtils request header:
GET /socket.io/?token=eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6ImZoZW0iLCJuYW1
Host: 127.0.0.1:8581
User-Agent: fhem
Accept-Encoding: gzip,deflate
Authorization: Bearer eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6ImZoZW0iLCJuYW1
Cookie: io=Md-A_SvZ5ke7TFZqAAAI

2021.03.26 08:51:44 1: http://127.0.0.1:8581/socket.io/?token=eyJhbGciOiJIUzI1NiIsInR5cCI6
2021.03.26 08:51:44 2: HttpUtils http://127.0.0.1:8581/socket.io/?token=eyJhbGciOiJIUzI1Ni
2021.03.26 08:51:44 2: HttpUtils response header:
HTTP/1.1 200 OK
Content-Type: text/plain; charset=UTF-8
Content-Length: 31
Access-Control-Allow-Origin: *
Set-Cookie: io=Md-A_SvZ5ke7TFZqAAAI; Path=/; HttpOnly; SameSite=Strict
Date: Fri, 26 Mar 2021 07:51:44 GMT
Connection: close
2021.03.26 08:51:44 5: HomeBridge: HttpAnswer: HTTP/1.1 200 OK
Content-Type: text/plain; charset=UTF-8
Content-Length: 31
Access-Control-Allow-Origin: *
Set-Cookie: io=Md-A_SvZ5ke7TFZqAAAI; Path=/; HttpOnly; SameSite=Strict
Date: Fri, 26 Mar 2021 07:51:44 GMT
Connection: close
2021.03.26 08:51:44 4: HomeBridge: Got Cookie: io=Md-A_SvZ5ke7TFZqAAAI
2021.03.26 08:51:44 4: HomeBridge: received 15:40/accessories,10:40/status,
2021.03.26 08:51:44 3: Opening HomeBridge device ws:127.0.0.1:8581/socket.io/?token=eyJhbG
2021.03.26 08:51:44 5: HttpUtils url=http://127.0.0.1:8581/socket.io/?token=eyJhbGciOiJIUz
2021.03.26 08:51:44 4: IP: 127.0.0.1 -> 127.0.0.1
2021.03.26 08:51:44 5: HttpUtils request header:
GET /socket.io/?token=eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6ImZoZW0iLCJuYW1
Host: 127.0.0.1:8581
User-Agent: fhem
Accept-Encoding: gzip,deflate
Sec-WebSocket-Version: 13
Upgrade: websocket
Connection: Upgrade
Cookie: io=Md-A_SvZ5ke7TFZqAAAI
Sec-WebSocket-Key: 0shFHI4hVspB5AwWBgYWwg==

2021.03.26 08:51:44 4: http://127.0.0.1:8581/socket.io/?token=eyJhbGciOiJIUzI1NiIsInR5cCI6
2021.03.26 08:51:44 5: HttpUtils http://127.0.0.1:8581/socket.io/?token=eyJhbGciOiJIUzI1Ni
2021.03.26 08:51:44 5: HttpUtils response header:
HTTP/1.1 101 Switching Protocols
Upgrade: websocket
Connection: Upgrade
Sec-WebSocket-Accept: yCJBIO2eYYj4jbuF7AeJF06pEow=
2021.03.26 08:51:44 3: HomeBridge device opened
2021.03.26 08:51:44 5: SW: 2probe
2021.03.26 08:51:44 5: SW: 5
2021.03.26 08:51:44 5: SW: 42/accessories,["get-accessories"]
2021.03.26 08:51:44 5: Websocket msg: OP:1 LEN:6 MASK:0 FIN:1
2021.03.26 08:51:44 5: HomeBridge: got: 3probe
2021.03.26 08:51:44 5: HomeBridge: got pong: 3probe
2021.03.26 08:51:44 5: Websocket msg: OP:1 LEN:107595 MASK:0 FIN:1
2021.03.26 08:51:44 5: HomeBridge: got: 42/accessories,["accessories-data",[{"aid":1,"iid"
2021.03.26 08:51:44 1: ws:127.0.0.1:8581/socket.io/?token=eyJhbGciOiJIUzI1NiIsInR5cCI6IkpX
2021.03.26 08:51:44 1: !!!!closed!!!!


um 6:55 heute hab ich Fhem neu gestartet.
um 8:51 ist das Device auf disconnected gegangen.

ich kenne mich viel zu wenig im Detail mit der Technik aus, aber es scheint so als würde ein set Homebridge reconnect was anderes zu machen, als ein Tokenrefresh.
beim Reconnecten ist das Device immer opened geblieben.

vielleicht hilft dir das irgendwie weiter

[Sascha_F]

Hi zusammen,

eine kurze Rückmeldung von mir: Das Problem mit dem HomeBridge-Device habe ich auch. Es wechselt auf disconnected und nur ein FHEM-Neustart behebt es. Da ich aber eh einen MQTT-Broker (MQTT2_SERVER) laufen habe, habe ich in Homebride im homebridge-unifi-protect den Broker eingetragen. Im Beispiel der "Eingabehilfe" ist es nicht benannt, aber es ist mqtt://user:passwort@IP:Port (sofern der Broker selbst oder über ein ALLOWED-Device abgesichert ist) --> damit werden die Motion-Events dann an das MQTT-Device übergeben. Für mich zumindest ist das OK, da ich den Broker eh laufen habe.

Ggf. ist dieses auch eine Variante (oder zumindest temporäre Lösung). @justme1968: Ich weiß nicht, wie das die breite Masse sieht, könnte Dich aber ggf. auch hinsichtlich der 39_homekitDevice.pm bzw. eher der 39_homebridge.pm entlasten...


Edit: Naja, etwas zu früh gefreut. Nach jedem Homebrigde-Neustart (oder zu Zeitpunkt X) erhalte ich das Motion-Event über den MQTT-Broker, allerdings werden immer neue Devices (z.B. MQTT2_mqttjs_2e35b933) angelegt (subscriptions ist unverändert) = so ist das natürlich nicht nutzbar. Genau dieses Problem hatte ich mit einer RING-Doorbell schon mal und konnte es nicht wirklich lösen (auch mqttjs) - bin dann dafür auf IFTTT umgestiegen. Und jetzt, wo ich demnächst auch auf die UniFi Doorbell wechseln will, holt es mich wieder ein :-/

Edit2: Wenn ich alles richtig verstanden habe, dann erzeugt mqttjs immer eine neue ClientID (was auch so gewollt ist) - was dann zum autocreate neuer Devices führt. Das autocreate sollte allerdings nur erfolgen, sofern noch kein MTTT2_DEVICE "lauscht". Ich habe jetzt im attr readingList die ClientID entfernt --> das sollte jetzt eigentlich schon die Lösung sein.

viele Grüße
Sascha

[mcp]

ich hab's soeben installiert und in FHEM eingebunden.

Ich bekomme leider keine Devices angelegt trotz autocreate aktiv, -I (insecure Mode) und admin Rechten.

FHEM in aktuell von grade eben, Homebridge 1.3.4 mit diversen Sub-Bridges, ebenso homebridge-config-ui-x, Raspian Buster auf einen Pi 4b.

Im FHEM Log sieht man sowas:

Code Auswählen Erweitern


2021.08.04 18:13:29 1: socket.io: unexpected answer: 97:0{"sid":"zVcY10dAbQJmnP7bAAAF","upgrades":["websocket"],"pingInterval":25000,"pingTimeout":20000}


Code Auswählen Erweitern


Internals:
   CFGFN     
   DEF        127.0.0.1:8581
   FUUID      610abadf-f33f-b956-0f49-781ab015efea6230
   HOST       127.0.0.1:8581
   NAME       homebridge
   NOTIFYDEV  global
   NR         723
   NTFY_ORDER 50-homebridge
   STATE      active
   TYPE       homebridge
   homebridgeInstanceName Homebridge MCP
   homebridgeVersion 1.3.4
   nexttoken  02:03:29
   helper:
     auth:
       access_token foobarblabla
       expires_in 28800
       timestamp  1628093609.25499
       token_type Bearer
Attributes:
   password   crypt:bla
   room       23_Homekit
   user       crypt:blub


Wenn er keine Devices erstellt die eh von FHEM kommen ist ja super, ich hab aber auch 4 Devices die nicht in FHEM drin sind, zumindest die würde ich gerne sehen wollen

What am I doing wrong?

[justme1968]

sind alle voraussetzungen laut erstem post erfüllt?
- insecure mode?
- homebridge-config-ui-x ?

wenn ja fällt mir auf die schelle nichts ein. kann erst nach dem urlaub schauen. vielleicht siehst du mit verbose 4/5 mehr.

[mcp]

Ja, hatte ich auch geschrieben.

Ich probiere mal mit verbose und schau mal ob ich was rausfinden kann.

Vielen Dank jedenfalls schon mal für deine Arbeit und weiterhin einen schönen Urlaub

[mcp]

Man sieht die ganzen HTTP Response Header, Return Codes sind alle 200, und dann am Ende wieder den socket.io unexpected answer Fehler (der erste im Code)

Code Auswählen Erweitern


2021.08.04 18:46:20 4: homebridge: Got Cookie:
2021.08.04 18:46:20 4: homebridge: received 97:0{"sid":"Ne-eTrqY2vHzF6syAAAM","upgrades":["websocket"],"pingInterval":25000,"pingTimeout":20000}
2021.08.04 18:46:20 1: socket.io: unexpected answer: 97:0{"sid":"Ne-eTrqY2vHzF6syAAAM","upgrades":["websocket"],"pingInterval":25000,"pingTimeout":20000}


Bei Bedarf kann ich natürlich auch das ganze Log posten.

[mcp]

Guten Morgen.

Gibt's evtl. schon irgendwelche Neuigkeiten oder bist du immer noch im Urlaub @justme1968?

[justme1968]

gerade auf dem rückweg . dauert noch bis zum
wochende. dann schaue ich.

[mcp]

Ich hoffe du hattest einen schönen Urlaub und bist wieder gut nach Hause gekommen.

Ich wollte mal vorsichtig anfragen ob du schon Zeit hattest?

Ich bin wirklich gespannt auf die Möglichkeit die das Modul hier bietet und würde es wirklich gerne nutzen.

Vielen Dank.

[justme1968]

ja. inzwischen bin ich zurück. das problem steht fürs wochenende auf dem plan.

[justme1968]

ich glaube das problem fängt schon mit der Got Cookie zeile an. da sollte das cookie stehen. bitte poste mal die HttpAnswer zeile direkt davor wenn du mit verbose 5 logst.

[mcp]

ich poste mal das ganze Log

Code Auswählen Erweitern


2021.09.12 21:41:24 4: homebridge2fhem: fetching data from http://127.0.0.1:8581/api/auth/settings
2021.09.12 21:41:24 5: homebridge2fhem: HttpAnswer: HTTP/1.1 200 OK
Content-Security-Policy: default-src 'self';script-src 'self' 'unsafe-inline' 'unsafe-eval';style-src 'self' 'unsafe-inline';img-src 'self' data: https://raw.githubusercontent.com https://user-images.githubusercontent.com;connect-src 'self' https://ope
nweathermap.org https://api.openweathermap.org wss://127.0.0.1:8581 ws://127.0.0.1:8581
X-DNS-Prefetch-Control: off
Expect-CT: max-age=0
X-Download-Options: noopen
X-Content-Type-Options: nosniff
X-Permitted-Cross-Domain-Policies: none
Referrer-Policy: no-referrer
X-XSS-Protection: 0
vary: Origin
content-type: application/json; charset=utf-8
content-length: 552
Date: Sun, 12 Sep 2021 19:41:24 GMT
Connection: close
2021.09.12 21:41:24 4: homebridge2fhem: Got Cookie:
2021.09.12 21:41:24 4: homebridge2fhem: received {"env":{"ableToConfigureSelf":true,"enableAccessories":true,"enableTerminalAccess":true,"homebridgeVersion":"1.3.4","homebridgeInstanceName":"Homebridge MCP","nodeVersion":"v14.17.6","packageName":"homebridge-config-ui-x","packageVersion":"4.41.2","platform":"linux","runningInDocker":false,"runningInLinux":true,"dockerOfflineUpdate":false,"serviceMode":true,"temperatureUnits":"c","lang":null,"instanceId":"5a30199053e0172181057be3e894246fc4c5539360e2dec84b60e1d2379bce0b"},"formAuth":true,"theme":"auto","serverTimestamp":"2021-09-12T19:41:24.330Z"}
2021.09.12 21:41:24 1: $VAR1 = 'Content-Security-Policy: default-src \'self\';script-src \'self\' \'unsafe-inline\' \'unsafe-eval\';style-src \'self\' \'unsafe-inline\';img-src \'self\' data: https://raw.githubusercontent.com https://user-images.githubusercontent.com;connect-src \'self\' https://openweathermap.org https://api.openweathermap.org wss://127.0.0.1:8581 ws://127.0.0.1:8581 ';
$VAR2 = 'X-DNS-Prefetch-Control: off';
$VAR3 = 'Expect-CT: max-age=0';
$VAR4 = 'X-Download-Options: noopen';
$VAR5 = 'X-Content-Type-Options: nosniff';
$VAR6 = 'X-Permitted-Cross-Domain-Policies: none';
$VAR7 = 'Referrer-Policy: no-referrer';
$VAR8 = 'X-XSS-Protection: 0';
$VAR9 = 'vary: Origin';
$VAR10 = 'content-type: application/json; charset=utf-8';
$VAR11 = 'content-length: 552';
$VAR12 = 'Date: Sun, 12 Sep 2021 19:41:24 GMT';
$VAR13 = 'Connection: close';

2021.09.12 21:41:24 4: homebridge2fhem: posting data to http://127.0.0.1:8581/api/auth/login
2021.09.12 21:41:24 5: homebridge2fhem: HttpAnswer: HTTP/1.1 201 Created
Content-Security-Policy: default-src 'self';script-src 'self' 'unsafe-inline' 'unsafe-eval';style-src 'self' 'unsafe-inline';img-src 'self' data: https://raw.githubusercontent.com https://user-images.githubusercontent.com;connect-src 'self' https://openweathermap.org https://api.openweathermap.org wss://127.0.0.1:8581 ws://127.0.0.1:8581
X-DNS-Prefetch-Control: off
Expect-CT: max-age=0
X-Download-Options: noopen
X-Content-Type-Options: nosniff
X-Permitted-Cross-Domain-Policies: none
Referrer-Policy: no-referrer
X-XSS-Protection: 0
vary: Origin
content-type: application/json; charset=utf-8
content-length: 368
Date: Sun, 12 Sep 2021 19:41:24 GMT
Connection: close
2021.09.12 21:41:24 4: homebridge2fhem: Got Cookie:
2021.09.12 21:41:24 4: homebridge2fhem: received {"access_token":"eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6ImFkbWluIiwibmFtZSI6IkFkbWluaXN0cmF0b3IiLCJhZG1pbiI6dHJ1ZSwiaW5zdGFuY2VJZCI6IjVhMzAxOTkwNTNlMDE3MjE4MTA1N2JlM2U4OTQyNDZmYzRjNTUzOTM2MGUyZGVjODRiNjBlMWQyMzc5YmNlMGIiLCJpYXQiOjE2MzE0NzU2ODQsImV4cCI6MTYzMTUwNDQ4NH0.XoBIEzqFTyDMI26LvHjY0jIGdnM6E8RIU-LNyMEQYW8","token_type":"Bearer","expires_in":28800}
2021.09.12 21:41:24 3: homebridge2fhem: got token
2021.09.12 21:41:24 4: homebridge2fhem: token valid, next token refresh at: 05:31:24
2021.09.12 21:41:24 4: homebridge2fhem: fetching data from http://127.0.0.1:8581/socket.io/?token=eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6ImFkbWluIiwibmFtZSI6IkFkbWluaXN0cmF0b3IiLCJhZG1pbiI6dHJ1ZSwiaW5zdGFuY2VJZCI6IjVhMzAxOTkwNTNlMDE3MjE4MTA1N2JlM2U4OTQyNDZmYzRjNTUzOTM2MGUyZGVjODRiNjBlMWQyMzc5YmNlMGIiLCJpYXQiOjE2MzE0NzU2ODQsImV4cCI6MTYzMTUwNDQ4NH0.XoBIEzqFTyDMI26LvHjY0jIGdnM6E8RIU-LNyMEQYW8&EIO=3&transport=polling
2021.09.12 21:41:24 2: HttpUtils url=http://127.0.0.1:8581/socket.io/?token=eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6ImFkbWluIiwibmFtZSI6IkFkbWluaXN0cmF0b3IiLCJhZG1pbiI6dHJ1ZSwiaW5zdGFuY2VJZCI6IjVhMzAxOTkwNTNlMDE3MjE4MTA1N2JlM2U4OTQyNDZmYzRjNTUzOTM2MGUyZGVjODRiNjBlMWQyMzc5YmNlMGIiLCJpYXQiOjE2MzE0NzU2ODQsImV4cCI6MTYzMTUwNDQ4NH0.XoBIEzqFTyDMI26LvHjY0jIGdnM6E8RIU-LNyMEQYW8&EIO=3&transport=polling NonBlocking via http
2021.09.12 21:41:24 1: IP: 127.0.0.1 -> 127.0.0.1
2021.09.12 21:41:24 2: HttpUtils request header:
GET /socket.io/?token=eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6ImFkbWluIiwibmFtZSI6IkFkbWluaXN0cmF0b3IiLCJhZG1pbiI6dHJ1ZSwiaW5zdGFuY2VJZCI6IjVhMzAxOTkwNTNlMDE3MjE4MTA1N2JlM2U4OTQyNDZmYzRjNTUzOTM2MGUyZGVjODRiNjBlMWQyMzc5YmNlMGIiLCJpYXQiOjE2MzE0NzU2ODQsImV4cCI6MTYzMTUwNDQ4NH0.XoBIEzqFTyDMI26LvHjY0jIGdnM6E8RIU-LNyMEQYW8&EIO=3&transport=polling HTTP/1.0
Host: 127.0.0.1:8581
User-Agent: fhem
Accept-Encoding: gzip,deflate
Authorization: Bearer eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6ImFkbWluIiwibmFtZSI6IkFkbWluaXN0cmF0b3IiLCJhZG1pbiI6dHJ1ZSwiaW5zdGFuY2VJZCI6IjVhMzAxOTkwNTNlMDE3MjE4MTA1N2JlM2U4OTQyNDZmYzRjNTUzOTM2MGUyZGVjODRiNjBlMWQyMzc5YmNlMGIiLCJpYXQiOjE2MzE0NzU2ODQsImV4cCI6MTYzMTUwNDQ4NH0.XoBIEzqFTyDMI26LvHjY0jIGdnM6E8RIU-LNyMEQYW8
Cookie:

2021.09.12 21:41:24 1: http://127.0.0.1:8581/socket.io/?token=eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6ImFkbWluIiwibmFtZSI6IkFkbWluaXN0cmF0b3IiLCJhZG1pbiI6dHJ1ZSwiaW5zdGFuY2VJZCI6IjVhMzAxOTkwNTNlMDE3MjE4MTA1N2JlM2U4OTQyNDZmYzRjNTUzOTM2MGUyZGVjODRiNjBlMWQyMzc5YmNlMGIiLCJpYXQiOjE2MzE0NzU2ODQsImV4cCI6MTYzMTUwNDQ4NH0.XoBIEzqFTyDMI26LvHjY0jIGdnM6E8RIU-LNyMEQYW8&EIO=3&transport=polling: HTTP response code 200
2021.09.12 21:41:24 2: HttpUtils http://127.0.0.1:8581/socket.io/?token=eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6ImFkbWluIiwibmFtZSI6IkFkbWluaXN0cmF0b3IiLCJhZG1pbiI6dHJ1ZSwiaW5zdGFuY2VJZCI6IjVhMzAxOTkwNTNlMDE3MjE4MTA1N2JlM2U4OTQyNDZmYzRjNTUzOTM2MGUyZGVjODRiNjBlMWQyMzc5YmNlMGIiLCJpYXQiOjE2MzE0NzU2ODQsImV4cCI6MTYzMTUwNDQ4NH0.XoBIEzqFTyDMI26LvHjY0jIGdnM6E8RIU-LNyMEQYW8&EIO=3&transport=polling: Got data, length: 100
2021.09.12 21:41:24 2: HttpUtils response header:
HTTP/1.1 200 OK
Vary: Origin
Access-Control-Allow-Credentials: true
Content-Type: text/plain; charset=UTF-8
Content-Length: 100
Date: Sun, 12 Sep 2021 19:41:24 GMT
Connection: close
2021.09.12 21:41:24 5: homebridge2fhem: HttpAnswer: HTTP/1.1 200 OK
Vary: Origin
Access-Control-Allow-Credentials: true
Content-Type: text/plain; charset=UTF-8
Content-Length: 100
Date: Sun, 12 Sep 2021 19:41:24 GMT
Connection: close
2021.09.12 21:41:24 4: homebridge2fhem: Got Cookie:
2021.09.12 21:41:24 4: homebridge2fhem: received 97:0{"sid":"1h1JED8llK9mz0UvAAAH","upgrades":["websocket"],"pingInterval":25000,"pingTimeout":20000}
2021.09.12 21:41:24 1: socket.io: unexpected answer 1: 97:0{"sid":"1h1JED8llK9mz0UvAAAH","upgrades":["websocket"],"pingInterval":25000,"pingTimeout":20000}