Hi,

Adding SNMP=N means that the live tests won’t attempt to verify the statistics 
produced by the deployment (please see 
https://github.com/Metaswitch/clearwater-docs/wiki/Clearwater-SNMP-Statistics 
for a description of the statistics Clearwater generates).

I’ve reproduced the test failures on my own system, and I’ve raised an issue to 
track fixing this up (you can follow this at 
https://github.com/Metaswitch/clearwater-snmp-handlers/issues/18). For now, can 
you please continue with adding SNMP=N when running the tests?

Thanks,

Ellie

From: Antonio Ken Iannillo [mailto:[email protected]]
Sent: 24 September 2014 19:51
To: Eleanor Merry
Cc: [email protected]
Subject: Re: [Clearwater] Live-Test all fails

The test passed. It just reported

Failed to delete leaked number, check Ellis logs


All the logs you requested, and the Ellis logs are attached to this mail.
I would like to continue this thread in order to understand what is happened. 
What the added option actually did?

2014-09-24 19:15 GMT+02:00 Eleanor Merry 
<[email protected]<mailto:[email protected]>>:
Hi,

Thanks for sending this across.

The subscribers are being created correctly, as otherwise the output of the 
test wouldn't include the numbers. From the output, it could be a problem with 
the SNMP statistics - can you try running the tests with SNMP=N to try and 
isolate the problem?

Can you also send me the debug logs from running a single test from sprout and 
bono? You can run a single test by adding TESTS="Basic Call - Mainline", and 
you can turn on debug logging by creating/editing the file 
/etc/clearwater/user_settings, adding log_level=5 and then restarting bono and 
sprout (service <component> stop - it's automatically restarted by monit). The 
bono and sprout logs are output in /var/log/bono/* and /var/log/sprout/* 
respectively.

Thanks,

Ellie

-----Original Message-----
From: 
[email protected]<mailto:[email protected]>
 
[mailto:[email protected]<mailto:[email protected]>]
 On Behalf Of Antonio Ken Iannillo
Sent: 24 September 2014 15:53
To: 
[email protected]<mailto:[email protected]>
Subject: Re: [Clearwater] Live-Test all fails

For clarification,

this is the result of the first test while executing the live-test

Basic Call - Mainline (TCP) - (6505550476<tel:%286505550476>, 
6505550683<tel:6505550683>) Failed
  SNMP::RequestTimeout thrown:
   - host 192.168.0.88 not responding
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/gems/snmp-1.1.1/lib/snmp/manager.rb:266:in
`get_next'
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/gems/snmp-1.1.1/lib/snmp/manager.rb:426:in
`block in walk'
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/gems/snmp-1.1.1/lib/snmp/manager.rb:425:in
`loop'
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/gems/snmp-1.1.1/lib/snmp/manager.rb:425:in
`walk'
     - /home/cwclient/clearwater-live-test/lib/test-definition.rb:413:in
`block in verify_snmp_stats'
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/gems/snmp-1.1.1/lib/snmp/manager.rb:205:in
`open'
     - /home/cwclient/clearwater-live-test/lib/test-definition.rb:412:in
`verify_snmp_stats'
     - /home/cwclient/clearwater-live-test/lib/test-definition.rb:264:in
`run'
     - /home/cwclient/clearwater-live-test/lib/test-definition.rb:136:in
`block (2 levels) in run_all'
     - /home/cwclient/clearwater-live-test/lib/test-definition.rb:129:in
`collect'
     - /home/cwclient/clearwater-live-test/lib/test-definition.rb:129:in
`block in run_all'
     - /home/cwclient/clearwater-live-test/lib/test-definition.rb:127:in
`times'
     - /home/cwclient/clearwater-live-test/lib/test-definition.rb:127:in
`run_all'
     - /home/cwclient/clearwater-live-test/lib/live-test.rb:48:in
`run_tests'
     - /home/cwclient/clearwater-live-test/Rakefile:39:in `block in <top 
(required)>'
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/gems/rake-10.0.3/lib/rake/task.rb:228:in
`call'
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/gems/rake-10.0.3/lib/rake/task.rb:228:in
`block in execute'
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/gems/rake-10.0.3/lib/rake/task.rb:223:in
`each'
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/gems/rake-10.0.3/lib/rake/task.rb:223:in
`execute'
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/gems/rake-10.0.3/lib/rake/task.rb:166:in
`block in invoke_with_call_chain'
     -
/home/cwclient/.rvm/rubies/ruby-1.9.3-p547/lib/ruby/1.9.1/monitor.rb:211:in
`mon_synchronize'
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/gems/rake-10.0.3/lib/rake/task.rb:159:in
`invoke_with_call_chain'
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/gems/rake-10.0.3/lib/rake/task.rb:152:in
`invoke'
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/gems/rake-10.0.3/lib/rake/application.rb:143:in
`invoke_task'
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/gems/rake-10.0.3/lib/rake/application.rb:101:in
`block (2 levels) in top_level'
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/gems/rake-10.0.3/lib/rake/application.rb:101:in
`each'
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/gems/rake-10.0.3/lib/rake/application.rb:101:in
`block in top_level'
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/gems/rake-10.0.3/lib/rake/application.rb:110:in
`run_with_threads'
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/gems/rake-10.0.3/lib/rake/application.rb:95:in
`top_level'
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/gems/rake-10.0.3/lib/rake/application.rb:73:in
`block in run'
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/gems/rake-10.0.3/lib/rake/application.rb:160:in
`standard_exception_handling'
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/gems/rake-10.0.3/lib/rake/application.rb:70:in
`run'
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/gems/rake-10.0.3/bin/rake:33:in
`<top (required)>'
     - /home/cwclient/.rvm/gems/ruby-1.9.3-p547/bin/rake:23:in `load'
     - /home/cwclient/.rvm/gems/ruby-1.9.3-p547/bin/rake:23:in `<main>'
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/bin/ruby_executable_hooks:15:in
`eval'
     -
/home/cwclient/.rvm/gems/ruby-1.9.3-p547/bin/ruby_executable_hooks:15:in
`<main>'

192.168.0.88 is the ip of the aio.

2014-09-23 20:23 GMT+02:00 Antonio Ken Iannillo <
[email protected]<mailto:[email protected]>>:

> > Hi Ellie,
> >
> > (1) the <DESCRIBE TABLES;> command return me the tables' name as
> > expected
> >
> > -------------------------------
> > impi      impi_mapping     impu
> > -------------------------------
> >
> > (2) In Ellis logs I have the process start, an uncaught exception as
> follows
> >
> >> 2014-09-22 16:14:54,708 I main:125 11875:140055109363456] Process 0
> starting up
> >> 2014-09-22 16:14:56,665 I main:128 11875:140055109363456] Going to
> listen for HTTP on port 80
> >> 2014-09-22 16:14:56,716 C main:142 11875:140055109363456] Not
> >> starting
> HTTPS
> >> 2014-09-22 16:14:57,202 W simple_httpclient:325
> >> 11875:140055109363456]
> uncaught exception
> >> Traceback (most recent call last):
> >>   File
> "/usr/share/clearwater/ellis/env/local/lib/python2.7/site-packages/tor
> nado-2.3-py2.7.egg/tornado/simple_httpclient.py",
> line 323, in cleanup
> >>     yield
> >>   File
> "/usr/share/clearwater/ellis/env/local/lib/python2.7/site-packages/tor
> nado-2.3-py2.7.egg/tornado/simple_httpclient.py",
> line 177, in __init__
> >>     0, 0)
> >> gaierror: [Errno -5] No address associated with hostname
> >
> >
> > Then a have a series of successful pings than I have several other
> exception and service unavailable.
> >
> >> 2014-09-23 08:02:47,774 I main:125 1457:140015295420160] Process 0
> starting up
> >> 2014-09-23 08:02:47,824 I main:128 1457:140015295420160] Going to
> listen for HTTP on port 80
> >> 2014-09-23 08:02:47,824 C main:142 1457:140015295420160] Not
> >> starting
> HTTPS
> >> 2014-09-23 08:02:47,855 W iostream:507 1457:140015295420160]
> >> Connect
> error on fd 8: ECONNREFUSED
> >> 2014-09-23 08:02:47,855 E homestead:68 1457:140015295420160] Failed
> >> to
> ping Homestead at http://192.168.0.88:8889/ping. Have you configured
> your HOMESTEAD_URL?
> >> 2014-09-23 08:04:04,166 I web:1447 1457:140015295420160] 200 GET
> >> /ping
> (192.168.0.88) 0.41ms
> >> 2014-09-23 08:05:24,230 I web:1447 1457:140015295420160] 200 GET
> >> /ping
> (192.168.0.88) 0.19ms
> >> 2014-09-23 08:05:37,898 D numbers:120 1457:140015295420160] Number
> allocation API call (PSTN = false)
> >> 2014-09-23 08:05:37,909 D numbers:125 1457:140015295420160]
> >> Allocating
> a non-PSTN number
> >> 2014-09-23 08:05:37,910 D numbers:139 1457:140015295420160] Fetched
> 1511165d-d614-478f-a1e7-5fe51e8677bf
> >> 2014-09-23 08:05:37,911 D numbers:151 1457:140015295420160] Updated
> >> the
> owner
> >> 2014-09-23 08:05:37,911 D numbers:129 1457:140015295420160] SIP URI
> sip:[email protected]<mailto:sip%[email protected]>
> >> 2014-09-23 08:05:37,939 D numbers:158 1457:140015295420160]
> >> Populating
> other servers...
> >> 2014-09-23 08:05:37,939 D numbers:169 1457:140015295420160] About
> >> to
> create private ID at Homestead
> >> 2014-09-23 08:05:37,940 W homestead:237 1457:140015295420160]
> >> Passing
> SIP password in the clear over http
> >> 2014-09-23 08:05:37,945 W homestead:237 1457:140015295420160]
> >> Passing
> SIP password in the clear over http
> >> 2014-09-23 08:05:37,947 W homestead:237 1457:140015295420160]
> >> Passing
> SIP password in the clear over http
> >> 2014-09-23 08:05:37,949 E _base:171 1457:140015295420160] Uncaught
> exception POST 
> /accounts/[email protected]/numbers/<http://[email protected]/numbers/>
> (192.168.0.11)
> >> HTTPRequest(protocol='http', host='192.168.0.88', method='POST',
> uri='/accounts/[email protected]/numbers/<http://[email protected]/numbers/>',
>  version='HTTP/1.1',
> remote_ip='192.168.0.11', body='pstn=false', headers={'Content-Length':
> '10', 'Cookie': 'Path=/;
> username="c3lzdGVtLnRlc3RAZXhhbXBsZS5jb20=|1411459529|cbd896c44a4438e8
> 2207c49fee3c5d112aa0a196"',
> 'Accept-Encoding': 'gzip, deflate', 'Content-Type':
> 'application/x-www-form-urlencoded', 'Host': '192.168.0.88', 'Accept':
> '*/*; q=0.5, application/xml', 'User-Agent': 'Ruby'})
> >> Traceback (most recent call last):
> >>   File
> "/usr/share/clearwater/ellis/env/local/lib/python2.7/site-packages/tor
> nado-2.3-py2.7.egg/tornado/web.py",
> line 1000, in _stack_context_handle_exception
> >>     raise_exc_info((type, value, traceback))
> >>   File
> "/usr/share/clearwater/ellis/env/local/lib/python2.7/site-packages/tor
> nado-2.3-py2.7.egg/tornado/web.py",
> line 1118, in wrapper
> >>     return method(self, *args, **kwargs)
> >>   File
> "/usr/share/clearwater/ellis/env/local/lib/python2.7/site-packages/ell
> is-0.1-py2.7.egg/metaswitch/ellis/api/numbers.py",
> line 173, in post
> >>     self._request_group.callback())
> >>   File
> "/usr/share/clearwater/ellis/env/local/lib/python2.7/site-packages/ell
> is-0.1-py2.7.egg/metaswitch/ellis/remote/homestead.py",
> line 92, in create_private_id
> >>     response = _sync_http_request(url, method="PUT", body="")
> >>   File
> "/usr/share/clearwater/ellis/env/local/lib/python2.7/site-packages/ell
> is-0.1-py2.7.egg/metaswitch/ellis/remote/homestead.py",
> line 232, in _sync_http_request
> >>     raise e
> >> HTTPError: HTTP 503: Service Unavailable
> >> 2014-09-23 08:05:37,950 E web:1447 1457:140015295420160] 500 POST
> /accounts/[email protected]/numbers/<http://[email protected]/numbers/>
>  (192.168.0.11) 52.64ms
> >> 2014-09-23 08:05:37,952 D numbers:120 1457:140015295420160] Number
> allocation API call (PSTN = false)
> >> 2014-09-23 08:05:37,953 D numbers:125 1457:140015295420160]
> >> Allocating
> a non-PSTN number
> >> 2014-09-23 08:05:37,954 D numbers:139 1457:140015295420160] Fetched
> b9de2006-9f61-4f9d-ab3a-3864d1df0e9b
> >> 2014-09-23 08:05:37,954 D numbers:151 1457:140015295420160] Updated
> >> the
> owner
> >> 2014-09-23 08:05:37,955 D numbers:129 1457:140015295420160] SIP URI
> sip:[email protected]<mailto:sip%[email protected]>
> >> 2014-09-23 08:05:37,972 D numbers:158 1457:140015295420160]
> >> Populating
> other servers...
> >> 2014-09-23 08:05:37,972 D numbers:169 1457:140015295420160] About
> >> to
> create private ID at Homestead
> >> 2014-09-23 08:05:37,972 W homestead:237 1457:140015295420160]
> >> Passing
> SIP password in the clear over http
> >> 2014-09-23 08:05:37,976 W homestead:237 1457:140015295420160]
> >> Passing
> SIP password in the clear over http
> >> 2014-09-23 08:05:37,978 E _base:171 1457:140015295420160] Uncaught
> exception POST 
> /accounts/[email protected]/numbers/<http://[email protected]/numbers/>
> (192.168.0.11)
> >> HTTPRequest(protocol='http', host='192.168.0.88', method='POST',
> uri='/accounts/[email protected]/numbers/<http://[email protected]/numbers/>',
>  version='HTTP/1.1',
> remote_ip='192.168.0.11', body='pstn=false', headers={'Content-Length':
> '10', 'Cookie': 'Path=/;
> username="c3lzdGVtLnRlc3RAZXhhbXBsZS5jb20=|1411459529|cbd896c44a4438e8
> 2207c49fee3c5d112aa0a196"',
> 'Accept-Encoding': 'gzip, deflate', 'Content-Type':
> 'application/x-www-form-urlencoded', 'Host': '192.168.0.88', 'Accept':
> '*/*; q=0.5, application/xml', 'User-Agent': 'Ruby'})
> >> Traceback (most recent call last):
> >>   File
> "/usr/share/clearwater/ellis/env/local/lib/python2.7/site-packages/tor
> nado-2.3-py2.7.egg/tornado/web.py",
> line 1000, in _stack_context_handle_exception
> >>     raise_exc_info((type, value, traceback))
> >>   File
> "/usr/share/clearwater/ellis/env/local/lib/python2.7/site-packages/tor
> nado-2.3-py2.7.egg/tornado/web.py",
> line 1118, in wrapper
> >>     return method(self, *args, **kwargs)
> >>   File
> "/usr/share/clearwater/ellis/env/local/lib/python2.7/site-packages/ell
> is-0.1-py2.7.egg/metaswitch/ellis/api/numbers.py",
> line 173, in post
> >>     self._request_group.callback())
> >>   File
> "/usr/share/clearwater/ellis/env/local/lib/python2.7/site-packages/ell
> is-0.1-py2.7.egg/metaswitch/ellis/remote/homestead.py",
> line 90, in create_private_id
> >>     uuid = _get_irs_uuid(_location(_sync_http_request(irs_url,
> method="POST", body="")))
> >>   File
> "/usr/share/clearwater/ellis/env/local/lib/python2.7/site-packages/ell
> is-0.1-py2.7.egg/metaswitch/ellis/remote/homestead.py",
> line 232, in _sync_http_request
> >>     raise e
> >> HTTPError: HTTP 503: Service Unavailable
> >> 2014-09-23 08:05:37,979 E web:1447 1457:140015295420160] 500 POST
> /accounts/[email protected]/numbers/<http://[email protected]/numbers/>
>  (192.168.0.11) 26.91ms
> >> 2014-09-23 08:05:38,130 D numbers:120 1457:140015295420160] Number
> allocation API call (PSTN = false)
> >> 2014-09-23 08:05:38,131 D numbers:125 1457:140015295420160]
> >> Allocating
> a non-PSTN number
> >> 2014-09-23 08:05:38,132 D numbers:139 1457:140015295420160] Fetched
> 1d53db97-40a8-454a-a52a-9ff6c8d10f0a
> >> 2014-09-23 08:05:38,132 D numbers:151 1457:140015295420160] Updated
> >> the
> owner
> >> 2014-09-23 08:05:38,132 D numbers:129 1457:140015295420160] SIP URI
> sip:[email protected]<mailto:sip%[email protected]>
> >> 2014-09-23 08:05:38,134 D numbers:158 1457:140015295420160]
> >> Populating
> other servers...
> >> 2014-09-23 08:05:38,134 D numbers:169 1457:140015295420160] About
> >> to
> create private ID at Homestead
> >> 2014-09-23 08:05:38,134 W homestead:237 1457:140015295420160]
> >> Passing
> SIP password in the clear over http
> >> 2014-09-23 08:05:38,138 W homestead:237 1457:140015295420160]
> >> Passing
> SIP password in the clear over http
> >> 2014-09-23 08:05:38,139 E _base:171 1457:140015295420160] Uncaught
> exception POST 
> /accounts/[email protected]/numbers/<http://[email protected]/numbers/>
> (192.168.0.11)
> >> HTTPRequest(protocol='http', host='192.168.0.88', method='POST',
> uri='/accounts/[email protected]/numbers/<http://[email protected]/numbers/>',
>  version='HTTP/1.1',
> remote_ip='192.168.0.11', body='pstn=false', headers={'Content-Length':
> '10', 'Cookie': 'Path=/;
> username="c3lzdGVtLnRlc3RAZXhhbXBsZS5jb20=|1411459529|cbd896c44a4438e8
> 2207c49fee3c5d112aa0a196"',
> 'Accept-Encoding': 'gzip, deflate', 'Content-Type':
> 'application/x-www-form-urlencoded', 'Host': '192.168.0.88', 'Accept':
> '*/*; q=0.5, application/xml', 'User-Agent': 'Ruby'})
> >> Traceback (most recent call last):
> >>   File
> "/usr/share/clearwater/ellis/env/local/lib/python2.7/site-packages/tor
> nado-2.3-py2.7.egg/tornado/web.py",
> line 1000, in _stack_context_handle_exception
> >>     raise_exc_info((type, value, traceback))
> >>   File
> "/usr/share/clearwater/ellis/env/local/lib/python2.7/site-packages/tor
> nado-2.3-py2.7.egg/tornado/web.py",
> line 1118, in wrapper
> >>     return method(self, *args, **kwargs)
> >>   File
> "/usr/share/clearwater/ellis/env/local/lib/python2.7/site-packages/ell
> is-0.1-py2.7.egg/metaswitch/ellis/api/numbers.py",
> line 173, in post
> >>     self._request_group.callback())
> >>   File
> "/usr/share/clearwater/ellis/env/local/lib/python2.7/site-packages/ell
> is-0.1-py2.7.egg/metaswitch/ellis/remote/homestead.py",
> line 90, in create_private_id
> >>     uuid = _get_irs_uuid(_location(_sync_http_request(irs_url,
> method="POST", body="")))
> >>   File
> "/usr/share/clearwater/ellis/env/local/lib/python2.7/site-packages/ell
> is-0.1-py2.7.egg/metaswitch/ellis/remote/homestead.py",
> line 232, in _sync_http_request
> >>     raise e
> >> HTTPError: HTTP 503: Service Unavailable
> >> 2014-09-23 08:05:38,140 E web:1447 1457:140015295420160] 500 POST
> /accounts/[email protected]/numbers/<http://[email protected]/numbers/>
>  (192.168.0.11) 10.42ms
> >> 2014-09-23 08:05:47,153 D numbers:120 1457:140015295420160] Number
> allocation API call (PSTN = false)
> >> 2014-09-23 08:05:47,161 D numbers:125 1457:140015295420160]
> >> Allocating
> a non-PSTN number
> >> 2014-09-23 08:05:47,162 D numbers:139 1457:140015295420160] Fetched
> 9f1a4389-be3d-458f-946a-ec6994966524
> >> 2014-09-23 08:05:47,162 D numbers:151 1457:140015295420160] Updated
> >> the
> owner
> >> 2014-09-23 08:05:47,162 D numbers:129 1457:140015295420160] SIP URI
> sip:[email protected]<mailto:sip%[email protected]>
> >> 2014-09-23 08:05:47,164 D numbers:158 1457:140015295420160]
> >> Populating
> other servers...
> >> 2014-09-23 08:05:47,164 D numbers:169 1457:140015295420160] About
> >> to
> create private ID at Homestead
> >> 2014-09-23 08:05:47,164 W homestead:237 1457:140015295420160]
> >> Passing
> SIP password in the clear over http
> >> 2014-09-23 08:05:47,168 W homestead:237 1457:140015295420160]
> >> Passing
> SIP password in the clear over http
> >> 2014-09-23 08:05:47,170 W homestead:237 1457:140015295420160]
> >> Passing
> SIP password in the clear over http
> >> 2014-09-23 08:05:47,177 D utils:79 1457:140015295420160] OK HTTP
> response.
> HTTPResponse(code=200,request_time=0.007186174392700195,buffer=<_io.By
> tesIO
> object at
> 0x2d9c230>,_body=None,time_info={},request=<tornado.httpclient.HTTPReq
> 0x2d9c230>uest
> object at 0x2d9f390>,effective_url='
> http://192.168.0.88:8889/private/6505550695%40example.com/associated_implicit_registration_sets/988b2ef8-1b79-4689-8c16-9a25486a5121',headers={'Content-Length':
> '0', 'Content-Type': 'text/html; charset=UTF-8', 'Server':
> 'cyclone/1.0'},error=None)
> >> 2014-09-23 08:05:47,177 D utils:89 1457:140015295420160] Still
> expecting 1 callbacks
> >> 2014-09-23 08:05:47,178 D numbers:174 1457:140015295420160] Created
> private ID at Homestead
> >> 2014-09-23 08:05:47,178 W homestead:237 1457:140015295420160]
> >> Passing
> SIP password in the clear over http
> >> 2014-09-23 08:05:47,180 W homestead:237 1457:140015295420160]
> >> Passing
> SIP password in the clear over http
> >> 2014-09-23 08:05:47,190 W homestead:237 1457:140015295420160]
> >> Passing
> SIP password in the clear over http
> >> 2014-09-23 08:05:47,203 W homestead:237 1457:140015295420160]
> >> Passing
> SIP password in the clear over http
> >> 2014-09-23 08:05:47,206 W homestead:237 1457:140015295420160]
> >> Passing
> SIP password in the clear over http
> >> 2014-09-23 08:05:47,209 D utils:79 1457:140015295420160] OK HTTP
> response.
> HTTPResponse(code=200,request_time=0.002543926239013672,buffer=<_io.By
> tesIO
> object at
> 0x2bdd8f0>,_body=None,time_info={},request=<tornado.httpclient.HTTPReq
> 0x2bdd8f0>uest
> object at 0x2d9aa50>,effective_url='
> http://192.168.0.88:7888/org.etsi.ngn.simservs/users/sip%3A6505550695%40example.com/simservs.xml',headers={'Content-Length':
> '2', 'Content-Type': 'application/json', 'Server':
> 'cyclone/1.0'},error=None)
> >> 2014-09-23 08:05:47,209 D utils:89 1457:140015295420160] Still
> expecting 1 callbacks
> >> 2014-09-23 08:05:47,221 D utils:79 1457:140015295420160] OK HTTP
> response.
> HTTPResponse(code=200,request_time=0.01518392562866211,buffer=<_io.Byt
> esIO
> object at
> 0x2d9c110>,_body=None,time_info={},request=<tornado.httpclient.HTTPReq
> 0x2d9c110>uest
> object at 0x2d9f2d0>,effective_url='
> http://192.168.0.88:8889/irs/988b2ef8-1b79-4689-8c16-9a25486a5121/service_profiles/25df0567-953b-430d-97dd-a02111856d81/filter_criteria',headers={'Content-Length':
> '0', 'Content-Type': 'text/html; charset=UTF-8', 'Server':
> 'cyclone/1.0'},error=None)
> >> 2014-09-23 08:05:47,221 D utils:87 1457:140015295420160] All
> >> requests
> successful.
> >> 2014-09-23 08:05:47,221 D numbers:192 1457:140015295420160]
> Successfully updated all the backends
> >> 2014-09-23 08:05:47,221 I web:1447 1457:140015295420160] 200 POST
> /accounts/[email protected]/numbers/<http://[email protected]/numbers/>
>  (192.168.0.11) 68.35ms
> >> 2014-09-23 08:05:47,222 D utils:89 1457:140015295420160] Still
> expecting 0 callbacks
> >> 2014-09-23 08:06:21,201 I numbers:286 1457:140015295420160] Request
> >> to
> delete sip:[email protected]<mailto:sip%[email protected]> by 
> [email protected]<mailto:[email protected]>
> >> 2014-09-23 08:06:21,209 W homestead:237 1457:140015295420160]
> >> Passing
> SIP password in the clear over http
> >> 2014-09-23 08:06:21,213 D utils:79 1457:140015295420160] OK HTTP
> response.
> HTTPResponse(code=200,request_time=0.003526926040649414,buffer=<_io.By
> tesIO
> object at
> 0x2d9c590>,_body=None,time_info={},request=<tornado.httpclient.HTTPReq
> 0x2d9c590>uest
> object at 0x2d9a890>,effective_url='
> http://192.168.0.88:8889/public/sip%3A6505550836%40example.com/associated_private_ids',headers={'Content-Length':
> '63', 'Etag': '"0b6cfe1e262ac95e6a458c8284ec764279ae3807"', 'Content-Type':
> 'application/json', 'Server': 'cyclone/1.0', 'Content-Encoding':
> 'gzip'},error=None)
> >> 2014-09-23 08:06:21,213 D utils:87 1457:140015295420160] All
> >> requests
> successful.
> >> 2014-09-23 08:06:21,213 D numbers:221 1457:140015295420160] Got
> >> related
> private ids
> >> 2014-09-23 08:06:21,213 W homestead:237 1457:140015295420160]
> >> Passing
> SIP password in the clear over http
> >> 2014-09-23 08:06:21,214 D utils:89 1457:140015295420160] Still
> expecting 0 callbacks
> >> 2014-09-23 08:06:21,219 D utils:79 1457:140015295420160] OK HTTP
> response.
> HTTPResponse(code=200,request_time=0.005959033966064453,buffer=<_io.By
> tesIO
> object at
> 0x2d9c770>,_body=None,time_info={},request=<tornado.httpclient.HTTPReq
> 0x2d9c770>uest
> object at 0x2de7090>,effective_url='
> http://192.168.0.88:8889/private/6505550836%40example.com/associated_public_ids',headers={'Content-Length':
> '77', 'Etag': '"9a718cdc0cd935a77f9051ec44848d776423f821"', 'Content-Type':
> 'application/json', 'Server': 'cyclone/1.0', 'Content-Encoding':
> 'gzip'},error=None)
> >> 2014-09-23 08:06:21,219 D utils:87 1457:140015295420160] All
> >> requests
> successful.
> >> 2014-09-23 08:06:21,220 D numbers:231 1457:140015295420160] Got
> >> related
> public ids
> >> 2014-09-23 08:06:21,220 D numbers:88 1457:140015295420160] Removing
> owner of sip:[email protected]<mailto:sip%[email protected]>
> >> 2014-09-23 08:06:21,240 W homestead:237 1457:140015295420160]
> >> Passing
> SIP password in the clear over http
> >> 2014-09-23 08:06:21,242 W homestead:237 1457:140015295420160]
> >> Passing
> SIP password in the clear over http
> >> 2014-09-23 08:06:21,275 W homestead:237 1457:140015295420160]
> >> Passing
> SIP password in the clear over http
> >> 2014-09-23 08:06:21,276 D utils:89 1457:140015295420160] Still
> expecting 0 callbacks
> >> 2014-09-23 08:06:21,278 D utils:79 1457:140015295420160] OK HTTP
> response.
> HTTPResponse(code=204,request_time=0.0019488334655761719,buffer=<_io.B
> ytesIO
> object at
> 0x2d9c8f0>,_body=None,time_info={},request=<tornado.httpclient.HTTPReq
> 0x2d9c8f0>uest
> object at 0x2d9a890>,effective_url='
> http://192.168.0.88:7888/org.etsi.ngn.simservs/users/sip%3A6505550836%40example.com/simservs.xml',headers={'Content-Length':
> '0', 'Content-Type': 'text/html; charset=UTF-8', 'Server':
> 'cyclone/1.0'},error=None)
> >> 2014-09-23 08:06:21,278 D utils:89 1457:140015295420160] Still
> expecting 1 callbacks
> >> 2014-09-23 08:06:21,279 D utils:79 1457:140015295420160] OK HTTP
> response.
> HTTPResponse(code=200,request_time=0.003699064254760742,buffer=<_io.By
> tesIO
> object at
> 0x2d9c950>,_body=None,time_info={},request=<tornado.httpclient.HTTPReq
> 0x2d9c950>uest
> object at 0x2c69b50>,effective_url='
> http://192.168.0.88:8889/private/6505550836%40example.com',headers={'Content-Length':
> '0', 'Content-Type': 'text/html; charset=UTF-8', 'Server':
> 'cyclone/1.0'},error=None)
> >> 2014-09-23 08:06:21,279 D utils:87 1457:140015295420160] All
> >> requests
> successful.
> >> 2014-09-23 08:06:21,279 D numbers:292 1457:140015295420160] All
> requests successful.
> >> 2014-09-23 08:06:21,279 I web:1447 1457:140015295420160] 200 DELETE
> /accounts/[email protected]/numbers/sip%3A6505550836%40example.c<http://[email protected]/numbers/sip%3A6505550836%40example.c>
> om
> (192.168.0.11) 78.73ms
> >> 2014-09-23 08:06:21,280 D utils:89 1457:140015295420160] Still
> expecting 0 callbacks
> >> 2014-09-23 08:13:34,674 I web:1447 1457:140015295420160] 200 GET
> >> /ping
> (192.168.0.88) 0.22ms
> >> 2014-09-23 08:16:24,831 I web:1447 1457:140015295420160] 200 GET
> >> /ping
> (192.168.0.88) 0.27ms
> >> 2014-09-23 08:16:54,843 I web:1447 1457:140015295420160] 200 GET
> >> /ping
> (192.168.0.88) 0.20ms
> >> 2014-09-23 08:19:34,996 I web:1447 1457:140015295420160] 200 GET
> >> /ping
> (192.168.0.88) 0.20ms
> >> 2014-09-23 08:20:25,047 I web:1447 1457:140015295420160] 200 GET
> >> /ping
> (192.168.0.88) 0.19ms
> >> 2014-09-23 08:23:45,213 I web:1447 1457:140015295420160] 200 GET
> >> /ping
> (192.168.0.88) 0.27ms
> >>
> >
> > (3) looking at the previous log suggests me to check homestead logs.
> > In
> homestead_prov-err.log I found some ConnectionRefusedError (connection
> was refused by other side: 111: connection refused) and in the
> homested_prov-err.log.old I found an InvalidRequestException (why=
> Keyspace homestead_cache does not exist). But didn't I check it before
> without any problem? It is still possible?
>
_______________________________________________
Clearwater mailing list
[email protected]<mailto:[email protected]>
http://lists.projectclearwater.org/listinfo/clearwater

_______________________________________________
Clearwater mailing list
[email protected]
http://lists.projectclearwater.org/listinfo/clearwater

Reply via email to