Closed kalika303 closed 1 year ago
What do you see in FusionSolar (app or website)?
Please generate debugging logs for a few minutes so that I can review the Modbus traffic
What do you see in FusionSolar (app or website)?
Please generate debugging logs for a few minutes so that I can review the Modbus traffic
Can you point me to the documentation on how to enable debugging logs? Thanks.
Here is the debugging log:
2023-02-28 13:20:17.145 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32064
2023-02-28 13:20:18.055 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32000
2023-02-28 13:20:18.699 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37201
2023-02-28 13:20:20.029 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37101
2023-02-28 13:20:20.596 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37760
2023-02-28 13:20:51.144 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32064
2023-02-28 13:20:51.786 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32000
2023-02-28 13:20:52.445 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37201
2023-02-28 13:20:53.054 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37101
2023-02-28 13:20:56.091 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37760
2023-02-28 13:21:27.148 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32064
2023-02-28 13:21:28.694 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32000
2023-02-28 13:21:29.546 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37201
2023-02-28 13:21:30.248 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37101
2023-02-28 13:21:31.409 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37760
2023-02-28 13:22:02.144 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32064
2023-02-28 13:22:02.641 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32000
2023-02-28 13:22:03.662 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37201
2023-02-28 13:22:04.613 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37101
2023-02-28 13:22:05.935 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37760
2023-02-28 13:22:09.154 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47075
2023-02-28 13:22:10.795 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47200
2023-02-28 13:22:11.387 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47255
2023-02-28 13:22:12.329 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47954
2023-02-28 13:22:36.145 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32064
2023-02-28 13:22:37.166 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32000
2023-02-28 13:22:38.430 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37201
2023-02-28 13:22:39.047 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37101
2023-02-28 13:22:40.123 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37760
2023-02-28 13:23:10.144 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32064
2023-02-28 13:23:11.326 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32000
2023-02-28 13:23:13.301 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37201
2023-02-28 13:23:13.980 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37101
2023-02-28 13:23:14.694 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37760
2023-02-28 13:23:45.143 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32064
2023-02-28 13:23:45.551 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32000
2023-02-28 13:23:46.055 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37201
2023-02-28 13:23:46.773 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37101
2023-02-28 13:23:47.975 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37760
2023-02-28 13:24:21.350 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32064
2023-02-28 13:24:35.794 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32000
2023-02-28 13:24:37.413 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37201
2023-02-28 13:24:39.209 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37101
2023-02-28 13:24:40.230 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37760
2023-02-28 13:25:05.295 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 40000
2023-02-28 13:25:07.475 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading file 0x44
2023-02-28 13:25:16.702 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32064
2023-02-28 13:25:17.808 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32000
2023-02-28 13:25:18.427 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37201
2023-02-28 13:25:20.204 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37101
2023-02-28 13:25:21.981 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37760
2023-02-28 13:25:53.146 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32064
2023-02-28 13:25:54.190 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32000
2023-02-28 13:25:55.156 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37201
2023-02-28 13:25:55.776 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37101
2023-02-28 13:25:57.140 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37760
2023-02-28 13:26:28.144 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32064
2023-02-28 13:26:28.413 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32000
2023-02-28 13:26:29.692 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37201
2023-02-28 13:26:30.332 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37101
2023-02-28 13:26:31.458 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37760
I need the pymodbus logs too. Please use the built in diagnostics tool: https://www.home-assistant.io/docs/configuration/troubleshooting/#debug-logs-and-diagnostics
I need the pymodbus logs too. Please use the built in diagnostics tool: https://www.home-assistant.io/docs/configuration/troubleshooting/#debug-logs-and-diagnostics
I used the diagnostic tool and also tried to add the following (as stated here https://www.home-assistant.io/integrations/modbus/#opening-an-issue):
logger:
default: warning
logs:
homeassistant.components.modbus: debug
pymodbus: debug
Still did not see different logs related to pymodbus in the output. Any other idea?
@wlcrs is there anything I can force my manually trigger some actions to give you more interesting logs and feedback? If you have some idea, I can try to debug the issue and some tests, but I really need some direction...
I need pymodbus log lines to further evaluate your problem.
You can also contact Huawei support to ask them why your battery is reporting strange values
No way. I've tried to use the configuration indicated here: https://github.com/wlcrs/huawei_solar#faq---troubleshooting After more than 100MB of log, no log concerning modbus has been recorded.
Is there any other place to check for log? Can I place a logger manually in the code somewhere?
You can also contact Huawei support to ask them why your battery is reporting strange values
In the FusionSolar app the report is correct. So I feel like it is an error in my installation of HA. What I can do is trying to read the modbus register manually from the cli and see if it reports the correct value, so we can narrow down between a modbus vs. record issue in HA.
Makes sense?
I finally understand why you are not getting pymodbus logs. In v1.2.5 of this integration I have updated pymodbus to v3.1.3, which apparently includes an unexpected and breaking change in how logging is configured: https://github.com/pymodbus-dev/pymodbus/pull/1324
You should be able to get proper logs by downgrading to 1.2.4 (and thus to pymodbus 3.1.2).
I've the same problem last month.
Happy to run into this issue. I thought they sold me an old battery...
Can you please use the latest beta version and gather some debug logs? (cfr. https://www.home-assistant.io/docs/configuration/troubleshooting/#debug-logs-and-diagnostics)
The latest beta version logs considerably more information, and wil allow me to better assess the problem.
Hope these help?
"home_assistant": {
"installation_type": "Home Assistant OS",
"version": "2023.5.2",
"dev": false,
"hassio": true,
"virtualenv": false,
"python_version": "3.10.11",
"docker": true,
"arch": "aarch64",
"timezone": "Europe/Brussels",
"os_name": "Linux",
"os_version": "6.1.21-v8",
"supervisor": "2023.04.1",
"host_os": "Home Assistant OS 10.1",
"docker_version": "23.0.3",
"chassis": "embedded",
"run_as_root": true
},
"custom_components": {
"huawei_solar": {
"version": "1.2.6b5",
"requirements": [
"huawei-solar==2.2.7b5"
]
},
"hacs": {
"version": "1.32.1",
"requirements": [
"aiogithubapi>=22.10.1"
]
},
"audiconnect": {
"version": "2021.1.1",
"requirements": [
"beautifulsoup4"
]
}
},
"integration_manifest": {
"domain": "huawei_solar",
"name": "Huawei Solar",
"config_flow": true,
"documentation": "https://www.home-assistant.io/integrations/huawei_solar",
"issue_tracker": "https://github.com/wlcrs/huawei_solar/issues",
"requirements": [
"huawei-solar==2.2.7b5"
],
"codeowners": [
"@wlcrs"
],
"iot_class": "local_polling",
"version": "1.2.6b5",
"loggers": [
"huawei_solar",
"pymodbus"
],
"is_built_in": false
},
"data": {
"config_entry_data": {
"host": "192.168.200.1",
"port": 6607,
"slave_ids": [
0
],
"enable_parameter_configuration": false,
"username": null,
"password": null
},
"slave_0": {
"model_name": "SUN2000-4.6KTL-L1",
"pv_string_count": 2,
"has_optimizers": 0,
"battery_type": 2,
"battery_1_type": 2,
"battery_2_type": 0,
"power_meter_type": 1,
"supports_capacity_control": true
},
"slave_0_data": {
"input_power": [
4876,
"W"
],
"line_voltage_A_B": [
241.5,
"V"
],
"line_voltage_B_C": [
0.0,
"V"
],
"line_voltage_C_A": [
0.0,
"V"
],
"phase_A_voltage": [
121.5,
"V"
],
"phase_B_voltage": [
0.1,
"V"
],
"phase_C_voltage": [
0.0,
"V"
],
"phase_A_current": [
1.244,
"A"
],
"phase_B_current": [
0.0,
"A"
],
"phase_C_current": [
0.0,
"A"
],
"day_active_power_peak": [
3553,
"W"
],
"active_power": [
285,
"W"
],
"reactive_power": [
-1,
"VA"
],
"power_factor": [
1.0,
null
],
"grid_frequency": [
49.98,
"Hz"
],
"efficiency": [
100.0,
"%"
],
"internal_temperature": [
36.2,
"\u00b0C"
],
"insulation_resistance": [
30.0,
"MOhm"
],
"device_status": [
"On-grid",
null
],
"fault_code": [
0,
null
],
"startup_time": [
"2023-05-12T07:18:24+00:00",
null
],
"shutdown_time": [
null,
null
],
"accumulated_yield_energy": [
1227.98,
"kWh"
],
"daily_yield_energy": [
5.37,
"kWh"
],
"state_1": [
[
"Grid-Connected",
"Grid-Connected normally"
],
null
],
"state_2": [
[
"Unlocked",
"PV connected",
"DSP data collection"
],
null
],
"state_3": [
[
"On-grid",
"Off-grid switch disabled"
],
null
],
"alarm_1": [
[],
null
],
"alarm_2": [
[],
null
],
"alarm_3": [
[],
null
],
"pv_01_voltage": [
275.9,
"V"
],
"pv_01_current": [
6.97,
"A"
],
"pv_02_voltage": [
299.2,
"V"
],
"pv_02_current": [
9.89,
"A"
],
"meter_status": [
1,
null
],
"grid_A_voltage": [
240.8,
"V"
],
"grid_B_voltage": [
241.8,
"V"
],
"grid_C_voltage": [
239.0,
"V"
],
"active_grid_A_current": [
0.9,
"I"
],
"active_grid_B_current": [
-1.24,
"I"
],
"active_grid_C_current": [
-0.41,
"I"
],
"power_meter_active_power": [
0,
"W"
],
"power_meter_reactive_power": [
356,
"Var"
],
"active_grid_power_factor": [
-0.001,
null
],
"active_grid_frequency": [
49.97,
"Hz"
],
"grid_exported_energy": [
509.92,
"kWh"
],
"grid_accumulated_energy": [
1096.41,
"kWh"
],
"grid_accumulated_reactive_power": [
0.0,
"kVarh"
],
"meter_type": [
1,
null
],
"active_grid_A_B_voltage": [
418.0,
"V"
],
"active_grid_B_C_voltage": [
416.3,
"V"
],
"active_grid_C_A_voltage": [
415.5,
"V"
],
"active_grid_A_power": [
176,
"W"
],
"active_grid_B_power": [
-156,
"W"
],
"active_grid_C_power": [
-20,
"W"
],
"storage_state_of_capacity": [
88.0,
"%"
],
"storage_running_status": [
2,
null
],
"storage_bus_voltage": [
439.5,
"V"
],
"storage_bus_current": [
10.3,
"A"
],
"storage_charge_discharge_power": [
4591,
"W"
],
"storage_total_charge": [
277825.52,
"kWh"
],
"storage_total_discharge": [
399.37,
"kWh"
],
"storage_current_day_charge_capacity": [
8.02,
"kWh"
],
"storage_current_day_discharge_capacity": [
3.0,
"kWh"
]
}
}
}
I've added the logs of the pymodbus activity?
2023-05-12 15:44:07.122 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32064 with length 52 from slave 0
2023-05-12 15:44:07.124 DEBUG (MainThread) [pymodbus.logging] send: 0x0 0x17 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2023-05-12 15:44:07.127 DEBUG (MainThread) [pymodbus.logging] Adding transaction 23
2023-05-12 15:44:07.138 DEBUG (MainThread) [pymodbus.logging] recv: 0x0 0x17 0x0 0x0 0x0 0x6b 0x0 0x3 0x68 0x0 0x0 0x12 0xc4 0x9 0x7b 0x0 0x0 0x0 0x0 0x4 0xc5 0x0 0x2 0x0 0x0 0x0 0x0 0x4 0xb9 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0xd 0xe1 0x0 0x0 0x1 0x15 0x0 0x0 0x0 0x1 0x3 0xe8 0x13 0x88 0x27 0x10 0x1 0x6a 0xb 0xb8 0x2 0x0 0x0 0x0 0x64 0x5d 0xf6 0x50 0xff 0xff 0xff 0xff 0x0 0x0 0x1 0x16 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x10 0xfc 0x0 0x1 0xdf 0xad 0x0 0x2 0xf 0x41 0x64 0x5e 0x5e 0xc3 0x0 0x0 0x0 0x1c 0x0 0x0 0x2 0x18
2023-05-12 15:44:07.139 DEBUG (MainThread) [pymodbus.logging] Processing: 0x0 0x17 0x0 0x0 0x0 0x6b 0x0 0x3 0x68 0x0 0x0 0x12 0xc4 0x9 0x7b 0x0 0x0 0x0 0x0 0x4 0xc5 0x0 0x2 0x0 0x0 0x0 0x0 0x4 0xb9 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0xd 0xe1 0x0 0x0 0x1 0x15 0x0 0x0 0x0 0x1 0x3 0xe8 0x13 0x88 0x27 0x10 0x1 0x6a 0xb 0xb8 0x2 0x0 0x0 0x0 0x64 0x5d 0xf6 0x50 0xff 0xff 0xff 0xff 0x0 0x0 0x1 0x16 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x10 0xfc 0x0 0x1 0xdf 0xad 0x0 0x2 0xf 0x41 0x64 0x5e 0x5e 0xc3 0x0 0x0 0x0 0x1c 0x0 0x0 0x2 0x18
2023-05-12 15:44:07.139 DEBUG (MainThread) [pymodbus.logging] Factory Response[ReadHoldingRegistersResponse': 3]
2023-05-12 15:44:07.139 DEBUG (MainThread) [pymodbus.logging] Getting transaction 23
2023-05-12 15:44:07.140 DEBUG (MainThread) [pymodbus.logging] [0, 4804, 2427, 0, 0, 1221, 2, 0, 0, 1209, 0, 0, 0, 0, 0, 3553, 0, 277, 0, 1, 1000, 5000, 10000, 362, 3000, 512, 0, 25693, 63056, 65535, 65535, 0, 278, 0, 0, 0, 0, 0, 0, 0, 0, 4348, 1, 57261, 2, 3905, 25694, 24259, 0, 28, 0, 536]
2023-05-12 15:44:07.140 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x12\xc4']
2023-05-12 15:44:07.141 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x04\xb9']
2023-05-12 15:44:07.141 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x00\x00']
2023-05-12 15:44:07.141 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x00\x00']
2023-05-12 15:44:07.141 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\r\xe1']
2023-05-12 15:44:07.141 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x01\x15']
2023-05-12 15:44:07.142 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x00\x01']
2023-05-12 15:44:07.142 DEBUG (MainThread) [pymodbus.logging] handle: [b'd]', b'\xf6P']
2023-05-12 15:44:07.142 DEBUG (MainThread) [pymodbus.logging] handle: [b'\xff\xff', b'\xff\xff']
2023-05-12 15:44:07.143 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x01', b'\xdf\xad']
2023-05-12 15:44:07.143 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x02\x18']
2023-05-12 15:44:07.195 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32000 with length 20 from slave 0
2023-05-12 15:44:07.195 DEBUG (MainThread) [pymodbus.logging] send: 0x0 0x18 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x0 0x0 0x14
2023-05-12 15:44:07.197 DEBUG (MainThread) [pymodbus.logging] Adding transaction 24
2023-05-12 15:44:07.213 DEBUG (MainThread) [pymodbus.logging] recv: 0x0 0x18 0x0 0x0 0x0 0x2b 0x0 0x3 0x28 0x0 0x6 0x0 0x0 0x0 0x7 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x71 0xf1 0xa 0xa9 0x2 0xb1 0xb 0x92 0x3 0xde
2023-05-12 15:44:07.213 DEBUG (MainThread) [pymodbus.logging] Processing: 0x0 0x18 0x0 0x0 0x0 0x2b 0x0 0x3 0x28 0x0 0x6 0x0 0x0 0x0 0x7 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x71 0xf1 0xa 0xa9 0x2 0xb1 0xb 0x92 0x3 0xde
2023-05-12 15:44:07.214 DEBUG (MainThread) [pymodbus.logging] Factory Response[ReadHoldingRegistersResponse': 3]
2023-05-12 15:44:07.214 DEBUG (MainThread) [pymodbus.logging] Getting transaction 24
2023-05-12 15:44:07.215 DEBUG (MainThread) [pymodbus.logging] [6, 0, 7, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 29169, 2729, 689, 2962, 990]
2023-05-12 15:44:07.215 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x00\x00']
2023-05-12 15:44:07.267 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37100 with length 38 from slave 0
2023-05-12 15:44:07.268 DEBUG (MainThread) [pymodbus.logging] send: 0x0 0x19 0x0 0x0 0x0 0x6 0x0 0x3 0x90 0xec 0x0 0x26
2023-05-12 15:44:07.270 DEBUG (MainThread) [pymodbus.logging] Adding transaction 25
2023-05-12 15:44:07.299 DEBUG (MainThread) [pymodbus.logging] recv: 0x0 0x19 0x0 0x0 0x0 0x4f 0x0 0x3 0x4c 0x0 0x1 0x0 0x0 0x9 0x75 0x0 0x0 0x9 0x68 0x0 0x0 0x9 0x5b 0x0 0x0 0x0 0x58 0xff 0xff 0xff 0x84 0xff 0xff 0xff 0xd7 0xff 0xff 0xff 0xfc 0x0 0x0 0x1 0x62 0xff 0xf8 0x13 0x87 0x0 0x0 0xc7 0x30 0x0 0x1 0xac 0x49 0x0 0x0 0x0 0x0 0x0 0x1 0x0 0x0 0x10 0x56 0x0 0x0 0x10 0x40 0x0 0x0 0x10 0x4b 0x0 0x0 0x0 0xaa 0xff 0xff 0xff 0x66 0xff 0xff 0xff 0xec
2023-05-12 15:44:07.300 DEBUG (MainThread) [pymodbus.logging] Processing: 0x0 0x19 0x0 0x0 0x0 0x4f 0x0 0x3 0x4c 0x0 0x1 0x0 0x0 0x9 0x75 0x0 0x0 0x9 0x68 0x0 0x0 0x9 0x5b 0x0 0x0 0x0 0x58 0xff 0xff 0xff 0x84 0xff 0xff 0xff 0xd7 0xff 0xff 0xff 0xfc 0x0 0x0 0x1 0x62 0xff 0xf8 0x13 0x87 0x0 0x0 0xc7 0x30 0x0 0x1 0xac 0x49 0x0 0x0 0x0 0x0 0x0 0x1 0x0 0x0 0x10 0x56 0x0 0x0 0x10 0x40 0x0 0x0 0x10 0x4b 0x0 0x0 0x0 0xaa 0xff 0xff 0xff 0x66 0xff 0xff 0xff 0xec
2023-05-12 15:44:07.300 DEBUG (MainThread) [pymodbus.logging] Factory Response[ReadHoldingRegistersResponse': 3]
2023-05-12 15:44:07.300 DEBUG (MainThread) [pymodbus.logging] Getting transaction 25
2023-05-12 15:44:07.301 DEBUG (MainThread) [pymodbus.logging] [1, 0, 2421, 0, 2408, 0, 2395, 0, 88, 65535, 65412, 65535, 65495, 65535, 65532, 0, 354, 65528, 4999, 0, 50992, 1, 44105, 0, 0, 1, 0, 4182, 0, 4160, 0, 4171, 0, 170, 65535, 65382, 65535, 65516]
2023-05-12 15:44:07.302 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\tu']
2023-05-12 15:44:07.302 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\th']
2023-05-12 15:44:07.302 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\t[']
2023-05-12 15:44:07.303 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x00X']
2023-05-12 15:44:07.303 DEBUG (MainThread) [pymodbus.logging] handle: [b'\xff\xff', b'\xff\x84']
2023-05-12 15:44:07.303 DEBUG (MainThread) [pymodbus.logging] handle: [b'\xff\xff', b'\xff\xd7']
2023-05-12 15:44:07.304 DEBUG (MainThread) [pymodbus.logging] handle: [b'\xff\xff', b'\xff\xfc']
2023-05-12 15:44:07.304 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x01b']
2023-05-12 15:44:07.304 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\xc70']
2023-05-12 15:44:07.305 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x01', b'\xacI']
2023-05-12 15:44:07.305 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x00\x00']
2023-05-12 15:44:07.305 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x10V']
2023-05-12 15:44:07.306 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x10@']
2023-05-12 15:44:07.306 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x10K']
2023-05-12 15:44:07.308 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x00\xaa']
2023-05-12 15:44:07.309 DEBUG (MainThread) [pymodbus.logging] handle: [b'\xff\xff', b'\xfff']
2023-05-12 15:44:07.309 DEBUG (MainThread) [pymodbus.logging] handle: [b'\xff\xff', b'\xff\xec']
2023-05-12 15:44:07.361 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37760 with length 28 from slave 0
2023-05-12 15:44:07.362 DEBUG (MainThread) [pymodbus.logging] send: 0x0 0x1a 0x0 0x0 0x0 0x6 0x0 0x3 0x93 0x80 0x0 0x1c
2023-05-12 15:44:07.363 DEBUG (MainThread) [pymodbus.logging] Adding transaction 26
2023-05-12 15:44:07.533 DEBUG (MainThread) [pymodbus.logging] recv: 0x0 0x1a 0x0 0x0 0x0 0x3b 0x0 0x3 0x38 0x3 0x70 0x0 0x0 0x0 0x2 0x11 0x2a 0x0 0x67 0x0 0x0 0x11 0xaf 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x1 0xa7 0xed 0x98 0x0 0x0 0x9c 0x1 0x0 0x0 0x3 0x22 0x0 0x0 0x1 0x2c
2023-05-12 15:44:07.534 DEBUG (MainThread) [pymodbus.logging] Processing: 0x0 0x1a 0x0 0x0 0x0 0x3b 0x0 0x3 0x38 0x3 0x70 0x0 0x0 0x0 0x2 0x11 0x2a 0x0 0x67 0x0 0x0 0x11 0xaf 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x1 0xa7 0xed 0x98 0x0 0x0 0x9c 0x1 0x0 0x0 0x3 0x22 0x0 0x0 0x1 0x2c
2023-05-12 15:44:07.534 DEBUG (MainThread) [pymodbus.logging] Factory Response[ReadHoldingRegistersResponse': 3]
2023-05-12 15:44:07.534 DEBUG (MainThread) [pymodbus.logging] Getting transaction 26
2023-05-12 15:44:07.535 DEBUG (MainThread) [pymodbus.logging] [880, 0, 2, 4394, 103, 0, 4527, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 423, 60824, 0, 39937, 0, 802, 0, 300]
2023-05-12 15:44:07.536 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x11\xaf']
2023-05-12 15:44:07.536 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x01\xa7', b'\xed\x98']
2023-05-12 15:44:07.536 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x9c\x01']
2023-05-12 15:44:07.537 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x03"']
2023-05-12 15:44:07.537 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x01,']
2023-05-12 15:44:07.537 DEBUG (MainThread) [custom_components.huawei_solar] Finished fetching HV2250368630_data_update_coordinator data in 0.416 seconds (success: True)
2023-05-12 15:44:13.520 INFO (MainThread) [pymodbus.logging] Protocol lost connection.
2023-05-12 15:44:13.628 INFO (MainThread) [pymodbus.logging] Protocol made connection.
2023-05-12 15:44:13.631 INFO (MainThread) [pymodbus.logging] Connected to 192.168.200.1:6607.
2023-05-12 15:44:14.151 INFO (MainThread) [huawei_solar.huawei_solar] Waiting for connection ...
2023-05-12 15:44:16.026 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.huawei_solar
2023-05-12 15:44:16.027 INFO (MainThread) [homeassistant.components.number] Setting up number.huawei_solar
2023-05-12 15:44:16.028 INFO (MainThread) [homeassistant.components.switch] Setting up switch.huawei_solar
2023-05-12 15:44:16.029 INFO (MainThread) [homeassistant.components.select] Setting up select.huawei_solar
2023-05-12 15:44:16.032 INFO (MainThread) [custom_components.huawei_solar.number] Skipping number setup, as parameter configuration is not enabled
2023-05-12 15:44:16.032 INFO (MainThread) [custom_components.huawei_solar.switch] Skipping switch setup, as parameter configuration is not enabled
2023-05-12 15:44:16.032 INFO (MainThread) [custom_components.huawei_solar.select] Skipping select setup, as parameter configuration is not enabled
2023-05-12 15:46:26.455 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32064 with length 52 from slave 0
2023-05-12 15:46:26.456 DEBUG (MainThread) [pymodbus.logging] send: 0x0 0x23 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2023-05-12 15:46:26.457 DEBUG (MainThread) [pymodbus.logging] Adding transaction 35
2023-05-12 15:46:26.541 DEBUG (MainThread) [pymodbus.logging] recv: 0x0 0x23 0x0 0x0 0x0 0x6b 0x0 0x3 0x68 0x0 0x0 0x13 0xff 0x9 0x7e 0x0 0x0 0x0 0x0 0x4 0xc6 0x0 0x2 0x0 0x0 0x0 0x0 0x5 0x21 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0xd 0xe1 0x0 0x0 0x1 0x2f 0xff 0xff 0xff 0xff 0x3 0xe8 0x13 0x89 0x27 0x10 0x1 0x6c 0xb 0xb8 0x2 0x0 0x0 0x0 0x64 0x5d 0xf6 0x50 0xff 0xff 0xff 0xff 0x0 0x0 0x1 0x30 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x10 0xfc 0x0 0x1 0xdf 0xaf 0x0 0x2 0xf 0x54 0x64 0x5e 0x5f 0x4e 0x0 0x0 0x0 0x1e 0x0 0x0 0x2 0x1a
2023-05-12 15:46:26.542 DEBUG (MainThread) [pymodbus.logging] Processing: 0x0 0x23 0x0 0x0 0x0 0x6b 0x0 0x3 0x68 0x0 0x0 0x13 0xff 0x9 0x7e 0x0 0x0 0x0 0x0 0x4 0xc6 0x0 0x2 0x0 0x0 0x0 0x0 0x5 0x21 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0xd 0xe1 0x0 0x0 0x1 0x2f 0xff 0xff 0xff 0xff 0x3 0xe8 0x13 0x89 0x27 0x10 0x1 0x6c 0xb 0xb8 0x2 0x0 0x0 0x0 0x64 0x5d 0xf6 0x50 0xff 0xff 0xff 0xff 0x0 0x0 0x1 0x30 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x10 0xfc 0x0 0x1 0xdf 0xaf 0x0 0x2 0xf 0x54 0x64 0x5e 0x5f 0x4e 0x0 0x0 0x0 0x1e 0x0 0x0 0x2 0x1a
2023-05-12 15:46:26.542 DEBUG (MainThread) [pymodbus.logging] Factory Response[ReadHoldingRegistersResponse': 3]
2023-05-12 15:46:26.543 DEBUG (MainThread) [pymodbus.logging] Getting transaction 35
2023-05-12 15:46:26.545 DEBUG (MainThread) [pymodbus.logging] [0, 5119, 2430, 0, 0, 1222, 2, 0, 0, 1313, 0, 0, 0, 0, 0, 3553, 0, 303, 65535, 65535, 1000, 5001, 10000, 364, 3000, 512, 0, 25693, 63056, 65535, 65535, 0, 304, 0, 0, 0, 0, 0, 0, 0, 0, 4348, 1, 57263, 2, 3924, 25694, 24398, 0, 30, 0, 538]
2023-05-12 15:46:26.545 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x13\xff']
2023-05-12 15:46:26.546 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x05!']
2023-05-12 15:46:26.546 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x00\x00']
2023-05-12 15:46:26.546 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x00\x00']
2023-05-12 15:46:26.547 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\r\xe1']
2023-05-12 15:46:26.547 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x01/']
2023-05-12 15:46:26.547 DEBUG (MainThread) [pymodbus.logging] handle: [b'\xff\xff', b'\xff\xff']
2023-05-12 15:46:26.548 DEBUG (MainThread) [pymodbus.logging] handle: [b'd]', b'\xf6P']
2023-05-12 15:46:26.548 DEBUG (MainThread) [pymodbus.logging] handle: [b'\xff\xff', b'\xff\xff']
2023-05-12 15:46:26.548 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x01', b'\xdf\xaf']
2023-05-12 15:46:26.549 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x02\x1a']
2023-05-12 15:46:26.601 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32000 with length 20 from slave 0
2023-05-12 15:46:26.602 DEBUG (MainThread) [pymodbus.logging] send: 0x0 0x24 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x0 0x0 0x14
2023-05-12 15:46:26.603 DEBUG (MainThread) [pymodbus.logging] Adding transaction 36
2023-05-12 15:46:26.611 DEBUG (MainThread) [pymodbus.logging] recv: 0x0 0x24 0x0 0x0 0x0 0x2b 0x0 0x3 0x28 0x0 0x6 0x0 0x0 0x0 0x7 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x71 0xf1 0xa 0xa9 0x2 0xef 0xb 0x80 0x4 0x17
2023-05-12 15:46:26.612 DEBUG (MainThread) [pymodbus.logging] Processing: 0x0 0x24 0x0 0x0 0x0 0x2b 0x0 0x3 0x28 0x0 0x6 0x0 0x0 0x0 0x7 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x71 0xf1 0xa 0xa9 0x2 0xef 0xb 0x80 0x4 0x17
2023-05-12 15:46:26.612 DEBUG (MainThread) [pymodbus.logging] Factory Response[ReadHoldingRegistersResponse': 3]
2023-05-12 15:46:26.612 DEBUG (MainThread) [pymodbus.logging] Getting transaction 36
2023-05-12 15:46:26.613 DEBUG (MainThread) [pymodbus.logging] [6, 0, 7, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 29169, 2729, 751, 2944, 1047]
2023-05-12 15:46:26.613 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x00\x00']
2023-05-12 15:46:26.665 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37100 with length 38 from slave 0
2023-05-12 15:46:26.666 DEBUG (MainThread) [pymodbus.logging] send: 0x0 0x25 0x0 0x0 0x0 0x6 0x0 0x3 0x90 0xec 0x0 0x26
2023-05-12 15:46:26.667 DEBUG (MainThread) [pymodbus.logging] Adding transaction 37
2023-05-12 15:46:26.676 DEBUG (MainThread) [pymodbus.logging] recv: 0x0 0x25 0x0 0x0 0x0 0x4f 0x0 0x3 0x4c 0x0 0x1 0x0 0x0 0x9 0x72 0x0 0x0 0x9 0x77 0x0 0x0 0x9 0x4f 0x0 0x0 0x0 0x5c 0xff 0xff 0xff 0x83 0xff 0xff 0xff 0xd7 0x0 0x0 0x0 0x2 0x0 0x0 0x1 0x63 0xff 0xfe 0x13 0x88 0x0 0x0 0xc7 0x30 0x0 0x1 0xac 0x49 0x0 0x0 0x0 0x0 0x0 0x1 0x0 0x0 0x10 0x60 0x0 0x0 0x10 0x42 0x0 0x0 0x10 0x3d 0x0 0x0 0x0 0xb4 0xff 0xff 0xff 0x63 0xff 0xff 0xff 0xeb
2023-05-12 15:46:26.677 DEBUG (MainThread) [pymodbus.logging] Processing: 0x0 0x25 0x0 0x0 0x0 0x4f 0x0 0x3 0x4c 0x0 0x1 0x0 0x0 0x9 0x72 0x0 0x0 0x9 0x77 0x0 0x0 0x9 0x4f 0x0 0x0 0x0 0x5c 0xff 0xff 0xff 0x83 0xff 0xff 0xff 0xd7 0x0 0x0 0x0 0x2 0x0 0x0 0x1 0x63 0xff 0xfe 0x13 0x88 0x0 0x0 0xc7 0x30 0x0 0x1 0xac 0x49 0x0 0x0 0x0 0x0 0x0 0x1 0x0 0x0 0x10 0x60 0x0 0x0 0x10 0x42 0x0 0x0 0x10 0x3d 0x0 0x0 0x0 0xb4 0xff 0xff 0xff 0x63 0xff 0xff 0xff 0xeb
2023-05-12 15:46:26.677 DEBUG (MainThread) [pymodbus.logging] Factory Response[ReadHoldingRegistersResponse': 3]
2023-05-12 15:46:26.677 DEBUG (MainThread) [pymodbus.logging] Getting transaction 37
2023-05-12 15:46:26.678 DEBUG (MainThread) [pymodbus.logging] [1, 0, 2418, 0, 2423, 0, 2383, 0, 92, 65535, 65411, 65535, 65495, 0, 2, 0, 355, 65534, 5000, 0, 50992, 1, 44105, 0, 0, 1, 0, 4192, 0, 4162, 0, 4157, 0, 180, 65535, 65379, 65535, 65515]
2023-05-12 15:46:26.678 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\tr']
2023-05-12 15:46:26.679 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\tw']
2023-05-12 15:46:26.679 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\tO']
2023-05-12 15:46:26.679 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x00\\']
2023-05-12 15:46:26.679 DEBUG (MainThread) [pymodbus.logging] handle: [b'\xff\xff', b'\xff\x83']
2023-05-12 15:46:26.680 DEBUG (MainThread) [pymodbus.logging] handle: [b'\xff\xff', b'\xff\xd7']
2023-05-12 15:46:26.680 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x00\x02']
2023-05-12 15:46:26.680 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x01c']
2023-05-12 15:46:26.680 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\xc70']
2023-05-12 15:46:26.681 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x01', b'\xacI']
2023-05-12 15:46:26.681 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x00\x00']
2023-05-12 15:46:26.681 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x10`']
2023-05-12 15:46:26.682 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x10B']
2023-05-12 15:46:26.682 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x10=']
2023-05-12 15:46:26.682 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x00\xb4']
2023-05-12 15:46:26.682 DEBUG (MainThread) [pymodbus.logging] handle: [b'\xff\xff', b'\xffc']
2023-05-12 15:46:26.682 DEBUG (MainThread) [pymodbus.logging] handle: [b'\xff\xff', b'\xff\xeb']
2023-05-12 15:46:26.735 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37760 with length 28 from slave 0
2023-05-12 15:46:26.736 DEBUG (MainThread) [pymodbus.logging] send: 0x0 0x26 0x0 0x0 0x0 0x6 0x0 0x3 0x93 0x80 0x0 0x1c
2023-05-12 15:46:26.738 DEBUG (MainThread) [pymodbus.logging] Adding transaction 38
2023-05-12 15:46:26.747 DEBUG (MainThread) [pymodbus.logging] recv: 0x0 0x26 0x0 0x0 0x0 0x3b 0x0 0x3 0x38 0x3 0x7a 0x0 0x0 0x0 0x2 0x11 0x2b 0x0 0x6d 0x0 0x0 0x12 0xd0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x1 0xa7 0xed 0xaf 0x0 0x0 0x9c 0x1 0x0 0x0 0x3 0x39 0x0 0x0 0x1 0x2c
2023-05-12 15:46:26.748 DEBUG (MainThread) [pymodbus.logging] Processing: 0x0 0x26 0x0 0x0 0x0 0x3b 0x0 0x3 0x38 0x3 0x7a 0x0 0x0 0x0 0x2 0x11 0x2b 0x0 0x6d 0x0 0x0 0x12 0xd0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x1 0xa7 0xed 0xaf 0x0 0x0 0x9c 0x1 0x0 0x0 0x3 0x39 0x0 0x0 0x1 0x2c
2023-05-12 15:46:26.748 DEBUG (MainThread) [pymodbus.logging] Factory Response[ReadHoldingRegistersResponse': 3]
2023-05-12 15:46:26.749 DEBUG (MainThread) [pymodbus.logging] Getting transaction 38
2023-05-12 15:46:26.749 DEBUG (MainThread) [pymodbus.logging] [890, 0, 2, 4395, 109, 0, 4816, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 423, 60847, 0, 39937, 0, 825, 0, 300]
2023-05-12 15:46:26.750 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x12\xd0']
2023-05-12 15:46:26.750 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x01\xa7', b'\xed\xaf']
2023-05-12 15:46:26.751 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x9c\x01']
2023-05-12 15:46:26.751 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x039']
2023-05-12 15:46:26.751 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x01,']
2023-05-12 15:46:26.751 DEBUG (MainThread) [custom_components.huawei_solar] Finished fetching HV2250368630_data_update_coordinator data in 0.298 seconds (success: True)
2023-05-12 15:46:55.079 INFO (MainThread) [pyhap.hap_protocol] ('192.168.0.225', 49517): Connection made to HASS Bridge 0I
2023-05-12 15:46:55.110 ERROR (MainThread) [pyhap.hap_handler] ('192.168.0.225', 49517): Client b471acd9-e859-4ae2-94f4-6190900d9179 attempted pair verify without being paired to HASS Bridge 0I first.
2023-05-12 15:46:56.456 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32064 with length 52 from slave 0
2023-05-12 15:46:56.457 DEBUG (MainThread) [pymodbus.logging] send: 0x0 0x27 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x40 0x0 0x34
2023-05-12 15:46:56.462 DEBUG (MainThread) [pymodbus.logging] Adding transaction 39
2023-05-12 15:46:56.567 DEBUG (MainThread) [pymodbus.logging] recv: 0x0 0x27 0x0 0x0 0x0 0x6b 0x0 0x3 0x68 0x0 0x0 0x13 0x98 0x9 0x7e 0x0 0x0 0x0 0x0 0x4 0xc6 0x0 0x1 0x0 0x0 0x0 0x0 0x5 0x1e 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0xd 0xe1 0x0 0x0 0x1 0x2e 0x0 0x0 0x0 0x3 0x3 0xe8 0x13 0x8b 0x27 0x10 0x1 0x6c 0xb 0xb8 0x2 0x0 0x0 0x0 0x64 0x5d 0xf6 0x50 0xff 0xff 0xff 0xff 0x0 0x0 0x1 0x26 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x10 0xfc 0x0 0x1 0xdf 0xaf 0x0 0x2 0xf 0x58 0x64 0x5e 0x5f 0x68 0x0 0x0 0x0 0x1e 0x0 0x0 0x2 0x1a
2023-05-12 15:46:56.568 DEBUG (MainThread) [pymodbus.logging] Processing: 0x0 0x27 0x0 0x0 0x0 0x6b 0x0 0x3 0x68 0x0 0x0 0x13 0x98 0x9 0x7e 0x0 0x0 0x0 0x0 0x4 0xc6 0x0 0x1 0x0 0x0 0x0 0x0 0x5 0x1e 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0xd 0xe1 0x0 0x0 0x1 0x2e 0x0 0x0 0x0 0x3 0x3 0xe8 0x13 0x8b 0x27 0x10 0x1 0x6c 0xb 0xb8 0x2 0x0 0x0 0x0 0x64 0x5d 0xf6 0x50 0xff 0xff 0xff 0xff 0x0 0x0 0x1 0x26 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x10 0xfc 0x0 0x1 0xdf 0xaf 0x0 0x2 0xf 0x58 0x64 0x5e 0x5f 0x68 0x0 0x0 0x0 0x1e 0x0 0x0 0x2 0x1a
2023-05-12 15:46:56.569 DEBUG (MainThread) [pymodbus.logging] Factory Response[ReadHoldingRegistersResponse': 3]
2023-05-12 15:46:56.569 DEBUG (MainThread) [pymodbus.logging] Getting transaction 39
2023-05-12 15:46:56.570 DEBUG (MainThread) [pymodbus.logging] [0, 5016, 2430, 0, 0, 1222, 1, 0, 0, 1310, 0, 0, 0, 0, 0, 3553, 0, 302, 0, 3, 1000, 5003, 10000, 364, 3000, 512, 0, 25693, 63056, 65535, 65535, 0, 294, 0, 0, 0, 0, 0, 0, 0, 0, 4348, 1, 57263, 2, 3928, 25694, 24424, 0, 30, 0, 538]
2023-05-12 15:46:56.571 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x13\x98']
2023-05-12 15:46:56.571 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x05\x1e']
2023-05-12 15:46:56.572 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x00\x00']
2023-05-12 15:46:56.572 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x00\x00']
2023-05-12 15:46:56.572 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\r\xe1']
2023-05-12 15:46:56.573 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x01.']
2023-05-12 15:46:56.573 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x00\x03']
2023-05-12 15:46:56.573 DEBUG (MainThread) [pymodbus.logging] handle: [b'd]', b'\xf6P']
2023-05-12 15:46:56.574 DEBUG (MainThread) [pymodbus.logging] handle: [b'\xff\xff', b'\xff\xff']
2023-05-12 15:46:56.574 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x01', b'\xdf\xaf']
2023-05-12 15:46:56.574 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x02\x1a']
2023-05-12 15:46:56.628 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32000 with length 20 from slave 0
2023-05-12 15:46:56.628 DEBUG (MainThread) [pymodbus.logging] send: 0x0 0x28 0x0 0x0 0x0 0x6 0x0 0x3 0x7d 0x0 0x0 0x14
2023-05-12 15:46:56.631 DEBUG (MainThread) [pymodbus.logging] Adding transaction 40
2023-05-12 15:46:56.642 DEBUG (MainThread) [pymodbus.logging] recv: 0x0 0x28 0x0 0x0 0x0 0x2b 0x0 0x3 0x28 0x0 0x6 0x0 0x0 0x0 0x7 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x71 0xf1 0xa 0xc7 0x2 0xbd 0xb 0x74 0x4 0x1e
2023-05-12 15:46:56.642 DEBUG (MainThread) [pymodbus.logging] Processing: 0x0 0x28 0x0 0x0 0x0 0x2b 0x0 0x3 0x28 0x0 0x6 0x0 0x0 0x0 0x7 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x71 0xf1 0xa 0xc7 0x2 0xbd 0xb 0x74 0x4 0x1e
2023-05-12 15:46:56.642 DEBUG (MainThread) [pymodbus.logging] Factory Response[ReadHoldingRegistersResponse': 3]
2023-05-12 15:46:56.643 DEBUG (MainThread) [pymodbus.logging] Getting transaction 40
2023-05-12 15:46:56.643 DEBUG (MainThread) [pymodbus.logging] [6, 0, 7, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 29169, 2759, 701, 2932, 1054]
2023-05-12 15:46:56.644 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x00\x00']
2023-05-12 15:46:56.695 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37100 with length 38 from slave 0
2023-05-12 15:46:56.696 DEBUG (MainThread) [pymodbus.logging] send: 0x0 0x29 0x0 0x0 0x0 0x6 0x0 0x3 0x90 0xec 0x0 0x26
2023-05-12 15:46:56.698 DEBUG (MainThread) [pymodbus.logging] Adding transaction 41
2023-05-12 15:46:56.707 DEBUG (MainThread) [pymodbus.logging] recv: 0x0 0x29 0x0 0x0 0x0 0x4f 0x0 0x3 0x4c 0x0 0x1 0x0 0x0 0x9 0x75 0x0 0x0 0x9 0x6d 0x0 0x0 0x9 0x59 0x0 0x0 0x0 0x60 0xff 0xff 0xff 0x81 0xff 0xff 0xff 0xd7 0x0 0x0 0x0 0xa 0x0 0x0 0x1 0x68 0xff 0xf2 0x13 0x8a 0x0 0x0 0xc7 0x30 0x0 0x1 0xac 0x49 0x0 0x0 0x0 0x0 0x0 0x1 0x0 0x0 0x10 0x5b 0x0 0x0 0x10 0x42 0x0 0x0 0x10 0x48 0x0 0x0 0x0 0xbd 0xff 0xff 0xff 0x62 0xff 0xff 0xff 0xec
2023-05-12 15:46:56.708 DEBUG (MainThread) [pymodbus.logging] Processing: 0x0 0x29 0x0 0x0 0x0 0x4f 0x0 0x3 0x4c 0x0 0x1 0x0 0x0 0x9 0x75 0x0 0x0 0x9 0x6d 0x0 0x0 0x9 0x59 0x0 0x0 0x0 0x60 0xff 0xff 0xff 0x81 0xff 0xff 0xff 0xd7 0x0 0x0 0x0 0xa 0x0 0x0 0x1 0x68 0xff 0xf2 0x13 0x8a 0x0 0x0 0xc7 0x30 0x0 0x1 0xac 0x49 0x0 0x0 0x0 0x0 0x0 0x1 0x0 0x0 0x10 0x5b 0x0 0x0 0x10 0x42 0x0 0x0 0x10 0x48 0x0 0x0 0x0 0xbd 0xff 0xff 0xff 0x62 0xff 0xff 0xff 0xec
2023-05-12 15:46:56.708 DEBUG (MainThread) [pymodbus.logging] Factory Response[ReadHoldingRegistersResponse': 3]
2023-05-12 15:46:56.709 DEBUG (MainThread) [pymodbus.logging] Getting transaction 41
2023-05-12 15:46:56.709 DEBUG (MainThread) [pymodbus.logging] [1, 0, 2421, 0, 2413, 0, 2393, 0, 96, 65535, 65409, 65535, 65495, 0, 10, 0, 360, 65522, 5002, 0, 50992, 1, 44105, 0, 0, 1, 0, 4187, 0, 4162, 0, 4168, 0, 189, 65535, 65378, 65535, 65516]
2023-05-12 15:46:56.710 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\tu']
2023-05-12 15:46:56.710 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\tm']
2023-05-12 15:46:56.710 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\tY']
2023-05-12 15:46:56.711 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x00`']
2023-05-12 15:46:56.711 DEBUG (MainThread) [pymodbus.logging] handle: [b'\xff\xff', b'\xff\x81']
2023-05-12 15:46:56.711 DEBUG (MainThread) [pymodbus.logging] handle: [b'\xff\xff', b'\xff\xd7']
2023-05-12 15:46:56.711 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x00\n']
2023-05-12 15:46:56.711 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x01h']
2023-05-12 15:46:56.712 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\xc70']
2023-05-12 15:46:56.712 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x01', b'\xacI']
2023-05-12 15:46:56.712 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x00\x00']
2023-05-12 15:46:56.712 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x10[']
2023-05-12 15:46:56.712 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x10B']
2023-05-12 15:46:56.713 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x10H']
2023-05-12 15:46:56.713 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x00\xbd']
2023-05-12 15:46:56.713 DEBUG (MainThread) [pymodbus.logging] handle: [b'\xff\xff', b'\xffb']
2023-05-12 15:46:56.713 DEBUG (MainThread) [pymodbus.logging] handle: [b'\xff\xff', b'\xff\xec']
2023-05-12 15:46:56.765 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37760 with length 28 from slave 0
2023-05-12 15:46:56.766 DEBUG (MainThread) [pymodbus.logging] send: 0x0 0x2a 0x0 0x0 0x0 0x6 0x0 0x3 0x93 0x80 0x0 0x1c
2023-05-12 15:46:56.768 DEBUG (MainThread) [pymodbus.logging] Adding transaction 42
2023-05-12 15:46:56.779 DEBUG (MainThread) [pymodbus.logging] recv: 0x0 0x2a 0x0 0x0 0x0 0x3b 0x0 0x3 0x38 0x3 0x7a 0x0 0x0 0x0 0x2 0x11 0x2c 0x0 0x6b 0x0 0x0 0x12 0x6a 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x1 0xa7 0xed 0xaf 0x0 0x0 0x9c 0x1 0x0 0x0 0x3 0x39 0x0 0x0 0x1 0x2c
2023-05-12 15:46:56.780 DEBUG (MainThread) [pymodbus.logging] Processing: 0x0 0x2a 0x0 0x0 0x0 0x3b 0x0 0x3 0x38 0x3 0x7a 0x0 0x0 0x0 0x2 0x11 0x2c 0x0 0x6b 0x0 0x0 0x12 0x6a 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x1 0xa7 0xed 0xaf 0x0 0x0 0x9c 0x1 0x0 0x0 0x3 0x39 0x0 0x0 0x1 0x2c
2023-05-12 15:46:56.780 DEBUG (MainThread) [pymodbus.logging] Factory Response[ReadHoldingRegistersResponse': 3]
2023-05-12 15:46:56.780 DEBUG (MainThread) [pymodbus.logging] Getting transaction 42
2023-05-12 15:46:56.781 DEBUG (MainThread) [pymodbus.logging] [890, 0, 2, 4396, 107, 0, 4714, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 423, 60847, 0, 39937, 0, 825, 0, 300]
2023-05-12 15:46:56.781 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x12j']
2023-05-12 15:46:56.782 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x01\xa7', b'\xed\xaf']
2023-05-12 15:46:56.782 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x9c\x01']
2023-05-12 15:46:56.782 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x039']
2023-05-12 15:46:56.782 DEBUG (MainThread) [pymodbus.logging] handle: [b'\x00\x00', b'\x01,']
2023-05-12 15:46:56.783 DEBUG (MainThread) [custom_components.huawei_solar] Finished fetching HV2250368630_data_update_coordinator data in 0.328 seconds (success: True)
(if you'd prefer a file, let me know)
The interesting stuff from your logs, where total charge is found in the register 7-8 and total discharge found in register 5-6 when counting from the end. I've highlighted those registers in the response of the inverter by annotating them with ***.
2023-05-12 15:46:26.735 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37760 with length 28 from slave 0
2023-05-12 15:46:26.736 DEBUG (MainThread) [pymodbus.logging] send: 0x0 0x26 0x0 0x0 0x0 0x6 0x0 0x3 0x93 0x80 0x0 0x1c
2023-05-12 15:46:26.738 DEBUG (MainThread) [pymodbus.logging] Adding transaction 38
2023-05-12 15:46:26.747 DEBUG (MainThread) [pymodbus.logging] recv: 0x0 0x26 0x0 0x0 0x0 0x3b 0x0 0x3 0x38 0x3 0x7a 0x0 0x0 0x0 0x2 0x11 0x2b 0x0 0x6d 0x0 0x0 0x12 0xd0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x1 0xa7 0xed 0xaf 0x0 0x0 0x9c 0x1 0x0 0x0 0x3 0x39 0x0 0x0 0x1 0x2c
2023-05-12 15:46:26.748 DEBUG (MainThread) [pymodbus.logging] Processing: 0x0 0x26 0x0 0x0 0x0 0x3b 0x0 0x3 0x38 0x3 0x7a 0x0 0x0 0x0 0x2 0x11 0x2b 0x0 0x6d 0x0 0x0 0x12 0xd0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 *** 0x1 0xa7 0xed 0xaf 0x0 0x0 0x9c 0x1 *** 0x0 0x0 0x3 0x39 0x0 0x0 0x1 0x2c
2023-05-12 15:46:26.748 DEBUG (MainThread) [pymodbus.logging] Factory Response[ReadHoldingRegistersResponse': 3]
2023-05-12 15:46:26.749 DEBUG (MainThread) [pymodbus.logging] Getting transaction 38
2023-05-12 15:46:26.749 DEBUG (MainThread) [pymodbus.logging] [890, 0, 2, 4395, 109, 0, 4816, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, ***423, 60847, 0, 39937***, 0, 825, 0, 300]
As you can see the inverter reports value 0x01a7edaf for the battery total charge register.
pyModbus correctly decodes the bytes received, as verified on https://rapidscada.net/modbus/
This 0x01a7edaf translates to 27782575 Wh, or 277825,75 kWh
So the integration receives incorrect data from the inverter. Please contact Huawei support and ask them why your inverter reports that big value when reading modbus register 37780
Oh great, thanks. Well, not great ;) But thanks for that, I'll try and contact them (I guess I'll still have to wait for the installer to give me an account before I can bug Huawei)
Please report back with their answer, as I guess you won't be the last one with this issue.
Good luck!
On Fri, May 12, 2023, 17:22 Sven Charleer @.***> wrote:
Oh great, thanks. Well, not great ;) But thanks for that, I'll try and contact them (I guess I'll still have to wait for the installer to give me an account before I can bug Huawei)
— Reply to this email directly, view it on GitHub https://github.com/wlcrs/huawei_solar/issues/307#issuecomment-1545916817, or unsubscribe https://github.com/notifications/unsubscribe-auth/AAQM5LFEN7GLD3LTRN62DLLXFZISFANCNFSM6AAAAAAVJ26RXI . You are receiving this because you were mentioned.Message ID: @.***>
Quick update. Been mailing back and forth with Huawei, just sent them the dongle logs, so hopefully news soon. Do realise now that I'm connecting to the inverter through inverter wifi <-> pi, while I could also be connecting it through dongle wifi <-> pi. Not sure if that'll make a difference.
(if anyone can explain me why there are 2 ways to connect to these inverters, would be great 😅)
AFAIK the dongle has 2 use cases:
If neither is the case, you're better of removing the dongle and complaining to your installer that they sold you something unnecessary.
This is the final answer I received. Doesn't really help me with the question "is my battery older than it should be?"
The calculation principle of 37780 is to increase the charging capacity of each BCU every two minutes. If the BCU or pack is replaced, the charging capacity of each BCU is not cleared but increases. If the customer needs to obtain the accumulated charge capacity of a BCU, it is recommended that you read the accumulated charge and discharge capacity of each pack and perform addition calculation. The interfaces are as follows: 38238, 2, [Energy storage port] [Module 1] [Battery pack 1] Accumulated charge level 38240, 2, [Energy storage port] [Module 1] [Battery pack 1] accumulated discharged capacity 38280, 2, [Energy storage port] [Module 1] [Battery pack 2] Accumulated charge level 38282, 2, [Energy storage port] [Module 1] [Battery pack 2] Accumulated discharge capacity 38322, 2, [Energy storage port] [Module 1] [Battery pack 3] Accumulated charge level 38324, 2, [Energy storage port] [Module 1] [Battery pack 3] Accumulated discharge capacity 38364, 2, [Energy storage port] [Module 2] [Battery pack 1] Accumulated charge level 38366, 2, [Energy storage port], [Module 2], [Battery pack 1] total discharged capacity 38406, 2, [Energy storage port] [Module 2] [Battery pack 2] Accumulated charge level 38408, 2, [Energy storage port] [Module 2] [Battery pack 2] Accumulated discharge capacity 38448, 2, [Energy storage port] [Module 2] [Battery pack 3] Accumulated charge level 38450, 2, [Energy storage port] [Module 2] [Battery pack 3] Accumulated discharge capacity”
According to Huawei (and now that I have portal login info), the battery should be fine. So it's just an odd bus behaviour. Hope this info is useful for you in one way or the other!
Closing this issue as there is no work to be done.
Describe the issue
Hello.
Everything was working as expected, but suddenly we got a strange value in the following fields:
storage_total_discharge storage_total_charge
Any idea what may cause this issue? Forcing a value change in the recorder at "Devloper/Statistics" section does not work.
Thanks!
Bescribe your Huawei Solar Setup
Inverter Type: SUN2000-6KTL-L1 Inverter Firmware version: V200R001C00SPC127 SDongle present: yes Power meter present: single phase Battery: LUNA2000 30kWh Battery Firmware version: V100R002C00SPC118
How do you connect to the inverter?
Over serial, with a serial-to-USB stick
Upload your Diagnostics File
Upload your relevant debug logs
Please confirm the following: