From FSLogger, 6 Years ago, written in Plain Text.
- view diff
Embed
  1. [m[33m[44m.=======================================================.
  2. |            _____ ____     ____ _     ___              |
  3. |           |  ___/ ___|   / ___| |   |_ _|             |
  4. |           | |_  \___ \  | |   | |    | |              |
  5. |           |  _|  ___) | | |___| |___ | |              |
  6. |           |_|   |____/   \____|_____|___|             |
  7. |                                                       |
  8. .=======================================================.
  9. | Anthony Minessale II, Ken Rice,                       |
  10. | Michael Jerris, Travis Cross                          |
  11. | FreeSWITCH (http://www.freeswitch.org)                |
  12. | Paypal Donations Appreciated: paypal@freeswitch.org   |
  13. | Brought to you by ClueCon http://www.cluecon.com/     |
  14. .=======================================================.
  15.  
  16. .===============================================================.
  17. |       _                                                       |
  18. |   ___| |_   _  ___  ___ ___  _ __         ___ ___  _ __ ___   |
  19. |  / __| | | | |/ _ \/ __/ _ \| '_ \       / __/ _ \| '_ ` _ \  |
  20. | | (__| | |_| |  __/ (_| (_) | | | |  _  | (_| (_) | | | | | | |
  21. |  \___|_|\__,_|\___|\___\___/|_| |_| (_)  \___\___/|_| |_| |_| |
  22. |                                                               |
  23. .===============================================================.
  24. [m
  25. Type /help <enter> to see a list of commands
  26.  
  27.  
  28.  
  29. [m
  30. [This app Best viewed at 160x60 or more..]
  31. +OK log level 7 [7]
  32. freeswitch@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.