Hi, Thanks for the help, there was an error in the file (no [] in the capabilities) then it was not loaded at system start. One more little thing, is it now possible to configure the mmtel for the user registered with openHSS? Thank you,
Abaco 2014-10-17 21:44 GMT+02:00 Eleanor Merry <[email protected]>: > Hi Abaco, > > This is happening because your I-CSCF doesn't know about your S-CSCF. > > You have I-CSCF and S-CSCF enabled on your deployment, so when a call > comes in to a subscriber it first goes to the I-CSCF to determine what > S-CSCF it should route the call to. > > If your deployment doesn't have a HSS, then Homestead returns the sprout > domain as the S-CSCF. If you have a HSS, then the I-CSCF queries the HSS > for which S-CSCF the subscriber belongs to. If no S-CSCF has been > allocated, the HSS returns this, and the I-CSCF selects the most > appropriate S-CSCF it knows about. > > In your case, the I-CSCF doesn't know about any S-CSCFs - as shown in the > log: > 15-10-2014 13:05:03.702 UTC Warning scscfselector.cpp:165: There are no > configured S-CSCFs > > This means the call gets rejected with a 600 Busy Everywhere. > > To tell your I-CSCF about your S-CSCF, you need to create the file > /etc/clearwater/s-cscf.json on each of your I-CSCF nodes. You can find more > information about it at: > https://github.com/Metaswitch/clearwater-docs/wiki/Manual-Install#setting-up-s-cscf-configuration > > Hope this helps, > > Ellie > > -----Original Message----- > From: [email protected] [mailto: > [email protected]] On Behalf Of Ruggero > Schiavi > Sent: 15 October 2014 15:27 > To: [email protected] > Subject: Re: [Clearwater] FoHSS integration - busy everywhere > > PPS. > The diameter answer si DIAMETER_UNREGISTERED_SERVICE when the user is not > registered. > > > 2014-10-15 15:40 GMT+02:00 Ruggero Schiavi <[email protected]>: > > > Hi, > > Sorry to bother you again, I am integrating the HSS and I followed the > > guide lines of your website. > > To have it working I added my domain zone inside the visited network > > of the public Identities and sprout:5054 as s-cscf. > > > > I am getting troubles if I call/perform a subscribe to a > > not-registered > > user: sprout in fact answers with a busy everywhere, I modified the > > IFCs to try to have them as similar as possible when they were > > provided by Homestead. > > > > Please let me know if you have any suggestion about configuration or > > the problem, > > > > I thank for any help you may provide, > > > > Abaco > > > > Ps. since this is still in testing OpenHss is mounted on the Homer > > machine > > > > > > > > > > > > > > 15-10-2014 13:05:03.679 UTC Debug httpconnection.cpp:833: Received > > header http/1.1200ok with value > > 15-10-2014 13:05:03.679 UTC Debug httpconnection.cpp:833: Received > > header content-length with value 938 > > 15-10-2014 13:05:03.679 UTC Debug httpconnection.cpp:833: Received > > header content-type with value text/plain > > 15-10-2014 13:05:03.679 UTC Debug httpconnection.cpp:833: Received > > header with value > > 15-10-2014 13:05:03.679 UTC Debug httpconnection.cpp:553: Received > > HTTP response : <ClearwaterRegData> > > <RegistrationState>REGISTERED</RegistrationState> > > <IMSSubscription> > > <PrivateID>[email protected]</PrivateID> > > <ServiceProfile> > > <PublicIdentity> > > <Identity>sip:[email protected]</Identity> > > <Extension> > > <IdentityType>0</IdentityType> > > </Extension> > > </PublicIdentity> > > <InitialFilterCriteria> > > <Priority>0</Priority> > > <TriggerPoint> > > <ConditionTypeCNF>0</ConditionTypeCNF> > > <SPT> > > <ConditionNegated>0</ConditionNegated> > > <Group>0</Group> > > <Method>INVITE</Method> > > <Extension> > > <RegistrationType>1</RegistrationType> > > <RegistrationType>2</RegistrationType> > > </Extension> > > </SPT> > > </TriggerPoint> > > <ApplicationServer> > > <ServerName>sip:mmtel.ims.prod.lan</ServerName> > > <DefaultHandling>0</DefaultHandling> > > </ApplicationServer> > > </InitialFilterCriteria> > > </ServiceProfile> > > </IMSSubscription> > > </ClearwaterRegData> > > > > > > 15-10-2014 13:05:03.679 UTC Debug hssconnection.cpp:331: Processing > > Identity node from HSS XML - sip:[email protected] > > > > 15-10-2014 13:05:03.679 UTC Debug scscfsproutlet.cpp:708: Successfully > > looked up iFCs > > 15-10-2014 13:05:03.679 UTC Debug acr.cpp:1495: Create RalfACR for > > node type S-CSCF with role Originating > > 15-10-2014 13:05:03.679 UTC Debug acr.cpp:48: Created ACR > > (0x7f77f0540560) > > 15-10-2014 13:05:03.679 UTC Debug acr.cpp:195: Created S-CSCF Ralf ACR > > 15-10-2014 13:05:03.679 UTC Debug aschain.cpp:75: Creating AsChain > > 0x7f77f0540770 with 1 IFC and adding to map > > 15-10-2014 13:05:03.679 UTC Debug aschain.cpp:77: Attached ACR > > (0x7f77f0540560) to chain > > 15-10-2014 13:05:03.679 UTC Debug scscfsproutlet.cpp:828: S-CSCF > > sproutlet transaction 0x7f77f01d3030 linked to AsChain > > AsChain-orig[0x7f77f0540770]:1/1 > > 15-10-2014 13:05:03.679 UTC Debug scscfsproutlet.cpp:729: Single > > Record-Route - initiation of originating handling > > 15-10-2014 13:05:03.679 UTC Debug sproutletproxy.cpp:324: Creating URI > > for scscf > > 15-10-2014 13:05:03.679 UTC Debug sproutletproxy.cpp:328: Add services > > parameter > > 15-10-2014 13:05:03.679 UTC Debug sproutletproxy.cpp:336: > > sip:ppsprout1.ims.prod.lan:5054;transport=TCP;lr;service=scscf > > 15-10-2014 13:05:03.679 UTC Debug acr.cpp:234: Set record type for > > P/S-CSCF > > 15-10-2014 13:05:03.679 UTC Debug acr.cpp:261: Dialog-initiating > > INVITE => START_RECORD > > 15-10-2014 13:05:03.680 UTC Debug acr.cpp:1229: Stored 0 subscription > > identifiers > > 15-10-2014 13:05:03.680 UTC Debug acr.cpp:1307: Found > > P-Charging-Vector header, store information > > 15-10-2014 13:05:03.680 UTC Info scscfsproutlet.cpp:394: Found served > > user, so apply services > > 15-10-2014 13:05:03.680 UTC Debug scscfsproutlet.cpp:836: Performing > > originating initiating request processing > > 15-10-2014 13:05:03.680 UTC Debug ifchandler.cpp:434: SPT class Method: > > result true > > 15-10-2014 13:05:03.680 UTC Debug ifchandler.cpp:538: Add to group 0 > > val true > > 15-10-2014 13:05:03.680 UTC Debug ifchandler.cpp:556: Result group 0 > > val true > > 15-10-2014 13:05:03.680 UTC Debug ifchandler.cpp:562: iFC matches > > 15-10-2014 13:05:03.680 UTC Debug aschain.cpp:212: Matched iFC > > AsChain-orig[0x7f77f0540770]:1/1 > > 15-10-2014 13:05:03.680 UTC Info ifchandler.cpp:681: Found (triggered) > > server sip:mmtel.ims.prod.lan > > 15-10-2014 13:05:03.680 UTC Info scscfsproutlet.cpp:945: Routing to > > Application Server sip:mmtel.ims.prod.lan with ODI token > > odi_Z6sxALGUH+ for > > AsChain-orig[0x7f77f0540770]:1/1 > > 15-10-2014 13:05:03.680 UTC Debug sproutletproxy.cpp:1137: Sproutlet > > send_request 0x7f77f0601b30 > > 15-10-2014 13:05:03.680 UTC Verbose sproutletproxy.cpp:1162: > > scscf-0x7f77f01d3030 sending Request msg INVITE/cseq=1789968436 > > (tdta0x7f77f0601520) on fork 0 > > 15-10-2014 13:05:03.680 UTC Debug sproutletproxy.cpp:413: Started > > Sproutlet timer, id = 140153105413808, duration = 2.000 > > 15-10-2014 13:05:03.680 UTC Debug sproutletproxy.cpp:1478: Processing > > actions from sproutlet - 0 responses, 1 requests > > 15-10-2014 13:05:03.680 UTC Debug sproutletproxy.cpp:1513: Processing > > request 0x7f77f06015c8, fork = 0 > > 15-10-2014 13:05:03.680 UTC Debug sproutletproxy.cpp:1631: > > scscf-0x7f77f01d3030 transmitting request on fork 0 > > 15-10-2014 13:05:03.680 UTC Debug sproutletproxy.cpp:1645: > > scscf-0x7f77f01d3030 store reference to non-ACK request Request msg > > INVITE/cseq=1789968436 (tdta0x7f77f0601520) on fork 0 > > 15-10-2014 13:05:03.680 UTC Debug sproutletproxy.cpp:1470: Removing > > message 0x7f77f0601b30 => txdata 0x7f77f06015c8 mapping > > 15-10-2014 13:05:03.680 UTC Debug sproutletproxy.cpp:110: Find target > > Sproutlet for request > > 15-10-2014 13:05:03.680 UTC Debug sproutletproxy.cpp:144: Found next > > routable URI: sip:mmtel.ims.prod.lan;lr > > 15-10-2014 13:05:03.680 UTC Debug mmtel.cpp:86: Found P-Served-User > > header: P-Served-User: <sip:[email protected] > > >;sescase=orig;regstate=reg > > 15-10-2014 13:05:03.680 UTC Debug mmtel.cpp:149: Fetching simservs > > configuration for sip:[email protected] > > 15-10-2014 13:05:03.680 UTC Debug httpresolver.cpp:70: > > HttpResolver::resolve for host pphomer1.ims.prod.lan, port 7888, > > family 2 > > 15-10-2014 13:05:03.680 UTC Debug baseresolver.cpp:511: Attempt to > > parse pphomer1.ims.prod.lan as IP address > > 15-10-2014 13:05:03.680 UTC Debug dnscachedresolver.cpp:179: Pulling 1 > > records from cache for pphomer1.ims.prod.lan A > > 15-10-2014 13:05:03.680 UTC Debug baseresolver.cpp:359: Found 1 A/AAAA > > records, randomizing > > 15-10-2014 13:05:03.680 UTC Debug baseresolver.cpp:501: > > 10.99.99.165:7888 transport 6 is not blacklisted > > 15-10-2014 13:05:03.680 UTC Debug baseresolver.cpp:380: Added a > > server, now have 1 of 5 > > 15-10-2014 13:05:03.681 UTC Debug baseresolver.cpp:418: Adding 0 > > servers from blacklist > > 15-10-2014 13:05:03.681 UTC Debug httpconnection.cpp:540: Sending HTTP > > request : > > http://pphomer1.ims.prod.lan:7888/org.etsi.ngn.simservs/users/sip%3A87 > > 100000%40ims.prod.lan/simservs.xml > > (trying 10.99.99.165) on new connection > > 15-10-2014 13:05:03.689 UTC Error httpconnection.cpp:569: > > http://pphomer1.ims.prod.lan:7888/org.etsi.ngn.simservs/users/sip%3A87 > > 100000%40ims.prod.lan/simservs.xml > > failed at server 10.99.99.165 : HTTP response code said error (22 404) : > > fatal > > 15-10-2014 13:05:03.689 UTC Error httpconnection.cpp:667: cURL failure > > with cURL error code 22 (see man 3 libcurl-errors) and HTTP error code > > 404 > > 15-10-2014 13:05:03.689 UTC Debug statistic.cpp:103: Send new value > > for statistic xdm_latency_us, size 5 > > 15-10-2014 13:05:03.689 UTC Debug zmq_lvc.cpp:167: Update to > > xdm_latency_us statistic > > 15-10-2014 13:05:03.689 UTC Debug zmq_lvc.cpp:250: Clearing message > > cache for 0x7f78280257f0 > > 15-10-2014 13:05:03.690 UTC Debug mmtel.cpp:153: Failed to fetch > > simservs configuration for sip:[email protected], no MMTel > > services enabled > > 15-10-2014 13:05:03.690 UTC Verbose sproutletproxy.cpp:977: Created > > Sproutlet mmtel-0x7f77f0253110 for Request msg INVITE/cseq=1789968436 > > (tdta0x7f77f0601520) > > 15-10-2014 13:05:03.690 UTC Info pjutils.cpp:1551: Cloning header! > > 140153110670272 > > 15-10-2014 13:05:03.690 UTC Debug sproutletproxy.cpp:1463: Adding > > message > > 0x7f77f0614b30 => txdata 0x7f77f06145c8 mapping > > 15-10-2014 13:05:03.690 UTC Verbose sproutletproxy.cpp:1366: > > scscf-0x7f77f01d3030 received provisional response Response msg > > 100/INVITE/cseq=1789968436 (tdta0x7f77f0614520) on fork 0, state = > > Proceeding > > 15-10-2014 13:05:03.690 UTC Info scscfsproutlet.cpp:448: S-CSCF > > received response > > 15-10-2014 13:05:03.690 UTC Debug sproutletproxy.cpp:425: Cancelled > > Sproutlet timer, id = 140153105413808 > > 15-10-2014 13:05:03.690 UTC Verbose sproutletproxy.cpp:1189: > > scscf-0x7f77f01d3030 sending Response msg 100/INVITE/cseq=1789968436 > > (tdta0x7f77f0614520) > > 15-10-2014 13:05:03.690 UTC Debug sproutletproxy.cpp:1478: Processing > > actions from sproutlet - 1 responses, 0 requests > > 15-10-2014 13:05:03.690 UTC Debug sproutletproxy.cpp:1553: Aggregating > > response with status code 100 > > 15-10-2014 13:05:03.690 UTC Debug sproutletproxy.cpp:1570: Discard > > 100/INVITE response (tdta0x7f77f0614520) > > 15-10-2014 13:05:03.690 UTC Debug sproutletproxy.cpp:1470: Removing > > message 0x7f77f0614b30 => txdata 0x7f77f06145c8 mapping > > 15-10-2014 13:05:03.690 UTC Debug pjsip: tdta0x7f77f061 Destroying > > txdata Response msg 100/INVITE/cseq=1789968436 (tdta0x7f77f0614520) > > 15-10-2014 13:05:03.690 UTC Debug pjutils.cpp:686: Cloned > > tdta0x7f77f0601520 to tdta0x7f77f0614520 > > 15-10-2014 13:05:03.690 UTC Debug sproutletproxy.cpp:1038: Remove top > > Route header Route: <sip:mmtel.ims.prod.lan;lr> > > 15-10-2014 13:05:03.690 UTC Debug sproutletproxy.cpp:1463: Adding > > message > > 0x7f77f0614b30 => txdata 0x7f77f06145c8 mapping > > 15-10-2014 13:05:03.690 UTC Verbose sproutletproxy.cpp:1337: > > mmtel-0x7f77f0253110 pass initial request Request msg > > INVITE/cseq=1789968436 (tdta0x7f77f0614520) to Sproutlet > > 15-10-2014 13:05:03.690 UTC Debug sproutletappserver.cpp:70: Store > > onward route-set for request > > 15-10-2014 13:05:03.690 UTC Debug sproutletappserver.cpp:76: Store > header: > > Route: <sip:[email protected]:5054;lr;orig> > > 15-10-2014 13:05:03.691 UTC Debug mmtel.cpp:578: Originating > > Identification Presentation Restriction disabled > > 15-10-2014 13:05:03.691 UTC Debug mmtel.cpp:638: Outbound call barring > > disabled > > 15-10-2014 13:05:03.691 UTC Debug sproutletappserver.cpp:183: Restore > > header: Route: > > <sip:[email protected]:5054;lr;orig> > > 15-10-2014 13:05:03.691 UTC Debug sproutletproxy.cpp:1137: Sproutlet > > send_request 0x7f77f0614b30 > > 15-10-2014 13:05:03.691 UTC Verbose sproutletproxy.cpp:1162: > > mmtel-0x7f77f0253110 sending Request msg INVITE/cseq=1789968436 > > (tdta0x7f77f0614520) on fork 0 > > 15-10-2014 13:05:03.691 UTC Debug sproutletproxy.cpp:1478: Processing > > actions from sproutlet - 0 responses, 1 requests > > 15-10-2014 13:05:03.691 UTC Debug sproutletproxy.cpp:1513: Processing > > request 0x7f77f06145c8, fork = 0 > > 15-10-2014 13:05:03.691 UTC Debug sproutletproxy.cpp:1631: > > mmtel-0x7f77f0253110 transmitting request on fork 0 > > 15-10-2014 13:05:03.691 UTC Debug sproutletproxy.cpp:1645: > > mmtel-0x7f77f0253110 store reference to non-ACK request Request msg > > INVITE/cseq=1789968436 (tdta0x7f77f0614520) on fork 0 > > 15-10-2014 13:05:03.691 UTC Debug sproutletproxy.cpp:1470: Removing > > message 0x7f77f0614b30 => txdata 0x7f77f06145c8 mapping > > 15-10-2014 13:05:03.691 UTC Debug sproutletproxy.cpp:110: Find target > > Sproutlet for request > > 15-10-2014 13:05:03.691 UTC Debug sproutletproxy.cpp:144: Found next > > routable URI: sip:[email protected]:5054;lr;orig > > 15-10-2014 13:05:03.691 UTC Debug sproutletproxy.cpp:260: Found user - > > odi_Z6sxALGUH+ > > 15-10-2014 13:05:03.691 UTC Debug sproutletproxy.cpp:260: Found user - > > odi_Z6sxALGUH+ > > 15-10-2014 13:05:03.691 UTC Debug sproutletproxy.cpp:260: Found user - > > odi_Z6sxALGUH+ > > 15-10-2014 13:05:03.691 UTC Debug sproutletproxy.cpp:260: Found user - > > odi_Z6sxALGUH+ > > 15-10-2014 13:05:03.691 UTC Debug sproutletproxy.cpp:174: No Sproutlet > > found using service name or host > > 15-10-2014 13:05:03.691 UTC Debug sproutletproxy.cpp:179: Find default > > service for port 5054 > > 15-10-2014 13:05:03.691 UTC Debug scscfsproutlet.cpp:312: S-CSCF > > Transaction (0x7f77f05abf30) created > > 15-10-2014 13:05:03.691 UTC Verbose sproutletproxy.cpp:977: Created > > Sproutlet scscf-0x7f77f05abf30 for Request msg INVITE/cseq=1789968436 > > (tdta0x7f77f0614520) > > 15-10-2014 13:05:03.691 UTC Info pjutils.cpp:1551: Cloning header! > > 140153110747704 > > 15-10-2014 13:05:03.691 UTC Debug sproutletproxy.cpp:1463: Adding > > message > > 0x7f77f0617aa0 => txdata 0x7f77f0617538 mapping > > 15-10-2014 13:05:03.691 UTC Verbose sproutletproxy.cpp:1366: > > mmtel-0x7f77f0253110 received provisional response Response msg > > 100/INVITE/cseq=1789968436 (tdta0x7f77f0617490) on fork 0, state = > > Proceeding > > 15-10-2014 13:05:03.691 UTC Verbose sproutletproxy.cpp:1189: > > mmtel-0x7f77f0253110 sending Response msg 100/INVITE/cseq=1789968436 > > (tdta0x7f77f0617490) > > 15-10-2014 13:05:03.691 UTC Debug sproutletproxy.cpp:1478: Processing > > actions from sproutlet - 1 responses, 0 requests > > 15-10-2014 13:05:03.691 UTC Debug sproutletproxy.cpp:1553: Aggregating > > response with status code 100 > > 15-10-2014 13:05:03.691 UTC Debug sproutletproxy.cpp:1570: Discard > > 100/INVITE response (tdta0x7f77f0617490) > > 15-10-2014 13:05:03.691 UTC Debug sproutletproxy.cpp:1470: Removing > > message 0x7f77f0617aa0 => txdata 0x7f77f0617538 mapping > > 15-10-2014 13:05:03.691 UTC Debug pjsip: tdta0x7f77f061 Destroying > > txdata Response msg 100/INVITE/cseq=1789968436 (tdta0x7f77f0617490) > > 15-10-2014 13:05:03.691 UTC Debug pjutils.cpp:686: Cloned > > tdta0x7f77f0614520 to tdta0x7f77f0617490 > > 15-10-2014 13:05:03.691 UTC Debug sproutletproxy.cpp:1038: Remove top > > Route header Route: <sip:[email protected] > > :5054;lr;orig> > > 15-10-2014 13:05:03.692 UTC Debug sproutletproxy.cpp:1463: Adding > > message > > 0x7f77f0617aa0 => txdata 0x7f77f0617538 mapping > > 15-10-2014 13:05:03.692 UTC Verbose sproutletproxy.cpp:1337: > > scscf-0x7f77f05abf30 pass initial request Request msg > > INVITE/cseq=1789968436 (tdta0x7f77f0617490) to Sproutlet > > 15-10-2014 13:05:03.692 UTC Info scscfsproutlet.cpp:342: S-CSCF > > received initial request > > 15-10-2014 13:05:03.692 UTC Debug scscfsproutlet.cpp:583: Route header > > references this system > > 15-10-2014 13:05:03.692 UTC Debug scscfsproutlet.cpp:596: Found ODI > > token > > Z6sxALGUH+ > > 15-10-2014 13:05:03.692 UTC Debug aschain.h:124: AsChain inc ref > > 0x7f77f0540770 -> 2 > > 15-10-2014 13:05:03.692 UTC Info scscfsproutlet.cpp:603: Original > > dialog for odi_Z6sxALGUH+ found: AsChain-orig[0x7f77f0540770]:2/1 > > 15-10-2014 13:05:03.692 UTC Debug scscfsproutlet.cpp:618: Got our > > Route header, session case orig, OD=AsChain-orig[0x7f77f0540770]:2/1 > > 15-10-2014 13:05:03.692 UTC Debug pjutils.cpp:344: Served user from > > P-Served-User header > > 15-10-2014 13:05:03.692 UTC Debug pjutils.cpp:239: aor_from_uri > > converted sip:[email protected] to sip:[email protected] > > 15-10-2014 13:05:03.692 UTC Debug scscfsproutlet.cpp:681: Retrieved > > ACR > > 0x7f77f0540560 for existing AS chain > > 15-10-2014 13:05:03.692 UTC Info scscfsproutlet.cpp:394: Found served > > user, so apply services > > 15-10-2014 13:05:03.692 UTC Debug scscfsproutlet.cpp:836: Performing > > originating initiating request processing > > 15-10-2014 13:05:03.692 UTC Info scscfsproutlet.cpp:861: Completed > > applying originating services > > 15-10-2014 13:05:03.692 UTC Debug scscfsproutlet.cpp:1223: Translating > > URI > > 15-10-2014 13:05:03.692 UTC Debug scscfsproutlet.cpp:218: ENUM is > > enabled > > 15-10-2014 13:05:03.692 UTC Debug scscfsproutlet.cpp:225: SIP URI - > > user = > > 87100001 > > 15-10-2014 13:05:03.692 UTC Debug scscfsproutlet.cpp:244: Global > > number or look-ups allowed for non-global numbers > > 15-10-2014 13:05:03.692 UTC Debug scscfsproutlet.cpp:250: Performing > > ENUM lookup for user 87100001 > > 15-10-2014 13:05:03.692 UTC Debug enumservice.cpp:186: Translating URI > > via JSON ENUM lookup > > 15-10-2014 13:05:03.692 UTC Debug enumservice.cpp:233: Comparing first > > 3 numbers of 87100001 against prefix 871 > > 15-10-2014 13:05:03.692 UTC Debug enumservice.cpp:240: Match found > > 15-10-2014 13:05:03.692 UTC Info enumservice.cpp:216: Number 87100001 > > found, translated URI = sip:[email protected] > > 15-10-2014 13:05:03.692 UTC Debug scscfsproutlet.cpp:1234: Update > > request URI to sip:[email protected] > > 15-10-2014 13:05:03.692 UTC Info scscfsproutlet.cpp:1025: Routing to > > I-CSCF sip:ppsprout1.ims.prod.lan:5052;transport=TCP > > 15-10-2014 13:05:03.692 UTC Debug sproutletproxy.cpp:1137: Sproutlet > > send_request 0x7f77f0617aa0 > > 15-10-2014 13:05:03.692 UTC Verbose sproutletproxy.cpp:1162: > > scscf-0x7f77f05abf30 sending Request msg INVITE/cseq=1789968436 > > (tdta0x7f77f0617490) on fork 0 > > 15-10-2014 13:05:03.692 UTC Debug sproutletproxy.cpp:1478: Processing > > actions from sproutlet - 0 responses, 1 requests > > 15-10-2014 13:05:03.692 UTC Debug sproutletproxy.cpp:1513: Processing > > request 0x7f77f0617538, fork = 0 > > 15-10-2014 13:05:03.692 UTC Debug sproutletproxy.cpp:1631: > > scscf-0x7f77f05abf30 transmitting request on fork 0 > > 15-10-2014 13:05:03.692 UTC Debug sproutletproxy.cpp:1645: > > scscf-0x7f77f05abf30 store reference to non-ACK request Request msg > > INVITE/cseq=1789968436 (tdta0x7f77f0617490) on fork 0 > > 15-10-2014 13:05:03.693 UTC Debug sproutletproxy.cpp:1470: Removing > > message 0x7f77f0617aa0 => txdata 0x7f77f0617538 mapping > > 15-10-2014 13:05:03.693 UTC Debug sproutletproxy.cpp:110: Find target > > Sproutlet for request > > 15-10-2014 13:05:03.693 UTC Debug sproutletproxy.cpp:144: Found next > > routable URI: sip:ppsprout1.ims.prod.lan:5052;transport=TCP;lr > > 15-10-2014 13:05:03.693 UTC Debug sproutletproxy.cpp:174: No Sproutlet > > found using service name or host > > 15-10-2014 13:05:03.693 UTC Debug sproutletproxy.cpp:179: Find default > > service for port 5052 > > 15-10-2014 13:05:03.693 UTC Verbose sproutletproxy.cpp:977: Created > > Sproutlet icscf-0x7f77f0475e70 for Request msg INVITE/cseq=1789968436 > > (tdta0x7f77f0617490) > > 15-10-2014 13:05:03.693 UTC Info pjutils.cpp:1551: Cloning header! > > 140153110759848 > > 15-10-2014 13:05:03.693 UTC Debug sproutletproxy.cpp:1463: Adding > > message > > 0x7f77f061aa10 => txdata 0x7f77f061a4a8 mapping > > 15-10-2014 13:05:03.693 UTC Verbose sproutletproxy.cpp:1366: > > scscf-0x7f77f05abf30 received provisional response Response msg > > 100/INVITE/cseq=1789968436 (tdta0x7f77f061a400) on fork 0, state = > > Proceeding > > 15-10-2014 13:05:03.693 UTC Info scscfsproutlet.cpp:448: S-CSCF > > received response > > 15-10-2014 13:05:03.693 UTC Verbose sproutletproxy.cpp:1189: > > scscf-0x7f77f05abf30 sending Response msg 100/INVITE/cseq=1789968436 > > (tdta0x7f77f061a400) > > 15-10-2014 13:05:03.693 UTC Debug sproutletproxy.cpp:1478: Processing > > actions from sproutlet - 1 responses, 0 requests > > 15-10-2014 13:05:03.693 UTC Debug sproutletproxy.cpp:1553: Aggregating > > response with status code 100 > > 15-10-2014 13:05:03.693 UTC Debug sproutletproxy.cpp:1570: Discard > > 100/INVITE response (tdta0x7f77f061a400) > > 15-10-2014 13:05:03.693 UTC Debug sproutletproxy.cpp:1470: Removing > > message 0x7f77f061aa10 => txdata 0x7f77f061a4a8 mapping > > 15-10-2014 13:05:03.693 UTC Debug pjsip: tdta0x7f77f061 Destroying > > txdata Response msg 100/INVITE/cseq=1789968436 (tdta0x7f77f061a400) > > 15-10-2014 13:05:03.693 UTC Debug pjutils.cpp:686: Cloned > > tdta0x7f77f0617490 to tdta0x7f77f061a400 > > 15-10-2014 13:05:03.693 UTC Debug sproutletproxy.cpp:1038: Remove top > > Route header Route: <sip:ppsprout1.ims.prod.lan:5052;transport=TCP;lr> > > 15-10-2014 13:05:03.693 UTC Debug sproutletproxy.cpp:1463: Adding > > message > > 0x7f77f061aa10 => txdata 0x7f77f061a4a8 mapping > > 15-10-2014 13:05:03.693 UTC Verbose sproutletproxy.cpp:1337: > > icscf-0x7f77f0475e70 pass initial request Request msg > > INVITE/cseq=1789968436 (tdta0x7f77f061a400) to Sproutlet > > 15-10-2014 13:05:03.693 UTC Debug acr.cpp:1495: Create RalfACR for > > node type BGCF with role Terminating > > 15-10-2014 13:05:03.693 UTC Debug acr.cpp:48: Created ACR > > (0x7f77f0100680) > > 15-10-2014 13:05:03.693 UTC Debug acr.cpp:195: Created BGCF Ralf ACR > > 15-10-2014 13:05:03.693 UTC Debug acr.cpp:274: Set record type for > > I-CSCF, BGCF, IBCF, AS to EVENT_RECORD > > 15-10-2014 13:05:03.693 UTC Debug acr.cpp:1307: Found > > P-Charging-Vector header, store information > > 15-10-2014 13:05:03.693 UTC Debug icscfsproutlet.cpp:405: I-CSCF > > initialize transaction for non-REGISTER request > > 15-10-2014 13:05:03.693 UTC Debug icscfsproutlet.cpp:427: Terminating > > request > > 15-10-2014 13:05:03.693 UTC Debug icscfrouter.cpp:362: Perform LIR - > > impu sip:[email protected], originating false, auth_type None > > 15-10-2014 13:05:03.693 UTC Debug httpresolver.cpp:70: > > HttpResolver::resolve for host pphomestead1.ims.prod.lan, port 8888, > > family > > 2 > > 15-10-2014 13:05:03.693 UTC Debug baseresolver.cpp:511: Attempt to > > parse pphomestead1.ims.prod.lan as IP address > > 15-10-2014 13:05:03.694 UTC Debug dnscachedresolver.cpp:179: Pulling 1 > > records from cache for pphomestead1.ims.prod.lan A > > 15-10-2014 13:05:03.694 UTC Debug baseresolver.cpp:359: Found 1 A/AAAA > > records, randomizing > > 15-10-2014 13:05:03.694 UTC Debug baseresolver.cpp:501: > > 10.99.99.166:8888 transport 6 is not blacklisted > > 15-10-2014 13:05:03.694 UTC Debug baseresolver.cpp:380: Added a > > server, now have 1 of 5 > > 15-10-2014 13:05:03.694 UTC Debug baseresolver.cpp:418: Adding 0 > > servers from blacklist > > 15-10-2014 13:05:03.694 UTC Debug baseresolver.cpp:511: Attempt to > > parse > > 10.99.99.166 as IP address > > 15-10-2014 13:05:03.694 UTC Debug httpconnection.cpp:540: Sending HTTP > > request : > > http://pphomestead1.ims.prod.lan:8888/impu/sip%3A87100001%40ims.prod.l > > an/location > > (trying 10.99.99.166) > > 15-10-2014 13:05:03.700 UTC Debug httpconnection.cpp:553: Received > > HTTP response : > > {"result-code":2003,"mandatory-capabilities":[],"optional-capabilities > > ":[]} > > 15-10-2014 13:05:03.700 UTC Debug icscfrouter.cpp:208: HSS returned > > capabilities > > 15-10-2014 13:05:03.700 UTC Debug acr.cpp:638: Storing > > Server-Capabilities > > 15-10-2014 13:05:03.700 UTC Verbose acr.cpp:646: Sending BGCF Ralf ACR > > (0x7f77f0100680) > > 15-10-2014 13:05:03.700 UTC Debug acr.cpp:662: Building message > > 15-10-2014 13:05:03.700 UTC Debug acr.cpp:677: Adding peers meta-data, > > 0 ccfs, 0 ecfs > > 15-10-2014 13:05:03.700 UTC Debug acr.cpp:694: Building event > > 15-10-2014 13:05:03.700 UTC Debug acr.cpp:698: Adding > > Account-Record-Type AVP 1 > > 15-10-2014 13:05:03.700 UTC Debug acr.cpp:711: Adding > > Service-Information AVP group > > 15-10-2014 13:05:03.700 UTC Debug acr.cpp:732: Adding IMS-Information > > AVP group > > 15-10-2014 13:05:03.700 UTC Debug acr.cpp:736: Adding Event-Type AVP > > group > > 15-10-2014 13:05:03.700 UTC Debug acr.cpp:753: Adding 0 > > Calling-Party-Address AVPs > > 15-10-2014 13:05:03.700 UTC Debug acr.cpp:764: Adding > > Called-Party-Address AVP > > 15-10-2014 13:05:03.700 UTC Debug acr.cpp:805: Adding Time-Stamps AVP > > group > > 15-10-2014 13:05:03.700 UTC Debug acr.cpp:845: Adding > > Inter-Operator-Identifier AVP group > > 15-10-2014 13:05:03.700 UTC Debug acr.cpp:858: Adding 0 > > Transit-IOI-List AVPs > > 15-10-2014 13:05:03.700 UTC Debug acr.cpp:999: Adding 0 Reason-Header > > AVPs > > 15-10-2014 13:05:03.700 UTC Debug acr.cpp:1008: Adding 0 > > Access-Network-Information AVPs > > 15-10-2014 13:05:03.700 UTC Debug acr.cpp:1017: Adding From-Address > > AVP > > 15-10-2014 13:05:03.700 UTC Debug httpresolver.cpp:70: > > HttpResolver::resolve for host ppralf1.ims.prod.lan, port 10888, > > family 2 > > 15-10-2014 13:05:03.700 UTC Debug baseresolver.cpp:511: Attempt to > > parse ppralf1.ims.prod.lan as IP address > > 15-10-2014 13:05:03.700 UTC Debug dnscachedresolver.cpp:179: Pulling 1 > > records from cache for ppralf1.ims.prod.lan A > > 15-10-2014 13:05:03.700 UTC Debug baseresolver.cpp:359: Found 1 A/AAAA > > records, randomizing > > 15-10-2014 13:05:03.700 UTC Debug baseresolver.cpp:501: > > 10.99.99.164:10888 transport 6 is not blacklisted > > 15-10-2014 13:05:03.700 UTC Debug baseresolver.cpp:380: Added a > > server, now have 1 of 5 > > 15-10-2014 13:05:03.700 UTC Debug baseresolver.cpp:418: Adding 0 > > servers from blacklist > > 15-10-2014 13:05:03.701 UTC Debug httpconnection.cpp:540: Sending HTTP > > request : > > http://ppralf1.ims.prod.lan:10888/call-id/100929623_64943439%4010.20.7 > > .34 (trying 10.99.99.164) on new connection > > 15-10-2014 13:05:03.702 UTC Debug httpconnection.cpp:833: Received > > header http/1.1200ok with value > > 15-10-2014 13:05:03.702 UTC Debug httpconnection.cpp:833: Received > > header content-length with value 0 > > 15-10-2014 13:05:03.702 UTC Debug httpconnection.cpp:833: Received > > header with value > > 15-10-2014 13:05:03.702 UTC Debug httpconnection.cpp:553: Received > > HTTP response : > > 15-10-2014 13:05:03.702 UTC Warning scscfselector.cpp:165: There are > > no configured S-CSCFs > > 15-10-2014 13:05:03.702 UTC Debug icscfrouter.cpp:122: SCSCF selected: > > 15-10-2014 13:05:03.702 UTC Info pjutils.cpp:1551: Cloning header! > > 140153110771920 > > 15-10-2014 13:05:03.702 UTC Debug sproutletproxy.cpp:1463: Adding > > message > > 0x7f77f061d980 => txdata 0x7f77f061d418 mapping > > 15-10-2014 13:05:03.702 UTC Verbose sproutletproxy.cpp:1189: > > icscf-0x7f77f0475e70 sending Response msg 600/INVITE/cseq=1789968436 > > (tdta0x7f77f061d370) > > 15-10-2014 13:05:03.702 UTC Debug sproutletproxy.cpp:1470: Removing > > message 0x7f77f061aa10 => txdata 0x7f77f061a4a8 mapping > > 15-10-2014 13:05:03.702 UTC Debug sproutletproxy.cpp:1266: Free > > message > > tdta0x7f77f061a400 > > 15-10-2014 13:05:03.702 UTC Debug pjsip: tdta0x7f77f061 Destroying > > txdata Request msg INVITE/cseq=1789968436 (tdta0x7f77f061a400) > > 15-10-2014 13:05:03.702 UTC Debug sproutletproxy.cpp:1478: Processing > > actions from sproutlet - 1 responses, 0 requests > > 15-10-2014 13:05:03.702 UTC Debug sproutletproxy.cpp:1553: Aggregating > > response with status code 600 > > 15-10-2014 13:05:03.702 UTC Debug sproutletproxy.cpp:1603: > > 3xx/4xx/5xx/6xx response > > 15-10-2014 13:05:03.702 UTC Debug sproutletproxy.cpp:1607: Best > > 3xx/4xx/5xx/6xx response so far > > 15-10-2014 13:05:03.702 UTC Debug sproutletproxy.cpp:1500: All UAC > > responded > > 15-10-2014 13:05:03.702 UTC Debug sproutletproxy.cpp:1470: Removing > > message 0x7f77f061d980 => txdata 0x7f77f061d418 mapping > > 15-10-2014 13:05:03.702 UTC Debug sproutletproxy.cpp:1463: Adding > > message > > 0x7f77f061d980 => txdata 0x7f77f061d418 mapping > > 15-10-2014 13:05:03.702 UTC Verbose sproutletproxy.cpp:1377: > > scscf-0x7f77f05abf30 received final response Response msg > > 600/INVITE/cseq=1789968436 (tdta0x7f77f061d370) on fork 0, state = > > Terminated > > 15-10-2014 13:05:03.703 UTC Info scscfsproutlet.cpp:448: S-CSCF > > received response > > 15-10-2014 13:05:03.703 UTC Debug acr.cpp:1307: Found > > P-Charging-Vector header, store information > > 15-10-2014 13:05:03.703 UTC Verbose sproutletproxy.cpp:1189: > > scscf-0x7f77f05abf30 sending Response msg 600/INVITE/cseq=1789968436 > > (tdta0x7f77f061d370) > > 15-10-2014 13:05:03.703 UTC Debug sproutletproxy.cpp:1478: Processing > > actions from sproutlet - 1 responses, 0 requests > > 15-10-2014 13:05:03.703 UTC Debug sproutletproxy.cpp:1553: Aggregating > > response with status code 600 > > 15-10-2014 13:05:03.703 UTC Debug sproutletproxy.cpp:1603: > > 3xx/4xx/5xx/6xx response > > 15-10-2014 13:05:03.703 UTC Debug sproutletproxy.cpp:1607: Best > > 3xx/4xx/5xx/6xx response so far > > 15-10-2014 13:05:03.703 UTC Debug sproutletproxy.cpp:1500: All UAC > > responded > > 15-10-2014 13:05:03.703 UTC Debug acr.cpp:598: Failed to start > > session, change record type to EVENT_RECORD > > 15-10-2014 13:05:03.703 UTC Debug sproutletproxy.cpp:1470: Removing > > message 0x7f77f061d980 => txdata 0x7f77f061d418 mapping > > 15-10-2014 13:05:03.703 UTC Debug sproutletproxy.cpp:1463: Adding > > message > > 0x7f77f061d980 => txdata 0x7f77f061d418 mapping > > 15-10-2014 13:05:03.703 UTC Verbose sproutletproxy.cpp:1377: > > mmtel-0x7f77f0253110 received final response Response msg > > 600/INVITE/cseq=1789968436 (tdta0x7f77f061d370) on fork 0, state = > > Terminated > > 15-10-2014 13:05:03.703 UTC Verbose sproutletproxy.cpp:1189: > > mmtel-0x7f77f0253110 sending Response msg 600/INVITE/cseq=1789968436 > > (tdta0x7f77f061d370) > > 15-10-2014 13:05:03.703 UTC Debug sproutletproxy.cpp:1478: Processing > > actions from sproutlet - 1 responses, 0 requests > > 15-10-2014 13:05:03.703 UTC Debug sproutletproxy.cpp:1553: Aggregating > > response with status code 600 > > 15-10-2014 13:05:03.703 UTC Debug sproutletproxy.cpp:1603: > > 3xx/4xx/5xx/6xx response > > 15-10-2014 13:05:03.703 UTC Debug sproutletproxy.cpp:1607: Best > > 3xx/4xx/5xx/6xx response so far > > 15-10-2014 13:05:03.703 UTC Debug sproutletproxy.cpp:1500: All UAC > > responded > > 15-10-2014 13:05:03.703 UTC Debug sproutletproxy.cpp:1470: Removing > > message 0x7f77f061d980 => txdata 0x7f77f061d418 mapping > > 15-10-2014 13:05:03.703 UTC Debug sproutletproxy.cpp:1463: Adding > > message > > 0x7f77f061d980 => txdata 0x7f77f061d418 mapping > > 15-10-2014 13:05:03.703 UTC Verbose sproutletproxy.cpp:1377: > > scscf-0x7f77f01d3030 received final response Response msg > > 600/INVITE/cseq=1789968436 (tdta0x7f77f061d370) on fork 0, state = > > Terminated > > 15-10-2014 13:05:03.703 UTC Info scscfsproutlet.cpp:448: S-CSCF > > received response > > 15-10-2014 13:05:03.703 UTC Verbose sproutletproxy.cpp:1189: > > scscf-0x7f77f01d3030 sending Response msg 600/INVITE/cseq=1789968436 > > (tdta0x7f77f061d370) > > 15-10-2014 13:05:03.703 UTC Debug sproutletproxy.cpp:1478: Processing > > actions from sproutlet - 1 responses, 0 requests > > 15-10-2014 13:05:03.703 UTC Debug sproutletproxy.cpp:1553: Aggregating > > response with status code 600 > > 15-10-2014 13:05:03.703 UTC Debug sproutletproxy.cpp:1603: > > 3xx/4xx/5xx/6xx response > > 15-10-2014 13:05:03.703 UTC Debug sproutletproxy.cpp:1607: Best > > 3xx/4xx/5xx/6xx response so far > > 15-10-2014 13:05:03.703 UTC Debug sproutletproxy.cpp:1500: All UAC > > responded > > 15-10-2014 13:05:03.703 UTC Debug sproutletproxy.cpp:1470: Removing > > message 0x7f77f061d980 => txdata 0x7f77f061d418 mapping > > 15-10-2014 13:05:03.703 UTC Debug pjsip: tsx0x7f77f05a6 Sending > > Response msg 600/INVITE/cseq=1789968436 (tdta0x7f77f061d370) in state > > Proceeding > > 15-10-2014 13:05:03.703 UTC Debug pjsip: tdta0x7f77f055 Destroying > > txdata Response msg 100/INVITE/cseq=1789968436 (tdta0x7f77f055cfe0) > > 15-10-2014 13:05:03.704 UTC Verbose stack.cpp:249: TX 593 bytes > > Response msg 600/INVITE/cseq=1789968436 (tdta0x7f77f061d370) to UDP > > 10.20.7.34:5060 > > : > > --start msg-- > > > > SIP/2.0 600 Busy Everywhere > > Via: SIP/2.0/UDP 195.78.8.215:5060 > > ;received=10.20.7.34;branch=z9hG4bK04B09231bee4f8f50f3 > > Record-Route: > > <sip:ppsprout1.ims.prod.lan:5054;transport=TCP;lr;service=scscf;billin > > g-role=charge-orig> > > Call-ID: [email protected] > > From: "Ru" <sip:[email protected];pstn-params=9084818088 > > ;cpc=ordinary>;tag=gK0407d837 > > To: <sip:[email protected]>;tag=z9hG4bK04B09231bee4f8f50f3 > > CSeq: 1789968436 INVITE > > P-Charging-Vector: > > icid-value="c0d4c060-369a-1032-00-00-00-10-6b-03-58-67";orig-ioi=ims.p > > rod.lan;icid-generated-at=10.20.7.34 > > Content-Length: 0 > > > > > _______________________________________________ > Clearwater mailing list > [email protected] > http://lists.projectclearwater.org/listinfo/clearwater > _______________________________________________ Clearwater mailing list [email protected] http://lists.projectclearwater.org/listinfo/clearwater
