tl;dr - the position estimation logic based on door open / close timing runs fast even though the timing info captured is correct.
This was also submitted as a support ticket on December 6: 17212358813
If I reset the door timings, I can see the capture of the open and close timing in the logs on the device web page. For my door, the captured TTO and TTC are between 11 and 12 seconds. Timing the door with a stopwatch shows these measurements to be accurate. What I observe when triggering an open or close from the physical wall button or the device web page, is that the events for estimated door position indicate that the estimation is far ahead of the actual position. If I understand the logs correctly, the example below shows the door position estimating fully closed many seconds before the event showing that the door is actually closed.
Time level Tag Message
18:48:04 [I] [gdo_cover:030]e[1;31m[gdo_main_task]e[0;32m
Door state: Closing, position: 67%
18:48:04 [D] [cover:170]e[1;31m[gdo_main_task]e[0;36m
‘Garage Door’ - Publishing:
18:48:04 [D] [cover:173]e[1;31m[gdo_main_task]e[0;36m
Position: 67%
18:48:04 [D] [cover:186]e[1;31m[gdo_main_task]e[0;36m
Current Operation: CLOSING
18:48:04 [I] [gdo_cover:030]e[1;31m[gdo_main_task]e[0;32m
Door state: Closing, position: 62%
18:48:04 [D] [cover:170]e[1;31m[gdo_main_task]e[0;36m
‘Garage Door’ - Publishing:
18:48:04 [D] [cover:173]e[1;31m[gdo_main_task]e[0;36m
Position: 62%
18:48:04 [D] [cover:186]e[1;31m[gdo_main_task]e[0;36m
Current Operation: CLOSING
18:48:05 [I] [gdo_cover:030]e[1;31m[gdo_main_task]e[0;32m
Door state: Closing, position: 51%
18:48:05 [D] [cover:170]e[1;31m[gdo_main_task]e[0;36m
‘Garage Door’ - Publishing:
18:48:05 [D] [cover:173]e[1;31m[gdo_main_task]e[0;36m
Position: 51%
18:48:05 [D] [cover:186]e[1;31m[gdo_main_task]e[0;36m
Current Operation: CLOSING
18:48:05 [I] [gdo_cover:030]e[1;31m[gdo_main_task]e[0;32m
Door state: Closing, position: 47%
18:48:05 [D] [cover:170]e[1;31m[gdo_main_task]e[0;36m
‘Garage Door’ - Publishing:
18:48:05 [D] [cover:173]e[1;31m[gdo_main_task]e[0;36m
Position: 47%
18:48:05 [D] [cover:186]e[1;31m[gdo_main_task]e[0;36m
Current Operation: CLOSING
18:48:06 [I] [gdo_cover:030]e[1;31m[gdo_main_task]e[0;32m
Door state: Closing, position: 34%
18:48:06 [D] [cover:170]e[1;31m[gdo_main_task]e[0;36m
‘Garage Door’ - Publishing:
18:48:06 [D] [cover:173]e[1;31m[gdo_main_task]e[0;36m
Position: 34%
18:48:06 [D] [cover:186]e[1;31m[gdo_main_task]e[0;36m
Current Operation: CLOSING
18:48:06 [I] [gdo_cover:030]e[1;31m[gdo_main_task]e[0;32m
Door state: Closing, position: 22%
18:48:06 [D] [cover:170]e[1;31m[gdo_main_task]e[0;36m
‘Garage Door’ - Publishing:
18:48:06 [D] [cover:173]e[1;31m[gdo_main_task]e[0;36m
Position: 22%
18:48:06 [D] [cover:186]e[1;31m[gdo_main_task]e[0;36m
Current Operation: CLOSING
18:48:07 [I] [gdo_cover:030]e[1;31m[gdo_main_task]e[0;32m
Door state: Closing, position: 14%
18:48:07 [D] [cover:170]e[1;31m[gdo_main_task]e[0;36m
‘Garage Door’ - Publishing:
18:48:07 [D] [cover:173]e[1;31m[gdo_main_task]e[0;36m
Position: 14%
18:48:07 [D] [cover:186]e[1;31m[gdo_main_task]e[0;36m
Current Operation: CLOSING
18:48:07 [I] [gdo_cover:030]e[1;31m[gdo_main_task]e[0;32m
Door state: Closing, position: 9%
18:48:07 [D] [cover:170]e[1;31m[gdo_main_task]e[0;36m
‘Garage Door’ - Publishing:
18:48:07 [D] [cover:173]e[1;31m[gdo_main_task]e[0;36m
Position: 9%
18:48:07 [D] [cover:186]e[1;31m[gdo_main_task]e[0;36m
Current Operation: CLOSING
18:48:08 [I] [gdo_cover:030]e[1;31m[gdo_main_task]e[0;32m
Door state: Closing, position: 0%
18:48:08 [D] [cover:170]e[1;31m[gdo_main_task]e[0;36m
‘Garage Door’ - Publishing:
18:48:08 [D] [cover:173]e[1;31m[gdo_main_task]e[0;36m
Position: 0%
18:48:08 [D] [cover:186]e[1;31m[gdo_main_task]e[0;36m
Current Operation: CLOSING
18:48:12 [D] [sensor:094]
‘Uptime’: Sending state 540.53900 s with 0 decimals of accuracy
18:48:13 [D] [sensor:094]
‘Heap Free’: Sending state 239044.00000 B with 0 decimals of accuracy
18:48:13 [I] [gdo_cover:030]e[1;31m[gdo_main_task]e[0;32m
Door state: Closed, position: 0%
18:48:13 [D] [cover:170]e[1;31m[gdo_main_task]e[0;36m
‘Garage Door’ - Publishing:
18:48:13 [D] [cover:173]e[1;31m[gdo_main_task]e[0;36m
Position: 0%
18:48:13 [D] [cover:186]e[1;31m[gdo_main_task]e[0;36m
Current Operation: IDLE
18:48:43 [D] [sensor:094]
‘Heap Free’: Sending state 239816.00000 B with 0 decimals of accuracy
18:48:45 [VV ][web_server_idf:106]e[1;31m[httpd]e[0;38m