From FSLogger, 7 Years ago, written in Plain Text.
- view diff
Embed
  1. [m[33m[44m.=======================================================.
  2. |            _____ ____     ____ _     ___              |
  3. |           |  ___/ ___|   / ___| |   |_ _|             |
  4. |           | |_  \___ \  | |   | |    | |              |
  5. |           |  _|  ___) | | |___| |___ | |              |
  6. |           |_|   |____/   \____|_____|___|             |
  7. |                                                       |
  8. .=======================================================.
  9. | Anthony Minessale II, Ken Rice,                       |
  10. | Michael Jerris, Travis Cross                          |
  11. | FreeSWITCH (http://www.freeswitch.org)                |
  12. | Paypal Donations Appreciated: paypal@freeswitch.org   |
  13. | Brought to you by ClueCon http://www.cluecon.com/     |
  14. .=======================================================.
  15.  
  16. .===============================================================.
  17. |       _                                                       |
  18. |   ___| |_   _  ___  ___ ___  _ __         ___ ___  _ __ ___   |
  19. |  / __| | | | |/ _ \/ __/ _ \| '_ \       / __/ _ \| '_ ` _ \  |
  20. | | (__| | |_| |  __/ (_| (_) | | | |  _  | (_| (_) | | | | | | |
  21. |  \___|_|\__,_|\___|\___\___/|_| |_| (_)  \___\___/|_| |_| |_| |
  22. |                                                               |
  23. .===============================================================.
  24. [m
  25. Type /help <enter> to see a list of commands
  26.  
  27.  
  28.  
  29. [m
  30. [This app Best viewed at 160x60 or more..]
  31. +OK log level 7 [7]
  32. freeswitch@default> Enabled sip debugging on internal
  33. freeswitch@default> recv 549 bytes from udp/[177.92.48.107]:60865 at 17:31:45.689775:
  34.    ------------------------------------------------------------------------
  35.    REGISTER sip:sip1.phonetrack.com.br SIP/2.0
  36.    Via: SIP/2.0/UDP 192.168.0.202:5060;branch=z9hG4bK-ae0483a3
  37.    From: From Office PSTN <sip:1001@sip1.phonetrack.com.br>;tag=76d4ab50aee00088o0
  38.    To: From Office PSTN <sip:1001@sip1.phonetrack.com.br>
  39.    Call-ID: 89892a52-c374bcb8@127.0.0.1
  40.    CSeq: 77309 REGISTER
  41.    Max-Forwards: 70
  42.    Contact: From Office PSTN <sip:1001@192.168.0.202:5060>;expires=3600
  43.    User-Agent: Linksys/SPA3102-5.2.13(GW002)
  44.    Content-Length: 0
  45.    Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
  46.    Supported: x-sipura, replaces
  47.    
  48.    ------------------------------------------------------------------------
  49. send 637 bytes to udp/[177.92.48.107]:5060 at 17:31:45.689933:
  50.    ------------------------------------------------------------------------
  51.    SIP/2.0 401 Unauthorized
  52.    Via: SIP/2.0/UDP 192.168.0.202:5060;branch=z9hG4bK-ae0483a3;received=177.92.48.107
  53.    From: From Office PSTN <sip:1001@sip1.phonetrack.com.br>;tag=76d4ab50aee00088o0
  54.    To: From Office PSTN <sip:1001@sip1.phonetrack.com.br>;tag=eD4r0rX8SQ57B
  55.    Call-ID: 89892a52-c374bcb8@127.0.0.1
  56.    CSeq: 77309 REGISTER
  57.    User-Agent: PhoneTrack
  58.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  59.    Supported: path, replaces
  60.    WWW-Authenticate: Digest realm="sip1.phonetrack.com.br", nonce="2055a344-9d45-11e6-a5ef-9bbfbda5c291", algorithm=MD5, qop="auth"
  61.    Content-Length: 0
  62.    
  63.    ------------------------------------------------------------------------
  64. recv 498 bytes from udp/[177.92.48.107]:60864 at 17:31:45.690260:
  65.    ------------------------------------------------------------------------
  66.    REGISTER sip:169.57.148.25 SIP/2.0
  67.    Via: SIP/2.0/UDP 192.168.0.202:5061;branch=z9hG4bK-466a16cb
  68.    From: GVT PSTN <sip:1010@169.57.148.25>;tag=e8e015108e55a1c8o1
  69.    To: GVT PSTN <sip:1010@169.57.148.25>
  70.    Call-ID: 8015e2e0-bcbdad82@127.0.0.1
  71.    CSeq: 58299 REGISTER
  72.    Max-Forwards: 70
  73.    Contact: GVT PSTN <sip:1010@192.168.0.202:5061>;expires=3600
  74.    User-Agent: Linksys/SPA3102-5.2.13(GW002)
  75.    Content-Length: 0
  76.    Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
  77.    Supported: x-sipura, replaces
  78.    
  79.    ------------------------------------------------------------------------
  80. send 594 bytes to udp/[177.92.48.107]:5061 at 17:31:45.690365:
  81.    ------------------------------------------------------------------------
  82.    SIP/2.0 401 Unauthorized
  83.    Via: SIP/2.0/UDP 192.168.0.202:5061;branch=z9hG4bK-466a16cb;received=177.92.48.107
  84.    From: GVT PSTN <sip:1010@169.57.148.25>;tag=e8e015108e55a1c8o1
  85.    To: GVT PSTN <sip:1010@169.57.148.25>;tag=FpXH2KecQ0UtQ
  86.    Call-ID: 8015e2e0-bcbdad82@127.0.0.1
  87.    CSeq: 58299 REGISTER
  88.    User-Agent: PhoneTrack
  89.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  90.    Supported: path, replaces
  91.    WWW-Authenticate: Digest realm="169.57.148.25", nonce="2055b79e-9d45-11e6-a5f0-9bbfbda5c291", algorithm=MD5, qop="auth"
  92.    Content-Length: 0
  93.    
  94.    ------------------------------------------------------------------------
  95. send 785 bytes to udp/[201.86.87.2]:5060 at 17:31:49.425051:
  96.    ------------------------------------------------------------------------
  97.    REGISTER sip:vono.net.br;transport=udp SIP/2.0
  98.    Via: SIP/2.0/UDP 169.57.148.25:5080;rport;branch=z9hG4bK868Qgy3jHeacK
  99.    Max-Forwards: 70
  100.    From: <sip:marciojc12@vono.net.br>;tag=NSvmSpZ3eSgvH
  101.    To: <sip:marciojc12@vono.net.br>
  102.    Call-ID: c54818de-8c0e-11e6-ab72-9bbfbda5c291
  103.    CSeq: 98421156 REGISTER
  104.    Contact: <sip:marciojc12@169.57.148.25:5080;transport=udp;gw=gvt-marciojc>
  105.    Expires: 600
  106.    User-Agent: FreeSWITCH-mod_sofia/1.4.26~64bit
  107.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  108.    Supported: timer, path, replaces
  109.    Authorization: Digest username="marciojc12", realm="vono", nonce="5813a7a29d50c7e8df7b1ff35d946a8a5b9172a6", algorithm=MD5, uri="sip:vono.net.br;transport=udp", response="2f696f61266e6c41f301c92726c2e5c7"
  110.    Content-Length: 0
  111.    
  112.    ------------------------------------------------------------------------
  113. recv 678 bytes from udp/[201.86.87.2]:5060 at 17:31:49.442837:
  114.    ------------------------------------------------------------------------
  115.    SIP/2.0 401 Unauthorized
  116.    Via: SIP/2.0/UDP 169.57.148.25:5080;received=169.57.148.25;branch=z9hG4bK868Qgy3jHeacK;rport=5080
  117.    From: <sip:marciojc12@vono.net.br>;tag=NSvmSpZ3eSgvH
  118.    To: <sip:marciojc12@vono.net.br>;tag=SDs027699-d6f710fce8c3b3ed764bb057a100053d.b3fd
  119.    Call-ID: c54818de-8c0e-11e6-ab72-9bbfbda5c291
  120.    CSeq: 98421156 REGISTER
  121.    WWW-Authenticate: Digest realm="vono", nonce="5813a8d118c24b3765bac04112fd9647e7742913", stale=true
  122.    Server: Plataforma Vono
  123.    Content-Length: 0
  124.    Warning: 392 10.141.1.118:6060 "Noisy feedback tells:  pid=2872 req_src_ip=10.141.1.112 req_src_port=5060 in_uri=sip:vono.net.br;transport=udp out_uri=sip:vono.net.br;transport=udp via_cnt==2"
  125.    
  126.    ------------------------------------------------------------------------
  127. send 785 bytes to udp/[201.86.87.2]:5060 at 17:31:49.443914:
  128.    ------------------------------------------------------------------------
  129.    REGISTER sip:vono.net.br;transport=udp SIP/2.0
  130.    Via: SIP/2.0/UDP 169.57.148.25:5080;rport;branch=z9hG4bK9F2gjSmpeQ0ye
  131.    Max-Forwards: 70
  132.    From: <sip:marciojc12@vono.net.br>;tag=NSvmSpZ3eSgvH
  133.    To: <sip:marciojc12@vono.net.br>
  134.    Call-ID: c54818de-8c0e-11e6-ab72-9bbfbda5c291
  135.    CSeq: 98421157 REGISTER
  136.    Contact: <sip:marciojc12@169.57.148.25:5080;transport=udp;gw=gvt-marciojc>
  137.    Expires: 600
  138.    User-Agent: FreeSWITCH-mod_sofia/1.4.26~64bit
  139.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  140.    Supported: timer, path, replaces
  141.    Authorization: Digest username="marciojc12", realm="vono", nonce="5813a8d118c24b3765bac04112fd9647e7742913", algorithm=MD5, uri="sip:vono.net.br;transport=udp", response="ea75d7dee4d49130379ca69db94a08c3"
  142.    Content-Length: 0
  143.    
  144.    ------------------------------------------------------------------------
  145. recv 655 bytes from udp/[201.86.87.2]:5060 at 17:31:49.503512:
  146.    ------------------------------------------------------------------------
  147.    SIP/2.0 200 OK
  148.    Via: SIP/2.0/UDP 169.57.148.25:5080;received=169.57.148.25;branch=z9hG4bK9F2gjSmpeQ0ye;rport=5080
  149.    From: <sip:marciojc12@vono.net.br>;tag=NSvmSpZ3eSgvH
  150.    To: <sip:marciojc12@vono.net.br>;tag=SDs027699-d6f710fce8c3b3ed764bb057a100053d.dda8
  151.    Call-ID: c54818de-8c0e-11e6-ab72-9bbfbda5c291
  152.    CSeq: 98421157 REGISTER
  153.    Contact: <sip:marciojc12@169.57.148.25:5080;transport=udp;gw=gvt-marciojc>;expires=600
  154.    Server: Plataforma Vono
  155.    Content-Length: 0
  156.    Warning: 392 10.141.1.118:6060 "Noisy feedback tells:  pid=2841 req_src_ip=10.141.1.112 req_src_port=5060 in_uri=sip:vono.net.br;transport=udp out_uri=sip:vono.net.br;transport=udp via_cnt==2"
  157.    
  158.    ------------------------------------------------------------------------
  159. recv 549 bytes from udp/[177.92.48.107]:60865 at 17:31:49.690070:
  160.    ------------------------------------------------------------------------
  161.    REGISTER sip:sip1.phonetrack.com.br SIP/2.0
  162.    Via: SIP/2.0/UDP 192.168.0.202:5060;branch=z9hG4bK-ae0483a3
  163.    From: From Office PSTN <sip:1001@sip1.phonetrack.com.br>;tag=76d4ab50aee00088o0
  164.    To: From Office PSTN <sip:1001@sip1.phonetrack.com.br>
  165.    Call-ID: 89892a52-c374bcb8@127.0.0.1
  166.    CSeq: 77309 REGISTER
  167.    Max-Forwards: 70
  168.    Contact: From Office PSTN <sip:1001@192.168.0.202:5060>;expires=3600
  169.    User-Agent: Linksys/SPA3102-5.2.13(GW002)
  170.    Content-Length: 0
  171.    Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
  172.    Supported: x-sipura, replaces
  173.    
  174.    ------------------------------------------------------------------------
  175. send 637 bytes to udp/[177.92.48.107]:5060 at 17:31:49.692266:
  176.    ------------------------------------------------------------------------
  177.    SIP/2.0 401 Unauthorized
  178.    Via: SIP/2.0/UDP 192.168.0.202:5060;branch=z9hG4bK-ae0483a3;received=177.92.48.107
  179.    From: From Office PSTN <sip:1001@sip1.phonetrack.com.br>;tag=76d4ab50aee00088o0
  180.    To: From Office PSTN <sip:1001@sip1.phonetrack.com.br>;tag=eD4r0rX8SQ57B
  181.    Call-ID: 89892a52-c374bcb8@127.0.0.1
  182.    CSeq: 77309 REGISTER
  183.    User-Agent: PhoneTrack
  184.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  185.    Supported: path, replaces
  186.    WWW-Authenticate: Digest realm="sip1.phonetrack.com.br", nonce="2055a344-9d45-11e6-a5ef-9bbfbda5c291", algorithm=MD5, qop="auth"
  187.    Content-Length: 0
  188.    
  189.    ------------------------------------------------------------------------
  190. recv 498 bytes from udp/[177.92.48.107]:60864 at 17:31:49.692393:
  191.    ------------------------------------------------------------------------
  192.    REGISTER sip:169.57.148.25 SIP/2.0
  193.    Via: SIP/2.0/UDP 192.168.0.202:5061;branch=z9hG4bK-466a16cb
  194.    From: GVT PSTN <sip:1010@169.57.148.25>;tag=e8e015108e55a1c8o1
  195.    To: GVT PSTN <sip:1010@169.57.148.25>
  196.    Call-ID: 8015e2e0-bcbdad82@127.0.0.1
  197.    CSeq: 58299 REGISTER
  198.    Max-Forwards: 70
  199.    Contact: GVT PSTN <sip:1010@192.168.0.202:5061>;expires=3600
  200.    User-Agent: Linksys/SPA3102-5.2.13(GW002)
  201.    Content-Length: 0
  202.    Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
  203.    Supported: x-sipura, replaces
  204.    
  205.    ------------------------------------------------------------------------
  206. send 594 bytes to udp/[177.92.48.107]:5061 at 17:31:49.692504:
  207.    ------------------------------------------------------------------------
  208.    SIP/2.0 401 Unauthorized
  209.    Via: SIP/2.0/UDP 192.168.0.202:5061;branch=z9hG4bK-466a16cb;received=177.92.48.107
  210.    From: GVT PSTN <sip:1010@169.57.148.25>;tag=e8e015108e55a1c8o1
  211.    To: GVT PSTN <sip:1010@169.57.148.25>;tag=FpXH2KecQ0UtQ
  212.    Call-ID: 8015e2e0-bcbdad82@127.0.0.1
  213.    CSeq: 58299 REGISTER
  214.    User-Agent: PhoneTrack
  215.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  216.    Supported: path, replaces
  217.    WWW-Authenticate: Digest realm="169.57.148.25", nonce="2055b79e-9d45-11e6-a5f0-9bbfbda5c291", algorithm=MD5, qop="auth"
  218.    Content-Length: 0
  219.    
  220.    ------------------------------------------------------------------------
  221. recv 996 bytes from udp/[200.201.197.137]:5060 at 17:31:52.453147:
  222.    ------------------------------------------------------------------------
  223.    INVITE sip:553140421175@169.57.148.25:5080;transport=udp;gw=gtgroup SIP/2.0
  224.    CSeq: 1 INVITE
  225.    Via: SIP/2.0/UDP 200.201.197.137:5060;branch=z9hG4bK311754136513860783951828
  226.    User-Agent: VoipSwitch 2.0
  227.    From: 553134177781 <sip:553134177781@200.201.197.137:5060>;tag=173154783951828
  228.    Call-ID: OGtK94Tu5Gc5481758-8c0e-11e6-ab71-9bbfbda5c291@200.201.197.137
  229.    To: <sip:553140421175@199.59.97.196:5060>
  230.    Contact: <sip:200.201.197.137:5060;transport=udp>
  231.    Allow: INVITE, ACK, OPTIONS, BYE, CANCEL, REGISTER, INFO, NOTIFY, MESSAGE, SUBSCRIBE, REFER, PUBLISH, UPDATE
  232.    Content-Type: application/sdp
  233.    Content-Length: 368
  234.    Max-Forwards: 70
  235.    
  236.    v=0
  237.    o=- 1291593172 1291593173 IN IP4 200.201.197.137
  238.    s=VoipSIP
  239.    c=IN IP4 200.201.197.137
  240.    t=0 0
  241.    m=audio 6772 RTP/AVP 18 4 3 8 0 101
  242.    a=rtpmap:18 G729/8000/1
  243.    a=fmtp:18 annexb=no
  244.    a=rtpmap:4 G723/8000/1
  245.    a=fmtp:4 bitrate=6.3;annexa=yes
  246.    a=rtpmap:3 GSM/8000
  247.    a=rtpmap:8 PCMA/8000
  248.    a=rtpmap:0 PCMU/8000
  249.    a=rtpmap:101 telephone-event/8000
  250.    a=fmtp:101 0-16
  251.    a=sendrecv
  252.    ------------------------------------------------------------------------
  253. send 378 bytes to udp/[200.201.197.137]:5060 at 17:31:52.453535:
  254.    ------------------------------------------------------------------------
  255.    SIP/2.0 100 Trying
  256.    Via: SIP/2.0/UDP 200.201.197.137:5060;branch=z9hG4bK311754136513860783951828
  257.    From: 553134177781 <sip:553134177781@200.201.197.137:5060>;tag=173154783951828
  258.    To: <sip:553140421175@199.59.97.196:5060>
  259.    Call-ID: OGtK94Tu5Gc5481758-8c0e-11e6-ab71-9bbfbda5c291@200.201.197.137
  260.    CSeq: 1 INVITE
  261.    User-Agent: FreeSWITCH-mod_sofia/1.4.26~64bit
  262.    Content-Length: 0
  263.    
  264.    ------------------------------------------------------------------------
  265. 2016-10-28 17:31:52.450302 [NOTICE] switch_channel.c:1077 New Channel sofia/external/553134177781@200.201.197.137:5060 [2d96db4a-9d45-11e6-a5fd-9bbfbda5c291]
  266. 2016-10-28 17:31:52.450302 [DEBUG] switch_core_session.c:1062 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  267. 2016-10-28 17:31:52.450302 [DEBUG] switch_core_session.c:1062 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  268. 2016-10-28 17:31:52.450302 [DEBUG] switch_core_state_machine.c:472 (sofia/external/553134177781@200.201.197.137:5060) Running State Change CS_NEW
  269. 2016-10-28 17:31:52.450302 [DEBUG] sofia.c:8957 sofia/external/553134177781@200.201.197.137:5060 receiving invite from 200.201.197.137:5060 version: 1.4.26  64bit
  270. 2016-10-28 17:31:52.450302 [DEBUG] sofia.c:6658 Channel sofia/external/553134177781@200.201.197.137:5060 entering state [received][100]
  271. 2016-10-28 17:31:52.450302 [DEBUG] sofia.c:6668 Remote SDP:
  272. v=0
  273. o=- 1291593172 1291593173 IN IP4 200.201.197.137
  274. s=VoipSIP
  275. c=IN IP4 200.201.197.137
  276. t=0 0
  277. m=audio 6772 RTP/AVP 18 4 3 8 0 101
  278. a=rtpmap:18 G729/8000/1
  279. a=fmtp:18 annexb=no
  280. a=rtpmap:4 G723/8000/1
  281. a=fmtp:4 bitrate=6.3;annexa=yes
  282. a=rtpmap:3 GSM/8000
  283. a=rtpmap:8 PCMA/8000
  284. a=rtpmap:0 PCMU/8000
  285. a=rtpmap:101 telephone-event/8000
  286. a=fmtp:101 0-16
  287.  
  288. 2016-10-28 17:31:52.450302 [DEBUG] sofia.c:6934 (sofia/external/553134177781@200.201.197.137:5060) State Change CS_NEW -> CS_INIT
  289. 2016-10-28 17:31:52.450302 [DEBUG] switch_core_session.c:1397 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  290. 2016-10-28 17:31:52.450302 [DEBUG] switch_core_state_machine.c:491 (sofia/external/553134177781@200.201.197.137:5060) State NEW
  291. 2016-10-28 17:31:52.450302 [DEBUG] switch_core_state_machine.c:472 (sofia/external/553134177781@200.201.197.137:5060) Running State Change CS_INIT
  292. 2016-10-28 17:31:52.450302 [DEBUG] switch_core_state_machine.c:512 (sofia/external/553134177781@200.201.197.137:5060) State INIT
  293. 2016-10-28 17:31:52.450302 [DEBUG] mod_sofia.c:87 sofia/external/553134177781@200.201.197.137:5060 SOFIA INIT
  294. 2016-10-28 17:31:52.450302 [DEBUG] switch_core_state_machine.c:40 sofia/external/553134177781@200.201.197.137:5060 Standard INIT
  295. 2016-10-28 17:31:52.450302 [DEBUG] switch_core_state_machine.c:48 (sofia/external/553134177781@200.201.197.137:5060) State Change CS_INIT -> CS_ROUTING
  296. 2016-10-28 17:31:52.450302 [DEBUG] switch_core_session.c:1397 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  297. 2016-10-28 17:31:52.450302 [DEBUG] switch_core_state_machine.c:512 (sofia/external/553134177781@200.201.197.137:5060) State INIT going to sleep
  298. 2016-10-28 17:31:52.450302 [DEBUG] switch_core_state_machine.c:472 (sofia/external/553134177781@200.201.197.137:5060) Running State Change CS_ROUTING
  299. 2016-10-28 17:31:52.450302 [DEBUG] switch_channel.c:2206 (sofia/external/553134177781@200.201.197.137:5060) Callstate Change DOWN -> RINGING
  300. 2016-10-28 17:31:52.450302 [DEBUG] switch_core_state_machine.c:528 (sofia/external/553134177781@200.201.197.137:5060) State ROUTING
  301. 2016-10-28 17:31:52.450302 [DEBUG] mod_sofia.c:123 sofia/external/553134177781@200.201.197.137:5060 SOFIA ROUTING
  302. 2016-10-28 17:31:52.450302 [DEBUG] switch_core_state_machine.c:166 sofia/external/553134177781@200.201.197.137:5060 Standard ROUTING
  303. 2016-10-28 17:31:52.450302 [INFO] mod_dialplan_xml.c:635 Processing 553134177781 <553134177781>->553140421175 in context public
  304. Dialplan: sofia/external/553134177781@200.201.197.137:5060 parsing [public->unloop] continue=false
  305. Dialplan: sofia/external/553134177781@200.201.197.137:5060 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
  306. Dialplan: sofia/external/553134177781@200.201.197.137:5060 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
  307. Dialplan: sofia/external/553134177781@200.201.197.137:5060 parsing [public->outside_call] continue=true
  308. Dialplan: sofia/external/553134177781@200.201.197.137:5060 Absolute Condition [outside_call]
  309. Dialplan: sofia/external/553134177781@200.201.197.137:5060 Action set(outside_call=true)
  310. Dialplan: sofia/external/553134177781@200.201.197.137:5060 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
  311. Dialplan: sofia/external/553134177781@200.201.197.137:5060 parsing [public->call_debug] continue=true
  312. Dialplan: sofia/external/553134177781@200.201.197.137:5060 Regex (PASS) [call_debug] ${call_debug}(true) =~ /^true$/ break=never
  313. Dialplan: sofia/external/553134177781@200.201.197.137:5060 Action info()
  314. Dialplan: sofia/external/553134177781@200.201.197.137:5060 parsing [public->public_extensions] continue=false
  315. Dialplan: sofia/external/553134177781@200.201.197.137:5060 Regex (FAIL) [public_extensions] destination_number(553140421175) =~ /^(10[01][0-9])$/ break=on-false
  316. Dialplan: sofia/external/553134177781@200.201.197.137:5060 parsing [public->pstn_normalize] continue=true
  317. Dialplan: sofia/external/553134177781@200.201.197.137:5060 Absolute Condition [pstn_normalize]
  318. Dialplan: sofia/external/553134177781@200.201.197.137:5060 Action log(INFO effective_caller_id_number: [${effective_caller_id_number}] --  ${outbound_caller_id_number} -- ${sip_gateway} )
  319. Dialplan: sofia/external/553134177781@200.201.197.137:5060 Regex (PASS) [pstn_normalize] destination_number(553140421175) =~ /^(55\d+)$/ break=on-true
  320. Dialplan: sofia/external/553134177781@200.201.197.137:5060 Action log(effective_caller_id_number: [${sip_from_user}] -  ${Caller-Caller-ID-Number}  )
  321. Dialplan: sofia/external/553134177781@200.201.197.137:5060 Action set(e164_dest=553140421175) INLINE
  322. EXECUTE sofia/external/553134177781@200.201.197.137:5060 set(e164_dest=553140421175)
  323. 2016-10-28 17:31:52.450302 [DEBUG] mod_dptools.c:1477 sofia/external/553134177781@200.201.197.137:5060 SET [e164_dest]=[553140421175]
  324. Dialplan: sofia/external/553134177781@200.201.197.137:5060 parsing [public->pstn_normalize_cid] continue=true
  325. Dialplan: sofia/external/553134177781@200.201.197.137:5060 Regex (PASS) [pstn_normalize_cid] ${sip_from_user}(553134177781) =~ /^\+?(55\d+)$/ break=on-true
  326. Dialplan: sofia/external/553134177781@200.201.197.137:5060 Action set(e164_cid=553134177781) INLINE
  327. EXECUTE sofia/external/553134177781@200.201.197.137:5060 set(e164_cid=553134177781)
  328. 2016-10-28 17:31:52.450302 [DEBUG] mod_dptools.c:1477 sofia/external/553134177781@200.201.197.137:5060 SET [e164_cid]=[553134177781]
  329. Dialplan: sofia/external/553134177781@200.201.197.137:5060 parsing [public->pstn_local_trunk] continue=false
  330. Dialplan: sofia/external/553134177781@200.201.197.137:5060 Regex (FAIL) [pstn_local_trunk] ${sip_h_X-PH-UseLocalTrunk}() =~ /^true$/ break=on-false
  331. Dialplan: sofia/external/553134177781@200.201.197.137:5060 parsing [public->plivo_public_did_dev] continue=false
  332. Dialplan: sofia/external/553134177781@200.201.197.137:5060 Regex (FAIL) [plivo_public_did_dev] destination_number(553140421175) =~ /^(551430420078)$/ break=on-false
  333. Dialplan: sofia/external/553134177781@200.201.197.137:5060 parsing [public->plivo_public_did_hom] continue=false
  334. Dialplan: sofia/external/553134177781@200.201.197.137:5060 Regex (FAIL) [plivo_public_did_hom] destination_number(553140421175) =~ /^(554140638450)/ break=on-false
  335. Dialplan: sofia/external/553134177781@200.201.197.137:5060 parsing [public->plivo_public_did_icarros] continue=false
  336. Dialplan: sofia/external/553134177781@200.201.197.137:5060 Regex (FAIL) [plivo_public_did_icarros] destination_number(553140421175) =~ /^(551132301667)/ break=on-false
  337. Dialplan: sofia/external/553134177781@200.201.197.137:5060 parsing [public->plivo_public_did_tecnoportas] continue=false
  338. Dialplan: sofia/external/553134177781@200.201.197.137:5060 Regex (FAIL) [plivo_public_did_tecnoportas] destination_number(553140421175) =~ /^(551132301249)/ break=on-false
  339. Dialplan: sofia/external/553134177781@200.201.197.137:5060 parsing [public->plivo_public_did] continue=false
  340. Dialplan: sofia/external/553134177781@200.201.197.137:5060 Regex (PASS) [plivo_public_did] destination_number(553140421175) =~ /^(55\d+)/ break=on-false
  341. Dialplan: sofia/external/553134177781@200.201.197.137:5060 Action enable_heartbeat(60)
  342. Dialplan: sofia/external/553134177781@200.201.197.137:5060 Action socket(10.150.130.131:8085 async full)
  343. 2016-10-28 17:31:52.450302 [DEBUG] switch_core_state_machine.c:216 (sofia/external/553134177781@200.201.197.137:5060) State Change CS_ROUTING -> CS_EXECUTE
  344. 2016-10-28 17:31:52.450302 [DEBUG] switch_core_session.c:1397 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  345. 2016-10-28 17:31:52.450302 [DEBUG] switch_core_state_machine.c:528 (sofia/external/553134177781@200.201.197.137:5060) State ROUTING going to sleep
  346. 2016-10-28 17:31:52.450302 [DEBUG] switch_core_state_machine.c:472 (sofia/external/553134177781@200.201.197.137:5060) Running State Change CS_EXECUTE
  347. 2016-10-28 17:31:52.450302 [DEBUG] switch_core_state_machine.c:535 (sofia/external/553134177781@200.201.197.137:5060) State EXECUTE
  348. 2016-10-28 17:31:52.450302 [DEBUG] mod_sofia.c:178 sofia/external/553134177781@200.201.197.137:5060 SOFIA EXECUTE
  349. 2016-10-28 17:31:52.450302 [DEBUG] switch_core_state_machine.c:258 sofia/external/553134177781@200.201.197.137:5060 Standard EXECUTE
  350. EXECUTE sofia/external/553134177781@200.201.197.137:5060 set(outside_call=true)
  351. 2016-10-28 17:31:52.450302 [DEBUG] mod_dptools.c:1477 sofia/external/553134177781@200.201.197.137:5060 SET [outside_call]=[true]
  352. EXECUTE sofia/external/553134177781@200.201.197.137:5060 export(RFC2822_DATE=Fri, 28 Oct 2016 17:31:52 -0200)
  353. 2016-10-28 17:31:52.450302 [DEBUG] switch_channel.c:1269 EXPORT (export_vars) [RFC2822_DATE]=[Fri, 28 Oct 2016 17:31:52 -0200]
  354. EXECUTE sofia/external/553134177781@200.201.197.137:5060 info()
  355. 2016-10-28 17:31:52.450302 [INFO] mod_dptools.c:1689 CHANNEL_DATA:
  356. Channel-State: [CS_EXECUTE]
  357. Channel-Call-State: [RINGING]
  358. Channel-State-Number: [4]
  359. Channel-Name: [sofia/external/553134177781@200.201.197.137:5060]
  360. Unique-ID: [2d96db4a-9d45-11e6-a5fd-9bbfbda5c291]
  361. Call-Direction: [inbound]
  362. Presence-Call-Direction: [inbound]
  363. Channel-HIT-Dialplan: [true]
  364. Channel-Call-UUID: [2d96db4a-9d45-11e6-a5fd-9bbfbda5c291]
  365. Answer-State: [ringing]
  366. Caller-Direction: [inbound]
  367. Caller-Logical-Direction: [inbound]
  368. Caller-Username: [553134177781]
  369. Caller-Dialplan: [XML]
  370. Caller-Caller-ID-Name: [553134177781]
  371. Caller-Caller-ID-Number: [553134177781]
  372. Caller-Orig-Caller-ID-Name: [553134177781]
  373. Caller-Orig-Caller-ID-Number: [553134177781]
  374. Caller-Network-Addr: [200.201.197.137]
  375. Caller-ANI: [553134177781]
  376. Caller-Destination-Number: [553140421175]
  377. Caller-Unique-ID: [2d96db4a-9d45-11e6-a5fd-9bbfbda5c291]
  378. Caller-Source: [mod_sofia]
  379. Caller-Context: [public]
  380. Caller-Channel-Name: [sofia/external/553134177781@200.201.197.137:5060]
  381. Caller-Profile-Index: [1]
  382. Caller-Profile-Created-Time: [1477683112450302]
  383. Caller-Channel-Created-Time: [1477683112450302]
  384. Caller-Channel-Answered-Time: [0]
  385. Caller-Channel-Progress-Time: [0]
  386. Caller-Channel-Progress-Media-Time: [0]
  387. Caller-Channel-Hangup-Time: [0]
  388. Caller-Channel-Transfer-Time: [0]
  389. Caller-Channel-Resurrect-Time: [0]
  390. Caller-Channel-Bridged-Time: [0]
  391. Caller-Channel-Last-Hold: [0]
  392. Caller-Channel-Hold-Accum: [0]
  393. Caller-Screen-Bit: [true]
  394. Caller-Privacy-Hide-Name: [false]
  395. Caller-Privacy-Hide-Number: [false]
  396. variable_direction: [inbound]
  397. variable_uuid: [2d96db4a-9d45-11e6-a5fd-9bbfbda5c291]
  398. variable_session_id: [105354]
  399. variable_sip_from_user: [553134177781]
  400. variable_sip_from_port: [5060]
  401. variable_sip_from_uri: [553134177781@200.201.197.137:5060]
  402. variable_sip_from_host: [200.201.197.137]
  403. variable_channel_name: [sofia/external/553134177781@200.201.197.137:5060]
  404. variable_sip_call_id: [OGtK94Tu5Gc5481758-8c0e-11e6-ab71-9bbfbda5c291@200.201.197.137]
  405. variable_ep_codec_string: [G729@8000h@20i@8000b,GSM@8000h@20i@13200b,PCMA@8000h@20i@64000b,PCMU@8000h@20i@64000b]
  406. variable_sip_local_network_addr: [169.57.148.25]
  407. variable_sip_network_ip: [200.201.197.137]
  408. variable_sip_network_port: [5060]
  409. variable_sip_received_ip: [200.201.197.137]
  410. variable_sip_received_port: [5060]
  411. variable_sip_via_protocol: [udp]
  412. variable_sip_from_user_stripped: [553134177781]
  413. variable_sip_from_tag: [173154783951828]
  414. variable_sofia_profile_name: [external]
  415. variable_recovery_profile_name: [external]
  416. variable_sip_full_via: [SIP/2.0/UDP 200.201.197.137:5060;branch=z9hG4bK311754136513860783951828]
  417. variable_sip_from_display: [553134177781]
  418. variable_sip_full_from: [553134177781 <sip:553134177781@200.201.197.137:5060>;tag=173154783951828]
  419. variable_sip_full_to: [<sip:553140421175@199.59.97.196:5060>]
  420. variable_sip_req_params: [transport=udp;gw=gtgroup]
  421. variable_sip_req_user: [553140421175]
  422. variable_sip_req_port: [5080]
  423. variable_sip_req_uri: [553140421175@169.57.148.25:5080]
  424. variable_sip_req_host: [169.57.148.25]
  425. variable_sip_to_user: [553140421175]
  426. variable_sip_to_port: [5060]
  427. variable_sip_to_uri: [553140421175@199.59.97.196:5060]
  428. variable_sip_to_host: [199.59.97.196]
  429. variable_sip_contact_params: [transport=udp]
  430. variable_sip_contact_user: [nobody]
  431. variable_sip_contact_port: [5060]
  432. variable_sip_contact_uri: [nobody@200.201.197.137:5060]
  433. variable_sip_contact_host: [200.201.197.137]
  434. variable_rtp_use_codec_string: [G729,G722,OPUS,PCMU,PCMA,GSM]
  435. variable_sip_user_agent: [VoipSwitch 2.0]
  436. variable_sip_via_host: [200.201.197.137]
  437. variable_sip_via_port: [5060]
  438. variable_max_forwards: [70]
  439. variable_sip_gateway: [gtgroup]
  440. variable_switch_r_sdp: [v=0
  441. o=- 1291593172 1291593173 IN IP4 200.201.197.137
  442. s=VoipSIP
  443. c=IN IP4 200.201.197.137
  444. t=0 0
  445. m=audio 6772 RTP/AVP 18 4 3 8 0 101
  446. a=rtpmap:18 G729/8000/1
  447. a=fmtp:18 annexb=no
  448. a=rtpmap:4 G723/8000/1
  449. a=fmtp:4 bitrate=6.3;annexa=yes
  450. a=rtpmap:3 GSM/8000
  451. a=rtpmap:8 PCMA/8000
  452. a=rtpmap:0 PCMU/8000
  453. a=rtpmap:101 telephone-event/8000
  454. a=fmtp:101 0-16
  455. ]
  456. variable_endpoint_disposition: [DELAYED NEGOTIATION]
  457. variable_e164_dest: [553140421175]
  458. variable_e164_cid: [553134177781]
  459. variable_DP_MATCH: [ARRAY::553140421175|:553140421175]
  460. variable_call_uuid: [2d96db4a-9d45-11e6-a5fd-9bbfbda5c291]
  461. variable_outside_call: [true]
  462. variable_RFC2822_DATE: [Fri, 28 Oct 2016 17:31:52 -0200]
  463. variable_export_vars: [RFC2822_DATE]
  464. variable_current_application: [info]
  465.  
  466.  
  467. EXECUTE sofia/external/553134177781@200.201.197.137:5060 log(INFO effective_caller_id_number: [] --   -- gtgroup )
  468. 2016-10-28 17:31:52.450302 [INFO] mod_dptools.c:1670 effective_caller_id_number: [] --   -- gtgroup
  469. EXECUTE sofia/external/553134177781@200.201.197.137:5060 log(effective_caller_id_number: [553134177781] -    )
  470. 2016-10-28 17:31:52.450302 [DEBUG] mod_dptools.c:1670 [553134177781] -    
  471. EXECUTE sofia/external/553134177781@200.201.197.137:5060 enable_heartbeat(60)
  472. 2016-10-28 17:31:52.450302 [WARNING] switch_core_session.c:1564 sofia/external/553134177781@200.201.197.137:5060 using scheduler due to bypass media or media is not established.
  473. 2016-10-28 17:31:52.450302 [DEBUG] switch_scheduler.c:249 Added task 21510 switch_core_session_sched_heartbeat (2d96db4a-9d45-11e6-a5fd-9bbfbda5c291) to run at 1477683172
  474. EXECUTE sofia/external/553134177781@200.201.197.137:5060 socket(10.150.130.131:8085 async full)
  475. 2016-10-28 17:31:52.570302 [DEBUG] switch_core_session.c:1197 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  476. 2016-10-28 17:31:52.570302 [DEBUG] switch_core_session.c:1197 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  477. 2016-10-28 17:31:52.570302 [DEBUG] switch_ivr.c:616 sofia/external/553134177781@200.201.197.137:5060 Command Execute unset(call_timeout)
  478. EXECUTE sofia/external/553134177781@200.201.197.137:5060 unset(call_timeout)
  479. 2016-10-28 17:31:52.570302 [DEBUG] switch_core_session.c:1197 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  480. 2016-10-28 17:31:52.570302 [DEBUG] mod_dptools.c:1621 UNSET [call_timeout]
  481. 2016-10-28 17:31:52.570302 [DEBUG] switch_ivr.c:616 sofia/external/553134177781@200.201.197.137:5060 Command Execute unset(effective_caller_id_number)
  482. EXECUTE sofia/external/553134177781@200.201.197.137:5060 unset(effective_caller_id_number)
  483. 2016-10-28 17:31:52.570302 [DEBUG] mod_dptools.c:1621 UNSET [effective_caller_id_number]
  484. 2016-10-28 17:31:52.570302 [DEBUG] switch_ivr.c:616 sofia/external/553134177781@200.201.197.137:5060 Command Execute unset(effective_caller_id_name)
  485. EXECUTE sofia/external/553134177781@200.201.197.137:5060 unset(effective_caller_id_name)
  486. 2016-10-28 17:31:52.570302 [DEBUG] mod_dptools.c:1621 UNSET [effective_caller_id_name]
  487. 2016-10-28 17:31:52.570302 [DEBUG] switch_core_session.c:1197 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  488. 2016-10-28 17:31:52.590295 [DEBUG] switch_core_session.c:1197 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  489. 2016-10-28 17:31:52.590295 [DEBUG] switch_core_session.c:1197 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  490. 2016-10-28 17:31:52.590295 [DEBUG] switch_core_session.c:1197 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  491. 2016-10-28 17:31:52.590295 [DEBUG] switch_core_session.c:1197 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  492. 2016-10-28 17:31:52.590295 [DEBUG] switch_core_session.c:1197 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  493. 2016-10-28 17:31:52.590295 [DEBUG] switch_ivr.c:616 sofia/external/553134177781@200.201.197.137:5060 Command Execute unset(bridge_terminate_key)
  494. EXECUTE sofia/external/553134177781@200.201.197.137:5060 unset(bridge_terminate_key)
  495. 2016-10-28 17:31:52.590295 [DEBUG] mod_dptools.c:1621 UNSET [bridge_terminate_key]
  496. 2016-10-28 17:31:52.590295 [DEBUG] switch_ivr.c:616 sofia/external/553134177781@200.201.197.137:5060 Command Execute set(hangup_after_bridge=false)
  497. EXECUTE sofia/external/553134177781@200.201.197.137:5060 set(hangup_after_bridge=false)
  498. 2016-10-28 17:31:52.590295 [DEBUG] mod_dptools.c:1477 sofia/external/553134177781@200.201.197.137:5060 SET [hangup_after_bridge]=[false]
  499. 2016-10-28 17:31:52.590295 [DEBUG] switch_ivr.c:616 sofia/external/553134177781@200.201.197.137:5060 Command Execute set(continue_on_fail=true)
  500. EXECUTE sofia/external/553134177781@200.201.197.137:5060 set(continue_on_fail=true)
  501. 2016-10-28 17:31:52.590295 [DEBUG] mod_dptools.c:1477 sofia/external/553134177781@200.201.197.137:5060 SET [continue_on_fail]=[true]
  502. 2016-10-28 17:31:52.610443 [DEBUG] switch_ivr.c:616 sofia/external/553134177781@200.201.197.137:5060 Command Execute set(bridge_early_media=false)
  503. EXECUTE sofia/external/553134177781@200.201.197.137:5060 set(bridge_early_media=false)
  504. 2016-10-28 17:31:52.610443 [DEBUG] mod_dptools.c:1477 sofia/external/553134177781@200.201.197.137:5060 SET [bridge_early_media]=[false]
  505. 2016-10-28 17:31:52.610443 [DEBUG] switch_ivr.c:616 sofia/external/553134177781@200.201.197.137:5060 Command Execute set(instant_ringback=true)
  506. EXECUTE sofia/external/553134177781@200.201.197.137:5060 set(instant_ringback=true)
  507. 2016-10-28 17:31:52.610443 [DEBUG] mod_dptools.c:1477 sofia/external/553134177781@200.201.197.137:5060 SET [instant_ringback]=[true]
  508. 2016-10-28 17:31:52.610443 [DEBUG] switch_ivr.c:616 sofia/external/553134177781@200.201.197.137:5060 Command Execute bridge({originate_timeout=30,origination_caller_id_number=553134177781}sofia/gateway/voxbeam_outbound/0011102553121015020)
  509. EXECUTE sofia/external/553134177781@200.201.197.137:5060 bridge({originate_timeout=30,origination_caller_id_number=553134177781}sofia/gateway/voxbeam_outbound/0011102553121015020)
  510. 2016-10-28 17:31:52.610443 [DEBUG] switch_channel.c:1223 sofia/external/553134177781@200.201.197.137:5060 EXPORTING[export_vars] [RFC2822_DATE]=[Fri, 28 Oct 2016 17:31:52 -0200] to event
  511. 2016-10-28 17:31:52.610443 [DEBUG] switch_ivr_originate.c:2124 Parsing global variables
  512. 2016-10-28 17:31:52.610443 [DEBUG] switch_event.c:1698 Parsing variable [originate_timeout]=[30]
  513. 2016-10-28 17:31:52.610443 [DEBUG] switch_event.c:1698 Parsing variable [origination_caller_id_number]=[553134177781]
  514. 2016-10-28 17:31:52.610443 [NOTICE] switch_channel.c:1077 New Channel sofia/external/0011102553121015020 [2daedae2-9d45-11e6-a60a-9bbfbda5c291]
  515. 2016-10-28 17:31:52.610443 [DEBUG] mod_sofia.c:4700 (sofia/external/0011102553121015020) State Change CS_NEW -> CS_INIT
  516. 2016-10-28 17:31:52.610443 [DEBUG] switch_core_session.c:1397 Send signal sofia/external/0011102553121015020 [BREAK]
  517. 2016-10-28 17:31:52.610443 [DEBUG] switch_core_state_machine.c:472 (sofia/external/0011102553121015020) Running State Change CS_INIT
  518. 2016-10-28 17:31:52.610443 [DEBUG] switch_core_state_machine.c:512 (sofia/external/0011102553121015020) State INIT
  519. 2016-10-28 17:31:52.610443 [DEBUG] mod_sofia.c:87 sofia/external/0011102553121015020 SOFIA INIT
  520. 2016-10-28 17:31:52.610443 [DEBUG] sofia_glue.c:1241 sofia/external/0011102553121015020 sending invite version: 1.4.26  64bit
  521. Local SDP:
  522. v=0
  523. o=FreeSWITCH 1477656382 1477656383 IN IP4 169.57.148.25
  524. s=FreeSWITCH
  525. c=IN IP4 169.57.148.25
  526. t=0 0
  527. m=audio 26730 RTP/AVP 18 3 8 0 101 13
  528. a=rtpmap:18 G729/8000
  529. a=fmtp:18 annexb=no
  530. a=rtpmap:3 GSM/8000
  531. a=rtpmap:8 PCMA/8000
  532. a=rtpmap:0 PCMU/8000
  533. a=rtpmap:101 telephone-event/8000
  534. a=fmtp:101 0-16
  535. a=ptime:20
  536. a=sendrecv
  537.  
  538. 2016-10-28 17:31:52.610443 [DEBUG] switch_core_state_machine.c:40 sofia/external/0011102553121015020 Standard INIT
  539. 2016-10-28 17:31:52.610443 [DEBUG] switch_core_state_machine.c:48 (sofia/external/0011102553121015020) State Change CS_INIT -> CS_ROUTING
  540. 2016-10-28 17:31:52.610443 [DEBUG] switch_core_session.c:1397 Send signal sofia/external/0011102553121015020 [BREAK]
  541. 2016-10-28 17:31:52.610443 [DEBUG] switch_core_state_machine.c:512 (sofia/external/0011102553121015020) State INIT going to sleep
  542. 2016-10-28 17:31:52.610443 [DEBUG] switch_core_state_machine.c:472 (sofia/external/0011102553121015020) Running State Change CS_ROUTING
  543. 2016-10-28 17:31:52.610443 [DEBUG] switch_core_state_machine.c:528 (sofia/external/0011102553121015020) State ROUTING
  544. 2016-10-28 17:31:52.610443 [DEBUG] mod_sofia.c:123 sofia/external/0011102553121015020 SOFIA ROUTING
  545. 2016-10-28 17:31:52.610443 [DEBUG] switch_ivr_originate.c:67 (sofia/external/0011102553121015020) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  546. 2016-10-28 17:31:52.610443 [DEBUG] switch_core_session.c:1397 Send signal sofia/external/0011102553121015020 [BREAK]
  547. 2016-10-28 17:31:52.610443 [DEBUG] switch_core_state_machine.c:528 (sofia/external/0011102553121015020) State ROUTING going to sleep
  548. 2016-10-28 17:31:52.610443 [DEBUG] switch_core_state_machine.c:472 (sofia/external/0011102553121015020) Running State Change CS_CONSUME_MEDIA
  549. 2016-10-28 17:31:52.610443 [DEBUG] switch_core_state_machine.c:547 (sofia/external/0011102553121015020) State CONSUME_MEDIA
  550. 2016-10-28 17:31:52.610443 [DEBUG] switch_core_state_machine.c:547 (sofia/external/0011102553121015020) State CONSUME_MEDIA going to sleep
  551. send 1186 bytes to udp/[108.59.2.134]:5060 at 17:31:52.613410:
  552.    ------------------------------------------------------------------------
  553.    INVITE sip:0011102553121015020@sbc.voxbeam.com SIP/2.0
  554.    Via: SIP/2.0/UDP 169.57.148.25:5080;rport;branch=z9hG4bKaSU9Km5SB0pHa
  555.    Max-Forwards: 69
  556.    From: "553134177781" <sip:553134177781@169.57.148.25>;tag=ZBSaFXXrv5gcj
  557.    To: <sip:0011102553121015020@sbc.voxbeam.com>
  558.    Call-ID: 050d55d0-17e8-1235-7585-064fe3a24e98
  559.    CSeq: 98505492 INVITE
  560.    Contact: <sip:gw+voxbeam_outbound@169.57.148.25:5080;transport=udp;gw=voxbeam_outbound>
  561.    User-Agent: FreeSWITCH-mod_sofia/1.4.26~64bit
  562.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  563.    Supported: timer, path, replaces
  564.    Allow-Events: talk, hold, conference, refer
  565.    Content-Type: application/sdp
  566.    Content-Disposition: session
  567.    Content-Length: 319
  568.    X-FS-Support: update_display,send_info
  569.    Remote-Party-ID: "553134177781" <sip:553134177781@169.57.148.25>;party=calling;screen=yes;privacy=off
  570.    
  571.    v=0
  572.    o=FreeSWITCH 1477656382 1477656383 IN IP4 169.57.148.25
  573.    s=FreeSWITCH
  574.    c=IN IP4 169.57.148.25
  575.    t=0 0
  576.    m=audio 26730 RTP/AVP 18 3 8 0 101 13
  577.    a=rtpmap:18 G729/8000
  578.    a=fmtp:18 annexb=no
  579.    a=rtpmap:3 GSM/8000
  580.    a=rtpmap:8 PCMA/8000
  581.    a=rtpmap:0 PCMU/8000
  582.    a=rtpmap:101 telephone-event/8000
  583.    a=fmtp:101 0-16
  584.    a=ptime:20
  585.    ------------------------------------------------------------------------
  586. 2016-10-28 17:31:52.610443 [DEBUG] switch_core_session.c:1062 Send signal sofia/external/0011102553121015020 [BREAK]
  587. 2016-10-28 17:31:52.610443 [DEBUG] sofia.c:6658 Channel sofia/external/0011102553121015020 entering state [calling][0]
  588. recv 383 bytes from udp/[108.59.2.134]:5060 at 17:31:52.742289:
  589.    ------------------------------------------------------------------------
  590.    SIP/2.0 100 Giving a try
  591.    Via: SIP/2.0/UDP 169.57.148.25:5080;received=169.57.148.25;rport=5080;branch=z9hG4bKaSU9Km5SB0pHa
  592.    From: "553134177781" <sip:553134177781@169.57.148.25>;tag=ZBSaFXXrv5gcj
  593.    To: <sip:0011102553121015020@sbc.voxbeam.com>
  594.    Call-ID: 050d55d0-17e8-1235-7585-064fe3a24e98
  595.    CSeq: 98505492 INVITE
  596.    Server: OpenSIPS (1.8.8-notls (x86_64/linux))
  597.    Content-Length: 0
  598.    
  599.    ------------------------------------------------------------------------
  600. recv 549 bytes from udp/[177.92.48.107]:60865 at 17:31:53.688591:
  601.    ------------------------------------------------------------------------
  602.    REGISTER sip:sip1.phonetrack.com.br SIP/2.0
  603.    Via: SIP/2.0/UDP 192.168.0.202:5060;branch=z9hG4bK-ae0483a3
  604.    From: From Office PSTN <sip:1001@sip1.phonetrack.com.br>;tag=76d4ab50aee00088o0
  605.    To: From Office PSTN <sip:1001@sip1.phonetrack.com.br>
  606.    Call-ID: 89892a52-c374bcb8@127.0.0.1
  607.    CSeq: 77309 REGISTER
  608.    Max-Forwards: 70
  609.    Contact: From Office PSTN <sip:1001@192.168.0.202:5060>;expires=3600
  610.    User-Agent: Linksys/SPA3102-5.2.13(GW002)
  611.    Content-Length: 0
  612.    Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
  613.    Supported: x-sipura, replaces
  614.    
  615.    ------------------------------------------------------------------------
  616. send 637 bytes to udp/[177.92.48.107]:5060 at 17:31:53.688806:
  617.    ------------------------------------------------------------------------
  618.    SIP/2.0 401 Unauthorized
  619.    Via: SIP/2.0/UDP 192.168.0.202:5060;branch=z9hG4bK-ae0483a3;received=177.92.48.107
  620.    From: From Office PSTN <sip:1001@sip1.phonetrack.com.br>;tag=76d4ab50aee00088o0
  621.    To: From Office PSTN <sip:1001@sip1.phonetrack.com.br>;tag=eD4r0rX8SQ57B
  622.    Call-ID: 89892a52-c374bcb8@127.0.0.1
  623.    CSeq: 77309 REGISTER
  624.    User-Agent: PhoneTrack
  625.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  626.    Supported: path, replaces
  627.    WWW-Authenticate: Digest realm="sip1.phonetrack.com.br", nonce="2055a344-9d45-11e6-a5ef-9bbfbda5c291", algorithm=MD5, qop="auth"
  628.    Content-Length: 0
  629.    
  630.    ------------------------------------------------------------------------
  631. recv 498 bytes from udp/[177.92.48.107]:60864 at 17:31:53.690867:
  632.    ------------------------------------------------------------------------
  633.    REGISTER sip:169.57.148.25 SIP/2.0
  634.    Via: SIP/2.0/UDP 192.168.0.202:5061;branch=z9hG4bK-466a16cb
  635.    From: GVT PSTN <sip:1010@169.57.148.25>;tag=e8e015108e55a1c8o1
  636.    To: GVT PSTN <sip:1010@169.57.148.25>
  637.    Call-ID: 8015e2e0-bcbdad82@127.0.0.1
  638.    CSeq: 58299 REGISTER
  639.    Max-Forwards: 70
  640.    Contact: GVT PSTN <sip:1010@192.168.0.202:5061>;expires=3600
  641.    User-Agent: Linksys/SPA3102-5.2.13(GW002)
  642.    Content-Length: 0
  643.    Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
  644.    Supported: x-sipura, replaces
  645.    
  646.    ------------------------------------------------------------------------
  647. send 594 bytes to udp/[177.92.48.107]:5061 at 17:31:53.690985:
  648.    ------------------------------------------------------------------------
  649.    SIP/2.0 401 Unauthorized
  650.    Via: SIP/2.0/UDP 192.168.0.202:5061;branch=z9hG4bK-466a16cb;received=177.92.48.107
  651.    From: GVT PSTN <sip:1010@169.57.148.25>;tag=e8e015108e55a1c8o1
  652.    To: GVT PSTN <sip:1010@169.57.148.25>;tag=FpXH2KecQ0UtQ
  653.    Call-ID: 8015e2e0-bcbdad82@127.0.0.1
  654.    CSeq: 58299 REGISTER
  655.    User-Agent: PhoneTrack
  656.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  657.    Supported: path, replaces
  658.    WWW-Authenticate: Digest realm="169.57.148.25", nonce="2055b79e-9d45-11e6-a5f0-9bbfbda5c291", algorithm=MD5, qop="auth"
  659.    Content-Length: 0
  660.    
  661.    ------------------------------------------------------------------------
  662. recv 549 bytes from udp/[177.92.48.107]:60865 at 17:31:57.689625:
  663.    ------------------------------------------------------------------------
  664.    REGISTER sip:sip1.phonetrack.com.br SIP/2.0
  665.    Via: SIP/2.0/UDP 192.168.0.202:5060;branch=z9hG4bK-ae0483a3
  666.    From: From Office PSTN <sip:1001@sip1.phonetrack.com.br>;tag=76d4ab50aee00088o0
  667.    To: From Office PSTN <sip:1001@sip1.phonetrack.com.br>
  668.    Call-ID: 89892a52-c374bcb8@127.0.0.1
  669.    CSeq: 77309 REGISTER
  670.    Max-Forwards: 70
  671.    Contact: From Office PSTN <sip:1001@192.168.0.202:5060>;expires=3600
  672.    User-Agent: Linksys/SPA3102-5.2.13(GW002)
  673.    Content-Length: 0
  674.    Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
  675.    Supported: x-sipura, replaces
  676.    
  677.    ------------------------------------------------------------------------
  678. send 637 bytes to udp/[177.92.48.107]:5060 at 17:31:57.689809:
  679.    ------------------------------------------------------------------------
  680.    SIP/2.0 401 Unauthorized
  681.    Via: SIP/2.0/UDP 192.168.0.202:5060;branch=z9hG4bK-ae0483a3;received=177.92.48.107
  682.    From: From Office PSTN <sip:1001@sip1.phonetrack.com.br>;tag=76d4ab50aee00088o0
  683.    To: From Office PSTN <sip:1001@sip1.phonetrack.com.br>;tag=eD4r0rX8SQ57B
  684.    Call-ID: 89892a52-c374bcb8@127.0.0.1
  685.    CSeq: 77309 REGISTER
  686.    User-Agent: PhoneTrack
  687.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  688.    Supported: path, replaces
  689.    WWW-Authenticate: Digest realm="sip1.phonetrack.com.br", nonce="2055a344-9d45-11e6-a5ef-9bbfbda5c291", algorithm=MD5, qop="auth"
  690.    Content-Length: 0
  691.    
  692.    ------------------------------------------------------------------------
  693. recv 498 bytes from udp/[177.92.48.107]:60864 at 17:31:57.690963:
  694.    ------------------------------------------------------------------------
  695.    REGISTER sip:169.57.148.25 SIP/2.0
  696.    Via: SIP/2.0/UDP 192.168.0.202:5061;branch=z9hG4bK-466a16cb
  697.    From: GVT PSTN <sip:1010@169.57.148.25>;tag=e8e015108e55a1c8o1
  698.    To: GVT PSTN <sip:1010@169.57.148.25>
  699.    Call-ID: 8015e2e0-bcbdad82@127.0.0.1
  700.    CSeq: 58299 REGISTER
  701.    Max-Forwards: 70
  702.    Contact: GVT PSTN <sip:1010@192.168.0.202:5061>;expires=3600
  703.    User-Agent: Linksys/SPA3102-5.2.13(GW002)
  704.    Content-Length: 0
  705.    Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
  706.    Supported: x-sipura, replaces
  707.    
  708.    ------------------------------------------------------------------------
  709. send 594 bytes to udp/[177.92.48.107]:5061 at 17:31:57.691064:
  710.    ------------------------------------------------------------------------
  711.    SIP/2.0 401 Unauthorized
  712.    Via: SIP/2.0/UDP 192.168.0.202:5061;branch=z9hG4bK-466a16cb;received=177.92.48.107
  713.    From: GVT PSTN <sip:1010@169.57.148.25>;tag=e8e015108e55a1c8o1
  714.    To: GVT PSTN <sip:1010@169.57.148.25>;tag=FpXH2KecQ0UtQ
  715.    Call-ID: 8015e2e0-bcbdad82@127.0.0.1
  716.    CSeq: 58299 REGISTER
  717.    User-Agent: PhoneTrack
  718.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  719.    Supported: path, replaces
  720.    WWW-Authenticate: Digest realm="169.57.148.25", nonce="2055b79e-9d45-11e6-a5f0-9bbfbda5c291", algorithm=MD5, qop="auth"
  721.    Content-Length: 0
  722.    
  723.    ------------------------------------------------------------------------
  724. send 795 bytes to udp/[200.201.197.137]:5060 at 17:31:58.539176:
  725.    ------------------------------------------------------------------------
  726.    REGISTER sip:sip2.gtgi.net;transport=udp SIP/2.0
  727.    Via: SIP/2.0/UDP 169.57.148.25:5080;rport;branch=z9hG4bKB2m2NFpX88c4N
  728.    Max-Forwards: 70
  729.    From: <sip:551132300751@sip2.gtgi.net>;tag=83tHK4gKayt7p
  730.    To: <sip:551132300751@sip2.gtgi.net>
  731.    Call-ID: c5481758-8c0e-11e6-ab71-9bbfbda5c291
  732.    CSeq: 98500671 REGISTER
  733.    Contact: <sip:gw+gtgroup@169.57.148.25:5080;transport=udp;gw=gtgroup>
  734.    Expires: 60
  735.    User-Agent: FreeSWITCH-mod_sofia/1.4.26~64bit
  736.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  737.    Supported: timer, path, replaces
  738.    Authorization: Digest username="551132300751", realm="VoipSwitch", nonce="2df5aacd1510184828130130210571743543", algorithm=MD5, uri="sip:sip2.gtgi.net;transport=udp", response="71890e0f8c835e6045d4df45633e0403"
  739.    Content-Length: 0
  740.    
  741.    ------------------------------------------------------------------------
  742. recv 391 bytes from udp/[200.201.197.137]:5060 at 17:31:58.546582:
  743.    ------------------------------------------------------------------------
  744.    SIP/2.0 200 OK
  745.    CSeq: 98500671 REGISTER
  746.    Via: SIP/2.0/UDP 169.57.148.25:5080;rport;branch=z9hG4bKB2m2NFpX88c4N
  747.    From: <sip:551132300751@sip2.gtgi.net>;tag=83tHK4gKayt7p
  748.    Call-ID: c5481758-8c0e-11e6-ab71-9bbfbda5c291
  749.    To: <sip:551132300751@sip2.gtgi.net>;tag=173200783957921
  750.    Contact: <sip:gw+gtgroup@169.57.148.25:5080;transport=udp;gw=gtgroup>;expires=60
  751.    Expires: 60
  752.    Content-Length: 0
  753.    
  754.    ------------------------------------------------------------------------
  755. recv 651 bytes from udp/[177.92.48.107]:51531 at 17:31:58.773455:
  756.    ------------------------------------------------------------------------
  757.    SUBSCRIBE sip:1000@169.57.148.25:5060 SIP/2.0
  758.    Via: SIP/2.0/UDP 192.168.0.151:51531;branch=z9hG4bK-524287-1---1f986633b2339328;rport
  759.    Max-Forwards: 70
  760.    Contact: <sip:1000@177.92.48.107:51531;rinstance=f4b63cd0eadd1787>
  761.    To: <sip:1000@sip1.phonetrack.com.br>;tag=TsG36U1TVilX
  762.    From: "Marcio" <sip:1000@sip1.phonetrack.com.br>;tag=ebf5d011
  763.    Call-ID: 82158NjgxZmNkYTRhMzIzZGI4NjljN2VjNjBkYTIxMTE4NTg
  764.    CSeq: 117 SUBSCRIBE
  765.    Expires: 300
  766.    Accept: application/simple-message-summary
  767.    Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
  768.    User-Agent: X-Lite release 4.9.6 stamp 82158
  769.    Event: message-summary
  770.    Content-Length: 0
  771.    
  772.    ------------------------------------------------------------------------
  773. send 784 bytes to udp/[177.92.48.107]:51531 at 17:31:58.775318:
  774.    ------------------------------------------------------------------------
  775.    SIP/2.0 202 Accepted
  776.    Via: SIP/2.0/UDP 192.168.0.151:51531;branch=z9hG4bK-524287-1---1f986633b2339328;rport=51531;received=177.92.48.107
  777.    From: "Marcio" <sip:1000@sip1.phonetrack.com.br>;tag=ebf5d011
  778.    To: <sip:1000@sip1.phonetrack.com.br>;tag=TsG36U1TVilX
  779.    Call-ID: 82158NjgxZmNkYTRhMzIzZGI4NjljN2VjNjBkYTIxMTE4NTg
  780.    CSeq: 117 SUBSCRIBE
  781.    Contact: <sip:1000@169.57.148.25:5060>
  782.    Expires: 300
  783.    User-Agent: PhoneTrack
  784.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  785.    Supported: path, replaces
  786.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  787.    Subscription-State: active;expires=300
  788.    Content-Length: 0
  789.    
  790.    ------------------------------------------------------------------------
  791. send 932 bytes to udp/[177.92.48.107]:51531 at 17:31:58.848405:
  792.    ------------------------------------------------------------------------
  793.    NOTIFY sip:1000@177.92.48.107:51531;rinstance=f4b63cd0eadd1787 SIP/2.0
  794.    Via: SIP/2.0/UDP 169.57.148.25;rport;branch=z9hG4bK9veg47NveXBeQ
  795.    Max-Forwards: 70
  796.    From: <sip:1000@sip1.phonetrack.com.br>;tag=TsG36U1TVilX
  797.    To: "Marcio" <sip:1000@sip1.phonetrack.com.br>;tag=ebf5d011
  798.    Call-ID: 82158NjgxZmNkYTRhMzIzZGI4NjljN2VjNjBkYTIxMTE4NTg
  799.    CSeq: 1303295901 NOTIFY
  800.    Contact: <sip:1000@169.57.148.25:5060>
  801.    User-Agent: PhoneTrack
  802.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  803.    Supported: path, replaces
  804.    Event: message-summary
  805.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  806.    Subscription-State: active;expires=300
  807.    Content-Type: application/simple-message-summary
  808.    Content-Length: 65
  809.    
  810.    Messages-Waiting: no
  811.    Message-Account: sip:1000@169.57.148.25
  812.    
  813.    ------------------------------------------------------------------------
  814. recv 424 bytes from udp/[177.92.48.107]:51531 at 17:31:58.867778:
  815.    ------------------------------------------------------------------------
  816.    SIP/2.0 200 OK
  817.    Via: SIP/2.0/UDP 169.57.148.25;rport=5060;branch=z9hG4bK9veg47NveXBeQ
  818.    Contact: <sip:1000@177.92.48.107:51531;rinstance=f4b63cd0eadd1787>
  819.    To: "Marcio"<sip:1000@sip1.phonetrack.com.br>;tag=ebf5d011
  820.    From: <sip:1000@sip1.phonetrack.com.br>;tag=TsG36U1TVilX
  821.    Call-ID: 82158NjgxZmNkYTRhMzIzZGI4NjljN2VjNjBkYTIxMTE4NTg
  822.    CSeq: 1303295901 NOTIFY
  823.    User-Agent: X-Lite release 4.9.6 stamp 82158
  824.    Content-Length: 0
  825.    
  826.    ------------------------------------------------------------------------
  827. recv 849 bytes from udp/[108.59.2.134]:5060 at 17:31:58.884387:
  828.    ------------------------------------------------------------------------
  829.    SIP/2.0 180 Ringing
  830.    Via: SIP/2.0/UDP 169.57.148.25:5080;received=169.57.148.25;rport=5080;branch=z9hG4bKaSU9Km5SB0pHa
  831.    From: "553134177781" <sip:553134177781@169.57.148.25>;tag=ZBSaFXXrv5gcj
  832.    To: <sip:0011102553121015020@sbc.voxbeam.com>;tag=SDkk99599-00b095ca-0067-067b-0000-0000
  833.    Call-ID: 050d55d0-17e8-1235-7585-064fe3a24e98
  834.    CSeq: 98505492 INVITE
  835.    P-Early-Media: sendrecv
  836.    Accept: application/sdp, application/isup, application/xml
  837.    Allow: INVITE, ACK, PRACK, CANCEL, BYE, OPTIONS, MESSAGE, NOTIFY, UPDATE, REGISTER, INFO, REFER, SUBSCRIBE
  838.    Contact: <sip:callee@108.59.2.134;did=28.99f3b0e7>
  839.    Content-Type: application/sdp
  840.    Content-Length: 197
  841.    
  842.    v=0
  843.    o=- 1037847 0 IN IP4 93.186.130.140
  844.    s=IMSS
  845.    c=IN IP4 93.186.130.140
  846.    t=0 0
  847.    m=audio 12376 RTP/AVP 18 101
  848.    a=fmtp:18 annexb=no
  849.    a=rtpmap:101 telephone-event/8000
  850.    a=fmtp:101 0-15
  851.    a=sendrecv
  852.    ------------------------------------------------------------------------
  853. 2016-10-28 17:31:58.870882 [DEBUG] switch_core_session.c:1062 Send signal sofia/external/0011102553121015020 [BREAK]
  854. 2016-10-28 17:31:58.870882 [DEBUG] switch_core_session.c:1062 Send signal sofia/external/0011102553121015020 [BREAK]
  855. 2016-10-28 17:31:58.870882 [DEBUG] sofia.c:6658 Channel sofia/external/0011102553121015020 entering state [proceeding][180]
  856. 2016-10-28 17:31:58.870882 [DEBUG] sofia.c:6668 Remote SDP:
  857. v=0
  858. o=- 1037847 0 IN IP4 93.186.130.140
  859. s=IMSS
  860. c=IN IP4 93.186.130.140
  861. t=0 0
  862. m=audio 12376 RTP/AVP 18 101
  863. a=fmtp:18 annexb=no
  864. a=rtpmap:101 telephone-event/8000
  865. a=fmtp:101 0-15
  866.  
  867. 2016-10-28 17:31:58.870882 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [G729:18:8000:20:8000:1]/[G729:18:8000:20:8000:1]
  868. 2016-10-28 17:31:58.870882 [DEBUG] switch_core_media.c:3734 Audio Codec Compare [G729:18:8000:20:8000:1] ++++ is saved as a match
  869. 2016-10-28 17:31:58.870882 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [G729:18:8000:20:8000:1]/[GSM:3:8000:20:13200:1]
  870. 2016-10-28 17:31:58.870882 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
  871. 2016-10-28 17:31:58.870882 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
  872. 2016-10-28 17:31:58.870882 [DEBUG] switch_core_media.c:3595 Set telephone-event payload to 101
  873. 2016-10-28 17:31:58.870882 [DEBUG] switch_core_media.c:2506 Set Codec sofia/external/0011102553121015020 G729/8000 20 ms 160 samples 8000 bits 1 channels
  874. 2016-10-28 17:31:58.870882 [DEBUG] switch_core_codec.c:111 sofia/external/0011102553121015020 Original read codec set to G729:18
  875. 2016-10-28 17:31:58.870882 [DEBUG] switch_core_media.c:3933 Set 2833 dtmf send payload to 101
  876. 2016-10-28 17:31:58.870882 [DEBUG] switch_core_media.c:5178 AUDIO RTP [sofia/external/0011102553121015020] 169.57.148.25 port 26730 -> 93.186.130.140 port 12376 codec: 18 ms: 20
  877. 2016-10-28 17:31:58.870882 [DEBUG] switch_rtp.c:3608 Starting timer [soft] 160 bytes per 20ms
  878. 2016-10-28 17:31:58.870882 [DEBUG] switch_core_media.c:5476 Set 2833 dtmf send payload to 101
  879. 2016-10-28 17:31:58.870882 [DEBUG] switch_core_media.c:5482 Set 2833 dtmf receive payload to 101
  880. 2016-10-28 17:31:58.870882 [DEBUG] switch_core_media.c:5504 sofia/external/0011102553121015020 Set rtp dtmf delay to 40
  881. 2016-10-28 17:31:58.870882 [NOTICE] sofia_media.c:92 Pre-Answer sofia/external/0011102553121015020!
  882. 2016-10-28 17:31:58.870882 [DEBUG] switch_channel.c:3417 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  883. 2016-10-28 17:31:58.870882 [DEBUG] switch_channel.c:3421 (sofia/external/0011102553121015020) Callstate Change DOWN -> EARLY
  884. 2016-10-28 17:31:58.890794 [INFO] switch_ivr_originate.c:3553 Sending early media
  885. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [G729:18:8000:20:8000:1]/[G729:18:8000:20:8000:1]
  886. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3734 Audio Codec Compare [G729:18:8000:20:8000:1] ++++ is saved as a match
  887. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [G729:18:8000:20:8000:1]/[G722:9:8000:20:64000:1]
  888. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
  889. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
  890. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [G729:18:8000:20:8000:1]/[GSM:3:8000:20:13200:1]
  891. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [G723:4:8000:30:6300:1]/[G729:18:8000:20:8000:1]
  892. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [G723:4:8000:30:6300:1]/[G722:9:8000:20:64000:1]
  893. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [G723:4:8000:30:6300:1]/[PCMU:0:8000:20:64000:1]
  894. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [G723:4:8000:30:6300:1]/[PCMA:8:8000:20:64000:1]
  895. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [G723:4:8000:30:6300:1]/[GSM:3:8000:20:13200:1]
  896. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [GSM:3:8000:20:13200:1]/[G729:18:8000:20:8000:1]
  897. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [GSM:3:8000:20:13200:1]/[G722:9:8000:20:64000:1]
  898. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMU:0:8000:20:64000:1]
  899. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMA:8:8000:20:64000:1]
  900. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [GSM:3:8000:20:13200:1]/[GSM:3:8000:20:13200:1]
  901. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3734 Audio Codec Compare [GSM:3:8000:20:13200:1] ++++ is saved as a match
  902. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G729:18:8000:20:8000:1]
  903. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  904. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  905. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  906. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3734 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  907. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[GSM:3:8000:20:13200:1]
  908. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G729:18:8000:20:8000:1]
  909. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  910. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  911. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3734 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  912. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  913. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[GSM:3:8000:20:13200:1]
  914. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3595 Set telephone-event payload to 101
  915. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:2506 Set Codec sofia/external/553134177781@200.201.197.137:5060 G729/8000 20 ms 160 samples 8000 bits 1 channels
  916. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_codec.c:111 sofia/external/553134177781@200.201.197.137:5060 Original read codec set to G729:18
  917. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:3942 Set 2833 dtmf send/recv payload to 101
  918. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:5178 AUDIO RTP [sofia/external/553134177781@200.201.197.137:5060] 169.57.148.25 port 27328 -> 200.201.197.137 port 6772 codec: 18 ms: 20
  919. 2016-10-28 17:31:58.890794 [DEBUG] switch_rtp.c:3608 Starting timer [soft] 160 bytes per 20ms
  920. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:5476 Set 2833 dtmf send payload to 101
  921. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:5482 Set 2833 dtmf receive payload to 101
  922. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_media.c:5504 sofia/external/553134177781@200.201.197.137:5060 Set rtp dtmf delay to 40
  923. 2016-10-28 17:31:58.890794 [NOTICE] sofia_media.c:92 Pre-Answer sofia/external/553134177781@200.201.197.137:5060!
  924. 2016-10-28 17:31:58.890794 [DEBUG] switch_channel.c:3421 (sofia/external/553134177781@200.201.197.137:5060) Callstate Change RINGING -> EARLY
  925. 2016-10-28 17:31:58.890794 [DEBUG] mod_sofia.c:2264 Ring SDP:
  926. v=0
  927. o=FreeSWITCH 1477655790 1477655791 IN IP4 169.57.148.25
  928. s=FreeSWITCH
  929. c=IN IP4 169.57.148.25
  930. t=0 0
  931. m=audio 27328 RTP/AVP 18 101
  932. a=rtpmap:18 G729/8000
  933. a=fmtp:18 annexb=no
  934. a=rtpmap:101 telephone-event/8000
  935. a=fmtp:101 0-16
  936. a=ptime:20
  937. a=sendrecv
  938.  
  939. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_session.c:913 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  940. 2016-10-28 17:31:58.890794 [DEBUG] switch_ivr_originate.c:3604 Originate Resulted in Success: [sofia/external/0011102553121015020]
  941. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_session.c:913 Send signal sofia/external/0011102553121015020 [BREAK]
  942. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_session.c:913 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  943. 2016-10-28 17:31:58.890794 [DEBUG] switch_ivr_bridge.c:1473 (sofia/external/0011102553121015020) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
  944. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_session.c:1397 Send signal sofia/external/0011102553121015020 [BREAK]
  945. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_state_machine.c:472 (sofia/external/0011102553121015020) Running State Change CS_EXCHANGE_MEDIA
  946. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_state_machine.c:538 (sofia/external/0011102553121015020) State EXCHANGE_MEDIA
  947. 2016-10-28 17:31:58.890794 [DEBUG] mod_sofia.c:594 SOFIA EXCHANGE_MEDIA
  948. send 1105 bytes to udp/[200.201.197.137]:5060 at 17:31:58.903377:
  949.    ------------------------------------------------------------------------
  950.    SIP/2.0 183 Session Progress
  951.    Via: SIP/2.0/UDP 200.201.197.137:5060;branch=z9hG4bK311754136513860783951828
  952.    From: 553134177781 <sip:553134177781@200.201.197.137:5060>;tag=173154783951828
  953.    To: <sip:553140421175@199.59.97.196:5060>;tag=y2ZHD2cNZvtSp
  954.    Call-ID: OGtK94Tu5Gc5481758-8c0e-11e6-ab71-9bbfbda5c291@200.201.197.137
  955.    CSeq: 1 INVITE
  956.    Contact: <sip:553140421175@169.57.148.25:5080;transport=udp>
  957.    User-Agent: FreeSWITCH-mod_sofia/1.4.26~64bit
  958.    Accept: application/sdp
  959.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  960.    Supported: timer, path, replaces
  961.    Allow-Events: talk, hold, conference, refer
  962.    Content-Type: application/sdp
  963.    Content-Disposition: session
  964.    Content-Length: 245
  965.    P-Early-Media: sendrecv
  966.    Remote-Party-ID: "Outbound Call" <sip:0011102553121015020@199.59.97.196>;party=calling;privacy=off;screen=no
  967.    
  968.    v=0
  969.    o=FreeSWITCH 1477655790 1477655791 IN IP4 169.57.148.25
  970.    s=FreeSWITCH
  971.    c=IN IP4 169.57.148.25
  972.    t=0 0
  973.    m=audio 27328 RTP/AVP 18 101
  974.    a=rtpmap:18 G729/8000
  975.    a=fmtp:18 annexb=no
  976.    a=rtpmap:101 telephone-event/8000
  977.    a=fmtp:101 0-16
  978.    a=ptime:20
  979.    ------------------------------------------------------------------------
  980. 2016-10-28 17:31:58.890794 [DEBUG] switch_core_session.c:1062 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  981. 2016-10-28 17:31:58.890794 [DEBUG] sofia.c:6658 Channel sofia/external/553134177781@200.201.197.137:5060 entering state [early][183]
  982. 2016-10-28 17:31:58.930312 [DEBUG] switch_rtp.c:5928 Correct ip/port confirmed.
  983. 2016-10-28 17:31:58.930312 [DEBUG] switch_rtp.c:5928 Correct ip/port confirmed.
  984. recv 819 bytes from udp/[108.59.2.134]:5060 at 17:31:59.961641:
  985.    ------------------------------------------------------------------------
  986.    SIP/2.0 200 OK
  987.    Via: SIP/2.0/UDP 169.57.148.25:5080;received=169.57.148.25;rport=5080;branch=z9hG4bKaSU9Km5SB0pHa
  988.    From: "553134177781" <sip:553134177781@169.57.148.25>;tag=ZBSaFXXrv5gcj
  989.    To: <sip:0011102553121015020@sbc.voxbeam.com>;tag=SDkk99599-00b095ca-0067-067b-0000-0000
  990.    Call-ID: 050d55d0-17e8-1235-7585-064fe3a24e98
  991.    CSeq: 98505492 INVITE
  992.    Accept: application/sdp, application/isup, application/xml
  993.    Allow: INVITE, ACK, PRACK, CANCEL, BYE, OPTIONS, MESSAGE, NOTIFY, UPDATE, REGISTER, INFO, REFER, SUBSCRIBE
  994.    Contact: <sip:callee@108.59.2.134;did=28.99f3b0e7>
  995.    Content-Type: application/sdp
  996.    Content-Length: 197
  997.    
  998.    v=0
  999.    o=- 1037847 0 IN IP4 93.186.130.140
  1000.    s=IMSS
  1001.    c=IN IP4 93.186.130.140
  1002.    t=0 0
  1003.    m=audio 12376 RTP/AVP 18 101
  1004.    a=fmtp:18 annexb=no
  1005.    a=rtpmap:101 telephone-event/8000
  1006.    a=fmtp:101 0-15
  1007.    a=sendrecv
  1008.    ------------------------------------------------------------------------
  1009. 2016-10-28 17:31:59.950301 [DEBUG] switch_core_session.c:1062 Send signal sofia/external/0011102553121015020 [BREAK]
  1010. 2016-10-28 17:31:59.950301 [DEBUG] switch_core_session.c:1062 Send signal sofia/external/0011102553121015020 [BREAK]
  1011. 2016-10-28 17:31:59.950301 [DEBUG] sofia.c:6658 Channel sofia/external/0011102553121015020 entering state [completing][200]
  1012. 2016-10-28 17:31:59.950301 [DEBUG] sofia.c:6665 Duplicate SDP
  1013. v=0
  1014. o=- 1037847 0 IN IP4 93.186.130.140
  1015. s=IMSS
  1016. c=IN IP4 93.186.130.140
  1017. t=0 0
  1018. m=audio 12376 RTP/AVP 18 101
  1019. a=fmtp:18 annexb=no
  1020. a=rtpmap:101 telephone-event/8000
  1021. a=fmtp:101 0-15
  1022.  
  1023. send 482 bytes to udp/[108.59.2.134]:5060 at 17:31:59.967178:
  1024.    ------------------------------------------------------------------------
  1025.    ACK sip:callee@108.59.2.134;did=28.99f3b0e7 SIP/2.0
  1026.    Via: SIP/2.0/UDP 169.57.148.25:5080;rport;branch=z9hG4bKcBeUQa705H3pH
  1027.    Max-Forwards: 70
  1028.    From: "553134177781" <sip:553134177781@169.57.148.25>;tag=ZBSaFXXrv5gcj
  1029.    To: <sip:0011102553121015020@sbc.voxbeam.com>;tag=SDkk99599-00b095ca-0067-067b-0000-0000
  1030.    Call-ID: 050d55d0-17e8-1235-7585-064fe3a24e98
  1031.    CSeq: 98505492 ACK
  1032.    Contact: <sip:gw+voxbeam_outbound@169.57.148.25:5080;transport=udp;gw=voxbeam_outbound>
  1033.    Content-Length: 0
  1034.    
  1035.    ------------------------------------------------------------------------
  1036. 2016-10-28 17:31:59.950301 [DEBUG] switch_core_session.c:1062 Send signal sofia/external/0011102553121015020 [BREAK]
  1037. 2016-10-28 17:31:59.950301 [DEBUG] switch_core_session.c:1062 Send signal sofia/external/0011102553121015020 [BREAK]
  1038. 2016-10-28 17:31:59.970305 [DEBUG] sofia.c:6658 Channel sofia/external/0011102553121015020 entering state [ready][200]
  1039. 2016-10-28 17:31:59.970305 [DEBUG] switch_channel.c:3659 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  1040. 2016-10-28 17:31:59.970305 [NOTICE] sofia.c:7466 Channel [sofia/external/0011102553121015020] has been answered
  1041. 2016-10-28 17:31:59.970305 [DEBUG] switch_channel.c:3713 (sofia/external/0011102553121015020) Callstate Change EARLY -> ACTIVE
  1042. 2016-10-28 17:31:59.990303 [DEBUG] mod_sofia.c:780 Local SDP sofia/external/553134177781@200.201.197.137:5060:
  1043. v=0
  1044. o=FreeSWITCH 1477655790 1477655792 IN IP4 169.57.148.25
  1045. s=FreeSWITCH
  1046. c=IN IP4 169.57.148.25
  1047. t=0 0
  1048. m=audio 27328 RTP/AVP 18 101
  1049. a=rtpmap:18 G729/8000
  1050. a=fmtp:18 annexb=no
  1051. a=rtpmap:101 telephone-event/8000
  1052. a=fmtp:101 0-16
  1053. a=ptime:20
  1054. a=sendrecv
  1055.  
  1056. 2016-10-28 17:31:59.990303 [DEBUG] switch_core_session.c:913 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  1057. send 1041 bytes to udp/[200.201.197.137]:5060 at 17:31:59.994744:
  1058.    ------------------------------------------------------------------------
  1059.    SIP/2.0 200 OK
  1060.    Via: SIP/2.0/UDP 200.201.197.137:5060;branch=z9hG4bK311754136513860783951828
  1061.    From: 553134177781 <sip:553134177781@200.201.197.137:5060>;tag=173154783951828
  1062.    To: <sip:553140421175@199.59.97.196:5060>;tag=y2ZHD2cNZvtSp
  1063.    Call-ID: OGtK94Tu5Gc5481758-8c0e-11e6-ab71-9bbfbda5c291@200.201.197.137
  1064.    CSeq: 1 INVITE
  1065.    Contact: <sip:553140421175@169.57.148.25:5080;transport=udp>
  1066.    User-Agent: FreeSWITCH-mod_sofia/1.4.26~64bit
  1067.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  1068.    Supported: timer, path, replaces
  1069.    Allow-Events: talk, hold, conference, refer
  1070.    Content-Type: application/sdp
  1071.    Content-Disposition: session
  1072.    Content-Length: 245
  1073.    Remote-Party-ID: "Outbound Call" <sip:0011102553121015020@199.59.97.196>;party=calling;privacy=off;screen=no
  1074.    
  1075.    v=0
  1076.    o=FreeSWITCH 1477655790 1477655791 IN IP4 169.57.148.25
  1077.    s=FreeSWITCH
  1078.    c=IN IP4 169.57.148.25
  1079.    t=0 0
  1080.    m=audio 27328 RTP/AVP 18 101
  1081.    a=rtpmap:18 G729/8000
  1082.    a=fmtp:18 annexb=no
  1083.    a=rtpmap:101 telephone-event/8000
  1084.    a=fmtp:101 0-16
  1085.    a=ptime:20
  1086.    ------------------------------------------------------------------------
  1087. 2016-10-28 17:31:59.990303 [DEBUG] switch_core_session.c:1062 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  1088. 2016-10-28 17:31:59.990303 [NOTICE] switch_ivr_bridge.c:501 Channel [sofia/external/553134177781@200.201.197.137:5060] has been answered
  1089. 2016-10-28 17:31:59.990303 [DEBUG] switch_channel.c:3713 (sofia/external/553134177781@200.201.197.137:5060) Callstate Change EARLY -> ACTIVE
  1090. 2016-10-28 17:31:59.990303 [DEBUG] sofia.c:6658 Channel sofia/external/553134177781@200.201.197.137:5060 entering state [completed][200]
  1091. 2016-10-28 17:32:00.030302 [DEBUG] switch_rtp.c:5928 Correct ip/port confirmed.
  1092. 2016-10-28 17:32:00.050290 [DEBUG] switch_rtp.c:5928 Correct ip/port confirmed.
  1093. 2016-10-28 17:32:00.070302 [DEBUG] switch_core_media_bug.c:519 Attaching BUG to sofia/external/553134177781@200.201.197.137:5060
  1094. 2016-10-28 17:32:00.090303 [DEBUG] switch_ivr_async.c:1473 No silence detection configured; assuming start of speech
  1095. 2016-10-28 17:32:00.130302 [DEBUG] switch_core_io.c:528 Setting BUG Codec G729:18
  1096. freeswitch@default> recv 445 bytes from udp/[200.201.197.137]:5060 at 17:32:00.276148:
  1097.    ------------------------------------------------------------------------
  1098.    ACK sip:553140421175@169.57.148.25:5080;transport=udp SIP/2.0
  1099.    CSeq: 1 ACK
  1100.    Via: SIP/2.0/UDP 200.201.197.137:5060;branch=z9hG4bK321702136901460783959656
  1101.    From: <sip:553134177781@200.201.197.137:5060>;tag=173154783951828
  1102.    Call-ID: OGtK94Tu5Gc5481758-8c0e-11e6-ab71-9bbfbda5c291@200.201.197.137
  1103.    To: <sip:553140421175@199.59.97.196:5060>;tag=y2ZHD2cNZvtSp
  1104.    Contact: <sip:200.201.197.137:5060;transport=udp>
  1105.    Content-Length: 0
  1106.    Max-Forwards: 70
  1107.    
  1108.    ------------------------------------------------------------------------
  1109. 2016-10-28 17:32:00.270306 [DEBUG] switch_core_session.c:1062 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  1110. 2016-10-28 17:32:00.270306 [DEBUG] switch_core_session.c:1062 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  1111. 2016-10-28 17:32:00.270306 [DEBUG] switch_core_session.c:1062 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  1112. 2016-10-28 17:32:00.290307 [DEBUG] sofia.c:6658 Channel sofia/external/553134177781@200.201.197.137:5060 entering state [ready][200]
  1113. 2016-10-28 17:32:00.290307 [DEBUG] switch_core_session.c:979 Send signal sofia/external/0011102553121015020 [BREAK]
  1114. 2016-10-28 17:32:00.290307 [DEBUG] switch_core_session.c:979 Send signal sofia/external/553134177781@200.201.197.137:5060 [BREAK]
  1115. freeswitch@default> freeswitch@default> recv 661 bytes from udp/[184.169.138.133]:5060 at 17:32:01.052213:
  1116.    ------------------------------------------------------------------------
  1117.    BYE sip:551127232100@169.57.148.25:5060;transport=udp SIP/2.0
  1118.    Via: SIP/2.0/UDP 184.169.138.133:5060;branch=z9hG4bK0b5f.c89d6ff.0
  1119.    Via: SIP/2.0/UDP 67.192.253.162:5080;received=67.192.253.162;rport=5080;branch=z9hG4bK1HX62r4KZDj0F
  1120.    Max-Forwards: 69
  1121.    From: "+5511984286929" <sip:+5511984286929@67.192.253.162>;tag=Q0mcme2NgXy5a
  1122.    To: <sip:s2.opensips-outbound.plivo.com:5060>;tag=5U0Sg558K7vZK
  1123.    Call-ID: 9fe770de-17e7-1235-8385-0026b93d8e7c
  1124.    CSeq: 98505408 BYE
  1125.    User-Agent: Plivo
  1126.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REFER, NOTIFY
  1127.    Supported: timer, path, replaces
  1128.    Reason: Q.850;cause=16;text="NORMAL_CLEARING"
  1129.    Content-Length: 0
  1130.    
  1131.    ------------------------------------------------------------------------
  1132. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/+5511984286929@67.192.253.162 [BREAK]
  1133. 2016-10-28 17:32:01.050302 [NOTICE] sofia.c:952 Hangup sofia/internal/+5511984286929@67.192.253.162 [CS_EXECUTE] [NORMAL_CLEARING]
  1134. 2016-10-28 17:32:01.050302 [DEBUG] switch_channel.c:3244 Send signal sofia/internal/+5511984286929@67.192.253.162 [KILL]
  1135. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/+5511984286929@67.192.253.162 [BREAK]
  1136. send 577 bytes to udp/[184.169.138.133]:5060 at 17:32:01.062501:
  1137.    ------------------------------------------------------------------------
  1138.    SIP/2.0 200 OK
  1139.    Via: SIP/2.0/UDP 184.169.138.133:5060;branch=z9hG4bK0b5f.c89d6ff.0
  1140.    Via: SIP/2.0/UDP 67.192.253.162:5080;received=67.192.253.162;rport=5080;branch=z9hG4bK1HX62r4KZDj0F
  1141.    From: "+5511984286929" <sip:+5511984286929@67.192.253.162>;tag=Q0mcme2NgXy5a
  1142.    To: <sip:s2.opensips-outbound.plivo.com:5060>;tag=5U0Sg558K7vZK
  1143.    Call-ID: 9fe770de-17e7-1235-8385-0026b93d8e7c
  1144.    CSeq: 98505408 BYE
  1145.    User-Agent: PhoneTrack
  1146.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  1147.    Supported: path, replaces
  1148.    Content-Length: 0
  1149.    
  1150.    ------------------------------------------------------------------------
  1151. 2016-10-28 17:32:01.050302 [DEBUG] switch_ivr_bridge.c:665 BRIDGE THREAD DONE [sofia/internal/+5511984286929@67.192.253.162]
  1152. 2016-10-28 17:32:01.050302 [DEBUG] switch_ivr_bridge.c:695 Send signal sofia/external/0011102551127232100 [BREAK]
  1153. 2016-10-28 17:32:01.050302 [DEBUG] switch_ivr_bridge.c:665 BRIDGE THREAD DONE [sofia/external/0011102551127232100]
  1154. 2016-10-28 17:32:01.050302 [DEBUG] switch_ivr_bridge.c:695 Send signal sofia/internal/+5511984286929@67.192.253.162 [BREAK]
  1155. 2016-10-28 17:32:01.050302 [NOTICE] switch_ivr_bridge.c:763 Hangup sofia/external/0011102551127232100 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
  1156. 2016-10-28 17:32:01.050302 [DEBUG] switch_channel.c:3244 Send signal sofia/external/0011102551127232100 [KILL]
  1157. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_session.c:1397 Send signal sofia/external/0011102551127232100 [BREAK]
  1158. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:538 (sofia/external/0011102551127232100) State EXCHANGE_MEDIA going to sleep
  1159. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:472 (sofia/external/0011102551127232100) Running State Change CS_HANGUP
  1160. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:735 (sofia/external/0011102551127232100) Callstate Change ACTIVE -> HANGUP
  1161. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:737 (sofia/external/0011102551127232100) State HANGUP
  1162. 2016-10-28 17:32:01.050302 [DEBUG] mod_sofia.c:407 sofia/external/0011102551127232100 Overriding SIP cause 480 with 200 from the other leg
  1163. 2016-10-28 17:32:01.050302 [DEBUG] mod_sofia.c:413 Channel sofia/external/0011102551127232100 hanging up, cause: NORMAL_CLEARING
  1164. 2016-10-28 17:32:01.050302 [DEBUG] mod_sofia.c:465 Sending BYE to sofia/external/0011102551127232100
  1165. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:60 sofia/external/0011102551127232100 Standard HANGUP, cause: NORMAL_CLEARING
  1166. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:737 (sofia/external/0011102551127232100) State HANGUP going to sleep
  1167. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:504 (sofia/external/0011102551127232100) State Change CS_HANGUP -> CS_REPORTING
  1168. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_session.c:1397 Send signal sofia/external/0011102551127232100 [BREAK]
  1169. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:472 (sofia/external/0011102551127232100) Running State Change CS_REPORTING
  1170. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:823 (sofia/external/0011102551127232100) State REPORTING
  1171. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:104 sofia/external/0011102551127232100 Standard REPORTING, cause: NORMAL_CLEARING
  1172. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:823 (sofia/external/0011102551127232100) State REPORTING going to sleep
  1173. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:498 (sofia/external/0011102551127232100) State Change CS_REPORTING -> CS_DESTROY
  1174. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_session.c:1397 Send signal sofia/external/0011102551127232100 [BREAK]
  1175. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_session.c:1624 Session 105342 (sofia/external/0011102551127232100) Locked, Waiting on external entities
  1176. 2016-10-28 17:32:01.050302 [DEBUG] switch_ivr_bridge.c:1574 sofia/internal/+5511984286929@67.192.253.162 skip receive message [UNBRIDGE] (channel is hungup already)
  1177. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_session.c:2767 sofia/internal/+5511984286929@67.192.253.162 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  1178. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:535 (sofia/internal/+5511984286929@67.192.253.162) State EXECUTE going to sleep
  1179. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/+5511984286929@67.192.253.162) Running State Change CS_HANGUP
  1180. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:735 (sofia/internal/+5511984286929@67.192.253.162) Callstate Change ACTIVE -> HANGUP
  1181. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:737 (sofia/internal/+5511984286929@67.192.253.162) State HANGUP
  1182. 2016-10-28 17:32:01.050302 [DEBUG] mod_sofia.c:413 Channel sofia/internal/+5511984286929@67.192.253.162 hanging up, cause: NORMAL_CLEARING
  1183. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:60 sofia/internal/+5511984286929@67.192.253.162 Standard HANGUP, cause: NORMAL_CLEARING
  1184. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:737 (sofia/internal/+5511984286929@67.192.253.162) State HANGUP going to sleep
  1185. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:504 (sofia/internal/+5511984286929@67.192.253.162) State Change CS_HANGUP -> CS_REPORTING
  1186. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/+5511984286929@67.192.253.162 [BREAK]
  1187. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/+5511984286929@67.192.253.162) Running State Change CS_REPORTING
  1188. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:823 (sofia/internal/+5511984286929@67.192.253.162) State REPORTING
  1189. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:104 sofia/internal/+5511984286929@67.192.253.162 Standard REPORTING, cause: NORMAL_CLEARING
  1190. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:823 (sofia/internal/+5511984286929@67.192.253.162) State REPORTING going to sleep
  1191. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:498 (sofia/internal/+5511984286929@67.192.253.162) State Change CS_REPORTING -> CS_DESTROY
  1192. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/+5511984286929@67.192.253.162 [BREAK]
  1193. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_session.c:1624 Session 105341 (sofia/internal/+5511984286929@67.192.253.162) Locked, Waiting on external entities
  1194. 2016-10-28 17:32:01.050302 [NOTICE] switch_core_session.c:1642 Session 105341 (sofia/internal/+5511984286929@67.192.253.162) Ended
  1195. 2016-10-28 17:32:01.050302 [NOTICE] switch_core_session.c:1646 Close Channel sofia/internal/+5511984286929@67.192.253.162 [CS_DESTROY]
  1196. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:626 (sofia/internal/+5511984286929@67.192.253.162) Running State Change CS_DESTROY
  1197. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:636 (sofia/internal/+5511984286929@67.192.253.162) State DESTROY
  1198. 2016-10-28 17:32:01.050302 [DEBUG] mod_sofia.c:323 sofia/internal/+5511984286929@67.192.253.162 SOFIA DESTROY
  1199. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:111 sofia/internal/+5511984286929@67.192.253.162 Standard DESTROY
  1200. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:636 (sofia/internal/+5511984286929@67.192.253.162) State DESTROY going to sleep
  1201. send 615 bytes to udp/[108.59.2.134]:5060 at 17:32:01.070718:
  1202.    ------------------------------------------------------------------------
  1203.    BYE sip:callee@108.59.2.134;did=eab.bf8d04d5 SIP/2.0
  1204.    Via: SIP/2.0/UDP 169.57.148.25:5080;rport;branch=z9hG4bKDm7KS5Q42tS9c
  1205.    Max-Forwards: 70
  1206.    From: "+5511984286929" <sip:5511984286929@169.57.148.25>;tag=Q3e404pvKyypN
  1207.    To: <sip:0011102551127232100@sbc.voxbeam.com>;tag=SDrnml299-00a3b932-0067-0412-0000-0000
  1208.    Call-ID: 9ffd7f21-17e7-1235-7585-064fe3a24e98
  1209.    CSeq: 98505408 BYE
  1210.    User-Agent: FreeSWITCH-mod_sofia/1.4.26~64bit
  1211.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  1212.    Supported: timer, path, replaces
  1213.    Reason: Q.850;cause=16;text="NORMAL_CLEARING"
  1214.    Content-Length: 0
  1215.    
  1216.    ------------------------------------------------------------------------
  1217. 2016-10-28 17:32:01.050302 [NOTICE] switch_core_session.c:1642 Session 105342 (sofia/external/0011102551127232100) Ended
  1218. 2016-10-28 17:32:01.050302 [NOTICE] switch_core_session.c:1646 Close Channel sofia/external/0011102551127232100 [CS_DESTROY]
  1219. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:626 (sofia/external/0011102551127232100) Running State Change CS_DESTROY
  1220. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:636 (sofia/external/0011102551127232100) State DESTROY
  1221. 2016-10-28 17:32:01.050302 [DEBUG] mod_sofia.c:323 sofia/external/0011102551127232100 SOFIA DESTROY
  1222. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:111 sofia/external/0011102551127232100 Standard DESTROY
  1223. 2016-10-28 17:32:01.050302 [DEBUG] switch_core_state_machine.c:636 (sofia/external/0011102551127232100) State DESTROY going to sleep
  1224. recv 530 bytes from udp/[108.59.2.134]:5060 at 17:32:01.321596:
  1225.    ------------------------------------------------------------------------
  1226.    SIP/2.0 200 OK
  1227.    Via: SIP/2.0/UDP 169.57.148.25:5080;received=169.57.148.25;rport=5080;branch=z9hG4bKDm7KS5Q42tS9c
  1228.    From: "+5511984286929" <sip:5511984286929@169.57.148.25>;tag=Q3e404pvKyypN
  1229.    To: <sip:0011102551127232100@sbc.voxbeam.com>;tag=SDrnml299-00a3b932-0067-0412-0000-0000
  1230.    Call-ID: 9ffd7f21-17e7-1235-7585-064fe3a24e98
  1231.    CSeq: 98505408 BYE
  1232.    Allow: INVITE, ACK, PRACK, CANCEL, BYE, OPTIONS, MESSAGE, NOTIFY, UPDATE, REGISTER, INFO, REFER, SUBSCRIBE
  1233.    Contact: <sip:callee@108.59.2.134;did=eab.bf8d04d5>
  1234.    Content-Length: 0
  1235.    
  1236.    ------------------------------------------------------------------------
  1237. recv 549 bytes from udp/[177.92.48.107]:60865 at 17:32:01.689513:
  1238.    ------------------------------------------------------------------------
  1239.    REGISTER sip:sip1.phonetrack.com.br SIP/2.0
  1240.    Via: SIP/2.0/UDP 192.168.0.202:5060;branch=z9hG4bK-ae0483a3
  1241.    From: From Office PSTN <sip:1001@sip1.phonetrack.com.br>;tag=76d4ab50aee00088o0
  1242.    To: From Office PSTN <sip:1001@sip1.phonetrack.com.br>
  1243.    Call-ID: 89892a52-c374bcb8@127.0.0.1
  1244.    CSeq: 77309 REGISTER
  1245.    Max-Forwards: 70
  1246.    Contact: From Office PSTN <sip:1001@192.168.0.202:5060>;expires=3600
  1247.    User-Agent: Linksys/SPA3102-5.2.13(GW002)
  1248.    Content-Length: 0
  1249.    Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
  1250.    Supported: x-sipura, replaces
  1251.    
  1252.    ------------------------------------------------------------------------
  1253. send 637 bytes to udp/[177.92.48.107]:5060 at 17:32:01.689701:
  1254.    ------------------------------------------------------------------------
  1255.    SIP/2.0 401 Unauthorized
  1256.    Via: SIP/2.0/UDP 192.168.0.202:5060;branch=z9hG4bK-ae0483a3;received=177.92.48.107
  1257.    From: From Office PSTN <sip:1001@sip1.phonetrack.com.br>;tag=76d4ab50aee00088o0
  1258.    To: From Office PSTN <sip:1001@sip1.phonetrack.com.br>;tag=eD4r0rX8SQ57B
  1259.    Call-ID: 89892a52-c374bcb8@127.0.0.1
  1260.    CSeq: 77309 REGISTER
  1261.    User-Agent: PhoneTrack
  1262.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  1263.    Supported: path, replaces
  1264.    WWW-Authenticate: Digest realm="sip1.phonetrack.com.br", nonce="2055a344-9d45-11e6-a5ef-9bbfbda5c291", algorithm=MD5, qop="auth"
  1265.    Content-Length: 0
  1266.    
  1267.    ------------------------------------------------------------------------
  1268. recv 498 bytes from udp/[177.92.48.107]:60864 at 17:32:01.690769:
  1269.    ------------------------------------------------------------------------
  1270.    REGISTER sip:169.57.148.25 SIP/2.0
  1271.    Via: SIP/2.0/UDP 192.168.0.202:5061;branch=z9hG4bK-466a16cb
  1272.    From: GVT PSTN <sip:1010@169.57.148.25>;tag=e8e015108e55a1c8o1
  1273.    To: GVT PSTN <sip:1010@169.57.148.25>
  1274.    Call-ID: 8015e2e0-bcbdad82@127.0.0.1
  1275.    CSeq: 58299 REGISTER
  1276.    Max-Forwards: 70
  1277.    Contact: GVT PSTN <sip:1010@192.168.0.202:5061>;expires=3600
  1278.    User-Agent: Linksys/SPA3102-5.2.13(GW002)
  1279.    Content-Length: 0
  1280.    Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
  1281.    Supported: x-sipura, replaces
  1282.    
  1283.    ------------------------------------------------------------------------
  1284. send 594 bytes to udp/[177.92.48.107]:5061 at 17:32:01.690938:
  1285.    ------------------------------------------------------------------------
  1286.    SIP/2.0 401 Unauthorized
  1287.    Via: SIP/2.0/UDP 192.168.0.202:5061;branch=z9hG4bK-466a16cb;received=177.92.48.107
  1288.    From: GVT PSTN <sip:1010@169.57.148.25>;tag=e8e015108e55a1c8o1
  1289.    To: GVT PSTN <sip:1010@169.57.148.25>;tag=FpXH2KecQ0UtQ
  1290.    Call-ID: 8015e2e0-bcbdad82@127.0.0.1
  1291.    CSeq: 58299 REGISTER
  1292.    User-Agent: PhoneTrack
  1293.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  1294.    Supported: path, replaces
  1295.    WWW-Authenticate: Digest realm="169.57.148.25", nonce="2055b79e-9d45-11e6-a5f0-9bbfbda5c291", algorithm=MD5, qop="auth"
  1296.    Content-Length: 0
  1297.    
  1298.    ------------------------------------------------------------------------
  1299.