Feedback Nightly 101.1

[Gero]

Bitte das Debuglevel auf Details stellen und einen kompletten Durchlauf von # ***Start*** bis # ***Start*** aus dem main.log posten, wenn der Fehler auftritt. Sensible Daten wie Benutzernamen und Kennwörter unkenntlich machen.

Ist schon "Detail". Aktuell finde ich noch nicht mal ein ***Start, der letzte war gestern um kurz nach drei: Interessant ist ja auch, dass es zwischen 23:55 und heute früh kurz vor Zehn keine Log-Einträge gibt.

Doch mal neu installieren? Falls ja, reicht drüberinstallieren oder erst ein rm -r /var/www/html/openWB machen?

Code: Alles auswählen

2023-03-30 23:45:00,938 - {helpermodules.setdata:290} - {ERROR:Thread-6} - Payload ungültig: Topic openWB/set/pv/2/get/daily_exported, Payload -163483.846 liegt in keinem der angegebenen Wertebereiche.
2023-03-30 23:45:00,939 - {helpermodules.setdata:290} - {ERROR:Thread-6} - Payload ungültig: Topic openWB/set/counter/set/daily_yield_home_consumption, Payload -348073.93061751977 liegt in keinem der angegebenen Wertebereiche.
2023-03-30 23:50:00,885 - {helpermodules.setdata:290} - {ERROR:Thread-6} - Payload ungültig: Topic openWB/set/bat/3/get/daily_imported, Payload -79428.98 liegt in keinem der angegebenen Wertebereiche.
2023-03-30 23:50:00,887 - {helpermodules.setdata:290} - {ERROR:Thread-6} - Payload ungültig: Topic openWB/set/bat/3/get/daily_exported, Payload -77959.67 liegt in keinem der angegebenen Wertebereiche.
2023-03-30 23:50:00,890 - {helpermodules.setdata:290} - {ERROR:Thread-6} - Payload ungültig: Topic openWB/set/counter/0/get/daily_imported, Payload -70010.91269578754 liegt in keinem der angegebenen Wertebereiche.
2023-03-30 23:50:00,892 - {helpermodules.setdata:290} - {ERROR:Thread-6} - Payload ungültig: Topic openWB/set/counter/0/get/daily_exported, Payload -29069.8683804701 liegt in keinem der angegebenen Wertebereiche.
2023-03-30 23:50:00,902 - {helpermodules.setdata:290} - {ERROR:Thread-6} - Payload ungültig: Topic openWB/set/pv/1/get/daily_exported, Payload -145026.688 liegt in keinem der angegebenen Wertebereiche.
2023-03-30 23:50:00,904 - {helpermodules.setdata:290} - {ERROR:Thread-6} - Payload ungültig: Topic openWB/set/pv/2/get/daily_exported, Payload -163483.846 liegt in keinem der angegebenen Wertebereiche.
2023-03-30 23:50:00,906 - {helpermodules.setdata:290} - {ERROR:Thread-6} - Payload ungültig: Topic openWB/set/counter/set/daily_yield_home_consumption, Payload -347982.2683153174 liegt in keinem der angegebenen Wertebereiche.
2023-03-30 23:54:01,107 - {control.counter_all:94} - {ERROR:MainThread} - Ungültiger Hausverbrauch: -371W, Berücksichtigte Komponenten neben EVU [{'id': 1, 'type': 'inverter', 'children': []}, {'id': 2, 'type': 'inverter', 'children': []}, {'id': 3, 'type': 'bat', 'children': []}]
2023-03-30 23:55:01,085 - {helpermodules.setdata:290} - {ERROR:Thread-6} - Payload ungültig: Topic openWB/set/bat/3/get/daily_imported, Payload -79428.98 liegt in keinem der angegebenen Wertebereiche.
2023-03-30 23:55:01,088 - {helpermodules.setdata:290} - {ERROR:Thread-6} - Payload ungültig: Topic openWB/set/bat/3/get/daily_exported, Payload -77874.45 liegt in keinem der angegebenen Wertebereiche.
2023-03-30 23:55:01,097 - {helpermodules.setdata:290} - {ERROR:Thread-6} - Payload ungültig: Topic openWB/set/counter/0/get/daily_imported, Payload -70009.53477287451 liegt in keinem der angegebenen Wertebereiche.
2023-03-30 23:55:01,099 - {helpermodules.setdata:290} - {ERROR:Thread-6} - Payload ungültig: Topic openWB/set/counter/0/get/daily_exported, Payload -29067.4585439486 liegt in keinem der angegebenen Wertebereiche.
2023-03-30 23:55:01,102 - {helpermodules.setdata:290} - {ERROR:Thread-6} - Payload ungültig: Topic openWB/set/pv/1/get/daily_exported, Payload -145026.688 liegt in keinem der angegebenen Wertebereiche.
2023-03-30 23:55:01,103 - {helpermodules.setdata:290} - {ERROR:Thread-6} - Payload ungültig: Topic openWB/set/pv/2/get/daily_exported, Payload -163483.846 liegt in keinem der angegebenen Wertebereiche.
2023-03-30 23:55:01,105 - {helpermodules.setdata:290} - {ERROR:Thread-6} - Payload ungültig: Topic openWB/set/counter/set/daily_yield_home_consumption, Payload -347898.080228926 liegt in keinem der angegebenen Wertebereiche.
2023-03-31 06:33:10,932 - {control.counter_all:94} - {ERROR:MainThread} - Ungültiger Hausverbrauch: -75W, Berücksichtigte Komponenten neben EVU [{'id': 1, 'type': 'inverter', 'children': []}, {'id': 2, 'type': 'inverter', 'children': []}, {'id': 3, 'type': 'bat', 'children': []}]
2023-03-31 09:56:57,293 - {helpermodules.setdata:817} - {WARNING:Thread-6} - Kein Zähler 4 mit gültiger Konfiguration gefunden.
2023-03-31 09:56:59,580 - {helpermodules.setdata:817} - {WARNING:Thread-6} - Kein Zähler 4 mit gültiger Konfiguration gefunden.
2023-03-31 09:57:07,937 - {helpermodules.setdata:817} - {WARNING:Thread-6} - Kein Zähler 4 mit gültiger Konfiguration gefunden.
2023-03-31 09:57:10,111 - {helpermodules.setdata:817} - {WARNING:Thread-6} - Kein Zähler 4 mit gültiger Konfiguration gefunden.
2023-03-31 09:57:17,807 - {helpermodules.setdata:817} - {WARNING:Thread-6} - Kein Zähler 4 mit gültiger Konfiguration gefunden.
2023-03-31 09:57:19,759 - {helpermodules.setdata:817} - {WARNING:Thread-6} - Kein Zähler 4 mit gültiger Konfiguration gefunden.
2023-03-31 09:57:27,345 - {helpermodules.setdata:817} - {WARNING:Thread-6} - Kein Zähler 4 mit gültiger Konfiguration gefunden.
2023-03-31 09:57:29,299 - {helpermodules.setdata:817} - {WARNING:Thread-6} - Kein Zähler 4 mit gültiger Konfiguration gefunden.
2023-03-31 09:57:37,408 - {helpermodules.setdata:817} - {WARNING:Thread-6} - Kein Zähler 4 mit gültiger Konfiguration gefunden.
2023-03-31 09:57:39,512 - {helpermodules.setdata:817} - {WARNING:Thread-6} - Kein Zähler 4 mit gültiger Konfiguration gefunden.
2023-03-31 09:57:47,513 - {helpermodules.setdata:817} - {WARNING:Thread-6} - Kein Zähler 4 mit gültiger Konfiguration gefunden.
2023-03-31 09:57:49,687 - {helpermodules.setdata:817} - {WARNING:Thread-6} - Kein Zähler 4 mit gültiger Konfiguration gefunden.
2023-03-31 09:57:57,508 - {helpermodules.setdata:817} - {WARNING:Thread-6} - Kein Zähler 4 mit gültiger Konfiguration gefunden.
2023-03-31 09:57:59,672 - {helpermodules.setdata:817} - {WARNING:Thread-6} - Kein Zähler 4 mit gültiger Konfiguration gefunden.
2023-03-31 09:58:09,602 - {helpermodules.setdata:817} - {WARNING:Thread-6} - Kein Zähler 4 mit gültiger Konfiguration gefunden.
2023-03-31 09:58:17,737 - {helpermodules.setdata:817} - {WARNING:Thread-6} - Kein Zähler 4 mit gültiger Konfiguration gefunden.
2023-03-31 09:58:19,927 - {helpermodules.setdata:817} - {WARNING:Thread-6} - Kein Zähler 4 mit gültiger Konfiguration gefunden.
2023-03-31 09:58:27,499 - {helpermodules.setdata:817} - {WARNING:Thread-6} - Kein Zähler 4 mit gültiger Konfiguration gefunden.

[LenaK]

Mit

Code: Alles auswählen

sudo ./reset-broker.sh clearall

kannst Du den Broker und damit alle Einstellungen zurück setzen.

[Gero]

Genau den reset_broker hatte ich schon einige Male gemacht. Weil ich ja nicht soviel zu konfigurieren habe, eigentlich nach jedem Update. Zuletzt hab’ ich ja mal das Update gemacht und dann erst nochmal den reset_broker. Erst dann kamen die ganz seltsamen Fehlermeldungen.

Kann es vielleicht an der Reihenfolge der Einrichtung liegen? Ich mache immer EVU, WR, ext WR und dann Speicher.

[ChristophR]

Hallo,

ich habe seit einiger Zeit bereits das Problem, dass das EV nur mit 1 Phase lädt, obwohl alles auf 3 Phasen eingerichtet ist.
Ich habe zwischenzeitlich zwar einen Shelly als WR für ein Balkonkraftwerk eingerichtet, der dürfte aber dafür keinen Einfluss haben.
Ich meine auch keine anderen Änderungen oder Updates zwischen Funktion und Nichtfunktion gehabt zu haben.
Nun habe ich aber eigentlich alles versucht und bin mit meinem Latein am Ende:

openWB 1.9 als Nur Ladepunkt, sowohl 1.9.295 als auch die aktuelle Nightly gestern ausprobiert.
openWB 2.0 mit fast aktueller Version (zum zeitpunkt der Logs), danach gleiches Problem auch mit aktuellster Version.
Neustart aller Wallboxen, Umstellung auf Sofortladen ohne SoC-Beachtung, openWB 1.9 Stromlos gemacht.
Alles ohne Erfolg.

Lt. Anzeige bietet die openWB 3 Phasen an, es wird aber nur mit 1 Phase geladen:

Ich habe vor ein paar Tagen versucht zu dem Zeitpunkt des Ladens die Logs zu ziehen:

Main.log:

Code: Alles auswählen

2023-03-27 02:28:20,515 - {root:61} - {INFO:MainThread} - # ***Start*** 
2023-03-27 02:28:20,532 - {modules.devices.virtual.device:40} - {DEBUG:device0} - Start device reading{'component0': <modules.devices.virtual.counter.VirtualCounter object at 0xf3fa6c70>}
2023-03-27 02:28:20,532 - {modules.common.component_context:24} - {DEBUG:device1} - Update Komponente ['Shelly Wechselrichter']
2023-03-27 02:28:20,533 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['Virtueller Zähler']
2023-03-27 02:28:20,533 - {modules.common.component_context:24} - {DEBUG:cp1} - Update Komponente ['Ladepunkt']
2023-03-27 02:28:20,538 - {urllib3.connectionpool:227} - {DEBUG:device1} - Starting new HTTP connection (1): 192.168.1.54:80
2023-03-27 02:28:20,539 - {modules.common.simcount._simcount:38} - {DEBUG:device0} - Previous state: SimCounterState(timestamp=1679876890.0582037, power=400, imported=610384.416090837, exported=0)
2023-03-27 02:28:20,541 - {modules.common.simcount._calculate:13} - {DEBUG:device0} - time passed: 0.00291135, power1: 400, power2: 400
2023-03-27 02:28:20,541 - {modules.common.simcount._calculate:29} - {DEBUG:device0} - power did not change sign. Total energy: 1.16454
2023-03-27 02:28:20,542 - {modules.common.simcount._simcount:47} - {DEBUG:device0} - imported: 1.16454 Wh, exported: 0 Wh, new state: SimCounterState(timestamp=1679876900.5390463, power=400, imported=610385.5806289025, exported=0)
2023-03-27 02:28:20,542 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data CounterState(voltages=[230.0, 230.0, 230.0], powers=[133.33333333333334, 133.33333333333334, 133.33333333333334], currents=[0.5797101449275363, 0.5797101449275363, 0.5797101449275363], power_factors=[0.0, 0.0, 0.0], imported=610385.5806289025, exported=0, power=400, frequency=50)
2023-03-27 02:28:20,588 - {urllib3.connectionpool:452} - {DEBUG:device1} - http://192.168.1.54:80 "GET /rpc/Shelly.GetStatus HTTP/1.1" 200 681
2023-03-27 02:28:20,589 - {modules.common.req:11} - {DEBUG:device1} - Get-Response: {"ble":{},"cloud":{"connected":false},"input:0":{"id":0,"state":false},"mqtt":{"connected":false},"switch:0":{"id":0, "source":"WS_in", "output":false, "apower":0.0, "voltage":238.4, "current":0.000, "aenergy":{"total":0.000,"by_minute":[0.000,0.000,0.000],"minute_ts":1679876899},"temperature":{"tC":31.9, "tF":89.4}},"sys":{"mac":"441793D4F72C","restart_required":false,"time":"02:28","unixtime":1679876900,"uptime":25021,"ram_size":248980,"ram_free":145360,"fs_size":458752,"fs_free":94208,"cfg_rev":13,"kvs_rev":2,"schedule_rev":11,"webhook_rev":0,"available_updates":{}},"wifi":{"sta_ip":"192.168.1.54","status":"got ip","ssid":"RSKNET","rssi":-69},"ws":{"connected":false}}

2023-03-27 02:28:20,590 - {modules.common.simcount._simcount:38} - {DEBUG:device1} - Previous state: SimCounterState(timestamp=1679876890.110662, power=0, imported=0.0, exported=19507.09847264528)
2023-03-27 02:28:20,591 - {modules.common.simcount._calculate:13} - {DEBUG:device1} - time passed: 0.00291112, power1: 0, power2: 0
2023-03-27 02:28:20,591 - {modules.common.simcount._calculate:29} - {DEBUG:device1} - power did not change sign. Total energy: 0
2023-03-27 02:28:20,591 - {modules.common.simcount._simcount:47} - {DEBUG:device1} - imported: 0 Wh, exported: 0 Wh, new state: SimCounterState(timestamp=1679876900.5906808, power=0, imported=0.0, exported=19507.09847264528)
2023-03-27 02:28:20,591 - {modules.common.store._api:26} - {DEBUG:device1} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=0, exported=19507.09847264528, dc_power=None)
2023-03-27 02:28:20,595 - {modules.common.component_context:24} - {DEBUG:cp1} - Update Komponente ['Ladepunkt']
2023-03-27 02:28:20,596 - {modules.common.component_context:24} - {DEBUG:component2} - Update Komponente ['Shelly Wechselrichter']
2023-03-27 02:28:20,599 - {modules.common.store._api:26} - {DEBUG:component2} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=0, exported=19507.09847264528, dc_power=None)
2023-03-27 02:28:20,600 - {modules.common.store._api:30} - {INFO:component2} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=0, exported=19507.09847264528, dc_power=None)
2023-03-27 02:28:20,621 - {modules.common.component_context:24} - {DEBUG:component0} - Update Komponente ['Virtueller Zähler']
2023-03-27 02:28:20,622 - {modules.common.store._api:30} - {INFO:component0} - Saving CounterState(voltages=[230.0, 230.0, 230.0], powers=[3836.3333333333335, 140.23333333333335, 142.53333333333336], currents=[16.679710144927537, 0.6097101449275363, 0.6197101449275363], power_factors=[0.0, 0.0, 0.0], imported=2715352.6206289027, exported=19507.098, power=4237.51, frequency=50)
2023-03-27 02:28:20,707 - {control.counter:125} - {INFO:MainThread} - Verbleibende Ströme an Zähler 0: [34.42, 34.42, 34.42]A
2023-03-27 02:28:20,707 - {control.counter:148} - {INFO:MainThread} - Verbleibende Leistung an Zähler 0: 20600.0W
2023-03-27 02:28:20,711 - {control.chargepoint:701} - {DEBUG:MainThread} - EV-Phasenzahl beschränkt die nutzbaren Phasen auf 3
2023-03-27 02:28:20,711 - {control.chargepoint:692} - {DEBUG:MainThread} - Phasenzahl Lademodus: 3
2023-03-27 02:28:20,712 - {control.ev:736} - {DEBUG:MainThread} - Plan-Nr. 2: Differenz zum Start -3373.538348s, Dauer 3.464673913043478h, Termin heute verpasst: False
2023-03-27 02:28:20,712 - {control.ev:782} - {DEBUG:MainThread} - Verwendeter Plan: 05:00 Uhr 100% SoC
2023-03-27 02:28:20,718 - {control.chargepoint:881} - {INFO:MainThread} - LP 1, EV: ***AUTO*** (EV-Nr.1): Theoretisch benötigter Strom 16A, Lademodus scheduled_charging, Submodus: Chargemode.INSTANT_CHARGING, Phasen: 3, Priorität: False, max. Ist-Strom: 16.1
2023-03-27 02:28:20,719 - {control.chargepoint:354} - {INFO:MainThread} - LP 1: Zielladen mit 16A. Der verfügbare Ladezeitraum reicht nicht aus, um das zu erreichen. Daher wird bis max. 20 Minuten nach dem angegebenen Zieltermin geladen.
2023-03-27 02:28:20,725 - {control.data:305} - {INFO:MainThread} - bat_all_data
BatAllData(config=Config(configured=False), get=Get(soc=0, daily_exported=0, daily_imported=0, imported=0, exported=0, power=0), set=Set(charging_power_left=0, switch_on_soc_reached=False))
2023-03-27 02:28:20,726 - {control.data:306} - {INFO:MainThread} - cp_all_data
AllChargepointData(get=AllGet(daily_imported=8141.85, daily_exported=0, power=3837.51, imported=2104967.04, exported=0))
2023-03-27 02:28:20,726 - {control.data:334} - {INFO:MainThread} - cp1
ChargepointData(get=Get(charge_state=True, connected_vehicle=ConnectedVehicle(config=ConnectedConfig(average_consumption=17, charge_template=0, chargemode='stop', current_plan=0, ev_template=0, priority=False, time_charging_in_use=False), info=ConnectedInfo(id=0, name='Ladepunkt'), soc=49.0), currents=[16.1, 0.03, 0.04], daily_imported=8141.85, daily_exported=0, exported=0, fault_str='Kein Fehler.', fault_state=0, imported=2104967.04, phases_in_use=1, plug_state=True, power=3837.51, rfid_timestamp=None, rfid=None, state_str='Zielladen mit 16A. Der verfügbare Ladezeitraum reicht nicht aus, um das zu erreichen. Daher wird bis max. 20 Minuten nach dem angegebenen Zieltermin geladen.', voltages=[238.46, 242.8, 241.64]), set=Set(change_ev_permitted=[True, ''], charging_ev=1, charging_ev_prev=1, current=16, energy_to_charge=0, loadmanagement_available=True, log=Log(chargemode_log_entry='scheduled_charging', imported_at_mode_switch=2104302.98, imported_at_plugtime=2096612.06, imported_since_mode_switch=654.0499999998137, imported_since_plugged=8344.96999999974, range_charged=3.8473529411753753, time_charged='0:10', timestamp_start_charging='03/27/2023, 02:18:01'), manual_lock=False, phases_to_use=3, plug_state_prev=True, plug_time='03/27/2023, 00:14:10', required_power=11040, rfid='2585087748', target_current=0, charging_ev_data=<control.ev.Ev object at 0xf25ec520>), config=Config(connection_module={'type': 'external_openwb', 'name': 'Externe openWB', 'configuration': {'ip_address': 'openwb', 'duo_num': 1}}, power_module={}, ev=0, name='openWB Carport', type='external_openwb', template=1, connected_phases=3, phase_1=1, auto_phase_switch_hw=True, control_pilot_interruption_hw=True, id=1))
2023-03-27 02:28:20,728 - {control.data:334} - {INFO:MainThread} - cpt0
CpTemplateData(autolock=Autolock(active=False, plans={}, wait_for_charging_end=False), id=0, max_current_multi_phases=32, max_current_single_phase=32, name='Standard Ladepunkt-Vorlage', rfid_enabling=False, valid_tags=[])
2023-03-27 02:28:20,732 - {control.data:334} - {INFO:MainThread} - cpt1
CpTemplateData(autolock=Autolock(active=False, plans={}, wait_for_charging_end=False), id=1, max_current_multi_phases=16, max_current_single_phase=19, name='RFID aktiviert', rfid_enabling=True, valid_tags=['0003526747', '1655332554', '2585087748'])
2023-03-27 02:28:20,733 - {control.data:334} - {INFO:MainThread} - counter0
CounterData(config=Config(max_currents=[35, 35, 35], max_total_power=21000), get=Get(powers=[3836.33, 140.23, 142.53], currents=[16.68, 0.61, 0.62], voltages=[230.0, 230.0, 230.0], power_factors=[0.0, 0.0, 0.0], unbalanced_load=0, frequency=50, daily_exported=0.0, daily_imported=9108.4548824782, imported=2715352.6206289027, exported=19507.098, fault_state=0, fault_str='Kein Fehler.', power=4237.51), set=Set(reserved_surplus=0, released_surplus=0, raw_power_left=20600.0, raw_currents_left=[34.42, 34.42, 34.42], surplus_power_left=0, state_str=''))
2023-03-27 02:28:20,733 - {control.data:310} - {INFO:MainThread} - counter_all_data
CounterAllData(config=Config(reserve_for_not_charging=False), get=Get(hierarchy=[{'id': 0, 'type': 'counter', 'children': [{'id': 1, 'type': 'cp', 'children': []}, {'id': 2, 'type': 'inverter', 'children': []}]}]), set=Set(loadmanagement_active=False, home_consumption=400.0, invalid_home_consumption=0, daily_yield_home_consumption=966.6048824781992))
2023-03-27 02:28:20,733 - {control.data:334} - {INFO:MainThread} - ct0
ChargeTemplateData(name='Standard-Ladeprofil-Vorlage', disable_after_unplug=False, prio=False, load_default=False, time_charging=TimeCharging(active=False, plans={}), chargemode=Chargemode(selected='stop', pv_charging=PvCharging(min_soc_current=6, min_current=0, feed_in_limit=False, min_soc=0, max_soc=101), scheduled_charging=ScheduledCharging(plans={}), instant_charging=InstantCharging(current=10, limit=Limit(selected='none', amount=1000, soc=50))))
2023-03-27 02:28:20,734 - {control.data:334} - {INFO:MainThread} - ct1
ChargeTemplateData(name='Zeitladen 16A mit EVU Sperrzeiten', disable_after_unplug=False, prio=False, load_default=True, time_charging=TimeCharging(active=True, plans={'0': TimeChargingPlan(active=True, frequency=Frequency(selected='daily', once=['2021-11-01', '2021-11-05'], weekly=[False, False, False, False, False, False, False]), time=['19:00', '11:00'], name='19:00 - 11:00 Uhr 16A', current=16, limit=Limit(selected='none', amount=1000, soc=50)), '1': TimeChargingPlan(active=True, frequency=Frequency(selected='daily', once=['2021-11-01', '2021-11-05'], weekly=[False, False, False, False, False, False, False]), time=['13:00', '17:00'], name='13:00 - 17:00 Uhr 16A', current=16, limit=Limit(selected='none', amount=1000, soc=50))}), chargemode=Chargemode(selected='standby', pv_charging=PvCharging(min_soc_current=10, min_current=0, feed_in_limit=False, min_soc=0, max_soc=100), scheduled_charging=ScheduledCharging(plans={}), instant_charging=InstantCharging(current=16, limit=Limit(selected='none', amount=1000, soc=50))))
2023-03-27 02:28:20,736 - {control.data:334} - {INFO:MainThread} - ct2
ChargeTemplateData(name='Sofortladen 16A', disable_after_unplug=False, prio=False, load_default=True, time_charging=TimeCharging(active=False, plans={}), chargemode=Chargemode(selected='instant_charging', pv_charging=PvCharging(min_soc_current=10, min_current=0, feed_in_limit=False, min_soc=65, max_soc=100), scheduled_charging=ScheduledCharging(plans={}), instant_charging=InstantCharging(current=16, limit=Limit(selected='none', amount=1000, soc=50))))
2023-03-27 02:28:20,736 - {control.data:334} - {INFO:MainThread} - ct3
ChargeTemplateData(name='Zielladen Mo-Fr 06:00 Uhr, 60% SoC, Sa-So 06:00 Uhr 40% SoC', disable_after_unplug=False, prio=False, load_default=True, time_charging=TimeCharging(active=False, plans={}), chargemode=Chargemode(selected='scheduled_charging', pv_charging=PvCharging(min_soc_current=6, min_current=0, feed_in_limit=False, min_soc=0, max_soc=101), scheduled_charging=ScheduledCharging(plans={'0': ScheduledChargingPlan(active=True, frequency=Frequency(selected='weekly', once=['2021-11-01', '2021-11-05'], weekly=[True, True, True, True, True, False, False]), current=16, name='Mo-Fr 6:00 Uhr, 60% SoC', limit=ScheduledLimit(selected='soc', amount=1000, soc_limit=100, soc_scheduled=60), time='06:00'), '1': ScheduledChargingPlan(active=True, frequency=Frequency(selected='weekly', once=['2021-11-01', '2021-11-05'], weekly=[False, False, False, False, False, True, True]), current=16, name='Sa-So 6:00 Uhr,  40% SoC', limit=ScheduledLimit(selected='soc', amount=1000, soc_limit=100, soc_scheduled=40), time='06:00')}), instant_charging=InstantCharging(current=16, limit=Limit(selected='none', amount=1000, soc=50))))
2023-03-27 02:28:20,737 - {control.data:334} - {INFO:MainThread} - ct4
ChargeTemplateData(name='22:00-17:00 Uhr 80% SoC, 05:00 Uhr 100% SoC, mit EVU Sperrzeit', disable_after_unplug=False, prio=False, load_default=True, time_charging=TimeCharging(active=True, plans={'3': TimeChargingPlan(active=True, frequency=Frequency(selected='daily', once=['2021-11-01', '2021-11-05'], weekly=[False, False, False, False, False, False, False]), time=['22:00', '11:00'], name='22:00-11:00 Uhr, 80%SoC', current=16, limit=Limit(selected='soc', amount=1000, soc=80)), '4': TimeChargingPlan(active=True, frequency=Frequency(selected='daily', once=['2021-11-01', '2021-11-05'], weekly=[False, False, False, False, False, False, False]), time=['13:00', '17:00'], name='13:00-17:00 Uhr, 80%SoC', current=16, limit=Limit(selected='soc', amount=1000, soc=80))}), chargemode=Chargemode(selected='scheduled_charging', pv_charging=PvCharging(min_soc_current=10, min_current=0, feed_in_limit=False, min_soc=0, max_soc=80), scheduled_charging=ScheduledCharging(plans={'2': ScheduledChargingPlan(active=True, frequency=Frequency(selected='daily', once=['2021-11-01', '2021-11-05'], weekly=[False, False, False, False, False, False, False]), current=16, name='05:00 Uhr 100% SoC', limit=ScheduledLimit(selected='soc', amount=1000, soc_limit=100, soc_scheduled=100), time='05:00')}), instant_charging=InstantCharging(current=16, limit=Limit(selected='none', amount=1000, soc=50))))
2023-03-27 02:28:20,737 - {control.data:334} - {INFO:MainThread} - ev0
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=16, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17, min_current=6, max_current_single_phase=32, battery_capacity=82, nominal_difference=2), et_num=0), soc_error_counter=0), control_parameter=ControlParameter(required_current=0, required_currents=[0.0, 0.0, 0.0], phases=0, prio=False, timestamp_switch_on_off=None, timestamp_auto_phase_switch=None, timestamp_perform_phase_switch=None, submode='stop', chargemode='stop', used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None), charge_template=0, ev_template=0, name='Standard-Fahrzeug', tag_id=[], get=Get(soc=0, soc_timestamp='', force_soc_update=True, range=0, fault_state=0, fault_str=''))
2023-03-27 02:28:20,738 - {control.data:334} - {INFO:MainThread} - ev1
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='Tesla Model Y (2022)', max_current_multi_phases=16, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17, min_current=6, max_current_single_phase=32, battery_capacity=75, nominal_difference=2), et_num=0), soc_error_counter=0), control_parameter=ControlParameter(required_current=16, required_currents=[16, 16, 16], phases=3, prio=False, timestamp_switch_on_off=None, timestamp_auto_phase_switch=None, timestamp_perform_phase_switch=None, submode=<Chargemode.INSTANT_CHARGING: 'instant_charging'>, chargemode=<Chargemode.SCHEDULED_CHARGING: 'scheduled_charging'>, used_amount_instant_charging=0, imported_at_plan_start=0, current_plan='05:00 Uhr 100% SoC'), charge_template=4, ev_template=1, name='***AUTO***', tag_id=['0003526747', '2585087748'], get=Get(soc=49.0, soc_timestamp='03/27/2023, 02:25:00', force_soc_update=False, range=233.37, fault_state=0, fault_str='Kein Fehler.'))
2023-03-27 02:28:20,739 - {control.data:334} - {INFO:MainThread} - et0
EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=16, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17, min_current=6, max_current_single_phase=32, battery_capacity=82, nominal_difference=2)
2023-03-27 02:28:20,739 - {control.data:334} - {INFO:MainThread} - et1
EvTemplateData(name='Tesla Model Y (2022)', max_current_multi_phases=16, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17, min_current=6, max_current_single_phase=32, battery_capacity=75, nominal_difference=2)
2023-03-27 02:28:20,739 - {control.data:314} - {INFO:MainThread} - general_data
GeneralData(chargemode_config=ChargemodeConfig(instant_charging=InstantCharging(phases_to_use=3), pv_charging=PvCharging(bat_prio=False, charging_power_reserve=200, control_range=[-230, 0], feed_in_yield=11000, phase_switch_delay=8, phases_to_use=0, rundown_power=5000, rundown_soc=50, switch_off_delay=60, switch_off_soc=40, switch_off_threshold=50, switch_on_delay=30, switch_on_soc=60, switch_on_threshold=1500), scheduled_charging=ScheduledCharging(phases_to_use=3), standby=Standby(phases_to_use=3), stop=Stop(phases_to_use=1), time_charging=TimeCharging(phases_to_use=3), unbalanced_load_limit=19, unbalanced_load=True), control_interval=10, extern_display_mode='local', extern=False, external_buttons_hw=False, grid_protection_active=False, grid_protection_configured=True, grid_protection_random_stop=0, grid_protection_timestamp='', mqtt_bridge=False, price_kwh=0.3528, range_unit='km', ripple_control_receiver=RippleControlReceiver(configured=False, r1_active=False, r2_active=False))
2023-03-27 02:28:20,739 - {control.data:315} - {INFO:MainThread} - graph_data
GraphData(config=Config(duration=120))
2023-03-27 02:28:20,740 - {control.data:316} - {INFO:MainThread} - optional_data
OptionalData(et=Et(active=False, config=EtConfig(max_price=0, provider={}), get=EtGet(price=0, price_list=[])), int_display=InternalDisplay(active=True, on_if_plugged_in=True, pin_active=False, pin_code='0000', standby=180, theme='cards'), led=Led(active=False), rfid=Rfid(active=True))
2023-03-27 02:28:20,740 - {control.data:334} - {INFO:MainThread} - pv2
PvData(config=Config(max_ac_out=0), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=0.0, monthly_exported=0, yearly_exported=0, exported=19507.098, fault_state=0, fault_str='Kein Fehler.', power=0))
2023-03-27 02:28:20,741 - {control.data:318} - {INFO:MainThread} - pv_all_data
PvAllData(config=Config(configured=True), get=Get(daily_exported=0.0, monthly_exported=0, yearly_exported=0, exported=19507.098, power=0))
2023-03-27 02:28:20,741 - {control.data:334} - {INFO:MainThread} - system
{'update_in_progress': False, 'perform_update': False, 'ip_address': '192.168.1.51', 'current_commit': '2023-03-13 14:52:30 +0100 [91d8e4376]', 'current_branch': 'master', 'current_branch_commit': '2023-03-23 13:52:54 +0100 [e55e40fc6]', 'current_missing_commits': ['2023-03-23 13:52:54 +0100 [e55e40fc6] - Merge pull request #843 from benderl/web', '2023-03-23 13:52:08 +0100 [80cecbefe] - fix deletion of system messages'], 'dataprotection_acknowledged': True, 'debug_level': 10, 'release_train': 'master', 'version': '1.99.102.0', 'datastore_version': 7, 'lastlivevaluesJson': {'timestamp': 1679876890, 'time': '02:28:10', 'grid': 4.25, 'house-power': 0.4, 'charging-all': 3.85, 'pv-all': -0.0, 'cp1-power': 3.85, 'ev1-soc': 49.0}, 'boot_done': True, 'module_update_completed': True}
2023-03-27 02:28:20,742 - {control.data:347} - {INFO:MainThread} - device0
{'name': 'Virtueller Zähler', 'type': 'virtual', 'id': 0, 'configuration': {}}
2023-03-27 02:28:20,742 - {control.data:349} - {INFO:MainThread} - component0
{'name': 'Virtueller Zähler', 'type': 'counter', 'id': 0, 'configuration': {'external_consumption': 400}}
2023-03-27 02:28:20,742 - {control.data:347} - {INFO:MainThread} - device1
{'name': 'Shelly', 'type': 'shelly', 'id': 1, 'configuration': {'address': '192.168.1.54', 'generation': 2}}
2023-03-27 02:28:20,742 - {control.data:349} - {INFO:MainThread} - component2
{'name': 'Shelly Wechselrichter', 'type': 'inverter', 'id': 2, 'configuration': {}}
2023-03-27 02:28:20,742 - {control.data:321} - {INFO:MainThread} - 

2023-03-27 02:28:20,743 - {control.algorithm.algorithm:26} - {INFO:MainThread} - # Algorithmus
2023-03-27 02:28:20,743 - {control.algorithm.algorithm:32} - {INFO:MainThread} - **Mindestrom setzen**
2023-03-27 02:28:20,744 - {control.algorithm.min_current:19} - {INFO:MainThread} - Mode-Tuple (<Chargemode.SCHEDULED_CHARGING: 'scheduled_charging'>, <Chargemode.INSTANT_CHARGING: 'instant_charging'>, False), Zähler 0
2023-03-27 02:28:20,745 - {control.counter:156} - {DEBUG:MainThread} - Zähler 0: [28.42, 28.42, 28.42]A verbleibende Ströme, 16460.0W verbleibende Leistung
2023-03-27 02:28:20,745 - {control.algorithm.common:87} - {INFO:MainThread} - LP1: Stromstärke 6A
2023-03-27 02:28:20,747 - {control.algorithm.algorithm:34} - {INFO:MainThread} - **Sollstrom setzen**
2023-03-27 02:28:20,748 - {control.algorithm.filter_chargepoints:118} - {DEBUG:MainThread} - Geordnete Ladepunkte [1]
2023-03-27 02:28:20,748 - {control.algorithm.additional_current:26} - {INFO:MainThread} - Mode-Tuple (<Chargemode.SCHEDULED_CHARGING: 'scheduled_charging'>, <Chargemode.INSTANT_CHARGING: 'instant_charging'>, False), Zähler 0
2023-03-27 02:28:20,749 - {control.counter:156} - {DEBUG:MainThread} - Zähler 0: [18.42, 18.42, 18.42]A verbleibende Ströme, 9560.0W verbleibende Leistung
2023-03-27 02:28:20,749 - {control.algorithm.common:87} - {INFO:MainThread} - LP1: Stromstärke 16A
2023-03-27 02:28:20,750 - {control.counter:185} - {INFO:MainThread} - Überschuss zur PV-geführten Ladung: 0W
2023-03-27 02:28:20,751 - {control.counter:448} - {DEBUG:MainThread} - Zähler 0: Begrenzung der verbleibenden Leistung auf 0W
2023-03-27 02:28:20,751 - {control.algorithm.algorithm:45} - {INFO:MainThread} - **Keine Leistung für PV-geführtes Laden übrig.**
2023-03-27 02:28:20,751 - {control.process:22} - {INFO:MainThread} - # Ladung starten.
2023-03-27 02:28:20,752 - {control.chargelog:52} - {DEBUG:MainThread} - imported_since_mode_switch 664.0600000000559 counter 2104967.04
2023-03-27 02:28:20,754 - {control.process:106} - {INFO:MainThread} - LP1: set current 16 A
2023-03-27 02:28:20,764 - {modules.common.component_context:24} - {DEBUG:cp1} - Update Komponente ['Ladepunkt']
2023-03-27 02:28:20,781 - {control.counter:173} - {INFO:MainThread} - 0W reservierte EVU-Leistung, 0W freigegebene EVU-Leistung
2023-03-27 02:28:21,044 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=update, args=(), kwargs={})
2023-03-27 02:28:30,121 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=handler10Sec, args=(), kwargs={})
2023-03-27 02:28:30,121 - {root:61} - {INFO:MainThread} - # ***Start*** 

Nur Ladepunkt Log:

Code: Alles auswählen

modules.common.fault_state.FaultState: ('modules.chargepoints.internal_openwb.chargepoint_module <class \'modules.common.fault_state.FaultState\'> ("modules.common.modbus <class \'modules.common.fault_state.FaultState\'> (\'modules.common.modbus Modbus Error: [Input/Output] Modbus Error: [Invalid Message] Incomplete message received, expected at least 2 bytes (0 received)\', <FaultStateLevel.ERROR: 2>)", <FaultStateLevel.ERROR: 2>)', <FaultStateLevel.ERROR: 2>)
    raise FaultState.error(__name__ + " " + str(type(e)) + " " + str(e)) from e
  File "/var/www/html/openWB/packages/modules/chargepoints/internal_openwb/chargepoint_module.py", line 155, in get_values
    state, _ = self.module.get_values(phase_switch_cp_active)
  File "/var/www/html/openWB/runs/isss.py", line 296, in update
Traceback (most recent call last):

The above exception was the direct cause of the following exception:

modules.common.fault_state.FaultState: ("modules.common.modbus <class 'modules.common.fault_state.FaultState'> ('modules.common.modbus Modbus Error: [Input/Output] Modbus Error: [Invalid Message] Incomplete message received, expected at least 2 bytes (0 received)', <FaultStateLevel.ERROR: 2>)", <FaultStateLevel.ERROR: 2>)
    str(e)) from e
  File "/var/www/html/openWB/packages/modules/common/modbus.py", line 101, in __read_registers
    self.delegate.read_holding_registers, address, types, byteorder, wordorder, **kwargs
  File "/var/www/html/openWB/packages/modules/common/modbus.py", line 119, in read_holding_registers
    1000, [ModbusDataType.UINT_16]*3, unit=self.id)
  File "/var/www/html/openWB/packages/modules/common/evse.py", line 35, in get_plug_charge_state
    plug_state, charge_state, self.set_current_evse = self.__client.evse_client.get_plug_charge_state()
  File "/var/www/html/openWB/packages/modules/chargepoints/internal_openwb/chargepoint_module.py", line 113, in get_values
Traceback (most recent call last):

The above exception was the direct cause of the following exception:

modules.common.fault_state.FaultState: ('modules.common.modbus Modbus Error: [Input/Output] Modbus Error: [Invalid Message] Incomplete message received, expected at least 2 bytes (0 received)', <FaultStateLevel.ERROR: 2>)
    raise FaultState.error(__name__+" "+str(response))
  File "/var/www/html/openWB/packages/modules/common/modbus.py", line 85, in __read_registers
Traceback (most recent call last):
2023-03-27 02:40:10,792 - {root:301} - ERROR - Fehler bei Ladepunkt 0
modules.common.fault_state.FaultState: ('modules.chargepoints.internal_openwb.chargepoint_module <class \'modules.common.fault_state.FaultState\'> ("modules.common.modbus <class \'modules.common.fault_state.FaultState\'> (\'modules.common.modbus Modbus Error: [Input/Output] Modbus Error: [Invalid Message] Incomplete message received, expected at least 2 bytes (0 received)\', <FaultStateLevel.ERROR: 2>)", <FaultStateLevel.ERROR: 2>)', <FaultStateLevel.ERROR: 2>)
    raise FaultState.error(__name__ + " " + str(type(e)) + " " + str(e)) from e
  File "/var/www/html/openWB/packages/modules/chargepoints/internal_openwb/chargepoint_module.py", line 155, in get_values
    state, _ = self.module.get_values(phase_switch_cp_active)
  File "/var/www/html/openWB/runs/isss.py", line 296, in update
Traceback (most recent call last):

The above exception was the direct cause of the following exception:

modules.common.fault_state.FaultState: ("modules.common.modbus <class 'modules.common.fault_state.FaultState'> ('modules.common.modbus Modbus Error: [Input/Output] Modbus Error: [Invalid Message] Incomplete message received, expected at least 2 bytes (0 received)', <FaultStateLevel.ERROR: 2>)", <FaultStateLevel.ERROR: 2>)
    str(e)) from e
  File "/var/www/html/openWB/packages/modules/common/modbus.py", line 101, in __read_registers
    self.delegate.read_holding_registers, address, types, byteorder, wordorder, **kwargs
  File "/var/www/html/openWB/packages/modules/common/modbus.py", line 119, in read_holding_registers
    1000, [ModbusDataType.UINT_16]*3, unit=self.id)
  File "/var/www/html/openWB/packages/modules/common/evse.py", line 35, in get_plug_charge_state
    plug_state, charge_state, self.set_current_evse = self.__client.evse_client.get_plug_charge_state()
  File "/var/www/html/openWB/packages/modules/chargepoints/internal_openwb/chargepoint_module.py", line 113, in get_values
Traceback (most recent call last):

The above exception was the direct cause of the following exception:

modules.common.fault_state.FaultState: ('modules.common.modbus Modbus Error: [Input/Output] Modbus Error: [Invalid Message] Incomplete message received, expected at least 2 bytes (0 received)', <FaultStateLevel.ERROR: 2>)
    raise FaultState.error(__name__+" "+str(response))
  File "/var/www/html/openWB/packages/modules/common/modbus.py", line 85, in __read_registers
Traceback (most recent call last):
2023-03-27 02:23:04,886 - {root:301} - ERROR - Fehler bei Ladepunkt 0
modules.common.fault_state.FaultState: ('modules.chargepoints.internal_openwb.chargepoint_module <class \'modules.common.fault_state.FaultState\'> ("modules.common.modbus <class \'modules.common.fault_state.FaultState\'> (\'modules.common.modbus Modbus Error: [Input/Output] Modbus Error: [Invalid Message] Incomplete message received, expected at least 2 bytes (0 received)\', <FaultStateLevel.ERROR: 2>)", <FaultStateLevel.ERROR: 2>)', <FaultStateLevel.ERROR: 2>)
    raise FaultState.error(__name__ + " " + str(type(e)) + " " + str(e)) from e
  File "/var/www/html/openWB/packages/modules/chargepoints/internal_openwb/chargepoint_module.py", line 155, in get_values
    state, _ = self.module.get_values(phase_switch_cp_active)
  File "/var/www/html/openWB/runs/isss.py", line 296, in update
Traceback (most recent call last):

The above exception was the direct cause of the following exception:

modules.common.fault_state.FaultState: ("modules.common.modbus <class 'modules.common.fault_state.FaultState'> ('modules.common.modbus Modbus Error: [Input/Output] Modbus Error: [Invalid Message] Incomplete message received, expected at least 2 bytes (0 received)', <FaultStateLevel.ERROR: 2>)", <FaultStateLevel.ERROR: 2>)
    str(e)) from e
  File "/var/www/html/openWB/packages/modules/common/modbus.py", line 101, in __read_registers
    self.delegate.read_holding_registers, address, types, byteorder, wordorder, **kwargs
  File "/var/www/html/openWB/packages/modules/common/modbus.py", line 119, in read_holding_registers
    1000, [ModbusDataType.UINT_16]*3, unit=self.id)
  File "/var/www/html/openWB/packages/modules/common/evse.py", line 35, in get_plug_charge_state
    plug_state, charge_state, self.set_current_evse = self.__client.evse_client.get_plug_charge_state()
  File "/var/www/html/openWB/packages/modules/chargepoints/internal_openwb/chargepoint_module.py", line 113, in get_values
Traceback (most recent call last):

The above exception was the direct cause of the following exception:

modules.common.fault_state.FaultState: ('modules.common.modbus Modbus Error: [Input/Output] Modbus Error: [Invalid Message] Incomplete message received, expected at least 2 bytes (0 received)', <FaultStateLevel.ERROR: 2>)
    raise FaultState.error(__name__+" "+str(response))
  File "/var/www/html/openWB/packages/modules/common/modbus.py", line 85, in __read_registers
Traceback (most recent call last):

Kann man aus den Logs erkennen, woran es liegt oder wie bekomme ich mehr Infos aus dem System?

VG
Christoph

[Basti]

Hi,
das Laden im PV-Min Modus funktioniert aber er verzählt sich, evtl. trifft das auch einen anderen Modus.
OWB 2.0 in der VM mit externer WB Custom

Laut Wallbox habe ich folgendes geladen:

Laut Ladelog nur:

Merkwürdig das es die gleichen Werte sind. Habe nur von ca- 30% geladen, schön wenn mein Tesla soviele kwh hätte von 60 - 85 %

[ChristophR]

Hallo,

ich habe seit einiger Zeit bereits das Problem, dass das EV nur mit 1 Phase lädt, obwohl alles auf 3 Phasen eingerichtet ist.
Ich habe zwischenzeitlich zwar einen Shelly als WR für ein Balkonkraftwerk eingerichtet, der dürfte aber dafür keinen Einfluss haben.
Ich meine auch keine anderen Änderungen oder Updates zwischen Funktion und Nichtfunktion gehabt zu haben.
Nun habe ich aber eigentlich alles versucht und bin mit meinem Latein am Ende:

openWB 1.9 als Nur Ladepunkt, sowohl 1.9.295 als auch die aktuelle Nightly gestern ausprobiert.
openWB 2.0 mit fast aktueller Version (zum zeitpunkt der Logs), danach gleiches Problem auch mit aktuellster Version.
Neustart aller Wallboxen, Umstellung auf Sofortladen ohne SoC-Beachtung, openWB 1.9 Stromlos gemacht.
Alles ohne Erfolg.

Es scheint ein Problem des openWB 1.9 nur Lademodus zu sein.
Es klappt nun, ich habe noch folgendes gemacht (Hatte vorher mal ein anderes Problem, wo das auch half):
In der openWB 1.9 nur Lademodus abgeschaltet und die Box neu gestartet.
Den Modus nur Lademodus wieder eingeschaltet und die Box nochmal neu gestartet.
Danach klappte es.

Vielleicht hilft das bei der Fehlersuche

VG
Christoph

[LenaK]

Genau den reset_broker hatte ich schon einige Male gemacht. Weil ich ja nicht soviel zu konfigurieren habe, eigentlich nach jedem Update. Zuletzt hab’ ich ja mal das Update gemacht und dann erst nochmal den reset_broker. Erst dann kamen die ganz seltsamen Fehlermeldungen.

Kann es vielleicht an der Reihenfolge der Einrichtung liegen? Ich mache immer EVU, WR, ext WR und dann Speicher.

Wie sieht das Log denn jetzt aus? Funktioniert es jetzt? Die Reihenfolge sollte keinen Einfluss haben, nur der EVU-Zähler muss zuerst konfiguriert werden.

[mrinas]

Mein Tesla SoC hat sich über Nacht verabschiedet, bekomme immer ein 408 timeout von Tesla zurück. Vermute ja dass das ein Service-seitiges Problem von Tesla ist und sich mit der Zeit wieder löst. Ich hab' zumindest nix gemacht, und tu's auch nie wieder.

Code: Alles auswählen

2023-04-04 04:15:12,657 - {modules.common.component_context:24} - {DEBUG:soc_ev3} - Update Komponente ['Tesla']
2023-04-04 04:15:12,658 - {modules.vehicles.tesla.api:56} - {DEBUG:soc_ev3} - No need to authenticate. Valid token already present.
2023-04-04 04:15:12,661 - {modules.vehicles.tesla.api:58} - {DEBUG:soc_ev3} - Access token expired. Refreshing token.
2023-04-04 04:15:12,679 - {urllib3.connectionpool:973} - {DEBUG:soc_ev3} - Starting new HTTPS connection (1): auth.tesla.com:443
2023-04-04 04:15:12,679 - {urllib3.connectionpool:973} - {DEBUG:soc_ev3} - Starting new HTTPS connection (1): auth.tesla.com:443
2023-04-04 04:15:13,023 - {urllib3.connectionpool:452} - {DEBUG:soc_ev3} - https://auth.tesla.com:443 "POST /oauth2/v3/token HTTP/1.1" 200 1560
2023-04-04 04:15:13,023 - {urllib3.connectionpool:452} - {DEBUG:soc_ev3} - https://auth.tesla.com:443 "POST /oauth2/v3/token HTTP/1.1" 200 1560
2023-04-04 04:15:13,030 - {modules.common.req:11} - {DEBUG:soc_ev3} - Get-Response: {"access_token":"ey...bw","refresh_token":"ey...XQ","id_token":"ey...-Q","expires_in":28800,"token_type":"Bearer"}
2023-04-04 04:15:13,034 - {modules.vehicles.tesla.api:75} - {DEBUG:soc_ev3} - received refresh token
2023-04-04 04:15:13,035 - {modules.vehicles.tesla.api:81} - {DEBUG:soc_ev3} - Token Refresh succeeded
2023-04-04 04:15:13,046 - {modules.vehicles.tesla.api:96} - {DEBUG:soc_ev3} - Requesting data: "vehicles"
2023-04-04 04:15:13,057 - {urllib3.connectionpool:973} - {DEBUG:soc_ev3} - Starting new HTTPS connection (1): owner-api.teslamotors.com:443
2023-04-04 04:15:13,057 - {urllib3.connectionpool:973} - {DEBUG:soc_ev3} - Starting new HTTPS connection (1): owner-api.teslamotors.com:443
2023-04-04 04:15:13,285 - {urllib3.connectionpool:452} - {DEBUG:soc_ev3} - https://owner-api.teslamotors.com:443 "GET /api/1/vehicles HTTP/1.1" 200 420
2023-04-04 04:15:13,285 - {urllib3.connectionpool:452} - {DEBUG:soc_ev3} - https://owner-api.teslamotors.com:443 "GET /api/1/vehicles HTTP/1.1" 200 420
2023-04-04 04:15:13,287 - {modules.common.req:11} - {DEBUG:soc_ev3} - Get-Response: {"response":[{"id":1493020668139213,"vehicle_id":225787841996,"vin":"LRWYGCEKXMC054...","display_name":"NotModelY","option_codes":null,"color":null,"access_type":"OWNER","tokens":["802d83415ad41c04","2aab37714cf3b405"],"state":"offline","in_service":false,"id_s":"1493020668139213","calendar_enabled":true,"api_version":54,"backseat_token":null,"backseat_token_updated_at":null,"ble_autopair_enrolled":false}],"count":1}
2023-04-04 04:15:13,296 - {modules.vehicles.tesla.api:89} - {DEBUG:soc_ev3} - vehicle_id for entry 0: 1493020668139213
2023-04-04 04:15:13,296 - {modules.vehicles.tesla.api:96} - {DEBUG:soc_ev3} - Requesting data: "vehicles/1493020668139213/vehicle_data"
2023-04-04 04:15:13,301 - {urllib3.connectionpool:973} - {DEBUG:soc_ev3} - Starting new HTTPS connection (1): owner-api.teslamotors.com:443
2023-04-04 04:15:13,301 - {urllib3.connectionpool:973} - {DEBUG:soc_ev3} - Starting new HTTPS connection (1): owner-api.teslamotors.com:443
2023-04-04 04:15:13,528 - {urllib3.connectionpool:452} - {DEBUG:soc_ev3} - https://owner-api.teslamotors.com:443 "GET /api/1/vehicles/1493020668139213/vehicle_data HTTP/1.1" 408 106
2023-04-04 04:15:13,528 - {urllib3.connectionpool:452} - {DEBUG:soc_ev3} - https://owner-api.teslamotors.com:443 "GET /api/1/vehicles/1493020668139213/vehicle_data HTTP/1.1" 408 106
2023-04-04 04:15:13,531 - {modules.common.fault_state:40} - {ERROR:soc_ev3} - Tesla: FaultState FaultStateLevel.ERROR, FaultStr HTTP 408: Client-Fehler. Überprüfe die Konfiguration., Traceback: 
Traceback (most recent call last):
  File "/var/www/html/openWB/packages/modules/vehicles/tesla/soc.py", line 33, in update
    soc, range = api.request_soc_range(
  File "/var/www/html/openWB/packages/modules/vehicles/tesla/api.py", line 46, in request_soc_range
    response = __request_data(data_part, token)
  File "/var/www/html/openWB/packages/modules/vehicles/tesla/api.py", line 102, in __request_data
    response = req.get_http_session().get("https://owner-api.teslamotors.com/api/1/" + data_part,
  File "/usr/lib/python3/dist-packages/requests/sessions.py", line 555, in get
    return self.request('GET', url, **kwargs)
  File "/usr/lib/python3/dist-packages/requests/sessions.py", line 542, in request
    resp = self.send(prep, **send_kwargs)
  File "/usr/lib/python3/dist-packages/requests/sessions.py", line 662, in send
    r = dispatch_hook('response', hooks, r, **kwargs)
  File "/usr/lib/python3/dist-packages/requests/hooks.py", line 31, in dispatch_hook
    _hook_data = hook(hook_data, **kwargs)
  File "/var/www/html/openWB/packages/modules/common/req.py", line 10, in <lambda>
    session.hooks['response'].append(lambda r, *args, **kwargs: r.raise_for_status())
  File "/usr/lib/python3/dist-packages/requests/models.py", line 943, in raise_for_status
    raise HTTPError(http_error_msg, response=self)
requests.exceptions.HTTPError: 408 Client Error: Request Timeout for url: https://owner-api.teslamotors.com/api/1/vehicles/1493020668139213/vehicle_data

Behandlungs des Fehlers hat wie derzeit erwartet funktioniert, der SoC wurde auf 0 gesetzt und Nachts über Zeitladen + SoC Limit geladen. Ladung wurde dann durch das SoC Limit im Auto beendet.

[LutzB]

Bei mir läuft es noch fehlerfrei in 1.9 und 2.0.

[mrinas]

Bei mir läuft es noch fehlerfrei in 1.9 und 2.0.

Nach einem Neustart gehts wieder.