00> <efr32 > ==================================================
00> <efr32 > chip-efr32-lighting-example starting
00> <efr32 > ==================================================
00> <efr32 > Init CHIP Stack
00> <detail> [-] Initializing key value store
00> <detail> [-] KeyValueStore init complete: active keys 0, deleted keys 1, sectors 4, logical sector size 8192 bytes
00> <info  > [DL] Setting device name to : "EFR32_LIGHT"
00> <efr32 > Initializing OpenThread stack
00> <info  > [DL] OpenThread started: OK
00> <info  > [DL] Setting OpenThread device type to ROUTER
00> <efr32 > Starting Platform Manager Event Loop
00> <efr32 > Starting OpenThread task
00> <efr32 > Starting App Task
00> <efr32 > Starting FreeRTOS scheduler
00> <info  > [DL] Bluetooth stack booted: v3.2.1-b216
00> <info  > [DL] RAIL version:, v2.11.1-b0
00> <detail> [DL] Thread task running
00> <detail> [DL] CHIP task running
00> <detail> [DL] Start BLE advertissement
00> <info  > [ZCL] Using ZAP configuration...
00> <info  > [ZCL] Initiating Admin Commissioning cluster.
00> <info  > [DL] _OnPlatformEvent def<detail> [DL] Thread packet RCVD: UDP, len 216
00> <detail> [DL]     src  2001:DB8::3993:4272:88A5:EB62, port 5542
00> <detail> [DL]     dest 2001:DB8::A52E:F0CD:BD83:1C5D, port 5540
00> <info  > [EM] Received message of type 0xhx with protocolId (48, 0) and MessageCounter:0 on exchange 35907r
00> <detail> [EM] Handling via exchange: 24946r, Delegate: 0x2001b564
00> <info  > [IN] CASE Server received Sigma1 message. Starting handshake. EC 0x2001c910
00> <info  > [DIS] CASE handshake initiated, closing all BLE Connections
00> <detail> [SC] Waiting for Sigma1 msg
00> <info  > [IN] CASE Server disabling CASE session setups
00> <detail> [SC] Received Sigma1 msg
00> <detail> [SC] Found MRP parameters in the message
00> <detail> [SC] Peer assigned session key ID 1
00> <info  > [DIS] Fabric (1) loaded from storage. Calling OnFabricRetrievedFromStorage
00> <info  > [ZCL] OpCreds: Fabric 0xhu was retrieved from storage. FabricId 0x0000000100000000, NodeId 0x0000000100000000, VendorId 0x5C01
00> <info  > [ZCL] OpCreds: Call to fabricListChanged
00> <detail> [IN] Generating DestinationID. Fabric ID 0x0000000000000001, Dest node ID 0x0000000000BC5C01, Random data
00> <detail> [IN] 0x67, 0x62, 0x4a, 0x93, 0x2c, 0x5c, 0x26, 0x26, 
00> <detail> [IN] 0xf1, 0x80, 0x05, 0xab, 0x78, 0xd1, 0x3d, 0xdb, 
00> <detail> [IN] 0xbc, 0x02, 0xee, 0xc5, 0xd6, 0x67, 0xa2, 0xc9, 
00> <detail> [IN] 0x01, 0x8b, 0x80, 0xd5, 0xbb, 0x3e, 0x81, 0xa5, 
00> <detail> [IN] Root pubkey
00> <detail> [IN] 0x04, 0xa4, 0x3a, 0x00, 0xc5, 0xe3, 0xe0, 0x09, 
00> <detail> [IN] 0x5c, 0xb6, 0x13, 0x66, 0x10, 0xa0, 0x34, 0xa6, 
00> <detail> [IN] 0x84, 0x2f, 0x3a, 0x<detail> [IN] Generated DestinationID output
00> <detail> [IN] 0xf2, 0x64, 0x97, 0x4e, 0xf5, 0xa8, 0x0d, 0x86, 
00> <detail> [IN] 0xc8, 0x92, 0x14, 0x58, 0x23, 0x1b, 0x48, 0xfe, 
00> <detail> [IN] 0xa4, 0x95, 0x35, 0x7c, 0xd7, 0xdb, 0x77, 0x02, 
00> <detail> [IN] 0x52, 0xd6, 0x2c, 0x39, 0xc5, 0x1c, 0xac, 0x31, 
00> <info  > [DIS] Fabric (1) loaded from storage. Calling OnFabricRetrievedFromStorage
00> <info  > [ZCL] OpCreds: Fabric 0xhu was retrieved from storage. FabricId 0x0000000100000000, NodeId 0x0000000100000000, VendorId 0x5C01
00> <info  > [ZCL] OpCreds: Call to fabricListChanged
00> <detail> [SC] Including MRP parameters
00> <detail> [EM] Piggybacking Ack for MessageCounter:2420149315 on exchange: 24946r
00> <info  > [IN] Prepared plaintext message 0x2001c79c to 0x0000000000000000 (0)  of type 0xhx and protocolId (49, 0) on exchange 0r with MessageCounter:114.
00> <info  > [IN] Sending plaintext msg 0x2001c79c with MessageCounter:3097735060 to 0x0000000000000000 at monotonic time: ld msec
00> <detail> [DL] Thread packet SENT: UDP, len 783
00> <detail> [DL]     src  2001:DB8::A52E:F0CD:BD83:1C5D, port 5540
00> <detail> [DL]     dest 2001:DB8::3993:4272:88A5:EB62, port 5542
00> <detail> [SC] Sent Sigma2 msg
00> <error > [DL] Long dispatch time: 1591 ms, for event type 3
00> <detail> [DL] Thread packet RCVD: UDP, len 647
00> <detail> [DL]     src  2001:DB8::3993:4272:88A5:EB62, port 5542
00> <detail> [DL]     dest 2001:DB8::A52E:F0CD:BD83:1C5D, port 5540
00> <info  > [EM] Received message of type 0xhx with protocolId (50, 0) and MessageCounter:0 on exchange 35908r
00> <detail> [EM] Found matching exchange: 24946r, Delegate: 0x2001b570
00> <detail> [EM] Rxd Ack; Removing MessageCounter:3097735060 from Retrans Table on exchange 24946r
00> <detail> [EM] Removed CHIP MessageCounter:3097735060 from RetransTable on exchange 24946r
00> <detail> [SC] Received Sigma3 msg
00> <detail> [IN] Generating compressed fabric ID using uncompressed fabric ID 0x0000000000000001 and root pubkey
00> <detail> [IN] 0x04, 0xa4, 0x3a, 0x00, 0xc5, 0xe3, 0xe0, 0x09, 
00> <detail> [IN] 0x5c, 0xb6, 0x13, 0x66, 0x10, 0xa0, 0x34, 0xa6, 
00> <detail> [IN] 0x84, 0x2f, 0x3a, 0x72, 0x9d, 0x61, 0x02, 0x92, 
00> <detail> [IN] 0x39, 0xf5, 0x14, 0x53, 0xed, 0x9e, 0x85, 0xd5, 
00> <detail> [IN] 0xb4, 0x26, 0xc0, 0x40, 0xc3, 0x69, 0x11, 0xa2, 
00> <detail> [IN] 0x71, 0x54, 0xf1, 0xb9, 0x12, 0x6f, 0xf6, 0xa9, 
00> <detail> [IN] 0xc6, 0xbb, 0x5a, 0xe5, 0xc0, 0x53, 0x2d, 0x21, 
00> <detail> [IN] 0x8c, 0x44, 0x78, 0x02, 0x47, 0x0c, 0xf5, 0x7a, 
00> <detail> [IN] 0x3b, 
00> <detail> [IN] Generated compressed fabric ID
00> <detail> [IN] 0xbe, 0xbe, 0x69, 0x30, 0x08, 0xac, 0x88, 0xaa, 
00> <detail> [SC] Sending status report. Protocol code 0, exchange 24946
00> <detail> [EM] Piggybacking Ack for MessageCounter:2420149316 on exchange: 24946r
00> <info  > [IN] Prepared plaintext message 0x2001c79c to 0x0000000000000000 (0)  of type 0xhx and protocolId (64, 0) on exchange 0r with MessageCounter:114.
00> <info  > [IN] Sending plaintext msg 0x2001c79c with MessageCounter:3097735061 to 0x0000000000000000 at monotonic time: ld msec
00> <detail> [DL] Thread packet SENT: UDP, len 74
00> <detail> [DL]     src  2001:DB8::A52E:F0CD:BD83:1C5D, port 5540
00> <detail> [DL]     dest 2001:DB8::3993:4272:88A5:EB62, port 5542
00> <info  > [IN] CASE Session established. Setting up the secure channel.
00> <detail> [IN] Marking old secure session for device 0x000000000001B669 as expired
00> <detail> [IN] New secure session created for device 0x000000000001B669, key 1!!
00> <info  > [IN] CASE secure channel is available now.
00> <info  > [IN] CASE Server enabling CASE session setups
00> <detail> [DL] Thread packet RCVD: UDP, len 96
00> <detail> [DL]     src  2001:DB8::3993:4272:88A5:EB62, port 5542
00> <detail> [DL]     dest 2001:DB8::A52E:F0CD:BD83:1C5D, port 5540
00> <info  > [EM] Received message of type 0xhx with protocolId (2, 0) and MessageCounter:1 on exchange 2349s
00> <detail> [EM] Handling via exchange: 24947r, Delegate: 0x2000f768
00> <detail> [IM] Received Read request
00> <detail> [DMG] IM RH moving to [Initialized]
00> <detail> [DMG] IM RH moving to [GeneratingReports]
00> <detail> [DMG] <RE:Run> Cluster 30, Attribute 0 is dirty
00> <detail> [DMG] Reading attribute: Cluster=0x0000_0030 Endpoint=1 AttributeId=0x0000_0000 (expanded=0)
00> <detail> [DMG] <RE> Sending report (payload has 30 bytes)...
00> <detail> [EM] Piggybacking Ack for MessageCounter:12192045 on exchange: 24947r
00> <info  > [IN] Prepared encrypted message 0x2001c7b4 to 0x000000000001B669 (1)  of type 0xhx and protocolId (5, 0) on exchange 1s with MessageCounter:114.
00> <info  > [IN] Sending encrypted msg 0x2001c7b4 with MessageCounter:5843111 to 0x000000000001B669 (1) at monotonic time: ld msec
00> <detail> [DL] Thread packet SENT: UDP, len 112
00> <detail> [DL]     src  2001:DB8::A52E:F0CD:BD83:1C5D, port 5540
00> <detail> [DL]     dest 2001:DB8::3993:4272:88A5:EB62, port 5542
00> <detail> [DMG] <RE> OnReportConfirm: NumReports = 0
00> <detail> [DMG] <RE> ReportsInFlight = 0 with readHandler 0, RE has no more messages
00> <detail> [DMG] IM RH moving to [Uninitialized]
00> <detail> [DL] Thread packet RCVD: UDP, len 66
00> <detail> [DL]     src  2001:DB8::3993:4272:88A5:EB62, port 5542
00> <detail> [DL]     dest 2001:DB8::A52E:F0CD:BD83:1C5D, port 5540
00> <info  > [EM] Received message of type 0xhx with protocolId (16, 0) and MessageCounter:0 on exchange 35909r
00> <detail> [EM] Found matching exchange: 24946r, Delegate: 0
00> <detail> [EM] Rxd Ack; Removing MessageCounter:3097735061 from Retrans Table on exchange 24946r
00> <detail> [EM] Removed CHIP MessageCounter:3097735061 from RetransTable on exchange 24946r
00> <detail> [DL] Thread packet RCVD: UDP, len 82
00> <detail> [DL]     src  2001:DB8::3993:4272:88A5:EB62, port 5542
00> <detail> [DL]     dest 2001:DB8::A52E:F0CD:BD83:1C5D, port 5540
00> <info  > [EM] Received message of type 0xhx with protocolId (16, 0) and MessageCounter:0 on exchange 2350s
00> <detail> [EM] Found matching exchange: 24947r, Delegate: 0
00> <detail> [EM] Rxd Ack; Removing MessageCounter:5843111 from Retrans Table on exchange 24947r
00> <detail> [EM] Removed CHIP MessageCounter:5843111 from RetransTable on exchange 24947r