andyboeh / esphome-elero

An ESPHOME custom component to control Elero blinds using the bidirectional Elero protocol
23 stars 6 forks source link

Lost in the jungle. Need some help. #7

Closed Hufenbacke closed 1 week ago

Hufenbacke commented 1 week ago

Hey guys,

I need some help. I just got some new Eleros and now I want to integrate them in Home Assistant. I don´t have a TempoTel2. I have MonoTec-868. On Eleros website they are listed as bidirectional. I have to say that this is my first ESP32 project, so I lack some knowledge. So I have espHome setup in HomeAssistant. I was able to flash the firmware on the device and it is booting. So this seems to be working. Than I tried to listen to the communication of the elero network. But this is where my problems begin. I don´t know where I should look. I guessed that it was this log:

log

But there happens nothing after pressing a button. The last entry in this log is:

[21:33:59][C][safe_mode:018]: Safe Mode:
[21:33:59][C][safe_mode:020]:   Boot considered successful after 60 seconds
[21:33:59][C][safe_mode:021]:   Invoke after 10 boot attempts
[21:33:59][C][safe_mode:023]:   Remain in safe mode for 300 seconds
[21:33:59][C][api:139]: API Server:
[21:33:59][C][api:140]:   Address: 10.20.20.80:6053
[21:33:59][C][api:142]:   Using noise encryption: YES

So do I have to look somewhere else or is this the right place. It is mentioned that I have to enable logging, but where do I do this? The log states the following:

[21:33:59][C][logger:185]: Logger:
[21:33:59][C][logger:186]:   Level: DEBUG
[21:33:59][C][logger:188]:   Log Baud Rate: 115200
[21:33:59][C][logger:189]:   Hardware UART: UART0

DEBUG sounds right to me. Or is it another option.

Here is my config so far:

esphome:
  name: elerosteuereinheit
  friendly_name: EleroSteuereinheit

esp32:
  board: esp32dev
  framework:
    type: arduino

# Enable logging
logger:

# Enable Home Assistant API
api:
  encryption:
    key: "******"

ota:
  - platform: esphome
    password: "*****"

wifi:
  ssid: !secret wifi_ssid
  password: !secret wifi_password

  # Optional manual IP
  manual_ip:
    static_ip: 10.20.20.80
    gateway: 10.20.20.1
    subnet: 255.255.255.0
    dns1: 10.20.20.21
    dns2: 10.20.20.22

  # Enable fallback hotspot (captive portal) in case wifi connection fails
  ap:
    ssid: "Elerosteuereinheit"
    password: "****"

captive_portal:

external_components:
  - source: github://andyboeh/esphome-elero

spi:
  clk_pin: GPIO18
  mosi_pin: GPIO23
  miso_pin: GPIO19

elero:
  cs_pin: GPIO5
  gdo0_pin: GPIO26
  freq0: 0xc0
  freq1: 0x71
  freq2: 0x21

cover:
  - platform: elero
    blind_address: 0xa831e5
    channel: 4
    remote_address: 0xf0d008
    name: Schlafzimmer
    open_duration: 25s
    close_duration: 22s
    poll_interval: 120min
    supports_tilt: False

I used the blind from the default for the fake one. I hope that this was the right move.

andyboeh commented 1 week ago

Please post the complete log. I updated your comment to include proper quoting, you have to use three accents, like so: "```"

Hufenbacke commented 1 week ago

Please post the complete log. I updated your comment to include proper quoting, you have to use three accents, like so: "```"

Thanks for you reply. Didn´t know it had to be "```". Here is the full log:

INFO ESPHome 2024.8.3
INFO Reading configuration /config/esphome/elerosteuereinheit.yaml...
WARNING GPIO5 is a strapping PIN and should only be used for I/O with care.
Attaching external pullup/down resistors to strapping pins can cause unexpected failures.
See https://esphome.io/guides/faq.html#why-am-i-getting-a-warning-about-strapping-pins
INFO Starting log output from 10.20.20.80 using esphome API
INFO Successfully connected to elerosteuereinheit @ 10.20.20.80 in 0.071s
INFO Successful handshake with elerosteuereinheit @ 10.20.20.80 in 0.109s
[09:20:18][I][app:100]: ESPHome version 2024.8.3 compiled on Sep  7 2024, 09:11:39
[09:20:18][C][wifi:600]: WiFi:
[09:20:18][C][wifi:428]:   Local MAC: *********
[09:20:18][C][wifi:433]:   SSID: '*******'[redacted]
[09:20:18][C][wifi:436]:   IP Address: 10.20.20.80
[09:20:18][C][wifi:440]:   BSSID: ********[redacted]
[09:20:18][C][wifi:441]:   Hostname: 'elerosteuereinheit'
[09:20:18][C][wifi:443]:   Signal strength: -81 dB ▂▄▆█
[09:20:18][C][wifi:447]:   Channel: 7
[09:20:18][C][wifi:448]:   Subnet: 255.255.255.0
[09:20:18][C][wifi:449]:   Gateway: 10.20.20.1
[09:20:18][C][wifi:450]:   DNS1: 10.20.20.21
[09:20:18][C][wifi:451]:   DNS2: 10.20.20.22
[09:20:18][C][logger:185]: Logger:
[09:20:18][C][logger:186]:   Level: DEBUG
[09:20:18][C][logger:188]:   Log Baud Rate: 115200
[09:20:18][C][logger:189]:   Hardware UART: UART0
[09:20:18][C][spi:064]: SPI bus:
[09:20:18][C][spi:065]:   CLK Pin: GPIO18
[09:20:18][C][spi:066]:   SDI Pin: GPIO19
[09:20:18][C][spi:067]:   SDO Pin: GPIO23
[09:20:18][C][spi:072]:   Using HW SPI: SPI
[09:20:18][C][elero:046]: Elero Config: 
[09:20:18][C][elero.cover:012]: Elero Cover 'Schlafzimmer'
[09:20:18][C][elero.cover:012]:   Assumed State: YES
[09:20:18][C][captive_portal:088]: Captive Portal:
[09:20:18][C][mdns:116]: mDNS:
[09:20:18][C][mdns:117]:   Hostname: elerosteuereinheit
[09:20:18][C][esphome.ota:073]: Over-The-Air updates:
[09:20:18][C][esphome.ota:074]:   Address: 10.20.20.80:3232
[09:20:18][C][esphome.ota:075]:   Version: 2
[09:20:18][C][esphome.ota:078]:   Password configured
[09:20:18][C][safe_mode:018]: Safe Mode:
[09:20:18][C][safe_mode:020]:   Boot considered successful after 60 seconds
[09:20:18][C][safe_mode:021]:   Invoke after 10 boot attempts
[09:20:18][C][safe_mode:023]:   Remain in safe mode for 300 seconds
[09:20:18][C][api:139]: API Server:
[09:20:18][C][api:140]:   Address: 10.20.20.80:6053
[09:20:18][C][api:142]:   Using noise encryption: YE
andyboeh commented 1 week ago

OK, that looks fine - the wiring of your CC1101 module matches the configured pins?

Hufenbacke commented 1 week ago

OK, that looks fine - the wiring of your CC1101 module matches the configured pins?

I already checked it like 50times or so :) I also took a multimeter to test the connection from all the the pins of the esp32 to the pins of the processor of the c1101. And all the connections work.

Btw: Was my guess right, that the communication log should appear in the esphomeweb console or do i have to look somewhere else?

andyboeh commented 1 week ago

It should also appear in the web console. Try to send anything from the fake cover, i.e. try to open and close it. What is reported in the log?

Hufenbacke commented 1 week ago

It should also appear in the web console. Try to send anything from the fake cover, i.e. try to open and close it. What is reported in the log?

The log:

[10:44:52][C][api:139]: API Server:
[10:44:52][C][api:140]:   Address: 10.20.20.80:6053
[10:44:52][C][api:142]:   Using noise encryption: YES
[10:45:12][D][cover:076]: 'Schlafzimmer' - Setting
[10:45:12][D][cover:084]:   Position: 100%
[10:45:12][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:45:12][D][cover:173]:   Position: 50%
[10:45:12][D][cover:186]:   Current Operation: OPENING
[10:45:12][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:12][D][elero.cover:086]: Retry #0 for blind 0xa831e5
[10:45:12][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:45:12][D][cover:173]:   Position: 50%
[10:45:12][D][cover:186]:   Current Operation: OPENING
[10:45:12][W][component:237]: Component elero.cover took a long time for an operation (77 ms).
[10:45:12][W][component:238]: Components should block for at most 30 ms.
[10:45:12][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:12][D][elero.cover:086]: Retry #1 for blind 0xa831e5
[10:45:12][W][component:237]: Component elero.cover took a long time for an operation (57 ms).
[10:45:12][W][component:238]: Components should block for at most 30 ms.
[10:45:12][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:12][D][elero.cover:086]: Retry #2 for blind 0xa831e5
[10:45:12][W][component:237]: Component elero.cover took a long time for an operation (57 ms).
[10:45:12][W][component:238]: Components should block for at most 30 ms.
[10:45:12][E][elero:436]: Received invalid packet: dests_len too long (125)
[10:45:12][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:12][D][elero.cover:086]: Retry #3 for blind 0xa831e5
[10:45:12][E][elero.cover:089]: Hit maximum number of retries, giving up.
[10:45:12][W][component:237]: Component elero.cover took a long time for an operation (63 ms).
[10:45:12][W][component:238]: Components should block for at most 30 ms.
[10:45:12][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:12][D][elero.cover:086]: Retry #0 for blind 0xa831e5
[10:45:12][W][component:237]: Component elero.cover took a long time for an operation (57 ms).
[10:45:12][W][component:238]: Components should block for at most 30 ms.
[10:45:12][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:12][D][elero.cover:086]: Retry #1 for blind 0xa831e5
[10:45:12][W][component:237]: Component elero.cover took a long time for an operation (57 ms).
[10:45:12][W][component:238]: Components should block for at most 30 ms.
[10:45:12][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:12][D][elero.cover:086]: Retry #2 for blind 0xa831e5
[10:45:12][W][component:237]: Component elero.cover took a long time for an operation (56 ms).
[10:45:12][W][component:238]: Components should block for at most 30 ms.
[10:45:12][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:12][D][elero.cover:086]: Retry #3 for blind 0xa831e5
[10:45:12][E][elero.cover:089]: Hit maximum number of retries, giving up.
[10:45:12][W][component:237]: Component elero.cover took a long time for an operation (61 ms).
[10:45:12][W][component:238]: Components should block for at most 30 ms.
[10:45:13][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:45:13][D][cover:173]:   Position: 54%
[10:45:13][D][cover:186]:   Current Operation: OPENING
[10:45:14][D][cover:076]: 'Schlafzimmer' - Setting
[10:45:14][D][cover:080]:   Command: STOP
[10:45:14][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:45:14][D][cover:173]:   Position: 58%
[10:45:14][D][cover:186]:   Current Operation: IDLE
[10:45:14][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:14][D][elero.cover:086]: Retry #0 for blind 0xa831e5
[10:45:14][W][component:237]: Component elero.cover took a long time for an operation (58 ms).
[10:45:14][W][component:238]: Components should block for at most 30 ms.
[10:45:14][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:14][D][elero.cover:086]: Retry #1 for blind 0xa831e5
[10:45:14][W][component:237]: Component elero.cover took a long time for an operation (57 ms).
[10:45:14][W][component:238]: Components should block for at most 30 ms.
[10:45:14][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:14][D][elero.cover:086]: Retry #2 for blind 0xa831e5
[10:45:14][W][component:237]: Component elero.cover took a long time for an operation (58 ms).
[10:45:14][W][component:238]: Components should block for at most 30 ms.
[10:45:14][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:14][D][elero.cover:086]: Retry #3 for blind 0xa831e5
[10:45:14][E][elero.cover:089]: Hit maximum number of retries, giving up.
[10:45:14][W][component:237]: Component elero.cover took a long time for an operation (61 ms).
[10:45:14][W][component:238]: Components should block for at most 30 ms.
[10:45:15][E][elero:436]: Received invalid packet: dests_len too long (71)
[10:45:15][D][cover:076]: 'Schlafzimmer' - Setting
[10:45:15][D][cover:084]:   Position: 0%
[10:45:15][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:45:15][D][cover:173]:   Position: 58%
[10:45:15][D][cover:186]:   Current Operation: CLOSING
[10:45:15][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:15][D][elero.cover:086]: Retry #0 for blind 0xa831e5
[10:45:15][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:45:15][D][cover:173]:   Position: 57%
[10:45:15][D][cover:186]:   Current Operation: CLOSING
[10:45:15][W][component:237]: Component elero.cover took a long time for an operation (78 ms).
[10:45:15][W][component:238]: Components should block for at most 30 ms.
[10:45:15][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:15][D][elero.cover:086]: Retry #1 for blind 0xa831e5
[10:45:15][W][component:237]: Component elero.cover took a long time for an operation (59 ms).
[10:45:15][W][component:238]: Components should block for at most 30 ms.
[10:45:15][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:15][D][elero.cover:086]: Retry #2 for blind 0xa831e5
[10:45:15][W][component:237]: Component elero.cover took a long time for an operation (59 ms).
[10:45:15][W][component:238]: Components should block for at most 30 ms.
[10:45:15][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:15][D][elero.cover:086]: Retry #3 for blind 0xa831e5
[10:45:15][E][elero.cover:089]: Hit maximum number of retries, giving up.
[10:45:15][W][component:237]: Component elero.cover took a long time for an operation (62 ms).
[10:45:15][W][component:238]: Components should block for at most 30 ms.
[10:45:15][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:15][D][elero.cover:086]: Retry #0 for blind 0xa831e5
[10:45:15][W][component:237]: Component elero.cover took a long time for an operation (62 ms).
[10:45:15][W][component:238]: Components should block for at most 30 ms.
[10:45:15][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:15][D][elero.cover:086]: Retry #1 for blind 0xa831e5
[10:45:15][W][component:237]: Component elero.cover took a long time for an operation (57 ms).
[10:45:15][W][component:238]: Components should block for at most 30 ms.
[10:45:15][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:15][D][elero.cover:086]: Retry #2 for blind 0xa831e5
[10:45:15][W][component:237]: Component elero.cover took a long time for an operation (59 ms).
[10:45:15][W][component:238]: Components should block for at most 30 ms.
[10:45:15][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:15][D][elero.cover:086]: Retry #3 for blind 0xa831e5
[10:45:15][E][elero.cover:089]: Hit maximum number of retries, giving up.
[10:45:16][W][component:237]: Component elero.cover took a long time for an operation (61 ms).
[10:45:16][W][component:238]: Components should block for at most 30 ms.
[10:45:16][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:45:16][D][cover:173]:   Position: 53%
[10:45:16][D][cover:186]:   Current Operation: CLOSING
[10:45:16][D][cover:076]: 'Schlafzimmer' - Setting
[10:45:16][D][cover:080]:   Command: STOP
[10:45:16][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:45:16][D][cover:173]:   Position: 51%
[10:45:16][D][cover:186]:   Current Operation: IDLE
[10:45:16][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:16][D][elero.cover:086]: Retry #0 for blind 0xa831e5
[10:45:16][W][component:237]: Component elero.cover took a long time for an operation (59 ms).
[10:45:16][W][component:238]: Components should block for at most 30 ms.
[10:45:16][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:16][D][elero.cover:086]: Retry #1 for blind 0xa831e5
[10:45:16][W][component:237]: Component elero.cover took a long time for an operation (57 ms).
[10:45:16][W][component:238]: Components should block for at most 30 ms.
[10:45:17][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:17][D][elero.cover:086]: Retry #2 for blind 0xa831e5
[10:45:17][W][component:237]: Component elero.cover took a long time for an operation (57 ms).
[10:45:17][W][component:238]: Components should block for at most 30 ms.
[10:45:17][E][elero:186]: Timed out waiting for TX: 0x0d
[10:45:17][D][elero.cover:086]: Retry #3 for blind 0xa831e5
[10:45:17][E][elero.cover:089]: Hit maximum number of retries, giving up.
[10:45:17][W][component:237]: Component elero.cover took a long time for an operation (60 ms).
[10:45:17][W][component:238]: Components should block for at most 30 ms.

It´s is still retrying as of writing :)

I am keeping it running and I saw something interesting(?):

[10:45:26][D][elero:451]: rcv'd: len=53, cnt=183, typ=0xba, typ2=0xde, hop=d0, syst=b7, chl=24, src=0x762218, bwd=0x8c9bda, fwd=0x18d095, #dst=182, dst=22ece7, rssi=-41.0, lqi=54, crc= 1, payload=[0x83 0x79 0x00 0x00 0x91 0xa0 0xde 0x72 0xdb 0x38] 
.................
[10:45:38][D][elero:451]: rcv'd: len=07, cnt=62, typ=0xf4, typ2=0x26, hop=be, syst=de, chl=61, src=0x866b7f, bwd=0x240bcd, fwd=0x99d5db, #dst=98, dst=9b45e3, rssi=-21.0, lqi=127, crc= 0, payload=[0x5b 0x5b 0x00 0x00 0x40 0xb0 0x74 0xca 0x08 0x30]
..............
[10:46:20][D][elero:451]: rcv'd: len=04, cnt=208, typ=0xb6, typ2=0x45, hop=60, syst=42, chl=12, src=0x090d48, bwd=0x484707, fwd=0xe1a993, #dst=02, dst=676764, rssi=-41.0, lqi=12, crc= 0, payload=[0xed 0xc7 0x00 0x00 0xab 0x43 0x43 0x87 0x87 0xcb]
..............
[10:46:55][D][elero:451]: rcv'd: len=04, cnt=103, typ=0xe0, typ2=0x32, hop=0e, syst=67, chl=127, src=0x718bd9, bwd=0x6ef8dc, fwd=0xf4de2d, #dst=181, dst=cd6290, rssi=-23.0, lqi=127, crc= 0, payload=[0xa7 0x2c 0x00 0x00 0x9d 0xba 0x4f 0xac 0xe9 0x2d]
..............
[10:47:06][D][elero:451]: rcv'd: len=13, cnt=192, typ=0x3f, typ2=0x1c, hop=22, syst=4d, chl=108, src=0x66bd4d, bwd=0x9bf721, fwd=0x777259, #dst=33, dst=000077, rssi=-17.0, lqi=89, crc= 0, payload=[0x79 0x4f 0x00 0x00 0xbd 0x40 0xb3 0x00 0x14 0x6b]
[10:47:06][E][elero:186]: Timed out waiting for TX: 0x0d
[10:47:06][D][elero.cover:086]: Retry #0 for blind 0xa831e5
[10:47:06][W][component:237]: Component elero.cover took a long time for an operation (59 ms).
[10:47:06][W][component:238]: Components should block for at most 30 ms.
[10:47:06][E][elero:186]: Timed out waiting for TX: 0x0d
[10:47:06][D][elero.cover:086]: Retry #1 for blind 0xa831e5
[10:47:06][W][component:237]: Component elero.cover took a long time for an operation (62 ms).
[10:47:06][W][component:238]: Components should block for at most 30 ms.
[10:47:06][E][elero:186]: Timed out waiting for TX: 0x0d
[10:47:06][D][elero.cover:086]: Retry #2 for blind 0xa831e5
[10:47:06][W][component:237]: Component elero.cover took a long time for an operation (57 ms).
[10:47:06][W][component:238]: Components should block for at most 30 ms.
[10:47:06][E][elero:186]: Timed out waiting for TX: 0x0d
[10:47:06][D][elero.cover:086]: Retry #3 for blind 0xa831e5
[10:47:06][E][elero.cover:089]: Hit maximum number of retries, giving up.
[10:47:06][W][component:237]: Component elero.cover took a long time for an operation (63 ms).
[10:47:06][W][component:238]: Components should block for at most 30 ms.
[10:47:06][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:06][D][cover:173]:   Position: 100%
[10:47:06][D][cover:186]:   Current Operation: OPENING
[10:47:07][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:07][D][cover:173]:   Position: 100%
[10:47:07][D][cover:186]:   Current Operation: OPENING
[10:47:08][E][elero:186]: Timed out waiting for TX: 0x0d
[10:47:08][D][elero.cover:086]: Retry #0 for blind 0xa831e5
[10:47:08][W][component:237]: Component elero.cover took a long time for an operation (59 ms).
[10:47:08][W][component:238]: Components should block for at most 30 ms.
[10:47:08][E][elero:186]: Timed out waiting for TX: 0x0d
[10:47:08][D][elero.cover:086]: Retry #1 for blind 0xa831e5
[10:47:08][W][component:237]: Component elero.cover took a long time for an operation (57 ms).
[10:47:08][W][component:238]: Components should block for at most 30 ms.
[10:47:08][E][elero:186]: Timed out waiting for TX: 0x0d
[10:47:08][D][elero.cover:086]: Retry #2 for blind 0xa831e5
[10:47:08][W][component:237]: Component elero.cover took a long time for an operation (58 ms).
[10:47:08][W][component:238]: Components should block for at most 30 ms.
[10:47:08][E][elero:186]: Timed out waiting for TX: 0x0d
[10:47:08][D][elero.cover:086]: Retry #3 for blind 0xa831e5
[10:47:08][E][elero.cover:089]: Hit maximum number of retries, giving up.
[10:47:08][W][component:237]: Component elero.cover took a long time for an operation (61 ms).
[10:47:08][W][component:238]: Components should block for at most 30 ms.
[10:47:08][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:08][D][cover:173]:   Position: 100%
[10:47:08][D][cover:186]:   Current Operation: OPENING
[10:47:09][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:09][D][cover:173]:   Position: 100%
[10:47:09][D][cover:186]:   Current Operation: OPENING
[10:47:10][E][elero:186]: Timed out waiting for TX: 0x0d
[10:47:10][D][elero.cover:086]: Retry #0 for blind 0xa831e5
[10:47:10][W][component:237]: Component elero.cover took a long time for an operation (59 ms).
[10:47:10][W][component:238]: Components should block for at most 30 ms.
[10:47:10][E][elero:186]: Timed out waiting for TX: 0x0d
[10:47:10][D][elero.cover:086]: Retry #1 for blind 0xa831e5
[10:47:10][W][component:237]: Component elero.cover took a long time for an operation (57 ms).
[10:47:10][W][component:238]: Components should block for at most 30 ms.
[10:47:10][E][elero:186]: Timed out waiting for TX: 0x11
[10:47:10][D][elero.cover:086]: Retry #2 for blind 0xa831e5
[10:47:10][W][component:237]: Component elero.cover took a long time for an operation (60 ms).
[10:47:10][W][component:238]: Components should block for at most 30 ms.
[10:47:10][E][elero:186]: Timed out waiting for TX: 0x0d
[10:47:10][D][elero.cover:086]: Retry #3 for blind 0xa831e5
[10:47:10][E][elero.cover:089]: Hit maximum number of retries, giving up.
[10:47:10][W][component:237]: Component elero.cover took a long time for an operation (61 ms).
[10:47:10][W][component:238]: Components should block for at most 30 ms.
[10:47:10][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:10][D][cover:173]:   Position: 100%
[10:47:10][D][cover:186]:   Current Operation: OPENING
[10:47:11][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:11][D][cover:173]:   Position: 100%
[10:47:11][D][cover:186]:   Current Operation: OPENING
[10:47:12][E][elero:186]: Timed out waiting for TX: 0x0d
[10:47:12][D][elero.cover:086]: Retry #0 for blind 0xa831e5
[10:47:12][W][component:237]: Component elero.cover took a long time for an operation (59 ms).
[10:47:12][W][component:238]: Components should block for at most 30 ms.
[10:47:12][E][elero:186]: Timed out waiting for TX: 0x0d
[10:47:12][D][elero.cover:086]: Retry #1 for blind 0xa831e5
[10:47:12][W][component:237]: Component elero.cover took a long time for an operation (58 ms).
[10:47:12][W][component:238]: Components should block for at most 30 ms.
[10:47:12][E][elero:186]: Timed out waiting for TX: 0x0d
[10:47:12][D][elero.cover:086]: Retry #2 for blind 0xa831e5
[10:47:12][W][component:237]: Component elero.cover took a long time for an operation (57 ms).
[10:47:12][W][component:238]: Components should block for at most 30 ms.
[10:47:12][E][elero:186]: Timed out waiting for TX: 0x0d
[10:47:12][D][elero.cover:086]: Retry #3 for blind 0xa831e5
[10:47:12][E][elero.cover:089]: Hit maximum number of retries, giving up.
[10:47:12][W][component:237]: Component elero.cover took a long time for an operation (62 ms).
[10:47:12][W][component:238]: Components should block for at most 30 ms.
[10:47:12][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:12][D][cover:173]:   Position: 100%
[10:47:12][D][cover:186]:   Current Operation: OPENING
[10:47:13][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:13][D][cover:173]:   Position: 100%
[10:47:13][D][cover:186]:   Current Operation: OPENING
[10:47:14][E][elero:186]: Timed out waiting for TX: 0x0d
[10:47:14][D][elero.cover:086]: Retry #0 for blind 0xa831e5
[10:47:14][W][component:237]: Component elero.cover took a long time for an operation (59 ms).
[10:47:14][W][component:238]: Components should block for at most 30 ms.
[10:47:14][E][elero:186]: Timed out waiting for TX: 0x0d
[10:47:14][D][elero.cover:086]: Retry #1 for blind 0xa831e5
[10:47:14][W][component:237]: Component elero.cover took a long time for an operation (57 ms).
[10:47:14][W][component:238]: Components should block for at most 30 ms.
[10:47:14][E][elero:186]: Timed out waiting for TX: 0x0d
[10:47:14][D][elero.cover:086]: Retry #2 for blind 0xa831e5
[10:47:14][W][component:237]: Component elero.cover took a long time for an operation (57 ms).
[10:47:14][W][component:238]: Components should block for at most 30 ms.
[10:47:14][E][elero:186]: Timed out waiting for TX: 0x0d
[10:47:14][D][elero.cover:086]: Retry #3 for blind 0xa831e5
[10:47:14][E][elero.cover:089]: Hit maximum number of retries, giving up.
[10:47:14][W][component:237]: Component elero.cover took a long time for an operation (62 ms).
[10:47:14][W][component:238]: Components should block for at most 30 ms.
[10:47:14][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:14][D][cover:173]:   Position: 100%
[10:47:14][D][cover:186]:   Current Operation: OPENING
[10:47:15][E][elero:436]: Received invalid packet: dests_len too long (193)
[10:47:15][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:15][D][cover:173]:   Position: 100%
[10:47:15][D][cover:186]:   Current Operation: OPENING
[10:47:16][E][elero:186]: Timed out waiting for TX: 0x0d
[10:47:16][D][elero.cover:086]: Retry #0 for blind 0xa831e5
[10:47:16][W][component:237]: Component elero.cover took a long time for an operation (60 ms).
[10:47:16][W][component:238]: Components should block for at most 30 ms.
[10:47:16][E][elero:186]: Timed out waiting for TX: 0x0d
[10:47:16][D][elero.cover:086]: Retry #1 for blind 0xa831e5
[10:47:16][W][component:237]: Component elero.cover took a long time for an operation (60 ms).
[10:47:16][W][component:238]: Components should block for at most 30 ms.
[10:47:16][E][elero:186]: Timed out waiting for TX: 0x0d
[10:47:16][D][elero.cover:086]: Retry #2 for blind 0xa831e5
[10:47:16][W][component:237]: Component elero.cover took a long time for an operation (57 ms).
[10:47:16][W][component:238]: Components should block for at most 30 ms.
[10:47:16][E][elero:186]: Timed out waiting for TX: 0x0d
[10:47:16][D][elero.cover:086]: Retry #3 for blind 0xa831e5
[10:47:16][E][elero.cover:089]: Hit maximum number of retries, giving up.
[10:47:16][W][component:237]: Component elero.cover took a long time for an operation (59 ms).
[10:47:16][W][component:238]: Components should block for at most 30 ms.
[10:47:16][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:16][D][cover:173]:   Position: 100%
[10:47:16][D][cover:186]:   Current Operation: OPENING
[10:47:17][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:17][D][cover:173]:   Position: 100%
[10:47:17][D][cover:186]:   Current Operation: OPENING
[10:47:18][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:18][D][cover:173]:   Position: 100%
[10:47:18][D][cover:186]:   Current Operation: OPENING
[10:47:19][E][elero:436]: Received invalid packet: dests_len too long (54)
[10:47:19][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:19][D][cover:173]:   Position: 100%
[10:47:19][D][cover:186]:   Current Operation: OPENING
[10:47:20][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:20][D][cover:173]:   Position: 100%
[10:47:20][D][cover:186]:   Current Operation: OPENING
[10:47:21][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:21][D][cover:173]:   Position: 100%
[10:47:21][D][cover:186]:   Current Operation: OPENING
[10:47:22][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:22][D][cover:173]:   Position: 100%
[10:47:22][D][cover:186]:   Current Operation: OPENING
[10:47:23][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:23][D][cover:173]:   Position: 100%
[10:47:23][D][cover:186]:   Current Operation: OPENING
[10:47:24][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:24][D][cover:173]:   Position: 100%
[10:47:24][D][cover:186]:   Current Operation: OPENING
[10:47:25][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:25][D][cover:173]:   Position: 100%
[10:47:25][D][cover:186]:   Current Operation: OPENING
[10:47:26][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:26][D][cover:173]:   Position: 100%
[10:47:26][D][cover:186]:   Current Operation: OPENING
[10:47:27][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:27][D][cover:173]:   Position: 100%
[10:47:27][D][cover:186]:   Current Operation: OPENING
[10:47:28][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:28][D][cover:173]:   Position: 100%
[10:47:28][D][cover:186]:   Current Operation: OPENING
[10:47:29][D][cover:170]: 'Schlafzimmer' - Publishing:
[10:47:29][D][cover:173]:   Position: 100%
and keeps spamming the same
andyboeh commented 1 week ago

Yes, you received something, but the data is complete nonsense. 182 destination blinds? The message "Timed out waiting for TX" should not appear. It stays in state "0x0d" which is Rx, so your module never enters the transmit state. This can have two reasons:

  1. The module does CCA first (Clear Channel Assessment). If CCA fails (i.e. the channel is in use), then the module statys in Rx.
  2. Your module behaves differently than mine
  3. The module is broken

Which CC1101 module are you using?

Hufenbacke commented 1 week ago

Yes, you received something, but the data is complete nonsense. 182 destination blinds? The message "Timed out waiting for TX" should not appear. It stays in state "0x0d" which is Rx, so your module never enters the transmit state. This can have two reasons:

1. The module does CCA first (Clear Channel Assessment). If CCA fails (i.e. the channel is in use), then the module statys in Rx.

2. Your module behaves differently than mine

3. The module is broken

Which CC1101 module are you using?

I found my mistake. I didn´t know that you have to connect VCC and GND too. Very obvious know that I know it, but for a first timer. I just did what you wrote in the yaml. I can capture packets now. But because of the meshing, I don´t know the right adress and channel yet.

andyboeh commented 1 week ago

That's a good one :) VCC and GND is so obvious that I did not explicitly state that.

Hufenbacke commented 1 week ago

That's a good one :) VCC and GND is so obvious that I did not explicitly state that.

Just to let you know. I got everything working. Maybe I will come back with a more specific question, if one arises at a later date, but for know, I am going to enjoy moving eleros up and down through HA. Thanks for your help!