search

wlcrs / huawei_solar

Home Assistant integration for Huawei Solar inverters via Modbus
GNU Affero General Public License v3.0
560 stars 91 forks source link

[Bug]: All sensors become unavailable #140

Closed themaninspain closed 2 years ago

themaninspain commented 2 years ago

System Health details

System Information

version core-2022.9.5
installation_type Home Assistant OS
dev false
hassio true
docker true
user root
virtualenv false
python_version 3.10.5
os_name Linux
os_version 5.15.67
arch x86_64
timezone Europe/Madrid
config_dir /config
Home Assistant Community Store GitHub API | ok -- | -- GitHub Content | ok GitHub Web | ok GitHub API Calls Remaining | 4901 Installed Version | 1.27.2 Stage | running Available Repositories | 1109 Downloaded Repositories | 14
Home Assistant Cloud logged_in | true -- | -- subscription_expiration | September 14, 2023 at 2:00 AM relayer_connected | true remote_enabled | true remote_connected | true alexa_enabled | false google_enabled | true remote_server | eu-central-1-4.ui.nabu.casa can_reach_cert_server | ok can_reach_cloud_auth | ok can_reach_cloud | ok
Home Assistant Supervisor host_os | Home Assistant OS 9.0 -- | -- update_channel | stable supervisor_version | supervisor-2022.08.6 agent_version | 1.3.0 docker_version | 20.10.17 disk_total | 109.3 GB disk_used | 15.4 GB healthy | true supported | true board | generic-x86-64 supervisor_api | ok version_api | ok installed_addons | Check Home Assistant configuration (3.11.0), Network UPS Tools (0.11.0), SSH & Web Terminal (12.0.2), Home Assistant Google Drive Backup (0.108.4), AdGuard Home (4.7.4), SQLite Web (3.6.1), Z-Wave JS (0.1.71)
Dashboards dashboards | 3 -- | -- resources | 3 views | 12 mode | storage
Recorder oldest_recorder_run | September 9, 2022 at 6:17 AM -- | -- current_recorder_run | September 19, 2022 at 12:44 PM estimated_db_size | 188.33 MiB database_engine | sqlite database_version | 3.38.5

Huawei Solar Setup

SUN2000-6KTL-L1, single phase, power meter, no battery. Built in WiFi

Describe the issue

I'm posting this as a bug because the only other option is a feature request. I am not sure if this is a bug or a problem with my installation.

After initialisation sensors show data then become unavailable.

The strange thing is that the energy dashboard does show readings and they correspond with what my utility smart meter shows. Here are some screenshots.

Screenshot 2022-09-19 at 13 43 53 Screenshot 2022-09-19 at 13 20 51

Relevant debug logs

2022-09-19 13:34:42.566 WARNING (SyncWorker_0) [homeassistant.loader] We found a custom integration huawei_solar which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2022-09-19 13:35:44.618 WARNING (MainThread) [homeassistant.bootstrap] Waiting on integrations to complete setup: huawei_solar
2022-09-19 13:36:44.687 WARNING (MainThread) [homeassistant.bootstrap] Waiting on integrations to complete setup: huawei_solar
2022-09-19 13:37:05.229 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 43006
2022-09-19 13:37:05.230 ERROR (MainThread) [huawei_solar.huawei_solar] Modbus client is not connected to the inverter.
2022-09-19 13:37:05.230 ERROR (MainThread) [huawei_solar.huawei_solar] Aborting client creation due to error.
File "/usr/local/lib/python3.10/site-packages/huawei_solar/huawei_solar.py", line 150, in create
await huawei_solar._initialize()
File "/usr/local/lib/python3.10/site-packages/huawei_solar/huawei_solar.py", line 115, in _initialize
File "/usr/local/lib/python3.10/site-packages/huawei_solar/huawei_solar.py", line 245, in get
File "/usr/local/lib/python3.10/site-packages/huawei_solar/huawei_solar.py", line 287, in get_multiple
File "/usr/local/lib/python3.10/site-packages/huawei_solar/huawei_solar.py", line 378, in _read_registers
File "/usr/local/lib/python3.10/site-packages/huawei_solar/huawei_solar.py", line 345, in _do_read
huawei_solar.exceptions.ConnectionException: Modbus client is not connected to the inverter.
2022-09-19 13:37:05.236 WARNING (MainThread) [homeassistant.config_entries] Config entry 'SUN2000-6KTL-L1' for huawei_solar integration not ready yet: Modbus client is not connected to the inverter.; Retrying in background
2022-09-19 13:37:07.001 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 43006
2022-09-19 13:37:12.192 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off reading for 2.0 seconds after 1 tries
2022-09-19 13:37:14.312 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47000
2022-09-19 13:37:14.453 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 30000
2022-09-19 13:37:14.589 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 30071
2022-09-19 13:37:14.688 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37200
2022-09-19 13:37:14.875 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37100
2022-09-19 13:37:14.964 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37125
2022-09-19 13:37:15.292 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47000
2022-09-19 13:37:15.419 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47089
2022-09-19 13:37:15.504 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32064
2022-09-19 13:37:17.570 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32016
2022-09-19 13:37:17.668 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37101
2022-09-19 13:37:17.747 DEBUG (MainThread) [custom_components.huawei_solar] Finished fetching 102160257714_data_update_coordinator data in 2.243 seconds (success: True)
2022-09-19 13:37:17.787 INFO (MainThread) [custom_components.huawei_solar.number] Skipping number setup, as parameter configuration is not enabled
2022-09-19 13:37:17.787 INFO (MainThread) [custom_components.huawei_solar.switch] Skipping switch setup, as parameter configuration is not enabled
2022-09-19 13:37:17.787 INFO (MainThread) [custom_components.huawei_solar.select] Skipping select setup, as parameter configuration is not enabled
2022-09-19 13:37:17.797 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32064
2022-09-19 13:37:20.801 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off reading for 2.0 seconds after 1 tries
2022-09-19 13:37:25.805 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off reading for 2.0 seconds after 2 tries
2022-09-19 13:37:27.760 WARNING (MainThread) [homeassistant.components.sensor] Setup of sensor platform huawei_solar is taking over 10 seconds.
2022-09-19 13:37:30.811 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off reading for 2.0 seconds after 3 tries
2022-09-19 13:37:35.816 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off reading for 2.0 seconds after 4 tries
2022-09-19 13:37:37.797 ERROR (MainThread) [custom_components.huawei_solar] Timeout fetching 102160257714_data_update_coordinator data
2022-09-19 13:37:37.799 DEBUG (MainThread) [custom_components.huawei_solar] Finished fetching 102160257714_data_update_coordinator data in 20.003 seconds (success: False)
2022-09-19 13:37:47.803 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32064
2022-09-19 13:37:50.808 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off reading for 2.0 seconds after 1 tries
2022-09-19 13:37:55.813 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off reading for 2.0 seconds after 2 tries
2022-09-19 13:38:00.819 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off reading for 2.0 seconds after 3 tries
2022-09-19 13:38:05.824 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off reading for 2.0 seconds after 4 tries
2022-09-19 13:38:07.803 DEBUG (MainThread) [custom_components.huawei_solar] Finished fetching 102160257714_data_update_coordinator data in 20.001 seconds (success: False)
2022-09-19 13:38:37.001 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32064
2022-09-19 13:38:40.005 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off reading for 2.0 seconds after 1 tries
2022-09-19 13:38:45.010 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off reading for 2.0 seconds after 2 tries
2022-09-19 13:38:50.014 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off reading for 2.0 seconds after 3 tries
2022-09-19 13:38:55.019 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off reading for 2.0 seconds after 4 tries
2022-09-19 13:38:57.002 DEBUG (MainThread) [custom_components.huawei_solar] Finished fetching 102160257714_data_update_coordinator data in 20.002 seconds (success: False)
2022-09-19 13:39:27.001 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32064
2022-09-19 13:39:27.177 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32016
2022-09-19 13:39:27.275 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37101
2022-09-19 13:39:27.444 INFO (MainThread) [custom_components.huawei_solar] Fetching 102160257714_data_update_coordinator data recovered
2022-09-19 13:39:27.444 DEBUG (MainThread) [custom_components.huawei_solar] Finished fetching 102160257714_data_update_coordinator data in 0.444 seconds (success: True)
2022-09-19 13:39:57.001 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32064
2022-09-19 13:40:00.004 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off reading for 2.0 seconds after 1 tries
2022-09-19 13:40:05.009 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off reading for 2.0 seconds after 2 tries
2022-09-19 13:40:10.022 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off reading for 2.0 seconds after 3 tries
2022-09-19 13:40:15.026 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off reading for 2.0 seconds after 4 tries
2022-09-19 13:40:17.001 ERROR (MainThread) [custom_components.huawei_solar] Timeout fetching 102160257714_data_update_coordinator data
2022-09-19 13:40:17.003 DEBUG (MainThread) [custom_components.huawei_solar] Finished fetching 102160257714_data_update_coordinator data in 20.003 seconds (success: False)

Modbus.py log
2022-09-19 13:34:52.314 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] Connecting to 192.168.42.20:502.
2022-09-19 13:34:52.314 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] Connecting.
2022-09-19 13:37:04.225 WARNING (MainThread) [pymodbus.client.asynchronous.async_io] Failed to connect: [Errno 110] Connect call failed ('192.168.42.20', 502)
2022-09-19 13:37:04.228 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] Waiting 100 ms before next connection attempt.
2022-09-19 13:37:04.329 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] Connecting.
2022-09-19 13:37:05.230 ERROR (MainThread) [huawei_solar.huawei_solar] Modbus client is not connected to the inverter.
huawei_solar.exceptions.ConnectionException: Modbus client is not connected to the inverter.
2022-09-19 13:37:05.236 WARNING (MainThread) [homeassistant.config_entries] Config entry 'SUN2000-6KTL-L1' for huawei_solar integration not ready yet: Modbus client is not connected to the inverter.; Retrying in background
2022-09-19 13:37:05.402 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] Connecting to 192.168.42.20:502.
2022-09-19 13:37:05.402 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] Connecting.
2022-09-19 13:37:05.515 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] Client connected to modbus server
2022-09-19 13:37:05.516 INFO (MainThread) [pymodbus.client.asynchronous.async_io] Protocol made connection.
2022-09-19 13:37:05.554 INFO (MainThread) [pymodbus.client.asynchronous.async_io] Connected to None:502.
2022-09-19 13:37:05.555 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] Client connected to modbus server
2022-09-19 13:37:05.555 INFO (MainThread) [pymodbus.client.asynchronous.async_io] Protocol made connection.
2022-09-19 13:37:05.564 INFO (MainThread) [pymodbus.client.asynchronous.async_io] Connected to 192.168.42.20:502.
2022-09-19 13:37:07.004 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x1 0x0 0x0 0x0 0x6 0x0 0x3 0xa7 0xfe 0x0 0x1
2022-09-19 13:37:07.008 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 1
2022-09-19 13:37:12.127 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] Client disconnected from modbus server: None
2022-09-19 13:37:12.128 INFO (MainThread) [pymodbus.client.asynchronous.async_io] Protocol lost connection.
2022-09-19 13:37:14.195 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x2 0x0 0x0 0x0 0x6 0x0 0x3 0xa7 0xfe 0x0 0x1
2022-09-19 13:37:14.195 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 2
2022-09-19 13:37:14.258 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] recv: 0x0 0x2 0x0 0x0 0x0 0x5 0x0 0x3 0x2 0x0 0x3c
2022-09-19 13:37:14.258 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x2 0x0 0x0 0x0 0x5 0x0 0x3 0x2 0x0 0x3c
2022-09-19 13:37:14.259 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse: 3]
2022-09-19 13:37:14.259 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 2
2022-09-19 13:37:14.312 DEBUG (MainThread) [pymodbus.payload] [60]
2022-09-19 13:37:14.312 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x3 0x0 0x0 0x0 0x6 0x0 0x3 0xb7 0x98 0x0 0x1
2022-09-19 13:37:14.313 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 3
2022-09-19 13:37:14.401 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] recv: 0x0 0x3 0x0 0x0 0x0 0x5 0x0 0x3 0x2 0x0 0x0
2022-09-19 13:37:14.401 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x3 0x0 0x0 0x0 0x5 0x0 0x3 0x2 0x0 0x0
2022-09-19 13:37:14.401 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse: 3]
2022-09-19 13:37:14.401 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 3
2022-09-19 13:37:14.453 DEBUG (MainThread) [pymodbus.payload] [0]
2022-09-19 13:37:14.454 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x4 0x0 0x0 0x0 0x6 0x0 0x3 0x75 0x30 0x0 0x19
2022-09-19 13:37:14.454 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 4
2022-09-19 13:37:14.510 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] recv: 0x0 0x4 0x0 0x0 0x0 0x35 0x0 0x3 0x32 0x53 0x55 0x4e 0x32 0x30 0x30 0x30 0x2d 0x36 0x4b 0x54 0x4c 0x2d 0x4c 0x31 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x31 0x30 0x32 0x31 0x36 0x30 0x32 0x35 0x37 0x37 0x31 0x34 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
2022-09-19 13:37:14.510 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x4 0x0 0x0 0x0 0x35 0x0 0x3 0x32 0x53 0x55 0x4e 0x32 0x30 0x30 0x30 0x2d 0x36 0x4b 0x54 0x4c 0x2d 0x4c 0x31 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x31 0x30 0x32 0x31 0x36 0x30 0x32 0x35 0x37 0x37 0x31 0x34 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
2022-09-19 13:37:14.510 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse: 3]
2022-09-19 13:37:14.511 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 4
2022-09-19 13:37:14.588 DEBUG (MainThread) [pymodbus.payload] [21333, 20018, 12336, 12333, 13899, 21580, 11596, 12544, 0, 0, 0, 0, 0, 0, 0, 12592, 12849, 13872, 12853, 14135, 12596, 0, 0, 0, 0]
2022-09-19 13:37:14.589 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x5 0x0 0x0 0x0 0x6 0x0 0x3 0x75 0x77 0x0 0x1
2022-09-19 13:37:14.590 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 5
2022-09-19 13:37:14.611 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] recv: 0x0 0x5 0x0 0x0 0x0 0x5 0x0 0x3 0x2 0x0 0x2
2022-09-19 13:37:14.611 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x5 0x0 0x0 0x0 0x5 0x0 0x3 0x2 0x0 0x2
2022-09-19 13:37:14.611 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse: 3]
2022-09-19 13:37:14.612 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 5
2022-09-19 13:37:14.688 DEBUG (MainThread) [pymodbus.payload] [2]
2022-09-19 13:37:14.688 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x6 0x0 0x0 0x0 0x6 0x0 0x3 0x91 0x50 0x0 0x1
2022-09-19 13:37:14.689 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 6
2022-09-19 13:37:14.804 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] recv: 0x0 0x6 0x0 0x0 0x0 0x5 0x0 0x3 0x2 0x0 0x0
2022-09-19 13:37:14.805 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x6 0x0 0x0 0x0 0x5 0x0 0x3 0x2 0x0 0x0
2022-09-19 13:37:14.805 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse: 3]
2022-09-19 13:37:14.805 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 6
2022-09-19 13:37:14.874 DEBUG (MainThread) [pymodbus.payload] [0]
2022-09-19 13:37:14.876 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x7 0x0 0x0 0x0 0x6 0x0 0x3 0x90 0xec 0x0 0x1
2022-09-19 13:37:14.877 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 7
2022-09-19 13:37:14.911 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] recv: 0x0 0x7 0x0 0x0 0x0 0x5 0x0 0x3 0x2 0x0 0x1
2022-09-19 13:37:14.911 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x7 0x0 0x0 0x0 0x5 0x0 0x3 0x2 0x0 0x1
2022-09-19 13:37:14.911 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse: 3]
2022-09-19 13:37:14.912 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 7
2022-09-19 13:37:14.963 DEBUG (MainThread) [pymodbus.payload] [1]
2022-09-19 13:37:14.964 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x8 0x0 0x0 0x0 0x6 0x0 0x3 0x91 0x5 0x0 0x1
2022-09-19 13:37:14.965 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 8
2022-09-19 13:37:15.238 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] recv: 0x0 0x8 0x0 0x0 0x0 0x5 0x0 0x3 0x2 0x0 0x0
2022-09-19 13:37:15.238 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x8 0x0 0x0 0x0 0x5 0x0 0x3 0x2 0x0 0x0
2022-09-19 13:37:15.238 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse: 3]
2022-09-19 13:37:15.239 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 8
2022-09-19 13:37:15.291 DEBUG (MainThread) [pymodbus.payload] [0]
2022-09-19 13:37:15.293 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x9 0x0 0x0 0x0 0x6 0x0 0x3 0xb7 0x98 0x0 0x1
2022-09-19 13:37:15.294 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 9
2022-09-19 13:37:15.337 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] recv: 0x0 0x9 0x0 0x0 0x0 0x5 0x0 0x3 0x2 0x0 0x0
2022-09-19 13:37:15.337 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x9 0x0 0x0 0x0 0x5 0x0 0x3 0x2 0x0 0x0
2022-09-19 13:37:15.337 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse: 3]
2022-09-19 13:37:15.337 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 9
2022-09-19 13:37:15.418 DEBUG (MainThread) [pymodbus.payload] [0]
2022-09-19 13:37:15.419 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0xa 0x0 0x0 0x0 0x6 0x0 0x3 0xb7 0xf1 0x0 0x1
2022-09-19 13:37:15.420 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 10
2022-09-19 13:37:15.446 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] recv: 0x0 0xa 0x0 0x0 0x0 0x5 0x0 0x3 0x2 0x0 0x0
2022-09-19 13:37:15.446 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xa 0x0 0x0 0x0 0x5 0x0 0x3 0x2 0x0 0x0
2022-09-19 13:37:15.447 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse: 3]
2022-09-19 13:37:15.447 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 10
2022-09-19 13:37:15.503 DEBUG (MainThread) [pymodbus.payload] [0]
2022-09-19 13:37:15.504 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0xb 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2022-09-19 13:37:15.505 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 11
2022-09-19 13:37:17.513 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] recv: 0x0 0xb 0x0 0x0 0x0 0x6b 0x0 0x3 0x68 0x0 0x0 0x3 0x59 0x8 0xdc 0x0 0x0 0x0 0x0 0x7 0xd9 0x0 0x3 0x0 0x0 0x0 0x0 0xe 0x88 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x17 0x70 0x0 0x0 0x3 0x47 0x0 0x0 0x0 0x0 0x3 0xe8 0x13 0x88 0x26 0x35 0x1 0x78 0xb 0xb8 0x2 0x0 0x0 0x0 0x63 0x28 0x21 0x26 0x63 0x27 0x82 0x36 0x0 0x0 0x3 0x4b 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0xd 0x18 0x1e 0x0 0xd 0x6e 0xc1 0x63 0x28 0x71 0x6e 0x0 0x0 0x0 0x3d 0x0 0x0 0x3 0x5c
2022-09-19 13:37:17.514 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xb 0x0 0x0 0x0 0x6b 0x0 0x3 0x68 0x0 0x0 0x3 0x59 0x8 0xdc 0x0 0x0 0x0 0x0 0x7 0xd9 0x0 0x3 0x0 0x0 0x0 0x0 0xe 0x88 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x17 0x70 0x0 0x0 0x3 0x47 0x0 0x0 0x0 0x0 0x3 0xe8 0x13 0x88 0x26 0x35 0x1 0x78 0xb 0xb8 0x2 0x0 0x0 0x0 0x63 0x28 0x21 0x26 0x63 0x27 0x82 0x36 0x0 0x0 0x3 0x4b 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0xd 0x18 0x1e 0x0 0xd 0x6e 0xc1 0x63 0x28 0x71 0x6e 0x0 0x0 0x0 0x3d 0x0 0x0 0x3 0x5c
2022-09-19 13:37:17.514 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse: 3]
2022-09-19 13:37:17.514 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 11
2022-09-19 13:37:17.565 DEBUG (MainThread) [pymodbus.payload] [0, 857, 2268, 0, 0, 2009, 3, 0, 0, 3720, 0, 0, 0, 0, 0, 6000, 0, 839, 0, 0, 1000, 5000, 9781, 376, 3000, 512, 0, 25384, 8486, 25383, 33334, 0, 843, 0, 0, 0, 0, 0, 0, 0, 0, 0, 13, 6174, 13, 28353, 25384, 29038, 0, 61, 0, 860]
2022-09-19 13:37:17.566 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x03Y']
2022-09-19 13:37:17.566 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x0e\x88']
2022-09-19 13:37:17.567 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2022-09-19 13:37:17.567 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2022-09-19 13:37:17.567 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x17p']
2022-09-19 13:37:17.567 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x03G']
2022-09-19 13:37:17.568 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2022-09-19 13:37:17.568 DEBUG (MainThread) [pymodbus.payload] [b'c(', b'!&']
2022-09-19 13:37:17.568 DEBUG (MainThread) [pymodbus.payload] [b"c'", b'\x826']
2022-09-19 13:37:17.569 DEBUG (MainThread) [pymodbus.payload] [b'\x00\r', b'\x18\x1e']
2022-09-19 13:37:17.569 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x03\\']
2022-09-19 13:37:17.570 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0xc 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x10 0x0 0x4
2022-09-19 13:37:17.571 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 12
2022-09-19 13:37:17.615 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] recv: 0x0 0xc 0x0 0x0 0x0 0xb 0x0 0x3 0x8 0xb 0x8f 0x0 0x8e 0xb 0x3b 0x0 0x94
2022-09-19 13:37:17.615 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xc 0x0 0x0 0x0 0xb 0x0 0x3 0x8 0xb 0x8f 0x0 0x8e 0xb 0x3b 0x0 0x94
2022-09-19 13:37:17.615 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse: 3]
2022-09-19 13:37:17.615 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 12
2022-09-19 13:37:17.667 DEBUG (MainThread) [pymodbus.payload] [2959, 142, 2875, 148]
2022-09-19 13:37:17.668 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0xd 0x0 0x0 0x0 0x6 0x0 0x3 0x90 0xed 0x0 0x25
2022-09-19 13:37:17.669 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 13
2022-09-19 13:37:17.689 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] recv: 0x0 0xd 0x0 0x0 0x0 0x4d 0x0 0x3 0x4a 0x0 0x0 0x8 0xcd 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0x4e 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xfe 0x70 0x0 0x0 0x0 0x0 0x3 0xe8 0x13 0x88 0x0 0x5 0x51 0x66 0x0 0xb 0x99 0x68 0x0 0x0 0x0 0x0 0x0 0x0 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff
2022-09-19 13:37:17.690 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xd 0x0 0x0 0x0 0x4d 0x0 0x3 0x4a 0x0 0x0 0x8 0xcd 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0x4e 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xfe 0x70 0x0 0x0 0x0 0x0 0x3 0xe8 0x13 0x88 0x0 0x5 0x51 0x66 0x0 0xb 0x99 0x68 0x0 0x0 0x0 0x0 0x0 0x0 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff
2022-09-19 13:37:17.690 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse: 3]
2022-09-19 13:37:17.690 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 13
2022-09-19 13:37:17.741 DEBUG (MainThread) [pymodbus.payload] [0, 2253, 65535, 65535, 65535, 65535, 65535, 65358, 65535, 65535, 65535, 65535, 65535, 65136, 0, 0, 1000, 5000, 5, 20838, 11, 39272, 0, 0, 0, 65535, 65535, 65535, 65535, 65535, 65535, 32767, 65535, 32767, 65535, 32767, 65535]
2022-09-19 13:37:17.742 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x08\xcd']
2022-09-19 13:37:17.742 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xff\xff']
2022-09-19 13:37:17.743 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xff\xff']
2022-09-19 13:37:17.743 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xffN']
2022-09-19 13:37:17.743 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xff\xff']
2022-09-19 13:37:17.743 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xff\xff']
2022-09-19 13:37:17.744 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xfep']
2022-09-19 13:37:17.744 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2022-09-19 13:37:17.744 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x05', b'Qf']
2022-09-19 13:37:17.744 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x0b', b'\x99h']
2022-09-19 13:37:17.745 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2022-09-19 13:37:17.745 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xff\xff']
2022-09-19 13:37:17.745 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xff\xff']
2022-09-19 13:37:17.745 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xff\xff']
2022-09-19 13:37:17.746 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2022-09-19 13:37:17.746 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2022-09-19 13:37:17.746 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2022-09-19 13:37:17.797 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0xe 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2022-09-19 13:37:17.798 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 14
2022-09-19 13:37:22.802 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0xf 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2022-09-19 13:37:22.803 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 15
2022-09-19 13:37:27.807 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x10 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2022-09-19 13:37:27.808 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 16
2022-09-19 13:37:32.812 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x11 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2022-09-19 13:37:32.813 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 17
2022-09-19 13:37:47.804 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x12 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2022-09-19 13:37:47.805 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 18
2022-09-19 13:37:52.809 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x13 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2022-09-19 13:37:52.811 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 19
2022-09-19 13:37:57.815 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x14 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2022-09-19 13:37:57.816 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 20
2022-09-19 13:38:02.820 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x15 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2022-09-19 13:38:02.821 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 21
2022-09-19 13:38:37.002 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x16 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2022-09-19 13:38:37.003 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 22
2022-09-19 13:38:42.006 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x17 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2022-09-19 13:38:42.007 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 23
2022-09-19 13:38:47.011 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x18 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2022-09-19 13:38:47.012 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 24
2022-09-19 13:38:52.016 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x19 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2022-09-19 13:38:52.017 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 25
2022-09-19 13:39:21.440 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] Client disconnected from modbus server: None
2022-09-19 13:39:21.441 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 1
2022-09-19 13:39:21.441 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 14
2022-09-19 13:39:21.441 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 15
2022-09-19 13:39:21.441 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 16
2022-09-19 13:39:21.442 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 17
2022-09-19 13:39:21.442 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 18
2022-09-19 13:39:21.442 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 19
2022-09-19 13:39:21.442 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 20
2022-09-19 13:39:21.442 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 21
2022-09-19 13:39:21.443 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 22
2022-09-19 13:39:21.443 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 23
2022-09-19 13:39:21.443 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 24
2022-09-19 13:39:21.443 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 25
2022-09-19 13:39:21.443 INFO (MainThread) [pymodbus.client.asynchronous.async_io] Protocol lost connection.
2022-09-19 13:39:21.445 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] Waiting 100 ms before next connection attempt.
2022-09-19 13:39:21.545 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] Connecting.
2022-09-19 13:39:21.605 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] Client connected to modbus server
2022-09-19 13:39:21.605 INFO (MainThread) [pymodbus.client.asynchronous.async_io] Protocol made connection.
2022-09-19 13:39:21.606 INFO (MainThread) [pymodbus.client.asynchronous.async_io] Connected to 192.168.42.20:502.
2022-09-19 13:39:27.002 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x1 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2022-09-19 13:39:27.003 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 1
2022-09-19 13:39:27.120 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] recv: 0x0 0x1 0x0 0x0 0x0 0x6b 0x0 0x3 0x68 0x0 0x0 0x3 0x6d 0x8 0xf5 0x0 0x0 0x0 0x0 0x7 0xed 0x0 0x3 0x0 0x0 0x0 0x0 0xe 0xb6 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x17 0x70 0x0 0x0 0x3 0x5a 0xff 0xff 0xff 0xff 0x3 0xe8 0x13 0x88 0x26 0x36 0x1 0x76 0xb 0xb8 0x2 0x0 0x0 0x0 0x63 0x28 0x21 0x26 0x63 0x27 0x82 0x36 0x0 0x0 0x3 0x5d 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0xd 0x18 0x21 0x0 0xd 0x6e 0xc5 0x63 0x28 0x71 0xef 0x0 0x0 0x0 0x40 0x0 0x0 0x3 0x5f
2022-09-19 13:39:27.120 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x1 0x0 0x0 0x0 0x6b 0x0 0x3 0x68 0x0 0x0 0x3 0x6d 0x8 0xf5 0x0 0x0 0x0 0x0 0x7 0xed 0x0 0x3 0x0 0x0 0x0 0x0 0xe 0xb6 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x17 0x70 0x0 0x0 0x3 0x5a 0xff 0xff 0xff 0xff 0x3 0xe8 0x13 0x88 0x26 0x36 0x1 0x76 0xb 0xb8 0x2 0x0 0x0 0x0 0x63 0x28 0x21 0x26 0x63 0x27 0x82 0x36 0x0 0x0 0x3 0x5d 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0xd 0x18 0x21 0x0 0xd 0x6e 0xc5 0x63 0x28 0x71 0xef 0x0 0x0 0x0 0x40 0x0 0x0 0x3 0x5f
2022-09-19 13:39:27.121 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse: 3]
2022-09-19 13:39:27.121 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 1
2022-09-19 13:39:27.172 DEBUG (MainThread) [pymodbus.payload] [0, 877, 2293, 0, 0, 2029, 3, 0, 0, 3766, 0, 0, 0, 0, 0, 6000, 0, 858, 65535, 65535, 1000, 5000, 9782, 374, 3000, 512, 0, 25384, 8486, 25383, 33334, 0, 861, 0, 0, 0, 0, 0, 0, 0, 0, 0, 13, 6177, 13, 28357, 25384, 29167, 0, 64, 0, 863]
2022-09-19 13:39:27.173 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x03m']
2022-09-19 13:39:27.173 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x0e\xb6']
2022-09-19 13:39:27.174 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2022-09-19 13:39:27.174 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2022-09-19 13:39:27.174 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x17p']
2022-09-19 13:39:27.174 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x03Z']
2022-09-19 13:39:27.175 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xff\xff']
2022-09-19 13:39:27.175 DEBUG (MainThread) [pymodbus.payload] [b'c(', b'!&']
2022-09-19 13:39:27.175 DEBUG (MainThread) [pymodbus.payload] [b"c'", b'\x826']
2022-09-19 13:39:27.176 DEBUG (MainThread) [pymodbus.payload] [b'\x00\r', b'\x18!']
2022-09-19 13:39:27.176 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x03_']
2022-09-19 13:39:27.177 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x2 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x10 0x0 0x4
2022-09-19 13:39:27.178 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 2
2022-09-19 13:39:27.222 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] recv: 0x0 0x2 0x0 0x0 0x0 0xb 0x0 0x3 0x8 0xb 0x8f 0x0 0x92 0xb 0x3b 0x0 0x98
2022-09-19 13:39:27.223 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x2 0x0 0x0 0x0 0xb 0x0 0x3 0x8 0xb 0x8f 0x0 0x92 0xb 0x3b 0x0 0x98
2022-09-19 13:39:27.223 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse: 3]
2022-09-19 13:39:27.223 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 2
2022-09-19 13:39:27.274 DEBUG (MainThread) [pymodbus.payload] [2959, 146, 2875, 152]
2022-09-19 13:39:27.276 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x3 0x0 0x0 0x0 0x6 0x0 0x3 0x90 0xed 0x0 0x25
2022-09-19 13:39:27.277 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 3
2022-09-19 13:39:27.387 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] recv: 0x0 0x3 0x0 0x0 0x0 0x4d 0x0 0x3 0x4a 0x0 0x0 0x8 0xe4 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0x57 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xfe 0x88 0xff 0xff 0xff 0xea 0x3 0xe6 0x13 0x85 0x0 0x5 0x51 0x66 0x0 0xb 0x99 0x6a 0x0 0x0 0x0 0x0 0x0 0x0 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff
2022-09-19 13:39:27.387 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x3 0x0 0x0 0x0 0x4d 0x0 0x3 0x4a 0x0 0x0 0x8 0xe4 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0x57 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xfe 0x88 0xff 0xff 0xff 0xea 0x3 0xe6 0x13 0x85 0x0 0x5 0x51 0x66 0x0 0xb 0x99 0x6a 0x0 0x0 0x0 0x0 0x0 0x0 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff
2022-09-19 13:39:27.387 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse: 3]
2022-09-19 13:39:27.388 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 3
2022-09-19 13:39:27.439 DEBUG (MainThread) [pymodbus.payload] [0, 2276, 65535, 65535, 65535, 65535, 65535, 65367, 65535, 65535, 65535, 65535, 65535, 65160, 65535, 65514, 998, 4997, 5, 20838, 11, 39274, 0, 0, 0, 65535, 65535, 65535, 65535, 65535, 65535, 32767, 65535, 32767, 65535, 32767, 65535]
2022-09-19 13:39:27.439 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x08\xe4']
2022-09-19 13:39:27.440 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xff\xff']
2022-09-19 13:39:27.440 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xff\xff']
2022-09-19 13:39:27.440 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xffW']
2022-09-19 13:39:27.440 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xff\xff']
2022-09-19 13:39:27.441 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xff\xff']
2022-09-19 13:39:27.441 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xfe\x88']
2022-09-19 13:39:27.441 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xff\xea']
2022-09-19 13:39:27.442 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x05', b'Qf']
2022-09-19 13:39:27.442 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x0b', b'\x99j']
2022-09-19 13:39:27.442 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2022-09-19 13:39:27.442 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xff\xff']
2022-09-19 13:39:27.443 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xff\xff']
2022-09-19 13:39:27.443 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xff\xff']
2022-09-19 13:39:27.443 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2022-09-19 13:39:27.443 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2022-09-19 13:39:27.444 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2022-09-19 13:39:57.001 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x4 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2022-09-19 13:39:57.002 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 4
2022-09-19 13:40:01.378 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] recv: 0x0 0x4 0x0 0x0 0x0 0x6b 0x0 0x3 0x68 0x0 0x0 0x3 0x74 0x8 0xf3 0x0 0x0 0x0 0x0 0x7 0xeb 0x0 0x3 0x0 0x0 0x0 0x0 0xe 0xd4 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x17 0x70 0x0 0x0 0x3 0x60 0x0 0x0 0x0 0x0 0x3 0xe8 0x13 0x87 0x26 0x37 0x1 0x75 0xb 0xb8 0x2 0x0 0x0 0x0 0x63 0x28 0x21 0x26 0x63 0x27 0x82 0x36 0x0 0x0 0x3 0x5f 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0xd 0x18 0x22 0x0 0xd 0x6e 0xc5 0x63 0x28 0x72 0x9 0x0 0x0 0x0 0x41 0x0 0x0 0x3 0x60
2022-09-19 13:40:01.379 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x4 0x0 0x0 0x0 0x6b 0x0 0x3 0x68 0x0 0x0 0x3 0x74 0x8 0xf3 0x0 0x0 0x0 0x0 0x7 0xeb 0x0 0x3 0x0 0x0 0x0 0x0 0xe 0xd4 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x17 0x70 0x0 0x0 0x3 0x60 0x0 0x0 0x0 0x0 0x3 0xe8 0x13 0x87 0x26 0x37 0x1 0x75 0xb 0xb8 0x2 0x0 0x0 0x0 0x63 0x28 0x21 0x26 0x63 0x27 0x82 0x36 0x0 0x0 0x3 0x5f 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0xd 0x18 0x22 0x0 0xd 0x6e 0xc5 0x63 0x28 0x72 0x9 0x0 0x0 0x0 0x41 0x0 0x0 0x3 0x60
2022-09-19 13:40:01.379 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse: 3]
2022-09-19 13:40:01.379 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 4
2022-09-19 13:40:02.005 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x5 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2022-09-19 13:40:02.007 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 5
2022-09-19 13:40:07.010 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x6 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2022-09-19 13:40:07.012 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 6
2022-09-19 13:40:12.023 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x7 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2022-09-19 13:40:12.024 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 7
2022-09-19 13:40:32.131 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] recv: 0x0 0x5 0x0 0x0 0x0 0x6b 0x0 0x3 0x68 0x0 0x0 0x3 0x76 0x8 0xf3 0x0 0x0 0x0 0x0 0x7 0xec 0x0 0x3 0x0 0x0 0x0 0x0 0xe 0xdf 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x17 0x70 0x0 0x0 0x3 0x63 0x0 0x0 0x0 0x0 0x3 0xe8 0x13 0x89 0x26 0x35 0x1 0x75 0xb 0xb8 0x2 0x0 0x0 0x0 0x63 0x28 0x21 0x26 0x63 0x27 0x82 0x36 0x0 0x0 0x3 0x67 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0xd 0x18 0x23 0x0 0xd 0x6e 0xc7 0x63 0x28 0x72 0x30 0x0 0x0 0x0 0x42 0x0 0x0 0x3 0x61
2022-09-19 13:40:32.132 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x5 0x0 0x0 0x0 0x6b 0x0 0x3 0x68 0x0 0x0 0x3 0x76 0x8 0xf3 0x0 0x0 0x0 0x0 0x7 0xec 0x0 0x3 0x0 0x0 0x0 0x0 0xe 0xdf 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x17 0x70 0x0 0x0 0x3 0x63 0x0 0x0 0x0 0x0 0x3 0xe8 0x13 0x89 0x26 0x35 0x1 0x75 0xb 0xb8 0x2 0x0 0x0 0x0 0x63 0x28 0x21 0x26 0x63 0x27 0x82 0x36 0x0 0x0 0x3 0x67 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0xd 0x18 0x23 0x0 0xd 0x6e 0xc7 0x63 0x28 0x72 0x30 0x0 0x0 0x0 0x42 0x0 0x0 0x3 0x61
2022-09-19 13:40:32.132 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse: 3]
2022-09-19 13:40:32.132 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 5
2022-09-19 13:40:32.173 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] recv: 0x0 0x6 0x0 0x0 0x0 0x6b 0x0 0x3 0x68 0x0 0x0 0x3 0x76 0x8 0xf3 0x0 0x0 0x0 0x0 0x7 0xec 0x0 0x3 0x0 0x0 0x0 0x0 0xe 0xdf 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x17 0x70 0x0 0x0 0x3 0x63 0x0 0x0 0x0 0x0 0x3 0xe8 0x13 0x89 0x26 0x35 0x1 0x75 0xb 0xb8 0x2 0x0 0x0 0x0 0x63 0x28 0x21 0x26 0x63 0x27 0x82 0x36 0x0 0x0 0x3 0x67 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0xd 0x18 0x23 0x0 0xd 0x6e 0xc7 0x63 0x28 0x72 0x30 0x0 0x0 0x0 0x42 0x0 0x0 0x3 0x61 0x0 0x7 0x0 0x0 0x0 0x6b 0x0 0x3 0x68 0x0 0x0 0x3 0x76 0x8 0xf3 0x0 0x0 0x0 0x0 0x7 0xec 0x0 0x3 0x0 0x0 0x0 0x0 0xe 0xdf 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x17 0x70 0x0 0x0 0x3 0x63 0x0 0x0 0x0 0x0 0x3 0xe8 0x13 0x89 0x26 0x35 0x1 0x75 0xb 0xb8 0x2 0x0 0x0 0x0 0x63 0x28 0x21 0x26 0x63 0x27 0x82 0x36 0x0 0x0 0x3 0x67 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0xd 0x18 0x23 0x0 0xd 0x6e 0xc7 0x63 0x28 0x72 0x30 0x0 0x0 0x0 0x42 0x0 0x0 0x3 0x61
2022-09-19 13:40:32.174 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x6 0x0 0x0 0x0 0x6b 0x0 0x3 0x68 0x0 0x0 0x3 0x76 0x8 0xf3 0x0 0x0 0x0 0x0 0x7 0xec 0x0 0x3 0x0 0x0 0x0 0x0 0xe 0xdf 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x17 0x70 0x0 0x0 0x3 0x63 0x0 0x0 0x0 0x0 0x3 0xe8 0x13 0x89 0x26 0x35 0x1 0x75 0xb 0xb8 0x2 0x0 0x0 0x0 0x63 0x28 0x21 0x26 0x63 0x27 0x82 0x36 0x0 0x0 0x3 0x67 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0xd 0x18 0x23 0x0 0xd 0x6e 0xc7 0x63 0x28 0x72 0x30 0x0 0x0 0x0 0x42 0x0 0x0 0x3 0x61 0x0 0x7 0x0 0x0 0x0 0x6b 0x0 0x3 0x68 0x0 0x0 0x3 0x76 0x8 0xf3 0x0 0x0 0x0 0x0 0x7 0xec 0x0 0x3 0x0 0x0 0x0 0x0 0xe 0xdf 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x17 0x70 0x0 0x0 0x3 0x63 0x0 0x0 0x0 0x0 0x3 0xe8 0x13 0x89 0x26 0x35 0x1 0x75 0xb 0xb8 0x2 0x0 0x0 0x0 0x63 0x28 0x21 0x26 0x63 0x27 0x82 0x36 0x0 0x0 0x3 0x67 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0xd 0x18 0x23 0x0 0xd 0x6e 0xc7 0x63 0x28 0x72 0x30 0x0 0x0 0x0 0x42 0x0 0x0 0x3 0x61
2022-09-19 13:40:32.174 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse: 3]
2022-09-19 13:40:32.174 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 6
2022-09-19 13:40:32.174 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse: 3]
2022-09-19 13:40:32.175 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 7
2022-09-19 13:40:47.002 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x8 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2022-09-19 13:40:47.003 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 8
2022-09-19 13:40:52.015 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0x9 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2022-09-19 13:40:52.016 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 9
2022-09-19 13:40:57.020 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0xa 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2022-09-19 13:40:57.021 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 10
2022-09-19 13:41:02.025 DEBUG (MainThread) [pymodbus.client.asynchronous.async_io] send: 0x0 0xb 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2022-09-19 13:41:02.026 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 11
wlcrs commented 2 years ago

I don't see any problems with the integration, but I do see disconnects/timeouts. Please check your setup: is the connection to the inverter stable enough?

themaninspain commented 2 years ago

The inverter connection was stable and has been for the last 10 months. The problem only started this month. I will get tech support to re-check the inverter.

tdr-its42 commented 2 years ago

Same issue happend with my installation. It was caused by unstable wifi connection, and it is solved by moving my ha machine next to the inverter.

themaninspain commented 2 years ago

Same issue happend with my installation. It was caused by unstable wifi connection, and it is solved by moving my ha machine next to the inverter.

I haven't changed the location of my AP's (I use unifi) but I will do some tests to see if it helps.

themaninspain commented 2 years ago

Same issue happend with my installation. It was caused by unstable wifi connection, and it is solved by moving my ha machine next to the inverter.

I haven't changed the location of my AP's (I use unifi) but I will do some tests to see if it helps.

That did it! I have 3 AP's and for some reason the inverter had started connecting to the one furthest away - I forced it to connect to the nearest AP and I am now getting consistent readings.