search

mongoose-os-apps / shelly-homekit

Apple HomeKit firmware for Shelly's
Other
1.81k stars 130 forks source link

Testing 2.11.0 #868

Closed rojer closed 2 years ago

rojer commented 2 years ago

What's new:

alpha5:

alpha6:

alpha7:

alpha8:

alpha9:

beta1:

beta2:

beta3:

beta4:

beta5:

beta6:

bmpalmeida commented 2 years ago

I don’t know if it is intentional in the alpha builds. But the check for updates and revert to stock are missing.

rojer commented 2 years ago

no, it's a bug - fixed in alpha3

timoschilling commented 2 years ago

There is a problem with the Shelly 2.5 firmware. It is introduced between alpha1 and alpha2. I tested it with 3 different shelly, each with a different installed version. So I think the problem is the new firmware and not the old one.

Observed things:

  1. alpha1 can be installed
  2. alpha2 & 3 not
  3. alpha2 jumps up in size from 992747 to 1005036
  4. flash crashes with ConnectionResetError: [Errno 54] Connection reset by peer
  5. upload via UI stops at 0%
bmpalmeida commented 2 years ago

I'm also having the same behaviour from the script, i left the script running all night (while [[ 0 -eq 0 ]]; do python3 flash-shelly.py -m keep -y -i 3 -a --variant alpha; sleep 20; clear; done) and none of the 2.5 were updated. But all the 1PM are completely fine.

andyblac commented 2 years ago

I'm also having the same behaviour from the script, i left the script running all night (while [[ 0 -eq 0 ]]; do python3 flash-shelly.py -m keep -y -i 3 -a --variant alpha; sleep 20; clear; done) and none of the 2.5 were updated. But all the 1PM are completely fine.

I would like to see the output of that if poss, as it should have timed out.

add --log-file debug.log to your command line, post the log file itself.

Thx

bmpalmeida commented 2 years ago

Looks like the crash is the script trying to update my 3d printer.

Attachment the debug log and also the console output.

debug.log

Console output:

admin@iMac tools % python3 flash-shelly.py -m keep -y -i 3 -a --variant alpha --log-file debug.log Scanning for Shelly devices...

Host: http://shellydimmer-D3E51C.local Device Name: Extrator-Musica Model: ShellyDimmer Device ID: shellydimmer-D3E51C Mode: White SSID: bma-home IP: 192.168.50.249 RSSI: -49 Up Time: 7 days, 14:44:55 Firmware: Stock 1.11.7 ✔

Host: http://Bomba-Casa-Maquinas.local Device Name: Bomba-Casa-Maquinas Model: Shelly1PM Device ID: shelly1pm-D220EB Mode: Switch SSID: bma-home IP: 192.168.50.247 Sys Temp: 30˚c Up Time: 9:42:56 HAP Connections: 0 / 2 / 12 Firmware: HomeKit 2.11.0-alpha3 ✔

Host: http://Musica-Duplo.local Device Name: Musica-Duplo Model: Shelly25 Device ID: shellyswitch25-F2F3F6 Mode: Switch SSID: bma-home IP: 192.168.50.45 RSSI: -43 Sys Temp: 58˚c Up Time: 7 days, 14:44:36 HAP Connections: 0 / 2 / 12 Firmware: HomeKit 2.10.1 ➜ 2.11.0-alpha3 Downloading Firmware... Now Flashing HomeKit 2.11.0-alpha3

Host: http://Luz-Casa-Maquinas.local Device Name: Luz-Casa-Maquinas Model: Shelly1PM Device ID: shelly1pm-FADBF9 Mode: Switch SSID: bma-home IP: 192.168.50.24 Sys Temp: 28˚c Up Time: 9:43:29 HAP Connections: 0 / 2 / 12 Firmware: HomeKit 2.11.0-alpha3 ✔

Host: http://shellydimmer-D3EB09.local Device Name: Exterior-Parede-Direita Model: ShellyDimmer Device ID: shellydimmer-D3EB09 Mode: White SSID: bma-home IP: 192.168.50.157 RSSI: -77 Up Time: 7 days, 14:44:55 Firmware: Stock 1.11.7 ✔

Host: http://Wc-cave.local Device Name: Wc-cave Model: Shelly1PM Device ID: shelly1pm-FADDE2 Mode: Switch SSID: bma-home IP: 192.168.50.145 Sys Temp: 39˚c Up Time: 6:20:48 HAP Connections: 0 / 0 / 12 Firmware: HomeKit 2.11.0-alpha3 ✔

Host: http://quarto-direita.local Device Name: quarto-direita Model: Shelly1PM Device ID: shelly1pm-05F7CB Mode: Switch SSID: bma-home IP: 192.168.50.39 Sys Temp: 39˚c Up Time: 9:36:05 HAP Connections: 0 / 2 / 12 Firmware: HomeKit 2.11.0-alpha3 ✔

Host: http://Suite-Banheira.local Device Name: Suite-Banheira Model: Shelly25 Device ID: shellyswitch25-10C5DF Mode: Switch SSID: bma-home IP: 192.168.50.213 RSSI: -59 Sys Temp: 53˚c Up Time: 12 days, 16:22:09 HAP Connections: 0 / 2 / 12 Firmware: HomeKit 2.10.1 ➜ 2.11.0-alpha3 Downloading Firmware... Now Flashing HomeKit 2.11.0-alpha3

flash-shelly version: 2.8.0 Try to update your script, maybe the bug is already fixed! Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/urllib3/response.py", line 438, in _error_catcher yield File "/usr/local/lib/python3.9/site-packages/urllib3/response.py", line 519, in read data = self._fp.read(amt) if not fp_closed else b"" File "/usr/local/Cellar/python@3.9/3.9.9/Frameworks/Python.framework/Versions/3.9/lib/python3.9/http/client.py", line 463, in read n = self.readinto(b) File "/usr/local/Cellar/python@3.9/3.9.9/Frameworks/Python.framework/Versions/3.9/lib/python3.9/http/client.py", line 507, in readinto n = self.fp.readinto(b) File "/usr/local/Cellar/python@3.9/3.9.9/Frameworks/Python.framework/Versions/3.9/lib/python3.9/socket.py", line 704, in readinto return self._sock.recv_into(b) ConnectionResetError: [Errno 54] Connection reset by peer

During handling of the above exception, another exception occurred:

Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/requests/models.py", line 758, in generate for chunk in self.raw.stream(chunk_size, decode_content=True): File "/usr/local/lib/python3.9/site-packages/urllib3/response.py", line 576, in stream data = self.read(amt=amt, decode_content=decode_content) File "/usr/local/lib/python3.9/site-packages/urllib3/response.py", line 541, in read raise IncompleteRead(self._fp_bytes_read, self.length_remaining) File "/usr/local/Cellar/python@3.9/3.9.9/Frameworks/Python.framework/Versions/3.9/lib/python3.9/contextlib.py", line 137, in exit self.gen.throw(typ, value, traceback) File "/usr/local/lib/python3.9/site-packages/urllib3/response.py", line 455, in _error_catcher raise ProtocolError("Connection broken: %r" % e, e) urllib3.exceptions.ProtocolError: ("Connection broken: ConnectionResetError(54, 'Connection reset by peer')", ConnectionResetError(54, 'Connection reset by peer'))

During handling of the above exception, another exception occurred:

Traceback (most recent call last): File "/Users/admin/Downloads/shelly-homekit-master/tools/flash-shelly.py", line 941, in run_app self.device_scan() File "/Users/admin/Downloads/shelly-homekit-master/tools/flash-shelly.py", line 1579, in device_scan self.probe_device(device) File "/Users/admin/Downloads/shelly-homekit-master/tools/flash-shelly.py", line 1485, in probe_device self.parse_info(device_info, hk_flash_fw_version) File "/Users/admin/Downloads/shelly-homekit-master/tools/flash-shelly.py", line 1355, in parse_info self.write_flash(device_info) File "/Users/admin/Downloads/shelly-homekit-master/tools/flash-shelly.py", line 1105, in write_flash response = device_info.flash_firmware(revert) File "/Users/admin/Downloads/shelly-homekit-master/tools/flash-shelly.py", line 574, in flash_firmware response = requests.post(url=f'http://{self.wifi_ip}/update', auth=HTTPDigestAuth(self.username, self.password), files=files) File "/usr/local/lib/python3.9/site-packages/requests/api.py", line 117, in post return request('post', url, data=data, json=json, kwargs) File "/usr/local/lib/python3.9/site-packages/requests/api.py", line 61, in request return session.request(method=method, url=url, kwargs) File "/usr/local/lib/python3.9/site-packages/requests/sessions.py", line 542, in request resp = self.send(prep, **send_kwargs) File "/usr/local/lib/python3.9/site-packages/requests/sessions.py", line 697, in send r.content File "/usr/local/lib/python3.9/site-packages/requests/models.py", line 836, in content self._content = b''.join(self.iter_content(CONTENT_CHUNK_SIZE)) or b'' File "/usr/local/lib/python3.9/site-packages/requests/models.py", line 761, in generate raise ChunkedEncodingError(e) requests.exceptions.ChunkedEncodingError: ("Connection broken: ConnectionResetError(54, 'Connection reset by peer')", ConnectionResetError(54, 'Connection reset by peer'))

During handling of the above exception, another exception occurred:

Traceback (most recent call last): File "/Users/admin/Downloads/shelly-homekit-master/tools/flash-shelly.py", line 1584, in sys.exit(main.run_app()) File "/Users/admin/Downloads/shelly-homekit-master/tools/flash-shelly.py", line 947, in run_app traceback.trace_exception(exc_type, exc_value, exc_traceback, file=sys.stdout) AttributeError: module 'traceback' has no attribute 'trace_exception'

Devices found: 8 Upgradeable: 2 Flashed: 0 Log file created: debug.log

andyblac commented 2 years ago

please try version 3.0 beta of the script https://github.com/mongoose-os-apps/shelly-homekit/issues/686

bmpalmeida commented 2 years ago

Now it crashes trying to update one 2.5 (i believe that this is due to what timoschilling was reporting on the firmware problem with 2.5).

debug.log

admin@iMac Downloads % python3 flash-shelly.py -m keep -y -i 3 -a --variant alpha --log-file debug.log Scanning for Shelly devices...

Host: http://quarto-direita.local Device Name: quarto-direita Model: Shelly1PM Device ID: shelly1pm-05F7CB Mode: Switch SSID: bma-home IP: 192.168.50.39 Sys Temp: 39˚c Up Time: 9:50:44 HAP Connections: 0 / 2 / 12 Firmware: HomeKit 2.11.0-alpha3 ✔

Host: http://Bomba-Casa-Maquinas.local Device Name: Bomba-Casa-Maquinas Model: Shelly1PM Device ID: shelly1pm-D220EB Mode: Switch SSID: bma-home IP: 192.168.50.247 Sys Temp: 30˚c Up Time: 9:57:36 HAP Connections: 0 / 2 / 12 Firmware: HomeKit 2.11.0-alpha3 ✔

Host: http://Luz-Casa-Maquinas.local Device Name: Luz-Casa-Maquinas Model: Shelly1PM Device ID: shelly1pm-FADBF9 Mode: Switch SSID: bma-home IP: 192.168.50.24 Sys Temp: 28˚c Up Time: 9:58:10 HAP Connections: 0 / 2 / 12 Firmware: HomeKit 2.11.0-alpha3 ✔

Host: http://shellyplug-s-51D7C0.local Device Name: Frigorifico Model: ShellyPlugS Device ID: shellyplug-s-51D7C0 SSID: bma-home IP: 192.168.50.59 RSSI: -55 Up Time: 22 days, 7:36:24 Firmware: Stock 1.11.7 ✔

Host: http://shellyem-C45BBE5FE4C8.local Device Name: None Model: ShellyEM Device ID: shellyem-C45BBE5FE4C8 SSID: bma-home IP: 192.168.50.253 RSSI: -76 Up Time: 7 days, 14:59:22 Firmware: Stock 1.11.7 ✔

Host: http://Lavandaria.local Device Name: Lavandaria Model: Shelly1PM Device ID: shelly1pm-FAE0FC Mode: Switch SSID: bma-home IP: 192.168.50.134 Sys Temp: 40˚c Up Time: 9:44:47 HAP Connections: 0 / 2 / 12 Firmware: HomeKit 2.11.0-alpha3 ✔

Host: http://shellydimmer-D3E51C.local Device Name: Extrator-Musica Model: ShellyDimmer Device ID: shellydimmer-D3E51C Mode: White SSID: bma-home IP: 192.168.50.249 RSSI: -48 Up Time: 7 days, 14:59:37 Firmware: Stock 1.11.7 ✔

Host: http://Musica-Duplo.local Device Name: Musica-Duplo Model: Shelly25 Device ID: shellyswitch25-F2F3F6 Mode: Switch SSID: bma-home IP: 192.168.50.45 RSSI: -43 Sys Temp: 58˚c Up Time: 7 days, 14:59:18 HAP Connections: 0 / 2 / 12 Firmware: HomeKit 2.10.1 ➜ 2.11.0-alpha3 Downloading Firmware... Now Flashing HomeKit 2.11.0-alpha3

flash-shelly version: 3.0.0 Try to update your script, maybe the bug is already fixed! Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/urllib3/response.py", line 438, in _error_catcher yield File "/usr/local/lib/python3.9/site-packages/urllib3/response.py", line 519, in read data = self._fp.read(amt) if not fp_closed else b"" File "/usr/local/Cellar/python@3.9/3.9.9/Frameworks/Python.framework/Versions/3.9/lib/python3.9/http/client.py", line 463, in read n = self.readinto(b) File "/usr/local/Cellar/python@3.9/3.9.9/Frameworks/Python.framework/Versions/3.9/lib/python3.9/http/client.py", line 507, in readinto n = self.fp.readinto(b) File "/usr/local/Cellar/python@3.9/3.9.9/Frameworks/Python.framework/Versions/3.9/lib/python3.9/socket.py", line 704, in readinto return self._sock.recv_into(b) ConnectionResetError: [Errno 54] Connection reset by peer

During handling of the above exception, another exception occurred:

Traceback (most recent call last): File "/usr/local/lib/python3.9/site-packages/requests/models.py", line 758, in generate for chunk in self.raw.stream(chunk_size, decode_content=True): File "/usr/local/lib/python3.9/site-packages/urllib3/response.py", line 576, in stream data = self.read(amt=amt, decode_content=decode_content) File "/usr/local/lib/python3.9/site-packages/urllib3/response.py", line 541, in read raise IncompleteRead(self._fp_bytes_read, self.length_remaining) File "/usr/local/Cellar/python@3.9/3.9.9/Frameworks/Python.framework/Versions/3.9/lib/python3.9/contextlib.py", line 137, in exit self.gen.throw(typ, value, traceback) File "/usr/local/lib/python3.9/site-packages/urllib3/response.py", line 455, in _error_catcher raise ProtocolError("Connection broken: %r" % e, e) urllib3.exceptions.ProtocolError: ("Connection broken: ConnectionResetError(54, 'Connection reset by peer')", ConnectionResetError(54, 'Connection reset by peer'))

During handling of the above exception, another exception occurred:

Traceback (most recent call last): File "/Users/admin/Downloads/flash-shelly.py", line 1188, in run_app self.device_scan() File "/Users/admin/Downloads/flash-shelly.py", line 1691, in device_scan self.probe_device(device) File "/Users/admin/Downloads/flash-shelly.py", line 1634, in probe_device self.parse_info(device, hk_flash_fw_version) # main convert run, or update stock to latest firmware if an update or color mode is required. File "/Users/admin/Downloads/flash-shelly.py", line 1527, in parse_info self.flash_firmware(device) File "/Users/admin/Downloads/flash-shelly.py", line 1291, in flash_firmware response = device.write_firmware() # do actual flash firmware. File "/Users/admin/Downloads/flash-shelly.py", line 659, in write_firmware response = requests.post(url=f'http://{self.wifi_ip}/update', auth=HTTPDigestAuth(self.username, self.password), files=files) File "/usr/local/lib/python3.9/site-packages/requests/api.py", line 117, in post return request('post', url, data=data, json=json, kwargs) File "/usr/local/lib/python3.9/site-packages/requests/api.py", line 61, in request return session.request(method=method, url=url, kwargs) File "/usr/local/lib/python3.9/site-packages/requests/sessions.py", line 542, in request resp = self.send(prep, **send_kwargs) File "/usr/local/lib/python3.9/site-packages/requests/sessions.py", line 697, in send r.content File "/usr/local/lib/python3.9/site-packages/requests/models.py", line 836, in content self._content = b''.join(self.iter_content(CONTENT_CHUNK_SIZE)) or b'' File "/usr/local/lib/python3.9/site-packages/requests/models.py", line 761, in generate raise ChunkedEncodingError(e) requests.exceptions.ChunkedEncodingError: ("Connection broken: ConnectionResetError(54, 'Connection reset by peer')", ConnectionResetError(54, 'Connection reset by peer'))

Devices found: 8 Upgradeable: 1 Flashed: 0 Log file created: debug.log

andyblac commented 2 years ago

ConnectionResetError: [Errno 54] Connection reset by peer same error as @timoschilling

rojer commented 2 years ago

hm, sorry, i don't understand - alpha3 cannot update? seems to be working for me, uploading firmware to an alpha3 device worked just fine.

andyblac commented 2 years ago

@rojer it seem to going from 2.10.1 direct to alpha3, (I have not tried myself, getting rooms re-plastered here, everything upside down atm.)

timoschilling commented 2 years ago

@rojer im not able to flash a 2.5 with 2.10.1/2.10.0/2.9.x to 2.11.0-alpha3. The upload via script, via curl and via UI didn’t work. Would work mean UI stops at 0% progress and curl/script getting a connection reset.

lucaspinelli85 commented 2 years ago

Can't updateimage

rojer commented 2 years ago

ah, you're right. 2.5 firmware size has crossed the magic 716KB. 2.5 is the biggest of them and i did not happen to have one on hand for testing the alpha. i will look at the things to trim, or this may in fact be the time when we need to shrink the FS to make more room for code.

rojer commented 2 years ago

i dropped rpc-service-ota and this freed up some space, so 2.5 should fit again. pushed alpha4, please give it a go.

miguelpruivo commented 2 years ago

Hi! I have one question regarding 1 plus integration: does it uses Wi-Fi, Bluetooth or both to connect to a HomeKit hub (iPad, HomePod etc)? Because since it has a Bluetooth connection it might be handy to use it as a fallback only.

Also regarding this, is it possible to completely disable Bluetooth module and use only Wi-Fi in the settings? This should save some power while also preventing collision interference when a lot of IoT devices are present.

Thank you!

Multisaft7 commented 2 years ago

Did I do something wrong when I try to do the firmware upgrade from my shelly 1 plus?

http://192.168.77.92/ota?url=http://rojer.me/files/shelly/2.11.0-alpha4/shelly-homekit-ShellyPlus1.zip

It says "Not Found"?!

rojer commented 2 years ago

Hi! I have one question regarding 1 plus integration: does it uses Wi-Fi, Bluetooth or both to connect to a HomeKit hub (iPad, HomePod etc)? Because since it has a Bluetooth connection it might be handy to use it as a fallback only.

so, situation with bluetooth is kinda unfortunate. i tried it, and it works but it doesn;t work seamlessly with wifi. once a bluetooth accessory, always a bluetooth accessory. accrding to apple, having accessory available on both BLE and IP transports is not supported. so when wifi becomes available, hub still insists on using BT, which in practice is slower and less responsive. additionally, bridge mode is not available over bluetooth and we use "bridge" mode to expose multiple accessories. so, in short, at the moment BLE is not supported. it's not much of a problem since when setting up shelly-hk, it's already connected to wifi.

firmware upgrade from my shelly 1 plus?

plus series cannot be upgraded this way, see instructions here.

miguelpruivo commented 2 years ago

@rojer so basically the 1 plus with HomeKit has Bluetooth completely disable? It’s not an issue for me, actually. I’d rather have Bluetooth off and all on Wi-Fi to prevent network collisions than having a lot of Shelly’s using both Wi-Fi and Bluetooth.

rojer commented 2 years ago

@miguelpruivo correct, currently bluetooth is not enabled in shelly-hk frmware.

lucaspinelli85 commented 2 years ago

Hi all! I managed to upgrade to alfa4, i have these questions: 1- how is the homekit qrcode generated now having two wifi? based on 1? or on the active one? 2- how does it connect to one wifi rather than the other? try the first if it fails, go to the second? or try both and connect to the best? 3- what happens if I put the same wifi in both? 4- by default the ap mode will be disabled, it would be convenient to auto-enable when the device fails to connect to the two wifi. Thanks!

rojer commented 2 years ago

Hi all! I managed to upgrade to alfa4, i have these questions: 1- how is the homekit qrcode generated now having two wifi? based on 1? or on the active one?

based on wifi 1

2- how does it connect to one wifi rather than the other? try the first if it fails, go to the second? or try both and connect to the best?

try all usable APs (RSSI > -90) for wifi 1 first, from best to worst, then wifi 2.

3- what happens if I put the same wifi in both?

nothing much. APs will be deduplicated.

4- by default the ap mode will be disabled, it would be convenient to auto-enable when the device fails to connect to the two wifi.

this will be the case during initial setup. however, not after connection was established. it might be convenient but since APs are open by default, it's kind of a security problem if device throws itself wide open on possibly transient connection failure. i think wifi reset via on/off or physical button is easy enough that this is not necessary.

bmpalmeida commented 2 years ago

Hello all,

i've installed alpha4 on a shelly 1PM before setup it on HomeKit, and every time i click setup i receive a request timeout (the interesting bit is that it was discoverable in the home app but i didn't knew the code).

This specific device is with RSSI -86 which could not help, but with 2.10.1 i manage to setup it perfectly.

timoschilling commented 2 years ago

@bmpalmeida I noticed something similar, try do make a reset and retry then.

rojer commented 2 years ago

timeout when setting up homekit? interesting, i'll take a look. are you connected to AP or STA address at the time?

bmpalmeida commented 2 years ago

timeout when setting up homekit? interesting, i'll take a look. are you connected to AP or STA address at the time?

STA Address, but with a low RSSI (-86).

Another strange thing that was happen, i see the AP broadcasted even with the device connected to STA, but never manage to connect directly. Now its fine, but i didn't understand what happen for it to get "normal".

rojer commented 2 years ago

i see the AP broadcasted even with the device connected to STA

it should turn itself off after a minute of inactivity on the AP. so, if you started in AP mode, configured STA, it connected, AP will remain up as long as you have the page open. when you close it, you should see AP disabled after 1 minute.

but never manage to connect directly

what do you mean by that?

bmpalmeida commented 2 years ago

I didn't know that the AP would continue open.

After i already manage to open the page via my network, i could see the AP, connect to it, but the page never opens.

Multisaft7 commented 2 years ago

Works now for me like a charm with my Shelly Plus 1 as a Light :-)

lucaspinelli85 commented 2 years ago

I have a problem with alpha4. In my Shelly2.5 roller shutter mode an obstacle continues to occur while running. Both outward and return. I have tried calibration numerous times. Can you help me understand what the problem is? I share the log ..

32945749 shelly_debug.cpp:231 No log file, sending new entries 34504107 shelly_main.cpp:526 Up 34.49, HAP 0/5/12 ns 5, RAM: 24344/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:80.14 tp:80.14 md:0 lemd:0 lhmd:0 42504191 shelly_main.cpp:526 Up 42.49, HAP 0/5/12 ns 5, RAM: 24344/41872; st 53; 4.1: c:1 mp:8.43 mt_ms:20589 cp:80.14 tp:80.14 md:0 lemd:0 lhmd:0 50504010 shelly_main.cpp:526 Up 50.49, HAP 0/5/12 ns 5, RAM: 24344/41872; st 53; 4.1: c:1 mp:8.43 mt_ms:20589 cp:80.14 tp:80.14 md:0 lemd:0 lhmd:0 58504139 shelly_main.cpp:526 Up 58.49, HAP 0/5/12 ns 5, RAM: 24344/41872; st 53; 4.1: c:1 mp:8.43 mt_ms:20589 cp:80.14 tp:80.14 md:0 lemd:0 lhmd:0 60993061 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 62001091 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 62992865 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 64016788 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 64718383 mg_rpc.c:310 Shelly.SetState via WS_in 192.168.0.3:64176 64725610 shelly_hap_window_c:347 WC 1: Tgt pos 80.14 -> 100.00 (RPC) 64764674 shelly_hap_window_c:327 WC 1: State: idle -> move (0 -> 20) 64819447 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 64863909 shelly_output.cpp:63 Output 2: off -> on (move) 64870647 shelly_hap_window_c:327 WC 1: State: move -> rampup (20 -> 22) 64964831 shelly_hap_window_c:549 P = 9.60 -> 8.43 64971328 shelly_hap_window_c:327 WC 1: State: rampup -> moving (22 -> 23) 64992356 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 65066556 shelly_hap_window_c:336 WC 1: Cur pos 80.14 -> 80.56, P = 1.52 65072225 shelly_hap_window_c:599 Moving to 100, p 1.52 65866546 shelly_hap_window_c:336 WC 1: Cur pos 83.97 -> 84.45, P = 8.33 65871732 shelly_hap_window_c:599 Moving to 100, p 8.33 65993155 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 66504326 shelly_main.cpp:526 Up 66.49, HAP 0/5/12 ns 5, RAM: 24296/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:87.37 tp:100.00 md:1 lemd:0 lhmd:0 66667101 shelly_hap_window_c:336 WC 1: Cur pos 87.85 -> 88.34, P = 8.29 66672264 shelly_hap_window_c:599 Moving to 100, p 8.29 66994865 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 67466789 shelly_hap_window_c:336 WC 1: Cur pos 91.73 -> 92.22, P = 8.57 67471941 shelly_hap_window_c:599 Moving to 100, p 8.57 67994737 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 68266918 shelly_hap_window_c:336 WC 1: Cur pos 95.62 -> 96.11, P = 10.31 68272195 shelly_hap_window_c:599 Moving to 100, p 10.31 68994444 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 69067129 shelly_hap_window_c:336 WC 1: Cur pos 99.51 -> 100.00, P = 8.73 69072354 shelly_hap_window_c:599 Moving to 100, p 8.73 69865297 shelly_hap_window_c:599 Moving to 100, p 1.03 70005783 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 70665425 shelly_hap_window_c:599 Moving to 100, p 1.14 71136198 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 71465275 shelly_hap_window_c:599 Moving to 100, p 1.29 72080559 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 72264939 shelly_hap_window_c:599 Moving to 100, p 1.03 73065392 shelly_hap_window_c:599 Moving to 100, p 1.18 73565509 shelly_output.cpp:63 Output 2: on -> off (moving) 73572276 shelly_hap_window_c:327 WC 1: State: moving -> stop (23 -> 24) 73823682 mgos_sys_config.c:323 Saved to conf9.json 73831760 shelly_hap_window_c:327 WC 1: State: stop -> stopping (24 -> 25) 73851843 shelly_hap_window_c:327 WC 1: State: stopping -> idle (25 -> 0) 74165649 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 74504435 shelly_main.cpp:526 Up 74.49, HAP 0/5/12 ns 5, RAM: 24344/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00 md:0 lemd:0 lhmd:0 75168458 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 75484299 mg_rpc.c:310 Shelly.SetState via WS_in 192.168.0.3:64176 75491470 shelly_hap_window_c:347 WC 1: Tgt pos 100.00 -> 0.00 (RPC) 75565767 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 75590366 shelly_hap_window_c:327 WC 1: State: idle -> move (0 -> 20) 75664106 shelly_output.cpp:63 Output 1: off -> on (move) 75670730 shelly_hap_window_c:327 WC 1: State: move -> rampup (20 -> 22) 75764577 shelly_hap_window_c:549 P = 10.44 -> 8.43 75771093 shelly_hap_window_c:327 WC 1: State: rampup -> moving (22 -> 23) 76065044 shelly_hap_window_c:599 Moving to 0, p 5.90 76162494 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 76466633 shelly_hap_window_c:336 WC 1: Cur pos 97.15 -> 96.66, P = 9.25 76865265 shelly_hap_window_c:599 Moving to 0, p 10.24 77187729 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 77266876 shelly_hap_window_c:336 WC 1: Cur pos 93.26 -> 92.78, P = 10.05 77665473 shelly_hap_window_c:599 Moving to 0, p 10.79 78066668 shelly_hap_window_c:336 WC 1: Cur pos 89.38 -> 88.89, P = 11.06 78182209 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 78464995 shelly_hap_window_c:599 Moving to 0, p 11.79 78866509 shelly_hap_window_c:336 WC 1: Cur pos 85.49 -> 85.01, P = 11.99 79185078 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 79266269 shelly_hap_window_c:599 Moving to 0, p 12.09 79666846 shelly_hap_window_c:336 WC 1: Cur pos 81.61 -> 81.12, P = 12.24 80065076 shelly_hap_window_c:599 Moving to 0, p 12.37 80167458 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 80466477 shelly_hap_window_c:336 WC 1: Cur pos 77.72 -> 77.24, P = 12.71 80865296 shelly_hap_window_c:599 Moving to 0, p 13.26 81168391 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 81267307 shelly_hap_window_c:336 WC 1: Cur pos 73.70 -> 73.35, P = 10.28 81664942 shelly_hap_window_c:599 Moving to 0, p 12.93 82066762 shelly_hap_window_c:336 WC 1: Cur pos 69.95 -> 69.46, P = 12.71 82171310 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 82465290 shelly_hap_window_c:599 Moving to 0, p 12.88 82503999 shelly_main.cpp:526 Up 82.49, HAP 0/5/12 ns 5, RAM: 24296/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:67.52 tp:0.00 md:2 lemd:0 lhmd:0 82866752 shelly_hap_window_c:336 WC 1: Cur pos 66.06 -> 65.58, P = 12.90 83168439 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 83265164 shelly_hap_window_c:599 Moving to 0, p 12.73 83666932 shelly_hap_window_c:336 WC 1: Cur pos 62.18 -> 61.69, P = 13.55 84066102 shelly_hap_window_c:599 Moving to 0, p 13.53 84190625 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 84466480 shelly_hap_window_c:336 WC 1: Cur pos 58.29 -> 57.81, P = 13.72 84865188 shelly_hap_window_c:599 Moving to 0, p 14.11 85163578 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 85267067 shelly_hap_window_c:336 WC 1: Cur pos 54.30 -> 53.92, P = 14.04 85664956 shelly_hap_window_c:599 Moving to 0, p 14.23 86066401 shelly_hap_window_c:336 WC 1: Cur pos 50.52 -> 50.04, P = 12.95 86163528 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 86465313 shelly_hap_window_c:599 Moving to 0, p 13.09 86866983 shelly_hap_window_c:336 WC 1: Cur pos 46.64 -> 46.15, P = 13.79 87174942 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 87265632 shelly_hap_window_c:599 Moving to 0, p 14.07 87666880 shelly_hap_window_c:336 WC 1: Cur pos 42.75 -> 42.27, P = 14.32 88065181 shelly_hap_window_c:599 Moving to 0, p 14.52 88171111 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 88466560 shelly_hap_window_c:336 WC 1: Cur pos 38.87 -> 38.38, P = 14.43 88865190 shelly_hap_window_c:599 Moving to 0, p 13.79 89165153 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 89266509 shelly_hap_window_c:336 WC 1: Cur pos 34.86 -> 34.49, P = 13.84 89666539 shelly_hap_window_c:586 Obstruction: p = 23.74 t = 13887 89672862 shelly_hap_window_c:327 WC 1: State: moving -> stop (23 -> 24) 89764592 shelly_output.cpp:63 Output 1: on -> off (stop) 89928625 mgos_sys_config.c:323 Saved to conf9.json 89936513 shelly_hap_window_c:327 WC 1: State: stop -> stopping (24 -> 25) 89956001 shelly_hap_window_c:327 WC 1: State: stopping -> idle (25 -> 0) 89964536 shelly_hap_window_c:327 WC 1: State: idle -> error (0 -> 100) 90065621 shelly_hap_window_c:347 WC 1: Tgt pos 0.00 -> 32.55 (error) 90072399 shelly_hap_window_c:327 WC 1: State: error -> idle (100 -> 0) 90164676 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 90504332 shelly_main.cpp:526 Up 90.49, HAP 0/5/12 ns 5, RAM: 24296/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:32.55 tp:32.55 md:0 lemd:0 lhmd:0 91187363 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 92166620 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 93166252 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 98504232 shelly_main.cpp:526 Up 98.49, HAP 0/5/12 ns 5, RAM: 24344/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:32.55 tp:32.55 md:0 lemd:0 lhmd:0 102589304 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 103602159 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 103690317 mg_rpc.c:310 Shelly.SetState via WS_in 192.168.0.3:64176 103697555 shelly_hap_window_c:347 WC 1: Tgt pos 32.55 -> 100.00 (RPC) 103765004 shelly_hap_window_c:327 WC 1: State: idle -> move (0 -> 20) 103864293 shelly_output.cpp:63 Output 2: off -> on (move) 103870870 shelly_hap_window_c:327 WC 1: State: move -> rampup (20 -> 22) 103911604 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 103964867 shelly_hap_window_c:549 P = 13.99 -> 8.43 103971413 shelly_hap_window_c:327 WC 1: State: rampup -> moving (22 -> 23) 104066967 shelly_hap_window_c:599 Moving to 100, p 1.61 104366368 shelly_hap_window_c:336 WC 1: Cur pos 33.95 -> 34.43, P = 13.34 104590329 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 104865376 shelly_hap_window_c:599 Moving to 100, p 6.93 105166323 shelly_hap_window_c:336 WC 1: Cur pos 37.83 -> 38.31, P = 7.71 105590941 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 105665348 shelly_hap_window_c:599 Moving to 100, p 8.56 105966492 shelly_hap_window_c:336 WC 1: Cur pos 41.72 -> 42.20, P = 8.72 106465325 shelly_hap_window_c:599 Moving to 100, p 8.13 106505904 shelly_main.cpp:526 Up 106.49, HAP 0/5/12 ns 5, RAM: 24296/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:44.63 tp:100.00 md:1 lemd:0 lhmd:0 106610289 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 106766692 shelly_hap_window_c:336 WC 1: Cur pos 45.60 -> 46.08, P = 8.35 107265177 shelly_hap_window_c:599 Moving to 100, p 8.82 107567067 shelly_hap_window_c:336 WC 1: Cur pos 49.48 -> 49.97, P = 8.65 107597589 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 108065123 shelly_hap_window_c:599 Moving to 100, p 9.44 108366352 shelly_hap_window_c:336 WC 1: Cur pos 53.37 -> 53.85, P = 9.91 108609422 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 108865145 shelly_hap_window_c:599 Moving to 100, p 9.79 109166356 shelly_hap_window_c:336 WC 1: Cur pos 57.26 -> 57.74, P = 10.01 109603586 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 109666677 shelly_hap_window_c:599 Moving to 100, p 10.48 109966595 shelly_hap_window_c:336 WC 1: Cur pos 61.14 -> 61.63, P = 10.88 110465228 shelly_hap_window_c:599 Moving to 100, p 11.07 110600724 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 110766685 shelly_hap_window_c:336 WC 1: Cur pos 65.03 -> 65.51, P = 10.90 111265339 shelly_hap_window_c:599 Moving to 100, p 11.02 111566769 shelly_hap_window_c:336 WC 1: Cur pos 68.91 -> 69.40, P = 10.96 111604978 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 112065605 shelly_hap_window_c:599 Moving to 100, p 10.19 112366534 shelly_hap_window_c:336 WC 1: Cur pos 72.80 -> 73.28, P = 10.27 112610755 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 112865615 shelly_hap_window_c:599 Moving to 100, p 10.77 113166437 shelly_hap_window_c:336 WC 1: Cur pos 76.68 -> 77.17, P = 10.62 113609608 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 113665417 shelly_hap_window_c:599 Moving to 100, p 10.09 113966408 shelly_hap_window_c:336 WC 1: Cur pos 80.57 -> 81.05, P = 10.38 114465399 shelly_hap_window_c:599 Moving to 100, p 10.63 114504502 shelly_main.cpp:526 Up 114.49, HAP 0/5/12 ns 5, RAM: 24096/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:83.49 tp:100.00 md:1 lemd:0 lhmd:0 114602388 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 114766640 shelly_hap_window_c:336 WC 1: Cur pos 84.45 -> 84.94, P = 10.24 115265008 shelly_hap_window_c:599 Moving to 100, p 10.52 115567221 shelly_hap_window_c:336 WC 1: Cur pos 88.34 -> 88.83, P = 10.49 115612009 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 116065593 shelly_hap_window_c:599 Moving to 100, p 10.65 116366460 shelly_hap_window_c:336 WC 1: Cur pos 92.22 -> 92.71, P = 10.59 116603874 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 116865442 shelly_hap_window_c:599 Moving to 100, p 10.63 117166561 shelly_hap_window_c:336 WC 1: Cur pos 96.11 -> 96.60, P = 10.38 117603571 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 117665800 shelly_hap_window_c:599 Moving to 100, p 10.57 117966781 shelly_hap_window_c:336 WC 1: Cur pos 100.00 -> 100.00, P = 10.35 118465236 shelly_hap_window_c:599 Moving to 100, p 10.45 118631697 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 119265261 shelly_hap_window_c:599 Moving to 100, p 1.07 119365290 shelly_output.cpp:63 Output 2: on -> off (moving) 119372045 shelly_hap_window_c:327 WC 1: State: moving -> stop (23 -> 24) 119621782 mgos_sys_config.c:323 Saved to conf9.json 119629859 shelly_hap_window_c:327 WC 1: State: stop -> stopping (24 -> 25) 119650101 shelly_hap_window_c:327 WC 1: State: stopping -> idle (25 -> 0) 119958610 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 120633470 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 121613271 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 122504582 shelly_main.cpp:526 Up 122.49, HAP 0/5/12 ns 5, RAM: 24344/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00 md:0 lemd:0 lhmd:0 125533571 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 126292124 mg_rpc.c:310 Shelly.SetState via WS_in 192.168.0.3:64176 126299305 shelly_hap_window_c:347 WC 1: Tgt pos 100.00 -> 0.00 (RPC) 126369763 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 126392240 shelly_hap_window_c:327 WC 1: State: idle -> move (0 -> 20) 126466796 shelly_output.cpp:63 Output 1: off -> on (move) 126473194 shelly_hap_window_c:327 WC 1: State: move -> rampup (20 -> 22) 126556499 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 126583103 shelly_hap_window_c:549 P = 5.97 -> 8.43 126664770 shelly_hap_window_c:549 P = 2.66 -> 8.43 126764470 shelly_hap_window_c:549 P = 17.43 -> 8.43 126770965 shelly_hap_window_c:327 WC 1: State: rampup -> moving (22 -> 23) 127465346 shelly_hap_window_c:599 Moving to 0, p 10.02 127535957 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 127556371 mgos_mongoose.c:66 New heap free LWM: 17568 127566347 shelly_hap_window_c:336 WC 1: Cur pos 96.66 -> 96.18, P = 9.66 128265180 shelly_hap_window_c:599 Moving to 0, p 10.18 128367678 shelly_hap_window_c:336 WC 1: Cur pos 92.78 -> 92.29, P = 10.01 128536986 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 129065684 shelly_hap_window_c:599 Moving to 0, p 10.57 129166633 shelly_hap_window_c:336 WC 1: Cur pos 88.89 -> 88.41, P = 10.36 129557050 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 129865089 shelly_hap_window_c:599 Moving to 0, p 10.73 129966577 shelly_hap_window_c:336 WC 1: Cur pos 85.01 -> 84.52, P = 10.49 130504378 shelly_main.cpp:526 Up 130.49, HAP 0/5/12 ns 5, RAM: 23496/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:82.09 tp:0.00 md:2 lemd:0 lhmd:0 130536132 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 130665141 shelly_hap_window_c:599 Moving to 0, p 11.04 130766845 shelly_hap_window_c:336 WC 1: Cur pos 81.12 -> 80.64, P = 10.79 131465423 shelly_hap_window_c:599 Moving to 0, p 11.46 131536403 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 131566798 shelly_hap_window_c:336 WC 1: Cur pos 77.24 -> 76.75, P = 11.48 132265124 shelly_hap_window_c:599 Moving to 0, p 11.34 132366710 shelly_hap_window_c:336 WC 1: Cur pos 73.35 -> 72.86, P = 11.43 132559171 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 133065759 shelly_hap_window_c:599 Moving to 0, p 11.71 133166711 shelly_hap_window_c:336 WC 1: Cur pos 69.46 -> 68.98, P = 11.82 133551711 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 133865260 shelly_hap_window_c:599 Moving to 0, p 11.30 133966877 shelly_hap_window_c:336 WC 1: Cur pos 65.58 -> 65.09, P = 11.46 134466523 shelly_hap_window_c:586 Obstruction: p = 24.35 t = 7687 134472856 shelly_hap_window_c:327 WC 1: State: moving -> stop (23 -> 24) 134537211 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 134564084 shelly_output.cpp:63 Output 1: on -> off (stop) 134728583 mgos_sys_config.c:323 Saved to conf9.json 134736490 shelly_hap_window_c:327 WC 1: State: stop -> stopping (24 -> 25) 134757847 shelly_hap_window_c:327 WC 1: State: stopping -> idle (25 -> 0) 134770714 shelly_hap_window_c:327 WC 1: State: idle -> error (0 -> 100) 134865774 shelly_hap_window_c:347 WC 1: Tgt pos 0.00 -> 62.66 (error) 134872570 shelly_hap_window_c:327 WC 1: State: error -> idle (100 -> 0) 135558612 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 136538859 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 137545467 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 138504255 shelly_main.cpp:526 Up 138.49, HAP 0/5/12 ns 5, RAM: 23544/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:62.66 tp:62.66 md:0 lemd:0 lhmd:0 138557973 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 139377345 HAPPlatformTCPStrea:105 0x3fff5c9c 192.168.0.119:51717 HAP connection closed, ns 0/5/12 i 2 139385300 HAPPlatformTCPStrea:303 HAPPlatformTCPStreamClose ts 0x3fff5264 nc 0x0 0/4/12 139394774 HAPPlatformTCPStrea:105 0x3fff5dcc 192.168.0.119:51718 HAP connection closed, ns 0/4/12 i 2 139402301 HAPPlatformTCPStrea:303 HAPPlatformTCPStreamClose ts 0x3fff20dc nc 0x0 0/3/12 139543020 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 139708984 mg_rpc.c:310 Shelly.SetState via WS_in 192.168.0.3:64176 139716077 shelly_hap_window_c:347 WC 1: Tgt pos 62.66 -> 0.00 (RPC) 139767111 shelly_hap_window_c:327 WC 1: State: idle -> move (0 -> 20) 139782296 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 139864630 shelly_output.cpp:63 Output 1: off -> on (move) 139871374 shelly_hap_window_c:327 WC 1: State: move -> rampup (20 -> 22) 139964666 shelly_hap_window_c:549 P = 10.99 -> 8.43 139971188 shelly_hap_window_c:327 WC 1: State: rampup -> moving (22 -> 23) 140267056 shelly_hap_window_c:336 WC 1: Cur pos 61.76 -> 61.27, P = 9.07 140272046 shelly_hap_window_c:599 Moving to 0, p 9.07 140541200 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 141066939 shelly_hap_window_c:336 WC 1: Cur pos 57.87 -> 57.39, P = 12.16 141072024 shelly_hap_window_c:599 Moving to 0, p 12.16 141561164 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 141866549 shelly_hap_window_c:336 WC 1: Cur pos 53.99 -> 53.50, P = 11.85 141871698 shelly_hap_window_c:599 Moving to 0, p 11.85 142543393 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 142666811 shelly_hap_window_c:336 WC 1: Cur pos 50.09 -> 49.61, P = 15.02 142671939 shelly_hap_window_c:599 Moving to 0, p 15.02 143467136 shelly_hap_window_c:336 WC 1: Cur pos 46.21 -> 45.73, P = 12.77 143472209 shelly_hap_window_c:599 Moving to 0, p 12.77 143541745 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 144266768 shelly_hap_window_c:336 WC 1: Cur pos 42.33 -> 41.84, P = 9.90 144271773 shelly_hap_window_c:599 Moving to 0, p 9.90 144553164 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 145067004 shelly_hap_window_c:336 WC 1: Cur pos 38.44 -> 37.96, P = 12.10 145072136 shelly_hap_window_c:599 Moving to 0, p 12.10 145661632 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 145866848 shelly_hap_window_c:336 WC 1: Cur pos 34.56 -> 34.07, P = 12.80 145871712 shelly_hap_window_c:599 Moving to 0, p 12.80 145888204 mgos_mongoose.c:66 New heap free LWM: 17280 146504226 shelly_main.cpp:526 Up 146.49, HAP 0/3/12 ns 3, RAM: 24280/41872; st 55; 4.1: c:1 mp:8.43 mt_ms:20589 cp:31.16 tp:0.00 md:2 lemd:0 lhmd:0 146555986 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 146667421 shelly_hap_window_c:336 WC 1: Cur pos 30.59 -> 30.19, P = 13.35 146672513 shelly_hap_window_c:599 Moving to 0, p 13.35 147466822 shelly_hap_window_c:336 WC 1: Cur pos 26.78 -> 26.30, P = 12.69 147471935 shelly_hap_window_c:599 Moving to 0, p 12.69 147560673 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 148267097 shelly_hap_window_c:336 WC 1: Cur pos 22.90 -> 22.41, P = 0.00 148271907 shelly_hap_window_c:599 Moving to 0, p 0.00 148276953 shelly_output.cpp:63 Output 1: on -> off (moving) 148283460 shelly_hap_window_c:327 WC 1: State: moving -> stop (23 -> 24) 148522124 mgos_sys_config.c:323 Saved to conf9.json 148530220 shelly_hap_window_c:327 WC 1: State: stop -> stopping (24 -> 25) 148546259 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 148570498 shelly_hap_window_c:327 WC 1: State: stopping -> idle (25 -> 0) 149666760 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 150561471 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 151544434 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 153610049 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 154504253 shelly_main.cpp:526 Up 154.49, HAP 0/3/12 ns 3, RAM: 24332/41872; st 55; 4.1: c:1 mp:8.43 mt_ms:20589 cp:0.00 tp:0.00 md:0 lemd:0 lhmd:0 154607751 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 155578911 mg_rpc.c:310 Shelly.SetState via WS_in 192.168.0.3:64176 155586067 shelly_hap_window_c:347 WC 1: Tgt pos 0.00 -> 100.00 (RPC) 155616601 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 155671825 shelly_hap_window_c:327 WC 1: State: idle -> move (0 -> 20) 155768263 shelly_output.cpp:63 Output 2: off -> on (move) 155774980 shelly_hap_window_c:327 WC 1: State: move -> rampup (20 -> 22) 155869118 shelly_hap_window_c:549 P = 10.94 -> 8.43 155875647 shelly_hap_window_c:327 WC 1: State: rampup -> moving (22 -> 23) 156571181 shelly_hap_window_c:336 WC 1: Cur pos 2.85 -> 3.34, P = 5.20 156613708 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 156669751 shelly_hap_window_c:599 Moving to 100, p 6.28 157370598 shelly_hap_window_c:336 WC 1: Cur pos 6.73 -> 7.22, P = 8.41 157469678 shelly_hap_window_c:599 Moving to 100, p 8.32 157685420 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 158170524 shelly_hap_window_c:336 WC 1: Cur pos 10.62 -> 11.10, P = 7.71 158269584 shelly_hap_window_c:599 Moving to 100, p 7.69 158747158 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 158970759 shelly_hap_window_c:336 WC 1: Cur pos 14.51 -> 14.99, P = 7.94 159069091 shelly_hap_window_c:599 Moving to 100, p 8.34 159771026 shelly_hap_window_c:336 WC 1: Cur pos 18.39 -> 18.88, P = 8.65 159869142 shelly_hap_window_c:599 Moving to 100, p 8.77 160570821 shelly_hap_window_c:336 WC 1: Cur pos 22.28 -> 22.76, P = 9.40 160613144 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 160669991 shelly_hap_window_c:599 Moving to 100, p 9.04 161370779 shelly_hap_window_c:336 WC 1: Cur pos 26.16 -> 26.65, P = 10.11 161469615 shelly_hap_window_c:599 Moving to 100, p 10.39 161614173 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 162170638 shelly_hap_window_c:336 WC 1: Cur pos 30.05 -> 30.53, P = 10.16 162269356 shelly_hap_window_c:599 Moving to 100, p 10.66 162504554 shelly_main.cpp:526 Up 162.49, HAP 0/3/12 ns 3, RAM: 24280/41872; st 55; 4.1: c:1 mp:8.43 mt_ms:20589 cp:31.99 tp:100.00 md:1 lemd:0 lhmd:0 162612532 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 162972185 shelly_hap_window_c:336 WC 1: Cur pos 33.94 -> 34.43, P = 10.60 163069168 shelly_hap_window_c:599 Moving to 100, p 10.29 163622293 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 163770724 shelly_hap_window_c:336 WC 1: Cur pos 37.82 -> 38.30, P = 10.40 163869714 shelly_hap_window_c:599 Moving to 100, p 10.34 164570567 shelly_hap_window_c:336 WC 1: Cur pos 41.71 -> 42.19, P = 10.32 164613890 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 164669813 shelly_hap_window_c:599 Moving to 100, p 10.36 165370733 shelly_hap_window_c:336 WC 1: Cur pos 45.59 -> 46.07, P = 10.54 165469238 shelly_hap_window_c:599 Moving to 100, p 10.25 165615219 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 166170694 shelly_hap_window_c:336 WC 1: Cur pos 49.48 -> 49.96, P = 10.14 166269294 shelly_hap_window_c:599 Moving to 100, p 9.92 166616450 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 166970721 shelly_hap_window_c:336 WC 1: Cur pos 53.36 -> 53.84, P = 10.13 167069302 shelly_hap_window_c:599 Moving to 100, p 10.26 167734657 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 167770762 shelly_hap_window_c:336 WC 1: Cur pos 57.24 -> 57.73, P = 9.88 167869537 shelly_hap_window_c:599 Moving to 100, p 9.73 168570561 shelly_hap_window_c:336 WC 1: Cur pos 61.13 -> 61.62, P = 10.37 168616269 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 168669756 shelly_hap_window_c:599 Moving to 100, p 10.04 169370646 shelly_hap_window_c:336 WC 1: Cur pos 65.02 -> 65.50, P = 9.80 169469208 shelly_hap_window_c:599 Moving to 100, p 9.90 169616312 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 170170595 shelly_hap_window_c:336 WC 1: Cur pos 68.91 -> 69.39, P = 9.95 170269601 shelly_hap_window_c:599 Moving to 100, p 10.29 170504677 shelly_main.cpp:526 Up 170.49, HAP 0/3/12 ns 3, RAM: 24284/41872; st 55; 4.1: c:1 mp:8.43 mt_ms:20589 cp:70.84 tp:100.00 md:1 lemd:0 lhmd:0 170617181 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 170970675 shelly_hap_window_c:336 WC 1: Cur pos 72.79 -> 73.27, P = 10.52 171069266 shelly_hap_window_c:599 Moving to 100, p 10.20 171622253 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 171770782 shelly_hap_window_c:336 WC 1: Cur pos 76.67 -> 77.16, P = 10.15 171869665 shelly_hap_window_c:599 Moving to 100, p 10.32 172570991 shelly_hap_window_c:336 WC 1: Cur pos 80.56 -> 81.05, P = 9.68 172617150 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 172669632 shelly_hap_window_c:599 Moving to 100, p 9.63 173370480 shelly_hap_window_c:336 WC 1: Cur pos 84.45 -> 84.93, P = 1.09 173469209 shelly_hap_window_c:599 Moving to 100, p 1.15 173617359 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 173870371 shelly_output.cpp:63 Output 2: on -> off (moving) 173877239 shelly_hap_window_c:327 WC 1: State: moving -> stop (23 -> 24) 174126533 mgos_sys_config.c:323 Saved to conf9.json 174134630 shelly_hap_window_c:327 WC 1: State: stop -> stopping (24 -> 25) 174150025 shelly_hap_window_c:327 WC 1: State: stopping -> idle (25 -> 0) 174627382 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 175621139 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 176833063 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 178504640 shelly_main.cpp:526 Up 178.49, HAP 0/3/12 ns 3, RAM: 24332/41872; st 55; 4.1: c:1 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00 md:0 lemd:0 lhmd:0 179739547 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:64176 186504515 shelly_main.cpp:526 Up 186.49, HAP 0/3/12 ns 3, RAM: 24332/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00 md:0 lemd:0 lhmd:0 194504407 shelly_main.cpp:526 Up 194.49, HAP 0/3/12 ns 3, RAM: 24332/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00 md:0 lemd:0 lhmd:0 202504330 shelly_main.cpp:526 Up 202.49, HAP 0/3/12 ns 3, RAM: 24332/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00 md:0 lemd:0 lhmd:0 210504706 shelly_main.cpp:526 Up 210.49, HAP 0/3/12 ns 3, RAM: 24332/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00 md:0 lemd:0 lhmd:0 218504344 shelly_main.cpp:526 Up 218.49, HAP 0/3/12 ns 3, RAM: 24332/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00 md:0 lemd:0 lhmd:0 219664022 mgos_http_server.c:180 0x3fff59fc HTTP connection from 192.168.0.3:64187 219671289 mgos_http_server.c:180 0x3fff5dcc HTTP connection from 192.168.0.3:64188 219678039 mgos_http_server.c:180 0x3fff5c9c HTTP connection from 192.168.0.3:64189 219684977 mgos_http_server.c:180 0x3fff5a84 HTTP connection from 192.168.0.3:64190 220624931 shelly_debug.cpp:231 No log file, sending new entries 226504489 shelly_main.cpp:526 Up 226.49, HAP 0/3/12 ns 3, RAM: 23464/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00 md:0 lemd:0 lhmd:0 234504581 shelly_main.cpp:526 Up 234.49, HAP 0/3/12 ns 3, RAM: 24008/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00 md:0 lemd:0 lhmd:0 242504468 shelly_main.cpp:526 Up 242.49, HAP 0/3/12 ns 3, RAM: 24008/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00 md:0 lemd:0 lhmd:0 250504619 shelly_main.cpp:526 Up 250.49, HAP 0/3/12 ns 3, RAM: 24500/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00 md:0 lemd:0 lhmd:0 251395237 HAPPlatformTCPStrea:105 0x3fff5154 192.168.0.78:49980 HAP connection closed, ns 0/3/12 i 2 251404732 HAPPlatformTCPStrea:303 HAPPlatformTCPStreamClose ts 0x3fff616c nc 0x0 0/2/12 258504564 shelly_main.cpp:526 Up 258.49, HAP 0/2/12 ns 2, RAM: 25696/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00 md:0 lemd:0 lhmd:0 266504262 shelly_main.cpp:526 Up 266.49, HAP 0/2/12 ns 2, RAM: 25696/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00 md:0 lemd:0 lhmd:0 274504514 shelly_main.cpp:526 Up 274.49, HAP 0/2/12 ns 2, RAM: 25696/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00 md:0 lemd:0 lhmd:0 282504343 shelly_main.cpp:526 Up 282.49, HAP 0/2/12 ns 2, RAM: 25696/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00 md:0 lemd:0 lhmd:0 290504335 shelly_main.cpp:526 Up 290.49, HAP 0/2/12 ns 2, RAM: 25696/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00

rojer commented 2 years ago

@lucaspinelli85 "obstruction" condition is raised if we detect high power consumption during movement. in this case, during calibration we determined that normal power consumption is 8.43 watts but at some point it spikes to over 24:

89666539 shelly_hap_window_c:586 Obstruction: p = 23.74 t = 13887
...
134466523 shelly_hap_window_c:586 Obstruction: p = 24.35 t = 7687

this is over 2.5 times the normal, so movement is stopped. the real question is why power spikes so high compared to normal. it's also strange that calibrated power value is just 8 watts, i see values > 10 consistently during movement in both directions. can you run calibration and post the log?

lucaspinelli85 commented 2 years ago

Thanks for your answer. My avg power is 8w, so I set the threshold to 5w otherwise the calibration was not successful (default is 10w). I have no idea why it goes above 20w, but there is no obstacle! Is there a "curl" in which I can raise the maximum threshold? Sorry for the off-topic, I thought it was a firmware problem ...image

rojer commented 2 years ago

@lucaspinelli85 makes sense. but based on th elogs you posted it should calibrate to something higher, more like 10. in which case obstruction detection would not kick in. can you run calibration and post the logs? i'd like to understand why it comes up with 8 as average power consumption.

the obstruction detection threshold is fixed at 2.5 for the moment, there is no config value for it. we can always add one, but before we go for that, i'm thinking - if this is indeed just a short term spike, we may be able to get over it by being a bit more patient. currently if at any point we measure p > mp * 2.5, we panic and declare obstruction. but instead, maybe we should keep a moving average over a few seconds, to smooth out short spikes. let me try it.

p.s. i lowered the default idle power threshold to 5 so you won't need to adjust it manually in newer version.

lucaspinelli85 commented 2 years ago

This il log of calibration but he did not go all the way, he did not reach the limit switch...

8528510749 shelly_debug.cpp:231 No log file, sending new entries 8530504409 shelly_main.cpp:526 Up 8530.49, HAP 0/3/12 ns 3, RAM: 25316/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00 md:0 lemd:0 lhmd:0 8538504353 shelly_main.cpp:526 Up 8538.49, HAP 0/3/12 ns 3, RAM: 25316/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00 md:0 lemd:0 lhmd:0 8546504439 shelly_main.cpp:526 Up 8546.49, HAP 0/3/12 ns 3, RAM: 25316/41872; st 53; 4.1: c:1 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00 md:0 lemd:0 lhmd:0 8550103004 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8551101541 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8552127027 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8553153222 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8554161279 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8554504522 shelly_main.cpp:526 Up 8554.49, HAP 0/3/12 ns 3, RAM: 25316/41872; st 54; 4.1: c:1 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00 md:0 lemd:0 lhmd:0 8555189567 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8556211373 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8557221273 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8557913664 mg_rpc.c:310 Shelly.SetState via WS_in 192.168.0.3:65080 8557933007 shelly_hap_window_c:327 WC 1: State: idle -> precal0 (0 -> 10) 8557959776 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8558031432 shelly_hap_window_c:449 Begin calibration 8558189738 mgos_sys_config.c:323 Saved to conf9.json 8558196787 shelly_output.cpp:63 Output 2: off -> on (precal0) 8558202815 shelly_hap_window_c:327 WC 1: State: precal0 -> cal0 (10 -> 11) 8558216318 shelly_hap_window_c:465 WC 1: P0 = 1.238 8558253344 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8558933006 shelly_hap_window_c:465 WC 1: P0 = 1.189 8559261218 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8559732700 shelly_hap_window_c:465 WC 1: P0 = 1.067 8560292437 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8560532293 shelly_hap_window_c:465 WC 1: P0 = 1.116 8561307150 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8561332465 shelly_hap_window_c:465 WC 1: P0 = 1.030 8562132515 shelly_hap_window_c:465 WC 1: P0 = 1.335 8562334717 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8562504496 shelly_main.cpp:526 Up 8562.49, HAP 0/3/12 ns 3, RAM: 25316/41872; st 54; 4.1: c:0 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00 md:0 lemd:0 lhmd:0 8562932536 shelly_hap_window_c:465 WC 1: P0 = 1.268 8563359903 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8563732568 shelly_hap_window_c:465 WC 1: P0 = 1.213 8564360615 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8564532443 shelly_hap_window_c:465 WC 1: P0 = 1.165 8565332222 shelly_hap_window_c:465 WC 1: P0 = 1.079 8565379995 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8566132441 shelly_hap_window_c:465 WC 1: P0 = 1.159 8566332844 shelly_output.cpp:63 Output 2: on -> off (cal0) 8566339268 shelly_hap_window_c:327 WC 1: State: cal0 -> postcal0 (11 -> 12) 8566401692 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8566433468 shelly_hap_window_c:327 WC 1: State: postcal0 -> precal1 (12 -> 13) 8566532319 shelly_output.cpp:63 Output 1: off -> on (precal1) 8566538663 shelly_hap_window_c:327 WC 1: State: precal1 -> cal1 (13 -> 14) 8566633034 shelly_hap_window_c:496 WC 1: P1 = 13.128 8567429526 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8567453014 shelly_hap_window_c:496 WC 1: P1 = 11.335 8568232678 shelly_hap_window_c:496 WC 1: P1 = 10.976 8569033433 shelly_hap_window_c:496 WC 1: P1 = 11.189 8569460477 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8569832674 shelly_hap_window_c:496 WC 1: P1 = 10.988 8570504907 shelly_main.cpp:526 Up 8570.49, HAP 0/3/12 ns 3, RAM: 23736/41872; st 54; 4.1: c:0 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00 md:0 lemd:0 lhmd:0 8570632723 shelly_hap_window_c:496 WC 1: P1 = 10.677 8571433059 shelly_hap_window_c:496 WC 1: P1 = 10.518 8571500556 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8572232588 shelly_hap_window_c:496 WC 1: P1 = 10.848 8572525187 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8572549867 shelly_output.cpp:63 Output 1: on -> off (cal1) 8572558362 shelly_hap_window_c:500 WC 1: calibration done, move_time 6005, move_power 10.876 8572564557 shelly_hap_window_c:327 WC 1: State: cal1 -> postcal1 (14 -> 15) 8572789844 mgos_sys_config.c:323 Saved to conf9.json 8572798485 shelly_hap_window_c:347 WC 1: Tgt pos 100.00 -> 50.00 (postcal1) 8572804804 shelly_hap_window_c:327 WC 1: State: postcal1 -> idle (15 -> 0) 8572818560 shelly_hap_window_c:327 WC 1: State: idle -> move (0 -> 20) 8572831476 shelly_output.cpp:63 Output 2: off -> on (move) 8572837490 shelly_hap_window_c:327 WC 1: State: move -> rampup (20 -> 22) 8572933088 shelly_hap_window_c:549 P = 9.34 -> 10.88 8572939568 shelly_hap_window_c:327 WC 1: State: rampup -> moving (22 -> 23) 8573034534 shelly_hap_window_c:336 WC 1: Cur pos 0.00 -> 1.43, P = 1.41 8573549858 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8573834979 shelly_hap_window_c:336 WC 1: Cur pos 13.09 -> 14.77, P = 6.47 8574561945 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8574634545 shelly_hap_window_c:336 WC 1: Cur pos 26.41 -> 28.08, P = 5.81 8575434671 shelly_hap_window_c:336 WC 1: Cur pos 39.73 -> 41.42, P = 8.09 8575582572 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8575934545 shelly_hap_window_c:347 WC 1: Tgt pos 50.00 -> 49.73 (fixup) 8575940052 shelly_output.cpp:63 Output 2: on -> off (moving) 8575945894 shelly_hap_window_c:327 WC 1: State: moving -> stop (23 -> 24) 8576190340 mgos_sys_config.c:323 Saved to conf9.json 8576198417 shelly_hap_window_c:327 WC 1: State: stop -> stopping (24 -> 25) 8576213335 shelly_hap_window_c:327 WC 1: State: stopping -> idle (25 -> 0) 8576607727 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8577628175 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8578504460 shelly_main.cpp:526 Up 8578.49, HAP 0/3/12 ns 3, RAM: 25316/41872; st 54; 4.1: c:1 mp:10.88 mt_ms:6005 cp:49.73 tp:49.73 md:0 lemd:0 lhmd:0 8578642216 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8579712589 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8580689520 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8581709218 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8582728037 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8583741143 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8584799343 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080 8586504437 shelly_main.cpp:526 Up 8586.49, HAP 0/3/12 ns 3, RAM: 25316/41872; st 54; 4.1: c:1 mp:10.88 mt_ms:6005 cp:49.73 tp:49.73 md:0 lemd:0 lhmd:0 8594504588 shelly_main.cpp:526 Up 8594.49, HAP 0/3/12 ns 3, RAM: 25316/41872; st 54; 4.1: c:1 mp:10.88 mt_ms:6005 cp:49.73 tp:49.73 md:0 lemd:0 lhmd:0 8602504240 shelly_main.cpp:526 Up 8602.49, HAP 0/3/12 ns 3, RAM: 25316/41872; st 54; 4.1: c:1 mp:10.88 mt_ms:6005 cp:49.73 tp:49.73 md:0 lemd:0 lhmd:0 8610504129 shelly_main.cpp:526 Up 8610.49, HAP 0/3/12 ns 3, RAM: 25316/41872; st 54; 4.1: c:1 mp:10.88 mt_ms:6005 cp:49.73 tp:49.73 md:0 lemd:0 lhmd:0 8618504731 shelly_main.cpp:526 Up 8618.49, HAP 0/3/12 ns 3, RAM: 25316/41872; st 54; 4.1: c:1 mp:10.88 mt_ms:6005 cp:49.73 tp:49.73 md:0 lemd:0 lhmd:0 8626504316 shelly_main.cpp:526 Up 8626.49, HAP 0/3/12 ns 3, RAM: 25316/41872; st 54; 4.1: c:1 mp:10.88 mt_ms:6005 cp:49.73 tp:49.73 md:0 lemd:0 lhmd:0 8634504629 shelly_main.cpp:526 Up 8634.49, HAP 0/3/12 ns 3, RAM: 25316/41872; st 54; 4.1: c:1 mp:10.88 mt_ms:6005 cp:49.73 tp:49.73 md:0 lemd:0 lhmd:0 8642504624 shelly_main.cpp:526 Up 8642.49, HAP 0/3/12 ns 3, RAM: 25316/41872; st 54; 4.1: c:1 mp:10.88 mt_ms:6005 cp:49.73 tp:49.73 md:0 lemd:0 lhmd:0 8650504317 shelly_main.cpp:526 Up 8650.49, HAP 0/3/12 ns 3, RAM: 25316/41872; st 54; 4.1: c:1 mp:10.88 mt_ms:6005 cp:49.73 tp:49.73 md:0 lemd:0 lhmd:0 8658504103 shelly_main.cpp:526 Up 8658.49, HAP 0/3/12 ns 3, RAM: 25316/41872; st 53; 4.1: c:1 mp:10.88 mt_ms:6005 cp:49.73 tp:49.73 md:0 lemd:0 lhmd:0 8666504196 shelly_main.cpp:526 Up 8666.49, HAP 0/3/12 ns 3, RAM: 25316/41872; st 53; 4.1: c:1 mp:10.88 mt_ms:6005 cp:49.73 tp:49.73 md:0 lemd:0 lhmd:0 8674504389 shelly_main.cpp:526 Up 8674.49, HAP 0/3/12 ns 3, RAM: 25316/41872; st 54; 4.1: c:1 mp:10.88 mt_ms:6005 cp:49.73 tp:49.73 md:0 lemd:0 lhmd:0 8682504110 shelly_main.cpp:526 Up 8682.49, HAP 0/3/12 ns 3, RAM: 25316/41872; st 53; 4.1: c:1 mp:10.88 mt_ms:6005 cp:49.73 tp:49.73 md:0 lemd:0 lhmd:0 8690504170 shelly_main.cpp:526 Up 8690.49, HAP 0/3/12 ns 3, RAM: 25316/41872; st 53; 4.1: c:1 mp:10.88 mt_ms:6005 cp:49.73 tp:49.73 md:0 lemd:0 lhmd:0 8698504561 shelly_main.cpp:526 Up 8698.49, HAP 0/3/12 ns 3, RAM: 25316/41872; st 53; 4.1: c:1 mp:10.88 mt_ms:6005 cp:49.73 tp:49.73 md:0 lemd:0 lhmd:0 8706504495 shelly_main.cpp:526 Up 8706.49, HAP 0/3/12 ns 3, RAM: 25316/41872; st 53; 4.1: c:1 mp:10.88 mt_ms:6005 cp:49.73 tp:49.73 md:0 lemd:0 lhmd:0

lucaspinelli85 commented 2 years ago

I repeated the calibration starting from the middle of the stroke instead of from the limit switch. Now it has gone up to 10W, it should be enough, but very close to the limit... Surely being able to evade the peak power, safeguarding the safety of the obstacle, or being able to edit the maximum obstacle intervention threshold would be an improvement. Thanks for the help! Please also take into consideration my other issues regarding roller shutter mode with low power and / or no absorption motors. Happy New Year!!!

rojer commented 2 years ago

@lucaspinelli85 looking at the calibration log, cal0 phase looks weird:

8558196787 shelly_output.cpp:63 Output 2: off -> on (precal0)
8558202815 shelly_hap_window_c:327 WC 1: State: precal0 -> cal0 (10 -> 11)
8558216318 shelly_hap_window_c:465 WC 1: P0 = 1.238
8558253344 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080
8558933006 shelly_hap_window_c:465 WC 1: P0 = 1.189
8559261218 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080
8559732700 shelly_hap_window_c:465 WC 1: P0 = 1.067
8560292437 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080
8560532293 shelly_hap_window_c:465 WC 1: P0 = 1.116
8561307150 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080
8561332465 shelly_hap_window_c:465 WC 1: P0 = 1.030
8562132515 shelly_hap_window_c:465 WC 1: P0 = 1.335
8562334717 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080
8562504496 shelly_main.cpp:526 Up 8562.49, HAP 0/3/12 ns 3, RAM: 25316/41872; st 54; 4.1: c:0 mp:8.43 mt_ms:20589 cp:100.00 tp:100.00 md:0 lemd:0 lhmd:0
8562932536 shelly_hap_window_c:465 WC 1: P0 = 1.268
8563359903 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080
8563732568 shelly_hap_window_c:465 WC 1: P0 = 1.213
8564360615 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080
8564532443 shelly_hap_window_c:465 WC 1: P0 = 1.165
8565332222 shelly_hap_window_c:465 WC 1: P0 = 1.079
8565379995 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65080
8566132441 shelly_hap_window_c:465 WC 1: P0 = 1.159
8566332844 shelly_output.cpp:63 Output 2: on -> off (cal0)
8566339268 shelly_hap_window_c:327 WC 1: State: cal0 -> postcal0 (11 -> 12)

there's barely any power consumed, just 1 watt. this is under even your lower threshold of 5, and stays that way, so in fact it ends early after allowed ramp-up time (5 seconds) expires. looking at your previous log, your motor is consuming about 10W moving in both directions, so what was it doing during these 5 seconds? no idea...

now, i have made a change to obstruction detection to require that overpower condition persists for 3 seconds, and also moved some hard-coded constants into config. here's a build with it: http://rojer.me/files/shelly/misc/shelly25-868.zip can you give it a try?

lucaspinelli85 commented 2 years ago

Yes i try!

lucaspinelli85 commented 2 years ago

this is the log, do you see something strange? now avg power is 9w

51947684 shelly_debug.cpp:231 No log file, sending new entries 57055877 shelly_main.cpp:525 Up 57.04, HAP 0/3/12 ns 3, RAM: 24832/41880; st 55; 4.1: c:1 mp:10.20 ip:1.00 mt_ms:20889 cp:58.41 tp:58.41 md:0 lemd:0 lhmd:0 65056110 shelly_main.cpp:525 Up 65.04, HAP 0/3/12 ns 3, RAM: 24832/41880; st 55; 4.1: c:1 mp:10.20 ip:1.00 mt_ms:20889 cp:58.41 tp:58.41 md:0 lemd:0 lhmd:0 73055984 shelly_main.cpp:525 Up 73.04, HAP 0/3/12 ns 3, RAM: 24832/41880; st 55; 4.1: c:1 mp:10.20 ip:1.00 mt_ms:20889 cp:58.41 tp:58.41 md:0 lemd:0 lhmd:0 76631521 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 77651939 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 78769694 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 79739042 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 80720043 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 81056078 shelly_main.cpp:525 Up 81.04, HAP 0/3/12 ns 3, RAM: 24832/41880; st 55; 4.1: c:1 mp:10.20 ip:1.00 mt_ms:20889 cp:58.41 tp:58.41 md:0 lemd:0 lhmd:0 81176802 mg_rpc.c:310 Shelly.SetState via WS_in 192.168.0.3:65271 81202230 shelly_hap_window_c:327 WC 1: State: idle -> precal0 (0 -> 10) 81214476 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 81300469 shelly_hap_window_c:449 Begin calibration 81463748 mgos_sys_config.c:323 Saved to conf9.json 81470718 shelly_output.cpp:63 Output 2: off -> on (precal0) 81476722 shelly_hap_window_c:327 WC 1: State: precal0 -> cal0 (10 -> 11) 81488274 shelly_hap_window_c:465 WC 1: P0 = 2.817 81737702 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 82201201 shelly_hap_window_c:465 WC 1: P0 = 6.457 82751602 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 83001267 shelly_hap_window_c:465 WC 1: P0 = 7.098 83786443 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 83809898 shelly_hap_window_c:465 WC 1: P0 = 7.055 84601517 shelly_hap_window_c:465 WC 1: P0 = 7.707 84791370 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 85401193 shelly_hap_window_c:465 WC 1: P0 = 8.970 85843659 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 86201276 shelly_hap_window_c:465 WC 1: P0 = 8.591 86831346 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 87001253 shelly_hap_window_c:465 WC 1: P0 = 8.409 87801441 shelly_hap_window_c:465 WC 1: P0 = 8.957 87854066 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 88601491 shelly_hap_window_c:465 WC 1: P0 = 8.201 88886166 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 89055978 shelly_main.cpp:525 Up 89.04, HAP 0/3/12 ns 3, RAM: 24832/41880; st 55; 4.1: c:0 mp:10.20 ip:1.00 mt_ms:20889 cp:58.41 tp:58.41 md:0 lemd:0 lhmd:0 89401244 shelly_hap_window_c:465 WC 1: P0 = 8.409 89891669 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 90204813 shelly_hap_window_c:465 WC 1: P0 = 8.317 90928302 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 91001190 shelly_hap_window_c:465 WC 1: P0 = 1.177 91801179 shelly_hap_window_c:465 WC 1: P0 = 1.360 91931491 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 92601447 shelly_hap_window_c:465 WC 1: P0 = 1.165 92959395 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 93401550 shelly_hap_window_c:465 WC 1: P0 = 1.244 93985507 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 94201302 shelly_hap_window_c:465 WC 1: P0 = 1.110 94998113 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 95022774 shelly_hap_window_c:465 WC 1: P0 = 1.421 95701684 shelly_output.cpp:63 Output 2: on -> off (cal0) 95708187 shelly_hap_window_c:327 WC 1: State: cal0 -> postcal0 (11 -> 12) 95802273 shelly_hap_window_c:327 WC 1: State: postcal0 -> precal1 (12 -> 13) 95900891 shelly_output.cpp:63 Output 1: off -> on (precal1) 95907247 shelly_hap_window_c:327 WC 1: State: precal1 -> cal1 (13 -> 14) 96001766 shelly_hap_window_c:496 WC 1: P1 = 10.024 96013525 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 96801589 shelly_hap_window_c:496 WC 1: P1 = 8.890 97031147 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 97065859 shelly_main.cpp:525 Up 97.05, HAP 0/3/12 ns 3, RAM: 23040/41880; st 55; 4.1: c:0 mp:10.20 ip:1.00 mt_ms:20889 cp:58.41 tp:58.41 md:0 lemd:0 lhmd:0 97601438 shelly_hap_window_c:496 WC 1: P1 = 8.530 98060332 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 98401702 shelly_hap_window_c:496 WC 1: P1 = 9.512 99087054 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 99201506 shelly_hap_window_c:496 WC 1: P1 = 9.707 100001372 shelly_hap_window_c:496 WC 1: P1 = 9.409 100091372 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 100801404 shelly_hap_window_c:496 WC 1: P1 = 9.738 101118623 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 101601584 shelly_hap_window_c:496 WC 1: P1 = 9.372 102140410 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 102401698 shelly_hap_window_c:496 WC 1: P1 = 8.957 103150949 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 103201329 shelly_hap_window_c:496 WC 1: P1 = 9.232 104001581 shelly_hap_window_c:496 WC 1: P1 = 9.482 104183088 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 104801426 shelly_hap_window_c:496 WC 1: P1 = 9.671 105056165 shelly_main.cpp:525 Up 105.04, HAP 0/3/12 ns 3, RAM: 24940/41880; st 55; 4.1: c:0 mp:10.20 ip:1.00 mt_ms:20889 cp:58.41 tp:58.41 md:0 lemd:0 lhmd:0 105203622 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 105601553 shelly_hap_window_c:496 WC 1: P1 = 9.780 106219256 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 106401322 shelly_hap_window_c:496 WC 1: P1 = 9.793 107201247 shelly_hap_window_c:496 WC 1: P1 = 9.896 107240301 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 108001636 shelly_hap_window_c:496 WC 1: P1 = 10.238 108265077 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 108801663 shelly_hap_window_c:496 WC 1: P1 = 10.128 109282722 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 109601256 shelly_hap_window_c:496 WC 1: P1 = 9.707 110299126 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 110401604 shelly_hap_window_c:496 WC 1: P1 = 10.354 111201132 shelly_hap_window_c:496 WC 1: P1 = 9.677 111312834 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 112001521 shelly_hap_window_c:496 WC 1: P1 = 9.805 112338039 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 112801458 shelly_hap_window_c:496 WC 1: P1 = 10.488 113056075 shelly_main.cpp:525 Up 113.04, HAP 0/3/12 ns 3, RAM: 25048/41880; st 55; 4.1: c:0 mp:10.20 ip:1.00 mt_ms:20889 cp:58.41 tp:58.41 md:0 lemd:0 lhmd:0 113356582 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 113601821 shelly_hap_window_c:496 WC 1: P1 = 10.061 114401403 shelly_hap_window_c:496 WC 1: P1 = 10.171 114413297 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 115201474 shelly_hap_window_c:496 WC 1: P1 = 11.165 115400865 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 116001190 shelly_hap_window_c:496 WC 1: P1 = 10.573 116421833 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 116602183 shelly_output.cpp:63 Output 1: on -> off (cal1) 116610697 shelly_hap_window_c:500 WC 1: calibration done, move_time 20689, move_power 9.764 116616894 shelly_hap_window_c:327 WC 1: State: cal1 -> postcal1 (14 -> 15) 116701990 shelly_hap_window_c:336 WC 1: Cur pos 58.41 -> 0.00, P = -1.00 116865163 mgos_sys_config.c:323 Saved to conf9.json 116873416 shelly_hap_window_c:347 WC 1: Tgt pos 58.41 -> 50.00 (postcal1) 116879830 shelly_hap_window_c:327 WC 1: State: postcal1 -> idle (15 -> 0) 116896256 shelly_hap_window_c:327 WC 1: State: idle -> move (0 -> 20) 116902959 shelly_output.cpp:63 Output 2: off -> on (move) 116908993 shelly_hap_window_c:327 WC 1: State: move -> rampup (20 -> 22) 117001285 shelly_hap_window_c:550 P = 13.38 -> 9.76 117007501 shelly_hap_window_c:327 WC 1: State: rampup -> moving (22 -> 23) 117440855 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 117803162 shelly_hap_window_c:336 WC 1: Cur pos 3.32 -> 3.80, P = 6.12 118459831 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 118603168 shelly_hap_window_c:336 WC 1: Cur pos 7.19 -> 7.67, P = 7.29 119403616 shelly_hap_window_c:336 WC 1: Cur pos 11.05 -> 11.54, P = 7.02 119496847 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 120203397 shelly_hap_window_c:336 WC 1: Cur pos 14.92 -> 15.40, P = 6.96 120497633 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 121003253 shelly_hap_window_c:336 WC 1: Cur pos 18.79 -> 19.27, P = 7.96 121056028 shelly_main.cpp:525 Up 121.04, HAP 0/3/12 ns 3, RAM: 24828/41880; st 56; 4.1: c:1 mp:9.76 ip:1.00 mt_ms:20689 cp:19.27 tp:50.00 md:1 lemd:0 lhmd:0 121519625 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 121803309 shelly_hap_window_c:336 WC 1: Cur pos 22.65 -> 23.14, P = 8.65 122539883 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 122603437 shelly_hap_window_c:336 WC 1: Cur pos 26.52 -> 27.00, P = 8.50 123403423 shelly_hap_window_c:336 WC 1: Cur pos 30.39 -> 30.87, P = 9.17 123553898 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 124203440 shelly_hap_window_c:336 WC 1: Cur pos 34.25 -> 34.74, P = 8.57 124596356 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 125003220 shelly_hap_window_c:336 WC 1: Cur pos 38.12 -> 38.61, P = 8.59 125597665 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 125803452 shelly_hap_window_c:336 WC 1: Cur pos 41.99 -> 42.47, P = 8.88 126603198 shelly_hap_window_c:336 WC 1: Cur pos 45.86 -> 46.34, P = 8.21 126619823 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 127303398 shelly_hap_window_c:347 WC 1: Tgt pos 50.00 -> 49.72 (fixup) 127308962 shelly_output.cpp:63 Output 2: on -> off (moving) 127314814 shelly_hap_window_c:327 WC 1: State: moving -> stop (23 -> 24) 127558926 mgos_sys_config.c:323 Saved to conf9.json 127566938 shelly_hap_window_c:327 WC 1: State: stop -> stopping (24 -> 25) 127583270 shelly_hap_window_c:327 WC 1: State: stopping -> idle (25 -> 0) 127637953 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 128659174 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 129056190 shelly_main.cpp:525 Up 129.04, HAP 0/3/12 ns 3, RAM: 25048/41880; st 56; 4.1: c:1 mp:9.76 ip:1.00 mt_ms:20689 cp:49.72 tp:49.72 md:0 lemd:0 lhmd:0 129680535 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 130697709 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 131719013 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 132739187 mg_rpc.c:310 Shelly.GetInfoExt via WS_in 192.168.0.3:65271 137056063 shelly_main.cpp:525 Up 137.04, HAP 0/3/12 ns 3, RAM: 25048/41880; st 56; 4.1: c:1 mp:9.76 ip:1.00 mt_ms:20689 cp:49.72 tp:49.72 md:0 lemd:0 lhmd:0

rojer commented 2 years ago

@lucaspinelli85 everything seems normal. but i also don't see the power spike to 24W during movement, so no real test happened. try a few times, see if you can reproduce the false obstruction detection with the new code.

lucaspinelli85 commented 2 years ago

ok, I'll try to see if I can replicate the peak or if it still happens, or if with this firmware that you changed me it doesn't give any more problems and I'll let you know! Thanks again!

rojer commented 2 years ago

pushed alpha5

lucaspinelli85 commented 2 years ago

ok, I'll try to see if I can replicate the peak or if it still happens, or if with this firmware that you changed me it doesn't give any more problems and I'll let you know! Thanks again!

With firmware "868" I have no longer had problems with obstacles. Is the change also present in alpha5?

rojer commented 2 years ago

yes, it's been merged to master and is present in alpha5 onwards.

bmpalmeida commented 2 years ago

Just a small detail, using the script on the 2.11.0 it no longer reports the RSSI of the devices.

timoschilling commented 2 years ago

@rojer have investigated this?

i've installed alpha4 on a shelly 1PM before setup it on HomeKit, and every time i click setup i receive a request timeout

It's still an issue. Reproducible via:

  1. Take a Stock devise (reverted to stock works too)
  2. flash to 2.10.1 (maybe optional)
  3. flash to 2.11.0-alpha5
  4. open UI
  5. click Setup in HomeKit Settings section
  6. result: Request timeout

Doing the same on the same Shells at the same place but skipping step 3 and using 2.10.1 works. If I reset the device (via System section), bringing back to Wifi and clicking Setup again and it works.

And if I reclick Setup after it has worked one time it timeout again.

rojer commented 2 years ago

@timoschilling thanks! timeout was too short, fixed in alpha6

rojer commented 2 years ago

@bmpalmeida yes, script will need to be adjusted for new format of wifi info and config.

timoschilling commented 2 years ago

@rojer you missed to push the code for alpha6, repo still has only alpha5.

rojer commented 2 years ago

@timoschilling you're right, forgot to push the master branch. done.

rojer commented 2 years ago

pushed alpha7 with fixes for #884