evcc-io / evcc

Sonne tanken ☀️🚘
https://evcc.io
MIT License
3.52k stars 651 forks source link

Solax RCP read failure #13718

Closed longtom99 closed 6 months ago

longtom99 commented 6 months ago

evcc-20240503-163350-debug.log

Describe the bug

Since upgrade to 126.1 i had this issue the first time! PV production is not displayed.

Steps to reproduce

Just see log.

Configuration details

Standard Alfen Wallbox integration

Log details

[lp-1 ] DEBUG 2024/05/03 15:51:41 charge power: 1366W
[lp-1 ] DEBUG 2024/05/03 15:51:41 charge currents: [5.99 0 0]A
[site ] ERROR 2024/05/03 15:51:51 pv 1 power: add[0]: read failed: read tcp 192.168.1.209:49634->192.168.90.99:502: i/o timeout
[site ] DEBUG 2024/05/03 15:51:51 pv power: 0W
[site ] DEBUG 2024/05/03 15:51:51 grid meter: -307W
[site ] DEBUG 2024/05/03 15:51:51 site power: -307W
[lp-1 ] DEBUG 2024/05/03 15:51:51 charge total import: 2716.064kWh
[lp-1 ] DEBUG 2024/05/03 15:51:51 charger status: C
[lp-1 ] DEBUG 2024/05/03 15:51:51 charge start energy: 2.72e+03kWh
[lp-1 ] INFO 2024/05/03 15:51:51 start charging ->
[lp-1 ] DEBUG 2024/05/03 15:51:51 wake-up timer: stop
[lp-1 ] DEBUG 2024/05/03 15:51:51 soc estimated: 35.20% (vehicle: 34.00%)
[lp-1 ] DEBUG 2024/05/03 15:51:51 vehicle soc: 35%
[lp-1 ] DEBUG 2024/05/03 15:51:51 vehicle soc limit: 80%
[lp-1 ] DEBUG 2024/05/03 15:51:51 vehicle range: 129km
[lp-1 ] DEBUG 2024/05/03 15:51:51 pv charge current: 7.33A = 6A + 1.33A (-307W @ 1p)
[lp-1 ] DEBUG 2024/05/03 15:51:51 pv timer reset
[lp-1 ] DEBUG 2024/05/03 15:51:51 pv timer inactive
[lp-1 ] DEBUG 2024/05/03 15:51:51 max charge current: 7.33A
[site ] DEBUG 2024/05/03 15:52:11 ----
[lp-1 ] DEBUG 2024/05/03 15:52:11 charge power: 1622W
[lp-1 ] DEBUG 2024/05/03 15:52:11 charge currents: [7.1 0 0]A
[site ] DEBUG 2024/05/03 15:52:12 pv power: 2791W
[site ] DEBUG 2024/05/03 15:52:14 grid meter: -26W
[site ] DEBUG 2024/05/03 15:52:14 site power: -26W
[lp-1 ] DEBUG 2024/05/03 15:52:14 detected active phases: 1p
[lp-1 ] DEBUG 2024/05/03 15:52:14 charge total import: 2716.075kWh
[lp-1 ] DEBUG 2024/05/03 15:52:14 charger status: C
[lp-1 ] DEBUG 2024/05/03 15:52:14 soc estimated: 35.21% (vehicle: 34.00%)
[lp-1 ] DEBUG 2024/05/03 15:52:14 vehicle soc: 35%
[lp-1 ] DEBUG 2024/05/03 15:52:14 vehicle soc limit: 80%
[lp-1 ] DEBUG 2024/05/03 15:52:14 vehicle range: 129km
[lp-1 ] DEBUG 2024/05/03 15:52:14 pv charge current: 7.45A = 7.33A + 0.113A (-26W @ 1p)
[lp-1 ] DEBUG 2024/05/03 15:52:14 max charge current: 7.45A
[site ] DEBUG 2024/05/03 15:52:41 ----
[lp-1 ] DEBUG 2024/05/03 15:52:41 charge power: 1652W
[lp-1 ] DEBUG 2024/05/03 15:52:41 charge currents: [7.23 0 0]A
[site ] ERROR 2024/05/03 15:52:51 pv 1 power: add[0]: read failed: read tcp 192.168.1.209:47588->192.168.90.99:502: i/o timeout
[site ] DEBUG 2024/05/03 15:52:51 pv power: 0W
[site ] DEBUG 2024/05/03 15:52:51 grid meter: 19W
[site ] DEBUG 2024/05/03 15:52:51 site power: 19W
[lp-1 ] DEBUG 2024/05/03 15:52:51 detected active phases: 1p
[lp-1 ] DEBUG 2024/05/03 15:52:51 charge total import: 2716.092kWh
[lp-1 ] DEBUG 2024/05/03 15:52:51 charger status: C
[lp-1 ] DEBUG 2024/05/03 15:52:51 soc estimated: 35.23% (vehicle: 34.00%)
[lp-1 ] DEBUG 2024/05/03 15:52:51 vehicle soc: 35%
[lp-1 ] DEBUG 2024/05/03 15:52:51 vehicle soc limit: 80%
[lp-1 ] DEBUG 2024/05/03 15:52:51 vehicle range: 129km
[lp-1 ] DEBUG 2024/05/03 15:52:51 pv charge current: 7.37A = 7.45A + -0.0826A (19W @ 1p)
[lp-1 ] DEBUG 2024/05/03 15:52:52 max charge current: 7.37A
[site ] DEBUG 2024/05/03 15:53:11 ----
[lp-1 ] DEBUG 2024/05/03 15:53:11 charge power: 1653W
[lp-1 ] DEBUG 2024/05/03 15:53:11 charge currents: [7.21 0 0]A
[site ] DEBUG 2024/05/03 15:53:12 pv power: 2778W
[site ] DEBUG 2024/05/03 15:53:14 grid meter: 42W
[site ] DEBUG 2024/05/03 15:53:14 site power: 42W
[lp-1 ] DEBUG 2024/05/03 15:53:14 detected active phases: 1p
[lp-1 ] DEBUG 2024/05/03 15:53:14 charge total import: 2716.103kWh
[lp-1 ] DEBUG 2024/05/03 15:53:14 charger status: C
[lp-1 ] DEBUG 2024/05/03 15:53:14 soc estimated: 35.24% (vehicle: 34.00%)
[lp-1 ] DEBUG 2024/05/03 15:53:14 vehicle soc: 35%
[lp-1 ] DEBUG 2024/05/03 15:53:14 vehicle soc limit: 80%
[lp-1 ] DEBUG 2024/05/03 15:53:14 vehicle range: 129km
[lp-1 ] DEBUG 2024/05/03 15:53:14 pv charge current: 7.18A = 7.37A + -0.183A (42W @ 1p)
[lp-1 ] DEBUG 2024/05/03 15:53:14 max charge current: 7.18A
[site ] DEBUG 2024/05/03 15:53:41 ----
[lp-1 ] DEBUG 2024/05/03 15:53:41 charge power: 1584W
[lp-1 ] DEBUG 2024/05/03 15:53:41 charge currents: [6.93 0 0]A
[site ] ERROR 2024/05/03 15:53:51 pv 1 power: add[0]: read failed: read tcp 192.168.1.209:47732->192.168.90.99:502: i/o timeout
[site ] DEBUG 2024/05/03 15:53:51 pv power: 0W
[site ] DEBUG 2024/05/03 15:53:51 grid meter: -29W
[site ] DEBUG 2024/05/03 15:53:51 site power: -29W
[lp-1 ] DEBUG 2024/05/03 15:53:51 detected active phases: 1p
[lp-1 ] DEBUG 2024/05/03 15:53:51 charge total import: 2716.119kWh
[lp-1 ] DEBUG 2024/05/03 15:53:51 charger status: C
[lp-1 ] DEBUG 2024/05/03 15:53:51 soc estimated: 35.26% (vehicle: 34.00%)
[lp-1 ] DEBUG 2024/05/03 15:53:51 vehicle soc: 35%
[lp-1 ] DEBUG 2024/05/03 15:53:51 vehicle soc limit: 80%
[lp-1 ] DEBUG 2024/05/03 15:53:51 vehicle range: 129km
[lp-1 ] DEBUG 2024/05/03 15:53:51 pv charge current: 7.31A = 7.18A + 0.126A (-29W @ 1p)
[lp-1 ] DEBUG 2024/05/03 15:53:52 max charge current: 7.31A
[site ] DEBUG 2024/05/03 15:54:11 ----
[lp-1 ] DEBUG 2024/05/03 15:54:11 charge power: 1604W
[lp-1 ] DEBUG 2024/05/03 15:54:11 charge currents: [7.02 0 0]A
[site ] DEBUG 2024/05/03 15:54:12 pv power: 2768W
[site ] DEBUG 2024/05/03 15:54:14 grid meter: 3W
[site ] DEBUG 2024/05/03 15:54:14 site power: 3W
[lp-1 ] DEBUG 2024/05/03 15:54:14 detected active phases: 1p
[lp-1 ] DEBUG 2024/05/03 15:54:14 charge total import: 2716.129kWh
[lp-1 ] DEBUG 2024/05/03 15:54:14 charger status: C
[lp-1 ] DEBUG 2024/05/03 15:54:14 soc estimated: 35.27% (vehicle: 34.00%)
[lp-1 ] DEBUG 2024/05/03 15:54:14 vehicle soc: 35%
[lp-1 ] DEBUG 2024/05/03 15:54:14 vehicle soc limit: 80%
[lp-1 ] DEBUG 2024/05/03 15:54:14 vehicle range: 129km
[lp-1 ] DEBUG 2024/05/03 15:54:14 pv charge current: 7.3A = 7.31A + -0.013A (3W @ 1p)
[lp-1 ] DEBUG 2024/05/03 15:54:14 max charge current: 7.3A
[site ] DEBUG 2024/05/03 15:54:41 ----
[lp-1 ] DEBUG 2024/05/03 15:54:41 charge power: 1609W
[lp-1 ] DEBUG 2024/05/03 15:54:41 charge currents: [7.03 0 0]A
[site ] ERROR 2024/05/03 15:54:51 pv 1 power: add[0]: read failed: read tcp 192.168.1.209:47878->192.168.90.99:502: i/o timeout
[site ] DEBUG 2024/05/03 15:54:51 pv power: 0W
[site ] DEBUG 2024/05/03 15:54:51 grid meter: -6W
[site ] DEBUG 2024/05/03 15:54:51 site power: -6W
[lp-1 ] DEBUG 2024/05/03 15:54:51 detected active phases: 1p
[lp-1 ] DEBUG 2024/05/03 15:54:51 charge total import: 2716.146kWh
[lp-1 ] DEBUG 2024/05/03 15:54:51 charger status: C
[lp-1 ] DEBUG 2024/05/03 15:54:51 soc estimated: 35.29% (vehicle: 34.00%)
[lp-1 ] DEBUG 2024/05/03 15:54:51 vehicle soc: 35%
[lp-1 ] DEBUG 2024/05/03 15:54:51 vehicle soc limit: 80%
[lp-1 ] DEBUG 2024/05/03 15:54:51 vehicle range: 129km
[lp-1 ] DEBUG 2024/05/03 15:54:51 pv charge current: 7.32A = 7.3A + 0.0261A (-6W @ 1p)
[lp-1 ] DEBUG 2024/05/03 15:54:52 max charge current: 7.32A
[site ] DEBUG 2024/05/03 15:55:11 ----
[lp-1 ] DEBUG 2024/05/03 15:55:11 charge power: 1607W
[lp-1 ] DEBUG 2024/05/03 15:55:11 charge currents: [7.02 0 0]A
[site ] ERROR 2024/05/03 15:55:21 pv 1 power: add[0]: read failed: read tcp 192.168.1.209:48016->192.168.90.99:502: i/o timeout
[site ] DEBUG 2024/05/03 15:55:21 pv power: 0W
[site ] DEBUG 2024/05/03 15:55:21 grid meter: -12W
[site ] DEBUG 2024/05/03 15:55:21 site power: -12W
[lp-1 ] DEBUG 2024/05/03 15:55:21 detected active phases: 1p
[lp-1 ] DEBUG 2024/05/03 15:55:21 charge total import: 2716.159kWh
[lp-1 ] DEBUG 2024/05/03 15:55:21 charger status: C
[lp-1 ] DEBUG 2024/05/03 15:55:21 soc estimated: 35.31% (vehicle: 34.00%)
[lp-1 ] DEBUG 2024/05/03 15:55:21 vehicle soc: 35%
[lp-1 ] DEBUG 2024/05/03 15:55:21 vehicle soc limit: 80%
[lp-1 ] DEBUG 2024/05/03 15:55:21 vehicle range: 129km
[lp-1 ] DEBUG 2024/05/03 15:55:21 pv charge current: 7.37A = 7.32A + 0.0522A (-12W @ 1p)
[lp-1 ] DEBUG 2024/05/03 15:55:22 max charge current: 7.37A
[site ] DEBUG 2024/05/03 15:55:41 ----
[lp-1 ] DEBUG 2024/05/03 15:55:41 charge power: 1606W
[lp-1 ] DEBUG 2024/05/03 15:55:41 charge currents: [7.02 0 0]A
[site ] ERROR 2024/05/03 15:55:51 pv 1 power: add[0]: read failed: read tcp 192.168.1.209:48086->192.168.90.99:502: i/o timeout
[site ] DEBUG 2024/05/03 15:55:51 pv power: 0W
[site ] DEBUG 2024/05/03 15:55:51 grid meter: -14W
[site ] DEBUG 2024/05/03 15:55:51 site power: -14W
[lp-1 ] DEBUG 2024/05/03 15:55:51 detected active phases: 1p
[lp-1 ] DEBUG 2024/05/03 15:55:51 charge total import: 2716.172kWh
[lp-1 ] DEBUG 2024/05/03 15:55:51 charger status: C
[lp-1 ] DEBUG 2024/05/03 15:55:51 soc estimated: 35.32% (vehicle: 34.00%)
[lp-1 ] DEBUG 2024/05/03 15:55:51 vehicle soc: 35%
[lp-1 ] DEBUG 2024/05/03 15:55:51 vehicle soc limit: 80%
[lp-1 ] DEBUG 2024/05/03 15:55:51 vehicle range: 129km
[lp-1 ] DEBUG 2024/05/03 15:55:51 pv charge current: 7.43A = 7.37A + 0.0609A (-14W @ 1p)
[lp-1 ] DEBUG 2024/05/03 15:55:52 max charge current: 7.43A
[site ] DEBUG 2024/05/03 15:56:11 ----
[lp-1 ] DEBUG 2024/05/03 15:56:11 charge power: 1654W
[lp-1 ] DEBUG 2024/05/03 15:56:11 charge currents: [7.23 0 0]A
[site ] ERROR 2024/05/03 15:56:21 pv 1 power: add[0]: read failed: read tcp 192.168.1.209:48158->192.168.90.99:502: i/o timeout
[site ] DEBUG 2024/05/03 15:56:21 pv power: 0W
[site ] DEBUG 2024/05/03 15:56:21 grid meter: 19W
[site ] DEBUG 2024/05/03 15:56:21 site power: 19W
[lp-1 ] DEBUG 2024/05/03 15:56:21 detected active phases: 1p
[lp-1 ] DEBUG 2024/05/03 15:56:21 charge total import: 2716.186kWh
[lp-1 ] DEBUG 2024/05/03 15:56:21 charger status: C
[lp-1 ] DEBUG 2024/05/03 15:56:21 soc estimated: 35.34% (vehicle: 34.00%)
[lp-1 ] DEBUG 2024/05/03 15:56:21 vehicle soc: 35%
[lp-1 ] DEBUG 2024/05/03 15:56:21 vehicle soc limit: 80%
[lp-1 ] DEBUG 2024/05/03 15:56:21 vehicle range: 129km
[lp-1 ] DEBUG 2024/05/03 15:56:21 pv charge current: 7.35A = 7.43A + -0.0826A (19W @ 1p)
[lp-1 ] DEBUG 2024/05/03 15:56:22 max charge current: 7.35A
[site ] DEBUG 2024/05/03 15:56:41 ----
[lp-1 ] DEBUG 2024/05/03 15:56:41 charge power: 1655W
[lp-1 ] DEBUG 2024/05/03 15:56:41 charge currents: [7.22 0 0]A
[site ] ERROR 2024/05/03 15:56:51 pv 1 power: add[0]: read failed: read tcp 192.168.1.209:48226->192.168.90.99:502: i/o timeout
[site ] DEBUG 2024/05/03 15:56:51 pv power: 0W
[site ] DEBUG 2024/05/03 15:56:51 grid meter: 24W
[site ] DEBUG 2024/05/03 15:56:51 site power: 24W
[lp-1 ] DEBUG 2024/05/03 15:56:51 detected active phases: 1p
[lp-1 ] DEBUG 2024/05/03 15:56:51 charge total import: 2716.200kWh
[lp-1 ] DEBUG 2024/05/03 15:56:51 charger status: C
[lp-1 ] DEBUG 2024/05/03 15:56:51 soc estimated: 35.35% (vehicle: 34.00%)
[lp-1 ] DEBUG 2024/05/03 15:56:51 vehicle soc: 35%
[lp-1 ] DEBUG 2024/05/03 15:56:51 vehicle soc limit: 80%
[lp-1 ] DEBUG 2024/05/03 15:56:51 vehicle range: 129km
[lp-1 ] DEBUG 2024/05/03 15:56:51 pv charge current: 7.25A = 7.35A + -0.104A (24W @ 1p)
[lp-1 ] DEBUG 2024/05/03 15:56:52 max charge current: 7.25A
[site ] DEBUG 2024/05/03 15:57:11 ----
[lp-1 ] DEBUG 2024/05/03 15:57:11 charge power: 1608W
[lp-1 ] DEBUG 2024/05/03 15:57:11 charge currents: [7.02 0 0]A
[site ] ERROR 2024/05/03 15:57:21 pv 1 power: add[0]: read failed: read tcp 192.168.1.209:48324->192.168.90.99:502: i/o timeout
[site ] DEBUG 2024/05/03 15:57:21 pv power: 0W
[site ] DEBUG 2024/05/03 15:57:21 grid meter: -3W
[site ] DEBUG 2024/05/03 15:57:21 site power: -3W
[lp-1 ] DEBUG 2024/05/03 15:57:21 detected active phases: 1p
[lp-1 ] DEBUG 2024/05/03 15:57:21 charge total import: 2716.213kWh
[lp-1 ] DEBUG 2024/05/03 15:57:21 charger status: C
[lp-1 ] DEBUG 2024/05/03 15:57:21 soc estimated: 35.37% (vehicle: 34.00%)
[lp-1 ] DEBUG 2024/05/03 15:57:21 vehicle soc: 35%
[lp-1 ] DEBUG 2024/05/03 15:57:21 vehicle soc limit: 80%
[lp-1 ] DEBUG 2024/05/03 15:57:21 vehicle range: 129km
[lp-1 ] DEBUG 2024/05/03 15:57:21 pv charge current: 7.26A = 7.25A + 0.013A (-3W @ 1p)
[lp-1 ] DEBUG 2024/05/03 15:57:22 max charge current: 7.26A
[site ] DEBUG 2024/05/03 15:57:41 ----
[lp-1 ] DEBUG 2024/05/03 15:57:41 charge power: 1614W
[lp-1 ] DEBUG 2024/05/03 15:57:41 charge currents: [7.03 0 0]A
[site ] ERROR 2024/05/03 15:57:51 pv 1 power: add[0]: read failed: read tcp 192.168.1.209:48396->192.168.90.99:502: i/o timeout
[site ] DEBUG 2024/05/03 15:57:51 pv power: 0W
[site ] DEBUG 2024/05/03 15:57:51 grid meter: 29W
[site ] DEBUG 2024/05/03 15:57:51 site power: 29W
[lp-1 ] DEBUG 2024/05/03 15:57:51 detected active phases: 1p
[lp-1 ] DEBUG 2024/05/03 15:57:51 charge total import: 2716.227kWh
[lp-1 ] DEBUG 2024/05/03 15:57:51 charger status: C
[lp-1 ] DEBUG 2024/05/03 15:57:51 soc estimated: 35.39% (vehicle: 34.00%)
[lp-1 ] DEBUG 2024/05/03 15:57:51 vehicle soc: 35%
[lp-1 ] DEBUG 2024/05/03 15:57:51 vehicle soc limit: 80%
[lp-1 ] DEBUG 2024/05/03 15:57:51 vehicle range: 129km
[lp-1 ] DEBUG 2024/05/03 15:57:51 pv charge current: 7.13A = 7.26A + -0.126A (29W @ 1p)
[lp-1 ] DEBUG 2024/05/03 15:57:52 max charge current: 7.13A

What type of operating system are you running?

Linux

Version

0.126.1

longtom99 commented 6 months ago

Standard Solax and Alfen Eve integration

mdkeil commented 6 months ago

Greifst Du noch mit einem anderen Tool parallel auf die Modbus-Schnittstelle zu?

longtom99 commented 6 months ago

Nein, nicht per Modbus-TCP der vom Solax WLAN-Dongle kommt. Ich greife direkt Modbus-RTU vom Solax WR über die RS485 Com-Schnittstelle für Loxone ab.

mdkeil commented 6 months ago

Ist ggfs. der WLAN-Empfang gestört?-- Der i/o timeout kommt ja nicht immer..

Poste aber bitte dennoch mal deine config, so wie es standard-mäßig bei einem issue gefordert ist. Ist Dir dieses Verhalten schon bei einer vorherigen Version aufgefallen?

mdkeil commented 6 months ago

Was mich wundert (kann aber Zufall sein), wenn ich mir das gesamte Log anschaue, dass es erst auftritt, nachdem der Ladevorgang gestartet wurde.

longtom99 commented 6 months ago

Ist mir heute das erste Mal richtig aufgefallen, lade aber erst seit 22.4. mit evcc und habe es am 1.5. auf Synology/Docker von VMware/debian portiert. WLAN Signal ist gut, Sender ist direkt darüber. evvc.yaml hier (vin maskiert):

` meters:

chargers:

vehicles:

loadpoints:

site: title: Zaus meters: grid: netz pv:

andig commented 6 months ago

IO timeout hat immer Netzwerk oder Gerät zur Ursache. Da können wir nix machen.

longtom99 commented 6 months ago

Ok, Danke! Werde es weiter beobachten.