GDO blaQ - sometimes garage door will not move when commanded

user107 · April 7, 2024, 11:19pm

I don’t see a full failure of the up/down buttons, but after a day of not interacting through the HA interface my first press of the up button yielded nothing (no lights, no audible, no door movement)…. SECOND press of the up button (and all other tests that followed) worked perfectly fine…

Oral_Allen · April 7, 2024, 11:55pm

I seem to be having sporadic issues also now I’ve rewired using the pass through and it makes the audible alert but doesn’t close the garage door…it’s very sporadic.
Show quoted text

user107 · April 8, 2024, 12:34am

wifi signal level currently good?

Oral_Allen · April 8, 2024, 12:52am

Yup

nate · April 8, 2024, 1:30pm

@Oral_Allen @user107 if you could please post some logs from the device when you’re experiencing inconsistencies like this, it would be really helpful. If you’re using ESPHome dashboard you can click the Logs button to stream the ESPHome device logs and download them. Or, open the web-page of the device on your local network and the logs will stream in the right-hand panel.

Oral_Allen · April 8, 2024, 3:41pm

I received an error when I tried to view the logs from ESP Home View Logs for the device:

INFO ESPHome 2024.3.2
INFO Reading configuration /config/esphome/konnected-9c42f8.yaml…
INFO Updating https://github.com/konnected-io/konnected-esphome@None
WARNING GPIO3 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 Frequently Asked Questions — ESPHome
INFO Starting log output from 192.168.1.253 using esphome API
INFO Successfully connected to konnected-9c42f8 @ 192.168.1.253 in 0.118s
WARNING konnected-9c42f8 @ 192.168.1.253: Connection error occurred: konnected-9c42f8 @ 192.168.1.253: The connection dropped immediately after encrypted hello; Try enabling encryption on the device or turning off encryption on the client (ESPHome Logs 2024.3.2).
WARNING Can’t connect to ESPHome API for konnected-9c42f8 @ 192.168.1.253: konnected-9c42f8 @ 192.168.1.253: The connection dropped immediately after encrypted hello; Try enabling encryption on the device or turning off encryption on the client (ESPHome Logs 2024.3.2). (HandshakeAPIError)
INFO Trying to connect to konnected-9c42f8 @ 192.168.1.253 in the background

Via the local integration here is what I got. Note the garage door does not close. I was able to open after clicking on Open 3 times.

Closing from the .local integration works everytime:

Now that I’ve interacted via the .local the Home Assistant Integration works without issue.

Time	level	Tag	Message
10:38:31	[I]	[secplus_gdo:061]	Door: Closing, 21%, target: 0%
10:38:31	[D]	[cover:170]	‘garage_door’ - Publishing:
10:38:31	[D]	[cover:173]	Position: 21%
10:38:31	[D]	[cover:186]	Current Operation: CLOSING
10:38:32	[I]	[secplus_gdo:061]	Door: Closing, 17%, target: 0%
10:38:32	[D]	[cover:170]	‘garage_door’ - Publishing:
10:38:32	[D]	[cover:173]	Position: 17%
10:38:32	[D]	[cover:186]	Current Operation: CLOSING
10:38:33	[I]	[secplus_gdo:061]	Door: Closing, 13%, target: 0%
10:38:33	[D]	[cover:170]	‘garage_door’ - Publishing:
10:38:33	[D]	[cover:173]	Position: 13%
10:38:33	[D]	[cover:186]	Current Operation: CLOSING
10:38:33	[I]	[secplus_gdo:061]	Door: Closing, 9%, target: 0%
10:38:33	[D]	[cover:170]	‘garage_door’ - Publishing:
10:38:33	[D]	[cover:173]	Position: 9%
10:38:33	[D]	[cover:186]	Current Operation: CLOSING
10:38:34	[I]	[secplus_gdo:061]	Door: Closing, 5%, target: 0%
10:38:34	[D]	[cover:170]	‘garage_door’ - Publishing:
10:38:34	[D]	[cover:173]	Position: 5%
10:38:34	[D]	[cover:186]	Current Operation: CLOSING
10:38:34	[I]	[secplus_gdo:061]	Door: Closing, 1%, target: 0%
10:38:34	[D]	[cover:170]	‘garage_door’ - Publishing:
10:38:34	[D]	[cover:173]	Position: 1%
10:38:34	[D]	[cover:186]	Current Operation: CLOSING
10:38:34	[I]	[secplus_gdo:061]	Door: Closing, 0%, target: 0%
10:38:34	[D]	[cover:170]	‘garage_door’ - Publishing:
10:38:34	[D]	[cover:173]	Position: 0%
10:38:34	[D]	[cover:186]	Current Operation: CLOSING
10:38:35	[V]	[esp-idf:000]	D (57699282) gdolib: RX packet size 20, pending: 1
10:38:35	[V]	[esp-idf:000]	e[0;32mI (57699285) gdolib: RX: [55 01 00 26 0C 60 A4 D5 74 36 B3 08 10 92 47 2C 30 0D 05]
10:38:35	[V]	[esp-idf:000]	e[0;32mI (57699286) gdolib: received rolling=0017d76 fixed=40761c200a data=42600281
10:38:35	[V]	[esp-idf:000]	e[0;32mI (57699287) gdolib: cmd=081 (STATUS) byte2=42 byte1=60 nibble=2
10:38:35	[V]	[esp-idf:000]	D (57699300) gdolib: Door state: Closed
10:38:35	[V]	[esp-idf:000]	e[0;32mI (57699301) gdolib: TX: [55 01 00 02 09 2C F2 CB 24 92 59 86 39 3E B3 FA A9 2E 6F]
10:38:35	[V]	[esp-idf:000]	D (57699310) gdolib: Light state: On
10:38:35	[V]	[esp-idf:000]	D (57699312) gdolib: Lock state: Unlocked
10:38:35	[V]	[esp-idf:000]	D (57699320) gdolib: Learn state: Active
10:38:35	[V]	[esp-idf:000]	D (57699331) gdolib: Obstruction state: Clear
10:38:35	[V]	[esp-idf:000]	D (57699363) gdolib: Sent command: GET_OPENINGS
10:38:35	[I]	[secplus_gdo:061]	Door: Closed, 0%, target: 0%
10:38:35	[D]	[cover:170]	‘garage_door’ - Publishing:
10:38:35	[D]	[cover:173]	Position: 0%
10:38:35	[D]	[cover:186]	Current Operation: IDLE
10:38:35	[D]	[binary_sensor:036]	‘Garage Door Motor’: Sending state OFF
10:38:35	[V]	[esp-idf:000]	D (57699477) gdolib: RX packet size 20, pending: 1
10:38:35	[V]	[esp-idf:000]	e[0;32mI (57699478) gdolib: RX: [55 01 00 25 3B BF 8B 23 B7 13 2E A9 2C 04 1C 11 E2 86 81]
10:38:35	[V]	[esp-idf:000]	e[0;32mI (57699480) gdolib: received rolling=0017d77 fixed=44761c200a data=1821008c
10:38:35	[V]	[esp-idf:000]	e[0;32mI (57699481) gdolib: cmd=48c (OPENINGS) byte2=18 byte1=21 nibble=0
10:38:35	[V]	[esp-idf:000]	D (57699495) gdolib: Openings: 8472
10:38:35	[I]	[secplus_gdo:091]	Openings: 8472

Oral_Allen · April 8, 2024, 3:50pm

Here is a log from a failed close attempt using Home Assistant. Open worked just fine:

Time	level	Tag	Message
10:48:59	[D]	[cover:076]	‘garage_door’ - Setting
10:48:59	[D]	[cover:084]	Position: 0%
10:48:59	[D]	[button:010]	‘Pre-close Warning’ Pressed.
10:48:59	[D]	[light:036]	‘warning_led’ Setting:
10:48:59	[D]	[light:047]	State: ON
10:48:59	[D]	[light:109]	Effect: ‘Strobe’
10:48:59	[D]	[button:010]	‘Play sound’ Pressed.
10:48:59	[D]	[rtttl:051]	Playing song ominous
10:48:59	[D]	[cover:170]	‘garage_door’ - Publishing:
10:48:59	[D]	[cover:173]	Position: 100%
10:48:59	[D]	[cover:186]	Current Operation: CLOSING
10:49:02	[V]	[esp-idf:000]	D (58325771) gdolib: RX packet size 20, pending: 1
10:49:02	[V]	[esp-idf:000]	e[0;32mI (58325775) gdolib: RX: [55 01 00 61 13 38 03 B1 5B 24 96 08 03 40 4B 46 20 0D 65]
10:49:02	[V]	[esp-idf:000]	e[0;32mI (58325777) gdolib: received rolling=0004427 fixed=624b9f890c data=00000085
10:49:02	[V]	[esp-idf:000]	e[0;32mI (58325778) gdolib: cmd=285 (MOTION) byte2=00 byte1=00 nibble=0
10:49:02	[V]	[esp-idf:000]	D (58325789) gdolib: Motion state: Detected
10:49:02	[I]	[secplus_gdo:076]	Motion: Detected
10:49:02	[D]	[binary_sensor:036]	‘Garage Motion Sensor’: Sending state ON
10:49:03	[D]	[rtttl:176]	Playback finished
10:49:04	[D]	[light:036]	‘warning_led’ Setting:
10:49:04	[D]	[light:047]	State: OFF
10:49:04	[D]	[light:109]	Effect: ‘None’
10:49:04	[D]	[light:036]	‘warning_led’ Setting:
10:49:04	[V]	[esp-idf:000]	e[0;32mI (58327872) gdolib: TX: [55 01 00 6A 29 A6 D8 6D A4 D3 4E 45 0F AC FA 4C 1E 5B EF]
10:49:04	[V]	[esp-idf:000]	e[0;32mI (58327874) gdolib: TX: [55 01 00 6A 29 A6 D8 6D A4 D3 4C 45 0F AC FA 4C 1E 4B EF]
10:49:04	[V]	[esp-idf:000]	D (58327896) gdolib: Sent command: DOOR_ACTION
10:49:04	[V]	[esp-idf:000]	D (58327919) gdolib: Sent command: DOOR_ACTION
10:49:05	[V]	[esp-idf:000]	D (58328800) gdolib: Motion state: Clear
10:49:05	[I]	[secplus_gdo:076]	Motion: Clear
10:49:05	[D]	[binary_sensor:036]	‘Garage Motion Sensor’: Sending state OFF
10:49:07	[V]	[esp-idf:000]	D (58330712) gdolib: RX packet size 20, pending: 1
10:49:07	[V]	[esp-idf:000]	e[0;32mI (58330716) gdolib: RX: [55 01 00 61 13 38 03 B1 5B 24 96 08 03 40 4B 46 20 0D 65]
10:49:07	[V]	[esp-idf:000]	e[0;32mI (58330718) gdolib: received rolling=0004427 fixed=624b9f890c data=00000085
10:49:07	[V]	[esp-idf:000]	e[0;32mI (58330720) gdolib: cmd=285 (MOTION) byte2=00 byte1=00 nibble=0
10:49:07	[V]	[esp-idf:000]	D (58330731) gdolib: Motion state: Detected
10:49:07	[I]	[secplus_gdo:076]	Motion: Detected
10:49:07	[D]	[binary_sensor:036]	‘Garage Motion Sensor’: Sending state ON
10:49:10	[V]	[esp-idf:000]	D (58333732) gdolib: Motion state: Clear
10:49:10	[I]	[secplus_gdo:076]	Motion: Clear
10:49:10	[D]	[binary_sensor:036]	‘Garage Motion Sensor’: Sending state OFF
10:49:11	[V]	[esp-idf:000]	D (58335652) gdolib: RX packet size 20, pending: 1
10:49:11	[V]	[esp-idf:000]	e[0;32mI (58335655) gdolib: RX: [55 01 00 61 13 38 03 B1 5B 24 96 08 03 40 4B 46 20 0D 65]
10:49:11	[V]	[esp-idf:000]	e[0;32mI (58335656) gdolib: received rolling=0004427 fixed=624b9f890c data=00000085
10:49:11	[V]	[esp-idf:000]	e[0;32mI (58335658) gdolib: cmd=285 (MOTION) byte2=00 byte1=00 nibble=0
10:49:11	[V]	[esp-idf:000]	D (58335671) gdolib: Motion state: Detected
10:49:11	[I]	[secplus_gdo:076]	Motion: Detected
10:49:11	[D]	[binary_sensor:036]	‘Garage Motion Sensor’: Sending state ON
10:49:14	[V]	[esp-idf:000]	D (58338672) gdolib: Motion state: Clear
10:49:14	[I]	[secplus_gdo:076]	Motion: Clear
10:49:14	[D]	[binary_sensor:036]	‘Garage Motion Sensor’: Sending state OFF

Oral_Allen · April 8, 2024, 3:51pm

This is the app after the failed closing attempt:

user107 · April 8, 2024, 7:13pm

I can concur that when up/down buttons fail (after audible alert) the only button available was stop even though door never moved… was leaving house for eclipse, so unable to debug yet, but should be able to recreate later… reboot from webpage got things working again…

scelfo · April 8, 2024, 7:41pm

Same for me re: only button available is stop if the down arrow doesn’t work (after audible alert). When this has happened to me, clicking on the name “garage_door” to the left of the up/stop/down buttons brings up a cover slider and I’m able to slide to 0% to close the door.

I’ll try to grab logs if this happens again.

scelfo · April 8, 2024, 7:43pm

I also see the Connection error occurred: konnected-9c4440 @ 192.168.3.143: The connection dropped immediately after encrypted hello; Try enabling encryption on the device or turning off encryption on the client (ESPHome Logs 2024.3.2). error when trying to stream logs through ESPHome.

Long term, I’d like to disable the self hosted webserver on device_hostname.local so there isn’t an open http server on my network that can open my garage door.

nate · April 8, 2024, 8:33pm

Thanks for the logs and detail. One thing that we noticed in the log that @Oral_Allen posted is that it looks like the garage close command is getting called twice:

Not sure why this is happening but it may be related and we are looking into it.

I think when you see that the open/close buttons are disabled in HA and only the stop command is available, it’s because the garage door state in HA is “OPENING” or “CLOSING” but if the door doesn’t actually move, it never gets to the fully “OPEN” or “CLOSED” state. In any case we are looking into this to determine if the double-command is part of the problem.

For those of you getting the API encryption error when trying to connect in ESPHome dashboard, remove the encryption_key: variable from your local configuration YAML and try again. This is added by HA automatically, and if the firmware is not updated after adopting, it will not be able to connect with encryption.

@Oral_Allen @user107 @scelfo can you tell me what model garage opener you have and if it has a round yellow learn button or another color?

nate · April 8, 2024, 9:03pm

@Oral_Allen @user107 @scelfo we also would like to know what type of wall button you have, and if it has a built-in motion sensor. Pics would be great.

user107 · April 8, 2024, 10:10pm

From earlier post:

Chamberlain MyQ Ready B503 (paired with Chamberlain myQ+Wifi B550), yellow round learn button

No motion sensor

Oral_Allen · April 8, 2024, 10:34pm

Both of my units are Liftmaster Model 1d8088
Yellow Learn button

Wall button does have a motion sensor

Oral_Allen · April 8, 2024, 10:42pm

@nate

Removing the encryption key did fix the log issue. I have included a fresh log. I had to hit the open command once it does show the device calling the open command two times, the door didn’t open. Hitting the open a second time does show two open commands being sent but this time the door did open. The close function sends two commands but did close on this attempt.

INFO ESPHome 2024.3.2
INFO Reading configuration /config/esphome/konnected-9c42f8.yaml…
INFO Updating https://github.com/konnected-io/konnected-esphome@None
WARNING GPIO3 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 Frequently Asked Questions — ESPHome
INFO Starting log output from 192.168.1.253 using esphome API
INFO Successfully connected to konnected-9c42f8 @ 192.168.1.253 in 0.171s
INFO Successful handshake with konnected-9c42f8 @ 192.168.1.253 in 0.027s
[17:37:56][I][app:102]: ESPHome version 2024.3.0 compiled on Mar 27 2024, 01:30:00
[17:37:56][I][app:104]: Project konnected.garage-door-gdov2-q version 0.1.1
[17:37:56][C][status_led:065]: Status Led Light:
[17:37:56][C][status_led:066]: Pin: GPIO18
[17:37:56][C][wifi:580]: WiFi:
[17:37:56][C][wifi:408]: Local MAC: F4:12:FA:9C:42:F8
[17:37:56][C][wifi:413]: SSID: ‘…::Predator::…’[redacted]
[17:37:56][C][wifi:416]: IP Address: 192.168.1.253
[17:37:56][C][wifi:420]: BSSID: BC:DF:58:D4:FD:C8[redacted]
[17:37:56][C][wifi:421]: Hostname: ‘konnected-9c42f8’
[17:37:56][C][wifi:423]: Signal strength: -57 dB ▂▄▆█
[17:37:56][V][wifi:425]: Priority: -1.0
[17:37:56][C][wifi:427]: Channel: 6
[17:37:56][C][wifi:428]: Subnet: 255.255.255.0
[17:37:56][C][wifi:429]: Gateway: 192.168.1.1
[17:37:56][C][wifi:430]: DNS1: 192.168.1.1
[17:37:56][C][logger:166]: Logger:
[17:37:56][C][logger:167]: Level: VERBOSE
[17:37:56][C][logger:169]: Log Baud Rate: 115200
[17:37:56][C][logger:170]: Hardware UART: UART0
[17:37:56][C][logger:174]: Level for ‘ledc.output’: INFO
[17:37:56][C][logger:174]: Level for ‘vl53l0x’: DEBUG
[17:37:56][C][logger:174]: Level for ‘sensor’: INFO
[17:37:57][C][logger:174]: Level for ‘json’: INFO
[17:37:57][C][logger:174]: Level for ‘api’: DEBUG
[17:37:57][C][template.text_sensor:020]: Template Sensor ‘Device ID’
[17:37:57][C][uptime.sensor:031]: Uptime Sensor ‘Uptime’
[17:37:57][C][uptime.sensor:031]: Device Class: ‘duration’
[17:37:57][C][uptime.sensor:031]: State Class: ‘total_increasing’
[17:37:57][C][uptime.sensor:031]: Unit of Measurement: ‘s’
[17:37:57][C][uptime.sensor:031]: Accuracy Decimals: 0
[17:37:57][C][uptime.sensor:031]: Icon: ‘mdi:timer-outline’
[17:37:57][V][uptime.sensor:031]: Unique ID: ‘f412fa9c42f8-uptime’
[17:37:57][C][gpio.output:010]: GPIO Binary Output:
[17:37:57][C][gpio.output:011]: Pin: GPIO3
[17:37:57][C][light:103]: Light ‘warning_led’
[17:37:57][C][light:103]: Light ‘blue_status_led’
[17:37:57][C][light:103]: Light ‘garage_light’
[17:37:57][C][copy.sensor:015]: Copy Sensor ‘WiFi Signal %’
[17:37:57][C][copy.sensor:015]: Device Class: ‘signal_strength’
[17:37:57][C][copy.sensor:015]: State Class: ‘measurement’
[17:37:57][C][copy.sensor:015]: Unit of Measurement: ‘%’
[17:37:57][C][copy.sensor:015]: Accuracy Decimals: 0
[17:37:57][C][restart.button:017]: Restart Button ‘Restart’
[17:37:57][C][factory_reset.button:011]: Factory Reset Button ‘Factory Reset’
[17:37:57][C][factory_reset.button:011]: Icon: ‘mdi:restart-alert’
[17:37:57][C][rtttl:029]: Rtttl
[17:37:57][C][esp32_ble:374]: ESP32 BLE:
[17:37:57][C][esp32_ble:376]: MAC address: F4:12:FA:9C:42:FA
[17:37:57][C][esp32_ble:377]: IO Capability: none
[17:37:57][C][esp32_ble_server:200]: ESP32 BLE Server:
[17:37:57][C][esp32_improv.component:261]: ESP32 Improv:
[17:37:57][C][esp32_improv.component:266]: Status Indicator: ‘NO’
[17:37:57][C][captive_portal:088]: Captive Portal:
[17:37:57][C][web_server:169]: Web Server:
[17:37:57][C][web_server:170]: Address: konnected.local:80
[17:37:57][C][mdns:144]: mDNS:
[17:37:57][C][mdns:145]: Hostname: konnected-9c42f8
[17:37:57][V][mdns:146]: Services:
[17:37:57][V][mdns:148]: - _konnected, _tcp, 80
[17:37:57][V][mdns:150]: TXT: friendly_name = GDO blaQ 9c42f8
[17:37:57][V][mdns:150]: TXT: esphome_version = 2024.3.0
[17:37:57][V][mdns:150]: TXT: mac = f412fa9c42f8
[17:37:57][V][mdns:148]: - _esphomelib, _tcp, 6053
[17:37:57][V][mdns:150]: TXT: friendly_name = GDO blaQ 9c42f8
[17:37:57][V][mdns:150]: TXT: version = 2024.3.0
[17:37:57][V][mdns:150]: TXT: mac = f412fa9c42f8
[17:37:57][V][mdns:150]: TXT: platform = ESP32
[17:37:57][V][mdns:150]: TXT: board = esp32-s3-devkitc-1
[17:37:57][V][mdns:150]: TXT: network = wifi
[17:37:57][V][mdns:150]: TXT: project_name = konnected.garage-door-gdov2-q
[17:37:57][V][mdns:150]: TXT: project_version = 0.1.1
[17:37:57][V][mdns:150]: TXT: package_import_url = github://konnected-io/konnected-esphome/garage-door-GDOv2-Q.yaml@master
[17:37:57][V][mdns:148]: - _http, _tcp, 80
[17:37:57][C][ota:096]: Over-The-Air Updates:
[17:37:57][C][ota:097]: Address: konnected.local:3232
[17:37:57][C][ota:103]: OTA version: 2.
[17:37:57][C][api:139]: API Server:
[17:37:57][C][api:140]: Address: konnected.local:6053
[17:37:57][C][api:144]: Using noise encryption: NO
[17:37:57][C][wifi_info:009]: WifiInfo IPAddress ‘IP Address’
[17:37:57][V][wifi_info:009]: Unique ID: ‘f412fa9c42f8-wifiinfo-ip’
[17:37:57][C][wifi_signal.sensor:009]: WiFi Signal ‘WiFi Signal RSSI’
[17:37:57][C][wifi_signal.sensor:009]: Device Class: ‘signal_strength’
[17:37:57][C][wifi_signal.sensor:009]: State Class: ‘measurement’
[17:37:57][C][wifi_signal.sensor:009]: Unit of Measurement: ‘dBm’
[17:37:57][C][wifi_signal.sensor:009]: Accuracy Decimals: 0
[17:37:57][V][wifi_signal.sensor:009]: Unique ID: ‘f412fa9c42f8-wifisignal’
[17:37:57][C][improv_serial:032]: Improv Serial:
[17:37:57][C][secplus_gdo:133]: Setting up secplus GDO …
[17:38:16][D][cover:076]: ‘garage_door’ - Setting
[17:38:16][D][cover:084]: Position: 100%
[17:38:16][V][esp-idf:000]: I (82880027) gdolib: TX: [55 01 00 22 01 24 18 48 24 12 47 AA 35 BF CB B8 54 19 61]

[17:38:16][V][esp-idf:000]: I (82880030) gdolib: TX: [55 01 00 22 01 24 18 48 24 12 45 AA 35 BF CB B8 54 59 61]

[17:38:16][V][esp-idf:000]: D (82880052) gdolib: Sent command: DOOR_ACTION

[17:38:16][V][esp-idf:000]: D (82880075) gdolib: Sent command: DOOR_ACTION

[17:38:36][D][cover:076]: ‘garage_door’ - Setting
[17:38:36][D][cover:084]: Position: 100%
[17:38:36][V][esp-idf:000]: I (82899287) gdolib: TX: [55 01 00 01 12 48 2C 92 49 24 95 99 30 19 41 91 E0 D8 05]

[17:38:36][V][esp-idf:000]: I (82899289) gdolib: TX: [55 01 00 01 12 48 2C 92 49 24 94 99 30 19 41 91 E0 C8 05]

[17:38:36][V][esp-idf:000]: D (82899311) gdolib: Sent command: DOOR_ACTION

[17:38:36][V][esp-idf:000]: D (82899334) gdolib: Sent command: DOOR_ACTION

[17:38:37][V][esp-idf:000]: D (82900623) gdolib: RX packet size 20, pending: 1

[17:38:37][V][esp-idf:000]: I (82900625) gdolib: RX: [55 01 00 55 0B A0 59 63 A8 CB 3C 09 34 41 0A 08 B0 45 03]

[17:38:37][V][esp-idf:000]: I (82900626) gdolib: received rolling=0017d9e fixed=40761c200a data=42600481

[17:38:37][V][esp-idf:000]: I (82900628) gdolib: cmd=081 (STATUS) byte2=42 byte1=60 nibble=4

[17:38:37][V][esp-idf:000]: D (82900641) gdolib: Door state: Opening

[17:38:37][V][esp-idf:000]: D (82900642) gdolib: Light state: On

[17:38:37][V][esp-idf:000]: D (82900651) gdolib: Lock state: Unlocked

[17:38:37][V][esp-idf:000]: D (82900652) gdolib: Learn state: Active

[17:38:37][V][esp-idf:000]: D (82900661) gdolib: Obstruction state: Clear

[17:38:37][I][secplus_gdo:061]: Door: Opening, 0%, target: 100%
[17:38:37][D][cover:170]: ‘garage_door’ - Publishing:
[17:38:37][D][cover:173]: Position: 0%
[17:38:37][D][cover:186]: Current Operation: OPENING
[17:38:38][I][secplus_gdo:061]: Door: Opening, 15%, target: 100%
[17:38:38][D][cover:170]: ‘garage_door’ - Publishing:
[17:38:38][D][cover:173]: Position: 15%
[17:38:38][D][cover:186]: Current Operation: OPENING
[17:38:38][I][secplus_gdo:061]: Door: Opening, 20%, target: 100%
[17:38:38][D][cover:170]: ‘garage_door’ - Publishing:
[17:38:38][D][cover:173]: Position: 20%
[17:38:38][D][cover:186]: Current Operation: OPENING
[17:38:38][V][esp-idf:000]: D (82901983) gdolib: RX packet size 20, pending: 1

[17:38:38][V][esp-idf:000]: I (82901985) gdolib: RX: [55 01 00 55 0B A0 5D 63 B2 CB 2C 09 34 41 0A 08 B2 04 42]

[17:38:38][V][esp-idf:000]: I (82901986) gdolib: received rolling=0017d9e fixed=42761c200a data=00000084

[17:38:38][V][esp-idf:000]: I (82901988) gdolib: cmd=284 (MOTOR_ON) byte2=00 byte1=00 nibble=0

[17:38:38][V][esp-idf:000]: D (82902001) gdolib: Motor state: On

[17:38:38][I][secplus_gdo:087]: Motor: On
[17:38:38][D][binary_sensor:036]: ‘Garage Door Motor’: Sending state ON
[17:38:39][I][secplus_gdo:061]: Door: Opening, 25%, target: 100%
[17:38:39][D][cover:170]: ‘garage_door’ - Publishing:
[17:38:39][D][cover:173]: Position: 25%
[17:38:39][D][cover:186]: Current Operation: OPENING
[17:38:39][I][secplus_gdo:061]: Door: Opening, 30%, target: 100%
[17:38:39][D][cover:170]: ‘garage_door’ - Publishing:
[17:38:39][D][cover:173]: Position: 30%
[17:38:39][D][cover:186]: Current Operation: OPENING
[17:38:40][I][secplus_gdo:061]: Door: Opening, 34%, target: 100%
[17:38:40][D][cover:170]: ‘garage_door’ - Publishing:
[17:38:40][D][cover:173]: Position: 34%
[17:38:40][D][cover:186]: Current Operation: OPENING
[17:38:40][V][esp-idf:000]: D (82903613) gdolib: RX packet size 20, pending: 1

[17:38:40][V][esp-idf:000]: I (82903615) gdolib: RX: [55 01 00 55 0B A0 5D 63 B2 CB 2C 09 34 41 0A 08 B2 04 42]

[17:38:40][V][esp-idf:000]: I (82903617) gdolib: received rolling=0017d9e fixed=42761c200a data=00000084

[17:38:40][V][esp-idf:000]: I (82903618) gdolib: cmd=284 (MOTOR_ON) byte2=00 byte1=00 nibble=0

[17:38:40][V][esp-idf:000]: D (82903631) gdolib: Motor state: On

[17:38:40][I][secplus_gdo:061]: Door: Opening, 39%, target: 100%
[17:38:40][D][cover:170]: ‘garage_door’ - Publishing:
[17:38:40][D][cover:173]: Position: 39%
[17:38:40][D][cover:186]: Current Operation: OPENING
[17:38:41][I][secplus_gdo:061]: Door: Opening, 44%, target: 100%
[17:38:41][D][cover:170]: ‘garage_door’ - Publishing:
[17:38:41][D][cover:173]: Position: 44%
[17:38:41][D][cover:186]: Current Operation: OPENING
[17:38:41][I][secplus_gdo:061]: Door: Opening, 49%, target: 100%
[17:38:41][D][cover:170]: ‘garage_door’ - Publishing:
[17:38:41][D][cover:173]: Position: 49%
[17:38:41][D][cover:186]: Current Operation: OPENING
[17:38:42][I][secplus_gdo:061]: Door: Opening, 54%, target: 100%
[17:38:42][D][cover:170]: ‘garage_door’ - Publishing:
[17:38:42][D][cover:173]: Position: 54%
[17:38:42][D][cover:186]: Current Operation: OPENING
[17:38:42][I][secplus_gdo:061]: Door: Opening, 59%, target: 100%
[17:38:42][D][cover:170]: ‘garage_door’ - Publishing:
[17:38:42][D][cover:173]: Position: 59%
[17:38:42][D][cover:186]: Current Operation: OPENING
[17:38:43][I][secplus_gdo:061]: Door: Opening, 64%, target: 100%
[17:38:43][D][cover:170]: ‘garage_door’ - Publishing:
[17:38:43][D][cover:173]: Position: 64%
[17:38:43][D][cover:186]: Current Operation: OPENING
[17:38:43][I][secplus_gdo:061]: Door: Opening, 69%, target: 100%
[17:38:43][D][cover:170]: ‘garage_door’ - Publishing:
[17:38:43][D][cover:173]: Position: 69%
[17:38:43][D][cover:186]: Current Operation: OPENING
[17:38:43][V][esp-idf:000]: D (82906866) gdolib: RX packet size 20, pending: 1

[17:38:43][V][esp-idf:000]: I (82906867) gdolib: RX: [55 01 00 55 0B A0 5D 63 B2 CB 2C 09 34 41 0A 08 B2 04 42]

[17:38:43][V][esp-idf:000]: I (82906869) gdolib: received rolling=0017d9e fixed=42761c200a data=00000084

[17:38:43][V][esp-idf:000]: I (82906872) gdolib: cmd=284 (MOTOR_ON) byte2=00 byte1=00 nibble=0

[17:38:43][V][esp-idf:000]: D (82906884) gdolib: Motor state: On

[17:38:44][I][secplus_gdo:061]: Door: Opening, 74%, target: 100%
[17:38:44][D][cover:170]: ‘garage_door’ - Publishing:
[17:38:44][D][cover:173]: Position: 74%
[17:38:44][D][cover:186]: Current Operation: OPENING
[17:38:44][I][secplus_gdo:061]: Door: Opening, 79%, target: 100%
[17:38:44][D][cover:170]: ‘garage_door’ - Publishing:
[17:38:44][D][cover:173]: Position: 79%
[17:38:44][D][cover:186]: Current Operation: OPENING
[17:38:45][I][secplus_gdo:061]: Door: Opening, 84%, target: 100%
[17:38:45][D][cover:170]: ‘garage_door’ - Publishing:
[17:38:45][D][cover:173]: Position: 84%
[17:38:45][D][cover:186]: Current Operation: OPENING
[17:38:45][I][secplus_gdo:061]: Door: Opening, 89%, target: 100%
[17:38:45][D][cover:170]: ‘garage_door’ - Publishing:
[17:38:45][D][cover:173]: Position: 89%
[17:38:45][D][cover:186]: Current Operation: OPENING
[17:38:46][I][secplus_gdo:061]: Door: Opening, 93%, target: 100%
[17:38:46][D][cover:170]: ‘garage_door’ - Publishing:
[17:38:46][D][cover:173]: Position: 93%
[17:38:46][D][cover:186]: Current Operation: OPENING
[17:38:46][I][secplus_gdo:061]: Door: Opening, 98%, target: 100%
[17:38:46][D][cover:170]: ‘garage_door’ - Publishing:
[17:38:46][D][cover:173]: Position: 98%
[17:38:46][D][cover:186]: Current Operation: OPENING
[17:38:47][I][secplus_gdo:061]: Door: Opening, 100%, target: 100%
[17:38:47][D][cover:170]: ‘garage_door’ - Publishing:
[17:38:47][D][cover:173]: Position: 100%
[17:38:47][D][cover:186]: Current Operation: OPENING
[17:38:47][V][esp-idf:000]: D (82910925) gdolib: RX packet size 20, pending: 1

[17:38:47][V][esp-idf:000]: I (82910927) gdolib: RX: [55 01 00 55 0B A0 5D 63 B2 CB 2C 09 34 41 0A 08 B2 04 42]

[17:38:47][V][esp-idf:000]: I (82910928) gdolib: received rolling=0017d9e fixed=42761c200a data=00000084

[17:38:47][V][esp-idf:000]: I (82910930) gdolib: cmd=284 (MOTOR_ON) byte2=00 byte1=00 nibble=0

[17:38:47][V][esp-idf:000]: D (82910944) gdolib: Motor state: On

[17:38:49][V][esp-idf:000]: D (82912690) gdolib: RX packet size 20, pending: 1

[17:38:49][V][esp-idf:000]: I (82912692) gdolib: RX: [55 01 00 54 11 ED 7F B9 E1 EF AF AA 09 B6 57 75 56 59 63]

[17:38:49][V][esp-idf:000]: I (82912694) gdolib: received rolling=0017d9f fixed=40761c200a data=42600181

[17:38:49][V][esp-idf:000]: I (82912695) gdolib: cmd=081 (STATUS) byte2=42 byte1=60 nibble=1

[17:38:49][V][esp-idf:000]: D (82912708) gdolib: Door state: Open

[17:38:49][V][esp-idf:000]: D (82912709) gdolib: Light state: On

[17:38:49][V][esp-idf:000]: D (82912718) gdolib: Lock state: Unlocked

[17:38:49][V][esp-idf:000]: D (82912720) gdolib: Learn state: Active

[17:38:49][V][esp-idf:000]: D (82912729) gdolib: Obstruction state: Clear

[17:38:49][I][secplus_gdo:061]: Door: Open, 100%, target: 100%
[17:38:49][D][cover:170]: ‘garage_door’ - Publishing:
[17:38:49][D][cover:173]: Position: 100%
[17:38:49][D][cover:186]: Current Operation: IDLE
[17:38:49][D][binary_sensor:036]: ‘Garage Door Motor’: Sending state OFF
[17:38:56][D][cover:076]: ‘garage_door’ - Setting
[17:38:56][D][cover:084]: Position: 0%
[17:38:56][D][button:010]: ‘Pre-close Warning’ Pressed.
[17:38:56][D][light:036]: ‘warning_led’ Setting:
[17:38:56][D][light:047]: State: ON
[17:38:56][D][light:109]: Effect: ‘Strobe’
[17:38:56][D][button:010]: ‘Play sound’ Pressed.
[17:38:56][D][rtttl:051]: Playing song ominous
[17:38:56][D][cover:170]: ‘garage_door’ - Publishing:
[17:38:56][D][cover:173]: Position: 100%
[17:38:56][D][cover:186]: Current Operation: CLOSING
[17:39:00][D][rtttl:176]: Playback finished
[17:39:01][D][light:036]: ‘warning_led’ Setting:
[17:39:01][D][light:047]: State: OFF
[17:39:01][D][light:109]: Effect: ‘None’
[17:39:01][D][light:036]: ‘warning_led’ Setting:
[17:39:01][V][esp-idf:000]: I (82924702) gdolib: TX: [55 01 00 00 34 9A 65 B6 DB 6D B3 8A 1D E4 FA CE 56 5F 7D]

[17:39:01][V][esp-idf:000]: I (82924705) gdolib: TX: [55 01 00 00 34 9A 65 B6 DB 6D B2 8A 1D E4 FA CE 56 4F 7D]

[17:39:01][V][esp-idf:000]: D (82924726) gdolib: Sent command: DOOR_ACTION

[17:39:01][V][esp-idf:000]: D (82924749) gdolib: Sent command: DOOR_ACTION

[17:39:02][V][esp-idf:000]: D (82925736) gdolib: RX packet size 20, pending: 1

[17:39:02][V][esp-idf:000]: I (82925738) gdolib: RX: [55 01 00 54 11 ED 7B B9 FB EF BF AA 09 B6 57 75 44 59 E5]

[17:39:02][V][esp-idf:000]: I (82925739) gdolib: received rolling=0017d9f fixed=42761c200a data=00000084

[17:39:02][V][esp-idf:000]: I (82925741) gdolib: cmd=284 (MOTOR_ON) byte2=00 byte1=00 nibble=0

[17:39:02][V][esp-idf:000]: D (82925754) gdolib: Motor state: On

[17:39:02][I][secplus_gdo:087]: Motor: On
[17:39:02][D][binary_sensor:036]: ‘Garage Door Motor’: Sending state ON
[17:39:02][V][esp-idf:000]: D (82925863) gdolib: RX packet size 20, pending: 1

[17:39:02][V][esp-idf:000]: I (82925864) gdolib: RX: [55 01 00 0A 22 B2 5B 68 A2 5F 5D 02 2D 2C 9C 41 94 93 5C]

[17:39:02][V][esp-idf:000]: I (82925866) gdolib: received rolling=0017da0 fixed=40761c200a data=42600581

[17:39:02][V][esp-idf:000]: I (82925867) gdolib: cmd=081 (STATUS) byte2=42 byte1=60 nibble=5

[17:39:02][V][esp-idf:000]: D (82925871) gdolib: Door state: Closing

[17:39:02][V][esp-idf:000]: D (82925881) gdolib: Light state: On

[17:39:02][V][esp-idf:000]: D (82925891) gdolib: Lock state: Unlocked

[17:39:02][V][esp-idf:000]: D (82925893) gdolib: Learn state: Active

[17:39:02][V][esp-idf:000]: D (82925901) gdolib: Obstruction state: Clear

[17:39:02][I][secplus_gdo:061]: Door: Closing, 100%, target: 0%
[17:39:02][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:02][D][cover:173]: Position: 100%
[17:39:02][D][cover:186]: Current Operation: CLOSING
[17:39:03][I][secplus_gdo:061]: Door: Closing, 88%, target: 0%
[17:39:03][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:03][D][cover:173]: Position: 88%
[17:39:03][D][cover:186]: Current Operation: CLOSING
[17:39:03][I][secplus_gdo:061]: Door: Closing, 84%, target: 0%
[17:39:03][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:03][D][cover:173]: Position: 84%
[17:39:03][D][cover:186]: Current Operation: CLOSING
[17:39:04][I][secplus_gdo:061]: Door: Closing, 80%, target: 0%
[17:39:04][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:04][D][cover:173]: Position: 80%
[17:39:04][D][cover:186]: Current Operation: CLOSING
[17:39:04][I][secplus_gdo:061]: Door: Closing, 76%, target: 0%
[17:39:04][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:04][D][cover:173]: Position: 76%
[17:39:04][D][cover:186]: Current Operation: CLOSING
[17:39:05][I][secplus_gdo:061]: Door: Closing, 72%, target: 0%
[17:39:05][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:05][D][cover:173]: Position: 72%
[17:39:05][D][cover:186]: Current Operation: CLOSING
[17:39:05][I][secplus_gdo:061]: Door: Closing, 68%, target: 0%
[17:39:05][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:05][D][cover:173]: Position: 68%
[17:39:05][D][cover:186]: Current Operation: CLOSING
[17:39:06][I][secplus_gdo:061]: Door: Closing, 64%, target: 0%
[17:39:06][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:06][D][cover:173]: Position: 64%
[17:39:06][D][cover:186]: Current Operation: CLOSING
[17:39:06][V][esp-idf:000]: D (82929764) gdolib: RX packet size 20, pending: 1

[17:39:06][V][esp-idf:000]: I (82929766) gdolib: RX: [55 01 00 0A 22 B2 53 68 B6 DF 7D 02 2D 2C 9C 41 96 92 19]

[17:39:06][V][esp-idf:000]: I (82929767) gdolib: received rolling=0017da0 fixed=42761c200a data=00000084

[17:39:06][V][esp-idf:000]: I (82929769) gdolib: cmd=284 (MOTOR_ON) byte2=00 byte1=00 nibble=0

[17:39:06][V][esp-idf:000]: D (82929783) gdolib: Motor state: On

[17:39:06][I][secplus_gdo:061]: Door: Closing, 60%, target: 0%
[17:39:06][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:06][D][cover:173]: Position: 60%
[17:39:06][D][cover:186]: Current Operation: CLOSING
[17:39:07][I][secplus_gdo:061]: Door: Closing, 57%, target: 0%
[17:39:07][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:07][D][cover:173]: Position: 57%
[17:39:07][D][cover:186]: Current Operation: CLOSING
[17:39:07][I][secplus_gdo:061]: Door: Closing, 53%, target: 0%
[17:39:07][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:07][D][cover:173]: Position: 53%
[17:39:07][D][cover:186]: Current Operation: CLOSING
[17:39:08][I][secplus_gdo:061]: Door: Closing, 49%, target: 0%
[17:39:08][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:08][D][cover:173]: Position: 49%
[17:39:08][D][cover:186]: Current Operation: CLOSING
[17:39:08][I][secplus_gdo:061]: Door: Closing, 45%, target: 0%
[17:39:08][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:08][D][cover:173]: Position: 45%
[17:39:08][D][cover:186]: Current Operation: CLOSING
[17:39:09][I][secplus_gdo:061]: Door: Closing, 41%, target: 0%
[17:39:09][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:09][D][cover:173]: Position: 41%
[17:39:09][D][cover:186]: Current Operation: CLOSING
[17:39:09][I][secplus_gdo:061]: Door: Closing, 37%, target: 0%
[17:39:09][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:09][D][cover:173]: Position: 37%
[17:39:09][D][cover:186]: Current Operation: CLOSING
[17:39:09][V][esp-idf:000]: D (82932988) gdolib: RX packet size 20, pending: 1

[17:39:09][V][esp-idf:000]: I (82932990) gdolib: RX: [55 01 00 0A 22 B2 53 68 B6 DF 7D 02 2D 2C 9C 41 96 92 19]

[17:39:09][V][esp-idf:000]: I (82932991) gdolib: received rolling=0017da0 fixed=42761c200a data=00000084

[17:39:09][V][esp-idf:000]: I (82932993) gdolib: cmd=284 (MOTOR_ON) byte2=00 byte1=00 nibble=0

[17:39:09][V][esp-idf:000]: D (82933006) gdolib: Motor state: On

[17:39:10][I][secplus_gdo:061]: Door: Closing, 33%, target: 0%
[17:39:10][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:10][D][cover:173]: Position: 33%
[17:39:10][D][cover:186]: Current Operation: CLOSING
[17:39:10][I][secplus_gdo:061]: Door: Closing, 29%, target: 0%
[17:39:10][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:10][D][cover:173]: Position: 29%
[17:39:10][D][cover:186]: Current Operation: CLOSING
[17:39:11][I][secplus_gdo:061]: Door: Closing, 25%, target: 0%
[17:39:11][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:11][D][cover:173]: Position: 25%
[17:39:11][D][cover:186]: Current Operation: CLOSING
[17:39:11][V][esp-idf:000]: D (82934596) gdolib: RX packet size 20, pending: 1

[17:39:11][V][esp-idf:000]: I (82934598) gdolib: RX: [55 01 00 0A 22 B2 53 68 B6 DF 7D 02 2D 2C 9C 41 96 92 19]

[17:39:11][V][esp-idf:000]: I (82934600) gdolib: received rolling=0017da0 fixed=42761c200a data=00000084

[17:39:11][V][esp-idf:000]: I (82934602) gdolib: cmd=284 (MOTOR_ON) byte2=00 byte1=00 nibble=0

[17:39:11][V][esp-idf:000]: D (82934614) gdolib: Motor state: On

[17:39:11][V][esp-idf:000]: D (82934678) gdolib: RX packet size 20, pending: 1

[17:39:11][V][esp-idf:000]: I (82934680) gdolib: RX: [55 01 00 0A 22 B2 53 68 B6 DF 7D 02 2D 2C 9C 41 96 92 19]

[17:39:11][V][esp-idf:000]: I (82934681) gdolib: received rolling=0017da0 fixed=42761c200a data=00000084

[17:39:11][V][esp-idf:000]: I (82934682) gdolib: cmd=284 (MOTOR_ON) byte2=00 byte1=00 nibble=0

[17:39:11][V][esp-idf:000]: D (82934697) gdolib: Motor state: On

[17:39:11][I][secplus_gdo:061]: Door: Closing, 21%, target: 0%
[17:39:11][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:11][D][cover:173]: Position: 21%
[17:39:11][D][cover:186]: Current Operation: CLOSING
[17:39:12][I][secplus_gdo:061]: Door: Closing, 17%, target: 0%
[17:39:12][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:12][D][cover:173]: Position: 17%
[17:39:12][D][cover:186]: Current Operation: CLOSING
[17:39:12][I][secplus_gdo:061]: Door: Closing, 13%, target: 0%
[17:39:12][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:12][D][cover:173]: Position: 13%
[17:39:12][D][cover:186]: Current Operation: CLOSING
[17:39:13][I][secplus_gdo:061]: Door: Closing, 9%, target: 0%
[17:39:13][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:13][D][cover:173]: Position: 9%
[17:39:13][D][cover:186]: Current Operation: CLOSING
[17:39:13][I][secplus_gdo:061]: Door: Closing, 5%, target: 0%
[17:39:13][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:13][D][cover:173]: Position: 5%
[17:39:13][D][cover:186]: Current Operation: CLOSING
[17:39:14][I][secplus_gdo:061]: Door: Closing, 1%, target: 0%
[17:39:14][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:14][D][cover:173]: Position: 1%
[17:39:14][D][cover:186]: Current Operation: CLOSING
[17:39:14][I][secplus_gdo:061]: Door: Closing, 0%, target: 0%
[17:39:14][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:14][D][cover:173]: Position: 0%
[17:39:14][D][cover:186]: Current Operation: CLOSING
[17:39:15][V][esp-idf:000]: D (82938510) gdolib: RX packet size 20, pending: 1

[17:39:15][V][esp-idf:000]: I (82938512) gdolib: RX: [55 01 00 09 1D 0D 84 05 14 84 22 A4 1B DF F1 EE 1D 3F 9D]

[17:39:15][V][esp-idf:000]: I (82938514) gdolib: received rolling=0017da1 fixed=40761c200a data=42600281

[17:39:15][V][esp-idf:000]: I (82938516) gdolib: cmd=081 (STATUS) byte2=42 byte1=60 nibble=2

[17:39:15][V][esp-idf:000]: D (82938529) gdolib: Door state: Closed

[17:39:15][V][esp-idf:000]: I (82938539) gdolib: TX: [55 01 00 56 1A 6D 94 D3 69 A6 93 29 11 09 10 D4 52 C6 13]

[17:39:15][V][esp-idf:000]: D (82938540) gdolib: Light state: On

[17:39:15][V][esp-idf:000]: D (82938542) gdolib: Lock state: Unlocked

[17:39:15][V][esp-idf:000]: D (82938549) gdolib: Learn state: Active

[17:39:15][V][esp-idf:000]: D (82938559) gdolib: Obstruction state: Clear

[17:39:15][V][esp-idf:000]: D (82938591) gdolib: Sent command: GET_OPENINGS

[17:39:15][I][secplus_gdo:061]: Door: Closed, 0%, target: 0%
[17:39:15][D][cover:170]: ‘garage_door’ - Publishing:
[17:39:15][D][cover:173]: Position: 0%
[17:39:15][D][cover:186]: Current Operation: IDLE
[17:39:15][D][binary_sensor:036]: ‘Garage Door Motor’: Sending state OFF
[17:39:15][V][esp-idf:000]: D (82938707) gdolib: RX packet size 20, pending: 1

[17:39:15][V][esp-idf:000]: I (82938709) gdolib: RX: [55 01 00 64 28 76 AE F8 EC EC BC 52 13 24 9C 69 E9 AB 41]

[17:39:15][V][esp-idf:000]: I (82938710) gdolib: received rolling=0017da2 fixed=44761c200a data=1d21008c

[17:39:15][V][esp-idf:000]: I (82938712) gdolib: cmd=48c (OPENINGS) byte2=1d byte1=21 nibble=0

[17:39:15][V][esp-idf:000]: D (82938725) gdolib: Openings: 8477

[17:39:15][I][secplus_gdo:091]: Openings: 8477

user107 · April 9, 2024, 2:43pm

Any good method to get the logs if issue occurred and I didn’t have the ESPHome webpage open? I keep triggering the issue, but by the time I grab laptop, load up the right page to grab debug, and press arrow again, it of course works just fine… (I’m not against leaving the page up and running, just wondering if I’m missing some other obvious method to grab the log that might have remained in device memory…)

this most recent one for me was requesting to close with down arrow, audible alert, didn’t close… about 2 min passed, logging into HA and also opening device page from ESPHome, (saw no logs to share), adjusted to partially closed with slider (because up/down arrowed hidden because of bug), then tried up/down arrows (they return after partial close finishes properly) and everything seemed working properly again for various up/down tests…

user107 · April 9, 2024, 3:04pm

Note, the double commands are not sending exactly the same commands (not knowing the exact calling structure of the data), below is a working call and you see only two bytes are different between two commands, so this is probably deliberate… (maybe a “stop” cmd always preceeds any new movement cmd?) I see same pattern in nate’s calls above with two bytes changed too… (I tried bolding the bytes that differed if you look closely)

Partial snippet:

[09:54:03][I][secplus_gdo:061]: Door: Open, 100%, target: 100%
[09:54:03][D][cover:170]: ‘garage_door’ - Publishing:
[09:54:03][D][cover:173]: Position: 100%
[09:54:03][D][cover:186]: Current Operation: IDLE
[09:54:03][D][binary_sensor:036]: ‘Garage Door Motor’: Sending state OFF
[09:54:16][W][web_server_idf:070]: Only application/x-www-form-urlencoded supported for POST request
[09:54:16][D][cover:076]: ‘garage_door’ - Setting
[09:54:16][D][cover:084]: Position: 0%
[09:54:16][D][button:010]: ‘Pre-close Warning’ Pressed.
[09:54:16][D][light:036]: ‘warning_led’ Setting:
[09:54:16][D][light:047]: State: ON
[09:54:16][D][light:109]: Effect: ‘Strobe’
[09:54:16][D][button:010]: ‘Play sound’ Pressed.
[09:54:16][D][rtttl:051]: Playing song ominous
[09:54:16][D][cover:170]: ‘garage_door’ - Publishing:
[09:54:16][D][cover:173]: Position: 100%
[09:54:16][D][cover:186]: Current Operation: CLOSING
[09:54:20][D][rtttl:176]: Playback finished
[09:54:21][D][light:036]: ‘warning_led’ Setting:
[09:54:21][D][light:047]: State: OFF
[09:54:21][D][light:109]: Effect: ‘None’
[09:54:21][D][light:036]: ‘warning_led’ Setting:
[09:54:21][V][esp-idf:000]: I (77620411) gdolib: TX: [55 01 00 A0 36 DF 75 B7 FB ED B0 56 3A 7F A7 B8 A8 A6 93]

[09:54:21][V][esp-idf:000]: I (77620414) gdolib: TX: [55 01 00 A0 36 DF 75 B7 FB ED B2 56 3A 7F A7 B8 A8 86 93]

[09:54:21][V][esp-idf:000]: D (77620435) gdolib: Sent command: DOOR_ACTION

[09:54:21][V][esp-idf:000]: D (77620458) gdolib: Sent command: DOOR_ACTION

[09:54:22][V][esp-idf:000]: D (77621547) gdolib: RX packet size 20, pending: 1

[09:54:22][V][esp-idf:000]: I (77621549) gdolib: RX: [55 01 00 A4 3D D7 DB FE C6 7F 9F A6 3F DE E6 CB 9D 37 95]

[09:54:22][V][esp-idf:000]: I (77621551) gdolib: received rolling=0010bcc fixed=00158fc022 data=42600581

[09:54:22][V][esp-idf:000]: I (77621553) gdolib: cmd=081 (STATUS) byte2=42 byte1=60 nibble=5

[09:54:22][V][esp-idf:000]: D (77621566) gdolib: Door state: Closing

[09:54:22][V][esp-idf:000]: D (77621568) gdolib: Light state: On

[09:54:22][V][esp-idf:000]: D (77621576) gdolib: Lock state: Unlocked

[09:54:22][V][esp-idf:000]: D (77621578) gdolib: Learn state: Active

[09:54:22][V][esp-idf:000]: D (77621586) gdolib: Obstruction state: Clear

[09:54:22][I][secplus_gdo:061]: Door: Closing, 100%, target: 0%
[09:54:22][D][cover:170]: ‘garage_door’ - Publishing:
[09:54:22][D][cover:173]: Position: 100%
[09:54:22][D][cover:186]: Current Operation: CLOSING
[09:54:22][I][secplus_gdo:061]: Door: Closing, 85%, target: 0%
[09:54:22][D][cover:170]: ‘garage_door’ - Publishing:
[09:54:22][D][cover:173]: Position: 85%
[09:54:22][D][cover:186]: Current Operation: CLOSING
[09:54:23][I][secplus_gdo:061]: Door: Closing, 80%, target: 0%
[09:54:23][D][cover:170]: ‘garage_door’ - Publishing:
[09:54:23][D][cover:173]: Position: 80%
[09:54:23][D][cover:186]: Current Operation: CLOSING

These two lines are where you see two bytes change

scelfo · April 9, 2024, 6:27pm

My wall button is also a LiftMaster with built-in motion sensors. Just like the picture above.

My opener looks just like 1d8088 but it’s a belt drive and does not have built-in wi-fi. I’ll try to get the model number and post back.

My learn button is round and yellow.

nate · April 9, 2024, 6:28pm

Thanks for the additional logs. We’re looking into this and are going to add some additional logging to identify where the duplicate commands are coming from. I’m having trouble reproducing this problem so we’re a little bit puzzled at the moment. It might be Home Assistant somehow sending the command twice.

Does it work more reliably when controlled by the device’s webpage?

Our theory is that the the double-command is being ignored by the garage opener as a mistake.

Yes, the minor byte changes are the rolling code counter. The command itself is the same.

Btw I have moved this issue to its own thread.