eq3_v2 crashes on ESPHome 2021.12.0

[dedors]

At least I think it's caused by eq3_v2 since that is the only thing running, and my other devices did update to 2021.12.0 with no problems.

[D][climate:381]: 'Thermostat EQ3 Schlofzimmer' - Sending state:
[D][climate:384]:   Mode: AUTO
[D][climate:395]:   Preset: HOME
[D][climate:410]:   Target Temperature: 12.00°C
[I][app:062]: setup() finished successfully!
[I][eq3:072]: Requesting ID of 1a220e5096...
[D][esp32_ble:104]: BT init done.
E (8066) task_wdt: Task watchdog got triggered. The following tasks did not reset the watchdog in time:
E (8066) task_wdt:  - loopTask (CPU 1)
E (8066) task_wdt: Tasks currently running:
E (8066) task_wdt: CPU 0: IDLE0
E (8066) task_wdt: CPU 1: IDLE1
E (8066) task_wdt: Aborting.
abort() was called at PC 0x401b9f28 on core 0

ELF file SHA256: 0000000000000000

Backtrace: 0x4008f980:0x3ffbfdf0 0x4008fbfd:0x3ffbfe10 0x401b9f28:0x3ffbfe30 0x4008e029:0x3ffbfe50 0x401e4767:0x3ffbc100 0x401bb8b3:0x3ffbc120 0x40092421:0x3ffbc140 0x40090c72:0x3ffbc160

Rebooting...
ets Jun  8 2016 00:22:57

rst:0xc (SW_CPU_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:0x3fff0018,len:4
load:0x3fff001c,len:1044
load:0x40078000,len:10124
load:0x40080400,len:5828
entry 0x400806a8
[E][esp32-hal-misc.c:111] disableCore1WDT(): Failed to remove Core 1 IDLE task from WDT

And then reboots.

My config

esphome:
  name: esp-gang
  platform: ESP32
  board: esp32doit-devkit-v1

wifi:
 *******
logger:

api:

ota:

external_components:
  - source: github://ayufan/esphome-components

time:
  - platform: sntp
    id: sntp_time

climate:
  - platform: eq3_v2
    id: thermostat_eq3_schlofzimmer
    name: Thermostat EQ3 Schlofzimmer
    mac_address: ************
    update_interval: 30min
    valve: # optional, allows to see valve state in %
      name: Thermostat EQ3 Schlofzimmer State
     # expire_after: 61min

switch:
  - platform: template
    name: "Thermostat EQ3 Schlofzimmer Refresh"
    lambda: "return false;"
    turn_on_action:
      - component.update: thermostat_eq3_schlofzimmer

A side note, the expire_after: entry gives a This option requires component mqtt. when compiling. I'm a bit confused as it already uses mqtt?

[Meaxl]

I've updated to 2021.12.1 today and seeing the same behavior. All nodes that are not running eq3_v2 updated flawlessly, but the one with it gets the same error as posted above by @dedors.

After removing the external_component it compiled successfully. So I can confirm your thoughts about it.

[jperquin]

Same here. compilation is successful, but new firmware, once uploaded keeps crashing on start-up. From what I gather it happens right after initial BT query for the devices.

[16:25:42][I][eq3:086]: Requesting Schedule of 1a2214b9b1...
[16:25:44]E (9246) task_wdt: Task watchdog got triggered. The following tasks did not reset the watchdog in time:
[16:25:44]E (9246) task_wdt:  - loopTask (CPU 1)
[16:25:44]E (9246) task_wdt: Tasks currently running:
[16:25:44]E (9246) task_wdt: CPU 0: IDLE0
[16:25:44]E (9246) task_wdt: CPU 1: IDLE1
[16:25:44]E (9246) task_wdt: Aborting.
[16:25:44]abort() was called at PC 0x401cad64 on core 0
[16:25:44]
[16:25:44]ELF file SHA256: 0000000000000000
[16:25:44]
[16:25:44]Backtrace: 0x4008f980:0x3ffbfe40 0x4008fbfd:0x3ffbfe60 0x401cad64:0x3ffbfe80 0x4008e029:0x3ffbfea0 0x401f752b:0x3ffbc160 0x401cd85f:0x3ffbc180 0x40092421:0x3ffbc1a0 0x40090c72:0x3ffbc1c0
[16:25:44]
[16:25:44]Rebooting...
[16:25:44]ets Jun  8 2016 00:22:57
[16:25:44]
[16:25:44]rst:0xc (SW_CPU_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
[16:25:44]configsip: 188777542, SPIWP:0xee
[16:25:44]clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
[16:25:44]mode:DIO, clock div:2
[16:25:44]load:0x3fff0018,len:4
[16:25:44]load:0x3fff001c,len:1044
[16:25:44]load:0x40078000,len:8896
[16:25:44]load:0x40080400,len:5828
[16:25:44]entry 0x400806ac
[16:25:45][E][esp32-hal-misc.c:111] disableCore1WDT(): Failed to remove Core 1 IDLE task from WDT
[16:25:45][I][logger:214]: Log initialized

[pikciu]

same issue

[18:04:05][W][ota:092]: Last Boot was an unhandled reset, will proceed to safe mode in 4 restarts
[18:04:05][C][mqtt:029]: Setting up MQTT...
[18:04:05][I][mqtt:174]: Connecting to MQTT...
[18:04:05][I][mqtt:214]: MQTT Connected!
[18:04:05][C][sntp:025]: Setting up SNTP...
[18:04:05][I][app:062]: setup() finished successfully!
[18:04:05][I][eq3:072]: Requesting ID of 1a220ebf78...
[18:04:05][D][esp32_ble:104]: BT init done.
[18:04:10][I][eq3:079]: ID of 1a220ebf78 succeeded.
[18:04:10][I][eq3:086]: Requesting Schedule of 1a220ebf78...
[18:04:10]E (9450) task_wdt: Task watchdog got triggered. The following tasks did not reset the watchdog in time:
[18:04:10]E (9450) task_wdt:  - loopTask (CPU 1)
[18:04:10]E (9450) task_wdt: Tasks currently running:
[18:04:10]E (9450) task_wdt: CPU 0: IDLE0
[18:04:10]E (9450) task_wdt: CPU 1: IDLE1
[18:04:10]E (9450) task_wdt: Aborting.
[18:04:10]abort() was called at PC 0x401c5964 on core 0
[18:04:10]
[18:04:10]ELF file SHA256: 0000000000000000
[18:04:10]
[18:04:10]Backtrace: 0x4008f980:0x3ffbfe40 0x4008fbfd:0x3ffbfe60 0x401c5964:0x3ffbfe80 0x4008e029:0x3ffbfea0 0x401f1baf:0x3ffbc160 0x401c82df:0x3ffbc180 0x40092421:0x3ffbc1a0 0x40090c72:0x3ffbc1c0
WARNING Found stack trace! Trying to decode it
WARNING Decoded 0x4008f980: invoke_abort at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/esp32/panic.c:715
WARNING Decoded 0x4008fbfd: abort at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/esp32/panic.c:715
WARNING Decoded 0x401c5964: task_wdt_isr at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/esp32/task_wdt.c:252
WARNING Decoded 0x4008e029: _xt_lowint1 at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/freertos/xtensa_vectors.S:1154
WARNING Decoded 0x401f1baf: esp_pm_impl_waiti at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/esp32/pm_esp32.c:492
WARNING Decoded 0x401c82df: esp_vApplicationIdleHook at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/esp32/freertos_hooks.c:108
WARNING Decoded 0x40092421: prvIdleTask at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/freertos/tasks.c:3507
WARNING Decoded 0x40090c72: vPortTaskWrapper at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/freertos/port.c:355 (discriminator 1)
[18:04:10]
[18:04:10]Rebooting...
[18:04:10]ets Jun  8 2016 00:22:57
[18:04:10]
[18:04:10]rst:0xc (SW_CPU_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
[18:04:10]configsip: 0, SPIWP:0xee
[18:04:10]clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
[18:04:10]mode:DIO, clock div:2
[18:04:10]load:0x3fff0018,len:4
[18:04:10]load:0x3fff001c,len:1044
[18:04:10]load:0x40078000,len:10124
[18:04:10]load:0x40080400,len:5828
[18:04:10]entry 0x400806a8
[18:04:11][E][esp32-hal-misc.c:111] disableCore1WDT(): Failed to remove Core 1 IDLE task from WDT
[18:04:11][I][logger:214]: Log initialized

[jperquin]

Had another go with ESPHome v. 2022.2.3 and ESP32 keeps rebooting..

Would be nice if someone can have a look at the code. From what I can gather the only relevant changes from v 2021.11 to 2021.12 are these two: https://github.com/esphome/esphome/pull/2707 and https://github.com/esphome/esphome/pull/2801

[jperquin]

.. bump

[deviant-aut]

Not working on 2022.11.2

[ayufan]

The problem is with some kind of memory corruption happening somewhere likely. I noticed this at random and there's no a good explanation how to fix it.

[ccoenen]

I can't get this running, either. My ESP32 just reboots constantly.

logger output when logging is enabled

```txt [23:43:10][C][wifi:376]: DNS1: 192.168.1.1 [23:43:10][C][wifi:377]: DNS2: 0.0.0.0 [23:43:10][D][wifi:527]: Disabling AP... [23:43:10][C][ota:093]: Over-The-Air Updates: [23:43:10][C][ota:094]: Address: eq3-relay.local:3232 [23:43:10][C][ota:097]: Using Password. [23:43:10][W][ota:103]: Last Boot was an unhandled reset, will proceed to safe mode in 3 restarts [23:43:10][C][api:025]: Setting up Home Assistant API server... [23:43:10][I][app:062]: setup() finished successfully! [23:43:10][I][eq3:072]: Requesting ID of [redacted]... [23:43:11][D][esp32_ble:104]: BT init done. [23:43:15]E (18457) task_wdt: Task watchdog got triggered. The following tasks did not reset the watchdog in time: [23:43:15]E (18457) task_wdt: - loopTask (CPU 1) [23:43:15]E (18457) task_wdt: Tasks currently running: [23:43:15]E (18457) task_wdt: CPU 0: IDLE [23:43:15]E (18457) task_wdt: CPU 1: IDLE [23:43:15]E (18457) task_wdt: Aborting. [23:43:15] [23:43:15]abort() was called at PC 0x400f88cc on core 0 [23:43:15] [23:43:15] [23:43:15]Backtrace:0x400837b9:0x3ffbe9bc |<-CORRUPTED WARNING Found stack trace! Trying to decode it WARNING Decoded 0x400837b9: panic_abort at /Users/ficeto/Desktop/ESP32/ESP32S2/esp-idf-public/components/esp_system/panic.c:402 [23:43:15] [23:43:15] [23:43:15] [23:43:15] [23:43:15]ELF file SHA256: 0000000000000000 [23:43:15] [23:43:15]Rebooting... [23:43:15]ets Jun 8 2016 00:22:57 [23:43:15] [23:43:15]rst:0xc (SW_CPU_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT) [23:43:15]configsip: 188777542, SPIWP:0xee [23:43:15]clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00 [23:43:15]mode:DIO, clock div:2 [23:43:15]load:0x3fff0030,len:1184 [23:43:15]load:0x40078000,len:13132 [23:43:15]load:0x40080400,len:3036 [23:43:15]entry 0x400805e4 [23:43:16][I][logger:258]: Log initialized [23:43:16][C][ota:469]: There have been 8 suspected unsuccessful boot attempts. ```

(but also does not work with logging removed)

Here is my config in case anyone wants to compare notes

```yaml # based on https://github.com/ayufan/esphome-components external_components: - source: github://ayufan/esphome-components esphome: name: eq3-relay esp32: board: ttgo-lora32-v1 framework: type: arduino # Home Assistant API api: encryption: key: !secret encryption_key wifi: ssid: !secret wifi_ssid password: !secret wifi_password time: - platform: homeassistant id: esptime climate: - platform: eq3_v2 name: Test-EQ3-1 # mac address slightly changed mac_address: "00:1A:22:01:01:01" update_interval: 30min ```

not sure any of this helps, sadly.