pv_opt
pv_opt copied to clipboard
fboundy
New timezone issue
Getting the following in the log
2025-04-22 12:37:54.384071 WARNING pv_opt: ------------------------------------------------------------
--
ValueError: Both dates must have the same UTC offset
raise ValueError("Both dates must have the same UTC offset")
File "/usr/lib/python3.11/site-packages/pandas/core/indexes/base.py", line 6875, in slice_locs
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
start_slice, end_slice = self.slice_locs(start, end, step=step)
File "/usr/lib/python3.11/site-packages/pandas/core/indexes/base.py", line 6662, in slice_indexer
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
return Index.slice_indexer(self, start, end, step)
File "/usr/lib/python3.11/site-packages/pandas/core/indexes/datetimes.py", line 682, in slice_indexer
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
indexer = labels.slice_indexer(slice_obj.start, slice_obj.stop, slice_obj.step)
File "/usr/lib/python3.11/site-packages/pandas/core/indexing.py", line 1443, in _get_slice_axis
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
return self._get_slice_axis(key, axis=axis)
File "/usr/lib/python3.11/site-packages/pandas/core/indexing.py", line 1411, in _getitem_axis
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
return self._getitem_axis(maybe_callable, axis=axis)
File "/usr/lib/python3.11/site-packages/pandas/core/indexing.py", line 1191, in __getitem__
~~~~~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^
return getattr(section, self.name)[new_key]
File "/usr/lib/python3.11/site-packages/pandas/core/indexing.py", line 1089, in _getitem_lowerdim
^^^^^^^^^^^^^^^^^^^^^^^^^^^
return self._getitem_lowerdim(tup)
File "/usr/lib/python3.11/site-packages/pandas/core/indexing.py", line 1368, in _getitem_tuple
^^^^^^^^^^^^^^^^^^^^^^^^
return self._getitem_tuple(key)
File "/usr/lib/python3.11/site-packages/pandas/core/indexing.py", line 1184, in __getitem__
~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
df.loc[event_start:event_end, "unit"] += event_value
File "/homeassistant/appdaemon/apps/pv_opt/pvpy.py", line 385, in to_df
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
imp_df = self.tariffs["import"].to_df(start=start.floor("30min"), end=end, **kwargs)
File "/homeassistant/appdaemon/apps/pv_opt/pvpy.py", line 659, in net_cost
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
cost_today = self.contract.net_cost(grid_flow=grid, log=self.debug, day_ahead=False, sum=False)
File "/homeassistant/appdaemon/apps/pv_opt/pv_opt.py", line 1424, in _cost_actual
self._cost_actual()
File "/homeassistant/appdaemon/apps/pv_opt/pv_opt.py", line 671, in initialize
^^^^^^^^^^^^^^
return f(*args, **kw)
File "/usr/lib/python3.11/site-packages/appdaemon/adbase.py", line 35, in f_app_lock
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
result = self.fn(*self.args, **self.kwargs)
File "/usr/lib/python3.11/concurrent/futures/thread.py", line 58, in run
^^^^^^^^^^^^^^^
response = future.result()
File "/usr/lib/python3.11/site-packages/appdaemon/utils.py", line 304, in run_in_executor
await utils.run_in_executor(self, init)
File "/usr/lib/python3.11/site-packages/appdaemon/app_management.py", line 162, in initialize_app
2025-04-22 12:37:54.383968 WARNING pv_opt: Traceback (most recent call last):
2025-04-22 12:37:54.381107 WARNING pv_opt: ------------------------------------------------------------
2025-04-22 12:37:54.381040 WARNING pv_opt: Unexpected error running initialize() for pv_opt
2025-04-22 12:37:54.380926 WARNING pv_opt: ------------------------------------------------------------
Started at noon today. I'm guessing Octopus have changed 'something'
Or is this caused by the Saving Session that's on today - 1st with GMT+1 this year
More logging (debug options OTFV): Looks like octopus have forgotten it's BST in their data...
Log Entry
--
2025-04-22 14:49:32.812472 INFO: >>> Start: 22/04 00:00 UTC End: 22/04 13:30 UTC
2025-04-22 14:49:32.811873 INFO: >>> E-1R-INTELLI-VAR-24-10-29-H
2025-04-22 14:49:32.753318 INFO: >>> Start: 22-Apr 00:00 UTC End: 22-Apr 13:49 UTC
2025-04-22 14:49:32.752806 INFO:
2025-04-22 14:49:32.752321 INFO: No entry found in config.yaml for plug_status sensor, leaving any autodetected sensor in place.
2025-04-22 14:49:32.751821 INFO:
2025-04-22 14:49:32.751265 INFO: sensor.myenergi_zappi_********_plug_status
2025-04-22 14:49:32.750757 INFO: Zappi plug_status sensor(s) found:
2025-04-22 14:49:32.750211 INFO: Attempting to autodetect Zappi Plugin status sensor(s)
2025-04-22 14:49:32.749743 INFO:
2025-04-22 14:49:32.749267 INFO: sensor.myenergi_zappi_********_charge_added_session
2025-04-22 14:49:32.748744 INFO: Zappi consumption sensor(s) found:
2025-04-22 14:49:32.735079 INFO: Attempting to autodetect Zappi consumption sensor(s)
2025-04-22 14:49:32.734631 INFO:
2025-04-22 14:49:32.734154 INFO: ----------------
2025-04-22 14:49:32.733676 INFO: Reading Zappi(s)
2025-04-22 14:49:32.733190 INFO:
2025-04-22 14:49:32.732452 INFO: Finished loading contract
2025-04-22 14:49:32.731844 INFO:
2025-04-22 14:49:32.731236 INFO: 1354: 22-Apr 18:00 UTC+01:00 - 22-Apr 19:00 UTC+01:00 at 11.9p/kWh
2025-04-22 14:49:32.730464 INFO: The following Octopus Saving Events have been joined:
2025-04-22 14:49:32.729753 INFO:
2025-04-22 14:49:32.728086 INFO: Found Octopus Savings Events entity: event.octopus_energy_**********_octoplus_saving_session_events
2025-04-22 14:49:32.727395 INFO:
2025-04-22 14:49:32.722606 INFO:
2025-04-22 14:49:32.721959 INFO: Contract tariffs loaded OK
2025-04-22 14:49:32.721451 INFO:
2025-04-22 14:49:32.720662 INFO: No IOG Smart Charging Schedule found.
2025-04-22 14:49:32.720040 INFO: Octopus Intelligent Go Smart Charging Schedule is....
2025-04-22 14:49:32.719454 INFO:
2025-04-22 14:49:32.718076 INFO: Current Dispatch Status (On/off) = : off
2025-04-22 14:49:32.716832 INFO:
2025-04-22 14:49:32.716285 INFO: -----------------------------------------------------------
2025-04-22 14:49:32.715744 INFO: Reloading IOG Car slots from Intelligent Dispatching Sensor
2025-04-22 14:49:32.715207 INFO:
2025-04-22 14:49:32.714658 INFO: Charge to Add Value = : 80
2025-04-22 14:49:32.713708 INFO: Found Charge to Add entity: number.octopus_energy_**********_intelligent_charge_target
2025-04-22 14:49:32.711102 INFO: Trying to find Car % Charge to add from Octopus Energy Integration
2025-04-22 14:49:32.710573 INFO:
2025-04-22 14:49:32.710026 INFO: Found Dispatching Sensor: binary_sensor.octopus_energy_**********_intelligent_dispatching
2025-04-22 14:49:32.707218 INFO: Trying to find Octopus Intelligent Dispatching Sensor from Octopus Energy Integration
2025-04-22 14:49:32.706706 INFO:
2025-04-22 14:49:32.706160 INFO: -------------------------
2025-04-22 14:49:32.705607 INFO: Getting Car Charging Plan
2025-04-22 14:49:32.705044 INFO:
2025-04-22 14:49:32.623149 INFO: >>>X _load_contract E-1R-OUTGOING-FIX-12M-19-05-13-H
2025-04-22 14:49:32.621228 INFO: >>>export: ['event.octopus_energy_electricity_22j0076737_2000060308364_export_current_day_rates']
2025-04-22 14:49:32.620743 INFO: start 2025-04-21 23:00:00+00:00 7.0003 2025-04-21 23:30:00+00:00 7.0003 2025-04-22 00:00:00+00:00 7.0003 2025-04-22 00:30:00+00:00 7.0003 2025-04-22 01:00:00+00:00 7.0003 2025-04-22 01:30:00+00:00 7.0003 2025-04-22 02:00:00+00:00 7.0003 2025-04-22 02:30:00+00:00 7.0003 2025-04-22 03:00:00+00:00 7.0003 2025-04-22 03:30:00+00:00 7.0003 2025-04-22 04:00:00+00:00 7.0003 2025-04-22 04:30:00+00:00 28.7898 2025-04-22 05:00:00+00:00 28.7898 2025-04-22 05:30:00+00:00 28.7898 2025-04-22 06:00:00+00:00 28.7898 2025-04-22 06:30:00+00:00 28.7898 2025-04-22 07:00:00+00:00 28.7898 2025-04-22 07:30:00+00:00 28.7898 2025-04-22 08:00:00+00:00 28.7898 2025-04-22 08:30:00+00:00 28.7898 2025-04-22 09:00:00+00:00 28.7898 2025-04-22 09:30:00+00:00 28.7898 2025-04-22 10:00:00+00:00 28.7898 2025-04-22 10:30:00+00:00 28.7898 2025-04-22 11:00:00+00:00 28.7898 2025-04-22 11:30:00+00:00 28.7898 2025-04-22 12:00:00+00:00 28.7898 2025-04-22 12:30:00+00:00 28.7898 2025-04-22 13:00:00+00:00 28.7898 2025-04-22 13:30:00+00:00 28.7898 2025-04-22 14:00:00+00:00 28.7898 2025-04-22 14:30:00+00:00 28.7898 2025-04-22 15:00:00+00:00 28.7898 2025-04-22 15:30:00+00:00 28.7898 2025-04-22 16:00:00+00:00 28.7898 2025-04-22 16:30:00+00:00 28.7898 2025-04-22 17:00:00+00:00 28.7898 2025-04-22 17:30:00+00:00 28.7898 2025-04-22 18:00:00+00:00 28.7898 2025-04-22 18:30:00+00:00 28.7898 2025-04-22 19:00:00+00:00 28.7898 2025-04-22 19:30:00+00:00 28.7898 2025-04-22 20:00:00+00:00 28.7898 2025-04-22 20:30:00+00:00 28.7898 2025-04-22 21:00:00+00:00 28.7898 2025-04-22 21:30:00+00:00 28.7898 2025-04-22 22:00:00+00:00 28.7898 2025-04-22 22:30:00+00:00 7.0003 2025-04-22 23:00:00+00:00 7.0003 2025-04-22 23:30:00+00:00 7.0003 2025-04-23 00:00:00+00:00 7.0003 2025-04-23 00:30:00+00:00 7.0003 2025-04-23 01:00:00+00:00 7.0003 2025-04-23 01:30:00+00:00 7.0003 2025-04-23 02:00:00+00:00 7.0003 2025-04-23 02:30:00+00:00 7.0003 2025-04-23 03:00:00+00:00 7.0003 2025-04-23 03:30:00+00:00 7.0003 2025-04-23 04:00:00+00:00 7.0003 2025-04-23 04:30:00+00:00 28.7898 2025-04-23 05:00:00+00:00 28.7898 2025-04-23 05:30:00+00:00 28.7898 2025-04-23 06:00:00+00:00 28.7898 2025-04-23 06:30:00+00:00 28.7898 2025-04-23 07:00:00+00:00 28.7898 2025-04-23 07:30:00+00:00 28.7898 2025-04-23 08:00:00+00:00 28.7898 2025-04-23 08:30:00+00:00 28.7898 2025-04-23 09:00:00+00:00 28.7898 2025-04-23 09:30:00+00:00 28.7898 2025-04-23 10:00:00+00:00 28.7898 2025-04-23 10:30:00+00:00 28.7898 2025-04-23 11:00:00+00:00 28.7898 2025-04-23 11:30:00+00:00 28.7898 2025-04-23 12:00:00+00:00 28.7898 2025-04-23 12:30:00+00:00 28.7898 2025-04-23 13:00:00+00:00 28.7898 2025-04-23 13:30:00+00:00 28.7898 2025-04-23 14:00:00+00:00 28.7898 2025-04-23 14:30:00+00:00 28.7898 2025-04-23 15:00:00+00:00 28.7898 2025-04-23 15:30:00+00:00 28.7898 2025-04-23 16:00:00+00:00 28.7898 2025-04-23 16:30:00+00:00 28.7898 2025-04-23 17:00:00+00:00 28.7898 2025-04-23 17:30:00+00:00 28.7898 2025-04-23 18:00:00+00:00 28.7898 2025-04-23 18:30:00+00:00 28.7898 2025-04-23 19:00:00+00:00 28.7898 2025-04-23 19:30:00+00:00 28.7898 2025-04-23 20:00:00+00:00 28.7898 2025-04-23 20:30:00+00:00 28.7898 2025-04-23 21:00:00+00:00 28.7898 2025-04-23 21:30:00+00:00 28.7898 2025-04-23 22:00:00+00:00 28.7898 2025-04-23 22:30:00+00:00 7.0003
2025-04-22 14:49:32.618730 INFO: IOG prices are
2025-04-22 14:49:32.618119 INFO:
2025-04-22 14:49:32.616984 INFO: start 2025-04-22 23:00:00+00:00 7.0003 2025-04-22 23:30:00+00:00 7.0003 2025-04-23 00:00:00+00:00 7.0003 2025-04-23 00:30:00+00:00 7.0003 2025-04-23 01:00:00+00:00 7.0003 2025-04-23 01:30:00+00:00 7.0003 2025-04-23 02:00:00+00:00 7.0003 2025-04-23 02:30:00+00:00 7.0003 2025-04-23 03:00:00+00:00 7.0003 2025-04-23 03:30:00+00:00 7.0003 2025-04-23 04:00:00+00:00 7.0003 2025-04-23 04:30:00+00:00 28.7898 2025-04-23 05:00:00+00:00 28.7898 2025-04-23 05:30:00+00:00 28.7898 2025-04-23 06:00:00+00:00 28.7898 2025-04-23 06:30:00+00:00 28.7898 2025-04-23 07:00:00+00:00 28.7898 2025-04-23 07:30:00+00:00 28.7898 2025-04-23 08:00:00+00:00 28.7898 2025-04-23 08:30:00+00:00 28.7898 2025-04-23 09:00:00+00:00 28.7898 2025-04-23 09:30:00+00:00 28.7898 2025-04-23 10:00:00+00:00 28.7898 2025-04-23 10:30:00+00:00 28.7898 2025-04-23 11:00:00+00:00 28.7898 2025-04-23 11:30:00+00:00 28.7898 2025-04-23 12:00:00+00:00 28.7898 2025-04-23 12:30:00+00:00 28.7898 2025-04-23 13:00:00+00:00 28.7898 2025-04-23 13:30:00+00:00 28.7898 2025-04-23 14:00:00+00:00 28.7898 2025-04-23 14:30:00+00:00 28.7898 2025-04-23 15:00:00+00:00 28.7898 2025-04-23 15:30:00+00:00 28.7898 2025-04-23 16:00:00+00:00 28.7898 2025-04-23 16:30:00+00:00 28.7898 2025-04-23 17:00:00+00:00 28.7898 2025-04-23 17:30:00+00:00 28.7898 2025-04-23 18:00:00+00:00 28.7898 2025-04-23 18:30:00+00:00 28.7898 2025-04-23 19:00:00+00:00 28.7898 2025-04-23 19:30:00+00:00 28.7898 2025-04-23 20:00:00+00:00 28.7898 2025-04-23 20:30:00+00:00 28.7898 2025-04-23 21:00:00+00:00 28.7898 2025-04-23 21:30:00+00:00 28.7898 2025-04-23 22:00:00+00:00 28.7898 2025-04-23 22:30:00+00:00 7.0003
2025-04-22 14:49:32.615613 INFO: Reading next day IOG prices from event.octopus_energy_electricity_************************_next_day_rates
2025-04-22 14:49:32.613975 INFO: start end value_inc_vat is_capped 0 2025-04-23T00:00:00+01:00 2025-04-23T00:30:00+01:00 0.070003 False 1 2025-04-23T00:30:00+01:00 2025-04-23T01:00:00+01:00 0.070003 False 2 2025-04-23T01:00:00+01:00 2025-04-23T01:30:00+01:00 0.070003 False 3 2025-04-23T01:30:00+01:00 2025-04-23T02:00:00+01:00 0.070003 False 4 2025-04-23T02:00:00+01:00 2025-04-23T02:30:00+01:00 0.070003 False 5 2025-04-23T02:30:00+01:00 2025-04-23T03:00:00+01:00 0.070003 False 6 2025-04-23T03:00:00+01:00 2025-04-23T03:30:00+01:00 0.070003 False 7 2025-04-23T03:30:00+01:00 2025-04-23T04:00:00+01:00 0.070003 False 8 2025-04-23T04:00:00+01:00 2025-04-23T04:30:00+01:00 0.070003 False 9 2025-04-23T04:30:00+01:00 2025-04-23T05:00:00+01:00 0.070003 False 10 2025-04-23T05:00:00+01:00 2025-04-23T05:30:00+01:00 0.070003 False 11 2025-04-23T05:30:00+01:00 2025-04-23T06:00:00+01:00 0.287898 False 12 2025-04-23T06:00:00+01:00 2025-04-23T06:30:00+01:00 0.287898 False 13 2025-04-23T06:30:00+01:00 2025-04-23T07:00:00+01:00 0.287898 False 14 2025-04-23T07:00:00+01:00 2025-04-23T07:30:00+01:00 0.287898 False 15 2025-04-23T07:30:00+01:00 2025-04-23T08:00:00+01:00 0.287898 False 16 2025-04-23T08:00:00+01:00 2025-04-23T08:30:00+01:00 0.287898 False 17 2025-04-23T08:30:00+01:00 2025-04-23T09:00:00+01:00 0.287898 False 18 2025-04-23T09:00:00+01:00 2025-04-23T09:30:00+01:00 0.287898 False 19 2025-04-23T09:30:00+01:00 2025-04-23T10:00:00+01:00 0.287898 False 20 2025-04-23T10:00:00+01:00 2025-04-23T10:30:00+01:00 0.287898 False 21 2025-04-23T10:30:00+01:00 2025-04-23T11:00:00+01:00 0.287898 False 22 2025-04-23T11:00:00+01:00 2025-04-23T11:30:00+01:00 0.287898 False 23 2025-04-23T11:30:00+01:00 2025-04-23T12:00:00+01:00 0.287898 False 24 2025-04-23T12:00:00+01:00 2025-04-23T12:30:00+01:00 0.287898 False 25 2025-04-23T12:30:00+01:00 2025-04-23T13:00:00+01:00 0.287898 False 26 2025-04-23T13:00:00+01:00 2025-04-23T13:30:00+01:00 0.287898 False 27 2025-04-23T13:30:00+01:00 2025-04-23T14:00:00+01:00 0.287898 False 28 2025-04-23T14:00:00+01:00 2025-04-23T14:30:00+01:00 0.287898 False 29 2025-04-23T14:30:00+01:00 2025-04-23T15:00:00+01:00 0.287898 False 30 2025-04-23T15:00:00+01:00 2025-04-23T15:30:00+01:00 0.287898 False 31 2025-04-23T15:30:00+01:00 2025-04-23T16:00:00+01:00 0.287898 False 32 2025-04-23T16:00:00+01:00 2025-04-23T16:30:00+01:00 0.287898 False 33 2025-04-23T16:30:00+01:00 2025-04-23T17:00:00+01:00 0.287898 False 34 2025-04-23T17:00:00+01:00 2025-04-23T17:30:00+01:00 0.287898 False 35 2025-04-23T17:30:00+01:00 2025-04-23T18:00:00+01:00 0.287898 False 36 2025-04-23T18:00:00+01:00 2025-04-23T18:30:00+01:00 0.287898 False 37 2025-04-23T18:30:00+01:00 2025-04-23T19:00:00+01:00 0.287898 False 38 2025-04-23T19:00:00+01:00 2025-04-23T19:30:00+01:00 0.287898 False 39 2025-04-23T19:30:00+01:00 2025-04-23T20:00:00+01:00 0.287898 False 40 2025-04-23T20:00:00+01:00 2025-04-23T20:30:00+01:00 0.287898 False 41 2025-04-23T20:30:00+01:00 2025-04-23T21:00:00+01:00 0.287898 False 42 2025-04-23T21:00:00+01:00 2025-04-23T21:30:00+01:00 0.287898 False 43 2025-04-23T21:30:00+01:00 2025-04-23T22:00:00+01:00 0.287898 False 44 2025-04-23T22:00:00+01:00 2025-04-23T22:30:00+01:00 0.287898 False 45 2025-04-23T22:30:00+01:00 2025-04-23T23:00:00+01:00 0.287898 False 46 2025-04-23T23:00:00+01:00 2025-04-23T23:30:00+01:00 0.287898 False 47 2025-04-23T23:30:00+01:00 2025-04-24T00:00:00+01:00 0.070003 False
2025-04-22 14:49:32.611996 INFO: Read of Bottlecap next day rate entity simplfied is.....
2025-04-22 14:49:32.611396 INFO:
2025-04-22 14:49:32.609976 INFO: start 2025-04-21 23:00:00+00:00 7.0003 2025-04-21 23:30:00+00:00 7.0003 2025-04-22 00:00:00+00:00 7.0003 2025-04-22 00:30:00+00:00 7.0003 2025-04-22 01:00:00+00:00 7.0003 2025-04-22 01:30:00+00:00 7.0003 2025-04-22 02:00:00+00:00 7.0003 2025-04-22 02:30:00+00:00 7.0003 2025-04-22 03:00:00+00:00 7.0003 2025-04-22 03:30:00+00:00 7.0003 2025-04-22 04:00:00+00:00 7.0003 2025-04-22 04:30:00+00:00 28.7898 2025-04-22 05:00:00+00:00 28.7898 2025-04-22 05:30:00+00:00 28.7898 2025-04-22 06:00:00+00:00 28.7898 2025-04-22 06:30:00+00:00 28.7898 2025-04-22 07:00:00+00:00 28.7898 2025-04-22 07:30:00+00:00 28.7898 2025-04-22 08:00:00+00:00 28.7898 2025-04-22 08:30:00+00:00 28.7898 2025-04-22 09:00:00+00:00 28.7898 2025-04-22 09:30:00+00:00 28.7898 2025-04-22 10:00:00+00:00 28.7898 2025-04-22 10:30:00+00:00 28.7898 2025-04-22 11:00:00+00:00 28.7898 2025-04-22 11:30:00+00:00 28.7898 2025-04-22 12:00:00+00:00 28.7898 2025-04-22 12:30:00+00:00 28.7898 2025-04-22 13:00:00+00:00 28.7898 2025-04-22 13:30:00+00:00 28.7898 2025-04-22 14:00:00+00:00 28.7898 2025-04-22 14:30:00+00:00 28.7898 2025-04-22 15:00:00+00:00 28.7898 2025-04-22 15:30:00+00:00 28.7898 2025-04-22 16:00:00+00:00 28.7898 2025-04-22 16:30:00+00:00 28.7898 2025-04-22 17:00:00+00:00 28.7898 2025-04-22 17:30:00+00:00 28.7898 2025-04-22 18:00:00+00:00 28.7898 2025-04-22 18:30:00+00:00 28.7898 2025-04-22 19:00:00+00:00 28.7898 2025-04-22 19:30:00+00:00 28.7898 2025-04-22 20:00:00+00:00 28.7898 2025-04-22 20:30:00+00:00 28.7898 2025-04-22 21:00:00+00:00 28.7898 2025-04-22 21:30:00+00:00 28.7898 2025-04-22 22:00:00+00:00 28.7898 2025-04-22 22:30:00+00:00 7.0003
2025-04-22 14:49:32.608626 INFO: Reading current day IOG prices from event.octopus_energy_electricity_************************_current_day_rates
2025-04-22 14:49:32.605746 INFO:
2025-04-22 14:49:32.605180 INFO: Downloading IOG pricing information from Octopus Energy Integration
2025-04-22 14:49:32.604604 INFO:
2025-04-22 14:49:32.603987 INFO: Octopus Intelligent Import Entity found: ['event.octopus_energy_electricity_************************_current_day_rates']
2025-04-22 14:49:32.601132 INFO: Trying to find Octopus Intelligent Entities from Octopus Energy Integration:
2025-04-22 14:49:32.437020 INFO: >>>X _load_contract E-1R-INTELLI-VAR-24-10-29-H
2025-04-22 14:49:32.435966 INFO: >>>import: ['event.octopus_energy_electricity_22j0076737_2000017817574_current_day_rates']
2025-04-22 14:49:32.435486 INFO: Found export entity event.octopus_energy_electricity_************************_export_current_day_rates: Tariff code: E-1R-OUTGOING-FIX-12M-19-05-13-H
2025-04-22 14:49:32.434496 INFO: Found import entity event.octopus_energy_electricity_************************_current_day_rates: Tariff code: E-1R-INTELLI-VAR-24-10-29-H
2025-04-22 14:49:32.431486 INFO: Trying to auto detect Octopus tariffs:
2025-04-22 14:49:32.430937 INFO: -----------------
2025-04-22 14:49:32.426733 INFO: Loading Contract:
2025-04-22 14:49:32.426192 INFO:
2025-04-22 14:49:32.419874 INFO: transfer_car_charge_plan switch.pvopt_transfer_car_charge_plan off
2025-04-22 14:49:32.418445 INFO: sleep_soc number.pvopt_sleep_soc 0
2025-04-22 14:49:32.417014 INFO: wakeup_soc number.pvopt_wakeup_soc 0
2025-04-22 14:49:32.415585 INFO: maximum_soc number.pvopt_maximum_soc 100
2025-04-22 14:49:32.414124 INFO: forced_power_group_tolerance number.pvopt_forced_power_group_tolerance 100
2025-04-22 14:49:32.412555 INFO: consumption_grouping select.pvopt_consumption_grouping mean
2025-04-22 14:49:32.410737 INFO: shape_consumption_profile switch.pvopt_shape_consumption_profile on
2025-04-22 14:49:32.409262 INFO: daily_consumption_kwh number.pvopt_daily_consumption_kwh 17
2025-04-22 14:49:32.407839 INFO: consumption_margin number.pvopt_consumption_margin 10
2025-04-22 14:49:32.406353 INFO: consumption_history_days number.pvopt_consumption_history_days 7
2025-04-22 14:49:32.404863 INFO: use_consumption_history switch.pvopt_use_consumption_history on
2025-04-22 14:49:32.403446 INFO: control_car_charging switch.pvopt_control_car_charging off
2025-04-22 14:49:32.402047 INFO: car_charging_ready_by select.pvopt_car_charging_ready_by 08:00
2025-04-22 14:49:32.400669 INFO: ev_charge_target_percent number.pvopt_ev_charge_target_percent 80
2025-04-22 14:49:32.399282 INFO: max_ev_price_p number.pvopt_max_ev_price_p 10.0
2025-04-22 14:49:32.397882 INFO: ev_charger_efficiency_percent number.pvopt_ev_charger_efficiency_percent 92
2025-04-22 14:49:32.396439 INFO: ev_charger select.pvopt_ev_charger Zappi
2025-04-22 14:49:32.395074 INFO: ev_battery_capacity_kwh number.pvopt_ev_battery_capacity_kwh 30
2025-04-22 14:49:32.393707 INFO: ev_charger_power_watts number.pvopt_ev_charger_power_watts 7000
2025-04-22 14:49:32.392293 INFO: battery_current_limit_amps number.pvopt_battery_current_limit_amps 100
2025-04-22 14:49:32.390722 INFO: inverter_loss_watts number.pvopt_inverter_loss_watts 100
2025-04-22 14:49:32.389354 INFO: inverter_power_watts number.pvopt_inverter_power_watts 5000
2025-04-22 14:49:32.387991 INFO: charger_power_watts number.pvopt_charger_power_watts 5000
2025-04-22 14:49:32.386625 INFO: charger_efficiency_percent number.pvopt_charger_efficiency_percent 91
2025-04-22 14:49:32.385211 INFO: inverter_efficiency_percent number.pvopt_inverter_efficiency_percent 97
2025-04-22 14:49:32.383773 INFO: battery_capacity_wh number.pvopt_battery_capacity_wh 12800
2025-04-22 14:49:32.382371 INFO: discharge_threshold_p number.pvopt_discharge_threshold_p 5.0
2025-04-22 14:49:32.380977 INFO: plunge_threshold_p_kwh number.pvopt_plunge_threshold_p_kwh -5.0
2025-04-22 14:49:32.379595 INFO: pass_threshold_p number.pvopt_pass_threshold_p 1.0
2025-04-22 14:49:32.378189 INFO: day_of_week_weighting number.pvopt_day_of_week_weighting 0.5
2025-04-22 14:49:32.376794 INFO: slot_threshold_p number.pvopt_slot_threshold_p 1.0
2025-04-22 14:49:32.375362 INFO: solcast_confidence_level number.pvopt_solcast_confidence_level 50
2025-04-22 14:49:32.373951 INFO: test_button button.pvopt_test_button 2024-05-26 17:33:46.469442+00:00
2025-04-22 14:49:32.372497 INFO: test_function select.pvopt_test_function Charge
2025-04-22 14:49:32.370991 INFO: test_enable select.pvopt_test_enable Enable
2025-04-22 14:49:32.369174 INFO: test_target_soc number.pvopt_test_target_soc 100
2025-04-22 14:49:32.367795 INFO: test_power number.pvopt_test_power 3000
2025-04-22 14:49:32.366367 INFO: test_end text.pvopt_test_end 00:00
2025-04-22 14:49:32.364977 INFO: test_start text.pvopt_test_start 00:00
2025-04-22 14:49:32.363618 INFO: optimise_frequency_minutes number.pvopt_optimise_frequency_minutes 10
2025-04-22 14:49:32.362228 INFO: prevent_discharge switch.pvopt_prevent_discharge off
2025-04-22 14:49:32.360823 INFO: ev_part_of_house_load switch.pvopt_ev_part_of_house_load on
2025-04-22 14:49:32.359425 INFO: use_solar switch.pvopt_use_solar on
2025-04-22 14:49:32.357988 INFO: allow_cyclic switch.pvopt_allow_cyclic off
2025-04-22 14:49:32.356576 INFO: forced_discharge switch.pvopt_forced_discharge on
2025-04-22 14:49:32.355116 INFO: include_export switch.pvopt_include_export on
2025-04-22 14:49:32.353476 INFO: read_only switch.pvopt_read_only off
2025-04-22 14:49:32.351522 INFO: ----------- --------- -------------
2025-04-22 14:49:32.350130 INFO: Config Item HA Entity Current State
2025-04-22 14:49:32.349220 INFO:
2025-04-22 14:49:32.348318 INFO: -----------------------------------
2025-04-22 14:49:32.347398 INFO: Syncing config with Home Assistant:
2025-04-22 14:49:32.346308 INFO:
2025-04-22 14:49:32.303071 INFO:
2025-04-22 14:49:32.302252 WARNING: id_solar_power = ['sensor.solmod_pv_power_1', 'sensor.solmod_pv_power_2'] 1187.2: system default. Not in YAML.
2025-04-22 14:49:32.300712 WARNING: id_backup_mode_soc = number.solmod_backup_mode_soc 100.0: system default. Not in YAML.
2025-04-22 14:49:32.299411 WARNING: id_inverter_mode = select.solmod_energy_storage_control_switch Self-Use: system default. Not in YAML.
2025-04-22 14:49:32.296746 WARNING: id_timed_charge_discharge_button = button.solmod_update_charge_discharge_times 2025-04-22T12:00:06.020978+00:00: system default. Not in YAML.
2025-04-22 14:49:32.295329 WARNING: id_timed_discharge_button = button.solmod_update_discharge_times button.solmod_update_discharge_times: system default. Not in YAML.
2025-04-22 14:49:32.294102 WARNING: id_timed_charge_button = button.solmod_update_charge_times button.solmod_update_charge_times: system default. Not in YAML.
2025-04-22 14:49:32.292860 WARNING: id_timed_discharge_soc = number.solmod_timed_discharge_soc number.solmod_timed_discharge_soc: system default. Not in YAML.
2025-04-22 14:49:32.291204 WARNING: id_timed_discharge_current = number.solmod_timed_discharge_current 0.0: system default. Not in YAML.
2025-04-22 14:49:32.289656 WARNING: id_timed_discharge_on = switch.solmod_timed_discharge_slot_1_enable switch.solmod_timed_discharge_slot_1_enable: system default. Not in YAML.
2025-04-22 14:49:32.288598 WARNING: id_timed_charge_soc = number.solmod_timed_charge_soc number.solmod_timed_charge_soc: system default. Not in YAML.
2025-04-22 14:49:32.287532 WARNING: id_timed_charge_current = number.solmod_timed_charge_current 100.0: system default. Not in YAML.
2025-04-22 14:49:32.286149 WARNING: id_timed_charge_on = switch.solmod_timed_charge_slot_1_enable switch.solmod_timed_charge_slot_1_enable: system default. Not in YAML.
2025-04-22 14:49:32.284982 WARNING: battery_voltage = sensor.solmod_battery_voltage 50.7: system default. Not in YAML.
2025-04-22 14:49:32.283309 WARNING: update_cycle_seconds = 15 15: system default. Not in YAML.
2025-04-22 14:49:32.282508 WARNING: supports_forced_discharge = True True: system default. Not in YAML.
2025-04-22 14:49:32.281512 WARNING: supports_hold_soc = True True: system default. Not in YAML.
2025-04-22 14:49:32.280697 WARNING: id_inverter_ac_power = sensor.solmod_active_power 200.0: system default. Not in YAML.
2025-04-22 14:49:32.279375 WARNING: id_battery_charge_power = sensor.solmod_battery_input_energy 927.0: system default. Not in YAML.
2025-04-22 14:49:32.277996 WARNING: id_grid_export_today = sensor.solmod_grid_export_today 19.3: system default. Not in YAML.
2025-04-22 14:49:32.276695 WARNING: id_grid_import_today = sensor.solmod_grid_import_today 14.3: system default. Not in YAML.
2025-04-22 14:49:32.275242 WARNING: id_battery_soc = sensor.solmod_battery_soc 97.0: system default. Not in YAML.
2025-04-22 14:49:32.273737 WARNING: maximum_dod_percent = number.solmod_battery_minimum_soc 16.0: system default. Not in YAML.
2025-04-22 14:49:32.271521 WARNING: transfer_car_charge_plan = False False: system default. Not in YAML.
2025-04-22 14:49:32.270745 WARNING: sleep_soc = 0 0: system default. Not in YAML.
2025-04-22 14:49:32.269965 WARNING: hold_soc_active = True True: system default. Not in YAML.
2025-04-22 14:49:32.269197 WARNING: discharge_active = True True: system default. Not in YAML.
2025-04-22 14:49:32.268400 WARNING: charge_active = True True: system default. Not in YAML.
2025-04-22 14:49:32.267612 WARNING: wakeup_soc = 0 0: system default. Not in YAML.
2025-04-22 14:49:32.266815 WARNING: maximum_soc = 100 100: system default. Not in YAML.
2025-04-22 14:49:32.266007 WARNING: forced_power_group_tolerance = 100 100: system default. Not in YAML.
2025-04-22 14:49:32.265176 WARNING: consumption_grouping = mean mean: system default. Not in YAML.
2025-04-22 14:49:32.263915 WARNING: consumption_margin = 10 10: system default. Not in YAML.
2025-04-22 14:49:32.262995 WARNING: id_solcast_tomorrow = sensor.solcast_pv_forecast_forecast_tomorrow 19.5726: system default. Not in YAML.
2025-04-22 14:49:32.261666 WARNING: id_solcast_today = sensor.solcast_pv_forecast_forecast_today 22.895: system default. Not in YAML.
2025-04-22 14:49:32.260118 WARNING: control_car_charging = False False: system default. Not in YAML.
2025-04-22 14:49:32.259284 WARNING: car_charging_ready_by = 07:00 07:00: system default. Not in YAML.
2025-04-22 14:49:32.256879 WARNING: ev_charge_target_percent = 80 80: system default. Not in YAML.
2025-04-22 14:49:32.256091 WARNING: max_ev_price_p = 10.0 10.0: system default. Not in YAML.
2025-04-22 14:49:32.255326 WARNING: ev_charger_efficiency_percent = 92 92: system default. Not in YAML.
2025-04-22 14:49:32.254561 WARNING: ev_battery_capacity_kwh = 50 50: system default. Not in YAML.
2025-04-22 14:49:32.253785 WARNING: ev_charger_power_watts = 7000 7000: system default. Not in YAML.
2025-04-22 14:49:32.253002 WARNING: inverter_loss_watts = 100 100: system default. Not in YAML.
2025-04-22 14:49:32.252232 WARNING: inverter_power_watts = 3600 3600: system default. Not in YAML.
2025-04-22 14:49:32.251467 WARNING: charger_power_watts = 3000 3000: system default. Not in YAML.
2025-04-22 14:49:32.250695 WARNING: charger_efficiency_percent = 91 91: system default. Not in YAML.
2025-04-22 14:49:32.249921 WARNING: inverter_efficiency_percent = 97 97: system default. Not in YAML.
2025-04-22 14:49:32.249148 WARNING: battery_capacity_wh = 10000 10000: system default. Not in YAML.
2025-04-22 14:49:32.248354 WARNING: discharge_threshold_p = 5.0 5.0: system default. Not in YAML.
2025-04-22 14:49:32.247577 WARNING: plunge_threshold_p_kwh = -5.0 -5.0: system default. Not in YAML.
2025-04-22 14:49:32.246689 WARNING: pass_threshold_p = 4.0 4.0: system default. Not in YAML.
2025-04-22 14:49:32.245880 WARNING: day_of_week_weighting = 0.5 0.5: system default. Not in YAML.
2025-04-22 14:49:32.245093 WARNING: slot_threshold_p = 1.0 1.0: system default. Not in YAML.
2025-04-22 14:49:32.244313 WARNING: solcast_confidence_level = 50 50: system default. Not in YAML.
2025-04-22 14:49:32.243545 WARNING: test_button = 2025-04-22 13:49:32.059785+00:00 2025-04-22 13:49:32.059785+00:00: system default. Not in YAML.
2025-04-22 14:49:32.242722 WARNING: test_function = Charge Charge: system default. Not in YAML.
2025-04-22 14:49:32.241666 WARNING: test_enable = Enable Enable: system default. Not in YAML.
2025-04-22 14:49:32.240364 WARNING: test_target_soc = 100 100: system default. Not in YAML.
2025-04-22 14:49:32.239581 WARNING: test_power = 3000 3000: system default. Not in YAML.
2025-04-22 14:49:32.238774 WARNING: test_end = 00:00 00:00: system default. Not in YAML.
2025-04-22 14:49:32.237679 WARNING: test_start = 00:00 00:00: system default. Not in YAML.
2025-04-22 14:49:32.236092 WARNING: optimise_frequency_minutes = 10 10: system default. Not in YAML.
2025-04-22 14:49:32.235301 WARNING: prevent_discharge = False False: system default. Not in YAML.
2025-04-22 14:49:32.234515 WARNING: use_solar = True True: system default. Not in YAML.
2025-04-22 14:49:32.233720 WARNING: include_export = True True: system default. Not in YAML.
2025-04-22 14:49:32.232901 INFO: -----------------------
2025-04-22 14:49:32.232132 INFO: Checking config:
2025-04-22 14:49:32.231281 INFO:
2025-04-22 14:49:32.230515 INFO: id_timed_discharge_end_minutes = number.solmod_timed_discharge_end_minutes 0.0: value(s) in YAML
2025-04-22 14:49:32.229361 INFO: >>> id_timed_discharge_end_minutes number.solmod_timed_discharge_end_minutes True
2025-04-22 14:49:32.228605 INFO: >>> Test: True
2025-04-22 14:49:32.227805 INFO: id_timed_discharge_end_hours = number.solmod_timed_discharge_end_hours 5.0: value(s) in YAML
2025-04-22 14:49:32.226652 INFO: >>> id_timed_discharge_end_hours number.solmod_timed_discharge_end_hours True
2025-04-22 14:49:32.225865 INFO: >>> Test: True
2025-04-22 14:49:32.225096 WARNING: id_timed_discharge_start_minutes = number.solmod_timed_discharge_start_minutes 0.0: system default. Entities listed in YAML ['number.solmod_timed_discharge_start_m'] do not all exist in HA.
2025-04-22 14:49:32.223782 INFO: >>> id_timed_discharge_start_minutes number.solmod_timed_discharge_start_m False
2025-04-22 14:49:32.222985 INFO: >>> Test: True
2025-04-22 14:49:32.222214 WARNING: id_timed_discharge_start_hours = number.solmod_timed_discharge_start_hours 5.0: system default. Entities listed in YAML ['number.solmod_timed_discharge_start_h'] do not all exist in HA.
2025-04-22 14:49:32.220827 INFO: >>> id_timed_discharge_start_hours number.solmod_timed_discharge_start_h False
2025-04-22 14:49:32.219944 INFO: >>> Test: True
2025-04-22 14:49:32.219165 INFO: id_timed_charge_end_minutes = number.solmod_timed_charge_end_minutes 0.0: value(s) in YAML
2025-04-22 14:49:32.217808 INFO: >>> id_timed_charge_end_minutes number.solmod_timed_charge_end_minutes True
2025-04-22 14:49:32.217050 INFO: >>> Test: True
2025-04-22 14:49:32.216269 INFO: id_timed_charge_end_hours = number.solmod_timed_charge_end_hours 0.0: value(s) in YAML
2025-04-22 14:49:32.214897 INFO: >>> id_timed_charge_end_hours number.solmod_timed_charge_end_hours True
2025-04-22 14:49:32.214021 INFO: >>> Test: True
2025-04-22 14:49:32.213158 INFO: id_timed_charge_start_minutes = number.solmod_timed_charge_start_minutes 0.0: value(s) in YAML
2025-04-22 14:49:32.211678 INFO: >>> id_timed_charge_start_minutes number.solmod_timed_charge_start_minutes True
2025-04-22 14:49:32.210803 INFO: >>> Test: True
2025-04-22 14:49:32.209952 INFO: id_timed_charge_start_hours = number.solmod_timed_charge_start_hours 0.0: value(s) in YAML
2025-04-22 14:49:32.208756 INFO: >>> id_timed_charge_start_hours number.solmod_timed_charge_start_hours True
2025-04-22 14:49:32.207978 INFO: >>> Test: True
2025-04-22 14:49:32.207204 WARNING: id_consumption = ['sensor.solmod_house_load_x', 'sensor.solmod_bypass_load_x'] None: system default. Null entry found in YAML.
2025-04-22 14:49:32.206247 WARNING: id_consumption_today = sensor.solmod_house_load_today 7.0: system default. Entities listed in YAML ['sensor.solmod_consumption_today'] do not all exist in HA.
2025-04-22 14:49:32.204738 INFO: >>> id_consumption_today sensor.solmod_consumption_today False
2025-04-22 14:49:32.203936 INFO: >>> Test: True
2025-04-22 14:49:32.203019 INFO: ev_part_of_house_load = False False: value in YAML
2025-04-22 14:49:32.202263 INFO: ev_charger = Zappi Zappi: value in YAML
2025-04-22 14:49:32.199743 INFO: octopus_auto = True True: value in YAML
2025-04-22 14:49:32.199034 INFO: 24.00 300 W
2025-04-22 14:49:32.198539 INFO: 22.00 750 W
2025-04-22 14:49:32.198014 INFO: 17.00 750 W
2025-04-22 14:49:32.197497 INFO: 15.50 500 W
2025-04-22 14:49:32.196856 INFO: 8.00 500 W
2025-04-22 14:49:32.196356 INFO: 6.00 150 W
2025-04-22 14:49:32.195847 INFO: 0.50 200 W
2025-04-22 14:49:32.195327 INFO: consumption_shape = Hour: 0.00 Consumption: 300 W
2025-04-22 14:49:32.194807 INFO: shape_consumption_profile = False False: value in YAML
2025-04-22 14:49:32.194109 INFO: daily_consumption_kwh = 17 17: value in YAML
2025-04-22 14:49:32.193373 INFO: consumption_history_days = 7 7: value in YAML
2025-04-22 14:49:32.192651 INFO: use_consumption_history = True True: value in YAML
2025-04-22 14:49:32.191928 INFO: battery_current_limit_amps = 100 100: value in YAML
2025-04-22 14:49:32.191205 INFO: allow_cyclic = False False: value in YAML
2025-04-22 14:49:32.190481 INFO: forced_discharge = True True: value in YAML
2025-04-22 14:49:32.189735 INFO: read_only = False False: value in YAML
2025-04-22 14:49:32.188981 INFO: debug_categories = OTFV OTFV: value in YAML
2025-04-22 14:49:32.187621 INFO: -----------------------------------
2025-04-22 14:49:32.187097 INFO: Reading arguments from YAML:
2025-04-22 14:49:32.174887 INFO:
2025-04-22 14:49:32.174460 INFO: sensor.solmod_meter_active_power_total (power): -0.089 kW
2025-04-22 14:49:32.174037 INFO: sensor.solmod_inverter_frequency (frequency): 50.06 Hz
2025-04-22 14:49:32.173618 INFO: sensor.solmod_timed_discharge_current (current): 0.0 A
2025-04-22 14:49:32.173199 INFO: sensor.solmod_timed_charge_current (current): 100.0 A
2025-04-22 14:49:32.172783 INFO: sensor.solmod_battery_discharge_current (current): 100.0 A
2025-04-22 14:49:32.172362 INFO: sensor.solmod_battery_charge_current (current): 100.0 A
2025-04-22 14:49:32.171946 INFO: sensor.solmod_battery_chargedischarge_current (current): 0.0 A
2025-04-22 14:49:32.171536 INFO: sensor.solmod_backflow_power (power): 0 W
2025-04-22 14:49:32.171115 INFO: sensor.solmod_backflow_power_switch (None): Off
2025-04-22 14:49:32.170703 INFO: sensor.solmod_backup_mode_soc (None): 100
2025-04-22 14:49:32.170276 INFO: sensor.solmod_force_charge_soc (None): 15
2025-04-22 14:49:32.169840 INFO: sensor.solmod_battery_minimum_soc (None): 16
2025-04-22 14:49:32.169399 INFO: sensor.solmod_power_switch (None): On
2025-04-22 14:49:32.168985 INFO: sensor.solmod_meter_grid_export_total (energy): 7895.01 kWh
2025-04-22 14:49:32.168583 INFO: sensor.solmod_meter_grid_import_total (energy): 6158.64 kWh
2025-04-22 14:49:32.168166 INFO: sensor.solmod_meter_grid_frequency (frequency): 50.04 Hz
2025-04-22 14:49:32.167682 INFO: sensor.solmod_meter_power_factor (power_factor): -0.14
2025-04-22 14:49:32.167274 INFO: sensor.solmod_meter_apparent_power_total (apparent_power): 486 VA
2025-04-22 14:49:32.166870 INFO: sensor.solmod_meter_apparent_power (apparent_power): 486 VA
2025-04-22 14:49:32.166469 INFO: sensor.solmod_meter_reactive_power_total (reactive_power): 478 var
2025-04-22 14:49:32.166055 INFO: sensor.solmod_meter_reactive_power (reactive_power): 478 var
2025-04-22 14:49:32.165652 INFO: sensor.solmod_meter_activepower_total (power): unavailable kW
2025-04-22 14:49:32.165226 INFO: sensor.solmod_meter_ac_current (current): 2.62 A
2025-04-22 14:49:32.164798 INFO: sensor.solmod_meter_ac_voltage (voltage): 245.2 V
2025-04-22 14:49:32.164372 INFO: sensor.solmod_battery_discharge_current_limit (current): 100.0 A
2025-04-22 14:49:32.163960 INFO: sensor.solmod_battery_charge_current_limit (current): 59.2 A
2025-04-22 14:49:32.163550 INFO: sensor.solmod_house_load_yesterday (energy): 14.4 kWh
2025-04-22 14:49:32.163120 INFO: sensor.solmod_house_load_today (energy): 7.0 kWh
2025-04-22 14:49:32.162706 INFO: sensor.solmod_house_load_total (energy): 7125 kWh
2025-04-22 14:49:32.162286 INFO: sensor.solmod_grid_export_yesterday (energy): 9.4 kWh
2025-04-22 14:49:32.161875 INFO: sensor.solmod_grid_export_today (energy): 19.3 kWh
2025-04-22 14:49:32.161468 INFO: sensor.solmod_grid_export_total (energy): 7895 kWh
2025-04-22 14:49:32.161051 INFO: sensor.solmod_grid_import_yesterday (energy): 15.3 kWh
2025-04-22 14:49:32.160565 INFO: sensor.solmod_grid_import_today (energy): 14.3 kWh
2025-04-22 14:49:32.160113 INFO: sensor.solmod_grid_import_total (energy): 6158 kWh
2025-04-22 14:49:32.159693 INFO: sensor.solmod_battery_discharge_yesterday (energy): 14.9 kWh
2025-04-22 14:49:32.159273 INFO: sensor.solmod_battery_discharge_today (energy): 3.8 kWh
2025-04-22 14:49:32.158850 INFO: sensor.solmod_total_battery_discharge (energy): 6231 kWh
2025-04-22 14:49:32.158439 INFO: sensor.solmod_battery_charge_yesterday (energy): 15.0 kWh
2025-04-22 14:49:32.158002 INFO: sensor.solmod_battery_charge_today (energy): 12.5 kWh
2025-04-22 14:49:32.157600 INFO: sensor.solmod_total_battery_charge (energy): 6515 kWh
2025-04-22 14:49:32.157193 INFO: sensor.solmod_battery_output_energy (power): 0 W
2025-04-22 14:49:32.156785 INFO: sensor.solmod_battery_input_energy (power): 927 W
2025-04-22 14:49:32.156380 INFO: sensor.solmod_battery_power (power): 927 W
2025-04-22 14:49:32.155970 INFO: sensor.solmod_bypass_load (power): 0 W
2025-04-22 14:49:32.155571 INFO: sensor.solmod_house_load (power): 290 W
2025-04-22 14:49:32.155145 INFO: sensor.solmod_bms_battery_discharge_limit (current): 148.0 A
2025-04-22 14:49:32.154729 INFO: sensor.solmod_bms_battery_charge_limit (current): 59.2 A
2025-04-22 14:49:32.154318 INFO: sensor.solmod_bms_battery_current (current): 18.3 A
2025-04-22 14:49:32.153901 INFO: sensor.solmod_bms_battery_voltage (voltage): 50.12 V
2025-04-22 14:49:32.153493 INFO: sensor.solmod_battery_soh (None): 96 %
2025-04-22 14:49:32.152995 INFO: sensor.solmod_battery_soc (battery): 97 %
2025-04-22 14:49:32.152596 INFO: sensor.solmod_battery_charge_direction (None): 0
2025-04-22 14:49:32.152187 INFO: sensor.solmod_battery_current (current): 18.3 A
2025-04-22 14:49:32.151769 INFO: sensor.solmod_battery_voltage (voltage): 50.7 V
2025-04-22 14:49:32.151357 INFO: sensor.solmod_energy_storage_control_switch (None): Self-Use
2025-04-22 14:49:32.150949 INFO: sensor.solmod_meter_active_power (power): -77 W
2025-04-22 14:49:32.150548 INFO: sensor.solmod_meter_current (current): 2.6 A
2025-04-22 14:49:32.150135 INFO: sensor.solmod_meter_voltage (voltage): 245.2 V
2025-04-22 14:49:32.149728 INFO: sensor.solmod_meter_total_activepower (energy): 140536.5 kWh
2025-04-22 14:49:32.149309 INFO: sensor.solmod_inverter_status (None): Generating
2025-04-22 14:49:32.148893 INFO: sensor.solmod_grid_frequency (frequency): unavailable Hz
2025-04-22 14:49:32.148484 INFO: sensor.solmod_inverter_temperature (temperature): 42.3 ��C
2025-04-22 14:49:32.148052 INFO: sensor.solmod_apparent_power (apparent_power): 200 VA
2025-04-22 14:49:32.147650 INFO: sensor.solmod_reactive_power (reactive_power): 0 var
2025-04-22 14:49:32.147245 INFO: sensor.solmod_active_power (power): 200 W
2025-04-22 14:49:32.146830 INFO: sensor.solmod_inverter_current (current): 2.4 A
2025-04-22 14:49:32.146405 INFO: sensor.solmod_inverter_voltage (voltage): 246.4 V
2025-04-22 14:49:32.145920 INFO: sensor.solmod_pv_total_power (power): 1187 W
2025-04-22 14:49:32.145522 INFO: sensor.solmod_pv_power_2 (power): 662.2 W
2025-04-22 14:49:32.145110 INFO: sensor.solmod_pv_current_2 (current): 2.8 A
2025-04-22 14:49:32.144696 INFO: sensor.solmod_pv_voltage_2 (voltage): 236.5 V
2025-04-22 14:49:32.144275 INFO: sensor.solmod_pv_power_1 (power): 525.0 W
2025-04-22 14:49:32.143860 INFO: sensor.solmod_pv_current_1 (current): 3.0 A
2025-04-22 14:49:32.143445 INFO: sensor.solmod_pv_voltage_1 (voltage): 175.0 V
2025-04-22 14:49:32.143007 INFO: sensor.solmod_power_generation_last_year (energy): 3222 kWh
2025-04-22 14:49:32.142576 INFO: sensor.solmod_power_generation_this_year (energy): 1016 kWh
2025-04-22 14:49:32.142137 INFO: sensor.solmod_power_generation_yesterday (energy): 7.0 kWh
2025-04-22 14:49:32.141705 INFO: sensor.solmod_power_generation_today (energy): 18.9 kWh
2025-04-22 14:49:32.141249 INFO: sensor.solmod_power_generation_last_month (energy): 380 kWh
2025-04-22 14:49:32.140815 INFO: sensor.solmod_power_generation_this_month (energy): 427 kWh
2025-04-22 14:49:32.140383 INFO: sensor.solmod_power_generation_total (energy): 6987 kWh
2025-04-22 14:49:32.139955 INFO: sensor.solmod_rtc (None): 2025-04-22 14:49:20
2025-04-22 14:49:32.139527 INFO: sensor.solmod_grid_import_power (power): 77.0 W
2025-04-22 14:49:32.139077 INFO: sensor.solmod_grid_export_power (power): 0 W
2025-04-22 14:49:32.125277 INFO: - min: 0 max: 23 step: 1
2025-04-22 14:49:32.124797 INFO: number.solmod_timed_charge_end_hours_2 (None): 0 h
2025-04-22 14:49:32.123640 INFO: - min: 0 max: 23 step: 1
2025-04-22 14:49:32.122288 INFO: number.solmod_timed_charge_end_hours_3 (None): 0 h
2025-04-22 14:49:32.121019 INFO: - min: 0 max: 23 step: 1
2025-04-22 14:49:32.119704 INFO: number.solmod_timed_charge_end_hours (None): 0 h
2025-04-22 14:49:32.118515 INFO: - min: 0 max: 59 step: 1
2025-04-22 14:49:32.117309 INFO: number.solmod_timed_charge_end_minutes_2 (None): 0 min
2025-04-22 14:49:32.114800 INFO: - min: 0 max: 59 step: 1
2025-04-22 14:49:32.114264 INFO: number.solmod_timed_charge_end_minutes_3 (None): 0 min
2025-04-22 14:49:32.113844 INFO: - min: 0 max: 59 step: 1
2025-04-22 14:49:32.113384 INFO: number.solmod_timed_charge_end_minutes (None): 0 min
2025-04-22 14:49:32.112962 INFO: - min: 0 max: 23 step: 1
2025-04-22 14:49:32.112516 INFO: number.solmod_timed_discharge_end_hours_2 (None): 0 h
2025-04-22 14:49:32.112082 INFO: - min: 0 max: 23 step: 1
2025-04-22 14:49:32.111634 INFO: number.solmod_timed_discharge_end_hours_3 (None): 0 h
2025-04-22 14:49:32.111210 INFO: - min: 0 max: 23 step: 1
2025-04-22 14:49:32.110758 INFO: number.solmod_timed_discharge_end_hours (None): 5 h
2025-04-22 14:49:32.110333 INFO: - min: 0 max: 59 step: 1
2025-04-22 14:49:32.109879 INFO: number.solmod_timed_discharge_end_minutes_2 (None): 0 min
2025-04-22 14:49:32.109462 INFO: - min: 0 max: 59 step: 1
2025-04-22 14:49:32.108997 INFO: number.solmod_timed_discharge_end_minutes_3 (None): 0 min
2025-04-22 14:49:32.108589 INFO: - min: 0 max: 59 step: 1
2025-04-22 14:49:32.108135 INFO: number.solmod_timed_discharge_end_minutes (None): 0 min
2025-04-22 14:49:32.107722 INFO: - min: 0 max: 23 step: 1
2025-04-22 14:49:32.107195 INFO: number.solmod_timed_charge_start_hours_3 (None): 0 h
2025-04-22 14:49:32.106776 INFO: - min: 0 max: 23 step: 1
2025-04-22 14:49:32.106319 INFO: number.solmod_timed_charge_start_hours_2 (None): 0 h
2025-04-22 14:49:32.105896 INFO: - min: 0 max: 23 step: 1
2025-04-22 14:49:32.105453 INFO: number.solmod_timed_charge_start_hours (None): 0 h
2025-04-22 14:49:32.105014 INFO: - min: 0 max: 59 step: 1
2025-04-22 14:49:32.104572 INFO: number.solmod_timed_charge_start_minutes_3 (None): 0 min
2025-04-22 14:49:32.104145 INFO: - min: 0 max: 59 step: 1
2025-04-22 14:49:32.103688 INFO: number.solmod_timed_charge_start_minutes_2 (None): 0 min
2025-04-22 14:49:32.103269 INFO: - min: 0 max: 59 step: 1
2025-04-22 14:49:32.102803 INFO: number.solmod_timed_charge_start_minutes (None): 0 min
2025-04-22 14:49:32.102368 INFO: - min: 0 max: 59 step: 1
2025-04-22 14:49:32.101907 INFO: number.solmod_timed_discharge_start_minutes_3 (None): 0 min
2025-04-22 14:49:32.101480 INFO: - min: 0 max: 23 step: 1
2025-04-22 14:49:32.101005 INFO: number.solmod_timed_discharge_start_hours_3 (None): 0 h
2025-04-22 14:49:32.100583 INFO: - min: 0 max: 59 step: 1
2025-04-22 14:49:32.100106 INFO: number.solmod_timed_discharge_start_minutes_2 (None): 0 min
2025-04-22 14:49:32.099606 INFO: - min: 0 max: 23 step: 1
2025-04-22 14:49:32.099141 INFO: number.solmod_timed_discharge_start_hours_2 (None): 0 h
2025-04-22 14:49:32.098715 INFO: - min: 0 max: 59 step: 1
2025-04-22 14:49:32.098242 INFO: number.solmod_timed_discharge_start_minutes (None): 0 min
2025-04-22 14:49:32.097812 INFO: - min: 0 max: 23 step: 1
2025-04-22 14:49:32.097344 INFO: number.solmod_timed_discharge_start_hours (None): 5 h
2025-04-22 14:49:32.096917 INFO: - min: 0 max: 100 step: 1
2025-04-22 14:49:32.096457 INFO: number.solmod_timed_discharge_current (current): 0.0 A
2025-04-22 14:49:32.096020 INFO: - min: 0 max: 100 step: 1
2025-04-22 14:49:32.095561 INFO: number.solmod_timed_charge_current (current): 100.0 A
2025-04-22 14:49:32.095120 INFO: - min: 0 max: 100 step: 1
2025-04-22 14:49:32.094657 INFO: number.solmod_battery_discharge_current (current): 100.0 A
2025-04-22 14:49:32.094227 INFO: - min: 0 max: 100 step: 1
2025-04-22 14:49:32.093766 INFO: number.solmod_battery_charge_current (current): 100.0 A
2025-04-22 14:49:32.093332 INFO: - min: 0 max: 100 step: 1
2025-04-22 14:49:32.092862 INFO: number.solmod_battery_chargedischarge_current (current): 0.0 A
2025-04-22 14:49:32.092327 INFO: - min: 0 max: 9900 step: 100
2025-04-22 14:49:32.091863 INFO: number.solmod_backflow_power (power): 0 W
2025-04-22 14:49:32.091439 INFO: - min: 10 max: 100 step: 1
2025-04-22 14:49:32.090966 INFO: number.solmod_backup_mode_soc (None): 100 %
2025-04-22 14:49:32.090542 INFO: - min: 10 max: 100 step: 1
2025-04-22 14:49:32.090076 INFO: number.solmod_force_charge_soc (None): 15 %
2025-04-22 14:49:32.089646 INFO: - min: 10 max: 100 step: 1
2025-04-22 14:49:32.089177 INFO: number.solmod_battery_minimum_soc (None): 16 %
2025-04-22 14:49:32.088730 INFO: - min: -3600 max: 3600 step: 1
2025-04-22 14:49:32.088229 INFO: number.solmod_sync_rtc_offset (None): 0 s
2025-04-22 14:49:32.084615 INFO: Off
2025-04-22 14:49:32.084140 INFO: On
2025-04-22 14:49:32.083668 INFO: select.solmod_power_switch (None):
2025-04-22 14:49:32.083234 INFO: Feed-in priority
2025-04-22 14:49:32.082771 INFO: Feed-in priority - No Timed Charge/Discharge
2025-04-22 14:49:32.082293 INFO: Feed-in priority - No Grid Charging
2025-04-22 14:49:32.081822 INFO: Backup/Reserve
2025-04-22 14:49:32.081275 INFO: Backup/Reserve - No Timed Charge/Discharge
2025-04-22 14:49:32.080807 INFO: Battery Awaken + Timed Charge/Discharge
2025-04-22 14:49:32.080332 INFO: Battery Awaken
2025-04-22 14:49:32.079863 INFO: Off-Grid Mode
2025-04-22 14:49:32.079377 INFO: Self-Use
2025-04-22 14:49:32.078903 INFO: Self-Use - No Timed Charge/Discharge
2025-04-22 14:49:32.078434 INFO: Backup/Reserve - No Grid Charging
2025-04-22 14:49:32.077953 INFO: Timed Charge/Discharge - No Grid Charging
2025-04-22 14:49:32.077488 INFO: Self-Use - No Grid Charging
2025-04-22 14:49:32.077003 INFO: select.solmod_energy_storage_control_switch (None):
2025-04-22 14:49:32.076581 INFO: On
2025-04-22 14:49:32.076109 INFO: Off
2025-04-22 14:49:32.075626 INFO: select.solmod_backflow_power_switch (None):
2025-04-22 14:49:32.073673 INFO:
2025-04-22 14:49:32.073216 INFO: -------------------------------------
2025-04-22 14:49:32.072762 INFO: Available entities for device solmod:
2025-04-22 14:49:32.072148 INFO:
2025-04-22 14:49:32.071703 INFO: Inverter appears to be online
2025-04-22 14:49:32.070764 INFO: Serial number:
2025-04-22 14:49:32.070306 INFO: Device name: solmod
2025-04-22 14:49:32.069249 INFO: HMI Firmware Flag set to False
2025-04-22 14:49:32.068779 INFO: Loading controller for inverter type SOLIS_SOLAX_MODBUS
2025-04-22 14:49:32.068208 INFO: Inverter type: SOLIS_SOLAX_MODBUS: inverter module: solis.py
2025-04-22 14:49:32.067788 INFO: Time Zone Offset: 60.0 minutes
2025-04-22 14:49:32.067090 INFO: Local timezone set to GB
2025-04-22 14:49:32.065659 INFO: Debug Categories selected = OTFV
2025-04-22 14:49:32.065299 INFO: Debug Categories selected = OTFV
2025-04-22 14:49:32.064944 INFO: Pre-release version. Enabling debug logging
2025-04-22 14:49:32.064588 INFO:
2025-04-22 14:49:32.064249 INFO: *************** PV Opt Version: v4.0.10-Beta-2 ***************
2025-04-22 14:49:32.063898 INFO:
My system did the same. As you suggest its the Savings Session, the loading of which appears to have mixed UTC and BST, which the code doesn't like.
I can't immediately see the problem from the logs but will do a beta release with extra debugging to catch it next saving session.
If your system hasnt recovered just add a carriage return to pv_opt.py to get it up and running again.
v4.0.10-Beta-3 adds additional logging when a savings event is detected. No changes required to debug logging settings (it will log regardless).
@stevebuk1 - looks like this issue has raised it’s head again, with the savings session today. Guess you’re seeing the same?
Log…
`2025-06-04 16:05:15.853946 WARNING pv_opt: ------------------------------------------------------------ ValueError: Both dates must have the same UTC offset raise ValueError("Both dates must have the same UTC offset") File "/usr/lib/python3.11/site-packages/pandas/core/indexes/base.py", line 6875, in slice_locs ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ start_slice, end_slice = self.slice_locs(start, end, step=step) File "/usr/lib/python3.11/site-packages/pandas/core/indexes/base.py", line 6662, in slice_indexer ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ return Index.slice_indexer(self, start, end, step) File "/usr/lib/python3.11/site-packages/pandas/core/indexes/datetimes.py", line 682, in slice_indexer ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ indexer = labels.slice_indexer(slice_obj.start, slice_obj.stop, slice_obj.step) File "/usr/lib/python3.11/site-packages/pandas/core/indexing.py", line 1443, in _get_slice_axis ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ return self._get_slice_axis(key, axis=axis) File "/usr/lib/python3.11/site-packages/pandas/core/indexing.py", line 1411, in _getitem_axis ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ return self._getitem_axis(maybe_callable, axis=axis) File "/usr/lib/python3.11/site-packages/pandas/core/indexing.py", line 1191, in getitem
return getattr(section, self.name)[new_key]
File "/usr/lib/python3.11/site-packages/pandas/core/indexing.py", line 1089, in _getitem_lowerdim
^^^^^^^^^^^^^^^^^^^^^^^^^^^
return self._getitem_lowerdim(tup)
File "/usr/lib/python3.11/site-packages/pandas/core/indexing.py", line 1368, in _getitem_tuple
^^^^^^^^^^^^^^^^^^^^^^^^
return self._getitem_tuple(key)
File "/usr/lib/python3.11/site-packages/pandas/core/indexing.py", line 1184, in __getitem__
~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
df.loc[event_start:event_end, "unit"] += event_value
File "/homeassistant/appdaemon/apps/pv_opt/pvpy.py", line 399, in to_df
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
imp_df = self.tariffs["import"].to_df(start=start.floor("30min"), end=end, **kwargs)
File "/homeassistant/appdaemon/apps/pv_opt/pvpy.py", line 673, in net_cost
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
cost_today = self.contract.net_cost(grid_flow=grid, log=self.debug, day_ahead=False, sum=False)
File "/homeassistant/appdaemon/apps/pv_opt/pv_opt.py", line 1424, in _cost_actual
self._cost_actual()
File "/homeassistant/appdaemon/apps/pv_opt/pv_opt.py", line 671, in initialize
^^^^^^^^^^^^^^
return f(*args, **kw)
File "/usr/lib/python3.11/site-packages/appdaemon/adbase.py", line 35, in f_app_lock
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
result = self.fn(*self.args, **self.kwargs)
File "/usr/lib/python3.11/concurrent/futures/thread.py", line 58, in run
^^^^^^^^^^^^^^^
response = future.result()
File "/usr/lib/python3.11/site-packages/appdaemon/utils.py", line 304, in run_in_executor
await utils.run_in_executor(self, init)
File "/usr/lib/python3.11/site-packages/appdaemon/app_management.py", line 162, in initialize_app
2025-06-04 16:05:15.853855 WARNING pv_opt: Traceback (most recent call last):
2025-06-04 16:05:15.851088 WARNING pv_opt: ------------------------------------------------------------
2025-06-04 16:05:15.851019 WARNING pv_opt: Unexpected error running initialize() for pv_opt
2025-06-04 16:05:15.850925 WARNING pv_opt: ------------------------------------------------------------
2025-06-04 16:03:51.801447 WARNING pv_opt: ------------------------------------------------------------
ValueError: Both dates must have the same UTC offset
raise ValueError("Both dates must have the same UTC offset")
File "/usr/lib/python3.11/site-packages/pandas/core/indexes/base.py", line 6875, in slice_locs
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
start_slice, end_slice = self.slice_locs(start, end, step=step)
File "/usr/lib/python3.11/site-packages/pandas/core/indexes/base.py", line 6662, in slice_indexer
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
return Index.slice_indexer(self, start, end, step)
File "/usr/lib/python3.11/site-packages/pandas/core/indexes/datetimes.py", line 682, in slice_indexer
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
indexer = labels.slice_indexer(slice_obj.start, slice_obj.stop, slice_obj.step)
File "/usr/lib/python3.11/site-packages/pandas/core/indexing.py", line 1443, in _get_slice_axis
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
return self._get_slice_axis(key, axis=axis)
File "/usr/lib/python3.11/site-packages/pandas/core/indexing.py", line 1411, in _getitem_axis
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
return self._getitem_axis(maybe_callable, axis=axis)
File "/usr/lib/python3.11/site-packages/pandas/core/indexing.py", line 1191, in __getitem__
~~~~~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^
return getattr(section, self.name)[new_key]
File "/usr/lib/python3.11/site-packages/pandas/core/indexing.py", line 1089, in _getitem_lowerdim
^^^^^^^^^^^^^^^^^^^^^^^^^^^
return self._getitem_lowerdim(tup)
File "/usr/lib/python3.11/site-packages/pandas/core/indexing.py", line 1368, in _getitem_tuple
^^^^^^^^^^^^^^^^^^^^^^^^
return self._getitem_tuple(key)
File "/usr/lib/python3.11/site-packages/pandas/core/indexing.py", line 1184, in __getitem__
~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
df.loc[event_start:event_end, "unit"] += event_value
File "/homeassistant/appdaemon/apps/pv_opt/pvpy.py", line 399, in to_df
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
imp_df = self.tariffs["import"].to_df(start=start.floor("30min"), end=end, **kwargs)
File "/homeassistant/appdaemon/apps/pv_opt/pvpy.py", line 673, in net_cost
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
cost_today = self.contract.net_cost(grid_flow=grid, log=self.debug, day_ahead=False, sum=False)
File "/homeassistant/appdaemon/apps/pv_opt/pv_opt.py", line 1424, in _cost_actual
^^^^^^^^^^^^^^^^^^^
cost_today = self._cost_actual().sum()
File "/homeassistant/appdaemon/apps/pv_opt/pv_opt.py", line 2619, in optimise
^^^^^^^^^^^^^^
return f(*args, **kw)
File "/usr/lib/python3.11/site-packages/appdaemon/adbase.py", line 35, in f_app_lock
self.optimise()
File "/homeassistant/appdaemon/apps/pv_opt/pv_opt.py", line 2312, in optimise_event
^^^^^^^^^^^^^^
return f(*args, **kw)
File "/usr/lib/python3.11/site-packages/appdaemon/adbase.py", line 35, in f_app_lock
funcref(args["event"], data, self.AD.events.sanitize_event_kwargs(app, args["kwargs"]))
File "/usr/lib/python3.11/site-packages/appdaemon/threading.py", line 1095, in worker
2025-06-04 16:03:51.801358 WARNING pv_opt: Traceback (most recent call last):
2025-06-04 16:03:51.800153 WARNING pv_opt: ------------------------------------------------------------
2025-06-04 16:03:51.800083 WARNING pv_opt: Worker Ags: {'id': 'd4076ca35a8542f6bfed84fd8fc29930', 'name': 'pv_opt', 'objectid': '384db02d74d1414b9d65e602b8381c59', 'type': 'event', 'event': 'PV_OPT', 'function': <bound method PVOpt.optimise_event of <pv_opt.PVOpt object at 0x7f8c15231a10>>, 'data': {'metadata': {'origin': 'LOCAL', 'time_fired': '2025-06-04T15:03:31.234963+00:00', 'context': {'id': '01JWXQG1N2CES8HKAHJF52WQKG', 'parent_id': None, 'user_id': 'f90d56dbc5da41c6bb0ea75491d9f50e'}}}, 'pin_app': True, 'pin_thread': 0, 'kwargs': {'__thread_id': 'thread-0'}}
2025-06-04 16:03:51.799992 WARNING pv_opt: Unexpected error in worker for App pv_opt:
2025-06-04 16:03:51.799910 WARNING pv_opt: ------------------------------------------------------------ `
@stevebuk1 - looks like this issue has raised it’s head again, with the savings session today. Guess you’re seeing the same?
Yes I saw the same. The debugging logging I added caught it, definitely a problem comparing times of different offets:
04/06, 11:30:54 INFO: Savings Events debugging 04/06, 11:30:54 INFO: 04/06, 11:30:54 INFO: start = 2025-06-04 00:00:00+00:00 04/06, 11:30:54 INFO: end = 2025-06-04 10:00:00+00:00 04/06, 11:30:54 INFO: event_start = 2025-06-04 20:00:00+01:00 04/06, 11:30:54 INFO: event_end = 2025-06-04 20:30:00+01:00 04/06, 11:30:54 INFO: Recalculating event_start and event_end 04/06, 11:30:54 INFO: 04/06, 11:30:54 INFO: event_start = 2025-06-04 20:00:00+01:00 04/06, 11:30:54 INFO: event_end = 2025-06-04 10:00:00+00:00 04/06, 11:30:54 INFO: event_value = 11.875 04/06, 11:40:00 INFO: Optimiser triggered by Scheduler 04/06, 11:40:00 INFO: Version: v4.0.10-Beta-2
I'll take a look this evening
Beta release v4.0.11-Beta-1 available on HACS that has a fix and some more logging.
Actually, I wonder if the issue is in the Bottlecap Dave add-on. I sat and manually drove the graphQL for the Octopus API and got this…
Seems like Octopus are not adding in TZ info… Unless the data is inaccurate when the session is pending, and they update once done. Need to wait for the next one (and be free) to query again, I guess.
Actually, I wonder if the issue is in the Bottlecap Dave add-on. I sat and manually drove the graphQL for the Octopus API and got this…
The BottlecapDave integration is delivering its times in local time, but from your grab the Octopus API works in UTC. Its not an error as such as such as long as everything stays consistent and that is what is expected. However, one only finds out by error if something is treated as UTC but then an offset is applied when BST kicked in in April (proving in fact it was actually GMT, not UTC) which is what has happened here.
I think even with savings events being loaded with BST, the underlying functionality works, in that the savings event price gets correctly loaded into the table of planned 1/2 hour slots (which is usually somewhere between 24 and 48 hours long depending on the time of day, and works in UTC). The issue lies within a check that ensures the savings event does lie with the 24/48 hour period. If it doesn't, the savings event start and end is modified so it falls within the available range. This check is made on every calculation - base cost, optimsed cost, etc etc and the instance I caught was one where the end time was 10am but with the savings event being 8pm to 8.30pm. In that case the savings event end time is modified, but its modified to UTC. So we have a saving event start with BST and a savings event end with UTC, which isn't handled due to mixed time offsets. (ValueError: Both dates must have the same UTC offset)
04/06, 11:30:54 INFO: event_start = 2025-06-04 20:00:00+01:00 04/06, 11:30:54 INFO: event_end = 2025-06-04 10:00:00+00:00
The fix in Beta-1 is to simply convert the savings event times into UTC first.
However I'm not convinced its the full fix as its clear from the above the end time is before the start time. We'll need another savings event to test whether that is then a problem.
More issues today, with another savings event. Installed most recent Beta and seems to have progressed past it.
Thanks, mine has always crashed up to now but it seems still to be running at the mo. I can only get a partial status from limited mirrored entities over NabuCasa so will check log files when I get home. Were you running 4.0.11-Beta-1 when you had the issues?
No - I was running 4.0.11 release (the most recent stable release).
Upgraded to Beta 3 and it seemed to get past it.
I’d had to do a bit of fiddling with the yaml to use a select for the energy storage control switch - kept erroring out with unknown / no status so swapped it for inverter control storage mode in the Solis Cloud Control integration (as opposed to the sensor integration). That also seems to have worked.
I can add logs when I get home, but didn’t have debug mode on.
Yes please to the logs, if there were issues found would have added extra entries to the log without needing debug switched on.
Re SolisCloud, I'm meaning to do this on a seperate development Rpi but I've got the opposite problem to you - Solax / Waveshares are stable but my SolisCloud logging is intermittent and I've lost inverter control via the Solis app, so need to fix both of these before giving the SolisCloud functionality a whirl.
Just for a bit of fun/in the interest of research, I flicked into Optimise Discharging at just gone 6 and it discharged until 7. I don't know if the timings were anything to do with the Saver Session or if that would have been the plan anyway. Usually Optimise Discharge tends to set a plan to start dumping the batteries around 4:30 pm.
Logs from today - not sure how far back they go, but I was fighting with it around 1400 ish I think
Hi @stevebuk1 just checked (been travelling all day) and with 4.0.11-beta1 no errors with the saving session
Checked my logs and no issues.
The offer was 104 Octopoints (13p) per kWh for any reduction on normal usage. Pv_opt added 13p to the export price and 13p to the import price which makes sense.
Apparently I now have the ability to release to production, so will attempt a 4.0.11 release with all the extra debugging removed.
@fboundy unfortunately the PR failed again, was careful this time to ensure all version numbers had Beta removed, the error message is something about local and remote repositories being different but my locals are the same as remote, perhaps its referring to your local.
Just for a bit of fun/in the interest of research, I flicked into Optimise Discharging at just gone 6 and it discharged until 7. I don't know if the timings were anything to do with the Saver Session or if that would have been the plan anyway. Usually Optimise Discharge tends to set a plan to start dumping the batteries around 4:30 pm.
I think it was the savings event, as your log is showing the higher export price for the hour, making it the most preferable time to discharge.
In the absence of being able to release v4.0.11 formal, I've released v4.0.11-Beta-4 which removes all the logging thats generated during a savings session. Will close the issue when v4.0.11 formal is released (via PR).
![github-actions[bot] avatar](https://avatars.githubusercontent.com/in/15368?v=4 "Published by a pub.dev verified publisher"){kind=small}