[FAST_PROV_CLIENT_DEMO] Timeout
Posted: Sat Apr 11, 2020 4:56 pm
While running the FAST_PROV_CLIENT_DEMO on one board and FAST_PROV_SERVER_DEMO in other, I keep receiving a timeout at the client when sending the ESP_BLE_MESH_VND_MODEL_OP_FAST_PROV_NODE_ADDR_GET message to the server. After that occurs, nothing else happens as the client still tries to send the same message.
The obtained log files in both sides are as follow:
Does someone know why this keeps happening? I don't get it since until that step the server node is able to receive all the messages. The current esp-idf branch is version 4.2 but at this point I already tried all the branches and the observed behavior is the same.
The obtained log files in both sides are as follow:
- I (1208) FAST_PROV_CLIENT_DEMO: BLE Mesh Provisioner initialized
- I (13258) FAST_PROV_CLIENT_DEMO: address: 246f28251a6e, address type: 0, adv type: 3
- I (13258) FAST_PROV_CLIENT_DEMO: dev uuid: dddd246f28251a6e0000000000000000
- I (13268) FAST_PROV_CLIENT_DEMO: oob info: 0, bearer: PB-ADV
- I (13278) FAST_PROV_CLIENT_DEMO: ESP_BLE_MESH_PROVISIONER_PROV_LINK_OPEN_EVT, bearer PB-ADV
- I (13278) FAST_PROV_CLIENT_DEMO: PB-ADV link open
- I (13288) FAST_PROV_CLIENT_DEMO: ESP_BLE_MESH_PROVISIONER_ADD_UNPROV_DEV_COMP_EVT, err_code: 0
- I (15228) FAST_PROV_CLIENT_DEMO: ESP_BLE_MESH_PROVISIONER_PROV_COMPLETE_EVT
- I (15228) FAST_PROV_CLIENT_DEMO: Node index: 0x0, unicast address: 0x05, element num: 1, netkey index: 0x00
- I (15238) FAST_PROV_CLIENT_DEMO: Node uuid: dddd246f28251a6e0000000000000000
- I (15248) FAST_PROV_CLIENT_DEMO: ESP_BLE_MESH_PROVISIONER_SET_NODE_NAME_COMP_EVT, err_code: 0
- I (15718) FAST_PROV_CLIENT_DEMO: example_config_client_callback, error_code = 0x00, event = 0x01, addr: 0x0005
- I (15728) FAST_PROV_OP: min: 0x0006, max: 0x7fff
- I (15728) FAST_PROV_OP: flags: 0x00, iv_index: 0x00000000
- I (15738) FAST_PROV_OP: net_idx: 0x0000, group_addr: 0xc000
- I (15738) FAST_PROV_OP: action: 0x81
- I (15748) FAST_PROV_OP: match_val: dd dd
- I (15748) 8.2.: chamada: esp_ble_mesh_client_model_send_msg()
- I (15758) 8.3.: executada: esp_ble_mesh_client_model_send_msg()
- I (15778) FAST_PROV_CLIENT_DEMO: ESP_BLE_MESH_MODEL_SEND_COMP_EVT, err_code 0
- I (16168) FAST_PROV_CLIENT_DEMO: example_custom_model_callback: Fast Prov Client Model receives status, opcode 0xc102e5
- I (16168) fast prov client receives: 7f 00 00 00 00 00 00 00 00
- I (16178) fast prov info status: 7f 00 00 00 00 00 00 00 00
- I (16188) 23. : chamada: k_delayed_work_init()
- I (16188) 24. : executada: k_delayed_work_init(), chamada: k_delayed_work_submit()
- I (16198) 25. : executada: k_delayed_work_submit()
- W (16658) BLE_MESH: Got segment for already complete SDU
- W (16738) BLE_MESH: Got segment for already complete SDU
- I (17218) FAST_PROV_CLIENT_DEMO: ESP_BLE_MESH_PROVISIONER_PROV_LINK_CLOSE_EVT, bearer PB-ADV reason 0x00
- I (17218) FAST_PROV_CLIENT_DEMO: PB-ADV link close, reason 0x00
- W (17238) BLE_MESH: Got segment for already complete SDU
- W (17318) BLE_MESH: Got segment for already complete SDU
- W (17818) BLE_MESH: Got segment for already complete SDU
- W (17898) BLE_MESH: Got segment for already complete SDU
- W (18398) BLE_MESH: Got segment for already complete SDU
- W (18478) BLE_MESH: Got segment for already complete SDU
- I (76208) FAST_PROV_CLIENT_DEMO: ESP_BLE_MESH_MODEL_SEND_COMP_EVT, err_code 0
- I (86208) FAST_PROV_CLIENT_DEMO: ESP_BLE_MESH_CLIENT_MODEL_SEND_TIMEOUT_EVT, opcode 0xc602e5, dst 0x0005
- W (86208) FAST_PROV_CLIENT: example_fast_prov_client_recv_timeout: Receive fast prov server status timeout
- I (86228) FAST_PROV_CLIENT_DEMO: ESP_BLE_MESH_MODEL_SEND_COMP_EVT, err_code 0
- I (96228) FAST_PROV_CLIENT_DEMO: ESP_BLE_MESH_CLIENT_MODEL_SEND_TIMEOUT_EVT, opcode 0xc602e5, dst 0x0005
- W (96228) FAST_PROV_CLIENT: example_fast_prov_client_recv_timeout: Receive fast prov server status timeout
- I (3908) FAST_PROV_SERVER_DEMO: ESP_BLE_MESH_PROV_REGISTER_COMP_EVT, err_code: 0
- I (3918) FAST_PROV_SERVER_DEMO: ESP_BLE_MESH_NODE_PROV_ENABLE_COMP_EVT, err_code: 0
- I (3918) FAST_PROV_SERVER_DEMO: BLE Mesh Fast Prov Node initialized
- I (3968) FAST_PROV_SERVER_DEMO: ESP_BLE_MESH_NODE_PROV_LINK_OPEN_EVT, bearer: PB-ADV
- I (5848) FAST_PROV_SERVER_DEMO: ESP_BLE_MESH_NODE_PROV_COMPLETE_EVT
- I (5848) FAST_PROV_SERVER_DEMO: net_idx: 0x0000, unicast_addr: 0x0005
- I (5848) FAST_PROV_SERVER_DEMO: flags: 0x00, iv_index: 0x00000000
- I (6068) FAST_PROV_SERVER_DEMO: ESP_BLE_MESH_NODE_PROV_LINK_CLOSE_EVT, bearer: PB-ADV
- I (6248) FAST_PROV_SERVER_DEMO: example_ble_mesh_config_server_cb, event = 0x00, opcode = 0x0000, addr: 0x0001
- I (6248) FAST_PROV_SERVER_DEMO: Config Server get Config AppKey Add
- I (6608) FAST_PROV_SERVER_DEMO: example_ble_mesh_custom_model_cb: Fast prov server receives msg, opcode 0xc002e5
- I (6618) fast prov server recv: 7f 03 64 00 06 00 ff 7f 00 00 00 00 00 00 00 00
- I (6618) fast prov server recv: c0 dd dd 81
- I (6628) FAST_PROV_SERVER_DEMO: ESP_BLE_MESH_SET_FAST_PROV_INFO_COMP_EVT
- I (6638) FAST_PROV_SERVER_DEMO: status_unicast: 0x00, status_net_idx: 0x00, status_match 0x00
- I (6638) 13. : chamada: esp_ble_mesh_set_fast_prov_action()
- I (6648) 14. : executada: esp_ble_mesh_set_fast_prov_action()
- I (6658) FAST_PROV_SERVER_DEMO: ESP_BLE_MESH_SET_FAST_PROV_ACTION_COMP_EVT, status_action 0x00
- I (6668) 19. : chamada: example_send_fast_prov_status_msg()
- I (6668) 20. : executada: example_send_fast_prov_status_msg()
- I (6678) FAST_PROV_SERVER_DEMO: ESP_BLE_MESH_MODEL_SEND_COMP_EVT, err_code 0
- I (6688) FAST_PROV_SERVER: example_handle_fast_prov_status_send_comp_evt: opcode 0xc102e5
- W (6698) FAST_PROV_SERVER: example_handle_fast_prov_status_send_comp_evt: Disable BLE Mesh Relay & GATT Proxy
- I (6708) 20.4. : chamada: esp_ble_mesh_proxy_gatt_disable()
- I (6708) 20.5. : executada: esp_ble_mesh_proxy_gatt_disable()
- I (6718) FAST_PROV_SERVER_DEMO: ESP_BLE_MESH_NODE_PROXY_GATT_DISABLE_COMP_EVT
Does someone know why this keeps happening? I don't get it since until that step the server node is able to receive all the messages. The current esp-idf branch is version 4.2 but at this point I already tried all the branches and the observed behavior is the same.