Thanks Stefan for the quick reply. Tried with enable_rtprelay=yes Still no audio. Attaching the log (with log level 3). Any help will be highly appreciated.
Regards Gary ----- Original Message ----- From: Stefan Sayer Sent: 04/08/14 05:09 PM To: Gary Nyquist, [email protected] Subject: Re: [Sems] SEMS as a TransCoder Hi Gary, o Gary Nyquist on 04/08/2014 10:16 PM: > Hello Users, > > I am trying to configure the SEMS as a transcoder. > One side can do SILK only. > The other side can do PCMU only. > > I am using the sbc profile. > For calls originating from SILK side, the profile looks like this: > ###################################### > enable_rtprelay=no I'd start with setting this to enable_rtprelay=yes and if it doesn't help I'd set log_level=3 and check the debug log. Stefan > rtprelay_force_symmetric_rtp=yes > transcoder_codecs=silk,pcmu > callee_codeccaps=pcmu > enable_transcoder=always > prefer_existing_codecs = no > prefer_existing_codecs_aleg = no > codec_preference = pcmu > prefer_transcoding_for_codecs = pcmu > #codec_preference_aleg = silk > #prefer_transcoding_for_codecs_aleg = silk > ###################################### > > The signaling works fine. > But there is no audio; i.e. no transcoding... > Can anyone help me in pointing out the mistake? > Thank you in advance. > > Best Regards > Gary > > > > _______________________________________________ > Sems mailing list > [email protected] > http://lists.iptel.org/mailman/listinfo/sems >
INVITE sip:[email protected] SIP/2.0 Record-Route: <sip:100.1.2.3:5060;lr;ftag=scCZp~6wH100.1.2.3:5060;vst=AAAAAAEIC3NcXFtbRl9JGyNaWS44NC4xMDQuODM-;did=2a8.33e4889> Via: SIP/2.0/UDP 100.1.2.3:5060;branch=z9hG4bK22d2.87f26873.0 Via: SIP/2.0/UDP 192.168.1.114:50748;received=75.134.217.208;branch=z9hG4bK.yKynQsfdo;rport=50748 From: <sip:[email protected]>;tag=scCZp~6wH To: sip:[email protected] CSeq: 21 INVITE Call-ID: 8a5gsBas9x Max-Forwards: 69 Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO Content-Type: application/sdp Content-Length: 152 User-Agent: LinphoneIPhone/2.1.2 (belle-sip/1.2.4) Contact: <sip:[email protected]:50748>;+sip.instance="<urn:uuid:778a6469-472c-45b6-a933-fdfab54ad856>" v=0 o=1098765431 855 2527 IN IP4 75.134.217.208 s=Talk c=IN IP4 75.134.217.208 b=AS:512 t=0 0 m=audio 7076 RTP/AVP 119 a=rtpmap:119 SILK/16000 --++-- [#7fe7ebd4f700/25592] [parse_sip_uri, parse_uri.cpp:328] DEBUG: Converted URI port () to int (5060) [#7fe7ebd4f700/25592] [parse_via_params, parse_via.cpp:525] DEBUG: parsed branch: z9hG4bK22d2.87f26873.0 [#7fe7ebd4f700/25592] [parse_via_params, parse_via.cpp:548] DEBUG: has_rport: 0 [#7fe7ebd4f700/25592] [match_request, trans_table.cpp:68] DEBUG: Matching INVITE request [#7fe7ebd4f700/25592] [parse_sip_uri, parse_uri.cpp:328] DEBUG: Converted URI port (50748) to int (50748) [#7fe7ebd4f700/25592] [parse, AmMimeBody.cpp:566] DEBUG: saving single-part body [#7fe7ebd4f700/25592] [sip_msg2am_request, SipCtrlInterface.cpp:447] DEBUG: MIME body successfully parsed [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:570] DEBUG: Received new request from <100.1.2.3:5060> on intf #0 [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:574] DEBUG: req.method = <INVITE> [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:577] DEBUG: req.r_uri = <sip:[email protected]> [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:578] DEBUG: req.from_uri = <sip:[email protected]:50748> [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:579] DEBUG: req.from = <<sip:[email protected]>> [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:580] DEBUG: req.to = <sip:[email protected]> [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:581] DEBUG: req.callid = <8a5gsBas9x> [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:582] DEBUG: req.from_tag = <scCZp~6wH> [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:583] DEBUG: req.to_tag = <> [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:584] DEBUG: cseq = <21> [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:585] DEBUG: req.route = <<sip:100.1.2.3:5060;lr;ftag=scCZp~6wH100.1.2.3:5060;vst=AAAAAAEIC3NcXFtbRl9JGyNaWS44NC4xMDQuODM-;did=2a8.33e4889>> [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:586] DEBUG: hdrs = <Max-Forwards: 69 Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO User-Agent: LinphoneIPhone/2.1.2 (belle-sip/1.2.4) > [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:587] DEBUG: body-ct = <application/sdp> [#7fe7ebd4f700/25592] [handleSipMsg, AmSipDispatcher.cpp:88] DEBUG: method: `INVITE' [6]. [#7fe7ebd4f700/25592] [replaceParameters, ParamReplacer.cpp:422] DEBUG: active_profile pattern replace: '$si' -> '100.1.2.3' [#7fe7ebd4f700/25592] [run_regex_mapping, AmUtils.cpp:1106] DEBUG: match of '100.1.2.3' to amtel_outbound [#7fe7ebd4f700/25592] [replaceParameters, ParamReplacer.cpp:339] DEBUG: matched regex mapping '100.1.2.3' (orig '$si) in 'src_ipmap' [#7fe7ebd4f700/25592] [replaceParameters, ParamReplacer.cpp:422] DEBUG: active_profile pattern replace: '$M($si=>src_ipmap)' -> 'amtel_outbound' [#7fe7ebd4f700/25592] [onInvite, SBC.cpp:525] DEBUG: using call profile 'amtel_outbound' (from matching active_profile rule '$M($si=>src_ipmap)') [#7fe7ebd4f700/25592] [setRel100State, AmSipDialog.cpp:278] DEBUG: setting 100rel state for '' to 3 [#7fe7ebd4f700/25592] [setLocalTag, AmSession.cpp:222] DEBUG: AmSession::setLocalTag() - session id set to 3DF945DE-53446EFA0005096A-EBD4F700 [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:593] DEBUG: ^^ M [8a5gsBas9x|] Ru SIP request INVITE handled ^^ [#7fe7eb94b700/25597] [_start, AmThread.cpp:65] DEBUG: Thread 140634066564864 is starting. [#7fe7eb94b700/25597] [run, AmSession.cpp:260] DEBUG: startup session [#7fe7eb94b700/25597] [run, AmSession.cpp:264] DEBUG: running session event loop [#7fe7eb94b700/25597] [processingCycle, AmSession.cpp:368] DEBUG: vv S [|3DF945DE-53446EFA0005096A-EBD4F700] Disconnected, running, 0 UACTransPending vv [#7fe7eb94b700/25597] [process, AmSession.cpp:713] DEBUG: AmSession processing event [#7fe7eb94b700/25597] [onRxRequest, AmSipDialog.cpp:132] DEBUG: AmSipDialog::onRxRequest(req = INVITE) [#7fe7eb94b700/25597] [onRxSdp, AmOfferAnswer.cpp:214] DEBUG: entering onRxSdp(), oa_state=None [#7fe7eb94b700/25597] [parse_sdp_line_ex, AmSdp.cpp:484] DEBUG: parsing SDP message... [#7fe7eb94b700/25597] [parse_sdp_connection, AmSdp.cpp:705] DEBUG: SDP: got session level connection: IP4 75.134.217.208 [#7fe7eb94b700/25597] [parse_sdp_media, AmSdp.cpp:848] DEBUG: SDP: got media: port 7076, payloads: 119 0 [#7fe7eb94b700/25597] [setState, AmOfferAnswer.cpp:69] DEBUG: setting SIP dialog O/A status: None->OfferRecved [#7fe7eb94b700/25597] [onRxSdp, AmOfferAnswer.cpp:257] DEBUG: oa_state: None -> OfferRecved [#7fe7eb94b700/25597] [onSipRequest, AmSession.cpp:763] DEBUG: onSipRequest: method = INVITE [#7fe7eb94b700/25597] [onInvite, SBC.cpp:1009] DEBUG: processing initial INVITE sip:[email protected] [#7fe7eb94b700/25597] [reply, AmSipDialog.cpp:749] DEBUG: reply: transaction found! [#7fe7eb94b700/25597] [send_reply, trans_layer.cpp:260] DEBUG: reply_len = 614 [#7fe7eb94b700/25597] [is_opt_set, transport.cpp:60] DEBUG: trsp_socket::socket_options = 0x0 [#7fe7eb94b700/25597] [send_reply, trans_layer.cpp:438] DEBUG: Sending to 100.1.2.3:5060 <SIP/2.0 100 Connecting Record-Route: <sip:54.84.1...> [#7fe7eb94b700/25597] [send, transport.cpp:109] DEBUG: send msg --++-- SIP/2.0 100 Connecting Record-Route: <sip:100.1.2.3:5060;lr;ftag=scCZp~6wH100.1.2.3:5060;vst=AAAAAAEIC3NcXFtbRl9JGyNaWS44NC4xMDQuODM-;did=2a8.33e4889> Via: SIP/2.0/UDP 100.1.2.3:5060;branch=z9hG4bK22d2.87f26873.0 Via: SIP/2.0/UDP 192.168.1.114:50748;received=75.134.217.208;branch=z9hG4bK.yKynQsfdo;rport=50748 From: <sip:[email protected]>;tag=scCZp~6wH To: sip:[email protected];tag=3DF945DE-53446EFA0005096A-EBD4F700 CSeq: 21 INVITE Call-ID: 8a5gsBas9x Server: Sip Express Media Server (1.5.0 (x86_64/linux)) Contact: <sip:[email protected]:5060> Content-Length: 0 --++-- [#7fe7eb94b700/25597] [update_uas_reply, trans_layer.cpp:1586] DEBUG: update_uas_reply(t=0x7fe7d80017c0) [#7fe7eb94b700/25597] [replaceParameters, ParamReplacer.cpp:422] DEBUG: ruri pattern replace: 'sip:[email protected]' -> 'sip:[email protected]' [#7fe7eb94b700/25597] [evaluate, SBCCallProfile.cpp:655] DEBUG: ruri = 'sip:[email protected]' [#7fe7eb94b700/25597] [evaluate, SBCCallProfile.cpp:1044] DEBUG: transcoder_mode_str = 'always' [#7fe7eb94b700/25597] [evaluate, SBCCallProfile.cpp:1045] DEBUG: audio_codecs_str = 'silk,pcmu' [#7fe7eb94b700/25597] [evaluate, SBCCallProfile.cpp:1046] DEBUG: audio_codecs_norelay_str = 'pcmu' [#7fe7eb94b700/25597] [evaluate, SBCCallProfile.cpp:1048] DEBUG: callee_codec_capabilities_str = 'pcmu' [#7fe7eb94b700/25597] [evaluate, SBCCallProfile.cpp:1074] DEBUG: transcoder is enabled [#7fe7eb94b700/25597] [evaluate, SBCCallProfile.cpp:674] DEBUG: force_symmetric_rtp = 'yes' [#7fe7eb94b700/25597] [evaluate, SBCCallProfile.cpp:675] DEBUG: force_symmetric_rtp = 'yes' [#7fe7eb94b700/25597] [evaluate, SBCCallProfile.cpp:932] DEBUG: aleg_prefer_existing_payloads_str = 'no' [#7fe7eb94b700/25597] [evaluate, SBCCallProfile.cpp:933] DEBUG: bleg_prefer_existing_payloads_str = 'no' [#7fe7eb94b700/25597] [evaluate, SBCCallProfile.cpp:936] DEBUG: bleg_payload_order_str = 'pcmu' [#7fe7eb94b700/25597] [onInvite, SBC.cpp:1112] DEBUG: Enabling RTP relay mode for SBC call [#7fe7eb94b700/25597] [onInvite, SBC.cpp:1115] DEBUG: forcing symmetric RTP (passive mode) [#7fe7eb94b700/25597] [setRtpRelayMode, AmB2BSession.cpp:840] DEBUG: enabled RTP relay mode for B2B call '3DF945DE-53446EFA0005096A-EBD4F700' [#7fe7eb94b700/25597] [setOAEnabled, AmSipDialog.cpp:284] DEBUG: disabling offer_answer on SIP dialog '3DF945DE-53446EFA0005096A-EBD4F700' [#7fe7eb94b700/25597] [onInvite, SBC.cpp:1177] DEBUG: SBC: connecting to 'sip:[email protected]' [#7fe7eb94b700/25597] [onInvite, SBC.cpp:1178] DEBUG: From: '<sip:[email protected]>' [#7fe7eb94b700/25597] [onInvite, SBC.cpp:1179] DEBUG: To: 'sip:[email protected]' [#7fe7eb94b700/25597] [filterBody, SBC.cpp:269] DEBUG: filtering SDP for request 'INVITE' [#7fe7eb94b700/25597] [parse_sdp_line_ex, AmSdp.cpp:484] DEBUG: parsing SDP message... [#7fe7eb94b700/25597] [parse_sdp_connection, AmSdp.cpp:705] DEBUG: SDP: got session level connection: IP4 75.134.217.208 [#7fe7eb94b700/25597] [parse_sdp_media, AmSdp.cpp:848] DEBUG: SDP: got media: port 7076, payloads: 119 0 [#7fe7eb94b700/25597] [fix_missing_encodings, SDPFilter.cpp:91] DEBUG: named SDP payload type 0 with PCMU/8000 [#7fe7eb94b700/25597] [appendTranscoderCodecs, SBC.cpp:118] DEBUG: going to append transcoder codecs into SDP [#7fe7eb94b700/25597] [orderSDP, SBCCallProfile.cpp:828] DEBUG: ordering SDP [#7fe7eb94b700/25597] [connectCallee, AmB2BSession.cpp:1107] DEBUG: relaying B2B connect event to sip:[email protected] [#7fe7eb94b700/25597] [setRel100State, AmSipDialog.cpp:278] DEBUG: setting 100rel state for '' to 3 [#7fe7eb94b700/25597] [setOAEnabled, AmSipDialog.cpp:284] DEBUG: disabling offer_answer on SIP dialog '' [#7fe7eb94b700/25597] [createCalleeSession, SBC.cpp:1844] DEBUG: Created B2BUA callee leg, From: <sip:[email protected]> [#7fe7eb94b700/25597] [setRtpRelayMode, AmB2BSession.cpp:840] DEBUG: enabled RTP relay mode for B2B call '1DDE9AF7-53446EFA0006072C-EB94B700' [#7fe7eb94b700/25597] [parse_sdp_line_ex, AmSdp.cpp:484] DEBUG: parsing SDP message... [#7fe7eb94b700/25597] [parse_sdp_connection, AmSdp.cpp:705] DEBUG: SDP: got session level connection: IP4 75.134.217.208 [#7fe7eb94b700/25597] [parse_sdp_media, AmSdp.cpp:848] DEBUG: SDP: got media: port 7076, payloads: 119 0 [#7fe7eb94b700/25597] [updateStreams, AmB2BMedia.cpp:583] DEBUG: update streams for changed A-leg SDP: relay [#7fe7eb94b700/25597] [setRtpRelayTransparentSeqno, AmRtpStream.cpp:971] DEBUG: enabled RTP relay transparent seqno for RTP stream instance [0x7fe7ee0e2010] [#7fe7eb94b700/25597] [setRtpRelayTransparentSSRC, AmRtpStream.cpp:977] DEBUG: enabled RTP relay transparent SSRC for RTP stream instance [0x7fe7ee0e2010] [#7fe7eb94b700/25597] [setRtpRelayTransparentSeqno, AmRtpStream.cpp:971] DEBUG: enabled RTP relay transparent seqno for RTP stream instance [0x7fe7ee0bf010] [#7fe7eb94b700/25597] [setRtpRelayTransparentSSRC, AmRtpStream.cpp:977] DEBUG: enabled RTP relay transparent SSRC for RTP stream instance [0x7fe7ee0bf010] [#7fe7eb94b700/25597] [computeRelayMask, SBC.cpp:307] DEBUG: entering SBCRelayController::computeRelayMask(A leg) [#7fe7eb94b700/25597] [computeRelayMask, SBC.cpp:332] DEBUG: m2: marking payload 119 for relay [#7fe7eb94b700/25597] [computeRelayMask, SBC.cpp:338] DEBUG: m1: marking payload 119 for relay [#7fe7eb94b700/25597] [computeRelayMask, SBC.cpp:332] DEBUG: m2: marking payload 0 for relay [#7fe7eb94b700/25597] [computeRelayMask, SBC.cpp:338] DEBUG: m1: marking payload 0 for relay [#7fe7eb94b700/25597] [computeRelayMask, SBC.cpp:350] DEBUG: using m2 [#7fe7eb94b700/25597] [relayEvent, AmB2BSession.cpp:533] DEBUG: AmB2BSession::relayEvent: to other_id='1DDE9AF7-53446EFA0006072C-EB94B700' [#7fe7eb94b700/25597] [onSipRequest, AmB2BSession.cpp:371] DEBUG: relaying B2B SIP request INVITE sip:[email protected] [#7fe7eb94b700/25597] [relayEvent, AmB2BSession.cpp:533] DEBUG: AmB2BSession::relayEvent: to other_id='1DDE9AF7-53446EFA0006072C-EB94B700' [#7fe7eb94b700/25597] [processingCycle, AmSession.cpp:386] DEBUG: ^^ S [8a5gsBas9x|3DF945DE-53446EFA0005096A-EBD4F700] Early, running, 0 UACTransPending ^^ [#7fe7eb84a700/25598] [_start, AmThread.cpp:65] DEBUG: Thread 140634065512192 is starting. [#7fe7eb84a700/25598] [run, AmSession.cpp:260] DEBUG: startup session [#7fe7eb84a700/25598] [run, AmSession.cpp:264] DEBUG: running session event loop [#7fe7eb84a700/25598] [processingCycle, AmSession.cpp:368] DEBUG: vv S [74275120-53446EFA00060733-EB94B700|1DDE9AF7-53446EFA0006072C-EB94B700] Disconnected, running, 0 UACTransPending vv [#7fe7eb84a700/25598] [parse_sdp_line_ex, AmSdp.cpp:484] DEBUG: parsing SDP message... [#7fe7eb84a700/25598] [parse_sdp_connection, AmSdp.cpp:705] DEBUG: SDP: got session level connection: IP4 75.134.217.208 [#7fe7eb84a700/25598] [parse_sdp_media, AmSdp.cpp:848] DEBUG: SDP: got media: port 7076, payloads: 0 119 120 [#7fe7eb84a700/25598] [replaceConnectionAddress, AmB2BMedia.cpp:515] DEBUG: new connection address: 100.0.0.19 [#7fe7eb84a700/25598] [setLocalPort, AmRtpStream.cpp:179] DEBUG: added stream [0x7fe7ee0bf010] to RTP receiver (0.0.0.0:10000) [#7fe7eb84a700/25598] [replaceConnectionAddress, AmB2BMedia.cpp:560] DEBUG: replaced connection address in SDP with 100.0.0.19:/10000. [#7fe7eb84a700/25598] [updateStreams, AmB2BMedia.cpp:583] DEBUG: update streams for changed B-leg SDP: [#7fe7eb84a700/25598] [parse, AmMimeBody.cpp:566] DEBUG: saving single-part body [#7fe7eb84a700/25598] [parse_sip_uri, parse_uri.cpp:328] DEBUG: Converted URI port () to int (5060) [#7fe7eb84a700/25598] [set_next_hop, trans_layer.cpp:705] DEBUG: next_hop:next_port is <100.55.11.225:0> [#7fe7eb84a700/25598] [set_destination_ip, trans_layer.cpp:716] DEBUG: checking whether '100.55.11.225' is IP address... [#7fe7eb84a700/25598] [set_destination_ip, trans_layer.cpp:758] DEBUG: set destination to 100.55.11.225:5060 [#7fe7eb84a700/25598] [send_request, trans_layer.cpp:910] DEBUG: send_request to R-URI <sip:[email protected]> [#7fe7eb84a700/25598] [parse_sip_uri, parse_uri.cpp:328] DEBUG: Converted URI port () to int (5060) [#7fe7eb84a700/25598] [parse_via_params, parse_via.cpp:525] DEBUG: parsed branch: z9hG4bKoWmjRahI [#7fe7eb84a700/25598] [parse_via_params, parse_via.cpp:548] DEBUG: has_rport: 1 [#7fe7eb84a700/25598] [send_request, trans_layer.cpp:980] DEBUG: Sending to 100.55.11.225:5060 <INVITE sip:[email protected] SIP/2.0 Via: ...> [#7fe7eb84a700/25598] [send, transport.cpp:109] DEBUG: send msg --++-- INVITE sip:[email protected] SIP/2.0 Via: SIP/2.0/UDP 10.0.0.19;branch=z9hG4bKoWmjRahI;rport From: <sip:[email protected]>;tag=1DDE9AF7-53446EFA0006072C-EB94B700 To: sip:[email protected] CSeq: 10 INVITE Call-ID: 74275120-53446EFA00060733-EB94B700 Contact: <sip:100.0.0.19:5060> Max-Forwards: 69 Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO User-Agent: LinphoneIPhone/2.1.2 (belle-sip/1.2.4) Content-Type: application/sdp Content-Length: 222 v=0 o=1098765431 855 2527 IN IP4 75.134.217.208 s=Talk c=IN IP4 100.0.0.19 t=0 0 m=audio 10000 RTP/AVP 0 119 120 a=rtpmap:0 PCMU/8000 a=rtpmap:119 SILK/16000 a=rtpmap:120 silk/8000 a=sendrecv a=direction:both --++-- [#7fe7eb84a700/25598] [send_request, trans_layer.cpp:992] DEBUG: update_uac_request tt->_t =(nil) [#7fe7eb84a700/25598] [update_uac_request, trans_layer.cpp:1530] DEBUG: update_uac_request(t=0x7fe7d0002560) [#7fe7eb84a700/25598] [reset_timer, sip_trans.cpp:188] DEBUG: New timer of type A at time=1238 (repeated=0) [#7fe7eb84a700/25598] [reset_timer, sip_trans.cpp:188] DEBUG: New timer of type B at time=2813 (repeated=0) [#7fe7eb84a700/25598] [reset_timer, sip_trans.cpp:188] DEBUG: New timer of type M at time=1613 (repeated=0) [#7fe7eb84a700/25598] [saveSessionDescription, AmB2BSession.cpp:602] DEBUG: saving session description (application/sdp, v=0 o=1098765431 855 2527 IN IP4 75.134.217.208 ...) [#7fe7eb84a700/25598] [onB2BEvent, AmB2BSession.cpp:133] DEBUG: AmB2BSession::onB2BEvent [#7fe7eb84a700/25598] [onB2BEvent, AmB2BSession.cpp:143] DEBUG: B2BSipRequest: INVITE (fwd=false) [#7fe7eb84a700/25598] [processingCycle, AmSession.cpp:386] DEBUG: ^^ S [74275120-53446EFA00060733-EB94B700|1DDE9AF7-53446EFA0006072C-EB94B700] Trying, running, 1 UACTransPending ^^ [#7fe7ebc4e700/25593] [run, udp_trsp.cpp:213] DEBUG: vv M [|] u recvd msg via UDP vv --++-- SIP/2.0 100 Trying Via: SIP/2.0/UDP 10.0.0.19;branch=z9hG4bKoWmjRahI;received=100.0.0.19;rport=5060 From: <sip:[email protected]>;tag=1DDE9AF7-53446EFA0006072C-EB94B700 To: sip:[email protected];tag=gK02ed6f12 Call-ID: 74275120-53446EFA00060733-EB94B700 CSeq: 10 INVITE Content-Length: 0 --++-- [#7fe7ebc4e700/25593] [parse_via_params, parse_via.cpp:525] DEBUG: parsed branch: z9hG4bKoWmjRahI [#7fe7ebc4e700/25593] [parse_via_params, parse_via.cpp:548] DEBUG: has_rport: 1 [#7fe7ebc4e700/25593] [received_msg, trans_layer.cpp:1288] DEBUG: Reply matched an existing transaction [#7fe7ebc4e700/25593] [update_uac_reply, trans_layer.cpp:1339] DEBUG: update_uac_reply(reply code = 100, trans=0x7fe7d0002560) [#7fe7ebc4e700/25593] [reset_timer, sip_trans.cpp:140] DEBUG: Clearing old timer of type A (this=0x7fe7d0002670) [#7fe7ebc4e700/25593] [reset_timer, sip_trans.cpp:140] DEBUG: Clearing old timer of type M (this=0x7fe7d00026f0) [#7fe7ebc4e700/25593] [reset_timer, sip_trans.cpp:140] DEBUG: Clearing old timer of type B (this=0x7fe7d00026b0) [#7fe7ebc4e700/25593] [reset_timer, sip_trans.cpp:188] DEBUG: New timer of type C at time=10214 (repeated=0) [#7fe7ebc4e700/25593] [handle_sip_reply, SipCtrlInterface.cpp:606] DEBUG: Received reply: 100 Trying [#7fe7ebc4e700/25593] [handle_sip_reply, SipCtrlInterface.cpp:607] DEBUG: reply.callid = <74275120-53446EFA00060733-EB94B700> [#7fe7ebc4e700/25593] [handle_sip_reply, SipCtrlInterface.cpp:608] DEBUG: reply.from_tag = <1DDE9AF7-53446EFA0006072C-EB94B700> [#7fe7ebc4e700/25593] [handle_sip_reply, SipCtrlInterface.cpp:609] DEBUG: reply.to_tag = <gK02ed6f12> [#7fe7ebc4e700/25593] [handle_sip_reply, SipCtrlInterface.cpp:610] DEBUG: reply.contact = <> [#7fe7ebc4e700/25593] [handle_sip_reply, SipCtrlInterface.cpp:611] DEBUG: reply.to_uri = <> [#7fe7ebc4e700/25593] [handle_sip_reply, SipCtrlInterface.cpp:612] DEBUG: cseq = <10> [#7fe7ebc4e700/25593] [handle_sip_reply, SipCtrlInterface.cpp:613] DEBUG: reply.route = <> [#7fe7ebc4e700/25593] [handle_sip_reply, SipCtrlInterface.cpp:614] DEBUG: hdrs = <> [#7fe7ebc4e700/25593] [handle_sip_reply, SipCtrlInterface.cpp:615] DEBUG: body-ct = <> [#7fe7ebc4e700/25593] [handle_sip_reply, SipCtrlInterface.cpp:621] DEBUG: ^^ M [74275120-53446EFA00060733-EB94B700|1DDE9AF7-53446EFA0006072C-EB94B700] ru SIP reply 100 Trying handled ^^ [#7fe7eb84a700/25598] [processingCycle, AmSession.cpp:368] DEBUG: vv S [74275120-53446EFA00060733-EB94B700|1DDE9AF7-53446EFA0006072C-EB94B700] Trying, running, 1 UACTransPending vv [#7fe7eb84a700/25598] [process, AmSession.cpp:713] DEBUG: AmSession processing event [#7fe7eb84a700/25598] [onRxReply, AmSipDialog.cpp:387] DEBUG: onRxReply(rep = 100 Trying): transaction found! [#7fe7eb84a700/25598] [onSipReply, SBC.cpp:2000] DEBUG: onSipReply: 100 Trying (fwd=1) [#7fe7eb84a700/25598] [onSipReply, SBC.cpp:2001] DEBUG: onSipReply: content-type = [#7fe7eb84a700/25598] [onSipReply, AmB2BSession.cpp:463] DEBUG: onSipReply: INVITE -> 100 Trying (fwd=false), c-t= [#7fe7eb84a700/25598] [onSipReply, AmSession.cpp:832] DEBUG: Dialog status changed Trying -> Early (stopped=false) [#7fe7eb84a700/25598] [onSipReply, AmB2BSession.cpp:503] DEBUG: relaying B2B SIP reply 100 Trying [#7fe7eb84a700/25598] [relayEvent, AmB2BSession.cpp:533] DEBUG: AmB2BSession::relayEvent: to other_id='3DF945DE-53446EFA0005096A-EBD4F700' [#7fe7eb94b700/25597] [processingCycle, AmSession.cpp:368] DEBUG: vv S [8a5gsBas9x|3DF945DE-53446EFA0005096A-EBD4F700] Early, running, 0 UACTransPending vv [#7fe7eb94b700/25597] [onB2BEvent, AmB2BSession.cpp:944] DEBUG: 100 Trying reply received from other leg [#7fe7eb94b700/25597] [onOtherReply, SBC.cpp:1397] DEBUG: Callee is trying... code 100 [#7fe7eb94b700/25597] [onB2BEvent, AmB2BSession.cpp:133] DEBUG: AmB2BSession::onB2BEvent [#7fe7eb94b700/25597] [onB2BEvent, AmB2BSession.cpp:187] DEBUG: B2BSipReply: 100 Trying (fwd=false) [#7fe7eb94b700/25597] [onB2BEvent, AmB2BSession.cpp:189] DEBUG: B2BSipReply: content-type = [#7fe7eb94b700/25597] [processingCycle, AmSession.cpp:386] DEBUG: ^^ S [8a5gsBas9x|3DF945DE-53446EFA0005096A-EBD4F700] Early, running, 0 UACTransPending ^^ [#7fe7eb84a700/25598] [processingCycle, AmSession.cpp:386] DEBUG: ^^ S [74275120-53446EFA00060733-EB94B700|1DDE9AF7-53446EFA0006072C-EB94B700] Early, running, 1 UACTransPending ^^ [#7fe7ebb4d700/25594] [run, udp_trsp.cpp:213] DEBUG: vv M [|] u recvd msg via UDP vv --++-- SIP/2.0 180 Ringing Via: SIP/2.0/UDP 10.0.0.19;branch=z9hG4bKoWmjRahI;received=100.0.0.19;rport=5060 From: <sip:[email protected]>;tag=1DDE9AF7-53446EFA0006072C-EB94B700 To: sip:[email protected];tag=gK02ed6f12 Call-ID: 74275120-53446EFA00060733-EB94B700 CSeq: 10 INVITE Contact: <sip:[email protected]:5060> Allow: INVITE,ACK,CANCEL,BYE,PRACK,UPDATE Content-Length: 198 Content-Disposition: session; handling=required Content-Type: application/sdp v=0 o=Sonus_UAC 4410 20558 IN IP4 100.55.11.225 s=SIP Media Capabilities c=IN IP4 100.55.11.198 t=0 0 m=audio 8240 RTP/AVP 0 a=direction: passive a=rtpmap:0 PCMU/8000 a=sendrecv a=maxptime:20 --++-- [#7fe7ebb4d700/25594] [parse_via_params, parse_via.cpp:525] DEBUG: parsed branch: z9hG4bKoWmjRahI [#7fe7ebb4d700/25594] [parse_via_params, parse_via.cpp:548] DEBUG: has_rport: 1 [#7fe7ebb4d700/25594] [received_msg, trans_layer.cpp:1288] DEBUG: Reply matched an existing transaction [#7fe7ebb4d700/25594] [update_uac_reply, trans_layer.cpp:1339] DEBUG: update_uac_reply(reply code = 180, trans=0x7fe7d0002560) [#7fe7ebb4d700/25594] [reset_timer, sip_trans.cpp:188] DEBUG: New timer of type C at time=10268 (repeated=0) [#7fe7ebb4d700/25594] [reset_timer, sip_trans.cpp:140] DEBUG: Clearing old timer of type C (this=0x7fe7cc0012e0) [#7fe7ebb4d700/25594] [parse, AmMimeBody.cpp:566] DEBUG: saving single-part body [#7fe7ebb4d700/25594] [sip_msg2am_reply, SipCtrlInterface.cpp:483] DEBUG: MIME body successfully parsed [#7fe7ebb4d700/25594] [handle_sip_reply, SipCtrlInterface.cpp:606] DEBUG: Received reply: 180 Ringing [#7fe7ebb4d700/25594] [handle_sip_reply, SipCtrlInterface.cpp:607] DEBUG: reply.callid = <74275120-53446EFA00060733-EB94B700> [#7fe7ebb4d700/25594] [handle_sip_reply, SipCtrlInterface.cpp:608] DEBUG: reply.from_tag = <1DDE9AF7-53446EFA0006072C-EB94B700> [#7fe7ebb4d700/25594] [handle_sip_reply, SipCtrlInterface.cpp:609] DEBUG: reply.to_tag = <gK02ed6f12> [#7fe7ebb4d700/25594] [handle_sip_reply, SipCtrlInterface.cpp:610] DEBUG: reply.contact = <<sip:[email protected]:5060>> [#7fe7ebb4d700/25594] [handle_sip_reply, SipCtrlInterface.cpp:611] DEBUG: reply.to_uri = <sip:[email protected]:5060> [#7fe7ebb4d700/25594] [handle_sip_reply, SipCtrlInterface.cpp:612] DEBUG: cseq = <10> [#7fe7ebb4d700/25594] [handle_sip_reply, SipCtrlInterface.cpp:613] DEBUG: reply.route = <> [#7fe7ebb4d700/25594] [handle_sip_reply, SipCtrlInterface.cpp:614] DEBUG: hdrs = <Allow: INVITE,ACK,CANCEL,BYE,PRACK,UPDATE Content-Disposition: session; handling=required > [#7fe7ebb4d700/25594] [handle_sip_reply, SipCtrlInterface.cpp:615] DEBUG: body-ct = <application/sdp> [#7fe7ebb4d700/25594] [handle_sip_reply, SipCtrlInterface.cpp:621] DEBUG: ^^ M [74275120-53446EFA00060733-EB94B700|1DDE9AF7-53446EFA0006072C-EB94B700] ru SIP reply 180 Ringing handled ^^ [#7fe7eb84a700/25598] [processingCycle, AmSession.cpp:368] DEBUG: vv S [74275120-53446EFA00060733-EB94B700|1DDE9AF7-53446EFA0006072C-EB94B700] Early, running, 1 UACTransPending vv [#7fe7eb84a700/25598] [process, AmSession.cpp:713] DEBUG: AmSession processing event [#7fe7eb84a700/25598] [onRxReply, AmSipDialog.cpp:387] DEBUG: onRxReply(rep = 180 Ringing): transaction found! [#7fe7eb84a700/25598] [onSipReply, SBC.cpp:2000] DEBUG: onSipReply: 180 Ringing (fwd=1) [#7fe7eb84a700/25598] [onSipReply, SBC.cpp:2001] DEBUG: onSipReply: content-type = application/sdp [#7fe7eb84a700/25598] [onSipReply, AmB2BSession.cpp:463] DEBUG: onSipReply: INVITE -> 180 Ringing (fwd=true), c-t=application/sdp [#7fe7eb84a700/25598] [updateRefreshMethod, AmSession.cpp:1106] DEBUG: remote allows UPDATE, using UPDATE for session refresh. [#7fe7eb84a700/25598] [parse_sdp_line_ex, AmSdp.cpp:484] DEBUG: parsing SDP message... [#7fe7eb84a700/25598] [parse_sdp_connection, AmSdp.cpp:705] DEBUG: SDP: got session level connection: IP4 100.55.11.198 [#7fe7eb84a700/25598] [parse_sdp_media, AmSdp.cpp:848] DEBUG: SDP: got media: port 8240, payloads: 0 [#7fe7eb84a700/25598] [updateStreams, AmB2BMedia.cpp:583] DEBUG: update streams for changed B-leg SDP: relay transcoding [#7fe7eb84a700/25598] [computeRelayMask, SBC.cpp:307] DEBUG: entering SBCRelayController::computeRelayMask(B leg) [#7fe7eb84a700/25598] [computeRelayMask, SBC.cpp:332] DEBUG: m2: marking payload 0 for relay [#7fe7eb84a700/25598] [computeRelayMask, SBC.cpp:350] DEBUG: using m2 [#7fe7eb84a700/25598] [stopStreamProcessing, AmB2BMedia.cpp:209] DEBUG: remove stream [0x7fe7ee0bf010] from RTP receiver [#7fe7eb84a700/25598] [init, AmRtpAudio.cpp:321] DEBUG: AmRtpAudio::init(...) [#7fe7eb84a700/25598] [setPassiveMode, AmRtpStream.cpp:498] DEBUG: The other UA is NATed: switched to passive mode. [#7fe7eb84a700/25598] [setRAddr, AmRtpStream.cpp:426] DEBUG: RTP remote address set to 100.55.11.198:8240 [#7fe7eb84a700/25598] [init, AmRtpStream.cpp:643] DEBUG: default payload selected = 0 [#7fe7eb84a700/25598] [init, AmRtpStream.cpp:651] DEBUG: remote party doesn't support telephone events [#7fe7eb84a700/25598] [setCurrentPayload, AmRtpAudio.cpp:48] DEBUG: fmt.codec_id = 1 [#7fe7eb84a700/25598] [setCurrentPayload, AmRtpAudio.cpp:51] DEBUG: fmt.rate = 8000 [#7fe7eb84a700/25598] [setCurrentPayload, AmRtpAudio.cpp:53] DEBUG: fmt.advertized_rate = 8000 [#7fe7eb84a700/25598] [setPlayoutType, AmRtpAudio.cpp:457] DEBUG: Adaptive playout buffer activated [#7fe7eb84a700/25598] [resumeStreamProcessing, AmB2BMedia.cpp:217] DEBUG: resume stream [0x7fe7ee0bf010] into RTP receiver [#7fe7eb84a700/25598] [filterBody, SBC.cpp:285] DEBUG: filtering body of relayed reply 180 [#7fe7eb84a700/25598] [parse_sdp_line_ex, AmSdp.cpp:484] DEBUG: parsing SDP message... [#7fe7eb84a700/25598] [parse_sdp_connection, AmSdp.cpp:705] DEBUG: SDP: got session level connection: IP4 100.55.11.198 [#7fe7eb84a700/25598] [parse_sdp_media, AmSdp.cpp:848] DEBUG: SDP: got media: port 8240, payloads: 0 [#7fe7eb84a700/25598] [appendTranscoderCodecs, SBC.cpp:118] DEBUG: going to append transcoder codecs into SDP [#7fe7eb84a700/25598] [filterAlinesInternal, SDPFilter.cpp:127] DEBUG: maxptime (maxptime) is_filtered: true [#7fe7eb84a700/25598] [onSipReply, AmB2BSession.cpp:484] DEBUG: relaying B2B SIP reply 180 Ringing [#7fe7eb84a700/25598] [relayEvent, AmB2BSession.cpp:533] DEBUG: AmB2BSession::relayEvent: to other_id='3DF945DE-53446EFA0005096A-EBD4F700' [#7fe7eb94b700/25597] [processingCycle, AmSession.cpp:368] DEBUG: vv S [8a5gsBas9x|3DF945DE-53446EFA0005096A-EBD4F700] Early, running, 0 UACTransPending vv [#7fe7eb94b700/25597] [onB2BEvent, AmB2BSession.cpp:944] DEBUG: 180 Ringing reply received from other leg [#7fe7eb94b700/25597] [onOtherReply, SBC.cpp:1397] DEBUG: Callee is trying... code 180 [#7fe7eb94b700/25597] [onB2BEvent, AmB2BSession.cpp:133] DEBUG: AmB2BSession::onB2BEvent [#7fe7eb94b700/25597] [onB2BEvent, AmB2BSession.cpp:187] DEBUG: B2BSipReply: 180 Ringing (fwd=true) [#7fe7eb94b700/25597] [onB2BEvent, AmB2BSession.cpp:189] DEBUG: B2BSipReply: content-type = application/sdp [#7fe7eb94b700/25597] [parse_sdp_line_ex, AmSdp.cpp:484] DEBUG: parsing SDP message... [#7fe7eb94b700/25597] [parse_sdp_connection, AmSdp.cpp:705] DEBUG: SDP: got session level connection: IP4 100.55.11.198 [#7fe7eb94b700/25597] [parse_sdp_media, AmSdp.cpp:848] DEBUG: SDP: got media: port 8240, payloads: 0 120 [#7fe7eb94b700/25597] [replaceConnectionAddress, AmB2BMedia.cpp:515] DEBUG: new connection address: 100.0.0.19 [#7fe7eb94b700/25597] [setLocalPort, AmRtpStream.cpp:179] DEBUG: added stream [0x7fe7ee0e2010] to RTP receiver (0.0.0.0:10002) [#7fe7eb94b700/25597] [replaceConnectionAddress, AmB2BMedia.cpp:560] DEBUG: replaced connection address in SDP with 100.0.0.19:/10002. [#7fe7eb94b700/25597] [updateStreams, AmB2BMedia.cpp:583] DEBUG: update streams for changed A-leg SDP: transcoding [#7fe7eb94b700/25597] [stopStreamProcessing, AmB2BMedia.cpp:209] DEBUG: remove stream [0x7fe7ee0e2010] from RTP receiver [#7fe7eb94b700/25597] [init, AmRtpAudio.cpp:321] DEBUG: AmRtpAudio::init(...) [#7fe7eb94b700/25597] [setPassiveMode, AmRtpStream.cpp:498] DEBUG: The other UA is NATed: switched to passive mode. [#7fe7eb94b700/25597] [setRAddr, AmRtpStream.cpp:426] DEBUG: RTP remote address set to 75.134.217.208:7076 [#7fe7eb94b700/25597] [init, AmRtpStream.cpp:643] DEBUG: default payload selected = 0 [#7fe7eb94b700/25597] [init, AmRtpStream.cpp:651] DEBUG: remote party doesn't support telephone events [#7fe7eb94b700/25597] [setCurrentPayload, AmRtpAudio.cpp:48] DEBUG: fmt.codec_id = 1 [#7fe7eb94b700/25597] [setCurrentPayload, AmRtpAudio.cpp:51] DEBUG: fmt.rate = 8000 [#7fe7eb94b700/25597] [setCurrentPayload, AmRtpAudio.cpp:53] DEBUG: fmt.advertized_rate = 8000 [#7fe7eb94b700/25597] [setPlayoutType, AmRtpAudio.cpp:457] DEBUG: Adaptive playout buffer activated [#7fe7eb94b700/25597] [resumeStreamProcessing, AmB2BMedia.cpp:217] DEBUG: resume stream [0x7fe7ee0e2010] into RTP receiver [#7fe7eb94b700/25597] [parse, AmMimeBody.cpp:566] DEBUG: saving single-part body [#7fe7eb94b700/25597] [relaySip, AmB2BSession.cpp:818] DEBUG: relaying SIP reply 180 Ringing [#7fe7eb94b700/25597] [reply, AmSipDialog.cpp:749] DEBUG: reply: transaction found! [#7fe7eb94b700/25597] [send_reply, trans_layer.cpp:260] DEBUG: reply_len = 888 [#7fe7eb94b700/25597] [is_opt_set, transport.cpp:60] DEBUG: trsp_socket::socket_options = 0x0 [#7fe7eb94b700/25597] [send_reply, trans_layer.cpp:438] DEBUG: Sending to 100.1.2.3:5060 <SIP/2.0 180 Ringing Record-Route: <sip:54.84.190....> [#7fe7eb94b700/25597] [send, transport.cpp:109] DEBUG: send msg --++-- SIP/2.0 180 Ringing Record-Route: <sip:100.1.2.3:5060;lr;ftag=scCZp~6wH100.1.2.3:5060;vst=AAAAAAEIC3NcXFtbRl9JGyNaWS44NC4xMDQuODM-;did=2a8.33e4889> Via: SIP/2.0/UDP 100.1.2.3:5060;branch=z9hG4bK22d2.87f26873.0 Via: SIP/2.0/UDP 192.168.1.114:50748;received=75.134.217.208;branch=z9hG4bK.yKynQsfdo;rport=50748 From: <sip:[email protected]>;tag=scCZp~6wH To: sip:[email protected];tag=3DF945DE-53446EFA0005096A-EBD4F700 CSeq: 21 INVITE Call-ID: 8a5gsBas9x Allow: INVITE,ACK,CANCEL,BYE,PRACK,UPDATE Content-Disposition: session; handling=required Contact: <sip:[email protected]:5060> Content-Type: application/sdp Content-Length: 209 v=0 o=Sonus_UAC 4410 20558 IN IP4 100.55.11.225 s=SIP Media Capabilities c=IN IP4 100.0.0.19 t=0 0 m=audio 10002 RTP/AVP 0 120 a=rtpmap:0 PCMU/8000 a=rtpmap:120 silk/8000 a=sendrecv a=direction:both --++-- [#7fe7eb94b700/25597] [update_uas_reply, trans_layer.cpp:1586] DEBUG: update_uas_reply(t=0x7fe7d80017c0) [#7fe7eb94b700/25597] [saveSessionDescription, AmB2BSession.cpp:602] DEBUG: saving session description (application/sdp, v=0 o=Sonus_UAC 4410 20558 IN IP4 100.55.11.225 s=...) [#7fe7eb94b700/25597] [processingCycle, AmSession.cpp:386] DEBUG: ^^ S [8a5gsBas9x|3DF945DE-53446EFA0005096A-EBD4F700] Early, running, 0 UACTransPending ^^ [#7fe7eb84a700/25598] [processingCycle, AmSession.cpp:386] DEBUG: ^^ S [74275120-53446EFA00060733-EB94B700|1DDE9AF7-53446EFA0006072C-EB94B700] Early, running, 1 UACTransPending ^^ [#7fe7eb749700/25599] [_start, AmThread.cpp:65] DEBUG: Thread 140634064459520 is starting. [#7fe7ec052700/25589] [process, AmMediaProcessor.cpp:308] DEBUG: Session inserted to the scheduler [#7fe7eba4c700/25595] [run, udp_trsp.cpp:213] DEBUG: vv M [|] u recvd msg via UDP vv --++-- SIP/2.0 200 OK Via: SIP/2.0/UDP 10.0.0.19;branch=z9hG4bKoWmjRahI;received=100.0.0.19;rport=5060 From: <sip:[email protected]>;tag=1DDE9AF7-53446EFA0006072C-EB94B700 To: sip:[email protected];tag=gK02ed6f12 Call-ID: 74275120-53446EFA00060733-EB94B700 CSeq: 10 INVITE Accept: application/sdp, application/isup, application/dtmf, application/dtmf-relay, multipart/mixed Contact: <sip:[email protected]:5060> Allow: INVITE,ACK,CANCEL,BYE,PRACK,UPDATE Content-Length: 198 Content-Disposition: session; handling=required Content-Type: application/sdp v=0 o=Sonus_UAC 4410 20558 IN IP4 100.55.11.225 s=SIP Media Capabilities c=IN IP4 100.55.11.198 t=0 0 m=audio 8240 RTP/AVP 0 a=direction: passive a=rtpmap:0 PCMU/8000 a=sendrecv a=maxptime:20 --++-- [#7fe7eba4c700/25595] [parse_via_params, parse_via.cpp:525] DEBUG: parsed branch: z9hG4bKoWmjRahI [#7fe7eba4c700/25595] [parse_via_params, parse_via.cpp:548] DEBUG: has_rport: 1 [#7fe7eba4c700/25595] [received_msg, trans_layer.cpp:1288] DEBUG: Reply matched an existing transaction [#7fe7eba4c700/25595] [update_uac_reply, trans_layer.cpp:1339] DEBUG: update_uac_reply(reply code = 200, trans=0x7fe7d0002560) [#7fe7eba4c700/25595] [update_uac_reply, trans_layer.cpp:1420] DEBUG: Positive final reply to INVITE transaction (state=3) [#7fe7eba4c700/25595] [reset_timer, sip_trans.cpp:140] DEBUG: Clearing old timer of type C (this=0x7fe7d0002a10) [#7fe7eba4c700/25595] [reset_timer, sip_trans.cpp:188] DEBUG: New timer of type L at time=3222 (repeated=0) [#7fe7eba4c700/25595] [parse, AmMimeBody.cpp:566] DEBUG: saving single-part body [#7fe7eba4c700/25595] [sip_msg2am_reply, SipCtrlInterface.cpp:483] DEBUG: MIME body successfully parsed [#7fe7eba4c700/25595] [handle_sip_reply, SipCtrlInterface.cpp:606] DEBUG: Received reply: 200 OK [#7fe7eba4c700/25595] [handle_sip_reply, SipCtrlInterface.cpp:607] DEBUG: reply.callid = <74275120-53446EFA00060733-EB94B700> [#7fe7eba4c700/25595] [handle_sip_reply, SipCtrlInterface.cpp:608] DEBUG: reply.from_tag = <1DDE9AF7-53446EFA0006072C-EB94B700> [#7fe7eba4c700/25595] [handle_sip_reply, SipCtrlInterface.cpp:609] DEBUG: reply.to_tag = <gK02ed6f12> [#7fe7eba4c700/25595] [handle_sip_reply, SipCtrlInterface.cpp:610] DEBUG: reply.contact = <<sip:[email protected]:5060>> [#7fe7eba4c700/25595] [handle_sip_reply, SipCtrlInterface.cpp:611] DEBUG: reply.to_uri = <sip:[email protected]:5060> [#7fe7eba4c700/25595] [handle_sip_reply, SipCtrlInterface.cpp:612] DEBUG: cseq = <10> [#7fe7eba4c700/25595] [handle_sip_reply, SipCtrlInterface.cpp:613] DEBUG: reply.route = <> [#7fe7eba4c700/25595] [handle_sip_reply, SipCtrlInterface.cpp:614] DEBUG: hdrs = <Accept: application/sdp, application/isup, application/dtmf, application/dtmf-relay, multipart/mixed Allow: INVITE,ACK,CANCEL,BYE,PRACK,UPDATE Content-Disposition: session; handling=required > [#7fe7eba4c700/25595] [handle_sip_reply, SipCtrlInterface.cpp:615] DEBUG: body-ct = <application/sdp> [#7fe7eba4c700/25595] [handle_sip_reply, SipCtrlInterface.cpp:621] DEBUG: ^^ M [74275120-53446EFA00060733-EB94B700|1DDE9AF7-53446EFA0006072C-EB94B700] ru SIP reply 200 OK handled ^^ [#7fe7eb84a700/25598] [processingCycle, AmSession.cpp:368] DEBUG: vv S [74275120-53446EFA00060733-EB94B700|1DDE9AF7-53446EFA0006072C-EB94B700] Early, running, 1 UACTransPending vv [#7fe7eb84a700/25598] [process, AmSession.cpp:713] DEBUG: AmSession processing event [#7fe7eb84a700/25598] [onRxReply, AmSipDialog.cpp:387] DEBUG: onRxReply(rep = 200 OK): transaction found! [#7fe7eb84a700/25598] [onSipReply, SBC.cpp:2000] DEBUG: onSipReply: 200 OK (fwd=1) [#7fe7eb84a700/25598] [onSipReply, SBC.cpp:2001] DEBUG: onSipReply: content-type = application/sdp [#7fe7eb84a700/25598] [onSipReply, AmB2BSession.cpp:463] DEBUG: onSipReply: INVITE -> 200 OK (fwd=true), c-t=application/sdp [#7fe7eb84a700/25598] [parse_sdp_line_ex, AmSdp.cpp:484] DEBUG: parsing SDP message... [#7fe7eb84a700/25598] [parse_sdp_connection, AmSdp.cpp:705] DEBUG: SDP: got session level connection: IP4 100.55.11.198 [#7fe7eb84a700/25598] [parse_sdp_media, AmSdp.cpp:848] DEBUG: SDP: got media: port 8240, payloads: 0 [#7fe7eb84a700/25598] [updateStreams, AmB2BMedia.cpp:583] DEBUG: update streams for changed B-leg SDP: relay [#7fe7eb84a700/25598] [stopStreamProcessing, AmB2BMedia.cpp:209] DEBUG: remove stream [0x7fe7ee0e2010] from RTP receiver [#7fe7eb84a700/25598] [computeRelayMask, SBC.cpp:307] DEBUG: entering SBCRelayController::computeRelayMask(B leg) [#7fe7eb84a700/25598] [computeRelayMask, SBC.cpp:332] DEBUG: m2: marking payload 0 for relay [#7fe7eb84a700/25598] [computeRelayMask, SBC.cpp:350] DEBUG: using m2 [#7fe7eb84a700/25598] [resumeStreamProcessing, AmB2BMedia.cpp:217] DEBUG: resume stream [0x7fe7ee0e2010] into RTP receiver [#7fe7eb84a700/25598] [filterBody, SBC.cpp:285] DEBUG: filtering body of relayed reply 200 [#7fe7eb84a700/25598] [parse_sdp_line_ex, AmSdp.cpp:484] DEBUG: parsing SDP message... [#7fe7eb84a700/25598] [parse_sdp_connection, AmSdp.cpp:705] DEBUG: SDP: got session level connection: IP4 100.55.11.198 [#7fe7eb84a700/25598] [parse_sdp_media, AmSdp.cpp:848] DEBUG: SDP: got media: port 8240, payloads: 0 [#7fe7eb84a700/25598] [appendTranscoderCodecs, SBC.cpp:118] DEBUG: going to append transcoder codecs into SDP [#7fe7eb84a700/25598] [filterAlinesInternal, SDPFilter.cpp:127] DEBUG: maxptime (maxptime) is_filtered: true [#7fe7eb84a700/25598] [onSipReply, AmB2BSession.cpp:484] DEBUG: relaying B2B SIP reply 200 OK [#7fe7eb84a700/25598] [relayEvent, AmB2BSession.cpp:533] DEBUG: AmB2BSession::relayEvent: to other_id='3DF945DE-53446EFA0005096A-EBD4F700' [#7fe7eb84a700/25598] [onSipReply, AmB2BSession.cpp:489] DEBUG: not removing relayed INVITE transaction yet... [#7fe7eb94b700/25597] [processingCycle, AmSession.cpp:368] DEBUG: vv S [8a5gsBas9x|3DF945DE-53446EFA0005096A-EBD4F700] Early, running, 0 UACTransPending vv [#7fe7eb84a700/25598] [onInvite2xx, AmB2BSession.cpp:516] DEBUG: no 200 ACK now: waiting for the 200 ACK from the other side... [#7fe7eb84a700/25598] [processingCycle, AmSession.cpp:386] DEBUG: ^^ S [74275120-53446EFA00060733-EB94B700|1DDE9AF7-53446EFA0006072C-EB94B700] Connected, running, 1 UACTransPending ^^ [#7fe7eb94b700/25597] [onB2BEvent, AmB2BSession.cpp:944] DEBUG: 200 OK reply received from other leg [#7fe7eb94b700/25597] [onB2BEvent, AmB2BSession.cpp:966] DEBUG: setting callee status to connected [#7fe7eb94b700/25597] [onB2BEvent, AmB2BSession.cpp:133] DEBUG: AmB2BSession::onB2BEvent [#7fe7eb94b700/25597] [onB2BEvent, AmB2BSession.cpp:187] DEBUG: B2BSipReply: 200 OK (fwd=true) [#7fe7eb94b700/25597] [onB2BEvent, AmB2BSession.cpp:189] DEBUG: B2BSipReply: content-type = application/sdp [#7fe7eb94b700/25597] [parse_sdp_line_ex, AmSdp.cpp:484] DEBUG: parsing SDP message... [#7fe7eb94b700/25597] [parse_sdp_connection, AmSdp.cpp:705] DEBUG: SDP: got session level connection: IP4 100.55.11.198 [#7fe7eb94b700/25597] [parse_sdp_media, AmSdp.cpp:848] DEBUG: SDP: got media: port 8240, payloads: 0 120 [#7fe7eb94b700/25597] [replaceConnectionAddress, AmB2BMedia.cpp:515] DEBUG: new connection address: 100.0.0.19 [#7fe7eb94b700/25597] [replaceConnectionAddress, AmB2BMedia.cpp:560] DEBUG: replaced connection address in SDP with 100.0.0.19:/10002. [#7fe7eb94b700/25597] [updateStreams, AmB2BMedia.cpp:583] DEBUG: update streams for changed A-leg SDP: [#7fe7eb94b700/25597] [parse, AmMimeBody.cpp:566] DEBUG: saving single-part body [#7fe7eb94b700/25597] [relaySip, AmB2BSession.cpp:818] DEBUG: relaying SIP reply 200 OK [#7fe7eb94b700/25597] [reply, AmSipDialog.cpp:749] DEBUG: reply: transaction found! [#7fe7eb94b700/25597] [send_reply, trans_layer.cpp:260] DEBUG: reply_len = 986 [#7fe7eb94b700/25597] [is_opt_set, transport.cpp:60] DEBUG: trsp_socket::socket_options = 0x0 [#7fe7eb94b700/25597] [send_reply, trans_layer.cpp:438] DEBUG: Sending to 100.1.2.3:5060 <SIP/2.0 200 OK Record-Route: <sip:100.1.2.3:5...> [#7fe7eb94b700/25597] [send, transport.cpp:109] DEBUG: send msg --++-- SIP/2.0 200 OK Record-Route: <sip:100.1.2.3:5060;lr;ftag=scCZp~6wH100.1.2.3:5060;vst=AAAAAAEIC3NcXFtbRl9JGyNaWS44NC4xMDQuODM-;did=2a8.33e4889> Via: SIP/2.0/UDP 100.1.2.3:5060;branch=z9hG4bK22d2.87f26873.0 Via: SIP/2.0/UDP 192.168.1.114:50748;received=75.134.217.208;branch=z9hG4bK.yKynQsfdo;rport=50748 From: <sip:[email protected]>;tag=scCZp~6wH To: sip:[email protected];tag=3DF945DE-53446EFA0005096A-EBD4F700 CSeq: 21 INVITE Call-ID: 8a5gsBas9x Accept: application/sdp, application/isup, application/dtmf, application/dtmf-relay, multipart/mixed Allow: INVITE,ACK,CANCEL,BYE,PRACK,UPDATE Content-Disposition: session; handling=required Contact: <sip:[email protected]:5060> Content-Type: application/sdp Content-Length: 209 v=0 o=Sonus_UAC 4410 20558 IN IP4 100.55.11.225 s=SIP Media Capabilities c=IN IP4 100.0.0.19 t=0 0 m=audio 10002 RTP/AVP 0 120 a=rtpmap:0 PCMU/8000 a=rtpmap:120 silk/8000 a=sendrecv a=direction:both --++-- [#7fe7eb94b700/25597] [update_uas_reply, trans_layer.cpp:1586] DEBUG: update_uas_reply(t=0x7fe7d80017c0) [#7fe7eb94b700/25597] [reset_timer, sip_trans.cpp:188] DEBUG: New timer of type G at time=1647 (repeated=0) [#7fe7eb94b700/25597] [reset_timer, sip_trans.cpp:188] DEBUG: New timer of type H at time=3222 (repeated=0) [#7fe7eb94b700/25597] [saveSessionDescription, AmB2BSession.cpp:602] DEBUG: saving session description (application/sdp, v=0 o=Sonus_UAC 4410 20558 IN IP4 100.55.11.225 s=...) [#7fe7eb94b700/25597] [onB2BEvent, AmB2BSession.cpp:223] DEBUG: recvd_req.erase(<21,INVITE>) [#7fe7eb94b700/25597] [processingCycle, AmSession.cpp:386] DEBUG: ^^ S [8a5gsBas9x|3DF945DE-53446EFA0005096A-EBD4F700] Connected, running, 0 UACTransPending ^^ [#7fe7ebd4f700/25592] [run, udp_trsp.cpp:213] DEBUG: vv M [|] u recvd msg via UDP vv --++-- ACK sip:[email protected]:5060 SIP/2.0 Via: SIP/2.0/UDP 100.1.2.3:5060;branch=z9hG4bK22d2.87f26873.2 Via: SIP/2.0/UDP 192.168.1.114:50748;received=75.134.217.208;rport=50748;branch=z9hG4bK.98Xq8h5mb From: <sip:[email protected]>;tag=scCZp~6wH To: <sip:[email protected]>;tag=3DF945DE-53446EFA0005096A-EBD4F700 CSeq: 21 ACK Call-ID: 8a5gsBas9x Max-Forwards: 69 Route: <sip:100.1.2.3:5060;lr;ftag=scCZp~6wH100.1.2.3%3a5060;vst=AAAAAAEIC3NcXFtbRl9JGyNaWS44NC4xMDQuODM-;did=2a8.33e4889> Authorization: Digest realm="100.1.2.3", nonce="53446f07000000b69abfa6982e8f06e283e2269ed5fb0fd2", username="1098765431", uri="sip:[email protected]", response="52513d1921be75507157ac03505f3c13" --++-- [#7fe7ebd4f700/25592] [parse_sip_uri, parse_uri.cpp:328] DEBUG: Converted URI port (5060) to int (5060) [#7fe7ebd4f700/25592] [parse_via_params, parse_via.cpp:525] DEBUG: parsed branch: z9hG4bK22d2.87f26873.2 [#7fe7ebd4f700/25592] [parse_via_params, parse_via.cpp:548] DEBUG: has_rport: 0 [#7fe7ebd4f700/25592] [match_request, trans_table.cpp:68] DEBUG: Matching ACK request [#7fe7ebd4f700/25592] [match_request, trans_table.cpp:87] DEBUG: do_3261_match = 1 [#7fe7ebd4f700/25592] [received_msg, trans_layer.cpp:1196] DEBUG: ACK matched INVITE transaction 0x7fe7d80017c0 [#7fe7ebd4f700/25592] [update_uas_request, trans_layer.cpp:1643] DEBUG: update_uas_request(t=0x7fe7d80017c0) [#7fe7ebd4f700/25592] [received_msg, trans_layer.cpp:1199] DEBUG: update_uas_request(bucket,t=0x7fe7d80017c0,msg) = 9 [#7fe7ebd4f700/25592] [received_msg, trans_layer.cpp:1216] DEBUG: Passing ACK to the UA. [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:570] DEBUG: Received new request from <100.1.2.3:5060> on intf #0 [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:574] DEBUG: req.method = <ACK> [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:577] DEBUG: req.r_uri = <sip:[email protected]:5060> [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:578] DEBUG: req.from_uri = <sip:[email protected]> [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:579] DEBUG: req.from = <<sip:[email protected]>> [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:580] DEBUG: req.to = <<sip:[email protected]>;tag=3DF945DE-53446EFA0005096A-EBD4F700> [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:581] DEBUG: req.callid = <8a5gsBas9x> [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:582] DEBUG: req.from_tag = <scCZp~6wH> [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:583] DEBUG: req.to_tag = <3DF945DE-53446EFA0005096A-EBD4F700> [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:584] DEBUG: cseq = <21> [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:585] DEBUG: req.route = <> [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:586] DEBUG: hdrs = <Max-Forwards: 69 Authorization: Digest realm="100.1.2.3", nonce="53446f07000000b69abfa6982e8f06e283e2269ed5fb0fd2", username="1098765431", uri="sip:[email protected]", response="52513d1921be75507157ac03505f3c13" > [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:587] DEBUG: body-ct = <> [#7fe7ebd4f700/25592] [handle_sip_request, SipCtrlInterface.cpp:593] DEBUG: ^^ M [8a5gsBas9x|3DF945DE-53446EFA0005096A-EBD4F700] Ru SIP request ACK handled ^^ [#7fe7eb94b700/25597] [processingCycle, AmSession.cpp:368] DEBUG: vv S [8a5gsBas9x|3DF945DE-53446EFA0005096A-EBD4F700] Connected, running, 0 UACTransPending vv [#7fe7eb94b700/25597] [process, AmSession.cpp:713] DEBUG: AmSession processing event [#7fe7eb94b700/25597] [onRxRequest, AmSipDialog.cpp:132] DEBUG: AmSipDialog::onRxRequest(req = ACK) [#7fe7eb94b700/25597] [onSipRequest, AmB2BSession.cpp:345] DEBUG: filtering body for request 'ACK' (c/t '') [#7fe7eb94b700/25597] [filterBody, SBC.cpp:269] DEBUG: filtering SDP for request 'ACK' [#7fe7eb94b700/25597] [onSipRequest, AmB2BSession.cpp:371] DEBUG: relaying B2B SIP request ACK sip:[email protected]:5060 [#7fe7eb94b700/25597] [relayEvent, AmB2BSession.cpp:533] DEBUG: AmB2BSession::relayEvent: to other_id='1DDE9AF7-53446EFA0006072C-EB94B700' [#7fe7eb94b700/25597] [processingCycle, AmSession.cpp:386] DEBUG: ^^ S [8a5gsBas9x|3DF945DE-53446EFA0005096A-EBD4F700] Connected, running, 0 UACTransPending ^^ [#7fe7eb84a700/25598] [processingCycle, AmSession.cpp:368] DEBUG: vv S [74275120-53446EFA00060733-EB94B700|1DDE9AF7-53446EFA0006072C-EB94B700] Connected, running, 1 UACTransPending vv [#7fe7eb84a700/25598] [onB2BEvent, AmB2BSession.cpp:133] DEBUG: AmB2BSession::onB2BEvent [#7fe7eb84a700/25598] [onB2BEvent, AmB2BSession.cpp:143] DEBUG: B2BSipRequest: ACK (fwd=true) [#7fe7eb84a700/25598] [relaySip, AmB2BSession.cpp:772] DEBUG: sending relayed 200 ACK [#7fe7eb84a700/25598] [parse_sip_uri, parse_uri.cpp:328] DEBUG: Converted URI port (5060) to int (5060) [#7fe7eb84a700/25598] [set_next_hop, trans_layer.cpp:705] DEBUG: next_hop:next_port is <100.55.11.225:5060> [#7fe7eb84a700/25598] [set_destination_ip, trans_layer.cpp:716] DEBUG: checking whether '100.55.11.225' is IP address... [#7fe7eb84a700/25598] [set_destination_ip, trans_layer.cpp:758] DEBUG: set destination to 100.55.11.225:5060 [#7fe7eb84a700/25598] [send_request, trans_layer.cpp:910] DEBUG: send_request to R-URI <sip:[email protected]:5060> [#7fe7eb84a700/25598] [parse_sip_uri, parse_uri.cpp:328] DEBUG: Converted URI port (5060) to int (5060) [#7fe7eb84a700/25598] [parse_via_params, parse_via.cpp:525] DEBUG: parsed branch: z9hG4bKl0xcea1W [#7fe7eb84a700/25598] [parse_via_params, parse_via.cpp:548] DEBUG: has_rport: 1 [#7fe7eb84a700/25598] [send_request, trans_layer.cpp:980] DEBUG: Sending to 100.55.11.225:5060 <ACK sip:[email protected]:5060 SIP/2.0 Via...> [#7fe7eb84a700/25598] [send, transport.cpp:109] DEBUG: send msg --++-- ACK sip:[email protected]:5060 SIP/2.0 Via: SIP/2.0/UDP 10.0.0.19;branch=z9hG4bKl0xcea1W;rport From: <sip:[email protected]>;tag=1DDE9AF7-53446EFA0006072C-EB94B700 To: sip:[email protected];tag=gK02ed6f12 CSeq: 10 ACK Call-ID: 74275120-53446EFA00060733-EB94B700 Contact: <sip:100.0.0.19:5060> Content-Length: 0 --++-- [#7fe7eb84a700/25598] [send_request, trans_layer.cpp:992] DEBUG: update_uac_request tt->_t =(nil) [#7fe7eb84a700/25598] [match_request, trans_table.cpp:68] DEBUG: Matching ACK request [#7fe7eb84a700/25598] [match_request, trans_table.cpp:87] DEBUG: do_3261_match = 1 [#7fe7eb84a700/25598] [update_uac_request, trans_layer.cpp:1539] DEBUG: update_uac_request(200 ACK, t=0x7fe7d0002560) [#7fe7eb84a700/25598] [processingCycle, AmSession.cpp:386] DEBUG: ^^ S [74275120-53446EFA00060733-EB94B700|1DDE9AF7-53446EFA0006072C-EB94B700] Connected, running, 0 UACTransPending ^^ [#7fe7ebc4e700/25593] [run, udp_trsp.cpp:213] DEBUG: vv M [|] u recvd msg via UDP vv --++-- BYE sip:100.0.0.19:5060 SIP/2.0 Via: SIP/2.0/UDP 100.55.11.225:5060;branch=z9hG4bK02B787f53960509e0a6 From: sip:[email protected];tag=gK02ed6f12 To: <sip:[email protected]>;tag=1DDE9AF7-53446EFA0006072C-EB94B700 Call-ID: 74275120-53446EFA00060733-EB94B700 CSeq: 31038 BYE Max-Forwards: 70 Reason: Q.850;cause=16 Content-Length: 0
_______________________________________________ Sems mailing list [email protected] http://lists.iptel.org/mailman/listinfo/sems
