Running Openhab 2.5.5 on CentOS 7.7
I’m trying to get Homekit to see my Openhab Environment.
I’ve done the
smarthome:homekit clearPairings
and see the need to repair in the logs, but don’t see anything when I repair.
I’ve removed the /var/lib/openhab2/cache/* and /var/lib/openhab2/tmp/* directories with no help.
I have changed my items file to only expose one item to HomeKit which I see when I do
openhab> smarthome:homekit listAccessories
1246407112 Dining Room Light
So it seems that it is there just unable to see it in HomeKit when I pair my phone running iOS 13.3.1.
Here is my entry in my items file:
Dimmer DiningRoom "Dining Room Light" [ "Lighting" ] { channel="zwave:device:46e495e3:node11:switch_dimmer" }
My openhab.log file is as follows from start of service:
2020-05-25 17:36:02.800 [INFO ] [panel.internal.HABPanelDashboardTile] - Stopped HABPanel
2020-05-25 17:36:02.831 [INFO ] [ebuilder.internal.HomeBuilderServlet] - Stopped Home Builder
2020-05-25 17:36:02.835 [INFO ] [openhab.ui.paper.internal.PaperUIApp] - Stopped Paper UI
2020-05-25 17:36:02.855 [INFO ] [.dashboard.internal.DashboardService] - Stopped Dashboard
2020-05-25 17:36:15.709 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Time zone set to 'America/Edmonton'.
2020-05-25 17:36:15.735 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Location set to '51.4526907,-113.8256959'.
2020-05-25 17:36:15.736 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Locale set to 'en_CA'.
2020-05-25 17:36:15.736 [INFO ] [.core.internal.i18n.I18nProviderImpl] - Measurement system set to 'SIUnits'.
2020-05-25 17:36:22.042 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'House.items'
2020-05-25 17:36:22.507 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'rrd4j.persist'
2020-05-25 17:36:23.083 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'House.things'
2020-05-25 17:36:23.102 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'echo.things'
2020-05-25 17:36:25.523 [INFO ] [thome.model.lsp.internal.ModelServer] - Started Language Server Protocol (LSP) service on port 5007
2020-05-25 17:36:27.342 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'StairLight.rules'
2020-05-25 17:36:27.691 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'FrontDoorLight.rules'
2020-05-25 17:36:29.478 [INFO ] [.dashboard.internal.DashboardService] - Started Dashboard at http://192.168.1.21:8080
2020-05-25 17:36:29.479 [INFO ] [.dashboard.internal.DashboardService] - Started Dashboard at https://192.168.1.21:8443
2020-05-25 17:36:32.693 [INFO ] [ternal.dhcp.DHCPPacketListenerServer] - DHCP request packet listener online
2020-05-25 17:36:33.059 [INFO ] [b.core.service.AbstractActiveService] - HTTP Refresh Service has been started
2020-05-25 17:36:33.255 [INFO ] [.handler.FlashBriefingProfileHandler] - FlashBriefingProfileHandler initialized
2020-05-25 17:36:33.286 [INFO ] [.handler.FlashBriefingProfileHandler] - FlashBriefingProfileHandler initialized
2020-05-25 17:36:33.808 [INFO ] [.onkyo.internal.handler.OnkyoHandler] - Using configuration: ipAddress = 192.168.1.145, port = 60128, udn = 50b0e9c6-11e9-c6b9-37e0-c60911b918a1, refreshInterval = 0, volumeLimit = 100, volumeScale = 1.0
2020-05-25 17:36:36.219 [INFO ] [ui.habmin.internal.servlet.HABminApp] - Started HABmin servlet at /habmin
2020-05-25 17:36:36.422 [INFO ] [panel.internal.HABPanelDashboardTile] - Started HABPanel at /habpanel
2020-05-25 17:36:36.609 [WARN ] [org.eclipse.jetty.server.HttpChannel] - /rest/events
javax.servlet.ServletException: javax.servlet.ServletException: A MultiException has 1 exceptions. They are:
1. java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_1,2,2077737649) has been shut down
at org.ops4j.pax.web.service.jetty.internal.JettyServerHandlerCollection.handle(JettyServerHandlerCollection.java:88) ~[bundleFile:?]
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.Server.handle(Server.java:494) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:374) [bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:268) [bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311) [bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103) [bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117) [bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:336) [bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:313) [bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171) [bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:129) [bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:367) [bundleFile:9.4.20.v20190813]
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(Unknown Source) [?:1.8.0_131]
Caused by: javax.servlet.ServletException: A MultiException has 1 exceptions. They are:
1. java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_1,2,2077737649) has been shut down
at org.glassfish.jersey.servlet.WebComponent.serviceImpl(WebComponent.java:489) ~[?:?]
at org.glassfish.jersey.servlet.WebComponent.service(WebComponent.java:427) ~[?:?]
at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:388) ~[?:?]
at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:341) ~[?:?]
at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:228) ~[?:?]
at com.eclipsesource.jaxrs.publisher.internal.ServletContainerBridge.service(ServletContainerBridge.java:76) ~[?:?]
at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:852) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:544) ~[bundleFile:9.4.20.v20190813]
at org.ops4j.pax.web.service.jetty.internal.HttpServiceServletHandler.doHandle(HttpServiceServletHandler.java:71) ~[bundleFile:?]
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:536) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:235) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1581) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1307) ~[bundleFile:9.4.20.v20190813]
at org.ops4j.pax.web.service.jetty.internal.HttpServiceContext.doHandle(HttpServiceContext.java:293) ~[bundleFile:?]
at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:482) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1549) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1204) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) ~[bundleFile:9.4.20.v20190813]
at org.ops4j.pax.web.service.jetty.internal.JettyServerHandlerCollection.handle(JettyServerHandlerCollection.java:80) ~[bundleFile:?]
... 15 more
Caused by: org.glassfish.hk2.api.MultiException: A MultiException has 1 exceptions. They are:
1. java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_1,2,2077737649) has been shut down
at org.jvnet.hk2.internal.FactoryCreator.getFactoryHandle(FactoryCreator.java:106) ~[?:?]
at org.jvnet.hk2.internal.FactoryCreator.dispose(FactoryCreator.java:173) ~[?:?]
at org.jvnet.hk2.internal.SystemDescriptor.dispose(SystemDescriptor.java:526) ~[?:?]
at org.glassfish.jersey.process.internal.RequestScope$Instance.remove(RequestScope.java:532) ~[?:?]
at org.glassfish.jersey.process.internal.RequestScope$Instance.release(RequestScope.java:549) ~[?:?]
at org.glassfish.jersey.process.internal.RequestScope.runInScope(RequestScope.java:319) ~[?:?]
at org.glassfish.jersey.server.ServerRuntime.process(ServerRuntime.java:305) ~[?:?]
at org.glassfish.jersey.server.ApplicationHandler.handle(ApplicationHandler.java:1154) ~[?:?]
at org.glassfish.jersey.servlet.WebComponent.serviceImpl(WebComponent.java:473) ~[?:?]
at org.glassfish.jersey.servlet.WebComponent.service(WebComponent.java:427) ~[?:?]
at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:388) ~[?:?]
at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:341) ~[?:?]
at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:228) ~[?:?]
at com.eclipsesource.jaxrs.publisher.internal.ServletContainerBridge.service(ServletContainerBridge.java:76) ~[?:?]
at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:852) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:544) ~[bundleFile:9.4.20.v20190813]
at org.ops4j.pax.web.service.jetty.internal.HttpServiceServletHandler.doHandle(HttpServiceServletHandler.java:71) ~[bundleFile:?]
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:536) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:235) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1581) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1307) ~[bundleFile:9.4.20.v20190813]
at org.ops4j.pax.web.service.jetty.internal.HttpServiceContext.doHandle(HttpServiceContext.java:293) ~[bundleFile:?]
at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:482) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1549) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1204) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) ~[bundleFile:9.4.20.v20190813]
at org.ops4j.pax.web.service.jetty.internal.JettyServerHandlerCollection.handle(JettyServerHandlerCollection.java:80) ~[bundleFile:?]
... 15 more
Caused by: java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_1,2,2077737649) has been shut down
at org.jvnet.hk2.internal.ServiceLocatorImpl.checkState(ServiceLocatorImpl.java:2288) ~[?:?]
at org.jvnet.hk2.internal.ServiceLocatorImpl.getServiceHandleImpl(ServiceLocatorImpl.java:629) ~[?:?]
at org.jvnet.hk2.internal.ServiceLocatorImpl.getServiceHandle(ServiceLocatorImpl.java:622) ~[?:?]
at org.jvnet.hk2.internal.ServiceLocatorImpl.getServiceHandle(ServiceLocatorImpl.java:640) ~[?:?]
at org.jvnet.hk2.internal.FactoryCreator.getFactoryHandle(FactoryCreator.java:103) ~[?:?]
at org.jvnet.hk2.internal.FactoryCreator.dispose(FactoryCreator.java:173) ~[?:?]
at org.jvnet.hk2.internal.SystemDescriptor.dispose(SystemDescriptor.java:526) ~[?:?]
at org.glassfish.jersey.process.internal.RequestScope$Instance.remove(RequestScope.java:532) ~[?:?]
at org.glassfish.jersey.process.internal.RequestScope$Instance.release(RequestScope.java:549) ~[?:?]
at org.glassfish.jersey.process.internal.RequestScope.runInScope(RequestScope.java:319) ~[?:?]
at org.glassfish.jersey.server.ServerRuntime.process(ServerRuntime.java:305) ~[?:?]
at org.glassfish.jersey.server.ApplicationHandler.handle(ApplicationHandler.java:1154) ~[?:?]
at org.glassfish.jersey.servlet.WebComponent.serviceImpl(WebComponent.java:473) ~[?:?]
at org.glassfish.jersey.servlet.WebComponent.service(WebComponent.java:427) ~[?:?]
at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:388) ~[?:?]
at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:341) ~[?:?]
at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:228) ~[?:?]
at com.eclipsesource.jaxrs.publisher.internal.ServletContainerBridge.service(ServletContainerBridge.java:76) ~[?:?]
at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:852) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:544) ~[bundleFile:9.4.20.v20190813]
at org.ops4j.pax.web.service.jetty.internal.HttpServiceServletHandler.doHandle(HttpServiceServletHandler.java:71) ~[bundleFile:?]
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:536) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:235) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1581) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1307) ~[bundleFile:9.4.20.v20190813]
at org.ops4j.pax.web.service.jetty.internal.HttpServiceContext.doHandle(HttpServiceContext.java:293) ~[bundleFile:?]
at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:482) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1549) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1204) ~[bundleFile:9.4.20.v20190813]
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) ~[bundleFile:9.4.20.v20190813]
at org.ops4j.pax.web.service.jetty.internal.JettyServerHandlerCollection.handle(JettyServerHandlerCollection.java:80) ~[bundleFile:?]
... 15 more
2020-05-25 17:36:36.691 [INFO ] [ebuilder.internal.HomeBuilderServlet] - Started Home Builder at /homebuilder
2020-05-25 17:36:36.705 [INFO ] [io.openhabcloud.internal.CloudClient] - Connected to the openHAB Cloud service (UUID = e4ccf64f-733f-47b5-a104-569a1de0dcaa, base URL = http://localhost:8080)
2020-05-25 17:36:36.984 [INFO ] [openhab.ui.paper.internal.PaperUIApp] - Started Paper UI at /paperui
2020-05-25 17:36:37.127 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Last voice command
2020-05-25 17:36:37.156 [TRACE] [.accessories.HomekitAccessoryFactory] - item Echo_Living_Room_LastVoiceCommand meta data null tags []
2020-05-25 17:36:37.212 [TRACE] [mekit.internal.HomekitChangeListener] - Item Echo_Living_Room_LastVoiceCommand has groups []
2020-05-25 17:36:37.249 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Switch
2020-05-25 17:36:37.271 [TRACE] [.accessories.HomekitAccessoryFactory] - item FrontDoorLight meta data null tags []
2020-05-25 17:36:37.272 [TRACE] [mekit.internal.HomekitChangeListener] - Item FrontDoorLight has groups []
2020-05-25 17:36:37.272 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Temperature
2020-05-25 17:36:37.273 [TRACE] [.accessories.HomekitAccessoryFactory] - item Computer_Room_Temperature meta data null tags []
2020-05-25 17:36:37.273 [TRACE] [mekit.internal.HomekitChangeListener] - Item Computer_Room_Temperature has groups []
2020-05-25 17:36:37.273 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Color
2020-05-25 17:36:37.274 [TRACE] [.accessories.HomekitAccessoryFactory] - item MasterBedroom1_Color meta data null tags []
2020-05-25 17:36:37.274 [TRACE] [mekit.internal.HomekitChangeListener] - Item MasterBedroom1_Color has groups []
2020-05-25 17:36:37.274 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Observation time
2020-05-25 17:36:37.275 [TRACE] [.accessories.HomekitAccessoryFactory] - item ObservationTime0 meta data null tags []
2020-05-25 17:36:37.275 [TRACE] [mekit.internal.HomekitChangeListener] - Item ObservationTime0 has groups []
2020-05-25 17:36:37.275 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Observation time
2020-05-25 17:36:37.276 [TRACE] [.accessories.HomekitAccessoryFactory] - item ObservationTime1 meta data null tags []
2020-05-25 17:36:37.276 [TRACE] [mekit.internal.HomekitChangeListener] - Item ObservationTime1 has groups []
2020-05-25 17:36:37.277 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Door Open
2020-05-25 17:36:37.277 [TRACE] [.accessories.HomekitAccessoryFactory] - item Basement_Door_Status meta data null tags []
2020-05-25 17:36:37.277 [TRACE] [mekit.internal.HomekitChangeListener] - Item Basement_Door_Status has groups []
2020-05-25 17:36:37.278 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Temperature min
2020-05-25 17:36:37.278 [TRACE] [.accessories.HomekitAccessoryFactory] - item Temp_Min0 meta data null tags []
2020-05-25 17:36:37.278 [TRACE] [mekit.internal.HomekitChangeListener] - Item Temp_Min0 has groups []
2020-05-25 17:36:37.279 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Temperature min
2020-05-25 17:36:37.279 [TRACE] [.accessories.HomekitAccessoryFactory] - item Temp_Min1 meta data null tags []
2020-05-25 17:36:37.279 [TRACE] [mekit.internal.HomekitChangeListener] - Item Temp_Min1 has groups []
2020-05-25 17:36:37.280 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Temperature min
2020-05-25 17:36:37.280 [TRACE] [.accessories.HomekitAccessoryFactory] - item Temp_Min2 meta data null tags []
2020-05-25 17:36:37.281 [TRACE] [mekit.internal.HomekitChangeListener] - Item Temp_Min2 has groups []
2020-05-25 17:36:37.281 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Temperature feel
2020-05-25 17:36:37.281 [TRACE] [.accessories.HomekitAccessoryFactory] - item Temp_Feel meta data null tags []
2020-05-25 17:36:37.282 [TRACE] [mekit.internal.HomekitChangeListener] - Item Temp_Feel has groups []
2020-05-25 17:36:37.289 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Observation time
2020-05-25 17:36:37.289 [TRACE] [.accessories.HomekitAccessoryFactory] - item ObservationTime2 meta data null tags []
2020-05-25 17:36:37.322 [TRACE] [mekit.internal.HomekitChangeListener] - Item ObservationTime2 has groups []
2020-05-25 17:36:37.323 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Color Temperature
2020-05-25 17:36:37.323 [TRACE] [.accessories.HomekitAccessoryFactory] - item LivingRoomLeft_ColorTemperature meta data null tags []
2020-05-25 17:36:37.323 [TRACE] [mekit.internal.HomekitChangeListener] - Item LivingRoomLeft_ColorTemperature has groups []
2020-05-25 17:36:37.324 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Temperature max
2020-05-25 17:36:37.324 [TRACE] [.accessories.HomekitAccessoryFactory] - item Temp_Max0 meta data null tags []
2020-05-25 17:36:37.325 [TRACE] [mekit.internal.HomekitChangeListener] - Item Temp_Max0 has groups []
2020-05-25 17:36:37.325 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Temperature max
2020-05-25 17:36:37.325 [TRACE] [.accessories.HomekitAccessoryFactory] - item Temp_Max1 meta data null tags []
2020-05-25 17:36:37.326 [TRACE] [mekit.internal.HomekitChangeListener] - Item Temp_Max1 has groups []
2020-05-25 17:36:37.326 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Door Lock
2020-05-25 17:36:37.326 [TRACE] [.accessories.HomekitAccessoryFactory] - item FrontDoorLock_Status meta data null tags []
2020-05-25 17:36:37.327 [TRACE] [mekit.internal.HomekitChangeListener] - Item FrontDoorLock_Status has groups []
2020-05-25 17:36:37.327 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Temperature max
2020-05-25 17:36:37.327 [TRACE] [.accessories.HomekitAccessoryFactory] - item Temp_Max2 meta data null tags []
2020-05-25 17:36:37.328 [TRACE] [mekit.internal.HomekitChangeListener] - Item Temp_Max2 has groups []
2020-05-25 17:36:37.328 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Color Temperature
2020-05-25 17:36:37.328 [TRACE] [.accessories.HomekitAccessoryFactory] - item LivingRoomRight_ColorTemperature meta data null tags []
2020-05-25 17:36:37.329 [TRACE] [mekit.internal.HomekitChangeListener] - Item LivingRoomRight_ColorTemperature has groups []
2020-05-25 17:36:37.329 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Rain Amount
2020-05-25 17:36:37.329 [TRACE] [.accessories.HomekitAccessoryFactory] - item Rain0 meta data null tags []
2020-05-25 17:36:37.330 [TRACE] [mekit.internal.HomekitChangeListener] - Item Rain0 has groups []
2020-05-25 17:36:37.330 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Rain Amount
2020-05-25 17:36:37.330 [TRACE] [.accessories.HomekitAccessoryFactory] - item Rain2 meta data null tags []
2020-05-25 17:36:37.331 [TRACE] [mekit.internal.HomekitChangeListener] - Item Rain2 has groups []
2020-05-25 17:36:37.331 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Color
2020-05-25 17:36:37.331 [TRACE] [.accessories.HomekitAccessoryFactory] - item MasterBedroom2_Color meta data null tags []
2020-05-25 17:36:37.332 [TRACE] [mekit.internal.HomekitChangeListener] - Item MasterBedroom2_Color has groups []
2020-05-25 17:36:37.332 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Battery Level
2020-05-25 17:36:37.333 [TRACE] [.accessories.HomekitAccessoryFactory] - item FrontDoorLock_Battery meta data null tags []
2020-05-25 17:36:37.364 [TRACE] [mekit.internal.HomekitChangeListener] - Item FrontDoorLock_Battery has groups []
2020-05-25 17:36:37.365 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Rain Amount
2020-05-25 17:36:37.365 [TRACE] [.accessories.HomekitAccessoryFactory] - item Rain1 meta data null tags []
2020-05-25 17:36:37.366 [TRACE] [mekit.internal.HomekitChangeListener] - Item Rain1 has groups []
2020-05-25 17:36:37.381 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Text to Speech Volume
2020-05-25 17:36:37.382 [TRACE] [.accessories.HomekitAccessoryFactory] - item Echo_Living_Room_TTS_Volume meta data null tags []
2020-05-25 17:36:37.382 [TRACE] [mekit.internal.HomekitChangeListener] - Item Echo_Living_Room_TTS_Volume has groups []
2020-05-25 17:36:37.383 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Music Provider Id
2020-05-25 17:36:37.384 [TRACE] [.accessories.HomekitAccessoryFactory] - item Echo_Living_Room_MusicProviderId meta data null tags []
2020-05-25 17:36:37.386 [TRACE] [mekit.internal.HomekitChangeListener] - Item Echo_Living_Room_MusicProviderId has groups []
2020-05-25 17:36:37.387 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Play music voice command (Write Only)
2020-05-25 17:36:37.387 [TRACE] [.accessories.HomekitAccessoryFactory] - item Echo_Living_Room_PlayMusicCommand meta data null tags []
2020-05-25 17:36:37.389 [TRACE] [mekit.internal.HomekitChangeListener] - Item Echo_Living_Room_PlayMusicCommand has groups []
2020-05-25 17:36:37.389 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Color Temperature
2020-05-25 17:36:37.393 [TRACE] [.accessories.HomekitAccessoryFactory] - item MasterBedroom1_ColorTemperature meta data null tags []
2020-05-25 17:36:37.393 [TRACE] [mekit.internal.HomekitChangeListener] - Item MasterBedroom1_ColorTemperature has groups []
2020-05-25 17:36:37.394 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Dining Room Light
2020-05-25 17:36:37.394 [TRACE] [.accessories.HomekitAccessoryFactory] - item DiningRoom meta data null tags [Lighting]
2020-05-25 17:36:37.395 [TRACE] [mekit.internal.HomekitChangeListener] - Item DiningRoom has groups []
2020-05-25 17:36:37.396 [TRACE] [mekit.internal.HomekitChangeListener] - Item DiningRoom is a HomeKit accessory of types [OLD_DIMMABLE_LIGHTBULB=EMPTY]
2020-05-25 17:36:37.400 [TRACE] [mekit.internal.HomekitChangeListener] - Adding HomeKit device DiningRoom
2020-05-25 17:36:37.440 [TRACE] [.accessories.HomekitAccessoryFactory] - Constructing DiningRoom of accessoryType OLD_DIMMABLE_LIGHTBULB
2020-05-25 17:36:37.441 [TRACE] [.accessories.HomekitAccessoryFactory] - get mandatory characteristics for item DiningRoom: isGroup? false, isMember? false
2020-05-25 17:36:37.443 [TRACE] [.accessories.HomekitAccessoryFactory] - item DiningRoom meta data null tags [Lighting]
2020-05-25 17:36:37.456 [TRACE] [.accessories.HomekitAccessoryFactory] - get optional characteristics for item DiningRoom: isGroup? false, isMember? false
2020-05-25 17:36:37.457 [TRACE] [.accessories.HomekitAccessoryFactory] - item DiningRoom meta data null tags [Lighting]
2020-05-25 17:36:37.503 [TRACE] [.accessories.HomekitAccessoryFactory] - characteristics for DiningRoom = {BRIGHTNESS=DiningRoom (Type=DimmerItem, State=NULL, Label=Dining Room Light, Category=null, Tags=[Lighting])}
2020-05-25 17:36:37.505 [TRACE] [.accessories.HomekitAccessoryFactory] - adding optional characteristic: BRIGHTNESS for item DiningRoom
2020-05-25 17:36:37.622 [TRACE] [ssories.HomekitCharacteristicFactory] - createCharacteristic, type BRIGHTNESS item DiningRoom (Type=DimmerItem, State=NULL, Label=Dining Room Light, Category=null, Tags=[Lighting])
2020-05-25 17:36:37.625 [TRACE] [it.internal.HomekitAccessoryRegistry] - Added accessory 1246407112
2020-05-25 17:36:37.625 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Brightness
2020-05-25 17:36:37.626 [TRACE] [.accessories.HomekitAccessoryFactory] - item Comp_Hue2_Level meta data null tags []
2020-05-25 17:36:37.626 [TRACE] [mekit.internal.HomekitChangeListener] - Item Comp_Hue2_Level has groups []
2020-05-25 17:36:37.626 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Text to Speech
2020-05-25 17:36:37.627 [TRACE] [.accessories.HomekitAccessoryFactory] - item Echo_Living_Room_TTS meta data null tags []
2020-05-25 17:36:37.627 [TRACE] [mekit.internal.HomekitChangeListener] - Item Echo_Living_Room_TTS has groups []
2020-05-25 17:36:37.627 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Snow Amount
2020-05-25 17:36:37.628 [TRACE] [.accessories.HomekitAccessoryFactory] - item Snow1 meta data null tags []
2020-05-25 17:36:37.628 [TRACE] [mekit.internal.HomekitChangeListener] - Item Snow1 has groups []
2020-05-25 17:36:37.628 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Snow Amount
2020-05-25 17:36:37.629 [TRACE] [.accessories.HomekitAccessoryFactory] - item Snow0 meta data null tags []
2020-05-25 17:36:37.629 [TRACE] [mekit.internal.HomekitChangeListener] - Item Snow0 has groups []
2020-05-25 17:36:37.629 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Snow Amount
2020-05-25 17:36:37.630 [TRACE] [.accessories.HomekitAccessoryFactory] - item Snow2 meta data null tags []
2020-05-25 17:36:37.630 [TRACE] [mekit.internal.HomekitChangeListener] - Item Snow2 has groups []
2020-05-25 17:36:37.630 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Dimmer
2020-05-25 17:36:37.631 [TRACE] [.accessories.HomekitAccessoryFactory] - item DiningRoom_Dimmer meta data null tags []
2020-05-25 17:36:37.648 [TRACE] [mekit.internal.HomekitChangeListener] - Item DiningRoom_Dimmer has groups []
2020-05-25 17:36:37.649 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Precip probability
2020-05-25 17:36:37.649 [TRACE] [.accessories.HomekitAccessoryFactory] - item POP meta data null tags []
2020-05-25 17:36:37.649 [TRACE] [mekit.internal.HomekitChangeListener] - Item POP has groups []
2020-05-25 17:36:37.650 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Start Routine
2020-05-25 17:36:37.650 [TRACE] [.accessories.HomekitAccessoryFactory] - item Echo_Living_Room_StartRoutine meta data null tags []
2020-05-25 17:36:37.650 [TRACE] [mekit.internal.HomekitChangeListener] - Item Echo_Living_Room_StartRoutine has groups []
2020-05-25 17:36:37.651 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Battery Level
2020-05-25 17:36:37.687 [TRACE] [.accessories.HomekitAccessoryFactory] - item Basement_Door_Battery meta data null tags []
2020-05-25 17:36:37.687 [TRACE] [mekit.internal.HomekitChangeListener] - Item Basement_Door_Battery has groups []
2020-05-25 17:36:37.687 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Condition
2020-05-25 17:36:37.688 [TRACE] [.accessories.HomekitAccessoryFactory] - item Condition2 meta data null tags []
2020-05-25 17:36:37.688 [TRACE] [mekit.internal.HomekitChangeListener] - Item Condition2 has groups []
2020-05-25 17:36:37.688 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Condition
2020-05-25 17:36:37.689 [TRACE] [.accessories.HomekitAccessoryFactory] - item Condition0 meta data null tags []
2020-05-25 17:36:37.689 [TRACE] [mekit.internal.HomekitChangeListener] - Item Condition0 has groups []
2020-05-25 17:36:37.689 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Switch
2020-05-25 17:36:37.690 [TRACE] [.accessories.HomekitAccessoryFactory] - item Airenet_Modem_State meta data null tags []
2020-05-25 17:36:37.690 [TRACE] [mekit.internal.HomekitChangeListener] - Item Airenet_Modem_State has groups []
2020-05-25 17:36:37.690 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Condition
2020-05-25 17:36:37.691 [TRACE] [.accessories.HomekitAccessoryFactory] - item Condition1 meta data null tags []
2020-05-25 17:36:37.691 [TRACE] [mekit.internal.HomekitChangeListener] - Item Condition1 has groups []
2020-05-25 17:36:37.692 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Brightness
2020-05-25 17:36:37.692 [TRACE] [.accessories.HomekitAccessoryFactory] - item Comp_Hue1_Level meta data null tags []
2020-05-25 17:36:37.692 [TRACE] [mekit.internal.HomekitChangeListener] - Item Comp_Hue1_Level has groups []
2020-05-25 17:36:37.693 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Temperature
2020-05-25 17:36:37.693 [TRACE] [.accessories.HomekitAccessoryFactory] - item Temperature meta data null tags []
2020-05-25 17:36:37.693 [TRACE] [mekit.internal.HomekitChangeListener] - Item Temperature has groups []
2020-05-25 17:36:37.694 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Burglar alarm
2020-05-25 17:36:37.694 [TRACE] [.accessories.HomekitAccessoryFactory] - item Computer_Room_Motion meta data null tags []
2020-05-25 17:36:37.694 [TRACE] [mekit.internal.HomekitChangeListener] - Item Computer_Room_Motion has groups []
2020-05-25 17:36:37.695 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Color
2020-05-25 17:36:37.695 [TRACE] [.accessories.HomekitAccessoryFactory] - item LivingRoomLeft_Color meta data null tags []
2020-05-25 17:36:37.695 [TRACE] [mekit.internal.HomekitChangeListener] - Item LivingRoomLeft_Color has groups []
2020-05-25 17:36:37.696 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Color
2020-05-25 17:36:37.696 [TRACE] [.accessories.HomekitAccessoryFactory] - item LivingRoomRight_Color meta data null tags []
2020-05-25 17:36:37.696 [TRACE] [mekit.internal.HomekitChangeListener] - Item LivingRoomRight_Color has groups []
2020-05-25 17:36:37.697 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Bob's iPhon Response Time
2020-05-25 17:36:37.729 [TRACE] [.accessories.HomekitAccessoryFactory] - item BobiPhoneResponseTime meta data null tags []
2020-05-25 17:36:37.730 [TRACE] [mekit.internal.HomekitChangeListener] - Item BobiPhoneResponseTime has groups []
2020-05-25 17:36:37.730 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Start Information
2020-05-25 17:36:37.731 [TRACE] [.accessories.HomekitAccessoryFactory] - item Echo_Living_Room_StartCommand meta data null tags []
2020-05-25 17:36:37.731 [TRACE] [mekit.internal.HomekitChangeListener] - Item Echo_Living_Room_StartCommand has groups []
2020-05-25 17:36:37.731 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Humidity
2020-05-25 17:36:37.732 [TRACE] [.accessories.HomekitAccessoryFactory] - item Humidity meta data null tags []
2020-05-25 17:36:37.732 [TRACE] [mekit.internal.HomekitChangeListener] - Item Humidity has groups []
2020-05-25 17:36:37.732 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Color Temperature
2020-05-25 17:36:37.733 [TRACE] [.accessories.HomekitAccessoryFactory] - item MasterBedroom2_ColorTemperature meta data null tags []
2020-05-25 17:36:37.733 [TRACE] [mekit.internal.HomekitChangeListener] - Item MasterBedroom2_ColorTemperature has groups []
2020-05-25 17:36:37.733 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Brightness
2020-05-25 17:36:37.734 [TRACE] [.accessories.HomekitAccessoryFactory] - item StairLight meta data null tags []
2020-05-25 17:36:37.734 [TRACE] [mekit.internal.HomekitChangeListener] - Item StairLight has groups []
2020-05-25 17:36:37.735 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Music Command
2020-05-25 17:36:37.735 [TRACE] [.accessories.HomekitAccessoryFactory] - item Echo_Living_Room_Music meta data null tags []
2020-05-25 17:36:37.735 [TRACE] [mekit.internal.HomekitChangeListener] - Item Echo_Living_Room_Music has groups []
2020-05-25 17:36:37.736 [TRACE] [mekit.internal.HomekitChangeListener] - create root accessory Bob's iPhone
2020-05-25 17:36:37.736 [TRACE] [.accessories.HomekitAccessoryFactory] - item BobiPhoneSwitch meta data null tags []
2020-05-25 17:36:37.736 [TRACE] [mekit.internal.HomekitChangeListener] - Item BobiPhoneSwitch has groups []
2020-05-25 17:36:37.737 [INFO ] [mekit.internal.HomekitChangeListener] - Created 1 HomeKit items.
2020-05-25 17:36:37.740 [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-05-25 17:36:38.572 [INFO ] [thub.hapjava.server.impl.HomekitRoot] - Added accessory java.util.concurrent.CompletableFuture@64838f85[Completed normally]
2020-05-25 17:36:38.573 [INFO ] [thub.hapjava.server.impl.HomekitRoot] - Added accessory java.util.concurrent.CompletableFuture@7a507582[Completed normally]
2020-05-25 17:36:39.427 [INFO ] [pl.http.impl.NettyHomekitHttpService] - Bound homekit listener to /192.168.1.21:9124
2020-05-25 17:36:39.433 [INFO ] [er.impl.jmdns.JmdnsHomekitAdvertiser] - Advertising accessory openHAB
2020-05-25 17:36:39.433 [INFO ] [er.impl.jmdns.JmdnsHomekitAdvertiser] - Registering _hap._tcp.local. on port 9124
2020-05-25 17:36:40.355 [INFO ] [zwave.handler.ZWaveControllerHandler] - Attempting to add listener when controller is null
2020-05-25 17:36:47.982 [INFO ] [ve.internal.protocol.ZWaveController] - Starting ZWave controller
2020-05-25 17:36:47.982 [INFO ] [ve.internal.protocol.ZWaveController] - ZWave timeout is set to 5000ms. Soft reset is false.
2020-05-25 17:36:59.920 [INFO ] [mmandclass.ZWaveDoorLockCommandClass] - NODE 12: Door-Lock config report - timeoutEnabled=false timeoutMinutes=254, timeoutSeconds=254
Probably more than needed. Not sure what the Java issues are from, but tha=ey don’t seem to affect anything else in my OpenHab environment.
The logs shows one item exposed to HomeKit which I do see from the listAccessories command.
I do see HomeKit listening with netstat
[root@openhab2 openhab2]# netstat -tapn
Active Internet connections (servers and established)
Proto Recv-Q Send-Q Local Address Foreign Address State PID/Program name
tcp 0 0 0.0.0.0:3306 0.0.0.0:* LISTEN 1289/mysqld
tcp 0 0 127.0.0.1:44750 0.0.0.0:* LISTEN 762/java
tcp 0 0 0.0.0.0:5007 0.0.0.0:* LISTEN 762/java
tcp 0 0 0.0.0.0:8080 0.0.0.0:* LISTEN 762/java
tcp 0 0 0.0.0.0:22 0.0.0.0:* LISTEN 778/sshd
tcp 0 0 127.0.0.1:25 0.0.0.0:* LISTEN 1494/master
tcp 0 0 0.0.0.0:8443 0.0.0.0:* LISTEN 762/java
tcp 0 0 192.168.1.21:9124 0.0.0.0:* LISTEN 762/java
tcp 0 0 127.0.0.1:8101 0.0.0.0:* LISTEN 762/java
tcp 0 0 192.168.1.21:22 192.168.1.147:57107 ESTABLISHED 30570/sshd: root@pt
tcp 0 0 192.168.1.21:8080 192.168.1.114:56550 ESTABLISHED 762/java
tcp 0 0 192.168.1.21:38466 192.168.1.25:9090 ESTABLISHED 762/java
tcp 0 0 192.168.1.21:38458 192.168.1.25:9090 ESTABLISHED 762/java
tcp 0 0 192.168.1.21:50932 139.162.151.221:443 ESTABLISHED 762/java
tcp 0 0 192.168.1.21:56794 52.94.228.85:443 ESTABLISHED 762/java
tcp6 0 0 :::22 :::* LISTEN 778/sshd
tcp6 0 0 ::1:25 :::* LISTEN 1494/master
[root@openhab2 openhab2]#
And I can telnet to port 9124 from another machine on my network so it appears to be listening.
I am not sure where else to go from here.
Any help would be appreciated.
Thanks,