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]] On Behalf Of Antonio Ken Iannillo Sent: 24 September 2014 15:53 To: [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, 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]>: > > 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] > >> 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/ > (192.168.0.11) > >> HTTPRequest(protocol='http', host='192.168.0.88', method='POST', > uri='/accounts/[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/ (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] > >> 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/ > (192.168.0.11) > >> HTTPRequest(protocol='http', host='192.168.0.88', method='POST', > uri='/accounts/[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/ (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] > >> 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/ > (192.168.0.11) > >> HTTPRequest(protocol='http', host='192.168.0.88', method='POST', > uri='/accounts/[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/ (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] > >> 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/ (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] by [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] > >> 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 > 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] http://lists.projectclearwater.org/listinfo/clearwater _______________________________________________ Clearwater mailing list [email protected] http://lists.projectclearwater.org/listinfo/clearwater
