esphome / issues

Issue Tracker for ESPHome
https://esphome.io/
290 stars 36 forks source link

Wifi connection issues. Git bisected. #1005

Closed skarcha closed 4 years ago

skarcha commented 4 years ago

Operating environment/Installation (Hass.io/Docker/pip/etc.):

Ubuntu 18.04, Kubuntu 19.10, several versions of Python, pip, esphome, etc.

ESP (ESP32/ESP8266, Board/Sonoff):

ESP8266. Board D1 Mini.

Affected component:

Wifi

Description of problem:

I have an ESP8266 configured as deep sleep with an BME280 and a ds18b20. All is powered by a 18650 battery and a solar panel.

The system works like a charm with v1.13.6, but it fails with v1.14.3 and 'dev'. It takes several minutes to connect to wifi (if connect), so it continues reading sensors, etc. but doesn't begin deep sleep because it can't connect to wifi. Sometimes it connects, enter deep sleep and when wakes up, the same cycle.

Problem-relevant YAML-configuration entries:

esphome:
  name: azotea
  platform: ESP8266
  board: d1_mini

wifi:
  ssid: !secret wifi_ssid
  password: !secret wifi_password
  fast_connect: true
  manual_ip:
      static_ip: 192.168.20.151
      gateway: 192.168.20.254
      subnet: 255.255.255.0

deep_sleep:
  run_duration: 1s
  sleep_duration: 3min
  id: deep_sleep_1

mqtt:
  broker: 192.168.20.200
  on_message:
    topic: azotea/ota_mode
    payload: 'ON'
    then:
      - deep_sleep.prevent: deep_sleep_1

logger:

ota:

i2c:

dallas:
  - pin: D3

sensor:
  - platform: dallas
    address: 0x85021563DF47FF28
    name: "Temperatura Placas"

  - platform: adc
    pin: VCC
    name: "VCC pila"

  - platform: bme280
    address: 0x76
    temperature:
      name: "Temperatura ambiente"
    pressure:
      name: "Presión"
      state_topic: azotea/sensor/presion/state
    humidity:
      name: "Humedad"

Logs (if applicable):

I provide two logs. The first one with a good connection, a deep sleep, wake up and good conection again.

The second one is a bad/no connect. It shows some retries to connect to wifi and mqtt and never enter deep sleep, so I canceled the log manually.

Good connection using commit: 7a895adec9dcf49c245ea2cfabab461d348ba2d7

SDK:2.2.1(cfd48f3)/Core:2.4.2/lwIP:2.0.3(STABLE-2_0_3_RELEASE/glue:arduino-2.4.1-13-g163bb82)/BearSSL:6d1cefc
[I][logger:116]: Log initialized
[VV][preferences:033]: LOAD 32: valid=YES, 0=0x00000000 1=0x0DEFE4E3 (Type=233825507, CRC=0x0DEFE4E3)
[C][ota:364]: There have been 0 suspected unsuccessful boot attempts.
[VV][preferences:046]: SAVE 32: 0=0x00000001 1=0x42F4583F (Type=233825507, CRC=0x42F4583F)
[I][app:028]: Running through setup()...
[V][app:029]: Sorting components by setup priority...
[C][adc:018]: Setting up ADC 'VCC pila'...
[VV][component:053]: set_interval(name='update', interval=60000, offset=22787)
[C][bme280.sensor:081]: Setting up BME280...
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11010000 (0xD0)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b01100000 (0x60)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10001000 (0x88)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b0100111001101101 (0x4E6D)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10001010 (0x8A)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b0000100001100110 (0x0866)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10001100 (0x8C)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b0011001000000000 (0x3200)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10001110 (0x8E)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1010100110001111 (0xA98F)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10010000 (0x90)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1110111011010101 (0xEED5)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10010010 (0x92)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1101000000001011 (0xD00B)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10010100 (0x94)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b0000011100100000 (0x0720)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10010110 (0x96)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1001000011111111 (0x90FF)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10011000 (0x98)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1111100111111111 (0xF9FF)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10011010 (0x9A)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b0000110000110000 (0x0C30)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10011100 (0x9C)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b0010000011010001 (0x20D1)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10011110 (0x9E)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1000100000010011 (0x8813)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10100001 (0xA1)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b01001011 (0x4B)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11100001 (0xE1)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b0101011100000001 (0x5701)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11100011 (0xE3)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00000000 (0x00)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11100100 (0xE4)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00010110 (0x16)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11100101 (0xE5)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00101101 (0x2D)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11100110 (0xE6)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00000011 (0x03)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11100101 (0xE5)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00101101 (0x2D)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11100111 (0xE7)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00011110 (0x1E)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110010 (0xF2)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00000101 (0x05)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110010 (0xF2)
[VV][i2c:093]:     Writing 0b00000101 (0x05)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110101 (0xF5)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00000000 (0x00)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110101 (0xF5)
[VV][i2c:093]:     Writing 0b00000000 (0x00)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][component:053]: set_interval(name='update', interval=60000, offset=19683)
[C][dallas.sensor:032]: Setting up DallasComponent...
[VV][dallas.sensor:245]: Scratch pad: 10.02.1F.1B.7F.FF.7F.10.8E (8E)
[VV][component:053]: set_interval(name='update', interval=60000, offset=27204)
[C][wifi:029]: Setting up WiFi...
[V][wifi_esp8266:033]: Enabling STA.
mode : sta(5c:cf:xx:xx:xx:xx)
add if0
[V][wifi_esp8266:392]: Event: Changed Mode old=OFF new=STA
wifi evt: 8
sleep disable
[I][wifi:164]: WiFi Connecting to 'SKaRCHa'...
[V][wifi:166]: Connection Params:
[V][wifi:167]:   SSID: 'SKaRCHa'
[V][wifi:172]:   BSSID: Not Set
[V][wifi:174]:   Password: 'xxxxxx'
[V][wifi:178]:   Channel: Not Set
[V][wifi:184]:   Manual IP: Static IP=192.168.20.151 Gateway=192.168.20.254 Subnet=255.255.255.0 DNS1=0.0.0.0 DNS2=0.0.0.0
[V][wifi:188]:   Hidden: NO
[VV][component:128]: Running interval 'update':0 with interval=60000 last_execution=4294884756 (now=1062)
[D][adc:056]: 'VCC pila': Got voltage=3.51V
[V][sensor:013]: 'VCC pila': Received new state 3.512695
[D][sensor:092]: 'VCC pila': Sending state 3.51270 V with 2 decimals of accuracy
[VV][component:128]: Running interval 'update':0 with interval=60000 last_execution=4294888524 (now=1081)
[V][bme280.sensor:171]: Sending conversion request...
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110100 (0xF4)
[VV][i2c:093]:     Writing 0b10110101 (0xB5)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][component:075]: set_timeout(name='data', timeout=113)
[VV][component:128]: Running interval 'update':0 with interval=60000 last_execution=4294881083 (now=1125)
[VV][component:075]: set_timeout(name='0x85021563DF47FF28', timeout=750)
[V][wifi_esp8266:360]: Event: Changed AuthMode old=OPEN new=WPA2 PSK
wifi evt: 2
[VV][component:128]: Running timeout 'data':1 with interval=113 last_execution=1118 (now=1232)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111010 (0xFA)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01110110 (0x76)
[VV][i2c:113]:     Received 0b00000111 (0x07)
[VV][i2c:113]:     Received 0b10100000 (0xA0)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110111 (0xF7)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01001100 (0x4C)
[VV][i2c:113]:     Received 0b01101000 (0x68)
[VV][i2c:113]:     Received 0b10100000 (0xA0)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111101 (0xFD)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1001010011010111 (0x94D7)
[D][bme280.sensor:197]: Got temperature=11.1°C pressure=1003.0hPa humidity=76.0%
[V][sensor:013]: 'Temperatura ambiente': Received new state 11.130000
[D][sensor:092]: 'Temperatura ambiente': Sending state 11.13000 °C with 1 decimals of accuracy
[V][sensor:013]: 'Presión': Received new state 1002.982239
[D][sensor:092]: 'Presión': Sending state 1002.98224 hPa with 1 decimals of accuracy
[V][sensor:013]: 'Humedad': Received new state 75.950195
[D][sensor:092]: 'Humedad': Sending state 75.95020 % with 1 decimals of accuracy
[VV][component:128]: Running timeout '0x85021563DF47FF28':1 with interval=750 last_execution=1138 (now=1889)
[VV][dallas.sensor:245]: Scratch pad: 10.02.1F.1B.7F.FF.7F.10.8E (8E)
[D][dallas.sensor:144]: 'Temperatura Placas': Got Temperature=33.0°C
[V][sensor:013]: 'Temperatura Placas': Received new state 33.000000
[D][sensor:092]: 'Temperatura Placas': Sending state 33.00000 °C with 1 decimals of accuracy
scandone
state: 0 -> 2 (b0)
state: 2 -> 0 (2)
[W][wifi_esp8266:354]: Event: Disconnected ssid='SKaRCHa' bssid=C0:F8:XX:XX:XX:XX reason='Auth Expired'
wifi evt: 1
STA disconnect: 2
[W][wifi:396]: Error while connecting to network.
[W][wifi:427]: Restarting WiFi adapter...
[V][wifi_esp8266:035]: Disabling STA.
del if0
usl
mode : null
[V][wifi_esp8266:392]: Event: Changed Mode old=STA new=OFF
wifi evt: 8
[I][wifi:164]: WiFi Connecting to 'SKaRCHa'...
[V][wifi:166]: Connection Params:
[V][wifi:167]:   SSID: 'SKaRCHa'
[V][wifi:172]:   BSSID: Not Set
[V][wifi:174]:   Password: 'xxxxxx'
[V][wifi:178]:   Channel: Not Set
[V][wifi:184]:   Manual IP: Static IP=192.168.20.151 Gateway=192.168.20.254 Subnet=255.255.255.0 DNS1=0.0.0.0 DNS2=0.0.0.0
[V][wifi:188]:   Hidden: NO
[V][wifi_esp8266:033]: Enabling STA.
mode : sta(5c:cf:xx:xx:xx:xx)
ip:192.168.20.151,mask:255.255.255.0,gw:192.168.20.254
add if0
[V][wifi_esp8266:392]: Event: Changed Mode old=OFF new=STA
wifi evt: 8
scandone
state: 0 -> 2 (b0)
state: 2 -> 3 (0)
state: 3 -> 5 (10)
add 0
aid 5
cnt 

connected with SKaRCHa, channel 8
ip:192.168.20.151,mask:255.255.255.0,gw:192.168.20.254
[V][wifi_esp8266:345]: Event: Connected ssid='SKaRCHa' bssid=C0:F8:XX:XX:XX:XX channel=8
wifi evt: 0
[V][wifi_esp8266:366]: Event: Got IP static_ip=192.168.20.151 gateway=192.168.20.254 netmask=255.255.255.0
wifi evt: 3
[I][wifi:376]: WiFi connected!
[C][wifi:250]:   SSID: 'SKaRCHa'
[C][wifi:251]:   IP Address: 192.168.20.151
[C][wifi:253]:   BSSID: C0:F8:XX:XX:XX:XX
[C][wifi:254]:   Hostname: 'azotea'
[C][wifi:258]:   Signal strength: -83 dB ▂▄▆█
[C][wifi:259]:   Channel: 8
[C][wifi:260]:   Subnet: 255.255.255.0
[C][wifi:261]:   Gateway: 192.168.20.254
[C][wifi:262]:   DNS1: 0.0.0.0
[C][wifi:263]:   DNS2: 0.0.0.0
[C][ota:029]: Over-The-Air Updates:
[C][ota:030]:   Address: 192.168.20.151:8266
[C][mqtt:025]: Setting up MQTT...
[I][mqtt:162]: Connecting to MQTT...
[I][mqtt:202]: MQTT Connected!
[V][mqtt:297]: subscribe(topic='azotea/ota_mode')
[V][mqtt.component:057]: 'VCC pila': Sending discovery...
[V][mqtt:372]: Publish(topic='homeassistant/sensor/azotea/vcc_pila/config' payload='{"unit_of_measurement":"V","icon":"mdi:flash","name":"VCC pila","state_topic":"azotea/sensor/vcc_pila/state","availability_topic":"azotea/status","unique_id":"5ccf7fd3bcb6-adc","device":{"identifiers":"5ccf7fd3bcb6","name":"azotea","sw_version":"esphome vdev Jan 21 2020, 17:50:33","model":"PLATFORMIO_D1_MINI","manufacturer":"espressif"}}' retain=1)
[V][mqtt:372]: Publish(topic='azotea/sensor/vcc_pila/state' payload='3.51' retain=1)
[V][mqtt.component:057]: 'Temperatura Placas': Sending discovery...
[V][mqtt:372]: Publish(topic='homeassistant/sensor/azotea/temperatura_placas/config' payload='{"unit_of_measurement":"°C","icon":"mdi:thermometer","name":"Temperatura Placas","state_topic":"azotea/sensor/temperatura_placas/state","availability_topic":"azotea/status","unique_id":"dallas-85021563DF47FF28","device":{"identifiers":"5ccf7fd3bcb6","name":"azotea","sw_version":"esphome vdev Jan 21 2020, 17:50:33","model":"PLATFORMIO_D1_M
[V][mqtt:372]: Publish(topic='azotea/sensor/temperatura_placas/state' payload='33.0' retain=1)
[V][mqtt.component:057]: 'Temperatura ambiente': Sending discovery...
[V][mqtt:372]: Publish(topic='homeassistant/sensor/azotea/temperatura_ambiente/config' payload='{"unit_of_measurement":"°C","icon":"mdi:thermometer","name":"Temperatura ambiente","state_topic":"azotea/sensor/temperatura_ambiente/state","availability_topic":"azotea/status","unique_id":"ESPsensortemperatura_ambiente","device":{"identifiers":"5ccf7fd3bcb6","name":"azotea","sw_version":"esphome vdev Jan 21 2020, 17:50:33","model":"PLA
[V][mqtt:372]: Publish(topic='azotea/sensor/temperatura_ambiente/state' payload='11.1' retain=1)
[V][mqtt.component:057]: 'Presión': Sending discovery...
[V][mqtt:372]: Publish(topic='homeassistant/sensor/azotea/presin/config' payload='{"unit_of_measurement":"hPa","icon":"mdi:gauge","name":"Presión","state_topic":"azotea/sensor/presion/state","availability_topic":"azotea/status","unique_id":"ESPsensorpresin","device":{"identifiers":"5ccf7fd3bcb6","name":"azotea","sw_version":"esphome vdev Jan 21 2020, 17:50:33","model":"PLATFORMIO_D1_MINI","manufacturer":"espressif"}}' retain=1)
[V][mqtt:372]: Publish(topic='azotea/sensor/presion/state' payload='1003.0' retain=1)
[V][mqtt.component:057]: 'Humedad': Sending discovery...
[V][mqtt:372]: Publish(topic='homeassistant/sensor/azotea/humedad/config' payload='{"unit_of_measurement":"%","icon":"mdi:water-percent","name":"Humedad","state_topic":"azotea/sensor/humedad/state","availability_topic":"azotea/status","unique_id":"ESPsensorhumedad","device":{"identifiers":"5ccf7fd3bcb6","name":"azotea","sw_version":"esphome vdev Jan 21 2020, 17:50:33","model":"PLATFORMIO_D1_MINI","manufacturer":"espressif"}}' retai
[V][mqtt:372]: Publish(topic='azotea/sensor/humedad/state' payload='76.0' retain=1)
[C][deep_sleep:013]: Setting up Deep Sleep...
[VV][component:075]: set_timeout(name='', timeout=1000)
[I][app:060]: setup() finished successfully!
[V][mqtt:372]: Publish(topic='azotea/status' payload='online' retain=1)
[I][app:096]: esphome version dev compiled on Jan 21 2020, 17:50:33
[C][wifi:368]: WiFi:
[C][wifi:250]:   SSID: 'SKaRCHa'
[C][wifi:251]:   IP Address: 192.168.20.151
[C][wifi:253]:   BSSID: C0:F8:XX:XX:XX:XX
[C][wifi:254]:   Hostname: 'azotea'
[C][wifi:258]:   Signal strength: -84 dB ▂▄▆█
[C][wifi:259]:   Channel: 8
[C][wifi:260]:   Subnet: 255.255.255.0
[C][wifi:261]:   Gateway: 192.168.20.254
[C][wifi:262]:   DNS1: 0.0.0.0
[C][wifi:263]:   DNS2: 0.0.0.0
[C][i2c:028]: I2C Bus:
[C][i2c:029]:   SDA Pin: GPIO4
[C][i2c:030]:   SCL Pin: GPIO5
[C][i2c:031]:   Frequency: 50000 Hz
[I][i2c:033]: Scanning i2c bus for active devices...
[I][i2c:040]: Found i2c device at address 0x76
[C][logger:137]: Logger:
[C][logger:138]:   Level: VERY_VERBOSE
[C][logger:139]:   Log Baud Rate: 115200
[C][logger:140]:   Hardware UART: UART0
[C][adc:026]: ADC Sensor 'VCC pila'
[C][adc:026]:   Unit of Measurement: 'V'
[C][adc:026]:   Accuracy Decimals: 2
[C][adc:026]:   Icon: 'mdi:flash'
[V][adc:026]:   Unique ID: '5ccf7fd3bcb6-adc'
[C][adc:029]:   Pin: VCC
[C][adc:051]:   Update Interval: 60.0s
[C][bme280.sensor:142]: BME280:
[C][bme280.sensor:143]:   Address: 0x76
[C][bme280.sensor:155]:   IIR Filter: OFF
[C][bme280.sensor:156]:   Update Interval: 60.0s
[C][bme280.sensor:158]:   Temperature 'Temperatura ambiente'
[C][bme280.sensor:158]:     Unit of Measurement: '°C'
[C][bme280.sensor:158]:     Accuracy Decimals: 1
[C][bme280.sensor:158]:     Icon: 'mdi:thermometer'
[C][bme280.sensor:159]:     Oversampling: 16x
[C][bme280.sensor:160]:   Pressure 'Presión'
[C][bme280.sensor:160]:     Unit of Measurement: 'hPa'
[C][bme280.sensor:160]:     Accuracy Decimals: 1
[C][bme280.sensor:160]:     Icon: 'mdi:gauge'
[C][bme280.sensor:161]:     Oversampling: 16x
[C][bme280.sensor:162]:   Humidity 'Humedad'
[C][bme280.sensor:162]:     Unit of Measurement: '%'
[C][bme280.sensor:162]:     Accuracy Decimals: 1
[C][bme280.sensor:162]:     Icon: 'mdi:water-percent'
[C][bme280.sensor:163]:     Oversampling: 16x
[C][dallas.sensor:070]: DallasComponent:
[C][dallas.sensor:071]:   Pin: GPIO0 (Mode: INPUT)
[C][dallas.sensor:072]:   Update Interval: 60.0s
[D][dallas.sensor:077]:   Found sensors:
[D][dallas.sensor:080]:     0x85021563DF47FF28
[C][dallas.sensor:085]:   Device 'Temperatura Placas'
[C][dallas.sensor:085]:     Unit of Measurement: '°C'
[C][dallas.sensor:085]:     Accuracy Decimals: 1
[C][dallas.sensor:085]:     Icon: 'mdi:thermometer'
[V][dallas.sensor:085]:     Unique ID: 'dallas-85021563DF47FF28'
[C][dallas.sensor:093]:     Address: 0x85021563DF47FF28
[C][dallas.sensor:094]:     Resolution: 12
[C][ota:029]: Over-The-Air Updates:
[C][ota:030]:   Address: 192.168.20.151:8266
[C][mqtt:051]: MQTT:
[C][mqtt:053]:   Server Address: 192.168.20.200:1883 (192.168.20.200)
[C][mqtt:054]:   Username: ''
[C][mqtt:055]:   Client ID: 'azotea-5ccf7fd3bcb6'
[C][mqtt:057]:   Discovery prefix: 'homeassistant'
[C][mqtt:058]:   Discovery retain: YES
[C][mqtt:060]:   Topic Prefix: 'azotea'
[C][mqtt:062]:   Log Topic: 'azotea/debug'
[C][mqtt:065]:   Availability: 'azotea/status'
[C][mqtt:551]: MQTT Message Trigger:
[C][mqtt:552]:   Topic: 'azotea/ota_mode'
[C][mqtt:553]:   QoS: 0
[C][mqtt.sensor:024]: MQTT Sensor 'VCC pila':
[C][mqtt.sensor:028]:   State Topic: 'azotea/sensor/vcc_pila/state'
[C][mqtt.sensor:024]: MQTT Sensor 'Temperatura Placas':
[C][mqtt.sensor:028]:   State Topic: 'azotea/sensor/temperatura_placas/state'
[C][mqtt.sensor:024]: MQTT Sensor 'Temperatura ambiente':
[C][mqtt.sensor:028]:   State Topic: 'azotea/sensor/temperatura_ambiente/state'
[C][mqtt.sensor:024]: MQTT Sensor 'Presión':
[C][mqtt.sensor:028]:   State Topic: 'azotea/sensor/presion/state'
[C][mqtt.sensor:024]: MQTT Sensor 'Humedad':
[C][mqtt.sensor:028]:   State Topic: 'azotea/sensor/humedad/state'
[C][deep_sleep:020]: Setting up Deep Sleep...
[C][deep_sleep:023]:   Sleep Duration: 180000 ms
[C][deep_sleep:026]:   Run Duration: 1000 ms
[VV][component:128]: Running timeout '':0 with interval=1000 last_execution=10462 (now=11466)
[I][deep_sleep:067]: Beginning Deep Sleep
[VV][preferences:046]: SAVE 32: 0=0x00000000 1=0x0DEFE4E3 (Type=233825507, CRC=0x0DEFE4E3)
state: 5 -> 0 (0)
rm 0
del if0
usl
[W][wifi_esp8266:354]: Event: Disconnected ssid='SKaRCHa' bssid=C0:F8:XX:XX:XX:XX reason='Association Leave'
wifi evt: 1
STA disconnect: 8
[W][wifi:089]: WiFi Connection lost... Reconnecting...
[W][wifi:427]: Restarting WiFi adapter...
[V][wifi_esp8266:035]: Disabling STA.
mode : null
[V][wifi_esp8266:392]: Event: Changed Mode old=STA new=OFF
wifi evt: 8
enter deep sleep��;ld��|�l�|�$�c|����;�c�c��g'�dog���c8��lrl;lp�g��l��co�<l��c��gn�d��$`�ogl n{���gc�lsۓn#�d�#cc����l`��g�
SDK:2.2.1(cfd48f3)/Core:2.4.2/lwIP:2.0.3(STABLE-2_0_3_RELEASE/glue:arduino-2.4.1-13-g163bb82)/BearSSL:6d1cefc
[I][logger:116]: Log initialized
[VV][preferences:033]: LOAD 32: valid=YES, 0=0x00000000 1=0x0DEFE4E3 (Type=233825507, CRC=0x0DEFE4E3)
[C][ota:364]: There have been 0 suspected unsuccessful boot attempts.
[VV][preferences:046]: SAVE 32: 0=0x00000001 1=0x42F4583F (Type=233825507, CRC=0x42F4583F)
[I][app:028]: Running through setup()...
[V][app:029]: Sorting components by setup priority...
[C][adc:018]: Setting up ADC 'VCC pila'...
[VV][component:053]: set_interval(name='update', interval=60000, offset=11421)
[C][bme280.sensor:081]: Setting up BME280...
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11010000 (0xD0)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b01100000 (0x60)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10001000 (0x88)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b0100111001101101 (0x4E6D)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10001010 (0x8A)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b0000100001100110 (0x0866)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10001100 (0x8C)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b0011001000000000 (0x3200)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10001110 (0x8E)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1010100110001111 (0xA98F)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10010000 (0x90)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1110111011010101 (0xEED5)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10010010 (0x92)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1101000000001011 (0xD00B)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10010100 (0x94)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b0000011100100000 (0x0720)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10010110 (0x96)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1001000011111111 (0x90FF)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10011000 (0x98)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1111100111111111 (0xF9FF)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10011010 (0x9A)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b0000110000110000 (0x0C30)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10011100 (0x9C)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b0010000011010001 (0x20D1)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10011110 (0x9E)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1000100000010011 (0x8813)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10100001 (0xA1)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b01001011 (0x4B)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11100001 (0xE1)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b0101011100000001 (0x5701)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11100011 (0xE3)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00000000 (0x00)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11100100 (0xE4)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00010110 (0x16)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11100101 (0xE5)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00101101 (0x2D)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11100110 (0xE6)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00000011 (0x03)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11100101 (0xE5)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00101101 (0x2D)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11100111 (0xE7)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00011110 (0x1E)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110010 (0xF2)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00000101 (0x05)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110010 (0xF2)
[VV][i2c:093]:     Writing 0b00000101 (0x05)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110101 (0xF5)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00000000 (0x00)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110101 (0xF5)
[VV][i2c:093]:     Writing 0b00000000 (0x00)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][component:053]: set_interval(name='update', interval=60000, offset=27580)
[C][dallas.sensor:032]: Setting up DallasComponent...
[VV][dallas.sensor:245]: Scratch pad: 10.02.1F.1B.7F.FF.7F.10.8E (8E)
[VV][component:053]: set_interval(name='update', interval=60000, offset=20097)
[C][wifi:029]: Setting up WiFi...
[V][wifi_esp8266:033]: Enabling STA.
mode : sta(5c:cf:xx:xx:xx:xx)
add if0
[V][wifi_esp8266:392]: Event: Changed Mode old=OFF new=STA
wifi evt: 8
sleep disable
[I][wifi:164]: WiFi Connecting to 'SKaRCHa'...
[V][wifi:166]: Connection Params:
[V][wifi:167]:   SSID: 'SKaRCHa'
[V][wifi:172]:   BSSID: Not Set
[V][wifi:174]:   Password: 'xxxxxx'
[V][wifi:178]:   Channel: Not Set
[V][wifi:184]:   Manual IP: Static IP=192.168.20.151 Gateway=192.168.20.254 Subnet=255.255.255.0 DNS1=0.0.0.0 DNS2=0.0.0.0
[V][wifi:188]:   Hidden: NO
[VV][component:128]: Running interval 'update':0 with interval=60000 last_execution=4294896126 (now=1067)
[D][adc:056]: 'VCC pila': Got voltage=3.52V
[V][sensor:013]: 'VCC pila': Received new state 3.515625
[D][sensor:092]: 'VCC pila': Sending state 3.51562 V with 2 decimals of accuracy
[VV][component:128]: Running interval 'update':0 with interval=60000 last_execution=4294880632 (now=1086)
[V][bme280.sensor:171]: Sending conversion request...
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110100 (0xF4)
[VV][i2c:093]:     Writing 0b10110101 (0xB5)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][component:075]: set_timeout(name='data', timeout=113)
[VV][component:128]: Running interval 'update':0 with interval=60000 last_execution=4294888195 (now=1130)
[VV][component:075]: set_timeout(name='0x85021563DF47FF28', timeout=750)
[VV][component:128]: Running timeout 'data':1 with interval=113 last_execution=1123 (now=1237)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111010 (0xFA)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01110101 (0x75)
[VV][i2c:113]:     Received 0b01100111 (0x67)
[VV][i2c:113]:     Received 0b01100000 (0x60)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110111 (0xF7)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01001100 (0x4C)
[VV][i2c:113]:     Received 0b00110111 (0x37)
[VV][i2c:113]:     Received 0b10010000 (0x90)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111101 (0xFD)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1001011110011100 (0x979C)
[D][bme280.sensor:197]: Got temperature=10.3°C pressure=1002.9hPa humidity=79.5%
[V][sensor:013]: 'Temperatura ambiente': Received new state 10.330000
[D][sensor:092]: 'Temperatura ambiente': Sending state 10.33000 °C with 1 decimals of accuracy
[V][sensor:013]: 'Presión': Received new state 1002.934692
[D][sensor:092]: 'Presión': Sending state 1002.93469 hPa with 1 decimals of accuracy
[V][sensor:013]: 'Humedad': Received new state 79.454102
[D][sensor:092]: 'Humedad': Sending state 79.45410 % with 1 decimals of accuracy
[V][wifi_esp8266:360]: Event: Changed AuthMode old=OPEN new=WPA2 PSK
wifi evt: 2
[VV][component:128]: Running timeout '0x85021563DF47FF28':1 with interval=750 last_execution=1143 (now=1894)
[VV][dallas.sensor:245]: Scratch pad: 10.02.1F.1B.7F.FF.7F.10.8E (8E)
[D][dallas.sensor:144]: 'Temperatura Placas': Got Temperature=33.0°C
[V][sensor:013]: 'Temperatura Placas': Received new state 33.000000
[D][sensor:092]: 'Temperatura Placas': Sending state 33.00000 °C with 1 decimals of accuracy
scandone
state: 0 -> 2 (b0)
state: 2 -> 3 (0)
state: 3 -> 5 (10)
add 0
aid 5
cnt 

connected with SKaRCHa, channel 8
ip:192.168.20.151,mask:255.255.255.0,gw:192.168.20.254
ip:192.168.20.151,mask:255.255.255.0,gw:192.168.20.254
[V][wifi_esp8266:345]: Event: Connected ssid='SKaRCHa' bssid=C0:F8:XX:XX:XX:XX channel=8
wifi evt: 0
[V][wifi_esp8266:366]: Event: Got IP static_ip=192.168.20.151 gateway=192.168.20.254 netmask=255.255.255.0
wifi evt: 3
[I][wifi:376]: WiFi connected!
[C][wifi:250]:   SSID: 'SKaRCHa'
[C][wifi:251]:   IP Address: 192.168.20.151
[C][wifi:253]:   BSSID: C0:F8:XX:XX:XX:XX
[C][wifi:254]:   Hostname: 'azotea'
[C][wifi:258]:   Signal strength: -86 dB ▂▄▆█
[C][wifi:259]:   Channel: 8
[C][wifi:260]:   Subnet: 255.255.255.0
[C][wifi:261]:   Gateway: 192.168.20.254
[C][wifi:262]:   DNS1: 0.0.0.0
[C][wifi:263]:   DNS2: 0.0.0.0
[C][ota:029]: Over-The-Air Updates:
[C][ota:030]:   Address: 192.168.20.151:8266
[C][mqtt:025]: Setting up MQTT...
[I][mqtt:162]: Connecting to MQTT...
[I][mqtt:202]: MQTT Connected!
[V][mqtt:297]: subscribe(topic='azotea/ota_mode')
[V][mqtt.component:057]: 'VCC pila': Sending discovery...
[V][mqtt:372]: Publish(topic='homeassistant/sensor/azotea/vcc_pila/config' payload='{"unit_of_measurement":"V","icon":"mdi:flash","name":"VCC pila","state_topic":"azotea/sensor/vcc_pila/state","availability_topic":"azotea/status","unique_id":"5ccf7fd3bcb6-adc","device":{"identifiers":"5ccf7fd3bcb6","name":"azotea","sw_version":"esphome vdev Jan 21 2020, 17:50:33","model":"PLATFORMIO_D1_MINI","manufacturer":"espressif"}}' retain=1)
[V][mqtt:372]: Publish(topic='azotea/sensor/vcc_pila/state' payload='3.52' retain=1)
[V][mqtt.component:057]: 'Temperatura Placas': Sending discovery...
[V][mqtt:372]: Publish(topic='homeassistant/sensor/azotea/temperatura_placas/config' payload='{"unit_of_measurement":"°C","icon":"mdi:thermometer","name":"Temperatura Placas","state_topic":"azotea/sensor/temperatura_placas/state","availability_topic":"azotea/status","unique_id":"dallas-85021563DF47FF28","device":{"identifiers":"5ccf7fd3bcb6","name":"azotea","sw_version":"esphome vdev Jan 21 2020, 17:50:33","model":"PLATFORMIO_D1_M
[V][mqtt:372]: Publish(topic='azotea/sensor/temperatura_placas/state' payload='33.0' retain=1)
[V][mqtt.component:057]: 'Temperatura ambiente': Sending discovery...
[V][mqtt:372]: Publish(topic='homeassistant/sensor/azotea/temperatura_ambiente/config' payload='{"unit_of_measurement":"°C","icon":"mdi:thermometer","name":"Temperatura ambiente","state_topic":"azotea/sensor/temperatura_ambiente/state","availability_topic":"azotea/status","unique_id":"ESPsensortemperatura_ambiente","device":{"identifiers":"5ccf7fd3bcb6","name":"azotea","sw_version":"esphome vdev Jan 21 2020, 17:50:33","model":"PLA
[V][mqtt:372]: Publish(topic='azotea/sensor/temperatura_ambiente/state' payload='10.3' retain=1)
[V][mqtt.component:057]: 'Presión': Sending discovery...
[V][mqtt:372]: Publish(topic='homeassistant/sensor/azotea/presin/config' payload='{"unit_of_measurement":"hPa","icon":"mdi:gauge","name":"Presión","state_topic":"azotea/sensor/presion/state","availability_topic":"azotea/status","unique_id":"ESPsensorpresin","device":{"identifiers":"5ccf7fd3bcb6","name":"azotea","sw_version":"esphome vdev Jan 21 2020, 17:50:33","model":"PLATFORMIO_D1_MINI","manufacturer":"espressif"}}' retain=1)
[V][mqtt:372]: Publish(topic='azotea/sensor/presion/state' payload='1002.9' retain=1)
[V][mqtt.component:057]: 'Humedad': Sending discovery...
[V][mqtt:375]: Publish failed for topic='homeassistant/sensor/azotea/humedad/config' (len=345). will retry later..
[VV][component:075]: set_timeout(name='publish', timeout=1000)
[V][mqtt:372]: Publish(topic='azotea/sensor/humedad/state' payload='79.5' retain=1)
[C][deep_sleep:013]: Setting up Deep Sleep...
[VV][component:075]: set_timeout(name='', timeout=1000)
[I][app:060]: setup() finished successfully!
[VV][component:128]: Running defer '':1 with interval=0 last_execution=0 (now=7852)
[V][mqtt:372]: Publish(topic='azotea/status' payload='online' retain=1)
[V][mqtt.component:057]: 'Humedad': Sending discovery...
[V][mqtt:372]: Publish(topic='homeassistant/sensor/azotea/humedad/config' payload='{"unit_of_measurement":"%","icon":"mdi:water-percent","name":"Humedad","state_topic":"azotea/sensor/humedad/state","availability_topic":"azotea/status","unique_id":"ESPsensorhumedad","device":{"identifiers":"5ccf7fd3bcb6","name":"azotea","sw_version":"esphome vdev Jan 21 2020, 17:50:33","model":"PLATFORMIO_D1_MINI","manufacturer":"espressif"}}' retai
[V][mqtt:372]: Publish(topic='azotea/sensor/humedad/state' payload='79.5' retain=1)
[I][app:096]: esphome version dev compiled on Jan 21 2020, 17:50:33
[C][wifi:368]: WiFi:
[C][wifi:250]:   SSID: 'SKaRCHa'
[C][wifi:251]:   IP Address: 192.168.20.151
[C][wifi:253]:   BSSID: C0:F8:XX:XX:XX:XX
[C][wifi:254]:   Hostname: 'azotea'
[C][wifi:258]:   Signal strength: -85 dB ▂▄▆█
[C][wifi:259]:   Channel: 8
[C][wifi:260]:   Subnet: 255.255.255.0
[C][wifi:261]:   Gateway: 192.168.20.254
[C][wifi:262]:   DNS1: 0.0.0.0
[C][wifi:263]:   DNS2: 0.0.0.0
[C][i2c:028]: I2C Bus:
[C][i2c:029]:   SDA Pin: GPIO4
[C][i2c:030]:   SCL Pin: GPIO5
[C][i2c:031]:   Frequency: 50000 Hz
[I][i2c:033]: Scanning i2c bus for active devices...
[I][i2c:040]: Found i2c device at address 0x76
[C][logger:137]: Logger:
[C][logger:138]:   Level: VERY_VERBOSE
[C][logger:139]:   Log Baud Rate: 115200
[C][logger:140]:   Hardware UART: UART0
[C][adc:026]: ADC Sensor 'VCC pila'
[C][adc:026]:   Unit of Measurement: 'V'
[C][adc:026]:   Accuracy Decimals: 2
[C][adc:026]:   Icon: 'mdi:flash'
[V][adc:026]:   Unique ID: '5ccf7fd3bcb6-adc'
[C][adc:029]:   Pin: VCC
[C][adc:051]:   Update Interval: 60.0s
[C][bme280.sensor:142]: BME280:
[C][bme280.sensor:143]:   Address: 0x76
[C][bme280.sensor:155]:   IIR Filter: OFF
[C][bme280.sensor:156]:   Update Interval: 60.0s
[C][bme280.sensor:158]:   Temperature 'Temperatura ambiente'
[C][bme280.sensor:158]:     Unit of Measurement: '°C'
[C][bme280.sensor:158]:     Accuracy Decimals: 1
[C][bme280.sensor:158]:     Icon: 'mdi:thermometer'
[C][bme280.sensor:159]:     Oversampling: 16x
[C][bme280.sensor:160]:   Pressure 'Presión'
[C][bme280.sensor:160]:     Unit of Measurement: 'hPa'
[C][bme280.sensor:160]:     Accuracy Decimals: 1
[C][bme280.sensor:160]:     Icon: 'mdi:gauge'
[C][bme280.sensor:161]:     Oversampling: 16x
[C][bme280.sensor:162]:   Humidity 'Humedad'
[C][bme280.sensor:162]:     Unit of Measurement: '%'
[C][bme280.sensor:162]:     Accuracy Decimals: 1
[C][bme280.sensor:162]:     Icon: 'mdi:water-percent'
[C][bme280.sensor:163]:     Oversampling: 16x
[C][dallas.sensor:070]: DallasComponent:
[C][dallas.sensor:071]:   Pin: GPIO0 (Mode: INPUT)
[C][dallas.sensor:072]:   Update Interval: 60.0s
[D][dallas.sensor:077]:   Found sensors:
[D][dallas.sensor:080]:     0x85021563DF47FF28
[C][dallas.sensor:085]:   Device 'Temperatura Placas'
[C][dallas.sensor:085]:     Unit of Measurement: '°C'
[C][dallas.sensor:085]:     Accuracy Decimals: 1
[C][dallas.sensor:085]:     Icon: 'mdi:thermometer'
[V][dallas.sensor:085]:     Unique ID: 'dallas-85021563DF47FF28'
[C][dallas.sensor:093]:     Address: 0x85021563DF47FF28
[C][dallas.sensor:094]:     Resolution: 12
[C][ota:029]: Over-The-Air Updates:
[C][ota:030]:   Address: 192.168.20.151:8266
[C][mqtt:051]: MQTT:
[C][mqtt:053]:   Server Address: 192.168.20.200:1883 (192.168.20.200)
[C][mqtt:054]:   Username: ''
[C][mqtt:055]:   Client ID: 'azotea-5ccf7fd3bcb6'
[C][mqtt:057]:   Discovery prefix: 'homeassistant'
[C][mqtt:058]:   Discovery retain: YES
[C][mqtt:060]:   Topic Prefix: 'azotea'
[C][mqtt:062]:   Log Topic: 'azotea/debug'
[C][mqtt:065]:   Availability: 'azotea/status'
[C][mqtt:551]: MQTT Message Trigger:
[C][mqtt:552]:   Topic: 'azotea/ota_mode'
[C][mqtt:553]:   QoS: 0
[C][mqtt.sensor:024]: MQTT Sensor 'VCC pila':
[C][mqtt.sensor:028]:   State Topic: 'azotea/sensor/vcc_pila/state'
[C][mqtt.sensor:024]: MQTT Sensor 'Temperatura Placas':
[C][mqtt.sensor:028]:   State Topic: 'azotea/sensor/temperatura_placas/state'
[C][mqtt.sensor:024]: MQTT Sensor 'Temperatura ambiente':
[C][mqtt.sensor:028]:   State Topic: 'azotea/sensor/temperatura_ambiente/state'
[C][mqtt.sensor:024]: MQTT Sensor 'Presión':
[C][mqtt.sensor:028]:   State Topic: 'azotea/sensor/presion/state'
[C][mqtt.sensor:024]: MQTT Sensor 'Humedad':
[C][mqtt.sensor:028]:   State Topic: 'azotea/sensor/humedad/state'
[C][deep_sleep:020]: Setting up Deep Sleep...
[C][deep_sleep:023]:   Sleep Duration: 180000 ms
[C][deep_sleep:026]:   Run Duration: 1000 ms
[VV][component:128]: Running timeout 'publish':0 with interval=1000 last_execution=7814 (now=8825)
[VV][component:128]: Running timeout '':0 with interval=1000 last_execution=7833 (now=8842)
[I][deep_sleep:067]: Beginning Deep Sleep
[VV][preferences:046]: SAVE 32: 0=0x00000000 1=0x0DEFE4E3 (Type=233825507, CRC=0x0DEFE4E3)
state: 5 -> 0 (0)
rm 0
del if0
usl
[W][wifi_esp8266:354]: Event: Disconnected ssid='SKaRCHa' bssid=C0:F8:XX:XX:XX:XX reason='Association Leave'
wifi evt: 1
STA disconnect: 8
[W][wifi:089]: WiFi Connection lost... Reconnecting...
[W][wifi:427]: Restarting WiFi adapter...
[V][wifi_esp8266:035]: Disabling STA.
mode : null
[V][wifi_esp8266:392]: Event: Changed Mode old=STA new=OFF
wifi evt: 8
enter deep sleep

Bad connection using commit: a55787f40caf11e8c7ed83aff76dd1205c5a50f6

SDK:2.2.1(cfd48f3)/Core:2.5.2=20502000/lwIP:STABLE-2_1_2_RELEASE/glue:1.1-7-g82abda3/BearSSL:a143020
[I][logger:156]: Log initialized
[VV][preferences:038]: LOAD 32: valid=YES, 0=0x00000000 1=0x0DEFE4E3 (Type=233825507, CRC=0x0DEFE4E3)
[C][ota:364]: There have been 0 suspected unsuccessful boot attempts.
[VV][preferences:051]: SAVE 32: 0=0x00000001 1=0x42F4583F (Type=233825507, CRC=0x42F4583F)
[I][app:028]: Running through setup()...
[V][app:029]: Sorting components by setup priority...
[C][adc:018]: Setting up ADC 'VCC pila'...
[VV][scheduler:056]: set_interval(name='update', interval=60000, offset=24362)
[C][bme280.sensor:081]: Setting up BME280...
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11010000 (0xD0)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b01100000 (0x60)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10001000 (0x88)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b0100111001101101 (0x4E6D)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10001010 (0x8A)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b0000100001100110 (0x0866)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10001100 (0x8C)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b0011001000000000 (0x3200)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10001110 (0x8E)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1010100110001111 (0xA98F)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10010000 (0x90)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1110111011010101 (0xEED5)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10010010 (0x92)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1101000000001011 (0xD00B)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10010100 (0x94)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b0000011100100000 (0x0720)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10010110 (0x96)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1001000011111111 (0x90FF)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10011000 (0x98)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1111100111111111 (0xF9FF)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10011010 (0x9A)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b0000110000110000 (0x0C30)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10011100 (0x9C)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b0010000011010001 (0x20D1)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10011110 (0x9E)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1000100000010011 (0x8813)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b10100001 (0xA1)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b01001011 (0x4B)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11100001 (0xE1)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b0101011100000001 (0x5701)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11100011 (0xE3)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00000000 (0x00)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11100100 (0xE4)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00010110 (0x16)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11100101 (0xE5)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00101101 (0x2D)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11100110 (0xE6)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00000011 (0x03)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11100101 (0xE5)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00101101 (0x2D)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11100111 (0xE7)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00011110 (0x1E)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110010 (0xF2)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00000101 (0x05)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110010 (0xF2)
[VV][i2c:093]:     Writing 0b00000101 (0x05)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110101 (0xF5)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 1 bytes from 0x76:
[VV][i2c:113]:     Received 0b00000000 (0x00)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110101 (0xF5)
[VV][i2c:093]:     Writing 0b00000000 (0x00)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][scheduler:056]: set_interval(name='update', interval=60000, offset=4788)
[C][dallas.sensor:032]: Setting up DallasComponent...
[VV][dallas.sensor:257]: Scratch pad: 10.02.1F.1B.7F.FF.7F.10.8E (8E)
[VV][scheduler:056]: set_interval(name='update', interval=60000, offset=16323)
[C][wifi:033]: Setting up WiFi...
[V][wifi_esp8266:041]: Enabling STA.
mode : sta(5c:cf:xx:xx:xx:xx)
add if0
[V][wifi_esp8266:433]: Event: Changed Mode old=OFF new=STA
wifi evt: 8
sleep disable
[I][wifi:193]: WiFi Connecting to 'SKaRCHa'...
[V][wifi:195]: Connection Params:
[V][wifi:196]:   SSID: 'SKaRCHa'
[V][wifi:201]:   BSSID: Not Set
[V][wifi:203]:   Password: 'xxxxxx'
[V][wifi:207]:   Channel: Not Set
[V][wifi:213]:   Manual IP: Static IP=192.168.20.151 Gateway=192.168.20.254 Subnet=255.255.255.0 DNS1=(IP unset) DNS2=(IP unset)
[V][wifi:217]:   Hidden: NO
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=4294883045 (now=919)
[D][adc:056]: 'VCC pila': Got voltage=3.52V
[V][sensor:013]: 'VCC pila': Received new state 3.519531
[D][sensor:092]: 'VCC pila': Sending state 3.51953 V with 2 decimals of accuracy
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=4294891829 (now=919)
[VV][scheduler:025]: set_timeout(name='0x85021563DF47FF28', timeout=750)
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=4294903284 (now=919)
[V][bme280.sensor:171]: Sending conversion request...
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110100 (0xF4)
[VV][i2c:093]:     Writing 0b10110101 (0xB5)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][scheduler:025]: set_timeout(name='data', timeout=114)
[V][wifi_esp8266:401]: Event: Changed AuthMode old=OPEN new=WPA2 PSK
wifi evt: 2
[VV][scheduler:131]: Running timeout 'data' with interval=114 last_execution=999 (now=1113)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111010 (0xFA)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01110101 (0x75)
[VV][i2c:113]:     Received 0b00111100 (0x3C)
[VV][i2c:113]:     Received 0b10010000 (0x90)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110111 (0xF7)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01001100 (0x4C)
[VV][i2c:113]:     Received 0b00110110 (0x36)
[VV][i2c:113]:     Received 0b01000000 (0x40)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111101 (0xFD)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1001110011010101 (0x9CD5)
[D][bme280.sensor:197]: Got temperature=10.1°C pressure=1002.6hPa humidity=86.2%
[V][sensor:013]: 'Temperatura ambiente': Received new state 10.120000
[D][sensor:092]: 'Temperatura ambiente': Sending state 10.12000 °C with 1 decimals of accuracy
[V][sensor:013]: 'Presión': Received new state 1002.609680
[D][sensor:092]: 'Presión': Sending state 1002.60968 hPa with 1 decimals of accuracy
[V][sensor:013]: 'Humedad': Received new state 86.195312
[D][sensor:092]: 'Humedad': Sending state 86.19531 % with 1 decimals of accuracy
[VV][scheduler:131]: Running timeout '0x85021563DF47FF28' with interval=750 last_execution=958 (now=1708)
[VV][dallas.sensor:257]: Scratch pad: 10.02.1F.1B.7F.FF.7F.10.8E (8E)
[D][dallas.sensor:153]: 'Temperatura Placas': Got Temperature=33.0°C
[V][sensor:013]: 'Temperatura Placas': Received new state 33.000000
[D][sensor:092]: 'Temperatura Placas': Sending state 33.00000 °C with 1 decimals of accuracy
scandone
state: 0 -> 2 (b0)
state: 2 -> 3 (0)
state: 3 -> 5 (10)
add 0
aid 1
cnt 

connected with SKaRCHa, channel 5
ip:192.168.20.151,mask:255.255.255.0,gw:192.168.20.254
ip:192.168.20.151,mask:255.255.255.0,gw:192.168.20.254
[V][wifi_esp8266:382]: Event: Connected ssid='SKaRCHa' bssid=C4:6E:XX:XX:XX:XX channel=5
wifi evt: 0
[V][wifi_esp8266:407]: Event: Got IP static_ip=192.168.20.151 gateway=192.168.20.254 netmask=255.255.255.0
wifi evt: 3
[I][wifi:423]: WiFi Connected!
[C][wifi:283]:   SSID: 'SKaRCHa'
[C][wifi:284]:   IP Address: 192.168.20.151
[C][wifi:286]:   BSSID: C4:6E:XX:XX:XX:XX
[C][wifi:287]:   Hostname: 'azotea'
[C][wifi:291]:   Signal strength: -93 dB ▂▄▆█
[C][wifi:295]:   Channel: 5
[C][wifi:296]:   Subnet: 255.255.255.0
[C][wifi:297]:   Gateway: 192.168.20.254
[C][wifi:298]:   DNS1: (IP unset)
[C][wifi:299]:   DNS2: (IP unset)
[C][ota:029]: Over-The-Air Updates:
[C][ota:030]:   Address: 192.168.20.151:8266
[C][mqtt:025]: Setting up MQTT...
[I][mqtt:162]: Connecting to MQTT...
bcn_timout,ap_probe_send_start
ap_probe_send over, rest wifi status to disassoc
state: 5 -> 0 (1)
rm 0
[W][wifi_esp8266:394]: Event: Disconnected ssid='SKaRCHa' bssid=C4:6E:XX:XX:XX:XX reason='Beacon Timeout'
wifi evt: 1
STA disconnect: 200
[W][wifi:100]: WiFi Connection lost... Reconnecting...
[W][wifi:488]: Restarting WiFi adapter...
[V][wifi_esp8266:043]: Disabling STA.
del if0
usl
mode : null
[V][wifi_esp8266:433]: Event: Changed Mode old=STA new=OFF
wifi evt: 8
[I][wifi:193]: WiFi Connecting to 'SKaRCHa'...
[V][wifi:195]: Connection Params:
[V][wifi:196]:   SSID: 'SKaRCHa'
[V][wifi:201]:   BSSID: Not Set
[V][wifi:203]:   Password: 'xxxxxx'
[V][wifi:207]:   Channel: Not Set
[V][wifi:213]:   Manual IP: Static IP=192.168.20.151 Gateway=192.168.20.254 Subnet=255.255.255.0 DNS1=(IP unset) DNS2=(IP unset)
[V][wifi:217]:   Hidden: NO
[V][wifi_esp8266:041]: Enabling STA.
mode : sta(5c:cf:xx:xx:xx:xx)
ip:192.168.20.151,mask:255.255.255.0,gw:192.168.20.254
add if0
[V][wifi_esp8266:433]: Event: Changed Mode old=OFF new=STA
wifi evt: 8
scandone
state: 0 -> 2 (b0)
state: 2 -> 3 (0)
state: 3 -> 5 (10)
add 0
aid 5
cnt 

connected with SKaRCHa, channel 8
ip:192.168.20.151,mask:255.255.255.0,gw:192.168.20.254
[V][wifi_esp8266:382]: Event: Connected ssid='SKaRCHa' bssid=C0:F8:XX:XX:XX:XX channel=8
wifi evt: 0
[V][wifi_esp8266:407]: Event: Got IP static_ip=192.168.20.151 gateway=192.168.20.254 netmask=255.255.255.0
wifi evt: 3
[I][wifi:423]: WiFi Connected!
[C][wifi:283]:   SSID: 'SKaRCHa'
[C][wifi:284]:   IP Address: 192.168.20.151
[C][wifi:286]:   BSSID: C0:F8:XX:XX:XX:XX
[C][wifi:287]:   Hostname: 'azotea'
[C][wifi:291]:   Signal strength: -85 dB ▂▄▆█
[C][wifi:295]:   Channel: 8
[C][wifi:296]:   Subnet: 255.255.255.0
[C][wifi:297]:   Gateway: 192.168.20.254
[C][wifi:298]:   DNS1: (IP unset)
[C][wifi:299]:   DNS2: (IP unset)
pm open,type:0 0
[W][mqtt:247]: MQTT Disconnected: TCP disconnected.
[I][mqtt:162]: Connecting to MQTT...
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=4294943045 (now=35749)
[D][adc:056]: 'VCC pila': Got voltage=3.52V
[V][sensor:013]: 'VCC pila': Received new state 3.521484
[D][sensor:092]: 'VCC pila': Sending state 3.52148 V with 2 decimals of accuracy
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=4294951829 (now=44533)
[VV][scheduler:025]: set_timeout(name='0x85021563DF47FF28', timeout=750)
[VV][scheduler:131]: Running timeout '0x85021563DF47FF28' with interval=750 last_execution=44536 (now=45286)
[VV][dallas.sensor:257]: Scratch pad: 10.02.1F.1B.7F.FF.7F.10.8E (8E)
[D][dallas.sensor:153]: 'Temperatura Placas': Got Temperature=33.0°C
[V][sensor:013]: 'Temperatura Placas': Received new state 33.000000
[D][sensor:092]: 'Temperatura Placas': Sending state 33.00000 °C with 1 decimals of accuracy
bcn_timout,ap_probe_send_start
ap_probe_send over, rest wifi status to disassoc
state: 5 -> 0 (1)
rm 0
pm close 7
[W][wifi_esp8266:394]: Event: Disconnected ssid='SKaRCHa' bssid=C0:F8:XX:XX:XX:XX reason='Beacon Timeout'
wifi evt: 1
STA disconnect: 200
[W][wifi:100]: WiFi Connection lost... Reconnecting...
[W][wifi:488]: Restarting WiFi adapter...
[V][wifi_esp8266:043]: Disabling STA.
del if0
usl
mode : null
[V][wifi_esp8266:433]: Event: Changed Mode old=STA new=OFF
wifi evt: 8
[I][wifi:193]: WiFi Connecting to 'SKaRCHa'...
[V][wifi:195]: Connection Params:
[V][wifi:196]:   SSID: 'SKaRCHa'
[V][wifi:201]:   BSSID: Not Set
[V][wifi:203]:   Password: 'xxxxxx'
[V][wifi:207]:   Channel: Not Set
[V][wifi:213]:   Manual IP: Static IP=192.168.20.151 Gateway=192.168.20.254 Subnet=255.255.255.0 DNS1=(IP unset) DNS2=(IP unset)
[V][wifi:217]:   Hidden: NO
[V][wifi_esp8266:041]: Enabling STA.
mode : sta(5c:cf:xx:xx:xx:xx)
ip:192.168.20.151,mask:255.255.255.0,gw:192.168.20.254
add if0
[V][wifi_esp8266:433]: Event: Changed Mode old=OFF new=STA
wifi evt: 8
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=4294963284 (now=55988)
[V][bme280.sensor:171]: Sending conversion request...
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110100 (0xF4)
[VV][i2c:093]:     Writing 0b10110101 (0xB5)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][scheduler:025]: set_timeout(name='data', timeout=114)
[VV][scheduler:131]: Running timeout 'data' with interval=114 last_execution=56015 (now=56129)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111010 (0xFA)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01110101 (0x75)
[VV][i2c:113]:     Received 0b01110100 (0x74)
[VV][i2c:113]:     Received 0b01110000 (0x70)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110111 (0xF7)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01001100 (0x4C)
[VV][i2c:113]:     Received 0b01001000 (0x48)
[VV][i2c:113]:     Received 0b10010000 (0x90)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111101 (0xFD)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1001011111001010 (0x97CA)
[D][bme280.sensor:197]: Got temperature=10.4°C pressure=1002.6hPa humidity=79.7%
[V][sensor:013]: 'Temperatura ambiente': Received new state 10.390000
[D][sensor:092]: 'Temperatura ambiente': Sending state 10.39000 °C with 1 decimals of accuracy
[V][sensor:013]: 'Presión': Received new state 1002.590637
[D][sensor:092]: 'Presión': Sending state 1002.59064 hPa with 1 decimals of accuracy
[V][sensor:013]: 'Humedad': Received new state 79.698242
[D][sensor:092]: 'Humedad': Sending state 79.69824 % with 1 decimals of accuracy
scandone
state: 0 -> 2 (b0)
state: 2 -> 3 (0)
state: 3 -> 5 (10)
add 0
aid 5
cnt 

connected with SKaRCHa, channel 8
ip:192.168.20.151,mask:255.255.255.0,gw:192.168.20.254
[V][wifi_esp8266:382]: Event: Connected ssid='SKaRCHa' bssid=C0:F8:XX:XX:XX:XX channel=8
wifi evt: 0
[V][wifi_esp8266:407]: Event: Got IP static_ip=192.168.20.151 gateway=192.168.20.254 netmask=255.255.255.0
wifi evt: 3
[I][wifi:423]: WiFi Connected!
[C][wifi:283]:   SSID: 'SKaRCHa'
[C][wifi:284]:   IP Address: 192.168.20.151
[C][wifi:286]:   BSSID: C0:F8:XX:XX:XX:XX
[C][wifi:287]:   Hostname: 'azotea'
[C][wifi:291]:   Signal strength: -81 dB ▂▄▆█
[C][wifi:295]:   Channel: 8
[C][wifi:296]:   Subnet: 255.255.255.0
[C][wifi:297]:   Gateway: 192.168.20.254
[C][wifi:298]:   DNS1: (IP unset)
[C][wifi:299]:   DNS2: (IP unset)
pm open,type:0 0
[I][mqtt:162]: Connecting to MQTT...
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=35749 (now=95749)
[D][adc:056]: 'VCC pila': Got voltage=3.52V
[V][sensor:013]: 'VCC pila': Received new state 3.519531
[D][sensor:092]: 'VCC pila': Sending state 3.51953 V with 2 decimals of accuracy
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=44533 (now=104533)
[VV][scheduler:025]: set_timeout(name='0x85021563DF47FF28', timeout=750)
[VV][scheduler:131]: Running timeout '0x85021563DF47FF28' with interval=750 last_execution=104536 (now=105286)
[VV][dallas.sensor:257]: Scratch pad: 10.02.1F.1B.7F.FF.7F.10.8E (8E)
[D][dallas.sensor:153]: 'Temperatura Placas': Got Temperature=33.0°C
[V][sensor:013]: 'Temperatura Placas': Received new state 33.000000
[D][sensor:092]: 'Temperatura Placas': Sending state 33.00000 °C with 1 decimals of accuracy
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=55988 (now=115988)
[V][bme280.sensor:171]: Sending conversion request...
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110100 (0xF4)
[VV][i2c:093]:     Writing 0b10110101 (0xB5)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][scheduler:025]: set_timeout(name='data', timeout=114)
[VV][scheduler:131]: Running timeout 'data' with interval=114 last_execution=116014 (now=116128)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111010 (0xFA)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01110101 (0x75)
[VV][i2c:113]:     Received 0b01101101 (0x6D)
[VV][i2c:113]:     Received 0b00000000 (0x00)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110111 (0xF7)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01001100 (0x4C)
[VV][i2c:113]:     Received 0b01000011 (0x43)
[VV][i2c:113]:     Received 0b10000000 (0x80)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111101 (0xFD)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1001011101011000 (0x9758)
[D][bme280.sensor:197]: Got temperature=10.4°C pressure=1002.7hPa humidity=79.1%
[V][sensor:013]: 'Temperatura ambiente': Received new state 10.360000
[D][sensor:092]: 'Temperatura ambiente': Sending state 10.36000 °C with 1 decimals of accuracy
[V][sensor:013]: 'Presión': Received new state 1002.666504
[D][sensor:092]: 'Presión': Sending state 1002.66650 hPa with 1 decimals of accuracy
[V][sensor:013]: 'Humedad': Received new state 79.116211
[D][sensor:092]: 'Humedad': Sending state 79.11621 % with 1 decimals of accuracy
[I][ota:046]: Boot seems successful, resetting boot loop counter.
[VV][preferences:051]: SAVE 32: 0=0x00000000 1=0x0DEFE4E3 (Type=233825507, CRC=0x0DEFE4E3)
bcn_timout,ap_probe_send_start
[I][mqtt:162]: Connecting to MQTT...
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=95749 (now=155749)
[D][adc:056]: 'VCC pila': Got voltage=3.52V
[V][sensor:013]: 'VCC pila': Received new state 3.515625
[D][sensor:092]: 'VCC pila': Sending state 3.51562 V with 2 decimals of accuracy
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=104533 (now=164533)
[VV][scheduler:025]: set_timeout(name='0x85021563DF47FF28', timeout=750)
[VV][scheduler:131]: Running timeout '0x85021563DF47FF28' with interval=750 last_execution=164536 (now=165286)
[VV][dallas.sensor:257]: Scratch pad: 10.02.1F.1B.7F.FF.7F.10.8E (8E)
[D][dallas.sensor:153]: 'Temperatura Placas': Got Temperature=33.0°C
[V][sensor:013]: 'Temperatura Placas': Received new state 33.000000
[D][sensor:092]: 'Temperatura Placas': Sending state 33.00000 °C with 1 decimals of accuracy
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=115988 (now=175988)
[V][bme280.sensor:171]: Sending conversion request...
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110100 (0xF4)
[VV][i2c:093]:     Writing 0b10110101 (0xB5)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][scheduler:025]: set_timeout(name='data', timeout=114)
[VV][scheduler:131]: Running timeout 'data' with interval=114 last_execution=176015 (now=176129)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111010 (0xFA)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01110101 (0x75)
[VV][i2c:113]:     Received 0b01011011 (0x5B)
[VV][i2c:113]:     Received 0b10100000 (0xA0)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110111 (0xF7)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01001100 (0x4C)
[VV][i2c:113]:     Received 0b00111100 (0x3C)
[VV][i2c:113]:     Received 0b00110000 (0x30)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111101 (0xFD)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1001011101010100 (0x9754)
[D][bme280.sensor:197]: Got temperature=10.3°C pressure=1002.7hPa humidity=79.1%
[V][sensor:013]: 'Temperatura ambiente': Received new state 10.270000
[D][sensor:092]: 'Temperatura ambiente': Sending state 10.27000 °C with 1 decimals of accuracy
[V][sensor:013]: 'Presión': Received new state 1002.713745
[D][sensor:092]: 'Presión': Sending state 1002.71375 hPa with 1 decimals of accuracy
[V][sensor:013]: 'Humedad': Received new state 79.089844
[D][sensor:092]: 'Humedad': Sending state 79.08984 % with 1 decimals of accuracy
[I][mqtt:162]: Connecting to MQTT...
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=155749 (now=215749)
[D][adc:056]: 'VCC pila': Got voltage=3.52V
[V][sensor:013]: 'VCC pila': Received new state 3.516602
[D][sensor:092]: 'VCC pila': Sending state 3.51660 V with 2 decimals of accuracy
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=164533 (now=224533)
[VV][scheduler:025]: set_timeout(name='0x85021563DF47FF28', timeout=750)
[VV][scheduler:131]: Running timeout '0x85021563DF47FF28' with interval=750 last_execution=224536 (now=225286)
[VV][dallas.sensor:257]: Scratch pad: 10.02.1F.1B.7F.FF.7F.10.8E (8E)
[D][dallas.sensor:153]: 'Temperatura Placas': Got Temperature=33.0°C
[V][sensor:013]: 'Temperatura Placas': Received new state 33.000000
[D][sensor:092]: 'Temperatura Placas': Sending state 33.00000 °C with 1 decimals of accuracy
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=175988 (now=235988)
[V][bme280.sensor:171]: Sending conversion request...
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110100 (0xF4)
[VV][i2c:093]:     Writing 0b10110101 (0xB5)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][scheduler:025]: set_timeout(name='data', timeout=114)
[VV][scheduler:131]: Running timeout 'data' with interval=114 last_execution=236015 (now=236129)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111010 (0xFA)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01110101 (0x75)
[VV][i2c:113]:     Received 0b01001101 (0x4D)
[VV][i2c:113]:     Received 0b01000000 (0x40)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110111 (0xF7)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01001100 (0x4C)
[VV][i2c:113]:     Received 0b00110110 (0x36)
[VV][i2c:113]:     Received 0b10110000 (0xB0)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111101 (0xFD)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1001011111101000 (0x97E8)
[D][bme280.sensor:197]: Got temperature=10.2°C pressure=1002.7hPa humidity=79.8%
[V][sensor:013]: 'Temperatura ambiente': Received new state 10.200000
[D][sensor:092]: 'Temperatura ambiente': Sending state 10.20000 °C with 1 decimals of accuracy
[V][sensor:013]: 'Presión': Received new state 1002.737793
[D][sensor:092]: 'Presión': Sending state 1002.73779 hPa with 1 decimals of accuracy
[V][sensor:013]: 'Humedad': Received new state 79.835938
[D][sensor:092]: 'Humedad': Sending state 79.83594 % with 1 decimals of accuracy
[I][mqtt:162]: Connecting to MQTT...
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=215749 (now=275749)
[D][adc:056]: 'VCC pila': Got voltage=3.51V
[V][sensor:013]: 'VCC pila': Received new state 3.513672
[D][sensor:092]: 'VCC pila': Sending state 3.51367 V with 2 decimals of accuracy
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=224533 (now=284533)
[VV][scheduler:025]: set_timeout(name='0x85021563DF47FF28', timeout=750)
[VV][scheduler:131]: Running timeout '0x85021563DF47FF28' with interval=750 last_execution=284536 (now=285286)
[VV][dallas.sensor:257]: Scratch pad: 10.02.1F.1B.7F.FF.7F.10.8E (8E)
[D][dallas.sensor:153]: 'Temperatura Placas': Got Temperature=33.0°C
[V][sensor:013]: 'Temperatura Placas': Received new state 33.000000
[D][sensor:092]: 'Temperatura Placas': Sending state 33.00000 °C with 1 decimals of accuracy
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=235988 (now=295988)
[V][bme280.sensor:171]: Sending conversion request...
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110100 (0xF4)
[VV][i2c:093]:     Writing 0b10110101 (0xB5)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][scheduler:025]: set_timeout(name='data', timeout=114)
[VV][scheduler:131]: Running timeout 'data' with interval=114 last_execution=296015 (now=296129)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111010 (0xFA)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01110101 (0x75)
[VV][i2c:113]:     Received 0b00110100 (0x34)
[VV][i2c:113]:     Received 0b10100000 (0xA0)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110111 (0xF7)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01001100 (0x4C)
[VV][i2c:113]:     Received 0b00101111 (0x2F)
[VV][i2c:113]:     Received 0b01100000 (0x60)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111101 (0xFD)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1001100010111010 (0x98BA)
[D][bme280.sensor:197]: Got temperature=10.1°C pressure=1002.7hPa humidity=80.9%
[V][sensor:013]: 'Temperatura ambiente': Received new state 10.080000
[D][sensor:092]: 'Temperatura ambiente': Sending state 10.08000 °C with 1 decimals of accuracy
[V][sensor:013]: 'Presión': Received new state 1002.725525
[D][sensor:092]: 'Presión': Sending state 1002.72552 hPa with 1 decimals of accuracy
[V][sensor:013]: 'Humedad': Received new state 80.875000
[D][sensor:092]: 'Humedad': Sending state 80.87500 % with 1 decimals of accuracy
[I][mqtt:162]: Connecting to MQTT...
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=275749 (now=335749)
[D][adc:056]: 'VCC pila': Got voltage=3.51V
[V][sensor:013]: 'VCC pila': Received new state 3.513672
[D][sensor:092]: 'VCC pila': Sending state 3.51367 V with 2 decimals of accuracy
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=284533 (now=344533)
[VV][scheduler:025]: set_timeout(name='0x85021563DF47FF28', timeout=750)
[VV][scheduler:131]: Running timeout '0x85021563DF47FF28' with interval=750 last_execution=344536 (now=345286)
[VV][dallas.sensor:257]: Scratch pad: 10.02.1F.1B.7F.FF.7F.10.8E (8E)
[D][dallas.sensor:153]: 'Temperatura Placas': Got Temperature=33.0°C
[V][sensor:013]: 'Temperatura Placas': Received new state 33.000000
[D][sensor:092]: 'Temperatura Placas': Sending state 33.00000 °C with 1 decimals of accuracy
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=295988 (now=355988)
[V][bme280.sensor:171]: Sending conversion request...
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110100 (0xF4)
[VV][i2c:093]:     Writing 0b10110101 (0xB5)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][scheduler:025]: set_timeout(name='data', timeout=114)
[VV][scheduler:131]: Running timeout 'data' with interval=114 last_execution=356015 (now=356129)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111010 (0xFA)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01110101 (0x75)
[VV][i2c:113]:     Received 0b00011101 (0x1D)
[VV][i2c:113]:     Received 0b01000000 (0x40)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110111 (0xF7)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01001100 (0x4C)
[VV][i2c:113]:     Received 0b00100111 (0x27)
[VV][i2c:113]:     Received 0b11010000 (0xD0)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111101 (0xFD)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1001100011110011 (0x98F3)
[D][bme280.sensor:197]: Got temperature=10.0°C pressure=1002.7hPa humidity=81.2%
[V][sensor:013]: 'Temperatura ambiente': Received new state 9.960000
[D][sensor:092]: 'Temperatura ambiente': Sending state 9.96000 °C with 1 decimals of accuracy
[V][sensor:013]: 'Presión': Received new state 1002.728210
[D][sensor:092]: 'Presión': Sending state 1002.72821 hPa with 1 decimals of accuracy
[V][sensor:013]: 'Humedad': Received new state 81.156250
[D][sensor:092]: 'Humedad': Sending state 81.15625 % with 1 decimals of accuracy
bcn_timout,ap_probe_send_start
[I][mqtt:162]: Connecting to MQTT...
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=335749 (now=395749)
[D][adc:056]: 'VCC pila': Got voltage=3.51V
[V][sensor:013]: 'VCC pila': Received new state 3.513672
[D][sensor:092]: 'VCC pila': Sending state 3.51367 V with 2 decimals of accuracy
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=344533 (now=404533)
[VV][scheduler:025]: set_timeout(name='0x85021563DF47FF28', timeout=750)
[VV][scheduler:131]: Running timeout '0x85021563DF47FF28' with interval=750 last_execution=404536 (now=405286)
[VV][dallas.sensor:257]: Scratch pad: 10.02.1F.1B.7F.FF.7F.10.8E (8E)
[D][dallas.sensor:153]: 'Temperatura Placas': Got Temperature=33.0°C
[V][sensor:013]: 'Temperatura Placas': Received new state 33.000000
[D][sensor:092]: 'Temperatura Placas': Sending state 33.00000 °C with 1 decimals of accuracy
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=355988 (now=415988)
[V][bme280.sensor:171]: Sending conversion request...
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110100 (0xF4)
[VV][i2c:093]:     Writing 0b10110101 (0xB5)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][scheduler:025]: set_timeout(name='data', timeout=114)
[VV][scheduler:131]: Running timeout 'data' with interval=114 last_execution=416015 (now=416129)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111010 (0xFA)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01110101 (0x75)
[VV][i2c:113]:     Received 0b00001110 (0x0E)
[VV][i2c:113]:     Received 0b10110000 (0xB0)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110111 (0xF7)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01001100 (0x4C)
[VV][i2c:113]:     Received 0b00100010 (0x22)
[VV][i2c:113]:     Received 0b10010000 (0x90)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111101 (0xFD)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1001100110001110 (0x998E)
[D][bme280.sensor:197]: Got temperature=9.9°C pressure=1002.7hPa humidity=81.9%
[V][sensor:013]: 'Temperatura ambiente': Received new state 9.890000
[D][sensor:092]: 'Temperatura ambiente': Sending state 9.89000 °C with 1 decimals of accuracy
[V][sensor:013]: 'Presión': Received new state 1002.745483
[D][sensor:092]: 'Presión': Sending state 1002.74548 hPa with 1 decimals of accuracy
[V][sensor:013]: 'Humedad': Received new state 81.930664
[D][sensor:092]: 'Humedad': Sending state 81.93066 % with 1 decimals of accuracy
[I][mqtt:162]: Connecting to MQTT...
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=395749 (now=455749)
[D][adc:056]: 'VCC pila': Got voltage=3.51V
[V][sensor:013]: 'VCC pila': Received new state 3.513672
[D][sensor:092]: 'VCC pila': Sending state 3.51367 V with 2 decimals of accuracy
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=404533 (now=464533)
[VV][scheduler:025]: set_timeout(name='0x85021563DF47FF28', timeout=750)
[VV][scheduler:131]: Running timeout '0x85021563DF47FF28' with interval=750 last_execution=464536 (now=465286)
[VV][dallas.sensor:257]: Scratch pad: 10.02.1F.1B.7F.FF.7F.10.8E (8E)
[D][dallas.sensor:153]: 'Temperatura Placas': Got Temperature=33.0°C
[V][sensor:013]: 'Temperatura Placas': Received new state 33.000000
[D][sensor:092]: 'Temperatura Placas': Sending state 33.00000 °C with 1 decimals of accuracy
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=415988 (now=475988)
[V][bme280.sensor:171]: Sending conversion request...
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110100 (0xF4)
[VV][i2c:093]:     Writing 0b10110101 (0xB5)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][scheduler:025]: set_timeout(name='data', timeout=114)
[VV][scheduler:131]: Running timeout 'data' with interval=114 last_execution=476015 (now=476129)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111010 (0xFA)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01110101 (0x75)
[VV][i2c:113]:     Received 0b00001011 (0x0B)
[VV][i2c:113]:     Received 0b10100000 (0xA0)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110111 (0xF7)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01001100 (0x4C)
[VV][i2c:113]:     Received 0b00100001 (0x21)
[VV][i2c:113]:     Received 0b11100000 (0xE0)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111101 (0xFD)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1001101000111110 (0x9A3E)
[D][bme280.sensor:197]: Got temperature=9.9°C pressure=1002.7hPa humidity=82.8%
[V][sensor:013]: 'Temperatura ambiente': Received new state 9.870000
[D][sensor:092]: 'Temperatura ambiente': Sending state 9.87000 °C with 1 decimals of accuracy
[V][sensor:013]: 'Presión': Received new state 1002.738281
[D][sensor:092]: 'Presión': Sending state 1002.73828 hPa with 1 decimals of accuracy
[V][sensor:013]: 'Humedad': Received new state 82.816406
[D][sensor:092]: 'Humedad': Sending state 82.81641 % with 1 decimals of accuracy
[I][mqtt:162]: Connecting to MQTT...
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=455749 (now=515749)
[D][adc:056]: 'VCC pila': Got voltage=3.51V
[V][sensor:013]: 'VCC pila': Received new state 3.512695
[D][sensor:092]: 'VCC pila': Sending state 3.51270 V with 2 decimals of accuracy
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=464533 (now=524533)
[VV][scheduler:025]: set_timeout(name='0x85021563DF47FF28', timeout=750)
[VV][scheduler:131]: Running timeout '0x85021563DF47FF28' with interval=750 last_execution=524536 (now=525286)
[VV][dallas.sensor:257]: Scratch pad: 10.02.1F.1B.7F.FF.7F.10.8E (8E)
[D][dallas.sensor:153]: 'Temperatura Placas': Got Temperature=33.0°C
[V][sensor:013]: 'Temperatura Placas': Received new state 33.000000
[D][sensor:092]: 'Temperatura Placas': Sending state 33.00000 °C with 1 decimals of accuracy
[VV][scheduler:131]: Running interval 'update' with interval=60000 last_execution=475988 (now=535988)
[V][bme280.sensor:171]: Sending conversion request...
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110100 (0xF4)
[VV][i2c:093]:     Writing 0b10110101 (0xB5)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][scheduler:025]: set_timeout(name='data', timeout=114)
[VV][scheduler:131]: Running timeout 'data' with interval=114 last_execution=536015 (now=536129)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111010 (0xFA)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01110101 (0x75)
[VV][i2c:113]:     Received 0b00000000 (0x00)
[VV][i2c:113]:     Received 0b10110000 (0xB0)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11110111 (0xF7)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 3 bytes from 0x76:
[VV][i2c:113]:     Received 0b01001100 (0x4C)
[VV][i2c:113]:     Received 0b00011011 (0x1B)
[VV][i2c:113]:     Received 0b11000000 (0xC0)
[VV][i2c:056]: Beginning Transmission to 0x76:
[VV][i2c:093]:     Writing 0b11111101 (0xFD)
[VV][i2c:061]:     Transmission ended. Status code: 0x00
[VV][i2c:083]: Requesting 2 bytes from 0x76:
[VV][i2c:126]:     Received 0b1001101000111100 (0x9A3C)
[D][bme280.sensor:197]: Got temperature=9.8°C pressure=1002.8hPa humidity=82.8%
[V][sensor:013]: 'Temperatura ambiente': Received new state 9.820000
[D][sensor:092]: 'Temperatura ambiente': Sending state 9.82000 °C with 1 decimals of accuracy
[V][sensor:013]: 'Presión': Received new state 1002.808777
[D][sensor:092]: 'Presión': Sending state 1002.80878 hPa with 1 decimals of accuracy
[V][sensor:013]: 'Humedad': Received new state 82.796875
[D][sensor:092]: 'Humedad': Sending state 82.79688 % with 1 decimals of accuracy

[CANCELED BY ME]

Additional information and things you've tried:

I decided to git bisect and after "some" work I found the last commit that works without problems: 7a895adec9dcf49c245ea2cfabab461d348ba2d7

After it, new scheduler was introduced in this commit: b51cbc420766a008d0ed55973898df5a143a38b3 (with other changes, so more dificult to git bisec and isolate problems). After it, I tried this commit 8db6f3129cb35a9a0fe8c5c4977af5be9521c2db (no logs provided, sorry) and Wifi connection works fine but not MQTT.

BUT, the key is in the next commit, 36f47ade70351e8d5ddbc6ec608b3092427f54bb, where captive portal is introduced, and with that commit starts the connection problems.

I've read some closed issues, like #455, even tried changing the output power, but I'm pretty sure the problem is the code changed to add captive portal. In git bisect I trust.. :-)

Hope this logs and info helps to solve the problem. If you need more, I'm glad to provide more logs or info.

P.S: I LOVE this software. A great idea and simple to configure and maintain. Congrats and thanks!

P.S.2: I'd suggest do more specific commit, avoid squash unrelated commits and create and merge hotfix branches instead cherry-picking to help with git bisect. Also use pip freeze every now and then; I had to edit requirements_test.txt in some commits to force voluptuous and platformio versions.

abmantis commented 4 years ago

I was also trying to revert the commit, but indeed it has a lot of changes. It would be good to have smaller commits with individual changes :/

skarcha commented 4 years ago

Thanks for trying, @abmantis 👍

stale[bot] commented 4 years ago

This issue has been automatically marked as stale because it has not had recent activity. It will be closed if no further activity occurs. Thank you for your contributions.

OttoWinter commented 4 years ago

So the scheduler that was introduced in the mentioned commit first had an issue (that would only show up in certain configurations, thus it was not caught immediately). See also git history here: https://github.com/esphome/esphome/commits/dev/esphome/core/scheduler.cpp

That probably means the git bisect is tainted (or at least doesn't give accurate result) because the pattern is not fail, fail, fail, ..., good, good, good.

Thanks for trying to bisect it. As for the big commits: We squash commits to keep the git history cleaner, obviously that makes git bisecting harder (but it should be possible if you switch to the branch of the PR).