did it created the new channels?
@beanz Please change the title of this thread to something like “[shelly] Stack Overflow reading N current from 3EM and no channel data”. I think we got far off the initial problem
I fixed " [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: Invalid format for sensor definition detected, id=6" and checked 5x for “Channel definition for meter#ncurrent not found!”, but can’t find something wrong. Maybe it’s related to the bug.
If the problem persists, switch to TRACE logging.
I update the 4.2.0-SNAPSHOT and also provided a .kar file, maybe that allows you to run the 4.2 version on 4.1.
good idea, changed the topic as suggested
now I started over again: new docker container with OH 4.2-SNAPSHOT Build #3847
on OH console:
feature:install openhab-transport-coap
log:set DEBUG org.openhab.binding.log
copied the jar and kar into the addons folder. restart docker container.
on console I looked at the installed bindings:
openhab> bundle:list | grep Shelly
262 x Waiting x 80 x 4.2.0.202401191937 x openHAB Add-ons :: Bundles :: Shelly Binding Gen 1,2,3, BLU
268 x Active x 80 x 4.2.0.202401191938 x openHAB Add-ons :: Bundles :: Shelly Binding Gen 1,2,3, BLU
hope the right binding is active. do I only have to put the kar file into the addons folder?
now I can see a shelly binding and discovered things.
so added the Shelly 3EM as a thing
looking at the channels, I’m missing all relevant channels, like three power phases and your new current N channel.
UID: shelly:shellyem3:244cab4359da
label: Mains Power (shellyem3-244cab4359da@192.168.48.21)
thingTypeUID: shelly:shellyem3
configuration:
eventsCoIoT: true
deviceIp: 192.168.48.21
eventsSwitch: false
updateInterval: 60
eventsButton: false
eventsPush: false
channels:
- id: device#alarm
channelTypeUID: shelly:alarmTrigger
label: Alarm
description: Alarm Trigger, e.g. weak WiFi Signal detected or over heating
configuration: {}
- id: device#wifiSignal
channelTypeUID: system:signal-strength
label: Signal Strength
description: Signal strength as with values 0 (worst), 1, 2, 3 or 4 (best)
configuration: {}
- id: device#deviceName
channelTypeUID: shelly:deviceName
label: Device Name
description: Symbolic Device Name as configured in the Shelly App
configuration: {}
- id: device#accumulatedWatts
channelTypeUID: shelly:meterAccuWatts
label: Accumulated Power Consumption
description: Accumulated Power Consumption in Watts of the device (including all meters)
configuration: {}
- id: device#accumulatedWTotal
channelTypeUID: shelly:meterAccuTotal
label: Accumulated Total Power
description: Accumulated Total Power in kW/h of the device (including all meters)
configuration: {}
- id: device#accumulatedReturned
channelTypeUID: shelly:meterAccuReturned
label: Accumulated Apparent Power
description: Accumulated Apparent Power in kW/h of the device (including all meters)
configuration: {}
- id: device#resetTotals
channelTypeUID: shelly:meterResetTotals
label: Reset Energy Measurements
description: Resets totals measurement data
configuration: {}
- id: device#uptime
channelTypeUID: shelly:uptime
label: Uptime
description: Number of seconds since the device was powered up
configuration: {}
- id: device#updateAvailable
channelTypeUID: shelly:updateAvailable
label: Update available
description: "ON: A firmware update is available (use the Shelly App to perform update)"
configuration: {}
- id: device#heartBeat
channelTypeUID: shelly:heartBeat
label: Last Heartbeat
description: Last time we received a signal from the device (API result or
sensor report), This indicates that device communication works on the
network layer (WiFi + IP)
configuration: {}
- id: device#statusLed
channelTypeUID: shelly:ledStatusDisable
label: Disable Status LED
description: Disable LED indication for network status
configuration: {}
- id: relay#output
channelTypeUID: system:power
label: Power
description: null
configuration: {}
- id: relay#timerActive
channelTypeUID: shelly:timerActive
label: Auto ON/OFF timer active
description: "ON: A timer is active, OFF: no timer active"
configuration: {}
- id: relay#autoOn
channelTypeUID: shelly:timerAutoOn
label: Auto-ON Timer
description: When the output of the relay is switched off, it will be switched
back on automatically after n seconds
configuration: {}
- id: relay#autoOff
channelTypeUID: shelly:timerAutoOff
label: Auto-OFF Timer
description: When the output of the relay is switched on, it will be switched
back off automatically after n seconds
configuration: {}
Digging into the log doesn’t look promising, looks like the installed shelly binding has a problem:
2024-01-20 10:15:31.622 [INFO ] [org.openhab.core.Activator ] - Starting openHAB 4.2.0 (Build #3847)
2024-01-20 10:15:32.750 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Time zone set to 'Europe/Zurich'.
2024-01-20 10:15:32.753 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Locale set to 'en_CH'.
2024-01-20 10:15:34.518 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/events's Observer
2024-01-20 10:15:34.621 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/addons/suggestions's Observer
2024-01-20 10:15:34.642 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/addons/services's Observer
2024-01-20 10:15:48.695 [INFO ] [nternal.manager.ShellyManagerServlet] - Shelly Manager started at http(s)://192.168.48.196:8080/shelly/manager
2024-01-20 10:15:50.459 [INFO ] [.core.model.lsp.internal.ModelServer] - Started Language Server Protocol (LSP) service on port 5007
2024-01-20 10:15:53.501 [INFO ] [e.automation.internal.RuleEngineImpl] - Rule engine started.
2024-01-20 10:15:54.612 [ERROR] [shelly.internal.ShellyHandlerFactory] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (262)[org.openhab.binding.shelly.internal.ShellyHandlerFactory(337)] : Error during instantiation of the implementation object
java.lang.IllegalArgumentException: argument type mismatch
at jdk.internal.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) ~[?:?]
at jdk.internal.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:77) ~[?:?]
at jdk.internal.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) ~[?:?]
at java.lang.reflect.Constructor.newInstanceWithCaller(Constructor.java:499) ~[?:?]
at java.lang.reflect.Constructor.newInstance(Constructor.java:480) ~[?:?]
at org.apache.felix.scr.impl.inject.internal.ComponentConstructorImpl.newInstance(ComponentConstructorImpl.java:326) ~[?:?]
at org.apache.felix.scr.impl.manager.SingleComponentManager.createImplementationObject(SingleComponentManager.java:286) ~[?:?]
at org.apache.felix.scr.impl.manager.SingleComponentManager.createComponent(SingleComponentManager.java:115) ~[?:?]
at org.apache.felix.scr.impl.manager.SingleComponentManager.getService(SingleComponentManager.java:1002) ~[?:?]
at org.apache.felix.scr.impl.manager.SingleComponentManager.getServiceInternal(SingleComponentManager.java:975) ~[?:?]
at org.apache.felix.scr.impl.manager.SingleComponentManager.getService(SingleComponentManager.java:920) ~[?:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceFactoryUse$1.run(ServiceFactoryUse.java:220) ~[org.eclipse.osgi-3.18.0.jar:?]
at java.security.AccessController.doPrivileged(AccessController.java:318) [?:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceFactoryUse.factoryGetService(ServiceFactoryUse.java:217) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceFactoryUse.getService(ServiceFactoryUse.java:118) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceConsumer$2.getService(ServiceConsumer.java:48) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceRegistrationImpl.getService(ServiceRegistrationImpl.java:547) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.getService(ServiceRegistry.java:534) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.framework.BundleContextImpl.getService(BundleContextImpl.java:660) [org.eclipse.osgi-3.18.0.jar:?]
at org.apache.felix.scr.impl.manager.SingleRefPair.getServiceObject(SingleRefPair.java:88) [bundleFile:?]
at org.apache.felix.scr.impl.inject.methods.BindMethod.getServiceObject(BindMethod.java:675) [bundleFile:?]
at org.apache.felix.scr.impl.manager.DependencyManager.getServiceObject(DependencyManager.java:2612) [bundleFile:?]
at org.apache.felix.scr.impl.manager.DependencyManager.doInvokeBindMethod(DependencyManager.java:2078) [bundleFile:?]
at org.apache.felix.scr.impl.manager.DependencyManager.invokeBindMethod(DependencyManager.java:2061) [bundleFile:?]
at org.apache.felix.scr.impl.manager.SingleComponentManager.invokeBindMethod(SingleComponentManager.java:443) [bundleFile:?]
at org.apache.felix.scr.impl.manager.DependencyManager$MultipleDynamicCustomizer.addedService(DependencyManager.java:336) [bundleFile:?]
at org.apache.felix.scr.impl.manager.DependencyManager$MultipleDynamicCustomizer.addedService(DependencyManager.java:304) [bundleFile:?]
at org.apache.felix.scr.impl.manager.ServiceTracker$Tracked.customizerAdded(ServiceTracker.java:1232) [bundleFile:?]
at org.apache.felix.scr.impl.manager.ServiceTracker$Tracked.customizerAdded(ServiceTracker.java:1152) [bundleFile:?]
at org.apache.felix.scr.impl.manager.ServiceTracker$AbstractTracked.trackAdding(ServiceTracker.java:959) [bundleFile:?]
at org.apache.felix.scr.impl.manager.ServiceTracker$AbstractTracked.track(ServiceTracker.java:895) [bundleFile:?]
at org.apache.felix.scr.impl.manager.ServiceTracker$Tracked.serviceChanged(ServiceTracker.java:1184) [bundleFile:?]
at org.apache.felix.scr.impl.BundleComponentActivator$ListenerInfo.serviceChanged(BundleComponentActivator.java:116) [bundleFile:?]
at org.eclipse.osgi.internal.serviceregistry.FilteredServiceListener.serviceChanged(FilteredServiceListener.java:123) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.framework.BundleContextImpl.dispatchEvent(BundleContextImpl.java:961) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.framework.eventmgr.EventManager.dispatchEvent(EventManager.java:234) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.framework.eventmgr.ListenerQueue.dispatchEventSynchronous(ListenerQueue.java:151) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.publishServiceEventPrivileged(ServiceRegistry.java:937) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.publishServiceEvent(ServiceRegistry.java:874) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceRegistrationImpl.register(ServiceRegistrationImpl.java:141) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.registerService(ServiceRegistry.java:262) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.framework.BundleContextImpl.registerService(BundleContextImpl.java:500) [org.eclipse.osgi-3.18.0.jar:?]
at org.apache.felix.scr.impl.manager.AbstractComponentManager$3.register(AbstractComponentManager.java:929) [bundleFile:?]
at org.apache.felix.scr.impl.manager.AbstractComponentManager$3.register(AbstractComponentManager.java:915) [bundleFile:?]
at org.apache.felix.scr.impl.manager.RegistrationManager.changeRegistration(RegistrationManager.java:133) [bundleFile:?]
at org.apache.felix.scr.impl.manager.AbstractComponentManager.registerService(AbstractComponentManager.java:984) [bundleFile:?]
at org.apache.felix.scr.impl.manager.AbstractComponentManager.activateInternal(AbstractComponentManager.java:752) [bundleFile:?]
at org.apache.felix.scr.impl.manager.AbstractComponentManager.enableInternal(AbstractComponentManager.java:674) [bundleFile:?]
at org.apache.felix.scr.impl.manager.AbstractComponentManager.enable(AbstractComponentManager.java:437) [bundleFile:?]
at org.apache.felix.scr.impl.manager.ConfigurableComponentHolder.enableComponents(ConfigurableComponentHolder.java:671) [bundleFile:?]
at org.apache.felix.scr.impl.BundleComponentActivator.initialEnable(BundleComponentActivator.java:310) [bundleFile:?]
at org.apache.felix.scr.impl.Activator.loadComponents(Activator.java:593) [bundleFile:?]
at org.apache.felix.scr.impl.Activator.access$200(Activator.java:74) [bundleFile:?]
at org.apache.felix.scr.impl.Activator$ScrExtension.start(Activator.java:460) [bundleFile:?]
at org.apache.felix.scr.impl.AbstractExtender.createExtension(AbstractExtender.java:196) [bundleFile:?]
at org.apache.felix.scr.impl.AbstractExtender.modifiedBundle(AbstractExtender.java:169) [bundleFile:?]
at org.apache.felix.scr.impl.AbstractExtender.modifiedBundle(AbstractExtender.java:49) [bundleFile:?]
at org.osgi.util.tracker.BundleTracker$Tracked.customizerModified(BundleTracker.java:488) [osgi.core-8.0.0.jar:?]
at org.osgi.util.tracker.BundleTracker$Tracked.customizerModified(BundleTracker.java:420) [osgi.core-8.0.0.jar:?]
at org.osgi.util.tracker.AbstractTracked.track(AbstractTracked.java:232) [osgi.core-8.0.0.jar:?]
at org.osgi.util.tracker.BundleTracker$Tracked.bundleChanged(BundleTracker.java:450) [osgi.core-8.0.0.jar:?]
at org.eclipse.osgi.internal.framework.BundleContextImpl.dispatchEvent(BundleContextImpl.java:949) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.framework.eventmgr.EventManager.dispatchEvent(EventManager.java:234) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.framework.eventmgr.ListenerQueue.dispatchEventSynchronous(ListenerQueue.java:151) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.framework.EquinoxEventPublisher.publishBundleEventPrivileged(EquinoxEventPublisher.java:229) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.framework.EquinoxEventPublisher.publishBundleEvent(EquinoxEventPublisher.java:138) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.framework.EquinoxEventPublisher.publishBundleEvent(EquinoxEventPublisher.java:130) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.framework.EquinoxContainerAdaptor.publishModuleEvent(EquinoxContainerAdaptor.java:217) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.container.Module.publishEvent(Module.java:499) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.container.Module.start(Module.java:486) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.container.ModuleContainer$ContainerStartLevel$2.run(ModuleContainer.java:1847) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.framework.EquinoxContainerAdaptor$1$1.execute(EquinoxContainerAdaptor.java:136) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.container.ModuleContainer$ContainerStartLevel.incStartLevel(ModuleContainer.java:1840) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.container.ModuleContainer$ContainerStartLevel.incStartLevel(ModuleContainer.java:1783) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.container.ModuleContainer$ContainerStartLevel.doContainerStartLevel(ModuleContainer.java:1745) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.container.ModuleContainer$ContainerStartLevel.dispatchEvent(ModuleContainer.java:1667) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.container.ModuleContainer$ContainerStartLevel.dispatchEvent(ModuleContainer.java:1) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.framework.eventmgr.EventManager.dispatchEvent(EventManager.java:234) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.run(EventManager.java:345) [org.eclipse.osgi-3.18.0.jar:?]
2024-01-20 10:15:54.671 [WARN ] [g.discovery.internal.PersistentInbox] - bundle org.openhab.core.config.discovery:4.2.0.202401180308 (169)[org.openhab.core.config.discovery.internal.PersistentInbox(125)] : Could not get service from ref {org.openhab.core.thing.binding.ThingHandlerFactory, org.openhab.binding.shelly.internal.ShellyHandlerFactory}={service.id=510, service.bundleid=262, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.binding.shelly.internal.ShellyHandlerFactory, component.id=337}
2024-01-20 10:15:54.673 [WARN ] [g.discovery.internal.PersistentInbox] - bundle org.openhab.core.config.discovery:4.2.0.202401180308 (169)[org.openhab.core.config.discovery.internal.PersistentInbox(125)] : DependencyManager : invokeBindMethod : Service not available from service registry for ServiceReference {org.openhab.core.thing.binding.ThingHandlerFactory, org.openhab.binding.shelly.internal.ShellyHandlerFactory}={service.id=510, service.bundleid=262, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.binding.shelly.internal.ShellyHandlerFactory, component.id=337} for reference ThingHandlerFactory
2024-01-20 10:15:54.676 [ERROR] [shelly.internal.ShellyHandlerFactory] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (262)[org.openhab.binding.shelly.internal.ShellyHandlerFactory(337)] : Error during instantiation of the implementation object
java.lang.IllegalArgumentException: argument type mismatch
at jdk.internal.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) ~[?:?]
at jdk.internal.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:77) ~[?:?]
at jdk.internal.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) ~[?:?]
at java.lang.reflect.Constructor.newInstanceWithCaller(Constructor.java:499) ~[?:?]
at java.lang.reflect.Constructor.newInstance(Constructor.java:480) ~[?:?]
at org.apache.felix.scr.impl.inject.internal.ComponentConstructorImpl.newInstance(ComponentConstructorImpl.java:326) ~[?:?]
at org.apache.felix.scr.impl.manager.SingleComponentManager.createImplementationObject(SingleComponentManager.java:286) ~[?:?]
at org.apache.felix.scr.impl.manager.SingleComponentManager.createComponent(SingleComponentManager.java:115) ~[?:?]
at org.apache.felix.scr.impl.manager.SingleComponentManager.getService(SingleComponentManager.java:1002) ~[?:?]
at org.apache.felix.scr.impl.manager.SingleComponentManager.getServiceInternal(SingleComponentManager.java:975) ~[?:?]
at org.apache.felix.scr.impl.manager.SingleComponentManager.getService(SingleComponentManager.java:920) ~[?:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceFactoryUse$1.run(ServiceFactoryUse.java:220) ~[org.eclipse.osgi-3.18.0.jar:?]
at java.security.AccessController.doPrivileged(AccessController.java:318) [?:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceFactoryUse.factoryGetService(ServiceFactoryUse.java:217) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceFactoryUse.getService(ServiceFactoryUse.java:118) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceConsumer$2.getService(ServiceConsumer.java:48) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceRegistrationImpl.getService(ServiceRegistrationImpl.java:547) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.getService(ServiceRegistry.java:534) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.framework.BundleContextImpl.getService(BundleContextImpl.java:660) [org.eclipse.osgi-3.18.0.jar:?]
at org.apache.felix.scr.impl.manager.SingleRefPair.getServiceObject(SingleRefPair.java:88) [bundleFile:?]
at org.apache.felix.scr.impl.inject.methods.BindMethod.getServiceObject(BindMethod.java:675) [bundleFile:?]
at org.apache.felix.scr.impl.manager.DependencyManager.getServiceObject(DependencyManager.java:2612) [bundleFile:?]
at org.apache.felix.scr.impl.manager.DependencyManager.doInvokeBindMethod(DependencyManager.java:2078) [bundleFile:?]
at org.apache.felix.scr.impl.manager.DependencyManager.invokeBindMethod(DependencyManager.java:2061) [bundleFile:?]
at org.apache.felix.scr.impl.manager.SingleComponentManager.invokeBindMethod(SingleComponentManager.java:443) [bundleFile:?]
at org.apache.felix.scr.impl.manager.DependencyManager$MultipleDynamicCustomizer.addedService(DependencyManager.java:336) [bundleFile:?]
at org.apache.felix.scr.impl.manager.DependencyManager$MultipleDynamicCustomizer.addedService(DependencyManager.java:304) [bundleFile:?]
at org.apache.felix.scr.impl.manager.ServiceTracker$Tracked.customizerAdded(ServiceTracker.java:1232) [bundleFile:?]
at org.apache.felix.scr.impl.manager.ServiceTracker$Tracked.customizerAdded(ServiceTracker.java:1152) [bundleFile:?]
at org.apache.felix.scr.impl.manager.ServiceTracker$AbstractTracked.trackAdding(ServiceTracker.java:959) [bundleFile:?]
at org.apache.felix.scr.impl.manager.ServiceTracker$AbstractTracked.track(ServiceTracker.java:895) [bundleFile:?]
at org.apache.felix.scr.impl.manager.ServiceTracker$Tracked.serviceChanged(ServiceTracker.java:1184) [bundleFile:?]
at org.apache.felix.scr.impl.BundleComponentActivator$ListenerInfo.serviceChanged(BundleComponentActivator.java:116) [bundleFile:?]
at org.eclipse.osgi.internal.serviceregistry.FilteredServiceListener.serviceChanged(FilteredServiceListener.java:123) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.framework.BundleContextImpl.dispatchEvent(BundleContextImpl.java:961) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.framework.eventmgr.EventManager.dispatchEvent(EventManager.java:234) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.framework.eventmgr.ListenerQueue.dispatchEventSynchronous(ListenerQueue.java:151) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.publishServiceEventPrivileged(ServiceRegistry.java:937) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.publishServiceEvent(ServiceRegistry.java:874) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceRegistrationImpl.register(ServiceRegistrationImpl.java:141) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.registerService(ServiceRegistry.java:262) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.framework.BundleContextImpl.registerService(BundleContextImpl.java:500) [org.eclipse.osgi-3.18.0.jar:?]
at org.apache.felix.scr.impl.manager.AbstractComponentManager$3.register(AbstractComponentManager.java:929) [bundleFile:?]
at org.apache.felix.scr.impl.manager.AbstractComponentManager$3.register(AbstractComponentManager.java:915) [bundleFile:?]
at org.apache.felix.scr.impl.manager.RegistrationManager.changeRegistration(RegistrationManager.java:133) [bundleFile:?]
at org.apache.felix.scr.impl.manager.AbstractComponentManager.registerService(AbstractComponentManager.java:984) [bundleFile:?]
at org.apache.felix.scr.impl.manager.AbstractComponentManager.activateInternal(AbstractComponentManager.java:752) [bundleFile:?]
at org.apache.felix.scr.impl.manager.AbstractComponentManager.enableInternal(AbstractComponentManager.java:674) [bundleFile:?]
at org.apache.felix.scr.impl.manager.AbstractComponentManager.enable(AbstractComponentManager.java:437) [bundleFile:?]
at org.apache.felix.scr.impl.manager.ConfigurableComponentHolder.enableComponents(ConfigurableComponentHolder.java:671) [bundleFile:?]
at org.apache.felix.scr.impl.BundleComponentActivator.initialEnable(BundleComponentActivator.java:310) [bundleFile:?]
at org.apache.felix.scr.impl.Activator.loadComponents(Activator.java:593) [bundleFile:?]
at org.apache.felix.scr.impl.Activator.access$200(Activator.java:74) [bundleFile:?]
at org.apache.felix.scr.impl.Activator$ScrExtension.start(Activator.java:460) [bundleFile:?]
at org.apache.felix.scr.impl.AbstractExtender.createExtension(AbstractExtender.java:196) [bundleFile:?]
at org.apache.felix.scr.impl.AbstractExtender.modifiedBundle(AbstractExtender.java:169) [bundleFile:?]
at org.apache.felix.scr.impl.AbstractExtender.modifiedBundle(AbstractExtender.java:49) [bundleFile:?]
at org.osgi.util.tracker.BundleTracker$Tracked.customizerModified(BundleTracker.java:488) [osgi.core-8.0.0.jar:?]
at org.osgi.util.tracker.BundleTracker$Tracked.customizerModified(BundleTracker.java:420) [osgi.core-8.0.0.jar:?]
at org.osgi.util.tracker.AbstractTracked.track(AbstractTracked.java:232) [osgi.core-8.0.0.jar:?]
at org.osgi.util.tracker.BundleTracker$Tracked.bundleChanged(BundleTracker.java:450) [osgi.core-8.0.0.jar:?]
at org.eclipse.osgi.internal.framework.BundleContextImpl.dispatchEvent(BundleContextImpl.java:949) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.framework.eventmgr.EventManager.dispatchEvent(EventManager.java:234) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.framework.eventmgr.ListenerQueue.dispatchEventSynchronous(ListenerQueue.java:151) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.framework.EquinoxEventPublisher.publishBundleEventPrivileged(EquinoxEventPublisher.java:229) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.framework.EquinoxEventPublisher.publishBundleEvent(EquinoxEventPublisher.java:138) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.framework.EquinoxEventPublisher.publishBundleEvent(EquinoxEventPublisher.java:130) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.framework.EquinoxContainerAdaptor.publishModuleEvent(EquinoxContainerAdaptor.java:217) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.container.Module.publishEvent(Module.java:499) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.container.Module.start(Module.java:486) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.container.ModuleContainer$ContainerStartLevel$2.run(ModuleContainer.java:1847) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.framework.EquinoxContainerAdaptor$1$1.execute(EquinoxContainerAdaptor.java:136) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.container.ModuleContainer$ContainerStartLevel.incStartLevel(ModuleContainer.java:1840) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.container.ModuleContainer$ContainerStartLevel.incStartLevel(ModuleContainer.java:1783) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.container.ModuleContainer$ContainerStartLevel.doContainerStartLevel(ModuleContainer.java:1745) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.container.ModuleContainer$ContainerStartLevel.dispatchEvent(ModuleContainer.java:1667) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.container.ModuleContainer$ContainerStartLevel.dispatchEvent(ModuleContainer.java:1) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.framework.eventmgr.EventManager.dispatchEvent(EventManager.java:234) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.run(EventManager.java:345) [org.eclipse.osgi-3.18.0.jar:?]
2024-01-20 10:15:54.704 [WARN ] [.thing.internal.GenericThingProvider] - bundle org.openhab.core.model.thing:4.2.0.202401180309 (214)[org.openhab.core.model.thing.internal.GenericThingProvider(232)] : Could not get service from ref {org.openhab.core.thing.binding.ThingHandlerFactory, org.openhab.binding.shelly.internal.ShellyHandlerFactory}={service.id=510, service.bundleid=262, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.binding.shelly.internal.ShellyHandlerFactory, component.id=337}
2024-01-20 10:15:54.706 [WARN ] [.thing.internal.GenericThingProvider] - bundle org.openhab.core.model.thing:4.2.0.202401180309 (214)[org.openhab.core.model.thing.internal.GenericThingProvider(232)] : DependencyManager : invokeBindMethod : Service not available from service registry for ServiceReference {org.openhab.core.thing.binding.ThingHandlerFactory, org.openhab.binding.shelly.internal.ShellyHandlerFactory}={service.id=510, service.bundleid=262, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.binding.shelly.internal.ShellyHandlerFactory, component.id=337} for reference ThingHandlerFactory
2024-01-20 10:15:54.712 [ERROR] [shelly.internal.ShellyHandlerFactory] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (262)[org.openhab.binding.shelly.internal.ShellyHandlerFactory(337)] : Error during instantiation of the implementation object
java.lang.IllegalArgumentException: argument type mismatch
at jdk.internal.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) ~[?:?]
at jdk.internal.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:77) ~[?:?]
at jdk.internal.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) ~[?:?]
at java.lang.reflect.Constructor.newInstanceWithCaller(Constructor.java:499) ~[?:?]
at java.lang.reflect.Constructor.newInstance(Constructor.java:480) ~[?:?]
at org.apache.felix.scr.impl.inject.internal.ComponentConstructorImpl.newInstance(ComponentConstructorImpl.java:326) ~[?:?]
at org.apache.felix.scr.impl.manager.SingleComponentManager.createImplementationObject(SingleComponentManager.java:286) ~[?:?]
at org.apache.felix.scr.impl.manager.SingleComponentManager.createComponent(SingleComponentManager.java:115) ~[?:?]
at org.apache.felix.scr.impl.manager.SingleComponentManager.getService(SingleComponentManager.java:1002) ~[?:?]
at org.apache.felix.scr.impl.manager.SingleComponentManager.getServiceInternal(SingleComponentManager.java:975) ~[?:?]
at org.apache.felix.scr.impl.manager.SingleComponentManager.getService(SingleComponentManager.java:920) ~[?:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceFactoryUse$1.run(ServiceFactoryUse.java:220) ~[org.eclipse.osgi-3.18.0.jar:?]
at java.security.AccessController.doPrivileged(AccessController.java:318) [?:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceFactoryUse.factoryGetService(ServiceFactoryUse.java:217) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceFactoryUse.getService(ServiceFactoryUse.java:118) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceConsumer$2.getService(ServiceConsumer.java:48) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceRegistrationImpl.getService(ServiceRegistrationImpl.java:547) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.getService(ServiceRegistry.java:534) [org.eclipse.osgi-3.18.0.jar:?]
at org.eclipse.osgi.internal.framework.BundleContextImpl.getService(BundleContextImpl.java:660) [org.eclipse.osgi-3.18.0.jar:?]
You need to fix that first
- make sure Shelly binding is not installed in the UI
- remove binding jar/kar from addons folder
- check with bundle:list that no Shelly binding is there
- install the coap feature
- copy the kar into the addons folder
o.k. took again a new docker container with OH 4.2 Snapshot, Build #3847
no shelly binding installed, nothing in the addons.
on console ran
feature:install openhab-transport-coap
console crashed, logged back in and checked what’s installed:
openhab> feature:list | grep coap
openhab-core-io-transport-coap x 4.2.0.SNAPSHOT x x Started x distro-4.2.0-SNAPSHOT x
openhab-transport-coap x 4.2.0.SNAPSHOT x x x Started x distro-4.2.0-SNAPSHOT x CoAP Transport
openhab.tp-coap x 4.2.0.SNAPSHOT x x Started x distro-4.2.0-SNAPSHOT x Californium CoAP library
The logfile looks o.k.
2024-01-21 10:53:53.153 [INFO ] [org.openhab.core.Activator ] - Starting openHAB 4.2.0 (Build #3847)
2024-01-21 10:53:53.362 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Time zone set to 'Europe/Zurich'.
2024-01-21 10:53:53.364 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Locale set to 'en_CH'.
2024-01-21 10:53:55.170 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/addons/suggestions's Observer
2024-01-21 10:53:55.171 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/addons/services's Observer
2024-01-21 10:53:59.215 [INFO ] [.core.model.lsp.internal.ModelServer] - Started Language Server Protocol (LSP) service on port 5007
2024-01-21 10:54:00.137 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/events's Observer
2024-01-21 10:54:00.172 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/addons/services's Observer
2024-01-21 10:54:08.738 [INFO ] [e.automation.internal.RuleEngineImpl] - Rule engine started.
Restarted OH docker container, checking log again. Also check the coap feature being present. Nothing to see from a Shelly binding.
The log shows another exception:
2024-01-21 11:03:14.985 [INFO ] [org.openhab.core.Activator ] - Starting openHAB 4.2.0 (Build #3847)
2024-01-21 11:03:16.404 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Time zone set to 'Europe/Zurich'.
2024-01-21 11:03:16.407 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Locale set to 'en_CH'.
2024-01-21 11:03:16.894 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/events's Observer
2024-01-21 11:03:16.944 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/addons/suggestions's Observer
2024-01-21 11:03:16.966 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/addons/services's Observer
2024-01-21 11:03:21.252 [WARN ] [org.eclipse.jetty.server.HttpChannel] - /rest/events
java.lang.NullPointerException: Cannot invoke "org.apache.cxf.transport.MessageObserver.onMessage(org.apache.cxf.message.Message)" because "this.incomingObserver" is null
at org.apache.cxf.transport.http.AbstractHTTPDestination.invoke(AbstractHTTPDestination.java:265) ~[?:?]
at org.apache.cxf.transport.servlet.ServletController.invokeDestination(ServletController.java:234) ~[?:?]
at org.apache.cxf.transport.servlet.ServletController.invoke(ServletController.java:208) ~[?:?]
at org.apache.cxf.transport.servlet.ServletController.invoke(ServletController.java:160) ~[?:?]
at org.apache.cxf.transport.servlet.CXFNonSpringServlet.invoke(CXFNonSpringServlet.java:225) ~[?:?]
at org.apache.cxf.transport.servlet.AbstractHTTPServlet.handleRequest(AbstractHTTPServlet.java:304) ~[?:?]
at org.apache.cxf.transport.servlet.AbstractHTTPServlet.doGet(AbstractHTTPServlet.java:222) ~[?:?]
at javax.servlet.http.HttpServlet.service(HttpServlet.java:497) ~[bundleFile:4.0.4]
at org.apache.cxf.transport.servlet.AbstractHTTPServlet.service(AbstractHTTPServlet.java:279) ~[?:?]
at org.ops4j.pax.web.service.spi.servlet.OsgiInitializedServlet.service(OsgiInitializedServlet.java:102) ~[?:?]
at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:799) ~[?:?]
at org.eclipse.jetty.servlet.ServletHandler$ChainEnd.doFilter(ServletHandler.java:1656) ~[?:?]
at org.ops4j.pax.web.service.spi.servlet.OsgiFilterChain.doFilter(OsgiFilterChain.java:100) ~[?:?]
at org.ops4j.pax.web.service.jetty.internal.PaxWebServletHandler.doHandle(PaxWebServletHandler.java:320) ~[?:?]
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143) ~[bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:600) ~[?:?]
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) ~[bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:235) ~[bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1624) ~[bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233) ~[bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1440) ~[bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188) ~[bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:505) ~[?:?]
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1594) ~[bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186) ~[bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1355) ~[bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) ~[bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:234) ~[bundleFile:9.4.52.v20230823]
at org.ops4j.pax.web.service.jetty.internal.PrioritizedHandlerCollection.handle(PrioritizedHandlerCollection.java:96) ~[?:?]
at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:772) ~[bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) ~[bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.server.Server.handle(Server.java:516) ~[bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:487) ~[bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:732) ~[bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:479) [bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:277) [bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311) [bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:105) [bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.io.ssl.SslConnection$DecryptedEndPoint.onFillable(SslConnection.java:555) [bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:410) [bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.io.ssl.SslConnection$2.succeeded(SslConnection.java:164) [bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:105) [bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.io.ChannelEndPoint$1.run(ChannelEndPoint.java:104) [bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:338) [bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:315) [bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:173) [bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:131) [bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:409) [bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:883) [bundleFile:9.4.52.v20230823]
at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:1034) [bundleFile:9.4.52.v20230823]
at java.lang.Thread.run(Thread.java:840) [?:?]
2024-01-21 11:03:21.433 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/addons/suggestions's Observer
2024-01-21 11:03:21.466 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/addons/services's Observer
2024-01-21 11:03:34.125 [INFO ] [.core.model.lsp.internal.ModelServer] - Started Language Server Protocol (LSP) service on port 5007
2024-01-21 11:03:41.862 [INFO ] [e.automation.internal.RuleEngineImpl] - Rule engine started.
Shutdown OH docker container, copy kar file into addons, start OH.
Checking presence of shelly binding:
openhab> bundle:list | grep -i shelly
267 x Active x 80 x 4.2.0.202401191938 x openHAB Add-ons :: Bundles :: Shelly Binding Gen 1,2,3, BLU
270 x Active x 80 x 0 x wrap_file__openhab_userdata_tmp_kar_shelly_org.openhab.binding.shelly-4.2.0-SNAPSHOT_org_lastnpe_eea_eea-all_2.2.1_eea-all-2.2.1.jar
Log seems to be o.k.
2024-01-21 11:08:32.597 [INFO ] [org.openhab.core.Activator ] - Starting openHAB 4.2.0 (Build #3847)
2024-01-21 11:08:33.455 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Time zone set to 'Europe/Zurich'.
2024-01-21 11:08:33.458 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Locale set to 'en_CH'.
2024-01-21 11:08:34.551 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/events's Observer
2024-01-21 11:08:34.572 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/addons/suggestions's Observer
2024-01-21 11:08:34.588 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/addons/services's Observer
2024-01-21 11:08:39.155 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/events's Observer
2024-01-21 11:08:39.178 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/addons/suggestions's Observer
2024-01-21 11:08:39.186 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/addons/services's Observer
2024-01-21 11:08:39.469 [INFO ] [core.karaf.internal.FeatureInstaller] - Some .kar files are not installed yet. Delaying add-on installation by 15s.
2024-01-21 11:08:47.454 [INFO ] [.core.model.lsp.internal.ModelServer] - Started Language Server Protocol (LSP) service on port 5007
2024-01-21 11:08:48.156 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/events's Observer
2024-01-21 11:08:48.197 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/addons/suggestions's Observer
2024-01-21 11:08:48.207 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/addons/services's Observer
2024-01-21 11:08:54.124 [INFO ] [e.automation.internal.RuleEngineImpl] - Rule engine started.
2024-01-21 11:08:54.482 [INFO ] [core.karaf.internal.FeatureInstaller] - Some .kar files are not installed yet. Delaying add-on installation by 15s.
2024-01-21 11:09:09.484 [INFO ] [core.karaf.internal.FeatureInstaller] - Some .kar files are not installed yet. Delaying add-on installation by 15s.
2024-01-21 11:09:26.652 [INFO ] [nternal.manager.ShellyManagerServlet] - Shelly Manager started at http(s)://192.168.48.196:8080/shelly/manager
Increasing log level
log:set DEBUG org.openhab.binding.log
On OH user interface, ran discovery of Shelly devices.
Added the Shelly 3EM as thing, which became online.
Again the channel list is very short, i.e. the essential measurement channels plus the new N current are still missing.
UID: shelly:shellyem3:244cab4359da
label: Mains Power (shellyem3-244cab4359da@192.168.48.21)
thingTypeUID: shelly:shellyem3
configuration:
eventsCoIoT: true
deviceIp: 192.168.48.21
eventsSwitch: false
updateInterval: 60
eventsButton: false
eventsPush: false
channels:
- id: device#alarm
channelTypeUID: shelly:alarmTrigger
label: Alarm
description: Alarm Trigger, e.g. weak WiFi Signal detected or over heating
configuration: {}
- id: device#wifiSignal
channelTypeUID: system:signal-strength
label: Signal Strength
description: Signal strength as with values 0 (worst), 1, 2, 3 or 4 (best)
configuration: {}
- id: device#deviceName
channelTypeUID: shelly:deviceName
label: Device Name
description: Symbolic Device Name as configured in the Shelly App
configuration: {}
- id: device#accumulatedWatts
channelTypeUID: shelly:meterAccuWatts
label: Accumulated Power Consumption
description: Accumulated Power Consumption in Watts of the device (including all meters)
configuration: {}
- id: device#accumulatedWTotal
channelTypeUID: shelly:meterAccuTotal
label: Accumulated Total Power
description: Accumulated Total Power in kW/h of the device (including all meters)
configuration: {}
- id: device#accumulatedReturned
channelTypeUID: shelly:meterAccuReturned
label: Accumulated Apparent Power
description: Accumulated Apparent Power in kW/h of the device (including all meters)
configuration: {}
- id: device#resetTotals
channelTypeUID: shelly:meterResetTotals
label: Reset Energy Measurements
description: Resets totals measurement data
configuration: {}
- id: device#uptime
channelTypeUID: shelly:uptime
label: Uptime
description: Number of seconds since the device was powered up
configuration: {}
- id: device#updateAvailable
channelTypeUID: shelly:updateAvailable
label: Update available
description: "ON: A firmware update is available (use the Shelly App to perform update)"
configuration: {}
- id: device#heartBeat
channelTypeUID: shelly:heartBeat
label: Last Heartbeat
description: Last time we received a signal from the device (API result or
sensor report), This indicates that device communication works on the
network layer (WiFi + IP)
configuration: {}
- id: device#statusLed
channelTypeUID: shelly:ledStatusDisable
label: Disable Status LED
description: Disable LED indication for network status
configuration: {}
- id: relay#output
channelTypeUID: system:power
label: Power
description: null
configuration: {}
- id: relay#timerActive
channelTypeUID: shelly:timerActive
label: Auto ON/OFF timer active
description: "ON: A timer is active, OFF: no timer active"
configuration: {}
- id: relay#autoOn
channelTypeUID: shelly:timerAutoOn
label: Auto-ON Timer
description: When the output of the relay is switched off, it will be switched
back on automatically after n seconds
configuration: {}
- id: relay#autoOff
channelTypeUID: shelly:timerAutoOff
label: Auto-OFF Timer
description: When the output of the relay is switched on, it will be switched
back off automatically after n seconds
configuration: {}
The continued log looks as follows.
Even 22 channel definitions have been found, the new N current has a problem. Does this exception prevent the thing being enriched by the channels?
Channel definition for meter#ncurrent not found!
2024-01-21 11:15:24.587 [INFO ] [nternal.manager.ShellyManagerServlet] - Shelly Manager started at http(s)://192.168.48.196:8080/shelly/manager
2024-01-21 11:15:24.592 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191938 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(333)] : Set implementation object for component
2024-01-21 11:15:24.594 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191938 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(333)] : Changed state from satisfied to active
2024-01-21 11:15:24.595 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191938 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(333)] : Querying state active
2024-01-21 11:15:24.597 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191938 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(333)] : invoking deactivate: deactivate: parameters []
2024-01-21 11:15:24.598 [DEBUG] [nternal.manager.ShellyManagerServlet] - ShellyManagerServlet stopped
2024-01-21 11:15:24.599 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191938 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(333)] : invoked deactivate: deactivate
2024-01-21 11:15:24.601 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191938 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(333)] : DependencyManager: osgi.ds.satisfying.condition close component unbinding from org.apache.felix.scr.impl.manager.ComponentContextImpl@28aa1f2d at tracking count 4 refpairs: [[RefPair: ref: [{org.osgi.service.condition.Condition}={service.id=6, service.bundleid=0, service.scope=singleton, service.pid=0.org.osgi.service.condition.ConditionImpl, osgi.condition.id=true}] service: [null]]]
2024-01-21 11:15:24.602 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191938 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(333)] : DependencyManager: $004 close component unbinding from org.apache.felix.scr.impl.manager.ComponentContextImpl@28aa1f2d at tracking count 6 refpairs: [[RefPair: ref: [{org.openhab.binding.shelly.internal.provider.ShellyTranslationProvider}={service.id=500, service.bundleid=267, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.binding.shelly.internal.provider.ShellyTranslationProvider, component.id=336}] service: [org.openhab.binding.shelly.internal.provider.ShellyTranslationProvider@425c33ee]]]
2024-01-21 11:15:24.604 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191938 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(333)] : DependencyManager: $003 close component unbinding from org.apache.felix.scr.impl.manager.ComponentContextImpl@28aa1f2d at tracking count 8 refpairs: [[RefPair: ref: [{org.openhab.core.thing.binding.ThingHandlerFactory, org.openhab.binding.shelly.internal.ShellyHandlerFactory}={service.id=512, service.bundleid=267, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), service.pid=binding.shelly, component.name=org.openhab.binding.shelly.internal.ShellyHandlerFactory, component.id=329}] service: [org.openhab.binding.shelly.internal.ShellyHandlerFactory@7b9f4e84]]]
2024-01-21 11:15:24.605 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191938 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(333)] : DependencyManager: $002 close component unbinding from org.apache.felix.scr.impl.manager.ComponentContextImpl@28aa1f2d at tracking count 3 refpairs: [[RefPair: ref: [{org.openhab.core.io.net.http.HttpClientFactory, org.openhab.core.io.net.http.WebSocketFactory}={service.id=286, service.bundleid=182, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.core.io.net.http.internal.WebClientFactoryImpl, component.id=153}] service: [org.openhab.core.io.net.http.internal.WebClientFactoryImpl@4d3e5792]]]
2024-01-21 11:15:24.607 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191938 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(333)] : DependencyManager: $001 close component unbinding from org.apache.felix.scr.impl.manager.ComponentContextImpl@28aa1f2d at tracking count 2 refpairs: [[RefPair: ref: [{org.openhab.core.net.NetworkAddressService}={service.id=195, service.bundleid=156, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), service.config.category=system, service.pid=org.openhab.network, service.config.label=Network Settings, component.name=org.openhab.core.net.NetUtil, service.config.description.uri=system:network, component.id=35}] service: [org.openhab.core.net.NetUtil@35956a6f]]]
2024-01-21 11:15:24.608 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191938 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(333)] : DependencyManager: $000 close component unbinding from org.apache.felix.scr.impl.manager.ComponentContextImpl@28aa1f2d at tracking count 1 refpairs: [[RefPair: ref: [{org.osgi.service.cm.ConfigurationAdmin}={osgi.command.scope=cm, service.description=Configuration Admin Service Specification 1.6 Implementation, service.id=40, service.bundleid=12, service.scope=bundle, osgi.command.function=[getConfiguration,getFactoryConfiguration,listConfigurations,createFactoryConfiguration], service.vendor=The Apache Software Foundation, config.plugins=, service.pid=org.apache.felix.cm.ConfigurationAdmin}] service: [org.apache.felix.cm.impl.ConfigurationAdminImpl@1675ec70]]]
2024-01-21 11:15:24.609 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191938 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(333)] : Unset and deconfigured implementation object for component in deleteComponent for reason Unspecified
2024-01-21 11:15:24.611 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191938 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(333)] : Changed state from active to satisfied
2024-01-21 11:15:24.616 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191938 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(333)] : dm $003 tracking 8 SingleStatic added {org.openhab.core.thing.binding.ThingHandlerFactory, org.openhab.binding.shelly.internal.ShellyHandlerFactory}={service.id=512, service.bundleid=267, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), service.pid=binding.shelly, component.name=org.openhab.binding.shelly.internal.ShellyHandlerFactory, component.id=329} (exit)
2024-01-21 11:15:24.617 [DEBUG] [shelly.internal.ShellyHandlerFactory] - bundle org.openhab.binding.shelly:4.2.0.202401191938 (267)[org.openhab.binding.shelly.internal.ShellyHandlerFactory(329)] : ImmediateComponentHolder Finished configuring the dependency managers for component for pid binding.shelly
2024-01-21 11:15:24.618 [DEBUG] [shelly.internal.ShellyHandlerFactory] - bundle org.openhab.binding.shelly:4.2.0.202401191938 (267)[org.openhab.binding.shelly.internal.ShellyHandlerFactory(329)] : ImmediateComponentHolder Will not enable component for pid binding.shelly: holder enabled state: true, metadata enabled: true
2024-01-21 11:16:01.425 [DEBUG] [.discovery.ShellyBluDiscoveryService] - Starting BLU Discovery
2024-01-21 11:16:01.426 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyem3-244cab4359da: Shelly device discovered: IP-Adress=192.168.48.21, type=shellyem3
2024-01-21 11:16:01.624 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyem3-244cab4359da: Shelly settings : {"device":{"type":"SHEM-3","mac":"244CAB4359DA","hostname":"shellyem3-244CAB4359DA","num_outputs":1,"num_meters":0,"num_emeters":3,"report_period":1},"wifi_ap":{"enabled":false,"ssid":"shellyem3-244CAB4359DA","key":""},"wifi_sta":{"enabled":true,"ssid":"beanzIOT","ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"wifi_sta1":{"enabled":false,"ssid":null,"ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"ap_roaming":{"enabled":true,"threshold":-70},"mqtt": {"enable":false,"server":"192.168.33.3:1883","user":"","id":"shellyem3-244CAB4359DA","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": {"enabled":true,"update_period":15,"peer":""},"sntp":{"server":"time.google.com","enabled":true},"login":{"enabled":false,"unprotected":false,"username":"admin"},"pin_code":"","name":"Mains Power","fw":"20230913-114244/v1.14.0-gcb84623","pon_wifi_reset":false,"discoverable":false,"build_info":{"build_id":"20230913-114244/v1.14.0-gcb84623","build_timestamp":"2023-09-13T11:42:44Z","build_version":"1.0"},"cloud":{"enabled":false,"connected":false},"timezone":"Europe/Zurich","lat":47.490700,"lng":8.738800,"tzautodetect":true,"tz_utc_offset":3600,"tz_dst":false,"tz_dst_auto":true,"time":"12:16","unixtime":1705835761,"led_status_disable":false,"debug_enable":false,"allow_cross_origin":false,"actions":{"active":false,"names":["out_on_url","out_off_url","over_power_url","under_power_url","over_power_url","under_power_url","over_power_url","under_power_url","over_power_url","under_power_url","n_mismatch_url"]},"hwinfo":{"hw_revision":"dev-prototype", "batch_id":0},"cf_output":0,"relays":[{"name":null,"ison":false,"has_timer":false,"default_state":"off","auto_on":0.00,"auto_off":0.00,"schedule":false,"schedule_rules":[]}],"emeters":[{"name":"Phase 1","appliance_type":"General","max_power":0,"range_extender":1},{"name":"Phase 2","appliance_type":"General","max_power":0,"range_extender":1},{"name":"Phase 3","appliance_type":"General","max_power":0,"range_extender":1}],"emeter_n":{"range_extender":1,"mismatch_threshold":0.00},"eco_mode_enabled":true}
2024-01-21 11:16:01.631 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyem3-244cab4359da: Adding Shelly Mains Power, UID=shelly:shellyem3:244cab4359da
2024-01-21 11:16:01.665 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'shelly:shellyem3:244cab4359da' to inbox.
2024-01-21 11:16:01.667 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyplusi4-a8032ab619f0: Shelly device discovered: IP-Adress=192.168.48.45, type=shellyplusi4
2024-01-21 11:16:01.806 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplusi4-a8032ab619f0: Connect Rpc Socket (discovery = true)
2024-01-21 11:16:01.810 [DEBUG] [helly.internal.api2.Shelly2RpcSocket] - shellyplusi4-a8032ab619f0: Connect WebSocket, URI=ws://192.168.48.45/rpc
2024-01-21 11:16:01.906 [DEBUG] [helly.internal.api2.Shelly2RpcSocket] - shellyplusi4-a8032ab619f0: WebSocket connected /192.168.48.196:54113<-/192.168.48.45:80, Idle Timeout=2147483647
2024-01-21 11:16:01.936 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplusi4-a8032ab619f0: Closing Rpc API (socket is connected, discovery=true)
2024-01-21 11:16:01.937 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplusi4-a8032ab619f0: Disconnect Rpc Socket
2024-01-21 11:16:01.938 [DEBUG] [helly.internal.api2.Shelly2RpcSocket] - shellyplusi4-a8032ab619f0: Disconnecting WebSocket (/192.168.48.196:54113 -> /192.168.48.45:80)
2024-01-21 11:16:01.956 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplusi4-a8032ab619f0: WebSocket connection closed, status = 1006/Disconnected
2024-01-21 11:16:01.958 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyplusi4-a8032ab619f0: Shelly settings : {"ble":{"enable":false},"cloud":{"enable":false,"server":"iot.shelly.cloud:6012/jrpc"},"mqtt":{"enable":false,"rpc_ntf":"true","status_ntf":"false"},"sys":{"cfg_rev":13,"device":{"name":"Abwasser Pumpe Monitor","mac":"A8032AB619F0","fw_id":"20231219-133933/1.1.0-g34b5d4f","eco_mode":true,"discoverable":true},"location":{"tz":"Europe/Zurich","lat":47.61205,"lon":8.72529},"sntp":{"server":"ch.pool.ntp.org"},"debug":{"mqtt":{"enable":false},"websocket":{"enable":false},"udp":{}},"ui_data":{},"rpc_udp":{}},"wifi":{"ap":{"enable":false,"ssid":"ShellyPlusI4-A8032AB619F0","is_open":true,"range_extender":{"enable":false}},"sta":{"ssid":"beanzIOT","is_open":false,"enable":true,"ipv4mode":"dhcp"},"sta1":{"is_open":true,"enable":false,"ipv4mode":"dhcp"},"roam":{"rssi_thr":-80,"interval":60}},"input:0":{"id":0,"type":"switch","invert":false,"factory_reset":true},"input:1":{"id":1,"type":"switch","invert":false,"factory_reset":true},"input:2":{"id":2,"type":"switch","invert":false,"factory_reset":true},"input:3":{"id":3,"type":"switch","invert":false,"factory_reset":true}}
2024-01-21 11:16:01.959 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyplusi4-a8032ab619f0: Adding Shelly Abwasser Pumpe Monitor, UID=shelly:shellyplusi4:a8032ab619f0
2024-01-21 11:16:01.966 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'shelly:shellyplusi4:a8032ab619f0' to inbox.
2024-01-21 11:16:01.968 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shelly1pm-e09806a9d2e8: Shelly device discovered: IP-Adress=192.168.48.39, type=shelly1pm
2024-01-21 11:16:02.906 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shelly1pm-e09806a9d2e8: Shelly settings : {"device":{"type":"SHSW-PM","mac":"E09806A9D2E8","hostname":"shelly1pm-E09806A9D2E8","num_outputs":1,"num_meters":1},"wifi_ap":{"enabled":false,"ssid":"shelly1pm-E09806A9D2E8","key":""},"wifi_sta":{"enabled":true,"ssid":"beanzIOT","ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"wifi_sta1":{"enabled":false,"ssid":null,"ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"ap_roaming":{"enabled":false,"threshold":-90},"mqtt": {"enable":false,"server":"192.168.33.3:1883","user":"","id":"shelly1pm-E09806A9D2E8","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": {"enabled":true,"update_period":15,"peer":""},"sntp":{"server":"ch.pool.ntp.org","enabled":true},"login":{"enabled":false,"unprotected":false,"username":"admin"},"pin_code":"","name":"Power Abwasserpumpe","fw":"20230913-113709/v1.14.0-gcb84623","factory_reset_from_switch":true,"pon_wifi_reset":false,"discoverable":true,"build_info":{"build_id":"20230913-113709/v1.14.0-gcb84623","build_timestamp":"2023-09-13T11:37:09Z","build_version":"1.0"},"cloud":{"enabled":false,"connected":false},"timezone":"Europe/Zurich","lat":47.490700,"lng":8.738800,"tzautodetect":true,"tz_utc_offset":3600,"tz_dst":false,"tz_dst_auto":true,"time":"12:16","unixtime":1705835763,"led_status_disable":false,"debug_enable":false,"allow_cross_origin":false,"ext_switch_enable":false,"ext_switch_reverse":false,"ext_switch":{"0":{"relay_num":-1}},"actions":{"active":false,"names":["btn_on_url","btn_off_url","longpush_url","shortpush_url","out_on_url","out_off_url","lp_on_url","lp_off_url","report_url","report_url","report_url","ext_temp_over_url","ext_temp_under_url","ext_temp_over_url","ext_temp_under_url","ext_temp_over_url","ext_temp_under_url","ext_hum_over_url","ext_hum_under_url"]},"hwinfo":{"hw_revision":"prod-191219", "batch_id":1},"max_power":0,"supply_voltage":1,"power_correction":1.00,"mode" :"relay","longpush_time":800,"relays":[{"name":"Power Abwasserpumpe","appliance_type":"General","ison":true,"has_timer":false,"default_state":"on","btn_type":"toggle","btn_reverse":0,"auto_on":0.00,"auto_off":0.00,"schedule":false,"schedule_rules":[],"max_power":0}],"ext_sensors":{},"ext_temperature":{},"ext_humidity":{},"eco_mode_enabled":true}
2024-01-21 11:16:02.907 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shelly1pm-e09806a9d2e8: Adding Shelly Power Abwasserpumpe, UID=shelly:shelly1pm:e09806a9d2e8
2024-01-21 11:16:02.912 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'shelly:shelly1pm:e09806a9d2e8' to inbox.
2024-01-21 11:16:02.913 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyplus1-3c610572ccc4: Shelly device discovered: IP-Adress=192.168.48.46, type=shellyplus1
2024-01-21 11:16:03.037 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplus1-3c610572ccc4: Connect Rpc Socket (discovery = true)
2024-01-21 11:16:03.038 [DEBUG] [helly.internal.api2.Shelly2RpcSocket] - shellyplus1-3c610572ccc4: Connect WebSocket, URI=ws://192.168.48.46/rpc
2024-01-21 11:16:03.095 [DEBUG] [helly.internal.api2.Shelly2RpcSocket] - shellyplus1-3c610572ccc4: WebSocket connected /192.168.48.196:56497<-/192.168.48.46:80, Idle Timeout=2147483647
2024-01-21 11:16:03.098 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplus1-3c610572ccc4: Closing Rpc API (socket is connected, discovery=true)
2024-01-21 11:16:03.099 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplus1-3c610572ccc4: Disconnect Rpc Socket
2024-01-21 11:16:03.100 [DEBUG] [helly.internal.api2.Shelly2RpcSocket] - shellyplus1-3c610572ccc4: Disconnecting WebSocket (/192.168.48.196:56497 -> /192.168.48.46:80)
2024-01-21 11:16:03.105 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplus1-3c610572ccc4: WebSocket connection closed, status = 1006/Disconnected
2024-01-21 11:16:03.107 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyplus1-3c610572ccc4: Shelly settings : {"ble":{"enable":false},"cloud":{"enable":false,"server":"iot.shelly.cloud:6012/jrpc"},"mqtt":{"enable":false,"rpc_ntf":"true","status_ntf":"false"},"sys":{"cfg_rev":26,"device":{"name":"switch-1","mac":"3C610572CCC4","fw_id":"20231219-133950/1.1.0-g34b5d4f","eco_mode":true,"discoverable":true},"location":{"tz":"Europe/Zurich","lat":47.61205,"lon":8.72529},"sntp":{"server":"time.google.com"},"debug":{"mqtt":{"enable":false},"websocket":{"enable":false},"udp":{}},"ui_data":{},"rpc_udp":{}},"wifi":{"ap":{"enable":false,"ssid":"ShellyPlus1-3C610572CCC4","is_open":true,"range_extender":{"enable":false}},"sta":{"ssid":"beanzIOT","is_open":false,"enable":true,"ipv4mode":"dhcp"},"sta1":{"is_open":true,"enable":false,"ipv4mode":"dhcp"},"roam":{"rssi_thr":-80,"interval":60}},"input:0":{"id":0,"type":"button","invert":false,"factory_reset":true},"switch:0":{"id":0,"in_mode":"momentary","initial_state":"restore_last","auto_on":false,"auto_on_delay":60.0,"auto_off":false,"auto_off_delay":60.0}}
2024-01-21 11:16:03.108 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyplus1-3c610572ccc4: Adding Shelly switch-1, UID=shelly:shellyplus1:3c610572ccc4
2024-01-21 11:16:03.113 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'shelly:shellyplus1:3c610572ccc4' to inbox.
2024-01-21 11:17:43.674 [DEBUG] [shelly.internal.ShellyHandlerFactory] - Mains Power (shellyem3-244cab4359da@192.168.48.21): Create new thing of type shelly:shellyem3 using ShellyRelayHandler
2024-01-21 11:17:43.731 [DEBUG] [shelly.internal.ShellyHandlerFactory] - Thing handler for uid shelly:shellyem3:244cab4359da added, total things = 1
2024-01-21 11:17:45.749 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Using default userId admin from binding config
2024-01-21 11:17:45.750 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Using default password from bindingConfig (userId=admin)
2024-01-21 11:17:45.751 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Device config: Device address=192.168.48.21, HTTP user/password=admin/***, update interval=60
2024-01-21 11:17:45.752 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Configured Events: Button: false, Switch (on/off): false, Push: false, Roller: true, Sensor: true, CoIoT: true, Enable AutoCoIoT: true
2024-01-21 11:17:45.753 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Start initializing for thing Mains Power (shellyem3-244cab4359da@192.168.48.21), type shellyem3, IP address 192.168.48.21, Gen2: false, CoIoT: true
2024-01-21 11:17:46.046 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Auto-CoIoT is enabled, disabling action urls
2024-01-21 11:17:46.048 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Starting CoIoT (autoCoIoT=true/true)
2024-01-21 11:17:46.049 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: Starting CoAP Listener
2024-01-21 11:17:46.050 [DEBUG] [elly.internal.api1.Shelly1CoapServer] - Initializing CoIoT listener (local IP=192.168.48.196:5683)
2024-01-21 11:17:46.116 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: Using CoAP device description from successful HTTP /cit/d
2024-01-21 11:17:46.118 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Device Description for shellyem3-244cab4359da: {"blk":[{"I":1,"D":"relay_0"},{"I":2,"D":"emeter_0"},{"I":3,"D":"emeter_1"},{"I":4,"D":"emeter_2"},{"I":5,"D":"device"}],"sen":[{"I":9103,"T":"EVC","D":"cfgChanged","R":"U16","L":5},{"I":1101,"T":"S","D":"output","R":"0/1","L":1},{"I":4105,"T":"P","D":"power","U":"W","L":2},{"I":4106,"T":"E","D":"energy","U":"Wh","L":2},{"I":4107,"T":"E","D":"energyReturned","U":"Wh","L":2},{"I":4108,"T":"V","D":"voltage","U":"V","L":2},{"I":4109,"T":"I","D":"current","U":"A","L":2},{"I":4110,"T":"S","D":"powerFactor","R":["0/1","-1"],"L":2},{"I":4205,"T":"P","D":"power","U":"W","L":3},{"I":4206,"T":"E","D":"energy","U":"Wh","L":3},{"I":4207,"T":"E","D":"energyReturned","U":"Wh","L":3},{"I":4208,"T":"V","D":"voltage","U":"V","L":3},{"I":4209,"T":"I","D":"current","U":"A","L":3},{"I":4210,"T":"S","D":"powerFactor","R":["0/1","-1"],"L":3},{"I":4305,"T":"P","D":"power","U":"W","L":4},{"I":4306,"T":"E","D":"energy","U":"Wh","L":4},{"I":4307,"T":"E","D":"energyReturned","U":"Wh","L":4},{"I":4308,"T":"V","D":"voltage","U":"V","L":4},{"I":4309,"T":"I","D":"current","U":"A","L":4},{"I":4310,"T":"S","D":"powerFactor","R":["0/1","-1"],"L":4},{"I":6,"T":"I","D":"neutralCurrent","U":"A","L":5},{"I":6102,"T":"A","D":"overpower","R":["0/1","-1"],"L":1}]}
2024-01-21 11:17:46.121 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=1: relay_0
2024-01-21 11:17:46.122 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=2: emeter_0
2024-01-21 11:17:46.123 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=3: emeter_1
2024-01-21 11:17:46.123 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=4: emeter_2
2024-01-21 11:17:46.124 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=5: device
2024-01-21 11:17:46.131 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: Adding 22 sensor definitions
2024-01-21 11:17:46.133 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 9103: cfgChanged, Type=EVC, Range=U16, Links=5
2024-01-21 11:17:46.134 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 1101: output, Type=S, Range=0/1, Links=1
2024-01-21 11:17:46.135 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4105: power, Type=P, Range=null, Links=2
2024-01-21 11:17:46.135 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4106: energy, Type=E, Range=null, Links=2
2024-01-21 11:17:46.136 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4107: energyReturned, Type=E, Range=null, Links=2
2024-01-21 11:17:46.137 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4108: voltage, Type=V, Range=null, Links=2
2024-01-21 11:17:46.138 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4109: current, Type=I, Range=null, Links=2
2024-01-21 11:17:46.139 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4110: powerFactor, Type=S, Range=0/1;-1, Links=2
2024-01-21 11:17:46.140 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4205: power, Type=P, Range=null, Links=3
2024-01-21 11:17:46.141 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4206: energy, Type=E, Range=null, Links=3
2024-01-21 11:17:46.142 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4207: energyReturned, Type=E, Range=null, Links=3
2024-01-21 11:17:46.143 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4208: voltage, Type=V, Range=null, Links=3
2024-01-21 11:17:46.144 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4209: current, Type=I, Range=null, Links=3
2024-01-21 11:17:46.145 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4210: powerFactor, Type=S, Range=0/1;-1, Links=3
2024-01-21 11:17:46.145 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4305: power, Type=P, Range=null, Links=4
2024-01-21 11:17:46.146 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4306: energy, Type=E, Range=null, Links=4
2024-01-21 11:17:46.147 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4307: energyReturned, Type=E, Range=null, Links=4
2024-01-21 11:17:46.148 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4308: voltage, Type=V, Range=null, Links=4
2024-01-21 11:17:46.149 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4309: current, Type=I, Range=null, Links=4
2024-01-21 11:17:46.150 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4310: powerFactor, Type=S, Range=0/1;-1, Links=4
2024-01-21 11:17:46.151 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 6: neutralCurrent, Type=I, Range=null, Links=5
2024-01-21 11:17:46.152 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 6102: overpower, Type=A, Range=0/1;-1, Links=1
2024-01-21 11:17:46.156 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Updating channel definitions, 9 channels
2024-01-21 11:17:46.157 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#deviceName
2024-01-21 11:17:46.159 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#accumulatedWatts
2024-01-21 11:17:46.181 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#accumulatedWTotal
2024-01-21 11:17:46.182 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#accumulatedReturned
2024-01-21 11:17:46.183 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#resetTotals
2024-01-21 11:17:46.184 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#uptime
2024-01-21 11:17:46.185 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#updateAvailable
2024-01-21 11:17:46.186 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#heartBeat
2024-01-21 11:17:46.187 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#statusLed
2024-01-21 11:17:46.198 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel definitions updated
2024-01-21 11:17:46.208 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Initializing device shelly-4359D, type SHEM-3, Hardware: Rev: dev-prototype, batch 0; Firmware: 1.14.0- / 20230913
2024-01-21 11:17:46.209 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Shelly settings info for shelly-4359D: {"device":{"type":"SHEM-3","mac":"244CAB4359DA","hostname":"shellyem3-244CAB4359DA","num_outputs":1,"num_meters":0,"num_emeters":3,"report_period":1},"wifi_ap":{"enabled":false,"ssid":"shellyem3-244CAB4359DA","key":""},"wifi_sta":{"enabled":true,"ssid":"beanzIOT","ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"wifi_sta1":{"enabled":false,"ssid":null,"ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"ap_roaming":{"enabled":true,"threshold":-70},"mqtt": {"enable":false,"server":"192.168.33.3:1883","user":"","id":"shellyem3-244CAB4359DA","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": {"enabled":true,"update_period":15,"peer":""},"sntp":{"server":"time.google.com","enabled":true},"login":{"enabled":false,"unprotected":false,"username":"admin"},"pin_code":"","name":"Mains Power","fw":"20230913-114244/v1.14.0-gcb84623","pon_wifi_reset":false,"discoverable":false,"build_info":{"build_id":"20230913-114244/v1.14.0-gcb84623","build_timestamp":"2023-09-13T11:42:44Z","build_version":"1.0"},"cloud":{"enabled":false,"connected":false},"timezone":"Europe/Zurich","lat":47.490700,"lng":8.738800,"tzautodetect":true,"tz_utc_offset":3600,"tz_dst":false,"tz_dst_auto":true,"time":"12:17","unixtime":1705835865,"led_status_disable":false,"debug_enable":false,"allow_cross_origin":false,"actions":{"active":false,"names":["out_on_url","out_off_url","over_power_url","under_power_url","over_power_url","under_power_url","over_power_url","under_power_url","over_power_url","under_power_url","n_mismatch_url"]},"hwinfo":{"hw_revision":"dev-prototype", "batch_id":0},"cf_output":0,"relays":[{"name":null,"ison":false,"has_timer":false,"default_state":"off","auto_on":0.00,"auto_off":0.00,"schedule":false,"schedule_rules":[]}],"emeters":[{"name":"Phase 1","appliance_type":"General","max_power":0,"range_extender":1},{"name":"Phase 2","appliance_type":"General","max_power":0,"range_extender":1},{"name":"Phase 3","appliance_type":"General","max_power":0,"range_extender":1}],"emeter_n":{"range_extender":1,"mismatch_threshold":0.00},"eco_mode_enabled":true}
2024-01-21 11:17:46.211 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Device hasRelays:true (numRelays=1),isRoller:false (numRoller=0),isDimmer:false,numMeter=3,isEMeter:true), ext. Switch Add-On: n/a,isSensor:false,isDS:false,hasBattery:false,isSense:false,isMotion:false,isLight:false,isBulb:false,isDuo:false,isRGBW2:false,inColor:false, BLU Gateway support: true,alwaysOn:70, updatePeriod:falsesec
2024-01-21 11:17:46.212 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Thing successfully initialized.
2024-01-21 11:17:46.230 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Update status job started, interval=20*3=60sec.
2024-01-21 11:17:48.356 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Updating channel definitions, 4 channels
2024-01-21 11:17:48.357 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel relay#output
2024-01-21 11:17:48.358 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel relay#timerActive
2024-01-21 11:17:48.359 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel relay#autoOn
2024-01-21 11:17:48.360 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel relay#autoOff
2024-01-21 11:17:48.372 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel definitions updated
2024-01-21 11:17:48.379 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Unable to refresh status: Unable to update status
java.lang.IllegalArgumentException: Channel definition for meter#ncurrent not found!
at org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions$ChannelMap.get(ShellyChannelDefinitions.java:788) ~[?:?]
at org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions.getDefinition(ShellyChannelDefinitions.java:297) ~[?:?]
at org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions.addChannel(ShellyChannelDefinitions.java:602) ~[?:?]
at org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions.createEMNCurrentChannels(ShellyChannelDefinitions.java:507) ~[?:?]
at org.openhab.binding.shelly.internal.handler.ShellyComponents.updateMeters(ShellyComponents.java:269) ~[?:?]
at org.openhab.binding.shelly.internal.handler.ShellyBaseHandler.refreshStatus(ShellyBaseHandler.java:574) ~[?:?]
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:539) [?:?]
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305) [?:?]
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:305) [?:?]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) [?:?]
at java.lang.Thread.run(Thread.java:840) [?:?]
2024-01-21 11:17:50.089 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Message from /192.168.48.21:5683 (MID=14450): {"G":[[0,9103,0],[0,1101,0],[0,4105,66.26],[0,4106,1848175.4],[0,4107,323446.6],[0,4108,226.55],[0,4109,0.34],[0,4110,0.87],[0,4205,67.59],[0,4206,2158873.3],[0,4207,241639.1],[0,4208,223.91],[0,4209,0.47],[0,4210,0.64],[0,4305,143.56],[0,4306,2596980.5],[0,4307,274044.7],[0,4308,228.44],[0,4309,0.91],[0,4310,0.69],[0,6,0.57],[0,6102,0]]}
2024-01-21 11:17:50.100 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Version 2 detected
2024-01-21 11:17:50.102 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Sensor data {"G":[[0,9103,0],[0,1101,0],[0,4105,66.26],[0,4106,1848175.4],[0,4107,323446.6],[0,4108,226.55],[0,4109,0.34],[0,4110,0.87],[0,4205,67.59],[0,4206,2158873.3],[0,4207,241639.1],[0,4208,223.91],[0,4209,0.47],[0,4210,0.64],[0,4305,143.56],[0,4306,2596980.5],[0,4307,274044.7],[0,4308,228.44],[0,4309,0.91],[0,4310,0.69],[0,6,0.57],[0,6102,0]]} (serial=43371)
2024-01-21 11:17:50.103 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: 22 CoAP sensor updates received
2024-01-21 11:17:50.112 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: 18 channels updated from CoIoT status, serial=43371
2024-01-21 11:17:50.161 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Message from /192.168.48.21:5683 (MID=51802): {"G":[[0,9103,0],[0,1101,0],[0,4105,66.26],[0,4106,1848175.4],[0,4107,323446.6],[0,4108,226.55],[0,4109,0.34],[0,4110,0.87],[0,4205,67.59],[0,4206,2158873.3],[0,4207,241639.1],[0,4208,223.91],[0,4209,0.47],[0,4210,0.64],[0,4305,143.56],[0,4306,2596980.5],[0,4307,274044.7],[0,4308,228.44],[0,4309,0.91],[0,4310,0.69],[0,6,0.57],[0,6102,0]]}
2024-01-21 11:17:50.163 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Sensor data {"G":[[0,9103,0],[0,1101,0],[0,4105,66.26],[0,4106,1848175.4],[0,4107,323446.6],[0,4108,226.55],[0,4109,0.34],[0,4110,0.87],[0,4205,67.59],[0,4206,2158873.3],[0,4207,241639.1],[0,4208,223.91],[0,4209,0.47],[0,4210,0.64],[0,4305,143.56],[0,4306,2596980.5],[0,4307,274044.7],[0,4308,228.44],[0,4309,0.91],[0,4310,0.69],[0,6,0.57],[0,6102,0]]} (serial=43371)
2024-01-21 11:17:50.164 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: 22 CoAP sensor updates received
2024-01-21 11:17:50.170 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: 18 channels updated from CoIoT status, serial=43371
2024-01-21 11:17:51.496 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Unable to refresh status: Unable to update status
java.lang.IllegalArgumentException: Channel definition for meter#ncurrent not found!
at org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions$ChannelMap.get(ShellyChannelDefinitions.java:788) ~[?:?]
at org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions.getDefinition(ShellyChannelDefinitions.java:297) ~[?:?]
at org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions.addChannel(ShellyChannelDefinitions.java:602) ~[?:?]
at org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions.createEMNCurrentChannels(ShellyChannelDefinitions.java:507) ~[?:?]
at org.openhab.binding.shelly.internal.handler.ShellyComponents.updateMeters(ShellyComponents.java:269) ~[?:?]
at org.openhab.binding.shelly.internal.handler.ShellyBaseHandler.refreshStatus(ShellyBaseHandler.java:574) ~[?:?]
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:539) [?:?]
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305) [?:?]
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:305) [?:?]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) [?:?]
ok, I found the problem
check latest build
o.k. back the newest snapshot 4.2
prepared all settings on console as required.
this time, putting the kar file into addons was not really helpfull, no single shelly device became visible.
started over with the official shelly binding. now I was able to see 3EM with the same channels as before i.e. without your new features.
Q: do I need a new version of the kar file? could you please post it if so?
here’s the log so far. sorry not having better news for you!
2024-01-29 20:36:55.151 [INFO ] [org.openhab.core.Activator ] - Starting openHAB 4.2.0 (Build #3864)
2024-01-29 20:37:03.184 [WARN ] [org.openhab.core.net.NetUtil ] - Found multiple local interfaces - ignoring 192.168.48.196
2024-01-29 20:37:03.733 [INFO ] [.core.model.lsp.internal.ModelServer] - Started Language Server Protocol (LSP) service on port 5007
2024-01-29 20:37:10.665 [INFO ] [e.automation.internal.RuleEngineImpl] - Rule engine started.
2024-01-29 20:40:49.100 [WARN ] [service.internal.HttpServiceDisabled] - Http service has already been stopped
2024-01-29 20:40:49.824 [INFO ] [org.openhab.core.Activator ] - Starting openHAB 4.2.0 (Build #3864)
2024-01-29 20:40:54.193 [WARN ] [org.openhab.core.net.NetUtil ] - Found multiple local interfaces - ignoring 192.168.48.196
2024-01-29 20:41:00.249 [INFO ] [.core.model.lsp.internal.ModelServer] - Started Language Server Protocol (LSP) service on port 5007
2024-01-29 20:41:10.658 [INFO ] [e.automation.internal.RuleEngineImpl] - Rule engine started.
2024-01-29 20:42:42.697 [WARN ] [.io.rest.auth.internal.TokenResource] - Couldn't find a user with a session matching the provided refresh_token
2024-01-29 20:42:42.699 [WARN ] [.io.rest.auth.internal.TokenResource] - Token issuing failed: invalid_grant
2024-01-29 20:42:58.257 [INFO ] [p.auth.internal.AuthorizePageServlet] - First user account created: admin
2024-01-29 20:43:37.059 [INFO ] [nternal.manager.ShellyManagerServlet] - Shelly Manager started at http(s)://192.168.96.193:8080/shelly/manager
2024-01-29 20:44:10.179 [DEBUG] [discovery.ShellyDiscoveryParticipant] - bundle org.openhab.binding.shelly:4.2.0.202401290406 (267)[org.openhab.binding.shelly.internal.discovery.ShellyDiscoveryParticipant(333)] : Querying state active
2024-01-29 20:44:10.181 [DEBUG] [al.provider.ShellyChannelDefinitions] - bundle org.openhab.binding.shelly:4.2.0.202401290406 (267)[org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions(336)] : Querying state satisfied
2024-01-29 20:44:10.182 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401290406 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(335)] : Querying state satisfied
2024-01-29 20:44:10.184 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401290406 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(332)] : Querying state satisfied
2024-01-29 20:44:10.185 [DEBUG] [shelly.internal.ShellyHandlerFactory] - bundle org.openhab.binding.shelly:4.2.0.202401290406 (267)[org.openhab.binding.shelly.internal.ShellyHandlerFactory(331)] : Querying state active
2024-01-29 20:44:10.186 [DEBUG] [l.provider.ShellyTranslationProvider] - bundle org.openhab.binding.shelly:4.2.0.202401290406 (267)[org.openhab.binding.shelly.internal.provider.ShellyTranslationProvider(338)] : Querying state active
2024-01-29 20:44:10.187 [DEBUG] [ly.internal.handler.ShellyThingTable] - bundle org.openhab.binding.shelly:4.2.0.202401290406 (267)[org.openhab.binding.shelly.internal.handler.ShellyThingTable(334)] : Querying state active
2024-01-29 20:44:10.189 [DEBUG] [vider.ShellyStateDescriptionProvider] - bundle org.openhab.binding.shelly:4.2.0.202401290406 (267)[org.openhab.binding.shelly.internal.provider.ShellyStateDescriptionProvider(337)] : Querying state active
2024-01-29 20:44:50.110 [DEBUG] [.discovery.ShellyBluDiscoveryService] - Starting BLU Discovery
2024-01-29 20:44:50.312 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyem3-244cab4359da: Shelly device discovered: IP-Adress=192.168.48.21, type=shellyem3
2024-01-29 20:44:50.712 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyem3-244cab4359da: Shelly settings : {"device":{"type":"SHEM-3","mac":"244CAB4359DA","hostname":"shellyem3-244CAB4359DA","num_outputs":1,"num_meters":0,"num_emeters":3,"report_period":1},"wifi_ap":{"enabled":false,"ssid":"shellyem3-244CAB4359DA","key":""},"wifi_sta":{"enabled":true,"ssid":"beanzIOT","ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"wifi_sta1":{"enabled":false,"ssid":null,"ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"ap_roaming":{"enabled":true,"threshold":-70},"mqtt": {"enable":false,"server":"192.168.33.3:1883","user":"","id":"shellyem3-244CAB4359DA","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": {"enabled":true,"update_period":15,"peer":""},"sntp":{"server":"time.google.com","enabled":true},"login":{"enabled":false,"unprotected":false,"username":"admin"},"pin_code":"","name":"Mains Power","fw":"20230913-114244/v1.14.0-gcb84623","pon_wifi_reset":false,"discoverable":false,"build_info":{"build_id":"20230913-114244/v1.14.0-gcb84623","build_timestamp":"2023-09-13T11:42:44Z","build_version":"1.0"},"cloud":{"enabled":false,"connected":false},"timezone":"Europe/Zurich","lat":47.490700,"lng":8.738800,"tzautodetect":true,"tz_utc_offset":3600,"tz_dst":false,"tz_dst_auto":true,"time":"21:44","unixtime":1706561090,"led_status_disable":false,"debug_enable":false,"allow_cross_origin":false,"actions":{"active":false,"names":["out_on_url","out_off_url","over_power_url","under_power_url","over_power_url","under_power_url","over_power_url","under_power_url","over_power_url","under_power_url","n_mismatch_url"]},"hwinfo":{"hw_revision":"dev-prototype", "batch_id":0},"cf_output":0,"relays":[{"name":null,"ison":false,"has_timer":false,"default_state":"off","auto_on":0.00,"auto_off":0.00,"schedule":false,"schedule_rules":[]}],"emeters":[{"name":"Phase 1","appliance_type":"General","max_power":0,"range_extender":1},{"name":"Phase 2","appliance_type":"General","max_power":0,"range_extender":1},{"name":"Phase 3","appliance_type":"General","max_power":0,"range_extender":1}],"emeter_n":{"range_extender":1,"mismatch_threshold":0.00},"eco_mode_enabled":true}
2024-01-29 20:44:50.718 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyem3-244cab4359da: Adding Shelly Mains Power, UID=shelly:shellyem3:244cab4359da
2024-01-29 20:44:50.753 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'shelly:shellyem3:244cab4359da' to inbox.
2024-01-29 20:44:50.755 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyplusi4-a8032ab619f0: Shelly device discovered: IP-Adress=192.168.48.45, type=shellyplusi4
2024-01-29 20:44:50.864 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplusi4-a8032ab619f0: Connect Rpc Socket (discovery = true)
2024-01-29 20:44:50.869 [DEBUG] [helly.internal.api2.Shelly2RpcSocket] - shellyplusi4-a8032ab619f0: Connect WebSocket, URI=ws://192.168.48.45/rpc
2024-01-29 20:44:51.014 [DEBUG] [helly.internal.api2.Shelly2RpcSocket] - shellyplusi4-a8032ab619f0: WebSocket connected /192.168.48.196:58620<-/192.168.48.45:80, Idle Timeout=2147483647
2024-01-29 20:44:51.028 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplusi4-a8032ab619f0: Closing Rpc API (socket is connected, discovery=true)
2024-01-29 20:44:51.030 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplusi4-a8032ab619f0: Disconnect Rpc Socket
2024-01-29 20:44:51.031 [DEBUG] [helly.internal.api2.Shelly2RpcSocket] - shellyplusi4-a8032ab619f0: Disconnecting WebSocket (/192.168.48.196:58620 -> /192.168.48.45:80)
2024-01-29 20:44:51.037 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplusi4-a8032ab619f0: WebSocket connection closed, status = 1006/Disconnected
2024-01-29 20:44:51.040 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyplusi4-a8032ab619f0: Shelly settings : {"ble":{"enable":false},"cloud":{"enable":false,"server":"iot.shelly.cloud:6012/jrpc"},"mqtt":{"enable":false,"rpc_ntf":"true","status_ntf":"false"},"sys":{"cfg_rev":13,"device":{"name":"Abwasser Pumpe Monitor","mac":"A8032AB619F0","fw_id":"20231219-133933/1.1.0-g34b5d4f","eco_mode":true,"discoverable":true},"location":{"tz":"Europe/Zurich","lat":47.61205,"lon":8.72529},"sntp":{"server":"ch.pool.ntp.org"},"debug":{"mqtt":{"enable":false},"websocket":{"enable":false},"udp":{}},"ui_data":{},"rpc_udp":{}},"wifi":{"ap":{"enable":false,"ssid":"ShellyPlusI4-A8032AB619F0","is_open":true,"range_extender":{"enable":false}},"sta":{"ssid":"beanzIOT","is_open":false,"enable":true,"ipv4mode":"dhcp"},"sta1":{"is_open":true,"enable":false,"ipv4mode":"dhcp"},"roam":{"rssi_thr":-80,"interval":60}},"input:0":{"id":0,"type":"switch","invert":false,"factory_reset":true},"input:1":{"id":1,"type":"switch","invert":false,"factory_reset":true},"input:2":{"id":2,"type":"switch","invert":false,"factory_reset":true},"input:3":{"id":3,"type":"switch","invert":false,"factory_reset":true}}
2024-01-29 20:44:51.041 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyplusi4-a8032ab619f0: Adding Shelly Abwasser Pumpe Monitor, UID=shelly:shellyplusi4:a8032ab619f0
2024-01-29 20:44:51.047 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'shelly:shellyplusi4:a8032ab619f0' to inbox.
2024-01-29 20:44:51.048 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shelly1pm-e09806a9d2e8: Shelly device discovered: IP-Adress=192.168.48.39, type=shelly1pm
2024-01-29 20:44:51.269 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shelly1pm-e09806a9d2e8: Shelly settings : {"device":{"type":"SHSW-PM","mac":"E09806A9D2E8","hostname":"shelly1pm-E09806A9D2E8","num_outputs":1,"num_meters":1},"wifi_ap":{"enabled":false,"ssid":"shelly1pm-E09806A9D2E8","key":""},"wifi_sta":{"enabled":true,"ssid":"beanzIOT","ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"wifi_sta1":{"enabled":false,"ssid":null,"ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"ap_roaming":{"enabled":false,"threshold":-90},"mqtt": {"enable":false,"server":"192.168.33.3:1883","user":"","id":"shelly1pm-E09806A9D2E8","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": {"enabled":true,"update_period":15,"peer":""},"sntp":{"server":"ch.pool.ntp.org","enabled":true},"login":{"enabled":false,"unprotected":false,"username":"admin"},"pin_code":"","name":"Power Abwasserpumpe","fw":"20230913-113709/v1.14.0-gcb84623","factory_reset_from_switch":true,"pon_wifi_reset":false,"discoverable":true,"build_info":{"build_id":"20230913-113709/v1.14.0-gcb84623","build_timestamp":"2023-09-13T11:37:09Z","build_version":"1.0"},"cloud":{"enabled":false,"connected":false},"timezone":"Europe/Zurich","lat":47.490700,"lng":8.738800,"tzautodetect":true,"tz_utc_offset":3600,"tz_dst":false,"tz_dst_auto":true,"time":"21:44","unixtime":1706561091,"led_status_disable":false,"debug_enable":false,"allow_cross_origin":false,"ext_switch_enable":false,"ext_switch_reverse":false,"ext_switch":{"0":{"relay_num":-1}},"actions":{"active":false,"names":["btn_on_url","btn_off_url","longpush_url","shortpush_url","out_on_url","out_off_url","lp_on_url","lp_off_url","report_url","report_url","report_url","ext_temp_over_url","ext_temp_under_url","ext_temp_over_url","ext_temp_under_url","ext_temp_over_url","ext_temp_under_url","ext_hum_over_url","ext_hum_under_url"]},"hwinfo":{"hw_revision":"prod-191219", "batch_id":1},"max_power":0,"supply_voltage":1,"power_correction":1.00,"mode" :"relay","longpush_time":800,"relays":[{"name":"Power Abwasserpumpe","appliance_type":"General","ison":true,"has_timer":false,"default_state":"on","btn_type":"toggle","btn_reverse":0,"auto_on":0.00,"auto_off":0.00,"schedule":false,"schedule_rules":[],"max_power":0}],"ext_sensors":{},"ext_temperature":{},"ext_humidity":{},"eco_mode_enabled":true}
2024-01-29 20:44:51.270 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shelly1pm-e09806a9d2e8: Adding Shelly Power Abwasserpumpe, UID=shelly:shelly1pm:e09806a9d2e8
2024-01-29 20:44:51.275 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'shelly:shelly1pm:e09806a9d2e8' to inbox.
2024-01-29 20:44:51.277 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyplus1-3c610572ccc4: Shelly device discovered: IP-Adress=192.168.48.46, type=shellyplus1
2024-01-29 20:44:52.394 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplus1-3c610572ccc4: Connect Rpc Socket (discovery = true)
2024-01-29 20:44:52.396 [DEBUG] [helly.internal.api2.Shelly2RpcSocket] - shellyplus1-3c610572ccc4: Connect WebSocket, URI=ws://192.168.48.46/rpc
2024-01-29 20:44:52.420 [DEBUG] [helly.internal.api2.Shelly2RpcSocket] - shellyplus1-3c610572ccc4: WebSocket connected /192.168.48.196:32770<-/192.168.48.46:80, Idle Timeout=2147483647
2024-01-29 20:44:52.458 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplus1-3c610572ccc4: Closing Rpc API (socket is connected, discovery=true)
2024-01-29 20:44:52.459 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplus1-3c610572ccc4: Disconnect Rpc Socket
2024-01-29 20:44:52.460 [DEBUG] [helly.internal.api2.Shelly2RpcSocket] - shellyplus1-3c610572ccc4: Disconnecting WebSocket (/192.168.48.196:32770 -> /192.168.48.46:80)
2024-01-29 20:44:52.464 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplus1-3c610572ccc4: WebSocket connection closed, status = 1006/Disconnected
2024-01-29 20:44:52.465 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyplus1-3c610572ccc4: Shelly settings : {"ble":{"enable":false},"cloud":{"enable":false,"server":"iot.shelly.cloud:6012/jrpc"},"mqtt":{"enable":false,"rpc_ntf":"true","status_ntf":"false"},"sys":{"cfg_rev":26,"device":{"name":"switch-1","mac":"3C610572CCC4","fw_id":"20231219-133950/1.1.0-g34b5d4f","eco_mode":true,"discoverable":true},"location":{"tz":"Europe/Zurich","lat":47.61205,"lon":8.72529},"sntp":{"server":"time.google.com"},"debug":{"mqtt":{"enable":false},"websocket":{"enable":false},"udp":{}},"ui_data":{},"rpc_udp":{}},"wifi":{"ap":{"enable":false,"ssid":"ShellyPlus1-3C610572CCC4","is_open":true,"range_extender":{"enable":false}},"sta":{"ssid":"beanzIOT","is_open":false,"enable":true,"ipv4mode":"dhcp"},"sta1":{"is_open":true,"enable":false,"ipv4mode":"dhcp"},"roam":{"rssi_thr":-80,"interval":60}},"input:0":{"id":0,"type":"button","invert":false,"factory_reset":true},"switch:0":{"id":0,"in_mode":"momentary","initial_state":"restore_last","auto_on":false,"auto_on_delay":60.0,"auto_off":false,"auto_off_delay":60.0}}
2024-01-29 20:44:52.466 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyplus1-3c610572ccc4: Adding Shelly switch-1, UID=shelly:shellyplus1:3c610572ccc4
2024-01-29 20:44:52.471 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'shelly:shellyplus1:3c610572ccc4' to inbox.
2024-01-29 20:45:13.679 [DEBUG] [shelly.internal.ShellyHandlerFactory] - Mains Power (shellyem3-244cab4359da@192.168.48.21): Create new thing of type shelly:shellyem3 using ShellyRelayHandler
2024-01-29 20:45:13.742 [DEBUG] [shelly.internal.ShellyHandlerFactory] - Thing handler for uid shelly:shellyem3:244cab4359da added, total things = 1
2024-01-29 20:45:15.763 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Using default userId admin from binding config
2024-01-29 20:45:15.764 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Using default password from bindingConfig (userId=admin)
2024-01-29 20:45:15.765 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Device config: Device address=192.168.48.21, HTTP user/password=admin/***, update interval=60
2024-01-29 20:45:15.766 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Configured Events: Button: false, Switch (on/off): false, Push: false, Roller: true, Sensor: true, CoIoT: true, Enable AutoCoIoT: true
2024-01-29 20:45:15.767 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Start initializing for thing Mains Power (shellyem3-244cab4359da@192.168.48.21), type shellyem3, IP address 192.168.48.21, Gen2: false, CoIoT: true
2024-01-29 20:45:15.992 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Auto-CoIoT is enabled, disabling action urls
2024-01-29 20:45:15.993 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Starting CoIoT (autoCoIoT=true/true)
2024-01-29 20:45:15.994 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: Starting CoAP Listener
2024-01-29 20:45:15.995 [DEBUG] [elly.internal.api1.Shelly1CoapServer] - Initializing CoIoT listener (local IP=192.168.96.193:5683)
2024-01-29 20:45:16.055 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: Using CoAP device description from successful HTTP /cit/d
2024-01-29 20:45:16.056 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Device Description for shellyem3-244cab4359da: {"blk":[{"I":1,"D":"relay_0"},{"I":2,"D":"emeter_0"},{"I":3,"D":"emeter_1"},{"I":4,"D":"emeter_2"},{"I":5,"D":"device"}],"sen":[{"I":9103,"T":"EVC","D":"cfgChanged","R":"U16","L":5},{"I":1101,"T":"S","D":"output","R":"0/1","L":1},{"I":4105,"T":"P","D":"power","U":"W","L":2},{"I":4106,"T":"E","D":"energy","U":"Wh","L":2},{"I":4107,"T":"E","D":"energyReturned","U":"Wh","L":2},{"I":4108,"T":"V","D":"voltage","U":"V","L":2},{"I":4109,"T":"I","D":"current","U":"A","L":2},{"I":4110,"T":"S","D":"powerFactor","R":["0/1","-1"],"L":2},{"I":4205,"T":"P","D":"power","U":"W","L":3},{"I":4206,"T":"E","D":"energy","U":"Wh","L":3},{"I":4207,"T":"E","D":"energyReturned","U":"Wh","L":3},{"I":4208,"T":"V","D":"voltage","U":"V","L":3},{"I":4209,"T":"I","D":"current","U":"A","L":3},{"I":4210,"T":"S","D":"powerFactor","R":["0/1","-1"],"L":3},{"I":4305,"T":"P","D":"power","U":"W","L":4},{"I":4306,"T":"E","D":"energy","U":"Wh","L":4},{"I":4307,"T":"E","D":"energyReturned","U":"Wh","L":4},{"I":4308,"T":"V","D":"voltage","U":"V","L":4},{"I":4309,"T":"I","D":"current","U":"A","L":4},{"I":4310,"T":"S","D":"powerFactor","R":["0/1","-1"],"L":4},{"I":6,"T":"I","D":"neutralCurrent","U":"A","L":5},{"I":6102,"T":"A","D":"overpower","R":["0/1","-1"],"L":1}]}
2024-01-29 20:45:16.058 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=1: relay_0
2024-01-29 20:45:16.059 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=2: emeter_0
2024-01-29 20:45:16.060 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=3: emeter_1
2024-01-29 20:45:16.061 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=4: emeter_2
2024-01-29 20:45:16.062 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=5: device
2024-01-29 20:45:16.068 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: Adding 22 sensor definitions
2024-01-29 20:45:16.069 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 9103: cfgChanged, Type=EVC, Range=U16, Links=5
2024-01-29 20:45:16.071 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 1101: output, Type=S, Range=0/1, Links=1
2024-01-29 20:45:16.071 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4105: power, Type=P, Range=null, Links=2
2024-01-29 20:45:16.072 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4106: energy, Type=E, Range=null, Links=2
2024-01-29 20:45:16.073 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4107: energyReturned, Type=E, Range=null, Links=2
2024-01-29 20:45:16.074 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4108: voltage, Type=V, Range=null, Links=2
2024-01-29 20:45:16.075 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4109: current, Type=I, Range=null, Links=2
2024-01-29 20:45:16.076 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4110: powerFactor, Type=S, Range=0/1;-1, Links=2
2024-01-29 20:45:16.077 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4205: power, Type=P, Range=null, Links=3
2024-01-29 20:45:16.078 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4206: energy, Type=E, Range=null, Links=3
2024-01-29 20:45:16.078 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4207: energyReturned, Type=E, Range=null, Links=3
2024-01-29 20:45:16.079 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4208: voltage, Type=V, Range=null, Links=3
2024-01-29 20:45:16.080 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4209: current, Type=I, Range=null, Links=3
2024-01-29 20:45:16.081 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4210: powerFactor, Type=S, Range=0/1;-1, Links=3
2024-01-29 20:45:16.082 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4305: power, Type=P, Range=null, Links=4
2024-01-29 20:45:16.083 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4306: energy, Type=E, Range=null, Links=4
2024-01-29 20:45:16.084 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4307: energyReturned, Type=E, Range=null, Links=4
2024-01-29 20:45:16.085 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4308: voltage, Type=V, Range=null, Links=4
2024-01-29 20:45:16.086 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4309: current, Type=I, Range=null, Links=4
2024-01-29 20:45:16.087 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4310: powerFactor, Type=S, Range=0/1;-1, Links=4
2024-01-29 20:45:16.087 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 6: neutralCurrent, Type=I, Range=null, Links=5
2024-01-29 20:45:16.088 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: Invalid format for sensor defition detected, id=6
2024-01-29 20:45:16.089 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 6102: overpower, Type=A, Range=0/1;-1, Links=1
2024-01-29 20:45:16.090 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: WARNING: Incompatible device description detected for CoIoT version 2!
2024-01-29 20:45:16.095 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Updating channel definitions, 9 channels
2024-01-29 20:45:16.096 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#deviceName
2024-01-29 20:45:16.097 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#accumulatedWatts
2024-01-29 20:45:16.098 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#accumulatedWTotal
2024-01-29 20:45:16.098 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#accumulatedReturned
2024-01-29 20:45:16.099 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#resetTotals
2024-01-29 20:45:16.100 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#uptime
2024-01-29 20:45:16.101 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#updateAvailable
2024-01-29 20:45:16.102 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#heartBeat
2024-01-29 20:45:16.103 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#statusLed
2024-01-29 20:45:16.112 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel definitions updated
2024-01-29 20:45:16.125 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Initializing device shelly-4359D, type SHEM-3, Hardware: Rev: dev-prototype, batch 0; Firmware: 1.14.0- / 20230913
2024-01-29 20:45:16.126 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Shelly settings info for shelly-4359D: {"device":{"type":"SHEM-3","mac":"244CAB4359DA","hostname":"shellyem3-244CAB4359DA","num_outputs":1,"num_meters":0,"num_emeters":3,"report_period":1},"wifi_ap":{"enabled":false,"ssid":"shellyem3-244CAB4359DA","key":""},"wifi_sta":{"enabled":true,"ssid":"beanzIOT","ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"wifi_sta1":{"enabled":false,"ssid":null,"ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"ap_roaming":{"enabled":true,"threshold":-70},"mqtt": {"enable":false,"server":"192.168.33.3:1883","user":"","id":"shellyem3-244CAB4359DA","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": {"enabled":true,"update_period":15,"peer":""},"sntp":{"server":"time.google.com","enabled":true},"login":{"enabled":false,"unprotected":false,"username":"admin"},"pin_code":"","name":"Mains Power","fw":"20230913-114244/v1.14.0-gcb84623","pon_wifi_reset":false,"discoverable":false,"build_info":{"build_id":"20230913-114244/v1.14.0-gcb84623","build_timestamp":"2023-09-13T11:42:44Z","build_version":"1.0"},"cloud":{"enabled":false,"connected":false},"timezone":"Europe/Zurich","lat":47.490700,"lng":8.738800,"tzautodetect":true,"tz_utc_offset":3600,"tz_dst":false,"tz_dst_auto":true,"time":"21:45","unixtime":1706561115,"led_status_disable":false,"debug_enable":false,"allow_cross_origin":false,"actions":{"active":false,"names":["out_on_url","out_off_url","over_power_url","under_power_url","over_power_url","under_power_url","over_power_url","under_power_url","over_power_url","under_power_url","n_mismatch_url"]},"hwinfo":{"hw_revision":"dev-prototype", "batch_id":0},"cf_output":0,"relays":[{"name":null,"ison":false,"has_timer":false,"default_state":"off","auto_on":0.00,"auto_off":0.00,"schedule":false,"schedule_rules":[]}],"emeters":[{"name":"Phase 1","appliance_type":"General","max_power":0,"range_extender":1},{"name":"Phase 2","appliance_type":"General","max_power":0,"range_extender":1},{"name":"Phase 3","appliance_type":"General","max_power":0,"range_extender":1}],"emeter_n":{"range_extender":1,"mismatch_threshold":0.00},"eco_mode_enabled":true}
2024-01-29 20:45:16.128 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Device hasRelays:true (numRelays=1),isRoller:false (numRoller=0),isDimmer:false,numMeter=3,isEMeter:true), ext. Switch Add-On: n/a,isSensor:false,isDS:false,hasBattery:false,isSense:false,isMotion:false,isLight:false,isBulb:false,isDuo:false,isRGBW2:false,inColor:false, BLU Gateway support: true,alwaysOn:70, updatePeriod:falsesec
2024-01-29 20:45:16.129 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Thing successfully initialized.
2024-01-29 20:45:16.147 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Update status job started, interval=20*3=60sec.
2024-01-29 20:45:18.245 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Updating channel definitions, 4 channels
2024-01-29 20:45:18.246 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel relay#output
2024-01-29 20:45:18.247 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel relay#timerActive
2024-01-29 20:45:18.248 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel relay#autoOn
2024-01-29 20:45:18.249 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel relay#autoOff
2024-01-29 20:45:18.259 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel definitions updated
2024-01-29 20:45:18.264 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Updating channel definitions, 7 channels
2024-01-29 20:45:18.265 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter1#currentWatts
2024-01-29 20:45:18.266 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter1#totalKWH
2024-01-29 20:45:18.267 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter1#returnedKWH
2024-01-29 20:45:18.268 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter1#voltage
2024-01-29 20:45:18.269 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter1#current
2024-01-29 20:45:18.270 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter1#powerFactor
2024-01-29 20:45:18.271 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter1#lastUpdate
2024-01-29 20:45:18.285 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel definitions updated
2024-01-29 20:45:18.288 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Updating channel definitions, 7 channels
2024-01-29 20:45:18.290 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter2#currentWatts
2024-01-29 20:45:18.291 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter2#totalKWH
2024-01-29 20:45:18.292 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter2#returnedKWH
2024-01-29 20:45:18.293 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter2#voltage
2024-01-29 20:45:18.294 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter2#current
2024-01-29 20:45:18.295 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter2#powerFactor
2024-01-29 20:45:18.296 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter2#lastUpdate
2024-01-29 20:45:18.312 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel definitions updated
2024-01-29 20:45:18.314 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Updating channel definitions, 7 channels
2024-01-29 20:45:18.316 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter3#currentWatts
2024-01-29 20:45:18.317 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter3#totalKWH
2024-01-29 20:45:18.318 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter3#returnedKWH
2024-01-29 20:45:18.319 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter3#voltage
2024-01-29 20:45:18.320 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter3#current
2024-01-29 20:45:18.321 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter3#powerFactor
2024-01-29 20:45:18.322 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter3#lastUpdate
2024-01-29 20:45:18.338 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel definitions updated
2024-01-29 20:46:15.393 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Enabling channel cache (20 updates / 60s)
then try the jar file
(it requires to have the coap feature installed)
Maybe a openhab-cli clean-cache is required, sometimes there are left overs when removing a bundle from the addons folder
that’s the beauty running OH under docker. within 5 minutes I have a brand new instance running.
ensured coap is present:
openhab> feature:install openhab-transport-coap
openhab> feature:list | grep -i coap
openhab-core-io-transport-coap x 4.2.0.SNAPSHOT x x Started x distro-4.2.0-SNAPSHOT x
openhab-transport-coap x 4.2.0.SNAPSHOT x x x Started x distro-4.2.0-SNAPSHOT x CoAP Transport
openhab.tp-coap x 4.2.0.SNAPSHOT x x Started x distro-4.2.0-SNAPSHOT x Californium CoAP library
openhab> bundle:list | grep -i shelly
openhab> log:set DEBUG org.openhab.binding.log
then threw the jar package into the addons and restarted.
openhab> bundle:list | grep -i shelly
267 x Active x 80 x 4.2.0.202401191937 x openHAB Add-ons :: Bundles :: Shelly Binding Gen 1,2,3, BLU
Scanned for Shelly devices works manually, added 3EM as a thing.
Unfortunately I get only a few channels with that binding:
UID: shelly:shellyem3:244cab4359da
label: Mains Power (shellyem3-244cab4359da@192.168.48.21)
thingTypeUID: shelly:shellyem3
configuration:
eventsCoIoT: true
deviceIp: 192.168.48.21
eventsSwitch: false
updateInterval: 60
eventsButton: false
eventsPush: false
channels:
- id: device#alarm
channelTypeUID: shelly:alarmTrigger
label: Alarm
description: Alarm Trigger, e.g. weak WiFi Signal detected or over heating
configuration: {}
- id: device#wifiSignal
channelTypeUID: system:signal-strength
label: Signal Strength
description: Signal strength as with values 0 (worst), 1, 2, 3 or 4 (best)
configuration: {}
- id: device#deviceName
channelTypeUID: shelly:deviceName
label: Device Name
description: Symbolic Device Name as configured in the Shelly App
configuration: {}
- id: device#accumulatedWatts
channelTypeUID: shelly:meterAccuWatts
label: Accumulated Power Consumption
description: Accumulated Power Consumption in Watts of the device (including all meters)
configuration: {}
- id: device#accumulatedWTotal
channelTypeUID: shelly:meterAccuTotal
label: Accumulated Total Power
description: Accumulated Total Power in kW/h of the device (including all meters)
configuration: {}
- id: device#accumulatedReturned
channelTypeUID: shelly:meterAccuReturned
label: Accumulated Apparent Power
description: Accumulated Apparent Power in kW/h of the device (including all meters)
configuration: {}
- id: device#resetTotals
channelTypeUID: shelly:meterResetTotals
label: Reset Energy Measurements
description: Resets totals measurement data
configuration: {}
- id: device#uptime
channelTypeUID: shelly:uptime
label: Uptime
description: Number of seconds since the device was powered up
configuration: {}
- id: device#updateAvailable
channelTypeUID: shelly:updateAvailable
label: Update available
description: "ON: A firmware update is available (use the Shelly App to perform update)"
configuration: {}
- id: device#heartBeat
channelTypeUID: shelly:heartBeat
label: Last Heartbeat
description: Last time we received a signal from the device (API result or
sensor report), This indicates that device communication works on the
network layer (WiFi + IP)
configuration: {}
- id: device#statusLed
channelTypeUID: shelly:ledStatusDisable
label: Disable Status LED
description: Disable LED indication for network status
configuration: {}
- id: relay#output
channelTypeUID: system:power
label: Power
description: null
configuration: {}
- id: relay#timerActive
channelTypeUID: shelly:timerActive
label: Auto ON/OFF timer active
description: "ON: A timer is active, OFF: no timer active"
configuration: {}
- id: relay#autoOn
channelTypeUID: shelly:timerAutoOn
label: Auto-ON Timer
description: When the output of the relay is switched off, it will be switched
back on automatically after n seconds
configuration: {}
- id: relay#autoOff
channelTypeUID: shelly:timerAutoOff
label: Auto-OFF Timer
description: When the output of the relay is switched on, it will be switched
back off automatically after n seconds
configuration: {}
Digging into the log (after disabling / enabling the thing shortly and manually setting the log level to debug on the shelly bundle since the command from console doesn’t work) …
BINGO! I can see for the first time a channel shellyem3-244cab4359da: id 6: neutralCurrent, Type=I, Range=null, Links=5
But it crashes shortly thereafter, this might be the reason I can’t see the channels on OH UI.
2024-01-30 19:54:45.417 [INFO ] [org.openhab.core.Activator ] - Starting openHAB 4.2.0 (Build #3868)
2024-01-30 19:54:46.500 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Time zone set to 'Europe/Zurich'.
2024-01-30 19:54:46.502 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Locale set to 'en_CH'.
2024-01-30 19:54:47.752 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/events's Observer
2024-01-30 19:54:47.781 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/addons/suggestions's Observer
2024-01-30 19:54:47.792 [WARN ] [.transport.servlet.ServletController] - Can't find the request for https://192.168.48.196:8443/rest/addons/services's Observer
2024-01-30 19:54:52.709 [WARN ] [org.openhab.core.net.NetUtil ] - Found multiple local interfaces - ignoring 192.168.48.196
2024-01-30 19:55:05.159 [INFO ] [.core.model.lsp.internal.ModelServer] - Started Language Server Protocol (LSP) service on port 5007
2024-01-30 19:55:12.282 [INFO ] [e.automation.internal.RuleEngineImpl] - Rule engine started.
2024-01-30 19:55:18.824 [INFO ] [nternal.manager.ShellyManagerServlet] - Shelly Manager started at http(s)://192.168.96.193:8080/shelly/manager
2024-01-30 19:55:29.116 [INFO ] [nternal.manager.ShellyManagerServlet] - Shelly Manager started at http(s)://192.168.96.193:8080/shelly/manager
2024-01-30 19:59:20.329 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'shelly:shellyem3:244cab4359da' to inbox.
2024-01-30 19:59:20.777 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'shelly:shellyplusi4:a8032ab619f0' to inbox.
2024-01-30 19:59:20.983 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'shelly:shelly1pm:e09806a9d2e8' to inbox.
2024-01-30 19:59:22.174 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'shelly:shellyplus1:3c610572ccc4' to inbox.
2024-01-30 20:06:32.363 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : dm $000 tracking 5 SingleStatic added {org.openhab.core.thing.binding.ThingHandlerFactory, org.openhab.binding.shelly.internal.ShellyHandlerFactory}={service.id=519, service.bundleid=267, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), service.pid=binding.shelly, component.name=org.openhab.binding.shelly.internal.ShellyHandlerFactory, component.id=338} (enter)
2024-01-30 20:06:32.365 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : ActivateInternal
2024-01-30 20:06:32.366 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : Querying state unsatisfiedReference
2024-01-30 20:06:32.367 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : Querying state unsatisfiedReference
2024-01-30 20:06:32.368 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : Activating component from state unsatisfiedReference
2024-01-30 20:06:32.370 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : Querying state unsatisfiedReference
2024-01-30 20:06:32.371 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : Querying state unsatisfiedReference
2024-01-30 20:06:32.372 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : Changed state from unsatisfiedReference to satisfied
2024-01-30 20:06:32.373 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : registration change queue [registered]
2024-01-30 20:06:32.375 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : This thread collected dependencies
2024-01-30 20:06:32.377 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : getService (single component manager) dependencies collected.
2024-01-30 20:06:32.378 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : Querying state satisfied
2024-01-30 20:06:32.379 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : Querying state satisfied
2024-01-30 20:06:32.381 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : For dependency $000, optional: false; to bind: [[RefPair: ref: [{org.openhab.core.thing.binding.ThingHandlerFactory, org.openhab.binding.shelly.internal.ShellyHandlerFactory}={service.id=519, service.bundleid=267, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), service.pid=binding.shelly, component.name=org.openhab.binding.shelly.internal.ShellyHandlerFactory, component.id=338}] service: [null]]]
2024-01-30 20:06:32.382 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : For dependency $001, optional: false; to bind: [[RefPair: ref: [{org.openhab.binding.shelly.internal.handler.ShellyThingTable}={service.id=508, service.bundleid=267, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.binding.shelly.internal.handler.ShellyThingTable, component.id=341}] service: [null]]]
2024-01-30 20:06:32.383 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : For dependency osgi.ds.satisfying.condition, optional: false; to bind: [[RefPair: ref: [{org.osgi.service.condition.Condition}={service.id=6, service.bundleid=0, service.scope=singleton, service.pid=0.org.osgi.service.condition.ConditionImpl, osgi.condition.id=true}] service: [null]]]
2024-01-30 20:06:32.385 [DEBUG] [elly.internal.api.ShellyEventServlet] - Shelly EventServlet started at /shelly/event and /shelly/wsevent
2024-01-30 20:06:32.386 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : Set implementation object for component
2024-01-30 20:06:32.388 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : Changed state from satisfied to active
2024-01-30 20:06:32.389 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : Querying state active
2024-01-30 20:06:32.390 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : invoking deactivate: deactivate: parameters []
2024-01-30 20:06:32.391 [DEBUG] [elly.internal.api.ShellyEventServlet] - ShellyEventServlet: Stopping
2024-01-30 20:06:32.393 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : invoked deactivate: deactivate
2024-01-30 20:06:32.394 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : DependencyManager: osgi.ds.satisfying.condition close component unbinding from org.apache.felix.scr.impl.manager.ComponentContextImpl@1cc2158f at tracking count 1 refpairs: [[RefPair: ref: [{org.osgi.service.condition.Condition}={service.id=6, service.bundleid=0, service.scope=singleton, service.pid=0.org.osgi.service.condition.ConditionImpl, osgi.condition.id=true}] service: [null]]]
2024-01-30 20:06:32.395 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : DependencyManager: $001 close component unbinding from org.apache.felix.scr.impl.manager.ComponentContextImpl@1cc2158f at tracking count 2 refpairs: [[RefPair: ref: [{org.openhab.binding.shelly.internal.handler.ShellyThingTable}={service.id=508, service.bundleid=267, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.binding.shelly.internal.handler.ShellyThingTable, component.id=341}] service: [org.openhab.binding.shelly.internal.handler.ShellyThingTable@a222b7b]]]
2024-01-30 20:06:32.397 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : DependencyManager: $000 close component unbinding from org.apache.felix.scr.impl.manager.ComponentContextImpl@1cc2158f at tracking count 5 refpairs: [[RefPair: ref: [{org.openhab.core.thing.binding.ThingHandlerFactory, org.openhab.binding.shelly.internal.ShellyHandlerFactory}={service.id=519, service.bundleid=267, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), service.pid=binding.shelly, component.name=org.openhab.binding.shelly.internal.ShellyHandlerFactory, component.id=338}] service: [org.openhab.binding.shelly.internal.ShellyHandlerFactory@42476544]]]
2024-01-30 20:06:32.398 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : Unset and deconfigured implementation object for component in deleteComponent for reason Unspecified
2024-01-30 20:06:32.399 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : Changed state from active to satisfied
2024-01-30 20:06:32.405 [DEBUG] [elly.internal.api.ShellyEventServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.api.ShellyEventServlet(339)] : dm $000 tracking 5 SingleStatic added {org.openhab.core.thing.binding.ThingHandlerFactory, org.openhab.binding.shelly.internal.ShellyHandlerFactory}={service.id=519, service.bundleid=267, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), service.pid=binding.shelly, component.name=org.openhab.binding.shelly.internal.ShellyHandlerFactory, component.id=338} (exit)
2024-01-30 20:06:32.406 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : dm $003 tracking 8 SingleStatic added {org.openhab.core.thing.binding.ThingHandlerFactory, org.openhab.binding.shelly.internal.ShellyHandlerFactory}={service.id=519, service.bundleid=267, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), service.pid=binding.shelly, component.name=org.openhab.binding.shelly.internal.ShellyHandlerFactory, component.id=338} (enter)
2024-01-30 20:06:32.407 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : ActivateInternal
2024-01-30 20:06:32.409 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : Querying state unsatisfiedReference
2024-01-30 20:06:32.410 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : Querying state unsatisfiedReference
2024-01-30 20:06:32.411 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : Activating component from state unsatisfiedReference
2024-01-30 20:06:32.412 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : Querying state unsatisfiedReference
2024-01-30 20:06:32.413 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : Querying state unsatisfiedReference
2024-01-30 20:06:32.414 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : Changed state from unsatisfiedReference to satisfied
2024-01-30 20:06:32.415 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : registration change queue [registered]
2024-01-30 20:06:32.418 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : This thread collected dependencies
2024-01-30 20:06:32.419 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : getService (single component manager) dependencies collected.
2024-01-30 20:06:32.420 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : Querying state satisfied
2024-01-30 20:06:32.421 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : Querying state satisfied
2024-01-30 20:06:32.422 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : For dependency $000, optional: false; to bind: [[RefPair: ref: [{org.osgi.service.cm.ConfigurationAdmin}={osgi.command.scope=cm, service.description=Configuration Admin Service Specification 1.6 Implementation, service.id=40, service.bundleid=12, service.scope=bundle, osgi.command.function=[getConfiguration,getFactoryConfiguration,listConfigurations,createFactoryConfiguration], service.vendor=The Apache Software Foundation, config.plugins=, service.pid=org.apache.felix.cm.ConfigurationAdmin}] service: [null]]]
2024-01-30 20:06:32.423 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : For dependency $001, optional: false; to bind: [[RefPair: ref: [{org.openhab.core.net.NetworkAddressService}={service.id=194, service.bundleid=156, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), service.config.category=system, service.pid=org.openhab.network, service.config.label=Network Settings, component.name=org.openhab.core.net.NetUtil, service.config.description.uri=system:network, component.id=35}] service: [null]]]
2024-01-30 20:06:32.424 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : For dependency $002, optional: false; to bind: [[RefPair: ref: [{org.openhab.core.io.net.http.HttpClientFactory, org.openhab.core.io.net.http.WebSocketFactory}={service.id=287, service.bundleid=182, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.core.io.net.http.internal.WebClientFactoryImpl, component.id=154}] service: [null]]]
2024-01-30 20:06:32.425 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : For dependency $003, optional: false; to bind: [[RefPair: ref: [{org.openhab.core.thing.binding.ThingHandlerFactory, org.openhab.binding.shelly.internal.ShellyHandlerFactory}={service.id=519, service.bundleid=267, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), service.pid=binding.shelly, component.name=org.openhab.binding.shelly.internal.ShellyHandlerFactory, component.id=338}] service: [null]]]
2024-01-30 20:06:32.426 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : For dependency $004, optional: false; to bind: [[RefPair: ref: [{org.openhab.binding.shelly.internal.provider.ShellyTranslationProvider}={service.id=510, service.bundleid=267, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.binding.shelly.internal.provider.ShellyTranslationProvider, component.id=345}] service: [null]]]
2024-01-30 20:06:32.427 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : For dependency osgi.ds.satisfying.condition, optional: false; to bind: [[RefPair: ref: [{org.osgi.service.condition.Condition}={service.id=6, service.bundleid=0, service.scope=singleton, service.pid=0.org.osgi.service.condition.ConditionImpl, osgi.condition.id=true}] service: [null]]]
2024-01-30 20:06:32.434 [INFO ] [nternal.manager.ShellyManagerServlet] - Shelly Manager started at http(s)://192.168.96.193:8080/shelly/manager
2024-01-30 20:06:32.435 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : Set implementation object for component
2024-01-30 20:06:32.436 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : Changed state from satisfied to active
2024-01-30 20:06:32.437 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : Querying state active
2024-01-30 20:06:32.438 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : invoking deactivate: deactivate: parameters []
2024-01-30 20:06:32.440 [DEBUG] [nternal.manager.ShellyManagerServlet] - ShellyManagerServlet stopped
2024-01-30 20:06:32.441 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : invoked deactivate: deactivate
2024-01-30 20:06:32.442 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : DependencyManager: osgi.ds.satisfying.condition close component unbinding from org.apache.felix.scr.impl.manager.ComponentContextImpl@254b06ee at tracking count 4 refpairs: [[RefPair: ref: [{org.osgi.service.condition.Condition}={service.id=6, service.bundleid=0, service.scope=singleton, service.pid=0.org.osgi.service.condition.ConditionImpl, osgi.condition.id=true}] service: [null]]]
2024-01-30 20:06:32.443 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : DependencyManager: $004 close component unbinding from org.apache.felix.scr.impl.manager.ComponentContextImpl@254b06ee at tracking count 6 refpairs: [[RefPair: ref: [{org.openhab.binding.shelly.internal.provider.ShellyTranslationProvider}={service.id=510, service.bundleid=267, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.binding.shelly.internal.provider.ShellyTranslationProvider, component.id=345}] service: [org.openhab.binding.shelly.internal.provider.ShellyTranslationProvider@292901a5]]]
2024-01-30 20:06:32.445 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : DependencyManager: $003 close component unbinding from org.apache.felix.scr.impl.manager.ComponentContextImpl@254b06ee at tracking count 8 refpairs: [[RefPair: ref: [{org.openhab.core.thing.binding.ThingHandlerFactory, org.openhab.binding.shelly.internal.ShellyHandlerFactory}={service.id=519, service.bundleid=267, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), service.pid=binding.shelly, component.name=org.openhab.binding.shelly.internal.ShellyHandlerFactory, component.id=338}] service: [org.openhab.binding.shelly.internal.ShellyHandlerFactory@42476544]]]
2024-01-30 20:06:32.446 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : DependencyManager: $002 close component unbinding from org.apache.felix.scr.impl.manager.ComponentContextImpl@254b06ee at tracking count 3 refpairs: [[RefPair: ref: [{org.openhab.core.io.net.http.HttpClientFactory, org.openhab.core.io.net.http.WebSocketFactory}={service.id=287, service.bundleid=182, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.core.io.net.http.internal.WebClientFactoryImpl, component.id=154}] service: [org.openhab.core.io.net.http.internal.WebClientFactoryImpl@32cb8e08]]]
2024-01-30 20:06:32.447 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : DependencyManager: $001 close component unbinding from org.apache.felix.scr.impl.manager.ComponentContextImpl@254b06ee at tracking count 2 refpairs: [[RefPair: ref: [{org.openhab.core.net.NetworkAddressService}={service.id=194, service.bundleid=156, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), service.config.category=system, service.pid=org.openhab.network, service.config.label=Network Settings, component.name=org.openhab.core.net.NetUtil, service.config.description.uri=system:network, component.id=35}] service: [org.openhab.core.net.NetUtil@696a5950]]]
2024-01-30 20:06:32.448 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : DependencyManager: $000 close component unbinding from org.apache.felix.scr.impl.manager.ComponentContextImpl@254b06ee at tracking count 1 refpairs: [[RefPair: ref: [{org.osgi.service.cm.ConfigurationAdmin}={osgi.command.scope=cm, service.description=Configuration Admin Service Specification 1.6 Implementation, service.id=40, service.bundleid=12, service.scope=bundle, osgi.command.function=[getConfiguration,getFactoryConfiguration,listConfigurations,createFactoryConfiguration], service.vendor=The Apache Software Foundation, config.plugins=, service.pid=org.apache.felix.cm.ConfigurationAdmin}] service: [org.apache.felix.cm.impl.ConfigurationAdminImpl@146b4ee5]]]
2024-01-30 20:06:32.449 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : Unset and deconfigured implementation object for component in deleteComponent for reason Unspecified
2024-01-30 20:06:32.450 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : Changed state from active to satisfied
2024-01-30 20:06:32.454 [DEBUG] [nternal.manager.ShellyManagerServlet] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.manager.ShellyManagerServlet(342)] : dm $003 tracking 8 SingleStatic added {org.openhab.core.thing.binding.ThingHandlerFactory, org.openhab.binding.shelly.internal.ShellyHandlerFactory}={service.id=519, service.bundleid=267, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), service.pid=binding.shelly, component.name=org.openhab.binding.shelly.internal.ShellyHandlerFactory, component.id=338} (exit)
2024-01-30 20:06:32.455 [DEBUG] [shelly.internal.ShellyHandlerFactory] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.ShellyHandlerFactory(338)] : ImmediateComponentHolder Finished configuring the dependency managers for component for pid binding.shelly
2024-01-30 20:06:32.456 [DEBUG] [shelly.internal.ShellyHandlerFactory] - bundle org.openhab.binding.shelly:4.2.0.202401191937 (267)[org.openhab.binding.shelly.internal.ShellyHandlerFactory(338)] : ImmediateComponentHolder Will not enable component for pid binding.shelly: holder enabled state: true, metadata enabled: true
2024-01-30 20:06:34.361 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Using default userId admin from binding config
2024-01-30 20:06:34.362 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Using default password from bindingConfig (userId=admin)
2024-01-30 20:06:34.363 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Device config: Device address=192.168.48.21, HTTP user/password=admin/***, update interval=60
2024-01-30 20:06:34.364 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Configured Events: Button: false, Switch (on/off): false, Push: false, Roller: true, Sensor: true, CoIoT: true, Enable AutoCoIoT: true
2024-01-30 20:06:34.365 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Start initializing for thing Mains Power (shellyem3-244cab4359da@192.168.48.21), type shellyem3, IP address 192.168.48.21, Gen2: false, CoIoT: true
2024-01-30 20:06:34.612 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Auto-CoIoT is enabled, disabling action urls
2024-01-30 20:06:34.613 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Starting CoIoT (autoCoIoT=true/true)
2024-01-30 20:06:34.614 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: Starting CoAP Listener
2024-01-30 20:06:34.616 [DEBUG] [elly.internal.api1.Shelly1CoapServer] - Initializing CoIoT listener (local IP=192.168.96.193:5683)
2024-01-30 20:06:34.656 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: Using CoAP device description from successful HTTP /cit/d
2024-01-30 20:06:34.657 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Device Description for shellyem3-244cab4359da: {"blk":[{"I":1,"D":"relay_0"},{"I":2,"D":"emeter_0"},{"I":3,"D":"emeter_1"},{"I":4,"D":"emeter_2"},{"I":5,"D":"device"}],"sen":[{"I":9103,"T":"EVC","D":"cfgChanged","R":"U16","L":5},{"I":1101,"T":"S","D":"output","R":"0/1","L":1},{"I":4105,"T":"P","D":"power","U":"W","L":2},{"I":4106,"T":"E","D":"energy","U":"Wh","L":2},{"I":4107,"T":"E","D":"energyReturned","U":"Wh","L":2},{"I":4108,"T":"V","D":"voltage","U":"V","L":2},{"I":4109,"T":"I","D":"current","U":"A","L":2},{"I":4110,"T":"S","D":"powerFactor","R":["0/1","-1"],"L":2},{"I":4205,"T":"P","D":"power","U":"W","L":3},{"I":4206,"T":"E","D":"energy","U":"Wh","L":3},{"I":4207,"T":"E","D":"energyReturned","U":"Wh","L":3},{"I":4208,"T":"V","D":"voltage","U":"V","L":3},{"I":4209,"T":"I","D":"current","U":"A","L":3},{"I":4210,"T":"S","D":"powerFactor","R":["0/1","-1"],"L":3},{"I":4305,"T":"P","D":"power","U":"W","L":4},{"I":4306,"T":"E","D":"energy","U":"Wh","L":4},{"I":4307,"T":"E","D":"energyReturned","U":"Wh","L":4},{"I":4308,"T":"V","D":"voltage","U":"V","L":4},{"I":4309,"T":"I","D":"current","U":"A","L":4},{"I":4310,"T":"S","D":"powerFactor","R":["0/1","-1"],"L":4},{"I":6,"T":"I","D":"neutralCurrent","U":"A","L":5},{"I":6102,"T":"A","D":"overpower","R":["0/1","-1"],"L":1}]}
2024-01-30 20:06:34.658 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=1: relay_0
2024-01-30 20:06:34.659 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=2: emeter_0
2024-01-30 20:06:34.660 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=3: emeter_1
2024-01-30 20:06:34.661 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=4: emeter_2
2024-01-30 20:06:34.662 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=5: device
2024-01-30 20:06:34.663 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: Adding 22 sensor definitions
2024-01-30 20:06:34.664 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 9103: cfgChanged, Type=EVC, Range=U16, Links=5
2024-01-30 20:06:34.665 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 1101: output, Type=S, Range=0/1, Links=1
2024-01-30 20:06:34.666 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4105: power, Type=P, Range=null, Links=2
2024-01-30 20:06:34.667 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4106: energy, Type=E, Range=null, Links=2
2024-01-30 20:06:34.668 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4107: energyReturned, Type=E, Range=null, Links=2
2024-01-30 20:06:34.669 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4108: voltage, Type=V, Range=null, Links=2
2024-01-30 20:06:34.670 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4109: current, Type=I, Range=null, Links=2
2024-01-30 20:06:34.671 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4110: powerFactor, Type=S, Range=0/1;-1, Links=2
2024-01-30 20:06:34.672 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4205: power, Type=P, Range=null, Links=3
2024-01-30 20:06:34.674 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4206: energy, Type=E, Range=null, Links=3
2024-01-30 20:06:34.675 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4207: energyReturned, Type=E, Range=null, Links=3
2024-01-30 20:06:34.676 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4208: voltage, Type=V, Range=null, Links=3
2024-01-30 20:06:34.677 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4209: current, Type=I, Range=null, Links=3
2024-01-30 20:06:34.678 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4210: powerFactor, Type=S, Range=0/1;-1, Links=3
2024-01-30 20:06:34.679 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4305: power, Type=P, Range=null, Links=4
2024-01-30 20:06:34.680 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4306: energy, Type=E, Range=null, Links=4
2024-01-30 20:06:34.681 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4307: energyReturned, Type=E, Range=null, Links=4
2024-01-30 20:06:34.682 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4308: voltage, Type=V, Range=null, Links=4
2024-01-30 20:06:34.683 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4309: current, Type=I, Range=null, Links=4
2024-01-30 20:06:34.684 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4310: powerFactor, Type=S, Range=0/1;-1, Links=4
2024-01-30 20:06:34.686 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 6: neutralCurrent, Type=I, Range=null, Links=5
2024-01-30 20:06:34.687 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 6102: overpower, Type=A, Range=0/1;-1, Links=1
2024-01-30 20:06:34.691 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Initializing device shelly-4359D, type SHEM-3, Hardware: Rev: dev-prototype, batch 0; Firmware: 1.14.0- / 20230913
2024-01-30 20:06:34.692 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Shelly settings info for shelly-4359D: {"device":{"type":"SHEM-3","mac":"244CAB4359DA","hostname":"shellyem3-244CAB4359DA","num_outputs":1,"num_meters":0,"num_emeters":3,"report_period":1},"wifi_ap":{"enabled":false,"ssid":"shellyem3-244CAB4359DA","key":""},"wifi_sta":{"enabled":true,"ssid":"beanzIOT","ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"wifi_sta1":{"enabled":false,"ssid":null,"ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"ap_roaming":{"enabled":true,"threshold":-70},"mqtt": {"enable":false,"server":"192.168.33.3:1883","user":"","id":"shellyem3-244CAB4359DA","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": {"enabled":true,"update_period":15,"peer":""},"sntp":{"server":"time.google.com","enabled":true},"login":{"enabled":false,"unprotected":false,"username":"admin"},"pin_code":"","name":"Mains Power","fw":"20230913-114244/v1.14.0-gcb84623","pon_wifi_reset":false,"discoverable":false,"build_info":{"build_id":"20230913-114244/v1.14.0-gcb84623","build_timestamp":"2023-09-13T11:42:44Z","build_version":"1.0"},"cloud":{"enabled":false,"connected":false},"timezone":"Europe/Zurich","lat":47.490700,"lng":8.738800,"tzautodetect":true,"tz_utc_offset":3600,"tz_dst":false,"tz_dst_auto":true,"time":"21:06","unixtime":1706645194,"led_status_disable":false,"debug_enable":false,"allow_cross_origin":false,"actions":{"active":false,"names":["out_on_url","out_off_url","over_power_url","under_power_url","over_power_url","under_power_url","over_power_url","under_power_url","over_power_url","under_power_url","n_mismatch_url"]},"hwinfo":{"hw_revision":"dev-prototype", "batch_id":0},"cf_output":0,"relays":[{"name":null,"ison":false,"has_timer":false,"default_state":"off","auto_on":0.00,"auto_off":0.00,"schedule":false,"schedule_rules":[]}],"emeters":[{"name":"Phase 1","appliance_type":"General","max_power":0,"range_extender":1},{"name":"Phase 2","appliance_type":"General","max_power":0,"range_extender":1},{"name":"Phase 3","appliance_type":"General","max_power":0,"range_extender":1}],"emeter_n":{"range_extender":1,"mismatch_threshold":0.00},"eco_mode_enabled":true}
2024-01-30 20:06:34.693 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Device hasRelays:true (numRelays=1),isRoller:false (numRoller=0),isDimmer:false,numMeter=3,isEMeter:true), ext. Switch Add-On: n/a,isSensor:false,isDS:false,hasBattery:false,isSense:false,isMotion:false,isLight:false,isBulb:false,isDuo:false,isRGBW2:false,inColor:false, BLU Gateway support: true,alwaysOn:70, updatePeriod:falsesec
2024-01-30 20:06:34.694 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Thing successfully initialized.
2024-01-30 20:06:34.705 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Update status job started, interval=20*3=60sec.
2024-01-30 20:06:36.984 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Unable to refresh status: Unable to update status
java.lang.IllegalArgumentException: Channel definition for meter#ncurrent not found!
at org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions$ChannelMap.get(ShellyChannelDefinitions.java:788) ~[?:?]
at org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions.getDefinition(ShellyChannelDefinitions.java:297) ~[?:?]
at org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions.addChannel(ShellyChannelDefinitions.java:602) ~[?:?]
at org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions.createEMNCurrentChannels(ShellyChannelDefinitions.java:507) ~[?:?]
at org.openhab.binding.shelly.internal.handler.ShellyComponents.updateMeters(ShellyComponents.java:269) ~[?:?]
at org.openhab.binding.shelly.internal.handler.ShellyBaseHandler.refreshStatus(ShellyBaseHandler.java:574) ~[?:?]
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:539) [?:?]
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305) [?:?]
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:305) [?:?]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) [?:?]
at java.lang.Thread.run(Thread.java:840) [?:?]
Restarted OH - but there was no difference on presented channels.
Logfile looks similar
How can I help you debugging further?
2024-01-30 20:16:04.143 [DEBUG] [shelly.internal.ShellyHandlerFactory] - Mains Power (shellyem3-244cab4359da@192.168.48.21): Create new thing of type shelly:shellyem3 using ShellyRelayHandler
2024-01-30 20:16:04.216 [DEBUG] [shelly.internal.ShellyHandlerFactory] - Thing handler for uid shelly:shellyem3:244cab4359da added, total things = 1
2024-01-30 20:16:06.239 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Using default userId admin from binding config
2024-01-30 20:16:06.240 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Using default password from bindingConfig (userId=admin)
2024-01-30 20:16:06.241 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Device config: Device address=192.168.48.21, HTTP user/password=admin/***, update interval=60
2024-01-30 20:16:06.242 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Configured Events: Button: false, Switch (on/off): false, Push: false, Roller: true, Sensor: true, CoIoT: true, Enable AutoCoIoT: true
2024-01-30 20:16:06.243 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Start initializing for thing Mains Power (shellyem3-244cab4359da@192.168.48.21), type shellyem3, IP address 192.168.48.21, Gen2: false, CoIoT: true
2024-01-30 20:16:06.504 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Auto-CoIoT is enabled, disabling action urls
2024-01-30 20:16:06.505 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Starting CoIoT (autoCoIoT=true/true)
2024-01-30 20:16:06.506 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: Starting CoAP Listener
2024-01-30 20:16:06.507 [DEBUG] [elly.internal.api1.Shelly1CoapServer] - Initializing CoIoT listener (local IP=192.168.96.193:5683)
2024-01-30 20:16:06.585 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: Using CoAP device description from successful HTTP /cit/d
2024-01-30 20:16:06.586 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Device Description for shellyem3-244cab4359da: {"blk":[{"I":1,"D":"relay_0"},{"I":2,"D":"emeter_0"},{"I":3,"D":"emeter_1"},{"I":4,"D":"emeter_2"},{"I":5,"D":"device"}],"sen":[{"I":9103,"T":"EVC","D":"cfgChanged","R":"U16","L":5},{"I":1101,"T":"S","D":"output","R":"0/1","L":1},{"I":4105,"T":"P","D":"power","U":"W","L":2},{"I":4106,"T":"E","D":"energy","U":"Wh","L":2},{"I":4107,"T":"E","D":"energyReturned","U":"Wh","L":2},{"I":4108,"T":"V","D":"voltage","U":"V","L":2},{"I":4109,"T":"I","D":"current","U":"A","L":2},{"I":4110,"T":"S","D":"powerFactor","R":["0/1","-1"],"L":2},{"I":4205,"T":"P","D":"power","U":"W","L":3},{"I":4206,"T":"E","D":"energy","U":"Wh","L":3},{"I":4207,"T":"E","D":"energyReturned","U":"Wh","L":3},{"I":4208,"T":"V","D":"voltage","U":"V","L":3},{"I":4209,"T":"I","D":"current","U":"A","L":3},{"I":4210,"T":"S","D":"powerFactor","R":["0/1","-1"],"L":3},{"I":4305,"T":"P","D":"power","U":"W","L":4},{"I":4306,"T":"E","D":"energy","U":"Wh","L":4},{"I":4307,"T":"E","D":"energyReturned","U":"Wh","L":4},{"I":4308,"T":"V","D":"voltage","U":"V","L":4},{"I":4309,"T":"I","D":"current","U":"A","L":4},{"I":4310,"T":"S","D":"powerFactor","R":["0/1","-1"],"L":4},{"I":6,"T":"I","D":"neutralCurrent","U":"A","L":5},{"I":6102,"T":"A","D":"overpower","R":["0/1","-1"],"L":1}]}
2024-01-30 20:16:06.589 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=1: relay_0
2024-01-30 20:16:06.590 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=2: emeter_0
2024-01-30 20:16:06.590 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=3: emeter_1
2024-01-30 20:16:06.591 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=4: emeter_2
2024-01-30 20:16:06.592 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=5: device
2024-01-30 20:16:06.593 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: Adding 22 sensor definitions
2024-01-30 20:16:06.594 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 9103: cfgChanged, Type=EVC, Range=U16, Links=5
2024-01-30 20:16:06.595 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 1101: output, Type=S, Range=0/1, Links=1
2024-01-30 20:16:06.596 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4105: power, Type=P, Range=null, Links=2
2024-01-30 20:16:06.597 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4106: energy, Type=E, Range=null, Links=2
2024-01-30 20:16:06.598 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4107: energyReturned, Type=E, Range=null, Links=2
2024-01-30 20:16:06.598 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4108: voltage, Type=V, Range=null, Links=2
2024-01-30 20:16:06.599 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4109: current, Type=I, Range=null, Links=2
2024-01-30 20:16:06.600 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4110: powerFactor, Type=S, Range=0/1;-1, Links=2
2024-01-30 20:16:06.601 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4205: power, Type=P, Range=null, Links=3
2024-01-30 20:16:06.602 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4206: energy, Type=E, Range=null, Links=3
2024-01-30 20:16:06.603 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4207: energyReturned, Type=E, Range=null, Links=3
2024-01-30 20:16:06.604 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4208: voltage, Type=V, Range=null, Links=3
2024-01-30 20:16:06.604 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4209: current, Type=I, Range=null, Links=3
2024-01-30 20:16:06.605 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4210: powerFactor, Type=S, Range=0/1;-1, Links=3
2024-01-30 20:16:06.606 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4305: power, Type=P, Range=null, Links=4
2024-01-30 20:16:06.607 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4306: energy, Type=E, Range=null, Links=4
2024-01-30 20:16:06.607 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4307: energyReturned, Type=E, Range=null, Links=4
2024-01-30 20:16:06.608 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4308: voltage, Type=V, Range=null, Links=4
2024-01-30 20:16:06.609 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4309: current, Type=I, Range=null, Links=4
2024-01-30 20:16:06.610 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4310: powerFactor, Type=S, Range=0/1;-1, Links=4
2024-01-30 20:16:06.611 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 6: neutralCurrent, Type=I, Range=null, Links=5
2024-01-30 20:16:06.611 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 6102: overpower, Type=A, Range=0/1;-1, Links=1
2024-01-30 20:16:06.633 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Initializing device shelly-4359D, type SHEM-3, Hardware: Rev: dev-prototype, batch 0; Firmware: 1.14.0- / 20230913
2024-01-30 20:16:06.634 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Shelly settings info for shelly-4359D: {"device":{"type":"SHEM-3","mac":"244CAB4359DA","hostname":"shellyem3-244CAB4359DA","num_outputs":1,"num_meters":0,"num_emeters":3,"report_period":1},"wifi_ap":{"enabled":false,"ssid":"shellyem3-244CAB4359DA","key":""},"wifi_sta":{"enabled":true,"ssid":"beanzIOT","ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"wifi_sta1":{"enabled":false,"ssid":null,"ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"ap_roaming":{"enabled":true,"threshold":-70},"mqtt": {"enable":false,"server":"192.168.33.3:1883","user":"","id":"shellyem3-244CAB4359DA","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": {"enabled":true,"update_period":15,"peer":""},"sntp":{"server":"time.google.com","enabled":true},"login":{"enabled":false,"unprotected":false,"username":"admin"},"pin_code":"","name":"Mains Power","fw":"20230913-114244/v1.14.0-gcb84623","pon_wifi_reset":false,"discoverable":false,"build_info":{"build_id":"20230913-114244/v1.14.0-gcb84623","build_timestamp":"2023-09-13T11:42:44Z","build_version":"1.0"},"cloud":{"enabled":false,"connected":false},"timezone":"Europe/Zurich","lat":47.490700,"lng":8.738800,"tzautodetect":true,"tz_utc_offset":3600,"tz_dst":false,"tz_dst_auto":true,"time":"21:16","unixtime":1706645765,"led_status_disable":false,"debug_enable":false,"allow_cross_origin":false,"actions":{"active":false,"names":["out_on_url","out_off_url","over_power_url","under_power_url","over_power_url","under_power_url","over_power_url","under_power_url","over_power_url","under_power_url","n_mismatch_url"]},"hwinfo":{"hw_revision":"dev-prototype", "batch_id":0},"cf_output":0,"relays":[{"name":null,"ison":false,"has_timer":false,"default_state":"off","auto_on":0.00,"auto_off":0.00,"schedule":false,"schedule_rules":[]}],"emeters":[{"name":"Phase 1","appliance_type":"General","max_power":0,"range_extender":1},{"name":"Phase 2","appliance_type":"General","max_power":0,"range_extender":1},{"name":"Phase 3","appliance_type":"General","max_power":0,"range_extender":1}],"emeter_n":{"range_extender":1,"mismatch_threshold":0.00},"eco_mode_enabled":true}
2024-01-30 20:16:06.635 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Device hasRelays:true (numRelays=1),isRoller:false (numRoller=0),isDimmer:false,numMeter=3,isEMeter:true), ext. Switch Add-On: n/a,isSensor:false,isDS:false,hasBattery:false,isSense:false,isMotion:false,isLight:false,isBulb:false,isDuo:false,isRGBW2:false,inColor:false, BLU Gateway support: true,alwaysOn:70, updatePeriod:falsesec
2024-01-30 20:16:06.636 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Thing successfully initialized.
2024-01-30 20:16:06.667 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Update status job started, interval=20*3=60sec.
2024-01-30 20:16:08.856 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Unable to refresh status: Unable to update status
java.lang.IllegalArgumentException: Channel definition for meter#ncurrent not found!
at org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions$ChannelMap.get(ShellyChannelDefinitions.java:788) ~[?:?]
at org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions.getDefinition(ShellyChannelDefinitions.java:297) ~[?:?]
at org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions.addChannel(ShellyChannelDefinitions.java:602) ~[?:?]
at org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions.createEMNCurrentChannels(ShellyChannelDefinitions.java:507) ~[?:?]
at org.openhab.binding.shelly.internal.handler.ShellyComponents.updateMeters(ShellyComponents.java:269) ~[?:?]
at org.openhab.binding.shelly.internal.handler.ShellyBaseHandler.refreshStatus(ShellyBaseHandler.java:574) ~[?:?]
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:539) [?:?]
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305) [?:?]
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:305) [?:?]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) [?:?]
at java.lang.Thread.run(Thread.java:840) [?:?]
2024-01-30 20:17:06.085 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Unable to refresh status: Unable to update status
java.lang.IllegalArgumentException: Channel definition for meter#ncurrent not found!
at org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions$ChannelMap.get(ShellyChannelDefinitions.java:788) ~[?:?]
at org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions.getDefinition(ShellyChannelDefinitions.java:297) ~[?:?]
at org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions.addChannel(ShellyChannelDefinitions.java:602) ~[?:?]
at org.openhab.binding.shelly.internal.provider.ShellyChannelDefinitions.createEMNCurrentChannels(ShellyChannelDefinitions.java:507) ~[?:?]
at org.openhab.binding.shelly.internal.handler.ShellyComponents.updateMeters(ShellyComponents.java:269) ~[?:?]
at org.openhab.binding.shelly.internal.handler.ShellyBaseHandler.refreshStatus(ShellyBaseHandler.java:574) ~[?:?]
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:539) [?:?]
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305) [?:?]
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:305) [?:?]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) [?:?]
at java.lang.Thread.run(Thread.java:840) [?:?]
2024-01-30 20:17:06.090 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Enabling channel cache (20 updates / 60s)
The timestamp 202401191937 shows me that you are still using an old version. The new jar is 2 days old, yours is from 19.1.24
Use this one and make sure that no other version is running
https://github.com/markus7017/myfiles/blob/master/shelly/org.openhab.binding.shelly-4.2.0-SNAPSHOT.jar?raw=true
o.k. put the new jar in the addons folder.
on the console I can see the new version and coap has been installed as well:
openhab> bundle:list |grep -i shelly
267 x Active x 80 x 4.2.0.202401281845 x openHAB Add-ons :: Bundles :: Shelly Binding Gen 1,2,3, BLU
Unfortunately the bundle does not appear on OH UI, i.e. I cannot scan for shellys and add 3EM as a thing.
Any ideas how to give the shelly binding a push? The logfile is also pretty empty.
try uninstall binding, openhab-cli clean-cache, reinstall coap+binding
no change, re-done everything. even using newest snapshot openHAB 4.2.0 (Build #3872).
coap is present, then I copied the provided JAR file into addons and restarted.
no shelly binding is visible on UI nor on the console.
I did not add the binding via UI from public sources.
Might there be a problem in the JAR? I freshly downloaded it from the link you posted.
try this build
https://github.com/markus7017/myfiles/blob/master/shelly/org.openhab.binding.shelly-4.2.0-SNAPSHOT-ncurrent.jar?raw=true
Hi Markus
Just restarted with newest snapshot 4.2.0 (Build #3900) and your provided ncurrent JAR.
Your Shelly binding turns up under other bindings. Very well.
And BINGO! The thing shows the new nCurrent channel:
UID: shelly:shellyem3:244cab4359da
label: Mains Power (shellyem3-244cab4359da@192.168.48.21)
thingTypeUID: shelly:shellyem3
configuration:
eventsCoIoT: true
deviceIp: 192.168.48.21
eventsSwitch: false
updateInterval: 60
eventsButton: false
eventsPush: false
channels:
- id: device#alarm
channelTypeUID: shelly:alarmTrigger
label: Alarm
description: Alarm Trigger, e.g. weak WiFi Signal detected or over heating
configuration: {}
- id: device#wifiSignal
channelTypeUID: system:signal-strength
label: Signal Strength
description: Signal strength as with values 0 (worst), 1, 2, 3 or 4 (best)
configuration: {}
- id: device#deviceName
channelTypeUID: shelly:deviceName
label: Device Name
description: Symbolic Device Name as configured in the Shelly App
configuration: {}
- id: device#accumulatedWatts
channelTypeUID: shelly:meterAccuWatts
label: Accumulated Power Consumption
description: Accumulated Power Consumption in Watts of the device (including all meters)
configuration: {}
- id: device#accumulatedWTotal
channelTypeUID: shelly:meterAccuTotal
label: Accumulated Total Power
description: Accumulated Total Power in kW/h of the device (including all meters)
configuration: {}
- id: device#accumulatedReturned
channelTypeUID: shelly:meterAccuReturned
label: Accumulated Apparent Power
description: Accumulated Apparent Power in kW/h of the device (including all meters)
configuration: {}
- id: device#resetTotals
channelTypeUID: shelly:meterResetTotals
label: Reset Energy Measurements
description: Resets totals measurement data
configuration: {}
- id: device#uptime
channelTypeUID: shelly:uptime
label: Uptime
description: Number of seconds since the device was powered up
configuration: {}
- id: device#updateAvailable
channelTypeUID: shelly:updateAvailable
label: Update available
description: "ON: A firmware update is available (use the Shelly App to perform update)"
configuration: {}
- id: device#heartBeat
channelTypeUID: shelly:heartBeat
label: Last Heartbeat
description: Last time we received a signal from the device (API result or
sensor report), This indicates that device communication works on the
network layer (WiFi + IP)
configuration: {}
- id: device#statusLed
channelTypeUID: shelly:ledStatusDisable
label: Disable Status LED
description: Disable LED indication for network status
configuration: {}
- id: relay#output
channelTypeUID: system:power
label: Power
configuration: {}
- id: relay#timerActive
channelTypeUID: shelly:timerActive
label: Auto ON/OFF timer active
description: "ON: A timer is active, OFF: no timer active"
configuration: {}
- id: relay#autoOn
channelTypeUID: shelly:timerAutoOn
label: Auto-ON Timer
description: When the output of the relay is switched off, it will be switched
back on automatically after n seconds
configuration: {}
- id: relay#autoOff
channelTypeUID: shelly:timerAutoOff
label: Auto-OFF Timer
description: When the output of the relay is switched on, it will be switched
back off automatically after n seconds
configuration: {}
- id: nmeter#ncurrent
channelTypeUID: shelly:ncurrent
label: Neutral Current
description: Measured neutral current
configuration: {}
- id: nmeter#ixsum
channelTypeUID: shelly:ixsum
label: Accumulated Current
description: Sum of measured current on all phases
configuration: {}
- id: nmeter#nmismatch
channelTypeUID: shelly:nmismatch
label: N-Current Mismatch
description: "ON: Sum of all signed currents of the 4 wires is greater than the
configured N Current Treshhold"
configuration: {}
- id: nmeter#nmTreshhold
channelTypeUID: shelly:nmTreshhold
label: Mismatch Treshhold
description: Mismatch becomes ON when treshhold is exceeded
configuration: {}
- id: meter1#currentWatts
channelTypeUID: shelly:meterWatts
label: Power Consumption 1
description: Current Power Consumption in Watts
configuration: {}
- id: meter1#totalKWH
channelTypeUID: shelly:meterTotal
label: Total Energy Consumption 1
description: Total energy consumption in kW/h since the device powered up
(resets on restart)
configuration: {}
- id: meter1#returnedKWH
channelTypeUID: shelly:meterReturned
label: Total Returned Energy 1
description: Total returned energy in kW/h
configuration: {}
- id: meter1#voltage
channelTypeUID: shelly:meterVoltage
label: Voltage 1
description: RMS voltage in Volt
configuration: {}
- id: meter1#current
channelTypeUID: shelly:meterCurrent
label: Current 1
description: Current in A
configuration: {}
- id: meter1#powerFactor
channelTypeUID: shelly:meterPowerFactor
label: Power Factor 1
description: Power Factor in percent for photovoltaic
configuration: {}
- id: meter1#lastUpdate
channelTypeUID: shelly:lastUpdate
label: Last Update 1
description: Timestamp of last status update
configuration: {}
- id: meter2#currentWatts
channelTypeUID: shelly:meterWatts
label: Power Consumption 2
description: Current Power Consumption in Watts
configuration: {}
- id: meter2#totalKWH
channelTypeUID: shelly:meterTotal
label: Total Energy Consumption 2
description: Total energy consumption in kW/h since the device powered up
(resets on restart)
configuration: {}
- id: meter2#returnedKWH
channelTypeUID: shelly:meterReturned
label: Total Returned Energy 2
description: Total returned energy in kW/h
configuration: {}
- id: meter2#voltage
channelTypeUID: shelly:meterVoltage
label: Voltage 2
description: RMS voltage in Volt
configuration: {}
- id: meter2#current
channelTypeUID: shelly:meterCurrent
label: Current 2
description: Current in A
configuration: {}
- id: meter2#powerFactor
channelTypeUID: shelly:meterPowerFactor
label: Power Factor 2
description: Power Factor in percent for photovoltaic
configuration: {}
- id: meter2#lastUpdate
channelTypeUID: shelly:lastUpdate
label: Last Update 2
description: Timestamp of last status update
configuration: {}
- id: meter3#currentWatts
channelTypeUID: shelly:meterWatts
label: Power Consumption 3
description: Current Power Consumption in Watts
configuration: {}
- id: meter3#totalKWH
channelTypeUID: shelly:meterTotal
label: Total Energy Consumption 3
description: Total energy consumption in kW/h since the device powered up
(resets on restart)
configuration: {}
- id: meter3#returnedKWH
channelTypeUID: shelly:meterReturned
label: Total Returned Energy 3
description: Total returned energy in kW/h
configuration: {}
- id: meter3#voltage
channelTypeUID: shelly:meterVoltage
label: Voltage 3
description: RMS voltage in Volt
configuration: {}
- id: meter3#current
channelTypeUID: shelly:meterCurrent
label: Current 3
description: Current in A
configuration: {}
- id: meter3#powerFactor
channelTypeUID: shelly:meterPowerFactor
label: Power Factor 3
description: Power Factor in percent for photovoltaic
configuration: {}
- id: meter3#lastUpdate
channelTypeUID: shelly:lastUpdate
label: Last Update 3
description: Timestamp of last status update
configuration: {}
Adding new links to the nCurrent channels all result in NULL values on the OH UI.
There seems to be a problem in the unit definitions of the new channels, I don’t know if I can change the conversion rule.
2024-02-12 07:15:34.241 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Message from /192.168.48.21:5683 (MID=55785): {"G":[[0,9103,0],[0,1101,0],[0,4105,67.38],[0,4106,1897722.6],[0,4107,323446.6],[0,4108,226.13],[0,4109,0.35],[0,4110,0.85],[0,4205,67.03],[0,4206,2287214.1],[0,4207,241639.1],[0,4208,224.38],[0,4209,0.49],[0,4210,0.61],[0,4305,177.30],[0,4306,2751311.4],[0,4307,274044.7],[0,4308,228.23],[0,4309,1.01],[0,4310,0.77],[0,6,0.62],[0,6102,0]]}
2024-02-12 07:15:34.242 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Sensor data {"G":[[0,9103,0],[0,1101,0],[0,4105,67.38],[0,4106,1897722.6],[0,4107,323446.6],[0,4108,226.13],[0,4109,0.35],[0,4110,0.85],[0,4205,67.03],[0,4206,2287214.1],[0,4207,241639.1],[0,4208,224.38],[0,4209,0.49],[0,4210,0.61],[0,4305,177.30],[0,4306,2751311.4],[0,4307,274044.7],[0,4308,228.23],[0,4309,1.01],[0,4310,0.77],[0,6,0.62],[0,6102,0]]} (serial=49315)
2024-02-12 07:15:34.247 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: 22 CoAP sensor updates received
2024-02-12 07:15:34.263 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel meter1#currentWatts updated with 67.38 W (type class org.openhab.core.library.types.QuantityType).
2024-02-12 07:15:34.272 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel meter2#currentWatts updated with 67.03 W (type class org.openhab.core.library.types.QuantityType).
2024-02-12 07:15:34.285 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel meter3#currentWatts updated with 177.30 W (type class org.openhab.core.library.types.QuantityType).
2024-02-12 07:15:34.289 [WARN ] [penhab.core.library.items.NumberItem] - Failed to update item 'Mains_Power_shellyem3244cab4359da1921684821_Neutral_Current' because '0.62 A' could not be converted to the item unit 'kWh'
2024-02-12 07:15:34.290 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel nmeter#ncurrent updated with 0.620 A (type class org.openhab.core.library.types.QuantityType).
2024-02-12 07:15:34.291 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: 18 channels updated from CoIoT status, serial=49315
2024-02-12 07:15:34.322 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel nmeter#ncurrent updated with 0.620 A (type class org.openhab.core.library.types.QuantityType).
2024-02-12 07:15:34.323 [WARN ] [penhab.core.library.items.NumberItem] - Failed to update item 'Mains_Power_shellyem3244cab4359da1921684821_Neutral_Current' because '0.62 A' could not be converted to the item unit 'kWh'
2024-02-12 07:15:34.324 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel meter1#currentWatts updated with 67.38 W (type class org.openhab.core.library.types.QuantityType).
2024-02-12 07:15:34.328 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel meter2#currentWatts updated with 67.03 W (type class org.openhab.core.library.types.QuantityType).
2024-02-12 07:15:34.338 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel meter3#currentWatts updated with 177.30 W (type class org.openhab.core.library.types.QuantityType).
Otherwise the log looks good to me. Very promising. I’ll attach below the startup sequence.
2024-02-12 07:11:20.947 [INFO ] [org.openhab.core.Activator ] - Starting openHAB 4.2.0 (Build #3900)
2024-02-12 07:11:21.748 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Time zone set to 'Europe/Zurich'.
2024-02-12 07:11:21.750 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Locale set to 'en_CH'.
2024-02-12 07:11:38.135 [INFO ] [.core.model.lsp.internal.ModelServer] - Started Language Server Protocol (LSP) service on port 5007
2024-02-12 07:11:42.648 [INFO ] [e.automation.internal.RuleEngineImpl] - Rule engine started.
2024-02-12 07:12:04.678 [INFO ] [nternal.manager.ShellyManagerServlet] - Shelly Manager started at http(s)://192.168.48.196:8080/shelly/manager
2024-02-12 07:12:50.143 [INFO ] [nternal.manager.ShellyManagerServlet] - Shelly Manager started at http(s)://192.168.48.196:8080/shelly/manager
2024-02-12 07:13:59.935 [DEBUG] [.discovery.ShellyBluDiscoveryService] - Starting BLU Discovery
2024-02-12 07:13:59.938 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyem3-244cab4359da: Shelly device discovered: IP-Adress=192.168.48.21, type=shellyem3
2024-02-12 07:14:00.368 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyem3-244cab4359da: Shelly settings : {"device":{"type":"SHEM-3","mac":"244CAB4359DA","hostname":"shellyem3-244CAB4359DA","num_outputs":1,"num_meters":0,"num_emeters":3,"report_period":1},"wifi_ap":{"enabled":false,"ssid":"shellyem3-244CAB4359DA","key":""},"wifi_sta":{"enabled":true,"ssid":"beanzIOT","ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"wifi_sta1":{"enabled":false,"ssid":null,"ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"ap_roaming":{"enabled":true,"threshold":-70},"mqtt": {"enable":false,"server":"192.168.33.3:1883","user":"","id":"shellyem3-244CAB4359DA","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": {"enabled":true,"update_period":15,"peer":""},"sntp":{"server":"time.google.com","enabled":true},"login":{"enabled":false,"unprotected":false,"username":"admin"},"pin_code":"","name":"Mains Power","fw":"20230913-114244/v1.14.0-gcb84623","pon_wifi_reset":false,"discoverable":false,"build_info":{"build_id":"20230913-114244/v1.14.0-gcb84623","build_timestamp":"2023-09-13T11:42:44Z","build_version":"1.0"},"cloud":{"enabled":false,"connected":false},"timezone":"Europe/Zurich","lat":47.490700,"lng":8.738800,"tzautodetect":true,"tz_utc_offset":3600,"tz_dst":false,"tz_dst_auto":true,"time":"08:13","unixtime":1707722039,"led_status_disable":false,"debug_enable":false,"allow_cross_origin":false,"actions":{"active":false,"names":["out_on_url","out_off_url","over_power_url","under_power_url","over_power_url","under_power_url","over_power_url","under_power_url","over_power_url","under_power_url","n_mismatch_url"]},"hwinfo":{"hw_revision":"dev-prototype", "batch_id":0},"cf_output":0,"relays":[{"name":null,"ison":false,"has_timer":false,"default_state":"off","auto_on":0.00,"auto_off":0.00,"schedule":false,"schedule_rules":[]}],"emeters":[{"name":"Phase 1","appliance_type":"General","max_power":0,"range_extender":1},{"name":"Phase 2","appliance_type":"General","max_power":0,"range_extender":1},{"name":"Phase 3","appliance_type":"General","max_power":0,"range_extender":1}],"emeter_n":{"range_extender":1,"mismatch_threshold":0.00},"eco_mode_enabled":true}
2024-02-12 07:14:00.375 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyem3-244cab4359da: Adding Shelly Mains Power, UID=shelly:shellyem3:244cab4359da
2024-02-12 07:14:00.416 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'shelly:shellyem3:244cab4359da' to inbox.
2024-02-12 07:14:00.418 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyplusi4-a8032ab619f0: Shelly device discovered: IP-Adress=192.168.48.45, type=shellyplusi4
2024-02-12 07:14:00.482 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplusi4-a8032ab619f0: Connect Rpc Socket (discovery = true)
2024-02-12 07:14:00.486 [DEBUG] [helly.internal.api2.Shelly2RpcSocket] - shellyplusi4-a8032ab619f0: Connect WebSocket, URI=ws://192.168.48.45/rpc
2024-02-12 07:14:00.608 [DEBUG] [helly.internal.api2.Shelly2RpcSocket] - shellyplusi4-a8032ab619f0: WebSocket connected /192.168.48.196:49702<-/192.168.48.45:80, Idle Timeout=2147483647
2024-02-12 07:14:00.638 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplusi4-a8032ab619f0: Closing Rpc API (socket is connected, discovery=true)
2024-02-12 07:14:00.639 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplusi4-a8032ab619f0: Disconnect Rpc Socket
2024-02-12 07:14:00.640 [DEBUG] [helly.internal.api2.Shelly2RpcSocket] - shellyplusi4-a8032ab619f0: Disconnecting WebSocket (/192.168.48.196:49702 -> /192.168.48.45:80)
2024-02-12 07:14:00.660 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplusi4-a8032ab619f0: WebSocket connection closed, status = 1006/Disconnected
2024-02-12 07:14:00.662 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyplusi4-a8032ab619f0: Shelly settings : {"ble":{"enable":false},"cloud":{"enable":false,"server":"iot.shelly.cloud:6012/jrpc"},"mqtt":{"enable":false,"rpc_ntf":"true","status_ntf":"false"},"sys":{"cfg_rev":13,"device":{"name":"Abwasser Pumpe Monitor","mac":"A8032AB619F0","fw_id":"20231219-133933/1.1.0-g34b5d4f","eco_mode":true,"discoverable":true},"location":{"tz":"Europe/Zurich","lat":47.61205,"lon":8.72529},"sntp":{"server":"ch.pool.ntp.org"},"debug":{"mqtt":{"enable":false},"websocket":{"enable":false},"udp":{}},"ui_data":{},"rpc_udp":{}},"wifi":{"ap":{"enable":false,"ssid":"ShellyPlusI4-A8032AB619F0","is_open":true,"range_extender":{"enable":false}},"sta":{"ssid":"beanzIOT","is_open":false,"enable":true,"ipv4mode":"dhcp"},"sta1":{"is_open":true,"enable":false,"ipv4mode":"dhcp"},"roam":{"rssi_thr":-80,"interval":60}},"input:0":{"id":0,"type":"switch","invert":false,"factory_reset":true},"input:1":{"id":1,"type":"switch","invert":false,"factory_reset":true},"input:2":{"id":2,"type":"switch","invert":false,"factory_reset":true},"input:3":{"id":3,"type":"switch","invert":false,"factory_reset":true}}
2024-02-12 07:14:00.663 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyplusi4-a8032ab619f0: Adding Shelly Abwasser Pumpe Monitor, UID=shelly:shellyplusi4:a8032ab619f0
2024-02-12 07:14:00.670 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'shelly:shellyplusi4:a8032ab619f0' to inbox.
2024-02-12 07:14:00.671 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shelly1pm-e09806a9d2e8: Shelly device discovered: IP-Adress=192.168.48.39, type=shelly1pm
2024-02-12 07:14:00.885 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shelly1pm-e09806a9d2e8: Shelly settings : {"device":{"type":"SHSW-PM","mac":"E09806A9D2E8","hostname":"shelly1pm-E09806A9D2E8","num_outputs":1,"num_meters":1},"wifi_ap":{"enabled":false,"ssid":"shelly1pm-E09806A9D2E8","key":""},"wifi_sta":{"enabled":true,"ssid":"beanzIOT","ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"wifi_sta1":{"enabled":false,"ssid":null,"ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"ap_roaming":{"enabled":false,"threshold":-90},"mqtt": {"enable":false,"server":"192.168.33.3:1883","user":"","id":"shelly1pm-E09806A9D2E8","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": {"enabled":true,"update_period":15,"peer":""},"sntp":{"server":"ch.pool.ntp.org","enabled":true},"login":{"enabled":false,"unprotected":false,"username":"admin"},"pin_code":"","name":"Power Abwasserpumpe","fw":"20230913-113709/v1.14.0-gcb84623","factory_reset_from_switch":true,"pon_wifi_reset":false,"discoverable":true,"build_info":{"build_id":"20230913-113709/v1.14.0-gcb84623","build_timestamp":"2023-09-13T11:37:09Z","build_version":"1.0"},"cloud":{"enabled":false,"connected":false},"timezone":"Europe/Zurich","lat":47.490700,"lng":8.738800,"tzautodetect":true,"tz_utc_offset":3600,"tz_dst":false,"tz_dst_auto":true,"time":"08:14","unixtime":1707722041,"led_status_disable":false,"debug_enable":false,"allow_cross_origin":false,"ext_switch_enable":false,"ext_switch_reverse":false,"ext_switch":{"0":{"relay_num":-1}},"actions":{"active":false,"names":["btn_on_url","btn_off_url","longpush_url","shortpush_url","out_on_url","out_off_url","lp_on_url","lp_off_url","report_url","report_url","report_url","ext_temp_over_url","ext_temp_under_url","ext_temp_over_url","ext_temp_under_url","ext_temp_over_url","ext_temp_under_url","ext_hum_over_url","ext_hum_under_url"]},"hwinfo":{"hw_revision":"prod-191219", "batch_id":1},"max_power":0,"supply_voltage":1,"power_correction":1.00,"mode" :"relay","longpush_time":800,"relays":[{"name":"Power Abwasserpumpe","appliance_type":"General","ison":true,"has_timer":false,"default_state":"on","btn_type":"toggle","btn_reverse":0,"auto_on":0.00,"auto_off":0.00,"schedule":false,"schedule_rules":[],"max_power":0}],"ext_sensors":{},"ext_temperature":{},"ext_humidity":{},"eco_mode_enabled":true}
2024-02-12 07:14:00.886 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shelly1pm-e09806a9d2e8: Adding Shelly Power Abwasserpumpe, UID=shelly:shelly1pm:e09806a9d2e8
2024-02-12 07:14:00.891 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'shelly:shelly1pm:e09806a9d2e8' to inbox.
2024-02-12 07:14:00.892 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyplus1-3c610572ccc4: Shelly device discovered: IP-Adress=192.168.48.46, type=shellyplus1
2024-02-12 07:14:02.015 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplus1-3c610572ccc4: Connect Rpc Socket (discovery = true)
2024-02-12 07:14:02.016 [DEBUG] [helly.internal.api2.Shelly2RpcSocket] - shellyplus1-3c610572ccc4: Connect WebSocket, URI=ws://192.168.48.46/rpc
2024-02-12 07:14:02.042 [DEBUG] [helly.internal.api2.Shelly2RpcSocket] - shellyplus1-3c610572ccc4: WebSocket connected /192.168.48.196:52085<-/192.168.48.46:80, Idle Timeout=2147483647
2024-02-12 07:14:02.086 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplus1-3c610572ccc4: Closing Rpc API (socket is connected, discovery=true)
2024-02-12 07:14:02.087 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplus1-3c610572ccc4: Disconnect Rpc Socket
2024-02-12 07:14:02.089 [DEBUG] [helly.internal.api2.Shelly2RpcSocket] - shellyplus1-3c610572ccc4: Disconnecting WebSocket (/192.168.48.196:52085 -> /192.168.48.46:80)
2024-02-12 07:14:02.095 [DEBUG] [g.shelly.internal.api2.Shelly2ApiRpc] - shellyplus1-3c610572ccc4: WebSocket connection closed, status = 1006/Disconnected
2024-02-12 07:14:02.096 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyplus1-3c610572ccc4: Shelly settings : {"ble":{"enable":false},"cloud":{"enable":false,"server":"iot.shelly.cloud:6012/jrpc"},"mqtt":{"enable":false,"rpc_ntf":"true","status_ntf":"false"},"sys":{"cfg_rev":26,"device":{"name":"switch-1","mac":"3C610572CCC4","fw_id":"20231219-133950/1.1.0-g34b5d4f","eco_mode":true,"discoverable":true},"location":{"tz":"Europe/Zurich","lat":47.61205,"lon":8.72529},"sntp":{"server":"time.google.com"},"debug":{"mqtt":{"enable":false},"websocket":{"enable":false},"udp":{}},"ui_data":{},"rpc_udp":{}},"wifi":{"ap":{"enable":false,"ssid":"ShellyPlus1-3C610572CCC4","is_open":true,"range_extender":{"enable":false}},"sta":{"ssid":"beanzIOT","is_open":false,"enable":true,"ipv4mode":"dhcp"},"sta1":{"is_open":true,"enable":false,"ipv4mode":"dhcp"},"roam":{"rssi_thr":-80,"interval":60}},"input:0":{"id":0,"type":"button","invert":false,"factory_reset":true},"switch:0":{"id":0,"in_mode":"momentary","initial_state":"restore_last","auto_on":false,"auto_on_delay":60.0,"auto_off":false,"auto_off_delay":60.0}}
2024-02-12 07:14:02.098 [DEBUG] [discovery.ShellyDiscoveryParticipant] - shellyplus1-3c610572ccc4: Adding Shelly switch-1, UID=shelly:shellyplus1:3c610572ccc4
2024-02-12 07:14:02.104 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'shelly:shellyplus1:3c610572ccc4' to inbox.
2024-02-12 07:14:14.952 [DEBUG] [shelly.internal.ShellyHandlerFactory] - Mains Power (shellyem3-244cab4359da@192.168.48.21): Create new thing of type shelly:shellyem3 using ShellyRelayHandler
2024-02-12 07:14:15.012 [DEBUG] [shelly.internal.ShellyHandlerFactory] - Thing handler for uid shelly:shellyem3:244cab4359da added, total things = 1
2024-02-12 07:14:17.029 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Using default userId admin from binding config
2024-02-12 07:14:17.030 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Using default password from bindingConfig (userId=admin)
2024-02-12 07:14:17.031 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Device config: Device address=192.168.48.21, HTTP user/password=admin/***, update interval=60
2024-02-12 07:14:17.032 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Configured Events: Button: false, Switch (on/off): false, Push: false, Roller: true, Sensor: true, CoIoT: true, Enable AutoCoIoT: true
2024-02-12 07:14:17.033 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Start initializing for thing Mains Power (shellyem3-244cab4359da@192.168.48.21), type shellyem3, IP address 192.168.48.21, Gen2: false, CoIoT: true
2024-02-12 07:14:17.324 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Auto-CoIoT is enabled, disabling action urls
2024-02-12 07:14:17.325 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Starting CoIoT (autoCoIoT=true/true)
2024-02-12 07:14:17.326 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: Starting CoAP Listener
2024-02-12 07:14:17.327 [DEBUG] [elly.internal.api1.Shelly1CoapServer] - Initializing CoIoT listener (local IP=192.168.48.196:5683)
2024-02-12 07:14:17.391 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: Using CoAP device description from successful HTTP /cit/d
2024-02-12 07:14:17.393 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Device Description for shellyem3-244cab4359da: {"blk":[{"I":1,"D":"relay_0"},{"I":2,"D":"emeter_0"},{"I":3,"D":"emeter_1"},{"I":4,"D":"emeter_2"},{"I":5,"D":"device"}],"sen":[{"I":9103,"T":"EVC","D":"cfgChanged","R":"U16","L":5},{"I":1101,"T":"S","D":"output","R":"0/1","L":1},{"I":4105,"T":"P","D":"power","U":"W","L":2},{"I":4106,"T":"E","D":"energy","U":"Wh","L":2},{"I":4107,"T":"E","D":"energyReturned","U":"Wh","L":2},{"I":4108,"T":"V","D":"voltage","U":"V","L":2},{"I":4109,"T":"I","D":"current","U":"A","L":2},{"I":4110,"T":"S","D":"powerFactor","R":["0/1","-1"],"L":2},{"I":4205,"T":"P","D":"power","U":"W","L":3},{"I":4206,"T":"E","D":"energy","U":"Wh","L":3},{"I":4207,"T":"E","D":"energyReturned","U":"Wh","L":3},{"I":4208,"T":"V","D":"voltage","U":"V","L":3},{"I":4209,"T":"I","D":"current","U":"A","L":3},{"I":4210,"T":"S","D":"powerFactor","R":["0/1","-1"],"L":3},{"I":4305,"T":"P","D":"power","U":"W","L":4},{"I":4306,"T":"E","D":"energy","U":"Wh","L":4},{"I":4307,"T":"E","D":"energyReturned","U":"Wh","L":4},{"I":4308,"T":"V","D":"voltage","U":"V","L":4},{"I":4309,"T":"I","D":"current","U":"A","L":4},{"I":4310,"T":"S","D":"powerFactor","R":["0/1","-1"],"L":4},{"I":6,"T":"I","D":"neutralCurrent","U":"A","L":5},{"I":6102,"T":"A","D":"overpower","R":["0/1","-1"],"L":1}]}
2024-02-12 07:14:17.395 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=1: relay_0
2024-02-12 07:14:17.396 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=2: emeter_0
2024-02-12 07:14:17.397 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=3: emeter_1
2024-02-12 07:14:17.398 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=4: emeter_2
2024-02-12 07:14:17.398 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=5: device
2024-02-12 07:14:17.404 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: Adding 22 sensor definitions
2024-02-12 07:14:17.405 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 9103: cfgChanged, Type=EVC, Range=U16, Links=5
2024-02-12 07:14:17.406 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 1101: output, Type=S, Range=0/1, Links=1
2024-02-12 07:14:17.407 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4105: power, Type=P, Range=null, Links=2
2024-02-12 07:14:17.408 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4106: energy, Type=E, Range=null, Links=2
2024-02-12 07:14:17.409 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4107: energyReturned, Type=E, Range=null, Links=2
2024-02-12 07:14:17.410 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4108: voltage, Type=V, Range=null, Links=2
2024-02-12 07:14:17.411 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4109: current, Type=I, Range=null, Links=2
2024-02-12 07:14:17.412 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4110: powerFactor, Type=S, Range=0/1;-1, Links=2
2024-02-12 07:14:17.412 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4205: power, Type=P, Range=null, Links=3
2024-02-12 07:14:17.413 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4206: energy, Type=E, Range=null, Links=3
2024-02-12 07:14:17.414 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4207: energyReturned, Type=E, Range=null, Links=3
2024-02-12 07:14:17.415 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4208: voltage, Type=V, Range=null, Links=3
2024-02-12 07:14:17.416 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4209: current, Type=I, Range=null, Links=3
2024-02-12 07:14:17.416 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4210: powerFactor, Type=S, Range=0/1;-1, Links=3
2024-02-12 07:14:17.417 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4305: power, Type=P, Range=null, Links=4
2024-02-12 07:14:17.418 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4306: energy, Type=E, Range=null, Links=4
2024-02-12 07:14:17.419 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4307: energyReturned, Type=E, Range=null, Links=4
2024-02-12 07:14:17.420 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4308: voltage, Type=V, Range=null, Links=4
2024-02-12 07:14:17.420 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4309: current, Type=I, Range=null, Links=4
2024-02-12 07:14:17.421 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4310: powerFactor, Type=S, Range=0/1;-1, Links=4
2024-02-12 07:14:17.422 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 6: neutralCurrent, Type=I, Range=null, Links=5
2024-02-12 07:14:17.423 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 6102: overpower, Type=A, Range=0/1;-1, Links=1
2024-02-12 07:14:17.428 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Updating channel definitions, 9 channels
2024-02-12 07:14:17.429 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#deviceName
2024-02-12 07:14:17.430 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#accumulatedWatts
2024-02-12 07:14:17.431 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#accumulatedWTotal
2024-02-12 07:14:17.432 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#accumulatedReturned
2024-02-12 07:14:17.433 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#resetTotals
2024-02-12 07:14:17.434 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#uptime
2024-02-12 07:14:17.434 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#updateAvailable
2024-02-12 07:14:17.435 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#heartBeat
2024-02-12 07:14:17.436 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#statusLed
2024-02-12 07:14:17.446 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel definitions updated
2024-02-12 07:14:17.459 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Initializing device shelly-4359D, type SHEM-3, Hardware: Rev: dev-prototype, batch 0; Firmware: 1.14.0- / 20230913
2024-02-12 07:14:17.460 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Shelly settings info for shelly-4359D: {"device":{"type":"SHEM-3","mac":"244CAB4359DA","hostname":"shellyem3-244CAB4359DA","num_outputs":1,"num_meters":0,"num_emeters":3,"report_period":1},"wifi_ap":{"enabled":false,"ssid":"shellyem3-244CAB4359DA","key":""},"wifi_sta":{"enabled":true,"ssid":"beanzIOT","ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"wifi_sta1":{"enabled":false,"ssid":null,"ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"ap_roaming":{"enabled":true,"threshold":-70},"mqtt": {"enable":false,"server":"192.168.33.3:1883","user":"","id":"shellyem3-244CAB4359DA","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": {"enabled":true,"update_period":15,"peer":""},"sntp":{"server":"time.google.com","enabled":true},"login":{"enabled":false,"unprotected":false,"username":"admin"},"pin_code":"","name":"Mains Power","fw":"20230913-114244/v1.14.0-gcb84623","pon_wifi_reset":false,"discoverable":false,"build_info":{"build_id":"20230913-114244/v1.14.0-gcb84623","build_timestamp":"2023-09-13T11:42:44Z","build_version":"1.0"},"cloud":{"enabled":false,"connected":false},"timezone":"Europe/Zurich","lat":47.490700,"lng":8.738800,"tzautodetect":true,"tz_utc_offset":3600,"tz_dst":false,"tz_dst_auto":true,"time":"08:14","unixtime":1707722056,"led_status_disable":false,"debug_enable":false,"allow_cross_origin":false,"actions":{"active":false,"names":["out_on_url","out_off_url","over_power_url","under_power_url","over_power_url","under_power_url","over_power_url","under_power_url","over_power_url","under_power_url","n_mismatch_url"]},"hwinfo":{"hw_revision":"dev-prototype", "batch_id":0},"cf_output":0,"relays":[{"name":null,"ison":false,"has_timer":false,"default_state":"off","auto_on":0.00,"auto_off":0.00,"schedule":false,"schedule_rules":[]}],"emeters":[{"name":"Phase 1","appliance_type":"General","max_power":0,"range_extender":1},{"name":"Phase 2","appliance_type":"General","max_power":0,"range_extender":1},{"name":"Phase 3","appliance_type":"General","max_power":0,"range_extender":1}],"emeter_n":{"range_extender":1,"mismatch_threshold":0.00},"eco_mode_enabled":true}
2024-02-12 07:14:17.461 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Device hasRelays:true (numRelays=1),isRoller:false (numRoller=0),isDimmer:false,numMeter=3,isEMeter:true), ext. Switch Add-On: n/a,isSensor:false,isDS:false,hasBattery:false,isSense:false,isMotion:false,isLight:false,isBulb:false,isDuo:false,isRGBW2:false,inColor:false, BLU Gateway support: true,alwaysOn:70, updatePeriod:falsesec
2024-02-12 07:14:17.461 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Thing successfully initialized.
2024-02-12 07:14:17.476 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Update status job started, interval=20*3=60sec.
2024-02-12 07:14:18.315 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Message from /192.168.48.21:5683 (MID=55752): {"G":[[0,9103,0],[0,1101,0],[0,4105,68.20],[0,4106,1897721.5],[0,4107,323446.6],[0,4108,226.36],[0,4109,0.35],[0,4110,0.85],[0,4205,57.18],[0,4206,2287213.0],[0,4207,241639.1],[0,4208,224.12],[0,4209,0.45],[0,4210,0.56],[0,4305,179.09],[0,4306,2751308.4],[0,4307,274044.7],[0,4308,227.63],[0,4309,1.02],[0,4310,0.77],[0,6,0.61],[0,6102,0]]}
2024-02-12 07:14:18.325 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Version 2 detected
2024-02-12 07:14:18.327 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Sensor data {"G":[[0,9103,0],[0,1101,0],[0,4105,68.20],[0,4106,1897721.5],[0,4107,323446.6],[0,4108,226.36],[0,4109,0.35],[0,4110,0.85],[0,4205,57.18],[0,4206,2287213.0],[0,4207,241639.1],[0,4208,224.12],[0,4209,0.45],[0,4210,0.56],[0,4305,179.09],[0,4306,2751308.4],[0,4307,274044.7],[0,4308,227.63],[0,4309,1.02],[0,4310,0.77],[0,6,0.61],[0,6102,0]]} (serial=40867)
2024-02-12 07:14:18.329 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: 22 CoAP sensor updates received
2024-02-12 07:14:18.338 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: 19 channels updated from CoIoT status, serial=40867
2024-02-12 07:14:18.375 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Message from /192.168.48.21:5683 (MID=3071): {"G":[[0,9103,0],[0,1101,0],[0,4105,68.20],[0,4106,1897721.5],[0,4107,323446.6],[0,4108,226.36],[0,4109,0.35],[0,4110,0.85],[0,4205,57.18],[0,4206,2287213.0],[0,4207,241639.1],[0,4208,224.12],[0,4209,0.45],[0,4210,0.56],[0,4305,179.09],[0,4306,2751308.4],[0,4307,274044.7],[0,4308,227.63],[0,4309,1.02],[0,4310,0.77],[0,6,0.61],[0,6102,0]]}
2024-02-12 07:14:18.376 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Sensor data {"G":[[0,9103,0],[0,1101,0],[0,4105,68.20],[0,4106,1897721.5],[0,4107,323446.6],[0,4108,226.36],[0,4109,0.35],[0,4110,0.85],[0,4205,57.18],[0,4206,2287213.0],[0,4207,241639.1],[0,4208,224.12],[0,4209,0.45],[0,4210,0.56],[0,4305,179.09],[0,4306,2751308.4],[0,4307,274044.7],[0,4308,227.63],[0,4309,1.02],[0,4310,0.77],[0,6,0.61],[0,6102,0]]} (serial=40867)
2024-02-12 07:14:18.378 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: 22 CoAP sensor updates received
2024-02-12 07:14:18.383 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: 18 channels updated from CoIoT status, serial=40867
2024-02-12 07:14:19.588 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Updating channel definitions, 4 channels
2024-02-12 07:14:19.589 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel relay#output
2024-02-12 07:14:19.590 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel relay#timerActive
2024-02-12 07:14:19.591 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel relay#autoOn
2024-02-12 07:14:19.592 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel relay#autoOff
2024-02-12 07:14:19.604 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel definitions updated
2024-02-12 07:14:19.609 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Updating channel definitions, 4 channels
2024-02-12 07:14:19.611 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel nmeter#ncurrent
2024-02-12 07:14:19.612 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel nmeter#ixsum
2024-02-12 07:14:19.613 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel nmeter#nmismatch
2024-02-12 07:14:19.615 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel nmeter#nmTreshhold
2024-02-12 07:14:19.646 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel definitions updated
2024-02-12 07:14:19.649 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Updating channel definitions, 7 channels
2024-02-12 07:14:19.651 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter1#currentWatts
2024-02-12 07:14:19.652 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter1#totalKWH
2024-02-12 07:14:19.653 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter1#returnedKWH
2024-02-12 07:14:19.654 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter1#voltage
2024-02-12 07:14:19.655 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter1#current
2024-02-12 07:14:19.657 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter1#powerFactor
2024-02-12 07:14:19.658 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter1#lastUpdate
2024-02-12 07:14:19.673 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel definitions updated
2024-02-12 07:14:19.681 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Updating channel definitions, 7 channels
2024-02-12 07:14:19.686 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter2#currentWatts
2024-02-12 07:14:19.687 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter2#totalKWH
2024-02-12 07:14:19.688 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter2#returnedKWH
2024-02-12 07:14:19.689 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter2#voltage
2024-02-12 07:14:19.692 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter2#current
2024-02-12 07:14:19.693 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter2#powerFactor
2024-02-12 07:14:19.694 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter2#lastUpdate
2024-02-12 07:14:19.713 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel definitions updated
2024-02-12 07:14:19.721 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Updating channel definitions, 7 channels
2024-02-12 07:14:19.722 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter3#currentWatts
2024-02-12 07:14:19.723 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter3#totalKWH
2024-02-12 07:14:19.725 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter3#returnedKWH
2024-02-12 07:14:19.726 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter3#voltage
2024-02-12 07:14:19.727 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter3#current
2024-02-12 07:14:19.728 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter3#powerFactor
2024-02-12 07:14:19.730 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter3#lastUpdate
2024-02-12 07:14:19.749 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel definitions updated
2024-02-12 07:14:20.253 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Message from /192.168.48.21:5683 (MID=55753): {"G":[[0,9103,0],[0,1101,0],[0,4105,67.39],[0,4106,1897721.5],[0,4107,323446.6],[0,4108,225.89],[0,4109,0.35],[0,4110,0.85],[0,4205,77.21],[0,4206,2287213.0],[0,4207,241639.1],[0,4208,224.17],[0,4209,0.56],[0,4210,0.63],[0,4305,185.71],[0,4306,2751308.4],[0,4307,274044.7],[0,4308,228.10],[0,4309,1.04],[0,4310,0.78],[0,6,0.67],[0,6102,0]]}
2024-02-12 07:14:20.255 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Sensor data {"G":[[0,9103,0],[0,1101,0],[0,4105,67.39],[0,4106,1897721.5],[0,4107,323446.6],[0,4108,225.89],[0,4109,0.35],[0,4110,0.85],[0,4205,77.21],[0,4206,2287213.0],[0,4207,241639.1],[0,4208,224.17],[0,4209,0.56],[0,4210,0.63],[0,4305,185.71],[0,4306,2751308.4],[0,4307,274044.7],[0,4308,228.10],[0,4309,1.04],[0,4310,0.78],[0,6,0.67],[0,6102,0]]} (serial=41123)
2024-02-12 07:14:20.256 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: 22 CoAP sensor updates received
2024-02-12 07:14:20.263 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: 18 channels updated from CoIoT status, serial=41123
2024-02-12 07:14:21.253 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Message from /192.168.48.21:5683 (MID=55754): {"G":[[0,9103,0],[0,1101,0],[0,4105,67.17],[0,4106,1897721.5],[0,4107,323446.6],[0,4108,225.81],[0,4109,0.35],[0,4110,0.85],[0,4205,57.59],[0,4206,2287213.0],[0,4207,241639.1],[0,4208,224.22],[0,4209,0.44],[0,4210,0.58],[0,4305,179.91],[0,4306,2751308.4],[0,4307,274044.7],[0,4308,228.09],[0,4309,1.02],[0,4310,0.77],[0,6,0.67],[0,6102,0]]}
2024-02-12 07:14:21.254 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Sensor data {"G":[[0,9103,0],[0,1101,0],[0,4105,67.17],[0,4106,1897721.5],[0,4107,323446.6],[0,4108,225.81],[0,4109,0.35],[0,4110,0.85],[0,4205,57.59],[0,4206,2287213.0],[0,4207,241639.1],[0,4208,224.22],[0,4209,0.44],[0,4210,0.58],[0,4305,179.91],[0,4306,2751308.4],[0,4307,274044.7],[0,4308,228.09],[0,4309,1.02],[0,4310,0.77],[0,6,0.67],[0,6102,0]]} (serial=41379)
2024-02-12 07:14:21.255 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: 22 CoAP sensor updates received
2024-02-12 07:14:21.261 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: 18 channels updated from CoIoT status, serial=41379
2024-02-12 07:14:25.252 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Message from /192.168.48.21:5683 (MID=55755): {"G":[[0,9103,0],[0,1101,0],[0,4105,67.11],[0,4106,1897721.5],[0,4107,323446.6],[0,4108,225.91],[0,4109,0.35],[0,4110,0.85],[0,4205,75.99],[0,4206,2287213.0],[0,4207,241639.1],[0,4208,224.38],[0,4209,0.49],[0,4210,0.67],[0,4305,179.47],[0,4306,2751308.4],[0,4307,274044.7],[0,4308,228.23],[0,4309,1.02],[0,4310,0.77],[0,6,0.63],[0,6102,0]]}
2024-02-12 07:14:25.253 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Sensor data {"G":[[0,9103,0],[0,1101,0],[0,4105,67.11],[0,4106,1897721.5],[0,4107,323446.6],[0,4108,225.91],[0,4109,0.35],[0,4110,0.85],[0,4205,75.99],[0,4206,2287213.0],[0,4207,241639.1],[0,4208,224.38],[0,4209,0.49],[0,4210,0.67],[0,4305,179.47],[0,4306,2751308.4],[0,4307,274044.7],[0,4308,228.23],[0,4309,1.02],[0,4310,0.77],[0,6,0.63],[0,6102,0]]} (serial=41635)
2024-02-12 07:14:25.254 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: 22 CoAP sensor updates received
2024-02-12 07:14:25.263 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: 18 channels updated from CoIoT status, serial=41635
2024-02-12 07:14:26.293 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Message from /192.168.48.21:5683 (MID=55756): {"G":[[0,9103,0],[0,1101,0],[0,4105,67.14],[0,4106,1897721.5],[0,4107,323446.6],[0,4108,225.94],[0,4109,0.35],[0,4110,0.85],[0,4205,58.84],[0,4206,2287213.0],[0,4207,241639.1],[0,4208,224.40],[0,4209,0.44],[0,4210,0.59],[0,4305,178.31],[0,4306,2751308.4],[0,4307,274044.7],[0,4308,228.27],[0,4309,1.01],[0,4310,0.77],[0,6,0.65],[0,6102,0]]}
2024-02-12 07:14:26.295 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Sensor data {"G":[[0,9103,0],[0,1101,0],[0,4105,67.14],[0,4106,1897721.5],[0,4107,323446.6],[0,4108,225.94],[0,4109,0.35],[0,4110,0.85],[0,4205,58.84],[0,4206,2287213.0],[0,4207,241639.1],[0,4208,224.40],[0,4209,0.44],[0,4210,0.59],[0,4305,178.31],[0,4306,2751308.4],[0,4307,274044.7],[0,4308,228.27],[0,4309,1.01],[0,4310,0.77],[0,6,0.65],[0,6102,0]]} (serial=41891)
2024-02-12 07:14:26.296 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: 22 CoAP sensor updates received
2024-02-12 07:14:26.303 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: 18 channels updated from CoIoT status, serial=41891
2024-02-12 07:14:34.253 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Message from /192.168.48.21:5683 (MID=55757): {"G":[[0,9103,0],[0,1101,0],[0,4105,66.40],[0,4106,1897721.5],[0,4107,323446.6],[0,4108,226.66],[0,4109,0.35],[0,4110,0.85],[0,4205,59.58],[0,4206,2287213.0],[0,4207,241639.1],[0,4208,223.94],[0,4209,0.44],[0,4210,0.60],[0,4305,178.77],[0,4306,2751308.4],[0,4307,274044.7],[0,4308,228.13],[0,4309,1.01],[0,4310,0.77],[0,6,0.65],[0,6102,0]]}
2024-02-12 07:14:34.254 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Sensor data {"G":[[0,9103,0],[0,1101,0],[0,4105,66.40],[0,4106,1897721.5],[0,4107,323446.6],[0,4108,226.66],[0,4109,0.35],[0,4110,0.85],[0,4205,59.58],[0,4206,2287213.0],[0,4207,241639.1],[0,4208,223.94],[0,4209,0.44],[0,4210,0.60],[0,4305,178.77],[0,4306,2751308.4],[0,4307,274044.7],[0,4308,228.13],[0,4309,1.01],[0,4310,0.77],[0,6,0.65],[0,6102,0]]} (serial=42147)
2024-02-12 07:14:34.255 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: 22 CoAP sensor updates received
2024-02-12 07:14:34.262 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: 18 channels updated from CoIoT status, serial=42147
2024-02-12 07:14:40.251 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Message from /192.168.48.21:5683 (MID=55758): {"G":[[0,9103,0],[0,1101,0],[0,4105,66.50],[0,4106,1897721.5],[0,4107,323446.6],[0,4108,226.50],[0,4109,0.35],[0,4110,0.85],[0,4205,64.46],[0,4206,2287213.0],[0,4207,241639.1],[0,4208,223.96],[0,4209,0.48],[0,4210,0.60],[0,4305,179.09],[0,4306,2751308.4],[0,4307,274044.7],[0,4308,227.99],[0,4309,1.01],[0,4310,0.77],[0,6,0.63],[0,6102,0]]}
2024-02-12 07:14:40.252 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Sensor data {"G":[[0,9103,0],[0,1101,0],[0,4105,66.50],[0,4106,1897721.5],[0,4107,323446.6],[0,4108,226.50],[0,4109,0.35],[0,4110,0.85],[0,4205,64.46],[0,4206,2287213.0],[0,4207,241639.1],[0,4208,223.96],[0,4209,0.48],[0,4210,0.60],[0,4305,179.09],[0,4306,2751308.4],[0,4307,274044.7],[0,4308,227.99],[0,4309,1.01],[0,4310,0.77],[0,6,0.63],[0,6102,0]]} (serial=42403)
2024-02-12 07:14:40.253 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: 22 CoAP sensor updates received
try updated build, but re-discover the thing (delete + discover)
Finally I needed to kick out the thing and setup the channel links again.
On all channels related to current, I needed to adapt the default settings for dimension from Energy (kWh) to Electric Current (A) and State Description Pattern from %0f to %.2f
Please take this as a suggestion for the default config.
With this setup I’m getting meaningful measurements and there are no further warnings visible in the log with respect to shelly. Thanks for your effort!!.
2024-02-13 07:24:37.479 [DEBUG] [shelly.internal.ShellyHandlerFactory] - Mains Power (shellyem3-244cab4359da@192.168.48.21): Create new thing of type shelly:shellyem3 using ShellyRelayHandler
2024-02-13 07:24:37.509 [DEBUG] [shelly.internal.ShellyHandlerFactory] - Thing handler for uid shelly:shellyem3:244cab4359da added, total things = 1
2024-02-13 07:24:39.516 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Using default userId admin from binding config
2024-02-13 07:24:39.517 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Using default password from bindingConfig (userId=admin)
2024-02-13 07:24:39.517 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Device config: Device address=192.168.48.21, HTTP user/password=admin/***, update interval=60
2024-02-13 07:24:39.517 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Configured Events: Button: false, Switch (on/off): false, Push: false, Roller: true, Sensor: true, CoIoT: true, Enable AutoCoIoT: true
2024-02-13 07:24:39.517 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Start initializing for thing Mains Power (shellyem3-244cab4359da@192.168.48.21), type shellyem3, IP address 192.168.48.21, Gen2: false, CoIoT: true
2024-02-13 07:24:39.797 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Auto-CoIoT is enabled, disabling action urls
2024-02-13 07:24:39.798 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Starting CoIoT (autoCoIoT=true/true)
2024-02-13 07:24:39.798 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: Starting CoAP Listener
2024-02-13 07:24:39.840 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: Using CoAP device description from successful HTTP /cit/d
2024-02-13 07:24:39.840 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Device Description for shellyem3-244cab4359da: {"blk":[{"I":1,"D":"relay_0"},{"I":2,"D":"emeter_0"},{"I":3,"D":"emeter_1"},{"I":4,"D":"emeter_2"},{"I":5,"D":"device"}],"sen":[{"I":9103,"T":"EVC","D":"cfgChanged","R":"U16","L":5},{"I":1101,"T":"S","D":"output","R":"0/1","L":1},{"I":4105,"T":"P","D":"power","U":"W","L":2},{"I":4106,"T":"E","D":"energy","U":"Wh","L":2},{"I":4107,"T":"E","D":"energyReturned","U":"Wh","L":2},{"I":4108,"T":"V","D":"voltage","U":"V","L":2},{"I":4109,"T":"I","D":"current","U":"A","L":2},{"I":4110,"T":"S","D":"powerFactor","R":["0/1","-1"],"L":2},{"I":4205,"T":"P","D":"power","U":"W","L":3},{"I":4206,"T":"E","D":"energy","U":"Wh","L":3},{"I":4207,"T":"E","D":"energyReturned","U":"Wh","L":3},{"I":4208,"T":"V","D":"voltage","U":"V","L":3},{"I":4209,"T":"I","D":"current","U":"A","L":3},{"I":4210,"T":"S","D":"powerFactor","R":["0/1","-1"],"L":3},{"I":4305,"T":"P","D":"power","U":"W","L":4},{"I":4306,"T":"E","D":"energy","U":"Wh","L":4},{"I":4307,"T":"E","D":"energyReturned","U":"Wh","L":4},{"I":4308,"T":"V","D":"voltage","U":"V","L":4},{"I":4309,"T":"I","D":"current","U":"A","L":4},{"I":4310,"T":"S","D":"powerFactor","R":["0/1","-1"],"L":4},{"I":6,"T":"I","D":"neutralCurrent","U":"A","L":5},{"I":6102,"T":"A","D":"overpower","R":["0/1","-1"],"L":1}]}
2024-02-13 07:24:39.841 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=1: relay_0
2024-02-13 07:24:39.841 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=2: emeter_0
2024-02-13 07:24:39.841 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=3: emeter_1
2024-02-13 07:24:39.841 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=4: emeter_2
2024-02-13 07:24:39.842 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id=5: device
2024-02-13 07:24:39.844 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: Adding 22 sensor definitions
2024-02-13 07:24:39.845 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 9103: cfgChanged, Type=EVC, Range=U16, Links=5
2024-02-13 07:24:39.845 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 1101: output, Type=S, Range=0/1, Links=1
2024-02-13 07:24:39.845 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4105: power, Type=P, Range=null, Links=2
2024-02-13 07:24:39.846 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4106: energy, Type=E, Range=null, Links=2
2024-02-13 07:24:39.846 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4107: energyReturned, Type=E, Range=null, Links=2
2024-02-13 07:24:39.846 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4108: voltage, Type=V, Range=null, Links=2
2024-02-13 07:24:39.846 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4109: current, Type=I, Range=null, Links=2
2024-02-13 07:24:39.847 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4110: powerFactor, Type=S, Range=0/1;-1, Links=2
2024-02-13 07:24:39.847 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4205: power, Type=P, Range=null, Links=3
2024-02-13 07:24:39.847 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4206: energy, Type=E, Range=null, Links=3
2024-02-13 07:24:39.847 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4207: energyReturned, Type=E, Range=null, Links=3
2024-02-13 07:24:39.847 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4208: voltage, Type=V, Range=null, Links=3
2024-02-13 07:24:39.848 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4209: current, Type=I, Range=null, Links=3
2024-02-13 07:24:39.848 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4210: powerFactor, Type=S, Range=0/1;-1, Links=3
2024-02-13 07:24:39.848 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4305: power, Type=P, Range=null, Links=4
2024-02-13 07:24:39.848 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4306: energy, Type=E, Range=null, Links=4
2024-02-13 07:24:39.848 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4307: energyReturned, Type=E, Range=null, Links=4
2024-02-13 07:24:39.849 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4308: voltage, Type=V, Range=null, Links=4
2024-02-13 07:24:39.849 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4309: current, Type=I, Range=null, Links=4
2024-02-13 07:24:39.849 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 4310: powerFactor, Type=S, Range=0/1;-1, Links=4
2024-02-13 07:24:39.849 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 6: neutralCurrent, Type=I, Range=null, Links=5
2024-02-13 07:24:39.850 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: id 6102: overpower, Type=A, Range=0/1;-1, Links=1
2024-02-13 07:24:39.850 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Updating channel definitions, 9 channels
2024-02-13 07:24:39.851 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#deviceName
2024-02-13 07:24:39.851 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#accumulatedWatts
2024-02-13 07:24:39.852 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#accumulatedWTotal
2024-02-13 07:24:39.852 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#accumulatedReturned
2024-02-13 07:24:39.852 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#resetTotals
2024-02-13 07:24:39.852 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#uptime
2024-02-13 07:24:39.852 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#updateAvailable
2024-02-13 07:24:39.853 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#heartBeat
2024-02-13 07:24:39.853 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel device#statusLed
2024-02-13 07:24:39.858 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel definitions updated
2024-02-13 07:24:39.859 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Initializing device shelly-4359D, type SHEM-3, Hardware: Rev: dev-prototype, batch 0; Firmware: 1.14.0- / 20230913
2024-02-13 07:24:39.859 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Shelly settings info for shelly-4359D: {"device":{"type":"SHEM-3","mac":"244CAB4359DA","hostname":"shellyem3-244CAB4359DA","num_outputs":1,"num_meters":0,"num_emeters":3,"report_period":1},"wifi_ap":{"enabled":false,"ssid":"shellyem3-244CAB4359DA","key":""},"wifi_sta":{"enabled":true,"ssid":"beanzIOT","ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"wifi_sta1":{"enabled":false,"ssid":null,"ipv4_method":"dhcp","ip":null,"gw":null,"mask":null,"dns":null},"ap_roaming":{"enabled":true,"threshold":-70},"mqtt": {"enable":false,"server":"192.168.33.3:1883","user":"","id":"shellyem3-244CAB4359DA","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": {"enabled":true,"update_period":15,"peer":""},"sntp":{"server":"time.google.com","enabled":true},"login":{"enabled":false,"unprotected":false,"username":"admin"},"pin_code":"","name":"Mains Power","fw":"20230913-114244/v1.14.0-gcb84623","pon_wifi_reset":false,"discoverable":false,"build_info":{"build_id":"20230913-114244/v1.14.0-gcb84623","build_timestamp":"2023-09-13T11:42:44Z","build_version":"1.0"},"cloud":{"enabled":false,"connected":false},"timezone":"Europe/Zurich","lat":47.490700,"lng":8.738800,"tzautodetect":true,"tz_utc_offset":3600,"tz_dst":false,"tz_dst_auto":true,"time":"08:24","unixtime":1707809079,"led_status_disable":false,"debug_enable":false,"allow_cross_origin":false,"actions":{"active":false,"names":["out_on_url","out_off_url","over_power_url","under_power_url","over_power_url","under_power_url","over_power_url","under_power_url","over_power_url","under_power_url","n_mismatch_url"]},"hwinfo":{"hw_revision":"dev-prototype", "batch_id":0},"cf_output":0,"relays":[{"name":null,"ison":false,"has_timer":false,"default_state":"off","auto_on":0.00,"auto_off":0.00,"schedule":false,"schedule_rules":[]}],"emeters":[{"name":"Phase 1","appliance_type":"General","max_power":0,"range_extender":1},{"name":"Phase 2","appliance_type":"General","max_power":0,"range_extender":1},{"name":"Phase 3","appliance_type":"General","max_power":0,"range_extender":1}],"emeter_n":{"range_extender":1,"mismatch_threshold":0.00},"eco_mode_enabled":true}
2024-02-13 07:24:39.860 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Device hasRelays:true (numRelays=1),isRoller:false (numRoller=0),isDimmer:false,numMeter=3,isEMeter:true), ext. Switch Add-On: n/a,isSensor:false,isDS:false,hasBattery:false,isSense:false,isMotion:false,isLight:false,isBulb:false,isDuo:false,isRGBW2:false,inColor:false, BLU Gateway support: true,alwaysOn:70, updatePeriod:falsesec
2024-02-13 07:24:39.860 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Thing successfully initialized.
2024-02-13 07:24:39.865 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Update status job started, interval=20*3=60sec.
2024-02-13 07:24:42.069 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Updating channel definitions, 4 channels
2024-02-13 07:24:42.069 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel relay#output
2024-02-13 07:24:42.070 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel relay#timerActive
2024-02-13 07:24:42.070 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel relay#autoOn
2024-02-13 07:24:42.071 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel relay#autoOff
2024-02-13 07:24:42.077 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel definitions updated
2024-02-13 07:24:42.079 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Updating channel definitions, 4 channels
2024-02-13 07:24:42.080 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel nmeter#ncurrent
2024-02-13 07:24:42.080 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel nmeter#ixsum
2024-02-13 07:24:42.080 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel nmeter#nmismatch
2024-02-13 07:24:42.081 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel nmeter#nmTreshhold
2024-02-13 07:24:42.086 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel definitions updated
2024-02-13 07:24:42.089 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Updating channel definitions, 7 channels
2024-02-13 07:24:42.089 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter1#currentWatts
2024-02-13 07:24:42.089 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter1#totalKWH
2024-02-13 07:24:42.090 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter1#returnedKWH
2024-02-13 07:24:42.090 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter1#voltage
2024-02-13 07:24:42.090 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter1#current
2024-02-13 07:24:42.090 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter1#powerFactor
2024-02-13 07:24:42.090 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter1#lastUpdate
2024-02-13 07:24:42.097 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel definitions updated
2024-02-13 07:24:42.098 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Updating channel definitions, 7 channels
2024-02-13 07:24:42.099 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter2#currentWatts
2024-02-13 07:24:42.099 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter2#totalKWH
2024-02-13 07:24:42.100 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter2#returnedKWH
2024-02-13 07:24:42.100 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter2#voltage
2024-02-13 07:24:42.100 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter2#current
2024-02-13 07:24:42.100 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter2#powerFactor
2024-02-13 07:24:42.101 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter2#lastUpdate
2024-02-13 07:24:42.109 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel definitions updated
2024-02-13 07:24:42.111 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Updating channel definitions, 7 channels
2024-02-13 07:24:42.111 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter3#currentWatts
2024-02-13 07:24:42.112 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter3#totalKWH
2024-02-13 07:24:42.112 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter3#returnedKWH
2024-02-13 07:24:42.113 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter3#voltage
2024-02-13 07:24:42.113 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter3#current
2024-02-13 07:24:42.113 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter3#powerFactor
2024-02-13 07:24:42.114 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Adding channel meter3#lastUpdate
2024-02-13 07:24:42.124 [DEBUG] [y.internal.handler.ShellyBaseHandler] - shellyem3-244cab4359da: Channel definitions updated
2024-02-13 07:24:52.001 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Message from /192.168.48.21:5683 (MID=7931): {"G":[[0,9103,0],[0,1101,0],[0,4105,8.77],[0,4106,1899031.6],[0,4107,323446.6],[0,4108,226.74],[0,4109,0.23],[0,4110,0.17],[0,4205,77.71],[0,4206,2290930.5],[0,4207,241639.1],[0,4208,224.96],[0,4209,0.52],[0,4210,0.67],[0,4305,148.92],[0,4306,2757018.6],[0,4307,274044.7],[0,4308,227.06],[0,4309,0.94],[0,4310,0.70],[0,6,0.77],[0,6102,0]]}
2024-02-13 07:24:52.012 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Version 2 detected
2024-02-13 07:24:52.013 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Sensor data {"G":[[0,9103,0],[0,1101,0],[0,4105,8.77],[0,4106,1899031.6],[0,4107,323446.6],[0,4108,226.74],[0,4109,0.23],[0,4110,0.17],[0,4205,77.71],[0,4206,2290930.5],[0,4207,241639.1],[0,4208,224.96],[0,4209,0.52],[0,4210,0.67],[0,4305,148.92],[0,4306,2757018.6],[0,4307,274044.7],[0,4308,227.06],[0,4309,0.94],[0,4310,0.70],[0,6,0.77],[0,6102,0]]} (serial=53981)
2024-02-13 07:24:52.014 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: 22 CoAP sensor updates received
2024-02-13 07:24:52.016 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: 18 channels updated from CoIoT status, serial=53981
2024-02-13 07:24:52.017 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Message from /192.168.48.21:5683 (MID=7931): {"G":[[0,9103,0],[0,1101,0],[0,4105,8.77],[0,4106,1899031.6],[0,4107,323446.6],[0,4108,226.74],[0,4109,0.23],[0,4110,0.17],[0,4205,77.71],[0,4206,2290930.5],[0,4207,241639.1],[0,4208,224.96],[0,4209,0.52],[0,4210,0.67],[0,4305,148.92],[0,4306,2757018.6],[0,4307,274044.7],[0,4308,227.06],[0,4309,0.94],[0,4310,0.70],[0,6,0.77],[0,6102,0]]}
2024-02-13 07:24:52.017 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: Thing is shutting down, ignore CoIOT message
2024-02-13 07:24:52.046 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Message from /192.168.48.21:5683 (MID=20201): {"G":[[0,9103,0],[0,1101,0],[0,4105,8.77],[0,4106,1899031.6],[0,4107,323446.6],[0,4108,226.74],[0,4109,0.23],[0,4110,0.17],[0,4205,77.71],[0,4206,2290930.5],[0,4207,241639.1],[0,4208,224.96],[0,4209,0.52],[0,4210,0.67],[0,4305,148.92],[0,4306,2757018.6],[0,4307,274044.7],[0,4308,227.06],[0,4309,0.94],[0,4310,0.70],[0,6,0.77],[0,6102,0]]}
2024-02-13 07:24:52.046 [DEBUG] [lly.internal.api1.Shelly1CoapHandler] - shellyem3-244cab4359da: CoIoT Sensor data {"G":[[0,9103,0],[0,1101,0],[0,4105,8.77],[0,4106,1899031.6],[0,4107,323446.6],[0,4108,226.74],[0,4109,0.23],[0,4110,0.17],[0,4205,77.71],[0,4206,2290930.5],[0,4207,241639.1],[0,4208,224.96],[0,4209,0.52],[0,4210,0.67],[0,4305,148.92],[0,4306,2757018.6],[0,4307,274044.7],[0,4308,227.06],[0,4309,0.94],[0,4310,0.70],[0,6,0.77],[0,6102,0]]} (serial=53981)
The thing should already create a channel of type Number:ElectricalCurrent, please check on a new thing config.
U change the default pattern to “%.3f %unit%”
Please check the new build.
Updated to OH 4.2 Build 3903
Nops, the thing’s channel comes always as number / Energy (kWh).
I have no clue, how to change the default pattern. Could u pls give me a hint?