search

falk0069 / hue-upnp

Philips Hue UPNP and HTTP emulator (works with the Android Hue app and Logitech Harmony Home Remotes)
30 stars 10 forks source link

no pairing with myharmony software #1

Closed Pmant closed 9 years ago

Pmant commented 9 years ago

myHarmony Software can't pair with emulator, here is the server's log (Hub's IP: 192.168.0.23):

2015-03-04 05:26:07,178 [INFO ] Server starting
2015-03-04 05:26:13,916 [INFO ] received M-SEARCH from ('192.168.0.23', 36012)
2015-03-04 05:26:13,916 [DEBUG]  data:
M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 2

ST: ssdp:all
2015-03-04 05:26:13,916 [DEBUG] ignoring
2015-03-04 05:26:13,916 [DEBUG] ----------------------
2015-03-04 05:26:13,916 [DEBUG]   
2015-03-04 05:26:14,018 [INFO ] received M-SEARCH from ('192.168.0.23', 36012)
2015-03-04 05:26:14,018 [DEBUG]  data:
M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 2

ST: urn:schemas-upnp-org:device:basic:1
2015-03-04 05:26:14,018 [DEBUG] received schemas-upnp-org:device:basic:1
2015-03-04 05:26:14,019 [INFO ] Response sent: http://192.168.0.53:80/description.xml
2015-03-04 05:26:14,019 [DEBUG] ----------------------
2015-03-04 05:26:14,019 [DEBUG]   
2015-03-04 05:26:14,121 [INFO ] received M-SEARCH from ('192.168.0.23', 36012)
2015-03-04 05:26:14,121 [DEBUG]  data:
M-SEARCH * HTTP/1.1

HOST:239.255.255.250:1900

MAN: "ssdp:discover"

MX: 3

ST: urn:schemas-udap:service:smartText:1

USER-AGENT: UDAP/2.0
2015-03-04 05:26:14,121 [DEBUG] ignoring
2015-03-04 05:26:14,121 [DEBUG] ----------------------
2015-03-04 05:26:14,121 [DEBUG]   
2015-03-04 05:26:14,633 [INFO ] received M-SEARCH from ('192.168.0.23', 36012)
2015-03-04 05:26:14,634 [DEBUG]  data:
M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 2

ST: ssdp:all
2015-03-04 05:26:14,634 [DEBUG] ignoring
2015-03-04 05:26:14,634 [DEBUG] ----------------------
2015-03-04 05:26:14,634 [DEBUG]   
2015-03-04 05:26:14,735 [INFO ] received M-SEARCH from ('192.168.0.23', 36012)
2015-03-04 05:26:14,735 [DEBUG]  data:
M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 2

ST: urn:schemas-upnp-org:device:basic:1
2015-03-04 05:26:14,735 [DEBUG] received schemas-upnp-org:device:basic:1
2015-03-04 05:26:14,735 [INFO ] Response sent: http://192.168.0.53:80/description.xml
2015-03-04 05:26:14,735 [DEBUG] ----------------------
2015-03-04 05:26:14,735 [DEBUG]   
2015-03-04 05:26:15,248 [INFO ] received M-SEARCH from ('192.168.0.23', 36012)
2015-03-04 05:26:15,248 [DEBUG]  data:
M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 2

ST: ssdp:all
2015-03-04 05:26:15,248 [DEBUG] ignoring
2015-03-04 05:26:15,248 [DEBUG] ----------------------
2015-03-04 05:26:15,248 [DEBUG]   
2015-03-04 05:26:15,349 [INFO ] received M-SEARCH from ('192.168.0.23', 36012)
2015-03-04 05:26:15,349 [DEBUG]  data:
M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 2

ST: urn:schemas-upnp-org:device:basic:1
2015-03-04 05:26:15,349 [DEBUG] received schemas-upnp-org:device:basic:1
2015-03-04 05:26:15,350 [INFO ] Response sent: http://192.168.0.53:80/description.xml
2015-03-04 05:26:15,350 [DEBUG] ----------------------
2015-03-04 05:26:15,350 [DEBUG]   
2015-03-04 05:26:15,452 [INFO ] received M-SEARCH from ('192.168.0.23', 36012)
2015-03-04 05:26:15,452 [DEBUG]  data:
M-SEARCH * HTTP/1.1

HOST:239.255.255.250:1900

MAN: "ssdp:discover"

MX: 3

ST: urn:schemas-udap:service:smartText:1

USER-AGENT: UDAP/2.0
2015-03-04 05:26:15,452 [DEBUG] ignoring
2015-03-04 05:26:15,452 [DEBUG] ----------------------
2015-03-04 05:26:15,452 [DEBUG]   
2015-03-04 05:26:15,861 [INFO ] received M-SEARCH from ('192.168.0.23', 36012)
2015-03-04 05:26:15,861 [DEBUG]  data:
M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 2

ST: ssdp:all
2015-03-04 05:26:15,862 [DEBUG] ignoring
2015-03-04 05:26:15,862 [DEBUG] ----------------------
2015-03-04 05:26:15,862 [DEBUG]   
2015-03-04 05:26:15,964 [INFO ] received M-SEARCH from ('192.168.0.23', 36012)
2015-03-04 05:26:15,964 [DEBUG]  data:
M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 2

ST: urn:schemas-upnp-org:device:basic:1
2015-03-04 05:26:15,964 [DEBUG] received schemas-upnp-org:device:basic:1
2015-03-04 05:26:15,964 [INFO ] Response sent: http://192.168.0.53:80/description.xml
2015-03-04 05:26:15,964 [DEBUG] ----------------------
2015-03-04 05:26:15,964 [DEBUG]   
2015-03-04 05:26:16,066 [INFO ] received M-SEARCH from ('192.168.0.23', 36012)
2015-03-04 05:26:16,066 [DEBUG]  data:
M-SEARCH * HTTP/1.1

HOST:239.255.255.250:1900

MAN: "ssdp:discover"

MX: 3

ST: urn:schemas-udap:service:smartText:1

USER-AGENT: UDAP/2.0
2015-03-04 05:26:16,066 [DEBUG] ignoring
2015-03-04 05:26:16,066 [DEBUG] ----------------------
2015-03-04 05:26:16,067 [DEBUG]   
2015-03-04 05:26:24,552 [INFO ] received M-SEARCH from ('192.168.0.58', 49775)
2015-03-04 05:26:24,552 [DEBUG]  data:
M-SEARCH * HTTP/1.1

Host:239.255.255.250:1900

ST:urn:schemas-upnp-org:device:InternetGatewayDevice:1

Man:"ssdp:discover"

MX:3
2015-03-04 05:26:24,552 [DEBUG] ignoring
2015-03-04 05:26:24,553 [DEBUG] ----------------------
2015-03-04 05:26:24,553 [DEBUG]   
2015-03-04 05:26:27,561 [INFO ] received M-SEARCH from ('192.168.0.58', 49775)
2015-03-04 05:26:27,562 [DEBUG]  data:
M-SEARCH * HTTP/1.1

Host:239.255.255.250:1900

ST:urn:schemas-upnp-org:device:InternetGatewayDevice:1

Man:"ssdp:discover"

MX:3
2015-03-04 05:26:27,562 [DEBUG] ignoring
2015-03-04 05:26:27,562 [DEBUG] ----------------------
2015-03-04 05:26:27,562 [DEBUG]   
2015-03-04 05:26:30,572 [INFO ] received M-SEARCH from ('192.168.0.58', 49775)
2015-03-04 05:26:30,572 [DEBUG]  data:
M-SEARCH * HTTP/1.1

Host:239.255.255.250:1900

ST:urn:schemas-upnp-org:device:InternetGatewayDevice:1

Man:"ssdp:discover"

MX:3
2015-03-04 05:26:30,572 [DEBUG] ignoring
2015-03-04 05:26:30,572 [DEBUG] ----------------------
2015-03-04 05:26:30,572 [DEBUG]   
2015-03-04 05:26:32,392 [INFO ] received M-SEARCH from ('192.168.0.53', 1900)
2015-03-04 05:26:32,392 [DEBUG]  data:
M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 2

ST: roku:ecp
2015-03-04 05:26:32,392 [DEBUG] ignoring
2015-03-04 05:26:32,392 [DEBUG] ----------------------
2015-03-04 05:26:32,392 [DEBUG]   
2015-03-04 05:26:33,389 [INFO ] received M-SEARCH from ('192.168.0.53', 1900)
2015-03-04 05:26:33,389 [DEBUG]  data:
M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 2

ST: roku:ecp
2015-03-04 05:26:33,389 [DEBUG] ignoring
2015-03-04 05:26:33,389 [DEBUG] ----------------------
2015-03-04 05:26:33,389 [DEBUG]   
2015-03-04 05:26:33,605 [INFO ] received M-SEARCH from ('192.168.0.58', 49775)
2015-03-04 05:26:33,605 [DEBUG]  data:
M-SEARCH * HTTP/1.1

Host:239.255.255.250:1900

ST:urn:schemas-upnp-org:device:InternetGatewayDevice:1

Man:"ssdp:discover"

MX:3
2015-03-04 05:26:33,605 [DEBUG] ignoring
2015-03-04 05:26:33,605 [DEBUG] ----------------------
2015-03-04 05:26:33,606 [DEBUG]   
2015-03-04 05:26:34,389 [INFO ] received M-SEARCH from ('192.168.0.53', 1900)
2015-03-04 05:26:34,389 [DEBUG]  data:
M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 2

ST: roku:ecp
2015-03-04 05:26:34,389 [DEBUG] ignoring
2015-03-04 05:26:34,389 [DEBUG] ----------------------
2015-03-04 05:26:34,389 [DEBUG]   
2015-03-04 05:26:36,609 [INFO ] received M-SEARCH from ('192.168.0.58', 49775)
2015-03-04 05:26:36,609 [DEBUG]  data:
M-SEARCH * HTTP/1.1

Host:239.255.255.250:1900

ST:urn:schemas-upnp-org:device:InternetGatewayDevice:1

Man:"ssdp:discover"

MX:3
2015-03-04 05:26:36,609 [DEBUG] ignoring
2015-03-04 05:26:36,609 [DEBUG] ----------------------
2015-03-04 05:26:36,609 [DEBUG]   
2015-03-04 05:26:39,619 [INFO ] received M-SEARCH from ('192.168.0.58', 49775)
2015-03-04 05:26:39,619 [DEBUG]  data:
M-SEARCH * HTTP/1.1

Host:239.255.255.250:1900

ST:urn:schemas-upnp-org:device:InternetGatewayDevice:1

Man:"ssdp:discover"

MX:3
2015-03-04 05:26:39,619 [DEBUG] ignoring
2015-03-04 05:26:39,619 [DEBUG] ----------------------
2015-03-04 05:26:39,619 [DEBUG]   
2015-03-04 05:26:54,773 [INFO ] http request from 192.168.0.23
2015-03-04 05:27:04,782 [DEBUG] HTTP Request: GET /description.xml HTTP/1.1

connection: keep-alive

content-length: 0

accept-language: en-us

user-agent: UDAP/2.0 Mozilla/5.0 (X11; Linux i686)

accept: /*

te: trailers

accept-encoding: gzip, deflate

host: 192.168.0.53
2015-03-04 05:27:04,783 [INFO ] Sent HTTP Response
2015-03-04 05:27:04,783 [DEBUG] -------------------------------
2015-03-04 05:27:04,783 [DEBUG]     
2015-03-04 05:27:04,790 [INFO ] http request from 192.168.0.23
2015-03-04 05:27:14,802 [DEBUG] HTTP Request: GET /description.xml HTTP/1.1

connection: keep-alive

content-length: 0

accept-language: en-us

user-agent: UDAP/2.0 Mozilla/5.0 (X11; Linux i686)

accept: /*

te: trailers

accept-encoding: gzip, deflate

host: 192.168.0.53
2015-03-04 05:27:14,802 [INFO ] Sent HTTP Response
2015-03-04 05:27:14,802 [DEBUG] -------------------------------
2015-03-04 05:27:14,802 [DEBUG]     
2015-03-04 05:27:14,806 [INFO ] http request from 192.168.0.23
2015-03-04 05:27:24,816 [DEBUG] HTTP Request: GET /description.xml HTTP/1.1

connection: keep-alive

content-length: 0

accept-language: en-us

user-agent: UDAP/2.0 Mozilla/5.0 (X11; Linux i686)

accept: /*

te: trailers

accept-encoding: gzip, deflate

host: 192.168.0.53
2015-03-04 05:27:24,816 [INFO ] Sent HTTP Response
2015-03-04 05:27:24,817 [DEBUG] -------------------------------
2015-03-04 05:27:24,817 [DEBUG]     
2015-03-04 05:27:41,868 [INFO ] received M-SEARCH from ('192.168.0.1', 55631)
2015-03-04 05:27:41,868 [DEBUG]  data:
M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 5

ST: urn:schemas-upnp-org:device:avm-aha:1
2015-03-04 05:27:41,868 [DEBUG] ignoring
2015-03-04 05:27:41,868 [DEBUG] ----------------------
2015-03-04 05:27:41,868 [DEBUG]   
2015-03-04 05:27:46,580 [INFO ] Waiting for connections to end before exiting
2015-03-04 05:27:46,884 [INFO ] received M-SEARCH from ('192.168.0.1', 55631)
2015-03-04 05:27:46,885 [DEBUG]  data:
M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 5

ST: urn:schemas-upnp-org:device:avm-aha:1
2015-03-04 05:27:46,885 [DEBUG] ignoring
2015-03-04 05:27:46,885 [DEBUG] ----------------------
2015-03-04 05:27:46,885 [DEBUG]
falk0069 commented 9 years ago

Sweet! You're trying my code. Let's see if we can figure this out. One thing I see is you are using port 80 for the http callback server. When the server is running can you access this URL? http://192.168.0.53:80/ http://192.168.0.53/description.xmldescription. http://192.168.0.53/description.xmlxml http://192.168.0.53/description.xml

You might want to make sure nothing else is using that port such as a webserver (e.g. apache). Also if running on Linux you'll need to run as root if using that port. Alternatively, you could try a high port such as 8080 instead. That is what I use for my Harmony remote. I'll let you know if I see anything else.

Andy On Mar 4, 2015 7:32 AM, "Pmant" notifications@github.com wrote:

myHarmony Software can't pair with emulator, here is the server's log (Hub's IP: 192.168.0.23):

2015-03-04 05:26:07,178 [INFO ] Server starting 2015-03-04 05:26:13,916 [INFO ] received M-SEARCH from ('192.168.0.23', 36012) 2015-03-04 05:26:13,916 [DEBUG] data: M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 2

ST: ssdp:all 2015-03-04 05:26:13,916 [DEBUG] ignoring 2015-03-04 05:26:13,916 [DEBUG] ---------------------- 2015-03-04 05:26:13,916 [DEBUG] 2015-03-04 05:26:14,018 [INFO ] received M-SEARCH from ('192.168.0.23', 36012) 2015-03-04 05:26:14,018 [DEBUG] data: M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 2

ST: urn:schemas-upnp-org:device:basic:1 2015-03-04 05:26:14,018 [DEBUG] received schemas-upnp-org:device:basic:1 2015-03-04 05:26:14,019 [INFO ] Response sent: http://192.168.0.53:80/description.xml 2015-03-04 05:26:14,019 [DEBUG] ---------------------- 2015-03-04 05:26:14,019 [DEBUG] 2015-03-04 05:26:14,121 [INFO ] received M-SEARCH from ('192.168.0.23', 36012) 2015-03-04 05:26:14,121 [DEBUG] data: M-SEARCH * HTTP/1.1

HOST:239.255.255.250:1900

MAN: "ssdp:discover"

MX: 3

ST: urn:schemas-udap:service:smartText:1

USER-AGENT: UDAP/2.0 2015-03-04 05:26:14,121 [DEBUG] ignoring 2015-03-04 05:26:14,121 [DEBUG] ---------------------- 2015-03-04 05:26:14,121 [DEBUG] 2015-03-04 05:26:14,633 [INFO ] received M-SEARCH from ('192.168.0.23', 36012) 2015-03-04 05:26:14,634 [DEBUG] data: M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 2

ST: ssdp:all 2015-03-04 05:26:14,634 [DEBUG] ignoring 2015-03-04 05:26:14,634 [DEBUG] ---------------------- 2015-03-04 05:26:14,634 [DEBUG] 2015-03-04 05:26:14,735 [INFO ] received M-SEARCH from ('192.168.0.23', 36012) 2015-03-04 05:26:14,735 [DEBUG] data: M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 2

ST: urn:schemas-upnp-org:device:basic:1 2015-03-04 05:26:14,735 [DEBUG] received schemas-upnp-org:device:basic:1 2015-03-04 05:26:14,735 [INFO ] Response sent: http://192.168.0.53:80/description.xml 2015-03-04 05:26:14,735 [DEBUG] ---------------------- 2015-03-04 05:26:14,735 [DEBUG] 2015-03-04 05:26:15,248 [INFO ] received M-SEARCH from ('192.168.0.23', 36012) 2015-03-04 05:26:15,248 [DEBUG] data: M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 2

ST: ssdp:all 2015-03-04 05:26:15,248 [DEBUG] ignoring 2015-03-04 05:26:15,248 [DEBUG] ---------------------- 2015-03-04 05:26:15,248 [DEBUG] 2015-03-04 05:26:15,349 [INFO ] received M-SEARCH from ('192.168.0.23', 36012) 2015-03-04 05:26:15,349 [DEBUG] data: M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 2

ST: urn:schemas-upnp-org:device:basic:1 2015-03-04 05:26:15,349 [DEBUG] received schemas-upnp-org:device:basic:1 2015-03-04 05:26:15,350 [INFO ] Response sent: http://192.168.0.53:80/description.xml 2015-03-04 05:26:15,350 [DEBUG] ---------------------- 2015-03-04 05:26:15,350 [DEBUG] 2015-03-04 05:26:15,452 [INFO ] received M-SEARCH from ('192.168.0.23', 36012) 2015-03-04 05:26:15,452 [DEBUG] data: M-SEARCH * HTTP/1.1

HOST:239.255.255.250:1900

MAN: "ssdp:discover"

MX: 3

ST: urn:schemas-udap:service:smartText:1

USER-AGENT: UDAP/2.0 2015-03-04 05:26:15,452 [DEBUG] ignoring 2015-03-04 05:26:15,452 [DEBUG] ---------------------- 2015-03-04 05:26:15,452 [DEBUG] 2015-03-04 05:26:15,861 [INFO ] received M-SEARCH from ('192.168.0.23', 36012) 2015-03-04 05:26:15,861 [DEBUG] data: M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 2

ST: ssdp:all 2015-03-04 05:26:15,862 [DEBUG] ignoring 2015-03-04 05:26:15,862 [DEBUG] ---------------------- 2015-03-04 05:26:15,862 [DEBUG] 2015-03-04 05:26:15,964 [INFO ] received M-SEARCH from ('192.168.0.23', 36012) 2015-03-04 05:26:15,964 [DEBUG] data: M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 2

ST: urn:schemas-upnp-org:device:basic:1 2015-03-04 05:26:15,964 [DEBUG] received schemas-upnp-org:device:basic:1 2015-03-04 05:26:15,964 [INFO ] Response sent: http://192.168.0.53:80/description.xml 2015-03-04 05:26:15,964 [DEBUG] ---------------------- 2015-03-04 05:26:15,964 [DEBUG] 2015-03-04 05:26:16,066 [INFO ] received M-SEARCH from ('192.168.0.23', 36012) 2015-03-04 05:26:16,066 [DEBUG] data: M-SEARCH * HTTP/1.1

HOST:239.255.255.250:1900

MAN: "ssdp:discover"

MX: 3

ST: urn:schemas-udap:service:smartText:1

USER-AGENT: UDAP/2.0 2015-03-04 05:26:16,066 [DEBUG] ignoring 2015-03-04 05:26:16,066 [DEBUG] ---------------------- 2015-03-04 05:26:16,067 [DEBUG] 2015-03-04 05:26:24,552 [INFO ] received M-SEARCH from ('192.168.0.58', 49775) 2015-03-04 05:26:24,552 [DEBUG] data: M-SEARCH * HTTP/1.1

Host:239.255.255.250:1900

ST:urn:schemas-upnp-org:device:InternetGatewayDevice:1

Man:"ssdp:discover"

MX:3 2015-03-04 05:26:24,552 [DEBUG] ignoring 2015-03-04 05:26:24,553 [DEBUG] ---------------------- 2015-03-04 05:26:24,553 [DEBUG] 2015-03-04 05:26:27,561 [INFO ] received M-SEARCH from ('192.168.0.58', 49775) 2015-03-04 05:26:27,562 [DEBUG] data: M-SEARCH * HTTP/1.1

Host:239.255.255.250:1900

ST:urn:schemas-upnp-org:device:InternetGatewayDevice:1

Man:"ssdp:discover"

MX:3 2015-03-04 05:26:27,562 [DEBUG] ignoring 2015-03-04 05:26:27,562 [DEBUG] ---------------------- 2015-03-04 05:26:27,562 [DEBUG] 2015-03-04 05:26:30,572 [INFO ] received M-SEARCH from ('192.168.0.58', 49775) 2015-03-04 05:26:30,572 [DEBUG] data: M-SEARCH * HTTP/1.1

Host:239.255.255.250:1900

ST:urn:schemas-upnp-org:device:InternetGatewayDevice:1

Man:"ssdp:discover"

MX:3 2015-03-04 05:26:30,572 [DEBUG] ignoring 2015-03-04 05:26:30,572 [DEBUG] ---------------------- 2015-03-04 05:26:30,572 [DEBUG] 2015-03-04 05:26:32,392 [INFO ] received M-SEARCH from ('192.168.0.53', 1900) 2015-03-04 05:26:32,392 [DEBUG] data: M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 2

ST: roku:ecp 2015-03-04 05:26:32,392 [DEBUG] ignoring 2015-03-04 05:26:32,392 [DEBUG] ---------------------- 2015-03-04 05:26:32,392 [DEBUG] 2015-03-04 05:26:33,389 [INFO ] received M-SEARCH from ('192.168.0.53', 1900) 2015-03-04 05:26:33,389 [DEBUG] data: M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 2

ST: roku:ecp 2015-03-04 05:26:33,389 [DEBUG] ignoring 2015-03-04 05:26:33,389 [DEBUG] ---------------------- 2015-03-04 05:26:33,389 [DEBUG] 2015-03-04 05:26:33,605 [INFO ] received M-SEARCH from ('192.168.0.58', 49775) 2015-03-04 05:26:33,605 [DEBUG] data: M-SEARCH * HTTP/1.1

Host:239.255.255.250:1900

ST:urn:schemas-upnp-org:device:InternetGatewayDevice:1

Man:"ssdp:discover"

MX:3 2015-03-04 05:26:33,605 [DEBUG] ignoring 2015-03-04 05:26:33,605 [DEBUG] ---------------------- 2015-03-04 05:26:33,606 [DEBUG] 2015-03-04 05:26:34,389 [INFO ] received M-SEARCH from ('192.168.0.53', 1900) 2015-03-04 05:26:34,389 [DEBUG] data: M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 2

ST: roku:ecp 2015-03-04 05:26:34,389 [DEBUG] ignoring 2015-03-04 05:26:34,389 [DEBUG] ---------------------- 2015-03-04 05:26:34,389 [DEBUG] 2015-03-04 05:26:36,609 [INFO ] received M-SEARCH from ('192.168.0.58', 49775) 2015-03-04 05:26:36,609 [DEBUG] data: M-SEARCH * HTTP/1.1

Host:239.255.255.250:1900

ST:urn:schemas-upnp-org:device:InternetGatewayDevice:1

Man:"ssdp:discover"

MX:3 2015-03-04 05:26:36,609 [DEBUG] ignoring 2015-03-04 05:26:36,609 [DEBUG] ---------------------- 2015-03-04 05:26:36,609 [DEBUG] 2015-03-04 05:26:39,619 [INFO ] received M-SEARCH from ('192.168.0.58', 49775) 2015-03-04 05:26:39,619 [DEBUG] data: M-SEARCH * HTTP/1.1

Host:239.255.255.250:1900

ST:urn:schemas-upnp-org:device:InternetGatewayDevice:1

Man:"ssdp:discover"

MX:3 2015-03-04 05:26:39,619 [DEBUG] ignoring 2015-03-04 05:26:39,619 [DEBUG] ---------------------- 2015-03-04 05:26:39,619 [DEBUG] 2015-03-04 05:26:54,773 [INFO ] http request from 192.168.0.23 2015-03-04 05:27:04,782 [DEBUG] HTTP Request: GET /description.xml HTTP/1.1

connection: keep-alive

content-length: 0

accept-language: en-us

user-agent: UDAP/2.0 Mozilla/5.0 (X11; Linux i686)

accept: /*

te: trailers

accept-encoding: gzip, deflate

host: 192.168.0.53 2015-03-04 05:27:04,783 [INFO ] Sent HTTP Response 2015-03-04 05:27:04,783 [DEBUG] ------------------------------- 2015-03-04 05:27:04,783 [DEBUG] 2015-03-04 05:27:04,790 [INFO ] http request from 192.168.0.23 2015-03-04 05:27:14,802 [DEBUG] HTTP Request: GET /description.xml HTTP/1.1

connection: keep-alive

content-length: 0

accept-language: en-us

user-agent: UDAP/2.0 Mozilla/5.0 (X11; Linux i686)

accept: /*

te: trailers

accept-encoding: gzip, deflate

host: 192.168.0.53 2015-03-04 05:27:14,802 [INFO ] Sent HTTP Response 2015-03-04 05:27:14,802 [DEBUG] ------------------------------- 2015-03-04 05:27:14,802 [DEBUG] 2015-03-04 05:27:14,806 [INFO ] http request from 192.168.0.23 2015-03-04 05:27:24,816 [DEBUG] HTTP Request: GET /description.xml HTTP/1.1

connection: keep-alive

content-length: 0

accept-language: en-us

user-agent: UDAP/2.0 Mozilla/5.0 (X11; Linux i686)

accept: /*

te: trailers

accept-encoding: gzip, deflate

host: 192.168.0.53 2015-03-04 05:27:24,816 [INFO ] Sent HTTP Response 2015-03-04 05:27:24,817 [DEBUG] ------------------------------- 2015-03-04 05:27:24,817 [DEBUG] 2015-03-04 05:27:41,868 [INFO ] received M-SEARCH from ('192.168.0.1', 55631) 2015-03-04 05:27:41,868 [DEBUG] data: M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 5

ST: urn:schemas-upnp-org:device:avm-aha:1 2015-03-04 05:27:41,868 [DEBUG] ignoring 2015-03-04 05:27:41,868 [DEBUG] ---------------------- 2015-03-04 05:27:41,868 [DEBUG] 2015-03-04 05:27:46,580 [INFO ] Waiting for connections to end before exiting 2015-03-04 05:27:46,884 [INFO ] received M-SEARCH from ('192.168.0.1', 55631) 2015-03-04 05:27:46,885 [DEBUG] data: M-SEARCH * HTTP/1.1

HOST: 239.255.255.250:1900

MAN: "ssdp:discover"

MX: 5

ST: urn:schemas-upnp-org:device:avm-aha:1 2015-03-04 05:27:46,885 [DEBUG] ignoring 2015-03-04 05:27:46,885 [DEBUG] ---------------------- 2015-03-04 05:27:46,885 [DEBUG]

— Reply to this email directly or view it on GitHub https://github.com/falk0069/hue-upnp/issues/1.

Pmant commented 9 years ago

Thanks for your fast reply. I tried port 8080 before, same result. Also I can access the description.xml file. As you can see in the logs the server gets requests and answers or ignores them. I recently updated my Hub firmware to latest 4.3.48, maybe they changed something.

falk0069 commented 9 years ago

I do see in the logs now the hub (192.168.0.23) making the call back to the description.xml. That was the toughest part for me. I might have hard coded something in the XML that only works for my system. Or maybe it has something to do with the firmware update. I'll check my firmware and see if I have the same when I get a chance. Try double checking the values in the XML to make sure it contains the right values. I think the only dynamic part of the XML is the IP and port. Makes sure those are correct. Also see if there are any other values like a MAC address. I do recall doing something with those, but I didn't think that ever amounted to anything.

Another thing you can try is downloading the hue app for either Android or iOS and see if you can pair.

After the hue grabs the description.xml, it should start sending JSON requests. So that is the next step we need to get to.

I won't have a chance to really start digging until this weekend. Please keep me updated if you make any progress.

Thanks Andy On Mar 5, 2015 4:16 AM, "Pmant" notifications@github.com wrote:

Thanks for your fast reply. I tried port 8080 before, same result. Also I can access the description.xml file. As you can see in the logs the server gets requests and answers or ignores them. I recently updated my Hub firmware to latest 4.3.48, maybe they changed something.

— Reply to this email directly or view it on GitHub https://github.com/falk0069/hue-upnp/issues/1#issuecomment-77339034.

Pmant commented 9 years ago

Indeed you have hardcoded gateway and mac address in NEWDEVELOPER_JSON. I edited the values, but that is part of the json responses and did not help getting beyond the xml response. The Android Hue App gets to the json part and pairs correctly as far as I can tell.

falk0069 commented 9 years ago

I noticed that the hub calls the description.xml 3X 10 seconds apart. It seems it doesn't like something about it. Another difference I see from my initial testing is it is sending the upnp requests 4X before grabbing the XML. I believe it only did it twice in my case. That might just be a timing thing.

The only other thing that comes to mind it is try editing the serial number everywhere it appears in the code:(00178817122c). Maybe Harmony is tracking that? Doubtfully, but I'm grasping at straws. I won't be able to try another pairing activity until this weekend.

On Thu, Mar 5, 2015 at 8:07 AM, Pmant notifications@github.com wrote:

Indeed you have hardcoded gateway and mac address in NEWDEVELOPER_JSON. I edited the values, but that is part of the json responses and did not help getting beyond the xml response. The Android Hue App gets to the json part and pairs correctly as far as I can tell.

— Reply to this email directly or view it on GitHub https://github.com/falk0069/hue-upnp/issues/1#issuecomment-77368788.

Pmant commented 9 years ago

Again, thanks for your help so far! I tried to change the serial number and all uuids accordingly but still the same. Another thing I noticed is that there is ja huge time gap between first traffic and the xml get request, also at this time the myharmony software already shows an error.

Pmant commented 9 years ago

I may have figured it out. On line 214 "schemas-upnp-org:device:basic:1" should be "urn:schemas-upnp-org:device:basic:1" instead.

falk0069 commented 9 years ago

Oh my goodness--that could totally cause issues. So, did it get to the JSON calls? Did you get it to pair?

I'll have to look at my research notes and see what I had down. Thanks for uncovering that. Let me know what other issues you find or if you have any suggestions.

I'm really happy someone else might find this useful. May I ask what functionality you are trying to add to your Harmony?

Thanks Andy On Mar 5, 2015 5:38 PM, "Pmant" notifications@github.com wrote:

I may have figured it out. On line 214 "schemas-upnp-org:device:basic:1" should be "urn:schemas-upnp-org:device:basic:1" instead.

— Reply to this email directly or view it on GitHub https://github.com/falk0069/hue-upnp/issues/1#issuecomment-77476786.

Pmant commented 9 years ago

Yes it pairs now. I also added MAC and GATEWAY to the config and replaced them in the NEWDEVELOPER_JSON response. It may work without this change but it feels more complete :smile: . Since the Harmony Hub does not provide anything like an api I'm trying to use this to bridge the harmony system to my Homematic home automation, which has an api. I'm hoping for a better integration of the Hue system into the Harmony software like assigning remote buttons to Hue changes, that would perfectly fit my needs.

falk0069 commented 9 years ago

Thank you for finding this issue. I will add in the MAC and GATEWAY as well. I'll also adjust the SERIALNO too since this is supposed to be MAC with the colons removed. Let me know if you have any other suggestions.