From Keith Murray, 6 Years ago, written in Plain Text.
- view diff
Embed
  1. 2018-01-08 13:19:10.279480 [NOTICE] mod_logfile.c:213 New log started.
  2. 2018-01-08 13:19:10.279480 [NOTICE] mod_cdr_csv.c:127 Rotated CDR logfile C:\Streem\LogFiles\freeswitch/cdr-csv/Master.csv
  3. 1790ebfe-b1a0-4833-9ef2-7b7d03fd6002 2018-01-08 13:19:46.699587 [NOTICE] switch_channel.c:1104 New Channel sofia/external/18156548285 [1790ebfe-b1a0-4833-9ef2-7b7d03fd6002]
  4. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:529 nua_signal() nua(000000DB8F7B77A0): sent signal r_invite
  5. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:569 nua_stack_signal() nua(000000DB8F7B77A0): recv signal r_invite
  6. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:280 soa_clone() soa_clone(static::000000DB8F2E3F60, 000000DB8F5301B0, 000000DB8F7B77A0) called
  7. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:403 soa_set_params() soa_set_params(static::000000DB8F9933D0, ...) called
  8. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:403 soa_set_params() soa_set_params(static::000000DB8F9933D0, ...) called
  9. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1052 soa_set_user_sdp() soa_set_user_sdp(static::000000DB8F9933D0, 0000000000000000, 000000DB9102FE57, -1) called
  10. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:890 soa_set_capability_sdp() soa_set_capability_sdp(static::000000DB8F9933D0, 0000000000000000, 000000DB9102FE57, -1) called
  11. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_dialog.c:338 nua_dialog_usage_add() nua(000000DB8F7B77A0): adding session usage
  12. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:4417 nta_leg_tcreate() nta_leg_tcreate(000000DB8F7AED90)
  13. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1302 soa_init_offer_answer() soa_init_offer_answer(static::000000DB8F9933D0) called
  14. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1426 soa_generate_offer() soa_generate_offer(static::000000DB8F9933D0, 0) called
  15. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1148 offer_answer_step() soa_static_offer_answer_action(000000DB8F9933D0, soa_generate_offer): called
  16. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1189 offer_answer_step() soa_static(000000DB8F9933D0, soa_generate_offer): generating local description
  17. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1217 offer_answer_step() soa_static(000000DB8F9933D0, soa_generate_offer): upgrade with local description
  18. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1029 soa_sdp_mode_set() soa_sdp_mode_set(000000DB9064D660, 0000000000000000, ""): called
  19. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1446 offer_answer_step() soa_static(000000DB8F9933D0, soa_generate_offer): storing local description
  20. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1270 soa_get_local_sdp() soa_get_local_sdp(static::000000DB8F9933D0, [0000000000000000], [000000DB9064F7B0], [000000DB9064F7E8]) called
  21. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:2665 nta_tpn_by_url() nta: selecting scheme sip
  22. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3257 tport_tsend() tport_tsend(000000DB8F2E4C10) tpn = */10.10.5.14:5060
  23. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4046 tport_resolve() tport_resolve addrinfo = 10.10.5.14:5060
  24. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4680 tport_by_addrinfo() tport(000000DB8F2E4C10): not found by name */10.10.5.14:5060
  25. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3594 tport_vsend() tport_vsend(000000DB8F2E4C10): 1145 bytes of 1145 to udp/10.10.5.14:5060
  26. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3492 tport_send_msg() tport_vsend returned 1145
  27. send 1145 bytes to udp/[10.10.5.14]:5060 at 19:19:46.705499:
  28.    ------------------------------------------------------------------------
  29.    INVITE sip:18156548285@10.10.5.14 SIP/2.0
  30.    Via: SIP/2.0/UDP 10.10.101.238:5080;rport;branch=z9hG4bK5c1vgeDUmZHBa
  31.    Max-Forwards: 70
  32.    From: "SUPPORTSTREEMVM" <sip:1000@10.10.5.14>;tag=66mNXc2Z3m12B
  33.    To: <sip:18156548285@10.10.5.14>
  34.    Call-ID: bae55b93-6f4b-1236-cf98-dd1cb2d72f2a
  35.    CSeq: 117383529 INVITE
  36.    Contact: <sip:gw+10.10.5.14@10.10.101.238:5080;transport=udp;gw=10.10.5.14>
  37.    User-Agent: FreeSWITCH-mod_sofia/1.6.19+git~20171109T180403Z~27aebc7253~64bit
  38.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  39.    Supported: timer, path, replaces
  40.    Allow-Events: talk, hold, conference, refer
  41.    Content-Type: application/sdp
  42.    Content-Disposition: session
  43.    Content-Length: 293
  44.    X-FS-Support: update_display,send_info
  45.    Remote-Party-ID: "SUPPORTSTREEMVM" <sip:8887344585@10.10.5.14>;party=calling;screen=yes;privacy=off
  46.    
  47.    v=0
  48.    o=FreeSWITCH 1515382836 1515382837 IN IP4 10.10.101.238
  49.    s=FreeSWITCH
  50.    c=IN IP4 10.10.101.238
  51.    t=0 0
  52.    m=audio 56350 RTP/AVP 0 8 3 101 13
  53.    a=rtpmap:0 PCMU/8000
  54.    a=rtpmap:8 PCMA/8000
  55.    a=rtpmap:3 GSM/8000
  56.    a=rtpmap:101 telephone-event/8000
  57.    a=fmtp:101 0-16
  58.    a=rtpmap:13 CN/8000
  59.    a=ptime:20
  60.    ------------------------------------------------------------------------
  61. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:8304 outgoing_send() nta: sent INVITE (117383529) to */10.10.5.14:5060
  62. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4160 tport_pend() tport_pend(000000DB8F2E4C10): pending 000000DB8F5A0CB0 for udp/10.10.101.238:5080 (already 0)
  63. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:1350 set_timeout() nta: timer set to 32000 ms
  64. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:1348 set_timeout() nta: timer shortened to 1000 ms
  65. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_session.c:4139 signal_call_state_change() nua(000000DB8F7B77A0): call state changed: init -> calling, sent offer
  66. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1270 soa_get_local_sdp() soa_get_local_sdp(static::000000DB8F9933D0, [000000DB9064F780], [000000DB9064F790], [0000000000000000]) called
  67. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:269 nua_stack_event() nua(000000DB8F7B77A0): event i_state INVITE sent
  68. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2749 tport_wakeup_pri() tport_wakeup_pri(000000DB8F2E4C10): events IN
  69. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2864 tport_recv_event() tport_recv_event(000000DB8F2E4C10)
  70. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3205 tport_recv_iovec() tport(000000DB8F2E4C10) msg 000000DB8F5A2330 from (udp/10.10.101.238:5080) has 308 bytes, veclen = 1
  71. recv 308 bytes from udp/[10.10.5.14]:1028 at 19:19:46.722506:
  72.    ------------------------------------------------------------------------
  73.    SIP/2.0 100 Trying
  74.    From:"SUPPORTSTREEMVM"<sip:1000@10.10.5.14>;tag=66mNXc2Z3m12B
  75.    To:<sip:18156548285@10.10.5.14>
  76.    Call-ID:bae55b93-6f4b-1236-cf98-dd1cb2d72f2a
  77.    CSeq:117383529 INVITE
  78.    Server:PBX-IP Media Gateway/2.1
  79.    Via:SIP/2.0/UDP 10.10.101.238:5080;rport;branch=z9hG4bK5c1vgeDUmZHBa
  80.    Content-Length:0
  81.    
  82.    ------------------------------------------------------------------------
  83. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3023 tport_deliver() tport(000000DB8F2E4C10): msg 000000DB8F5A2330 (308 bytes) from udp/10.10.5.14:5080/sip next=0000000000000000
  84. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3299 agent_recv_response() nta: received 100 Trying for INVITE (117383529)
  85. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3366 agent_recv_response() nta: 100 Trying is going to a transaction
  86. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:9564 outgoing_estimate_delay() nta_outgoing: RTT is 17.007 ms
  87. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4222 tport_release() tport(000000DB8F2E4C10): 000000DB8F5A0CB0 by 000000DB8F3A5E50 with 000000DB8F5A2330 (preliminary)
  88. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:1289 agent_timer() nta: timer not set
  89. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2749 tport_wakeup_pri() tport_wakeup_pri(000000DB8F2E4C10): events IN
  90. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2864 tport_recv_event() tport_recv_event(000000DB8F2E4C10)
  91. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3205 tport_recv_iovec() tport(000000DB8F2E4C10) msg 000000DB8F5A08F0 from (udp/10.10.101.238:5080) has 556 bytes, veclen = 1
  92. recv 556 bytes from udp/[10.10.5.14]:1028 at 19:19:47.763593:
  93.    ------------------------------------------------------------------------
  94.    SIP/2.0 180 Ringing
  95.    Reason:Q.931;progress_indicator=8;text="In-band information or an appropriate pattern is now available"
  96.    Contact:<sip:18156548285@10.10.5.14:5060>
  97.    Allow:INVITE,ACK,OPTIONS,BYE,CANCEL,REGISTER,INFO,PRACK,REFER,NOTIFY
  98.    From:"SUPPORTSTREEMVM"<sip:1000@10.10.5.14>;tag=66mNXc2Z3m12B
  99.    To:<sip:18156548285@10.10.5.14>;tag=60DC324631353641000011D3
  100.    Call-ID:bae55b93-6f4b-1236-cf98-dd1cb2d72f2a
  101.    CSeq:117383529 INVITE
  102.    Server:PBX-IP Media Gateway/2.1
  103.    Via:SIP/2.0/UDP 10.10.101.238:5080;rport;branch=z9hG4bK5c1vgeDUmZHBa
  104.    Content-Length:0
  105.    
  106.    ------------------------------------------------------------------------
  107. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3023 tport_deliver() tport(000000DB8F2E4C10): msg 000000DB8F5A08F0 (556 bytes) from udp/10.10.5.14:5080/sip next=0000000000000000
  108. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3299 agent_recv_response() nta: received 180 Ringing for INVITE (117383529)
  109. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3366 agent_recv_response() nta: 180 Ringing is going to a transaction
  110. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4222 tport_release() tport(000000DB8F2E4C10): 000000DB8F5A0CB0 by 000000DB8F3A5E50 with 000000DB8F5A08F0 (preliminary)
  111. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B77A0): event r_invite 180 Ringing
  112. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_session.c:4139 signal_call_state_change() nua(000000DB8F7B77A0): call state changed: calling -> proceeding
  113. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B77A0): event i_state 180 Ringing
  114. 1790ebfe-b1a0-4833-9ef2-7b7d03fd6002 2018-01-08 13:19:47.759594 [NOTICE] sofia.c:7192 Ring-Ready sofia/external/18156548285!
  115. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2749 tport_wakeup_pri() tport_wakeup_pri(000000DB8F2E4C10): events IN
  116. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2864 tport_recv_event() tport_recv_event(000000DB8F2E4C10)
  117. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3205 tport_recv_iovec() tport(000000DB8F2E4C10) msg 000000DB8F5A1070 from (udp/10.10.101.238:5080) has 451 bytes, veclen = 1
  118. recv 451 bytes from udp/[10.10.5.14]:1028 at 19:19:49.785758:
  119.    ------------------------------------------------------------------------
  120.    SIP/2.0 180 Ringing
  121.    Contact:<sip:18156548285@10.10.5.14:5060>
  122.    Allow:INVITE,ACK,OPTIONS,BYE,CANCEL,REGISTER,INFO,PRACK,REFER,NOTIFY
  123.    From:"SUPPORTSTREEMVM"<sip:1000@10.10.5.14>;tag=66mNXc2Z3m12B
  124.    To:<sip:18156548285@10.10.5.14>;tag=60DC324631353641000011D3
  125.    Call-ID:bae55b93-6f4b-1236-cf98-dd1cb2d72f2a
  126.    CSeq:117383529 INVITE
  127.    Server:PBX-IP Media Gateway/2.1
  128.    Via:SIP/2.0/UDP 10.10.101.238:5080;rport;branch=z9hG4bK5c1vgeDUmZHBa
  129.    Content-Length:0
  130.    
  131.    ------------------------------------------------------------------------
  132. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3023 tport_deliver() tport(000000DB8F2E4C10): msg 000000DB8F5A1070 (451 bytes) from udp/10.10.5.14:5080/sip next=0000000000000000
  133. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3299 agent_recv_response() nta: received 180 Ringing for INVITE (117383529)
  134. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3366 agent_recv_response() nta: 180 Ringing is going to a transaction
  135. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4222 tport_release() tport(000000DB8F2E4C10): 000000DB8F5A0CB0 by 000000DB8F3A5E50 with 000000DB8F5A1070 (preliminary)
  136. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B77A0): event r_invite 180 Ringing
  137. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_session.c:4139 signal_call_state_change() nua(000000DB8F7B77A0): call state changed: proceeding -> proceeding
  138. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B77A0): event i_state 180 Ringing
  139. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2749 tport_wakeup_pri() tport_wakeup_pri(000000DB8F2E4C10): events IN
  140. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2864 tport_recv_event() tport_recv_event(000000DB8F2E4C10)
  141. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3205 tport_recv_iovec() tport(000000DB8F2E4C10) msg 000000DB8F5A1F70 from (udp/10.10.101.238:5080) has 747 bytes, veclen = 1
  142. recv 747 bytes from udp/[10.10.5.14]:1028 at 19:19:52.934016:
  143.    ------------------------------------------------------------------------
  144.    SIP/2.0 200 OK
  145.    Content-Type:application/sdp
  146.    Supported:replaces,100rel
  147.    Contact:<sip:18156548285@10.10.5.14:5060>
  148.    Reason:E.182;text="Fax"
  149.    Allow:INVITE,ACK,OPTIONS,BYE,CANCEL,REGISTER,INFO,PRACK,REFER,NOTIFY
  150.    From:"SUPPORTSTREEMVM"<sip:1000@10.10.5.14>;tag=66mNXc2Z3m12B
  151.    To:<sip:18156548285@10.10.5.14>;tag=60DC324631353641000011D3
  152.    Call-ID:bae55b93-6f4b-1236-cf98-dd1cb2d72f2a
  153.    CSeq:117383529 INVITE
  154.    Server:PBX-IP Media Gateway/2.1
  155.    Via:SIP/2.0/UDP 10.10.101.238:5080;rport;branch=z9hG4bK5c1vgeDUmZHBa
  156.    Content-Length:217
  157.    
  158.    v=0
  159.    o=phone 14740 9006 IN IP4 10.10.5.14
  160.    s=-
  161.    c=IN IP4 10.10.5.14
  162.    t=0 0
  163.    m=audio 49008 RTP/AVP 0 101 13
  164.    a=rtpmap:0 PCMU/8000/1
  165.    a=ptime:20
  166.    a=rtpmap:101 telephone-event/8000
  167.    a=fmtp:101 0-15
  168.    a=rtpmap:13 CN/8000
  169.    ------------------------------------------------------------------------
  170. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3023 tport_deliver() tport(000000DB8F2E4C10): msg 000000DB8F5A1F70 (747 bytes) from udp/10.10.5.14:5080/sip next=0000000000000000
  171. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3299 agent_recv_response() nta: received 200 OK for INVITE (117383529)
  172. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3366 agent_recv_response() nta: 200 OK is going to a transaction
  173. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4222 tport_release() tport(000000DB8F2E4C10): 000000DB8F5A0CB0 by 000000DB8F3A5E50 with 000000DB8F5A1F70
  174. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:1350 set_timeout() nta: timer set to 32000 ms
  175. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1171 soa_set_remote_sdp() soa_set_remote_sdp(static::000000DB8F9933D0, 0000000000000000, 000000DB90B3D222, 217) called
  176. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1595 soa_process_answer() soa_process_answer(static::000000DB8F9933D0) called
  177. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1148 offer_answer_step() soa_static_offer_answer_action(000000DB8F9933D0, soa_process_answer): called
  178. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1029 soa_sdp_mode_set() soa_sdp_mode_set(000000DB8E4E62F0, 000000DB8F325C10, ""): called
  179. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1304 offer_answer_step() soa_static(000000DB8F9933D0, soa_process_answer): upgrade codecs with remote description
  180. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1446 offer_answer_step() soa_static(000000DB8F9933D0, soa_process_answer): storing local description
  181. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1730 soa_activate() soa_activate(static::000000DB8F9933D0, (nil)) called
  182. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_session.c:988 nua_session_client_response() nua(000000DB8F7B77A0): INVITE: processed SDP answer in 200 OK
  183. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B77A0): event r_invite 200 OK
  184. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_session.c:4139 signal_call_state_change() nua(000000DB8F7B77A0): call state changed: proceeding -> completing, received answer
  185. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1098 soa_get_remote_sdp() soa_get_remote_sdp(static::000000DB8F9933D0, [000000DB9064F3B8], [000000DB9064F3A0], [0000000000000000]) called
  186. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:616 soa_get_params() soa_get_params(static::000000DB8F9933D0, ...) called
  187. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B77A0): event i_state 200 OK
  188. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:529 nua_signal() nua(000000DB8F7B77A0): sent signal r_ack
  189. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:569 nua_stack_signal() nua(000000DB8F7B77A0): recv signal r_ack
  190. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:403 soa_set_params() soa_set_params(static::000000DB8F9933D0, ...) called
  191. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1730 soa_activate() soa_activate(static::000000DB8F9933D0, (nil)) called
  192. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:2665 nta_tpn_by_url() nta: selecting scheme sip
  193. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3257 tport_tsend() tport_tsend(000000DB8F2E4C10) tpn = */10.10.5.14:5060
  194. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4046 tport_resolve() tport_resolve addrinfo = 10.10.5.14:5060
  195. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4680 tport_by_addrinfo() tport(000000DB8F2E4C10): not found by name */10.10.5.14:5060
  196. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3594 tport_vsend() tport_vsend(000000DB8F2E4C10): 428 bytes of 428 to udp/10.10.5.14:5060
  197. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3492 tport_send_msg() tport_vsend returned 428
  198. send 428 bytes to udp/[10.10.5.14]:5060 at 19:19:52.943019:
  199.    ------------------------------------------------------------------------
  200.    ACK sip:18156548285@10.10.5.14:5060 SIP/2.0
  201.    Via: SIP/2.0/UDP 10.10.101.238:5080;rport;branch=z9hG4bK6NtNj9XyH87XN
  202.    Max-Forwards: 70
  203.    From: "SUPPORTSTREEMVM" <sip:1000@10.10.5.14>;tag=66mNXc2Z3m12B
  204.    To: <sip:18156548285@10.10.5.14>;tag=60DC324631353641000011D3
  205.    Call-ID: bae55b93-6f4b-1236-cf98-dd1cb2d72f2a
  206.    CSeq: 117383529 ACK
  207.    Contact: <sip:gw+10.10.5.14@10.10.101.238:5080;transport=udp;gw=10.10.5.14>
  208.    Content-Length: 0
  209.    
  210.    ------------------------------------------------------------------------
  211. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:8304 outgoing_send() nta: sent ACK (117383529) to */10.10.5.14:5060
  212. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_session.c:4139 signal_call_state_change() nua(000000DB8F7B77A0): call state changed: completing -> ready
  213. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B77A0): event i_state 200 ACK sent
  214. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B77A0): event i_active 200 Call active
  215. 1790ebfe-b1a0-4833-9ef2-7b7d03fd6002 2018-01-08 13:19:52.939019 [NOTICE] sofia.c:8218 Channel [sofia/external/18156548285] has been answered
  216. 1790ebfe-b1a0-4833-9ef2-7b7d03fd6002 2018-01-08 13:19:52.939019 [INFO] switch_channel.c:3129 sofia/external/18156548285 Flipping CID from "SUPPORTSTREEMVM" <8887344585> to "Outbound Call" <18156548285>
  217. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2749 tport_wakeup_pri() tport_wakeup_pri(000000DB8F2E4C10): events IN
  218. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2864 tport_recv_event() tport_recv_event(000000DB8F2E4C10)
  219. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3205 tport_recv_iovec() tport(000000DB8F2E4C10) msg 000000DB8F5A08F0 from (udp/10.10.101.238:5080) has 865 bytes, veclen = 1
  220. recv 865 bytes from udp/[10.10.5.14]:1028 at 19:19:52.964020:
  221.    ------------------------------------------------------------------------
  222.    INVITE sip:gw+10.10.5.14@10.10.101.238:5080;transport=udp;gw=10.10.5.14 SIP/2.0
  223.    Content-Type:application/sdp
  224.    Allow:INVITE,BYE,CANCEL,REFER,NOTIFY,OPTIONS,REGISTER,INFO,ACK,PRACK
  225.    Supported:100rel,replaces
  226.    Expires:120
  227.    To:"SUPPORTSTREEMVM"<sip:1000@10.10.5.14>;tag=66mNXc2Z3m12B
  228.    From:<sip:18156548285@10.10.5.14>;tag=60DC324631353641000011D3
  229.    Call-ID:bae55b93-6f4b-1236-cf98-dd1cb2d72f2a
  230.    CSeq:1 INVITE
  231.    Max-Forwards:70
  232.    User-Agent:PBX-IP Media Gateway
  233.    Contact:<sip:18156548285@10.10.5.14:5060>
  234.    Via:SIP/2.0/UDP 10.10.5.14:5060;branch=z9hG4bK610FFE624F10D6EE40DC26B4FCE75E24
  235.    Content-Length:263
  236.    
  237.    v=0
  238.    o=phone 14740 9007 IN IP4 10.10.5.14
  239.    s=-
  240.    c=IN IP4 10.10.5.14
  241.    t=0 0
  242.    m=image 49008 udptl t38
  243.    a=T38FaxMaxBuffer:1800
  244.    a=T38FaxMaxDatagram:150
  245.    a=T38FaxVersion:0
  246.    a=T38MaxBitRate:14400
  247.    a=T38FaxRateManagement:transferredTCF
  248.    a=T38FaxUdpEC:t38UDPRedundancy
  249.    ------------------------------------------------------------------------
  250. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3023 tport_deliver() tport(000000DB8F2E4C10): msg 000000DB8F5A08F0 (865 bytes) from udp/10.10.5.14:5080/sip next=0000000000000000
  251. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:2880 agent_recv_request() nta: received INVITE sip:gw+10.10.5.14@10.10.101.238:5080;transport=udp;gw=10.10.5.14 SIP/2.0 (CSeq 1)
  252. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3248 agent_aliases() nta: canonizing sip:gw+10.10.5.14@10.10.101.238:5080 with contact
  253. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3060 agent_recv_request() nta: INVITE (1) going to existing leg
  254. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:1348 set_timeout() nta: timer shortened to 200 ms
  255. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1302 soa_init_offer_answer() soa_init_offer_answer(static::000000DB8F9933D0) called
  256. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1171 soa_set_remote_sdp() soa_set_remote_sdp(static::000000DB8F9933D0, 0000000000000000, 000000DB8F9ADC8A, 263) called
  257. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3257 tport_tsend() tport_tsend(000000DB8F2E4C10) tpn = UDP/10.10.5.14:5060
  258. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4046 tport_resolve() tport_resolve addrinfo = 10.10.5.14:5060
  259. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4680 tport_by_addrinfo() tport(000000DB8F2E4C10): not found by name UDP/10.10.5.14:5060
  260. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3594 tport_vsend() tport_vsend(000000DB8F2E4C10): 386 bytes of 386 to udp/10.10.5.14:5060
  261. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3492 tport_send_msg() tport_vsend returned 386
  262. send 386 bytes to udp/[10.10.5.14]:5060 at 19:19:52.965022:
  263.    ------------------------------------------------------------------------
  264.    SIP/2.0 100 Trying
  265.    Via:SIP/2.0/UDP 10.10.5.14:5060;branch=z9hG4bK610FFE624F10D6EE40DC26B4FCE75E24
  266.    From:<sip:18156548285@10.10.5.14>;tag=60DC324631353641000011D3
  267.    To:"SUPPORTSTREEMVM"<sip:1000@10.10.5.14>;tag=66mNXc2Z3m12B
  268.    Call-ID:bae55b93-6f4b-1236-cf98-dd1cb2d72f2a
  269.    CSeq:1 INVITE
  270.    User-Agent: FreeSWITCH-mod_sofia/1.6.19+git~20171109T180403Z~27aebc7253~64bit
  271.    Content-Length: 0
  272.    
  273.    ------------------------------------------------------------------------
  274. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:6791 incoming_reply() nta: sent 100 Trying for INVITE (1)
  275. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B77A0): event i_invite 100 Trying
  276. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_session.c:4145 signal_call_state_change() nua(000000DB8F7B77A0): ready call updated: received received offer
  277. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1098 soa_get_remote_sdp() soa_get_remote_sdp(static::000000DB8F9933D0, [000000DB9064F288], [000000DB9064F270], [0000000000000000]) called
  278. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B77A0): event i_state 100 Trying
  279. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:1296 agent_timer() nta: timer set next to 31769 ms
  280. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:529 nua_signal() nua(000000DB8F7B77A0): sent signal r_respond
  281. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:573 nua_stack_signal() nua(000000DB8F7B77A0): recv signal r_respond 200 OK
  282. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:403 soa_set_params() soa_set_params(static::000000DB8F9933D0, ...) called
  283. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1052 soa_set_user_sdp() soa_set_user_sdp(static::000000DB8F9933D0, 0000000000000000, 000000DB8E266E00, -1) called
  284. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1515 soa_generate_answer() soa_generate_answer(static::000000DB8F9933D0) called
  285. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1148 offer_answer_step() soa_static_offer_answer_action(000000DB8F9933D0, soa_generate_answer): called
  286. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1230 offer_answer_step() soa_static(000000DB8F9933D0, soa_generate_answer): upgrade with remote description
  287. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1029 soa_sdp_mode_set() soa_sdp_mode_set(000000DB9064D760, 000000DB8F9AC220, ""): called
  288. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1446 offer_answer_step() soa_static(000000DB8F9933D0, soa_generate_answer): storing local description
  289. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1730 soa_activate() soa_activate(static::000000DB8F9933D0, (nil)) called
  290. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1270 soa_get_local_sdp() soa_get_local_sdp(static::000000DB8F9933D0, [0000000000000000], [000000DB9064F8B0], [000000DB9064F8E8]) called
  291. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3257 tport_tsend() tport_tsend(000000DB8F2E4C10) tpn = UDP/10.10.5.14:5060
  292. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4046 tport_resolve() tport_resolve addrinfo = 10.10.5.14:5060
  293. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4680 tport_by_addrinfo() tport(000000DB8F2E4C10): not found by name UDP/10.10.5.14:5060
  294. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3594 tport_vsend() tport_vsend(000000DB8F2E4C10): 965 bytes of 965 to udp/10.10.5.14:5060
  295. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3492 tport_send_msg() tport_vsend returned 965
  296. send 965 bytes to udp/[10.10.5.14]:5060 at 19:19:53.239043:
  297.    ------------------------------------------------------------------------
  298.    SIP/2.0 200 OK
  299.    Via:SIP/2.0/UDP 10.10.5.14:5060;branch=z9hG4bK610FFE624F10D6EE40DC26B4FCE75E24
  300.    From:<sip:18156548285@10.10.5.14>;tag=60DC324631353641000011D3
  301.    To:"SUPPORTSTREEMVM"<sip:1000@10.10.5.14>;tag=66mNXc2Z3m12B
  302.    Call-ID:bae55b93-6f4b-1236-cf98-dd1cb2d72f2a
  303.    CSeq:1 INVITE
  304.    Contact: <sip:gw+10.10.5.14@10.10.101.238:5080;transport=udp;gw=10.10.5.14>
  305.    User-Agent: FreeSWITCH-mod_sofia/1.6.19+git~20171109T180403Z~27aebc7253~64bit
  306.    Accept: application/sdp
  307.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  308.    Supported: timer, path, replaces
  309.    Content-Type: application/sdp
  310.    Content-Disposition: session
  311.    Content-Length: 294
  312.    
  313.    v=0
  314.    o=FreeSWITCH 1515382836 1515382838 IN IP4 10.10.101.238
  315.    s=FreeSWITCH
  316.    c=IN IP4 10.10.101.238
  317.    t=0 0
  318.    m=image 56350 udptl t38
  319.    a=T38FaxVersion:0
  320.    a=T38MaxBitRate:14400
  321.    a=T38FaxRateManagement:transferredTCF
  322.    a=T38FaxMaxBuffer:1800
  323.    a=T38FaxMaxDatagram:400
  324.    a=T38FaxUdpEC:t38UDPRedundancy
  325.    ------------------------------------------------------------------------
  326. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:6791 incoming_reply() nta: sent 200 OK for INVITE (1)
  327. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:1348 set_timeout() nta: timer shortened to 500 ms
  328. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_session.c:4145 signal_call_state_change() nua(000000DB8F7B77A0): ready call updated: completed sent answer
  329. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1270 soa_get_local_sdp() soa_get_local_sdp(static::000000DB8F9933D0, [000000DB9064F960], [000000DB9064F970], [0000000000000000]) called
  330. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:616 soa_get_params() soa_get_params(static::000000DB8F9933D0, ...) called
  331. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B77A0): event i_state 200 OK
  332. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2749 tport_wakeup_pri() tport_wakeup_pri(000000DB8F2E4C10): events IN
  333. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2864 tport_recv_event() tport_recv_event(000000DB8F2E4C10)
  334. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3205 tport_recv_iovec() tport(000000DB8F2E4C10) msg 000000DB8F5A1430 from (udp/10.10.101.238:5080) has 411 bytes, veclen = 1
  335. recv 411 bytes from udp/[10.10.5.14]:1028 at 19:19:53.251052:
  336.    ------------------------------------------------------------------------
  337.    ACK sip:gw+10.10.5.14@10.10.101.238:5080;transport=udp;gw=10.10.5.14 SIP/2.0
  338.    CSeq:1 ACK
  339.    To:"SUPPORTSTREEMVM"<sip:1000@10.10.5.14>;tag=66mNXc2Z3m12B
  340.    From:<sip:18156548285@10.10.5.14>;tag=60DC324631353641000011D3
  341.    Call-ID:bae55b93-6f4b-1236-cf98-dd1cb2d72f2a
  342.    Max-Forwards:70
  343.    User-Agent:PBX-IP Media Gateway
  344.    Via:SIP/2.0/UDP 10.10.5.14:5060;branch=z9hG4bK75D99919404F6DB024F717EADF7AA9F4
  345.    Content-Length:0
  346.    
  347.    ------------------------------------------------------------------------
  348. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3023 tport_deliver() tport(000000DB8F2E4C10): msg 000000DB8F5A1430 (411 bytes) from udp/10.10.5.14:5080/sip next=0000000000000000
  349. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:2880 agent_recv_request() nta: received ACK sip:gw+10.10.5.14@10.10.101.238:5080;transport=udp;gw=10.10.5.14 SIP/2.0 (CSeq 1)
  350. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3019 agent_recv_request() nta: ACK (1) is going to INVITE (1)
  351. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1214 soa_clear_remote_sdp() soa_clear_remote_sdp(static::000000DB8F9933D0) called
  352. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B77A0): event i_ack 200 OK
  353. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_session.c:4145 signal_call_state_change() nua(000000DB8F7B77A0): ready call updated: ready
  354. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B77A0): event i_state 200 OK
  355. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B77A0): event i_active 200 Call active
  356. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:1296 agent_timer() nta: timer set next to 4512 ms
  357. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:7134 _nta_incoming_timer() nta: timer I fired, terminate 200 response
  358. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:5825 incoming_reclaim_queued() incoming_reclaim_all(0000000000000000, 0000000000000000, 000000DB9064FA40)
  359. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:7188 _nta_incoming_timer() nta_incoming_timer: 0/0 resent, 0/0 tout, 1/1 term, 1/1 free
  360. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:1296 agent_timer() nta: timer set next to 26683 ms
  361. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:9101 outgoing_timer_dk() nta: timer D fired, terminate INVITE (117383529)
  362. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:8799 outgoing_reclaim_queued() outgoing_reclaim_all(0000000000000000, 0000000000000000, 000000DB9064FA40)
  363. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:8929 _nta_outgoing_timer() nta_outgoing_timer: 0/0 resent, 0/1 tout, 1/1 term, 1/2 free
  364. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:1296 agent_timer() nta: timer set next to 9 ms
  365. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:8982 outgoing_timer_bf() nta: timer F fired, terminating ACK (117383529)
  366. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:8799 outgoing_reclaim_queued() outgoing_reclaim_all(0000000000000000, 0000000000000000, 000000DB9064FA40)
  367. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:8929 _nta_outgoing_timer() nta_outgoing_timer: 0/0 resent, 1/1 tout, 0/0 term, 1/1 free
  368. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:1289 agent_timer() nta: timer not set
  369. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2749 tport_wakeup_pri() tport_wakeup_pri(000000DB8F2E4C10): events IN
  370. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2864 tport_recv_event() tport_recv_event(000000DB8F2E4C10)
  371. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3205 tport_recv_iovec() tport(000000DB8F2E4C10) msg 000000DB8F5A1F70 from (udp/10.10.101.238:5080) has 490 bytes, veclen = 1
  372. recv 490 bytes from udp/[10.10.5.14]:1028 at 19:20:51.489871:
  373.    ------------------------------------------------------------------------
  374.    BYE sip:gw+10.10.5.14@10.10.101.238:5080;transport=udp;gw=10.10.5.14 SIP/2.0
  375.    Reason:E.182;text="Normal"
  376.    Reason:Q.850;cause=16;text="Normal call clearing"
  377.    To:"SUPPORTSTREEMVM"<sip:1000@10.10.5.14>;tag=66mNXc2Z3m12B
  378.    From:<sip:18156548285@10.10.5.14>;tag=60DC324631353641000011D3
  379.    Call-ID:bae55b93-6f4b-1236-cf98-dd1cb2d72f2a
  380.    CSeq:2 BYE
  381.    Max-Forwards:70
  382.    User-Agent:PBX-IP Media Gateway
  383.    Via:SIP/2.0/UDP 10.10.5.14:5060;branch=z9hG4bK2C988DEFAE63B5E00C2E0F4DF5E43ACB
  384.    Content-Length:0
  385.    
  386.    ------------------------------------------------------------------------
  387. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3023 tport_deliver() tport(000000DB8F2E4C10): msg 000000DB8F5A1F70 (490 bytes) from udp/10.10.5.14:5080/sip next=0000000000000000
  388. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:2880 agent_recv_request() nta: received BYE sip:gw+10.10.5.14@10.10.101.238:5080;transport=udp;gw=10.10.5.14 SIP/2.0 (CSeq 2)
  389. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3248 agent_aliases() nta: canonizing sip:gw+10.10.5.14@10.10.101.238:5080 with contact
  390. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3060 agent_recv_request() nta: BYE (2) going to existing leg
  391. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B77A0): event i_bye 100 Trying
  392. 1790ebfe-b1a0-4833-9ef2-7b7d03fd6002 2018-01-08 13:20:51.478878 [NOTICE] sofia.c:1012 Hangup sofia/external/18156548285 [CS_EXECUTE] [NORMAL_CLEARING]
  393. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:529 nua_signal() nua(000000DB8F7B77A0): sent signal r_respond
  394. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:529 nua_signal() nua(000000DB8F7B77A0): sent signal r_destroy
  395. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:573 nua_stack_signal() nua(000000DB8F7B77A0): recv signal r_respond 200 OK
  396. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:403 soa_set_params() soa_set_params(static::000000DB8F9933D0, ...) called
  397. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3257 tport_tsend() tport_tsend(000000DB8F2E4C10) tpn = UDP/10.10.5.14:5060
  398. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4046 tport_resolve() tport_resolve addrinfo = 10.10.5.14:5060
  399. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4680 tport_by_addrinfo() tport(000000DB8F2E4C10): not found by name UDP/10.10.5.14:5060
  400. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3594 tport_vsend() tport_vsend(000000DB8F2E4C10): 503 bytes of 503 to udp/10.10.5.14:5060
  401. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3492 tport_send_msg() tport_vsend returned 503
  402. send 503 bytes to udp/[10.10.5.14]:5060 at 19:20:51.491875:
  403.    ------------------------------------------------------------------------
  404.    SIP/2.0 200 OK
  405.    Via:SIP/2.0/UDP 10.10.5.14:5060;branch=z9hG4bK2C988DEFAE63B5E00C2E0F4DF5E43ACB
  406.    From:<sip:18156548285@10.10.5.14>;tag=60DC324631353641000011D3
  407.    To:"SUPPORTSTREEMVM"<sip:1000@10.10.5.14>;tag=66mNXc2Z3m12B
  408.    Call-ID:bae55b93-6f4b-1236-cf98-dd1cb2d72f2a
  409.    CSeq:2 BYE
  410.    User-Agent: FreeSWITCH-mod_sofia/1.6.19+git~20171109T180403Z~27aebc7253~64bit
  411.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  412.    Supported: timer, path, replaces
  413.    Content-Length: 0
  414.    
  415.    ------------------------------------------------------------------------
  416. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:6791 incoming_reply() nta: sent 200 OK for BYE (2)
  417. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:1350 set_timeout() nta: timer set to 32000 ms
  418. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_dialog.c:397 nua_dialog_usage_remove_at() nua(000000DB8F7B77A0): removing session usage
  419. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_session.c:4139 signal_call_state_change() nua(000000DB8F7B77A0): call state changed: ready -> terminated
  420. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B77A0): event i_state 200 Session Terminated
  421. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B77A0): event i_terminated 200 Session Terminated
  422. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:356 soa_destroy() soa_destroy(static::000000DB8F9933D0) called
  423. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:4470 nta_leg_destroy() nta_leg_destroy(000000DB8F7AED90)
  424. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:569 nua_stack_signal() nua(000000DB8F7B77A0): recv signal r_destroy
  425. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:4470 nta_leg_destroy() nta_leg_destroy(0000000000000000)
  426. 1790ebfe-b1a0-4833-9ef2-7b7d03fd6002 2018-01-08 13:20:51.478878 [NOTICE] switch_core_session.c:1683 Session 19 (sofia/external/18156548285) Ended
  427. 1790ebfe-b1a0-4833-9ef2-7b7d03fd6002 2018-01-08 13:20:51.478878 [NOTICE] switch_core_session.c:1687 Close Channel sofia/external/18156548285 [CS_DESTROY]
  428. d4b0f76f-e30b-4180-b12b-54d8c1fa0ea5 2018-01-08 13:21:17.038770 [NOTICE] switch_channel.c:1104 New Channel sofia/external/18156548285 [d4b0f76f-e30b-4180-b12b-54d8c1fa0ea5]
  429. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:529 nua_signal() nua(000000DB8F7B6A20): sent signal r_invite
  430. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:569 nua_stack_signal() nua(000000DB8F7B6A20): recv signal r_invite
  431. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:280 soa_clone() soa_clone(static::000000DB8F2E3F60, 000000DB8F5301B0, 000000DB8F7B6A20) called
  432. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:403 soa_set_params() soa_set_params(static::000000DB8F992C50, ...) called
  433. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:403 soa_set_params() soa_set_params(static::000000DB8F992C50, ...) called
  434. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1052 soa_set_user_sdp() soa_set_user_sdp(static::000000DB8F992C50, 0000000000000000, 000000DB8F324987, -1) called
  435. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:890 soa_set_capability_sdp() soa_set_capability_sdp(static::000000DB8F992C50, 0000000000000000, 000000DB8F324987, -1) called
  436. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_dialog.c:338 nua_dialog_usage_add() nua(000000DB8F7B6A20): adding session usage
  437. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:4417 nta_leg_tcreate() nta_leg_tcreate(000000DB90D6D8C0)
  438. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1302 soa_init_offer_answer() soa_init_offer_answer(static::000000DB8F992C50) called
  439. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1426 soa_generate_offer() soa_generate_offer(static::000000DB8F992C50, 0) called
  440. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1148 offer_answer_step() soa_static_offer_answer_action(000000DB8F992C50, soa_generate_offer): called
  441. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1189 offer_answer_step() soa_static(000000DB8F992C50, soa_generate_offer): generating local description
  442. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1217 offer_answer_step() soa_static(000000DB8F992C50, soa_generate_offer): upgrade with local description
  443. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1029 soa_sdp_mode_set() soa_sdp_mode_set(000000DB9064D660, 0000000000000000, ""): called
  444. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1446 offer_answer_step() soa_static(000000DB8F992C50, soa_generate_offer): storing local description
  445. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1270 soa_get_local_sdp() soa_get_local_sdp(static::000000DB8F992C50, [0000000000000000], [000000DB9064F7B0], [000000DB9064F7E8]) called
  446. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:2665 nta_tpn_by_url() nta: selecting scheme sip
  447. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3257 tport_tsend() tport_tsend(000000DB8F2E4C10) tpn = */10.10.5.14:5060
  448. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4046 tport_resolve() tport_resolve addrinfo = 10.10.5.14:5060
  449. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4680 tport_by_addrinfo() tport(000000DB8F2E4C10): not found by name */10.10.5.14:5060
  450. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3594 tport_vsend() tport_vsend(000000DB8F2E4C10): 1145 bytes of 1145 to udp/10.10.5.14:5060
  451. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3492 tport_send_msg() tport_vsend returned 1145
  452. send 1145 bytes to udp/[10.10.5.14]:5060 at 19:21:17.049785:
  453.    ------------------------------------------------------------------------
  454.    INVITE sip:18156548285@10.10.5.14 SIP/2.0
  455.    Via: SIP/2.0/UDP 10.10.101.238:5080;rport;branch=z9hG4bK7yKem4e2eHygH
  456.    Max-Forwards: 70
  457.    From: "SUPPORTSTREEMVM" <sip:1000@10.10.5.14>;tag=7FeeZ7j30XQNQ
  458.    To: <sip:18156548285@10.10.5.14>
  459.    Call-ID: f0becd40-6f4b-1236-cf98-dd1cb2d72f2a
  460.    CSeq: 117383574 INVITE
  461.    Contact: <sip:gw+10.10.5.14@10.10.101.238:5080;transport=udp;gw=10.10.5.14>
  462.    User-Agent: FreeSWITCH-mod_sofia/1.6.19+git~20171109T180403Z~27aebc7253~64bit
  463.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  464.    Supported: timer, path, replaces
  465.    Allow-Events: talk, hold, conference, refer
  466.    Content-Type: application/sdp
  467.    Content-Disposition: session
  468.    Content-Length: 293
  469.    X-FS-Support: update_display,send_info
  470.    Remote-Party-ID: "SUPPORTSTREEMVM" <sip:8887344585@10.10.5.14>;party=calling;screen=yes;privacy=off
  471.    
  472.    v=0
  473.    o=FreeSWITCH 1515383223 1515383224 IN IP4 10.10.101.238
  474.    s=FreeSWITCH
  475.    c=IN IP4 10.10.101.238
  476.    t=0 0
  477.    m=audio 56054 RTP/AVP 0 8 3 101 13
  478.    a=rtpmap:0 PCMU/8000
  479.    a=rtpmap:8 PCMA/8000
  480.    a=rtpmap:3 GSM/8000
  481.    a=rtpmap:101 telephone-event/8000
  482.    a=fmtp:101 0-16
  483.    a=rtpmap:13 CN/8000
  484.    a=ptime:20
  485.    ------------------------------------------------------------------------
  486. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:8304 outgoing_send() nta: sent INVITE (117383574) to */10.10.5.14:5060
  487. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4160 tport_pend() tport_pend(000000DB8F2E4C10): pending 000000DB8F5A08F0 for udp/10.10.101.238:5080 (already 0)
  488. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:1348 set_timeout() nta: timer shortened to 1000 ms
  489. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_session.c:4139 signal_call_state_change() nua(000000DB8F7B6A20): call state changed: init -> calling, sent offer
  490. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1270 soa_get_local_sdp() soa_get_local_sdp(static::000000DB8F992C50, [000000DB9064F780], [000000DB9064F790], [0000000000000000]) called
  491. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:269 nua_stack_event() nua(000000DB8F7B6A20): event i_state INVITE sent
  492. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2749 tport_wakeup_pri() tport_wakeup_pri(000000DB8F2E4C10): events IN
  493. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2864 tport_recv_event() tport_recv_event(000000DB8F2E4C10)
  494. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3205 tport_recv_iovec() tport(000000DB8F2E4C10) msg 000000DB8F5A1430 from (udp/10.10.101.238:5080) has 308 bytes, veclen = 1
  495. recv 308 bytes from udp/[10.10.5.14]:1028 at 19:21:17.064778:
  496.    ------------------------------------------------------------------------
  497.    SIP/2.0 100 Trying
  498.    From:"SUPPORTSTREEMVM"<sip:1000@10.10.5.14>;tag=7FeeZ7j30XQNQ
  499.    To:<sip:18156548285@10.10.5.14>
  500.    Call-ID:f0becd40-6f4b-1236-cf98-dd1cb2d72f2a
  501.    CSeq:117383574 INVITE
  502.    Server:PBX-IP Media Gateway/2.1
  503.    Via:SIP/2.0/UDP 10.10.101.238:5080;rport;branch=z9hG4bK7yKem4e2eHygH
  504.    Content-Length:0
  505.    
  506.    ------------------------------------------------------------------------
  507. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3023 tport_deliver() tport(000000DB8F2E4C10): msg 000000DB8F5A1430 (308 bytes) from udp/10.10.5.14:5080/sip next=0000000000000000
  508. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3299 agent_recv_response() nta: received 100 Trying for INVITE (117383574)
  509. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3366 agent_recv_response() nta: 100 Trying is going to a transaction
  510. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:9564 outgoing_estimate_delay() nta_outgoing: RTT is 14.993 ms
  511. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4222 tport_release() tport(000000DB8F2E4C10): 000000DB8F5A08F0 by 000000DB8F3A6390 with 000000DB8F5A1430 (preliminary)
  512. fb05e962-059f-4bb4-b9e1-54130ed0b2e3 2018-01-08 13:21:17.078782 [NOTICE] switch_channel.c:1104 New Channel sofia/external/18156548285 [fb05e962-059f-4bb4-b9e1-54130ed0b2e3]
  513. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:529 nua_signal() nua(000000DB8F7B7200): sent signal r_invite
  514. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:569 nua_stack_signal() nua(000000DB8F7B7200): recv signal r_invite
  515. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:280 soa_clone() soa_clone(static::000000DB8F2E3F60, 000000DB8F5301B0, 000000DB8F7B7200) called
  516. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:403 soa_set_params() soa_set_params(static::000000DB8F9933D0, ...) called
  517. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:403 soa_set_params() soa_set_params(static::000000DB8F9933D0, ...) called
  518. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1052 soa_set_user_sdp() soa_set_user_sdp(static::000000DB8F9933D0, 0000000000000000, 000000DB8F324667, -1) called
  519. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:890 soa_set_capability_sdp() soa_set_capability_sdp(static::000000DB8F9933D0, 0000000000000000, 000000DB8F324667, -1) called
  520. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_dialog.c:338 nua_dialog_usage_add() nua(000000DB8F7B7200): adding session usage
  521. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:4417 nta_leg_tcreate() nta_leg_tcreate(000000DB90D6DBC0)
  522. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1302 soa_init_offer_answer() soa_init_offer_answer(static::000000DB8F9933D0) called
  523. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1426 soa_generate_offer() soa_generate_offer(static::000000DB8F9933D0, 0) called
  524. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1148 offer_answer_step() soa_static_offer_answer_action(000000DB8F9933D0, soa_generate_offer): called
  525. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1189 offer_answer_step() soa_static(000000DB8F9933D0, soa_generate_offer): generating local description
  526. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1217 offer_answer_step() soa_static(000000DB8F9933D0, soa_generate_offer): upgrade with local description
  527. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1029 soa_sdp_mode_set() soa_sdp_mode_set(000000DB9064D660, 0000000000000000, ""): called
  528. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1446 offer_answer_step() soa_static(000000DB8F9933D0, soa_generate_offer): storing local description
  529. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1270 soa_get_local_sdp() soa_get_local_sdp(static::000000DB8F9933D0, [0000000000000000], [000000DB9064F7B0], [000000DB9064F7E8]) called
  530. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:2665 nta_tpn_by_url() nta: selecting scheme sip
  531. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3257 tport_tsend() tport_tsend(000000DB8F2E4C10) tpn = */10.10.5.14:5060
  532. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4046 tport_resolve() tport_resolve addrinfo = 10.10.5.14:5060
  533. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4680 tport_by_addrinfo() tport(000000DB8F2E4C10): not found by name */10.10.5.14:5060
  534. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3594 tport_vsend() tport_vsend(000000DB8F2E4C10): 1145 bytes of 1145 to udp/10.10.5.14:5060
  535. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3492 tport_send_msg() tport_vsend returned 1145
  536. send 1145 bytes to udp/[10.10.5.14]:5060 at 19:21:17.084775:
  537.    ------------------------------------------------------------------------
  538.    INVITE sip:18156548285@10.10.5.14 SIP/2.0
  539.    Via: SIP/2.0/UDP 10.10.101.238:5080;rport;branch=z9hG4bK87c7NZZ5Btm3c
  540.    Max-Forwards: 70
  541.    From: "SUPPORTSTREEMVM" <sip:1000@10.10.5.14>;tag=8r760236X6D8j
  542.    To: <sip:18156548285@10.10.5.14>
  543.    Call-ID: f0c42408-6f4b-1236-cf98-dd1cb2d72f2a
  544.    CSeq: 117383574 INVITE
  545.    Contact: <sip:gw+10.10.5.14@10.10.101.238:5080;transport=udp;gw=10.10.5.14>
  546.    User-Agent: FreeSWITCH-mod_sofia/1.6.19+git~20171109T180403Z~27aebc7253~64bit
  547.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  548.    Supported: timer, path, replaces
  549.    Allow-Events: talk, hold, conference, refer
  550.    Content-Type: application/sdp
  551.    Content-Disposition: session
  552.    Content-Length: 293
  553.    X-FS-Support: update_display,send_info
  554.    Remote-Party-ID: "SUPPORTSTREEMVM" <sip:8887344585@10.10.5.14>;party=calling;screen=yes;privacy=off
  555.    
  556.    v=0
  557.    o=FreeSWITCH 1515382535 1515382536 IN IP4 10.10.101.238
  558.    s=FreeSWITCH
  559.    c=IN IP4 10.10.101.238
  560.    t=0 0
  561.    m=audio 56742 RTP/AVP 0 8 3 101 13
  562.    a=rtpmap:0 PCMU/8000
  563.    a=rtpmap:8 PCMA/8000
  564.    a=rtpmap:3 GSM/8000
  565.    a=rtpmap:101 telephone-event/8000
  566.    a=fmtp:101 0-16
  567.    a=rtpmap:13 CN/8000
  568.    a=ptime:20
  569.    ------------------------------------------------------------------------
  570. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:8304 outgoing_send() nta: sent INVITE (117383574) to */10.10.5.14:5060
  571. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4160 tport_pend() tport_pend(000000DB8F2E4C10): pending 000000DB8F5A0CB0 for udp/10.10.101.238:5080 (already 1)
  572. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_session.c:4139 signal_call_state_change() nua(000000DB8F7B7200): call state changed: init -> calling, sent offer
  573. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1270 soa_get_local_sdp() soa_get_local_sdp(static::000000DB8F9933D0, [000000DB9064F780], [000000DB9064F790], [0000000000000000]) called
  574. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:269 nua_stack_event() nua(000000DB8F7B7200): event i_state INVITE sent
  575. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2749 tport_wakeup_pri() tport_wakeup_pri(000000DB8F2E4C10): events IN
  576. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2864 tport_recv_event() tport_recv_event(000000DB8F2E4C10)
  577. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3205 tport_recv_iovec() tport(000000DB8F2E4C10) msg 000000DB8F5A1BB0 from (udp/10.10.101.238:5080) has 308 bytes, veclen = 1
  578. recv 308 bytes from udp/[10.10.5.14]:1028 at 19:21:17.099941:
  579.    ------------------------------------------------------------------------
  580.    SIP/2.0 100 Trying
  581.    From:"SUPPORTSTREEMVM"<sip:1000@10.10.5.14>;tag=8r760236X6D8j
  582.    To:<sip:18156548285@10.10.5.14>
  583.    Call-ID:f0c42408-6f4b-1236-cf98-dd1cb2d72f2a
  584.    CSeq:117383574 INVITE
  585.    Server:PBX-IP Media Gateway/2.1
  586.    Via:SIP/2.0/UDP 10.10.101.238:5080;rport;branch=z9hG4bK87c7NZZ5Btm3c
  587.    Content-Length:0
  588.    
  589.    ------------------------------------------------------------------------
  590. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3023 tport_deliver() tport(000000DB8F2E4C10): msg 000000DB8F5A1BB0 (308 bytes) from udp/10.10.5.14:5080/sip next=0000000000000000
  591. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3299 agent_recv_response() nta: received 100 Trying for INVITE (117383574)
  592. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3366 agent_recv_response() nta: 100 Trying is going to a transaction
  593. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:9564 outgoing_estimate_delay() nta_outgoing: RTT is 15.166 ms
  594. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4222 tport_release() tport(000000DB8F2E4C10): 000000DB8F5A0CB0 by 000000DB8F3A6630 with 000000DB8F5A1BB0 (preliminary)
  595. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2749 tport_wakeup_pri() tport_wakeup_pri(000000DB8F2E4C10): events IN
  596. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2864 tport_recv_event() tport_recv_event(000000DB8F2E4C10)
  597. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3205 tport_recv_iovec() tport(000000DB8F2E4C10) msg 000000DB8F5A1BB0 from (udp/10.10.101.238:5080) has 556 bytes, veclen = 1
  598. recv 556 bytes from udp/[10.10.5.14]:1028 at 19:21:17.993843:
  599.    ------------------------------------------------------------------------
  600.    SIP/2.0 180 Ringing
  601.    Reason:Q.931;progress_indicator=8;text="In-band information or an appropriate pattern is now available"
  602.    Contact:<sip:18156548285@10.10.5.14:5060>
  603.    Allow:INVITE,ACK,OPTIONS,BYE,CANCEL,REGISTER,INFO,PRACK,REFER,NOTIFY
  604.    From:"SUPPORTSTREEMVM"<sip:1000@10.10.5.14>;tag=8r760236X6D8j
  605.    To:<sip:18156548285@10.10.5.14>;tag=5EE13246313536410000155C
  606.    Call-ID:f0c42408-6f4b-1236-cf98-dd1cb2d72f2a
  607.    CSeq:117383574 INVITE
  608.    Server:PBX-IP Media Gateway/2.1
  609.    Via:SIP/2.0/UDP 10.10.101.238:5080;rport;branch=z9hG4bK87c7NZZ5Btm3c
  610.    Content-Length:0
  611.    
  612.    ------------------------------------------------------------------------
  613. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3023 tport_deliver() tport(000000DB8F2E4C10): msg 000000DB8F5A1BB0 (556 bytes) from udp/10.10.5.14:5080/sip next=0000000000000000
  614. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3299 agent_recv_response() nta: received 180 Ringing for INVITE (117383574)
  615. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3366 agent_recv_response() nta: 180 Ringing is going to a transaction
  616. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4222 tport_release() tport(000000DB8F2E4C10): 000000DB8F5A0CB0 by 000000DB8F3A6630 with 000000DB8F5A1BB0 (preliminary)
  617. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B7200): event r_invite 180 Ringing
  618. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_session.c:4139 signal_call_state_change() nua(000000DB8F7B7200): call state changed: calling -> proceeding
  619. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B7200): event i_state 180 Ringing
  620. fb05e962-059f-4bb4-b9e1-54130ed0b2e3 2018-01-08 13:21:17.998851 [NOTICE] sofia.c:7192 Ring-Ready sofia/external/18156548285!
  621. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:1296 agent_timer() nta: timer set next to 5442 ms
  622. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2749 tport_wakeup_pri() tport_wakeup_pri(000000DB8F2E4C10): events IN
  623. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2864 tport_recv_event() tport_recv_event(000000DB8F2E4C10)
  624. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3205 tport_recv_iovec() tport(000000DB8F2E4C10) msg 000000DB8E267960 from (udp/10.10.101.238:5080) has 411 bytes, veclen = 1
  625. recv 411 bytes from udp/[10.10.5.14]:1028 at 19:21:19.179927:
  626.    ------------------------------------------------------------------------
  627.    SIP/2.0 486 Busy Here
  628.    Reason:E.182;text="User Busy"
  629.    Reason:Q.850;cause=17;text="User busy"
  630.    From:"SUPPORTSTREEMVM"<sip:1000@10.10.5.14>;tag=7FeeZ7j30XQNQ
  631.    To:<sip:18156548285@10.10.5.14>;tag=1D6C3246313536410000155B
  632.    Call-ID:f0becd40-6f4b-1236-cf98-dd1cb2d72f2a
  633.    CSeq:117383574 INVITE
  634.    Server:PBX-IP Media Gateway/2.1
  635.    Via:SIP/2.0/UDP 10.10.101.238:5080;rport;branch=z9hG4bK7yKem4e2eHygH
  636.    Content-Length:0
  637.    
  638.    ------------------------------------------------------------------------
  639. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3023 tport_deliver() tport(000000DB8F2E4C10): msg 000000DB8E267960 (411 bytes) from udp/10.10.5.14:5080/sip next=0000000000000000
  640. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3299 agent_recv_response() nta: received 486 Busy Here for INVITE (117383574)
  641. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3366 agent_recv_response() nta: 486 Busy Here is going to a transaction
  642. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4222 tport_release() tport(000000DB8F2E4C10): 000000DB8F5A08F0 by 000000DB8F3A6390 with 000000DB8E267960
  643. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3257 tport_tsend() tport_tsend(000000DB8F2E4C10) tpn = UDP/10.10.5.14:5060
  644. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4046 tport_resolve() tport_resolve addrinfo = 10.10.5.14:5060
  645. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4680 tport_by_addrinfo() tport(000000DB8F2E4C10): not found by name UDP/10.10.5.14:5060
  646. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3594 tport_vsend() tport_vsend(000000DB8F2E4C10): 346 bytes of 346 to udp/10.10.5.14:5060
  647. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3492 tport_send_msg() tport_vsend returned 346
  648. send 346 bytes to udp/[10.10.5.14]:5060 at 19:21:19.179927:
  649.    ------------------------------------------------------------------------
  650.    ACK sip:18156548285@10.10.5.14 SIP/2.0
  651.    Via: SIP/2.0/UDP 10.10.101.238:5080;rport;branch=z9hG4bK7yKem4e2eHygH
  652.    Max-Forwards: 70
  653.    From: "SUPPORTSTREEMVM" <sip:1000@10.10.5.14>;tag=7FeeZ7j30XQNQ
  654.    To: <sip:18156548285@10.10.5.14>;tag=1D6C3246313536410000155B
  655.    Call-ID: f0becd40-6f4b-1236-cf98-dd1cb2d72f2a
  656.    CSeq: 117383574 ACK
  657.    Content-Length: 0
  658.    
  659.    ------------------------------------------------------------------------
  660. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:8304 outgoing_send() nta: sent ACK (117383574) to UDP/10.10.5.14:5060
  661. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:8722 outgoing_free() nta: outgoing_free(000000DB8F3A6A20)
  662. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B6A20): event r_invite 486 Busy Here
  663. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_session.c:4139 signal_call_state_change() nua(000000DB8F7B6A20): call state changed: calling -> init
  664. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B6A20): event i_state 486 Busy Here
  665. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B6A20): event i_terminated 486 Busy Here
  666. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_dialog.c:397 nua_dialog_usage_remove_at() nua(000000DB8F7B6A20): removing session usage
  667. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:356 soa_destroy() soa_destroy(static::000000DB8F992C50) called
  668. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:4470 nta_leg_destroy() nta_leg_destroy(000000DB90D6D8C0)
  669. d4b0f76f-e30b-4180-b12b-54d8c1fa0ea5 2018-01-08 13:21:19.178955 [NOTICE] sofia.c:8273 Hangup sofia/external/18156548285 [CS_CONSUME_MEDIA] [USER_BUSY]
  670. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:529 nua_signal() nua(000000DB8F7B6A20): sent signal r_destroy
  671. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:569 nua_stack_signal() nua(000000DB8F7B6A20): recv signal r_destroy
  672. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:4470 nta_leg_destroy() nta_leg_destroy(0000000000000000)
  673. d4b0f76f-e30b-4180-b12b-54d8c1fa0ea5 2018-01-08 13:21:19.178955 [NOTICE] switch_core_session.c:1683 Session 20 (sofia/external/18156548285) Ended
  674. d4b0f76f-e30b-4180-b12b-54d8c1fa0ea5 2018-01-08 13:21:19.178955 [NOTICE] switch_core_session.c:1687 Close Channel sofia/external/18156548285 [CS_DESTROY]
  675. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2749 tport_wakeup_pri() tport_wakeup_pri(000000DB8F2E4C10): events IN
  676. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2864 tport_recv_event() tport_recv_event(000000DB8F2E4C10)
  677. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3205 tport_recv_iovec() tport(000000DB8F2E4C10) msg 000000DB8E2671E0 from (udp/10.10.101.238:5080) has 451 bytes, veclen = 1
  678. recv 451 bytes from udp/[10.10.5.14]:1028 at 19:21:20.029990:
  679.    ------------------------------------------------------------------------
  680.    SIP/2.0 180 Ringing
  681.    Contact:<sip:18156548285@10.10.5.14:5060>
  682.    Allow:INVITE,ACK,OPTIONS,BYE,CANCEL,REGISTER,INFO,PRACK,REFER,NOTIFY
  683.    From:"SUPPORTSTREEMVM"<sip:1000@10.10.5.14>;tag=8r760236X6D8j
  684.    To:<sip:18156548285@10.10.5.14>;tag=5EE13246313536410000155C
  685.    Call-ID:f0c42408-6f4b-1236-cf98-dd1cb2d72f2a
  686.    CSeq:117383574 INVITE
  687.    Server:PBX-IP Media Gateway/2.1
  688.    Via:SIP/2.0/UDP 10.10.101.238:5080;rport;branch=z9hG4bK87c7NZZ5Btm3c
  689.    Content-Length:0
  690.    
  691.    ------------------------------------------------------------------------
  692. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3023 tport_deliver() tport(000000DB8F2E4C10): msg 000000DB8E2671E0 (451 bytes) from udp/10.10.5.14:5080/sip next=0000000000000000
  693. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3299 agent_recv_response() nta: received 180 Ringing for INVITE (117383574)
  694. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3366 agent_recv_response() nta: 180 Ringing is going to a transaction
  695. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4222 tport_release() tport(000000DB8F2E4C10): 000000DB8F5A0CB0 by 000000DB8F3A6630 with 000000DB8E2671E0 (preliminary)
  696. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B7200): event r_invite 180 Ringing
  697. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_session.c:4139 signal_call_state_change() nua(000000DB8F7B7200): call state changed: proceeding -> proceeding
  698. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B7200): event i_state 180 Ringing
  699. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2749 tport_wakeup_pri() tport_wakeup_pri(000000DB8F2E4C10): events IN
  700. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2864 tport_recv_event() tport_recv_event(000000DB8F2E4C10)
  701. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3205 tport_recv_iovec() tport(000000DB8F2E4C10) msg 000000DB8E2675A0 from (udp/10.10.101.238:5080) has 747 bytes, veclen = 1
  702. recv 747 bytes from udp/[10.10.5.14]:1028 at 19:21:23.159213:
  703.    ------------------------------------------------------------------------
  704.    SIP/2.0 200 OK
  705.    Content-Type:application/sdp
  706.    Supported:replaces,100rel
  707.    Contact:<sip:18156548285@10.10.5.14:5060>
  708.    Reason:E.182;text="Fax"
  709.    Allow:INVITE,ACK,OPTIONS,BYE,CANCEL,REGISTER,INFO,PRACK,REFER,NOTIFY
  710.    From:"SUPPORTSTREEMVM"<sip:1000@10.10.5.14>;tag=8r760236X6D8j
  711.    To:<sip:18156548285@10.10.5.14>;tag=5EE13246313536410000155C
  712.    Call-ID:f0c42408-6f4b-1236-cf98-dd1cb2d72f2a
  713.    CSeq:117383574 INVITE
  714.    Server:PBX-IP Media Gateway/2.1
  715.    Via:SIP/2.0/UDP 10.10.101.238:5080;rport;branch=z9hG4bK87c7NZZ5Btm3c
  716.    Content-Length:217
  717.    
  718.    v=0
  719.    o=phone 21830 8286 IN IP4 10.10.5.14
  720.    s=-
  721.    c=IN IP4 10.10.5.14
  722.    t=0 0
  723.    m=audio 49012 RTP/AVP 0 101 13
  724.    a=rtpmap:0 PCMU/8000/1
  725.    a=ptime:20
  726.    a=rtpmap:101 telephone-event/8000
  727.    a=fmtp:101 0-15
  728.    a=rtpmap:13 CN/8000
  729.    ------------------------------------------------------------------------
  730. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3023 tport_deliver() tport(000000DB8F2E4C10): msg 000000DB8E2675A0 (747 bytes) from udp/10.10.5.14:5080/sip next=0000000000000000
  731. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3299 agent_recv_response() nta: received 200 OK for INVITE (117383574)
  732. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3366 agent_recv_response() nta: 200 OK is going to a transaction
  733. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4222 tport_release() tport(000000DB8F2E4C10): 000000DB8F5A0CB0 by 000000DB8F3A6630 with 000000DB8E2675A0
  734. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1171 soa_set_remote_sdp() soa_set_remote_sdp(static::000000DB8F9933D0, 0000000000000000, 000000DB90B3D222, 217) called
  735. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1595 soa_process_answer() soa_process_answer(static::000000DB8F9933D0) called
  736. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1148 offer_answer_step() soa_static_offer_answer_action(000000DB8F9933D0, soa_process_answer): called
  737. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1029 soa_sdp_mode_set() soa_sdp_mode_set(000000DB8D9D1750, 000000DB8D9C6020, ""): called
  738. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1304 offer_answer_step() soa_static(000000DB8F9933D0, soa_process_answer): upgrade codecs with remote description
  739. ..\..\sofia-sip\libsofia-sip-ua\soa\soa_static.c:1446 offer_answer_step() soa_static(000000DB8F9933D0, soa_process_answer): storing local description
  740. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1730 soa_activate() soa_activate(static::000000DB8F9933D0, (nil)) called
  741. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_session.c:988 nua_session_client_response() nua(000000DB8F7B7200): INVITE: processed SDP answer in 200 OK
  742. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B7200): event r_invite 200 OK
  743. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_session.c:4139 signal_call_state_change() nua(000000DB8F7B7200): call state changed: proceeding -> completing, received answer
  744. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1098 soa_get_remote_sdp() soa_get_remote_sdp(static::000000DB8F9933D0, [000000DB9064F3B8], [000000DB9064F3A0], [0000000000000000]) called
  745. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:616 soa_get_params() soa_get_params(static::000000DB8F9933D0, ...) called
  746. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B7200): event i_state 200 OK
  747. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:529 nua_signal() nua(000000DB8F7B7200): sent signal r_ack
  748. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:569 nua_stack_signal() nua(000000DB8F7B7200): recv signal r_ack
  749. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:403 soa_set_params() soa_set_params(static::000000DB8F9933D0, ...) called
  750. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1730 soa_activate() soa_activate(static::000000DB8F9933D0, (nil)) called
  751. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:2665 nta_tpn_by_url() nta: selecting scheme sip
  752. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3257 tport_tsend() tport_tsend(000000DB8F2E4C10) tpn = */10.10.5.14:5060
  753. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4046 tport_resolve() tport_resolve addrinfo = 10.10.5.14:5060
  754. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4680 tport_by_addrinfo() tport(000000DB8F2E4C10): not found by name */10.10.5.14:5060
  755. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3594 tport_vsend() tport_vsend(000000DB8F2E4C10): 428 bytes of 428 to udp/10.10.5.14:5060
  756. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3492 tport_send_msg() tport_vsend returned 428
  757. send 428 bytes to udp/[10.10.5.14]:5060 at 19:21:23.165212:
  758.    ------------------------------------------------------------------------
  759.    ACK sip:18156548285@10.10.5.14:5060 SIP/2.0
  760.    Via: SIP/2.0/UDP 10.10.101.238:5080;rport;branch=z9hG4bK9g6ZQtg982apr
  761.    Max-Forwards: 70
  762.    From: "SUPPORTSTREEMVM" <sip:1000@10.10.5.14>;tag=8r760236X6D8j
  763.    To: <sip:18156548285@10.10.5.14>;tag=5EE13246313536410000155C
  764.    Call-ID: f0c42408-6f4b-1236-cf98-dd1cb2d72f2a
  765.    CSeq: 117383574 ACK
  766.    Contact: <sip:gw+10.10.5.14@10.10.101.238:5080;transport=udp;gw=10.10.5.14>
  767.    Content-Length: 0
  768.    
  769.    ------------------------------------------------------------------------
  770. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:8304 outgoing_send() nta: sent ACK (117383574) to */10.10.5.14:5060
  771. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_session.c:4139 signal_call_state_change() nua(000000DB8F7B7200): call state changed: completing -> ready
  772. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B7200): event i_state 200 ACK sent
  773. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B7200): event i_active 200 Call active
  774. fb05e962-059f-4bb4-b9e1-54130ed0b2e3 2018-01-08 13:21:23.159213 [NOTICE] sofia.c:8218 Channel [sofia/external/18156548285] has been answered
  775. fb05e962-059f-4bb4-b9e1-54130ed0b2e3 2018-01-08 13:21:23.179211 [INFO] switch_channel.c:3129 sofia/external/18156548285 Flipping CID from "SUPPORTSTREEMVM" <8887344585> to "Outbound Call" <18156548285>
  776. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2749 tport_wakeup_pri() tport_wakeup_pri(000000DB8F2E4C10): events IN
  777. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2864 tport_recv_event() tport_recv_event(000000DB8F2E4C10)
  778. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3205 tport_recv_iovec() tport(000000DB8F2E4C10) msg 000000DB8E266A60 from (udp/10.10.101.238:5080) has 865 bytes, veclen = 1
  779. recv 865 bytes from udp/[10.10.5.14]:1028 at 19:21:23.186209:
  780.    ------------------------------------------------------------------------
  781.    INVITE sip:gw+10.10.5.14@10.10.101.238:5080;transport=udp;gw=10.10.5.14 SIP/2.0
  782.    Content-Type:application/sdp
  783.    Allow:INVITE,BYE,CANCEL,REFER,NOTIFY,OPTIONS,REGISTER,INFO,ACK,PRACK
  784.    Supported:100rel,replaces
  785.    Expires:120
  786.    To:"SUPPORTSTREEMVM"<sip:1000@10.10.5.14>;tag=8r760236X6D8j
  787.    From:<sip:18156548285@10.10.5.14>;tag=5EE13246313536410000155C
  788.    Call-ID:f0c42408-6f4b-1236-cf98-dd1cb2d72f2a
  789.    CSeq:1 INVITE
  790.    Max-Forwards:70
  791.    User-Agent:PBX-IP Media Gateway
  792.    Contact:<sip:18156548285@10.10.5.14:5060>
  793.    Via:SIP/2.0/UDP 10.10.5.14:5060;branch=z9hG4bK12A5F71F4F26DE87885611256A0FA027
  794.    Content-Length:263
  795.    
  796.    v=0
  797.    o=phone 21830 8287 IN IP4 10.10.5.14
  798.    s=-
  799.    c=IN IP4 10.10.5.14
  800.    t=0 0
  801.    m=image 49012 udptl t38
  802.    a=T38FaxMaxBuffer:1800
  803.    a=T38FaxMaxDatagram:150
  804.    a=T38FaxVersion:0
  805.    a=T38MaxBitRate:14400
  806.    a=T38FaxRateManagement:transferredTCF
  807.    a=T38FaxUdpEC:t38UDPRedundancy
  808.    ------------------------------------------------------------------------
  809. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3023 tport_deliver() tport(000000DB8F2E4C10): msg 000000DB8E266A60 (865 bytes) from udp/10.10.5.14:5080/sip next=0000000000000000
  810. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:2880 agent_recv_request() nta: received INVITE sip:gw+10.10.5.14@10.10.101.238:5080;transport=udp;gw=10.10.5.14 SIP/2.0 (CSeq 1)
  811. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3248 agent_aliases() nta: canonizing sip:gw+10.10.5.14@10.10.101.238:5080 with contact
  812. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3060 agent_recv_request() nta: INVITE (1) going to existing leg
  813. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:1348 set_timeout() nta: timer shortened to 200 ms
  814. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1302 soa_init_offer_answer() soa_init_offer_answer(static::000000DB8F9933D0) called
  815. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1171 soa_set_remote_sdp() soa_set_remote_sdp(static::000000DB8F9933D0, 0000000000000000, 000000DB8E4E653A, 263) called
  816. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3257 tport_tsend() tport_tsend(000000DB8F2E4C10) tpn = UDP/10.10.5.14:5060
  817. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4046 tport_resolve() tport_resolve addrinfo = 10.10.5.14:5060
  818. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4680 tport_by_addrinfo() tport(000000DB8F2E4C10): not found by name UDP/10.10.5.14:5060
  819. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3594 tport_vsend() tport_vsend(000000DB8F2E4C10): 386 bytes of 386 to udp/10.10.5.14:5060
  820. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3492 tport_send_msg() tport_vsend returned 386
  821. send 386 bytes to udp/[10.10.5.14]:5060 at 19:21:23.186209:
  822.    ------------------------------------------------------------------------
  823.    SIP/2.0 100 Trying
  824.    Via:SIP/2.0/UDP 10.10.5.14:5060;branch=z9hG4bK12A5F71F4F26DE87885611256A0FA027
  825.    From:<sip:18156548285@10.10.5.14>;tag=5EE13246313536410000155C
  826.    To:"SUPPORTSTREEMVM"<sip:1000@10.10.5.14>;tag=8r760236X6D8j
  827.    Call-ID:f0c42408-6f4b-1236-cf98-dd1cb2d72f2a
  828.    CSeq:1 INVITE
  829.    User-Agent: FreeSWITCH-mod_sofia/1.6.19+git~20171109T180403Z~27aebc7253~64bit
  830.    Content-Length: 0
  831.    
  832.    ------------------------------------------------------------------------
  833. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:6791 incoming_reply() nta: sent 100 Trying for INVITE (1)
  834. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B7200): event i_invite 100 Trying
  835. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_session.c:4145 signal_call_state_change() nua(000000DB8F7B7200): ready call updated: received received offer
  836. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1098 soa_get_remote_sdp() soa_get_remote_sdp(static::000000DB8F9933D0, [000000DB9064F288], [000000DB9064F270], [0000000000000000]) called
  837. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B7200): event i_state 100 Trying
  838. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:529 nua_signal() nua(000000DB8F7B7200): sent signal r_respond
  839. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:573 nua_stack_signal() nua(000000DB8F7B7200): recv signal r_respond 488 Not Acceptable Here
  840. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:403 soa_set_params() soa_set_params(static::000000DB8F9933D0, ...) called
  841. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1214 soa_clear_remote_sdp() soa_clear_remote_sdp(static::000000DB8F9933D0) called
  842. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3257 tport_tsend() tport_tsend(000000DB8F2E4C10) tpn = UDP/10.10.5.14:5060
  843. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4046 tport_resolve() tport_resolve addrinfo = 10.10.5.14:5060
  844. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4680 tport_by_addrinfo() tport(000000DB8F2E4C10): not found by name UDP/10.10.5.14:5060
  845. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3594 tport_vsend() tport_vsend(000000DB8F2E4C10): 548 bytes of 548 to udp/10.10.5.14:5060
  846. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3492 tport_send_msg() tport_vsend returned 548
  847. send 548 bytes to udp/[10.10.5.14]:5060 at 19:21:23.199207:
  848.    ------------------------------------------------------------------------
  849.    SIP/2.0 488 Not Acceptable Here
  850.    Via:SIP/2.0/UDP 10.10.5.14:5060;branch=z9hG4bK12A5F71F4F26DE87885611256A0FA027
  851.    From:<sip:18156548285@10.10.5.14>;tag=5EE13246313536410000155C
  852.    To:"SUPPORTSTREEMVM"<sip:1000@10.10.5.14>;tag=8r760236X6D8j
  853.    Call-ID:f0c42408-6f4b-1236-cf98-dd1cb2d72f2a
  854.    CSeq:1 INVITE
  855.    User-Agent: FreeSWITCH-mod_sofia/1.6.19+git~20171109T180403Z~27aebc7253~64bit
  856.    Accept: application/sdp
  857.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  858.    Supported: timer, path, replaces
  859.    Content-Length: 0
  860.    
  861.    ------------------------------------------------------------------------
  862. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:6791 incoming_reply() nta: sent 488 Not Acceptable Here for INVITE (1)
  863. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_session.c:4145 signal_call_state_change() nua(000000DB8F7B7200): ready call updated: init
  864. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B7200): event i_state 488 Not Acceptable Here
  865. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B7200): event i_active 488 Call active
  866. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:1302 soa_init_offer_answer() soa_init_offer_answer(static::000000DB8F9933D0) called
  867. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2749 tport_wakeup_pri() tport_wakeup_pri(000000DB8F2E4C10): events IN
  868. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2864 tport_recv_event() tport_recv_event(000000DB8F2E4C10)
  869. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3205 tport_recv_iovec() tport(000000DB8F2E4C10) msg 000000DB8E2662E0 from (udp/10.10.101.238:5080) has 411 bytes, veclen = 1
  870. recv 411 bytes from udp/[10.10.5.14]:1028 at 19:21:23.219210:
  871.    ------------------------------------------------------------------------
  872.    ACK sip:gw+10.10.5.14@10.10.101.238:5080;transport=udp;gw=10.10.5.14 SIP/2.0
  873.    Call-ID:f0c42408-6f4b-1236-cf98-dd1cb2d72f2a
  874.    CSeq:1 ACK
  875.    From:<sip:18156548285@10.10.5.14>;tag=5EE13246313536410000155C
  876.    To:"SUPPORTSTREEMVM"<sip:1000@10.10.5.14>;tag=8r760236X6D8j
  877.    Via:SIP/2.0/UDP 10.10.5.14:5060;branch=z9hG4bK12A5F71F4F26DE87885611256A0FA027
  878.    Max-Forwards:70
  879.    User-Agent:PBX-IP Media Gateway
  880.    Content-Length:0
  881.    
  882.    ------------------------------------------------------------------------
  883. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3023 tport_deliver() tport(000000DB8F2E4C10): msg 000000DB8E2662E0 (411 bytes) from udp/10.10.5.14:5080/sip next=0000000000000000
  884. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:2880 agent_recv_request() nta: received ACK sip:gw+10.10.5.14@10.10.101.238:5080;transport=udp;gw=10.10.5.14 SIP/2.0 (CSeq 1)
  885. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3019 agent_recv_request() nta: ACK (1) is going to INVITE (1)
  886. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2749 tport_wakeup_pri() tport_wakeup_pri(000000DB8F2E4C10): events IN
  887. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:2864 tport_recv_event() tport_recv_event(000000DB8F2E4C10)
  888. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3205 tport_recv_iovec() tport(000000DB8F2E4C10) msg 000000DB8E2662E0 from (udp/10.10.101.238:5080) has 440 bytes, veclen = 1
  889. recv 440 bytes from udp/[10.10.5.14]:1028 at 19:21:23.225246:
  890.    ------------------------------------------------------------------------
  891.    BYE sip:gw+10.10.5.14@10.10.101.238:5080;transport=udp;gw=10.10.5.14 SIP/2.0
  892.    Reason:E.182;text="Unknown"
  893.    To:"SUPPORTSTREEMVM"<sip:1000@10.10.5.14>;tag=8r760236X6D8j
  894.    From:<sip:18156548285@10.10.5.14>;tag=5EE13246313536410000155C
  895.    Call-ID:f0c42408-6f4b-1236-cf98-dd1cb2d72f2a
  896.    CSeq:2 BYE
  897.    Max-Forwards:70
  898.    User-Agent:PBX-IP Media Gateway
  899.    Via:SIP/2.0/UDP 10.10.5.14:5060;branch=z9hG4bK0AFCAE9B17E7D9127AE53C4E8A560C4D
  900.    Content-Length:0
  901.    
  902.    ------------------------------------------------------------------------
  903. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3023 tport_deliver() tport(000000DB8F2E4C10): msg 000000DB8E2662E0 (440 bytes) from udp/10.10.5.14:5080/sip next=0000000000000000
  904. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:2880 agent_recv_request() nta: received BYE sip:gw+10.10.5.14@10.10.101.238:5080;transport=udp;gw=10.10.5.14 SIP/2.0 (CSeq 2)
  905. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3248 agent_aliases() nta: canonizing sip:gw+10.10.5.14@10.10.101.238:5080 with contact
  906. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:3060 agent_recv_request() nta: BYE (2) going to existing leg
  907. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B7200): event i_bye 100 Trying
  908. fb05e962-059f-4bb4-b9e1-54130ed0b2e3 2018-01-08 13:21:23.239246 [NOTICE] sofia.c:1012 Hangup sofia/external/18156548285 [CS_EXECUTE] [NORMAL_CLEARING]
  909. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:529 nua_signal() nua(000000DB8F7B7200): sent signal r_respond
  910. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:529 nua_signal() nua(000000DB8F7B7200): sent signal r_destroy
  911. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:573 nua_stack_signal() nua(000000DB8F7B7200): recv signal r_respond 200 OK
  912. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:403 soa_set_params() soa_set_params(static::000000DB8F9933D0, ...) called
  913. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3257 tport_tsend() tport_tsend(000000DB8F2E4C10) tpn = UDP/10.10.5.14:5060
  914. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4046 tport_resolve() tport_resolve addrinfo = 10.10.5.14:5060
  915. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:4680 tport_by_addrinfo() tport(000000DB8F2E4C10): not found by name UDP/10.10.5.14:5060
  916. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3594 tport_vsend() tport_vsend(000000DB8F2E4C10): 503 bytes of 503 to udp/10.10.5.14:5060
  917. ..\..\sofia-sip\libsofia-sip-ua\tport\tport.c:3492 tport_send_msg() tport_vsend returned 503
  918. send 503 bytes to udp/[10.10.5.14]:5060 at 19:21:23.240214:
  919.    ------------------------------------------------------------------------
  920.    SIP/2.0 200 OK
  921.    Via:SIP/2.0/UDP 10.10.5.14:5060;branch=z9hG4bK0AFCAE9B17E7D9127AE53C4E8A560C4D
  922.    From:<sip:18156548285@10.10.5.14>;tag=5EE13246313536410000155C
  923.    To:"SUPPORTSTREEMVM"<sip:1000@10.10.5.14>;tag=8r760236X6D8j
  924.    Call-ID:f0c42408-6f4b-1236-cf98-dd1cb2d72f2a
  925.    CSeq:2 BYE
  926.    User-Agent: FreeSWITCH-mod_sofia/1.6.19+git~20171109T180403Z~27aebc7253~64bit
  927.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  928.    Supported: timer, path, replaces
  929.    Content-Length: 0
  930.    
  931.    ------------------------------------------------------------------------
  932. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:6791 incoming_reply() nta: sent 200 OK for BYE (2)
  933. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_dialog.c:397 nua_dialog_usage_remove_at() nua(000000DB8F7B7200): removing session usage
  934. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_session.c:4139 signal_call_state_change() nua(000000DB8F7B7200): call state changed: ready -> terminated
  935. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B7200): event i_state 200 Session Terminated
  936. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:271 nua_stack_event() nua(000000DB8F7B7200): event i_terminated 200 Session Terminated
  937. ..\..\sofia-sip\libsofia-sip-ua\soa\soa.c:356 soa_destroy() soa_destroy(static::000000DB8F9933D0) called
  938. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:4470 nta_leg_destroy() nta_leg_destroy(000000DB90D6DBC0)
  939. ..\..\sofia-sip\libsofia-sip-ua\nua\nua_stack.c:569 nua_stack_signal() nua(000000DB8F7B7200): recv signal r_destroy
  940. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:4470 nta_leg_destroy() nta_leg_destroy(0000000000000000)
  941. fb05e962-059f-4bb4-b9e1-54130ed0b2e3 2018-01-08 13:21:23.239246 [NOTICE] switch_core_session.c:1683 Session 21 (sofia/external/18156548285) Ended
  942. fb05e962-059f-4bb4-b9e1-54130ed0b2e3 2018-01-08 13:21:23.239246 [NOTICE] switch_core_session.c:1687 Close Channel sofia/external/18156548285 [CS_DESTROY]
  943. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:1296 agent_timer() nta: timer set next to 106 ms
  944. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:7159 _nta_incoming_timer() nta: timer J fired, terminate 200 response
  945. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:5825 incoming_reclaim_queued() incoming_reclaim_all(0000000000000000, 0000000000000000, 000000DB9064FA40)
  946. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:7188 _nta_incoming_timer() nta_incoming_timer: 0/0 resent, 0/0 tout, 1/3 term, 1/3 free
  947. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:1296 agent_timer() nta: timer set next to 4727 ms
  948. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:7134 _nta_incoming_timer() nta: timer I fired, terminate 488 response
  949. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:5825 incoming_reclaim_queued() incoming_reclaim_all(0000000000000000, 0000000000000000, 000000DB9064FA40)
  950. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:7188 _nta_incoming_timer() nta_incoming_timer: 0/0 resent, 0/0 tout, 1/2 term, 1/2 free
  951. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:1296 agent_timer() nta: timer set next to 22960 ms
  952. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:9101 outgoing_timer_dk() nta: timer D fired, terminate INVITE (117383574)
  953. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:8799 outgoing_reclaim_queued() outgoing_reclaim_all(0000000000000000, 0000000000000000, 000000DB9064FA40)
  954. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:8929 _nta_outgoing_timer() nta_outgoing_timer: 0/0 resent, 0/1 tout, 1/2 term, 1/3 free
  955. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:1296 agent_timer() nta: timer set next to 3979 ms
  956. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:9101 outgoing_timer_dk() nta: timer D fired, terminate INVITE (117383574)
  957. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:8799 outgoing_reclaim_queued() outgoing_reclaim_all(0000000000000000, 0000000000000000, 000000DB9064FA40)
  958. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:8929 _nta_outgoing_timer() nta_outgoing_timer: 0/0 resent, 0/1 tout, 1/1 term, 1/2 free
  959. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:1296 agent_timer() nta: timer set next to 6 ms
  960. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:8982 outgoing_timer_bf() nta: timer F fired, terminating ACK (117383574)
  961. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:8799 outgoing_reclaim_queued() outgoing_reclaim_all(0000000000000000, 0000000000000000, 000000DB9064FA40)
  962. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:8929 _nta_outgoing_timer() nta_outgoing_timer: 0/0 resent, 1/1 tout, 0/0 term, 1/1 free
  963. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:1296 agent_timer() nta: timer set next to 74 ms
  964. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:7159 _nta_incoming_timer() nta: timer J fired, terminate 200 response
  965. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:5825 incoming_reclaim_queued() incoming_reclaim_all(0000000000000000, 0000000000000000, 000000DB9064FA40)
  966. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:7188 _nta_incoming_timer() nta_incoming_timer: 0/0 resent, 0/0 tout, 1/1 term, 1/1 free
  967. ..\..\sofia-sip\libsofia-sip-ua\nta\nta.c:1289 agent_timer() nta: timer not set
  968.