openHAB 2.0 binding

ben999

@TimO
Hi Tim
Thanks a lot for your message.
NRF is connected to GPIO pins as per https://www.mysensors.org/build/raspberry
I have run dmesg |grep -i tty as suggested by @Yveaux and i got

[    0.000000] Kernel command line: 8250.nr_uarts=0 dma.dmachans=0x7f35 bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2709.boardrev=0xa02082 bcm2709.serial=0xcc3e67e3 smsc95xx.macaddr=B8:27:EB:3E:67:E3 bcm2708_fb.fbswap=1 bcm2709.uart_clock=48000000 vc_mem.mem_base=0x3dc00000 vc_mem.mem_size=0x3f000000  dwc_otg.lpm_enable=0 console=ttyS0,115200 console=tty1 root=/dev/mmcblk0p2 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait
[    0.001337] console [tty1] enabled
[    1.781491] 3f201000.uart: ttyAMA0 at MMIO 0x3f201000 (irq = 87, base_baud = 0) is a PL011 rev2

I assumed that my serail port would be ttyAMA0
So i wrote my "home.things" file with it:

Bridge mysensors:bridge-ser:gateway [ serialPort="/dev/ttyAMA0", sendDelay=200 ] {
    /** define things connected to that bridge here */  }

This pi@raspberrypi:~ $ screen /dev/ttyAMA0 115200 returns that

[screen is terminating]

Also, when watching the live output from sudo ./bin/mysgw -d i can see that

pi@raspberrypi:~ $ cd MySensors
pi@raspberrypi:~/MySensors $ sudo ./bin/mysgw -d
mysgw: Starting gateway...
mysgw: Protocol version - 2.0.1-beta
mysgw: MCO:BGN:INIT GW,CP=RNNG---,VER=2.0.1-beta
mysgw: TSF:LRT:OK
mysgw: TSM:INIT
mysgw: TSM:INIT:TSP OK
mysgw: TSM:INIT:GW MODE
mysgw: TSM:READY
mysgw: Listening for connections on 0.0.0.0:5003

but when i launch openhab with sudo ./start_debug.sh i see

Launching the openHAB runtime...
Listening for transport dt_socket at address: 5005

5003 vs 5005... I tried that pi@raspberrypi:~/MySensors $ ./configure --my-port=5005 but no luck, I got that in return...

mysgw: accept: Bad file descriptor
mysgw: accept: Bad file descriptor

going forever :(

bentrik

@TimO said:

GitHub Repo
So I´m very new to OpenHAB, but I´ve tried to bind MySensors for a few days now, and I´m stuck. I´d be really happy if someone could guide me a little further.

-I´ve flashed and installed OpenHABian on my Raspberry. (OpenHAB2)
-Managed to bind my Sonos through the paper ui, so the OpenHAB2 install looks good.
-Now I wish to bind Mysensors on a serial gateway.

Looking at the GitHub install guide it seems as simple as adding the MySensors.jar file to the addons directory, but from what I can see, bindings are not managed like that in OpenHab2? All guiding I read seems to refer to another file structure in OpenHab 1.8.
I managed to find an addons directory in /usr/share/openhab2/addons, but I can´t find a way to copy the .jar file there, as I get permission denied both through WinSCP in sudo mode and terminal ssh. The folder has permission 0775.

Can anyone guide me to thread that describes how to install MySensors on an OpenHABian Raspberry installation?

TimO

@bentrik said:

I managed to find an addons directory in /usr/share/openhab2/addons, but I can´t find a way to copy the .jar file there, as I get permission denied both through WinSCP in sudo mode and terminal ssh. The folder has permission 0775.

That is the correct directory if you installed OH2 via .deb. Seems like you are using a user in WinSCP that is not allowed to write to the directory above. To circumvent this:

Copy the binding jar to /tmp.
Login via ssh and execute:

sudo cp /tmp/org.openhab.binding.mysensors-2.0.0-SNAPSHOT.jar /usr/share/openhab2/addons/

and

sudo chmod openhab.openhab /usr/share/openhab2/addons/org.openhab.binding.mysensors-2.0.0-SNAPSHOT.jar

OH2 is started/stopped/restarted with

service openhab2 start/stop/restart

To log into the karaf console do:

ssh openhab@localhost -p 8101

Password is: habopen

Follow the guide/wiki from:

In the console enter feature:install openhab-transport-serial

TimO

@ben999

If you are using the RPi gateway with the options you provided above:

sudo ./bin/mysgw -d

You need to configure the OH2 binding to connect to a ethernet gateway (via localhost, 127.0.0.1 and port 5003), don't use the serial gateway. You are able to confirm this if you execute a "telnet localhost 5003" on the RPi and should be see the messages incoming from the node.

FutureCow

I did some testing with older and newer version:

OpenHAB #457, MySensor_Binding Aug2016, Text conf: No problems
OpenHAB #457, MySensor_Binding Nov2016, Text conf: No problems
OpenHAB #457, MySensor_Binding Aug2016, PaperUI conf: No autodiscovery, Manual Add: No problems
OpenHAB #457, MySensor_Binding Nov2016, PaperUI conf: No autodiscovery, Manual Add: No problems

OpenHAB #603, MySensor_Binding Aug2016, Text conf: Doesn't Work!
OpenHAB #603, MySensor_Binding Nov2016, Text conf: Doesn't work!
OpenHAB #603, MySensor_Binding Aug2016, PaperUI conf: No autodiscovery, Manual Add: Doesn't work!
OpenHAB #603, MySensor_Binding Nov2016, PaperUI conf: No autodiscovery, Manual Add: Doesn't work!

Doesn't work! means the gateway is working, I receive messages, but the items doesn't get updated.
Also restarting openhab/mysensor binding doesnt solve the problem.

TimO

@FutureCow Thanks for testing! There definiatly is a bug and slowly I'm getting a grip on it. The annoying thing is: in my development environment everything works smooth, so I updated my production environment and voila there is the problem: no thing updates.

It looks like a timing issue on initialization of the bridge/gateway. I'll dig deeper!

The topic autodiscovery will follow, I've not spent much time in testing this feature as it was of no use till lately. Now PaperUI/Habpanel are getting the functionality that makes it usable and will make the big difference to OpenHAB 1.

bathoryr

I also have similar problems, after upgrade OH to latest snapshot yesterday. All things remain in offline status. Discovery is working when I hit "Search for things" from Paper UI and force presentation/reset on some sensor.

21:23:12.982 [DEBUG] [org.openhab.binding.mysensors       ] - BundleEvent STARTING - org.openhab.binding.mysensors
21:23:13.062 [DEBUG] [org.openhab.binding.mysensors       ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandlerFactory}={component.name=org.openhab.binding.mysensors.internal.factory.MySensorsHandlerFactory, component.id=252, service.id=400, service.bundleid=198, service.scope=bundle} - org.openhab.binding.mysensors
21:23:13.082 [DEBUG] [org.openhab.binding.mysensors       ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.discovery.DiscoveryService}={service.id=401, service.bundleid=198, service.scope=singleton} - org.openhab.binding.mysensors
21:23:13.121 [DEBUG] [org.openhab.binding.mysensors       ] - BundleEvent STARTED - org.openhab.binding.mysensors
21:23:13.548 [DEBUG] [ernal.handler.MySensorsBridgeHandler] - Initialization of the MySensors bridge
21:23:13.551 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Set skip check on startup to: false
21:23:13.552 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Enabling connection watchdog
21:23:13.555 [DEBUG] [ternal.factory.MySensorsCacheFactory] - Cache file: given_ids.cached exist.
21:23:13.557 [DEBUG] [ternal.factory.MySensorsCacheFactory] - Cache (given_ids) content: [5, 12, 7, 10, 1, 9, 3, 8, 30, 6, 24]
21:23:13.559 [DEBUG] [ernal.handler.MySensorsBridgeHandler] - Initialization of the MySensors bridge DONE!
21:23:13.549 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:bridge-eth:gateway' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
21:23:13.571 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Connecting to IP bridge [127.0.0.1:5003]
21:23:13.596 [DEBUG] [rs.internal.protocol.MySensorsReader] - 0;255;3;0;14;Gateway startup complete.
21:23:13.598 [DEBUG] [rs.internal.protocol.MySensorsReader] - 0;255;0;0;18;2.0.1-beta
21:23:13.778 [DEBUG] [rs.internal.protocol.MySensorsWriter] - Sending to MySensors: 0;0;3;0;2;
21:23:13.797 [DEBUG] [rs.internal.protocol.MySensorsReader] - 0;255;3;0;2;2.0.1-beta
21:23:13.800 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Good,Gateway is up and running! (Ver:2.0.1-beta)
21:23:13.813 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:bridge-eth:gateway' changed from INITIALIZING to ONLINE
21:23:13.828 [INFO ] [al.protocol.ip.MySensorsIpConnection] - Successfully connected to MySensors Bridge.
21:23:13.830 [DEBUG] [ternal.handler.MySensorsThingHandler] - Configuration: node 12, chiledId: 1, revertState: false
21:23:13.830 [WARN ] [al.protocol.ip.MySensorsIpConnection] - Network Sanity Checker thread disabled from bridge configuration
21:23:13.855 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:power:gateway:house_power_12_1' changed from INITIALIZING to OFFLINE
21:23:13.856 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:power:gateway:house_power_12_1' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
21:23:13.882 [DEBUG] [ternal.handler.MySensorsThingHandler] - Configuration: node 24, chiledId: 1, revertState: false
21:23:13.892 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:dimmer:gateway:Dimmer_24_1' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
21:23:13.892 [DEBUG] [ternal.handler.MySensorsThingHandler] - Configuration: node 5, chiledId: 1, revertState: false
21:23:13.899 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:dimmer:gateway:living_room_5_1' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
21:23:13.904 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:dimmer:gateway:Dimmer_24_1' changed from INITIALIZING to OFFLINE
21:23:13.926 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:dimmer:gateway:living_room_5_1' changed from INITIALIZING to OFFLINE
21:23:23.832 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Bridge is connected, connection skipped
21:23:25.599 [DEBUG] [rs.internal.protocol.MySensorsReader] - 12;1;1;0;17;516
21:23:25.624 [DEBUG] [rs.internal.protocol.MySensorsReader] - 12;1;1;0;24;550307
21:23:25.639 [DEBUG] [rs.internal.protocol.MySensorsReader] - 12;1;1;0;18;55.0307
21:23:29.103 [DEBUG] [rs.internal.protocol.MySensorsReader] - 7;1;1;0;0;19.8
21:23:29.119 [DEBUG] [rs.internal.protocol.MySensorsReader] - 7;255;3;0;22;1208410

Also, when I stop bundle from karaf console, this error appears in log:

21:24:37.371 [DEBUG] [org.openhab.binding.mysensors       ] - ServiceEvent UNREGISTERING - {org.eclipse.smarthome.config.discovery.DiscoveryService}={service.id=401, service.bundleid=198, service.scope=singleton} - org.openhab.binding.mysensors
21:24:37.379 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:dimmer:gateway:Dimmer_24_1' changed from OFFLINE to UNINITIALIZED (HANDLER_MISSING_ERROR)
21:24:37.397 [DEBUG] [ernal.handler.MySensorsBridgeHandler] - Disposing of the MySensors bridge
21:24:37.399 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Destroying connection
21:24:37.400 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Disconnecting from IP bridge ...
21:24:37.401 [DEBUG] [rs.internal.protocol.MySensorsWriter] - Stopping Writer thread
21:24:37.413 [ERROR] [rs.internal.protocol.MySensorsWriter] - (java.lang.InterruptedException) on writing from serial port, message: class org.openhab.binding.mysensors.internal.protocol.ip.MySensorsIpWriter
21:24:37.414 [DEBUG] [rs.internal.protocol.MySensorsReader] - Stopping Reader thread
21:24:37.422 [ERROR] [rs.internal.protocol.MySensorsReader] - (java.lang.InterruptedException: sleep interrupted) on reading from serial port, message: class org.openhab.binding.mysensors.internal.protocol.ip.MySensorIpReader
21:24:37.422 [DEBUG] [ternal.factory.MySensorsCacheFactory] - Cache file: given_ids.cached exist.
21:24:37.426 [DEBUG] [ternal.factory.MySensorsCacheFactory] - Cache (given_ids) content: [5, 12, 7, 10, 1, 9, 3, 8, 30, 6, 24]
21:24:37.433 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:bridge-eth:gateway' changed from ONLINE to UNINITIALIZED (HANDLER_MISSING_ERROR)
21:24:37.429 [ERROR] [ome.core.thing.internal.ThingManager] - Exception occured while disposing handler of thing 'mysensors:bridge-eth:gateway': java.lang.NullPointerException
java.util.concurrent.ExecutionException: java.lang.NullPointerException
	at java.util.concurrent.FutureTask.report(FutureTask.java:122)[:1.8.0_65]
	at java.util.concurrent.FutureTask.get(FutureTask.java:206)[:1.8.0_65]
	at org.eclipse.smarthome.core.common.SafeMethodCaller.callAsynchronous(SafeMethodCaller.java:186)
	at org.eclipse.smarthome.core.common.SafeMethodCaller.call(SafeMethodCaller.java:79)
	at org.eclipse.smarthome.core.common.SafeMethodCaller.call(SafeMethodCaller.java:63)
	at org.eclipse.smarthome.core.thing.internal.ThingManager.doDisposeHandler(ThingManager.java:858)
	at org.eclipse.smarthome.core.thing.internal.ThingManager.disposeHandler(ThingManager.java:848)
	at org.eclipse.smarthome.core.thing.internal.ThingManager.removeThingHandlerFactory(ThingManager.java:1045)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)[:1.8.0_65]
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)[:1.8.0_65]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)[:1.8.0_65]
	at java.lang.reflect.Method.invoke(Method.java:497)[:1.8.0_65]
	at org.apache.felix.scr.impl.helper.BaseMethod.invokeMethod(BaseMethod.java:222)[34:org.apache.felix.scr:2.0.2]
	at org.apache.felix.scr.impl.helper.BaseMethod.access$500(BaseMethod.java:37)[34:org.apache.felix.scr:2.0.2]
	at org.apache.felix.scr.impl.helper.BaseMethod$Resolved.invoke(BaseMethod.java:615)[34:org.apache.felix.scr:2.0.2]
	at org.apache.felix.scr.impl.helper.BaseMethod.invoke(BaseMethod.java:499)[34:org.apache.felix.scr:2.0.2]
	at org.apache.felix.scr.impl.helper.BindMethod.invoke(BindMethod.java:41)[34:org.apache.felix.scr:2.0.2]
	at org.apache.felix.scr.impl.manager.DependencyManager.invokeUnbindMethod(DependencyManager.java:1774)[34:org.apache.felix.scr:2.0.2]
	at org.apache.felix.scr.impl.manager.SingleComponentManager.invokeUnbindMethod(SingleComponentManager.java:393)[34:org.apache.felix.scr:2.0.2]
	at org.apache.felix.scr.impl.manager.DependencyManager$MultipleDynamicCustomizer.removedService(DependencyManager.java:364)[34:org.apache.felix.scr:2.0.2]
	at org.apache.felix.scr.impl.manager.DependencyManager$MultipleDynamicCustomizer.removedService(DependencyManager.java:295)[34:org.apache.felix.scr:2.0.2]
	at org.apache.felix.scr.impl.manager.ServiceTracker$Tracked.customizerRemoved(ServiceTracker.java:1241)[34:org.apache.felix.scr:2.0.2]
	at org.apache.felix.scr.impl.manager.ServiceTracker$Tracked.customizerRemoved(ServiceTracker.java:1136)[34:org.apache.felix.scr:2.0.2]
	at org.apache.felix.scr.impl.manager.ServiceTracker$AbstractTracked.untrack(ServiceTracker.java:996)[34:org.apache.felix.scr:2.0.2]
	at org.apache.felix.scr.impl.manager.ServiceTracker$Tracked.serviceChanged(ServiceTracker.java:1175)[34:org.apache.felix.scr:2.0.2]
	at org.apache.felix.scr.impl.BundleComponentActivator$ListenerInfo.serviceChanged(BundleComponentActivator.java:120)[34:org.apache.felix.scr:2.0.2]
	at org.eclipse.osgi.internal.serviceregistry.FilteredServiceListener.serviceChanged(FilteredServiceListener.java:109)[org.eclipse.osgi-3.10.2.v20150203-1939.jar:]

ben999

@TimO
Thank you one more time Tim

So i went ahead and replaced

Bridge mysensors:bridge-ser:gateway [ serialPort="/dev/ttyAMA0", sendDelay=200 ]

with

Bridge mysensors:bridge-eth:gateway [ ipAddress="127.0.0.1", tcpPort=5003, sendDelay=200 ]

together with

pi@raspberrypi:/usr/share/openhab2 $ ./configure --my-gateway=ethernet --my-port=5003 --my-serial-port=/dev/ttyAMA0

pi@raspberrypi:/ $ telnet 127.0.0.1 5003 returns what is expected i guess :

Trying 127.0.0.1...
Connected to 127.0.0.1.
Escape character is '^]'.
0;255;3;0;14;Gateway startup complete.
0;255;0;0;18;2.0.1-beta
1;255;0;0;17;2.0.0
1;255;3;0;11;TemperatureAndHumidity
1;255;3;0;12;1.1
1;0;0;0;7;
1;1;0;0;6;
1;1;1;0;0;19.1
1;0;1;0;1;62.5

But still, there must be a missing link : neither in PaperUi nor openHab on iOS i get temp and humidity readings...

This is my OH2 log:tail

06:26:19.597 [DEBUG] [e.internal.WriterInterceptorExecutor] - Message body writer (class com.eclipsesource.jaxrs.provider.gson.GsonProvider) is trying to close the entity output stream. Not closing.
06:26:19.598 [DEBUG] [.eclipse.jetty.server.HttpConnection] - org.eclipse.jetty.server.HttpConnection$SendCallback@1785907[PROCESSING][i=ResponseInfo{HTTP/1.1 200 OK,740,false},cb=org.eclipse.jetty.server.HttpChannel$CommitCallback@113ab9] generate: NEED_HEADER (null,[p=0,l=740,c=8192,r=740],true)@START
06:26:19.600 [DEBUG] [.eclipse.jetty.server.HttpConnection] - org.eclipse.jetty.server.HttpConnection$SendCallback@1785907[PROCESSING][i=ResponseInfo{HTTP/1.1 200 OK,740,false},cb=org.eclipse.jetty.server.HttpChannel$CommitCallback@113ab9] generate: FLUSH ([p=0,l=105,c=8192,r=105],[p=0,l=740,c=8192,r=740],true)@COMPLETING
06:26:19.601 [DEBUG] [org.eclipse.jetty.io.WriteFlusher   ] - write: WriteFlusher@af70aa{IDLE} [HeapByteBuffer@2a5ea9[p=0,l=105,c=8192,r=105]={<<<HTTP/1.1 200 OK\r\n....v20151106)\r\n\r\n>>>\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00},HeapByteBuffer@1ef785[p=0,l=740,c=8192,r=740]={<<<{"id":"_default",...idgets":[]}]}]}>>>\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}]
06:26:19.602 [DEBUG] [org.eclipse.jetty.io.WriteFlusher   ] - update WriteFlusher@af70aa{WRITING}:IDLE-->WRITING
06:26:19.604 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@d43845{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@5d1aa0[FILLING,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,-,W,128/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,58/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=END,0 of -1},g=HttpGenerator{s=COMPLETING},c=HttpChannelOverHttp@170a7cc{r=25,c=true,a=DISPATCHED,uri=/rest/sitemaps/_default/_default}] flush enter [java.nio.HeapByteBuffer[pos=0 lim=105 cap=8192], java.nio.HeapByteBuffer[pos=0 lim=740 cap=8192]]
06:26:19.607 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@d43845{NOT_HANDSHAKING,eio=-1/874,di=-1} -> HttpConnection@5d1aa0[FILLING,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,-,W,131/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,61/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=END,0 of -1},g=HttpGenerator{s=COMPLETING},c=HttpChannelOverHttp@170a7cc{r=25,c=true,a=DISPATCHED,uri=/rest/sitemaps/_default/_default}] wrap Status = OK HandshakeStatus = NOT_HANDSHAKING
bytesConsumed = 845 bytesProduced = 874
06:26:19.610 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,-,W,134/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,65/30000,SslConnection}{io=0,kio=0,kro=1} OK HeapByteBuffer@1543b4c[p=0,l=874,c=17408,r=874]={<<<\x17\x03\x03\x03e\x00\x00\x00\x00\x00\x00\x00\x19\xC1\xE8\x8c-...g\xEbkEP\x05\xD7D\x1d\xD51\xA4\x92\x86Y>>>\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}
06:26:19.613 [DEBUG] [org.eclipse.jetty.io.ChannelEndPoint] - flushed 874 SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,68/30000,SslConnection}{io=0,kio=0,kro=1}
06:26:19.615 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@d43845{NOT_HANDSHAKING,eio=-1/0,di=-1} -> HttpConnection@5d1aa0[FILLING,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,-,W,140/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,0/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=END,0 of -1},g=HttpGenerator{s=COMPLETING},c=HttpChannelOverHttp@170a7cc{r=25,c=true,a=DISPATCHED,uri=/rest/sitemaps/_default/_default}] flush exit, consumed 845
06:26:19.617 [DEBUG] [org.eclipse.jetty.io.WriteFlusher   ] - update WriteFlusher@af70aa{IDLE}:WRITING-->IDLE
06:26:19.619 [DEBUG] [.eclipse.jetty.server.HttpConnection] - org.eclipse.jetty.server.HttpConnection$SendCallback@1785907[PROCESSING][i=ResponseInfo{HTTP/1.1 200 OK,740,false},cb=org.eclipse.jetty.server.HttpChannel$CommitCallback@113ab9] generate: DONE ([p=105,l=105,c=8192,r=0],[p=740,l=740,c=8192,r=0],true)@END
06:26:19.621 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/_default @ o.e.j.s.h.ContextHandler@2b17f5{/static,null,AVAILABLE}
06:26:19.622 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/_default @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.eclipse.smarthome.core.audio_0.9.0.201611041332 [100], contextID=default]}
06:26:19.623 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/_default @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.eclipse.smarthome.ui_0.9.0.201611041332 [137], contextID=default]}
06:26:19.624 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/_default @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.eclipse.smarthome.ui.icon_0.9.0.201611041332 [138], contextID=default]}
06:26:19.625 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/_default @ HttpServiceContext{httpContext=org.jupnp.transport.impl.osgi.DisableAuthenticationHttpContext@715e88}
06:26:19.626 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/_default @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.eclipse.smarthome.ui.basic_0.9.0.201611041332 [186], contextID=default]}
06:26:19.627 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/_default @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.eclipse.smarthome.ui.classic_0.9.0.201611041332 [187], contextID=default]}
06:26:19.629 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/_default @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.eclipse.smarthome.ui.paper_0.9.0.201611041332 [188], contextID=default]}
06:26:19.630 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/_default @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.io.rest.docs_2.0.0.201611062131 [189], contextID=default]}
06:26:19.631 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/_default @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.ui.dashboard_2.0.0.201611062131 [192], contextID=default]}
06:26:19.632 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/_default @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.core_2.0.0.201611062131 [168], contextID=default]}
06:26:19.632 [DEBUG] [org.eclipse.jetty.server.Server     ] - RESPONSE /rest/sitemaps/_default/_default  200 handled=true
06:26:19.633 [DEBUG] [clipse.jetty.server.HttpChannelState] - HttpChannelState@8beceb{s=DISPATCHED i=true a=null} unhandle DISPATCHED
06:26:19.635 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - reset HttpParser{s=END,0 of -1}
06:26:19.636 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - END --> START
06:26:19.637 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - HttpChannelOverHttp@170a7cc{r=25,c=false,a=IDLE,uri=} handle exit, result COMPLETE
06:26:19.638 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@d43845{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@5d1aa0[FILLING,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,-,-,163/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,23/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@170a7cc{r=25,c=false,a=IDLE,uri=}] fill enter
06:26:19.640 [DEBUG] [org.eclipse.jetty.io.ChannelEndPoint] - filled 0 SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,24/30000,SslConnection}{io=0,kio=0,kro=1}
06:26:19.641 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@d43845{NOT_HANDSHAKING,eio=0/-1,di=-1} -> HttpConnection@5d1aa0[FILLING,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,-,-,166/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,26/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@170a7cc{r=25,c=false,a=IDLE,uri=}] filled 0 encrypted bytes
06:26:19.643 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@d43845{NOT_HANDSHAKING,eio=0/-1,di=-1} -> HttpConnection@5d1aa0[FILLING,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,-,-,168/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,28/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@170a7cc{r=25,c=false,a=IDLE,uri=}] unwrap Status = BUFFER_UNDERFLOW HandshakeStatus = NOT_HANDSHAKING
bytesConsumed = 0 bytesProduced = 0
06:26:19.645 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@d43845{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@5d1aa0[FILLING,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,-,-,170/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,30/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@170a7cc{r=25,c=false,a=IDLE,uri=}] fill exit
06:26:19.647 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@d43845{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@5d1aa0[FILLING,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,-,-,171/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,31/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@170a7cc{r=25,c=false,a=IDLE,uri=}] fill enter
06:26:19.648 [DEBUG] [org.eclipse.jetty.io.ChannelEndPoint] - filled 0 SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,33/30000,SslConnection}{io=0,kio=0,kro=1}
06:26:19.650 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@d43845{NOT_HANDSHAKING,eio=0/-1,di=-1} -> HttpConnection@5d1aa0[FILLING,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,-,-,174/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,34/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@170a7cc{r=25,c=false,a=IDLE,uri=}] filled 0 encrypted bytes
06:26:19.652 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@d43845{NOT_HANDSHAKING,eio=0/-1,di=-1} -> HttpConnection@5d1aa0[FILLING,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,-,-,176/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,36/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@170a7cc{r=25,c=false,a=IDLE,uri=}] unwrap Status = BUFFER_UNDERFLOW HandshakeStatus = NOT_HANDSHAKING
bytesConsumed = 0 bytesProduced = 0
06:26:19.654 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@d43845{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@5d1aa0[FILLING,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,-,-,178/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,38/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@170a7cc{r=25,c=false,a=IDLE,uri=}] fill exit
06:26:19.654 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - parseNext s=START HeapByteBuffer@ad25df[p=0,l=0,c=17408,r=0]={<<<>>>GET /rest/sitemap...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}
06:26:19.656 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - fillInterested HttpConnection@5d1aa0[FILLING,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,-,-,181/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,41/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@170a7cc{r=25,c=false,a=IDLE,uri=}]
06:26:19.658 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - FILLING-->FILLING_FILL_INTERESTED HttpConnection@5d1aa0[FILLING_FILL_INTERESTED,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,-,-,183/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,43/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@170a7cc{r=25,c=false,a=IDLE,uri=}]
06:26:19.660 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - FILLING_FILL_INTERESTED-->FILL_INTERESTED HttpConnection@5d1aa0[FILL_INTERESTED,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,-,-,184/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,44/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@170a7cc{r=25,c=false,a=IDLE,uri=}]
06:26:19.661 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - fillInterested SslConnection@d43845{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@5d1aa0[FILL_INTERESTED,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,R,-,1/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,46/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@170a7cc{r=25,c=false,a=IDLE,uri=}]
06:26:19.663 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - IDLE-->FILL_INTERESTED SslConnection@d43845{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@5d1aa0[FILL_INTERESTED,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,R,-,3/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,48/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@170a7cc{r=25,c=false,a=IDLE,uri=}]
06:26:19.664 [DEBUG] [lipse.jetty.io.SelectChannelEndPoint] - Local interests updating 0 -> 1 for SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,R,-,0/30000,SslConnection}{io=1,kio=0,kro=1}
06:26:19.665 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Queued change org.eclipse.jetty.io.SelectChannelEndPoint$1@2ea554
06:26:19.666 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Selector loop woken up from select, 0/1 selected
06:26:19.667 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Running change org.eclipse.jetty.io.SelectChannelEndPoint$1@2ea554
06:26:19.667 [DEBUG] [lipse.jetty.io.SelectChannelEndPoint] - Key interests updated 0 -> 1 on SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,R,-,3/30000,SslConnection}{io=1,kio=1,kro=1}
06:26:19.667 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Selector loop waiting on select
06:26:19.714 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Selector loop woken up from select, 1/1 selected
06:26:19.714 [DEBUG] [lipse.jetty.io.SelectChannelEndPoint] - Key interests updated 1 -> 0 on SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,R,-,50/30000,SslConnection}{io=1,kio=0,kro=1}
06:26:19.715 [DEBUG] [lipse.jetty.io.SelectChannelEndPoint] - Local interests updating 1 -> 0 for SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,R,-,51/30000,SslConnection}{io=0,kio=0,kro=1}
06:26:19.715 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Queued change org.eclipse.jetty.io.SelectChannelEndPoint$1@2ea554
06:26:19.716 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - FILL_INTERESTED-->FILLING SslConnection@d43845{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@5d1aa0[FILL_INTERESTED,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,R,-,56/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,52/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@170a7cc{r=25,c=false,a=IDLE,uri=}]
06:26:19.717 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - onFillable enter DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,R,-,57/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,53/30000,SslConnection}{io=0,kio=0,kro=1}
06:26:19.718 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - FILL_INTERESTED-->FILLING HttpConnection@5d1aa0[FILLING,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,-,-,58/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,54/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@170a7cc{r=25,c=false,a=IDLE,uri=}]
06:26:19.719 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - onFillable exit DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,-,-,59/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,55/30000,SslConnection}{io=0,kio=0,kro=1}
06:26:19.720 [DEBUG] [.eclipse.jetty.server.HttpConnection] - HttpConnection@5d1aa0[FILLING,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,-,-,59/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,55/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@170a7cc{r=25,c=false,a=IDLE,uri=}] onFillable HttpChannelState@8beceb{s=IDLE i=true a=null}
06:26:19.721 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - FILLING-->IDLE SslConnection@d43845{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@5d1aa0[FILLING,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,-,-,60/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,56/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@170a7cc{r=25,c=false,a=IDLE,uri=}]
06:26:19.721 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@d43845{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@5d1aa0[FILLING,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,-,-,60/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,56/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@170a7cc{r=25,c=false,a=IDLE,uri=}] fill enter
06:26:19.721 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Running change org.eclipse.jetty.io.SelectChannelEndPoint$1@2ea554
06:26:19.722 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Selector loop waiting on select
06:26:19.722 [DEBUG] [org.eclipse.jetty.io.ChannelEndPoint] - filled 515 SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,57/30000,SslConnection}{io=0,kio=0,kro=1}
06:26:19.726 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@d43845{NOT_HANDSHAKING,eio=515/-1,di=-1} -> HttpConnection@5d1aa0[FILLING,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,-,-,62/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,2/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@170a7cc{r=25,c=false,a=IDLE,uri=}] filled 515 encrypted bytes
06:26:19.730 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@d43845{NOT_HANDSHAKING,eio=0/-1,di=-1} -> HttpConnection@5d1aa0[FILLING,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,-,-,70/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,8/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@170a7cc{r=25,c=false,a=IDLE,uri=}] unwrap Status = OK HandshakeStatus = NOT_HANDSHAKING
bytesConsumed = 515 bytesProduced = 486
06:26:19.733 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@d43845{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@5d1aa0[FILLING,DecryptedEndPoint@12d4ea{/192.168.1.24:54399<->8443,Open,in,out,-,-,73/30000,HttpConnection}->SelectChannelEndPoint@bd1cb6{/192.168.1.24:54399<->8443,Open,in,out,-,-,11/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@170a7cc{r=25,c=false,a=IDLE,uri=}] fill exit
06:26:19.735 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - parseNext s=START HeapByteBuffer@19b0494[p=0,l=486,c=17408,r=486]={<<<GET /rest/sitemap...rwin/16.1.0\r\n\r\n>>>\xBd\xE2\xFb\xC2E\x82\xF6\xD7\xEf\x82(\xE4\xBd`i\xDf\xBd...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}
06:26:19.737 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - START --> SPACE1
06:26:19.738 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - SPACE1 --> URI
06:26:19.740 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - URI --> SPACE2
06:26:19.740 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - SPACE2 --> REQUEST_VERSION
06:26:19.741 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - REQUEST_VERSION --> HEADER
06:26:19.742 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
06:26:19.743 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
06:26:19.744 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_NAME
06:26:19.745 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_NAME --> HEADER_VALUE
06:26:19.746 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_VALUE --> HEADER_IN_VALUE
06:26:19.746 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
06:26:19.747 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
06:26:19.748 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
06:26:19.748 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
06:26:19.749 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
06:26:19.750 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
06:26:19.751 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
06:26:19.752 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
06:26:19.752 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
06:26:19.753 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_NAME
06:26:19.754 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_NAME --> HEADER_VALUE
06:26:19.755 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_VALUE --> HEADER_IN_VALUE
06:26:19.755 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
06:26:19.756 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_NAME
06:26:19.756 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_NAME --> HEADER_VALUE
06:26:19.757 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_VALUE --> HEADER_IN_VALUE
06:26:19.758 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
06:26:19.759 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
06:26:19.759 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
06:26:19.760 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
06:26:19.761 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
06:26:19.761 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
06:26:19.762 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
06:26:19.763 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> END
06:26:19.764 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - HttpChannelOverHttp@170a7cc{r=26,c=false,a=IDLE,uri=/rest/sitemaps/_default/_default} messageComplete
06:26:19.765 [DEBUG] [org.eclipse.jetty.server.HttpInput  ] - HttpInputOverHTTP@1f4ee36 EOF
06:26:19.765 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - HttpChannelOverHttp@170a7cc{r=26,c=false,a=IDLE,uri=/rest/sitemaps/_default/_default} handle enter
06:26:19.766 [DEBUG] [clipse.jetty.server.HttpChannelState] - HttpChannelState@8beceb{s=IDLE i=true a=null} handling IDLE
06:26:19.767 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - HttpChannelOverHttp@170a7cc{r=26,c=false,a=DISPATCHED,uri=/rest/sitemaps/_default/_default} action REQUEST_DISPATCH
06:26:19.769 [DEBUG] [org.eclipse.jetty.server.Server     ] - REQUEST GET /rest/sitemaps/_default/_default on HttpChannelOverHttp@170a7cc{r=26,c=false,a=DISPATCHED,uri=/rest/sitemaps/_default/_default}
06:26:19.769 [DEBUG] [ax.web.service.spi.model.ServerModel] - Matching [/rest/sitemaps/_default/_default]...
06:26:19.770 [DEBUG] [ax.web.service.spi.model.ServerModel] - Path [/rest/sitemaps/_default/_default] matched to {pattern=/rest/.*,model=ServletModel{id=org.ops4j.pax.web.service.spi.model.ServletModel-2,name=org.ops4j.pax.web.service.spi.model.ServletModel-2,urlPatterns=[/rest/*],alias=/rest,servlet=com.eclipsesource.jaxrs.publisher.internal.ServletContainerBridge@f40c7,initParams={},context=ContextModel{id=org.ops4j.pax.web.service.spi.model.ContextModel-1,name=,httpContext=DefaultHttpContext [bundle=com.eclipsesource.jaxrs.publisher_5.3.1.201602281253 [12], contextID=default],contextParams={},virtualHosts={},connectors={}}}}
06:26:19.771 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/_default @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=com.eclipsesource.jaxrs.publisher_5.3.1.201602281253 [12], contextID=default]}
06:26:19.772 [DEBUG] [.jetty.server.handler.ContextHandler] - context=||/rest/sitemaps/_default/_default @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=com.eclipsesource.jaxrs.publisher_5.3.1.201602281253 [12], contextID=default]}
06:26:19.773 [DEBUG] [org.eclipse.jetty.server.session    ] - sessionManager=org.ops4j.pax.web.service.jetty.internal.LateInvalidatingHashSessionManager@18d27f3
06:26:19.774 [DEBUG] [org.eclipse.jetty.server.session    ] - session=null
06:26:19.775 [DEBUG] [eclipse.jetty.servlet.ServletHandler] - servlet |/rest|/sitemaps/_default/_default -> org.ops4j.pax.web.service.spi.model.ServletModel-2@378be0fa==com.eclipsesource.jaxrs.publisher.internal.ServletContainerBridge,-1,true
06:26:19.775 [DEBUG] [ce.jetty.internal.HttpServiceContext] - Handling request for [/rest/sitemaps/_default/_default] using http context [DefaultHttpContext [bundle=com.eclipsesource.jaxrs.publisher_5.3.1.201602281253 [12], contextID=default]]
06:26:19.776 [DEBUG] [y.internal.HttpServiceServletHandler] - handling request org.ops4j.pax.web.service.jetty.internal.HttpServiceRequestWrapper@edd379, org.ops4j.pax.web.service.jetty.internal.HttpServiceResponseWrapper@662e02
06:26:19.777 [DEBUG] [eclipse.jetty.servlet.ServletHandler] - chain=null

repeated every few seconds... anything can be understood from that?

TimO

Ok, here is the corrected jar file: LINK

The things now should update.

I've tested it with the current snapshot on two systems / mysensors environments. I've not tested it against the curren testing (beta4). It should work, but it may throw exceptions on startup.

At the moment please only update if you expierence problems. I would like to ensure the binding is now working.

FutureCow

Thanks, the new version is working nice. only your link didn't work for me, i used this one:
https://github.com/tobof/openhab2-addons/blob/MySensors/addons/binding/org.openhab.binding.mysensors/target/org.openhab.binding.mysensors-2.0.0-SNAPSHOT.jar?raw=true

ben999

@TimO
Thank you for that new jar file.
Gateway is "online" in PaperUI
Sensors are "Uninitialised"
PaperUI says Status: UNINITIALIZED - HANDLER_INITIALIZING_ERROR org.eclipse.smarthome.core.thing.Bridge.getHandler()Lorg/eclipse/smarthome/core/thing/binding/BridgeHandler;
I have added these sensors manually to thing file:

Bridge mysensors:bridge-eth:gateway [ ipAddress="127.0.0.1", tcpPort=5003, sendDelay=200, skipStartupCheck=true ] {
        humidity        bathHum01               [ nodeId="1", childId="0" ]
        temperature     bathTemp01              [ nodeId="1", childId="1" ]    }

Here is log file from OH2

22:06:55.465 [DEBUG] [io.socket.engineio.client.Socket    ] - writing ping packet - expecting pong within 60000ms
22:06:55.466 [DEBUG] [io.socket.engineio.client.Socket    ] - flushing 1 packets in socket
22:06:55.509 [DEBUG] [io.socket.engineio.client.Socket    ] - socket received: type 'pong', data 'null'
22:07:04.487 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Bridge is connected, connection skipped
22:07:07.682 [DEBUG] [org.eclipse.jetty.io.IdleTimeout    ] - SelectChannelEndPoint@310200{/192.168.1.9:60520<->8080,Open,in,out,-,-,30000/30000,HttpConnection}{io=0,kio=0,kro=1} idle timeout check, elapsed: 30000 ms, remaining: 0 ms
22:07:07.683 [DEBUG] [org.eclipse.jetty.io.IdleTimeout    ] - SelectChannelEndPoint@310200{/192.168.1.9:60520<->8080,Open,in,out,-,-,30002/30000,HttpConnection}{io=0,kio=0,kro=1} idle timeout expired
22:07:07.684 [DEBUG] [org.eclipse.jetty.io.WriteFlusher   ] - ignored: WriteFlusher@82249d{IDLE} java.util.concurrent.TimeoutException: Idle timeout expired: 30000/30000 ms
22:07:07.685 [DEBUG] [rg.eclipse.jetty.io.AbstractEndPoint] - Ignored idle endpoint SelectChannelEndPoint@310200{/192.168.1.9:60520<->8080,Open,in,out,-,-,30003/30000,HttpConnection}{io=0,kio=0,kro=1}
22:07:09.977 [DEBUG] [org.eclipse.jetty.io.IdleTimeout    ] - SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,29439/30000,SslConnection}{io=0,kio=0,kro=1} idle timeout check, elapsed: 29439 ms, remaining: 561 ms
22:07:10.540 [DEBUG] [org.eclipse.jetty.io.IdleTimeout    ] - SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,30001/30000,SslConnection}{io=0,kio=0,kro=1} idle timeout check, elapsed: 30001 ms, remaining: -1 ms
22:07:10.541 [DEBUG] [org.eclipse.jetty.io.IdleTimeout    ] - SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,30002/30000,SslConnection}{io=0,kio=0,kro=1} idle timeout expired
22:07:10.541 [DEBUG] [org.eclipse.jetty.io.WriteFlusher   ] - ignored: WriteFlusher@f4107c{IDLE} java.util.concurrent.TimeoutException: Idle timeout expired: 30001/30000 ms
22:07:10.542 [DEBUG] [rg.eclipse.jetty.io.AbstractEndPoint] - Ignored idle endpoint SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,30004/30000,SslConnection}{io=0,kio=0,kro=1}
22:07:10.884 [DEBUG] [e.internal.WriterInterceptorExecutor] - Message body writer (class com.eclipsesource.jaxrs.provider.gson.GsonProvider) is trying to close the entity output stream. Not closing.
22:07:10.886 [DEBUG] [.eclipse.jetty.server.HttpConnection] - org.eclipse.jetty.server.HttpConnection$SendCallback@ad3ff7[PROCESSING][i=ResponseInfo{HTTP/1.1 200 OK,1051,false},cb=org.eclipse.jetty.server.HttpChannel$CommitCallback@b60904] generate: NEED_HEADER (null,[p=0,l=1051,c=8192,r=1051],true)@START
22:07:10.887 [DEBUG] [.eclipse.jetty.server.HttpConnection] - org.eclipse.jetty.server.HttpConnection$SendCallback@ad3ff7[PROCESSING][i=ResponseInfo{HTTP/1.1 200 OK,1051,false},cb=org.eclipse.jetty.server.HttpChannel$CommitCallback@b60904] generate: FLUSH ([p=0,l=106,c=8192,r=106],[p=0,l=1051,c=8192,r=1051],true)@COMPLETING
22:07:10.889 [DEBUG] [org.eclipse.jetty.io.WriteFlusher   ] - write: WriteFlusher@18a5ae6{IDLE} [HeapByteBuffer@107873[p=0,l=106,c=8192,r=106]={<<<HTTP/1.1 200 OK\r\n....v20151106)\r\n\r\n>>> chunked\r\nServer:...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00},HeapByteBuffer@6612b4[p=0,l=1051,c=8192,r=1051]={<<<{"id":"0000","tit..."widgets":[]}]}>>>\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}]
22:07:10.892 [DEBUG] [org.eclipse.jetty.io.WriteFlusher   ] - update WriteFlusher@18a5ae6{WRITING}:IDLE-->WRITING
22:07:10.895 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,W,30371/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,353/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=END,0 of -1},g=HttpGenerator{s=COMPLETING},c=HttpChannelOverHttp@d19aaf{r=38,c=true,a=DISPATCHED,uri=/rest/sitemaps/_default/0000}] flush enter [java.nio.HeapByteBuffer[pos=0 lim=106 cap=8192], java.nio.HeapByteBuffer[pos=0 lim=1051 cap=8192]]
22:07:10.901 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/1186,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,W,30377/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,358/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=END,0 of -1},g=HttpGenerator{s=COMPLETING},c=HttpChannelOverHttp@d19aaf{r=38,c=true,a=DISPATCHED,uri=/rest/sitemaps/_default/0000}] wrap Status = OK HandshakeStatus = NOT_HANDSHAKING
bytesConsumed = 1157 bytesProduced = 1186
22:07:10.903 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,W,30379/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,361/30000,SslConnection}{io=0,kio=0,kro=1} OK HeapByteBuffer@eb6978[p=0,l=1186,c=17408,r=1186]={<<<\x17\x03\x03\x04\x9d\x00\x00\x00\x00\x00\x00\x00&\xFe3\xE3|...\xFe$\xE1\xF9J\xE06\xE9\xE96_=\x9a\xAa\x0c>>>\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}
22:07:10.906 [DEBUG] [org.eclipse.jetty.io.ChannelEndPoint] - flushed 1186 SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,363/30000,SslConnection}{io=0,kio=0,kro=1}
22:07:10.908 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/0,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,W,30384/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,1/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=END,0 of -1},g=HttpGenerator{s=COMPLETING},c=HttpChannelOverHttp@d19aaf{r=38,c=true,a=DISPATCHED,uri=/rest/sitemaps/_default/0000}] flush exit, consumed 1157
22:07:10.910 [DEBUG] [org.eclipse.jetty.io.WriteFlusher   ] - update WriteFlusher@18a5ae6{IDLE}:WRITING-->IDLE
22:07:10.912 [DEBUG] [.eclipse.jetty.server.HttpConnection] - org.eclipse.jetty.server.HttpConnection$SendCallback@ad3ff7[PROCESSING][i=ResponseInfo{HTTP/1.1 200 OK,1051,false},cb=org.eclipse.jetty.server.HttpChannel$CommitCallback@b60904] generate: DONE ([p=106,l=106,c=8192,r=0],[p=1051,l=1051,c=8192,r=0],true)@END
22:07:10.915 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ o.e.j.s.h.ContextHandler@1f3fece{/static,null,AVAILABLE}
22:07:10.916 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.eclipse.smarthome.core.audio_0.9.0.201611041332 [100], contextID=default]}
22:07:10.917 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.eclipse.smarthome.ui_0.9.0.201611041332 [137], contextID=default]}
22:07:10.918 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.eclipse.smarthome.ui.icon_0.9.0.201611041332 [138], contextID=default]}
22:07:10.919 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=org.jupnp.transport.impl.osgi.DisableAuthenticationHttpContext@14870c1}
22:07:10.919 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.eclipse.smarthome.ui.basic_0.9.0.201611041332 [186], contextID=default]}
22:07:10.920 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.eclipse.smarthome.ui.classic_0.9.0.201611041332 [187], contextID=default]}
22:07:10.921 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.eclipse.smarthome.ui.paper_0.9.0.201611041332 [188], contextID=default]}
22:07:10.921 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.io.rest.docs_2.0.0.201611062131 [189], contextID=default]}
22:07:10.922 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.ui.dashboard_2.0.0.201611062131 [192], contextID=default]}
22:07:10.923 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.core_2.0.0.201611062131 [168], contextID=default]}
22:07:10.924 [DEBUG] [org.eclipse.jetty.server.Server     ] - RESPONSE /rest/sitemaps/_default/0000  200 handled=true
22:07:10.925 [DEBUG] [clipse.jetty.server.HttpChannelState] - HttpChannelState@6e53d6{s=DISPATCHED i=true a=null} unhandle DISPATCHED
22:07:10.926 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - reset HttpParser{s=END,0 of -1}
22:07:10.926 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - END --> START
22:07:10.927 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - HttpChannelOverHttp@d19aaf{r=38,c=false,a=IDLE,uri=} handle exit, result COMPLETE
22:07:10.929 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,30405/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,22/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=38,c=false,a=IDLE,uri=}] fill enter
22:07:10.931 [DEBUG] [org.eclipse.jetty.io.ChannelEndPoint] - filled 0 SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,23/30000,SslConnection}{io=0,kio=0,kro=1}
22:07:10.933 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=0/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,30409/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,25/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=38,c=false,a=IDLE,uri=}] filled 0 encrypted bytes
22:07:10.935 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=0/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,30411/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,27/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=38,c=false,a=IDLE,uri=}] unwrap Status = BUFFER_UNDERFLOW HandshakeStatus = NOT_HANDSHAKING
bytesConsumed = 0 bytesProduced = 0
22:07:10.937 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,30413/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,29/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=38,c=false,a=IDLE,uri=}] fill exit
22:07:10.939 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,30415/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,32/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=38,c=false,a=IDLE,uri=}] fill enter
22:07:10.941 [DEBUG] [org.eclipse.jetty.io.ChannelEndPoint] - filled 0 SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,33/30000,SslConnection}{io=0,kio=0,kro=1}
22:07:10.942 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=0/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,30419/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,35/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=38,c=false,a=IDLE,uri=}] filled 0 encrypted bytes
22:07:10.945 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=0/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,30421/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,37/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=38,c=false,a=IDLE,uri=}] unwrap Status = BUFFER_UNDERFLOW HandshakeStatus = NOT_HANDSHAKING
bytesConsumed = 0 bytesProduced = 0
22:07:10.947 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,30423/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,39/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=38,c=false,a=IDLE,uri=}] fill exit
22:07:10.948 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - parseNext s=START HeapByteBuffer@1ac887b[p=0,l=0,c=17408,r=0]={<<<>>>GET /rest/sitemap...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}
22:07:10.949 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - fillInterested HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,30426/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,42/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=38,c=false,a=IDLE,uri=}]
22:07:10.951 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - FILLING-->FILLING_FILL_INTERESTED HttpConnection@12c6b19[FILLING_FILL_INTERESTED,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,30427/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,44/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=38,c=false,a=IDLE,uri=}]
22:07:10.953 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - FILLING_FILL_INTERESTED-->FILL_INTERESTED HttpConnection@12c6b19[FILL_INTERESTED,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,30429/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,46/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=38,c=false,a=IDLE,uri=}]
22:07:10.955 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - fillInterested SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@12c6b19[FILL_INTERESTED,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,R,-,0/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,48/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=38,c=false,a=IDLE,uri=}]
22:07:10.958 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - IDLE-->FILL_INTERESTED SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@12c6b19[FILL_INTERESTED,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,R,-,3/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,50/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=38,c=false,a=IDLE,uri=}]
22:07:10.959 [DEBUG] [lipse.jetty.io.SelectChannelEndPoint] - Local interests updating 0 -> 1 for SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,R,-,0/30000,SslConnection}{io=1,kio=0,kro=1}
22:07:10.960 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Queued change org.eclipse.jetty.io.SelectChannelEndPoint$1@1d2164a
22:07:10.961 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Selector loop woken up from select, 0/1 selected
22:07:10.961 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Running change org.eclipse.jetty.io.SelectChannelEndPoint$1@1d2164a
22:07:10.962 [DEBUG] [lipse.jetty.io.SelectChannelEndPoint] - Key interests updated 0 -> 1 on SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,R,-,3/30000,SslConnection}{io=1,kio=1,kro=1}
22:07:10.962 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Selector loop waiting on select
22:07:11.035 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Selector loop woken up from select, 1/1 selected
22:07:11.036 [DEBUG] [lipse.jetty.io.SelectChannelEndPoint] - Key interests updated 1 -> 0 on SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,R,-,78/30000,SslConnection}{io=1,kio=0,kro=1}
22:07:11.036 [DEBUG] [lipse.jetty.io.SelectChannelEndPoint] - Local interests updating 1 -> 0 for SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,R,-,78/30000,SslConnection}{io=0,kio=0,kro=1}
22:07:11.037 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Queued change org.eclipse.jetty.io.SelectChannelEndPoint$1@1d2164a
22:07:11.038 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - FILL_INTERESTED-->FILLING SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@12c6b19[FILL_INTERESTED,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,R,-,83/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,79/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=38,c=false,a=IDLE,uri=}]
22:07:11.038 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - onFillable enter DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,R,-,84/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,80/30000,SslConnection}{io=0,kio=0,kro=1}
22:07:11.039 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - FILL_INTERESTED-->FILLING HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,85/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,81/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=38,c=false,a=IDLE,uri=}]
22:07:11.040 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - onFillable exit DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,86/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,82/30000,SslConnection}{io=0,kio=0,kro=1}
22:07:11.041 [DEBUG] [.eclipse.jetty.server.HttpConnection] - HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,86/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,82/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=38,c=false,a=IDLE,uri=}] onFillable HttpChannelState@6e53d6{s=IDLE i=true a=null}
22:07:11.041 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - FILLING-->IDLE SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,87/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,83/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=38,c=false,a=IDLE,uri=}]
22:07:11.042 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,87/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,83/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=38,c=false,a=IDLE,uri=}] fill enter
22:07:11.042 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Running change org.eclipse.jetty.io.SelectChannelEndPoint$1@1d2164a
22:07:11.042 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Selector loop waiting on select
22:07:11.042 [DEBUG] [org.eclipse.jetty.io.ChannelEndPoint] - filled 473 SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,84/30000,SslConnection}{io=0,kio=0,kro=1}
22:07:11.043 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=473/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,89/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,1/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=38,c=false,a=IDLE,uri=}] filled 473 encrypted bytes
22:07:11.045 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=0/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,91/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,3/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=38,c=false,a=IDLE,uri=}] unwrap Status = OK HandshakeStatus = NOT_HANDSHAKING
bytesConsumed = 473 bytesProduced = 444
22:07:11.046 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,92/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,4/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=38,c=false,a=IDLE,uri=}] fill exit
22:07:11.047 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - parseNext s=START HeapByteBuffer@c998ba[p=0,l=444,c=17408,r=444]={<<<GET /rest/sitemap...rwin/16.1.0\r\n\r\n>>>.0 CFNetwork/808....\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}
22:07:11.047 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - START --> SPACE1
22:07:11.047 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - SPACE1 --> URI
22:07:11.048 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - URI --> SPACE2
22:07:11.048 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - SPACE2 --> REQUEST_VERSION
22:07:11.048 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - REQUEST_VERSION --> HEADER
22:07:11.048 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
22:07:11.049 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
22:07:11.049 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_NAME
22:07:11.049 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_NAME --> HEADER_VALUE
22:07:11.049 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_VALUE --> HEADER_IN_VALUE
22:07:11.050 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
22:07:11.050 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
22:07:11.050 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
22:07:11.050 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
22:07:11.050 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
22:07:11.050 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
22:07:11.051 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
22:07:11.051 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
22:07:11.051 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
22:07:11.051 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
22:07:11.051 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
22:07:11.052 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_NAME
22:07:11.052 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_NAME --> HEADER_VALUE
22:07:11.052 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_VALUE --> HEADER_IN_VALUE
22:07:11.052 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
22:07:11.052 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
22:07:11.053 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
22:07:11.053 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
22:07:11.053 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
22:07:11.053 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> END
22:07:11.054 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - HttpChannelOverHttp@d19aaf{r=39,c=false,a=IDLE,uri=/rest/sitemaps/_default/0000} messageComplete
22:07:11.054 [DEBUG] [org.eclipse.jetty.server.HttpInput  ] - HttpInputOverHTTP@15ca2 EOF
22:07:11.055 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - HttpChannelOverHttp@d19aaf{r=39,c=false,a=IDLE,uri=/rest/sitemaps/_default/0000} handle enter
22:07:11.055 [DEBUG] [clipse.jetty.server.HttpChannelState] - HttpChannelState@6e53d6{s=IDLE i=true a=null} handling IDLE
22:07:11.056 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - HttpChannelOverHttp@d19aaf{r=39,c=false,a=DISPATCHED,uri=/rest/sitemaps/_default/0000} action REQUEST_DISPATCH
22:07:11.056 [DEBUG] [org.eclipse.jetty.server.Server     ] - REQUEST GET /rest/sitemaps/_default/0000 on HttpChannelOverHttp@d19aaf{r=39,c=false,a=DISPATCHED,uri=/rest/sitemaps/_default/0000}
22:07:11.057 [DEBUG] [ax.web.service.spi.model.ServerModel] - Matching [/rest/sitemaps/_default/0000]...
22:07:11.057 [DEBUG] [ax.web.service.spi.model.ServerModel] - Path [/rest/sitemaps/_default/0000] matched to {pattern=/rest/.*,model=ServletModel{id=org.ops4j.pax.web.service.spi.model.ServletModel-2,name=org.ops4j.pax.web.service.spi.model.ServletModel-2,urlPatterns=[/rest/*],alias=/rest,servlet=com.eclipsesource.jaxrs.publisher.internal.ServletContainerBridge@1efe36d,initParams={},context=ContextModel{id=org.ops4j.pax.web.service.spi.model.ContextModel-1,name=,httpContext=DefaultHttpContext [bundle=com.eclipsesource.jaxrs.publisher_5.3.1.201602281253 [12], contextID=default],contextParams={},virtualHosts={},connectors={}}}}
22:07:11.057 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=com.eclipsesource.jaxrs.publisher_5.3.1.201602281253 [12], contextID=default]}
22:07:11.058 [DEBUG] [.jetty.server.handler.ContextHandler] - context=||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=com.eclipsesource.jaxrs.publisher_5.3.1.201602281253 [12], contextID=default]}
22:07:11.058 [DEBUG] [org.eclipse.jetty.server.session    ] - sessionManager=org.ops4j.pax.web.service.jetty.internal.LateInvalidatingHashSessionManager@1a5ce14
22:07:11.059 [DEBUG] [org.eclipse.jetty.server.session    ] - session=null
22:07:11.059 [DEBUG] [eclipse.jetty.servlet.ServletHandler] - servlet |/rest|/sitemaps/_default/0000 -> org.ops4j.pax.web.service.spi.model.ServletModel-2@378be0fa==com.eclipsesource.jaxrs.publisher.internal.ServletContainerBridge,-1,true
22:07:11.059 [DEBUG] [ce.jetty.internal.HttpServiceContext] - Handling request for [/rest/sitemaps/_default/0000] using http context [DefaultHttpContext [bundle=com.eclipsesource.jaxrs.publisher_5.3.1.201602281253 [12], contextID=default]]
22:07:11.060 [DEBUG] [y.internal.HttpServiceServletHandler] - handling request org.ops4j.pax.web.service.jetty.internal.HttpServiceRequestWrapper@5ce2b2, org.ops4j.pax.web.service.jetty.internal.HttpServiceResponseWrapper@97896c
22:07:11.060 [DEBUG] [eclipse.jetty.servlet.ServletHandler] - chain=null
22:07:11.073 [DEBUG] [e.internal.WriterInterceptorExecutor] - Message body writer (class com.eclipsesource.jaxrs.provider.gson.GsonProvider) is trying to close the entity output stream. Not closing.

ben999

22:07:11.075 [DEBUG] [.eclipse.jetty.server.HttpConnection] - org.eclipse.jetty.server.HttpConnection$SendCallback@ad3ff7[PROCESSING][i=ResponseInfo{HTTP/1.1 200 OK,1051,false},cb=org.eclipse.jetty.server.HttpChannel$CommitCallback@1ccbd33] generate: NEED_HEADER (null,[p=0,l=1051,c=8192,r=1051],true)@START
22:07:11.075 [DEBUG] [.eclipse.jetty.server.HttpConnection] - org.eclipse.jetty.server.HttpConnection$SendCallback@ad3ff7[PROCESSING][i=ResponseInfo{HTTP/1.1 200 OK,1051,false},cb=org.eclipse.jetty.server.HttpChannel$CommitCallback@1ccbd33] generate: FLUSH ([p=0,l=106,c=8192,r=106],[p=0,l=1051,c=8192,r=1051],true)@COMPLETING
22:07:11.076 [DEBUG] [org.eclipse.jetty.io.WriteFlusher   ] - write: WriteFlusher@18a5ae6{IDLE} [HeapByteBuffer@107873[p=0,l=106,c=8192,r=106]={<<<HTTP/1.1 200 OK\r\n....v20151106)\r\n\r\n>>> chunked\r\nServer:...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00},HeapByteBuffer@193feb4[p=0,l=1051,c=8192,r=1051]={<<<{"id":"0000","tit..."widgets":[]}]}>>>\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}]
22:07:11.076 [DEBUG] [org.eclipse.jetty.io.WriteFlusher   ] - update WriteFlusher@18a5ae6{WRITING}:IDLE-->WRITING
22:07:11.077 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,W,123/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,35/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=END,0 of -1},g=HttpGenerator{s=COMPLETING},c=HttpChannelOverHttp@d19aaf{r=39,c=true,a=DISPATCHED,uri=/rest/sitemaps/_default/0000}] flush enter [java.nio.HeapByteBuffer[pos=0 lim=106 cap=8192], java.nio.HeapByteBuffer[pos=0 lim=1051 cap=8192]]
22:07:11.102 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/1186,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,W,147/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,60/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=END,0 of -1},g=HttpGenerator{s=COMPLETING},c=HttpChannelOverHttp@d19aaf{r=39,c=true,a=DISPATCHED,uri=/rest/sitemaps/_default/0000}] wrap Status = OK HandshakeStatus = NOT_HANDSHAKING
bytesConsumed = 1157 bytesProduced = 1186
22:07:11.103 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,W,148/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,61/30000,SslConnection}{io=0,kio=0,kro=1} OK HeapByteBuffer@eb6978[p=0,l=1186,c=17408,r=1186]={<<<\x17\x03\x03\x04\x9d\x00\x00\x00\x00\x00\x00\x00']\x1a(\xA4...\x94_\xF6\x11\x13PZf&0^\x1a\xC5c\x85>>>\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}
22:07:11.104 [DEBUG] [org.eclipse.jetty.io.ChannelEndPoint] - flushed 1186 SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,61/30000,SslConnection}{io=0,kio=0,kro=1}
22:07:11.105 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/0,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,W,150/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,0/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=END,0 of -1},g=HttpGenerator{s=COMPLETING},c=HttpChannelOverHttp@d19aaf{r=39,c=true,a=DISPATCHED,uri=/rest/sitemaps/_default/0000}] flush exit, consumed 1157
22:07:11.105 [DEBUG] [org.eclipse.jetty.io.WriteFlusher   ] - update WriteFlusher@18a5ae6{IDLE}:WRITING-->IDLE
22:07:11.106 [DEBUG] [.eclipse.jetty.server.HttpConnection] - org.eclipse.jetty.server.HttpConnection$SendCallback@ad3ff7[PROCESSING][i=ResponseInfo{HTTP/1.1 200 OK,1051,false},cb=org.eclipse.jetty.server.HttpChannel$CommitCallback@1ccbd33] generate: DONE ([p=106,l=106,c=8192,r=0],[p=1051,l=1051,c=8192,r=0],true)@END
22:07:11.107 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ o.e.j.s.h.ContextHandler@1f3fece{/static,null,AVAILABLE}
22:07:11.107 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.eclipse.smarthome.core.audio_0.9.0.201611041332 [100], contextID=default]}
22:07:11.108 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.eclipse.smarthome.ui_0.9.0.201611041332 [137], contextID=default]}
22:07:11.108 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.eclipse.smarthome.ui.icon_0.9.0.201611041332 [138], contextID=default]}
22:07:11.108 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=org.jupnp.transport.impl.osgi.DisableAuthenticationHttpContext@14870c1}
22:07:11.109 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.eclipse.smarthome.ui.basic_0.9.0.201611041332 [186], contextID=default]}
22:07:11.109 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.eclipse.smarthome.ui.classic_0.9.0.201611041332 [187], contextID=default]}
22:07:11.110 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.eclipse.smarthome.ui.paper_0.9.0.201611041332 [188], contextID=default]}
22:07:11.110 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.io.rest.docs_2.0.0.201611062131 [189], contextID=default]}
22:07:11.110 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.ui.dashboard_2.0.0.201611062131 [192], contextID=default]}
22:07:11.111 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.core_2.0.0.201611062131 [168], contextID=default]}
22:07:11.111 [DEBUG] [org.eclipse.jetty.server.Server     ] - RESPONSE /rest/sitemaps/_default/0000  200 handled=true
22:07:11.111 [DEBUG] [clipse.jetty.server.HttpChannelState] - HttpChannelState@6e53d6{s=DISPATCHED i=true a=null} unhandle DISPATCHED
22:07:11.112 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - reset HttpParser{s=END,0 of -1}
22:07:11.112 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - END --> START
22:07:11.112 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - HttpChannelOverHttp@d19aaf{r=39,c=false,a=IDLE,uri=} handle exit, result COMPLETE
22:07:11.114 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,159/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,9/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=39,c=false,a=IDLE,uri=}] fill enter
22:07:11.114 [DEBUG] [org.eclipse.jetty.io.ChannelEndPoint] - filled 0 SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,10/30000,SslConnection}{io=0,kio=0,kro=1}
22:07:11.115 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=0/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,161/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,11/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=39,c=false,a=IDLE,uri=}] filled 0 encrypted bytes
22:07:11.116 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=0/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,162/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,12/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=39,c=false,a=IDLE,uri=}] unwrap Status = BUFFER_UNDERFLOW HandshakeStatus = NOT_HANDSHAKING
bytesConsumed = 0 bytesProduced = 0
22:07:11.118 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,163/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,13/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=39,c=false,a=IDLE,uri=}] fill exit
22:07:11.119 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,164/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,14/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=39,c=false,a=IDLE,uri=}] fill enter
22:07:11.119 [DEBUG] [org.eclipse.jetty.io.ChannelEndPoint] - filled 0 SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,15/30000,SslConnection}{io=0,kio=0,kro=1}
22:07:11.120 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=0/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,166/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,16/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=39,c=false,a=IDLE,uri=}] filled 0 encrypted bytes
22:07:11.121 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=0/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,167/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,17/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=39,c=false,a=IDLE,uri=}] unwrap Status = BUFFER_UNDERFLOW HandshakeStatus = NOT_HANDSHAKING
bytesConsumed = 0 bytesProduced = 0
22:07:11.122 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,168/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,18/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=39,c=false,a=IDLE,uri=}] fill exit
22:07:11.123 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - parseNext s=START HeapByteBuffer@138a3c8[p=0,l=0,c=17408,r=0]={<<<>>>GET /rest/sitemap...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}
22:07:11.124 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - fillInterested HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,169/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,19/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=39,c=false,a=IDLE,uri=}]
22:07:11.125 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - FILLING-->FILLING_FILL_INTERESTED HttpConnection@12c6b19[FILLING_FILL_INTERESTED,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,170/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,20/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=39,c=false,a=IDLE,uri=}]
22:07:11.126 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - FILLING_FILL_INTERESTED-->FILL_INTERESTED HttpConnection@12c6b19[FILL_INTERESTED,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,171/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,21/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=39,c=false,a=IDLE,uri=}]
22:07:11.127 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - fillInterested SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@12c6b19[FILL_INTERESTED,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,R,-,0/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,22/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=39,c=false,a=IDLE,uri=}]
22:07:11.128 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - IDLE-->FILL_INTERESTED SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@12c6b19[FILL_INTERESTED,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,R,-,1/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,24/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=39,c=false,a=IDLE,uri=}]
22:07:11.129 [DEBUG] [lipse.jetty.io.SelectChannelEndPoint] - Local interests updating 0 -> 1 for SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,R,-,0/30000,SslConnection}{io=1,kio=0,kro=1}
22:07:11.129 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Queued change org.eclipse.jetty.io.SelectChannelEndPoint$1@1d2164a
22:07:11.129 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Selector loop woken up from select, 0/1 selected
22:07:11.130 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Running change org.eclipse.jetty.io.SelectChannelEndPoint$1@1d2164a
22:07:11.130 [DEBUG] [lipse.jetty.io.SelectChannelEndPoint] - Key interests updated 0 -> 1 on SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,R,-,2/30000,SslConnection}{io=1,kio=1,kro=1}
22:07:11.131 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Selector loop waiting on select
22:07:11.238 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Selector loop woken up from select, 1/1 selected
22:07:11.238 [DEBUG] [lipse.jetty.io.SelectChannelEndPoint] - Key interests updated 1 -> 0 on SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,R,-,110/30000,SslConnection}{io=1,kio=0,kro=1}
22:07:11.239 [DEBUG] [lipse.jetty.io.SelectChannelEndPoint] - Local interests updating 1 -> 0 for SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,R,-,111/30000,SslConnection}{io=0,kio=0,kro=1}
22:07:11.239 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Queued change org.eclipse.jetty.io.SelectChannelEndPoint$1@1d2164a
22:07:11.240 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - FILL_INTERESTED-->FILLING SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@12c6b19[FILL_INTERESTED,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,R,-,114/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,112/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=39,c=false,a=IDLE,uri=}]
22:07:11.241 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - onFillable enter DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,R,-,115/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,113/30000,SslConnection}{io=0,kio=0,kro=1}
22:07:11.242 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - FILL_INTERESTED-->FILLING HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,115/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,114/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=39,c=false,a=IDLE,uri=}]
22:07:11.243 [DEBUG] [.eclipse.jetty.server.HttpConnection] - HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,117/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,115/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=39,c=false,a=IDLE,uri=}] onFillable HttpChannelState@6e53d6{s=IDLE i=true a=null}
22:07:11.244 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,118/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,116/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=39,c=false,a=IDLE,uri=}] fill enter
22:07:11.245 [DEBUG] [org.eclipse.jetty.io.ChannelEndPoint] - filled 511 SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,117/30000,SslConnection}{io=0,kio=0,kro=1}
22:07:11.246 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=511/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,120/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,1/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=39,c=false,a=IDLE,uri=}] filled 511 encrypted bytes
22:07:11.248 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=0/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,121/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,3/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=39,c=false,a=IDLE,uri=}] unwrap Status = OK HandshakeStatus = NOT_HANDSHAKING
bytesConsumed = 511 bytesProduced = 482
22:07:11.249 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,122/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,4/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=39,c=false,a=IDLE,uri=}] fill exit
22:07:11.249 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - parseNext s=START HeapByteBuffer@1ac887b[p=0,l=482,c=17408,r=482]={<<<GET /rest/sitemap...rwin/16.1.0\r\n\r\n>>>in/16.1.0\r\n\r\n\xE0\xBc\xB1\xF2...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}
22:07:11.250 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - START --> SPACE1
22:07:11.250 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - SPACE1 --> URI
22:07:11.250 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - URI --> SPACE2
22:07:11.250 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - SPACE2 --> REQUEST_VERSION
22:07:11.250 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - REQUEST_VERSION --> HEADER
22:07:11.251 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
22:07:11.251 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
22:07:11.251 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_NAME
22:07:11.251 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - onFillable exit DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,123/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,5/30000,SslConnection}{io=0,kio=0,kro=1}
22:07:11.251 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_NAME --> HEADER_VALUE
22:07:11.252 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_VALUE --> HEADER_IN_VALUE
22:07:11.252 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
22:07:11.252 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
22:07:11.252 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
22:07:11.252 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
22:07:11.252 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
22:07:11.253 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
22:07:11.253 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
22:07:11.253 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
22:07:11.253 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
22:07:11.254 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_NAME
22:07:11.254 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_NAME --> HEADER_VALUE
22:07:11.254 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_VALUE --> HEADER_IN_VALUE
22:07:11.254 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
22:07:11.254 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_NAME
22:07:11.255 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_NAME --> HEADER_VALUE
22:07:11.255 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_VALUE --> HEADER_IN_VALUE
22:07:11.255 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
22:07:11.255 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
22:07:11.255 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
22:07:11.255 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
22:07:11.256 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
22:07:11.256 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> HEADER_IN_VALUE
22:07:11.256 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER_IN_VALUE --> HEADER
22:07:11.256 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - HEADER --> END
22:07:11.257 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - HttpChannelOverHttp@d19aaf{r=40,c=false,a=IDLE,uri=/rest/sitemaps/_default/0000} messageComplete
22:07:11.257 [DEBUG] [org.eclipse.jetty.server.HttpInput  ] - HttpInputOverHTTP@15ca2 EOF
22:07:11.257 [DEBUG] [.eclipse.jetty.io.AbstractConnection] - FILLING-->IDLE SslConnection@140f96f{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@12c6b19[FILLING,DecryptedEndPoint@47d536{/192.168.1.24:55097<->8443,Open,in,out,-,-,127/30000,HttpConnection}->SelectChannelEndPoint@c36456{/192.168.1.24:55097<->8443,Open,in,out,-,-,9/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=HEADER_IN_VALUE,0 of -1},g=HttpGenerator{s=START},c=HttpChannelOverHttp@d19aaf{r=40,c=false,a=IDLE,uri=/rest/sitemaps/_default/0000}]
22:07:11.257 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - HttpChannelOverHttp@d19aaf{r=40,c=false,a=IDLE,uri=/rest/sitemaps/_default/0000} handle enter
22:07:11.258 [DEBUG] [clipse.jetty.server.HttpChannelState] - HttpChannelState@6e53d6{s=IDLE i=true a=null} handling IDLE
22:07:11.258 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Running change org.eclipse.jetty.io.SelectChannelEndPoint$1@1d2164a
22:07:11.258 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - HttpChannelOverHttp@d19aaf{r=40,c=false,a=DISPATCHED,uri=/rest/sitemaps/_default/0000} action REQUEST_DISPATCH
22:07:11.259 [DEBUG] [org.eclipse.jetty.server.Server     ] - REQUEST GET /rest/sitemaps/_default/0000 on HttpChannelOverHttp@d19aaf{r=40,c=false,a=DISPATCHED,uri=/rest/sitemaps/_default/0000}
22:07:11.260 [DEBUG] [ax.web.service.spi.model.ServerModel] - Matching [/rest/sitemaps/_default/0000]...
22:07:11.260 [DEBUG] [ax.web.service.spi.model.ServerModel] - Path [/rest/sitemaps/_default/0000] matched to {pattern=/rest/.*,model=ServletModel{id=org.ops4j.pax.web.service.spi.model.ServletModel-2,name=org.ops4j.pax.web.service.spi.model.ServletModel-2,urlPatterns=[/rest/*],alias=/rest,servlet=com.eclipsesource.jaxrs.publisher.internal.ServletContainerBridge@1efe36d,initParams={},context=ContextModel{id=org.ops4j.pax.web.service.spi.model.ContextModel-1,name=,httpContext=DefaultHttpContext [bundle=com.eclipsesource.jaxrs.publisher_5.3.1.201602281253 [12], contextID=default],contextParams={},virtualHosts={},connectors={}}}}
22:07:11.260 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=com.eclipsesource.jaxrs.publisher_5.3.1.201602281253 [12], contextID=default]}
22:07:11.261 [DEBUG] [.jetty.server.handler.ContextHandler] - context=||/rest/sitemaps/_default/0000 @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=com.eclipsesource.jaxrs.publisher_5.3.1.201602281253 [12], contextID=default]}
22:07:11.261 [DEBUG] [org.eclipse.jetty.io.SelectorManager] - Selector loop waiting on select
22:07:11.261 [DEBUG] [org.eclipse.jetty.server.session    ] - sessionManager=org.ops4j.pax.web.service.jetty.internal.LateInvalidatingHashSessionManager@1a5ce14
22:07:11.261 [DEBUG] [org.eclipse.jetty.server.session    ] - session=null
22:07:11.262 [DEBUG] [eclipse.jetty.servlet.ServletHandler] - servlet |/rest|/sitemaps/_default/0000 -> org.ops4j.pax.web.service.spi.model.ServletModel-2@378be0fa==com.eclipsesource.jaxrs.publisher.internal.ServletContainerBridge,-1,true
22:07:11.262 [DEBUG] [ce.jetty.internal.HttpServiceContext] - Handling request for [/rest/sitemaps/_default/0000] using http context [DefaultHttpContext [bundle=com.eclipsesource.jaxrs.publisher_5.3.1.201602281253 [12], contextID=default]]
22:07:11.262 [DEBUG] [y.internal.HttpServiceServletHandler] - handling request org.ops4j.pax.web.service.jetty.internal.HttpServiceRequestWrapper@fee5d4, org.ops4j.pax.web.service.jetty.internal.HttpServiceResponseWrapper@1d0961
22:07:11.263 [DEBUG] [eclipse.jetty.servlet.ServletHandler] - chain=null
22:07:12.534 [DEBUG] [org.eclipse.jetty.io.IdleTimeout    ] - SelectChannelEndPoint@dd0653{/192.168.1.9:60519<->8080,Open,in,out,-,-,30000/30000,HttpConnection}{io=0,kio=0,kro=1} idle timeout check, elapsed: 30000 ms, remaining: 0 ms
22:07:12.534 [DEBUG] [org.eclipse.jetty.io.IdleTimeout    ] - SelectChannelEndPoint@dd0653{/192.168.1.9:60519<->8080,Open,in,out,-,-,30001/30000,HttpConnection}{io=0,kio=0,kro=1} idle timeout expired
22:07:12.535 [DEBUG] [org.eclipse.jetty.io.WriteFlusher   ] - ignored: WriteFlusher@aca643{IDLE} java.util.concurrent.TimeoutException: Idle timeout expired: 30000/30000 ms
22:07:12.535 [DEBUG] [rg.eclipse.jetty.io.AbstractEndPoint] - Ignored idle endpoint SelectChannelEndPoint@dd0653{/192.168.1.9:60519<->8080,Open,in,out,-,-,30002/30000,HttpConnection}{io=0,kio=0,kro=1}
22:07:14.488 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Bridge is connected, connection skipped
22:07:19.729 [DEBUG] [org.eclipse.jetty.io.IdleTimeout    ] - SelectChannelEndPoint@17b31db{/192.168.1.9:60535<->8080,Open,in,out,-,-,30000/30000,HttpConnection}{io=0,kio=0,kro=1} idle timeout check, elapsed: 30000 ms, remaining: 0 ms
22:07:19.730 [DEBUG] [org.eclipse.jetty.io.IdleTimeout    ] - SelectChannelEndPoint@17b31db{/192.168.1.9:60535<->8080,Open,in,out,-,-,30001/30000,HttpConnection}{io=0,kio=0,kro=1} idle timeout expired
22:07:19.730 [DEBUG] [org.eclipse.jetty.io.WriteFlusher   ] - ignored: WriteFlusher@14d7529{IDLE} java.util.concurrent.TimeoutException: Idle timeout expired: 30000/30000 ms
22:07:19.731 [DEBUG] [rg.eclipse.jetty.io.AbstractEndPoint] - Ignored idle endpoint SelectChannelEndPoint@17b31db{/192.168.1.9:60535<->8080,Open,in,out,-,-,30003/30000,HttpConnection}{io=0,kio=0,kro=1}
22:07:20.626 [DEBUG] [io.socket.engineio.client.Socket    ] - writing ping packet - expecting pong within 60000ms
22:07:20.626 [DEBUG] [io.socket.engineio.client.Socket    ] - flushing 1 packets in socket
22:07:20.669 [DEBUG] [io.socket.engineio.client.Socket    ] - socket received: type 'pong', data 'null'
22:07:21.383 [DEBUG] [rg.quartz.core.QuartzSchedulerThread] - batch acquisition of 0 triggers
22:07:24.489 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Bridge is connected, connection skipped

Repeated again and again
Log at startup would be of any interest ?
There is some progress though: NEW CONNECTION when starting OH2!!! :)

mysgw: Starting gateway...
mysgw: Protocol version - 2.0.1-beta
mysgw: MCO:BGN:INIT GW,CP=RNNG---,VER=2.0.1-beta
mysgw: TSF:LRT:OK
mysgw: TSM:INIT
mysgw: TSM:INIT:TSP OK
mysgw: TSM:INIT:GW MODE
mysgw: TSM:READY
mysgw: Listening for connections on 0.0.0.0:5003
mysgw: MCO:REG:NOT NEEDED
mysgw: MCO:BGN:STP
mysgw: MCO:BGN:INIT OK,ID=0,PAR=0,DIS=0,REG=1
mysgw: TSF:MSG:READ,1-1-0,s=255,c=3,t=26,pt=1,l=1,sg=0:2
mysgw: TSF:MSG:SEND,0-0-1-1,s=255,c=3,t=27,pt=1,l=1,sg=0,ft=0,st=OK:1
mysgw: TSF:MSG:READ,1-1-0,s=255,c=3,t=15,pt=6,l=2,sg=0:0100
mysgw: TSF:MSG:SEND,0-0-1-1,s=255,c=3,t=15,pt=6,l=2,sg=0,ft=0,st=OK:0100
mysgw: TSF:MSG:READ,1-1-0,s=255,c=0,t=17,pt=0,l=5,sg=0:2.0.0
mysgw: TSF:MSG:READ,1-1-0,s=255,c=3,t=6,pt=1,l=1,sg=0:0
mysgw: TSF:MSG:READ,1-1-0,s=255,c=3,t=11,pt=0,l=22,sg=0:TemperatureAndHumidity
mysgw: TSF:MSG:READ,1-1-0,s=255,c=3,t=12,pt=0,l=3,sg=0:1.1
mysgw: TSF:MSG:READ,1-1-0,s=0,c=0,t=7,pt=0,l=0,sg=0:
mysgw: TSF:MSG:READ,1-1-0,s=1,c=0,t=6,pt=0,l=0,sg=0:
mysgw: TSF:MSG:READ,1-1-0,s=255,c=3,t=26,pt=1,l=1,sg=0:2
mysgw: TSF:MSG:SEND,0-0-1-1,s=255,c=3,t=27,pt=1,l=1,sg=0,ft=0,st=OK:1
mysgw: TSF:MSG:READ,1-1-0,s=1,c=1,t=0,pt=7,l=5,sg=0:19.9
mysgw: TSF:MSG:READ,1-1-0,s=0,c=1,t=1,pt=7,l=5,sg=0:61.2
mysgw: New connection from 127.0.0.1
mysgw: Client 0 connected
mysgw: TSF:MSG:READ,1-1-0,s=0,c=1,t=1,pt=7,l=5,sg=0:61.3

Thank you so much for your time

TimO

@ben999 had a chat @Jic right now who has exactly the same problem.

There is still something wrong! :-(
I'll keep searching!

undee

@TimO Can you say anything regarding the autoupdate=false option yet? It would be useful to separate the UI user action from the status displayed by the UI. Rollershutters for example can show the percentage of how much the shutters are down. This conflicts with the autoupdate=true behaviour which sets the value to 0 as soon as the UP button is pushed.

Jic

@TimO I have reviewed all my steps, and seems that I had not updated correctly the binding.
So later update Openhab2 to latest snapshot, the latest org.openhab.binding.mysensors-2.0.0-SNAPSHOT.jar now it working right.

0_1479854234589_Selección_003.png

thank you very much

ben999

@TimO
Will do as @Jic said and will start fresh tonight (europe) with latest OH2 and all on a fresh SD Card
There might be old files and bugs on this really messed up install...
Thanks again for your time and effort

TimO

@Jic I'm glad it worked out finally, thank you for your feedback!

@ben999 Please do so and ensure you install the latest snapshot of OH2.

At least I think we found the guilty one:

"The methods ThingHandler.bridgeHandlerInitialized() and ThingHandler.bridgeHandlerDisposed() are removed. This breaks the API."
PR LINK

The most annoying part is: I don't see a way to keep up backward compatibility with the current testing release (beta4).

TimO

@undee I'm not able to find a hint, that it is already implemented in OH2, do you have more information for me?

Defining:

Switch light01  "light01"       { autoupdate=false, channel="mysensors:light:gateway:light01:status" }

Returns:

[.e.s.m.i.i.GenericItemProvider:385  ] - Couldn't find ItemFactory for item 'channel' of type 'false'

Does not look like OH2 already knows what it means.

undee

@TimO The MQTT binding might be helpful. It is possible to implement the following behaviour with MQTT when autoupdate is set to false:

When you touch a switch, the defined message is published to an MQTT topic, but the button status remains unchanged. Then, for example, the device processes the message and publishes a status message which then causes the update to the visible status of the button.

The same can be implemented with shutters. When you push the button to move the shutters up, with autoupdate=true the icon is immediately set to reflect 0%. With autoupdate=false, you can show the current position by updating the position while it is in motion.

I can't do this with the MySensors binding yet because pushing a button always updates the status automatically.

ben999

@TimO
:crown: you deserve that one :)
All working fine, no trouble
Very clean OH2 log file
Happy man i am!
Thanks again for time, effort and availability
Please let me know if i can help in any way

pi@raspberrypi:/usr/share/openhab2 $ ./start.sh
Launching the openHAB runtime...

                          __  _____    ____      
  ____  ____  ___  ____  / / / /   |  / __ )     
 / __ \/ __ \/ _ \/ __ \/ /_/ / /| | / __  | 
/ /_/ / /_/ /  __/ / / / __  / ___ |/ /_/ /      
\____/ .___/\___/_/ /_/_/ /_/_/  |_/_____/     
    /_/                        2.0.0-SNAPSHOT
                               Build #609   

Hit '<tab>' for a list of available commands
and '[cmd] --help' for help on a specific command.
Hit '<ctrl-d>' or type 'system:shutdown' or 'logout' to shutdown openHAB.

openhab> log:set DEBUG org.openhab.binding.mysensors
openhab> log:tail
21:42:00.387 [DEBUG] [org.openhab.binding.mysensors       ] - BundleEvent STARTING - org.openhab.binding.mysensors
21:42:00.403 [DEBUG] [org.openhab.binding.mysensors       ] - BundleEvent STARTED - org.openhab.binding.mysensors
21:42:00.523 [DEBUG] [org.openhab.binding.mysensors       ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandlerFactory}={component.name=org.openhab.binding.mysensors.internal.factory.MySensorsHandlerFactory, component.id=0, service.id=106, service.bundleid=10, service.scope=bundle} - org.openhab.binding.mysensors
21:42:14.666 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'home.things'
21:42:14.994 [INFO ] [smarthome.event.ThingAddedEvent     ] - Thing 'mysensors:bridge-eth:gateway' has been added.                                                                                   
21:42:15.002 [INFO ] [smarthome.event.ThingAddedEvent     ] - Thing 'mysensors:humidity:gateway:bathHum01' has been added.                                                                           
21:42:15.006 [INFO ] [smarthome.event.ThingAddedEvent     ] - Thing 'mysensors:temperature:gateway:bathTemp01' has been added.                                                                       
21:42:15.433 [DEBUG] [org.openhab.binding.mysensors       ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.discovery.DiscoveryService}={service.id=230, service.bundleid=10, service.scope=singleton} - org.openhab.binding.mysensors
21:42:15.451 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:bridge-eth:gateway' changed from UNINITIALIZED to INITIALIZING
21:42:15.453 [DEBUG] [ernal.handler.MySensorsBridgeHandler] - Initialization of the MySensors bridge
21:42:15.464 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:humidity:gateway:bathHum01' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
21:42:15.474 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:temperature:gateway:bathTemp01' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)                         
21:42:15.507 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Set skip check on startup to: false
21:42:15.508 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Enabling connection watchdog
21:42:15.517 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Connecting to IP bridge [127.0.0.1:5003]
21:42:15.532 [DEBUG] [ternal.factory.MySensorsCacheFactory] - Cache file: given_ids.cached exist.
21:42:15.534 [DEBUG] [ternal.factory.MySensorsCacheFactory] - Cache (given_ids) content: [1]
21:42:15.540 [DEBUG] [ernal.handler.MySensorsBridgeHandler] - Initialization of the MySensors bridge DONE!
21:42:15.541 [DEBUG] [rs.internal.protocol.MySensorsReader] - 0;255;3;0;14;Gateway startup complete.
21:42:15.548 [DEBUG] [rs.internal.protocol.MySensorsReader] - 0;255;3;0;14;Gateway startup complete.
21:42:15.552 [INFO ] [smarthome.event.ItemAddedEvent      ] - Item 'mysensors_humidity_gateway_bathHum01_hum' has been added.
21:42:15.554 [DEBUG] [rs.internal.protocol.MySensorsReader] - 0;255;0;0;18;2.0.1-beta
21:42:15.556 [INFO ] [home.event.ItemChannelLinkAddedEvent] - Link 'mysensors_humidity_gateway_bathHum01_hum-mysensors:humidity:gateway:bathHum01:hum' has been added.
21:42:15.555 [DEBUG] [rs.internal.protocol.MySensorsReader] - 0;255;0;0;18;2.0.1-beta
21:42:15.559 [INFO ] [smarthome.event.ItemAddedEvent      ] - Item 'mysensors_humidity_gateway_bathHum01_lastupdate' has been added.
21:42:15.562 [INFO ] [home.event.ItemChannelLinkAddedEvent] - Link 'mysensors_humidity_gateway_bathHum01_lastupdate-mysensors:humidity:gateway:bathHum01:lastupdate' has been added.                 
21:42:15.565 [INFO ] [smarthome.event.ItemAddedEvent      ] - Item 'mysensors_temperature_gateway_bathTemp01_lastupdate' has been added.                                                             
21:42:15.569 [INFO ] [home.event.ItemChannelLinkAddedEvent] - Link 'mysensors_temperature_gateway_bathTemp01_lastupdate-mysensors:temperature:gateway:bathTemp01:lastupdate' has been added.         
21:42:15.571 [INFO ] [smarthome.event.ItemAddedEvent      ] - Item 'mysensors_temperature_gateway_bathTemp01_temp' has been added.                                                                   
21:42:15.573 [INFO ] [home.event.ItemChannelLinkAddedEvent] - Link 'mysensors_temperature_gateway_bathTemp01_temp-mysensors:temperature:gateway:bathTemp01:temp' has been added.                     
21:42:15.729 [DEBUG] [rs.internal.protocol.MySensorsWriter] - Sending to MySensors: 0;0;3;0;2;
21:42:15.743 [DEBUG] [rs.internal.protocol.MySensorsReader] - 0;255;3;0;2;2.0.1-beta
21:42:15.744 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Good,Gateway is up and running! (Ver:2.0.1-beta)
21:42:15.745 [DEBUG] [rs.internal.protocol.MySensorsReader] - 0;255;3;0;2;2.0.1-beta
21:42:15.749 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:bridge-eth:gateway' changed from INITIALIZING to ONLINE
21:42:15.759 [INFO ] [al.protocol.ip.MySensorsIpConnection] - Successfully connected to MySensors Bridge.
21:42:15.761 [WARN ] [al.protocol.ip.MySensorsIpConnection] - Network Sanity Checker thread disabled from bridge configuration
21:42:15.788 [DEBUG] [ternal.handler.MySensorsThingHandler] - Configuration: node 1, chiledId: 1, revertState: false
21:42:15.789 [DEBUG] [ternal.handler.MySensorsThingHandler] - Event listener for node 1-1 not registered yet, registering...
21:42:15.789 [DEBUG] [ternal.handler.MySensorsThingHandler] - Configuration: node 1, chiledId: 0, revertState: false
21:42:15.790 [DEBUG] [ternal.handler.MySensorsThingHandler] - Event listener for node 1-0 not registered yet, registering...
21:42:15.794 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:temperature:gateway:bathTemp01' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
21:42:15.796 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:humidity:gateway:bathHum01' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
21:42:15.797 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:temperature:gateway:bathTemp01' changed from INITIALIZING to ONLINE
21:42:15.799 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:humidity:gateway:bathHum01' changed from INITIALIZING to ONLINE
21:42:17.115 [INFO ] [basic.internal.servlet.WebAppServlet] - Started Basic UI at /basicui/app
21:42:17.453 [INFO ] [assic.internal.servlet.WebAppServlet] - Started Classic UI at /classicui/app
21:42:17.949 [INFO ] [arthome.ui.paper.internal.PaperUIApp] - Started Paper UI at /ui
21:42:18.125 [INFO ] [.dashboard.internal.DashboardService] - Started dashboard at /start
21:42:25.762 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Bridge is connected, connection skipped
21:42:35.763 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Bridge is connected, connection skipped
21:42:45.765 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Bridge is connected, connection skipped
21:42:55.766 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Bridge is connected, connection skipped
21:43:05.768 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Bridge is connected, connection skipped
21:43:13.988 [DEBUG] [rs.internal.protocol.MySensorsReader] - 1;0;1;0;1;62.5
21:43:14.005 [DEBUG] [ternal.handler.MySensorsThingHandler] - Setting last update for node 1 to 2016-11-23T21:43:13.995+0000
21:43:14.010 [DEBUG] [ternal.handler.MySensorsThingHandler] - Setting last update for node 1 to 2016-11-23T21:43:14.006+0000
21:43:14.016 [DEBUG] [rs.internal.protocol.MySensorsReader] - 1;0;1;0;1;62.5
21:43:14.022 [INFO ] [marthome.event.ItemStateChangedEvent] - mysensors_temperature_gateway_bathTemp01_lastupdate changed from NULL to 2016-11-23T21:43:13.995+0000
21:43:14.037 [INFO ] [marthome.event.ItemStateChangedEvent] - mysensors_humidity_gateway_bathHum01_lastupdate changed from NULL to 2016-11-23T21:43:14.006+0000
21:43:14.040 [INFO ] [marthome.event.ItemStateChangedEvent] - mysensors_humidity_gateway_bathHum01_hum changed from NULL to 62.5
21:43:15.769 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Bridge is connected, connection skipped
21:43:25.771 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Bridge is connected, connection skipped
21:43:35.772 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Bridge is connected, connection skipped
21:43:45.775 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Bridge is connected, connection skipped
21:43:55.778 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Bridge is connected, connection skipped
21:44:05.779 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Bridge is connected, connection skipped
21:44:15.780 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Bridge is connected, connection skipped
21:44:20.330 [DEBUG] [rs.internal.protocol.MySensorsReader] - 1;1;1;0;0;18.9
21:44:20.340 [DEBUG] [ternal.handler.MySensorsThingHandler] - Setting last update for node 1 to 2016-11-23T21:44:20.333+0000
21:44:20.348 [DEBUG] [ternal.handler.MySensorsThingHandler] - Setting last update for node 1 to 2016-11-23T21:44:20.342+0000
21:44:20.349 [DEBUG] [rs.internal.protocol.MySensorsReader] - 1;1;1;0;0;18.9
21:44:20.352 [DEBUG] [rs.internal.protocol.MySensorsReader] - 1;0;1;0;1;62.0
21:44:20.362 [DEBUG] [rs.internal.protocol.MySensorsReader] - 1;0;1;0;1;62.0
21:44:20.364 [INFO ] [marthome.event.ItemStateChangedEvent] - mysensors_temperature_gateway_bathTemp01_lastupdate changed from 2016-11-23T21:43:13.995+0000 to 2016-11-23T21:44:20.333+0000
21:44:20.370 [INFO ] [marthome.event.ItemStateChangedEvent] - mysensors_temperature_gateway_bathTemp01_temp changed from NULL to 18.9
21:44:20.381 [INFO ] [marthome.event.ItemStateChangedEvent] - mysensors_humidity_gateway_bathHum01_lastupdate changed from 2016-11-23T21:43:14.006+0000 to 2016-11-23T21:44:20.342+0000
21:44:20.387 [INFO ] [marthome.event.ItemStateChangedEvent] - mysensors_humidity_gateway_bathHum01_hum changed from 62.5 to 62.0
21:44:25.783 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Bridge is connected, connection skipped
21:44:35.785 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Bridge is connected, connection skipped
21:44:45.786 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Bridge is connected, connection skipped
21:44:55.788 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Bridge is connected, connection skipped
21:45:05.789 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Bridge is connected, connection skipped
21:45:15.792 [DEBUG] [al.protocol.ip.MySensorsIpConnection] - Bridge is connected, connection skipped

openHAB 2.0 binding

13

11.7k

11.2k

113.0k