Hi clearwater team,
The successful call rate is quite low when I do SIPp testing via the command:
/usr/share/clearwater/bin/run_stress clearwater.opnfv 100 30 --sipp-output
--icscf-target sprout.clearwater.local:5052 --scscf-target
sprout.clearwater.local:5054
Actually after 7 successful calls, the 480 error occurs.
Here is one capture when runing:
------------------------------ Scenario Screen -------- [1-9]: Change Screen --
Call-rate(length) Port Total-time Total-calls Remote-host
0.0(5000 ms)/1.000s 5062 1234.12 s 22 10.67.79.12:5054(TCP)
0 new calls during 1.004 s period 1 ms scheduler resolution
0 calls (limit 1) Peak was 1 calls, after 55 s
1 Running, 3 Paused, 3 Woken up
0 dead call msg (discarded) 0 out-of-call msg (discarded)
2 open sockets
Messages Retrans Timeout Unexpected-Msg
INVITE ----------> 22 0 0
100 <---------- 22 0 0 0
183 <---------- 12 0 0 10
PRACK ----------> 12 0
200 <---------- 12 0 0 0
UPDATE ----------> 12 0
201 <---------- 12 0 0 0
180 <---------- E-RTD1 12 0 0 0
201 <---------- 0 0 0 0
200 <---------- 12 0 0 0
ACK ----------> 12 0
Pause [ 5000ms] 12 0
BYE ----------> 12 0 0
200 <---------- 12 0 0 0
------ [+|-|*|/]: Adjust rate ---- [q]: Soft exit ---- [p]: Pause traffic -----
Last Error: Aborting call on unexpected message for Call-Id '21-14814@10...
2018-03-28 06:33:54.190938 1522218834.190938: Aborting call on unexpected
message for Call-Id '[email protected]': while expecting '183' (index 2),
received 'SIP/2.0 480 Temporarily Unavailable
Via: SIP/2.0/TCP
10.67.79.24:29014;received=10.67.79.24;branch=z9hG4bK-14814-17-0
Record-Route:
<sip:scscf.sprout.clearwater.local:5054;transport=TCP;lr;billing-role=charge-term>
Record-Route:
<sip:scscf.sprout.clearwater.local:5054;transport=TCP;lr;billing-role=charge-orig>
Call-ID: [email protected]
From: <sip:[email protected]>;tag=14814SIPpTag0017
To: <sip:[email protected]>;tag=z9hG4bK-14814-17-0
CSeq: 1 INVITE
P-Charging-Vector:
icid-value="14814SIPpTag0017";orig-ioi=clearwater.opnfv;term-ioi=clearwater.opnfv
P-Charging-Function-Addresses: ccf=0.0.0.0
Content-Length: 0
'.
1) I deoloyed clearwater via one testcase named "cloudify_ims" from
opnfv/functest project, where 3 steps are run:
* deploy a VNF orchestrator (Cloudify)
* deploy a Clearwater vIMS (IP Multimedia Subsystem) VNF from this
orchestrator based on a TOSCA blueprint defined in [1]
* run suite of signaling tests on top of this VNF
[1]:
https://github.com/Orange-OpenSource/opnfv-cloudify-clearwater/archive/master.zip
8 instances are created and I also created a new instance named "stress-node"
according to this guidance:
http://clearwater.readthedocs.io/en/stable/Clearwater_stress_testing.html-
bash-4.4# openstack server list
+--------------------------------------+-------------------------------------------------------+--------+---------------------------------------------------------------------------------------+----------------------+-----------+
| ID | Name
| Status | Networks
| Image | Flavor |
+--------------------------------------+-------------------------------------------------------+--------+---------------------------------------------------------------------------------------+----------------------+-----------+
| df2d9f82-8aa2-4514-9f07-27974267b590 | stress-node
| ACTIVE |
cloudify_ims_network-6c79129a-8384-4069-81f7-a024738102cd=10.67.79.24
| ubuntu_14.04 | m1.small |
| 48a41da3-c55d-410c-a8f3-ef26bc409aef |
server_clearwater-opnfv_bono_host_llp4mt | ACTIVE |
cloudify_ims_network-6c79129a-8384-4069-81f7-a024738102cd=10.67.79.23,
192.168.36.113 | ubuntu_14.04 | m1.small |
| a992435c-a397-4622-b0d3-b8e515ebab51 |
server_clearwater-opnfv_homer_host_vz97vi | ACTIVE |
cloudify_ims_network-6c79129a-8384-4069-81f7-a024738102cd=10.67.79.19
| ubuntu_14.04 | m1.small |
| 283fef46-78e4-4d0a-9e91-ffeb14e7bfb9 |
server_clearwater-opnfv_sprout_host_nnoxye | ACTIVE |
cloudify_ims_network-6c79129a-8384-4069-81f7-a024738102cd=10.67.79.12
| ubuntu_14.04 | m1.small |
| bfe5111d-ed7d-4c65-80c2-20144935ee8c |
server_clearwater-opnfv_ellis_host_bo7auh | ACTIVE |
cloudify_ims_network-6c79129a-8384-4069-81f7-a024738102cd=10.67.79.14,
192.168.36.111 | ubuntu_14.04 | m1.small |
| b83e1727-b5a6-430e-8b5e-b3f0e6421675 |
server_clearwater-opnfv_vellum_host_sh0ocy | ACTIVE |
cloudify_ims_network-6c79129a-8384-4069-81f7-a024738102cd=10.67.79.6
| ubuntu_14.04 | m1.small |
| 8b03d8fa-5873-489b-994b-5f1de24a85c0 |
server_clearwater-opnfv_bind_host_b9f49w | ACTIVE |
cloudify_ims_network-6c79129a-8384-4069-81f7-a024738102cd=10.67.79.16,
192.168.36.110 | ubuntu_14.04 | m1.small |
| 0ca72f55-7e05-4477-ad2e-2661ad49f7ce |
server_clearwater-opnfv_dime_host_xryxen | ACTIVE |
cloudify_ims_network-6c79129a-8384-4069-81f7-a024738102cd=10.67.79.11
| ubuntu_14.04 | m1.small |
| 7d51e479-24b6-4db4-9b8f-3ef42be0b87e |
server_clearwater-opnfv_proxy_host_rqr7bo | ACTIVE |
cloudify_ims_network-6c79129a-8384-4069-81f7-a024738102cd=10.67.79.5
| ubuntu_14.04 | m1.small |
| 82672984-b967-49ff-8f00-09ffe3f7fc87 |
cloudify_manager-6c79129a-8384-4069-81f7-a024738102cd | ACTIVE |
cloudify_ims_network-6c79129a-8384-4069-81f7-a024738102cd=10.67.79.13,
192.168.36.105 | cloudify_manager_4.0 | m1.medium |
+--------------------------------------+-------------------------------------------------------+--------+---------------------------------------------------------------------------------------+----------------------+-----------+
2) I checked the ralf log
root@dime-au6gte:/var/log/ralf# vim ralf_20180328T060000Z.txt
28-03-2018 06:25:57.063 UTC Debug dnscachedresolver.cpp:543: Create and execute
DNS query transaction
28-03-2018 06:25:57.063 UTC Debug dnscachedresolver.cpp:556: Wait for query
responses
28-03-2018 06:25:57.064 UTC Debug dnscachedresolver.cpp:704: Received DNS
response for _diameter._tcp.clearwater.opnfv type SRV
28-03-2018 06:25:57.064 UTC Warning dnscachedresolver.cpp:846: Failed to
retrieve record for _diameter._tcp.clearwater.opnfv: Domain name not found
28-03-2018 06:25:57.064 UTC Debug dnscachedresolver.cpp:946: Adding
_diameter._tcp.clearwater.opnfv to cache expiry list with deletion time of
1522218957
28-03-2018 06:25:57.064 UTC Debug dnscachedresolver.cpp:704: Received DNS
response for _diameter._sctp.clearwater.opnfv type SRV
28-03-2018 06:25:57.064 UTC Warning dnscachedresolver.cpp:846: Failed to
retrieve record for _diameter._sctp.clearwater.opnfv: Domain name not found
28-03-2018 06:25:57.064 UTC Debug dnscachedresolver.cpp:946: Adding
_diameter._sctp.clearwater.opnfv to cache expiry list with deletion time of
1522218957
28-03-2018 06:25:57.064 UTC Debug dnscachedresolver.cpp:560: Received all query
responses
28-03-2018 06:25:57.064 UTC Debug dnscachedresolver.cpp:588: Pulling 0 records
from cache for _diameter._tcp.clearwater.opnfv SRV
28-03-2018 06:25:57.064 UTC Debug dnscachedresolver.cpp:588: Pulling 0 records
from cache for _diameter._sctp.clearwater.opnfv SRV
28-03-2018 06:25:57.064 UTC Debug diameterresolver.cpp:131: TCP SRV record
_diameter._tcp.clearwater.opnfv returned 0 records
28-03-2018 06:25:57.064 UTC Debug diameterresolver.cpp:134: SCTP SRV record
_diameter._sctp.clearwater.opnfv returned 0 records
28-03-2018 06:25:57.064 UTC Error diameterstack.cpp:864: No Diameter peers have
been found
28-03-2018 06:25:57.068 UTC Verbose httpstack.cpp:345: Process request for URL
/ping, args (null)
28-03-2018 06:25:57.068 UTC Verbose httpstack.cpp:93: Sending response 200 to
request for URL /ping, args (null)
28-03-2018 06:25:58.027 UTC Verbose httpstack.cpp:345: Process request for URL
/call-id/2010000020%2F%2F%2F14990-8708%4010.67.79.24, args (null)
28-03-2018 06:25:58.027 UTC Debug handlers.cpp:128: Handling request, body:
{
"peers": {
"ccf": [
""
]
},
"event": {
"Accounting-Record-Type": 1,
"Event-Timestamp": 1522218357,
"Service-Information": {
"Subscription-Id": [
{
"Subscription-Id-Type": 2,
"Subscription-Id-Data": "sip:[email protected]"
}
],
"IMS-Information": {
"Event-Type": {
"SIP-Method": "REGISTER",
"Expires": 3600
},
"Role-Of-Node": 0,
"Node-Functionality": 1,
"User-Session-Id": "2010000020///[email protected]",
"Called-Party-Address": "sip:[email protected]",
"Associated-URI": [
"sip:[email protected]"
],
"Time-Stamps": {
"SIP-Request-Timestamp": 1522218357,
"SIP-Request-Timestamp-Fraction": 960,
"SIP-Response-Timestamp": 1522218357,
"SIP-Response-Timestamp-Fraction": 967
},
"IMS-Charging-Identifier": "",
"Cause-Code": -1,
"From-Address":
"<sip:[email protected]>;tag=8708SIPpTag0014990",
"Route-Header-Received":
"<sip:clearwater.opnfv;transport=TCP;lr>",
"Route-Header-Transmitted":
"<sip:icscf.sprout.clearwater.local:5052;transport=TCP;lr;orig>",
"Instance-Id": "<urn:uuid:00000000-0000-0000-0000-000000000001>"
}
}
}
}
28-03-2018 06:25:58.027 UTC Debug handlers.cpp:244: Adding CCF
28-03-2018 06:25:58.027 UTC Debug handlers.cpp:82: Handle the received message
28-03-2018 06:25:58.027 UTC Debug peer_message_sender.cpp:84: Sending message
to (number 0)
28-03-2018 06:25:58.027 UTC Debug rf.cpp:63: Building an Accounting-Request
28-03-2018 06:25:58.027 UTC Debug freeDiameter: No Session-Id AVP found in
message 0x7f764c008d50
28-03-2018 06:25:58.027 UTC Verbose diameterstack.cpp:1470: Sending Diameter
message of type 271 on transaction 0x7f764c008d00
28-03-2018 06:25:58.027 UTC Verbose httpstack.cpp:93: Sending response 200 to
request for URL /call-id/2010000020%2F%2F%2F14990-8708%4010.67.79.24, args
(null)
28-03-2018 06:25:58.027 UTC Debug diameterstack.cpp:397: Routing out callback
from freeDiameter
28-03-2018 06:25:58.027 UTC Error diameterstack.cpp:293: Routing error: 'No
remaining suitable candidate to route the message to' for message with
Command-Code 271, Destination-Host and Destination-Realm clearwater.opnfv
28-03-2018 06:25:58.027 UTC Debug freeDiameter: Iterating on rules of COMMAND:
'(generic error format)'.
28-03-2018 06:25:58.027 UTC Debug freeDiameter: Calling callback registered
when query was sent (0x43cb30, 0x7f764c008d00)
28-03-2018 06:25:58.027 UTC Verbose diameterstack.cpp:1130: Got Diameter
response of type 271 - calling callback on transaction 0x7f764c008d00
28-03-2018 06:25:58.027 UTC Warning peer_message_sender.cpp:125: Failed to send
ACR to (number 0)
28-03-2018 06:25:58.027 UTC Error peer_message_sender.cpp:145: Failed to
connect to all CCFs, message not sent
28-03-2018 06:25:58.027 UTC Warning session_manager.cpp:414: Session for
2010000020///[email protected] received error from CDF
28-03-2018 06:25:58.032 UTC Verbose httpstack.cpp:345: Process request for URL
/call-id/2010000020%2F%2F%2F14990-8708%4010.67.79.24, args (null)
28-03-2018 06:25:58.032 UTC Debug handlers.cpp:128: Handling request, body:
{
"peers": {
"ccf": [
""
]
},
"event": {
"Accounting-Record-Type": 1,
"Event-Timestamp": 1522218357,
"Service-Information": {
"Subscription-Id": [
{
"Subscription-Id-Type": 2,
"Subscription-Id-Data": "sip:[email protected]"
}
],
"IMS-Information": {
"Event-Type": {
"SIP-Method": "REGISTER",
"Expires": 3600
},
"Role-Of-Node": 0,
"Node-Functionality": 1,
"User-Session-Id": "2010000020///[email protected]",
"Called-Party-Address": "sip:[email protected]",
"Associated-URI": [
"sip:[email protected]"
],
"Time-Stamps": {
"SIP-Request-Timestamp": 1522218357,
"SIP-Request-Timestamp-Fraction": 968,
"SIP-Response-Timestamp": 1522218357,
"SIP-Response-Timestamp-Fraction": 974
},
"IMS-Charging-Identifier": "",
"Cause-Code": -1,
"From-Address":
"<sip:[email protected]>;tag=8708SIPpTag0014990",
"Route-Header-Received":
"<sip:clearwater.opnfv;transport=TCP;lr>",
"Route-Header-Transmitted":
"<sip:icscf.sprout.clearwater.local:5052;transport=TCP;lr;orig>",
"Instance-Id": "<urn:uuid:00000000-0000-0000-0000-000000000001>"
}
}
}
}
28-03-2018 06:25:58.032 UTC Debug handlers.cpp:244: Adding CCF
28-03-2018 06:25:58.032 UTC Debug handlers.cpp:82: Handle the received message
28-03-2018 06:25:58.032 UTC Debug peer_message_sender.cpp:84: Sending message
to (number 0)
28-03-2018 06:25:58.032 UTC Debug rf.cpp:63: Building an Accounting-Request
28-03-2018 06:25:58.032 UTC Debug freeDiameter: No Session-Id AVP found in
message 0x7f764c001310
28-03-2018 06:25:58.032 UTC Verbose diameterstack.cpp:1470: Sending Diameter
message of type 271 on transaction 0x7f764c006f30
28-03-2018 06:25:58.032 UTC Verbose httpstack.cpp:93: Sending response 200 to
request for URL /call-id/2010000020%2F%2F%2F14990-8708%4010.67.79.24, args
(null)
28-03-2018 06:25:58.032 UTC Debug diameterstack.cpp:397: Routing out callback
from freeDiameter
28-03-2018 06:25:58.032 UTC Error diameterstack.cpp:293: Routing error: 'No
remaining suitable candidate to route the message to' for message with
Command-Code 271, Destination-Host and Destination-Realm clearwater.opnfv
28-03-2018 06:25:58.032 UTC Debug freeDiameter: Iterating on rules of COMMAND:
'(generic error format)'.
28-03-2018 06:25:58.032 UTC Debug freeDiameter: Calling callback registered
when query was sent (0x43cb30, 0x7f764c006f30)
28-03-2018 06:25:58.032 UTC Verbose diameterstack.cpp:1130: Got Diameter
response of type 271 - calling callback on transaction 0x7f764c006f30
28-03-2018 06:25:58.032 UTC Warning peer_message_sender.cpp:125: Failed to send
ACR to (number 0)
28-03-2018 06:25:58.032 UTC Error peer_message_sender.cpp:145: Failed to
connect to all CCFs, message not sent
28-03-2018 06:25:58.032 UTC Warning session_manager.cpp:414: Session for
2010000020///[email protected] received error from CDF
Have I missed something in shared_config?
root@dime-au6gte:/var/log/ralf# cat /etc/clearwater/shared_config
# Deployment definitions
home_domain=clearwater.opnfv
sprout_hostname=sprout.clearwater.local
chronos_hostname=10.67.79.16:7253
hs_hostname=hs.clearwater.local:8888
hs_provisioning_hostname=hs-prov.clearwater.local:8889
sprout_impi_store=vellum.clearwater.local
sprout_registration_store=vellum.clearwater.local
cassandra_hostname=vellum.clearwater.local
chronos_hostname=vellum.clearwater.local
ralf_session_store=vellum.clearwater.local
ralf_hostname=ralf.clearwater.local:10888
xdms_hostname=homer.clearwater.local:7888
signaling_dns_server=10.67.79.16
snmp_ip=10.67.79.11
reg_max_expires=1800
bgcf=0
# Email server configuration
smtp_smarthost=localhost
smtp_username=username
smtp_password=password
[email protected]
# Keys
signup_key=secret
turn_workaround=secret
ellis_api_key=secret
ellis_cookie_key=secret
root@dime-au6gte:~# cat /etc/clearwater/local_config
local_ip=10.67.79.11
public_ip=
public_hostname=dime-au6gte.clearwater.local
homestead seems fine except one line "Failed TWO read for get_row. Try ONE":
root@dime-au6gte:/var/log/homestead# vim homestead_20180328T060000Z.txt
28-03-2018 06:30:58.045 UTC Debug baseresolver.cpp:425: Attempt to parse
vellum.clearwater.local as IP address
28-03-2018 06:30:58.045 UTC Verbose dnscachedresolver.cpp:486: Check cache for
vellum.clearwater.local type 1
28-03-2018 06:30:58.045 UTC Debug dnscachedresolver.cpp:588: Pulling 1 records
from cache for vellum.clearwater.local A
28-03-2018 06:30:58.045 UTC Debug baseresolver.cpp:366: Found 1 A/AAAA records,
creating iterator
28-03-2018 06:30:58.045 UTC Debug baseresolver.cpp:819: 10.67.79.6:9160
transport 6 has state: WHITE
28-03-2018 06:30:58.045 UTC Debug baseresolver.cpp:819: 10.67.79.6:9160
transport 6 has state: WHITE
28-03-2018 06:30:58.045 UTC Debug baseresolver.cpp:1004: Added a whitelisted
server, now have 1 of 1
28-03-2018 06:30:58.045 UTC Debug connection_pool.h:231: Request for connection
to IP: 10.67.79.6, port: 9160
28-03-2018 06:30:58.045 UTC Debug connection_pool.h:244: Found existing
connection 0x7fed8c0115a0 in pool
28-03-2018 06:30:58.045 UTC Debug cassandra_store.cpp:159: Generated Cassandra
timestamp 1522218658045331
28-03-2018 06:30:58.045 UTC Debug cache.cpp:350: Issuing get for key
sip:[email protected]
28-03-2018 06:30:58.045 UTC Debug cassandra_store.cpp:731: Failed TWO read for
get_row. Try ONE
28-03-2018 06:30:58.045 UTC Debug cache.cpp:370: Retrieved XML column with TTL
0 and value <?xml version='1.0' encoding='UTF-8'?><IMSSubscription
xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance";
xsi:noNamespaceSchemaLocation="CxDataType.xsd"><PrivateID>[email protected]</PrivateID><ServiceProfile><InitialFilterCriteria><TriggerPoint><ConditionTypeCNF>0</ConditionTypeCNF><SPT><ConditionNegated>0</ConditionNegated><Group>0</Group><Method>INVITE</Method><Extension
/></SPT></TriggerPoint><ApplicationServer><ServerName>sip:mmtel.clearwater.opnfv</ServerName><DefaultHandling>0</DefaultHandling></ApplicationServer></InitialFilterCriteria><PublicIdentity><BarringIndication>1</BarringIndication><Identity>sip:[email protected]</Identity></PublicIdentity></ServiceProfile></IMSSubscription>
28-03-2018 06:30:58.045 UTC Debug cache.cpp:388: Retrieved is_registered column
with value False and TTL 0
28-03-2018 06:30:58.045 UTC Debug baseresolver.cpp:830: Successful response
from 10.67.79.6:9160 transport 6
28-03-2018 06:30:58.045 UTC Debug connection_pool.h:267: Release connection to
IP: 10.67.79.6, port: 9160 to pool
28-03-2018 06:30:58.045 UTC Debug handlers.cpp:1245: Got IMS subscription from
cache
28-03-2018 06:30:58.045 UTC Debug handlers.cpp:1260: TTL for this database
record is 0, IMS Subscription XML is not empty, registration state is
UNREGISTERED, and the charging addresses are empty
28-03-2018 06:30:58.045 UTC Debug handlers.cpp:1510: Rejecting deregistration
for user who was not registered
28-03-2018 06:30:58.045 UTC Verbose httpstack.cpp:93: Sending response 400 to
request for URL /impu/sip%3A2010000021%40clearwater.opnfv/reg-data, args (null)
28-03-2018 06:30:58.046 UTC Debug cache.cpp:370: Retrieved XML column with TTL
0 and value <?xml version='1.0' encoding='UTF-8'?><IMSSubscription
xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance";
xsi:noNamespaceSchemaLocation="CxDataType.xsd"><PrivateID>[email protected]</PrivateID><ServiceProfile><InitialFilterCriteria><TriggerPoint><ConditionTypeCNF>0</ConditionTypeCNF><SPT><ConditionNegated>0</ConditionNegated><Group>0</Group><Method>INVITE</Method><Extension
/></SPT></TriggerPoint><ApplicationServer><ServerName>sip:mmtel.clearwater.opnfv</ServerName><DefaultHandling>0</DefaultHandling></ApplicationServer></InitialFilterCriteria><PublicIdentity><BarringIndication>1</BarringIndication><Identity>sip:[email protected]</Identity></PublicIdentity></ServiceProfile></IMSSubscription>
28-03-2018 06:30:58.046 UTC Debug cache.cpp:388: Retrieved is_registered column
with value False and TTL 0
28-03-2018 06:30:58.046 UTC Debug baseresolver.cpp:830: Successful response
from 10.67.79.6:9160 transport 6
28-03-2018 06:30:58.046 UTC Debug connection_pool.h:267: Release connection to
IP: 10.67.79.6, port: 9160 to pool
28-03-2018 06:30:58.046 UTC Debug handlers.cpp:1245: Got IMS subscription from
cache
28-03-2018 06:30:58.046 UTC Debug handlers.cpp:1260: TTL for this database
record is 0, IMS Subscription XML is not empty, registration state is
UNREGISTERED, and the charging addresses are empty
28-03-2018 06:30:58.046 UTC Debug handlers.cpp:1286: Subscriber registering
with new binding
28-03-2018 06:30:58.046 UTC Debug handlers.cpp:1457: Handling initial
registration
28-03-2018 06:30:58.046 UTC Debug handlers.cpp:1654: Attempting to cache IMS
subscription for public IDs
28-03-2018 06:30:58.046 UTC Debug handlers.cpp:1658: Got public IDs to cache
against - doing it
28-03-2018 06:30:58.046 UTC Debug handlers.cpp:1663: Public ID
sip:[email protected]
28-03-2018 06:30:58.046 UTC Debug cassandra_store.cpp:159: Generated Cassandra
timestamp 1522218658046440
28-03-2018 06:30:58.046 UTC Debug a_record_resolver.cpp:80:
ARecordResolver::resolve_iter for host vellum.clearwater.local, port 9160,
family 2
28-03-2018 06:30:58.046 UTC Debug baseresolver.cpp:425: Attempt to parse
vellum.clearwater.local as IP address
28-03-2018 06:30:58.046 UTC Verbose dnscachedresolver.cpp:486: Check cache for
vellum.clearwater.local type 1
28-03-2018 06:30:58.046 UTC Debug dnscachedresolver.cpp:588: Pulling 1 records
from cache for vellum.clearwater.local A
28-03-2018 06:30:58.046 UTC Debug baseresolver.cpp:366: Found 1 A/AAAA records,
creating iterator
28-03-2018 06:30:58.046 UTC Debug baseresolver.cpp:819: 10.67.79.6:9160
transport 6 has state: WHITE
28-03-2018 06:30:58.046 UTC Debug baseresolver.cpp:819: 10.67.79.6:9160
transport 6 has state: WHITE
28-03-2018 06:30:58.046 UTC Debug baseresolver.cpp:1004: Added a whitelisted
server, now have 1 of 1
28-03-2018 06:30:58.046 UTC Debug connection_pool.h:231: Request for connection
to IP: 10.67.79.6, port: 9160
28-03-2018 06:30:58.046 UTC Debug connection_pool.h:244: Found existing
connection 0x7fed8c0115a0 in pool
28-03-2018 06:30:58.046 UTC Debug cassandra_store.cpp:612: Constructing
cassandra put request with timestamp 1522218658046440 and per-column TTLs
28-03-2018 06:30:58.046 UTC Debug cassandra_store.cpp:629:
ims_subscription_xml => <?xml version='1.0' encoding='UTF-8'?><IMSSubscription
xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance";
xsi:noNamespaceSchemaLocation="CxDataType.xsd"><PrivateID>[email protected]</PrivateID><ServiceProfile><InitialFilterCriteria><TriggerPoint><ConditionTypeCNF>0</ConditionTypeCNF><SPT><ConditionNegated>0</ConditionNegated><Group>0</Group><Method>INVITE</Method><Extension
/></SPT></TriggerPoint><ApplicationServer><ServerName>sip:mmtel.clearwater.opnfv</ServerName><DefaultHandling>0</DefaultHandling></ApplicationServer></InitialFilterCriteria><PublicIdentity><BarringIndication>1</BarringIndication><Identity>sip:[email protected]</Identity></PublicIdentity></ServiceProfile></IMSSubscription>
(TTL 0)
28-03-2018 06:30:58.046 UTC Debug cassandra_store.cpp:629: is_registered =>
(TTL 0)
28-03-2018 06:30:58.046 UTC Debug cassandra_store.cpp:650: Executing put
request operation
28-03-2018 06:30:58.047 UTC Debug baseresolver.cpp:830: Successful response
from 10.67.79.6:9160 transport 6
28-03-2018 06:30:58.047 UTC Debug connection_pool.h:267: Release connection to
IP: 10.67.79.6, port: 9160 to pool
28-03-2018 06:30:58.047 UTC Debug handlers.cpp:1567: Sending 200 response (body
was {"reqtype": "reg", "server_name":
"sip:scscf.sprout.clearwater.local:5054;transport=TCP"})
28-03-2018 06:30:58.047 UTC Verbose httpstack.cpp:93: Sending response 200 to
request for URL /impu/sip%3A2010000021%40clearwater.opnfv/reg-data, args
private_id=2010000021%40clearwater.opnfv
The error about "Could not get subscriber data from HSS" on Sprout node
occurred sometimes.
root@sprout-2tl8g3:/var/log/sprout# vim sprout_20180328T060000Z.txt
28-03-2018 06:36:11.741 UTC Error httpclient.cpp:712: cURL failure with cURL
error code 0 (see man 3 libcurl-errors) and HTTP error code 400
28-03-2018 06:36:11.741 UTC Error hssconnection.cpp:704: Could not get
subscriber data from HSS
28-03-2018 06:36:25.875 UTC Status alarm.cpp:62: sprout issued 1004.1 alarm
root@dime-au6gte:/var/log/homestead# monit summary
Monit 5.18.1 uptime: 2h 27m
Service Name Status Type
node-dime-au6gte.clearwater.... Running System
snmpd_process Running Process
ralf_process Running Process
ntp_process Running Process
nginx_process Running Process
homestead_process Running Process
homestead-prov_process Running Process
clearwater_queue_manager_pro... Running Process
etcd_process Running Process
clearwater_diags_monitor_pro... Running Process
clearwater_config_manager_pr... Running Process
clearwater_cluster_manager_p... Running Process
ralf_uptime Status ok Program
poll_ralf Status ok Program
nginx_ping Status ok Program
nginx_uptime Status ok Program
monit_uptime Status ok Program
homestead_uptime Status ok Program
poll_homestead Status ok Program
check_cx_health Status ok Program
poll_homestead-prov Status ok Program
clearwater_queue_manager_uptime Status ok Program
etcd_uptime Status ok Program
poll_etcd_cluster Status ok Program
poll_etcd Status ok Program
Any help/suggestion would be much appreciated.
Thanks,
Linda
_______________________________________________
Clearwater mailing list
[email protected]
http://lists.projectclearwater.org/mailman/listinfo/clearwater_lists.projectclearwater.org
