Querying [3 - 128] failed with exception [IllegalDataValueError]

[lenwar]

Hi,

I have a few microinverters which used to work with the 2mptt yaml file. Since a few days they no longer work and provide the following error:

2023-08-13 17:10:37.318 DEBUG (SyncWorker_2) [pysolarmanv5.pysolarmanv5] Socket setup completed... <socket.socket fd=27, family=2, type=1, proto=6, laddr=('192.168.xxx.yyy', 60194), raddr=('192.168.yyy.zzz', 8899)> 2023-08-13 17:10:37.318 WARNING (SyncWorker_2) [custom_components.solarman.solarman] Querying [3 - 128] failed with exception [IllegalDataValueError] 2023-08-13 17:10:37.321 WARNING (SyncWorker_2) [custom_components.solarman.solarman] Querying [3 - 128] failed, [5] retry attempts left 2023-08-13 17:10:37.323 WARNING (SyncWorker_2) [custom_components.solarman.solarman] Querying [3 - 128] failed with exception [IllegalDataValueError] 2023-08-13 17:10:37.325 WARNING (SyncWorker_2) [custom_components.solarman.solarman] Querying [3 - 128] failed, [4] retry attempts left 2023-08-13 17:10:37.327 WARNING (SyncWorker_2) [custom_components.solarman.solarman] Querying [3 - 128] failed with exception [IllegalDataValueError] 2023-08-13 17:10:37.329 WARNING (SyncWorker_2) [custom_components.solarman.solarman] Querying [3 - 128] failed, [3] retry attempts left 2023-08-13 17:10:37.331 WARNING (SyncWorker_2) [custom_components.solarman.solarman] Querying [3 - 128] failed with exception [IllegalDataValueError] 2023-08-13 17:10:37.332 WARNING (SyncWorker_2) [custom_components.solarman.solarman] Querying [3 - 128] failed, [2] retry attempts left 2023-08-13 17:10:37.333 WARNING (SyncWorker_2) [custom_components.solarman.solarman] Querying [3 - 128] failed with exception [IllegalDataValueError] 2023-08-13 17:10:37.336 WARNING (SyncWorker_2) [custom_components.solarman.solarman] Querying [3 - 128] failed, [1] retry attempts left 2023-08-13 17:10:37.338 WARNING (SyncWorker_2) [custom_components.solarman.solarman] Querying [3 - 128] failed with exception [IllegalDataValueError] 2023-08-13 17:10:37.339 WARNING (SyncWorker_2) [custom_components.solarman.solarman] Querying [3 - 128] failed, [0] retry attempts left 2023-08-13 17:10:37.340 WARNING (SyncWorker_2) [custom_components.solarman.solarman] Querying registers [3 - 128] failed, aborting

I really haven’t a clue where to start looking. I updated to the latest ‘Main’. (I was back an x-number of versions of the ‘Main’. I don’t know which moment did work)

Edit: I ‘downgraded’ to 1.4.3. I made a copy of the current deye_mppt2.yaml from Github and copied it to custom_parameters.yaml adjusted my configurations to use that file.

It works now for me, but the current Main does not.

[Kolbi]

Working for me again, why do you think it's not a fix?

because there is more then that. you didn't read the debug message?! sure, the registers are fixed.. but not the whole issue ppl reporting here.

Ah no not yet. Will have a look into it. Just fixed my issue with no data :)

[Kolbi]

I don't see any "relevant" loglines for solarman.

2023-09-08 16:33:50.712 DEBUG (SyncWorker_5) [custom_components.solarman.solarman] Starting to query for [1] ranges... 2023-09-08 16:33:50.712 DEBUG (SyncWorker_5) [custom_components.solarman.solarman] Querying [1 - 125]... 2023-09-08 16:33:50.712 DEBUG (SyncWorker_5) [custom_components.solarman.solarman] SENT: 2023-09-08 16:33:51.105 DEBUG (SyncWorker_5) [custom_components.solarman.solarman] RECD: 2023-09-08 16:33:51.105 DEBUG (SyncWorker_5) [custom_components.solarman.solarman] Querying [1 - 125] succeeded 2023-09-08 16:33:51.105 DEBUG (SyncWorker_5) [custom_components.solarman.solarman] All queries succeeded, exposing updated values. 2023-09-08 16:34:20.713 DEBUG (SyncWorker_4) [custom_components.solarman.solarman] Starting to query for [1] ranges... 2023-09-08 16:34:20.713 DEBUG (SyncWorker_4) [custom_components.solarman.solarman] Querying [1 - 125]... 2023-09-08 16:34:20.713 DEBUG (SyncWorker_4) [custom_components.solarman.solarman] SENT: 2023-09-08 16:34:21.049 DEBUG (SyncWorker_4) [custom_components.solarman.solarman] RECD: 2023-09-08 16:34:21.049 DEBUG (SyncWorker_4) [custom_components.solarman.solarman] Querying [1 - 125] succeeded 2023-09-08 16:34:21.049 DEBUG (SyncWorker_4) [custom_components.solarman.solarman] All queries succeeded, exposing updated values.

[oxynatOr]

for example...

2023-09-08 12:13:49.419 DEBUG (SyncWorker_9) [custom_components.solarman.solarman] SENT: a5 17 00 10 45 17 00 b1 56 8c f7 02 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01 03 00 01 00 7d d4 2b 90 15
2023-09-08 12:13:49.527 DEBUG (SyncWorker_9) [custom_components.solarman.solarman] RECD: 41 54 2b 59 5a 43 4d 50 56 45 52 3d 4d 57 33 5f 31 36 55 5f 35 34 30 36 5f 32 2e 32 37 0d 0a 0d 0a

and

2023-09-06 10:05:41.340 DEBUG (SyncWorker_9) [custom_components.solarman.solarman] All queries succeeded, exposing updated values.
2023-09-06 10:06:09.708 DEBUG (Thread-15 (_data_receiver)) [custom_components.solarman.solarman] [POLL-DISCARDED] RECD: 41 54 2b 59 5a 43 4d 50 56 45 52 3d 4d 57 33 5f 31 36 55 5f 35 34 30 36 5f 32 2e 30 36 0d 0a 0d 0a
2023-09-06 10:06:10.132 DEBUG (Thread-15 (_data_receiver)) [custom_components.solarman.solarman] [POLL-DISCARDED] RECD: a5 0f 01 10 15 00 38 d0 99 4f e9 02 01 e8 b2 07 00 3c 03 00 00 09 80 f0 64 01 03 fc 32 33 30 34 32 33 33 32 35 39 00 01 00 00 12 0c 07 00 01 02 01 17 12 18 00 00 1f 40 00 00 02 01 00 4b 00 00 00 3c 17 09 06 0a 03 0e 00 00 00 00 0a be 07 08 14 50 12 8e 00 00 00 00 00 00 13 9c 00 2c 00 00 00 00 00 00 00 00 00 64 00 00 00 00 00 01 00 00 00 00 00 01 00 00 00 00 00 01 ff d5 00 00 00 0a 00 02 00 00 00 00 00 00 00 00 00 00 00 04 00 08 00 00 00 00 01 2f 00 00 00 04 00 04 00 00 00 00 00 94 00 00 00 94 00 00 09 4c 00 00 00 00 00 18 00 00 00 00 13 88 00 00 00 00 00 00 00 00 00 00 00 00 16 a8 00 00 00 00 00 00 15 5e 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01 dd 00 3d 01 e0 00 3b 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 04 b6 f7 15
2023-09-06 10:06:10.562 DEBUG (Thread-15 (_data_receiver)) [custom_components.solarman.solarman] [POLL-DISCARDED] RECD: a5 0f 01 10 15 00 39 d0 99 4f e9 02 01 e8 b2 07 00 3d 03 00 00 09 80 f0 64 01 03 fc 32 33 30 34 32 33 33 32 35 39 00 01 00 00 12 0c 07 00 01 02 01 17 12 18 00 00 1f 40 00 00 02 01 00 4b 00 00 00 3c 17 09 06 0a 03 0e 00 00 00 00 0a be 07 08 14 50 12 8e 00 00 00 00 00 00 13 9c 00 2c 00 00 00 00 00 00 00 00 00 64 00 00 00 00 00 01 00 00 00 00 00 01 00 00 00 00 00 01 ff d5 00 00 00 0a 00 02 00 00 00 00 00 00 00 00 00 00 00 04 00 08 00 00 00 00 01 2f 00 00 00 04 00 04 00 00 00 00 00 94 00 00 00 94 00 00 09 4c 00 00 00 00 00 18 00 00 00 00 13 88 00 00 00 00 00 00 00 00 00 00 00 00 16 a8 00 00 00 00 00 00 15 5e 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01 dd 00 3d 01 e0 00 3b 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 04 b6 f9 15

or

2023-09-06 15:08:32.313 DEBUG (SyncWorker_1) [custom_components.solarman.solarman] frame_len does not match payload_len.
2023-09-06 15:08:32.313 WARNING (SyncWorker_1) [custom_components.solarman.solarman] Querying 1 - 125 - failed with exception :V5FrameError: V5 frame contains invalid start or end values

i'm still collecting debug Information, that why i ask all the ppl to post it.

indeed, the message is gone, or better lead us to the next issues

pls get me right, i'm happy that more dev join here.

[stvogel]

So I'm using the prefix

start: 0x0001
end: 0x007D
mb_functioncode: 0x03

in deye_2mppt.yaml

And I got a clear log like this:

2023-09-09 07:56:29.847 DEBUG (SyncWorker_2) [pysolarmanv5.pysolarmanv5] Socket setup completed... <socket.socket fd=27, family=2, type=1, proto=6, laddr=('192.yyyy', 54960), raddr=('192.xxxxx', 8899)>
2023-09-09 07:56:29.848 DEBUG (SyncWorker_2) [pysolarmanv5.pysolarmanv5] SENT: a5 17 00 10 45 6e 00 03 71 f3 ea 02 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01 03 00 03 00 7b f5 e9 8d 15
2023-09-09 07:56:30.174 DEBUG (SyncWorker_2) [pysolarmanv5.pysolarmanv5] RECD: a5 09 01 10 15 6e ba 03 71 f3 ea 02 01 b1 cf 37 00 9e 0f 00 00 5b 39 c4 64 01 03 f6 32 33 30 35 31 32 33 30 31 32 00 01 00 00 12 0c 07 00 01 02 01 17 12 18 00 00 1f 40 00 00 02 01 00 4b 00 00 00 3c 17 09 09 07 34 07 00 00 00 00 0a be 07 08 14 50 12 8e 00 00 00 00 00 00 13 9c 00 2c 00 00 00 00 00 00 00 00 00 49 00 00 00 00 00 01 00 00 00 00 00 01 00 00 00 00 00 01 ff d5 00 00 00 0a 00 02 00 00 00 00 00 00 00 00 00 00 00 04 00 00 00 00 00 00 08 0c 00 00 00 00 00 00 00 00 00 00 03 fd 00 00 03 dd 00 00 09 38 00 00 00 00 00 00 00 00 00 00 13 88 00 00 00 00 00 00 00 00 00 00 00 00 00 b4 00 00 00 00 00 00 09 f6 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01 3c 00 02 01 48 00 02 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 69 d9 ac 15

Only once in a while:

2023-09-09 07:56:09.834 WARNING (MainThread) [homeassistant.helpers.entity] Update of sensor.solarman_pv1_voltage is taking over 10 seconds

I got one Home Assistant running and a Deye SUN-M80G3-EU-Q0 with two panels. Everything's fine. Well ok, "Running Status" is always "Fault"

[matthiaskind]

Der Einwand mit der FW, kann ich ggf später / morgen prüfen. Da man die 2.27 nicht downloaden kann, vom FW-Server. Muss ich auf den Kollegen warten, der einen deye M80 mit diesem Relais bekommt.

Es gibt inzwischen die 2.30 und 2.31, die werden vermutlich ähnlich zur 2.27 sein und man kann sie vom FW-Server downloaden.

[oxynatOr]

Der Einwand mit der FW, kann ich ggf später / morgen prüfen. Da man die 2.27 nicht downloaden kann, vom FW-Server. Muss ich auf den Kollegen warten, der einen deye M80 mit diesem Relais bekommt.

Es gibt inzwischen die 2.30 und 2.31, die werden vermutlich ähnlich zur 2.27 sein und man kann sie vom FW-Server downloaden.

danke für die info

[lenwar]

Hi,

Final update. Version 1.5.1 has resolved the issue for me. This version contains the updated files that you guys had conjured up!

My sincere thanks to all that spend so much time and effort in resolving this!!