Hyundai Bluelink wieder kein SoC???

[gorthon]

Habe heute upgedatet, um es auch auszuprobieren. Ich habe nur einen Hyundai-Account, kein Bluelink, da erst im Dezember angelegt. Zuerst klappte der Abruf nicht, dann habe ich in openWB alle Zugangsdaten gelöscht und neu eingegeben. Wieder blieb der SoC auf 0%. Dann erneut auf Refresh geklickt und plötzlich war er da.

Dann habe ich Debug=2 eingestellt und nochmal auf Refresh geklickt, da ging es wieder nicht. Ein paar Minuten später ging es dann wieder. Hier mein Log-Auszug:

Code: Alles auswählen

2021-04-06 16:18:36: LP1: -----------------------------------------------------------
2021-04-06 16:18:34: LP1: Bluelink SoC Module ending
2021-04-06 16:18:34: LP1:     SoC Update ending
2021-04-06 16:18:34: LP1:         Applying new SoC to openWB (no manual calculation)
2021-04-06 16:18:34: LP1:         SoC received: 90%
2021-04-06 16:18:34: LP1:         SoC download ending
2021-04-06 16:18:34: LP1:             SoC = 90
2021-04-06 16:18:30: LP1:             Receiving status
2021-04-06 16:18:30: LP1:             controlToken = Bearer eyJ...
2021-04-06 16:18:30: LP1:             Sending PIN
2021-04-06 16:18:30: LP1:             Triggering Pre-Wakeup
2021-04-06 16:18:30: LP1:             VehicleId = ee1...
2021-04-06 16:18:29: LP1:             Requesting vehicle list
2021-04-06 16:18:29: LP1:             Token = Bearer eyJ...
2021-04-06 16:18:29: LP1:             Requesting Token
2021-04-06 16:18:29: LP1:             AuthCode = 6TQLUO4QOHYW1GKSXRSOFA
2021-04-06 16:18:29: LP1:             Sending username/password
2021-04-06 16:18:29: LP1:             Setting language
2021-04-06 16:18:28: LP1:             Get cookies for login
2021-04-06 16:18:28: LP1:             DeviceId = c6f45dd3-a979-4a63-8b92-05ec3feaf21c
2021-04-06 16:18:28: LP1:             Requesting DeviceId
2021-04-06 16:18:28: LP1:         SoC download starting
2021-04-06 16:18:26: LP1:     SoC Update starting (Timer expired)
2021-04-06 16:18:26: LP1:     Next update: -3273.3 minutes (-19640 ticks)
2021-04-06 16:18:26: LP1: Bluelink SoC Module starting
2021-04-06 16:18:26: LP1: -----------------------------------------------------------
2021-04-06 16:18:16: LP1: Bluelink SoC Module ending
2021-04-06 16:18:16: LP1:     Nothing to do yet
2021-04-06 16:18:16: LP1:     Next update: 58.3 minutes (350 ticks)
2021-04-06 16:18:16: LP1: Bluelink SoC Module starting
2021-04-06 16:18:16: LP1: -----------------------------------------------------------
2021-04-06 16:18:06: LP1: Bluelink SoC Module ending
2021-04-06 16:18:06: LP1:     Nothing to do yet
2021-04-06 16:18:06: LP1:     Next update: 58.5 minutes (351 ticks)
2021-04-06 16:18:06: LP1: Bluelink SoC Module starting
2021-04-06 16:18:06: LP1: -----------------------------------------------------------
2021-04-06 16:17:55: LP1: Bluelink SoC Module ending
2021-04-06 16:17:55: LP1:     Nothing to do yet
2021-04-06 16:17:55: LP1:     Next update: 58.6 minutes (352 ticks)
2021-04-06 16:17:55: LP1: Bluelink SoC Module starting
2021-04-06 16:17:55: LP1: -----------------------------------------------------------
2021-04-06 16:17:45: LP1: Bluelink SoC Module ending
2021-04-06 16:17:45: LP1:     Nothing to do yet
2021-04-06 16:17:45: LP1:     Next update: 58.8 minutes (353 ticks)
2021-04-06 16:17:45: LP1: Bluelink SoC Module starting
2021-04-06 16:17:45: LP1: -----------------------------------------------------------
2021-04-06 16:17:35: LP1: Bluelink SoC Module ending
2021-04-06 16:17:35: LP1:     Nothing to do yet
2021-04-06 16:17:35: LP1:     Next update: 59.0 minutes (354 ticks)
2021-04-06 16:17:35: LP1: Bluelink SoC Module starting
2021-04-06 16:17:35: LP1: -----------------------------------------------------------
2021-04-06 16:17:25: LP1: Bluelink SoC Module ending
2021-04-06 16:17:25: LP1:     Nothing to do yet
2021-04-06 16:17:25: LP1:     Next update: 59.1 minutes (355 ticks)
2021-04-06 16:17:25: LP1: Bluelink SoC Module starting
2021-04-06 16:17:25: LP1: -----------------------------------------------------------
2021-04-06 16:17:15: LP1: Bluelink SoC Module ending
2021-04-06 16:17:15: LP1:     Nothing to do yet
2021-04-06 16:17:15: LP1:     Next update: 59.3 minutes (356 ticks)
2021-04-06 16:17:15: LP1: Bluelink SoC Module starting
2021-04-06 16:17:15: LP1: -----------------------------------------------------------
2021-04-06 16:17:05: LP1: Bluelink SoC Module ending
2021-04-06 16:17:05: LP1:     Nothing to do yet
2021-04-06 16:17:05: LP1:     Next update: 59.5 minutes (357 ticks)
2021-04-06 16:17:05: LP1: Bluelink SoC Module starting
2021-04-06 16:17:05: LP1: -----------------------------------------------------------
2021-04-06 16:16:56: LP1: Bluelink SoC Module ending
2021-04-06 16:16:56: LP1:     Nothing to do yet
2021-04-06 16:16:56: LP1:     Next update: 59.6 minutes (358 ticks)
2021-04-06 16:16:56: LP1: Bluelink SoC Module starting
2021-04-06 16:16:56: LP1: -----------------------------------------------------------
2021-04-06 16:16:51: LP1: Bluelink SoC Module ending
2021-04-06 16:16:51: LP1:     SoC Update ending
2021-04-06 16:16:51: LP1:         SoC download not successful
2021-04-06 16:16:51: LP1:         SoC download ending
2021-04-06 16:16:51: LP1:             Connection Timeout
2021-04-06 16:16:30: LP1:             Receiving status
2021-04-06 16:16:30: LP1:             controlToken = Bearer eyJ...
2021-04-06 16:16:30: LP1:             Sending PIN
2021-04-06 16:16:30: LP1:             Triggering Pre-Wakeup
2021-04-06 16:16:30: LP1:             VehicleId = ee1...
2021-04-06 16:16:30: LP1:             Requesting vehicle list
2021-04-06 16:16:30: LP1:             Token = Bearer eyJ...
2021-04-06 16:16:30: LP1:             Requesting Token
2021-04-06 16:16:30: LP1:             AuthCode = 3CFUCMU-OUUV_ZKLYJJE5G
2021-04-06 16:16:29: LP1:             Sending username/password
2021-04-06 16:16:29: LP1:             Setting language
2021-04-06 16:16:29: LP1:             Get cookies for login
2021-04-06 16:16:29: LP1:             DeviceId = c6f45dd3-a979-4a63-8b92-05ec3feaf21c
2021-04-06 16:16:28: LP1:             Requesting DeviceId
2021-04-06 16:16:28: LP1:         SoC download starting
2021-04-06 16:16:46: LP1: Bluelink SoC Module ending
2021-04-06 16:16:46: LP1:     Nothing to do yet
2021-04-06 16:16:46: LP1:     Next update: 59.8 minutes (359 ticks)
2021-04-06 16:16:46: LP1: Bluelink SoC Module starting
2021-04-06 16:16:46: LP1: -----------------------------------------------------------

2021-04-06 16:08:36: LP1: -----------------------------------------------------------
2021-04-06 16:08:31: LP1: Bluelink SoC Module ending
2021-04-06 16:08:31: LP1:     SoC Update ending
2021-04-06 16:08:31: LP1:         SoC download not successful
2021-04-06 16:08:31: LP1:         SoC download ending
2021-04-06 16:08:31: LP1:             Receiving status failed, StatusCode: 400
2021-04-06 16:08:30: LP1:             Receiving status
2021-04-06 16:08:30: LP1:             controlToken = Bearer eyJhbG...
2021-04-06 16:08:30: LP1:             Sending PIN
2021-04-06 16:08:30: LP1:             Triggering Pre-Wakeup
2021-04-06 16:08:30: LP1:             VehicleId = ee...
2021-04-06 16:08:30: LP1:             Requesting vehicle list
2021-04-06 16:08:30: LP1:             Token = Bearer eyJhbGciOiJSUzI1...
2021-04-06 16:08:30: LP1:             Requesting Token
2021-04-06 16:08:30: LP1:             AuthCode = EX-SD6K1M3QLFFFXAYO_3A
2021-04-06 16:08:29: LP1:             Sending username/password
2021-04-06 16:08:29: LP1:             Setting language
2021-04-06 16:08:29: LP1:             Get cookies for login
2021-04-06 16:08:29: LP1:             DeviceId = c6f45dd3-a979-4a63-8b92-05ec3feaf21c
2021-04-06 16:08:28: LP1:             Requesting DeviceId
2021-04-06 16:08:28: LP1:         SoC download starting
2021-04-06 16:08:26: LP1:     SoC Update starting (Timer expired)
2021-04-06 16:08:26: LP1:     Next update: -3273.3 minutes (-19640 ticks)
2021-04-06 16:08:26: LP1: Bluelink SoC Module starting
2021-04-06 16:08:26: LP1: -----------------------------------------------------------
2021-04-06 16:08:21: LP1: Bluelink SoC Module ending
2021-04-06 16:08:21: LP1:     SoC Update ending
2021-04-06 16:08:21: LP1:         SoC download not successful
2021-04-06 16:08:21: LP1:         SoC download ending
2021-04-06 16:08:21: LP1:             Connection Timeout
2021-04-06 16:08:01: LP1:             Receiving status
2021-04-06 16:08:01: LP1:             controlToken = Bearer eyJhb...
2021-04-06 16:08:01: LP1:             Sending PIN
2021-04-06 16:08:00: LP1:             Triggering Pre-Wakeup
2021-04-06 16:08:00: LP1:             VehicleId = ee...
2021-04-06 16:07:59: LP1:             Requesting vehicle list
2021-04-06 16:07:59: LP1:             Token = Bearer eyJh...
2021-04-06 16:07:59: LP1:             Requesting Token
2021-04-06 16:07:59: LP1:             AuthCode = S-YVCGX7MYCWFXQ0RJPFSA
2021-04-06 16:07:59: LP1:             Sending username/password
2021-04-06 16:07:59: LP1:             Setting language
2021-04-06 16:07:58: LP1:             Get cookies for login
2021-04-06 16:07:58: LP1:             DeviceId = c6f45dd3-a979-4a63-8b92-05ec3feaf21c
2021-04-06 16:07:58: LP1:             Requesting DeviceId
2021-04-06 16:07:58: LP1:         SoC download starting

Per App ging es die ganze Zeit.

Beobachten andere hier Ähnliches? Ich würde jetzt dazu tendieren, die openWB auf "Abruf alle 20 Minuten" zu stellen, damit es im Schnitt dann einmal die Stunde funktioniert

Eine Bitte hätte ich noch: Es gibt eine große Diskrepanz zwischen dem, was das manuelle SoC-Modul bei Debug=0 ausgibt (massig Zeug), und dem, was das Hyundai-Modul da ausgibt (quasi gar nichts). Wäre es möglich, zumindest auch die wichtigsten Infos bei Debug=0 ins Log zu schreiben, dann kann man sich das später auch mal im Tagesverlauf anschauen. Also in obigen Beispielen wären das:

Code: Alles auswählen

SoC download starting
Connection Timeout /  Receiving status failed, StatusCode: 400 / SoC = 90
SoC Update ending

Spende ist natürlich auch schon raus

[Flocki]

Hi,

hast du mal Debug-Stufe 1 getestet? Da sollte es etwas übersichtlicher werden, aber Fehlermeldungen immer noch anzeigen.

Aus deinem Log sehe ich 2 verschiedene Probleme:

Manchmal wird die Anfrage abgelehnt. Vermutlich, weil du dein Tageslimit an Abfragen erschöpft hast.
Hyundai hat da eine Begrenzung eingebaut.. Keiner weiß hoch die genau ist, aber Konsens ist, dass abfragen öfter als alle 100-120 min zu Problemen führt. (Von den bekannten Problemen mit der 12V-Batterie mal abgesehen)

Das andere ist ein Timeout bei der Abfrage des Autos. Ich weiß nicht, wie der Hyundai sich da exakt verhält, aber von meinem Kia kenne ich das so, dass ich bei diesem Fehler auch in der App nicht mehr das Auto auslesen kann. Zwar zeigt die App dann noch einen alten gecachten SoC an, aber beim Versuch die Werte zu aktualisieren kommt dann auch eine Fehlermeldung.

Gruß,
Florian

[gorthon]

Hallo Florian,

Ja, ganz selten habe ich auch in der App einen Timeout, vielleicht in 10 Prozent der Fälle. Bei der openWB ist es aber umgekehrt, ich kriege in weit weniger als der Hälfte der Abfragen erfolgreich den SoC.

Tageslimit kann nicht sein, dann könnte ich ja auch über die App nicht abfragen. Außerdem hat die openWB ja im von mir geposteten Beispiel beim zeitlich letzten Versuch den SoC bekommen. Das nächste Update hat sie dann erst wieder nach drei Stunden geschafft, zwischendurch sind also wieder zwei Abfragen gescheitert, da ich auf stündlich eingestellt habe.

Kann man Debug 1 auch länger laufen lassen oder überquellen dann die Logs?

[Flocki]

Soweit mir bekannt kannst du das Logging problemlos auf einer höheren Debug-Stufe laufen lassen. Die Logfiles liegen in einer Ram-Disk und werden zyklisch auf eine bestimmte Anzahl Zeilen eingekürzt.

[gorthon]

Mit debug=1 bekommt man leider auch keine gute Übersicht über den Tag, weil man dann alle paar Sekunden diese Einträge hat und nicht im Web Interface genug sieht, um mehr als eine Stunde sehen zu können:

Code: Alles auswählen

2021-04-07 09:37:16: LP1: -----------------------------------------------------------
2021-04-07 09:37:06: LP1: Bluelink SoC Module ending
2021-04-07 09:37:06: LP1:     Nothing to do yet
2021-04-07 09:37:06: LP1:     Next update: 44.3 minutes (266 ticks)
2021-04-07 09:37:06: LP1: Bluelink SoC Module starting
2021-04-07 09:37:06: LP1: -----------------------------------------------------------

[gorthon]

Welches Timeout ist denn bei der Abfrage von Bluelink konfiguriert? Ich merke bei der App, dass die Abfrage auch locker mal eine Minute dauert. Könnte das Timeout vielleicht erhöht werden?

[Flocki]

Aktuell steht der Timeout auf 20 Sekunden

[gorthon]

Aktuell steht der Timeout auf 20 Sekunden

Hm, ich laufe fast immer in den Timeout bei manueller Abfrage (oder auf Error 400, wenn ich zu schnell nacheinander abfrage). Könntest du den Timeout auf 40 Sekunden setzen?


Kann man irgendwo das Log über den ganzen Tag sehen? Auf der Status-Seite kriege ich bei Debug=1 nur die ca. letzten 30 Minuten zu sehen.

[Flocki]

Ich denke der Log beinhaltet immer nur die letzten 1000 Zeilen, ältere Zeilen werden verworfen. Das ist aber SoC-unabhängig on der OpenWB gemanaged.

[gorthon]

Ich denke der Log beinhaltet immer nur die letzten 1000 Zeilen, ältere Zeilen werden verworfen. Das ist aber SoC-unabhängig on der OpenWB gemanaged.

Deshalb war ja meine Idee, bei Debug=0 immerhin eine Info bei der Abfrage (erfolgreich/Timeout/etc) auszugeben, dann könnte man im Normalzustand durch Aufruf des Logs genau sehen, wie die Abfragen über den Tag gelaufen sind. Bei Debug=1 ist ja alles paar Sekunden der Timer-Eintrag, dadurch kommt man so schnell auf die 1000 Zeilen und kann nie mal über ein paar Stunden sehen, wie viele der Regel-Abfragen erfolgreich waren.

Meine Zugangsdaten müssen ja stimmen, denn mindestens 3mal wurde seit gestern erfolgreich der SoC abgerufen.