Hi markus,
maybe you can have a look at my issue here: I am trying out the recent version from your post here:
I havent updated in a while, so I removed all things first, stoped the service, removed the old file, added the 2 new jars, cleaned the cache, started openhab, waited, updated all firmware on all devices, moved the jar, added all the things back…
now I have 2 issues left:
- the input channel of the RGBWs. It used to be named “power”, right? now you renamed that to input, ok, but I cannot get them to turn things off. It seems the brightness does not change. it should go to 0 shouldn’t it?
Switch Kitchen_CeilingLight_Switch0b "Deckenlicht Kanal 1b" <light> (G_Kitchen_CeilingLight_Switch) [ "Lighting" ] {channel="shelly:shellyrgbw2-white:662176:channel1#input"}
shellyrgbw2-662176: Execute command ON on channel shelly:shellyrgbw2-white:662176:channel1#input, lightId=0
21-Mar-2020 00:32:01.660 [TRACE] [binding.shelly.internal.handler.ShellyLightHandler] - Colors loaded for lightId 0: RGBW=0/0/0/0, gain=0, brightness=1, color temp=0 (min=0, max=0
21-Mar-2020 00:32:02.140 [TRACE] [binding.shelly.internal.handler.ShellyLightHandler] - shellyrgbw2-662176: Execute command OFF on channel shelly:shellyrgbw2-white:662176:channel1#input, lightId=0
21-Mar-2020 00:32:02.140 [TRACE] [binding.shelly.internal.handler.ShellyLightHandler] - Colors loaded for lightId 0: RGBW=0/0/0/0, gain=0, brightness=1, color temp=0 (min=0, max=0
21-Mar-2020 00:32:02.522 [TRACE] [binding.shelly.internal.handler.ShellyLightHandler] - shellyrgbw2-662176: Execute command ON on channel shelly:shellyrgbw2-white:662176:channel1#input, lightId=0
21-Mar-2020 00:32:02.523 [TRACE] [binding.shelly.internal.handler.ShellyLightHandler] - Colors loaded for lightId 0: RGBW=0/0/0/0, gain=0, brightness=1, color temp=0 (min=0, max=0
21-Mar-2020 00:32:02.949 [TRACE] [binding.shelly.internal.handler.ShellyLightHandler] - shellyrgbw2-662176: Execute command OFF on channel shelly:shellyrgbw2-white:662176:channel1#input, lightId=0
21-Mar-2020 00:32:02.950 [TRACE] [binding.shelly.internal.handler.ShellyLightHandler] - Colors loaded for lightId 0: RGBW=0/0/0/0, gain=0, brightness=1, color temp=0 (min=0, max=0
my other problem is a delay, but that is only for the rollershutter.
like those 4 seconds
2020-03-20 23:28:26.912 [ome.event.ItemCommandEvent] - Item 'Livingroom_RollershutterCenter_Control' received command STOP
2020-03-20 23:28:30.686 [vent.ChannelTriggeredEvent] - shelly:shelly25-roller:686a85:roller#event triggered ROLLER_STOP
20-Mar-2020 23:28:24.380 [DEBUG] [.binding.shelly.internal.handler.ShellyBaseHandler] - shellyswitch25-686a85: Request settings refresh
20-Mar-2020 23:28:26.916 [DEBUG] [.binding.shelly.internal.handler.ShellyBaseHandler] - shellyswitch25-686a85: Refresh settings
20-Mar-2020 23:28:26.916 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shellyswitch25-686a85: HTTP GET for http://172.16.12.14/settings
20-Mar-2020 23:28:28.069 [DEBUG] [.binding.shelly.internal.handler.ShellyBaseHandler] - shellyswitch25-686a85: Refresh settings
20-Mar-2020 23:28:28.069 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shellyswitch25-686a85: HTTP GET for http://172.16.12.14/settings
20-Mar-2020 23:28:28.398 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shellyswitch25-686a85: HTTP response: {"device":{"type":"SHSW-25","mac":"2CF432686A85","hostname":"shellyswitch25-686A85","num_outputs":2, "num_meters":2, "num_rollers":1},"wifi_ap":{"enabled":false,"ssid":"shellyswitch25-686A85","key":""},"wifi_sta":{"enabled":true,"ssid":"IoT_DG_2G","ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"wifi_sta1":{"enabled":false,"ssid":null,"ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"mqtt": {"enable":false,"server":"10.0.1.2:1883","user":"","id":"Livingroom_RollershutterCenter","reconnect_timeout_max":60.000000,"reconnect_timeout_min":2.000000,"clean_session":false,"keep_alive":60,"max_qos":2,"retain":true,"update_period":30},"coiot": {"update_period":15},"sntp":{"server":"172.16.0.1","enabled":true},"login":{"enabled":false,"unprotected":false,"username":"admin","password":"admin"},"pin_code":"","name":"","fw":"20200309-104051/v1.6.0@43056d58","factory_reset_from_switch":true,"discoverable":true,"build_info":{"build_id":"20200309-104051/v1.6.0@43056d58","build_timestamp":"2020-03-09T10:40:51Z","build_version":"1.0"},"cloud":{"enabled":false,"connected":false},"timezone":"Europe/Berlin","lat":48.775398,"lng":9.181760,"tzautodetect":false,"tz_utc_offset":3600,"tz_dst":false,"tz_dst_auto":false,"time":"23:28","unixtime":1584746908,"hwinfo":{"hw_revision":"prod-2019-03", "batch_id":1},"mode":"roller","max_power":1840,"longpush_time":800,"relays":[{"name":null,"ison":false,"has_timer":false,"overpower":false,"default_state":"off","btn_type":"toggle","btn_reverse":0,"auto_on":0.00,"auto_off":0.00,"max_power":0,"btn_on_url":"http://10.0.10.254:8080/shelly/event/shellyswitch25-686a85/relay/0?type=btn_on","btn_off_url":"http://10.0.10.254:8080/shelly/event/shellyswitch25-686a85/relay/0?type=btn_off","out_on_url":"http://10.0.10.254:8080/shelly/event/shellyswitch25-686a85/relay/0?type=out_on","out_off_url":"http://10.0.10.254:8080/shelly/event/shellyswitch25-686a85/relay/0?type=out_off","longpush_url":null,"shortpush_url":null,"schedule":false,"schedule_rules":[]},{"name":null,"ison":false,"has_timer":false,"overpower":false,"default_state":"off","btn_type":"toggle","btn_reverse":0,"auto_on":0.00,"auto_off":0.00,"max_power":0,"btn_on_url":"http://10.0.10.254:8080/shelly/event/shellyswitch25-686a85/relay/1?type=btn_on","btn_off_url":"http://10.0.10.254:8080/shelly/event/shellyswitch25-686a85/relay/1?type=btn_off","out_on_url":"http://10.0.10.254:8080/shelly/event/shellyswitch25-686a85/relay/1?type=out_on","out_off_url":"http://10.0.10.254:8080/shelly/event/shellyswitch25-686a85/relay/1?type=out_off","longpush_url":null,"shortpush_url":null,"schedule":false,"schedule_rules":[]}],"rollers":[{"maxtime":20.00,"maxtime_open":60.00,"maxtime_close":60.00,"default_state":"stop","swap":false,"swap_inputs":false,"input_mode":"openclose","button_type":"detached","btn_reverse":0,"state":"open","power":131.00,"is_valid":true,"safety_switch":false,"roller_open_url":"http://10.0.1.2:8080/shelly/event/shellyswitch25-686a85/roller/0?type=roller_open","roller_close_url":"http://10.0.1.2:8080/shelly/event/shellyswitch25-686a85/roller/0?type=roller_close","roller_stop_url":"http://10.0.1.2:8080/shelly/event/shellyswitch25-686a85/roller/0?type=roller_stop","schedule":false,"schedule_rules":[],"obstacle_mode":"disabled","obstacle_action":"stop","obstacle_power":200,"obstacle_delay":1,"safety_mode":"while_opening","safety_action":"stop","safety_allowed_on_trigger":"none","off_power":2,"positioning":true}],"meters":[{"power":131.00,"is_valid":true,"timestamp":1584746908,"counters":[8.239, 0.000, 0.000],"total":8},{"power":0.00,"is_valid":true,"timestamp":1584746908,"counters":[4.589, 0.000, 0.000],"total":4}]}
20-Mar-2020 23:28:28.400 [DEBUG] [binding.shelly.internal.handler.ShellyRelayHandler] - shellyswitch25-686a85: Roller command/position STOP
20-Mar-2020 23:28:28.400 [DEBUG] [binding.shelly.internal.handler.ShellyRelayHandler] - shellyswitch25-686a85: Stop roller
20-Mar-2020 23:28:28.400 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shellyswitch25-686a85: HTTP GET for http://172.16.12.14/roller/0?go=stop
20-Mar-2020 23:28:29.567 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shellyswitch25-686a85: HTTP response: {"device":{"type":"SHSW-25","mac":"2CF432686A85","hostname":"shellyswitch25-686A85","num_outputs":2, "num_meters":2, "num_rollers":1},"wifi_ap":{"enabled":false,"ssid":"shellyswitch25-686A85","key":""},"wifi_sta":{"enabled":true,"ssid":"IoT_DG_2G","ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"wifi_sta1":{"enabled":false,"ssid":null,"ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"mqtt": {"enable":false,"server":"10.0.1.2:1883","user":"","id":"Livingroom_RollershutterCenter","reconnect_timeout_max":60.000000,"reconnect_timeout_min":2.000000,"clean_session":false,"keep_alive":60,"max_qos":2,"retain":true,"update_period":30},"coiot": {"update_period":15},"sntp":{"server":"172.16.0.1","enabled":true},"login":{"enabled":false,"unprotected":false,"username":"admin","password":"admin"},"pin_code":"","name":"","fw":"20200309-104051/v1.6.0@43056d58","factory_reset_from_switch":true,"discoverable":true,"build_info":{"build_id":"20200309-104051/v1.6.0@43056d58","build_timestamp":"2020-03-09T10:40:51Z","build_version":"1.0"},"cloud":{"enabled":false,"connected":false},"timezone":"Europe/Berlin","lat":48.775398,"lng":9.181760,"tzautodetect":false,"tz_utc_offset":3600,"tz_dst":false,"tz_dst_auto":false,"time":"23:28","unixtime":1584746909,"hwinfo":{"hw_revision":"prod-2019-03", "batch_id":1},"mode":"roller","max_power":1840,"longpush_time":800,"relays":[{"name":null,"ison":false,"has_timer":false,"overpower":false,"default_state":"off","btn_type":"toggle","btn_reverse":0,"auto_on":0.00,"auto_off":0.00,"max_power":0,"btn_on_url":"http://10.0.10.254:8080/shelly/event/shellyswitch25-686a85/relay/0?type=btn_on","btn_off_url":"http://10.0.10.254:8080/shelly/event/shellyswitch25-686a85/relay/0?type=btn_off","out_on_url":"http://10.0.10.254:8080/shelly/event/shellyswitch25-686a85/relay/0?type=out_on","out_off_url":"http://10.0.10.254:8080/shelly/event/shellyswitch25-686a85/relay/0?type=out_off","longpush_url":null,"shortpush_url":null,"schedule":false,"schedule_rules":[]},{"name":null,"ison":false,"has_timer":false,"overpower":false,"default_state":"off","btn_type":"toggle","btn_reverse":0,"auto_on":0.00,"auto_off":0.00,"max_power":0,"btn_on_url":"http://10.0.10.254:8080/shelly/event/shellyswitch25-686a85/relay/1?type=btn_on","btn_off_url":"http://10.0.10.254:8080/shelly/event/shellyswitch25-686a85/relay/1?type=btn_off","out_on_url":"http://10.0.10.254:8080/shelly/event/shellyswitch25-686a85/relay/1?type=out_on","out_off_url":"http://10.0.10.254:8080/shelly/event/shellyswitch25-686a85/relay/1?type=out_off","longpush_url":null,"shortpush_url":null,"schedule":false,"schedule_rules":[]}],"rollers":[{"maxtime":20.00,"maxtime_open":60.00,"maxtime_close":60.00,"default_state":"stop","swap":false,"swap_inputs":false,"input_mode":"openclose","button_type":"detached","btn_reverse":0,"state":"open","power":130.31,"is_valid":true,"safety_switch":false,"roller_open_url":"http://10.0.1.2:8080/shelly/event/shellyswitch25-686a85/roller/0?type=roller_open","roller_close_url":"http://10.0.1.2:8080/shelly/event/shellyswitch25-686a85/roller/0?type=roller_close","roller_stop_url":"http://10.0.1.2:8080/shelly/event/shellyswitch25-686a85/roller/0?type=roller_stop","schedule":false,"schedule_rules":[],"obstacle_mode":"disabled","obstacle_action":"stop","obstacle_power":200,"obstacle_delay":1,"safety_mode":"while_opening","safety_action":"stop","safety_allowed_on_trigger":"none","off_power":2,"positioning":true}],"meters":[{"power":130.31,"is_valid":true,"timestamp":1584746909,"counters":[8.239, 0.000, 0.000],"total":8},{"power":0.00,"is_valid":true,"timestamp":1584746909,"counters":[4.589, 0.000, 0.000],"total":4}]}
20-Mar-2020 23:28:29.568 [TRACE] [.binding.shelly.internal.handler.ShellyBaseHandler] - shellyswitch25-686a85: Updating status
20-Mar-2020 23:28:29.568 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shellyswitch25-686a85: HTTP GET for http://172.16.12.14/status
20-Mar-2020 23:28:30.608 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shellyswitch25-686a85: HTTP response: {"state":"stop","power":0.00,"is_valid":true,"safety_switch":false,"overtemperature":false,"stop_reason":"normal","last_direction":"open","current_pos":21,"calibrating":false,"positioning":true}
20-Mar-2020 23:28:30.685 [DEBUG] [hab.binding.shelly.internal.api.ShellyEventServlet] - CallbackServlet: HTTP/1.1 Request from 172.16.12.14:65466/shelly/event/shellyswitch25-686a85/roller/0?{type=[roller_stop]}
20-Mar-2020 23:28:30.686 [TRACE] [hab.binding.shelly.internal.api.ShellyEventServlet] - Process event of type type=roller for device shellyswitch25-686a85, index=0
20-Mar-2020 23:28:30.686 [TRACE] [enhab.binding.shelly.internal.ShellyHandlerFactory] - Dispatch event to device handler shellyswitch25-686a85
20-Mar-2020 23:28:30.686 [DEBUG] [.binding.shelly.internal.handler.ShellyBaseHandler] - shellyswitch25-686a85: Event received: class=roller, index=0, parameters={type=roller_stop}
20-Mar-2020 23:28:30.686 [DEBUG] [.binding.shelly.internal.handler.ShellyBaseHandler] - shellyswitch25-686a85: Post event ROLLER_STOP
20-Mar-2020 23:28:30.686 [DEBUG] [.binding.shelly.internal.handler.ShellyBaseHandler] - shellyswitch25-686a85: Request settings refresh
I can replicate a API-Timeout just by commanding up/down/stop while in this delay.
21-Mar-2020 00:49:22.930 [TRACE] [.binding.shelly.internal.handler.ShellyBaseHandler] - shellyrgbw2-b0e159: Updating status
21-Mar-2020 00:49:22.930 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shellyrgbw2-b0e159: HTTP GET for http://172.16.12.34/status
21-Mar-2020 00:49:22.945 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shelly1pm-b1d493: HTTP response: {"device":{"type":"SHSW-PM","mac":"840D8EB1D493","hostname":"shelly1pm-B1D493","num_outputs":1,"num_meters":1},"wifi_ap":{"enabled":false,"ssid":"shelly1pm-B1D493","key":""},"wifi_sta":{"enabled":true,"ssid":"IoT_UG_2G","ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"wifi_sta1":{"enabled":false,"ssid":null,"ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"mqtt": {"enable":false,"server":"10.0.1.2:1883","user":"","id":"Basement_Switch_Door","reconnect_timeout_max":60.000000,"reconnect_timeout_min":2.000000,"clean_session":false,"keep_alive":60,"max_qos":2,"retain":true,"update_period":30},"coiot": {"update_period":15},"sntp":{"server":"172.16.0.1","enabled":true},"login":{"enabled":false,"unprotected":false,"username":"admin","password":"admin"},"pin_code":"","name":"","fw":"20200312-124223/v1.6.1@112262fd","factory_reset_from_switch":true,"discoverable":true,"build_info":{"build_id":"20200312-124223/v1.6.1@112262fd","build_timestamp":"2020-03-12T12:42:23Z","build_version":"1.0"},"cloud":{"enabled":false,"connected":false},"timezone":"Europe/Berlin","lat":48.775398,"lng":9.181760,"tzautodetect":true,"tz_utc_offset":3600,"tz_dst":false,"tz_dst_auto":true,"time":"00:49","unixtime":1584751762,"hwinfo":{"hw_revision":"prod-190329", "batch_id":1},"max_power":3500,"power_correction":1.00,"mode" :"relay","longpush_time":800,"relays":[{"name":null,"ison":false,"has_timer":false,"default_state":"on","btn_type":"toggle","btn_reverse":1,"auto_on":0.00,"auto_off":0.00,"btn_on_url":null,"btn_off_url":null,"out_on_url":"http://10.0.1.2:8080/shelly/event/shelly1pm-b1d493/relay/0?type=out_on","out_off_url":"http://10.0.1.2:8080/shelly/event/shelly1pm-b1d493/relay/0?type=out_off","longpush_url":"http://10.0.1.2:8080/shelly/event/shelly1pm-b1d493/relay/0?type=longpush","shortpush_url":"http://10.0.1.2:8080/shelly/event/shelly1pm-b1d493/relay/0?type=shortpush","schedule":false,"schedule_rules":[],"max_power":3500}],"meters":[{"power":0.00,"is_valid":true,"timestamp":1584751762,"counters":[0.000, 0.000, 0.000],"total":0}],"ext_sensors":{},"ext_temperature":[],"ext_humidity":[]}
21-Mar-2020 00:49:22.946 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shelly1pm-b1daea: HTTP response: {"device":{"type":"SHSW-PM","mac":"840D8EB1DAEA","hostname":"shelly1pm-B1DAEA","num_outputs":1,"num_meters":1},"wifi_ap":{"enabled":false,"ssid":"shelly1pm-B1DAEA","key":""},"wifi_sta":{"enabled":true,"ssid":"IoT_OG_2G","ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"wifi_sta1":{"enabled":false,"ssid":null,"ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"mqtt": {"enable":false,"server":"10.0.1.2:1883","user":"","id":"shelly1pm-B1DAEA","reconnect_timeout_max":60.000000,"reconnect_timeout_min":2.000000,"clean_session":true,"keep_alive":60,"max_qos":0,"retain":true,"update_period":30},"coiot": {"update_period":15},"sntp":{"server":"172.16.0.1","enabled":true},"login":{"enabled":false,"unprotected":false,"username":"admin","password":"admin"},"pin_code":"","name":"","fw":"20200312-124223/v1.6.1@112262fd","factory_reset_from_switch":true,"discoverable":true,"build_info":{"build_id":"20200312-124223/v1.6.1@112262fd","build_timestamp":"2020-03-12T12:42:23Z","build_version":"1.0"},"cloud":{"enabled":false,"connected":false},"timezone":"Europe/Berlin","lat":48.775398,"lng":9.181760,"tzautodetect":false,"tz_utc_offset":3600,"tz_dst":false,"tz_dst_auto":false,"time":"00:49","unixtime":1584751763,"hwinfo":{"hw_revision":"prod-190329", "batch_id":1},"max_power":3500,"power_correction":1.00,"mode" :"relay","longpush_time":800,"relays":[{"name":null,"ison":false,"has_timer":false,"default_state":"last","btn_type":"toggle","btn_reverse":0,"auto_on":0.00,"auto_off":0.00,"btn_on_url":null,"btn_off_url":null,"out_on_url":"http://10.0.1.2:8080/shelly/event/shelly1pm-b1daea/relay/0?type=out_on","out_off_url":"http://10.0.1.2:8080/shelly/event/shelly1pm-b1daea/relay/0?type=out_off","longpush_url":"http://10.0.1.2:8080/shelly/event/shelly1pm-b1daea/relay/0?type=longpush","shortpush_url":"http://10.0.1.2:8080/shelly/event/shelly1pm-b1daea/relay/0?type=shortpush","schedule":false,"schedule_rules":[],"max_power":3500}],"meters":[{"power":0.00,"is_valid":true,"timestamp":1584751763,"counters":[0.000, 0.000, 0.000],"total":0}],"ext_sensors":{},"ext_temperature":[],"ext_humidity":[]}
21-Mar-2020 00:49:22.947 [TRACE] [.binding.shelly.internal.handler.ShellyBaseHandler] - shelly1pm-b1d493: Updating status
21-Mar-2020 00:49:22.947 [TRACE] [.binding.shelly.internal.handler.ShellyBaseHandler] - shelly1pm-b1daea: Updating status
21-Mar-2020 00:49:22.947 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shelly1pm-b1daea: HTTP GET for http://172.16.12.11/status
21-Mar-2020 00:49:22.947 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shelly1pm-b1d493: HTTP GET for http://172.16.12.32/status
21-Mar-2020 00:49:23.004 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shellyrgbw2-b0e159: HTTP response: {"wifi_sta":{"connected":true,"ssid":"IoT_OG_2G","ip":"172.16.12.34","rssi":-54},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"00:49","unixtime":1584751764,"serial":1,"has_update":false,"mac":"500291B0E159","mode":"color","input":0,"lights":[{"ison":true,"has_timer":false,"timer_remaining":0,"mode":"color","red":25,"green":0,"blue":0,"white":0,"gain":1,"effect":0,"power":0.46,"overpower":false}],"meters":[{"power":0.46,"is_valid":true}],"update":{"status":"idle","has_update":false,"new_version":"20200309-104453/v1.6.0@43056d58","old_version":"20200309-104453/v1.6.0@43056d58"},"ram_total":49744,"ram_free":37724,"fs_size":233681,"fs_free":155369,"uptime":6096}
21-Mar-2020 00:49:23.004 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shellyrgbw2-b0e159: HTTP GET for http://172.16.12.34/status
21-Mar-2020 00:49:23.005 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shellyplug-s-0419fa: HTTP response: {"wifi_sta":{"connected":true,"ssid":"IoT_DG_2G","ip":"172.16.12.38","rssi":-78},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"00:49","unixtime":1584751764,"serial":1,"has_update":false,"mac":"4C11AE0419FA","relays":[{"ison":true,"has_timer":false,"timer_remaining":0,"overpower":false}],"meters":[{"power":111.93,"is_valid":true,"timestamp":1584751764,"counters":[67.048, 67.761, 73.078],"total":6353}],"temperature":36.11,"overtemperature":false,"tmp":{"tC":36.11,"tF":96.99, "is_valid":"true"},"update":{"status":"idle","has_update":false,"new_version":"20200309-104506/v1.6.0@43056d58","old_version":"20200309-104506/v1.6.0@43056d58"},"ram_total":50608,"ram_free":39724,"fs_size":233681,"fs_free":167417,"uptime":5878}
21-Mar-2020 00:49:23.005 [TRACE] [binding.shelly.internal.handler.ShellyRelayHandler] - shellyplug-s-0419fa: Updating 1 relay(s)
21-Mar-2020 00:49:23.006 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shellyplug-s-0419fa: HTTP GET for http://172.16.12.38/status/relay/0
21-Mar-2020 00:49:23.026 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shelly1pm-b1daea: HTTP response: {"wifi_sta":{"connected":true,"ssid":"IoT_OG_2G","ip":"172.16.12.11","rssi":-66},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":true},"time":"00:49","unixtime":1584751763,"serial":1,"has_update":false,"mac":"840D8EB1DAEA","relays" :[{"ison":false, "has_timer":false, "timer_remaining":0, "overpower":false}],"meters":[{"power":0.00,"is_valid":true,"timestamp":1584751763,"counters":[0.000, 0.000, 0.000],"total":0}],"inputs":[{"input":0}],"ext_sensors":{},"ext_temperature":{},"ext_humidity":{},"temperature":44.34,"overtemperature":false,"tmp":{"tC":44.34,"tF":111.82, "is_valid":"true"},"update":{"status":"idle","has_update":false,"new_version":"20200312-124223/v1.6.1@112262fd","old_version":"20200312-124223/v1.6.1@112262fd"},"ram_total":50328,"ram_free":38928,"fs_size":233681,"fs_free":151855,"uptime":6999}
21-Mar-2020 00:49:23.026 [TRACE] [binding.shelly.internal.handler.ShellyRelayHandler] - shelly1pm-b1daea: Updating 1 relay(s)
21-Mar-2020 00:49:23.026 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shelly1pm-b1daea: HTTP GET for http://172.16.12.11/status/relay/0
21-Mar-2020 00:49:23.027 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shelly1pm-b1d493: HTTP response: {"wifi_sta":{"connected":true,"ssid":"IoT_UG_2G","ip":"172.16.12.32","rssi":-82},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":true},"time":"00:49","unixtime":1584751762,"serial":1,"has_update":false,"mac":"840D8EB1D493","relays" :[{"ison":false, "has_timer":false, "timer_remaining":0, "overpower":false}],"meters":[{"power":0.00,"is_valid":true,"timestamp":1584751762,"counters":[0.000, 0.000, 0.000],"total":0}],"inputs":[{"input":0}],"ext_sensors":{},"ext_temperature":{},"ext_humidity":{},"temperature":36.34,"overtemperature":false,"tmp":{"tC":36.34,"tF":97.41, "is_valid":"true"},"update":{"status":"idle","has_update":false,"new_version":"20200312-124223/v1.6.1@112262fd","old_version":"20200312-124223/v1.6.1@112262fd"},"ram_total":50328,"ram_free":38704,"fs_size":233681,"fs_free":151855,"uptime":91977}
21-Mar-2020 00:49:23.027 [TRACE] [binding.shelly.internal.handler.ShellyRelayHandler] - shelly1pm-b1d493: Updating 1 relay(s)
21-Mar-2020 00:49:23.027 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shelly1pm-b1d493: HTTP GET for http://172.16.12.32/status/relay/0
21-Mar-2020 00:49:23.087 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shellyrgbw2-b0e159: HTTP response: {"wifi_sta":{"connected":true,"ssid":"IoT_OG_2G","ip":"172.16.12.34","rssi":-54},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"00:49","unixtime":1584751764,"serial":1,"has_update":false,"mac":"500291B0E159","mode":"color","input":0,"lights":[{"ison":true,"has_timer":false,"timer_remaining":0,"mode":"color","red":25,"green":0,"blue":0,"white":0,"gain":1,"effect":0,"power":0.46,"overpower":false}],"meters":[{"power":0.46,"is_valid":true}],"update":{"status":"idle","has_update":false,"new_version":"20200309-104453/v1.6.0@43056d58","old_version":"20200309-104453/v1.6.0@43056d58"},"ram_total":49744,"ram_free":37556,"fs_size":233681,"fs_free":155369,"uptime":6097}
21-Mar-2020 00:49:23.088 [TRACE] [binding.shelly.internal.handler.ShellyLightHandler] - Updating light status for shellyrgbw2-b0e159, in color mode, 1 channel(s)
21-Mar-2020 00:49:23.088 [TRACE] [binding.shelly.internal.handler.ShellyLightHandler] - Updating lightId 0/1
21-Mar-2020 00:49:23.088 [TRACE] [binding.shelly.internal.handler.ShellyLightHandler] - Updating light channels shellyrgbw2-b0e159.control (mode=color)
21-Mar-2020 00:49:23.088 [TRACE] [binding.shelly.internal.handler.ShellyLightHandler] - Colors entry created for lightId 0
21-Mar-2020 00:49:23.088 [TRACE] [.binding.shelly.internal.handler.ShellyBaseHandler] - shellyrgbw2-b0e159: Updating input with 0
21-Mar-2020 00:49:23.089 [TRACE] [binding.shelly.internal.handler.ShellyLightHandler] - update color settings
21-Mar-2020 00:49:23.089 [TRACE] [binding.shelly.internal.handler.ShellyLightHandler] - Update channels for color: RGBW=25/0/0, in %:10%/0%/0%, white=0%, gain=1%
21-Mar-2020 00:49:23.089 [TRACE] [binding.shelly.internal.handler.ShellyLightHandler] - update color.color picker
21-Mar-2020 00:49:23.089 [TRACE] [.binding.shelly.internal.handler.ShellyBaseHandler] - shellyrgbw2-b0e159: Updating 1 standard meter(s)
21-Mar-2020 00:49:23.090 [DEBUG] [.binding.shelly.internal.handler.ShellyBaseHandler] - shellyrgbw2-b0e159: Channel device#uptime updated with 6096 s (type class org.eclipse.smarthome.core.library.types.QuantityType).
21-Mar-2020 00:49:23.092 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shellyplug-s-0419fa: HTTP response: {"wifi_sta":{"connected":true,"ssid":"IoT_DG_2G","ip":"172.16.12.38","rssi":-78},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"00:49","unixtime":1584751764,"serial":1,"has_update":false,"mac":"4C11AE0419FA","relays":[{"ison":true,"has_timer":false,"timer_remaining":0,"overpower":false}],"meters":[{"power":111.93,"is_valid":true,"timestamp":1584751764,"counters":[67.048, 67.761, 73.078],"total":6353}],"temperature":36.11,"overtemperature":false,"tmp":{"tC":36.11,"tF":96.99, "is_valid":"true"},"update":{"status":"idle","has_update":false,"new_version":"20200309-104506/v1.6.0@43056d58","old_version":"20200309-104506/v1.6.0@43056d58"},"ram_total":50608,"ram_free":39544,"fs_size":233681,"fs_free":167417,"uptime":5878}
21-Mar-2020 00:49:23.093 [DEBUG] [binding.shelly.internal.handler.ShellyRelayHandler] - shellyplug-s-0419fa: LED disabled status: powerLed: false, : statusLedtrue
21-Mar-2020 00:49:23.093 [TRACE] [.binding.shelly.internal.handler.ShellyBaseHandler] - shellyplug-s-0419fa: Updating 1 standard meter(s)
21-Mar-2020 00:49:23.093 [DEBUG] [.binding.shelly.internal.handler.ShellyBaseHandler] - shellyplug-s-0419fa: Channel meter#currentWatts updated with 111.930 W (type class org.eclipse.smarthome.core.library.types.QuantityType).
21-Mar-2020 00:49:23.094 [DEBUG] [.binding.shelly.internal.handler.ShellyBaseHandler] - shellyplug-s-0419fa: Channel meter#totalKWH updated with 0.1059 kWh (type class org.eclipse.smarthome.core.library.types.QuantityType).
21-Mar-2020 00:49:23.095 [DEBUG] [.binding.shelly.internal.handler.ShellyBaseHandler] - shellyplug-s-0419fa: Channel meter#lastPower1 updated with 67.048 W (type class org.eclipse.smarthome.core.library.types.QuantityType).
21-Mar-2020 00:49:23.095 [DEBUG] [.binding.shelly.internal.handler.ShellyBaseHandler] - shellyplug-s-0419fa: Channel meter#lastPower2 updated with 67.761 W (type class org.eclipse.smarthome.core.library.types.QuantityType).
21-Mar-2020 00:49:23.096 [DEBUG] [.binding.shelly.internal.handler.ShellyBaseHandler] - shellyplug-s-0419fa: Channel meter#lastPower3 updated with 73.078 W (type class org.eclipse.smarthome.core.library.types.QuantityType).
21-Mar-2020 00:49:23.096 [DEBUG] [.binding.shelly.internal.handler.ShellyBaseHandler] - shellyplug-s-0419fa: Channel meter#lastUpdate updated with 2020-03-21T00:49:24.000+0100 (type class org.eclipse.smarthome.core.library.types.DateTimeType).
21-Mar-2020 00:49:23.096 [DEBUG] [.binding.shelly.internal.handler.ShellyBaseHandler] - shellyplug-s-0419fa: Channel device#uptime updated with 5878 s (type class org.eclipse.smarthome.core.library.types.QuantityType).
21-Mar-2020 00:49:23.097 [DEBUG] [.binding.shelly.internal.handler.ShellyBaseHandler] - shellyplug-s-0419fa: Channel device#wifiSignal updated with 2 (type class org.eclipse.smarthome.core.library.types.DecimalType).
21-Mar-2020 00:49:23.102 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shelly1pm-b1daea: HTTP response: {"wifi_sta":{"connected":true,"ssid":"IoT_OG_2G","ip":"172.16.12.11","rssi":-66},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":true},"time":"00:49","unixtime":1584751763,"serial":1,"has_update":false,"mac":"840D8EB1DAEA","relays" :[{"ison":false, "has_timer":false, "timer_remaining":0, "overpower":false}],"meters":[{"power":0.00,"is_valid":true,"timestamp":1584751763,"counters":[0.000, 0.000, 0.000],"total":0}],"inputs":[{"input":0}],"ext_sensors":{},"ext_temperature":{},"ext_humidity":{},"temperature":44.34,"overtemperature":false,"tmp":{"tC":44.34,"tF":111.82, "is_valid":"true"},"update":{"status":"idle","has_update":false,"new_version":"20200312-124223/v1.6.1@112262fd","old_version":"20200312-124223/v1.6.1@112262fd"},"ram_total":50328,"ram_free":38912,"fs_size":233681,"fs_free":151855,"uptime":6999}
21-Mar-2020 00:49:23.102 [DEBUG] [binding.shelly.internal.handler.ShellyRelayHandler] - shelly1pm-b1daea: Updating external sensors
21-Mar-2020 00:49:23.102 [TRACE] [.binding.shelly.internal.handler.ShellyBaseHandler] - shelly1pm-b1daea: Updating input[0] with OFF
21-Mar-2020 00:49:23.102 [TRACE] [.binding.shelly.internal.handler.ShellyBaseHandler] - shelly1pm-b1daea: Updating 1 standard meter(s)
21-Mar-2020 00:49:23.103 [DEBUG] [.binding.shelly.internal.handler.ShellyBaseHandler] - shelly1pm-b1daea: Channel meter#lastUpdate updated with 2020-03-21T00:49:23.000+0100 (type class org.eclipse.smarthome.core.library.types.DateTimeType).
21-Mar-2020 00:49:23.103 [DEBUG] [.binding.shelly.internal.handler.ShellyBaseHandler] - shelly1pm-b1daea: Channel device#uptime updated with 6999 s (type class org.eclipse.smarthome.core.library.types.QuantityType).
21-Mar-2020 00:49:23.108 [TRACE] [.openhab.binding.shelly.internal.api.ShellyHttpApi] - shelly1pm-b1d493: HTTP response: {"wifi_sta":{"connected":true,"ssid":"IoT_UG_2G","ip":"172.16.12.32","rssi":-82},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":true},"time":"00:49","unixtime":1584751762,"serial":1,"has_update":false,"mac":"840D8EB1D493","relays" :[{"ison":false, "has_timer":false, "timer_remaining":0, "overpower":false}],"meters":[{"power":0.00,"is_valid":true,"timestamp":1584751763,"counters":[0.000, 0.000, 0.000],"total":0}],"inputs":[{"input":0}],"ext_sensors":{},"ext_temperature":{},"ext_humidity":{},"temperature":36.34,"overtemperature":false,"tmp":{"tC":36.34,"tF":97.41, "is_valid":"true"},"update":{"status":"idle","has_update":false,"new_version":"20200312-124223/v1.6.1@112262fd","old_version":"20200312-124223/v1.6.1@112262fd"},"ram_total":50328,"ram_free":38392,"fs_size":233681,"fs_free":151855,"uptime":91977}
21-Mar-2020 00:49:23.109 [DEBUG] [binding.shelly.internal.handler.ShellyRelayHandler] - shelly1pm-b1d493: Updating external sensors
21-Mar-2020 00:49:23.109 [TRACE] [.binding.shelly.internal.handler.ShellyBaseHandler] - shelly1pm-b1d493: Updating input[0] with OFF
21-Mar-2020 00:49:23.109 [TRACE] [.binding.shelly.internal.handler.ShellyBaseHandler] - shelly1pm-b1d493: Updating 1 standard meter(s)
21-Mar-2020 00:49:23.109 [DEBUG] [.binding.shelly.internal.handler.ShellyBaseHandler] - shelly1pm-b1d493: Channel meter#lastUpdate updated with 2020-03-21T00:49:22.000+0100 (type class org.eclipse.smarthome.core.library.types.DateTimeType).
21-Mar-2020 00:49:23.109 [DEBUG] [.binding.shelly.internal.handler.ShellyBaseHandler] - shelly1pm-b1d493: Channel device#uptime updated with 91977 s (type class org.eclipse.smarthome.core.library.types.QuantityType).
21-Mar-2020 00:49:23.763 [DEBUG] [.binding.shelly.internal.handler.ShellyBaseHandler] - shellyswitch25-686a85: Device is not reachable, update canceled (20 skips, 1 scheduledUpdates)!
21-Mar-2020 00:49:23.765 [TRACE] [.binding.shelly.internal.handler.ShellyBaseHandler] - shellyswitch25-686a85: 0 more updates requested
21-Mar-2020 00:49:23.765 [INFO ] [.binding.shelly.internal.handler.ShellyBaseHandler] - shellyswitch25-686a85 ERROR: Unable to process command for channel shelly:shelly25-roller:686a85:roller#control: EXCEPTION: Unable to get settings from device with IP 172.16.12.14: Shelly API error: Empty response, Timeout? (IOException), uri=/settings (class java.io.IOException)
Stack Trace: [Ljava.lang.StackTraceElement;@11d6fbf
21-Mar-2020 00:49:23.770 [DEBUG] [binding.shelly.internal.handler.ShellyRelayHandler] - shellyswitch25-686a85: Roller command/position DOWN