use of "median" filters as shown in the example lead to 'Components should block for at most 20-30ms in loop().' warning

[gretel]

one more thing i noted while checking on https://github.com/trvrnrth/esphome-bsec-bme680/issues/29:

[21:59:54][V][sensor:013]: 'PoniWormSuite Temperature': Received new state 19.305878
[21:59:54][VV][sensor.filter:013]: Filter(0x3ffb2820)::input(19.305878)
[21:59:54][VV][sensor.filter:053]: MedianFilter(0x3ffb2820)::new_value(19.305878)
[21:59:54][V][sensor:013]: 'PoniWormSuite Humidity': Received new state 44.856663
[21:59:54][VV][sensor.filter:013]: Filter(0x3ffb3178)::input(44.856663)
[21:59:54][VV][sensor.filter:053]: MedianFilter(0x3ffb3178)::new_value(44.856663)
[21:59:54][V][sensor:013]: 'PoniWormSuite Pressure': Received new state 996.859985
[21:59:54][VV][sensor.filter:013]: Filter(0x3ffb2ddc)::input(996.859985)
[21:59:54][VV][sensor.filter:053]: MedianFilter(0x3ffb2ddc)::new_value(996.859985)
[21:59:54][V][sensor:013]: 'PoniWormSuite Gas Resistance': Received new state 104816.000000
[21:59:54][VV][sensor.filter:013]: Filter(0x3ffb356c)::input(104816.000000)
[21:59:54][VV][sensor.filter:053]: MedianFilter(0x3ffb356c)::new_value(104816.000000)
[21:59:54][V][sensor:013]: 'PoniWormSuite IAQ': Received new state 25.000000
[21:59:54][VV][sensor.filter:013]: Filter(0x3ffb3930)::input(25.000000)
[21:59:54][VV][sensor.filter:053]: MedianFilter(0x3ffb3930)::new_value(25.000000)
[21:59:54][V][sensor:013]: 'PoniWormSuite CO2 Equivalent': Received new state 500.000000
[21:59:54][VV][sensor.filter:013]: Filter(0x3ffb3e14)::input(500.000000)
[21:59:54][VV][sensor.filter:053]: MedianFilter(0x3ffb3e14)::new_value(500.000000)
[21:59:54][V][sensor:013]: 'PoniWormSuite VOC Equivalent': Received new state 0.500000
[21:59:54][VV][sensor.filter:013]: Filter(0x3ffb3cd8)::input(0.500000)
[21:59:54][VV][sensor.filter:053]: MedianFilter(0x3ffb3cd8)::new_value(0.500000)
[21:59:54][V][app:081]: A component took a long time in a loop() cycle (0.74 s).
[21:59:54][V][app:082]: Components should block for at most 20-30ms in loop().

again, this might be more of an upstream issue. but probably worth raising your attention. regards!

[trvrnrth]

Looking at the core app code I think that's the loop execution time for all components so the message appears to be slightly misleading.

The upstream BSEC library does necessitate use of a delay in the loop which isn't ideal but I believe it will be relatively short and will at least yield allowing things like the TCP stack to be serviced.

I'm also not sure if you're seeing the effects of that or the time taken to push the sensor states themselves. I did previously have the state pushes split across subsequent loop calls but neatened that up in 8226e17eeb97138d08948e78d38e5d0a8de48f7b as it was pretty ugly. I'm not actually sure if the pushes via the API are decoupled further up the chain internally so it's possible that network latency might come into play here too.

0.74 seconds does seem very high though so when I get a chance I'll check the behaviour on my test board and see how that compares.

[gretel]

@trvrnrth thanks for the insight!

it's possible that network latency might come into play here too

good point. it's actually far worse than i expected:

50 packets transmitted, 50 received, 0% packet loss, time 49071ms
rtt min/avg/max/mdev = 22.215/158.096/319.959/88.832 ms

going to check why this is so latent.

0.74 seconds does seem very high though so when I get a chance I'll check the behaviour on my test board and see how that compares.

thank you!

[trvrnrth]

It turns out that delay I was mentioning was actually a whopping 240ms! So on the basis of that I've taken the plunge and ripped out the Bosch Bsec helper class to give me the flexibility to handle that as a timeout callback and properly yield control to the rest of the app and other components. I was avoiding it as it's more hassle but overall the handling is nicer so it's been worth the effort.

The changes are hot off the press over in #31 if you're able to try them out. There's more scope to yield control at certain points during execution if needed but I have a feeling just taking out that massive delay is probably sufficient so they'll no longer be needed. I've only had it running on my test board for a short period of time but initial results are promising.

[gretel]

@trvrnrth 240ms is quite something! thanks for working on this.

flashed two esp32 using #31 (19e19cd) and both are working fine. though, it looks - well - similar :)

[08:15:39][V][sensor:013]: 'PoniWormBox Temperature': Received new state 18.165531
[08:15:39][VV][sensor.filter:013]: Filter(0x3ffb2bdc)::input(18.165531)
[08:15:39][VV][sensor.filter:053]: MedianFilter(0x3ffb2bdc)::new_value(18.165531)
[08:15:39][V][sensor:013]: 'PoniWormBox Humidity': Received new state 100.000000
[08:15:39][VV][sensor.filter:013]: Filter(0x3ffb3594)::input(100.000000)
[08:15:39][VV][sensor.filter:053]: MedianFilter(0x3ffb3594)::new_value(100.000000)
[08:15:39][V][sensor:013]: 'PoniWormBox Pressure': Received new state 1011.890015
[08:15:39][VV][sensor.filter:013]: Filter(0x3ffb31d0)::input(1011.890015)
[08:15:39][VV][sensor.filter:053]: MedianFilter(0x3ffb31d0)::new_value(1011.890015)
[08:15:39][V][sensor:013]: 'PoniWormBox Gas Resistance': Received new state 98723.000000
[08:15:39][VV][sensor.filter:013]: Filter(0x3ffb3958)::input(98723.000000)
[08:15:39][VV][sensor.filter:053]: MedianFilter(0x3ffb3958)::new_value(98723.000000)
[08:15:39][V][sensor:013]: 'PoniWormBox IAQ': Received new state 190.047607
[08:15:39][VV][sensor.filter:013]: Filter(0x3ffb3d14)::input(190.047607)
[08:15:39][VV][sensor.filter:053]: MedianFilter(0x3ffb3d14)::new_value(190.047607)
[08:15:39][V][sensor:013]: 'PoniWormBox CO2 Equivalent': Received new state 1900.476074
[08:15:39][VV][sensor.filter:013]: Filter(0x3ffb41f8)::input(1900.476074)
[08:15:39][VV][sensor.filter:053]: MedianFilter(0x3ffb41f8)::new_value(1900.476074)
[08:15:39][V][sensor:013]: 'PoniWormBox VOC Equivalent': Received new state 6.060450
[08:15:39][VV][sensor.filter:013]: Filter(0x3ffb4564)::input(6.060450)
[08:15:39][VV][sensor.filter:053]: MedianFilter(0x3ffb4564)::new_value(6.060450)
[08:15:39][V][app:081]: A component took a long time in a loop() cycle (0.73 s).
[08:15:39][V][app:082]: Components should block for at most 20-30ms in loop().

did i miss something?

[trvrnrth]

You should see a few new verbose log lines before that as well from the new version:

[08:39:05][V][bme680_bsec.sensor:170]: Performing sensor run
[08:39:05][V][bme680_bsec.sensor:201]: Queueing read in 240ms
[08:39:06][V][bme680_bsec.sensor:206]: Reading data
[08:39:06][V][bme680_bsec.sensor:274]: Publishing sensor states

[gretel]

oh dang missed to actually copy the updated files over 🤦

[13:33:31][V][bme680_bsec.sensor:170]: Performing sensor run
[13:33:31][VV][i2c:056]: Beginning Transmission to 0x77:
[13:33:31][VV][i2c:093]:     Writing 0b01011010 (0x5A)
[13:33:31][VV][i2c:093]:     Writing 0b01101101 (0x6D)
[13:33:31][VV][i2c:093]:     Writing 0b01100100 (0x64)
[13:33:31][VV][i2c:093]:     Writing 0b01110001 (0x71)
[13:33:31][VV][i2c:061]:     Transmission ended. Status code: 0x00
[13:33:31][VV][i2c:056]: Beginning Transmission to 0x77:
[13:33:31][VV][i2c:093]:     Writing 0b01110100 (0x74)
[13:33:31][VV][i2c:061]:     Transmission ended. Status code: 0x00
[13:33:31][VV][i2c:083]: Requesting 1 bytes from 0x77:
[13:33:31][VV][i2c:113]:     Received 0b01010100 (0x54)
[13:33:31][VV][i2c:056]: Beginning Transmission to 0x77:
[13:33:31][VV][i2c:093]:     Writing 0b01110101 (0x75)
[13:33:31][VV][i2c:061]:     Transmission ended. Status code: 0x00
[13:33:31][VV][i2c:083]: Requesting 1 bytes from 0x77:
[13:33:31][VV][i2c:113]:     Received 0b00000000 (0x00)
[13:33:31][VV][i2c:056]: Beginning Transmission to 0x77:
[13:33:31][VV][i2c:093]:     Writing 0b01110100 (0x74)
[13:33:31][VV][i2c:061]:     Transmission ended. Status code: 0x00
[13:33:31][VV][i2c:083]: Requesting 1 bytes from 0x77:
[13:33:31][VV][i2c:113]:     Received 0b01010100 (0x54)
[13:33:31][VV][i2c:056]: Beginning Transmission to 0x77:
[13:33:31][VV][i2c:093]:     Writing 0b01110010 (0x72)
[13:33:31][VV][i2c:061]:     Transmission ended. Status code: 0x00
[13:33:31][VV][i2c:083]: Requesting 1 bytes from 0x77:
[13:33:31][VV][i2c:113]:     Received 0b00000001 (0x01)
[13:33:31][VV][i2c:056]: Beginning Transmission to 0x77:
[13:33:31][VV][i2c:093]:     Writing 0b01110001 (0x71)
[13:33:31][VV][i2c:061]:     Transmission ended. Status code: 0x00
[13:33:31][VV][i2c:083]: Requesting 1 bytes from 0x77:
[13:33:31][VV][i2c:113]:     Received 0b00010000 (0x10)
[13:33:31][VV][i2c:056]: Beginning Transmission to 0x77:
[13:33:31][VV][i2c:093]:     Writing 0b01110101 (0x75)
[13:33:31][VV][i2c:093]:     Writing 0b00000000 (0x00)
[13:33:31][VV][i2c:093]:     Writing 0b01110100 (0x74)
[13:33:31][VV][i2c:093]:     Writing 0b01010100 (0x54)
[13:33:31][VV][i2c:093]:     Writing 0b01110010 (0x72)
[13:33:31][VV][i2c:093]:     Writing 0b00000001 (0x01)
[13:33:32][VV][i2c:093]:     Writing 0b01110001 (0x71)
[13:33:32][VV][i2c:093]:     Writing 0b00010000 (0x10)
[13:33:32][VV][i2c:061]:     Transmission ended. Status code: 0x00
[13:33:32][VV][i2c:056]: Beginning Transmission to 0x77:
[13:33:32][VV][i2c:093]:     Writing 0b01110100 (0x74)
[13:33:32][VV][i2c:061]:     Transmission ended. Status code: 0x00
[13:33:32][VV][i2c:083]: Requesting 1 bytes from 0x77:
[13:33:32][VV][i2c:113]:     Received 0b01010100 (0x54)
[13:33:32][VV][i2c:056]: Beginning Transmission to 0x77:
[13:33:32][VV][i2c:093]:     Writing 0b01110100 (0x74)
[13:33:32][VV][i2c:093]:     Writing 0b01010101 (0x55)
[13:33:32][VV][i2c:061]:     Transmission ended. Status code: 0x00
[13:33:32][V][bme680_bsec.sensor:201]: Queueing read in 240ms
[13:33:32][VV][scheduler:026]: set_timeout(name='read', timeout=240)
[13:33:32][V][app:081]: A component took a long time in a loop() cycle (0.27 s).
[13:33:32][V][app:082]: Components should block for at most 20-30ms in loop().
[13:33:32][VV][scheduler:152]: Running timeout 'read' with interval=240 last_execution=137131 (now=137371)
[13:33:32][V][bme680_bsec.sensor:206]: Reading data
[13:33:32][VV][i2c:056]: Beginning Transmission to 0x77:
[13:33:32][VV][i2c:093]:     Writing 0b00011101 (0x1D)
[13:33:32][VV][i2c:061]:     Transmission ended. Status code: 0x00
[13:33:32][VV][i2c:083]: Requesting 15 bytes from 0x77:
[13:33:32][VV][i2c:113]:     Received 0b10000000 (0x80)
[13:33:32][VV][i2c:113]:     Received 0b00000000 (0x00)
[13:33:32][VV][i2c:113]:     Received 0b01001100 (0x4C)
[13:33:32][VV][i2c:113]:     Received 0b10100000 (0xA0)
[13:33:32][VV][i2c:113]:     Received 0b11000000 (0xC0)
[13:33:32][VV][i2c:113]:     Received 0b01110100 (0x74)
[13:33:32][VV][i2c:113]:     Received 0b00101100 (0x2C)
[13:33:32][VV][i2c:113]:     Received 0b10000000 (0x80)
[13:33:32][VV][i2c:113]:     Received 0b01100110 (0x66)
[13:33:32][VV][i2c:113]:     Received 0b11101010 (0xEA)
[13:33:32][VV][i2c:113]:     Received 0b10000000 (0x80)
[13:33:32][VV][i2c:113]:     Received 0b00000000 (0x00)
[13:33:32][VV][i2c:113]:     Received 0b00000000 (0x00)
[13:33:32][VV][i2c:113]:     Received 0b00010000 (0x10)
[13:33:32][VV][i2c:113]:     Received 0b10110111 (0xB7)
[13:33:32][V][bme680_bsec.sensor:274]: Publishing sensor states

now it's different - takes about 2/3 less time per cycle! 👍

[trvrnrth]

That's more like the improvement I was expecting!

I suspect you'll find the rest of the time is spent doing the VERY_VERBOSE logging and if you dial it back to VERBOSE you'll be within the acceptable loop block time (that log is itself VERBOSE so it would still be present if applicable).

I'd hope that the combination of these two things will sort out the API disconnects you've been seeing in #29 as well.

[gretel]

I'd hope that the combination of these two things will sort out the API disconnects you've been seeing in #29 as well.

now, it's worse 😄 - crashing every cycle even without connecting to the http port.

[22:42:54][V][api.connection:588]: Hello from client: 'Home Assistant 2021.1.5 (10.0.23.16)'
[22:42:54]Fatal exception 29(StoreProhibitedCause):
[22:42:54]epc1=0x4000df64, epc2=0x00000000, epc3=0x00000000, excvaddr=0x00000000, depc=0x00000000
[22:42:54]
[22:42:54]--------------- CUT HERE FOR EXCEPTION DECODER ---------------
[22:42:54]
[22:42:54]Exception (29):
WARNING Exception type: Access to invalid address: STORE (wild pointer?)
[22:42:54]epc1=0x4000df64 epc2=0x00000000 epc3=0x00000000 excvaddr=0x00000000 depc=0x00000000
[22:42:55]
[22:42:55]>>>stack>>>
WARNING Found stack trace! Trying to decode it
[22:42:55]
[22:42:55]ctx: sys
[22:42:55]sp: 3fffec10 end: 3fffffb0 offset: 0190
[22:42:55]3fffeda0:  0000001a 3fff3498 00000002 40100e2c
WARNING Decoded 0x40100e2c: pvPortZalloc
[22:42:55]3fffedb0:  402584f3 00000000 00000005 40258488
WARNING Decoded 0x402584f3: ieee80211_setup_ratetable
WARNING Decoded 0x40258488: ieee80211_setup_ratetable
[22:42:55]3fffedc0:  00000002 4025842f 00000002 40257584
WARNING Decoded 0x4025842f: ieee80211_phy_init
WARNING Decoded 0x40257584: cnx_update_bss_more
[22:42:55]3fffedd0:  402575ad 3fffee80 3fff3498 0000001a
WARNING Decoded 0x402575ad: cnx_update_bss_more
[22:42:55]3fffede0:  40255020 3fffee80 3fff3344 3fff2d30
WARNING Decoded 0x40255020: scan_parse_beacon
[22:42:55]3fffedf0:  3ffef790 3fffee80 3fffee80 40100e08
WARNING Decoded 0x40100e08: free
[22:42:55]3fffee00:  6e616c50 61467465 40006c6c 00000100
[22:42:55]3fffee10:  3ffef0fc 7fffffff 00002200 00000001
[22:42:55]3fffee20:  40251391 00000080 3fffbde4 40101479
WARNING Decoded 0x40251391: ieee80211_parse_beacon
WARNING Decoded 0x40101479: check_poison_neighbors$part$3 at umm_malloc.cpp
[22:42:55]3fffee30:  ffffffbd 3fff2e58 3ffef7a0 3fff3498
[22:42:55]3fffee40:  3fff2300 0000001d 00000000 40255d17
WARNING Decoded 0x40255d17: sta_input
[22:42:55]3fffee50:  00000000 3fff54f4 ffffffbd 00000000
[22:42:55]3fffee60:  00000000 3fff3498 00000013 0000000f
[22:42:55]3fffee70:  40000f58 00000000 08e878f3 00000000
[22:42:55]3fffee80:  00000000 00310909 00640100 00000049
[22:42:55]3fffee90:  3ffef7b4 000000bf 3ffef7cd 3ffef7a8
[22:42:55]3fffeea0:  3ffef7d3 3ffef7b4 3ffef7c0 00000000
[22:42:55]3fffeeb0:  00000000 3ffef841 3ffef7de 3ffef859
[22:42:55]3fffeec0:  3ffef803 3ffef81f 00000000 00000000
[22:42:55]3fffeed0:  00000000 00000000 0000001d 00000000
[22:42:55]3fffeee0:  3fff58cc 4025578a 3fff2300 3fff54f4
WARNING Decoded 0x4025578a: sta_input
[22:42:55]3fffeef0:  00000000 3fff3498 3fff2300 3ffef790
[22:42:55]3fffef00:  3ffef790 000000e7 00000000 0000001d
[22:42:55]3fffef10:  00000000 3ffef79a 4025ef07 3fff2300
WARNING Decoded 0x4025ef07: pp_tx_idle_timeout
[22:42:55]3fffef20:  3ffef784 3fffdcc0 3ffee970 3ffee970
[22:42:55]3fffef30:  00000080 3fff2300 00000000 3ffe85c4
[22:42:55]3fffef40:  4025e7c7 3fffdab0 00000000 40230680
WARNING Decoded 0x4025e7c7: ppPeocessRxPktHdr
WARNING Decoded 0x40230680: loop_task(ETSEventTag*) at core_esp8266_main.cpp
[22:42:55]3fffef50:  3ffee970 40000f49 3fffdab0 40000f49
[22:42:55]3fffef60:  40000e19 00000005 0008347c 00000000
[22:42:55]3fffef70:  3fffefc0 aa55aa55 000000e7 401056fd
WARNING Decoded 0x401056fd: call_user_start_local
[22:42:55]3fffef80:  40105703 0008347c 00000000 2f64322e
WARNING Decoded 0x40105703: call_user_start_local
[22:42:55]3fffef90:  4010000d 322e252f 2d590064 252d6d25
WARNING Decoded 0x4010000d: call_user_start
[22:42:55]3fffefa0:  4025d69c 3fffef3c 4025d64d 3fffff28
WARNING Decoded 0x4025d69c: cont_ret at cont.S.o
WARNING Decoded 0x4025d64d: cont_continue at cont.S.o
[22:42:55]3fffefb0:  3fffffc0 00000000 00000000 feefeffe
[22:42:55]3fffefc0:  feefeffe feefeffe feefeffe feefeffe
[22:42:55]3fffefd0:  00000003 00000000 0000000a 00000000
[22:42:55]3fffefe0:  00000003 00000000 0000000a 00000000
[22:42:55]3fffeff0:  feefeffe feefeffe feefeffe feefeffe
[22:42:55]3ffff000:  00000000 a0000000 00000000 0000001c
[22:42:55]3ffff010:  00003000 feefeffe 00003000 00000000
[22:42:55]3ffff020:  3ffff180 00000000 3ffff180 4023e56e
WARNING Decoded 0x4023e56e: __ssputs_r at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf.c:233
[22:42:55]3ffff030:  0000a000 3ffff123 feefeffe feefeffe
[22:42:55]3ffff040:  feefeffe feefeffe 40238c31 00000003
WARNING Decoded 0x40238c31: _printf_i at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf_i.c:194 (discriminator 1)
[22:42:55]3ffff050:  3ffff180 00000003 3ffff180 4023e56e
WARNING Decoded 0x4023e56e: __ssputs_r at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf.c:233
[22:42:55]3ffff060:  3ffff0e0 3ffff120 3ffff090 00000000
[22:42:55]3ffff070:  feefeffe feefeffe feefeffe 4023e4a4
WARNING Decoded 0x4023e4a4: __ssputs_r at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf.c:180
[22:42:55]3ffff080:  3ffff180 3ffff120 3ffff0e0 40238d5c
WARNING Decoded 0x40238d5c: _printf_i at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf_i.c:246
[22:42:55]3ffff090:  00000003 00000000 0000000a 00000003
[22:42:55]3ffff0a0:  00000000 00000003 3ffff180 4023e56e
WARNING Decoded 0x4023e56e: __ssputs_r at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf.c:233
[22:42:55]3ffff0b0:  3ffff123 3ffeb195 00000000 0000001c
[22:42:55]3ffff0c0:  00001000 feefeffe 00001000 3ffeb195
[22:42:55]3ffff0d0:  00000000 3ffeb198 3ffff180 4023e758
WARNING Decoded 0x4023e758: _svfprintf_r at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf.c:531
[22:42:56]3ffff0e0:  00000004 ffffffff ffffffff 0000000c
[22:42:56]3ffff0f0:  00000000 0000000c 3ffff1d0 4023e56e
WARNING Decoded 0x4023e56e: __ssputs_r at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf.c:233
[22:42:56]3ffff100:  3ffff230 3ffea946 3ffff230 4023e56e
WARNING Decoded 0x4023e56e: __ssputs_r at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf.c:233
[22:42:56]3ffff110:  3ffff190 3ffff1d0 3ffff140 3ffea946
[22:42:56]3ffff120:  00000000 3ffea952 3ffff1d0 4023e758
WARNING Decoded 0x4023e758: _svfprintf_r at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf.c:531
[22:42:56]3ffff130:  3ffff230 3ffff1d0 00000000 40238d5c
WARNING Decoded 0x40238d5c: _printf_i at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf_i.c:246
[22:42:56]3ffff140:  3ffff270 0000000c 00302018 3ffe8344
[22:42:56]3ffff150:  00000003 00000003 00000000 40273991
WARNING Decoded 0x40273991: sleep_reset_analog_rtcreg_8266
[22:42:56]3ffff160:  3ffff1d3 00000001 00000000 3ffea946
[22:42:56]3ffff170:  00000003 3ffe8344 00000200 4023bb51
WARNING Decoded 0x4023bb51: _vsnprintf_r at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/vsnprintf.c:73
[22:42:56]3ffff180:  3fff5c08 3ffec5fb 000001db ffff0208
[22:42:56]3ffff190:  3ffff320 3ffff310 00000010 3ffe8344
[22:42:56]3ffff1a0:  00000003 0000000c 00000000 3f800000
[22:42:56]3ffff1b0:  3f800000 3f800000 3fff44d0 3ffea946
[22:42:56]3ffff1c0:  00000003 3ffe8344 000001dc 4023bb51
WARNING Decoded 0x4023bb51: _vsnprintf_r at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/vsnprintf.c:73
[22:42:56]3ffff1d0:  3fff5c14 3f800000 000001cf ffff0208
[22:42:56]3ffff1e0:  3fff5c08 000001db 00000000 4010142a
WARNING Decoded 0x4010142a: check_poison_neighbors$part$3 at umm_malloc.cpp
[22:42:56]3ffff1f0:  3ffedcc0 00000000 0a0d0a0d 402322c1
WARNING Decoded 0x402322c1: uart_write
[22:42:56]3ffff200:  3ffedcc0 00000000 6d305b1b 402322c1
WARNING Decoded 0x402322c1: uart_write
[22:42:56]3ffff210:  3fff5c18 3ffffb40 00000020 3ffea5a7
[22:42:56]3ffff220:  4022dc54 3fff4c14 3ffedcbe 4022dc60
WARNING Decoded 0x4022dc54: HardwareSerial::write(unsigned char const*, unsigned int)
WARNING Decoded 0x4022dc60: HardwareSerial::write(unsigned char const*, unsigned int)
[22:42:56]3ffff230:  4022dc54 3fff4c14 3ffedcbe 4022e091
WARNING Decoded 0x4022dc54: HardwareSerial::write(unsigned char const*, unsigned int)
WARNING Decoded 0x4022e091: Print::write(char const*)
[22:42:56]3ffff240:  00000003 00000034 3fff4c14 4022e310
WARNING Decoded 0x4022e310: Print::println()
[22:42:56]3ffff250:  00000003 3fff5be4 3fff4c14 4022e384
WARNING Decoded 0x4022e384: Print::println(char const*)
[22:42:56]3ffff260:  75307530 3fff5be4 3fff5b94 40212a00
WARNING Decoded 0x40212a00: esphome::logger::Logger::log_message_(int, char const*, int)
[22:42:56]3ffff270:  3ffea5a7 00000167 00000015 402128f6
WARNING Decoded 0x402128f6: esphome::logger::Logger::vprintf_to_buffer_(char const*, __va_list_tag)
[22:42:56]3ffff280:  3ffff320 3ffff310 00000010 3ffea946
[22:42:56]3ffff290:  00000003 3ffea5a7 3fff5b94 40212b70
WARNING Decoded 0x40212b70: esphome::logger::Logger::log_vprintf_(int, char const*, int, char const*, __va_list_tag)
[22:42:56]3ffff2a0:  00000000 3ffff340 3fff46b0 40204b0a
WARNING Decoded 0x40204b0a: bsec_HumidityTemperatureCorrector_setState
[22:42:56]3ffff2b0:  00000008 00000008 00000000 0000003c
[22:42:56]3ffff2c0:  3fff67ec 3ffea5a7 3fff67ec 4021da20
WARNING Decoded 0x4021da20: esphome::esp_log_vprintf_(int, char const*, int, char const*, __va_list_tag)
[22:42:56]3ffff2d0:  3ffff320 3ffff310 00000010 402019ec
WARNING Decoded 0x402019ec: bsec_codegen_set_state
[22:42:56]3ffff2e0:  3ffff2f0 00000023 3ffff300 4021da4c
WARNING Decoded 0x4021da4c: esphome::esp_log_printf_(int, char const*, int, char const*, ...)
[22:42:56]3ffff2f0:  3ffff320 3ffff310 00000010 4021dc0a
WARNING Decoded 0x4021dc0a: esphome::ESPPreferenceObject::load_internal_()
[22:42:56]3ffff300:  3ffff320 3ffff310 00000010 3fff9cf4
[22:42:56]3ffff310:  3fff6701 0000000f 3ffffb40 0000003c
[22:42:56]3ffff320:  00000000 00000000 3fff67ec 402010d4
WARNING Decoded 0x402010d4: bsec_set_state
[22:42:56]3ffff330:  3fff67ec 3fff687c 3fff67ec 4020e451
WARNING Decoded 0x4020e451: esphome::bme680_bsec::BME680BSECComponent::load_state_()
[22:42:56]3ffff340:  400a0008 4199dc0c 00000d3c 00000000
[22:42:56]3ffff350:  528c002b 00000101 1515012c 40400000
[22:42:56]3ffff360:  40400000 00030000 3f5fa817 40201914
WARNING Decoded 0x40201914: bsec_codegen_set_configuration
[22:42:57]3ffff370:  3ffff380 feefeffe feefeffe feefeffe
[22:42:57]3ffff380:  000000e5 000001be 00000000 feefeffe
[22:42:57]3ffff390:  000001be 000001c6 feefeffe feefeffe
[22:42:57]3ffff3a0:  feefeffe feefeffe feefeffe 0000003c
[22:42:57]3ffff3b0:  3fff67ec 0000000f 3fff67ec 402010b0
WARNING Decoded 0x402010b0: bsec_set_configuration
[22:42:57]3ffff3c0:  feefeffe feefeffe feefeffe 4020dc28
WARNING Decoded 0x4020dc28: esphome::bme680_bsec::BME680BSECComponent::set_config_(unsigned char const*)
[22:42:57]3ffff3d0:  00fe00e5 30050102 2c006475 97177001
[22:42:57]3ffff3e0:  c5038407 90045c00 40014001 30019001
[22:42:57]3ffff3f0:  30753075 64753075 64006400 30753000
[22:42:57]3ffff400:  64753075 30006400 64753075 64006400
[22:42:57]3ffff410:  30006400 30753075 64006475 30006400
[22:42:57]3ffff420:  64753075 2c006400 2c012c01 2c012c01
[22:42:57]3ffff430:  2c012c01 2c012c01 2c012c01 2c012c01
[22:42:57]3ffff440:  08012c01 08070807 08070807 08070807
[22:42:57]3ffff450:  08070807 08070807 08070807 70070807
[22:42:57]3ffff460:  70177017 70177017 70177017 70177017
[22:42:57]3ffff470:  70177017 70177017 ff177017 ffffffff
[22:42:57]3ffff480:  dcffffff dc05dc05 ffffff05 dcffffff
[22:42:57]3ffff490:  ff05dc05 ffffffff ffffffff ffffffff
[22:42:57]3ffff4a0:  ffffffff ffffffff ffffffff ffffffff
[22:42:57]3ffff4b0:  2cffffff feefef01 feefeffe feefeffe
[22:42:57]3ffff4c0:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff4d0:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff4e0:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff4f0:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff500:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff510:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff520:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff530:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff540:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff550:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff560:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff570:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff580:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff590:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff5a0:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff5b0:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff5c0:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff5d0:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff5e0:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff5f0:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff600:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff610:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff620:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff630:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff640:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff650:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff660:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff670:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff680:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff690:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff6a0:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff6b0:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff6c0:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff6d0:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff6e0:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff6f0:  feefeffe feefeffe feefeffe feefeffe
[22:42:57]3ffff700:  00000046 404b3bf3 e0000000 4023e2ca
WARNING Decoded 0x4023e2ca: __d2b at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdlib/mprec.c:786
[22:42:57]3ffff710:  00000000 00000007 feefeffe feefeffe
[22:42:57]3ffff720:  3ffff750 3ffff754 feefeffe feefeffe
[22:42:57]3ffff730:  feefeffe 7fcd977f feefeffe 404b3bf3
[22:42:57]3ffff740:  ffcf2c00 00000007 3fff9cd3 4023cea5
WARNING Decoded 0x4023cea5: _dtoa_r at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdlib/dtoa.c:858
[22:42:57]3ffff750:  ffffffee 00000018 0000000a 00000000
[22:42:57]3ffff760:  00000001 3ffe8344 00000007 3fff9c9c
[22:42:57]3ffff770:  bfeb0000 3e311092 00000013 00000000
[22:42:57]3ffff780:  3fff9ccc 00000003 00000000 00000006
[22:42:57]3ffff790:  00000001 00000000 0000000a 00000000
[22:42:57]3ffff7a0:  00000001 00000000 0000000a 00000000
[22:42:57]3ffff7b0:  3fff9cd3 00000007 40238c31 00000000
WARNING Decoded 0x40238c31: _printf_i at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf_i.c:194 (discriminator 1)
[22:42:57]3ffff7c0:  00000000 a0000000 00000000 0000001c
[22:42:57]3ffff7d0:  00001000 3ffff8e3 00001000 00000000
[22:42:57]3ffff7e0:  3ffff940 00000000 3ffff940 4023e56e
WARNING Decoded 0x4023e56e: __ssputs_r at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf.c:233
[22:42:57]3ffff7f0:  0000a000 3ffff8e3 3ffff940 4023e56e
WARNING Decoded 0x4023e56e: __ssputs_r at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf.c:233
[22:42:57]3ffff800:  00000001 3fff9cce 40238c31 00000001
WARNING Decoded 0x40238c31: _printf_i at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf_i.c:194 (discriminator 1)
[22:42:57]3ffff810:  3ffff940 00000001 3ffff940 4023e56e
WARNING Decoded 0x4023e56e: __ssputs_r at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf.c:233
[22:42:57]3ffff820:  3ffff8a0 3ffff8e2 3ffff850 00000000
[22:42:57]3ffff830:  3ffff85c 3ffff858 00000066 4023e4a4
WARNING Decoded 0x4023e4a4: __ssputs_r at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf.c:180
[22:42:57]3ffff840:  3ffff940 3ffff8e2 3ffff8a0 40238d5c
WARNING Decoded 0x40238d5c: _printf_i at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf_i.c:246
[22:42:57]3ffff850:  00000001 00000007 00000002 00000015
[22:42:57]3ffff860:  00000005 00000000 00000020 40100944
WARNING Decoded 0x40100944: ets_post
[22:42:57]3ffff870:  00000046 404b5135 e0000000 4023e2ca
WARNING Decoded 0x4023e2ca: __d2b at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdlib/mprec.c:786
[22:42:57]3ffff880:  00000000 00000007 3fff22d8 3ffeb7b3
[22:42:57]3ffff890:  3ffff8c0 3ffff8c4 3ffff940 4023e758
WARNING Decoded 0x4023e758: _svfprintf_r at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf.c:531
[22:42:57]3ffff8a0:  00000005 00000000 00000020 40100944
WARNING Decoded 0x40100944: ets_post
[22:42:57]3ffff8b0:  00000000 00000007 00000005 40102344
WARNING Decoded 0x40102344: pp_post
[22:42:57]3ffff8c0:  3ffee875 401055f7 3fff2300 00000000
WARNING Decoded 0x401055f7: lmacRxDone
[22:42:57]3ffff8d0:  40102edb 3fff2300 00000007 3fff9c9c
WARNING Decoded 0x40102edb: rcReachRetryLimit
[22:42:57]3ffff8e0:  00007fff 014ce80e 3fff2d30 401030bc
WARNING Decoded 0x401030bc: rcReachRetryLimit
[22:42:57]3ffff8f0:  3ffef114 00000000 00000000 4023e2ca
WARNING Decoded 0x4023e2ca: __d2b at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdlib/mprec.c:786
[22:42:57]3ffff900:  00007fff 014ce80e 4010357e 00000100
WARNING Decoded 0x4010357e: wDev_ProcessFiq
[22:42:57]3ffff910:  3ffef114 7fffffff 00002200 00000001
[22:42:57]3ffff920:  00000001 00000080 40238c31 404b441f
WARNING Decoded 0x40238c31: _printf_i at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf_i.c:194 (discriminator 1)
[22:42:57]3ffff930:  3ffef114 00000008 3fff9cd4 014ce80e
[22:42:57]3ffff940:  3ffef0f0 2c9f0300 4000050c 3fffc278
[22:42:57]3ffff950:  401032a0 3fffc200 00000022 3fff9c9c
WARNING Decoded 0x401032a0: wDev_ProcessFiq
[22:42:57]3ffff960:  402131ae 00000030 00000010 ffffffff
WARNING Decoded 0x402131ae: esphome::ota::OTAComponent::handle_()
[22:42:57]3ffff970:  402131a9 00000000 3ffffef4 00000000
WARNING Decoded 0x402131a9: esphome::ota::OTAComponent::handle_()
[22:42:57]3ffff980:  3fff6284 00000000 00000000 fffffffe
[22:42:57]3ffff990:  000004b0 3fffc6fc 00000000 3ffffa70
[22:42:57]3ffff9a0:  00000002 3fffb5c0 00005539 00000030
[22:42:57]3ffff9b0:  3ffffb30 00000000 3ffffb30 4023e56e
WARNING Decoded 0x4023e56e: __ssputs_r at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf.c:233
[22:42:58]3ffff9c0:  00000046 3ffffad3 3ffe8344 40238146
WARNING Decoded 0x40238146: __cvt at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf_float.c:101
[22:42:58]3ffff9d0:  007a1200 c05fdda7 3ffff900 00000006
[22:42:58]3ffff9e0:  00000000 00000000 00000001 40100944
WARNING Decoded 0x40100944: ets_post
[22:42:58]3ffff9f0:  00000001 00000004 3fffb0ec 0000501c
[22:42:58]3ffffa00:  3fffb5c0 3ffffa70 3fffb0ec 40230742
WARNING Decoded 0x40230742: yield
[22:42:58]3ffffa10:  4023e4a4 00000010 00000d26 4023077c
WARNING Decoded 0x4023e4a4: __ssputs_r at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf.c:180
WARNING Decoded 0x4023077c: optimistic_yield
[22:42:58]3ffffa20:  00005690 00000ad2 00000ad2 40222852
WARNING Decoded 0x40222852: WiFiServer::available(unsigned char*)
[22:42:58]3ffffa30:  00000000 3fff8678 3ffffa90 00000010
[22:42:58]3ffffa40:  00000020 3fffbccc 3fffaa2c 401019f8
WARNING Decoded 0x401019f8: umm_realloc
[22:42:58]3ffffa50:  3fffb5c0 00000002 3ffffa70 40213239
WARNING Decoded 0x40213239: esphome::ota::OTAComponent::handle_()
[22:42:58]3ffffa60:  00000ad2 00000002 3fff9cce ffffffff
[22:42:58]3ffffa70:  40236100 00000000 00001388 0000001d
WARNING Decoded 0x40236100: precache
[22:42:58]3ffffa80:  00000000 00000000 0000007c 40101a69
WARNING Decoded 0x40101a69: umm_poison_realloc_fl
[22:42:58]3ffffa90:  00000005 00000000 0000000a 00000000
[22:42:58]3ffffaa0:  00000005 00000000 0000000a 00000000
[22:42:58]3ffffab0:  00000003 00000003 00000000 0000005d
[22:42:58]3ffffac0:  00000000 a0000000 00000000 0000001c
[22:42:58]3ffffad0:  00005000 3ffe8344 00005000 00000000
[22:42:58]3ffffae0:  3ffffc40 00000000 3ffffc40 4023e56e
WARNING Decoded 0x4023e56e: __ssputs_r at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf.c:233
[22:42:58]3ffffaf0:  0000a000 3ffffbe3 00000d1a 4010124f
WARNING Decoded 0x4010124f: umm_free_core at umm_malloc.cpp
[22:42:58]3ffffb00:  00000001 00000000 40238c31 00000003
WARNING Decoded 0x40238c31: _printf_i at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf_i.c:194 (discriminator 1)
[22:42:58]3ffffb10:  3ffffc40 00000003 3ffffc40 4023e56e
WARNING Decoded 0x4023e56e: __ssputs_r at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf.c:233
[22:42:58]3ffffb20:  3ffffba0 3ffffbe0 3ffffb50 00000000
[22:42:58]3ffffb30:  3ffffc90 00000000 3ffffc90 4023e56e
WARNING Decoded 0x4023e56e: __ssputs_r at /home/earle/src/esp-quick-toolchain/repo/newlib/newlib/libc/stdio/nano-vfprintf.c:233
[22:42:58]3ffffb40:  3ffffc40 3ffffc33 3ffffba0 40101479
WARNING Decoded 0x40101479: check_poison_neighbors$part$3 at umm_malloc.cpp
[22:42:58]3ffffb50:  00000003 00000004 000009ff 40101534
WARNING Decoded 0x40101534: umm_malloc_core at umm_malloc.cpp
[22:42:58]3ffffb60:  00004ff8 3fff4ec0 3ffffc90 40101479
WARNING Decoded 0x40101479: check_poison_neighbors$part$3 at umm_malloc.cpp
[22:42:58]3ffffb70:  3ffffbe3 00000006 00000d38 40101534
WARNING Decoded 0x40101534: umm_malloc_core at umm_malloc.cpp
[22:42:58]3ffffb80:  00004ff8 000009ff 000009ff 4010124f
WARNING Decoded 0x4010124f: umm_free_core at umm_malloc.cpp
[22:42:58]3ffffb90:  3ffffc90 3fffaa08 3ffffbf0 00000006
[22:42:58]3ffffba0:  00000020 3fffbd5c 3fffa394 401019f8
WARNING Decoded 0x401019f8: umm_realloc
[22:42:58]3ffffbb0:  00000020 0000001c 3fffa394 40101657
WARNING Decoded 0x40101657: get_unpoisoned_check_neighbors at umm_malloc.cpp
[22:42:58]3ffffbc0:  000009ff 3ffe916a 3fffb4cc 40212a21
WARNING Decoded 0x40212a21: esphome::logger::Logger::log_message_(int, char const*, int)
[22:42:58]3ffffbd0:  40101364 0000000d 3fff75f4 0000000b
WARNING Decoded 0x40101364: get_poisoned at umm_malloc.cpp
[22:42:58]3ffffbe0:  00000007 00000020 0000002c 40101a69
WARNING Decoded 0x40101a69: umm_poison_realloc_fl
[22:42:58]3ffffbf0:  00000000 00000024 3ffffd00 40100df4
WARNING Decoded 0x40100df4: realloc
[22:42:58]3ffffc00:  00000024 00000039 00302073 4022f402
WARNING Decoded 0x4022f402: String::changeBuffer(unsigned int)
[22:42:58]3ffffc10:  00000003 00000003 00000000 00000000
[22:42:58]3ffffc20:  0000000b 425a20ff 3fff860c 3ffe9154
[22:42:58]3ffffc30:  00000005 3ffe8344 00000200 3ffe95ad
[22:42:58]3ffffc40:  00000015 00000012 3ffffd00 4022f517
WARNING Decoded 0x4022f517: String::reserve(unsigned int)
[22:42:58]3ffffc50:  00000017 00000015 3ffffd00 4022f90c
WARNING Decoded 0x4022f90c: String::concat(char const*, unsigned int)
[22:42:58]3ffffc60:  00000001 00000017 3ffffd00 3fff5be4
[22:42:58]3ffffc70:  000069c0 00000d38 00000d38 4010124f
WARNING Decoded 0x4010124f: umm_free_core at umm_malloc.cpp
[22:42:59]3ffffc80:  3ffffcc0 00000000 3fffbd5c 3ffe906c
[22:42:59]3ffffc90:  00000006 3fff63c4 00000020 4010174f
WARNING Decoded 0x4010174f: umm_free
[22:42:59]3ffffca0:  3ffedcbe 3ffffcc0 3ffffd00 3ffe906c
[22:42:59]3ffffcb0:  00000006 3fff63c4 3ffffd00 4010176c
WARNING Decoded 0x4010176c: umm_poison_free_fl
[22:42:59]3ffffcc0:  00676f00 00000032 8030006d 00000610
[22:42:59]3ffffcd0:  0000005a 000005b4 00000020 4010179e
WARNING Decoded 0x4010179e: umm_malloc
[22:42:59]3ffffce0:  00000000 00000007 00000d38 40101534
WARNING Decoded 0x40101534: umm_malloc_core at umm_malloc.cpp
[22:42:59]3ffffcf0:  000069c0 000005b4 0000062c 401017d0
WARNING Decoded 0x401017d0: umm_poison_malloc
[22:42:59]3ffffd00:  3fff5be4 0017001f 3fffbcac 40100dd0
WARNING Decoded 0x40100dd0: malloc
[22:42:59]3ffffd10:  00002250 0000044a 0000044a 4024d738
WARNING Decoded 0x4024d738: mem_malloc at /local/users/gauchard/arduino/arduino_esp8266/esp8266-lwip/tools/sdk/lwip2/builder/lwip2-src/src/core/mem.c:210
[22:42:59]3ffffd20:  000056a8 00000000 3fff75ec 40248f42
WARNING Decoded 0x40248f42: pbuf_alloc_LWIP2 at /local/users/gauchard/arduino/arduino_esp8266/esp8266-lwip/tools/sdk/lwip2/builder/lwip2-src/src/core/pbuf.c:284
[22:42:59]3ffffd30:  00000004 3fffaa4c 00000020 4010174f
WARNING Decoded 0x4010174f: umm_free
[22:42:59]3ffffd40:  00000004 4020833a 00000020 000005b4
WARNING Decoded 0x4020833a: void std::vector<unsigned char, std::allocator<unsigned char> >::emplace_back<unsigned char>(unsigned char&&)
[22:42:59]3ffffd50:  000056a8 00000ad5 00000ad5 4010124f
WARNING Decoded 0x4010124f: umm_free_core at umm_malloc.cpp
[22:42:59]3ffffd60:  00000000 00000000 3fffaa44 00000024
[22:42:59]3ffffd70:  3fffbee0 3fffbed4 00000020 4010174f
WARNING Decoded 0x4010174f: umm_free
[22:42:59]3ffffd80:  000069c0 00000d38 00000d38 4010124f
WARNING Decoded 0x4010124f: umm_free_core at umm_malloc.cpp
[22:42:59]3ffffd90:  3fffbee0 00000000 3fffbd5c 00000003
[22:42:59]3ffffda0:  00006c20 00000d84 00000d84 4010124f
WARNING Decoded 0x4010124f: umm_free_core at umm_malloc.cpp
[22:42:59]3ffffdb0:  00000000 00000000 3fffbfbc 00000003
[22:42:59]3ffffdc0:  00000019 40235108 00000020 4010174f
WARNING Decoded 0x40235108: precache
WARNING Decoded 0x4010174f: umm_free
[22:42:59]3ffffdd0:  3fffbee0 3fffbed4 00000000 00000003
[22:42:59]3ffffde0:  00000019 40235108 3fffbed4 4010176c
WARNING Decoded 0x40235108: precache
WARNING Decoded 0x4010176c: umm_poison_free_fl
[22:42:59]3ffffdf0:  00000002 00000000 3ffffe40 40100e08
WARNING Decoded 0x40100e08: free
[22:42:59]3ffffe00:  00000002 3fffbee0 3ffffe40 40244de5
WARNING Decoded 0x40244de5: operator delete(void*) at /workdir/repo/gcc/libstdc++-v3/libsupc++/del_op.cc:48
[22:42:59]3ffffe10:  3fffbee0 3fffbfa8 3fff4f00 40244fbc
WARNING Decoded 0x40244fbc: std::string::_Rep::_M_destroy(std::allocator<char> const&) at /workdir/arena.x86_64/gcc/xtensa-lx106-elf/libstdc++-v3/include/bits/basic_string.tcc:452
[22:42:59]3ffffe20:  3ffffe40 3fffbee0 3fffbed4 40244fde
WARNING Decoded 0x40244fde: std::string::_Rep::_M_dispose(std::allocator<char> const&) at /workdir/arena.x86_64/gcc/xtensa-lx106-elf/libstdc++-v3/include/bits/basic_string.h:254
[22:42:59]3ffffe30:  00000019 40235108 3fffbed4 40244ffa
WARNING Decoded 0x40235108: precache
WARNING Decoded 0x40244ffa: std::basic_string<char, std::char_traits<char>, std::allocator<char> >::~basic_string() at /workdir/arena.x86_64/gcc/xtensa-lx106-elf/libstdc++-v3/include/bits/basic_string.h:541
[22:42:59]3ffffe40:  00000000 4bc6a7f0 0000559e 0000559e
[22:42:59]3ffffe50:  0000559e 000f4240 3fffb5bc 0000559e
[22:42:59]3ffffe60:  0000559e 00000000 000f4240 00000000
[22:42:59]3ffffe70:  00000000 4bc6a7f0 4020dd32 3fff67ec
WARNING Decoded 0x4020dd32: esphome::bme680_bsec::BME680BSECComponent::get_time_ns_()
[22:42:59]3ffffe80:  00000002 00000002 3fff67ec 4020dd04
WARNING Decoded 0x4020dd04: esphome::bme680_bsec::BME680BSECComponent::get_time_ns_()
[22:42:59]3ffffe90:  00000001 3fffbc6e 3fff67ec 4020dd76
WARNING Decoded 0x4020dd76: esphome::bme680_bsec::BME680BSECComponent::run_()
[22:42:59]3ffffea0:  00000000 4021de48 3fffb558 00000002
WARNING Decoded 0x4021de48: esphome::Scheduler::SchedulerItem::cmp(std::unique_ptr<esphome::Scheduler::SchedulerItem, std::default_delete<esphome::Scheduler::SchedulerItem> > const&, std::unique_ptr<esphome::Scheduler::SchedulerItem, std::default_delete<esphome::Scheduler::SchedulerItem> > const&)
[22:42:59]3ffffeb0:  402664d2 00000000 3fff601c 00000001
WARNING Decoded 0x402664d2: wifi_get_opmode
[22:42:59]3ffffec0:  00000000 4bc6a7f0 0000559e 0000559e
[22:42:59]3ffffed0:  00000000 00000000 4bc6a7f0 00000000
[22:42:59]3ffffee0:  00000000 4bc6a7f0 0000559e 0000559e
[22:43:00]3ffffef0:  00000000 00000000 4bc6a7f0 00000000
[22:43:00]3fffff00:  00000000 4bc6a7f0 40100cbe 90a3d70a
WARNING Decoded 0x40100cbe: millis
[22:43:00]3fffff10:  40105fe1 006867ae 3fff4e6c 00000000
WARNING Decoded 0x40105fe1: ets_timer_arm_new
[22:43:00]3fffff20:  3fff3b80 3fff4e6c 00000010 3fff4e6c
[22:43:00]3fffff30:  0000559e 0000559e 40230700 3fffefa0
WARNING Decoded 0x40230700: esp_yield
[22:43:00]3fffff40:  3fff4e6c 0000559e 0000559e 40231696
WARNING Decoded 0x40231696: __delay
[22:43:00]3fffff50:  3fffb5cc 00000010 3fff433c 4021bac0
WARNING Decoded 0x4021bac0: esphome::Application::loop()
[22:43:00]3fffff60:  00000001 000005e3 3fff6600 3fff65f8
[22:43:00]3fffff70:  3fff65ec 3fffb5cc feefeffe feefeffe
[22:43:00]3fffff80:  00000000 00000000 00000001 3fff4d60
[22:43:00]3fffff90:  3fffdad0 00000000 3fff4d20 4021ee3c
WARNING Decoded 0x4021ee3c: loop
[22:43:00]3fffffa0:  3fffdad0 00000000 3fff4d20 40230824
WARNING Decoded 0x40230824: loop_wrapper() at core_esp8266_main.cpp
[22:43:00]<<<stack<<<
[22:43:00]
[22:43:00]--------------- CUT HERE FOR EXCEPTION DECODER ---------------

still think it's an upstream issue in regards to #29.

[gretel]

closing, it's an upstream issue. though, thanks a lot for improving the loop time!