20:16:49.005 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'ShutterEG' received command 60 20:16:49.053 [DEBUG] [webnet.handler.OpenWebNetThingHandler] - ==OWN:ThingHandler== handleCommand() (command=60 - channel=openwebnet:bus_automation:cfa0a33c:25:shutter) 20:16:49.051 [DEBUG] [webnet.handler.OpenWebNetThingHandler] - ==OWN:ThingHandler== handleCommand() (command=60 - channel=openwebnet:bus_automation:cfa0a33c:23:shutter) 20:16:49.049 [DEBUG] [webnet.handler.OpenWebNetThingHandler] - ==OWN:ThingHandler== handleCommand() (command=60 - channel=openwebnet:bus_automation:cfa0a33c:24:shutter) 20:16:49.028 [DEBUG] [webnet.handler.OpenWebNetThingHandler] - ==OWN:ThingHandler== handleCommand() (command=60 - channel=openwebnet:bus_automation:cfa0a33c:22:shutter) 20:16:49.011 [DEBUG] [webnet.handler.OpenWebNetThingHandler] - ==OWN:ThingHandler== handleCommand() (command=60 - channel=openwebnet:bus_automation:cfa0a33c:21:shutter) 20:16:49.314 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== handleShutterCommand() (command=60) 20:16:49.242 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== handleShutterCommand() (command=60) 20:16:49.183 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== handleShutterCommand() (command=60) 20:16:49.120 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== handleShutterCommand() (command=60) 20:16:49.071 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'RolloWohnziRe' received command 60 20:16:49.562 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== 60% requested 20:16:49.516 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== 60% requested 20:16:49.466 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== 60% requested 20:16:49.419 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== 60% requested 20:16:49.364 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== handleShutterCommand() (command=60) 20:16:49.765 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== moveTime=21000 20:16:49.722 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== moveTime=12000 20:16:49.682 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== moveTime=12000 20:16:49.639 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== moveTime=2000 20:16:49.600 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'RolloTerrasse' received command 60 20:16:49.959 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== MOVING 2 - startedMovingAt=1531246609959 20:16:49.945 [WARN ] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== updateAutomationState() FRAME <*2*1000#2*22##> NOT SUPPORTED for thing openwebnet:bus_automation:cfa0a33c:22, ignoring it. 20:16:49.811 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== 60% requested 20:16:50.089 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=2 positionEst=0 - calibrating=-1 shutterRun=35000 ]]] 20:16:50.027 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'RolloEsszi' received command 60 20:16:50.335 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== MOVING 2 - startedMovingAt=1531246610335 20:16:50.334 [WARN ] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== updateAutomationState() FRAME <*2*1000#2*25##> NOT SUPPORTED for thing openwebnet:bus_automation:cfa0a33c:25, ignoring it. 20:16:50.219 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== ...sending returned 20:16:50.189 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== moveTime=18000 20:16:50.393 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=2 positionEst=50 - calibrating=-1 shutterRun=20000 ]]] 20:16:50.350 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'RolloWohnZiLi' received command 60 20:16:50.621 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== ...sending returned 20:16:50.639 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'RolloKueche' received command 60 20:16:50.694 [WARN ] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== updateAutomationState() FRAME <*2*1000#2*23##> NOT SUPPORTED for thing openwebnet:bus_automation:cfa0a33c:23, ignoring it. 20:16:50.720 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== MOVING 2 - startedMovingAt=1531246610720 20:16:50.712 [INFO ] [smarthome.event.ItemStateChangedEvent] - RolloWohnziRe changed from 0 to 60 20:16:50.836 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=2 positionEst=0 - calibrating=-1 shutterRun=20000 ]]] 20:16:50.852 [INFO ] [smarthome.event.ItemStateChangedEvent] - RolloTerrasse changed from 0 to 60 20:16:50.939 [INFO ] [smarthome.event.ItemStateChangedEvent] - RolloEsszi changed from 0 to 60 20:16:50.975 [INFO ] [smarthome.event.ItemStateChangedEvent] - RolloWohnZiLi changed from 0 to 60 20:16:50.988 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== ...sending returned 20:16:51.020 [INFO ] [smarthome.event.ItemStateChangedEvent] - RolloKueche changed from 50 to 60 20:16:51.088 [WARN ] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== updateAutomationState() FRAME <*2*1000#2*24##> NOT SUPPORTED for thing openwebnet:bus_automation:cfa0a33c:24, ignoring it. 20:16:51.098 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== MOVING 2 - startedMovingAt=1531246611098 20:16:51.204 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=2 positionEst=0 - calibrating=-1 shutterRun=20000 ]]] 20:16:51.358 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== ...sending returned 20:16:51.436 [WARN ] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== updateAutomationState() FRAME <*2*1000#2*21##> NOT SUPPORTED for thing openwebnet:bus_automation:cfa0a33c:21, ignoring it. 20:16:51.475 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== MOVING 2 - startedMovingAt=1531246611468 20:16:51.544 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=2 positionEst=0 - calibrating=-1 shutterRun=30000 ]]] 20:16:51.731 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== ...sending returned 20:16:51.991 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== moveSchedule expired, sending STOP... 20:16:52.046 [WARN ] [ommon.WrappedScheduledExecutorService] - Scheduled runnable ended with an exception java.lang.NullPointerException: null at org.openwebnet.OpenGatewayBus.a(OpenGatewayBus.java:238) ~[?:?] at org.openwebnet.OpenGatewayBus.send(OpenGatewayBus.java:217) ~[?:?] at org.openhab.binding.openwebnet.handler.OpenWebNetAutomationHandler.lambda$0(OpenWebNetAutomationHandler.java:211) ~[?:?] at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:?] at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:?] at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180) [?:?] at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) [?:?] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:?] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:?] at java.lang.Thread.run(Thread.java:748) [?:?] 20:16:54.041 [WARN ] [org.openwebnet.bus.MyHomeConnection ] - ##gw-openwebnet-conn## ... handshake not completed but timeout expired, closing socket... 20:16:56.497 [DEBUG] [ebnet.handler.OpenWebNetBridgeHandler] - ==OWN== GatewayManagement WHAT = null 20:17:01.896 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== moveSchedule expired, sending STOP... 20:17:01.952 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== moveSchedule expired, sending STOP... 20:17:02.014 [WARN ] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== updateAutomationState() FRAME <*2*1000#0*24##> NOT SUPPORTED for thing openwebnet:bus_automation:cfa0a33c:24, ignoring it. 20:17:02.049 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== movementSteps=55 DOWN(+) 20:17:02.128 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=0 positionEst=55 - calibrating=-1 shutterRun=20000 ]]] 20:17:02.135 [INFO ] [smarthome.event.ItemStateChangedEvent] - RolloEsszi changed from 60 to 55 20:17:02.374 [WARN ] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== updateAutomationState() FRAME <*2*1000#0*23##> NOT SUPPORTED for thing openwebnet:bus_automation:cfa0a33c:23, ignoring it. 20:17:02.427 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== movementSteps=59 DOWN(+) 20:17:02.488 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=0 positionEst=59 - calibrating=-1 shutterRun=20000 ]]] 20:17:02.493 [INFO ] [smarthome.event.ItemStateChangedEvent] - RolloWohnZiLi changed from 60 to 59 20:17:08.544 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== moveSchedule expired, sending STOP... 20:17:08.664 [WARN ] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== updateAutomationState() FRAME <*2*1000#0*21##> NOT SUPPORTED for thing openwebnet:bus_automation:cfa0a33c:21, ignoring it. 20:17:08.691 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== movementSteps=57 DOWN(+) 20:17:08.769 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=0 positionEst=57 - calibrating=-1 shutterRun=30000 ]]] 20:17:08.771 [INFO ] [smarthome.event.ItemStateChangedEvent] - RolloWohnziRe changed from 60 to 57 20:17:10.854 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== moveSchedule expired, sending STOP... 20:17:10.975 [WARN ] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== updateAutomationState() FRAME <*2*1000#0*22##> NOT SUPPORTED for thing openwebnet:bus_automation:cfa0a33c:22, ignoring it. 20:17:11.008 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== movementSteps=60 DOWN(+) 20:17:11.085 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=0 positionEst=60 - calibrating=-1 shutterRun=35000 ]]] 20:17:17.313 [DEBUG] [net.handler.OpenWebNetLightingHandler] - ==OWN:LightingHandler== updateLightState() for thing: openwebnet:bus_on_off_switch:cfa0a33c:11 20:17:17.349 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=0 positionEst=57 - calibrating=-1 shutterRun=30000 ]]] 20:17:17.419 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=0 positionEst=60 - calibrating=-1 shutterRun=35000 ]]] 20:17:17.385 [DEBUG] [net.handler.OpenWebNetLightingHandler] - ==OWN:LightingHandler== updateLightState() for thing: openwebnet:bus_on_off_switch:cfa0a33c:31 20:17:17.500 [DEBUG] [net.handler.OpenWebNetLightingHandler] - ==OWN:LightingHandler== updateLightState() for thing: openwebnet:bus_on_off_switch:cfa0a33c:51 20:17:17.459 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=0 positionEst=0 - calibrating=-1 shutterRun=20000 ]]] 20:17:17.646 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=0 positionEst=100 - calibrating=-1 shutterRun=20000 ]]] 20:17:17.619 [DEBUG] [net.handler.OpenWebNetLightingHandler] - ==OWN:LightingHandler== updateLightState() for thing: openwebnet:bus_on_off_switch:cfa0a33c:32 20:17:17.580 [DEBUG] [net.handler.OpenWebNetLightingHandler] - ==OWN:LightingHandler== updateLightState() for thing: openwebnet:bus_on_off_switch:cfa0a33c:12 20:17:17.538 [DEBUG] [net.handler.OpenWebNetLightingHandler] - ==OWN:LightingHandler== updateLightState() for thing: openwebnet:bus_on_off_switch:cfa0a33c:61 20:17:17.839 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=0 positionEst=100 - calibrating=-1 shutterRun=20000 ]]] 20:17:17.806 [DEBUG] [net.handler.OpenWebNetLightingHandler] - ==OWN:LightingHandler== updateLightState() for thing: openwebnet:bus_on_off_switch:cfa0a33c:33 20:17:17.778 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=0 positionEst=59 - calibrating=-1 shutterRun=20000 ]]] 20:17:17.729 [DEBUG] [net.handler.OpenWebNetLightingHandler] - ==OWN:LightingHandler== updateLightState() for thing: openwebnet:bus_on_off_switch:cfa0a33c:13 20:17:17.690 [DEBUG] [net.handler.OpenWebNetLightingHandler] - ==OWN:LightingHandler== updateLightState() for thing: openwebnet:bus_on_off_switch:cfa0a33c:52 20:17:18.097 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== movementSteps=139 DOWN(+) 20:17:18.060 [DEBUG] [net.handler.OpenWebNetLightingHandler] - ==OWN:LightingHandler== updateLightState() for thing: openwebnet:bus_on_off_switch:cfa0a33c:15 20:17:18.005 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=0 positionEst=100 - calibrating=-1 shutterRun=20000 ]]] 20:17:17.979 [DEBUG] [net.handler.OpenWebNetLightingHandler] - ==OWN:LightingHandler== updateLightState() for thing: openwebnet:bus_on_off_switch:cfa0a33c:34 20:17:17.923 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=0 positionEst=55 - calibrating=-1 shutterRun=20000 ]]] 20:17:17.889 [DEBUG] [net.handler.OpenWebNetLightingHandler] - ==OWN:LightingHandler== updateLightState() for thing: openwebnet:bus_on_off_switch:cfa0a33c:14 20:17:18.421 [DEBUG] [net.handler.OpenWebNetLightingHandler] - ==OWN:LightingHandler== updateLightState() for thing: openwebnet:bus_on_off_switch:cfa0a33c:38 20:17:18.363 [DEBUG] [net.handler.OpenWebNetLightingHandler] - ==OWN:LightingHandler== updateLightState() for thing: openwebnet:bus_dimmer:cfa0a33c:18 20:17:18.320 [DEBUG] [net.handler.OpenWebNetLightingHandler] - ==OWN:LightingHandler== updateLightState() for thing: openwebnet:bus_dimmer:cfa0a33c:17 20:17:18.274 [DEBUG] [net.handler.OpenWebNetLightingHandler] - ==OWN:LightingHandler== updateLightState() for thing: openwebnet:bus_on_off_switch:cfa0a33c:37 20:17:18.230 [DEBUG] [net.handler.OpenWebNetLightingHandler] - ==OWN:LightingHandler== updateLightState() for thing: openwebnet:bus_on_off_switch:cfa0a33c:36 20:17:18.195 [DEBUG] [net.handler.OpenWebNetLightingHandler] - ==OWN:LightingHandler== updateLightState() for thing: openwebnet:bus_on_off_switch:cfa0a33c:16 20:17:18.193 [INFO ] [smarthome.event.ItemStateChangedEvent] - RolloKueche changed from 60 to 100 20:17:18.179 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== MOVING 2 - startedMovingAt=1531246638178 20:17:18.140 [DEBUG] [net.handler.OpenWebNetLightingHandler] - ==OWN:LightingHandler== updateLightState() for thing: openwebnet:bus_on_off_switch:cfa0a33c:35 20:17:18.833 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=2 positionEst=100 - calibrating=-1 shutterRun=20000 ]]] 20:17:18.595 [DEBUG] [net.handler.OpenWebNetLightingHandler] - ==OWN:LightingHandler== updateLightBrightnessState() msg=<*1*0*17##> 20:17:18.545 [DEBUG] [net.handler.OpenWebNetLightingHandler] - ==OWN:LightingHandler== updateLightBrightnessState() msg=<*1*0*18##> 20:17:18.520 [DEBUG] [net.handler.OpenWebNetLightingHandler] - ==OWN:LightingHandler== updateLightState() for thing: openwebnet:bus_on_off_switch:cfa0a33c:0110 20:17:18.464 [DEBUG] [net.handler.OpenWebNetLightingHandler] - ==OWN:LightingHandler== updateLightState() for thing: openwebnet:bus_on_off_switch:cfa0a33c:19 20:17:19.027 [DEBUG] [net.handler.OpenWebNetLightingHandler] - $$$ START---updateLightBr latestBriWhat=0 latestBriBeforeOff=-1 brightnessLevelRequested=false 20:17:18.984 [DEBUG] [net.handler.OpenWebNetLightingHandler] - $$$ START---updateLightBr latestBriWhat=0 latestBriBeforeOff=-1 brightnessLevelRequested=false 20:17:19.269 [DEBUG] [net.handler.OpenWebNetLightingHandler] - $bri now=1.531246639269E12 delta=1.531246639269E12 20:17:19.303 [DEBUG] [net.handler.OpenWebNetLightingHandler] - $bri now=1.531246639303E12 delta=1.531246639303E12 20:17:19.342 [DEBUG] [net.handler.OpenWebNetLightingHandler] - $bri update from network -> level should be present in WHAT part of the message 20:17:19.385 [DEBUG] [net.handler.OpenWebNetLightingHandler] - $bri update from network -> level should be present in WHAT part of the message 20:17:19.430 [DEBUG] [net.handler.OpenWebNetLightingHandler] - $bri latest 0 ----> new 0 20:17:19.480 [DEBUG] [net.handler.OpenWebNetLightingHandler] - $bri latest 0 ----> new 0 20:17:19.514 [DEBUG] [net.handler.OpenWebNetLightingHandler] - $bri no change 20:17:19.548 [DEBUG] [net.handler.OpenWebNetLightingHandler] - $bri no change 20:17:19.577 [DEBUG] [net.handler.OpenWebNetLightingHandler] - $$$ END ---updateLightBr latestBriWhat=0 latestBriBeforeOff=-1 brightnessLevelRequested=false 20:17:19.610 [DEBUG] [net.handler.OpenWebNetLightingHandler] - $$$ END ---updateLightBr latestBriWhat=0 latestBriBeforeOff=-1 brightnessLevelRequested=false 20:17:19.891 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=0 positionEst=57 - calibrating=-1 shutterRun=30000 ]]] 20:17:19.935 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=0 positionEst=100 - calibrating=-1 shutterRun=20000 ]]] 20:17:19.921 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=0 positionEst=100 - calibrating=-1 shutterRun=20000 ]]] 20:17:19.921 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=0 positionEst=100 - calibrating=-1 shutterRun=20000 ]]] 20:17:19.918 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=0 positionEst=0 - calibrating=-1 shutterRun=20000 ]]] 20:17:19.915 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== movementSteps=9 DOWN(+) 20:17:19.902 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=0 positionEst=55 - calibrating=-1 shutterRun=20000 ]]] 20:17:19.898 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=0 positionEst=59 - calibrating=-1 shutterRun=20000 ]]] 20:17:19.895 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=0 positionEst=60 - calibrating=-1 shutterRun=35000 ]]] 20:17:20.217 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== MOVING 2 - startedMovingAt=1531246640217 20:17:20.426 [DEBUG] [t.handler.OpenWebNetAutomationHandler] - ==OWN:AutomationHandler== [[[ internalState=2 positionEst=100 - calibrating=-1 shutterRun=20000 ]]] 20:17:31.233 [DEBUG] [ebnet.handler.OpenWebNetBridgeHandler] - ==OWN== GatewayManagement WHAT = null