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

nRF9160dk with hci_uart: After restart in provisioned state mesh scan can not start.

Hi,
the provisioning works and after that the dk is capable to get mesh messages
but oddly enough a restart brokes this feature.

The error message is:

[00:00:01.914,215] <wrn> bt_hci_core: opcode 0x2005 status 0x0c
[00:00:01.923,858] <err> bt_mesh_adv: starting scan failed (err -5)

0x0c means BT_HCI_ERR_CMD_DISALLOWED and that's why the I/O error (5) happens
in bt_mesh_scan_enable.
That function is called indirectly by bt_mesh_provision after provisioning
and by mesh_commit after restart in provisioned state with totally different result.

I use nRF Connect SDK 1.3.2.
What is the problem?

I start mesh with this:

bool mesh_init(void)
{
  int err;

  err = get_device_uuid();
  if (err) {
    LOG_ERR("Getting device uuid failed\n");
    return false;
  }
  err = bt_mesh_init(&prov, &comp);
  if (err) {
    LOG_ERR("Initializing mesh failed (err %d)\n", err);
    return false;
  }

  settings_load();

  // This will be a no-op if settings_load() loaded provisioning info
  bt_mesh_prov_enable(BT_MESH_PROV_ADV | BT_MESH_PROV_GATT);

  LOG_INF("Mesh initialized\n");

  return true;
}

Here is the provisioning log:

BY NRF MESH APP

*** Booting Zephyr OS build v2.3.0-rc1-ncs3  ***
[00:00:00.187,225] <dbg> nrf9160_gps.setup: MAGPIO set: AT%XMAGPIO=1,0,0,1,1,1574,1577
[00:00:00.196,380] <dbg> nrf9160_gps.setup: COEX0 set: AT%XCOEX0=1,1,1570,1580
[00:00:00.204,437] <inf> asset_tracker: iLuminate Hub started
main thread: id:537018052, priority:0
[00:00:00.214,813] <inf> google_cloud:  cmd:disconnect, state:STATE_DISCONNECTED
[00:00:01.217,864] <inf> fs_nvs: 2 Sectors of 4096 bytes
[00:00:01.223,937] <inf> fs_nvs: alloc wra: 0, ff0
[00:00:01.229,461] <inf> fs_nvs: data wra: 0, 0
[00:00:01.234,802] <inf> app: hub added to cloud:false
bd_addr generated 0xcf, 0x9e, 0x00, 0x00, 0xcf, 0xc0
bd_addr found 0xcf, 0x9e, 0x00, 0x00, 0xcf, 0xc0
[00:00:01.265,869] <wrn> bt_hci_core: opcode 0x0000 pool id 7 pool 0x20021220 != &hci_cmd_pool 0x200211f4
[00:00:01.293,518] <inf> bt_hci_core: Identity: c0:cf:00:00:9e:cf (random)
[00:00:01.301,177] <inf> bt_hci_core: HCI: version 5.1 (0x0a) revision 0x0000, manufacturer 0x05f1
[00:00:01.314,239] <inf> bt_hci_core: LMP: version 5.1 (0x0a) subver 0xffff
[00:00:01.566,772] <inf> modem: IMEI 352656100375461
[00:00:01.573,638] <inf> ble: Bluetooth initialized:iLuminate hub 352656100375461

[00:00:01.582,153] <inf> mesh: generated device uuid 0000ca81-0000-ca81-0000-ca810000ca81
[00:00:01.592,315] <inf> mesh: found device uuid 0000ca81-0000-ca81-0000-ca810000ca81
[00:00:01.601,287] <inf> storage: settings_handler_set name:device_uuid
[00:00:01.609,100] <inf> storage: settings_handler_set name:bd_addr
[00:00:01.616,241] <dbg> bt_mesh_settings.mesh_commit: sub[0].net_idx 0xffff
[00:00:01.624,206] <inf> bt_mesh_prov: Device UUID: 0000ca81-0000-ca81-0000-ca810000ca81
[00:00:01.637,908] <inf> mesh: Mesh initialized

[00:00:01.644,134] <inf> app: event type:APP_EVENT_TYPE_MQTT
[00:00:01.653,747] <inf> app: mqtt state: APP_STATE_MQTT_NOT_CONNECTED
[00:00:30.794,067] <inf> app: event type:APP_EVENT_TYPE_BLE
[00:00:30.800,476] <inf> app: ble state: APP_STATE_BLE_CONNECTED
[00:00:36.786,041] <inf> bt_mesh_main: Primary Element: 0x0002
[00:00:36.792,663] <dbg> bt_mesh_main.bt_mesh_provision: net_idx 0x0000 flags 0x00 iv_index 0x0000
[00:00:36.802,917] <dbg> bt_mesh_net.bt_mesh_net_create: idx 0 flags 0x00 iv_index 0
[00:00:36.811,523] <dbg> bt_mesh_net.bt_mesh_net_create: NetKey 561b2cc3eb0bcf88c0d9c8ad3ba19931
[00:00:36.823,699] <dbg> bt_mesh_net.bt_mesh_net_keys_create: NID 0x09 EncKey 2f6be1b4636aad17986463d9baa4ee1c
[00:00:36.834,625] <dbg> bt_mesh_net.bt_mesh_net_keys_create: PrivacyKey 871d8224abc10fdcae40048b4fa2e649
[00:00:36.846,374] <dbg> bt_mesh_net.bt_mesh_net_keys_create: NetID f17dfcdfc7294841
[00:00:36.856,201] <dbg> bt_mesh_net.bt_mesh_net_keys_create: IdentityKey c307ae03610a6f43c39f10e0dad8adbc
[00:00:36.868,041] <dbg> bt_mesh_net.bt_mesh_net_keys_create: BeaconKey a23cdf2227835733fd0f26dbdbc89f78
[00:00:36.878,448] <dbg> bt_mesh_net.bt_mesh_net_beacon_update: NetIndex 0 Using current key
[00:00:36.887,756] <dbg> bt_mesh_net.bt_mesh_net_beacon_update: flags 0x00, IVI 0x00000000
[00:00:36.897,338] <dbg> bt_mesh_main.bt_mesh_provision: Storing network information persistently
[00:00:36.907,104] <dbg> bt_mesh_settings.schedule_store: Waiting 0 seconds
[00:00:36.914,886] <dbg> bt_mesh_settings.bt_mesh_store_subnet: NetKeyIndex 0x000
[00:00:36.923,217] <dbg> bt_mesh_settings.schedule_store: Waiting 0 seconds
[00:00:36.930,999] <dbg> bt_mesh_settings.schedule_store: Waiting 0 seconds
[00:00:36.938,812] <dbg> bt_mesh_settings.schedule_store: Waiting 0 seconds
[00:00:36.946,594] <dbg> bt_mesh_net.bt_mesh_net_beacon_update: NetIndex 0 Using current key
[00:00:36.955,902] <dbg> bt_mesh_net.bt_mesh_net_beacon_update: flags 0x00, IVI 0x00000000
[00:00:36.965,545] <inf> mesh: prov complete
[00:00:36.970,733] <dbg> bt_mesh_settings.store_pending: 
[00:00:36.976,898] <dbg> bt_mesh_settings.store_net_key: NetKeyIndex 0x000 NetKey 561b2cc3eb0bcf88c0d9c8ad3ba19931
[00:00:36.989,624] <dbg> bt_mesh_settings.store_net_key: Stored NetKey value
[00:00:36.997,467] <dbg> bt_mesh_settings.store_pending_net: addr 0x0002 DevKey 6a86ba18824872c4cfd630031981144f
[00:00:37.009,857] <dbg> bt_mesh_settings.store_pending_net: Stored Network value
[00:00:37.019,409] <dbg> bt_mesh_settings.store_pending_iv: Stored IV value
[00:00:37.028,472] <dbg> bt_mesh_settings.store_pending_seq: Stored Seq value
[00:00:38.001,831] <inf> app: event type:APP_EVENT_TYPE_BLE
[00:00:38.009,246] <inf> app: ble state: APP_STATE_BLE_NOT_CONNECTED
[00:00:40.511,260] <inf> app: event type:APP_EVENT_TYPE_BLE
[00:00:40.517,669] <inf> app: ble state: APP_STATE_BLE_CONNECTED
[00:00:43.996,612] <dbg> bt_mesh_net.bt_mesh_net_recv: rssi 0 net_if 2
[00:00:44.003,967] <dbg> bt_mesh_net.bt_mesh_net_decode: 21 bytes: 0923d5ebf086e95774091491fcf8ef6c8626cff83a
[00:00:44.014,801] <dbg> bt_mesh_net.net_find_and_decrypt: 
[00:00:44.021,118] <dbg> bt_mesh_net.net_decrypt: NID 0x09 net_idx 0x0000
[00:00:44.028,747] <dbg> bt_mesh_net.net_decrypt: IVI 0 net->iv_index 0x00000000
[00:00:44.037,200] <dbg> bt_mesh_net.net_decrypt: src 0x0001
[00:00:44.044,433] <dbg> bt_mesh_net.bt_mesh_net_decode: Decryption successful. Payload len 17
[00:00:44.053,924] <dbg> bt_mesh_net.bt_mesh_net_decode: src 0x0001 dst 0x0002 ttl 5
[00:00:44.062,561] <dbg> bt_mesh_net.bt_mesh_net_decode: PDU: 090500046e00010002006328ae75a6afd2
[00:00:44.072,235] <dbg> bt_mesh_transport.bt_mesh_trans_recv: src 0x0001 dst 0x0002 seq 0x0000046e friend_match 0
[00:00:44.083,587] <dbg> bt_mesh_transport.bt_mesh_trans_recv: Payload 006328ae75a6afd2
[00:00:44.092,437] <dbg> bt_mesh_transport.trans_unseg: AFK 0 AID 0x00
[00:00:44.099,792] <dbg> bt_mesh_settings.schedule_store: Waiting 5 seconds
[00:00:44.107,574] <dbg> bt_mesh_transport.sdu_recv_unseg: AKF 0 AID 0x00
[00:00:44.115,203] <dbg> bt_mesh_transport.sdu_recv_unseg: len 7: 6328ae75a6afd2
[00:00:44.124,267] <dbg> bt_mesh_transport.bt_mesh_trans_send: net_idx 0x0000 app_idx 0xfffe dst 0x0001
[00:00:44.134,643] <dbg> bt_mesh_transport.bt_mesh_trans_send: len 24: 0200f105000000000a000300000004000000020000100310
[00:00:44.147,583] <dbg> bt_mesh_transport.send_seg: src 0x0002 dst 0x0001 app_idx 0xfffe aszmic 1 sdu_len 32
[00:00:44.158,508] <dbg> bt_mesh_transport.send_seg: SeqZero 0x0000 (segs: 3)
[00:00:44.166,473] <dbg> bt_mesh_transport.send_seg: seg 0: 4dc1dde3e7a8885454f4d025
[00:00:44.175,079] <dbg> bt_mesh_transport.send_seg: seg 1: 6930c146adc319b2abdf7e50
[00:00:44.183,685] <dbg> bt_mesh_transport.send_seg: seg 2: 1a5d8676a0a08f3e
[00:00:44.191,558] <dbg> bt_mesh_transport.seg_tx_send_unacked: SeqZero: 0x0000 Attempts: 4
[00:00:44.200,805] <dbg> bt_mesh_transport.seg_tx_send_unacked: Sending 0/2
[00:00:44.208,587] <dbg> bt_mesh_net.bt_mesh_net_send: src 0x0002 dst 0x0001 len 16 headroom 9 tailroom 4
[00:00:44.219,146] <dbg> bt_mesh_net.bt_mesh_net_send: Payload len 16: 808000024dc1dde3e7a8885454f4d025
[00:00:44.229,461] <dbg> bt_mesh_net.bt_mesh_net_send: Seq 0x000000
[00:00:44.236,511] <dbg> bt_mesh_net.bt_mesh_net_encode: src 0x0002 dst 0x0001 ctl 0 seq 0x000000
[00:00:44.247,894] <dbg> bt_mesh_transport.seg_tx_send_unacked: Sending 1/2
[00:00:44.255,676] <dbg> bt_mesh_net.bt_mesh_net_send: src 0x0002 dst 0x0001 len 16 headroom 9 tailroom 4
[00:00:44.266,235] <dbg> bt_mesh_net.bt_mesh_net_send: Payload len 16: 808000226930c146adc319b2abdf7e50
[00:00:44.276,519] <dbg> bt_mesh_net.bt_mesh_net_send: Seq 0x000001
[00:00:44.283,569] <dbg> bt_mesh_net.bt_mesh_net_encode: src 0x0002 dst 0x0001 ctl 0 seq 0x000001
[00:00:44.294,952] <dbg> bt_mesh_transport.seg_tx_send_unacked: Sending 2/2
[00:00:44.302,734] <dbg> bt_mesh_net.bt_mesh_net_send: src 0x0002 dst 0x0001 len 12 headroom 9 tailroom 8
[00:00:44.313,262] <dbg> bt_mesh_net.bt_mesh_net_send: Payload len 12: 808000421a5d8676a0a08f3e
[00:00:44.322,845] <dbg> bt_mesh_net.bt_mesh_net_send: Seq 0x000002
[00:00:44.329,925] <dbg> bt_mesh_net.bt_mesh_net_encode: src 0x0002 dst 0x0001 ctl 0 seq 0x000002
[00:00:44.581,665] <dbg> bt_mesh_net.bt_mesh_net_recv: rssi 0 net_if 2
[00:00:44.589,019] <dbg> bt_mesh_net.bt_mesh_net_decode: 24 bytes: 097ed1628207e2c96b87fceff23c9a27e83093872474be0f
[00:00:44.600,372] <dbg> bt_mesh_net.net_find_and_decrypt: 
[00:00:44.606,719] <dbg> bt_mesh_net.net_decrypt: NID 0x09 net_idx 0x0000
[00:00:44.614,318] <dbg> bt_mesh_net.net_decrypt: IVI 0 net->iv_index 0x00000000
[00:00:44.622,772] <dbg> bt_mesh_net.net_decrypt: src 0x0001
[00:00:44.630,004] <dbg> bt_mesh_net.bt_mesh_net_decode: Decryption successful. Payload len 16
[00:00:44.639,495] <dbg> bt_mesh_net.bt_mesh_net_decode: src 0x0001 dst 0x0002 ttl 5
[00:00:44.648,132] <dbg> bt_mesh_net.bt_mesh_net_decode: PDU: 098500046f0001000200000000000007
[00:00:44.657,623] <dbg> bt_mesh_transport.bt_mesh_trans_recv: src 0x0001 dst 0x0002 seq 0x0000046f friend_match 0
[00:00:44.668,945] <dbg> bt_mesh_transport.bt_mesh_trans_recv: Payload 00000000000007
[00:00:44.677,612] <dbg> bt_mesh_transport.trans_unseg: AFK 0 AID 0x00
[00:00:44.684,967] <dbg> bt_mesh_settings.schedule_store: Not rescheduling due to existing earlier deadline
[00:00:44.695,617] <dbg> bt_mesh_transport.ctl_recv: OpCode 0x00 len 6
[00:00:44.702,941] <dbg> bt_mesh_transport.trans_ack: OBO 0 seq_zero 0x0000 ack 0x00000007
[00:00:44.712,127] <dbg> bt_mesh_transport.trans_ack: seg 0/2 acked
[00:00:44.719,207] <dbg> bt_mesh_transport.trans_ack: seg 1/2 acked
[00:00:44.726,287] <dbg> bt_mesh_transport.trans_ack: seg 2/2 acked
[00:00:44.733,337] <dbg> bt_mesh_transport.trans_ack: SDU TX complete
[00:00:44.922,882] <dbg> bt_mesh_net.bt_mesh_net_recv: rssi 0 net_if 2
[00:00:44.930,236] <dbg> bt_mesh_net.bt_mesh_net_decode: 24 bytes: 0906191b2afafd24e3e35931665bcc02fbee379109d53717
[00:00:44.941,619] <dbg> bt_mesh_net.net_find_and_decrypt: 
[00:00:44.947,937] <dbg> bt_mesh_net.net_decrypt: NID 0x09 net_idx 0x0000
[00:00:44.955,535] <dbg> bt_mesh_net.net_decrypt: IVI 0 net->iv_index 0x00000000
[00:00:44.963,989] <dbg> bt_mesh_net.net_decrypt: src 0x0001
[00:00:44.971,252] <dbg> bt_mesh_net.bt_mesh_net_decode: Decryption successful. Payload len 16
[00:00:44.980,743] <dbg> bt_mesh_net.bt_mesh_net_decode: src 0x0001 dst 0x0002 ttl 5
[00:00:44.989,349] <dbg> bt_mesh_net.bt_mesh_net_decode: PDU: 09850004700001000200000000000007
[00:00:44.998,840] <dbg> bt_mesh_transport.bt_mesh_trans_recv: src 0x0001 dst 0x0002 seq 0x00000470 friend_match 0
[00:00:45.010,192] <dbg> bt_mesh_transport.bt_mesh_trans_recv: Payload 00000000000007
[00:00:45.018,859] <dbg> bt_mesh_transport.trans_unseg: AFK 0 AID 0x00
[00:00:45.026,214] <dbg> bt_mesh_settings.schedule_store: Not rescheduling due to existing earlier deadline
[00:00:45.036,865] <dbg> bt_mesh_transport.ctl_recv: OpCode 0x00 len 6
[00:00:45.044,219] <dbg> bt_mesh_transport.trans_ack: OBO 0 seq_zero 0x0000 ack 0x00000007
[00:00:45.053,375] <wrn> bt_mesh_transport: No matching TX context for ack
[00:00:45.166,595] <dbg> bt_mesh_net.bt_mesh_net_recv: rssi 0 net_if 2
[00:00:45.173,950] <dbg> bt_mesh_net.bt_mesh_net_decode: 20 bytes: 09c6f2b84d44bf6ea2f28db98bbb09b26091b0fe
[00:00:45.184,600] <dbg> bt_mesh_net.net_find_and_decrypt: 
[00:00:45.190,917] <dbg> bt_mesh_net.net_decrypt: NID 0x09 net_idx 0x0000
[00:00:45.198,547] <dbg> bt_mesh_net.net_decrypt: IVI 0 net->iv_index 0x00000000
[00:00:45.207,000] <dbg> bt_mesh_net.net_decrypt: src 0x0001
[00:00:45.214,233] <dbg> bt_mesh_net.bt_mesh_net_decode: Decryption successful. Payload len 16
[00:00:45.223,754] <dbg> bt_mesh_net.bt_mesh_net_decode: src 0x0001 dst 0x0002 ttl 5
[00:00:45.232,360] <dbg> bt_mesh_net.bt_mesh_net_decode: PDU: 090500047100010002003a966b2f9981
[00:00:45.241,851] <dbg> bt_mesh_transport.bt_mesh_trans_recv: src 0x0001 dst 0x0002 seq 0x00000471 friend_match 0
[00:00:45.253,204] <dbg> bt_mesh_transport.bt_mesh_trans_recv: Payload 003a966b2f9981
[00:00:45.261,871] <dbg> bt_mesh_transport.trans_unseg: AFK 0 AID 0x00
[00:00:45.269,226] <dbg> bt_mesh_settings.schedule_store: Not rescheduling due to existing earlier deadline
[00:00:45.279,876] <dbg> bt_mesh_transport.sdu_recv_unseg: AKF 0 AID 0x00
[00:00:45.287,506] <dbg> bt_mesh_transport.sdu_recv_unseg: len 6: 3a966b2f9981
[00:00:45.296,356] <dbg> bt_mesh_transport.bt_mesh_trans_send: net_idx 0x0000 app_idx 0xfffe dst 0x0001
[00:00:45.306,701] <dbg> bt_mesh_transport.bt_mesh_trans_send: len 3: 800e07
[00:00:45.315,429] <dbg> bt_mesh_net.bt_mesh_net_send: src 0x0002 dst 0x0001 len 8 headroom 9 tailroom 12
[00:00:45.325,958] <dbg> bt_mesh_net.bt_mesh_net_send: Payload len 8: 00af21a618403dd9
[00:00:45.334,747] <dbg> bt_mesh_net.bt_mesh_net_send: Seq 0x000003
[00:00:45.341,827] <dbg> bt_mesh_net.bt_mesh_net_encode: src 0x0002 dst 0x0001 ctl 0 seq 0x000003
[00:00:47.068,054] <dbg> bt_mesh_net.bt_mesh_net_recv: rssi 0 net_if 2
[00:00:47.075,408] <dbg> bt_mesh_net.bt_mesh_net_decode: 29 bytes: 092de03828453591da22cfb8971ab9bd32041efbe4824fdbce4e03a3ba
[00:00:47.087,677] <dbg> bt_mesh_net.net_find_and_decrypt: 
[00:00:47.093,994] <dbg> bt_mesh_net.net_decrypt: NID 0x09 net_idx 0x0000
[00:00:47.101,654] <dbg> bt_mesh_net.net_decrypt: IVI 0 net->iv_index 0x00000000
[00:00:47.110,107] <dbg> bt_mesh_net.net_decrypt: src 0x0001
[00:00:47.117,950] <dbg> bt_mesh_net.bt_mesh_net_decode: Decryption successful. Payload len 25
[00:00:47.127,441] <dbg> bt_mesh_net.bt_mesh_net_decode: src 0x0001 dst 0x0002 ttl 5
[00:00:47.136,077] <dbg> bt_mesh_net.bt_mesh_net_decode: PDU: 0905000472000100028011c80148d0d91d5b34f8fe02156889
[00:00:47.147,186] <dbg> bt_mesh_transport.bt_mesh_trans_recv: src 0x0001 dst 0x0002 seq 0x00000472 friend_match 0
[00:00:47.158,538] <dbg> bt_mesh_transport.bt_mesh_trans_recv: Payload 8011c80148d0d91d5b34f8fe02156889
[00:00:47.168,792] <dbg> bt_mesh_transport.trans_seg: ASZMIC 0 AKF 0 AID 0x00
[00:00:47.176,788] <dbg> bt_mesh_transport.trans_seg: SeqZero 0x0472 SegO 0 SegN 1
[00:00:47.185,241] <dbg> bt_mesh_transport.seg_rx_alloc: New RX context. Block Complete 0x00000003
[00:00:47.195,129] <dbg> bt_mesh_transport.trans_seg: Received 0/1
[00:00:47.202,545] <dbg> bt_mesh_net.bt_mesh_net_recv: rssi 0 net_if 2
[00:00:47.209,930] <dbg> bt_mesh_net.bt_mesh_net_decode: 29 bytes: 09446f5284a229720511275468daccc122ec3674998f80e9ceae940c80
[00:00:47.222,198] <dbg> bt_mesh_net.net_find_and_decrypt: 
[00:00:47.228,515] <dbg> bt_mesh_net.net_decrypt: NID 0x09 net_idx 0x0000
[00:00:47.236,145] <dbg> bt_mesh_net.net_decrypt: IVI 0 net->iv_index 0x00000000
[00:00:47.244,598] <dbg> bt_mesh_net.net_decrypt: src 0x0001
[00:00:47.252,227] <dbg> bt_mesh_net.bt_mesh_net_decode: Decryption successful. Payload len 25
[00:00:47.261,718] <dbg> bt_mesh_net.bt_mesh_net_decode: src 0x0001 dst 0x0002 ttl 5
[00:00:47.270,355] <dbg> bt_mesh_net.bt_mesh_net_decode: PDU: 0905000473000100028011c821c85f6760728031bd8608f06d
[00:00:47.281,433] <dbg> bt_mesh_transport.bt_mesh_trans_recv: src 0x0001 dst 0x0002 seq 0x00000473 friend_match 0
[00:00:47.292,785] <dbg> bt_mesh_transport.bt_mesh_trans_recv: Payload 8011c821c85f6760728031bd8608f06d
[00:00:47.303,070] <dbg> bt_mesh_transport.trans_seg: ASZMIC 0 AKF 0 AID 0x00
[00:00:47.311,065] <dbg> bt_mesh_transport.trans_seg: SeqZero 0x0472 SegO 1 SegN 1
[00:00:47.319,488] <dbg> bt_mesh_transport.trans_seg: Existing RX context. Block 0x00000001
[00:00:47.328,735] <dbg> bt_mesh_transport.trans_seg: Target len 1 * 12 + 12 = 24
[00:00:47.337,097] <dbg> bt_mesh_transport.trans_seg: Received 1/1
[00:00:47.344,085] <dbg> bt_mesh_transport.trans_seg: Complete SDU
[00:00:47.351,043] <dbg> bt_mesh_settings.schedule_store: Not rescheduling due to existing earlier deadline
[00:00:47.361,694] <dbg> bt_mesh_transport.send_ack: SeqZero 0x0472 Block 0x00000003 OBO 0
[00:00:47.370,880] <dbg> bt_mesh_transport.bt_mesh_ctl_send: src 0x0002 dst 0x0001 ttl 0xff ctl 0x00
[00:00:47.380,950] <dbg> bt_mesh_transport.bt_mesh_ctl_send: len 6: 11c800000003
[00:00:47.389,190] <dbg> bt_mesh_net.bt_mesh_net_send: src 0x0002 dst 0x0001 len 7 headroom 9 tailroom 13
[00:00:47.399,749] <dbg> bt_mesh_net.bt_mesh_net_send: Payload len 7: 0011c800000003
[00:00:47.408,355] <dbg> bt_mesh_net.bt_mesh_net_send: Seq 0x000004
[00:00:47.415,405] <dbg> bt_mesh_net.bt_mesh_net_encode: src 0x0002 dst 0x0001 ctl 1 seq 0x000004
[00:00:47.426,330] <dbg> bt_mesh_transport.sdu_recv_seg: ASZMIC 0 AKF 0 AID 0x00
[00:00:47.437,103] <dbg> bt_mesh_settings.bt_mesh_store_app_key: AppKeyIndex 0x000
[00:00:47.445,526] <dbg> bt_mesh_settings.schedule_store: Not rescheduling due to existing earlier deadline
[00:00:47.456,176] <dbg> bt_mesh_transport.bt_mesh_trans_send: net_idx 0x0000 app_idx 0xfffe dst 0x0001
[00:00:47.466,522] <dbg> bt_mesh_transport.bt_mesh_trans_send: len 6: 800300000000
[00:00:47.475,769] <dbg> bt_mesh_net.bt_mesh_net_send: src 0x0002 dst 0x0001 len 11 headroom 9 tailroom 9
[00:00:47.486,297] <dbg> bt_mesh_net.bt_mesh_net_send: Payload len 11: 00b79a2e11f40d77b73f57
[00:00:47.495,697] <dbg> bt_mesh_net.bt_mesh_net_send: Seq 0x000005
[00:00:47.502,777] <dbg> bt_mesh_net.bt_mesh_net_encode: src 0x0002 dst 0x0001 ctl 0 seq 0x000005
[00:00:47.513,671] <dbg> bt_mesh_transport.seg_rx_reset: rx 0x20021440
[00:00:49.107,635] <dbg> bt_mesh_settings.store_pending: 
[00:00:49.113,769] <dbg> bt_mesh_settings.store_pending_rpl: 
[00:00:49.120,269] <dbg> bt_mesh_settings.store_rpl: src 0x0001 seq 0x000473 old_iv 0
[00:00:49.130,493] <dbg> bt_mesh_settings.store_rpl: Stored RPL bt/mesh/RPL/1 value
[00:00:49.140,991] <dbg> bt_mesh_settings.store_app_key: Stored AppKey bt/mesh/AppKey/0 value
[00:00:49.261,688] <dbg> bt_mesh_net.bt_mesh_net_recv: rssi 0 net_if 2
[00:00:49.269,042] <dbg> bt_mesh_net.bt_mesh_net_decode: 21 bytes: 09e4a00f1fd2d53c85d8ba2dcf2c91a250f7c08669
[00:00:49.279,876] <dbg> bt_mesh_net.net_find_and_decrypt: 
[00:00:49.286,193] <dbg> bt_mesh_net.net_decrypt: NID 0x09 net_idx 0x0000
[00:00:49.293,792] <dbg> bt_mesh_net.net_decrypt: IVI 0 net->iv_index 0x00000000
[00:00:49.302,246] <dbg> bt_mesh_net.net_decrypt: src 0x0001
[00:00:49.309,478] <dbg> bt_mesh_net.bt_mesh_net_decode: Decryption successful. Payload len 17
[00:00:49.318,969] <dbg> bt_mesh_net.bt_mesh_net_decode: src 0x0001 dst 0x0002 ttl 5
[00:00:49.327,606] <dbg> bt_mesh_net.bt_mesh_net_decode: PDU: 090500047400010002007ef8cb9007dd48
[00:00:49.337,249] <dbg> bt_mesh_transport.bt_mesh_trans_recv: src 0x0001 dst 0x0002 seq 0x00000474 friend_match 0
[00:00:49.348,602] <dbg> bt_mesh_transport.bt_mesh_trans_recv: Payload 007ef8cb9007dd48
[00:00:49.357,421] <dbg> bt_mesh_transport.trans_unseg: AFK 0 AID 0x00
[00:00:49.364,776] <dbg> bt_mesh_settings.schedule_store: Waiting 5 seconds
[00:00:49.372,558] <dbg> bt_mesh_transport.sdu_recv_unseg: AKF 0 AID 0x00
[00:00:49.380,187] <dbg> bt_mesh_transport.sdu_recv_unseg: len 7: 7ef8cb9007dd48
[00:00:49.389,251] <dbg> bt_mesh_settings.schedule_store: Waiting 2 seconds
[00:00:49.397,033] <dbg> bt_mesh_transport.bt_mesh_trans_send: net_idx 0x0000 app_idx 0xfffe dst 0x0001
[00:00:49.407,379] <dbg> bt_mesh_transport.bt_mesh_trans_send: len 3: 80250a
[00:00:49.416,076] <dbg> bt_mesh_net.bt_mesh_net_send: src 0x0002 dst 0x0001 len 8 headroom 9 tailroom 12
[00:00:49.426,605] <dbg> bt_mesh_net.bt_mesh_net_send: Payload len 8: 00035bbbd9411d47
[00:00:49.435,394] <dbg> bt_mesh_net.bt_mesh_net_send: Seq 0x000006
[00:00:49.442,443] <dbg> bt_mesh_net.bt_mesh_net_encode: src 0x0002 dst 0x0001 ctl 0 seq 0x000006
[00:00:51.397,094] <dbg> bt_mesh_settings.store_pending: 
[00:00:51.403,228] <dbg> bt_mesh_settings.store_pending_rpl: 
[00:00:51.409,759] <dbg> bt_mesh_settings.store_rpl: src 0x0001 seq 0x000474 old_iv 0
[00:00:51.418,792] <dbg> bt_mesh_settings.store_rpl: Stored RPL bt/mesh/RPL/1 value
[00:00:51.429,107] <dbg> bt_mesh_settings.store_pending_cfg: Stored configuration value
[00:00:51.437,957] <dbg> bt_mesh_settings.raw value
0a 00 0a 01 01 02 07                             |.......          

Here is the log of the restart after provisioning:

*** Booting Zephyr OS build v2.3.0-rc1-ncs3  ***
[00:00:00.187,255] <dbg> nrf9160_gps.setup: MAGPIO set: AT%XMAGPIO=1,0,0,1,1,1574,1577
[00:00:00.196,441] <dbg> nrf9160_gps.setup: COEX0 set: AT%XCOEX0=1,1,1570,1580
[00:00:00.204,467] <inf> asset_tracker: iLuminate Hub started
main thread: id:537018052, priority:0
[00:00:00.214,874] <inf> google_cloud:  cmd:disconnect, state:STATE_DISCONNECTED
[00:00:01.217,895] <inf> fs_nvs: 2 Sectors of 4096 bytes
[00:00:01.223,999] <inf> fs_nvs: alloc wra: 0, ed0
[00:00:01.229,522] <inf> fs_nvs: data wra: 0, 198
[00:00:01.236,022] <inf> storage: settings_handler_set name:device_uuid
[00:00:01.244,232] <inf> storage: settings_handler_set name:bd_addr
[00:00:01.251,434] <inf> app: hub added to cloud:false
bd_addr found 0xcf, 0x9e, 0x00, 0x00, 0xcf, 0xc0
[00:00:01.276,702] <wrn> bt_hci_core: opcode 0x0000 pool id 7 pool 0x20021220 != &hci_cmd_pool 0x200211f4
[00:00:01.304,077] <inf> bt_hci_core: Identity: c0:cf:00:00:9e:cf (random)
[00:00:01.311,737] <inf> bt_hci_core: HCI: version 5.1 (0x0a) revision 0x0000, manufacturer 0x05f1
[00:00:01.325,042] <inf> bt_hci_core: LMP: version 5.1 (0x0a) subver 0xffff
[00:00:01.577,484] <inf> modem: IMEI 352656100375461
[00:00:01.584,014] <inf> ble: Bluetooth initialized:iLuminate hub 352656100375461

[00:00:01.592,468] <inf> mesh: found device uuid 0000ca81-0000-ca81-0000-ca810000ca81
[00:00:01.601,501] <dbg> bt_mesh_settings.val
0a 00 0a 01 01 02 07                             |.......          
[00:00:01.612,945] <dbg> bt_mesh_settings.cfg_set: Restored configuration state
[00:00:01.621,215] <dbg> bt_mesh_settings.val
00 00 00 67 69 b5 22 c2  bd be bb 06 5a 51 6d 91 |...gi.". ....ZQm.
d3 9c 97 00 00 00 00 00  00 00 00 00 00 00 00 00 |........ ........
00 00 00                                         |...              
[00:00:01.648,223] <dbg> bt_mesh_settings.app_key_set: AppKeyIndex 0x000 recovered from storage
[00:00:01.657,928] <dbg> bt_mesh_settings.val
74 04 00 20                                      |t..              
[00:00:01.669,342] <dbg> bt_mesh_settings.rpl_set: RPL entry for 0x0001: Seq 0x000474 old_iv 0
[00:00:01.679,077] <dbg> bt_mesh_settings.val
00 00 00                                         |...              
[00:00:01.690,460] <dbg> bt_mesh_settings.seq_set: Sequence Number 0x00007f
[00:00:01.698,486] <dbg> bt_mesh_settings.val
00 00 00 00 c0                                   |.....            
[00:00:01.709,899] <dbg> bt_mesh_settings.iv_set: IV Index 0x0000 (IV Update Flag 0) duration 96 hours
[00:00:01.720,489] <dbg> bt_mesh_settings.val
02 00 6a 86 ba 18 82 48  72 c4 cf d6 30 03 19 81 |..j....H r...0...
14 4f                                            |.O               
[00:00:01.738,403] <dbg> bt_mesh_settings.net_set: Provisioned with primary address 0x0002
[00:00:01.747,528] <dbg> bt_mesh_settings.net_set: Recovered DevKey 6a86ba18824872c4cfd630031981144f
[00:00:01.757,843] <dbg> bt_mesh_settings.val
00 56 1b 2c c3 eb 0b cf  88 c0 d9 c8 ad 3b a1 99 |.V.,.... .....;..
31 00 00 00 00 00 00 00  00 00 00 00 00 00 00 00 |1....... ........
00                                               |.                
[00:00:01.782,287] <dbg> bt_mesh_settings.net_key_set: NetKeyIndex 0x000 recovered from storage
[00:00:01.792,114] <inf> storage: settings_handler_set name:device_uuid
[00:00:01.800,445] <inf> storage: settings_handler_set name:bd_addr
[00:00:01.807,678] <dbg> bt_mesh_settings.mesh_commit: sub[0].net_idx 0x000
[00:00:01.817,962] <dbg> bt_mesh_net.bt_mesh_net_keys_create: NID 0x09 EncKey 2f6be1b4636aad17986463d9baa4ee1c
[00:00:01.828,918] <dbg> bt_mesh_net.bt_mesh_net_keys_create: PrivacyKey 871d8224abc10fdcae40048b4fa2e649
[00:00:01.840,637] <dbg> bt_mesh_net.bt_mesh_net_keys_create: NetID f17dfcdfc7294841
[00:00:01.850,494] <dbg> bt_mesh_net.bt_mesh_net_keys_create: IdentityKey c307ae03610a6f43c39f10e0dad8adbc
[00:00:01.862,335] <dbg> bt_mesh_net.bt_mesh_net_keys_create: BeaconKey a23cdf2227835733fd0f26dbdbc89f78
[00:00:01.872,711] <dbg> bt_mesh_net.bt_mesh_net_beacon_update: NetIndex 0 Using current key
[00:00:01.882,049] <dbg> bt_mesh_net.bt_mesh_net_beacon_update: flags 0x00, IVI 0x00000000
[00:00:01.891,632] <dbg> bt_mesh_net.bt_mesh_net_beacon_update: NetIndex 0 Using current key
[00:00:01.900,939] <dbg> bt_mesh_net.bt_mesh_net_beacon_update: flags 0x00, IVI 0x00000000
[00:00:01.914,215] <wrn> bt_hci_core: opcode 0x2005 status 0x0c
[00:00:01.923,858] <err> bt_mesh_adv: starting scan failed (err -5)
[00:00:01.931,182] <inf> mesh: prov complete
[00:00:01.937,347] <inf> mesh: Mesh initialized

[00:00:01.942,718] <inf> app: event type:APP_EVENT_TYPE_MQTT
[00:00:01.949,127] <inf> app: mqtt state: APP_STATE_MQTT_NOT_CONNECTED

My overlay file:

/ {
	chosen {
		zephyr,bt-uart=&uart2;
	};
};

&uart2 {
	compatible = "nordic,nrf-uarte";
	current-speed = <1000000>;
	status = "okay";
	tx-pin = <18>;
	rx-pin = <17>;
	rts-pin = <21>;
	cts-pin = <19>;
};

My prj.conf:

# General config
CONFIG_NEWLIB_LIBC=y
CONFIG_NEWLIB_LIBC_FLOAT_PRINTF=y
CONFIG_ASSERT=y
CONFIG_REBOOT=y
CONFIG_LOG=y
CONFIG_LOG_IMMEDIATE=y

# Network
CONFIG_NETWORKING=y
CONFIG_NET_NATIVE=n
CONFIG_NET_SOCKETS=y
CONFIG_NET_SOCKETS_OFFLOAD=y

# AT
CONFIG_AT_CMD_RESPONSE_MAX_LEN=4096

# LTE link control
CONFIG_POWER_OPTIMIZATION_ENABLE=n
CONFIG_LTE_LINK_CONTROL=y
CONFIG_LTE_NETWORK_MODE_LTE_M_GPS=n
CONFIG_LTE_AUTO_INIT_AND_CONNECT=n
CONFIG_LTE_LINK_CONTROL_LOG_LEVEL_DBG=y

CONFIG_LTE_NETWORK_MODE_NBIOT_GPS=n
CONFIG_LTE_LEGACY_PCO_MODE=n
CONFIG_LTE_PSM_REQ_RPTAU="00000110"
CONFIG_LTE_PSM_REQ_RAT="00000010"
CONFIG_LTE_NETWORK_MODE_NBIOT=y

# Modem info
CONFIG_MODEM_INFO=y

# BSD library
CONFIG_BSD_LIBRARY=y
CONFIG_BSD_LIBRARY_TRACE_ENABLED=n

# MQTT
CONFIG_MQTT_LIB=y
CONFIG_MQTT_LIB_TLS=y

# nRF Cloud
# Needed for the cloud codec
CONFIG_CJSON_LIB=y
# Shorter to prevent NAT timeouts
CONFIG_MQTT_KEEPALIVE=120
# Don't resubscribe to topics if broker remembers them
CONFIG_CLOUD_PERSISTENT_SESSIONS=y

# Sensors
CONFIG_ACCEL_USE_SIM=y
CONFIG_TEMP_USE_SIM=y
CONFIG_CLOUD_BUTTON=n

# GPS
CONFIG_NRF9160_GPS=y
# CONFIG_GPS_USE_SIM=y
CONFIG_NRF9160_GPS_LOG_LEVEL_DBG=y
CONFIG_GPS_USE_EXTERNAL=y
CONFIG_GPS_DEV_NAME="NRF9160_GPS"
CONFIG_GPS_CONTROL_PSM_ENABLE_ON_START=y

CONFIG_GPS_CONTROL_FIRST_FIX_CHECK_DELAY=10
CONFIG_GPS_CONTROL_FIX_CHECK_INTERVAL=30
CONFIG_GPS_CONTROL_FIX_TRY_TIME=360
CONFIG_GPS_CONTROL_PSM_DISABLE_ON_STOP=n

# Library for buttons and LEDs
CONFIG_DK_LIBRARY=y
CONFIG_DK_LIBRARY_INVERT_LEDS=n

# Console
CONFIG_CONSOLE_SUBSYS=y
CONFIG_CONSOLE_HANDLER=y
CONFIG_CONSOLE_GETCHAR=y
# Árpád
# Use RTT as console
# Based on https://devzone.nordicsemi.com/f/nordic-q-a/46083/how-to-setup-zephyr-for-rtt-logging-with-nrf9160
CONFIG_PRINTK=y
CONFIG_CONSOLE=y
CONFIG_SERIAL=y
CONFIG_STDOUT_CONSOLE=y
CONFIG_RTT_CONSOLE=y
CONFIG_USE_SEGGER_RTT=y

# SNTP
CONFIG_SNTP=y

# JWT
CONFIG_JWT=y
CONFIG_JWT_SIGN_ECDSA=y

# Heap and stacks and every kind of size
#   TODO optimize the sizes
# Partially from ncs/zephyr/samples/boards/nrf/mesh/onoff_level_lighting_vnd_app/prj.conf
CONFIG_MAIN_STACK_SIZE=8192
CONFIG_HEAP_MEM_POOL_SIZE=2048
CONFIG_SYSTEM_WORKQUEUE_STACK_SIZE=4096
CONFIG_BT_RX_STACK_SIZE=4096
CONFIG_BT_HCI_TX_STACK_SIZE=512
CONFIG_BT_MESH_MSG_CACHE_SIZE=20
CONFIG_HW_STACK_PROTECTION=y
# counts
CONFIG_BT_L2CAP_TX_BUF_COUNT=8
CONFIG_BT_MESH_ADV_BUF_COUNT=60
CONFIG_BT_MESH_TX_SEG_MAX=6
CONFIG_BT_MESH_TX_SEG_MSG_COUNT=3
CONFIG_BT_MESH_RX_SEG_MAX=6
CONFIG_BT_MESH_RX_SEG_MSG_COUNT=3
CONFIG_BT_RX_BUF_COUNT=30
CONFIG_BT_HCI_CMD_COUNT=6

# MCUBOOT
CONFIG_BOOTLOADER_MCUBOOT=y
CONFIG_IMG_MANAGER=y
CONFIG_MCUBOOT_IMG_MANAGER=y

# Flash
CONFIG_FLASH=y
CONFIG_IMG_ERASE_PROGRESSIVELY=y

# Fatal error
CONFIG_RESET_ON_FATAL_ERROR=n
CONFIG_WATCHDOG=y

# Log to debug Google Cloud IoT connection problem
CONFIG_NET_LOG=y
CONFIG_MQTT_LOG_LEVEL_OFF=n
CONFIG_MQTT_LOG_LEVEL_INF=y

# Google Cloud IoT
CONFIG_GOOGLE_CLOUD_PROJECT_ID="XXXX"
CONFIG_GOOGLE_CLOUD_REGION="XXXX"
CONFIG_GOOGLE_CLOUD_REGISTRY_ID="XXXX"

# Generate credentials
# Based on
#   ncs/zephyr/samples/net/cloud/google_iot_mqtt/prj.conf
#   ncs/PROJECT/build_nrf9160dk_nrf9160ns/mcuboot/zephyr/.config
CONFIG_MBEDTLS=y
CONFIG_MBEDTLS_BUILTIN=y
#   Configure mbedTLS directly with its configuration file instead through Zephyr config symbols
#     Relative from ncs/modules/crypto/mbedtls/configs/config-tls-generic.h
CONFIG_MBEDTLS_CFG_FILE="../../../../PROJECT/config-mbedtls.h"
#   for X509 certificate
# CONFIG_MBEDTLS_ENABLE_HEAP=y
# CONFIG_MBEDTLS_HEAP_SIZE=16384

# Persistent storage
CONFIG_NVS=y
CONFIG_FLASH_PAGE_LAYOUT=y
CONFIG_MPU_ALLOW_FLASH_WRITE=y
CONFIG_NVS_LOG_LEVEL_DBG=y

# Bluetooth BLE
CONFIG_BT=y
CONFIG_BT_DEBUG_LOG=y
CONFIG_BT_SMP=y
CONFIG_BT_SIGNING=y
CONFIG_BT_PERIPHERAL=y
CONFIG_BT_ATT_PREPARE_COUNT=5
#   With y bt_set_id_addr let the sw crash after some seconds.
CONFIG_BT_PRIVACY=n
#   Name, etc
CONFIG_BT_DEVICE_NAME_MAX=65
CONFIG_BT_DEVICE_NAME_DYNAMIC=y
#     https://infocenter.nordicsemi.com/index.jsp?topic=%2Fcom.nordic.infocenter.s132.api.v2.0.0%2Fgroup___b_l_e___a_p_p_e_a_r_a_n_c_e_s.html
CONFIG_BT_DEVICE_APPEARANCE=128
CONFIG_BT_DEVICE_NAME_DYNAMIC=y
CONFIG_BT_DEVICE_NAME_MAX=65
CONFIG_BT_KEYS_OVERWRITE_OLDEST=y
#   Storing in flash
CONFIG_BT_SETTINGS=y
CONFIG_FLASH=y
CONFIG_FLASH_PAGE_LAYOUT=y
CONFIG_FLASH_MAP=y
CONFIG_NVS=y
CONFIG_SETTINGS=y
#   Use nRF52840 as BT controller
#     Disable Modem traces, since we need UART1 for HCI
CONFIG_BSD_LIBRARY_TRACE_ENABLED=n
#     Use UART HCI
CONFIG_BT_H4=y
#       in the right mode
CONFIG_BT_WAIT_NOP=y
#     WARNING don't forget to have overlay file with uart2 definition!
#     without that the invisible CONFIG_UART_2_NRF_UARTE symbol is always false!
CONFIG_UART_2_NRF_FLOW_CONTROL=y
CONFIG_UART_INTERRUPT_DRIVEN=y
# needed for mesh
CONFIG_BT_OBSERVER=y
CONFIG_BT_TINYCRYPT_ECC=y

# Mesh
CONFIG_BT_MESH=y
CONFIG_BT_MESH_MODEL_EXTENSIONS=y
CONFIG_BT_MESH_RELAY=y
CONFIG_BT_MESH_PB_GATT=y
CONFIG_BT_MESH_PB_ADV=y  # TODO needed?
CONFIG_BT_MESH_GATT_PROXY=y
#CONFIG_BT_MESH_LOW_POWER=y
#CONFIG_BT_MESH_LPN_SCAN_LATENCY=30
#CONFIG_BT_MESH_LPN_RECV_DELAY=40
#CONFIG_BT_MESH_LPN_POLL_TIMEOUT=300
CONFIG_BT_MESH_MODEL_KEY_COUNT=2
CONFIG_BT_MESH_SUBNET_COUNT=2
CONFIG_BT_MESH_APP_KEY_COUNT=2
CONFIG_BT_MESH_MODEL_GROUP_COUNT=2
CONFIG_BT_MESH_LABEL_COUNT=3
CONFIG_BT_DEBUG_LOG=y
CONFIG_BT_MESH_DEBUG=y
#CONFIG_BT_MESH_DEBUG_PROV=y
#CONFIG_BT_MESH_DEBUG_PROXY=y
#CONFIG_BT_MESH_DEBUG_BEACON=y
CONFIG_BT_MESH_DEBUG_NET=y
CONFIG_BT_MESH_DEBUG_TRANS=y
CONFIG_BT_MESH_DEBUG_SETTINGS=y
#CONFIG_BT_MESH_DEBUG_LOW_POWER=y
#CONFIG_BT_MESH_DEBUG_FRIEND=y
#CONFIG_BT_MESH_DEBUG_MODEL=y
#CONFIG_BT_MESH_DEBUG_ACCESS=y
#CONFIG_BT_MESH_DEBUG_CRYPTO=y
#CONFIG_BT_MESH_DEBUG_ADV=y
#   Models and utilites from nrf mesh
CONFIG_BT_MESH_LVL_CLI=y

With kind regards,

Árpád

Parents
  • Hi Arpad, 
    Just for clarification could you confirm that you are running BLE controller on the nRF52840 and you run mesh and the BLE host stack on the nRF9160 ? 
    The HCI interface used was UART ? Which exact firmware and BLE stack did you flash on the nRF52840 ?

    You only experienced issue when you do a restart, before that everything operated normally including sending and receiving mesh packets ? 

    When you mentioned restart, what exactly did you do ? Have you made sure the nRF52840 also got restarted ? 


    EDIT: I posted this just to realized that you already found a fix, I will try to have a look. 

  • Hi Hung,

    Thank you for your reply.

    Just for clarification could you confirm that you are running BLE controller on the nRF52840 and you run mesh and the BLE host stack on the nRF9160 ?   

    Yes


    The HCI interface used was UART ?

    Yes

    Which exact firmware and BLE stack did you flash on the nRF52840 ?

    All software is from NCS 1.3.2

    You only experienced issue when you do a restart, before that everything operated normally including sending and receiving mesh packets ? 

    Yes, it took me long time to realize that the scan is not working after restart in provisioned mode, because the GATT bearer worked :) The first sign of the problem was that the relaying didn't work (app  -  nrf9160dk - other node)

    When you mentioned restart, what exactly did you do ? Have you made sure the nRF52840 also got restarted ?

    I turn the dk power completely off and on. 

    Best regards,

    Árpád

Reply
  • Hi Hung,

    Thank you for your reply.

    Just for clarification could you confirm that you are running BLE controller on the nRF52840 and you run mesh and the BLE host stack on the nRF9160 ?   

    Yes


    The HCI interface used was UART ?

    Yes

    Which exact firmware and BLE stack did you flash on the nRF52840 ?

    All software is from NCS 1.3.2

    You only experienced issue when you do a restart, before that everything operated normally including sending and receiving mesh packets ? 

    Yes, it took me long time to realize that the scan is not working after restart in provisioned mode, because the GATT bearer worked :) The first sign of the problem was that the relaying didn't work (app  -  nrf9160dk - other node)

    When you mentioned restart, what exactly did you do ? Have you made sure the nRF52840 also got restarted ?

    I turn the dk power completely off and on. 

    Best regards,

    Árpád

Children
Related