Connection to HomeKit don't work

Hello together,

I have been trying to connect my Openhab to the homekit for days without success :frowning_face:
Openhab version: 2.5.2 & IOS 13.3.1

Error Message in HomeKit is: This accessory is not supported by the home app (see screenshot).

I already tried following steps:

  1. Delete pairing from the IOS home app
  2. openhab-cli console ->> smarthome:homekit clearPairings
    2-1. smarthome:homekit allowUnauthenticated true
  3. Uninstall Homekit Integration (WEB)
  4. sudo rm -r /var/lib/openhab2/jsondb/homekit.json
  5. sudo rm -r /var/lib/openhab2/jsondb/backup/*
  6. Install homekit integration addon and configure
  7. Restart openhab and check to see if /var/lib/openhab2/jsondb/homekit.json has the mac address entry.

Unfortunately without success :frowning:

Trace results:
2020-03-05 21:16:18.568 [ERROR] [org.openhab.io.homekit ] - bundle org.openhab.io.homekit:2.5.2 (266)[org.openhab.io.homekit.internal.HomekitImpl(234)] : The modified method has thrown an exception
java.lang.RuntimeException: HomekitHttpServer can only be started once
at io.github.hapjava.impl.http.impl.HomekitHttpServer.start(HomekitHttpServer.java:34) ~[?:?]
at io.github.hapjava.HomekitRoot.start(HomekitRoot.java:112) ~[?:?]
at org.openhab.io.homekit.internal.HomekitImpl.startBridge(HomekitImpl.java:120) ~[?:?]
at org.openhab.io.homekit.internal.HomekitImpl.modified(HomekitImpl.java:97) ~[?:?]
2020-03-05 21:16:18.568 [ERROR] [org.openhab.io.homekit ] - bundle org.openhab.io.homekit:2.5.2 (266)[org.openhab.io.homekit.internal.HomekitImpl(234)] : The modified method has thrown an exception
java.lang.RuntimeException: HomekitHttpServer can only be started once
at io.github.hapjava.impl.http.impl.HomekitHttpServer.start(HomekitHttpServer.java:34) ~[?:?]
at io.github.hapjava.HomekitRoot.start(HomekitRoot.java:112) ~[?:?]
at org.openhab.io.homekit.internal.HomekitImpl.startBridge(HomekitImpl.java:120) ~[?:?]
at org.openhab.io.homekit.internal.HomekitImpl.modified(HomekitImpl.java:97) ~[?:?]

openhab> bundle:list
START LEVEL 100 , List Threshold: 50
ID │ State │ Lvl │ Version │ Name
────┼────────┼─────┼─────────────────────────┼─────────────────────────────────
19 │ Active │ 80 │ 5.3.1.201602281253 │ OSGi JAX-RS Connector
20 │ Active │ 80 │ 2.8.2.v20180104-1110 │ Gson: Google Json Library for J
21 │ Active │ 80 │ 18.0.0 │ Guava: Google Core Libraries fo
22 │ Active │ 80 │ 27.1.0.jre │ Guava: Google Core Libraries fo
23 │ Active │ 80 │ 1.0.1 │ Guava InternalFutureFailureAcce
24 │ Active │ 80 │ 3.0.0.v201312141243 │ Google Guice (No AOP)
25 │ Active │ 80 │ 4.8.35.v20190528-1517 │ ClassGraph
26 │ Active │ 80 │ 3.18.1.GA │ Javassist
29 │ Active │ 80 │ 3.5.5 │ JmDNS
31 │ Active │ 80 │ 1.0.0 │ Units of Measurement API
33 │ Active │ 80 │ 1.1.0.Final │ Bean Validation API
35 │ Active │ 80 │ 2.0.1 │ javax.ws.rs-api
36 │ Active │ 80 │ 2.9.2 │ Joda-Time
37 │ Active │ 80 │ 0.5.8 │ Jollyday
38 │ Active │ 80 │ 3.2.0.v201101311130 │ ANTLR Runtime
40 │ Active │ 80 │ 1.1 │ Commons Exec
41 │ Active │ 80 │ 2.2.0 │ Commons IO
42 │ Active │ 80 │ 2.6 │ Commons Lang
51 │ Active │ 80 │ 4.2.7 │ Apache Karaf :: OSGi Services :
66 │ Active │ 80 │ 1.4.7.1 │ Apache ServiceMix :: Bundles ::
69 │ Active │ 80 │ 4.14.0 │ Apache XBean OSGI Bundle Utilit
70 │ Active │ 80 │ 4.14.0 │ Apache XBean :: Classpath Resou
71 │ Active │ 80 │ 2.12.0.v20160420-0247 │ EMF Common
72 │ Active │ 80 │ 2.12.0.v20160420-0247 │ EMF Ecore
73 │ Active │ 80 │ 2.11.0.v20160420-0247 │ EMF Change Model
74 │ Active │ 80 │ 2.12.0.v20160420-0247 │ EMF XML/XMI Persistence
75 │ Active │ 80 │ 3.10.400.v20190516-1504 │ Common Eclipse Runtime
104 │ Active │ 80 │ 0.8.0.v20190822-0801 │ org.eclipse.lsp4j
105 │ Active │ 80 │ 0.8.0.v20190822-0801 │ org.eclipse.lsp4j.jsonrpc
106 │ Active │ 80 │ 2.19.0.v20190902-0728 │ Xtend Runtime Library
107 │ Active │ 80 │ 2.19.0.v20190902-0728 │ Xtend Macro Interfaces
108 │ Active │ 80 │ 2.19.0.v20190902-0737 │ Xtext
109 │ Active │ 80 │ 2.19.0.v20190902-0952 │ Xtext Common Types
110 │ Active │ 80 │ 2.19.0.v20190902-0737 │ Xtext IDE Core
111 │ Active │ 80 │ 2.19.0.v20190902-0737 │ Xtext Utility
112 │ Active │ 80 │ 2.19.0.v20190902-0952 │ Xbase Model
113 │ Active │ 80 │ 2.19.0.v20190902-0952 │ Xbase Generic IDE Services
114 │ Active │ 80 │ 2.19.0.v20190902-0728 │ Xbase Runtime Library
129 │ Active │ 80 │ 1.9.6 │ MIME streaming extension
131 │ Active │ 80 │ 7.1.0 │ org.objectweb.asm.commons
132 │ Active │ 80 │ 7.1.0 │ org.objectweb.asm.tree
133 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Core
134 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Audio
135 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: OAut
136 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Bind
137 │ Active │ 90 │ 2.5.0 │ openHAB Core :: Bundles :: Boot
138 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Conf
139 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Conf
140 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Conf
141 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Conf
142 │ Active │ 75 │ 2.5.0 │ openHAB Core :: Bundles :: Conf
143 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Ephe
144 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: ID
145 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Cons
146 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Cons
147 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: HTTP
149 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Moni
150 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Netw
151 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: REST
152 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Audi
153 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: REST
154 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: REST
155 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: REST
156 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Site
157 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: SSE
158 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Voic
159 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: mDNS
160 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Kara
161 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Mode
162 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Mode
163 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Mode
164 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Mode
165 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Lang
166 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Mode
167 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Mode
168 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Mode
169 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Mode
170 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Mode
171 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Mode
172 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Mode
173 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Mode
174 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Mode
175 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Mode
176 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Mode
177 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Mode
178 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Mode
179 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Mode
180 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Mode
181 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Pers
182 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Sche
183 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Sema
184 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: JSON
185 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Thing
186 │ Active │ 75 │ 2.5.0 │ openHAB Core :: Bundles :: Thin
187 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Tran
188 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: UI
189 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: UI I
190 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Voice
191 │ Active │ 80 │ 2.5.2 │ openHAB UI :: Bundles :: Dashbo
200 │ Active │ 80 │ 1.4.0 │ ThreeTen-Extra
201 │ Active │ 80 │ 1.0.3 │ Units of Measurement Common Lib
202 │ Active │ 80 │ 1.0.10 │ Units of Measurement Implementa
203 │ Active │ 80 │ 2.5.2 │ openHAB Add-ons :: Bundles :: I
204 │ Active │ 80 │ 2.5.2 │ openHAB Add-ons :: Bundles :: I
205 │ Active │ 80 │ 2.5.2 │ openHAB UI :: Bundles :: Basic
206 │ Active │ 80 │ 2.5.2 │ openHAB UI :: Bundles :: HABPan
207 │ Active │ 80 │ 2.5.2 │ openHAB UI :: Bundles :: HomeBu
208 │ Active │ 80 │ 2.5.2 │ openHAB UI :: Bundles :: Icon S
209 │ Active │ 80 │ 2.5.2 │ openHAB UI :: Bundles :: Paper
214 │ Active │ 80 │ 2.5.2 │ JUPnP Library
215 │ Active │ 80 │ 2.5.2 │ openHAB Add-ons :: Bundles :: D
216 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: Conf
217 │ Active │ 80 │ 2.5.0 │ openHAB Core :: Bundles :: UPnP
219 │ Active │ 80 │ 1.0.0 │ IO.Socket Engine Client
220 │ Active │ 80 │ 1.0.0 │ IO.Socket Socket Client
221 │ Active │ 80 │ 20180813.0.0 │ JSON in Java
222 │ Active │ 80 │ 3.8.1.1 │ Apache ServiceMix :: Bundles ::
223 │ Active │ 80 │ 1.13.0.1 │ Apache ServiceMix :: Bundles ::
224 │ Active │ 80 │ 2.5.2 │ openHAB Add-ons :: Bundles :: I
235 │ Active │ 80 │ 2.5.2 │ openHAB Add-ons :: Bundles :: W
236 │ Active │ 80 │ 2.5.2 │ openHAB Add-ons :: Bundles :: B
237 │ Active │ 80 │ 3.3.0 │ Commons Net
238 │ Active │ 80 │ 2.5.2 │ openHAB Add-ons :: Bundles :: S
248 │ Active │ 80 │ 2.5.2 │ openHAB Add-ons :: Bundles :: h
258 │ Active │ 80 │ 4.1.42.Final │ Netty/Buffer
259 │ Active │ 80 │ 4.1.42.Final │ Netty/Codec
260 │ Active │ 80 │ 4.1.42.Final │ Netty/Codec/HTTP
261 │ Active │ 80 │ 4.1.42.Final │ Netty/Common
262 │ Active │ 80 │ 4.1.42.Final │ Netty/Handler
263 │ Active │ 80 │ 4.1.42.Final │ Netty/Resolver
264 │ Active │ 80 │ 4.1.42.Final │ Netty/Transport
265 │ Active │ 80 │ 1.0.4 │ JSR 353 (JSON Processing) Defau
266 │ Active │ 80 │ 2.5.2 │ openHAB Add-ons :: Bundles :: I

Many Thanks in advance!

it looks like homekit cannot bind to the port.

what is in your services/homekit.cfg ? the default port there should be 9124

please also check that port 9124 is free. so, shutdown openhab and check the port usage, depending on your OS it can be done with lsof or netstat

please also paste the log messages you have in the log file before the message with error.

Hello Yfre,
please see the fully steps & detail informations:

1. Delete pairing from the IOS home app
2. openhab-cli console ->>
smarthome:homekit clearPairings
–> Cleared homekit pairings
smarthome:homekit allowUnauthenticated true
–> Enabled unauthenticated homekit access
3. Uninstall Homekit Integration (WEB)
4. Raspberry openhabian@openhab
sudo find / -name homekit*
–> delete all homekit* data
sudo rm -r /var/lib/openhab2/jsondb/homekit.json
sudo rm -r /var/lib/openhab2/jsondb/backup/*
sudo rm -r /var/lib/openhab2/config/org/openhab/homekit.config
sudo rm -r /etc/openhab2/services/homekit.cfg
sudo rm -r /srv/openhab2-userdata/config/org/openhab/homekit.config
sudo rm -r /srv/openhab2-userdata/jsondb/homekit.json
sudo rm -r /srv/openhab2-conf/services/homekit.cfg

**5. openhab-cli console ->> trace the logs**
	log:set TRACE com.beowulfe.hap


**6. Restart openhabian**
	sudo shutdown -r now
**7. Install & configure Homekit Integration (WEB)**

**8. openhab-cli console ->> check to see if /var/lib/openhab2/jsondb/homekit.json has the mac address entry**
	sudo nano /var/lib/openhab2/jsondb/homekit.json
**9. Config of homekit.cfg --> nof existing**
	sudo find / -name homekit.cfg
**10. Create homekit.cfg**
	sudo nano /srv/openhab2-conf/services/homekit.cfg
		org.openhab.homekit:port=9124
		org.openhab.homekit:pin=031-45-154
		org.openhab.homekit:useFahrenheitTemperature=false
		org.openhab.homekit:thermostatCoolMode=MANU_MODE
		org.openhab.homekit:thermostatHeatMode=MANU_MODE
		org.openhab.homekit:thermostatAutoMode=AUTO_MODE
		org.openhab.homekit:thermostatOffMode=AUTO_MODE
		org.openhab.homekit:networkInterface=192.168.0.81
		org.openhab.homekit:name=SN_openHAB
		org.openhab.homekit:minimumTemperature=-50
		org.openhab.homekit:maximumTemperature=100
**11. Restart openhabian**
	sudo shutdown -r now
**12. openhab-cli console ->> trace the logs**
	log:set TRACE com.beowulfe.hap

**13. Create pairing from the IOS home app** with Message: 
              **---> This accessory is not supported by the home app**



**14. Log**
tail -f /var/log/openhab2/openhab.log /var/log/openhab2/events.log

2020-03-06 13:17:21.728 [hingStatusInfoChangedEvent] - 'wifiled:wifiled:C82B96407ABE' changed from ONLINE to UNINITIALIZED
2020-03-06 13:17:21.742 [hingStatusInfoChangedEvent] - 'wifiled:wifiled:C82B96407ABE' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-06 13:17:21.811 [hingStatusInfoChangedEvent] - 'deconz:deconz:homeserver' changed from OFFLINE (COMMUNICATION_ERROR): org.eclipse.jetty.io.EofException to UNINITIALIZED
2020-03-06 13:17:21.827 [hingStatusInfoChangedEvent] - 'deconz:deconz:homeserver' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-06 13:17:22.260 [temChannelLinkRemovedEvent] - Link 'SNBose_Mute => bosesoundtouch:300:9884E3B7F1D7:mute' has been removed.
2020-03-06 13:17:22.262 [temChannelLinkRemovedEvent] - Link 'W_Schranklicht_Farbe => hue:0210:00212E054E86:2:color' has been removed.
2020-03-06 13:17:22.263 [temChannelLinkRemovedEvent] - Link 'SamsungTV_StummSchalten => samsungtv:tv:31140144_7b09_41a1_992d_a3f98708a6d9:mute' has been removed.
2020-03-06 13:17:22.264 [temChannelLinkRemovedEvent] - Link 'TV_Ledwand_Color => wifiled:wifiled:C82B96407ABE:color' has been removed.
2020-03-06 13:17:22.265 [temChannelLinkRemovedEvent] - Link 'SNBose_Volume => bosesoundtouch:300:9884E3B7F1D7:volume' has been removed.
2020-03-06 13:17:22.266 [temChannelLinkRemovedEvent] - Link 'SamsungTV_LautstRke => samsungtv:tv:31140144_7b09_41a1_992d_a3f98708a6d9:volume' has been removed.
2020-03-06 13:17:22.267 [temChannelLinkRemovedEvent] - Link 'W_Bodenlampe_Farbtemperatur => hue:0210:00212E054E86:5:color_temperature' has been removed.
2020-03-06 13:17:22.268 [temChannelLinkRemovedEvent] - Link 'TV_Ledwand_Power => wifiled:wifiled:C82B96407ABE:power' has been removed.
2020-03-06 13:17:22.269 [temChannelLinkRemovedEvent] - Link 'SamsungTV_Power => samsungtv:tv:31140144_7b09_41a1_992d_a3f98708a6d9:power' has been removed.
2020-03-06 13:17:22.272 [temChannelLinkRemovedEvent] - Link 'TV_Ledwand_Wei => wifiled:wifiled:C82B96407ABE:white' has been removed.
2020-03-06 13:17:22.284 [temChannelLinkRemovedEvent] - Link 'W_Stehlampe_Farbe => hue:0210:00212E054E86:4:color' has been removed.
2020-03-06 13:17:22.285 [temChannelLinkRemovedEvent] - Link 'W_Schranklicht_Power => hue:0210:00212E054E86:2:color' has been removed.
2020-03-06 13:17:22.286 [temChannelLinkRemovedEvent] - Link 'W_Stehlampe_Power => hue:0210:00212E054E86:4:color' has been removed.
2020-03-06 13:17:22.288 [temChannelLinkRemovedEvent] - Link 'W_Stehlampe_Farbtemperatur => hue:0210:00212E054E86:4:color_temperature' has been removed.
2020-03-06 13:17:22.289 [temChannelLinkRemovedEvent] - Link 'SNBose_Power => bosesoundtouch:300:9884E3B7F1D7:power' has been removed.
2020-03-06 13:17:22.291 [temChannelLinkRemovedEvent] - Link 'W_Zwischenstecker1_Schalter => hue:0010:00212E054E86:3:switch' has been removed.
2020-03-06 13:17:22.292 [temChannelLinkRemovedEvent] - Link 'W_Bodenlampe_Power => hue:0210:00212E054E86:5:color' has been removed.
2020-03-06 13:17:22.293 [temChannelLinkRemovedEvent] - Link 'W_Schranklicht_Farbtemperatur => hue:0210:00212E054E86:2:color_temperature' has been removed.
2020-03-06 13:17:22.295 [temChannelLinkRemovedEvent] - Link 'W_Bodenlampe_Farbe => hue:0210:00212E054E86:5:color' has been removed.
==> /var/log/openhab2/openhab.log <==
2020-03-06 13:18:00.501 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Time zone set to 'Europe/Berlin'.
2020-03-06 13:18:00.537 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Location set to '51.094920116298425,6.902150497825202'.
2020-03-06 13:18:00.542 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Locale set to 'de_DE'.
2020-03-06 13:18:06.682 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'deconz.things'
2020-03-06 13:18:24.746 [INFO ] [thome.model.lsp.internal.ModelServer] - Started Language Server Protocol (LSP) service on port 5007
2020-03-06 13:18:26.004 [INFO ] [.dashboard.internal.DashboardService] - Started Dashboard at http://192.168.0.81:8080
2020-03-06 13:18:26.006 [INFO ] [.dashboard.internal.DashboardService] - Started Dashboard at https://192.168.0.81:8443
2020-03-06 13:18:26.662 [INFO ] [panel.internal.HABPanelDashboardTile] - Started HABPanel at /habpanel
2020-03-06 13:18:26.751 [INFO ] [ebuilder.internal.HomeBuilderServlet] - Started Home Builder at /homebuilder
2020-03-06 13:18:26.866 [INFO ] [openhab.ui.paper.internal.PaperUIApp] - Started Paper UI at /paperui
==> /var/log/openhab2/events.log <==
2020-03-06 13:18:28.083 [hingStatusInfoChangedEvent] - 'wifiled:wifiled:C82B96407ABE' changed from UNINITIALIZED to INITIALIZING
2020-03-06 13:18:28.455 [hingStatusInfoChangedEvent] - 'wifiled:wifiled:C82B96407ABE' changed from INITIALIZING to ONLINE
2020-03-06 13:18:28.473 [hingStatusInfoChangedEvent] - 'deconz:deconz:homeserver' changed from UNINITIALIZED to INITIALIZING
2020-03-06 13:18:28.494 [hingStatusInfoChangedEvent] - 'deconz:deconz:homeserver' changed from INITIALIZING to OFFLINE (CONFIGURATION_PENDING): Requesting API Key
2020-03-06 13:18:28.570 [hingStatusInfoChangedEvent] - 'deconz:deconz:homeserver' changed from OFFLINE (CONFIGURATION_PENDING): Requesting API Key to OFFLINE (CONFIGURATION_PENDING): Allow authentification for 3rd party apps. Trying again in 10 seconds
2020-03-06 13:18:28.748 [hingStatusInfoChangedEvent] - 'bosesoundtouch:300:9884E3B7F1D7' changed from UNINITIALIZED to INITIALIZING
2020-03-06 13:18:28.751 [vent.ItemStateChangedEvent] - TV_Ledwand_Power changed from NULL to OFF
2020-03-06 13:18:28.754 [vent.ItemStateChangedEvent] - TV_Ledwand_Color changed from NULL to 240.000007152557373046875000,2.04081628471612930297851562500,19.21568661928176879882812500
2020-03-06 13:18:28.755 [vent.ItemStateChangedEvent] - TV_Ledwand_Wei changed from NULL to 0.000
2020-03-06 13:18:28.863 [hingStatusInfoChangedEvent] - 'samsungtv:tv:31140144_7b09_41a1_992d_a3f98708a6d9' changed from UNINITIALIZED to INITIALIZING
2020-03-06 13:18:28.884 [hingStatusInfoChangedEvent] - 'samsungtv:tv:31140144_7b09_41a1_992d_a3f98708a6d9' changed from INITIALIZING to UNKNOWN
2020-03-06 13:18:28.892 [vent.ItemStateChangedEvent] - SamsungTV_Power changed from NULL to OFF
2020-03-06 13:18:28.903 [hingStatusInfoChangedEvent] - 'samsungtv:tv:31140144_7b09_41a1_992d_a3f98708a6d9' changed from UNKNOWN to ONLINE
2020-03-06 13:18:28.907 [vent.ItemStateChangedEvent] - SamsungTV_Power changed from OFF to ON
==> /var/log/openhab2/openhab.log <==
2020-03-06 13:18:28.914 [INFO ] [rnal.service.RemoteControllerService] - Using None interface
2020-03-06 13:18:28.927 [INFO ] [rnal.service.RemoteControllerService] - Using None interface
==> /var/log/openhab2/events.log <==
2020-03-06 13:18:28.941 [vent.ItemStateChangedEvent] - SamsungTV_Power changed from ON to OFF
2020-03-06 13:18:28.965 [hingStatusInfoChangedEvent] - 'bosesoundtouch:300:9884E3B7F1D7' changed from INITIALIZING to ONLINE
2020-03-06 13:18:29.043 [vent.ItemStateChangedEvent] - SamsungTV_LautstRke changed from NULL to 0
2020-03-06 13:18:29.065 [vent.ItemStateChangedEvent] - SamsungTV_StummSchalten changed from NULL to OFF
2020-03-06 13:18:29.113 [vent.ItemStateChangedEvent] - SNBose_Volume changed from NULL to 30
==> /var/log/openhab2/openhab.log <==
2020-03-06 13:18:29.405 [INFO ] [.samsungtv.internal.WakeOnLanUtility] - MAC address of host 192.168.0.150 is 7c:64:56:4f:97:ff
==> /var/log/openhab2/events.log <==
2020-03-06 13:18:29.467 [vent.ItemStateChangedEvent] - SamsungTV_Power changed from OFF to ON
==> /var/log/openhab2/openhab.log <==
2020-03-06 13:18:29.476 [INFO ] [rnal.service.RemoteControllerService] - Using SecureWebSocket interface
==> /var/log/openhab2/events.log <==
2020-03-06 13:18:29.582 [vent.ItemStateChangedEvent] - SNBose_Power changed from NULL to OFF
2020-03-06 13:18:29.668 [hingStatusInfoChangedEvent] - 'hue:0210:00212E054E86:4' changed from UNINITIALIZED to UNINITIALIZED (BRIDGE_UNINITIALIZED)
2020-03-06 13:18:29.672 [hingStatusInfoChangedEvent] - 'hue:0210:00212E054E86:5' changed from UNINITIALIZED to UNINITIALIZED (BRIDGE_UNINITIALIZED)
2020-03-06 13:18:29.677 [hingStatusInfoChangedEvent] - 'hue:0210:00212E054E86:2' changed from UNINITIALIZED to UNINITIALIZED (BRIDGE_UNINITIALIZED)
2020-03-06 13:18:29.679 [hingStatusInfoChangedEvent] - 'hue:0010:00212E054E86:3' changed from UNINITIALIZED to UNINITIALIZED (BRIDGE_UNINITIALIZED)
2020-03-06 13:18:29.716 [hingStatusInfoChangedEvent] - 'hue:bridge:00212E054E86' changed from UNINITIALIZED to INITIALIZING
2020-03-06 13:18:30.373 [hingStatusInfoChangedEvent] - 'hue:bridge:00212E054E86' changed from INITIALIZING to ONLINE
2020-03-06 13:18:30.411 [hingStatusInfoChangedEvent] - 'hue:0210:00212E054E86:4' changed from UNINITIALIZED (BRIDGE_UNINITIALIZED) to INITIALIZING
2020-03-06 13:18:30.414 [hingStatusInfoChangedEvent] - 'hue:0210:00212E054E86:2' changed from UNINITIALIZED (BRIDGE_UNINITIALIZED) to INITIALIZING
2020-03-06 13:18:30.415 [hingStatusInfoChangedEvent] - 'hue:0210:00212E054E86:5' changed from UNINITIALIZED (BRIDGE_UNINITIALIZED) to INITIALIZING
2020-03-06 13:18:30.417 [hingStatusInfoChangedEvent] - 'hue:0010:00212E054E86:3' changed from UNINITIALIZED (BRIDGE_UNINITIALIZED) to INITIALIZING
2020-03-06 13:18:30.431 [hingStatusInfoChangedEvent] - 'hue:0210:00212E054E86:5' changed from INITIALIZING to ONLINE
2020-03-06 13:18:30.441 [hingStatusInfoChangedEvent] - 'hue:0010:00212E054E86:3' changed from INITIALIZING to ONLINE
2020-03-06 13:18:30.447 [hingStatusInfoChangedEvent] - 'hue:0210:00212E054E86:2' changed from INITIALIZING to ONLINE
2020-03-06 13:18:30.452 [hingStatusInfoChangedEvent] - 'hue:0210:00212E054E86:4' changed from INITIALIZING to ONLINE
2020-03-06 13:18:30.802 [me.event.ThingUpdatedEvent] - Thing 'hue:0210:00212E054E86:2' has been updated.
2020-03-06 13:18:30.813 [vent.ItemStateChangedEvent] - W_Schranklicht_Farbe changed from NULL to 228,31,0
2020-03-06 13:18:30.815 [vent.ItemStateChangedEvent] - W_Schranklicht_Power changed from NULL to OFF
2020-03-06 13:18:30.816 [vent.ItemStateChangedEvent] - W_Schranklicht_Farbtemperatur changed from NULL to 0
2020-03-06 13:18:30.821 [me.event.ThingUpdatedEvent] - Thing 'hue:0010:00212E054E86:3' has been updated.
2020-03-06 13:18:30.823 [vent.ItemStateChangedEvent] - W_Zwischenstecker1_Schalter changed from NULL to ON
2020-03-06 13:18:30.847 [me.event.ThingUpdatedEvent] - Thing 'hue:0210:00212E054E86:4' has been updated.
2020-03-06 13:18:30.854 [vent.ItemStateChangedEvent] - W_Stehlampe_Power changed from NULL to OFF
2020-03-06 13:18:30.864 [vent.ItemStateChangedEvent] - W_Stehlampe_Farbe changed from NULL to 0,0,0
2020-03-06 13:18:30.898 [me.event.ThingUpdatedEvent] - Thing 'hue:0210:00212E054E86:5' has been updated.
2020-03-06 13:18:30.901 [vent.ItemStateChangedEvent] - W_Bodenlampe_Power changed from NULL to OFF
2020-03-06 13:18:30.903 [vent.ItemStateChangedEvent] - W_Bodenlampe_Farbe changed from NULL to 46,56,0
2020-03-06 13:18:30.905 [vent.ItemStateChangedEvent] - W_Bodenlampe_Farbtemperatur changed from NULL to 61
==> /var/log/openhab2/openhab.log <==
2020-03-06 13:18:36.540 [INFO ] [io.openhabcloud.internal.CloudClient] - Connected to the openHAB Cloud service (UUID = 5788fbbf-c36d-4e53-96a4-5648e1c4d04e, base URL = http://localhost:8080)
==> /var/log/openhab2/events.log <==
2020-03-06 13:18:38.574 [hingStatusInfoChangedEvent] - 'deconz:deconz:homeserver' changed from OFFLINE (CONFIGURATION_PENDING): Allow authentification for 3rd party apps. Trying again in 10 seconds to OFFLINE (CONFIGURATION_PENDING): Requesting API Key
2020-03-06 13:18:38.591 [hingStatusInfoChangedEvent] - 'deconz:deconz:homeserver' changed from OFFLINE (CONFIGURATION_PENDING): Requesting API Key to OFFLINE (COMMUNICATION_ERROR): org.eclipse.jetty.io.EofException
==> /var/log/openhab2/openhab.log <==
2020-03-06 13:18:38.590 [WARN ] [internal.handler.DeconzBridgeHandler] - Authorisation failed
java.util.concurrent.CompletionException: org.eclipse.jetty.io.EofException
at java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:292) ~[?:1.8.0_222]
at java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:308) ~[?:1.8.0_222]
at java.util.concurrent.CompletableFuture.uniAccept(CompletableFuture.java:647) ~[?:1.8.0_222]
at java.util.concurrent.CompletableFuture$UniAccept.tryFire(CompletableFuture.java:632) ~[?:1.8.0_222]
at java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:474) ~[?:1.8.0_222]
at java.util.concurrent.CompletableFuture.completeExceptionally(CompletableFuture.java:1977) ~[?:1.8.0_222]
at org.openhab.binding.deconz.internal.netutils.AsyncHttpClient$1.onComplete(AsyncHttpClient.java:109) ~[?:?]
at org.eclipse.jetty.client.ResponseNotifier.notifyComplete(ResponseNotifier.java:198) ~[?:?]
at org.eclipse.jetty.client.ResponseNotifier.notifyComplete(ResponseNotifier.java:190) ~[?:?]
at org.eclipse.jetty.client.HttpReceiver.terminateResponse(HttpReceiver.java:444) ~[?:?]
at org.eclipse.jetty.client.HttpReceiver.abort(HttpReceiver.java:527) ~[?:?]
at org.eclipse.jetty.client.HttpChannel.abortResponse(HttpChannel.java:156) ~[?:?]
at org.eclipse.jetty.client.HttpSender.terminateRequest(HttpSender.java:394) ~[?:?]
at org.eclipse.jetty.client.HttpSender.abort(HttpSender.java:571) ~[?:?]
at org.eclipse.jetty.client.HttpSender.lambda$executeAbort$0(HttpSender.java:358) ~[?:?]
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:782) [bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:918) [bundleFile:9.4.20.v20190813]
at java.lang.Thread.run(Thread.java:748) [?:1.8.0_222]
Caused by: org.eclipse.jetty.io.EofException
at org.eclipse.jetty.io.ChannelEndPoint.flush(ChannelEndPoint.java:283) ~[?:?]
at org.eclipse.jetty.io.WriteFlusher.flush(WriteFlusher.java:422) ~[?:?]
at org.eclipse.jetty.io.WriteFlusher.write(WriteFlusher.java:277) ~[?:?]
at org.eclipse.jetty.io.AbstractEndPoint.write(AbstractEndPoint.java:381) ~[?:?]
at org.eclipse.jetty.client.http.HttpSenderOverHTTP$HeadersCallback.process(HttpSenderOverHTTP.java:249) ~[?:?]
at org.eclipse.jetty.util.IteratingCallback.processing(IteratingCallback.java:241) ~[?:?]
at org.eclipse.jetty.util.IteratingCallback.iterate(IteratingCallback.java:223) ~[?:?]
at org.eclipse.jetty.client.http.HttpSenderOverHTTP.sendHeaders(HttpSenderOverHTTP.java:62) ~[?:?]
at org.eclipse.jetty.client.HttpSender.send(HttpSender.java:212) ~[?:?]
at org.eclipse.jetty.client.http.HttpChannelOverHTTP.send(HttpChannelOverHTTP.java:85) ~[?:?]
at org.eclipse.jetty.client.HttpChannel.send(HttpChannel.java:128) ~[?:?]
at org.eclipse.jetty.client.HttpConnection.send(HttpConnection.java:201) ~[?:?]
at org.eclipse.jetty.client.http.HttpConnectionOverHTTP$Delegate.send(HttpConnectionOverHTTP.java:252) ~[?:?]
at org.eclipse.jetty.client.http.HttpConnectionOverHTTP.send(HttpConnectionOverHTTP.java:121) ~[?:?]
at org.eclipse.jetty.client.http.HttpDestinationOverHTTP.send(HttpDestinationOverHTTP.java:38) ~[?:?]
at org.eclipse.jetty.client.HttpDestination.process(HttpDestination.java:346) ~[?:?]
at org.eclipse.jetty.client.HttpDestination.process(HttpDestination.java:304) ~[?:?]
at org.eclipse.jetty.client.HttpDestination.send(HttpDestination.java:294) ~[?:?]
at org.eclipse.jetty.client.HttpDestination.send(HttpDestination.java:269) ~[?:?]
at org.eclipse.jetty.client.HttpDestination.send(HttpDestination.java:246) ~[?:?]
at org.eclipse.jetty.client.HttpClient.send(HttpClient.java:580) ~[?:?]
at org.eclipse.jetty.client.HttpRequest.send(HttpRequest.java:728) ~[?:?]
at org.eclipse.jetty.client.HttpRequest.send(HttpRequest.java:720) ~[?:?]
at org.openhab.binding.deconz.internal.netutils.AsyncHttpClient.doNetwork(AsyncHttpClient.java:103) ~[?:?]
at org.openhab.binding.deconz.internal.netutils.AsyncHttpClient.post(AsyncHttpClient.java:52) ~[?:?]
at org.openhab.binding.deconz.internal.handler.DeconzBridgeHandler.requestApiKey(DeconzBridgeHandler.java:238) ~[?:?]
at org.openhab.binding.deconz.internal.handler.DeconzBridgeHandler.lambda$0(DeconzBridgeHandler.java:122) ~[?:?]
at java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[?:1.8.0_222]
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180) ~[?:1.8.0_222]
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) ~[?:1.8.0_222]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) ~[?:1.8.0_222]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) ~[?:1.8.0_222]
... 1 more
Caused by: java.nio.channels.ClosedByInterruptException
at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:202) ~[?:1.8.0_222]
at sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:511) ~[?:1.8.0_222]
at org.eclipse.jetty.io.ChannelEndPoint.flush(ChannelEndPoint.java:263) ~[?:?]
at org.eclipse.jetty.io.WriteFlusher.flush(WriteFlusher.java:422) ~[?:?]
at org.eclipse.jetty.io.WriteFlusher.write(WriteFlusher.java:277) ~[?:?]
at org.eclipse.jetty.io.AbstractEndPoint.write(AbstractEndPoint.java:381) ~[?:?]
at org.eclipse.jetty.client.http.HttpSenderOverHTTP$HeadersCallback.process(HttpSenderOverHTTP.java:249) ~[?:?]
at org.eclipse.jetty.util.IteratingCallback.processing(IteratingCallback.java:241) ~[?:?]
at org.eclipse.jetty.util.IteratingCallback.iterate(IteratingCallback.java:223) ~[?:?]
at org.eclipse.jetty.client.http.HttpSenderOverHTTP.sendHeaders(HttpSenderOverHTTP.java:62) ~[?:?]
at org.eclipse.jetty.client.HttpSender.send(HttpSender.java:212) ~[?:?]
at org.eclipse.jetty.client.http.HttpChannelOverHTTP.send(HttpChannelOverHTTP.java:85) ~[?:?]
at org.eclipse.jetty.client.HttpChannel.send(HttpChannel.java:128) ~[?:?]
at org.eclipse.jetty.client.HttpConnection.send(HttpConnection.java:201) ~[?:?]
at org.eclipse.jetty.client.http.HttpConnectionOverHTTP$Delegate.send(HttpConnectionOverHTTP.java:252) ~[?:?]
at org.eclipse.jetty.client.http.HttpConnectionOverHTTP.send(HttpConnectionOverHTTP.java:121) ~[?:?]
at org.eclipse.jetty.client.http.HttpDestinationOverHTTP.send(HttpDestinationOverHTTP.java:38) ~[?:?]
at org.eclipse.jetty.client.HttpDestination.process(HttpDestination.java:346) ~[?:?]
at org.eclipse.jetty.client.HttpDestination.process(HttpDestination.java:304) ~[?:?]
at org.eclipse.jetty.client.HttpDestination.send(HttpDestination.java:294) ~[?:?]
at org.eclipse.jetty.client.HttpDestination.send(HttpDestination.java:269) ~[?:?]
at org.eclipse.jetty.client.HttpDestination.send(HttpDestination.java:246) ~[?:?]
at org.eclipse.jetty.client.HttpClient.send(HttpClient.java:580) ~[?:?]
at org.eclipse.jetty.client.HttpRequest.send(HttpRequest.java:728) ~[?:?]
at org.eclipse.jetty.client.HttpRequest.send(HttpRequest.java:720) ~[?:?]
at org.openhab.binding.deconz.internal.netutils.AsyncHttpClient.doNetwork(AsyncHttpClient.java:103) ~[?:?]
at org.openhab.binding.deconz.internal.netutils.AsyncHttpClient.post(AsyncHttpClient.java:52) ~[?:?]
at org.openhab.binding.deconz.internal.handler.DeconzBridgeHandler.requestApiKey(DeconzBridgeHandler.java:238) ~[?:?]
at org.openhab.binding.deconz.internal.handler.DeconzBridgeHandler.lambda$0(DeconzBridgeHandler.java:122) ~[?:?]
at java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[?:1.8.0_222]
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180) ~[?:1.8.0_222]
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) ~[?:1.8.0_222]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) ~[?:1.8.0_222]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) ~[?:1.8.0_222]
... 1 more

Many Thanks in advance,
Sergo

Once I also had problem with Homekit. Whats worked for me is:

  1. Stop openhab2 service
  2. Change port in homekit config to 9126
  3. Clear cache of openhab this way:
    sudo rm -rf /var/lib/openhab2/cache/*
    sudo rm -rf /var/lib/openhab2/tmp/*
  4. Start openhab2 and try to pair again.

Hello Jar,

after change the port to 9126 no openHAB can be found in my iphone :frowning:

Sergo,

could you please run it with
log:set TRACE io.github.hapjava

Hi Eugen, here the log information:

2020-03-06 16:17:25.315 [temChannelLinkRemovedEvent] - Link ‘W_Schranklicht_Power => hue:0210:00212E054E86:2:color’ has been removed.

2020-03-06 16:17:25.316 [temChannelLinkRemovedEvent] - Link ‘W_Stehlampe_Power => hue:0210:00212E054E86:4:color’ has been removed.

2020-03-06 16:17:25.317 [temChannelLinkRemovedEvent] - Link ‘W_Stehlampe_Farbtemperatur => hue:0210:00212E054E86:4:color_temperature’ has been removed.

2020-03-06 16:17:25.319 [temChannelLinkRemovedEvent] - Link ‘SNBose_Power => bosesoundtouch:300:9884E3B7F1D7:power’ has been removed.

2020-03-06 16:17:25.320 [temChannelLinkRemovedEvent] - Link ‘W_Zwischenstecker1_Schalter => hue:0010:00212E054E86:3:switch’ has been removed.

2020-03-06 16:17:25.321 [temChannelLinkRemovedEvent] - Link ‘W_Bodenlampe_Power => hue:0210:00212E054E86:5:color’ has been removed.

2020-03-06 16:17:25.322 [temChannelLinkRemovedEvent] - Link ‘W_Schranklicht_Farbtemperatur => hue:0210:00212E054E86:2:color_temperature’ has been removed.

2020-03-06 16:17:25.323 [temChannelLinkRemovedEvent] - Link ‘W_Bodenlampe_Farbe => hue:0210:00212E054E86:5:color’ has been removed.

==> /var/log/openhab2/openhab.log <==

2020-03-06 16:17:43.468 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Time zone set to ‘Europe/Berlin’.

2020-03-06 16:17:43.494 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Location set to ‘51.094920116298425,6.902150497825202’.

2020-03-06 16:17:43.497 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Locale set to ‘de_DE’.

2020-03-06 16:17:48.885 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model ‘deconz.things’

2020-03-06 16:17:50.935 [INFO ] [thome.model.lsp.internal.ModelServer] - Started Language Server Protocol (LSP) service on port 5007

2020-03-06 16:17:52.517 [INFO ] [.dashboard.internal.DashboardService] - Started Dashboard at http://192.168.0.81:8080

2020-03-06 16:17:52.519 [INFO ] [.dashboard.internal.DashboardService] - Started Dashboard at https://192.168.0.81:8443

==> /var/log/openhab2/events.log <==

2020-03-06 16:17:53.362 [hingStatusInfoChangedEvent] - ‘hue:0210:00212E054E86:4’ changed from UNINITIALIZED to UNINITIALIZED (BRIDGE_UNINITIALIZED)

2020-03-06 16:17:53.365 [hingStatusInfoChangedEvent] - ‘hue:0210:00212E054E86:5’ changed from UNINITIALIZED to UNINITIALIZED (BRIDGE_UNINITIALIZED)

2020-03-06 16:17:53.378 [hingStatusInfoChangedEvent] - ‘hue:0210:00212E054E86:2’ changed from UNINITIALIZED to UNINITIALIZED (BRIDGE_UNINITIALIZED)

2020-03-06 16:17:53.385 [hingStatusInfoChangedEvent] - ‘hue:0010:00212E054E86:3’ changed from UNINITIALIZED to UNINITIALIZED (BRIDGE_UNINITIALIZED)

2020-03-06 16:17:53.514 [hingStatusInfoChangedEvent] - ‘hue:bridge:00212E054E86’ changed from UNINITIALIZED to INITIALIZING

2020-03-06 16:17:53.560 [hingStatusInfoChangedEvent] - ‘bosesoundtouch:300:9884E3B7F1D7’ changed from UNINITIALIZED to INITIALIZING

2020-03-06 16:17:53.709 [hingStatusInfoChangedEvent] - ‘wifiled:wifiled:C82B96407ABE’ changed from UNINITIALIZED to INITIALIZING

2020-03-06 16:17:53.905 [hingStatusInfoChangedEvent] - ‘wifiled:wifiled:C82B96407ABE’ changed from INITIALIZING to ONLINE

2020-03-06 16:17:53.929 [hingStatusInfoChangedEvent] - ‘deconz:deconz:homeserver’ changed from UNINITIALIZED to INITIALIZING

2020-03-06 16:17:53.950 [hingStatusInfoChangedEvent] - ‘deconz:deconz:homeserver’ changed from INITIALIZING to OFFLINE (CONFIGURATION_PENDING): Requesting API Key

2020-03-06 16:17:53.978 [hingStatusInfoChangedEvent] - ‘deconz:deconz:homeserver’ changed from OFFLINE (CONFIGURATION_PENDING): Requesting API Key to OFFLINE (CONFIGURATION_PENDING): Allow authentification for 3rd party apps. Trying again in 10 seconds

2020-03-06 16:17:54.002 [hingStatusInfoChangedEvent] - ‘bosesoundtouch:300:9884E3B7F1D7’ changed from INITIALIZING to ONLINE

2020-03-06 16:17:54.149 [vent.ItemStateChangedEvent] - SNBose_Volume changed from NULL to 43

2020-03-06 16:17:54.174 [vent.ItemStateChangedEvent] - TV_Ledwand_Power changed from NULL to OFF

2020-03-06 16:17:54.180 [vent.ItemStateChangedEvent] - TV_Ledwand_Color changed from NULL to 240.000007152557373046875000,2.04081628471612930297851562500,19.21568661928176879882812500

2020-03-06 16:17:54.182 [vent.ItemStateChangedEvent] - TV_Ledwand_Wei changed from NULL to 0.000

2020-03-06 16:17:54.200 [hingStatusInfoChangedEvent] - ‘samsungtv:tv:31140144_7b09_41a1_992d_a3f98708a6d9’ changed from UNINITIALIZED to INITIALIZING

2020-03-06 16:17:54.211 [hingStatusInfoChangedEvent] - ‘samsungtv:tv:31140144_7b09_41a1_992d_a3f98708a6d9’ changed from INITIALIZING to UNKNOWN

2020-03-06 16:17:54.220 [vent.ItemStateChangedEvent] - SamsungTV_Power changed from NULL to OFF

==> /var/log/openhab2/openhab.log <==

2020-03-06 16:17:54.237 [INFO ] [rnal.service.RemoteControllerService] - Using None interface

==> /var/log/openhab2/events.log <==

2020-03-06 16:17:54.311 [vent.ItemStateChangedEvent] - SNBose_Power changed from NULL to OFF

2020-03-06 16:17:54.337 [hingStatusInfoChangedEvent] - ‘hue:bridge:00212E054E86’ changed from INITIALIZING to ONLINE

2020-03-06 16:17:54.379 [hingStatusInfoChangedEvent] - ‘hue:0010:00212E054E86:3’ changed from UNINITIALIZED (BRIDGE_UNINITIALIZED) to INITIALIZING

2020-03-06 16:17:54.381 [hingStatusInfoChangedEvent] - ‘hue:0210:00212E054E86:5’ changed from UNINITIALIZED (BRIDGE_UNINITIALIZED) to INITIALIZING

2020-03-06 16:17:54.394 [hingStatusInfoChangedEvent] - ‘hue:0210:00212E054E86:4’ changed from UNINITIALIZED (BRIDGE_UNINITIALIZED) to INITIALIZING

2020-03-06 16:17:54.400 [hingStatusInfoChangedEvent] - ‘hue:0210:00212E054E86:2’ changed from UNINITIALIZED (BRIDGE_UNINITIALIZED) to INITIALIZING

2020-03-06 16:17:54.404 [hingStatusInfoChangedEvent] - ‘hue:0010:00212E054E86:3’ changed from INITIALIZING to ONLINE

2020-03-06 16:17:54.424 [hingStatusInfoChangedEvent] - ‘hue:0210:00212E054E86:4’ changed from INITIALIZING to ONLINE

2020-03-06 16:17:54.432 [hingStatusInfoChangedEvent] - ‘hue:0210:00212E054E86:2’ changed from INITIALIZING to ONLINE

2020-03-06 16:17:54.440 [hingStatusInfoChangedEvent] - ‘hue:0210:00212E054E86:5’ changed from INITIALIZING to ONLINE

2020-03-06 16:17:54.682 [me.event.ThingUpdatedEvent] - Thing ‘hue:0210:00212E054E86:2’ has been updated.

2020-03-06 16:17:54.689 [vent.ItemStateChangedEvent] - W_Schranklicht_Farbe changed from NULL to 228,31,100

2020-03-06 16:17:54.692 [vent.ItemStateChangedEvent] - W_Schranklicht_Power changed from NULL to ON

2020-03-06 16:17:54.694 [vent.ItemStateChangedEvent] - W_Schranklicht_Farbtemperatur changed from NULL to 0

2020-03-06 16:17:54.731 [me.event.ThingUpdatedEvent] - Thing ‘hue:0010:00212E054E86:3’ has been updated.

2020-03-06 16:17:54.735 [vent.ItemStateChangedEvent] - W_Zwischenstecker1_Schalter changed from NULL to ON

2020-03-06 16:17:54.774 [me.event.ThingUpdatedEvent] - Thing ‘hue:0210:00212E054E86:4’ has been updated.

2020-03-06 16:17:54.779 [vent.ItemStateChangedEvent] - W_Stehlampe_Power changed from NULL to ON

2020-03-06 16:17:54.780 [vent.ItemStateChangedEvent] - W_Stehlampe_Farbe changed from NULL to 0,0,100

2020-03-06 16:17:54.792 [me.event.ThingUpdatedEvent] - Thing ‘hue:0210:00212E054E86:5’ has been updated.

2020-03-06 16:17:54.797 [vent.ItemStateChangedEvent] - W_Bodenlampe_Power changed from NULL to OFF

2020-03-06 16:17:54.798 [vent.ItemStateChangedEvent] - W_Bodenlampe_Farbe changed from NULL to 46,56,0

2020-03-06 16:17:54.805 [vent.ItemStateChangedEvent] - W_Bodenlampe_Farbtemperatur changed from NULL to 61

==> /var/log/openhab2/openhab.log <==

2020-03-06 16:17:55.253 [INFO ] [panel.internal.HABPanelDashboardTile] - Started HABPanel at /habpanel

2020-03-06 16:17:55.358 [INFO ] [ebuilder.internal.HomeBuilderServlet] - Started Home Builder at /homebuilder

2020-03-06 16:17:55.529 [INFO ] [openhab.ui.paper.internal.PaperUIApp] - Started Paper UI at /paperui

2020-03-06 16:17:55.681 [INFO ] [io.openhabcloud.internal.CloudClient] - Connected to the openHAB Cloud service (UUID = 5788fbbf-c36d-4e53-96a4-5648e1c4d04e, base URL = http://localhost:8080)

==> /var/log/openhab2/events.log <==

2020-03-06 16:18:04.003 [hingStatusInfoChangedEvent] - ‘deconz:deconz:homeserver’ changed from OFFLINE (CONFIGURATION_PENDING): Allow authentification for 3rd party apps. Trying again in 10 seconds to OFFLINE (CONFIGURATION_PENDING): Requesting API Key

==> /var/log/openhab2/openhab.log <==

2020-03-06 16:18:04.012 [WARN ] [internal.handler.DeconzBridgeHandler] - Authorisation failed

java.util.concurrent.CompletionException: org.eclipse.jetty.io.EofException

at java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:292) ~[?:1.8.0_222]

at java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:308) ~[?:1.8.0_222]

at java.util.concurrent.CompletableFuture.uniAccept(CompletableFuture.java:647) ~[?:1.8.0_222]

at java.util.concurrent.CompletableFuture.uniAcceptStage(CompletableFuture.java:669) ~[?:1.8.0_222]

at java.util.concurrent.CompletableFuture.thenAccept(CompletableFuture.java:1997) ~[?:1.8.0_222]

at org.openhab.binding.deconz.internal.handler.DeconzBridgeHandler.requestApiKey(DeconzBridgeHandler.java:238) ~[?:?]

at org.openhab.binding.deconz.internal.handler.DeconzBridgeHandler.lambda$0(DeconzBridgeHandler.java:122) ~[?:?]

at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:1.8.0_222]

at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180) [?:1.8.0_222]

at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) [?:1.8.0_222]

at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_222]

at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_222]

at java.lang.Thread.run(Thread.java:748) [?:1.8.0_222]

Caused by: org.eclipse.jetty.io.EofException

at org.eclipse.jetty.io.ChannelEndPoint.flush(ChannelEndPoint.java:283) ~[?:?]

at org.eclipse.jetty.io.WriteFlusher.flush(WriteFlusher.java:422) ~[?:?]

at org.eclipse.jetty.io.WriteFlusher.write(WriteFlusher.java:277) ~[?:?]

at org.eclipse.jetty.io.AbstractEndPoint.write(AbstractEndPoint.java:381) ~[?:?]

at org.eclipse.jetty.client.http.HttpSenderOverHTTP$HeadersCallback.process(HttpSenderOverHTTP.java:249) ~[?:?]

at org.eclipse.jetty.util.IteratingCallback.processing(IteratingCallback.java:241) ~[?:?]

at org.eclipse.jetty.util.IteratingCallback.iterate(IteratingCallback.java:223) ~[?:?]

at org.eclipse.jetty.client.http.HttpSenderOverHTTP.sendHeaders(HttpSenderOverHTTP.java:62) ~[?:?]

at org.eclipse.jetty.client.HttpSender.send(HttpSender.java:212) ~[?:?]

at org.eclipse.jetty.client.http.HttpChannelOverHTTP.send(HttpChannelOverHTTP.java:85) ~[?:?]

at org.eclipse.jetty.client.HttpChannel.send(HttpChannel.java:128) ~[?:?]

at org.eclipse.jetty.client.HttpConnection.send(HttpConnection.java:201) ~[?:?]

at org.eclipse.jetty.client.http.HttpConnectionOverHTTP$Delegate.send(HttpConnectionOverHTTP.java:252) ~[?:?]

at org.eclipse.jetty.client.http.HttpConnectionOverHTTP.send(HttpConnectionOverHTTP.java:121) ~[?:?]

at org.eclipse.jetty.client.http.HttpDestinationOverHTTP.send(HttpDestinationOverHTTP.java:38) ~[?:?]

at org.eclipse.jetty.client.HttpDestination.process(HttpDestination.java:346) ~[?:?]

at org.eclipse.jetty.client.HttpDestination.process(HttpDestination.java:304) ~[?:?]

at org.eclipse.jetty.client.HttpDestination.send(HttpDestination.java:294) ~[?:?]

at org.eclipse.jetty.client.HttpDestination.send(HttpDestination.java:269) ~[?:?]

at org.eclipse.jetty.client.HttpDestination.send(HttpDestination.java:246) ~[?:?]

at org.eclipse.jetty.client.HttpClient.send(HttpClient.java:580) ~[?:?]

at org.eclipse.jetty.client.HttpRequest.send(HttpRequest.java:728) ~[?:?]

at org.eclipse.jetty.client.HttpRequest.send(HttpRequest.java:720) ~[?:?]

at org.openhab.binding.deconz.internal.netutils.AsyncHttpClient.doNetwork(AsyncHttpClient.java:103) ~[?:?]

at org.openhab.binding.deconz.internal.netutils.AsyncHttpClient.post(AsyncHttpClient.java:52) ~[?:?]

… 8 more

Caused by: java.nio.channels.ClosedByInterruptException

at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:202) ~[?:1.8.0_222]

at sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:511) ~[?:1.8.0_222]

at org.eclipse.jetty.io.ChannelEndPoint.flush(ChannelEndPoint.java:263) ~[?:?]

at org.eclipse.jetty.io.WriteFlusher.flush(WriteFlusher.java:422) ~[?:?]

at org.eclipse.jetty.io.WriteFlusher.write(WriteFlusher.java:277) ~[?:?]

at org.eclipse.jetty.io.AbstractEndPoint.write(AbstractEndPoint.java:381) ~[?:?]

at org.eclipse.jetty.client.http.HttpSenderOverHTTP$HeadersCallback.process(HttpSenderOverHTTP.java:249) ~[?:?]

at org.eclipse.jetty.util.IteratingCallback.processing(IteratingCallback.java:241) ~[?:?]

at org.eclipse.jetty.util.IteratingCallback.iterate(IteratingCallback.java:223) ~[?:?]

at org.eclipse.jetty.client.http.HttpSenderOverHTTP.sendHeaders(HttpSenderOverHTTP.java:62) ~[?:?]

at org.eclipse.jetty.client.HttpSender.send(HttpSender.java:212) ~[?:?]

at org.eclipse.jetty.client.http.HttpChannelOverHTTP.send(HttpChannelOverHTTP.java:85) ~[?:?]

at org.eclipse.jetty.client.HttpChannel.send(HttpChannel.java:128) ~[?:?]

at org.eclipse.jetty.client.HttpConnection.send(HttpConnection.java:201) ~[?:?]

at org.eclipse.jetty.client.http.HttpConnectionOverHTTP$Delegate.send(HttpConnectionOverHTTP.java:252) ~[?:?]

at org.eclipse.jetty.client.http.HttpConnectionOverHTTP.send(HttpConnectionOverHTTP.java:121) ~[?:?]

at org.eclipse.jetty.client.http.HttpDestinationOverHTTP.send(HttpDestinationOverHTTP.java:38) ~[?:?]

at org.eclipse.jetty.client.HttpDestination.process(HttpDestination.java:346) ~[?:?]

at org.eclipse.jetty.client.HttpDestination.process(HttpDestination.java:304) ~[?:?]

at org.eclipse.jetty.client.HttpDestination.send(HttpDestination.java:294) ~[?:?]

at org.eclipse.jetty.client.HttpDestination.send(HttpDestination.java:269) ~[?:?]

at org.eclipse.jetty.client.HttpDestination.send(HttpDestination.java:246) ~[?:?]

at org.eclipse.jetty.client.HttpClient.send(HttpClient.java:580) ~[?:?]

at org.eclipse.jetty.client.HttpRequest.send(HttpRequest.java:728) ~[?:?]

at org.eclipse.jetty.client.HttpRequest.send(HttpRequest.java:720) ~[?:?]

at org.openhab.binding.deconz.internal.netutils.AsyncHttpClient.doNetwork(AsyncHttpClient.java:103) ~[?:?]

at org.openhab.binding.deconz.internal.netutils.AsyncHttpClient.post(AsyncHttpClient.java:52) ~[?:?]

… 8 more

==> /var/log/openhab2/events.log <==

2020-03-06 16:18:04.236 [hingStatusInfoChangedEvent] - ‘deconz:deconz:homeserver’ changed from OFFLINE (CONFIGURATION_PENDING): Requesting API Key to OFFLINE (COMMUNICATION_ERROR): org.eclipse.jetty.io.EofException

==> /var/log/openhab2/openhab.log <==

2020-03-06 16:19:16.671 [WARN ] [homekit.internal.HomekitAuthInfoImpl] - Could not find existing MAC in org.eclipse.smarthome.storage.json.internal.JsonStorage. Generating new MAC. This will require re-pairing of iOS devices.

2020-03-06 16:19:16.798 [INFO ] [io.github.hapjava.HomekitRoot ] - Added accessory openHAB

2020-03-06 16:19:17.757 [INFO ] [pl.http.impl.NettyHomekitHttpService] - Bound homekit listener to /192.168.0.81:9123

2020-03-06 16:19:17.776 [INFO ] [va.impl.jmdns.JmdnsHomekitAdvertiser] - Advertising accessory openHAB

2020-03-06 16:19:17.778 [INFO ] [va.impl.jmdns.JmdnsHomekitAdvertiser] - Registering _hap._tcp.local. on port 9123

==> /var/log/openhab2/events.log <==

2020-03-06 16:19:17.860 [thome.event.ExtensionEvent] - Extension ‘misc-homekit’ has been installed.

==> /var/log/openhab2/openhab.log <==

2020-03-06 16:20:57.394 [DEBUG] [impl.connections.SubscriptionManager] - Removing 0 reverse connections from subscription manager

2020-03-06 16:20:57.400 [DEBUG] [impl.connections.SubscriptionManager] - Subscription sizes are 0 and 0

2020-03-06 16:20:57.428 [INFO ] [io.github.hapjava.HomekitRoot ] - Added accessory openHAB

2020-03-06 16:20:57.461 [INFO ] [pl.http.impl.NettyHomekitHttpService] - Bound homekit listener to /192.168.0.81:9126

2020-03-06 16:20:57.465 [INFO ] [va.impl.jmdns.JmdnsHomekitAdvertiser] - Advertising accessory openHAB

2020-03-06 16:20:57.471 [INFO ] [va.impl.jmdns.JmdnsHomekitAdvertiser] - Registering _hap._tcp.local. on port 9126

2020-03-06 16:24:09.761 [DEBUG] [impl.connections.SubscriptionManager] - Removing 0 reverse connections from subscription manager

2020-03-06 16:24:09.762 [DEBUG] [impl.connections.SubscriptionManager] - Subscription sizes are 0 and 0

2020-03-06 16:24:09.767 [INFO ] [io.github.hapjava.HomekitRoot ] - Added accessory SN_openHAB

2020-03-06 16:24:09.770 [ERROR] [org.openhab.io.homekit ] - bundle org.openhab.io.homekit:2.5.2 (242)[org.openhab.io.homekit.internal.HomekitImpl(234)] : The modified method has thrown an exception

java.lang.RuntimeException: HomekitHttpServer can only be started once

at io.github.hapjava.impl.http.impl.HomekitHttpServer.start(HomekitHttpServer.java:34) ~[?:?]

at io.github.hapjava.HomekitRoot.start(HomekitRoot.java:112) ~[?:?]

at org.openhab.io.homekit.internal.HomekitImpl.startBridge(HomekitImpl.java:120) ~[?:?]

at org.openhab.io.homekit.internal.HomekitImpl.modified(HomekitImpl.java:97) ~[?:?]

at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_222]

at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_222]

at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_222]

at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_222]

at org.apache.felix.scr.impl.inject.methods.BaseMethod.invokeMethod(BaseMethod.java:228) ~[bundleFile:?]

at org.apache.felix.scr.impl.inject.methods.BaseMethod.access$500(BaseMethod.java:41) ~[bundleFile:?]

at org.apache.felix.scr.impl.inject.methods.BaseMethod$Resolved.invoke(BaseMethod.java:664) ~[bundleFile:?]

at org.apache.felix.scr.impl.inject.methods.BaseMethod.invoke(BaseMethod.java:510) [bundleFile:?]

at org.apache.felix.scr.impl.inject.methods.ActivateMethod.invoke(ActivateMethod.java:317) [bundleFile:?]

at org.apache.felix.scr.impl.inject.methods.ActivateMethod.invoke(ActivateMethod.java:307) [bundleFile:?]

at org.apache.felix.scr.impl.manager.SingleComponentManager.invokeModifiedMethod(SingleComponentManager.java:836) [bundleFile:?]

at org.apache.felix.scr.impl.manager.SingleComponentManager.modify(SingleComponentManager.java:791) [bundleFile:?]

at org.apache.felix.scr.impl.manager.SingleComponentManager.reconfigure(SingleComponentManager.java:709) [bundleFile:?]

at org.apache.felix.scr.impl.manager.SingleComponentManager.reconfigure(SingleComponentManager.java:673) [bundleFile:?]

at org.apache.felix.scr.impl.manager.ConfigurableComponentHolder.configurationUpdated(ConfigurableComponentHolder.java:435) [bundleFile:?]

at org.apache.felix.scr.impl.manager.RegionConfigurationSupport.configurationEvent(RegionConfigurationSupport.java:316) [bundleFile:?]

at org.apache.felix.scr.impl.manager.RegionConfigurationSupport$2.configurationEvent(RegionConfigurationSupport.java:118) [bundleFile:?]

at org.apache.felix.cm.impl.ConfigurationManager$FireConfigurationEvent.sendEvent(ConfigurationManager.java:1709) [bundleFile:?]

at org.apache.felix.cm.impl.ConfigurationManager$FireConfigurationEvent.run(ConfigurationManager.java:1651) [bundleFile:?]

at org.apache.felix.cm.impl.UpdateThread.run0(UpdateThread.java:138) [bundleFile:?]

at org.apache.felix.cm.impl.UpdateThread.run(UpdateThread.java:105) [bundleFile:?]

at java.lang.Thread.run(Thread.java:748) [?:1.8.0_222]

Result is the same: my IOS HomeKit can not find Openhab device with new port 9126…

P.S: here is the context of configuration files:
homekit.cfg
org.openhab.homekit:port=9126
org.openhab.homekit:pin=031-45-154
org.openhab.homekit:useFahrenheitTemperature=false
org.openhab.homekit:thermostatCoolMode=MANU_MODE
org.openhab.homekit:thermostatHeatMode=MANU_MODE
org.openhab.homekit:thermostatAutoMode=AUTO_MODE
org.openhab.homekit:thermostatOffMode=AUTO_MODE
org.openhab.homekit:networkInterface=192.168.0.81
org.openhab.homekit:name=SN_openHAB
org.openhab.homekit:minimumTemperature=-50
org.openhab.homekit:maximumTemperature=100

homekit.config
:org.apache.felix.configadmin.revision:=L"3"
maximumTemperature=“100.0”
minimumTemperature="-50.0"
name=“SN_openHAB”
networkInterface=“192.168.0.81”
pin=“031-45-154”
port=“9126”
service.pid=“org.openhab.homekit”
thermostatAutoMode=“AUTO_MODE”
thermostatCoolMode=“MANU_MODE”
thermostatCurrentModeCooling=“Cooling”
thermostatCurrentModeHeating=“Heating”
thermostatCurrentModeOff=“Off”
thermostatHeatMode=“MANU_MODE”
thermostatOffMode=“AUTO_MODE”
thermostatTargetModeAuto=“Auto”
thermostatTargetModeCool=“CoolOn”
thermostatTargetModeHeat=“HeatOn”
thermostatTargetModeOff=“Off”
useFahrenheitTemperature=B"false"

after change the port back to 9124, my IOS HomeKit find the SN_Openhab directly. After adding of this device no connection can be builded: Error Message in HomeKit is: This accessory is not supported by the home app

See log entries:
2020-03-06 16:38:46.153 [INFO ] [io.github.hapjava.HomekitRoot ] - Added accessory SN_openHAB

2020-03-06 16:38:46.181 [INFO ] [pl.http.impl.NettyHomekitHttpService] - Bound homekit listener to /192.168.0.81:9124

2020-03-06 16:38:46.184 [INFO ] [va.impl.jmdns.JmdnsHomekitAdvertiser] - Advertising accessory SN_openHAB

2020-03-06 16:38:46.187 [INFO ] [va.impl.jmdns.JmdnsHomekitAdvertiser] - Registering _hap._tcp.local. on port 9124

2020-03-06 16:39:25.622 [INFO ] [java.impl.http.impl.AccessoryHandler] - New homekit connection from /192.168.0.87:52788

2020-03-06 16:39:25.651 [TRACE] [pl.http.impl.NettyHomekitHttpService] - READ PooledUnsafeDirectByteBuf(ridx: 0, widx: 128, cap: 1024) [/192.168.0.87:52788]:

504F5354202F706169722D736574757020485454502F312E310D0A486F73743A20534E5F6F70656E4841422E5F6861702E5F7463702E6C6F63616C0D0A436F6E74656E742D4C656E6774683A20360D0A436F6E74656E742D547970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A0D0A000100060101

2020-03-06 16:39:25.701 [TRACE] [http.impl.FullRequestHttpRequestImpl] - received [0, 1, 0, 6, 1, 1]

2020-03-06 16:39:25.717 [INFO ] [.hapjava.impl.pairing.PairingManager] - Starting pair for SN_openHAB

2020-03-06 16:39:26.240 [INFO ] [va.impl.http.HomekitClientConnection] - 200 /pair-setup

2020-03-06 16:39:26.256 [TRACE] [pl.http.impl.NettyHomekitHttpService] - WRITE PooledUnsafeDirectByteBuf(ridx: 0, widx: 513, cap: 1024) [/192.168.0.87:52788]:

485454502F312E3120323030204F4B0D0A436F6E74656E742D747970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A436F6E74656E742D4C656E6774683A203430390D0A436F6E6E656374696F6E3A206B6565702D616C6976650D0A0D0A0601020210AD8E8ADB7BBF05EBB44A703F78A3F64603FFA9AB4431B388EA1002CC73D4E826042CA499B532294EFF6D2C5AE46551A2C1F3E0D33E2FDDDA9126DDDF8E6C72A941497C12F80F85F6FAB5F518270F94CBF6D034F19204B809686F786A4B81274410AAFB74D77D35BD7EC93921327CE5D1B02AE4B15321A2E2E408DB4BE2488515EBEAED480B7A728E3E70E3B1872CB3653BC0E366F0061EEB330DDF9264AE383818DEFE50B04D2398882349C86BE7E112FDD2467661485F5F167E4D4D8EB856CDD807F3BF622E73491052D17D11EAD2B1277E0D755904D7E89CA20C4975C09C44FEABCE342CACF5E5610F3607F0E30C158C785D7162231B6FC7D0DDAB99890F445ACE4CA82C1B4DC3BEBC6209C95C3B8A5B0381FFBD406E079CCF285554EE5910FFEA342C7C877DEB5D3DCB1EA045453636AD6590B605B71135BEFBF23AAA578514E8AB4D851F83B749FE2AD586E9D9DC189EDAA09D051338CF176BFBF8218105DB0FF1F8C2A2357ECDA6C4011C90F2122CF0A073E3C945E3990E330C775863B655A51952E443F42429642C98582F8A30D4DAA1D8

2020-03-06 16:39:33.267 [TRACE] [pl.http.impl.NettyHomekitHttpService] - READ PooledUnsafeDirectByteBuf(ridx: 0, widx: 581, cap: 1024) [/192.168.0.87:52788]:

504F5354202F706169722D736574757020485454502F312E310D0A486F73743A20534E5F6F70656E4841422E5F6861702E5F7463702E6C6F63616C0D0A436F6E74656E742D4C656E6774683A203435370D0A436F6E74656E742D547970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A0D0A06010303FFC461E6D0287BFC7AC504D0899DC7757A4991A226A88C425F4F0E619185A2E25720A02930983EC53F9C640299050FFB37EB5F2BE66D408D9C55366FB66CA54CA128D1868B6F6834AFC6965936961BDCB632231F9C817954CDBF50A75383DA79FC8D9362F3FE077C7D17512DD422E72562696A861CBA58EC5A852B1A4D499815A7AE741FAF19144490F62AA671B49CB44177A727D462E8D959973DBF791A1571A333BD8057D7CE664FA4EF2048AB29E809DF85CBE14FDA5F83A9F5D85A922BFE1DEB08E7F8EAB81DA2A1D897E615124D7A214E2748F81A41F86F4867680989E13E3AE389D5663095EB5B4E820568E91CF6418908811C12243494BF46D94D1389038185851D74A3493F654E7DFCC75B57C85C6BDA7FFFACE1BD280A201568C2FD750703C0789E2519EF57A20B85C6C5963445227EDE146F5A275914715BDA0F24F85D8DF81A52EDF837EE93C5EB944C855E342312A158C01D0B52C00580866B3AD03E000EFFF9ECDE3970E1B9D224906AC0682086DD7AA7375D86E54D1C15813BF1BF410440F7382648A5796CE3303F05CA2F14792C917F9A57BDAF64CB4099883A03E7C18C1ACF9436E46331F17704D4F6FB27B1BE2FD2B858F44F02253359AC1EA99F8C4C

2020-03-06 16:39:33.269 [TRACE] [http.impl.FullRequestHttpRequestImpl] - received [6, 1, 3, 3, -1, -60, 97, -26, -48, 40, 123, -4, 122, -59, 4, -48, -119, -99, -57, 117, 122, 73, -111, -94, 38, -88, -116, 66, 95, 79, 14, 97, -111, -123, -94, -30, 87, 32, -96, 41, 48, -104, 62, -59, 63, -100, 100, 2, -103, 5, 15, -5, 55, -21, 95, 43, -26, 109, 64, -115, -100, 85, 54, 111, -74, 108, -91, 76, -95, 40, -47, -122, -117, 111, 104, 52, -81, -58, -106, 89, 54, -106, 27, -36, -74, 50, 35, 31, -100, -127, 121, 84, -51, -65, 80, -89, 83, -125, -38, 121, -4, -115, -109, 98, -13, -2, 7, 124, 125, 23, 81, 45, -44, 34, -25, 37, 98, 105, 106, -122, 28, -70, 88, -20, 90, -123, 43, 26, 77, 73, -104, 21, -89, -82, 116, 31, -81, 25, 20, 68, -112, -10, 42, -90, 113, -76, -100, -76, 65, 119, -89, 39, -44, 98, -24, -39, 89, -105, 61, -65, 121, 26, 21, 113, -93, 51, -67, -128, 87, -41, -50, 102, 79, -92, -17, 32, 72, -85, 41, -24, 9, -33, -123, -53, -31, 79, -38, 95, -125, -87, -11, -40, 90, -110, 43, -2, 29, -21, 8, -25, -8, -22, -72, 29, -94, -95, -40, -105, -26, 21, 18, 77, 122, 33, 78, 39, 72, -8, 26, 65, -8, 111, 72, 103, 104, 9, -119, -31, 62, 58, -29, -119, -43, 102, 48, -107, -21, 91, 78, -126, 5, 104, -23, 28, -10, 65, -119, 8, -127, 28, 18, 36, 52, -108, -65, 70, -39, 77, 19, -119, 3, -127, -123, -123, 29, 116, -93, 73, 63, 101, 78, 125, -4, -57, 91, 87, -56, 92, 107, -38, 127, -1, -84, -31, -67, 40, 10, 32, 21, 104, -62, -3, 117, 7, 3, -64, 120, -98, 37, 25, -17, 87, -94, 11, -123, -58, -59, -106, 52, 69, 34, 126, -34, 20, 111, 90, 39, 89, 20, 113, 91, -38, 15, 36, -8, 93, -115, -8, 26, 82, -19, -8, 55, -18, -109, -59, -21, -108, 76, -123, 94, 52, 35, 18, -95, 88, -64, 29, 11, 82, -64, 5, -128, -122, 107, 58, -48, 62, 0, 14, -1, -7, -20, -34, 57, 112, -31, -71, -46, 36, -112, 106, -64, 104, 32, -122, -35, 122, -89, 55, 93, -122, -27, 77, 28, 21, -127, 59, -15, -65, 65, 4, 64, -9, 56, 38, 72, -91, 121, 108, -29, 48, 63, 5, -54, 47, 20, 121, 44, -111, 127, -102, 87, -67, -81, 100, -53, 64, -103, -120, 58, 3, -25, -63, -116, 26, -49, -108, 54, -28, 99, 49, -15, 119, 4, -44, -10, -5, 39, -79, -66, 47, -46, -72, 88, -12, 79, 2, 37, 51, 89, -84, 30, -87, -97, -116, 76]

2020-03-06 16:39:33.271 [DEBUG] [.hapjava.impl.pairing.PairingManager] - Entering second stage of pair for SN_openHAB

2020-03-06 16:39:33.500 [INFO ] [va.impl.http.HomekitClientConnection] - 200 /pair-setup

2020-03-06 16:39:33.503 [TRACE] [pl.http.impl.NettyHomekitHttpService] - WRITE PooledUnsafeDirectByteBuf(ridx: 0, widx: 172, cap: 232) [/192.168.0.87:52788]:

485454502F312E3120323030204F4B0D0A436F6E74656E742D747970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A436F6E74656E742D4C656E6774683A2036390D0A436F6E6E656374696F6E3A206B6565702D616C6976650D0A0D0A06010404407D8681C92CA99D0D456E8C9410D8B4D19C9ABC5AAD07201D72229C58A90A40488DF291B330FA7108A66C5F73B679B7558A20CDF96B13DB414B4ABBF1829C1403

2020-03-06 16:39:33.633 [TRACE] [pl.http.impl.NettyHomekitHttpService] - READ PooledUnsafeDirectByteBuf(ridx: 0, widx: 283, cap: 1024) [/192.168.0.87:52788]:

504F5354202F706169722D736574757020485454502F312E310D0A486F73743A20534E5F6F70656E4841422E5F6861702E5F7463702E6C6F63616C0D0A436F6E74656E742D4C656E6774683A203135390D0A436F6E74656E742D547970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A0D0A059A2D95062D3CF3A815ACF2E6854F467C93BDCAEC6436C7B85584B2267E61F49638B5482D01CE7D99CBCDD89B098DCBFF929540944DB5FD51E2FBD19596A227985A38D5BA9EAE63D58E290C7BF2745F7770CDEB30CABC8EF5D4B7D924827BAB69D216759CD916007BD0351BCA79B7FF039356B848B50006A9CC6C2063C86C24DCB20B2ACF188A5F5B940F36FCFE2C80D7ED785D89AFD52898762F45060105

2020-03-06 16:39:33.636 [TRACE] [http.impl.FullRequestHttpRequestImpl] - received [5, -102, 45, -107, 6, 45, 60, -13, -88, 21, -84, -14, -26, -123, 79, 70, 124, -109, -67, -54, -20, 100, 54, -57, -72, 85, -124, -78, 38, 126, 97, -12, -106, 56, -75, 72, 45, 1, -50, 125, -103, -53, -51, -40, -101, 9, -115, -53, -1, -110, -107, 64, -108, 77, -75, -3, 81, -30, -5, -47, -107, -106, -94, 39, -104, 90, 56, -43, -70, -98, -82, 99, -43, -114, 41, 12, 123, -14, 116, 95, 119, 112, -51, -21, 48, -54, -68, -114, -11, -44, -73, -39, 36, -126, 123, -85, 105, -46, 22, 117, -100, -39, 22, 0, 123, -48, 53, 27, -54, 121, -73, -1, 3, -109, 86, -72, 72, -75, 0, 6, -87, -52, 108, 32, 99, -56, 108, 36, -36, -78, 11, 42, -49, 24, -118, 95, 91, -108, 15, 54, -4, -2, 44, -128, -41, -19, 120, 93, -119, -81, -43, 40, -104, 118, 47, 69, 6, 1, 5]

2020-03-06 16:39:33.637 [DEBUG] [.hapjava.impl.pairing.PairingManager] - Entering third stage of pair for SN_openHAB

2020-03-06 16:39:33.675 [TRACE] [ub.hapjava.impl.crypto.ChachaDecoder] - calculated ‘[-4, -2, 44, -128, -41, -19, 120, 93, -119, -81, -43, 40, -104, 118, 47, 69]’, received ‘[-4, -2, 44, -128, -41, -19, 120, 93, -119, -81, -43, 40, -104, 118, 47, 69]’

2020-03-06 16:39:33.753 [INFO ] [va.impl.http.HomekitClientConnection] - 200 /pair-setup

2020-03-06 16:39:33.757 [TRACE] [pl.http.impl.NettyHomekitHttpService] - WRITE PooledUnsafeDirectByteBuf(ridx: 0, widx: 244, cap: 256) [/192.168.0.87:52788]:

485454502F312E3120323030204F4B0D0A436F6E74656E742D747970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A436F6E74656E742D4C656E6774683A203134300D0A436F6E6E656374696F6E3A206B6565702D616C6976650D0A0D0A060106058777051A10044252EFACDCB116F0BCCBAB627D4CDF0BE206E96D16A06B07D526204628BA8E7EB20295AC9690365CC4965C1D4EED4C4A371221CA94517E4437A93953671FEFCE97D95642A0391027066BDC27997C933D10A1882894CE4F99E8D70E9DE53A2BC84720E71E4AEDAB6452BB06A1CBDEE61AAC75337360966B8E7AD86D1DA75E543F317F

2020-03-06 16:39:33.823 [INFO ] [java.impl.http.impl.AccessoryHandler] - Terminated homekit connection from /192.168.0.87:52788

2020-03-06 16:39:33.841 [INFO ] [java.impl.http.impl.AccessoryHandler] - New homekit connection from /192.168.0.87:52789

2020-03-06 16:39:33.843 [TRACE] [pl.http.impl.NettyHomekitHttpService] - READ PooledUnsafeDirectByteBuf(ridx: 0, widx: 161, cap: 1024) [/192.168.0.87:52789]:

504F5354202F706169722D76657269667920485454502F312E310D0A486F73743A20534E5F6F70656E4841422E5F6861702E5F7463702E6C6F63616C0D0A436F6E74656E742D4C656E6774683A2033370D0A436F6E74656E742D547970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A0D0A0601010320F3942CEB60863A8F44587456A3B95259FEF22188E4AC07A21C6AF51B4ED7202D

2020-03-06 16:39:33.848 [TRACE] [http.impl.FullRequestHttpRequestImpl] - received [6, 1, 1, 3, 32, -13, -108, 44, -21, 96, -122, 58, -113, 68, 88, 116, 86, -93, -71, 82, 89, -2, -14, 33, -120, -28, -84, 7, -94, 28, 106, -11, 27, 78, -41, 32, 45]

2020-03-06 16:39:33.852 [DEBUG] [impl.pairing.PairVerificationManager] - Starting pair verification for SN_openHAB

2020-03-06 16:39:33.884 [INFO ] [va.impl.http.HomekitClientConnection] - 200 /pair-verify

2020-03-06 16:39:33.886 [TRACE] [pl.http.impl.NettyHomekitHttpService] - WRITE PooledUnsafeDirectByteBuf(ridx: 0, widx: 244, cap: 256) [/192.168.0.87:52789]:

485454502F312E3120323030204F4B0D0A436F6E74656E742D747970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A436F6E74656E742D4C656E6774683A203134300D0A436F6E6E656374696F6E3A206B6565702D616C6976650D0A0D0A0601020565C879FAD59FDE737BE7BF1C9CCAB077C8BB946B29934FAE7649C7494F0C54B9A8F8C3CDC8A3F2FFD41356A29D8ABF1E5FC5C19F244CC4E765725BC53D7ED05822B0CB1C2062F7BD2BCFB3EAD3240B0C42180E16DABE46188794B60F86CE0CE1CD3293B967120320C6DE38BF4D0145A4484C72896D8EBF384EE985F9514939F6726AC4526A85CA6D

2020-03-06 16:39:33.994 [TRACE] [pl.http.impl.NettyHomekitHttpService] - READ PooledUnsafeDirectByteBuf(ridx: 0, widx: 250, cap: 1024) [/192.168.0.87:52789]:

504F5354202F706169722D76657269667920485454502F312E310D0A486F73743A20534E5F6F70656E4841422E5F6861702E5F7463702E6C6F63616C0D0A436F6E74656E742D4C656E6774683A203132350D0A436F6E74656E742D547970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A0D0A0578C4CB6246701475B3B241539568884AEDDB284AE6D5DFDFAB565B7F4978B057661619E6F91B5F82369AA1E9D69CE77DAE78ACC7B543D7D09E249BA1E8ABC4509A865E920D34824D526B9B10EEB20E7D08EBC0211FDCCD962CE4AC7F7D9A2C7233BBD2ADB93B6B36084F1B921ECA356ED4428200B3501C0638060103

2020-03-06 16:39:33.997 [TRACE] [http.impl.FullRequestHttpRequestImpl] - received [5, 120, -60, -53, 98, 70, 112, 20, 117, -77, -78, 65, 83, -107, 104, -120, 74, -19, -37, 40, 74, -26, -43, -33, -33, -85, 86, 91, 127, 73, 120, -80, 87, 102, 22, 25, -26, -7, 27, 95, -126, 54, -102, -95, -23, -42, -100, -25, 125, -82, 120, -84, -57, -75, 67, -41, -48, -98, 36, -101, -95, -24, -85, -60, 80, -102, -122, 94, -110, 13, 52, -126, 77, 82, 107, -101, 16, -18, -78, 14, 125, 8, -21, -64, 33, 31, -36, -51, -106, 44, -28, -84, 127, 125, -102, 44, 114, 51, -69, -46, -83, -71, 59, 107, 54, 8, 79, 27, -110, 30, -54, 53, 110, -44, 66, -126, 0, -77, 80, 28, 6, 56, 6, 1, 3]

2020-03-06 16:39:34.000 [TRACE] [ub.hapjava.impl.crypto.ChachaDecoder] - calculated ‘[79, 27, -110, 30, -54, 53, 110, -44, 66, -126, 0, -77, 80, 28, 6, 56]’, received ‘[79, 27, -110, 30, -54, 53, 110, -44, 66, -126, 0, -77, 80, 28, 6, 56]’

2020-03-06 16:39:34.012 [DEBUG] [impl.pairing.PairVerificationManager] - Completed pair verification for SN_openHAB

2020-03-06 16:39:34.016 [INFO ] [va.impl.http.HomekitClientConnection] - 200 /pair-verify

2020-03-06 16:39:34.030 [TRACE] [pl.http.impl.NettyHomekitHttpService] - WRITE PooledUnsafeDirectByteBuf(ridx: 0, widx: 105, cap: 256) [/192.168.0.87:52789]:

485454502F312E3120323030204F4B0D0A436F6E74656E742D747970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A436F6E74656E742D4C656E6774683A20330D0A436F6E6E656374696F6E3A206B6565702D616C6976650D0A0D0A060104

2020-03-06 16:39:34.151 [TRACE] [pl.http.impl.NettyHomekitHttpService] - READ PooledUnsafeDirectByteBuf(ridx: 0, widx: 81, cap: 512) [/192.168.0.87:52789]:

3F00498CF64669E07BD40F8273CAFDD4D355E8903543D5C927C22C174E1C6516D1694DD997C3060EBA0DC911F94B213C8E52845B933BB5216DADBD500F7ABBFB4D2D5A1C4A882F893E60BA22DB3EF0A725

2020-03-06 16:39:34.155 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Received message of length 81. Existing buffer is 0

2020-03-06 16:39:34.157 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Attempting to read message of length 81

2020-03-06 16:39:34.158 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Read complete message

2020-03-06 16:39:34.160 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Returning 1 results

2020-03-06 16:39:34.164 [TRACE] [ub.hapjava.impl.crypto.ChachaDecoder] - calculated ‘[45, 90, 28, 74, -120, 47, -119, 62, 96, -70, 34, -37, 62, -16, -89, 37]’, received ‘[45, 90, 28, 74, -120, 47, -119, 62, 96, -70, 34, -37, 62, -16, -89, 37]’

2020-03-06 16:39:34.166 [DEBUG] [hapjava.impl.http.impl.BinaryHandler] - Received data [/192.168.0.87:52789]:

GET /accessories HTTP/1.1

Host: SN_openHAB._hap._tcp.local

2020-03-06 16:39:34.234 [INFO ] [va.impl.http.HomekitClientConnection] - 200 /accessories

2020-03-06 16:39:34.236 [DEBUG] [hapjava.impl.http.impl.BinaryHandler] - Sending data [/192.168.0.87:52789]:

HTTP/1.1 200 OK

Content-type: application/hap+json

Content-Length: 784

Connection: keep-alive

{“accessories”:[{“aid”:1,“services”:[{“iid”:1,“type”:“3E”,“characteristics”:[{“iid”:2,“type”:“23”,“perms”:[“pr”],“format”:“string”,“ev”:false,“description”:“Name of the accessory”,“value”:“SN_openHAB”,“maxLen”:255},{“iid”:3,“type”:“20”,“perms”:[“pr”],“format”:“string”,“ev”:false,“description”:“The name of the manufacturer”,“value”:“openHAB”,“maxLen”:255},{“iid”:4,“type”:“21”,“perms”:[“pr”],“format”:“string”,“ev”:false,“description”:“The name of the model”,“value”:“2.5.2”,“maxLen”:255},{“iid”:5,“type”:“30”,“perms”:[“pr”],“format”:“string”,“ev”:false,“description”:“The serial number of the accessory”,“value”:“none”,“maxLen”:255},{“iid”:6,“type”:“14”,“perms”:[“pw”],“format”:“bool”,“ev”:false,“description”:“Identifies the accessory via a physical action on the accessory”}]}]}]}

2020-03-06 16:39:34.240 [TRACE] [pl.http.impl.NettyHomekitHttpService] - WRITE PooledUnsafeDirectByteBuf(ridx: 0, widx: 902, cap: 1024) [/192.168.0.87:52789]:

74031A7C02935D3A0834ECE32F87ED2E6AC395B6277EE8C55671A790FDF5079429BE31D1F2A340223CDEB407ECC72DB16690FAEFD51EFB7670713B639AAB801D2C48D0E11434C15DDF2FFCC5A7CE7A75E6B445F0D024D288710850E86B6D86A4CCE09DF60829580FCDA88301238AB7213BE6AD42099B4FF1FBF9D54567234C1B25BA19A5F144867B4570F91A07F2F0FA6B9BAE3B92D8BEFB8896695D96E838E7CF6D781F2990D081D9D2FC7588BC51C9026419D56413153F860D1436E0A72A39A865040F09A451CD59F4E2C5C32800EB47853C5054609366F88E9ABB3B14137F76508050421272B2FE1975D45FB09A149238AE0B010957E8B6BEE755FE565AE65B938317EE24513D52D5ABF8C31904317C71B3E279DC7E836532FCF14DE290D1408C80CDE62EAF6465410A5E1E40572269BED70A3DAB7288EBF7BEC7D287F548C78D43BD57F3ED42413B7BA6D0B48BF22598FF626314F729B87C85178FFC8B70776947FCA554AAF5D43FBF82E895CE9AA77DBD2DDB9E06248CA8E77E07A4FF856D39387215C0DCDA94B01640DBBDA65FE488F7E8F336D310B1BFE1D52233B7770534CDF20B6610EAB3706182AF60DAD43A9B9BE52E762E20CC8E1CBB05E90FCD0D255BDC9104FBA4F9467292EF3C6A58596D1F17A34D5AECA978028765C73E3AFD1A10A350FFCCB9363EE58C05C25D6AEE842DB3CF39B2AF30A16E288217B7243FF2B848BE60FD186A7A121035AB00D6FD68A5842AD105CCEF9939E64D538393A29288DC4BA32ABC789526CF81B78C3BCE2CF3484768329F0D6AA93CE47661BB4C2E67882523E39FA1389660A1629190B6BEA6D62E0BF0CEC2F13723132D860FD5E3DA11680D239D1046779BA59F18D28526E0045FBC6091AC00CE753E2536F23595446A12FC7803EB764EDFB0F9A2015AA211DF94DA5C59A870E5C0B4220D4D541C8414F5EA40979F089327B7D3FA3B3944D449923127633901E528942C8AC0DE7695A4EC5CC3B269D31AC8A3329044414AB42F2C060AFA4BB82B3A7E8EBBE7950CD0D571E41A7A1091A73B5FF953F51FD42A4DE29FAA669801D9FE8434E3DA6797C07D5DAE0368B31D4CE9219518DE556C5E82F2B27B33DE0255C1D33906973E2EEDF0D60A867E9F9AEE49B296F283E2FEC1606CC241BC92ED006D568330B5FDC1115067BE1DE58D7B8796BBBC57BD60B21DE1F27355C1F2356E13E19AE912C283370515099E035F6B607AD7DBFA0195223FBEA1A87A968BABA184B5A1A28901ACB2640EE5

2020-03-06 16:39:36.413 [INFO ] [java.impl.http.impl.AccessoryHandler] - New homekit connection from /192.168.0.38:60843

2020-03-06 16:39:36.414 [TRACE] [pl.http.impl.NettyHomekitHttpService] - READ PooledUnsafeDirectByteBuf(ridx: 0, widx: 161, cap: 1024) [/192.168.0.38:60843]:

504F5354202F706169722D76657269667920485454502F312E310D0A486F73743A20534E5F6F70656E4841422E5F6861702E5F7463702E6C6F63616C0D0A436F6E74656E742D4C656E6774683A2033370D0A436F6E74656E742D547970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A0D0A06010103204DBD09613BEA2506FF00EFB0F752D83C81B68ABD849120D3AB06DDE7014E7772

2020-03-06 16:39:36.417 [TRACE] [http.impl.FullRequestHttpRequestImpl] - received [6, 1, 1, 3, 32, 77, -67, 9, 97, 59, -22, 37, 6, -1, 0, -17, -80, -9, 82, -40, 60, -127, -74, -118, -67, -124, -111, 32, -45, -85, 6, -35, -25, 1, 78, 119, 114]

2020-03-06 16:39:36.418 [DEBUG] [impl.pairing.PairVerificationManager] - Starting pair verification for SN_openHAB

2020-03-06 16:39:36.427 [INFO ] [va.impl.http.HomekitClientConnection] - 200 /pair-verify

2020-03-06 16:39:36.429 [TRACE] [pl.http.impl.NettyHomekitHttpService] - WRITE PooledUnsafeDirectByteBuf(ridx: 0, widx: 244, cap: 256) [/192.168.0.38:60843]:

485454502F312E3120323030204F4B0D0A436F6E74656E742D747970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A436F6E74656E742D4C656E6774683A203134300D0A436F6E6E656374696F6E3A206B6565702D616C6976650D0A0D0A06010205650D03A5FE051BC6940C9C45385D6A208F48EFE1F6A549516E955AA101583360798F734EB4F41C59999859368A84C66D7EE19AA55013A6D829DACD0894E0517192891BE915986B425CEB437B7B2C712BCA0B9D7CAD6B711A1145859128A4B0E3A9BC53F1FB460320A533DC810DD86B58BBEF6EAEE490102C64F71D2CE9560741BFF0B8D4CE315802

2020-03-06 16:39:36.437 [TRACE] [pl.http.impl.NettyHomekitHttpService] - READ PooledUnsafeDirectByteBuf(ridx: 0, widx: 250, cap: 1024) [/192.168.0.38:60843]:

504F5354202F706169722D76657269667920485454502F312E310D0A486F73743A20534E5F6F70656E4841422E5F6861702E5F7463702E6C6F63616C0D0A436F6E74656E742D4C656E6774683A203132350D0A436F6E74656E742D547970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A0D0A0578D614350252F61DDE21CE3378DA7036A90B342251105721C46165CCE428DFFBFC0CDC3C6DC3CFDC77816584B8B948FC1503203F14B027E028075DF80932D4659CCD83F7C8E4B50E8C8F581CB172CC3418BB31290A16B9D7C1C3AC3F95A993EAA4FB5FCCB9418A378F30DAEC1B2CCEE69D412D2CB98565DD51060103

2020-03-06 16:39:36.439 [TRACE] [http.impl.FullRequestHttpRequestImpl] - received [5, 120, -42, 20, 53, 2, 82, -10, 29, -34, 33, -50, 51, 120, -38, 112, 54, -87, 11, 52, 34, 81, 16, 87, 33, -60, 97, 101, -52, -28, 40, -33, -5, -4, 12, -36, 60, 109, -61, -49, -36, 119, -127, 101, -124, -72, -71, 72, -4, 21, 3, 32, 63, 20, -80, 39, -32, 40, 7, 93, -8, 9, 50, -44, 101, -100, -51, -125, -9, -56, -28, -75, 14, -116, -113, 88, 28, -79, 114, -52, 52, 24, -69, 49, 41, 10, 22, -71, -41, -63, -61, -84, 63, -107, -87, -109, -22, -92, -5, 95, -52, -71, 65, -118, 55, -113, 48, -38, -20, 27, 44, -50, -26, -99, 65, 45, 44, -71, -123, 101, -35, 81, 6, 1, 3]

2020-03-06 16:39:36.441 [TRACE] [ub.hapjava.impl.crypto.ChachaDecoder] - calculated ‘[48, -38, -20, 27, 44, -50, -26, -99, 65, 45, 44, -71, -123, 101, -35, 81]’, received ‘[48, -38, -20, 27, 44, -50, -26, -99, 65, 45, 44, -71, -123, 101, -35, 81]’

2020-03-06 16:39:36.448 [DEBUG] [impl.pairing.PairVerificationManager] - Completed pair verification for SN_openHAB

2020-03-06 16:39:36.450 [INFO ] [va.impl.http.HomekitClientConnection] - 200 /pair-verify

2020-03-06 16:39:36.455 [TRACE] [pl.http.impl.NettyHomekitHttpService] - WRITE PooledUnsafeDirectByteBuf(ridx: 0, widx: 105, cap: 256) [/192.168.0.38:60843]:

485454502F312E3120323030204F4B0D0A436F6E74656E742D747970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A436F6E74656E742D4C656E6774683A20330D0A436F6E6E656374696F6E3A206B6565702D616C6976650D0A0D0A060104

2020-03-06 16:39:36.461 [TRACE] [pl.http.impl.NettyHomekitHttpService] - READ PooledUnsafeDirectByteBuf(ridx: 0, widx: 81, cap: 512) [/192.168.0.38:60843]:

3F001600686D1278A0648E4F887ED81B20EF30CC2ED37E29B83CBCCF4F161498ADC5D9A0DC805CFDDE1F13B1412DF74F1111307839D4D30963AD6C93A0674DF2823CA4716515F3C1EC219FCEF35A7408AB

2020-03-06 16:39:36.462 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Received message of length 81. Existing buffer is 0

2020-03-06 16:39:36.463 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Attempting to read message of length 81

2020-03-06 16:39:36.465 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Read complete message

2020-03-06 16:39:36.467 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Returning 1 results

2020-03-06 16:39:36.468 [TRACE] [ub.hapjava.impl.crypto.ChachaDecoder] - calculated ‘[60, -92, 113, 101, 21, -13, -63, -20, 33, -97, -50, -13, 90, 116, 8, -85]’, received ‘[60, -92, 113, 101, 21, -13, -63, -20, 33, -97, -50, -13, 90, 116, 8, -85]’

2020-03-06 16:39:36.470 [DEBUG] [hapjava.impl.http.impl.BinaryHandler] - Received data [/192.168.0.38:60843]:

GET /accessories HTTP/1.1

Host: SN_openHAB._hap._tcp.local

2020-03-06 16:39:36.481 [INFO ] [va.impl.http.HomekitClientConnection] - 200 /accessories

2020-03-06 16:39:36.484 [DEBUG] [hapjava.impl.http.impl.BinaryHandler] - Sending data [/192.168.0.38:60843]:

HTTP/1.1 200 OK

Content-type: application/hap+json

Content-Length: 784

Connection: keep-alive

{“accessories”:[{“aid”:1,“services”:[{“iid”:1,“type”:“3E”,“characteristics”:[{“iid”:2,“type”:“23”,“perms”:[“pr”],“format”:“string”,“ev”:false,“description”:“Name of the accessory”,“value”:“SN_openHAB”,“maxLen”:255},{“iid”:3,“type”:“20”,“perms”:[“pr”],“format”:“string”,“ev”:false,“description”:“The name of the manufacturer”,“value”:“openHAB”,“maxLen”:255},{“iid”:4,“type”:“21”,“perms”:[“pr”],“format”:“string”,“ev”:false,“description”:“The name of the model”,“value”:“2.5.2”,“maxLen”:255},{“iid”:5,“type”:“30”,“perms”:[“pr”],“format”:“string”,“ev”:false,“description”:“The serial number of the accessory”,“value”:“none”,“maxLen”:255},{“iid”:6,“type”:“14”,“perms”:[“pw”],“format”:“bool”,“ev”:false,“description”:“Identifies the accessory via a physical action on the accessory”}]}]}]}

2020-03-06 16:39:36.487 [TRACE] [pl.http.impl.NettyHomekitHttpService] - WRITE PooledUnsafeDirectByteBuf(ridx: 0, widx: 902, cap: 1024) [/192.168.0.38:60843]:

74031513405049879CA5F75AD87E01454A121B8DF60CDC81D0360FA0BD9E8378F2A88D3F360A4759778B7589E14A79EDF701804B2C038A2A230F67A557CB6DA4CA4B771F01306C57E978DFDBDDFC6AB0F99E8B625B9415D0B6C81FF95DEC29B6FCDFD35F608A1F89EBD2563E0E3F7E77C250F1FB1164CC65FAE2D41AD3AAC4FEB6DE83F4935CDBE6C92D46D46025890C2703B791113CD6704CC24A47DBCB4103A1C84AC0520A95735720D7A0A05F326A22AE07E4CC7129E5A7137A41FD6E46FAA45A181FF638BE62B6D3699FA5C7145054DE149EBBE41CD517F90FC04F2C21A0D5FF5FF3F419959AF87C0E766857C905AB6112B3D690004564F7379260544B9CF8532D49993F461C3D89FB1086AB7FB171D37C28D41ADBFEF6DF34C30756B9B182E3F8AE1020EAB6A0DCA14908935746BD59C64920569FC534AA5682D8BD84955700143EE06AAEF018314AE2DB6A20221AE6810CB7853106A18F1855D102979B70388B4F9455E7516CA2196E08A74904F83F5AE85C1DEE82C7047E68836A0454B11D5DE59CB2748C75463E01728928774E9ACA8113ADCBE2C986550E27C06FB7D36EAF3DCE1E1A491B58ABDCAE6F210581CDD748604D40625041C8316B1370D37FB8597FA30854854EFC1C72B4A0FD5B72B7C0CD716EEA27E17BF63006E5D0BCAEA87490D7CFF0CD77185324DC5456E97B906A836CB60C9A697C905F85C128B410B368B6D5BA66A5C1B21CE22257C21C8A85062DDCDAFEA3968E4AB5CB63AB509C4335BDF7DB110CF5064D44B043AFD2A2A557717319F671A3876B142FA53EC421E38670EFE9B38CB32DDA767EFDB81CA1003C0B26ACAD8EA56E6810BC392B9C2AF1C790686E639B98CB58B85863121F3642809C72912BA76F2667B772004C18C20FCB99A2158733558AF4A17FF5749CE9D4FBE4D516ED7C418543D6E9642412F4A3D2AE3EAE69E11BF707653A01B7C220C0D3D48B678ACB5A0554C21762682D7C50039DAB91600FA73038F65F1D13B36EBA347A1FD6032177765A2D01A5226DE76BA85727837195F5037B986079ECC8416A8F50C0CCEED614A2706369B553EC00EEB0F10F53824A3AD71AC9F51658581BECAFC1016F5FBDD42E1425334E4CEE803FCEA51D6F4B84841C2ABDB9D11771E3DEBBD99E1E47DF8941DB87A2F9062EB8B31E8F04F5278B8B36A8C4D217063538CE19673B8662ECFCE86A9E13817E480B34A2749D36A59DC07841C81BDFC9A15E2EA31B9C53AFDC6C164739FBE36711125B12838537

looks ok for me. i have similar logging messages.
currently you have no homekit accessaries (only the bridge). please try add one, e.g. add following label to devices in your items.xml
[“Lighting”], [“WindowCovering”]
here is an example from my items.xml

Switch    hobbyroom_light             "Hobbyraum Licht Hinten [%s]"     <light>  (gHobbyraum)     ["Lighting"] {channel="knx:device:scn_ip:AKK1616_01:channe

Rollershutter studio_blinds          "Atelier Rollladen [%d %%]"             <rollershutter>  (gAteilier)     ["WindowCovering"] {channel="knx:device:scn_ip:JAL0810_02:channel_c"}

Hello Eugen,

the same result after creation of items… :scream:

tail -f /var/log/openhab2/openhab.log /var/log/openhab2/events.log

at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.java:92) ~[?:?]

at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.java:67) ~[?:?]

at okhttp3.internal.cache.CacheInterceptor.intercept(CacheInterceptor.java:93) ~[?:?]

at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.java:92) ~[?:?]

at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.java:67) ~[?:?]

at okhttp3.internal.http.BridgeInterceptor.intercept(BridgeInterceptor.java:93) ~[?:?]

at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.java:92) ~[?:?]

at okhttp3.internal.http.RetryAndFollowUpInterceptor.intercept(RetryAndFollowUpInterceptor.java:120) ~[?:?]

at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.java:92) ~[?:?]

at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.java:67) ~[?:?]

at okhttp3.RealCall.getResponseWithInterceptorChain(RealCall.java:185) ~[?:?]

at okhttp3.RealCall$AsyncCall.execute(RealCall.java:135) ~[?:?]

at okhttp3.internal.NamedRunnable.run(NamedRunnable.java:32) ~[?:?]

… 3 more

Caused by: java.net.SocketException: Socket closed

at java.net.SocketInputStream.read(SocketInputStream.java:204) ~[?:1.8.0_222]

at java.net.SocketInputStream.read(SocketInputStream.java:141) ~[?:1.8.0_222]

at sun.security.ssl.InputRecord.readFully(InputRecord.java:465) ~[?:1.8.0_222]

at sun.security.ssl.InputRecord.read(InputRecord.java:503) ~[?:1.8.0_222]

at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:975) ~[?:1.8.0_222]

at sun.security.ssl.SSLSocketImpl.readDataRecord(SSLSocketImpl.java:933) ~[?:1.8.0_222]

at sun.security.ssl.AppInputStream.read(AppInputStream.java:105) ~[?:1.8.0_222]

at okio.Okio$2.read(Okio.java:139) ~[?:?]

at okio.AsyncTimeout$2.read(AsyncTimeout.java:237) ~[?:?]

at okio.RealBufferedSource.indexOf(RealBufferedSource.java:345) ~[?:?]

at okio.RealBufferedSource.readUtf8LineStrict(RealBufferedSource.java:217) ~[?:?]

at okio.RealBufferedSource.readUtf8LineStrict(RealBufferedSource.java:211) ~[?:?]

at okhttp3.internal.http1.Http1Codec.readResponseHeaders(Http1Codec.java:189) ~[?:?]

at okhttp3.internal.http.CallServerInterceptor.intercept(CallServerInterceptor.java:75) ~[?:?]

at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.java:92) ~[?:?]

at okhttp3.internal.connection.ConnectInterceptor.intercept(ConnectInterceptor.java:45) ~[?:?]

at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.java:92) ~[?:?]

at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.java:67) ~[?:?]

at okhttp3.internal.cache.CacheInterceptor.intercept(CacheInterceptor.java:93) ~[?:?]

at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.java:92) ~[?:?]

at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.java:67) ~[?:?]

at okhttp3.internal.http.BridgeInterceptor.intercept(BridgeInterceptor.java:93) ~[?:?]

at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.java:92) ~[?:?]

at okhttp3.internal.http.RetryAndFollowUpInterceptor.intercept(RetryAndFollowUpInterceptor.java:120) ~[?:?]

at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.java:92) ~[?:?]

at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.java:67) ~[?:?]

at okhttp3.RealCall.getResponseWithInterceptorChain(RealCall.java:185) ~[?:?]

at okhttp3.RealCall$AsyncCall.execute(RealCall.java:135) ~[?:?]

at okhttp3.internal.NamedRunnable.run(NamedRunnable.java:32) ~[?:?]

… 3 more

2020-03-06 23:53:28.297 [INFO ] [io.openhabcloud.internal.CloudClient] - Disconnected from the openHAB Cloud service (UUID = 5788fbbf-c36d-4e53-96a4-5648e1c4d04e, base URL = http://localhost:8080)

2020-03-06 23:53:29.590 [INFO ] [io.openhabcloud.internal.CloudClient] - Connected to the openHAB Cloud service (UUID = 5788fbbf-c36d-4e53-96a4-5648e1c4d04e, base URL = http://localhost:8080)

2020-03-06 23:54:25.877 [DEBUG] [impl.connections.SubscriptionManager] - Removing 0 reverse connections from subscription manager

2020-03-06 23:54:25.880 [DEBUG] [impl.connections.SubscriptionManager] - Subscription sizes are 0 and 0

2020-03-06 23:54:25.891 [INFO ] [io.github.hapjava.HomekitRoot ] - Added accessory SN_openHAB

2020-03-06 23:54:25.894 [ERROR] [org.openhab.io.homekit ] - bundle org.openhab.io.homekit:2.5.2 (251)[org.openhab.io.homekit.internal.HomekitImpl(234)] : The modified method has thrown an exception

java.lang.RuntimeException: HomekitHttpServer can only be started once

at io.github.hapjava.impl.http.impl.HomekitHttpServer.start(HomekitHttpServer.java:34) ~[?:?]

at io.github.hapjava.HomekitRoot.start(HomekitRoot.java:112) ~[?:?]

at org.openhab.io.homekit.internal.HomekitImpl.startBridge(HomekitImpl.java:120) ~[?:?]

at org.openhab.io.homekit.internal.HomekitImpl.modified(HomekitImpl.java:97) ~[?:?]

at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_222]

at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_222]

at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_222]

at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_222]

at org.apache.felix.scr.impl.inject.methods.BaseMethod.invokeMethod(BaseMethod.java:228) ~[bundleFile:?]

at org.apache.felix.scr.impl.inject.methods.BaseMethod.access$500(BaseMethod.java:41) ~[bundleFile:?]

at org.apache.felix.scr.impl.inject.methods.BaseMethod$Resolved.invoke(BaseMethod.java:664) ~[bundleFile:?]

at org.apache.felix.scr.impl.inject.methods.BaseMethod.invoke(BaseMethod.java:510) [bundleFile:?]

at org.apache.felix.scr.impl.inject.methods.ActivateMethod.invoke(ActivateMethod.java:317) [bundleFile:?]

at org.apache.felix.scr.impl.inject.methods.ActivateMethod.invoke(ActivateMethod.java:307) [bundleFile:?]

at org.apache.felix.scr.impl.manager.SingleComponentManager.invokeModifiedMethod(SingleComponentManager.java:836) [bundleFile:?]

at org.apache.felix.scr.impl.manager.SingleComponentManager.modify(SingleComponentManager.java:791) [bundleFile:?]

at org.apache.felix.scr.impl.manager.SingleComponentManager.reconfigure(SingleComponentManager.java:709) [bundleFile:?]

at org.apache.felix.scr.impl.manager.SingleComponentManager.reconfigure(SingleComponentManager.java:673) [bundleFile:?]

at org.apache.felix.scr.impl.manager.ConfigurableComponentHolder.configurationUpdated(ConfigurableComponentHolder.java:435) [bundleFile:?]

at org.apache.felix.scr.impl.manager.RegionConfigurationSupport.configurationEvent(RegionConfigurationSupport.java:316) [bundleFile:?]

at org.apache.felix.scr.impl.manager.RegionConfigurationSupport$2.configurationEvent(RegionConfigurationSupport.java:118) [bundleFile:?]

at org.apache.felix.cm.impl.ConfigurationManager$FireConfigurationEvent.sendEvent(ConfigurationManager.java:1709) [bundleFile:?]

at org.apache.felix.cm.impl.ConfigurationManager$FireConfigurationEvent.run(ConfigurationManager.java:1651) [bundleFile:?]

at org.apache.felix.cm.impl.UpdateThread.run0(UpdateThread.java:138) [bundleFile:?]

at org.apache.felix.cm.impl.UpdateThread.run(UpdateThread.java:105) [bundleFile:?]

at java.lang.Thread.run(Thread.java:748) [?:1.8.0_222]

2020-03-06 23:56:56.332 [INFO ] [io.github.hapjava.HomekitRoot ] - Added accessory SN_openHAB

2020-03-06 23:56:56.343 [INFO ] [pl.http.impl.NettyHomekitHttpService] - Bound homekit listener to /192.168.0.81:9154

2020-03-06 23:56:56.345 [INFO ] [va.impl.jmdns.JmdnsHomekitAdvertiser] - Advertising accessory SN_openHAB

2020-03-06 23:56:56.346 [INFO ] [va.impl.jmdns.JmdnsHomekitAdvertiser] - Registering _hap._tcp.local. on port 9154

2020-03-06 23:57:09.091 [INFO ] [java.impl.http.impl.AccessoryHandler] - New homekit connection from /192.168.0.87:54818

2020-03-06 23:57:09.114 [TRACE] [pl.http.impl.NettyHomekitHttpService] - READ PooledUnsafeDirectByteBuf(ridx: 0, widx: 128, cap: 1024) [/192.168.0.87:54818]:

504F5354202F706169722D736574757020485454502F312E310D0A486F73743A20534E5F6F70656E4841422E5F6861702E5F7463702E6C6F63616C0D0A436F6E74656E742D4C656E6774683A20360D0A436F6E74656E742D547970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A0D0A000100060101

2020-03-06 23:57:09.158 [TRACE] [http.impl.FullRequestHttpRequestImpl] - received [0, 1, 0, 6, 1, 1]

2020-03-06 23:57:09.169 [INFO ] [.hapjava.impl.pairing.PairingManager] - Starting pair for SN_openHAB

2020-03-06 23:57:09.688 [INFO ] [va.impl.http.HomekitClientConnection] - 200 /pair-setup

2020-03-06 23:57:09.708 [TRACE] [pl.http.impl.NettyHomekitHttpService] - WRITE PooledUnsafeDirectByteBuf(ridx: 0, widx: 513, cap: 1024) [/192.168.0.87:54818]:

485454502F312E3120323030204F4B0D0A436F6E74656E742D747970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A436F6E74656E742D4C656E6774683A203430390D0A436F6E6E656374696F6E3A206B6565702D616C6976650D0A0D0A0601020210AD2AE8D7DFF147E9B856C2389BAB97E503FF853A9D6A81FFA694932EFA1014ABDDE4CAF0F9546D7F328C20366AF81B7B9CE56C8FAD449155BCEE957836D98AC769E16CEB053CC6B524811F483EC8D929EF8FD66499127D80F46F7D725DDCEA1440CE1B849AC859EB67D437261379CCC7871578C4E007C0C9E39A09D00E7A8555D0CAEC2B6F4672FF20E6C4EC40E34DCF1A246C4914A2D1FED755D414CCFF00CB7E9C9B77113B7D373EB862303C2FC144826A81D9757F2E026FCBE07718401D978C8E118B368B8CE4291729BC8F021EE38A4A7A2E06D736A644514C4DBD469A0BD21D5532E7F1E1E93FA15D89100719AA58BF967078814DBADCC8EBE7ECBAC8AF9EDF7779C9D640EDFF55CDD90E8212EBB503818427DA6BEE85352740B8C7EA91C4637C1F4DC94BB3A823EF40A8931D58FC21D6624C5AD4CA132B485B1390F0ECFE70AF6A629B8E03BC9F0D355E0752716DF0AB8A1C99B3C05440289813FE507056C8CD5963ACB9E8956D801FEC55BFD1EB5460ACB18A0743DDAA550B315439B2C11303C2DA21BC86D902C01E8B897824314D0E0D

2020-03-06 23:57:14.030 [TRACE] [pl.http.impl.NettyHomekitHttpService] - READ PooledUnsafeDirectByteBuf(ridx: 0, widx: 581, cap: 1024) [/192.168.0.87:54818]:

504F5354202F706169722D736574757020485454502F312E310D0A486F73743A20534E5F6F70656E4841422E5F6861702E5F7463702E6C6F63616C0D0A436F6E74656E742D4C656E6774683A203435370D0A436F6E74656E742D547970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A0D0A06010303FFFB67E4D78FB69D6F76C2D6185D893E1502330AE8F9F70AC29641D696DFF08B690FD7FA46488134EDC6868DFC182EC193C712F03E90E0E3BA866D51F483BC689C16E1E0066F7FE07D7F629DA891CC7AE62EF343B6429ED12905D76A71CA12492BCD52E8C9FB4BA27DE0852C1E9DC51C4DE03DE8ECA12498DB485344CE21D67A3BADC33BEBD2FCA47C6ECC5FAB9E9B2E788F0E165389A5E0518D6CDE4671D9708B0FB5FAFE6CF137960245777779DF0716AC0D40930398E57D53C8ADE8CF562BFF2A8455138B0CAB0102373BA74FB5EAFB440E6E7E84A2154909D6209AFF8B51285259FB5D7844D174604DC6FFB85F62F91DDD17499CD99FE8A3FB3522E0DD4403813C17FFA7F98F38C9EA9A0BD777538CF129546B448859A971BB42895856B2E861C61CB3E20D715A7A0E82BA2CB8C9D4F26B92094E936A11FB2C9E9F3002B6D7D0F31BBB626C9796C3C3766A4D782E5FBE9B5E7BC3F74CAEBB93E9B7EB15BB2C2E0268CD9938B7909646877A7389BFAB15DFEE8113D05B46970C50EF16185E4C0B2A0440E073782C493458FF1943A455AF39059C32B3186970269FB18B4F5BEB2B8C7C7156F800820CD3934D3FF9C17CDD98F28B50479D01889DC26330E6A862C1866FA5

2020-03-06 23:57:14.032 [TRACE] [http.impl.FullRequestHttpRequestImpl] - received [6, 1, 3, 3, -1, -5, 103, -28, -41, -113, -74, -99, 111, 118, -62, -42, 24, 93, -119, 62, 21, 2, 51, 10, -24, -7, -9, 10, -62, -106, 65, -42, -106, -33, -16, -117, 105, 15, -41, -6, 70, 72, -127, 52, -19, -58, -122, -115, -4, 24, 46, -63, -109, -57, 18, -16, 62, -112, -32, -29, -70, -122, 109, 81, -12, -125, -68, 104, -100, 22, -31, -32, 6, 111, 127, -32, 125, 127, 98, -99, -88, -111, -52, 122, -26, 46, -13, 67, -74, 66, -98, -47, 41, 5, -41, 106, 113, -54, 18, 73, 43, -51, 82, -24, -55, -5, 75, -94, 125, -32, -123, 44, 30, -99, -59, 28, 77, -32, 61, -24, -20, -95, 36, -104, -37, 72, 83, 68, -50, 33, -42, 122, 59, -83, -61, 59, -21, -46, -4, -92, 124, 110, -52, 95, -85, -98, -101, 46, 120, -113, 14, 22, 83, -119, -91, -32, 81, -115, 108, -34, 70, 113, -39, 112, -117, 15, -75, -6, -2, 108, -15, 55, -106, 2, 69, 119, 119, 121, -33, 7, 22, -84, 13, 64, -109, 3, -104, -27, 125, 83, -56, -83, -24, -49, 86, 43, -1, 42, -124, 85, 19, -117, 12, -85, 1, 2, 55, 59, -89, 79, -75, -22, -5, 68, 14, 110, 126, -124, -94, 21, 73, 9, -42, 32, -102, -1, -117, 81, 40, 82, 89, -5, 93, 120, 68, -47, 116, 96, 77, -58, -1, -72, 95, 98, -7, 29, -35, 23, 73, -100, -39, -97, -24, -93, -5, 53, 34, -32, -35, 68, 3, -127, 60, 23, -1, -89, -7, -113, 56, -55, -22, -102, 11, -41, 119, 83, -116, -15, 41, 84, 107, 68, -120, 89, -87, 113, -69, 66, -119, 88, 86, -78, -24, 97, -58, 28, -77, -30, 13, 113, 90, 122, 14, -126, -70, 44, -72, -55, -44, -14, 107, -110, 9, 78, -109, 106, 17, -5, 44, -98, -97, 48, 2, -74, -41, -48, -13, 27, -69, 98, 108, -105, -106, -61, -61, 118, 106, 77, 120, 46, 95, -66, -101, 94, 123, -61, -9, 76, -82, -69, -109, -23, -73, -21, 21, -69, 44, 46, 2, 104, -51, -103, 56, -73, -112, -106, 70, -121, 122, 115, -119, -65, -85, 21, -33, -18, -127, 19, -48, 91, 70, -105, 12, 80, -17, 22, 24, 94, 76, 11, 42, 4, 64, -32, 115, 120, 44, 73, 52, 88, -1, 25, 67, -92, 85, -81, 57, 5, -100, 50, -77, 24, 105, 112, 38, -97, -79, -117, 79, 91, -21, 43, -116, 124, 113, 86, -8, 0, -126, 12, -45, -109, 77, 63, -7, -63, 124, -35, -104, -14, -117, 80, 71, -99, 1, -120, -99, -62, 99, 48, -26, -88, 98, -63, -122, 111, -91]

2020-03-06 23:57:14.034 [DEBUG] [.hapjava.impl.pairing.PairingManager] - Entering second stage of pair for SN_openHAB

2020-03-06 23:57:14.324 [INFO ] [va.impl.http.HomekitClientConnection] - 200 /pair-setup

2020-03-06 23:57:14.331 [TRACE] [pl.http.impl.NettyHomekitHttpService] - WRITE PooledUnsafeDirectByteBuf(ridx: 0, widx: 172, cap: 232) [/192.168.0.87:54818]:

485454502F312E3120323030204F4B0D0A436F6E74656E742D747970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A436F6E74656E742D4C656E6774683A2036390D0A436F6E6E656374696F6E3A206B6565702D616C6976650D0A0D0A0601040440776AF9A9E109B70E7FC2C48471B3BA71EA62887968E229FDBC7AD6F4AAD14B8A16CA167ADF756A4DEB710C1F42CA7E868927BB9FF5928AECA7E51C11D76D5994

2020-03-06 23:57:14.385 [TRACE] [pl.http.impl.NettyHomekitHttpService] - READ PooledUnsafeDirectByteBuf(ridx: 0, widx: 283, cap: 1024) [/192.168.0.87:54818]:

504F5354202F706169722D736574757020485454502F312E310D0A486F73743A20534E5F6F70656E4841422E5F6861702E5F7463702E6C6F63616C0D0A436F6E74656E742D4C656E6774683A203135390D0A436F6E74656E742D547970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A0D0A059A9E624618F5EA83F4B2998EE41C4112D47052760E1F391B45FA50F96C6E31F0CEABD56B4FF30ED9766FF731B379DEBCBB505F9261F65E8E894053708A6A903DD92B156FB9300A9857449068FF1B2C9B56793F62FB1C7826F31FC34005E4AE160585A47DA852FA775E8B8090000723449F2212F80A492443EE4E509745A3DB1260E5F942E5B9B30C6CEBC55189682018954E29CE5C4234406635CF060105

2020-03-06 23:57:14.387 [TRACE] [http.impl.FullRequestHttpRequestImpl] - received [5, -102, -98, 98, 70, 24, -11, -22, -125, -12, -78, -103, -114, -28, 28, 65, 18, -44, 112, 82, 118, 14, 31, 57, 27, 69, -6, 80, -7, 108, 110, 49, -16, -50, -85, -43, 107, 79, -13, 14, -39, 118, 111, -9, 49, -77, 121, -34, -68, -69, 80, 95, -110, 97, -10, 94, -114, -119, 64, 83, 112, -118, 106, -112, 61, -39, 43, 21, 111, -71, 48, 10, -104, 87, 68, -112, 104, -1, 27, 44, -101, 86, 121, 63, 98, -5, 28, 120, 38, -13, 31, -61, 64, 5, -28, -82, 22, 5, -123, -92, 125, -88, 82, -6, 119, 94, -117, -128, -112, 0, 7, 35, 68, -97, 34, 18, -8, 10, 73, 36, 67, -18, 78, 80, -105, 69, -93, -37, 18, 96, -27, -7, 66, -27, -71, -77, 12, 108, -21, -59, 81, -119, 104, 32, 24, -107, 78, 41, -50, 92, 66, 52, 64, 102, 53, -49, 6, 1, 5]

2020-03-06 23:57:14.388 [DEBUG] [.hapjava.impl.pairing.PairingManager] - Entering third stage of pair for SN_openHAB

2020-03-06 23:57:14.423 [TRACE] [ub.hapjava.impl.crypto.ChachaDecoder] - calculated ‘[81, -119, 104, 32, 24, -107, 78, 41, -50, 92, 66, 52, 64, 102, 53, -49]’, received ‘[81, -119, 104, 32, 24, -107, 78, 41, -50, 92, 66, 52, 64, 102, 53, -49]’

2020-03-06 23:57:14.478 [INFO ] [va.impl.http.HomekitClientConnection] - 200 /pair-setup

2020-03-06 23:57:14.481 [TRACE] [pl.http.impl.NettyHomekitHttpService] - WRITE PooledUnsafeDirectByteBuf(ridx: 0, widx: 243, cap: 256) [/192.168.0.87:54818]:

485454502F312E3120323030204F4B0D0A436F6E74656E742D747970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A436F6E74656E742D4C656E6774683A203133390D0A436F6E6E656374696F6E3A206B6565702D616C6976650D0A0D0A0601060586C4CAB689A3C978B595064C915E2318744634ABA84D3CA4CF3494E670EAC3C332308149F265C6DA70B9A66B7B5909F346D3E1CC92E6299CAD9580BF70875A7038631F8D5B937E63AE06B84E11BED9113261ADF4A9453291A4A41CA5189DE5A9CC79B269E3F210CAB00872230CC3A43CA98F35EF35C2517D0359A4E4D32C0D9A934CD692075C01

2020-03-06 23:57:14.569 [INFO ] [java.impl.http.impl.AccessoryHandler] - Terminated homekit connection from /192.168.0.87:54818

2020-03-06 23:57:14.579 [INFO ] [java.impl.http.impl.AccessoryHandler] - New homekit connection from /192.168.0.87:54819

2020-03-06 23:57:14.581 [TRACE] [pl.http.impl.NettyHomekitHttpService] - READ PooledUnsafeDirectByteBuf(ridx: 0, widx: 161, cap: 1024) [/192.168.0.87:54819]:

504F5354202F706169722D76657269667920485454502F312E310D0A486F73743A20534E5F6F70656E4841422E5F6861702E5F7463702E6C6F63616C0D0A436F6E74656E742D4C656E6774683A2033370D0A436F6E74656E742D547970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A0D0A0601010320C3666A4FFCE37FA4D65B8C8F75C5CE40CD53A62FB12714E9366EECB9396EA429

2020-03-06 23:57:14.586 [TRACE] [http.impl.FullRequestHttpRequestImpl] - received [6, 1, 1, 3, 32, -61, 102, 106, 79, -4, -29, 127, -92, -42, 91, -116, -113, 117, -59, -50, 64, -51, 83, -90, 47, -79, 39, 20, -23, 54, 110, -20, -71, 57, 110, -92, 41]

2020-03-06 23:57:14.591 [DEBUG] [impl.pairing.PairVerificationManager] - Starting pair verification for SN_openHAB

2020-03-06 23:57:14.623 [INFO ] [va.impl.http.HomekitClientConnection] - 200 /pair-verify

2020-03-06 23:57:14.625 [TRACE] [pl.http.impl.NettyHomekitHttpService] - WRITE PooledUnsafeDirectByteBuf(ridx: 0, widx: 243, cap: 256) [/192.168.0.87:54819]:

485454502F312E3120323030204F4B0D0A436F6E74656E742D747970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A436F6E74656E742D4C656E6774683A203133390D0A436F6E6E656374696F6E3A206B6565702D616C6976650D0A0D0A060102056447E2FE72091460F74B0D90B41F65C1ECEC9A27D77995ED644C327509743C4B45FDA7D0AEE0392E3D43FF24E1C32B32EA1EEAAC7D0F453B3D82D79823A3918577EA12D5BA90EA370812D55A4C83025861B0F59CD98447E00F26CC0DCEBD34517FB720CF8E03206A14BF65911C4EB62741C9D8D3099A473F5AB28ADC31045C0B5A365B8B91412D

2020-03-06 23:57:14.740 [TRACE] [pl.http.impl.NettyHomekitHttpService] - READ PooledUnsafeDirectByteBuf(ridx: 0, widx: 250, cap: 1024) [/192.168.0.87:54819]:

504F5354202F706169722D76657269667920485454502F312E310D0A486F73743A20534E5F6F70656E4841422E5F6861702E5F7463702E6C6F63616C0D0A436F6E74656E742D4C656E6774683A203132350D0A436F6E74656E742D547970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A0D0A05788495DB7BFAE70C4A61251D90D9A201D8227E4B872B7A9BFE22BAC2378C78A905B66347C1BA6D987C107B27DDBB98B60510C1895CF854A8CF0D9724FC67A608D90E0C4FF3A19E3E2893242058F43295085FFFAA4230A4F589E31DFCA83E2D43FED8BA179D9E29DE59E622F674D0BF29E30D8887FB8342BC9E060103

2020-03-06 23:57:14.742 [TRACE] [http.impl.FullRequestHttpRequestImpl] - received [5, 120, -124, -107, -37, 123, -6, -25, 12, 74, 97, 37, 29, -112, -39, -94, 1, -40, 34, 126, 75, -121, 43, 122, -101, -2, 34, -70, -62, 55, -116, 120, -87, 5, -74, 99, 71, -63, -70, 109, -104, 124, 16, 123, 39, -35, -69, -104, -74, 5, 16, -63, -119, 92, -8, 84, -88, -49, 13, -105, 36, -4, 103, -90, 8, -39, 14, 12, 79, -13, -95, -98, 62, 40, -109, 36, 32, 88, -12, 50, -107, 8, 95, -1, -86, 66, 48, -92, -11, -119, -29, 29, -4, -88, 62, 45, 67, -2, -40, -70, 23, -99, -98, 41, -34, 89, -26, 34, -10, 116, -48, -65, 41, -29, 13, -120, -121, -5, -125, 66, -68, -98, 6, 1, 3]

2020-03-06 23:57:14.744 [TRACE] [ub.hapjava.impl.crypto.ChachaDecoder] - calculated ‘[-26, 34, -10, 116, -48, -65, 41, -29, 13, -120, -121, -5, -125, 66, -68, -98]’, received ‘[-26, 34, -10, 116, -48, -65, 41, -29, 13, -120, -121, -5, -125, 66, -68, -98]’

2020-03-06 23:57:14.752 [DEBUG] [impl.pairing.PairVerificationManager] - Completed pair verification for SN_openHAB

2020-03-06 23:57:14.755 [INFO ] [va.impl.http.HomekitClientConnection] - 200 /pair-verify

2020-03-06 23:57:14.763 [TRACE] [pl.http.impl.NettyHomekitHttpService] - WRITE PooledUnsafeDirectByteBuf(ridx: 0, widx: 105, cap: 256) [/192.168.0.87:54819]:

485454502F312E3120323030204F4B0D0A436F6E74656E742D747970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A436F6E74656E742D4C656E6774683A20330D0A436F6E6E656374696F6E3A206B6565702D616C6976650D0A0D0A060104

2020-03-06 23:57:14.769 [TRACE] [pl.http.impl.NettyHomekitHttpService] - READ PooledUnsafeDirectByteBuf(ridx: 0, widx: 81, cap: 512) [/192.168.0.87:54819]:

3F00F0D565D11E4EB0852ACCF854828D79A762A10966C39AC12E00661A74337B647BFFA6E07C11F2A073798DE05E34ABB78D1322118816311DD780B5DB6217B88FC46AF57DB9F54D44C0518D5C1C792312

2020-03-06 23:57:14.772 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Received message of length 81. Existing buffer is 0

2020-03-06 23:57:14.774 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Attempting to read message of length 81

2020-03-06 23:57:14.775 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Read complete message

2020-03-06 23:57:14.776 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Returning 1 results

2020-03-06 23:57:14.781 [TRACE] [ub.hapjava.impl.crypto.ChachaDecoder] - calculated ‘[-60, 106, -11, 125, -71, -11, 77, 68, -64, 81, -115, 92, 28, 121, 35, 18]’, received ‘[-60, 106, -11, 125, -71, -11, 77, 68, -64, 81, -115, 92, 28, 121, 35, 18]’

2020-03-06 23:57:14.783 [DEBUG] [hapjava.impl.http.impl.BinaryHandler] - Received data [/192.168.0.87:54819]:

GET /accessories HTTP/1.1

Host: SN_openHAB._hap._tcp.local

2020-03-06 23:57:14.852 [INFO ] [va.impl.http.HomekitClientConnection] - 200 /accessories

2020-03-06 23:57:14.854 [DEBUG] [hapjava.impl.http.impl.BinaryHandler] - Sending data [/192.168.0.87:54819]:

HTTP/1.1 200 OK

Content-type: application/hap+json

Content-Length: 784

Connection: keep-alive

{“accessories”:[{“aid”:1,“services”:[{“iid”:1,“type”:“3E”,“characteristics”:[{“iid”:2,“type”:“23”,“perms”:[“pr”],“format”:“string”,“ev”:false,“description”:“Name of the accessory”,“value”:“SN_openHAB”,“maxLen”:255},{“iid”:3,“type”:“20”,“perms”:[“pr”],“format”:“string”,“ev”:false,“description”:“The name of the manufacturer”,“value”:“openHAB”,“maxLen”:255},{“iid”:4,“type”:“21”,“perms”:[“pr”],“format”:“string”,“ev”:false,“description”:“The name of the model”,“value”:“2.5.2”,“maxLen”:255},{“iid”:5,“type”:“30”,“perms”:[“pr”],“format”:“string”,“ev”:false,“description”:“The serial number of the accessory”,“value”:“none”,“maxLen”:255},{“iid”:6,“type”:“14”,“perms”:[“pw”],“format”:“bool”,“ev”:false,“description”:“Identifies the accessory via a physical action on the accessory”}]}]}]}

2020-03-06 23:57:14.857 [TRACE] [pl.http.impl.NettyHomekitHttpService] - WRITE PooledUnsafeDirectByteBuf(ridx: 0, widx: 902, cap: 1024) [/192.168.0.87:54819]:

74030B1B1ABB0E2DF8CDCFC1554EBB5FA3B54F7C83C450F93E19A4A3FD1C3900C6BFC54094367C43A015BC58EFA735289998315986FEBE90A68BE05B6387C76DEB6158B4B441D7049A1A5F34EF2A42A82EE08DA4574F73B3F708928F378E8365C32D36AB249464CA506C9C0925C8708B44072238EA3592022CC00907FAEDABD3A7B117AE7FAB26F98B62EDD4EC3D74689AE2682EB22D25064696E7681D5DAC9A28335A85C069A45579A87BE7F715231D491CB0C36C50DAE495FD64A6566C43A900C715EAA2800515542316272AF461F472E1DD05C647E71454333DBA72C0583688133C790E7914BA68F541216E5DD85599F43C2E123A9EB8258C492E3830FA44B902D526BABB6416EDAA6982A64A63FEB53A2FEB66AA5B61C939B706DE63DE86D95C70D0CFFF8AC684E325041A33A06D8E1F2B8C2184C4D16FFDC8772A68FDF4BFD73E995A22B8A2BAD318CBF4416412E029AD9F890DC67993F47C8CC39B80629A3F830E723DB0AB421A02762B93362930F55C7E4C5A0295012DD266149A889E52CEBBD2AE4B9491B57EDA6AB0D39CDFD00240E71F0489A74BBB85E141DA3499987B04348635052EDBC06274ED86588365B8942CD579EF8E6FACB42555BD93FA620630A3B83B3A72781B41999D3CE7C920946256ECE1804C8F23472613723D351B02CD445FA3B64FD676CBF8595A353A3A9C05250235F324F377B1EC469607D6B08C797A1DB601C2B26679A339AADF30F41FF25564545BCBDF336F4879B7037CAE36561E40A9AAF8BFC76A37044169D21AC3A672368FC1F082054B7698B379F5879E38368B14A9F2920663B77E47857C57412FC6A119B059932BC2AC9677F29DA3198BC24EFD5045B73788722DA19D2A50B6A4A93650F43233AAE99AABC25B32C141337D06B6A5E017CC74FF55CEE3C0FB1C532769B020B6A2FF5D2782531DA9FBE31B43D0811D9673A91665104A39FCB2A4FE93C659F95651B339CB4F11FC12F3CF8379DBA9D66DD976134ADE064C60A096DA79AFF19A0AA2A530A8438FCB40316705098F3AD8747D477947C61688E316CD147677B0CDE05A72C7133176A3AAB7200C1DF3B073D30DE4246E9BDED77723B683EF9E669047B26B975FC9183FC2FF47AE0433D3911B52084FD8A0387465F7A4828648BDE7C7E5BC65CE4B4A4FA550E83A766BC6E9C942EDBACEF7B4BFBDE4B0ACE5499D68087F5DA06B26B04B7525226E849ED402CAB168AE98CCE19FE3A3881588C202FA6829C5B54044F82746EAA469C79FB8

2020-03-06 23:57:17.438 [INFO ] [java.impl.http.impl.AccessoryHandler] - New homekit connection from /192.168.0.38:62943

2020-03-06 23:57:17.440 [TRACE] [pl.http.impl.NettyHomekitHttpService] - READ PooledUnsafeDirectByteBuf(ridx: 0, widx: 161, cap: 1024) [/192.168.0.38:62943]:

504F5354202F706169722D76657269667920485454502F312E310D0A486F73743A20534E5F6F70656E4841422E5F6861702E5F7463702E6C6F63616C0D0A436F6E74656E742D4C656E6774683A2033370D0A436F6E74656E742D547970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A0D0A060101032031DA5BA54802FF8706AA88F416E7FCE058341F366B78A5DC3090126BA6B70157

2020-03-06 23:57:17.445 [TRACE] [http.impl.FullRequestHttpRequestImpl] - received [6, 1, 1, 3, 32, 49, -38, 91, -91, 72, 2, -1, -121, 6, -86, -120, -12, 22, -25, -4, -32, 88, 52, 31, 54, 107, 120, -91, -36, 48, -112, 18, 107, -90, -73, 1, 87]

2020-03-06 23:57:17.447 [DEBUG] [impl.pairing.PairVerificationManager] - Starting pair verification for SN_openHAB

2020-03-06 23:57:17.468 [INFO ] [va.impl.http.HomekitClientConnection] - 200 /pair-verify

2020-03-06 23:57:17.527 [TRACE] [pl.http.impl.NettyHomekitHttpService] - WRITE PooledUnsafeDirectByteBuf(ridx: 0, widx: 243, cap: 256) [/192.168.0.38:62943]:

485454502F312E3120323030204F4B0D0A436F6E74656E742D747970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A436F6E74656E742D4C656E6774683A203133390D0A436F6E6E656374696F6E3A206B6565702D616C6976650D0A0D0A0601020564A012A17215C53384E55A0AEB77E730A9B2503A5B618B2E9761B908CE043CBBBC3DD45DDF8125F84340BF86CB49BC9B2555880262AA05454694AEB49773BC7F416EB89AB932AD881603670B0BACEFD1B0693DCD86F75AD4A2693E88B7F81F6AB65FC9E45D03200BF24A5F351F61E5A1755E56C63EC2C6793CC182734159D2B5466092B9E9092A

2020-03-06 23:57:17.541 [TRACE] [pl.http.impl.NettyHomekitHttpService] - READ PooledUnsafeDirectByteBuf(ridx: 0, widx: 250, cap: 1024) [/192.168.0.38:62943]:

504F5354202F706169722D76657269667920485454502F312E310D0A486F73743A20534E5F6F70656E4841422E5F6861702E5F7463702E6C6F63616C0D0A436F6E74656E742D4C656E6774683A203132350D0A436F6E74656E742D547970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A0D0A0578A1DAEA46C8D9744C00C72B88FF18437F5AE9FF855404016768D7859603A06EB41CA339A9ED7124CAE041F05BCADDB82512E15C73E9516693BE71BEF77B9CFB725EA66247597180428DC7B5E4359E215B31643EA4305A313BA12754CC0FF3C78DF5ADAB1F0F7D406C4A8A3885E39063AE9633575AEED08FBF060103

2020-03-06 23:57:17.544 [TRACE] [http.impl.FullRequestHttpRequestImpl] - received [5, 120, -95, -38, -22, 70, -56, -39, 116, 76, 0, -57, 43, -120, -1, 24, 67, 127, 90, -23, -1, -123, 84, 4, 1, 103, 104, -41, -123, -106, 3, -96, 110, -76, 28, -93, 57, -87, -19, 113, 36, -54, -32, 65, -16, 91, -54, -35, -72, 37, 18, -31, 92, 115, -23, 81, 102, -109, -66, 113, -66, -9, 123, -100, -5, 114, 94, -90, 98, 71, 89, 113, -128, 66, -115, -57, -75, -28, 53, -98, 33, 91, 49, 100, 62, -92, 48, 90, 49, 59, -95, 39, 84, -52, 15, -13, -57, -115, -11, -83, -85, 31, 15, 125, 64, 108, 74, -118, 56, -123, -29, -112, 99, -82, -106, 51, 87, 90, -18, -48, -113, -65, 6, 1, 3]

2020-03-06 23:57:17.550 [TRACE] [ub.hapjava.impl.crypto.ChachaDecoder] - calculated ‘[74, -118, 56, -123, -29, -112, 99, -82, -106, 51, 87, 90, -18, -48, -113, -65]’, received ‘[74, -118, 56, -123, -29, -112, 99, -82, -106, 51, 87, 90, -18, -48, -113, -65]’

2020-03-06 23:57:17.579 [DEBUG] [impl.pairing.PairVerificationManager] - Completed pair verification for SN_openHAB

2020-03-06 23:57:17.587 [INFO ] [va.impl.http.HomekitClientConnection] - 200 /pair-verify

2020-03-06 23:57:17.593 [TRACE] [pl.http.impl.NettyHomekitHttpService] - WRITE PooledUnsafeDirectByteBuf(ridx: 0, widx: 105, cap: 256) [/192.168.0.38:62943]:

485454502F312E3120323030204F4B0D0A436F6E74656E742D747970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A436F6E74656E742D4C656E6774683A20330D0A436F6E6E656374696F6E3A206B6565702D616C6976650D0A0D0A060104

2020-03-06 23:57:17.600 [TRACE] [pl.http.impl.NettyHomekitHttpService] - READ PooledUnsafeDirectByteBuf(ridx: 0, widx: 81, cap: 512) [/192.168.0.38:62943]:

3F001906878AC4EED4B5B6242BD41FB46D5D75DF071AE3E3D1D2BA08E1C32F198BA52435E221D75D7BC9E0D959F06A926E4D5B164A70CA7A67AF0B25EEFF65EA07EE709CD937B251A4FC76008D590A6AAC

2020-03-06 23:57:17.602 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Received message of length 81. Existing buffer is 0

2020-03-06 23:57:17.603 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Attempting to read message of length 81

2020-03-06 23:57:17.605 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Read complete message

2020-03-06 23:57:17.606 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Returning 1 results

2020-03-06 23:57:17.607 [TRACE] [ub.hapjava.impl.crypto.ChachaDecoder] - calculated ‘[-18, 112, -100, -39, 55, -78, 81, -92, -4, 118, 0, -115, 89, 10, 106, -84]’, received ‘[-18, 112, -100, -39, 55, -78, 81, -92, -4, 118, 0, -115, 89, 10, 106, -84]’

2020-03-06 23:57:17.610 [DEBUG] [hapjava.impl.http.impl.BinaryHandler] - Received data [/192.168.0.38:62943]:

GET /accessories HTTP/1.1

Host: SN_openHAB._hap._tcp.local

2020-03-06 23:57:17.629 [INFO ] [va.impl.http.HomekitClientConnection] - 200 /accessories

2020-03-06 23:57:17.631 [DEBUG] [hapjava.impl.http.impl.BinaryHandler] - Sending data [/192.168.0.38:62943]:

HTTP/1.1 200 OK

Content-type: application/hap+json

Content-Length: 784

Connection: keep-alive

{“accessories”:[{“aid”:1,“services”:[{“iid”:1,“type”:“3E”,“characteristics”:[{“iid”:2,“type”:“23”,“perms”:[“pr”],“format”:“string”,“ev”:false,“description”:“Name of the accessory”,“value”:“SN_openHAB”,“maxLen”:255},{“iid”:3,“type”:“20”,“perms”:[“pr”],“format”:“string”,“ev”:false,“description”:“The name of the manufacturer”,“value”:“openHAB”,“maxLen”:255},{“iid”:4,“type”:“21”,“perms”:[“pr”],“format”:“string”,“ev”:false,“description”:“The name of the model”,“value”:“2.5.2”,“maxLen”:255},{“iid”:5,“type”:“30”,“perms”:[“pr”],“format”:“string”,“ev”:false,“description”:“The serial number of the accessory”,“value”:“none”,“maxLen”:255},{“iid”:6,“type”:“14”,“perms”:[“pw”],“format”:“bool”,“ev”:false,“description”:“Identifies the accessory via a physical action on the accessory”}]}]}]}

2020-03-06 23:57:17.635 [TRACE] [pl.http.impl.NettyHomekitHttpService] - WRITE PooledUnsafeDirectByteBuf(ridx: 0, widx: 902, cap: 1024) [/192.168.0.38:62943]:

7403B7B79B0E1750901D91955AF35FD2B39FEEA21E8756BEA74812980B4EF9BFCF7B9ABA182AA3859AD42CBA7A4600F6EB2DBD0350F96579B1FDD75BD942B9B628AB5CBE7B62B41CA6E5A49A93E7BD76D30A56335DA231F76F54E251D6C0147B61612895C4F83DDB0CC27E1CCA70376A2B13F5AE7201FE2EC78D00C5410C0AF615DB3912F95E8A07A77AB5B22FF11F72E79E73272987DCE01CC18631A8D14AFDDB6F259AF4CA2C141D80D590FEB9256A925D881BC2FC6F509C35847D2FAE56F12C18E57AA6D82E1E5AD8B08DEC54DBE43397C0F1D630434775A1B5281ADD724E969ED0461689CDE27458656FF2CAFB6A5DE38B4463F8FD73A8D5C59E4B93EBCD4BFEC68401AD9C2D212540B8C77E439518CD3C721406CDF3F8A71743ECCA0172A1988F508970ADFC509B0A72A2619F434C2E21784BEF4662AA8957CD9CDCC9FE1919E06DD9043B18A6B47D1F36E1F6C51EBBF67B113C3F94E9E03D2090CA586E85B501D20D333B864F420A029DC34B2AE46BE879D5C14126BBB141295F560C8267B441F2DAD718D944255F3CC35382EF03B591D7230435DE5684D1010505750AF5EBC8493F66855E32F42A120EFB547B8CA72715721CF451782E655562375F329CCC2422C7538C249B49EDD661409AF6ED8B2CADE3A7D9E233EA50752719D7541B9310B50081FDBAE099DF39CED45681526D664631C30736950AEF0CBD2621FA5718182610D120F873EAF6EF8173F6696D91387AEA7948A488988C7468C9259A8A522FEA8B5156E8DC4D69C486351E69E04E731E80D60BA131B0E44E43DB7C8ED1D85B07A93E84FAAA35E254617482002CF2C69358999AC56042E2E5A4779742292E4DB2B493D59F8EA0A828DA6732367BA2A548CB306F1AF70F99CEA6EE04B09C55282C72289FD9DF6E8E8A5CB79ECBA6A051336123689474FDA929B1F08DCAD578623EE9582DFB8B5E780B517BCA53384EC4BF25896D63BB68F57712946668B67C3965E6DAACF4A07346AB25AD69B535F34CDD272139477BE8E823BA7B45DA0B07327C81AB2F6DA3E867DCAB24F943AE07EF7589DBA845990A12B29F1D9AAAC6370205E79E9FC01189DB46B797EC3EE9C76D2DCDBD12ECB0590D54E4BFDBC0B2EB764A69FC8F9C7929F1D4AD7E812C43482DDAFE759F5FDC9DB06B6233F0E46F23075E4ED298263AFD98668B46A4EF00879BB9818D9CF8A650462350FECD3EA25207E5A0C7DA4F8CE756F3D0327706E0CBD2DDC61AC9A0FAFB52FB7797067D2C0E1943EDD1

2020-03-06 23:58:29.939 [WARN ] [okhttp3.OkHttpClient ] - A connection to https://myopenhab.org/ was leaked. Did you forget to close a response body? To see where this was allocated, set the OkHttpClient logger level to FINE: Logger.getLogger(OkHttpClient.class.getName()).setLevel(Level.FINE);

2020-03-06 23:58:29.941 [WARN ] [okhttp3.OkHttpClient ] - A connection to https://myopenhab.org/ was leaked. Did you forget to close a response body? To see where this was allocated, set the OkHttpClient logger level to FINE: Logger.getLogger(OkHttpClient.class.getName()).setLevel(Level.FINE);

2020-03-06 23:58:29.944 [WARN ] [okhttp3.OkHttpClient ] - A connection to https://myopenhab.org/ was leaked. Did you forget to close a response body? To see where this was allocated, set the OkHttpClient logger level to FINE: Logger.getLogger(OkHttpClient.class.getName()).setLevel(Level.FINE);

items are not marked as homekit items. you need to add label “Lighting” to your device “Power”. i do it by adding [“Lighting”] in items.xml

pay attention to lines in logging after
GET /accessories HTTP/1.1

it lists all homekit items. in you case it has only the bridge. so, add homekit labels to your items and check that these items appears in the accessories lists in log.

{“accessories”:[{“aid”:1,“services”:[{“iid”:1,“type”:“3E”,“characteristics”:[{“iid”:2,“type”:“23”,“perms”:[“pr”],“format”:“string”,“ev”:false,“description”:“Name of the accessory”,“value”:“SN_openHAB”,“maxLen”:255},{“iid”:3,“type”:“20”,“perms”:[“pr”],“format”:“string”,“ev”:false,“description”:“The name of the manufacturer”,“value”:“openHAB”,“maxLen”:255},{“iid”:4,“type”:“21”,“perms”:[“pr”],“format”:“string”,“ev”:false,“description”:“The name of the model”,“value”:“2.5.2”,“maxLen”:255},{“iid”:5,“type”:“30”,“perms”:[“pr”],“format”:“string”,“ev”:false,“description”:“The serial number of the accessory”,“value”:“none”,“maxLen”:255},{“iid”:6,“type”:“14”,“perms”:[“pw”],“format”:“bool”,“ev”:false,“description”:“Identifies the accessory via a physical action on the accessory”}]}]}]}

1 Like

You are my hero Eugen! :partying_face:
Spasibo for your support! :wink:

BR, Sergo

1 Like

you are welcome! happy that it works for you now.
it looks like we should update the documentation.

and mine too :slight_smile: