Did enabling IPv6 (as well as v4) on my network break my hue setup?

Matthew_Herren · March 12, 2016, 12:52am

Hello all —

There have been some discussions on the forums about this, but seemingly without a solid resolution, or cause…

But as of yesterday, OpenHAB no longer wants to talk to my Phillips Hue bridge.

Specifically, this is the error that I get:

2016-03-12 00:38:35.112 [WARN ] [.h.internal.hardware.HueBridge] - Failed to connect to Hue bridge: HTTP request timed out.

Following that I would get this message: Hue settings were null, maybe misconfigured bridge IP.

I’ve tried everything — countless restarts of both OpenHAB and the bridge, changing secrets, IPs… Copying over my OpenHAB config from the Pi2 it normally runs on, to my MacBook and running it there. Same errors.

There is, however, one perhaps rather significant thing that I did right before this all started… My ISP here in Zurich rolled out this DS-lite version of ipv6… Searching online about my problems, I’ve come across people describing numerous problems involving hue’s and ipv6 — however my impression is that that is mainly about trying to use ipv6 addressing in contacting the bridge. my home network has both ipv4 and ipv6 addressing. the raspberry pi running openhab, I have even disabled ipv6 completely. also, that pi can ping the hue bridge without issue.

Here’s some sort of random other troubleshooting that I was trying:

root@bedroompi02:~# ping 192.168.0.165
PING 192.168.0.165 (192.168.0.165) 56(84) bytes of data.
64 bytes from 192.168.0.165: icmp_seq=1 ttl=64 time=16.3 ms
64 bytes from 192.168.0.165: icmp_seq=2 ttl=64 time=2.24 ms
64 bytes from 192.168.0.165: icmp_seq=3 ttl=64 time=2.44 ms
^X^Y^C
--- 192.168.0.165 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2003ms
rtt min/avg/max/mdev = 2.244/7.007/16.331/6.593 ms
root@bedroompi02:~# telnet 192.168.0.165 80
Trying 192.168.0.165...
Connected to 192.168.0.165.
Escape character is '^]'.
Connection closed by foreign host.
root@bedroompi02:~# telnet 192.168.0.165 80
Trying 192.168.0.165...
Connected to 192.168.0.165.
Escape character is '^]'.
Connection closed by foreign host.
root@bedroompi02:~# telnet 192.168.0.165 8080
Trying 192.168.0.165...
Connected to 192.168.0.165.
Escape character is '^]'.
GET /
HTTP/1.1 400 Bad Request

^[[A
HTTP/1.1 400 Bad Request

GET /debug/clip.html
HTTP/1.1 400 Bad Request

Short of reverting back to a full ipv4 network (which, I’m not sure is actually the reason), does anyone have any ideas that I could try?

best,
matt

Matthew_Herren · March 15, 2016, 4:05pm

No replies ?

I’ve called my ISP; and switched back to solely ipv4.

But that doesn’t really help:

2016-03-15 15:21:05.391 [WARN ] [.h.internal.hardware.HueBridge] - Failed to connect to Hue bridge: HTTP request timed out.
2016-03-15 15:21:10.109 [WARN ] [.h.internal.hardware.HueBridge] - Failed to connect to Hue bridge: HTTP request timed out.
2016-03-15 15:21:14.590 [WARN ] [.h.internal.hardware.HueBridge] - Failed to connect to Hue bridge: HTTP request timed out.
2016-03-15 15:21:16.282 [WARN ] [.h.internal.hardware.HueBridge] - Failed to connect to Hue bridge: HTTP request timed out.
2016-03-15 15:21:16.644 [WARN ] [.h.internal.hardware.HueBridge] - Failed to connect to Hue bridge: HTTP request timed out.
2016-03-15 15:21:16.673 [WARN ] [.h.internal.hardware.HueBridge] - Failed to connect to Hue bridge: HTTP request timed out.

Matthew_Herren · March 16, 2016, 2:56pm

Hi everyone,

Sorry for the continued posts, but I’m pulling my hair out.

I’ve now not only reset my hue bridge but, moved OpenHAB to a different machine, and canceled my whole little IPv6 adventure.

Nothing works, I really don’t understand it. I can ping the bridge’s IP from the OpenHAB box, so its not like there is a connection problem. Authentication, perhaps? I’ve moved things around so much I would have expected that OpenHAB asks me to press the button on the bridge again. But it doesn’t. Is there some way to force a clearing of the cache so that it does?

Apologies, long file coming next, but this is my log:

root@bedroompi02:/srv/heimatt/server# ./start_debug.sh
Launching the openHAB runtime in debug mode…
Listening for transport dt_socket at address: 8001
osgi> 14:44:52.565 [DEBUG] [.s.internal.SchedulerActivator:36 ] - Scheduler has been started.
14:44:52.790 [INFO ] [uartz.impl.StdSchedulerFactory:1175 ] - Using default implementation for ThreadExecutor
14:44:52.906 [INFO ] [rtz.core.SchedulerSignalerImpl:61 ] - Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl
14:44:52.909 [INFO ] [rg.quartz.core.QuartzScheduler:243 ] - Quartz Scheduler v.2.1.7 created.
14:44:52.919 [INFO ] [org.quartz.simpl.RAMJobStore :154 ] - RAMJobStore initialized.
14:44:52.928 [INFO ] [rg.quartz.core.QuartzScheduler:268 ] - Scheduler meta-data: Quartz Scheduler (v2.1.7) ‘openHAB-job-scheduler’ with instanceId 'NON_CLUSTERED’
Scheduler class: ‘org.quartz.core.QuartzScheduler’ - running locally.
NOT STARTED.
Currently in standby mode.
Number of jobs executed: 0
Using thread pool ‘org.quartz.simpl.SimpleThreadPool’ - with 2 threads.
Using job-store ‘org.quartz.simpl.RAMJobStore’ - which does not support persistence. and is not clustered.

14:44:52.932 [INFO ] [uartz.impl.StdSchedulerFactory:1324 ] - Quartz scheduler ‘openHAB-job-scheduler’ initialized from specified file: './etc/quartz.properties’
14:44:52.934 [INFO ] [uartz.impl.StdSchedulerFactory:1328 ] - Quartz scheduler version: 2.1.7
14:44:52.937 [INFO ] [rg.quartz.core.QuartzScheduler:534 ] - Scheduler openHAB-job-scheduler_$_NON_CLUSTERED started.
14:44:52.956 [DEBUG] [o.config.core.ConfigDispatcher:146 ] - Processing openHAB default configuration file ‘/srv/heimatt/server/configurations/openhab_default.cfg’.
14:44:52.960 [DEBUG] [o.config.core.ConfigDispatcher:168 ] - Processing openHAB main configuration file ‘/srv/heimatt/server/configurations/openhab.cfg’.
14:44:53.323 [DEBUG] [.o.core.internal.CoreActivator:93 ] - UUID file already exists at ‘/srv/heimatt/server/webapps/static/uuid’ with content '00136d1a-5f6d-47c7-b18a-5ebb64910a9c’
14:44:53.333 [DEBUG] [.o.core.internal.CoreActivator:115 ] - Created file ‘/srv/heimatt/server/webapps/static/version’ with content '1.8.1’
14:44:53.334 [INFO ] [.o.core.internal.CoreActivator:61 ] - openHAB runtime has been started (v1.8.1).
14:44:53.466 [DEBUG] [a.internal.AutoUpdateActivator:31 ] - AutoUpdate binding has been started.
14:44:57.974 [DEBUG] [.p.i.PersistenceModelActivator:23 ] - Registered ‘persistence’ configuration parser
14:44:58.054 [DEBUG] [.c.t.i.TransformationActivator:38 ] - Transformation Service has been started.
14:44:58.236 [DEBUG] [m.internal.MultimediaActivator:34 ] - Multimedia I/O bundle has been started.
14:44:58.347 [DEBUG] [.s.i.DiscoveryServiceActivator:27 ] - Discovery service has been started.
14:44:58.368 [INFO ] [o.o.i.s.i.DiscoveryServiceImpl:93 ] - mDNS service has been started
14:44:58.758 [DEBUG] [.io.transport.mqtt.MqttService:123 ] - Starting MQTT Service…
14:44:59.047 [INFO ] [o.o.i.s.i.DiscoveryServiceImpl:53 ] - Service Discovery initialization completed.
14:44:59.267 [DEBUG] [.i.internal.ItemModelActivator:24 ] - Registered ‘item’ configuration parser
14:44:59.685 [DEBUG] [o.o.c.i.items.ItemRegistryImpl:137 ] - Item provider ‘GenericItemProvider’ has been added.
14:45:02.741 [DEBUG] [.o.m.s.i.SitemapModelActivator:23 ] - Registered ‘sitemap’ configuration parser
14:45:03.154 [DEBUG] [io.rest.internal.RESTActivator:33 ] - REST API has been started.
14:45:03.526 [INFO ] [org.atmosphere.util.IOUtils :370 ] - META-INF/services/org.atmosphere.cpr.AtmosphereFramework not found in class loader
14:45:03.680 [INFO ] [sphere.cpr.AtmosphereFramework:2601 ] - Atmosphere is using org.atmosphere.cpr.DefaultAnnotationProcessor for processing annotation
14:45:03.685 [INFO ] [cpr.DefaultAnnotationProcessor:138 ] - AnnotationProcessor class org.atmosphere.cpr.DefaultAnnotationProcessor$BytecodeBasedAnnotationProcessor being used
14:45:03.770 [WARN ] [cpr.DefaultAnnotationProcessor:178 ] - Unable to detect annotations. Application may fail to deploy.
14:45:03.888 [INFO ] [sphere.cpr.AtmosphereFramework:1891 ] - Auto detecting atmosphere handlers /WEB-INF/classes/
14:45:03.978 [INFO ] [sphere.cpr.AtmosphereFramework:639 ] - Installed AtmosphereHandler org.atmosphere.handler.ReflectorServletProcessor mapped to context-path /* and Broadcaster Class org.atmosphere.jersey.JerseyBroadcaster
14:45:03.981 [INFO ] [sphere.cpr.AtmosphereFramework:1945 ] - Auto detecting WebSocketHandler in /WEB-INF/classes/
14:45:03.986 [INFO ] [sphere.cpr.AtmosphereFramework:1602 ] - Installed WebSocketProtocol org.atmosphere.websocket.protocol.SimpleHttpProtocol
14:45:04.192 [INFO ] [.a.h.ReflectorServletProcessor:103 ] - Installing Servlet com.sun.jersey.spi.container.servlet.ServletContainer
14:45:04.712 [INFO ] [c.s.j.s.i.a.WebApplicationImpl:815 ] - Initiating Jersey application, version 'Jersey: 1.18.1 02/19/2014 03:28 AM’
14:45:04.724 [INFO ] [c.s.j.s.i.a.WebApplicationImpl:826 ] - Adding the following classes declared in META-INF/services/jersey-server-components to the resource configuration:
class org.atmosphere.jersey.AtmosphereResourceConfigurator
14:45:04.986 [INFO ] [j.s.i.a.DeferredResourceConfig:101 ] - Instantiated the Application class org.openhab.io.rest.RESTApplication
14:45:06.828 [INFO ] [c.internal.ModelRepositoryImpl:80 ] - Loading model 'bridge.sitemap’
14:45:07.719 [INFO ] [c.internal.ModelRepositoryImpl:80 ] - Loading model 'default.sitemap’
14:45:08.125 [INFO ] [c.internal.ModelRepositoryImpl:80 ] - Loading model 'groups.items’
14:45:08.215 [DEBUG] [i.internal.GenericItemProvider:154 ] - Processing binding configs for items from model 'groups.items’
14:45:08.227 [DEBUG] [i.internal.GenericItemProvider:133 ] - Read items from model 'groups.items’
14:45:08.263 [INFO ] [c.internal.ModelRepositoryImpl:80 ] - Loading model 'hue.items’
14:45:08.399 [DEBUG] [i.internal.GenericItemProvider:154 ] - Processing binding configs for items from model 'hue.items’
14:45:08.414 [DEBUG] [i.internal.GenericItemProvider:133 ] - Read items from model 'groups.items’
14:45:08.417 [DEBUG] [i.internal.GenericItemProvider:133 ] - Read items from model 'hue.items’
14:45:08.449 [INFO ] [c.internal.ModelRepositoryImpl:80 ] - Loading model 'media.items’
14:45:08.467 [DEBUG] [i.internal.GenericItemProvider:154 ] - Processing binding configs for items from model 'media.items’
14:45:08.471 [DEBUG] [i.internal.GenericItemProvider:133 ] - Read items from model 'groups.items’
14:45:08.474 [DEBUG] [i.internal.GenericItemProvider:133 ] - Read items from model 'hue.items’
14:45:08.478 [DEBUG] [i.internal.GenericItemProvider:133 ] - Read items from model 'media.items’
14:45:08.508 [INFO ] [c.internal.ModelRepositoryImpl:80 ] - Loading model 'homematic.items’
14:45:08.574 [DEBUG] [i.internal.GenericItemProvider:154 ] - Processing binding configs for items from model 'homematic.items’
14:45:08.589 [DEBUG] [i.internal.GenericItemProvider:133 ] - Read items from model 'groups.items’
14:45:08.592 [DEBUG] [i.internal.GenericItemProvider:133 ] - Read items from model 'hue.items’
14:45:08.596 [DEBUG] [i.internal.GenericItemProvider:133 ] - Read items from model 'media.items’
14:45:08.598 [DEBUG] [i.internal.GenericItemProvider:133 ] - Read items from model 'homematic.items’
14:45:08.633 [INFO ] [c.internal.ModelRepositoryImpl:80 ] - Loading model 'sensors.items’
14:45:08.648 [DEBUG] [i.internal.GenericItemProvider:154 ] - Processing binding configs for items from model 'sensors.items’
14:45:08.650 [DEBUG] [i.internal.GenericItemProvider:133 ] - Read items from model 'groups.items’
14:45:08.653 [DEBUG] [i.internal.GenericItemProvider:133 ] - Read items from model 'hue.items’
14:45:08.656 [DEBUG] [i.internal.GenericItemProvider:133 ] - Read items from model 'media.items’
14:45:08.659 [DEBUG] [i.internal.GenericItemProvider:133 ] - Read items from model 'homematic.items’
14:45:08.664 [DEBUG] [i.internal.GenericItemProvider:133 ] - Read items from model 'sensors.items’
14:45:09.396 [INFO ] [sphere.cpr.AtmosphereFramework:2435 ] - AtmosphereInterceptor CORS Interceptor Support will always be executed first
14:45:09.399 [INFO ] [sphere.cpr.AtmosphereFramework:2404 ] - Installed AtmosphereInterceptor CORS Interceptor Support with priority FIRST_BEFORE_DEFAULT
14:45:09.402 [INFO ] [sphere.cpr.AtmosphereFramework:2404 ] - Installed AtmosphereInterceptor Default Response’s Headers Interceptor with priority AFTER_DEFAULT
14:45:09.410 [INFO ] [sphere.cpr.AtmosphereFramework:2404 ] - Installed AtmosphereInterceptor Android Interceptor Support with priority AFTER_DEFAULT
14:45:09.416 [INFO ] [sphere.cpr.AtmosphereFramework:2404 ] - Installed AtmosphereInterceptor SSE Interceptor Support with priority AFTER_DEFAULT
14:45:09.420 [INFO ] [sphere.cpr.AtmosphereFramework:2404 ] - Installed AtmosphereInterceptor JSONP Interceptor Support with priority AFTER_DEFAULT
14:45:09.427 [INFO ] [sphere.cpr.AtmosphereFramework:2404 ] - Installed AtmosphereInterceptor Atmosphere JavaScript Protocol with priority AFTER_DEFAULT
14:45:09.431 [INFO ] [sphere.cpr.AtmosphereFramework:2404 ] - Installed AtmosphereInterceptor Browser disconnection detection with priority AFTER_DEFAULT
14:45:09.447 [INFO ] [sphere.cpr.AtmosphereFramework:935 ] - Using EndpointMapper class org.atmosphere.util.DefaultEndpointMapper
14:45:09.453 [WARN ] [sphere.cpr.AtmosphereFramework:941 ] - No BroadcasterCache configured. Broadcasted message between client reconnection will be LOST. It is recommended to configure the org.atmosphere.cache.UUIDBroadcasterCache
14:45:09.455 [INFO ] [sphere.cpr.AtmosphereFramework:949 ] - Default Broadcaster Class: org.atmosphere.jersey.JerseyBroadcaster
14:45:09.457 [INFO ] [sphere.cpr.AtmosphereFramework:950 ] - Broadcaster Polling Wait Time 100
14:45:09.459 [INFO ] [sphere.cpr.AtmosphereFramework:951 ] - Shared ExecutorService supported: true
14:45:09.461 [INFO ] [sphere.cpr.AtmosphereFramework:958 ] - Messaging Thread Pool Size: 10
14:45:09.463 [INFO ] [sphere.cpr.AtmosphereFramework:968 ] - Async I/O Thread Pool Size: 10
14:45:09.465 [INFO ] [sphere.cpr.AtmosphereFramework:979 ] - Using BroadcasterFactory: org.atmosphere.cpr.DefaultBroadcasterFactory
14:45:09.467 [INFO ] [sphere.cpr.AtmosphereFramework:980 ] - Using WebSocketProcessor: org.atmosphere.websocket.DefaultWebSocketProcessor
14:45:09.469 [INFO ] [sphere.cpr.AtmosphereFramework:990 ] - Invoke AtmosphereInterceptor on WebSocket message true
14:45:09.471 [INFO ] [sphere.cpr.AtmosphereFramework:991 ] - HttpSession supported: false
14:45:09.473 [INFO ] [sphere.cpr.AtmosphereFramework:993 ] - Atmosphere is using DefaultAtmosphereObjectFactory for dependency injection and object creation
14:45:09.475 [INFO ] [sphere.cpr.AtmosphereFramework:994 ] - Atmosphere is using async support: org.atmosphere.container.JettyAsyncSupportWithWebSocket running under container: jetty/8.1.3.v20120522 with WebSocket enabled.
14:45:09.483 [INFO ] [sphere.cpr.AtmosphereFramework:996 ] - Atmosphere Framework 2.2.5 started.
14:45:09.485 [INFO ] [sphere.cpr.AtmosphereFramework:998 ] -

For Atmosphere Framework Commercial Support, visit 
http://www.async-io.org/ or send an email to support@async-io.org

14:45:09.490 [INFO ] [penhab.io.rest.RESTApplication:144 ] - Started REST API at /rest
14:45:09.496 [DEBUG] [o.o.i.s.i.DiscoveryServiceImpl:66 ] - Registering new service _openhab-server._tcp.local. at port 8080
14:45:12.190 [DEBUG] [o.o.i.s.i.DiscoveryServiceImpl:66 ] - Registering new service _openhab-server-ssl._tcp.local. at port 8443
14:45:15.128 [INFO ] [.o.u.w.i.servlet.WebAppServlet:80 ] - Started Classic UI at /classicui/openhab.app
14:45:16.475 [DEBUG] [.r.internal.RuleModelActivator:42 ] - Registered ‘rules’ configuration parser
14:45:16.532 [DEBUG] [m.r.internal.engine.RuleEngine:77 ] - Started rule engine
14:45:19.016 [INFO ] [c.internal.ModelRepositoryImpl:80 ] - Loading model 'office.rules’
14:45:19.804 [INFO ] [c.internal.ModelRepositoryImpl:80 ] - Loading model 'kitchen.rules’
14:45:19.931 [INFO ] [c.internal.ModelRepositoryImpl:80 ] - Loading model 'livingroom.rules’
14:45:20.115 [INFO ] [c.internal.ModelRepositoryImpl:80 ] - Loading model 'bedroom.rules’
14:45:20.229 [INFO ] [c.internal.ModelRepositoryImpl:80 ] - Loading model 'balcony.rules’
14:45:20.281 [INFO ] [c.internal.ModelRepositoryImpl:80 ] - Loading model 'hallway.rules’
14:45:21.021 [DEBUG] [.a.t.internal.TwitterActivator:34 ] - Twitter action has been started.
14:45:21.159 [DEBUG] [.m.i.MyOpenHABServiceActivator:28 ] - MyOpenHAB service has been started.
14:45:21.169 [DEBUG] [o.o.i.m.i.MyOpenHABServiceImpl:300 ] - setEventPublisher
14:45:21.171 [DEBUG] [o.o.i.m.i.MyOpenHABServiceImpl:135 ] - my.openHAB service activated
14:45:21.174 [DEBUG] [o.o.i.m.i.MyOpenHABServiceImpl:118 ] - config is null
14:45:21.179 [DEBUG] [o.o.i.m.i.MyOpenHABServiceImpl:176 ] - UUID file found at ‘/srv/heimatt/server/webapps/static/uuid’ with content '00136d1a-5f6d-47c7-b18a-5ebb64910a9c’
14:45:21.183 [DEBUG] [o.o.i.m.i.MyOpenHABServiceImpl:228 ] - Secret file already exists at ‘/srv/heimatt/server/webapps/static/secret’ with content 'ocsfB8d3emOXNtfBcudb’
14:45:21.183 [DEBUG] [.p.internal.PersistenceManager:146 ] - Initializing myopenhab persistence service.
14:45:21.185 [DEBUG] [o.o.i.m.i.MyOpenHABServiceImpl:120 ] - UUID = 00136d1a-5f6d-47c7-b18a-5ebb64910a9c, secret = ocsfB8d3emOXNtfBcudb
14:45:21.201 [DEBUG] [c.internal.ModelRepositoryImpl:64 ] - Configuration model ‘myopenhab.persist’ can not be found
14:45:21.226 [DEBUG] [o.o.i.m.i.MyOpenHABServiceImpl:176 ] - UUID file found at ‘/srv/heimatt/server/webapps/static/uuid’ with content '00136d1a-5f6d-47c7-b18a-5ebb64910a9c’
14:45:21.228 [DEBUG] [o.o.i.m.i.MyOpenHABServiceImpl:228 ] - Secret file already exists at ‘/srv/heimatt/server/webapps/static/secret’ with content 'ocsfB8d3emOXNtfBcudb’
14:45:21.232 [DEBUG] [o.o.i.m.i.MyOpenHABServiceImpl:162 ] - Version file found at ‘/srv/heimatt/server/webapps/static/version’ with content '1.8.1’
14:45:21.247 [DEBUG] [o.b.h.i.bus.HomematicActivator:33 ] - Homematic binding has been started.
14:45:21.268 [DEBUG] [i.internal.GenericItemProvider:341 ] - Start processing binding configuration of Item ‘dimmer_officecouch (Type=DimmerItem, State=Uninitialized)’ with ‘HomematicGenericBindingProvider’ reader.
14:45:21.357 [DEBUG] [omematicGenericBindingProvider:63 ] - Adding item dimmer_officecouch with DatapointConfig[address=JEQ0348610,channel=1,parameter=LEVEL]
14:45:21.360 [DEBUG] [i.internal.GenericItemProvider:341 ] - Start processing binding configuration of Item ‘dimmer_hallway (Type=DimmerItem, State=Uninitialized)’ with ‘HomematicGenericBindingProvider’ reader.
14:45:21.363 [DEBUG] [omematicGenericBindingProvider:63 ] - Adding item dimmer_hallway with DatapointConfig[address=JEQ0348625,channel=1,parameter=LEVEL]
14:45:21.365 [DEBUG] [i.internal.GenericItemProvider:341 ] - Start processing binding configuration of Item ‘dimmer_tubelights (Type=DimmerItem, State=Uninitialized)’ with ‘HomematicGenericBindingProvider’ reader.
14:45:21.368 [DEBUG] [omematicGenericBindingProvider:63 ] - Adding item dimmer_tubelights with DatapointConfig[address=JEQ0646748,channel=1,parameter=LEVEL]
14:45:22.622 [INFO ] [.service.AbstractActiveService:169 ] - Exec Refresh Service has been started
14:45:22.635 [DEBUG] [.b.mqtt.internal.MqttActivator:34 ] - MQTT binding has been started.
14:45:22.732 [DEBUG] [m.internal.MqttEventBusBinding:68 ] - MQTT: Activating event bus binding.
14:45:22.749 [DEBUG] [.a.internal.bus.AstroActivator:32 ] - Astro binding has been started.
14:45:22.862 [DEBUG] [.b.http.internal.HttpActivator:34 ] - HTTP binding has been started.
14:45:22.935 [INFO ] [.service.AbstractActiveService:169 ] - HTTP Refresh Service has been started
14:45:22.948 [DEBUG] [.m.internal.MqttitudeActivator:33 ] - Mqttitude binding has been started.
14:45:23.008 [DEBUG] [.b.m.internal.MqttitudeBinding:84 ] - Activating Mqttitude binding
14:45:23.147 [DEBUG] [.o.internal.OpenPathsActivator:33 ] - OpenPaths binding has been started.
14:45:23.225 [DEBUG] [.o.b.hue.internal.HueActivator:30 ] - Hue binding has been started.
14:45:23.268 [DEBUG] [i.internal.GenericItemProvider:341 ] - Start processing binding configuration of Item ‘Toggle_1 (Type=SwitchItem, State=Uninitialized)’ with ‘HueGenericBindingProvider’ reader.
14:45:23.275 [DEBUG] [i.internal.GenericItemProvider:341 ] - Start processing binding configuration of Item ‘Toggle_2 (Type=SwitchItem, State=Uninitialized)’ with ‘HueGenericBindingProvider’ reader.
14:45:23.278 [DEBUG] [i.internal.GenericItemProvider:341 ] - Start processing binding configuration of Item ‘Toggle_3 (Type=SwitchItem, State=Uninitialized)’ with ‘HueGenericBindingProvider’ reader.
14:45:23.281 [DEBUG] [i.internal.GenericItemProvider:341 ] - Start processing binding configuration of Item ‘Toggle_4 (Type=SwitchItem, State=Uninitialized)’ with ‘HueGenericBindingProvider’ reader.
14:45:23.284 [DEBUG] [i.internal.GenericItemProvider:341 ] - Start processing binding configuration of Item ‘Toggle_5 (Type=SwitchItem, State=Uninitialized)’ with ‘HueGenericBindingProvider’ reader.
14:45:23.286 [DEBUG] [i.internal.GenericItemProvider:341 ] - Start processing binding configuration of Item ‘Toggle_6 (Type=SwitchItem, State=Uninitialized)’ with ‘HueGenericBindingProvider’ reader.
14:45:23.291 [DEBUG] [i.internal.GenericItemProvider:341 ] - Start processing binding configuration of Item ‘Toggle_7 (Type=SwitchItem, State=Uninitialized)’ with ‘HueGenericBindingProvider’ reader.
14:45:23.294 [DEBUG] [i.internal.GenericItemProvider:341 ] - Start processing binding configuration of Item ‘Toggle_8 (Type=SwitchItem, State=Uninitialized)’ with ‘HueGenericBindingProvider’ reader.
14:45:23.296 [DEBUG] [i.internal.GenericItemProvider:341 ] - Start processing binding configuration of Item ‘Toggle_9 (Type=SwitchItem, State=Uninitialized)’ with ‘HueGenericBindingProvider’ reader.
14:45:23.298 [DEBUG] [i.internal.GenericItemProvider:341 ] - Start processing binding configuration of Item ‘Color_1 (Type=ColorItem, State=Uninitialized)’ with ‘HueGenericBindingProvider’ reader.
14:45:23.301 [DEBUG] [i.internal.GenericItemProvider:341 ] - Start processing binding configuration of Item ‘Color_2 (Type=ColorItem, State=Uninitialized)’ with ‘HueGenericBindingProvider’ reader.
14:45:23.303 [DEBUG] [i.internal.GenericItemProvider:341 ] - Start processing binding configuration of Item ‘Color_3 (Type=ColorItem, State=Uninitialized)’ with ‘HueGenericBindingProvider’ reader.
14:45:23.305 [DEBUG] [i.internal.GenericItemProvider:341 ] - Start processing binding configuration of Item ‘Color_4 (Type=ColorItem, State=Uninitialized)’ with ‘HueGenericBindingProvider’ reader.
14:45:23.308 [DEBUG] [i.internal.GenericItemProvider:341 ] - Start processing binding configuration of Item ‘Color_5 (Type=ColorItem, State=Uninitialized)’ with ‘HueGenericBindingProvider’ reader.
14:45:23.310 [DEBUG] [i.internal.GenericItemProvider:341 ] - Start processing binding configuration of Item 'Color_6

14:46:40.337 [DEBUG] [inding.hue.internal.HueBinding:97 ] - Start Hue data refresh
14:46:43.342 [WARN ] [.h.internal.hardware.HueBridge:147 ] - Failed to connect to Hue bridge: HTTP request timed out.
14:46:43.344 [WARN ] [inding.hue.internal.HueBinding:100 ] - Hue settings were null, maybe misconfigured bridge IP.

best
matt