So I’ve been using my HA Core system here fairly successfully with a Sonoff 3.0 Dongle Plus but I need more range to get to the bottom level. Picked up a Aeotec ZW189 from Amazon, plugged it in, pressed button, “Add Device” and…
Nothing. Did not add, see, or anything.
As a cross-check I brought up a fresh copy of 2024.4 on another Pi Blade, reset the radio completely, went to “Add device”, pressed the button, and gave it a try. Still no dice, but here are the messages.
Preformatted text
homeassistant@grumpy:~ $ 2024-04-28 21:19:28.191 INFO (MainThread) [zigpy_znp.zigbee.application] Permitting joins for 254 seconds
2024-04-28 21:19:28.195 DEBUG (MainThread) [zigpy_znp.zigbee.application] Sending packet ZigbeePacket(timestamp=datetime.datetime(2024, 4, 29, 1, 19, 28, 195526, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), src_ep=0, dst=AddrModeAddress(addr_mode=<AddrMode.Broadcast: 15>, address=<BroadcastAddress.ALL_ROUTERS_AND_COORDINATOR: 65532>), dst_ep=0, source_route=None, extended_timeout=False, tsn=2, profile_id=0, cluster_id=<ZDOCmd.Mgmt_Permit_Joining_req: 0x0036>, data=Serialized[b'\x02\xfe\x00'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=None, rssi=None)
2024-04-28 21:19:28.201 DEBUG (MainThread) [zigpy_znp.api] Sending request: ZDO.MgmtPermitJoinReq.Req(AddrMode=<AddrMode.Broadcast: 15>, Dst=0xFFFC, Duration=254, TCSignificance=0)
2024-04-28 21:19:28.226 DEBUG (MainThread) [zigpy_znp.api] Received command: ZDO.MgmtPermitJoinReq.Rsp(Status=<Status.SUCCESS: 0>)
2024-04-28 21:19:28.230 DEBUG (MainThread) [zigpy_znp.api] Received command: ZDO.MgmtPermitJoinRsp.Callback(Src=0x0000, Status=<Status.SUCCESS: 0>)
2024-04-28 21:19:28.233 DEBUG (MainThread) [zigpy_znp.api] Received command: ZDO.MsgCbIncoming.Callback(Src=0x0000, IsBroadcast=<Bool.false: 0>, ClusterId=32822, SecurityUse=0, TSN=3, MacDst=0x0000, Data=b'\x00')
2024-04-28 21:19:28.238 DEBUG (MainThread) [zigpy_znp.api] Sending request: AF.DataRequestExt.Req(DstAddrModeAddress=AddrModeAddress(mode=<AddrMode.Broadcast: 15>, address=0xFFFC), DstEndpoint=0, DstPanId=0x0000, SrcEndpoint=0, ClusterId=54, TSN=2, Options=<TransmitOptions.SUPPRESS_ROUTE_DISC_NETWORK: 32>, Radius=0, Data=b'\x02\xFE\x00')
2024-04-28 21:19:28.242 DEBUG (MainThread) [zigpy.application] Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 4, 29, 1, 19, 28, 242448, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), src_ep=0, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=0, source_route=None, extended_timeout=False, tsn=3, profile_id=0, cluster_id=32822, data=Serialized[b'\x03\x00'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=None, rssi=None)
2024-04-28 21:19:28.245 DEBUG (MainThread) [zigpy.zdo] [0x0000:zdo] ZDO request ZDOCmd.Mgmt_Permit_Joining_rsp: [<Status.SUCCESS: 0>]
2024-04-28 21:19:28.245 DEBUG (MainThread) [zigpy.zdo] [0x0000:zdo] No handler for ZDO request:ZDOCmd.Mgmt_Permit_Joining_rsp([<Status.SUCCESS: 0>])
2024-04-28 21:19:28.261 DEBUG (MainThread) [zigpy_znp.api] Received command: AF.DataRequestExt.Rsp(Status=<Status.SUCCESS: 0>)
2024-04-28 21:19:30.765 DEBUG (MainThread) [zigpy.application] Feeding watchdog
2024-04-28 21:19:30.767 DEBUG (MainThread) [zigpy_znp.api] Sending request: SYS.Ping.Req()
2024-04-28 21:19:30.776 DEBUG (MainThread) [zigpy_znp.api] Received command: SYS.Ping.Rsp(Capabilities=<MTCapabilities.SYS|AF|ZDO|UTIL|GP|APP_CNF: 1625>)
Then I press the button and no diag messages.
2024-04-28 21:20:00.781 DEBUG (MainThread) [zigpy.application] Feeding watchdog
2024-04-28 21:20:00.783 DEBUG (MainThread) [zigpy_znp.api] Sending request: SYS.Ping.Req()
2024-04-28 21:20:00.790 DEBUG (MainThread) [zigpy_znp.api] Received command: SYS.Ping.Rsp(Capabilities=<MTCapabilities.SYS|AF|ZDO|UTIL|GP|APP_CNF: 1625>)
2024-04-28 21:20:30.792 DEBUG (MainThread) [zigpy.application] Feeding watchdog
2024-04-28 21:20:30.793 DEBUG (MainThread) [zigpy_znp.api] Sending request: SYS.Ping.Req()
2024-04-28 21:20:30.799 DEBUG (MainThread) [zigpy_znp.api] Received command: SYS.Ping.Rsp(Capabilities=<MTCapabilities.SYS|AF|ZDO|UTIL|GP|APP_CNF: 1625>)
2024-04-28 21:21:00.801 DEBUG (MainThread) [zigpy.application] Feeding watchdog
2024-04-28 21:21:00.803 DEBUG (MainThread) [zigpy_znp.api] Sending request: SYS.Ping.Req()
2024-04-28 21:21:00.809 DEBUG (MainThread) [zigpy_znp.api] Received command: SYS.Ping.Rsp(Capabilities=<MTCapabilities.SYS|AF|ZDO|UTIL|GP|APP_CNF: 1625>)
2024-04-28 21:21:30.812 DEBUG (MainThread) [zigpy.application] Feeding watchdog
2024-04-28 21:21:30.813 DEBUG (MainThread) [zigpy_znp.api] Sending request: SYS.Ping.Req()
2024-04-28 21:21:30.819 DEBUG (MainThread) [zigpy_znp.api] Received command: SYS.Ping.Rsp(Capabilities=<MTCapabilities.SYS|AF|ZDO|UTIL|GP|APP_CNF: 1625>)
2024-04-28 21:22:00.821 DEBUG (MainThread) [zigpy.application] Feeding watchdog
2024-04-28 21:22:00.822 DEBUG (MainThread) [zigpy_znp.api] Sending request: SYS.Ping.Req()
2024-04-28 21:22:00.828 DEBUG (MainThread) [zigpy_znp.api] Received command: SYS.Ping.Rsp(Capabilities=<MTCapabilities.SYS|AF|ZDO|UTIL|GP|APP_CNF: 1625>)
2024-04-28 21:22:30.830 DEBUG (MainThread) [zigpy.application] Feeding watchdog
2024-04-28 21:22:30.831 DEBUG (MainThread) [zigpy_znp.api] Sending request: SYS.Ping.Req()
2024-04-28 21:22:30.838 DEBUG (MainThread) [zigpy_znp.api] Received command: SYS.Ping.Rsp(Capabilities=<MTCapabilities.SYS|AF|ZDO|UTIL|GP|APP_CNF: 1625>)
2024-04-28 21:23:00.840 DEBUG (MainThread) [zigpy.application] Feeding watchdog
2024-04-28 21:23:00.841 DEBUG (MainThread) [zigpy_znp.api] Sending request: SYS.Ping.Req()
2024-04-28 21:23:00.847 DEBUG (MainThread) [zigpy_znp.api] Received command: SYS.Ping.Rsp(Capabilities=<MTCapabilities.SYS|AF|ZDO|UTIL|GP|APP_CNF: 1625>)
Thoughts? Dud device, dropped support, or something else. It’s doing the slow white light flash, when I push the button it does the fast blink for 30 seconds. Already tried a reset, and tried going from channel 26 to 16.
Thanks!