Skip to content

Instantly share code, notes, and snippets.

@phildunks

phildunks/error_with_createB2BUA.txt

Created June 28, 2019 14:29
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save phildunks/9960c4b3124fa720ac6bb694a254fbdf to your computer and use it in GitHub Desktop.
Save phildunks/9960c4b3124fa720ac6bb694a254fbdf to your computer and use it in GitHub Desktop.
Download ZIP
Race condition with createB2BUA
Raw
error_with_createB2BUA.txt
2019-06-28 14:24:50.154266 makeTags - hdr 'contact' replacing host with 192.168.47.161
2019-06-28 14:24:50.154308 makeTags - Adding well-known header 'contact' with value '<sip:mm2dev-slee@192.168.47.161:5060>'
2019-06-28 14:24:50.154357 SipDialogController::doSendRequestOutsideDialog - from: <sip:mm2dev-slee@192.168.47.161:5060>
2019-06-28 14:24:50.154396 SipDialogController::doSendRequestOutsideDialog - to: sip:1234@192.168.47.134:5060
2019-06-28 14:24:50.154434 SipDialogController::doSendRequestOutsideDialog - contact: <sip:192.168.47.161:5060>
2019-06-28 14:24:50.154473 SipDialogController::doSendRequestOutsideDialog - automatically detecting content-type as application/sdp
2019-06-28 14:24:50.154523 isLocalSipUri: checking to see if this is one of mine: sip:1234@192.168.47.134:5060
2019-06-28 14:24:50.154919 nta.c:4566 nta_leg_tcreate() nta_leg_tcreate(0x561a4287c6a0)
2019-06-28 14:24:50.155006 nta.c:2813 nta_tpn_by_url() nta: selecting scheme sip
2019-06-28 14:24:50.155070 tport.c:3285 tport_tsend() tport_tsend(0x561a428005a0) tpn = */192.168.47.134:5060
2019-06-28 14:24:50.155115 tport.c:4085 tport_resolve() tport_resolve addrinfo = 192.168.47.134:5060
2019-06-28 14:24:50.155252 tport.c:3531 tport_send_msg() tport_vsend returned 539
2019-06-28 14:24:50.155415 send 539 bytes to udp/[192.168.47.134]:5060 at 14:24:50.155162:
INVITE sip:1234@192.168.47.134:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.47.161;rport;branch=z9hG4bKXHHeX0jpZagme
Max-Forwards: 70
From: <sip:mm2dev-slee@192.168.47.161:5060>;tag=gvQjpm3g2Sr0j
To: <sip:1234@192.168.47.134:5060>
Call-ID: 5458056f-1453-1238-328e-0242ac110002
CSeq: 6312153 INVITE
Contact: <sip:mm2dev-slee@192.168.47.161:5060>
Content-Type: application/sdp
Content-Length: 139
v=0
o=user1 53655765 2353687637 IN IP4 192.168.47.161
s=-
c=IN IP4 192.168.47.161
t=0 0
m=audio 6000 RTP/AVP 0
a=rtpmap:0 PCMU/8000
2019-06-28 14:24:50.155478 nta.c:8470 outgoing_send() nta: sent INVITE (6312153) to */192.168.47.134:5060
2019-06-28 14:24:50.155549 tport.c:4199 tport_pend() tport_pend(0x561a428005a0): pending 0x561a42877f30 for udp/172.17.0.2:5060 (already 0)
2019-06-28 14:24:50.155606 nta.c:1411 set_timeout() nta: timer set to 32000 ms
2019-06-28 14:24:50.155658 nta.c:1409 set_timeout() nta: timer shortened to 1000 ms
2019-06-28 14:24:50.155725 SipDialog::SipDialog - creating dialog for outbound INVITE sent from udp/172.17.0.2:5060 to 192.168.47.134:5060
2019-06-28 14:24:50.155769 SipDialogController::addOutgoingInviteTransaction: adding leg 0x561a4287c6a0
2019-06-28 14:24:50.155846 No connected clients found to handle incoming cdr:attempt request
2019-06-28 14:24:50.155944 ClientController::removeApiRequest: clientMsgId 65bc96c6-9de8-48e7-9fae-d6e76d74fe8e; size: 0
2019-06-28 14:24:50.156151 Client::write_handler - wrote 730 bytes: system:0
2019-06-28 14:24:50.157926 tport.c:2777 tport_wakeup_pri() tport_wakeup_pri(0x561a428005a0): events IN
2019-06-28 14:24:50.158019 tport.c:2892 tport_recv_event() tport_recv_event(0x561a428005a0)
2019-06-28 14:24:50.158085 tport.c:3233 tport_recv_iovec() tport_recv_iovec(0x561a428005a0) msg 0x561a428916c0 from (udp/172.17.0.2:5060) has 360 bytes, veclen = 1
2019-06-28 14:24:50.158277 recv 360 bytes from udp/[192.168.47.134]:5060 at 14:24:50.158141:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.47.161;rport=57792;branch=z9hG4bKXHHeX0jpZagme
From: <sip:mm2dev-slee@192.168.47.161:5060>;tag=gvQjpm3g2Sr0j
To: <sip:1234@192.168.47.134:5060>
Call-ID: 5458056f-1453-1238-328e-0242ac110002
CSeq: 6312153 INVITE
User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20190606T174518Z~813a37d844~64bit
Content-Length: 0
2019-06-28 14:24:50.158344 tport.c:3051 tport_deliver() tport_deliver(0x561a428005a0): msg 0x561a428916c0 (360 bytes) from udp/192.168.47.134:5060 next=(nil)
2019-06-28 14:24:50.158417 nta.c:3448 agent_recv_response() nta: received 100 Trying for INVITE (6312153)
2019-06-28 14:24:50.158490 nta.c:3515 agent_recv_response() nta: 100 Trying is going to a transaction
2019-06-28 14:24:50.158560 nta.c:9734 outgoing_estimate_delay() nta_outgoing: RTT is 3.485 ms
2019-06-28 14:24:50.158604 tport.c:4261 tport_release() tport_release(0x561a428005a0): 0x561a42877f30 by 0x561a4287df20 with 0x561a428916c0 (preliminary)
2019-06-28 14:24:50.167107 tport.c:2777 tport_wakeup_pri() tport_wakeup_pri(0x561a428005a0): events IN
2019-06-28 14:24:50.167228 tport.c:2892 tport_recv_event() tport_recv_event(0x561a428005a0)
2019-06-28 14:24:50.167361 tport.c:3233 tport_recv_iovec() tport_recv_iovec(0x561a428005a0) msg 0x561a4288ff60 from (udp/172.17.0.2:5060) has 968 bytes, veclen = 1
2019-06-28 14:24:50.167905 recv 968 bytes from udp/[192.168.47.134]:5060 at 14:24:50.167431:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.47.161;rport=57792;branch=z9hG4bKXHHeX0jpZagme
From: <sip:mm2dev-slee@192.168.47.161:5060>;tag=gvQjpm3g2Sr0j
To: <sip:1234@192.168.47.134:5060>;tag=yHU086rytt7pS
Call-ID: 5458056f-1453-1238-328e-0242ac110002
CSeq: 6312153 INVITE
Contact: <sip:1234@192.168.47.134:5060;transport=udp>
User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20190606T174518Z~813a37d844~64bit
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REFER, NOTIFY
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, refer
Session-Expires: 1800;refresher=uas
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 168
Remote-Party-ID: "1234" <sip:1234@192.168.47.134>;party=calling;privacy=off;screen=no
v=0
o=FreeSWITCH 1561695738 1561695739 IN IP4 192.168.47.134
s=FreeSWITCH
c=IN IP4 192.168.47.134
t=0 0
m=audio 36152 RTP/AVP 0
a=rtpmap:0 PCMU/8000
a=ptime:20
2019-06-28 14:24:50.167985 tport.c:3051 tport_deliver() tport_deliver(0x561a428005a0): msg 0x561a4288ff60 (968 bytes) from udp/192.168.47.134:5060 next=(nil)
2019-06-28 14:24:50.168047 nta.c:3448 agent_recv_response() nta: received 200 OK for INVITE (6312153)
2019-06-28 14:24:50.168110 nta.c:3515 agent_recv_response() nta: 200 OK is going to a transaction
2019-06-28 14:24:50.168169 tport.c:4261 tport_release() tport_release(0x561a428005a0): 0x561a42877f30 by 0x561a4287df20 with 0x561a4288ff60
2019-06-28 14:24:50.168231 SipDialogController::processResponseOutsideDialog
2019-06-28 14:24:50.168294 SipDialogController::processResponse - adding dialog id: 5458056f-1453-1238-328e-0242ac110002;from-tag=gvQjpm3g2Sr0j
2019-06-28 14:24:50.168358 ClientController::addDialogForTransaction - added dialog (uac), now tracking: 8 dialogs and 1 app transactions
2019-06-28 14:24:50.168415 ClientController::addDialogForTransaction - transaction id 23f18400-71f3-4ee1-afb3-d3b9591cb8e3 has associated dialog 5458056f-1453-1238-328e-0242ac110002;from-tag=gvQjpm3g2Sr0j
2019-06-28 14:24:50.168497 timerD: Adding entry to go off in 32500ms
2019-06-28 14:24:50.168552 timerD: Adding entry to the head (queue was empty), length: 1
2019-06-28 14:24:50.168611 TimerDHandler::addInvite 0x561a4287df20, 5458056f-1453-1238-328e-0242ac1100026312153
2019-06-28 14:24:50.168722 ClientController::removeAppTransaction: transactionId 23f18400-71f3-4ee1-afb3-d3b9591cb8e3; size: 0
2019-06-28 14:24:50.168796 No connected clients found to handle incoming cdr:start request
2019-06-28 14:24:50.168950 Client::write_handler - wrote 1165 bytes: system:0
2019-06-28 14:24:50.210538 Client::read_handler read: c9c22778-6507-407f-97cc-72ca8303060e|sip||5458056f-1453-1238-328e-0242ac110002;from-tag=gvQjpm3g2Sr0j
ACK sip:1234@192.168.47.134:5060 SIP/2.0
Content-Length: 0
2019-06-28 14:24:50.211380 Client::processMessage - got request with 4 tokens
2019-06-28 14:24:50.212448 Client::processMessage - request id c9c22778-6507-407f-97cc-72ca8303060e, request type: sip transaction id: , dialog id: 5458056f-1453-1238-328e-0242ac110002;from-tag=gvQjpm3g2Sr0j
2019-06-28 14:24:50.212515 Client::processMessage - sending a request inside a dialog (dialogId provided)
2019-06-28 14:24:50.212584 ClientController::addApiRequest: clientMsgId c9c22778-6507-407f-97cc-72ca8303060e; size: 1
2019-06-28 14:24:50.213869 SipDialogController::doSendRequestInsideDialog dialog id: 5458056f-1453-1238-328e-0242ac110002;from-tag=gvQjpm3g2Sr0j
2019-06-28 14:24:50.214394 SipDialogController::doSendRequestInsideDialog - defaulting request uri to sip:1234@192.168.47.134:5060;transport=udp
2019-06-28 14:24:50.214444 DrachtioController::findTportForSubscription: no transport found for 1234@192.168.47.134
2019-06-28 14:24:50.214521 nta.c:2813 nta_tpn_by_url() nta: selecting scheme sip
2019-06-28 14:24:50.214591 tport.c:3285 tport_tsend() tport_tsend(0x561a428005a0) tpn = udp/192.168.47.134:5060
2019-06-28 14:24:50.214631 tport.c:4085 tport_resolve() tport_resolve addrinfo = 192.168.47.134:5060
2019-06-28 14:24:50.214752 tport.c:3531 tport_send_msg() tport_vsend returned 345
2019-06-28 14:24:50.214895 send 345 bytes to udp/[192.168.47.134]:5060 at 14:24:50.214671:
ACK sip:1234@192.168.47.134:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP 192.168.47.161;rport;branch=z9hG4bKyta7yU3SvK66S
Max-Forwards: 70
From: <sip:mm2dev-slee@192.168.47.161:5060>;tag=gvQjpm3g2Sr0j
To: <sip:1234@192.168.47.134:5060>;tag=yHU086rytt7pS
Call-ID: 5458056f-1453-1238-328e-0242ac110002
CSeq: 6312153 ACK
Content-Length: 0
2019-06-28 14:24:50.214975 nta.c:8470 outgoing_send() nta: sent ACK (6312153) to udp/192.168.47.134:5060
2019-06-28 14:24:50.215046 TimerDHandler::addAck 0x561a4288f250, 5458056f-1453-1238-328e-0242ac1100026312153
2019-06-28 14:24:50.214918 Client::read_handler read: 2dadcb50-e9d4-4177-a756-8f0ad73b862a|sip|229b40cd-fed8-4844-afcd-2cf678a7c293|
SIP/2.0 200 OK
Call-ID: VbLKOt47J6
cseq: 1 INVITE
from: "mm2dev-slee"<sip:mm2dev-slee@192.168.46.213>;tag=1213582515617318901111.0
to: <sip:msml@192.168.47.161:5060>
Content-Length: 168
v=0
o=FreeSWITCH 1561695738 1561695739 IN IP4 192.168.47.134
s=FreeSWITCH
c=IN IP4 192.168.47.134
t=0 0
m=audio 36152 RTP/AVP 0
a=rtpmap:0 PCMU/8000
a=ptime:20
2019-06-28 14:24:50.215101 SipDialogController::doSendRequestInsideDialog - clearing IIP that we generated as uac
2019-06-28 14:24:50.219149 SipDialogController::clearIIP: clearing leg 0x561a4287c6a0, irq: 0, orq: 0x561a4287df20, rel: 0
2019-06-28 14:24:50.219224 SipDialogController::clearIIP: clearing m_mapOrq2IIP for leg 0x561a4287c6a0
2019-06-28 14:24:50.219343 ClientController::removeApiRequest: clientMsgId c9c22778-6507-407f-97cc-72ca8303060e; size: 0
2019-06-28 14:24:50.224763 Client::processMessage - got request with 4 tokens
2019-06-28 14:24:50.224910 Client::processMessage - request id 2dadcb50-e9d4-4177-a756-8f0ad73b862a, request type: sip transaction id: 229b40cd-fed8-4844-afcd-2cf678a7c293, dialog id:
2019-06-28 14:24:50.224970 ClientController::addApiRequest: clientMsgId 2dadcb50-e9d4-4177-a756-8f0ad73b862a; size: 1
2019-06-28 14:24:50.225290 Client::write_handler - wrote 536 bytes: system:0
2019-06-28 14:24:50.225402 SipDialogController::doRespondToSipRequest thread 139856003069760
2019-06-28 14:24:50.225480 SipDialogController::findAndRemoveTransactionIdForIncomingRequest - searching transactionId 229b40cd-fed8-4844-afcd-2cf678a7c293
2019-06-28 14:24:50.225585 SipDialogController::findAndRemoveTransactionIdForIncomingRequest - failed to find transactionId 229b40cd-fed8-4844-afcd-2cf678a7c293, most likely this is a response to an invite we sent
2019-06-28 14:24:50.225772 pending-request: removing entry, prior to removal length: 1
2019-06-28 14:24:50.225868 pending-request: removed entry, timer not set (queue is empty after removal), length: 0
2019-06-28 14:24:50.226143 nta.c:1409 set_timeout() nta: timer shortened to 200 ms
2019-06-28 14:24:50.226476 nta.c:4566 nta_leg_tcreate() nta_leg_tcreate(0x561a42883020)
2019-06-28 14:24:50.226594 DrachtioController::setupLegForIncomingRequest - created leg: 0x561a42883020, irq: 0x561a4288d550, for transactionId: 229b40cd-fed8-4844-afcd-2cf678a7c293
2019-06-28 14:24:50.226714 SipDialog::SipDialog - (UAS) detected client behind nat, using 172.17.0.1:55425 as route for requests within this dialog
2019-06-28 14:24:50.226864 SipDialog::SipDialog - creating dialog for inbound INVITE sent from UDP/172.17.0.2:5060
2019-06-28 14:24:50.227018 SipDialogController::addIncomingInviteTransaction: added iip: 0x561a4288e610 with leg 0x561a42883020, irq: 0x561a4288d550, transactionId 229b40cd-fed8-4844-afcd-2cf678a7c293, iip size: 1
2019-06-28 14:24:50.227269 SipDialogController::doRespondToSipRequest found invite or subscribe in progress 0x561a4288e610
2019-06-28 14:24:50.227344 SipTransport::getContactUri - created Contact header: sip:192.168.47.161:5060
2019-06-28 14:24:50.227784 makeTags - Adding well-known header 'Call-ID' with value 'VbLKOt47J6'
2019-06-28 14:24:50.227842 makeTags - Adding well-known header 'cseq' with value '1 INVITE'
2019-06-28 14:24:50.227894 makeTags - Adding well-known header 'from' with value '"mm2dev-slee"<sip:mm2dev-slee@192.168.46.213>;tag=1213582515617318901111.0'
2019-06-28 14:24:50.227962 makeTags - Adding well-known header 'to' with value '<sip:msml@192.168.47.161:5060>'
2019-06-28 14:24:50.228017 Sending 200 response (not reliably) on irq 0x561a4288d550
2019-06-28 14:24:50.228090 tport.c:3285 tport_tsend() tport_tsend(0x561a428005a0) tpn = UDP/172.17.0.1:55425
2019-06-28 14:24:50.228134 tport.c:4085 tport_resolve() tport_resolve addrinfo = 172.17.0.1:55425
2019-06-28 14:24:50.228290 tport.c:3531 tport_send_msg() tport_vsend returned 555
2019-06-28 14:24:50.228434 send 555 bytes to udp/[172.17.0.1]:55425 at 14:24:50.228183:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.46.213:5062;branch=z9hG4bKnopaTFRgbj2XNFYh5rRqw1;received=172.17.0.1;rport=55425
From: "mm2dev-slee" <sip:mm2dev-slee@192.168.46.213>;tag=1213582515617318901111.0
To: <sip:msml@192.168.47.161:5060>;tag=H5gBrFmmZ2eKe
Call-ID: VbLKOt47J6
CSeq: 1 INVITE
Contact: <sip:192.168.47.161:5060>
Content-Type: application/sdp
Content-Length: 168
v=0
o=FreeSWITCH 1561695738 1561695739 IN IP4 192.168.47.134
s=FreeSWITCH
c=IN IP4 192.168.47.134
t=0 0
m=audio 36152 RTP/AVP 0
a=rtpmap:0 PCMU/8000
a=ptime:20
2019-06-28 14:24:50.228507 nta.c:6939 incoming_reply() nta: sent 200 OK for INVITE (1)
2019-06-28 14:24:50.228576 ClientController::addDialogForTransaction - added dialog (uas), now tracking: 9 dialogs and 1 net transactions
2019-06-28 14:24:50.228655 ClientController::addDialogForTransaction - transaction id 229b40cd-fed8-4844-afcd-2cf678a7c293 has associated dialog VbLKOt47J6;from-tag=1213582515617318901111.0
2019-06-28 14:24:50.228758 timerG: Adding entry to go off in 500ms
2019-06-28 14:24:50.228849 timerG: Adding entry to the head (queue was empty), length: 1
2019-06-28 14:24:50.229022 timerH: Adding entry to go off in 32000ms
2019-06-28 14:24:50.229124 timerH: Adding entry to the head (queue was empty), length: 1
2019-06-28 14:24:50.229291 ClientController::removeApiRequest: clientMsgId 2dadcb50-e9d4-4177-a756-8f0ad73b862a; size: 0
2019-06-28 14:24:50.229746 Client::write_handler - wrote 793 bytes: system:0
2019-06-28 14:24:50.230030 No connected clients found to handle incoming cdr:start request
2019-06-28 14:24:50.241946 tport.c:2777 tport_wakeup_pri() tport_wakeup_pri(0x561a428005a0): events IN
2019-06-28 14:24:50.242070 tport.c:2892 tport_recv_event() tport_recv_event(0x561a428005a0)
2019-06-28 14:24:50.242126 tport.c:3233 tport_recv_iovec() tport_recv_iovec(0x561a428005a0) msg 0x561a42896850 from (udp/172.17.0.2:5060) has 321 bytes, veclen = 1
2019-06-28 14:24:50.242318 recv 321 bytes from udp/[172.17.0.1]:55425 at 14:24:50.242169:
ACK sip:192.168.47.161:5060 SIP/2.0
Max-Forwards: 70
Content-Length: 0
To: <sip:msml@192.168.47.161:5060>;tag=H5gBrFmmZ2eKe
CSeq: 1 ACK
Via: SIP/2.0/UDP 192.168.46.213:5062;branch=z9hG4bKn9X5Sa1k6TTgciEbQHG1r1
Call-ID: VbLKOt47J6
From: "mm2dev-slee"<sip:mm2dev-slee@192.168.46.213>;tag=1213582515617318901111.0
2019-06-28 14:24:50.242385 tport.c:3051 tport_deliver() tport_deliver(0x561a428005a0): msg 0x561a42896850 (321 bytes) from udp/172.17.0.1:5060 next=(nil)
2019-06-28 14:24:50.242462 nta.c:3028 agent_recv_request() nta: received ACK sip:192.168.47.161:5060 SIP/2.0 (CSeq 1)
2019-06-28 14:24:50.242550 nta.c:3323 agent_check_request_via() nta: Via check: received=172.17.0.1
2019-06-28 14:24:50.242599 nta.c:3397 agent_aliases() nta: canonizing sip:192.168.47.161:5060 with contact
2019-06-28 14:24:50.242693 nta.c:3209 agent_recv_request() nta: ACK (1) going to existing leg
2019-06-28 14:24:50.242761 DrachtioController::processRequestInsideDialog
2019-06-28 14:24:50.242827 SipDialogController::processRequestInsideDialog: ACK irq 0x561a42889ab0
2019-06-28 14:24:50.242881 SipDialogController::clearIIP: clearing leg 0x561a42883020, irq: 0x561a4288d550, orq: 0, rel: 0
2019-06-28 14:24:50.242930 SipDialogController::clearIIP: clearing m_mapIrq2IIP for leg 0x561a42883020
2019-06-28 14:24:50.242980 SipDialogController::clearSipTimers for VbLKOt47J6
2019-06-28 14:24:50.243027 timerG: removing entry, prior to removal length: 1
2019-06-28 14:24:50.243074 timerG: removed entry, timer not set (queue is empty after removal), length: 0
2019-06-28 14:24:50.243123 timerH: removing entry, prior to removal length: 1
2019-06-28 14:24:50.243162 timerH: removed entry, timer not set (queue is empty after removal), length: 0
2019-06-28 14:24:50.243274 Client::write_handler - wrote 528 bytes: system:0
2019-06-28 14:24:50.243321 ClientController::removeNetTransaction: transactionId 229b40cd-fed8-4844-afcd-2cf678a7c293; size: 0
2019-06-28 14:24:50.243355 ClientController::route_ack_request_inside_dialog - removed incoming invite transaction, map size is now: 0 request
2019-06-28 14:24:50.243394 nta.c:5892 incoming_free() nta: incoming_free(0x561a42889ab0)
2019-06-28 14:24:50.243473 tport.c:2777 tport_wakeup_pri() tport_wakeup_pri(0x561a428005a0): events IN
2019-06-28 14:24:50.243555 tport.c:2892 tport_recv_event() tport_recv_event(0x561a428005a0)
2019-06-28 14:24:50.243607 tport.c:3233 tport_recv_iovec() tport_recv_iovec(0x561a428005a0) msg 0x561a428916c0 from (udp/172.17.0.2:5060) has 954 bytes, veclen = 1
2019-06-28 14:24:50.243827 recv 954 bytes from udp/[172.17.0.1]:55425 at 14:24:50.243664:
INFO sip:192.168.47.161:5060 SIP/2.0
Content-Length: 561
To: <sip:msml@192.168.47.161:5060>;tag=H5gBrFmmZ2eKe
Contact: <sip:192.168.46.213:5062;transport=UDP>
CSeq: 2 INFO
Via: SIP/2.0/UDP 192.168.46.213:5062;branch=z9hG4bKnd6FE1DLjbEfO1cZx0s6b1
Call-ID: VbLKOt47J6
Content-Type: application/msml+xml
From: "mm2dev-slee"<sip:mm2dev-slee@192.168.46.213>;tag=1213582515617318901111.0
<?xml version='1.0' encoding='US-ASCII'?>
<msml version='1.1'>
<dialogstart target='conn:H5gBrFmmZ2eKe' type='application/moml+xml' >
<play cvd:barge='true' cvd:cleardb='false' >
<audio uri='file://provisioned/bt/MM2/eng/pin_prompt.wav' />
</play>
<dtmf fdt='10s' idt='20s' edt='20s' cleardb='false' >
<pattern digits='min=1;max=27;rtk=#' format='moml+digits'>
<exit namelist='dtmf.digits dtmf.end'/>
</pattern>
<noinput><exit namelist='dtmf.digits dtmf.end'/></noinput>
<nomatch><exit namelist='dtmf.digits dtmf.end'/></nomatch>
</dtmf>
</dialogstart>
</msml>
2019-06-28 14:24:50.243875 tport.c:3051 tport_deliver() tport_deliver(0x561a428005a0): msg 0x561a428916c0 (954 bytes) from udp/172.17.0.1:5060 next=(nil)
2019-06-28 14:24:50.243924 nta.c:3028 agent_recv_request() nta: received INFO sip:192.168.47.161:5060 SIP/2.0 (CSeq 2)
2019-06-28 14:24:50.244004 nta.c:3323 agent_check_request_via() nta: Via check: received=172.17.0.1
2019-06-28 14:24:50.244051 nta.c:3397 agent_aliases() nta: canonizing sip:192.168.47.161:5060 with contact
2019-06-28 14:24:50.244088 nta.c:3209 agent_recv_request() nta: INFO (2) going to existing leg
2019-06-28 14:24:50.244150 DrachtioController::processRequestInsideDialog
2019-06-28 14:24:50.244195 SipDialogController::processRequestInsideDialog: INFO irq 0x561a428926a0
2019-06-28 14:24:50.244261 ClientController::addNetTransaction: transactionId 49f95273-36de-47d5-a52c-5e60194dd71b; size: 1
2019-06-28 14:24:50.244525 Client::write_handler - wrote 1165 bytes: system:0
2019-06-28 14:24:50.244579 SipDialogController::addIncomingRequestTransaction - adding transactionId 49f95273-36de-47d5-a52c-5e60194dd71b for irq:0x561a428926a0
2019-06-28 14:24:50.257921 Client::read_handler read: 047b429d-6ecc-4717-a83c-e038ed72d6f3|sip|49f95273-36de-47d5-a52c-5e60194dd71b|
SIP/2.0 200 OK
Call-ID: VbLKOt47J6
cseq: 2 INFO
from: "mm2dev-slee"<sip:mm2dev-slee@192.168.46.213>;tag=1213582515617318901111.0
to: <sip:msml@192.168.47.161:5060>;tag=H5gBrFmmZ2eKe
Content-Length: 0
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment