Shelly Binding

Matthias_Marx · September 16, 2020, 10:29am

Hello @ll,

sorry but I need your help. In my setup I am using a Shelly 1 for a while without issues. Today I have added a Shelly Dimmer to this setup. It is reachable in my home network and the control looks good. But the OH integration stucks.

I have already updated to OH 2.5.8 stable and re-added the shelly dimmer thing again and again but it still stucks in the UNKNOWN Status. It also doesn’t change the status if I trigger some events. Also the control from OH to the shelly is not working.

The log shows me a Handler_Missing Error. I also tried with deactivated CoIoT Events but this still has no effect.

Is there anything else I can do or share to fix this issue?

Matthias_Marx · September 16, 2020, 12:45pm

I uninstalled the Shelly binding and now it seems to work.

daspid92 · September 16, 2020, 8:25pm

I’ve waited to reply because I was planning to move the network to UniFi, today I’ve relplaced my TP-LINK (Archer C8 + Extender) with UniFi, CoAP seems to work perfectly now!
I’ve previously checked on the old router for any settings regarding multicast but I haven’t found anything so probably this was a bug of it’s firmware…
Thank you very much for the support and for the binding!

stuetzomat · September 18, 2020, 1:03pm

@markus7017, with the latest DEV build everything works fine now.
Thanks for your effort!

markus7017 · September 18, 2020, 1:20pm

markus7017 · September 18, 2020, 9:22pm

fyi: Just today I received a sample of the Shelly Plug US.

Will be discovered by the current version as Shelly Plug and works
I added specific device profile and created a PR, but don’t expect to get that into 2.5.9, which is release at the weekend

For now it works with the current release. Nevertheless I updated the DEV build.

markus7017 · September 19, 2020, 9:15am

fyi: Just today I received a sample of the Shelly Plug US.

Will be discovered by the current version as Shelly Plug and works
I added specific device profile

Most likely this will not ho into the 2.5.9, because it works in general with the existing release and it’s no so important. Nevertheless I updated the DEV build.

Baschtlwaschtl · September 20, 2020, 2:39pm

Hi, I’m new to openhab and Shelly.
I got the Shelly bulb duo and Shelly i3 working.
But the Shelly i3 reacts really slow.
Openhab control of the bulb is Realtime.
if I push the switch the i3 reacts in ca 3 seconds. (I see this in the Shelly app.)
The command for the bulb in openhab comes ca 10 seconds later. This is not good for a light switch.
What can I do?
The bulb react in Realtime with openhab Manual mode

markus7017 · September 20, 2020, 3:11pm

You should see reaction times < 1-3sec. Do you have the latest DEV build and firmware on the device (1.8.3/1.8.2)?

Baschtlwaschtl · September 20, 2020, 3:48pm

Yes, latest firmware and 2.5.9 snapshot.
my rule trigger is Ereigniszähler and I’m reading the last state (S, SS, L, etc)
with this information I decide in if else what to do…
Greets

markus7017 · September 20, 2020, 4:45pm

please provide a DEBUG log
are talking about Button 1?

Baschtlwaschtl · September 20, 2020, 5:47pm

Shelly i3. First input.
how do I make this log?
I found event.log and openhab.log

You are German, right? Can we talk pn?

Edit: I think I found the debug log option. I’ll get back to you if I have the log.

Baschtlwaschtl · September 20, 2020, 7:45pm

If set log to debug for Shelly binding.

2020-09-20 21:30:26.285 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel status1#lastEvent updated with SS (type class org.eclipse.smarthome.core.library.types.StringType).
2020-09-20 21:30:26.286 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel status1#eventCount updated with 177 (type class org.eclipse.smarthome.core.library.types.DecimalType).
2020-09-20 21:30:26.286 [INFO ] [clipse.smarthome.model.script.rule#1] - var zustand = SS
2020-09-20 21:30:26.287 [INFO ] [clipse.smarthome.model.script.rule#1] - var helligkeit = 0
2020-09-20 21:30:26.293 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Set brightness to 100.0%/100
2020-09-20 21:30:26.293 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Changing brightness from 50 to 100
2020-09-20 21:30:26.294 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Setting brightness to 100
2020-09-20 21:30:26.294 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Send light settings: {brightness=100, turn=on}
2020-09-20 21:30:26.354 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Colors updated for lightId 0: RGBW=0/0/0/0, Sat/Gain=0, Bright=100, Temp=3840 
2020-09-20 21:30:26.358 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Set color temp to 60.0%
2020-09-20 21:30:26.358 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Converted color-temp 0.6% to 4980K (from Percent to Integer)
2020-09-20 21:30:26.359 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Setting color temp to 4980
2020-09-20 21:30:26.359 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Send light settings: {temp=4980}
2020-09-20 21:30:26.415 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Colors updated for lightId 0: RGBW=0/0/0/0, Sat/Gain=0, Bright=-1, Temp=4980 
2020-09-20 21:30:41.549 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel status1#lastEvent updated with S (type class org.eclipse.smarthome.core.library.types.StringType).
2020-09-20 21:30:41.550 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel status1#eventCount updated with 178 (type class org.eclipse.smarthome.core.library.types.DecimalType).
2020-09-20 21:30:41.551 [INFO ] [clipse.smarthome.model.script.rule#1] - var zustand = S
2020-09-20 21:30:41.551 [INFO ] [clipse.smarthome.model.script.rule#1] - var helligkeit = 100
2020-09-20 21:30:41.555 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Set brightness to 0.0%/0
2020-09-20 21:30:41.556 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Brightness=0 -> switch light OFF
2020-09-20 21:30:50.714 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellybulbduo-7e83378b: Channel white#temperature updated with 61 (type class org.eclipse.smarthome.core.library.types.PercentType).
2020-09-20 21:30:56.812 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel status1#eventCount updated with 179 (type class org.eclipse.smarthome.core.library.types.DecimalType).
2020-09-20 21:30:56.813 [INFO ] [clipse.smarthome.model.script.rule#1] - var zustand = S
2020-09-20 21:30:56.813 [INFO ] [clipse.smarthome.model.script.rule#1] - var helligkeit = 0
2020-09-20 21:30:56.817 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Set brightness to 40.0%/40
2020-09-20 21:30:56.818 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Changing brightness from 100 to 40
2020-09-20 21:30:56.818 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Setting brightness to 40
2020-09-20 21:30:56.818 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Send light settings: {brightness=40, turn=on}
2020-09-20 21:30:56.857 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Colors updated for lightId 0: RGBW=0/0/0/0, Sat/Gain=0, Bright=40, Temp=5000 
2020-09-20 21:30:56.859 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Set color temp to 30.0%
2020-09-20 21:30:56.859 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Converted color-temp 0.3% to 3840K (from Percent to Integer)
2020-09-20 21:30:56.859 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Setting color temp to 3840
2020-09-20 21:30:56.859 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Send light settings: {temp=3840}
2020-09-20 21:30:56.901 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Colors updated for lightId 0: RGBW=0/0/0/0, Sat/Gain=0, Bright=-1, Temp=3840 
2020-09-20 21:31:27.301 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel status1#eventCount updated with 180 (type class org.eclipse.smarthome.core.library.types.DecimalType).
2020-09-20 21:31:27.302 [INFO ] [clipse.smarthome.model.script.rule#1] - var zustand = S
2020-09-20 21:31:27.302 [INFO ] [clipse.smarthome.model.script.rule#1] - var helligkeit = 40
2020-09-20 21:31:27.306 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Set brightness to 0.0%/0
2020-09-20 21:31:27.306 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-7e83378b: Brightness=0 -> switch light OFF
2020-09-20 21:31:51.390 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellybulbduo-7e83378b: Channel white#temperature updated with 30 (type class org.eclipse.smarthome.core.library.types.PercentType).

Is this okay?

Edit:
Am I using a false trigger? Which should I use?

AndreNewman · September 21, 2020, 9:33am

Hi, I’ve just added a Shelly EM to my network yesterday, had some issues getting updates from it but reading this thread and then I saw the 2.5.9 release yesterday, installed that this morning and all is working well.

One remaining question, the EM reports reactive watts instead of power factor, while that’s a simple calculation I wonder why the shelly em web interface shows PF and not reactive watts? I also see that the em3 has a channel for power factor in the definition but the em does not?

Is it just a case of the channels defined, if so can I change the thing in PaperUI to collect PF instead of or as well as reactive watts? I’d rather the em did the calculation, that way it’s sure to be using the readings at the same moment.

Appreciate the effort in this binding works really well here.

HarryS1 · September 21, 2020, 11:00am

Hello,

I had the Shelly SNAPSHOT developer version installed in automation:
californium-core-2.0.0.jar
element-connector-2.0.0.jar
org.openhab.binding.shelly-2.5.8-SNAPSHOT.jar

Today I upgraded to OH 2.5.9 and found the updated Shelly binding included. So I removed the above files and restarted OH.

As Shelly items were not updated afterwards, I checked the bundle status in Karaf. This is what I get:
openhab> bundle:list|grep Shelly
262 │ Installed │ 80 │ 2.5.9 │ openHAB Add-ons :: Bundles :: Shelly Binding

So the binding is here but not Active. The reason for this is:
openhab> bundle:start 262
Error executing command: Error executing command on bundles:
Error starting bundle 262: Could not resolve module: org.openhab.binding.shelly [262]
Unresolved requirement: Import-Package: org.eclipse.californium.core; version="[2.0.0,3.0.0)"

So it looks like the dependency to Californium resolved by the SNAPSHOT jar before is missing for the release version. I assume the binding install in incomplete now. Any quick fix for this or do I need to uninstall and reinstall the binding? Are things defined in PaperUI wiped in case I do this?

HarryS1 · September 21, 2020, 11:16am

O.k., couldn’t wait.

Uninstalled the binding and installed it again. Things were preserved, everything’s fine.

markus7017 · September 22, 2020, 6:33am

hmm, I don‘t see any CoAP events. They are reported bear realtime and that explains the slow response.

Please make sure that AutoCoIOT ist enabled in the binding config or CoIOT Events in the thing config. Provide a log extract from thr thing initialization

Baschtlwaschtl · September 22, 2020, 8:16am

Hi, I set log trace and updated things.

 2020-09-22 10:02:27.181 [TRACE] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Updating status
2020-09-22 10:02:27.182 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellyix3-68c63afa98b2: HTTP GET for http://192.168.0.191/status
2020-09-22 10:02:27.427 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellyix3-68c63afa98b2: HTTP Response 200: {"wifi_sta":{"connected":true,"ssid":"Shellynetz","ip":"192.168.0.191","rssi":-72},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"10:02","unixtime":1600768947,"serial":510,"has_update":false,"mac":"68C63AFA98B2","cfg_changed_cnt":20,"actions_stats":{"skipped":0},"inputs":[{"input":0,"event":"S","event_cnt":214},{"input":0,"event":"","event_cnt":0},{"input":0,"event":"","event_cnt":0}],"update":{"status":"unknown","has_update":false,"new_version":"","old_version":"20200827-070910/v1.8.3@4a8bc427"},"ram_total":51376,"ram_free":39824,"fs_size":233681,"fs_free":150349,"uptime":302527}
2020-09-22 10:02:42.468 [TRACE] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Updating status
2020-09-22 10:02:42.469 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellyix3-68c63afa98b2: HTTP GET for http://192.168.0.191/status
2020-09-22 10:02:42.676 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellyix3-68c63afa98b2: HTTP Response 200: {"wifi_sta":{"connected":true,"ssid":"Shellynetz","ip":"192.168.0.191","rssi":-71},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"10:02","unixtime":1600768962,"serial":510,"has_update":false,"mac":"68C63AFA98B2","cfg_changed_cnt":20,"actions_stats":{"skipped":0},"inputs":[{"input":0,"event":"S","event_cnt":214},{"input":0,"event":"","event_cnt":0},{"input":0,"event":"","event_cnt":0}],"update":{"status":"unknown","has_update":false,"new_version":"","old_version":"20200827-070910/v1.8.3@4a8bc427"},"ram_total":51376,"ram_free":39824,"fs_size":233681,"fs_free":150349,"uptime":302542}
2020-09-22 10:02:56.360 [TRACE] [y.internal.handler.ShellyBaseHandler] - shellybulbduo-d11ece: Updating status
2020-09-22 10:02:56.361 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellybulbduo-d11ece: HTTP GET for http://192.168.0.190/status
2020-09-22 10:02:56.566 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellybulbduo-d11ece: HTTP Response 200: {"wifi_sta":{"connected":true,"ssid":"Wurstsemmel","ip":"192.168.0.190","rssi":-78},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"","unixtime":0,"serial":233,"has_update":false,"mac":"98F4ABD11ECE","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"lights":[{"ison":false,"has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"brightness":40,"white":30,"temp":3840}],"meters":[{"power":0.00,"is_valid":true,"timestamp":0,"counters":[0.000, 0.000, 0.000],"total":0}],"update":{"status":"unknown","has_update":false,"new_version":"","old_version":"20200827-065050/v1.8.3@4a8bc427"},"ram_total":51176,"ram_free":36852,"fs_size":233681,"fs_free":161142,"uptime":13709}
2020-09-22 10:02:56.566 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellybulbduo-d11ece: HTTP GET for http://192.168.0.190/status
2020-09-22 10:02:56.774 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellybulbduo-d11ece: HTTP Response 200: {"wifi_sta":{"connected":true,"ssid":"Wurstsemmel","ip":"192.168.0.190","rssi":-78},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"","unixtime":0,"serial":233,"has_update":false,"mac":"98F4ABD11ECE","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"lights":[{"ison":false,"has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"brightness":40,"white":30,"temp":3840}],"meters":[{"power":0.00,"is_valid":true,"timestamp":0,"counters":[0.000, 0.000, 0.000],"total":0}],"update":{"status":"unknown","has_update":false,"new_version":"","old_version":"20200827-065050/v1.8.3@4a8bc427"},"ram_total":51176,"ram_free":36860,"fs_size":233681,"fs_free":161142,"uptime":13709}
2020-09-22 10:02:56.775 [TRACE] [.internal.handler.ShellyLightHandler] - shellybulbduo-d11ece: Updating light status in white mode, 1 channel(s)
2020-09-22 10:02:56.775 [TRACE] [.internal.handler.ShellyLightHandler] - shellybulbduo-d11ece: Colors loaded for lightId 0: power=OFF, RGBW=0/0/0/0, gain=0, brightness=40, color temp=3840 (min=2700, max=6500
2020-09-22 10:02:56.775 [TRACE] [.internal.handler.ShellyLightHandler] - shellybulbduo-d11ece: update white.color picker
2020-09-22 10:02:56.776 [TRACE] [y.internal.handler.ShellyBaseHandler] - shellybulbduo-d11ece: Updating 1 standard meter(s)
2020-09-22 10:02:56.943 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Shutting down
2020-09-22 10:02:56.943 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Shelly statusJob stopped
2020-09-22 10:02:56.944 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2: Stopping CoAP Listener
2020-09-22 10:02:56.944 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2: CoAP Request was canceled
2020-09-22 10:02:56.946 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Thing config updated, re-initialize
2020-09-22 10:02:58.953 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Using userId admin from bindingConfig
2020-09-22 10:02:58.954 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Device config: IP address=192.168.0.191, HTTP user/password=admin/***, update interval=60
2020-09-22 10:02:58.954 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Configured Events: Button: true, Switch (on/off): false, Push: true, Roller: true, Sensor: true, CoIoT: true, Enable AutoCoIoT: true
2020-09-22 10:02:58.955 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Start initializing thing Shelly ix3 (SHIX3-1), type shellyix3, ip address 192.168.0.191, CoIoT: true
2020-09-22 10:02:58.955 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellyix3-68c63afa98b2: HTTP GET for http://192.168.0.191/shelly
2020-09-22 10:02:59.001 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellyix3-68c63afa98b2: HTTP Response 200: {"type":"SHIX3-1","mac":"68C63AFA98B2","auth":true,"fw":"20200827-070910/v1.8.3@4a8bc427","longid":1,"num_inputs":3, "num_outputs":0}
2020-09-22 10:02:59.002 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellyix3-68c63afa98b2: HTTP GET for http://192.168.0.191/settings
2020-09-22 10:02:59.820 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellyix3-68c63afa98b2: HTTP Response 200: {"device":{"type":"SHIX3-1","mac":"68C63AFA98B2","hostname":"shellyix3-68C63AFA98B2","num_inputs":3, "num_outputs":0},"wifi_ap":{"enabled":false,"ssid":"shellyix3-68C63AFA98B2","key":""},"wifi_sta":{"enabled":true,"ssid":"Shellynetz","ipv4_method":"static","ip":"192.168.0.191","gw":null,"mask":"255.255.255.0","dns":null},"wifi_sta1":{"enabled":false,"ssid":null,"ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"mqtt": {"enable":false,"server":"192.168.33.3:1883","user":"","id":"shellyix3-68C63AFA98B2","reconnect_timeout_max":60.000000,"reconnect_timeout_min":2.000000,"clean_session":true,"keep_alive":60,"max_qos":0,"retain":false,"update_period":30},"coiot": {"update_period":15},"sntp":{"server":"192.168.0.1","enabled":true},"login":{"enabled":true,"unprotected":false,"username":"admin"},"pin_code":"","name":"I3","fw":"20200827-070910/v1.8.3@4a8bc427","factory_reset_from_switch":true,"discoverable":true,"build_info":{"build_id":"20200827-070910/v1.8.3@4a8bc427","build_timestamp":"2020-08-27T07:09:10Z","build_version":"1.0"},"cloud":{"enabled":false,"connected":false},"timezone":"Europe/Berlin","lat":50.110901,"lng":8.682130,"tzautodetect":true,"tz_utc_offset":7200,"tz_dst":true,"tz_dst_auto":true,"time":"10:02","unixtime":1600768979,"led_status_disable":false,"actions":{"active":false,"names":["btn_on_url","btn_off_url","shortpush_url","longpush_url","double_shortpush_url","triple_shortpush_url","shortpush_longpush_url","longpush_shortpush_url","btn_on_url","btn_off_url","shortpush_url","longpush_url","double_shortpush_url","triple_shortpush_url","shortpush_longpush_url","longpush_shortpush_url","btn_on_url","btn_off_url","shortpush_url","longpush_url","double_shortpush_url","triple_shortpush_url","shortpush_longpush_url","longpush_shortpush_url"]},"hwinfo":{"hw_revision":"prod-2020-04-21", "batch_id":1},"longpush_duration_ms":{"min":500, "max":3000},"multipush_time_between_pushes_ms":{"max":500},"inputs":[{"name":null,"btn_type":"momentary","btn_reverse":0,"btn_on_url":"http://admin:admin@192.168.0.190/light/0?turn=on","btn_off_url":"http://admin:admin@192.168.0.190/light/0?turn=off","shortpush_url":"http://admin:admin@192.168.0.190/light/0?turn=on&brightness=30&white=30","longpush_url":"http://admin:admin@192.168.0.190/light/0?turn=off","double_shortpush_url":"","triple_shortpush_url":"","shortpush_longpush_url":"","longpush_shortpush_url":""},{"name":null,"btn_type":"momentary","btn_reverse":0,"btn_on_url":"","btn_off_url":"","shortpush_url":"","longpush_url":"","double_shortpush_url":"","triple_shortpush_url":"","shortpush_longpush_url":"","longpush_shortpush_url":""},{"name":null,"btn_type":"momentary","btn_reverse":0,"btn_on_url":"","btn_off_url":"","shortpush_url":"","longpush_url":"","double_shortpush_url":"","triple_shortpush_url":"","shortpush_longpush_url":"","longpush_shortpush_url":""}]}
2020-09-22 10:02:59.821 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Initializing device shellyix3-68c63afa98b2, type SHIX3-1, Hardware: Rev: prod-2020-04-21, batch 1; Firmware: v1.8.3 / 20200827-070910 (4a8bc427)
2020-09-22 10:02:59.821 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Shelly settings info for shellyix3-68c63afa98b2: {"device":{"type":"SHIX3-1","mac":"68C63AFA98B2","hostname":"shellyix3-68C63AFA98B2","num_inputs":3, "num_outputs":0},"wifi_ap":{"enabled":false,"ssid":"shellyix3-68C63AFA98B2","key":""},"wifi_sta":{"enabled":true,"ssid":"Shellynetz","ipv4_method":"static","ip":"192.168.0.191","gw":null,"mask":"255.255.255.0","dns":null},"wifi_sta1":{"enabled":false,"ssid":null,"ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"mqtt": {"enable":false,"server":"192.168.33.3:1883","user":"","id":"shellyix3-68C63AFA98B2","reconnect_timeout_max":60.000000,"reconnect_timeout_min":2.000000,"clean_session":true,"keep_alive":60,"max_qos":0,"retain":false,"update_period":30},"coiot": {"update_period":15},"sntp":{"server":"192.168.0.1","enabled":true},"login":{"enabled":true,"unprotected":false,"username":"admin"},"pin_code":"","name":"I3","fw":"20200827-070910/v1.8.3@4a8bc427","factory_reset_from_switch":true,"discoverable":true,"build_info":{"build_id":"20200827-070910/v1.8.3@4a8bc427","build_timestamp":"2020-08-27T07:09:10Z","build_version":"1.0"},"cloud":{"enabled":false,"connected":false},"timezone":"Europe/Berlin","lat":50.110901,"lng":8.682130,"tzautodetect":true,"tz_utc_offset":7200,"tz_dst":true,"tz_dst_auto":true,"time":"10:02","unixtime":1600768979,"led_status_disable":false,"actions":{"active":false,"names":["btn_on_url","btn_off_url","shortpush_url","longpush_url","double_shortpush_url","triple_shortpush_url","shortpush_longpush_url","longpush_shortpush_url","btn_on_url","btn_off_url","shortpush_url","longpush_url","double_shortpush_url","triple_shortpush_url","shortpush_longpush_url","longpush_shortpush_url","btn_on_url","btn_off_url","shortpush_url","longpush_url","double_shortpush_url","triple_shortpush_url","shortpush_longpush_url","longpush_shortpush_url"]},"hwinfo":{"hw_revision":"prod-2020-04-21", "batch_id":1},"longpush_duration_ms":{"min":500, "max":3000},"multipush_time_between_pushes_ms":{"max":500},"inputs":[{"name":null,"btn_type":"momentary","btn_reverse":0,"btn_on_url":"http://admin:admin@192.168.0.190/light/0?turn=on","btn_off_url":"http://admin:admin@192.168.0.190/light/0?turn=off","shortpush_url":"http://admin:admin@192.168.0.190/light/0?turn=on&brightness=30&white=30","longpush_url":"http://admin:admin@192.168.0.190/light/0?turn=off","double_shortpush_url":"","triple_shortpush_url":"","shortpush_longpush_url":"","longpush_shortpush_url":""},{"name":null,"btn_type":"momentary","btn_reverse":0,"btn_on_url":"","btn_off_url":"","shortpush_url":"","longpush_url":"","double_shortpush_url":"","triple_shortpush_url":"","shortpush_longpush_url":"","longpush_shortpush_url":""},{"name":null,"btn_type":"momentary","btn_reverse":0,"btn_on_url":"","btn_off_url":"","shortpush_url":"","longpush_url":"","double_shortpush_url":"","triple_shortpush_url":"","shortpush_longpush_url":"","longpush_shortpush_url":""}]}
2020-09-22 10:02:59.822 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Device hasRelays:false (numRelays=0),isRoller:false (numRoller=0),isDimmer:false,numMeter=0,isEMeter:false),isSensor:false,isDS:false,hasBattery:false,isSense:false,isLight:false,isBulb:false,isDuo:false,isRGBW2:false,inColor:false,updatePeriod:70sec
2020-09-22 10:02:59.822 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellyix3-68c63afa98b2: HTTP GET for http://192.168.0.191/status
2020-09-22 10:03:00.016 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellyix3-68c63afa98b2: HTTP Response 200: {"wifi_sta":{"connected":true,"ssid":"Shellynetz","ip":"192.168.0.191","rssi":-72},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"10:02","unixtime":1600768979,"serial":510,"has_update":false,"mac":"68C63AFA98B2","cfg_changed_cnt":20,"actions_stats":{"skipped":0},"inputs":[{"input":0,"event":"S","event_cnt":214},{"input":0,"event":"","event_cnt":0},{"input":0,"event":"","event_cnt":0}],"update":{"status":"unknown","has_update":false,"new_version":"","old_version":"20200827-070910/v1.8.3@4a8bc427"},"ram_total":51376,"ram_free":39828,"fs_size":233681,"fs_free":150349,"uptime":302560}
2020-09-22 10:03:00.016 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Auto-CoIoT is enabled, disabling action urls
2020-09-22 10:03:00.016 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel device#alarm updated with NONE (type class org.eclipse.smarthome.core.library.types.StringType).
2020-09-22 10:03:00.017 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Starting CoIoT (autoCoIoT=true/true)
2020-09-22 10:03:00.017 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2: Starting CoAP Listener
2020-09-22 10:03:00.017 [ERROR] [.eclipse.californium.core.CoapClient] - could not set and start client endpoint
java.net.SocketException: Invalid argument
	at java.net.PlainDatagramSocketImpl.join(Native Method) ~[?:1.8.0_265]
	at java.net.AbstractPlainDatagramSocketImpl.join(AbstractPlainDatagramSocketImpl.java:178) ~[?:1.8.0_265]
	at java.net.MulticastSocket.joinGroup(MulticastSocket.java:323) ~[?:1.8.0_265]
	at org.eclipse.californium.elements.UdpMulticastConnector.start(UdpMulticastConnector.java:89) ~[?:?]
	at org.eclipse.californium.core.network.CoapEndpoint.start(CoapEndpoint.java:506) ~[?:?]
	at org.eclipse.californium.core.CoapClient.setEndpoint(CoapClient.java:356) ~[?:?]
	at org.openhab.binding.shelly.internal.coap.ShellyCoapHandler.start(ShellyCoapHandler.java:118) ~[?:?]
	at org.openhab.binding.shelly.internal.handler.ShellyBaseHandler.initializeThing(ShellyBaseHandler.java:276) ~[?:?]
	at org.openhab.binding.shelly.internal.handler.ShellyBaseHandler.lambda$0(ShellyBaseHandler.java:158) ~[?:?]
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:1.8.0_265]
	at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:1.8.0_265]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180) [?:1.8.0_265]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) [?:1.8.0_265]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_265]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_265]
	at java.lang.Thread.run(Thread.java:748) [?:1.8.0_265]
2020-09-22 10:03:00.019 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Thing successfully initialized.
2020-09-22 10:03:00.019 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Update status job started, interval=20*3=60sec.
2020-09-22 10:03:00.037 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2: CoIoT Message from /192.168.0.191:5683 (MID=38261): {"blk":[{"I":1,"D":"input_0"},{"I":2,"D":"input_1"},{"I":3,"D":"input_2"},{"I":4,"D":"device"}],"sen":[{"I":9103,"T":"EVC","D":"cfgChanged","R":"U16","L":4},{"I":2101,"T":"S","D":"input","R":"0/1","L":1},{"I":2102,"T":"EV","D":"inputEvent","R":["S/L/SS/SSS/SL/LS",""],"L":1},{"I":2103,"T":"EVC","D":"inputEventCnt","R":"U16","L":1},{"I":2201,"T":"S","D":"input","R":"0/1","L":2},{"I":2202,"T":"EV","D":"inputEvent","R":["S/L/SS/SSS/SL/LS",""],"L":2},{"I":2203,"T":"EVC","D":"inputEventCnt","R":"U16","L":2},{"I":2301,"T":"S","D":"input","R":"0/1","L":3},{"I":2302,"T":"EV","D":"inputEvent","R":["S/L/SS/SSS/SL/LS",""],"L":3},{"I":2303,"T":"EVC","D":"inputEventCnt","R":"U16","L":3}]}
2020-09-22 10:03:00.037 [TRACE] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Properties updated
2020-09-22 10:03:00.037 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2: CoIoT Version 2 detected
2020-09-22 10:03:00.037 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2: CoIoT Device Description for SHIX3-1#68C63AFA98B2#2: {"blk":[{"I":1,"D":"input_0"},{"I":2,"D":"input_1"},{"I":3,"D":"input_2"},{"I":4,"D":"device"}],"sen":[{"I":9103,"T":"EVC","D":"cfgChanged","R":"U16","L":4},{"I":2101,"T":"S","D":"input","R":"0/1","L":1},{"I":2102,"T":"EV","D":"inputEvent","R":["S/L/SS/SSS/SL/LS",""],"L":1},{"I":2103,"T":"EVC","D":"inputEventCnt","R":"U16","L":1},{"I":2201,"T":"S","D":"input","R":"0/1","L":2},{"I":2202,"T":"EV","D":"inputEvent","R":["S/L/SS/SSS/SL/LS",""],"L":2},{"I":2203,"T":"EVC","D":"inputEventCnt","R":"U16","L":2},{"I":2301,"T":"S","D":"input","R":"0/1","L":3},{"I":2302,"T":"EV","D":"inputEvent","R":["S/L/SS/SSS/SL/LS",""],"L":3},{"I":2303,"T":"EVC","D":"inputEventCnt","R":"U16","L":3}]}
2020-09-22 10:03:00.038 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id=1: input_0
2020-09-22 10:03:00.038 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id=2: input_1
2020-09-22 10:03:00.038 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id=3: input_2
2020-09-22 10:03:00.038 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id=4: device
2020-09-22 10:03:00.038 [TRACE] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Properties updated
2020-09-22 10:03:00.038 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2: Adding 10 sensor definitions
2020-09-22 10:03:00.039 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id 9103: cfgChanged, Type=EVC, Range=U16, Links=4
2020-09-22 10:03:00.039 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id 2101: input, Type=S, Range=0/1, Links=1
2020-09-22 10:03:00.039 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id 2102: inputEvent, Type=EV, Range=S/L/SS/SSS/SL/LS;, Links=1
2020-09-22 10:03:00.039 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id 2103: inputEventCnt, Type=EVC, Range=U16, Links=1
2020-09-22 10:03:00.039 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id 2201: input, Type=S, Range=0/1, Links=2
2020-09-22 10:03:00.039 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id 2202: inputEvent, Type=EV, Range=S/L/SS/SSS/SL/LS;, Links=2
2020-09-22 10:03:00.039 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id 2203: inputEventCnt, Type=EVC, Range=U16, Links=2
2020-09-22 10:03:00.040 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id 2301: input, Type=S, Range=0/1, Links=3
2020-09-22 10:03:00.040 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id 2302: inputEvent, Type=EV, Range=S/L/SS/SSS/SL/LS;, Links=3
2020-09-22 10:03:00.040 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id 2303: inputEventCnt, Type=EVC, Range=U16, Links=3
2020-09-22 10:03:02.029 [TRACE] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Updating status
2020-09-22 10:03:02.030 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellyix3-68c63afa98b2: HTTP GET for http://192.168.0.191/status
2020-09-22 10:03:02.239 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellyix3-68c63afa98b2: HTTP Response 200: {"wifi_sta":{"connected":true,"ssid":"Shellynetz","ip":"192.168.0.191","rssi":-72},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"10:03","unixtime":1600768982,"serial":510,"has_update":false,"mac":"68C63AFA98B2","cfg_changed_cnt":20,"actions_stats":{"skipped":0},"inputs":[{"input":0,"event":"S","event_cnt":214},{"input":0,"event":"","event_cnt":0},{"input":0,"event":"","event_cnt":0}],"update":{"status":"unknown","has_update":false,"new_version":"","old_version":"20200827-070910/v1.8.3@4a8bc427"},"ram_total":51376,"ram_free":39824,"fs_size":233681,"fs_free":150349,"uptime":302562}
2020-09-22 10:03:02.240 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel status1#lastEvent updated with S (type class org.eclipse.smarthome.core.library.types.StringType).
2020-09-22 10:03:02.240 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel status1#eventCount updated with 214 (type class org.eclipse.smarthome.core.library.types.DecimalType).
2020-09-22 10:03:02.240 [TRACE] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: 3 more updates requested
2020-09-22 10:03:05.259 [TRACE] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Updating status
2020-09-22 10:03:05.260 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellyix3-68c63afa98b2: HTTP GET for http://192.168.0.191/status
2020-09-22 10:03:05.463 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellyix3-68c63afa98b2: HTTP Response 200: {"wifi_sta":{"connected":true,"ssid":"Shellynetz","ip":"192.168.0.191","rssi":-71},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"10:03","unixtime":1600768985,"serial":510,"has_update":false,"mac":"68C63AFA98B2","cfg_changed_cnt":20,"actions_stats":{"skipped":0},"inputs":[{"input":0,"event":"S","event_cnt":214},{"input":0,"event":"","event_cnt":0},{"input":0,"event":"","event_cnt":0}],"update":{"status":"unknown","has_update":false,"new_version":"","old_version":"20200827-070910/v1.8.3@4a8bc427"},"ram_total":51376,"ram_free":39824,"fs_size":233681,"fs_free":150349,"uptime":302565}
2020-09-22 10:03:05.464 [TRACE] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: 2 more updates requested
2020-09-22 10:03:08.474 [TRACE] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Updating status
2020-09-22 10:03:08.475 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellyix3-68c63afa98b2: HTTP GET for http://192.168.0.191/status
2020-09-22 10:03:08.683 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellyix3-68c63afa98b2: HTTP Response 200: {"wifi_sta":{"connected":true,"ssid":"Shellynetz","ip":"192.168.0.191","rssi":-72},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"10:03","unixtime":1600768988,"serial":510,"has_update":false,"mac":"68C63AFA98B2","cfg_changed_cnt":20,"actions_stats":{"skipped":0},"inputs":[{"input":0,"event":"S","event_cnt":214},{"input":0,"event":"","event_cnt":0},{"input":0,"event":"","event_cnt":0}],"update":{"status":"unknown","has_update":false,"new_version":"","old_version":"20200827-070910/v1.8.3@4a8bc427"},"ram_total":51376,"ram_free":39824,"fs_size":233681,"fs_free":150349,"uptime":302568}
2020-09-22 10:03:08.684 [TRACE] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: 1 more updates requested
2020-09-22 10:03:11.687 [TRACE] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Updating status
2020-09-22 10:03:11.687 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellyix3-68c63afa98b2: HTTP GET for http://192.168.0.191/status
2020-09-22 10:03:11.901 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellyix3-68c63afa98b2: HTTP Response 200: {"wifi_sta":{"connected":true,"ssid":"Shellynetz","ip":"192.168.0.191","rssi":-71},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"10:03","unixtime":1600768991,"serial":510,"has_update":false,"mac":"68C63AFA98B2","cfg_changed_cnt":20,"actions_stats":{"skipped":0},"inputs":[{"input":0,"event":"S","event_cnt":214},{"input":0,"event":"","event_cnt":0},{"input":0,"event":"","event_cnt":0}],"update":{"status":"unknown","has_update":false,"new_version":"","old_version":"20200827-070910/v1.8.3@4a8bc427"},"ram_total":51376,"ram_free":39824,"fs_size":233681,"fs_free":150349,"uptime":302572}
2020-09-22 10:03:11.902 [TRACE] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: 0 more updates requested
2020-09-22 10:03:19.629 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellybulbduo-d11ece: Thing config updated, re-initialize
2020-09-22 10:03:19.630 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellybulbduo-d11ece: Stopping CoAP Listener
2020-09-22 10:03:19.632 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellybulbduo-d11ece: CoAP Request was canceled
2020-09-22 10:03:20.887 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellybulbduo-d11ece: HTTP GET for http://192.168.0.190/settings
2020-09-22 10:03:21.418 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellybulbduo-d11ece: HTTP Response 200: {"device":{"type":"SHBDUO-1","mac":"98F4ABD11ECE","hostname":"ShellyBulbDuo-D11ECE","num_outputs":1},"wifi_ap":{"enabled":false,"ssid":"ShellyBulbDuo-D11ECE","key":""},"wifi_sta":{"enabled":true,"ssid":"Wurstsemmel","ipv4_method":"static","ip":"192.168.0.190","gw":null,"mask":"255.255.255.0","dns":null},"wifi_sta1":{"enabled":false,"ssid":null,"ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"mqtt": {"enable":false,"server":"192.168.33.3:1883","user":"","id":"ShellyBulbDuo-D11ECE","reconnect_timeout_max":60.000000,"reconnect_timeout_min":2.000000,"clean_session":true,"keep_alive":60,"max_qos":0,"retain":false,"update_period":30},"coiot": {"update_period":15},"sntp":{"server":"192.168.0.1 ","enabled":true},"login":{"enabled":true,"unprotected":false,"username":"admin"},"pin_code":"","name":"Treppenhaus_Lampe","fw":"20200827-065050/v1.8.3@4a8bc427","discoverable":true,"build_info":{"build_id":"20200827-065050/v1.8.3@4a8bc427","build_timestamp":"2020-08-27T06:50:50Z","build_version":"1.0"},"cloud":{"enabled":false,"connected":false},"timezone":"Europe/Berlin","lat":50.110901,"lng":8.682130,"tzautodetect":true,"tz_utc_offset":7200,"tz_dst":false,"tz_dst_auto":true,"time":"","unixtime":0,"actions":{"active":false,"names":["out_on_url","out_off_url"]},"hwinfo":{"hw_revision":"prod-2019-12","batch_id":0},"mode":"white","transition":1000,"lights":[{"name":null,"ison":false,"brightness":40,"white":30,"temp":3840,"default_state":"last","auto_on":0.00,"auto_off":0.00,"schedule":false,"out_on_url":"","out_off_url":"","schedule_rules":[]}],"night_mode":{"enabled":false, "start_time":"00:00", "end_time":"00:00", "brightness":0}}
2020-09-22 10:03:21.419 [TRACE] [y.internal.handler.ShellyBaseHandler] - shellybulbduo-d11ece: Updating status
2020-09-22 10:03:21.419 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellybulbduo-d11ece: HTTP GET for http://192.168.0.190/status
2020-09-22 10:03:21.628 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellybulbduo-d11ece: HTTP Response 200: {"wifi_sta":{"connected":true,"ssid":"Wurstsemmel","ip":"192.168.0.190","rssi":-79},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"","unixtime":0,"serial":233,"has_update":false,"mac":"98F4ABD11ECE","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"lights":[{"ison":false,"has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"brightness":40,"white":30,"temp":3840}],"meters":[{"power":0.00,"is_valid":true,"timestamp":0,"counters":[0.000, 0.000, 0.000],"total":0}],"update":{"status":"unknown","has_update":false,"new_version":"","old_version":"20200827-065050/v1.8.3@4a8bc427"},"ram_total":51176,"ram_free":36856,"fs_size":233681,"fs_free":161142,"uptime":13734}
2020-09-22 10:03:21.629 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellybulbduo-d11ece: HTTP GET for http://192.168.0.190/status
2020-09-22 10:03:21.836 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellybulbduo-d11ece: HTTP Response 200: {"wifi_sta":{"connected":true,"ssid":"Wurstsemmel","ip":"192.168.0.190","rssi":-79},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"","unixtime":0,"serial":233,"has_update":false,"mac":"98F4ABD11ECE","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"lights":[{"ison":false,"has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"brightness":40,"white":30,"temp":3840}],"meters":[{"power":0.00,"is_valid":true,"timestamp":0,"counters":[0.000, 0.000, 0.000],"total":0}],"update":{"status":"unknown","has_update":false,"new_version":"","old_version":"20200827-065050/v1.8.3@4a8bc427"},"ram_total":51176,"ram_free":36868,"fs_size":233681,"fs_free":161142,"uptime":13734}
2020-09-22 10:03:21.837 [TRACE] [.internal.handler.ShellyLightHandler] - shellybulbduo-d11ece: Updating light status in white mode, 1 channel(s)
2020-09-22 10:03:21.837 [TRACE] [.internal.handler.ShellyLightHandler] - shellybulbduo-d11ece: Colors loaded for lightId 0: power=OFF, RGBW=0/0/0/0, gain=0, brightness=40, color temp=3840 (min=2700, max=6500
2020-09-22 10:03:21.837 [TRACE] [.internal.handler.ShellyLightHandler] - shellybulbduo-d11ece: update white.color picker
2020-09-22 10:03:21.838 [TRACE] [y.internal.handler.ShellyBaseHandler] - shellybulbduo-d11ece: Updating 1 standard meter(s)
2020-09-22 10:03:21.838 [TRACE] [y.internal.handler.ShellyBaseHandler] - shellybulbduo-d11ece: 0 more updates requested
2020-09-22 10:03:32.938 [TRACE] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Updating status
2020-09-22 10:03:32.938 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellyix3-68c63afa98b2: HTTP GET for http://192.168.0.191/status
2020-09-22 10:03:33.145 [TRACE] [ng.shelly.internal.api.ShellyHttpApi] - shellyix3-68c63afa98b2: HTTP Response 200: {"wifi_sta":{"connected":true,"ssid":"Shellynetz","ip":"192.168.0.191","rssi":-71},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"10:03","unixtime":1600769012,"serial":510,"has_update":false,"mac":"68C63AFA98B2","cfg_changed_cnt":20,"actions_stats":{"skipped":0},"inputs":[{"input":0,"event":"S","event_cnt":214},{"input":0,"event":"","event_cnt":0},{"input":0,"event":"","event_cnt":0}],"update":{"status":"unknown","has_update":false,"new_version":"","old_version":"20200827-070910/v1.8.3@4a8bc427"},"ram_total":51376,"ram_free":39824,"fs_size":233681,"fs_free":150349,"uptime":302593}

I see “stopping coAP listener”

Edit:
I have tradfri binding installed. Should I put the 2 other jarfiles into the addon folder?

markus7017 · September 22, 2020, 3:36pm

I see

Hopefully Trafi and Shelly don’t use the same Multicast port. Default is 5684 for Tradfi and 5683 for Shelly, so that should work.

Please try to disable the Trafi binding (bundle:stop on the OH console), disable/enable the the Shelly thing, which causes a re-init.

Baschtlwaschtl · September 22, 2020, 4:58pm

I did.
Reaction time is still to long.


2020-09-22 18:44:34.471 [ERROR] [.eclipse.californium.core.CoapClient] - could not set and start client endpoint
java.net.SocketException: Invalid argument
	at java.net.PlainDatagramSocketImpl.join(Native Method) ~[?:1.8.0_265]
	at java.net.AbstractPlainDatagramSocketImpl.join(AbstractPlainDatagramSocketImpl.java:178) ~[?:1.8.0_265]
	at java.net.MulticastSocket.joinGroup(MulticastSocket.java:323) ~[?:1.8.0_265]
	at org.eclipse.californium.elements.UdpMulticastConnector.start(UdpMulticastConnector.java:89) ~[?:?]
	at org.eclipse.californium.core.network.CoapEndpoint.start(CoapEndpoint.java:506) ~[?:?]
	at org.eclipse.californium.core.CoapClient.setEndpoint(CoapClient.java:356) ~[?:?]
	at org.openhab.binding.shelly.internal.coap.ShellyCoapHandler.start(ShellyCoapHandler.java:118) ~[?:?]
	at org.openhab.binding.shelly.internal.handler.ShellyBaseHandler.initializeThing(ShellyBaseHandler.java:276) ~[?:?]
	at org.openhab.binding.shelly.internal.handler.ShellyBaseHandler.lambda$0(ShellyBaseHandler.java:158) ~[?:?]
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:1.8.0_265]
	at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:1.8.0_265]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180) [?:1.8.0_265]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) [?:1.8.0_265]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_265]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_265]
	at java.lang.Thread.run(Thread.java:748) [?:1.8.0_265]
2020-09-22 18:45:37.707 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel status1#lastEvent updated with S (type class org.eclipse.smarthome.core.library.types.StringType).
2020-09-22 18:45:37.707 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel status1#eventCount updated with 220 (type class org.eclipse.smarthome.core.library.types.DecimalType).
2020-09-22 18:45:37.708 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Enabling channel cache (20 updates / 60s)
2020-09-22 18:45:46.552 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Shutting down
2020-09-22 18:45:46.553 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Shelly statusJob stopped
2020-09-22 18:45:46.553 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2: Stopping CoAP Listener
2020-09-22 18:45:46.553 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2: CoAP Request was canceled
2020-09-22 18:45:46.553 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2: CoAP Request was canceled
2020-09-22 18:45:53.395 [DEBUG] [shelly.internal.ShellyHandlerFactory] - Shelly ix3 (SHIX3-1): Create new thing of type shelly:shellyix3 using ShellyRelayHandler
2020-09-22 18:45:55.421 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Using userId admin from bindingConfig
2020-09-22 18:45:55.422 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Device config: IP address=192.168.0.191, HTTP user/password=admin/***, update interval=60
2020-09-22 18:45:55.422 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Configured Events: Button: true, Switch (on/off): false, Push: true, Roller: true, Sensor: true, CoIoT: true, Enable AutoCoIoT: true
2020-09-22 18:45:55.422 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Start initializing thing Shelly ix3 (SHIX3-1), type shellyix3, ip address 192.168.0.191, CoIoT: true
2020-09-22 18:45:56.340 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Initializing device shellyix3-68c63afa98b2, type SHIX3-1, Hardware: Rev: prod-2020-04-21, batch 1; Firmware: v1.8.3 / 20200827-070910 (4a8bc427)
2020-09-22 18:45:56.340 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Shelly settings info for shellyix3-68c63afa98b2: {"device":{"type":"SHIX3-1","mac":"68C63AFA98B2","hostname":"shellyix3-68C63AFA98B2","num_inputs":3, "num_outputs":0},"wifi_ap":{"enabled":false,"ssid":"shellyix3-68C63AFA98B2","key":""},"wifi_sta":{"enabled":true,"ssid":"Shellynetz","ipv4_method":"static","ip":"192.168.0.191","gw":null,"mask":"255.255.255.0","dns":null},"wifi_sta1":{"enabled":false,"ssid":null,"ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"mqtt": {"enable":false,"server":"192.168.33.3:1883","user":"","id":"shellyix3-68C63AFA98B2","reconnect_timeout_max":60.000000,"reconnect_timeout_min":2.000000,"clean_session":true,"keep_alive":60,"max_qos":0,"retain":false,"update_period":30},"coiot": {"update_period":15},"sntp":{"server":"192.168.0.1","enabled":true},"login":{"enabled":true,"unprotected":false,"username":"admin"},"pin_code":"","name":"I3","fw":"20200827-070910/v1.8.3@4a8bc427","factory_reset_from_switch":true,"discoverable":true,"build_info":{"build_id":"20200827-070910/v1.8.3@4a8bc427","build_timestamp":"2020-08-27T07:09:10Z","build_version":"1.0"},"cloud":{"enabled":false,"connected":false},"timezone":"Europe/Berlin","lat":50.110901,"lng":8.682130,"tzautodetect":true,"tz_utc_offset":7200,"tz_dst":true,"tz_dst_auto":true,"time":"18:45","unixtime":1600800356,"led_status_disable":false,"actions":{"active":false,"names":["btn_on_url","btn_off_url","shortpush_url","longpush_url","double_shortpush_url","triple_shortpush_url","shortpush_longpush_url","longpush_shortpush_url","btn_on_url","btn_off_url","shortpush_url","longpush_url","double_shortpush_url","triple_shortpush_url","shortpush_longpush_url","longpush_shortpush_url","btn_on_url","btn_off_url","shortpush_url","longpush_url","double_shortpush_url","triple_shortpush_url","shortpush_longpush_url","longpush_shortpush_url"]},"hwinfo":{"hw_revision":"prod-2020-04-21", "batch_id":1},"longpush_duration_ms":{"min":500, "max":3000},"multipush_time_between_pushes_ms":{"max":500},"inputs":[{"name":null,"btn_type":"momentary","btn_reverse":0,"btn_on_url":"http://admin:admin@192.168.0.190/light/0?turn=on","btn_off_url":"http://admin:admin@192.168.0.190/light/0?turn=off","shortpush_url":"http://admin:admin@192.168.0.190/light/0?turn=on&brightness=30&white=30","longpush_url":"http://admin:admin@192.168.0.190/light/0?turn=off","double_shortpush_url":"","triple_shortpush_url":"","shortpush_longpush_url":"","longpush_shortpush_url":""},{"name":null,"btn_type":"momentary","btn_reverse":0,"btn_on_url":"","btn_off_url":"","shortpush_url":"","longpush_url":"","double_shortpush_url":"","triple_shortpush_url":"","shortpush_longpush_url":"","longpush_shortpush_url":""},{"name":null,"btn_type":"momentary","btn_reverse":0,"btn_on_url":"","btn_off_url":"","shortpush_url":"","longpush_url":"","double_shortpush_url":"","triple_shortpush_url":"","shortpush_longpush_url":"","longpush_shortpush_url":""}]}
2020-09-22 18:45:56.341 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Device hasRelays:false (numRelays=0),isRoller:false (numRoller=0),isDimmer:false,numMeter=0,isEMeter:false),isSensor:false,isDS:false,hasBattery:false,isSense:false,isLight:false,isBulb:false,isDuo:false,isRGBW2:false,inColor:false,updatePeriod:70sec
2020-09-22 18:45:56.552 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Auto-CoIoT is enabled, disabling action urls
2020-09-22 18:45:56.552 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel device#alarm updated with NONE (type class org.eclipse.smarthome.core.library.types.StringType).
2020-09-22 18:45:56.552 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Starting CoIoT (autoCoIoT=true/true)
2020-09-22 18:45:56.553 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2: Starting CoAP Listener
2020-09-22 18:45:56.553 [ERROR] [.eclipse.californium.core.CoapClient] - could not set and start client endpoint
java.net.SocketException: Invalid argument
	at java.net.PlainDatagramSocketImpl.join(Native Method) ~[?:1.8.0_265]
	at java.net.AbstractPlainDatagramSocketImpl.join(AbstractPlainDatagramSocketImpl.java:178) ~[?:1.8.0_265]
	at java.net.MulticastSocket.joinGroup(MulticastSocket.java:323) ~[?:1.8.0_265]
	at org.eclipse.californium.elements.UdpMulticastConnector.start(UdpMulticastConnector.java:89) ~[?:?]
	at org.eclipse.californium.core.network.CoapEndpoint.start(CoapEndpoint.java:506) ~[?:?]
	at org.eclipse.californium.core.CoapClient.setEndpoint(CoapClient.java:356) ~[?:?]
	at org.openhab.binding.shelly.internal.coap.ShellyCoapHandler.start(ShellyCoapHandler.java:118) ~[?:?]
	at org.openhab.binding.shelly.internal.handler.ShellyBaseHandler.initializeThing(ShellyBaseHandler.java:276) ~[?:?]
	at org.openhab.binding.shelly.internal.handler.ShellyBaseHandler.lambda$0(ShellyBaseHandler.java:158) ~[?:?]
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:1.8.0_265]
	at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:1.8.0_265]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180) [?:1.8.0_265]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) [?:1.8.0_265]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_265]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_265]
	at java.lang.Thread.run(Thread.java:748) [?:1.8.0_265]
2020-09-22 18:45:56.555 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Thing successfully initialized.
2020-09-22 18:45:56.555 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Update status job started, interval=20*3=60sec.
2020-09-22 18:45:56.571 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2: CoIoT Message from /192.168.0.191:5683 (MID=8832): {"blk":[{"I":1,"D":"input_0"},{"I":2,"D":"input_1"},{"I":3,"D":"input_2"},{"I":4,"D":"device"}],"sen":[{"I":9103,"T":"EVC","D":"cfgChanged","R":"U16","L":4},{"I":2101,"T":"S","D":"input","R":"0/1","L":1},{"I":2102,"T":"EV","D":"inputEvent","R":["S/L/SS/SSS/SL/LS",""],"L":1},{"I":2103,"T":"EVC","D":"inputEventCnt","R":"U16","L":1},{"I":2201,"T":"S","D":"input","R":"0/1","L":2},{"I":2202,"T":"EV","D":"inputEvent","R":["S/L/SS/SSS/SL/LS",""],"L":2},{"I":2203,"T":"EVC","D":"inputEventCnt","R":"U16","L":2},{"I":2301,"T":"S","D":"input","R":"0/1","L":3},{"I":2302,"T":"EV","D":"inputEvent","R":["S/L/SS/SSS/SL/LS",""],"L":3},{"I":2303,"T":"EVC","D":"inputEventCnt","R":"U16","L":3}]}
2020-09-22 18:45:56.572 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2: CoIoT Version 2 detected
2020-09-22 18:45:56.572 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2: CoIoT Device Description for SHIX3-1#68C63AFA98B2#2: {"blk":[{"I":1,"D":"input_0"},{"I":2,"D":"input_1"},{"I":3,"D":"input_2"},{"I":4,"D":"device"}],"sen":[{"I":9103,"T":"EVC","D":"cfgChanged","R":"U16","L":4},{"I":2101,"T":"S","D":"input","R":"0/1","L":1},{"I":2102,"T":"EV","D":"inputEvent","R":["S/L/SS/SSS/SL/LS",""],"L":1},{"I":2103,"T":"EVC","D":"inputEventCnt","R":"U16","L":1},{"I":2201,"T":"S","D":"input","R":"0/1","L":2},{"I":2202,"T":"EV","D":"inputEvent","R":["S/L/SS/SSS/SL/LS",""],"L":2},{"I":2203,"T":"EVC","D":"inputEventCnt","R":"U16","L":2},{"I":2301,"T":"S","D":"input","R":"0/1","L":3},{"I":2302,"T":"EV","D":"inputEvent","R":["S/L/SS/SSS/SL/LS",""],"L":3},{"I":2303,"T":"EVC","D":"inputEventCnt","R":"U16","L":3}]}
2020-09-22 18:45:56.572 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id=1: input_0
2020-09-22 18:45:56.572 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id=2: input_1
2020-09-22 18:45:56.573 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id=3: input_2
2020-09-22 18:45:56.573 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id=4: device
2020-09-22 18:45:56.573 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2: Adding 10 sensor definitions
2020-09-22 18:45:56.573 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id 9103: cfgChanged, Type=EVC, Range=U16, Links=4
2020-09-22 18:45:56.573 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id 2101: input, Type=S, Range=0/1, Links=1
2020-09-22 18:45:56.573 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id 2102: inputEvent, Type=EV, Range=S/L/SS/SSS/SL/LS;, Links=1
2020-09-22 18:45:56.574 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id 2103: inputEventCnt, Type=EVC, Range=U16, Links=1
2020-09-22 18:45:56.574 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id 2201: input, Type=S, Range=0/1, Links=2
2020-09-22 18:45:56.574 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id 2202: inputEvent, Type=EV, Range=S/L/SS/SSS/SL/LS;, Links=2
2020-09-22 18:45:56.574 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id 2203: inputEventCnt, Type=EVC, Range=U16, Links=2
2020-09-22 18:45:56.574 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id 2301: input, Type=S, Range=0/1, Links=3
2020-09-22 18:45:56.574 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id 2302: inputEvent, Type=EV, Range=S/L/SS/SSS/SL/LS;, Links=3
2020-09-22 18:45:56.574 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2:    id 2303: inputEventCnt, Type=EVC, Range=U16, Links=3
2020-09-22 18:45:56.588 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2: CoIoT Message from /192.168.0.191:5683 (MID=8833): {"G":[[0,9103,20],[0,2101,0],[0,2102,"S"],[0,2103,220],[0,2201,0],[0,2202,""],[0,2203,0],[0,2301,0],[0,2302,""],[0,2303,0]]}
2020-09-22 18:45:56.588 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2: CoIoT Sensor data {"G":[[0,9103,20],[0,2101,0],[0,2102,"S"],[0,2103,220],[0,2201,0],[0,2202,""],[0,2203,0],[0,2301,0],[0,2302,""],[0,2303,0]]} (serial=3074)
2020-09-22 18:45:56.589 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2: 10 CoAP sensor updates received
2020-09-22 18:45:56.589 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel status1#eventCount updated with 220 (type class org.eclipse.smarthome.core.library.types.DecimalType).
2020-09-22 18:45:56.589 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel status1#lastEvent updated with S (type class org.eclipse.smarthome.core.library.types.StringType).
2020-09-22 18:45:56.589 [DEBUG] [elly.internal.coap.ShellyCoapHandler] - shellyix3-68c63afa98b2: 2 channels updated from CoIoT status, serial=3074
2020-09-22 18:46:01.728 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel status1#lastEvent updated with S (type class org.eclipse.smarthome.core.library.types.StringType).
2020-09-22 18:46:01.729 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel status1#eventCount updated with 220 (type class org.eclipse.smarthome.core.library.types.DecimalType).
2020-09-22 18:46:04.936 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel status1#lastEvent updated with S (type class org.eclipse.smarthome.core.library.types.StringType).
2020-09-22 18:46:04.936 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel status1#eventCount updated with 220 (type class org.eclipse.smarthome.core.library.types.DecimalType).
2020-09-22 18:46:08.163 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel status1#lastEvent updated with S (type class org.eclipse.smarthome.core.library.types.StringType).
2020-09-22 18:46:08.163 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel status1#eventCount updated with 220 (type class org.eclipse.smarthome.core.library.types.DecimalType).
2020-09-22 18:46:11.355 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel status1#lastEvent updated with S (type class org.eclipse.smarthome.core.library.types.StringType).
2020-09-22 18:46:11.356 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel status1#eventCount updated with 220 (type class org.eclipse.smarthome.core.library.types.DecimalType).
2020-09-22 18:46:59.764 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel status1#lastEvent updated with S (type class org.eclipse.smarthome.core.library.types.StringType).
2020-09-22 18:46:59.764 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel status1#eventCount updated with 221 (type class org.eclipse.smarthome.core.library.types.DecimalType).
2020-09-22 18:46:59.765 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyix3-68c63afa98b2: Enabling channel cache (20 updates / 60s)
2020-09-22 18:46:59.797 [INFO ] [clipse.smarthome.model.script.rule#1] - var zustand = S
2020-09-22 18:46:59.798 [INFO ] [clipse.smarthome.model.script.rule#1] - var helligkeit = 0
2020-09-22 18:46:59.804 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-d11ece: Set brightness to 40.0%/40
2020-09-22 18:46:59.804 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-d11ece: Changing brightness from 40 to 40
2020-09-22 18:46:59.804 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-d11ece: Send light settings: {turn=on}
2020-09-22 18:46:59.857 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-d11ece: Colors updated for lightId 0: RGBW=0/0/0/0, Sat/Gain=0, Bright=40, Temp=3840 
2020-09-22 18:46:59.860 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-d11ece: Set color temp to 30.0%
2020-09-22 18:46:59.860 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-d11ece: Converted color-temp 0.3% to 3840K (from Percent to Integer)
2020-09-22 18:47:46.427 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellybulbduo-d11ece: Channel white#brightness$Switch updated with ON (type class org.eclipse.smarthome.core.library.types.OnOffType).
2020-09-22 18:47:46.428 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellybulbduo-d11ece: Channel white#brightness$Value updated with 40 % (type class org.eclipse.smarthome.core.library.types.QuantityType).
2020-09-22 18:48:00.232 [DEBUG] [lly.internal.util.ShellyChannelCache] - shellyix3-68c63afa98b2: Channel status1#eventCount updated with 223 (type class org.eclipse.smarthome.core.library.types.DecimalType).
2020-09-22 18:48:00.234 [INFO ] [clipse.smarthome.model.script.rule#1] - var zustand = S
2020-09-22 18:48:00.234 [INFO ] [clipse.smarthome.model.script.rule#1] - var helligkeit = 40
2020-09-22 18:48:00.239 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-d11ece: Set brightness to 0.0%/0
2020-09-22 18:48:00.239 [DEBUG] [.internal.handler.ShellyLightHandler] - shellybulbduo-d11ece: Brightness=0 -> switch light OFF

and one switch wasn’t recognized. See eventcount