[BTicino/OpenWebNet] New openHAB2 binding ready for testing

k0nti · December 27, 2018, 10:17pm

Hi,

Setup:
Openhab 2.5 Snapshot / Openwebnet Binding 9

I have a question. In my systems i have a “All Lights OFF”
In my Log tail it looks light that
“2018-12-27 23:12:40.420 [DEBUG] [bnet.handler.OpenWebNetBridgeHandler] - ==OWN== ownId=0 has NO THING associated, ignoring it”
So all lights are off and my openhab don’t recognize it -> because of the “All Lights OFF” Switch.

Have i forgot something? or isn’t it integrated yet?
Thank you guys for your great work and affort.
bg Patrick

gozilla01 · December 28, 2018, 12:53am

Sorry but I do not think I understood your problem well, if you intend to use AMB, GR and GEN (Environment, Groups and General) are not implemented.
If you have a scene module (MH200N , MH202, ecc. )then you can create a scene with CEN + activation and configure the command to OH, but you have to binding beta9-1 and follow this example.
Or publish the configuration part, .things and .items

tagada · December 28, 2018, 8:35am

Hello all
I have a problem with heating sitemap
Logs:
2018-12-28 09:25:27.339 [ERROR] [ui.internal.items.ItemUIRegistryImpl] - Cannot retrieve item ‘gC_SdB_thermo’ for widget org.eclipse.smarthome.model.sitemap.Text

2018-12-28 09:25:27.343 [ERROR] [ui.internal.items.ItemUIRegistryImpl] - Cannot retrieve item ‘gC_SdB_thermo’ for widget org.eclipse.smarthome.model.sitemap.Text

2018-12-28 09:25:27.346 [ERROR] [ui.internal.items.ItemUIRegistryImpl] - Cannot retrieve item for widget org.eclipse.smarthome.model.sitemap.Text

2018-12-28 09:25:27.351 [ERROR] [ui.internal.items.ItemUIRegistryImpl] - Cannot retrieve item for widget org.eclipse.smarthome.model.sitemap.Text

My items:
Group gC_SdB_Thermo

Number:Temperature tC_SdB_temp “SdB RdJ [%.1f Â°C]” (gC_SdB_Thermo, Temperatures) { channel=“openwebnet:bus_thermostat:mybridge:BtSdB_RdJ_Th:temperature” }
String tC_SdB_offset “Offset” (gC_SdB_Thermo) { channel=“openwebnet:bus_thermostat:mybridge:BtSdB_RdJ_Th:localMode” }
Switch tC_SdB_heating “Heating is” (gC_SdB_Thermo) { channel=“openwebnet:bus_thermostat:mybridge:BtSdB_RdJ_Th:heating” }
Switch tC_SdB_cooling “Cooling is” (gC_SdB_Thermo) { channel=“openwebnet:bus_thermostat:mybridge:BtSdB_RdJ_Th:cooling” }
Number:Temperature tC_SdB_targetTemp “Target [%.1f Â°C]” (gC_SdB_Thermo) { channel=“openwebnet:bus_thermostat:mybridge:BtSdB_RdJ_Th:targetTemperature” }
String tC_SdB_activeMode “Mode Actuel” (gC_SdB_Thermo) { channel=“openwebnet:bus_thermostat:mybridge:BtSdB_RdJ_Th:activeMode” }
String tC_SdB_heatcool “HeatingCoolingMode” (gC_SdB_Thermo) { channel=“openwebnet:bus_thermostat:mybridge:BtSdB_RdJ_Th:heatingCoolingMode” }
Number:Temperature tC_SdB_setpointTemp “Setpoint Temperature [%.1f Â°C]” (gC_SdB_Thermo) { channel=“openwebnet:bus_thermostat:mybridge:BtSdB_RdJ_Th:setpointTemperature” }
String tC_SdB_setMode “Reglage Mode” (gC_SdB_Thermo) { channel=“openwebnet:bus_thermostat:mybridge:BtSdB_RdJ_Th:setMode”}

My Sitemap:
Frame label=“Thermoregulation” {

Text item=gC_SdB_thermo label=“Thermostat SdB RdJ” icon=“heating”
{
Default item=tC_SdB_temp label=“Temperature” icon=“temperature”
Default item=tC_SdB_targetTemp label=“Temperature Reglee” icon=“temperature”
Default item=tC_SdB_offset icon=“heating” visibility=[tC_sdB_offset != “NORMAL”]
Text item=tC_SdB_heatcool icon=“fire” label=“Chauffage Actif” labelcolor=[“red”] visibility=[tC_SdB_heating==“ON”]
Text item=tC_SdB_heatcool icon=“climate” label=“Refroidissement Actif” labelcolor=[“blue”] visibility=[tC_SdB_cooling==“ON”]
Default item=tC_SdB_activeMode icon=“radiator” valuecolor=[AUTO=“green”, MANUAL=“orange”, PROTECTION=“blue”, OFF=“red”]
Selection item=tC_SdB_setMode icon=“heating” mappings=[AUTO=“Auto”, MANUAL=“Manuel”, PROTECTION=“Hors-Gel”, OFF=“Off”]
Setpoint item=tC_SdB_setpointTemp label=“Reglage Temp [%.1f Â°C]” minValue=12 maxValue=25 step=0.5
}
}

or i’m wrong ?

Thermo cental logs:
2018-12-28 09:32:22.272 [WARN ] [penwebnet.message.OpenMessageFactory] - ##openwebnet## unsupported WHAT 1101 from frame 41101*#0##

2018-12-28 09:32:22.326 [WARN ] [penwebnet.message.OpenMessageFactory] - ##openwebnet## unsupported WHAT 21 from frame 421*#0##
it’s normal ?

Best regards,
Arnaud_

bastler · December 28, 2018, 8:40am

may be your items is
gC_SdB_Thermo (big letter “T”)
and your sitemap is
gC_SdB_thermo
?

tagada · December 28, 2018, 8:59am

Opps, I did not see the syntax error
It’s Works
Thank you Stefan

Can we choose 1,2,3, summer, winter programs on the 3550 plant?

Currently “active mode” displays only the state “Off and anti freeze” not the state “auto or manual”

2018-12-28 09: 55: 36.786 [WARN] [penwebnet.message.openMessageFactory] - ## openwebnet ## unsupported WHAT 1101 from frame * 4 * 1101 * # 0 ##

2018-12-28 09: 55: 36.830 [WARN] [penwebnet.message.OpenMessageFactory] - ## openwebnet ## unsupported WHAT 21 from frame * 4 * 21 * # 0 ##

2018-12-28 09: 55: 39.937 [WARN] [penwebnet.message.openMessageFactory] - ## openwebnet ## unsupported WHAT 22 from frame * 4 * 22 * # 0 ##

2018-12-28 09: 55: 36.860 [WARN] [penwebnet.message.OpenMessageFactory] - ## openwebnet ## unsupported WHAT 23 from frame * 4 * 23 * # 0 ##

massi · December 28, 2018, 9:36am

Hi Patrick (@k0nti),
this issue has been raised already see here: OpenWebNet: group commands [WHERE=#n ?].
Feedbacks from group WHEREs (#0) events are not supported yet in the binding.

At least someone has to file a new issue, or it will never be tracked (and solved).

bye
M

massi · December 28, 2018, 9:45am

Hi Arnaud (@tagada),
there are 2 separate issues:

activeMode

this has been already reported by some users, I suggest you file a new Issue with some relevant and well formatted log when this happens, or it will not be tracked.

programs

Programs are not supported yet, and for example this Heating Program 01 message is not handled:
2018-12-28 09: 55: 36.786 [WARN] [penwebnet.message.openMessageFactory] - ## openwebnet ## unsupported WHAT 1101 from frame *4*1101*#0##

Again here a new issue should be added, or it will not be tracked.

The rest of unsupported messages: WHAT=21,22,23 are not relevant and useful here.

bye
M

gozilla01 · December 28, 2018, 1:23pm

@tagada @k0nti @massi
I created the issues:

gozilla01 · December 28, 2018, 1:29pm

Hi everyone,
If we want Massimo to help us with the implementation or corrections of problems, we have to write an issue here , once certain of the problem.
There are no other ways

Thanks to everyone for the collaboration

gozilla01 · December 28, 2018, 1:42pm

Hi Massimo,
you’ve probably missed the @col_1958 problem, see here
It’s Italian, do you give them an answer?
Thank you

tagada · December 28, 2018, 10:17pm

Thanks Michele

col_1958 · December 28, 2018, 11:42pm

Ok, some debug logs follow. The first is after a fresh start with beta 9.1 without attempting to discover the gateway (MHS1). As you can see upnp discovers the gateway (and the tv and the router).

2018-12-28 20:37:37.913 [WARN ] [g.eclipse.smarthome.core.net.NetUtil] - Found multiple local interfaces - ignoring 192.168.1.77
2018-12-28 20:37:38.143 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Time zone set to 'Europe/Rome'.
2018-12-28 20:37:38.155 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Location set to '44.4048,8.9444'.
2018-12-28 20:37:38.160 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Locale set to 'it_IT'.
2018-12-28 20:37:38.425 [INFO ] [ebuilder.internal.HomeBuilderServlet] - Started Home Builder at /homebuilder
2018-12-28 20:37:38.502 [INFO ] [panel.internal.HABPanelDashboardTile] - Started HABPanel at /habpanel
2018-12-28 20:37:42.480 [WARN ] [g.eclipse.smarthome.core.net.NetUtil] - Found multiple local interfaces - ignoring 192.168.1.77
2018-12-28 20:37:49.780 [INFO ] [thome.model.lsp.internal.ModelServer] - Started Language Server Protocol (LSP) service on port 5007
2018-12-28 20:37:52.650 [INFO ] [.dashboard.internal.DashboardService] - Started Dashboard at http://192.168.1.205:8080
2018-12-28 20:37:52.653 [INFO ] [.dashboard.internal.DashboardService] - Started Dashboard at https://192.168.1.205:8443
2018-12-28 20:37:53.065 [INFO ] [arthome.ui.paper.internal.PaperUIApp] - Started Paper UI at /paperui
2018-12-28 20:37:53.838 [DEBUG] [org.openhab.binding.openwebnet      ] - BundleEvent STARTING - org.openhab.binding.openwebnet
2018-12-28 20:37:53.843 [DEBUG] [org.openhab.binding.openwebnet      ] - BundleEvent STARTED - org.openhab.binding.openwebnet
2018-12-28 20:37:53.865 [ERROR] [org.openhab.binding.openwebnet      ] - bundle org.openhab.binding.openwebnet:2.4.0.201812262319 (222)[org.openhab.binding.openwebnet.internal.OpenWebNetHandlerFactory] :  Cannot register component
org.osgi.service.component.ComponentException: The component name 'org.openhab.binding.openwebnet.internal.OpenWebNetHandlerFactory' has already been registered by Bundle 222 (org.openhab.binding.openwebnet) as Component of Class org.openhab.binding.openwebnet.internal.OpenWebNetHandlerFactory
	at org.apache.felix.scr.impl.ComponentRegistry.checkComponentName(ComponentRegistry.java:235) ~[39:org.apache.felix.scr:2.1.2]
	at org.apache.felix.scr.impl.BundleComponentActivator.loadDescriptor(BundleComponentActivator.java:443) [39:org.apache.felix.scr:2.1.2]
	at org.apache.felix.scr.impl.BundleComponentActivator.initialize(BundleComponentActivator.java:315) [39:org.apache.felix.scr:2.1.2]
	at org.apache.felix.scr.impl.BundleComponentActivator.<init>(BundleComponentActivator.java:270) [39:org.apache.felix.scr:2.1.2]
	at org.apache.felix.scr.impl.Activator.loadComponents(Activator.java:379) [39:org.apache.felix.scr:2.1.2]
	at org.apache.felix.scr.impl.Activator.access$200(Activator.java:49) [39:org.apache.felix.scr:2.1.2]
	at org.apache.felix.scr.impl.Activator$ScrExtension.start(Activator.java:263) [39:org.apache.felix.scr:2.1.2]
	at org.apache.felix.scr.impl.AbstractExtender.createExtension(AbstractExtender.java:196) [39:org.apache.felix.scr:2.1.2]
	at org.apache.felix.scr.impl.AbstractExtender.modifiedBundle(AbstractExtender.java:169) [39:org.apache.felix.scr:2.1.2]
	at org.apache.felix.scr.impl.AbstractExtender.modifiedBundle(AbstractExtender.java:49) [39:org.apache.felix.scr:2.1.2]
	at org.osgi.util.tracker.BundleTracker$Tracked.customizerModified(BundleTracker.java:482) [?:?]
	at org.osgi.util.tracker.BundleTracker$Tracked.customizerModified(BundleTracker.java:415) [?:?]
	at org.osgi.util.tracker.AbstractTracked.track(AbstractTracked.java:232) [?:?]
	at org.osgi.util.tracker.BundleTracker$Tracked.bundleChanged(BundleTracker.java:444) [?:?]
	at org.eclipse.osgi.internal.framework.BundleContextImpl.dispatchEvent(BundleContextImpl.java:908) [?:?]
	at org.eclipse.osgi.framework.eventmgr.EventManager.dispatchEvent(EventManager.java:230) [?:?]
	at org.eclipse.osgi.framework.eventmgr.ListenerQueue.dispatchEventSynchronous(ListenerQueue.java:148) [?:?]
	at org.eclipse.osgi.internal.framework.EquinoxEventPublisher.publishBundleEventPrivileged(EquinoxEventPublisher.java:213) [?:?]
	at org.eclipse.osgi.internal.framework.EquinoxEventPublisher.publishBundleEvent(EquinoxEventPublisher.java:120) [?:?]
	at org.eclipse.osgi.internal.framework.EquinoxEventPublisher.publishBundleEvent(EquinoxEventPublisher.java:112) [?:?]
	at org.eclipse.osgi.internal.framework.EquinoxContainerAdaptor.publishModuleEvent(EquinoxContainerAdaptor.java:168) [?:?]
	at org.eclipse.osgi.container.Module.publishEvent(Module.java:476) [?:?]
	at org.eclipse.osgi.container.Module.start(Module.java:467) [?:?]
	at org.eclipse.osgi.container.ModuleContainer$ContainerStartLevel.incStartLevel(ModuleContainer.java:1634) [?:?]
	at org.eclipse.osgi.container.ModuleContainer$ContainerStartLevel.incStartLevel(ModuleContainer.java:1614) [?:?]
	at org.eclipse.osgi.container.ModuleContainer$ContainerStartLevel.doContainerStartLevel(ModuleContainer.java:1585) [?:?]
	at org.eclipse.osgi.container.ModuleContainer$ContainerStartLevel.dispatchEvent(ModuleContainer.java:1528) [?:?]
	at org.eclipse.osgi.container.ModuleContainer$ContainerStartLevel.dispatchEvent(ModuleContainer.java:1) [?:?]
	at org.eclipse.osgi.framework.eventmgr.EventManager.dispatchEvent(EventManager.java:230) [?:?]
	at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.run(EventManager.java:340) [?:?]
2018-12-28 20:37:54.009 [DEBUG] [org.openhab.binding.openwebnet      ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandlerFactory}={service.id=358, service.bundleid=222, service.scope=bundle, component.name=org.openhab.binding.openwebnet.internal.OpenWebNetHandlerFactory, component.id=216} - org.openhab.binding.openwebnet
2018-12-28 20:37:54.038 [DEBUG] [ery.OpenWebNetBridgeDiscoveryService] - #############################################################################################
2018-12-28 20:37:54.041 [DEBUG] [ery.OpenWebNetBridgeDiscoveryService] - ==OWN:BridgeDiscovery== constructor()
2018-12-28 20:37:54.044 [DEBUG] [ery.OpenWebNetBridgeDiscoveryService] - #############################################################################################
2018-12-28 20:37:54.053 [DEBUG] [org.openhab.binding.openwebnet      ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.discovery.DiscoveryService}={service.id=359, service.bundleid=222, service.scope=bundle, component.name=org.openhab.binding.openwebnet.internal.discovery, component.id=217} - org.openhab.binding.openwebnet
2018-12-28 20:37:54.093 [DEBUG] [org.openhab.binding.openwebnet      ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.discovery.UpnpDiscoveryParticipant}={service.id=360, service.bundleid=222, service.scope=bundle, component.name=org.openhab.binding.openwebnet.internal.discovery.BusGatewayDiscoveryParticipant, component.id=218} - org.openhab.binding.openwebnet
2018-12-28 20:37:55.067 [INFO ] [overy.BusGatewayDiscoveryParticipant] - ================================================
2018-12-28 20:37:55.069 [INFO ] [overy.BusGatewayDiscoveryParticipant] - ==OWN:UPnP== DISCOVERED DEVICE: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:pnp-myhomeserver1-2_2-00:03:50:A4:69:C9, Descriptor: http://192.168.1.114:49152/, Root: true
2018-12-28 20:37:55.071 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =FRIENDLY NAME: MyHomeSERVER1
2018-12-28 20:37:55.078 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =BASE URL     : null
2018-12-28 20:37:55.080 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =SERIAL #     : 00:03:50:A4:69:C9
2018-12-28 20:37:55.089 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =UPC          : 
2018-12-28 20:37:55.105 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =ID.DESC URL  : http://192.168.1.114:49152/
2018-12-28 20:37:55.107 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =ID.MAX AGE   : 500
2018-12-28 20:37:55.123 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =MANUFACTURER : BTicino S.p.A.
2018-12-28 20:37:55.127 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =MODEL        : MyHomeServer1 | MYHOMESERVER1 | 2.2
2018-12-28 20:37:55.213 [INFO ] [overy.BusGatewayDiscoveryParticipant] - ================================================
2018-12-28 20:37:55.215 [INFO ] [overy.BusGatewayDiscoveryParticipant] - ==OWN:UPnP== DISCOVERED DEVICE: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:49b7f49e-d2fa-4f36-94e2-22e8903569ce, Descriptor: http://192.168.1.254:5000/rootDesc.xml, Root: true
2018-12-28 20:37:55.217 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =FRIENDLY NAME: MediaAccess DGA4131FWB (1811JC1DM)
2018-12-28 20:37:55.219 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =BASE URL     : null
2018-12-28 20:37:55.223 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =SERIAL #     : 1811JC1DM
2018-12-28 20:37:55.228 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =UPC          : null
2018-12-28 20:37:55.229 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =ID.DESC URL  : http://192.168.1.254:5000/rootDesc.xml
2018-12-28 20:37:55.232 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =ID.MAX AGE   : 120
2018-12-28 20:37:55.233 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =MANUFACTURER : Technicolor
2018-12-28 20:37:55.235 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =MODEL        : MediaAccess DG | Technicolor Internet Gateway Device | Technicolor DGA4131FWB
2018-12-28 21:44:05.975 [INFO ] [overy.BusGatewayDiscoveryParticipant] - ================================================
2018-12-28 21:44:05.978 [INFO ] [overy.BusGatewayDiscoveryParticipant] - ==OWN:UPnP== DISCOVERED DEVICE: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:00000000-0000-1010-8000-ac9b0a0e2638, Descriptor: http://192.168.1.184:52323/dmr.xml, Root: true
2018-12-28 21:44:05.980 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =FRIENDLY NAME: BRAVIA KD-49X8505B
2018-12-28 21:44:05.982 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =BASE URL     : null
2018-12-28 21:44:05.983 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =SERIAL #     : null
2018-12-28 21:44:05.985 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =UPC          : null
2018-12-28 21:44:05.986 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =ID.DESC URL  : http://192.168.1.184:52323/dmr.xml
2018-12-28 21:44:05.988 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =ID.MAX AGE   : 1800
2018-12-28 21:44:05.989 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =MANUFACTURER : Sony Corporation
2018-12-28 21:44:05.992 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =MODEL        : KD-49X8505B | null | MINT1.7.0.1

col_1958 · December 28, 2018, 11:47pm

This is the log of the automatic search from PAPERUI, which ends out with nothing

2018-12-28 21:59:42.711 [DEBUG] [ery.OpenWebNetBridgeDiscoveryService] - ==OWN:BridgeDiscovery== getSupportedThingTypes()
2018-12-28 21:59:42.790 [DEBUG] [ery.OpenWebNetBridgeDiscoveryService] - ==OWN:BridgeDiscovery== getSupportedThingTypes()
2018-12-28 21:59:42.837 [DEBUG] [ery.OpenWebNetBridgeDiscoveryService] - ==OWN:BridgeDiscovery== getSupportedThingTypes()
2018-12-28 21:59:42.847 [DEBUG] [ery.OpenWebNetBridgeDiscoveryService] - ==OWN:BridgeDiscovery== getSupportedThingTypes()
2018-12-28 21:59:42.854 [INFO ] [ery.OpenWebNetBridgeDiscoveryService] - ==OWN:BridgeDiscovery== ------ startScan() - SEARCHING for bridges...
2018-12-28 21:59:42.858 [DEBUG] [ery.OpenWebNetBridgeDiscoveryService] - ==OWN:BridgeDiscovery:Dongle== Gateway NULL, creating a new one ...
2018-12-28 21:59:42.890 [DEBUG] [ery.OpenWebNetBridgeDiscoveryService] - ==OWN:BridgeDiscovery:Dongle== ... trying to connect dongle ...
2018-12-28 21:59:42.893 [DEBUG] [org.openwebnet.OpenGatewayZigBee    ] - ##gw-openwebnet## Finding serial ports...
2018-12-28 21:59:42.943 [DEBUG] [org.openwebnet.OpenGatewayZigBee    ] - ##gw-openwebnet## ... found serial port /dev/ttyAMA0
2018-12-28 21:59:42.953 [DEBUG] [org.openwebnet.OpenGatewayZigBee    ] - ##gw-openwebnet## ... trying to connect USB dongle on serial port /dev/ttyAMA0 ...
2018-12-28 21:59:42.983 [INFO ] [org.openwebnet.OpenGatewayZigBee$a  ] - ##gw-openwebnet-ReceiveThread##  USB *RECEIVING* on port: /dev/ttyAMA0
2018-12-28 21:59:42.990 [INFO ] [org.openwebnet.OpenGatewayZigBee    ] - SERIAL SENDING   >>>>>>>>>>>>>>>>>>>>>>>> *13*60*##
2018-12-28 21:59:45.000 [DEBUG] [org.openwebnet.OpenGatewayZigBee$a  ] - ##gw-openwebnet-ReceiveThread## STOPPED receive thread on port: /dev/ttyAMA0
2018-12-28 21:59:45.078 [DEBUG] [org.openwebnet.OpenGatewayZigBee    ] - ##gw-openwebnet## no response received from port: /dev/ttyAMA0
2018-12-28 21:59:45.083 [DEBUG] [org.openwebnet.OpenGatewayZigBee    ] - ##gw-openwebnet## --NO USB ZigBee dongle FOUND--
2018-12-28 21:59:45.097 [INFO ] [ery.OpenWebNetBridgeDiscoveryService] - ==OWN:BridgeDiscovery== no serial ports found
2018-12-28 21:59:45.103 [INFO ] [overy.BusGatewayDiscoveryParticipant] - ================================================
2018-12-28 21:59:45.110 [INFO ] [overy.BusGatewayDiscoveryParticipant] - ==OWN:UPnP== DISCOVERED DEVICE: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:00000000-0000-1010-8000-ac9b0a0e2638, Descriptor: http://192.168.1.184:52323/dmr.xml, Root: true
2018-12-28 21:59:45.114 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =FRIENDLY NAME: BRAVIA KD-49X8505B
2018-12-28 21:59:45.119 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =BASE URL     : null
2018-12-28 21:59:45.123 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =SERIAL #     : null
2018-12-28 21:59:45.128 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =UPC          : null
2018-12-28 21:59:45.132 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =ID.DESC URL  : http://192.168.1.184:52323/dmr.xml
2018-12-28 21:59:45.137 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =ID.MAX AGE   : 1800
2018-12-28 21:59:45.141 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =MANUFACTURER : Sony Corporation
2018-12-28 21:59:45.146 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =MODEL        : KD-49X8505B | null | MINT1.7.0.1
2018-12-28 21:59:45.150 [INFO ] [overy.BusGatewayDiscoveryParticipant] - ================================================
2018-12-28 21:59:45.155 [INFO ] [overy.BusGatewayDiscoveryParticipant] - ==OWN:UPnP== DISCOVERED DEVICE: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:pnp-myhomeserver1-2_2-00:03:50:A4:69:C9, Descriptor: http://192.168.1.114:49152/, Root: true
2018-12-28 21:59:45.159 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =FRIENDLY NAME: MyHomeSERVER1
2018-12-28 21:59:45.164 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =BASE URL     : null
2018-12-28 21:59:45.168 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =SERIAL #     : 00:03:50:A4:69:C9
2018-12-28 21:59:45.172 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =UPC          : 
2018-12-28 21:59:45.176 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =ID.DESC URL  : http://192.168.1.114:49152/
2018-12-28 21:59:45.180 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =ID.MAX AGE   : 500
2018-12-28 21:59:45.182 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =MANUFACTURER : BTicino S.p.A.
2018-12-28 21:59:45.185 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =MODEL        : MyHomeServer1 | MYHOMESERVER1 | 2.2
2018-12-28 21:59:45.187 [INFO ] [overy.BusGatewayDiscoveryParticipant] - ================================================
2018-12-28 21:59:45.189 [INFO ] [overy.BusGatewayDiscoveryParticipant] - ==OWN:UPnP== DISCOVERED DEVICE: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:49b7f49e-d2fa-4f36-94e2-22e8903569ce, Descriptor: http://192.168.1.254:5000/rootDesc.xml, Root: true
2018-12-28 21:59:45.192 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =FRIENDLY NAME: MediaAccess DGA4131FWB (1811JC1DM)
2018-12-28 21:59:45.194 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =BASE URL     : null
2018-12-28 21:59:45.196 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =SERIAL #     : 1811JC1DM
2018-12-28 21:59:45.199 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =UPC          : null
2018-12-28 21:59:45.201 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =ID.DESC URL  : http://192.168.1.254:5000/rootDesc.xml
2018-12-28 21:59:45.204 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =ID.MAX AGE   : 120
2018-12-28 21:59:45.206 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =MANUFACTURER : Technicolor
2018-12-28 21:59:45.209 [INFO ] [overy.BusGatewayDiscoveryParticipant] - =MODEL        : MediaAccess DG | Technicolor Internet Gateway Device | Technicolor DGA4131FWB
2018-12-28 21:59:45.213 [DEBUG] [ery.OpenWebNetBridgeDiscoveryService] - ==OWN:BridgeDiscovery== getSupportedThingTypes()

col_1958 · December 28, 2018, 11:48pm

And this is the result of the manual search, after which the server is eventually discovered

2018-12-28 22:07:35.297 [DEBUG] [et.internal.OpenWebNetHandlerFactory] - ==OWN:HandlerFactory== createHandler()
2018-12-28 22:07:35.310 [DEBUG] [et.internal.OpenWebNetHandlerFactory] - ==OWN:HandlerFactory== creating NEW BRIDGE Handler
2018-12-28 22:07:35.316 [DEBUG] [et.internal.OpenWebNetHandlerFactory] - ==OWN:HandlerFactory== registerDiscoveryService()
2018-12-28 22:07:35.331 [DEBUG] [ery.OpenWebNetDeviceDiscoveryService] - ==OWN:DeviceDiscovery== constructor for bridge: openwebnet:bus_gateway:571428b2
2018-12-28 22:07:35.335 [DEBUG] [ery.OpenWebNetDeviceDiscoveryService] - ==OWN:DeviceDiscovery== activate()
2018-12-28 22:07:35.353 [DEBUG] [org.openhab.binding.openwebnet      ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.discovery.DiscoveryService}={service.id=363, service.bundleid=222, service.scope=singleton} - org.openhab.binding.openwebnet
2018-12-28 22:07:35.392 [DEBUG] [org.openhab.binding.openwebnet      ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.core.status.ConfigStatusProvider}={service.id=364, service.bundleid=222, service.scope=singleton} - org.openhab.binding.openwebnet
2018-12-28 22:07:35.436 [DEBUG] [bnet.handler.OpenWebNetBridgeHandler] - ==OWN== BridgeHandler.initialize() 
2018-12-28 22:07:35.442 [DEBUG] [bnet.handler.OpenWebNetBridgeHandler] - ==OWN== type = openwebnet:bus_gateway
2018-12-28 22:07:35.447 [DEBUG] [bnet.handler.OpenWebNetBridgeHandler] - ==OWN== Creating new BUS gateway with config properties: 192.168.1.114:20000, pwd=******95
2018-12-28 22:07:35.467 [DEBUG] [g.openwebnet.bus.MyHomeJavaConnector] - ##gw-openwebnet-connector## Created MyHomeJavaConnector 192.168.1.114:20000
2018-12-28 22:07:35.479 [DEBUG] [bnet.handler.OpenWebNetBridgeHandler] - ==OWN== Trying to connect gateway...
2018-12-28 22:07:35.487 [INFO ] [org.openwebnet.OpenGatewayBus       ] - ##gw-openwebnet-BUS## Trying to connect BUS (192.168.1.114:20000)...
2018-12-28 22:07:35.493 [DEBUG] [g.openwebnet.bus.MyHomeSocketFactory] - ##gw-openwebnet-socket## Trying openMonitorSession socket....  (192.168.1.114:20000)
2018-12-28 22:07:35.507 [DEBUG] [org.openwebnet.bus.MyHomeConnection ] - ##gw-openwebnet-conn## ... starting HANDSHAKE ... 
2018-12-28 22:07:35.511 [DEBUG] [org.openwebnet.bus.MyHomeConnection ] - MON RECEIVED   <<<<<<====== *#*1##
2018-12-28 22:07:35.514 [DEBUG] [org.openwebnet.bus.MyHomeConnection ] - MON SENDING    ======>>>>>> *99*1##
2018-12-28 22:07:35.519 [DEBUG] [org.openwebnet.bus.MyHomeConnection ] - MON RECEIVED   <<<<<<====== *98*2##
2018-12-28 22:07:35.522 [DEBUG] [org.openwebnet.bus.MyHomeConnection ] - MON SENDING    ======>>>>>> *#*1##
2018-12-28 22:07:35.527 [DEBUG] [org.openwebnet.bus.MyHomeConnection ] - MON RECEIVED   <<<<<<====== *#00081309021112060305011211130809111105040908141011030901061109150311020003010809110313130201091212010512080512010215031507131310##
2018-12-28 22:07:35.534 [DEBUG] [org.openwebnet.bus.MyHomeConnection ] - MON SENDING    ======>>>>>> *#02141304080809070608071514080612000213001403151012101208141005010011151309030714150907051305090906150709101012110311090306001100*04080002061200061108091507070000030800140111101301110312140409151001000603040814051507110106070813071309120615000902080502010115##
2018-12-28 22:07:35.540 [DEBUG] [org.openwebnet.bus.MyHomeConnection ] - MON RECEIVED   <<<<<<====== *#12020103131109150714020307031003121106020709090508020008030109120905020615081003000703090614020408150505040500040907130207080009##
2018-12-28 22:07:35.543 [DEBUG] [org.openwebnet.bus.MyHomeConnection ] - MON SENDING    ======>>>>>> *#*1##
2018-12-28 22:07:35.546 [DEBUG] [org.openwebnet.bus.MyHomeConnection ] - ##gw-openwebnet-conn## starting MON keepalive timer
2018-12-28 22:07:35.549 [DEBUG] [g.openwebnet.bus.MyHomeSocketFactory] - ##gw-openwebnet-socket## ... connected monitor session 192.168.1.114:20000
2018-12-28 22:07:35.556 [INFO ] [org.openwebnet.OpenGatewayBus       ] - ##gw-openwebnet-BUS## CONNECTED BUS MONITORING to: 192.168.1.114:20000
2018-12-28 22:07:35.556 [DEBUG] [org.openwebnet.OpenGatewayBus$a     ] - ##gw-openwebnet-BusReceiveThread## STARTING receive thread
2018-12-28 22:07:35.574 [DEBUG] [g.openwebnet.bus.MyHomeJavaConnector] - ##gw-openwebnet-connector## Opening a NEW COMMAND SESSION...
2018-12-28 22:07:35.576 [INFO ] [g.openwebnet.bus.MyHomeSocketFactory] - ##gw-openwebnet-socket## Trying openCommandSession() socket....  (192.168.1.114:20000)
2018-12-28 22:07:35.579 [DEBUG] [org.openwebnet.bus.MyHomeConnection ] - ##gw-openwebnet-conn## ... starting HANDSHAKE ... 
2018-12-28 22:07:35.588 [DEBUG] [org.openwebnet.bus.MyHomeConnection ] - COM RECEIVED   <<<<<<====== *#*1##
2018-12-28 22:07:35.590 [DEBUG] [org.openwebnet.bus.MyHomeConnection ] - COM SENDING    ======>>>>>> *99*0##
2018-12-28 22:07:35.594 [DEBUG] [org.openwebnet.bus.MyHomeConnection ] - COM RECEIVED   <<<<<<====== *98*2##
2018-12-28 22:07:35.596 [DEBUG] [org.openwebnet.bus.MyHomeConnection ] - COM SENDING    ======>>>>>> *#*1##
2018-12-28 22:07:35.600 [DEBUG] [org.openwebnet.bus.MyHomeConnection ] - COM RECEIVED   <<<<<<====== *#12010301130705150610090102141403081307040209060415091501101211100913001511090902061408030508130500071000091301120511121107000100##
2018-12-28 22:07:35.606 [DEBUG] [org.openwebnet.bus.MyHomeConnection ] - COM SENDING    ======>>>>>> *#07061109080904041408060803150710001010060500100711011207081514080314121212071406050905050414030002060810040002060006021402040915*12091201081505060302081311120314130801081501021404130108041004041312060701050307030100080511081012070213141201021400110508130006##
2018-12-28 22:07:35.613 [DEBUG] [org.openwebnet.bus.MyHomeConnection ] - COM RECEIVED   <<<<<<====== *#09031015090009120501121000010802080115091108140314041113041415011002030312150509131508151401111009050103140402020315090500091106##
2018-12-28 22:07:35.616 [DEBUG] [org.openwebnet.bus.MyHomeConnection ] - COM SENDING    ======>>>>>> *#*1##
2018-12-28 22:07:35.618 [INFO ] [g.openwebnet.bus.MyHomeSocketFactory] - ##gw-openwebnet-socket## ... CONNECTED command session 192.168.1.114:20000
2018-12-28 22:07:35.621 [INFO ] [g.openwebnet.bus.MyHomeJavaConnector] - COM SENDING   ============>>>>>>>>>>>> *#13**15##
2018-12-28 22:07:35.669 [INFO ] [org.openwebnet.OpenGatewayBus$a     ] - MON RECEIVED  <<<<<<<<<<< *#13**15*200##
2018-12-28 22:07:35.669 [INFO ] [g.openwebnet.bus.MyHomeSocketFactory] - COM RECEIVED  <<<<<<<<<<<<============ *#13**15*200##
2018-12-28 22:07:35.679 [DEBUG] [org.openwebnet.OpenGatewayBus       ] - ##gw-openwebnet-BUS## server MODEL=MyHOMEServer1 / MH202 / F455
2018-12-28 22:07:35.687 [DEBUG] [bnet.handler.OpenWebNetBridgeHandler] - ==OWN==  GatewayManagement WHAT = null
2018-12-28 22:07:35.713 [INFO ] [g.openwebnet.bus.MyHomeSocketFactory] - COM RECEIVED  <<<<<<<<<<<<============ *#*1##
2018-12-28 22:07:36.025 [INFO ] [bnet.handler.OpenWebNetBridgeHandler] - ==OWN== ------------------- CONNECTED to BUS gateway - 192.168.1.114:20000

gozilla01 · December 29, 2018, 12:17am

Marco,
excuse the question but have you entered the password in the webserver bus?

col_1958 · December 29, 2018, 12:26am

Ciao Michele,

only in the manual search … I was expecting the automatic search to ask for the password at some point.

Am I wrong?

gozilla01 · December 29, 2018, 12:32am

I send you a PM

massi · December 29, 2018, 9:22am

Michele (@gozilla01) and Marco (@col_1958 ).
Automatic finding of BTicino gateway is not implemented yet, never said it is!, it’s also well written in the (in)famous README.
I am away from PC these days, I will write you in a separate thread to help me doing some tests about gateway automatic discovery.
bye!
M

gozilla01 · December 29, 2018, 9:24am

Hi Massi,
@col_1958 is Italian, write to us in PM

col_1958 · December 29, 2018, 9:32am

Ciao Massimo,

this time I’am innocent! I’ve RTFM! I provided some debug listing just for the purpose of testing automatic discovery of the gateway. I can confirm that UPNP correctly finds the IP address of the server.

Just for understanding.

Where is the jar file of OWH when one installs from eclipse?
Can I open (and read) the jar file in Visual Studio Code?
Can I play with the java code and do tests on my own?