Home Connect: Kaffeeauswahl

Begonnen von Schlimbo, 28 Februar 2018, 22:53:09

Vorheriges Thema - Nächstes Thema

Schlimbo

Hallo,
Besitze einen Siemens Kaffeevollautomaten EQ.9 Connect und würde die Kaffeeauswahl gerne über FHEM triggern.
Hierfür gibt es im HomeConnect Modul verschiedenen set Befehle z.B.
set <device> startProgram Espresso

Laut API Beschreibung gibt es hierzu noch die optionalen Parameter "BeanAmount" und "FillQuantity".
Auszug aus
https://developer.home-connect.com/?q=docs/coffee-maker/supported_programs_and_options
{
    "data":{
        "key":"ConsumerProducts.CoffeeMaker.Program.Beverage.Espresso",
        "options":[
            {
                "key":"ConsumerProducts.CoffeeMaker.Option.BeanAmount",
                "value":"ConsumerProducts.CoffeeMaker.EnumType.BeanAmount.Mild"
            },
            {
                "key":"ConsumerProducts.CoffeeMaker.Option.FillQuantity",
                "value":45,
                "unit":"ml"
            }
        ]
    }
}


Ist es irgendwie möglich diese Parameter beim "startProgram" Befehl mit anzuhängen?

Gruß Schlimbo

Schlimbo

Gut fände ich es auch wenn es eine Möglichkeit gäbe raw Daten zu senden und dies auch unabhängig von irgendwelchen Abhängigkeiten.

Das Problem was ich nämlich momentan habe, ist dass die HomeConnect API Events so verzögert kommen, das hierdurch das Modul fast unbenutzbar wird.
Wird die Kaffeemaschine eingeschaltet, macht sie Geräte bedingt erst mal einen Spülgang, dieser dauert nur ein paar Sekunden,
in FHEM wird beim Start der Spülung "ActiveProgram = CleaningModes.ApplianceOnRinsing" gesetzt und "ProgramProgress" fängt an von 0% hoch zu zählen, dies dauert aber ca. 5 Minuten. (Der Spülgang an der Maschine ist nach ca. 30s fertig!)

Hier läuft mit der API etwa gewaltig schief, habe nach dem lesen hier im Forum aber auch keine große Hoffnung, dass sich hier seitens Home Connect auf die schnelle etwas ändern wird :-\.
2018.03.01 17:38:31.852 4: BSH.Common.Root.ActiveProgram = ConsumerProducts.CoffeeMaker.Program.CleaningModes.ApplianceOnRinsing
2018.03.01 17:38:31.852 4: BSH.Common.Option.ProgramProgress = 0 %
2018.03.01 17:38:51.971 4: BSH.Common.Option.ProgramProgress = 5 %
2018.03.01 17:39:02.039 4: BSH.Common.Option.ProgramProgress = 11 %
2018.03.01 17:39:12.116 4: BSH.Common.Option.ProgramProgress = 13 %
2018.03.01 17:39:22.182 4: BSH.Common.Option.ProgramProgress = 16 %
2018.03.01 17:39:32.498 4: BSH.Common.Option.ProgramProgress = 18 %
2018.03.01 17:39:42.569 4: BSH.Common.Option.ProgramProgress = 21 %
2018.03.01 17:39:52.635 4: BSH.Common.Option.ProgramProgress = 23 %
2018.03.01 17:40:02.712 4: BSH.Common.Option.ProgramProgress = 26 %
2018.03.01 17:40:12.784 4: BSH.Common.Option.ProgramProgress = 28 %
2018.03.01 17:40:22.849 4: BSH.Common.Option.ProgramProgress = 31 %
2018.03.01 17:40:32.911 4: BSH.Common.Option.ProgramProgress = 33 %
2018.03.01 17:40:42.977 4: BSH.Common.Option.ProgramProgress = 36 %
2018.03.01 17:40:53.058 4: BSH.Common.Option.ProgramProgress = 38 %
2018.03.01 17:41:03.121 4: BSH.Common.Option.ProgramProgress = 41 %
2018.03.01 17:41:13.177 4: BSH.Common.Option.ProgramProgress = 43 %
2018.03.01 17:41:23.227 4: BSH.Common.Option.ProgramProgress = 46 %
2018.03.01 17:41:33.515 4: BSH.Common.Option.ProgramProgress = 48 %
2018.03.01 17:41:43.576 4: BSH.Common.Option.ProgramProgress = 51 %
2018.03.01 17:41:53.653 4: BSH.Common.Option.ProgramProgress = 53 %
2018.03.01 17:42:03.716 4: BSH.Common.Option.ProgramProgress = 55 %
2018.03.01 17:42:13.795 4: BSH.Common.Option.ProgramProgress = 57 %
2018.03.01 17:42:23.858 4: BSH.Common.Option.ProgramProgress = 60 %
2018.03.01 17:42:33.932 4: BSH.Common.Option.ProgramProgress = 62 %
2018.03.01 17:42:43.990 4: BSH.Common.Option.ProgramProgress = 64 %
2018.03.01 17:42:54.049 4: BSH.Common.Option.ProgramProgress = 67 %
2018.03.01 17:43:04.321 4: BSH.Common.Option.ProgramProgress = 95 %
2018.03.01 17:43:34.497 4: BSH.Common.Root.ActiveProgram = -


Möchte ich nach dem Einschalten direkt ein Getränk über "startProgram.." beziehen, muss ich also erst 5 Minuten Warten!
Ein "set <name> startProgram espresso" gibt mir nämlich während dieser Zeit nur "A program is already running" zurück.

Als Workaround würde ich deshalb einfach gerne Raw Daten schicken wollen, in der Hoffnung, dass die API das an die Maschine weiter gibt und mein Espresso gebrüht wird.
z.B.
set <name> raw /programs/active{"data":{"key":"ConsumerProducts.CoffeeMaker.Program.Beverage.Espresso","options":[{"key":"ConsumerProducts.CoffeeMaker.Option.BeanAmount","value":"ConsumerProducts.CoffeeMaker.EnumType.BeanAmount.Mild"},{"key":"ConsumerProducts.CoffeeMaker.Option.FillQuantity","value":45,"unit":"ml"}]}}
Dies würde auch ein weiteres Problem Lösen:
Manchmal wird mir nämlich auch überhaupt keine "startProgram" Auswahl angezeigt, manchmal auch nur eine Auswahl: "ApplianceOnRinsing" , ein "set <name> startProgram espresso" gibt mir dann den Fehler:
Unknown program Espresso, choose one of ApplianceOnRinsing
Warum mir manchmal kein, oder nur "ApplianceOnRinsing" als Programm Auswahl angezeigt wird ist mir auch noch nicht so klar, beim versuch dieses zu starten kommt:
Unsupported operation: ConsumerProducts.CoffeeMaker.Program.CleaningModes.ApplianceOnRinsing

Gruß Schlimbo

Schlimbo

Und hier noch ein Beispiel, ein Ristretto mit 25ml benötigt laut API 3 Minuten ::)
2018.03.01 20:44:46.696 4: BSH.Common.Root.ActiveProgram = ConsumerProducts.CoffeeMaker.Program.Beverage.Ristretto
2018.03.01 20:44:46.697 4: ConsumerProducts.CoffeeMaker.Option.CoffeeTemperature = ConsumerProducts.CoffeeMaker.EnumType.CoffeeTemperature.90C
2018.03.01 20:44:46.697 4: ConsumerProducts.CoffeeMaker.Option.BeanAmount = ConsumerProducts.CoffeeMaker.EnumType.BeanAmount.VeryStrong
2018.03.01 20:44:46.698 4: ConsumerProducts.CoffeeMaker.Option.FillQuantity = 25 ml
2018.03.01 20:44:46.698 4: BSH.Common.Option.ProgramProgress = 0 %
.
.
.
2018.03.01 20:47:38.015 4: BSH.Common.Root.SelectedProgram = ConsumerProducts.CoffeeMaker.Program.Beverage.Ristretto
2018.03.01 20:47:38.016 4: ConsumerProducts.CoffeeMaker.Option.CoffeeTemperature = ConsumerProducts.CoffeeMaker.EnumType.CoffeeTemperature.90C
2018.03.01 20:47:38.016 4: ConsumerProducts.CoffeeMaker.Option.BeanAmount = ConsumerProducts.CoffeeMaker.EnumType.BeanAmount.VeryStrong
2018.03.01 20:47:38.017 4: ConsumerProducts.CoffeeMaker.Option.FillQuantity = 25 ml
2018.03.01 20:47:38.018 4: BSH.Common.Option.ProgramProgress = 100 %

Mir kommt es vor, als werden die Events in irgendeinen queue gesammelt und dann nur mit Verzögerung ausgegeben, lasse ich an der Maschine mehrer Kaffee Getränke nach einander raus, sammeln sich so viele Events an, dass eine halbe Stunde später in FHEM immer noch Events ankommen.

Pf@nne

Das ist bei meinen Geräten (GS, Ofen) auch immer so, wenn ein Programm läuft.
Wenn kein Programm läuft geht es ein wenig schneller, z.B. Tür AUF/ZU.
Aber auch das hat ca. 5-10Sekunden Verzögerung.

FHEM auf: DS415+ (Master), Raspberry Pi 2

Schlimbo

Zitat von: Schlimbo am 01 März 2018, 20:39:37
Als Workaround würde ich deshalb einfach gerne Raw Daten schicken wollen, in der Hoffnung, dass die API das an die Maschine weiter gibt und mein Espresso gebrüht wird.

Gerade noch mal getestet:
Habe in 48_HomeConnect.pm die Zeile 115 auskommentiert
#   return "A program is already running" if ($pgmRunning);
jetzt kann ich direkt nach dem Einschalten eine Kaffee beziehen, auch wenn die API noch der Meinung ist, dass der Spülgang noch läuft.

Ablauf
21:03:38 über FHEM die Maschine eingeschaltet
21:04:39 über FHEM Espresso bezogen (wurde auch sofort von der Maschine ausgegeben)
21:09:46 API Meldet Spülgang nach Power-On fertig
21:10:16 API Meldet start Espresso
21:14:48 API Meldet Espresso fertig

Hier der Log in abgespeckter Form dazu:
2018.03.01 21:03:38.333 3: set command: BSH.Common.Setting.PowerState
2018.03.01 21:03:38.334 4: TI123xxx PUT request: https://api.home-connect.com/api/homeappliances/SIEMENS-TI123xxx-xxxxxxxxxxxx/settings/BSH.Common.Setting.PowerState with data: {"data":{"key":"BSH.Common.Setting.PowerState","value":"BSH.Common.EnumType.PowerState.On"}}
2018.03.01 21:03:53.270 5: TI123xxx event channel data: {"items":[{"timestamp":1519934620,"handling":"none","uri":"/api/homeappliances/SIEMENS-TI123xxx-xxxxxxxxxxxx/programs/active","key":"BSH.Common.Root.ActiveProgram","value":"ConsumerProducts.CoffeeMaker.Program.CleaningModes.ApplianceOnRinsing","level":"hint"},{"timestamp":1519934620,"handling":"none","uri":"/api/homeappliances/SIEMENS-TI123xxx-xxxxxxxxxxxx/programs/active/BSH.Common.Option.ProgramProgress","key":"BSH.Common.Option.ProgramProgress","unit":"%","value":0,"level":"hint"}]}
2018.03.01 21:03:53.272 4: BSH.Common.Root.ActiveProgram = ConsumerProducts.CoffeeMaker.Program.CleaningModes.ApplianceOnRinsing
2018.03.01 21:03:53.273 4: BSH.Common.Option.ProgramProgress = 0 %
2018.03.01 21:03:53.273 4: BSH.Common.Option.ProgramProgress = 0 %
2018.03.01 21:04:03.356 4: BSH.Common.Option.ProgramProgress = 0 %
2018.03.01 21:04:23.471 4: BSH.Common.Option.ProgramProgress = 0 %
2018.03.01 21:04:39.845 3: set command: startProgram
2018.03.01 21:04:39.846 4: TI123xxx PUT request: https://api.home-connect.com/api/homeappliances/SIEMENS-TI123xxx-xxxxxxxxxxxx/programs/active with data: {"data":{"key":"ConsumerProducts.CoffeeMaker.Program.Beverage.Espresso","options":[]}}
2018.03.01 21:04:43.680 4: BSH.Common.Root.ActiveProgram = ConsumerProducts.CoffeeMaker.Program.CleaningModes.ApplianceOnRinsing
2018.03.01 21:04:43.681 4: BSH.Common.Option.ProgramProgress = 5 %
2018.03.01 21:04:53.969 4: BSH.Common.Option.ProgramProgress = 12 %
2018.03.01 21:05:04.066 4: BSH.Common.Option.ProgramProgress = 14 %
2018.03.01 21:05:14.158 4: BSH.Common.Option.ProgramProgress = 17 %
2018.03.01 21:05:24.220 4: BSH.Common.Option.ProgramProgress = 19 %
2018.03.01 21:05:34.280 4: BSH.Common.Option.ProgramProgress = 21 %
2018.03.01 21:05:44.343 4: BSH.Common.Option.ProgramProgress = 23 %
2018.03.01 21:05:54.418 4: BSH.Common.Option.ProgramProgress = 26 %
2018.03.01 21:06:04.523 4: BSH.Common.Option.ProgramProgress = 28 %
2018.03.01 21:06:14.582 4: BSH.Common.Option.ProgramProgress = 31 %
2018.03.01 21:06:24.697 4: BSH.Common.Option.ProgramProgress = 33 %
2018.03.01 21:06:34.757 4: BSH.Common.Option.ProgramProgress = 36 %
2018.03.01 21:06:44.820 4: BSH.Common.Option.ProgramProgress = 38 %
2018.03.01 21:06:54.908 4: BSH.Common.Option.ProgramProgress = 41 %
2018.03.01 21:07:04.982 4: BSH.Common.Option.ProgramProgress = 43 %
2018.03.01 21:07:15.046 4: BSH.Common.Option.ProgramProgress = 46 %
2018.03.01 21:07:25.108 4: BSH.Common.Option.ProgramProgress = 48 %
2018.03.01 21:07:35.172 4: BSH.Common.Option.ProgramProgress = 51 %
2018.03.01 21:07:45.243 4: BSH.Common.Option.ProgramProgress = 53 %
2018.03.01 21:07:55.306 4: BSH.Common.Option.ProgramProgress = 56 %
2018.03.01 21:08:05.372 4: BSH.Common.Option.ProgramProgress = 58 %
2018.03.01 21:08:15.439 4: BSH.Common.Option.ProgramProgress = 60 %
2018.03.01 21:08:25.522 4: BSH.Common.Option.ProgramProgress = 63 %
2018.03.01 21:08:35.589 4: BSH.Common.Option.ProgramProgress = 65 %
2018.03.01 21:09:05.769 4: BSH.Common.Option.ProgramProgress = 67 %
2018.03.01 21:09:15.826 4: BSH.Common.Root.ActiveProgram = ConsumerProducts.CoffeeMaker.Program.CleaningModes.ApplianceOnRinsing
2018.03.01 21:09:15.827 4: BSH.Common.Option.ProgramProgress = 95 %
2018.03.01 21:09:46.045 5: TI123xxx event channel data: {"items":[{"timestamp":1519934667,"handling":"none","uri":"/api/homeappliances/SIEMENS-TI123xxx-xxxxxxxxxxxx/programs/active","key":"BSH.Common.Root.ActiveProgram","value":null,"level":"hint"}]}
2018.03.01 21:09:46.046 4: BSH.Common.Root.ActiveProgram = -
2018.03.01 21:09:56.100 4: BSH.Common.Option.ProgramProgress = 0 %
2018.03.01 21:10:06.161 5: TI123xxx event channel received 133
event:NOTIFY
data:{"items":[{"timestamp":1519934680,"handling":"none","uri":"/api/homeappliances/SIEMENS-TI123xxx-xxxxxxxxxxxx/programs/selected","key":"BSH.Common.Root.SelectedProgram","value":"ConsumerProducts.CoffeeMaker.Program.Beverage.Espresso","level":"hint"}]}
id:SIEMENS-TI123xxx-xxxxxxxxxxxx
2018.03.01 21:10:06.164 4: BSH.Common.Root.SelectedProgram = ConsumerProducts.CoffeeMaker.Program.Beverage.Espresso
2018.03.01 21:10:16.239 4: BSH.Common.Root.SelectedProgram = ConsumerProducts.CoffeeMaker.Program.Beverage.Espresso
2018.03.01 21:10:16.240 4: ConsumerProducts.CoffeeMaker.Option.CoffeeTemperature = ConsumerProducts.CoffeeMaker.EnumType.CoffeeTemperature.90C
2018.03.01 21:10:16.241 4: ConsumerProducts.CoffeeMaker.Option.BeanAmount = ConsumerProducts.CoffeeMaker.EnumType.BeanAmount.VeryStrong
2018.03.01 21:10:16.241 4: ConsumerProducts.CoffeeMaker.Option.FillQuantity = 40 ml
2018.03.01 21:10:16.242 4: BSH.Common.Option.ProgramProgress = 0 %
2018.03.01 21:10:26.311 4: BSH.Common.Option.ProgramProgress = 0 %
2018.03.01 21:10:46.490 4: BSH.Common.Option.ProgramProgress = 0 %
2018.03.01 21:11:16.656 4: BSH.Common.Option.ProgramProgress = 0 %
2018.03.01 21:11:36.772 4: BSH.Common.Option.ProgramProgress = 7 %
2018.03.01 21:11:46.842 4: BSH.Common.Option.ProgramProgress = 14 %
2018.03.01 21:11:56.922 4: BSH.Common.Option.ProgramProgress = 20 %
2018.03.01 21:12:06.989 4: BSH.Common.Option.ProgramProgress = 26 %
2018.03.01 21:12:17.085 4: BSH.Common.Option.ProgramProgress = 31 %
2018.03.01 21:12:27.176 4: BSH.Common.Option.ProgramProgress = 35 %
2018.03.01 21:12:37.251 4: BSH.Common.Option.ProgramProgress = 39 %
2018.03.01 21:12:47.316 4: BSH.Common.Option.ProgramProgress = 41 %
2018.03.01 21:12:57.391 4: BSH.Common.Option.ProgramProgress = 45 %
2018.03.01 21:13:07.468 4: BSH.Common.Option.ProgramProgress = 50 %
2018.03.01 21:13:17.555 4: BSH.Common.Option.ProgramProgress = 55 %
2018.03.01 21:13:27.631 4: BSH.Common.Option.ProgramProgress = 60 %
2018.03.01 21:13:37.718 4: BSH.Common.Option.ProgramProgress = 66 %
2018.03.01 21:13:47.793 4: BSH.Common.Option.ProgramProgress = 72 %
2018.03.01 21:13:57.875 4: BSH.Common.Option.ProgramProgress = 79 %
2018.03.01 21:14:07.951 4: BSH.Common.Option.ProgramProgress = 85 %
2018.03.01 21:14:18.033 4: BSH.Common.Option.ProgramProgress = 90 %
2018.03.01 21:14:28.129 4: BSH.Common.Option.ProgramProgress = 100 %
2018.03.01 21:14:48.251 4: BSH.Common.Root.SelectedProgram = ConsumerProducts.CoffeeMaker.Program.Beverage.Espresso
2018.03.01 21:14:48.252 4: ConsumerProducts.CoffeeMaker.Option.CoffeeTemperature = ConsumerProducts.CoffeeMaker.EnumType.CoffeeTemperature.90C
2018.03.01 21:14:48.252 4: ConsumerProducts.CoffeeMaker.Option.BeanAmount = ConsumerProducts.CoffeeMaker.EnumType.BeanAmount.VeryStrong
2018.03.01 21:14:48.253 4: ConsumerProducts.CoffeeMaker.Option.FillQuantity = 40 ml
2018.03.01 21:14:48.253 4: BSH.Common.Option.ProgramProgress = 100 %
2018.03.01 21:15:18.463 4: BSH.Common.Option.ProgramProgress = 0 %
2018.03.01 21:15:28.531 4: BSH.Common.Option.ProgramProgress = 0 %


Wie man hier sieht sind die API Events absolut unbrauchbar.

swhome

#5
Zitat von: Schlimbo am 28 Februar 2018, 22:53:09
Besitze einen Siemens Kaffeevollautomaten EQ.9 Connect und würde die Kaffeeauswahl gerne über FHEM triggern.
Laut API Beschreibung gibt es hierzu noch die optionalen Parameter "BeanAmount" und "FillQuantity".
Ist es irgendwie möglich diese Parameter beim "startProgram" Befehl mit anzuhängen?

Meine Idee war, dass man zunächst einmal die Optionen des Programms abruft (set <device> requestProgramOptions Espresso). Diese werden dann als als Readings angelegt und können im zweiten Schritt mit set gesetzt werden, z.B. set <device> ConsumerProducts.CoffeeMaker.Option.FillQuantity 30. Bei einem folgenden Programmstart sollte die Option dann mit berücksichtigt werden.

Leider ist dieses Feature aber noch sehr unausgereift. Berichte mal ob es funktioniert.

Zitat von: Schlimbo am 01 März 2018, 20:39:37
Das Problem was ich nämlich momentan habe, ist dass die HomeConnect API Events so verzögert kommen, das hierdurch das Modul fast unbenutzbar wird.

Sehr interessant, das Problem hab ich auch mit meinem Backofen. Nun bin ich natürlich felsenfest der Meinung dass dieser Fehler nicht in meiner Schnittstelle zu finden ist...  :D aber bewiesen ist das freilich nicht. In der API Dokumentation ist erwähnt, dass man den Event-Stream mit dem curl Tool abrufen kann. Vielleicht kriegt das einer von Euch mal hin und kann vergleichen ob die Meldungen direkt vom API auch schon mit Verzögerung kommen?

Der Befehl müsste etwa so aussehen:

curl -X GET --header "Accept: text/event-stream" --header "Authorization: Bearer OAUTH_TOKEN_HERE" "https://api.home-connect.com/api/homeappliances/BOSCH-HCS01OVN1-1E19AD5C6E3A25/events"
Im Einsatz: FHEM auf Raspberry Pi mit 350 devices, hauptsächlich Homematic Wired und HM-Heizungsregler, dazu diverse Eigenbauten für Fussbodenheizung und LED Beleuchtung. Und jetzt mit Alexa!

Schlimbo

Hallo Stefan,
danke für deine Antwort, werde das mal ausprobieren, wird aber wahrscheinlich noch eins/zwei Wochen dauern, da ich gerade beruflich unterwegs bin.

Schlimbo

Zitat von: swhome am 06 März 2018, 17:38:33
Sehr interessant, das Problem hab ich auch mit meinem Backofen. Nun bin ich natürlich felsenfest der Meinung dass dieser Fehler nicht in meiner Schnittstelle zu finden ist...  :D aber bewiesen ist das freilich nicht. In der API Dokumentation ist erwähnt, dass man den Event-Stream mit dem curl Tool abrufen kann. Vielleicht kriegt das einer von Euch mal hin und kann vergleichen ob die Meldungen direkt vom API auch schon mit Verzögerung kommen?

Der Befehl müsste etwa so aussehen:

curl -X GET --header "Accept: text/event-stream" --header "Authorization: Bearer OAUTH_TOKEN_HERE" "https://api.home-connect.com/api/homeappliances/BOSCH-HCS01OVN1-1E19AD5C6E3A25/events"

Hallo Stefan,
habe gerade mal den Event-Stream im Terminal beobachtet, dieser liefert die korrekten Werte ohne Verzögerung, scheint also doch so, als würde in deiner Schnittstelle noch etwas nicht in Ordnung sein.

Gruß
Schlimbo

swhome

Hi Schlimbo, vielen Dank für die Info. Werde mir das Thema mal vornehmen.
Im Einsatz: FHEM auf Raspberry Pi mit 350 devices, hauptsächlich Homematic Wired und HM-Heizungsregler, dazu diverse Eigenbauten für Fussbodenheizung und LED Beleuchtung. Und jetzt mit Alexa!

Schlimbo

Hallo Stefan,
habe noch etwas weiter getestet:
Zitat von: swhome am 06 März 2018, 17:38:33
Meine Idee war, dass man zunächst einmal die Optionen des Programms abruft (set <device> requestProgramOptions Espresso). Diese werden dann als als Readings angelegt und können im zweiten Schritt mit set gesetzt werden, z.B. set <device> ConsumerProducts.CoffeeMaker.Option.FillQuantity 30. Bei einem folgenden Programmstart sollte die Option dann mit berücksichtigt werden.
Heißt das also, dass bei einem Programmstart die aktuellen Werte der Options-Readings verwendet werden?
Wenn ich das richtig beobachtet habe, werden die Options-Readings aber auch über die API Events gesetzt.
Stelle ich an der Kaffeemaschine auf Cappuccino, werden die Readings
ConsumerProducts.CoffeeMaker.Option.BeanAmount
ConsumerProducts.CoffeeMaker.Option.CoffeeTemperature
ConsumerProducts.CoffeeMaker.Option.FillQuantity

Auf die, an der Maschinen, eingestellten Werte gesetzt und würden somit meine FHEM Vorwahl überschreiben.
Mann kann sich somit also nicht sicher sein, dass die Readings beim Programmstart noch korrekt sind.
Aus diesem Grund fände ich es schon besser, wenn es eine Möglichkeit gäbe, einem Programmstart direkt die Parameter übergeben zu könnte.
Kannst du hier noch etwas machen?

Anbei das Ergebnis von "set <device> requestProgramOptions Cappuccino":
2018.03.20 07:26:53.276 3: set command: requestProgramOptions
2018.03.20 07:26:53.277 4: TI123xxx request: https://api.home-connect.com/api/homeappliances/SIEMENS-TI123xxx-xxxxxxxxxxxx/programs/available/ConsumerProducts.CoffeeMaker.Program.Beverage.Cappuccino
2018.03.20 07:26:53.280 4: TI123xxx: no token refresh needed
2018.03.20 07:26:54.156 4: TI123xxx response: {
  "data": {
    "key": "ConsumerProducts.CoffeeMaker.Program.Beverage.Cappuccino",
    "options": [{
      "key": "ConsumerProducts.CoffeeMaker.Option.CoffeeTemperature",
      "type": "ConsumerProducts.CoffeeMaker.EnumType.CoffeeTemperature",
      "constraints": {
        "allowedvalues": ["ConsumerProducts.CoffeeMaker.EnumType.CoffeeTemperature.96C", "ConsumerProducts.CoffeeMaker.EnumType.CoffeeTemperature.95C", "ConsumerProducts.CoffeeMaker.EnumType.CoffeeTemperature.94C", "ConsumerProducts.CoffeeMaker.EnumType.CoffeeTemperature.90C", "ConsumerProducts.CoffeeMaker.EnumType.CoffeeTemperature.88C", "ConsumerProducts.CoffeeMaker.EnumType.CoffeeTemperature.92C"]
      }
    }, {
      "key": "ConsumerProducts.CoffeeMaker.Option.BeanAmount",
      "type": "ConsumerProducts.CoffeeMaker.EnumType.BeanAmount",
      "constraints": {
        "allowedvalues": ["ConsumerProducts.CoffeeMaker.EnumType.BeanAmount.StrongPlus", "ConsumerProducts.CoffeeMaker.EnumType.BeanAmount.NormalPlus", "ConsumerProducts.CoffeeMaker.EnumType.BeanAmount.ExtraStrong", "ConsumerProducts.CoffeeMaker.EnumType.BeanAmount.Mild", "ConsumerProducts.CoffeeMaker.EnumType.BeanAmount.DoubleShotPlus", "ConsumerProducts.CoffeeMaker.EnumType.BeanAmount.VeryStrongPlus", "ConsumerProducts.CoffeeMaker.EnumType.BeanAmount.MildPlus", "ConsumerProducts.CoffeeMaker.EnumType.BeanAmount.DoubleShot", "ConsumerProducts.CoffeeMaker.EnumType.BeanAmount.CoffeeGround", "ConsumerProducts.CoffeeMaker.EnumType.BeanAmount.VeryMild", "ConsumerProducts.CoffeeMaker.EnumType.BeanAmount.VeryStrong", "ConsumerProducts.CoffeeMaker.EnumType.BeanAmount.DoubleShotPlusPlus", "ConsumerProducts.CoffeeMaker.EnumType.BeanAmount.Normal", "ConsumerProducts.CoffeeMaker.EnumType.BeanAmount.Strong"]
      }
    }, {
      "key": "ConsumerProducts.CoffeeMaker.Option.FillQuantity",
      "type": "Int",
      "unit": "ml",
      "constraints": {
        "min": 20,
        "max": 400,
        "stepsize": 5
      }
    }]
  }
}

Hierbei werden anscheinend nur die Möglichen Parameter ausgelesen und nicht wie ich anfangs dachte, die momentan eingestellten Werte in die Readings übernommen.
In der Setlist tauchen die ProgrammOptionen danach auch nicht auf. Wie war das gedacht? Sollte nach einem "requestProgramOptions" die Setlist nicht die Optionen zur Auswahl haben?

Ein "set <device> ConsumerProducts.CoffeeMaker.Option.FillQuantity 30" verändert das Reading bei mir auch nicht.

Gruß Schlimbo

swhome

Hallo Schlimbo, ich hab am Wochenende viel mit dem Kaffeemaschinensimulator experimentiert und heraus kam eine komplette Überarbeitung der Schnittstelle. Die Version ist seit eben live, muss dazu noch einen Ankündigungsthread machen.

Nur soviel vorab:
Ändere nach dem Update das Attribut webCmd auf "BSH.Common.Root.SelectedProgram:startProgram:stopProgram", dann kannst Du zuerst das Programm wählen (die Optionen wechseln dann auf passende Standardwerte des Programms), danach mit startProgram das Programm mit den eventuell angepassten Optionen starten.
Im Einsatz: FHEM auf Raspberry Pi mit 350 devices, hauptsächlich Homematic Wired und HM-Heizungsregler, dazu diverse Eigenbauten für Fussbodenheizung und LED Beleuchtung. Und jetzt mit Alexa!

Schlimbo

Wow, das sind ja gute Neuigkeiten :)
Werde ich heute abend gleich mal testen.
Vielen dank schon mal für deine Arbeit und Zeit, die du in das Modul investierst.

Gruß Schlimbo

Schlimbo

Hallo Stefan,
die API Events kommen jetzt ohne Verzögerung an, die Programm Optionen konnte ich noch nicht testen, da ich mein Koffein-Pensum für heute schon überstrapaziert habe ;)

Schlimbo

Hallo Stefan,
hatte es jetzt schon drei mal, dass sich mein FHEM aufgehängt hat, das Log ist voll mit der Meldung:
2018.03.23 04:52:06.185 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.185 5: TI123xxx event channel read failed
2018.03.23 04:52:06.186 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.187 5: TI123xxx event channel read failed
2018.03.23 04:52:06.187 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.188 5: TI123xxx event channel read failed
2018.03.23 04:52:06.188 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.189 5: TI123xxx event channel read failed
2018.03.23 04:52:06.190 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.190 5: TI123xxx event channel read failed
2018.03.23 04:52:06.191 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.192 5: TI123xxx event channel read failed
2018.03.23 04:52:06.192 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.193 5: TI123xxx event channel read failed
2018.03.23 04:52:06.193 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.194 5: TI123xxx event channel read failed
2018.03.23 04:52:06.194 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.195 5: TI123xxx event channel read failed
2018.03.23 04:52:06.195 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.196 5: TI123xxx event channel read failed
2018.03.23 04:52:06.196 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.197 5: TI123xxx event channel read failed
2018.03.23 04:52:06.197 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.198 5: TI123xxx event channel read failed
2018.03.23 04:52:06.198 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.199 5: TI123xxx event channel read failed
2018.03.23 04:52:06.200 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.200 5: TI123xxx event channel read failed
2018.03.23 04:52:06.201 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.202 5: TI123xxx event channel read failed
2018.03.23 04:52:06.202 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.203 5: TI123xxx event channel read failed
2018.03.23 04:52:06.203 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.204 5: TI123xxx event channel read failed
2018.03.23 04:52:06.205 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.205 5: TI123xxx event channel read failed
2018.03.23 04:52:06.206 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.207 5: TI123xxx event channel read failed
2018.03.23 04:52:06.207 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.208 5: TI123xxx event channel read failed
2018.03.23 04:52:06.209 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.209 5: TI123xxx event channel read failed
2018.03.23 04:52:06.209 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.210 5: TI123xxx event channel read failed
2018.03.23 04:52:06.211 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.211 5: TI123xxx event channel read failed
2018.03.23 04:52:06.212 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.212 5: TI123xxx event channel read failed
2018.03.23 04:52:06.213 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.213 5: TI123xxx event channel read failed
2018.03.23 04:52:06.214 5: TI123xxx event channel searching for data
2018.03.23 04:52:06.214 5: TI123xxx event channel read failed

Das passiert mit der neuen Version ungefähr zwei mal täglich.

Schlimbo

Hier noch mal der Bereich aus dem Log, wo es angefangen hat.
Bei 2018.03.23 01:16:31.722 geht es los:
event:KEEP-ALIVE
data:
id:SIEMENS-TI123xxx-xxxxxxxxxxxx



2018.03.23 01:10:56.001 5: TI123xxx event channel searching for data
2018.03.23 01:10:56.002 5: TI123xxx event channel received no more data
2018.03.23 01:11:01.005 5: TI123xxx event channel searching for data
2018.03.23 01:11:01.006 5: TI123xxx event channel received no more data
2018.03.23 01:11:06.011 5: TI123xxx event channel searching for data
2018.03.23 01:11:06.017 5: TI123xxx event channel received no more data
2018.03.23 01:11:11.021 5: TI123xxx event channel searching for data
2018.03.23 01:11:11.027 5: TI123xxx event channel received no more data
2018.03.23 01:11:16.030 5: TI123xxx event channel searching for data
2018.03.23 01:11:16.037 5: TI123xxx event channel received no more data
2018.03.23 01:11:21.040 5: TI123xxx event channel searching for data
2018.03.23 01:11:21.040 5: TI123xxx event channel received no more data
2018.03.23 01:11:26.048 5: TI123xxx event channel searching for data
2018.03.23 01:11:26.054 5: TI123xxx event channel received no more data
2018.03.23 01:11:31.058 5: TI123xxx event channel searching for data
2018.03.23 01:11:31.065 5: TI123xxx event channel received no more data
2018.03.23 01:11:36.069 5: TI123xxx event channel searching for data
2018.03.23 01:11:36.075 5: TI123xxx event channel received no more data
2018.03.23 01:11:41.080 5: TI123xxx event channel searching for data
2018.03.23 01:11:41.087 5: TI123xxx event channel received no more data
2018.03.23 01:11:46.091 5: TI123xxx event channel searching for data
2018.03.23 01:11:46.097 5: TI123xxx event channel received no more data
2018.03.23 01:11:51.100 5: TI123xxx event channel searching for data
2018.03.23 01:11:51.107 5: TI123xxx event channel received 3b
event:KEEP-ALIVE
data:
id:SIEMENS-TI123xxx-xxxxxxxxxxxx



2018.03.23 01:11:51.109 5: TI123xxx event channel searching for data
2018.03.23 01:11:51.109 5: TI123xxx event channel received no more data
2018.03.23 01:11:56.113 5: TI123xxx event channel searching for data
2018.03.23 01:11:56.113 5: TI123xxx event channel received no more data
2018.03.23 01:12:01.122 5: TI123xxx event channel searching for data
2018.03.23 01:12:01.128 5: TI123xxx event channel received no more data
2018.03.23 01:12:06.132 5: TI123xxx event channel searching for data
2018.03.23 01:12:06.138 5: TI123xxx event channel received no more data
2018.03.23 01:12:11.142 5: TI123xxx event channel searching for data
2018.03.23 01:12:11.148 5: TI123xxx event channel received no more data
2018.03.23 01:12:16.152 5: TI123xxx event channel searching for data
2018.03.23 01:12:16.159 5: TI123xxx event channel received no more data
2018.03.23 01:12:21.163 5: TI123xxx event channel searching for data
2018.03.23 01:12:21.170 5: TI123xxx event channel received no more data
2018.03.23 01:12:26.174 5: TI123xxx event channel searching for data
2018.03.23 01:12:26.181 5: TI123xxx event channel received no more data
2018.03.23 01:12:31.185 5: TI123xxx event channel searching for data
2018.03.23 01:12:31.191 5: TI123xxx event channel received no more data
2018.03.23 01:12:36.194 5: TI123xxx event channel searching for data
2018.03.23 01:12:36.201 5: TI123xxx event channel received no more data
2018.03.23 01:12:41.205 5: TI123xxx event channel searching for data
2018.03.23 01:12:41.205 5: TI123xxx event channel received no more data
2018.03.23 01:12:46.213 5: TI123xxx event channel searching for data
2018.03.23 01:12:46.215 5: TI123xxx event channel received 3b
event:KEEP-ALIVE
data:
id:SIEMENS-TI123xxx-xxxxxxxxxxxx



2018.03.23 01:12:46.220 5: TI123xxx event channel searching for data
2018.03.23 01:12:46.220 5: TI123xxx event channel received no more data
2018.03.23 01:12:51.225 5: TI123xxx event channel searching for data
2018.03.23 01:12:51.226 5: TI123xxx event channel received no more data
2018.03.23 01:12:56.245 5: TI123xxx event channel searching for data
2018.03.23 01:12:56.245 5: TI123xxx event channel received no more data
2018.03.23 01:13:01.255 5: TI123xxx event channel searching for data
2018.03.23 01:13:01.256 5: TI123xxx event channel received no more data
2018.03.23 01:13:06.260 5: TI123xxx event channel searching for data
2018.03.23 01:13:06.261 5: TI123xxx event channel received no more data
2018.03.23 01:13:11.270 5: TI123xxx event channel searching for data
2018.03.23 01:13:11.276 5: TI123xxx event channel received no more data
2018.03.23 01:13:16.279 5: TI123xxx event channel searching for data
2018.03.23 01:13:16.286 5: TI123xxx event channel received no more data
2018.03.23 01:13:21.289 5: TI123xxx event channel searching for data
2018.03.23 01:13:21.294 5: TI123xxx event channel received no more data
2018.03.23 01:13:26.298 5: TI123xxx event channel searching for data
2018.03.23 01:13:26.300 5: TI123xxx event channel received no more data
2018.03.23 01:13:31.308 5: TI123xxx event channel searching for data
2018.03.23 01:13:31.308 5: TI123xxx event channel received no more data
2018.03.23 01:13:36.316 5: TI123xxx event channel searching for data
2018.03.23 01:13:36.317 5: TI123xxx event channel received no more data
2018.03.23 01:13:41.326 5: TI123xxx event channel searching for data
2018.03.23 01:13:41.328 5: TI123xxx event channel received 3b
event:KEEP-ALIVE
data:
id:SIEMENS-TI123xxx-xxxxxxxxxxxx



2018.03.23 01:13:41.333 5: TI123xxx event channel searching for data
2018.03.23 01:13:41.333 5: TI123xxx event channel received no more data
2018.03.23 01:13:46.355 5: TI123xxx event channel searching for data
2018.03.23 01:13:46.356 5: TI123xxx event channel received no more data
2018.03.23 01:13:51.364 5: TI123xxx event channel searching for data
2018.03.23 01:13:51.365 5: TI123xxx event channel received no more data
2018.03.23 01:13:56.368 5: TI123xxx event channel searching for data
2018.03.23 01:13:56.374 5: TI123xxx event channel received no more data
2018.03.23 01:14:01.378 5: TI123xxx event channel searching for data
2018.03.23 01:14:01.379 5: TI123xxx event channel received no more data
2018.03.23 01:14:06.387 5: TI123xxx event channel searching for data
2018.03.23 01:14:06.393 5: TI123xxx event channel received no more data
2018.03.23 01:14:11.396 5: TI123xxx event channel searching for data
2018.03.23 01:14:11.397 5: TI123xxx event channel received no more data
2018.03.23 01:14:16.412 5: TI123xxx event channel searching for data
2018.03.23 01:14:16.413 5: TI123xxx event channel received no more data
2018.03.23 01:14:21.421 5: TI123xxx event channel searching for data
2018.03.23 01:14:21.427 5: TI123xxx event channel received no more data
2018.03.23 01:14:26.430 5: TI123xxx event channel searching for data
2018.03.23 01:14:26.431 5: TI123xxx event channel received no more data
2018.03.23 01:14:31.439 5: TI123xxx event channel searching for data
2018.03.23 01:14:31.439 5: TI123xxx event channel received no more data
2018.03.23 01:14:36.447 5: TI123xxx event channel searching for data
2018.03.23 01:14:36.449 5: TI123xxx event channel received 3b
event:KEEP-ALIVE
data:
id:SIEMENS-TI123xxx-xxxxxxxxxxxx



2018.03.23 01:14:36.454 5: TI123xxx event channel searching for data
2018.03.23 01:14:36.455 5: TI123xxx event channel received no more data
2018.03.23 01:14:41.459 5: TI123xxx event channel searching for data
2018.03.23 01:14:41.464 5: TI123xxx event channel received no more data
2018.03.23 01:14:46.467 5: TI123xxx event channel searching for data
2018.03.23 01:14:46.473 5: TI123xxx event channel received no more data
2018.03.23 01:14:51.477 5: TI123xxx event channel searching for data
2018.03.23 01:14:51.479 5: TI123xxx event channel received no more data
2018.03.23 01:14:56.486 5: TI123xxx event channel searching for data
2018.03.23 01:14:56.487 5: TI123xxx event channel received no more data
2018.03.23 01:15:01.495 5: TI123xxx event channel searching for data
2018.03.23 01:15:01.496 5: TI123xxx event channel received no more data
2018.03.23 01:15:06.503 5: TI123xxx event channel searching for data
2018.03.23 01:15:06.504 5: TI123xxx event channel received no more data
2018.03.23 01:15:11.513 5: TI123xxx event channel searching for data
2018.03.23 01:15:11.519 5: TI123xxx event channel received no more data
2018.03.23 01:15:16.554 5: TI123xxx event channel searching for data
2018.03.23 01:15:16.561 5: TI123xxx event channel received no more data
2018.03.23 01:15:21.564 5: TI123xxx event channel searching for data
2018.03.23 01:15:21.570 5: TI123xxx event channel received 0


2018.03.23 01:15:21.572 5: TI123xxx event channel searching for data
2018.03.23 01:15:21.572 5: TI123xxx event channel received no more data
2018.03.23 01:15:26.576 5: TI123xxx event channel searching for data
2018.03.23 01:15:26.582 5: TI123xxx event channel received no more data
2018.03.23 01:15:31.586 5: TI123xxx event channel searching for data
2018.03.23 01:15:31.592 5: TI123xxx event channel received no more data
2018.03.23 01:15:36.596 5: TI123xxx event channel searching for data
2018.03.23 01:15:36.603 5: TI123xxx event channel received no more data
2018.03.23 01:15:41.607 5: TI123xxx event channel searching for data
2018.03.23 01:15:41.613 5: TI123xxx event channel received no more data
2018.03.23 01:15:46.618 5: TI123xxx event channel searching for data
2018.03.23 01:15:46.624 5: TI123xxx event channel received no more data
2018.03.23 01:15:51.629 5: TI123xxx event channel searching for data
2018.03.23 01:15:51.635 5: TI123xxx event channel received no more data
2018.03.23 01:15:56.640 5: TI123xxx event channel searching for data
2018.03.23 01:15:56.647 5: TI123xxx event channel received no more data
2018.03.23 01:16:01.651 5: TI123xxx event channel searching for data
2018.03.23 01:16:01.657 5: TI123xxx event channel received no more data
2018.03.23 01:16:06.661 5: TI123xxx event channel searching for data
2018.03.23 01:16:06.668 5: TI123xxx event channel received no more data
2018.03.23 01:16:11.672 5: TI123xxx event channel searching for data
2018.03.23 01:16:11.678 5: TI123xxx event channel received no more data
2018.03.23 01:16:16.682 5: TI123xxx event channel searching for data
2018.03.23 01:16:16.688 5: TI123xxx event channel received no more data
2018.03.23 01:16:21.692 5: TI123xxx event channel searching for data
2018.03.23 01:16:21.699 5: TI123xxx event channel received no more data
2018.03.23 01:16:26.703 5: TI123xxx event channel searching for data
2018.03.23 01:16:26.709 5: TI123xxx event channel received no more data
2018.03.23 01:16:31.713 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.722 5: TI123xxx event channel read failed
2018.03.23 01:16:31.723 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.723 5: TI123xxx event channel read failed
2018.03.23 01:16:31.724 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.724 5: TI123xxx event channel read failed
2018.03.23 01:16:31.725 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.725 5: TI123xxx event channel read failed
2018.03.23 01:16:31.726 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.726 5: TI123xxx event channel read failed
2018.03.23 01:16:31.727 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.727 5: TI123xxx event channel read failed
2018.03.23 01:16:31.727 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.728 5: TI123xxx event channel read failed
2018.03.23 01:16:31.728 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.729 5: TI123xxx event channel read failed
2018.03.23 01:16:31.729 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.730 5: TI123xxx event channel read failed
2018.03.23 01:16:31.730 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.730 5: TI123xxx event channel read failed
2018.03.23 01:16:31.731 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.731 5: TI123xxx event channel read failed
2018.03.23 01:16:31.732 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.732 5: TI123xxx event channel read failed
2018.03.23 01:16:31.732 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.733 5: TI123xxx event channel read failed
2018.03.23 01:16:31.733 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.734 5: TI123xxx event channel read failed
2018.03.23 01:16:31.734 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.735 5: TI123xxx event channel read failed
2018.03.23 01:16:31.735 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.735 5: TI123xxx event channel read failed
2018.03.23 01:16:31.736 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.736 5: TI123xxx event channel read failed
2018.03.23 01:16:31.737 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.737 5: TI123xxx event channel read failed
2018.03.23 01:16:31.738 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.738 5: TI123xxx event channel read failed
2018.03.23 01:16:31.738 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.739 5: TI123xxx event channel read failed
2018.03.23 01:16:31.739 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.740 5: TI123xxx event channel read failed
2018.03.23 01:16:31.740 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.740 5: TI123xxx event channel read failed
2018.03.23 01:16:31.741 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.741 5: TI123xxx event channel read failed
2018.03.23 01:16:31.742 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.742 5: TI123xxx event channel read failed
2018.03.23 01:16:31.742 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.743 5: TI123xxx event channel read failed
2018.03.23 01:16:31.743 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.744 5: TI123xxx event channel read failed
2018.03.23 01:16:31.744 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.745 5: TI123xxx event channel read failed
2018.03.23 01:16:31.745 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.745 5: TI123xxx event channel read failed
2018.03.23 01:16:31.746 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.746 5: TI123xxx event channel read failed
2018.03.23 01:16:31.747 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.747 5: TI123xxx event channel read failed
2018.03.23 01:16:31.747 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.748 5: TI123xxx event channel read failed
2018.03.23 01:16:31.748 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.749 5: TI123xxx event channel read failed
2018.03.23 01:16:31.749 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.750 5: TI123xxx event channel read failed
2018.03.23 01:16:31.750 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.750 5: TI123xxx event channel read failed
2018.03.23 01:16:31.751 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.751 5: TI123xxx event channel read failed
2018.03.23 01:16:31.752 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.752 5: TI123xxx event channel read failed
2018.03.23 01:16:31.752 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.753 5: TI123xxx event channel read failed
2018.03.23 01:16:31.753 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.754 5: TI123xxx event channel read failed
2018.03.23 01:16:31.754 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.754 5: TI123xxx event channel read failed
2018.03.23 01:16:31.755 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.755 5: TI123xxx event channel read failed
2018.03.23 01:16:31.756 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.756 5: TI123xxx event channel read failed
2018.03.23 01:16:31.757 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.757 5: TI123xxx event channel read failed
2018.03.23 01:16:31.757 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.758 5: TI123xxx event channel read failed
2018.03.23 01:16:31.758 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.759 5: TI123xxx event channel read failed
2018.03.23 01:16:31.759 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.759 5: TI123xxx event channel read failed
2018.03.23 01:16:31.760 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.760 5: TI123xxx event channel read failed
2018.03.23 01:16:31.761 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.761 5: TI123xxx event channel read failed
2018.03.23 01:16:31.761 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.762 5: TI123xxx event channel read failed
2018.03.23 01:16:31.762 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.763 5: TI123xxx event channel read failed
2018.03.23 01:16:31.763 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.763 5: TI123xxx event channel read failed
2018.03.23 01:16:31.764 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.764 5: TI123xxx event channel read failed
2018.03.23 01:16:31.765 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.765 5: TI123xxx event channel read failed
2018.03.23 01:16:31.765 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.766 5: TI123xxx event channel read failed
2018.03.23 01:16:31.766 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.767 5: TI123xxx event channel read failed
2018.03.23 01:16:31.767 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.768 5: TI123xxx event channel read failed
2018.03.23 01:16:31.768 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.769 5: TI123xxx event channel read failed
2018.03.23 01:16:31.769 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.769 5: TI123xxx event channel read failed
2018.03.23 01:16:31.770 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.770 5: TI123xxx event channel read failed
2018.03.23 01:16:31.770 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.771 5: TI123xxx event channel read failed
2018.03.23 01:16:31.771 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.772 5: TI123xxx event channel read failed
2018.03.23 01:16:31.772 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.772 5: TI123xxx event channel read failed
2018.03.23 01:16:31.773 5: TI123xxx event channel searching for data
2018.03.23 01:16:31.773 5: TI123xxx event channel read failed
2018.03.23 01:16:31.774 5: TI123xxx event channel searching for data