search

armzilla / amazon-echo-ha-bridge

emulates philips hue api to other home automation gateways
Apache License 2.0
721 stars 168 forks source link

The app detects the request from Echo when told to discover devices but the discovery fails. #84

Open NibblyPig opened 7 years ago

NibblyPig commented 7 years ago

I installed java, and ran this command to start the application:

java -jar C:\echo\amazon-echo-bridge-0.4.0.jar --upnp.config.address=192.168.1.2 --server.port=8098

This is the output:

C:\Echo>java -jar C:\echo\amazon-echo-bridge-0.4.0.jar --upnp.config.address=192.168.1.2 --server.port=8098

. _ /\ / **' () \ \ \ \ ( ( )** | ' | '| | ' \/ ` | \ \ \ \ \/ _)| |)| | | | | || (| | ) ) ) ) ' |_| .**|| ||| |**, | / / / / =========||==============|_/=///_/ :: Spring Boot :: (v1.2.6.RELEASE)

2016-10-16 03:44:26.825 INFO 4632 --- [ main] com.armzilla.ha.SpringbootEntry : Starting SpringbootEntry v0.4.0 on nibblypc with PID 4632 (C:\Echo\amazon-echo-bridge-0.4.0.jar started by nibbly in C:\Echo) 2016-10-16 03:44:26.868 INFO 4632 --- [ main] ationConfigEmbeddedWebApplicationContext : Refreshing org.springframework.boot.context.embedded.AnnotationConfigEmbeddedWebApplicationContext@63de678d: startup date [Sun Oct 16 03:44:26 BST 2016]; root of context hierarchy 2016-10-16 03:44:27.586 INFO 4632 --- [ main] o.s.b.f.s.DefaultListableBeanFactory : Overriding bean definition for bean 'beanNameViewResolver': replacing [Root bean: class [null]; scope=; abstract=false; lazyInit=false; autowireMode=3; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=org.springframework.boot.autoconfigure.web.ErrorMvcAutoConfiguration$WhitelabelErrorViewConfiguration; factoryMethodName=beanNameViewResolver; initMethodName=null; destroyMethodName=(inferred); defined in class path resource [org/springframework/boot/autoconfigure/web/ErrorMvcAutoConfiguration$WhitelabelErrorViewConfiguration.class]] with [Root bean: class [null]; scope=; abstract=false; lazyInit=false; autowireMode=3; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=org.springframework.boot.autoconfigure.web.WebMvcAutoConfiguration$WebMvcAutoConfigurationAdapter; factoryMethodName=beanNameViewResolver; initMethodName=null; destroyMethodName=(inferred); defined in class path resource [org/springframework/boot/autoconfigure/web/WebMvcAutoConfiguration$WebMvcAutoConfigurationAdapter.class]] 2016-10-16 03:44:28.071 INFO 4632 --- [ main] trationDelegate$BeanPostProcessorChecker : Bean 'org.springframework.scheduling.annotation.SchedulingConfiguration' of type [class org.springframework.scheduling.annotation.SchedulingConfiguration$$EnhancerBySpringCGLIB$$4151c85b] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2016-10-16 03:44:28.709 INFO 4632 --- [ main] s.b.c.e.t.TomcatEmbeddedServletContainer : Tomcat initialized with port(s): 8098 (http) 8081 (http) 8082 (http) 2016-10-16 03:44:28.914 INFO 4632 --- [ main] o.apache.catalina.core.StandardService : Starting service Tomcat 2016-10-16 03:44:28.917 INFO 4632 --- [ main] org.apache.catalina.core.StandardEngine : Starting Servlet Engine: Apache Tomcat/8.0.26 2016-10-16 03:44:29.001 INFO 4632 --- [ost-startStop-1] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring embedded WebApplicationContext 2016-10-16 03:44:29.006 INFO 4632 --- [ost-startStop-1] o.s.web.context.ContextLoader : Root WebApplicationContext: initialization completed in 2140 ms 2016-10-16 03:44:30.029 INFO 4632 --- [ost-startStop-1] o.s.b.c.e.ServletRegistrationBean : Mapping servlet: 'dispatcherServlet' to [/] 2016-10-16 03:44:30.043 INFO 4632 --- [ost-startStop-1] o.s.b.c.embedded.FilterRegistrationBean : Mapping filter: 'metricFilter' to: [/] 2016-10-16 03:44:30.049 INFO 4632 --- [ost-startStop-1] o.s.b.c.embedded.FilterRegistrationBean : Mapping filter: 'characterEncodingFilter' to: [/] 2016-10-16 03:44:30.053 INFO 4632 --- [ost-startStop-1] o.s.b.c.embedded.FilterRegistrationBean : Mapping filter: 'hiddenHttpMethodFilter' to: [/] 2016-10-16 03:44:30.055 INFO 4632 --- [ost-startStop-1] o.s.b.c.embedded.FilterRegistrationBean : Mapping filter: 'webRequestLoggingFilter' to: [/] 2016-10-16 03:44:30.058 INFO 4632 --- [ost-startStop-1] o.s.b.c.embedded.FilterRegistrationBean : Mapping filter: 'springBootCorsFilter' to: [/] 2016-10-16 03:44:30.062 INFO 4632 --- [ost-startStop-1] o.s.b.c.embedded.FilterRegistrationBean : Mapping filter: 'applicationContextIdFilter' to: [/] 2016-10-16 03:44:30.298 INFO 4632 --- [ main] org.elasticsearch.node : [Brute II] version[1.3.2], pid[4632], build[dee175d/2014-08-13T14:29:30Z] 2016-10-16 03:44:30.300 INFO 4632 --- [ main] org.elasticsearch.node : [Brute II] initializing ... 2016-10-16 03:44:30.305 INFO 4632 --- [ main] org.elasticsearch.plugins : [Brute II] loaded [], sites [] 2016-10-16 03:44:31.730 INFO 4632 --- [ main] org.elasticsearch.node : [Brute II] initialized 2016-10-16 03:44:31.732 INFO 4632 --- [ main] org.elasticsearch.node : [Brute II] starting ... 2016-10-16 03:44:31.742 INFO 4632 --- [ main] org.elasticsearch.transport : [Brute II] bound_address {local[1]}, publish_address {local[1]} 2016-10-16 03:44:31.758 INFO 4632 --- [ main] org.elasticsearch.discovery : [Brute II] elasticsearch/T3tVGA7eRIOa8ZJqh0CR8g 2016-10-16 03:44:31.765 INFO 4632 --- [pdateTask][T#1]] org.elasticsearch.cluster.service : [Brute II] new_master [Brute II][T3tVGA7eRIOa8ZJqh0CR8g][nibblypc][local[1]]{local=true}, reason: local-disco-initial_connect(master) 2016-10-16 03:44:31.814 INFO 4632 --- [ main] org.elasticsearch.node : [Brute II] started 2016-10-16 03:44:32.284 INFO 4632 --- [pdateTask][T#1]] org.elasticsearch.gateway : [Brute II] recovered [1] indices into clusterstate 2016-10-16 03:44:32.714 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerAdapter : Looking for @ControllerAdvice: org.springframework.boot.context.embedded.AnnotationConfigEmbeddedWebApplicationContext@63de678d: startup date [Sun Oct 16 03:44:26 BST 2016]; root of context hierarchy 2016-10-16 03:44:32.772 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/api/devices],methods=[POST],produces=[application/json]}" onto public org.springframework.http.ResponseEntity com.armzilla.ha.devicemanagmeent.DeviceResource.createDevice(com.armzilla.ha.api.Device) 2016-10-16 03:44:32.778 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/api/devices/{lightId}],methods=[PUT],produces=[application/json]}" onto public org.springframework.http.ResponseEntity com.armzilla.ha.devicemanagmeent.DeviceResource.updateDevice(java.lang.String,com.armzilla.ha.api.Device) 2016-10-16 03:44:32.784 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/api/devices],methods=[GET],produces=[application/json]}" onto public org.springframework.http.ResponseEntity<java.util.List> com.armzilla.ha.devicemanagmeent.DeviceResource.findAllDevices() 2016-10-16 03:44:32.790 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/api/devices/{lightId}],methods=[DELETE],produces=[application/json]}" onto public org.springframework.http.ResponseEntity com.armzilla.ha.devicemanagmeent.DeviceResource.deleteDeviceById(java.lang.String) 2016-10-16 03:44:32.796 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/api/devices/{lightId}],methods=[GET],produces=[application/json]}" onto public org.springframework.http.ResponseEntity com.armzilla.ha.devicemanagmeent.DeviceResource.findByDevicId(java.lang.String) 2016-10-16 03:44:32.802 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/api/{userId}/lights],methods=[GET],produces=[application/json]}" onto public org.springframework.http.ResponseEntity<java.util.Map<java.lang.String, java.lang.String>> com.armzilla.ha.hue.HueMulator.getUpnpConfiguration(java.lang.String,javax.servlet.http.HttpServletRequest) 2016-10-16 03:44:32.809 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/api/{userId}/lights/{lightId}/state],methods=[PUT]}" onto public org.springframework.http.ResponseEntity com.armzilla.ha.hue.HueMulator.stateChange(java.lang.String,java.lang.String,javax.servlet.http.HttpServletRequest,java.lang.String) 2016-10-16 03:44:32.815 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/api/],methods=[POST],produces=[application/json]}" onto public org.springframework.http.ResponseEntity com.armzilla.ha.hue.HueMulator.postAPI(javax.servlet.http.HttpServletRequest) 2016-10-16 03:44:32.820 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/api/{userId}/lights/{lightId}],methods=[GET],produces=[application/json]}" onto public org.springframework.http.ResponseEntity com.armzilla.ha.hue.HueMulator.getLigth(java.lang.String,java.lang.String,javax.servlet.http.HttpServletRequest) 2016-10-16 03:44:32.827 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/api/{userId}],methods=[GET],produces=[application/json]}" onto public org.springframework.http.ResponseEntity com.armzilla.ha.hue.HueMulator.getApi(java.lang.String,javax.servlet.http.HttpServletRequest) 2016-10-16 03:44:32.833 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/upnp/{deviceId}/setup.xml],methods=[GET],produces=[application/xml]}" onto public org.springframework.http.ResponseEntity com.armzilla.ha.upnp.UpnpSettingsResource.getUpnpConfiguration(java.lang.String,javax.servlet.http.HttpServletRequest) 2016-10-16 03:44:32.839 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/error]}" onto public org.springframework.http.ResponseEntity<java.util.Map<java.lang.String, java.lang.Object>> org.springframework.boot.autoconfigure.web.BasicErrorController.error(javax.servlet.http.HttpServletRequest) 2016-10-16 03:44:32.845 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/error],produces=[text/html]}" onto public org.springframework.web.servlet.ModelAndView org.springframework.boot.autoconfigure.web.BasicErrorController.errorHtml(javax.servlet.http.HttpServletRequest) 2016-10-16 03:44:32.881 INFO 4632 --- [ main] o.s.w.s.handler.SimpleUrlHandlerMapping : Mapped URL path [/webjars/] onto handler of type [class org.springframework.web.servlet.resource.ResourceHttpRequestHandler] 2016-10-16 03:44:32.885 INFO 4632 --- [ main] o.s.w.s.handler.SimpleUrlHandlerMapping : Mapped URL path [/] onto handler of type [class org.springframework.web.servlet.resource.ResourceHttpRequestHandler] 2016-10-16 03:44:32.953 INFO 4632 --- [ main] o.s.w.s.handler.SimpleUrlHandlerMapping : Mapped URL path [/_/favicon.ico] onto handler of type [class org.springframework.web.servlet.resource.ResourceHttpRequestHandler] 2016-10-16 03:44:33.264 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/trace],methods=[GET]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke() 2016-10-16 03:44:33.271 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/env/{name:.}],methods=[GET]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EnvironmentMvcEndpoint.value(java.lang.String) 2016-10-16 03:44:33.284 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/env],methods=[GET]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke() 2016-10-16 03:44:33.291 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/info],methods=[GET]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke() 2016-10-16 03:44:33.296 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/dump],methods=[GET]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke() 2016-10-16 03:44:33.301 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/autoconfig],methods=[GET]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke() 2016-10-16 03:44:33.306 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/configprops],methods=[GET]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke() 2016-10-16 03:44:33.311 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/health]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.HealthMvcEndpoint.invoke(java.security.Principal) 2016-10-16 03:44:33.315 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/beans],methods=[GET]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke() 2016-10-16 03:44:33.320 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/metrics/{name:.*}],methods=[GET]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.MetricsMvcEndpoint.value(java.lang.String) 2016-10-16 03:44:33.325 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/metrics],methods=[GET]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke() 2016-10-16 03:44:33.333 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/mappings],methods=[GET]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke() 2016-10-16 03:44:33.363 INFO 4632 --- [ main] o.s.j.e.a.AnnotationMBeanExporter : Registering beans for JMX exposure on startup 2016-10-16 03:44:33.372 INFO 4632 --- [ main] o.s.c.support.DefaultLifecycleProcessor : Starting beans in phase 0 2016-10-16 03:44:33.446 INFO 4632 --- [pool-1-thread-1] com.armzilla.ha.upnp.UpnpListener : Starting UPNP Discovery Listener 2016-10-16 03:44:33.512 INFO 4632 --- [ main] s.b.c.e.t.TomcatEmbeddedServletContainer : Tomcat started on port(s): 8098 (http) 8081 (http) 8082 (http) 2016-10-16 03:44:33.517 INFO 4632 --- [ main] com.armzilla.ha.SpringbootEntry : Started SpringbootEntry in 6.943 seconds (JVM running for 7.348) 2016-10-16 03:44:48.148 INFO 4632 --- [nio-8081-exec-1] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring FrameworkServlet 'dispatcherServlet' 2016-10-16 03:44:48.152 INFO 4632 --- [nio-8081-exec-1] o.s.web.servlet.DispatcherServlet : FrameworkServlet 'dispatcherServlet': initialization started 2016-10-16 03:44:48.173 INFO 4632 --- [nio-8081-exec-1] o.s.web.servlet.DispatcherServlet : FrameworkServlet 'dispatcherServlet': initialization completed in 19 ms 2016-10-16 03:44:48.206 INFO 4632 --- [nio-8082-exec-1] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge2 from 192.168.1.3 2016-10-16 03:44:48.207 INFO 4632 --- [nio-8081-exec-1] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge1 from 192.168.1.3 2016-10-16 03:44:54.541 INFO 4632 --- [nio-8081-exec-3] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge1 from 192.168.1.2 2016-10-16 03:44:54.544 INFO 4632 --- [nio-8082-exec-3] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge2 from 192.168.1.2

After I tell Alexa to discover devices, this appears:

2016-10-16 03:46:24.822 INFO 4632 --- [nio-8081-exec-5] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge1 from 192.168.1.126 2016-10-16 03:46:24.822 INFO 4632 --- [nio-8082-exec-8] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge2 from 192.168.1.126 2016-10-16 03:46:24.824 INFO 4632 --- [nio-8082-exec-1] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge2 from 192.168.1.126 2016-10-16 03:46:24.841 INFO 4632 --- [nio-8082-exec-9] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge2 from 192.168.1.126 2016-10-16 03:46:24.846 INFO 4632 --- [nio-8081-exec-6] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge1 from 192.168.1.126 2016-10-16 03:46:24.849 INFO 4632 --- [io-8082-exec-10] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge2 from 192.168.1.126 2016-10-16 03:46:24.852 INFO 4632 --- [nio-8081-exec-7] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge1 from 192.168.1.126 2016-10-16 03:46:24.860 INFO 4632 --- [nio-8081-exec-8] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge1 from 192.168.1.126 2016-10-16 03:46:25.598 INFO 4632 --- [nio-8082-exec-2] com.armzilla.ha.hue.HueMulator : hue lights list requested: RBoGp9dIoNqjqypzeUs9b16E2OOT1oEt0pqhgrxA from 192.168.1.1268082 2016-10-16 03:46:25.699 INFO 4632 --- [nio-8081-exec-9] com.armzilla.ha.hue.HueMulator : hue lights list requested: RBoGp9dIoNqjqypzeUs9b16E2OOT1oEt0pqhgrxA from 192.168.1.1268081 2016-10-16 03:46:25.760 INFO 4632 --- [nio-8082-exec-3] com.armzilla.ha.hue.HueMulator : hue lights list requested: RBoGp9dIoNqjqypzeUs9b16E2OOT1oEt0pqhgrxA from 192.168.1.1268082 2016-10-16 03:46:25.760 INFO 4632 --- [nio-8081-exec-1] com.armzilla.ha.hue.HueMulator : hue lights list requested: RBoGp9dIoNqjqypzeUs9b16E2OOT1oEt0pqhgrxA from 192.168.1.1268081 2016-10-16 03:46:25.768 INFO 4632 --- [io-8081-exec-10] com.armzilla.ha.hue.HueMulator : hue lights list requested: RBoGp9dIoNqjqypzeUs9b16E2OOT1oEt0pqhgrxA from 192.168.1.1268081 2016-10-16 03:46:25.959 INFO 4632 --- [nio-8082-exec-4] com.armzilla.ha.hue.HueMulator : hue lights list requested: RBoGp9dIoNqjqypzeUs9b16E2OOT1oEt0pqhgrxA from 192.168.1.1268082 2016-10-16 03:46:26.010 INFO 4632 --- [nio-8081-exec-2] com.armzilla.ha.hue.HueMulator : hue lights list requested: RBoGp9dIoNqjqypzeUs9b16E2OOT1oEt0pqhgrxA from 192.168.1.1268081 2016-10-16 03:46:26.062 INFO 4632 --- [nio-8082-exec-5] com.armzilla.ha.hue.HueMulator : hue lights list requested: RBoGp9dIoNqjqypzeUs9b16E2OOT1oEt0pqhgrxA from 192.168.1.1268082

After this, nothing happens.

Any suggestions to debug?

armzilla commented 7 years ago

If possible can you send the list of devices? Just do a http get on the device endpoint.

On Sat, Oct 15, 2016, 21:47 NibblyPig notifications@github.com wrote:

I installed java, and ran this command to start the application:

java -jar C:\echo\amazon-echo-bridge-0.4.0.jar --upnp.config.address=192.168.1.2 --server.port=8098

This is the output:

C:\Echo>java -jar C:\echo\amazon-echo-bridge-0.4.0.jar --upnp.config.address=192.168.1.2 --server.port=8098

. _ _ /\ / ' () _ \ \ \ \ ( ( ) | ' | '| | ' \/ ` | \ \ \ \ \/ _)| |)| | | | | || (| | ) ) ) ) ' |__| .|| ||| |_, | / / / / =========||==============|_/=///_/ :: Spring Boot :: (v1.2.6.RELEASE)

2016-10-16 03:44:26.825 INFO 4632 --- [ main] com.armzilla.ha.SpringbootEntry : Starting SpringbootEntry v0.4.0 on nibblypc with PID 4632 (C:\Echo\amazon-echo-bridge-0.4.0.jar started by nibbly in C:\Echo) 2016-10-16 03:44:26.868 INFO 4632 --- [ main] ationConfigEmbeddedWebApplicationContext : Refreshing org.springframework.boot.context.embedded.AnnotationConfigEmbeddedWebApplicationContext@ 63de678 https://github.com/org.springframework.boot.context.embedded.AnnotationConfigEmbeddedWebApplicationContext/amazon-echo-ha-bridge/commit/63de678d: startup date [Sun Oct 16 03:44:26 BST 2016]; root of context hierarchy 2016-10-16 03:44:27.586 INFO 4632 --- [ main] o.s.b.f.s.DefaultListableBeanFactory : Overriding bean definition for bean 'beanNameViewResolver': replacing [Root bean: class [null]; scope=; abstract=false; lazyInit=false; autowireMode=3; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=org.springframework.boot.autoconfigure.web.ErrorMvcAutoConfiguration$WhitelabelErrorViewConfiguration; factoryMethodName=beanNameViewResolver; initMethodName=null; destroyMethodName=(inferred); defined in class path resource [org/springframework/boot/autoconfigure/web/ErrorMvcAutoConfiguration$WhitelabelErrorViewConfiguration.class]] with [Root bean: class [null]; scope=; abstract=false; lazyInit=false; autowireMode=3; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=org.springframework.boot.autoconfigure.web.WebMvcAutoConfiguration$WebMvcAutoConfigurationAdapter; factoryMethodName=beanNameViewResolver; initMethodName=null; destroyMethodName=(inferred); defined in class path resource [org/springframework/boot/autoconfigure/web/WebMvcAutoConfiguration$WebMvcAutoConfigurationAdapter.class]] 2016-10-16 03:44:28.071 INFO 4632 --- [ main] trationDelegate$BeanPostProcessorChecker : Bean 'org.springframework.scheduling.annotation.SchedulingConfiguration' of type [class org.springframework.scheduling.annotation.SchedulingConfiguration$$EnhancerBySpringCGLIB$$4151c85b] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2016-10-16 03:44:28.709 INFO 4632 --- [ main] s.b.c.e.t.TomcatEmbeddedServletContainer : Tomcat initialized with port(s): 8098 (http) 8081 (http) 8082 (http) 2016-10-16 03:44:28.914 INFO 4632 --- [ main] o.apache.catalina.core.StandardService : Starting service Tomcat 2016-10-16 03:44:28.917 INFO 4632 --- [ main] org.apache.catalina.core.StandardEngine : Starting Servlet Engine: Apache Tomcat/8.0.26 2016-10-16 03:44:29.001 INFO 4632 --- [ost-startStop-1] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring embedded WebApplicationContext 2016-10-16 03:44:29.006 INFO 4632 --- [ost-startStop-1] o.s.web.context.ContextLoader : Root WebApplicationContext: initialization completed in 2140 ms 2016-10-16 03:44:30.029 INFO 4632 --- [ost-startStop-1] o.s.b.c.e.ServletRegistrationBean : Mapping servlet: 'dispatcherServlet' to [/] 2016-10-16 03:44:30.043 INFO 4632 --- [ost-startStop-1] o.s.b.c.embedded.FilterRegistrationBean : Mapping filter: 'metricFilter' to: [/ ] 2016-10-16 03:44:30.049 INFO 4632 --- [ost-startStop-1] o.s.b.c.embedded.FilterRegistrationBean : Mapping filter: 'characterEncodingFilter' to: [/] 2016-10-16 03:44:30.053 INFO 4632 --- [ost-startStop-1] o.s.b.c.embedded.FilterRegistrationBean : Mapping filter: 'hiddenHttpMethodFilter' to: [/ ] 2016-10-16 03:44:30.055 INFO 4632 --- [ost-startStop-1] o.s.b.c.embedded.FilterRegistrationBean : Mapping filter: 'webRequestLoggingFilter' to: [/] 2016-10-16 03:44:30.058 INFO 4632 --- [ost-startStop-1] o.s.b.c.embedded.FilterRegistrationBean : Mapping filter: 'springBootCorsFilter' to: [/ ] 2016-10-16 03:44:30.062 INFO 4632 --- [ost-startStop-1] o.s.b.c.embedded.FilterRegistrationBean : Mapping filter: 'applicationContextIdFilter' to: [/] 2016-10-16 03:44:30.298 INFO 4632 --- [ main] org.elasticsearch.node : [Brute II] version[1.3.2], pid[4632], build[dee175d/2014-08-13T14:29:30Z] 2016-10-16 03:44:30.300 INFO 4632 --- [ main] org.elasticsearch.node : [Brute II] initializing ... 2016-10-16 03:44:30.305 INFO 4632 --- [ main] org.elasticsearch.plugins : [Brute II] loaded [], sites [] 2016-10-16 03:44:31.730 INFO 4632 --- [ main] org.elasticsearch.node : [Brute II] initialized 2016-10-16 03:44:31.732 INFO 4632 --- [ main] org.elasticsearch.node : [Brute II] starting ... 2016-10-16 03:44:31.742 INFO 4632 --- [ main] org.elasticsearch.transport : [Brute II] bound_address {local[1]}, publish_address {local[1]} 2016-10-16 03:44:31.758 INFO 4632 --- [ main] org.elasticsearch.discovery : [Brute II] elasticsearch/T3tVGA7eRIOa8ZJqh0CR8g 2016-10-16 03:44:31.765 INFO 4632 --- [pdateTask][T#1]] org.elasticsearch.cluster.service : [Brute II] new_master [Brute II][T3tVGA7eRIOa8ZJqh0CR8g][nibblypc][local[1]]{local=true}, reason: local-disco-initial_connect(master) 2016-10-16 03:44:31.814 INFO 4632 --- [ main] org.elasticsearch.node : [Brute II] started 2016-10-16 03:44:32.284 INFO 4632 --- [pdateTask][T#1]] org.elasticsearch.gateway : [Brute II] recovered [1] indices into cluster_state 2016-10-16 03:44:32.714 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerAdapter : Looking for @ControllerAdvice: org.springframework.boot.context.embedded.AnnotationConfigEmbeddedWebApplicationContext@ 63de678 https://github.com/org.springframework.boot.context.embedded.AnnotationConfigEmbeddedWebApplicationContext/amazon-echo-ha-bridge/commit/63de678d: startup date [Sun Oct 16 03:44:26 BST 2016]; root of context hierarchy 2016-10-16 03:44:32.772 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/api/devices],methods=[POST],produces=[application/json]}" onto public org.springframework.http.ResponseEntity com.armzilla.ha.devicemanagmeent.DeviceResource.createDevice(com.armzilla.ha.api.Device) 2016-10-16 03:44:32.778 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/api/devices/{lightId}],methods=[PUT],produces=[application/json]}" onto public org.springframework.http.ResponseEntity com.armzilla.ha.devicemanagmeent.DeviceResource.updateDevice(java.lang.String,com.armzilla.ha.api.Device) 2016-10-16 03:44:32.784 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/api/devices],methods=[GET],produces=[application/json]}" onto public org.springframework.http.ResponseEntity> com.armzilla.ha.devicemanagmeent.DeviceResource.findAllDevices() 2016-10-16 03:44:32.790 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/api/devices/{lightId}],methods=[DELETE],produces=[application/json]}" onto public org.springframework.http.ResponseEntity com.armzilla.ha.devicemanagmeent.DeviceResource.deleteDeviceById(java.lang.String) 2016-10-16 03:44:32.796 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/api/devices/{lightId}],methods=[GET],produces=[application/json]}" onto public org.springframework.http.ResponseEntity com.armzilla.ha.devicemanagmeent.DeviceResource.findByDevicId(java.lang.String) 2016-10-16 03:44:32.802 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/api/{userId}/lights],methods=[GET],produces=[application/json]}" onto public org.springframework.http.ResponseEntity> com.armzilla.ha.hue.HueMulator.getUpnpConfiguration(java.lang.String,javax.servlet.http.HttpServletRequest) 2016-10-16 03:44:32.809 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/api/{userId}/lights/{lightId}/state],methods=[PUT]}" onto public org.springframework.http.ResponseEntity com.armzilla.ha.hue.HueMulator.stateChange(java.lang.String,java.lang.String,javax.servlet.http.HttpServletRequest,java.lang.String) 2016-10-16 03:44:32.815 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/api/

],methods=[POST],produces=[application/json]}" onto public org.springframework.http.ResponseEntity com.armzilla.ha.hue.HueMulator.postAPI(javax.servlet.http.HttpServletRequest) 2016-10-16 03:44:32.820 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/api/{userId}/lights/{lightId}],methods=[GET],produces=[application/json]}" onto public org.springframework.http.ResponseEntity com.armzilla.ha.hue.HueMulator.getLigth(java.lang.String,java.lang.String,javax.servlet.http.HttpServletRequest) 2016-10-16 03:44:32.827 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/api/{userId}],methods=[GET],produces=[application/json]}" onto public org.springframework.http.ResponseEntity com.armzilla.ha.hue.HueMulator.getApi(java.lang.String,javax.servlet.http.HttpServletRequest) 2016-10-16 03:44:32.833 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/upnp/{deviceId}/setup.xml],methods=[GET],produces=[application/xml]}" onto public org.springframework.http.ResponseEntity com.armzilla.ha.upnp.UpnpSettingsResource.getUpnpConfiguration(java.lang.String,javax.servlet.http.HttpServletRequest) 2016-10-16 03:44:32.839 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/error]}" onto public org.springframework.http.ResponseEntity> org.springframework.boot.autoconfigure.web.BasicErrorController.error(javax.servlet.http.HttpServletRequest) 2016-10-16 03:44:32.845 INFO 4632 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/error],produces=[text/html]}" onto public org.springframework.web.servlet.ModelAndView org.springframework.boot.autoconfigure.web.BasicErrorController.errorHtml(javax.servlet.http.HttpServletRequest) 2016-10-16 03:44:32.881 INFO 4632 --- [ main] o.s.w.s.handler.SimpleUrlHandlerMapping : Mapped URL path [/webjars/ ] onto handler of type [class org.springframework.web.servlet.resource.ResourceHttpRequestHandler] 2016-10-16 03:44:32.885 INFO 4632 --- [ main] o.s.w.s.handler.SimpleUrlHandlerMapping : Mapped URL path [/ ] onto handler of type [class org.springframework.web.servlet.resource.ResourceHttpRequestHandler] 2016-10-16 03:44:32.953 INFO 4632 --- [ main] o.s.w.s.handler.SimpleUrlHandlerMapping : Mapped URL path [/

/favicon.ico] onto handler of type [class org.springframework.web.servlet.resource.ResourceHttpRequestHandler] 2016-10-16 03:44:33.264 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/trace],methods=[GET]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke() 2016-10-16 03:44:33.271 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/env/{name:.}],methods=[GET]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EnvironmentMvcEndpoint.value(java.lang.String) 2016-10-16 03:44:33.284 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/env],methods=[GET]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke() 2016-10-16 03:44:33.291 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/info],methods=[GET]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke() 2016-10-16 03:44:33.296 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/dump],methods=[GET]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke() 2016-10-16 03:44:33.301 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/autoconfig],methods=[GET]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke() 2016-10-16 03:44:33.306 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/configprops],methods=[GET]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke() 2016-10-16 03:44:33.311 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/health]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.HealthMvcEndpoint.invoke(java.security.Principal) 2016-10-16 03:44:33.315 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/beans],methods=[GET]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke() 2016-10-16 03:44:33.320 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/metrics/{name:.*}],methods=[GET]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.MetricsMvcEndpoint.value(java.lang.String) 2016-10-16 03:44:33.325 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/metrics],methods=[GET]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke() 2016-10-16 03:44:33.333 INFO 4632 --- [ main] o.s.b.a.e.mvc.EndpointHandlerMapping : Mapped "{[/mappings],methods=[GET]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke() 2016-10-16 03:44:33.363 INFO 4632 --- [ main] o.s.j.e.a.AnnotationMBeanExporter : Registering beans for JMX exposure on startup 2016-10-16 03:44:33.372 INFO 4632 --- [ main] o.s.c.support.DefaultLifecycleProcessor : Starting beans in phase 0 2016-10-16 03:44:33.446 INFO 4632 --- [pool-1-thread-1] com.armzilla.ha.upnp.UpnpListener : Starting UPNP Discovery Listener 2016-10-16 03:44:33.512 INFO 4632 --- [ main] s.b.c.e.t.TomcatEmbeddedServletContainer : Tomcat started on port(s): 8098 (http) 8081 (http) 8082 (http) 2016-10-16 03:44:33.517 INFO 4632 --- [ main] com.armzilla.ha.SpringbootEntry : Started SpringbootEntry in 6.943 seconds (JVM running for 7.348) 2016-10-16 03:44:48.148 INFO 4632 --- [nio-8081-exec-1] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring FrameworkServlet 'dispatcherServlet' 2016-10-16 03:44:48.152 INFO 4632 --- [nio-8081-exec-1] o.s.web.servlet.DispatcherServlet : FrameworkServlet 'dispatcherServlet': initialization started 2016-10-16 03:44:48.173 INFO 4632 --- [nio-8081-exec-1] o.s.web.servlet.DispatcherServlet : FrameworkServlet 'dispatcherServlet': initialization completed in 19 ms 2016-10-16 03:44:48.206 INFO 4632 --- [nio-8082-exec-1] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge2 from 192.168.1.3 2016-10-16 03:44:48.207 INFO 4632 --- [nio-8081-exec-1] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge1 from 192.168.1.3 2016-10-16 03:44:54.541 INFO 4632 --- [nio-8081-exec-3] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge1 from 192.168.1.2 2016-10-16 03:44:54.544 INFO 4632 --- [nio-8082-exec-3] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge2 from 192.168.1.2

After I tell Alexa to discover devices, this appears:

2016-10-16 03:46:24.822 INFO 4632 --- [nio-8081-exec-5] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge1 from 192.168.1.126 2016-10-16 03:46:24.822 INFO 4632 --- [nio-8082-exec-8] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge2 from 192.168.1.126 2016-10-16 03:46:24.824 INFO 4632 --- [nio-8082-exec-1] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge2 from 192.168.1.126 2016-10-16 03:46:24.841 INFO 4632 --- [nio-8082-exec-9] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge2 from 192.168.1.126 2016-10-16 03:46:24.846 INFO 4632 --- [nio-8081-exec-6] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge1 from 192.168.1.126 2016-10-16 03:46:24.849 INFO 4632 --- [io-8082-exec-10] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge2 from 192.168.1.126 2016-10-16 03:46:24.852 INFO 4632 --- [nio-8081-exec-7] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge1 from 192.168.1.126 2016-10-16 03:46:24.860 INFO 4632 --- [nio-8081-exec-8] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge1 from 192.168.1.126 2016-10-16 03:46:25.598 INFO 4632 --- [nio-8082-exec-2] com.armzilla.ha.hue.HueMulator : hue lights list requested: RBoGp9dIoNqjqypzeUs9b16E2OOT1oEt0pqhgrxA from 192.168.1.1268082 2016-10-16 03:46:25.699 INFO 4632 --- [nio-8081-exec-9] com.armzilla.ha.hue.HueMulator : hue lights list requested: RBoGp9dIoNqjqypzeUs9b16E2OOT1oEt0pqhgrxA from 192.168.1.1268081 2016-10-16 03:46:25.760 INFO 4632 --- [nio-8082-exec-3] com.armzilla.ha.hue.HueMulator : hue lights list requested: RBoGp9dIoNqjqypzeUs9b16E2OOT1oEt0pqhgrxA from 192.168.1.1268082 2016-10-16 03:46:25.760 INFO 4632 --- [nio-8081-exec-1] com.armzilla.ha.hue.HueMulator : hue lights list requested: RBoGp9dIoNqjqypzeUs9b16E2OOT1oEt0pqhgrxA from 192.168.1.1268081 2016-10-16 03:46:25.768 INFO 4632 --- [io-8081-exec-10] com.armzilla.ha.hue.HueMulator : hue lights list requested: RBoGp9dIoNqjqypzeUs9b16E2OOT1oEt0pqhgrxA from 192.168.1.1268081 2016-10-16 03:46:25.959 INFO 4632 --- [nio-8082-exec-4] com.armzilla.ha.hue.HueMulator : hue lights list requested: RBoGp9dIoNqjqypzeUs9b16E2OOT1oEt0pqhgrxA from 192.168.1.1268082 2016-10-16 03:46:26.010 INFO 4632 --- [nio-8081-exec-2] com.armzilla.ha.hue.HueMulator : hue lights list requested: RBoGp9dIoNqjqypzeUs9b16E2OOT1oEt0pqhgrxA from 192.168.1.1268081 2016-10-16 03:46:26.062 INFO 4632 --- [nio-8082-exec-5] com.armzilla.ha.hue.HueMulator : hue lights list requested: RBoGp9dIoNqjqypzeUs9b16E2OOT1oEt0pqhgrxA from 192.168.1.1268082

After this, nothing happens.

Any suggestions to debug?

— You are receiving this because you are subscribed to this thread. Reply to this email directly, view it on GitHub https://github.com/armzilla/amazon-echo-ha-bridge/issues/84, or mute the thread https://github.com/notifications/unsubscribe-auth/ABTxZpGksX9z3sgbwgwxXPts2q9inFJFks5q0ZA0gaJpZM4KX31i .

dangeist commented 7 years ago

I'm in the same boat. I'm a long time ISY user with light API experience. I just got a Dot v2 the other day (first one ever) and setup version 0.4.0 of the ha_bridge with Oracle java 8 on Ubuntu 16.04:
/usr/bin/java -jar -Djava.net.preferIPv4Stack=true /usr/local/src/amazon-echo-ha-bridge-master/target/amazon-echo-bridge-0.4.0.jar --upnp.config.address=192.168.1.78

I finally figure out how to generate the URLs for my scenes and I'm able to query them manually and they appear to be populated at http://192.168.1.78:8080/api/devices:

[{"content":[{"id":"45ff3d4f-1efd-424e-8328-83ce73265a65","name":"Guest Bedroom Light","deviceType":"Scene","offUrl":"http://****:****@192.168.1.7:80/rest/nodes/34057/cmd/DOF","onUrl":"http://****:****@192.168.1.7:80/rest/nodes/34057/cmd/DON","httpVerb":null,"contentType":null,"contentBody":null},{"id":"094b3dba-31f4-49d6-9000-7e5be263750c","name":"Sebastian's Bedroom Light","deviceType":"Scene","offUrl":"http://****:****@192.168.1.7:80/rest/nodes/39232/cmd/DOF","onUrl":"http://****:****@192.168.1.7:80/rest/nodes/39232/cmd/DON","httpVerb":null,"contentType":null,"contentBody":null},{"id":"a83559b4-f4d0-43c3-9fad-0c1cc0ded431","name":"Genevieve's Bedroom Light","deviceType":"Scene","offUrl":"http://****:****@192.168.1.7:80/rest/nodes/30690/cmd/DOF","onUrl":"http://****:****@192.168.1.7:80/rest/nodes/30690/cmd/DON","httpVerb":null,"contentType":null,"contentBody":null},{"id":"8f099e0f-6049-4aa6-88ea-f289341172df","name":"Dining Room Chandelier","deviceType":"Scene","offUrl":"http://****:****@192.168.1.7:80/rest/nodes/60190/cmd/DOF","onUrl":"http://****:****@192.168.1.7:80/rest/nodes/60190/cmd/DON","httpVerb":null,"contentType":null,"contentBody":null},{"id":"571c2682-4602-4c00-85ba-4cdbda123ab9","name":"Front Porch Light","deviceType":"Scene","offUrl":"http://****:****@192.168.1.7:80/rest/nodes/52151/cmd/DOF","onUrl":"http://****:****@192.168.1.7:80/rest/nodes/52151/cmd/DON","httpVerb":null,"contentType":null,"contentBody":null},{"id":"fbd69290-f052-4a3f-aeeb-17ae823da7f8","name":"Garage Back Door Light","deviceType":"Scene","offUrl":"http://****:****@192.168.1.7:80/rest/nodes/30656/cmd/DOF","onUrl":"http://****:****@192.168.1.7:80/rest/nodes/30656/cmd/DON","httpVerb":null,"contentType":null,"contentBody":null},{"id":"1a7f1fe1-670a-4ca1-b844-4b1f8ed9f02e","name":"Kitchen Table Light","deviceType":"Scene","offUrl":"http://****:****@192.168.1.7:80/rest/nodes/7959/cmd/DOF","onUrl":"http://****:****@192.168.1.7:80/rest/nodes/7959/cmd/DON","httpVerb":null,"contentType":null,"contentBody":null}],"facets":],"totalElements":7,"totalPages":1,"last":true,"sort":null,"first":true,"numberOfElements":7,"size":7,"number":0}]

The discovery, if initiated via the alexa website or via voice command, both seem to initiate communications (the logging increments with lots of:

INFO 6467 --- [nio-8081-exec-1] com.armzilla.ha.hue.HueMulator : hue lights list requested: c 3sycnDxwQUoiS2FhjqcdatdkvGiEGmDKbdP0ov1 from 192.168.1.798081

...and so forth.

Do you think there was a change in the discovery mechanisms in the v2 dot unit?

Dan

NibblyPig commented 7 years ago

I've managed to get mine working, both my echo and dot v2. Unfortunately I can't explain what I did, I just kept fiddling. At least you know it works in theory though. I can only suggest ensuring that upnp is enabled on your router.

dangeist commented 7 years ago

@NibblyPig , what were you fiddling WITH? I have both devices on the same logical subnet of my home network, so uPnP shouldn't really matter. It's all broadcast frames at that point. How does your topology compare and what all did you tweak (even if you don't know what fixed it)?

dangeist commented 7 years ago

I was able to get mine working as well, but I did literally nothing. Just left it alone, went to bed, and checked it from work the next morning. I'm wondering if there's a scaling problem on the limited power VM I'm using. Is there a syslog output of the java execution that I can check (or set on the cli next time so I can track it?)

Dan

jlekhter commented 7 years ago

Discovery doesnt work for me either. I went back to 2.1 version of the code and can discover all my devices, but in 4.0 it doesnt work. was hoping to get more devices loaded with 4.0

ianj001 commented 7 years ago

I am having the same problem too, I see lots of requests like this: oiS2FhjqcdatdkvGiEGmDKbdP0ov1 from 192.168.1.108081 2016-10-31 21:06:58.784 INFO 3648 --- [nio-8082-exec-6] com.armzilla.ha.hue.HueMulator : hue lights list requested: c3sycnDxwQUoiS2FhjqcdatdkvGiEGmDKbdP0ov1 from 192.168.1.108082 2016-10-31 21:06:58.851 INFO 3648 --- [nio-8081-exec-1] com.armzilla.ha.hue.HueMulator : hue lights list requested: c3sycnDxwQUoiS2FhjqcdatdkvGiEGmDKbdP0ov1 from 192.168.1.108081 2016-10-31 21:07:01.204 INFO 3648 --- [nio-8082-exec-9] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge2 from 192.168.1.27 2016-10-31 21:07:02.637 INFO 3648 --- [nio-8082-exec-8] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge2 from 192.168.1.27 2016-10-31 21:07:04.630 INFO 3648 --- [nio-8082-exec-1] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge2 from 192.168.1.27 2016-10-31 21:09:00.913 INFO 3648 --- [io-8082-exec-10] c.armzilla.ha.upnp.UpnpSettingsResource : upnp device settings requested: amazon-ha-bridge2 from 192.168.1.27 but the Amazon Echo never finds any new devices. For full disclosure, I have a TP-LINK HS100 connected to the Echo using the Kasa skill.

I am able to see my devices in the bridge and modify them in the configurator. I have also checked that devices are valid and working through Openhab2

My devices look like this:

[{"content":[{"id":"d342eb3e-f18c-4a76-a46c-520f632e48d6","name":"LampLight","deviceType":"switch","offUrl":"http://192.168.1.23:8080/classicui/CMD?Living_Room=OFF","onUrl":"http://localhost:8080/classicui/CMD?Living_Room=ON","httpVerb":null,"contentType":null,"contentBody":null},{"id":"00665c6b-e70d-4afe-9093-216964655421","name":"Camera","deviceType":"switch","offUrl":"http://localhost:8080/CMD?IP_CAM=OFF","onUrl":"http://localhost:8080/classicui/CMD?IP_CAM=ON","httpVerb":null,"contentType":null,"contentBody":null}],"facets":[],"totalElements":2,"totalPages":1,"last":true,"sort":null,"first":true,"numberOfElements":2,"size":2,"number":0}]

Any help to get these devices discovered would be greatly appreciated.

NOTE: I saw this on another issue here and installed the bridge from here https://github.com/bwssytems/ha-bridge it works like a champ.

hazymat commented 7 years ago

@ianj001 I had what looks to be the same problem. Devices are showing fine from /api/devices, but the Alexa app simply didn't discover them. As per @jlekhter, I rolled back to 0.2.1 and it worked.

davidn70 commented 7 years ago

FWIW I am seeing the same issue. New user to this project but really long time ISY/Insteon/API user. 0.2.1 works great for me, but 0.4.0 does not work at all. Using Echo Dot 2.

spencerryan commented 7 years ago

Same thing here. 0.2.1 works fine, 0.4.0 does not. Insteon/misterhouse user here.

nbrysondev commented 7 years ago

Likewise, rollback to 0.2.1 works for me.

phutchins commented 7 years ago

Same issue here. I've attempted to log out what the bridge finds here:

https://github.com/armzilla/amazon-echo-ha-bridge/blob/master/src/main/java/com/armzilla/ha/hue/HueMulator.java#L71

but it seems there are no devices added to the responsemap as this line is never reached:

https://github.com/armzilla/amazon-echo-ha-bridge/blob/master/src/main/java/com/armzilla/ha/hue/HueMulator.java#L74

I too have a valid device in my device list and can see them through the UI. Rolling back to 0.2.1 works for me as well.

excal2 commented 7 years ago

I had the same issue and rolling back to 0.2.1 worked straightaway . I had assumed it was a multicast issue so I tried that first , with no solution.

Thanks for the rollback suggestion , i'm up and running now

staehler commented 7 years ago

The same here, a downgrade helped. 0.4.0 seems to be buggy.

jimkernsjr commented 7 years ago

Hi All... Here are my discoveries: -I seem to have the same experience as you all. So I moved it to a separate Linux installation, and let it start on 8080. Discovered fine.
-Removed devices from Amazon, changed the start port to 8083, so it would pick 8081+8082+8083, and discovery no longer works.
-Reverted to 2.1, discovery works on 8081

So for me, you can use 0.4.0 if you are ok with the default ports. If not, back to 0.2.1 Hope it helps! BTW...letting it discover, then switching back to 0.4.0 using alternate ports does not work...I have to stay with 0.2.1 if using alternate ports...

gregreid commented 7 years ago

THANK YOU for that. Yes, 0.4.0 only works if you allow it to use the default 8080 (and 8081, 8082) ports. I had my 0.2.1 set up to use 8089 (because my NAS administrative web interface was already using 8080), and ran into the same issue of Alexa device discovery coming up empty -- even with just a single simple switch configured for a test.

I found the way to reconfigure my NAS admin interface to use 9090 instead, then allowed the amazon-echo-ha-bridge 0.4.0 to use its default 8080, and now everything is good again.

This seems that it ought to be a relatively easy problem for the author to fix. But thank you for the circumvention!

Greg