Adafruit_Wippersnapper_Arduino
Adafruit_Wippersnapper_Arduino copied to clipboard
adafruit
locally built v99 (checkout tag) on esp32v2 with build_type=debug was working half hour ago, but just seen error about ssl buffer too small
00:53:53:895 -> [ 53650][E][ssl_client.cpp:36] _handle_error(): [send_ssl_data():423]: (-27136) SSL - A buffer is too small to receive or write a message 00:53:53:906 -> [ 53662][E][NetworkClientSecure.cpp:244] write(): Closing connection on failed write
00:53:15:991 -> Connected to WiFi!
00:53:15:997 -> Connecting to AIO MQTT (attempt #0)
00:53:15:997 -> WiFi Status: 20
00:53:16:002 -> E (21148) task_wdt: esp_task_wdt_reset(705): task not found
00:53:16:603 -> E (21748) task_wdt: esp_task_wdt_reset(705): task not found
00:53:27:675 -> E (32820) task_wdt: esp_task_wdt_reset(705): task not found
00:53:27:675 -> MQTT Connection Error: -2
00:53:27:680 -> Failed to subscribe
00:53:27:680 -> Unable to connect to Adafruit IO MQTT, retrying in 3 seconds...
00:53:30:685 -> Connecting to AIO MQTT (attempt #1)
00:53:30:685 -> WiFi Status: 20
00:53:30:685 -> E (35834) task_wdt: esp_task_wdt_reset(705): task not found
00:53:31:290 -> E (36435) task_wdt: esp_task_wdt_reset(705): task not found
00:53:34:549 -> [ 34303][E][ssl_client.cpp:36] _handle_error(): [send_ssl_data():423]: (-27136) SSL - A buffer is too small to receive or write a message
00:53:34:560 -> [ 34316][E][NetworkClientSecure.cpp:244] write(): Closing connection on failed write
00:53:34:570 -> E (39715) task_wdt: esp_task_wdt_reset(705): task not found
00:53:34:570 -> MQTT Connection Error: -1
00:53:34:575 -> Connection failed
00:53:34:575 -> Unable to connect to Adafruit IO MQTT, retrying in 3 seconds...
00:53:37:580 -> Connecting to AIO MQTT (attempt #2)
00:53:37:580 -> WiFi Status: 20
00:53:37:580 -> E (42729) task_wdt: esp_task_wdt_reset(705): task not found
00:53:38:201 -> E (43330) task_wdt: esp_task_wdt_reset(705): task not found
00:53:50:001 -> E (55146) task_wdt: esp_task_wdt_reset(705): task not found
00:53:50:001 -> MQTT Connection Error: -2
00:53:50:007 -> Failed to subscribe
00:53:50:007 -> Unable to connect to Adafruit IO MQTT, retrying in 3 seconds...
00:53:53:011 -> Connecting to AIO MQTT (attempt #3)
00:53:53:011 -> WiFi Status: 20
00:53:53:011 -> E (58160) task_wdt: esp_task_wdt_reset(705): task not found
00:53:53:616 -> E (58761) task_wdt: esp_task_wdt_reset(705): task not found
00:53:53:895 -> [ 53650][E][ssl_client.cpp:36] _handle_error(): [send_ssl_data():423]: (-27136) SSL - A buffer is too small to receive or write a message
00:53:53:906 -> [ 53662][E][NetworkClientSecure.cpp:244] write(): Closing connection on failed write
00:53:53:916 -> E (59061) task_wdt: esp_task_wdt_reset(705): task not found
00:53:53:916 -> MQTT Connection Error: -1
00:53:53:922 -> Connection failed
00:53:53:922 -> Unable to connect to Adafruit IO MQTT, retrying in 3 seconds...
00:53:56:927 -> Connecting to AIO MQTT (attempt #4)
00:53:56:927 -> WiFi Status: 20
00:53:56:927 -> E (62076) task_wdt: esp_task_wdt_reset(705): task not found
00:53:57:532 -> E (62677) task_wdt: esp_task_wdt_reset(705): task not found
00:54:14:272 -> E (79417) task_wdt: esp_task_wdt_reset(705): task not found
00:54:14:272 -> MQTT Connection Error: -2
00:54:14:278 -> Failed to subscribe
00:54:14:278 -> Unable to connect to Adafruit IO MQTT, retrying in 3 seconds...
00:54:17:282 -> ERROR [WDT RESET IN 25]:
00:54:17:282 -> ERROR: Unable to connect to Adafruit.IO MQTT, rebooting soon...
Encoding registration request...Encoding registration msg...Published!
18:32:40.059 > Polling for registration message response...2
18:32:40.110 >
18:32:40.110 > assert failed: vTaskPriorityDisinheritAfterTimeout tasks.c:5267 (pxTCB != pxCurrentTCBs[ xPortGetCoreID() ])
18:32:40.115 >
18:32:40.115 >
18:32:40.115 > Backtrace: 0x40083a68:0x3ffb1f60 0x4008e829:0x3ffb1f80 0x40094c15:0x3ffb1fa0 0x4009178a:0x3ffb20e0 0x4008f09f:0x3ffb2100 0x400e585a:0x3ffb2140 0x400e5690:0x3ffb2160 0x400dfd25:0x3ffb2180 0x400dfeda:0x3ffb21a0 0x400df849:0x3ffb21c0 0x400d5e49:0x3ffb21e0 0x400d602a:0x3ffb2200 0x400d6806:0x3ffb2240 0x4011b05b:0x3ffb2270 0x4008f4ae:0x3ffb2290
18:32:43.671 > #0 0x40083a68 in panic_abort at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/esp_system/panic.c:454
18:32:43.671 > #1 0x4008e829 in esp_system_abort at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/esp_system/port/esp_system_chip.c:87
18:32:43.671 > #2 0x40094c15 in __assert_func at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/newlib/assert.c:80
18:32:43.671 > #3 0x4009178a in vTaskPriorityDisinheritAfterTimeout at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/freertos/FreeRTOS-Kernel/tasks.c:5267 (discriminator 1)
18:32:43.671 > #4 0x4008f09f in xQueueSemaphoreTake at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/freertos/FreeRTOS-Kernel/queue.c:1842
18:32:43.671 > #5 0x400e585a in espShow at .pio/libdeps/featheresp32v2_debug/Adafruit NeoPixel/esp.c:52 (discriminator 1)
18:32:43.671 > #6 0x400e5690 in Adafruit_NeoPixel::show() at .pio/libdeps/featheresp32v2_debug/Adafruit NeoPixel/Adafruit_NeoPixel.cpp:3176
18:32:43.671 > #7 0x400dfd25 in setStatusLEDColor(unsigned long) at src/components/statusLED/Wippersnapper_StatusLED.cpp:160
18:32:43.671 > #8 0x400dfeda in statusLEDBlink(ws_led_status_t) at src/components/statusLED/Wippersnapper_StatusLED.cpp:404
18:32:43.671 > #9 0x400df849 in Wippersnapper::pollRegistrationResp() at src/components/register/Wippersnapper_Register.cpp:83
18:32:43.671 > #10 0x400d5e49 in Wippersnapper::registerBoard() at src/Wippersnapper.cpp:2556
18:32:43.671 > #11 0x400d602a in Wippersnapper::connect() at src/Wippersnapper.cpp:2802
18:32:43.671 > #12 0x400d6806 in setup() at C:/Users/tyeth/source/repos/arduino/Adafruit_Wippersnapper_Arduino/src/Wippersnapper_demo.ino:29
18:32:43.671 > #13 0x4011b05b in loopTask(void*) at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/main.cpp:59
18:32:43.671 > #14 0x4008f4ae in vPortTaskWrapper at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/freertos/FreeRTOS-Kernel/portable/xtensa/port.c:139
18:32:43.671 >
18:32:43.671 >
18:32:43.671 >
18:32:43.671 >
18:32:43.671 >
18:32:43.671 > ELF file SHA256: 86407712f
18:32:43.671 >
18:32:50.027 > Rebooting...
First two outputs were PlatformIO builds v99 with BSP3.13 and v100 with lower bsp, so ignore. Then v100 with BSP 3.20 so take note of neopixel / vTask error. Note that I have the neopixel component setup. It feels a bit like a race condition for who can deinit the neopixel pin via some vTask
One bad boot (neopixel vTask conflict) then one good boot - Details
ets Jul 29 2019 12:21:46
20:48:44.285 >
20:48:44.285 > rst:0x1 (POWERON_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
20:48:44.290 > configsip: 271414342, SPIWP:0xee
20:48:44.290 > clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
20:48:44.300 > mode:DIO, clock div:1
20:48:44.300 > load:0x3fff0030,len:4660
20:48:44.300 > load:0x40078000,len:15576
20:48:44.307 > load:0x40080400,len:4
20:48:44.307 > load:0x40080404,len:3152
20:48:44.307 > entry 0x400805a0
20:48:45.024 > [ 1][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_RX (2) successfully set to 0x40119d1c
20:48:45.314 > #0 0x40119d1c in _uartDetachBus_RX at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:268
20:48:45.314 >
20:48:49.260 > [ 13][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_TX (3) successfully set to 0x40119d00
20:48:49.260 > #0 0x40119d00 in _uartDetachBus_TX at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:275
20:48:49.260 >
20:48:49.260 > [ 26][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_CTS (4) successfully set to 0x40119ce4
20:48:49.260 > #0 0x40119ce4 in _uartDetachBus_CTS at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:282
20:48:49.260 >
20:48:49.260 > [ 40][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_RTS (5) successfully set to 0x40119cc4
20:48:49.260 > #0 0x40119cc4 in _uartDetachBus_RTS at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:289
20:48:49.260 >
20:48:49.260 > [ 53][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_RX (2) successfully set to 0x40119d1c
20:48:49.260 > #0 0x40119d1c in _uartDetachBus_RX at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:268
20:48:49.260 >
20:48:49.260 > [ 67][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_TX (3) successfully set to 0x40119d00
20:48:49.260 > #0 0x40119d00 in _uartDetachBus_TX at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:275
20:48:49.260 >
20:48:49.260 > [ 80][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_CTS (4) successfully set to 0x40119ce4
20:48:49.260 > #0 0x40119ce4 in _uartDetachBus_CTS at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:282
20:48:49.260 >
20:48:49.260 > [ 94][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_RTS (5) successfully set to 0x40119cc4
20:48:49.260 > #0 0x40119cc4 in _uartDetachBus_RTS at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:289
20:48:49.260 >
20:48:49.260 > [ 107][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_RX (2) successfully set to 0x40119d1c
20:48:49.260 > #0 0x40119d1c in _uartDetachBus_RX at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:268
20:48:49.260 >
20:48:49.260 > [ 121][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_TX (3) successfully set to 0x40119d00
20:48:49.260 > #0 0x40119d00 in _uartDetachBus_TX at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:275
20:48:49.260 >
20:48:49.260 > [ 134][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_CTS (4) successfully set to 0x40119ce4
20:48:49.260 > #0 0x40119ce4 in _uartDetachBus_CTS at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:282
20:48:49.260 >
20:48:49.260 > [ 148][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_RTS (5) successfully set to 0x40119cc4
20:48:49.260 > #0 0x40119cc4 in _uartDetachBus_RTS at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:289
20:48:49.260 >
20:48:49.260 > [ 193][D][esp32-hal-cpu.c:263] setCpuFrequencyMhz(): PLL: 480 / 2 = 240 Mhz, APB: 80000000 Hz
20:48:49.260 > [ 202][I][esp32-hal-psram.c:102] psramAddToHeap(): PSRAM added to the heap.
20:48:49.260 > [ 230][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type GPIO (1) successfully set to 0x401cb9b0
20:48:49.260 > #0 0x401cb9b0 in gpioDetachBus at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-gpio.c:100
20:48:49.260 >
20:48:49.260 > [ 242][V][esp32-hal-periman.c:160] perimanSetPinBus(): Pin 2 successfully set to type GPIO (1) with bus 0x3
20:48:49.260 > [ 254][V][esp32-hal-periman.c:160] perimanSetPinBus(): Pin 3 successfully set to type UART_RX (2) with bus 0x3ffbdfb0
20:48:49.260 > #0 0x3ffbdfb0 in ?? at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:97
20:48:49.260 >
20:48:49.260 > [ 266][V][esp32-hal-periman.c:160] perimanSetPinBus(): Pin 1 successfully set to type UART_TX (3) with bus 0x3ffbdfb0
20:48:49.260 > #0 0x3ffbdfb0 in ?? at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:97
20:48:49.260 >
20:48:49.260 > =========== Before Setup Start ===========
20:48:49.260 > Chip Info:
20:48:49.260 > ------------------------------------------
20:48:50.121 > Model : ESP32
20:48:50.121 > Package : PICO-V3-02
20:48:50.121 > Revision : 3.01
20:48:50.121 > Cores : 2
20:48:50.121 > CPU Frequency : 240 MHz
20:48:50.121 > XTAL Frequency : 40 MHz
20:48:50.121 > Features Bitfield : 0x000000b3
20:48:50.121 > Embedded Flash : Yes
20:48:50.121 > Embedded PSRAM : Yes
20:48:50.121 > 2.4GHz WiFi : Yes
20:48:50.121 > Classic BT : Yes
20:48:50.121 > BT Low Energy : Yes
20:48:50.121 > IEEE 802.15.4 : No
20:48:50.121 > ------------------------------------------
20:48:50.121 > INTERNAL Memory Info:
20:48:50.121 > ------------------------------------------
20:48:50.121 > Total Size : 314756 B ( 307.4 KB)
20:48:50.121 > Free Bytes : 272480 B ( 266.1 KB)
20:48:50.121 > Allocated Bytes : 34788 B ( 34.0 KB)
20:48:50.121 > Minimum Free Bytes: 266840 B ( 260.6 KB)
20:48:50.121 > Largest Free Block: 110580 B ( 108.0 KB)
20:48:50.121 > ------------------------------------------
20:48:50.121 > SPIRAM Memory Info:
20:48:50.121 > ------------------------------------------
20:48:50.121 > Total Size : 2097152 B (2048.0 KB)
20:48:50.121 > Free Bytes : 2095104 B (2046.0 KB)
20:48:50.121 > Allocated Bytes : 0 B ( 0.0 KB)
20:48:50.121 > Minimum Free Bytes: 2095104 B (2046.0 KB)
20:48:50.121 > Largest Free Block: 2064372 B (2016.0 KB)
20:48:50.121 > Bus Mode : QSPI
20:48:50.121 > ------------------------------------------
20:48:50.121 > Flash Info:
20:48:50.121 > ------------------------------------------
20:48:50.121 > Chip Size : 8388608 B (8 MB)
20:48:50.121 > Block Size : 65536 B ( 64.0 KB)
20:48:50.121 > Sector Size : 4096 B ( 4.0 KB)
20:48:50.121 > Page Size : 256 B ( 0.2 KB)
20:48:50.121 > Bus Speed : 80 MHz
20:48:50.121 > Bus Mode : DIO
20:48:50.121 > ------------------------------------------
20:48:50.121 > Partitions Info:
20:48:50.121 > ------------------------------------------
20:48:50.121 > nvs : addr: 0x00009000, size: 20.0 KB, type: DATA, subtype: NVS
20:48:50.121 > otadata : addr: 0x0000E000, size: 8.0 KB, type: DATA, subtype: OTA
20:48:50.121 > app0 : addr: 0x00010000, size: 3264.0 KB, type: APP, subtype: OTA_0
20:48:50.121 > app1 : addr: 0x00340000, size: 3264.0 KB, type: APP, subtype: OTA_1
20:48:50.121 > spiffs : addr: 0x00670000, size: 1536.0 KB, type: DATA, subtype: SPIFFS
20:48:50.121 > coredump : addr: 0x007F0000, size: 64.0 KB, type: DATA, subtype: COREDUMP
20:48:50.121 > ------------------------------------------
20:48:50.121 > Software Info:
20:48:50.121 > ------------------------------------------
20:48:50.121 > Compile Date/Time : Apr 24 2025 17:24:13
20:48:50.121 > ESP-IDF Version : v5.4.1-1-g2f7dcd862a-dirty
20:48:50.121 > Arduino Version : 3.2.0
20:48:50.121 > ------------------------------------------
20:48:50.121 > Board Info:
20:48:50.121 > ------------------------------------------
20:48:50.121 > Arduino Board : Adafruit Feather ESP32 V2
20:48:50.121 > Arduino Variant : adafruit_feather_esp32_v2
20:48:50.121 > Core Debug Level : 5
20:48:50.121 > Arduino Runs Core : 1
20:48:50.121 > Arduino Events on : 1
20:48:50.121 > CDC On Boot : 0
20:48:50.121 > ============ Before Setup End ============
20:48:50.121 > [ 824][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type GPIO (1) successfully set to 0x401cb9b0
20:48:50.121 > #0 0x401cb9b0 in gpioDetachBus at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-gpio.c:100
20:48:50.121 >
20:48:50.121 > [ 835][V][esp32-hal-periman.c:160] perimanSetPinBus(): Pin 0 successfully set to type GPIO (1) with bus 0x1
20:48:50.121 > [ 847][V][esp32-hal-rmt.c:454] rmtInit(): GPIO 0 - TX MODE - MemSize[64] - Freq=10000000Hz
20:48:50.121 > [ 857][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type RMT_TX (13) successfully set to 0x40117cd0
20:48:50.121 > #0 0x40117cd0 in _rmtDetachBus at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-rmt.c:136
20:48:50.121 >
20:48:50.121 > [ 870][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type RMT_RX (14) successfully set to 0x40117cd0
20:48:50.121 > #0 0x40117cd0 in _rmtDetachBus at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-rmt.c:136
20:48:50.121 >
20:48:50.121 > [ 884][V][esp32-hal-periman.c:160] perimanSetPinBus(): Pin 0 successfully set to type INIT (0) with bus 0x0
20:48:50.121 > E (703) rmt: rmt_new_tx_channel(269): not able to power down in light sleep
20:48:50.121 > [ 896][E][esp32-hal-rmt.c:548] rmtInit(): GPIO 0 - RMT TX Initialization error.
20:48:50.121 > [ 912][V][esp32-hal-rmt.c:142] _rmtDetachBus(): Detaching RMT GPIO Bus
20:48:50.121 > [ 921][E][esp.c:81] espShow(): Failed to init RMT TX mode on pin 0
20:48:50.121 > [ 941][V][esp32-hal-uart.c:552] uartBegin(): UART0 baud(115200) Mode(800001c) rxPin(3) txPin(1)
20:48:50.121 > [ 950][V][esp32-hal-uart.c:650] uartBegin(): UART0 not installed. Starting installation
20:48:50.121 > [ 960][V][esp32-hal-uart.c:660] uartBegin(): UART0 RX FIFO full threshold set to 120 (value requested: 120 || FIFO Max = 128)
20:48:50.121 > [ 973][V][esp32-hal-uart.c:681] uartBegin(): Setting UART0 to use REF_TICK clock
20:48:50.121 > [ 983][V][esp32-hal-uart.c:732] uartBegin(): UART0 initialization done.
20:48:50.121 > [ 998][V][esp32-hal-uart.c:783] uartSetRxFIFOFull(): UART0 RX FIFO Full value set to 120 from a requested value of 120
20:48:50.121 > Adafruit.io WipperSnapper
20:48:50.121 > -------Device Information-------
20:48:50.121 > Firmware Version: 1.0.0-beta.100
20:48:50.121 > Board ID: feather-esp32-v2
20:48:50.121 > Adafruit.io User: tyeth
20:48:50.121 > WiFi Network: free4all
20:48:50.121 > MAC Address: 10:06:1C:18:CD:74
20:48:50.121 > -------------------------------
20:48:50.121 > ESP32 CPU0 RESET REASON: NO_MEAN
20:48:50.121 > ESP32 CPU1 RESET REASON: POWERON_RESET
20:48:50.121 > Generating device's MQTT topics...
20:48:50.121 > Running Network FSM...
20:48:50.121 > E (838) task_wdt: esp_task_wdt_reset(705): task not found
20:48:50.121 > Establishing network connection...
20:48:50.121 > Performing a WiFi scan for SSID...[ 1063][V][NetworkEvents.cpp:117] _checkForEvent(): Network Event: 101 - WIFI_READY
20:48:50.121 > [ 1207][W][STA.cpp:543] disconnect(): STA already disconnected.
20:48:50.121 > [ 1209][V][STA.cpp:186] _onStaEvent(): STA Started
20:48:50.121 > [ 1218][V][NetworkEvents.cpp:117] _checkForEvent(): Network Event: 110 - STA_START
20:48:50.121 > [ 1225][V][STA.cpp:110] _onStaArduinoEvent(): Arduino STA Event: 110 - STA_START
20:48:50.121 > [ 3909][V][WiFiGeneric.cpp:80] _arduino_event_cb(): SCAN Done: ID: 128, Status: 0, Results: 7
20:48:50.121 > [ 3917][V][NetworkEvents.cpp:117] _checkForEvent(): Network Event: 102 - SCAN_DONE
20:48:50.121 > WipperSnapper found these WiFi networks:
20:48:50.121 > free4all (28:F5:D1:EF:10:12) -58dB (ch6)
20:48:50.121 > free4all (6C:63:9C:23:A3:AB) -64dB (ch1)
20:48:50.121 > free4all (10:7C:61:82:50:F1) -74dB (ch1)
20:48:50.121 > TALKTALKB8C4F9 (10:D7:B0:B8:C4:F6) -87dB (ch1)
20:48:50.121 > Shaun (48:D3:43:A2:44:81) -88dB (ch6)
20:48:50.121 > Ginger Moggie (48:D3:43:AC:16:A9) -90dB (ch6)
20:48:50.121 > VM7662787 (18:35:D1:3A:9:9) -91dB (ch6)
20:48:50.121 > E (4657) task_wdt: esp_task_wdt_reset(705): task not found
20:48:50.121 > Connecting to WiFi (attempt #0)
20:48:50.121 > E (4665) task_wdt: esp_task_wdt_reset(705): task not found
20:48:50.121 > [ 4857][W][STA.cpp:543] disconnect(): STA already disconnected.
20:48:50.486 > E (5279) task_wdt: esp_task_wdt_reset(705): task not found
20:48:50.918 > E (12024) wifi:Association refused too many times, max allowed 1
20:48:50.923 > [ 5900][V][STA.cpp:216] _onStaEvent(): STA Disconnected: SSID: free4all, BSSID: 28:f5:d1:ef:10:12, Reason: 208
20:48:50.929 > [ 5911][V][NetworkEvents.cpp:117] _checkForEvent(): Network Event: 113 - STA_DISCONNECTED
20:48:50.940 > [ 5919][V][STA.cpp:110] _onStaArduinoEvent(): Arduino STA Event: 113 - STA_DISCONNECTED
20:48:50.940 > [ 5927][W][STA.cpp:137] _onStaArduinoEvent(): Reason: 208 - ASSOC_COMEBACK_TIME_TOO_LONG
20:48:50.957 > [ 5935][D][STA.cpp:155] _onStaArduinoEvent(): WiFi Reconnect Running
20:48:50.957 > [ 5941][W][STA.cpp:543] disconnect(): STA already disconnected.
20:48:51.396 > E (12504) wifi:Association refused too many times, max allowed 1
20:48:51.403 > [ 6379][V][STA.cpp:216] _onStaEvent(): STA Disconnected: SSID: free4all, BSSID: 28:f5:d1:ef:10:12, Reason: 208
20:48:51.408 > [ 6390][V][NetworkEvents.cpp:117] _checkForEvent(): Network Event: 113 - STA_DISCONNECTED
20:48:51.419 > [ 6398][V][STA.cpp:110] _onStaArduinoEvent(): Arduino STA Event: 113 - STA_DISCONNECTED
20:48:51.424 > [ 6406][W][STA.cpp:137] _onStaArduinoEvent(): Reason: 208 - ASSOC_COMEBACK_TIME_TOO_LONG
20:48:55.494 > E (16601) task_wdt: esp_task_wdt_reset(705): task not found
20:48:55.494 > E (16601) task_wdt: esp_task_wdt_reset(705): task not found
20:48:56.394 > E (17501) task_wdt: esp_task_wdt_reset(705): task not found
20:48:56.394 > Connecting to WiFi (attempt #1)
20:48:56.399 > E (17509) task_wdt: esp_task_wdt_reset(705): task not found
20:48:56.400 > [ 11379][W][STA.cpp:543] disconnect(): STA already disconnected.
20:48:57.010 > E (18123) task_wdt: esp_task_wdt_reset(705): task not found
20:48:57.052 > [ 12038][V][STA.cpp:206] _onStaEvent(): STA Connected: SSID: free4all, BSSID: 28:f5:d1:ef:10:12, Channel: 6, Auth: WPA2_PSK
20:48:57.067 > [ 12050][V][NetworkEvents.cpp:117] _checkForEvent(): Network Event: 112 - STA_CONNECTED
20:48:57.078 > [ 12058][V][STA.cpp:110] _onStaArduinoEvent(): Arduino STA Event: 112 - STA_CONNECTED
20:48:59.119 > [ 14096][V][NetworkInterface.cpp:78] _onIpEvent(): sta Got New IP: 192.168.1.13 MASK: 255.255.255.0 GW: 192.168.1.254
20:48:59.125 > [ 14107][V][NetworkEvents.cpp:117] _checkForEvent(): Network Event: 115 - STA_GOT_IP
20:48:59.136 > [ 14115][V][STA.cpp:110] _onStaArduinoEvent(): Arduino STA Event: 115 - STA_GOT_IP
20:48:59.137 > [ 14122][V][STA.cpp:171] _onStaArduinoEvent(): STA IP: 192.168.1.13, MASK: 255.255.255.0, GW: 192.168.1.254
20:49:02.015 > E (23123) task_wdt: esp_task_wdt_reset(705): task not found
20:49:02.015 > E (23123) task_wdt: esp_task_wdt_reset(705): task not found
20:49:02.021 > Connected to WiFi!
20:49:02.026 > Connecting to AIO MQTT (attempt #0)
20:49:02.026 > WiFi Status: 20
20:49:02.032 > E (23140) task_wdt: esp_task_wdt_reset(705): task not found
20:49:02.933 > E (24040) task_wdt: esp_task_wdt_reset(705): task not found
20:49:02.933 > [ 17910][D][NetworkManager.cpp:83] hostByName(): Clearing DNS cache
20:49:02.963 > [ 17940][D][NetworkManager.cpp:127] hostByName(): DNS found IPv4 52.4.253.177
20:49:02.969 > [ 17948][V][ssl_client.cpp:68] start_ssl_client(): Free internal heap before TLS 208028
20:49:02.970 > [ 17955][V][ssl_client.cpp:75] start_ssl_client(): Starting socket (domain 2)
20:49:03.132 > [ 18110][V][ssl_client.cpp:170] start_ssl_client(): Seeding the random number generator
20:49:03.141 > [ 18119][V][ssl_client.cpp:178] start_ssl_client(): Setting up the SSL/TLS structure...
20:49:03.150 > [ 18128][V][ssl_client.cpp:198] start_ssl_client(): Loading CA cert
20:49:03.153 > [ 18139][V][ssl_client.cpp:292] start_ssl_client(): Setting hostname for TLS session...
20:49:03.167 > [ 18147][V][ssl_client.cpp:313] ssl_starttls_handshake(): Performing the SSL/TLS handshake...
20:49:03.747 > [ 18729][V][ssl_client.cpp:334] ssl_starttls_handshake(): Verifying peer X.509 certificate...
20:49:03.757 > [ 18737][V][ssl_client.cpp:342] ssl_starttls_handshake(): Certificate verified.
20:49:03.757 > [ 18744][V][ssl_client.cpp:358] ssl_starttls_handshake(): Free internal heap after TLS 164892
20:49:05.087 > E (26194) task_wdt: esp_task_wdt_reset(705): task not found
20:49:05.087 > E (26194) task_wdt: delete_entry(236): task not found
20:49:05.093 > E (26195) task_wdt: esp_task_wdt_reset(705): task not found
20:49:05.098 > Registering hardware with WipperSnapper...
20:49:05.101 > Registering hardware with IO...
20:49:05.101 > Encoding registration request...Encoding registration msg...Published!
20:49:05.284 > Polling for registration message response...2
20:49:05.331 >
20:49:05.331 > assert failed: vTaskPriorityDisinheritAfterTimeout tasks.c:5267 (pxTCB != pxCurrentTCBs[ xPortGetCoreID() ])
20:49:05.331 >
20:49:05.331 >
20:49:05.331 > Backtrace: 0x40083a68:0x3ffb1f60 0x4008e829:0x3ffb1f80 0x40094c15:0x3ffb1fa0 0x4009178a:0x3ffb20e0 0x4008f09f:0x3ffb2100 0x400e585a:0x3ffb2140 0x400e5690:0x3ffb2160 0x400dfd25:0x3ffb2180 0x400dfeda:0x3ffb21a0 0x400df849:0x3ffb21c0 0x400d5e49:0x3ffb21e0 0x400d602a:0x3ffb2200 0x400d6806:0x3ffb2240 0x4011b05b:0x3ffb2270 0x4008f4ae:0x3ffb2290
20:49:08.512 > #0 0x40083a68 in panic_abort at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/esp_system/panic.c:454
20:49:08.512 > #1 0x4008e829 in esp_system_abort at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/esp_system/port/esp_system_chip.c:87
20:49:08.512 > #2 0x40094c15 in __assert_func at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/newlib/assert.c:80
20:49:08.512 > #3 0x4009178a in vTaskPriorityDisinheritAfterTimeout at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/freertos/FreeRTOS-Kernel/tasks.c:5267 (discriminator 1)
20:49:08.512 > #4 0x4008f09f in xQueueSemaphoreTake at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/freertos/FreeRTOS-Kernel/queue.c:1842
20:49:08.512 > #5 0x400e585a in espShow at .pio/libdeps/featheresp32v2_debug/Adafruit NeoPixel/esp.c:52 (discriminator 1)
20:49:08.512 > #6 0x400e5690 in Adafruit_NeoPixel::show() at .pio/libdeps/featheresp32v2_debug/Adafruit NeoPixel/Adafruit_NeoPixel.cpp:3176
20:49:08.512 > #7 0x400dfd25 in setStatusLEDColor(unsigned long) at src/components/statusLED/Wippersnapper_StatusLED.cpp:160
20:49:08.512 > #8 0x400dfeda in statusLEDBlink(ws_led_status_t) at src/components/statusLED/Wippersnapper_StatusLED.cpp:404
20:49:08.512 > #9 0x400df849 in Wippersnapper::pollRegistrationResp() at src/components/register/Wippersnapper_Register.cpp:83
20:49:08.512 > #10 0x400d5e49 in Wippersnapper::registerBoard() at src/Wippersnapper.cpp:2556
20:49:08.512 > #11 0x400d602a in Wippersnapper::connect() at src/Wippersnapper.cpp:2802
20:49:08.512 > #12 0x400d6806 in setup() at C:/Users/tyeth/source/repos/arduino/Adafruit_Wippersnapper_Arduino/src/Wippersnapper_demo.ino:29
20:49:08.512 > #13 0x4011b05b in loopTask(void*) at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/main.cpp:59
20:49:08.512 > #14 0x4008f4ae in vPortTaskWrapper at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/freertos/FreeRTOS-Kernel/portable/xtensa/port.c:139
20:49:08.512 >
20:49:08.512 >
20:49:08.512 >
20:49:08.512 >
20:49:08.512 >
20:49:08.512 > ELF file SHA256: 86407712f
20:49:08.512 >
20:49:14.152 > Rebooting...
20:49:14.152 > ets Jul 29 2019 12:21:46
20:49:14.152 >
20:49:14.152 > rst:0xc (SW_CPU_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
20:49:14.152 > configsip: 271414342, SPIWP:0xee
20:49:14.152 > clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
20:49:14.152 > mode:DIO, clock div:1
20:49:14.152 > load:0x3fff0030,len:4660
20:49:14.152 > load:0x40078000,len:15576
20:49:14.152 > load:0x40080400,len:4
20:49:14.152 > load:0x40080404,len:3152
20:49:14.152 > entry 0x400805a0
20:49:14.152 > [ 1][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_RX (2) successfully set to 0x40119d1c
20:49:14.152 > #0 0x40119d1c in _uartDetachBus_RX at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:268
20:49:14.152 >
20:49:14.152 > [ 13][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_TX (3) successfully set to 0x40119d00
20:49:14.152 > #0 0x40119d00 in _uartDetachBus_TX at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:275
20:49:14.152 >
20:49:14.152 > [ 26][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_CTS (4) successfully set to 0x40119ce4
20:49:14.152 > #0 0x40119ce4 in _uartDetachBus_CTS at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:282
20:49:14.152 >
20:49:14.152 > [ 40][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_RTS (5) successfully set to 0x40119cc4
20:49:14.152 > #0 0x40119cc4 in _uartDetachBus_RTS at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:289
20:49:14.152 >
20:49:14.152 > [ 53][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_RX (2) successfully set to 0x40119d1c
20:49:14.152 > #0 0x40119d1c in _uartDetachBus_RX at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:268
20:49:14.152 >
20:49:14.152 > [ 67][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_TX (3) successfully set to 0x40119d00
20:49:14.152 > #0 0x40119d00 in _uartDetachBus_TX at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:275
20:49:14.152 >
20:49:14.152 > [ 80][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_CTS (4) successfully set to 0x40119ce4
20:49:14.152 > #0 0x40119ce4 in _uartDetachBus_CTS at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:282
20:49:14.152 >
20:49:14.152 > [ 94][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_RTS (5) successfully set to 0x40119cc4
20:49:14.152 > #0 0x40119cc4 in _uartDetachBus_RTS at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:289
20:49:14.152 >
20:49:14.152 > [ 107][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_RX (2) successfully set to 0x40119d1c
20:49:14.152 > #0 0x40119d1c in _uartDetachBus_RX at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:268
20:49:14.152 >
20:49:14.152 > [ 121][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_TX (3) successfully set to 0x40119d00
20:49:14.152 > #0 0x40119d00 in _uartDetachBus_TX at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:275
20:49:14.152 >
20:49:14.152 > [ 134][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_CTS (4) successfully set to 0x40119ce4
20:49:14.152 > #0 0x40119ce4 in _uartDetachBus_CTS at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:282
20:49:14.152 >
20:49:14.152 > [ 148][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type UART_RTS (5) successfully set to 0x40119cc4
20:49:14.152 > #0 0x40119cc4 in _uartDetachBus_RTS at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:289
20:49:14.152 >
20:49:14.152 > [ 193][D][esp32-hal-cpu.c:263] setCpuFrequencyMhz(): PLL: 480 / 2 = 240 Mhz, APB: 80000000 Hz
20:49:14.152 > [ 202][I][esp32-hal-psram.c:102] psramAddToHeap(): PSRAM added to the heap.
20:49:14.152 > [ 231][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type GPIO (1) successfully set to 0x401cb9b0
20:49:14.152 > #0 0x401cb9b0 in gpioDetachBus at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-gpio.c:100
20:49:14.152 >
20:49:14.152 > [ 242][V][esp32-hal-periman.c:160] perimanSetPinBus(): Pin 2 successfully set to type GPIO (1) with bus 0x3
20:49:14.152 > [ 254][V][esp32-hal-periman.c:160] perimanSetPinBus(): Pin 3 successfully set to type UART_RX (2) with bus 0x3ffbdfb0
20:49:14.152 > #0 0x3ffbdfb0 in ?? at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:97
20:49:14.152 >
20:49:14.152 > [ 266][V][esp32-hal-periman.c:160] perimanSetPinBus(): Pin 1 successfully set to type UART_TX (3) with bus 0x3ffbdfb0
20:49:14.152 > #0 0x3ffbdfb0 in ?? at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-uart.c:97
20:49:14.152 >
20:49:14.152 > =========== Before Setup Start ===========
20:49:14.152 > Chip Info:
20:49:14.152 > ------------------------------------------
20:49:14.152 > Model : ESP32
20:49:14.152 > Package : PICO-V3-02
20:49:14.152 > Revision : 3.01
20:49:14.152 > Cores : 2
20:49:14.152 > CPU Frequency : 240 MHz
20:49:14.152 > XTAL Frequency : 40 MHz
20:49:14.152 > Features Bitfield : 0x000000b3
20:49:14.152 > Embedded Flash : Yes
20:49:14.152 > Embedded PSRAM : Yes
20:49:14.152 > 2.4GHz WiFi : Yes
20:49:14.152 > Classic BT : Yes
20:49:14.152 > BT Low Energy : Yes
20:49:14.152 > IEEE 802.15.4 : No
20:49:14.152 > ------------------------------------------
20:49:14.152 > INTERNAL Memory Info:
20:49:14.152 > ------------------------------------------
20:49:14.152 > Total Size : 314756 B ( 307.4 KB)
20:49:14.152 > Free Bytes : 272332 B ( 265.9 KB)
20:49:14.152 > Allocated Bytes : 34920 B ( 34.1 KB)
20:49:14.152 > Minimum Free Bytes: 266716 B ( 260.5 KB)
20:49:14.152 > Largest Free Block: 110580 B ( 108.0 KB)
20:49:14.152 > ------------------------------------------
20:49:14.152 > SPIRAM Memory Info:
20:49:14.152 > ------------------------------------------
20:49:14.152 > Total Size : 2097152 B (2048.0 KB)
20:49:14.152 > Free Bytes : 2095104 B (2046.0 KB)
20:49:14.152 > Allocated Bytes : 0 B ( 0.0 KB)
20:49:14.152 > Minimum Free Bytes: 2095104 B (2046.0 KB)
20:49:14.152 > Largest Free Block: 2064372 B (2016.0 KB)
20:49:14.152 > Bus Mode : QSPI
20:49:14.152 > ------------------------------------------
20:49:14.152 > Flash Info:
20:49:14.152 > ------------------------------------------
20:49:14.152 > Chip Size : 8388608 B (8 MB)
20:49:14.152 > Block Size : 65536 B ( 64.0 KB)
20:49:14.152 > Sector Size : 4096 B ( 4.0 KB)
20:49:14.152 > Page Size : 256 B ( 0.2 KB)
20:49:14.152 > Bus Speed : 80 MHz
20:49:14.152 > Bus Mode : DIO
20:49:14.152 > ------------------------------------------
20:49:14.152 > Partitions Info:
20:49:14.152 > ------------------------------------------
20:49:14.152 > nvs : addr: 0x00009000, size: 20.0 KB, type: DATA, subtype: NVS
20:49:14.152 > otadata : addr: 0x0000E000, size: 8.0 KB, type: DATA, subtype: OTA
20:49:14.152 > app0 : addr: 0x00010000, size: 3264.0 KB, type: APP, subtype: OTA_0
20:49:14.152 > app1 : addr: 0x00340000, size: 3264.0 KB, type: APP, subtype: OTA_1
20:49:14.152 > spiffs : addr: 0x00670000, size: 1536.0 KB, type: DATA, subtype: SPIFFS
20:49:14.152 > coredump : addr: 0x007F0000, size: 64.0 KB, type: DATA, subtype: COREDUMP
20:49:14.152 > ------------------------------------------
20:49:14.152 > Software Info:
20:49:14.152 > ------------------------------------------
20:49:14.152 > Compile Date/Time : Apr 24 2025 17:24:13
20:49:14.152 > ESP-IDF Version : v5.4.1-1-g2f7dcd862a-dirty
20:49:14.152 > Arduino Version : 3.2.0
20:49:14.152 > ------------------------------------------
20:49:14.152 > Board Info:
20:49:14.152 > ------------------------------------------
20:49:14.152 > Arduino Board : Adafruit Feather ESP32 V2
20:49:14.152 > Arduino Variant : adafruit_feather_esp32_v2
20:49:14.152 > Core Debug Level : 5
20:49:14.152 > Arduino Runs Core : 1
20:49:14.152 > Arduino Events on : 1
20:49:14.152 > CDC On Boot : 0
20:49:14.152 > ============ Before Setup End ============
20:49:14.152 > [ 824][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type GPIO (1) successfully set to 0x401cb9b0
20:49:14.152 > #0 0x401cb9b0 in gpioDetachBus at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-gpio.c:100
20:49:14.152 >
20:49:14.152 > [ 835][V][esp32-hal-periman.c:160] perimanSetPinBus(): Pin 0 successfully set to type GPIO (1) with bus 0x1
20:49:14.152 > [ 847][V][esp32-hal-rmt.c:454] rmtInit(): GPIO 0 - TX MODE - MemSize[64] - Freq=10000000Hz
20:49:14.152 > [ 857][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type RMT_TX (13) successfully set to 0x40117cd0
20:49:14.152 > #0 0x40117cd0 in _rmtDetachBus at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-rmt.c:136
20:49:14.152 >
20:49:14.152 > [ 870][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type RMT_RX (14) successfully set to 0x40117cd0
20:49:14.152 > #0 0x40117cd0 in _rmtDetachBus at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-rmt.c:136
20:49:14.152 >
20:49:14.152 > [ 884][V][esp32-hal-periman.c:160] perimanSetPinBus(): Pin 0 successfully set to type INIT (0) with bus 0x0
20:49:14.152 > E (703) rmt: rmt_new_tx_channel(269): not able to power down in light sleep
20:49:14.152 > [ 896][E][esp32-hal-rmt.c:548] rmtInit(): GPIO 0 - RMT TX Initialization error.
20:49:14.152 > [ 912][V][esp32-hal-rmt.c:142] _rmtDetachBus(): Detaching RMT GPIO Bus
20:49:14.152 > [ 921][E][esp.c:81] espShow(): Failed to init RMT TX mode on pin 0
20:49:14.152 > [ 941][V][esp32-hal-uart.c:552] uartBegin(): UART0 baud(115200) Mode(800001c) rxPin(3) txPin(1)
20:49:14.152 > [ 950][V][esp32-hal-uart.c:650] uartBegin(): UART0 not installed. Starting installation
20:49:14.152 > [ 960][V][esp32-hal-uart.c:660] uartBegin(): UART0 RX FIFO full threshold set to 120 (value requested: 120 || FIFO Max = 128)
20:49:14.152 > [ 973][V][esp32-hal-uart.c:681] uartBegin(): Setting UART0 to use REF_TICK clock
20:49:14.152 > [ 983][V][esp32-hal-uart.c:732] uartBegin(): UART0 initialization done.
20:49:14.152 > [ 998][V][esp32-hal-uart.c:783] uartSetRxFIFOFull(): UART0 RX FIFO Full value set to 120 from a requested value of 120
20:49:14.152 > Adafruit.io WipperSnapper
20:49:14.152 > -------Device Information-------
20:49:14.152 > Firmware Version: 1.0.0-beta.100
20:49:14.152 > Board ID: feather-esp32-v2
20:49:14.152 > Adafruit.io User: tyeth
20:49:14.152 > WiFi Network: free4all
20:49:14.152 > MAC Address: 10:06:1C:18:CD:74
20:49:14.152 > -------------------------------
20:49:14.152 > ESP32 CPU0 RESET REASON: NO_MEAN
20:49:14.152 > ESP32 CPU1 RESET REASON: POWERON_RESET
20:49:14.152 > Generating device's MQTT topics...
20:49:14.152 > Running Network FSM...
20:49:14.152 > E (838) task_wdt: esp_task_wdt_reset(705): task not found
20:49:14.152 > Establishing network connection...
20:49:14.152 > Performing a WiFi scan for SSID...[ 1063][V][NetworkEvents.cpp:117] _checkForEvent(): Network Event: 101 - WIFI_READY
20:49:14.152 > [ 1158][W][STA.cpp:543] disconnect(): STA already disconnected.
20:49:14.152 > [ 1159][V][STA.cpp:186] _onStaEvent(): STA Started
20:49:14.152 > [ 1169][V][NetworkEvents.cpp:117] _checkForEvent(): Network Event: 110 - STA_START
20:49:14.152 > [ 1176][V][STA.cpp:110] _onStaArduinoEvent(): Arduino STA Event: 110 - STA_START
20:49:14.152 > [ 3860][V][WiFiGeneric.cpp:80] _arduino_event_cb(): SCAN Done: ID: 128, Status: 0, Results: 7
20:49:14.152 > [ 3868][V][NetworkEvents.cpp:117] _checkForEvent(): Network Event: 102 - SCAN_DONE
20:49:14.152 > WipperSnapper found these WiFi networks:
20:49:14.152 > free4all (28:F5:D1:EF:10:12) -59dB (ch6)
20:49:14.152 > free4all (6C:63:9C:23:A3:AB) -64dB (ch1)
20:49:14.152 > free4all (10:7C:61:82:50:F1) -75dB (ch1)
20:49:14.152 > TALKTALKB8C4F9 (10:D7:B0:B8:C4:F6) -88dB (ch1)
20:49:14.152 > Shaun (48:D3:43:A2:44:81) -88dB (ch6)
20:49:14.152 > VM7662787 (18:35:D1:3A:9:9) -89dB (ch6)
20:49:14.152 > Ginger Moggie (48:D3:43:AC:16:A9) -92dB (ch6)
20:49:14.152 > E (4607) task_wdt: esp_task_wdt_reset(705): task not found
20:49:14.152 > Connecting to WiFi (attempt #0)
20:49:14.152 > E (4615) task_wdt: esp_task_wdt_reset(705): task not found
20:49:14.152 > [ 4807][W][STA.cpp:543] disconnect(): STA already disconnected.
20:49:14.152 > E (5229) task_wdt: esp_task_wdt_reset(705): task not found
20:49:14.152 > E (11925) wifi:Association refused too many times, max allowed 1
20:49:14.152 > [ 5850][V][STA.cpp:216] _onStaEvent(): STA Disconnected: SSID: free4all, BSSID: 28:f5:d1:ef:10:12, Reason: 208
20:49:14.152 > [ 5861][V][NetworkEvents.cpp:117] _checkForEvent(): Network Event: 113 - STA_DISCONNECTED
20:49:14.152 > [ 5869][V][STA.cpp:110] _onStaArduinoEvent(): Arduino STA Event: 113 - STA_DISCONNECTED
20:49:14.152 > [ 5877][W][STA.cpp:137] _onStaArduinoEvent(): Reason: 208 - ASSOC_COMEBACK_TIME_TOO_LONG
20:49:14.152 > [ 5885][D][STA.cpp:155] _onStaArduinoEvent(): WiFi Reconnect Running
20:49:14.152 > [ 5891][W][STA.cpp:543] disconnect(): STA already disconnected.
20:49:14.152 > E (12405) wifi:Association refused too many times, max allowed 1
20:49:14.152 > [ 6330][V][STA.cpp:216] _onStaEvent(): STA Disconnected: SSID: free4all, BSSID: 28:f5:d1:ef:10:12, Reason: 208
20:49:14.152 > [ 6341][V][NetworkEvents.cpp:117] _checkForEvent(): Network Event: 113 - STA_DISCONNECTED
20:49:14.152 > [ 6349][V][STA.cpp:110] _onStaArduinoEvent(): Arduino STA Event: 113 - STA_DISCONNECTED
20:49:14.152 > [ 6357][W][STA.cpp:137] _onStaArduinoEvent(): Reason: 208 - ASSOC_COMEBACK_TIME_TOO_LONG
20:49:16.823 > E (16501) task_wdt: esp_task_wdt_reset(705): task not found
20:49:16.823 > E (16501) task_wdt: esp_task_wdt_reset(705): task not found
20:49:17.723 > E (17401) task_wdt: esp_task_wdt_reset(705): task not found
20:49:17.723 > Connecting to WiFi (attempt #1)
20:49:17.729 > E (17409) task_wdt: esp_task_wdt_reset(705): task not found
20:49:17.735 > [ 11329][W][STA.cpp:543] disconnect(): STA already disconnected.
20:49:18.340 > E (18023) task_wdt: esp_task_wdt_reset(705): task not found
20:49:18.392 > [ 11997][V][STA.cpp:206] _onStaEvent(): STA Connected: SSID: free4all, BSSID: 28:f5:d1:ef:10:12, Channel: 6, Auth: WPA2_PSK
20:49:18.402 > [ 12008][V][NetworkEvents.cpp:117] _checkForEvent(): Network Event: 112 - STA_CONNECTED
20:49:18.411 > [ 12016][V][STA.cpp:110] _onStaArduinoEvent(): Arduino STA Event: 112 - STA_CONNECTED
20:49:20.522 > [ 14119][V][NetworkInterface.cpp:78] _onIpEvent(): sta Got New IP: 192.168.1.13 MASK: 255.255.255.0 GW: 192.168.1.254
20:49:20.527 > [ 14130][V][NetworkEvents.cpp:117] _checkForEvent(): Network Event: 115 - STA_GOT_IP
20:49:20.539 > [ 14138][V][STA.cpp:110] _onStaArduinoEvent(): Arduino STA Event: 115 - STA_GOT_IP
20:49:20.544 > [ 14145][V][STA.cpp:171] _onStaArduinoEvent(): STA IP: 192.168.1.13, MASK: 255.255.255.0, GW: 192.168.1.254
20:49:23.338 > E (23023) task_wdt: esp_task_wdt_reset(705): task not found
20:49:23.338 > E (23023) task_wdt: esp_task_wdt_reset(705): task not found
20:49:23.348 > Connected to WiFi!
20:49:23.356 > Connecting to AIO MQTT (attempt #0)
20:49:23.356 > WiFi Status: 20
20:49:23.362 > E (23040) task_wdt: esp_task_wdt_reset(705): task not found
20:49:24.263 > E (23941) task_wdt: esp_task_wdt_reset(705): task not found
20:49:24.263 > [ 17861][D][NetworkManager.cpp:83] hostByName(): Clearing DNS cache
20:49:24.289 > [ 17887][D][NetworkManager.cpp:127] hostByName(): DNS found IPv4 52.7.84.197
20:49:24.293 > [ 17894][V][ssl_client.cpp:68] start_ssl_client(): Free internal heap before TLS 208028
20:49:24.293 > [ 17902][V][ssl_client.cpp:75] start_ssl_client(): Starting socket (domain 2)
20:49:24.433 > [ 18031][V][ssl_client.cpp:170] start_ssl_client(): Seeding the random number generator
20:49:24.442 > [ 18040][V][ssl_client.cpp:178] start_ssl_client(): Setting up the SSL/TLS structure...
20:49:24.451 > [ 18049][V][ssl_client.cpp:198] start_ssl_client(): Loading CA cert
20:49:24.462 > [ 18060][V][ssl_client.cpp:292] start_ssl_client(): Setting hostname for TLS session...
20:49:24.470 > [ 18068][V][ssl_client.cpp:313] ssl_starttls_handshake(): Performing the SSL/TLS handshake...
20:49:25.047 > [ 18648][V][ssl_client.cpp:334] ssl_starttls_handshake(): Verifying peer X.509 certificate...
20:49:25.056 > [ 18656][V][ssl_client.cpp:342] ssl_starttls_handshake(): Certificate verified.
20:49:25.062 > [ 18663][V][ssl_client.cpp:358] ssl_starttls_handshake(): Free internal heap after TLS 165020
20:49:26.378 > E (26055) task_wdt: esp_task_wdt_reset(705): task not found
20:49:26.378 > E (26055) task_wdt: delete_entry(236): task not found
20:49:26.383 > E (26056) task_wdt: esp_task_wdt_reset(705): task not found
20:49:26.388 > Registering hardware with WipperSnapper...
20:49:26.392 > Registering hardware with IO...
20:49:26.392 > Encoding registration request...Encoding registration msg...Published!
20:49:26.585 > Polling for registration message response...2
20:49:27.486 > GOT Registration Response Message:
20:49:27.486 > Hardware Response Msg:
20:49:27.486 > GPIO Pins: 21
20:49:27.486 > Analog Pins: 7
20:49:27.486 > Reference voltage: 3.30v
20:49:27.610 > Completed registration process, configuration next!
20:49:27.610 > Polling for message containing hardware configuration...
20:49:27.621 > cbSignalTopic: New Msg on Signal Topic
20:49:27.622 > 17 bytes.
20:49:27.622 > decodeSignalMsg
20:49:27.622 > cbSignalMsg
20:49:27.622 > Sub-messages found: 1
20:49:27.622 > Signal Msg Tag: Pin Configuration
20:49:27.633 > cbDecodePinConfigMsg
20:49:27.633 > Configuring digital input pin on D38with internal pull-up enabled
20:49:27.639 > [ 21231][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type GPIO (1) successfully set to 0x401cb9b0
20:49:27.932 > #0 0x401cb9b0 in gpioDetachBus at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-gpio.c:100
20:49:27.932 >
20:49:28.771 > [ 21251][V][esp32-hal-periman.c:160] perimanSetPinBus(): Pin 38 successfully set to type GPIO (1) with bus 0x27
20:49:28.771 > Interval (ms):0
20:49:28.771 > Initial Pin Configuration Complete!
20:49:28.771 > Publishing to pin config complete...
20:49:28.771 > * NEW MESSAGE [Topic: Pixels]:
20:49:28.771 > 14 bytes.
20:49:28.771 > [Message Type]: wippersnapper_signal_v1_PixelsRequest_req_pixels_create_tag
20:49:28.771 > Releasing status LED
20:49:28.771 > [ 21324][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type GPIO (1) successfully set to 0x401cb9b0
20:49:28.771 > #0 0x401cb9b0 in gpioDetachBus at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-gpio.c:100
20:49:28.771 >
20:49:28.771 > [ 21336][V][esp32-hal-periman.c:160] perimanSetPinBus(): Pin 0 successfully set to type GPIO (1) with bus 0x1
20:49:28.771 > Setting up new NeoPixel Strand...
20:49:28.771 > Created NeoPixel strand of length 1 on GPIO #D0
20:49:28.771 > -> wippersnapper_signal_v1_PixelsResponse...* NEW MESSAGE [Topic: Pixels]:
20:49:28.771 > 13 bytes.
20:49:28.771 > [Message Type]: wippersnapper_signal_v1_PixelsRequest_req_pixels_write_tag
20:49:28.771 > Filling color: 5460819
20:49:28.771 > * NEW MESSAGE [Topic: Signal-I2C]:
20:49:28.771 > 75 bytes.
20:49:28.771 > cbDecodeSignalRequestI2C
20:49:28.771 > I2C Device LIST Init Request Found!
20:49:28.771 > EXEC: cbDecodeI2CDeviceInitRequestList
20:49:28.771 > EXEC: New I2C Port
20:49:28.771 > Port #: 0
20:49:28.771 > SDA Pin: 22
20:49:28.771 > SCL Pin: 20
20:49:28.771 > Frequency (Hz): 100000
20:49:28.771 > [ 21473][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type GPIO (1) successfully set to 0x401cb9b0
20:49:28.771 > #0 0x401cb9b0 in gpioDetachBus at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-gpio.c:100
20:49:28.771 >
20:49:28.771 > [ 21493][V][esp32-hal-periman.c:160] perimanSetPinBus(): Pin 20 successfully set to type GPIO (1) with bus 0x15
20:49:28.771 > [ 21503][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type GPIO (1) successfully set to 0x401cb9b0
20:49:28.771 > #0 0x401cb9b0 in gpioDetachBus at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-gpio.c:100
20:49:28.771 >
20:49:28.771 > [ 21514][V][esp32-hal-periman.c:160] perimanSetPinBus(): Pin 22 successfully set to type GPIO (1) with bus 0x17
20:49:29.587 > [ 21673][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type I2C_MASTER_SDA (33) successfully set to 0x40114a5c
20:49:29.587 > #0 0x40114a5c in i2cDetachBus at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-i2c-ng.c:46
20:49:29.587 >
20:49:29.587 > [ 21685][V][esp32-hal-periman.c:235] perimanSetBusDeinit(): Deinit function for type I2C_MASTER_SCL (34) successfully set to 0x40114a5c
20:49:29.587 > #0 0x40114a5c in i2cDetachBus at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-i2c-ng.c:46
20:49:29.587 >
20:49:29.587 > [ 21697][V][esp32-hal-periman.c:160] perimanSetPinBus(): Pin 22 successfully set to type INIT (0) with bus 0x0
20:49:29.587 > [ 21707][V][esp32-hal-periman.c:160] perimanSetPinBus(): Pin 20 successfully set to type INIT (0) with bus 0x0
20:49:29.587 > [ 21717][I][esp32-hal-i2c-ng.c:105] i2cInit(): Initializing I2C Master: num=0 sda=22 scl=20 freq=100000
20:49:29.587 > [ 21727][V][esp32-hal-periman.c:160] perimanSetPinBus(): Pin 22 successfully set to type I2C_MASTER_SDA (33) with bus 0x1
20:49:29.587 > [ 21738][V][esp32-hal-periman.c:160] perimanSetPinBus(): Pin 20 successfully set to type I2C_MASTER_SCL (34) with bus 0x1
20:49:29.587 > Attempting to initialize I2C device: bme280
20:49:29.587 > [ 21749][W][Wire.cpp:296] begin(): Bus already started in Master Mode.
20:49:29.587 > [ 21759][V][esp32-hal-i2c-ng.c:221] i2cAddDeviceIfNeeded(): added device: bus=0 addr=0x77 handle=0x3f801318
20:49:29.587 > [ 21769][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=1
20:49:29.587 > [ 21782][V][esp32-hal-i2c-ng.c:262] i2cWrite(): i2c_master_transmit: bus=0 addr=0x77 handle=0x3f801318 size=2
20:49:29.587 > [ 21801][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=1
20:49:29.587 > [ 21814][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=2
20:49:29.587 > [ 21826][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=2
20:49:29.587 > [ 21839][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=2
20:49:29.587 > [ 21852][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=2
20:49:29.587 > [ 21865][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=2
20:49:29.587 > [ 21877][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=2
20:49:29.587 > [ 21890][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=2
20:49:29.587 > [ 21903][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=2
20:49:29.587 > [ 21915][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=2
20:49:29.587 > [ 21928][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=2
20:49:29.587 > [ 21941][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=2
20:49:29.587 > [ 21953][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=2
20:49:29.587 > [ 21966][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=1
20:49:29.587 > [ 21979][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=2
20:49:29.587 > [ 21991][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=1
20:49:29.587 > [ 22004][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=1
20:49:29.587 > [ 22016][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=1
20:49:29.587 > [ 22029][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=1
20:49:29.587 > [ 22042][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=1
20:49:29.587 > [ 22054][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=1
20:49:29.587 > [ 22067][V][esp32-hal-i2c-ng.c:262] i2cWrite(): i2c_master_transmit: bus=0 addr=0x77 handle=0x3f801318 size=2
20:49:29.587 > [ 22077][V][esp32-hal-i2c-ng.c:262] i2cWrite(): i2c_master_transmit: bus=0 addr=0x77 handle=0x3f801318 size=2
20:49:29.587 > [ 22087][V][esp32-hal-i2c-ng.c:262] i2cWrite(): i2c_master_transmit: bus=0 addr=0x77 handle=0x3f801318 size=2
20:49:29.587 > [ 22097][V][esp32-hal-i2c-ng.c:262] i2cWrite(): i2c_master_transmit: bus=0 addr=0x77 handle=0x3f801318 size=2
20:49:29.587 > BME280 Initialized Successfully!
20:49:29.587 > Publishing Message: I2CResponse...ERROR: Failed to publish I2C Response!
20:49:29.587 > EXEC: cbDecodeI2CDeviceInitRequestList
20:49:29.587 > Attempting to initialize I2C device: sgp30
20:49:29.587 > [ 22221][W][Wire.cpp:296] begin(): Bus already started in Master Mode.
20:49:29.587 > [ 22231][V][esp32-hal-i2c-ng.c:221] i2cAddDeviceIfNeeded(): added device: bus=0 addr=0x58 handle=0x3f801348
20:49:29.587 > [ 22240][V][esp32-hal-i2c-ng.c:262] i2cWrite(): i2c_master_transmit: bus=0 addr=0x58 handle=0x3f801348 size=2
20:49:29.587 > [ 22260][V][esp32-hal-i2c-ng.c:308] i2cRead(): i2c_master_receive: bus=0 addr=0x58 handle=0x3f801348 size=9
20:49:29.587 > [ 22271][V][esp32-hal-i2c-ng.c:262] i2cWrite(): i2c_master_transmit: bus=0 addr=0x58 handle=0x3f801348 size=2
20:49:29.587 > [ 22291][V][esp32-hal-i2c-ng.c:308] i2cRead(): i2c_master_receive: bus=0 addr=0x58 handle=0x3f801348 size=3
20:49:29.587 > [ 22301][V][esp32-hal-i2c-ng.c:262] i2cWrite(): i2c_master_transmit: bus=0 addr=0x58 handle=0x3f801348 size=2
20:49:29.587 > SGP30 Initialized Successfully!
20:49:29.587 > Publishing Message: I2CResponse...ERROR: Failed to publish I2C Response!
20:49:29.587 > Published!
20:49:29.588 > Hardware configured successfully!
20:49:30.378 > Registration and configuration complete!
20:49:30.378 > Running application...
20:49:30.383 > =========== After Setup Start ============
20:49:30.383 > INTERNAL Memory Info:
20:49:30.388 > ------------------------------------------
20:49:30.388 > Total Size : 314756 B ( 307.4 KB)
20:49:30.388 > Free Bytes : 162516 B ( 158.7 KB)
20:49:30.398 > Allocated Bytes : 140320 B ( 137.0 KB)
20:49:30.405 > Minimum Free Bytes: 154368 B ( 150.8 KB)
20:49:30.405 > Largest Free Block: 110580 B ( 108.0 KB)
20:49:30.408 > ------------------------------------------
20:49:30.408 > SPIRAM Memory Info:
20:49:30.408 > ------------------------------------------
20:49:30.422 > Total Size : 2097152 B (2048.0 KB)
20:49:30.425 > Free Bytes : 2092168 B (2043.1 KB)
20:49:30.425 > Allocated Bytes : 2472 B ( 2.4 KB)
20:49:30.425 > Minimum Free Bytes: 2092168 B (2043.1 KB)
20:49:30.439 > Largest Free Block: 2064372 B (2016.0 KB)
20:49:30.439 > ------------------------------------------
20:49:30.441 > GPIO Info:
20:49:30.441 > ------------------------------------------
20:49:30.441 > GPIO : BUS_TYPE[bus/unit][chan]
20:49:30.455 > --------------------------------------
20:49:30.455 > 0 : GPIO
20:49:30.455 > 1 : UART_TX[0]
20:49:30.458 > 2 : GPIO
20:49:30.458 > 3 : UART_RX[0]
20:49:30.458 > 20 : I2C_MASTER_SCL[0]
20:49:30.458 > 22 : I2C_MASTER_SDA[0]
20:49:30.458 > 38 : GPIO
20:49:30.458 > ============ After Setup End =============
20:49:30.491 > Sending MQTT PING: SUCCESS!
20:49:30.676 > WiFi RSSI: -60
20:49:30.699 > Executing state-based event on D38
20:49:30.699 > Encoding pinEvent...Encoded!
20:49:30.701 > Publishing pinEvent...Published!
20:49:30.891 > [ 24490][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=3
20:49:30.905 > Sensor 0x77
20:49:30.905 > Ambient Temperature: 22.65 degrees C
20:49:30.905 > [ 24504][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=3
20:49:30.922 > [ 24521][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=2
20:49:30.935 > Sensor 0x77
20:49:30.935 > Humidity: 47.82 %RH
20:49:30.935 > [ 24534][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=3
20:49:30.951 > [ 24549][V][esp32-hal-i2c-ng.c:356] i2cWriteReadNonStop(): i2c_master_transmit_receive: bus=0 addr=0x77 handle=0x3f801318 write=1 read=3
20:49:30.958 > Sensor 0x77
20:49:30.958 > Pressure: 1018.81 hPa
20:49:30.958 > PUBLISHING -> I2C Device Sensor Event Message...PUBLISHED!
20:49:31.097 > [ 24696][V][esp32-hal-i2c-ng.c:262] i2cWrite(): i2c_master_transmit: bus=0 addr=0x58 handle=0x3f801348 size=2
20:49:31.121 > [ 24719][V][esp32-hal-i2c-ng.c:308] i2cRead(): i2c_master_receive: bus=0 addr=0x58 handle=0x3f801348 size=6
20:49:31.124 > Sensor 0x58
20:49:31.124 > eCO2: 400.00 ppm
20:49:31.124 > [ 24730][V][esp32-hal-i2c-ng.c:262] i2cWrite(): i2c_master_transmit: bus=0 addr=0x58 handle=0x3f801348 size=2
20:49:31.156 > [ 24754][V][esp32-hal-i2c-ng.c:308] i2cRead(): i2c_master_receive: bus=0 addr=0x58 handle=0x3f801348 size=6
20:49:31.157 > Sensor 0x58
20:49:31.157 > TVOC: 0.00 ppb
20:49:31.157 > PUBLISHING -> I2C Device Sensor Event Message...PUBLISHED!
* Terminal will be reused by tasks, press any key to close it.
Questions and Answers:
- [ ] Does it still crash due to NeoPixel, with nothing connected on IO?
-
- Yes, no components (deleted board), and same neopixel / status LED crash.
- [ ] Remove all the components from the device on IO and check if it’s still crashing
-
- Yes, makes it to registration message then crashing on status light change (See above). Seemed random but happened as much as 90% of the time.
-
- Also randomly crashed at Status Blink which I hadn't noticed before (probably mistook some prior crashes at boot instead of blink)
- [ ] Then add the BME280, see if it crashes
-
- No crash, except randomly on a status blink at boot or STATUS LED BLINK KAT
- [ ] Then remove the BME280 and add the SGP30
- [ ] Then add both.
- [ ] I’d really try to isolate it down, because these issues seem far from the actual issue where the user doesn’t see SGP30 data come into IO (edited)
STATUS LED BLINK KAT crash Details
21:03:53.838 > Sending MQTT PING: SUCCESS!
21:03:53.940 > WiFi RSSI: -62
21:03:55.100 > STATUS LED BLINK KAT
21:03:55.154 >
21:03:55.154 > assert failed: vTaskPriorityDisinheritAfterTimeout tasks.c:5267 (pxTCB != pxCurrentTCBs[ xPortGetCoreID() ])
21:03:55.159 >
21:03:55.159 >
21:03:55.159 > Backtrace: 0x40083a68:0x3ffb1fb0 0x4008e829:0x3ffb1fd0 0x40094c15:0x3ffb1ff0 0x4009178a:0x3ffb2130 0x4008f09f:0x3ffb2150 0x400e585a:0x3ffb2190 0x400e5690:0x3ffb21b0 0x400dfd25:0x3ffb21d0 0x400dfeda:0x3ffb21f0 0x400d5f14:0x3ffb2210 0x400d619a:0x3ffb2230 0x400d6816:0x3ffb2250 0x4011b06c:0x3ffb2270 0x4008f4ae:0x3ffb2290
21:03:58.526 > #0 0x40083a68 in panic_abort at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/esp_system/panic.c:454
21:03:58.526 > #1 0x4008e829 in esp_system_abort at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/esp_system/port/esp_system_chip.c:87
21:03:58.526 > #2 0x40094c15 in __assert_func at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/newlib/assert.c:80
21:03:58.526 > #3 0x4009178a in vTaskPriorityDisinheritAfterTimeout at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/freertos/FreeRTOS-Kernel/tasks.c:5267 (discriminator 1)
21:03:58.526 > #4 0x4008f09f in xQueueSemaphoreTake at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/freertos/FreeRTOS-Kernel/queue.c:1842
21:03:58.526 > #5 0x400e585a in espShow at .pio/libdeps/featheresp32v2_debug/Adafruit NeoPixel/esp.c:52 (discriminator 1)
21:03:58.526 > #6 0x400e5690 in Adafruit_NeoPixel::show() at .pio/libdeps/featheresp32v2_debug/Adafruit NeoPixel/Adafruit_NeoPixel.cpp:3176
21:03:58.526 > #7 0x400dfd25 in setStatusLEDColor(unsigned long) at src/components/statusLED/Wippersnapper_StatusLED.cpp:160
21:03:58.526 > #8 0x400dfeda in statusLEDBlink(ws_led_status_t) at src/components/statusLED/Wippersnapper_StatusLED.cpp:404
21:03:58.526 > #9 0x400d5f14 in Wippersnapper::pingBroker() at src/Wippersnapper.cpp:2598
21:03:58.526 > #10 0x400d619a in Wippersnapper::run() at src/Wippersnapper.cpp:2878
21:03:58.526 > #11 0x400d6816 in loop() at C:/Users/tyeth/source/repos/arduino/Adafruit_Wippersnapper_Arduino/src/Wippersnapper_demo.ino:34
21:03:58.526 > #12 0x4011b06c in loopTask(void*) at C:/Users/tyeth/.platformio/packages/framework-arduinoespressif32/cores/esp32/main.cpp:74
21:03:58.526 > #13 0x4008f4ae in vPortTaskWrapper at /home/runner/work/esp32-arduino-lib-builder/esp32-arduino-lib-builder/esp-idf/components/freertos/FreeRTOS-Kernel/portable/xtensa/port.c:139
21:03:58.526 >
21:03:58.526 >
21:03:58.526 >
21:03:58.526 >
21:03:58.526 >
21:03:58.526 > ELF file SHA256: 86407712f
21:04:05.238 >
21:04:05.238 > Rebooting...
Appears to be only happening on my debug builds, maybe a conflict with debug build