espressif / esp-homekit-sdk

544 stars 98 forks source link

Error in Wi-Fi provisioning #60

Open sateliermartin opened 2 years ago

sateliermartin commented 2 years ago

When executing the examples and trying to provision the WIFI, the Espressif Provisioning Apps find the bluetooth device.

entry 0x40080664
I (27) boot: ESP-IDF v4.4-dev-2487-g8131d6f46-dirty 2nd stage bootloader
I (27) boot: compile time 23:50:41
I (28) boot: chip revision: 1
I (32) boot_comm: chip revision: 1, min. bootloader chip revision: 0
I (39) boot.esp32: SPI Speed      : 40MHz
I (44) boot.esp32: SPI Mode       : DIO
I (48) boot.esp32: SPI Flash Size : 4MB
I (53) boot: Enabling RNG early entropy source...
I (58) boot: Partition Table:
I (62) boot: ## Label            Usage          Type ST Offset   Length
I (69) boot:  0 sec_cert         unknown          3f 00 0000d000 00003000
I (76) boot:  1 nvs              WiFi data        01 02 00010000 00006000
I (84) boot:  2 otadata          OTA data         01 00 00016000 00002000
I (91) boot:  3 phy_init         RF data          01 01 00018000 00001000
I (99) boot:  4 ota_0            OTA app          00 10 00020000 00190000
I (106) boot:  5 ota_1            OTA app          00 11 001b0000 00190000
I (114) boot:  6 factory_nvs      WiFi data        01 02 00340000 00006000
I (121) boot:  7 nvs_keys         NVS keys         01 04 00346000 00001000
I (129) boot: End of partition table
I (133) boot_comm: chip revision: 1, min. application chip revision: 0
I (140) esp_image: segment 0: paddr=00020020 vaddr=3f400020 size=3ec58h (257112) map
I (242) esp_image: segment 1: paddr=0005ec80 vaddr=3ffbdb60 size=01398h (  5016) load
I (244) esp_image: segment 2: paddr=00060020 vaddr=400d0020 size=115310h (1135376) map
I (659) esp_image: segment 3: paddr=00175338 vaddr=3ffbeef8 size=02fe8h ( 12264) load
I (664) esp_image: segment 4: paddr=00178328 vaddr=40080000 size=1b8ach (112812) load
I (711) esp_image: segment 5: paddr=00193bdc vaddr=50000000 size=00010h (    16) load
I (725) boot: Loaded app from partition at offset 0x20000
I (725) boot: Disabling RNG early entropy source...
I (736) cpu_start: Pro cpu up.
I (736) cpu_start: Single core mode
I (747) cpu_start: Pro cpu start user code
I (747) cpu_start: cpu freq: 160000000
I (747) cpu_start: Application information:
I (751) cpu_start: Project name:     lightbulb
I (756) cpu_start: App version:      c62f64d
I (761) cpu_start: Compile time:     Aug  5 2021 23:50:14
I (767) cpu_start: ELF file SHA256:  745e64b142ad374f...
I (773) cpu_start: ESP-IDF:          v4.4-dev-2487-g8131d6f46-dirty
I (781) heap_init: Initializing. RAM available for dynamic allocation:
I (788) heap_init: At 3FF80000 len 00002000 (8 KiB): RTCRAM
I (794) heap_init: At 3FFAFF10 len 000000F0 (0 KiB): DRAM
I (800) heap_init: At 3FFB6388 len 00001C78 (7 KiB): DRAM
I (806) heap_init: At 3FFB9A20 len 00004108 (16 KiB): DRAM
I (812) heap_init: At 3FFCA6B8 len 00015948 (86 KiB): DRAM
I (818) heap_init: At 3FFE0440 len 0001FBC0 (126 KiB): D/IRAM
I (825) heap_init: At 40078000 len 00008000 (32 KiB): IRAM
I (831) heap_init: At 4009B8AC len 00004754 (17 KiB): IRAM
I (838) spi_flash: detected chip: generic
I (842) spi_flash: flash io: dio
I (847) cpu_start: Starting scheduler on PRO CPU.
Keystore initialised
Accessory is not Paired with any controller
Database initialised. Accessory Device ID: 0A:60:FA:B4:26:DF
HAP Initialization succeeded. Version : 4.0-c62f64d
E (914) ledc: freq_hz=5000 duty_resolution=0
I (914) gpio: GPIO[0]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:3
I (924) app_hap_setup_payload: -----QR Code for HomeKit-----
I (934) app_hap_setup_payload: Scan this QR code from the Home app on iOS

  █▀▀▀▀▀█   █▀  █▀▀▀▀▀█
  █ ███ █ █▀▄▀▀ █ ███ █
  █ ▀▀▀ █ ██▀ █ █ ▀▀▀ █
  ▀▀▀▀▀▀▀ █ █ ▀ ▀▀▀▀▀▀▀
  ▀ ▀███▀ ▄▀ ▄█▄██▀██ ▄
  █▄█▄▀▄▀▀▀█▀▄█  ▀  ▄█▄
    ▀▀  ▀▀▄▄▀ ▀▄▀▄ ▄▄█▀
  █▀▀▀▀▀█ ▄  ▄█▀▄█ █ ▀▄
  █ ███ █ █▀█  ▄▀▀█▀  ▀
  █ ▀▀▀ █ ▀█▄ █▄ ▄ █▀ ▄
  ▀▀▀▀▀▀▀ ▀▀ ▀▀▀  ▀▀

I (1014) app_hap_setup_payload: If QR code is not visible, copy paste the below URL in a browser.
https://espressif.github.io/esp-homekit-sdk/qrcode.html?data=X-HM://00527813XES32
MFi auth not supported. Falling back to HAP_MFI_AUTH_NONE
I (1054) wifi:wifi driver task: 3ffcee9c, prio:23, stack:6656, core=0
I (1054) system_api: Base MAC address is not set
I (1054) system_api: read default base MAC address from EFUSE
I (1064) wifi:wifi firmware version: e381636
I (1064) wifi:wifi certification version: v7.0
I (1064) wifi:config NVS flash: enabled
I (1074) wifi:config nano formating: disabled
I (1074) wifi:Init data frame dynamic rx buffer num: 32
I (1074) wifi:Init management frame dynamic rx buffer num: 32
I (1084) wifi:Init management short buffer num: 32
I (1084) wifi:Init dynamic tx buffer num: 32
I (1094) wifi:Init static rx buffer size: 1600
I (1094) wifi:Init static rx buffer num: 10
I (1104) wifi:Init dynamic rx buffer num: 32
I (1104) wifi_init: rx ba win: 6
I (1104) wifi_init: tcpip mbox: 32
I (1114) wifi_init: udp mbox: 10
I (1114) wifi_init: tcp mbox: 6
I (1124) wifi_init: tcp tx win: 5744
I (1124) wifi_init: tcp rx win: 5744
I (1134) wifi_init: tcp mss: 1440
I (1134) wifi_init: WiFi IRAM OP enabled
I (1134) wifi_init: WiFi RX IRAM OP enabled
Setup ID: ES32
HAP Main Loop Started
mDNS initialised
Registering HomeKit web handlers
Announcing _hap._tcp mDNS service
I (1164) wifi_prov_scheme_ble: BT memory released
I (1164) app_wifi: Starting provisioning
I (1184) phy_init: phy_version 4670,719f9f6,Feb 18 2021,17:07:07
I (1264) wifi:mode : sta (3c:61:05:13:54:d8)
I (1264) wifi:enable tsf
I (1274) BTDM_INIT: BT controller compile version [d83d996]
I (1574) wifi_prov_mgr: Provisioning started with service name : PROV_1354D8
I (1574) app_wifi: Provisioning started
I (1574) app_wifi: -----QR Code for ESP Provisioning-----
I (1584) app_wifi: Scan this QR code from the phone app for Provisioning.

  █▀▀▀▀▀█ ▀▀    ▀ ▀  ▀ ▀███ █▀▀▀▀▀█
  █ ███ █ █▄ █▀█ ██▄█▀▄  ▀  █ ███ █
  █ ▀▀▀ █ ▀█▀▀▄ ▀▀▀▀███ ▀ ▄ █ ▀▀▀ █
  ▀▀▀▀▀▀▀ ▀▄▀▄▀ █▄█▄█ ▀ ▀▄▀ ▀▀▀▀▀▀▀
  ▀▀██ ▄▀▄█▄   ▄▄▀█▀ █▀▄ ▄█▀▄ ▀▀█▄█
  ▀█ ▀▀█▀█   ▄▄█▀ ▄▀▀▄▀ ███▀ ▀▄▀▀▀▀
  ▄▀▀▄▀▀▀▄██▄█ ▀▄███ ▄█▄▄█▄▀ █▀▄ ▀
   ▀▄▄ ▄▀ █   █     ██ ▄▀▄ ▄  ▄ █ ▄
   ███ █▀▄▀▄▀▀▄█ ▄▀▄▄ ▀▀▄▀█▄█▄█ █▀█
   ▄▄  ▀▀▀▄▄▀▀█▀▄█▄▄▀▄▄   ▄  ▀▀▄ ▀
  ▄▄ ▀▄▄▀ ▄▀ ▀█▄▀▀█▀▄▄▀▀▀▀ █▄▄  █▀▄
   ▄██ ▄▀▀▄▄█▀▀▄  █   ▀ ██ ▄▄▄ █▀ █
  ▀ ▀ ▀▀▀ █ ▀▄█▀██▄▀▀▄▄   █▀▀▀█▀ ▄▀
  █▀▀▀▀▀█  ▄██ ▀█ ▀ █▀ █▀▄█ ▀ █ █
  █ ███ █ ▄▀▀  █▀▄▀   ▄▀▀▀▀█▀▀▀ ▀█▀
  █ ▀▀▀ █ █ ▀▄▄▀▄▀▄█▀▄▀▀  ▀ █▀▄█▀▀▄
  ▀▀▀▀▀▀▀ ▀ ▀▀▀ ▀  ▀▀  ▀ ▀ ▀▀ ▀ ▀

I (1794) app_wifi: If QR code is not visible, copy paste the below URL in a browser.
https://espressif.github.io/esp-jumpstart/qrcode.html?data={"ver":"v1","name":"PROV_1354D8","pop":"051354d8","transport":"ble"}
I (1814) app_wifi: Provisioning Started. Name : PROV_1354D8, POP : 051354d8

In my iPhone, not found

IMG-5-CE8-A9-A6-DFFE-1

Use a lightbulb example in repo.

vikas-chandra-mnnit commented 2 years ago

Hi @sateliermartin, can you make sure that the BLE device is in the discoverable state and is not connected with any other apps on your iPhone. Also please provide us with these additional information so we can try this out at our end:

  1. App version.
  2. iOS version.
  3. Frequency of issue.
sateliermartin commented 2 years ago

@vikas-chandra-mnnit thanks for the reply.

BLE Config:

#
# Bluetooth controller(ESP32 Dual Mode Bluetooth)
#
CONFIG_BTDM_CTRL_MODE_BLE_ONLY=y
# CONFIG_BTDM_CTRL_MODE_BR_EDR_ONLY is not set
# CONFIG_BTDM_CTRL_MODE_BTDM is not set
CONFIG_BTDM_CTRL_BLE_MAX_CONN=3
CONFIG_BTDM_CTRL_BR_EDR_SCO_DATA_PATH_EFF=0
CONFIG_BTDM_CTRL_PCM_ROLE_EFF=0
CONFIG_BTDM_CTRL_PCM_POLAR_EFF=0
CONFIG_BTDM_CTRL_BLE_MAX_CONN_EFF=3
CONFIG_BTDM_CTRL_BR_EDR_MAX_ACL_CONN_EFF=0
CONFIG_BTDM_CTRL_BR_EDR_MAX_SYNC_CONN_EFF=0
CONFIG_BTDM_CTRL_PINNED_TO_CORE=0
CONFIG_BTDM_CTRL_HCI_MODE_VHCI=y
# CONFIG_BTDM_CTRL_HCI_MODE_UART_H4 is not set

#
# MODEM SLEEP Options
#
CONFIG_BTDM_CTRL_MODEM_SLEEP=y
CONFIG_BTDM_CTRL_MODEM_SLEEP_MODE_ORIG=y
# CONFIG_BTDM_CTRL_MODEM_SLEEP_MODE_EVED is not set
CONFIG_BTDM_CTRL_LPCLK_SEL_MAIN_XTAL=y
# end of MODEM SLEEP Options

CONFIG_BTDM_BLE_DEFAULT_SCA_250PPM=y
CONFIG_BTDM_BLE_SLEEP_CLOCK_ACCURACY_INDEX_EFF=1
CONFIG_BTDM_BLE_SCAN_DUPL=y
CONFIG_BTDM_SCAN_DUPL_TYPE_DEVICE=y
# CONFIG_BTDM_SCAN_DUPL_TYPE_DATA is not set
# CONFIG_BTDM_SCAN_DUPL_TYPE_DATA_DEVICE is not set
CONFIG_BTDM_SCAN_DUPL_TYPE=0
CONFIG_BTDM_SCAN_DUPL_CACHE_SIZE=200
# CONFIG_BTDM_BLE_MESH_SCAN_DUPL_EN is not set
CONFIG_BTDM_CTRL_FULL_SCAN_SUPPORTED=y
CONFIG_BTDM_BLE_ADV_REPORT_FLOW_CTRL_SUPP=y
CONFIG_BTDM_BLE_ADV_REPORT_FLOW_CTRL_NUM=100
CONFIG_BTDM_BLE_ADV_REPORT_DISCARD_THRSHOLD=20
# end of Bluetooth controller(ESP32 Dual Mode Bluetooth)
  1. App version v2.0.11 (5485c79)
  2. IOS version 14.7.1 - iPhone 11 Pro

it is not connected with another application.

On my iPhone on Mac they don't see the device but my Windows PC yes.

lorenzofiamingo commented 2 years ago

Same error here. I think this is because esp32 hasn't a device name. How can we set this?

vikas-chandra-mnnit commented 2 years ago

@sateliermartin We tried replicating the behaviour using:

  1. App version v2.0.11 (5485c79)
  2. iOS version 14.7.1
  3. ESP-IDF v4.4-dev

We did not found any issue and provisioning was successful. If you have made any changes in the ESP-IDF source that you think might be relevant to this issue, please let us know.

We will continue to look into this. Meanwhile, I would suggest that you try some basic steps like restarting the iPhone or re-installing the provisioning apps to check if it works.

Suhas7 commented 2 years ago

I'm also having this issue, flashed on an adafruit esp32 feather. I flashed the vanilla source repo, no adjustments and clean idf install.

sateliermartin commented 2 years ago

Steps to reproduce the problem:

> git clone --recursive https://github.com/espressif/esp-idf.git
> cd esp-idf
> ./install.sh esp32
> . ./export.sh
Detecting the Python interpreter
Checking "python" ...
Python 3.9.6
"python" has been detected
Adding ESP-IDF tools to PATH...
Using Python interpreter in /Users/unknown/.espressif/python_env/idf4.4_py3.9_env/bin/python
Checking if Python packages are up to date...
Python requirements from /Users/unknown/esp-idf/requirements.txt are satisfied.
Updated PATH variable:
  /Users/unknown/esp-idf/components/esptool_py/esptool:/Users/unknown/esp-idf/components/espcoredump:/Users/unknown/esp-idf/components/partition_table:/Users/unknown/esp-idf/components/app_update:/Users/unknown/esp-idf/components/esptool_py/esptool:/Users/unknown/esp-idf/components/espcoredump:/Users/unknown/esp-idf/components/partition_table:/Users/unknown/esp-idf/components/app_update:/Users/unknown/.espressif/tools/xtensa-esp32-elf/esp-2021r1-8.4.0/xtensa-esp32-elf/bin:/Users/unknown/.espressif/tools/xtensa-esp32s2-elf/esp-2021r1-8.4.0/xtensa-esp32s2-elf/bin:/Users/unknown/.espressif/tools/xtensa-esp32s3-elf/esp-2021r1-8.4.0/xtensa-esp32s3-elf/bin:/Users/unknown/.espressif/tools/riscv32-esp-elf/esp-2021r1-8.4.0/riscv32-esp-elf/bin:/Users/unknown/.espressif/tools/esp32ulp-elf/2.28.51-esp-20191205/esp32ulp-elf-binutils/bin:/Users/unknown/.espressif/tools/esp32s2ulp-elf/2.28.51-esp-20191205/esp32s2ulp-elf-binutils/bin:/Users/unknown/.espressif/tools/openocd-esp32/v0.10.0-esp32-20210721/openocd-esp32/bin:/Users/unknown/.espressif/python_env/idf4.4_py3.9_env/bin:/Users/unknown/esp-idf/tools:/opt/homebrew/opt/icu4c/sbin:/opt/homebrew/opt/icu4c/bin:/opt/homebrew/opt/icu4c/sbin:/opt/homebrew/opt/icu4c/bin:/opt/homebrew/opt/openssl@1.1/bin:/opt/homebrew/bin:/opt/homebrew/sbin:/usr/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/Library/Apple/usr/bin:/usr/local/opt/liquibase
Done! You can now compile ESP-IDF projects.
Go to the project directory and run:

  idf.py build
> cd
> git clone --recursive https://github.com/espressif/esp-homekit-sdk.git
> cd esp-homekit-sdk
> cd examples/lightbulb
> export ESPPORT=/dev/cu.usbserial-0001
> idf.py set-target esp32
Adding "set-target"'s dependency "fullclean" to list of commands with default set of options.
Executing action: fullclean
Build directory '/Users/unknown/esp-homekit-sdk/examples/lightbulb/build' not found. Nothing to clean.
Executing action: set-target
Set Target to: esp32, new sdkconfig created. Existing sdkconfig renamed to sdkconfig.old.
Running cmake in directory /Users/unknown/esp-homekit-sdk/examples/lightbulb/build
Executing "cmake -G Ninja -DPYTHON_DEPS_CHECKED=1 -DESP_PLATFORM=1 -DIDF_TARGET=esp32 -DCCACHE_ENABLE=0 /Users/unknown/esp-homekit-sdk/examples/lightbulb"...
-- Found Git: /usr/bin/git (found version "2.30.1 (Apple Git-130)")
-- The C compiler identification is GNU 8.4.0
-- The CXX compiler identification is GNU 8.4.0
-- The ASM compiler identification is GNU
-- Found assembler: /Users/unknown/.espressif/tools/xtensa-esp32-elf/esp-2021r1-8.4.0/xtensa-esp32-elf/bin/xtensa-esp32-elf-gcc
-- Detecting C compiler ABI info
-- Detecting C compiler ABI info - done
-- Check for working C compiler: /Users/unknown/.espressif/tools/xtensa-esp32-elf/esp-2021r1-8.4.0/xtensa-esp32-elf/bin/xtensa-esp32-elf-gcc - skipped
-- Detecting C compile features
-- Detecting C compile features - done
-- Detecting CXX compiler ABI info
-- Detecting CXX compiler ABI info - done
-- Check for working CXX compiler: /Users/unknown/.espressif/tools/xtensa-esp32-elf/esp-2021r1-8.4.0/xtensa-esp32-elf/bin/xtensa-esp32-elf-g++ - skipped
-- Detecting CXX compile features
-- Detecting CXX compile features - done
-- Building ESP-IDF components for target esp32
-- Project sdkconfig file /Users/unknown/esp-homekit-sdk/examples/lightbulb/sdkconfig
Loading defaults file /Users/unknown/esp-homekit-sdk/examples/lightbulb/sdkconfig.defaults...
-- Found PythonInterp: /Users/unknown/.espressif/python_env/idf4.4_py3.9_env/bin/python (found version "3.9.6")
-- Found Perl: /usr/bin/perl (found version "5.30.2")
-- App "lightbulb" version: c62f64d
-- Adding linker script /Users/unknown/esp-homekit-sdk/examples/lightbulb/build/esp-idf/esp_system/ld/memory.ld
-- Adding linker script /Users/unknown/esp-idf/components/esp_system/ld/esp32/sections.ld.in
-- Adding linker script /Users/unknown/esp-idf/components/esp_rom/esp32/ld/esp32.rom.ld
-- Adding linker script /Users/unknown/esp-idf/components/esp_rom/esp32/ld/esp32.rom.api.ld
-- Adding linker script /Users/unknown/esp-idf/components/esp_rom/esp32/ld/esp32.rom.libgcc.ld
-- Adding linker script /Users/unknown/esp-idf/components/esp_rom/esp32/ld/esp32.rom.newlib-data.ld
-- Adding linker script /Users/unknown/esp-idf/components/esp_rom/esp32/ld/esp32.rom.syscalls.ld
-- Adding linker script /Users/unknown/esp-idf/components/esp_rom/esp32/ld/esp32.rom.newlib-funcs.ld
-- Adding linker script /Users/unknown/esp-idf/components/esp_rom/esp32/ld/esp32.rom.newlib-time.ld
-- Adding linker script /Users/unknown/esp-idf/components/soc/esp32/ld/esp32.peripherals.ld
4.0-c62f64d
ESP HomeKit SDK Project commit: c62f64d
-- Components: app_hap_setup_payload app_trace app_update app_wifi asio bootloader bootloader_support bt button cbor cmock coap console cxx driver efuse esp-tls esp32 esp_adc_cal esp_common esp_eth esp_event esp_gdbstub esp_hap_apple_profiles esp_hap_core esp_hap_extras esp_hap_platform esp_hid esp_http_client esp_http_server esp_https_ota esp_https_server esp_hw_support esp_ipc esp_lcd esp_local_ctrl esp_netif esp_phy esp_pm esp_ringbuf esp_rom esp_serial_slave_link esp_system esp_timer esp_websocket_client esp_wifi espcoredump esptool_py expat fatfs freemodbus freertos hal heap hkdf-sha idf_test ieee802154 jsmn json json_generator json_parser libsodium log lwip main mbedtls mdns mqtt mu_srp newlib nghttp nvs_flash openssl openthread partition_table perfmon protobuf-c protocomm pthread qrcode sdmmc soc spi_flash spiffs tcp_transport tcpip_adapter tinyusb ulp unity usb vfs wear_levelling wifi_provisioning wpa_supplicant xtensa
-- Component paths: /Users/unknown/esp-homekit-sdk/examples/common/app_hap_setup_payload /Users/unknown/esp-idf/components/app_trace /Users/unknown/esp-idf/components/app_update /Users/unknown/esp-homekit-sdk/examples/common/app_wifi /Users/unknown/esp-idf/components/asio /Users/unknown/esp-idf/components/bootloader /Users/unknown/esp-idf/components/bootloader_support /Users/unknown/esp-idf/components/bt /Users/unknown/esp-homekit-sdk/components/button /Users/unknown/esp-idf/components/cbor /Users/unknown/esp-idf/components/cmock /Users/unknown/esp-idf/components/coap /Users/unknown/esp-idf/components/console /Users/unknown/esp-idf/components/cxx /Users/unknown/esp-idf/components/driver /Users/unknown/esp-idf/components/efuse /Users/unknown/esp-idf/components/esp-tls /Users/unknown/esp-idf/components/esp32 /Users/unknown/esp-idf/components/esp_adc_cal /Users/unknown/esp-idf/components/esp_common /Users/unknown/esp-idf/components/esp_eth /Users/unknown/esp-idf/components/esp_event /Users/unknown/esp-idf/components/esp_gdbstub /Users/unknown/esp-homekit-sdk/components/homekit/esp_hap_apple_profiles /Users/unknown/esp-homekit-sdk/components/homekit/esp_hap_core /Users/unknown/esp-homekit-sdk/components/homekit/esp_hap_extras /Users/unknown/esp-homekit-sdk/components/homekit/esp_hap_platform /Users/unknown/esp-idf/components/esp_hid /Users/unknown/esp-idf/components/esp_http_client /Users/unknown/esp-idf/components/esp_http_server /Users/unknown/esp-idf/components/esp_https_ota /Users/unknown/esp-idf/components/esp_https_server /Users/unknown/esp-idf/components/esp_hw_support /Users/unknown/esp-idf/components/esp_ipc /Users/unknown/esp-idf/components/esp_lcd /Users/unknown/esp-idf/components/esp_local_ctrl /Users/unknown/esp-idf/components/esp_netif /Users/unknown/esp-idf/components/esp_phy /Users/unknown/esp-idf/components/esp_pm /Users/unknown/esp-idf/components/esp_ringbuf /Users/unknown/esp-idf/components/esp_rom /Users/unknown/esp-idf/components/esp_serial_slave_link /Users/unknown/esp-idf/components/esp_system /Users/unknown/esp-idf/components/esp_timer /Users/unknown/esp-idf/components/esp_websocket_client /Users/unknown/esp-idf/components/esp_wifi /Users/unknown/esp-idf/components/espcoredump /Users/unknown/esp-idf/components/esptool_py /Users/unknown/esp-idf/components/expat /Users/unknown/esp-idf/components/fatfs /Users/unknown/esp-idf/components/freemodbus /Users/unknown/esp-idf/components/freertos /Users/unknown/esp-idf/components/hal /Users/unknown/esp-idf/components/heap /Users/unknown/esp-homekit-sdk/components/homekit/hkdf-sha /Users/unknown/esp-idf/components/idf_test /Users/unknown/esp-idf/components/ieee802154 /Users/unknown/esp-idf/components/jsmn /Users/unknown/esp-idf/components/json /Users/unknown/esp-homekit-sdk/components/homekit/json_generator /Users/unknown/esp-homekit-sdk/components/homekit/json_parser /Users/unknown/esp-idf/components/libsodium /Users/unknown/esp-idf/components/log /Users/unknown/esp-idf/components/lwip /Users/unknown/esp-homekit-sdk/examples/lightbulb/main /Users/unknown/esp-idf/components/mbedtls /Users/unknown/esp-idf/components/mdns /Users/unknown/esp-idf/components/mqtt /Users/unknown/esp-homekit-sdk/components/homekit/mu_srp /Users/unknown/esp-idf/components/newlib /Users/unknown/esp-idf/components/nghttp /Users/unknown/esp-idf/components/nvs_flash /Users/unknown/esp-idf/components/openssl /Users/unknown/esp-idf/components/openthread /Users/unknown/esp-idf/components/partition_table /Users/unknown/esp-idf/components/perfmon /Users/unknown/esp-idf/components/protobuf-c /Users/unknown/esp-idf/components/protocomm /Users/unknown/esp-idf/components/pthread /Users/unknown/esp-homekit-sdk/examples/common/qrcode /Users/unknown/esp-idf/components/sdmmc /Users/unknown/esp-idf/components/soc /Users/unknown/esp-idf/components/spi_flash /Users/unknown/esp-idf/components/spiffs /Users/unknown/esp-idf/components/tcp_transport /Users/unknown/esp-idf/components/tcpip_adapter /Users/unknown/esp-idf/components/tinyusb /Users/unknown/esp-idf/components/ulp /Users/unknown/esp-idf/components/unity /Users/unknown/esp-idf/components/usb /Users/unknown/esp-idf/components/vfs /Users/unknown/esp-idf/components/wear_levelling /Users/unknown/esp-idf/components/wifi_provisioning /Users/unknown/esp-idf/components/wpa_supplicant /Users/unknown/esp-idf/components/xtensa
-- Configuring done
-- Generating done
-- Build files have been written to: /Users/unknown/esp-homekit-sdk/examples/lightbulb/build
> idf.py flash monitor
Executing action: flash
Running ninja in directory /Users/unknown/esp-homekit-sdk/examples/lightbulb/build
Executing "ninja flash"...
[4/1331] Generating ../../partition_table/partition-table.bin
Partition table binary generated. Contents:
*******************************************************************************
# ESP-IDF Partition Table
# Name, Type, SubType, Offset, Size, Flags
sec_cert,63,6,0xd000,12K,
nvs,data,nvs,0x10000,24K,
otadata,data,ota,0x16000,8K,
phy_init,data,phy,0x18000,4K,
ota_0,app,ota_0,0x20000,1600K,
ota_1,app,ota_1,0x1b0000,1600K,
factory_nvs,data,nvs,0x340000,24K,
nvs_keys,data,nvs_keys,0x346000,4K,
*******************************************************************************
[215/1331] Performing configure step for 'bootloader'
-- Found Git: /usr/bin/git (found version "2.30.1 (Apple Git-130)")
-- The C compiler identification is GNU 8.4.0
-- The CXX compiler identification is GNU 8.4.0
-- The ASM compiler identification is GNU
-- Found assembler: /Users/unknown/.espressif/tools/xtensa-esp32-elf/esp-2021r1-8.4.0/xtensa-esp32-elf/bin/xtensa-esp32-elf-gcc
-- Detecting C compiler ABI info
-- Detecting C compiler ABI info - done
-- Check for working C compiler: /Users/unknown/.espressif/tools/xtensa-esp32-elf/esp-2021r1-8.4.0/xtensa-esp32-elf/bin/xtensa-esp32-elf-gcc - skipped
-- Detecting C compile features
-- Detecting C compile features - done
-- Detecting CXX compiler ABI info
-- Detecting CXX compiler ABI info - done
-- Check for working CXX compiler: /Users/unknown/.espressif/tools/xtensa-esp32-elf/esp-2021r1-8.4.0/xtensa-esp32-elf/bin/xtensa-esp32-elf-g++ - skipped
-- Detecting CXX compile features
-- Detecting CXX compile features - done
-- Building ESP-IDF components for target esp32
-- Project sdkconfig file /Users/unknown/esp-homekit-sdk/examples/lightbulb/sdkconfig
-- Adding linker script /Users/unknown/esp-idf/components/soc/esp32/ld/esp32.peripherals.ld
-- Adding linker script /Users/unknown/esp-idf/components/esp_rom/esp32/ld/esp32.rom.ld
-- Adding linker script /Users/unknown/esp-idf/components/esp_rom/esp32/ld/esp32.rom.api.ld
-- Adding linker script /Users/unknown/esp-idf/components/esp_rom/esp32/ld/esp32.rom.libgcc.ld
-- Adding linker script /Users/unknown/esp-idf/components/esp_rom/esp32/ld/esp32.rom.newlib-funcs.ld
-- Adding linker script /Users/unknown/esp-idf/components/bootloader/subproject/main/ld/esp32/bootloader.ld
-- Adding linker script /Users/unknown/esp-idf/components/bootloader/subproject/main/ld/esp32/bootloader.rom.ld
-- Components: bootloader bootloader_support efuse esp32 esp_common esp_hw_support esp_rom esp_system esptool_py freertos hal log main micro-ecc newlib partition_table soc spi_flash xtensa
-- Component paths: /Users/unknown/esp-idf/components/bootloader /Users/unknown/esp-idf/components/bootloader_support /Users/unknown/esp-idf/components/efuse /Users/unknown/esp-idf/components/esp32 /Users/unknown/esp-idf/components/esp_common /Users/unknown/esp-idf/components/esp_hw_support /Users/unknown/esp-idf/components/esp_rom /Users/unknown/esp-idf/components/esp_system /Users/unknown/esp-idf/components/esptool_py /Users/unknown/esp-idf/components/freertos /Users/unknown/esp-idf/components/hal /Users/unknown/esp-idf/components/log /Users/unknown/esp-idf/components/bootloader/subproject/main /Users/unknown/esp-idf/components/bootloader/subproject/components/micro-ecc /Users/unknown/esp-idf/components/newlib /Users/unknown/esp-idf/components/partition_table /Users/unknown/esp-idf/components/soc /Users/unknown/esp-idf/components/spi_flash /Users/unknown/esp-idf/components/xtensa
-- Configuring done
-- Generating done
-- Build files have been written to: /Users/unknown/esp-homekit-sdk/examples/lightbulb/build/bootloader
[303/1331] Performing build step for 'bootloader'
[1/97] Generating project_elf_src_esp32.c
[2/97] Building C object esp-idf/soc/CMakeFiles/__idf_soc.dir/soc_include_legacy_warn.c.obj
[3/97] Building C object CMakeFiles/bootloader.elf.dir/project_elf_src_esp32.c.obj
[4/97] Building C object esp-idf/soc/CMakeFiles/__idf_soc.dir/esp32/gpio_periph.c.obj
[5/97] Building C object esp-idf/soc/CMakeFiles/__idf_soc.dir/esp32/i2c_periph.c.obj
[6/97] Building C object esp-idf/soc/CMakeFiles/__idf_soc.dir/esp32/adc_periph.c.obj
[7/97] Building C object esp-idf/soc/CMakeFiles/__idf_soc.dir/esp32/dac_periph.c.obj
[8/97] Building C object esp-idf/soc/CMakeFiles/__idf_soc.dir/esp32/i2s_periph.c.obj
[9/97] Building C object esp-idf/soc/CMakeFiles/__idf_soc.dir/esp32/interrupts.c.obj
[10/97] Building C object esp-idf/hal/CMakeFiles/__idf_hal.dir/mpu_hal.c.obj
[11/97] Building C object esp-idf/soc/CMakeFiles/__idf_soc.dir/esp32/lcd_periph.c.obj
[12/97] Building C object esp-idf/soc/CMakeFiles/__idf_soc.dir/esp32/ledc_periph.c.obj
[13/97] Building C object esp-idf/soc/CMakeFiles/__idf_soc.dir/esp32/pcnt_periph.c.obj
[14/97] Building C object esp-idf/soc/CMakeFiles/__idf_soc.dir/esp32/mcpwm_periph.c.obj
[15/97] Building C object esp-idf/soc/CMakeFiles/__idf_soc.dir/esp32/rmt_periph.c.obj
[16/97] Building C object esp-idf/soc/CMakeFiles/__idf_soc.dir/esp32/sdmmc_periph.c.obj
[17/97] Building C object esp-idf/soc/CMakeFiles/__idf_soc.dir/esp32/rtc_io_periph.c.obj
[18/97] Building C object esp-idf/soc/CMakeFiles/__idf_soc.dir/esp32/sdio_slave_periph.c.obj
[19/97] Building C object esp-idf/soc/CMakeFiles/__idf_soc.dir/lldesc.c.obj
[20/97] Building C object esp-idf/soc/CMakeFiles/__idf_soc.dir/esp32/timer_periph.c.obj
[21/97] Building C object esp-idf/soc/CMakeFiles/__idf_soc.dir/esp32/uart_periph.c.obj
[22/97] Building C object esp-idf/soc/CMakeFiles/__idf_soc.dir/esp32/sigmadelta_periph.c.obj
[23/97] Building C object esp-idf/soc/CMakeFiles/__idf_soc.dir/esp32/spi_periph.c.obj
[24/97] Building C object esp-idf/soc/CMakeFiles/__idf_soc.dir/esp32/touch_sensor_periph.c.obj
[25/97] Building C object esp-idf/bootloader_support/CMakeFiles/__idf_bootloader_support.dir/src/bootloader_mem.c.obj
[26/97] Building C object esp-idf/hal/CMakeFiles/__idf_hal.dir/cpu_hal.c.obj
[27/97] Building C object esp-idf/hal/CMakeFiles/__idf_hal.dir/wdt_hal_iram.c.obj
[28/97] Building C object esp-idf/bootloader_support/CMakeFiles/__idf_bootloader_support.dir/src/bootloader_clock_init.c.obj
[29/97] Building C object esp-idf/bootloader_support/CMakeFiles/__idf_bootloader_support.dir/src/bootloader_random.c.obj
[30/97] Building C object esp-idf/bootloader_support/CMakeFiles/__idf_bootloader_support.dir/src/bootloader_random_esp32.c.obj
[31/97] Building C object esp-idf/bootloader_support/CMakeFiles/__idf_bootloader_support.dir/src/secure_boot.c.obj
[32/97] Building C object esp-idf/bootloader_support/CMakeFiles/__idf_bootloader_support.dir/src/bootloader_common_loader.c.obj
[33/97] Building C object esp-idf/bootloader_support/CMakeFiles/__idf_bootloader_support.dir/src/flash_encrypt.c.obj
[34/97] Building C object esp-idf/bootloader_support/CMakeFiles/__idf_bootloader_support.dir/src/bootloader_common.c.obj
[35/97] Building C object esp-idf/bootloader_support/CMakeFiles/__idf_bootloader_support.dir/src/flash_partitions.c.obj
[36/97] Building C object esp-idf/bootloader_support/CMakeFiles/__idf_bootloader_support.dir/src/bootloader_efuse_esp32.c.obj
[37/97] Building C object esp-idf/bootloader_support/CMakeFiles/__idf_bootloader_support.dir/src/bootloader_flash.c.obj
[38/97] Building C object esp-idf/bootloader_support/CMakeFiles/__idf_bootloader_support.dir/src/bootloader_clock_loader.c.obj
[39/97] Building C object esp-idf/bootloader_support/CMakeFiles/__idf_bootloader_support.dir/src/flash_qio_mode.c.obj
[40/97] Building C object esp-idf/bootloader_support/CMakeFiles/__idf_bootloader_support.dir/src/bootloader_console_loader.c.obj
[41/97] Building C object esp-idf/bootloader_support/CMakeFiles/__idf_bootloader_support.dir/src/bootloader_console.c.obj
[42/97] Building C object esp-idf/bootloader_support/CMakeFiles/__idf_bootloader_support.dir/src/esp32/bootloader_soc.c.obj
[43/97] Building C object esp-idf/bootloader_support/CMakeFiles/__idf_bootloader_support.dir/src/bootloader_flash_config_esp32.c.obj
[44/97] Building C object esp-idf/spi_flash/CMakeFiles/__idf_spi_flash.dir/esp32/spi_flash_rom_patch.c.obj
[45/97] Building C object esp-idf/efuse/CMakeFiles/__idf_efuse.dir/esp32/esp_efuse_table.c.obj
[46/97] Building C object esp-idf/bootloader_support/CMakeFiles/__idf_bootloader_support.dir/src/bootloader_panic.c.obj
[47/97] Building C object esp-idf/bootloader_support/CMakeFiles/__idf_bootloader_support.dir/src/bootloader_init.c.obj
[48/97] Building C object esp-idf/bootloader_support/CMakeFiles/__idf_bootloader_support.dir/src/bootloader_utility.c.obj
[49/97] Building C object esp-idf/bootloader_support/CMakeFiles/__idf_bootloader_support.dir/src/esp32/bootloader_sha.c.obj
[50/97] Building C object esp-idf/bootloader_support/CMakeFiles/__idf_bootloader_support.dir/src/esp_image_format.c.obj
[51/97] Building C object esp-idf/efuse/CMakeFiles/__idf_efuse.dir/esp32/esp_efuse_fields.c.obj
[52/97] Building C object esp-idf/efuse/CMakeFiles/__idf_efuse.dir/src/esp_efuse_fields.c.obj
[53/97] Building C object esp-idf/esp_hw_support/CMakeFiles/__idf_esp_hw_support.dir/compare_set.c.obj
[54/97] Building C object esp-idf/esp_system/CMakeFiles/__idf_esp_system.dir/esp_err.c.obj
[55/97] Building C object esp-idf/bootloader_support/CMakeFiles/__idf_bootloader_support.dir/src/esp32/bootloader_esp32.c.obj
[56/97] Building C object esp-idf/efuse/CMakeFiles/__idf_efuse.dir/esp32/esp_efuse_utility.c.obj
[57/97] Building C object esp-idf/efuse/CMakeFiles/__idf_efuse.dir/src/esp_efuse_api.c.obj
[58/97] Building C object esp-idf/esp_hw_support/CMakeFiles/__idf_esp_hw_support.dir/port/esp32/rtc_pm.c.obj
[59/97] Building C object esp-idf/esp_hw_support/CMakeFiles/__idf_esp_hw_support.dir/cpu_util.c.obj
[60/97] Building C object esp-idf/efuse/CMakeFiles/__idf_efuse.dir/src/esp_efuse_api_key_esp32.c.obj
[61/97] Building C object esp-idf/esp_hw_support/CMakeFiles/__idf_esp_hw_support.dir/port/esp32/rtc_init.c.obj
[62/97] Building C object esp-idf/esp_hw_support/CMakeFiles/__idf_esp_hw_support.dir/port/esp32/rtc_clk_init.c.obj
[63/97] Building C object esp-idf/efuse/CMakeFiles/__idf_efuse.dir/src/esp_efuse_utility.c.obj
[64/97] Building C object esp-idf/xtensa/CMakeFiles/__idf_xtensa.dir/eri.c.obj
[65/97] Building C object esp-idf/esp_hw_support/CMakeFiles/__idf_esp_hw_support.dir/port/esp32/chip_info.c.obj
[66/97] Building C object esp-idf/esp_rom/CMakeFiles/__idf_esp_rom.dir/patches/esp_rom_crc.c.obj
[67/97] Building C object esp-idf/esp_rom/CMakeFiles/__idf_esp_rom.dir/patches/esp_rom_tjpgd.c.obj
[68/97] Building C object esp-idf/xtensa/CMakeFiles/__idf_xtensa.dir/xt_trax.c.obj
[69/97] Building C object esp-idf/esp_rom/CMakeFiles/__idf_esp_rom.dir/patches/esp_rom_sys.c.obj
[70/97] Building C object esp-idf/esp_hw_support/CMakeFiles/__idf_esp_hw_support.dir/port/esp32/rtc_wdt.c.obj
[71/97] Building ASM object esp-idf/esp_rom/CMakeFiles/__idf_esp_rom.dir/patches/esp_rom_longjmp.S.obj
[72/97] Building C object esp-idf/esp_hw_support/CMakeFiles/__idf_esp_hw_support.dir/port/esp32/rtc_sleep.c.obj
[73/97] Building C object esp-idf/esp_common/CMakeFiles/__idf_esp_common.dir/src/esp_err_to_name.c.obj
[74/97] Building C object esp-idf/esp_hw_support/CMakeFiles/__idf_esp_hw_support.dir/port/esp32/rtc_time.c.obj
[75/97] Building C object esp-idf/esp_rom/CMakeFiles/__idf_esp_rom.dir/patches/esp_rom_uart.c.obj
[76/97] Building C object esp-idf/micro-ecc/CMakeFiles/__idf_micro-ecc.dir/uECC_verify_antifault.c.obj
[77/97] Building C object esp-idf/main/CMakeFiles/__idf_main.dir/bootloader_start.c.obj
[78/97] Building C object esp-idf/log/CMakeFiles/__idf_log.dir/log_noos.c.obj
[79/97] Building C object esp-idf/esp_hw_support/CMakeFiles/__idf_esp_hw_support.dir/port/esp32/rtc_clk.c.obj
[80/97] Building C object esp-idf/log/CMakeFiles/__idf_log.dir/log.c.obj
[81/97] Building C object esp-idf/log/CMakeFiles/__idf_log.dir/log_buffers.c.obj
[82/97] Linking C static library esp-idf/log/liblog.a
[83/97] Linking C static library esp-idf/esp_rom/libesp_rom.a
[84/97] Linking C static library esp-idf/esp_common/libesp_common.a
[85/97] Linking C static library esp-idf/xtensa/libxtensa.a
[86/97] Linking C static library esp-idf/esp_hw_support/libesp_hw_support.a
[87/97] Linking C static library esp-idf/esp_system/libesp_system.a
[88/97] Linking C static library esp-idf/efuse/libefuse.a
[89/97] Linking C static library esp-idf/bootloader_support/libbootloader_support.a
[90/97] Linking C static library esp-idf/spi_flash/libspi_flash.a
[91/97] Linking C static library esp-idf/micro-ecc/libmicro-ecc.a
[92/97] Linking C static library esp-idf/soc/libsoc.a
[93/97] Linking C static library esp-idf/hal/libhal.a
[94/97] Linking C static library esp-idf/main/libmain.a
[95/97] Linking C executable bootloader.elf
[96/97] Generating binary image from built executable
esptool.py v3.2-dev
Merged 1 ELF section
Generated /Users/unknown/esp-homekit-sdk/examples/lightbulb/build/bootloader/bootloader.bin
[97/97] cd /Users/unknown/esp-homekit-sdk/examples/lightbulb/build/bootloader/esp-idf/esptool_py && /Users/unknown/.espressif/python_env/idf4.4_py3.9_env/bin/python /Users/unknown/esp-idf/components/partition_table/check_sizes.py --offset 0x8000 bootloader 0x1000 /Users/unknown/esp-homekit-sdk/examples/lightbulb/build/bootloader/bootloader.bin
Bootloader binary size 0x6280 bytes. 0xd80 bytes (14%) free.
[1329/1331] Generating binary image from built executable
esptool.py v3.2-dev
Merged 25 ELF sections
Generated /Users/unknown/esp-homekit-sdk/examples/lightbulb/build/lightbulb.bin
[1330/1331] cd /Users/unknown/esp-homekit-sdk/examples/lightbulb/build/esp-i...le.bin /Users/unknown/esp-homekit-sdk/examples/lightbulb/build/lightbulb.bin
lightbulb.bin binary size 0x174510 bytes. Smallest app partition is 0x190000 bytes. 0x1baf0 bytes (7%) free.
[1330/1331] cd /Users/unknown/esp-idf/components/esptool_py && /opt/homebrew...build" -P /Users/unknown/esp-idf/components/esptool_py/run_serial_tool.cmake
esptool.py esp32 -p /dev/cu.usbserial-0001 -b 460800 --before=default_reset --after=hard_reset write_flash --flash_mode dio --flash_freq 40m --flash_size 4MB 0x1000 bootloader/bootloader.bin 0x20000 lightbulb.bin 0x8000 partition_table/partition-table.bin 0x16000 ota_data_initial.bin
esptool.py v3.2-dev
Serial port /dev/cu.usbserial-0001
Connecting.................
Chip is ESP32-D0WDQ6 (revision 1)
Features: WiFi, BT, Dual Core, 240MHz, VRef calibration in efuse, Coding Scheme None
Crystal is 40MHz
MAC: 3c:61:05:13:54:d8
Uploading stub...
Running stub...
Stub running...
Changing baud rate to 460800
Changed.
Configuring flash size...
Flash will be erased from 0x00001000 to 0x00007fff...
Flash will be erased from 0x00020000 to 0x00194fff...
Flash will be erased from 0x00008000 to 0x00008fff...
Flash will be erased from 0x00016000 to 0x00017fff...
Compressed 25216 bytes to 15759...
Writing at 0x00001000... (100 %)
Wrote 25216 bytes (15759 compressed) at 0x00001000 in 0.8 seconds (effective 256.0 kbit/s)...
Hash of data verified.
Compressed 1525008 bytes to 962080...
Writing at 0x00020000... (1 %)
Writing at 0x0002cfe6... (3 %)
Writing at 0x0003b1cf... (5 %)
Writing at 0x00040cec... (6 %)
Writing at 0x00045145... (8 %)
Writing at 0x00050bee... (10 %)
Writing at 0x0005addb... (11 %)
Writing at 0x00063d42... (13 %)
Writing at 0x00069569... (15 %)
Writing at 0x0006f1fe... (16 %)
Writing at 0x00074ca7... (18 %)
Writing at 0x0007ab06... (20 %)
Writing at 0x0008041b... (22 %)
Writing at 0x00085d69... (23 %)
Writing at 0x0008bb58... (25 %)
Writing at 0x0009232e... (27 %)
Writing at 0x00097e42... (28 %)
Writing at 0x0009defb... (30 %)
Writing at 0x000a3e2b... (32 %)
Writing at 0x000a9bcc... (33 %)
Writing at 0x000af8d0... (35 %)
Writing at 0x000b57d5... (37 %)
Writing at 0x000bb83d... (38 %)
Writing at 0x000c1a54... (40 %)
Writing at 0x000c73f4... (42 %)
Writing at 0x000cd2d5... (44 %)
Writing at 0x000d36a0... (45 %)
Writing at 0x000d90f3... (47 %)
Writing at 0x000df005... (49 %)
Writing at 0x000e5212... (50 %)
Writing at 0x000ead50... (52 %)
Writing at 0x000f084e... (54 %)
Writing at 0x000f6020... (55 %)
Writing at 0x000fb91c... (57 %)
Writing at 0x00101321... (59 %)
Writing at 0x00106c60... (61 %)
Writing at 0x0010cc4e... (62 %)
Writing at 0x00112dca... (64 %)
Writing at 0x001185d2... (66 %)
Writing at 0x0011d871... (67 %)
Writing at 0x00122be0... (69 %)
Writing at 0x001280d4... (71 %)
Writing at 0x0012d756... (72 %)
Writing at 0x00132f0b... (74 %)
Writing at 0x00138acf... (76 %)
Writing at 0x0013e652... (77 %)
Writing at 0x0014470f... (79 %)
Writing at 0x00149e11... (81 %)
Writing at 0x0014f527... (83 %)
Writing at 0x0015523f... (84 %)
Writing at 0x0015ab79... (86 %)
Writing at 0x00161c3e... (88 %)
Writing at 0x00169c5d... (89 %)
Writing at 0x00172380... (91 %)
Writing at 0x00179b6b... (93 %)
Writing at 0x0017f1e8... (94 %)
Writing at 0x00185008... (96 %)
Writing at 0x0018ac98... (98 %)
Writing at 0x0019034f... (100 %)
Wrote 1525008 bytes (962080 compressed) at 0x00020000 in 23.5 seconds (effective 520.1 kbit/s)...
Hash of data verified.
Compressed 3072 bytes to 178...
Writing at 0x00008000... (100 %)
Wrote 3072 bytes (178 compressed) at 0x00008000 in 0.1 seconds (effective 291.7 kbit/s)...
Hash of data verified.
Compressed 8192 bytes to 31...
Writing at 0x00016000... (100 %)
Wrote 8192 bytes (31 compressed) at 0x00016000 in 0.1 seconds (effective 472.8 kbit/s)...
Hash of data verified.

Leaving...
Hard resetting via RTS pin...
Executing action: monitor
Running idf_monitor in directory /Users/unknown/esp-homekit-sdk/examples/lightbulb
Executing "/Users/unknown/.espressif/python_env/idf4.4_py3.9_env/bin/python /Users/unknown/esp-idf/tools/idf_monitor.py -p /dev/cu.usbserial-0001 -b 115200 --toolchain-prefix xtensa-esp32-elf- --target esp32 --revision 0 /Users/unknown/esp-homekit-sdk/examples/lightbulb/build/lightbulb.elf -m '/Users/unknown/.espressif/python_env/idf4.4_py3.9_env/bin/python' '/Users/unknown/esp-idf/tools/idf.py'"...
--- idf_monitor on /dev/cu.usbserial-0001 115200 ---
--- Quit: Ctrl+] | Menu: Ctrl+T | Help: Ctrl+T followed by Ctrl+H ---
er chip revision: 0
I (38) boot.esp32: SPI Speed    k��2: SPI Mode       : DIO
I (47) boot.esp32: SPI Flash Size : 4MB
I (52) boot: Enabling R�ets Jun  8 2016 00:22:57

rst:0x1 (POWERON_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:6720
load:0x40078000,len:14816
load:0x40080400,len:3584
0x40080400: _init at ??:?

entry 0x40080660
I (26) boot: ESP-IDF v4.4-dev-2977-gdd491ee851 2nd stage bootloader
I (27) boot: compile time 23:12:45
I (27) boot: chip revision: 1
I (31) boot_comm: chip revision: 1, min. bootloader chip revision: 0
I (38) boot.esp32: SPI Speed      : 40MHz
I (43) boot.esp32: SPI Mode       : DIO
I (47) boot.esp32: SPI Flash Size : 4MB
I (52) boot: Enabling RNG early entropy source...
I (57) boot: Partition Table:
I (61) boot: ## Label            Usage          Type ST Offset   Length
I (68) boot:  0 sec_cert         unknown          3f 06 0000d000 00003000
I (75) boot:  1 nvs              WiFi data        01 02 00010000 00006000
I (83) boot:  2 otadata          OTA data         01 00 00016000 00002000
I (90) boot:  3 phy_init         RF data          01 01 00018000 00001000
I (98) boot:  4 ota_0            OTA app          00 10 00020000 00190000
I (105) boot:  5 ota_1            OTA app          00 11 001b0000 00190000
I (113) boot:  6 factory_nvs      WiFi data        01 02 00340000 00006000
I (120) boot:  7 nvs_keys         NVS keys         01 04 00346000 00001000
I (128) boot: End of partition table
I (132) boot: No factory image, trying OTA 0
I (137) boot_comm: chip revision: 1, min. application chip revision: 0
I (144) esp_image: segment 0: paddr=00020020 vaddr=3f400020 size=3ed60h (257376) map
I (246) esp_image: segment 1: paddr=0005ed88 vaddr=3ffbdb60 size=01290h (  4752) load
I (248) esp_image: segment 2: paddr=00060020 vaddr=400d0020 size=11586ch (1136748) map
I (663) esp_image: segment 3: paddr=00175894 vaddr=3ffbedf0 size=03124h ( 12580) load
I (668) esp_image: segment 4: paddr=001789c0 vaddr=40080000 size=1bb08h (113416) load
I (716) esp_image: segment 5: paddr=001944d0 vaddr=50000000 size=00010h (    16) load
I (729) boot: Loaded app from partition at offset 0x20000
I (765) boot: Set actual ota_seq=1 in otadata[0]
I (765) boot: Disabling RNG early entropy source...
I (776) cpu_start: Pro cpu up.
I (776) cpu_start: Single core mode
I (786) cpu_start: Pro cpu start user code
I (786) cpu_start: cpu freq: 160000000
I (786) cpu_start: Application information:
I (791) cpu_start: Project name:     lightbulb
I (796) cpu_start: App version:      c62f64d
I (801) cpu_start: Compile time:     Sep  7 2021 23:12:39
I (807) cpu_start: ELF file SHA256:  fb0cd68fba74084f...
I (813) cpu_start: ESP-IDF:          v4.4-dev-2977-gdd491ee851
I (820) heap_init: Initializing. RAM available for dynamic allocation:
I (827) heap_init: At 3FF80000 len 00002000 (8 KiB): RTCRAM
I (833) heap_init: At 3FFAFF10 len 000000F0 (0 KiB): DRAM
I (839) heap_init: At 3FFB6388 len 00001C78 (7 KiB): DRAM
I (845) heap_init: At 3FFB9A20 len 00004108 (16 KiB): DRAM
I (851) heap_init: At 3FFCA6F0 len 00015910 (86 KiB): DRAM
I (857) heap_init: At 3FFE0440 len 0001FBC0 (126 KiB): D/IRAM
I (864) heap_init: At 40078000 len 00008000 (32 KiB): IRAM
I (870) heap_init: At 4009BB08 len 000044F8 (17 KiB): IRAM
I (877) spi_flash: detected chip: generic
I (881) spi_flash: flash io: dio
I (886) cpu_start: Starting scheduler on PRO CPU.
Keystore initialised
Accessory is not Paired with any controller
Database initialised. Accessory Device ID: 0A:60:FA:B4:26:DF
HAP Initialization succeeded. Version : 4.0-c62f64d
E (953) ledc: freq_hz=5000 duty_resolution=0
I (953) gpio: GPIO[0]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:3
I (963) app_hap_setup_payload: -----QR Code for HomeKit-----
I (973) app_hap_setup_payload: Scan this QR code from the Home app on iOS

  █▀▀▀▀▀█   █▀  █▀▀▀▀▀█
  █ ███ █ █▀▄▀▀ █ ███ █
  █ ▀▀▀ █ ██▀ █ █ ▀▀▀ █
  ▀▀▀▀▀▀▀ █ █ ▀ ▀▀▀▀▀▀▀
  ▀ ▀███▀ ▄▀ ▄█▄██▀██ ▄
  █▄█▄▀▄▀▀▀█▀▄█  ▀  ▄█▄
    ▀▀  ▀▀▄▄▀ ▀▄▀▄ ▄▄█▀
  █▀▀▀▀▀█ ▄  ▄█▀▄█ █ ▀▄
  █ ███ █ █▀█  ▄▀▀█▀  ▀
  █ ▀▀▀ █ ▀█▄ █▄ ▄ █▀ ▄
  ▀▀▀▀▀▀▀ ▀▀ ▀▀▀  ▀▀

I (1053) app_hap_setup_payload: If QR code is not visible, copy paste the below URL in a browser.
https://espressif.github.io/esp-homekit-sdk/qrcode.html?data=X-HM://00527813XES32
MFi auth not supported. Falling back to HAP_MFI_AUTH_NONE
I (1093) wifi:wifi driver task: 3ffceed4, prio:23, stack:6656, core=0
I (1093) system_api: Base MAC address is not set
I (1093) system_api: read default base MAC address from EFUSE
I (1103) wifi:wifi firmware version: d683787
I (1103) wifi:wifi certification version: v7.0
I (1103) wifi:config NVS flash: enabled
I (1113) wifi:config nano formating: disabled
I (1113) wifi:Init data frame dynamic rx buffer num: 32
I (1123) wifi:Init management frame dynamic rx buffer num: 32
I (1123) wifi:Init management short buffer num: 32
I (1133) wifi:Init dynamic tx buffer num: 32
I (1133) wifi:Init static rx buffer size: 1600
I (1133) wifi:Init static rx buffer num: 10
I (1143) wifi:Init dynamic rx buffer num: 32
I (1143) wifi_init: rx ba win: 6
I (1143) wifi_init: tcpip mbox: 32
I (1153) wifi_init: udp mbox: 10
I (1153) wifi_init: tcp mbox: 6
I (1163) wifi_init: tcp tx win: 5744
I (1163) wifi_init: tcp rx win: 5744
I (1173) wifi_init: tcp mss: 1440
I (1173) wifi_init: WiFi IRAM OP enabled
I (1173) wifi_init: WiFi RX IRAM OP enabled
Setup ID: ES32
HAP Main Loop Started
mDNS initialised
Registering HomeKit web handlers
Announcing _hap._tcp mDNS service
I (1213) wifi_prov_scheme_ble: BT memory released
I (1213) app_wifi: Starting provisioning
I (1213) phy_init: phy_version 4670,719f9f6,Feb 18 2021,17:07:07
I (1303) wifi:mode : sta (3c:61:05:13:54:d8)
I (1303) wifi:enable tsf
I (1313) BTDM_INIT: BT controller compile version [bfbbe1e]
I (1613) wifi_prov_mgr: Provisioning started with service name : PROV_1354D8
I (1623) app_wifi: Provisioning started
I (1623) app_wifi: -----QR Code for ESP Provisioning-----
I (1623) app_wifi: Scan this QR code from the phone app for Provisioning.

  █▀▀▀▀▀█ ▀▀    ▀ ▀  ▀ ▀███ █▀▀▀▀▀█
  █ ███ █ █▄ █▀█ ██▄█▀▄  ▀  █ ███ █
  █ ▀▀▀ █ ▀█▀▀▄ ▀▀▀▀███ ▀ ▄ █ ▀▀▀ █
  ▀▀▀▀▀▀▀ ▀▄▀▄▀ █▄█▄█ ▀ ▀▄▀ ▀▀▀▀▀▀▀
  ▀▀██ ▄▀▄█▄   ▄▄▀█▀ █▀▄ ▄█▀▄ ▀▀█▄█
  ▀█ ▀▀█▀█   ▄▄█▀ ▄▀▀▄▀ ███▀ ▀▄▀▀▀▀
  ▄▀▀▄▀▀▀▄██▄█ ▀▄███ ▄█▄▄█▄▀ █▀▄ ▀
   ▀▄▄ ▄▀ █   █     ██ ▄▀▄ ▄  ▄ █ ▄
   ███ █▀▄▀▄▀▀▄█ ▄▀▄▄ ▀▀▄▀█▄█▄█ █▀█
   ▄▄  ▀▀▀▄▄▀▀█▀▄█▄▄▀▄▄   ▄  ▀▀▄ ▀
  ▄▄ ▀▄▄▀ ▄▀ ▀█▄▀▀█▀▄▄▀▀▀▀ █▄▄  █▀▄
   ▄██ ▄▀▀▄▄█▀▀▄  █   ▀ ██ ▄▄▄ █▀ █
  ▀ ▀ ▀▀▀ █ ▀▄█▀██▄▀▀▄▄   █▀▀▀█▀ ▄▀
  █▀▀▀▀▀█  ▄██ ▀█ ▀ █▀ █▀▄█ ▀ █ █
  █ ███ █ ▄▀▀  █▀▄▀   ▄▀▀▀▀█▀▀▀ ▀█▀
  █ ▀▀▀ █ █ ▀▄▄▀▄▀▄█▀▄▀▀  ▀ █▀▄█▀▀▄
  ▀▀▀▀▀▀▀ ▀ ▀▀▀ ▀  ▀▀  ▀ ▀ ▀▀ ▀ ▀

I (1833) app_wifi: If QR code is not visible, copy paste the below URL in a browser.
https://espressif.github.io/esp-jumpstart/qrcode.html?data={"ver":"v1","name":"PROV_1354D8","pop":"051354d8","transport":"ble"}
I (1853) app_wifi: Provisioning Started. Name : PROV_1354D8, POP : 051354d8

NOTE: The QR looks good, here, I don't know why, it looks bad

vikas-chandra-mnnit commented 2 years ago

Hi @sateliermartin @Suhas7, we have tracked down the issue and it may be related to the pairing of BLE devices that was introduced later in the ESP-IDF. Due to this connection with BLE device is successful for the first time but if we do erase_flash on the same device then pairing information is getting erased from the device. However, iOS still keeps this information and tries to pair it with that which ultimately leads to failure.

We are currently working on the fix. For now, you can go to iPhone->Settings->Bluetooth and forget the device from the list and try again. Let us know if doing this fixes your issue.

sateliermartin commented 2 years ago

Hi @vikas-chandra-mnnit, I can't pair the device for the first time so I don't have it on the mentioned list.

wangyz1997 commented 2 years ago

Having the same issue with esp-idf v4.3 on esp32 chip. The provisioning fails because the ble device name is anonymous, so the provisioning app can't find esp32. Later version of esp-idf introduces new menuconfig options, which is default enabled in older versions, and the default value in this repo is not yet up-to-date. So just manually fix it by enabling (Top) -> Component config -> Bluetooth -> Bluedroid Options -> Bluetooth Low Energy -> Include GATT server module(GATTS) -> Include blufi function. This works fine for me. Hoping for compatibility improvements in later versions.

sateliermartin commented 2 years ago

@wangyz1997 thanks, but it didn't work for me.

Could you copy sdkconfg file? I put a copy of mine.

#
# Bluedroid Options
#
CONFIG_BT_BTC_TASK_STACK_SIZE=3072
CONFIG_BT_BLUEDROID_PINNED_TO_CORE=0
CONFIG_BT_BTU_TASK_STACK_SIZE=4096
# CONFIG_BT_BLUEDROID_MEM_DEBUG is not set
# CONFIG_BT_CLASSIC_ENABLED is not set
CONFIG_BT_BLE_ENABLED=y
CONFIG_BT_GATTS_ENABLE=y
# CONFIG_BT_GATTS_PPCP_CHAR_GAP is not set
CONFIG_BT_BLE_BLUFI_ENABLE=y
CONFIG_BT_GATT_MAX_SR_PROFILES=8
# CONFIG_BT_GATTS_SEND_SERVICE_CHANGE_MANUAL is not set
CONFIG_BT_GATTS_SEND_SERVICE_CHANGE_AUTO=y
CONFIG_BT_GATTS_SEND_SERVICE_CHANGE_MODE=0
CONFIG_BT_GATTC_ENABLE=y
# CONFIG_BT_GATTC_CACHE_NVS_FLASH is not set
CONFIG_BT_GATTC_CONNECT_RETRY_COUNT=3
CONFIG_BT_BLE_SMP_ENABLE=y
# CONFIG_BT_SMP_SLAVE_CON_PARAMS_UPD_ENABLE is not set
# CONFIG_BT_STACK_NO_LOG is not set