Re: openWB software2 2.1.4 Beta 1
Verfasst: Do Mai 02, 2024 1:36 pm
Habe das log vom 17.4. noch lokal gespeichert: Und das passende Main Log dazu: Danke für's Kümmern! habe die letzten Male vor dem Einstecken immer mit dem Handy schnell den Debug Modus angeschmissen, aber es lief wie eine 1...LenaK hat geschrieben: ↑Do Mai 02, 2024 12:50 pmFalls das Problem nochmal auftritt bitte ein Ticket erstellen. Dann werden alle Logdateien erfasst. Hier fehlt das Log vom internen Ladepunkt, um zu sehen, ob die EVSE den Strom freigibt und es ein Problem des Fahrzeugs ist.Pendragon hat geschrieben: ↑Do Apr 25, 2024 2:45 pm Und mal wieder soll die WB laden, sagt auch dass sie lädt, aber tut es dann doch nicht.
Code: Alles auswählen
2024-04-25 16:43:40,161 - {root:75} - {INFO:MainThread} - # ***Start*** 2024-04-25 16:43:45,179 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=smarthome_handler, args=(), kwargs={}) 2024-04-25 16:43:45,181 - {root:56} - {DEBUG:MainThread} - Don't start multiple instances of smarthome thread. 2024-04-25 16:43:50,193 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=smarthome_handler, args=(), kwargs={}) 2024-04-25 16:43:50,195 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=handler10Sec, args=(), kwargs={}) 2024-04-25 16:43:50,196 - {root:75} - {INFO:MainThread} - # ***Start*** 2024-04-25 16:43:50,227 - {modules.common.component_context:54} - {DEBUG:device1} - Update Komponenten ['MQTT-Zähler', 'MQTT-Wechselrichter'] 2024-04-25 16:43:50,227 - {modules.devices.mqtt.device:47} - {DEBUG:device1} - MQTT-Module müssen nicht ausgelesen werden. 2024-04-25 16:43:50,231 - {modules.common.component_context:25} - {DEBUG:set values cp1} - Update Komponente ['Ladepunkt'] 2024-04-25 16:43:50,284 - {modules.common.component_context:25} - {DEBUG:component3} - Update Komponente ['MQTT-Wechselrichter'] 2024-04-25 16:43:50,285 - {modules.common.component_context:25} - {DEBUG:update values cp1} - Update Komponente ['Ladepunkt'] 2024-04-25 16:43:50,297 - {modules.common.component_context:25} - {DEBUG:component2} - Update Komponente ['MQTT-Zähler'] 2024-04-25 16:43:50,404 - {control.counter:145} - {INFO:MainThread} - Verbleibende Ströme an Zähler 2: [66.73, 66.75, 66.79]A 2024-04-25 16:43:50,405 - {control.counter:168} - {INFO:MainThread} - Verbleibende Leistung an Zähler 2: 45372W 2024-04-25 16:43:50,416 - {control.chargepoint.chargepoint:550} - {DEBUG:MainThread} - EV-Phasenzahl beschränkt die nutzbaren Phasen auf 3 2024-04-25 16:43:50,420 - {control.chargepoint.chargepoint:533} - {DEBUG:MainThread} - Phasenzahl Lademodus: 1 2024-04-25 16:43:50,425 - {control.chargepoint.chargepoint:674} - {INFO:MainThread} - LP 1, EV: Opel Corsa-e (EV-Nr.1): Theoretisch benötigter Strom 6A, Lademodus pv_charging, Submodus: Chargemode.PV_CHARGING, Phasen: 1, Priorität: False, max. Ist-Strom: 0.0 2024-04-25 16:43:50,443 - {modules.common.simcount._simcount:38} - {DEBUG:MainThread} - Previous state: SimCounterState(timestamp=1714056210.6634357, power=582.6100000000001, imported=1093462.825598368, exported=0) 2024-04-25 16:43:50,446 - {modules.common.simcount._calculate:11} - {DEBUG:MainThread} - time passed: 0.0054944, power1: 582.61, power2: 605.45 2024-04-25 16:43:50,447 - {modules.common.simcount._calculate:27} - {DEBUG:MainThread} - power did not change sign. Total energy: 3.26384 2024-04-25 16:43:50,459 - {modules.common.simcount._simcount:53} - {DEBUG:MainThread} - imported: 3.26384 Wh, exported: 0 Wh, new state: SimCounterState(timestamp=1714056230.4432807, power=605.4499999999998, imported=1093466.089437625, exported=0) 2024-04-25 16:43:50,462 - {control.data:236} - {INFO:MainThread} - bat_all_data BatAllData(config=Config(configured=False), get=Get(soc=0, daily_exported=0.0, daily_imported=0.0, fault_str='Kein Fehler.', fault_state=0, imported=0, exported=0, power=0), set=Set(charging_power_left=0, regulate_up=False)) 2024-04-25 16:43:50,463 - {control.data:237} - {INFO:MainThread} - cp_all_data AllChargepointData(get=AllGet(daily_imported=6719.0, daily_exported=0.0, power=0, imported=529671.02, exported=0)) 2024-04-25 16:43:50,465 - {control.data:266} - {INFO:MainThread} - cp1 ChargepointData(control_parameter=ControlParameter(chargemode=<Chargemode.PV_CHARGING: 'pv_charging'>, current_plan='Zielladen-Standard', failed_phase_switches=0, imported_at_plan_start=529671.02, imported_instant_charging=None, limit=None, phases=1, prio=False, required_current=6, required_currents=[0.0, 0.0, 6], state=4, submode=<Chargemode.PV_CHARGING: 'pv_charging'>, timestamp_auto_phase_switch=None, timestamp_perform_phase_switch=None, timestamp_switch_on_off=None), get=Get(charge_state=False, 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=50), currents=[0.0, 0.0, 0.0], daily_imported=6719.0, daily_exported=0.0, evse_current=600, exported=0, fault_str='Kein Fehler.', fault_state=0, imported=529671.02, phases_in_use=1, plug_state=True, power=0, rfid_timestamp=None, rfid=None, serial_number='240121692', soc=None, soc_timestamp=None, state_str=None, vehicle_id=None, voltages=[227.15, 225.62, 224.75]), set=Set(change_ev_permitted=[True, ''], charging_ev=1, charging_ev_prev=1, current=6, energy_to_charge=0, loadmanagement_available=True, log=Log(chargemode_log_entry='_', costs=0, imported_at_mode_switch=529671.02, imported_at_plugtime=529671.02, imported_since_mode_switch=0, imported_since_plugged=0.0, range_charged=0, time_charged='00:00', timestamp_start_charging=None, ev=-1, prio=False, rfid=None, serial_number=None), manual_lock=False, phases_to_use=1, plug_state_prev=True, plug_time=1714052270.621543, required_power=1380.0, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x6ec700a0>), config=Config(configuration={'mode': 'series', 'ip_address': 'localhost', 'duo_num': 0}, ev=1, name='Interne openWB', type='internal_openwb', template=0, connected_phases=3, phase_1=3, auto_phase_switch_hw=1, control_pilot_interruption_hw=1, id=1)) 2024-04-25 16:43:50,466 - {control.data:266} - {INFO:MainThread} - cpt0 CpTemplateData(autolock=Autolock(active=False, plans={}, wait_for_charging_end=False), id=0, max_current_multi_phases=16, max_current_single_phase=16, name='Standard Ladepunkt-Profil', rfid_enabling=False, valid_tags=[]) 2024-04-25 16:43:50,467 - {control.data:266} - {INFO:MainThread} - counter2 CounterData(config=Config(max_currents=[63, 63, 63], max_total_power=43000), get=Get(powers=[-797, -832, -850], currents=[-3.73, -3.75, -3.79], voltages=[224.6, 227.6, 226.3], power_factors=[0.55999994277954, 0.68999993801117, 0.7299998998642], unbalanced_load=0, frequency=49.93, daily_exported=23830.0, daily_imported=3250.0, imported=6297220, exported=23333240, fault_state=0, fault_str='Kein Fehler.', power=-2372), set=Set(error_counter=0, reserved_surplus=0, released_surplus=0, raw_power_left=45372, raw_currents_left=[66.73, 66.75, 66.79], surplus_power_left=0, state_str='')) 2024-04-25 16:43:50,471 - {control.data:241} - {INFO:MainThread} - counter_all_data CounterAllData(config=Config(reserve_for_not_charging=True), get=Get(hierarchy=[{'id': 2, 'type': 'counter', 'children': [{'id': 3, 'type': 'inverter', 'children': []}, {'id': 1, 'type': 'cp', 'children': []}]}]), set=Set(loadmanagement_active=False, home_consumption=605.4499999999998, smarthome_power_excluded_from_home_consumption=0, invalid_home_consumption=0, daily_yield_home_consumption=8714.0, imported_home_consumption=1093466.089437625, disengageable_smarthome_power=0)) 2024-04-25 16:43:50,474 - {control.data:266} - {INFO:MainThread} - ct0 ChargeTemplateData(name='Standard-Lade-Profil', disable_after_unplug=False, prio=False, load_default=False, et=Et(active=False, max_price=0.0002), time_charging=TimeCharging(active=False, plans={}), chargemode=Chargemode(selected='pv_charging', pv_charging=PvCharging(min_soc_current=12, min_current=0, feed_in_limit=False, min_soc=0, max_soc=80), scheduled_charging=ScheduledCharging(plans={'1': ScheduledChargingPlan(active=True, frequency=Frequency(selected='weekly', once=['2021-11-01', '2021-11-05'], weekly=[True, True, True, True, False, False, False]), current=12, name='Zielladen-Standard', limit=ScheduledLimit(selected='soc', amount=1000, soc_limit=80, soc_scheduled=40), time='07:40')}), instant_charging=InstantCharging(current=13, limit=Limit(selected='soc', amount=50000, soc=60)))) 2024-04-25 16:43:50,479 - {control.data:266} - {INFO:MainThread} - ct1 ChargeTemplateData(name='Standard-Lade-Profil', disable_after_unplug=False, prio=False, load_default=False, et=Et(active=False, max_price=0.0002), time_charging=TimeCharging(active=False, plans={'0': TimeChargingPlan(active=False, frequency=Frequency(selected='weekly', once=['2021-11-01', '2021-11-05'], weekly=[True, True, True, True, True, False, False]), time=['07:00', '08:00'], name='Wochentags morgens', current=7, limit=Limit(selected='none', amount=1000, soc=50))}), chargemode=Chargemode(selected='stop', pv_charging=PvCharging(min_soc_current=10, min_current=0, feed_in_limit=False, min_soc=0, max_soc=100), scheduled_charging=ScheduledCharging(plans={'0': ScheduledChargingPlan(active=True, frequency=Frequency(selected='daily', once=['2021-11-01', '2021-11-05'], weekly=[False, False, False, False, False, False, False]), current=14, name='Morgens', limit=ScheduledLimit(selected='soc', amount=3000, soc_limit=90, soc_scheduled=80), time='07:45')}), instant_charging=InstantCharging(current=10, limit=Limit(selected='none', amount=1000, soc=50)))) 2024-04-25 16:43:50,481 - {control.data:266} - {INFO:MainThread} - ct2 ChargeTemplateData(name='Standard-Lade-Profil', disable_after_unplug=False, prio=False, load_default=False, et=Et(active=False, max_price=0.0002), time_charging=TimeCharging(active=False, plans={'2': TimeChargingPlan(active=True, frequency=Frequency(selected='weekly', once=['2021-11-01', '2021-11-05'], weekly=[True, True, True, True, True, False, False]), time=['07:15', '08:00'], name='Wochentags morgens', current=7, limit=Limit(selected='none', amount=1000, soc=50))}), chargemode=Chargemode(selected='stop', 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=10, limit=Limit(selected='none', amount=1000, soc=50)))) 2024-04-25 16:43:50,487 - {control.data:266} - {INFO:MainThread} - ev0 EvData(set=Set(soc_error_counter=0), charge_template=0, ev_template=0, name='Standard-Fahrzeug', tag_id=[], get=Get(soc=0, soc_timestamp=1706991493.0, force_soc_update=True, range=None, fault_state=0, fault_str='Kein Fehler.')) 2024-04-25 16:43:50,490 - {control.data:266} - {INFO:MainThread} - ev1 EvData(set=Set(soc_error_counter=0), charge_template=0, ev_template=1, name='Opel Corsa-e', tag_id=[], get=Get(soc=50, soc_timestamp=1714052270.676733, force_soc_update=False, range=94, fault_state=0, fault_str='Kein Fehler.')) 2024-04-25 16:43:50,491 - {control.data:266} - {INFO:MainThread} - et0 EvTemplateData(name='Standard-Fahrzeug-Profil', max_current_multi_phases=16, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=True, control_pilot_interruption_duration=7, average_consump=17000, min_current=6, max_current_single_phase=32, battery_capacity=46000, efficiency=95, nominal_difference=1, keep_charge_active_duration=50) 2024-04-25 16:43:50,496 - {control.data:266} - {INFO:MainThread} - et1 EvTemplateData(name='Opel Corsa-e', max_current_multi_phases=16, max_phases=3, phase_switch_pause=60, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=True, control_pilot_interruption_duration=4, average_consump=20000, min_current=6, max_current_single_phase=16, battery_capacity=46000, efficiency=95, nominal_difference=1, keep_charge_active_duration=40) 2024-04-25 16:43:50,498 - {control.data:245} - {INFO:MainThread} - general_data GeneralData(chargemode_config=ChargemodeConfig(instant_charging=InstantCharging(phases_to_use=3), pv_charging=PvCharging(bat_power_reserve=200, bat_power_reserve_active=False, control_range=[-115, 115], feed_in_yield=0, phase_switch_delay=5, phases_to_use=0, bat_power_discharge=1000, bat_power_discharge_active=False, min_bat_soc=50, bat_mode='min_soc_bat_mode', switch_off_delay=180, switch_off_threshold=500, switch_on_delay=30, switch_on_threshold=1500), retry_failed_phase_switches=True, scheduled_charging=ScheduledCharging(phases_to_use=0), time_charging=TimeCharging(phases_to_use=3), unbalanced_load_limit=18, unbalanced_load=False), control_interval=20, extern_display_mode='primary', 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, prices=Prices(bat=0.00033, cp=0, grid=0.00033, pv=7e-05), range_unit='km', ripple_control_receiver=RippleControlReceiver(get=RippleControlReceiverGet(fault_state=0, fault_str='Kein Fehler.', override_value=100), module=None, overrice_reference=<OverrideReference.CHARGEPOINT: 'chargepoint'>)) 2024-04-25 16:43:50,501 - {control.data:246} - {INFO:MainThread} - general_data-display primary 2024-04-25 16:43:50,503 - {control.data:247} - {INFO:MainThread} - graph_data GraphData(config=Config(duration=120)) 2024-04-25 16:43:50,504 - {control.data:248} - {INFO:MainThread} - optional_data OptionalData(et=Et(get=EtGet(fault_state=0, fault_str='Kein Fehler.', prices={})), int_display=InternalDisplay(active=False, on_if_plugged_in=True, pin_active=False, pin_code='0000', standby=60, theme=<modules.display_themes.cards.config.CardsDisplayTheme object at 0x6ec7b8b0>), led=Led(active=False), rfid=Rfid(active=True)) 2024-04-25 16:43:50,505 - {control.data:266} - {INFO:MainThread} - pv3 PvData(config=Config(max_ac_out=13000), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=34990.0, monthly_exported=971060, yearly_exported=2177020, exported=28335000, fault_state=0, fault_str='Kein Fehler.', power=-2977.45)) 2024-04-25 16:43:50,507 - {control.data:250} - {INFO:MainThread} - pv_all_data PvAllData(config=Config(configured=True), get=Get(daily_exported=34990.0, fault_str='Kein Fehler.', fault_state=0, monthly_exported=971060, yearly_exported=28334620, exported=28335000, power=-2977.45)) 2024-04-25 16:43:50,510 - {control.data:266} - {INFO:MainThread} - system {'update_in_progress': False, 'perform_update': False, 'ip_address': '192.168.1.60', 'current_commit': '2024-04-19 16:02:46 +0200 [72f765e68]', 'current_branch': 'Beta', 'current_branch_commit': '2024-04-19 16:02:46 +0200 [72f765e68]', 'current_missing_commits': [], 'datastore_version': 44, 'dataprotection_acknowledged': True, 'usage_terms_acknowledged': True, 'debug_level': 10, 'release_train': 'master', 'version': '2.1.4-Beta.1', 'boot_done': True, 'lastlivevaluesJson': {'timestamp': 1714056210, 'time': '16:43:30', 'grid': -2.48, 'house-power': 0.583, 'charging-all': 0.0, 'pv-all': 3.063, 'cp1-power': 0.0, 'ev1-soc': 50}, 'backup_before_update': True, 'module_update_completed': True} 2024-04-25 16:43:50,516 - {dataclass_utils._dataclass_asdict:23} - {DEBUG:MainThread} - {'name': 'MQTT', 'type': 'mqtt', 'id': 1, 'configuration': <modules.devices.mqtt.config.MqttConfiguration object at 0x712a4e38>} 2024-04-25 16:43:50,518 - {dataclass_utils._dataclass_asdict:23} - {DEBUG:MainThread} - {} 2024-04-25 16:43:50,521 - {control.data:279} - {INFO:MainThread} - device1 {'name': 'MQTT', 'type': 'mqtt', 'id': 1, 'configuration': {}} 2024-04-25 16:43:50,523 - {dataclass_utils._dataclass_asdict:23} - {DEBUG:MainThread} - {'name': 'MQTT-Zähler', 'type': 'counter', 'id': 2, 'configuration': <modules.devices.mqtt.config.MqttCounterConfiguration object at 0x700c0688>} 2024-04-25 16:43:50,524 - {dataclass_utils._dataclass_asdict:23} - {DEBUG:MainThread} - {} 2024-04-25 16:43:50,525 - {control.data:281} - {INFO:MainThread} - component2 {'name': 'MQTT-Zähler', 'type': 'counter', 'id': 2, 'configuration': {}} 2024-04-25 16:43:50,526 - {dataclass_utils._dataclass_asdict:23} - {DEBUG:MainThread} - {'name': 'MQTT-Wechselrichter', 'type': 'inverter', 'id': 3, 'configuration': <modules.devices.mqtt.config.MqttInverterConfiguration object at 0x700c07a8>} 2024-04-25 16:43:50,526 - {dataclass_utils._dataclass_asdict:23} - {DEBUG:MainThread} - {} 2024-04-25 16:43:50,527 - {control.data:281} - {INFO:MainThread} - component3 {'name': 'MQTT-Wechselrichter', 'type': 'inverter', 'id': 3, 'configuration': {}} 2024-04-25 16:43:50,527 - {control.data:253} - {INFO:MainThread} - 2024-04-25 16:43:50,528 - {control.algorithm.algorithm:25} - {INFO:MainThread} - # Algorithmus 2024-04-25 16:43:50,529 - {control.counter:204} - {INFO:MainThread} - Überschuss zur PV-geführten Ladung: -2372W 2024-04-25 16:43:50,530 - {control.counter:382} - {DEBUG:MainThread} - LP1 Switch-Off-Threshold prüfen: -2372W, Schwelle: 500W, freigegebener Überschuss 0W, Einspeisegrenze 0W 2024-04-25 16:43:50,530 - {control.counter:249} - {DEBUG:MainThread} - Anpassen des Regelbereichs 0.0W 2024-04-25 16:43:50,531 - {control.counter:217} - {INFO:MainThread} - Überschuss zur PV-geführten Ladung: 2372.0W 2024-04-25 16:43:50,531 - {control.algorithm.algorithm:30} - {INFO:MainThread} - **Mindestrom setzen** 2024-04-25 16:43:50,534 - {control.algorithm.min_current:18} - {INFO:MainThread} - Mode-Tuple Chargemode.PV_CHARGING - Chargemode.PV_CHARGING - False, Zähler 2 2024-04-25 16:43:50,535 - {control.counter:176} - {DEBUG:MainThread} - Zähler 2: [66.73, 66.75, 60.790000000000006]A verbleibende Ströme, 43992W verbleibende Leistung 2024-04-25 16:43:50,536 - {control.algorithm.common:95} - {INFO:MainThread} - LP1: Stromstärke 6A 2024-04-25 16:43:50,537 - {control.algorithm.algorithm:32} - {INFO:MainThread} - **Sollstrom setzen** 2024-04-25 16:43:50,540 - {control.counter:249} - {DEBUG:MainThread} - Anpassen des Regelbereichs 0.0W 2024-04-25 16:43:50,540 - {control.counter:217} - {INFO:MainThread} - Überschuss zur PV-geführten Ladung: 992.0W 2024-04-25 16:43:50,541 - {control.counter:495} - {DEBUG:MainThread} - Zähler 2: Begrenzung der verbleibenden Leistung auf 992.0W 2024-04-25 16:43:50,542 - {control.algorithm.algorithm:38} - {INFO:MainThread} - **PV-geführten Strom setzen** 2024-04-25 16:43:50,544 - {control.algorithm.filter_chargepoints:116} - {DEBUG:MainThread} - Geordnete Ladepunkte [1] 2024-04-25 16:43:50,545 - {control.algorithm.filter_chargepoints:49} - {INFO:MainThread} - LP 1: Lädt nicht, daher keine weitere Berücksichtigung 2024-04-25 16:43:50,545 - {control.process:23} - {INFO:MainThread} - # Ladung starten. 2024-04-25 16:43:50,547 - {dataclass_utils._dataclass_asdict:23} - {DEBUG:MainThread} - {'chargemode_log_entry': '_', 'costs': 0, 'imported_at_mode_switch': 529671.02, 'imported_at_plugtime': 529671.02, 'imported_since_mode_switch': 0, 'imported_since_plugged': 0.0, 'range_charged': 0, 'time_charged': '00:00', 'timestamp_start_charging': None, 'ev': -1, 'prio': False, 'rfid': None, 'serial_number': None} 2024-04-25 16:43:50,549 - {control.process:111} - {INFO:MainThread} - LP1: set current 6 A, state CHARGING_ALLOWED 2024-04-25 16:43:50,558 - {modules.common.component_context:25} - {DEBUG:set current cp1} - Update Komponente ['Ladepunkt'] 2024-04-25 16:43:50,592 - {control.counter:193} - {INFO:MainThread} - 0W reservierte EVU-Leistung, 0W freigegebene EVU-Leistung
Ich war gemeint
