New binding available: SolarEdge binding

Kbaras · October 16, 2018, 9:16pm

Hello,

I restarted openhab, set legacy code to “true”, and removed older logfiles. I don’t understand, but now it is green, I logged in
Thank you for the quick reply

LarsB · November 15, 2018, 8:13pm

I have a setup similar to Ron’s, just configured it, and everythings works like a charm (Great work Alex )
One thing I cant figure out, is how I change WH to KWH ??

I found this on the GitHub page, and tried several combination without luck

Available channels depend on the specific setup e.g. if a meter and/or a battery is present.
Following models/channels are currently available
All numeric channels use the UoM feature (see https://www.eclipse.org/smarthome/blog/2018/02/22/units-of-measurement.html for details).
This means you can easily change the desired unit e.g. MWh instead of kWh just in your item definition

Can anyone point me in the right direction ?
/Lars

bartus · November 15, 2018, 11:07pm

As long as you’re using OH 2.4 or later (which brought in units of measure (UoM), you can do that by defining the unit in your item definition, i.e.

For kWh:

Number:Energy           SE7600_Production_Day    "Day Production [%.1f kWh]"   (gSolar)      {channel="solaredge:generic:yourid:aggregate_day#production"}

For W:

Number:Energy           SE7600_Production_Day    "Day Production [%.1f W]"   (gSolar)      {channel="solaredge:generic:yourid:aggregate_day#production"}

For default (whatever the binding sends):

Number:Energy           SE7600_Production_Day    "Day Production [%.1f %unit%]"   (gSolar)      {channel="solaredge:generic:yourid:aggregate_day#production"}

NicGray · November 16, 2018, 4:59am

I am on 2.4.m3 and found that if I tried to use UoM to change the Day values from Wh to kWh it just changed the unit but the numbers were still Watts. For now Grafana handles it so I haven’t validated whether it should work yet in that version or is a bug in the binding. Strangely the default for the Live values is kWh…

LarsB · November 17, 2018, 5:49am

Hi Bartus

I wasn’t aware that it required openHAB 2.4 - thanks for the clarification

/Lars

brononius · November 20, 2018, 1:29pm

Hey,
Also trying out the new binding…
With the ‘old’ binding (manual jar file), everything was working.

I’m having a SolarEdge Convertor, with optimizer, but without a meter or batteries. The token I’m using, was found through the cookie in google chrome (SPRING_SECURITY_REMEMBER_ME_COOKIE), this wasn’t the same as the token before (with the jar-file)?

When I now try the new binding (through PaperUI), it seems I cant get the ‘live’ data coming in.
Only combination right now is attempt 2 (see below).

Tested:

When I use the ‘Private Option’ ON, Legacy OFF:

Status: OFFLINE - CONFIGURATION_ERROR a meter must be present in order to use the private API

When I use the ‘Private Option’ ON, Legacy ON:

Average data is coming in, but no ‘realtime’ data.

When I use the ‘Private Option’ OFF, Legacy ON:

invalid api key or solarId is not valid for this api key

When I use the ‘Private Option’ OFF, Legacy OFF:

invalid api key or solarId is not valid for this api key

For reference:

solaredge.items:

Number:Power   se15000_Prod    "Huidige productie [%.2f kW]"   <sun>    {channel="solaredge:generic:57b4a87c:live#production" }
Number         se15000_DProd   "Productie Dag [%.2f kW]"       <line>   { channel="solaredge:generic:57b4a87c:aggregate_day#production" }
Number         se15000_WProd   "Productie Week [%.2f kW]"      <line>   { channel="solaredge:generic:57b4a87c:aggregate_week#production" }
Number         se15000_MProd   "Productie Maand [%.2f kW]"     <line>   { channel="solaredge:generic:57b4a87c:aggregate_month#production" }
Number         se15000_YProd   "Productie Jaar [%.2f kW]"      <line>   { channel="solaredge:generic:57b4a87c:aggregate_year#production" }

default.sitemap

Frame label="PV" {  
      Text item=se15000_Prod 
      Text item=se15000_DProd  
      Text item=se15000_WProd
      Text item=se15000_MProd
      Text item=se15000_YProd
      }

Any idea what I’m doing wrong?

ps if it’s easier that I give you my token and ID, no prob. Let me know…

bartus · November 20, 2018, 1:59pm

Is that really the cookie that contains the key for SolarEdge, or are you possibly looking at the wrong file for your token? Actually, the token shouldn’t have changed between the JAR binding and the M6 one. Look for an “API Key” in your monitoring.solaredge.com website’s Admin->Site Access section, as that’s what you need for the cloud operation to work.

brononius · November 20, 2018, 4:43pm

OK. Missed the API key on the Solaredge Admin site.
I tried this one, and at first sight, the API key is working.

When the private API is OFF, Legacy ON, the average is coming in. But no ‘live’ data.

2018-11-20 16:32:26.258 [vent.ItemStateChangedEvent] - se15000_Prod changed from NULL to 0.0 kW
2018-11-20 16:34:11.878 [vent.ItemStateChangedEvent] - se15000_DProd changed from NULL to 2142.0
2018-11-20 16:34:16.875 [vent.ItemStateChangedEvent] - se15000_WProd changed from NULL to 6742.0
2018-11-20 16:34:21.863 [vent.ItemStateChangedEvent] - se15000_MProd changed from NULL to 257079.0
2018-11-20 16:34:28.614 [vent.ItemStateChangedEvent] - se15000_YProd changed from NULL to 7851655.0

After about 80 minutes, no updates seen for the live production data…

bartus · November 20, 2018, 5:00pm

Since you don’t have a meter, turn legacy “OFF” - that way, the binding will pull data from the API (website).

brononius · November 20, 2018, 5:47pm

Changed this to ‘no legacy’, but no improvement. Only one update received…

2018-11-20 18:15:32.952 [vent.ItemStateChangedEvent] - se15000_WProd changed from NULL to UNDEF
2018-11-20 18:15:32.957 [vent.ItemStateChangedEvent] - se15000_DProd changed from NULL to 2142.0
2018-11-20 18:15:32.958 [vent.ItemStateChangedEvent] - se15000_MProd changed from NULL to 257079.0    
2018-11-20 18:15:32.958 [vent.ItemStateChangedEvent] - se15000_YProd changed from NULL to 7851655.0
2018-11-20 18:15:32.964 [vent.ItemStateChangedEvent] - se15000_Prod changed from NULL to 0.0 kW

AlexF · November 20, 2018, 6:08pm

Please check documentation: https://www.openhab.org/addons/bindings/solaredge/

The option legacyMode does not exist anymore. This might be your issue, or maybe another problem with your configuration.

brononius · November 21, 2018, 5:26pm

Ahhh, OK. Guess my problem is that I was still on M5. I saw that M6 was already provided.
This can explain why I still see the legacy, and no ‘meterinstalled’ option in the GUI.

So did the upgrade yesterday, but noticed then that I had reached the limit of 300 request. So I waited till today, and tadaaaa… It works!!!

Thanks a lot!

greg_smith · November 27, 2018, 10:24am

Ummm… completely noob to Openhab and pretty new to Raspberry Pis.

First time I muddled through installing Openhab, I saw the SolarEdge bindings in PaperUI under Addons/Bindings - installed it and it worked.

Decided to do a fresh install of Raspian and Openhab2, now the SolarEdge binding is not in the list anymore. Kind of confused by this… how can I make it show up in Addons/Bindings binding again?

brononius · November 27, 2018, 1:25pm

Yelled a bit to soon…

The live data is pulled every 10 minutes (as expected).
But the averages (week, month…) aren’t.

Am I missing something somewhere?

AlexF · November 27, 2018, 3:52pm

Hi @greg_smith ,

the Solaredge Binding is quite new so maybe you switched to the latest release 2.3.0 which does not yet contain the solaredge binding. 2.4.0 will soon be released, Solaredge binding is included then. Otherwise you could put the 2.4.0-SNAPSHOT version (the link was posted above in the thread) into the “addons” folder. It should work.

@brononius:
To be able to help you, I will at least need your thing/item configuration. It would be even better to have the debug logs but maybe I can find an issue regarding your configuration.

BR
Alex

brononius · November 27, 2018, 4:16pm

Hey AlexF,

The thing is configured by the PaperUI. So not so easy to copy/paste this.

My item file:

Number:Power    se15000_Prod                    "Huidige productie [%.2f kW]"           <sun>           (BU_solar)      { channel="solaredge:generic:57b4a87c:live#production" }
Number:Energy   se15000_DProd                   "Productie Dag [%.2f kW]"               <line>                          { channel="solaredge:generic:57b4a87c:aggregate_day#production" }
Number:Energy   se15000_WProd                   "Productie Week [%.2f kW]"              <line>                          { channel="solaredge:generic:57b4a87c:aggregate_week#production" }
Number:Energy   se15000_MProd                   "Productie Maand [%.2f kW]"             <line>                          { channel="solaredge:generic:57b4a87c:aggregate_month#production" }
Number:Energy   se15000_YProd                   "Productie Jaar [%.2f kW]"              <line>                          { channel="solaredge:generic:57b4a87c:aggregate_year#production" }
Number:Energy   se15000_ProdAverage             "Gemiddelde vandaag [%.2f kW]"          <incline>

My logfile from this afternoon (grep se15000 events.log):

2018-11-27 14:07:43.741 [vent.ItemStateChangedEvent] - se15000_Prod changed from 0.731 kW to 0.676 kW
2018-11-27 14:07:43.746 [vent.ItemStateChangedEvent] - se15000_ProdAverage changed from 0.1689947207801861 kW to 0.1807532923500102 kW
2018-11-27 14:17:50.606 [vent.ItemStateChangedEvent] - se15000_Prod changed from 0.676 kW to 0.457 kW
2018-11-27 14:17:50.612 [vent.ItemStateChangedEvent] - se15000_ProdAverage changed from 0.1807532923500102 kW to 0.19071195391038 kW
2018-11-27 14:21:46.326 [temChannelLinkRemovedEvent] - Link 'se15000_Prod => solaredge:generic:57b4a87c:live#production' has been removed.
2018-11-27 14:21:46.327 [temChannelLinkRemovedEvent] - Link 'se15000_DProd => solaredge:generic:57b4a87c:aggregate_day#production' has been removed.
2018-11-27 14:21:46.328 [temChannelLinkRemovedEvent] - Link 'se15000_YProd => solaredge:generic:57b4a87c:aggregate_year#production' has been removed.
2018-11-27 14:21:46.328 [temChannelLinkRemovedEvent] - Link 'se15000_WProd => solaredge:generic:57b4a87c:aggregate_week#production' has been removed.
2018-11-27 14:21:46.329 [temChannelLinkRemovedEvent] - Link 'se15000_MProd => solaredge:generic:57b4a87c:aggregate_month#production' has been removed.
2018-11-27 14:21:46.377 [.ItemChannelLinkAddedEvent] - Link 'se15000_Prod-solaredge:generic:57b4a87c:live#production' has been added.
2018-11-27 14:21:46.378 [.ItemChannelLinkAddedEvent] - Link 'se15000_DProd-solaredge:generic:57b4a87c:aggregate_day#production' has been added.
2018-11-27 14:21:46.379 [.ItemChannelLinkAddedEvent] - Link 'se15000_WProd-solaredge:generic:57b4a87c:aggregate_week#production' has been added.
2018-11-27 14:21:46.379 [.ItemChannelLinkAddedEvent] - Link 'se15000_MProd-solaredge:generic:57b4a87c:aggregate_month#production' has been added.
2018-11-27 14:21:46.380 [.ItemChannelLinkAddedEvent] - Link 'se15000_YProd-solaredge:generic:57b4a87c:aggregate_year#production' has been added.
2018-11-27 14:26:42.484 [vent.ItemStateChangedEvent] - se15000_MProd changed from NULL to UNDEF
2018-11-27 14:26:42.486 [vent.ItemStateChangedEvent] - se15000_WProd changed from NULL to UNDEF
2018-11-27 14:26:42.486 [vent.ItemStateChangedEvent] - se15000_YProd changed from NULL to UNDEF
2018-11-27 14:26:42.487 [vent.ItemStateChangedEvent] - se15000_Prod changed from NULL to 0.308 kW
2018-11-27 14:26:42.489 [vent.ItemStateChangedEvent] - se15000_DProd changed from NULL to UNDEF
2018-11-27 14:26:42.625 [vent.ItemStateChangedEvent] - se15000_ProdAverage changed from NULL to 0.1961609545043435 kW
2018-11-27 14:37:11.872 [vent.ItemStateChangedEvent] - se15000_Prod changed from 0.308 kW to 0.136 kW
2018-11-27 14:37:11.877 [vent.ItemStateChangedEvent] - se15000_ProdAverage changed from 0.1961609545043435 kW to 0.2016862209699206 kW
2018-11-27 14:47:09.208 [vent.ItemStateChangedEvent] - se15000_Prod changed from 0.136 kW to 0.019 kW
2018-11-27 14:47:09.212 [vent.ItemStateChangedEvent] - se15000_ProdAverage changed from 0.2016862209699206 kW to 0.2033382279962537 kW
2018-11-27 14:57:13.660 [vent.ItemStateChangedEvent] - se15000_Prod changed from 0.019 kW to 0.323 kW
2018-11-27 14:57:13.672 [vent.ItemStateChangedEvent] - se15000_ProdAverage changed from 0.2033382279962537 kW to 0.2049696808096935 kW
2018-11-27 15:07:21.314 [vent.ItemStateChangedEvent] - se15000_Prod changed from 0.323 kW to 0.29 kW
2018-11-27 15:07:21.319 [vent.ItemStateChangedEvent] - se15000_ProdAverage changed from 0.2049696808096935 kW to 0.207825531841394 kW
2018-11-27 15:17:22.477 [vent.ItemStateChangedEvent] - se15000_Prod changed from 0.29 kW to 0.178 kW
2018-11-27 15:17:22.483 [vent.ItemStateChangedEvent] - se15000_ProdAverage changed from 0.207825531841394 kW to 0.2124951987316902 kW
2018-11-27 15:27:27.998 [vent.ItemStateChangedEvent] - se15000_Prod changed from 0.178 kW to 0.134 kW
2018-11-27 15:27:28.004 [vent.ItemStateChangedEvent] - se15000_ProdAverage changed from 0.2124951987316902 kW to 0.2146281477655602 kW
2018-11-27 15:37:28.793 [vent.ItemStateChangedEvent] - se15000_Prod changed from 0.134 kW to 0.149 kW
2018-11-27 15:37:28.798 [vent.ItemStateChangedEvent] - se15000_ProdAverage changed from 0.2146281477655602 kW to 0.2173083919466644 kW
2018-11-27 15:47:33.314 [vent.ItemStateChangedEvent] - se15000_Prod changed from 0.149 kW to 0.262 kW
2018-11-27 15:47:33.320 [vent.ItemStateChangedEvent] - se15000_ProdAverage changed from 0.2173083919466644 kW to 0.219000004794628 kW
2018-11-27 15:57:37.073 [vent.ItemStateChangedEvent] - se15000_Prod changed from 0.262 kW to 0.134 kW
2018-11-27 15:57:37.078 [vent.ItemStateChangedEvent] - se15000_ProdAverage changed from 0.219000004794628 kW to 0.2226133759756468 kW
2018-11-27 16:07:41.948 [vent.ItemStateChangedEvent] - se15000_Prod changed from 0.134 kW to 0.194 kW
2018-11-27 16:07:41.954 [vent.ItemStateChangedEvent] - se15000_ProdAverage changed from 0.2226133759756468 kW to 0.2243905117853759 kW
2018-11-27 16:17:34.638 [vent.ItemStateChangedEvent] - se15000_Prod changed from 0.194 kW to 0.002 kW
2018-11-27 16:17:34.644 [vent.ItemStateChangedEvent] - se15000_ProdAverage changed from 0.2243905117853759 kW to 0.2272501776986133 kW
2018-11-27 16:27:45.658 [vent.ItemStateChangedEvent] - se15000_Prod changed from 0.002 kW to 0.0 kW
2018-11-27 16:27:45.664 [vent.ItemStateChangedEvent] - se15000_ProdAverage changed from 0.2272501776986133 kW to 0.2271736829731517 kW

AlexF · November 29, 2018, 8:12am

Hi @brononius,

your provided logs do not reveal any new information. I cannot see if the aggregate data is not processed or if it is not even polled.
Please activate debug logging it should then look like this:

Binding should be initialized

2018-11-29 08:55:20.324 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:77   ] - About to initialize SolarEdge
2018-11-29 08:55:20.324 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:79   ] - Solaredge initialized with configuration: org.openhab.binding.solaredge.internal.config.SolarEdgeConfiguration@4d36f095[tokenOrApiKey=******,solarId=******,meterInstalled=true,usePrivateApi=false,live data pollingInterval=1,aggregate data pollingInterval=1,asyncTimeout=120,syncTimeout=120]
2018-11-29 08:55:20.338 [INFO ] [ome.event.ThingStatusInfoEvent:53   ] - 'solaredge:generic:se2200' updated: UNKNOWN: waiting for web api login
2018-11-29 08:55:20.339 [INFO ] [nt.ThingStatusInfoChangedEvent:53   ] - 'solaredge:generic:se2200' changed from INITIALIZING to UNKNOWN: waiting for web api login

Login should be sucessful

2018-11-29 08:57:03.330 [INFO ] [ome.event.ThingStatusInfoEvent:53   ] - 'solaredge:generic:se2200' updated: ONLINE: logged in
2018-11-29 08:57:03.333 [INFO ] [nt.ThingStatusInfoChangedEvent:53   ] - 'solaredge:generic:se2200' changed from UNKNOWN: waiting for web api login to ONLINE: logged in
2018-11-29 08:57:07.657 [DEBUG] [.s.i.c.AbstractCommandCallback:123  ] - received content, length: 320
2018-11-29 08:57:07.693 [DEBUG] [.s.i.c.AbstractCommandCallback:98   ] - HTTP response 200
2018-11-29 08:57:07.693 [DEBUG] [.s.i.c.AbstractCommandCallback:54   ] - onComplete()

Livedata is polled in a single request:

2018-11-29 09:04:19.002 [DEBUG] [s.i.h.SolarEdgeLiveDataPolling:48   ] - polling SolarEdge live data org.openhab.binding.solaredge.internal.config.SolarEdgeConfiguration@217909dd[tokenOrApiKey=******,solarId=******,meterInstalled=true,usePrivateApi=false,live data pollingInterval=1,aggregate data pollingInterval=1,asyncTimeout=120,syncTimeout=120]
2018-11-29 09:04:22.337 [DEBUG] [.s.i.c.AbstractCommandCallback:123  ] - received content, length: 349
2018-11-29 09:04:22.338 [DEBUG] [.s.i.c.AbstractCommandCallback:98   ] - HTTP response 200
2018-11-29 09:04:22.338 [DEBUG] [.s.i.c.AbstractCommandCallback:54   ] - onComplete()
2018-11-29 09:04:22.339 [DEBUG] [.s.i.c.AbstractCommandCallback:65   ] - JSON String: {"siteCurrentPowerFlow":{"updateRefreshRate":3,"unit":"kW","connections":[{"from":"GRID","to":"Load"},{"from":"PV","to":"Load"}],"GRID":{"status":"Active","currentPower":0.39},"LOAD":{"status":"Active","currentPower":0.43},"PV":{"status":"Active","currentPower":0.04},"STORAGE":{"status":"Idle","currentPower":0.0,"chargeLevel":9,"critical":false}}}
2018-11-29 09:04:22.339 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:123  ] - Handling channel update.
2018-11-29 09:04:22.339 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:128  ] - Channel is to be updated: live#battery_charge: 0.0 kW
2018-11-29 09:04:22.340 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:128  ] - Channel is to be updated: live#grid_status: Active
2018-11-29 09:04:22.340 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:128  ] - Channel is to be updated: live#battery_level: 9.0 %
2018-11-29 09:04:22.341 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:128  ] - Channel is to be updated: live#export: 0.0 kW
2018-11-29 09:04:22.341 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:128  ] - Channel is to be updated: live#battery_status: Idle
2018-11-29 09:04:22.342 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:128  ] - Channel is to be updated: live#battery_discharge: 0.0 kW
2018-11-29 09:04:22.342 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:128  ] - Channel is to be updated: live#pv_status: Active
2018-11-29 09:04:22.342 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:128  ] - Channel is to be updated: live#load_status: Active
2018-11-29 09:04:22.342 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:128  ] - Channel is to be updated: live#battery_critical: false
2018-11-29 09:04:22.343 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:128  ] - Channel is to be updated: live#import: 0.39 kW
2018-11-29 09:04:22.343 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:128  ] - Channel is to be updated: live#battery_charge_discharge: 0.0 kW
2018-11-29 09:04:22.343 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:128  ] - Channel is to be updated: live#consumption: 0.43 kW
2018-11-29 09:04:22.344 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:128  ] - Channel is to be updated: live#production: 0.04 kW
2018-11-29 09:04:22.345 [INFO ] [smarthome.event.ItemStateEvent:53   ] - SE_CUR_CHARGE_RATE updated to 0.0 kW
2018-11-29 09:04:22.345 [INFO ] [smarthome.event.ItemStateEvent:53   ] - SE_CUR_BATT_LEVEL updated to 9.0 %
2018-11-29 09:04:22.347 [INFO ] [smarthome.event.ItemStateEvent:53   ] - SE_CUR_EXPORT updated to 0.0 kW
2018-11-29 09:04:22.348 [INFO ] [smarthome.event.ItemStateEvent:53   ] - SE_CUR_DISCHARGE_RATE updated to 0.0 kW
2018-11-29 09:04:22.348 [INFO ] [smarthome.event.ItemStateEvent:53   ] - SE_CUR_IMPORT updated to 0.39 kW
2018-11-29 09:04:22.349 [INFO ] [smarthome.event.ItemStateEvent:53   ] - SE_CUR_CHARGE_DISCHARGE updated to 0.0 kW
2018-11-29 09:04:22.349 [INFO ] [smarthome.event.ItemStateEvent:53   ] - SE_CUR_CONSUMPTION updated to 0.43 kW
2018-11-29 09:04:22.350 [INFO ] [smarthome.event.ItemStateEvent:53   ] - SE_CUR_PRODUCTION updated to 0.04 kW
2018-11-29 09:04:22.357 [INFO ] [s.event.ItemStateChangedEvent :53   ] - SE_CUR_CHARGE_RATE changed from NULL to 0.0 kW
2018-11-29 09:04:22.357 [DEBUG] [.m.r.r.i.engine.RuleEngineImpl:338  ] - Executing rule 'Nibe SG Ready Emulation'
2018-11-29 09:04:22.361 [INFO ] [s.event.ItemStateChangedEvent :53   ] - SE_CUR_BATT_LEVEL changed from NULL to 9.0 %
2018-11-29 09:04:22.364 [INFO ] [s.event.ItemStateChangedEvent :53   ] - SE_CUR_EXPORT changed from NULL to 0.0 kW
2018-11-29 09:04:22.365 [INFO ] [s.event.ItemStateChangedEvent :53   ] - SE_CUR_DISCHARGE_RATE changed from NULL to 0.0 kW
2018-11-29 09:04:22.366 [INFO ] [s.event.ItemStateChangedEvent :53   ] - SE_CUR_IMPORT changed from NULL to 0.39 kW
2018-11-29 09:04:22.366 [INFO ] [s.event.ItemStateChangedEvent :53   ] - SE_CUR_CHARGE_DISCHARGE changed from NULL to 0.0 kW
2018-11-29 09:04:22.367 [INFO ] [s.event.ItemStateChangedEvent :53   ] - SE_CUR_CONSUMPTION changed from NULL to 0.43 kW
2018-11-29 09:04:22.370 [INFO ] [s.event.ItemStateChangedEvent :53   ] - SE_CUR_PRODUCTION changed from NULL to 0.04 kW

Aggregate data is polled in different requests:

2018-11-29 09:05:18.998 [DEBUG] [.SolarEdgeAggregateDataPolling:53   ] - polling SolarEdge aggregate data org.openhab.binding.solaredge.internal.config.SolarEdgeConfiguration@1668ae53[tokenOrApiKey=******,solarId=******,meterInstalled=true,usePrivateApi=false,live data pollingInterval=1,aggregate data pollingInterval=1,asyncTimeout=120,syncTimeout=120]
2018-11-29 09:05:23.039 [DEBUG] [.s.i.c.AbstractCommandCallback:123  ] - received content, length: 446
2018-11-29 09:05:23.040 [DEBUG] [.s.i.c.AbstractCommandCallback:98   ] - HTTP response 200
2018-11-29 09:05:23.041 [DEBUG] [.s.i.c.AbstractCommandCallback:84   ] - onComplete()
2018-11-29 09:05:23.041 [DEBUG] [.s.i.c.AbstractCommandCallback:98   ] - JSON String: {"energyDetails":{"timeUnit":"DAY","unit":"Wh","meters":[{"type":"FeedIn","values":[{"date":"2018-11-29 00:00:00","value":0.0}]},{"type":"Production","values":[{"date":"2018-11-29 00:00:00","value":0.0}]},{"type":"SelfConsumption","values":[{"date":"2018-11-29 00:00:00","value":0.0}]},{"type":"Consumption","values":[{"date":"2018-11-29 00:00:00","value":6050.0}]},{"type":"Purchased","values":[{"date":"2018-11-29 00:00:00","value":6071.0}]}]}}
2018-11-29 09:05:23.042 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:123  ] - Handling channel update.
2018-11-29 09:05:23.042 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:128  ] - Channel is to be updated: aggregate_day#export: 0.0 Wh
2018-11-29 09:05:23.046 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:128  ] - Channel is to be updated: aggregate_day#production: 0.0 Wh
2018-11-29 09:05:23.049 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:128  ] - Channel is to be updated: aggregate_day#import: 6071.0 Wh
2018-11-29 09:05:23.051 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:128  ] - Channel is to be updated: aggregate_day#selfConsumptionCoverage: 0.0 %
2018-11-29 09:05:23.052 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:128  ] - Channel is to be updated: aggregate_day#consumption: 6050.0 Wh
2018-11-29 09:05:23.054 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:128  ] - Channel is to be updated: aggregate_day#selfConsumptionForConsumption: 0.0 Wh
2018-11-29 09:05:23.066 [INFO ] [smarthome.event.ItemStateEvent:53   ] - SE_DAY_EXPORT updated to 0.0 kWh
2018-11-29 09:05:23.077 [INFO ] [smarthome.event.ItemStateEvent:53   ] - SE_DAY_PRODUCTION updated to 0.0 kWh
2018-11-29 09:05:23.078 [INFO ] [smarthome.event.ItemStateEvent:53   ] - SE_DAY_IMPORT updated to 6.071 kWh
2018-11-29 09:05:23.078 [INFO ] [smarthome.event.ItemStateEvent:53   ] - SE_DAY_COVERAGE updated to 0.0 %
2018-11-29 09:05:23.079 [INFO ] [smarthome.event.ItemStateEvent:53   ] - SE_DAY_CONSUMPTION updated to 6.05 kWh
2018-11-29 09:05:23.079 [INFO ] [s.event.ItemStateChangedEvent :53   ] - SE_DAY_EXPORT changed from NULL to 0.0 kWh
2018-11-29 09:05:23.079 [INFO ] [s.event.ItemStateChangedEvent :53   ] - SE_DAY_PRODUCTION changed from NULL to 0.0 kWh
2018-11-29 09:05:23.080 [INFO ] [s.event.ItemStateChangedEvent :53   ] - SE_DAY_IMPORT changed from NULL to 6.071 kWh
2018-11-29 09:05:23.080 [INFO ] [s.event.ItemStateChangedEvent :53   ] - SE_DAY_COVERAGE changed from NULL to 0.0 %
2018-11-29 09:05:23.083 [INFO ] [s.event.ItemStateChangedEvent :53   ] - SE_DAY_CONSUMPTION changed from NULL to 6.05 kWh
2018-11-29 09:05:27.904 [DEBUG] [.s.i.c.AbstractCommandCallback:123  ] - received content, length: 456
2018-11-29 09:05:27.914 [DEBUG] [.s.i.c.AbstractCommandCallback:98   ] - HTTP response 200
2018-11-29 09:05:27.915 [DEBUG] [.s.i.c.AbstractCommandCallback:84   ] - onComplete()
2018-11-29 09:05:27.915 [DEBUG] [.s.i.c.AbstractCommandCallback:98   ] - JSON String: {"energyDetails":{"timeUnit":"WEEK","unit":"Wh","meters":[{"type":"FeedIn","values":[{"date":"2018-11-26 00:00:00","value":58.0}]},{"type":"SelfConsumption","values":[{"date":"2018-11-26 00:00:00","value":5110.0}]},{"type":"Production","values":[{"date":"2018-11-26 00:00:00","value":5110.0}]},{"type":"Consumption","values":[{"date":"2018-11-26 00:00:00","value":60307.0}]},{"type":"Purchased","values":[{"date":"2018-11-26 00:00:00","value":55210.0}]}]}}
2018-11-29 09:05:27.917 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:123  ] - Handling channel update.
...
2018-11-29 09:05:33.292 [DEBUG] [.s.i.c.AbstractCommandCallback:98   ] - JSON String: {"energyDetails":{"timeUnit":"MONTH","unit":"Wh","meters":[{"type":"FeedIn","values":[{"date":"2018-11-01 00:00:00","value":8291.0}]},{"type":"Production","values":[{"date":"2018-11-01 00:00:00","value":136335.0}]},{"type":"SelfConsumption","values":[{"date":"2018-11-01 00:00:00","value":132127.0}]},{"type":"Consumption","values":[{"date":"2018-11-01 00:00:00","value":457497.0}]},{"type":"Purchased","values":[{"date":"2018-11-01 00:00:00","value":328682.0}]}]}}
2018-11-29 09:05:33.294 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:123  ] - Handling channel update.
...
2018-11-29 09:05:38.651 [DEBUG] [.s.i.c.AbstractCommandCallback:98   ] - JSON String: {"energyDetails":{"timeUnit":"YEAR","unit":"Wh","meters":[{"type":"FeedIn","values":[{"date":"2018-01-01 00:00:00","value":388086.0}]},{"type":"SelfConsumption","values":[{"date":"2018-01-01 00:00:00","value":2881344.0}]},{"type":"Production","values":[{"date":"2018-01-01 00:00:00","value":3210095.0}]},{"type":"Consumption","values":[{"date":"2018-01-01 00:00:00","value":5224542.0}]},{"type":"Purchased","values":[{"date":"2018-01-01 00:00:00","value":2403873.0}]}]}}
2018-11-29 09:05:38.652 [DEBUG] [o.b.s.i.h.SolarEdgeBaseHandler:123  ] - Handling channel update.
...

brononius · November 29, 2018, 8:40am

When I debug the info, a lot is being put. I think beside on logs of knx, zwave…
Any way to filter just the log of Solaredge?

Also, do i wait the next run (fe every hour) for the aveage?
Or is there a way to ‘push’ the pull?

AlexF · November 29, 2018, 11:37am

In the first place you could start with setting debug only for solaredge binding, e.g. via karaf console

log:set DEBUG org.openhab.binding.solaredge

brononius · November 29, 2018, 1:37pm

I know. But if I let run that, a lot of logs are generated (zwave info, knx info, zoneminder…).
So I was wondering how you guys limit it to see just the solaredge info.
A “log:tail | grep olar” or something?