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@FusionPBX> Invalid Profile [internal]
33. freeswitch@FusionPBX> 2017-03-30 19:20:25.320953 [WARNING] sofia_reg.c:1791 SIP auth challenge (REGISTER) on sofia profile 'internal_old' for [14440@fs.mindc.co] from ip 81.218.146.180
34. 2017-03-30 19:20:30.620935 [NOTICE] switch_channel.c:1104 New Channel sofia/internal_old/14451@fs.mindc.co [131b4280-8834-4deb-923d-afca926d4463]
35. 2017-03-30 19:20:30.620935 [DEBUG] switch_core_state_machine.c:584 (sofia/internal_old/14451@fs.mindc.co) Running State Change CS_NEW
36. 2017-03-30 19:20:30.620935 [DEBUG] sofia.c:9603 sofia/internal_old/14451@fs.mindc.co receiving invite from 81.218.146.180:53449 version: 1.6.12 -20-b91a0a6 64bit
37. 2017-03-30 19:20:30.620935 [DEBUG] sofia.c:9770 IP 81.218.146.180 Rejected by acl "domains". Falling back to Digest auth.
38. 2017-03-30 19:20:30.620935 [WARNING] sofia_reg.c:1791 SIP auth challenge (INVITE) on sofia profile 'internal_old' for [0523838030@fs.mindc.co] from ip 81.218.146.180
39. 2017-03-30 19:20:30.620935 [DEBUG] switch_core_state_machine.c:603 (sofia/internal_old/14451@fs.mindc.co) State NEW
40. 2017-03-30 19:20:30.620935 [DEBUG] sofia.c:2276 detaching session 131b4280-8834-4deb-923d-afca926d4463
41. 2017-03-30 19:20:30.640941 [DEBUG] sofia.c:2384 Re-attaching to session 131b4280-8834-4deb-923d-afca926d4463
42. 2017-03-30 19:20:30.660965 [DEBUG] sofia.c:9603 sofia/internal_old/14451@fs.mindc.co receiving invite from 81.218.146.180:53449 version: 1.6.12 -20-b91a0a6 64bit
43. 2017-03-30 19:20:30.660965 [DEBUG] sofia.c:9770 IP 81.218.146.180 Rejected by acl "domains". Falling back to Digest auth.
44. 2017-03-30 19:20:30.680946 [DEBUG] sofia.c:10906 Setting NAT mode based on via received
45. 2017-03-30 19:20:30.680946 [DEBUG] sofia.c:6965 Channel sofia/internal_old/14451@fs.mindc.co entering state [received][100]
46. 2017-03-30 19:20:30.680946 [DEBUG] sofia.c:6975 Remote SDP:
47. v=0
48. o=- 2239406885585055500 2 IN IP4 127.0.0.1
49. s=Doubango Telecom - chrome
50. t=0 0
51. a=group:BUNDLE audio
52. a=msid-semantic: WMS 8bg48LRrdKoskspjDM176L5o4u9v9FKh0Jrr
53. m=audio 55975 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 126
54. c=IN IP4 81.218.146.180
55. a=rtpmap:111 opus/48000/2
56. a=fmtp:111 minptime=10;useinbandfec=1
57. a=rtpmap:103 ISAC/16000
58. a=rtpmap:104 ISAC/32000
59. a=rtpmap:9 G722/8000
60. a=rtpmap:0 PCMU/8000
61. a=rtpmap:8 PCMA/8000
62. a=rtpmap:106 CN/32000
63. a=rtpmap:105 CN/16000
64. a=rtpmap:13 CN/8000
65. a=rtpmap:126 telephone-event/8000
66. a=rtcp:55979 IN IP4 81.218.146.180
67. a=candidate:3836812040 1 udp 2122255103 2001::9d38:6abd:30cb:32b4:f5ff:2f 55973 typ host generation 0 network-id 1 network-cost 50
68. a=candidate:495521287 1 udp 2122194687 192.168.217.1 55974 typ host generation 0 network-id 4
69. a=candidate:1877284270 1 udp 2122129151 10.0.255.208 55975 typ host generation 0 network-id 3
70. a=candidate:812160150 1 udp 2122063615 192.168.148.1 55976 typ host generation 0 network-id 2
71. a=candidate:3836812040 2 udp 2122255102 2001::9d38:6abd:30cb:32b4:f5ff:2f 55977 typ host generation 0 network-id 1 network-cost 50
72. a=candidate:495521287 2 udp 2122194686 192.168.217.1 55978 typ host generation 0 network-id 4
73. a=candidate:1877284270 2 udp 2122129150 10.0.255.208 55979 typ host generation 0 network-id 3
74. a=candidate:812160150 2 udp 2122063614 192.168.148.1 55980 typ host generation 0 network-id 2
75. a=candidate:2855462904 1 tcp 1518275327 2001::9d38:6abd:30cb:32b4:f5ff:2f 9 typ host tcptype active generation 0 network-id 1 network-cost 50
76. a=candidate:1393226487 1 tcp 1518214911 192.168.217.1 9 typ host tcptype active generation 0 network-id 4
77. a=candidate:560392542 1 tcp 1518149375 10.0.255.208 9 typ host tcptype active generation 0 network-id 3
78. a=candidate:2129356902 1 tcp 1518083839 192.168.148.1 9 typ host tcptype active generation 0 network-id 2
79. a=candidate:2855462904 2 tcp 1518275326 2001::9d38:6abd:30cb:32b4:f5ff:2f 9 typ host tcptype active generation 0 network-id 1 network-cost 50
80. a=candidate:1393226487 2 tcp 1518214910 192.168.217.1 9 typ host tcptype active generation 0 network-id 4
81. a=candidate:560392542 2 tcp 1518149374 10.0.255.208 9 typ host tcptype active generation 0 network-id 3
82. a=candidate:2129356902 2 tcp 1518083838 192.168.148.1 9 typ host tcptype active generation 0 network-id 2
83. a=candidate:2582998138 1 udp 1685921535 81.218.146.180 55975 typ srflx raddr 10.0.255.208 rport 55975 generation 0 network-id 3
84. a=candidate:2582998138 2 udp 1685921534 81.218.146.180 55979 typ srflx raddr 10.0.255.208 rport 55979 generation 0 network-id 3
85. a=ice-ufrag:NsA1
86. a=ice-pwd:okXubah6rhTy9OSZiWz0YCDB
87. a=fingerprint:sha-256 14:FC:E0:7D:79:58:42:BA:17:AA:A2:85:27:8B:CE:9A:C8:CA:D8:2A:65:2E:09:E7:85:56:1F:6B:20:38:90:DE
88. a=setup:actpass
89. a=mid:audio
90. a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
91. a=rtcp-mux
92. a=rtcp-fb:111 transport-cc
93. a=ssrc:601562311 cname:8DQ5W+vGA5FKjF1K
94. a=ssrc:601562311 msid:8bg48LRrdKoskspjDM176L5o4u9v9FKh0Jrr 8dd1b9ab-fa3b-45e6-a1d6-9628bf7fb8d2
95. a=ssrc:601562311 mslabel:8bg48LRrdKoskspjDM176L5o4u9v9FKh0Jrr
96. a=ssrc:601562311 label:8dd1b9ab-fa3b-45e6-a1d6-9628bf7fb8d2
97.  
98. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [opus:111:48000:20:0:2]/[PCMU:0:8000:20:64000:1]
99. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [opus:111:48000:20:0:2]/[PCMA:8:8000:20:64000:1]
100. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [ISAC:103:16000:30:32000:1]/[PCMU:0:8000:20:64000:1]
101. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [ISAC:103:16000:30:32000:1]/[PCMA:8:8000:20:64000:1]
102. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [ISAC:104:32000:30:32000:1]/[PCMU:0:8000:20:64000:1]
103. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [ISAC:104:32000:30:32000:1]/[PCMA:8:8000:20:64000:1]
104. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
105. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
106. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
107. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4366 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
108. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
109. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
110. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
111. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4366 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
112. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [CN:105:16000:20:0:1]/[PCMU:0:8000:20:64000:1]
113. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [CN:105:16000:20:0:1]/[PCMA:8:8000:20:64000:1]
114. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [CN:13:8000:20:0:1]/[PCMU:0:8000:20:64000:1]
115. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [CN:13:8000:20:0:1]/[PCMA:8:8000:20:64000:1]
116. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4227 Set telephone-event payload to 126@8000
117. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3021 Set Codec sofia/internal_old/14451@fs.mindc.co PCMU/8000 20 ms 160 samples 64000 bits 1 channels
118. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_codec.c:111 sofia/internal_old/14451@fs.mindc.co Original read codec set to PCMU:0
119. 2017-03-30 19:20:30.680946 [WARNING] switch_core_media.c:3395 NO candidate ACL defined, Defaulting to wan.auto
120. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3419 Drop audio Candidate cid: 1 proto: udp type: host addr: 2001::9d38:6abd:30cb:32b4:f5ff:2f:55973 (no network path)
121. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3425 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.217.1:55974
122. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3425 Save audio Candidate cid: 1 proto: udp type: host addr: 10.0.255.208:55975
123. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3425 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.148.1:55976
124. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3419 Drop audio Candidate cid: 2 proto: udp type: host addr: 2001::9d38:6abd:30cb:32b4:f5ff:2f:55977 (no network path)
125. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3425 Save audio Candidate cid: 2 proto: udp type: host addr: 192.168.217.1:55978
126. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3425 Save audio Candidate cid: 2 proto: udp type: host addr: 10.0.255.208:55979
127. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3425 Save audio Candidate cid: 2 proto: udp type: host addr: 192.168.148.1:55980
128. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3425 Save audio Candidate cid: 1 proto: udp type: srflx addr: 81.218.146.180:55975
129. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3425 Save audio Candidate cid: 2 proto: udp type: srflx addr: 81.218.146.180:55979
130. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3467 Searching for rtp candidate.
131. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3472 Choose rtp candidate, index 3, 81.218.146.180:55975
132. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3250 sofia/internal_old/14451@fs.mindc.co choosing family v4
133. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3483 Choose same candidate, index 4, for rtcp based on rtcp-mux attribute 81.218.146.180:55975
134. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3528 setting remote audio ice addr to index 3 81.218.146.180:55975 based on candidate
135. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3549 Setting remote rtcp audio addr to 81.218.146.180:55975 based on candidate
136. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4572 Set telephone-event payload to 126@8000
137. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4631 sofia/internal_old/14451@fs.mindc.co Set 2833 dtmf send payload to 126 recv payload to 126
138. 2017-03-30 19:20:30.680946 [DEBUG] sofia.c:7364 (sofia/internal_old/14451@fs.mindc.co) State Change CS_NEW -> CS_INIT
139. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_state_machine.c:584 (sofia/internal_old/14451@fs.mindc.co) Running State Change CS_INIT
140. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_state_machine.c:627 (sofia/internal_old/14451@fs.mindc.co) State INIT
141. 2017-03-30 19:20:30.680946 [DEBUG] mod_sofia.c:90 sofia/internal_old/14451@fs.mindc.co SOFIA INIT
142. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_state_machine.c:40 sofia/internal_old/14451@fs.mindc.co Standard INIT
143. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_state_machine.c:48 (sofia/internal_old/14451@fs.mindc.co) State Change CS_INIT -> CS_ROUTING
144. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_state_machine.c:627 (sofia/internal_old/14451@fs.mindc.co) State INIT going to sleep
145. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_state_machine.c:584 (sofia/internal_old/14451@fs.mindc.co) Running State Change CS_ROUTING
146. 2017-03-30 19:20:30.680946 [DEBUG] switch_channel.c:2249 (sofia/internal_old/14451@fs.mindc.co) Callstate Change DOWN -> RINGING
147. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_state_machine.c:643 (sofia/internal_old/14451@fs.mindc.co) State ROUTING
148. 2017-03-30 19:20:30.680946 [DEBUG] mod_sofia.c:143 sofia/internal_old/14451@fs.mindc.co SOFIA ROUTING
149. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_state_machine.c:236 sofia/internal_old/14451@fs.mindc.co Standard ROUTING
150. 2017-03-30 19:20:30.680946 [INFO] mod_dialplan_xml.c:637 Processing 14451 <14451>->0523838030 in context fs.mindc.co
151. Dialplan: sofia/internal_old/14451@fs.mindc.co parsing [fs.mindc.co->user_exists] continue=true
152. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [user_exists] () =~ // break=on-false
153. Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
154. 2017-03-30 19:20:30.680946 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f5710040a50 Connected.
155. 2017-03-30 19:20:30.680946 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f5710040a50 released.
156. EXECUTE sofia/internal_old/14451@fs.mindc.co set(user_exists=false)
157. 2017-03-30 19:20:30.680946 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [user_exists]=[false]
158. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_exists] ${user_exists}(false) =~ /^true$/ break=on-false
159. Dialplan: sofia/internal_old/14451@fs.mindc.co parsing [fs.mindc.co->variables] continue=true
160. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [variables] () =~ // break=on-false
161. Dialplan: sofia/internal_old/14451@fs.mindc.co Action export(origination_callee_id_name=${destination_number})
162. Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
163. Dialplan: sofia/internal_old/14451@fs.mindc.co parsing [fs.mindc.co->call-direction] continue=true
164. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [call-direction] ${call_direction}() =~ /^(inbound|outbound|local)$/ break=never
165. Dialplan: sofia/internal_old/14451@fs.mindc.co ANTI-Action set(call_direction=local)
166. Dialplan: sofia/internal_old/14451@fs.mindc.co parsing [fs.mindc.co->chanspy] continue=false
167. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [chanspy] destination_number(0523838030) =~ /^\*33(\d{2,7})$/ break=on-false
168. Dialplan: sofia/internal_old/14451@fs.mindc.co parsing [fs.mindc.co->user_record] continue=true
169. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [user_record] () =~ // break=on-false
170. Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(user_record=${user_data ${destination_number}@${domain_name} var user_record}) INLINE
171. 2017-03-30 19:20:30.680946 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f5710040a50 Connected.
172. 2017-03-30 19:20:30.680946 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f5710040a50 released.
173. 2017-03-30 19:20:30.680946 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f5710040a50 Connected.
174. 2017-03-30 19:20:30.680946 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f5710040a50 released.
175. EXECUTE sofia/internal_old/14451@fs.mindc.co set(user_record=)
176. 2017-03-30 19:20:30.680946 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [user_record]=[UNDEF]
177. Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
178. EXECUTE sofia/internal_old/14451@fs.mindc.co set(from_user_exists=true)
179. 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [from_user_exists]=[true]
180. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
181. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never
182. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
183. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${call_direction}() =~ /^inbound$/ break=never
184. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never
185. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
186. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${call_direction}() =~ /^outbound$/ break=never
187. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never
188. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
189. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${call_direction}() =~ /^local$/ break=never
190. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
191. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
192. Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(from_user_record=${user_data ${sip_from_user}@${sip_from_host} var user_record}) INLINE
193. EXECUTE sofia/internal_old/14451@fs.mindc.co set(from_user_record=all)
194. 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [from_user_record]=[all]
195. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
196. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [user_record] ${from_user_record}(all) =~ /^all$/ break=never
197. Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(record_session=true) INLINE
198. EXECUTE sofia/internal_old/14451@fs.mindc.co set(record_session=true)
199. 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [record_session]=[true]
200. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
201. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${call_direction}() =~ /^inbound$/ break=never
202. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${from_user_record}(all) =~ /^inbound$/ break=never
203. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
204. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${call_direction}() =~ /^outbound$/ break=never
205. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${from_user_record}(all) =~ /^outbound$/ break=never
206. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
207. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${call_direction}() =~ /^local$/ break=never
208. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${from_user_record}(all) =~ /^local$/ break=never
209. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [user_record] ${record_session}(true) =~ /^true$/ break=on-false
210. Dialplan: sofia/internal_old/14451@fs.mindc.co Action export(nolocal:api_on_answer=uuid_record ${uuid} start ${recordings_dir}/${domain_name}/archive/${strftime(%Y)}/${strftime(%b)}/${strftime(%d)}/${uuid}.${record_ext})
211. Dialplan: sofia/internal_old/14451@fs.mindc.co parsing [fs.mindc.co->redial] continue=true
212. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [redial] destination_number(0523838030) =~ /^(redial|\*870)$/ break=on-true
213. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [redial] destination_number(0523838030) =~ /^(redial|\*870)$/ break=on-true
214. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [redial] () =~ // break=never
215. Dialplan: sofia/internal_old/14451@fs.mindc.co Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
216. Dialplan: sofia/internal_old/14451@fs.mindc.co parsing [fs.mindc.co->local_numbers] continue=false
217. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [local_numbers] destination_number(0523838030) =~ //0(2|3|4|8|9)(\d{7})// break=on-false
218. Dialplan: sofia/internal_old/14451@fs.mindc.co parsing [fs.mindc.co->mobile_numbers] continue=false
219. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [mobile_numbers] context(fs.mindc.co) =~ /fs.mindc.co/ break=on-false
220. Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [mobile_numbers] destination_number(0523838030) =~ /^0([5]\d{8})$/ break=on-false
221. Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(sip_h_X-accountcode=${accountcode})
222. Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(call_direction=outbound)
223. Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(hangup_after_bridge=true)
224. Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(_effective_caller_id_name=${effective_caller_id_name})
225. Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(effective_caller_id_number=0737392826)
226. Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(inherit_codec=true)
227. Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(ignore_display_updates=true)
228. Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(callee_id_number=0523838030)
229. Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(continue_on_fail=true)
230. Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(hangup_after_bridge=true)
231. Dialplan: sofia/internal_old/14451@fs.mindc.co Action sched_hangup(+1800 allotted_timeout)
232. Dialplan: sofia/internal_old/14451@fs.mindc.co Action export(_sip_from_uri=${outbound_caller_id_number}@${external_sip_ip})
233. Dialplan: sofia/internal_old/14451@fs.mindc.co Action bridge(sofia/gateway/0882e632-95b7-44f7-a7a1-75a7e638f2df/0523838030)
234. Dialplan: sofia/internal_old/14451@fs.mindc.co Action bridge(sofia/gateway/6a14be4d-af77-4d45-9796-7aedad6185a4/0523838030)
235. 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:286 (sofia/internal_old/14451@fs.mindc.co) State Change CS_ROUTING -> CS_EXECUTE
236. 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:643 (sofia/internal_old/14451@fs.mindc.co) State ROUTING going to sleep
237. 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:584 (sofia/internal_old/14451@fs.mindc.co) Running State Change CS_EXECUTE
238. 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:650 (sofia/internal_old/14451@fs.mindc.co) State EXECUTE
239. 2017-03-30 19:20:30.700944 [DEBUG] mod_sofia.c:198 sofia/internal_old/14451@fs.mindc.co SOFIA EXECUTE
240. 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:328 sofia/internal_old/14451@fs.mindc.co Standard EXECUTE
241. EXECUTE sofia/internal_old/14451@fs.mindc.co export(origination_callee_id_name=0523838030)
242. 2017-03-30 19:20:30.700944 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [origination_callee_id_name]=[0523838030]
243. EXECUTE sofia/internal_old/14451@fs.mindc.co set(RFC2822_DATE=Thu, 30 Mar 2017 19:20:30 +0300)
244. 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [RFC2822_DATE]=[Thu, 30 Mar 2017 19:20:30 +0300]
245. EXECUTE sofia/internal_old/14451@fs.mindc.co set(call_direction=local)
246. 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [call_direction]=[local]
247. EXECUTE sofia/internal_old/14451@fs.mindc.co export(nolocal:api_on_answer=uuid_record 131b4280-8834-4deb-923d-afca926d4463 start /var/lib/freeswitch/recordings/fs.mindc.co/archive/2017/Mar/30/131b4280-8834-4deb-923d-afca926d4463.mp3)
248. 2017-03-30 19:20:30.700944 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) (REMOTE ONLY) [api_on_answer]=[uuid_record 131b4280-8834-4deb-923d-afca926d4463 start /var/lib/freeswitch/recordings/fs.mindc.co/archive/2017/Mar/30/131b4280-8834-4deb-923d-afca926d4463.mp3]
249. EXECUTE sofia/internal_old/14451@fs.mindc.co hash(insert/fs.mindc.co-last_dial/14451/0523838030)
250. EXECUTE sofia/internal_old/14451@fs.mindc.co set(sip_h_X-accountcode=fs.mindc.co)
251. 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [sip_h_X-accountcode]=[fs.mindc.co]
252. EXECUTE sofia/internal_old/14451@fs.mindc.co set(call_direction=outbound)
253. 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [call_direction]=[outbound]
254. EXECUTE sofia/internal_old/14451@fs.mindc.co set(hangup_after_bridge=true)
255. 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [hangup_after_bridge]=[true]
256. EXECUTE sofia/internal_old/14451@fs.mindc.co set(_effective_caller_id_name=)
257. 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [_effective_caller_id_name]=[UNDEF]
258. EXECUTE sofia/internal_old/14451@fs.mindc.co set(effective_caller_id_number=0737392826)
259. 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [effective_caller_id_number]=[0737392826]
260. EXECUTE sofia/internal_old/14451@fs.mindc.co set(inherit_codec=true)
261. 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [inherit_codec]=[true]
262. EXECUTE sofia/internal_old/14451@fs.mindc.co set(ignore_display_updates=true)
263. 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [ignore_display_updates]=[true]
264. EXECUTE sofia/internal_old/14451@fs.mindc.co set(callee_id_number=0523838030)
265. 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [callee_id_number]=[0523838030]
266. EXECUTE sofia/internal_old/14451@fs.mindc.co set(continue_on_fail=true)
267. 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [continue_on_fail]=[true]
268. EXECUTE sofia/internal_old/14451@fs.mindc.co set(hangup_after_bridge=true)
269. 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [hangup_after_bridge]=[true]
270. EXECUTE sofia/internal_old/14451@fs.mindc.co sched_hangup(+1800 allotted_timeout)
271. 2017-03-30 19:20:30.700944 [DEBUG] switch_scheduler.c:249 Added task 27477 switch_ivr_schedule_hangup (131b4280-8834-4deb-923d-afca926d4463) to run at 1490892630
272. EXECUTE sofia/internal_old/14451@fs.mindc.co export(_sip_from_uri=@199.203.140.46)
273. 2017-03-30 19:20:30.700944 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [_sip_from_uri]=[@199.203.140.46]
274. EXECUTE sofia/internal_old/14451@fs.mindc.co bridge(sofia/gateway/0882e632-95b7-44f7-a7a1-75a7e638f2df/0523838030)
275. 2017-03-30 19:20:30.700944 [DEBUG] switch_channel.c:1250 sofia/internal_old/14451@fs.mindc.co EXPORTING[export_vars] [domain_name]=[fs.mindc.co] to event
276. 2017-03-30 19:20:30.700944 [DEBUG] switch_channel.c:1250 sofia/internal_old/14451@fs.mindc.co EXPORTING[export_vars] [origination_callee_id_name]=[0523838030] to event
277. 2017-03-30 19:20:30.700944 [DEBUG] switch_channel.c:1250 sofia/internal_old/14451@fs.mindc.co EXPORTING[export_vars] [api_on_answer]=[uuid_record 131b4280-8834-4deb-923d-afca926d4463 start /var/lib/freeswitch/recordings/fs.mindc.co/archive/2017/Mar/30/131b4280-8834-4deb-923d-afca926d4463.mp3] to event
278. 2017-03-30 19:20:30.700944 [DEBUG] switch_channel.c:1250 sofia/internal_old/14451@fs.mindc.co EXPORTING[export_vars] [_sip_from_uri]=[@199.203.140.46] to event
279. 2017-03-30 19:20:30.700944 [DEBUG] switch_ivr_originate.c:2138 Parsing global variables
280. 2017-03-30 19:20:30.700944 [NOTICE] switch_channel.c:1104 New Channel sofia/external/0523838030 [c1b3d560-4342-4c15-bc5f-782d594616ad]
281. 2017-03-30 19:20:30.700944 [DEBUG] mod_sofia.c:4753 (sofia/external/0523838030) State Change CS_NEW -> CS_INIT
282. 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:584 (sofia/external/0523838030) Running State Change CS_INIT
283. 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:627 (sofia/external/0523838030) State INIT
284. 2017-03-30 19:20:30.700944 [DEBUG] mod_sofia.c:90 sofia/external/0523838030 SOFIA INIT
285. 2017-03-30 19:20:30.700944 [DEBUG] sofia_glue.c:1282 sofia/external/0523838030 sending invite version: 1.6.12 -20-b91a0a6 64bit
286. Local SDP:
287. v=0
288. o=FreeSWITCH 1490864090 1490864091 IN IP4 199.203.140.46
289. s=FreeSWITCH
290. c=IN IP4 199.203.140.46
291. t=0 0
292. m=audio 26740 RTP/AVP 0 8 101 13
293. a=rtpmap:0 PCMU/8000
294. a=rtpmap:8 PCMA/8000
295. a=rtpmap:101 telephone-event/8000
296. a=fmtp:101 0-16
297. a=rtpmap:13 CN/8000
298. a=ptime:20
299. a=sendrecv
300.  
301. 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:40 sofia/external/0523838030 Standard INIT
302. 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:48 (sofia/external/0523838030) State Change CS_INIT -> CS_ROUTING
303. 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:627 (sofia/external/0523838030) State INIT going to sleep
304. 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:584 (sofia/external/0523838030) Running State Change CS_ROUTING
305. 2017-03-30 19:20:30.700944 [DEBUG] sofia.c:6965 Channel sofia/external/0523838030 entering state [calling][0]
306. 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:643 (sofia/external/0523838030) State ROUTING
307. 2017-03-30 19:20:30.700944 [DEBUG] mod_sofia.c:143 sofia/external/0523838030 SOFIA ROUTING
308. 2017-03-30 19:20:30.700944 [DEBUG] switch_ivr_originate.c:67 (sofia/external/0523838030) State Change CS_ROUTING -> CS_CONSUME_MEDIA
309. 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:643 (sofia/external/0523838030) State ROUTING going to sleep
310. 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:584 (sofia/external/0523838030) Running State Change CS_CONSUME_MEDIA
311. 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:662 (sofia/external/0523838030) State CONSUME_MEDIA
312. 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:662 (sofia/external/0523838030) State CONSUME_MEDIA going to sleep
313. 2017-03-30 19:20:31.680945 [DEBUG] sofia.c:6965 Channel sofia/external/0523838030 entering state [proceeding][183]
314. 2017-03-30 19:20:31.680945 [DEBUG] sofia.c:6975 Remote SDP:
315. v=0
316. o=Sonus_UAC 26586 18988 IN IP4 82.166.66.43
317. s=SIP Media Capabilities
318. c=IN IP4 82.166.66.33
319. t=0 0
320. m=audio 7554 RTP/AVP 0 101
321. a=rtpmap:0 PCMU/8000
322. a=rtpmap:101 telephone-event/8000
323. a=fmtp:101 0-15
324.  
325. 2017-03-30 19:20:31.680945 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
326. 2017-03-30 19:20:31.680945 [DEBUG] switch_core_media.c:4366 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
327. 2017-03-30 19:20:31.680945 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
328. 2017-03-30 19:20:31.680945 [DEBUG] switch_core_media.c:4227 Set telephone-event payload to 101@8000
329. 2017-03-30 19:20:31.680945 [DEBUG] switch_core_media.c:3021 Set Codec sofia/external/0523838030 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
330. 2017-03-30 19:20:31.680945 [DEBUG] switch_core_codec.c:111 sofia/external/0523838030 Original read codec set to PCMU:0
331. 2017-03-30 19:20:31.680945 [DEBUG] switch_core_media.c:4572 Set telephone-event payload to 101@8000
332. 2017-03-30 19:20:31.680945 [DEBUG] switch_core_media.c:4631 sofia/external/0523838030 Set 2833 dtmf send payload to 101 recv payload to 101
333. 2017-03-30 19:20:31.680945 [DEBUG] switch_core_media.c:6588 AUDIO RTP [sofia/external/0523838030] 10.0.0.46 port 26740 -> 82.166.66.33 port 7554 codec: 0 ms: 20
334. 2017-03-30 19:20:31.680945 [DEBUG] switch_rtp.c:3875 Starting timer [soft] 160 bytes per 20ms
335. 2017-03-30 19:20:31.680945 [DEBUG] switch_core_media.c:6887 sofia/external/0523838030 Set 2833 dtmf send payload to 101
336. 2017-03-30 19:20:31.680945 [DEBUG] switch_core_media.c:6894 sofia/external/0523838030 Set 2833 dtmf receive payload to 101
337. 2017-03-30 19:20:31.680945 [DEBUG] switch_core_media.c:6917 sofia/external/0523838030 Set rtp dtmf delay to 40
338. 2017-03-30 19:20:31.680945 [NOTICE] sofia_media.c:92 Pre-Answer sofia/external/0523838030!
339. 2017-03-30 19:20:31.680945 [DEBUG] switch_channel.c:3471 (sofia/external/0523838030) Callstate Change DOWN -> EARLY
340. 2017-03-30 19:20:31.680945 [DEBUG] switch_ivr_originate.c:410 Setting codec string on sofia/internal_old/14451@fs.mindc.co to PCMU@8000h@20i
341. 2017-03-30 19:20:31.740945 [INFO] switch_ivr_originate.c:3635 Sending early media
342. 2017-03-30 19:20:31.740945 [DEBUG] switch_core_media.c:6588 AUDIO RTP [sofia/internal_old/14451@fs.mindc.co] 10.0.0.46 port 17294 -> 81.218.146.180 port 55975 codec: 0 ms: 20
343. 2017-03-30 19:20:31.740945 [DEBUG] switch_rtp.c:3875 Starting timer [soft] 160 bytes per 20ms
344. 2017-03-30 19:20:31.740945 [INFO] switch_core_media.c:6763 Activating Audio ICE
345. 2017-03-30 19:20:31.740945 [NOTICE] switch_rtp.c:4364 Activating RTP audio ICE: NsA1:plI0Yryx91mbOYFX 81.218.146.180:55975
346. 2017-03-30 19:20:31.740945 [DEBUG] switch_core_media.c:6806 Activating RTCP PORT 55975
347. 2017-03-30 19:20:31.740945 [DEBUG] switch_rtp.c:4261 RTCP send rate is: 5000 and packet rate is: 20000 Remote Port: 55975
348. 2017-03-30 19:20:31.740945 [INFO] switch_core_media.c:6814 Skipping RTCP ICE (Same as RTP)
349. 2017-03-30 19:20:31.740945 [INFO] switch_rtp.c:3368 Activate RTP/RTCP audio DTLS client
350. 2017-03-30 19:20:31.740945 [INFO] switch_rtp.c:3502 Changing audio DTLS state from OFF to HANDSHAKE
351. 2017-03-30 19:20:31.740945 [DEBUG] switch_core_media.c:6887 sofia/internal_old/14451@fs.mindc.co Set 2833 dtmf send payload to 126
352. 2017-03-30 19:20:31.740945 [DEBUG] switch_core_media.c:6894 sofia/internal_old/14451@fs.mindc.co Set 2833 dtmf receive payload to 126
353. 2017-03-30 19:20:31.740945 [DEBUG] switch_core_media.c:6917 sofia/internal_old/14451@fs.mindc.co Set rtp dtmf delay to 40
354. 2017-03-30 19:20:31.740945 [DEBUG] switch_core_media.c:6923 Set comfort noise payload to 13
355. 2017-03-30 19:20:31.740945 [DEBUG] mod_sofia.c:2307 Ring SDP:
356. v=0
357. o=FreeSWITCH 1490873537 1490873538 IN IP4 199.203.140.46
358. s=FreeSWITCH
359. c=IN IP4 199.203.140.46
360. t=0 0
361. a=msid-semantic: WMS AvlxU2WxDvwlo5kdXT6mLMSHIRDYcXMD
362. m=audio 17294 UDP/TLS/RTP/SAVPF 0 126 13
363. a=rtpmap:0 PCMU/8000
364. a=rtpmap:126 telephone-event/8000
365. a=rtpmap:13 CN/8000
366. a=ptime:20
367. a=sendrecv
368. a=fingerprint:sha-256 DA:15:3C:2F:CC:74:4A:10:20:11:B4:90:59:E6:71:77:7A:91:98:93:78:0B:96:A3:FF:22:2A:19:43:11:BA:08
369. a=setup:active
370. a=rtcp-mux
371. a=rtcp:17294 IN IP4 199.203.140.46
372. a=ice-ufrag:plI0Yryx91mbOYFX
373. a=ice-pwd:MvQr87B6KWijsyFHKeyzvWXu
374. a=candidate:7171139242 1 udp 659136 199.203.140.46 17294 typ host generation 0
375. a=end-of-candidates
376. a=ssrc:3571550670 cname:iX03PMqj7NvmIFpw
377. a=ssrc:3571550670 msid:AvlxU2WxDvwlo5kdXT6mLMSHIRDYcXMD a0
378. a=ssrc:3571550670 mslabel:AvlxU2WxDvwlo5kdXT6mLMSHIRDYcXMD
379. a=ssrc:3571550670 label:AvlxU2WxDvwlo5kdXT6mLMSHIRDYcXMDa0
380.  
381. 2017-03-30 19:20:31.740945 [NOTICE] mod_sofia.c:2310 Pre-Answer sofia/internal_old/14451@fs.mindc.co!
382. 2017-03-30 19:20:31.740945 [DEBUG] switch_channel.c:3471 (sofia/internal_old/14451@fs.mindc.co) Callstate Change RINGING -> EARLY
383. 2017-03-30 19:20:31.740945 [DEBUG] switch_ivr_originate.c:3686 Originate Resulted in Success: [sofia/external/0523838030]
384. 2017-03-30 19:20:31.740945 [DEBUG] sofia.c:6965 Channel sofia/internal_old/14451@fs.mindc.co entering state [early][183]
385. 2017-03-30 19:20:31.740945 [DEBUG] switch_ivr_bridge.c:1522 (sofia/external/0523838030) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
386. 2017-03-30 19:20:31.740945 [DEBUG] switch_core_state_machine.c:584 (sofia/external/0523838030) Running State Change CS_EXCHANGE_MEDIA
387. 2017-03-30 19:20:31.740945 [DEBUG] switch_core_state_machine.c:653 (sofia/external/0523838030) State EXCHANGE_MEDIA
388. 2017-03-30 19:20:31.740945 [DEBUG] mod_sofia.c:631 SOFIA EXCHANGE_MEDIA
389. 2017-03-30 19:20:31.780945 [DEBUG] switch_rtp.c:6963 Correct audio ip/port confirmed.
390. 2017-03-30 19:20:31.900952 [INFO] switch_rtp.c:3159 Changing audio DTLS state from HANDSHAKE to SETUP
391. 2017-03-30 19:20:31.900952 [INFO] switch_rtp.c:3068 audio Fingerprint Verified.
392. 2017-03-30 19:20:31.900952 [INFO] switch_rtp.c:3687 Activating Audio Secure RTP SEND
393. 2017-03-30 19:20:31.900952 [INFO] switch_rtp.c:3665 Activating Audio Secure RTP RECV
394. 2017-03-30 19:20:31.900952 [INFO] switch_rtp.c:3108 Changing audio DTLS state from SETUP to READY
395. 2017-03-30 19:20:31.900952 [DEBUG] switch_core_sqldb.c:2612 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80
396. 2017-03-30 19:20:31.900952 [DEBUG] switch_core_sqldb.c:2612 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80
397. 2017-03-30 19:20:31.980945 [DEBUG] switch_rtp.c:1875 rtcp_stats_init: audio ssrc[601562311] base_seq[19018]
398. 2017-03-30 19:20:33.640971 [DEBUG] sofia.c:6965 Channel sofia/external/0523838030 entering state [proceeding][183]
399. 2017-03-30 19:20:33.640971 [DEBUG] sofia.c:6972 Duplicate SDP
400. v=0
401. o=Sonus_UAC 26586 18988 IN IP4 82.166.66.43
402. s=SIP Media Capabilities
403. c=IN IP4 82.166.66.33
404. t=0 0
405. m=audio 7554 RTP/AVP 0 101
406. a=rtpmap:0 PCMU/8000
407. a=rtpmap:101 telephone-event/8000
408. a=fmtp:101 0-15
409.  
410. 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
411. 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4366 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
412. 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
413. 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4227 Set telephone-event payload to 101@8000
414. 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4572 Set telephone-event payload to 101@8000
415. 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4631 sofia/external/0523838030 Set 2833 dtmf send payload to 101 recv payload to 101
416. 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:6571 Audio params are unchanged for sofia/external/0523838030.
417. 2017-03-30 19:20:33.640971 [DEBUG] sofia.c:6965 Channel sofia/external/0523838030 entering state [proceeding][180]
418. 2017-03-30 19:20:33.640971 [DEBUG] sofia.c:6972 Duplicate SDP
419. v=0
420. o=Sonus_UAC 26586 18988 IN IP4 82.166.66.43
421. s=SIP Media Capabilities
422. c=IN IP4 82.166.66.33
423. t=0 0
424. m=audio 7554 RTP/AVP 0 101
425. a=rtpmap:0 PCMU/8000
426. a=rtpmap:101 telephone-event/8000
427. a=fmtp:101 0-15
428.  
429. 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
430. 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4366 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
431. 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
432. 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4227 Set telephone-event payload to 101@8000
433. 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4572 Set telephone-event payload to 101@8000
434. 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4631 sofia/external/0523838030 Set 2833 dtmf send payload to 101 recv payload to 101
435. 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:6571 Audio params are unchanged for sofia/external/0523838030.
436.