Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

[Bug]: cant connect to inverter in 1.2.0b5 #225

Closed
3 of 4 tasks
etamtlosz opened this issue Jan 1, 2023 · 23 comments
Closed
3 of 4 tasks

[Bug]: cant connect to inverter in 1.2.0b5 #225

etamtlosz opened this issue Jan 1, 2023 · 23 comments
Labels
bug Something isn't working

Comments

@etamtlosz
Copy link

Describe the issue

After recommending to upgrade to beta, to get access to my optimizers, as stated in #222 , I can not connect to the inverter anymore.
Tried deleting the integration from HACS, multiple HA restarts, etc.
The procedure crashes in the moment this line appears in the log 2023-01-01 19:36:24.510 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off file upload for 10.0 seconds after 3 tries
2023-01-01-19-29-58nZB2Ume0N5

Bescribe your Huawei Solar Setup

Inverter Type: SUN2000-5KTL-L1
Inverter Firmware version: V200R001C00SPC125
SDongle present: yes
Power meter present: single phase
Battery: LUNA2000 10kWh
Battery Firmware version :V100R002C00SPC116

How do you connect to the inverter?

Via the SDongle, wired connection

Upload your Diagnostics File

Drag & Drop your Diagnostics File here.

Upload your relevant debug logs

2023-01-01 19:35:26.727 DEBUG (MainThread) [pymodbus.client.tcp] Connecting to 192.168.2.170:502.
2023-01-01 19:35:26.727 DEBUG (MainThread) [pymodbus.client.tcp] Connecting.
2023-01-01 19:35:26.729 DEBUG (MainThread) [pymodbus.client.base] Client connected to modbus server
2023-01-01 19:35:26.729 INFO (MainThread) [pymodbus.client.tcp] Protocol made connection.
2023-01-01 19:35:26.729 INFO (MainThread) [pymodbus.client.tcp] Connected to 192.168.2.170:502.
2023-01-01 19:35:27.731 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 43006
2023-01-01 19:35:27.731 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x1 0x0 0x0 0x0 0x6 0x1 0x3 0xa7 0xfe 0x0 0x1
2023-01-01 19:35:27.731 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 1
2023-01-01 19:35:28.000 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x1 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x2 0xd0
2023-01-01 19:35:28.000 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x1 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x2 0xd0
2023-01-01 19:35:28.000 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:28.001 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 1
2023-01-01 19:35:28.052 DEBUG (MainThread) [pymodbus.payload] [720]
2023-01-01 19:35:28.052 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47000
2023-01-01 19:35:28.053 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x2 0x0 0x0 0x0 0x6 0x1 0x3 0xb7 0x98 0x0 0x1
2023-01-01 19:35:28.053 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 2
2023-01-01 19:35:28.109 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x2 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-01 19:35:28.109 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x2 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-01 19:35:28.109 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:28.109 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 2
2023-01-01 19:35:28.160 DEBUG (MainThread) [pymodbus.payload] [2]
2023-01-01 19:35:28.160 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 30000
2023-01-01 19:35:28.160 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x3 0x0 0x0 0x0 0x6 0x1 0x3 0x75 0x30 0x0 0x23
2023-01-01 19:35:28.160 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 3
2023-01-01 19:35:29.329 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x3 0x0 0x0 0x0 0x49 0x1 0x3 0x46 0x53 0x55 0x4e 0x32 0x30 0x30 0x30 0x2d 0x35 0x4b 0x54 0x4c 0x2d 0x4c 0x31 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x54 0x41 0x32 0x32 0x35 0x30 0x30 0x34 0x31 0x31 0x39 0x30 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x30 0x31 0x30 0x37 0x35 0x33 0x34 0x36 0x2d 0x30 0x31 0x35 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
2023-01-01 19:35:29.329 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x3 0x0 0x0 0x0 0x49 0x1 0x3 0x46 0x53 0x55 0x4e 0x32 0x30 0x30 0x30 0x2d 0x35 0x4b 0x54 0x4c 0x2d 0x4c 0x31 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x54 0x41 0x32 0x32 0x35 0x30 0x30 0x34 0x31 0x31 0x39 0x30 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x30 0x31 0x30 0x37 0x35 0x33 0x34 0x36 0x2d 0x30 0x31 0x35 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
2023-01-01 19:35:29.329 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:29.329 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 3
2023-01-01 19:35:29.380 DEBUG (MainThread) [pymodbus.payload] [21333, 20018, 12336, 12333, 13643, 21580, 11596, 12544, 0, 0, 0, 0, 0, 0, 0, 21569, 12850, 13616, 12340, 12593, 14640, 0, 0, 0, 0, 12337, 12343, 13619, 13366, 11568, 12597, 0, 0, 0, 0]
2023-01-01 19:35:29.380 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 30071
2023-01-01 19:35:29.380 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x4 0x0 0x0 0x0 0x6 0x1 0x3 0x75 0x77 0x0 0x1
2023-01-01 19:35:29.381 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 4
2023-01-01 19:35:30.365 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x4 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-01 19:35:30.365 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x4 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-01 19:35:30.365 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:30.365 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 4
2023-01-01 19:35:30.416 DEBUG (MainThread) [pymodbus.payload] [2]
2023-01-01 19:35:30.416 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37200
2023-01-01 19:35:30.416 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x5 0x0 0x0 0x0 0x6 0x1 0x3 0x91 0x50 0x0 0x1
2023-01-01 19:35:30.417 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 5
2023-01-01 19:35:30.815 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x5 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x4
2023-01-01 19:35:30.815 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x5 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x4
2023-01-01 19:35:30.815 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:30.815 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 5
2023-01-01 19:35:30.866 DEBUG (MainThread) [pymodbus.payload] [4]
2023-01-01 19:35:30.866 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37100
2023-01-01 19:35:30.866 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x6 0x0 0x0 0x0 0x6 0x1 0x3 0x90 0xec 0x0 0x1
2023-01-01 19:35:30.867 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 6
2023-01-01 19:35:31.675 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x6 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x1
2023-01-01 19:35:31.675 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x6 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x1
2023-01-01 19:35:31.675 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:31.675 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 6
2023-01-01 19:35:31.726 DEBUG (MainThread) [pymodbus.payload] [1]
2023-01-01 19:35:31.727 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37125
2023-01-01 19:35:31.727 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x7 0x0 0x0 0x0 0x6 0x1 0x3 0x91 0x5 0x0 0x1
2023-01-01 19:35:31.727 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 7
2023-01-01 19:35:32.339 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x7 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-01 19:35:32.339 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x7 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-01 19:35:32.339 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:32.339 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 7
2023-01-01 19:35:32.390 DEBUG (MainThread) [pymodbus.payload] [0]
2023-01-01 19:35:32.390 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47000
2023-01-01 19:35:32.390 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x8 0x0 0x0 0x0 0x6 0x1 0x3 0xb7 0x98 0x0 0x1
2023-01-01 19:35:32.390 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 8
2023-01-01 19:35:32.791 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x8 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-01 19:35:32.791 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x8 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-01 19:35:32.791 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:32.791 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 8
2023-01-01 19:35:32.843 DEBUG (MainThread) [pymodbus.payload] [2]
2023-01-01 19:35:32.843 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47089
2023-01-01 19:35:32.844 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x9 0x0 0x0 0x0 0x6 0x1 0x3 0xb7 0xf1 0x0 0x1
2023-01-01 19:35:32.844 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 9
2023-01-01 19:35:33.859 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x9 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-01 19:35:33.859 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x9 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-01 19:35:33.859 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:33.859 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 9
2023-01-01 19:35:33.910 DEBUG (MainThread) [pymodbus.payload] [0]
2023-01-01 19:35:33.910 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47954
2023-01-01 19:35:33.910 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xa 0x0 0x0 0x0 0x6 0x1 0x3 0xbb 0x52 0x0 0x1
2023-01-01 19:35:33.911 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 10
2023-01-01 19:35:34.310 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xa 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-01 19:35:34.310 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xa 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-01 19:35:34.310 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:34.310 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 10
2023-01-01 19:35:34.361 DEBUG (MainThread) [pymodbus.payload] [0]
2023-01-01 19:35:34.362 INFO (MainThread) [custom_components.huawei_solar.config_flow] Successfully connected to inverter SUN2000-5KTL-L1 with SN TA2250041190
2023-01-01 19:35:34.362 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 43006
2023-01-01 19:35:34.362 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xb 0x0 0x0 0x0 0x6 0x1 0x3 0xa7 0xfe 0x0 0x1
2023-01-01 19:35:34.362 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 11
2023-01-01 19:35:35.147 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xb 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x2 0xd0
2023-01-01 19:35:35.147 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xb 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x2 0xd0
2023-01-01 19:35:35.147 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:35.147 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 11
2023-01-01 19:35:35.198 DEBUG (MainThread) [pymodbus.payload] [720]
2023-01-01 19:35:35.199 DEBUG (MainThread) [pymodbus.payload] [720]
2023-01-01 19:35:35.199 DEBUG (MainThread) [pymodbus.payload] [720]
2023-01-01 19:35:35.199 DEBUG (MainThread) [huawei_solar.huawei_solar] Writing to 43006: [720]
2023-01-01 19:35:35.199 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xc 0x0 0x0 0x0 0x9 0x1 0x10 0xa7 0xfe 0x0 0x1 0x2 0x2 0xd0
2023-01-01 19:35:35.199 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 12
2023-01-01 19:35:36.281 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xc 0x0 0x0 0x0 0x6 0x1 0x10 0xa7 0xfe 0x0 0x1
2023-01-01 19:35:36.281 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xc 0x0 0x0 0x0 0x6 0x1 0x10 0xa7 0xfe 0x0 0x1
2023-01-01 19:35:36.281 DEBUG (MainThread) [pymodbus.factory] Factory Response[WriteMultipleRegistersResponse': 16]
2023-01-01 19:35:36.281 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 12
2023-01-01 19:35:36.333 DEBUG (MainThread) [pymodbus.client.base] Client disconnected from modbus server: None
2023-01-01 19:35:36.333 INFO (MainThread) [pymodbus.client.tcp] Protocol lost connection.
2023-01-01 19:35:36.335 DEBUG (MainThread) [pymodbus.client.tcp] Connecting to 192.168.2.170:502.
2023-01-01 19:35:36.335 DEBUG (MainThread) [pymodbus.client.tcp] Connecting.
2023-01-01 19:35:36.337 DEBUG (MainThread) [pymodbus.client.base] Client connected to modbus server
2023-01-01 19:35:36.337 INFO (MainThread) [pymodbus.client.tcp] Protocol made connection.
2023-01-01 19:35:36.337 INFO (MainThread) [pymodbus.client.tcp] Connected to 192.168.2.170:502.
2023-01-01 19:35:37.339 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 43006
2023-01-01 19:35:37.339 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x1 0x0 0x0 0x0 0x6 0x1 0x3 0xa7 0xfe 0x0 0x1
2023-01-01 19:35:37.339 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 1
2023-01-01 19:35:38.125 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x1 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x2 0xd0
2023-01-01 19:35:38.125 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x1 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x2 0xd0
2023-01-01 19:35:38.125 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:38.126 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 1
2023-01-01 19:35:38.176 DEBUG (MainThread) [pymodbus.payload] [720]
2023-01-01 19:35:38.177 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47000
2023-01-01 19:35:38.177 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x2 0x0 0x0 0x0 0x6 0x1 0x3 0xb7 0x98 0x0 0x1
2023-01-01 19:35:38.177 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 2
2023-01-01 19:35:38.619 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x2 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-01 19:35:38.619 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x2 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-01 19:35:38.619 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:38.619 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 2
2023-01-01 19:35:38.670 DEBUG (MainThread) [pymodbus.payload] [2]
2023-01-01 19:35:38.671 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 30000
2023-01-01 19:35:38.671 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x3 0x0 0x0 0x0 0x6 0x1 0x3 0x75 0x30 0x0 0x23
2023-01-01 19:35:38.671 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 3
2023-01-01 19:35:39.299 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x3 0x0 0x0 0x0 0x49 0x1 0x3 0x46 0x53 0x55 0x4e 0x32 0x30 0x30 0x30 0x2d 0x35 0x4b 0x54 0x4c 0x2d 0x4c 0x31 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x54 0x41 0x32 0x32 0x35 0x30 0x30 0x34 0x31 0x31 0x39 0x30 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x30 0x31 0x30 0x37 0x35 0x33 0x34 0x36 0x2d 0x30 0x31 0x35 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
2023-01-01 19:35:39.299 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x3 0x0 0x0 0x0 0x49 0x1 0x3 0x46 0x53 0x55 0x4e 0x32 0x30 0x30 0x30 0x2d 0x35 0x4b 0x54 0x4c 0x2d 0x4c 0x31 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x54 0x41 0x32 0x32 0x35 0x30 0x30 0x34 0x31 0x31 0x39 0x30 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x30 0x31 0x30 0x37 0x35 0x33 0x34 0x36 0x2d 0x30 0x31 0x35 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
2023-01-01 19:35:39.299 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:39.300 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 3
2023-01-01 19:35:39.357 DEBUG (MainThread) [pymodbus.payload] [21333, 20018, 12336, 12333, 13643, 21580, 11596, 12544, 0, 0, 0, 0, 0, 0, 0, 21569, 12850, 13616, 12340, 12593, 14640, 0, 0, 0, 0, 12337, 12343, 13619, 13366, 11568, 12597, 0, 0, 0, 0]
2023-01-01 19:35:39.358 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 30071
2023-01-01 19:35:39.358 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x4 0x0 0x0 0x0 0x6 0x1 0x3 0x75 0x77 0x0 0x1
2023-01-01 19:35:39.358 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 4
2023-01-01 19:35:40.919 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x4 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-01 19:35:40.919 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x4 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-01 19:35:40.919 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:40.920 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 4
2023-01-01 19:35:40.970 DEBUG (MainThread) [pymodbus.payload] [2]
2023-01-01 19:35:40.971 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37200
2023-01-01 19:35:40.971 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x5 0x0 0x0 0x0 0x6 0x1 0x3 0x91 0x50 0x0 0x1
2023-01-01 19:35:40.971 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 5
2023-01-01 19:35:43.279 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x5 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x4
2023-01-01 19:35:43.279 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x5 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x4
2023-01-01 19:35:43.279 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:43.280 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 5
2023-01-01 19:35:43.330 DEBUG (MainThread) [pymodbus.payload] [4]
2023-01-01 19:35:43.331 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37100
2023-01-01 19:35:43.331 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x6 0x0 0x0 0x0 0x6 0x1 0x3 0x90 0xec 0x0 0x1
2023-01-01 19:35:43.331 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 6
2023-01-01 19:35:43.864 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x6 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x1
2023-01-01 19:35:43.864 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x6 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x1
2023-01-01 19:35:43.865 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:43.865 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 6
2023-01-01 19:35:43.916 DEBUG (MainThread) [pymodbus.payload] [1]
2023-01-01 19:35:43.916 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37125
2023-01-01 19:35:43.916 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x7 0x0 0x0 0x0 0x6 0x1 0x3 0x91 0x5 0x0 0x1
2023-01-01 19:35:43.916 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 7
2023-01-01 19:35:44.669 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x7 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-01 19:35:44.669 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x7 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-01 19:35:44.669 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:44.670 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 7
2023-01-01 19:35:44.721 DEBUG (MainThread) [pymodbus.payload] [0]
2023-01-01 19:35:44.721 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47000
2023-01-01 19:35:44.721 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x8 0x0 0x0 0x0 0x6 0x1 0x3 0xb7 0x98 0x0 0x1
2023-01-01 19:35:44.722 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 8
2023-01-01 19:35:45.694 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x8 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-01 19:35:45.694 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x8 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-01 19:35:45.695 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:45.695 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 8
2023-01-01 19:35:45.746 DEBUG (MainThread) [pymodbus.payload] [2]
2023-01-01 19:35:45.746 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47089
2023-01-01 19:35:45.746 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x9 0x0 0x0 0x0 0x6 0x1 0x3 0xb7 0xf1 0x0 0x1
2023-01-01 19:35:45.747 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 9
2023-01-01 19:35:47.324 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x9 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-01 19:35:47.325 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x9 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-01 19:35:47.325 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:47.325 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 9
2023-01-01 19:35:47.376 DEBUG (MainThread) [pymodbus.payload] [0]
2023-01-01 19:35:47.377 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47954
2023-01-01 19:35:47.377 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xa 0x0 0x0 0x0 0x6 0x1 0x3 0xbb 0x52 0x0 0x1
2023-01-01 19:35:47.378 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 10
2023-01-01 19:35:48.325 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xa 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-01 19:35:48.326 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xa 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-01 19:35:48.326 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:48.326 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 10
2023-01-01 19:35:48.378 DEBUG (MainThread) [pymodbus.payload] [0]
2023-01-01 19:35:48.378 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32064
2023-01-01 19:35:48.379 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xb 0x0 0x0 0x0 0x6 0x1 0x3 0x7d 0x40 0x0 0x34
2023-01-01 19:35:48.379 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 11
2023-01-01 19:35:48.943 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xb 0x0 0x0 0x0 0x6b 0x1 0x3 0x68 0x0 0x0 0x4 0x11 0x9 0x52 0x0 0x0 0x0 0x0 0x4 0xa7 0x0 0x3 0x0 0x0 0x0 0x0 0x1c 0x2c 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x12 0x59 0x0 0x0 0x4 0xdf 0xff 0xff 0xfb 0x6c 0x2 0xd9 0x13 0x86 0x27 0x10 0x1 0xa0 0xb 0xb8 0x4 0x2 0x0 0x0 0x63 0xb1 0x2a 0xeb 0xff 0xff 0xff 0xff 0x0 0x0 0x4 0xe9 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x5a 0x0 0x2 0x77 0xfd 0x0 0x2 0xa9 0xcf 0x63 0xb1 0xe1 0xab 0x0 0x0 0x0 0x6a 0x0 0x0 0x10 0x2a
2023-01-01 19:35:48.943 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xb 0x0 0x0 0x0 0x6b 0x1 0x3 0x68 0x0 0x0 0x4 0x11 0x9 0x52 0x0 0x0 0x0 0x0 0x4 0xa7 0x0 0x3 0x0 0x0 0x0 0x0 0x1c 0x2c 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x12 0x59 0x0 0x0 0x4 0xdf 0xff 0xff 0xfb 0x6c 0x2 0xd9 0x13 0x86 0x27 0x10 0x1 0xa0 0xb 0xb8 0x4 0x2 0x0 0x0 0x63 0xb1 0x2a 0xeb 0xff 0xff 0xff 0xff 0x0 0x0 0x4 0xe9 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x5a 0x0 0x2 0x77 0xfd 0x0 0x2 0xa9 0xcf 0x63 0xb1 0xe1 0xab 0x0 0x0 0x0 0x6a 0x0 0x0 0x10 0x2a
2023-01-01 19:35:48.943 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:48.943 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 11
2023-01-01 19:35:48.994 DEBUG (MainThread) [pymodbus.payload] [0, 1041, 2386, 0, 0, 1191, 3, 0, 0, 7212, 0, 0, 0, 0, 0, 4697, 0, 1247, 65535, 64364, 729, 4998, 10000, 416, 3000, 1026, 0, 25521, 10987, 65535, 65535, 0, 1257, 0, 0, 0, 0, 0, 0, 0, 0, 90, 2, 30717, 2, 43471, 25521, 57771, 0, 106, 0, 4138]
2023-01-01 19:35:48.994 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x04\x11']
2023-01-01 19:35:48.994 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x1c,']
2023-01-01 19:35:48.994 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2023-01-01 19:35:48.994 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2023-01-01 19:35:48.994 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x12Y']
2023-01-01 19:35:48.994 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x04\xdf']
2023-01-01 19:35:48.995 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xfbl']
2023-01-01 19:35:48.995 DEBUG (MainThread) [pymodbus.payload] [b'c\xb1', b'*\xeb']
2023-01-01 19:35:48.995 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xff\xff']
2023-01-01 19:35:48.995 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x02', b'w\xfd']
2023-01-01 19:35:48.995 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x10*']
2023-01-01 19:35:48.995 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32000
2023-01-01 19:35:48.995 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xc 0x0 0x0 0x0 0x6 0x1 0x3 0x7d 0x0 0x0 0x14
2023-01-01 19:35:48.996 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 12
2023-01-01 19:35:49.663 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xc 0x0 0x0 0x0 0x2b 0x1 0x3 0x28 0x0 0xa 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 0x91 0x70 0x7 0x99 0x0 0xbc 0xd 0x86 0x0 0xd0
2023-01-01 19:35:49.663 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xc 0x0 0x0 0x0 0x2b 0x1 0x3 0x28 0x0 0xa 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 0x91 0x70 0x7 0x99 0x0 0xbc 0xd 0x86 0x0 0xd0
2023-01-01 19:35:49.663 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:49.663 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 12
2023-01-01 19:35:49.714 DEBUG (MainThread) [pymodbus.payload] [10, 0, 7, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 37232, 1945, 188, 3462, 208]
2023-01-01 19:35:49.715 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2023-01-01 19:35:49.715 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37201
2023-01-01 19:35:49.715 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xd 0x0 0x0 0x0 0x6 0x1 0x3 0x91 0x51 0x0 0x1
2023-01-01 19:35:49.715 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 13
2023-01-01 19:35:50.509 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xd 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x4
2023-01-01 19:35:50.509 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xd 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x4
2023-01-01 19:35:50.510 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:50.510 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 13
2023-01-01 19:35:50.561 DEBUG (MainThread) [pymodbus.payload] [4]
2023-01-01 19:35:50.561 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37101
2023-01-01 19:35:50.562 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xe 0x0 0x0 0x0 0x6 0x1 0x3 0x90 0xed 0x0 0x25
2023-01-01 19:35:50.562 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 14
2023-01-01 19:35:51.380 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xe 0x0 0x0 0x0 0x4d 0x1 0x3 0x4a 0x0 0x0 0x9 0x4d 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x0 0x0 0x1 0x8a 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x0 0x0 0x0 0x28 0xff 0xff 0xfc 0x74 0xff 0x0 0x13 0x87 0x0 0x0 0xf3 0xfd 0x0 0x0 0x1a 0x46 0x0 0x0 0xda 0xe0 0x0 0x0 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff
2023-01-01 19:35:51.380 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xe 0x0 0x0 0x0 0x4d 0x1 0x3 0x4a 0x0 0x0 0x9 0x4d 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x0 0x0 0x1 0x8a 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x0 0x0 0x0 0x28 0xff 0xff 0xfc 0x74 0xff 0x0 0x13 0x87 0x0 0x0 0xf3 0xfd 0x0 0x0 0x1a 0x46 0x0 0x0 0xda 0xe0 0x0 0x0 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff
2023-01-01 19:35:51.380 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:51.380 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 14
2023-01-01 19:35:51.431 DEBUG (MainThread) [pymodbus.payload] [0, 2381, 32767, 65535, 32767, 65535, 0, 394, 32767, 65535, 32767, 65535, 0, 40, 65535, 64628, 65280, 4999, 0, 62461, 0, 6726, 0, 56032, 0, 32767, 65535, 32767, 65535, 32767, 65535, 32767, 65535, 32767, 65535, 32767, 65535]
2023-01-01 19:35:51.432 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\tM']
2023-01-01 19:35:51.432 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-01 19:35:51.432 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-01 19:35:51.432 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x01\x8a']
2023-01-01 19:35:51.432 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-01 19:35:51.432 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-01 19:35:51.432 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00(']
2023-01-01 19:35:51.432 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xfct']
2023-01-01 19:35:51.432 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\xf3\xfd']
2023-01-01 19:35:51.432 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x1aF']
2023-01-01 19:35:51.432 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\xda\xe0']
2023-01-01 19:35:51.432 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-01 19:35:51.433 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-01 19:35:51.433 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-01 19:35:51.433 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-01 19:35:51.433 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-01 19:35:51.433 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-01 19:35:51.433 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37760
2023-01-01 19:35:51.433 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xf 0x0 0x0 0x0 0x6 0x1 0x3 0x93 0x80 0x0 0x1c
2023-01-01 19:35:51.434 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 15
2023-01-01 19:35:52.057 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xf 0x0 0x0 0x0 0x3b 0x1 0x3 0x38 0x3 0xd4 0x0 0x0 0x0 0x2 0x11 0x26 0xff 0xfc 0xff 0xff 0xff 0xe1 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 0x0 0x0 0xbb 0xb4 0x0 0x0 0xb7 0x94 0x0 0x0 0x2 0xe6 0x0 0x0 0x1 0xfe
2023-01-01 19:35:52.057 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xf 0x0 0x0 0x0 0x3b 0x1 0x3 0x38 0x3 0xd4 0x0 0x0 0x0 0x2 0x11 0x26 0xff 0xfc 0xff 0xff 0xff 0xe1 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 0x0 0x0 0xbb 0xb4 0x0 0x0 0xb7 0x94 0x0 0x0 0x2 0xe6 0x0 0x0 0x1 0xfe
2023-01-01 19:35:52.057 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:52.057 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 15
2023-01-01 19:35:52.108 DEBUG (MainThread) [pymodbus.payload] [980, 0, 2, 4390, 65532, 65535, 65505, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 48052, 0, 46996, 0, 742, 0, 510]
2023-01-01 19:35:52.108 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xff\xe1']
2023-01-01 19:35:52.108 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\xbb\xb4']
2023-01-01 19:35:52.108 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\xb7\x94']
2023-01-01 19:35:52.108 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x02\xe6']
2023-01-01 19:35:52.108 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x01\xfe']
2023-01-01 19:35:52.108 DEBUG (MainThread) [custom_components.huawei_solar] Finished fetching TA2250041190_data_update_coordinator data in 3.730 seconds (success: True)
2023-01-01 19:35:52.109 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47075
2023-01-01 19:35:52.109 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x10 0x0 0x0 0x0 0x6 0x1 0x3 0xb7 0xe3 0x0 0xe
2023-01-01 19:35:52.109 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 16
2023-01-01 19:35:52.830 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x10 0x0 0x0 0x0 0x1f 0x1 0x3 0x1c 0x0 0x0 0x7 0xd0 0x0 0x0 0x13 0x87 0x0 0x0 0x13 0x87 0x3 0xd4 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x2 0x0 0x1 0x3 0xb6
2023-01-01 19:35:52.830 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x10 0x0 0x0 0x0 0x1f 0x1 0x3 0x1c 0x0 0x0 0x7 0xd0 0x0 0x0 0x13 0x87 0x0 0x0 0x13 0x87 0x3 0xd4 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x2 0x0 0x1 0x3 0xb6
2023-01-01 19:35:52.830 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:52.830 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 16
2023-01-01 19:35:52.881 DEBUG (MainThread) [pymodbus.payload] [0, 2000, 0, 4999, 0, 4999, 980, 0, 0, 0, 0, 2, 1, 950]
2023-01-01 19:35:52.882 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x07\xd0']
2023-01-01 19:35:52.882 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x13\x87']
2023-01-01 19:35:52.882 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47200
2023-01-01 19:35:52.882 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x11 0x0 0x0 0x0 0x6 0x1 0x3 0xb8 0x60 0x0 0x2e
2023-01-01 19:35:52.883 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 17
2023-01-01 19:35:53.878 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x11 0x0 0x0 0x0 0x5f 0x1 0x3 0x5c 0x0 0x0 0xf 0x0 0xe8 0x3 0xf4 0x1 0x90 0x1 0x2c 0x1 0x58 0x2 0xc8 0x0 0x1 0x0 0x96 0x0 0x84 0x3 0x70 0x17 0x2 0x0 0xf7 0x0 0xa0 0x5 0xff 0xff 0x6 0x0 0x5 0x0 0x3f 0x0 0x3 0x0 0x0 0x0 0x10 0x27 0x0 0x0 0x0 0x0 0x0 0x0 0x80 0x43 0x6d 0x38 0x88 0x13 0x0 0x0 0xff 0xff 0xff 0xff 0x0 0xe1 0x0 0x3 0x2 0x0 0x0 0x0 0x28 0xb6 0x13 0x0 0x0 0x0 0x0 0x0 0x1 0xe1 0x0 0x3 0x0 0x0 0x0 0x0 0xb 0xb8 0x0 0x0 0xb 0xb8
2023-01-01 19:35:53.878 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x11 0x0 0x0 0x0 0x5f 0x1 0x3 0x5c 0x0 0x0 0xf 0x0 0xe8 0x3 0xf4 0x1 0x90 0x1 0x2c 0x1 0x58 0x2 0xc8 0x0 0x1 0x0 0x96 0x0 0x84 0x3 0x70 0x17 0x2 0x0 0xf7 0x0 0xa0 0x5 0xff 0xff 0x6 0x0 0x5 0x0 0x3f 0x0 0x3 0x0 0x0 0x0 0x10 0x27 0x0 0x0 0x0 0x0 0x0 0x0 0x80 0x43 0x6d 0x38 0x88 0x13 0x0 0x0 0xff 0xff 0xff 0xff 0x0 0xe1 0x0 0x3 0x2 0x0 0x0 0x0 0x28 0xb6 0x13 0x0 0x0 0x0 0x0 0x0 0x1 0xe1 0x0 0x3 0x0 0x0 0x0 0x0 0xb 0xb8 0x0 0x0 0xb 0xb8
2023-01-01 19:35:53.878 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:53.878 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 17
2023-01-01 19:35:53.929 DEBUG (MainThread) [pymodbus.payload] [0, 3840, 59395, 62465, 36865, 11265, 22530, 51200, 256, 38400, 33795, 28695, 512, 63232, 40965, 65535, 1536, 1280, 16128, 768, 0, 4135, 0, 0, 0, 32835, 27960, 34835, 0, 65535, 65535, 225, 3, 512, 0, 10422, 4864, 0, 0, 481, 3, 0, 0, 3000, 0, 3000]
2023-01-01 19:35:53.930 DEBUG (MainThread) [pymodbus.payload] [b'\xf4\x01', b'\x90\x01']
2023-01-01 19:35:53.930 DEBUG (MainThread) [pymodbus.payload] [b'\xc8\x00', b'\x01\x00']
2023-01-01 19:35:53.930 DEBUG (MainThread) [pymodbus.payload] [b'p\x17', b'\x02\x00']
2023-01-01 19:35:53.930 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\x06\x00']
2023-01-01 19:35:53.930 DEBUG (MainThread) [pymodbus.payload] [b'\x03\x00', b'\x00\x00']
2023-01-01 19:35:53.930 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2023-01-01 19:35:53.930 DEBUG (MainThread) [pymodbus.payload] [b'\x88\x13', b'\x00\x00']
2023-01-01 19:35:53.930 DEBUG (MainThread) [pymodbus.payload] [b'\x00\xe1', b'\x00\x03']
2023-01-01 19:35:53.931 DEBUG (MainThread) [pymodbus.payload] [b'(\xb6', b'\x13\x00']
2023-01-01 19:35:53.931 DEBUG (MainThread) [pymodbus.payload] [b'\x01\xe1', b'\x00\x03']
2023-01-01 19:35:53.931 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x0b\xb8']
2023-01-01 19:35:53.931 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x0b\xb8']
2023-01-01 19:35:53.931 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47255
2023-01-01 19:35:53.931 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x12 0x0 0x0 0x0 0x6 0x1 0x3 0xb8 0x97 0x0 0x2d
2023-01-01 19:35:53.932 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 18
2023-01-01 19:35:54.695 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x12 0x0 0x0 0x0 0x5d 0x1 0x3 0x5a 0x0 0x2 0x0 0x0 0x1 0x68 0x0 0x7f 0x1 0xe0 0x5 0x28 0x1 0x7f 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 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 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x1
2023-01-01 19:35:54.695 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x12 0x0 0x0 0x0 0x5d 0x1 0x3 0x5a 0x0 0x2 0x0 0x0 0x1 0x68 0x0 0x7f 0x1 0xe0 0x5 0x28 0x1 0x7f 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 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 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x1
2023-01-01 19:35:54.695 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:54.695 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 18
2023-01-01 19:35:54.746 DEBUG (MainThread) [pymodbus.payload] [2, 0, 360, 127, 480, 1320, 383, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1]
2023-01-01 19:35:54.747 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47954
2023-01-01 19:35:54.747 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x13 0x0 0x0 0x0 0x6 0x1 0x3 0xbb 0x52 0x0 0x42
2023-01-01 19:35:54.747 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 19
2023-01-01 19:35:55.451 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x13 0x0 0x0 0x0 0x87 0x1 0x3 0x84 0x0 0x0 0x1 0xf4 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 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 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 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 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
2023-01-01 19:35:55.451 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x13 0x0 0x0 0x0 0x87 0x1 0x3 0x84 0x0 0x0 0x1 0xf4 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 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 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 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 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
2023-01-01 19:35:55.451 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-01 19:35:55.451 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 19
2023-01-01 19:35:55.502 DEBUG (MainThread) [pymodbus.payload] [0, 500, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]
2023-01-01 19:35:55.502 DEBUG (MainThread) [custom_components.huawei_solar] Finished fetching TA2250041190_configuration_update_coordinator data in 3.394 seconds (success: True)
2023-01-01 19:35:55.502 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading file 0x45
2023-01-01 19:35:55.503 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x14 0x0 0x0 0x0 0x5 0x0 0x41 0x5 0x1 0x45
2023-01-01 19:35:55.503 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 20
2023-01-01 19:35:58.504 INFO (MainThread) [backoff] Backing off _perform_request(...) for 10.0s (asyncio.exceptions.TimeoutError)
2023-01-01 19:35:58.504 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off file upload for 10.0 seconds after 1 tries
2023-01-01 19:36:08.505 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x15 0x0 0x0 0x0 0x5 0x0 0x41 0x5 0x1 0x45
2023-01-01 19:36:08.506 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 21
2023-01-01 19:36:11.507 INFO (MainThread) [backoff] Backing off _perform_request(...) for 10.0s (asyncio.exceptions.TimeoutError)
2023-01-01 19:36:11.507 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off file upload for 10.0 seconds after 2 tries
2023-01-01 19:36:21.509 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x16 0x0 0x0 0x0 0x5 0x0 0x41 0x5 0x1 0x45
2023-01-01 19:36:21.509 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 22
2023-01-01 19:36:24.510 INFO (MainThread) [backoff] Backing off _perform_request(...) for 10.0s (asyncio.exceptions.TimeoutError)
2023-01-01 19:36:24.510 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off file upload for 10.0 seconds after 3 tries

Please confirm the following:

  • The problem is still present in the latest release of this integration.
  • I did not find an existing issue describing this problem.
  • I did upload the diagnostics-file that I could retrieve from the 'Devices & Services Page'
  • I increased the logging configuration, restarted HA, and have copied all relevant log lines from the 'Full Logs' into the textarea.
@etamtlosz etamtlosz added the bug Something isn't working label Jan 1, 2023
@wlcrs
Copy link
Owner

wlcrs commented Jan 1, 2023

Can you let me know if the problem persists if you retry while the inverters are online (eg. when there is enough sun to let them all generate some power)?

@etamtlosz
Copy link
Author

I'll do that in a few hours, since the Sun is setting right now here in New Zealand.

@wlcrs
Copy link
Owner

wlcrs commented Jan 1, 2023

Ok, thanks for the confirmation. I'll need to look into working around the timeouts you are receiving. Very strange that those are consistent after many retries.

@wlcrs
Copy link
Owner

wlcrs commented Jan 1, 2023

I would expect your logs to contain a stacktrace of the error that is occurring. Can you also post that error here please?

I've gone through all the log lines from your initial bugreport, and those are all valid communication between HA and the inverter. The "Backing off file upload" is something that is retried up to 6 times (as required by the documentation provided by Huawei), so I'm surprised that it's already cut of after 3 retries.

@etamtlosz
Copy link
Author

Good morning. Unfortunately the same is happening.

2023-01-02 07:17:53.995 DEBUG (MainThread) [pymodbus.client.tcp] Connecting.
2023-01-02 07:17:53.996 DEBUG (MainThread) [pymodbus.client.base] Client connected to modbus server
2023-01-02 07:17:53.996 INFO (MainThread) [pymodbus.client.tcp] Protocol made connection.
2023-01-02 07:17:53.997 INFO (MainThread) [pymodbus.client.tcp] Connected to 192.168.2.170:502.
2023-01-02 07:17:54.998 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 43006
2023-01-02 07:17:54.998 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x1 0x0 0x0 0x0 0x6 0x1 0x3 0xa7 0xfe 0x0 0x1
2023-01-02 07:17:54.998 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 1
2023-01-02 07:17:55.861 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x1 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x2 0xd0
2023-01-02 07:17:55.861 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x1 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x2 0xd0
2023-01-02 07:17:55.861 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:17:55.861 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 1
2023-01-02 07:17:55.912 DEBUG (MainThread) [pymodbus.payload] [720]
2023-01-02 07:17:55.912 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47000
2023-01-02 07:17:55.912 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x2 0x0 0x0 0x0 0x6 0x1 0x3 0xb7 0x98 0x0 0x1
2023-01-02 07:17:55.913 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 2
2023-01-02 07:17:56.758 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x2 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:17:56.758 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x2 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:17:56.758 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:17:56.758 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 2
2023-01-02 07:17:56.809 DEBUG (MainThread) [pymodbus.payload] [2]
2023-01-02 07:17:56.809 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 30000
2023-01-02 07:17:56.810 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x3 0x0 0x0 0x0 0x6 0x1 0x3 0x75 0x30 0x0 0x23
2023-01-02 07:17:56.810 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 3
2023-01-02 07:17:57.559 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x3 0x0 0x0 0x0 0x49 0x1 0x3 0x46 0x53 0x55 0x4e 0x32 0x30 0x30 0x30 0x2d 0x35 0x4b 0x54 0x4c 0x2d 0x4c 0x31 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x54 0x41 0x32 0x32 0x35 0x30 0x30 0x34 0x31 0x31 0x39 0x30 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x30 0x31 0x30 0x37 0x35 0x33 0x34 0x36 0x2d 0x30 0x31 0x35 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
2023-01-02 07:17:57.559 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x3 0x0 0x0 0x0 0x49 0x1 0x3 0x46 0x53 0x55 0x4e 0x32 0x30 0x30 0x30 0x2d 0x35 0x4b 0x54 0x4c 0x2d 0x4c 0x31 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x54 0x41 0x32 0x32 0x35 0x30 0x30 0x34 0x31 0x31 0x39 0x30 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x30 0x31 0x30 0x37 0x35 0x33 0x34 0x36 0x2d 0x30 0x31 0x35 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
2023-01-02 07:17:57.559 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:17:57.559 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 3
2023-01-02 07:17:57.610 DEBUG (MainThread) [pymodbus.payload] [21333, 20018, 12336, 12333, 13643, 21580, 11596, 12544, 0, 0, 0, 0, 0, 0, 0, 21569, 12850, 13616, 12340, 12593, 14640, 0, 0, 0, 0, 12337, 12343, 13619, 13366, 11568, 12597, 0, 0, 0, 0]
2023-01-02 07:17:57.610 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 30071
2023-01-02 07:17:57.611 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x4 0x0 0x0 0x0 0x6 0x1 0x3 0x75 0x77 0x0 0x1
2023-01-02 07:17:57.611 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 4
2023-01-02 07:17:58.515 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x4 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:17:58.515 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x4 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:17:58.515 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:17:58.515 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 4
2023-01-02 07:17:58.566 DEBUG (MainThread) [pymodbus.payload] [2]
2023-01-02 07:17:58.567 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37200
2023-01-02 07:17:58.567 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x5 0x0 0x0 0x0 0x6 0x1 0x3 0x91 0x50 0x0 0x1
2023-01-02 07:17:58.567 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 5
2023-01-02 07:17:59.329 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x5 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x4
2023-01-02 07:17:59.329 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x5 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x4
2023-01-02 07:17:59.329 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:17:59.329 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 5
2023-01-02 07:17:59.380 DEBUG (MainThread) [pymodbus.payload] [4]
2023-01-02 07:17:59.380 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37100
2023-01-02 07:17:59.380 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x6 0x0 0x0 0x0 0x6 0x1 0x3 0x90 0xec 0x0 0x1
2023-01-02 07:17:59.381 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 6
2023-01-02 07:17:59.866 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x6 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x1
2023-01-02 07:17:59.866 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x6 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x1
2023-01-02 07:17:59.866 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:17:59.866 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 6
2023-01-02 07:17:59.918 DEBUG (MainThread) [pymodbus.payload] [1]
2023-01-02 07:17:59.918 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37125
2023-01-02 07:17:59.918 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x7 0x0 0x0 0x0 0x6 0x1 0x3 0x91 0x5 0x0 0x1
2023-01-02 07:17:59.918 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 7
2023-01-02 07:18:00.873 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x7 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:18:00.873 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x7 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:18:00.873 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:00.873 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 7
2023-01-02 07:18:00.924 DEBUG (MainThread) [pymodbus.payload] [0]
2023-01-02 07:18:00.924 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47000
2023-01-02 07:18:00.924 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x8 0x0 0x0 0x0 0x6 0x1 0x3 0xb7 0x98 0x0 0x1
2023-01-02 07:18:00.925 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 8
2023-01-02 07:18:01.351 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x8 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:18:01.351 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x8 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:18:01.351 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:01.351 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 8
2023-01-02 07:18:01.402 DEBUG (MainThread) [pymodbus.payload] [2]
2023-01-02 07:18:01.403 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47089
2023-01-02 07:18:01.403 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x9 0x0 0x0 0x0 0x6 0x1 0x3 0xb7 0xf1 0x0 0x1
2023-01-02 07:18:01.404 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 9
2023-01-02 07:18:01.945 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x9 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:18:01.945 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x9 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:18:01.946 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:01.946 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 9
2023-01-02 07:18:01.997 DEBUG (MainThread) [pymodbus.payload] [0]
2023-01-02 07:18:01.997 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47954
2023-01-02 07:18:01.997 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xa 0x0 0x0 0x0 0x6 0x1 0x3 0xbb 0x52 0x0 0x1
2023-01-02 07:18:01.998 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 10
2023-01-02 07:18:03.748 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xa 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:18:03.748 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xa 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:18:03.748 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:03.748 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 10
2023-01-02 07:18:03.800 DEBUG (MainThread) [pymodbus.payload] [0]
2023-01-02 07:18:03.800 INFO (MainThread) [custom_components.huawei_solar.config_flow] Successfully connected to inverter SUN2000-5KTL-L1 with SN TA2250041190
2023-01-02 07:18:03.800 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 43006
2023-01-02 07:18:03.801 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xb 0x0 0x0 0x0 0x6 0x1 0x3 0xa7 0xfe 0x0 0x1
2023-01-02 07:18:03.801 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 11
2023-01-02 07:18:04.598 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xb 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x2 0xd0
2023-01-02 07:18:04.598 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xb 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x2 0xd0
2023-01-02 07:18:04.598 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:04.598 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 11
2023-01-02 07:18:04.650 DEBUG (MainThread) [pymodbus.payload] [720]
2023-01-02 07:18:04.650 DEBUG (MainThread) [pymodbus.payload] [720]
2023-01-02 07:18:04.650 DEBUG (MainThread) [pymodbus.payload] [720]
2023-01-02 07:18:04.650 DEBUG (MainThread) [huawei_solar.huawei_solar] Writing to 43006: [720]
2023-01-02 07:18:04.651 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xc 0x0 0x0 0x0 0x9 0x1 0x10 0xa7 0xfe 0x0 0x1 0x2 0x2 0xd0
2023-01-02 07:18:04.651 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 12
2023-01-02 07:18:05.238 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xc 0x0 0x0 0x0 0x6 0x1 0x10 0xa7 0xfe 0x0 0x1
2023-01-02 07:18:05.239 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xc 0x0 0x0 0x0 0x6 0x1 0x10 0xa7 0xfe 0x0 0x1
2023-01-02 07:18:05.239 DEBUG (MainThread) [pymodbus.factory] Factory Response[WriteMultipleRegistersResponse': 16]
2023-01-02 07:18:05.239 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 12
2023-01-02 07:18:05.290 DEBUG (MainThread) [pymodbus.client.tcp] Connecting to 192.168.2.170:502.
2023-01-02 07:18:05.290 DEBUG (MainThread) [pymodbus.client.tcp] Connecting.
2023-01-02 07:18:05.291 DEBUG (MainThread) [pymodbus.client.base] Client disconnected from modbus server: None
2023-01-02 07:18:05.291 INFO (MainThread) [pymodbus.client.tcp] Protocol lost connection.
2023-01-02 07:18:05.293 DEBUG (MainThread) [pymodbus.client.base] Client connected to modbus server
2023-01-02 07:18:05.294 INFO (MainThread) [pymodbus.client.tcp] Protocol made connection.
2023-01-02 07:18:05.294 INFO (MainThread) [pymodbus.client.tcp] Connected to 192.168.2.170:502.
2023-01-02 07:18:06.295 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 43006
2023-01-02 07:18:06.295 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x1 0x0 0x0 0x0 0x6 0x1 0x3 0xa7 0xfe 0x0 0x1
2023-01-02 07:18:06.296 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 1
2023-01-02 07:18:06.696 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x1 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x2 0xd0
2023-01-02 07:18:06.697 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x1 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x2 0xd0
2023-01-02 07:18:06.697 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:06.697 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 1
2023-01-02 07:18:06.748 DEBUG (MainThread) [pymodbus.payload] [720]
2023-01-02 07:18:06.748 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47000
2023-01-02 07:18:06.748 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x2 0x0 0x0 0x0 0x6 0x1 0x3 0xb7 0x98 0x0 0x1
2023-01-02 07:18:06.748 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 2
2023-01-02 07:18:07.215 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x2 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:18:07.215 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x2 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:18:07.215 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:07.215 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 2
2023-01-02 07:18:07.267 DEBUG (MainThread) [pymodbus.payload] [2]
2023-01-02 07:18:07.267 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 30000
2023-01-02 07:18:07.267 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x3 0x0 0x0 0x0 0x6 0x1 0x3 0x75 0x30 0x0 0x23
2023-01-02 07:18:07.267 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 3
2023-01-02 07:18:08.343 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x3 0x0 0x0 0x0 0x49 0x1 0x3 0x46 0x53 0x55 0x4e 0x32 0x30 0x30 0x30 0x2d 0x35 0x4b 0x54 0x4c 0x2d 0x4c 0x31 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x54 0x41 0x32 0x32 0x35 0x30 0x30 0x34 0x31 0x31 0x39 0x30 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x30 0x31 0x30 0x37 0x35 0x33 0x34 0x36 0x2d 0x30 0x31 0x35 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
2023-01-02 07:18:08.343 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x3 0x0 0x0 0x0 0x49 0x1 0x3 0x46 0x53 0x55 0x4e 0x32 0x30 0x30 0x30 0x2d 0x35 0x4b 0x54 0x4c 0x2d 0x4c 0x31 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x54 0x41 0x32 0x32 0x35 0x30 0x30 0x34 0x31 0x31 0x39 0x30 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x30 0x31 0x30 0x37 0x35 0x33 0x34 0x36 0x2d 0x30 0x31 0x35 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
2023-01-02 07:18:08.343 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:08.344 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 3
2023-01-02 07:18:08.394 DEBUG (MainThread) [pymodbus.payload] [21333, 20018, 12336, 12333, 13643, 21580, 11596, 12544, 0, 0, 0, 0, 0, 0, 0, 21569, 12850, 13616, 12340, 12593, 14640, 0, 0, 0, 0, 12337, 12343, 13619, 13366, 11568, 12597, 0, 0, 0, 0]
2023-01-02 07:18:08.395 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 30071
2023-01-02 07:18:08.395 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x4 0x0 0x0 0x0 0x6 0x1 0x3 0x75 0x77 0x0 0x1
2023-01-02 07:18:08.395 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 4
2023-01-02 07:18:08.794 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x4 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:18:08.794 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x4 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:18:08.794 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:08.795 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 4
2023-01-02 07:18:08.846 DEBUG (MainThread) [pymodbus.payload] [2]
2023-01-02 07:18:08.846 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37200
2023-01-02 07:18:08.847 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x5 0x0 0x0 0x0 0x6 0x1 0x3 0x91 0x50 0x0 0x1
2023-01-02 07:18:08.847 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 5
2023-01-02 07:18:09.918 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x5 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x4
2023-01-02 07:18:09.918 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x5 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x4
2023-01-02 07:18:09.918 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:09.918 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 5
2023-01-02 07:18:09.969 DEBUG (MainThread) [pymodbus.payload] [4]
2023-01-02 07:18:09.970 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37100
2023-01-02 07:18:09.970 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x6 0x0 0x0 0x0 0x6 0x1 0x3 0x90 0xec 0x0 0x1
2023-01-02 07:18:09.970 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 6
2023-01-02 07:18:10.838 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x6 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x1
2023-01-02 07:18:10.839 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x6 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x1
2023-01-02 07:18:10.839 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:10.839 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 6
2023-01-02 07:18:10.890 DEBUG (MainThread) [pymodbus.payload] [1]
2023-01-02 07:18:10.891 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37125
2023-01-02 07:18:10.891 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x7 0x0 0x0 0x0 0x6 0x1 0x3 0x91 0x5 0x0 0x1
2023-01-02 07:18:10.891 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 7
2023-01-02 07:18:11.550 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x7 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:18:11.551 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x7 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:18:11.551 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:11.551 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 7
2023-01-02 07:18:11.602 DEBUG (MainThread) [pymodbus.payload] [0]
2023-01-02 07:18:11.603 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47000
2023-01-02 07:18:11.603 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x8 0x0 0x0 0x0 0x6 0x1 0x3 0xb7 0x98 0x0 0x1
2023-01-02 07:18:11.603 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 8
2023-01-02 07:18:12.004 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x8 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:18:12.004 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x8 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:18:12.004 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:12.005 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 8
2023-01-02 07:18:12.057 DEBUG (MainThread) [pymodbus.payload] [2]
2023-01-02 07:18:12.057 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47089
2023-01-02 07:18:12.057 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x9 0x0 0x0 0x0 0x6 0x1 0x3 0xb7 0xf1 0x0 0x1
2023-01-02 07:18:12.058 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 9
2023-01-02 07:18:13.165 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x9 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:18:13.165 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x9 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:18:13.166 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:13.166 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 9
2023-01-02 07:18:13.216 DEBUG (MainThread) [pymodbus.payload] [0]
2023-01-02 07:18:13.217 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47954
2023-01-02 07:18:13.217 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xa 0x0 0x0 0x0 0x6 0x1 0x3 0xbb 0x52 0x0 0x1
2023-01-02 07:18:13.217 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 10
2023-01-02 07:18:13.955 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xa 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:18:13.956 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xa 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:18:13.956 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:13.956 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 10
2023-01-02 07:18:14.007 DEBUG (MainThread) [pymodbus.payload] [0]
2023-01-02 07:18:14.008 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32064
2023-01-02 07:18:14.008 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xb 0x0 0x0 0x0 0x6 0x1 0x3 0x7d 0x40 0x0 0x34
2023-01-02 07:18:14.008 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 11
2023-01-02 07:18:15.069 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xb 0x0 0x0 0x0 0x6b 0x1 0x3 0x68 0x0 0x0 0x1 0x22 0x9 0x32 0x0 0x0 0x0 0x0 0x4 0x97 0x0 0x3 0x0 0x0 0x0 0x0 0x5 0x7d 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x4 0x59 0x0 0x0 0x1 0x22 0xff 0xff 0xff 0x8a 0x3 0x9e 0x13 0x88 0x27 0x10 0x1 0x37 0xb 0xb8 0x4 0x2 0x0 0x0 0x63 0xb2 0x7d 0x7c 0xff 0xff 0xff 0xff 0x0 0x0 0x1 0x21 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x5a 0x0 0x2 0x7b 0x8b 0x0 0x2 0xaa 0x1f 0x63 0xb2 0x86 0x49 0x0 0x0 0x0 0x9 0x0 0x0 0x1 0xca
2023-01-02 07:18:15.069 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xb 0x0 0x0 0x0 0x6b 0x1 0x3 0x68 0x0 0x0 0x1 0x22 0x9 0x32 0x0 0x0 0x0 0x0 0x4 0x97 0x0 0x3 0x0 0x0 0x0 0x0 0x5 0x7d 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x4 0x59 0x0 0x0 0x1 0x22 0xff 0xff 0xff 0x8a 0x3 0x9e 0x13 0x88 0x27 0x10 0x1 0x37 0xb 0xb8 0x4 0x2 0x0 0x0 0x63 0xb2 0x7d 0x7c 0xff 0xff 0xff 0xff 0x0 0x0 0x1 0x21 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x5a 0x0 0x2 0x7b 0x8b 0x0 0x2 0xaa 0x1f 0x63 0xb2 0x86 0x49 0x0 0x0 0x0 0x9 0x0 0x0 0x1 0xca
2023-01-02 07:18:15.069 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:15.069 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 11
2023-01-02 07:18:15.120 DEBUG (MainThread) [pymodbus.payload] [0, 290, 2354, 0, 0, 1175, 3, 0, 0, 1405, 0, 0, 0, 0, 0, 1113, 0, 290, 65535, 65418, 926, 5000, 10000, 311, 3000, 1026, 0, 25522, 32124, 65535, 65535, 0, 289, 0, 0, 0, 0, 0, 0, 0, 0, 90, 2, 31627, 2, 43551, 25522, 34377, 0, 9, 0, 458]
2023-01-02 07:18:15.120 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x01"']
2023-01-02 07:18:15.120 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x05}']
2023-01-02 07:18:15.120 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2023-01-02 07:18:15.120 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2023-01-02 07:18:15.120 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x04Y']
2023-01-02 07:18:15.120 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x01"']
2023-01-02 07:18:15.121 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xff\x8a']
2023-01-02 07:18:15.121 DEBUG (MainThread) [pymodbus.payload] [b'c\xb2', b'}|']
2023-01-02 07:18:15.121 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xff\xff']
2023-01-02 07:18:15.121 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x02', b'{\x8b']
2023-01-02 07:18:15.121 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x01\xca']
2023-01-02 07:18:15.121 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32000
2023-01-02 07:18:15.121 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xc 0x0 0x0 0x0 0x6 0x1 0x3 0x7d 0x0 0x0 0x14
2023-01-02 07:18:15.122 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 12
2023-01-02 07:18:16.201 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xc 0x0 0x0 0x0 0x2b 0x1 0x3 0x28 0x0 0xa 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 0x91 0x70 0x7 0x58 0x0 0x3d 0xd 0xea 0x0 0x38
2023-01-02 07:18:16.202 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xc 0x0 0x0 0x0 0x2b 0x1 0x3 0x28 0x0 0xa 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 0x91 0x70 0x7 0x58 0x0 0x3d 0xd 0xea 0x0 0x38
2023-01-02 07:18:16.202 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:16.202 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 12
2023-01-02 07:18:16.253 DEBUG (MainThread) [pymodbus.payload] [10, 0, 7, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 37232, 1880, 61, 3562, 56]
2023-01-02 07:18:16.253 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2023-01-02 07:18:16.253 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37201
2023-01-02 07:18:16.253 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xd 0x0 0x0 0x0 0x6 0x1 0x3 0x91 0x51 0x0 0x1
2023-01-02 07:18:16.254 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 13
2023-01-02 07:18:16.870 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xd 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x4
2023-01-02 07:18:16.871 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xd 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x4
2023-01-02 07:18:16.871 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:16.871 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 13
2023-01-02 07:18:16.922 DEBUG (MainThread) [pymodbus.payload] [4]
2023-01-02 07:18:16.922 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37101
2023-01-02 07:18:16.922 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xe 0x0 0x0 0x0 0x6 0x1 0x3 0x90 0xed 0x0 0x25
2023-01-02 07:18:16.923 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 14
2023-01-02 07:18:17.543 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xe 0x0 0x0 0x0 0x4d 0x1 0x3 0x4a 0x0 0x0 0x9 0x2f 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0xff 0xff 0xfe 0xc8 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0xff 0xff 0xfd 0x66 0x0 0x0 0x1 0x46 0xfc 0x82 0x13 0x88 0x0 0x0 0xf3 0xff 0x0 0x0 0x1a 0xbc 0x0 0x0 0xda 0xfc 0x0 0x0 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff
2023-01-02 07:18:17.544 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xe 0x0 0x0 0x0 0x4d 0x1 0x3 0x4a 0x0 0x0 0x9 0x2f 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0xff 0xff 0xfe 0xc8 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0xff 0xff 0xfd 0x66 0x0 0x0 0x1 0x46 0xfc 0x82 0x13 0x88 0x0 0x0 0xf3 0xff 0x0 0x0 0x1a 0xbc 0x0 0x0 0xda 0xfc 0x0 0x0 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff
2023-01-02 07:18:17.544 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:17.544 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 14
2023-01-02 07:18:17.595 DEBUG (MainThread) [pymodbus.payload] [0, 2351, 32767, 65535, 32767, 65535, 65535, 65224, 32767, 65535, 32767, 65535, 65535, 64870, 0, 326, 64642, 5000, 0, 62463, 0, 6844, 0, 56060, 0, 32767, 65535, 32767, 65535, 32767, 65535, 32767, 65535, 32767, 65535, 32767, 65535]
2023-01-02 07:18:17.595 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\t/']
2023-01-02 07:18:17.595 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-02 07:18:17.595 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-02 07:18:17.595 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xfe\xc8']
2023-01-02 07:18:17.595 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-02 07:18:17.595 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-02 07:18:17.595 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xfdf']
2023-01-02 07:18:17.596 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x01F']
2023-01-02 07:18:17.596 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\xf3\xff']
2023-01-02 07:18:17.596 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x1a\xbc']
2023-01-02 07:18:17.596 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\xda\xfc']
2023-01-02 07:18:17.596 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-02 07:18:17.596 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-02 07:18:17.596 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-02 07:18:17.596 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-02 07:18:17.596 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-02 07:18:17.596 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-02 07:18:17.597 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37760
2023-01-02 07:18:17.597 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xf 0x0 0x0 0x0 0x6 0x1 0x3 0x93 0x80 0x0 0x1c
2023-01-02 07:18:17.597 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 15
2023-01-02 07:18:18.705 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xf 0x0 0x0 0x0 0x3b 0x1 0x3 0x38 0x0 0x5a 0x0 0x0 0x0 0x2 0x10 0x95 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 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0xbb 0xb4 0x0 0x0 0xbb 0x41 0x0 0x0 0x0 0x0 0x0 0x0 0x1 0xf9
2023-01-02 07:18:18.705 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xf 0x0 0x0 0x0 0x3b 0x1 0x3 0x38 0x0 0x5a 0x0 0x0 0x0 0x2 0x10 0x95 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 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0xbb 0xb4 0x0 0x0 0xbb 0x41 0x0 0x0 0x0 0x0 0x0 0x0 0x1 0xf9
2023-01-02 07:18:18.705 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:18.705 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 15
2023-01-02 07:18:18.756 DEBUG (MainThread) [pymodbus.payload] [90, 0, 2, 4245, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 48052, 0, 47937, 0, 0, 0, 505]
2023-01-02 07:18:18.757 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2023-01-02 07:18:18.757 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\xbb\xb4']
2023-01-02 07:18:18.757 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\xbbA']
2023-01-02 07:18:18.757 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2023-01-02 07:18:18.757 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x01\xf9']
2023-01-02 07:18:18.757 DEBUG (MainThread) [custom_components.huawei_solar] Finished fetching TA2250041190_data_update_coordinator data in 4.750 seconds (success: True)
2023-01-02 07:18:18.757 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47075
2023-01-02 07:18:18.758 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x10 0x0 0x0 0x0 0x6 0x1 0x3 0xb7 0xe3 0x0 0xe
2023-01-02 07:18:18.758 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 16
2023-01-02 07:18:19.370 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x10 0x0 0x0 0x0 0x1f 0x1 0x3 0x1c 0x0 0x0 0x0 0x0 0x0 0x0 0x13 0x87 0x0 0x0 0x13 0x87 0x3 0xd4 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x2 0x0 0x1 0x3 0xb6
2023-01-02 07:18:19.371 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x10 0x0 0x0 0x0 0x1f 0x1 0x3 0x1c 0x0 0x0 0x0 0x0 0x0 0x0 0x13 0x87 0x0 0x0 0x13 0x87 0x3 0xd4 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x2 0x0 0x1 0x3 0xb6
2023-01-02 07:18:19.371 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:19.371 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 16
2023-01-02 07:18:19.423 DEBUG (MainThread) [pymodbus.payload] [0, 0, 0, 4999, 0, 4999, 980, 0, 0, 0, 0, 2, 1, 950]
2023-01-02 07:18:19.423 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2023-01-02 07:18:19.423 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x13\x87']
2023-01-02 07:18:19.423 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47200
2023-01-02 07:18:19.423 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x11 0x0 0x0 0x0 0x6 0x1 0x3 0xb8 0x60 0x0 0x2e
2023-01-02 07:18:19.424 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 17
2023-01-02 07:18:20.983 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x11 0x0 0x0 0x0 0x5f 0x1 0x3 0x5c 0x0 0x0 0xf 0x0 0xe8 0x3 0xf4 0x1 0x90 0x1 0x2c 0x1 0x58 0x2 0xc8 0x0 0x1 0x0 0x96 0x0 0x84 0x3 0x70 0x17 0x2 0x0 0xf7 0x0 0xa0 0x5 0xff 0xff 0x6 0x0 0x5 0x0 0x3f 0x0 0x3 0x0 0x0 0x0 0x10 0x27 0x0 0x0 0x0 0x0 0x0 0x0 0x80 0x43 0x6d 0x38 0x88 0x13 0x0 0x0 0xff 0xff 0xff 0xff 0x0 0xe1 0x0 0x3 0x2 0x0 0x0 0x0 0x28 0xb6 0x13 0x0 0x0 0x0 0x0 0x0 0x1 0xe1 0x0 0x3 0x0 0x0 0x0 0x0 0xb 0xb8 0x0 0x0 0xb 0xb8
2023-01-02 07:18:20.983 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x11 0x0 0x0 0x0 0x5f 0x1 0x3 0x5c 0x0 0x0 0xf 0x0 0xe8 0x3 0xf4 0x1 0x90 0x1 0x2c 0x1 0x58 0x2 0xc8 0x0 0x1 0x0 0x96 0x0 0x84 0x3 0x70 0x17 0x2 0x0 0xf7 0x0 0xa0 0x5 0xff 0xff 0x6 0x0 0x5 0x0 0x3f 0x0 0x3 0x0 0x0 0x0 0x10 0x27 0x0 0x0 0x0 0x0 0x0 0x0 0x80 0x43 0x6d 0x38 0x88 0x13 0x0 0x0 0xff 0xff 0xff 0xff 0x0 0xe1 0x0 0x3 0x2 0x0 0x0 0x0 0x28 0xb6 0x13 0x0 0x0 0x0 0x0 0x0 0x1 0xe1 0x0 0x3 0x0 0x0 0x0 0x0 0xb 0xb8 0x0 0x0 0xb 0xb8
2023-01-02 07:18:20.983 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:20.983 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 17
2023-01-02 07:18:21.040 DEBUG (MainThread) [pymodbus.payload] [0, 3840, 59395, 62465, 36865, 11265, 22530, 51200, 256, 38400, 33795, 28695, 512, 63232, 40965, 65535, 1536, 1280, 16128, 768, 0, 4135, 0, 0, 0, 32835, 27960, 34835, 0, 65535, 65535, 225, 3, 512, 0, 10422, 4864, 0, 0, 481, 3, 0, 0, 3000, 0, 3000]
2023-01-02 07:18:21.040 DEBUG (MainThread) [pymodbus.payload] [b'\xf4\x01', b'\x90\x01']
2023-01-02 07:18:21.040 DEBUG (MainThread) [pymodbus.payload] [b'\xc8\x00', b'\x01\x00']
2023-01-02 07:18:21.040 DEBUG (MainThread) [pymodbus.payload] [b'p\x17', b'\x02\x00']
2023-01-02 07:18:21.040 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\x06\x00']
2023-01-02 07:18:21.040 DEBUG (MainThread) [pymodbus.payload] [b'\x03\x00', b'\x00\x00']
2023-01-02 07:18:21.040 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2023-01-02 07:18:21.040 DEBUG (MainThread) [pymodbus.payload] [b'\x88\x13', b'\x00\x00']
2023-01-02 07:18:21.040 DEBUG (MainThread) [pymodbus.payload] [b'\x00\xe1', b'\x00\x03']
2023-01-02 07:18:21.041 DEBUG (MainThread) [pymodbus.payload] [b'(\xb6', b'\x13\x00']
2023-01-02 07:18:21.041 DEBUG (MainThread) [pymodbus.payload] [b'\x01\xe1', b'\x00\x03']
2023-01-02 07:18:21.041 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x0b\xb8']
2023-01-02 07:18:21.041 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x0b\xb8']
2023-01-02 07:18:21.041 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47255
2023-01-02 07:18:21.041 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x12 0x0 0x0 0x0 0x6 0x1 0x3 0xb8 0x97 0x0 0x2d
2023-01-02 07:18:21.042 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 18
2023-01-02 07:18:21.552 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x12 0x0 0x0 0x0 0x5d 0x1 0x3 0x5a 0x0 0x2 0x0 0x0 0x1 0x68 0x0 0x7f 0x1 0xe0 0x5 0x28 0x1 0x7f 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 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 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x1
2023-01-02 07:18:21.552 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x12 0x0 0x0 0x0 0x5d 0x1 0x3 0x5a 0x0 0x2 0x0 0x0 0x1 0x68 0x0 0x7f 0x1 0xe0 0x5 0x28 0x1 0x7f 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 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 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x1
2023-01-02 07:18:21.552 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:21.552 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 18
2023-01-02 07:18:21.603 DEBUG (MainThread) [pymodbus.payload] [2, 0, 360, 127, 480, 1320, 383, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1]
2023-01-02 07:18:21.604 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47954
2023-01-02 07:18:21.604 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x13 0x0 0x0 0x0 0x6 0x1 0x3 0xbb 0x52 0x0 0x42
2023-01-02 07:18:21.604 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 19
2023-01-02 07:18:22.376 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x13 0x0 0x0 0x0 0x87 0x1 0x3 0x84 0x0 0x0 0x1 0xf4 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 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 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 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 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
2023-01-02 07:18:22.376 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x13 0x0 0x0 0x0 0x87 0x1 0x3 0x84 0x0 0x0 0x1 0xf4 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 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 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 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 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
2023-01-02 07:18:22.376 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:18:22.376 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 19
2023-01-02 07:18:22.428 DEBUG (MainThread) [pymodbus.payload] [0, 500, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]
2023-01-02 07:18:22.428 DEBUG (MainThread) [custom_components.huawei_solar] Finished fetching TA2250041190_configuration_update_coordinator data in 3.671 seconds (success: True)
2023-01-02 07:18:22.428 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading file 0x45
2023-01-02 07:18:22.428 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x14 0x0 0x0 0x0 0x5 0x0 0x41 0x5 0x1 0x45
2023-01-02 07:18:22.429 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 20
2023-01-02 07:18:25.429 INFO (MainThread) [backoff] Backing off _perform_request(...) for 10.0s (asyncio.exceptions.TimeoutError)
2023-01-02 07:18:25.430 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off file upload for 10.0 seconds after 1 tries
2023-01-02 07:18:35.431 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x15 0x0 0x0 0x0 0x5 0x0 0x41 0x5 0x1 0x45
2023-01-02 07:18:35.432 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 21
2023-01-02 07:18:38.432 INFO (MainThread) [backoff] Backing off _perform_request(...) for 10.0s (asyncio.exceptions.TimeoutError)
2023-01-02 07:18:38.433 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off file upload for 10.0 seconds after 2 tries
2023-01-02 07:18:48.434 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x16 0x0 0x0 0x0 0x5 0x0 0x41 0x5 0x1 0x45
2023-01-02 07:18:48.434 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 22
2023-01-02 07:18:51.436 INFO (MainThread) [backoff] Backing off _perform_request(...) for 10.0s (asyncio.exceptions.TimeoutError)
2023-01-02 07:18:51.436 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off file upload for 10.0 seconds after 3 tries```

@wlcrs
Copy link
Owner

wlcrs commented Jan 1, 2023

I'm afraid that what you are sending me is still incomplete for me to figure out what is going wrong.

Can you please increase the overall 'default' logging level so that you hopefully capture the real error that is occurring?

Adjust the logger: entry in your configuration.yaml as follows and restart HA before retrying:

logger:
  default: info
  logs:
    pymodbus: debug 
    huawei_solar: debug
    homeassistant.components.huawei_solar: debug

@etamtlosz
Copy link
Author

etamtlosz commented Jan 1, 2023

Done. Here's the unfiltered log:

2023-01-02 07:55:59.977 INFO (SyncWorker_7) [homeassistant.util.package] Attempting install of huawei-solar==2.2.0b6
2023-01-02 07:56:06.140 INFO (SyncWorker_5) [homeassistant.components.proximity] eni phone: proximity calculation complete
2023-01-02 07:56:06.141 INFO (SyncWorker_5) [homeassistant.components.proximity] eni phone: proximity calculation complete
2023-01-02 07:56:06.141 INFO (SyncWorker_5) [homeassistant.components.proximity] eni phone: proximity calculation complete
2023-01-02 07:56:06.142 INFO (SyncWorker_4) [homeassistant.components.proximity] eni phone: proximity calculation complete
2023-01-02 07:56:06.142 INFO (SyncWorker_4) [homeassistant.components.proximity] eni phone: proximity calculation complete
2023-01-02 07:56:23.436 INFO (MainThread) [custom_components.blueiris.api.blue_iris_api] Updating data from BI Server (wonderNVR)
2023-01-02 07:56:23.516 DEBUG (MainThread) [pymodbus.client.tcp] Connecting to 192.168.2.170:502.
2023-01-02 07:56:23.516 DEBUG (MainThread) [pymodbus.client.tcp] Connecting.
2023-01-02 07:56:23.517 DEBUG (MainThread) [pymodbus.client.base] Client connected to modbus server
2023-01-02 07:56:23.517 INFO (MainThread) [pymodbus.client.tcp] Protocol made connection.
2023-01-02 07:56:23.518 INFO (MainThread) [pymodbus.client.tcp] Connected to 192.168.2.170:502.
2023-01-02 07:56:24.519 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 43006
2023-01-02 07:56:24.519 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x1 0x0 0x0 0x0 0x6 0x1 0x3 0xa7 0xfe 0x0 0x1
2023-01-02 07:56:24.520 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 1
2023-01-02 07:56:24.754 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x1 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x2 0xd0
2023-01-02 07:56:24.754 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x1 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x2 0xd0
2023-01-02 07:56:24.754 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:24.755 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 1
2023-01-02 07:56:24.805 DEBUG (MainThread) [pymodbus.payload] [720]
2023-01-02 07:56:24.806 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47000
2023-01-02 07:56:24.806 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x2 0x0 0x0 0x0 0x6 0x1 0x3 0xb7 0x98 0x0 0x1
2023-01-02 07:56:24.806 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 2
2023-01-02 07:56:24.992 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x2 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:56:24.992 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x2 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:56:24.992 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:24.993 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 2
2023-01-02 07:56:25.043 DEBUG (MainThread) [pymodbus.payload] [2]
2023-01-02 07:56:25.044 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 30000
2023-01-02 07:56:25.044 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x3 0x0 0x0 0x0 0x6 0x1 0x3 0x75 0x30 0x0 0x23
2023-01-02 07:56:25.044 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 3
2023-01-02 07:56:25.570 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x3 0x0 0x0 0x0 0x49 0x1 0x3 0x46 0x53 0x55 0x4e 0x32 0x30 0x30 0x30 0x2d 0x35 0x4b 0x54 0x4c 0x2d 0x4c 0x31 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x54 0x41 0x32 0x32 0x35 0x30 0x30 0x34 0x31 0x31 0x39 0x30 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x30 0x31 0x30 0x37 0x35 0x33 0x34 0x36 0x2d 0x30 0x31 0x35 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
2023-01-02 07:56:25.571 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x3 0x0 0x0 0x0 0x49 0x1 0x3 0x46 0x53 0x55 0x4e 0x32 0x30 0x30 0x30 0x2d 0x35 0x4b 0x54 0x4c 0x2d 0x4c 0x31 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x54 0x41 0x32 0x32 0x35 0x30 0x30 0x34 0x31 0x31 0x39 0x30 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x30 0x31 0x30 0x37 0x35 0x33 0x34 0x36 0x2d 0x30 0x31 0x35 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
2023-01-02 07:56:25.571 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:25.571 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 3
2023-01-02 07:56:25.621 DEBUG (MainThread) [pymodbus.payload] [21333, 20018, 12336, 12333, 13643, 21580, 11596, 12544, 0, 0, 0, 0, 0, 0, 0, 21569, 12850, 13616, 12340, 12593, 14640, 0, 0, 0, 0, 12337, 12343, 13619, 13366, 11568, 12597, 0, 0, 0, 0]
2023-01-02 07:56:25.622 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 30071
2023-01-02 07:56:25.622 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x4 0x0 0x0 0x0 0x6 0x1 0x3 0x75 0x77 0x0 0x1
2023-01-02 07:56:25.622 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 4
2023-01-02 07:56:26.207 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x4 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:56:26.208 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x4 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:56:26.208 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:26.208 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 4
2023-01-02 07:56:26.261 DEBUG (MainThread) [pymodbus.payload] [2]
2023-01-02 07:56:26.261 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37200
2023-01-02 07:56:26.261 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x5 0x0 0x0 0x0 0x6 0x1 0x3 0x91 0x50 0x0 0x1
2023-01-02 07:56:26.262 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 5
2023-01-02 07:56:27.571 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x5 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x4
2023-01-02 07:56:27.572 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x5 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x4
2023-01-02 07:56:27.572 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:27.572 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 5
2023-01-02 07:56:27.623 DEBUG (MainThread) [pymodbus.payload] [4]
2023-01-02 07:56:27.623 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37100
2023-01-02 07:56:27.624 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x6 0x0 0x0 0x0 0x6 0x1 0x3 0x90 0xec 0x0 0x1
2023-01-02 07:56:27.624 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 6
2023-01-02 07:56:28.022 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x6 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x1
2023-01-02 07:56:28.023 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x6 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x1
2023-01-02 07:56:28.023 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:28.023 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 6
2023-01-02 07:56:28.074 DEBUG (MainThread) [pymodbus.payload] [1]
2023-01-02 07:56:28.074 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37125
2023-01-02 07:56:28.074 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x7 0x0 0x0 0x0 0x6 0x1 0x3 0x91 0x5 0x0 0x1
2023-01-02 07:56:28.074 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 7
2023-01-02 07:56:28.582 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x7 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:56:28.582 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x7 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:56:28.583 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:28.583 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 7
2023-01-02 07:56:28.634 DEBUG (MainThread) [pymodbus.payload] [0]
2023-01-02 07:56:28.634 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47000
2023-01-02 07:56:28.635 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x8 0x0 0x0 0x0 0x6 0x1 0x3 0xb7 0x98 0x0 0x1
2023-01-02 07:56:28.635 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 8
2023-01-02 07:56:29.420 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x8 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:56:29.420 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x8 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:56:29.420 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:29.421 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 8
2023-01-02 07:56:29.471 DEBUG (MainThread) [pymodbus.payload] [2]
2023-01-02 07:56:29.472 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47089
2023-01-02 07:56:29.472 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x9 0x0 0x0 0x0 0x6 0x1 0x3 0xb7 0xf1 0x0 0x1
2023-01-02 07:56:29.472 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 9
2023-01-02 07:56:30.063 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x9 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:56:30.063 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x9 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:56:30.063 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:30.063 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 9
2023-01-02 07:56:30.114 DEBUG (MainThread) [pymodbus.payload] [0]
2023-01-02 07:56:30.114 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47954
2023-01-02 07:56:30.114 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xa 0x0 0x0 0x0 0x6 0x1 0x3 0xbb 0x52 0x0 0x1
2023-01-02 07:56:30.115 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 10
2023-01-02 07:56:30.520 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xa 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:56:30.521 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xa 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:56:30.521 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:30.521 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 10
2023-01-02 07:56:30.571 DEBUG (MainThread) [pymodbus.payload] [0]
2023-01-02 07:56:30.572 INFO (MainThread) [custom_components.huawei_solar.config_flow] Successfully connected to inverter SUN2000-5KTL-L1 with SN TA2250041190
2023-01-02 07:56:30.572 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 43006
2023-01-02 07:56:30.572 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xb 0x0 0x0 0x0 0x6 0x1 0x3 0xa7 0xfe 0x0 0x1
2023-01-02 07:56:30.572 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 11
2023-01-02 07:56:31.436 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xb 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x2 0xd0
2023-01-02 07:56:31.436 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xb 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x2 0xd0
2023-01-02 07:56:31.436 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:31.436 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 11
2023-01-02 07:56:31.487 DEBUG (MainThread) [pymodbus.payload] [720]
2023-01-02 07:56:31.487 DEBUG (MainThread) [pymodbus.payload] [720]
2023-01-02 07:56:31.488 DEBUG (MainThread) [pymodbus.payload] [720]
2023-01-02 07:56:31.488 DEBUG (MainThread) [huawei_solar.huawei_solar] Writing to 43006: [720]
2023-01-02 07:56:31.488 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xc 0x0 0x0 0x0 0x9 0x1 0x10 0xa7 0xfe 0x0 0x1 0x2 0x2 0xd0
2023-01-02 07:56:31.488 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 12
2023-01-02 07:56:32.312 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xc 0x0 0x0 0x0 0x6 0x1 0x10 0xa7 0xfe 0x0 0x1
2023-01-02 07:56:32.313 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xc 0x0 0x0 0x0 0x6 0x1 0x10 0xa7 0xfe 0x0 0x1
2023-01-02 07:56:32.313 DEBUG (MainThread) [pymodbus.factory] Factory Response[WriteMultipleRegistersResponse': 16]
2023-01-02 07:56:32.313 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 12
2023-01-02 07:56:32.364 DEBUG (MainThread) [pymodbus.client.base] Client disconnected from modbus server: None
2023-01-02 07:56:32.364 INFO (MainThread) [pymodbus.client.tcp] Protocol lost connection.
2023-01-02 07:56:32.365 INFO (MainThread) [homeassistant.setup] Setting up huawei_solar
2023-01-02 07:56:32.365 INFO (MainThread) [homeassistant.setup] Setup of domain huawei_solar took 0.0 seconds
2023-01-02 07:56:32.366 DEBUG (MainThread) [pymodbus.client.tcp] Connecting to 192.168.2.170:502.
2023-01-02 07:56:32.366 DEBUG (MainThread) [pymodbus.client.tcp] Connecting.
2023-01-02 07:56:32.368 DEBUG (MainThread) [pymodbus.client.base] Client connected to modbus server
2023-01-02 07:56:32.368 INFO (MainThread) [pymodbus.client.tcp] Protocol made connection.
2023-01-02 07:56:32.369 INFO (MainThread) [pymodbus.client.tcp] Connected to 192.168.2.170:502.
2023-01-02 07:56:33.370 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 43006
2023-01-02 07:56:33.370 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x1 0x0 0x0 0x0 0x6 0x1 0x3 0xa7 0xfe 0x0 0x1
2023-01-02 07:56:33.371 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 1
2023-01-02 07:56:34.770 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x1 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x2 0xd0
2023-01-02 07:56:34.770 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x1 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x2 0xd0
2023-01-02 07:56:34.770 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:34.770 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 1
2023-01-02 07:56:34.822 DEBUG (MainThread) [pymodbus.payload] [720]
2023-01-02 07:56:34.822 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47000
2023-01-02 07:56:34.822 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x2 0x0 0x0 0x0 0x6 0x1 0x3 0xb7 0x98 0x0 0x1
2023-01-02 07:56:34.823 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 2
2023-01-02 07:56:35.265 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x2 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:56:35.265 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x2 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:56:35.265 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:35.265 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 2
2023-01-02 07:56:35.318 DEBUG (MainThread) [pymodbus.payload] [2]
2023-01-02 07:56:35.319 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 30000
2023-01-02 07:56:35.319 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x3 0x0 0x0 0x0 0x6 0x1 0x3 0x75 0x30 0x0 0x23
2023-01-02 07:56:35.319 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 3
2023-01-02 07:56:36.103 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x3 0x0 0x0 0x0 0x49 0x1 0x3 0x46 0x53 0x55 0x4e 0x32 0x30 0x30 0x30 0x2d 0x35 0x4b 0x54 0x4c 0x2d 0x4c 0x31 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x54 0x41 0x32 0x32 0x35 0x30 0x30 0x34 0x31 0x31 0x39 0x30 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x30 0x31 0x30 0x37 0x35 0x33 0x34 0x36 0x2d 0x30 0x31 0x35 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
2023-01-02 07:56:36.103 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x3 0x0 0x0 0x0 0x49 0x1 0x3 0x46 0x53 0x55 0x4e 0x32 0x30 0x30 0x30 0x2d 0x35 0x4b 0x54 0x4c 0x2d 0x4c 0x31 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x54 0x41 0x32 0x32 0x35 0x30 0x30 0x34 0x31 0x31 0x39 0x30 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x30 0x31 0x30 0x37 0x35 0x33 0x34 0x36 0x2d 0x30 0x31 0x35 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
2023-01-02 07:56:36.103 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:36.103 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 3
2023-01-02 07:56:36.156 DEBUG (MainThread) [pymodbus.payload] [21333, 20018, 12336, 12333, 13643, 21580, 11596, 12544, 0, 0, 0, 0, 0, 0, 0, 21569, 12850, 13616, 12340, 12593, 14640, 0, 0, 0, 0, 12337, 12343, 13619, 13366, 11568, 12597, 0, 0, 0, 0]
2023-01-02 07:56:36.156 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 30071
2023-01-02 07:56:36.156 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x4 0x0 0x0 0x0 0x6 0x1 0x3 0x75 0x77 0x0 0x1
2023-01-02 07:56:36.156 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 4
2023-01-02 07:56:37.046 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x4 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:56:37.046 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x4 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:56:37.046 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:37.046 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 4
2023-01-02 07:56:37.098 DEBUG (MainThread) [pymodbus.payload] [2]
2023-01-02 07:56:37.098 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37200
2023-01-02 07:56:37.098 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x5 0x0 0x0 0x0 0x6 0x1 0x3 0x91 0x50 0x0 0x1
2023-01-02 07:56:37.098 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 5
2023-01-02 07:56:37.957 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x5 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x4
2023-01-02 07:56:37.957 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x5 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x4
2023-01-02 07:56:37.957 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:37.957 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 5
2023-01-02 07:56:38.008 DEBUG (MainThread) [pymodbus.payload] [4]
2023-01-02 07:56:38.009 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37100
2023-01-02 07:56:38.009 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x6 0x0 0x0 0x0 0x6 0x1 0x3 0x90 0xec 0x0 0x1
2023-01-02 07:56:38.010 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 6
2023-01-02 07:56:38.467 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x6 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x1
2023-01-02 07:56:38.467 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x6 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x1
2023-01-02 07:56:38.467 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:38.467 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 6
2023-01-02 07:56:38.518 DEBUG (MainThread) [pymodbus.payload] [1]
2023-01-02 07:56:38.519 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37125
2023-01-02 07:56:38.519 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x7 0x0 0x0 0x0 0x6 0x1 0x3 0x91 0x5 0x0 0x1
2023-01-02 07:56:38.519 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 7
2023-01-02 07:56:39.321 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x7 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:56:39.321 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x7 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:56:39.321 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:39.321 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 7
2023-01-02 07:56:39.372 DEBUG (MainThread) [pymodbus.payload] [0]
2023-01-02 07:56:39.372 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47000
2023-01-02 07:56:39.373 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x8 0x0 0x0 0x0 0x6 0x1 0x3 0xb7 0x98 0x0 0x1
2023-01-02 07:56:39.373 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 8
2023-01-02 07:56:40.198 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x8 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:56:40.198 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x8 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x2
2023-01-02 07:56:40.198 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:40.198 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 8
2023-01-02 07:56:40.249 DEBUG (MainThread) [pymodbus.payload] [2]
2023-01-02 07:56:40.250 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47089
2023-01-02 07:56:40.250 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x9 0x0 0x0 0x0 0x6 0x1 0x3 0xb7 0xf1 0x0 0x1
2023-01-02 07:56:40.250 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 9
2023-01-02 07:56:40.718 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x9 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:56:40.718 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x9 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:56:40.718 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:40.718 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 9
2023-01-02 07:56:40.770 DEBUG (MainThread) [pymodbus.payload] [0]
2023-01-02 07:56:40.770 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47954
2023-01-02 07:56:40.770 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xa 0x0 0x0 0x0 0x6 0x1 0x3 0xbb 0x52 0x0 0x1
2023-01-02 07:56:40.771 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 10
2023-01-02 07:56:41.523 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xa 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:56:41.523 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xa 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x0
2023-01-02 07:56:41.523 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:41.523 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 10
2023-01-02 07:56:41.575 DEBUG (MainThread) [pymodbus.payload] [0]
2023-01-02 07:56:41.576 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32064
2023-01-02 07:56:41.576 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xb 0x0 0x0 0x0 0x6 0x1 0x3 0x7d 0x40 0x0 0x34
2023-01-02 07:56:41.576 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 11
2023-01-02 07:56:42.512 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xb 0x0 0x0 0x0 0x6b 0x1 0x3 0x68 0x0 0x0 0x3 0x50 0x9 0x40 0x0 0x0 0x0 0x0 0x4 0x9e 0x0 0x3 0x0 0x0 0x0 0x0 0x11 0x36 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x4 0x59 0x0 0x0 0x3 0x50 0xff 0xff 0xfd 0xb4 0x3 0x36 0x13 0x88 0x27 0x10 0x1 0x3b 0xb 0xb8 0x4 0x2 0x0 0x0 0x63 0xb2 0x7d 0x7c 0xff 0xff 0xff 0xff 0x0 0x0 0x3 0x53 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x5a 0x0 0x2 0x7b 0xac 0x0 0x2 0xaa 0x42 0x63 0xb2 0x8f 0x52 0x0 0x0 0x0 0x2 0x0 0x0 0x1 0xeb
2023-01-02 07:56:42.512 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xb 0x0 0x0 0x0 0x6b 0x1 0x3 0x68 0x0 0x0 0x3 0x50 0x9 0x40 0x0 0x0 0x0 0x0 0x4 0x9e 0x0 0x3 0x0 0x0 0x0 0x0 0x11 0x36 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x4 0x59 0x0 0x0 0x3 0x50 0xff 0xff 0xfd 0xb4 0x3 0x36 0x13 0x88 0x27 0x10 0x1 0x3b 0xb 0xb8 0x4 0x2 0x0 0x0 0x63 0xb2 0x7d 0x7c 0xff 0xff 0xff 0xff 0x0 0x0 0x3 0x53 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x5a 0x0 0x2 0x7b 0xac 0x0 0x2 0xaa 0x42 0x63 0xb2 0x8f 0x52 0x0 0x0 0x0 0x2 0x0 0x0 0x1 0xeb
2023-01-02 07:56:42.512 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:42.512 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 11
2023-01-02 07:56:42.563 DEBUG (MainThread) [pymodbus.payload] [0, 848, 2368, 0, 0, 1182, 3, 0, 0, 4406, 0, 0, 0, 0, 0, 1113, 0, 848, 65535, 64948, 822, 5000, 10000, 315, 3000, 1026, 0, 25522, 32124, 65535, 65535, 0, 851, 0, 0, 0, 0, 0, 0, 0, 0, 90, 2, 31660, 2, 43586, 25522, 36690, 0, 2, 0, 491]
2023-01-02 07:56:42.564 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x03P']
2023-01-02 07:56:42.564 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x116']
2023-01-02 07:56:42.564 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2023-01-02 07:56:42.564 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2023-01-02 07:56:42.564 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x04Y']
2023-01-02 07:56:42.564 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x03P']
2023-01-02 07:56:42.564 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xfd\xb4']
2023-01-02 07:56:42.564 DEBUG (MainThread) [pymodbus.payload] [b'c\xb2', b'}|']
2023-01-02 07:56:42.565 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xff\xff']
2023-01-02 07:56:42.565 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x02', b'{\xac']
2023-01-02 07:56:42.565 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x01\xeb']
2023-01-02 07:56:42.565 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 32000
2023-01-02 07:56:42.565 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xc 0x0 0x0 0x0 0x6 0x1 0x3 0x7d 0x0 0x0 0x14
2023-01-02 07:56:42.565 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 12
2023-01-02 07:56:43.690 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xc 0x0 0x0 0x0 0x2b 0x1 0x3 0x28 0x0 0xa 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 0x91 0x70 0x7 0xeb 0x0 0x96 0xd 0x6f 0x0 0xab
2023-01-02 07:56:43.690 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xc 0x0 0x0 0x0 0x2b 0x1 0x3 0x28 0x0 0xa 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 0x91 0x70 0x7 0xeb 0x0 0x96 0xd 0x6f 0x0 0xab
2023-01-02 07:56:43.690 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:43.690 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 12
2023-01-02 07:56:43.741 DEBUG (MainThread) [pymodbus.payload] [10, 0, 7, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 37232, 2027, 150, 3439, 171]
2023-01-02 07:56:43.741 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2023-01-02 07:56:43.742 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37201
2023-01-02 07:56:43.742 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xd 0x0 0x0 0x0 0x6 0x1 0x3 0x91 0x51 0x0 0x1
2023-01-02 07:56:43.742 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 13
2023-01-02 07:56:44.585 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xd 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x4
2023-01-02 07:56:44.585 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xd 0x0 0x0 0x0 0x5 0x1 0x3 0x2 0x0 0x4
2023-01-02 07:56:44.585 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:44.585 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 13
2023-01-02 07:56:44.637 DEBUG (MainThread) [pymodbus.payload] [4]
2023-01-02 07:56:44.637 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37101
2023-01-02 07:56:44.637 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xe 0x0 0x0 0x0 0x6 0x1 0x3 0x90 0xed 0x0 0x25
2023-01-02 07:56:44.637 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 14
2023-01-02 07:56:45.488 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xe 0x0 0x0 0x0 0x4d 0x1 0x3 0x4a 0x0 0x0 0x9 0x3b 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0xff 0xff 0xff 0xb5 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0xff 0xff 0xff 0xf7 0xff 0xff 0xff 0x54 0x0 0xfe 0x13 0x87 0x0 0x0 0xf3 0xff 0x0 0x0 0x1a 0xd9 0x0 0x0 0xdb 0x1 0x0 0x0 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff
2023-01-02 07:56:45.488 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xe 0x0 0x0 0x0 0x4d 0x1 0x3 0x4a 0x0 0x0 0x9 0x3b 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0xff 0xff 0xff 0xb5 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0xff 0xff 0xff 0xf7 0xff 0xff 0xff 0x54 0x0 0xfe 0x13 0x87 0x0 0x0 0xf3 0xff 0x0 0x0 0x1a 0xd9 0x0 0x0 0xdb 0x1 0x0 0x0 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff 0x7f 0xff 0xff 0xff
2023-01-02 07:56:45.488 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:45.488 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 14
2023-01-02 07:56:45.540 DEBUG (MainThread) [pymodbus.payload] [0, 2363, 32767, 65535, 32767, 65535, 65535, 65461, 32767, 65535, 32767, 65535, 65535, 65527, 65535, 65364, 254, 4999, 0, 62463, 0, 6873, 0, 56065, 0, 32767, 65535, 32767, 65535, 32767, 65535, 32767, 65535, 32767, 65535, 32767, 65535]
2023-01-02 07:56:45.540 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\t;']
2023-01-02 07:56:45.540 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-02 07:56:45.540 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-02 07:56:45.540 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xff\xb5']
2023-01-02 07:56:45.540 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-02 07:56:45.540 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-02 07:56:45.541 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xff\xf7']
2023-01-02 07:56:45.541 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\xffT']
2023-01-02 07:56:45.541 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\xf3\xff']
2023-01-02 07:56:45.541 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x1a\xd9']
2023-01-02 07:56:45.541 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\xdb\x01']
2023-01-02 07:56:45.541 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-02 07:56:45.541 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-02 07:56:45.541 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-02 07:56:45.541 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-02 07:56:45.541 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-02 07:56:45.541 DEBUG (MainThread) [pymodbus.payload] [b'\x7f\xff', b'\xff\xff']
2023-01-02 07:56:45.542 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 37760
2023-01-02 07:56:45.542 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0xf 0x0 0x0 0x0 0x6 0x1 0x3 0x93 0x80 0x0 0x1c
2023-01-02 07:56:45.550 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 15
2023-01-02 07:56:46.140 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0xf 0x0 0x0 0x0 0x3b 0x1 0x3 0x38 0x0 0x5a 0x0 0x0 0x0 0x2 0x10 0x98 0xff 0xff 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 0x0 0x0 0x0 0x0 0x0 0x0 0xbb 0xb5 0x0 0x0 0xbb 0x42 0x0 0x0 0x0 0x1 0x0 0x0 0x1 0xfa
2023-01-02 07:56:46.140 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0xf 0x0 0x0 0x0 0x3b 0x1 0x3 0x38 0x0 0x5a 0x0 0x0 0x0 0x2 0x10 0x98 0xff 0xff 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 0x0 0x0 0x0 0x0 0x0 0x0 0xbb 0xb5 0x0 0x0 0xbb 0x42 0x0 0x0 0x0 0x1 0x0 0x0 0x1 0xfa
2023-01-02 07:56:46.141 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:46.141 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 15
2023-01-02 07:56:46.192 DEBUG (MainThread) [pymodbus.payload] [90, 0, 2, 4248, 65535, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 48053, 0, 47938, 0, 1, 0, 506]
2023-01-02 07:56:46.192 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2023-01-02 07:56:46.193 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\xbb\xb5']
2023-01-02 07:56:46.193 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\xbbB']
2023-01-02 07:56:46.193 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x01']
2023-01-02 07:56:46.193 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x01\xfa']
2023-01-02 07:56:46.193 DEBUG (MainThread) [custom_components.huawei_solar] Finished fetching TA2250041190_data_update_coordinator data in 4.617 seconds (success: True)
2023-01-02 07:56:46.193 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47075
2023-01-02 07:56:46.194 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x10 0x0 0x0 0x0 0x6 0x1 0x3 0xb7 0xe3 0x0 0xe
2023-01-02 07:56:46.194 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 16
2023-01-02 07:56:47.005 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x10 0x0 0x0 0x0 0x1f 0x1 0x3 0x1c 0x0 0x0 0x0 0x0 0x0 0x0 0x13 0x87 0x0 0x0 0x13 0x87 0x3 0xd4 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x2 0x0 0x1 0x3 0xb6
2023-01-02 07:56:47.005 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x10 0x0 0x0 0x0 0x1f 0x1 0x3 0x1c 0x0 0x0 0x0 0x0 0x0 0x0 0x13 0x87 0x0 0x0 0x13 0x87 0x3 0xd4 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x2 0x0 0x1 0x3 0xb6
2023-01-02 07:56:47.005 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:47.005 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 16
2023-01-02 07:56:47.058 DEBUG (MainThread) [pymodbus.payload] [0, 0, 0, 4999, 0, 4999, 980, 0, 0, 0, 0, 2, 1, 950]
2023-01-02 07:56:47.058 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2023-01-02 07:56:47.058 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x13\x87']
2023-01-02 07:56:47.058 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47200
2023-01-02 07:56:47.058 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x11 0x0 0x0 0x0 0x6 0x1 0x3 0xb8 0x60 0x0 0x2e
2023-01-02 07:56:47.059 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 17
2023-01-02 07:56:48.261 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x11 0x0 0x0 0x0 0x5f 0x1 0x3 0x5c 0x0 0x0 0xf 0x0 0xe8 0x3 0xf4 0x1 0x90 0x1 0x2c 0x1 0x58 0x2 0xc8 0x0 0x1 0x0 0x96 0x0 0x84 0x3 0x70 0x17 0x2 0x0 0xf7 0x0 0xa0 0x5 0xff 0xff 0x6 0x0 0x5 0x0 0x3f 0x0 0x3 0x0 0x0 0x0 0x10 0x27 0x0 0x0 0x0 0x0 0x0 0x0 0x80 0x43 0x6d 0x38 0x88 0x13 0x0 0x0 0xff 0xff 0xff 0xff 0x0 0xe1 0x0 0x3 0x2 0x0 0x0 0x0 0x28 0xb6 0x13 0x0 0x0 0x0 0x0 0x0 0x1 0xe1 0x0 0x3 0x0 0x0 0x0 0x0 0xb 0xb8 0x0 0x0 0xb 0xb8
2023-01-02 07:56:48.261 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x11 0x0 0x0 0x0 0x5f 0x1 0x3 0x5c 0x0 0x0 0xf 0x0 0xe8 0x3 0xf4 0x1 0x90 0x1 0x2c 0x1 0x58 0x2 0xc8 0x0 0x1 0x0 0x96 0x0 0x84 0x3 0x70 0x17 0x2 0x0 0xf7 0x0 0xa0 0x5 0xff 0xff 0x6 0x0 0x5 0x0 0x3f 0x0 0x3 0x0 0x0 0x0 0x10 0x27 0x0 0x0 0x0 0x0 0x0 0x0 0x80 0x43 0x6d 0x38 0x88 0x13 0x0 0x0 0xff 0xff 0xff 0xff 0x0 0xe1 0x0 0x3 0x2 0x0 0x0 0x0 0x28 0xb6 0x13 0x0 0x0 0x0 0x0 0x0 0x1 0xe1 0x0 0x3 0x0 0x0 0x0 0x0 0xb 0xb8 0x0 0x0 0xb 0xb8
2023-01-02 07:56:48.261 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:48.261 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 17
2023-01-02 07:56:48.312 DEBUG (MainThread) [pymodbus.payload] [0, 3840, 59395, 62465, 36865, 11265, 22530, 51200, 256, 38400, 33795, 28695, 512, 63232, 40965, 65535, 1536, 1280, 16128, 768, 0, 4135, 0, 0, 0, 32835, 27960, 34835, 0, 65535, 65535, 225, 3, 512, 0, 10422, 4864, 0, 0, 481, 3, 0, 0, 3000, 0, 3000]
2023-01-02 07:56:48.312 DEBUG (MainThread) [pymodbus.payload] [b'\xf4\x01', b'\x90\x01']
2023-01-02 07:56:48.312 DEBUG (MainThread) [pymodbus.payload] [b'\xc8\x00', b'\x01\x00']
2023-01-02 07:56:48.312 DEBUG (MainThread) [pymodbus.payload] [b'p\x17', b'\x02\x00']
2023-01-02 07:56:48.313 DEBUG (MainThread) [pymodbus.payload] [b'\xff\xff', b'\x06\x00']
2023-01-02 07:56:48.313 DEBUG (MainThread) [pymodbus.payload] [b'\x03\x00', b'\x00\x00']
2023-01-02 07:56:48.313 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x00\x00']
2023-01-02 07:56:48.313 DEBUG (MainThread) [pymodbus.payload] [b'\x88\x13', b'\x00\x00']
2023-01-02 07:56:48.313 DEBUG (MainThread) [pymodbus.payload] [b'\x00\xe1', b'\x00\x03']
2023-01-02 07:56:48.313 DEBUG (MainThread) [pymodbus.payload] [b'(\xb6', b'\x13\x00']
2023-01-02 07:56:48.313 DEBUG (MainThread) [pymodbus.payload] [b'\x01\xe1', b'\x00\x03']
2023-01-02 07:56:48.313 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x0b\xb8']
2023-01-02 07:56:48.313 DEBUG (MainThread) [pymodbus.payload] [b'\x00\x00', b'\x0b\xb8']
2023-01-02 07:56:48.313 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47255
2023-01-02 07:56:48.314 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x12 0x0 0x0 0x0 0x6 0x1 0x3 0xb8 0x97 0x0 0x2d
2023-01-02 07:56:48.314 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 18
2023-01-02 07:56:48.972 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x12 0x0 0x0 0x0 0x5d 0x1 0x3 0x5a 0x0 0x2 0x0 0x0 0x1 0x68 0x0 0x7f 0x1 0xe0 0x5 0x28 0x1 0x7f 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 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 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x1
2023-01-02 07:56:48.972 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x12 0x0 0x0 0x0 0x5d 0x1 0x3 0x5a 0x0 0x2 0x0 0x0 0x1 0x68 0x0 0x7f 0x1 0xe0 0x5 0x28 0x1 0x7f 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 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 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x1
2023-01-02 07:56:48.972 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:48.973 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 18
2023-01-02 07:56:49.023 DEBUG (MainThread) [pymodbus.payload] [2, 0, 360, 127, 480, 1320, 383, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1]
2023-01-02 07:56:49.024 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading register 47954
2023-01-02 07:56:49.024 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x13 0x0 0x0 0x0 0x6 0x1 0x3 0xbb 0x52 0x0 0x42
2023-01-02 07:56:49.025 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 19
2023-01-02 07:56:50.123 DEBUG (MainThread) [pymodbus.client.base] recv: 0x0 0x13 0x0 0x0 0x0 0x87 0x1 0x3 0x84 0x0 0x0 0x1 0xf4 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 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 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 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 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
2023-01-02 07:56:50.123 DEBUG (MainThread) [pymodbus.framer.socket_framer] Processing: 0x0 0x13 0x0 0x0 0x0 0x87 0x1 0x3 0x84 0x0 0x0 0x1 0xf4 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 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 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 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 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
2023-01-02 07:56:50.124 DEBUG (MainThread) [pymodbus.factory] Factory Response[ReadHoldingRegistersResponse': 3]
2023-01-02 07:56:50.124 DEBUG (MainThread) [pymodbus.transaction] Getting transaction 19
2023-01-02 07:56:50.174 DEBUG (MainThread) [pymodbus.payload] [0, 500, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]
2023-01-02 07:56:50.175 DEBUG (MainThread) [custom_components.huawei_solar] Finished fetching TA2250041190_configuration_update_coordinator data in 3.982 seconds (success: True)
2023-01-02 07:56:50.175 DEBUG (MainThread) [huawei_solar.huawei_solar] Reading file 0x45
2023-01-02 07:56:50.175 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x14 0x0 0x0 0x0 0x5 0x0 0x41 0x5 0x1 0x45
2023-01-02 07:56:50.176 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 20
2023-01-02 07:56:53.178 INFO (MainThread) [backoff] Backing off _perform_request(...) for 10.0s (asyncio.exceptions.TimeoutError)
2023-01-02 07:56:53.178 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off file upload for 10.0 seconds after 1 tries
2023-01-02 07:56:53.437 INFO (MainThread) [custom_components.blueiris.api.blue_iris_api] Updating data from BI Server (wonderNVR)
2023-01-02 07:56:56.757 WARNING (MainThread) [zigpy.application] Unknown device AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x51B6)
2023-01-02 07:57:03.179 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x15 0x0 0x0 0x0 0x5 0x0 0x41 0x5 0x1 0x45
2023-01-02 07:57:03.180 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 21
2023-01-02 07:57:06.181 INFO (MainThread) [backoff] Backing off _perform_request(...) for 10.0s (asyncio.exceptions.TimeoutError)
2023-01-02 07:57:06.181 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off file upload for 10.0 seconds after 2 tries
2023-01-02 07:57:16.183 DEBUG (MainThread) [pymodbus.client.base] send: 0x0 0x16 0x0 0x0 0x0 0x5 0x0 0x41 0x5 0x1 0x45
2023-01-02 07:57:16.183 DEBUG (MainThread) [pymodbus.transaction] Adding transaction 22
2023-01-02 07:57:19.185 INFO (MainThread) [backoff] Backing off _perform_request(...) for 10.0s (asyncio.exceptions.TimeoutError)
2023-01-02 07:57:19.186 DEBUG (MainThread) [huawei_solar.huawei_solar] Backing off file upload for 10.0 seconds after 3 tries

@wlcrs
Copy link
Owner

wlcrs commented Jan 1, 2023

I'm still missing any clue on what error is really occurring. Is there really nothing of potential interest that appears after what you copy&pasting now? If not, can you increase the 'default' logging level to 'debug' and try again? This should create considerable amount of output.

Please also upload the diagnostics file of another integration, as this will help me to understand how the rest of your HA system looks like (version numbers of all installed dependencies)

@etamtlosz
Copy link
Author

etamtlosz commented Jan 1, 2023

OK, doing it right now.
BTW:

  1. the latest production version installs without any issues, except I can not see my optimizers.
  2. The beta version remains as initializing after the error. A reboot or delete is needed to get rid of it. In the logs this keeps popping up:
2023-01-02 08:06:20.940 DEBUG (MainThread) [pymodbus.client.tcp] Connecting.
2023-01-02 08:06:20.942 DEBUG (MainThread) [pymodbus.client.base] Client connected to modbus server
2023-01-02 08:06:20.942 INFO (MainThread) [pymodbus.client.tcp] Protocol made connection.
2023-01-02 08:06:20.943 INFO (MainThread) [pymodbus.client.tcp] Connected to 192.168.2.170:502.

Stand by for the debug logging level.

@wlcrs
Copy link
Owner

wlcrs commented Jan 1, 2023

You'll probably want to upload the home-assistant.log as a file by dragging&dropping it. This logging level will create a considerable amount of output.

FYI: I've been creating fresh HA installations and have been installing my own installer multiple times already this evening, but am unable to recreate your error for now.

@etamtlosz
Copy link
Author

etamtlosz commented Jan 1, 2023

config_entry-webostv-d1f82df05b35e29580d97318bfbd7f64.json.txt
HA log file is larger than 25MB, so I've uploaded it to GDrive. I hope there's no sensible data in it.
https://drive.google.com/file/d/xxxxxxxxxxxxxxxxxxxx/view?usp=share_link

LE: there is some sensible data, I'll delete the shared file as soon as you have it.

@wlcrs
Copy link
Owner

wlcrs commented Jan 1, 2023

I've downloaded it. Feel free to delete it from your drive again.

@etamtlosz
Copy link
Author

etamtlosz commented Jan 1, 2023

Strange thing just happened.
Had to restart HA to change the default logger level, it was a long restart - Huawei solar needed time to initialize, I have the integration up and running, unfortunately without optimizers.

Logger: homeassistant.bootstrap
Source: bootstrap.py:486
First occurred: 8:42:39 AM (1 occurrences)
Last logged: 8:42:39 AM

Waiting on integrations to complete setup: huawei_solar

Now I can provide a diag file.
config_entry-huawei_solar-f2a0b70a5f9ecfbd9e900875a68dd88d.json.txt

@etamtlosz
Copy link
Author

Forgot to attach the HA log file to the previous message.
home-assistant_2023-01-01T19-48-36.882Z.log.txt

@wlcrs
Copy link
Owner

wlcrs commented Jan 1, 2023

Ok, glad to hear that we've progressed a bit so that we can better debug the issue.

2023-01-02 08:43:12.143 ERROR (MainThread) [backoff] Giving up _perform_request(...) after 6 tries (asyncio.exceptions.TimeoutError)

The integration has to eventually give up fetching the optimizer data: even after retrying 6 times, and waiting for 10 seconds on each try for a response to occur we cannot read the optimizer information file from the inverter. Your inverter is thus not adhering to the spec that Huawei defined.

It is therefore choosing to ignore the optimizers as to not hinder the setup of the rest of the integration:

2023-01-02 08:43:12.146 INFO (MainThread) [custom_components.huawei_solar] Cannot create optimizer sensor entities as the integration has insufficient permissions. Consider enabling elevated permissions to get more optimizer data

(ignore the part in the message about insufficient permissions, not applicable in your case)

A few things to consider:

  • Do a full power cycle of your inverter. Power off your inverter completely: shut down the AC and DC side of your inverter, also power off your battery. Wait for all lights to go off (takes a minute or two). Then start it up back again. This can take up to 10 minutes.
  • Scan your inverters again. Use the 'device commissioning' part of your FusionSolar app to connect to your inverter, go to Maintenance -> Subdevice management -> click on the 'auto search' button in the optimizer list.
    (out of curiosity: are you able to correctly see your inverters in the 'device monitoring' tab of the commissioning tool before and after doing that?)

@wlcrs
Copy link
Owner

wlcrs commented Jan 1, 2023

FYI: I did not learn anything from your 85MB log. I think it is incomplete because it had not been fully flushed to disk on the moment you uploaded it. It only included 2 retries instead of the 3 that you uploaded with your previous log excerpts.

I've thus removed it from my disk again, as I don't want to store any of your -potentially- sensitive data for longer than necessary.

@etamtlosz
Copy link
Author

I did restart the whole system, ran the subdevice discovery and the 4 optimizers I have have been rediscovered, but they didn't show up in HA. So I removed the integration, added again, but Now I can't get the inverter discovered into HA, not even after a restart.

PS
I can see the inverter under device commissioning and the optimizers too, in the app.

@wlcrs
Copy link
Owner

wlcrs commented Jan 2, 2023

I slept on the problem for a night, and found that it probably is a bug introduced in the major version upgrade of pyModbus.

This will be tough to find the root cause, so I'll potentially have to revert that upgrade.

@etamtlosz
Copy link
Author

Good morning. I had to revert to 1.1.6 to be able to run my automations that control the maximum charging power.
If there's any way I can help, let me know. I'll be available in ~9hours.

@wlcrs wlcrs mentioned this issue Jan 4, 2023
4 tasks
wlcrs added a commit to wlcrs/huawei-solar-lib that referenced this issue Jan 5, 2023
@wlcrs
Copy link
Owner

wlcrs commented Jan 5, 2023

I found the root cause: the slave id was not passed correctly when retrieving the optimizer data. This caused it to default to slave_id 0 (which works for many people, including me).

Can you try again with 1.2.0b7?

@etamtlosz
Copy link
Author

Updated to b7 and got connected after the restart. All the devices are there AFAIK.
At the moment I'm not at home, to confirm that everything is spot on, but I'll be back in a few hours, do some test and hopefully I'm going to close this issue/bug.

@etamtlosz
Copy link
Author

Closing it now.
1.2.0b7 solved this issue. I tested on two different PV systems and everything works perfect.
Thanks for the help and time you invest into this integration.

@wlcrs
Copy link
Owner

wlcrs commented Jan 7, 2023

🎉

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
bug Something isn't working
Projects
None yet
Development

No branches or pull requests

2 participants