Robert, Thank you for opening a issue for tracking this and confirming that CNAMEs are not supported. Since we switched to A records things are working fine so I don’t have any immediate need for a fix and I agree that a warning message in the future may make it clearer if someone else runs into the same issue.
Thanks! Matt On 12/30/14, 5:20 AM, "Robert Day" <[email protected]> wrote: >Hi Matthew, > >Thanks for raising this, and for figuring out that CNAME records cause >it! I think there are two issues here - firstly that Clearwater's DNS >resolver doesn't support CNAME records, and secondly that if we get a >CNAME record, we misclassify it as an AAAA record and read a spurious >IPv6 address (instead of ignoring it and logging a warning that CNAME is >unsupported, which I think would be a better stopgap until full CNAME >support gets implemented). > >I've raised https://github.com/Metaswitch/cpp-common/issues/224 to track >the issue - feel free to watch it for updates. It sounds like you've got >things working by switching from CNAME records to A records, though, so >you don't need an immediate fix - is that right? > >Thanks again, >Rob > > >-----Original Message----- >From: [email protected] >[mailto:[email protected]] On Behalf Of >Matthew M. Gamble >Sent: 29 December 2014 21:10 >To: Matthew M. Gamble; [email protected] >Subject: Re: [Clearwater] Bono / Sprout communication issue on manual >install > >Following up on my own question, the issue was DNS related. > >Apparently the DNS stack does not like the CNAMEs - since we only had one >of each node, I setup the DNS as follows (example Ips) > >sprout-01 IN A 3.0.0.1 > >sprout IN CNAME sprout-01 > > >The name resolves fine, but bono wasn¹t working. When I changed the DNS >to have sprout.<zone> point to an IP instead of a CNAME things started to >work again. The same is true for other inter-node communication - it >appears nothing likes CNAMEs - is there a reason for that? > > > >On 12/29/14, 3:03 PM, "Matthew M. Gamble" <[email protected]> wrote: > >>I¹m working on a manual install in our lab and Bono is having issues >>communicating to sprout when a client sends a register request (see >>below). The error appears to be when bono attempts to send the request >>to sprout, when this error is generated: >>29-12-2014 19:54:53.416 UTC Warning pjsip: tsx0x7f9fa4005 Failed to >>send Request msg REGISTER/cseq=1 (tdta0x7f9fa4003950)! err=171060 >>(Unsupported transport (PJSIP_EUNSUPTRANSPORT)). >> >>The really confusing thing is prior to that bono appears to somehow >>grab an IPv6 address (5036:a4:9f7f:0:3500:::5054) for sprout however >>the internal DNS servers only have IPv4 addresses. I¹ve included the >>log snippit of the register request please let me know what else I >>need to include to help troubleshoot this. >> >>Thanks! >> >> >> >>Full log: >> >>--start msg-- >> >>REGISTER sip:ims.rovvr.ca SIP/2.0 >>Via: SIP/2.0/TCP >>172.16.1.122:37498;branch=z9hG4bK-d8754z-7975774666b13031-1---d8754z-;r >>por >>t >>Max-Forwards: 70 >>Contact: >><sip:[email protected]:37498;rinstance=1cade11b5d526682;transport >>=tc >>p> >>To: "6474787201"<sip:[email protected]> >>From: "6474787201"<sip:[email protected]>;tag=2055be16 >>Call-ID: MjY5NjUwNzIxNzY3OWU4NmNjNDhlNzAxNzA2ODMwNWU >>CSeq: 1 REGISTER >>Expires: 3600 >>Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, >>SUBSCRIBE, INFO >>User-Agent: Bria 3 release 3.5.5 stamp 71243 >>Content-Length: 0 >> >> >>--end msg-- >>29-12-2014 19:54:53.410 UTC Debug stack.cpp:467: Queuing cloned >>received message 0x7f9fa004eb68 for worker threads >>29-12-2014 19:54:53.410 UTC Debug statistic.cpp:103: Send new value for >>statistic queue_size, size 5 >>29-12-2014 19:54:53.410 UTC Debug zmq_lvc.cpp:172: Update to queue_size >>statistic >>29-12-2014 19:54:53.410 UTC Debug zmq_lvc.cpp:256: Clearing message >>cache for 0x7f9fc00335b0 >>29-12-2014 19:54:53.410 UTC Debug stack.cpp:204: Worker thread dequeue >>message 0x7f9fa004eb68 >>29-12-2014 19:54:53.410 UTC Debug pjsip: sip_endpoint.c Distributing >>rdata to modules: Request msg REGISTER/cseq=1 (rdata0x7f9fa004eb68) >>29-12-2014 19:54:53.410 UTC Debug stateful_proxy.cpp:258: Proxy RX >>request >>29-12-2014 19:54:53.411 UTC Debug pjutils.cpp:676: Cloned Request msg >>REGISTER/cseq=1 (rdata0x7f9fa004eb68) to tdta0x7f9fa4007e70 >>29-12-2014 19:54:53.411 UTC Debug stateful_proxy.cpp:951: Request >>received on non-trusted port 5060 >>29-12-2014 19:54:53.411 UTC Debug stateful_proxy.cpp:1223: Perform >>access proxy routing for REGISTER request >>29-12-2014 19:54:53.411 UTC Debug stateful_proxy.cpp:1260: Message >>requires outbound support >>29-12-2014 19:54:53.411 UTC Debug flowtable.cpp:91: Find or create flow >>for transport tcps0x7f9fa0003868 (2), remote address >>216.235.11.118:62955 >>29-12-2014 19:54:53.411 UTC Debug flowtable.cpp:296: Added transport >>listener for flow 0x7f9fa40029e0 >>29-12-2014 19:54:53.411 UTC Debug flowtable.cpp:106: Added flow record >>0x7f9fa40029e0 >>29-12-2014 19:54:53.411 UTC Debug flowtable.cpp:233: Reporting current >>flow count: 1 >>29-12-2014 19:54:53.411 UTC Debug flowtable.cpp:602: Dialog count now 2 >>for flow >>29-12-2014 19:54:53.411 UTC Debug stateful_proxy.cpp:1272: Found or >>created flow data record, token = 0OvM00p+qt >>29-12-2014 19:54:53.411 UTC Debug flowtable.cpp:619: Dialog count now 1 >>for flow >>29-12-2014 19:54:53.412 UTC Debug stateful_proxy.cpp:1181: Mark >>originating >>29-12-2014 19:54:53.412 UTC Info stateful_proxy.cpp:1202: Route request >>to upstream proxy sip:sprout.ims.rovvr.ca:5054;transport=TCP;lr;orig >>29-12-2014 19:54:53.412 UTC Debug acr.cpp:1706: Create RalfACR for node >>type P-CSCF with role Originating >>29-12-2014 19:54:53.412 UTC Debug acr.cpp:48: Created ACR >>(0x7f9fa40031e0) >>29-12-2014 19:54:53.412 UTC Debug acr.cpp:166: Created P-CSCF Ralf ACR >>29-12-2014 19:54:53.412 UTC Debug acr.cpp:205: Set record type for >>P/S-CSCF >>29-12-2014 19:54:53.412 UTC Debug acr.cpp:213: Non-dialog message => >>EVENT_RECORD >>29-12-2014 19:54:53.412 UTC Debug acr.cpp:1434: Stored 0 subscription >>identifiers >>29-12-2014 19:54:53.412 UTC Debug stateful_proxy.cpp:594: Trust mode >>INBOUND_EDGE_CLIENT(,-rsp,-pch), serving state None >>29-12-2014 19:54:53.412 UTC Debug pjsip: tsx0x7f9fa4009 Transaction >>created for Request msg REGISTER/cseq=1 (rdata0x7f9fa004eb68) >>29-12-2014 19:54:53.412 UTC Debug stateful_proxy.cpp:2245: >>UASTransaction constructor (0x7f9fa40098a0) >>29-12-2014 19:54:53.413 UTC Debug stateful_proxy.cpp:2246: ACR >>(0x7f9fa40031e0) >>29-12-2014 19:54:53.413 UTC Debug pjsip: tsx0x7f9fa4009 Incoming >>Request msg REGISTER/cseq=1 (rdata0x7f9fa004eb68) in state Null >>29-12-2014 19:54:53.413 UTC Debug pjsip: tsx0x7f9fa4009 State changed >>from Null to Trying, event=RX_MSG >>29-12-2014 19:54:53.413 UTC Debug stateful_proxy.cpp:366: >>tsx0x7f9fa4009138 - tu_on_tsx_state UAS, TSX_STATE RX_MSG state=Trying >>29-12-2014 19:54:53.413 UTC Debug pjsip: endpoint Response msg >>408/REGISTER/cseq=1 (tdta0x7f9fa4001890) created >>29-12-2014 19:54:53.413 UTC Debug stateful_proxy.cpp:3692: Report SAS >>start marker - trail (1d) >>29-12-2014 19:54:53.413 UTC Debug trustboundary.cpp:67: Add P-Charging >>headers >>29-12-2014 19:54:53.413 UTC Debug stateful_proxy.cpp:3781: Allocating >>transaction and data for target 0 >>29-12-2014 19:54:53.413 UTC Debug pjsip: tsx0x7f9fa4005 Transaction >>created for Request msg REGISTER/cseq=1 (tdta0x7f9fa4003950) >>29-12-2014 19:54:53.413 UTC Debug stateful_proxy.cpp:3802: Adding trail >>identifier 29 to UAC transaction >>29-12-2014 19:54:53.414 UTC Debug stateful_proxy.cpp:3821: Updating >>request URI and route for target 0 >>29-12-2014 19:54:53.414 UTC Debug stateful_proxy.cpp:4187: Stripping >>loose routes from proxied message >>29-12-2014 19:54:53.414 UTC Debug stateful_proxy.cpp:4217: Adding a >>Route header to sip:sprout.ims.rovvr.ca:5054;transport=TCP >>29-12-2014 19:54:53.414 UTC Debug stateful_proxy.cpp:4255: Resolve next >>hop destination >>29-12-2014 19:54:53.414 UTC Debug pjutils.cpp:505: Next hop node is >>encoded in top route header >>29-12-2014 19:54:53.414 UTC Debug sipresolver.cpp:85: >>SIPResolver::resolve for name sprout.ims.rovvr.ca, port 5054, transport >>6, family 2 >>29-12-2014 19:54:53.414 UTC Debug baseresolver.cpp:511: Attempt to >>parse sprout.ims.rovvr.ca as IP address >>29-12-2014 19:54:53.414 UTC Debug sipresolver.cpp:127: Port is >>specified >>29-12-2014 19:54:53.414 UTC Debug sipresolver.cpp:295: Perform A/AAAA >>record lookup only, name = sprout.ims.rovvr.ca >>29-12-2014 19:54:53.414 UTC Debug statistic.cpp:103: Send new value for >>statistic client_count, size 1 >>29-12-2014 19:54:53.414 UTC Debug zmq_lvc.cpp:172: Update to >>client_count statistic >>29-12-2014 19:54:53.415 UTC Debug zmq_lvc.cpp:256: Clearing message >>cache for 0x7f9fc00008c0 >>29-12-2014 19:54:53.415 UTC Debug statistic.cpp:103: Send new value for >>statistic incoming_requests, size 1 >>29-12-2014 19:54:53.415 UTC Debug zmq_lvc.cpp:172: Update to >>incoming_requests statistic >>29-12-2014 19:54:53.415 UTC Debug zmq_lvc.cpp:256: Clearing message >>cache for 0x7f9fc002a270 >>29-12-2014 19:54:53.415 UTC Debug dnscachedresolver.cpp:179: Pulling 1 >>records from cache for sprout.ims.rovvr.ca A >>29-12-2014 19:54:53.416 UTC Debug baseresolver.cpp:359: Found 1 A/AAAA >>records, randomizing >>29-12-2014 19:54:53.416 UTC Debug baseresolver.cpp:501: >>5036:a4:9f7f:0:3500:::5054 transport 6 is not blacklisted >>29-12-2014 19:54:53.416 UTC Debug baseresolver.cpp:380: Added a server, >>now have 1 of 5 >>29-12-2014 19:54:53.416 UTC Debug baseresolver.cpp:418: Adding 0 >>servers from blacklist >>29-12-2014 19:54:53.416 UTC Info pjutils.cpp:940: Resolved destination >>URI sip:sprout.ims.rovvr.ca:5054;transport=TCP;lr;orig to 1 servers >>29-12-2014 19:54:53.416 UTC Debug stateful_proxy.cpp:4293: Sending >>request for sip:ims.rovvr.ca >>29-12-2014 19:54:53.416 UTC Debug pjsip: tsx0x7f9fa4005 Sending Request >>msg REGISTER/cseq=1 (tdta0x7f9fa4003950) in state Null >>29-12-2014 19:54:53.416 UTC Debug pjsip: endpoint Request msg >>REGISTER/cseq=1 (tdta0x7f9fa4003950): skipping target resolution >>because address is already set >>29-12-2014 19:54:53.416 UTC Warning pjsip: tsx0x7f9fa4005 Failed to >>send Request msg REGISTER/cseq=1 (tdta0x7f9fa4003950)! err=171060 >>(Unsupported transport (PJSIP_EUNSUPTRANSPORT)) >>29-12-2014 19:54:53.416 UTC Debug pjsip: tsx0x7f9fa4005 State changed >>from Null to Terminated, event=TRANSPORT_ERROR >>29-12-2014 19:54:53.416 UTC Debug stateful_proxy.cpp:366: >>tsx0x7f9fa40059b8 - tu_on_tsx_state UAC, TSX_STATE TRANSPORT_ERROR >>state=Terminated >>29-12-2014 19:54:53.416 UTC Debug stateful_proxy.cpp:4400: >>tsx0x7f9fa40059b8 - uac_data = 0x7f9fa4009c40, uas_data = >>0x7f9fa40098a0 >>29-12-2014 19:54:53.416 UTC Debug stateful_proxy.cpp:4419: Failed to >>connected to server, so add to blacklist >>29-12-2014 19:54:53.416 UTC Debug baseresolver.cpp:471: Add >>5036:a4:9f7f:0:3500:::5054 transport 6 to blacklist for 30 seconds >>29-12-2014 19:54:53.416 UTC Debug stateful_proxy.cpp:4461: >>tsx0x7f9fa40059b8 - UAC tsx terminated while still connected to UAS tsx >>29-12-2014 19:54:53.416 UTC Debug stateful_proxy.cpp:4464: Timeout or >>transport error >>29-12-2014 19:54:53.416 UTC Debug stateful_proxy.cpp:3440: >>tsx0x7f9fa40059b8 - Not forked request >>29-12-2014 19:54:53.416 UTC Debug pjsip: tsx0x7f9fa4009 Sending >>Response msg 408/REGISTER/cseq=1 (tdta0x7f9fa4001890) in state Trying >>29-12-2014 19:54:53.416 UTC Verbose stack.cpp:257: TX 406 bytes >>Response msg 408/REGISTER/cseq=1 (tdta0x7f9fa4001890) to TCP >>216.235.11.118:62955: >>_______________________________________________ >>Clearwater mailing list >>[email protected] >>http://lists.projectclearwater.org/listinfo/clearwater > >_______________________________________________ >Clearwater mailing list >[email protected] >http://lists.projectclearwater.org/listinfo/clearwater _______________________________________________ Clearwater mailing list [email protected] http://lists.projectclearwater.org/listinfo/clearwater
