From shashi kumar, 6 Years ago, written in FreeSWITCH.
- go back
Embed
Viewing differences between and Bria call log Audio to VIdeo Upgrade
  1. recv 956 bytes from udp/[106.76.208.110]:49663 at 17:51:22.661661:
  2.    ------------------------------------------------------------------------
  3.    INVITE sip:1000@icc-tech.com:5020 SIP/2.0
  4.    Via: SIP/2.0/UDP 100.67.7.149:49663;branch=z9hG4bK-524287-1---fea7e85e3d7ad879;rport
  5.    Max-Forwards: 70
  6.    Contact: <sip:1003@106.76.208.110:49663;rinstance=c68d10a466e6eed9>
  7.    To: <sip:1000@icc-tech.com:5020>
  8.    From: "Brian West"<sip:1003@icc-tech.com:5020>;tag=cfc94962
  9.    Call-ID: ZGRiN2M4Mjk1NDI0OTIxYTQ2ODRmY2MwZTE4YTFkMDY
  10.    CSeq: 1 INVITE
  11.   Allow: INVITE, ACK, CANCEL, BYE, REFER, INFO, NOTIFY, OPTIONS, UPDATE, PRACK, MESSAGE, SUBSCRIBE
  12.    Content-Type: application/sdp
  13.    Supported: replaces, 100rel
  14.    User-Agent: Bria Stretto iOS release 5.2.4001 stamp 41079.41081
  15.    Content-Length: 329
  16.  
  17.    v=0
  18.    o=- 1525974679157578 1 IN IP4 100.67.7.149
  19.    s=Cpc session
  20.    c=IN IP4 100.67.7.149
  21.    t=0 0
  22.    m=audio 64218 RTP/AVP 120 18 0 8 101
  23.    a=rtpmap:120 opus/48000/2
  24.    a=fmtp:120 useinbandfec=1; usedtx=1; maxaveragebitrate=64000
  25.    a=rtpmap:18 G729/8000
  26.    a=fmtp:18 annexb=no
  27.    a=rtpmap:101 telephone-event/8000
  28.    a=fmtp:101 0-15
  29.    a=sendrecv
  30.    ------------------------------------------------------------------------
  31. 2018-05-10 17:51:22.658062 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/1003@icc-tech.com:5020 [a7df158e-bc42-40d2-b61a-f366749fbaf6]
  32. 2018-05-10 17:51:22.658062 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1003@icc-tech.com:5020) Running State Change CS_NEW (Cur 1 Tot 30)
  33. 2018-05-10 17:51:22.658062 [DEBUG] sofia.c:10080 sofia/internal/1003@icc-tech.com:5020 receiving invite from 106.76.208.110:49663 version: 1.9.0 git a139bbd 2018-05-09 16:08:24Z 64bit
  34. 2018-05-10 17:51:22.658062 [DEBUG] sofia.c:10251 IP 106.76.208.110 Rejected by acl "domains". Falling back to Digest auth.
  35. send 903 bytes to udp/[106.76.208.110]:49663 at 17:51:22.662994:
  36.    ------------------------------------------------------------------------
  37.    SIP/2.0 407 Proxy Authentication Required
  38.    Via: SIP/2.0/UDP 100.67.7.149:49663;branch=z9hG4bK-524287-1---fea7e85e3d7ad879;rport=49663;received=106.76.208.110
  39.    From: "Brian West"<sip:1003@icc-tech.com:5020>;tag=cfc94962
  40.    To: <sip:1000@icc-tech.com:5020>;tag=Ue2UaSr7yHKFe
  41.    Call-ID: ZGRiN2M4Mjk1NDI0OTIxYTQ2ODRmY2MwZTE4YTFkMDY
  42.    CSeq: 1 INVITE
  43.    User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20180509T160824Z~a139bbd195~64bit
  44.    Accept: application/sdp
  45.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  46.    Supported: timer, path, replaces
  47.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  48.    Proxy-Authenticate: Digest realm="icc-tech.com", nonce="b9660709-36c8-45de-a71c-99d8337a0f0a", algorithm=MD5, qop="auth"
  49.    Content-Length: 0
  50.  
  51.    ------------------------------------------------------------------------
  52. 2018-05-10 17:51:22.658062 [DEBUG] sofia.c:2413 detaching session a7df158e-bc42-40d2-b61a-f366749fbaf6
  53. 2018-05-10 17:51:22.658062 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/1003@icc-tech.com:5020) State NEW
  54. recv 956 bytes from udp/[106.76.208.110]:49663 at 17:51:22.762128:
  55.    ------------------------------------------------------------------------
  56.    INVITE sip:1000@icc-tech.com:5020 SIP/2.0
  57.    Via: SIP/2.0/UDP 100.67.7.149:49663;branch=z9hG4bK-524287-1---fea7e85e3d7ad879;rport
  58.    Max-Forwards: 70
  59.    Contact: <sip:1003@106.76.208.110:49663;rinstance=c68d10a466e6eed9>
  60.    To: <sip:1000@icc-tech.com:5020>
  61.    From: "Brian West"<sip:1003@icc-tech.com:5020>;tag=cfc94962
  62.    Call-ID: ZGRiN2M4Mjk1NDI0OTIxYTQ2ODRmY2MwZTE4YTFkMDY
  63.    CSeq: 1 INVITE
  64.   Allow: INVITE, ACK, CANCEL, BYE, REFER, INFO, NOTIFY, OPTIONS, UPDATE, PRACK, MESSAGE, SUBSCRIBE
  65.    Content-Type: application/sdp
  66.    Supported: replaces, 100rel
  67.    User-Agent: Bria Stretto iOS release 5.2.4001 stamp 41079.41081
  68.    Content-Length: 329
  69.  
  70.    v=0
  71.    o=- 1525974679157578 1 IN IP4 100.67.7.149
  72.    s=Cpc session
  73.    c=IN IP4 100.67.7.149
  74.    t=0 0
  75.    m=audio 64218 RTP/AVP 120 18 0 8 101
  76.    a=rtpmap:120 opus/48000/2
  77.    a=fmtp:120 useinbandfec=1; usedtx=1; maxaveragebitrate=64000
  78.    a=rtpmap:18 G729/8000
  79.    a=fmtp:18 annexb=no
  80.    a=rtpmap:101 telephone-event/8000
  81.    a=fmtp:101 0-15
  82.    a=sendrecv
  83.    ------------------------------------------------------------------------
  84. send 903 bytes to udp/[106.76.208.110]:49663 at 17:51:22.762324:
  85.    ------------------------------------------------------------------------
  86.    SIP/2.0 407 Proxy Authentication Required
  87.    Via: SIP/2.0/UDP 100.67.7.149:49663;branch=z9hG4bK-524287-1---fea7e85e3d7ad879;rport=49663;received=106.76.208.110
  88.    From: "Brian West"<sip:1003@icc-tech.com:5020>;tag=cfc94962
  89.    To: <sip:1000@icc-tech.com:5020>;tag=Ue2UaSr7yHKFe
  90.    Call-ID: ZGRiN2M4Mjk1NDI0OTIxYTQ2ODRmY2MwZTE4YTFkMDY
  91.    CSeq: 1 INVITE
  92.    User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20180509T160824Z~a139bbd195~64bit
  93.    Accept: application/sdp
  94.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  95.    Supported: timer, path, replaces
  96.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  97.    Proxy-Authenticate: Digest realm="icc-tech.com", nonce="b9660709-36c8-45de-a71c-99d8337a0f0a", algorithm=MD5, qop="auth"
  98.    Content-Length: 0
  99.  
  100.    ------------------------------------------------------------------------
  101. recv 345 bytes from udp/[106.76.208.110]:49663 at 17:51:22.821412:
  102.    ------------------------------------------------------------------------
  103.    ACK sip:1000@icc-tech.com:5020 SIP/2.0
  104.    Via: SIP/2.0/UDP 100.67.7.149:49663;branch=z9hG4bK-524287-1---fea7e85e3d7ad879;rport
  105.    Max-Forwards: 70
  106.    To: <sip:1000@icc-tech.com:5020>;tag=Ue2UaSr7yHKFe
  107.    From: "Brian West"<sip:1003@icc-tech.com:5020>;tag=cfc94962
  108.    Call-ID: ZGRiN2M4Mjk1NDI0OTIxYTQ2ODRmY2MwZTE4YTFkMDY
  109.    CSeq: 1 ACK
  110.    Content-Length: 0
  111.  
  112.    ------------------------------------------------------------------------
  113. recv 345 bytes from udp/[106.76.208.110]:49663 at 17:51:22.991311:
  114.    ------------------------------------------------------------------------
  115.    ACK sip:1000@icc-tech.com:5020 SIP/2.0
  116.    Via: SIP/2.0/UDP 100.67.7.149:49663;branch=z9hG4bK-524287-1---fea7e85e3d7ad879;rport
  117.    Max-Forwards: 70
  118.    To: <sip:1000@icc-tech.com:5020>;tag=Ue2UaSr7yHKFe
  119.    From: "Brian West"<sip:1003@icc-tech.com:5020>;tag=cfc94962
  120.    Call-ID: ZGRiN2M4Mjk1NDI0OTIxYTQ2ODRmY2MwZTE4YTFkMDY
  121.    CSeq: 1 ACK
  122.    Content-Length: 0
  123.  
  124.    ------------------------------------------------------------------------
  125. recv 1221 bytes from udp/[106.76.208.110]:49663 at 17:51:23.081564:
  126.    ------------------------------------------------------------------------
  127.    INVITE sip:1000@icc-tech.com:5020 SIP/2.0
  128.    Via: SIP/2.0/UDP 100.67.7.149:49663;branch=z9hG4bK-524287-1---8332b03d7907781a;rport
  129.    Max-Forwards: 70
  130.    Contact: <sip:1003@106.76.208.110:49663;rinstance=c68d10a466e6eed9>
  131.    To: <sip:1000@icc-tech.com:5020>
  132.    From: "Brian West"<sip:1003@icc-tech.com:5020>;tag=cfc94962
  133.    Call-ID: ZGRiN2M4Mjk1NDI0OTIxYTQ2ODRmY2MwZTE4YTFkMDY
  134.    CSeq: 2 INVITE
  135.   Allow: INVITE, ACK, CANCEL, BYE, REFER, INFO, NOTIFY, OPTIONS, UPDATE, PRACK, MESSAGE, SUBSCRIBE
  136.    Content-Type: application/sdp
  137.    Proxy-Authorization: Digest username="1003",realm="icc-tech.com",nonce="b9660709-36c8-45de-a71c-99d8337a0f0a",uri="sip:1000@icc-tech.com:5020",response="311c3acbbc374665bfc18dfe228f8fdb",cnonce="3074b2c0f27705e21e58561406cc9148",nc=00000001,qop=auth,algorithm=MD5
  138.    Supported: replaces, 100rel
  139.    User-Agent: Bria Stretto iOS release 5.2.4001 stamp 41079.41081
  140.    Content-Length: 329
  141.  
  142.    v=0
  143.    o=- 1525974679157578 1 IN IP4 100.67.7.149
  144.    s=Cpc session
  145.    c=IN IP4 100.67.7.149
  146.    t=0 0
  147.    m=audio 64218 RTP/AVP 120 18 0 8 101
  148.    a=rtpmap:120 opus/48000/2
  149.    a=fmtp:120 useinbandfec=1; usedtx=1; maxaveragebitrate=64000
  150.    a=rtpmap:18 G729/8000
  151.    a=fmtp:18 annexb=no
  152.    a=rtpmap:101 telephone-event/8000
  153.    a=fmtp:101 0-15
  154.    a=sendrecv
  155.    ------------------------------------------------------------------------
  156. 2018-05-10 17:51:23.078072 [DEBUG] sofia.c:2522 Re-attaching to session a7df158e-bc42-40d2-b61a-f366749fbaf6
  157. 2018-05-10 17:51:23.078072 [DEBUG] sofia.c:10080 sofia/internal/1003@icc-tech.com:5020 receiving invite from 106.76.208.110:49663 version: 1.9.0 git a139bbd 2018-05-09 16:08:24Z 64bit
  158. 2018-05-10 17:51:23.078072 [DEBUG] sofia.c:10251 IP 106.76.208.110 Rejected by acl "domains". Falling back to Digest auth.
  159. 2018-05-10 17:51:23.078072 [DEBUG] sofia.c:11388 Setting NAT mode based on nat.auto
  160. 2018-05-10 17:51:23.078072 [DEBUG] sofia.c:7291 Channel sofia/internal/1003@icc-tech.com:5020 entering state [received][100]
  161. 2018-05-10 17:51:23.078072 [DEBUG] sofia.c:7301 Remote SDP:
  162. v=0
  163. o=- 1525974679157578 1 IN IP4 100.67.7.149
  164. s=Cpc session
  165. c=IN IP4 100.67.7.149
  166. t=0 0
  167. m=audio 64218 RTP/AVP 120 18 0 8 101
  168. a=rtpmap:120 opus/48000/2
  169. a=fmtp:120 useinbandfec=1; usedtx=1; maxaveragebitrate=64000
  170. a=rtpmap:18 G729/8000
  171. a=fmtp:18 annexb=no
  172. a=rtpmap:101 telephone-event/8000
  173. a=fmtp:101 0-15
  174.  
  175. 2018-05-10 17:51:23.078072 [DEBUG] sofia.c:7695 (sofia/internal/1003@icc-tech.com:5020) State Change CS_NEW -> CS_INIT
  176. 2018-05-10 17:51:23.078072 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1003@icc-tech.com:5020) Running State Change CS_INIT (Cur 1 Tot 30)
  177. 2018-05-10 17:51:23.078072 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1003@icc-tech.com:5020) State INIT
  178. 2018-05-10 17:51:23.078072 [DEBUG] mod_sofia.c:93 sofia/internal/1003@icc-tech.com:5020 SOFIA INIT
  179. 2018-05-10 17:51:23.078072 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1003@icc-tech.com:5020 Standard INIT
  180. 2018-05-10 17:51:23.078072 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1003@icc-tech.com:5020) State Change CS_INIT -> CS_ROUTING
  181. 2018-05-10 17:51:23.078072 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1003@icc-tech.com:5020) State INIT going to sleep
  182. 2018-05-10 17:51:23.078072 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1003@icc-tech.com:5020) Running State Change CS_ROUTING (Cur 1 Tot 30)
  183. 2018-05-10 17:51:23.078072 [DEBUG] switch_channel.c:2249 (sofia/internal/1003@icc-tech.com:5020) Callstate Change DOWN -> RINGING
  184. 2018-05-10 17:51:23.078072 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1003@icc-tech.com:5020) State ROUTING
  185. send 400 bytes to udp/[106.76.208.110]:49663 at 17:51:23.086652:
  186.    ------------------------------------------------------------------------
  187.    SIP/2.0 100 Trying
  188.    Via: SIP/2.0/UDP 100.67.7.149:49663;branch=z9hG4bK-524287-1---8332b03d7907781a;rport=49663;received=106.76.208.110
  189.    From: "Brian West"<sip:1003@icc-tech.com:5020>;tag=cfc94962
  190.    To: <sip:1000@icc-tech.com:5020>
  191.    Call-ID: ZGRiN2M4Mjk1NDI0OTIxYTQ2ODRmY2MwZTE4YTFkMDY
  192.    CSeq: 2 INVITE
  193.    User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20180509T160824Z~a139bbd195~64bit
  194.    Content-Length: 0
  195.  
  196.    ------------------------------------------------------------------------
  197. 2018-05-10 17:51:23.078072 [DEBUG] mod_sofia.c:154 sofia/internal/1003@icc-tech.com:5020 SOFIA ROUTING
  198. 2018-05-10 17:51:23.078072 [DEBUG] switch_core_state_machine.c:236 sofia/internal/1003@icc-tech.com:5020 Standard ROUTING
  199. 2018-05-10 17:51:23.078072 [INFO] mod_dialplan_xml.c:637 Processing Brian West <1003>->1000 in context default
  200. Dialplan: sofia/internal/1003@icc-tech.com:5020 parsing [default->unloop] continue=false
  201. Dialplan: sofia/internal/1003@icc-tech.com:5020 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
  202. Dialplan: sofia/internal/1003@icc-tech.com:5020 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
  203. Dialplan: sofia/internal/1003@icc-tech.com:5020 parsing [default->tod_example] continue=true
  204. Dialplan: sofia/internal/1003@icc-tech.com:5020 Date/Time Match (PASS) [tod_example] break=on-false
  205. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action set(open=true)
  206. Dialplan: sofia/internal/1003@icc-tech.com:5020 parsing [default->holiday_example] continue=true
  207. Dialplan: sofia/internal/1003@icc-tech.com:5020 Date/TimeMatch (FAIL) [holiday_example] break=on-false
  208. Dialplan: sofia/internal/1003@icc-tech.com:5020 parsing [default->global-intercept] continue=false
  209. Dialplan: sofia/internal/1003@icc-tech.com:5020 Regex (FAIL) [global-intercept] destination_number(1000) =~ /^886$/ break=on-false
  210. Dialplan: sofia/internal/1003@icc-tech.com:5020 parsing [default->group-intercept] continue=false
  211. Dialplan: sofia/internal/1003@icc-tech.com:5020 Regex (FAIL) [group-intercept] destination_number(1000) =~ /^\*8$/ break=on-false
  212. Dialplan: sofia/internal/1003@icc-tech.com:5020 parsing [default->intercept-ext] continue=false
  213. Dialplan: sofia/internal/1003@icc-tech.com:5020 Regex (FAIL) [intercept-ext] destination_number(1000) =~ /^\*\*(\d+)$/ break=on-false
  214. Dialplan: sofia/internal/1003@icc-tech.com:5020 parsing [default->redial] continue=false
  215. Dialplan: sofia/internal/1003@icc-tech.com:5020 Regex (FAIL) [redial] destination_number(1000) =~ /^(redial|870)$/ break=on-false
  216. Dialplan: sofia/internal/1003@icc-tech.com:5020 parsing [default->global] continue=true
  217. Dialplan: sofia/internal/1003@icc-tech.com:5020 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never
  218. Dialplan: sofia/internal/1003@icc-tech.com:5020 Regex (FAIL) [global] ${default_password}(12345) =~ /^1234$/ break=never
  219. Dialplan: sofia/internal/1003@icc-tech.com:5020 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
  220. Dialplan: sofia/internal/1003@icc-tech.com:5020 Regex (PASS) [global] ${endpoint_disposition}(DELAYED NEGOTIATION) =~ /^(DELAYED NEGOTIATION)/ break=on-false
  221. Dialplan: sofia/internal/1003@icc-tech.com:5020 Regex (FAIL) [global] ${switch_r_sdp}(v=0
  222. o=- 1525974679157578 1 IN IP4 100.67.7.149
  223. s=Cpc session
  224. c=IN IP4 100.67.7.149
  225. t=0 0
  226. m=audio 64218 RTP/AVP 120 18 0 8 101
  227. a=rtpmap:120 opus/48000/2
  228. a=fmtp:120 useinbandfec=1; usedtx=1; maxaveragebitrate=64000
  229. a=rtpmap:18 G729/8000
  230. a=fmtp:18 annexb=no
  231. a=rtpmap:101 telephone-event/8000
  232. a=fmtp:101 0-15
  233. ) =~ /(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)/ break=never
  234. Dialplan: sofia/internal/1003@icc-tech.com:5020 Absolute Condition [global]
  235. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid})
  236. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
  237. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action hash(insert/${domain_name}-last_dial/global/${uuid})
  238. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
  239. Dialplan: sofia/internal/1003@icc-tech.com:5020 parsing [default->snom-demo-2] continue=false
  240. Dialplan: sofia/internal/1003@icc-tech.com:5020 Regex (FAIL) [snom-demo-2] destination_number(1000) =~ /^9001$/ break=on-false
  241. Dialplan: sofia/internal/1003@icc-tech.com:5020 parsing [default->snom-demo-1] continue=false
  242. Dialplan: sofia/internal/1003@icc-tech.com:5020 Regex (FAIL) [snom-demo-1] destination_number(1000) =~ /^9000$/ break=on-false
  243. Dialplan: sofia/internal/1003@icc-tech.com:5020 parsing [default->eavesdrop] continue=false
  244. Dialplan: sofia/internal/1003@icc-tech.com:5020 Regex (FAIL) [eavesdrop] destination_number(1000) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false
  245. Dialplan: sofia/internal/1003@icc-tech.com:5020 parsing [default->eavesdrop] continue=false
  246. Dialplan: sofia/internal/1003@icc-tech.com:5020 Regex (FAIL) [eavesdrop] destination_number(1000) =~ /^779$/ break=on-false
  247. Dialplan: sofia/internal/1003@icc-tech.com:5020 parsing [default->call_return] continue=false
  248. Dialplan: sofia/internal/1003@icc-tech.com:5020 Regex (FAIL) [call_return] destination_number(1000) =~ /^\*69$|^869$|^lcr$/ break=on-false
  249. Dialplan: sofia/internal/1003@icc-tech.com:5020 parsing [default->del-group] continue=false
  250. Dialplan: sofia/internal/1003@icc-tech.com:5020 Regex (FAIL) [del-group] destination_number(1000) =~ /^80(\d{2})$/ break=on-false
  251. Dialplan: sofia/internal/1003@icc-tech.com:5020 parsing [default->add-group] continue=false
  252. Dialplan: sofia/internal/1003@icc-tech.com:5020 Regex (FAIL) [add-group] destination_number(1000) =~ /^81(\d{2})$/ break=on-false
  253. Dialplan: sofia/internal/1003@icc-tech.com:5020 parsing [default->call-group-simo] continue=false
  254. Dialplan: sofia/internal/1003@icc-tech.com:5020 Regex (FAIL) [call-group-simo] destination_number(1000) =~ /^82(\d{2})$/ break=on-false
  255. Dialplan: sofia/internal/1003@icc-tech.com:5020 parsing [default->call-group-order] continue=false
  256. Dialplan: sofia/internal/1003@icc-tech.com:5020 Regex (FAIL) [call-group-order] destination_number(1000) =~ /^83(\d{2})$/ break=on-false
  257. Dialplan: sofia/internal/1003@icc-tech.com:5020 parsing [default->extension-intercom] continue=false
  258. Dialplan: sofia/internal/1003@icc-tech.com:5020 Regex (FAIL) [extension-intercom] destination_number(1000) =~ /^8(10[01][0-9])$/ break=on-false
  259. Dialplan: sofia/internal/1003@icc-tech.com:5020 parsing [default->Local_Extension] continue=false
  260. Dialplan: sofia/internal/1003@icc-tech.com:5020 Regex (PASS) [Local_Extension] destination_number(1000) =~ /^(10[01][0-9])$/ break=on-false
  261. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action export(dialed_extension=1000)
  262. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action bind_meta_app(1 b s execute_extension::dx XML features)
  263. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action bind_meta_app(2 b s record_session::/usr/local/freeswitch/recordings/${caller_id_number}.${strftime(%Y-%m-%d-%H-%M-%S)}.wav)
  264. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action bind_meta_app(3 b s execute_extension::cf XML features)
  265. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action bind_meta_app(4 b s execute_extension::att_xfer XML features)
  266. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action set(ringback=${us-ring})
  267. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action set(transfer_ringback=local_stream://moh)
  268. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action set(call_timeout=30)
  269. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action set(hangup_after_bridge=true)
  270. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action set(continue_on_fail=true)
  271. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action hash(insert/${domain_name}-call_return/${dialed_extension}/${caller_id_number})
  272. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action hash(insert/${domain_name}-last_dial_ext/${dialed_extension}/${uuid})
  273. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action set(called_party_callgroup=${user_data(${dialed_extension}@${domain_name} var callgroup)})
  274. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action hash(insert/${domain_name}-last_dial_ext/${called_party_callgroup}/${uuid})
  275. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action hash(insert/${domain_name}-last_dial_ext/global/${uuid})
  276. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action hash(insert/${domain_name}-last_dial/${called_party_callgroup}/${uuid})
  277. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action bridge(user/${dialed_extension}@${domain_name})
  278. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action answer()
  279. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action sleep(1000)
  280. Dialplan: sofia/internal/1003@icc-tech.com:5020 Action bridge(loopback/app=voicemail:default ${domain_name} ${dialed_extension})
  281. 2018-05-10 17:51:23.078072 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/1003@icc-tech.com:5020) State Change CS_ROUTING -> CS_EXECUTE
  282. 2018-05-10 17:51:23.078072 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1003@icc-tech.com:5020) State ROUTING going to sleep
  283. 2018-05-10 17:51:23.088018 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1003@icc-tech.com:5020) Running State Change CS_EXECUTE (Cur 1 Tot 30)
  284. 2018-05-10 17:51:23.088018 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/1003@icc-tech.com:5020) State EXECUTE
  285. 2018-05-10 17:51:23.088018 [DEBUG] mod_sofia.c:209 sofia/internal/1003@icc-tech.com:5020 SOFIA EXECUTE
  286. 2018-05-10 17:51:23.088018 [DEBUG] switch_core_state_machine.c:328 sofia/internal/1003@icc-tech.com:5020 Standard EXECUTE
  287. EXECUTE sofia/internal/1003@icc-tech.com:5020 set(open=true)
  288. 2018-05-10 17:51:23.088018 [DEBUG] mod_dptools.c:1593 SET sofia/internal/1003@icc-tech.com:5020 [open]=[true]
  289. EXECUTE sofia/internal/1003@icc-tech.com:5020 hash(insert/159.89.163.195-spymap/1003/a7df158e-bc42-40d2-b61a-f366749fbaf6)
  290. EXECUTE sofia/internal/1003@icc-tech.com:5020 hash(insert/159.89.163.195-last_dial/1003/1000)
  291. EXECUTE sofia/internal/1003@icc-tech.com:5020 hash(insert/159.89.163.195-last_dial/global/a7df158e-bc42-40d2-b61a-f366749fbaf6)
  292. EXECUTE sofia/internal/1003@icc-tech.com:5020 export(RFC2822_DATE=Thu, 10 May 2018 17:51:23 +0000)
  293. 2018-05-10 17:51:23.088018 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [RFC2822_DATE]=[Thu, 10 May 2018 17:51:23 +0000]
  294. EXECUTE sofia/internal/1003@icc-tech.com:5020 export(dialed_extension=1000)
  295. 2018-05-10 17:51:23.088018 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [dialed_extension]=[1000]
  296. EXECUTE sofia/internal/1003@icc-tech.com:5020 bind_meta_app(1 b s execute_extension::dx XML features)
  297. 2018-05-10 17:51:23.088018 [INFO] switch_ivr_async.c:4273 Bound B-Leg: *1 execute_extension::dx XML features
  298. EXECUTE sofia/internal/1003@icc-tech.com:5020 bind_meta_app(2 b s record_session::/usr/local/freeswitch/recordings/1003.2018-05-10-17-51-23.wav)
  299. 2018-05-10 17:51:23.088018 [INFO] switch_ivr_async.c:4273 Bound B-Leg: *2 record_session::/usr/local/freeswitch/recordings/1003.2018-05-10-17-51-23.wav
  300. EXECUTE sofia/internal/1003@icc-tech.com:5020 bind_meta_app(3 b s execute_extension::cf XML features)
  301. 2018-05-10 17:51:23.088018 [INFO] switch_ivr_async.c:4273 Bound B-Leg: *3 execute_extension::cf XML features
  302. EXECUTE sofia/internal/1003@icc-tech.com:5020 bind_meta_app(4 b s execute_extension::att_xfer XML features)
  303. 2018-05-10 17:51:23.088018 [INFO] switch_ivr_async.c:4273 Bound B-Leg: *4 execute_extension::att_xfer XML features
  304. EXECUTE sofia/internal/1003@icc-tech.com:5020 set(ringback=%(2000,4000,440,480))
  305. 2018-05-10 17:51:23.088018 [DEBUG] mod_dptools.c:1593 SET sofia/internal/1003@icc-tech.com:5020 [ringback]=[%(2000,4000,440,480)]
  306. EXECUTE sofia/internal/1003@icc-tech.com:5020 set(transfer_ringback=local_stream://moh)
  307. 2018-05-10 17:51:23.088018 [DEBUG] mod_dptools.c:1593 SET sofia/internal/1003@icc-tech.com:5020 [transfer_ringback]=[local_stream://moh]
  308. EXECUTE sofia/internal/1003@icc-tech.com:5020 set(call_timeout=30)
  309. 2018-05-10 17:51:23.088018 [DEBUG] mod_dptools.c:1593 SET sofia/internal/1003@icc-tech.com:5020 [call_timeout]=[30]
  310. EXECUTE sofia/internal/1003@icc-tech.com:5020 set(hangup_after_bridge=true)
  311. 2018-05-10 17:51:23.088018 [DEBUG] mod_dptools.c:1593 SET sofia/internal/1003@icc-tech.com:5020 [hangup_after_bridge]=[true]
  312. EXECUTE sofia/internal/1003@icc-tech.com:5020 set(continue_on_fail=true)
  313. 2018-05-10 17:51:23.088018 [DEBUG] mod_dptools.c:1593 SET sofia/internal/1003@icc-tech.com:5020 [continue_on_fail]=[true]
  314. EXECUTE sofia/internal/1003@icc-tech.com:5020 hash(insert/159.89.163.195-call_return/1000/1003)
  315. EXECUTE sofia/internal/1003@icc-tech.com:5020 hash(insert/159.89.163.195-last_dial_ext/1000/a7df158e-bc42-40d2-b61a-f366749fbaf6)
  316. EXECUTE sofia/internal/1003@icc-tech.com:5020 set(called_party_callgroup=techsupport)
  317. 2018-05-10 17:51:23.088018 [DEBUG] mod_dptools.c:1593 SET sofia/internal/1003@icc-tech.com:5020 [called_party_callgroup]=[techsupport]
  318. EXECUTE sofia/internal/1003@icc-tech.com:5020 hash(insert/159.89.163.195-last_dial_ext/techsupport/a7df158e-bc42-40d2-b61a-f366749fbaf6)
  319. EXECUTE sofia/internal/1003@icc-tech.com:5020 hash(insert/159.89.163.195-last_dial_ext/global/a7df158e-bc42-40d2-b61a-f366749fbaf6)
  320. EXECUTE sofia/internal/1003@icc-tech.com:5020 hash(insert/159.89.163.195-last_dial/techsupport/a7df158e-bc42-40d2-b61a-f366749fbaf6)
  321. EXECUTE sofia/internal/1003@icc-tech.com:5020 bridge(user/1000@159.89.163.195)
  322. 2018-05-10 17:51:23.088018 [DEBUG] switch_channel.c:1250 sofia/internal/1003@icc-tech.com:5020 EXPORTING[export_vars] [RFC2822_DATE]=[Thu, 10 May 2018 17:51:23 +0000] to event
  323. 2018-05-10 17:51:23.088018 [DEBUG] switch_channel.c:1250 sofia/internal/1003@icc-tech.com:5020 EXPORTING[export_vars] [dialed_extension]=[1000] to event
  324. 2018-05-10 17:51:23.088018 [DEBUG] switch_ivr_originate.c:2159 Parsing global variables
  325. 2018-05-10 17:51:23.088018 [DEBUG] switch_channel.c:1250 sofia/internal/1003@icc-tech.com:5020 EXPORTING[export_vars] [RFC2822_DATE]=[Thu, 10 May 2018 17:51:23 +0000] to event
  326. 2018-05-10 17:51:23.088018 [DEBUG] switch_channel.c:1250 sofia/internal/1003@icc-tech.com:5020 EXPORTING[export_vars] [dialed_extension]=[1000] to event
  327. 2018-05-10 17:51:23.088018 [DEBUG] switch_ivr_originate.c:2159 Parsing global variables
  328. 2018-05-10 17:51:23.088018 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/1000@124.123.68.233:21102 [5e6e3045-9f9b-4caf-b743-1b2a189029dc]
  329. 2018-05-10 17:51:23.088018 [DEBUG] mod_sofia.c:5028 (sofia/internal/1000@124.123.68.233:21102) State Change CS_NEW -> CS_INIT
  330. 2018-05-10 17:51:23.088018 [NOTICE] switch_ivr_originate.c:2868 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  331. 2018-05-10 17:51:23.098016 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1000@124.123.68.233:21102) Running State Change CS_INIT (Cur 2 Tot 31)
  332. 2018-05-10 17:51:23.098016 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1000@124.123.68.233:21102) State INIT
  333. 2018-05-10 17:51:23.098016 [DEBUG] mod_sofia.c:93 sofia/internal/1000@124.123.68.233:21102 SOFIA INIT
  334. 2018-05-10 17:51:23.098016 [DEBUG] sofia_glue.c:1299 sofia/internal/1000@124.123.68.233:21102 sending invite version: 1.9.0 git a139bbd 2018-05-09 16:08:24Z 64bit
  335. Local SDP:
  336. v=0
  337. o=FreeSWITCH 1525954505 1525954506 IN IP4 159.89.163.195
  338. s=FreeSWITCH
  339. c=IN IP4 159.89.163.195
  340. t=0 0
  341. m=audio 20178 RTP/AVP 102 0 8 103 101
  342. a=rtpmap:102 opus/48000/2
  343. a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40; stereo=1
  344. a=rtpmap:0 PCMU/8000
  345. a=rtpmap:8 PCMA/8000
  346. a=rtpmap:103 telephone-event/48000
  347. a=fmtp:103 0-16
  348. a=rtpmap:101 telephone-event/8000
  349. a=fmtp:101 0-16
  350. a=ptime:20
  351. a=sendrecv
  352.  
  353. send 1484 bytes to udp/[124.123.68.233]:21102 at 17:51:23.099537:
  354.    ------------------------------------------------------------------------
  355.    INVITE sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f SIP/2.0
  356.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport;branch=z9hG4bK8g5e6B3yccaNp
  357.    Max-Forwards: 69
  358.    From: "Extension 1003" <sip:1003@159.89.163.195>;tag=X0mDeFteS3ZmN
  359.    To: <sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f>
  360.    Call-ID: 9818cb57-cf1d-1236-a889-528373432f88
  361.    CSeq: 122651277 INVITE
  362.    Contact: <sip:mod_sofia@159.89.163.195:5020>
  363.    User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20180509T160824Z~a139bbd195~64bit
  364.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  365.    Supported: timer, path, replaces
  366.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  367.    Content-Type: application/sdp
  368.    Content-Disposition: session
  369.    Content-Length: 457
  370.    X-FS-Support: update_display,send_info
  371.    Remote-Party-ID: "Extension 1003" <sip:1003@159.89.163.195>;party=calling;screen=yes;privacy=off
  372.  
  373.    v=0
  374.    o=FreeSWITCH 1525954505 1525954506 IN IP4 159.89.163.195
  375.    s=FreeSWITCH
  376.    c=IN IP4 159.89.163.195
  377.    t=0 0
  378.    m=audio 20178 RTP/AVP 102 0 8 103 101
  379.    a=rtpmap:102 opus/48000/2
  380.    a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40; stereo=1
  381.    a=rtpmap:0 PCMU/8000
  382.    a=rtpmap:8 PCMA/8000
  383.    a=rtpmap:103 telephone-event/48000
  384.    a=fmtp:103 0-16
  385.    a=rtpmap:101 telephone-event/8000
  386.    a=fmtp:101 0-16
  387.    a=ptime:20
  388.    ------------------------------------------------------------------------
  389. 2018-05-10 17:51:23.098016 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1000@124.123.68.233:21102 Standard INIT
  390. 2018-05-10 17:51:23.098016 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1000@124.123.68.233:21102) State Change CS_INIT -> CS_ROUTING
  391. 2018-05-10 17:51:23.098016 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1000@124.123.68.233:21102) State INIT going to sleep
  392. 2018-05-10 17:51:23.098016 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1000@124.123.68.233:21102) Running State Change CS_ROUTING (Cur 2 Tot 31)
  393. 2018-05-10 17:51:23.098016 [DEBUG] sofia.c:7291 Channel sofia/internal/1000@124.123.68.233:21102 entering state [calling][0]
  394. 2018-05-10 17:51:23.098016 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1000@124.123.68.233:21102) State ROUTING
  395. 2018-05-10 17:51:23.098016 [DEBUG] mod_sofia.c:154 sofia/internal/1000@124.123.68.233:21102 SOFIA ROUTING
  396. 2018-05-10 17:51:23.098016 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/1000@124.123.68.233:21102) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  397. 2018-05-10 17:51:23.098016 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1000@124.123.68.233:21102) State ROUTING going to sleep
  398. 2018-05-10 17:51:23.098016 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1000@124.123.68.233:21102) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 31)
  399. 2018-05-10 17:51:23.098016 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/1000@124.123.68.233:21102) State CONSUME_MEDIA
  400. 2018-05-10 17:51:23.098016 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/1000@124.123.68.233:21102) State CONSUME_MEDIA going to sleep
  401. recv 321 bytes from udp/[124.123.68.233]:21102 at 17:51:23.201475:
  402.    ------------------------------------------------------------------------
  403.    SIP/2.0 100 Trying
  404.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport=5020;branch=z9hG4bK8g5e6B3yccaNp
  405.    To: <sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f>
  406.    From: "Extension 1003" <sip:1003@159.89.163.195>;tag=X0mDeFteS3ZmN
  407.    Call-ID: 9818cb57-cf1d-1236-a889-528373432f88
  408.    CSeq: 122651277 INVITE
  409.    Content-Length: 0
  410.  
  411.    ------------------------------------------------------------------------
  412. recv 490 bytes from udp/[124.123.68.233]:21102 at 17:51:23.603599:
  413.    ------------------------------------------------------------------------
  414.    SIP/2.0 180 Ringing
  415.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport=5020;branch=z9hG4bK8g5e6B3yccaNp
  416.    Contact: <sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f>
  417.    To: "shashi"<sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f>;tag=03fadd26
  418.    From: "Extension 1003" <sip:1003@159.89.163.195>;tag=X0mDeFteS3ZmN
  419.    Call-ID: 9818cb57-cf1d-1236-a889-528373432f88
  420.    CSeq: 122651277 INVITE
  421.    User-Agent: Bria Stretto release 5.2.0 stamp 90726
  422.    Allow-Events: talk, hold
  423.    Content-Length: 0
  424.  
  425.    ------------------------------------------------------------------------
  426. 2018-05-10 17:51:23.598065 [DEBUG] sofia.c:7291 Channel sofia/internal/1000@124.123.68.233:21102 entering state [proceeding][180]
  427. 2018-05-10 17:51:23.598065 [NOTICE] sofia.c:7401 Ring-Ready sofia/internal/1000@124.123.68.233:21102!
  428. 2018-05-10 17:51:23.598065 [DEBUG] switch_channel.c:3354 (sofia/internal/1000@124.123.68.233:21102) Callstate Change DOWN -> RINGING
  429. 2018-05-10 17:51:23.618112 [INFO] switch_ivr_originate.c:1220 Sending early media
  430. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [opus:120:48000:20:0:1]/[opus:116:48000:20:0:1]
  431. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:5513 Audio Codec Compare [opus:116:48000:20:0:1] ++++ is saved as a match
  432. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [opus:120:48000:20:0:1]/[G722:9:8000:20:64000:1]
  433. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [opus:120:48000:20:0:1]/[PCMU:0:8000:20:64000:1]
  434. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [opus:120:48000:20:0:1]/[PCMA:8:8000:20:64000:1]
  435. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [G729:18:8000:20:8000:1]/[opus:116:48000:20:0:1]
  436. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [G729:18:8000:20:8000:1]/[G722:9:8000:20:64000:1]
  437. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
  438. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
  439. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
  440. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  441. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  442. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:5513 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  443. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  444. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1]
  445. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  446. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  447. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  448. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:5513 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  449. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:5374 Set telephone-event payload to 101@8000
  450. 2018-05-10 17:51:23.618112 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [72000bps]
  451. 2018-05-10 17:51:23.618112 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [72000bps]
  452. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:3773 Set Codec sofia/internal/1003@icc-tech.com:5020 opus/48000 20 ms 960 samples 0 bits 1 channels
  453. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_codec.c:111 sofia/internal/1003@icc-tech.com:5020 Original read codec set to opus:116
  454. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:5775 sofia/internal/1003@icc-tech.com:5020 Set 2833 dtmf send payload to 101 recv payload to 101
  455. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:8491 AUDIO RTP [sofia/internal/1003@icc-tech.com:5020] 159.89.163.195 port 28270 -> 100.67.7.149 port 64218 codec: 120 ms: 20
  456. 2018-05-10 17:51:23.618112 [DEBUG] switch_rtp.c:4277 Starting timer [soft] 960 bytes per 20ms
  457. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:8795 sofia/internal/1003@icc-tech.com:5020 Set 2833 dtmf send payload to 101
  458. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:8802 sofia/internal/1003@icc-tech.com:5020 Set 2833 dtmf receive payload to 101
  459. 2018-05-10 17:51:23.618112 [DEBUG] switch_core_media.c:8825 sofia/internal/1003@icc-tech.com:5020 Set rtp dtmf delay to 40
  460. 2018-05-10 17:51:23.618112 [NOTICE] sofia_media.c:92 Pre-Answer sofia/internal/1003@icc-tech.com:5020!
  461. 2018-05-10 17:51:23.618112 [DEBUG] switch_channel.c:3482 (sofia/internal/1003@icc-tech.com:5020) Callstate Change RINGING -> EARLY
  462. 2018-05-10 17:51:23.628079 [DEBUG] switch_core_media.c:8474 Audio params are unchanged for sofia/internal/1003@icc-tech.com:5020.
  463. 2018-05-10 17:51:23.628079 [DEBUG] mod_sofia.c:2514 Ring SDP:
  464. v=0
  465. o=FreeSWITCH 1525946413 1525946414 IN IP4 159.89.163.195
  466. s=FreeSWITCH
  467. c=IN IP4 159.89.163.195
  468. t=0 0
  469. m=audio 28270 RTP/AVP 120 101
  470. a=rtpmap:120 opus/48000/2
  471. a=fmtp:120 useinbandfec=1
  472. a=rtpmap:101 telephone-event/8000
  473. a=fmtp:101 0-16
  474. a=ptime:20
  475. a=sendrecv
  476.  
  477. send 1229 bytes to udp/[106.76.208.110]:49663 at 17:51:23.628562:
  478.    ------------------------------------------------------------------------
  479.    SIP/2.0 183 Session Progress
  480.    Via: SIP/2.0/UDP 100.67.7.149:49663;branch=z9hG4bK-524287-1---8332b03d7907781a;rport=49663;received=106.76.208.110
  481.    From: "Brian West"<sip:1003@icc-tech.com:5020>;tag=cfc94962
  482.    To: <sip:1000@icc-tech.com:5020>;tag=vQUmcm9avt91S
  483.    Call-ID: ZGRiN2M4Mjk1NDI0OTIxYTQ2ODRmY2MwZTE4YTFkMDY
  484.    CSeq: 2 INVITE
  485.    Contact: <sip:1000@159.89.163.195:5020;transport=udp>
  486.    User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20180509T160824Z~a139bbd195~64bit
  487.    Accept: application/sdp
  488.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  489.    Supported: timer, path, replaces
  490.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  491.    Content-Type: application/sdp
  492.    Content-Disposition: session
  493.    Content-Length: 258
  494.    Remote-Party-ID: "1000" <sip:1000@icc-tech.com>;party=calling;privacy=off;screen=no
  495.  
  496.    v=0
  497.    o=FreeSWITCH 1525946413 1525946414 IN IP4 159.89.163.195
  498.    s=FreeSWITCH
  499.    c=IN IP4 159.89.163.195
  500.    t=0 0
  501.    m=audio 28270 RTP/AVP 120 101
  502.    a=rtpmap:120 opus/48000/2
  503.    a=fmtp:120 useinbandfec=1
  504.    a=rtpmap:101 telephone-event/8000
  505.    a=fmtp:101 0-16
  506.    a=ptime:20
  507.    ------------------------------------------------------------------------
  508. 2018-05-10 17:51:23.628079 [DEBUG] sofia.c:7291 Channel sofia/internal/1003@icc-tech.com:5020 entering state [early][183]
  509. 2018-05-10 17:51:23.628079 [DEBUG] switch_ivr_originate.c:1278 Raw Codec Activation Success L16@48000hz 1 channel 20ms
  510. 2018-05-10 17:51:23.628079 [DEBUG] switch_core_codec.c:223 sofia/internal/1003@icc-tech.com:5020 Push codec L16:100
  511. 2018-05-10 17:51:23.628079 [DEBUG] switch_ivr_originate.c:1347 Play Ringback Tone [%(2000,4000,440,480)]
  512. 2018-05-10 17:51:24.978060 [INFO] switch_rtp.c:7450 Auto Changing audio port from 100.67.7.149:64218 to 106.76.208.110:64218
  513. recv 894 bytes from udp/[124.123.68.233]:21102 at 17:51:27.092968:
  514.    ------------------------------------------------------------------------
  515.    SIP/2.0 200 OK
  516.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport=5020;branch=z9hG4bK8g5e6B3yccaNp
  517.    Contact: <sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f>
  518.    To: <sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f>;tag=03fadd26
  519.    From: "Extension 1003" <sip:1003@159.89.163.195>;tag=X0mDeFteS3ZmN
  520.    Call-ID: 9818cb57-cf1d-1236-a889-528373432f88
  521.    CSeq: 122651277 INVITE
  522.   Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
  523.    Content-Type: application/sdp
  524.    Supported: replaces
  525.    User-Agent: Bria Stretto release 5.2.0 stamp 90726
  526.    Content-Length: 306
  527.  
  528.    v=0
  529.    o=- 3816328869 3 IN IP4 10.144.160.39
  530.    s=Bria Stretto release 5.2.0 stamp 90726
  531.    c=IN IP4 124.123.68.233
  532.    t=0 0
  533.    m=audio 21231 RTP/AVP 102 0 8 101
  534.    a=rtpmap:102 opus/48000/2
  535.    a=fmtp:102 useinbandfec=1; usedtx=1; maxaveragebitrate=64000
  536.    a=rtpmap:101 telephone-event/8000
  537.    a=fmtp:101 0-15
  538.    a=sendrecv
  539.    ------------------------------------------------------------------------
  540. 2018-05-10 17:51:27.088021 [DEBUG] sofia.c:7291 Channel sofia/internal/1000@124.123.68.233:21102 entering state [completing][200]
  541. 2018-05-10 17:51:27.088021 [DEBUG] sofia.c:7301 Remote SDP:
  542. v=0
  543. o=- 3816328869 3 IN IP4 10.144.160.39
  544. s=Bria Stretto release 5.2.0 stamp 90726
  545. c=IN IP4 124.123.68.233
  546. t=0 0
  547. m=audio 21231 RTP/AVP 102 0 8 101
  548. a=rtpmap:102 opus/48000/2
  549. a=fmtp:102 useinbandfec=1; usedtx=1; maxaveragebitrate=64000
  550. a=rtpmap:101 telephone-event/8000
  551. a=fmtp:101 0-15
  552.  
  553. 2018-05-10 17:51:27.088021 [NOTICE] sofia.c:7304 Pre-Answer sofia/internal/1000@124.123.68.233:21102!
  554. 2018-05-10 17:51:27.088021 [DEBUG] switch_channel.c:3482 (sofia/internal/1000@124.123.68.233:21102) Callstate Change RINGING -> EARLY
  555. send 440 bytes to udp/[124.123.68.233]:21102 at 17:51:27.095857:
  556.    ------------------------------------------------------------------------
  557.    ACK sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f SIP/2.0
  558.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport;branch=z9hG4bK9Sy776K29m07H
  559.    Max-Forwards: 70
  560.    From: "Extension 1003" <sip:1003@159.89.163.195>;tag=X0mDeFteS3ZmN
  561.    To: <sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f>;tag=03fadd26
  562.    Call-ID: 9818cb57-cf1d-1236-a889-528373432f88
  563.    CSeq: 122651277 ACK
  564.    Contact: <sip:mod_sofia@159.89.163.195:5020>
  565.    Content-Length: 0
  566.  
  567.    ------------------------------------------------------------------------
  568. 2018-05-10 17:51:27.088021 [DEBUG] sofia.c:7291 Channel sofia/internal/1000@124.123.68.233:21102 entering state [ready][200]
  569. 2018-05-10 17:51:27.088021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [opus:102:48000:20:0:1]/[opus:116:48000:20:0:2]
  570. 2018-05-10 17:51:27.088021 [DEBUG] switch_core_media.c:5513 Audio Codec Compare [opus:116:48000:20:0:2] ++++ is saved as a match
  571. 2018-05-10 17:51:27.088021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [opus:102:48000:20:0:1]/[PCMU:0:8000:20:64000:1]
  572. 2018-05-10 17:51:27.088021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [opus:102:48000:20:0:1]/[PCMA:8:8000:20:64000:1]
  573. 2018-05-10 17:51:27.088021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:2]
  574. 2018-05-10 17:51:27.088021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  575. 2018-05-10 17:51:27.088021 [DEBUG] switch_core_media.c:5513 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  576. 2018-05-10 17:51:27.088021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  577. 2018-05-10 17:51:27.088021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:2]
  578. 2018-05-10 17:51:27.088021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  579. 2018-05-10 17:51:27.088021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  580. 2018-05-10 17:51:27.088021 [DEBUG] switch_core_media.c:5513 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  581. 2018-05-10 17:51:27.088021 [DEBUG] switch_core_media.c:5374 Set telephone-event payload to 101@8000
  582. 2018-05-10 17:51:27.088021 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [72000bps]
  583. 2018-05-10 17:51:27.088021 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [72000bps]
  584. 2018-05-10 17:51:27.088021 [DEBUG] switch_core_media.c:3773 Set Codec sofia/internal/1000@124.123.68.233:21102 opus/48000 20 ms 960 samples 0 bits 1 channels
  585. 2018-05-10 17:51:27.088021 [DEBUG] switch_core_codec.c:111 sofia/internal/1000@124.123.68.233:21102 Original read codec set to opus:116
  586. 2018-05-10 17:51:27.088021 [DEBUG] switch_core_media.c:5775 sofia/internal/1000@124.123.68.233:21102 Set 2833 dtmf send payload to 101 recv payload to 101
  587. 2018-05-10 17:51:27.088021 [DEBUG] switch_core_media.c:8491 AUDIO RTP [sofia/internal/1000@124.123.68.233:21102] 159.89.163.195 port 20178 -> 124.123.68.233 port 21231 codec: 102 ms: 20
  588. 2018-05-10 17:51:27.088021 [DEBUG] switch_rtp.c:4277 Starting timer [soft] 960 bytes per 20ms
  589. 2018-05-10 17:51:27.098038 [DEBUG] switch_core_media.c:8795 sofia/internal/1000@124.123.68.233:21102 Set 2833 dtmf send payload to 101
  590. 2018-05-10 17:51:27.098038 [DEBUG] switch_core_media.c:8802 sofia/internal/1000@124.123.68.233:21102 Set 2833 dtmf receive payload to 101
  591. 2018-05-10 17:51:27.098038 [DEBUG] switch_core_media.c:8825 sofia/internal/1000@124.123.68.233:21102 Set rtp dtmf delay to 40
  592. 2018-05-10 17:51:27.098038 [NOTICE] sofia.c:8429 Channel [sofia/internal/1000@124.123.68.233:21102] has been answered
  593. 2018-05-10 17:51:27.098038 [DEBUG] switch_channel.c:3781 (sofia/internal/1000@124.123.68.233:21102) Callstate Change EARLY -> ACTIVE
  594. 2018-05-10 17:51:27.098038 [DEBUG] switch_core_codec.c:248 sofia/internal/1003@icc-tech.com:5020 Restore previous codec opus:116.
  595. 2018-05-10 17:51:27.098038 [DEBUG] switch_core_media.c:8474 Audio params are unchanged for sofia/internal/1003@icc-tech.com:5020.
  596. 2018-05-10 17:51:27.098038 [DEBUG] mod_sofia.c:881 Local SDP sofia/internal/1003@icc-tech.com:5020:
  597. v=0
  598. o=FreeSWITCH 1525946413 1525946415 IN IP4 159.89.163.195
  599. s=FreeSWITCH
  600. c=IN IP4 159.89.163.195
  601. t=0 0
  602. m=audio 28270 RTP/AVP 120 101
  603. a=rtpmap:120 opus/48000/2
  604. a=fmtp:120 useinbandfec=1
  605. a=rtpmap:101 telephone-event/8000
  606. a=fmtp:101 0-16
  607. a=ptime:20
  608. a=sendrecv
  609.  
  610. send 1235 bytes to udp/[106.76.208.110]:49663 at 17:51:27.106548:
  611.    ------------------------------------------------------------------------
  612.    SIP/2.0 200 OK
  613.    Via: SIP/2.0/UDP 100.67.7.149:49663;branch=z9hG4bK-524287-1---8332b03d7907781a;rport=49663;received=106.76.208.110
  614.    From: "Brian West"<sip:1003@icc-tech.com:5020>;tag=cfc94962
  615.    To: <sip:1000@icc-tech.com:5020>;tag=vQUmcm9avt91S
  616.    Call-ID: ZGRiN2M4Mjk1NDI0OTIxYTQ2ODRmY2MwZTE4YTFkMDY
  617.    CSeq: 2 INVITE
  618.    Contact: <sip:1000@159.89.163.195:5020;transport=udp>
  619.    User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20180509T160824Z~a139bbd195~64bit
  620.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  621.    Supported: timer, path, replaces
  622.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  623.    Session-Expires: 120;refresher=uas
  624.    Content-Type: application/sdp
  625.    Content-Disposition: session
  626.    Content-Length: 258
  627.    Remote-Party-ID: "Outbound Call" <sip:1000@icc-tech.com>;party=calling;privacy=off;screen=no
  628.  
  629.    v=0
  630.    o=FreeSWITCH 1525946413 1525946414 IN IP4 159.89.163.195
  631.    s=FreeSWITCH
  632.    c=IN IP4 159.89.163.195
  633.    t=0 0
  634.    m=audio 28270 RTP/AVP 120 101
  635.    a=rtpmap:120 opus/48000/2
  636.    a=fmtp:120 useinbandfec=1
  637.    a=rtpmap:101 telephone-event/8000
  638.    a=fmtp:101 0-16
  639.    a=ptime:20
  640.    ------------------------------------------------------------------------
  641. 2018-05-10 17:51:27.098038 [DEBUG] sofia.c:7291 Channel sofia/internal/1003@icc-tech.com:5020 entering state [completed][200]
  642. 2018-05-10 17:51:27.098038 [NOTICE] switch_ivr_originate.c:3664 Channel [sofia/internal/1003@icc-tech.com:5020] has been answered
  643. 2018-05-10 17:51:27.108016 [DEBUG] switch_channel.c:3781 (sofia/internal/1003@icc-tech.com:5020) Callstate Change EARLY -> ACTIVE
  644. 2018-05-10 17:51:27.108016 [DEBUG] switch_ivr_originate.c:3722 Originate Resulted in Success: [sofia/internal/1000@124.123.68.233:21102]
  645. 2018-05-10 17:51:27.108016 [DEBUG] switch_ivr_originate.c:3722 Originate Resulted in Success: [sofia/internal/1000@124.123.68.233:21102]
  646. 2018-05-10 17:51:27.108016 [DEBUG] switch_ivr_bridge.c:1744 (sofia/internal/1000@124.123.68.233:21102) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
  647. 2018-05-10 17:51:27.108016 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1000@124.123.68.233:21102) Running State Change CS_EXCHANGE_MEDIA (Cur 2 Tot 31)
  648. 2018-05-10 17:51:27.108016 [DEBUG] switch_core_state_machine.c:653 (sofia/internal/1000@124.123.68.233:21102) State EXCHANGE_MEDIA
  649. 2018-05-10 17:51:27.108016 [DEBUG] mod_sofia.c:645 SOFIA EXCHANGE_MEDIA
  650. 2018-05-10 17:51:27.138068 [DEBUG] switch_rtp.c:7490 Correct audio ip/port confirmed.
  651. 2018-05-10 17:51:27.138068 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[0] PLC[0] FEC[0]
  652. 2018-05-10 17:51:27.138068 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[0] Bytes encoded[0] Encoded length ms[0] Average encoded bitrate bps[0]
  653. 2018-05-10 17:51:27.138068 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [72000bps]
  654. 2018-05-10 17:51:27.148035 [DEBUG] switch_rtp.c:7490 Correct audio ip/port confirmed.
  655. 2018-05-10 17:51:27.148035 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[0] PLC[0] FEC[0]
  656. 2018-05-10 17:51:27.148035 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[0] Bytes encoded[0] Encoded length ms[0] Average encoded bitrate bps[0]
  657. 2018-05-10 17:51:27.148035 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [72000bps]
  658. recv 495 bytes from udp/[106.76.208.110]:49663 at 17:51:27.261476:
  659.    ------------------------------------------------------------------------
  660.    ACK sip:1000@159.89.163.195:5020;transport=udp SIP/2.0
  661.    Via: SIP/2.0/UDP 100.67.7.149:49663;branch=z9hG4bK-524287-1---cfe29338297b9b68;rport
  662.    Max-Forwards: 70
  663.    Contact: <sip:1003@106.76.208.110:49663;rinstance=c68d10a466e6eed9>
  664.    To: <sip:1000@icc-tech.com:5020>;tag=vQUmcm9avt91S
  665.    From: "Brian West"<sip:1003@icc-tech.com:5020>;tag=cfc94962
  666.    Call-ID: ZGRiN2M4Mjk1NDI0OTIxYTQ2ODRmY2MwZTE4YTFkMDY
  667.    CSeq: 2 ACK
  668.    User-Agent: Bria Stretto iOS release 5.2.4001 stamp 41079.41081
  669.    Content-Length: 0
  670.  
  671.    ------------------------------------------------------------------------
  672. 2018-05-10 17:51:27.258022 [DEBUG] sofia.c:7291 Channel sofia/internal/1003@icc-tech.com:5020 entering state [ready][200]
  673. freeswitch@debian-s-1vcpu-1gb-blr1-01>
  674. recv 651 bytes from udp/[124.123.68.233]:21102 at 17:51:30.077202:
  675.    ------------------------------------------------------------------------
  676.    SUBSCRIBE sip:1000@159.89.163.195:5020 SIP/2.0
  677.    Via: SIP/2.0/UDP 10.144.160.39:49933;branch=z9hG4bK-524287-1---3260dc4579d5e177;rport
  678.    Max-Forwards: 70
  679.    Contact: <sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f>
  680.    To: <sip:1000@159.89.163.195:5020>;tag=fMWlF8WwfHPO
  681.    From: "shashi" <sip:1000@159.89.163.195:5020>;tag=835a095d
  682.    Call-ID: 90726NzQ5NGNkZmEwZjJjMzg3ZmY0ZGRjYzQ1Y2RmZTI5MDU
  683.    CSeq: 33 SUBSCRIBE
  684.    Expires: 60
  685.    Accept: application/simple-message-summary
  686.   Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
  687.    User-Agent: Bria Stretto release 5.2.0 stamp 90726
  688.    Event: message-summary
  689.    Content-Length: 0
  690.  
  691.    ------------------------------------------------------------------------
  692. send 838 bytes to udp/[124.123.68.233]:21102 at 17:51:30.078474:
  693.    ------------------------------------------------------------------------
  694.    SIP/2.0 202 Accepted
  695.    Via: SIP/2.0/UDP 10.144.160.39:49933;branch=z9hG4bK-524287-1---3260dc4579d5e177;rport=21102;received=124.123.68.233
  696.    From: "shashi" <sip:1000@159.89.163.195:5020>;tag=835a095d
  697.    To: <sip:1000@159.89.163.195:5020>;tag=fMWlF8WwfHPO
  698.    Call-ID: 90726NzQ5NGNkZmEwZjJjMzg3ZmY0ZGRjYzQ1Y2RmZTI5MDU
  699.    CSeq: 33 SUBSCRIBE
  700.    Contact: <sip:1000@159.89.163.195:5020>
  701.    Expires: 60
  702.    User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20180509T160824Z~a139bbd195~64bit
  703.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  704.    Supported: timer, path, replaces
  705.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  706.    Subscription-State: active;expires=60
  707.    Content-Length: 0
  708.  
  709.    ------------------------------------------------------------------------
  710. send 994 bytes to udp/[124.123.68.233]:21102 at 17:51:30.186653:
  711.    ------------------------------------------------------------------------
  712.    NOTIFY sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f SIP/2.0
  713.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport;branch=z9hG4bKa3Q091456XptD
  714.    Max-Forwards: 70
  715.    From: <sip:1000@159.89.163.195:5020>;tag=fMWlF8WwfHPO
  716.    To: "shashi" <sip:1000@159.89.163.195:5020>;tag=835a095d
  717.    Call-ID: 90726NzQ5NGNkZmEwZjJjMzg3ZmY0ZGRjYzQ1Y2RmZTI5MDU
  718.    CSeq: 560494501 NOTIFY
  719.    Contact: <sip:1000@159.89.163.195:5020>
  720.    User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20180509T160824Z~a139bbd195~64bit
  721.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  722.    Supported: timer, path, replaces
  723.    Event: message-summary
  724.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  725.    Subscription-State: active;expires=60
  726.    Content-Type: application/simple-message-summary
  727.    Content-Length: 66
  728.  
  729.    Messages-Waiting: no
  730.    Message-Account: sip:1000@159.89.163.195
  731.  
  732.    ------------------------------------------------------------------------
  733. recv 430 bytes from udp/[124.123.68.233]:21102 at 17:51:30.208780:
  734.    ------------------------------------------------------------------------
  735.    SIP/2.0 200 OK
  736.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport=5020;branch=z9hG4bKa3Q091456XptD
  737.    Contact: <sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f>
  738.    To: "shashi"<sip:1000@159.89.163.195:5020>;tag=835a095d
  739.    From: <sip:1000@159.89.163.195:5020>;tag=fMWlF8WwfHPO
  740.    Call-ID: 90726NzQ5NGNkZmEwZjJjMzg3ZmY0ZGRjYzQ1Y2RmZTI5MDU
  741.    CSeq: 560494501 NOTIFY
  742.    User-Agent: Bria Stretto release 5.2.0 stamp 90726
  743.    Content-Length: 0
  744.  
  745.    ------------------------------------------------------------------------
  746.    
  747.    
  748. **************************************Video Activation in Bria starts**********************************
  749.  
  750.  
  751. recv 1273 bytes from udp/[124.123.68.233]:21102 at 17:51:37.756534:
  752.    ------------------------------------------------------------------------
  753.    INVITE sip:mod_sofia@159.89.163.195:5020 SIP/2.0
  754.    Via: SIP/2.0/UDP 10.144.160.39:49933;branch=z9hG4bK-524287-1---1d377b60adff825e;rport
  755.    Max-Forwards: 70
  756.    Contact: <sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f>
  757.    To: "Extension 1003" <sip:1003@159.89.163.195>;tag=X0mDeFteS3ZmN
  758.    From: <sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f>;tag=03fadd26
  759.    Call-ID: 9818cb57-cf1d-1236-a889-528373432f88
  760.    CSeq: 2 INVITE
  761.   Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
  762.    Content-Type: application/sdp
  763.    Supported: replaces
  764.    User-Agent: Bria Stretto release 5.2.0 stamp 90726
  765.    Content-Length: 631
  766.  
  767.    v=0
  768.    o=- 3816328869 4 IN IP4 10.144.160.39
  769.    s=Bria Stretto release 5.2.0 stamp 90726
  770.    c=IN IP4 124.123.68.233
  771.    t=0 0
  772.    m=audio 21231 RTP/AVP 102 0 8 101 9 18
  773.    a=rtpmap:102 opus/48000/2
  774.    a=fmtp:102 useinbandfec=1; usedtx=1; maxaveragebitrate=64000
  775.    a=rtpmap:101 telephone-event/8000
  776.    a=fmtp:101 0-15
  777.    a=rtpmap:18 G729/8000
  778.    a=fmtp:18 annexb=yes
  779.    a=sendrecv
  780.    m=video 21234 RTP/AVP 127 126 100
  781.    a=rtpmap:127 H264/90000
  782.    a=fmtp:127 profile-level-id=428016;packetization-mode=0
  783.    a=rtpmap:126 H264/90000
  784.    a=fmtp:126 profile-level-id=428016;packetization-mode=1
  785.    a=rtpmap:100 VP8/90000
  786.    a=rtcp-fb:* nack
  787.    a=rtcp-fb:* nack pli
  788.    a=sendrecv
  789.    ------------------------------------------------------------------------
  790. send 444 bytes to udp/[124.123.68.233]:21102 at 17:51:37.757174:
  791.    ------------------------------------------------------------------------
  792.    SIP/2.0 100 Trying
  793.    Via: SIP/2.0/UDP 10.144.160.39:49933;branch=z9hG4bK-524287-1---1d377b60adff825e;rport=21102;received=124.123.68.233
  794.    From: <sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f>;tag=03fadd26
  795.    To: "Extension 1003" <sip:1003@159.89.163.195>;tag=X0mDeFteS3ZmN
  796.    Call-ID: 9818cb57-cf1d-1236-a889-528373432f88
  797.    CSeq: 2 INVITE
  798.    User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20180509T160824Z~a139bbd195~64bit
  799.    Content-Length: 0
  800.  
  801.    ------------------------------------------------------------------------
  802. 2018-05-10 17:51:37.748021 [DEBUG] sofia.c:7291 Channel sofia/internal/1000@124.123.68.233:21102 entering state [received][100]
  803. 2018-05-10 17:51:37.748021 [DEBUG] sofia.c:7301 Remote SDP:
  804. v=0
  805. o=- 3816328869 4 IN IP4 10.144.160.39
  806. s=Bria Stretto release 5.2.0 stamp 90726
  807. c=IN IP4 124.123.68.233
  808. t=0 0
  809. m=audio 21231 RTP/AVP 102 0 8 101 9 18
  810. a=rtpmap:102 opus/48000/2
  811. a=fmtp:102 useinbandfec=1; usedtx=1; maxaveragebitrate=64000
  812. a=rtpmap:101 telephone-event/8000
  813. a=fmtp:101 0-15
  814. a=rtpmap:18 G729/8000
  815. a=fmtp:18 annexb=yes
  816. m=video 21234 RTP/AVP 127 126 100
  817. a=rtpmap:127 H264/90000
  818. a=fmtp:127 profile-level-id=428016;packetization-mode=0
  819. a=rtpmap:126 H264/90000
  820. a=fmtp:126 profile-level-id=428016;packetization-mode=1
  821. a=rtpmap:100 VP8/90000
  822. a=rtcp-fb:* nack
  823. a=rtcp-fb:* nack pli
  824.  
  825. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [opus:102:48000:20:0:1]/[opus:116:48000:20:0:1]
  826. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5513 Audio Codec Compare [opus:116:48000:20:0:1] ++++ is saved as a match
  827. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [opus:102:48000:20:0:1]/[G722:9:8000:20:64000:1]
  828. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [opus:102:48000:20:0:1]/[PCMU:0:8000:20:64000:1]
  829. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [opus:102:48000:20:0:1]/[PCMA:8:8000:20:64000:1]
  830. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
  831. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  832. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  833. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5513 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  834. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  835. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1]
  836. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  837. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  838. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  839. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5513 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  840. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5374 Set telephone-event payload to 101@8000
  841. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [G722:9:8000:20:64000:1]/[opus:116:48000:20:0:1]
  842. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [G722:9:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  843. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5513 Audio Codec Compare [G722:9:8000:20:64000:1] ++++ is saved as a match
  844. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  845. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  846. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [G729:18:8000:20:8000:1]/[opus:116:48000:20:0:1]
  847. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [G729:18:8000:20:8000:1]/[G722:9:8000:20:64000:1]
  848. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
  849. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
  850. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:5775 sofia/internal/1000@124.123.68.233:21102 Set 2833 dtmf send payload to 101 recv payload to 101
  851. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:6058 Video Codec Compare [H264:127]/[VP8:99]
  852. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:6058 Video Codec Compare [H264:126]/[VP8:99]
  853. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:6058 Video Codec Compare [VP8:100]/[VP8:99]
  854. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:6090 Video Codec Compare [VP8:100] +++ is saved as a match
  855. 2018-05-10 17:51:37.748021 [DEBUG] switch_vpx.c:636 VPX VER:v1.6.0 VPX_IMAGE_ABI_VERSION:4 VPX_CODEC_ABI_VERSION:7
  856. 2018-05-10 17:51:37.748021 [DEBUG] switch_vpx.c:636 VPX VER:v1.6.0 VPX_IMAGE_ABI_VERSION:4 VPX_CODEC_ABI_VERSION:7
  857. 2018-05-10 17:51:37.748021 [DEBUG] switch_core_media.c:3583 Set VIDEO Codec sofia/internal/1000@124.123.68.233:21102 VP8/90000 0 ms
  858. 2018-05-10 17:51:37.758014 [DEBUG] switch_core_media.c:8474 Audio params are unchanged for sofia/internal/1000@124.123.68.233:21102.
  859. 2018-05-10 17:51:37.758014 [DEBUG] switch_rtp.c:4292 Starting video timer.
  860. 2018-05-10 17:51:37.758014 [DEBUG] switch_core_media.c:9320 VIDEO RTP [sofia/internal/1000@124.123.68.233:21102] 159.89.163.195:28390->124.123.68.233:21234 codec: 100 ms: 0 [SUCCESS]
  861. 2018-05-10 17:51:37.758014 [DEBUG] switch_core_media.c:7483 sofia/internal/1000@124.123.68.233:21102 Starting Video thread
  862. 2018-05-10 17:51:37.758014 [DEBUG] switch_core_media.c:7349 sofia/internal/1000@124.123.68.233:21102 Video thread started. Echo is off
  863. 2018-05-10 17:51:37.758014 [INFO] switch_core_media.c:9400 Activating VIDEO RTCP PORT 21235 interval 1000 mux -1
  864. 2018-05-10 17:51:37.758014 [DEBUG] switch_rtp.c:4673 RTCP send rate is: 1000 and packet rate is: 90000 Remote Port: 21235
  865. 2018-05-10 17:51:37.758014 [DEBUG] switch_rtp.c:2568 Setting RTCP remote addr to 124.123.68.233:21235 2
  866. 2018-05-10 17:51:37.758014 [DEBUG] sofia.c:8208 Processing updated SDP
  867. 2018-05-10 17:51:37.758014 [DEBUG] sofia_glue.c:1299 sofia/internal/1003@icc-tech.com:5020 sending invite version: 1.9.0 git a139bbd 2018-05-09 16:08:24Z 64bit
  868. Local SDP:
  869. v=0
  870. o=FreeSWITCH 1525946413 1525946417 IN IP4 159.89.163.195
  871. s=FreeSWITCH
  872. c=IN IP4 159.89.163.195
  873. t=0 0
  874. m=audio 28270 RTP/AVP 102 9 0 8 103 101
  875. a=rtpmap:102 opus/48000/2
  876. a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40; stereo=1
  877. a=rtpmap:9 G722/8000
  878. a=rtpmap:0 PCMU/8000
  879. a=rtpmap:8 PCMA/8000
  880. a=rtpmap:103 telephone-event/48000
  881. a=fmtp:103 0-16
  882. a=rtpmap:101 telephone-event/8000
  883. a=fmtp:101 0-16
  884. a=ptime:20
  885. a=sendrecv
  886. m=video 22692 RTP/AVP 100
  887. b=AS:1024
  888. a=rtpmap:100 VP8/90000
  889. a=sendrecv
  890. a=rtcp-fb:100 ccm fir
  891. a=rtcp-fb:100 ccm tmmbr
  892. a=rtcp-fb:100 nack
  893. a=rtcp-fb:100 nack pli
  894.  
  895. send 1434 bytes to udp/[106.76.208.110]:49663 at 17:51:37.765655:
  896.    ------------------------------------------------------------------------
  897.    INVITE sip:1003@106.76.208.110:49663;rinstance=c68d10a466e6eed9 SIP/2.0
  898.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport;branch=z9hG4bKBcHSBXN936cDS
  899.    Max-Forwards: 70
  900.    From: <sip:1000@icc-tech.com:5020>;tag=vQUmcm9avt91S
  901.    To: "Brian West" <sip:1003@icc-tech.com:5020>;tag=cfc94962
  902.    Call-ID: ZGRiN2M4Mjk1NDI0OTIxYTQ2ODRmY2MwZTE4YTFkMDY
  903.    CSeq: 122651284 INVITE
  904.    Contact: <sip:1000@159.89.163.195:5020;transport=udp>
  905.    User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20180509T160824Z~a139bbd195~64bit
  906.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  907.    Supported: timer, path, replaces
  908.    Session-Expires: 120;refresher=uac
  909.    Min-SE: 120
  910.    Content-Type: application/sdp
  911.    Content-Length: 659
  912.    X-FS-Support: update_display,send_info
  913.  
  914.    v=0
  915.    o=FreeSWITCH 1525946413 1525946417 IN IP4 159.89.163.195
  916.    s=FreeSWITCH
  917.    c=IN IP4 159.89.163.195
  918.    t=0 0
  919.    m=audio 28270 RTP/AVP 102 9 0 8 103 101
  920.    a=rtpmap:102 opus/48000/2
  921.    a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40; stereo=1
  922.    a=rtpmap:9 G722/8000
  923.    a=rtpmap:0 PCMU/8000
  924.    a=rtpmap:8 PCMA/8000
  925.    a=rtpmap:103 telephone-event/48000
  926.    a=fmtp:103 0-16
  927.    a=rtpmap:101 telephone-event/8000
  928.    a=fmtp:101 0-16
  929.    a=ptime:20
  930.    a=sendrecv
  931.    m=video 22692 RTP/AVP 100
  932.    b=AS:1024
  933.    a=rtpmap:100 VP8/90000
  934.    a=sendrecv
  935.    a=rtcp-fb:100 ccm fir
  936.    a=rtcp-fb:100 ccm tmmbr
  937.    a=rtcp-fb:100 nack
  938.    a=rtcp-fb:100 nack pli
  939.    ------------------------------------------------------------------------
  940. 2018-05-10 17:51:37.758014 [DEBUG] sofia.c:7291 Channel sofia/internal/1003@icc-tech.com:5020 entering state [calling][0]
  941. 2018-05-10 17:51:37.868032 [NOTICE] switch_vpx.c:410 VPX reset encoder picture from 320x240 to 352x288 1024 BW
  942. recv 310 bytes from udp/[106.76.208.110]:49663 at 17:51:37.981570:
  943.    ------------------------------------------------------------------------
  944.    SIP/2.0 100 Trying
  945.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport=5020;branch=z9hG4bKBcHSBXN936cDS
  946.    To: "Brian West" <sip:1003@icc-tech.com:5020>;tag=cfc94962
  947.    From: <sip:1000@icc-tech.com:5020>;tag=vQUmcm9avt91S
  948.    Call-ID: ZGRiN2M4Mjk1NDI0OTIxYTQ2ODRmY2MwZTE4YTFkMDY
  949.    CSeq: 122651284 INVITE
  950.    Content-Length: 0
  951.  
  952.    ------------------------------------------------------------------------
  953. recv 976 bytes from udp/[106.76.208.110]:49663 at 17:51:38.051765:
  954.    ------------------------------------------------------------------------
  955.    SIP/2.0 200 OK
  956.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport=5020;branch=z9hG4bKBcHSBXN936cDS
  957.    Contact: <sip:1003@106.76.208.110:49663;rinstance=c68d10a466e6eed9>
  958.    To: "Brian West"<sip:1003@icc-tech.com:5020>;tag=cfc94962
  959.    From: <sip:1000@icc-tech.com:5020>;tag=vQUmcm9avt91S
  960.    Call-ID: ZGRiN2M4Mjk1NDI0OTIxYTQ2ODRmY2MwZTE4YTFkMDY
  961.    CSeq: 122651284 INVITE
  962.   Allow: INVITE, ACK, CANCEL, BYE, REFER, INFO, NOTIFY, OPTIONS, UPDATE, PRACK, MESSAGE, SUBSCRIBE
  963.    Content-Type: application/sdp
  964.    Supported: replaces
  965.    User-Agent: Bria Stretto iOS release 5.2.4001 stamp 41079.41081
  966.    Content-Length: 385
  967.  
  968.    v=0
  969.    o=- 1525974679157578 2 IN IP4 100.67.7.149
  970.    s=Cpc session
  971.    c=IN IP4 100.67.7.149
  972.    t=0 0
  973.    m=audio 64218 RTP/AVP 102 0 8 101
  974.    a=rtpmap:102 opus/48000/2
  975.    a=fmtp:102 useinbandfec=1; usedtx=1; maxaveragebitrate=64000
  976.    a=rtpmap:101 telephone-event/8000
  977.    a=fmtp:101 0-15
  978.    a=sendrecv
  979.    m=video 62886 RTP/AVP 100
  980.    a=rtpmap:100 VP8/90000
  981.    a=sendrecv
  982.    a=rtcp-fb:* nack
  983.    a=rtcp-fb:* nack pli
  984.    ------------------------------------------------------------------------
  985. 2018-05-10 17:51:38.058042 [DEBUG] sofia.c:7291 Channel sofia/internal/1003@icc-tech.com:5020 entering state [completing][200]
  986. 2018-05-10 17:51:38.058042 [DEBUG] sofia.c:7301 Remote SDP:
  987. v=0
  988. o=- 1525974679157578 2 IN IP4 100.67.7.149
  989. s=Cpc session
  990. c=IN IP4 100.67.7.149
  991. t=0 0
  992. m=audio 64218 RTP/AVP 102 0 8 101
  993. a=rtpmap:102 opus/48000/2
  994. a=fmtp:102 useinbandfec=1; usedtx=1; maxaveragebitrate=64000
  995. a=rtpmap:101 telephone-event/8000
  996. a=fmtp:101 0-15
  997. a=sendrecv
  998. m=video 62886 RTP/AVP 100
  999. a=rtpmap:100 VP8/90000
  1000. a=sendrecv
  1001. a=rtcp-fb:* nack
  1002. a=rtcp-fb:* nack pli
  1003.  
  1004. send 370 bytes to udp/[106.76.208.110]:49663 at 17:51:38.067641:
  1005.    ------------------------------------------------------------------------
  1006.    ACK sip:1003@106.76.208.110:49663;rinstance=c68d10a466e6eed9 SIP/2.0
  1007.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport;branch=z9hG4bKcNajDr6c1F3Zm
  1008.    Max-Forwards: 70
  1009.    From: <sip:1000@icc-tech.com:5020>;tag=vQUmcm9avt91S
  1010.    To: "Brian West" <sip:1003@icc-tech.com:5020>;tag=cfc94962
  1011.    Call-ID: ZGRiN2M4Mjk1NDI0OTIxYTQ2ODRmY2MwZTE4YTFkMDY
  1012.    CSeq: 122651284 ACK
  1013.    Content-Length: 0
  1014.  
  1015.    ------------------------------------------------------------------------
  1016. 2018-05-10 17:51:38.058042 [DEBUG] sofia.c:7291 Channel sofia/internal/1003@icc-tech.com:5020 entering state [ready][200]
  1017. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [opus:102:48000:20:0:1]/[opus:116:48000:20:0:2]
  1018. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:5513 Audio Codec Compare [opus:116:48000:20:0:2] ++++ is saved as a match
  1019. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [opus:102:48000:20:0:1]/[G722:9:8000:20:64000:1]
  1020. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [opus:102:48000:20:0:1]/[PCMU:0:8000:20:64000:1]
  1021. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [opus:102:48000:20:0:1]/[PCMA:8:8000:20:64000:1]
  1022. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:2]
  1023. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  1024. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  1025. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:5513 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  1026. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  1027. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:2]
  1028. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  1029. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  1030. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:5458 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  1031. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:5513 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  1032. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:5374 Set telephone-event payload to 101@8000
  1033. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:5775 sofia/internal/1003@icc-tech.com:5020 Set 2833 dtmf send payload to 101 recv payload to 101
  1034. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:6058 Video Codec Compare [VP8:100]/[VP8:99]
  1035. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:6090 Video Codec Compare [VP8:100] +++ is saved as a match
  1036. 2018-05-10 17:51:38.068019 [DEBUG] switch_vpx.c:636 VPX VER:v1.6.0 VPX_IMAGE_ABI_VERSION:4 VPX_CODEC_ABI_VERSION:7
  1037. 2018-05-10 17:51:38.068019 [DEBUG] switch_vpx.c:636 VPX VER:v1.6.0 VPX_IMAGE_ABI_VERSION:4 VPX_CODEC_ABI_VERSION:7
  1038. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:3583 Set VIDEO Codec sofia/internal/1003@icc-tech.com:5020 VP8/90000 0 ms
  1039. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:8474 Audio params are unchanged for sofia/internal/1003@icc-tech.com:5020.
  1040. 2018-05-10 17:51:38.068019 [DEBUG] switch_rtp.c:4292 Starting video timer.
  1041. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:9320 VIDEO RTP [sofia/internal/1003@icc-tech.com:5020] 159.89.163.195:22692->100.67.7.149:62886 codec: 100 ms: 0 [SUCCESS]
  1042. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:7483 sofia/internal/1003@icc-tech.com:5020 Starting Video thread
  1043. 2018-05-10 17:51:38.068019 [DEBUG] switch_core_media.c:7349 sofia/internal/1003@icc-tech.com:5020 Video thread started. Echo is off
  1044. 2018-05-10 17:51:38.068019 [INFO] switch_core_media.c:9400 Activating VIDEO RTCP PORT 62887 interval 1000 mux -1
  1045. 2018-05-10 17:51:38.068019 [DEBUG] switch_rtp.c:4673 RTCP send rate is: 1000 and packet rate is: 90000 Remote Port: 62887
  1046. 2018-05-10 17:51:38.068019 [DEBUG] switch_rtp.c:2568 Setting RTCP remote addr to 100.67.7.149:62887 2
  1047. send 1118 bytes to udp/[124.123.68.233]:21102 at 17:51:38.077368:
  1048.    ------------------------------------------------------------------------
  1049.    SIP/2.0 200 OK
  1050.    Via: SIP/2.0/UDP 10.144.160.39:49933;branch=z9hG4bK-524287-1---1d377b60adff825e;rport=21102;received=124.123.68.233
  1051.    From: <sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f>;tag=03fadd26
  1052.    To: "Extension 1003" <sip:1003@159.89.163.195>;tag=X0mDeFteS3ZmN
  1053.    Call-ID: 9818cb57-cf1d-1236-a889-528373432f88
  1054.    CSeq: 2 INVITE
  1055.    Contact: <sip:mod_sofia@159.89.163.195:5020>
  1056.    User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20180509T160824Z~a139bbd195~64bit
  1057.    Accept: application/sdp
  1058.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  1059.    Supported: timer, path, replaces
  1060.    Content-Type: application/sdp
  1061.    Content-Disposition: session
  1062.    Content-Length: 400
  1063.  
  1064.    v=0
  1065.    o=FreeSWITCH 1525954505 1525954507 IN IP4 159.89.163.195
  1066.    s=FreeSWITCH
  1067.    c=IN IP4 159.89.163.195
  1068.    t=0 0
  1069.    m=audio 20178 RTP/AVP 102 101
  1070.    a=rtpmap:102 opus/48000/2
  1071.    a=fmtp:102 useinbandfec=1
  1072.    a=rtpmap:101 telephone-event/8000
  1073.    a=fmtp:101 0-16
  1074.    a=ptime:20
  1075.    m=video 28390 RTP/AVP 100
  1076.    b=AS:1024
  1077.    a=rtpmap:100 VP8/90000
  1078.    a=rtcp:28391 IN IP4 159.89.163.195
  1079.    a=rtcp-fb:100 nack
  1080.    a=rtcp-fb:100 nack pli
  1081.    ------------------------------------------------------------------------
  1082. 2018-05-10 17:51:38.068019 [DEBUG] sofia.c:7291 Channel sofia/internal/1000@124.123.68.233:21102 entering state [completed][200]
  1083. recv 499 bytes from udp/[124.123.68.233]:21102 at 17:51:38.122828:
  1084.    ------------------------------------------------------------------------
  1085.    ACK sip:mod_sofia@159.89.163.195:5020 SIP/2.0
  1086.    Via: SIP/2.0/UDP 10.144.160.39:49933;branch=z9hG4bK-524287-1---40d22948c6745c2a;rport
  1087.    Max-Forwards: 70
  1088.    Contact: <sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f>
  1089.    To: "Extension 1003" <sip:1003@159.89.163.195>;tag=X0mDeFteS3ZmN
  1090.    From: <sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f>;tag=03fadd26
  1091.    Call-ID: 9818cb57-cf1d-1236-a889-528373432f88
  1092.    CSeq: 2 ACK
  1093.    User-Agent: Bria Stretto release 5.2.0 stamp 90726
  1094.    Content-Length: 0
  1095.  
  1096.    ------------------------------------------------------------------------
  1097. 2018-05-10 17:51:38.128034 [DEBUG] sofia.c:7291 Channel sofia/internal/1000@124.123.68.233:21102 entering state [ready][200]
  1098. 2018-05-10 17:51:38.208033 [DEBUG] switch_rtp.c:6930 Correct video RTCP ip/port confirmed.
  1099. 2018-05-10 17:51:38.418034 [DEBUG] switch_rtp.c:1886 rtcp_stats_init: video ssrc[2140545607] base_seq[26864]
  1100. 2018-05-10 17:51:38.468057 [DEBUG] switch_rtp.c:7490 Correct video ip/port confirmed.
  1101. 2018-05-10 17:51:38.768041 [INFO] switch_rtp.c:6909 Auto Changing video RTCP port from 100.67.7.149:62887 to 106.76.208.110:62887
  1102. 2018-05-10 17:51:38.768041 [DEBUG] switch_rtp.c:2568 Setting RTCP remote addr to 106.76.208.110:62887 2
  1103. recv 776 bytes from udp/[106.76.208.110]:49663 at 17:51:50.341235:
  1104.    ------------------------------------------------------------------------
  1105.    BYE sip:1000@159.89.163.195:5020;transport=udp SIP/2.0
  1106.    Via: SIP/2.0/UDP 100.67.7.149:49663;branch=z9hG4bK-524287-1---312cdc292acf5c32;rport
  1107.    Max-Forwards: 70
  1108.    Contact: <sip:1003@106.76.208.110:49663;rinstance=c68d10a466e6eed9>
  1109.    To: <sip:1000@icc-tech.com:5020>;tag=vQUmcm9avt91S
  1110.    From: "Brian West"<sip:1003@icc-tech.com:5020>;tag=cfc94962
  1111.    Call-ID: ZGRiN2M4Mjk1NDI0OTIxYTQ2ODRmY2MwZTE4YTFkMDY
  1112.    CSeq: 3 BYE
  1113.    Proxy-Authorization: Digest username="1003",realm="icc-tech.com",nonce="b9660709-36c8-45de-a71c-99d8337a0f0a",uri="sip:1000@159.89.163.195:5020;transport=udp",response="34d2fa3e6eb305f33375e5c86aec7b95",cnonce="f28b91a5197ae923f3b841c671e4c385",nc=00000002,qop=auth,algorithm=MD5
  1114.    User-Agent: Bria Stretto iOS release 5.2.4001 stamp 41079.41081
  1115.    Content-Length: 0
  1116.  
  1117.    ------------------------------------------------------------------------
  1118. 2018-05-10 17:51:50.338017 [NOTICE] sofia.c:1079 Hangup sofia/internal/1003@icc-tech.com:5020 [CS_EXECUTE] [NORMAL_CLEARING]
  1119. send 555 bytes to udp/[106.76.208.110]:49663 at 17:51:50.347014:
  1120.    ------------------------------------------------------------------------
  1121.    SIP/2.0 200 OK
  1122.    Via: SIP/2.0/UDP 100.67.7.149:49663;branch=z9hG4bK-524287-1---312cdc292acf5c32;rport=49663;received=106.76.208.110
  1123.    From: "Brian West"<sip:1003@icc-tech.com:5020>;tag=cfc94962
  1124.    To: <sip:1000@icc-tech.com:5020>;tag=vQUmcm9avt91S
  1125.    Call-ID: ZGRiN2M4Mjk1NDI0OTIxYTQ2ODRmY2MwZTE4YTFkMDY
  1126.    CSeq: 3 BYE
  1127.    User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20180509T160824Z~a139bbd195~64bit
  1128.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  1129.    Supported: timer, path, replaces
  1130.    Content-Length: 0
  1131.  
  1132.    ------------------------------------------------------------------------
  1133. 2018-05-10 17:51:50.338017 [DEBUG] switch_ivr_bridge.c:848 Ending video thread.
  1134. 2018-05-10 17:51:50.338017 [DEBUG] switch_ivr_bridge.c:906 Ending video thread.
  1135. 2018-05-10 17:51:50.338017 [DEBUG] switch_ivr_bridge.c:255 sofia/internal/1003@icc-tech.com:5020 video thread ended.
  1136. 2018-05-10 17:51:50.338017 [DEBUG] switch_ivr_bridge.c:257 sofia/internal/1003@icc-tech.com:5020 skip receive message [DISPLAY] (channel is hungup already)
  1137. 2018-05-10 17:51:50.348029 [DEBUG] switch_core_media.c:7450 sofia/internal/1003@icc-tech.com:5020 Video thread ended
  1138. 2018-05-10 17:51:50.348029 [DEBUG] switch_ivr_bridge.c:825 sofia/internal/1003@icc-tech.com:5020 ending bridge by request from write function
  1139. 2018-05-10 17:51:50.348029 [DEBUG] switch_ivr_bridge.c:848 Ending video thread.
  1140. 2018-05-10 17:51:50.348029 [DEBUG] switch_ivr_bridge.c:906 Ending video thread.
  1141. 2018-05-10 17:51:50.348029 [DEBUG] switch_ivr_bridge.c:917 BRIDGE THREAD DONE [sofia/internal/1003@icc-tech.com:5020]
  1142. 2018-05-10 17:51:50.378024 [DEBUG] switch_ivr_bridge.c:255 sofia/internal/1000@124.123.68.233:21102 video thread ended.
  1143. 2018-05-10 17:51:50.378024 [DEBUG] switch_ivr_bridge.c:917 BRIDGE THREAD DONE [sofia/internal/1000@124.123.68.233:21102]
  1144. 2018-05-10 17:51:50.378024 [NOTICE] switch_ivr_bridge.c:1034 Hangup sofia/internal/1000@124.123.68.233:21102 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
  1145. 2018-05-10 17:51:50.378024 [DEBUG] switch_core_state_machine.c:653 (sofia/internal/1000@124.123.68.233:21102) State EXCHANGE_MEDIA going to sleep
  1146. 2018-05-10 17:51:50.378024 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1000@124.123.68.233:21102) Running State Change CS_HANGUP (Cur 2 Tot 31)
  1147. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/1000@124.123.68.233:21102) Callstate Change ACTIVE -> HANGUP
  1148. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1000@124.123.68.233:21102) State HANGUP
  1149. 2018-05-10 17:51:50.388018 [DEBUG] mod_sofia.c:443 sofia/internal/1000@124.123.68.233:21102 Overriding SIP cause 480 with 200 from the other leg
  1150. 2018-05-10 17:51:50.388018 [DEBUG] mod_sofia.c:449 Channel sofia/internal/1000@124.123.68.233:21102 hanging up, cause: NORMAL_CLEARING
  1151. 2018-05-10 17:51:50.388018 [DEBUG] mod_sofia.c:502 Sending BYE to sofia/internal/1000@124.123.68.233:21102
  1152. send 663 bytes to udp/[124.123.68.233]:21102 at 17:51:50.389368:
  1153.    ------------------------------------------------------------------------
  1154.    BYE sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f SIP/2.0
  1155.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport;branch=z9hG4bKDy3aFKQgyrSjg
  1156.    Max-Forwards: 70
  1157.    From: "Extension 1003" <sip:1003@159.89.163.195>;tag=X0mDeFteS3ZmN
  1158.    To: <sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f>;tag=03fadd26
  1159.    Call-ID: 9818cb57-cf1d-1236-a889-528373432f88
  1160.    CSeq: 122651278 BYE
  1161.    User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20180509T160824Z~a139bbd195~64bit
  1162.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  1163.    Supported: timer, path, replaces
  1164.    Reason: Q.850;cause=16;text="NORMAL_CLEARING"
  1165.    Content-Length: 0
  1166.  
  1167.    ------------------------------------------------------------------------
  1168. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1000@124.123.68.233:21102 Standard HANGUP, cause: NORMAL_CLEARING
  1169. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1000@124.123.68.233:21102) State HANGUP going to sleep
  1170. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/1000@124.123.68.233:21102) State Change CS_HANGUP -> CS_REPORTING
  1171. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1000@124.123.68.233:21102) Running State Change CS_REPORTING (Cur 2 Tot 31)
  1172. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1000@124.123.68.233:21102) State REPORTING
  1173. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:174 sofia/internal/1000@124.123.68.233:21102 Standard REPORTING, cause: NORMAL_CLEARING
  1174. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1000@124.123.68.233:21102) State REPORTING going to sleep
  1175. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/1000@124.123.68.233:21102) State Change CS_REPORTING -> CS_DESTROY
  1176. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_session.c:1713 Session 31 (sofia/internal/1000@124.123.68.233:21102) Locked, Waiting on external entities
  1177. 2018-05-10 17:51:50.388018 [DEBUG] switch_ivr_bridge.c:1846 sofia/internal/1003@icc-tech.com:5020 skip receive message [TRANSFER] (channel is hungup already)
  1178. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_session.c:2885 sofia/internal/1003@icc-tech.com:5020 skip receive message [PHONE_EVENT] (channel is hungup already)
  1179. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/1003@icc-tech.com:5020) State EXECUTE going to sleep
  1180. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1003@icc-tech.com:5020) Running State Change CS_HANGUP (Cur 2 Tot 31)
  1181. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/1003@icc-tech.com:5020) Callstate Change ACTIVE -> HANGUP
  1182. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1003@icc-tech.com:5020) State HANGUP
  1183. 2018-05-10 17:51:50.388018 [DEBUG] mod_sofia.c:449 Channel sofia/internal/1003@icc-tech.com:5020 hanging up, cause: NORMAL_CLEARING
  1184. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1003@icc-tech.com:5020 Standard HANGUP, cause: NORMAL_CLEARING
  1185. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1003@icc-tech.com:5020) State HANGUP going to sleep
  1186. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/1003@icc-tech.com:5020) State Change CS_HANGUP -> CS_REPORTING
  1187. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1003@icc-tech.com:5020) Running State Change CS_REPORTING (Cur 2 Tot 31)
  1188. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1003@icc-tech.com:5020) State REPORTING
  1189. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:174 sofia/internal/1003@icc-tech.com:5020 Standard REPORTING, cause: NORMAL_CLEARING
  1190. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1003@icc-tech.com:5020) State REPORTING going to sleep
  1191. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/1003@icc-tech.com:5020) State Change CS_REPORTING -> CS_DESTROY
  1192. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_session.c:1713 Session 30 (sofia/internal/1003@icc-tech.com:5020) Locked, Waiting on external entities
  1193. 2018-05-10 17:51:50.388018 [NOTICE] switch_core_session.c:1731 Session 30 (sofia/internal/1003@icc-tech.com:5020) Ended
  1194. 2018-05-10 17:51:50.388018 [NOTICE] switch_core_session.c:1735 Close Channel sofia/internal/1003@icc-tech.com:5020 [CS_DESTROY]
  1195. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/1003@icc-tech.com:5020) Running State Change CS_DESTROY (Cur 1 Tot 31)
  1196. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1003@icc-tech.com:5020) State DESTROY
  1197. 2018-05-10 17:51:50.388018 [DEBUG] mod_sofia.c:354 sofia/internal/1003@icc-tech.com:5020 SOFIA DESTROY
  1198. 2018-05-10 17:51:50.388018 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[116] PLC[0] FEC[0]
  1199. 2018-05-10 17:51:50.388018 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[0] Bytes encoded[0] Encoded length ms[0] Average encoded bitrate bps[0]
  1200. 2018-05-10 17:51:50.388018 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[0] PLC[0] FEC[0]
  1201. 2018-05-10 17:51:50.388018 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[174] Bytes encoded[14581] Encoded length ms[3480] Average encoded bitrate bps[38882]
  1202. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:181 sofia/internal/1003@icc-tech.com:5020 Standard DESTROY
  1203. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1003@icc-tech.com:5020) State DESTROY going to sleep
  1204. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_media.c:7450 sofia/internal/1000@124.123.68.233:21102 Video thread ended
  1205. 2018-05-10 17:51:50.388018 [NOTICE] switch_core_session.c:1731 Session 31 (sofia/internal/1000@124.123.68.233:21102) Ended
  1206. 2018-05-10 17:51:50.388018 [NOTICE] switch_core_session.c:1735 Close Channel sofia/internal/1000@124.123.68.233:21102 [CS_DESTROY]
  1207. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/1000@124.123.68.233:21102) Running State Change CS_DESTROY (Cur 0 Tot 31)
  1208. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1000@124.123.68.233:21102) State DESTROY
  1209. 2018-05-10 17:51:50.388018 [DEBUG] mod_sofia.c:354 sofia/internal/1000@124.123.68.233:21102 SOFIA DESTROY
  1210. 2018-05-10 17:51:50.388018 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[0] PLC[0] FEC[0]
  1211. 2018-05-10 17:51:50.388018 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[0] Bytes encoded[0] Encoded length ms[0] Average encoded bitrate bps[0]
  1212. 2018-05-10 17:51:50.388018 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[0] PLC[0] FEC[0]
  1213. 2018-05-10 17:51:50.388018 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[0] Bytes encoded[0] Encoded length ms[0] Average encoded bitrate bps[0]
  1214. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:181 sofia/internal/1000@124.123.68.233:21102 Standard DESTROY
  1215. 2018-05-10 17:51:50.388018 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1000@124.123.68.233:21102) State DESTROY going to sleep
  1216. recv 448 bytes from udp/[124.123.68.233]:21102 at 17:51:50.455352:
  1217.    ------------------------------------------------------------------------
  1218.    SIP/2.0 200 OK
  1219.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport=5020;branch=z9hG4bKDy3aFKQgyrSjg
  1220.    Contact: <sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f>
  1221.    To: <sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f>;tag=03fadd26
  1222.    From: "Extension 1003" <sip:1003@159.89.163.195>;tag=X0mDeFteS3ZmN
  1223.    Call-ID: 9818cb57-cf1d-1236-a889-528373432f88
  1224.    CSeq: 122651278 BYE
  1225.    User-Agent: Bria Stretto release 5.2.0 stamp 90726
  1226.    Content-Length: 0
  1227.  
  1228.    ------------------------------------------------------------------------
  1229. recv 651 bytes from udp/[124.123.68.233]:21102 at 17:52:24.208795:
  1230.    ------------------------------------------------------------------------
  1231.    SUBSCRIBE sip:1000@159.89.163.195:5020 SIP/2.0
  1232.    Via: SIP/2.0/UDP 10.144.160.39:49933;branch=z9hG4bK-524287-1---52bb2d32cf8c7d08;rport
  1233.    Max-Forwards: 70
  1234.    Contact: <sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f>
  1235.    To: <sip:1000@159.89.163.195:5020>;tag=fMWlF8WwfHPO
  1236.    From: "shashi" <sip:1000@159.89.163.195:5020>;tag=835a095d
  1237.    Call-ID: 90726NzQ5NGNkZmEwZjJjMzg3ZmY0ZGRjYzQ1Y2RmZTI5MDU
  1238.    CSeq: 34 SUBSCRIBE
  1239.    Expires: 60
  1240.    Accept: application/simple-message-summary
  1241.   Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
  1242.    User-Agent: Bria Stretto release 5.2.0 stamp 90726
  1243.    Event: message-summary
  1244.    Content-Length: 0
  1245.  
  1246.    ------------------------------------------------------------------------
  1247. send 838 bytes to udp/[124.123.68.233]:21102 at 17:52:24.209990:
  1248.    ------------------------------------------------------------------------
  1249.    SIP/2.0 202 Accepted
  1250.    Via: SIP/2.0/UDP 10.144.160.39:49933;branch=z9hG4bK-524287-1---52bb2d32cf8c7d08;rport=21102;received=124.123.68.233
  1251.    From: "shashi" <sip:1000@159.89.163.195:5020>;tag=835a095d
  1252.    To: <sip:1000@159.89.163.195:5020>;tag=fMWlF8WwfHPO
  1253.    Call-ID: 90726NzQ5NGNkZmEwZjJjMzg3ZmY0ZGRjYzQ1Y2RmZTI5MDU
  1254.    CSeq: 34 SUBSCRIBE
  1255.    Contact: <sip:1000@159.89.163.195:5020>
  1256.    Expires: 60
  1257.    User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20180509T160824Z~a139bbd195~64bit
  1258.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  1259.    Supported: timer, path, replaces
  1260.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  1261.    Subscription-State: active;expires=60
  1262.    Content-Length: 0
  1263.  
  1264.    ------------------------------------------------------------------------
  1265. send 994 bytes to udp/[124.123.68.233]:21102 at 17:52:24.315222:
  1266.    ------------------------------------------------------------------------
  1267.    NOTIFY sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f SIP/2.0
  1268.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport;branch=z9hG4bKe7v3ge8KU1F5B
  1269.    Max-Forwards: 70
  1270.    From: <sip:1000@159.89.163.195:5020>;tag=fMWlF8WwfHPO
  1271.    To: "shashi" <sip:1000@159.89.163.195:5020>;tag=835a095d
  1272.    Call-ID: 90726NzQ5NGNkZmEwZjJjMzg3ZmY0ZGRjYzQ1Y2RmZTI5MDU
  1273.    CSeq: 560497201 NOTIFY
  1274.    Contact: <sip:1000@159.89.163.195:5020>
  1275.    User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20180509T160824Z~a139bbd195~64bit
  1276.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  1277.    Supported: timer, path, replaces
  1278.    Event: message-summary
  1279.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  1280.    Subscription-State: active;expires=60
  1281.    Content-Type: application/simple-message-summary
  1282.    Content-Length: 66
  1283.  
  1284.    Messages-Waiting: no
  1285.    Message-Account: sip:1000@159.89.163.195
  1286.  
  1287.    ------------------------------------------------------------------------
  1288. recv 430 bytes from udp/[124.123.68.233]:21102 at 17:52:24.336615:
  1289.    ------------------------------------------------------------------------
  1290.    SIP/2.0 200 OK
  1291.    Via: SIP/2.0/UDP 159.89.163.195:5020;rport=5020;branch=z9hG4bKe7v3ge8KU1F5B
  1292.    Contact: <sip:1000@124.123.68.233:21102;rinstance=f72e49e8403a7e5f>
  1293.    To: "shashi"<sip:1000@159.89.163.195:5020>;tag=835a095d
  1294.    From: <sip:1000@159.89.163.195:5020>;tag=fMWlF8WwfHPO
  1295.    Call-ID: 90726NzQ5NGNkZmEwZjJjMzg3ZmY0ZGRjYzQ1Y2RmZTI5MDU
  1296.    CSeq: 560497201 NOTIFY
  1297.    User-Agent: Bria Stretto release 5.2.0 stamp 90726
  1298.    Content-Length: 0
  1299.  
  1300.    ------------------------------------------------------------------------
  1301. freeswitch@debian-s-1vcpu-1gb-blr1-01> /exit
  1302.