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.