search

nymea / nymea-zigbee

Zigbee library and tools for the nymea IoT stack.
GNU Lesser General Public License v3.0
3 stars 4 forks source link

ConBee 1 issue with Hue Remote #20

Open mzanetti opened 2 years ago

mzanetti commented 2 years ago

The hue remote doesn't work with the ConBee 1 stick (it does work with the ConBee 2). Interestingly the ZCL indidcations appear in the log, but the signals never end up in the nymea plugin. I've tracked it down to this:

The remote first seems to set up fine, but eventually you'll get this message in the logs:

W | ZigbeeNode: Failed to request IEEE address from unrecognized ZigbeeNode(0xf408, 00:00:00:00:00:00:00:00, End device, RxOn:false) ZigbeeDeviceObjectReply::ErrorTimeout
 I | ZigbeeNetwork: Request unrecognized ZigbeeNode(0xf408, 00:00:00:00:00:00:00:00, End device, RxOn:false) to leave the newtork
 W | ZigbeeNetwork: Received confirmation but could not find any reply. Ignoring the confirmation

This causes the Node to be removed from the stack (Note: for some reason it doesn't seem to actually leave the network!).

When then pressing a button, this will show up in the logs.

W | ZigbeeNetwork: Received a ZCL indication from an unrecognized node. Checking IEEE address for this node APSDE-DATA.indication(Group address:"0x0000", Destination EP:"0x9d", Source EP:"0x02", Source NWK address:"0xf408", Zigbee::ZigbeeProfileHomeAutomation, ZigbeeClusterLibrary::ClusterIdManufacturerSpecificPhilips, ASDU: "0x1d 0x0b 0x10 0x1f 0x00 0x04 0x00 0x00 0x30 0x00 0x21 0x00 0x00", LQI: 255, RSSI: -31dBm)
 I | ZigbeeNetwork: Start verify process for unrecognized node ZigbeeNode(0xf408, 00:00:00:00:00:00:00:00, End device, RxOn:false)
 I | ZigbeeNetwork: Request IEEE address from unrecognized node ZigbeeNode(0xf408, 00:00:00:00:00:00:00:00, End device, RxOn:false)
 I | ZigbeeNetwork: Received a ZCL indication for an unrecognized endpoint. There is no such endpoint on ZigbeeNode(0xf408, 00:00:00:00:00:00:00:00, End device, RxOn:false) Creating the uninitialized endpoint

The logs continue to create the endpoints and the clusters again and the ZCL indication arrives fine in the newly created cluster. However, the nymea plugin still thinks it's connected to the old node/endpoint/cluster pointers.

t-mon commented 2 years ago

Could you try to re-add the remote and past the init logs here? The zero mac address might be the main issue here, and the IEEE address request seems not to work either.

mzanetti commented 2 years ago 

 I | ZigbeeNetwork: Device announced "0x8c80" "00:17:88:01:04:F4:08:F3" "0x80"
 I | Zigbee: Node joined the network "{a4406906-5159-4175-9599-98eac380cdac}" ZigbeeNode(0x8c80, 00:17:88:01:04:F4:08:F3, End device, RxOn:false)
 I | ZigbeeNetwork: Finish network reply ZigbeeNetworkReply(0x56261fd03e70) ZigbeeNetworkReply::ErrorNoError
 I | ZigbeeNetwork: Network request sent successfully to device Request(ID:7, Zigbee::ZigbeeProfileDevice, ZigbeeDeviceProfile::NodeDescriptorRequest, NWK address:"0x8c80", Destination EP:"0x00", Source EP:"0x00", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x00 0x80 0x8c")
 I | ZigbeeNetwork: Finish network reply ZigbeeNetworkReply(0x56261fc28e90) ZigbeeNetworkReply::ErrorNoError
 I | ZigbeeNetwork: Network request sent successfully to device Request(ID:8, Zigbee::ZigbeeProfileDevice, ZigbeeDeviceProfile::PowerDescriptorRequest, NWK address:"0x8c80", Destination EP:"0x00", Source EP:"0x00", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x01 0x80 0x8c")
 I | ZigbeeNetwork: Finish network reply ZigbeeNetworkReply(0x56261fcf8fc0) ZigbeeNetworkReply::ErrorNoError
 I | ZigbeeNetwork: Network request sent successfully to device Request(ID:9, Zigbee::ZigbeeProfileDevice, ZigbeeDeviceProfile::ActiveEndpointsRequest, NWK address:"0x8c80", Destination EP:"0x00", Source EP:"0x00", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x02 0x80 0x8c")
 I | ZigbeeNetwork: Finish network reply ZigbeeNetworkReply(0x56261fce6f60) ZigbeeNetworkReply::ErrorNoError
 I | ZigbeeNetwork: Network request sent successfully to device Request(ID:10, Zigbee::ZigbeeProfileDevice, ZigbeeDeviceProfile::SimpleDescriptorRequest, NWK address:"0x8c80", Destination EP:"0x00", Source EP:"0x00", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x03 0x80 0x8c 0x01")
 I | ZigbeeEndpoint: Creating endpoint 1 on ZigbeeNode(0x8c80, 00:17:88:01:04:F4:08:F3, Router, RxOn:false)
 I | ZigbeeNetwork: Finish network reply ZigbeeNetworkReply(0x56261ef3a6c0) ZigbeeNetworkReply::ErrorNoError
 I | ZigbeeNetwork: Network request sent successfully to device Request(ID:11, Zigbee::ZigbeeProfileDevice, ZigbeeDeviceProfile::SimpleDescriptorRequest, NWK address:"0x8c80", Destination EP:"0x00", Source EP:"0x00", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x04 0x80 0x8c 0x02")
 I | ZigbeeEndpoint: Creating endpoint 2 on ZigbeeNode(0x8c80, 00:17:88:01:04:F4:08:F3, Router, RxOn:false)
 I | ZigbeeCluster: Read attributes from ZigbeeNode(0x8c80, 00:17:88:01:04:F4:08:F3, Router, RxOn:false) ZigbeeNodeEndpoint(0x01, Zigbee::ZigbeeProfileLightLink, Zigbee::LightLinkDeviceNonColourSceneController) ZigbeeCluster(0x0000, Basic, Servers) (4)
 I | ZigbeeEndpoint: Processing ZCL indication ZigbeeNodeEndpoint(0x01, Zigbee::ZigbeeProfileLightLink, Zigbee::LightLinkDeviceNonColourSceneController) APSDE-DATA.indication(NWK address:"0x0000", Destination EP:"0x01", Source EP:"0x01", Source NWK address:"0x8c80", Zigbee::ZigbeeProfileHomeAutomation, ZigbeeClusterLibrary::ClusterIdBasic, ASDU: "0x18 0x00 0x01 0x04 0x00 0x00 0x42 0x07 0x50 0x68 0x69 0x6c 0x69 0x70 0x73", LQI: 255, RSSI: -12dBm) Frame(Header(FrameControl(Frame Type: Global, Manufacturer specific: 0, Direction: Server to client, Disable default response: 1) TSN:0, 1) "0x04 0x00 0x00 0x42 0x07 0x50 0x68 0x69 0x6c 0x69 0x70 0x73")
 I | ZigbeeCluster: Received read attribute status record ZigbeeCluster(0x0000, Basic, Servers) ReadAttributeStatusRecord(0x0004, ZigbeeClusterLibrary::StatusSuccess, ZigbeeDataType(Character string, Philips) )
 I | ZigbeeCluster: Update attribute 0x56261fed6280 0x562620af7540 ZigbeeCluster(0x0000, Basic, Servers) ZigbeeClusterBasic::AttributeManufacturerName ZigbeeDataType(Character string, Philips)
 I | ZigbeeNetwork: Finish network reply ZigbeeNetworkReply(0x56261fcdd510) ZigbeeNetworkReply::ErrorNoError
 I | ZigbeeNetwork: Network request sent successfully to device Request(ID:12, Zigbee::ZigbeeProfileHomeAutomation, ZigbeeClusterLibrary::ClusterIdBasic, NWK address:"0x8c80", Destination EP:"0x01", Source EP:"0x01", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x10 0x00 0x00 0x04 0x00")
 I | ZigbeeCluster: ZigbeeClusterReply finished Request(ID:12, Zigbee::ZigbeeProfileHomeAutomation, ZigbeeClusterLibrary::ClusterIdBasic, NWK address:"0x8c80", Destination EP:"0x01", Source EP:"0x01", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x10 0x00 0x00 0x04 0x00") Frame(Header(FrameControl(Frame Type: Global, Manufacturer specific: 0, Direction: Client to server, Disable default response: 1) TSN:0, 0) "0x04 0x00") Frame(Header(FrameControl(Frame Type: Global, Manufacturer specific: 0, Direction: Server to client, Disable default response: 1) TSN:0, 1) "0x04 0x00 0x00 0x42 0x07 0x50 0x68 0x69 0x6c 0x69 0x70 0x73")
 I | ZigbeeCluster: Update attribute 0x56261fed6280 0x562620af7540 ZigbeeCluster(0x0000, Basic, Servers) ZigbeeClusterBasic::AttributeManufacturerName ZigbeeDataType(Character string, Philips)
 I | ZigbeeCluster: Read attributes from ZigbeeNode(0x8c80, 00:17:88:01:04:F4:08:F3, Philips, Router, RxOn:false) ZigbeeNodeEndpoint(0x01, Zigbee::ZigbeeProfileLightLink, Zigbee::LightLinkDeviceNonColourSceneController) ZigbeeCluster(0x0000, Basic, Servers) (5)
 I | ZigbeeNetwork: Finish network reply ZigbeeNetworkReply(0x56261fcf3d00) ZigbeeNetworkReply::ErrorNoError
 I | ZigbeeNetwork: Network request sent successfully to device Request(ID:13, Zigbee::ZigbeeProfileHomeAutomation, ZigbeeClusterLibrary::ClusterIdBasic, NWK address:"0x8c80", Destination EP:"0x01", Source EP:"0x01", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x10 0x00 0x00 0x05 0x00")
 I | ZigbeeEndpoint: Processing ZCL indication ZigbeeNodeEndpoint(0x01, Zigbee::ZigbeeProfileLightLink, Zigbee::LightLinkDeviceNonColourSceneController) APSDE-DATA.indication(NWK address:"0x0000", Destination EP:"0x01", Source EP:"0x01", Source NWK address:"0x8c80", Zigbee::ZigbeeProfileHomeAutomation, ZigbeeClusterLibrary::ClusterIdBasic, ASDU: "0x18 0x00 0x01 0x05 0x00 0x00 0x42 0x06 0x52 0x57 0x4c 0x30 0x32 0x31", LQI: 255, RSSI: -12dBm) Frame(Header(FrameControl(Frame Type: Global, Manufacturer specific: 0, Direction: Server to client, Disable default response: 1) TSN:0, 1) "0x05 0x00 0x00 0x42 0x06 0x52 0x57 0x4c 0x30 0x32 0x31")
 I | ZigbeeCluster: ZigbeeClusterReply finished Request(ID:13, Zigbee::ZigbeeProfileHomeAutomation, ZigbeeClusterLibrary::ClusterIdBasic, NWK address:"0x8c80", Destination EP:"0x01", Source EP:"0x01", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x10 0x00 0x00 0x05 0x00") Frame(Header(FrameControl(Frame Type: Global, Manufacturer specific: 0, Direction: Client to server, Disable default response: 1) TSN:0, 0) "0x05 0x00") Frame(Header(FrameControl(Frame Type: Global, Manufacturer specific: 0, Direction: Server to client, Disable default response: 1) TSN:0, 1) "0x05 0x00 0x00 0x42 0x06 0x52 0x57 0x4c 0x30 0x32 0x31")
 I | ZigbeeCluster: Update attribute 0x56261fed6280 0x562620af7540 ZigbeeCluster(0x0000, Basic, Servers) ZigbeeClusterBasic::AttributeModelIdentifier ZigbeeDataType(Character string, RWL021)
 I | ZigbeeCluster: Read attributes from ZigbeeNode(0x8c80, 00:17:88:01:04:F4:08:F3, Philips, RWL021, Router, RxOn:false) ZigbeeNodeEndpoint(0x01, Zigbee::ZigbeeProfileLightLink, Zigbee::LightLinkDeviceNonColourSceneController) ZigbeeCluster(0x0000, Basic, Servers) (16384)
 I | ZigbeeCluster: Received read attribute status record ZigbeeCluster(0x0000, Basic, Servers) ReadAttributeStatusRecord(0x0005, ZigbeeClusterLibrary::StatusSuccess, ZigbeeDataType(Character string, RWL021) )
 I | ZigbeeCluster: Update attribute 0x56261fed6280 0x562620af7540 ZigbeeCluster(0x0000, Basic, Servers) ZigbeeClusterBasic::AttributeModelIdentifier ZigbeeDataType(Character string, RWL021)
 I | ZigbeeNetwork: Finish network reply ZigbeeNetworkReply(0x56261eef6d70) ZigbeeNetworkReply::ErrorNoError
 I | ZigbeeNetwork: Network request sent successfully to device Request(ID:14, Zigbee::ZigbeeProfileHomeAutomation, ZigbeeClusterLibrary::ClusterIdBasic, NWK address:"0x8c80", Destination EP:"0x01", Source EP:"0x01", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x10 0x01 0x00 0x00 0x40")
 I | ZigbeeEndpoint: Processing ZCL indication ZigbeeNodeEndpoint(0x01, Zigbee::ZigbeeProfileLightLink, Zigbee::LightLinkDeviceNonColourSceneController) APSDE-DATA.indication(NWK address:"0x0000", Destination EP:"0x01", Source EP:"0x01", Source NWK address:"0x8c80", Zigbee::ZigbeeProfileHomeAutomation, ZigbeeClusterLibrary::ClusterIdBasic, ASDU: "0x18 0x01 0x01 0x00 0x40 0x00 0x42 0x0b 0x36 0x2e 0x31 0x2e 0x31 0x2e 0x32 0x38 0x35 0x37 0x33", LQI: 255, RSSI: -12dBm) Frame(Header(FrameControl(Frame Type: Global, Manufacturer specific: 0, Direction: Server to client, Disable default response: 1) TSN:1, 1) "0x00 0x40 0x00 0x42 0x0b 0x36 0x2e 0x31 0x2e 0x31 0x2e 0x32 0x38 0x35 0x37 0x33")
 I | ZigbeeCluster: ZigbeeClusterReply finished Request(ID:14, Zigbee::ZigbeeProfileHomeAutomation, ZigbeeClusterLibrary::ClusterIdBasic, NWK address:"0x8c80", Destination EP:"0x01", Source EP:"0x01", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x10 0x01 0x00 0x00 0x40") Frame(Header(FrameControl(Frame Type: Global, Manufacturer specific: 0, Direction: Client to server, Disable default response: 1) TSN:1, 0) "0x00 0x40") Frame(Header(FrameControl(Frame Type: Global, Manufacturer specific: 0, Direction: Server to client, Disable default response: 1) TSN:1, 1) "0x00 0x40 0x00 0x42 0x0b 0x36 0x2e 0x31 0x2e 0x31 0x2e 0x32 0x38 0x35 0x37 0x33")
 I | ZigbeeCluster: Update attribute 0x56261fed6280 0x562620af7540 ZigbeeCluster(0x0000, Basic, Servers) ZigbeeClusterBasic::AttributeSwBuildId ZigbeeDataType(Character string, 6.1.1.28573)
 I | ZigbeeNetwork: Add node ZigbeeNode(0x8c80, 00:17:88:01:04:F4:08:F3, Philips, RWL021, Router, RxOn:false)
 I | Zigbee: Node added to ZigbeeNetwork(00:21:2E:FF:FF:02:78:B6, {a4406906-5159-4175-9599-98eac380cdac}, Zigbee::ZigbeeBackendTypeDeconz, Channel: 16, ZigbeeNetwork::StateRunning) ZigbeeNode(0x8c80, 00:17:88:01:04:F4:08:F3, Philips, RWL021, Router, RxOn:false)
 I | Zigbee: --> ZigbeeNode(0x8c80, 00:17:88:01:04:F4:08:F3, Philips, RWL021, Router, RxOn:false)
 I | Zigbee:   ZigbeeNodeEndpoint(0x01, Zigbee::ZigbeeProfileLightLink, Zigbee::LightLinkDeviceNonColourSceneController)
 I | Zigbee:   Manufacturer: "Philips"
 I | Zigbee:   Model "RWL021"
 I | Zigbee:   Version "6.1.1.28573"
 I | Zigbee:     Input clusters ( 1 )
 I | Zigbee:      - ZigbeeCluster(0x0000, Basic, Servers)
 I | Zigbee:        -  ZigbeeClusterAttribute(0x0004, ZigbeeDataType(Character string, Philips) ) 
 I | Zigbee:        -  ZigbeeClusterAttribute(0x0005, ZigbeeDataType(Character string, RWL021) ) 
 I | Zigbee:        -  ZigbeeClusterAttribute(0x4000, ZigbeeDataType(Character string, 6.1.1.28573) ) 
 I | Zigbee:     Output clusters ( 6 )
 I | Zigbee:      - ZigbeeCluster(0x0008, LevelControl, Client)
 I | Zigbee:      - ZigbeeCluster(0x0004, Groups, Client)
 I | Zigbee:      - ZigbeeCluster(0x0005, Scenes, Client)
 I | Zigbee:      - ZigbeeCluster(0x0006, OnOff, Client)
 I | Zigbee:      - ZigbeeCluster(0x0000, Basic, Client)
 I | Zigbee:      - ZigbeeCluster(0x0003, Identify, Client)
 I | Zigbee:   ZigbeeNodeEndpoint(0x02, Zigbee::ZigbeeProfileHomeAutomation, Zigbee::HomeAutomationDeviceSimpleSensor)
 I | Zigbee:     Input clusters ( 5 )
 I | Zigbee:      - ZigbeeCluster(0x000f, BinaryInput, Servers)
 I | Zigbee:      - ZigbeeCluster(0xfc00, ManufacturerSpecificPhilips, Servers)
 I | Zigbee:      - ZigbeeCluster(0x0000, Basic, Servers)
 I | Zigbee:      - ZigbeeCluster(0x0001, PowerConfiguration, Servers)
 I | Zigbee:      - ZigbeeCluster(0x0003, Identify, Servers)
 I | Zigbee:     Output clusters ( 1 )
 I | Zigbee:      - ZigbeeCluster(0x0019, OtaUpgrade, Client)
 I | ZigbeeResource: ZigbeeNode(0x8c80, 00:17:88:01:04:F4:08:F3, Philips, RWL021, Router, RxOn:false) joined the network ZigbeeNetwork(00:21:2E:FF:FF:02:78:B6, {a4406906-5159-4175-9599-98eac380cdac}, Zigbee::ZigbeeBackendTypeDeconz, Channel: 16, ZigbeeNetwork::StateRunning)
 I | ZigbeePhilipsHue: Handling Hue dimmer switch ZigbeeNode(0x8c80, 00:17:88:01:04:F4:08:F3, Philips, RWL021, Router, RxOn:false) ZigbeeNodeEndpoint(0x01, Zigbee::ZigbeeProfileLightLink, Zigbee::LightLinkDeviceNonColourSceneController) ZigbeeNodeEndpoint(0x02, Zigbee::ZigbeeProfileHomeAutomation, Zigbee::HomeAutomationDeviceSimpleSensor)
 I | ZigbeeResource: Node ZigbeeNode(0x8c80, 00:17:88:01:04:F4:08:F3, Philips, RWL021, Router, RxOn:false) taken by handler "Philips Hue"
 I | ZigbeeCluster: Received read attribute status record ZigbeeCluster(0x0000, Basic, Servers) ReadAttributeStatusRecord(0x4000, ZigbeeClusterLibrary::StatusSuccess, ZigbeeDataType(Character string, 6.1.1.28573) )
 I | ZigbeeCluster: Update attribute 0x56261fed6280 0x562620af7540 ZigbeeCluster(0x0000, Basic, Servers) ZigbeeClusterBasic::AttributeSwBuildId ZigbeeDataType(Character string, 6.1.1.28573)
 C | ZigbeePhilipsHue: ************************** QUuid("{b2711164-a848-4715-8ddf-33ca86f9f4cf}")
 C | ZigbeePhilipsHue: Connecting to button presses 0x56261fcd6b30
 I | ZigbeeNetwork: Finish network reply ZigbeeNetworkReply(0x56261fc9ebf0) ZigbeeNetworkReply::ErrorNoError
 I | ZigbeeNetwork: Network request sent successfully to device Request(ID:15, Zigbee::ZigbeeProfileDevice, ZigbeeDeviceProfile::MgmtBindRequest, NWK address:"0x8c80", Destination EP:"0x00", Source EP:"0x00", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x05 0x00")
 I | ZigbeePhilipsHue: Removed all bindings successfully from ZigbeeNode(0x8c80, 00:17:88:01:04:F4:08:F3, Philips, RWL021, Router, RxOn:false)
 I | ZigbeePhilipsHue: Reading power configuration cluster attributes ZigbeeNode(0x8c80, 00:17:88:01:04:F4:08:F3, Philips, RWL021, Router, RxOn:false)
 I | ZigbeeCluster: Read attributes from ZigbeeNode(0x8c80, 00:17:88:01:04:F4:08:F3, Philips, RWL021, Router, RxOn:false) ZigbeeNodeEndpoint(0x02, Zigbee::ZigbeeProfileHomeAutomation, Zigbee::HomeAutomationDeviceSimpleSensor) ZigbeeCluster(0x0001, PowerConfiguration, Servers) (33)
 I | ZigbeeNetwork: Finish network reply ZigbeeNetworkReply(0x56261ee08cf0) ZigbeeNetworkReply::ErrorNoError
 I | ZigbeeNetwork: Network request sent successfully to device Request(ID:16, Zigbee::ZigbeeProfileHomeAutomation, ZigbeeClusterLibrary::ClusterIdPowerConfiguration, NWK address:"0x8c80", Destination EP:"0x02", Source EP:"0x01", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x10 0x00 0x00 0x21 0x00")
 I | ZigbeeEndpoint: Processing ZCL indication ZigbeeNodeEndpoint(0x02, Zigbee::ZigbeeProfileHomeAutomation, Zigbee::HomeAutomationDeviceSimpleSensor) APSDE-DATA.indication(NWK address:"0x0000", Destination EP:"0x01", Source EP:"0x02", Source NWK address:"0x8c80", Zigbee::ZigbeeProfileHomeAutomation, ZigbeeClusterLibrary::ClusterIdPowerConfiguration, ASDU: "0x18 0x00 0x01 0x21 0x00 0x00 0x20 0xc8", LQI: 255, RSSI: -12dBm) Frame(Header(FrameControl(Frame Type: Global, Manufacturer specific: 0, Direction: Server to client, Disable default response: 1) TSN:0, 1) "0x21 0x00 0x00 0x20 0xc8")
 I | ZigbeeCluster: ZigbeeClusterReply finished Request(ID:16, Zigbee::ZigbeeProfileHomeAutomation, ZigbeeClusterLibrary::ClusterIdPowerConfiguration, NWK address:"0x8c80", Destination EP:"0x02", Source EP:"0x01", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x10 0x00 0x00 0x21 0x00") Frame(Header(FrameControl(Frame Type: Global, Manufacturer specific: 0, Direction: Client to server, Disable default response: 1) TSN:0, 0) "0x21 0x00") Frame(Header(FrameControl(Frame Type: Global, Manufacturer specific: 0, Direction: Server to client, Disable default response: 1) TSN:0, 1) "0x21 0x00 0x00 0x20 0xc8")
 I | ZigbeePhilipsHue: Reading power configuration cluster attributes finished successfully
 I | ZigbeePhilipsHue: Binding power configuration cluster to coordinator IEEE address
 I | ZigbeeCluster: Received read attribute status record ZigbeeCluster(0x0001, PowerConfiguration, Servers) ReadAttributeStatusRecord(0x0021, ZigbeeClusterLibrary::StatusSuccess, ZigbeeDataType(Unsigned 8-bit integer, 0xc8) )
 I | ZigbeeCluster: Update attribute 0x56261fed6280 0x56261fcdafb0 ZigbeeCluster(0x0001, PowerConfiguration, Servers) ZigbeeClusterPowerConfiguration::AttributeBatteryPercentageRemaining ZigbeeDataType(Unsigned 8-bit integer, 0xc8)
 I | ZigbeeCluster: PowerConfiguration remaining battery percentage changed on 0x56261fed6280 0x56261fcdafb0 ZigbeeCluster(0x0001, PowerConfiguration, Servers) 100 %
 I | ZigbeePhilipsHue: Battery percentage changed 100 % Thing("Hue Dimmer switch", id: "{3ae39371-c144-4f8d-9181-21ae9da92bba}", ThingClassId: "{b2711164-a848-4715-8ddf-33ca86f9f4cf}")
 I | ZigbeeNetwork: Finish network reply ZigbeeNetworkReply(0x56261fd2dce0) ZigbeeNetworkReply::ErrorNoError
 I | ZigbeeNetwork: Network request sent successfully to device Request(ID:17, Zigbee::ZigbeeProfileDevice, ZigbeeDeviceProfile::BindRequest, NWK address:"0x8c80", Destination EP:"0x00", Source EP:"0x00", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x06 0xf3 0x08 0xf4 0x04 0x01 0x88 0x17 0x00 0x02 0x01 0x00 0x03 0xb6 0x78 0x02 0xff 0xff 0x2e 0x21 0x00 0x01")
 I | ZigbeePhilipsHue: Binding power configuration cluster to coordinator finished successfully
 I | ZigbeePhilipsHue: Configure attribute reporting for power configuration cluster to coordinator
 I | ZigbeeCluster: Configure reporting on ZigbeeNode(0x8c80, 00:17:88:01:04:F4:08:F3, Philips, RWL021, Router, RxOn:false) ZigbeeNodeEndpoint(0x02, Zigbee::ZigbeeProfileHomeAutomation, Zigbee::HomeAutomationDeviceSimpleSensor) ZigbeeCluster(0x0001, PowerConfiguration, Servers) (AttributeReportingConfiguration(ZigbeeClusterLibrary::ReportingDirectionReporting, 0x0021, Zigbee::Uint8, Min interval: 300[s], Max interval: 2700[s], Change: 0x01, Timeout period: 0[s]) ) 
 I | ZigbeeNetwork: Finish network reply ZigbeeNetworkReply(0x56261fce6f60) ZigbeeNetworkReply::ErrorNoError
 I | ZigbeeNetwork: Network request sent successfully to device Request(ID:18, Zigbee::ZigbeeProfileHomeAutomation, ZigbeeClusterLibrary::ClusterIdPowerConfiguration, NWK address:"0x8c80", Destination EP:"0x02", Source EP:"0x01", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x10 0x00 0x06 0x00 0x21 0x00 0x20 0x2c 0x01 0x8c 0x0a 0x01")
 I | ZigbeeEndpoint: Processing ZCL indication ZigbeeNodeEndpoint(0x02, Zigbee::ZigbeeProfileHomeAutomation, Zigbee::HomeAutomationDeviceSimpleSensor) APSDE-DATA.indication(NWK address:"0x0000", Destination EP:"0x01", Source EP:"0x02", Source NWK address:"0x8c80", Zigbee::ZigbeeProfileHomeAutomation, ZigbeeClusterLibrary::ClusterIdPowerConfiguration, ASDU: "0x18 0x00 0x07 0x00", LQI: 255, RSSI: -12dBm) Frame(Header(FrameControl(Frame Type: Global, Manufacturer specific: 0, Direction: Server to client, Disable default response: 1) TSN:0, 7) "0x00")
 I | ZigbeeCluster: ZigbeeClusterReply finished Request(ID:18, Zigbee::ZigbeeProfileHomeAutomation, ZigbeeClusterLibrary::ClusterIdPowerConfiguration, NWK address:"0x8c80", Destination EP:"0x02", Source EP:"0x01", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x10 0x00 0x06 0x00 0x21 0x00 0x20 0x2c 0x01 0x8c 0x0a 0x01") Frame(Header(FrameControl(Frame Type: Global, Manufacturer specific: 0, Direction: Client to server, Disable default response: 1) TSN:0, 6) "0x00 0x21 0x00 0x20 0x2c 0x01 0x8c 0x0a 0x01") Frame(Header(FrameControl(Frame Type: Global, Manufacturer specific: 0, Direction: Server to client, Disable default response: 1) TSN:0, 7) "0x00")
 I | ZigbeePhilipsHue: Attribute reporting configuration finished for power cluster (AttributeReportingConfiguration(ZigbeeClusterLibrary::StatusSuccess, 0, ZigbeeClusterLibrary::ReportingDirectionReporting) ) 
 I | ZigbeePhilipsHue: Bind on/off cluster to coordinator
 I | ZigbeeNetwork: Finish network reply ZigbeeNetworkReply(0x56261fc8bd00) ZigbeeNetworkReply::ErrorNoError
 I | ZigbeeNetwork: Network request sent successfully to device Request(ID:19, Zigbee::ZigbeeProfileDevice, ZigbeeDeviceProfile::BindRequest, NWK address:"0x8c80", Destination EP:"0x00", Source EP:"0x00", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x07 0xf3 0x08 0xf4 0x04 0x01 0x88 0x17 0x00 0x01 0x06 0x00 0x01 0x00 0x00")
 I | ZigbeePhilipsHue: Bind on/off cluster to coordinator finished successfully
 I | ZigbeePhilipsHue: Binding level control cluster to coordinator
 I | ZigbeeEndpoint: Processing ZCL indication ZigbeeNodeEndpoint(0x02, Zigbee::ZigbeeProfileHomeAutomation, Zigbee::HomeAutomationDeviceSimpleSensor) APSDE-DATA.indication(NWK address:"0x0000", Destination EP:"0x01", Source EP:"0x02", Source NWK address:"0x8c80", Zigbee::ZigbeeProfileHomeAutomation, ZigbeeClusterLibrary::ClusterIdPowerConfiguration, ASDU: "0x08 0x00 0x0a 0x21 0x00 0x20 0xc8", LQI: 255, RSSI: -12dBm) Frame(Header(FrameControl(Frame Type: Global, Manufacturer specific: 0, Direction: Server to client, Disable default response: 0) TSN:0, 10) "0x21 0x00 0x20 0xc8")
 I | ZigbeeCluster: Received attributes report ZigbeeCluster(0x0001, PowerConfiguration, Servers) Frame(Header(FrameControl(Frame Type: Global, Manufacturer specific: 0, Direction: Server to client, Disable default response: 0) TSN:0, 10) 0x21 0x00 0x20 0xc8)
 I | ZigbeeCluster: Update attribute 0x56261fed6280 0x56261fcdafb0 ZigbeeCluster(0x0001, PowerConfiguration, Servers) ZigbeeClusterPowerConfiguration::AttributeBatteryPercentageRemaining ZigbeeDataType(Unsigned 8-bit integer, 0xc8)
 I | ZigbeeCluster: PowerConfiguration remaining battery percentage changed on 0x56261fed6280 0x56261fcdafb0 ZigbeeCluster(0x0001, PowerConfiguration, Servers) 100 %
 I | ZigbeePhilipsHue: Battery percentage changed 100 % Thing("Hue Dimmer switch", id: "{3ae39371-c144-4f8d-9181-21ae9da92bba}", ThingClassId: "{b2711164-a848-4715-8ddf-33ca86f9f4cf}")
 I | ZigbeeNetwork: Finish network reply ZigbeeNetworkReply(0x56261fd16f40) ZigbeeNetworkReply::ErrorNoError
 I | ZigbeeNetwork: Network request sent successfully to device Request(ID:20, Zigbee::ZigbeeProfileDevice, ZigbeeDeviceProfile::BindRequest, NWK address:"0x8c80", Destination EP:"0x00", Source EP:"0x00", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x08 0xf3 0x08 0xf4 0x04 0x01 0x88 0x17 0x00 0x01 0x08 0x00 0x01 0x00 0x00")
 I | ZigbeePhilipsHue: Binding level control cluster to coordinator finished successfully
 I | ZigbeePhilipsHue: Binding scenes cluster to coordinator
 I | ZigbeeNetwork: Finish network reply ZigbeeNetworkReply(0x56261ed38790) ZigbeeNetworkReply::ErrorNoError
 I | ZigbeeNetwork: Network request sent successfully to device Request(ID:21, Zigbee::ZigbeeProfileDevice, ZigbeeDeviceProfile::BindRequest, NWK address:"0x8c80", Destination EP:"0x00", Source EP:"0x00", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x09 0xf3 0x08 0xf4 0x04 0x01 0x88 0x17 0x00 0x01 0x05 0x00 0x01 0x00 0x00")
 I | ZigbeePhilipsHue: Binding scenes control cluster to coordinator finished successfully
 I | ZigbeePhilipsHue: Binding groups cluster to coordinator
 I | ZigbeeNetwork: Finish network reply ZigbeeNetworkReply(0x56261fed4fd0) ZigbeeNetworkReply::ErrorNoError
 I | ZigbeeNetwork: Network request sent successfully to device Request(ID:22, Zigbee::ZigbeeProfileDevice, ZigbeeDeviceProfile::BindRequest, NWK address:"0x8c80", Destination EP:"0x00", Source EP:"0x00", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x0a 0xf3 0x08 0xf4 0x04 0x01 0x88 0x17 0x00 0x01 0x04 0x00 0x01 0x00 0x00")
 I | ZigbeePhilipsHue: Binding groups cluster to coordinator finished successfully
 I | ZigbeePhilipsHue: Binding binary input cluster to coordinator
 I | ZigbeeNetwork: Finish network reply ZigbeeNetworkReply(0x56261fd14d60) ZigbeeNetworkReply::ErrorNoError
 I | ZigbeeNetwork: Network request sent successfully to device Request(ID:23, Zigbee::ZigbeeProfileDevice, ZigbeeDeviceProfile::BindRequest, NWK address:"0x8c80", Destination EP:"0x00", Source EP:"0x00", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x0b 0xf3 0x08 0xf4 0x04 0x01 0x88 0x17 0x00 0x02 0x0f 0x00 0x01 0x00 0x00")
 I | ZigbeePhilipsHue: Binding binary input cluster to coordinator finished successfully
 I | ZigbeePhilipsHue: Binding Manufacturer specific cluster to coordinator
 I | ZigbeeNetwork: Finish network reply ZigbeeNetworkReply(0x56261fcf66c0) ZigbeeNetworkReply::ErrorNoError
 I | ZigbeeNetwork: Network request sent successfully to device Request(ID:24, Zigbee::ZigbeeProfileDevice, ZigbeeDeviceProfile::BindRequest, NWK address:"0x8c80", Destination EP:"0x00", Source EP:"0x00", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x0c 0xf3 0x08 0xf4 0x04 0x01 0x88 0x17 0x00 0x02 0x00 0xfc 0x01 0x00 0x00")
 I | ZigbeePhilipsHue: Binding manufacturer specific cluster to coordinator finished successfully
 I | ZigbeePhilipsHue: Reading binding table from node ZigbeeNode(0x8c80, 00:17:88:01:04:F4:08:F3, Philips, RWL021, Router, RxOn:false)
 I | ZigbeeNetwork: Finish network reply ZigbeeNetworkReply(0x56261fd2ba30) ZigbeeNetworkReply::ErrorNoError
 I | ZigbeeNetwork: Network request sent successfully to device Request(ID:25, Zigbee::ZigbeeProfileDevice, ZigbeeDeviceProfile::MgmtBindRequest, NWK address:"0x8c80", Destination EP:"0x00", Source EP:"0x00", Radius:0, QFlags<Zigbee::ZigbeeTxOption>(ZigbeeTxOptionAckTransmission), "0x0d 0x00")
 I | ZigbeePhilipsHue: ZigbeeNode(0x8c80, 00:17:88:01:04:F4:08:F3, Philips, RWL021, Router, RxOn:false) BindingTableListRecord("00:17:88:01:04:F4:08:F3", source endpoint: 2, cluster: ZigbeeClusterLibrary::ClusterIdPowerConfiguration --> destination address (unicast): "00:21:2E:FF:FF:02:78:B6", destination endpoint: 1) 
 I | ZigbeePhilipsHue: ZigbeeNode(0x8c80, 00:17:88:01:04:F4:08:F3, Philips, RWL021, Router, RxOn:false) BindingTableListRecord("00:17:88:01:04:F4:08:F3", source endpoint: 1, cluster: ZigbeeClusterLibrary::ClusterIdOnOff --> destination address (group): "0x0000") 
 I | ZigbeePhilipsHue: ZigbeeNode(0x8c80, 00:17:88:01:04:F4:08:F3, Philips, RWL021, Router, RxOn:false) BindingTableListRecord("00:17:88:01:04:F4:08:F3", source endpoint: 1, cluster: ZigbeeClusterLibrary::ClusterIdLevelControl --> destination address (group): "0x0000") 
 I | ZigbeePhilipsHue: ZigbeeNode(0x8c80, 00:17:88:01:04:F4:08:F3, Philips, RWL021, Router, RxOn:false) BindingTableListRecord("00:17:88:01:04:F4:08:F3", source endpoint: 1, cluster: ZigbeeClusterLibrary::ClusterIdScenes --> destination address (group): "0x0000") 

 W | ZigbeeNetwork: Received a ZCL indication from an unrecognized node. Checking IEEE address for this node APSDE-DATA.indication(Group address:"0x0000", Destination EP:"0x9d", Source EP:"0x02", Source NWK address:"0xf408", Zigbee::ZigbeeProfileHomeAutomation, ZigbeeClusterLibrary::ClusterIdManufacturerSpecificPhilips, ASDU: "0x1d 0x0b 0x10 0x01 0x00 0x04 0x00 0x00 0x30 0x00 0x21 0x00 0x00", LQI: 255, RSSI: -22dBm)
 I | ZigbeeNetwork: Start verify process for unrecognized node ZigbeeNode(0xf408, 00:00:00:00:00:00:00:00, End device, RxOn:false)
 I | ZigbeeNetwork: Request IEEE address from unrecognized node ZigbeeNode(0xf408, 00:00:00:00:00:00:00:00, End device, RxOn:false)
 I | ZigbeeNetwork: Received a ZCL indication for an unrecognized endpoint. There is no such endpoint on ZigbeeNode(0xf408, 00:00:00:00:00:00:00:00, End device, RxOn:false) Creating the uninitialized endpoint
 I | ZigbeeEndpoint: Creating endpoint 1 on ZigbeeNode(0xf408, 00:00:00:00:00:00:00:00, End device, RxOn:false)
 I | ZigbeeEndpoint: Processing ZCL indication ZigbeeNodeEndpoint(0x01, Zigbee::ZigbeeProfileHomeAutomation, Zigbee::HomeAutomationDeviceOnOffSwitch) APSDE-DATA.indication(Group address:"0x0000", Destination EP:"0x9d", Source EP:"0x01", Source NWK address:"0xf408", Zigbee::ZigbeeProfileHomeAutomation, ZigbeeClusterLibrary::ClusterIdOnOff, ASDU: "0x01 0x02 0x40 0x00 0x00", LQI: 255, RSSI: -22dBm) Frame(Header(FrameControl(Frame Type: Cluster specific, Manufacturer specific: 0, Direction: Client to server, Disable default response: 0) TSN:2, 64) "0x00 0x00")
 I | ZigbeeEndpoint: Received a ZCL indication for a client cluster which does not exist yet on ZigbeeNode(0xf408, 00:00:00:00:00:00:00:00, End device, RxOn:false) ZigbeeNodeEndpoint(0x01, Zigbee::ZigbeeProfileHomeAutomation, Zigbee::HomeAutomationDeviceOnOffSwitch) Creating ZigbeeCluster(0x0006, OnOff, Client)
 I | ZigbeeCluster: Processing cluster frame ZigbeeNode(0xf408, 00:00:00:00:00:00:00:00, End device, RxOn:false) ZigbeeNodeEndpoint(0x01, Zigbee::ZigbeeProfileHomeAutomation, Zigbee::HomeAutomationDeviceOnOffSwitch) ZigbeeCluster(0x0006, OnOff, Client) Frame(Header(FrameControl(Frame Type: Cluster specific, Manufacturer specific: 0, Direction: Client to server, Disable default response: 0) TSN:2, 64) 0x00 0x00)
 I | ZigbeeCluster: Received ZigbeeClusterOnOff::CommandOffWithEffect from ZigbeeNode(0xf408, 00:00:00:00:00:00:00:00, End device, RxOn:false) ZigbeeNodeEndpoint(0x01, Zigbee::ZigbeeProfileHomeAutomation, Zigbee::HomeAutomationDeviceOnOffSwitch) ZigbeeCluster(0x0006, OnOff, Client)
 I | ZigbeeNetwork: Received a ZCL indication for an unrecognized endpoint. There is no such endpoint on ZigbeeNode(0xf408, 00:00:00:00:00:00:00:00, End device, RxOn:false) Creating the uninitialized endpoint
 I | ZigbeeEndpoint: Creating endpoint 2 on ZigbeeNode(0xf408, 00:00:00:00:00:00:00:00, End device, RxOn:false)
 I | ZigbeeEndpoint: Processing ZCL indication ZigbeeNodeEndpoint(0x02, Zigbee::ZigbeeProfileHomeAutomation, Zigbee::HomeAutomationDeviceOnOffSwitch) APSDE-DATA.indication(Group address:"0x0000", Destination EP:"0x9d", Source EP:"0x02", Source NWK address:"0xf408", Zigbee::ZigbeeProfileHomeAutomation, ZigbeeClusterLibrary::ClusterIdManufacturerSpecificPhilips, ASDU: "0x1d 0x0b 0x10 0x03 0x00 0x04 0x00 0x00 0x30 0x02 0x21 0x01 0x00", LQI: 255, RSSI: -22dBm) Frame(Header(FrameControl(Frame Type: Cluster specific, Manufacturer specific: 1, Direction: Server to client, Disable default response: 1) Manufacturer code: "0x100b", TSN:3, 0) "0x04 0x00 0x00 0x30 0x02 0x21 0x01 0x00")
 I | ZigbeeEndpoint: Received a ZCL indication for a server cluster which does not exist yet on ZigbeeNode(0xf408, 00:00:00:00:00:00:00:00, End device, RxOn:false) ZigbeeNodeEndpoint(0x02, Zigbee::ZigbeeProfileHomeAutomation, Zigbee::HomeAutomationDeviceOnOffSwitch) Creating ZigbeeCluster(0xfc00, ManufacturerSpecificPhilips, Servers)
 I | ZigbeeCluster: Processing manufacturer specific (Philips) cluster frame ZigbeeNode(0xf408, 00:00:00:00:00:00:00:00, End device, RxOn:false) ZigbeeNodeEndpoint(0x02, Zigbee::ZigbeeProfileHomeAutomation, Zigbee::HomeAutomationDeviceOnOffSwitch) ZigbeeCluster(0xfc00, ManufacturerSpecificPhilips, Servers) Frame(Header(FrameControl(Frame Type: Cluster specific, Manufacturer specific: 1, Direction: Server to client, Disable default response: 1) Manufacturer code: 0x100b, TSN:3, 0) 0x04 0x00 0x00 0x30 0x02 0x21 0x01 0x00)
 I | ZigbeeCluster: Received manufacturer specific (Philips) command: 4 2 0x56261ff32ac0

The empty space is where the joining was finished, I waited a bit and then pressed a button on the remote.

Also, I've patched the code to print the Cluster Object pointer. As you can see, during the initial setup, it is a different pointer (0x56261fcd6b30) then later when the button press is handled (0x56261ff32ac0)

t-mon commented 2 years ago

The indication seems to come from a different node (different short address). Looks like the node was not updated correctly in the node table internally in the firmware. Please try to update and factory reset the stick firmware (delete all storage), factory reset the network on nymea and add the controller. This looks to me like a firmware bug. From nymea perspective, the indication is coming from a complete unknown node, it tries to initialize the unknown node, but failes.

mzanetti commented 2 years ago

Did that... Updated to the latest firmware, reset the dongle with the flasher too. Then also from nymea, re-added. Still the same.