[Solved] ZigBee Bitron 902010/25 no meter values

Setup, Configuration and Use Beginners
1
  • Platform information:
    • Hardware: Raspi4 8Gb
    • OS: openhabian
    • openHAB version: OH3.1

The Things " Bitron 902010/25" (Poweroutlet with Smartmeter Values" are implemented by Qivison USB Dongle and run in Status Online.
Items to all 3 channels are configured and the Switch function is running.

image
image1379×377 40.1 KB

The Values of Meter Channels shown “Null” all time. The Bitron Description shows following for " Bitron 902010/25"
image
image1668×1497 388 KB

in ZigBee XML-File are the Values have different Names

<ZclCluster>
          <clusterId>1794</clusterId>
          <isClient>false</isClient>
          <attributes>
            <entry>
              <int>0</int>
              <ZclAttribute>
                <id>0</id>
                <name>Current Summation Delivered</name>
                <dataType>UNSIGNED_48_BIT_INTEGER</dataType>
                <mandatory>true</mandatory>
                <implemented>true</implemented>
                <readable>true</readable>
                <writable>false</writable>
                <reportable>false</reportable>
                <minimumReportingPeriod>0</minimumReportingPeriod>
                <maximumReportingPeriod>0</maximumReportingPeriod>
                <reportingTimeout>0</reportingTimeout>
                <lastReportTime>
                  <time>1625991602180</time>
                  <timezone>Europe/Berlin</timezone>
                </lastReportTime>
                <lastValue class="long">107680</lastValue>
              </ZclAttribute>
            </entry>
            <entry>
              <int>2048</int>
              <ZclAttribute>
                <id>2048</id>
                <name>Generic Alarm Mask</name>
                <dataType>BITMAP_16_BIT</dataType>
                <mandatory>false</mandatory>
                <implemented>false</implemented>
                <readable>true</readable>
                <writable>true</writable>
                <reportable>true</reportable>
                <minimumReportingPeriod>0</minimumReportingPeriod>
                <maximumReportingPeriod>0</maximumReportingPeriod>
                <reportingTimeout>0</reportingTimeout>
              </ZclAttribute>
            </entry>
            <entry>
              <int>1</int>
              <ZclAttribute>
                <id>1</id>
                <name>Current Summation Received</name>
                <dataType>UNSIGNED_48_BIT_INTEGER</dataType>
                <mandatory>false</mandatory>
                <implemented>false</implemented>
                <readable>true</readable>
                <writable>false</writable>
                <reportable>false</reportable>
                <minimumReportingPeriod>0</minimumReportingPeriod>
                <maximumReportingPeriod>0</maximumReportingPeriod>
                <reportingTimeout>0</reportingTimeout>
              </ZclAttribute>
            </entry>

In \OPENHABIAN\openHAB-userdata\jsondb\org.openhab.core.thing.Thing.json you can see the Name of the Values also different to the XML File

 "zigbee:device:06001B20:00124b0007307ffd": {
    "class": "org.openhab.core.thing.internal.ThingImpl",
    "value": {
      "label": "BitronSteckd2",
      "bridgeUID": {
        "segments": [
          "zigbee",
          "coordinator_telegesis",
          "06001B20"
        ],
        "uid": "zigbee:coordinator_telegesis:06001B20"
      },
      "channels": [
        {
          "acceptedItemType": "Number",
          "kind": "STATE",
          "uid": {
            "segments": [
              "zigbee",
              "device",
              "06001B20",
              "00124b0007307ffd",
              "00124B0007307FFD_1_meteringinstantdemand"
            ],
            "uid": "zigbee:device:06001B20:00124b0007307ffd:00124B0007307FFD_1_meteringinstantdemand"
          },
          "channelTypeUID": {
            "segments": [
              "zigbee",
              "metering_instantdemand"
            ],
            "uid": "zigbee:metering_instantdemand"
          },
          "label": "Metering Instantaneous Demand",
          "configuration": {
            "properties": {
              "zigbee_reporting_polling": 7200.0
            }
          },
          "properties": {
            "zigbee_endpoint": "1"
          },
          "defaultTags": [],
          "autoUpdatePolicy": "DEFAULT"
        },
        {
          "acceptedItemType": "Number",
          "kind": "STATE",
          "uid": {
            "segments": [
              "zigbee",
              "device",
              "06001B20",
              "00124b0007307ffd",
              "00124B0007307FFD_1_meteringsumdelivered"
            ],
            "uid": "zigbee:device:06001B20:00124b0007307ffd:00124B0007307FFD_1_meteringsumdelivered"
          },
          "channelTypeUID": {
            "segments": [
              "zigbee",
              "metering_sumdelivered"
            ],
            "uid": "zigbee:metering_sumdelivered"
          },
          "label": "Metering Summation Delivered",
          "configuration": {
            "properties": {
              "zigbee_reporting_polling": 7200.0
            }
          },
          "properties": {
            "zigbee_endpoint": "1"
          },
          "defaultTags": [],
          "autoUpdatePolicy": "DEFAULT"
        },
        {
          "acceptedItemType": "Switch",
          "kind": "STATE",
          "uid": {
            "segments": [
              "zigbee",
              "device",
              "06001B20",
              "00124b0007307ffd",
              "00124B0007307FFD_1_switch"
            ],
            "uid": "zigbee:device:06001B20:00124b0007307ffd:00124B0007307FFD_1_switch"
          },
          "channelTypeUID": {
            "segments": [
              "zigbee",
              "switch_onoff"
            ],
            "uid": "zigbee:switch_onoff"
          },
          "label": "Switch",
          "configuration": {
            "properties": {
              "zigbee_reporting_polling": 900
            }
          },
          "properties": {
            "zigbee_endpoint": "1"
          },
          "defaultTags": [],
          "autoUpdatePolicy": "DEFAULT"
        }
      ],
      "configuration": {
        "properties": {
          "zigbee_macaddress": "00124B0007307FFD"
        }
      },
      "properties": {
        "zigbee_logicaltype": "ROUTER",
        "zigbee_powerlevel": "FULL",
        "zigbee_manufacturercode": "0x0000",
        "modelId": "902010/25",
        "zigbee_networkaddress": "33807",
        "zigbee_powersource": "MAINS",
        "zigbee_datecode": "20150629",
        "zigbee_zclversion": "1",
        "zigbee_routes": "[]",
        "zigbee_lastupdate": "",
        "zigbee_stkcompliance": "0",
        "vendor": "Bitron Home",
        "zigbee_powermode": "RECEIVER_ON_IDLE",
        "zigbee_powersources": "[MAINS]",
        "hardwareVersion": "0",
        "firmwareVersion": "0x0000000F",
        "zigbee_neighbors": "[]",
        "zigbee_applicationVersion": "15",
        "zigbee_device_initialised": "true",
        "zigbee_devices": "[]"
      },
      "uid": {
        "segments": [
          "zigbee",
          "device",
          "06001B20",
          "00124b0007307ffd"
        ],
        "uid": "zigbee:device:06001B20:00124b0007307ffd"
      },
      "thingTypeUID": {
        "segments": [
          "zigbee",
          "device"
        ],
        "uid": "zigbee:device"
      }
    }
  },

Is there any Idea how or who can solve this problem.

Thanks for reply’s

2

Given that the channels are shown, this means that the binding has detected the device supports this. If it’s not reporting, then possibly the configuration to set the reporting didn’t get transferred, or the device simply isn’t reporting.

If you have logs of the initialisation, I can take a look (you can reinitialise the device in the UI). Likewise it would be good to just check the logs to see if the device is reporting, but the binding isn’t detecting it for some reason.

3

here the logfiles and thx for support.

events:

2021-07-19 10:45:22.534 [INFO ] [openhab.event.InboxAddedEvent       ] - Discovery Result with UID 'zigbee:device:06001B20:00124b00073081bd' has been added.
2021-07-19 10:46:17.046 [INFO ] [openhab.event.InboxRemovedEvent     ] - Discovery Result with UID 'zigbee:device:06001B20:00124b00073081bd' has been removed.
2021-07-19 10:46:17.056 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:device:06001B20:00124b00073081bd' changed from UNINITIALIZED to INITIALIZING
2021-07-19 10:46:17.066 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:device:06001B20:00124b00073081bd' changed from INITIALIZING to UNKNOWN
2021-07-19 10:46:18.155 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:device:06001B20:00124b00073081bd' changed from UNKNOWN to OFFLINE (HANDLER_INITIALIZING_ERROR)
2021-07-19 10:46:43.440 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:device:06001B20:00124b00073081bd' changed from OFFLINE (HANDLER_INITIALIZING_ERROR) to UNINITIALIZED
2021-07-19 10:46:43.455 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:device:06001B20:00124b00073081bd' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2021-07-19 10:46:43.459 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:coordinator_telegesis:06001B20' changed from ONLINE to UNINITIALIZED
2021-07-19 10:46:43.778 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:coordinator_telegesis:06001B20' changed from UNINITIALIZED to UNINITIALIZED (DISABLED)
2021-07-19 10:46:43.783 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:device:06001B20:00124b00073081bd' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to UNINITIALIZED (BRIDGE_UNINITIALIZED)
2021-07-19 10:46:53.069 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:coordinator_telegesis:06001B20' changed from UNINITIALIZED (DISABLED) to INITIALIZING
2021-07-19 10:46:53.082 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:coordinator_telegesis:06001B20' changed from INITIALIZING to UNKNOWN
2021-07-19 10:46:53.092 [INFO ] [penhab.event.FirmwareStatusInfoEvent] - Firmware status of thing zigbee:coordinator_telegesis:06001B20 changed to UNKNOWN.
2021-07-19 10:46:53.095 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:device:06001B20:00124b00073081bd' changed from UNINITIALIZED (BRIDGE_UNINITIALIZED) to INITIALIZING
2021-07-19 10:46:53.103 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:device:06001B20:00124b00073081bd' changed from INITIALIZING to UNKNOWN
2021-07-19 10:46:55.114 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:coordinator_telegesis:06001B20' changed from UNKNOWN to ONLINE
2021-07-19 10:48:10.890 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:device:06001B20:00124b00073081bd' changed from UNKNOWN to ONLINE

OpenHAB:

2021-07-19 10:46:18.143 [ERROR] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Exception creating channels 
java.lang.ClassCastException: class java.lang.Integer cannot be cast to class java.lang.Long (java.lang.Integer and java.lang.Long are in module java.base of loader 'bootstrap')
	at com.zsmartsystems.zigbee.serialization.DefaultSerializer.appendZigBeeType(DefaultSerializer.java:209) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.zcl.field.AttributeReportingConfigurationRecord.serialize(AttributeReportingConfigurationRecord.java:361) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.zcl.ZclFieldSerializer.serialize(ZclFieldSerializer.java:38) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.zcl.clusters.general.ConfigureReportingCommand.serialize(ConfigureReportingCommand.java:107) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.ZigBeeNetworkManager.sendCommand(ZigBeeNetworkManager.java:905) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager.send(ZigBeeTransactionManager.java:443) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager.sendNextTransaction(ZigBeeTransactionManager.java:681) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager.queueTransaction(ZigBeeTransactionManager.java:372) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager.sendTransaction(ZigBeeTransactionManager.java:351) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.ZigBeeNetworkManager.sendTransaction(ZigBeeNetworkManager.java:2032) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.ZigBeeNode.sendTransaction(ZigBeeNode.java:926) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.ZigBeeEndpoint.sendTransaction(ZigBeeEndpoint.java:596) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.zcl.ZclCluster.sendCommand(ZclCluster.java:294) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.zcl.ZclCluster.sendCommand(ZclCluster.java:305) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.zcl.ZclCluster.setReporting(ZclCluster.java:1767) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.zcl.ZclCluster.setReporting(ZclCluster.java:589) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.zcl.ZclAttribute.setReporting(ZclAttribute.java:431) ~[bundleFile:?]
	at org.openhab.binding.zigbee.internal.converter.ZigBeeConverterMeteringSummationDelivered.initializeDevice(ZigBeeConverterMeteringSummationDelivered.java:81) ~[bundleFile:?]
	at org.openhab.binding.zigbee.handler.ZigBeeThingHandler.initializeDevice(ZigBeeThingHandler.java:514) ~[bundleFile:?]
	at org.openhab.binding.zigbee.handler.ZigBeeThingHandler.doNodeInitialisation(ZigBeeThingHandler.java:377) [bundleFile:?]
	at org.openhab.binding.zigbee.handler.ZigBeeThingHandler$1.call(ZigBeeThingHandler.java:227) [bundleFile:?]
	at org.openhab.binding.zigbee.handler.ZigBeeThingHandler$1.call(ZigBeeThingHandler.java:1) [bundleFile:?]
	at java.util.concurrent.FutureTask.run(FutureTask.java:264) [?:?]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:304) [?:?]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [?:?]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [?:?]
	at java.lang.Thread.run(Thread.java:829) [?:?]
2021-07-19 10:46:55.114 [INFO ] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Starting ZigBee device discovery
2021-07-19 10:47:05.286 [INFO ] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Starting ZigBee device discovery
2021-07-19 10:47:08.984 [WARN ] [zsmartsystems.zigbee.ZigBeeExecutors] - Uncaught exception in thread NotificationService-thread-5
java.lang.ClassCastException: class java.lang.Integer cannot be cast to class java.lang.Long (java.lang.Integer and java.lang.Long are in module java.base of loader 'bootstrap')
	at com.zsmartsystems.zigbee.serialization.DefaultSerializer.appendZigBeeType(DefaultSerializer.java:209) ~[?:?]
	at com.zsmartsystems.zigbee.zcl.field.AttributeReportingConfigurationRecord.serialize(AttributeReportingConfigurationRecord.java:361) ~[?:?]
	at com.zsmartsystems.zigbee.zcl.ZclFieldSerializer.serialize(ZclFieldSerializer.java:38) ~[?:?]
	at com.zsmartsystems.zigbee.zcl.clusters.general.ConfigureReportingCommand.serialize(ConfigureReportingCommand.java:107) ~[?:?]
	at com.zsmartsystems.zigbee.ZigBeeNetworkManager.sendCommand(ZigBeeNetworkManager.java:905) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager.send(ZigBeeTransactionManager.java:443) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager.sendNextTransaction(ZigBeeTransactionManager.java:681) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager.transactionComplete(ZigBeeTransactionManager.java:540) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransaction.completeTransaction(ZigBeeTransaction.java:435) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransaction.commandReceived(ZigBeeTransaction.java:387) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager$2.run(ZigBeeTransactionManager.java:557) ~[?:?]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) ~[?:?]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) ~[?:?]
	at java.lang.Thread.run(Thread.java:829) [?:?]
4

Please enable debug logging. The binding docs describe how to do this - without this it’s pretty much impossible to know what is happening.

5

find enclosed the debug logging from ZigBee Binding. The MeterValues will be detected but the chanels shown NULL. Hope you found a solution to bring both together.

I have now only the ZigBee and MQTT Binding running and the Zig is in debug. Can not post all togehteht so I split.

PART 1

2021-07-21 13:55:23.286 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - Starting ZigBee scan for zigbee:coordinator_telegesis:06001B20
2021-07-21 13:55:42.515 [INFO ] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Starting ZigBee device discovery
2021-07-21 13:55:42.519 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Creating ZigBee device zigbee:device with bridge zigbee:coordinator_telegesis:06001B20
2021-07-21 13:55:42.523 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'zigbee:device:06001B20:00124b00073081bd' to inbox.
2021-07-21 13:55:42.527 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Node discovery not complete
2021-07-21 13:55:42.764 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 00124B00073081BD: ZigBee saving network state complete.
2021-07-21 13:55:43.452 [INFO ] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Starting ZigBee device discovery
2021-07-21 13:55:43.454 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Creating ZigBee device zigbee:device with bridge zigbee:coordinator_telegesis:06001B20
2021-07-21 13:55:43.461 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: ZigBee node property discovery start
2021-07-21 13:55:43.466 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: ZigBee node property discovery using basic cluster on endpoint 6F87/1
2021-07-21 13:55:43.940 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: Stack version failed
2021-07-21 13:55:43.943 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: ZigBee node property discovery using OTA cluster on endpoint 6F87/4
2021-07-21 13:55:44.027 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 00124B00073081BD: ZigBee saving network state complete.
2021-07-21 13:55:44.058 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: ZigBee node property discovery complete: {zigbee_logicaltype=ROUTER, zigbee_powerlevel=FULL, zigbee_manufacturercode=0x0000, modelId=902010/25, zigbee_networkaddress=28551, zigbee_powersource=MAINS, zigbee_datecode=20150629, zigbee_zclversion=1, vendor=Bitron Home, zigbee_powermode=RECEIVER_ON_IDLE, zigbee_powersources=[MAINS], hardwareVersion=0, firmwareVersion=0x0000000F, zigbee_applicationVersion=15}
2021-07-21 13:55:44.062 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Checking endpoint 1 channels
2021-07-21 13:55:44.574 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Initializing channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_meteringinstantdemand with org.openhab.binding.zigbee.internal.converter.ZigBeeConverterMeteringInstantaneousDemand@194c970
2021-07-21 13:55:44.577 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: Initialising electrical measurement cluster
2021-07-21 13:55:44.826 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Initializing channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_meteringsumdelivered with org.openhab.binding.zigbee.internal.converter.ZigBeeConverterMeteringSummationDelivered@1bc770
2021-07-21 13:55:44.829 [DEBUG] [eConverterMeteringSummationDelivered] - 00124B00073081BD: Initialising electrical measurement cluster
2021-07-21 13:55:44.954 [WARN ] [zsmartsystems.zigbee.ZigBeeExecutors] - Uncaught exception in thread NotificationService-thread-9
java.lang.ClassCastException: class java.lang.Integer cannot be cast to class java.lang.Long (java.lang.Integer and java.lang.Long are in module java.base of loader 'bootstrap')
	at com.zsmartsystems.zigbee.serialization.DefaultSerializer.appendZigBeeType(DefaultSerializer.java:209) ~[?:?]
	at com.zsmartsystems.zigbee.zcl.field.AttributeReportingConfigurationRecord.serialize(AttributeReportingConfigurationRecord.java:361) ~[?:?]
	at com.zsmartsystems.zigbee.zcl.ZclFieldSerializer.serialize(ZclFieldSerializer.java:38) ~[?:?]
	at com.zsmartsystems.zigbee.zcl.clusters.general.ConfigureReportingCommand.serialize(ConfigureReportingCommand.java:107) ~[?:?]
	at com.zsmartsystems.zigbee.ZigBeeNetworkManager.sendCommand(ZigBeeNetworkManager.java:905) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager.send(ZigBeeTransactionManager.java:443) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager.sendNextTransaction(ZigBeeTransactionManager.java:681) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager.transactionComplete(ZigBeeTransactionManager.java:540) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransaction.completeTransaction(ZigBeeTransaction.java:435) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransaction.commandReceived(ZigBeeTransaction.java:387) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager$2.run(ZigBeeTransactionManager.java:557) ~[?:?]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) ~[?:?]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) ~[?:?]
	at java.lang.Thread.run(Thread.java:829) [?:?]
2021-07-21 13:56:04.955 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Initializing channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch with org.openhab.binding.zigbee.internal.converter.ZigBeeConverterSwitchOnoff@15330bc
2021-07-21 13:56:05.197 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Checking endpoint 4 channels
2021-07-21 13:56:05.204 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Update ZigBee device zigbee:device with bridge zigbee:coordinator_telegesis:06001B20, label 'Bitron Home 902010/25'
2021-07-21 13:56:05.650 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 00124B00073081BD: ZigBee saving network state complete.
2021-07-21 13:57:46.769 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Initializing ZigBee thing handler zigbee:device:06001B20:00124b00073081bd
2021-07-21 13:57:46.772 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Coordinator status changed to ONLINE.
2021-07-21 13:57:46.774 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Coordinator is ONLINE. Starting device initialisation.
2021-07-21 13:57:46.788 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Start initialising ZigBee Thing handler
2021-07-21 13:57:46.790 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: ZigBee node property discovery start
2021-07-21 13:57:46.791 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: ZigBee node property discovery using basic cluster on endpoint 6F87/1
2021-07-21 13:57:47.241 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: Stack version failed
2021-07-21 13:57:47.244 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: ZigBee node property discovery using OTA cluster on endpoint 6F87/4
2021-07-21 13:57:47.246 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: ZigBee node property discovery complete: {zigbee_logicaltype=ROUTER, zigbee_powerlevel=FULL, zigbee_manufacturercode=0x0000, modelId=902010/25, zigbee_networkaddress=28551, zigbee_powersource=MAINS, zigbee_datecode=20150629, zigbee_zclversion=1, vendor=Bitron Home, zigbee_powermode=RECEIVER_ON_IDLE, zigbee_powersources=[MAINS], hardwareVersion=0, firmwareVersion=0x0000000F, zigbee_applicationVersion=15}
2021-07-21 13:57:47.256 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Checking endpoint 1 channels
2021-07-21 13:57:47.378 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Checking endpoint 4 channels
2021-07-21 13:57:47.385 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Dynamically created 3 channels
2021-07-21 13:57:47.387 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Updating thing definition as channels have changed from [] to [zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_meteringinstantdemand, zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_meteringsumdelivered, zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch]
2021-07-21 13:57:47.393 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Initializing device
2021-07-21 13:57:47.395 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Initializing channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_meteringinstantdemand with org.openhab.binding.zigbee.internal.converter.ZigBeeConverterMeteringInstantaneousDemand@ebcb8
2021-07-21 13:57:47.396 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: Initialising electrical measurement cluster
2021-07-21 13:57:47.639 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Initializing channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_meteringsumdelivered with org.openhab.binding.zigbee.internal.converter.ZigBeeConverterMeteringSummationDelivered@c0db63
2021-07-21 13:57:47.641 [DEBUG] [eConverterMeteringSummationDelivered] - 00124B00073081BD: Initialising electrical measurement cluster
2021-07-21 13:57:47.767 [ERROR] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Exception creating channels 
java.lang.ClassCastException: class java.lang.Integer cannot be cast to class java.lang.Long (java.lang.Integer and java.lang.Long are in module java.base of loader 'bootstrap')
	at com.zsmartsystems.zigbee.serialization.DefaultSerializer.appendZigBeeType(DefaultSerializer.java:209) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.zcl.field.AttributeReportingConfigurationRecord.serialize(AttributeReportingConfigurationRecord.java:361) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.zcl.ZclFieldSerializer.serialize(ZclFieldSerializer.java:38) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.zcl.clusters.general.ConfigureReportingCommand.serialize(ConfigureReportingCommand.java:107) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.ZigBeeNetworkManager.sendCommand(ZigBeeNetworkManager.java:905) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager.send(ZigBeeTransactionManager.java:443) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager.sendNextTransaction(ZigBeeTransactionManager.java:681) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager.queueTransaction(ZigBeeTransactionManager.java:372) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager.sendTransaction(ZigBeeTransactionManager.java:351) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.ZigBeeNetworkManager.sendTransaction(ZigBeeNetworkManager.java:2032) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.ZigBeeNode.sendTransaction(ZigBeeNode.java:926) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.ZigBeeEndpoint.sendTransaction(ZigBeeEndpoint.java:596) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.zcl.ZclCluster.sendCommand(ZclCluster.java:294) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.zcl.ZclCluster.sendCommand(ZclCluster.java:305) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.zcl.ZclCluster.setReporting(ZclCluster.java:1767) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.zcl.ZclCluster.setReporting(ZclCluster.java:589) ~[bundleFile:?]
	at com.zsmartsystems.zigbee.zcl.ZclAttribute.setReporting(ZclAttribute.java:431) ~[bundleFile:?]
	at org.openhab.binding.zigbee.internal.converter.ZigBeeConverterMeteringSummationDelivered.initializeDevice(ZigBeeConverterMeteringSummationDelivered.java:81) ~[bundleFile:?]
	at org.openhab.binding.zigbee.handler.ZigBeeThingHandler.initializeDevice(ZigBeeThingHandler.java:514) ~[bundleFile:?]
	at org.openhab.binding.zigbee.handler.ZigBeeThingHandler.doNodeInitialisation(ZigBeeThingHandler.java:377) [bundleFile:?]
	at org.openhab.binding.zigbee.handler.ZigBeeThingHandler$1.call(ZigBeeThingHandler.java:227) [bundleFile:?]
	at org.openhab.binding.zigbee.handler.ZigBeeThingHandler$1.call(ZigBeeThingHandler.java:1) [bundleFile:?]
	at java.util.concurrent.FutureTask.run(FutureTask.java:264) [?:?]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:304) [?:?]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [?:?]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [?:?]
	at java.lang.Thread.run(Thread.java:829) [?:?]
2021-07-21 13:58:43.098 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Handler dispose.
2021-07-21 13:58:43.099 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker removed for thingUID=zigbee:device:06001B20:00124b00073081bd
2021-07-21 13:58:43.114 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=SHUTDOWN
2021-07-21 13:58:43.284 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 00124B00073081BD: ZigBee saving network state complete.
2021-07-21 13:58:43.293 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 000D6F0003E38764: ZigBee saving network state complete.
2021-07-21 13:58:43.341 [DEBUG] [nding.zigbee.serial.ZigBeeSerialPort] - Serial port '/dev/ttyUSB0' closed.
2021-07-21 13:58:43.348 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - ZigBee network [zigbee:coordinator_telegesis:06001B20] closed.
2021-07-21 13:58:43.356 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.1.0 (290)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(319)] : dm ZigBeeCoordinatorHandler tracking 4 MultipleDynamic removed {org.openhab.binding.zigbee.handler.ZigBeeCoordinatorHandler}={service.id=532, service.bundleid=297, service.scope=singleton} (enter)
2021-07-21 13:58:43.358 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.1.0 (290)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(319)] : getting unbind: removeZigBeeCoordinatorHandler
2021-07-21 13:58:43.360 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.1.0 (290)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(319)] : Locating method removeZigBeeCoordinatorHandler in class org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService
2021-07-21 13:58:43.361 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.1.0 (290)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(319)] : doFindMethod: Looking for method org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService.removeZigBeeCoordinatorHandler
2021-07-21 13:58:43.363 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.1.0 (290)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(319)] : Declared Method org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService.removeZigBeeCoordinatorHandler([interface org.osgi.framework.ServiceReference]) not found
2021-07-21 13:58:43.365 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.1.0 (290)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(319)] : Declared Method org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService.removeZigBeeCoordinatorHandler([interface org.osgi.service.component.ComponentServiceObjects]) not found
2021-07-21 13:58:43.366 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.1.0 (290)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(319)] : getReferenceClass: Looking for interface class org.openhab.binding.zigbee.handler.ZigBeeCoordinatorHandler through loader of org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService
2021-07-21 13:58:43.367 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.1.0 (290)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(319)] : getParameterClass: Found class org.openhab.binding.zigbee.handler.ZigBeeCoordinatorHandler
2021-07-21 13:58:43.368 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.1.0 (290)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(319)] : doFindMethod: No method taking ServiceReference found, checking method taking org.openhab.binding.zigbee.handler.ZigBeeCoordinatorHandler
2021-07-21 13:58:43.369 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.1.0 (290)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(319)] : doFindMethod: Found Method protected void org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService.removeZigBeeCoordinatorHandler(org.openhab.binding.zigbee.handler.ZigBeeCoordinatorHandler)
2021-07-21 13:58:43.370 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.1.0 (290)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(319)] : Found unbind method: protected void org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService.removeZigBeeCoordinatorHandler(org.openhab.binding.zigbee.handler.ZigBeeCoordinatorHandler)
2021-07-21 13:58:43.371 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.1.0 (290)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(319)] : invoking unbind: removeZigBeeCoordinatorHandler: parameters [org.openhab.binding.zigbee.telegesis.handler.TelegesisHandler]
2021-07-21 13:58:43.373 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.1.0 (290)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(319)] : invoked unbind: removeZigBeeCoordinatorHandler
2021-07-21 13:58:43.374 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.1.0 (290)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(319)] : dm ZigBeeCoordinatorHandler tracking 4 MultipleDynamic removed (unbind) {org.openhab.binding.zigbee.handler.ZigBeeCoordinatorHandler}={service.id=532, service.bundleid=297, service.scope=singleton}
2021-07-21 13:58:50.959 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.1.0 (290)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(319)] : dm ZigBeeCoordinatorHandler tracking 5 MultipleDynamic added {org.openhab.binding.zigbee.handler.ZigBeeCoordinatorHandler}={service.id=537, service.bundleid=297, service.scope=singleton} (enter)
2021-07-21 13:58:50.962 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.1.0 (290)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(319)] : dm ZigBeeCoordinatorHandler tracking 5 MultipleDynamic already active, binding {org.openhab.binding.zigbee.handler.ZigBeeCoordinatorHandler}={service.id=537, service.bundleid=297, service.scope=singleton}
2021-07-21 13:58:50.964 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.1.0 (290)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(319)] : invoking bind: addZigBeeCoordinatorHandler: parameters [org.openhab.binding.zigbee.telegesis.handler.TelegesisHandler]
2021-07-21 13:58:50.965 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.1.0 (290)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(319)] : invoked bind: addZigBeeCoordinatorHandler
2021-07-21 13:58:50.967 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.1.0 (290)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(319)] : dm ZigBeeCoordinatorHandler tracking 5 MultipleDynamic added {org.openhab.binding.zigbee.handler.ZigBeeCoordinatorHandler}={service.id=537, service.bundleid=297, service.scope=singleton} (exit)
2021-07-21 13:58:51.031 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Initializing ZigBee network [zigbee:coordinator_telegesis:06001B20].
2021-07-21 13:58:51.032 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Channel 11
2021-07-21 13:58:51.033 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - PANID 34867
2021-07-21 13:58:51.034 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - EPANID F2B2B3CF1EECC9B5
2021-07-21 13:58:51.036 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Network Key 5971005F8D4B23CB5F1F1316E2486820
2021-07-21 13:58:51.037 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Link Key 5A6967426565416C6C69616E63653039
2021-07-21 13:58:51.038 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Config: zigbee_initialise found, initializeNetwork=false
2021-07-21 13:58:51.039 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Network Key String 5971005F8D4B23CB5F1F1316E2486820
2021-07-21 13:58:51.041 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Network key final array 5971005F8D4B23CB5F1F1316E2486820
2021-07-21 13:58:51.042 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Link Key String 5A6967426565416C6C69616E63653039
2021-07-21 13:58:51.044 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Link key final array 5A6967426565416C6C69616E63653039
2021-07-21 13:58:51.045 [DEBUG] [e.telegesis.handler.TelegesisHandler] - Initializing ZigBee Telegesis serial bridge handler.
2021-07-21 13:58:51.047 [DEBUG] [e.telegesis.handler.TelegesisHandler] - ZigBee Telegesis Coordinator opening Port:'/dev/ttyUSB0' PAN:8833, EPAN:F2B2B3CF1EECC9B5, Channel:11
2021-07-21 13:58:51.049 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Scheduling ZigBee start
2021-07-21 13:58:51.067 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Initializing ZigBee thing handler zigbee:device:06001B20:00124b00073081bd
2021-07-21 13:58:51.069 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Coordinator status changed to UNKNOWN.
2021-07-21 13:58:51.070 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Coordinator is unknown or not online.
2021-07-21 13:58:52.050 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - ZigBee network starting
2021-07-21 13:58:52.052 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Initialising ZigBee coordinator
2021-07-21 13:58:52.056 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=INITIALISING
2021-07-21 13:58:52.360 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 00124B00073081BD: ZigBee reading network state complete.
2021-07-21 13:58:52.387 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 000D6F0003E38764: ZigBee reading network state complete.
2021-07-21 13:58:52.388 [DEBUG] [nding.zigbee.serial.ZigBeeSerialPort] - Connecting to serial port [/dev/ttyUSB0] at 19200 baud, flow control FLOWCONTROL_OUT_NONE.
2021-07-21 13:58:52.437 [DEBUG] [nding.zigbee.serial.ZigBeeSerialPort] - Serial port [/dev/ttyUSB0] is initialized.
2021-07-21 13:58:52.987 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Mesh Update Period 86400
2021-07-21 13:58:53.005 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - ZigBee Initialise: Previous device configuration was: channel=null, PanID=0, EPanId=null
2021-07-21 13:58:53.006 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Config: zigbee_trustcentremode=TC_JOIN_SECURE
2021-07-21 13:58:53.167 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - ZigBee initialise done. channel=CHANNEL_11, PanId=34867  EPanId=F2B2B3CF1EECC9B5
2021-07-21 13:58:53.183 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=ONLINE
2021-07-21 13:58:53.189 [INFO ] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Starting ZigBee device discovery
2021-07-21 13:58:53.190 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Creating ZigBee device zigbee:device with bridge zigbee:coordinator_telegesis:06001B20
2021-07-21 13:58:53.193 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: ZigBee node property discovery start
2021-07-21 13:58:53.194 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: ZigBee node property discovery using basic cluster on endpoint 6F87/1
2021-07-21 13:58:53.195 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Coordinator status changed to ONLINE.
2021-07-21 13:58:53.197 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Coordinator is ONLINE. Starting device initialisation.
2021-07-21 13:58:53.213 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Start initialising ZigBee Thing handler
2021-07-21 13:58:53.214 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: ZigBee node property discovery start
2021-07-21 13:58:53.216 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: ZigBee node property discovery using basic cluster on endpoint 6F87/1
2021-07-21 13:58:53.626 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 00124B00073081BD: ZigBee saving network state complete.
2021-07-21 13:58:53.643 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 000D6F0003E38764: ZigBee saving network state complete.
2021-07-21 13:58:59.712 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Node updated - ZigBeeNode [state=ONLINE, IEEE=00124B00073081BD, NWK=6F87, Type=ROUTER, endpoints=[1, 4]]
2021-07-21 13:58:59.722 [INFO ] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Starting ZigBee device discovery
2021-07-21 13:58:59.723 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Creating ZigBee device zigbee:device with bridge zigbee:coordinator_telegesis:06001B20
2021-07-21 13:58:59.725 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: ZigBee node property discovery start
2021-07-21 13:58:59.726 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: ZigBee node property discovery using basic cluster on endpoint 6F87/1
2021-07-21 13:59:00.151 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 00124B00073081BD: ZigBee saving network state complete.
2021-07-21 13:59:00.246 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: Stack version failed
2021-07-21 13:59:00.248 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: ZigBee node property discovery using OTA cluster on endpoint 6F87/4
2021-07-21 13:59:00.249 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: ZigBee node property discovery complete: {zigbee_logicaltype=ROUTER, zigbee_powerlevel=FULL, zigbee_manufacturercode=0x0000, modelId=902010/25, zigbee_networkaddress=28551, zigbee_powersource=MAINS, zigbee_datecode=20150629, zigbee_zclversion=1, vendor=Bitron Home, zigbee_powermode=RECEIVER_ON_IDLE, zigbee_powersources=[MAINS], hardwareVersion=0, firmwareVersion=0x0000000F, zigbee_applicationVersion=15}
2021-07-21 13:59:00.251 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Checking endpoint 1 channels
2021-07-21 13:59:00.642 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: Stack version failed
2021-07-21 13:59:00.643 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: ZigBee node property discovery using OTA cluster on endpoint 6F87/4
2021-07-21 13:59:00.645 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: ZigBee node property discovery complete: {zigbee_logicaltype=ROUTER, zigbee_powerlevel=FULL, zigbee_manufacturercode=0x0000, modelId=902010/25, zigbee_networkaddress=28551, zigbee_powersource=MAINS, zigbee_datecode=20150629, zigbee_zclversion=1, vendor=Bitron Home, zigbee_powermode=RECEIVER_ON_IDLE, zigbee_powersources=[MAINS], hardwareVersion=0, firmwareVersion=0x0000000F, zigbee_applicationVersion=15, zigbee_device_initialised=false}
2021-07-21 13:59:00.647 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Checking endpoint 1 channels
2021-07-21 13:59:00.769 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Initializing channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_meteringinstantdemand with org.openhab.binding.zigbee.internal.converter.ZigBeeConverterMeteringInstantaneousDemand@639857
2021-07-21 13:59:00.772 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: Initialising electrical measurement cluster
2021-07-21 13:59:00.992 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: Stack version failed
2021-07-21 13:59:00.994 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: ZigBee node property discovery using OTA cluster on endpoint 6F87/4
2021-07-21 13:59:00.996 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B00073081BD: ZigBee node property discovery complete: {zigbee_logicaltype=ROUTER, zigbee_powerlevel=FULL, zigbee_manufacturercode=0x0000, modelId=902010/25, zigbee_networkaddress=28551, zigbee_powersource=MAINS, zigbee_datecode=20150629, zigbee_zclversion=1, vendor=Bitron Home, zigbee_powermode=RECEIVER_ON_IDLE, zigbee_powersources=[MAINS], hardwareVersion=0, firmwareVersion=0x0000000F, zigbee_applicationVersion=15}
2021-07-21 13:59:00.998 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Checking endpoint 1 channels
2021-07-21 13:59:01.115 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Checking endpoint 4 channels
2021-07-21 13:59:01.122 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Dynamically created 3 channels
2021-07-21 13:59:01.124 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Initializing device
2021-07-21 13:59:01.126 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Initializing channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_meteringinstantdemand with org.openhab.binding.zigbee.internal.converter.ZigBeeConverterMeteringInstantaneousDemand@1ae6909
2021-07-21 13:59:01.127 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: Initialising electrical measurement cluster
2021-07-21 13:59:01.361 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Initializing channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_meteringinstantdemand with org.openhab.binding.zigbee.internal.converter.ZigBeeConverterMeteringInstantaneousDemand@1118d09
2021-07-21 13:59:01.362 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: Initialising electrical measurement cluster
2021-07-21 13:59:01.597 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Initializing channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_meteringsumdelivered with org.openhab.binding.zigbee.internal.converter.ZigBeeConverterMeteringSummationDelivered@16113bf
2021-07-21 13:59:01.599 [DEBUG] [eConverterMeteringSummationDelivered] - 00124B00073081BD: Initialising electrical measurement cluster
2021-07-21 13:59:01.841 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Initializing channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_meteringsumdelivered with org.openhab.binding.zigbee.internal.converter.ZigBeeConverterMeteringSummationDelivered@746950
2021-07-21 13:59:01.843 [DEBUG] [eConverterMeteringSummationDelivered] - 00124B00073081BD: Initialising electrical measurement cluster
2021-07-21 13:59:02.080 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Initializing channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_meteringsumdelivered with org.openhab.binding.zigbee.internal.converter.ZigBeeConverterMeteringSummationDelivered@13098f
2021-07-21 13:59:02.082 [DEBUG] [eConverterMeteringSummationDelivered] - 00124B00073081BD: Initialising electrical measurement cluster
2021-07-21 13:59:02.199 [WARN ] [zsmartsystems.zigbee.ZigBeeExecutors] - Uncaught exception in thread NotificationService-thread-3
java.lang.ClassCastException: class java.lang.Integer cannot be cast to class java.lang.Long (java.lang.Integer and java.lang.Long are in module java.base of loader 'bootstrap')
	at com.zsmartsystems.zigbee.serialization.DefaultSerializer.appendZigBeeType(DefaultSerializer.java:209) ~[?:?]
	at com.zsmartsystems.zigbee.zcl.field.AttributeReportingConfigurationRecord.serialize(AttributeReportingConfigurationRecord.java:361) ~[?:?]
	at com.zsmartsystems.zigbee.zcl.ZclFieldSerializer.serialize(ZclFieldSerializer.java:38) ~[?:?]
	at com.zsmartsystems.zigbee.zcl.clusters.general.ConfigureReportingCommand.serialize(ConfigureReportingCommand.java:107) ~[?:?]
	at com.zsmartsystems.zigbee.ZigBeeNetworkManager.sendCommand(ZigBeeNetworkManager.java:905) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager.send(ZigBeeTransactionManager.java:443) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager.sendNextTransaction(ZigBeeTransactionManager.java:681) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager.transactionComplete(ZigBeeTransactionManager.java:540) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransaction.completeTransaction(ZigBeeTransaction.java:435) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransaction.commandReceived(ZigBeeTransaction.java:387) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager$2.run(ZigBeeTransactionManager.java:557) ~[?:?]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) ~[?:?]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) ~[?:?]
	at java.lang.Thread.run(Thread.java:829) [?:?]
2021-07-21 13:59:22.199 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Initializing channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch with org.openhab.binding.zigbee.internal.converter.ZigBeeConverterSwitchOnoff@1ad77f
2021-07-21 13:59:22.342 [WARN ] [zsmartsystems.zigbee.ZigBeeExecutors] - Uncaught exception in thread NotificationService-thread-11
java.lang.ClassCastException: class java.lang.Integer cannot be cast to class java.lang.Long (java.lang.Integer and java.lang.Long are in module java.base of loader 'bootstrap')
	at com.zsmartsystems.zigbee.serialization.DefaultSerializer.appendZigBeeType(DefaultSerializer.java:209) ~[?:?]
	at com.zsmartsystems.zigbee.zcl.field.AttributeReportingConfigurationRecord.serialize(AttributeReportingConfigurationRecord.java:361) ~[?:?]
	at com.zsmartsystems.zigbee.zcl.ZclFieldSerializer.serialize(ZclFieldSerializer.java:38) ~[?:?]
	at com.zsmartsystems.zigbee.zcl.clusters.general.ConfigureReportingCommand.serialize(ConfigureReportingCommand.java:107) ~[?:?]
	at com.zsmartsystems.zigbee.ZigBeeNetworkManager.sendCommand(ZigBeeNetworkManager.java:905) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager.send(ZigBeeTransactionManager.java:443) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager.sendNextTransaction(ZigBeeTransactionManager.java:681) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager.transactionComplete(ZigBeeTransactionManager.java:540) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransaction.completeTransaction(ZigBeeTransaction.java:435) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransaction.commandReceived(ZigBeeTransaction.java:387) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager$2.run(ZigBeeTransactionManager.java:557) ~[?:?]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) ~[?:?]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) ~[?:?]
	at java.lang.Thread.run(Thread.java:829) [?:?]
6

Have you enabled all debug as per the binding documentation? I don’t see any zigbee messages being received in this log and I need to see this to understand what is happening.

7

The Logging parameter “ALL” will be not accepted.

PART2

2021-07-21 13:59:42.343 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Initializing channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch with org.openhab.binding.zigbee.internal.converter.ZigBeeConverterSwitchOnoff@c2a5f6
2021-07-21 13:59:42.463 [WARN ] [zsmartsystems.zigbee.ZigBeeExecutors] - Uncaught exception in thread NotificationService-thread-12
java.lang.ClassCastException: class java.lang.Integer cannot be cast to class java.lang.Long (java.lang.Integer and java.lang.Long are in module java.base of loader 'bootstrap')
	at com.zsmartsystems.zigbee.serialization.DefaultSerializer.appendZigBeeType(DefaultSerializer.java:209) ~[?:?]
	at com.zsmartsystems.zigbee.zcl.field.AttributeReportingConfigurationRecord.serialize(AttributeReportingConfigurationRecord.java:361) ~[?:?]
	at com.zsmartsystems.zigbee.zcl.ZclFieldSerializer.serialize(ZclFieldSerializer.java:38) ~[?:?]
	at com.zsmartsystems.zigbee.zcl.clusters.general.ConfigureReportingCommand.serialize(ConfigureReportingCommand.java:107) ~[?:?]
	at com.zsmartsystems.zigbee.ZigBeeNetworkManager.sendCommand(ZigBeeNetworkManager.java:905) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager.send(ZigBeeTransactionManager.java:443) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager.sendNextTransaction(ZigBeeTransactionManager.java:681) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager.transactionComplete(ZigBeeTransactionManager.java:540) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransaction.completeTransaction(ZigBeeTransaction.java:435) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransaction.commandReceived(ZigBeeTransaction.java:387) ~[?:?]
	at com.zsmartsystems.zigbee.transaction.ZigBeeTransactionManager$2.run(ZigBeeTransactionManager.java:557) ~[?:?]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) ~[?:?]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) ~[?:?]
	at java.lang.Thread.run(Thread.java:829) [?:?]
2021-07-21 14:00:02.467 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Initializing channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch with org.openhab.binding.zigbee.internal.converter.ZigBeeConverterSwitchOnoff@e9d723
2021-07-21 14:00:02.711 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Checking endpoint 4 channels
2021-07-21 14:00:02.719 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Update ZigBee device zigbee:device with bridge zigbee:coordinator_telegesis:06001B20, label 'Bitron Home 902010/25'
2021-07-21 14:00:03.057 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Checking endpoint 4 channels
2021-07-21 14:00:03.061 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - 00124B00073081BD: Update ZigBee device zigbee:device with bridge zigbee:coordinator_telegesis:06001B20, label 'Bitron Home 902010/25'
2021-07-21 14:00:03.176 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 00124B00073081BD: ZigBee saving network state complete.
2021-07-21 14:00:03.291 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=769, name=Multiplier, dataType=UNSIGNED_24_BIT_INTEGER, lastValue=1, lastReportTime=Wed Jul 21 14:00:03 CEST 2021, implemented=true]
2021-07-21 14:00:03.399 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=1024, name=Instantaneous Demand, dataType=SIGNED_24_BIT_INTEGER, lastValue=0, lastReportTime=Wed Jul 21 14:00:03 CEST 2021, implemented=true]
2021-07-21 14:00:03.484 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 00124B00073081BD: ZigBee saving network state complete.
2021-07-21 14:00:03.516 [DEBUG] [eConverterMeteringSummationDelivered] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=0, name=Current Summation Delivered, dataType=UNSIGNED_48_BIT_INTEGER, lastValue=0, lastReportTime=Wed Jul 21 14:00:03 CEST 2021, implemented=true]
2021-07-21 14:00:03.518 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=0, name=Current Summation Delivered, dataType=UNSIGNED_48_BIT_INTEGER, lastValue=0, lastReportTime=Wed Jul 21 14:00:03 CEST 2021, implemented=true]
2021-07-21 14:00:03.758 [DEBUG] [converter.ZigBeeConverterSwitchOnoff] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=On/Off, id=0, name=On Off, dataType=BOOLEAN, lastValue=false, lastReportTime=Wed Jul 21 14:00:03 CEST 2021, implemented=true]
2021-07-21 14:00:03.760 [DEBUG] [converter.ZigBeeBaseChannelConverter] - 00124B00073081BD: Channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch updated to OFF
2021-07-21 14:00:03.762 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Updating ZigBee channel state zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch to OFF
2021-07-21 14:00:03.873 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Channel initialisation complete
2021-07-21 14:00:03.875 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Setting ONLINE/OFFLINE timeout interval to: 1830
2021-07-21 14:00:03.877 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker added for thingUID=zigbee:device:06001B20:00124b00073081bd
2021-07-21 14:00:03.878 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker reset for handler with thingUID=zigbee:device:06001B20:00124b00073081bd
2021-07-21 14:00:03.880 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker scheduled task for thingUID=zigbee:device:06001B20:00124b00073081bd in 1830 seconds
2021-07-21 14:00:04.028 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Polling initialised at 978813ms
2021-07-21 14:00:04.031 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Done initialising ZigBee Thing handler
2021-07-21 14:00:04.034 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker reset for handler with thingUID=zigbee:device:06001B20:00124b00073081bd
2021-07-21 14:00:04.036 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker cancelled task for thingUID=zigbee:device:06001B20:00124b00073081bd
2021-07-21 14:00:04.037 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker scheduled task for thingUID=zigbee:device:06001B20:00124b00073081bd in 1830 seconds
2021-07-21 14:00:04.465 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 00124B00073081BD: ZigBee saving network state complete.
2021-07-21 14:02:18.645 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch linked - polling started.
2021-07-21 14:02:18.764 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Node updated - ZigBeeNode [state=ONLINE, IEEE=00124B00073081BD, NWK=6F87, Type=ROUTER, endpoints=[1, 4]]
2021-07-21 14:02:18.766 [DEBUG] [converter.ZigBeeConverterSwitchOnoff] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=On/Off, id=0, name=On Off, dataType=BOOLEAN, lastValue=false, lastReportTime=Wed Jul 21 14:02:18 CEST 2021, implemented=true]
2021-07-21 14:02:18.769 [DEBUG] [converter.ZigBeeBaseChannelConverter] - 00124B00073081BD: Channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch updated to OFF
2021-07-21 14:02:18.771 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Updating ZigBee channel state zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch to OFF
2021-07-21 14:02:18.776 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker reset for handler with thingUID=zigbee:device:06001B20:00124b00073081bd
2021-07-21 14:02:18.780 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker cancelled task for thingUID=zigbee:device:06001B20:00124b00073081bd
2021-07-21 14:02:18.781 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker scheduled task for thingUID=zigbee:device:06001B20:00124b00073081bd in 1830 seconds
2021-07-21 14:02:19.218 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 00124B00073081BD: ZigBee saving network state complete.
2021-07-21 14:02:25.693 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Command for channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch --> ON [OnOffType]
2021-07-21 14:02:25.697 [DEBUG] [converter.ZigBeeBaseChannelConverter] - 00124B00073081BD: Channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch waiting for response to ON
2021-07-21 14:02:25.860 [DEBUG] [converter.ZigBeeConverterSwitchOnoff] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=On/Off, id=0, name=On Off, dataType=BOOLEAN, lastValue=true, lastReportTime=Wed Jul 21 14:02:25 CEST 2021, implemented=true]
2021-07-21 14:02:25.862 [DEBUG] [converter.ZigBeeBaseChannelConverter] - 00124B00073081BD: Channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch updated to ON
2021-07-21 14:02:25.864 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Updating ZigBee channel state zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch to ON
2021-07-21 14:02:25.868 [DEBUG] [converter.ZigBeeBaseChannelConverter] - 00124B00073081BD: Channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch received SUCCESS in response to ON
2021-07-21 14:02:25.872 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker reset for handler with thingUID=zigbee:device:06001B20:00124b00073081bd
2021-07-21 14:02:25.873 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker cancelled task for thingUID=zigbee:device:06001B20:00124b00073081bd
2021-07-21 14:02:25.876 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker scheduled task for thingUID=zigbee:device:06001B20:00124b00073081bd in 1830 seconds
2021-07-21 14:02:30.167 [DEBUG] [eConverterMeteringSummationDelivered] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=1024, name=Instantaneous Demand, dataType=SIGNED_24_BIT_INTEGER, lastValue=4, lastReportTime=Wed Jul 21 14:02:30 CEST 2021, implemented=true]
2021-07-21 14:02:30.167 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=1024, name=Instantaneous Demand, dataType=SIGNED_24_BIT_INTEGER, lastValue=4, lastReportTime=Wed Jul 21 14:02:30 CEST 2021, implemented=true]
2021-07-21 14:02:30.168 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=0, name=Current Summation Delivered, dataType=UNSIGNED_48_BIT_INTEGER, lastValue=93000, lastReportTime=Wed Jul 21 14:02:30 CEST 2021, implemented=true]
2021-07-21 14:02:30.171 [DEBUG] [eConverterMeteringSummationDelivered] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=0, name=Current Summation Delivered, dataType=UNSIGNED_48_BIT_INTEGER, lastValue=93000, lastReportTime=Wed Jul 21 14:02:30 CEST 2021, implemented=true]
2021-07-21 14:02:36.823 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Command for channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch --> OFF [OnOffType]
2021-07-21 14:02:36.825 [DEBUG] [converter.ZigBeeBaseChannelConverter] - 00124B00073081BD: Channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch waiting for response to OFF
2021-07-21 14:02:36.978 [DEBUG] [converter.ZigBeeConverterSwitchOnoff] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=On/Off, id=0, name=On Off, dataType=BOOLEAN, lastValue=false, lastReportTime=Wed Jul 21 14:02:36 CEST 2021, implemented=true]
2021-07-21 14:02:36.980 [DEBUG] [converter.ZigBeeBaseChannelConverter] - 00124B00073081BD: Channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch updated to OFF
2021-07-21 14:02:36.981 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Updating ZigBee channel state zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch to OFF
2021-07-21 14:02:36.985 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker reset for handler with thingUID=zigbee:device:06001B20:00124b00073081bd
2021-07-21 14:02:36.989 [DEBUG] [converter.ZigBeeBaseChannelConverter] - 00124B00073081BD: Channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch received SUCCESS in response to OFF
2021-07-21 14:02:36.989 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker cancelled task for thingUID=zigbee:device:06001B20:00124b00073081bd
2021-07-21 14:02:36.991 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker scheduled task for thingUID=zigbee:device:06001B20:00124b00073081bd in 1830 seconds
2021-07-21 14:02:37.853 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Command for channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch --> ON [OnOffType]
2021-07-21 14:02:37.855 [DEBUG] [converter.ZigBeeBaseChannelConverter] - 00124B00073081BD: Channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch waiting for response to ON
2021-07-21 14:02:38.009 [DEBUG] [converter.ZigBeeConverterSwitchOnoff] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=On/Off, id=0, name=On Off, dataType=BOOLEAN, lastValue=true, lastReportTime=Wed Jul 21 14:02:38 CEST 2021, implemented=true]
2021-07-21 14:02:38.011 [DEBUG] [converter.ZigBeeBaseChannelConverter] - 00124B00073081BD: Channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch updated to ON
2021-07-21 14:02:38.014 [DEBUG] [converter.ZigBeeBaseChannelConverter] - 00124B00073081BD: Channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch received SUCCESS in response to ON
2021-07-21 14:02:38.014 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Updating ZigBee channel state zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_switch to ON
2021-07-21 14:02:38.019 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker reset for handler with thingUID=zigbee:device:06001B20:00124b00073081bd
2021-07-21 14:02:38.020 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker cancelled task for thingUID=zigbee:device:06001B20:00124b00073081bd
2021-07-21 14:02:38.022 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker scheduled task for thingUID=zigbee:device:06001B20:00124b00073081bd in 1830 seconds
2021-07-21 14:02:40.165 [DEBUG] [eConverterMeteringSummationDelivered] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=1024, name=Instantaneous Demand, dataType=SIGNED_24_BIT_INTEGER, lastValue=2, lastReportTime=Wed Jul 21 14:02:40 CEST 2021, implemented=true]
2021-07-21 14:02:40.165 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=1024, name=Instantaneous Demand, dataType=SIGNED_24_BIT_INTEGER, lastValue=2, lastReportTime=Wed Jul 21 14:02:40 CEST 2021, implemented=true]
2021-07-21 14:02:40.168 [DEBUG] [eConverterMeteringSummationDelivered] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=0, name=Current Summation Delivered, dataType=UNSIGNED_48_BIT_INTEGER, lastValue=93000, lastReportTime=Wed Jul 21 14:02:40 CEST 2021, implemented=true]
2021-07-21 14:02:40.168 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=0, name=Current Summation Delivered, dataType=UNSIGNED_48_BIT_INTEGER, lastValue=93000, lastReportTime=Wed Jul 21 14:02:40 CEST 2021, implemented=true]
2021-07-21 14:03:00.164 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=0, name=Current Summation Delivered, dataType=UNSIGNED_48_BIT_INTEGER, lastValue=93000, lastReportTime=Wed Jul 21 14:03:00 CEST 2021, implemented=true]
2021-07-21 14:03:00.164 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=1024, name=Instantaneous Demand, dataType=SIGNED_24_BIT_INTEGER, lastValue=4, lastReportTime=Wed Jul 21 14:03:00 CEST 2021, implemented=true]
2021-07-21 14:03:00.164 [DEBUG] [eConverterMeteringSummationDelivered] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=0, name=Current Summation Delivered, dataType=UNSIGNED_48_BIT_INTEGER, lastValue=93000, lastReportTime=Wed Jul 21 14:03:00 CEST 2021, implemented=true]
2021-07-21 14:03:00.165 [DEBUG] [eConverterMeteringSummationDelivered] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=1024, name=Instantaneous Demand, dataType=SIGNED_24_BIT_INTEGER, lastValue=4, lastReportTime=Wed Jul 21 14:03:00 CEST 2021, implemented=true]
2021-07-21 14:03:10.166 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=0, name=Current Summation Delivered, dataType=UNSIGNED_48_BIT_INTEGER, lastValue=93000, lastReportTime=Wed Jul 21 14:03:10 CEST 2021, implemented=true]
2021-07-21 14:03:10.166 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=1024, name=Instantaneous Demand, dataType=SIGNED_24_BIT_INTEGER, lastValue=3, lastReportTime=Wed Jul 21 14:03:10 CEST 2021, implemented=true]
2021-07-21 14:03:10.166 [DEBUG] [eConverterMeteringSummationDelivered] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=0, name=Current Summation Delivered, dataType=UNSIGNED_48_BIT_INTEGER, lastValue=93000, lastReportTime=Wed Jul 21 14:03:10 CEST 2021, implemented=true]
2021-07-21 14:03:10.167 [DEBUG] [eConverterMeteringSummationDelivered] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=1024, name=Instantaneous Demand, dataType=SIGNED_24_BIT_INTEGER, lastValue=3, lastReportTime=Wed Jul 21 14:03:10 CEST 2021, implemented=true]
2021-07-21 14:03:30.110 [DEBUG] [eConverterMeteringSummationDelivered] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=0, name=Current Summation Delivered, dataType=UNSIGNED_48_BIT_INTEGER, lastValue=93000, lastReportTime=Wed Jul 21 14:03:30 CEST 2021, implemented=true]
2021-07-21 14:03:30.110 [DEBUG] [eConverterMeteringSummationDelivered] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=1024, name=Instantaneous Demand, dataType=SIGNED_24_BIT_INTEGER, lastValue=9, lastReportTime=Wed Jul 21 14:03:30 CEST 2021, implemented=true]
2021-07-21 14:03:30.110 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=0, name=Current Summation Delivered, dataType=UNSIGNED_48_BIT_INTEGER, lastValue=93000, lastReportTime=Wed Jul 21 14:03:30 CEST 2021, implemented=true]
2021-07-21 14:03:30.110 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=1024, name=Instantaneous Demand, dataType=SIGNED_24_BIT_INTEGER, lastValue=9, lastReportTime=Wed Jul 21 14:03:30 CEST 2021, implemented=true]
2021-07-21 14:03:40.111 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=1024, name=Instantaneous Demand, dataType=SIGNED_24_BIT_INTEGER, lastValue=8, lastReportTime=Wed Jul 21 14:03:40 CEST 2021, implemented=true]
2021-07-21 14:03:40.111 [DEBUG] [eConverterMeteringSummationDelivered] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=1024, name=Instantaneous Demand, dataType=SIGNED_24_BIT_INTEGER, lastValue=8, lastReportTime=Wed Jul 21 14:03:40 CEST 2021, implemented=true]
2021-07-21 14:03:40.111 [DEBUG] [eConverterMeteringSummationDelivered] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=0, name=Current Summation Delivered, dataType=UNSIGNED_48_BIT_INTEGER, lastValue=93000, lastReportTime=Wed Jul 21 14:03:40 CEST 2021, implemented=true]
2021-07-21 14:03:40.111 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=0, name=Current Summation Delivered, dataType=UNSIGNED_48_BIT_INTEGER, lastValue=93000, lastReportTime=Wed Jul 21 14:03:40 CEST 2021, implemented=true]
2021-07-21 14:04:25.405 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_meteringsumdelivered linked - polling started.
2021-07-21 14:04:25.525 [DEBUG] [eConverterMeteringSummationDelivered] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=0, name=Current Summation Delivered, dataType=UNSIGNED_48_BIT_INTEGER, lastValue=93000, lastReportTime=Wed Jul 21 14:04:25 CEST 2021, implemented=true]
2021-07-21 14:04:25.525 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=0, name=Current Summation Delivered, dataType=UNSIGNED_48_BIT_INTEGER, lastValue=93000, lastReportTime=Wed Jul 21 14:04:25 CEST 2021, implemented=true]
2021-07-21 14:04:40.015 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B00073081BD: Channel zigbee:device:06001B20:00124b00073081bd:00124B00073081BD_1_meteringinstantdemand linked - polling started.
2021-07-21 14:04:40.225 [DEBUG] [eConverterMeteringSummationDelivered] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=1024, name=Instantaneous Demand, dataType=SIGNED_24_BIT_INTEGER, lastValue=6, lastReportTime=Wed Jul 21 14:04:40 CEST 2021, implemented=true]
2021-07-21 14:04:40.225 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=0, name=Current Summation Delivered, dataType=UNSIGNED_48_BIT_INTEGER, lastValue=93000, lastReportTime=Wed Jul 21 14:04:40 CEST 2021, implemented=true]
2021-07-21 14:04:40.225 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=1024, name=Instantaneous Demand, dataType=SIGNED_24_BIT_INTEGER, lastValue=6, lastReportTime=Wed Jul 21 14:04:40 CEST 2021, implemented=true]
2021-07-21 14:04:40.226 [DEBUG] [eConverterMeteringSummationDelivered] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=0, name=Current Summation Delivered, dataType=UNSIGNED_48_BIT_INTEGER, lastValue=93000, lastReportTime=Wed Jul 21 14:04:40 CEST 2021, implemented=true]
2021-07-21 14:04:40.234 [DEBUG] [eConverterMeteringSummationDelivered] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=1024, name=Instantaneous Demand, dataType=SIGNED_24_BIT_INTEGER, lastValue=6, lastReportTime=Wed Jul 21 14:04:40 CEST 2021, implemented=true]
2021-07-21 14:04:40.234 [DEBUG] [ConverterMeteringInstantaneousDemand] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=1024, name=Instantaneous Demand, dataType=SIGNED_24_BIT_INTEGER, lastValue=6, lastReportTime=Wed Jul 21 14:04:40 CEST 2021, implemented=true]
2021-07-21 14:04:50.168 [DEBUG] [eConverterMeteringSummationDelivered] - 00124B00073081BD: ZigBee attribute reports ZclAttribute [cluster=Metering, id=0, name=Current Summation Delivered, dataType=UNSIGNED_48_BIT_INTEGER, lastValue=93000, lastReportTime=Wed Jul 21 14:04:50 CEST 2021, implemented=true]
8

Now I have activate also the Trace function and found more

https://www.magentacloud.de/lnk/R2iVS393

9

It doesn’t look like the debug logging contains the information from the zigbee library - it only contains information from the binding itself which is not where the issue lies. I need to see the data that is received from the device to understand why the frame is not in the correct format as expected by the library.

You need to enable logging on com.zsmartsystems.zigbee - this should be part of the list in the documentation.

TRACE logging shouldn’t really be needed and will likely just make the files longer without adding more useful data.

10

Here the new Logging

https://www.magentacloud.de/lnk/R2iVS393

In my understanding the ZigBeeThingHandler should use for meteringinstand the “id=1024”
and for meteringsum the “id=0”

image
image1950×944 119 KB

image
image1775×990 160 KB

thx for help

11

ZigBee Bitron 902010/25 are integrated by Chris Jackson.

Thx a lot for this job.

The ZigBee Binding is running on OH3.2 Build 2467 or later.

1 Like
12

select non_negative_difference(last(cumulative_sum)) from (select cumulative_sum(non_negative_difference(last(“value”)))