FreeSWITCH Pastebin

working-arvind-in-bkg

From Small Monkey, 5 Years ago, written in FreeSWITCH.
- view diff
URL https://pastebin.freeswitch.org/view/9c6ce90d
Embed
Download Paste or View Raw
  1.  
  2. recv 1053 bytes from tls/[103.249.234.189]:55144 at 13:02:39.052978:
  3.    ------------------------------------------------------------------------
  4.    INVITE sip:wifi%23CTTESTCALL027@81.95.124.28:5061 SIP/2.0
  5.    v: SIP/2.0/TLS 192.168.1.176:37032;rport;branch=z9hG4bKPj4HmVCkHNlEAbQXOPXbpBHNp9ob9pYK1A;alias
  6.    Max-Forwards: 70
  7.    f: <sip:CTTESTCALL029@81.95.124.28>;tag=LeV4xZGeHULUa2UgZgPiR9U9e3HmtlE3
  8.    t: <sip:wifi%23CTTESTCALL027@81.95.124.28>
  9.    m: <sip:CTTESTCALL029@192.168.1.176:37032;transport=TLS;ob>
  10.    i: 7zHizyRvhAqxBZ7UxUQdmjUfEbDtjAma
  11.    CSeq: 645 INVITE
  12.    Route: <sip:81.95.124.28:5061;transport=tls;lr>
  13.    k: replaces, 100rel, timer, norefersub
  14.    x: 1800
  15.    Min-SE: 180
  16.    User-Agent: CallApp
  17.    c: application/sdp
  18.    l:   481
  19.    
  20.    v=0
  21.    o=- 3757937296 3757937296 IN IP4 192.168.1.176
  22.    s=pjmedia
  23.    c=IN IP4 192.168.1.176
  24.    t=0 0
  25.    m=audio 4010 RTP/SAVP 111 0 8 101
  26.    c=IN IP4 192.168.1.176
  27.    a=rtcp:4011 IN IP4 192.168.1.176
  28.    a=sendrecv
  29.    a=rtpmap:111 opus/48000/2
  30.    a=fmtp:111 maxplaybackrate=16000
  31.    a=rtpmap:101 telephone-event/8000
  32.    a=fmtp:101 0-16
  33.    a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:QJToSC+Zoi8YxFchaC0b/lonDpf3HrmIqdSyuw7v
  34.    a=crypto:2 AES_CM_128_HMAC_SHA1_32 inline:mmd2h2zW0bGnB8/1Ppj6BTDym2pMMghr3utJo4xr
  35.    ------------------------------------------------------------------------
  36. send 363 bytes to tls/[103.249.234.189]:55144 at 13:02:39.053234:
  37.    ------------------------------------------------------------------------
  38.    SIP/2.0 100 Trying
  39.    Via: SIP/2.0/TLS 192.168.1.176:37032;rport=55144;branch=z9hG4bKPj4HmVCkHNlEAbQXOPXbpBHNp9ob9pYK1A;alias;received=103.249.234.189
  40.    f: <sip:CTTESTCALL029@81.95.124.28>;tag=LeV4xZGeHULUa2UgZgPiR9U9e3HmtlE3
  41.    t: <sip:wifi%23CTTESTCALL027@81.95.124.28>
  42.    i: 7zHizyRvhAqxBZ7UxUQdmjUfEbDtjAma
  43.    CSeq: 645 INVITE
  44.    User-Agent: ASTPP
  45.    Content-Length: 0
  46.    
  47.    ------------------------------------------------------------------------
  48. 2019-01-31 13:02:39.043044 [NOTICE] switch_channel.c:1104 New Channel sofia/default/CTTESTCALL029@81.95.124.28 [d1cc0546-0497-4b7d-995c-0729a4d2abac]
  49. 2019-01-31 13:02:39.043044 [DEBUG] switch_core_state_machine.c:584 (sofia/default/CTTESTCALL029@81.95.124.28) Running State Change CS_NEW (Cur 1 Tot 33)
  50. 2019-01-31 13:02:39.043044 [DEBUG] sofia.c:9873 sofia/default/CTTESTCALL029@81.95.124.28 receiving invite from 103.249.234.189:55144 version: 1.6.19 git 7a77e0b 2017-07-13 12:01:45Z 64bit
  51. 2019-01-31 13:02:39.043044 [DEBUG] sofia.c:10044 IP 103.249.234.189 Rejected by acl "default". Falling back to Digest auth.
  52. 2019-01-31 13:02:39.043044 [WARNING] sofia_reg.c:1792 SIP auth challenge (INVITE) on sofia profile 'default' for [wifi%23CTTESTCALL027@81.95.124.28] from ip 103.249.234.189
  53. 2019-01-31 13:02:39.043044 [DEBUG] switch_core_state_machine.c:603 (sofia/default/CTTESTCALL029@81.95.124.28) State NEW
  54. send 853 bytes to tls/[103.249.234.189]:55144 at 13:02:39.054336:
  55.    ------------------------------------------------------------------------
  56.    SIP/2.0 407 Proxy Authentication Required
  57.    Via: SIP/2.0/TLS 192.168.1.176:37032;rport=55144;branch=z9hG4bKPj4HmVCkHNlEAbQXOPXbpBHNp9ob9pYK1A;alias;received=103.249.234.189
  58.    f: <sip:CTTESTCALL029@81.95.124.28>;tag=LeV4xZGeHULUa2UgZgPiR9U9e3HmtlE3
  59.    To: <sip:wifi%23CTTESTCALL027@81.95.124.28>;tag=K2Be9KtBBUrcB
  60.    i: 7zHizyRvhAqxBZ7UxUQdmjUfEbDtjAma
  61.    CSeq: 645 INVITE
  62.    User-Agent: ASTPP
  63.    Accept: application/sdp
  64.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, NOTIFY, PUBLISH, SUBSCRIBE
  65.    Supported: path, replaces
  66.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  67.    Proxy-Authenticate: Digest realm="81.95.124.28", nonce="f3abf057-8016-446a-9777-277a0f39f7b6", algorithm=MD5, qop="auth"
  68.    Content-Length: 0
  69.    
  70.    ------------------------------------------------------------------------
  71. 2019-01-31 13:02:39.043044 [DEBUG] sofia.c:2334 detaching session d1cc0546-0497-4b7d-995c-0729a4d2abac
  72. recv 417 bytes from tls/[103.249.234.189]:55144 at 13:02:39.192875:
  73.    ------------------------------------------------------------------------
  74.    ACK sip:wifi%23CTTESTCALL027@81.95.124.28:5061 SIP/2.0
  75.    v: SIP/2.0/TLS 192.168.1.176:37032;rport;branch=z9hG4bKPj4HmVCkHNlEAbQXOPXbpBHNp9ob9pYK1A;alias
  76.    Max-Forwards: 70
  77.    f: <sip:CTTESTCALL029@81.95.124.28>;tag=LeV4xZGeHULUa2UgZgPiR9U9e3HmtlE3
  78.    t: <sip:wifi%23CTTESTCALL027@81.95.124.28>;tag=K2Be9KtBBUrcB
  79.    i: 7zHizyRvhAqxBZ7UxUQdmjUfEbDtjAma
  80.    CSeq: 645 ACK
  81.    Route: <sip:81.95.124.28:5061;transport=tls;lr>
  82.    l:  0
  83.    
  84.    ------------------------------------------------------------------------
  85. recv 1351 bytes from tls/[103.249.234.189]:55144 at 13:02:39.368783:
  86.    ------------------------------------------------------------------------
  87.    INVITE sip:wifi%23CTTESTCALL027@81.95.124.28:5061 SIP/2.0
  88.    v: SIP/2.0/TLS 192.168.1.176:37032;rport;branch=z9hG4bKPjdupoVmLqSsNyzqdhAwlE-pEvSVQAVcRs;alias
  89.    Max-Forwards: 70
  90.    f: <sip:CTTESTCALL029@81.95.124.28>;tag=LeV4xZGeHULUa2UgZgPiR9U9e3HmtlE3
  91.    t: <sip:wifi%23CTTESTCALL027@81.95.124.28>
  92.    m: <sip:CTTESTCALL029@192.168.1.176:37032;transport=TLS;ob>
  93.    i: 7zHizyRvhAqxBZ7UxUQdmjUfEbDtjAma
  94.    CSeq: 646 INVITE
  95.    Route: <sip:81.95.124.28:5061;transport=tls;lr>
  96.    k: replaces, 100rel, timer, norefersub
  97.    x: 1800
  98.    Min-SE: 180
  99.    User-Agent: CallApp
  100.    Proxy-Authorization: Digest username="CTTESTCALL029", realm="81.95.124.28", nonce="f3abf057-8016-446a-9777-277a0f39f7b6", uri="sip:wifi%23CTTESTCALL027@81.95.124.28:5061", response="b79ea7d5167cc470fb76f9bdbebc2fcb", algorithm=MD5, cnonce="Zj0Y5DMTJYjQE69V0CpNFHCFBIeXF-On", qop=auth, nc=00000001
  101.    c: application/sdp
  102.    l:   481
  103.    
  104.    v=0
  105.    o=- 3757937296 3757937296 IN IP4 192.168.1.176
  106.    s=pjmedia
  107.    c=IN IP4 192.168.1.176
  108.    t=0 0
  109.    m=audio 4010 RTP/SAVP 111 0 8 101
  110.    c=IN IP4 192.168.1.176
  111.    a=rtcp:4011 IN IP4 192.168.1.176
  112.    a=sendrecv
  113.    a=rtpmap:111 opus/48000/2
  114.    a=fmtp:111 maxplaybackrate=16000
  115.    a=rtpmap:101 telephone-event/8000
  116.    a=fmtp:101 0-16
  117.    a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:QJToSC+Zoi8YxFchaC0b/lonDpf3HrmIqdSyuw7v
  118.    a=crypto:2 AES_CM_128_HMAC_SHA1_32 inline:mmd2h2zW0bGnB8/1Ppj6BTDym2pMMghr3utJo4xr
  119.    ------------------------------------------------------------------------
  120. send 363 bytes to tls/[103.249.234.189]:55144 at 13:02:39.369030:
  121.    ------------------------------------------------------------------------
  122.    SIP/2.0 100 Trying
  123.    Via: SIP/2.0/TLS 192.168.1.176:37032;rport=55144;branch=z9hG4bKPjdupoVmLqSsNyzqdhAwlE-pEvSVQAVcRs;alias;received=103.249.234.189
  124.    f: <sip:CTTESTCALL029@81.95.124.28>;tag=LeV4xZGeHULUa2UgZgPiR9U9e3HmtlE3
  125.    t: <sip:wifi%23CTTESTCALL027@81.95.124.28>
  126.    i: 7zHizyRvhAqxBZ7UxUQdmjUfEbDtjAma
  127.    CSeq: 646 INVITE
  128.    User-Agent: ASTPP
  129.    Content-Length: 0
  130.    
  131.    ------------------------------------------------------------------------
  132. 2019-01-31 13:02:39.363048 [DEBUG] sofia.c:2442 Re-attaching to session d1cc0546-0497-4b7d-995c-0729a4d2abac
  133. 2019-01-31 13:02:39.363048 [DEBUG] sofia.c:9873 sofia/default/CTTESTCALL029@81.95.124.28 receiving invite from 103.249.234.189:55144 version: 1.6.19 git 7a77e0b 2017-07-13 12:01:45Z 64bit
  134. 2019-01-31 13:02:39.363048 [DEBUG] sofia.c:10044 IP 103.249.234.189 Rejected by acl "default". Falling back to Digest auth.
  135. 2019-01-31 13:02:39.543051 [DEBUG] sofia.c:11168 Setting NAT mode based on via received
  136. 2019-01-31 13:02:39.543051 [DEBUG] sofia.c:7084 Channel sofia/default/CTTESTCALL029@81.95.124.28 entering state [received][100]
  137. 2019-01-31 13:02:39.543051 [DEBUG] sofia.c:7094 Remote SDP:
  138. v=0
  139. o=- 3757937296 3757937296 IN IP4 192.168.1.176
  140. s=pjmedia
  141. c=IN IP4 192.168.1.176
  142. t=0 0
  143. m=audio 4010 RTP/SAVP 111 0 8 101
  144. c=IN IP4 192.168.1.176
  145. a=rtpmap:111 opus/48000/2
  146. a=fmtp:111 maxplaybackrate=16000
  147. a=rtpmap:101 telephone-event/8000
  148. a=fmtp:101 0-16
  149. a=rtcp:4011 IN IP4 192.168.1.176
  150. a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:QJToSC+Zoi8YxFchaC0b/lonDpf3HrmIqdSyuw7v
  151. a=crypto:2 AES_CM_128_HMAC_SHA1_32 inline:mmd2h2zW0bGnB8/1Ppj6BTDym2pMMghr3utJo4xr
  152.  
  153. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_media.c:1395 looking for crypto suite [AEAD_AES_256_GCM_8] in [1 AES_CM_128_HMAC_SHA1_80 inline:QJToSC+Zoi8YxFchaC0b/lonDpf3HrmIqdSyuw7v]
  154. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_media.c:1395 looking for crypto suite [AEAD_AES_128_GCM_8] in [1 AES_CM_128_HMAC_SHA1_80 inline:QJToSC+Zoi8YxFchaC0b/lonDpf3HrmIqdSyuw7v]
  155. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_media.c:1395 looking for crypto suite [AES_CM_256_HMAC_SHA1_80] in [1 AES_CM_128_HMAC_SHA1_80 inline:QJToSC+Zoi8YxFchaC0b/lonDpf3HrmIqdSyuw7v]
  156. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_media.c:1395 looking for crypto suite [AES_CM_192_HMAC_SHA1_80] in [1 AES_CM_128_HMAC_SHA1_80 inline:QJToSC+Zoi8YxFchaC0b/lonDpf3HrmIqdSyuw7v]
  157. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_media.c:1395 looking for crypto suite [AES_CM_128_HMAC_SHA1_80] in [1 AES_CM_128_HMAC_SHA1_80 inline:QJToSC+Zoi8YxFchaC0b/lonDpf3HrmIqdSyuw7v]
  158. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_media.c:1400 Found suite AES_CM_128_HMAC_SHA1_80
  159. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_media.c:1466 Set Remote Key [1 AES_CM_128_HMAC_SHA1_80 inline:QJToSC+Zoi8YxFchaC0b/lonDpf3HrmIqdSyuw7v]
  160. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_media.c:1128 Set Local audio crypto Key [1 AES_CM_128_HMAC_SHA1_80 inline:nNL3KcLr541WF/YlClUdz/9zza85ke6XSt1jBsjW]
  161. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [opus:111:48000:20:0:1]/[PCMA:8:8000:20:64000:1]
  162. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [opus:111:48000:20:0:1]/[PCMU:0:8000:20:64000:1]
  163. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [opus:111:48000:20:0:1]/[G729:18:8000:20:8000:1]
  164. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  165. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  166. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  167. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G729:18:8000:20:8000:1]
  168. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  169. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  170. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  171. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G729:18:8000:20:8000:1]
  172. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
  173. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_media.c:3061 Set Codec sofia/default/CTTESTCALL029@81.95.124.28 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  174. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_codec.c:111 sofia/default/CTTESTCALL029@81.95.124.28 Original read codec set to PCMU:0
  175. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
  176. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_media.c:4767 sofia/default/CTTESTCALL029@81.95.124.28 Set 2833 dtmf send payload to 101 recv payload to 101
  177. 2019-01-31 13:02:39.543051 [DEBUG] sofia.c:7507 (sofia/default/CTTESTCALL029@81.95.124.28) State Change CS_NEW -> CS_INIT
  178. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_state_machine.c:584 (sofia/default/CTTESTCALL029@81.95.124.28) Running State Change CS_INIT (Cur 1 Tot 33)
  179. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_state_machine.c:627 (sofia/default/CTTESTCALL029@81.95.124.28) State INIT
  180. 2019-01-31 13:02:39.543051 [DEBUG] mod_sofia.c:90 sofia/default/CTTESTCALL029@81.95.124.28 SOFIA INIT
  181. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_state_machine.c:40 sofia/default/CTTESTCALL029@81.95.124.28 Standard INIT
  182. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_state_machine.c:48 (sofia/default/CTTESTCALL029@81.95.124.28) State Change CS_INIT -> CS_ROUTING
  183. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_state_machine.c:627 (sofia/default/CTTESTCALL029@81.95.124.28) State INIT going to sleep
  184. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_state_machine.c:584 (sofia/default/CTTESTCALL029@81.95.124.28) Running State Change CS_ROUTING (Cur 1 Tot 33)
  185. 2019-01-31 13:02:39.543051 [DEBUG] switch_channel.c:2249 (sofia/default/CTTESTCALL029@81.95.124.28) Callstate Change DOWN -> RINGING
  186. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_state_machine.c:643 (sofia/default/CTTESTCALL029@81.95.124.28) State ROUTING
  187. 2019-01-31 13:02:39.543051 [DEBUG] mod_sofia.c:143 sofia/default/CTTESTCALL029@81.95.124.28 SOFIA ROUTING
  188. 2019-01-31 13:02:39.543051 [DEBUG] switch_core_state_machine.c:236 sofia/default/CTTESTCALL029@81.95.124.28 Standard ROUTING
  189. 2019-01-31 13:02:39.543051 [INFO] mod_dialplan_xml.c:637 Processing CTTESTCALL029 <CTTESTCALL029>->wifi#CTTESTCALL027 in context default
  190. span style="color: goldenrod; font-weight: bold;"> 2019-01-31 13:02:39.563076 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f403806ab70 Connected.
  191. 2019-01-31 13:02:39.563076 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [LOAD_CONF] Query :SELECT name,value FROM system WHERE group_title IN ('global','opensips','callingcard')
  192. 2019-01-31 13:02:39.743118 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Dialed number using WIFI : CTTESTCALL027
  193. 2019-01-31 13:02:39.743118 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Dialed number : CTTESTCALL027
  194. 2019-01-31 13:02:39.743118 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Caller Id name / number  : 029 / CTTESTCALL029
  195. 2019-01-31 13:02:39.743118 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,B.id as accountid,B.number as account_code,B.did_cid_translation as did_cid_translation,A.number as  did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout FROM dids AS A,accounts AS B WHERE A.status=0 AND B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="CTTESTCALL027" LIMIT 1
  196. 2019-01-31 13:02:39.923095 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_LOCAL_CALL] Query :SELECT sip_devices.username as username,accounts.number as accountcode,sip_devices.accountid as accountid,accounts.did_cid_translation as did_cid_translation FROM sip_devices as sip_devices,accounts as  accounts WHERE accounts.status=0 AND accounts.deleted=0 AND accounts.id=sip_devices.accountid AND sip_devices.username="CTTESTCALL027" limit 1
  197. 2019-01-31 13:02:40.083036 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Call direction : local
  198. 2019-01-31 13:02:40.083036 [NOTICE] switch_cpp.cpp:1365 [ASTPP] [Accountcode : CTTESTCALL029]
  199. 2019-01-31 13:02:40.083036 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [DOAUTHORIZATION] Query :SELECT * FROM accounts WHERE (number = "CTTESTCALL029" OR id="CTTESTCALL029") AND status=0 AND deleted=0 AND (expiry >= '2019-01-31 13:02:40' OR expiry = '0000-00-00 00:00:00') limit 1
  200. 2019-01-31 13:02:40.283039 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PACKAGE_INFO] Query :SELECT * FROM packages  as P inner join package_patterns as PKGPTR on P.id = PKGPTR.package_id WHERE (patterns ='^CTTESTCALL027.*' OR patterns ='^CTTESTCALL02.*' OR patterns ='^CTTESTCALL0.*' OR patterns ='^CTTESTCALL.*' OR patterns ='^CTTESTCAL.*' OR patterns ='^CTTESTCA.*' OR patterns ='^CTTESTC.*' OR patterns ='^CTTEST.*' OR patterns ='^CTTES.*' OR patterns ='^CTTE.*' OR patterns ='^CTT.*' OR patterns ='^CT.*' OR patterns ='^C.*' OR patterns ='--') AND status = 0 AND pricelist_id = 1 ORDER BY LENGTH(PKGPTR.patterns) DESC LIMIT 1
  201. 2019-01-31 13:02:40.463044 [INFO] switch_cpp.cpp:1365 [ASTPP] =============== Account Information ===================
  202. 2019-01-31 13:02:40.463044 [INFO] switch_cpp.cpp:1365 [ASTPP] User id : 583
  203. 2019-01-31 13:02:40.463044 [INFO] switch_cpp.cpp:1365 [ASTPP] Account code : CTTESTCALL029
  204. 2019-01-31 13:02:40.463044 [INFO] switch_cpp.cpp:1365 [ASTPP] Balance : 60
  205. 2019-01-31 13:02:40.463044 [INFO] switch_cpp.cpp:1365 [ASTPP] Type : 0 [0:prepaid,1:postpaid]
  206. 2019-01-31 13:02:40.463044 [INFO] switch_cpp.cpp:1365 [ASTPP] Ratecard id : 1
  207. 2019-01-31 13:02:40.463044 [INFO] switch_cpp.cpp:1365 [ASTPP] ========================================================
  208. 2019-01-31 13:02:40.463044 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 1 AND status = 0
  209. 2019-01-31 13:02:40.643103 [INFO] switch_cpp.cpp:1365 [ASTPP] [FIND_MAXLENGTH] LIMITING CALL TO CONFIG MAX LENGTH 24!!!
  210. 2019-01-31 13:02:40.643103 [INFO] switch_cpp.cpp:1365 [ASTPP] =============== Rates Information ===================
  211. 2019-01-31 13:02:40.643103 [INFO] switch_cpp.cpp:1365 [ASTPP] ID : 0
  212. 2019-01-31 13:02:40.643103 [INFO] switch_cpp.cpp:1365 [ASTPP] Code : CTTESTCALL027
  213. 2019-01-31 13:02:40.643103 [INFO] switch_cpp.cpp:1365 [ASTPP] Destination : Local
  214. 2019-01-31 13:02:40.643103 [INFO] switch_cpp.cpp:1365 [ASTPP] Connectcost : 0
  215. 2019-01-31 13:02:40.643103 [INFO] switch_cpp.cpp:1365 [ASTPP] Includedseconds : 0
  216. 2019-01-31 13:02:40.643103 [INFO] switch_cpp.cpp:1365 [ASTPP] Cost : 1
  217. 2019-01-31 13:02:40.643103 [INFO] switch_cpp.cpp:1365 [ASTPP] Initial Increment : 60
  218. 2019-01-31 13:02:40.643103 [INFO] switch_cpp.cpp:1365 [ASTPP] Increment : 60
  219. 2019-01-31 13:02:40.643103 [INFO] switch_cpp.cpp:1365 [ASTPP] Accid : 583
  220. 2019-01-31 13:02:40.643103 [INFO] switch_cpp.cpp:1365 [ASTPP] ================================================================
  221. 2019-01-31 13:02:40.643103 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_SPEEDDIAL] Query :SELECT balance FROM accounts WHERE status=0 AND deleted=0 AND number ="CTTESTCALL027" limit 1
  222. 2019-01-31 13:02:40.803110 [INFO] switch_cpp.cpp:1365 [ASTPP] [FIND_MAXLENGTH1] Balance for destination number 60.00000 !!!
  223. 2019-01-31 13:02:40.803110 [INFO] switch_cpp.cpp:1365 [ASTPP] [FIND_MAXLENGTH1] LIMITING CALL TO CONFIG MAX LENGTH 60!!!
  224. 2019-01-31 13:02:40.803110 [INFO] switch_cpp.cpp:1365 [ASTPP] Call Max length duration : 60 minutes
  225. 2019-01-31 13:02:40.803110 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_LOCAL_CALL] Query :SELECT sip_devices.username as username,accounts.number as accountcode,sip_devices.accountid as accountid,accounts.did_cid_translation as did_cid_translation FROM sip_devices as sip_devices,accounts as  accounts WHERE accounts.status=0 AND accounts.deleted=0 AND accounts.id=sip_devices.accountid AND sip_devices.username="CTTESTCALL027" limit 1
  226. 2019-01-31 13:02:40.983088 [WARNING] switch_cpp.cpp:1365 [ASTPP] [FSXMLLOCAL] Caller ID Translation Starts
  227. 2019-01-31 13:02:40.983088 [WARNING] switch_cpp.cpp:1365 [ASTPP] [FSXMLLOCAL] Caller ID Translation Ends
  228. 2019-01-31 13:02:40.983088 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [NOTIFY] Query :select devicetoken from accounts where number = 'CTTESTCALL027' and status =0 and deleted =0 limit 1
  229. 2019-01-31 13:02:41.163040 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Generated XML:
  230. <?xml version="1.0" encoding="UTF-8" standalone="no"?>
  231. <document type="freeswitch/xml">
  232. <section name="dialplan" description="ASTPP Dialplan">
  233. <context name="default">
  234. <extension name="CTTESTCALL027">
  235. <condition field="destination_number" expression="wifi#CTTESTCALL027">
  236. <action application="set" data="effective_destination_number=CTTESTCALL027"/>
  237. <action application="sched_hangup" data="+3600 normal_clearing"/>
  238. <action application="set" data="callstart=2019-01-31 13:02:40"/>
  239. <action application="set" data="hangup_after_bridge=true"/>
  240. <action application="set" data="rtp_enable_vad_in=true"/>
  241. <action application="set" data="rtp_enable_vad_out=true"/>
  242. <action application="set" data="continue_on_fail=!USER_BUSY"/>
  243. <action application="set" data="account_id=583"/>
  244. <action application="set" data="parent_id=0"/>
  245. <action application="set" data="entity_id=0"/>
  246. <action application="set" data="call_processed=internal"/>
  247. <action application="set" data="call_direction=local"/>
  248. <action application="set" data="accountname=default"/>
  249. <action application="set" data="origination_rates=ID:0|CODE:CTTESTCALL027|DESTINATION:Local|CONNECTIONCOST:0|INCLUDEDSECONDS:0|COST:1|INC:60|INITIALBLOCK:60|RATEGROUP:1|MARKUP:0|ACCID:583"/>
  250. <action application="set" data="wificall=true"/>
  251. <action application="set" data="original_caller_id_name=029"/>
  252. <action application="set" data="original_caller_id_number=CTTESTCALL029"/>
  253. <action application="set" data="effective_caller_id_name=029"/>
  254. <action application="set" data="effective_caller_id_number=CTTESTCALL029"/>
  255. <action application="set" data="calltype=LOCAL"/>
  256. <action application="set" data="rtp_secure_media=true"/>
  257. <action application="export" data="rtp_secure_media=true"/>
  258. <action application="set" data="receiver_accid=581"/>
  259. <action application="curl" data="http://142.44.213.51:8711/notify.php post destination=CTTESTCALL027&uuid=${uuid}&google_push_api_key=AIzaSyBcE27m3oTIC5wP6Kx_VV_iDbzbMTAwnMc&callkit_token=dq75M499flw:APA91bFX4y1v3-wc7_skH1mKmDXnP0zvOe-tTN9ZOvfIHapM3VDZJsyDP-nd0nvvE8MwNpY5_bWJJxmre4OPYFR8-yHXuRSIojNJtdrXXyiyOH0AuZSA48rlLuc15Q5POM6kbSF9YQq8&destination=${effective_destination_number}&source_main=CTTESTCALL029&source_override=${effective_caller_id_number}"/>
  260. <action application="ring_ready"/>
  261. <action application="sleep" data="9000"/>
  262. <action application="set" data="rtp_enable_vad_in=true"/>
  263. <action application="set" data="rtp_enable_vad_out=true"/>
  264. <action application="bridge" data="[leg_timeout=30]user/CTTESTCALL027@${domain_name}"/>
  265. <condition field="${cond(${user_data CTTESTCALL027@${domain_name} param vm-enabled} == true ? YES : NO)}" expression="^YES$">
  266. <action application="answer"/>
  267. <action application="export" data="voicemail_alternate_greet_id=CTTESTCALL027"/>
  268. <action application="voicemail" data="default $${domain_name} CTTESTCALL027"/>
  269. <anti-action application="hangup" data="${originate_disposition}"/>
  270. </condition>
  271. </condition>
  272. </extension>
  273. </context>
  274. </section>
  275. </document>
  276. 2019-01-31 13:02:41.163040 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f403806ab70 released.
  277. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 parsing [default->CTTESTCALL027] continue=false
  278. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Regex (PASS) [CTTESTCALL027] destination_number(wifi#CTTESTCALL027) =~ /wifi#CTTESTCALL027/ break=on-false
  279. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action set(effective_destination_number=CTTESTCALL027)
  280. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action sched_hangup(+3600 normal_clearing)
  281. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action set(callstart=2019-01-31 13:02:40)
  282. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action set(hangup_after_bridge=true)
  283. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action set(rtp_enable_vad_in=true)
  284. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action set(rtp_enable_vad_out=true)
  285. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action set(continue_on_fail=!USER_BUSY)
  286. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action set(account_id=583)
  287. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action set(parent_id=0)
  288. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action set(entity_id=0)
  289. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action set(call_processed=internal)
  290. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action set(call_direction=local)
  291. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action set(accountname=default)
  292. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action set(origination_rates=ID:0|CODE:CTTESTCALL027|DESTINATION:Local|CONNECTIONCOST:0|INCLUDEDSECONDS:0|COST:1|INC:60|INITIALBLOCK:60|RATEGROUP:1|MARKUP:0|ACCID:583)
  293. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action set(wificall=true)
  294. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action set(original_caller_id_name=029)
  295. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action set(original_caller_id_number=CTTESTCALL029)
  296. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action set(effective_caller_id_name=029)
  297. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action set(effective_caller_id_number=CTTESTCALL029)
  298. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action set(calltype=LOCAL)
  299. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action set(rtp_secure_media=true)
  300. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action export(rtp_secure_media=true)
  301. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action set(receiver_accid=581)
  302. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action curl(http://142.44.213.51:8711/notify.php post destination=CTTESTCALL027&uuid=${uuid}&google_push_api_key=AIzaSyBcE27m3oTIC5wP6Kx_VV_iDbzbMTAwnMc&callkit_token=dq75M499flw:APA91bFX4y1v3-wc7_skH1mKmDXnP0zvOe-tTN9ZOvfIHapM3VDZJsyDP-nd0nvvE8MwNpY5_bWJJxmre4OPYFR8-yHXuRSIojNJtdrXXyiyOH0AuZSA48rlLuc15Q5POM6kbSF9YQq8&destination=${effective_destination_number}&source_main=CTTESTCALL029&source_override=${effective_caller_id_number})
  303. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action ring_ready()
  304. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action sleep(9000)
  305. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action set(rtp_enable_vad_in=true)
  306. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action set(rtp_enable_vad_out=true)
  307. Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Action bridge([leg_timeout=30]user/CTTESTCALL027@${domain_name})
  308. |--- Dialplan: Processing recursive conditions level:1 [CTTESTCALL027_recur_1] require-nested=TRUE
  309. |--- Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 Regex (FAIL) [CTTESTCALL027_recur_1] ${cond(${user_data CTTESTCALL027@${domain_name} param vm-enabled} == true ? YES : NO)}(NO) =~ /^YES$/ break=on-false
  310. |--- Dialplan: sofia/default/CTTESTCALL029@81.95.124.28 ANTI-Action hangup(${originate_disposition})
  311. 2019-01-31 13:02:41.343115 [DEBUG] switch_core_state_machine.c:286 (sofia/default/CTTESTCALL029@81.95.124.28) State Change CS_ROUTING -> CS_EXECUTE
  312. 2019-01-31 13:02:41.343115 [DEBUG] switch_core_state_machine.c:643 (sofia/default/CTTESTCALL029@81.95.124.28) State ROUTING going to sleep
  313. 2019-01-31 13:02:41.343115 [DEBUG] switch_core_state_machine.c:584 (sofia/default/CTTESTCALL029@81.95.124.28) Running State Change CS_EXECUTE (Cur 1 Tot 33)
  314. 2019-01-31 13:02:41.343115 [DEBUG] switch_core_state_machine.c:650 (sofia/default/CTTESTCALL029@81.95.124.28) State EXECUTE
  315. 2019-01-31 13:02:41.343115 [DEBUG] mod_sofia.c:198 sofia/default/CTTESTCALL029@81.95.124.28 SOFIA EXECUTE
  316. 2019-01-31 13:02:41.343115 [DEBUG] switch_core_state_machine.c:328 sofia/default/CTTESTCALL029@81.95.124.28 Standard EXECUTE
  317. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 set(effective_destination_number=CTTESTCALL027)
  318. 2019-01-31 13:02:41.343115 [DEBUG] mod_dptools.c:1548 SET sofia/default/CTTESTCALL029@81.95.124.28 [effective_destination_number]=[CTTESTCALL027]
  319. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 sched_hangup(+3600 normal_clearing)
  320. 2019-01-31 13:02:41.343115 [DEBUG] switch_scheduler.c:249 Added task 20 switch_ivr_schedule_hangup (d1cc0546-0497-4b7d-995c-0729a4d2abac) to run at 1548943361
  321. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 set(callstart=2019-01-31 13:02:40)
  322. 2019-01-31 13:02:41.343115 [DEBUG] mod_dptools.c:1548 SET sofia/default/CTTESTCALL029@81.95.124.28 [callstart]=[2019-01-31 13:02:40]
  323. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 set(hangup_after_bridge=true)
  324. 2019-01-31 13:02:41.363035 [DEBUG] mod_dptools.c:1548 SET sofia/default/CTTESTCALL029@81.95.124.28 [hangup_after_bridge]=[true]
  325. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 set(rtp_enable_vad_in=true)
  326. 2019-01-31 13:02:41.363035 [DEBUG] mod_dptools.c:1548 SET sofia/default/CTTESTCALL029@81.95.124.28 [rtp_enable_vad_in]=[true]
  327. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 set(rtp_enable_vad_out=true)
  328. 2019-01-31 13:02:41.363035 [DEBUG] mod_dptools.c:1548 SET sofia/default/CTTESTCALL029@81.95.124.28 [rtp_enable_vad_out]=[true]
  329. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 set(continue_on_fail=!USER_BUSY)
  330. 2019-01-31 13:02:41.363035 [DEBUG] mod_dptools.c:1548 SET sofia/default/CTTESTCALL029@81.95.124.28 [continue_on_fail]=[!USER_BUSY]
  331. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 set(account_id=583)
  332. 2019-01-31 13:02:41.363035 [DEBUG] mod_dptools.c:1548 SET sofia/default/CTTESTCALL029@81.95.124.28 [account_id]=[583]
  333. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 set(parent_id=0)
  334. 2019-01-31 13:02:41.363035 [DEBUG] mod_dptools.c:1548 SET sofia/default/CTTESTCALL029@81.95.124.28 [parent_id]=[0]
  335. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 set(entity_id=0)
  336. 2019-01-31 13:02:41.363035 [DEBUG] mod_dptools.c:1548 SET sofia/default/CTTESTCALL029@81.95.124.28 [entity_id]=[0]
  337. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 set(call_processed=internal)
  338. 2019-01-31 13:02:41.363035 [DEBUG] mod_dptools.c:1548 SET sofia/default/CTTESTCALL029@81.95.124.28 [call_processed]=[internal]
  339. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 set(call_direction=local)
  340. 2019-01-31 13:02:41.363035 [DEBUG] mod_dptools.c:1548 SET sofia/default/CTTESTCALL029@81.95.124.28 [call_direction]=[local]
  341. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 set(accountname=default)
  342. 2019-01-31 13:02:41.363035 [DEBUG] mod_dptools.c:1548 SET sofia/default/CTTESTCALL029@81.95.124.28 [accountname]=[default]
  343. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 set(origination_rates=ID:0|CODE:CTTESTCALL027|DESTINATION:Local|CONNECTIONCOST:0|INCLUDEDSECONDS:0|COST:1|INC:60|INITIALBLOCK:60|RATEGROUP:1|MARKUP:0|ACCID:583)
  344. 2019-01-31 13:02:41.363035 [DEBUG] mod_dptools.c:1548 SET sofia/default/CTTESTCALL029@81.95.124.28 [origination_rates]=[ID:0|CODE:CTTESTCALL027|DESTINATION:Local|CONNECTIONCOST:0|INCLUDEDSECONDS:0|COST:1|INC:60|INITIALBLOCK:60|RATEGROUP:1|MARKUP:0|ACCID:583]
  345. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 set(wificall=true)
  346. 2019-01-31 13:02:41.363035 [DEBUG] mod_dptools.c:1548 SET sofia/default/CTTESTCALL029@81.95.124.28 [wificall]=[true]
  347. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 set(original_caller_id_name=029)
  348. 2019-01-31 13:02:41.363035 [DEBUG] mod_dptools.c:1548 SET sofia/default/CTTESTCALL029@81.95.124.28 [original_caller_id_name]=[029]
  349. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 set(original_caller_id_number=CTTESTCALL029)
  350. 2019-01-31 13:02:41.363035 [DEBUG] mod_dptools.c:1548 SET sofia/default/CTTESTCALL029@81.95.124.28 [original_caller_id_number]=[CTTESTCALL029]
  351. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 set(effective_caller_id_name=029)
  352. 2019-01-31 13:02:41.363035 [DEBUG] mod_dptools.c:1548 SET sofia/default/CTTESTCALL029@81.95.124.28 [effective_caller_id_name]=[029]
  353. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 set(effective_caller_id_number=CTTESTCALL029)
  354. 2019-01-31 13:02:41.363035 [DEBUG] mod_dptools.c:1548 SET sofia/default/CTTESTCALL029@81.95.124.28 [effective_caller_id_number]=[CTTESTCALL029]
  355. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 set(calltype=LOCAL)
  356. 2019-01-31 13:02:41.363035 [DEBUG] mod_dptools.c:1548 SET sofia/default/CTTESTCALL029@81.95.124.28 [calltype]=[LOCAL]
  357. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 set(rtp_secure_media=true)
  358. 2019-01-31 13:02:41.363035 [DEBUG] mod_dptools.c:1548 SET sofia/default/CTTESTCALL029@81.95.124.28 [rtp_secure_media]=[true]
  359. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 export(rtp_secure_media=true)
  360. 2019-01-31 13:02:41.363035 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [rtp_secure_media]=[true]
  361. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 set(receiver_accid=581)
  362. 2019-01-31 13:02:41.363035 [DEBUG] mod_dptools.c:1548 SET sofia/default/CTTESTCALL029@81.95.124.28 [receiver_accid]=[581]
  363. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 curl(http://142.44.213.51:8711/notify.php post destination=CTTESTCALL027&uuid=d1cc0546-0497-4b7d-995c-0729a4d2abac&google_push_api_key=AIzaSyBcE27m3oTIC5wP6Kx_VV_iDbzbMTAwnMc&callkit_token=dq75M499flw:APA91bFX4y1v3-wc7_skH1mKmDXnP0zvOe-tTN9ZOvfIHapM3VDZJsyDP-nd0nvvE8MwNpY5_bWJJxmre4OPYFR8-yHXuRSIojNJtdrXXyiyOH0AuZSA48rlLuc15Q5POM6kbSF9YQq8&destination=CTTESTCALL027&source_main=CTTESTCALL029&source_override=CTTESTCALL029)
  364. 2019-01-31 13:02:41.363035 [DEBUG] mod_curl.c:182 method: post, url: http://142.44.213.51:8711/notify.php, content-type: (null)
  365. 2019-01-31 13:02:41.363035 [DEBUG] mod_curl.c:211 Post data: destination=CTTESTCALL027&uuid=d1cc0546-0497-4b7d-995c-0729a4d2abac&google_push_api_key=AIzaSyBcE27m3oTIC5wP6Kx_VV_iDbzbMTAwnMc&callkit_token=dq75M499flw:APA91bFX4y1v3-wc7_skH1mKmDXnP0zvOe-tTN9ZOvfIHapM3VDZJsyDP-nd0nvvE8MwNpY5_bWJJxmre4OPYFR8-yHXuRSIojNJtdrXXyiyOH0AuZSA48rlLuc15Q5POM6kbSF9YQq8&destination=CTTESTCALL027&source_main=CTTESTCALL029&source_override=CTTESTCALL029
  366. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 ring_ready()
  367. 2019-01-31 13:02:41.643039 [NOTICE] mod_sofia.c:2273 Ring-Ready sofia/default/CTTESTCALL029@81.95.124.28!
  368. send 776 bytes to tls/[103.249.234.189]:55144 at 13:02:41.650834:
  369.    ------------------------------------------------------------------------
  370.    SIP/2.0 180 Ringing
  371.    Via: SIP/2.0/TLS 192.168.1.176:37032;rport=55144;branch=z9hG4bKPjdupoVmLqSsNyzqdhAwlE-pEvSVQAVcRs;alias;received=103.249.234.189
  372.    f: <sip:CTTESTCALL029@81.95.124.28>;tag=LeV4xZGeHULUa2UgZgPiR9U9e3HmtlE3
  373.    To: <sip:wifi%23CTTESTCALL027@81.95.124.28>;tag=mB56aFBF83eZp
  374.    i: 7zHizyRvhAqxBZ7UxUQdmjUfEbDtjAma
  375.    CSeq: 646 INVITE
  376.    Contact: <sip:wifi#CTTESTCALL027@81.95.124.28:5061;transport=tls>
  377.    User-Agent: ASTPP
  378.    Accept: application/sdp
  379.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, NOTIFY, PUBLISH, SUBSCRIBE
  380.    Supported: path, replaces
  381.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  382.    Content-Length: 0
  383.    
  384.    ------------------------------------------------------------------------
  385. 2019-01-31 13:02:41.643039 [DEBUG] sofia.c:7084 Channel sofia/default/CTTESTCALL029@81.95.124.28 entering state [early][180]
  386. 2019-01-31 13:02:41.643039 [NOTICE] mod_dptools.c:1028 Ring Ready sofia/default/CTTESTCALL029@81.95.124.28!
  387. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 sleep(9000)
  388. freeswitch@astpp04>
  389. freeswitch@astpp04>
  390.  
  391. freeswitch@astpp04>
  392. freeswitch@astpp04>
  393. freeswitch@astpp04>
  394. freeswitch@astpp04>
  395. freeswitch@astpp04>
  396. freeswitch@astpp04>
  397. freeswitch@astpp04>
  398. freeswitch@astpp04>
  399. freeswitch@astpp04>
  400. freeswitch@astpp04>
  401. freeswitch@astpp04>
  402. freeswitch@astpp04>
  403. freeswitch@astpp04>
  404. recv 669 bytes from tls/[103.249.234.189]:54246 at 13:02:44.838847:
  405.    ------------------------------------------------------------------------
  406.    REGISTER sip:81.95.124.28:5061 SIP/2.0
  407.    v: SIP/2.0/TLS 192.168.1.175:33816;rport;branch=z9hG4bKPjjmkHDVipV0jbBBt9iuOuBqPNsMzRStdW;alias
  408.    Route: <sip:81.95.124.28:5061;transport=tls;lr>
  409.    Max-Forwards: 70
  410.    f: <sip:CTTESTCALL027@81.95.124.28>;tag=SdkNopgCcqFcPSM8owiWKB3t0oZB1PMV
  411.    t: <sip:CTTESTCALL027@81.95.124.28>
  412.    i: u1CnzzMG4Yg0jcazZRDbWVb1FkNmewIl
  413.    CSeq: 56540 REGISTER
  414.    User-Agent: CallApp
  415.    k: outbound, path
  416.    m: <sip:CTTESTCALL027@192.168.1.175:33816;transport=TLS;ob>;reg-id=1;+sip.instance="<urn:uuid:ab614474-4ad0-4c25-8e98-307ebdbcc3de>"
  417.    Expires: 900
  418.   Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
  419.    l:  0
  420.    
  421.    ------------------------------------------------------------------------
  422. 2019-01-31 13:02:44.823041 [WARNING] sofia_reg.c:1792 SIP auth challenge (REGISTER) on sofia profile 'default' for [CTTESTCALL027@81.95.124.28] from ip 103.249.234.189
  423. send 635 bytes to tls/[103.249.234.189]:54246 at 13:02:44.839801:
  424.    ------------------------------------------------------------------------
  425.    SIP/2.0 401 Unauthorized
  426.    Via: SIP/2.0/TLS 192.168.1.175:33816;rport=54246;branch=z9hG4bKPjjmkHDVipV0jbBBt9iuOuBqPNsMzRStdW;alias;received=103.249.234.189
  427.    f: <sip:CTTESTCALL027@81.95.124.28>;tag=SdkNopgCcqFcPSM8owiWKB3t0oZB1PMV
  428.    To: <sip:CTTESTCALL027@81.95.124.28>;tag=NmyZcavj5c5Hj
  429.    i: u1CnzzMG4Yg0jcazZRDbWVb1FkNmewIl
  430.    CSeq: 56540 REGISTER
  431.    User-Agent: ASTPP
  432.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, NOTIFY, PUBLISH, SUBSCRIBE
  433.    Supported: path, replaces
  434.    WWW-Authenticate: Digest realm="81.95.124.28", nonce="c97af12a-ada6-4cbe-ad10-6653269d9a15", algorithm=MD5, qop="auth"
  435.    Content-Length: 0
  436.    
  437.    ------------------------------------------------------------------------
  438. freeswitch@astpp04>
  439. freeswitch@astpp04>
  440. freeswitch@astpp04>
  441. freeswitch@astpp04>
  442. freeswitch@astpp04>
  443. recv 1011 bytes from tls/[103.249.234.189]:54246 at 13:02:45.004906:
  444.    ------------------------------------------------------------------------
  445.    REGISTER sip:81.95.124.28:5061 SIP/2.0
  446.    v: SIP/2.0/TLS 192.168.1.175:33816;rport;branch=z9hG4bKPjMEcBLyJJZ0KIoQjCg9bkKfVz7JKI9rvK;alias
  447.    Route: <sip:81.95.124.28:5061;transport=tls;lr>
  448.    Max-Forwards: 70
  449.    f: <sip:CTTESTCALL027@81.95.124.28>;tag=SdkNopgCcqFcPSM8owiWKB3t0oZB1PMV
  450.    t: <sip:CTTESTCALL027@81.95.124.28>
  451.    i: u1CnzzMG4Yg0jcazZRDbWVb1FkNmewIl
  452.    CSeq: 56541 REGISTER
  453.    User-Agent: CallApp
  454.    k: outbound, path
  455.    m: <sip:CTTESTCALL027@192.168.1.175:33816;transport=TLS;ob>;reg-id=1;+sip.instance="<urn:uuid:ab614474-4ad0-4c25-8e98-307ebdbcc3de>"
  456.    Expires: 900
  457.   Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
  458.    Authorization: Digest username="CTTESTCALL027", realm="81.95.124.28", nonce="c97af12a-ada6-4cbe-ad10-6653269d9a15", uri="sip:81.95.124.28:5061", response="a064c55a4900e3d1b7d5391ecd065610", algorithm=MD5, cnonce="aF.RKQ49bIC206vb3JFFqlaGofgHurpc", qop=auth, nc=00000001
  459.    m: <sip:CTTESTCALL027@192.168.1.175:39246;transport=TLS;ob>;expires=0
  460.    l:  0
  461.    
  462.    ------------------------------------------------------------------------
  463. freeswitch@astpp04>
  464. freeswitch@astpp04>
  465. freeswitch@astpp04>
  466. freeswitch@astpp04>
  467. freeswitch@astpp04>
  468. freeswitch@astpp04>
  469. freeswitch@astpp04>
  470. send 621 bytes to tls/[103.249.234.189]:54246 at 13:02:45.190174:
  471.    ------------------------------------------------------------------------
  472.    SIP/2.0 200 OK
  473.    Via: SIP/2.0/TLS 192.168.1.175:33816;rport=54246;branch=z9hG4bKPjMEcBLyJJZ0KIoQjCg9bkKfVz7JKI9rvK;alias;received=103.249.234.189
  474.    f: <sip:CTTESTCALL027@81.95.124.28>;tag=SdkNopgCcqFcPSM8owiWKB3t0oZB1PMV
  475.    To: <sip:CTTESTCALL027@81.95.124.28>;tag=pXQre5cp2NU4D
  476.    i: u1CnzzMG4Yg0jcazZRDbWVb1FkNmewIl
  477.    CSeq: 56541 REGISTER
  478.    Contact: <sip:CTTESTCALL027@192.168.1.175:33816;transport=TLS;ob>;expires=900
  479.    Date: Thu, 31 Jan 2019 13:02:45 GMT
  480.    User-Agent: ASTPP
  481.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, NOTIFY, PUBLISH, SUBSCRIBE
  482.    Supported: path, replaces
  483.    Content-Length: 0
  484.    
  485.    ------------------------------------------------------------------------
  486. freeswitch@astpp04>
  487. recv 640 bytes from tls/[103.249.234.189]:54246 at 13:02:45.389483:
  488.    ------------------------------------------------------------------------
  489.    SUBSCRIBE sip:CTTESTCALL027@81.95.124.28:5061 SIP/2.0
  490.    v: SIP/2.0/TLS 192.168.1.175:33816;rport;branch=z9hG4bKPj1sHwi-Eby0YkgsiWIENF8e9rX.U1HeD-;alias
  491.    Max-Forwards: 70
  492.    f: <sip:CTTESTCALL027@81.95.124.28>;tag=UJCanD36ORdpQKjH5hnGRdAu-IiAk0qP
  493.    t: <sip:CTTESTCALL027@81.95.124.28>
  494.    m: <sip:CTTESTCALL027@192.168.1.175:33816;transport=TLS;ob>
  495.    i: SPe7IB-z73ld7rXGSliacNIR4Gl8B.M7
  496.    CSeq: 7718 SUBSCRIBE
  497.    Route: <sip:81.95.124.28:5061;transport=tls;lr>
  498.    Event: message-summary
  499.    Expires: 3600
  500.    k: replaces, 100rel, timer, norefersub
  501.    Accept: application/simple-message-summary
  502.    u: presence, message-summary, refer
  503.    User-Agent: CallApp
  504.    l:  0
  505.    
  506.    ------------------------------------------------------------------------
  507. send 799 bytes to tls/[103.249.234.189]:54246 at 13:02:45.390712:
  508.    ------------------------------------------------------------------------
  509.    SIP/2.0 202 Accepted
  510.    Via: SIP/2.0/TLS 192.168.1.175:33816;rport=54246;branch=z9hG4bKPj1sHwi-Eby0YkgsiWIENF8e9rX.U1HeD-;alias;received=103.249.234.189
  511.    f: <sip:CTTESTCALL027@81.95.124.28>;tag=UJCanD36ORdpQKjH5hnGRdAu-IiAk0qP
  512.    To: <sip:CTTESTCALL027@81.95.124.28>;tag=xeXzrE31RyR6
  513.    i: SPe7IB-z73ld7rXGSliacNIR4Gl8B.M7
  514.    CSeq: 7718 SUBSCRIBE
  515.    Contact: <sip:CTTESTCALL027@81.95.124.28:5061;transport=tls>
  516.    Expires: 3600
  517.    User-Agent: ASTPP
  518.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, NOTIFY, PUBLISH, SUBSCRIBE
  519.    Supported: path, replaces
  520.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  521.    Subscription-State: active;expires=3600
  522.    Content-Length: 0
  523.    
  524.    ------------------------------------------------------------------------
  525. send 990 bytes to tls/[103.249.234.189]:54246 at 13:02:45.410736:
  526.    ------------------------------------------------------------------------
  527.    NOTIFY sip:CTTESTCALL027@192.168.1.175:33816;transport=TLS;ob SIP/2.0
  528.    Via: SIP/2.0/TLS 81.95.124.28:5061;rport;branch=z9hG4bK8QBStF9K4eX8r
  529.    Route: <sip:CTTESTCALL027@103.249.234.189:54246>;transport=TLS;ob
  530.    Max-Forwards: 70
  531.    From: <sip:CTTESTCALL027@81.95.124.28>;tag=rFaajUeXv779m
  532.    To: <sip:CTTESTCALL027@81.95.124.28>
  533.    Call-ID: 57d4b25b-9ffb-1237-30b3-ee26cdf725c6
  534.    CSeq: 134133818 NOTIFY
  535.    Contact: <sip:mod_sofia@81.95.124.28:5061;transport=tls>
  536.    User-Agent: ASTPP
  537.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, NOTIFY, PUBLISH, SUBSCRIBE
  538.    Supported: path, replaces
  539.    Event: message-summary
  540.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  541.    Subscription-State: terminated;reason=noresource
  542.    Content-Type: application/simple-message-summary
  543.    Content-Length: 73
  544.    
  545.    Messages-Waiting: no
  546.    Message-Account: sip:CTTESTCALL027@81.95.124.28
  547.    
  548.    ------------------------------------------------------------------------
  549. recv 302 bytes from tls/[103.249.234.189]:54246 at 13:02:45.571395:
  550.    ------------------------------------------------------------------------
  551.    SIP/2.0 200 OK
  552.    v: SIP/2.0/TLS 81.95.124.28:5061;rport=5061;received=81.95.124.28;branch=z9hG4bK8QBStF9K4eX8r
  553.    i: 57d4b25b-9ffb-1237-30b3-ee26cdf725c6
  554.    f: <sip:CTTESTCALL027@81.95.124.28>;tag=rFaajUeXv779m
  555.    t: <sip:CTTESTCALL027@81.95.124.28>;tag=z9hG4bK8QBStF9K4eX8r
  556.    CSeq: 134133818 NOTIFY
  557.    l:  0
  558.    
  559.    ------------------------------------------------------------------------
  560. send 1003 bytes to tls/[103.249.234.189]:54246 at 13:02:45.693266:
  561.    ------------------------------------------------------------------------
  562.    NOTIFY sip:CTTESTCALL027@192.168.1.175:33816;transport=TLS;ob SIP/2.0
  563.    Via: SIP/2.0/TLS 81.95.124.28:5061;rport;branch=z9hG4bK904HvatQ1QKUm
  564.    Route: <sip:103.249.234.189:54246>;transport=TLS;ob
  565.    Max-Forwards: 70
  566.    From: <sip:CTTESTCALL027@81.95.124.28>;tag=xeXzrE31RyR6
  567.    To: <sip:CTTESTCALL027@81.95.124.28>;tag=UJCanD36ORdpQKjH5hnGRdAu-IiAk0qP
  568.    Call-ID: SPe7IB-z73ld7rXGSliacNIR4Gl8B.M7
  569.    CSeq: 131948251 NOTIFY
  570.    Contact: <sip:CTTESTCALL027@81.95.124.28:5061;transport=tls>
  571.    User-Agent: ASTPP
  572.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, NOTIFY, PUBLISH, SUBSCRIBE
  573.    Supported: path, replaces
  574.    Event: message-summary
  575.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  576.    Subscription-State: active;expires=3600
  577.    Content-Type: application/simple-message-summary
  578.    Content-Length: 73
  579.    
  580.    Messages-Waiting: no
  581.    Message-Account: sip:CTTESTCALL027@81.95.124.28
  582.    
  583.    ------------------------------------------------------------------------
  584. recv 410 bytes from tls/[103.249.234.189]:54246 at 13:02:45.860559:
  585.    ------------------------------------------------------------------------
  586.    SIP/2.0 200 OK
  587.    v: SIP/2.0/TLS 81.95.124.28:5061;rport=5061;received=81.95.124.28;branch=z9hG4bK904HvatQ1QKUm
  588.    i: SPe7IB-z73ld7rXGSliacNIR4Gl8B.M7
  589.    f: <sip:CTTESTCALL027@81.95.124.28>;tag=xeXzrE31RyR6
  590.    t: <sip:CTTESTCALL027@81.95.124.28>;tag=UJCanD36ORdpQKjH5hnGRdAu-IiAk0qP
  591.    CSeq: 131948251 NOTIFY
  592.    m: <sip:CTTESTCALL027@192.168.1.175:33816;transport=TLS;ob>
  593.    k: replaces, 100rel, timer, norefersub
  594.    l:  0
  595.    
  596.    ------------------------------------------------------------------------
  597. freeswitch@astpp04>
  598. freeswitch@astpp04>
  599. freeswitch@astpp04>
  600. freeswitch@astpp04>
  601. freeswitch@astpp04>
  602. freeswitch@astpp04>
  603. freeswitch@astpp04>
  604. freeswitch@astpp04>
  605. freeswitch@astpp04>
  606. freeswitch@astpp04>
  607. freeswitch@astpp04>
  608. freeswitch@astpp04>
  609. freeswitch@astpp04>
  610. freeswitch@astpp04>
  611. freeswitch@astpp04>
  612. freeswitch@astpp04>
  613. freeswitch@astpp04>
  614. freeswitch@astpp04>
  615. freeswitch@astpp04>
  616. freeswitch@astpp04>
  617. freeswitch@astpp04>
  618. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 set(rtp_enable_vad_in=true)
  619. 2019-01-31 13:02:50.663083 [DEBUG] mod_dptools.c:1548 SET sofia/default/CTTESTCALL029@81.95.124.28 [rtp_enable_vad_in]=[true]
  620. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 set(rtp_enable_vad_out=true)
  621. 2019-01-31 13:02:50.663083 [DEBUG] mod_dptools.c:1548 SET sofia/default/CTTESTCALL029@81.95.124.28 [rtp_enable_vad_out]=[true]
  622. EXECUTE sofia/default/CTTESTCALL029@81.95.124.28 bridge([leg_timeout=30]user/CTTESTCALL027@81.95.124.28)
  623. 2019-01-31 13:02:50.663083 [DEBUG] switch_channel.c:1250 sofia/default/CTTESTCALL029@81.95.124.28 EXPORTING[export_vars] [rtp_secure_media]=[true] to event
  624. 2019-01-31 13:02:50.663083 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  625. 2019-01-31 13:02:50.663083 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  626. 2019-01-31 13:02:50.843076 [DEBUG] switch_channel.c:1250 sofia/default/CTTESTCALL029@81.95.124.28 EXPORTING[export_vars] [rtp_secure_media]=[true] to event
  627. 2019-01-31 13:02:50.843076 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  628. 2019-01-31 13:02:50.843076 [NOTICE] switch_channel.c:1104 New Channel sofia/default/CTTESTCALL027@192.168.1.175:33816 [47ae46c3-c426-49dd-9796-e55c2eb06284]
  629. 2019-01-31 13:02:50.843076 [DEBUG] mod_sofia.c:4819 (sofia/default/CTTESTCALL027@192.168.1.175:33816) State Change CS_NEW -> CS_INIT
  630. 2019-01-31 13:02:50.843076 [DEBUG] switch_ivr_originate.c:2963 sofia/default/CTTESTCALL027@192.168.1.175:33816 Setting leg timeout to 30
  631. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_state_machine.c:584 (sofia/default/CTTESTCALL027@192.168.1.175:33816) Running State Change CS_INIT (Cur 2 Tot 34)
  632. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_state_machine.c:627 (sofia/default/CTTESTCALL027@192.168.1.175:33816) State INIT
  633. 2019-01-31 13:02:50.843076 [DEBUG] mod_sofia.c:90 sofia/default/CTTESTCALL027@192.168.1.175:33816 SOFIA INIT
  634. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_media.c:1128 Set Local audio crypto Key [1 AEAD_AES_256_GCM_8 inline:caxRp151s212sBJmttw2/X0LlokboRIGP1l+/qAiwQWkwLjWLPrMWlDiq1k]
  635. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_media.c:1128 Set Local video crypto Key [1 AEAD_AES_256_GCM_8 inline:ILm5NroPWEcHswjtSD2HQ9cb5hD015yatT4bJCoy8nhoPcLX30+w5Qd7JGk]
  636. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_media.c:1128 Set Local audio crypto Key [2 AEAD_AES_128_GCM_8 inline:vqCSA/zmTTPmdERXd/qg+vEDsovEpCVTZ7mUGA]
  637. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_media.c:1128 Set Local video crypto Key [2 AEAD_AES_128_GCM_8 inline:wOtj7jUo5V8+wEL13kmUQ2MZeITtce6xxOB6VQ]
  638. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_media.c:1128 Set Local audio crypto Key [3 AES_CM_256_HMAC_SHA1_80 inline:cgVq3v4yxfNRoEHqYrxl6mxcXpqP6df87nqKY84l9UJ5zBbhC23gCJvE98d6Nw]
  639. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_media.c:1128 Set Local video crypto Key [3 AES_CM_256_HMAC_SHA1_80 inline:ih2KLVM3dTPerT3hgNxP1RALSoMhzTGqOR34jwv/LIxR1f/0PzPGjcIoN7fFUA]
  640. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_media.c:1128 Set Local audio crypto Key [4 AES_CM_192_HMAC_SHA1_80 inline:encQO5t3tJl0yd/jq2XyastJlKSZSP+rEclrFtYU3X6mg8ELcXI]
  641. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_media.c:1128 Set Local video crypto Key [4 AES_CM_192_HMAC_SHA1_80 inline:OCmhCP55ld1cSvPqGHdlDItx/yfF39rQqVvtss+2HzJNhNpZ82E]
  642. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_media.c:1128 Set Local audio crypto Key [5 AES_CM_128_HMAC_SHA1_80 inline:K3CDkdy7m3ybkgraIzL+ojTU6LhZQLECv45kWIcT]
  643. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_media.c:1128 Set Local video crypto Key [5 AES_CM_128_HMAC_SHA1_80 inline:WsyyeNgaPCrQC2chq++KC7MLjHvigos5JL9IP69W]
  644. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_media.c:1128 Set Local audio crypto Key [6 AES_CM_256_HMAC_SHA1_32 inline:ZBSxI4exvPK7F0lMa6aNgzxr4jbF3g6Z0lhSElFulnHFiutTqzIKRn1SG6VTBQ]
  645. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_media.c:1128 Set Local video crypto Key [6 AES_CM_256_HMAC_SHA1_32 inline:q4im8gghx4PMTW01tY8qzcyIYyarJQCq4ylrbrBIakKW/1X/1Us99KkOlUanww]
  646. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_media.c:1128 Set Local audio crypto Key [7 AES_CM_192_HMAC_SHA1_32 inline:xVQXPDDf/TFl6TDrSqq+7B4aqdVyzR7fH6UgQ1IFa/q3/buHnsw]
  647. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_media.c:1128 Set Local video crypto Key [7 AES_CM_192_HMAC_SHA1_32 inline:+ptK8f3wsGCOXt+3BCqcr+HtQyIdjbgCVXHSqmgVlZ7QH6DNtNs]
  648. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_media.c:1128 Set Local audio crypto Key [8 AES_CM_128_HMAC_SHA1_32 inline:hB+VHS1Z6UDlDvkz8L0ulFZkDbqTuKzjEDEmW3Wg]
  649. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_media.c:1128 Set Local video crypto Key [8 AES_CM_128_HMAC_SHA1_32 inline:1EpjRsu6lU0g3OoV5ySstDs7U7XRaeaYHxogru5c]
  650. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_media.c:1128 Set Local audio crypto Key [9 AES_CM_128_NULL_AUTH inline:xVv5ZVwPi/CYc13TzJL2WfVF/Pl4hq/8i8A+lrw8]
  651. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_media.c:1128 Set Local video crypto Key [9 AES_CM_128_NULL_AUTH inline:Jck1Z/Ks+LY++4jnVLJ8PNUyOWxNadDWJLmxf+8r]
  652. 2019-01-31 13:02:50.843076 [DEBUG] sofia_glue.c:1264 sip:CTTESTCALL027@103.249.234.189:54246;transport=TLS;ob Setting proxy route to sofia/default/CTTESTCALL027@192.168.1.175:33816
  653. 2019-01-31 13:02:50.843076 [DEBUG] sofia_glue.c:1295 sofia/default/CTTESTCALL027@192.168.1.175:33816 sending invite version: 1.6.19 git 7a77e0b 2017-07-13 12:01:45Z 64bit
  654. Local SDP:
  655. v=0
  656. o=FreeSWITCH 1548908940 1548908941 IN IP4 81.95.124.28
  657. s=FreeSWITCH
  658. c=IN IP4 81.95.124.28
  659. t=0 0
  660. m=audio 30830 RTP/SAVP 0 101
  661. a=rtpmap:0 PCMU/8000
  662. a=rtpmap:101 telephone-event/8000
  663. a=fmtp:101 0-16
  664. a=crypto:1 AEAD_AES_256_GCM_8 inline:caxRp151s212sBJmttw2/X0LlokboRIGP1l+/qAiwQWkwLjWLPrMWlDiq1k
  665. a=crypto:2 AEAD_AES_128_GCM_8 inline:vqCSA/zmTTPmdERXd/qg+vEDsovEpCVTZ7mUGA
  666. a=crypto:3 AES_CM_256_HMAC_SHA1_80 inline:cgVq3v4yxfNRoEHqYrxl6mxcXpqP6df87nqKY84l9UJ5zBbhC23gCJvE98d6Nw
  667. a=crypto:4 AES_CM_192_HMAC_SHA1_80 inline:encQO5t3tJl0yd/jq2XyastJlKSZSP+rEclrFtYU3X6mg8ELcXI
  668. a=crypto:5 AES_CM_128_HMAC_SHA1_80 inline:K3CDkdy7m3ybkgraIzL+ojTU6LhZQLECv45kWIcT
  669. a=crypto:6 AES_CM_256_HMAC_SHA1_32 inline:ZBSxI4exvPK7F0lMa6aNgzxr4jbF3g6Z0lhSElFulnHFiutTqzIKRn1SG6VTBQ
  670. a=crypto:7 AES_CM_192_HMAC_SHA1_32 inline:xVQXPDDf/TFl6TDrSqq+7B4aqdVyzR7fH6UgQ1IFa/q3/buHnsw
  671. a=crypto:8 AES_CM_128_HMAC_SHA1_32 inline:hB+VHS1Z6UDlDvkz8L0ulFZkDbqTuKzjEDEmW3Wg
  672. a=crypto:9 AES_CM_128_NULL_AUTH inline:xVv5ZVwPi/CYc13TzJL2WfVF/Pl4hq/8i8A+lrw8
  673. a=ptime:20
  674. a=sendrecv
  675.  
  676. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_state_machine.c:40 sofia/default/CTTESTCALL027@192.168.1.175:33816 Standard INIT
  677. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_state_machine.c:48 (sofia/default/CTTESTCALL027@192.168.1.175:33816) State Change CS_INIT -> CS_ROUTING
  678. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_state_machine.c:627 (sofia/default/CTTESTCALL027@192.168.1.175:33816) State INIT going to sleep
  679. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_state_machine.c:584 (sofia/default/CTTESTCALL027@192.168.1.175:33816) Running State Change CS_ROUTING (Cur 2 Tot 34)
  680. send 2027 bytes to tls/[103.249.234.189]:54246 at 13:02:50.861816:
  681.    ------------------------------------------------------------------------
  682.    INVITE sip:CTTESTCALL027@192.168.1.175:33816;transport=TLS;ob SIP/2.0
  683.    Via: SIP/2.0/TLS 81.95.124.28:5061;rport;branch=z9hG4bKaayay5aUy09Dg
  684.    Route: <sip:CTTESTCALL027@103.249.234.189:54246>;transport=TLS;ob
  685.    Max-Forwards: 69
  686.    From: "029" <sip:CTTESTCALL029@81.95.124.28>;tag=Sr32KpZ0Sgyvg
  687.    To: <sip:CTTESTCALL027@192.168.1.175:33816;transport=TLS;ob>
  688.    Call-ID: 5b147688-9ffb-1237-30b3-ee26cdf725c6
  689.    CSeq: 134133821 INVITE
  690.    Contact: <sip:mod_sofia@81.95.124.28:5061;transport=tls>
  691.    User-Agent: ASTPP
  692.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, NOTIFY, PUBLISH, SUBSCRIBE
  693.    Supported: path, replaces
  694.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  695.    Content-Type: application/sdp
  696.    Content-Disposition: session
  697.    Content-Length: 1047
  698.    Remote-Party-ID: "029" <sip:CTTESTCALL029@81.95.124.28>;party=calling;screen=yes;privacy=off
  699.    
  700.    v=0
  701.    o=FreeSWITCH 1548908940 1548908941 IN IP4 81.95.124.28
  702.    s=FreeSWITCH
  703.    c=IN IP4 81.95.124.28
  704.    t=0 0
  705.    m=audio 30830 RTP/SAVP 0 101
  706. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_state_machine.c:643 (sofia/default/CTTESTCALL027@192.168.1.175:33816) State ROUTING
  707.    a=rtpmap:0 PCMU/8000
  708. 2019-01-31 13:02:50.843076 [DEBUG] mod_sofia.c:143 sofia/default/CTTESTCALL027@192.168.1.175:33816 SOFIA ROUTING
  709.    a=rtpmap:101 telephone-event/8000
  710. 2019-01-31 13:02:50.843076 [DEBUG] switch_ivr_originate.c:67 (sofia/default/CTTESTCALL027@192.168.1.175:33816) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  711.    a=fmtp:101 0-16
  712.    a=crypto:1 AEAD_AES_256_GCM_8 inline:caxRp151s212sBJmttw2/X0LlokboRIGP1l+/qAiwQWkwLjWLPrMWlDiq1k
  713. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_state_machine.c:643 (sofia/default/CTTESTCALL027@192.168.1.175:33816) State ROUTING going to sleep
  714.    a=crypto:2 AEAD_AES_128_GCM_8 inline:vqCSA/zmTTPmdERXd/qg+vEDsovEpCVTZ7mUGA
  715.    a=crypto:3 AES_CM_256_HMAC_SHA1_80 inline:cgVq3v4yxfNRoEHqYrxl6mxcXpqP6df87nqKY84l9UJ5zBbhC23gCJvE98d6Nw
  716.    a=crypto:4 AES_CM_192_HMAC_SHA1_80 inline:encQO5t3tJl0yd/jq2XyastJlKSZSP+rEclrFtYU3X6mg8ELcXI
  717.    a=crypto:5 AES_CM_128_HMAC_SHA1_80 inline:K3CDkdy7m3ybkgraIzL+ojTU6LhZQLECv45kWIcT
  718.    a=crypto:6 AES_CM_256_HMAC_SHA1_32 inline:ZBSxI4exvPK7F0lMa6aNgzxr4jbF3g6Z0lhSElFulnHFiutTqzIKRn1SG6VTBQ
  719.    a=crypto:7 AES_CM_192_HMAC_SHA1_32 inline:xVQXPDDf/TFl6TDrSqq+7B4aqdVyzR7fH6UgQ1IFa/q3/buHnsw
  720.    a=crypto:8 AES_CM_128_HMAC_SHA1_32 inline:hB+VHS1Z6UDlDvkz8L0ulFZkDbqTuKzjEDEmW3Wg
  721.    a=crypto:9 AES_CM_128_NULL_AUTH inline:xVv5ZVwPi/CYc13TzJL2WfVF/Pl4hq/8i8A+lrw8
  722.    a=ptime:20
  723.    ------------------------------------------------------------------------
  724. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_state_machine.c:584 (sofia/default/CTTESTCALL027@192.168.1.175:33816) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 34)
  725. 2019-01-31 13:02:50.843076 [DEBUG] sofia.c:7084 Channel sofia/default/CTTESTCALL027@192.168.1.175:33816 entering state [calling][0]
  726. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_state_machine.c:662 (sofia/default/CTTESTCALL027@192.168.1.175:33816) State CONSUME_MEDIA
  727. 2019-01-31 13:02:50.843076 [DEBUG] switch_core_state_machine.c:662 (sofia/default/CTTESTCALL027@192.168.1.175:33816) State CONSUME_MEDIA going to sleep
  728. recv 291 bytes from tls/[103.249.234.189]:54246 at 13:02:51.426629:
  729.    ------------------------------------------------------------------------
  730.    SIP/2.0 100 Trying
  731.    v: SIP/2.0/TLS 81.95.124.28:5061;rport=5061;received=81.95.124.28;branch=z9hG4bKaayay5aUy09Dg
  732.    i: 5b147688-9ffb-1237-30b3-ee26cdf725c6
  733.    f: "029" <sip:CTTESTCALL029@81.95.124.28>;tag=Sr32KpZ0Sgyvg
  734.    t: <sip:CTTESTCALL027@192.168.1.175;ob>
  735.    CSeq: 134133821 INVITE
  736.    l:  0
  737.    
  738.    ------------------------------------------------------------------------
  739. recv 390 bytes from tls/[103.249.234.189]:54246 at 13:02:51.574988:
  740.    ------------------------------------------------------------------------
  741.    SIP/2.0 180 Ringing
  742.    v: SIP/2.0/TLS 81.95.124.28:5061;rport=5061;received=81.95.124.28;branch=z9hG4bKaayay5aUy09Dg
  743.    i: 5b147688-9ffb-1237-30b3-ee26cdf725c6
  744.    f: "029" <sip:CTTESTCALL029@81.95.124.28>;tag=Sr32KpZ0Sgyvg
  745.    t: <sip:CTTESTCALL027@192.168.1.175;ob>;tag=JXJAYnfVKLCJTjWT6tqtg1qnaJd58P3t
  746.    CSeq: 134133821 INVITE
  747.    m: <sip:CTTESTCALL027@192.168.1.175:33816;transport=TLS;ob>
  748.    l:  0
  749.    
  750.    ------------------------------------------------------------------------
  751. 2019-01-31 13:02:51.563114 [DEBUG] sofia.c:7084 Channel sofia/default/CTTESTCALL027@192.168.1.175:33816 entering state [proceeding][180]
  752. 2019-01-31 13:02:51.563114 [NOTICE] sofia.c:7192 Ring-Ready sofia/default/CTTESTCALL027@192.168.1.175:33816!
  753. 2019-01-31 13:02:51.563114 [DEBUG] switch_channel.c:3346 (sofia/default/CTTESTCALL027@192.168.1.175:33816) Callstate Change DOWN -> RINGING
  754. 2019-01-31 13:02:51.583141 [NOTICE] switch_ivr_originate.c:525 Ring Ready sofia/default/CTTESTCALL029@81.95.124.28!
  755. recv 778 bytes from tls/[103.249.234.189]:54246 at 13:02:56.868066:
  756.    ------------------------------------------------------------------------
  757.    SIP/2.0 200 OK
  758.    v: SIP/2.0/TLS 81.95.124.28:5061;rport=5061;received=81.95.124.28;branch=z9hG4bKaayay5aUy09Dg
  759.    i: 5b147688-9ffb-1237-30b3-ee26cdf725c6
  760.    f: "029" <sip:CTTESTCALL029@81.95.124.28>;tag=Sr32KpZ0Sgyvg
  761.    t: <sip:CTTESTCALL027@192.168.1.175;ob>;tag=JXJAYnfVKLCJTjWT6tqtg1qnaJd58P3t
  762.    CSeq: 134133821 INVITE
  763.    m: <sip:CTTESTCALL027@192.168.1.175:33816;transport=TLS;ob>
  764.    k: replaces, 100rel, timer, norefersub
  765.    c: application/sdp
  766.    l:   330
  767.    
  768.    v=0
  769.    o=- 3757928571 3757928572 IN IP4 192.168.1.175
  770.    s=pjmedia
  771.    c=IN IP4 192.168.1.175
  772.    t=0 0
  773.    m=audio 4000 RTP/SAVP 0 101
  774.    c=IN IP4 192.168.1.175
  775.    a=rtcp:4001 IN IP4 192.168.1.175
  776.    a=sendrecv
  777.    a=rtpmap:101 telephone-event/8000
  778.    a=fmtp:101 0-16
  779.    a=crypto:5 AES_CM_128_HMAC_SHA1_80 inline:d8d9CLaWcSB4zc5nbzcd1Tu2Lp0QVhf729BhauDH
  780.    ------------------------------------------------------------------------
  781. 2019-01-31 13:02:56.863044 [DEBUG] sofia.c:7084 Channel sofia/default/CTTESTCALL027@192.168.1.175:33816 entering state [completing][200]
  782. 2019-01-31 13:02:56.863044 [DEBUG] sofia.c:7094 Remote SDP:
  783. v=0
  784. o=- 3757928571 3757928572 IN IP4 192.168.1.175
  785. s=pjmedia
  786. c=IN IP4 192.168.1.175
  787. t=0 0
  788. m=audio 4000 RTP/SAVP 0 101
  789. c=IN IP4 192.168.1.175
  790. a=rtpmap:101 telephone-event/8000
  791. a=fmtp:101 0-16
  792. a=rtcp:4001 IN IP4 192.168.1.175
  793. a=crypto:5 AES_CM_128_HMAC_SHA1_80 inline:d8d9CLaWcSB4zc5nbzcd1Tu2Lp0QVhf729BhauDH
  794.  
  795. send 466 bytes to tls/[103.249.234.189]:54246 at 13:02:56.869484:
  796.    ------------------------------------------------------------------------
  797.    ACK sip:CTTESTCALL027@192.168.1.175:33816;transport=TLS;ob SIP/2.0
  798.    Via: SIP/2.0/TLS 81.95.124.28:5061;rport;branch=z9hG4bKBKQ3Z0UyU9Z0B
  799.    Max-Forwards: 70
  800.    From: "029" <sip:CTTESTCALL029@81.95.124.28>;tag=Sr32KpZ0Sgyvg
  801.    To: <sip:CTTESTCALL027@192.168.1.175:33816;transport=TLS;ob>;tag=JXJAYnfVKLCJTjWT6tqtg1qnaJd58P3t
  802.    Call-ID: 5b147688-9ffb-1237-30b3-ee26cdf725c6
  803.    CSeq: 134133821 ACK
  804.    Contact: <sip:mod_sofia@81.95.124.28:5061;transport=tls>
  805.    Content-Length: 0
  806.    
  807.    ------------------------------------------------------------------------
  808. 2019-01-31 13:02:56.863044 [DEBUG] sofia.c:7084 Channel sofia/default/CTTESTCALL027@192.168.1.175:33816 entering state [ready][200]
  809. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:1395 looking for crypto suite [AEAD_AES_256_GCM_8] in [5 AES_CM_128_HMAC_SHA1_80 inline:d8d9CLaWcSB4zc5nbzcd1Tu2Lp0QVhf729BhauDH]
  810. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:1395 looking for crypto suite [AEAD_AES_128_GCM_8] in [5 AES_CM_128_HMAC_SHA1_80 inline:d8d9CLaWcSB4zc5nbzcd1Tu2Lp0QVhf729BhauDH]
  811. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:1395 looking for crypto suite [AES_CM_256_HMAC_SHA1_80] in [5 AES_CM_128_HMAC_SHA1_80 inline:d8d9CLaWcSB4zc5nbzcd1Tu2Lp0QVhf729BhauDH]
  812. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:1395 looking for crypto suite [AES_CM_192_HMAC_SHA1_80] in [5 AES_CM_128_HMAC_SHA1_80 inline:d8d9CLaWcSB4zc5nbzcd1Tu2Lp0QVhf729BhauDH]
  813. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:1395 looking for crypto suite [AES_CM_128_HMAC_SHA1_80] in [5 AES_CM_128_HMAC_SHA1_80 inline:d8d9CLaWcSB4zc5nbzcd1Tu2Lp0QVhf729BhauDH]
  814. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:1400 Found suite AES_CM_128_HMAC_SHA1_80
  815. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:1466 Set Remote Key [5 AES_CM_128_HMAC_SHA1_80 inline:d8d9CLaWcSB4zc5nbzcd1Tu2Lp0QVhf729BhauDH]
  816. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  817. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  818. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
  819. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:3061 Set Codec sofia/default/CTTESTCALL027@192.168.1.175:33816 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  820. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_codec.c:111 sofia/default/CTTESTCALL027@192.168.1.175:33816 Original read codec set to PCMU:0
  821. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
  822. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:4767 sofia/default/CTTESTCALL027@192.168.1.175:33816 Set 2833 dtmf send payload to 101 recv payload to 101
  823. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:6878 AUDIO RTP [sofia/default/CTTESTCALL027@192.168.1.175:33816] 81.95.124.28 port 30830 -> 192.168.1.175 port 4000 codec: 0 ms: 20
  824. 2019-01-31 13:02:56.863044 [DEBUG] switch_rtp.c:4111 Starting timer [soft] 160 bytes per 20ms
  825. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:7098 Activating RTCP PORT 4001
  826. 2019-01-31 13:02:56.863044 [DEBUG] switch_rtp.c:4507 RTCP send rate is: 1000 and packet rate is: 20000 Remote Port: 4001
  827. 2019-01-31 13:02:56.863044 [DEBUG] switch_rtp.c:2567 Setting RTCP remote addr to 192.168.1.175:4001 2
  828. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:7179 sofia/default/CTTESTCALL027@192.168.1.175:33816 Set 2833 dtmf send payload to 101
  829. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:7186 sofia/default/CTTESTCALL027@192.168.1.175:33816 Set 2833 dtmf receive payload to 101
  830. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:7209 sofia/default/CTTESTCALL027@192.168.1.175:33816 Set rtp dtmf delay to 40
  831. 2019-01-31 13:02:56.863044 [INFO] switch_rtp.c:3915 Activating audio Secure RTP SEND
  832. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:sdes:AES_CM_128_HMAC_SHA1_80
  833. 2019-01-31 13:02:56.863044 [INFO] switch_rtp.c:3893 Activating audio Secure RTP RECV
  834. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:sdes:AES_CM_128_HMAC_SHA1_80
  835. 2019-01-31 13:02:56.863044 [NOTICE] sofia.c:8218 Channel [sofia/default/CTTESTCALL027@192.168.1.175:33816] has been answered
  836. 2019-01-31 13:02:56.863044 [DEBUG] switch_channel.c:3773 (sofia/default/CTTESTCALL027@192.168.1.175:33816) Callstate Change RINGING -> ACTIVE
  837. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:6878 AUDIO RTP [sofia/default/CTTESTCALL029@81.95.124.28] 81.95.124.28 port 20286 -> 192.168.1.176 port 4010 codec: 0 ms: 20
  838. 2019-01-31 13:02:56.863044 [DEBUG] switch_rtp.c:4111 Starting timer [soft] 160 bytes per 20ms
  839. 2019-01-31 13:02:56.863044 [DEBUG] switch_rtp.c:8332 Activate VAD codec PCMU 20ms
  840. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:7046 AUDIO RTP Engage VAD for sofia/default/CTTESTCALL029@81.95.124.28 ( in out )
  841. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:7098 Activating RTCP PORT 4011
  842. 2019-01-31 13:02:56.863044 [DEBUG] switch_rtp.c:4507 RTCP send rate is: 1000 and packet rate is: 20000 Remote Port: 4011
  843. 2019-01-31 13:02:56.863044 [DEBUG] switch_rtp.c:2567 Setting RTCP remote addr to 192.168.1.176:4011 2
  844. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:7179 sofia/default/CTTESTCALL029@81.95.124.28 Set 2833 dtmf send payload to 101
  845. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:7186 sofia/default/CTTESTCALL029@81.95.124.28 Set 2833 dtmf receive payload to 101
  846. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_media.c:7209 sofia/default/CTTESTCALL029@81.95.124.28 Set rtp dtmf delay to 40
  847. 2019-01-31 13:02:56.863044 [INFO] switch_rtp.c:3915 Activating audio Secure RTP SEND
  848. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:sdes:AES_CM_128_HMAC_SHA1_80
  849. 2019-01-31 13:02:56.863044 [INFO] switch_rtp.c:3893 Activating audio Secure RTP RECV
  850. 2019-01-31 13:02:56.863044 [DEBUG] mod_sofia.c:850 Local SDP sofia/default/CTTESTCALL029@81.95.124.28:
  851. v=0
  852. o=FreeSWITCH 1548919490 1548919491 IN IP4 81.95.124.28
  853. s=FreeSWITCH
  854. c=IN IP4 81.95.124.28
  855. t=0 0
  856. m=audio 20286 RTP/SAVP 0 101
  857. a=rtpmap:0 PCMU/8000
  858. a=rtpmap:101 telephone-event/8000
  859. a=fmtp:101 0-16
  860. a=ptime:20
  861. a=sendrecv
  862. a=rtcp:20287 IN IP4 81.95.124.28
  863. a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:nNL3KcLr541WF/YlClUdz/9zza85ke6XSt1jBsjW
  864.  
  865. 2019-01-31 13:02:56.863044 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:sdes:AES_CM_128_HMAC_SHA1_80
  866. 2019-01-31 13:02:56.863044 [NOTICE] switch_ivr_originate.c:3647 Channel [sofia/default/CTTESTCALL029@81.95.124.28] has been answered
  867. send 1148 bytes to tls/[103.249.234.189]:55144 at 13:02:56.881142:
  868.    ------------------------------------------------------------------------
  869.    SIP/2.0 200 OK
  870.    Via: SIP/2.0/TLS 192.168.1.176:37032;rport=55144;branch=z9hG4bKPjdupoVmLqSsNyzqdhAwlE-pEvSVQAVcRs;alias;received=103.249.234.189
  871.    f: <sip:CTTESTCALL029@81.95.124.28>;tag=LeV4xZGeHULUa2UgZgPiR9U9e3HmtlE3
  872.    To: <sip:wifi%23CTTESTCALL027@81.95.124.28>;tag=mB56aFBF83eZp
  873.    i: 7zHizyRvhAqxBZ7UxUQdmjUfEbDtjAma
  874.    CSeq: 646 INVITE
  875.    Contact: <sip:wifi#CTTESTCALL027@81.95.124.28:5061;transport=tls>
  876.    User-Agent: ASTPP
  877.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, NOTIFY, PUBLISH, SUBSCRIBE
  878.    Supported: path, replaces
  879.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  880.    Content-Type: application/sdp
  881.    Content-Disposition: session
  882.    Content-Length: 339
  883.    
  884.    v=0
  885.    o=FreeSWITCH 1548919490 1548919491 IN IP4 81.95.124.28
  886.    s=FreeSWITCH
  887.    c=IN IP4 81.95.124.28
  888.    t=0 0
  889.    m=audio 20286 RTP/SAVP 0 101
  890.    a=rtpmap:0 PCMU/8000
  891.    a=rtpmap:101 telephone-event/8000
  892.    a=fmtp:101 0-16
  893.    a=ptime:20
  894.    a=rtcp:20287 IN IP4 81.95.124.28
  895.    a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:nNL3KcLr541WF/YlClUdz/9zza85ke6XSt1jBsjW
  896.    ------------------------------------------------------------------------
  897. 2019-01-31 13:02:56.863044 [DEBUG] switch_channel.c:3773 (sofia/default/CTTESTCALL029@81.95.124.28) Callstate Change RINGING -> ACTIVE
  898. 2019-01-31 13:02:56.863044 [DEBUG] sofia.c:7084 Channel sofia/default/CTTESTCALL029@81.95.124.28 entering state [completed][200]
  899. 2019-01-31 13:02:56.863044 [DEBUG] switch_ivr_originate.c:3705 Originate Resulted in Success: [sofia/default/CTTESTCALL027@192.168.1.175:33816]
  900. 2019-01-31 13:02:56.863044 [DEBUG] switch_ivr_originate.c:2963 sofia/default/CTTESTCALL027@192.168.1.175:33816 Setting leg timeout to 30
  901. 2019-01-31 13:02:56.883034 [DEBUG] switch_ivr_originate.c:3705 Originate Resulted in Success: [sofia/default/CTTESTCALL027@192.168.1.175:33816]
  902. 2019-01-31 13:02:56.883034 [DEBUG] switch_ivr_bridge.c:1614 (sofia/default/CTTESTCALL027@192.168.1.175:33816) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
  903. 2019-01-31 13:02:56.883034 [DEBUG] switch_core_state_machine.c:584 (sofia/default/CTTESTCALL027@192.168.1.175:33816) Running State Change CS_EXCHANGE_MEDIA (Cur 2 Tot 34)
  904. 2019-01-31 13:02:56.883034 [DEBUG] switch_core_state_machine.c:653 (sofia/default/CTTESTCALL027@192.168.1.175:33816) State EXCHANGE_MEDIA
  905. 2019-01-31 13:02:56.883034 [DEBUG] mod_sofia.c:631 SOFIA EXCHANGE_MEDIA
  906. 2019-01-31 13:02:56.983116 [DEBUG] switch_rtp.c:1887 rtcp_stats_init: audio ssrc[806478040] base_seq[29998]
  907. 2019-01-31 13:02:57.063117 [DEBUG] switch_rtp.c:1887 rtcp_stats_init: audio ssrc[1813395729] base_seq[202]
  908. 2019-01-31 13:02:57.063117 [INFO] switch_rtp.c:6700 Auto Changing audio RTCP port from 192.168.1.176:4011 to 103.249.234.189:53651
  909. 2019-01-31 13:02:57.063117 [DEBUG] switch_rtp.c:2567 Setting RTCP remote addr to 103.249.234.189:53651 2
  910. recv 382 bytes from tls/[103.249.234.189]:55144 at 13:02:57.129519:
  911.    ------------------------------------------------------------------------
  912.    ACK sip:wifi%23CTTESTCALL027@81.95.124.28:5061;transport=tls SIP/2.0
  913.    v: SIP/2.0/TLS 192.168.1.176:37032;rport;branch=z9hG4bKPjvco0rGXKL6MJZLj413tfwRsch.Z7hbHI;alias
  914.    Max-Forwards: 70
  915.    f: <sip:CTTESTCALL029@81.95.124.28>;tag=LeV4xZGeHULUa2UgZgPiR9U9e3HmtlE3
  916.    t: <sip:wifi%23CTTESTCALL027@81.95.124.28>;tag=mB56aFBF83eZp
  917.    i: 7zHizyRvhAqxBZ7UxUQdmjUfEbDtjAma
  918.    CSeq: 646 ACK
  919.    l:  0
  920.    
  921.    ------------------------------------------------------------------------
  922. 2019-01-31 13:02:57.123134 [DEBUG] sofia.c:7084 Channel sofia/default/CTTESTCALL029@81.95.124.28 entering state [ready][200]
  923. 2019-01-31 13:02:57.203110 [INFO] switch_rtp.c:7231 Auto Changing audio port from 192.168.1.175:4000 to 103.249.234.189:53578
  924. 2019-01-31 13:02:57.283108 [INFO] switch_rtp.c:7231 Auto Changing audio port from 192.168.1.176:4010 to 103.249.234.189:53822
  925. 2019-01-31 13:02:57.543114 [INFO] switch_rtp.c:6700 Auto Changing audio RTCP port from 192.168.1.175:4001 to 103.249.234.189:54951
  926. 2019-01-31 13:02:57.543114 [DEBUG] switch_rtp.c:2567 Setting RTCP remote addr to 103.249.234.189:54951 2
  927. recv 400 bytes from tls/[103.249.234.189]:54246 at 13:03:01.382883:
  928.    ------------------------------------------------------------------------
  929.    BYE sip:mod_sofia@81.95.124.28:5061;transport=tls SIP/2.0
  930.    v: SIP/2.0/TLS 192.168.1.175:33816;rport;branch=z9hG4bKPjdmf9QWxn8V-gYdL2wrqDRbSV22Sj.dcJ;alias
  931.    Max-Forwards: 70
  932.    f: <sip:CTTESTCALL027@192.168.1.175;ob>;tag=JXJAYnfVKLCJTjWT6tqtg1qnaJd58P3t
  933.    t: "029" <sip:CTTESTCALL029@81.95.124.28>;tag=Sr32KpZ0Sgyvg
  934.    i: 5b147688-9ffb-1237-30b3-ee26cdf725c6
  935.    CSeq: 3717 BYE
  936.    User-Agent: CallApp
  937.    l:  0
  938.    
  939.    ------------------------------------------------------------------------
  940. 2019-01-31 13:03:01.383100 [NOTICE] sofia.c:1012 Hangup sofia/default/CTTESTCALL027@192.168.1.175:33816 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
  941. send 512 bytes to tls/[103.249.234.189]:54246 at 13:03:01.392060:
  942.    ------------------------------------------------------------------------
  943.    SIP/2.0 200 OK
  944.    Via: SIP/2.0/TLS 192.168.1.175:33816;rport=54246;branch=z9hG4bKPjdmf9QWxn8V-gYdL2wrqDRbSV22Sj.dcJ;alias;received=103.249.234.189
  945.    f: <sip:CTTESTCALL027@192.168.1.175;ob>;tag=JXJAYnfVKLCJTjWT6tqtg1qnaJd58P3t
  946.    t: "029" <sip:CTTESTCALL029@81.95.124.28>;tag=Sr32KpZ0Sgyvg
  947.    i: 5b147688-9ffb-1237-30b3-ee26cdf725c6
  948.    CSeq: 3717 BYE
  949.    User-Agent: ASTPP
  950.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, NOTIFY, PUBLISH, SUBSCRIBE
  951.    Supported: path, replaces
  952.    Content-Length: 0
  953.    
  954.    ------------------------------------------------------------------------
  955. 2019-01-31 13:03:01.383100 [DEBUG] switch_ivr_bridge.c:787 BRIDGE THREAD DONE [sofia/default/CTTESTCALL027@192.168.1.175:33816]
  956. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:653 (sofia/default/CTTESTCALL027@192.168.1.175:33816) State EXCHANGE_MEDIA going to sleep
  957. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:584 (sofia/default/CTTESTCALL027@192.168.1.175:33816) Running State Change CS_HANGUP (Cur 2 Tot 34)
  958. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:850 (sofia/default/CTTESTCALL027@192.168.1.175:33816) Callstate Change ACTIVE -> HANGUP
  959. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:852 (sofia/default/CTTESTCALL027@192.168.1.175:33816) State HANGUP
  960. 2019-01-31 13:03:01.383100 [DEBUG] mod_sofia.c:438 Channel sofia/default/CTTESTCALL027@192.168.1.175:33816 hanging up, cause: NORMAL_CLEARING
  961. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:60 sofia/default/CTTESTCALL027@192.168.1.175:33816 Standard HANGUP, cause: NORMAL_CLEARING
  962. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:852 (sofia/default/CTTESTCALL027@192.168.1.175:33816) State HANGUP going to sleep
  963. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:619 (sofia/default/CTTESTCALL027@192.168.1.175:33816) State Change CS_HANGUP -> CS_REPORTING
  964. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:584 (sofia/default/CTTESTCALL027@192.168.1.175:33816) Running State Change CS_REPORTING (Cur 2 Tot 34)
  965. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:938 (sofia/default/CTTESTCALL027@192.168.1.175:33816) State REPORTING
  966. 2019-01-31 13:03:01.383100 [INFO] mod_json_cdr.c:271 Process [47ae46c3-c426-49dd-9796-e55c2eb06284.cdr.json]
  967. 2019-01-31 13:03:01.383100 [DEBUG] switch_ivr_bridge.c:706 sofia/default/CTTESTCALL027@192.168.1.175:33816 ending bridge by request from write function
  968. 2019-01-31 13:03:01.383100 [ERR] mod_json_cdr.c:396 Got error [0] posting to web server [http://localhost:7742/cdr.php]
  969. 2019-01-31 13:03:01.383100 [ERR] mod_json_cdr.c:415 Unable to post to web server
  970. 2019-01-31 13:03:01.383100 [INFO] mod_json_cdr.c:208 Backup file /usr/local/freeswitch/log/xml_json/47ae46c3-c426-49dd-9796-e55c2eb06284.cdr.json
  971. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:174 sofia/default/CTTESTCALL027@192.168.1.175:33816 Standard REPORTING, cause: NORMAL_CLEARING
  972. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:938 (sofia/default/CTTESTCALL027@192.168.1.175:33816) State REPORTING going to sleep
  973. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:610 (sofia/default/CTTESTCALL027@192.168.1.175:33816) State Change CS_REPORTING -> CS_DESTROY
  974. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_session.c:1665 Session 34 (sofia/default/CTTESTCALL027@192.168.1.175:33816) Locked, Waiting on external entities
  975. 2019-01-31 13:03:01.383100 [DEBUG] switch_ivr_bridge.c:787 BRIDGE THREAD DONE [sofia/default/CTTESTCALL029@81.95.124.28]
  976. 2019-01-31 13:03:01.383100 [NOTICE] switch_ivr_bridge.c:1764 Hangup sofia/default/CTTESTCALL029@81.95.124.28 [CS_EXECUTE] [NORMAL_CLEARING]
  977. 2019-01-31 13:03:01.383100 [NOTICE] switch_core_session.c:1683 Session 34 (sofia/default/CTTESTCALL027@192.168.1.175:33816) Ended
  978. 2019-01-31 13:03:01.383100 [NOTICE] switch_core_session.c:1687 Close Channel sofia/default/CTTESTCALL027@192.168.1.175:33816 [CS_DESTROY]
  979. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_session.c:2815 sofia/default/CTTESTCALL029@81.95.124.28 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  980. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:741 (sofia/default/CTTESTCALL027@192.168.1.175:33816) Running State Change CS_DESTROY (Cur 1 Tot 34)
  981. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:650 (sofia/default/CTTESTCALL029@81.95.124.28) State EXECUTE going to sleep
  982. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:584 (sofia/default/CTTESTCALL029@81.95.124.28) Running State Change CS_HANGUP (Cur 1 Tot 34)
  983. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:751 (sofia/default/CTTESTCALL027@192.168.1.175:33816) State DESTROY
  984. 2019-01-31 13:03:01.383100 [DEBUG] mod_sofia.c:343 sofia/default/CTTESTCALL027@192.168.1.175:33816 SOFIA DESTROY
  985. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:181 sofia/default/CTTESTCALL027@192.168.1.175:33816 Standard DESTROY
  986. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:751 (sofia/default/CTTESTCALL027@192.168.1.175:33816) State DESTROY going to sleep
  987. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:850 (sofia/default/CTTESTCALL029@81.95.124.28) Callstate Change ACTIVE -> HANGUP
  988. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:852 (sofia/default/CTTESTCALL029@81.95.124.28) State HANGUP
  989. 2019-01-31 13:03:01.383100 [DEBUG] mod_sofia.c:432 sofia/default/CTTESTCALL029@81.95.124.28 Overriding SIP cause 480 with 200 from the other leg
  990. 2019-01-31 13:03:01.383100 [DEBUG] mod_sofia.c:438 Channel sofia/default/CTTESTCALL029@81.95.124.28 hanging up, cause: NORMAL_CLEARING
  991. 2019-01-31 13:03:01.383100 [DEBUG] mod_sofia.c:491 Sending BYE to sofia/default/CTTESTCALL029@81.95.124.28
  992. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:60 sofia/default/CTTESTCALL029@81.95.124.28 Standard HANGUP, cause: NORMAL_CLEARING
  993. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:852 (sofia/default/CTTESTCALL029@81.95.124.28) State HANGUP going to sleep
  994. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:619 (sofia/default/CTTESTCALL029@81.95.124.28) State Change CS_HANGUP -> CS_REPORTING
  995. send 577 bytes to tls/[103.249.234.189]:55144 at 13:03:01.402536:
  996.    ------------------------------------------------------------------------
  997.    BYE sip:CTTESTCALL029@192.168.1.176:37032;transport=TLS;ob SIP/2.0
  998.    Via: SIP/2.0/TLS 81.95.124.28:5061;rport;branch=z9hG4bKcvgv1Uc2rjpKQ
  999.    Max-Forwards: 70
  1000.    From: <sip:wifi%23CTTESTCALL027@81.95.124.28>;tag=mB56aFBF83eZp
  1001.    To: <sip:CTTESTCALL029@81.95.124.28>;tag=LeV4xZGeHULUa2UgZgPiR9U9e3HmtlE3
  1002.    Call-ID: 7zHizyRvhAqxBZ7UxUQdmjUfEbDtjAma
  1003.    CSeq: 134133826 BYE
  1004.    User-Agent: ASTPP
  1005.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, NOTIFY, PUBLISH, SUBSCRIBE
  1006.    Supported: path, replaces
  1007.    Reason: Q.850;cause=16;text="NORMAL_CLEARING"
  1008. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:584 (sofia/default/CTTESTCALL029@81.95.124.28) Running State Change CS_REPORTING (Cur 1 Tot 34)
  1009.    Content-Length: 0
  1010.    
  1011.    ------------------------------------------------------------------------
  1012. 2019-01-31 13:03:01.383100 [DEBUG] switch_core_state_machine.c:938 (sofia/default/CTTESTCALL029@81.95.124.28) State REPORTING
  1013. 2019-01-31 13:03:01.403038 [INFO] mod_json_cdr.c:271 Process [d1cc0546-0497-4b7d-995c-0729a4d2abac.cdr.json]
  1014. 2019-01-31 13:03:01.403038 [ERR] mod_json_cdr.c:396 Got error [0] posting to web server [http://localhost:7742/cdr.php]
  1015. 2019-01-31 13:03:01.403038 [ERR] mod_json_cdr.c:415 Unable to post to web server
  1016. 2019-01-31 13:03:01.403038 [INFO] mod_json_cdr.c:208 Backup file /usr/local/freeswitch/log/xml_json/d1cc0546-0497-4b7d-995c-0729a4d2abac.cdr.json
  1017. 2019-01-31 13:03:01.403038 [DEBUG] switch_core_state_machine.c:174 sofia/default/CTTESTCALL029@81.95.124.28 Standard REPORTING, cause: NORMAL_CLEARING
  1018. 2019-01-31 13:03:01.403038 [DEBUG] switch_core_state_machine.c:938 (sofia/default/CTTESTCALL029@81.95.124.28) State REPORTING going to sleep
  1019. 2019-01-31 13:03:01.403038 [DEBUG] switch_core_state_machine.c:610 (sofia/default/CTTESTCALL029@81.95.124.28) State Change CS_REPORTING -> CS_DESTROY
  1020. 2019-01-31 13:03:01.403038 [DEBUG] switch_core_session.c:1665 Session 33 (sofia/default/CTTESTCALL029@81.95.124.28) Locked, Waiting on external entities
  1021. 2019-01-31 13:03:01.403038 [NOTICE] switch_core_session.c:1683 Session 33 (sofia/default/CTTESTCALL029@81.95.124.28) Ended
  1022. 2019-01-31 13:03:01.403038 [NOTICE] switch_core_session.c:1687 Close Channel sofia/default/CTTESTCALL029@81.95.124.28 [CS_DESTROY]
  1023. 2019-01-31 13:03:01.403038 [DEBUG] switch_core_state_machine.c:741 (sofia/default/CTTESTCALL029@81.95.124.28) Running State Change CS_DESTROY (Cur 0 Tot 34)
  1024. 2019-01-31 13:03:01.403038 [DEBUG] switch_core_state_machine.c:751 (sofia/default/CTTESTCALL029@81.95.124.28) State DESTROY
  1025. 2019-01-31 13:03:01.403038 [DEBUG] mod_sofia.c:343 sofia/default/CTTESTCALL029@81.95.124.28 SOFIA DESTROY
  1026. 2019-01-31 13:03:01.403038 [DEBUG] switch_core_state_machine.c:181 sofia/default/CTTESTCALL029@81.95.124.28 Standard DESTROY
  1027. 2019-01-31 13:03:01.403038 [DEBUG] switch_core_state_machine.c:751 (sofia/default/CTTESTCALL029@81.95.124.28) State DESTROY going to sleep
  1028. recv 400 bytes from tls/[103.249.234.189]:54246 at 13:03:01.418600:
  1029.    ------------------------------------------------------------------------
  1030.    BYE sip:mod_sofia@81.95.124.28:5061;transport=tls SIP/2.0
  1031.    v: SIP/2.0/TLS 192.168.1.175:33816;rport;branch=z9hG4bKPj.uU.KQ.53rN2NK-sjp67HJ-pNI3l9m8k;alias
  1032.    Max-Forwards: 70
  1033.    f: <sip:CTTESTCALL027@192.168.1.175;ob>;tag=JXJAYnfVKLCJTjWT6tqtg1qnaJd58P3t
  1034.    t: "029" <sip:CTTESTCALL029@81.95.124.28>;tag=Sr32KpZ0Sgyvg
  1035.    i: 5b147688-9ffb-1237-30b3-ee26cdf725c6
  1036.    CSeq: 3718 BYE
  1037.    User-Agent: CallApp
  1038.    l:  0
  1039.    
  1040.    ------------------------------------------------------------------------
  1041. send 529 bytes to tls/[103.249.234.189]:54246 at 13:03:01.418758:
  1042.    ------------------------------------------------------------------------
  1043.    SIP/2.0 481 Call Does Not Exist
  1044.    Via: SIP/2.0/TLS 192.168.1.175:33816;rport=54246;branch=z9hG4bKPj.uU.KQ.53rN2NK-sjp67HJ-pNI3l9m8k;alias;received=103.249.234.189
  1045.    f: <sip:CTTESTCALL027@192.168.1.175;ob>;tag=JXJAYnfVKLCJTjWT6tqtg1qnaJd58P3t
  1046.    t: "029" <sip:CTTESTCALL029@81.95.124.28>;tag=Sr32KpZ0Sgyvg
  1047.    i: 5b147688-9ffb-1237-30b3-ee26cdf725c6
  1048.    CSeq: 3718 BYE
  1049.    User-Agent: ASTPP
  1050.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, NOTIFY, PUBLISH, SUBSCRIBE
  1051.    Supported: path, replaces
  1052.    Content-Length: 0
  1053.    
  1054.    ------------------------------------------------------------------------
  1055. recv 400 bytes from tls/[103.249.234.189]:54246 at 13:03:01.418972:
  1056.    ------------------------------------------------------------------------
  1057.    BYE sip:mod_sofia@81.95.124.28:5061;transport=tls SIP/2.0
  1058.    v: SIP/2.0/TLS 192.168.1.175:33816;rport;branch=z9hG4bKPjeQ6ohNB6GFsabur1BGphqmr23k13CQ9B;alias
  1059.    Max-Forwards: 70
  1060.    f: <sip:CTTESTCALL027@192.168.1.175;ob>;tag=JXJAYnfVKLCJTjWT6tqtg1qnaJd58P3t
  1061.    t: "029" <sip:CTTESTCALL029@81.95.124.28>;tag=Sr32KpZ0Sgyvg
  1062.    i: 5b147688-9ffb-1237-30b3-ee26cdf725c6
  1063.    CSeq: 3719 BYE
  1064.    User-Agent: CallApp
  1065.    l:  0
  1066.    
  1067.    ------------------------------------------------------------------------
  1068. send 529 bytes to tls/[103.249.234.189]:54246 at 13:03:01.419063:
  1069.    ------------------------------------------------------------------------
  1070.    SIP/2.0 481 Call Does Not Exist
  1071.    Via: SIP/2.0/TLS 192.168.1.175:33816;rport=54246;branch=z9hG4bKPjeQ6ohNB6GFsabur1BGphqmr23k13CQ9B;alias;received=103.249.234.189
  1072.    f: <sip:CTTESTCALL027@192.168.1.175;ob>;tag=JXJAYnfVKLCJTjWT6tqtg1qnaJd58P3t
  1073.    t: "029" <sip:CTTESTCALL029@81.95.124.28>;tag=Sr32KpZ0Sgyvg
  1074.    i: 5b147688-9ffb-1237-30b3-ee26cdf725c6
  1075.    CSeq: 3719 BYE
  1076.    User-Agent: ASTPP
  1077.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, NOTIFY, PUBLISH, SUBSCRIBE
  1078.    Supported: path, replaces
  1079.    Content-Length: 0
  1080.    
  1081.    ------------------------------------------------------------------------
  1082. recv 400 bytes from tls/[103.249.234.189]:54246 at 13:03:01.419248:
  1083.    ------------------------------------------------------------------------
  1084.    BYE sip:mod_sofia@81.95.124.28:5061;transport=tls SIP/2.0
  1085.    v: SIP/2.0/TLS 192.168.1.175:33816;rport;branch=z9hG4bKPjcoG1uj9Mc5L6BqKk.vaBHrpeZdAZFzws;alias
  1086.    Max-Forwards: 70
  1087.    f: <sip:CTTESTCALL027@192.168.1.175;ob>;tag=JXJAYnfVKLCJTjWT6tqtg1qnaJd58P3t
  1088.    t: "029" <sip:CTTESTCALL029@81.95.124.28>;tag=Sr32KpZ0Sgyvg
  1089.    i: 5b147688-9ffb-1237-30b3-ee26cdf725c6
  1090.    CSeq: 3720 BYE
  1091.    User-Agent: CallApp
  1092.    l:  0
  1093.    
  1094.    ------------------------------------------------------------------------
  1095. send 529 bytes to tls/[103.249.234.189]:54246 at 13:03:01.419358:
  1096.    ------------------------------------------------------------------------
  1097.    SIP/2.0 481 Call Does Not Exist
  1098.    Via: SIP/2.0/TLS 192.168.1.175:33816;rport=54246;branch=z9hG4bKPjcoG1uj9Mc5L6BqKk.vaBHrpeZdAZFzws;alias;received=103.249.234.189
  1099.    f: <sip:CTTESTCALL027@192.168.1.175;ob>;tag=JXJAYnfVKLCJTjWT6tqtg1qnaJd58P3t
  1100.    t: "029" <sip:CTTESTCALL029@81.95.124.28>;tag=Sr32KpZ0Sgyvg
  1101.    i: 5b147688-9ffb-1237-30b3-ee26cdf725c6
  1102.    CSeq: 3720 BYE
  1103.    User-Agent: ASTPP
  1104.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, NOTIFY, PUBLISH, SUBSCRIBE
  1105.    Supported: path, replaces
  1106.    Content-Length: 0
  1107.    
  1108.    ------------------------------------------------------------------------
  1109. recv 314 bytes from tls/[103.249.234.189]:55144 at 13:03:01.538411:
  1110.    ------------------------------------------------------------------------
  1111.    SIP/2.0 200 OK
  1112.    v: SIP/2.0/TLS 81.95.124.28:5061;rport=5061;received=81.95.124.28;branch=z9hG4bKcvgv1Uc2rjpKQ
  1113.    i: 7zHizyRvhAqxBZ7UxUQdmjUfEbDtjAma
  1114.    f: <sip:wifi%23CTTESTCALL027@81.95.124.28>;tag=mB56aFBF83eZp
  1115.    t: <sip:CTTESTCALL029@81.95.124.28>;tag=LeV4xZGeHULUa2UgZgPiR9U9e3HmtlE3
  1116.    CSeq: 134133826 BYE
  1117.    l:  0
  1118.    
  1119.    ------------------------------------------------------------------------
  1120. recv 400 bytes from tls/[103.249.234.189]:54246 at 13:03:01.556322:
  1121.    ------------------------------------------------------------------------
  1122.    BYE sip:mod_sofia@81.95.124.28:5061;transport=tls SIP/2.0
  1123.    v: SIP/2.0/TLS 192.168.1.175:33816;rport;branch=z9hG4bKPjOEraD8heVxy5Mc2Dx7s57mSaIOq1iJb5;alias
  1124.    Max-Forwards: 70
  1125.    f: <sip:CTTESTCALL027@192.168.1.175;ob>;tag=JXJAYnfVKLCJTjWT6tqtg1qnaJd58P3t
  1126.    t: "029" <sip:CTTESTCALL029@81.95.124.28>;tag=Sr32KpZ0Sgyvg
  1127.    i: 5b147688-9ffb-1237-30b3-ee26cdf725c6
  1128.    CSeq: 3721 BYE
  1129.    User-Agent: CallApp
  1130.    l:  0
  1131.    
  1132.    ------------------------------------------------------------------------
  1133. send 529 bytes to tls/[103.249.234.189]:54246 at 13:03:01.556466:
  1134.    ------------------------------------------------------------------------
  1135.    SIP/2.0 481 Call Does Not Exist
  1136.    Via: SIP/2.0/TLS 192.168.1.175:33816;rport=54246;branch=z9hG4bKPjOEraD8heVxy5Mc2Dx7s57mSaIOq1iJb5;alias;received=103.249.234.189
  1137.    f: <sip:CTTESTCALL027@192.168.1.175;ob>;tag=JXJAYnfVKLCJTjWT6tqtg1qnaJd58P3t
  1138.    t: "029" <sip:CTTESTCALL029@81.95.124.28>;tag=Sr32KpZ0Sgyvg
  1139.    i: 5b147688-9ffb-1237-30b3-ee26cdf725c6
  1140.    CSeq: 3721 BYE
  1141.    User-Agent: ASTPP
  1142.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, NOTIFY, PUBLISH, SUBSCRIBE
  1143.    Supported: path, replaces
  1144.    Content-Length: 0
  1145.    
  1146.    ------------------------------------------------------------------------
  1147. recv 400 bytes from tls/[103.249.234.189]:54246 at 13:03:01.556671:
  1148.    ------------------------------------------------------------------------
  1149.    BYE sip:mod_sofia@81.95.124.28:5061;transport=tls SIP/2.0
  1150.    v: SIP/2.0/TLS 192.168.1.175:33816;rport;branch=z9hG4bKPj6gT9NjphiQYkL5FEe4LH11iG29hHGI-y;alias
  1151.    Max-Forwards: 70
  1152.    f: <sip:CTTESTCALL027@192.168.1.175;ob>;tag=JXJAYnfVKLCJTjWT6tqtg1qnaJd58P3t
  1153.    t: "029" <sip:CTTESTCALL029@81.95.124.28>;tag=Sr32KpZ0Sgyvg
  1154.    i: 5b147688-9ffb-1237-30b3-ee26cdf725c6
  1155.    CSeq: 3722 BYE
  1156.    User-Agent: CallApp
  1157.    l:  0
  1158.    
  1159.    ------------------------------------------------------------------------
  1160. send 529 bytes to tls/[103.249.234.189]:54246 at 13:03:01.556744:
  1161.    ------------------------------------------------------------------------
  1162.    SIP/2.0 481 Call Does Not Exist
  1163.    Via: SIP/2.0/TLS 192.168.1.175:33816;rport=54246;branch=z9hG4bKPj6gT9NjphiQYkL5FEe4LH11iG29hHGI-y;alias;received=103.249.234.189
  1164.    f: <sip:CTTESTCALL027@192.168.1.175;ob>;tag=JXJAYnfVKLCJTjWT6tqtg1qnaJd58P3t
  1165.    t: "029" <sip:CTTESTCALL029@81.95.124.28>;tag=Sr32KpZ0Sgyvg
  1166.    i: 5b147688-9ffb-1237-30b3-ee26cdf725c6
  1167.    CSeq: 3722 BYE
  1168.    User-Agent: ASTPP
  1169.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, NOTIFY, PUBLISH, SUBSCRIBE
  1170.    Supported: path, replaces
  1171.    Content-Length: 0
  1172.    
  1173.    ------------------------------------------------------------------------
  1174. 2019-01-31 13:03:01.863041 [DEBUG] switch_scheduler.c:144 Deleting task 20 switch_ivr_schedule_hangup (d1cc0546-0497-4b7d-995c-0729a4d2abac)
  1175. freeswitch@astpp04>
  1176.  

Reply to "working-arvind-in-bkg"