From Bistre Cheetah, 5 Years ago, written in Plain Text.
- view diff
Embed
  1.    ------------------------------------------------------------------------
  2.    INVITE sip:1000@159.89.163.195:5020 SIP/2.0
  3.    Via: SIP/2.0/UDP 192.168.1.4:64343;branch=z9hG4bK-524287-1---db742d5d8e370f4f;rport
  4.    Max-Forwards: 70
  5.    Contact: <sip:1000@183.82.203.220:23502;rinstance=455085c26772fb89>
  6.    To: <sip:1000@159.89.163.195:5020>
  7.    From: "1000"<sip:1000@159.89.163.195:5020>;tag=34407550
  8.    Call-ID: 92627MzJlOWE2MzNlZDM5ODhkZTc4YzJjZGM2YmFlZDdhNTU
  9.    CSeq: 1 INVITE
  10.    Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
  11.    Content-Type: application/sdp
  12.    Supported: replaces
  13.    User-Agent: X-Lite release 5.3.2 stamp 92627
  14.    Content-Length: 207
  15.  
  16.    v=0
  17.    o=- 13185393934421558 1 IN IP4 192.168.1.4
  18.    s=X-Lite release 5.3.2 stamp 92627
  19.    c=IN IP4 192.168.1.4
  20.    t=0 0
  21.    m=audio 50586 RTP/AVP 0 101
  22.    a=rtpmap:101 telephone-event/8000
  23.    a=fmtp:101 0-15
  24.    a=sendrecv
  25.    ------------------------------------------------------------------------
  26. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.904815 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/1000@159.89.163.195:5020 [18923368-a8a9-4a94-9b9f-dcceaca1e6c8]
  27. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.904815 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1000@159.89.163.195:5020) Running State Change CS_NEW (Cur 1 Tot 22)
  28. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.904815 [DEBUG] sofia.c:10080 sofia/internal/1000@159.89.163.195:5020 receiving invite from 183.82.203.220:23502 version: 1.8.2 git a98a958 2018-09-26 17:55:25Z 64bit
  29. 2018-10-30 12:26:00.904815 [DEBUG] sofia.c:10251 IP 183.82.203.220 Rejected by acl "domains". Falling back to Digest auth.
  30. send 907 bytes to udp/[183.82.203.220]:23502 at 12:26:00.915024:
  31.    ------------------------------------------------------------------------
  32.    SIP/2.0 407 Proxy Authentication Required
  33.    Via: SIP/2.0/UDP 192.168.1.4:64343;branch=z9hG4bK-524287-1---db742d5d8e370f4f;rport=23502;received=183.82.203.220
  34.    From: "1000"<sip:1000@159.89.163.195:5020>;tag=34407550
  35.    To: <sip:1000@159.89.163.195:5020>;tag=BUH1eSKQQZ1DN
  36.    Call-ID: 92627MzJlOWE2MzNlZDM5ODhkZTc4YzJjZGM2YmFlZDdhNTU
  37.    CSeq: 1 INVITE
  38.    User-Agent: FreeSWITCH-mod_sofia/1.8.2+git~20180926T175525Z~a98a958ac3~64bit
  39.    Accept: application/sdp
  40.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  41.    Supported: timer, path, replaces
  42.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  43.    Proxy-Authenticate: Digest realm="159.89.163.195", nonce="4dbd93c8-ce87-4255-ade9-f4f291831cbb", algorithm=MD5, qop="auth"
  44.    Content-Length: 0
  45.  
  46.    ------------------------------------------------------------------------
  47. 2018-10-30 12:26:00.914806 [DEBUG] sofia.c:2413 detaching session 18923368-a8a9-4a94-9b9f-dcceaca1e6c8
  48. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.914806 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/1000@159.89.163.195:5020) State NEW
  49. recv 349 bytes from udp/[183.82.203.220]:23502 at 12:26:00.942172:
  50.    ------------------------------------------------------------------------
  51.    ACK sip:1000@159.89.163.195:5020 SIP/2.0
  52.    Via: SIP/2.0/UDP 192.168.1.4:64343;branch=z9hG4bK-524287-1---db742d5d8e370f4f;rport
  53.    Max-Forwards: 70
  54.    To: <sip:1000@159.89.163.195:5020>;tag=BUH1eSKQQZ1DN
  55.    From: "1000"<sip:1000@159.89.163.195:5020>;tag=34407550
  56.    Call-ID: 92627MzJlOWE2MzNlZDM5ODhkZTc4YzJjZGM2YmFlZDdhNTU
  57.    CSeq: 1 ACK
  58.    Content-Length: 0
  59.  
  60.    ------------------------------------------------------------------------
  61. recv 1065 bytes from udp/[183.82.203.220]:23502 at 12:26:00.944902:
  62.    ------------------------------------------------------------------------
  63.    INVITE sip:1000@159.89.163.195:5020 SIP/2.0
  64.    Via: SIP/2.0/UDP 192.168.1.4:64343;branch=z9hG4bK-524287-1---2604a17df0500073;rport
  65.    Max-Forwards: 70
  66.    Contact: <sip:1000@183.82.203.220:23502;rinstance=455085c26772fb89>
  67.    To: <sip:1000@159.89.163.195:5020>
  68.    From: "1000"<sip:1000@159.89.163.195:5020>;tag=34407550
  69.    Call-ID: 92627MzJlOWE2MzNlZDM5ODhkZTc4YzJjZGM2YmFlZDdhNTU
  70.    CSeq: 2 INVITE
  71.    Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
  72.    Content-Type: application/sdp
  73.    Proxy-Authorization: Digest username="1000",realm="159.89.163.195",nonce="4dbd93c8-ce87-4255-ade9-f4f291831cbb",uri="sip:1000@159.89.163.195:5020",response="2a67bbd049f241a35d730f39dc038f80",cnonce="9d2d6facce122e838e69bdec92cc09c4",nc=00000001,qop=auth,algorithm=MD5
  74.    Supported: replaces
  75.    User-Agent: X-Lite release 5.3.2 stamp 92627
  76.    Content-Length: 207
  77.  
  78.    v=0
  79.    o=- 13185393934421558 1 IN IP4 192.168.1.4
  80.    s=X-Lite release 5.3.2 stamp 92627
  81.    c=IN IP4 192.168.1.4
  82.    t=0 0
  83.    m=audio 50586 RTP/AVP 0 101
  84.    a=rtpmap:101 telephone-event/8000
  85.    a=fmtp:101 0-15
  86.    a=sendrecv
  87.    ------------------------------------------------------------------------
  88. 2018-10-30 12:26:00.944817 [DEBUG] sofia.c:2522 Re-attaching to session 18923368-a8a9-4a94-9b9f-dcceaca1e6c8
  89. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] sofia.c:10080 sofia/internal/1000@159.89.163.195:5020 receiving invite from 183.82.203.220:23502 version: 1.8.2 git a98a958 2018-09-26 17:55:25Z 64bit
  90. 2018-10-30 12:26:00.954806 [DEBUG] sofia.c:10251 IP 183.82.203.220 Rejected by acl "domains". Falling back to Digest auth.
  91. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] sofia.c:11388 Setting NAT mode based on nat.auto
  92. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] sofia.c:7291 Channel sofia/internal/1000@159.89.163.195:5020 entering state [received][100]
  93. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] sofia.c:7301 Remote SDP:
  94. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 v=0
  95. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 o=- 13185393934421558 1 IN IP4 192.168.1.4
  96. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 s=X-Lite release 5.3.2 stamp 92627
  97. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 c=IN IP4 192.168.1.4
  98. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 t=0 0
  99. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 m=audio 50586 RTP/AVP 0 101
  100. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 a=rtpmap:101 telephone-event/8000
  101. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 a=fmtp:101 0-15
  102. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8
  103. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] sofia.c:7695 (sofia/internal/1000@159.89.163.195:5020) State Change CS_NEW -> CS_INIT
  104. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1000@159.89.163.195:5020) Running State Change CS_INIT (Cur 1 Tot 22)
  105. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1000@159.89.163.195:5020) State INIT
  106. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_sofia.c:93 sofia/internal/1000@159.89.163.195:5020 SOFIA INIT
  107. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1000@159.89.163.195:5020 Standard INIT
  108. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1000@159.89.163.195:5020) State Change CS_INIT -> CS_ROUTING
  109. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1000@159.89.163.195:5020) State INIT going to sleep
  110. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1000@159.89.163.195:5020) Running State Change CS_ROUTING (Cur 1 Tot 22)
  111. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] switch_channel.c:2249 (sofia/internal/1000@159.89.163.195:5020) Callstate Change DOWN -> RINGING
  112. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1000@159.89.163.195:5020) State ROUTING
  113. send 402 bytes to udp/[183.82.203.220]:23502 at 12:26:00.956768:
  114.    ------------------------------------------------------------------------
  115.    SIP/2.0 100 Trying
  116.    Via: SIP/2.0/UDP 192.168.1.4:64343;branch=z9hG4bK-524287-1---2604a17df0500073;rport=23502;received=183.82.203.220
  117.    From: "1000"<sip:1000@159.89.163.195:5020>;tag=34407550
  118.    To: <sip:1000@159.89.163.195:5020>
  119.    Call-ID: 92627MzJlOWE2MzNlZDM5ODhkZTc4YzJjZGM2YmFlZDdhNTU
  120.    CSeq: 2 INVITE
  121.    User-Agent: FreeSWITCH-mod_sofia/1.8.2+git~20180926T175525Z~a98a958ac3~64bit
  122.    Content-Length: 0
  123.  
  124.    ------------------------------------------------------------------------
  125. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_sofia.c:154 sofia/internal/1000@159.89.163.195:5020 SOFIA ROUTING
  126. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] switch_core_state_machine.c:236 sofia/internal/1000@159.89.163.195:5020 Standard ROUTING
  127. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [INFO] mod_dialplan_xml.c:637 Processing 1000 <1000>->1000 in context default
  128. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 parsing [default->ee634e42-e806-4e15-9abe-969d09a3eb33] continue=false
  129. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Regex (PASS) [ee634e42-e806-4e15-9abe-969d09a3eb33] destination_number(1000) =~ /^1000$/ break=on-false
  130. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action clear_digit_action(all)
  131. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action export(bind_digit_digit_timeout=200)
  132. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action unset(sip_h_X-Weave-DC)
  133. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action unset(sip_h_X-Loop-Data)
  134. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action unset(sip_h_X-Weave-External)
  135. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action unset(sip_h_X-Weave-Internal)
  136. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action unset(sip_h_X-Weave-Outbound)
  137. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action export(weave_domain=dev-scott)
  138. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action export(w_domain=dev-scott.getweave.io)
  139. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action export(selected_carrier=twilio)
  140. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(cdr_log=true)
  141. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(cdr_direction=inbound)
  142. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(cdr_dialed_number=8017970178)
  143. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(cdr_caller_name=Weave )
  144. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(cdr_caller_number=7164186158)
  145. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(cdr_auto_sms_webhook_url=http://admin-api.client:8000/portal/v1/phones/missedcall)
  146. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(cdr_auto_sms_webhook_key=4G7tEQa0CQB8XlXs-JkdiP3AFRBT3pIrG-hm0k1GK4QZMBzMM4)
  147. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action limit(hash dev-scott.getweave.io inbound 10 inbound_exceeded)
  148. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(w_cdr_originator=7164186158)
  149. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(w_cdr_destination=8017970178)
  150. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(w_cdr_direction=inbound)
  151. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(w_call_direction=inbound)
  152. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(RECORD_STEREO=true)
  153. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(media_bug_answer_req=true)
  154. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(recording_follow_transfer=true)
  155. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(record_post_process_exec_app=bgsystem:curl -d /temp_recordings/dev-scott_2018-10-30_ee634e42-e806-4e15-9abe-969d09a3eb33.mp3 http:///pub?topic=CallRecording)
  156. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(execute_on_answer=record_session /temp_recordings/dev-scott_2018-10-30_ee634e42-e806-4e15-9abe-969d09a3eb33.mp3)
  157. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action export(location_id=94472cd8-2b1c-4b44-94fe-9708c2bd739d)
  158. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(weave_lookup_number=${caller_id_number})
  159. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(continue_on_fail=true)
  160. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(hangup_after_bridge=true)
  161. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(hold_music=local_stream://moh)
  162. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(temp_hold_music=local_stream://moh)
  163. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(cdr_slug=dev-scott)
  164. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(generated_channel_id_eschmidbauer02_dev-scott=1a9b5231-e815-4aba-900d-ecf1089e848f)
  165. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(cdr_sip_id_eschmidbauer02_dev-scott=44ea632a-a36d-4f3e-b2cc-5272065d1d09)
  166. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(cdr_sip_name_eschmidbauer02_dev-scott=eschmidbauer02)
  167. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(generated_channel_id_eschmidbauer01_dev-scott=8f00162e-9926-4f19-a078-b88487aa6e58)
  168. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(cdr_sip_id_eschmidbauer01_dev-scott=126385ac-5c42-4b20-bc64-0eec19733a42)
  169. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(cdr_sip_name_eschmidbauer01_dev-scott=E-VVX400)
  170. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(generated_channel_id_xlite_dev-scott=f60035e5-788e-4acd-9d86-18f19ae75dec)
  171. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(cdr_sip_id_xlite_dev-scott=4073da9c-2359-4f2b-ae75-7fc06748ba78)
  172. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(cdr_sip_name_xlite_dev-scott=xlite)
  173. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(generated_channel_id_eschmidbauer03_dev-scott=f403f20c-cb2e-40f9-bde5-d1ad9e10616b)
  174. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(cdr_sip_id_eschmidbauer03_dev-scott=1fa6d75e-765e-4110-a8e1-13f7df9275c0)
  175. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(cdr_sip_name_eschmidbauer03_dev-scott=vvx500)
  176. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(generated_channel_id_testline05_dev-scott=3573a9a4-b04e-4ab1-92e8-dfaa401c1b85)
  177. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(cdr_sip_id_testline05_dev-scott=1b112711-e324-484a-bbc5-f17564d26935)
  178. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(cdr_sip_name_testline05_dev-scott=testline05)
  179. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(mobile_app=eschmidbauer01;xlite)
  180. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action set(desk_phone=eschmidbauer02;eschmidbauer03;testline05)
  181. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 Dialplan: sofia/internal/1000@159.89.163.195:5020 Action bridge({origination_uuid=14a8bd6f-af2e-4b1d-8d18-bd59d863387f}user/1003@${domain_name})
  182. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/1000@159.89.163.195:5020) State Change CS_ROUTING -> CS_EXECUTE
  183. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1000@159.89.163.195:5020) State ROUTING going to sleep
  184. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1000@159.89.163.195:5020) Running State Change CS_EXECUTE (Cur 1 Tot 22)
  185. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/1000@159.89.163.195:5020) State EXECUTE
  186. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_sofia.c:209 sofia/internal/1000@159.89.163.195:5020 SOFIA EXECUTE
  187. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] switch_core_state_machine.c:328 sofia/internal/1000@159.89.163.195:5020 Standard EXECUTE
  188. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 clear_digit_action(all)
  189. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 export(bind_digit_digit_timeout=200)
  190. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [bind_digit_digit_timeout]=[200]
  191. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 unset(sip_h_X-Weave-DC)
  192. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1743 UNSET [sip_h_X-Weave-DC]
  193. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 unset(sip_h_X-Loop-Data)
  194. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1743 UNSET [sip_h_X-Loop-Data]
  195. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 unset(sip_h_X-Weave-External)
  196. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1743 UNSET [sip_h_X-Weave-External]
  197. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 unset(sip_h_X-Weave-Internal)
  198. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1743 UNSET [sip_h_X-Weave-Internal]
  199. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 unset(sip_h_X-Weave-Outbound)
  200. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1743 UNSET [sip_h_X-Weave-Outbound]
  201. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 export(weave_domain=dev-scott)
  202. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [weave_domain]=[dev-scott]
  203. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 export(w_domain=dev-scott.getweave.io)
  204. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [w_domain]=[dev-scott.getweave.io]
  205. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 export(selected_carrier=twilio)
  206. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [selected_carrier]=[twilio]
  207. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(cdr_log=true)
  208. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [cdr_log]=[true]
  209. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(cdr_direction=inbound)
  210. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [cdr_direction]=[inbound]
  211. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(cdr_dialed_number=8017970178)
  212. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [cdr_dialed_number]=[8017970178]
  213. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(cdr_caller_name=Weave )
  214. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [cdr_caller_name]=[Weave ]
  215. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(cdr_caller_number=7164186158)
  216. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [cdr_caller_number]=[7164186158]
  217. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(cdr_auto_sms_webhook_url=http://admin-api.client:8000/portal/v1/phones/missedcall)
  218. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [cdr_auto_sms_webhook_url]=[http://admin-api.client:8000/portal/v1/phones/missedcall]
  219. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(cdr_auto_sms_webhook_key=4G7tEQa0CQB8XlXs-JkdiP3AFRBT3pIrG-hm0k1GK4QZMBzMM4)
  220. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [cdr_auto_sms_webhook_key]=[4G7tEQa0CQB8XlXs-JkdiP3AFRBT3pIrG-hm0k1GK4QZMBzMM4]
  221. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 limit(hash dev-scott.getweave.io inbound 10 inbound_exceeded)
  222. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] switch_limit.c:126 incr called: dev-scott.getweave.io_inbound max:10, interval:0
  223. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_hash.c:196 Usage for dev-scott.getweave.io_inbound is now 1/10
  224. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(w_cdr_originator=7164186158)
  225. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [w_cdr_originator]=[7164186158]
  226. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(w_cdr_destination=8017970178)
  227. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [w_cdr_destination]=[8017970178]
  228. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(w_cdr_direction=inbound)
  229. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [w_cdr_direction]=[inbound]
  230. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(w_call_direction=inbound)
  231. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [w_call_direction]=[inbound]
  232. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(RECORD_STEREO=true)
  233. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [RECORD_STEREO]=[true]
  234. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(media_bug_answer_req=true)
  235. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [media_bug_answer_req]=[true]
  236. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(recording_follow_transfer=true)
  237. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [recording_follow_transfer]=[true]
  238. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(record_post_process_exec_app=bgsystem:curl -d /temp_recordings/dev-scott_2018-10-30_ee634e42-e806-4e15-9abe-969d09a3eb33.mp3 http:///pub?topic=CallRecording)
  239. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [record_post_process_exec_app]=[bgsystem:curl -d /temp_recordings/dev-scott_2018-10-30_ee634e42-e806-4e15-9abe-969d09a3eb33.mp3 http:///pub?topic=CallRecording]
  240. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(execute_on_answer=record_session /temp_recordings/dev-scott_2018-10-30_ee634e42-e806-4e15-9abe-969d09a3eb33.mp3)
  241. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [execute_on_answer]=[record_session /temp_recordings/dev-scott_2018-10-30_ee634e42-e806-4e15-9abe-969d09a3eb33.mp3]
  242. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 export(location_id=94472cd8-2b1c-4b44-94fe-9708c2bd739d)
  243. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [location_id]=[94472cd8-2b1c-4b44-94fe-9708c2bd739d]
  244. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(weave_lookup_number=1000)
  245. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [weave_lookup_number]=[1000]
  246. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(continue_on_fail=true)
  247. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [continue_on_fail]=[true]
  248. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(hangup_after_bridge=true)
  249. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [hangup_after_bridge]=[true]
  250. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(hold_music=local_stream://moh)
  251. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.954806 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [hold_music]=[local_stream://moh]
  252. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(temp_hold_music=local_stream://moh)
  253. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [temp_hold_music]=[local_stream://moh]
  254. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(cdr_slug=dev-scott)
  255. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [cdr_slug]=[dev-scott]
  256. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(generated_channel_id_eschmidbauer02_dev-scott=1a9b5231-e815-4aba-900d-ecf1089e848f)
  257. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [generated_channel_id_eschmidbauer02_dev-scott]=[1a9b5231-e815-4aba-900d-ecf1089e848f]
  258. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(cdr_sip_id_eschmidbauer02_dev-scott=44ea632a-a36d-4f3e-b2cc-5272065d1d09)
  259. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [cdr_sip_id_eschmidbauer02_dev-scott]=[44ea632a-a36d-4f3e-b2cc-5272065d1d09]
  260. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(cdr_sip_name_eschmidbauer02_dev-scott=eschmidbauer02)
  261. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [cdr_sip_name_eschmidbauer02_dev-scott]=[eschmidbauer02]
  262. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(generated_channel_id_eschmidbauer01_dev-scott=8f00162e-9926-4f19-a078-b88487aa6e58)
  263. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [generated_channel_id_eschmidbauer01_dev-scott]=[8f00162e-9926-4f19-a078-b88487aa6e58]
  264. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(cdr_sip_id_eschmidbauer01_dev-scott=126385ac-5c42-4b20-bc64-0eec19733a42)
  265. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [cdr_sip_id_eschmidbauer01_dev-scott]=[126385ac-5c42-4b20-bc64-0eec19733a42]
  266. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(cdr_sip_name_eschmidbauer01_dev-scott=E-VVX400)
  267. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [cdr_sip_name_eschmidbauer01_dev-scott]=[E-VVX400]
  268. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(generated_channel_id_xlite_dev-scott=f60035e5-788e-4acd-9d86-18f19ae75dec)
  269. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [generated_channel_id_xlite_dev-scott]=[f60035e5-788e-4acd-9d86-18f19ae75dec]
  270. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(cdr_sip_id_xlite_dev-scott=4073da9c-2359-4f2b-ae75-7fc06748ba78)
  271. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [cdr_sip_id_xlite_dev-scott]=[4073da9c-2359-4f2b-ae75-7fc06748ba78]
  272. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(cdr_sip_name_xlite_dev-scott=xlite)
  273. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [cdr_sip_name_xlite_dev-scott]=[xlite]
  274. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(generated_channel_id_eschmidbauer03_dev-scott=f403f20c-cb2e-40f9-bde5-d1ad9e10616b)
  275. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [generated_channel_id_eschmidbauer03_dev-scott]=[f403f20c-cb2e-40f9-bde5-d1ad9e10616b]
  276. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(cdr_sip_id_eschmidbauer03_dev-scott=1fa6d75e-765e-4110-a8e1-13f7df9275c0)
  277. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [cdr_sip_id_eschmidbauer03_dev-scott]=[1fa6d75e-765e-4110-a8e1-13f7df9275c0]
  278. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(cdr_sip_name_eschmidbauer03_dev-scott=vvx500)
  279. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [cdr_sip_name_eschmidbauer03_dev-scott]=[vvx500]
  280. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(generated_channel_id_testline05_dev-scott=3573a9a4-b04e-4ab1-92e8-dfaa401c1b85)
  281. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [generated_channel_id_testline05_dev-scott]=[3573a9a4-b04e-4ab1-92e8-dfaa401c1b85]
  282. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(cdr_sip_id_testline05_dev-scott=1b112711-e324-484a-bbc5-f17564d26935)
  283. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [cdr_sip_id_testline05_dev-scott]=[1b112711-e324-484a-bbc5-f17564d26935]
  284. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(cdr_sip_name_testline05_dev-scott=testline05)
  285. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [cdr_sip_name_testline05_dev-scott]=[testline05]
  286. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(mobile_app=eschmidbauer01;xlite)
  287. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [mobile_app]=[eschmidbauer01;xlite]
  288. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 set(desk_phone=eschmidbauer02;eschmidbauer03;testline05)
  289. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] mod_dptools.c:1598 SET sofia/internal/1000@159.89.163.195:5020 [desk_phone]=[eschmidbauer02;eschmidbauer03;testline05]
  290. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 bridge({origination_uuid=14a8bd6f-af2e-4b1d-8d18-bd59d863387f}user/1003@159.89.163.195)
  291. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] switch_channel.c:1250 sofia/internal/1000@159.89.163.195:5020 EXPORTING[export_vars] [bind_digit_digit_timeout]=[200] to event
  292. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] switch_channel.c:1250 sofia/internal/1000@159.89.163.195:5020 EXPORTING[export_vars] [weave_domain]=[dev-scott] to event
  293. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] switch_channel.c:1250 sofia/internal/1000@159.89.163.195:5020 EXPORTING[export_vars] [w_domain]=[dev-scott.getweave.io] to event
  294. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] switch_channel.c:1250 sofia/internal/1000@159.89.163.195:5020 EXPORTING[export_vars] [selected_carrier]=[twilio] to event
  295. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] switch_channel.c:1250 sofia/internal/1000@159.89.163.195:5020 EXPORTING[export_vars] [location_id]=[94472cd8-2b1c-4b44-94fe-9708c2bd739d] to event
  296. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] switch_ivr_originate.c:2204 Parsing global variables
  297. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] switch_channel.c:1250 sofia/internal/1000@159.89.163.195:5020 EXPORTING[export_vars] [bind_digit_digit_timeout]=[200] to event
  298. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] switch_channel.c:1250 sofia/internal/1000@159.89.163.195:5020 EXPORTING[export_vars] [weave_domain]=[dev-scott] to event
  299. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] switch_channel.c:1250 sofia/internal/1000@159.89.163.195:5020 EXPORTING[export_vars] [w_domain]=[dev-scott.getweave.io] to event
  300. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] switch_channel.c:1250 sofia/internal/1000@159.89.163.195:5020 EXPORTING[export_vars] [selected_carrier]=[twilio] to event
  301. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] switch_channel.c:1250 sofia/internal/1000@159.89.163.195:5020 EXPORTING[export_vars] [location_id]=[94472cd8-2b1c-4b44-94fe-9708c2bd739d] to event
  302. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [DEBUG] switch_ivr_originate.c:2204 Parsing global variables
  303. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:00.964805 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/1003@183.82.203.220:23585 [14a8bd6f-af2e-4b1d-8d18-bd59d863387f]
  304. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:00.964805 [DEBUG] mod_sofia.c:5028 (sofia/internal/1003@183.82.203.220:23585) State Change CS_NEW -> CS_INIT
  305. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:00.964805 [DEBUG] switch_core_session.c:641 sofia/internal/1003@183.82.203.220:23585 set UUID=14a8bd6f-af2e-4b1d-8d18-bd59d863387f
  306. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:00.964805 [NOTICE] switch_ivr_originate.c:2944 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  307. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:00.964805 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1003@183.82.203.220:23585) Running State Change CS_INIT (Cur 2 Tot 23)
  308. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:00.964805 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1003@183.82.203.220:23585) State INIT
  309. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:00.964805 [DEBUG] mod_sofia.c:93 sofia/internal/1003@183.82.203.220:23585 SOFIA INIT
  310. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:00.964805 [DEBUG] sofia_glue.c:1299 sofia/internal/1003@183.82.203.220:23585 sending invite version: 1.8.2 git a98a958 2018-09-26 17:55:25Z 64bit
  311. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f Local SDP:
  312. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f v=0
  313. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f o=FreeSWITCH 1540898580 1540898581 IN IP4 159.89.163.195
  314. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f s=FreeSWITCH
  315. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f c=IN IP4 159.89.163.195
  316. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f t=0 0
  317. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f m=audio 21780 RTP/AVP 0 101
  318. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f a=rtpmap:0 PCMU/8000
  319. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f a=rtpmap:101 telephone-event/8000
  320. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f a=fmtp:101 0-16
  321. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f a=ptime:20
  322. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f a=sendrecv
  323. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f
  324. send 1287 bytes to tcp/[183.82.203.220]:23585 at 12:26:00.972819:
  325.    ------------------------------------------------------------------------
  326.    INVITE sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0 SIP/2.0
  327.    Via: SIP/2.0/TCP 159.89.163.195:5020;branch=z9hG4bKt59Q4U8B1X7BD
  328.    Max-Forwards: 69
  329.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  330.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>
  331.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  332.    CSeq: 130124116 INVITE
  333.    Contact: <sip:mod_sofia@159.89.163.195:5020;transport=tcp>
  334.    User-Agent: FreeSWITCH-mod_sofia/1.8.2+git~20180926T175525Z~a98a958ac3~64bit
  335.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  336.    Supported: timer, path, replaces
  337.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  338.    Content-Type: application/sdp
  339.    Content-Disposition: session
  340.    Content-Length: 224
  341.    X-FS-Support: update_display,send_info
  342.    Remote-Party-ID: "Extension 1000" <sip:1000@159.89.163.195>;party=calling;screen=yes;privacy=off
  343.  
  344.    v=0
  345.    o=FreeSWITCH 1540898580 1540898581 IN IP4 159.89.163.195
  346.    s=FreeSWITCH
  347.    c=IN IP4 159.89.163.195
  348.    t=0 0
  349.    m=audio 21780 RTP/AVP 0 101
  350.    a=rtpmap:0 PCMU/8000
  351.    a=rtpmap:101 telephone-event/8000
  352.    a=fmtp:101 0-16
  353.    a=ptime:20
  354.    ------------------------------------------------------------------------
  355. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:00.964805 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1003@183.82.203.220:23585 Standard INIT
  356. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:00.964805 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1003@183.82.203.220:23585) State Change CS_INIT -> CS_ROUTING
  357. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:00.964805 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1003@183.82.203.220:23585) State INIT going to sleep
  358. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:00.964805 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1003@183.82.203.220:23585) Running State Change CS_ROUTING (Cur 2 Tot 23)
  359. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:00.964805 [DEBUG] sofia.c:7291 Channel sofia/internal/1003@183.82.203.220:23585 entering state [calling][0]
  360. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:00.964805 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1003@183.82.203.220:23585) State ROUTING
  361. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:00.964805 [DEBUG] mod_sofia.c:154 sofia/internal/1003@183.82.203.220:23585 SOFIA ROUTING
  362. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:00.964805 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/1003@183.82.203.220:23585) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  363. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:00.964805 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1003@183.82.203.220:23585) State ROUTING going to sleep
  364. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:00.964805 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1003@183.82.203.220:23585) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 23)
  365. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:00.964805 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/1003@183.82.203.220:23585) State CONSUME_MEDIA
  366. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:00.964805 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/1003@183.82.203.220:23585) State CONSUME_MEDIA going to sleep
  367. recv 324 bytes from tcp/[183.82.203.220]:23585 at 12:26:01.700022:
  368.    ------------------------------------------------------------------------
  369.    SIP/2.0 100 Trying
  370.    Via: SIP/2.0/TCP 159.89.163.195:5020;branch=z9hG4bKt59Q4U8B1X7BD
  371.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>
  372.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  373.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  374.    CSeq: 130124116 INVITE
  375.    Content-Length: 0
  376.  
  377.    ------------------------------------------------------------------------
  378. recv 529 bytes from tcp/[183.82.203.220]:23585 at 12:26:02.510275:
  379.    ------------------------------------------------------------------------
  380.    SIP/2.0 180 Ringing
  381.    Via: SIP/2.0/TCP 159.89.163.195:5020;branch=z9hG4bKt59Q4U8B1X7BD
  382.    Contact: <sip:1003@183.82.203.220:23581>
  383.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  384.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  385.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  386.    CSeq: 130124116 INVITE
  387.    Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
  388.    User-Agent: Zoiper rv2.8.109
  389.    Allow-Events: presence, kpml, talk
  390.    Content-Length: 0
  391.  
  392.    ------------------------------------------------------------------------
  393. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:02.504822 [DEBUG] sofia.c:7291 Channel sofia/internal/1003@183.82.203.220:23585 entering state [proceeding][180]
  394. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:02.504822 [NOTICE] sofia.c:7401 Ring-Ready sofia/internal/1003@183.82.203.220:23585!
  395. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:02.504822 [DEBUG] switch_channel.c:3354 (sofia/internal/1003@183.82.203.220:23585) Callstate Change DOWN -> RINGING
  396. send 903 bytes to udp/[183.82.203.220]:23502 at 12:26:02.518341:
  397.    ------------------------------------------------------------------------
  398.    SIP/2.0 180 Ringing
  399.    Via: SIP/2.0/UDP 192.168.1.4:64343;branch=z9hG4bK-524287-1---2604a17df0500073;rport=23502;received=183.82.203.220
  400.    From: "1000"<sip:1000@159.89.163.195:5020>;tag=34407550
  401.    To: <sip:1000@159.89.163.195:5020>;tag=c4atgm4tm8Q0g
  402.    Call-ID: 92627MzJlOWE2MzNlZDM5ODhkZTc4YzJjZGM2YmFlZDdhNTU
  403.    CSeq: 2 INVITE
  404.    Contact: <sip:1000@159.89.163.195:5020;transport=udp>
  405.    User-Agent: FreeSWITCH-mod_sofia/1.8.2+git~20180926T175525Z~a98a958ac3~64bit
  406.    Accept: application/sdp
  407.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  408.    Supported: timer, path, replaces
  409.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  410.    Content-Length: 0
  411.    Remote-Party-ID: "1000" <sip:1000@159.89.163.195>;party=calling;privacy=off;screen=no
  412.  
  413.    ------------------------------------------------------------------------
  414. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:02.514811 [NOTICE] mod_sofia.c:2419 Ring-Ready sofia/internal/1000@159.89.163.195:5020!
  415. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:02.514811 [DEBUG] sofia.c:7291 Channel sofia/internal/1000@159.89.163.195:5020 entering state [early][180]
  416. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:02.514811 [NOTICE] switch_ivr_originate.c:553 Ring Ready sofia/internal/1000@159.89.163.195:5020!
  417. recv 802 bytes from tcp/[183.82.203.220]:23585 at 12:26:05.406842:
  418.    ------------------------------------------------------------------------
  419.    SIP/2.0 200 OK
  420.    Via: SIP/2.0/TCP 159.89.163.195:5020;branch=z9hG4bKt59Q4U8B1X7BD
  421.    Contact: <sip:1003@183.82.203.220:23581>
  422.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  423.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  424.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  425.    CSeq: 130124116 INVITE
  426.    Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
  427.    Content-Type: application/sdp
  428.    User-Agent: Zoiper rv2.8.109
  429.    Allow-Events: presence, kpml, talk
  430.    Content-Length: 245
  431.  
  432.    v=0
  433.    o=Zoiper 0 2 IN IP4 183.82.203.220
  434.    s=Zoiper
  435.    c=IN IP4 183.82.203.220
  436.    t=0 0
  437.    m=audio 24103 RTP/AVP 0 3 8 101
  438.    a=rtpmap:0 PCMU/8000
  439.    a=rtpmap:3 GSM/8000
  440.    a=rtpmap:8 PCMA/8000
  441.    a=rtpmap:101 telephone-event/8000
  442.    a=fmtp:101 0-16
  443.    a=sendrecv
  444.    ------------------------------------------------------------------------
  445. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.404815 [DEBUG] sofia.c:7291 Channel sofia/internal/1003@183.82.203.220:23585 entering state [completing][200]
  446. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.404815 [DEBUG] sofia.c:7301 Remote SDP:
  447. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f v=0
  448. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f o=Zoiper 0 2 IN IP4 183.82.203.220
  449. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f s=Zoiper
  450. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f c=IN IP4 183.82.203.220
  451. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f t=0 0
  452. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f m=audio 24103 RTP/AVP 0 3 8 101
  453. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f a=rtpmap:0 PCMU/8000
  454. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f a=rtpmap:3 GSM/8000
  455. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f a=rtpmap:8 PCMA/8000
  456. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f a=rtpmap:101 telephone-event/8000
  457. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f a=fmtp:101 0-16
  458. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f
  459. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.404815 [NOTICE] sofia.c:7304 Pre-Answer sofia/internal/1003@183.82.203.220:23585!
  460. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.404815 [DEBUG] switch_channel.c:3482 (sofia/internal/1003@183.82.203.220:23585) Callstate Change RINGING -> EARLY
  461. send 441 bytes to udp/[183.82.203.220]:23581 at 12:26:05.408882:
  462.    ------------------------------------------------------------------------
  463.    ACK sip:1003@183.82.203.220:23581 SIP/2.0
  464.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport;branch=z9hG4bKUe3g6pSFy6Xyr
  465.    Max-Forwards: 70
  466.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  467.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  468.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  469.    CSeq: 130124116 ACK
  470.    Contact: <sip:mod_sofia@159.89.163.195:5020;transport=tcp>
  471.    Content-Length: 0
  472.  
  473.    ------------------------------------------------------------------------
  474. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.404815 [DEBUG] sofia.c:7291 Channel sofia/internal/1003@183.82.203.220:23585 entering state [ready][200]
  475. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  476. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:5533 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  477. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMU:0:8000:20:64000:1]
  478. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  479. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:5394 Set telephone-event payload to 101@8000
  480. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:3781 Set Codec sofia/internal/1003@183.82.203.220:23585 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  481. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.404815 [DEBUG] switch_core_codec.c:111 sofia/internal/1003@183.82.203.220:23585 Original read codec set to PCMU:0
  482. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:5737 Set telephone-event payload to 101@8000
  483. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:5795 sofia/internal/1003@183.82.203.220:23585 Set 2833 dtmf send payload to 101 recv payload to 101
  484. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:8511 AUDIO RTP [sofia/internal/1003@183.82.203.220:23585] 159.89.163.195 port 21780 -> 183.82.203.220 port 24103 codec: 0 ms: 20
  485. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.404815 [INFO] switch_ivr_originate.c:3747 Sending early media
  486. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
  487. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  488. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  489. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:5533 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  490. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  491. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:5394 Set telephone-event payload to 101@8000
  492. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:3781 Set Codec sofia/internal/1000@159.89.163.195:5020 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  493. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.404815 [DEBUG] switch_core_codec.c:111 sofia/internal/1000@159.89.163.195:5020 Original read codec set to PCMU:0
  494. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:5737 Set telephone-event payload to 101@8000
  495. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:5795 sofia/internal/1000@159.89.163.195:5020 Set 2833 dtmf send payload to 101 recv payload to 101
  496. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:8511 AUDIO RTP [sofia/internal/1000@159.89.163.195:5020] 159.89.163.195 port 18476 -> 192.168.1.4 port 50586 codec: 0 ms: 20
  497. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.404815 [DEBUG] switch_rtp.c:4300 Starting timer [soft] 160 bytes per 20ms
  498. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.404815 [DEBUG] switch_rtp.c:4300 Starting timer [soft] 160 bytes per 20ms
  499. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:8815 sofia/internal/1003@183.82.203.220:23585 Set 2833 dtmf send payload to 101
  500. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:8822 sofia/internal/1003@183.82.203.220:23585 Set 2833 dtmf receive payload to 101
  501. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:8845 sofia/internal/1003@183.82.203.220:23585 Set rtp dtmf delay to 40
  502. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.404815 [NOTICE] sofia.c:8429 Channel [sofia/internal/1003@183.82.203.220:23585] has been answered
  503. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.404815 [DEBUG] switch_channel.c:3781 (sofia/internal/1003@183.82.203.220:23585) Callstate Change EARLY -> ACTIVE
  504. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:8815 sofia/internal/1000@159.89.163.195:5020 Set 2833 dtmf send payload to 101
  505. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:8822 sofia/internal/1000@159.89.163.195:5020 Set 2833 dtmf receive payload to 101
  506. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:8845 sofia/internal/1000@159.89.163.195:5020 Set rtp dtmf delay to 40
  507. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.404815 [NOTICE] sofia_media.c:92 Pre-Answer sofia/internal/1000@159.89.163.195:5020!
  508. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.404815 [DEBUG] switch_channel.c:3482 (sofia/internal/1000@159.89.163.195:5020) Callstate Change RINGING -> EARLY
  509. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.404815 [DEBUG] switch_core_media.c:8494 Audio params are unchanged for sofia/internal/1000@159.89.163.195:5020.
  510. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.404815 [DEBUG] mod_sofia.c:2514 Ring SDP:
  511. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 v=0
  512. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 o=FreeSWITCH 1540901889 1540901890 IN IP4 159.89.163.195
  513. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 s=FreeSWITCH
  514. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 c=IN IP4 159.89.163.195
  515. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 t=0 0
  516. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 m=audio 18476 RTP/AVP 0 101
  517. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 a=rtpmap:0 PCMU/8000
  518. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 a=rtpmap:101 telephone-event/8000
  519. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 a=fmtp:101 0-16
  520. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 a=ptime:20
  521. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 a=sendrecv
  522. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8
  523. send 1183 bytes to udp/[183.82.203.220]:23502 at 12:26:05.414734:
  524.    ------------------------------------------------------------------------
  525.    SIP/2.0 183 Session Progress
  526.    Via: SIP/2.0/UDP 192.168.1.4:64343;branch=z9hG4bK-524287-1---2604a17df0500073;rport=23502;received=183.82.203.220
  527.    From: "1000"<sip:1000@159.89.163.195:5020>;tag=34407550
  528.    To: <sip:1000@159.89.163.195:5020>;tag=c4atgm4tm8Q0g
  529.    Call-ID: 92627MzJlOWE2MzNlZDM5ODhkZTc4YzJjZGM2YmFlZDdhNTU
  530.    CSeq: 2 INVITE
  531.    Contact: <sip:1000@159.89.163.195:5020;transport=udp>
  532.    User-Agent: FreeSWITCH-mod_sofia/1.8.2+git~20180926T175525Z~a98a958ac3~64bit
  533.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  534.    Supported: timer, path, replaces
  535.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  536.    Content-Type: application/sdp
  537.    Content-Disposition: session
  538.    Content-Length: 224
  539.    Remote-Party-ID: "Outbound Call" <sip:1003@159.89.163.195>;party=calling;privacy=off;screen=no
  540.  
  541.    v=0
  542.    o=FreeSWITCH 1540901889 1540901890 IN IP4 159.89.163.195
  543.    s=FreeSWITCH
  544.    c=IN IP4 159.89.163.195
  545.    t=0 0
  546.    m=audio 18476 RTP/AVP 0 101
  547.    a=rtpmap:0 PCMU/8000
  548.    a=rtpmap:101 telephone-event/8000
  549.    a=fmtp:101 0-16
  550.    a=ptime:20
  551.    ------------------------------------------------------------------------
  552. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.414826 [DEBUG] sofia.c:7291 Channel sofia/internal/1000@159.89.163.195:5020 entering state [early][183]
  553. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.414826 [DEBUG] switch_ivr_originate.c:3798 Originate Resulted in Success: [sofia/internal/1003@183.82.203.220:23585]
  554. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.414826 [DEBUG] switch_core_media.c:8494 Audio params are unchanged for sofia/internal/1000@159.89.163.195:5020.
  555. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.414826 [DEBUG] mod_sofia.c:881 Local SDP sofia/internal/1000@159.89.163.195:5020:
  556. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 v=0
  557. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 o=FreeSWITCH 1540901889 1540901891 IN IP4 159.89.163.195
  558. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 s=FreeSWITCH
  559. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 c=IN IP4 159.89.163.195
  560. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 t=0 0
  561. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 m=audio 18476 RTP/AVP 0 101
  562. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 a=rtpmap:0 PCMU/8000
  563. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 a=rtpmap:101 telephone-event/8000
  564. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 a=fmtp:101 0-16
  565. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 a=ptime:20
  566. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 a=sendrecv
  567. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8
  568. send 1205 bytes to udp/[183.82.203.220]:23502 at 12:26:05.416480:
  569.    ------------------------------------------------------------------------
  570.    SIP/2.0 200 OK
  571.    Via: SIP/2.0/UDP 192.168.1.4:64343;branch=z9hG4bK-524287-1---2604a17df0500073;rport=23502;received=183.82.203.220
  572.    From: "1000"<sip:1000@159.89.163.195:5020>;tag=34407550
  573.    To: <sip:1000@159.89.163.195:5020>;tag=c4atgm4tm8Q0g
  574.    Call-ID: 92627MzJlOWE2MzNlZDM5ODhkZTc4YzJjZGM2YmFlZDdhNTU
  575.    CSeq: 2 INVITE
  576.    Contact: <sip:1000@159.89.163.195:5020;transport=udp>
  577.    User-Agent: FreeSWITCH-mod_sofia/1.8.2+git~20180926T175525Z~a98a958ac3~64bit
  578.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  579.    Supported: timer, path, replaces
  580.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  581.    Session-Expires: 120;refresher=uas
  582.    Content-Type: application/sdp
  583.    Content-Disposition: session
  584.    Content-Length: 224
  585.    Remote-Party-ID: "Outbound Call" <sip:1003@159.89.163.195>;party=calling;privacy=off;screen=no
  586.  
  587.    v=0
  588.    o=FreeSWITCH 1540901889 1540901890 IN IP4 159.89.163.195
  589.    s=FreeSWITCH
  590.    c=IN IP4 159.89.163.195
  591.    t=0 0
  592.    m=audio 18476 RTP/AVP 0 101
  593.    a=rtpmap:0 PCMU/8000
  594.    a=rtpmap:101 telephone-event/8000
  595.    a=fmtp:101 0-16
  596.    a=ptime:20
  597.    ------------------------------------------------------------------------
  598. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.414826 [DEBUG] sofia.c:7291 Channel sofia/internal/1000@159.89.163.195:5020 entering state [completed][200]
  599. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.414826 [NOTICE] switch_ivr_originate.c:3740 Channel [sofia/internal/1000@159.89.163.195:5020] has been answered
  600. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 EXECUTE sofia/internal/1000@159.89.163.195:5020 record_session(/temp_recordings/dev-scott_2018-10-30_ee634e42-e806-4e15-9abe-969d09a3eb33.mp3)
  601. 2018-10-30 12:26:05.414826 [ERR] switch_core_file.c:301 Invalid file format [mp3] for [/temp_recordings/dev-scott_2018-10-30_ee634e42-e806-4e15-9abe-969d09a3eb33.mp3]!
  602. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.414826 [ERR] switch_ivr_async.c:2737 Error opening /temp_recordings/dev-scott_2018-10-30_ee634e42-e806-4e15-9abe-969d09a3eb33.mp3
  603. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.414826 [DEBUG] switch_channel.c:3781 (sofia/internal/1000@159.89.163.195:5020) Callstate Change EARLY -> ACTIVE
  604. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.414826 [DEBUG] switch_ivr_originate.c:3798 Originate Resulted in Success: [sofia/internal/1003@183.82.203.220:23585]
  605. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.414826 [DEBUG] switch_ivr_bridge.c:1782 (sofia/internal/1003@183.82.203.220:23585) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
  606. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.414826 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1003@183.82.203.220:23585) Running State Change CS_EXCHANGE_MEDIA (Cur 2 Tot 23)
  607. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.414826 [DEBUG] switch_core_state_machine.c:653 (sofia/internal/1003@183.82.203.220:23585) State EXCHANGE_MEDIA
  608. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.414826 [DEBUG] mod_sofia.c:645 SOFIA EXCHANGE_MEDIA
  609. recv 478 bytes from udp/[183.82.203.220]:23502 at 12:26:05.546249:
  610.    ------------------------------------------------------------------------
  611.    ACK sip:1000@159.89.163.195:5020;transport=udp SIP/2.0
  612.    Via: SIP/2.0/UDP 192.168.1.4:64343;branch=z9hG4bK-524287-1---0fd46e1c2958b736;rport
  613.    Max-Forwards: 70
  614.    Contact: <sip:1000@183.82.203.220:23502;rinstance=455085c26772fb89>
  615.    To: <sip:1000@159.89.163.195:5020>;tag=c4atgm4tm8Q0g
  616.    From: "1000"<sip:1000@159.89.163.195:5020>;tag=34407550
  617.    Call-ID: 92627MzJlOWE2MzNlZDM5ODhkZTc4YzJjZGM2YmFlZDdhNTU
  618.    CSeq: 2 ACK
  619.    User-Agent: X-Lite release 5.3.2 stamp 92627
  620.    Content-Length: 0
  621.  
  622.    ------------------------------------------------------------------------
  623. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.544816 [DEBUG] sofia.c:7291 Channel sofia/internal/1000@159.89.163.195:5020 entering state [ready][200]
  624. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:05.724831 [DEBUG] switch_rtp.c:7550 Correct audio ip/port confirmed.
  625. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:05.764813 [INFO] switch_rtp.c:7510 Auto Changing audio port from 192.168.1.4:50586 to 183.82.203.220:24108
  626. recv 802 bytes from tcp/[183.82.203.220]:23585 at 12:26:05.904223:
  627.    ------------------------------------------------------------------------
  628.    SIP/2.0 200 OK
  629.    Via: SIP/2.0/TCP 159.89.163.195:5020;branch=z9hG4bKt59Q4U8B1X7BD
  630.    Contact: <sip:1003@183.82.203.220:23581>
  631.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  632.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  633.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  634.    CSeq: 130124116 INVITE
  635.    Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
  636.    Content-Type: application/sdp
  637.    User-Agent: Zoiper rv2.8.109
  638.    Allow-Events: presence, kpml, talk
  639.    Content-Length: 245
  640.  
  641.    v=0
  642.    o=Zoiper 0 2 IN IP4 183.82.203.220
  643.    s=Zoiper
  644.    c=IN IP4 183.82.203.220
  645.    t=0 0
  646.    m=audio 24103 RTP/AVP 0 3 8 101
  647.    a=rtpmap:0 PCMU/8000
  648.    a=rtpmap:3 GSM/8000
  649.    a=rtpmap:8 PCMA/8000
  650.    a=rtpmap:101 telephone-event/8000
  651.    a=fmtp:101 0-16
  652.    a=sendrecv
  653.    ------------------------------------------------------------------------
  654. send 441 bytes to udp/[183.82.203.220]:23581 at 12:26:05.904343:
  655.    ------------------------------------------------------------------------
  656.    ACK sip:1003@183.82.203.220:23581 SIP/2.0
  657.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport;branch=z9hG4bKUe3g6pSFy6Xyr
  658.    Max-Forwards: 70
  659.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  660.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  661.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  662.    CSeq: 130124116 ACK
  663.    Contact: <sip:mod_sofia@159.89.163.195:5020;transport=tcp>
  664.    Content-Length: 0
  665.  
  666.    ------------------------------------------------------------------------
  667. recv 802 bytes from tcp/[183.82.203.220]:23585 at 12:26:06.903636:
  668.    ------------------------------------------------------------------------
  669.    SIP/2.0 200 OK
  670.    Via: SIP/2.0/TCP 159.89.163.195:5020;branch=z9hG4bKt59Q4U8B1X7BD
  671.    Contact: <sip:1003@183.82.203.220:23581>
  672.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  673.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  674.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  675.    CSeq: 130124116 INVITE
  676.    Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
  677.    Content-Type: application/sdp
  678.    User-Agent: Zoiper rv2.8.109
  679.    Allow-Events: presence, kpml, talk
  680.    Content-Length: 245
  681.  
  682.    v=0
  683.    o=Zoiper 0 2 IN IP4 183.82.203.220
  684.    s=Zoiper
  685.    c=IN IP4 183.82.203.220
  686.    t=0 0
  687.    m=audio 24103 RTP/AVP 0 3 8 101
  688.    a=rtpmap:0 PCMU/8000
  689.    a=rtpmap:3 GSM/8000
  690.    a=rtpmap:8 PCMA/8000
  691.    a=rtpmap:101 telephone-event/8000
  692.    a=fmtp:101 0-16
  693.    a=sendrecv
  694.    ------------------------------------------------------------------------
  695. send 441 bytes to udp/[183.82.203.220]:23581 at 12:26:06.903794:
  696.    ------------------------------------------------------------------------
  697.    ACK sip:1003@183.82.203.220:23581 SIP/2.0
  698.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport;branch=z9hG4bKUe3g6pSFy6Xyr
  699.    Max-Forwards: 70
  700.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  701.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  702.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  703.    CSeq: 130124116 ACK
  704.    Contact: <sip:mod_sofia@159.89.163.195:5020;transport=tcp>
  705.    Content-Length: 0
  706.  
  707.    ------------------------------------------------------------------------
  708. recv 802 bytes from tcp/[183.82.203.220]:23585 at 12:26:08.903960:
  709.    ------------------------------------------------------------------------
  710.    SIP/2.0 200 OK
  711.    Via: SIP/2.0/TCP 159.89.163.195:5020;branch=z9hG4bKt59Q4U8B1X7BD
  712.    Contact: <sip:1003@183.82.203.220:23581>
  713.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  714.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  715.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  716.    CSeq: 130124116 INVITE
  717.    Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
  718.    Content-Type: application/sdp
  719.    User-Agent: Zoiper rv2.8.109
  720.    Allow-Events: presence, kpml, talk
  721.    Content-Length: 245
  722.  
  723.    v=0
  724.    o=Zoiper 0 2 IN IP4 183.82.203.220
  725.    s=Zoiper
  726.    c=IN IP4 183.82.203.220
  727.    t=0 0
  728.    m=audio 24103 RTP/AVP 0 3 8 101
  729.    a=rtpmap:0 PCMU/8000
  730.    a=rtpmap:3 GSM/8000
  731.    a=rtpmap:8 PCMA/8000
  732.    a=rtpmap:101 telephone-event/8000
  733.    a=fmtp:101 0-16
  734.    a=sendrecv
  735.    ------------------------------------------------------------------------
  736. send 441 bytes to udp/[183.82.203.220]:23581 at 12:26:08.904084:
  737.    ------------------------------------------------------------------------
  738.    ACK sip:1003@183.82.203.220:23581 SIP/2.0
  739.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport;branch=z9hG4bKUe3g6pSFy6Xyr
  740.    Max-Forwards: 70
  741.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  742.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  743.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  744.    CSeq: 130124116 ACK
  745.    Contact: <sip:mod_sofia@159.89.163.195:5020;transport=tcp>
  746.    Content-Length: 0
  747.  
  748.    ------------------------------------------------------------------------
  749. recv 802 bytes from tcp/[183.82.203.220]:23585 at 12:26:12.904473:
  750.    ------------------------------------------------------------------------
  751.    SIP/2.0 200 OK
  752.    Via: SIP/2.0/TCP 159.89.163.195:5020;branch=z9hG4bKt59Q4U8B1X7BD
  753.    Contact: <sip:1003@183.82.203.220:23581>
  754.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  755.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  756.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  757.    CSeq: 130124116 INVITE
  758.    Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
  759.    Content-Type: application/sdp
  760.    User-Agent: Zoiper rv2.8.109
  761.    Allow-Events: presence, kpml, talk
  762.    Content-Length: 245
  763.  
  764.    v=0
  765.    o=Zoiper 0 2 IN IP4 183.82.203.220
  766.    s=Zoiper
  767.    c=IN IP4 183.82.203.220
  768.    t=0 0
  769.    m=audio 24103 RTP/AVP 0 3 8 101
  770.    a=rtpmap:0 PCMU/8000
  771.    a=rtpmap:3 GSM/8000
  772.    a=rtpmap:8 PCMA/8000
  773.    a=rtpmap:101 telephone-event/8000
  774.    a=fmtp:101 0-16
  775.    a=sendrecv
  776.    ------------------------------------------------------------------------
  777. send 441 bytes to udp/[183.82.203.220]:23581 at 12:26:12.904623:
  778.    ------------------------------------------------------------------------
  779.    ACK sip:1003@183.82.203.220:23581 SIP/2.0
  780.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport;branch=z9hG4bKUe3g6pSFy6Xyr
  781.    Max-Forwards: 70
  782.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  783.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  784.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  785.    CSeq: 130124116 ACK
  786.    Contact: <sip:mod_sofia@159.89.163.195:5020;transport=tcp>
  787.    Content-Length: 0
  788.  
  789.    ------------------------------------------------------------------------
  790. recv 802 bytes from tcp/[183.82.203.220]:23585 at 12:26:16.905169:
  791.    ------------------------------------------------------------------------
  792.    SIP/2.0 200 OK
  793.    Via: SIP/2.0/TCP 159.89.163.195:5020;branch=z9hG4bKt59Q4U8B1X7BD
  794.    Contact: <sip:1003@183.82.203.220:23581>
  795.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  796.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  797.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  798.    CSeq: 130124116 INVITE
  799.    Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
  800.    Content-Type: application/sdp
  801.    User-Agent: Zoiper rv2.8.109
  802.    Allow-Events: presence, kpml, talk
  803.    Content-Length: 245
  804.  
  805.    v=0
  806.    o=Zoiper 0 2 IN IP4 183.82.203.220
  807.    s=Zoiper
  808.    c=IN IP4 183.82.203.220
  809.    t=0 0
  810.    m=audio 24103 RTP/AVP 0 3 8 101
  811.    a=rtpmap:0 PCMU/8000
  812.    a=rtpmap:3 GSM/8000
  813.    a=rtpmap:8 PCMA/8000
  814.    a=rtpmap:101 telephone-event/8000
  815.    a=fmtp:101 0-16
  816.    a=sendrecv
  817.    ------------------------------------------------------------------------
  818. send 441 bytes to udp/[183.82.203.220]:23581 at 12:26:16.905299:
  819.    ------------------------------------------------------------------------
  820.    ACK sip:1003@183.82.203.220:23581 SIP/2.0
  821.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport;branch=z9hG4bKUe3g6pSFy6Xyr
  822.    Max-Forwards: 70
  823.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  824.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  825.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  826.    CSeq: 130124116 ACK
  827.    Contact: <sip:mod_sofia@159.89.163.195:5020;transport=tcp>
  828.    Content-Length: 0
  829.  
  830.    ------------------------------------------------------------------------
  831. recv 802 bytes from tcp/[183.82.203.220]:23585 at 12:26:20.905699:
  832.    ------------------------------------------------------------------------
  833.    SIP/2.0 200 OK
  834.    Via: SIP/2.0/TCP 159.89.163.195:5020;branch=z9hG4bKt59Q4U8B1X7BD
  835.    Contact: <sip:1003@183.82.203.220:23581>
  836.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  837.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  838.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  839.    CSeq: 130124116 INVITE
  840.    Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
  841.    Content-Type: application/sdp
  842.    User-Agent: Zoiper rv2.8.109
  843.    Allow-Events: presence, kpml, talk
  844.    Content-Length: 245
  845.  
  846.    v=0
  847.    o=Zoiper 0 2 IN IP4 183.82.203.220
  848.    s=Zoiper
  849.    c=IN IP4 183.82.203.220
  850.    t=0 0
  851.    m=audio 24103 RTP/AVP 0 3 8 101
  852.    a=rtpmap:0 PCMU/8000
  853.    a=rtpmap:3 GSM/8000
  854.    a=rtpmap:8 PCMA/8000
  855.    a=rtpmap:101 telephone-event/8000
  856.    a=fmtp:101 0-16
  857.    a=sendrecv
  858.    ------------------------------------------------------------------------
  859. send 441 bytes to udp/[183.82.203.220]:23581 at 12:26:20.905827:
  860.    ------------------------------------------------------------------------
  861.    ACK sip:1003@183.82.203.220:23581 SIP/2.0
  862.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport;branch=z9hG4bKUe3g6pSFy6Xyr
  863.    Max-Forwards: 70
  864.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  865.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  866.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  867.    CSeq: 130124116 ACK
  868.    Contact: <sip:mod_sofia@159.89.163.195:5020;transport=tcp>
  869.    Content-Length: 0
  870.  
  871.    ------------------------------------------------------------------------
  872. recv 802 bytes from tcp/[183.82.203.220]:23585 at 12:26:24.906082:
  873.    ------------------------------------------------------------------------
  874.    SIP/2.0 200 OK
  875.    Via: SIP/2.0/TCP 159.89.163.195:5020;branch=z9hG4bKt59Q4U8B1X7BD
  876.    Contact: <sip:1003@183.82.203.220:23581>
  877.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  878.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  879.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  880.    CSeq: 130124116 INVITE
  881.    Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
  882.    Content-Type: application/sdp
  883.    User-Agent: Zoiper rv2.8.109
  884.    Allow-Events: presence, kpml, talk
  885.    Content-Length: 245
  886.  
  887.    v=0
  888.    o=Zoiper 0 2 IN IP4 183.82.203.220
  889.    s=Zoiper
  890.    c=IN IP4 183.82.203.220
  891.    t=0 0
  892.    m=audio 24103 RTP/AVP 0 3 8 101
  893.    a=rtpmap:0 PCMU/8000
  894.    a=rtpmap:3 GSM/8000
  895.    a=rtpmap:8 PCMA/8000
  896.    a=rtpmap:101 telephone-event/8000
  897.    a=fmtp:101 0-16
  898.    a=sendrecv
  899.    ------------------------------------------------------------------------
  900. send 441 bytes to udp/[183.82.203.220]:23581 at 12:26:24.906202:
  901.    ------------------------------------------------------------------------
  902.    ACK sip:1003@183.82.203.220:23581 SIP/2.0
  903.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport;branch=z9hG4bKUe3g6pSFy6Xyr
  904.    Max-Forwards: 70
  905.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  906.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  907.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  908.    CSeq: 130124116 ACK
  909.    Contact: <sip:mod_sofia@159.89.163.195:5020;transport=tcp>
  910.    Content-Length: 0
  911.  
  912.    ------------------------------------------------------------------------
  913. recv 802 bytes from tcp/[183.82.203.220]:23585 at 12:26:28.907575:
  914.    ------------------------------------------------------------------------
  915.    SIP/2.0 200 OK
  916.    Via: SIP/2.0/TCP 159.89.163.195:5020;branch=z9hG4bKt59Q4U8B1X7BD
  917.    Contact: <sip:1003@183.82.203.220:23581>
  918.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  919.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  920.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  921.    CSeq: 130124116 INVITE
  922.    Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
  923.    Content-Type: application/sdp
  924.    User-Agent: Zoiper rv2.8.109
  925.    Allow-Events: presence, kpml, talk
  926.    Content-Length: 245
  927.  
  928.    v=0
  929.    o=Zoiper 0 2 IN IP4 183.82.203.220
  930.    s=Zoiper
  931.    c=IN IP4 183.82.203.220
  932.    t=0 0
  933.    m=audio 24103 RTP/AVP 0 3 8 101
  934.    a=rtpmap:0 PCMU/8000
  935.    a=rtpmap:3 GSM/8000
  936.    a=rtpmap:8 PCMA/8000
  937.    a=rtpmap:101 telephone-event/8000
  938.    a=fmtp:101 0-16
  939.    a=sendrecv
  940.    ------------------------------------------------------------------------
  941. send 441 bytes to udp/[183.82.203.220]:23581 at 12:26:28.907695:
  942.    ------------------------------------------------------------------------
  943.    ACK sip:1003@183.82.203.220:23581 SIP/2.0
  944.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport;branch=z9hG4bKUe3g6pSFy6Xyr
  945.    Max-Forwards: 70
  946.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  947.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  948.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  949.    CSeq: 130124116 ACK
  950.    Contact: <sip:mod_sofia@159.89.163.195:5020;transport=tcp>
  951.    Content-Length: 0
  952.  
  953.    ------------------------------------------------------------------------
  954. recv 802 bytes from tcp/[183.82.203.220]:23585 at 12:26:32.910912:
  955.    ------------------------------------------------------------------------
  956.    SIP/2.0 200 OK
  957.    Via: SIP/2.0/TCP 159.89.163.195:5020;branch=z9hG4bKt59Q4U8B1X7BD
  958.    Contact: <sip:1003@183.82.203.220:23581>
  959.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  960.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  961.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  962.    CSeq: 130124116 INVITE
  963.    Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
  964.    Content-Type: application/sdp
  965.    User-Agent: Zoiper rv2.8.109
  966.    Allow-Events: presence, kpml, talk
  967.    Content-Length: 245
  968.  
  969.    v=0
  970.    o=Zoiper 0 2 IN IP4 183.82.203.220
  971.    s=Zoiper
  972.    c=IN IP4 183.82.203.220
  973.    t=0 0
  974.    m=audio 24103 RTP/AVP 0 3 8 101
  975.    a=rtpmap:0 PCMU/8000
  976.    a=rtpmap:3 GSM/8000
  977.    a=rtpmap:8 PCMA/8000
  978.    a=rtpmap:101 telephone-event/8000
  979.    a=fmtp:101 0-16
  980.    a=sendrecv
  981.    ------------------------------------------------------------------------
  982. send 441 bytes to udp/[183.82.203.220]:23581 at 12:26:32.911024:
  983.    ------------------------------------------------------------------------
  984.    ACK sip:1003@183.82.203.220:23581 SIP/2.0
  985.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport;branch=z9hG4bKUe3g6pSFy6Xyr
  986.    Max-Forwards: 70
  987.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  988.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  989.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  990.    CSeq: 130124116 ACK
  991.    Contact: <sip:mod_sofia@159.89.163.195:5020;transport=tcp>
  992.    Content-Length: 0
  993.  
  994.    ------------------------------------------------------------------------
  995. recv 802 bytes from tcp/[183.82.203.220]:23585 at 12:26:36.909961:
  996.    ------------------------------------------------------------------------
  997.    SIP/2.0 200 OK
  998.    Via: SIP/2.0/TCP 159.89.163.195:5020;branch=z9hG4bKt59Q4U8B1X7BD
  999.    Contact: <sip:1003@183.82.203.220:23581>
  1000.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  1001.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  1002.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  1003.    CSeq: 130124116 INVITE
  1004.    Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
  1005.    Content-Type: application/sdp
  1006.    User-Agent: Zoiper rv2.8.109
  1007.    Allow-Events: presence, kpml, talk
  1008.    Content-Length: 245
  1009.  
  1010.    v=0
  1011.    o=Zoiper 0 2 IN IP4 183.82.203.220
  1012.    s=Zoiper
  1013.    c=IN IP4 183.82.203.220
  1014.    t=0 0
  1015.    m=audio 24103 RTP/AVP 0 3 8 101
  1016.    a=rtpmap:0 PCMU/8000
  1017.    a=rtpmap:3 GSM/8000
  1018.    a=rtpmap:8 PCMA/8000
  1019.    a=rtpmap:101 telephone-event/8000
  1020.    a=fmtp:101 0-16
  1021.    a=sendrecv
  1022.    ------------------------------------------------------------------------
  1023. send 441 bytes to udp/[183.82.203.220]:23581 at 12:26:36.910067:
  1024.    ------------------------------------------------------------------------
  1025.    ACK sip:1003@183.82.203.220:23581 SIP/2.0
  1026.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport;branch=z9hG4bKUe3g6pSFy6Xyr
  1027.    Max-Forwards: 70
  1028.    From: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  1029.    To: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  1030.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  1031.    CSeq: 130124116 ACK
  1032.    Contact: <sip:mod_sofia@159.89.163.195:5020;transport=tcp>
  1033.    Content-Length: 0
  1034.  
  1035.    ------------------------------------------------------------------------
  1036. recv 479 bytes from tcp/[183.82.203.220]:23585 at 12:26:37.403601:
  1037.    ------------------------------------------------------------------------
  1038.    BYE sip:mod_sofia@159.89.163.195:5020;transport=tcp SIP/2.0
  1039.    Via: SIP/2.0/TCP 183.82.203.220:23585;branch=z9hG4bK-524287-1---2f6d96be77c073e1;rport
  1040.    Max-Forwards: 70
  1041.    Contact: <sip:1003@183.82.203.220:23581>
  1042.    To: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  1043.    From: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  1044.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  1045.    CSeq: 2 BYE
  1046.    User-Agent: Zoiper rv2.8.109
  1047.    Content-Length: 0
  1048.  
  1049.    ------------------------------------------------------------------------
  1050. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:37.404822 [NOTICE] sofia.c:1079 Hangup sofia/internal/1003@183.82.203.220:23585 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
  1051. send 572 bytes to tcp/[183.82.203.220]:23585 at 12:26:37.410884:
  1052.    ------------------------------------------------------------------------
  1053.    SIP/2.0 200 OK
  1054.    Via: SIP/2.0/TCP 183.82.203.220:23585;branch=z9hG4bK-524287-1---2f6d96be77c073e1;rport=23585
  1055.    From: <sip:1003@183.82.203.220:23585;transport=TCP;rinstance=eff915fadb99c0b0>;tag=fc90b801
  1056.    To: "Extension 1000" <sip:1000@159.89.163.195>;tag=DD4jjFNyHHeKc
  1057.    Call-ID: b64d71ce-570b-1237-2b97-528373432f88
  1058.    CSeq: 2 BYE
  1059.    User-Agent: FreeSWITCH-mod_sofia/1.8.2+git~20180926T175525Z~a98a958ac3~64bit
  1060.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  1061.    Supported: timer, path, replaces
  1062.    Content-Length: 0
  1063.  
  1064.    ------------------------------------------------------------------------
  1065. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:37.404822 [DEBUG] switch_ivr_bridge.c:917 BRIDGE THREAD DONE [sofia/internal/1003@183.82.203.220:23585]
  1066. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:37.404822 [DEBUG] switch_core_state_machine.c:653 (sofia/internal/1003@183.82.203.220:23585) State EXCHANGE_MEDIA going to sleep
  1067. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:37.404822 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1003@183.82.203.220:23585) Running State Change CS_HANGUP (Cur 2 Tot 23)
  1068. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:37.404822 [DEBUG] switch_core_state_machine.c:847 (sofia/internal/1003@183.82.203.220:23585) Callstate Change ACTIVE -> HANGUP
  1069. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:37.404822 [DEBUG] switch_core_state_machine.c:849 (sofia/internal/1003@183.82.203.220:23585) State HANGUP
  1070. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:37.404822 [DEBUG] mod_sofia.c:449 Channel sofia/internal/1003@183.82.203.220:23585 hanging up, cause: NORMAL_CLEARING
  1071. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:37.404822 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1003@183.82.203.220:23585 Standard HANGUP, cause: NORMAL_CLEARING
  1072. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:37.404822 [DEBUG] switch_core_state_machine.c:849 (sofia/internal/1003@183.82.203.220:23585) State HANGUP going to sleep
  1073. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:37.404822 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/1003@183.82.203.220:23585) State Change CS_HANGUP -> CS_REPORTING
  1074. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:37.404822 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1003@183.82.203.220:23585) Running State Change CS_REPORTING (Cur 2 Tot 23)
  1075. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:37.404822 [DEBUG] switch_core_state_machine.c:935 (sofia/internal/1003@183.82.203.220:23585) State REPORTING
  1076. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:37.404822 [DEBUG] switch_core_state_machine.c:174 sofia/internal/1003@183.82.203.220:23585 Standard REPORTING, cause: NORMAL_CLEARING
  1077. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:37.404822 [DEBUG] switch_core_state_machine.c:935 (sofia/internal/1003@183.82.203.220:23585) State REPORTING going to sleep
  1078. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:37.414836 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/1003@183.82.203.220:23585) State Change CS_REPORTING -> CS_DESTROY
  1079. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:37.414836 [DEBUG] switch_core_session.c:1714 Session 23 (sofia/internal/1003@183.82.203.220:23585) Locked, Waiting on external entities
  1080. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] switch_ivr_bridge.c:825 sofia/internal/1003@183.82.203.220:23585 ending bridge by request from write function
  1081. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] switch_ivr_bridge.c:917 BRIDGE THREAD DONE [sofia/internal/1000@159.89.163.195:5020]
  1082. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [NOTICE] switch_ivr_bridge.c:1933 Hangup sofia/internal/1000@159.89.163.195:5020 [CS_EXECUTE] [NORMAL_CLEARING]
  1083. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] mod_hash.c:297 Usage for dev-scott.getweave.io_inbound is now 0
  1084. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] switch_core_session.c:2886 sofia/internal/1000@159.89.163.195:5020 skip receive message [PHONE_EVENT] (channel is hungup already)
  1085. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/1000@159.89.163.195:5020) State EXECUTE going to sleep
  1086. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1000@159.89.163.195:5020) Running State Change CS_HANGUP (Cur 2 Tot 23)
  1087. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] switch_core_state_machine.c:847 (sofia/internal/1000@159.89.163.195:5020) Callstate Change ACTIVE -> HANGUP
  1088. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] switch_core_state_machine.c:849 (sofia/internal/1000@159.89.163.195:5020) State HANGUP
  1089. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] mod_sofia.c:443 sofia/internal/1000@159.89.163.195:5020 Overriding SIP cause 480 with 200 from the other leg
  1090. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] mod_sofia.c:449 Channel sofia/internal/1000@159.89.163.195:5020 hanging up, cause: NORMAL_CLEARING
  1091. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] mod_sofia.c:502 Sending BYE to sofia/internal/1000@159.89.163.195:5020
  1092. send 642 bytes to udp/[183.82.203.220]:23502 at 12:26:37.417679:
  1093.    ------------------------------------------------------------------------
  1094.    BYE sip:1000@183.82.203.220:23502;rinstance=455085c26772fb89 SIP/2.0
  1095.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport;branch=z9hG4bKvQv97HaKUFmHm
  1096.    Max-Forwards: 70
  1097.    From: <sip:1000@159.89.163.195:5020>;tag=c4atgm4tm8Q0g
  1098.    To: "1000" <sip:1000@159.89.163.195:5020>;tag=34407550
  1099.    Call-ID: 92627MzJlOWE2MzNlZDM5ODhkZTc4YzJjZGM2YmFlZDdhNTU
  1100.    CSeq: 130124134 BYE
  1101.    User-Agent: FreeSWITCH-mod_sofia/1.8.2+git~20180926T175525Z~a98a958ac3~64bit
  1102.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  1103.    Supported: timer, path, replaces
  1104.    Reason: Q.850;cause=16;text="NORMAL_CLEARING"
  1105.    Content-Length: 0
  1106.  
  1107.    ------------------------------------------------------------------------
  1108. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1000@159.89.163.195:5020 Standard HANGUP, cause: NORMAL_CLEARING
  1109. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] switch_core_state_machine.c:849 (sofia/internal/1000@159.89.163.195:5020) State HANGUP going to sleep
  1110. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/1000@159.89.163.195:5020) State Change CS_HANGUP -> CS_REPORTING
  1111. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1000@159.89.163.195:5020) Running State Change CS_REPORTING (Cur 2 Tot 23)
  1112. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] switch_core_state_machine.c:935 (sofia/internal/1000@159.89.163.195:5020) State REPORTING
  1113. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] switch_core_state_machine.c:174 sofia/internal/1000@159.89.163.195:5020 Standard REPORTING, cause: NORMAL_CLEARING
  1114. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] switch_core_state_machine.c:935 (sofia/internal/1000@159.89.163.195:5020) State REPORTING going to sleep
  1115. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/1000@159.89.163.195:5020) State Change CS_REPORTING -> CS_DESTROY
  1116. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] switch_core_session.c:1714 Session 22 (sofia/internal/1000@159.89.163.195:5020) Locked, Waiting on external entities
  1117. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [NOTICE] switch_core_session.c:1732 Session 22 (sofia/internal/1000@159.89.163.195:5020) Ended
  1118. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [NOTICE] switch_core_session.c:1736 Close Channel sofia/internal/1000@159.89.163.195:5020 [CS_DESTROY]
  1119. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] switch_core_state_machine.c:738 (sofia/internal/1000@159.89.163.195:5020) Running State Change CS_DESTROY (Cur 1 Tot 23)
  1120. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] switch_core_state_machine.c:748 (sofia/internal/1000@159.89.163.195:5020) State DESTROY
  1121. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] mod_sofia.c:354 sofia/internal/1000@159.89.163.195:5020 SOFIA DESTROY
  1122. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] switch_core_state_machine.c:181 sofia/internal/1000@159.89.163.195:5020 Standard DESTROY
  1123. 18923368-a8a9-4a94-9b9f-dcceaca1e6c8 2018-10-30 12:26:37.414836 [DEBUG] switch_core_state_machine.c:748 (sofia/internal/1000@159.89.163.195:5020) State DESTROY going to sleep
  1124. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:37.414836 [NOTICE] switch_core_session.c:1732 Session 23 (sofia/internal/1003@183.82.203.220:23585) Ended
  1125. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:37.414836 [NOTICE] switch_core_session.c:1736 Close Channel sofia/internal/1003@183.82.203.220:23585 [CS_DESTROY]
  1126. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:37.414836 [DEBUG] switch_core_state_machine.c:738 (sofia/internal/1003@183.82.203.220:23585) Running State Change CS_DESTROY (Cur 0 Tot 23)
  1127. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:37.414836 [DEBUG] switch_core_state_machine.c:748 (sofia/internal/1003@183.82.203.220:23585) State DESTROY
  1128. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:37.414836 [DEBUG] mod_sofia.c:354 sofia/internal/1003@183.82.203.220:23585 SOFIA DESTROY
  1129. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:37.414836 [DEBUG] switch_core_state_machine.c:181 sofia/internal/1003@183.82.203.220:23585 Standard DESTROY
  1130. 14a8bd6f-af2e-4b1d-8d18-bd59d863387f 2018-10-30 12:26:37.414836 [DEBUG] switch_core_state_machine.c:748 (sofia/internal/1003@183.82.203.220:23585) State DESTROY going to sleep
  1131. recv 420 bytes from udp/[183.82.203.220]:23502 at 12:26:37.505861:
  1132.    ------------------------------------------------------------------------
  1133.    SIP/2.0 200 OK
  1134.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport=5020;branch=z9hG4bKvQv97HaKUFmHm
  1135.    Contact: <sip:1000@183.82.203.220:23502;rinstance=455085c26772fb89>
  1136.    To: "1000"<sip:1000@159.89.163.195:5020>;tag=34407550
  1137.    From: <sip:1000@159.89.163.195:5020>;tag=c4atgm4tm8Q0g
  1138.    Call-ID: 92627MzJlOWE2MzNlZDM5ODhkZTc4YzJjZGM2YmFlZDdhNTU
  1139.    CSeq: 130124134 BYE
  1140.    User-Agent: X-Lite release 5.3.2 stamp 92627
  1141.    Content-Length: 0
  1142.