This post is older than 2 years and might not be relevant anymore
More Info: Consider searching for newer posts

iOS NRF Mesh app will only provision and configure one device

I am able to provision and configure 1 mesh device with the nrfMesh iOS app.

I am able to successfully provision a second device, but when I configure a second device, the first config message times out, and I never receive a response

ConfigCompositionDataGet(page: 0) sent from: 0001, to: 000B timed out


Any info would be appreciated

Here are the complete logs for the second device

2021-04-07 14:21:30.156371-0600 nRFMeshProvision_Example[47763:5305094] [Provisioning] Provisioning started

2021-04-07 14:21:30.156621-0600 nRFMeshProvision_Example[47763:5305094] [Provisioning] Sending Provisioning Start (algorithm: FIPS P-256 Elliptic Curve, public Key: No OOB Public Key, authentication Method: No OOB)

2021-04-07 14:21:30.156982-0600 nRFMeshProvision_Example[47763:5305094] [Bearer] -> 0x03020000000000

2021-04-07 14:21:30.158071-0600 nRFMeshProvision_Example[47763:5305094] [Provisioning] Sending Provisioner Public Key (0x1DF9979C088510747126188E47D47E4339EA8A611C9B3F2BA10F9FDEF8B21E3C7B2BCA6467FA442283245B693EFF0E3ED8DAF42147898F8A878849BC9A7E2749)

2021-04-07 14:21:30.158454-0600 nRFMeshProvision_Example[47763:5305094] [Bearer] -> 0x43031DF9979C088510747126188E47D47E4339EA

2021-04-07 14:21:30.160081-0600 nRFMeshProvision_Example[47763:5305094] [Bearer] -> 0x838A611C9B3F2BA10F9FDEF8B21E3C7B2BCA6467

2021-04-07 14:21:30.160513-0600 nRFMeshProvision_Example[47763:5305094] [Bearer] -> 0x83FA442283245B693EFF0E3ED8DAF42147898F8A

2021-04-07 14:21:30.161021-0600 nRFMeshProvision_Example[47763:5305094] [Bearer] -> 0xC3878849BC9A7E2749

2021-04-07 14:21:30.671585-0600 nRFMeshProvision_Example[47763:5305094] [Bearer] <- 0x4303D8EBADC613B92A1024324C90C4205885EB47

2021-04-07 14:21:30.672807-0600 nRFMeshProvision_Example[47763:5305094] [Bearer] <- 0x83BF832F55ECD92B7EF985E0922FFB663C93B897

2021-04-07 14:21:30.673133-0600 nRFMeshProvision_Example[47763:5305094] [Bearer] <- 0x839FC86B25DDDA01909B432E0C0E5DDA8FB3B2FF

2021-04-07 14:21:30.719694-0600 nRFMeshProvision_Example[47763:5305094] [Bearer] <- 0xC376507A90C0C5FC03

2021-04-07 14:21:30.720366-0600 nRFMeshProvision_Example[47763:5305094] [Provisioning] Device Public Key (0xD8EBADC613B92A1024324C90C4205885EB47BF832F55ECD92B7EF985E0922FFB663C93B8979FC86B25DDDA01909B432E0C0E5DDA8FB3B2FF76507A90C0C5FC03) received

2021-04-07 14:21:30.751927-0600 nRFMeshProvision_Example[47763:5305094] [Provisioning] Sending Provisioner Confirmation (0x876BCB1B27C6A2EF64DA61208D456234)

2021-04-07 14:21:30.752101-0600 nRFMeshProvision_Example[47763:5305094] [Bearer] -> 0x0305876BCB1B27C6A2EF64DA61208D456234

2021-04-07 14:21:30.820442-0600 nRFMeshProvision_Example[47763:5305094] [Bearer] <- 0x03056F0B246A777CB104FB49EE46F0729F7F

2021-04-07 14:21:30.820779-0600 nRFMeshProvision_Example[47763:5305094] [Provisioning] Device Confirmation (0x6F0B246A777CB104FB49EE46F0729F7F) received

2021-04-07 14:21:30.820988-0600 nRFMeshProvision_Example[47763:5305094] [Provisioning] Sending Provisioner Random (0x9E2BDD2A73079E0354A942E5BBC47793)

2021-04-07 14:21:30.821361-0600 nRFMeshProvision_Example[47763:5305094] [Bearer] -> 0x03069E2BDD2A73079E0354A942E5BBC47793

2021-04-07 14:21:30.954340-0600 nRFMeshProvision_Example[47763:5305094] [Bearer] <- 0x03064D766DA56C3A9B52A168060DF9528743

2021-04-07 14:21:30.954666-0600 nRFMeshProvision_Example[47763:5305094] [Provisioning] Device Random (0x4D766DA56C3A9B52A168060DF9528743) received

2021-04-07 14:21:31.016593-0600 nRFMeshProvision_Example[47763:5305094] [Provisioning] Sending Encrypted Provisioning Data (0xF85FE4F64331E308CDDC179A07EC78FFEB2AA2AE025E33445094771279F6FF918D)

2021-04-07 14:21:31.016664-0600 nRFMeshProvision_Example[47763:5305094] [Bearer] -> 0x4307F85FE4F64331E308CDDC179A07EC78FFEB2A

2021-04-07 14:21:31.017340-0600 nRFMeshProvision_Example[47763:5305094] [Bearer] -> 0xC3A2AE025E33445094771279F6FF918D

2021-04-07 14:21:31.102840-0600 nRFMeshProvision_Example[47763:5305094] [Bearer] <- 0x0308

2021-04-07 14:21:31.102974-0600 nRFMeshProvision_Example[47763:5305094] [Provisioning] Provisioning Complete received

2021-04-07 14:21:31.103186-0600 nRFMeshProvision_Example[47763:5305094] [Provisioning] Provisioning complete

2021-04-07 14:21:31.103341-0600 nRFMeshProvision_Example[47763:5305094] [Bearer] Cancelling connection...

2021-04-07 14:21:31.107255-0600 nRFMeshProvision_Example[47763:5305094] [Bearer] Disconnected from Broadcaster

2021-04-07 14:21:31.107377-0600 nRFMeshProvision_Example[47763:5305094] [Provisioning] Provisioner is ready

2021-04-07 14:21:33.751374-0600 nRFMeshProvision_Example[47763:5316570] [CoreBluetooth] XPC connection invalid

2021-04-07 14:21:33.751565-0600 nRFMeshProvision_Example[47763:5316610] [CoreBluetooth] XPC connection invalid

2021-04-07 14:21:34.317007-0600 nRFMeshProvision_Example[47763:5316610] [FoundationModel] Sending ConfigCompositionDataGet(page: 0) to: 000B

2021-04-07 14:21:34.317205-0600 nRFMeshProvision_Example[47763:5316610] [Access] Sending Access PDU (opcode: 0x8008, parameters: 0x00)

2021-04-07 14:21:34.326190-0600 nRFMeshProvision_Example[47763:5316610] [UpperTransport] Sending Upper Transport PDU (encrypted data: 0x9FFC46, transMic: 0xC62D177C) encrypted using key: Broadcaster's Device Key

2021-04-07 14:21:34.326411-0600 nRFMeshProvision_Example[47763:5316610] [LowerTransport] Sending Access Message (akf: 0, szmic: 0, data: 0x9FFC46C62D177C)

2021-04-07 14:21:34.336156-0600 nRFMeshProvision_Example[47763:5316610] [Network] Sending Network PDU (ivi: 0, nid: 0x6F, ctl: 0, ttl: 5, seq: 195, src: 0001, dst: 000B, transportPdu: 0xFB5FFD35C68E27F1, netMic: 0x561C768B) encrypted using Primary Network Key (index: 0)

2021-04-07 14:21:34.336394-0600 nRFMeshProvision_Example[47763:5316610] [Bearer] -> 0x406F48E99DBFF7613B20FB5FFD35C68E27F1561C

2021-04-07 14:21:34.352579-0600 nRFMeshProvision_Example[47763:5305094] [Bearer] -> 0xC0768B

2021-04-07 14:21:38.848990-0600 nRFMeshProvision_Example[47763:5316610] [Access] Resending Access PDU (opcode: 0x8008, parameters: 0x00)

2021-04-07 14:21:38.862996-0600 nRFMeshProvision_Example[47763:5316610] [UpperTransport] Sending Upper Transport PDU (encrypted data: 0xC72600, transMic: 0xDB7018C0) encrypted using key: Broadcaster's Device Key

2021-04-07 14:21:38.863223-0600 nRFMeshProvision_Example[47763:5316610] [LowerTransport] Sending Access Message (akf: 0, szmic: 0, data: 0xC72600DB7018C0)

2021-04-07 14:21:38.880954-0600 nRFMeshProvision_Example[47763:5316610] [Network] Sending Network PDU (ivi: 0, nid: 0x6F, ctl: 0, ttl: 5, seq: 196, src: 0001, dst: 000B, transportPdu: 0x1681ED74A6F4E87D, netMic: 0x6AAD71CE) encrypted using Primary Network Key (index: 0)

2021-04-07 14:21:38.881475-0600 nRFMeshProvision_Example[47763:5316610] [Bearer] -> 0x406F8371368189DEE3731681ED74A6F4E87D6AAD

2021-04-07 14:21:38.883163-0600 nRFMeshProvision_Example[47763:5305094] [Bearer] -> 0xC071CE

2021-04-07 14:21:47.982843-0600 nRFMeshProvision_Example[47763:5316610] [Access] Resending Access PDU (opcode: 0x8008, parameters: 0x00)

2021-04-07 14:21:47.998811-0600 nRFMeshProvision_Example[47763:5316610] [UpperTransport] Sending Upper Transport PDU (encrypted data: 0xBDC729, transMic: 0x060CA679) encrypted using key: Broadcaster's Device Key

2021-04-07 14:21:47.999233-0600 nRFMeshProvision_Example[47763:5316610] [LowerTransport] Sending Access Message (akf: 0, szmic: 0, data: 0xBDC729060CA679)

2021-04-07 14:21:48.023717-0600 nRFMeshProvision_Example[47763:5316610] [Network] Sending Network PDU (ivi: 0, nid: 0x6F, ctl: 0, ttl: 5, seq: 197, src: 0001, dst: 000B, transportPdu: 0xACEB7F712E3056A9, netMic: 0x093A02E9) encrypted using Primary Network Key (index: 0)

2021-04-07 14:21:48.024232-0600 nRFMeshProvision_Example[47763:5316610] [Bearer] -> 0x406F3AE5FEFBA2E593D5ACEB7F712E3056A9093A

2021-04-07 14:21:48.025871-0600 nRFMeshProvision_Example[47763:5305094] [Bearer] -> 0xC002E9

2021-04-07 14:22:06.100065-0600 nRFMeshProvision_Example[47763:5316862] [Access] Resending Access PDU (opcode: 0x8008, parameters: 0x00)

2021-04-07 14:22:06.116682-0600 nRFMeshProvision_Example[47763:5316862] [UpperTransport] Sending Upper Transport PDU (encrypted data: 0x1D4CDA, transMic: 0xF4E9CE43) encrypted using key: Broadcaster's Device Key

2021-04-07 14:22:06.116942-0600 nRFMeshProvision_Example[47763:5316862] [LowerTransport] Sending Access Message (akf: 0, szmic: 0, data: 0x1D4CDAF4E9CE43)

2021-04-07 14:22:06.140968-0600 nRFMeshProvision_Example[47763:5316862] [Network] Sending Network PDU (ivi: 0, nid: 0x6F, ctl: 0, ttl: 5, seq: 198, src: 0001, dst: 000B, transportPdu: 0xD619F5F165361C1F, netMic: 0xE4152E53) encrypted using Primary Network Key (index: 0)

2021-04-07 14:22:06.141489-0600 nRFMeshProvision_Example[47763:5316862] [Bearer] -> 0x406FB3A4F4105E0E0D24D619F5F165361C1FE415

2021-04-07 14:22:06.143244-0600 nRFMeshProvision_Example[47763:5305094] [Bearer] -> 0xC02E53

2021-04-07 14:22:14.418655-0600 nRFMeshProvision_Example[47763:5316922] [Access] Response to Access PDU (opcode: 0x8008, parameters: 0x00) not received (timeout)

2021-04-07 14:22:14.419445-0600 nRFMeshProvision_Example[47763:5316922] [FoundationModel] ConfigCompositionDataGet(page: 0) sent from: 0001, to: 000B timed out

2021-04-07 14:22:14.419806-0600 nRFMeshProvision_Example[47763:5316922] [Access] Cancelling messages with op code: 32776, sent from: 0001 to: 000B

  • There may be a lot of reasons why this happens:

    - The node you're connected to has GATT Proxy turned off (this is by default enabled, so you'd have to turn it off)
    - The new node is not reachable (also not likely, as you just provisioned it. Check if you can connect to it using the Proxy tab -> disable automatic connection -> connect to it -> repeat sending ConfigCompositionGet)
    - Your ConfigCompositionGet is sent in 2 packets:

    2021-04-07 14:21:34.336394-0600 nRFMeshProvision_Example[47763:5316610] [Bearer] -> 0x406F48E99DBFF7613B20FB5FFD35C68E27F1561C

    2021-04-07 14:21:34.352579-0600 nRFMeshProvision_Example[47763:5305094] [Bearer] -> 0xC0768B

    which means, you have MTU = 23. What mesh implementation on the devices are you using? It doesn't look like nRF Mesh SDK or mesh projects from nRF Connect SDK, as as far as I know, they have MTU set to 200+. That is not a problem, MTU = 23 should also work, but if you have a different mesh impl, perhaps there are issues with it. Try connecting directly to the new provisioned node, like I wrote in the 2nd bullet.

Related