Matt:

Sorry I responded to the wrong thread a few mins ago. Here is my current
status :)

OK maybe this is becoming a bad habit and posting to the list is just
theraputic. Turns out I had a residual entry in /etc/hosts before DNS was
up and running. Once that was fixed it worked like a charm.

Will set up clients tonite for test calls.

On Sat, Apr 2, 2016 at 5:03 PM, Matt Williams <[email protected]>
wrote:

> Thanks for the logs!  It looks as though Ellis is successfully
> communicating with Homestead, but failing to communicate with Homer (the
> XDMS).
>
>
>
> Ellis is trying to connect to "homer.verified".  Is that server installed
> and running and, if so, please can you share its "monit status" and
> /var/log/homer/homer_*.txt?
>
>
>
> Cheers,
>
>
>
> Matt
>
>
>
> *From:* Clearwater [mailto:[email protected]]
> *On Behalf Of *Bud Asterisk
> *Sent:* 02 April 2016 19:01
> *To:* [email protected]
> *Subject:* [Project Clearwater] new user creation fails
>
>
>
> [image: Mic Drop]
>
> Can log into my Ellis node fine. When I try to create a new user I get the
> infamous 'failed to update....' popup error. Here are Ellis logs with debug
> enabled:
>
> 02-04-2016 17:44:06.442 UTC WARNING homestead.py:309: Passing SIP password
> in the clear over http
> 02-04-2016 17:44:06.468 UTC WARNING homestead.py:309: Passing SIP password
> in the clear over http
> 02-04-2016 17:44:06.474 UTC WARNING homestead.py:309: Passing SIP password
> in the clear over http
> 02-04-2016 17:44:06.475 UTC WARNING iostream.py:507: Connect error on fd
> 17: ECONNREFUSED
> 02-04-2016 17:44:06.475 UTC WARNING utils.py:78: Non-OK HTTP response.
> HTTPResponse(code=599,request_time=0.0007290840148925781,buffer=None,_body=None,time_info={},request=<tornado.httpclient.HTTPRequest
> object at 0x7f30dd4b11d0>,effective_url='
> http://homer.verified:7888/org.etsi.ngn.simservs/users/sip%3A6505550020%40verified/simservs.xml',headers={},error=HTTPError('HTTP
> 599: Connection closed',))
> 02-04-2016 17:44:06.476 UTC WARNING numbers.py:195: Failed to update all
> the backends
> 02-04-2016 17:44:06.476 UTC WARNING homestead.py:309: Passing SIP password
> in the clear over http
> 02-04-2016 17:44:06.484 UTC WARNING homestead.py:309: Passing SIP password
> in the clear over http
> 02-04-2016 17:44:06.494 UTC INFO numbers.py:282: Returning number to pool
> before attempting deletion from Homestead and Homer
> 02-04-2016 17:44:06.498 UTC WARNING homestead.py:309: Passing SIP password
> in the clear over http
> 02-04-2016 17:44:06.504 UTC WARNING homestead.py:309: Passing SIP password
> in the clear over http
> 02-04-2016 17:44:06.559 UTC WARNING homestead.py:309: Passing SIP password
> in the clear over http
> 02-04-2016 17:44:06.560 UTC WARNING iostream.py:507: Connect error on fd
> 18: ECONNREFUSED
> 02-04-2016 17:44:06.562 UTC WARNING utils.py:78: Non-OK HTTP response.
> HTTPResponse(code=599,request_time=0.0010280609130859375,buffer=None,_body=None,time_info={},request=<tornado.httpclient.HTTPRequest
> object at 0x7f30dd4b63d0>,effective_url='
> http://homer.verified:7888/org.etsi.ngn.simservs/users/sip%3A6505550020%40verified/simservs.xml',headers={},error=HTTPError('HTTP
> 599: Connection closed',))
> 02-04-2016 17:44:06.562 UTC WARNING numbers.py:211: Failed to back out
> changes after failure
> 02-04-2016 17:44:06.564 UTC ERROR web.py:1447: 502 POST /accounts/john%
> 40doe.com/numbers/?cb=1ca4d84b57W1 (0.0.0.0) 179.05ms
> 02-04-2016 17:44:17.961 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.31ms
> 02-04-2016 17:44:38.352 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.36ms
> 02-04-2016 17:44:58.086 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.51ms
> 02-04-2016 17:45:18.143 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.42ms
> 02-04-2016 17:45:38.464 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.52ms
> 02-04-2016 17:45:58.237 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.34ms
> 02-04-2016 17:46:18.284 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.45ms
> 02-04-2016 17:46:38.684 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.35ms
> 02-04-2016 17:46:58.401 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.34ms
> 02-04-2016 17:47:18.472 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.35ms
> 02-04-2016 17:47:38.792 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.33ms
> 02-04-2016 17:47:58.564 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.42ms
> 02-04-2016 17:48:18.627 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.36ms
> 02-04-2016 17:48:39.017 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.34ms
> 02-04-2016 17:48:58.731 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.33ms
> 02-04-2016 17:49:18.789 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.37ms
> 02-04-2016 17:49:39.178 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.50ms
> 02-04-2016 17:49:58.874 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.34ms
> 02-04-2016 17:50:18.955 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.62ms
> 02-04-2016 17:50:39.340 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.42ms
> 02-04-2016 17:50:59.057 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.47ms
> 02-04-2016 17:51:19.114 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.50ms
> 02-04-2016 17:51:39.493 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.41ms
> 02-04-2016 17:51:59.226 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 1.23ms
> 02-04-2016 17:52:19.287 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.72ms
> 02-04-2016 17:52:39.652 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.38ms
> 02-04-2016 17:52:59.369 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.62ms
> 02-04-2016 17:53:19.450 UTC INFO web.py:1447: 200 GET /ping (0.0.0.0)
> 0.35ms
>
> here is a subset of homstead provisioning:
>
> 02-04-2016 17:55:56.053 UTC INFO base.py:274: Sending 200 response to
> localhost for GET
> http://http_homestead_prov/public/sip%3A6505550638%40verified/associated_private_ids
> 02-04-2016 17:55:56.055 UTC INFO base.py:261: Received request from
> localhost - GET
> http://http_homestead_prov/private/6505550638%40verified/associated_public_ids
> 02-04-2016 17:55:56.069 UTC INFO base.py:274: Sending 200 response to
> localhost for GET
> http://http_homestead_prov/private/6505550638%40verified/associated_public_ids
> 02-04-2016 17:55:56.076 UTC INFO base.py:261: Received request from
> localhost - GET
> http://http_homestead_prov/private/6505550638%40verified/associated_implicit_registration_sets
> 02-04-2016 17:55:56.080 UTC INFO base.py:274: Sending 200 response to
> localhost for GET
> http://http_homestead_prov/private/6505550638%40verified/associated_implicit_registration_sets
> 02-04-2016 17:55:56.082 UTC INFO base.py:261: Received request from
> localhost - DELETE
> http://http_homestead_prov/irs/3dadbf97-b8cd-445b-8140-f9f0f486ef51
> 02-04-2016 17:55:56.101 UTC WARNING models.py:265: Not pushing to cache
> since IRS doesn't contain a SIP URI
> 02-04-2016 17:55:56.114 UTC INFO base.py:274: Sending 200 response to
> localhost for PUT
> http://http_homestead_prov/irs/3dadbf97-b8cd-445b-8140-f9f0f486ef51/service_profiles/77fee9d3-9298-499e-b3a3-c86797b75afc/filter_criteria
> 02-04-2016 17:55:56.123 UTC WARNING models.py:265: Not pushing to cache
> since IRS doesn't contain a SIP URI
> 02-04-2016 17:55:56.142 UTC WARNING models.py:265: Not pushing to cache
> since IRS doesn't contain a SIP URI
> 02-04-2016 17:55:56.156 UTC INFO base.py:274: Sending 200 response to
> localhost for DELETE
> http://http_homestead_prov/irs/3dadbf97-b8cd-445b-8140-f9f0f486ef51
> 02-04-2016 17:55:56.160 UTC INFO base.py:261: Received request from
> localhost - DELETE
> http://http_homestead_prov/private/6505550638%40verified
> 02-04-2016 17:55:56.164 UTC INFO base.py:274: Sending 200 response to
> localhost for DELETE
> http://http_homestead_prov/private/6505550638%40verified
>
> Any insights as to what else I may have set up wrong would help!
>
_______________________________________________
Clearwater mailing list
[email protected]
http://lists.projectclearwater.org/mailman/listinfo/clearwater_lists.projectclearwater.org

Reply via email to