Shelly Binding

Ranzkarl · January 13, 2023, 4:32pm

it worked for about 35 minutes, and it’s back now. Restarting the binding only results in the following TRACE output:

openhab>
bundle:restart org.openhab.binding.shelly
openhab> log:tail
17:19:32.870 [DEBUG] [internal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:3.4.1 (281)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(371)] : Set implementation object for component
17:19:32.871 [DEBUG] [internal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:3.4.1 (281)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(371)] : Changed state from satisfied to active
17:19:32.873 [INFO ] [rd.internal.element.ServletWebElement] - Ignoring servlet [637] without valid alias or url patterns property.
17:19:32.874 [DEBUG] [internal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:3.4.1 (281)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(371)] : dm $005 tracking 6 SingleStatic added {org.openhab.binding.shelly.internal.provider.ShellyTranslationProvider}={service.id=632, service.bundleid=281, service.scope=bundle, component.name=org.openhab.binding.shelly.internal.provider.ShellyTranslationProvider, component.id=374} (exit)
17:19:32.875 [DEBUG] [nal.provider.ShellyChannelDefinitions] - bundle org.openhab.binding.shelly:3.4.1 (281)[org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions(372)] : dm $000 tracking 1 SingleStatic added {org.openhab.binding.shelly.internal.provider.ShellyTranslationProvider}={service.id=632, service.bundleid=281, service.scope=bundle, component.name=org.openhab.binding.shelly.internal.provider.ShellyTranslationProvider, component.id=374} (enter)
17:19:32.876 [DEBUG] [nal.provider.ShellyChannelDefinitions] - bundle org.openhab.binding.shelly:3.4.1 (281)[org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions(372)] : ActivateInternal
17:19:32.877 [DEBUG] [nal.provider.ShellyChannelDefinitions] - bundle org.openhab.binding.shelly:3.4.1 (281)[org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions(372)] : Querying state unsatisfiedReference
17:19:32.878 [DEBUG] [nal.provider.ShellyChannelDefinitions] - bundle org.openhab.binding.shelly:3.4.1 (281)[org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions(372)] : Querying state unsatisfiedReference
17:19:32.879 [DEBUG] [nal.provider.ShellyChannelDefinitions] - bundle org.openhab.binding.shelly:3.4.1 (281)[org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions(372)] : Activating component from state unsatisfiedReference
17:19:32.880 [DEBUG] [nal.provider.ShellyChannelDefinitions] - bundle org.openhab.binding.shelly:3.4.1 (281)[org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions(372)] : Querying state unsatisfiedReference
17:19:32.881 [DEBUG] [nal.provider.ShellyChannelDefinitions] - bundle org.openhab.binding.shelly:3.4.1 (281)[org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions(372)] : Querying state unsatisfiedReference
17:19:32.882 [DEBUG] [nal.provider.ShellyChannelDefinitions] - bundle org.openhab.binding.shelly:3.4.1 (281)[org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions(372)] : Changed state from unsatisfiedReference to satisfied
17:19:32.883 [DEBUG] [nal.provider.ShellyChannelDefinitions] - bundle org.openhab.binding.shelly:3.4.1 (281)[org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions(372)] : registration change queue [registered]
17:19:32.886 [DEBUG] [nal.provider.ShellyChannelDefinitions] - bundle org.openhab.binding.shelly:3.4.1 (281)[org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions(372)] : dm $000 tracking 1 SingleStatic added {org.openhab.binding.shelly.internal.provider.ShellyTranslationProvider}={service.id=632, service.bundleid=281, service.scope=bundle, component.name=org.openhab.binding.shelly.internal.provider.ShellyTranslationProvider, component.id=374} (exit)
17:19:33.069 [DEBUG] [.shelly.internal.ShellyHandlerFactory] - Licht Mauer - X.X.X.203: Create new thing of type shelly:shellydimmer2 using ShellyRelayHandler
17:19:33.091 [DEBUG] [.shelly.internal.ShellyHandlerFactory] - Thing handler for uid shelly:shellydimmer2:e8db84d3c8e4 added, total things = 1
17:19:33.102 [INFO ] [hab.event.ThingStatusInfoChangedEvent] - Thing 'shelly:shellydimmer2:e8db84d3c8e4' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
17:19:33.118 [DEBUG] [.shelly.internal.ShellyHandlerFactory] - Licht Küchenschrank - X.X.X.201: Create new thing of type shelly:shellyrgbw2-white using ShellyLightHandler
17:19:33.140 [DEBUG] [.shelly.internal.ShellyHandlerFactory] - Thing handler for uid shelly:shellyrgbw2-white:00bccf added, total things = 2
17:19:33.152 [INFO ] [hab.event.ThingStatusInfoChangedEvent] - Thing 'shelly:shellyrgbw2-white:00bccf' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
17:19:33.157 [DEBUG] [y.internal.handler.ShellyLightHandler] - Thing is using  class org.openhab.binding.shelly.internal.handler.ShellyLightHandler
17:19:33.168 [DEBUG] [.shelly.internal.ShellyHandlerFactory] - Licht Küche Regal Fenster - X.X.X.204: Create new thing of type shelly:shellyrgbw2-white using ShellyLightHandler
17:19:33.193 [DEBUG] [.shelly.internal.ShellyHandlerFactory] - Thing handler for uid shelly:shellyrgbw2-white:D9625E added, total things = 3
17:19:33.205 [INFO ] [hab.event.ThingStatusInfoChangedEvent] - Thing 'shelly:shellyrgbw2-white:D9625E' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
17:19:33.209 [DEBUG] [y.internal.handler.ShellyLightHandler] - Thing is using  class org.openhab.binding.shelly.internal.handler.ShellyLightHandler
17:19:33.952 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4: CoIoT Message from /X.X.X.203:5683 (MID=4982): {"G":[[0,9103,0],[0,1101,1],[0,5101,14],[0,2101,0],[0,2102,""],[0,2103,0],[0,2201,0],[0,2202,""],[0,2203,0],[0,4101,9.91],[0,4103,145],[0,6102,0],[0,6109,0.00],[0,6104,0],[0,3104,30.58],[0,3105,87.04],[0,6101,0],[0,9101,"white"]]}
17:19:33.953 [WARN ] [b.core.thing.binding.BaseThingHandler] - Handler ShellyRelayHandler tried updating the thing status although the handler was already disposed.
17:19:33.954 [TRACE] [ly.internal.handler.ShellyBaseHandler] - shellydimmer2-e8db84d3c8e4: Watchdog restarted (expires in 70 sec)
17:19:33.955 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4: CoIoT Sensor data {"G":[[0,9103,0],[0,1101,1],[0,5101,14],[0,2101,0],[0,2102,""],[0,2103,0],[0,2201,0],[0,2202,""],[0,2203,0],[0,4101,9.91],[0,4103,145],[0,6102,0],[0,6109,0.00],[0,6104,0],[0,3104,30.58],[0,3105,87.04],[0,6101,0],[0,9101,"white"]]} (serial=1536)
17:19:33.956 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4: 18 CoAP sensor updates received
17:19:33.956 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[0]: id=9103, Value=0.0 (cfgChanged, Type=EVC, Range=U16, Link=4: device)
17:19:33.957 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[1]: id=1101, Value=1.0 (output, Type=S, Range=0/1, Link=1: light_0)
17:19:33.958 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[2]: id=5101, Value=14.0 (brightness, Type=S, Range=1/100, Link=1: light_0)
17:19:33.959 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[3]: id=2101, Value=0.0 (input, Type=S, Range=0/1, Link=2: input_0)
17:19:33.959 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[4]: id=2102, Value=-1.0 (inputEvent, Type=EV, Range=S/L;, Link=2: input_0)
17:19:33.960 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[5]: id=2103, Value=0.0 (inputEventCnt, Type=EVC, Range=U16, Link=2: input_0)
17:19:33.961 [TRACE] [ly.internal.api1.Shelly1CoIoTProtocol] - shellydimmer2-e8db84d3c8e4: Check button[0] for event trigger (isButtonMode=true, isButton=false, hasBattery=false, serial=1536, count=0, lastEventCount[0]=0
17:19:33.962 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[6]: id=2201, Value=0.0 (input, Type=S, Range=0/1, Link=3: input_1)
17:19:33.963 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[7]: id=2202, Value=-1.0 (inputEvent, Type=EV, Range=S/L;, Link=3: input_1)
17:19:33.963 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[8]: id=2203, Value=0.0 (inputEventCnt, Type=EVC, Range=U16, Link=3: input_1)
17:19:33.964 [TRACE] [ly.internal.api1.Shelly1CoIoTProtocol] - shellydimmer2-e8db84d3c8e4: Check button[1] for event trigger (isButtonMode=true, isButton=false, hasBattery=false, serial=1536, count=0, lastEventCount[1]=0
17:19:33.965 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[9]: id=4101, Value=9.91 (power, Type=P, Range=0/230;-1, Link=1: light_0)
17:19:33.966 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[10]: id=4103, Value=145.0 (energy, Type=E, Range=U32;-1, Link=1: light_0)
17:19:33.967 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[11]: id=6102, Value=0.0 (overpower, Type=A, Range=0/1;-1, Link=1: light_0)
17:19:33.968 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[12]: id=6109, Value=0.0 (overpowerValue, Type=P, Range=U32;-1, Link=1: light_0)
17:19:33.968 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[13]: id=6104, Value=0.0 (loadError, Type=A, Range=0/1, Link=1: light_0)
17:19:33.969 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[14]: id=3104, Value=30.58 (deviceTemp, Type=T, Range=-40/300;999, Link=4: device)
17:19:33.970 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[15]: id=3105, Value=87.04 (deviceTemp, Type=T, Range=-40/572;999, Link=4: device)
17:19:33.971 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[16]: id=6101, Value=0.0 (overtemp, Type=A, Range=0/1;-1, Link=4: device)
17:19:33.971 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[17]: id=9101, Value=white (mode, Type=S, Range=color/white, Link=4: device)
17:19:35.461 [INFO ] [pport.EventAdminConfigurationNotifier] - Sending Event Admin notification (configuration successful) to org/ops4j/pax/logging/Configuration
17:19:40.005 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_LastUpdated' changed from 2023-01-13T17:19:31.447+0100 to 2023-01-13T17:19:39.999+0100
17:19:40.008 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_Power' changed from 2 W to 0 W
17:19:40.862 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_LastUpdated' changed from 2023-01-13T17:19:39.999+0100 to 2023-01-13T17:19:40.854+0100
17:19:40.867 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_Power' changed from 0 W to 2 W
17:19:42.316 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellyrgbw2-white-d9625e: CoIoT Message from /X.X.X.204:5683 (MID=42401): {"G":[[0,9103,0],[0,1101,0],[0,5101,100],[0,1201,0],[0,5201,1],[0,1301,0],[0,5301,1],[0,1401,0],[0,5401,1],[0,4101,0.00],[0,4103,190],[0,4201,0.00],[0,4203,0],[0,4301,0.00],[0,4303,0],[0,4401,0.00],[0,4403,0],[0,6102,0],[0,2101,0],[0,2102,""],[0,2103,0],[0,9101,"white"]]}
17:19:42.324 [WARN ] [b.core.thing.binding.BaseThingHandler] - Handler ShellyLightHandler tried updating the thing status although the handler was already disposed.
17:19:42.327 [TRACE] [ly.internal.handler.ShellyBaseHandler] - shellyrgbw2-white-d9625e: Watchdog restarted (expires in 70 sec)
17:19:42.330 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellyrgbw2-white-d9625e: Serial 27904 was already processed, ignore update
17:19:42.831 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellyrgbw2-00bccf: CoIoT Message from /X.X.X.201:5683 (MID=19140): {"G":[[0,9103,0],[0,1101,0],[0,5101,100],[0,1201,0],[0,5201,100],[0,1301,0],[0,5301,0],[0,1401,0],[0,5401,1],[0,4101,0.00],[0,4103,129],[0,4201,0.00],[0,4203,129],[0,4301,0.00],[0,4303,0],[0,4401,0.00],[0,4403,0],[0,6102,0],[0,2101,0],[0,2102,""],[0,2103,0],[0,9101,"white"]]}
17:19:42.833 [WARN ] [b.core.thing.binding.BaseThingHandler] - Handler ShellyLightHandler tried updating the thing status although the handler was already disposed.
17:19:42.835 [TRACE] [ly.internal.handler.ShellyBaseHandler] - shellyrgbw2-00bccf: Watchdog restarted (expires in 70 sec)
17:19:42.837 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellyrgbw2-00bccf: Serial 36608 was already processed, ignore update
17:19:44.852 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_LastUpdated' changed from 2023-01-13T17:19:40.854+0100 to 2023-01-13T17:19:44.843+0100
17:19:44.856 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_Power' changed from 2 W to 0 W
17:19:48.954 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4: CoIoT Message from /X.X.X.203:5683 (MID=4983): {"G":[[0,9103,0],[0,1101,1],[0,5101,14],[0,2101,0],[0,2102,""],[0,2103,0],[0,2201,0],[0,2202,""],[0,2203,0],[0,4101,9.96],[0,4103,145],[0,6102,0],[0,6109,0.00],[0,6104,0],[0,3104,30.68],[0,3105,87.22],[0,6101,0],[0,9101,"white"]]}
17:19:48.960 [WARN ] [b.core.thing.binding.BaseThingHandler] - Handler ShellyRelayHandler tried updating the thing status although the handler was already disposed.
17:19:48.964 [TRACE] [ly.internal.handler.ShellyBaseHandler] - shellydimmer2-e8db84d3c8e4: Watchdog restarted (expires in 70 sec)
17:19:48.966 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4: CoIoT Sensor data {"G":[[0,9103,0],[0,1101,1],[0,5101,14],[0,2101,0],[0,2102,""],[0,2103,0],[0,2201,0],[0,2202,""],[0,2203,0],[0,4101,9.96],[0,4103,145],[0,6102,0],[0,6109,0.00],[0,6104,0],[0,3104,30.68],[0,3105,87.22],[0,6101,0],[0,9101,"white"]]} (serial=1536)
17:19:48.968 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4: 18 CoAP sensor updates received
17:19:48.970 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[0]: id=9103, Value=0.0 (cfgChanged, Type=EVC, Range=U16, Link=4: device)
17:19:48.972 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[1]: id=1101, Value=1.0 (output, Type=S, Range=0/1, Link=1: light_0)
17:19:48.974 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[2]: id=5101, Value=14.0 (brightness, Type=S, Range=1/100, Link=1: light_0)
17:19:48.976 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[3]: id=2101, Value=0.0 (input, Type=S, Range=0/1, Link=2: input_0)
17:19:48.978 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[4]: id=2102, Value=-1.0 (inputEvent, Type=EV, Range=S/L;, Link=2: input_0)
17:19:48.980 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[5]: id=2103, Value=0.0 (inputEventCnt, Type=EVC, Range=U16, Link=2: input_0)
17:19:48.981 [TRACE] [ly.internal.api1.Shelly1CoIoTProtocol] - shellydimmer2-e8db84d3c8e4: Check button[0] for event trigger (isButtonMode=true, isButton=false, hasBattery=false, serial=1536, count=0, lastEventCount[0]=0
17:19:48.983 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[6]: id=2201, Value=0.0 (input, Type=S, Range=0/1, Link=3: input_1)
17:19:48.988 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[7]: id=2202, Value=-1.0 (inputEvent, Type=EV, Range=S/L;, Link=3: input_1)
17:19:48.990 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[8]: id=2203, Value=0.0 (inputEventCnt, Type=EVC, Range=U16, Link=3: input_1)
17:19:48.992 [TRACE] [ly.internal.api1.Shelly1CoIoTProtocol] - shellydimmer2-e8db84d3c8e4: Check button[1] for event trigger (isButtonMode=true, isButton=false, hasBattery=false, serial=1536, count=0, lastEventCount[1]=0
17:19:48.994 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[9]: id=4101, Value=9.96 (power, Type=P, Range=0/230;-1, Link=1: light_0)
17:19:48.996 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[10]: id=4103, Value=145.0 (energy, Type=E, Range=U32;-1, Link=1: light_0)
17:19:48.998 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[11]: id=6102, Value=0.0 (overpower, Type=A, Range=0/1;-1, Link=1: light_0)
17:19:48.999 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[12]: id=6109, Value=0.0 (overpowerValue, Type=P, Range=U32;-1, Link=1: light_0)
17:19:49.001 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[13]: id=6104, Value=0.0 (loadError, Type=A, Range=0/1, Link=1: light_0)
17:19:49.003 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[14]: id=3104, Value=30.68 (deviceTemp, Type=T, Range=-40/300;999, Link=4: device)
17:19:49.005 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[15]: id=3105, Value=87.22 (deviceTemp, Type=T, Range=-40/572;999, Link=4: device)
17:19:49.007 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[16]: id=6101, Value=0.0 (overtemp, Type=A, Range=0/1;-1, Link=4: device)
17:19:49.009 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[17]: id=9101, Value=white (mode, Type=S, Range=color/white, Link=4: device)
17:19:55.665 [INFO ] [hab.event.ThingStatusInfoChangedEvent] - Thing 'deconz:onofflight:00212E06912F:7cb03eaa00b2319503' changed from OFFLINE: Not reachable to ONLINE
17:19:55.671 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseHandstaubsaugerOSRAM_State' changed from UNDEF to ON
17:19:57.318 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellyrgbw2-white-d9625e: CoIoT Message from /X.X.X.204:5683 (MID=42402): {"G":[[0,9103,0],[0,1101,0],[0,5101,100],[0,1201,0],[0,5201,1],[0,1301,0],[0,5301,1],[0,1401,0],[0,5401,1],[0,4101,0.00],[0,4103,190],[0,4201,0.00],[0,4203,0],[0,4301,0.00],[0,4303,0],[0,4401,0.00],[0,4403,0],[0,6102,0],[0,2101,0],[0,2102,""],[0,2103,0],[0,9101,"white"]]}
17:19:57.323 [WARN ] [b.core.thing.binding.BaseThingHandler] - Handler ShellyLightHandler tried updating the thing status although the handler was already disposed.
17:19:57.326 [TRACE] [ly.internal.handler.ShellyBaseHandler] - shellyrgbw2-white-d9625e: Watchdog restarted (expires in 70 sec)
17:19:57.329 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellyrgbw2-white-d9625e: Serial 27904 was already processed, ignore update
17:19:57.835 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellyrgbw2-00bccf: CoIoT Message from /X.X.X.201:5683 (MID=19141): {"G":[[0,9103,0],[0,1101,0],[0,5101,100],[0,1201,0],[0,5201,100],[0,1301,0],[0,5301,0],[0,1401,0],[0,5401,1],[0,4101,0.00],[0,4103,129],[0,4201,0.00],[0,4203,129],[0,4301,0.00],[0,4303,0],[0,4401,0.00],[0,4403,0],[0,6102,0],[0,2101,0],[0,2102,""],[0,2103,0],[0,9101,"white"]]}
17:19:57.838 [WARN ] [b.core.thing.binding.BaseThingHandler] - Handler ShellyLightHandler tried updating the thing status although the handler was already disposed.
17:19:57.840 [TRACE] [ly.internal.handler.ShellyBaseHandler] - shellyrgbw2-00bccf: Watchdog restarted (expires in 70 sec)
17:19:57.841 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellyrgbw2-00bccf: Serial 36608 was already processed, ignore update
17:20:03.958 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4: CoIoT Message from /X.X.X.203:5683 (MID=4984): {"G":[[0,9103,0],[0,1101,1],[0,5101,14],[0,2101,0],[0,2102,""],[0,2103,0],[0,2201,0],[0,2202,""],[0,2203,0],[0,4101,9.96],[0,4103,155],[0,6102,0],[0,6109,0.00],[0,6104,0],[0,3104,30.73],[0,3105,87.31],[0,6101,0],[0,9101,"white"]]}
17:20:03.965 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseMonitorrechtsinnr_LastUpdated' changed from 2023-01-13T17:19:28.551+0100 to 2023-01-13T17:20:03.949+0100
17:20:03.967 [WARN ] [b.core.thing.binding.BaseThingHandler] - Handler ShellyRelayHandler tried updating the thing status although the handler was already disposed.
17:20:03.971 [TRACE] [ly.internal.handler.ShellyBaseHandler] - shellydimmer2-e8db84d3c8e4: Watchdog restarted (expires in 70 sec)
17:20:03.975 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4: CoIoT Sensor data {"G":[[0,9103,0],[0,1101,1],[0,5101,14],[0,2101,0],[0,2102,""],[0,2103,0],[0,2201,0],[0,2202,""],[0,2203,0],[0,4101,9.96],[0,4103,155],[0,6102,0],[0,6109,0.00],[0,6104,0],[0,3104,30.73],[0,3105,87.31],[0,6101,0],[0,9101,"white"]]} (serial=1536)
17:20:03.978 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4: 18 CoAP sensor updates received
17:20:03.981 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[0]: id=9103, Value=0.0 (cfgChanged, Type=EVC, Range=U16, Link=4: device)
17:20:03.984 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[1]: id=1101, Value=1.0 (output, Type=S, Range=0/1, Link=1: light_0)
17:20:03.987 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[2]: id=5101, Value=14.0 (brightness, Type=S, Range=1/100, Link=1: light_0)
17:20:03.990 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[3]: id=2101, Value=0.0 (input, Type=S, Range=0/1, Link=2: input_0)
17:20:03.993 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[4]: id=2102, Value=-1.0 (inputEvent, Type=EV, Range=S/L;, Link=2: input_0)
17:20:03.996 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[5]: id=2103, Value=0.0 (inputEventCnt, Type=EVC, Range=U16, Link=2: input_0)
17:20:03.999 [TRACE] [ly.internal.api1.Shelly1CoIoTProtocol] - shellydimmer2-e8db84d3c8e4: Check button[0] for event trigger (isButtonMode=true, isButton=false, hasBattery=false, serial=1536, count=0, lastEventCount[0]=0
17:20:04.002 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[6]: id=2201, Value=0.0 (input, Type=S, Range=0/1, Link=3: input_1)
17:20:04.005 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[7]: id=2202, Value=-1.0 (inputEvent, Type=EV, Range=S/L;, Link=3: input_1)
17:20:04.008 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[8]: id=2203, Value=0.0 (inputEventCnt, Type=EVC, Range=U16, Link=3: input_1)
17:20:04.011 [TRACE] [ly.internal.api1.Shelly1CoIoTProtocol] - shellydimmer2-e8db84d3c8e4: Check button[1] for event trigger (isButtonMode=true, isButton=false, hasBattery=false, serial=1536, count=0, lastEventCount[1]=0
17:20:04.014 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[9]: id=4101, Value=9.96 (power, Type=P, Range=0/230;-1, Link=1: light_0)
17:20:04.017 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[10]: id=4103, Value=155.0 (energy, Type=E, Range=U32;-1, Link=1: light_0)
17:20:04.020 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[11]: id=6102, Value=0.0 (overpower, Type=A, Range=0/1;-1, Link=1: light_0)
17:20:04.023 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[12]: id=6109, Value=0.0 (overpowerValue, Type=P, Range=U32;-1, Link=1: light_0)
17:20:04.025 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[13]: id=6104, Value=0.0 (loadError, Type=A, Range=0/1, Link=1: light_0)
17:20:04.028 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[14]: id=3104, Value=30.73 (deviceTemp, Type=T, Range=-40/300;999, Link=4: device)
17:20:04.031 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[15]: id=3105, Value=87.31 (deviceTemp, Type=T, Range=-40/572;999, Link=4: device)
17:20:04.034 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[16]: id=6101, Value=0.0 (overtemp, Type=A, Range=0/1;-1, Link=4: device)
17:20:04.037 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[17]: id=9101, Value=white (mode, Type=S, Range=color/white, Link=4: device)
17:20:04.409 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_LastUpdated' changed from 2023-01-13T17:19:44.843+0100 to 2023-01-13T17:20:04.400+0100
17:20:04.411 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_Voltage' changed from 234 V to 230 V
17:20:09.014 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseMonitorrechtsinnr_LastUpdated' changed from 2023-01-13T17:20:03.949+0100 to 2023-01-13T17:20:08.997+0100
17:20:09.019 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseMonitorrechtsinnr_Voltage' changed from 235 V to 232 V
17:20:12.321 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellyrgbw2-white-d9625e: CoIoT Message from /X.X.X.204:5683 (MID=42403): {"G":[[0,9103,0],[0,1101,0],[0,5101,100],[0,1201,0],[0,5201,1],[0,1301,0],[0,5301,1],[0,1401,0],[0,5401,1],[0,4101,0.00],[0,4103,190],[0,4201,0.00],[0,4203,0],[0,4301,0.00],[0,4303,0],[0,4401,0.00],[0,4403,0],[0,6102,0],[0,2101,0],[0,2102,""],[0,2103,0],[0,9101,"white"]]}
17:20:12.326 [WARN ] [b.core.thing.binding.BaseThingHandler] - Handler ShellyLightHandler tried updating the thing status although the handler was already disposed.
17:20:12.330 [TRACE] [ly.internal.handler.ShellyBaseHandler] - shellyrgbw2-white-d9625e: Watchdog restarted (expires in 70 sec)
17:20:12.333 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellyrgbw2-white-d9625e: Serial 27904 was already processed, ignore update
17:20:12.832 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellyrgbw2-00bccf: CoIoT Message from /X.X.X.201:5683 (MID=19142): {"G":[[0,9103,0],[0,1101,0],[0,5101,100],[0,1201,0],[0,5201,100],[0,1301,0],[0,5301,0],[0,1401,0],[0,5401,1],[0,4101,0.00],[0,4103,129],[0,4201,0.00],[0,4203,129],[0,4301,0.00],[0,4303,0],[0,4401,0.00],[0,4403,0],[0,6102,0],[0,2101,0],[0,2102,""],[0,2103,0],[0,9101,"white"]]}
17:20:12.836 [WARN ] [b.core.thing.binding.BaseThingHandler] - Handler ShellyLightHandler tried updating the thing status although the handler was already disposed.
17:20:12.839 [TRACE] [ly.internal.handler.ShellyBaseHandler] - shellyrgbw2-00bccf: Watchdog restarted (expires in 70 sec)
17:20:12.843 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellyrgbw2-00bccf: Serial 36608 was already processed, ignore update
17:20:18.584 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_LastUpdated' changed from 2023-01-13T17:20:04.400+0100 to 2023-01-13T17:20:18.578+0100
17:20:18.589 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_Voltage' changed from 230 V to 234 V
17:20:18.956 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4: CoIoT Message from /X.X.X.203:5683 (MID=4985): {"G":[[0,9103,0],[0,1101,1],[0,5101,14],[0,2101,0],[0,2102,""],[0,2103,0],[0,2201,0],[0,2202,""],[0,2203,0],[0,4101,9.96],[0,4103,155],[0,6102,0],[0,6109,0.00],[0,6104,0],[0,3104,30.73],[0,3105,87.31],[0,6101,0],[0,9101,"white"]]}
17:20:18.959 [WARN ] [b.core.thing.binding.BaseThingHandler] - Handler ShellyRelayHandler tried updating the thing status although the handler was already disposed.
17:20:18.961 [TRACE] [ly.internal.handler.ShellyBaseHandler] - shellydimmer2-e8db84d3c8e4: Watchdog restarted (expires in 70 sec)
17:20:18.963 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4: Serial 1536 was already processed, ignore update
17:20:21.832 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_LastUpdated' changed from 2023-01-13T17:20:18.578+0100 to 2023-01-13T17:20:21.822+0100
17:20:21.838 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_Power' changed from 0 W to 2 W
17:20:22.976 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseMonitorrechtsinnr_LastUpdated' changed from 2023-01-13T17:20:08.997+0100 to 2023-01-13T17:20:22.970+0100
17:20:22.981 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseMonitorrechtsinnr_Voltage' changed from 232 V to 235 V
17:20:27.030 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_LastUpdated' changed from 2023-01-13T17:20:21.822+0100 to 2023-01-13T17:20:27.021+0100
17:20:27.035 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_Power' changed from 2 W to 0 W
17:20:27.324 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellyrgbw2-white-d9625e: CoIoT Message from /X.X.X.204:5683 (MID=42404): {"G":[[0,9103,0],[0,1101,0],[0,5101,100],[0,1201,0],[0,5201,1],[0,1301,0],[0,5301,1],[0,1401,0],[0,5401,1],[0,4101,0.00],[0,4103,190],[0,4201,0.00],[0,4203,0],[0,4301,0.00],[0,4303,0],[0,4401,0.00],[0,4403,0],[0,6102,0],[0,2101,0],[0,2102,""],[0,2103,0],[0,9101,"white"]]}
17:20:27.327 [WARN ] [b.core.thing.binding.BaseThingHandler] - Handler ShellyLightHandler tried updating the thing status although the handler was already disposed.
17:20:27.329 [TRACE] [ly.internal.handler.ShellyBaseHandler] - shellyrgbw2-white-d9625e: Watchdog restarted (expires in 70 sec)
17:20:27.331 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellyrgbw2-white-d9625e: Serial 27904 was already processed, ignore update
17:20:27.811 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_LastUpdated' changed from 2023-01-13T17:20:27.021+0100 to 2023-01-13T17:20:27.801+0100
17:20:27.817 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_Power' changed from 0 W to 2 W
17:20:27.832 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellyrgbw2-00bccf: CoIoT Message from /X.X.X.201:5683 (MID=19143): {"G":[[0,9103,0],[0,1101,0],[0,5101,100],[0,1201,0],[0,5201,100],[0,1301,0],[0,5301,0],[0,1401,0],[0,5401,1],[0,4101,0.00],[0,4103,129],[0,4201,0.00],[0,4203,129],[0,4301,0.00],[0,4303,0],[0,4401,0.00],[0,4403,0],[0,6102,0],[0,2101,0],[0,2102,""],[0,2103,0],[0,9101,"white"]]}
17:20:27.837 [WARN ] [b.core.thing.binding.BaseThingHandler] - Handler ShellyLightHandler tried updating the thing status although the handler was already disposed.
17:20:27.845 [TRACE] [ly.internal.handler.ShellyBaseHandler] - shellyrgbw2-00bccf: Watchdog restarted (expires in 70 sec)
17:20:27.848 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellyrgbw2-00bccf: Serial 36608 was already processed, ignore update
17:20:28.845 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_LastUpdated' changed from 2023-01-13T17:20:27.801+0100 to 2023-01-13T17:20:28.836+0100
17:20:28.850 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_Power' changed from 2 W to 0 W
17:20:32.410 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_LastUpdated' changed from 2023-01-13T17:20:28.836+0100 to 2023-01-13T17:20:32.404+0100
17:20:32.415 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_Voltage' changed from 234 V to 230 V
17:20:34.082 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4: CoIoT Message from /X.X.X.203:5683 (MID=4986): {"G":[[0,9103,0],[0,1101,1],[0,5101,14],[0,2101,0],[0,2102,""],[0,2103,0],[0,2201,0],[0,2202,""],[0,2203,0],[0,4101,9.96],[0,4103,155],[0,6102,0],[0,6109,0.00],[0,6104,0],[0,3104,30.48],[0,3105,86.86],[0,6101,0],[0,9101,"white"]]}
17:20:34.084 [WARN ] [b.core.thing.binding.BaseThingHandler] - Handler ShellyRelayHandler tried updating the thing status although the handler was already disposed.
17:20:34.086 [TRACE] [ly.internal.handler.ShellyBaseHandler] - shellydimmer2-e8db84d3c8e4: Watchdog restarted (expires in 70 sec)
17:20:34.088 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4: CoIoT Sensor data {"G":[[0,9103,0],[0,1101,1],[0,5101,14],[0,2101,0],[0,2102,""],[0,2103,0],[0,2201,0],[0,2202,""],[0,2203,0],[0,4101,9.96],[0,4103,155],[0,6102,0],[0,6109,0.00],[0,6104,0],[0,3104,30.48],[0,3105,86.86],[0,6101,0],[0,9101,"white"]]} (serial=1536)
17:20:34.090 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4: 18 CoAP sensor updates received
17:20:34.092 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[0]: id=9103, Value=0.0 (cfgChanged, Type=EVC, Range=U16, Link=4: device)
17:20:34.093 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[1]: id=1101, Value=1.0 (output, Type=S, Range=0/1, Link=1: light_0)
17:20:34.095 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[2]: id=5101, Value=14.0 (brightness, Type=S, Range=1/100, Link=1: light_0)
17:20:34.097 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[3]: id=2101, Value=0.0 (input, Type=S, Range=0/1, Link=2: input_0)
17:20:34.099 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[4]: id=2102, Value=-1.0 (inputEvent, Type=EV, Range=S/L;, Link=2: input_0)
17:20:34.101 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[5]: id=2103, Value=0.0 (inputEventCnt, Type=EVC, Range=U16, Link=2: input_0)
17:20:34.102 [TRACE] [ly.internal.api1.Shelly1CoIoTProtocol] - shellydimmer2-e8db84d3c8e4: Check button[0] for event trigger (isButtonMode=true, isButton=false, hasBattery=false, serial=1536, count=0, lastEventCount[0]=0
17:20:34.104 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[6]: id=2201, Value=0.0 (input, Type=S, Range=0/1, Link=3: input_1)
17:20:34.106 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[7]: id=2202, Value=-1.0 (inputEvent, Type=EV, Range=S/L;, Link=3: input_1)
17:20:34.108 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[8]: id=2203, Value=0.0 (inputEventCnt, Type=EVC, Range=U16, Link=3: input_1)
17:20:34.110 [TRACE] [ly.internal.api1.Shelly1CoIoTProtocol] - shellydimmer2-e8db84d3c8e4: Check button[1] for event trigger (isButtonMode=true, isButton=false, hasBattery=false, serial=1536, count=0, lastEventCount[1]=0
17:20:34.112 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[9]: id=4101, Value=9.96 (power, Type=P, Range=0/230;-1, Link=1: light_0)
17:20:34.114 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[10]: id=4103, Value=155.0 (energy, Type=E, Range=U32;-1, Link=1: light_0)
17:20:34.116 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[11]: id=6102, Value=0.0 (overpower, Type=A, Range=0/1;-1, Link=1: light_0)
17:20:34.117 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[12]: id=6109, Value=0.0 (overpowerValue, Type=P, Range=U32;-1, Link=1: light_0)
17:20:34.119 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[13]: id=6104, Value=0.0 (loadError, Type=A, Range=0/1, Link=1: light_0)
17:20:34.121 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[14]: id=3104, Value=30.48 (deviceTemp, Type=T, Range=-40/300;999, Link=4: device)
17:20:34.123 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[15]: id=3105, Value=86.86 (deviceTemp, Type=T, Range=-40/572;999, Link=4: device)
17:20:34.125 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[16]: id=6101, Value=0.0 (overtemp, Type=A, Range=0/1;-1, Link=4: device)
17:20:34.126 [TRACE] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4:  Sensor value[17]: id=9101, Value=white (mode, Type=S, Range=color/white, Link=4: device)
17:20:36.831 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_LastUpdated' changed from 2023-01-13T17:20:32.404+0100 to 2023-01-13T17:20:36.824+0100
17:20:36.836 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_Power' changed from 0 W to 2 W
17:20:37.339 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseMonitorlinksinnr_LastUpdated' changed from 2023-01-13T17:18:30.142+0100 to 2023-01-13T17:20:37.331+0100
17:20:40.835 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_LastUpdated' changed from 2023-01-13T17:20:36.824+0100 to 2023-01-13T17:20:40.822+0100
17:20:40.843 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'SteckdoseKlingelinnr_Power' changed from 2 W to 0 W
17:20:42.326 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellyrgbw2-white-d9625e: CoIoT Message from /X.X.X.204:5683 (MID=42405): {"G":[[0,9103,0],[0,1101,0],[0,5101,100],[0,1201,0],[0,5201,1],[0,1301,0],[0,5301,1],[0,1401,0],[0,5401,1],[0,4101,0.00],[0,4103,190],[0,4201,0.00],[0,4203,0],[0,4301,0.00],[0,4303,0],[0,4401,0.00],[0,4403,0],[0,6102,0],[0,2101,0],[0,2102,""],[0,2103,0],[0,9101,"white"]]}
17:20:42.331 [WARN ] [b.core.thing.binding.BaseThingHandler] - Handler ShellyLightHandler tried updating the thing status although the handler was already disposed.
17:20:42.335 [TRACE] [ly.internal.handler.ShellyBaseHandler] - shellyrgbw2-white-d9625e: Watchdog restarted (expires in 70 sec)
17:20:42.339 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellyrgbw2-white-d9625e: Serial 27904 was already processed, ignore update
17:20:42.838 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellyrgbw2-00bccf: CoIoT Message from /X.X.X.201:5683 (MID=19144): {"G":[[0,9103,0],[0,1101,0],[0,5101,100],[0,1201,0],[0,5201,100],[0,1301,0],[0,5301,0],[0,1401,0],[0,5401,1],[0,4101,0.00],[0,4103,129],[0,4201,0.00],[0,4203,129],[0,4301,0.00],[0,4303,0],[0,4401,0.00],[0,4403,0],[0,6102,0],[0,2101,0],[0,2102,""],[0,2103,0],[0,9101,"white"]]}
17:20:42.843 [WARN ] [b.core.thing.binding.BaseThingHandler] - Handler ShellyLightHandler tried updating the thing status although the handler was already disposed.
17:20:42.846 [TRACE] [ly.internal.handler.ShellyBaseHandler] - shellyrgbw2-00bccf: Watchdog restarted (expires in 70 sec)
17:20:42.849 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellyrgbw2-00bccf: Serial 36608 was already processed, ignore update
17:20:49.085 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4: CoIoT Message from /X.X.X.203:5683 (MID=4987): {"G":[[0,9103,0],[0,1101,1],[0,5101,14],[0,2101,0],[0,2102,""],[0,2103,0],[0,2201,0],[0,2202,""],[0,2203,0],[0,4101,9.96],[0,4103,155],[0,6102,0],[0,6109,0.00],[0,6104,0],[0,3104,30.48],[0,3105,86.86],[0,6101,0],[0,9101,"white"]]}
17:20:49.088 [WARN ] [b.core.thing.binding.BaseThingHandler] - Handler ShellyRelayHandler tried updating the thing status although the handler was already disposed.
17:20:49.089 [TRACE] [ly.internal.handler.ShellyBaseHandler] - shellydimmer2-e8db84d3c8e4: Watchdog restarted (expires in 70 sec)
17:20:49.091 [DEBUG] [elly.internal.api1.Shelly1CoapHandler] - shellydimmer2-e8db84d3c8e4: Serial 1536 was already processed, ignore update

jabra_the_hut · January 14, 2023, 8:04am

Hi,

my logs are also flooded with the following messages:


2023-01-14 09:00:34.033 [WARN ] [.core.thing.binding.BaseThingHandler] - Handler ShellyRelayHandler tried updating the thing status although the handler was already disposed.
2023-01-14 09:00:34.658 [WARN ] [.core.thing.binding.BaseThingHandler] - Handler ShellyRelayHandler tried updating the thing status although the handler was already disposed.
2023-01-14 09:00:35.160 [WARN ] [.core.thing.binding.BaseThingHandler] - Handler ShellyRelayHandler tried updating the thing status although the handler was already disposed.
2023-01-14 09:00:36.672 [WARN ] [.core.thing.binding.BaseThingHandler] - Handler ShellyRelayHandler tried updating the thing status although the handler was already disposed.
2023-01-14 09:00:36.929 [WARN ] [.core.thing.binding.BaseThingHandler] - Handler ShellyRelayHandler tried updating the thing status although the handler was already disposed.
2023-01-14 09:00:37.325 [WARN ] [.core.thing.binding.BaseThingHandler] - Handler ShellyRelayHandler tried updating the thing status although the handler was already disposed.

Here is what I did:

In openHAB 3.4.0 I enabled a Thing via UI which was disabled via UI but still listed in a *.things file
I renamed the label only via the *.things file
The logs started to flood with the above mentioned snippet but all messages included the edited Thing
I removed the Shelly binding via UI
I updated to openHAB 3.4.1 via apt-get upgrade
I re-installed the Shelly binding via UI

All things appear as “Online” but the log is flooded with the message above and at some point openHAB forces a restart.

jabra_the_hut · January 14, 2023, 8:19am

OK, messages seem to be gone for now. I removed the binding again then I temporarily removed the *.things file containing all Shellys. Then re-installed the binding. Then I got no error messages.
Then I made the *.things file available again and now all things are back without error messages (so far).

thefox73 · January 14, 2023, 11:39am

Hi all,

since I updated to OH 3.4.1 via openHABian my log is flooded with

[WARN ] [.core.thing.binding.BaseThingHandler] - Handler ShellyRelayHandler tried updating the thing status although the handler was already disposed.

as well. I do not use thing-files. I already removed the binding, cleaned the OH cache, removed the things, installed the binding again, added the things again, but I don’t get rid of the handler warning.
Any help is much appreciated.

Thank you

Oliver2 · January 14, 2023, 11:50am

I read a few times that physically switching off the machine helped.

thefox73 · January 14, 2023, 12:07pm

That did the trick!!!
THX!

scha · January 14, 2023, 4:06pm

switching off and on also on my side removed the log-flood.
No idea why, but all fine now again.

Ranzkarl · January 14, 2023, 9:39pm

Hi, I just found out that my openhab instance completely loses outbound TCP connections when the issue appears. E.g. It stops updating the date and time object as well as not being able to send updates to the Shellys. The Debian itself is not affected as I can ping external adresses fine and SSH / telnet is working as well… So thanks for trying to troubleshoot the Shelly issue but it is obviously related to something different.

The handler is already disposed message can be fixed by simply restarting the whole device. Binding reset or openhab service restart doesn’t do the trick for me.

Matthias_Kaufmann · January 16, 2023, 12:49pm

I got 3.4.2 installed, thank you for the hint.
Nevertheless still values get mapped “randomely” to 0 or 100 stillm, see also bug report here.

charlyx · January 17, 2023, 8:29pm

@markus7017: are you probably already working on support of Shelly Plus Smoke Alarm?

the-ninth · January 19, 2023, 8:50am

Good morning!

Has anyone tried to use the range extender functionality of the current generation of Shellys?

I read that when using it, both the device acting as range extender and the device connecting to it would be accessible via the same IP but different ports. Would the binding support such a setup?

So far I cannot get it to work, but that seems to be a different issue, because I can’t even access the device connecting to the range extender in the Shelly app and do not really know how to troubleshoot that.

Baschtlwaschtl · January 22, 2023, 6:50pm

Hello, I have a question regarding this binding and battery operated shellys.
For example, shelly motion or TRV.
The devices go into sleep mode and commands are not sent sometimes.

shellymotionsensor-60a42386d716: FEHLER: Der Befehl 2 für Kanal shelly:shellymotion:f76253bbaa:sensors#sensorSleepTime kann nicht verarbeitet werden - API Timeout for GET http://192.168.0.225/settings?sleep_time=3

Is the command sent again or is it simply ignored after the timeout?

How can I be sure that a - for example - temperature change for a TRV has also been adopted.

Greets

hmerk · January 22, 2023, 7:10pm

I don‘t really know how the binding handles this internally, but can say that my TRVs did not miss any temperature change.

Oliver2 · January 22, 2023, 7:31pm

I can confirm this.
For TRVs the binding works perfectly.

Baschtlwaschtl · January 22, 2023, 9:43pm

Unfortunately, this is not the case with me.

shellytrv-60a423d92dd4: FEHLER: Der Befehl 22 für Kanal shelly:shellytrv:TrvBad226:control#targetTemp kann nicht verarbeitet werden - API Timeout for GET http://192.168.0.226/thermostat/0?target_t_enabled=1&target_t=22

There is a ‘window_open’ action in the TRV which isn’t included in the binding.
I wrote a shell script to send the action with check of the answer. And sometimes the script run twice to set the window open/close state.

Maybe @markus7017 can say something about that timeout behavior.
Greets.

Oliver2 · January 22, 2023, 10:13pm

Is CoIoT enabled?

Baschtlwaschtl · January 23, 2023, 6:03am

Yes

DrRSatzteil · January 23, 2023, 9:29pm

I don’t want to interrupt the discussion but can anyone suggest a configuration for a dw2 sensor that does not drain the battery like crazy? I installed three of them not long ago and thought they broke after two months or so because they did not react anymore but the latest battery level was still at about 60% (which was really bad already). However it turned out that the battery was just too low to wake the device…

Does it make sense to invest in another set of batteries or should I just dump them completely

igi · January 24, 2023, 5:54am

Mine have longer life. I have 8 pieces DW2. This one as an example is after 1 year at 91%.

Settings (bold marked are important):

Tilt: enabled
Vibration: enabled
Wake Up By Lighting: disabled
Temperature Treshold: 1.5
no I/O + Sensor Actions
static IP address
current firmware v1.12.1
Batteries: CR123A Kraftmax Pro, 20 pieces for about 30 Euro.

DrRSatzteil · January 24, 2023, 7:58am

I’ll give it another try. Mine looked more like this. It died at 67%