I am trying to pair another ecosystem after being paired with the Home app. The third party ecosystem here is the chip-tool from the matter SDK. I can reproduce the issue following these steps: Pair with Apple Home app. In accessory settings in Home app, open pairing mode to obtain pairing code. Pair accessory with Chip-Tool using the following command: “./chip-tool pairing code 1234 <Home App generated Pairing Code>” Chip tool fails pairing at the “SendComplete” step. I wonder if there is some configuration that is limiting the number of pairing systems.

Matter device fails to pair a second ecosystem

I am trying to pair another ecosystem after being paired with the Home app. The third party ecosystem here is the chip-tool from the matter SDK.

I can reproduce the issue following these steps:

Pair with Apple Home app.
In accessory settings in Home app, open pairing mode to obtain pairing code.
Pair accessory with Chip-Tool using the following command: “./chip-tool pairing code 1234 <Home App generated Pairing Code>”
Chip tool fails pairing at the “SendComplete” step.

I wonder if there is some configuration that is limiting the number of pairing systems.

0 Hugo.Dev over 2 years ago

Attached logs from both sides.

Device logs:

b05> [5D[J[21:52:03.437,927] <inf> chip: [EM]>>> [E:61084r S:5793 M:53712788] (S) Msg RX from 1:5BC1324CA448C23D [EC5B] — Type 0001:02 (IM:ReadRequest)
b05> [5D[J[21:52:03.438,873] <inf> chip: [DL]OpenThread SED interval is 200ms
b05> [5D[J[21:52:03.440,124] <inf> chip: [EM]<<< [E:61084r S:5793 M:129165141 (Ack:53712788)] (S) Msg TX to 1:5BC1324CA448C23D [EC5B] — Type 0001:05 (IM:ReportData)
b05> [5D[J[21:52:03.440,277] <inf> chip: [IN](S) Sending msg 129165141 on secure session with LSID: 5793
b05> [5D[J[21:52:03.519,256] <inf> chip: [EM]>>> [E:61084r S:5793 M:53712789 (Ack:129165141)] (S) Msg RX from 1:5BC1324CA448C23D [EC5B] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[J[21:52:03.519,439] <inf> chip: [DL]OpenThread SED interval is 1000ms
b05> [5D[Jb05> [5D[Jb05> [5D[J[21:52:04.762,359] <inf> chip: [EM]>>> [E:61085r S:5793 M:53712790] (S) Msg RX from 1:5BC1324CA448C23D [EC5B] — Type 0001:0a (IM:TimedRequest)
b05> [5D[J[21:52:04.763,519] <inf> chip: [EM]<<< [E:61085r S:5793 M:129165142 (Ack:53712790)] (S) Msg TX to 1:5BC1324CA448C23D [EC5B] — Type 0001:01 (IM:StatusResponse)
b05> [5D[J[21:52:04.763,671] <inf> chip: [IN](S) Sending msg 129165142 on secure session with LSID: 5793
b05> [5D[J[21:52:04.764,984] <inf> chip: [DL]OpenThread SED interval is 200ms
b05> [5D[J[21:52:05.338,958] <inf> chip: [EM]>>> [E:61085r S:5793 M:53712791 (Ack:129165142)] (S) Msg RX from 1:5BC1324CA448C23D [EC5B] — Type 0001:08 (IM:InvokeCommandRequest)
b05> [5D[J[21:52:05.339,721] <inf> chip: [ZCL]Received command to open commissioning window
b05> [5D[J[21:52:05.340,332] <inf> chip: [DIS]Updating services using commissioning mode 2
b05> [5D[J[21:52:05.340,545] <inf> chip: [DIS]Advertise operational node 8BDF6D46F41EEC5B-00000000E9F27E32
b05> [5D[J[21:52:05.341,094] <inf> chip: [DIS]Advertise operational node 10FDFC35AD8D6D67-00000000C357B3F7
b05> [5D[J[21:52:05.341,613] <inf> chip: [DIS]Advertise operational node 00666433E3012986-00000000000004D2
b05> [5D[J[21:52:05.343,688] <inf> chip: [DIS]Advertise commission parameter vendorID=65521 productID=32773 discriminator=0495/01 cm=2
b05> [5D[J[21:52:05.344,238] <inf> chip: [DL]advertising srp service: 7F6BF7BD580EBC96._matterc._udp
b05> [5D[J[21:52:05.344,482] <inf> chip: [DL]removing srp service: 2D6B524ECA0C2C2A._matterc._udp
b05> [5D[J[21:52:05.344,696] <inf> chip: [ZCL]Commissioning window is now open
b05> [5D[J[21:52:05.345,977] <inf> chip: [EM]<<< [E:61085r S:5793 M:129165143 (Ack:53712791)] (S) Msg TX to 1:5BC1324CA448C23D [EC5B] — Type 0001:09 (IM:InvokeCommandResponse)
b05> [5D[J[21:52:05.346,130] <inf> chip: [IN](S) Sending msg 129165143 on secure session with LSID: 5793
b05> [5D[J[21:52:05.358,367] <inf> chip: [EM]<<< [E:4664i S:5793 M:129165144] (S) Msg TX to 1:5BC1324CA448C23D [EC5B] — Type 0001:05 (IM:ReportData)
b05> [5D[J[21:52:05.358,581] <inf> chip: [IN](S) Sending msg 129165144 on secure session with LSID: 5793
b05> [5D[J[21:52:05.360,534] <inf> chip: [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 60 seconds
b05> [5D[J[21:52:05.385,498] <inf> chip: [EM]>>> [E:61085r S:5793 M:53712792 (Ack:129165143)] (S) Msg RX from 1:5BC1324CA448C23D [EC5B] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[Jb05> [5D[Jb05> [5D[J[21:52:05.627,868] <inf> chip: [EM]>>> [E:4664i S:5793 M:53712793 (Ack:129165144)] (S) Msg RX from 1:5BC1324CA448C23D [EC5B] — Type 0001:01 (IM:StatusResponse)
b05> [5D[J[21:52:05.628,143] <inf> chip: [IM]Received status response, status is 0x00
b05> [5D[J[21:52:05.629,547] <inf> chip: [EM]<<< [E:4664i S:5793 M:129165145 (Ack:53712793)] (S) Msg TX to 1:5BC1324CA448C23D [EC5B] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[J[21:52:05.629,699] <inf> chip: [IN](S) Sending msg 129165145 on secure session with LSID: 5793
b05> [5D[Jb05> [5D[Jb05> [5D[J[21:52:22.591,644] <inf> chip: [EM]>>> [E:7114r S:0 M:164073984] (U) Msg RX from 0:C59EC11094475D93 [0000] — Type 0000:20 (SecureChannel:PBKDFParamRequest)
b05> [5D[J[21:52:22.592,132] <inf> chip: [EM]<<< [E:7114r S:0 M:145049556 (Ack:164073984)] (U) Msg TX to 0:0000000000000000 [0000] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[J[21:52:22.592,376] <inf> chip: [IN](U) Sending msg 145049556 to IP address ‘UDP:[fde0:5808:b16a:4517:e8:c198:5af7:8421]:57735’
b05> [5D[J[21:52:22.594,818] <inf> chip: [EM]<<< [E:7114r S:0 M:145049557 (Ack:164073984)] (U) Msg TX to 0:0000000000000000 [0000] — Type 0000:21 (SecureChannel:PBKDFParamResponse)
b05> [5D[J[21:52:22.595,062] <inf> chip: [IN](U) Sending msg 145049557 to IP address ‘UDP:[fde0:5808:b16a:4517:e8:c198:5af7:8421]:57735’
b05> [5D[J[21:52:22.810,028] <inf> chip: [EM]>>> [E:7114r S:0 M:164073985 (Ack:145049557)] (U) Msg RX from 0:C59EC11094475D93 [0000] — Type 0000:22 (SecureChannel:PASE_Pake1)
b05> [5D[J[21:52:22.810,546] <inf> chip: [EM]<<< [E:7114r S:0 M:145049558 (Ack:164073985)] (U) Msg TX to 0:0000000000000000 [0000] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[J[21:52:22.810,791] <inf> chip: [IN](U) Sending msg 145049558 to IP address ‘UDP:[fde0:5808:b16a:4517:e8:c198:5af7:8421]:57735’
b05> [5D[J[21:52:24.485,229] <inf> chip: [EM]<<< [E:7114r S:0 M:145049559 (Ack:164073985)] (U) Msg TX to 0:0000000000000000 [0000] — Type 0000:23 (SecureChannel:PASE_Pake2)
b05> [5D[J[21:52:24.485,473] <inf> chip: [IN](U) Sending msg 145049559 to IP address ‘UDP:[fde0:5808:b16a:4517:e8:c198:5af7:8421]:57735’
b05> [5D[Jb05> [5D[Jb05> [5D[J[21:52:25.537,384] <inf> chip: [IN](U) Sending msg 145049559 to IP address ‘UDP:[fde0:5808:b16a:4517:e8:c198:5af7:8421]:57735’
b05> [5D[J[21:52:25.803,375] <inf> chip: [EM]>>> [E:7114r S:0 M:164073986 (Ack:145049559)] (U) Msg RX from 0:C59EC11094475D93 [0000] — Type 0000:24 (SecureChannel:PASE_Pake3)
b05> [5D[J[21:52:25.803,894] <inf> chip: [EM]<<< [E:7114r S:0 M:145049560 (Ack:164073986)] (U) Msg TX to 0:0000000000000000 [0000] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[J[21:52:25.804,138] <inf> chip: [IN](U) Sending msg 145049560 to IP address ‘UDP:[fde0:5808:b16a:4517:e8:c198:5af7:8421]:57735’
b05> [5D[J[21:52:25.806,091] <inf> chip: [EM]<<< [E:7114r S:0 M:145049561 (Ack:164073986)] (U) Msg TX to 0:0000000000000000 [0000] — Type 0000:40 (SecureChannel:StatusReport)
b05> [5D[J[21:52:25.806,549] <inf> chip: [IN](U) Sending msg 145049561 to IP address ‘UDP:[fde0:5808:b16a:4517:e8:c198:5af7:8421]:57735’
b05> [5D[J[21:52:25.808,166] <inf> chip: [SC]SecureSession[0x200042c0]: Moving from state ‘kEstablishing’ —> ‘kActive’
b05> [5D[J[21:52:25.808,258] <inf> chip: [SVR]Commissioning completed session establishment step
b05> [5D[J[21:52:25.808,776] <inf> chip: [DIS]Updating services using commissioning mode 0
b05> [5D[J[21:52:25.809,051] <inf> chip: [DIS]Advertise operational node 8BDF6D46F41EEC5B-00000000E9F27E32
b05> [5D[J[21:52:25.810,729] <inf> chip: [DIS]Advertise operational node 10FDFC35AD8D6D67-00000000C357B3F7
b05> [5D[J[21:52:25.811,645] <inf> chip: [DIS]Advertise operational node 00666433E3012986-00000000000004D2
b05> [5D[J[21:52:25.813,751] <inf> chip: [DIS]Advertise commission parameter vendorID=65521 productID=32773 discriminator=3840/15 cm=0
b05> [5D[J[21:52:25.814,422] <inf> chip: [DL]advertising srp service: 7F6BF7BD580EBC96._matterc._udp
b05> [5D[J[21:52:25.814,666] <inf> chip: [SVR]Device completed Rendezvous process
b05> [5D[Jb05> [5D[Jb05> [5D[J[21:52:26.198,486] <inf> chip: [EM]>>> [E:7114r S:0 M:164073987 (Ack:145049559)] (U) Msg RX from 0:C59EC11094475D93 [0000] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[J[21:52:26.222,167] <inf> chip: [EM]>>> [E:7114r S:0 M:164073986 (Ack:145049559)] (U) Msg RX from 0:C59EC11094475D93 [0000] — Type 0000:24 (SecureChannel:PASE_Pake3)
b05> [5D[J[21:52:26.222,595] <inf> chip: [EM]<<< [E:7114r S:0 M:145049562 (Ack:164073986)] (U) Msg TX to 0:0000000000000000 [0000] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[J[21:52:26.222,839] <inf> chip: [IN](U) Sending msg 145049562 to IP address ‘UDP:[fde0:5808:b16a:4517:e8:c198:5af7:8421]:57735’
b05> [5D[J[21:52:26.299,041] <inf> chip: [EM]>>> [E:7115r S:5800 M:196832937] (S) Msg RX from 0:FFFFFFFB00000000 [0000] — Type 0001:02 (IM:ReadRequest)
b05> [5D[J[21:52:26.308,380] <inf> chip: [EM]<<< [E:7115r S:5800 M:117603833 (Ack:196832937)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] — Type 0001:05 (IM:ReportData)
b05> [5D[J[21:52:26.308,532] <inf> chip: [IN](S) Sending msg 117603833 on secure session with LSID: 5800
b05> [5D[J[21:52:26.310,455] <inf> chip: [EM]>>> [E:7114r S:0 M:164073988 (Ack:145049561)] (U) Msg RX from 0:C59EC11094475D93 [0000] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[J[21:52:26.653,594] <inf> chip: [EM]>>> [E:7116r S:5800 M:196832938] (S) Msg RX from 0:FFFFFFFB00000000 [0000] — Type 0001:08 (IM:InvokeCommandRequest)
b05> [5D[J[21:52:26.654,266] <inf> chip: [FS]GeneralCommissioning: Received ArmFailSafe (60s)
b05> [5D[J[21:52:26.655,609] <inf> chip: [EM]<<< [E:7116r S:5800 M:117603834 (Ack:196832938)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] — Type 0001:09 (IM:InvokeCommandResponse)
b05> [5D[J[21:52:26.655,792] <inf> chip: [IN](S) Sending msg 117603834 on secure session with LSID: 5800
b05> [5D[J[21:52:26.667,724] <inf> chip: [EM]<<< [E:4665i S:5793 M:129165146] (S) Msg TX to 1:5BC1324CA448C23D [EC5B] — Type 0001:05 (IM:ReportData)
b05> [5D[J[21:52:26.667,877] <inf> chip: [IN](S) Sending msg 129165146 on secure session with LSID: 5793
b05> [5D[J[21:52:26.668,670] <inf> chip: [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 60 seconds
b05> [5D[J[21:52:26.677,368] <inf> chip: [EM]>>> [E:7115r S:5800 M:196832939 (Ack:117603833)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[Jb05> [5D[Jb05> [5D[J[21:52:26.867,340] <inf> chip: [EM]>>> [E:4665i S:5793 M:53712794 (Ack:129165146)] (S) Msg RX from 1:5BC1324CA448C23D [EC5B] — Type 0001:01 (IM:StatusResponse)
b05> [5D[J[21:52:26.867,614] <inf> chip: [IM]Received status response, status is 0x00
b05> [5D[J[21:52:26.868,530] <inf> chip: [EM]<<< [E:4665i S:5793 M:129165147 (Ack:53712794)] (S) Msg TX to 1:5BC1324CA448C23D [EC5B] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[J[21:52:26.868,682] <inf> chip: [IN](S) Sending msg 129165147 on secure session with LSID: 5793
b05> [5D[J[21:52:27.391,479] <inf> chip: [EM]>>> [E:7117r S:5800 M:196832940] (S) Msg RX from 0:FFFFFFFB00000000 [0000] — Type 0001:08 (IM:InvokeCommandRequest)
b05> [5D[J[21:52:27.395,477] <inf> chip: [EM]<<< [E:7117r S:5800 M:117603835 (Ack:196832940)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] — Type 0001:09 (IM:InvokeCommandResponse)
b05> [5D[J[21:52:27.395,629] <inf> chip: [IN](S) Sending msg 117603835 on secure session with LSID: 5800
b05> [5D[J[21:52:27.407,623] <inf> chip: [EM]<<< [E:4666i S:5793 M:129165148] (S) Msg TX to 1:5BC1324CA448C23D [EC5B] — Type 0001:05 (IM:ReportData)
b05> [5D[J[21:52:27.407,775] <inf> chip: [IN](S) Sending msg 129165148 on secure session with LSID: 5793
b05> [5D[J[21:52:27.408,538] <inf> chip: [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 60 seconds
b05> [5D[J[21:52:27.409,606] <inf> chip: [EM]>>> [E:7116r S:5800 M:196832941 (Ack:117603834)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[Jb05> [5D[Jb05> [5D[J[21:52:27.736,633] <inf> chip: [EM]>>> [E:4666i S:5793 M:53712795 (Ack:129165148)] (S) Msg RX from 1:5BC1324CA448C23D [EC5B] — Type 0001:01 (IM:StatusResponse)
b05> [5D[J[21:52:27.736,968] <inf> chip: [IM]Received status response, status is 0x00
b05> [5D[J[21:52:27.738,281] <inf> chip: [EM]<<< [E:4666i S:5793 M:129165149 (Ack:53712795)] (S) Msg TX to 1:5BC1324CA448C23D [EC5B] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[J[21:52:27.738,433] <inf> chip: [IN](S) Sending msg 129165149 on secure session with LSID: 5793
b05> [5D[J[21:52:27.984,954] <inf> chip: [EM]>>> [E:7118r S:5800 M:196832942] (S) Msg RX from 0:FFFFFFFB00000000 [0000] — Type 0001:08 (IM:InvokeCommandRequest)
b05> [5D[J[21:52:27.985,992] <inf> chip: [ZCL]OpCreds: Certificate Chain request received for PAI
b05> [5D[J[21:52:27.989,440] <inf> chip: [EM]<<< [E:7118r S:5800 M:117603836 (Ack:196832942)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] — Type 0001:09 (IM:InvokeCommandResponse)
b05> [5D[J[21:52:27.989,624] <inf> chip: [IN](S) Sending msg 117603836 on secure session with LSID: 5800
b05> [5D[J[21:52:27.996,002] <inf> chip: [EM]>>> [E:7117r S:5800 M:196832943 (Ack:117603835)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[J[21:52:28.501,770] <inf> chip: [EM]>>> [E:7119r S:5800 M:196832944] (S) Msg RX from 0:FFFFFFFB00000000 [0000] — Type 0001:08 (IM:InvokeCommandRequest)
b05> [5D[J[21:52:28.502,471] <inf> chip: [ZCL]OpCreds: Certificate Chain request received for DAC
b05> [5D[J[21:52:28.506,408] <inf> chip: [EM]<<< [E:7119r S:5800 M:117603837 (Ack:196832944)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] — Type 0001:09 (IM:InvokeCommandResponse)
b05> [5D[J[21:52:28.506,591] <inf> chip: [IN](S) Sending msg 117603837 on secure session with LSID: 5800
b05> [5D[J[21:52:28.514,312] <inf> chip: [EM]>>> [E:7118r S:5800 M:196832945 (Ack:117603836)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[Jb05> [5D[Jb05> [5D[J[21:52:29.247,192] <inf> chip: [EM]>>> [E:7120r S:5800 M:196832946] (S) Msg RX from 0:FFFFFFFB00000000 [0000] — Type 0001:08 (IM:InvokeCommandRequest)
b05> [5D[J[21:52:29.248,107] <inf> chip: [ZCL]OpCreds: Received an AttestationRequest command
b05> [5D[J[21:52:29.249,053] <inf> chip: [EM]<<< [E:7120r S:5800 M:117603838 (Ack:196832946)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[J[21:52:29.249,572] <inf> chip: [IN](S) Sending msg 117603838 on secure session with LSID: 5800
b05> [5D[J[21:52:29.287,567] <inf> chip: [ZCL]OpCreds: AttestationRequest successful.
b05> [5D[J[21:52:29.291,748] <inf> chip: [EM]<<< [E:7120r S:5800 M:117603839 (Ack:196832946)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] — Type 0001:09 (IM:InvokeCommandResponse)
b05> [5D[J[21:52:29.291,900] <inf> chip: [IN](S) Sending msg 117603839 on secure session with LSID: 5800
b05> [5D[J[21:52:29.294,830] <inf> chip: [EM]>>> [E:7119r S:5800 M:196832947 (Ack:117603837)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[J[21:52:30.297,180] <inf> chip: [EM]>>> [E:7120r S:5800 M:196832946] (S) Msg RX from 0:FFFFFFFB00000000 [0000] — Type 0001:08 (IM:InvokeCommandRequest)
b05> [5D[J[21:52:30.298,034] <inf> chip: [EM]<<< [E:7120r S:5800 M:117603840 (Ack:196832946)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[J[21:52:30.298,187] <inf> chip: [IN](S) Sending msg 117603840 on secure session with LSID: 5800
b05> [5D[J[21:52:30.324,768] <inf> chip: [IN](S) Sending msg 117603839 on secure session with LSID: 5800
b05> [5D[Jb05> [5D[Jb05> [5D[J[21:52:31.038,330] <inf> chip: [EM]>>> [E:7121r S:5800 M:196832948] (S) Msg RX from 0:FFFFFFFB00000000 [0000] — Type 0001:08 (IM:InvokeCommandRequest)
b05> [5D[J[21:52:31.039,062] <inf> chip: [ZCL]OpCreds: Received a CSRRequest command
b05> [5D[J[21:52:31.040,405] <inf> chip: [EM]<<< [E:7121r S:5800 M:117603841 (Ack:196832948)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[J[21:52:31.040,588] <inf> chip: [IN](S) Sending msg 117603841 on secure session with LSID: 5800
b05> [5D[J[21:52:31.213,623] <inf> chip: [ZCL]OpCreds: AllocatePendingOperationalKey succeeded
b05> [5D[J[21:52:31.250,976] <inf> chip: [ZCL]OpCreds: CSRRequest successful.
b05> [5D[J[21:52:31.254,791] <inf> chip: [EM]<<< [E:7121r S:5800 M:117603842 (Ack:196832948)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] — Type 0001:09 (IM:InvokeCommandResponse)
b05> [5D[J[21:52:31.254,943] <inf> chip: [IN](S) Sending msg 117603842 on secure session with LSID: 5800
b05> [5D[J[21:52:31.256,774] <inf> chip: [EM]>>> [E:7120r S:5800 M:196832949 (Ack:117603839)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[J[21:52:31.852,447] <inf> chip: [EM]>>> [E:7120r S:5800 M:196832950 (Ack:117603839)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[J[21:52:32.107,696] <inf> chip: [EM]>>> [E:7121r S:5800 M:196832948] (S) Msg RX from 0:FFFFFFFB00000000 [0000] — Type 0001:08 (IM:InvokeCommandRequest)
b05> [5D[J[21:52:32.108,825] <inf> chip: [EM]<<< [E:7121r S:5800 M:117603843 (Ack:196832948)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[J[21:52:32.108,978] <inf> chip: [IN](S) Sending msg 117603843 on secure session with LSID: 5800
b05> [5D[Jb05> [5D[Jb05> [5D[J[21:52:32.170,013] <inf> chip: [EM]>>> [E:7122r S:5800 M:196832951] (S) Msg RX from 0:FFFFFFFB00000000 [0000] — Type 0001:08 (IM:InvokeCommandRequest)
b05> [5D[J[21:52:32.171,051] <inf> chip: [ZCL]OpCreds: Received an AddTrustedRootCertificate command
b05> [5D[J[21:52:32.171,905] <inf> chip: [EM]<<< [E:7122r S:5800 M:117603844 (Ack:196832951)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[J[21:52:32.172,088] <inf> chip: [IN](S) Sending msg 117603844 on secure session with LSID: 5800
b05> [5D[J[21:52:32.238,311] <inf> chip: [ZCL]OpCreds: AddTrustedRootCertificate successful.
b05> [5D[J[21:52:32.239,532] <inf> chip: [EM]<<< [E:7122r S:5800 M:117603845 (Ack:196832951)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] — Type 0001:09 (IM:InvokeCommandResponse)
b05> [5D[J[21:52:32.239,685] <inf> chip: [IN](S) Sending msg 117603845 on secure session with LSID: 5800
b05> [5D[J[21:52:32.242,248] <inf> chip: [EM]>>> [E:7121r S:5800 M:196832952 (Ack:117603842)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[J[21:52:32.979,797] <inf> chip: [EM]>>> [E:7123r S:5800 M:196832953] (S) Msg RX from 0:FFFFFFFB00000000 [0000] — Type 0001:08 (IM:InvokeCommandRequest)
b05> [5D[J[21:52:32.980,621] <inf> chip: [ZCL]OpCreds: Received an AddNOC command
b05> [5D[J[21:52:32.981,842] <inf> chip: [EM]<<< [E:7123r S:5800 M:117603846 (Ack:196832953)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[J[21:52:32.982,025] <inf> chip: [IN](S) Sending msg 117603846 on secure session with LSID: 5800
b05> [5D[J[21:52:32.985,198] <err> chip: [ZCL]OpCreds: Failed AddNOC request (err=7e) with OperationalCert error 9
b05> [5D[J[21:52:32.986,419] <inf> chip: [EM]<<< [E:7123r S:5800 M:117603847 (Ack:196832953)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] — Type 0001:09 (IM:InvokeCommandResponse)
b05> [5D[J[21:52:32.986,572] <inf> chip: [IN](S) Sending msg 117603847 on secure session with LSID: 5800
b05> [5D[J[21:52:32.993,988] <inf> chip: [EM]>>> [E:7122r S:5800 M:196832954 (Ack:117603845)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[Jb05> [5D[Jb05> [5D[J[21:52:33.392,517] <inf> chip: [EM]>>> [E:7124r S:5800 M:196832955] (S) Msg RX from 0:FFFFFFFB00000000 [0000] — Type 0001:08 (IM:InvokeCommandRequest)
b05> [5D[J[21:52:33.393,249] <inf> chip: [FS]GeneralCommissioning: Received ArmFailSafe (0s)
b05> [5D[J[21:52:33.393,341] <inf> chip: [FS]Fail-safe timer expired
b05> [5D[J[21:52:33.395,050] <inf> chip: [EM]<<< [E:7124r S:5800 M:117603848 (Ack:196832955)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] — Type 0001:09 (IM:InvokeCommandResponse)
b05> [5D[J[21:52:33.395,202] <inf> chip: [IN](S) Sending msg 117603848 on secure session with LSID: 5800
b05> [5D[J[21:52:33.395,965] <err> chip: [SVR]Failsafe timer expired
b05> [5D[J[21:52:33.396,118] <inf> chip: [SC]SecureSession[0x200042c0]: Moving from state ‘kActive’ —> ‘kPendingEviction’
b05> [5D[J[21:52:33.396,362] <err> chip: [SVR]Commissioning failed (attempt 1): 32
b05> [5D[J[21:52:33.396,789] <inf> chip: [DIS]Updating services using commissioning mode 2
b05> [5D[J[21:52:33.397,003] <inf> chip: [DIS]Advertise operational node 8BDF6D46F41EEC5B-00000000E9F27E32
b05> [5D[J[21:52:33.397,521] <inf> chip: [DIS]Advertise operational node 10FDFC35AD8D6D67-00000000C357B3F7
b05> [5D[J[21:52:33.398,071] <inf> chip: [DIS]Advertise operational node 00666433E3012986-00000000000004D2
b05> [5D[J[21:52:33.400,360] <inf> chip: [DIS]Advertise commission parameter vendorID=65521 productID=32773 discriminator=0495/01 cm=2
b05> [5D[J[21:52:33.401,031] <inf> chip: [DL]advertising srp service: 7F6BF7BD580EBC96._matterc._udp
b05> [5D[J[21:52:33.401,245] <err> chip: [ZCL]OpCreds: Got FailSafeTimerExpired
b05> [5D[J[21:52:33.401,336] <err> chip: [ZCL]OpCreds: Proceeding to FailSafeCleanup on fail-safe expiry!
b05> [5D[J[21:52:33.401,428] <err> chip: [FP]Reverting pending fabric data for fabric 0x4
b05> [5D[J[21:52:33.401,855] <inf> chip: [TS]Pending Last Known Good Time: 2023-06-19T15:43:08
b05> [5D[J[21:52:33.403,503] <inf> chip: [TS]Previous Last Known Good Time: 2023-06-19T15:43:08
b05> [5D[J[21:52:33.403,564] <inf> chip: [TS]Reverted Last Known Good Time to previous value
b05> [5D[J[21:52:33.405,212] <inf> chip: [FS]Fail-safe cleanly disarmed
b05> [5D[J[21:52:33.414,093] <inf> chip: [EM]<<< [E:4667i S:5793 M:129165150] (S) Msg TX to 1:5BC1324CA448C23D [EC5B] — Type 0001:05 (IM:ReportData)
b05> [5D[J[21:52:33.414,245] <inf> chip: [IN](S) Sending msg 129165150 on secure session with LSID: 5793
b05> [5D[J[21:52:33.415,039] <inf> chip: [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 60 seconds
b05> [5D[J[21:52:33.560,729] <err> chip: [IN]Data received on an unknown session (LSID=5800). Dropping it!
b05> [5D[Jb05> [5D[Jb05> [5D[J[21:52:33.635,437] <inf> chip: [EM]>>> [E:4667i S:5793 M:53712796 (Ack:129165150)] (S) Msg RX from 1:5BC1324CA448C23D [EC5B] — Type 0001:01 (IM:StatusResponse)
b05> [5D[J[21:52:33.635,681] <inf> chip: [IM]Received status response, status is 0x00
b05> [5D[J[21:52:33.636,596] <inf> chip: [EM]<<< [E:4667i S:5793 M:129165151 (Ack:53712796)] (S) Msg TX to 1:5BC1324CA448C23D [EC5B] — Type 0000:10 (SecureChannel:StandaloneAck)
b05> [5D[J[21:52:33.636,749] <inf> chip: [IN](S) Sending msg 129165151 on secure session with LSID: 5793
b05> [5D[Jb05> [5D[Jb05>

Chip-tool logs:

./chip-tool pairing code 1234 03101038080
[1687268077697] [71452:11938902] [DL] KVS will be written to: file:///tmp/chip_kvs
[1687268077704] [71452:11938902] [DL] _Init
[1687268077704] [71452:11938902] [IN] UDP::Init bind&listen port=0
[1687268077705] [71452:11938902] [IN] UDP::Init bound to port=57735
[1687268077705] [71452:11938902] [IN] UDP::Init bind&listen port=0
[1687268077705] [71452:11938902] [IN] UDP::Init bound to port=50538
[1687268077705] [71452:11938902] [IN] BLEBase::Init - setting/overriding transport
[1687268077705] [71452:11938902] [IN] TransportMgr initialized
[1687268077705] [71452:11938902] [FP] Initializing FabricTable from persistent storage
[1687268077705] [71452:11938902] [TS] Last Known Good Time: 2023-06-16T15:24:10
[1687268077707] [71452:11938902] [FP] Fabric index 0x1 was retrieved from storage. Compressed FabricId 0x00666433E3012986, FabricId 0x0000000000000001, NodeId 0x000000000001B669, VendorId 0xFFF1
[1687268077707] [71452:11938902] [FP] Fabric index 0x2 was retrieved from storage. Compressed FabricId 0x09A0A133024A6F00, FabricId 0x0000000000000004, NodeId 0x000000000001B669, VendorId 0xFFF1
[1687268077709] [71452:11938902] [ZCL] Using ZAP configuration...
[1687268077709] [71452:11938902] [CTL] System State Initialized...
[1687268077709] [71452:11938902] [CTL] Stopping commissioning discovery over DNS-SD
[1687268077709] [71452:11938902] [CTL] Setting attestation nonce to random value
[1687268077709] [71452:11938902] [CTL] Setting CSR nonce to random value
[1687268077709] [71452:11938902] [IN] UDP::Init bind&listen port=5550
[1687268077710] [71452:11938902] [IN] UDP::Init bound to port=5550
[1687268077710] [71452:11938902] [IN] UDP::Init bind&listen port=5550
[1687268077710] [71452:11938902] [IN] UDP::Init bound to port=5550
[1687268077710] [71452:11938902] [IN] TransportMgr initialized
[1687268077710] [71452:11938905] [DL] _OnPlatformEvent
[1687268077710] [71452:11938905] [CTL] Stopping commissioning discovery over DNS-SD
[1687268077710] [71452:11938905] [CTL] Setting attestation nonce to random value
[1687268077710] [71452:11938905] [CTL] Setting CSR nonce to random value
[1687268077711] [71452:11938905] [CTL] Generating NOC
[1687268077712] [71452:11938905] [FP] Validating NOC chain
[1687268077716] [71452:11938905] [FP] NOC chain validation successful
[1687268077716] [71452:11938905] [FP] Updated fabric at index: 0x1, Node ID: 0x000000000001B669
[1687268077716] [71452:11938905] [TS] Last Known Good Time: 2023-06-16T15:24:10
[1687268077716] [71452:11938905] [TS] New proposed Last Known Good Time: 2021-01-01T00:00:00
[1687268077716] [71452:11938905] [TS] Retaining current Last Known Good Time
[1687268077717] [71452:11938905] [FP] Metadata for Fabric 0x1 persisted to storage.
[1687268077717] [71452:11938905] [TS] Committing Last Known Good Time to storage: 2023-06-16T15:24:10
[1687268077718] [71452:11938905] [CTL] Joined the fabric at index 1. Fabric ID is 0x0000000000000001 (Compressed Fabric ID: 00666433E3012986)
[1687268077718] [71452:11938905] [IN] UDP::Init bind&listen port=5550
[1687268077718] [71452:11938905] [IN] UDP::Init bound to port=5550
[1687268077718] [71452:11938905] [IN] UDP::Init bind&listen port=5550
[1687268077718] [71452:11938905] [IN] UDP::Init bound to port=5550
[1687268077718] [71452:11938905] [IN] TransportMgr initialized
[1687268077724] [71452:11938905] [CTL] Setting attestation nonce to random value
[1687268077724] [71452:11938905] [CTL] Setting CSR nonce to random value
[1687268077724] [71452:11938905] [CTL] Stopping commissioning discovery over DNS-SD
[1687268077724] [71452:11938905] [CTL] Starting commissioning discovery over DNS-SD
[1687268077724] [71452:11938905] [DIS] Browsing for: _matterc._udp,_S1
[1687268077725] [71452:11938906] [DIS] Mdns: OnBrowseAdd  name: 7F6BF7BD580EBC96, type: _matterc._udp., domain: local., interface: 12
[1687268077725] [71452:11938906] [DIS] Resolve type=_matterc._udp name=7F6BF7BD580EBC96 interface=12
[1687268077725] [71452:11938906] [DIS] Mdns: OnResolve flags: 0, interface: 12, fullname: 7F6BF7BD580EBC96._matterc._udp.local., hostname: 9A2D4D9F3E4D45B9.local., port: 42005
[1687268077725] [71452:11938906] [DIS] Mdns : OnNewInterface hostname:9A2D4D9F3E4D45B9.local. fullname:7F6BF7BD580EBC96._matterc._udp.local. interface: 12 port: 5540 TXT:"VP=65521+32773,SII=1800,SAI=1000,T=0,D=495,CM=2,PH=36,PI="
[1687268078189] [71452:11938906] [DIS] Mdns: OnGetAddrInfo flags: 2, interface: 12, hostname: 9A2D4D9F3E4D45B9.local.
[1687268078189] [71452:11938906] [DIS] Mdns: OnNewAddress interface: 12 ip:fd9c:398b:edff:0:cf3c:b6c4:c22d:54e8
[1687268078189] [71452:11938906] [DIS] Mdns: Resolve success on interface 12
[1687268078189] [71452:11938906] [DIS] Discovered node:
[1687268078189] [71452:11938906] [DIS] 	Hostname: 9A2D4D9F3E4D45B9
[1687268078189] [71452:11938906] [DIS] 	IP Address #1: fd9c:398b:edff:0:cf3c:b6c4:c22d:54e8
[1687268078189] [71452:11938906] [DIS] 	Port: 5540
[1687268078189] [71452:11938906] [DIS] 	Mrp Interval idle: 1800 ms
[1687268078189] [71452:11938906] [DIS] 	Mrp Interval active: 1000 ms
[1687268078189] [71452:11938906] [DIS] 	TCP Supported: 0
[1687268078189] [71452:11938906] [DIS] 	Vendor ID: 65521
[1687268078189] [71452:11938906] [DIS] 	Product ID: 32773
[1687268078189] [71452:11938906] [DIS] 	Long Discriminator: 495
[1687268078189] [71452:11938906] [DIS] 	Pairing Hint: 36
[1687268078189] [71452:11938906] [DIS] 	Instance Name: 7F6BF7BD580EBC96
[1687268078189] [71452:11938906] [DIS] 	Commissioning Mode: 2
[1687268078189] [71452:11938906] [CTL] Discovered device to be commissioned over DNS-SD
[1687268078189] [71452:11938906] [CTL] Attempting PASE connection to UDP:[fd9c:398b:edff:0:cf3c:b6c4:c22d:54e8]:5540
[1687268078190] [71452:11938906] [IN] SecureSession[0x60000339c000]: Allocated Type:1 LSID:63495
[1687268078191] [71452:11938906] [SC] Assigned local session key ID 63495
[1687268078191] [71452:11938906] [EM] <<< [E:7114i S:0 M:164073984] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:20 (SecureChannel:PBKDFParamRequest)
[1687268078191] [71452:11938906] [IN] (U) Sending msg 164073984 to IP address 'UDP:[fd9c:398b:edff:0:cf3c:b6c4:c22d:54e8]:5540'
[1687268078192] [71452:11938906] [SC] Sent PBKDF param request
[1687268078192] [71452:11938906] [CTL] Commission called for node ID 0x00000000000004D2
[1687268078833] [71452:11938906] [EM] >>> [E:7114i S:0 M:145049556 (Ack:164073984)] (U) Msg RX from 0:0000000000000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1687268078833] [71452:11938906] [EM] Found matching exchange: 7114i, Delegate: 0x12f009250
[1687268078833] [71452:11938906] [EM] Rxd Ack; Removing MessageCounter:164073984 from Retrans Table on exchange 7114i
[1687268078833] [71452:11938906] [EM] >>> [E:7114i S:0 M:145049557 (Ack:164073984)] (U) Msg RX from 0:0000000000000000 [0000] --- Type 0000:21 (SecureChannel:PBKDFParamResponse)
[1687268078833] [71452:11938906] [EM] Found matching exchange: 7114i, Delegate: 0x12f009250
[1687268078833] [71452:11938906] [EM] CHIP MessageCounter:164073984 not in RetransTable on exchange 7114i
[1687268078833] [71452:11938906] [SC] Received PBKDF param response
[1687268078833] [71452:11938906] [SC] Peer assigned session ID 5800
[1687268078833] [71452:11938906] [SC] Found MRP parameters in the message
[1687268078864] [71452:11938906] [EM] <<< [E:7114i S:0 M:164073985 (Ack:145049557)] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:22 (SecureChannel:PASE_Pake1)
[1687268078864] [71452:11938906] [IN] (U) Sending msg 164073985 to IP address 'UDP:[fd9c:398b:edff:0:cf3c:b6c4:c22d:54e8%en1]:5540'
[1687268078864] [71452:11938906] [SC] Sent spake2p msg1
[1687268079048] [71452:11938906] [EM] >>> [E:7114i S:0 M:145049558 (Ack:164073985)] (U) Msg RX from 0:0000000000000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1687268079048] [71452:11938906] [EM] Found matching exchange: 7114i, Delegate: 0x12f009250
[1687268079048] [71452:11938906] [EM] Rxd Ack; Removing MessageCounter:164073985 from Retrans Table on exchange 7114i
[1687268080804] [71452:11938906] [EM] >>> [E:7114i S:0 M:145049559 (Ack:164073985)] (U) Msg RX from 0:0000000000000000 [0000] --- Type 0000:23 (SecureChannel:PASE_Pake2)
[1687268080804] [71452:11938906] [EM] Found matching exchange: 7114i, Delegate: 0x12f009250
[1687268080804] [71452:11938906] [EM] CHIP MessageCounter:164073985 not in RetransTable on exchange 7114i
[1687268080804] [71452:11938906] [SC] Received spake2p msg2
[1687268080819] [71452:11938906] [EM] <<< [E:7114i S:0 M:164073986 (Ack:145049559)] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:24 (SecureChannel:PASE_Pake3)
[1687268080819] [71452:11938906] [IN] (U) Sending msg 164073986 to IP address 'UDP:[fd9c:398b:edff:0:cf3c:b6c4:c22d:54e8%en1]:5540'
[1687268080819] [71452:11938906] [SC] Sent spake2p msg3
[1687268081929] [71452:11938906] [IN] Received a duplicate message with MessageCounter:145049559 on exchange 7114i
[1687268081929] [71452:11938906] [EM] >>> [E:7114i S:0 M:145049559 (Ack:164073985)] (U) Msg RX from 0:0000000000000000 [0000] --- Type 0000:23 (SecureChannel:PASE_Pake2)
[1687268081929] [71452:11938906] [EM] Found matching exchange: 7114i, Delegate: 0x12f009250
[1687268081929] [71452:11938906] [EM] Forcing tx of solitary ack for duplicate MessageCounter:145049559 on exchange 7114i
[1687268081930] [71452:11938906] [EM] <<< [E:7114i S:0 M:164073987 (Ack:145049559)] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1687268081930] [71452:11938906] [IN] (U) Sending msg 164073987 to IP address 'UDP:[fd9c:398b:edff:0:cf3c:b6c4:c22d:54e8%en1]:5540'
[1687268082079] [71452:11938906] [EM] Retransmitting MessageCounter:164073986 on exchange 7114i Send Cnt 1
[1687268082080] [71452:11938906] [IN] (U) Sending msg 164073986 to IP address 'UDP:[fd9c:398b:edff:0:cf3c:b6c4:c22d:54e8%en1]:5540'
[1687268082194] [71452:11938906] [EM] >>> [E:7114i S:0 M:145049560 (Ack:164073986)] (U) Msg RX from 0:0000000000000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1687268082194] [71452:11938906] [EM] Found matching exchange: 7114i, Delegate: 0x12f009250
[1687268082194] [71452:11938906] [EM] Rxd Ack; Removing MessageCounter:164073986 from Retrans Table on exchange 7114i
[1687268082194] [71452:11938906] [EM] >>> [E:7114i S:0 M:145049561 (Ack:164073986)] (U) Msg RX from 0:0000000000000000 [0000] --- Type 0000:40 (SecureChannel:StatusReport)
[1687268082194] [71452:11938906] [EM] Found matching exchange: 7114i, Delegate: 0x12f009250
[1687268082194] [71452:11938906] [EM] CHIP MessageCounter:164073986 not in RetransTable on exchange 7114i
[1687268082194] [71452:11938906] [SC] SecureSession[0x60000339c000, LSID:63495]: State change 'kEstablishing' --> 'kActive'
[1687268082194] [71452:11938906] [IN] SecureSession[0x60000339c000]: Activated - Type:1 LSID:63495
[1687268082194] [71452:11938906] [IN] New secure session activated for device <FFFFFFFB00000000, 0>, LSID:63495 PSID:5800!
[1687268082194] [71452:11938906] [CTL] Remote device completed SPAKE2+ handshake
[1687268082194] [71452:11938906] [CTL] Stopping commissioning discovery over DNS-SD
[1687268082194] [71452:11938906] [DIS] Mdns: Browse failure (src/platform/Darwin/DnssdImpl.cpp:412: CHIP Error 0x00000074: The operation has been cancelled)
[1687268082194] [71452:11938906] [TOO] Pairing Success
[1687268082194] [71452:11938906] [TOO] PASE establishment successful
[1687268082194] [71452:11938906] [CTL] Commissioning stage next step: 'SecurePairing' -> 'ReadCommissioningInfo'
[1687268082194] [71452:11938906] [CTL] Performing next commissioning step 'ReadCommissioningInfo'
[1687268082194] [71452:11938906] [CTL] Sending request for commissioning information
[1687268082195] [71452:11938906] [DMG] SendReadRequest ReadClient[0x12ee042d0]: Sending Read Request
[1687268082196] [71452:11938906] [EM] <<< [E:7115i S:63495 M:196832937] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
[1687268082196] [71452:11938906] [IN] (S) Sending msg 196832937 on secure session with LSID: 63495
[1687268082196] [71452:11938906] [DMG] MoveToState ReadClient[0x12ee042d0]: Moving to [AwaitingIn]
[1687268082196] [71452:11938906] [EM] <<< [E:7114i S:0 M:164073988 (Ack:145049561)] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1687268082197] [71452:11938906] [IN] (U) Sending msg 164073988 to IP address 'UDP:[fd9c:398b:edff:0:cf3c:b6c4:c22d:54e8%en1]:5540'
[1687268082197] [71452:11938906] [EM] Flushed pending ack for MessageCounter:145049561 on exchange 7114i
[1687268082612] [71452:11938905] [EM] >>> [E:7114i S:0 M:145049562 (Ack:164073986)] (U) Msg RX from 0:0000000000000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1687268082612] [71452:11938905] [EM] OnMessageReceived failed, err = src/messaging/ExchangeMgr.cpp:305: CHIP Error 0x00000070: Unsolicited msg with originator bit clear
[1687268082612] [71452:11938905] [EM] >>> [E:7115i S:63495 M:117603833 (Ack:196832937)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
[1687268082613] [71452:11938905] [EM] Found matching exchange: 7115i, Delegate: 0x12ee042e0
[1687268082613] [71452:11938905] [EM] Rxd Ack; Removing MessageCounter:196832937 from Retrans Table on exchange 7115i
[1687268082613] [71452:11938905] [DMG] ReportDataMessage =
[1687268082613] [71452:11938905] [DMG] {
[1687268082613] [71452:11938905] [DMG] 	AttributeReportIBs =
[1687268082613] [71452:11938905] [DMG] 	[
[1687268082613] [71452:11938905] [DMG] 		AttributeReportIB =
[1687268082613] [71452:11938905] [DMG] 		{
[1687268082613] [71452:11938905] [DMG] 			AttributeDataIB =
[1687268082613] [71452:11938905] [DMG] 			{
[1687268082613] [71452:11938905] [DMG] 				DataVersion = 0x36d0582e,
[1687268082613] [71452:11938905] [DMG] 				AttributePathIB =
[1687268082613] [71452:11938905] [DMG] 				{
[1687268082613] [71452:11938905] [DMG] 					Endpoint = 0x0,
[1687268082613] [71452:11938905] [DMG] 					Cluster = 0x31,
[1687268082613] [71452:11938905] [DMG] 					Attribute = 0x0000_0003,
[1687268082613] [71452:11938905] [DMG] 				}
[1687268082613] [71452:11938905] [DMG] 					
[1687268082613] [71452:11938905] [DMG] 				Data = 20, 
[1687268082613] [71452:11938905] [DMG] 			},
[1687268082613] [71452:11938905] [DMG] 			
[1687268082613] [71452:11938905] [DMG] 		},
[1687268082613] [71452:11938905] [DMG] 		
[1687268082613] [71452:11938905] [DMG] 		AttributeReportIB =
[1687268082613] [71452:11938905] [DMG] 		{
[1687268082613] [71452:11938905] [DMG] 			AttributeDataIB =
[1687268082613] [71452:11938905] [DMG] 			{
[1687268082613] [71452:11938905] [DMG] 				DataVersion = 0x2d06f9df,
[1687268082613] [71452:11938905] [DMG] 				AttributePathIB =
[1687268082613] [71452:11938905] [DMG] 				{
[1687268082613] [71452:11938905] [DMG] 					Endpoint = 0x0,
[1687268082613] [71452:11938905] [DMG] 					Cluster = 0x28,
[1687268082613] [71452:11938905] [DMG] 					Attribute = 0x0000_0004,
[1687268082613] [71452:11938905] [DMG] 				}
[1687268082613] [71452:11938905] [DMG] 					
[1687268082613] [71452:11938905] [DMG] 				Data = 32773, 
[1687268082613] [71452:11938905] [DMG] 			},
[1687268082613] [71452:11938905] [DMG] 			
[1687268082613] [71452:11938905] [DMG] 		},
[1687268082613] [71452:11938905] [DMG] 		
[1687268082613] [71452:11938905] [DMG] 		AttributeReportIB =
[1687268082613] [71452:11938905] [DMG] 		{
[1687268082613] [71452:11938905] [DMG] 			AttributeDataIB =
[1687268082613] [71452:11938905] [DMG] 			{
[1687268082613] [71452:11938905] [DMG] 				DataVersion = 0x2d06f9df,
[1687268082613] [71452:11938905] [DMG] 				AttributePathIB =
[1687268082613] [71452:11938905] [DMG] 				{
[1687268082613] [71452:11938905] [DMG] 					Endpoint = 0x0,
[1687268082613] [71452:11938905] [DMG] 					Cluster = 0x28,
[1687268082613] [71452:11938905] [DMG] 					Attribute = 0x0000_0002,
[1687268082613] [71452:11938905] [DMG] 				}
[1687268082613] [71452:11938905] [DMG] 					
[1687268082613] [71452:11938905] [DMG] 				Data = 65521, 
[1687268082613] [71452:11938905] [DMG] 			},
[1687268082613] [71452:11938905] [DMG] 			
[1687268082613] [71452:11938905] [DMG] 		},
[1687268082613] [71452:11938905] [DMG] 		
[1687268082613] [71452:11938905] [DMG] 		AttributeReportIB =
[1687268082613] [71452:11938905] [DMG] 		{
[1687268082613] [71452:11938905] [DMG] 			AttributeDataIB =
[1687268082613] [71452:11938905] [DMG] 			{
[1687268082613] [71452:11938905] [DMG] 				DataVersion = 0x3acfa6fe,
[1687268082613] [71452:11938905] [DMG] 				AttributePathIB =
[1687268082613] [71452:11938905] [DMG] 				{
[1687268082613] [71452:11938905] [DMG] 					Endpoint = 0x0,
[1687268082614] [71452:11938905] [DMG] 					Cluster = 0x30,
[1687268082614] [71452:11938905] [DMG] 					Attribute = 0x0000_0003,
[1687268082614] [71452:11938905] [DMG] 				}
[1687268082614] [71452:11938905] [DMG] 					
[1687268082614] [71452:11938905] [DMG] 				Data = 0, 
[1687268082614] [71452:11938905] [DMG] 			},
[1687268082614] [71452:11938905] [DMG] 			
[1687268082614] [71452:11938905] [DMG] 		},
[1687268082614] [71452:11938905] [DMG] 		
[1687268082614] [71452:11938905] [DMG] 		AttributeReportIB =
[1687268082614] [71452:11938905] [DMG] 		{
[1687268082614] [71452:11938905] [DMG] 			AttributeDataIB =
[1687268082614] [71452:11938905] [DMG] 			{
[1687268082614] [71452:11938905] [DMG] 				DataVersion = 0x3acfa6fe,
[1687268082614] [71452:11938905] [DMG] 				AttributePathIB =
[1687268082614] [71452:11938905] [DMG] 				{
[1687268082614] [71452:11938905] [DMG] 					Endpoint = 0x0,
[1687268082614] [71452:11938905] [DMG] 					Cluster = 0x30,
[1687268082614] [71452:11938905] [DMG] 					Attribute = 0x0000_0002,
[1687268082614] [71452:11938905] [DMG] 				}
[1687268082614] [71452:11938905] [DMG] 					
[1687268082614] [71452:11938905] [DMG] 				Data = 0, 
[1687268082614] [71452:11938905] [DMG] 			},
[1687268082614] [71452:11938905] [DMG] 			
[1687268082614] [71452:11938905] [DMG] 		},
[1687268082614] [71452:11938905] [DMG] 		
[1687268082614] [71452:11938905] [DMG] 		AttributeReportIB =
[1687268082614] [71452:11938905] [DMG] 		{
[1687268082614] [71452:11938905] [DMG] 			AttributeDataIB =
[1687268082615] [71452:11938905] [DMG] 			{
[1687268082615] [71452:11938905] [DMG] 				DataVersion = 0x3acfa6fe,
[1687268082615] [71452:11938905] [DMG] 				AttributePathIB =
[1687268082615] [71452:11938905] [DMG] 				{
[1687268082615] [71452:11938905] [DMG] 					Endpoint = 0x0,
[1687268082615] [71452:11938905] [DMG] 					Cluster = 0x30,
[1687268082615] [71452:11938905] [DMG] 					Attribute = 0x0000_0001,
[1687268082615] [71452:11938905] [DMG] 				}
[1687268082615] [71452:11938905] [DMG] 					
[1687268082615] [71452:11938905] [DMG] 				Data = 
[1687268082615] [71452:11938905] [DMG] 				{
[1687268082615] [71452:11938905] [DMG] 					0x0 = 60, 
[1687268082615] [71452:11938905] [DMG] 					0x1 = 900, 
[1687268082615] [71452:11938905] [DMG] 				},
[1687268082615] [71452:11938905] [DMG] 			},
[1687268082615] [71452:11938905] [DMG] 			
[1687268082615] [71452:11938905] [DMG] 		},
[1687268082615] [71452:11938905] [DMG] 		
[1687268082615] [71452:11938905] [DMG] 		AttributeReportIB =
[1687268082615] [71452:11938905] [DMG] 		{
[1687268082615] [71452:11938905] [DMG] 			AttributeDataIB =
[1687268082615] [71452:11938905] [DMG] 			{
[1687268082615] [71452:11938905] [DMG] 				DataVersion = 0x3acfa6fe,
[1687268082615] [71452:11938905] [DMG] 				AttributePathIB =
[1687268082615] [71452:11938905] [DMG] 				{
[1687268082615] [71452:11938905] [DMG] 					Endpoint = 0x0,
[1687268082615] [71452:11938905] [DMG] 					Cluster = 0x30,
[1687268082615] [71452:11938905] [DMG] 					Attribute = 0x0000_0000,
[1687268082615] [71452:11938905] [DMG] 				}
[1687268082615] [71452:11938905] [DMG] 					
[1687268082615] [71452:11938905] [DMG] 				Data = 0, 
[1687268082615] [71452:11938905] [DMG] 			},
[1687268082615] [71452:11938905] [DMG] 			
[1687268082615] [71452:11938905] [DMG] 		},
[1687268082615] [71452:11938905] [DMG] 		
[1687268082615] [71452:11938905] [DMG] 		AttributeReportIB =
[1687268082615] [71452:11938905] [DMG] 		{
[1687268082615] [71452:11938905] [DMG] 			AttributeDataIB =
[1687268082616] [71452:11938905] [DMG] 			{
[1687268082616] [71452:11938905] [DMG] 				DataVersion = 0x36d0582e,
[1687268082616] [71452:11938905] [DMG] 				AttributePathIB =
[1687268082616] [71452:11938905] [DMG] 				{
[1687268082616] [71452:11938905] [DMG] 					Endpoint = 0x0,
[1687268082616] [71452:11938905] [DMG] 					Cluster = 0x31,
[1687268082616] [71452:11938905] [DMG] 					Attribute = 0x0000_FFFC,
[1687268082616] [71452:11938905] [DMG] 				}
[1687268082616] [71452:11938905] [DMG] 					
[1687268082616] [71452:11938905] [DMG] 				Data = 2, 
[1687268082616] [71452:11938905] [DMG] 			},
[1687268082616] [71452:11938905] [DMG] 			
[1687268082616] [71452:11938905] [DMG] 		},
[1687268082616] [71452:11938905] [DMG] 		
[1687268082616] [71452:11938905] [DMG] 	],
[1687268082616] [71452:11938905] [DMG] 	
[1687268082616] [71452:11938905] [DMG] 	SuppressResponse = true, 
[1687268082616] [71452:11938905] [DMG] 	InteractionModelRevision = 1
[1687268082616] [71452:11938905] [DMG] }
[1687268082618] [71452:11938905] [CTL] ----- NetworkCommissioning Features: has Thread. endpointid = 0
[1687268082618] [71452:11938905] [CTL] Successfully finished commissioning step 'ReadCommissioningInfo'
[1687268082619] [71452:11938905] [CTL] Commissioning stage next step: 'ReadCommissioningInfo' -> 'ArmFailSafe'
[1687268082619] [71452:11938905] [CTL] Performing next commissioning step 'ArmFailSafe'
[1687268082619] [71452:11938905] [CTL] Arming failsafe (60 seconds)
[1687268082619] [71452:11938905] [DMG] ICR moving to [AddingComm]
[1687268082619] [71452:11938905] [DMG] ICR moving to [AddedComma]
[1687268082619] [71452:11938905] [EM] <<< [E:7116i S:63495 M:196832938] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1687268082619] [71452:11938905] [IN] (S) Sending msg 196832938 on secure session with LSID: 63495
[1687268082620] [71452:11938905] [DMG] ICR moving to [CommandSen]
[1687268082620] [71452:11938905] [EM] <<< [E:7115i S:63495 M:196832939 (Ack:117603833)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1687268082620] [71452:11938905] [IN] (S) Sending msg 196832939 on secure session with LSID: 63495
[1687268082620] [71452:11938905] [EM] Flushed pending ack for MessageCounter:117603833 on exchange 7115i
[1687268083214] [71452:11938907] [EM] >>> [E:7116i S:63495 M:117603834 (Ack:196832938)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1687268083214] [71452:11938907] [EM] Found matching exchange: 7116i, Delegate: 0x12ef04088
[1687268083214] [71452:11938907] [EM] Rxd Ack; Removing MessageCounter:196832938 from Retrans Table on exchange 7116i
[1687268083214] [71452:11938907] [DMG] ICR moving to [ResponseRe]
[1687268083214] [71452:11938907] [DMG] InvokeResponseMessage =
[1687268083214] [71452:11938907] [DMG] {
[1687268083214] [71452:11938907] [DMG] 	suppressResponse = false, 
[1687268083214] [71452:11938907] [DMG] 	InvokeResponseIBs =
[1687268083214] [71452:11938907] [DMG] 	[
[1687268083214] [71452:11938907] [DMG] 		InvokeResponseIB =
[1687268083214] [71452:11938907] [DMG] 		{
[1687268083214] [71452:11938907] [DMG] 			CommandDataIB =
[1687268083214] [71452:11938907] [DMG] 			{
[1687268083214] [71452:11938907] [DMG] 				CommandPathIB =
[1687268083214] [71452:11938907] [DMG] 				{
[1687268083214] [71452:11938907] [DMG] 					EndpointId = 0x0,
[1687268083214] [71452:11938907] [DMG] 					ClusterId = 0x30,
[1687268083214] [71452:11938907] [DMG] 					CommandId = 0x1,
[1687268083214] [71452:11938907] [DMG] 				},
[1687268083214] [71452:11938907] [DMG] 				
[1687268083214] [71452:11938907] [DMG] 				CommandFields = 
[1687268083214] [71452:11938907] [DMG] 				{
[1687268083214] [71452:11938907] [DMG] 					0x0 = 0, 
[1687268083214] [71452:11938907] [DMG] 					0x1 = "" (0 chars), 
[1687268083214] [71452:11938907] [DMG] 				},
[1687268083214] [71452:11938907] [DMG] 			},
[1687268083214] [71452:11938907] [DMG] 			
[1687268083214] [71452:11938907] [DMG] 		},
[1687268083214] [71452:11938907] [DMG] 		
[1687268083214] [71452:11938907] [DMG] 	],
[1687268083214] [71452:11938907] [DMG] 	
[1687268083214] [71452:11938907] [DMG] 	InteractionModelRevision = 1
[1687268083214] [71452:11938907] [DMG] },
[1687268083215] [71452:11938907] [DMG] Received Command Response Data, Endpoint=0 Cluster=0x0000_0030 Command=0x0000_0001
[1687268083218] [71452:11938907] [CTL] Received ArmFailSafe response errorCode=0
[1687268083218] [71452:11938907] [CTL] Successfully finished commissioning step 'ArmFailSafe'
[1687268083218] [71452:11938907] [CTL] Commissioning stage next step: 'ArmFailSafe' -> 'ConfigRegulatory'
[1687268083218] [71452:11938907] [CTL] Performing next commissioning step 'ConfigRegulatory'
[1687268083218] [71452:11938907] [CTL] Setting Regulatory Config
[1687268083218] [71452:11938907] [CTL] Device does not support configurable regulatory location
[1687268083218] [71452:11938907] [DMG] ICR moving to [AddingComm]
[1687268083218] [71452:11938907] [DMG] ICR moving to [AddedComma]
[1687268083219] [71452:11938907] [EM] <<< [E:7117i S:63495 M:196832940] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1687268083219] [71452:11938907] [IN] (S) Sending msg 196832940 on secure session with LSID: 63495
[1687268083219] [71452:11938907] [DMG] ICR moving to [CommandSen]
[1687268083219] [71452:11938907] [DMG] ICR moving to [AwaitingDe]
[1687268083219] [71452:11938907] [EM] <<< [E:7116i S:63495 M:196832941 (Ack:117603834)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1687268083219] [71452:11938907] [IN] (S) Sending msg 196832941 on secure session with LSID: 63495
[1687268083219] [71452:11938907] [EM] Flushed pending ack for MessageCounter:117603834 on exchange 7116i
[1687268083828] [71452:11938906] [EM] >>> [E:7117i S:63495 M:117603835 (Ack:196832940)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1687268083828] [71452:11938906] [EM] Found matching exchange: 7117i, Delegate: 0x12ee041c8
[1687268083828] [71452:11938906] [EM] Rxd Ack; Removing MessageCounter:196832940 from Retrans Table on exchange 7117i
[1687268083828] [71452:11938906] [DMG] ICR moving to [ResponseRe]
[1687268083828] [71452:11938906] [DMG] InvokeResponseMessage =
[1687268083828] [71452:11938906] [DMG] {
[1687268083828] [71452:11938906] [DMG] 	suppressResponse = false, 
[1687268083828] [71452:11938906] [DMG] 	InvokeResponseIBs =
[1687268083828] [71452:11938906] [DMG] 	[
[1687268083828] [71452:11938906] [DMG] 		InvokeResponseIB =
[1687268083828] [71452:11938906] [DMG] 		{
[1687268083828] [71452:11938906] [DMG] 			CommandDataIB =
[1687268083828] [71452:11938906] [DMG] 			{
[1687268083828] [71452:11938906] [DMG] 				CommandPathIB =
[1687268083828] [71452:11938906] [DMG] 				{
[1687268083828] [71452:11938906] [DMG] 					EndpointId = 0x0,
[1687268083828] [71452:11938906] [DMG] 					ClusterId = 0x30,
[1687268083828] [71452:11938906] [DMG] 					CommandId = 0x3,
[1687268083829] [71452:11938906] [DMG] 				},
[1687268083829] [71452:11938906] [DMG] 				
[1687268083829] [71452:11938906] [DMG] 				CommandFields = 
[1687268083829] [71452:11938906] [DMG] 				{
[1687268083829] [71452:11938906] [DMG] 					0x0 = 0, 
[1687268083829] [71452:11938906] [DMG] 					0x1 = "" (0 chars), 
[1687268083829] [71452:11938906] [DMG] 				},
[1687268083829] [71452:11938906] [DMG] 			},
[1687268083829] [71452:11938906] [DMG] 			
[1687268083829] [71452:11938906] [DMG] 		},
[1687268083829] [71452:11938906] [DMG] 		
[1687268083829] [71452:11938906] [DMG] 	],
[1687268083829] [71452:11938906] [DMG] 	
[1687268083829] [71452:11938906] [DMG] 	InteractionModelRevision = 1
[1687268083829] [71452:11938906] [DMG] },
[1687268083829] [71452:11938906] [DMG] Received Command Response Data, Endpoint=0 Cluster=0x0000_0030 Command=0x0000_0003
[1687268083829] [71452:11938906] [CTL] Received SetRegulatoryConfig response errorCode=0
[1687268083829] [71452:11938906] [CTL] Successfully finished commissioning step 'ConfigRegulatory'
[1687268083829] [71452:11938906] [CTL] Commissioning stage next step: 'ConfigRegulatory' -> 'SendPAICertificateRequest'
[1687268083829] [71452:11938906] [CTL] Performing next commissioning step 'SendPAICertificateRequest'
[1687268083829] [71452:11938906] [CTL] Sending request for PAI certificate
[1687268083829] [71452:11938906] [CTL] Sending Certificate Chain request to 0x12f009200 device
[1687268083829] [71452:11938906] [DMG] ICR moving to [AddingComm]
[1687268083831] [71452:11938906] [DMG] ICR moving to [AddedComma]
[1687268083831] [71452:11938906] [EM] <<< [E:7118i S:63495 M:196832942] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1687268083831] [71452:11938906] [IN] (S) Sending msg 196832942 on secure session with LSID: 63495
[1687268083831] [71452:11938906] [DMG] ICR moving to [CommandSen]
[1687268083831] [71452:11938906] [DMG] ICR moving to [AwaitingDe]
[1687268083832] [71452:11938906] [EM] <<< [E:7117i S:63495 M:196832943 (Ack:117603835)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1687268083832] [71452:11938906] [IN] (S) Sending msg 196832943 on secure session with LSID: 63495
[1687268083832] [71452:11938906] [EM] Flushed pending ack for MessageCounter:117603835 on exchange 7117i
[1687268084315] [71452:11938907] [EM] >>> [E:7118i S:63495 M:117603836 (Ack:196832942)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1687268084315] [71452:11938907] [EM] Found matching exchange: 7118i, Delegate: 0x12ee04458
[1687268084315] [71452:11938907] [EM] Rxd Ack; Removing MessageCounter:196832942 from Retrans Table on exchange 7118i
[1687268084315] [71452:11938907] [DMG] ICR moving to [ResponseRe]
[1687268084315] [71452:11938907] [DMG] InvokeResponseMessage =
[1687268084315] [71452:11938907] [DMG] {
[1687268084315] [71452:11938907] [DMG] 	suppressResponse = false, 
[1687268084315] [71452:11938907] [DMG] 	InvokeResponseIBs =
[1687268084316] [71452:11938907] [DMG] 	[
[1687268084316] [71452:11938907] [DMG] 		InvokeResponseIB =
[1687268084316] [71452:11938907] [DMG] 		{
[1687268084316] [71452:11938907] [DMG] 			CommandDataIB =
[1687268084316] [71452:11938907] [DMG] 			{
[1687268084316] [71452:11938907] [DMG] 				CommandPathIB =
[1687268084316] [71452:11938907] [DMG] 				{
[1687268084316] [71452:11938907] [DMG] 					EndpointId = 0x0,
[1687268084316] [71452:11938907] [DMG] 					ClusterId = 0x3e,
[1687268084316] [71452:11938907] [DMG] 					CommandId = 0x3,
[1687268084316] [71452:11938907] [DMG] 				},
[1687268084316] [71452:11938907] [DMG] 				
[1687268084316] [71452:11938907] [DMG] 				CommandFields = 
[1687268084316] [71452:11938907] [DMG] 				{
[1687268084316] [71452:11938907] [DMG] 					0x0 = [
[1687268084316] [71452:11938907] [DMG] 							0x30, 0x82, 0x01, 0xcb, 0x30, 0x82, 0x01, 0x71, 0xa0, 0x03, 0x02, 0x01, 0x02, 0x02, 0x08, 0x56, 0xad, 0x82, 0x22, 0xad, 0x94, 0x5b, 0x64, 0x30, 0x0a, 0x06, 0x08, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x04, 0x03, 0x02, 0x30, 0x30, 0x31, 0x18, 0x30, 0x16, 0x06, 0x03, 0x55, 0x04, 0x03, 0x0c, 0x0f, 0x4d, 0x61, 0x74, 0x74, 0x65, 0x72, 0x20, 0x54, 0x65, 0x73, 0x74, 0x20, 0x50, 0x41, 0x41, 0x31, 0x14, 0x30, 0x12, 0x06, 0x0a, 0x2b, 0x06, 0x01, 0x04, 0x01, 0x82, 0xa2, 0x7c, 0x02, 0x01, 0x0c, 0x04, 0x46, 0x46, 0x46, 0x31, 0x30, 0x20, 0x17, 0x0d, 0x32, 0x32, 0x30, 0x32, 0x30, 0x35, 0x30, 0x30, 0x30, 0x30, 0x30, 0x30, 0x5a, 0x18, 0x0f, 0x39, 0x39, 0x39, 0x39, 0x31, 0x32, 0x33, 0x31, 0x32, 0x33, 0x35, 0x39, 0x35, 0x39, 0x5a, 0x30, 0x3d, 0x31, 0x25, 0x30, 0x23, 0x06, 0x03, 0x55, 0x04, 0x03, 0x0c, 0x1c, 0x4d, 0x61, 0x74, 0x74, 0x65, 0x72, 0x20, 0x44, 0x65, 0x76, 0x20, 0x50, 0x41, 0x49, 0x20, 0x30, 0x78, 0x46, 0x46, 0x46, 0x31, 0x20, 0x6e, 0x6f, 0x20, 0x50, 0x49, 0x44, 0x31, 0x14, 0x30, 0x12, 0x06, 0x0a, 0x2b, 0x06, 0x01, 0x04, 0x01, 0x82, 0xa2, 0x7c, 0x02, 0x01, 0x0c, 0x04, 0x46, 0x46, 0x46, 0x31, 0x30, 0x59, 0x30, 0x13, 0x06, 0x07, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x02, 0x01, 0x06, 0x08, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x03, 0x01, 0x07, 0x03, 0x42, 0x00, 0x04, 0x41, 0x9a, 0x93, 0x15, 0xc2, 0x17, 0x3e, 0x0c, 0x8c, 0x87, 0x6d, 0x03, 0xcc, 0xfc, 0x94, 0x48, 0x52, 0x64, 0x7f, 0x7f, 0xec, 0x5e, 0x50, 0x82, 0xf4, 0x05, 0x99, 0x28, 0xec, 0xa8, 0x94, 0xc5, 0x94, 0x15, 0x13, 0x09, 0xac, 0x63, 0x1e, 0x4c, 0xb0, 0x33, 0x92, 0xaf, 0x68, 0x4b, 0x0b, 0xaf, 0xb7, 0xe6, 0x5b, 0x3b, 0x81, 0x62, 0xc2, 0xf5, 0x2b, 0xf9, 0x31, 0xb8, 0xe7, 0x7a, 0xaa, 0x82, 0xa3, 0x66, 0x30, 0x64,
[1687268084316] [71452:11938907] [DMG] 					] (463 bytes)
[1687268084316] [71452:11938907] [DMG] 				},
[1687268084316] [71452:11938907] [DMG] 			},
[1687268084316] [71452:11938907] [DMG] 			
[1687268084316] [71452:11938907] [DMG] 		},
[1687268084316] [71452:11938907] [DMG] 		
[1687268084316] [71452:11938907] [DMG] 	],
[1687268084316] [71452:11938907] [DMG] 	
[1687268084316] [71452:11938907] [DMG] 	InteractionModelRevision = 1
[1687268084316] [71452:11938907] [DMG] },
[1687268084316] [71452:11938907] [DMG] Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0003
[1687268084316] [71452:11938907] [CTL] Received certificate chain from the device
[1687268084316] [71452:11938907] [CTL] Successfully finished commissioning step 'SendPAICertificateRequest'
[1687268084316] [71452:11938907] [CTL] Commissioning stage next step: 'SendPAICertificateRequest' -> 'SendDACCertificateRequest'
[1687268084317] [71452:11938907] [CTL] Performing next commissioning step 'SendDACCertificateRequest'
[1687268084317] [71452:11938907] [CTL] Sending request for DAC certificate
[1687268084317] [71452:11938907] [CTL] Sending Certificate Chain request to 0x12f009200 device
[1687268084317] [71452:11938907] [DMG] ICR moving to [AddingComm]
[1687268084317] [71452:11938907] [DMG] ICR moving to [AddedComma]
[1687268084317] [71452:11938907] [EM] <<< [E:7119i S:63495 M:196832944] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1687268084317] [71452:11938907] [IN] (S) Sending msg 196832944 on secure session with LSID: 63495
[1687268084317] [71452:11938907] [DMG] ICR moving to [CommandSen]
[1687268084317] [71452:11938907] [DMG] ICR moving to [AwaitingDe]
[1687268084317] [71452:11938907] [EM] <<< [E:7118i S:63495 M:196832945 (Ack:117603836)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1687268084317] [71452:11938907] [IN] (S) Sending msg 196832945 on secure session with LSID: 63495
[1687268084318] [71452:11938907] [EM] Flushed pending ack for MessageCounter:117603836 on exchange 7118i
[1687268084832] [71452:11938906] [EM] >>> [E:7119i S:63495 M:117603837 (Ack:196832944)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1687268084832] [71452:11938906] [EM] Found matching exchange: 7119i, Delegate: 0x12ee041c8
[1687268084832] [71452:11938906] [EM] Rxd Ack; Removing MessageCounter:196832944 from Retrans Table on exchange 7119i
[1687268084832] [71452:11938906] [DMG] ICR moving to [ResponseRe]
[1687268084832] [71452:11938906] [DMG] InvokeResponseMessage =
[1687268084832] [71452:11938906] [DMG] {
[1687268084832] [71452:11938906] [DMG] 	suppressResponse = false, 
[1687268084832] [71452:11938906] [DMG] 	InvokeResponseIBs =
[1687268084832] [71452:11938906] [DMG] 	[
[1687268084832] [71452:11938906] [DMG] 		InvokeResponseIB =
[1687268084832] [71452:11938906] [DMG] 		{
[1687268084832] [71452:11938906] [DMG] 			CommandDataIB =
[1687268084832] [71452:11938906] [DMG] 			{
[1687268084832] [71452:11938906] [DMG] 				CommandPathIB =
[1687268084832] [71452:11938906] [DMG] 				{
[1687268084832] [71452:11938906] [DMG] 					EndpointId = 0x0,
[1687268084832] [71452:11938906] [DMG] 					ClusterId = 0x3e,
[1687268084832] [71452:11938906] [DMG] 					CommandId = 0x3,
[1687268084832] [71452:11938906] [DMG] 				},
[1687268084832] [71452:11938906] [DMG] 				
[1687268084832] [71452:11938906] [DMG] 				CommandFields = 
[1687268084832] [71452:11938906] [DMG] 				{
[1687268084832] [71452:11938906] [DMG] 					0x0 = [
[1687268084832] [71452:11938906] [DMG] 							0x30, 0x82, 0x01, 0xe8, 0x30, 0x82, 0x01, 0x8e, 0xa0, 0x03, 0x02, 0x01, 0x02, 0x02, 0x08, 0x6f, 0xdc, 0xb6, 0xed, 0x06, 0xf3, 0x58, 0xf9, 0x30, 0x0a, 0x06, 0x08, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x04, 0x03, 0x02, 0x30, 0x3d, 0x31, 0x25, 0x30, 0x23, 0x06, 0x03, 0x55, 0x04, 0x03, 0x0c, 0x1c, 0x4d, 0x61, 0x74, 0x74, 0x65, 0x72, 0x20, 0x44, 0x65, 0x76, 0x20, 0x50, 0x41, 0x49, 0x20, 0x30, 0x78, 0x46, 0x46, 0x46, 0x31, 0x20, 0x6e, 0x6f, 0x20, 0x50, 0x49, 0x44, 0x31, 0x14, 0x30, 0x12, 0x06, 0x0a, 0x2b, 0x06, 0x01, 0x04, 0x01, 0x82, 0xa2, 0x7c, 0x02, 0x01, 0x0c, 0x04, 0x46, 0x46, 0x46, 0x31, 0x30, 0x20, 0x17, 0x0d, 0x32, 0x32, 0x30, 0x32, 0x30, 0x35, 0x30, 0x30, 0x30, 0x30, 0x30, 0x30, 0x5a, 0x18, 0x0f, 0x39, 0x39, 0x39, 0x39, 0x31, 0x32, 0x33, 0x31, 0x32, 0x33, 0x35, 0x39, 0x35, 0x39, 0x5a, 0x30, 0x53, 0x31, 0x25, 0x30, 0x23, 0x06, 0x03, 0x55, 0x04, 0x03, 0x0c, 0x1c, 0x4d, 0x61, 0x74, 0x74, 0x65, 0x72, 0x20, 0x44, 0x65, 0x76, 0x20, 0x44, 0x41, 0x43, 0x20, 0x30, 0x78, 0x46, 0x46, 0x46, 0x31, 0x2f, 0x30, 0x78, 0x38, 0x30, 0x30, 0x35, 0x31, 0x14, 0x30, 0x12, 0x06, 0x0a, 0x2b, 0x06, 0x01, 0x04, 0x01, 0x82, 0xa2, 0x7c, 0x02, 0x01, 0x0c, 0x04, 0x46, 0x46, 0x46, 0x31, 0x31, 0x14, 0x30, 0x12, 0x06, 0x0a, 0x2b, 0x06, 0x01, 0x04, 0x01, 0x82, 0xa2, 0x7c, 0x02, 0x02, 0x0c, 0x04, 0x38, 0x30, 0x30, 0x35, 0x30, 0x59, 0x30, 0x13, 0x06, 0x07, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x02, 0x01, 0x06, 0x08, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x03, 0x01, 0x07, 0x03, 0x42, 0x00, 0x04, 0x7e, 0xf2, 0xf1, 0x08, 0x2b, 0x2a, 0x56, 0x4a, 0x05, 0x44, 0xc0, 0xa6, 0x13, 0xd2, 0x1b, 0x15, 0x75, 0x00, 0x55, 0x2d, 0x03, 0x5f, 0x23, 0x02, 0x25, 0x2f, 0xce, 0xe8, 0x1d, 0x6e, 0xc6, 0x74, 0x17,
[1687268084832] [71452:11938906] [DMG] 					] (492 bytes)
[1687268084832] [71452:11938906] [DMG] 				},
[1687268084832] [71452:11938906] [DMG] 			},
[1687268084832] [71452:11938906] [DMG] 			
[1687268084832] [71452:11938906] [DMG] 		},
[1687268084832] [71452:11938906] [DMG] 		
[1687268084833] [71452:11938906] [DMG] 	],
[1687268084833] [71452:11938906] [DMG] 	
[1687268084833] [71452:11938906] [DMG] 	InteractionModelRevision = 1
[1687268084833] [71452:11938906] [DMG] },
[1687268084833] [71452:11938906] [DMG] Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0003
[1687268084833] [71452:11938906] [CTL] Received certificate chain from the device
[1687268084833] [71452:11938906] [CTL] Successfully finished commissioning step 'SendDACCertificateRequest'
[1687268084833] [71452:11938906] [CTL] Commissioning stage next step: 'SendDACCertificateRequest' -> 'SendAttestationRequest'
[1687268084833] [71452:11938906] [CTL] Performing next commissioning step 'SendAttestationRequest'
[1687268084833] [71452:11938906] [CTL] Sending Attestation Request to the device.
[1687268084833] [71452:11938906] [CTL] Sending Attestation request to 0x12f009200 device
[1687268084833] [71452:11938906] [DMG] ICR moving to [AddingComm]
[1687268084833] [71452:11938906] [DMG] ICR moving to [AddedComma]
[1687268084833] [71452:11938906] [EM] <<< [E:7120i S:63495 M:196832946] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1687268084833] [71452:11938906] [IN] (S) Sending msg 196832946 on secure session with LSID: 63495
[1687268084834] [71452:11938906] [DMG] ICR moving to [CommandSen]
[1687268084834] [71452:11938906] [CTL] Sent Attestation request, waiting for the Attestation Information
[1687268084834] [71452:11938906] [DMG] ICR moving to [AwaitingDe]
[1687268084834] [71452:11938906] [EM] <<< [E:7119i S:63495 M:196832947 (Ack:117603837)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1687268084834] [71452:11938906] [IN] (S) Sending msg 196832947 on secure session with LSID: 63495
[1687268084834] [71452:11938906] [EM] Flushed pending ack for MessageCounter:117603837 on exchange 7119i
[1687268085961] [71452:11938906] [EM] Retransmitting MessageCounter:196832946 on exchange 7120i Send Cnt 1
[1687268085962] [71452:11938906] [IN] (S) Sending msg 196832946 on secure session with LSID: 63495
[1687268086131] [71452:11938907] [EM] >>> [E:7120i S:63495 M:117603838 (Ack:196832946)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1687268086131] [71452:11938907] [EM] Found matching exchange: 7120i, Delegate: 0x139104278
[1687268086131] [71452:11938907] [EM] Rxd Ack; Removing MessageCounter:196832946 from Retrans Table on exchange 7120i
[1687268086132] [71452:11938907] [EM] >>> [E:7120i S:63495 M:117603839 (Ack:196832946)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1687268086132] [71452:11938907] [EM] Found matching exchange: 7120i, Delegate: 0x139104278
[1687268086132] [71452:11938907] [EM] CHIP MessageCounter:196832946 not in RetransTable on exchange 7120i
[1687268086132] [71452:11938907] [DMG] ICR moving to [ResponseRe]
[1687268086132] [71452:11938907] [DMG] InvokeResponseMessage =
[1687268086132] [71452:11938907] [DMG] {
[1687268086132] [71452:11938907] [DMG] 	suppressResponse = false, 
[1687268086132] [71452:11938907] [DMG] 	InvokeResponseIBs =
[1687268086132] [71452:11938907] [DMG] 	[
[1687268086132] [71452:11938907] [DMG] 		InvokeResponseIB =
[1687268086132] [71452:11938907] [DMG] 		{
[1687268086132] [71452:11938907] [DMG] 			CommandDataIB =
[1687268086132] [71452:11938907] [DMG] 			{
[1687268086132] [71452:11938907] [DMG] 				CommandPathIB =
[1687268086132] [71452:11938907] [DMG] 				{
[1687268086132] [71452:11938907] [DMG] 					EndpointId = 0x0,
[1687268086132] [71452:11938907] [DMG] 					ClusterId = 0x3e,
[1687268086132] [71452:11938907] [DMG] 					CommandId = 0x1,
[1687268086132] [71452:11938907] [DMG] 				},
[1687268086132] [71452:11938907] [DMG] 				
[1687268086132] [71452:11938907] [DMG] 				CommandFields = 
[1687268086132] [71452:11938907] [DMG] 				{
[1687268086132] [71452:11938907] [DMG] 					0x0 = [
[1687268086132] [71452:11938907] [DMG] 							0x15, 0x31, 0x01, 0x1b, 0x02, 0x30, 0x82, 0x02, 0x17, 0x06, 0x09, 0x2a, 0x86, 0x48, 0x86, 0xf7, 0x0d, 0x01, 0x07, 0x02, 0xa0, 0x82, 0x02, 0x08, 0x30, 0x82, 0x02, 0x04, 0x02, 0x01, 0x03, 0x31, 0x0d, 0x30, 0x0b, 0x06, 0x09, 0x60, 0x86, 0x48, 0x01, 0x65, 0x03, 0x04, 0x02, 0x01, 0x30, 0x82, 0x01, 0x70, 0x06, 0x09, 0x2a, 0x86, 0x48, 0x86, 0xf7, 0x0d, 0x01, 0x07, 0x01, 0xa0, 0x82, 0x01, 0x61, 0x04, 0x82, 0x01, 0x5d, 0x15, 0x24, 0x00, 0x01, 0x25, 0x01, 0xf1, 0xff, 0x36, 0x02, 0x05, 0x00, 0x80, 0x05, 0x01, 0x80, 0x05, 0x02, 0x80, 0x05, 0x03, 0x80, 0x05, 0x04, 0x80, 0x05, 0x05, 0x80, 0x05, 0x06, 0x80, 0x05, 0x07, 0x80, 0x05, 0x08, 0x80, 0x05, 0x09, 0x80, 0x05, 0x0a, 0x80, 0x05, 0x0b, 0x80, 0x05, 0x0c, 0x80, 0x05, 0x0d, 0x80, 0x05, 0x0e, 0x80, 0x05, 0x0f, 0x80, 0x05, 0x10, 0x80, 0x05, 0x11, 0x80, 0x05, 0x12, 0x80, 0x05, 0x13, 0x80, 0x05, 0x14, 0x80, 0x05, 0x15, 0x80, 0x05, 0x16, 0x80, 0x05, 0x17, 0x80, 0x05, 0x18, 0x80, 0x05, 0x19, 0x80, 0x05, 0x1a, 0x80, 0x05, 0x1b, 0x80, 0x05, 0x1c, 0x80, 0x05, 0x1d, 0x80, 0x05, 0x1e, 0x80, 0x05, 0x1f, 0x80, 0x05, 0x20, 0x80, 0x05, 0x21, 0x80, 0x05, 0x22, 0x80, 0x05, 0x23, 0x80, 0x05, 0x24, 0x80, 0x05, 0x25, 0x80, 0x05, 0x26, 0x80, 0x05, 0x27, 0x80, 0x05, 0x28, 0x80, 0x05, 0x29, 0x80, 0x05, 0x2a, 0x80, 0x05, 0x2b, 0x80, 0x05, 0x2c, 0x80, 0x05, 0x2d, 0x80, 0x05, 0x2e, 0x80, 0x05, 0x2f, 0x80, 0x05, 0x30, 0x80, 0x05, 0x31, 0x80, 0x05, 0x32, 0x80, 0x05, 0x33, 0x80, 0x05, 0x34, 0x80, 0x05, 0x35, 0x80, 0x05, 0x36, 0x80, 0x05, 0x37, 0x80, 0x05, 0x38, 0x80, 0x05, 0x39, 0x80, 0x05, 0x3a, 0x80, 0x05, 0x3b, 0x80, 0x05, 0x3c, 0x80, 0x05, 0x3d, 0x80, 0x05, 0x3e, 0x80, 0x05, 0x3f, 0x80, 0x05, 0x40, 0x80, 0x05, 0x41, 0x80,
[1687268086132] [71452:11938907] [DMG] 					] (583 bytes)
[1687268086132] [71452:11938907] [DMG] 					0x1 = [
[1687268086132] [71452:11938907] [DMG] 							0xb8, 0xca, 0x92, 0xf6, 0xb1, 0xdd, 0x38, 0xec, 0x11, 0x55, 0x96, 0x53, 0xc3, 0x43, 0x50, 0xce, 0xa0, 0x9c, 0x61, 0xdb, 0x1a, 0xca, 0x6e, 0x80, 0xba, 0x86, 0xf6, 0xc6, 0x13, 0x15, 0x2b, 0x99, 0x03, 0xd4, 0x35, 0x45, 0xc4, 0x83, 0x95, 0xa1, 0xfc, 0x7f, 0xe6, 0x23, 0x55, 0x70, 0x95, 0xc5, 0xd2, 0x58, 0x27, 0xd2, 0xdb, 0xf1, 0xdd, 0x13, 0x48, 0xfd, 0xf3, 0x0b, 0xda, 0x13, 0x7d, 0x73, 
[1687268086133] [71452:11938907] [DMG] 					] (64 bytes)
[1687268086133] [71452:11938907] [DMG] 				},
[1687268086133] [71452:11938907] [DMG] 			},
[1687268086133] [71452:11938907] [DMG] 			
[1687268086133] [71452:11938907] [DMG] 		},
[1687268086133] [71452:11938907] [DMG] 		
[1687268086133] [71452:11938907] [DMG] 	],
[1687268086133] [71452:11938907] [DMG] 	
[1687268086133] [71452:11938907] [DMG] 	InteractionModelRevision = 1
[1687268086133] [71452:11938907] [DMG] },
[1687268086133] [71452:11938907] [DMG] Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0001
[1687268086133] [71452:11938907] [CTL] Received Attestation Information from the device
[1687268086133] [71452:11938907] [CTL] Successfully finished commissioning step 'SendAttestationRequest'
[1687268086133] [71452:11938907] [CTL] AutoCommissioner setting attestationElements buffer size 583/583
[1687268086133] [71452:11938907] [CTL] Commissioning stage next step: 'SendAttestationRequest' -> 'AttestationVerification'
[1687268086133] [71452:11938907] [CTL] Performing next commissioning step 'AttestationVerification'
[1687268086133] [71452:11938907] [CTL] Verifying attestation
[1687268086163] [71452:11938907] [CTL] Successfully validated 'Attestation Information' command received from the device.
[1687268086163] [71452:11938907] [CTL] Successfully finished commissioning step 'AttestationVerification'
[1687268086163] [71452:11938907] [CTL] Commissioning stage next step: 'AttestationVerification' -> 'SendOpCertSigningRequest'
[1687268086163] [71452:11938907] [CTL] Performing next commissioning step 'SendOpCertSigningRequest'
[1687268086163] [71452:11938907] [CTL] Sending CSR request to 0x12f009200 device
[1687268086163] [71452:11938907] [DMG] ICR moving to [AddingComm]
[1687268086163] [71452:11938907] [DMG] ICR moving to [AddedComma]
[1687268086163] [71452:11938907] [EM] <<< [E:7121i S:63495 M:196832948] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1687268086163] [71452:11938907] [IN] (S) Sending msg 196832948 on secure session with LSID: 63495
[1687268086163] [71452:11938907] [DMG] ICR moving to [CommandSen]
[1687268086163] [71452:11938907] [CTL] Sent CSR request, waiting for the CSR
[1687268086164] [71452:11938907] [DMG] ICR moving to [AwaitingDe]
[1687268086164] [71452:11938907] [EM] <<< [E:7120i S:63495 M:196832949 (Ack:117603839)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1687268086164] [71452:11938907] [IN] (S) Sending msg 196832949 on secure session with LSID: 63495
[1687268086164] [71452:11938907] [EM] Flushed pending ack for MessageCounter:117603839 on exchange 7120i
[1687268086566] [71452:11938906] [EM] >>> [E:7120i S:63495 M:117603840 (Ack:196832946)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1687268086566] [71452:11938906] [EM] OnMessageReceived failed, err = src/messaging/ExchangeMgr.cpp:305: CHIP Error 0x00000070: Unsolicited msg with originator bit clear
[1687268086986] [71452:11938906] [IN] Received a duplicate message with MessageCounter:117603839 on exchange 7120i
[1687268086986] [71452:11938906] [EM] >>> [E:7120i S:63495 M:117603839 (Ack:196832946)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1687268086987] [71452:11938906] [EM] Generating StandaloneAck via exchange: 7120i
[1687268086987] [71452:11938906] [EM] Forcing tx of solitary ack for duplicate MessageCounter:117603839 on exchange 7120i
[1687268086987] [71452:11938906] [EM] <<< [E:7120i S:63495 M:196832950 (Ack:117603839)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1687268086987] [71452:11938906] [IN] (S) Sending msg 196832950 on secure session with LSID: 63495
[1687268087316] [71452:11938907] [EM] Retransmitting MessageCounter:196832948 on exchange 7121i Send Cnt 1
[1687268087316] [71452:11938907] [IN] (S) Sending msg 196832948 on secure session with LSID: 63495
[1687268087376] [71452:11938906] [EM] >>> [E:7121i S:63495 M:117603841 (Ack:196832948)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1687268087376] [71452:11938906] [EM] Found matching exchange: 7121i, Delegate: 0x13ee5a958
[1687268087376] [71452:11938906] [EM] Rxd Ack; Removing MessageCounter:196832948 from Retrans Table on exchange 7121i
[1687268087779] [71452:11938906] [EM] >>> [E:7121i S:63495 M:117603842 (Ack:196832948)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1687268087779] [71452:11938906] [EM] Found matching exchange: 7121i, Delegate: 0x13ee5a958
[1687268087779] [71452:11938906] [EM] CHIP MessageCounter:196832948 not in RetransTable on exchange 7121i
[1687268087779] [71452:11938906] [DMG] ICR moving to [ResponseRe]
[1687268087779] [71452:11938906] [DMG] InvokeResponseMessage =
[1687268087779] [71452:11938906] [DMG] {
[1687268087779] [71452:11938906] [DMG] 	suppressResponse = false, 
[1687268087779] [71452:11938906] [DMG] 	InvokeResponseIBs =
[1687268087779] [71452:11938906] [DMG] 	[
[1687268087779] [71452:11938906] [DMG] 		InvokeResponseIB =
[1687268087779] [71452:11938906] [DMG] 		{
[1687268087779] [71452:11938906] [DMG] 			CommandDataIB =
[1687268087779] [71452:11938906] [DMG] 			{
[1687268087779] [71452:11938906] [DMG] 				CommandPathIB =
[1687268087779] [71452:11938906] [DMG] 				{
[1687268087779] [71452:11938906] [DMG] 					EndpointId = 0x0,
[1687268087779] [71452:11938906] [DMG] 					ClusterId = 0x3e,
[1687268087779] [71452:11938906] [DMG] 					CommandId = 0x5,
[1687268087779] [71452:11938906] [DMG] 				},
[1687268087779] [71452:11938906] [DMG] 				
[1687268087779] [71452:11938906] [DMG] 				CommandFields = 
[1687268087779] [71452:11938906] [DMG] 				{
[1687268087779] [71452:11938906] [DMG] 					0x0 = [
[1687268087779] [71452:11938906] [DMG] 							0x15, 0x30, 0x01, 0xcd, 0x30, 0x81, 0xca, 0x30, 0x70, 0x02, 0x01, 0x00, 0x30, 0x0e, 0x31, 0x0c, 0x30, 0x0a, 0x06, 0x03, 0x55, 0x04, 0x0a, 0x0c, 0x03, 0x43, 0x53, 0x52, 0x30, 0x59, 0x30, 0x13, 0x06, 0x07, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x02, 0x01, 0x06, 0x08, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x03, 0x01, 0x07, 0x03, 0x42, 0x00, 0x04, 0x90, 0x55, 0xb8, 0x1b, 0x82, 0xe7, 0xd4, 0x26, 0x5e, 0x07, 0xaa, 0x71, 0x83, 0xe3, 0x00, 0xcd, 0x2c, 0xf7, 0xbb, 0x21, 0x9c, 0x03, 0x71, 0x25, 0xce, 0x05, 0x66, 0x43, 0xe4, 0x6c, 0x13, 0x55, 0x0a, 0x26, 0x1b, 0x51, 0x10, 0x29, 0x54, 0xd7, 0xee, 0xab, 0x50, 0xc2, 0xa3, 0xfe, 0xb0, 0xfc, 0x21, 0xb1, 0x38, 0xd5, 0x59, 0x94, 0xc9, 0x69, 0xb8, 0x9b, 0x6d, 0x55, 0x43, 0x2e, 0x96, 0xee, 0xa0, 0x00, 0x30, 0x0c, 0x06, 0x08, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x04, 0x03, 0x02, 0x05, 0x00, 0x03, 0x48, 0x00, 0x30, 0x45, 0x02, 0x21, 0x00, 0xab, 0xbd, 0x6b, 0x72, 0xed, 0xdf, 0xd0, 0x7f, 0xd8, 0x99, 0xa4, 0xef, 0x05, 0x08, 0x51, 0xf4, 0xce, 0xd2, 0x87, 0x53, 0x04, 0xc7, 0x3f, 0x57, 0xe3, 0x64, 0xaf, 0xef, 0x5b, 0xa1, 0xa7, 0x26, 0x02, 0x20, 0x4f, 0xd3, 0x51, 0xc6, 0xbc, 0xf8, 0xc8, 0x6a, 0xfc, 0xd6, 0xa8, 0xef, 0x08, 0xab, 0x6c, 0x9a, 0x73, 0x47, 0xc8, 0x52, 0xf8, 0xdf, 0xc0, 0x77, 0x40, 0x8e, 0x74, 0xd2, 0xe4, 0xd6, 0x7e, 0x63, 0x30, 0x02, 0x20, 0x95, 0x34, 0x63, 0x96, 0x40, 0x47, 0xdc, 0xfd, 0xec, 0x8d, 0xd3, 0xd4, 0x7c, 0x0e, 0xa3, 0xef, 0xf4, 0xe2, 0x12, 0x8f, 0xaf, 0x9d, 0x5b, 0x2b, 0x44, 0xec, 0x48, 0x44, 0xd0, 0x70, 0xe0, 0x14, 0x18, 
[1687268087779] [71452:11938906] [DMG] 					] (245 bytes)
[1687268087779] [71452:11938906] [DMG] 					0x1 = [
[1687268087779] [71452:11938906] [DMG] 							0xeb, 0xde, 0xb2, 0xf6, 0x53, 0x5a, 0xe1, 0x1f, 0x7d, 0x72, 0xd2, 0x89, 0x28, 0x34, 0x45, 0x69, 0xb5, 0x85, 0xb9, 0x11, 0x21, 0x90, 0x4b, 0xf9, 0x18, 0xf9, 0x45, 0x0a, 0xe3, 0x8f, 0xe4, 0xd1, 0x50, 0x1f, 0x5c, 0x22, 0x8e, 0x6f, 0xc3, 0xed, 0xd2, 0xca, 0x49, 0xe8, 0x66, 0x1b, 0x00, 0xf6, 0xf0, 0x7f, 0xb4, 0x1f, 0x77, 0x0d, 0x2f, 0x29, 0x88, 0x53, 0x18, 0x55, 0xa7, 0x6c, 0xcc, 0x46, 
[1687268087779] [71452:11938906] [DMG] 					] (64 bytes)
[1687268087779] [71452:11938906] [DMG] 				},
[1687268087779] [71452:11938906] [DMG] 			},
[1687268087779] [71452:11938906] [DMG] 			
[1687268087779] [71452:11938906] [DMG] 		},
[1687268087779] [71452:11938906] [DMG] 		
[1687268087779] [71452:11938906] [DMG] 	],
[1687268087779] [71452:11938906] [DMG] 	
[1687268087779] [71452:11938906] [DMG] 	InteractionModelRevision = 1
[1687268087779] [71452:11938906] [DMG] },
[1687268087780] [71452:11938906] [DMG] Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0005
[1687268087780] [71452:11938906] [CTL] Received certificate signing request from the device
[1687268087780] [71452:11938906] [CTL] Successfully finished commissioning step 'SendOpCertSigningRequest'
[1687268087780] [71452:11938906] [CTL] Commissioning stage next step: 'SendOpCertSigningRequest' -> 'ValidateCSR'
[1687268087780] [71452:11938906] [CTL] Performing next commissioning step 'ValidateCSR'
[1687268087790] [71452:11938906] [CTL] Successfully finished commissioning step 'ValidateCSR'
[1687268087790] [71452:11938906] [CTL] Commissioning stage next step: 'ValidateCSR' -> 'GenerateNOCChain'
[1687268087790] [71452:11938906] [CTL] Performing next commissioning step 'GenerateNOCChain'
[1687268087790] [71452:11938906] [CTL] Getting certificate chain for the device from the issuer
[1687268087791] [71452:11938906] [CTL] Verifying Certificate Signing Request
[1687268087797] [71452:11938906] [CTL] Generating NOC
[1687268087799] [71452:11938906] [CTL] Providing certificate chain to the commissioner
[1687268087799] [71452:11938906] [CTL] Received callback from the CA for NOC Chain generation. Status src/controller/ExampleOperationalCredentialsIssuer.cpp:396: Success
[1687268087799] [71452:11938906] [CTL] Successfully finished commissioning step 'GenerateNOCChain'
[1687268087799] [71452:11938906] [CTL] Performing next commissioning step 'SendTrustedRootCert'
[1687268087799] [71452:11938906] [CTL] Sending root certificate to the device
[1687268087799] [71452:11938906] [DMG] ICR moving to [AddingComm]
[1687268087799] [71452:11938906] [DMG] ICR moving to [AddedComma]
[1687268087799] [71452:11938906] [EM] <<< [E:7122i S:63495 M:196832951] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1687268087799] [71452:11938906] [IN] (S) Sending msg 196832951 on secure session with LSID: 63495
[1687268087800] [71452:11938906] [DMG] ICR moving to [CommandSen]
[1687268087800] [71452:11938906] [CTL] Sent root certificate to the device
[1687268087800] [71452:11938906] [DMG] ICR moving to [AwaitingDe]
[1687268087800] [71452:11938906] [EM] <<< [E:7121i S:63495 M:196832952 (Ack:117603842)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1687268087800] [71452:11938906] [IN] (S) Sending msg 196832952 on secure session with LSID: 63495
[1687268087800] [71452:11938906] [EM] Flushed pending ack for MessageCounter:117603842 on exchange 7121i
[1687268088421] [71452:11938907] [EM] >>> [E:7121i S:63495 M:117603843 (Ack:196832948)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1687268088421] [71452:11938907] [EM] OnMessageReceived failed, err = src/messaging/ExchangeMgr.cpp:305: CHIP Error 0x00000070: Unsolicited msg with originator bit clear
[1687268088422] [71452:11938907] [EM] >>> [E:7122i S:63495 M:117603844 (Ack:196832951)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1687268088422] [71452:11938907] [EM] Found matching exchange: 7122i, Delegate: 0x13ef05c68
[1687268088422] [71452:11938907] [EM] Rxd Ack; Removing MessageCounter:196832951 from Retrans Table on exchange 7122i
[1687268088726] [71452:11938907] [EM] >>> [E:7122i S:63495 M:117603845 (Ack:196832951)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1687268088726] [71452:11938907] [EM] Found matching exchange: 7122i, Delegate: 0x13ef05c68
[1687268088726] [71452:11938907] [EM] CHIP MessageCounter:196832951 not in RetransTable on exchange 7122i
[1687268088726] [71452:11938907] [DMG] ICR moving to [ResponseRe]
[1687268088726] [71452:11938907] [DMG] InvokeResponseMessage =
[1687268088726] [71452:11938907] [DMG] {
[1687268088726] [71452:11938907] [DMG] 	suppressResponse = false, 
[1687268088726] [71452:11938907] [DMG] 	InvokeResponseIBs =
[1687268088726] [71452:11938907] [DMG] 	[
[1687268088726] [71452:11938907] [DMG] 		InvokeResponseIB =
[1687268088726] [71452:11938907] [DMG] 		{
[1687268088726] [71452:11938907] [DMG] 			CommandStatusIB =
[1687268088726] [71452:11938907] [DMG] 			{
[1687268088726] [71452:11938907] [DMG] 				CommandPathIB =
[1687268088726] [71452:11938907] [DMG] 				{
[1687268088726] [71452:11938907] [DMG] 					EndpointId = 0x0,
[1687268088726] [71452:11938907] [DMG] 					ClusterId = 0x3e,
[1687268088726] [71452:11938907] [DMG] 					CommandId = 0xb,
[1687268088726] [71452:11938907] [DMG] 				},
[1687268088726] [71452:11938907] [DMG] 				
[1687268088726] [71452:11938907] [DMG] 				StatusIB =
[1687268088726] [71452:11938907] [DMG] 				{
[1687268088727] [71452:11938907] [DMG] 					status = 0x00 (SUCCESS),
[1687268088727] [71452:11938907] [DMG] 				},
[1687268088727] [71452:11938907] [DMG] 				
[1687268088727] [71452:11938907] [DMG] 			},
[1687268088727] [71452:11938907] [DMG] 			
[1687268088727] [71452:11938907] [DMG] 		},
[1687268088727] [71452:11938907] [DMG] 		
[1687268088727] [71452:11938907] [DMG] 	],
[1687268088727] [71452:11938907] [DMG] 	
[1687268088727] [71452:11938907] [DMG] 	InteractionModelRevision = 1
[1687268088727] [71452:11938907] [DMG] },
[1687268088727] [71452:11938907] [DMG] Received Command Response Status for Endpoint=0 Cluster=0x0000_003E Command=0x0000_000B Status=0x0
[1687268088727] [71452:11938907] [CTL] Device confirmed that it has received the root certificate
[1687268088727] [71452:11938907] [CTL] Successfully finished commissioning step 'SendTrustedRootCert'
[1687268088727] [71452:11938907] [CTL] Commissioning stage next step: 'SendTrustedRootCert' -> 'SendNOC'
[1687268088727] [71452:11938907] [CTL] Performing next commissioning step 'SendNOC'
[1687268088727] [71452:11938907] [DMG] ICR moving to [AddingComm]
[1687268088727] [71452:11938907] [DMG] ICR moving to [AddedComma]
[1687268088728] [71452:11938907] [EM] <<< [E:7123i S:63495 M:196832953] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1687268088728] [71452:11938907] [IN] (S) Sending msg 196832953 on secure session with LSID: 63495
[1687268088729] [71452:11938907] [DMG] ICR moving to [CommandSen]
[1687268088729] [71452:11938907] [CTL] Sent operational certificate to the device
[1687268088729] [71452:11938907] [DMG] ICR moving to [AwaitingDe]
[1687268088729] [71452:11938907] [EM] <<< [E:7122i S:63495 M:196832954 (Ack:117603845)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1687268088729] [71452:11938907] [IN] (S) Sending msg 196832954 on secure session with LSID: 63495
[1687268088729] [71452:11938907] [EM] Flushed pending ack for MessageCounter:117603845 on exchange 7122i
[1687268089366] [71452:11938907] [EM] >>> [E:7123i S:63495 M:117603846 (Ack:196832953)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1687268089366] [71452:11938907] [EM] Found matching exchange: 7123i, Delegate: 0x12ee041c8
[1687268089366] [71452:11938907] [EM] Rxd Ack; Removing MessageCounter:196832953 from Retrans Table on exchange 7123i
[1687268089366] [71452:11938907] [EM] >>> [E:7123i S:63495 M:117603847 (Ack:196832953)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1687268089366] [71452:11938907] [EM] Found matching exchange: 7123i, Delegate: 0x12ee041c8
[1687268089366] [71452:11938907] [EM] CHIP MessageCounter:196832953 not in RetransTable on exchange 7123i
[1687268089367] [71452:11938907] [DMG] ICR moving to [ResponseRe]
[1687268089367] [71452:11938907] [DMG] InvokeResponseMessage =
[1687268089367] [71452:11938907] [DMG] {
[1687268089367] [71452:11938907] [DMG] 	suppressResponse = false, 
[1687268089367] [71452:11938907] [DMG] 	InvokeResponseIBs =
[1687268089367] [71452:11938907] [DMG] 	[
[1687268089367] [71452:11938907] [DMG] 		InvokeResponseIB =
[1687268089367] [71452:11938907] [DMG] 		{
[1687268089367] [71452:11938907] [DMG] 			CommandDataIB =
[1687268089367] [71452:11938907] [DMG] 			{
[1687268089367] [71452:11938907] [DMG] 				CommandPathIB =
[1687268089367] [71452:11938907] [DMG] 				{
[1687268089367] [71452:11938907] [DMG] 					EndpointId = 0x0,
[1687268089367] [71452:11938907] [DMG] 					ClusterId = 0x3e,
[1687268089367] [71452:11938907] [DMG] 					CommandId = 0x8,
[1687268089367] [71452:11938907] [DMG] 				},
[1687268089367] [71452:11938907] [DMG] 				
[1687268089367] [71452:11938907] [DMG] 				CommandFields = 
[1687268089367] [71452:11938907] [DMG] 				{
[1687268089367] [71452:11938907] [DMG] 					0x0 = 9, 
[1687268089367] [71452:11938907] [DMG] 				},
[1687268089367] [71452:11938907] [DMG] 			},
[1687268089367] [71452:11938907] [DMG] 			
[1687268089367] [71452:11938907] [DMG] 		},
[1687268089367] [71452:11938907] [DMG] 		
[1687268089367] [71452:11938907] [DMG] 	],
[1687268089367] [71452:11938907] [DMG] 	
[1687268089367] [71452:11938907] [DMG] 	InteractionModelRevision = 1
[1687268089367] [71452:11938907] [DMG] },
[1687268089367] [71452:11938907] [DMG] Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0008
[1687268089367] [71452:11938907] [CTL] Device returned status 9 on receiving the NOC
[1687268089367] [71452:11938907] [CTL] Add NOC failed with error src/controller/CHIPDeviceController.cpp:1455: CHIP Error 0x0000007E: Trying to add a NOC for a fabric that already exists
[1687268089367] [71452:11938907] [CTL] Error on commissioning step 'SendNOC': 'src/controller/CHIPDeviceController.cpp:1455: CHIP Error 0x0000007E: Trying to add a NOC for a fabric that already exists'
[1687268089367] [71452:11938907] [CTL] Failed to perform commissioning step 13
[1687268089367] [71452:11938907] [CTL] Going from commissioning step 'SendNOC' with lastErr = 'src/controller/CHIPDeviceController.cpp:1455: CHIP Error 0x0000007E: Trying to add a NOC for a fabric that already exists' -> 'Cleanup'
[1687268089367] [71452:11938907] [CTL] Performing next commissioning step 'Cleanup' with completion status = 'src/controller/CHIPDeviceController.cpp:1455: CHIP Error 0x0000007E: Trying to add a NOC for a fabric that already exists'
[1687268089367] [71452:11938907] [CTL] Expiring failsafe on proxy 0x12f009200
[1687268089367] [71452:11938907] [DMG] ICR moving to [AddingComm]
[1687268089367] [71452:11938907] [DMG] ICR moving to [AddedComma]
[1687268089367] [71452:11938907] [EM] <<< [E:7124i S:63495 M:196832955] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1687268089367] [71452:11938907] [IN] (S) Sending msg 196832955 on secure session with LSID: 63495
[1687268089368] [71452:11938907] [DMG] ICR moving to [CommandSen]
[1687268089368] [71452:11938907] [DMG] ICR moving to [AwaitingDe]
[1687268089368] [71452:11938907] [EM] <<< [E:7123i S:63495 M:196832956 (Ack:117603847)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1687268089368] [71452:11938907] [IN] (S) Sending msg 196832956 on secure session with LSID: 63495
[1687268089368] [71452:11938907] [EM] Flushed pending ack for MessageCounter:117603847 on exchange 7123i
[1687268089744] [71452:11938907] [EM] >>> [E:7124i S:63495 M:117603848 (Ack:196832955)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1687268089744] [71452:11938907] [EM] Found matching exchange: 7124i, Delegate: 0x139004088
[1687268089744] [71452:11938907] [EM] Rxd Ack; Removing MessageCounter:196832955 from Retrans Table on exchange 7124i
[1687268089745] [71452:11938907] [DMG] ICR moving to [ResponseRe]
[1687268089745] [71452:11938907] [DMG] InvokeResponseMessage =
[1687268089745] [71452:11938907] [DMG] {
[1687268089745] [71452:11938907] [DMG] 	suppressResponse = false, 
[1687268089745] [71452:11938907] [DMG] 	InvokeResponseIBs =
[1687268089745] [71452:11938907] [DMG] 	[
[1687268089745] [71452:11938907] [DMG] 		InvokeResponseIB =
[1687268089745] [71452:11938907] [DMG] 		{
[1687268089745] [71452:11938907] [DMG] 			CommandDataIB =
[1687268089745] [71452:11938907] [DMG] 			{
[1687268089745] [71452:11938907] [DMG] 				CommandPathIB =
[1687268089745] [71452:11938907] [DMG] 				{
[1687268089745] [71452:11938907] [DMG] 					EndpointId = 0x0,
[1687268089745] [71452:11938907] [DMG] 					ClusterId = 0x30,
[1687268089745] [71452:11938907] [DMG] 					CommandId = 0x1,
[1687268089745] [71452:11938907] [DMG] 				},
[1687268089745] [71452:11938907] [DMG] 				
[1687268089745] [71452:11938907] [DMG] 				CommandFields = 
[1687268089745] [71452:11938907] [DMG] 				{
[1687268089745] [71452:11938907] [DMG] 					0x0 = 0, 
[1687268089745] [71452:11938907] [DMG] 					0x1 = "" (0 chars), 
[1687268089745] [71452:11938907] [DMG] 				},
[1687268089745] [71452:11938907] [DMG] 			},
[1687268089745] [71452:11938907] [DMG] 			
[1687268089745] [71452:11938907] [DMG] 		},
[1687268089745] [71452:11938907] [DMG] 		
[1687268089745] [71452:11938907] [DMG] 	],
[1687268089745] [71452:11938907] [DMG] 	
[1687268089745] [71452:11938907] [DMG] 	InteractionModelRevision = 1
[1687268089745] [71452:11938907] [DMG] },
[1687268089745] [71452:11938907] [DMG] Received Command Response Data, Endpoint=0 Cluster=0x0000_0030 Command=0x0000_0001
[1687268089745] [71452:11938907] [CTL] Failsafe disarmed
[1687268089745] [71452:11938907] [CTL] Successfully finished commissioning step 'Cleanup'
[1687268089745] [71452:11938907] [TOO] Device commissioning Failure: src/controller/CHIPDeviceController.cpp:1455: CHIP Error 0x0000007E: Trying to add a NOC for a fabric that already exists
[1687268089745] [71452:11938907] [IN] SecureSession[0x60000339c000]: MarkForEviction Type:1 LSID:63495
[1687268089745] [71452:11938907] [SC] SecureSession[0x60000339c000, LSID:63495]: State change 'kActive' --> 'kPendingEviction'
[1687268089745] [71452:11938907] [EM] Failed to send Solitary ack for MessageCounter:117603848 on exchange 7124i:src/messaging/ExchangeContext.cpp:144: CHIP Error 0x00000002: Connection aborted
[1687268089745] [71452:11938907] [DMG] ICR moving to [AwaitingDe]
[1687268089745] [71452:11938907] [IN] SecureSession[0x60000339c000]: Released - Type:1 LSID:63495
[1687268089745] [71452:11938902] [CTL] Shutting down the commissioner
[1687268089745] [71452:11938902] [CTL] Stopping commissioning discovery over DNS-SD
[1687268089745] [71452:11938902] [CTL] Shutting down the controller
[1687268089745] [71452:11938902] [IN] Expiring all sessions for fabric 0x1!!
[1687268089745] [71452:11938902] [FP] Forgetting fabric 0x1
[1687268089745] [71452:11938902] [TS] Pending Last Known Good Time: 2023-06-16T15:24:10
[1687268089746] [71452:11938902] [TS] Previous Last Known Good Time: 2023-06-16T15:24:10
[1687268089746] [71452:11938902] [TS] Reverted Last Known Good Time to previous value
[1687268089746] [71452:11938902] [CTL] Shutting down the commissioner
[1687268089746] [71452:11938902] [CTL] Stopping commissioning discovery over DNS-SD
[1687268089746] [71452:11938902] [CTL] Shutting down the controller
[1687268089746] [71452:11938902] [CTL] Shutting down the System State, this will teardown the CHIP Stack
[1687268089747] [71452:11938902] [DMG] All ReadHandler-s are clean, clear GlobalDirtySet
[1687268089747] [71452:11938902] [BLE] CancelConnection
[1687268089747] [71452:11938902] [FP] Shutting down FabricTable
[1687268089747] [71452:11938902] [TS] Pending Last Known Good Time: 2023-06-16T15:24:10
[1687268089747] [71452:11938902] [TS] Previous Last Known Good Time: 2023-06-16T15:24:10
[1687268089747] [71452:11938902] [TS] Reverted Last Known Good Time to previous value
[1687268089747] [71452:11938902] [DL] Inet Layer shutdown
[1687268089747] [71452:11938902] [DL] BLE shutdown
[1687268089747] [71452:11938902] [DL] System Layer shutdown
[1687268089747] [71452:11938902] [TOO] Run command failure: src/controller/CHIPDeviceController.cpp:1455: CHIP Error 0x0000007E: Trying to add a NOC for a fabric that already exists

0 Maria Gilje over 2 years ago

Hi Hugo,

I wonder if there is some configuration that is limiting the number of pairing systems.

This could be very possible, yes. You need the Administrator Commissioning Cluster on your node to enable it to be commissioned into more than one ecosystem. This feature is documented here.

Best regards,

Maria
Cancel
Vote Up 0 Vote Down

Sign in to reply

Verify Answer

Cancel