You signed in with another tab or window. Reload to refresh your session.You signed out in another tab or window. Reload to refresh your session.You switched accounts on another tab or window. Reload to refresh your session.Dismiss alert
I have updated my IDF branch (release/vX.Y) to the latest version and checked that the issue is present there. This is not applicable if you are using Rainmaker with Arduino.
I have searched the Rainmaker forum and issue tracker for a similar issue and not found a similar issue.
IDF / ESP32-Arduino version.
V5.0.6
Operating System used.
Linux
How did you build your project?
Command line with idf.py
Development Kit.
ESP32-C3-DevKit
What is the expected behavior?
I expect I can run the matter+rainmaker switch example,but it failed.
What is the actual behavior?
I follow the rainmaker docs step by step, after downloading and run, the chip always reboot ,
SPIWP:0xee
mode:DIO, clock div:1
load:0x3fcd5820,len:0x16a8
load:0x403cc710,len:0x95c
load:0x403ce710,len:0x2eac
entry 0x403cc710
I (35) boot: ESP-IDF v5.0.6-dirty 2nd stage bootloader
I (35) boot: compile time 23:47:42
I (35) boot: chip revision: v0.4
I (37) boot.esp32c3: SPI Speed : 80MHz
I (42) boot.esp32c3: SPI Mode : DIO
I (47) boot.esp32c3: 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 esp_secure_cert unknown 3f 06 0000d000 00002000
I (75) boot: 1 nvs WiFi data 01 02 00010000 0000c000
I (83) boot: 2 nvs_keys NVS keys 01 04 0001c000 00001000
I (90) boot: 3 otadata OTA data 01 00 0001d000 00002000
I (98) boot: 4 phy_init RF data 01 01 0001f000 00001000
I (105) boot: 5 ota_0 OTA app 00 10 00020000 001e0000
I (113) boot: 6 ota_1 OTA app 00 11 00200000 001e0000
I (120) boot: 7 fctry WiFi data 01 02 003e0000 00006000
I (128) boot: End of partition table
I (132) esp_image: segment 0: paddr=00020020 vaddr=3c140020 size=5d978h (383352) map
I (201) esp_image: segment 1: paddr=0007d9a0 vaddr=3fc94c00 size=02678h ( 9848) load
I (203) esp_image: segment 2: paddr=00080020 vaddr=42000020 size=13de38h (1302072) map
I (410) esp_image: segment 3: paddr=001bde60 vaddr=3fc97278 size=00c64h ( 3172) load
I (411) esp_image: segment 4: paddr=001beacc vaddr=40380000 size=14ad8h ( 84696) load
I (431) esp_image: segment 5: paddr=001d35ac vaddr=50000010 size=00004h ( 4) load
I (437) boot: Loaded app from partition at offset 0x20000
I (438) boot: Disabling RNG early entropy source...
I (452) cpu_start: Unicore app
I (452) cpu_start: Pro cpu up.
I (460) cpu_start: Pro cpu start user code
I (460) cpu_start: cpu freq: 160000000 Hz
I (460) cpu_start: Application information:
I (463) cpu_start: Project name: matter_switch
I (469) cpu_start: App version: d0960b4
I (474) cpu_start: Compile time: Apr 29 2024 09:03:59
I (480) cpu_start: ELF file SHA256: d4fab19c71456fce...
I (486) cpu_start: ESP-IDF: v5.0.6-dirty
I (491) cpu_start: Min chip rev: v0.3
I (496) cpu_start: Max chip rev: v1.99
I (501) cpu_start: Chip rev: v0.4
I (506) heap_init: Initializing. RAM available for dynamic allocation:
I (513) heap_init: At 3FCAA190 len 00032580 (201 KiB): DRAM
I (519) heap_init: At 3FCDC710 len 00002950 (10 KiB): STACK/DRAM
I (526) heap_init: At 50000014 len 00001FD4 (7 KiB): RTCRAM
I (533) spi_flash: detected chip: generic
I (537) spi_flash: flash io: dio
W (541) rmt(legacy): legacy driver is deprecated, please migrate to driver/rmt_tx.h and/or driver/rmt_rx.h
I (552) sleep: Configure to isolate all GPIO pins in sleep state
I (558) sleep: Enable automatic switching of GPIO sleep configuration
I (565) coexist: coexist rom version 9387209
I (570) app_start: Starting scheduler on CPU0
I (575) main_task: Started on CPU0
I (575) main_task: Calling app_main()
I (585) led_driver_ws2812: Initializing light driver
I (585) led_driver_ws2812: led set r:0, g:0, b:0
I (585) gpio: GPIO[9]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:0
I (605) app_matter: Switch created with endpoint_id 1
I (605) pp: pp rom version: 9387209
I (605) net80211: net80211 rom version: 9387209
I (625) wifi:wifi driver task: 3fcb6bd4, prio:23, stack:6656, core=0
I (625) system_api: Base MAC address is not set
I (625) system_api: read default base MAC address from EFUSE
I (635) wifi:wifi firmware version: dbb7b72
I (635) wifi:wifi certification version: v7.0
I (635) wifi:config NVS flash: enabled
I (645) wifi:config nano formating: disabled
I (645) wifi:Init data frame dynamic rx buffer num: 32
I (655) wifi:Init static rx mgmt buffer num: 5
I (655) wifi:Init management short buffer num: 32
I (665) wifi:Init dynamic tx buffer num: 32
I (665) wifi:Init static tx FG buffer num: 2
I (665) wifi:Init static rx buffer size: 1600
I (675) wifi:Init static rx buffer num: 10
I (675) wifi:Init dynamic rx buffer num: 32
I (685) wifi_init: rx ba win: 6
I (685) wifi_init: tcpip mbox: 32
I (685) wifi_init: udp mbox: 6
I (695) wifi_init: tcp mbox: 6
I (695) wifi_init: tcp tx win: 5760
I (695) wifi_init: tcp rx win: 5760
I (705) wifi_init: tcp mss: 1440
I (705) wifi_init: WiFi IRAM OP enabled
I (715) wifi_init: WiFi RX IRAM OP enabled
I (735) chip[DL]: NVS set: chip-counters/reboot-count = 1508 (0x5E4)
I (735) chip[DL]: Real time clock set to 946684800 (0100/00/01 00:00:00 UTC)
I (735) BLE_INIT: BT controller compile version [9359a4d]
I (745) BLE_INIT: Bluetooth MAC: ec:da:3b:cc:bd:d6
I (745) phy_init: phy_version 1150,7c3c08f,Jan 24 2024,17:32:21
I (785) NimBLE: GAP procedure initiated: stop advertising.
I (795) CHIP[DL]: BLE host-controller synced
I (1295) chip[DL]: Configuring CHIPoBLE advertising (interval 25 ms, connectable)
I (1295) NimBLE: GAP procedure initiated: advertise;
I (1295) NimBLE: disc_mode=2
I (1295) NimBLE: adv_channel_map=0 own_addr_type=1 adv_filter_policy=0 adv_itvl_min=40 adv_itvl_max=40
I (1305) NimBLE:
I (1315) chip[DL]: CHIPoBLE advertising started
I (1315) chip[DL]: Starting ESP WiFi layer
I (1325) wifi:mode : sta (ec:da:3b:cc:bd:d4)
I (1325) wifi:enable tsf
W (1325) wifi:Haven't to connect to a suitable AP now!
I (1335) chip[DL]: Done driving station state, nothing else to do...
W (1335) wifi:Haven't to connect to a suitable AP now!
I (1345) chip[DL]: Done driving station state, nothing else to do...
I (1355) chip[SVR]: Initializing subscription resumption storage...
I (1355) chip[SVR]: Server initializing...
I (1365) chip[TS]: Last Known Good Time: 2023-10-14T01:16:48
I (1365) chip[DMG]: AccessControl: initializing
I (1375) chip[DMG]: Examples::AccessControlDelegate::Init
I (1385) chip[DMG]: AccessControl: setting
I (1385) chip[DMG]: DefaultAclStorage: initializing
I (1395) chip[DMG]: DefaultAclStorage: 0 entries loaded
I (1405) chip[ZCL]: Using ZAP configuration...
I (1405) esp_matter_cluster: Cluster plugin init common callback
I (1405) chip[DMG]: AccessControlCluster: initializing
I (1415) chip[ZCL]: 0x3c1511d8ep 0 clus 0x0000_0030 attr 0x0000_0000 not supported
I (1425) chip[ZCL]: Initiating Admin Commissioning cluster.
I (1435) chip[DIS]: Updating services using commissioning mode 1
I (1435) chip[DIS]: CHIP minimal mDNS started advertising.
I (1445) chip[DIS]: Advertise commission parameter vendorID=4891 productID=2 discriminator=2551/09 cm=1
I (1455) chip[DIS]: CHIP minimal mDNS configured as 'Commissionable node device'; instance name: EE343A640B9004BF.
I (1465) chip[DIS]: mDNS service published: _matterc._udp
I (1465) chip[IN]: CASE Server enabling CASE session setups
I (1475) chip[SVR]: Joining Multicast groups
I (1485) chip[SVR]: Server Listening...
I (1485) esp_matter_core: Dynamic endpoint 0 added
I (1495) esp_matter_attribute: ********** W : Endpoint 0x0001's Cluster 0x00000003's Attribute 0x00000001 is 0 **********
I (1505) esp_matter_attribute: ********** W : Endpoint 0x0001's Cluster 0x00000004's Attribute 0x00000000 is 128 **********
I (1515) esp_matter_attribute: ********** W : Endpoint 0x0001's Cluster 0x00000004's Attribute 0x0000FFFC is <invalid type: 0> **********
I (1525) esp_matter_core: Dynamic endpoint 1 added
I (1535) chip[DL]: WIFI_EVENT_STA_START
W (1535) wifi:Haven't to connect to a suitable AP now!
I (1545) chip[DL]: Done driving station state, nothing else to do...
I (1545) chip[DL]: Configuring CHIPoBLE advertising (interval 25 ms, connectable)
I (1555) chip[DL]: Device already advertising, stop active advertisement and restart
I (1565) NimBLE: GAP procedure initiated: stop advertising.
I (1575) NimBLE: GAP procedure initiated: advertise;
I (1575) NimBLE: disc_mode=2
I (1585) NimBLE: adv_channel_map=0 own_addr_type=1 adv_filter_policy=0 adv_itvl_min=40 adv_itvl_max=40
I (1595) NimBLE:
E (1595) esp_matter_client: failed to notify the bound cluster changed
I (1605) esp_rmaker_work_queue: Work Queue created.
I (1605) esp_mqtt_glue: AWS PPI: ?Platform=APN3|A0|RM|EX00|RMDev|1x0|ECDA3BCCBDD4
I (1615) esp_mqtt_glue: Initialising MQTT
I (1615) esp_rmaker_mqtt_budget: MQTT Budgeting initialised. Default: 100, Max: 1024, Revive count: 1, Revive period: 5
I (1635) esp_rmaker_node: Node ID ----- WWhfctC2WPRRx3jNrvqvqD
I (1635) esp_rmaker_ota_using_params: OTA enabled with Params
I (1645) esp_rmaker_ota: OTA state = 2
I (1645) esp_rmaker_time: Initializing SNTP. Using the SNTP server: pool.ntp.org
assert failed: sntp_setoperatingmode /IDF/components/lwip/lwip/src/apps/sntp/sntp.c:732 (Required to lock TCPIP core functionality!)
Core 0 register dump:
MEPC : 0x403808bc RA : 0x4038a684 SP : 0x3fcacf20 GP : 0x3fc95400
Stack dump detected
0x403808bc: panic_abort at /mnt/d/ubuntu/esp-idf/components/esp_system/panic.c:425
0x4038a684: __ubsan_include at /mnt/d/ubuntu/esp-idf/components/esp_system/ubsan.c:313
panic_abort (details=details@entry=0x3fcacf78 "assert failed: sntp_setoperatingmode /IDF/components/lwip/lwip/src/apps/sntp/sntp.c:732 (Required to lock TCPIP core functionality!)") at /mnt/d/ubuntu/esp-idf/components/esp_system/panic.c:425
425 *((volatile int *) 0) = 0; // NOLINT(clang-analyzer-core.NullDereference) should be an invalid operation on targets
#0 panic_abort (details=details@entry=0x3fcacf78 "assert failed: sntp_setoperatingmode /IDF/components/lwip/lwip/src/apps/sntp/sntp.c:732 (Required to lock TCPIP core functionality!)") at /mnt/d/ubuntu/esp-idf/components/esp_system/panic.c:425 #1 0x4038a684 in esp_system_abort (details=details@entry=0x3fcacf78 "assert failed: sntp_setoperatingmode /IDF/components/lwip/lwip/src/apps/sntp/sntp.c:732 (Required to lock TCPIP core functionality!)") at /mnt/d/ubuntu/esp-idf/components/esp_system/esp_system.c:153 #2 0x40390ed2 in __assert_func (file=, file@entry=0x3c172744 "", line=, func=, expr=) at /mnt/d/ubuntu/esp-idf/components/newlib/assert.c:78 #3 0x4206b75c in sntp_setoperatingmode (operating_mode=operating_mode@entry=0 '\000') at /mnt/d/ubuntu/esp-idf/components/lwip/lwip/src/apps/sntp/sntp.c:733 #4 0x42059c84 in esp_rmaker_time_sync_init (config=config@entry=0x0) at /mnt/d/ubuntu/esp-rainmaker/components/rmaker_common/src/time.c:224 #5 0x42010216 in esp_rmaker_ota_enable (ota_config=, type=) at /mnt/d/ubuntu/esp-rainmaker/components/esp_rainmaker/src/ota/esp_rmaker_ota.c:713 #6 0x42007866 in app_main () at /mnt/d/ubuntu/esp-rainmaker/examples-wenxe/matter/matter_switch/main/app_main.cpp:88 #7 0x4213d4ea in main_task (args=) at /mnt/d/ubuntu/esp-idf/components/freertos/app_startup.c:208 #8 0x4038a68c in vPortTaskWrapper (pxCode=, pvParameters=) at /mnt/d/ubuntu/esp-idf/components/freertos/FreeRTOS-Kernel/portable/riscv/port.c:127
ELF file SHA256: d4fab19c71456fce
SPIWP:0xee
mode:DIO, clock div:1
load:0x3fcd5820,len:0x16a8
load:0x403cc710,len:0x95c
load:0x403ce710,len:0x2eac
entry 0x403cc710
I (35) boot: ESP-IDF v5.0.6-dirty 2nd stage bootloader
I (35) boot: compile time 23:47:42
I (35) boot: chip revision: v0.4
I (37) boot.esp32c3: SPI Speed : 80MHz
I (42) boot.esp32c3: SPI Mode : DIO
I (47) boot.esp32c3: 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 esp_secure_cert unknown 3f 06 0000d000 00002000
I (75) boot: 1 nvs WiFi data 01 02 00010000 0000c000
I (83) boot: 2 nvs_keys NVS keys 01 04 0001c000 00001000
I (90) boot: 3 otadata OTA data 01 00 0001d000 00002000
I (98) boot: 4 phy_init RF data 01 01 0001f000 00001000
I (105) boot: 5 ota_0 OTA app 00 10 00020000 001e0000
I (113) boot: 6 ota_1 OTA app 00 11 00200000 001e0000
I (120) boot: 7 fctry WiFi data 01 02 003e0000 00006000
I (128) boot: End of partition table
I (132) esp_image: segment 0: paddr=00020020 vaddr=3c140020 size=5d978h (383352) map
I (201) esp_image: segment 1: paddr=0007d9a0 vaddr=3fc94c00 size=02678h ( 9848) load
I (203) esp_image: segment 2: paddr=00080020 vaddr=42000020 size=13de38h (1302072) map
I (410) esp_image: segment 3: paddr=001bde60 vaddr=3fc97278 size=00c64h ( 3172) load
I (411) esp_image: segment 4: paddr=001beacc vaddr=40380000 size=14ad8h ( 84696) load
I (431) esp_image: segment 5: paddr=001d35ac vaddr=50000010 size=00004h ( 4) load
I (437) boot: Loaded app from partition at offset 0x20000
I (438) boot: Disabling RNG early entropy source...
I (452) cpu_start: Unicore app
I (452) cpu_start: Pro cpu up.
I (460) cpu_start: Pro cpu start user code
I (460) cpu_start: cpu freq: 160000000 Hz
I (460) cpu_start: Application information:
I (463) cpu_start: Project name: matter_switch
I (469) cpu_start: App version: d0960b4
I (474) cpu_start: Compile time: Apr 29 2024 09:03:59
I (480) cpu_start: ELF file SHA256: d4fab19c71456fce...
I (486) cpu_start: ESP-IDF: v5.0.6-dirty
I (491) cpu_start: Min chip rev: v0.3
I (496) cpu_start: Max chip rev: v1.99
I (501) cpu_start: Chip rev: v0.4
I (506) heap_init: Initializing. RAM available for dynamic allocation:
I (513) heap_init: At 3FCAA190 len 00032580 (201 KiB): DRAM
I (519) heap_init: At 3FCDC710 len 00002950 (10 KiB): STACK/DRAM
I (526) heap_init: At 50000014 len 00001FD4 (7 KiB): RTCRAM
I (533) spi_flash: detected chip: generic
I (537) spi_flash: flash io: dio
W (541) rmt(legacy): legacy driver is deprecated, please migrate to `driver/rmt_tx.h` and/or `driver/rmt_rx.h`
I (552) sleep: Configure to isolate all GPIO pins in sleep state
I (558) sleep: Enable automatic switching of GPIO sleep configuration
I (565) coexist: coexist rom version 9387209
I (570) app_start: Starting scheduler on CPU0
I (575) main_task: Started on CPU0
I (575) main_task: Calling app_main()
I (585) led_driver_ws2812: Initializing light driver
I (585) led_driver_ws2812: led set r:0, g:0, b:0
I (585) gpio: GPIO[9]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:0
I (605) app_matter: Switch created with endpoint_id 1
I (605) pp: pp rom version: 9387209
I (605) net80211: net80211 rom version: 9387209
I (625) wifi:wifi driver task: 3fcb6bd4, prio:23, stack:6656, core=0
I (625) system_api: Base MAC address is not set
I (625) system_api: read default base MAC address from EFUSE
I (635) wifi:wifi firmware version: dbb7b72
I (635) wifi:wifi certification version: v7.0
I (635) wifi:config NVS flash: enabled
I (645) wifi:config nano formating: disabled
I (645) wifi:Init data frame dynamic rx buffer num: 32
I (655) wifi:Init static rx mgmt buffer num: 5
I (655) wifi:Init management short buffer num: 32
I (665) wifi:Init dynamic tx buffer num: 32
I (665) wifi:Init static tx FG buffer num: 2
I (665) wifi:Init static rx buffer size: 1600
I (675) wifi:Init static rx buffer num: 10
I (675) wifi:Init dynamic rx buffer num: 32
I (685) wifi_init: rx ba win: 6
I (685) wifi_init: tcpip mbox: 32
I (685) wifi_init: udp mbox: 6
I (695) wifi_init: tcp mbox: 6
I (695) wifi_init: tcp tx win: 5760
I (695) wifi_init: tcp rx win: 5760
I (705) wifi_init: tcp mss: 1440
I (705) wifi_init: WiFi IRAM OP enabled
I (715) wifi_init: WiFi RX IRAM OP enabled
I (735) chip[DL]: NVS set: chip-counters/reboot-count = 1508 (0x5E4)
I (735) chip[DL]: Real time clock set to 946684800 (0100/00/01 00:00:00 UTC)
I (735) BLE_INIT: BT controller compile version [9359a4d]
I (745) BLE_INIT: Bluetooth MAC: ec:da:3b:cc:bd:d6
I (745) phy_init: phy_version 1150,7c3c08f,Jan 24 2024,17:32:21
I (785) NimBLE: GAP procedure initiated: stop advertising.
I (795) CHIP[DL]: BLE host-controller synced
I (1295) chip[DL]: Configuring CHIPoBLE advertising (interval 25 ms, connectable)
I (1295) NimBLE: GAP procedure initiated: advertise;
I (1295) NimBLE: disc_mode=2
I (1295) NimBLE: adv_channel_map=0 own_addr_type=1 adv_filter_policy=0 adv_itvl_min=40 adv_itvl_max=40
I (1305) NimBLE:
I (1315) chip[DL]: CHIPoBLE advertising started
I (1315) chip[DL]: Starting ESP WiFi layer
I (1325) wifi:mode : sta (ec:da:3b:cc:bd:d4)
I (1325) wifi:enable tsf
W (1325) wifi:Haven't to connect to a suitable AP now!
I (1335) chip[DL]: Done driving station state, nothing else to do...
W (1335) wifi:Haven't to connect to a suitable AP now!
I (1345) chip[DL]: Done driving station state, nothing else to do...
I (1355) chip[SVR]: Initializing subscription resumption storage...
I (1355) chip[SVR]: Server initializing...
I (1365) chip[TS]: Last Known Good Time: 2023-10-14T01:16:48
I (1365) chip[DMG]: AccessControl: initializing
I (1375) chip[DMG]: Examples::AccessControlDelegate::Init
I (1385) chip[DMG]: AccessControl: setting
I (1385) chip[DMG]: DefaultAclStorage: initializing
I (1395) chip[DMG]: DefaultAclStorage: 0 entries loaded
I (1405) chip[ZCL]: Using ZAP configuration...
I (1405) esp_matter_cluster: Cluster plugin init common callback
I (1405) chip[DMG]: AccessControlCluster: initializing
I (1415) chip[ZCL]: 0x3c1511d8ep 0 clus 0x0000_0030 attr 0x0000_0000 not supported
I (1425) chip[ZCL]: Initiating Admin Commissioning cluster.
I (1435) chip[DIS]: Updating services using commissioning mode 1
I (1435) chip[DIS]: CHIP minimal mDNS started advertising.
I (1445) chip[DIS]: Advertise commission parameter vendorID=4891 productID=2 discriminator=2551/09 cm=1
I (1455) chip[DIS]: CHIP minimal mDNS configured as 'Commissionable node device'; instance name: EE343A640B9004BF.
I (1465) chip[DIS]: mDNS service published: _matterc._udp
I (1465) chip[IN]: CASE Server enabling CASE session setups
I (1475) chip[SVR]: Joining Multicast groups
I (1485) chip[SVR]: Server Listening...
I (1485) esp_matter_core: Dynamic endpoint 0 added
I (1495) esp_matter_attribute: ********** W : Endpoint 0x0001's Cluster 0x00000003's Attribute 0x00000001 is 0 **********
I (1505) esp_matter_attribute: ********** W : Endpoint 0x0001's Cluster 0x00000004's Attribute 0x00000000 is 128 **********
I (1515) esp_matter_attribute: ********** W : Endpoint 0x0001's Cluster 0x00000004's Attribute 0x0000FFFC is <invalid type: 0> **********
I (1525) esp_matter_core: Dynamic endpoint 1 added
I (1535) chip[DL]: WIFI_EVENT_STA_START
W (1535) wifi:Haven't to connect to a suitable AP now!
I (1545) chip[DL]: Done driving station state, nothing else to do...
I (1545) chip[DL]: Configuring CHIPoBLE advertising (interval 25 ms, connectable)
I (1555) chip[DL]: Device already advertising, stop active advertisement and restart
I (1565) NimBLE: GAP procedure initiated: stop advertising.
I (1575) NimBLE: GAP procedure initiated: advertise;
I (1575) NimBLE: disc_mode=2
I (1585) NimBLE: adv_channel_map=0 own_addr_type=1 adv_filter_policy=0 adv_itvl_min=40 adv_itvl_max=40
I (1595) NimBLE:
E (1595) esp_matter_client: failed to notify the bound cluster changed
I (1605) esp_rmaker_work_queue: Work Queue created.
I (1605) esp_mqtt_glue: AWS PPI: ?Platform=APN3|A0|RM|EX00|RMDev|1x0|ECDA3BCCBDD4
I (1615) esp_mqtt_glue: Initialising MQTT
I (1615) esp_rmaker_mqtt_budget: MQTT Budgeting initialised. Default: 100, Max: 1024, Revive count: 1, Revive period: 5
I (1635) esp_rmaker_node: Node ID ----- WWhfctC2WPRRx3jNrvqvqD
I (1635) esp_rmaker_ota_using_params: OTA enabled with Params
I (1645) esp_rmaker_ota: OTA state = 2
I (1645) esp_rmaker_time: Initializing SNTP. Using the SNTP server: pool.ntp.org
assert failed: sntp_setoperatingmode /IDF/components/lwip/lwip/src/apps/sntp/sntp.c:732 (Required to lock TCPIP core functionality!)
Core 0 register dump:
MEPC : 0x403808bc RA : 0x4038a684 SP : 0x3fcacf20 GP : 0x3fc95400
Stack dump detected
0x403808bc: panic_abort at /mnt/d/ubuntu/esp-idf/components/esp_system/panic.c:425
0x4038a684: __ubsan_include at /mnt/d/ubuntu/esp-idf/components/esp_system/ubsan.c:313
TP : 0x3fc5046c T0 : 0x37363534 T1 : 0x7271706f T2 : 0x33323130
S0/FP : 0x3fcad0c4 S1 : 0x00000043 A0 : 0x3fcacf78 A1 : 0x3fc9725d
A2 : 0x00000001 A3 : 0x00000029 A4 : 0x00000001 A5 : 0x3fca8000
A6 : 0x7a797877 A7 : 0x76757473 S2 : 0x3fcacf78 S3 : 0x00000001
S4 : 0x3fcacf78 S5 : 0x3c14a000 S6 : 0x00000000 S7 : 0x00000000
S8 : 0x00000000 S9 : 0x00000000 S10 : 0x00000000 S11 : 0x00000000
T3 : 0x6e6d6c6b T4 : 0x6a696867 T5 : 0x66656463 T6 : 0x62613938
MSTATUS : 0x00001801 MTVEC : 0x40380001 MCAUSE : 0x00000007 MTVAL : 0x00000000
0x40380001: _vector_table at ??:?
MHARTID : 0x00000000
Backtrace:
panic_abort (details=details@entry=0x3fcacf78 "assert failed: sntp_setoperatingmode /IDF/components/lwip/lwip/src/apps/sntp/sntp.c:732 (Required to lock TCPIP core functionality!)") at /mnt/d/ubuntu/esp-idf/components/esp_system/panic.c:425
425 *((volatile int *) 0) = 0; // NOLINT(clang-analyzer-core.NullDereference) should be an invalid operation on targets
#0 panic_abort (details=details@entry=0x3fcacf78 "assert failed: sntp_setoperatingmode /IDF/components/lwip/lwip/src/apps/sntp/sntp.c:732 (Required to lock TCPIP core functionality!)") at /mnt/d/ubuntu/esp-idf/components/esp_system/panic.c:425
#1 0x4038a684 in esp_system_abort (details=details@entry=0x3fcacf78 "assert failed: sntp_setoperatingmode /IDF/components/lwip/lwip/src/apps/sntp/sntp.c:732 (Required to lock TCPIP core functionality!)") at /mnt/d/ubuntu/esp-idf/components/esp_system/esp_system.c:153
#2 0x40390ed2 in __assert_func (file=<optimized out>, file@entry=0x3c172744 "", line=<optimized out>, func=<optimized out>, expr=<optimized out>) at /mnt/d/ubuntu/esp-idf/components/newlib/assert.c:78
#3 0x4206b75c in sntp_setoperatingmode (operating_mode=operating_mode@entry=0 '\000') at /mnt/d/ubuntu/esp-idf/components/lwip/lwip/src/apps/sntp/sntp.c:733
#4 0x42059c84 in esp_rmaker_time_sync_init (config=config@entry=0x0) at /mnt/d/ubuntu/esp-rainmaker/components/rmaker_common/src/time.c:224
#5 0x42010216 in esp_rmaker_ota_enable (ota_config=<optimized out>, type=<optimized out>) at /mnt/d/ubuntu/esp-rainmaker/components/esp_rainmaker/src/ota/esp_rmaker_ota.c:713
#6 0x42007866 in app_main () at /mnt/d/ubuntu/esp-rainmaker/examples-wenxe/matter/matter_switch/main/app_main.cpp:88
#7 0x4213d4ea in main_task (args=<error reading variable: value has been optimized out>) at /mnt/d/ubuntu/esp-idf/components/freertos/app_startup.c:208
#8 0x4038a68c in vPortTaskWrapper (pxCode=<optimized out>, pvParameters=<optimized out>) at /mnt/d/ubuntu/esp-idf/components/freertos/FreeRTOS-Kernel/portable/riscv/port.c:127
ELF file SHA256: d4fab19c71456fce
Rebooting...
ESP-ROM:esp32c3-api1-20210207
Build:Feb 7 2021
rst:0x3 (RTC_SW_SYS_RST),boot:0xc (SPI_FAST_FLASH_BOOT)
Saved PC:0x40380688
0x40380688: esp_restart_noos_dig at /mnt/d/ubuntu/esp-idf/components/esp_system/esp_system.c:64 (discriminator 1)
More Information.
I tried ESP-IDF V4.4.4,it can't build correctly.
CMake Error at /mnt/d/ubuntu/esp-idf/tools/cmake/build.cmake:452 (message):
WARNING: Component "idf" not found
WARNING: Component "idf" not found
WARNING: Component "idf" not found
WARNING: Component "idf" not found
WARNING: Component "idf" not found
WARNING: Component "idf" not found
WARNING: Component "idf" not found
ERROR: Because no versions of espressif/mdns match >1.2.0,<1.2.1 ||
And because espressif/mdns (1.2.1) depends on both idf (>=5.0) and idf
(>=5.0), espressif/mdns (>=1.2.0,<1.2.3 || >1.2.3,<1.2.4 || >1.2.4,<1.2.5
|| >1.2.5,<1.3.0 || >1.3.0,<2.0.0) requires idf (>=5.0.0).
And because espressif/mdns (1.2.3) depends on both idf (>=5.0) and idf
(>=5.0), espressif/mdns (>=1.2.0,<1.2.5 || >1.2.5,<1.3.0 || >1.3.0,<2.0.0)
requires idf (>=5.0.0).
And because espressif/mdns (1.2.5) depends on both idf (>=5.0) and idf
(>=5.0), espressif/mdns (>=1.2.0,<2.0.0) requires idf (>=5.0.0).
And because no versions of idf match >=5.0.0
and espressif/esp_rainmaker (1.1.0) depends on espressif/mdns (^1.2.0), espressif/esp_rainmaker is forbidden.
So, because no versions of espressif/esp_rainmaker match >=1.0.0,<1.1.0 ||
1.1.0,<2.0.0
and project depends on espressif/esp_rainmaker (~=1.0), version solving failed.
Call Stack (most recent call first)
and ESP-IDF V5.0.1 alse also build failed.
The text was updated successfully, but these errors were encountered:
github-actionsbot
changed the title
run esp-rainmaker/examples/matter/matter_switch failed
run esp-rainmaker/examples/matter/matter_switch failed (MEGH-5466)
Apr 29, 2024
Answers checklist.
IDF / ESP32-Arduino version.
V5.0.6
Operating System used.
Linux
How did you build your project?
Command line with idf.py
Development Kit.
ESP32-C3-DevKit
What is the expected behavior?
I expect I can run the matter+rainmaker switch example,but it failed.
What is the actual behavior?
I follow the rainmaker docs step by step, after downloading and run, the chip always reboot ,
SPIWP:0xee
mode:DIO, clock div:1
load:0x3fcd5820,len:0x16a8
load:0x403cc710,len:0x95c
load:0x403ce710,len:0x2eac
entry 0x403cc710
I (35) boot: ESP-IDF v5.0.6-dirty 2nd stage bootloader
I (35) boot: compile time 23:47:42
I (35) boot: chip revision: v0.4
I (37) boot.esp32c3: SPI Speed : 80MHz
I (42) boot.esp32c3: SPI Mode : DIO
I (47) boot.esp32c3: 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 esp_secure_cert unknown 3f 06 0000d000 00002000
I (75) boot: 1 nvs WiFi data 01 02 00010000 0000c000
I (83) boot: 2 nvs_keys NVS keys 01 04 0001c000 00001000
I (90) boot: 3 otadata OTA data 01 00 0001d000 00002000
I (98) boot: 4 phy_init RF data 01 01 0001f000 00001000
I (105) boot: 5 ota_0 OTA app 00 10 00020000 001e0000
I (113) boot: 6 ota_1 OTA app 00 11 00200000 001e0000
I (120) boot: 7 fctry WiFi data 01 02 003e0000 00006000
I (128) boot: End of partition table
I (132) esp_image: segment 0: paddr=00020020 vaddr=3c140020 size=5d978h (383352) map
I (201) esp_image: segment 1: paddr=0007d9a0 vaddr=3fc94c00 size=02678h ( 9848) load
I (203) esp_image: segment 2: paddr=00080020 vaddr=42000020 size=13de38h (1302072) map
I (410) esp_image: segment 3: paddr=001bde60 vaddr=3fc97278 size=00c64h ( 3172) load
I (411) esp_image: segment 4: paddr=001beacc vaddr=40380000 size=14ad8h ( 84696) load
I (431) esp_image: segment 5: paddr=001d35ac vaddr=50000010 size=00004h ( 4) load
I (437) boot: Loaded app from partition at offset 0x20000
I (438) boot: Disabling RNG early entropy source...
I (452) cpu_start: Unicore app
I (452) cpu_start: Pro cpu up.
I (460) cpu_start: Pro cpu start user code
I (460) cpu_start: cpu freq: 160000000 Hz
I (460) cpu_start: Application information:
I (463) cpu_start: Project name: matter_switch
I (469) cpu_start: App version: d0960b4
I (474) cpu_start: Compile time: Apr 29 2024 09:03:59
I (480) cpu_start: ELF file SHA256: d4fab19c71456fce...
I (486) cpu_start: ESP-IDF: v5.0.6-dirty
I (491) cpu_start: Min chip rev: v0.3
I (496) cpu_start: Max chip rev: v1.99
I (501) cpu_start: Chip rev: v0.4
I (506) heap_init: Initializing. RAM available for dynamic allocation:
I (513) heap_init: At 3FCAA190 len 00032580 (201 KiB): DRAM
I (519) heap_init: At 3FCDC710 len 00002950 (10 KiB): STACK/DRAM
I (526) heap_init: At 50000014 len 00001FD4 (7 KiB): RTCRAM
I (533) spi_flash: detected chip: generic
I (537) spi_flash: flash io: dio
W (541) rmt(legacy): legacy driver is deprecated, please migrate to
driver/rmt_tx.h
and/ordriver/rmt_rx.h
I (552) sleep: Configure to isolate all GPIO pins in sleep state
I (558) sleep: Enable automatic switching of GPIO sleep configuration
I (565) coexist: coexist rom version 9387209
I (570) app_start: Starting scheduler on CPU0
I (575) main_task: Started on CPU0
I (575) main_task: Calling app_main()
I (585) led_driver_ws2812: Initializing light driver
I (585) led_driver_ws2812: led set r:0, g:0, b:0
I (585) gpio: GPIO[9]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:0
I (605) app_matter: Switch created with endpoint_id 1
I (605) pp: pp rom version: 9387209
I (605) net80211: net80211 rom version: 9387209
I (625) wifi:wifi driver task: 3fcb6bd4, prio:23, stack:6656, core=0
I (625) system_api: Base MAC address is not set
I (625) system_api: read default base MAC address from EFUSE
I (635) wifi:wifi firmware version: dbb7b72
I (635) wifi:wifi certification version: v7.0
I (635) wifi:config NVS flash: enabled
I (645) wifi:config nano formating: disabled
I (645) wifi:Init data frame dynamic rx buffer num: 32
I (655) wifi:Init static rx mgmt buffer num: 5
I (655) wifi:Init management short buffer num: 32
I (665) wifi:Init dynamic tx buffer num: 32
I (665) wifi:Init static tx FG buffer num: 2
I (665) wifi:Init static rx buffer size: 1600
I (675) wifi:Init static rx buffer num: 10
I (675) wifi:Init dynamic rx buffer num: 32
I (685) wifi_init: rx ba win: 6
I (685) wifi_init: tcpip mbox: 32
I (685) wifi_init: udp mbox: 6
I (695) wifi_init: tcp mbox: 6
I (695) wifi_init: tcp tx win: 5760
I (695) wifi_init: tcp rx win: 5760
I (705) wifi_init: tcp mss: 1440
I (705) wifi_init: WiFi IRAM OP enabled
I (715) wifi_init: WiFi RX IRAM OP enabled
I (735) chip[DL]: NVS set: chip-counters/reboot-count = 1508 (0x5E4)
I (735) chip[DL]: Real time clock set to 946684800 (0100/00/01 00:00:00 UTC)
I (735) BLE_INIT: BT controller compile version [9359a4d]
I (745) BLE_INIT: Bluetooth MAC: ec:da:3b:cc:bd:d6
I (745) phy_init: phy_version 1150,7c3c08f,Jan 24 2024,17:32:21
I (785) NimBLE: GAP procedure initiated: stop advertising.
I (795) CHIP[DL]: BLE host-controller synced
I (1295) chip[DL]: Configuring CHIPoBLE advertising (interval 25 ms, connectable)
I (1295) NimBLE: GAP procedure initiated: advertise;
I (1295) NimBLE: disc_mode=2
I (1295) NimBLE: adv_channel_map=0 own_addr_type=1 adv_filter_policy=0 adv_itvl_min=40 adv_itvl_max=40
I (1305) NimBLE:
I (1315) chip[DL]: CHIPoBLE advertising started
I (1315) chip[DL]: Starting ESP WiFi layer
I (1325) wifi:mode : sta (ec:da:3b:cc:bd:d4)
I (1325) wifi:enable tsf
W (1325) wifi:Haven't to connect to a suitable AP now!
I (1335) chip[DL]: Done driving station state, nothing else to do...
W (1335) wifi:Haven't to connect to a suitable AP now!
I (1345) chip[DL]: Done driving station state, nothing else to do...
I (1355) chip[SVR]: Initializing subscription resumption storage...
I (1355) chip[SVR]: Server initializing...
I (1365) chip[TS]: Last Known Good Time: 2023-10-14T01:16:48
I (1365) chip[DMG]: AccessControl: initializing
I (1375) chip[DMG]: Examples::AccessControlDelegate::Init
I (1385) chip[DMG]: AccessControl: setting
I (1385) chip[DMG]: DefaultAclStorage: initializing
I (1395) chip[DMG]: DefaultAclStorage: 0 entries loaded
I (1405) chip[ZCL]: Using ZAP configuration...
I (1405) esp_matter_cluster: Cluster plugin init common callback
I (1405) chip[DMG]: AccessControlCluster: initializing
I (1415) chip[ZCL]: 0x3c1511d8ep 0 clus 0x0000_0030 attr 0x0000_0000 not supported
I (1425) chip[ZCL]: Initiating Admin Commissioning cluster.
I (1435) chip[DIS]: Updating services using commissioning mode 1
I (1435) chip[DIS]: CHIP minimal mDNS started advertising.
I (1445) chip[DIS]: Advertise commission parameter vendorID=4891 productID=2 discriminator=2551/09 cm=1
I (1455) chip[DIS]: CHIP minimal mDNS configured as 'Commissionable node device'; instance name: EE343A640B9004BF.
I (1465) chip[DIS]: mDNS service published: _matterc._udp
I (1465) chip[IN]: CASE Server enabling CASE session setups
I (1475) chip[SVR]: Joining Multicast groups
I (1485) chip[SVR]: Server Listening...
I (1485) esp_matter_core: Dynamic endpoint 0 added
I (1495) esp_matter_attribute: ********** W : Endpoint 0x0001's Cluster 0x00000003's Attribute 0x00000001 is 0 **********
I (1505) esp_matter_attribute: ********** W : Endpoint 0x0001's Cluster 0x00000004's Attribute 0x00000000 is 128 **********
I (1515) esp_matter_attribute: ********** W : Endpoint 0x0001's Cluster 0x00000004's Attribute 0x0000FFFC is <invalid type: 0> **********
I (1525) esp_matter_core: Dynamic endpoint 1 added
I (1535) chip[DL]: WIFI_EVENT_STA_START
W (1535) wifi:Haven't to connect to a suitable AP now!
I (1545) chip[DL]: Done driving station state, nothing else to do...
I (1545) chip[DL]: Configuring CHIPoBLE advertising (interval 25 ms, connectable)
I (1555) chip[DL]: Device already advertising, stop active advertisement and restart
I (1565) NimBLE: GAP procedure initiated: stop advertising.
I (1575) NimBLE: GAP procedure initiated: advertise;
I (1575) NimBLE: disc_mode=2
I (1585) NimBLE: adv_channel_map=0 own_addr_type=1 adv_filter_policy=0 adv_itvl_min=40 adv_itvl_max=40
I (1595) NimBLE:
E (1595) esp_matter_client: failed to notify the bound cluster changed
I (1605) esp_rmaker_work_queue: Work Queue created.
I (1605) esp_mqtt_glue: AWS PPI: ?Platform=APN3|A0|RM|EX00|RMDev|1x0|ECDA3BCCBDD4
I (1615) esp_mqtt_glue: Initialising MQTT
I (1615) esp_rmaker_mqtt_budget: MQTT Budgeting initialised. Default: 100, Max: 1024, Revive count: 1, Revive period: 5
I (1635) esp_rmaker_node: Node ID ----- WWhfctC2WPRRx3jNrvqvqD
I (1635) esp_rmaker_ota_using_params: OTA enabled with Params
I (1645) esp_rmaker_ota: OTA state = 2
I (1645) esp_rmaker_time: Initializing SNTP. Using the SNTP server: pool.ntp.org
assert failed: sntp_setoperatingmode /IDF/components/lwip/lwip/src/apps/sntp/sntp.c:732 (Required to lock TCPIP core functionality!)
Core 0 register dump:
MEPC : 0x403808bc RA : 0x4038a684 SP : 0x3fcacf20 GP : 0x3fc95400
Stack dump detected
0x403808bc: panic_abort at /mnt/d/ubuntu/esp-idf/components/esp_system/panic.c:425
0x4038a684: __ubsan_include at /mnt/d/ubuntu/esp-idf/components/esp_system/ubsan.c:313
TP : 0x3fc5046c T0 : 0x37363534 T1 : 0x7271706f T2 : 0x33323130
S0/FP : 0x3fcad0c4 S1 : 0x00000043 A0 : 0x3fcacf78 A1 : 0x3fc9725d
A2 : 0x00000001 A3 : 0x00000029 A4 : 0x00000001 A5 : 0x3fca8000
A6 : 0x7a797877 A7 : 0x76757473 S2 : 0x3fcacf78 S3 : 0x00000001
S4 : 0x3fcacf78 S5 : 0x3c14a000 S6 : 0x00000000 S7 : 0x00000000
S8 : 0x00000000 S9 : 0x00000000 S10 : 0x00000000 S11 : 0x00000000
T3 : 0x6e6d6c6b T4 : 0x6a696867 T5 : 0x66656463 T6 : 0x62613938
MSTATUS : 0x00001801 MTVEC : 0x40380001 MCAUSE : 0x00000007 MTVAL : 0x00000000
0x40380001: _vector_table at ??:?
MHARTID : 0x00000000
Backtrace:
panic_abort (details=details@entry=0x3fcacf78 "assert failed: sntp_setoperatingmode /IDF/components/lwip/lwip/src/apps/sntp/sntp.c:732 (Required to lock TCPIP core functionality!)") at /mnt/d/ubuntu/esp-idf/components/esp_system/panic.c:425
425 *((volatile int *) 0) = 0; // NOLINT(clang-analyzer-core.NullDereference) should be an invalid operation on targets
#0 panic_abort (details=details@entry=0x3fcacf78 "assert failed: sntp_setoperatingmode /IDF/components/lwip/lwip/src/apps/sntp/sntp.c:732 (Required to lock TCPIP core functionality!)") at /mnt/d/ubuntu/esp-idf/components/esp_system/panic.c:425
#1 0x4038a684 in esp_system_abort (details=details@entry=0x3fcacf78 "assert failed: sntp_setoperatingmode /IDF/components/lwip/lwip/src/apps/sntp/sntp.c:732 (Required to lock TCPIP core functionality!)") at /mnt/d/ubuntu/esp-idf/components/esp_system/esp_system.c:153
#2 0x40390ed2 in __assert_func (file=, file@entry=0x3c172744 "", line=, func=, expr=) at /mnt/d/ubuntu/esp-idf/components/newlib/assert.c:78
#3 0x4206b75c in sntp_setoperatingmode (operating_mode=operating_mode@entry=0 '\000') at /mnt/d/ubuntu/esp-idf/components/lwip/lwip/src/apps/sntp/sntp.c:733
#4 0x42059c84 in esp_rmaker_time_sync_init (config=config@entry=0x0) at /mnt/d/ubuntu/esp-rainmaker/components/rmaker_common/src/time.c:224
#5 0x42010216 in esp_rmaker_ota_enable (ota_config=, type=) at /mnt/d/ubuntu/esp-rainmaker/components/esp_rainmaker/src/ota/esp_rmaker_ota.c:713
#6 0x42007866 in app_main () at /mnt/d/ubuntu/esp-rainmaker/examples-wenxe/matter/matter_switch/main/app_main.cpp:88
#7 0x4213d4ea in main_task (args=) at /mnt/d/ubuntu/esp-idf/components/freertos/app_startup.c:208
#8 0x4038a68c in vPortTaskWrapper (pxCode=, pvParameters=) at /mnt/d/ubuntu/esp-idf/components/freertos/FreeRTOS-Kernel/portable/riscv/port.c:127
ELF file SHA256: d4fab19c71456fce
Rebooting...
ESP-ROM:esp32c3-api1-20210207
Build:Feb 7 2021
rst:0x3 (RTC_SW_SYS_RST),boot:0xc (SPI_FAST_FLASH_BOOT)
Saved PC:0x40380688
0x40380688: esp_restart_noos_dig at /mnt/d/ubuntu/esp-idf/components/esp_system/esp_system.c:64 (discriminator 1)
log-20240429.txt
Steps to reproduce.
...
Debug Logs.
More Information.
I tried ESP-IDF V4.4.4,it can't build correctly.
CMake Error at /mnt/d/ubuntu/esp-idf/tools/cmake/build.cmake:452 (message):
WARNING: Component "idf" not found
WARNING: Component "idf" not found
WARNING: Component "idf" not found
WARNING: Component "idf" not found
WARNING: Component "idf" not found
WARNING: Component "idf" not found
WARNING: Component "idf" not found
ERROR: Because no versions of espressif/mdns match >1.2.0,<1.2.1 ||
and espressif/mdns (1.2.0) depends on idf (>=5.0), espressif/mdns (>=1.2.0,<1.2.1 || >1.2.1,<1.2.2 || >1.2.2,<1.2.3 || >1.2.3,<1.2.4 || >1.2.4,<1.2.5 || >1.2.5,<1.3.0 || >1.3.0,<2.0.0) requires idf (>=5.0).
And because espressif/mdns (1.2.1) depends on both idf (>=5.0) and idf
(>=5.0), espressif/mdns (>=1.2.0,<1.2.3 || >1.2.3,<1.2.4 || >1.2.4,<1.2.5
|| >1.2.5,<1.3.0 || >1.3.0,<2.0.0) requires idf (>=5.0.0).
And because espressif/mdns (1.2.3) depends on both idf (>=5.0) and idf
(>=5.0), espressif/mdns (>=1.2.0,<1.2.5 || >1.2.5,<1.3.0 || >1.3.0,<2.0.0)
requires idf (>=5.0.0).
And because espressif/mdns (1.2.5) depends on both idf (>=5.0) and idf
(>=5.0), espressif/mdns (>=1.2.0,<2.0.0) requires idf (>=5.0.0).
And because no versions of idf match >=5.0.0
and espressif/esp_rainmaker (1.1.0) depends on espressif/mdns (^1.2.0), espressif/esp_rainmaker is forbidden.
So, because no versions of espressif/esp_rainmaker match >=1.0.0,<1.1.0 ||
and project depends on espressif/esp_rainmaker (~=1.0), version solving failed.
Call Stack (most recent call first)
and ESP-IDF V5.0.1 alse also build failed.
The text was updated successfully, but these errors were encountered: