From carloskekwa, 7 Years ago, written in FreeSWITCH.
- go back
Embed
Viewing differences between and Logs
  1. freeswitch@internal>
  2. freeswitch@internal> recv 883 bytes from udp/[91.142.62.148]:61807 at 14:59:07.946390:
  3.    ------------------------------------------------------------------------
  4.    INVITE sip:1001@35.160.75.57 SIP/2.0
  5.    Via: SIP/2.0/UDP 192.168.10.116:58927;branch=z9hG4bKU64Zh5aN0fD1BuyV;rport
  6.    Contact: <sip:1002@192.168.10.116:58927>
  7.    Max-Forwards: 70
  8.    From: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  9.    Allow: OPTIONS, INVITE, ACK, REFER, CANCEL, BYE, NOTIFY, MESSAGE
  10.    Supported: replaces, path
  11.    User-Agent: Acrobits SDK (build 0; iOS; arm64-neon)
  12.    To: <sip:1001@35.160.75.57>
  13.    Content-Type: application/sdp
  14.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  15.    CSeq: 1 INVITE
  16.    Content-Length: 345
  17.    
  18.    v=0
  19.    o=- 5366485179 20532 IN IP4 172.26.170.170
  20.    s=jxgxntt
  21.    c=IN IP4 192.168.10.116
  22.    t=0 0
  23.    m=audio 31210 RTP/AVP 0 8 9 3 102 101
  24.    a=rtpmap:101 telephone-event/8000
  25.    a=rtpmap:102 iLBC/8000
  26.    a=fmtp:101 0-15
  27.    a=fmtp:102 mode=20
  28.    a=ptime:20
  29.    a=sendrecv
  30.    m=video 45462 RTP/AVP 34
  31.    a=rtpmap:34 H263/90000
  32.    a=fmtp:34 CIF=1;QCIF=2;SQCIF=2
  33.    a=sendrecv
  34.    ------------------------------------------------------------------------
  35. send 357 bytes to udp/[91.142.62.148]:61807 at 14:59:07.946606:
  36.    ------------------------------------------------------------------------
  37.    SIP/2.0 100 Trying
  38.    Via: SIP/2.0/UDP 192.168.10.116:58927;branch=z9hG4bKU64Zh5aN0fD1BuyV;rport=61807;received=91.142.62.148
  39.    From: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  40.    To: <sip:1001@35.160.75.57>
  41.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  42.    CSeq: 1 INVITE
  43.    User-Agent: FreeSWITCH-mod_sofia/1.4.23~64bit
  44.    Content-Length: 0
  45.    
  46.    ------------------------------------------------------------------------
  47. 2016-12-22 14:59:07.938192 [NOTICE] switch_channel.c:1075 New Channel sofia/internal/1002@35.160.75.57 [304d65e2-c857-11e6-8125-fb2640f076da]
  48. 2016-12-22 14:59:07.938192 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  49. 2016-12-22 14:59:07.938192 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  50. 2016-12-22 14:59:07.938192 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1002@35.160.75.57) Running State Change CS_NEW
  51. 2016-12-22 14:59:07.938192 [DEBUG] sofia.c:8957 sofia/internal/1002@35.160.75.57 receiving invite from 91.142.62.148:61807 version: 1.4.23  64bit
  52. 2016-12-22 14:59:07.938192 [DEBUG] sofia.c:9124 IP 91.142.62.148 Rejected by acl "domains". Falling back to Digest auth.
  53. send 860 bytes to udp/[91.142.62.148]:61807 at 14:59:07.947287:
  54.    ------------------------------------------------------------------------
  55.    SIP/2.0 407 Proxy Authentication Required
  56.    Via: SIP/2.0/UDP 192.168.10.116:58927;branch=z9hG4bKU64Zh5aN0fD1BuyV;rport=61807;received=91.142.62.148
  57.    From: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  58.    To: <sip:1001@35.160.75.57>;tag=ce7yN682g53XB
  59.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  60.    CSeq: 1 INVITE
  61.    User-Agent: FreeSWITCH-mod_sofia/1.4.23~64bit
  62.    Accept: application/sdp
  63.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  64.    Supported: timer, path, replaces
  65.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  66.    Proxy-Authenticate: Digest realm="35.160.75.57", nonce="304d6fba-c857-11e6-8126-fb2640f076da", algorithm=MD5, qop="auth"
  67.    Content-Length: 0
  68.    
  69.    ------------------------------------------------------------------------
  70. 2016-12-22 14:59:07.938192 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  71. 2016-12-22 14:59:07.938192 [DEBUG] sofia.c:2065 detaching session 304d65e2-c857-11e6-8125-fb2640f076da
  72. 2016-12-22 14:59:07.938192 [WARNING] sofia_reg.c:1758 SIP auth challenge (INVITE) on sofia profile 'internal' for [1001@35.160.75.57] from ip 91.142.62.148
  73. 2016-12-22 14:59:07.938192 [DEBUG] switch_core_state_machine.c:491 (sofia/internal/1002@35.160.75.57) State NEW
  74. send 860 bytes to udp/[91.142.62.148]:61807 at 14:59:08.446675:
  75.    ------------------------------------------------------------------------
  76.    SIP/2.0 407 Proxy Authentication Required
  77.    Via: SIP/2.0/UDP 192.168.10.116:58927;branch=z9hG4bKU64Zh5aN0fD1BuyV;rport=61807;received=91.142.62.148
  78.    From: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  79.    To: <sip:1001@35.160.75.57>;tag=ce7yN682g53XB
  80.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  81.    CSeq: 1 INVITE
  82.    User-Agent: FreeSWITCH-mod_sofia/1.4.23~64bit
  83.    Accept: application/sdp
  84.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  85.    Supported: timer, path, replaces
  86.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  87.    Proxy-Authenticate: Digest realm="35.160.75.57", nonce="304d6fba-c857-11e6-8126-fb2640f076da", algorithm=MD5, qop="auth"
  88.    Content-Length: 0
  89.    
  90.    ------------------------------------------------------------------------
  91. recv 329 bytes from udp/[91.142.62.148]:61807 at 14:59:08.465485:
  92.    ------------------------------------------------------------------------
  93.    ACK sip:1001@35.160.75.57 SIP/2.0
  94.    Via: SIP/2.0/UDP 192.168.10.116:58927;branch=z9hG4bKU64Zh5aN0fD1BuyV;rport
  95.    Max-Forwards: 70
  96.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  97.    From: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  98.    To: <sip:1001@35.160.75.57>;tag=ce7yN682g53XB
  99.    CSeq: 1 ACK
  100.    Content-Length: 0
  101.    
  102.    ------------------------------------------------------------------------
  103. recv 1143 bytes from udp/[91.142.62.148]:61807 at 14:59:08.471303:
  104.    ------------------------------------------------------------------------
  105.    INVITE sip:1001@35.160.75.57 SIP/2.0
  106.    Via: SIP/2.0/UDP 192.168.10.116:58927;branch=z9hG4bKdY4bwnRzxuZZ3oE3;rport
  107.    Contact: <sip:1002@192.168.10.116:58927>
  108.    Max-Forwards: 70
  109.    From: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  110.    Allow: OPTIONS, INVITE, ACK, REFER, CANCEL, BYE, NOTIFY, MESSAGE
  111.    Supported: replaces, path
  112.    User-Agent: Acrobits SDK (build 0; iOS; arm64-neon)
  113.    To: <sip:1001@35.160.75.57>
  114.    Content-Type: application/sdp
  115.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  116.    CSeq: 2 INVITE
  117.    Proxy-Authorization: Digest username="1002",realm="35.160.75.57",algorithm=MD5,uri="sip:1001@35.160.75.57",nonce="304d6fba-c857-11e6-8126-fb2640f076da",qop=auth,cnonce="b0d6df67c670924e0d5c2cdec81d1bc8",nc=00000001,response="021b2f72ab5229ed532afad393f9aa97"
  118.    Content-Length: 345
  119.    
  120.    v=0
  121.    o=- 5366485179 20532 IN IP4 172.26.170.170
  122.    s=jxgxntt
  123.    c=IN IP4 192.168.10.116
  124.    t=0 0
  125.    m=audio 31210 RTP/AVP 0 8 9 3 102 101
  126.    a=rtpmap:101 telephone-event/8000
  127.    a=rtpmap:102 iLBC/8000
  128.    a=fmtp:101 0-15
  129.    a=fmtp:102 mode=20
  130.    a=ptime:20
  131.    a=sendrecv
  132.    m=video 45462 RTP/AVP 34
  133.    a=rtpmap:34 H263/90000
  134.    a=fmtp:34 CIF=1;QCIF=2;SQCIF=2
  135.    a=sendrecv
  136.    ------------------------------------------------------------------------
  137. send 357 bytes to udp/[91.142.62.148]:61807 at 14:59:08.471487:
  138.    ------------------------------------------------------------------------
  139.    SIP/2.0 100 Trying
  140.    Via: SIP/2.0/UDP 192.168.10.116:58927;branch=z9hG4bKdY4bwnRzxuZZ3oE3;rport=61807;received=91.142.62.148
  141.    From: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  142.    To: <sip:1001@35.160.75.57>
  143.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  144.    CSeq: 2 INVITE
  145.    User-Agent: FreeSWITCH-mod_sofia/1.4.23~64bit
  146.    Content-Length: 0
  147.    
  148.    ------------------------------------------------------------------------
  149. 2016-12-22 14:59:08.458219 [DEBUG] sofia.c:2173 Re-attaching to session 304d65e2-c857-11e6-8125-fb2640f076da
  150. 2016-12-22 14:59:08.458219 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  151. 2016-12-22 14:59:08.458219 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  152. 2016-12-22 14:59:08.478211 [DEBUG] sofia.c:8957 sofia/internal/1002@35.160.75.57 receiving invite from 91.142.62.148:61807 version: 1.4.23  64bit
  153. 2016-12-22 14:59:08.478211 [DEBUG] sofia.c:9124 IP 91.142.62.148 Rejected by acl "domains". Falling back to Digest auth.
  154. 2016-12-22 14:59:08.478211 [DEBUG] sofia.c:10222 Setting NAT mode based on nat.auto
  155. 2016-12-22 14:59:08.478211 [DEBUG] sofia.c:6658 Channel sofia/internal/1002@35.160.75.57 entering state [received][100]
  156. 2016-12-22 14:59:08.478211 [DEBUG] sofia.c:6668 Remote SDP:
  157. v=0
  158. o=- 5366485179 20532 IN IP4 172.26.170.170
  159. s=jxgxntt
  160. c=IN IP4 192.168.10.116
  161. t=0 0
  162. m=audio 31210 RTP/AVP 0 8 9 3 102 101
  163. a=rtpmap:102 iLBC/8000
  164. a=fmtp:102 mode=20
  165. a=rtpmap:101 telephone-event/8000
  166. a=fmtp:101 0-15
  167. a=ptime:20
  168. m=video 45462 RTP/AVP 34
  169. a=rtpmap:34 H263/90000
  170. a=fmtp:34 CIF=1;QCIF=2;SQCIF=2
  171.  
  172. 2016-12-22 14:59:08.478211 [DEBUG] sofia.c:6934 (sofia/internal/1002@35.160.75.57) State Change CS_NEW -> CS_INIT
  173. 2016-12-22 14:59:08.478211 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  174. 2016-12-22 14:59:08.478211 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1002@35.160.75.57) Running State Change CS_INIT
  175. 2016-12-22 14:59:08.478211 [DEBUG] switch_core_state_machine.c:512 (sofia/internal/1002@35.160.75.57) State INIT
  176. 2016-12-22 14:59:08.478211 [DEBUG] mod_sofia.c:87 sofia/internal/1002@35.160.75.57 SOFIA INIT
  177. 2016-12-22 14:59:08.478211 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1002@35.160.75.57 Standard INIT
  178. 2016-12-22 14:59:08.478211 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1002@35.160.75.57) State Change CS_INIT -> CS_ROUTING
  179. 2016-12-22 14:59:08.478211 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  180. 2016-12-22 14:59:08.478211 [DEBUG] switch_core_state_machine.c:512 (sofia/internal/1002@35.160.75.57) State INIT going to sleep
  181. 2016-12-22 14:59:08.478211 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1002@35.160.75.57) Running State Change CS_ROUTING
  182. 2016-12-22 14:59:08.478211 [DEBUG] switch_channel.c:2204 (sofia/internal/1002@35.160.75.57) Callstate Change DOWN -> RINGING
  183. 2016-12-22 14:59:08.478211 [DEBUG] switch_core_state_machine.c:528 (sofia/internal/1002@35.160.75.57) State ROUTING
  184. 2016-12-22 14:59:08.478211 [DEBUG] mod_sofia.c:123 sofia/internal/1002@35.160.75.57 SOFIA ROUTING
  185. 2016-12-22 14:59:08.478211 [DEBUG] switch_core_state_machine.c:166 sofia/internal/1002@35.160.75.57 Standard ROUTING
  186. 2016-12-22 14:59:08.478211 [INFO] mod_dialplan_xml.c:635 Processing 1002 <1002>->1001 in context default
  187. Dialplan: sofia/internal/1002@35.160.75.57 parsing [default->unloop] continue=false
  188. Dialplan: sofia/internal/1002@35.160.75.57 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
  189. Dialplan: sofia/internal/1002@35.160.75.57 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
  190. Dialplan: sofia/internal/1002@35.160.75.57 parsing [default->tod_example] continue=true
  191. Dialplan: sofia/internal/1002@35.160.75.57 Date/Time Match (PASS) [tod_example] break=on-false
  192. Dialplan: sofia/internal/1002@35.160.75.57 Action set(open=true)
  193. Dialplan: sofia/internal/1002@35.160.75.57 parsing [default->holiday_example] continue=true
  194. Dialplan: sofia/internal/1002@35.160.75.57 Date/TimeMatch (FAIL) [holiday_example] break=on-false
  195. Dialplan: sofia/internal/1002@35.160.75.57 parsing [default->global-intercept] continue=false
  196. Dialplan: sofia/internal/1002@35.160.75.57 Regex (FAIL) [global-intercept] destination_number(1001) =~ /^886$/ break=on-false
  197. Dialplan: sofia/internal/1002@35.160.75.57 parsing [default->group-intercept] continue=false
  198. Dialplan: sofia/internal/1002@35.160.75.57 Regex (FAIL) [group-intercept] destination_number(1001) =~ /^\*8$/ break=on-false
  199. Dialplan: sofia/internal/1002@35.160.75.57 parsing [default->intercept-ext] continue=false
  200. Dialplan: sofia/internal/1002@35.160.75.57 Regex (FAIL) [intercept-ext] destination_number(1001) =~ /^\*\*(\d+)$/ break=on-false
  201. Dialplan: sofia/internal/1002@35.160.75.57 parsing [default->redial] continue=false
  202. Dialplan: sofia/internal/1002@35.160.75.57 Regex (FAIL) [redial] destination_number(1001) =~ /^(redial|870)$/ break=on-false
  203. Dialplan: sofia/internal/1002@35.160.75.57 parsing [default->global] continue=true
  204. Dialplan: sofia/internal/1002@35.160.75.57 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never
  205. Dialplan: sofia/internal/1002@35.160.75.57 Regex (FAIL) [global] ${default_password}(i-0d1b371d79afbe962) =~ /^1234$/ break=never
  206. Dialplan: sofia/internal/1002@35.160.75.57 Regex (FAIL) [global] ${rtp_has_crypto}() =~ /^(AEAD_AES_256_GCM_8|AEAD_AES_128_GCM_8|AES_CM_256_HMAC_SHA1_80|AES_CM_192_HMAC_SHA1_80|AES_CM_128_HMAC_SHA1_80|AES_CM_256_HMAC_SHA1_32|AES_CM_192_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_32|AES_CM_128_NULL_AUTH)$/ break=never
  207. Dialplan: sofia/internal/1002@35.160.75.57 Regex (PASS) [global] ${endpoint_disposition}(DELAYED NEGOTIATION) =~ /^(DELAYED NEGOTIATION)/ break=on-false
  208. Dialplan: sofia/internal/1002@35.160.75.57 Regex (FAIL) [global] ${switch_r_sdp}(v=0
  209. o=- 5366485179 20532 IN IP4 172.26.170.170
  210. s=jxgxntt
  211. c=IN IP4 192.168.10.116
  212. t=0 0
  213. m=audio 31210 RTP/AVP 0 8 9 3 102 101
  214. a=rtpmap:102 iLBC/8000
  215. a=fmtp:102 mode=20
  216. a=rtpmap:101 telephone-event/8000
  217. a=fmtp:101 0-15
  218. a=ptime:20
  219. m=video 45462 RTP/AVP 34
  220. a=rtpmap:34 H263/90000
  221. a=fmtp:34 CIF=1;QCIF=2;SQCIF=2
  222. ) =~ /(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)/ break=never
  223. Dialplan: sofia/internal/1002@35.160.75.57 Absolute Condition [global]
  224. Dialplan: sofia/internal/1002@35.160.75.57 Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid})
  225. Dialplan: sofia/internal/1002@35.160.75.57 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
  226. Dialplan: sofia/internal/1002@35.160.75.57 Action hash(insert/${domain_name}-last_dial/global/${uuid})
  227. Dialplan: sofia/internal/1002@35.160.75.57 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
  228. Dialplan: sofia/internal/1002@35.160.75.57 parsing [default->snom-demo-2] continue=false
  229. Dialplan: sofia/internal/1002@35.160.75.57 Regex (FAIL) [snom-demo-2] destination_number(1001) =~ /^9001$/ break=on-false
  230. Dialplan: sofia/internal/1002@35.160.75.57 parsing [default->snom-demo-1] continue=false
  231. Dialplan: sofia/internal/1002@35.160.75.57 Regex (FAIL) [snom-demo-1] destination_number(1001) =~ /^9000$/ break=on-false
  232. Dialplan: sofia/internal/1002@35.160.75.57 parsing [default->eavesdrop] continue=false
  233. Dialplan: sofia/internal/1002@35.160.75.57 Regex (FAIL) [eavesdrop] destination_number(1001) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false
  234. Dialplan: sofia/internal/1002@35.160.75.57 parsing [default->eavesdrop] continue=false
  235. Dialplan: sofia/internal/1002@35.160.75.57 Regex (FAIL) [eavesdrop] destination_number(1001) =~ /^779$/ break=on-false
  236. Dialplan: sofia/internal/1002@35.160.75.57 parsing [default->call_return] continue=false
  237. Dialplan: sofia/internal/1002@35.160.75.57 Regex (FAIL) [call_return] destination_number(1001) =~ /^\*69$|^869$|^lcr$/ break=on-false
  238. Dialplan: sofia/internal/1002@35.160.75.57 parsing [default->del-group] continue=false
  239. Dialplan: sofia/internal/1002@35.160.75.57 Regex (FAIL) [del-group] destination_number(1001) =~ /^80(\d{2})$/ break=on-false
  240. Dialplan: sofia/internal/1002@35.160.75.57 parsing [default->add-group] continue=false
  241. Dialplan: sofia/internal/1002@35.160.75.57 Regex (FAIL) [add-group] destination_number(1001) =~ /^81(\d{2})$/ break=on-false
  242. Dialplan: sofia/internal/1002@35.160.75.57 parsing [default->call-group-simo] continue=false
  243. Dialplan: sofia/internal/1002@35.160.75.57 Regex (FAIL) [call-group-simo] destination_number(1001) =~ /^82(\d{2})$/ break=on-false
  244. Dialplan: sofia/internal/1002@35.160.75.57 parsing [default->call-group-order] continue=false
  245. Dialplan: sofia/internal/1002@35.160.75.57 Regex (FAIL) [call-group-order] destination_number(1001) =~ /^83(\d{2})$/ break=on-false
  246. Dialplan: sofia/internal/1002@35.160.75.57 parsing [default->extension-intercom] continue=false
  247. Dialplan: sofia/internal/1002@35.160.75.57 Regex (FAIL) [extension-intercom] destination_number(1001) =~ /^8(10[01][0-9])$/ break=on-false
  248. Dialplan: sofia/internal/1002@35.160.75.57 parsing [default->Local_Extension] continue=false
  249. Dialplan: sofia/internal/1002@35.160.75.57 Regex (PASS) [Local_Extension] destination_number(1001) =~ /^(10[01][0-9])$/ break=on-false
  250. Dialplan: sofia/internal/1002@35.160.75.57 Action export(dialed_extension=1001)
  251. Dialplan: sofia/internal/1002@35.160.75.57 Action bind_meta_app(1 b s execute_extension::dx XML features)
  252. Dialplan: sofia/internal/1002@35.160.75.57 Action bind_meta_app(2 b s record_session::/usr/local/freeswitch/recordings/${caller_id_number}.${strftime(%Y-%m-%d-%H-%M-%S)}.wav)
  253. Dialplan: sofia/internal/1002@35.160.75.57 Action bind_meta_app(3 b s execute_extension::cf XML features)
  254. Dialplan: sofia/internal/1002@35.160.75.57 Action bind_meta_app(4 b s execute_extension::att_xfer XML features)
  255. Dialplan: sofia/internal/1002@35.160.75.57 Action set(ringback=${us-ring})
  256. Dialplan: sofia/internal/1002@35.160.75.57 Action set(transfer_ringback=local_stream://moh)
  257. Dialplan: sofia/internal/1002@35.160.75.57 Action set(call_timeout=30)
  258. Dialplan: sofia/internal/1002@35.160.75.57 Action set(hangup_after_bridge=true)
  259. Dialplan: sofia/internal/1002@35.160.75.57 Action set(continue_on_fail=true)
  260. Dialplan: sofia/internal/1002@35.160.75.57 Action hash(insert/${domain_name}-call_return/${dialed_extension}/${caller_id_number})
  261. Dialplan: sofia/internal/1002@35.160.75.57 Action hash(insert/${domain_name}-last_dial_ext/${dialed_extension}/${uuid})
  262. Dialplan: sofia/internal/1002@35.160.75.57 Action set(called_party_callgroup=${user_data(${dialed_extension}@${domain_name} var callgroup)})
  263. Dialplan: sofia/internal/1002@35.160.75.57 Action hash(insert/${domain_name}-last_dial_ext/${called_party_callgroup}/${uuid})
  264. Dialplan: sofia/internal/1002@35.160.75.57 Action hash(insert/${domain_name}-last_dial_ext/global/${uuid})
  265. Dialplan: sofia/internal/1002@35.160.75.57 Action hash(insert/${domain_name}-last_dial/${called_party_callgroup}/${uuid})
  266. Dialplan: sofia/internal/1002@35.160.75.57 Action bridge(user/${dialed_extension}@${domain_name})
  267. Dialplan: sofia/internal/1002@35.160.75.57 Action answer()
  268. Dialplan: sofia/internal/1002@35.160.75.57 Action sleep(1000)
  269. Dialplan: sofia/internal/1002@35.160.75.57 Action bridge(loopback/app=voicemail:default ${domain_name} ${dialed_extension})
  270. 2016-12-22 14:59:08.478211 [DEBUG] switch_core_state_machine.c:216 (sofia/internal/1002@35.160.75.57) State Change CS_ROUTING -> CS_EXECUTE
  271. 2016-12-22 14:59:08.478211 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  272. 2016-12-22 14:59:08.478211 [DEBUG] switch_core_state_machine.c:528 (sofia/internal/1002@35.160.75.57) State ROUTING going to sleep
  273. 2016-12-22 14:59:08.478211 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1002@35.160.75.57) Running State Change CS_EXECUTE
  274. 2016-12-22 14:59:08.478211 [DEBUG] switch_core_state_machine.c:535 (sofia/internal/1002@35.160.75.57) State EXECUTE
  275. 2016-12-22 14:59:08.478211 [DEBUG] mod_sofia.c:178 sofia/internal/1002@35.160.75.57 SOFIA EXECUTE
  276. 2016-12-22 14:59:08.478211 [DEBUG] switch_core_state_machine.c:258 sofia/internal/1002@35.160.75.57 Standard EXECUTE
  277. EXECUTE sofia/internal/1002@35.160.75.57 set(open=true)
  278. 2016-12-22 14:59:08.478211 [DEBUG] mod_dptools.c:1477 sofia/internal/1002@35.160.75.57 SET [open]=[true]
  279. EXECUTE sofia/internal/1002@35.160.75.57 hash(insert/35.160.75.57-spymap/1002/304d65e2-c857-11e6-8125-fb2640f076da)
  280. EXECUTE sofia/internal/1002@35.160.75.57 hash(insert/35.160.75.57-last_dial/1002/1001)
  281. EXECUTE sofia/internal/1002@35.160.75.57 hash(insert/35.160.75.57-last_dial/global/304d65e2-c857-11e6-8125-fb2640f076da)
  282. EXECUTE sofia/internal/1002@35.160.75.57 export(RFC2822_DATE=Thu, 22 Dec 2016 14:59:08 +0000)
  283. 2016-12-22 14:59:08.478211 [DEBUG] switch_channel.c:1267 EXPORT (export_vars) [RFC2822_DATE]=[Thu, 22 Dec 2016 14:59:08 +0000]
  284. EXECUTE sofia/internal/1002@35.160.75.57 export(dialed_extension=1001)
  285. 2016-12-22 14:59:08.478211 [DEBUG] switch_channel.c:1267 EXPORT (export_vars) [dialed_extension]=[1001]
  286. EXECUTE sofia/internal/1002@35.160.75.57 bind_meta_app(1 b s execute_extension::dx XML features)
  287. 2016-12-22 14:59:08.478211 [INFO] switch_ivr_async.c:3932 Bound B-Leg: *1 execute_extension::dx XML features
  288. EXECUTE sofia/internal/1002@35.160.75.57 bind_meta_app(2 b s record_session::/usr/local/freeswitch/recordings/1002.2016-12-22-14-59-08.wav)
  289. 2016-12-22 14:59:08.478211 [INFO] switch_ivr_async.c:3932 Bound B-Leg: *2 record_session::/usr/local/freeswitch/recordings/1002.2016-12-22-14-59-08.wav
  290. EXECUTE sofia/internal/1002@35.160.75.57 bind_meta_app(3 b s execute_extension::cf XML features)
  291. 2016-12-22 14:59:08.478211 [INFO] switch_ivr_async.c:3932 Bound B-Leg: *3 execute_extension::cf XML features
  292. EXECUTE sofia/internal/1002@35.160.75.57 bind_meta_app(4 b s execute_extension::att_xfer XML features)
  293. 2016-12-22 14:59:08.478211 [INFO] switch_ivr_async.c:3932 Bound B-Leg: *4 execute_extension::att_xfer XML features
  294. EXECUTE sofia/internal/1002@35.160.75.57 set(ringback=%(2000,4000,440,480))
  295. 2016-12-22 14:59:08.478211 [DEBUG] mod_dptools.c:1477 sofia/internal/1002@35.160.75.57 SET [ringback]=[%(2000,4000,440,480)]
  296. EXECUTE sofia/internal/1002@35.160.75.57 set(transfer_ringback=local_stream://moh)
  297. 2016-12-22 14:59:08.478211 [DEBUG] mod_dptools.c:1477 sofia/internal/1002@35.160.75.57 SET [transfer_ringback]=[local_stream://moh]
  298. EXECUTE sofia/internal/1002@35.160.75.57 set(call_timeout=30)
  299. 2016-12-22 14:59:08.478211 [DEBUG] mod_dptools.c:1477 sofia/internal/1002@35.160.75.57 SET [call_timeout]=[30]
  300. EXECUTE sofia/internal/1002@35.160.75.57 set(hangup_after_bridge=true)
  301. 2016-12-22 14:59:08.478211 [DEBUG] mod_dptools.c:1477 sofia/internal/1002@35.160.75.57 SET [hangup_after_bridge]=[true]
  302. EXECUTE sofia/internal/1002@35.160.75.57 set(continue_on_fail=true)
  303. 2016-12-22 14:59:08.478211 [DEBUG] mod_dptools.c:1477 sofia/internal/1002@35.160.75.57 SET [continue_on_fail]=[true]
  304. EXECUTE sofia/internal/1002@35.160.75.57 hash(insert/35.160.75.57-call_return/1001/1002)
  305. EXECUTE sofia/internal/1002@35.160.75.57 hash(insert/35.160.75.57-last_dial_ext/1001/304d65e2-c857-11e6-8125-fb2640f076da)
  306. EXECUTE sofia/internal/1002@35.160.75.57 set(called_party_callgroup=techsupport)
  307. 2016-12-22 14:59:08.478211 [DEBUG] mod_dptools.c:1477 sofia/internal/1002@35.160.75.57 SET [called_party_callgroup]=[techsupport]
  308. EXECUTE sofia/internal/1002@35.160.75.57 hash(insert/35.160.75.57-last_dial_ext/techsupport/304d65e2-c857-11e6-8125-fb2640f076da)
  309. EXECUTE sofia/internal/1002@35.160.75.57 hash(insert/35.160.75.57-last_dial_ext/global/304d65e2-c857-11e6-8125-fb2640f076da)
  310. EXECUTE sofia/internal/1002@35.160.75.57 hash(insert/35.160.75.57-last_dial/techsupport/304d65e2-c857-11e6-8125-fb2640f076da)
  311. EXECUTE sofia/internal/1002@35.160.75.57 bridge(user/1001@35.160.75.57)
  312. 2016-12-22 14:59:08.478211 [DEBUG] switch_channel.c:1221 sofia/internal/1002@35.160.75.57 EXPORTING[export_vars] [RFC2822_DATE]=[Thu, 22 Dec 2016 14:59:08 +0000] to event
  313. 2016-12-22 14:59:08.478211 [DEBUG] switch_channel.c:1221 sofia/internal/1002@35.160.75.57 EXPORTING[export_vars] [dialed_extension]=[1001] to event
  314. 2016-12-22 14:59:08.478211 [DEBUG] switch_ivr_originate.c:2101 Parsing global variables
  315. 2016-12-22 14:59:08.478211 [DEBUG] switch_channel.c:1221 sofia/internal/1002@35.160.75.57 EXPORTING[export_vars] [RFC2822_DATE]=[Thu, 22 Dec 2016 14:59:08 +0000] to event
  316. 2016-12-22 14:59:08.478211 [DEBUG] switch_channel.c:1221 sofia/internal/1002@35.160.75.57 EXPORTING[export_vars] [dialed_extension]=[1001] to event
  317. 2016-12-22 14:59:08.478211 [DEBUG] switch_ivr_originate.c:2101 Parsing global variables
  318. 2016-12-22 14:59:08.478211 [DEBUG] switch_event.c:1698 Parsing variable [sip_invite_domain]=[35.160.75.57]
  319. 2016-12-22 14:59:08.478211 [DEBUG] switch_event.c:1698 Parsing variable [presence_id]=[1001@35.160.75.57]
  320. 2016-12-22 14:59:08.478211 [NOTICE] switch_channel.c:1075 New Channel sofia/internal/1001@192.168.10.113:53834 [30a159ae-c857-11e6-8144-fb2640f076da]
  321. 2016-12-22 14:59:08.478211 [DEBUG] mod_sofia.c:4700 (sofia/internal/1001@192.168.10.113:53834) State Change CS_NEW -> CS_INIT
  322. 2016-12-22 14:59:08.478211 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  323. 2016-12-22 14:59:08.478211 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1001@192.168.10.113:53834) Running State Change CS_INIT
  324. 2016-12-22 14:59:08.478211 [DEBUG] switch_core_state_machine.c:512 (sofia/internal/1001@192.168.10.113:53834) State INIT
  325. 2016-12-22 14:59:08.478211 [DEBUG] mod_sofia.c:87 sofia/internal/1001@192.168.10.113:53834 SOFIA INIT
  326. 2016-12-22 14:59:08.478211 [DEBUG] sofia_glue.c:1212 sip:1001@91.142.62.148:61814;rinstance=B840C22E Setting proxy route to sofia/internal/1001@192.168.10.113:53834
  327. 2016-12-22 14:59:08.478211 [DEBUG] sofia_glue.c:1241 sofia/internal/1001@192.168.10.113:53834 sending invite version: 1.4.23  64bit
  328. Local SDP:
  329. v=0
  330. o=FreeSWITCH 1482391882 1482391883 IN IP4 35.160.75.57
  331. s=FreeSWITCH
  332. c=IN IP4 35.160.75.57
  333. t=0 0
  334. m=audio 26866 RTP/AVP 0 8 9 3 102 101 13
  335. a=rtpmap:0 PCMU/8000
  336. a=rtpmap:8 PCMA/8000
  337. a=rtpmap:9 G722/8000
  338. a=rtpmap:3 GSM/8000
  339. a=rtpmap:102 opus/48000/2
  340. a=fmtp:102 useinbandfec=1; usedtx=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=20; maxptime=20; samplerate=48000
  341. a=rtpmap:101 telephone-event/8000
  342. a=fmtp:101 0-16
  343. a=ptime:20
  344. a=sendrecv
  345. m=video 16652 RTP/AVP 103 34
  346. a=rtpmap:103 H264/90000
  347. a=rtpmap:34 H263/90000
  348.  
  349. send 1626 bytes to udp/[91.142.62.148]:61814 at 14:59:08.498290:
  350.    ------------------------------------------------------------------------
  351.    INVITE sip:1001@192.168.10.113:53834;rinstance=B840C22E;received=91.142.62.148:61814 SIP/2.0
  352.    Via: SIP/2.0/UDP 35.160.75.57;rport;branch=z9hG4bK6p71K0ygvg8Zg
  353.    Route: <sip:1001@91.142.62.148:61814>;rinstance=B840C22E
  354.    Max-Forwards: 69
  355.    From: "Extension 1002" <sip:1002@35.160.75.57>;tag=e0SgSvaaBQg3j
  356.    To: <sip:1001@192.168.10.113:53834;rinstance=B840C22E;received=91.142.62.148:61814>
  357.    Call-ID: 07ffcba1-42fa-1235-4aab-029d80950d35
  358.    CSeq: 100873310 INVITE
  359.    Contact: <sip:mod_sofia@35.160.75.57:5060>
  360.    User-Agent: FreeSWITCH-mod_sofia/1.4.23~64bit
  361.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  362.    Supported: timer, path, replaces
  363.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  364.    Content-Type: application/sdp
  365.    Content-Disposition: session
  366.    Content-Length: 543
  367.    X-FS-Support: update_display,send_info
  368.    Remote-Party-ID: "Extension 1002" <sip:1002@35.160.75.57>;party=calling;screen=yes;privacy=off
  369.    
  370.    v=0
  371.    o=FreeSWITCH 1482391882 1482391883 IN IP4 35.160.75.57
  372.    s=FreeSWITCH
  373.    c=IN IP4 35.160.75.57
  374.    t=0 0
  375.    m=audio 26866 RTP/AVP 0 8 9 3 102 101 13
  376.    a=rtpmap:0 PCMU/8000
  377.    a=rtpmap:8 PCMA/8000
  378.    a=rtpmap:9 G722/8000
  379.    a=rtpmap:3 GSM/8000
  380.    a=rtpmap:102 opus/48000/2
  381.    a=fmtp:102 useinbandfec=1; usedtx=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=20; maxptime=20; samplerate=48000
  382.    a=rtpmap:101 telephone-event/8000
  383.    a=fmtp:101 0-16
  384.    a=ptime:20
  385.    m=video 16652 RTP/AVP 103 34
  386.    a=rtpmap:103 H264/90000
  387.    a=rtpmap:34 H263/90000
  388.    ------------------------------------------------------------------------
  389. 2016-12-22 14:59:08.498406 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  390. 2016-12-22 14:59:08.498406 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1001@192.168.10.113:53834 Standard INIT
  391. 2016-12-22 14:59:08.498406 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1001@192.168.10.113:53834) State Change CS_INIT -> CS_ROUTING
  392. 2016-12-22 14:59:08.498406 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  393. 2016-12-22 14:59:08.498406 [DEBUG] switch_core_state_machine.c:512 (sofia/internal/1001@192.168.10.113:53834) State INIT going to sleep
  394. 2016-12-22 14:59:08.498406 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1001@192.168.10.113:53834) Running State Change CS_ROUTING
  395. 2016-12-22 14:59:08.498406 [DEBUG] sofia.c:6658 Channel sofia/internal/1001@192.168.10.113:53834 entering state [calling][0]
  396. 2016-12-22 14:59:08.498406 [DEBUG] switch_core_state_machine.c:528 (sofia/internal/1001@192.168.10.113:53834) State ROUTING
  397. 2016-12-22 14:59:08.498406 [DEBUG] mod_sofia.c:123 sofia/internal/1001@192.168.10.113:53834 SOFIA ROUTING
  398. 2016-12-22 14:59:08.498406 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/1001@192.168.10.113:53834) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  399. 2016-12-22 14:59:08.498406 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  400. 2016-12-22 14:59:08.498406 [DEBUG] switch_core_state_machine.c:528 (sofia/internal/1001@192.168.10.113:53834) State ROUTING going to sleep
  401. 2016-12-22 14:59:08.498406 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1001@192.168.10.113:53834) Running State Change CS_CONSUME_MEDIA
  402. 2016-12-22 14:59:08.498406 [DEBUG] switch_core_state_machine.c:547 (sofia/internal/1001@192.168.10.113:53834) State CONSUME_MEDIA
  403. 2016-12-22 14:59:08.498406 [DEBUG] switch_core_state_machine.c:547 (sofia/internal/1001@192.168.10.113:53834) State CONSUME_MEDIA going to sleep
  404. recv 355 bytes from udp/[91.142.62.148]:61814 at 14:59:08.865760:
  405.    ------------------------------------------------------------------------
  406.    SIP/2.0 100 Trying
  407.    Via: SIP/2.0/UDP 35.160.75.57;rport=5060;branch=z9hG4bK6p71K0ygvg8Zg;received=35.160.75.57
  408.    From: "Extension 1002" <sip:1002@35.160.75.57>;tag=e0SgSvaaBQg3j
  409.    Call-ID: 07ffcba1-42fa-1235-4aab-029d80950d35
  410.    CSeq: 100873310 INVITE
  411.    To: <sip:1001@192.168.10.113:53834;rinstance=B840C22E;received=91.142.62.148:61814>
  412.    Content-Length: 0
  413.    
  414.    ------------------------------------------------------------------------
  415. recv 528 bytes from udp/[91.142.62.148]:61814 at 14:59:08.904586:
  416.    ------------------------------------------------------------------------
  417.    SIP/2.0 180 Ringing
  418.    Via: SIP/2.0/UDP 35.160.75.57;rport=5060;branch=z9hG4bK6p71K0ygvg8Zg;received=35.160.75.57
  419.    Contact: <sip:1001@192.168.10.113:53834>
  420.    From: "Extension 1002" <sip:1002@35.160.75.57>;tag=e0SgSvaaBQg3j
  421.    Call-ID: 07ffcba1-42fa-1235-4aab-029d80950d35
  422.    CSeq: 100873310 INVITE
  423.    To: <sip:1001@192.168.10.113:53834;rinstance=B840C22E;received=91.142.62.148:61814>;tag=FE5DFD1A456A147EE3A2145487DF53FD
  424.    Allow: OPTIONS, INVITE, ACK, REFER, CANCEL, BYE, NOTIFY, MESSAGE
  425.    Supported: replaces, path
  426.    Content-Length: 0
  427.    
  428.    ------------------------------------------------------------------------
  429. 2016-12-22 14:59:08.898222 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  430. 2016-12-22 14:59:08.898222 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  431. 2016-12-22 14:59:08.898222 [DEBUG] sofia.c:6658 Channel sofia/internal/1001@192.168.10.113:53834 entering state [proceeding][180]
  432. 2016-12-22 14:59:08.898222 [NOTICE] sofia.c:6760 Ring-Ready sofia/internal/1001@192.168.10.113:53834!
  433. 2016-12-22 14:59:08.898222 [DEBUG] switch_channel.c:3297 (sofia/internal/1001@192.168.10.113:53834) Callstate Change DOWN -> RINGING
  434. recv 329 bytes from udp/[91.142.62.148]:61807 at 14:59:08.919943:
  435.    ------------------------------------------------------------------------
  436.    ACK sip:1001@35.160.75.57 SIP/2.0
  437.    Via: SIP/2.0/UDP 192.168.10.116:58927;branch=z9hG4bKU64Zh5aN0fD1BuyV;rport
  438.    Max-Forwards: 70
  439.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  440.    From: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  441.    To: <sip:1001@35.160.75.57>;tag=ce7yN682g53XB
  442.    CSeq: 1 ACK
  443.    Content-Length: 0
  444.    
  445.    ------------------------------------------------------------------------
  446. 2016-12-22 14:59:08.918210 [INFO] switch_ivr_originate.c:1193 Sending early media
  447. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
  448. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  449. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  450. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3734 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  451. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  452. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[GSM:3:8000:20:13200:1]
  453. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1]
  454. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  455. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  456. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  457. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3734 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  458. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[GSM:3:8000:20:13200:1]
  459. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [G722:9:8000:20:64000:1]/[opus:116:48000:20:0:1]
  460. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [G722:9:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  461. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3734 Audio Codec Compare [G722:9:8000:20:64000:1] ++++ is saved as a match
  462. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  463. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  464. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [G722:9:8000:20:64000:1]/[GSM:3:8000:20:13200:1]
  465. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [GSM:3:8000:20:13200:1]/[opus:116:48000:20:0:1]
  466. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [GSM:3:8000:20:13200:1]/[G722:9:8000:20:64000:1]
  467. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMU:0:8000:20:64000:1]
  468. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMA:8:8000:20:64000:1]
  469. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [GSM:3:8000:20:13200:1]/[GSM:3:8000:20:13200:1]
  470. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3734 Audio Codec Compare [GSM:3:8000:20:13200:1] ++++ is saved as a match
  471. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [iLBC:102:8000:20:0:1]/[opus:116:48000:20:0:1]
  472. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [iLBC:102:8000:20:0:1]/[G722:9:8000:20:64000:1]
  473. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [iLBC:102:8000:20:0:1]/[PCMU:0:8000:20:64000:1]
  474. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [iLBC:102:8000:20:0:1]/[PCMA:8:8000:20:64000:1]
  475. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [iLBC:102:8000:20:0:1]/[GSM:3:8000:20:13200:1]
  476. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3595 Set telephone-event payload to 101
  477. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:2506 Set Codec sofia/internal/1002@35.160.75.57 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  478. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_codec.c:111 sofia/internal/1002@35.160.75.57 Original read codec set to PCMU:0
  479. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:3942 Set 2833 dtmf send/recv payload to 101
  480. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:4060 Video Codec Compare [H263:34]/[H264:97]
  481. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:4060 Video Codec Compare [H263:34]/[H263:34]
  482. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:4073 Video Codec Compare [H263:34] +++ is saved as a match
  483. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:2326 Set VIDEO Codec sofia/internal/1002@35.160.75.57 H263/90000 0 ms
  484. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:5178 AUDIO RTP [sofia/internal/1002@35.160.75.57] 172.31.32.166 port 21588 -> 192.168.10.116 port 31210 codec: 0 ms: 20
  485. 2016-12-22 14:59:08.918210 [DEBUG] switch_rtp.c:3579 Starting timer [soft] 160 bytes per 20ms
  486. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:5476 Set 2833 dtmf send payload to 101
  487. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:5482 Set 2833 dtmf receive payload to 101
  488. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:5504 sofia/internal/1002@35.160.75.57 Set rtp dtmf delay to 40
  489. 2016-12-22 14:59:08.918210 [DEBUG] switch_rtp.c:3588 Not using a timer
  490. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:5680 VIDEO RTP [sofia/internal/1002@35.160.75.57] 192.168.10.116:31984->192.168.10.116:45462 codec: 34 ms: 0 [SUCCESS]
  491. 2016-12-22 14:59:08.918210 [NOTICE] switch_core_media.c:4442 sofia/internal/1002@35.160.75.57 Starting Video thread
  492. 2016-12-22 14:59:08.918210 [NOTICE] sofia_media.c:92 Pre-Answer sofia/internal/1002@35.160.75.57!
  493. 2016-12-22 14:59:08.918210 [DEBUG] switch_channel.c:3419 (sofia/internal/1002@35.160.75.57) Callstate Change RINGING -> EARLY
  494. 2016-12-22 14:59:08.918210 [DEBUG] mod_sofia.c:2264 Ring SDP:
  495. v=0
  496. o=FreeSWITCH 1482397160 1482397161 IN IP4 35.160.75.57
  497. s=FreeSWITCH
  498. c=IN IP4 35.160.75.57
  499. t=0 0
  500. m=audio 21588 RTP/AVP 0 101
  501. a=rtpmap:0 PCMU/8000
  502. a=rtpmap:101 telephone-event/8000
  503. a=fmtp:101 0-16
  504. a=ptime:20
  505. a=sendrecv
  506. m=video 31984 RTP/AVP 34
  507. a=rtpmap:34 H263/90000
  508. a=fmtp:34 CIF=1;QCIF=2;SQCIF=2
  509.  
  510. send 1228 bytes to udp/[91.142.62.148]:61807 at 14:59:08.926064:
  511.    ------------------------------------------------------------------------
  512.    SIP/2.0 183 Session Progress
  513.    Via: SIP/2.0/UDP 192.168.10.116:58927;branch=z9hG4bKdY4bwnRzxuZZ3oE3;rport=61807;received=91.142.62.148
  514.    From: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  515.    To: <sip:1001@35.160.75.57>;tag=DQ0QQ1S6DetgQ
  516.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  517.    CSeq: 2 INVITE
  518.    Contact: <sip:1001@35.160.75.57:5060;transport=udp>
  519.    User-Agent: FreeSWITCH-mod_sofia/1.4.23~64bit
  520.    Accept: application/sdp
  521.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  522.    Supported: timer, path, replaces
  523.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  524.    Content-Type: application/sdp
  525.    Content-Disposition: session
  526.    Content-Length: 302
  527.    Remote-Party-ID: "1001" <sip:1001@35.160.75.57>;party=calling;privacy=off;screen=no
  528.    
  529.    v=0
  530.    o=FreeSWITCH 1482397160 1482397161 IN IP4 35.160.75.57
  531.    s=FreeSWITCH
  532.    c=IN IP4 35.160.75.57
  533.    t=0 0
  534.    m=audio 21588 RTP/AVP 0 101
  535.    a=rtpmap:0 PCMU/8000
  536.    a=rtpmap:101 telephone-event/8000
  537.    a=fmtp:101 0-16
  538.    a=ptime:20
  539.    m=video 31984 RTP/AVP 34
  540.    a=rtpmap:34 H263/90000
  541.    a=fmtp:34 CIF=1;QCIF=2;SQCIF=2
  542.    ------------------------------------------------------------------------
  543. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  544. 2016-12-22 14:59:08.918210 [DEBUG] sofia.c:6658 Channel sofia/internal/1002@35.160.75.57 entering state [early][183]
  545. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_session.c:913 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  546. 2016-12-22 14:59:08.918210 [DEBUG] switch_ivr_originate.c:1250 Raw Codec Activation Success L16@8000hz 1 channel 20ms
  547. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_codec.c:221 sofia/internal/1002@35.160.75.57 Push codec L16:100
  548. 2016-12-22 14:59:08.918210 [DEBUG] switch_ivr_originate.c:1318 Play Ringback Tone [%(2000,4000,440,480)]
  549. 2016-12-22 14:59:08.918210 [DEBUG] switch_core_media.c:4366 sofia/internal/1002@35.160.75.57 Video thread started. Echo is on
  550. send 802 bytes to udp/[91.142.62.148]:61807 at 14:59:08.926683:
  551.    ------------------------------------------------------------------------
  552.   INFO sip:1002@192.168.10.116:58927 SIP/2.0
  553.    Via: SIP/2.0/UDP 35.160.75.57;rport;branch=z9hG4bK7Z0tNUFmSSyjc
  554.    Max-Forwards: 70
  555.    From: <sip:1001@35.160.75.57>;tag=DQ0QQ1S6DetgQ
  556.    To: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  557.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  558.   CSeq: 100873310 INFO
  559.    Contact: <sip:1001@35.160.75.57:5060;transport=udp>
  560.    User-Agent: FreeSWITCH-mod_sofia/1.4.23~64bit
  561.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  562.    Supported: timer, path, replaces
  563.    Content-Type: application/media_control+xml
  564.    Content-Length: 175
  565.    
  566.    <?xml version="1.0" encoding="utf-8" ?>
  567.    <media_control>
  568.    <vc_primitive>
  569.    <to_encoder>
  570.    <picture_fast_update>
  571.    </picture_fast_update>
  572.    </to_encoder>
  573.    </vc_primitive>
  574.    </media_control>
  575.  
  576.    ------------------------------------------------------------------------
  577. recv 452 bytes from udp/[91.142.62.148]:61807 at 14:59:09.466745:
  578.    ------------------------------------------------------------------------
  579.    SIP/2.0 200 OK
  580.    Via: SIP/2.0/UDP 35.160.75.57;rport=5060;branch=z9hG4bK7Z0tNUFmSSyjc;received=35.160.75.57
  581.    Contact: <sip:1002@192.168.10.116:58927>
  582.    From: <sip:1001@35.160.75.57>;tag=DQ0QQ1S6DetgQ
  583.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  584.   CSeq: 100873310 INFO
  585.    To: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  586.    Allow: OPTIONS, INVITE, ACK, REFER, CANCEL, BYE, NOTIFY, MESSAGE
  587.    Supported: replaces, path
  588.    Content-Length: 0
  589.    
  590.    ------------------------------------------------------------------------
  591. 2016-12-22 14:59:09.458188 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  592. 2016-12-22 14:59:09.758224 [INFO] switch_rtp.c:5867 Auto Changing port from 192.168.10.116:31210 to 46.19.199.210:31210
  593. 2016-12-22 14:59:10.558192 [INFO] switch_rtp.c:5867 Auto Changing port from 192.168.10.116:45462 to 46.19.199.210:45462
  594. recv 847 bytes from udp/[91.142.62.148]:61814 at 14:59:10.961401:
  595.    ------------------------------------------------------------------------
  596.    SIP/2.0 200 OK
  597.    Via: SIP/2.0/UDP 35.160.75.57;rport=5060;branch=z9hG4bK6p71K0ygvg8Zg;received=35.160.75.57
  598.    Contact: <sip:1001@192.168.10.113:53834>
  599.    From: "Extension 1002" <sip:1002@35.160.75.57>;tag=e0SgSvaaBQg3j
  600.    Call-ID: 07ffcba1-42fa-1235-4aab-029d80950d35
  601.    CSeq: 100873310 INVITE
  602.    To: <sip:1001@192.168.10.113:53834;rinstance=B840C22E;received=91.142.62.148:61814>;tag=FE5DFD1A456A147EE3A2145487DF53FD
  603.    Allow: OPTIONS, INVITE, ACK, REFER, CANCEL, BYE, NOTIFY, MESSAGE
  604.    Supported: replaces, path
  605.    Content-Type: application/sdp
  606.    Content-Length: 291
  607.    
  608.    v=0
  609.    o=- 0773657206 19259 IN IP4 172.26.170.170
  610.    s=elopowo
  611.    c=IN IP4 192.168.10.113
  612.    t=0 0
  613.    m=audio 33100 RTP/AVP 0 101
  614.    a=rtpmap:101 telephone-event/8000
  615.    a=fmtp:101 0-15
  616.    a=ptime:20
  617.    a=sendrecv
  618.    m=video 33726 RTP/AVP 34
  619.    a=rtpmap:34 H263/90000
  620.    a=fmtp:34 CIF=1;QCIF=2;SQCIF=2
  621.    a=sendrecv
  622.    ------------------------------------------------------------------------
  623. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  624. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  625. 2016-12-22 14:59:10.958137 [DEBUG] sofia.c:6658 Channel sofia/internal/1001@192.168.10.113:53834 entering state [completing][200]
  626. 2016-12-22 14:59:10.958137 [DEBUG] sofia.c:6668 Remote SDP:
  627. v=0
  628. o=- 773657206 19259 IN IP4 172.26.170.170
  629. s=elopowo
  630. c=IN IP4 192.168.10.113
  631. t=0 0
  632. m=audio 33100 RTP/AVP 0 101
  633. a=rtpmap:101 telephone-event/8000
  634. a=fmtp:101 0-15
  635. a=ptime:20
  636. m=video 33726 RTP/AVP 34
  637. a=rtpmap:34 H263/90000
  638. a=fmtp:34 CIF=1;QCIF=2;SQCIF=2
  639.  
  640. send 447 bytes to udp/[91.142.62.148]:61814 at 14:59:10.962528:
  641.    ------------------------------------------------------------------------
  642.    ACK sip:1001@192.168.10.113:53834 SIP/2.0
  643.    Via: SIP/2.0/UDP 35.160.75.57;rport;branch=z9hG4bK88SKQp0Qp2m5Q
  644.    Max-Forwards: 70
  645.    From: "Extension 1002" <sip:1002@35.160.75.57>;tag=e0SgSvaaBQg3j
  646.    To: <sip:1001@192.168.10.113:53834;rinstance=B840C22E;received=91.142.62.148:61814>;tag=FE5DFD1A456A147EE3A2145487DF53FD
  647.    Call-ID: 07ffcba1-42fa-1235-4aab-029d80950d35
  648.    CSeq: 100873310 ACK
  649.    Contact: <sip:mod_sofia@35.160.75.57:5060>
  650.    Content-Length: 0
  651.    
  652.    ------------------------------------------------------------------------
  653. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  654. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  655. 2016-12-22 14:59:10.958137 [DEBUG] sofia.c:6658 Channel sofia/internal/1001@192.168.10.113:53834 entering state [ready][200]
  656. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  657. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_media.c:3734 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  658. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  659. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  660. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[GSM:3:8000:20:13200:1]
  661. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
  662. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_media.c:3595 Set telephone-event payload to 101
  663. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_media.c:2506 Set Codec sofia/internal/1001@192.168.10.113:53834 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  664. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_codec.c:111 sofia/internal/1001@192.168.10.113:53834 Original read codec set to PCMU:0
  665. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_media.c:3933 Set 2833 dtmf send payload to 101
  666. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_media.c:4060 Video Codec Compare [H263:34]/[H264:97]
  667. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_media.c:4060 Video Codec Compare [H263:34]/[H263:34]
  668. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_media.c:4073 Video Codec Compare [H263:34] +++ is saved as a match
  669. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_media.c:2326 Set VIDEO Codec sofia/internal/1001@192.168.10.113:53834 H263/90000 0 ms
  670. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_media.c:5178 AUDIO RTP [sofia/internal/1001@192.168.10.113:53834] 172.31.32.166 port 26866 -> 192.168.10.113 port 33100 codec: 0 ms: 20
  671. 2016-12-22 14:59:10.958137 [DEBUG] switch_rtp.c:3579 Starting timer [soft] 160 bytes per 20ms
  672. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_media.c:5476 Set 2833 dtmf send payload to 101
  673. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_media.c:5482 Set 2833 dtmf receive payload to 101
  674. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_media.c:5504 sofia/internal/1001@192.168.10.113:53834 Set rtp dtmf delay to 40
  675. 2016-12-22 14:59:10.958137 [DEBUG] switch_rtp.c:3588 Not using a timer
  676. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_media.c:5680 VIDEO RTP [sofia/internal/1001@192.168.10.113:53834] 192.168.10.113:16652->192.168.10.113:33726 codec: 34 ms: 0 [SUCCESS]
  677. 2016-12-22 14:59:10.958137 [NOTICE] switch_core_media.c:4442 sofia/internal/1001@192.168.10.113:53834 Starting Video thread
  678. 2016-12-22 14:59:10.958137 [DEBUG] switch_channel.c:3657 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  679. 2016-12-22 14:59:10.958137 [NOTICE] sofia.c:7525 Channel [sofia/internal/1001@192.168.10.113:53834] has been answered
  680. 2016-12-22 14:59:10.958137 [DEBUG] switch_channel.c:3711 (sofia/internal/1001@192.168.10.113:53834) Callstate Change RINGING -> ACTIVE
  681. 2016-12-22 14:59:10.958137 [DEBUG] switch_core_media.c:4366 sofia/internal/1001@192.168.10.113:53834 Video thread started. Echo is off
  682. send 862 bytes to udp/[91.142.62.148]:61814 at 14:59:10.967435:
  683.    ------------------------------------------------------------------------
  684.   INFO sip:1001@192.168.10.113:53834 SIP/2.0
  685.    Via: SIP/2.0/UDP 35.160.75.57;rport;branch=z9hG4bK9HKcSHHUKBBrK
  686.    Max-Forwards: 70
  687.    From: "Extension 1002" <sip:1002@35.160.75.57>;tag=e0SgSvaaBQg3j
  688.    To: <sip:1001@192.168.10.113:53834;rinstance=B840C22E;received=91.142.62.148:61814>;tag=FE5DFD1A456A147EE3A2145487DF53FD
  689.    Call-ID: 07ffcba1-42fa-1235-4aab-029d80950d35
  690.   CSeq: 100873311 INFO
  691.    Contact: <sip:mod_sofia@35.160.75.57:5060>
  692.    User-Agent: FreeSWITCH-mod_sofia/1.4.23~64bit
  693.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  694.    Supported: timer, path, replaces
  695.    Content-Type: application/media_control+xml
  696.    Content-Length: 175
  697.    
  698.    <?xml version="1.0" encoding="utf-8" ?>
  699.    <media_control>
  700.    <vc_primitive>
  701.    <to_encoder>
  702.    <picture_fast_update>
  703.    </picture_fast_update>
  704.    </to_encoder>
  705.    </vc_primitive>
  706.    </media_control>
  707.  
  708.    ------------------------------------------------------------------------
  709. 2016-12-22 14:59:10.978178 [DEBUG] switch_core_codec.c:246 sofia/internal/1002@35.160.75.57 Restore previous codec PCMU:0.
  710. 2016-12-22 14:59:10.978178 [DEBUG] mod_sofia.c:780 Local SDP sofia/internal/1002@35.160.75.57:
  711. v=0
  712. o=FreeSWITCH 1482397160 1482397162 IN IP4 35.160.75.57
  713. s=FreeSWITCH
  714. c=IN IP4 35.160.75.57
  715. t=0 0
  716. m=audio 21588 RTP/AVP 0 101
  717. a=rtpmap:0 PCMU/8000
  718. a=rtpmap:101 telephone-event/8000
  719. a=fmtp:101 0-16
  720. a=ptime:20
  721. a=sendrecv
  722. m=video 31984 RTP/AVP 34
  723. a=rtpmap:34 H263/90000
  724. a=fmtp:34 CIF=1;QCIF=2;SQCIF=2
  725.  
  726. send 1234 bytes to udp/[91.142.62.148]:61807 at 14:59:10.983100:
  727.    ------------------------------------------------------------------------
  728.    SIP/2.0 200 OK
  729.    Via: SIP/2.0/UDP 192.168.10.116:58927;branch=z9hG4bKdY4bwnRzxuZZ3oE3;rport=61807;received=91.142.62.148
  730.    From: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  731.    To: <sip:1001@35.160.75.57>;tag=DQ0QQ1S6DetgQ
  732.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  733.    CSeq: 2 INVITE
  734.    Contact: <sip:1001@35.160.75.57:5060;transport=udp>
  735.    User-Agent: FreeSWITCH-mod_sofia/1.4.23~64bit
  736.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  737.    Supported: timer, path, replaces
  738.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  739.    Session-Expires: 120;refresher=uas
  740.    Content-Type: application/sdp
  741.    Content-Disposition: session
  742.    Content-Length: 302
  743.    Remote-Party-ID: "Outbound Call" <sip:1001@35.160.75.57>;party=calling;privacy=off;screen=no
  744.    
  745.    v=0
  746.    o=FreeSWITCH 1482397160 1482397161 IN IP4 35.160.75.57
  747.    s=FreeSWITCH
  748.    c=IN IP4 35.160.75.57
  749.    t=0 0
  750.    m=audio 21588 RTP/AVP 0 101
  751.    a=rtpmap:0 PCMU/8000
  752.    a=rtpmap:101 telephone-event/8000
  753.    a=fmtp:101 0-16
  754.    a=ptime:20
  755.    m=video 31984 RTP/AVP 34
  756.    a=rtpmap:34 H263/90000
  757.    a=fmtp:34 CIF=1;QCIF=2;SQCIF=2
  758.    ------------------------------------------------------------------------
  759. 2016-12-22 14:59:10.978178 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  760. 2016-12-22 14:59:10.978178 [DEBUG] sofia.c:6658 Channel sofia/internal/1002@35.160.75.57 entering state [completed][200]
  761. 2016-12-22 14:59:10.978178 [DEBUG] switch_core_session.c:913 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  762. 2016-12-22 14:59:10.978178 [NOTICE] switch_ivr_originate.c:3523 Channel [sofia/internal/1002@35.160.75.57] has been answered
  763. 2016-12-22 14:59:10.978178 [DEBUG] switch_channel.c:3711 (sofia/internal/1002@35.160.75.57) Callstate Change EARLY -> ACTIVE
  764. 2016-12-22 14:59:10.978178 [DEBUG] switch_ivr_originate.c:3581 Originate Resulted in Success: [sofia/internal/1001@192.168.10.113:53834]
  765. 2016-12-22 14:59:10.978178 [DEBUG] switch_ivr_originate.c:3581 Originate Resulted in Success: [sofia/internal/1001@192.168.10.113:53834]
  766. 2016-12-22 14:59:10.978178 [DEBUG] switch_core_session.c:913 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  767. 2016-12-22 14:59:10.978178 [DEBUG] switch_core_session.c:913 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  768. 2016-12-22 14:59:10.978178 [DEBUG] switch_ivr_bridge.c:1473 (sofia/internal/1001@192.168.10.113:53834) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
  769. 2016-12-22 14:59:10.978178 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  770. 2016-12-22 14:59:10.978178 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1001@192.168.10.113:53834) Running State Change CS_EXCHANGE_MEDIA
  771. 2016-12-22 14:59:10.978178 [DEBUG] switch_core_state_machine.c:538 (sofia/internal/1001@192.168.10.113:53834) State EXCHANGE_MEDIA
  772. 2016-12-22 14:59:10.978178 [DEBUG] mod_sofia.c:594 SOFIA EXCHANGE_MEDIA
  773. send 802 bytes to udp/[91.142.62.148]:61807 at 14:59:10.986495:
  774.    ------------------------------------------------------------------------
  775.   INFO sip:1002@192.168.10.116:58927 SIP/2.0
  776.    Via: SIP/2.0/UDP 35.160.75.57;rport;branch=z9hG4bKaUc5tc2ygm1aF
  777.    Max-Forwards: 70
  778.    From: <sip:1001@35.160.75.57>;tag=DQ0QQ1S6DetgQ
  779.    To: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  780.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  781.   CSeq: 100873311 INFO
  782.    Contact: <sip:1001@35.160.75.57:5060;transport=udp>
  783.    User-Agent: FreeSWITCH-mod_sofia/1.4.23~64bit
  784.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  785.    Supported: timer, path, replaces
  786.    Content-Type: application/media_control+xml
  787.    Content-Length: 175
  788.    
  789.    <?xml version="1.0" encoding="utf-8" ?>
  790.    <media_control>
  791.    <vc_primitive>
  792.    <to_encoder>
  793.    <picture_fast_update>
  794.    </picture_fast_update>
  795.    </to_encoder>
  796.    </vc_primitive>
  797.    </media_control>
  798.  
  799.    ------------------------------------------------------------------------
  800. 2016-12-22 14:59:11.018225 [DEBUG] switch_core_media.c:4373 sofia/internal/1002@35.160.75.57 Video thread paused. Echo is on
  801. 2016-12-22 14:59:11.038227 [DEBUG] switch_rtp.c:5894 Correct ip/port confirmed.
  802. 2016-12-22 14:59:11.038227 [DEBUG] switch_rtp.c:5894 Correct ip/port confirmed.
  803. 2016-12-22 14:59:11.038227 [DEBUG] switch_core_media.c:4373 sofia/internal/1001@192.168.10.113:53834 Video thread paused. Echo is off
  804. recv 521 bytes from udp/[91.142.62.148]:61814 at 14:59:11.349382:
  805.    ------------------------------------------------------------------------
  806.    SIP/2.0 200 OK
  807.    Via: SIP/2.0/UDP 35.160.75.57;rport=5060;branch=z9hG4bK9HKcSHHUKBBrK;received=35.160.75.57
  808.    Contact: <sip:1001@192.168.10.113:53834>
  809.    From: "Extension 1002" <sip:1002@35.160.75.57>;tag=e0SgSvaaBQg3j
  810.    Call-ID: 07ffcba1-42fa-1235-4aab-029d80950d35
  811.   CSeq: 100873311 INFO
  812.    To: <sip:1001@192.168.10.113:53834;rinstance=B840C22E;received=91.142.62.148:61814>;tag=FE5DFD1A456A147EE3A2145487DF53FD
  813.    Allow: OPTIONS, INVITE, ACK, REFER, CANCEL, BYE, NOTIFY, MESSAGE
  814.    Supported: replaces, path
  815.    Content-Length: 0
  816.    
  817.    ------------------------------------------------------------------------
  818. 2016-12-22 14:59:11.338187 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  819. recv 348 bytes from udp/[91.142.62.148]:61807 at 14:59:11.379738:
  820.    ------------------------------------------------------------------------
  821.    ACK sip:1001@35.160.75.57:5060;transport=udp SIP/2.0
  822.    Via: SIP/2.0/UDP 192.168.10.116:58927;branch=z9hG4bKAbOzSk717AXaSyHH;rport
  823.    Max-Forwards: 70
  824.    To: <sip:1001@35.160.75.57>;tag=DQ0QQ1S6DetgQ
  825.    From: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  826.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  827.    CSeq: 2 ACK
  828.    Content-Length: 0
  829.    
  830.    ------------------------------------------------------------------------
  831. 2016-12-22 14:59:11.378191 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  832. 2016-12-22 14:59:11.378191 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  833. 2016-12-22 14:59:11.378191 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  834. 2016-12-22 14:59:11.378191 [DEBUG] sofia.c:6658 Channel sofia/internal/1002@35.160.75.57 entering state [ready][200]
  835. 2016-12-22 14:59:11.378191 [DEBUG] switch_core_session.c:979 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  836. 2016-12-22 14:59:11.378191 [DEBUG] switch_core_session.c:979 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  837. recv 452 bytes from udp/[91.142.62.148]:61807 at 14:59:11.403646:
  838.    ------------------------------------------------------------------------
  839.    SIP/2.0 200 OK
  840.    Via: SIP/2.0/UDP 35.160.75.57;rport=5060;branch=z9hG4bKaUc5tc2ygm1aF;received=35.160.75.57
  841.    Contact: <sip:1002@192.168.10.116:58927>
  842.    From: <sip:1001@35.160.75.57>;tag=DQ0QQ1S6DetgQ
  843.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  844.   CSeq: 100873311 INFO
  845.    To: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  846.    Allow: OPTIONS, INVITE, ACK, REFER, CANCEL, BYE, NOTIFY, MESSAGE
  847.    Supported: replaces, path
  848.    Content-Length: 0
  849.    
  850.    ------------------------------------------------------------------------
  851. 2016-12-22 14:59:11.398259 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  852. 2016-12-22 14:59:11.958213 [INFO] switch_rtp.c:5867 Auto Changing port from 192.168.10.113:33726 to 46.19.199.210:33726
  853. recv 556 bytes from udp/[91.142.62.148]:61814 at 14:59:11.981186:
  854.    ------------------------------------------------------------------------
  855.    REGISTER sip:35.160.75.57 SIP/2.0
  856.    Via: SIP/2.0/UDP 192.168.10.113:53834;branch=z9hG4bKwlxEfQSuT9xMptbG;rport
  857.    Contact: <sip:1001@192.168.10.113:53834;rinstance=B840C22E>;expires=600;video
  858.    Max-Forwards: 70
  859.    From: <sip:1001@35.160.75.57>;tag=7A2373838CBF988908A5247F8C3350E2
  860.    Allow: OPTIONS, INVITE, ACK, REFER, CANCEL, BYE, NOTIFY, MESSAGE
  861.    Supported: replaces, path
  862.    User-Agent: Acrobits SDK (build 0; iOS; arm64-neon)
  863.    To: <sip:1001@35.160.75.57>
  864.    Expires: 600
  865.    Call-ID: 298A4925D0727E7A0DBC5EF55270652DE8141158
  866.    CSeq: 11 REGISTER
  867.    Content-Length: 0
  868.    
  869.    ------------------------------------------------------------------------
  870. send 648 bytes to udp/[91.142.62.148]:61814 at 14:59:11.981764:
  871.    ------------------------------------------------------------------------
  872.    SIP/2.0 401 Unauthorized
  873.    Via: SIP/2.0/UDP 192.168.10.113:53834;branch=z9hG4bKwlxEfQSuT9xMptbG;rport=61814;received=91.142.62.148
  874.    From: <sip:1001@35.160.75.57>;tag=7A2373838CBF988908A5247F8C3350E2
  875.    To: <sip:1001@35.160.75.57>;tag=F9j9tQUD8Z6Ne
  876.    Call-ID: 298A4925D0727E7A0DBC5EF55270652DE8141158
  877.    CSeq: 11 REGISTER
  878.    User-Agent: FreeSWITCH-mod_sofia/1.4.23~64bit
  879.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  880.    Supported: timer, path, replaces
  881.    WWW-Authenticate: Digest realm="35.160.75.57", nonce="32b50cfe-c857-11e6-814c-fb2640f076da", algorithm=MD5, qop="auth"
  882.    Content-Length: 0
  883.    
  884.    ------------------------------------------------------------------------
  885. 2016-12-22 14:59:11.978204 [WARNING] sofia_reg.c:1758 SIP auth challenge (REGISTER) on sofia profile 'internal' for [1001@35.160.75.57] from ip 91.142.62.148
  886. recv 805 bytes from udp/[91.142.62.148]:61814 at 14:59:12.366352:
  887.    ------------------------------------------------------------------------
  888.    REGISTER sip:35.160.75.57 SIP/2.0
  889.    Via: SIP/2.0/UDP 192.168.10.113:53834;branch=z9hG4bK60RL5NU9pPPDTsa3;rport
  890.    Contact: <sip:1001@192.168.10.113:53834;rinstance=B840C22E>;expires=600;video
  891.    Max-Forwards: 70
  892.    From: <sip:1001@35.160.75.57>;tag=7A2373838CBF988908A5247F8C3350E2
  893.    Allow: OPTIONS, INVITE, ACK, REFER, CANCEL, BYE, NOTIFY, MESSAGE
  894.    Supported: replaces, path
  895.    User-Agent: Acrobits SDK (build 0; iOS; arm64-neon)
  896.    To: <sip:1001@35.160.75.57>
  897.    Expires: 600
  898.    Call-ID: 298A4925D0727E7A0DBC5EF55270652DE8141158
  899.    CSeq: 12 REGISTER
  900.    Authorization: Digest username="1001",realm="35.160.75.57",algorithm=MD5,uri="sip:35.160.75.57",nonce="32b50cfe-c857-11e6-814c-fb2640f076da",qop=auth,cnonce="8805cf792e65ee7b56282054e6049ac3",nc=00000001,response="52a32d00e5e6ce9ad6c79c3fe9180e05"
  901.    Content-Length: 0
  902.    
  903.    ------------------------------------------------------------------------
  904. send 657 bytes to udp/[91.142.62.148]:61814 at 14:59:12.367584:
  905.    ------------------------------------------------------------------------
  906.    SIP/2.0 200 OK
  907.    Via: SIP/2.0/UDP 192.168.10.113:53834;branch=z9hG4bK60RL5NU9pPPDTsa3;rport=61814;received=91.142.62.148
  908.    From: <sip:1001@35.160.75.57>;tag=7A2373838CBF988908A5247F8C3350E2
  909.    To: <sip:1001@35.160.75.57>;tag=gjc2vjcH58v8S
  910.    Call-ID: 298A4925D0727E7A0DBC5EF55270652DE8141158
  911.    CSeq: 12 REGISTER
  912.    Contact: <sip:1001@192.168.10.113:53834;rinstance=B840C22E;received=91.142.62.148:61814>;expires=600
  913.    Date: Thu, 22 Dec 2016 14:59:12 GMT
  914.    User-Agent: FreeSWITCH-mod_sofia/1.4.23~64bit
  915.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  916.    Supported: timer, path, replaces
  917.    Content-Length: 0
  918.    
  919.    ------------------------------------------------------------------------
  920. recv 731 bytes from udp/[91.142.62.148]:61807 at 14:59:24.415243:
  921.    ------------------------------------------------------------------------
  922.   INFO sip:1001@35.160.75.57:5060;transport=udp SIP/2.0
  923.    Via: SIP/2.0/UDP 192.168.10.116:58927;branch=z9hG4bKJMSXAOFFlczmwm1Y;rport
  924.    Contact: <sip:1002@192.168.10.116:58927>
  925.    Max-Forwards: 70
  926.    From: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  927.    Allow: OPTIONS, INVITE, ACK, REFER, CANCEL, BYE, NOTIFY, MESSAGE
  928.    Supported: replaces, path
  929.    User-Agent: Acrobits SDK (build 0; iOS; arm64-neon)
  930.    Content-Type: application/media_control+xml
  931.    To: <sip:1001@35.160.75.57>;tag=DQ0QQ1S6DetgQ
  932.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  933.   CSeq: 3 INFO
  934.    Content-Length: 146
  935.    
  936.    <?xml version="1.0" encoding="utf-8" ?><media_control><vc_primitive><to_encoder><picture_fast_update/></to_encoder></vc_primitive></media_control>
  937.  
  938.    ------------------------------------------------------------------------
  939. 2016-12-22 14:59:24.398190 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  940. 2016-12-22 14:59:24.418206 [DEBUG] switch_core_session.c:979 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  941. 2016-12-22 14:59:24.418206 [DEBUG] sofia.c:8784 dispatched freeswitch event for INFO
  942. send 513 bytes to udp/[91.142.62.148]:61807 at 14:59:24.423471:
  943.    ------------------------------------------------------------------------
  944.    SIP/2.0 200 OK
  945.    Via: SIP/2.0/UDP 192.168.10.116:58927;branch=z9hG4bKJMSXAOFFlczmwm1Y;rport=61807;received=91.142.62.148
  946.    From: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  947.    To: <sip:1001@35.160.75.57>;tag=DQ0QQ1S6DetgQ
  948.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  949.   CSeq: 3 INFO
  950.    User-Agent: FreeSWITCH-mod_sofia/1.4.23~64bit
  951.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  952.    Supported: timer, path, replaces
  953.    Content-Length: 0
  954.    
  955.    ------------------------------------------------------------------------
  956. send 833 bytes to udp/[91.142.62.148]:61814 at 14:59:24.423732:
  957.    ------------------------------------------------------------------------
  958.   INFO sip:1001@192.168.10.113:53834 SIP/2.0
  959.    Via: SIP/2.0/UDP 35.160.75.57;rport;branch=z9hG4bKB45Xv7j2DXQXa
  960.    Max-Forwards: 70
  961.    From: "Extension 1002" <sip:1002@35.160.75.57>;tag=e0SgSvaaBQg3j
  962.    To: <sip:1001@192.168.10.113:53834;rinstance=B840C22E;received=91.142.62.148:61814>;tag=FE5DFD1A456A147EE3A2145487DF53FD
  963.    Call-ID: 07ffcba1-42fa-1235-4aab-029d80950d35
  964.   CSeq: 100873312 INFO
  965.    Contact: <sip:mod_sofia@35.160.75.57:5060>
  966.    User-Agent: FreeSWITCH-mod_sofia/1.4.23~64bit
  967.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  968.    Supported: timer, path, replaces
  969.    Content-Type: application/media_control+xml
  970.    Content-Length: 146
  971.    
  972.    <?xml version="1.0" encoding="utf-8" ?><media_control><vc_primitive><to_encoder><picture_fast_update/></to_encoder></vc_primitive></media_control>
  973.  
  974.    ------------------------------------------------------------------------
  975. recv 521 bytes from udp/[91.142.62.148]:61814 at 14:59:24.848185:
  976.    ------------------------------------------------------------------------
  977.    SIP/2.0 200 OK
  978.    Via: SIP/2.0/UDP 35.160.75.57;rport=5060;branch=z9hG4bKB45Xv7j2DXQXa;received=35.160.75.57
  979.    Contact: <sip:1001@192.168.10.113:53834>
  980.    From: "Extension 1002" <sip:1002@35.160.75.57>;tag=e0SgSvaaBQg3j
  981.    Call-ID: 07ffcba1-42fa-1235-4aab-029d80950d35
  982.   CSeq: 100873312 INFO
  983.    To: <sip:1001@192.168.10.113:53834;rinstance=B840C22E;received=91.142.62.148:61814>;tag=FE5DFD1A456A147EE3A2145487DF53FD
  984.    Allow: OPTIONS, INVITE, ACK, REFER, CANCEL, BYE, NOTIFY, MESSAGE
  985.    Supported: replaces, path
  986.    Content-Length: 0
  987.    
  988.    ------------------------------------------------------------------------
  989. 2016-12-22 14:59:24.838204 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  990. recv 596 bytes from udp/[91.142.62.148]:61814 at 14:59:24.905798:
  991.    ------------------------------------------------------------------------
  992.    BYE sip:mod_sofia@35.160.75.57:5060 SIP/2.0
  993.    Via: SIP/2.0/UDP 192.168.10.113:53834;branch=z9hG4bKIzHlVYkgvga1ZwSq;rport
  994.    Contact: <sip:1001@192.168.10.113:53834>
  995.    Max-Forwards: 70
  996.    From: <sip:1001@192.168.10.113:53834;rinstance=B840C22E;received=91.142.62.148:61814>;tag=FE5DFD1A456A147EE3A2145487DF53FD
  997.    Allow: OPTIONS, INVITE, ACK, REFER, CANCEL, BYE, NOTIFY, MESSAGE
  998.    Supported: replaces, path
  999.    User-Agent: Acrobits SDK (build 0; iOS; arm64-neon)
  1000.    To: "Extension 1002" <sip:1002@35.160.75.57>;tag=e0SgSvaaBQg3j
  1001.    Call-ID: 07ffcba1-42fa-1235-4aab-029d80950d35
  1002.    CSeq: 1 BYE
  1003.    Content-Length: 0
  1004.    
  1005.    ------------------------------------------------------------------------
  1006. 2016-12-22 14:59:24.898188 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  1007. 2016-12-22 14:59:24.918190 [NOTICE] sofia.c:952 Hangup sofia/internal/1001@192.168.10.113:53834 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
  1008. 2016-12-22 14:59:24.918190 [DEBUG] switch_channel.c:3242 Send signal sofia/internal/1001@192.168.10.113:53834 [KILL]
  1009. 2016-12-22 14:59:24.918190 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  1010. send 581 bytes to udp/[91.142.62.148]:61814 at 14:59:24.924396:
  1011.    ------------------------------------------------------------------------
  1012.    SIP/2.0 200 OK
  1013.    Via: SIP/2.0/UDP 192.168.10.113:53834;branch=z9hG4bKIzHlVYkgvga1ZwSq;rport=61814;received=91.142.62.148
  1014.    From: <sip:1001@192.168.10.113:53834;rinstance=B840C22E;received=91.142.62.148:61814>;tag=FE5DFD1A456A147EE3A2145487DF53FD
  1015.    To: "Extension 1002" <sip:1002@35.160.75.57>;tag=e0SgSvaaBQg3j
  1016.    Call-ID: 07ffcba1-42fa-1235-4aab-029d80950d35
  1017.    CSeq: 1 BYE
  1018.    User-Agent: FreeSWITCH-mod_sofia/1.4.23~64bit
  1019.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  1020.    Supported: timer, path, replaces
  1021.    Content-Length: 0
  1022.    
  1023.    ------------------------------------------------------------------------
  1024. 2016-12-22 14:59:24.918190 [DEBUG] switch_ivr_bridge.c:602 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  1025. 2016-12-22 14:59:24.918190 [DEBUG] switch_ivr_bridge.c:603 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  1026. 2016-12-22 14:59:24.918190 [DEBUG] switch_ivr_bridge.c:604 Ending video thread.
  1027. 2016-12-22 14:59:24.918190 [DEBUG] switch_ivr_bridge.c:651 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  1028. 2016-12-22 14:59:24.918190 [DEBUG] switch_ivr_bridge.c:652 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  1029. 2016-12-22 14:59:24.918190 [DEBUG] switch_ivr_bridge.c:654 Ending video thread.
  1030. 2016-12-22 14:59:24.918190 [DEBUG] switch_ivr_bridge.c:99 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  1031. 2016-12-22 14:59:24.918190 [DEBUG] switch_ivr_bridge.c:100 sofia/internal/1001@192.168.10.113:53834 video thread ended.
  1032. 2016-12-22 14:59:24.918190 [DEBUG] switch_core_session.c:2906 sofia/internal/1001@192.168.10.113:53834 skip receive message [VIDEO_REFRESH_REQ] (channel is hungup already)
  1033. send 802 bytes to udp/[91.142.62.148]:61807 at 14:59:24.924990:
  1034.    ------------------------------------------------------------------------
  1035.   INFO sip:1002@192.168.10.116:58927 SIP/2.0
  1036.    Via: SIP/2.0/UDP 35.160.75.57;rport;branch=z9hG4bKcDZpy235a6Dgp
  1037.    Max-Forwards: 70
  1038.    From: <sip:1001@35.160.75.57>;tag=DQ0QQ1S6DetgQ
  1039.    To: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  1040.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  1041.   CSeq: 100873312 INFO
  1042.    Contact: <sip:1001@35.160.75.57:5060;transport=udp>
  1043.    User-Agent: FreeSWITCH-mod_sofia/1.4.23~64bit
  1044.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  1045.    Supported: timer, path, replaces
  1046.    Content-Type: application/media_control+xml
  1047.    Content-Length: 175
  1048.    
  1049.    <?xml version="1.0" encoding="utf-8" ?>
  1050.    <media_control>
  1051.    <vc_primitive>
  1052.    <to_encoder>
  1053.    <picture_fast_update>
  1054.    </picture_fast_update>
  1055.    </to_encoder>
  1056.    </vc_primitive>
  1057.    </media_control>
  1058.  
  1059.    ------------------------------------------------------------------------
  1060. 2016-12-22 14:59:24.918190 [DEBUG] switch_core_media.c:4376 sofia/internal/1001@192.168.10.113:53834 Video thread resumed  Echo is off
  1061. 2016-12-22 14:59:24.918190 [DEBUG] switch_core_session.c:2906 sofia/internal/1001@192.168.10.113:53834 skip receive message [VIDEO_REFRESH_REQ] (channel is hungup already)
  1062. 2016-12-22 14:59:24.918190 [DEBUG] switch_ivr_bridge.c:665 BRIDGE THREAD DONE [sofia/internal/1001@192.168.10.113:53834]
  1063. 2016-12-22 14:59:24.918190 [DEBUG] switch_ivr_bridge.c:695 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  1064. 2016-12-22 14:59:24.918190 [DEBUG] switch_core_state_machine.c:538 (sofia/internal/1001@192.168.10.113:53834) State EXCHANGE_MEDIA going to sleep
  1065. 2016-12-22 14:59:24.918190 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1001@192.168.10.113:53834) Running State Change CS_HANGUP
  1066. 2016-12-22 14:59:24.918190 [DEBUG] switch_core_state_machine.c:735 (sofia/internal/1001@192.168.10.113:53834) Callstate Change ACTIVE -> HANGUP
  1067. 2016-12-22 14:59:24.918190 [DEBUG] switch_core_state_machine.c:737 (sofia/internal/1001@192.168.10.113:53834) State HANGUP
  1068. 2016-12-22 14:59:24.918190 [DEBUG] switch_core_session.c:2906 sofia/internal/1001@192.168.10.113:53834 skip receive message [VIDEO_REFRESH_REQ] (channel is hungup already)
  1069. 2016-12-22 14:59:24.918190 [DEBUG] mod_sofia.c:413 Channel sofia/internal/1001@192.168.10.113:53834 hanging up, cause: NORMAL_CLEARING
  1070. 2016-12-22 14:59:24.918190 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1001@192.168.10.113:53834 Standard HANGUP, cause: NORMAL_CLEARING
  1071. 2016-12-22 14:59:24.918190 [DEBUG] switch_core_state_machine.c:737 (sofia/internal/1001@192.168.10.113:53834) State HANGUP going to sleep
  1072. 2016-12-22 14:59:24.918190 [DEBUG] switch_core_state_machine.c:504 (sofia/internal/1001@192.168.10.113:53834) State Change CS_HANGUP -> CS_REPORTING
  1073. 2016-12-22 14:59:24.918190 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  1074. 2016-12-22 14:59:24.918190 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1001@192.168.10.113:53834) Running State Change CS_REPORTING
  1075. 2016-12-22 14:59:24.918190 [DEBUG] switch_core_state_machine.c:823 (sofia/internal/1001@192.168.10.113:53834) State REPORTING
  1076. 2016-12-22 14:59:24.918190 [DEBUG] switch_core_session.c:2906 sofia/internal/1001@192.168.10.113:53834 skip receive message [VIDEO_REFRESH_REQ] (channel is hungup already)
  1077. 2016-12-22 14:59:24.918190 [DEBUG] switch_core_state_machine.c:104 sofia/internal/1001@192.168.10.113:53834 Standard REPORTING, cause: NORMAL_CLEARING
  1078. 2016-12-22 14:59:24.918190 [DEBUG] switch_core_state_machine.c:823 (sofia/internal/1001@192.168.10.113:53834) State REPORTING going to sleep
  1079. 2016-12-22 14:59:24.918190 [DEBUG] switch_core_state_machine.c:498 (sofia/internal/1001@192.168.10.113:53834) State Change CS_REPORTING -> CS_DESTROY
  1080. 2016-12-22 14:59:24.918190 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  1081. 2016-12-22 14:59:24.918190 [DEBUG] switch_core_session.c:1624 Session 9 (sofia/internal/1001@192.168.10.113:53834) Locked, Waiting on external entities
  1082. 2016-12-22 14:59:24.918190 [DEBUG] switch_core_media.c:4415 sofia/internal/1001@192.168.10.113:53834 Video thread ended
  1083. 2016-12-22 14:59:24.938194 [DEBUG] switch_ivr_bridge.c:584 sofia/internal/1001@192.168.10.113:53834 ending bridge by request from write function
  1084. 2016-12-22 14:59:24.938194 [DEBUG] switch_ivr_bridge.c:602 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  1085. 2016-12-22 14:59:24.938194 [DEBUG] switch_ivr_bridge.c:603 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  1086. 2016-12-22 14:59:24.938194 [DEBUG] switch_ivr_bridge.c:604 Ending video thread.
  1087. 2016-12-22 14:59:24.938194 [DEBUG] switch_ivr_bridge.c:651 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  1088. 2016-12-22 14:59:24.938194 [DEBUG] switch_ivr_bridge.c:652 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  1089. 2016-12-22 14:59:24.938194 [DEBUG] switch_ivr_bridge.c:654 Ending video thread.
  1090. 2016-12-22 14:59:24.958191 [DEBUG] switch_ivr_bridge.c:99 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  1091. 2016-12-22 14:59:24.958191 [DEBUG] switch_ivr_bridge.c:100 sofia/internal/1002@35.160.75.57 video thread ended.
  1092. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_media.c:4376 sofia/internal/1002@35.160.75.57 Video thread resumed  Echo is on
  1093. 2016-12-22 14:59:24.958191 [DEBUG] switch_ivr_bridge.c:665 BRIDGE THREAD DONE [sofia/internal/1002@35.160.75.57]
  1094. 2016-12-22 14:59:24.958191 [DEBUG] switch_ivr_bridge.c:695 Send signal sofia/internal/1001@192.168.10.113:53834 [BREAK]
  1095. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_session.c:913 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  1096. 2016-12-22 14:59:24.958191 [NOTICE] switch_ivr_bridge.c:1616 Hangup sofia/internal/1002@35.160.75.57 [CS_EXECUTE] [NORMAL_CLEARING]
  1097. 2016-12-22 14:59:24.958191 [DEBUG] switch_channel.c:3242 Send signal sofia/internal/1002@35.160.75.57 [KILL]
  1098. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  1099. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_session.c:2767 sofia/internal/1002@35.160.75.57 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  1100. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_state_machine.c:535 (sofia/internal/1002@35.160.75.57) State EXECUTE going to sleep
  1101. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1002@35.160.75.57) Running State Change CS_HANGUP
  1102. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_state_machine.c:735 (sofia/internal/1002@35.160.75.57) Callstate Change ACTIVE -> HANGUP
  1103. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_state_machine.c:737 (sofia/internal/1002@35.160.75.57) State HANGUP
  1104. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_session.c:2906 sofia/internal/1002@35.160.75.57 skip receive message [VIDEO_REFRESH_REQ] (channel is hungup already)
  1105. 2016-12-22 14:59:24.958191 [DEBUG] mod_sofia.c:407 sofia/internal/1002@35.160.75.57 Overriding SIP cause 480 with 200 from the other leg
  1106. 2016-12-22 14:59:24.958191 [DEBUG] mod_sofia.c:413 Channel sofia/internal/1002@35.160.75.57 hanging up, cause: NORMAL_CLEARING
  1107. 2016-12-22 14:59:24.958191 [DEBUG] mod_sofia.c:465 Sending BYE to sofia/internal/1002@35.160.75.57
  1108. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1002@35.160.75.57 Standard HANGUP, cause: NORMAL_CLEARING
  1109. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_state_machine.c:737 (sofia/internal/1002@35.160.75.57) State HANGUP going to sleep
  1110. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_state_machine.c:504 (sofia/internal/1002@35.160.75.57) State Change CS_HANGUP -> CS_REPORTING
  1111. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  1112. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1002@35.160.75.57) Running State Change CS_REPORTING
  1113. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_state_machine.c:823 (sofia/internal/1002@35.160.75.57) State REPORTING
  1114. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_session.c:2906 sofia/internal/1002@35.160.75.57 skip receive message [VIDEO_REFRESH_REQ] (channel is hungup already)
  1115. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_state_machine.c:104 sofia/internal/1002@35.160.75.57 Standard REPORTING, cause: NORMAL_CLEARING
  1116. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_state_machine.c:823 (sofia/internal/1002@35.160.75.57) State REPORTING going to sleep
  1117. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_state_machine.c:498 (sofia/internal/1002@35.160.75.57) State Change CS_REPORTING -> CS_DESTROY
  1118. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/1002@35.160.75.57 [BREAK]
  1119. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_session.c:1624 Session 8 (sofia/internal/1002@35.160.75.57) Locked, Waiting on external entities
  1120. 2016-12-22 14:59:24.958191 [NOTICE] switch_core_session.c:1642 Session 9 (sofia/internal/1001@192.168.10.113:53834) Ended
  1121. 2016-12-22 14:59:24.958191 [NOTICE] switch_core_session.c:1646 Close Channel sofia/internal/1001@192.168.10.113:53834 [CS_DESTROY]
  1122. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_state_machine.c:626 (sofia/internal/1001@192.168.10.113:53834) Running State Change CS_DESTROY
  1123. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_state_machine.c:636 (sofia/internal/1001@192.168.10.113:53834) State DESTROY
  1124. 2016-12-22 14:59:24.958191 [DEBUG] mod_sofia.c:323 sofia/internal/1001@192.168.10.113:53834 SOFIA DESTROY
  1125. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_state_machine.c:111 sofia/internal/1001@192.168.10.113:53834 Standard DESTROY
  1126. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_state_machine.c:636 (sofia/internal/1001@192.168.10.113:53834) State DESTROY going to sleep
  1127. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_media.c:4415 sofia/internal/1002@35.160.75.57 Video thread ended
  1128. 2016-12-22 14:59:24.958191 [NOTICE] switch_core_session.c:1642 Session 8 (sofia/internal/1002@35.160.75.57) Ended
  1129. 2016-12-22 14:59:24.958191 [NOTICE] switch_core_session.c:1646 Close Channel sofia/internal/1002@35.160.75.57 [CS_DESTROY]
  1130. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_state_machine.c:626 (sofia/internal/1002@35.160.75.57) Running State Change CS_DESTROY
  1131. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_state_machine.c:636 (sofia/internal/1002@35.160.75.57) State DESTROY
  1132. 2016-12-22 14:59:24.958191 [DEBUG] mod_sofia.c:323 sofia/internal/1002@35.160.75.57 SOFIA DESTROY
  1133. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_state_machine.c:111 sofia/internal/1002@35.160.75.57 Standard DESTROY
  1134. 2016-12-22 14:59:24.958191 [DEBUG] switch_core_state_machine.c:636 (sofia/internal/1002@35.160.75.57) State DESTROY going to sleep
  1135. recv 536 bytes from udp/[91.142.62.148]:61807 at 14:59:25.683221:
  1136.    ------------------------------------------------------------------------
  1137.    BYE sip:1001@35.160.75.57:5060;transport=udp SIP/2.0
  1138.    Via: SIP/2.0/UDP 192.168.10.116:58927;branch=z9hG4bKA3UU3bQyBLb5I5j8;rport
  1139.    Contact: <sip:1002@192.168.10.116:58927>
  1140.    Max-Forwards: 70
  1141.    From: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  1142.    Allow: OPTIONS, INVITE, ACK, REFER, CANCEL, BYE, NOTIFY, MESSAGE
  1143.    Supported: replaces, path
  1144.    User-Agent: Acrobits SDK (build 0; iOS; arm64-neon)
  1145.    To: <sip:1001@35.160.75.57>;tag=DQ0QQ1S6DetgQ
  1146.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  1147.    CSeq: 4 BYE
  1148.    Content-Length: 0
  1149.    
  1150.    ------------------------------------------------------------------------
  1151. send 802 bytes to udp/[91.142.62.148]:61807 at 14:59:25.924928:
  1152.    ------------------------------------------------------------------------
  1153.   INFO sip:1002@192.168.10.116:58927 SIP/2.0
  1154.    Via: SIP/2.0/UDP 35.160.75.57;rport;branch=z9hG4bKcDZpy235a6Dgp
  1155.    Max-Forwards: 70
  1156.    From: <sip:1001@35.160.75.57>;tag=DQ0QQ1S6DetgQ
  1157.    To: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  1158.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  1159.   CSeq: 100873312 INFO
  1160.    Contact: <sip:1001@35.160.75.57:5060;transport=udp>
  1161.    User-Agent: FreeSWITCH-mod_sofia/1.4.23~64bit
  1162.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  1163.    Supported: timer, path, replaces
  1164.    Content-Type: application/media_control+xml
  1165.    Content-Length: 175
  1166.    
  1167.    <?xml version="1.0" encoding="utf-8" ?>
  1168.    <media_control>
  1169.    <vc_primitive>
  1170.    <to_encoder>
  1171.    <picture_fast_update>
  1172.    </picture_fast_update>
  1173.    </to_encoder>
  1174.    </vc_primitive>
  1175.    </media_control>
  1176.  
  1177.    ------------------------------------------------------------------------
  1178. recv 469 bytes from udp/[91.142.62.148]:61807 at 14:59:27.415716:
  1179.    ------------------------------------------------------------------------
  1180.    SIP/2.0 481 Call Does Not Exist
  1181.    Via: SIP/2.0/UDP 35.160.75.57;rport=5060;branch=z9hG4bKcDZpy235a6Dgp;received=35.160.75.57
  1182.    Contact: <sip:1002@192.168.10.116:58927>
  1183.    From: <sip:1001@35.160.75.57>;tag=DQ0QQ1S6DetgQ
  1184.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  1185.   CSeq: 100873312 INFO
  1186.    To: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  1187.    Allow: OPTIONS, INVITE, ACK, REFER, CANCEL, BYE, NOTIFY, MESSAGE
  1188.    Supported: replaces, path
  1189.    Content-Length: 0
  1190.    
  1191.    ------------------------------------------------------------------------
  1192. send 572 bytes to udp/[91.142.62.148]:61807 at 14:59:27.415936:
  1193.    ------------------------------------------------------------------------
  1194.    BYE sip:1002@192.168.10.116:58927 SIP/2.0
  1195.    Via: SIP/2.0/UDP 35.160.75.57;rport;branch=z9hG4bKDprF0Xm97e42H
  1196.    Max-Forwards: 70
  1197.    From: <sip:1001@35.160.75.57>;tag=DQ0QQ1S6DetgQ
  1198.    To: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  1199.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  1200.    CSeq: 100873313 BYE
  1201.    User-Agent: FreeSWITCH-mod_sofia/1.4.23~64bit
  1202.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  1203.    Supported: timer, path, replaces
  1204.    Reason: Q.850;cause=16;text="NORMAL_CLEARING"
  1205.    Content-Length: 0
  1206.    
  1207.    ------------------------------------------------------------------------
  1208. recv 536 bytes from udp/[91.142.62.148]:61807 at 14:59:27.649741:
  1209.    ------------------------------------------------------------------------
  1210.    BYE sip:1001@35.160.75.57:5060;transport=udp SIP/2.0
  1211.    Via: SIP/2.0/UDP 192.168.10.116:58927;branch=z9hG4bKA3UU3bQyBLb5I5j8;rport
  1212.    Contact: <sip:1002@192.168.10.116:58927>
  1213.    Max-Forwards: 70
  1214.    From: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  1215.    Allow: OPTIONS, INVITE, ACK, REFER, CANCEL, BYE, NOTIFY, MESSAGE
  1216.    Supported: replaces, path
  1217.    User-Agent: Acrobits SDK (build 0; iOS; arm64-neon)
  1218.    To: <sip:1001@35.160.75.57>;tag=DQ0QQ1S6DetgQ
  1219.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  1220.    CSeq: 4 BYE
  1221.    Content-Length: 0
  1222.    
  1223.    ------------------------------------------------------------------------
  1224. recv 451 bytes from udp/[91.142.62.148]:61807 at 14:59:27.861682:
  1225.    ------------------------------------------------------------------------
  1226.    SIP/2.0 200 OK
  1227.    Via: SIP/2.0/UDP 35.160.75.57;rport=5060;branch=z9hG4bKDprF0Xm97e42H;received=35.160.75.57
  1228.    Contact: <sip:1002@192.168.10.116:58927>
  1229.    From: <sip:1001@35.160.75.57>;tag=DQ0QQ1S6DetgQ
  1230.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  1231.    CSeq: 100873313 BYE
  1232.    To: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  1233.    Allow: OPTIONS, INVITE, ACK, REFER, CANCEL, BYE, NOTIFY, MESSAGE
  1234.    Supported: replaces, path
  1235.    Content-Length: 0
  1236.    
  1237.    ------------------------------------------------------------------------
  1238. send 321 bytes to udp/[91.142.62.148]:61807 at 14:59:27.861988:
  1239.    ------------------------------------------------------------------------
  1240.    SIP/2.0 200 OK
  1241.    Via: SIP/2.0/UDP 192.168.10.116:58927;branch=z9hG4bKA3UU3bQyBLb5I5j8;rport=61807;received=91.142.62.148
  1242.    From: <sip:1002@35.160.75.57>;tag=92531864719D9D5229855C1EA95219C2
  1243.    To: <sip:1001@35.160.75.57>;tag=DQ0QQ1S6DetgQ
  1244.    Call-ID: 14E5E54EF64EF3F74FF5B59F2EB87654D281A738
  1245.    CSeq: 4 BYE
  1246.    Content-Length: 0
  1247.    
  1248.    ------------------------------------------------------------------------