UPDATE 31.10.: Amazon Alexa - ioBroker Skill läuft aus ?

[simatec]

@Tom-Haase
Bitte den Log im Beitrag als Code darstellen (siehe Button </>)

[simatec]

@Tom-Haase
Das ist kein Debug Log.
Bitte stelle shuttercontrol auf debug und poste nur den Log von shuttercontrol, während du das betroffene Fenster öffnest.

[da_Woody]

@dos1973 rolladen spät schliessen in verbindung mit sommer einstellungen wird sich sicher was machen lassen.

[simatec]

@Tom-Haase sagte in Test Adapter shuttercontrol v1.1.x:

system.adapter.shuttercontrol.0.json

So funktioniert das nicht.
Erstmal fehlen die Zeiteinstellungen für das hoch/runterfahren
dann muss dein Triggerstate auf false (Wert des Fensterkontaktes im geschlossenen Zustand)

Und dann bitte den debuglog posten, wenn das Fenster geöffnet wird bzw. wieder geschlossen wird

{
        "enabled": true,
        "shutterName": "Buero1 pct",
        "name": "fhem.0.friedhelm.pct",
        "triggerID": "zigbee.0.00158d00053f428f.opened",
        "typeUp": "",
        "typeDown": "",
        "type": "",
        "heightDownSun": "30",
        "direction": "120",
        "directionRange": "50",
        "tempInside": "23",
        "tempSensor": "",
        "outsideTempSensor": "",
        "tempOutside": "23",
        "lightSensor": "",
        "valueLight": "15",
        "heightUp": "0",
        "heightDown": "100",
        "triggerState": "true",
        "triggerDrive": "50",
        "triggerChange": "upDown",
        "elevation": "8",
        "autoDrive": "upDown",
        "hysteresisOutside": "5",
        "hysteresisInside": "5",
        "hysteresisLight": "5",
        "currentAction": "",
        "currentHeight": "",
        "oldHeight": "",
        "firstCompleteUp": "",
        "triggerHeight": "",
        "LateDown": false,
        "inSummerNotDown": false,
        "KeepSunProtect": false,
        "triggerAction": "",
        "driveAfterClose": false,
        "useXmasLevel": false,
        "XmasLevel": "0",
        "betweenPosition": false,
        "betweenPositionLevel": "50"
      }

[FoxRo]

@Tom-Haase said in Test Adapter shuttercontrol v1.1.x:

Hi,
danke für die Geduld.

So wie oben eingestellt fährt der Rolladen nach Zeit. Alles gut!

Als nächstes binde ich nun den Fensterkontakt ein. Der schaltet zwar, aber der Rolladen fährt nicht. Erst wenn ich die 0 und 100 tausche fährt der Rollo nach Kontakt.

Jetzt funktioniert aber die Zeitsteuerung nicht mehr.

Also wie eingangs oben beschrieben. Entweder oder!

Nette Grüße
Tom

@Tom-Haase
So wie du das hier mit dem Screenshot beschreibst vermute ich, dass Du die Trigger Tests mit offenem Rollladen machst.
Shuttercontrol fährt den Rollladen im Trigger Fall nur, wenn die aktuelle Position tiefer (mehr zu) ist als die angeforderte Pos. (bei Dir aktuell 50).
Also setze die Settings wie folgt:
Rollladen beim runterfahren = 100
Rollladen beim hochfahren = 0
Rollladenhöhe bei öffnen des Fensters = zb.50
Nimm mal den State von „opened“ und stelle den Wert für Fenster /Tür Sensor im geschl. Zusand auf false
Fahre mal den Rollladen ganz nach unten und öffne dann das Fenster -> Der Rollladen fährt nun auf 50% ;-)
Wenn nicht, teste andere Triggersettings.
Viel Erfolg
Roli

[Tom Haase]

@simatec sagte in Test Adapter shuttercontrol v1.1.x:

Bitte stelle shuttercontrol auf debug und poste nur den Log von shuttercontrol, während du das betroffene Fenster öffnest.

es erfolgt keine Ausgabe über die Aktion im log

2021-01-09 15:22:34.203 - info: host.raspberrypi stopInstance system.adapter.shuttercontrol.0 (force=false, process=true)
2021-01-09 15:22:34.206 - info: host.raspberrypi stopInstance system.adapter.shuttercontrol.0 send kill signal
2021-01-09 15:22:34.212 - info: shuttercontrol.0 (26394) Got terminate signal TERMINATE_YOURSELF
2021-01-09 15:22:34.214 - info: shuttercontrol.0 (26394) cleaned everything up...
2021-01-09 15:22:34.217 - info: shuttercontrol.0 (26394) terminating
2021-01-09 15:22:34.219 - info: shuttercontrol.0 (26394) Terminated (ADAPTER_REQUESTED_TERMINATION): Without reason
2021-01-09 15:22:34.771 - info: host.raspberrypi instance system.adapter.shuttercontrol.0 terminated with code 11 (ADAPTER_REQUESTED_TERMINATION)
2021-01-09 15:22:37.271 - info: host.raspberrypi instance system.adapter.shuttercontrol.0 started with pid 26597
2021-01-09 15:22:38.926 - info: shuttercontrol.0 (26597) Plugin sentry Sentry Plugin disabled for this process because sending of statistic data is disabled for the system
2021-01-09 15:22:38.943 - info: shuttercontrol.0 (26597) starting. Version 1.1.1 in /opt/iobroker/node_modules/iobroker.shuttercontrol, node: v12.20.0, js-controller: 3.1.6

2021-01-09 15:23:59.940 - info: fhem.0 (16306) stateChange (out): fhem.0.info.Commands.sendFHEM | set fhem.0.alive on-for-timer 360 > set fhem.0.alive on-for-timer 360

[Tom Haase]

@FoxRo sagte in Test Adapter shuttercontrol v1.1.x:

So wie du das hier mit dem Screenshot beschreibst vermute ich, dass Du die Trigger Tests mit offenem Rollladen machst.

Ja, hast recht. Also Rolladen runter.....

Shuttercontrol fährt den Rollladen im Trigger Fall nur, wenn die aktuelle Position tiefer (mehr zu) ist als die angeforderte Pos. (bei Dir aktuell 50).
Also setze die Settings wie folgt:
Rollladen beim runterfahren = 100
Rollladen beim hochfahren = 0
Rollladenhöhe bei öffnen des Fensters = zb.50
Nimm mal den State von „opened“ und stelle den Wert für Fenster /Tür Sensor im geschl. Zusand auf false
Fahre mal den Rollladen ganz nach unten und öffne dann das Fenster -> Der Rollladen fährt nun auf 50%

Alles genau so umgesetzt, keine Reaktion.
:angry:

Wenn nicht, teste andere Triggersettings.

Vielen Dank für eure Geduld.

[simatec]

@Tom-Haase sagte in Test Adapter shuttercontrol v1.1.x:

@simatec sagte in Test Adapter shuttercontrol v1.1.x:

Bitte stelle shuttercontrol auf debug und poste nur den Log von shuttercontrol, während du das betroffene Fenster öffnest.

es erfolgt keine Ausgabe über die Aktion im log

2021-01-09 15:22:34.203 - info: host.raspberrypi stopInstance system.adapter.shuttercontrol.0 (force=false, process=true)
2021-01-09 15:22:34.206 - info: host.raspberrypi stopInstance system.adapter.shuttercontrol.0 send kill signal
2021-01-09 15:22:34.212 - info: shuttercontrol.0 (26394) Got terminate signal TERMINATE_YOURSELF
2021-01-09 15:22:34.214 - info: shuttercontrol.0 (26394) cleaned everything up...
2021-01-09 15:22:34.217 - info: shuttercontrol.0 (26394) terminating
2021-01-09 15:22:34.219 - info: shuttercontrol.0 (26394) Terminated (ADAPTER_REQUESTED_TERMINATION): Without reason
2021-01-09 15:22:34.771 - info: host.raspberrypi instance system.adapter.shuttercontrol.0 terminated with code 11 (ADAPTER_REQUESTED_TERMINATION)
2021-01-09 15:22:37.271 - info: host.raspberrypi instance system.adapter.shuttercontrol.0 started with pid 26597
2021-01-09 15:22:38.926 - info: shuttercontrol.0 (26597) Plugin sentry Sentry Plugin disabled for this process because sending of statistic data is disabled for the system
2021-01-09 15:22:38.943 - info: shuttercontrol.0 (26597) starting. Version 1.1.1 in /opt/iobroker/node_modules/iobroker.shuttercontrol, node: v12.20.0, js-controller: 3.1.6
2021-01-09 15:22:38.990 - info: shuttercontrol.0 (26597) system longitude 11.54050° latitude 50.01820°
2021-01-09 15:23:59.940 - info: fhem.0 (16306) stateChange (out): fhem.0.info.Commands.sendFHEM | set fhem.0.alive on-for-timer 360 > set fhem.0.alive on-for-timer 360

Du hast die Instanz von shuttercontrol nicht auf Debuglevel. Stelle shuttercontrol so wie in meiner Signatur beschrieben auf debug

[Tom Haase]

@simatec sagte in Test Adapter shuttercontrol v1.1.x:

Erstmal fehlen die Zeiteinstellungen für das hoch/runterfahren

ok, eingetragen

dann muss dein Triggerstate auf false (Wert des Fensterkontaktes im geschlossenen Zustand)

geändert

Und dann bitte den debuglog posten, wenn das Fenster geöffnet wird bzw. wieder geschlossen wird

wie oben schon geschriben wird keine veränderung im log angezeigt. Unter Objects kann ich aber sehen das der state sich bei offnen/schließen des Fensterkontakts ändert:
bei contact von true auf false

und wie jetzt nach eurer Anweisung hier eingestellt auf "opened"
also von false auf true
Der Kontakt arbeitet anscheinend doch, oder?

[FoxRo]

@Tom-Haase said in Test Adapter shuttercontrol v1.1.x:

Alles genau so umgesetzt, keine Reaktion.
:angry:

Wenn nicht, teste andere Triggersettings.

Vielen Dank für eure Geduld.

.. noch einen Tipp zum Fehlersuchen
Bei einem Adapter Neustart verlieren die IoBroker Adapter die aktuellen Werte. Dies ist auch bei Shuttercontrol so. Also, jedes Mal wenn Du was an der Config geändert hast und der Adapter wieder grün (Status) wird, als erstes die Rollläden in eine definierte Position initialisieren. (ganz hoch oder ganz runter) ab dann weiss Shuttercontrol auch, wo der Rollladen aktuell steht und reagiert dann auch korrekt.;-)
Ansonsten kann es in Deinem Fall eigentlich nur noch am Triggersetting liegen. Entweder hast den falschen Datenpunkt verlinkt, auf dem Trigger-Datenpunkt kommt keine Änderung an wenn das Fenster öffnet oder der Status für geschlossen ist falsch gesetzt. Mehr Möglichkeiten gibts eigentlich nicht.
Viel Erfolg
Roli

[Tom Haase]

@simatec
sorry das ist alles ziemliches Neuland für mich..
:confused:

2021-01-09 16:08:52.566 - debug: shuttercontrol.0 (1591) TriggerID changed: zigbee.0.00158d00053f428f.opened Value: true
2021-01-09 16:08:52.575 - debug: shuttercontrol.0 (1591) save trigger height: 0% for device: Buero1 pct
2021-01-09 16:08:52.576 - debug: shuttercontrol.0 (1591) save trigger action: up for device: Buero1 pct
2021-01-09 16:08:55.365 - debug: shuttercontrol.0 (1591) TriggerID changed: zigbee.0.00158d00053f428f.opened Value: false
2021-01-09 16:08:55.374 - debug: shuttercontrol.0 (1591) shutter trigger released Buero1 pct already in place: 0%
2021-01-09 16:08:55.376 - debug: shuttercontrol.0 (1591) save back trigger action: up for device Buero1 pct

Das ist die Ausgabe bei öffnen und schließen des Fensterkontakts.

[FoxRo]

@Tom-Haase said in Test Adapter shuttercontrol v1.1.x:

@simatec
sorry das ist alles ziemliches Neuland für mich..
:confused:

2021-01-09 16:08:52.566 - debug: shuttercontrol.0 (1591) TriggerID changed: zigbee.0.00158d00053f428f.opened Value: true
2021-01-09 16:08:52.575 - debug: shuttercontrol.0 (1591) save trigger height: 0% for device: Buero1 pct
2021-01-09 16:08:52.576 - debug: shuttercontrol.0 (1591) save trigger action: up for device: Buero1 pct
2021-01-09 16:08:55.365 - debug: shuttercontrol.0 (1591) TriggerID changed: zigbee.0.00158d00053f428f.opened Value: false
2021-01-09 16:08:55.374 - debug: shuttercontrol.0 (1591) shutter trigger released Buero1 pct already in place: 0%
2021-01-09 16:08:55.376 - debug: shuttercontrol.0 (1591) save back trigger action: up for device Buero1 pct

Das ist die Ausgabe bei öffnen und schließen des Fensterkontakts.

Das ist doch schon mal was.
jetzt das Ganze noch, wenn der Rollladen unten ist. ;-)

[simatec]

@Tom-Haase
Das sieht doch recht gut aus. Jetzt fahre den Rolladen mal runter und wiederhole den Vorgang des Fenster öffnens ...

Bitte auch den Log posten.

[Tom Haase]

Rolladen per Object "closeSleep" runtergefahren.
Fensterkontakt geöffnet

2021-01-09 16:56:57.523 - debug: shuttercontrol.0 (1591) start buttonAction
2021-01-09 16:56:57.528 - info: shuttercontrol.0 (1591) Set ID: Buero1 pct value: 100%
2021-01-09 16:56:57.530 - debug: shuttercontrol.0 (1591) shutterDownButton Buero1 pct old height: 0% new height: 100%
2021-01-09 16:56:57.547 - debug: shuttercontrol.0 (1591) Shutter state changed: Buero1 pct old value = 0 new value = 100
2021-01-09 16:56:57.548 - debug: shuttercontrol.0 (1591) Buero1 pct Old value = 0. New value = 100. automatic is active
2021-01-09 16:56:57.642 - info: fhem.0 (1222) stateChange (out): fhem.0.Friedhelm.pct | 100 > set Friedhelm pct 100
2021-01-09 16:56:57.647 - info: fhem.0 (1222) event FHEM: Friedhelm | ROLLO Friedhelm drive-down | state > fhem.0.Friedhelm.state drive-down
2021-01-09 16:56:57.648 - info: fhem.0 (1222) event FHEM: Friedhelm | ROLLO Friedhelm drive-down | boolean > fhem.0.Friedhelm.state_boolean drive-down
2021-01-09 16:56:57.649 - info: fhem.0 (1222) event FHEM: Friedhelm | ROLLO Friedhelm drive-down | value > fhem.0.Friedhelm.state_value drive-down
2021-01-09 16:56:57.653 - info: fhem.0 (1222) event FHEM: SD_Keeloq_AC6000 | SD_Keeloq SD_Keeloq_AC6000 send down | state > fhem.0.SD_Keeloq_AC6000.state send down
2021-01-09 16:57:24.118 - info: fhem.0 (1222) event FHEM: SD_Keeloq_AC6000 | SD_Keeloq SD_Keeloq_AC6000 send stop | state > fhem.0.SD_Keeloq_AC6000.state send stop
2021-01-09 16:57:24.121 - info: fhem.0 (1222) event FHEM: Friedhelm | ROLLO Friedhelm closed | state > fhem.0.Friedhelm.state closed
2021-01-09 16:57:24.123 - info: fhem.0 (1222) event FHEM: Friedhelm | ROLLO Friedhelm closed | boolean > fhem.0.Friedhelm.state_boolean false
2021-01-09 16:57:24.124 - info: fhem.0 (1222) event FHEM: Friedhelm | ROLLO Friedhelm closed | value > fhem.0.Friedhelm.state_value 0
2021-01-09 16:57:24.159 - debug: shuttercontrol.0 (1591) Shutter state changed: Buero1 pct old value = 0 new value = 100
2021-01-09 16:57:24.160 - debug: shuttercontrol.0 (1591) Buero1 pct Old value = 0. New value = 100. automatic is active
2021-01-09 16:57:45.212 - debug: shuttercontrol.0 (1591) TriggerID changed: zigbee.0.00158d00053f428f.opened Value: true
2021-01-09 16:57:45.219 - debug: shuttercontrol.0 (1591) save trigger height: 100% for device: Buero1 pct
2021-01-09 16:57:45.220 - debug: shuttercontrol.0 (1591) save trigger action: down for device: Buero1 pct
2021-01-09 16:57:47.776 - info: fhem.0 (1222) stateChange (out): fhem.0.info.Commands.sendFHEM | set fhem.0.alive on-for-timer 360 > set fhem.0.alive on-for-timer 360

[Tom Haase]

und wenn ich den Fensterkontakt wieder schließe

2021-01-09 16:56:57.523 - debug: shuttercontrol.0 (1591) start buttonAction
2021-01-09 16:56:57.528 - info: shuttercontrol.0 (1591) Set ID: Buero1 pct value: 100%
2021-01-09 16:56:57.530 - debug: shuttercontrol.0 (1591) shutterDownButton Buero1 pct old height: 0% new height: 100%
2021-01-09 16:56:57.547 - debug: shuttercontrol.0 (1591) Shutter state changed: Buero1 pct old value = 0 new value = 100
2021-01-09 16:56:57.548 - debug: shuttercontrol.0 (1591) Buero1 pct Old value = 0. New value = 100. automatic is active
2021-01-09 16:56:57.642 - info: fhem.0 (1222) stateChange (out): fhem.0.Friedhelm.pct | 100 > set Friedhelm pct 100
2021-01-09 16:56:57.647 - info: fhem.0 (1222) event FHEM: Friedhelm | ROLLO Friedhelm drive-down | state > fhem.0.Friedhelm.state drive-down
2021-01-09 16:56:57.648 - info: fhem.0 (1222) event FHEM: Friedhelm | ROLLO Friedhelm drive-down | boolean > fhem.0.Friedhelm.state_boolean drive-down
2021-01-09 16:56:57.649 - info: fhem.0 (1222) event FHEM: Friedhelm | ROLLO Friedhelm drive-down | value > fhem.0.Friedhelm.state_value drive-down
2021-01-09 16:56:57.653 - info: fhem.0 (1222) event FHEM: SD_Keeloq_AC6000 | SD_Keeloq SD_Keeloq_AC6000 send down | state > fhem.0.SD_Keeloq_AC6000.state send down
2021-01-09 16:57:24.118 - info: fhem.0 (1222) event FHEM: SD_Keeloq_AC6000 | SD_Keeloq SD_Keeloq_AC6000 send stop | state > fhem.0.SD_Keeloq_AC6000.state send stop
2021-01-09 16:57:24.121 - info: fhem.0 (1222) event FHEM: Friedhelm | ROLLO Friedhelm closed | state > fhem.0.Friedhelm.state closed
2021-01-09 16:57:24.123 - info: fhem.0 (1222) event FHEM: Friedhelm | ROLLO Friedhelm closed | boolean > fhem.0.Friedhelm.state_boolean false
2021-01-09 16:57:24.124 - info: fhem.0 (1222) event FHEM: Friedhelm | ROLLO Friedhelm closed | value > fhem.0.Friedhelm.state_value 0
2021-01-09 16:57:24.159 - debug: shuttercontrol.0 (1591) Shutter state changed: Buero1 pct old value = 0 new value = 100
2021-01-09 16:57:24.160 - debug: shuttercontrol.0 (1591) Buero1 pct Old value = 0. New value = 100. automatic is active
2021-01-09 16:57:45.212 - debug: shuttercontrol.0 (1591) TriggerID changed: zigbee.0.00158d00053f428f.opened Value: true
2021-01-09 16:57:45.219 - debug: shuttercontrol.0 (1591) save trigger height: 100% for device: Buero1 pct
2021-01-09 16:57:45.220 - debug: shuttercontrol.0 (1591) save trigger action: down for device: Buero1 pct
2021-01-09 16:57:47.776 - info: fhem.0 (1222) stateChange (out): fhem.0.info.Commands.sendFHEM | set fhem.0.alive on-for-timer 360 > set fhem.0.alive on-for-timer 360
2021-01-09 17:00:00.008 - debug: shuttercontrol.0 (1591) calculate astrodata ...
2021-01-09 17:00:00.009 - debug: shuttercontrol.0 (1591) Sun Azimut: NaN°
2021-01-09 17:00:00.010 - debug: shuttercontrol.0 (1591) Sun Elevation: NaN°
2021-01-09 17:00:00.082 - info: host.raspberrypi instance system.adapter.dwd.0 started with pid 4141
2021-01-09 17:00:01.887 - info: dwd.0 (4141) Plugin sentry Sentry Plugin disabled for this process because sending of statistic data is disabled for the system
2021-01-09 17:00:01.899 - info: dwd.0 (4141) starting. Version 2.5.2 in /opt/iobroker/node_modules/iobroker.dwd, node: v12.20.0, js-controller: 3.1.6
2021-01-09 17:00:04.124 - info: host.raspberrypi instance system.adapter.daswetter.0 started with pid 4156
2021-01-09 17:00:05.536 - info: daswetter.0 (4156) Plugin sentry Sentry Plugin disabled for this process because sending of statistic data is disabled for the system
2021-01-09 17:00:05.553 - info: daswetter.0 (4156) starting. Version 3.0.4 in /opt/iobroker/node_modules/iobroker.daswetter, node: v12.20.0, js-controller: 3.1.6
2021-01-09 17:00:08.146 - info: host.raspberrypi instance system.adapter.ical.0 started with pid 4172
2021-01-09 17:00:08.369 - info: dwd.0 (4141) Terminated (ADAPTER_REQUESTED_TERMINATION): Without reason
2021-01-09 17:00:08.889 - info: host.raspberrypi instance system.adapter.dwd.0 terminated with code 11 (ADAPTER_REQUESTED_TERMINATION)
2021-01-09 17:00:10.413 - info: ical.0 (4172) Plugin sentry Sentry Plugin disabled for this process because sending of statistic data is disabled for the system
2021-01-09 17:00:10.473 - info: ical.0 (4172) starting. Version 1.8.5 in /opt/iobroker/node_modules/iobroker.ical, node: v12.20.0, js-controller: 3.1.6
2021-01-09 17:00:11.504 - info: ical.0 (4172) processing URL: calendar1 https://calendar.google.com/calendar/ical/6gbrsp5mk0pf4a0dgamj7d56n4%40group.calendar.google.com/private-a5d30d07577f1b5f997d66da0421d549/basic.ics
2021-01-09 17:00:16.263 - info: daswetter.0 (4156) got wrong data structure! trying to repair...
2021-01-09 17:00:16.680 - info: ical.0 (4172) Terminated (NO_ERROR): Without reason
2021-01-09 17:00:17.194 - info: host.raspberrypi instance system.adapter.ical.0 terminated with code 0 (NO_ERROR)
2021-01-09 17:00:18.807 - info: daswetter.0 (4156) Terminated (NO_ERROR): Without reason
2021-01-09 17:00:19.323 - info: host.raspberrypi instance system.adapter.daswetter.0 terminated with code 0 (NO_ERROR)
2021-01-09 17:00:55.047 - debug: shuttercontrol.0 (1591) TriggerID changed: zigbee.0.00158d00053f428f.opened Value: false
2021-01-09 17:00:55.054 - debug: shuttercontrol.0 (1591) shutter trigger released Buero1 pct already in place: 100%
2021-01-09 17:00:55.055 - debug: shuttercontrol.0 (1591) save back trigger action: down for device Buero1 pct

[MichMein]

@simatec sagte in Test Adapter shuttercontrol v1.1.x:

... so wie in meiner Signatur beschrieben auf debug

Wo genau soll die denn sein 🤔 ich sehe nix

[Homoran]

@MichMein sagte in Test Adapter shuttercontrol v1.1.x:

Wo genau soll die denn sein ich sehe nix

dann musst du das aktivieren

[FoxRo]

@Tom-Haase said in Test Adapter shuttercontrol v1.1.x:

2021-01-09 16:57:24.159 - debug: shuttercontrol.0 (1591) Shutter state changed: Buero1 pct old value = 0 new value = 100
2021-01-09 16:57:24.160 - debug: shuttercontrol.0 (1591) Buero1 pct Old value = 0. New value = 100. automatic is active

... Rollladen wurde runtergefahren..

2021-01-09 16:57:45.212 - debug: shuttercontrol.0 (1591) TriggerID changed: zigbee.0.00158d00053f428f.opened Value: true
2021-01-09 16:57:45.219 - debug: shuttercontrol.0 (1591) save trigger height: 100% for device: Buero1 pct
2021-01-09 16:57:45.220 - debug: shuttercontrol.0 (1591) save trigger action: down for device: Buero1 pct

... Fenster wurde geöffnet ...
..an dieser Stelle müsste der Fahrauftrag kommen um auf 50% zu fahren...
Im Code gibt es an dieser Stelle keine weitere Verzweigung oder Abhängigkeiten!

2021-01-09 16:57:47.776 - info: fhem.0 (1222) stateChange (out): fhem.0.info.Commands.sendFHEM | set fhem.0.alive on-for-timer 360 > set fhem.0.alive on-for-timer 360

Warum dann erst 2Sek später vom FHEM was zum "Alive" gemeldet wird weiss ich nicht, sieht aber danach aus, dass der FHEM Adapter an dieser Stelle neu gestartet wurde. (warum auch immer)
Wenn das so ist, kann dieser den Fahrauftrag vom Shuttercontrol wohl nicht ausführen.
Kannst Du mal in den Objekten vom Shuttercontrol / shutters schauen, was für Werte im autoState und im autoLevel für den Rollladen stehen, während Du das Fenster offen hast?
Das gibt einen Hinweis, ob die Stelle von Shuttercontrol korrekt weiter durchlaufen wurde.
Allenfalls gibt es noch mehr an Informationen her, wenn alle anderen Adapter, die nicht benötigt werden, stoppst und den FHEM Adapter gleich wie den Shuttercontrol auf Debug stellst.

[Tom Haase]

@FoxRo sagte in Test Adapter shuttercontrol v1.1.x:

Kannst Du mal in den Objekten vom Shuttercontrol / shutters schauen, was für Werte im autoState und im autoLevel für den Rollladen stehen, während Du das Fenster offen hast?

und so sieht es bei geschlossenem Rollo aus:

[Tom Haase]

Puuuh!
:blush:
Rolladen per "closeSleep" manuell heruntergefahren, dann den Fensterkontakt geöffnet

2021-01-09 18:34:58.573 - debug: fhem.0 (8023) [setAlive] start setAlive 300 sec
2021-01-09 18:34:58.581 - info: fhem.0 (8023) stateChange (out): fhem.0.info.Commands.sendFHEM | set fhem.0.alive on-for-timer 360 > set fhem.0.alive on-for-timer 360
2021-01-09 18:34:58.583 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.info.Commands.sendFHEM set fhem.0.alive on-for-timer 360 {"val":"set fhem.0.alive on-for-timer 360","ack":true,"ts":1610213698576,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213698576}
2021-01-09 18:34:58.592 - debug: fhem.0 (8023) [main] [eventFHEM] eventFHEM(in): "dummy fhem.0.alive on"
2021-01-09 18:34:58.594 - debug: fhem.0 (8023) [main] [eventFHEM] [processEvent] [parseEvent] [getAlive] alive true - start
2021-01-09 18:34:58.596 - debug: fhem.0 (8023) [main] [eventFHEM] [processEvent] [parseEvent] [main] [eventFHEM] [processEvent] [parseEvent] [getAlive] alive reset timer
2021-01-09 18:34:58.653 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.info.Commands.resultFHEM {"val":"","ack":true,"ts":1610213698647,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213398597}
2021-01-09 18:34:58.656 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.info.Info.alive true {"val":true,"ack":true,"ts":1610213698648,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213098621}
2021-01-09 18:34:58.659 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.info.Debug.numberIn 19 {"val":19,"ack":true,"ts":1610213698648,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213698648}
2021-01-09 18:34:58.663 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.info.Debug.timeIn 57 {"val":57,"ack":true,"ts":1610213698648,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213698648}
2021-01-09 18:34:58.666 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.info.Debug.numberOut 1 {"val":1,"ack":true,"ts":1610213698648,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213698648}
2021-01-09 18:34:58.670 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.info.Debug.timeOut 114 {"val":114,"ack":true,"ts":1610213698649,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213698649}
2021-01-09 18:34:58.677 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.info.Commands.lastCommand set fhem.0.alive on-for-timer 360 {"val":"set fhem.0.alive on-for-timer 360","ack":true,"ts":1610213698673,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213398609}
2021-01-09 18:34:58.680 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.info.Commands.sendFHEM done {"val":"done","ack":true,"ts":1610213698678,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213698678}
2021-01-09 18:35:00.011 - debug: shuttercontrol.0 (1591) calculate astrodata ...
2021-01-09 18:35:00.012 - debug: shuttercontrol.0 (1591) Sun Azimut: NaN°
2021-01-09 18:35:00.013 - debug: shuttercontrol.0 (1591) Sun Elevation: NaN°
2021-01-09 18:39:23.313 - debug: shuttercontrol.0 (1591) start buttonAction
2021-01-09 18:39:23.316 - info: shuttercontrol.0 (1591) Set ID: Buero1 pct value: 100%
2021-01-09 18:39:23.318 - debug: shuttercontrol.0 (1591) shutterDownButton Buero1 pct old height: 0% new height: 100%
2021-01-09 18:39:23.324 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.Friedhelm.pct 100 {"val":100,"ack":false,"ts":1610213963319,"q":0,"from":"system.adapter.shuttercontrol.0","user":"system.user.admin","lc":1610213963319}
2021-01-09 18:39:23.328 - debug: shuttercontrol.0 (1591) Shutter state changed: Buero1 pct old value = 0 new value = 100
2021-01-09 18:39:23.329 - debug: shuttercontrol.0 (1591) Buero1 pct Old value = 0. New value = 100. automatic is active
2021-01-09 18:39:23.434 - info: fhem.0 (8023) stateChange (out): fhem.0.Friedhelm.pct | 100 > set Friedhelm pct 100
2021-01-09 18:39:23.436 - debug: fhem.0 (8023) [main] [eventFHEM] eventFHEM(in): "ROLLO Friedhelm command: pct-100"
2021-01-09 18:39:23.437 - debug: fhem.0 (8023) [main] [eventFHEM] [processEvent] [parseEvent] [eventOK] event FHEM: Friedhelm | ROLLO Friedhelm command: pct-100 | reading > fhem.0.Friedhelm.command pct-100
2021-01-09 18:39:23.438 - debug: fhem.0 (8023) [main] [eventFHEM] eventFHEM(in): "ROLLO Friedhelm desired_pct: 100"
2021-01-09 18:39:23.439 - debug: fhem.0 (8023) [main] [eventFHEM] [processEvent] [parseEvent] [eventOK] event FHEM: Friedhelm | ROLLO Friedhelm desired_pct: 100 | reading > fhem.0.Friedhelm.desired_pct 100
2021-01-09 18:39:23.440 - debug: fhem.0 (8023) [main] [eventFHEM] eventFHEM(in): "ROLLO Friedhelm last_drive: drive-down"
2021-01-09 18:39:23.440 - debug: fhem.0 (8023) [main] [eventFHEM] [processEvent] [parseEvent] [eventOK] event FHEM: Friedhelm | ROLLO Friedhelm last_drive: drive-down | reading > fhem.0.Friedhelm.last_drive drive-down
2021-01-09 18:39:23.441 - debug: fhem.0 (8023) [main] [eventFHEM] eventFHEM(in): "ROLLO Friedhelm drive-down"
2021-01-09 18:39:23.442 - info: fhem.0 (8023) event FHEM: Friedhelm | ROLLO Friedhelm drive-down | state > fhem.0.Friedhelm.state drive-down
2021-01-09 18:39:23.443 - info: fhem.0 (8023) event FHEM: Friedhelm | ROLLO Friedhelm drive-down | boolean > fhem.0.Friedhelm.state_boolean drive-down
2021-01-09 18:39:23.444 - info: fhem.0 (8023) event FHEM: Friedhelm | ROLLO Friedhelm drive-down | value > fhem.0.Friedhelm.state_value drive-down
2021-01-09 18:39:23.445 - debug: fhem.0 (8023) [main] [eventFHEM] eventFHEM(in): "ROLLO Friedhelm drive-type: modul"
2021-01-09 18:39:23.445 - debug: fhem.0 (8023) [main] [eventFHEM] [processEvent] [parseEvent] [eventOK] event FHEM: Friedhelm | ROLLO Friedhelm drive-type: modul | reading > fhem.0.Friedhelm.drive-type modul
2021-01-09 18:39:23.446 - debug: fhem.0 (8023) [main] [eventFHEM] eventFHEM(in): "SD_Keeloq SD_Keeloq_AC6000 button: down"
2021-01-09 18:39:23.447 - debug: fhem.0 (8023) [main] [eventFHEM] [processEvent] [parseEvent] [eventOK] event FHEM: SD_Keeloq_AC6000 | SD_Keeloq SD_Keeloq_AC6000 button: down | reading > fhem.0.SD_Keeloq_AC6000.button down
2021-01-09 18:39:23.448 - debug: fhem.0 (8023) [main] [eventFHEM] eventFHEM(in): "SD_Keeloq SD_Keeloq_AC6000 channel: 9"
2021-01-09 18:39:23.449 - debug: fhem.0 (8023) [main] [eventFHEM] [processEvent] [parseEvent] [eventOK] event FHEM: SD_Keeloq_AC6000 | SD_Keeloq SD_Keeloq_AC6000 channel: 9 | reading > fhem.0.SD_Keeloq_AC6000.channel 9
2021-01-09 18:39:23.449 - debug: fhem.0 (8023) [main] [eventFHEM] eventFHEM(in): "SD_Keeloq SD_Keeloq_AC6000 counter_send: 9226"
2021-01-09 18:39:23.450 - debug: fhem.0 (8023) [main] [eventFHEM] [processEvent] [parseEvent] [eventOK] event FHEM: SD_Keeloq_AC6000 | SD_Keeloq SD_Keeloq_AC6000 counter_send: 9226 | reading > fhem.0.SD_Keeloq_AC6000.counter_send 9226
2021-01-09 18:39:23.451 - debug: fhem.0 (8023) [main] [eventFHEM] eventFHEM(in): "SD_Keeloq SD_Keeloq_AC6000 send down"
2021-01-09 18:39:23.452 - info: fhem.0 (8023) event FHEM: SD_Keeloq_AC6000 | SD_Keeloq SD_Keeloq_AC6000 send down | state > fhem.0.SD_Keeloq_AC6000.state send down
2021-01-09 18:39:23.453 - debug: fhem.0 (8023) [main] [eventFHEM] eventFHEM(in): "SD_Keeloq SD_Keeloq_AC6000 LastAction_Channel_09: down"
2021-01-09 18:39:23.453 - debug: fhem.0 (8023) [main] [eventFHEM] [processEvent] [parseEvent] [eventOK] event FHEM: SD_Keeloq_AC6000 | SD_Keeloq SD_Keeloq_AC6000 LastAction_Channel_09: down | reading > fhem.0.SD_Keeloq_AC6000.LastAction_Channel_09 down
2021-01-09 18:39:23.454 - debug: fhem.0 (8023) [main] [eventFHEM] eventFHEM(in): "SD_Keeloq SD_Keeloq_AC6000 channel_control: no"
2021-01-09 18:39:23.455 - debug: fhem.0 (8023) [main] [eventFHEM] [processEvent] [parseEvent] [eventOK] event FHEM: SD_Keeloq_AC6000 | SD_Keeloq SD_Keeloq_AC6000 channel_control: no | reading > fhem.0.SD_Keeloq_AC6000.channel_control no
2021-01-09 18:39:23.481 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.Friedhelm.command pct-100 {"val":"pct-100","ack":true,"ts":1610213963474,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213963474}
2021-01-09 18:39:23.482 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.Friedhelm.desired_pct 100 {"val":"100","ack":true,"ts":1610213963476,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213963476}
2021-01-09 18:39:23.486 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.Friedhelm.last_drive drive-down {"val":"drive-down","ack":true,"ts":1610213963476,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213963476}
2021-01-09 18:39:23.490 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.Friedhelm.state drive-down {"val":"drive-down","ack":true,"ts":1610213963476,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213963476}
2021-01-09 18:39:23.491 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.Friedhelm.state_boolean drive-down {"val":"drive-down","ack":true,"ts":1610213963476,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213963476}
2021-01-09 18:39:23.495 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.Friedhelm.state_value drive-down {"val":"drive-down","ack":true,"ts":1610213963477,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213963477}
2021-01-09 18:39:23.496 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.SD_Keeloq_AC6000.button down {"val":"down","ack":true,"ts":1610213963477,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213963477}
2021-01-09 18:39:23.497 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.SD_Keeloq_AC6000.counter_send 9226 {"val":"9226","ack":true,"ts":1610213963477,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213963477}
2021-01-09 18:39:23.501 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.SD_Keeloq_AC6000.state send down {"val":"send down","ack":true,"ts":1610213963477,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213963477}
2021-01-09 18:39:23.502 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.SD_Keeloq_AC6000.LastAction_Channel_09 down {"val":"down","ack":true,"ts":1610213963478,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213963478}
2021-01-09 18:39:50.099 - debug: fhem.0 (8023) [main] [eventFHEM] eventFHEM(in): "ROLLO Friedhelm pct: 100"
2021-01-09 18:39:50.100 - debug: fhem.0 (8023) [main] [eventFHEM] [processEvent] [parseEvent] [eventOK] event FHEM: Friedhelm | ROLLO Friedhelm pct: 100 | reading > fhem.0.Friedhelm.pct 100
2021-01-09 18:39:50.101 - debug: fhem.0 (8023) [main] [eventFHEM] eventFHEM(in): "SD_Keeloq SD_Keeloq_AC6000 button: stop"
2021-01-09 18:39:50.102 - debug: fhem.0 (8023) [main] [eventFHEM] [processEvent] [parseEvent] [eventOK] event FHEM: SD_Keeloq_AC6000 | SD_Keeloq SD_Keeloq_AC6000 button: stop | reading > fhem.0.SD_Keeloq_AC6000.button stop
2021-01-09 18:39:50.103 - debug: fhem.0 (8023) [main] [eventFHEM] eventFHEM(in): "SD_Keeloq SD_Keeloq_AC6000 channel: 9"
2021-01-09 18:39:50.104 - debug: fhem.0 (8023) [main] [eventFHEM] [processEvent] [parseEvent] [eventOK] event FHEM: SD_Keeloq_AC6000 | SD_Keeloq SD_Keeloq_AC6000 channel: 9 | reading > fhem.0.SD_Keeloq_AC6000.channel 9
2021-01-09 18:39:50.104 - debug: fhem.0 (8023) [main] [eventFHEM] eventFHEM(in): "SD_Keeloq SD_Keeloq_AC6000 counter_send: 9227"
2021-01-09 18:39:50.105 - debug: fhem.0 (8023) [main] [eventFHEM] [processEvent] [parseEvent] [eventOK] event FHEM: SD_Keeloq_AC6000 | SD_Keeloq SD_Keeloq_AC6000 counter_send: 9227 | reading > fhem.0.SD_Keeloq_AC6000.counter_send 9227
2021-01-09 18:39:50.106 - debug: fhem.0 (8023) [main] [eventFHEM] eventFHEM(in): "SD_Keeloq SD_Keeloq_AC6000 send stop"
2021-01-09 18:39:50.106 - info: fhem.0 (8023) event FHEM: SD_Keeloq_AC6000 | SD_Keeloq SD_Keeloq_AC6000 send stop | state > fhem.0.SD_Keeloq_AC6000.state send stop
2021-01-09 18:39:50.107 - debug: fhem.0 (8023) [main] [eventFHEM] eventFHEM(in): "SD_Keeloq SD_Keeloq_AC6000 LastAction_Channel_09: stop"
2021-01-09 18:39:50.108 - debug: fhem.0 (8023) [main] [eventFHEM] [processEvent] [parseEvent] [eventOK] event FHEM: SD_Keeloq_AC6000 | SD_Keeloq SD_Keeloq_AC6000 LastAction_Channel_09: stop | reading > fhem.0.SD_Keeloq_AC6000.LastAction_Channel_09 stop
2021-01-09 18:39:50.109 - debug: fhem.0 (8023) [main] [eventFHEM] eventFHEM(in): "SD_Keeloq SD_Keeloq_AC6000 channel_control: no"
2021-01-09 18:39:50.109 - debug: fhem.0 (8023) [main] [eventFHEM] [processEvent] [parseEvent] [eventOK] event FHEM: SD_Keeloq_AC6000 | SD_Keeloq SD_Keeloq_AC6000 channel_control: no | reading > fhem.0.SD_Keeloq_AC6000.channel_control no
2021-01-09 18:39:50.110 - debug: fhem.0 (8023) [main] [eventFHEM] eventFHEM(in): "ROLLO Friedhelm closed"
2021-01-09 18:39:50.111 - info: fhem.0 (8023) event FHEM: Friedhelm | ROLLO Friedhelm closed | state > fhem.0.Friedhelm.state closed
2021-01-09 18:39:50.112 - info: fhem.0 (8023) event FHEM: Friedhelm | ROLLO Friedhelm closed | boolean > fhem.0.Friedhelm.state_boolean false
2021-01-09 18:39:50.113 - info: fhem.0 (8023) event FHEM: Friedhelm | ROLLO Friedhelm closed | value > fhem.0.Friedhelm.state_value 0
2021-01-09 18:39:50.140 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.Friedhelm.pct 100 {"val":"100","ack":true,"ts":1610213990132,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213990132}
2021-01-09 18:39:50.141 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.SD_Keeloq_AC6000.button stop {"val":"stop","ack":true,"ts":1610213990133,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213990133}
2021-01-09 18:39:50.148 - debug: shuttercontrol.0 (1591) Shutter state changed: Buero1 pct old value = 0 new value = 100
2021-01-09 18:39:50.147 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.SD_Keeloq_AC6000.counter_send 9227 {"val":"9227","ack":true,"ts":1610213990134,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213990134}
2021-01-09 18:39:50.148 - debug: shuttercontrol.0 (1591) Buero1 pct Old value = 0. New value = 100. automatic is active
2021-01-09 18:39:50.151 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.SD_Keeloq_AC6000.state send stop {"val":"send stop","ack":true,"ts":1610213990134,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213990134}
2021-01-09 18:39:50.155 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.SD_Keeloq_AC6000.LastAction_Channel_09 stop {"val":"stop","ack":true,"ts":1610213990137,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213990137}
2021-01-09 18:39:50.156 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.Friedhelm.state closed {"val":"closed","ack":true,"ts":1610213990138,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213990138}
2021-01-09 18:39:50.156 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.Friedhelm.state_boolean false {"val":false,"ack":true,"ts":1610213990138,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213990138}
2021-01-09 18:39:50.157 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.Friedhelm.state_value 0 {"val":0,"ack":true,"ts":1610213990139,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213990139}
2021-01-09 18:39:54.744 - debug: shuttercontrol.0 (1591) TriggerID changed: zigbee.0.00158d00053f428f.opened Value: true
2021-01-09 18:39:54.749 - debug: shuttercontrol.0 (1591) save trigger height: 100% for device: Buero1 pct
2021-01-09 18:39:54.750 - debug: shuttercontrol.0 (1591) save trigger action: down for device: Buero1 pct
2021-01-09 18:39:58.576 - debug: fhem.0 (8023) [setAlive] start setAlive 300 sec
2021-01-09 18:39:58.584 - info: fhem.0 (8023) stateChange (out): fhem.0.info.Commands.sendFHEM | set fhem.0.alive on-for-timer 360 > set fhem.0.alive on-for-timer 360
2021-01-09 18:39:58.585 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.info.Commands.sendFHEM set fhem.0.alive on-for-timer 360 {"val":"set fhem.0.alive on-for-timer 360","ack":true,"ts":1610213998579,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213998579}
2021-01-09 18:39:58.595 - debug: fhem.0 (8023) [main] [eventFHEM] eventFHEM(in): "dummy fhem.0.alive on"
2021-01-09 18:39:58.596 - debug: fhem.0 (8023) [main] [eventFHEM] [processEvent] [parseEvent] [getAlive] alive true - start
2021-01-09 18:39:58.599 - debug: fhem.0 (8023) [main] [eventFHEM] [processEvent] [parseEvent] [main] [eventFHEM] [processEvent] [parseEvent] [getAlive] alive reset timer
2021-01-09 18:39:58.627 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.info.Commands.resultFHEM {"val":"","ack":true,"ts":1610213998620,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213398597}
2021-01-09 18:39:58.630 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.info.Info.alive true {"val":true,"ack":true,"ts":1610213998621,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213098621}
2021-01-09 18:39:58.641 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.info.Debug.numberIn 18 {"val":18,"ack":true,"ts":1610213998622,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213998622}
2021-01-09 18:39:58.645 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.info.Debug.timeIn 47 {"val":47,"ack":true,"ts":1610213998623,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213998623}
2021-01-09 18:39:58.649 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.info.Debug.numberOut 1 {"val":1,"ack":true,"ts":1610213998623,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213698648}
2021-01-09 18:39:58.650 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.info.Debug.timeOut 111 {"val":111,"ack":true,"ts":1610213998623,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213998623}
2021-01-09 18:39:58.655 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.info.Commands.lastCommand set fhem.0.alive on-for-timer 360 {"val":"set fhem.0.alive on-for-timer 360","ack":true,"ts":1610213998649,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213398609}
2021-01-09 18:39:58.662 - debug: fhem.0 (8023) [stateChange] stateChange (in): fhem.0.info.Commands.sendFHEM done {"val":"done","ack":true,"ts":1610213998658,"q":0,"from":"system.adapter.fhem.0","user":"system.user.admin","lc":1610213998658}
2021-01-09 18:40:00.008 - debug: shuttercontrol.0 (1591) calculate astrodata ...
2021-01-09 18:40:00.009 - debug: shuttercontrol.0 (1591) Sun Azimut: NaN°
2021-01-09 18:40:00.010 - debug: shuttercontrol.0 (1591) Sun Elevation: NaN°