search

project-chip / connectedhomeip

Matter (formerly Project CHIP) creates more connections between more objects, simplifying development for manufacturers and increasing compatibility for consumers, guided by the Connectivity Standards Alliance.
https://buildwithmatter.com
Apache License 2.0
7.55k stars 2.04k forks source link

Could not able to pair Matter accessory using Chiptool iOS app. #26049

Closed muralivm closed 1 year ago

muralivm commented 1 year ago

Reproduction steps

  1. Install the iOS app by following https://github.com/project-chip/connectedhomeip/tree/master/src/darwin/CHIPTool
  2. Launch the app
  3. Go to QR code scanner
  4. Using the camera option and scanning the QR code and I am able to see vendor ID, product ID etc .. Uploaded the image as well details IMG_49135AA5F116-1
  5. I am not getting WIFI password, i am struck here.

Note: I will be attaching the logs as well. could you please help me here.

Bug prevalence

Every time

GitHub hash of the SDK that was being used

fc0e4a2c698b06a6467a4969981e3dbd87a82063

Platform

darwin

Platform Version(s)

NA

Anything else?

Log from CHIPTool ``` 2023-04-11 09:21:04.494251-0400 CHIPTool[1312:261505] [DataManagement] AccessControl: initializing 2023-04-11 09:21:04.496814-0400 CHIPTool[1312:261505] [DeviceLayer] _Init 2023-04-11 09:21:04.497422-0400 CHIPTool[1312:261505] [Inet] UDP::Init bind&listen port=0 2023-04-11 09:21:04.497630-0400 CHIPTool[1312:261505] [Inet] UDP::Init bound to port=65104 2023-04-11 09:21:04.497643-0400 CHIPTool[1312:261505] [Inet] UDP::Init bind&listen port=0 2023-04-11 09:21:04.497725-0400 CHIPTool[1312:261505] [Inet] UDP::Init bound to port=51500 2023-04-11 09:21:04.497734-0400 CHIPTool[1312:261505] [Inet] BLEBase::Init - setting/overriding transport 2023-04-11 09:21:04.497740-0400 CHIPTool[1312:261505] [Inet] TransportMgr initialized 2023-04-11 09:21:04.498154-0400 CHIPTool[1312:261505] [FabricProvisioning] Initializing FabricTable from persistent storage 2023-04-11 09:21:04.498893-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/lkgt, value (null) 2023-04-11 09:21:04.498950-0400 CHIPTool[1312:261505] [TimeService] Last Known Good Time: [unknown] 2023-04-11 09:21:04.499036-0400 CHIPTool[1312:261505] [TimeService] Setting Last Known Good Time to firmware build time 2023-04-03T14:50:14 2023-04-11 09:21:04.500283-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/fidx, value (null) 2023-04-11 09:21:04.500343-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/fs/c, value (null) 2023-04-11 09:21:04.500630-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/gcc, value (null) 2023-04-11 09:21:04.500676-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/gdc, value (null) 2023-04-11 09:21:04.523431-0400 CHIPTool[1312:261505] [Controller] System State Initialized... 2023-04-11 09:21:04.523471-0400 CHIPTool[1312:261505] [Controller] Shutting down the System State, this will teardown the CHIP Stack 2023-04-11 09:21:04.524787-0400 CHIPTool[1312:261505] [DataManagement] All ReadHandler-s are clean, clear GlobalDirtySet 2023-04-11 09:21:04.524896-0400 CHIPTool[1312:261505] [Ble] CancelConnection 2023-04-11 09:21:04.524951-0400 CHIPTool[1312:261505] [FabricProvisioning] Shutting down FabricTable 2023-04-11 09:21:04.525010-0400 CHIPTool[1312:261505] [TimeService] Pending Last Known Good Time: 2023-04-03T14:50:14 2023-04-11 09:21:04.525104-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/lkgt, value {length = 8, bytes = 0x15260026a4bd2b18} 2023-04-11 09:21:04.525167-0400 CHIPTool[1312:261505] [TimeService] Previous Last Known Good Time: 2023-04-03T14:50:14 2023-04-11 09:21:04.525188-0400 CHIPTool[1312:261505] [TimeService] Reverted Last Known Good Time to previous value 2023-04-11 09:21:04.525204-0400 CHIPTool[1312:261505] [DeviceLayer] Inet Layer shutdown 2023-04-11 09:21:04.525219-0400 CHIPTool[1312:261505] [DeviceLayer] BLE shutdown 2023-04-11 09:21:04.525252-0400 CHIPTool[1312:261505] [DeviceLayer] System Layer shutdown 2023-04-11 09:21:04.525356-0400 CHIPTool[1312:261765] [DeviceLayer] _OnPlatformEvent 2023-04-11 09:21:04.528303-0400 CHIPTool[1312:261505] Found an existing IPK in the keychain 2023-04-11 09:21:04.528890-0400 CHIPTool[1312:261505] Found an existing CA key in the keychain 2023-04-11 09:21:04.529656-0400 CHIPTool[1312:261505] [Controller] Trying to start operational browse 2023-04-11 09:21:04.545439-0400 CHIPTool[1312:261505] [FabricProvisioning] Initializing FabricTable from persistent storage 2023-04-11 09:21:04.545477-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/lkgt, value {length = 8, bytes = 0x15260026a4bd2b18} 2023-04-11 09:21:04.545506-0400 CHIPTool[1312:261505] [TimeService] Last Known Good Time: 2023-04-03T14:50:14 2023-04-11 09:21:04.545539-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/fidx, value (null) 2023-04-11 09:21:04.545569-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/fs/c, value (null) 2023-04-11 09:21:04.545824-0400 CHIPTool[1312:261505] [Default] Can't start on existing fabric: fabric not found 2023-04-11 09:21:04.545926-0400 CHIPTool[1312:261505] [Controller] Trying to start operational browse 2023-04-11 09:21:04.547243-0400 CHIPTool[1312:261505] [FabricProvisioning] Initializing FabricTable from persistent storage 2023-04-11 09:21:04.547272-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/lkgt, value {length = 8, bytes = 0x15260026a4bd2b18} 2023-04-11 09:21:04.547297-0400 CHIPTool[1312:261505] [TimeService] Last Known Good Time: 2023-04-03T14:50:14 2023-04-11 09:21:04.547324-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/fidx, value (null) 2023-04-11 09:21:04.547348-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/fs/c, value (null) 2023-04-11 09:21:04.547444-0400 CHIPTool[1312:261505] [Default] Generating root certificate 2023-04-11 09:21:04.550607-0400 CHIPTool[1312:261505] [Controller] Stopping commissioning discovery over DNS-SD 2023-04-11 09:21:04.550661-0400 CHIPTool[1312:261505] [Controller] Setting attestation nonce to random value 2023-04-11 09:21:04.550752-0400 CHIPTool[1312:261505] [Controller] Setting CSR nonce to random value 2023-04-11 09:21:04.557519-0400 CHIPTool[1312:261505] [DeviceLayer] _Init 2023-04-11 09:21:04.557530-0400 CHIPTool[1312:261505] [Inet] UDP::Init bind&listen port=0 2023-04-11 09:21:04.557632-0400 CHIPTool[1312:261505] [Inet] UDP::Init bound to port=62061 2023-04-11 09:21:04.557637-0400 CHIPTool[1312:261505] [Inet] UDP::Init bind&listen port=0 2023-04-11 09:21:04.557681-0400 CHIPTool[1312:261505] [Inet] UDP::Init bound to port=50214 2023-04-11 09:21:04.557685-0400 CHIPTool[1312:261505] [Inet] BLEBase::Init - setting/overriding transport 2023-04-11 09:21:04.557689-0400 CHIPTool[1312:261505] [Inet] TransportMgr initialized 2023-04-11 09:21:04.557697-0400 CHIPTool[1312:261505] [FabricProvisioning] Initializing FabricTable from persistent storage 2023-04-11 09:21:04.557727-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/lkgt, value {length = 8, bytes = 0x15260026a4bd2b18} 2023-04-11 09:21:04.557753-0400 CHIPTool[1312:261505] [TimeService] Last Known Good Time: 2023-04-03T14:50:14 2023-04-11 09:21:04.557780-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/fidx, value (null) 2023-04-11 09:21:04.557804-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/fs/c, value (null) 2023-04-11 09:21:04.557945-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/gcc, value {length = 4, bytes = 0xe8030000} 2023-04-11 09:21:04.557981-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/gdc, value {length = 4, bytes = 0xe8030000} 2023-04-11 09:21:04.558568-0400 CHIPTool[1312:261505] [Controller] System State Initialized... 2023-04-11 09:21:04.558899-0400 CHIPTool[1312:261505] [Controller] Intermediate CA is not needed 2023-04-11 09:21:04.559003-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/r, value (null) 2023-04-11 09:21:04.559074-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/o, value (null) 2023-04-11 09:21:04.559147-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/n, value (null) 2023-04-11 09:21:04.559174-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/i, value (null) 2023-04-11 09:21:04.559191-0400 CHIPTool[1312:261505] [FabricProvisioning] Validating NOC chain 2023-04-11 09:21:04.561859-0400 CHIPTool[1312:261505] [FabricProvisioning] NOC chain validation successful 2023-04-11 09:21:04.561880-0400 CHIPTool[1312:261505] [FabricProvisioning] Added new fabric at index: 0x1 2023-04-11 09:21:04.561894-0400 CHIPTool[1312:261505] [FabricProvisioning] Assigned compressed fabric ID: 0x9B6524C1E675D9D1, node ID: 0x01E54E9CEDBAB631 2023-04-11 09:21:04.561910-0400 CHIPTool[1312:261505] [TimeService] Last Known Good Time: 2023-04-03T14:50:14 2023-04-11 09:21:04.561924-0400 CHIPTool[1312:261505] [TimeService] New proposed Last Known Good Time: 2023-04-11T13:21:04 2023-04-11 09:21:04.561938-0400 CHIPTool[1312:261505] [TimeService] Updating pending Last Known Good Time to 2023-04-11T13:21:04 2023-04-11 09:21:04.561963-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/sri, value (null) 2023-04-11 09:21:04.562294-0400 CHIPTool[1312:261505] [FabricProvisioning] Metadata for Fabric 0x1 persisted to storage. 2023-04-11 09:21:04.562830-0400 CHIPTool[1312:261505] [TimeService] Committing Last Known Good Time to storage: 2023-04-11T13:21:04 2023-04-11 09:21:04.563282-0400 CHIPTool[1312:261505] [Controller] Joined the fabric at index 1. Fabric ID is 0x0000000000000001 (Compressed Fabric ID: 9B6524C1E675D9D1) 2023-04-11 09:21:04.563394-0400 CHIPTool[1312:261765] [DeviceLayer] _OnPlatformEvent Thread Performance Checker: -[AVCaptureSession startRunning] should be called from background thread. Calling it on the main thread can lead to UI unresponsiveness PID: 1312, TID: 261505 Backtrace ================================================================= 3 CHIPTool 0x00000001020996b4 -[QRCodeViewController startScanning] + 884 4 CHIPTool 0x0000000102099fac -[QRCodeViewController startScanningQRCode:] + 76 5 UIKitCore 0x00000001c7391114 B0858D8E-7220-37BF-873F-ECC2B0A358C3 + 2400532 6 UIKitCore 0x00000001c776311c B0858D8E-7220-37BF-873F-ECC2B0A358C3 + 6406428 7 UIKitCore 0x00000001c774db9c B0858D8E-7220-37BF-873F-ECC2B0A358C3 + 6319004 8 UIKitCore 0x00000001c774da9c B0858D8E-7220-37BF-873F-ECC2B0A358C3 + 6318748 9 UIKitCore 0x00000001c7391114 B0858D8E-7220-37BF-873F-ECC2B0A358C3 + 2400532 10 UIKitCore 0x00000001c7390e14 B0858D8E-7220-37BF-873F-ECC2B0A358C3 + 2399764 11 UIKitCore 0x00000001c73907a8 B0858D8E-7220-37BF-873F-ECC2B0A358C3 + 2398120 12 UIKitCore 0x00000001c73907e4 B0858D8E-7220-37BF-873F-ECC2B0A358C3 + 2398180 13 UIKitCore 0x00000001c739020c B0858D8E-7220-37BF-873F-ECC2B0A358C3 + 2396684 14 UIKitCore 0x00000001c72776c8 B0858D8E-7220-37BF-873F-ECC2B0A358C3 + 1246920 15 CoreFoundation 0x00000001c5169324 6A07CBE8-4F65-3DBC-B59D-C1A188A7B95D + 590628 16 CoreFoundation 0x00000001c50f34f0 6A07CBE8-4F65-3DBC-B59D-C1A188A7B95D + 107760 17 CoreFoundation 0x00000001c515328c 6A07CBE8-4F65-3DBC-B59D-C1A188A7B95D + 500364 18 CoreFoundation 0x00000001c51584dc CFRunLoopRunSpecific + 612 19 GraphicsServices 0x00000002003b835c GSEventRunModal + 164 20 UIKitCore 0x00000001c74e437c B0858D8E-7220-37BF-873F-ECC2B0A358C3 + 3789692 21 UIKitCore 0x00000001c74e3fe0 UIApplicationMain + 340 22 CHIPTool 0x00000001020aa7e0 main + 120 23 dyld 0x00000001e45e0dec 41605DC7-F412-37D1-B51B-FEE1A26701E9 + 89580 2023-04-11 09:21:19.912779-0400 CHIPTool[1312:261505] Payload vendorID 65521 2023-04-11 09:21:19.912919-0400 CHIPTool[1312:261505] Rendezvous Default 2023-04-11 09:21:19.915815-0400 CHIPTool[1312:261505] Found an existing IPK in the keychain 2023-04-11 09:21:19.917052-0400 CHIPTool[1312:261505] Found an existing CA key in the keychain 2023-04-11 09:21:19.917161-0400 CHIPTool[1312:261505] Shutting down the stack 2023-04-11 09:21:19.917419-0400 CHIPTool[1312:261505] [Controller] Shutting down the commissioner 2023-04-11 09:21:19.917443-0400 CHIPTool[1312:261505] [Controller] Stopping commissioning discovery over DNS-SD 2023-04-11 09:21:19.917454-0400 CHIPTool[1312:261505] [Controller] Shutting down the controller 2023-04-11 09:21:19.917465-0400 CHIPTool[1312:261505] [Inet] Expiring all sessions for fabric 0x1!! 2023-04-11 09:21:19.917476-0400 CHIPTool[1312:261505] [FabricProvisioning] Forgetting fabric 0x1 2023-04-11 09:21:19.917551-0400 CHIPTool[1312:261505] [TimeService] Pending Last Known Good Time: 2023-04-11T13:21:04 2023-04-11 09:21:19.917703-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/lkgt, value {length = 8, bytes = 0x152600401bc82b18} 2023-04-11 09:21:19.917760-0400 CHIPTool[1312:261505] [TimeService] Previous Last Known Good Time: 2023-04-11T13:21:04 2023-04-11 09:21:19.917798-0400 CHIPTool[1312:261505] [TimeService] Reverted Last Known Good Time to previous value 2023-04-11 09:21:19.917831-0400 CHIPTool[1312:261505] [Controller] Shutting down the System State, this will teardown the CHIP Stack 2023-04-11 09:21:19.917853-0400 CHIPTool[1312:261505] [DataManagement] All ReadHandler-s are clean, clear GlobalDirtySet 2023-04-11 09:21:19.917938-0400 CHIPTool[1312:261505] [Ble] CancelConnection 2023-04-11 09:21:19.917992-0400 CHIPTool[1312:261505] [FabricProvisioning] Shutting down FabricTable 2023-04-11 09:21:19.918027-0400 CHIPTool[1312:261505] [TimeService] Pending Last Known Good Time: 2023-04-11T13:21:04 2023-04-11 09:21:19.918103-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/lkgt, value {length = 8, bytes = 0x152600401bc82b18} 2023-04-11 09:21:19.918145-0400 CHIPTool[1312:261505] [TimeService] Previous Last Known Good Time: 2023-04-11T13:21:04 2023-04-11 09:21:19.918176-0400 CHIPTool[1312:261505] [TimeService] Reverted Last Known Good Time to previous value 2023-04-11 09:21:19.918211-0400 CHIPTool[1312:261505] [DeviceLayer] Inet Layer shutdown 2023-04-11 09:21:19.918266-0400 CHIPTool[1312:261505] [DeviceLayer] BLE shutdown 2023-04-11 09:21:19.918352-0400 CHIPTool[1312:261505] [DeviceLayer] System Layer shutdown 2023-04-11 09:21:19.919006-0400 CHIPTool[1312:261505] Starting up the stack 2023-04-11 09:21:19.919154-0400 CHIPTool[1312:261505] [Controller] Trying to start operational browse 2023-04-11 09:21:19.927904-0400 CHIPTool[1312:261505] [FabricProvisioning] Initializing FabricTable from persistent storage 2023-04-11 09:21:19.928062-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/lkgt, value {length = 8, bytes = 0x152600401bc82b18} 2023-04-11 09:21:19.928188-0400 CHIPTool[1312:261505] [TimeService] Last Known Good Time: 2023-04-11T13:21:04 2023-04-11 09:21:19.928307-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/fidx, value {length = 10, bytes = 0x15240002360104011818} 2023-04-11 09:21:19.928416-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/n, value {length = 258, bytes = 0x15300101 01240201 37032714 c856cfa2 ... cb65580c e49c0c18 } 2023-04-11 09:21:19.928492-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/r, value {length = 251, bytes = 0x15300101 00240201 37032714 c856cfa2 ... 337b22e2 e9d01b18 } 2023-04-11 09:21:19.928744-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/m, value {length = 9, bytes = 0x152500f1ff2c010018} 2023-04-11 09:21:19.928792-0400 CHIPTool[1312:261505] [FabricProvisioning] Fabric index 0x1 was retrieved from storage. Compressed FabricId 0x9B6524C1E675D9D1, FabricId 0x0000000000000001, NodeId 0x01E54E9CEDBAB631, VendorId 0xFFF1 2023-04-11 09:21:19.928925-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/fs/c, value (null) 2023-04-11 09:21:19.929149-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/n, value {length = 258, bytes = 0x15300101 01240201 37032714 c856cfa2 ... cb65580c e49c0c18 } 2023-04-11 09:21:19.929299-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/o, value {length = 105, bytes = 0x15240001 30016104 0f2505dd 5ff8248c ... 141c1fab b6883418 } 2023-04-11 09:21:19.929352-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/i, value (null) 2023-04-11 09:21:19.929438-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/n, value {length = 258, bytes = 0x15300101 01240201 37032714 c856cfa2 ... cb65580c e49c0c18 } 2023-04-11 09:21:19.929507-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/r, value {length = 251, bytes = 0x15300101 00240201 37032714 c856cfa2 ... 337b22e2 e9d01b18 } 2023-04-11 09:21:19.931371-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/o, value {length = 105, bytes = 0x15240001 30016104 0f2505dd 5ff8248c ... 141c1fab b6883418 } 2023-04-11 09:21:19.931537-0400 CHIPTool[1312:261505] [Controller] Stopping commissioning discovery over DNS-SD 2023-04-11 09:21:19.931569-0400 CHIPTool[1312:261505] [Controller] Setting attestation nonce to random value 2023-04-11 09:21:19.931789-0400 CHIPTool[1312:261505] [Controller] Setting CSR nonce to random value 2023-04-11 09:21:19.932199-0400 CHIPTool[1312:261505] [DeviceLayer] _Init 2023-04-11 09:21:19.932227-0400 CHIPTool[1312:261505] [Inet] UDP::Init bind&listen port=0 2023-04-11 09:21:19.932412-0400 CHIPTool[1312:261505] [Inet] UDP::Init bound to port=61532 2023-04-11 09:21:19.932423-0400 CHIPTool[1312:261505] [Inet] UDP::Init bind&listen port=0 2023-04-11 09:21:19.932479-0400 CHIPTool[1312:261505] [Inet] UDP::Init bound to port=53682 2023-04-11 09:21:19.932488-0400 CHIPTool[1312:261505] [Inet] BLEBase::Init - setting/overriding transport 2023-04-11 09:21:19.932494-0400 CHIPTool[1312:261505] [Inet] TransportMgr initialized 2023-04-11 09:21:19.932513-0400 CHIPTool[1312:261505] [FabricProvisioning] Initializing FabricTable from persistent storage 2023-04-11 09:21:19.932582-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/lkgt, value {length = 8, bytes = 0x152600401bc82b18} 2023-04-11 09:21:19.932659-0400 CHIPTool[1312:261505] [TimeService] Last Known Good Time: 2023-04-11T13:21:04 2023-04-11 09:21:19.932764-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/fidx, value {length = 10, bytes = 0x15240002360104011818} 2023-04-11 09:21:19.932853-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/n, value {length = 258, bytes = 0x15300101 01240201 37032714 c856cfa2 ... cb65580c e49c0c18 } 2023-04-11 09:21:19.932922-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/r, value {length = 251, bytes = 0x15300101 00240201 37032714 c856cfa2 ... 337b22e2 e9d01b18 } 2023-04-11 09:21:19.933131-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/m, value {length = 9, bytes = 0x152500f1ff2c010018} 2023-04-11 09:21:19.933176-0400 CHIPTool[1312:261505] [FabricProvisioning] Fabric index 0x1 was retrieved from storage. Compressed FabricId 0x9B6524C1E675D9D1, FabricId 0x0000000000000001, NodeId 0x01E54E9CEDBAB631, VendorId 0xFFF1 2023-04-11 09:21:19.933236-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/fs/c, value (null) 2023-04-11 09:21:19.933623-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/gcc, value {length = 4, bytes = 0xd0070000} 2023-04-11 09:21:19.933694-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/gdc, value {length = 4, bytes = 0xd0070000} 2023-04-11 09:21:19.935520-0400 CHIPTool[1312:261505] [Controller] System State Initialized... 2023-04-11 09:21:19.935667-0400 CHIPTool[1312:261505] [Controller] Intermediate CA is not needed 2023-04-11 09:21:19.935941-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/o, value {length = 105, bytes = 0x15240001 30016104 0f2505dd 5ff8248c ... 141c1fab b6883418 } 2023-04-11 09:21:19.936028-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/o, value {length = 105, bytes = 0x15240001 30016104 0f2505dd 5ff8248c ... 141c1fab b6883418 } 2023-04-11 09:21:19.936136-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/r, value {length = 251, bytes = 0x15300101 00240201 37032714 c856cfa2 ... 337b22e2 e9d01b18 } 2023-04-11 09:21:19.936246-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/r, value {length = 251, bytes = 0x15300101 00240201 37032714 c856cfa2 ... 337b22e2 e9d01b18 } 2023-04-11 09:21:19.936310-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/n, value {length = 258, bytes = 0x15300101 01240201 37032714 c856cfa2 ... cb65580c e49c0c18 } 2023-04-11 09:21:19.936383-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/r, value {length = 251, bytes = 0x15300101 00240201 37032714 c856cfa2 ... 337b22e2 e9d01b18 } 2023-04-11 09:21:19.936419-0400 CHIPTool[1312:261505] [FabricProvisioning] Validating NOC chain 2023-04-11 09:21:19.944192-0400 CHIPTool[1312:261505] [FabricProvisioning] NOC chain validation successful 2023-04-11 09:21:19.944412-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/o, value {length = 105, bytes = 0x15240001 30016104 0f2505dd 5ff8248c ... 141c1fab b6883418 } 2023-04-11 09:21:19.944470-0400 CHIPTool[1312:261505] [FabricProvisioning] Updated fabric at index: 0x1, Node ID: 0x01E54E9CEDBAB631 2023-04-11 09:21:19.944512-0400 CHIPTool[1312:261505] [TimeService] Last Known Good Time: 2023-04-11T13:21:04 2023-04-11 09:21:19.944546-0400 CHIPTool[1312:261505] [TimeService] New proposed Last Known Good Time: 2023-04-11T13:21:04 2023-04-11 09:21:19.944581-0400 CHIPTool[1312:261505] [TimeService] Retaining current Last Known Good Time 2023-04-11 09:21:19.944633-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: g/sri, value (null) 2023-04-11 09:21:19.944710-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/o, value {length = 105, bytes = 0x15240001 30016104 0f2505dd 5ff8248c ... 141c1fab b6883418 } 2023-04-11 09:21:19.945424-0400 CHIPTool[1312:261505] [FabricProvisioning] Metadata for Fabric 0x1 persisted to storage. 2023-04-11 09:21:19.945651-0400 CHIPTool[1312:261505] MTRPersistentStorageDelegate Get Value for Key: f/1/o, value {length = 105, bytes = 0x15240001 30016104 0f2505dd 5ff8248c ... 141c1fab b6883418 } 2023-04-11 09:21:19.945784-0400 CHIPTool[1312:261505] [TimeService] Committing Last Known Good Time to storage: 2023-04-11T13:21:04 2023-04-11 09:21:19.946346-0400 CHIPTool[1312:261505] [Controller] Joined the fabric at index 1. Fabric ID is 0x0000000000000001 (Compressed Fabric ID: 9B6524C1E675D9D1) 2023-04-11 09:21:19.947042-0400 CHIPTool[1312:261954] [DeviceLayer] _OnPlatformEvent 2023-04-11 09:21:19.947485-0400 CHIPTool[1312:261505] [Controller] Stopping commissioning discovery over DNS-SD 2023-04-11 09:21:19.947504-0400 CHIPTool[1312:261505] [Controller] Starting commissioning discovery over BLE 2023-04-11 09:21:19.947553-0400 CHIPTool[1312:261505] [Ble] NewConnection 2023-04-11 09:21:19.947587-0400 CHIPTool[1312:261505] [Ble] CancelConnection 2023-04-11 09:21:19.951927-0400 CHIPTool[1312:261505] [Controller] Starting commissioning discovery over DNS-SD 2023-04-11 09:21:19.952403-0400 CHIPTool[1312:261505] [Discovery] Browsing for: _matterc._udp,_L3840 2023-04-11 09:21:21.801514-0400 CHIPTool[1312:261765] [Ble] CBManagerState: ON 2023-04-11 09:21:21.879476-0400 CHIPTool[1312:261765] [Ble] Connecting to device 0x280e6c5b0 with discriminator: 3840 2023-04-11 09:21:22.912899-0400 CHIPTool[1312:261765] [Controller] Discovered device to be commissioned over BLE 2023-04-11 09:21:22.913118-0400 CHIPTool[1312:261765] [Controller] Attempting PASE connection to BLE 2023-04-11 09:21:22.914507-0400 CHIPTool[1312:261765] [Inet] BleConnectionComplete: endPoint 0x108d93950 2023-04-11 09:21:22.914617-0400 CHIPTool[1312:261765] [Ble] ATT MTU = 247 2023-04-11 09:21:22.915657-0400 CHIPTool[1312:261908] [Ble] BLE:Error writing Characteristics in Chip service on the device: [The specified UUID is not allowed for this operation.] 2023-04-11 09:21:22.917117-0400 CHIPTool[1312:261765] [Inet] SecureSession[0x280a700f0]: Allocated Type:1 LSID:43939 2023-04-11 09:21:22.917602-0400 CHIPTool[1312:261765] [SecureChannel] Assigned local session key ID 43939 2023-04-11 09:21:22.919633-0400 CHIPTool[1312:261765] [ExchangeManager] <<< [E:34317i S:0 M:173829262] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:20 (SecureChannel:PBKDFParamRequest) 2023-04-11 09:21:22.919840-0400 CHIPTool[1312:261765] [Inet] (U) Sending msg 173829262 to IP address 'BLE' 2023-04-11 09:21:22.919960-0400 CHIPTool[1312:261765] [Inet] Message appended to BLE send queue 2023-04-11 09:21:22.919986-0400 CHIPTool[1312:261765] [SecureChannel] Sent PBKDF param request 2023-04-11 09:21:22.920094-0400 CHIPTool[1312:261765] [Inet] Failed to establish BLE connection: ../../../../../../../../../../../connectedhomeip/src/platform/Darwin/BleConnectionDelegateImpl.mm:332: Ble Error 0x00000407: GATT write characteristic operation failed 2023-04-11 09:21:22.920204-0400 CHIPTool[1312:261765] [Inet] Clearing BLE pending packets. 2023-04-11 09:21:22.920226-0400 CHIPTool[1312:261765] [Ble] Auto-closing end point's BLE connection. 2023-04-11 09:21:39.921428-0400 CHIPTool[1312:261769] [SecureChannel] PASESession timed out while waiting for a response from the peer. Expected message type was 33 2023-04-11 09:21:39.921699-0400 CHIPTool[1312:261769] [Inet] SecureSession[0x280a700f0]: Released - Type:1 LSID:43939 2023-04-11 09:21:39.921750-0400 CHIPTool[1312:261769] [Controller] Ignoring SecurePairingFailed status for now; we are waiting to see if we discover more devices 2023-04-11 09:21:39.921845-0400 CHIPTool[1312:261769] [Discovery] Closing all BLE connections 2023-04-11 09:21:39.921976-0400 CHIPTool[1312:261769] [Controller] Waiting to discover commissionees that match our filters 2023-04-11 09:21:49.956140-0400 CHIPTool[1312:262153] [Controller] Discovery timed out 2023-04-11 09:21:49.956409-0400 CHIPTool[1312:262153] [Controller] Stopping commissioning discovery over DNS-SD 2023-04-11 09:21:49.956454-0400 CHIPTool[1312:262153] [Discovery] Mdns: Browse failure (kDNSServiceErr_Timeout) 2023-04-11 09:21:49.956598-0400 CHIPTool[1312:262153] [Default] DeviceControllerDelegate status updated: 1 ```
bzbarsky-apple commented 1 year ago

Here's the issue:

2023-04-11 09:21:22.915657-0400 CHIPTool[1312:261908] [Ble] BLE:Error writing Characteristics in Chip service on the device: [The specified UUID is not allowed for this operation.]

Please follow the instructions at https://github.com/project-chip/connectedhomeip/blob/master/docs/guides/darwin.md#using-chip-tool-on-macos-or-chip-tool-on-ios