Not connecting: Zigbee Binding, CC2531 and AQARA Temp Humidity Sensor

coryprice26 · October 7, 2020, 3:10am

I flashed the 2531 with the CC2531ZNP-Pro-Secure_Standard.hex. I was able to add it as a Thing and select the appropriate serial port. It is showing online.

I am trying to get the Aqara temp/humidity sensor to connect now. I have pressed the button about every 5 seconds and see the blue light flashing. I do see some traffic in the debug. I see a Unhandled ZToolPacket type 0x45cb.

Does anyone see anything that stands out as a potential problem? Let me know if I need to get more information.

==> /var/log/openhab2/openhab.log <==
2020-10-06 21:45:45.332 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: ManagementPermitJoiningResponse [0/0 -> 0/0, cluster=8036, TID=NULL, status=SUCCESS]
2020-10-06 21:45:47.171 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 0C 45 CA D8 25 06 DF 40 05 00 8D 15 00 00 00 7A)
2020-10-06 21:45:47.171 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=12, apiId=45 CA, data=FE 0C 45 CA D8 25 06 DF 40 05 00 8D 15 00 00 00 7A, checksum=7A, error=false
2020-10-06 21:45:47.172 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45ca
2020-10-06 21:45:50.988 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 0C 45 CA D8 25 06 DF 40 05 00 8D 15 00 00 00 7A)
2020-10-06 21:45:50.989 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=12, apiId=45 CA, data=FE 0C 45 CA D8 25 06 DF 40 05 00 8D 15 00 00 00 7A, checksum=7A, error=false
2020-10-06 21:45:50.989 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45ca
2020-10-06 21:46:45.319 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 01 45 CB 00 8F)
2020-10-06 21:46:45.320 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=1, apiId=45 CB, data=FE 01 45 CB 00 8F, checksum=8F, error=false
2020-10-06 21:46:45.320 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45cb



==> /var/log/openhab2/openhab.log <==
2020-10-06 21:48:55.646 [DEBUG] [com.zsmartsystems.zigbee.ZigBeeNode ] - 00124B001CCE233E: Routing table unchanged
2020-10-06 21:48:55.646 [DEBUG] [iscovery.ZigBeeNodeServiceDiscoverer] - 00124B001CCE233E: Node SVC Discovery: request ROUTES successful. Advanced to null.
2020-10-06 21:48:55.646 [DEBUG] [iscovery.ZigBeeNodeServiceDiscoverer] - 00124B001CCE233E: Node SVC Discovery: running
2020-10-06 21:48:55.646 [DEBUG] [iscovery.ZigBeeNodeServiceDiscoverer] - 00124B001CCE233E: Node SVC Discovery: complete
2020-10-06 21:48:55.646 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B001CCE233E: Node 0 update
2020-10-06 21:48:55.647 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction complete: ManagementRoutingRequest [0/0 -> 0/0, cluster=0032, TID=3A, startIndex=0]
2020-10-06 21:48:55.648 [DEBUG] [nal.ZigBeeNetworkStateSerializerImpl] - Saving ZigBee network state: Start.
2020-10-06 21:48:55.649 [DEBUG] [nal.ZigBeeNetworkStateSerializerImpl] - Saving ZigBee network state: Done.
2020-10-06 21:49:32.022 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - null: Handler dispose.
2020-10-06 21:49:32.028 [DEBUG] [org.openhab.binding.zigbee          ] - ServiceEvent UNREGISTERING - {org.eclipse.smarthome.core.thing.binding.firmware.FirmwareUpdateHandler}={service.id=451, service.bundleid=247, service.scope=singleton} - org.openhab.binding.zigbee

Another log, this time with the things scanning running:

==> /var/log/openhab2/openhab.log <==
2020-10-06 22:14:14.129 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: ManagementPermitJoiningResponse [0/0 -> 0/0, cluster=8036, TID=NULL, status=SUCCESS]
2020-10-06 22:14:27.243 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 0C 45 CA D8 25 06 DF 40 05 00 8D 15 00 00 00 7A)
2020-10-06 22:14:27.244 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=12, apiId=45 CA, data=FE 0C 45 CA D8 25 06 DF 40 05 00 8D 15 00 00 00 7A, checksum=7A, error=false
2020-10-06 22:14:27.244 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45ca
2020-10-06 22:14:30.912 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 0C 45 CA D8 25 06 DF 40 05 00 8D 15 00 00 00 7A)
2020-10-06 22:14:30.912 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=12, apiId=45 CA, data=FE 0C 45 CA D8 25 06 DF 40 05 00 8D 15 00 00 00 7A, checksum=7A, error=false
2020-10-06 22:14:30.913 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45ca
2020-10-06 22:15:14.113 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 01 45 CB 00 8F)
2020-10-06 22:15:14.114 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=1, apiId=45 CB, data=FE 01 45 CB 00 8F, checksum=8F, error=false
2020-10-06 22:15:14.114 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45cb
2020-10-06 22:15:20.523 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - Starting ZigBee scan for zigbee:coordinator_cc2531:16085035
2020-10-06 22:15:20.524 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Permit join to 65532/0 for 60 seconds.
2020-10-06 22:15:20.524 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ManagementPermitJoiningRequest [0/0 -> 65532/0, cluster=0036, TID=49, permitDuration=60, tcSignificance=true]
2020-10-06 22:15:20.524 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0/0, destinationAddress=65532/0, profile=0000, cluster=54, addressMode=DEVICE, radius=31, apsSecurity=false, apsCounter=73, payload=00 3C 01]
2020-10-06 22:15:20.525 [DEBUG] [31.network.impl.CommandInterfaceImpl] - ->  AF_DATA_REQUEST (Packet: subsystem=null, length=13, apiId=24 01, data=FE 0D 24 01 FC FF 00 00 36 00 49 30 1F 03 00 3C 01 45, checksum=45, error=false) 
2020-10-06 22:15:20.636 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-  AF_DATA_SRSP (FE 01 64 01 00 64)
2020-10-06 22:15:20.636 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ManagementPermitJoiningRequest [0/0 -> 0/0, cluster=0036, TID=4A, permitDuration=60, tcSignificance=true]
2020-10-06 22:15:20.637 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0/0, destinationAddress=0/0, profile=0000, cluster=54, addressMode=DEVICE, radius=31, apsSecurity=false, apsCounter=74, payload=00 3C 01]
2020-10-06 22:15:20.637 [DEBUG] [31.network.impl.CommandInterfaceImpl] - ->  AF_DATA_REQUEST (Packet: subsystem=null, length=13, apiId=24 01, data=FE 0D 24 01 00 00 00 00 36 00 4A 30 1F 03 00 3C 01 45, checksum=45, error=false) 
2020-10-06 22:15:20.757 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-  AF_DATA_SRSP (FE 01 64 01 00 64)
2020-10-06 22:15:20.757 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 01 45 CB 3C B3)
2020-10-06 22:15:20.757 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=1, apiId=45 CB, data=FE 01 45 CB 3C B3, checksum=B3, error=false
2020-10-06 22:15:20.757 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45cb
2020-10-06 22:15:20.757 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 03 45 B6 00 00 00 F0)
2020-10-06 22:15:20.757 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=3, apiId=45 B6, data=FE 03 45 B6 00 00 00 F0, checksum=F0, error=false
2020-10-06 22:15:20.757 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45b6
2020-10-06 22:15:20.757 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 0A 45 FF 00 00 00 36 80 00 00 00 00 00 06)
2020-10-06 22:15:20.757 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=10, apiId=45 FF, data=FE 0A 45 FF 00 00 00 36 80 00 00 00 00 00 06, checksum=06, error=false
2020-10-06 22:15:20.758 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=0/0, destinationAddress=0/0, profile=0000, cluster=32822, addressMode=null, radius=0, apsSecurity=false, apsCounter=0, payload=00 00]
2020-10-06 22:15:20.758 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: ManagementPermitJoiningResponse [0/0 -> 0/0, cluster=8036, TID=NULL, status=SUCCESS]
2020-10-06 22:15:32.056 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 0C 45 CA D8 25 06 DF 40 05 00 8D 15 00 00 00 7A)
2020-10-06 22:15:32.056 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=12, apiId=45 CA, data=FE 0C 45 CA D8 25 06 DF 40 05 00 8D 15 00 00 00 7A, checksum=7A, error=false
2020-10-06 22:15:32.056 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45ca
2020-10-06 22:15:35.832 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 0C 45 CA D8 25 06 DF 40 05 00 8D 15 00 00 00 7A)
2020-10-06 22:15:35.832 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=12, apiId=45 CA, data=FE 0C 45 CA D8 25 06 DF 40 05 00 8D 15 00 00 00 7A, checksum=7A, error=false
2020-10-06 22:15:35.832 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45ca
2020-10-06 22:15:49.775 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 0C 45 CA D8 25 06 DF 40 05 00 8D 15 00 00 00 7A)
2020-10-06 22:15:49.775 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=12, apiId=45 CA, data=FE 0C 45 CA D8 25 06 DF 40 05 00 8D 15 00 00 00 7A, checksum=7A, error=false
2020-10-06 22:15:49.776 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45ca
2020-10-06 22:16:00.479 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 0C 45 CA D8 25 06 DF 40 05 00 8D 15 00 00 00 7A)
2020-10-06 22:16:00.479 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=12, apiId=45 CA, data=FE 0C 45 CA D8 25 06 DF 40 05 00 8D 15 00 00 00 7A, checksum=7A, error=false
2020-10-06 22:16:00.479 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45ca
2020-10-06 22:16:04.211 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 0C 45 CA D8 25 06 DF 40 05 00 8D 15 00 00 00 7A)
2020-10-06 22:16:04.211 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=12, apiId=45 CA, data=FE 0C 45 CA D8 25 06 DF 40 05 00 8D 15 00 00 00 7A, checksum=7A, error=false
2020-10-06 22:16:04.212 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45ca
2020-10-06 22:16:19.545 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 0C 45 CA D8 25 06 DF 40 05 00 8D 15 00 00 00 7A)
2020-10-06 22:16:19.545 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=12, apiId=45 CA, data=FE 0C 45 CA D8 25 06 DF 40 05 00 8D 15 00 00 00 7A, checksum=7A, error=false
2020-10-06 22:16:19.546 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45ca
2020-10-06 22:16:20.745 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 01 45 CB 00 8F)
2020-10-06 22:16:20.745 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=1, apiId=45 CB, data=FE 01 45 CB 00 8F, checksum=8F, error=false
2020-10-06 22:16:20.745 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45cb
2020-10-06 22:16:24.265 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - Starting ZigBee scan for zigbee:coordinator_cc2531:16085035
2020-10-06 22:16:24.265 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Permit join to 65532/0 for 60 seconds.
2020-10-06 22:16:24.266 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ManagementPermitJoiningRequest [0/0 -> 65532/0, cluster=0036, TID=4B, permitDuration=60, tcSignificance=true]
2020-10-06 22:16:24.266 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0/0, destinationAddress=65532/0, profile=0000, cluster=54, addressMode=DEVICE, radius=31, apsSecurity=false, apsCounter=75, payload=00 3C 01]
2020-10-06 22:16:24.266 [DEBUG] [31.network.impl.CommandInterfaceImpl] - ->  AF_DATA_REQUEST (Packet: subsystem=null, length=13, apiId=24 01, data=FE 0D 24 01 FC FF 00 00 36 00 4B 30 1F 03 00 3C 01 47, checksum=47, error=false) 
2020-10-06 22:16:24.378 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-  AF_DATA_SRSP (FE 01 64 01 00 64)
2020-10-06 22:16:24.378 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ManagementPermitJoiningRequest [0/0 -> 0/0, cluster=0036, TID=4C, permitDuration=60, tcSignificance=true]
2020-10-06 22:16:24.378 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0/0, destinationAddress=0/0, profile=0000, cluster=54, addressMode=DEVICE, radius=31, apsSecurity=false, apsCounter=76, payload=00 3C 01]
2020-10-06 22:16:24.379 [DEBUG] [31.network.impl.CommandInterfaceImpl] - ->  AF_DATA_REQUEST (Packet: subsystem=null, length=13, apiId=24 01, data=FE 0D 24 01 00 00 00 00 36 00 4C 30 1F 03 00 3C 01 43, checksum=43, error=false) 
2020-10-06 22:16:24.498 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-  AF_DATA_SRSP (FE 01 64 01 00 64)
2020-10-06 22:16:24.498 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 01 45 CB 3C B3)
2020-10-06 22:16:24.499 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=1, apiId=45 CB, data=FE 01 45 CB 3C B3, checksum=B3, error=false
2020-10-06 22:16:24.499 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45cb
2020-10-06 22:16:24.499 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 03 45 B6 00 00 00 F0)
2020-10-06 22:16:24.499 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=3, apiId=45 B6, data=FE 03 45 B6 00 00 00 F0, checksum=F0, error=false
2020-10-06 22:16:24.499 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45b6
2020-10-06 22:16:24.499 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 0A 45 FF 00 00 00 36 80 00 00 00 00 00 06)
2020-10-06 22:16:24.499 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=10, apiId=45 FF, data=FE 0A 45 FF 00 00 00 36 80 00 00 00 00 00 06, checksum=06, error=false
2020-10-06 22:16:24.499 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=0/0, destinationAddress=0/0, profile=0000, cluster=32822, addressMode=null, radius=0, apsSecurity=false, apsCounter=0, payload=00 00]
2020-10-06 22:16:24.499 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: ManagementPermitJoiningResponse [0/0 -> 0/0, cluster=8036, TID=NULL, status=SUCCESS]

Bruce_Osborne · October 7, 2020, 5:46am

I have not used Zigbee but perhaps the log viewer can provide insight.

https://opensmarthouse.org/utilities/logviewer/zigbee/

Dave_K · October 7, 2020, 5:53am

You need to press and hold the button for about 5 seconds for the device to go in pairing mode. At least that’s what I had to do with mine. After that the device showed up in the inbox and I was able to add it.

Alhtough it did work that way for me I switched to using Zigbee2MQTT, because I like the way I can configure it more than with the zigbee binding.

Bruce_Osborne · October 7, 2020, 6:01am

I think Chris would be interested in what functionality is missing in the Zigbee binding. He is usually very responsive.

Dave_K · October 7, 2020, 6:46am

I’m not sure if anything is missing. The only thing I found was the “last seen” time, that I can add in Z2M. My “issue” was more, that I was not able to configure it through files and had to use PaperUI. I personally just prefer to do my configuration via files.

Edit: Maybe my sentence is missing a comma, so the meaning is different that what I wanted to say. I just like “the way I can configure z2m” better, not that it has more options or the binding has missing functionalities.

coryprice26 · October 7, 2020, 11:00pm

Yes. I hold it for more than 5 seconds, get 3 blinks, then 1 blink on release. I am repeating this over and over while searching.

coryprice26 · October 7, 2020, 11:07pm

This is neat. I tried this. It looks like my temp/humidity sensor is never reaching out to pair?

coryprice26 · October 13, 2020, 2:22am

Does anyone know the meaning of the Unhandled ZToolPacket type 0x45cb message? This seems to correlate to pressing the pair button on the Aqara sensor.

chris · October 13, 2020, 7:41am

If memory serves me it’s an unused ZDO message that the stack doesn’t need - I think it’s related to devices leaving the network, but the system uses different commands so that it’s more standard across ths different dongles.