From Francesco Facco de Lagarda, 1 Week ago, written in Plain Text.
- view diff
Embed
  1. 2018-12-05 21:21:31.766191 [NOTICE] switch_channel.c:1104 New Channel sofia/external/06412213225@192.168.1.230:5060 [6c61794b-cbfa-477f-95cc-ba006e03b6e5]
  2. 2018-12-05 21:21:31.766191 [DEBUG] switch_core_state_machine.c:584 (sofia/external/06412213225@192.168.1.230:5060) Running State Change CS_NEW (Cur 1 Tot 4)
  3. 2018-12-05 21:21:31.766191 [DEBUG] sofia.c:9873 sofia/external/06412213225@192.168.1.230:5060 receiving invite from 192.168.1.230:5060 version: 1.6.20 -37-987c9b9 64bit
  4. 2018-12-05 21:21:31.766191 [DEBUG] sofia.c:7084 Channel sofia/external/06412213225@192.168.1.230:5060 entering state [received][100]
  5. 2018-12-05 21:21:31.766191 [DEBUG] sofia.c:7094 Remote SDP:
  6. v=0
  7. o=MxSIP 0 43 IN IP4 192.168.1.230
  8. s=SIP Call
  9. c=IN IP4 192.168.1.230
  10. t=0 0
  11. m=audio 4906 RTP/AVP 8 0 101
  12. a=rtpmap:8 PCMA/8000
  13. a=rtpmap:0 PCMU/8000
  14. a=rtpmap:101 telephone-event/8000
  15. a=fmtp:101 0-16
  16.  
  17. 2018-12-05 21:21:31.766191 [DEBUG] sofia.c:7486 (sofia/external/06412213225@192.168.1.230:5060) State Change CS_NEW -> CS_INIT
  18. 2018-12-05 21:21:31.766191 [DEBUG] switch_core_state_machine.c:603 (sofia/external/06412213225@192.168.1.230:5060) State NEW
  19. 2018-12-05 21:21:31.766191 [DEBUG] switch_core_state_machine.c:584 (sofia/external/06412213225@192.168.1.230:5060) Running State Change CS_INIT (Cur 1 Tot 4)
  20. 2018-12-05 21:21:31.766191 [DEBUG] switch_core_state_machine.c:627 (sofia/external/06412213225@192.168.1.230:5060) State INIT
  21. 2018-12-05 21:21:31.766191 [DEBUG] mod_sofia.c:90 sofia/external/06412213225@192.168.1.230:5060 SOFIA INIT
  22. 2018-12-05 21:21:31.766191 [DEBUG] switch_core_state_machine.c:40 sofia/external/06412213225@192.168.1.230:5060 Standard INIT
  23. 2018-12-05 21:21:31.766191 [DEBUG] switch_core_state_machine.c:48 (sofia/external/06412213225@192.168.1.230:5060) State Change CS_INIT -> CS_ROUTING
  24. 2018-12-05 21:21:31.766191 [DEBUG] switch_core_state_machine.c:627 (sofia/external/06412213225@192.168.1.230:5060) State INIT going to sleep
  25. 2018-12-05 21:21:31.766191 [DEBUG] switch_core_state_machine.c:584 (sofia/external/06412213225@192.168.1.230:5060) Running State Change CS_ROUTING (Cur 1 Tot 4)
  26. 2018-12-05 21:21:31.766191 [DEBUG] switch_channel.c:2249 (sofia/external/06412213225@192.168.1.230:5060) Callstate Change DOWN -> RINGING
  27. 2018-12-05 21:21:31.766191 [DEBUG] switch_core_state_machine.c:643 (sofia/external/06412213225@192.168.1.230:5060) State ROUTING
  28. 2018-12-05 21:21:31.766191 [DEBUG] mod_sofia.c:143 sofia/external/06412213225@192.168.1.230:5060 SOFIA ROUTING
  29. 2018-12-05 21:21:31.766191 [DEBUG] switch_core_state_machine.c:236 sofia/external/06412213225@192.168.1.230:5060 Standard ROUTING
  30. 2018-12-05 21:21:31.766191 [INFO] mod_dialplan_xml.c:637 Processing 06412213225 <06412213225>->064114551 in context public
  31. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [public->unloop] continue=false
  32. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
  33. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
  34. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [public->outside_call] continue=true
  35. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Absolute Condition [outside_call]
  36. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action set(outside_call=true)
  37. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
  38. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [public->call_debug] continue=true
  39. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never
  40. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [public->public_extensions] continue=false
  41. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [public_extensions] destination_number(064114551) =~ /^(10[01][0-9])$/ break=on-false
  42. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [public->public_did] continue=false
  43. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (PASS) [public_did] destination_number(064114551) =~ /^(064114551)$/ break=on-false
  44. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action set(domain_name=192.168.1.234)
  45. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action transfer(400 XML default)
  46. 2018-12-05 21:21:31.766191 [DEBUG] switch_core_state_machine.c:286 (sofia/external/06412213225@192.168.1.230:5060) State Change CS_ROUTING -> CS_EXECUTE
  47. 2018-12-05 21:21:31.766191 [DEBUG] switch_core_state_machine.c:643 (sofia/external/06412213225@192.168.1.230:5060) State ROUTING going to sleep
  48. 2018-12-05 21:21:31.766191 [DEBUG] switch_core_state_machine.c:584 (sofia/external/06412213225@192.168.1.230:5060) Running State Change CS_EXECUTE (Cur 1 Tot 4)
  49. 2018-12-05 21:21:31.766191 [DEBUG] switch_core_state_machine.c:650 (sofia/external/06412213225@192.168.1.230:5060) State EXECUTE
  50. 2018-12-05 21:21:31.766191 [DEBUG] mod_sofia.c:198 sofia/external/06412213225@192.168.1.230:5060 SOFIA EXECUTE
  51. 2018-12-05 21:21:31.766191 [DEBUG] switch_core_state_machine.c:328 sofia/external/06412213225@192.168.1.230:5060 Standard EXECUTE
  52. EXECUTE sofia/external/06412213225@192.168.1.230:5060 set(outside_call=true)
  53. 2018-12-05 21:21:31.766191 [DEBUG] mod_dptools.c:1548 SET sofia/external/06412213225@192.168.1.230:5060 [outside_call]=[true]
  54. EXECUTE sofia/external/06412213225@192.168.1.230:5060 export(RFC2822_DATE=Wed, 05 Dec 2018 21:21:31 +0100)
  55. 2018-12-05 21:21:31.766191 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [RFC2822_DATE]=[Wed, 05 Dec 2018 21:21:31 +0100]
  56. EXECUTE sofia/external/06412213225@192.168.1.230:5060 set(domain_name=192.168.1.234)
  57. 2018-12-05 21:21:31.766191 [DEBUG] mod_dptools.c:1548 SET sofia/external/06412213225@192.168.1.230:5060 [domain_name]=[192.168.1.234]
  58. EXECUTE sofia/external/06412213225@192.168.1.230:5060 transfer(400 XML default)
  59. 2018-12-05 21:21:31.786086 [DEBUG] switch_ivr.c:2165 (sofia/external/06412213225@192.168.1.230:5060) State Change CS_EXECUTE -> CS_ROUTING
  60. 2018-12-05 21:21:31.786086 [NOTICE] switch_ivr.c:2172 Transfer sofia/external/06412213225@192.168.1.230:5060 to XML[400@default]
  61. 2018-12-05 21:21:31.786086 [DEBUG] switch_core_state_machine.c:650 (sofia/external/06412213225@192.168.1.230:5060) State EXECUTE going to sleep
  62. 2018-12-05 21:21:31.786086 [DEBUG] switch_core_state_machine.c:584 (sofia/external/06412213225@192.168.1.230:5060) Running State Change CS_ROUTING (Cur 1 Tot 4)
  63. 2018-12-05 21:21:31.786086 [DEBUG] switch_core_state_machine.c:643 (sofia/external/06412213225@192.168.1.230:5060) State ROUTING
  64. 2018-12-05 21:21:31.786086 [DEBUG] mod_sofia.c:143 sofia/external/06412213225@192.168.1.230:5060 SOFIA ROUTING
  65. 2018-12-05 21:21:31.786086 [DEBUG] switch_core_state_machine.c:236 sofia/external/06412213225@192.168.1.230:5060 Standard ROUTING
  66. 2018-12-05 21:21:31.786086 [INFO] mod_dialplan_xml.c:637 Processing 06412213225 <06412213225>->400 in context default
  67. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->unloop] continue=false
  68. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
  69. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
  70. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->tod_example] continue=true
  71. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Date/TimeMatch (FAIL) [tod_example] break=on-false
  72. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->holiday_example] continue=true
  73. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Date/TimeMatch (FAIL) [holiday_example] break=on-false
  74. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->global-intercept] continue=false
  75. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [global-intercept] destination_number(400) =~ /^886$/ break=on-false
  76. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->group-intercept] continue=false
  77. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [group-intercept] destination_number(400) =~ /^\*8$/ break=on-false
  78. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->intercept-ext] continue=false
  79. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [intercept-ext] destination_number(400) =~ /^\*\*(\d+)$/ break=on-false
  80. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->redial] continue=false
  81. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [redial] destination_number(400) =~ /^(redial|870)$/ break=on-false
  82. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->global] continue=true
  83. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never
  84. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [global] ${default_password}(passw0rd) =~ /^1234$/ break=never
  85. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [global] ${rtp_has_crypto}() =~ /^(AEAD_AES_256_GCM_8|AEAD_AES_128_GCM_8|AES_CM_256_HMAC_SHA1_80|AES_CM_192_HMAC_SHA1_80|AES_CM_128_HMAC_SHA1_80|AES_CM_256_HMAC_SHA1_32|AES_CM_192_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_32|AES_CM_128_NULL_AUTH)$/ break=never
  86. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (PASS) [global] ${endpoint_disposition}(DELAYED NEGOTIATION) =~ /^(DELAYED NEGOTIATION)/ break=on-false
  87. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [global] ${switch_r_sdp}(v=0
  88. o=MxSIP 0 43 IN IP4 192.168.1.230
  89. s=SIP Call
  90. c=IN IP4 192.168.1.230
  91. t=0 0
  92. m=audio 4906 RTP/AVP 8 0 101
  93. a=rtpmap:8 PCMA/8000
  94. a=rtpmap:0 PCMU/8000
  95. a=rtpmap:101 telephone-event/8000
  96. a=fmtp:101 0-16
  97. ) =~ /(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)/ break=never
  98. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Absolute Condition [global]
  99. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid})
  100. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
  101. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action hash(insert/${domain_name}-last_dial/global/${uuid})
  102. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
  103. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->t3block] continue=false
  104. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [t3block] destination_number(400) =~ /^66$/ break=on-false
  105. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->tvision1] continue=false
  106. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [tvision1] destination_number(400) =~ /^9111$/ break=on-false
  107. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->playMOH] continue=false
  108. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [playMOH] destination_number(400) =~ /^9211$/ break=on-false
  109. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->tvision2] continue=false
  110. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [tvision2] destination_number(400) =~ /^9112$/ break=on-false
  111. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->tvisionConf] continue=false
  112. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [tvisionConf] destination_number(400) =~ /^9113$/ break=on-false
  113. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->tvTest] continue=false
  114. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [tvTest] destination_number(400) =~ /^9114$/ break=on-false
  115. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->digitsIT] continue=false
  116. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [digitsIT] destination_number(400) =~ /^9119$/ break=on-false
  117. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->hello_world] continue=false
  118. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [hello_world] destination_number(400) =~ /^9022$/ break=on-false
  119. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->snom-demo-2] continue=false
  120. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [snom-demo-2] destination_number(400) =~ /^9001$/ break=on-false
  121. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->snom-demo-1] continue=false
  122. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [snom-demo-1] destination_number(400) =~ /^9000$/ break=on-false
  123. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->eavesdrop] continue=false
  124. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [eavesdrop] destination_number(400) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false
  125. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->eavesdrop] continue=false
  126. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [eavesdrop] destination_number(400) =~ /^779$/ break=on-false
  127. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->call_return] continue=false
  128. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [call_return] destination_number(400) =~ /^\*69$|^869$|^lcr$/ break=on-false
  129. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->del-group] continue=false
  130. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [del-group] destination_number(400) =~ /^80(\d{2})$/ break=on-false
  131. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->add-group] continue=false
  132. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [add-group] destination_number(400) =~ /^81(\d{2})$/ break=on-false
  133. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->call-group-simo] continue=false
  134. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [call-group-simo] destination_number(400) =~ /^82(\d{2})$/ break=on-false
  135. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->call-group-order] continue=false
  136. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [call-group-order] destination_number(400) =~ /^83(\d{2})$/ break=on-false
  137. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->extension-intercom] continue=false
  138. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [extension-intercom] destination_number(400) =~ /^8(10[01][0-9])$/ break=on-false
  139. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->Local_Extension] continue=false
  140. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (FAIL) [Local_Extension] destination_number(400) =~ /^(10[01][0-9])$/ break=on-false
  141. Dialplan: sofia/external/06412213225@192.168.1.230:5060 parsing [default->Local_Extension_300] continue=false
  142. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Regex (PASS) [Local_Extension_300] destination_number(400) =~ /^([3-4][0-9][0-9])$/ break=on-false
  143. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action export(dialed_extension=400)
  144. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action bind_meta_app(1 b s execute_extension::dx XML features)
  145. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action bind_meta_app(2 b s record_session::/var/lib/freeswitch/recordings/${caller_id_number}.${strftime(%Y-%m-%d-%H-%M-%S)}.wav)
  146. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action bind_meta_app(3 b s execute_extension::cf XML features)
  147. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action bind_meta_app(4 b s execute_extension::att_xfer XML features)
  148. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action set(ringback=${us-ring})
  149. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action set(transfer_ringback=local_stream://moh)
  150. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action set(call_timeout=30)
  151. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action set(hangup_after_bridge=true)
  152. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action set(continue_on_fail=true)
  153. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action hash(insert/${domain_name}-call_return/${dialed_extension}/${caller_id_number})
  154. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action hash(insert/${domain_name}-last_dial_ext/${dialed_extension}/${uuid})
  155. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action set(called_party_callgroup=${user_data(${dialed_extension}@${domain_name} var callgroup)})
  156. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action hash(insert/${domain_name}-last_dial_ext/${called_party_callgroup}/${uuid})
  157. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action hash(insert/${domain_name}-last_dial_ext/global/${uuid})
  158. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action hash(insert/${domain_name}-last_dial/${called_party_callgroup}/${uuid})
  159. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action bridge(user/${dialed_extension}@${domain_name})
  160. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action answer()
  161. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action sleep(1000)
  162. Dialplan: sofia/external/06412213225@192.168.1.230:5060 Action bridge(loopback/app=voicemail:default ${domain_name} ${dialed_extension})
  163. 2018-12-05 21:21:31.786086 [DEBUG] switch_core_state_machine.c:286 (sofia/external/06412213225@192.168.1.230:5060) State Change CS_ROUTING -> CS_EXECUTE
  164. 2018-12-05 21:21:31.786086 [DEBUG] switch_core_state_machine.c:643 (sofia/external/06412213225@192.168.1.230:5060) State ROUTING going to sleep
  165. 2018-12-05 21:21:31.786086 [DEBUG] switch_core_state_machine.c:584 (sofia/external/06412213225@192.168.1.230:5060) Running State Change CS_EXECUTE (Cur 1 Tot 4)
  166. 2018-12-05 21:21:31.786086 [DEBUG] switch_core_state_machine.c:650 (sofia/external/06412213225@192.168.1.230:5060) State EXECUTE
  167. 2018-12-05 21:21:31.786086 [DEBUG] mod_sofia.c:198 sofia/external/06412213225@192.168.1.230:5060 SOFIA EXECUTE
  168. 2018-12-05 21:21:31.786086 [DEBUG] switch_core_state_machine.c:328 sofia/external/06412213225@192.168.1.230:5060 Standard EXECUTE
  169. EXECUTE sofia/external/06412213225@192.168.1.230:5060 hash(insert/192.168.1.234-spymap/06412213225/6c61794b-cbfa-477f-95cc-ba006e03b6e5)
  170. EXECUTE sofia/external/06412213225@192.168.1.230:5060 hash(insert/192.168.1.234-last_dial/06412213225/400)
  171. EXECUTE sofia/external/06412213225@192.168.1.230:5060 hash(insert/192.168.1.234-last_dial/global/6c61794b-cbfa-477f-95cc-ba006e03b6e5)
  172. EXECUTE sofia/external/06412213225@192.168.1.230:5060 export(RFC2822_DATE=Wed, 05 Dec 2018 21:21:31 +0100)
  173. 2018-12-05 21:21:31.786086 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [RFC2822_DATE]=[Wed, 05 Dec 2018 21:21:31 +0100]
  174. EXECUTE sofia/external/06412213225@192.168.1.230:5060 export(dialed_extension=400)
  175. 2018-12-05 21:21:31.786086 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [dialed_extension]=[400]
  176. EXECUTE sofia/external/06412213225@192.168.1.230:5060 bind_meta_app(1 b s execute_extension::dx XML features)
  177. 2018-12-05 21:21:31.786086 [INFO] switch_ivr_async.c:4173 Bound B-Leg: *1 execute_extension::dx XML features
  178. EXECUTE sofia/external/06412213225@192.168.1.230:5060 bind_meta_app(2 b s record_session::/var/lib/freeswitch/recordings/06412213225.2018-12-05-21-21-31.wav)
  179. 2018-12-05 21:21:31.786086 [INFO] switch_ivr_async.c:4173 Bound B-Leg: *2 record_session::/var/lib/freeswitch/recordings/06412213225.2018-12-05-21-21-31.wav
  180. EXECUTE sofia/external/06412213225@192.168.1.230:5060 bind_meta_app(3 b s execute_extension::cf XML features)
  181. 2018-12-05 21:21:31.786086 [INFO] switch_ivr_async.c:4173 Bound B-Leg: *3 execute_extension::cf XML features
  182. EXECUTE sofia/external/06412213225@192.168.1.230:5060 bind_meta_app(4 b s execute_extension::att_xfer XML features)
  183. 2018-12-05 21:21:31.786086 [INFO] switch_ivr_async.c:4173 Bound B-Leg: *4 execute_extension::att_xfer XML features
  184. EXECUTE sofia/external/06412213225@192.168.1.230:5060 set(ringback=%(2000,4000,440,480))
  185. 2018-12-05 21:21:31.786086 [DEBUG] mod_dptools.c:1548 SET sofia/external/06412213225@192.168.1.230:5060 [ringback]=[%(2000,4000,440,480)]
  186. EXECUTE sofia/external/06412213225@192.168.1.230:5060 set(transfer_ringback=local_stream://moh)
  187. 2018-12-05 21:21:31.786086 [DEBUG] mod_dptools.c:1548 SET sofia/external/06412213225@192.168.1.230:5060 [transfer_ringback]=[local_stream://moh]
  188. EXECUTE sofia/external/06412213225@192.168.1.230:5060 set(call_timeout=30)
  189. 2018-12-05 21:21:31.786086 [DEBUG] mod_dptools.c:1548 SET sofia/external/06412213225@192.168.1.230:5060 [call_timeout]=[30]
  190. EXECUTE sofia/external/06412213225@192.168.1.230:5060 set(hangup_after_bridge=true)
  191. 2018-12-05 21:21:31.786086 [DEBUG] mod_dptools.c:1548 SET sofia/external/06412213225@192.168.1.230:5060 [hangup_after_bridge]=[true]
  192. EXECUTE sofia/external/06412213225@192.168.1.230:5060 set(continue_on_fail=true)
  193. 2018-12-05 21:21:31.786086 [DEBUG] mod_dptools.c:1548 SET sofia/external/06412213225@192.168.1.230:5060 [continue_on_fail]=[true]
  194. EXECUTE sofia/external/06412213225@192.168.1.230:5060 hash(insert/192.168.1.234-call_return/400/06412213225)
  195. EXECUTE sofia/external/06412213225@192.168.1.230:5060 hash(insert/192.168.1.234-last_dial_ext/400/6c61794b-cbfa-477f-95cc-ba006e03b6e5)
  196. EXECUTE sofia/external/06412213225@192.168.1.230:5060 set(called_party_callgroup=techsupport)
  197. 2018-12-05 21:21:31.786086 [DEBUG] mod_dptools.c:1548 SET sofia/external/06412213225@192.168.1.230:5060 [called_party_callgroup]=[techsupport]
  198. EXECUTE sofia/external/06412213225@192.168.1.230:5060 hash(insert/192.168.1.234-last_dial_ext/techsupport/6c61794b-cbfa-477f-95cc-ba006e03b6e5)
  199. EXECUTE sofia/external/06412213225@192.168.1.230:5060 hash(insert/192.168.1.234-last_dial_ext/global/6c61794b-cbfa-477f-95cc-ba006e03b6e5)
  200. EXECUTE sofia/external/06412213225@192.168.1.230:5060 hash(insert/192.168.1.234-last_dial/techsupport/6c61794b-cbfa-477f-95cc-ba006e03b6e5)
  201. EXECUTE sofia/external/06412213225@192.168.1.230:5060 bridge(user/400@192.168.1.234)
  202. 2018-12-05 21:21:31.786086 [DEBUG] switch_channel.c:1250 sofia/external/06412213225@192.168.1.230:5060 EXPORTING[export_vars] [RFC2822_DATE]=[Wed, 05 Dec 2018 21:21:31 +0100] to event
  203. 2018-12-05 21:21:31.786086 [DEBUG] switch_channel.c:1250 sofia/external/06412213225@192.168.1.230:5060 EXPORTING[export_vars] [RFC2822_DATE]=[Wed, 05 Dec 2018 21:21:31 +0100] to event
  204. 2018-12-05 21:21:31.786086 [DEBUG] switch_channel.c:1250 sofia/external/06412213225@192.168.1.230:5060 EXPORTING[export_vars] [dialed_extension]=[400] to event
  205. 2018-12-05 21:21:31.786086 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  206. 2018-12-05 21:21:31.786086 [DEBUG] switch_channel.c:1250 sofia/external/06412213225@192.168.1.230:5060 EXPORTING[export_vars] [RFC2822_DATE]=[Wed, 05 Dec 2018 21:21:31 +0100] to event
  207. 2018-12-05 21:21:31.786086 [DEBUG] switch_channel.c:1250 sofia/external/06412213225@192.168.1.230:5060 EXPORTING[export_vars] [RFC2822_DATE]=[Wed, 05 Dec 2018 21:21:31 +0100] to event
  208. 2018-12-05 21:21:31.786086 [DEBUG] switch_channel.c:1250 sofia/external/06412213225@192.168.1.230:5060 EXPORTING[export_vars] [dialed_extension]=[400] to event
  209. 2018-12-05 21:21:31.786086 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  210. 2018-12-05 21:21:31.786086 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/400@192.168.1.249:2048 [8c440b6d-355b-42d1-bf84-ca979d0353e5]
  211. 2018-12-05 21:21:31.786086 [DEBUG] mod_sofia.c:4819 (sofia/internal/400@192.168.1.249:2048) State Change CS_NEW -> CS_INIT
  212. 2018-12-05 21:21:31.786086 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  213. 2018-12-05 21:21:31.786086 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/400@192.168.1.249:2048) Running State Change CS_INIT (Cur 2 Tot 5)
  214. 2018-12-05 21:21:31.786086 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/400@192.168.1.249:2048) State INIT
  215. 2018-12-05 21:21:31.786086 [DEBUG] mod_sofia.c:90 sofia/internal/400@192.168.1.249:2048 SOFIA INIT
  216. 2018-12-05 21:21:31.806028 [DEBUG] sofia_glue.c:1295 sofia/internal/400@192.168.1.249:2048 sending invite version: 1.6.20 -37-987c9b9 64bit
  217. Local SDP:
  218. v=0
  219. o=FreeSWITCH 1544018427 1544018428 IN IP4 192.168.1.234
  220. s=FreeSWITCH
  221. c=IN IP4 192.168.1.234
  222. t=0 0
  223. m=audio 22864 RTP/AVP 8 0 101
  224. a=rtpmap:8 PCMA/8000
  225. a=rtpmap:0 PCMU/8000
  226. a=rtpmap:101 telephone-event/8000
  227. a=fmtp:101 0-16
  228. a=ptime:20
  229. a=sendrecv
  230.  
  231. 2018-12-05 21:21:31.806028 [DEBUG] switch_core_state_machine.c:40 sofia/internal/400@192.168.1.249:2048 Standard INIT
  232. 2018-12-05 21:21:31.806028 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/400@192.168.1.249:2048) State Change CS_INIT -> CS_ROUTING
  233. 2018-12-05 21:21:31.806028 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/400@192.168.1.249:2048) State INIT going to sleep
  234. 2018-12-05 21:21:31.806028 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/400@192.168.1.249:2048) Running State Change CS_ROUTING (Cur 2 Tot 5)
  235. 2018-12-05 21:21:31.806028 [DEBUG] sofia.c:7084 Channel sofia/internal/400@192.168.1.249:2048 entering state [calling][0]
  236. 2018-12-05 21:21:31.806028 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/400@192.168.1.249:2048) State ROUTING
  237. 2018-12-05 21:21:31.806028 [DEBUG] mod_sofia.c:143 sofia/internal/400@192.168.1.249:2048 SOFIA ROUTING
  238. 2018-12-05 21:21:31.806028 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/400@192.168.1.249:2048) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  239. 2018-12-05 21:21:31.806028 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/400@192.168.1.249:2048) State ROUTING going to sleep
  240. 2018-12-05 21:21:31.806028 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/400@192.168.1.249:2048) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 5)
  241. 2018-12-05 21:21:31.806028 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/400@192.168.1.249:2048) State CONSUME_MEDIA
  242. 2018-12-05 21:21:31.806028 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/400@192.168.1.249:2048) State CONSUME_MEDIA going to sleep
  243. 2018-12-05 21:21:31.846124 [DEBUG] sofia.c:7084 Channel sofia/internal/400@192.168.1.249:2048 entering state [proceeding][180]
  244. 2018-12-05 21:21:31.846124 [NOTICE] sofia.c:7192 Ring-Ready sofia/internal/400@192.168.1.249:2048!
  245. 2018-12-05 21:21:31.846124 [DEBUG] switch_channel.c:3346 (sofia/internal/400@192.168.1.249:2048) Callstate Change DOWN -> RINGING
  246. 2018-12-05 21:21:31.866187 [INFO] switch_ivr_originate.c:1215 Sending early media
  247. 2018-12-05 21:21:31.866187 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1]
  248. 2018-12-05 21:21:31.866187 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  249. 2018-12-05 21:21:31.866187 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  250. 2018-12-05 21:21:31.866187 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  251. 2018-12-05 21:21:31.866187 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  252. 2018-12-05 21:21:31.866187 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
  253. 2018-12-05 21:21:31.866187 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  254. 2018-12-05 21:21:31.866187 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  255. 2018-12-05 21:21:31.866187 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  256. 2018-12-05 21:21:31.866187 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  257. 2018-12-05 21:21:31.866187 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
  258. 2018-12-05 21:21:31.866187 [DEBUG] switch_core_media.c:3061 Set Codec sofia/external/06412213225@192.168.1.230:5060 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
  259. 2018-12-05 21:21:31.866187 [DEBUG] switch_core_codec.c:111 sofia/external/06412213225@192.168.1.230:5060 Original read codec set to PCMA:8
  260. 2018-12-05 21:21:31.866187 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
  261. 2018-12-05 21:21:31.866187 [DEBUG] switch_core_media.c:4767 sofia/external/06412213225@192.168.1.230:5060 Set 2833 dtmf send payload to 101 recv payload to 101
  262. 2018-12-05 21:21:31.866187 [DEBUG] switch_core_media.c:6878 AUDIO RTP [sofia/external/06412213225@192.168.1.230:5060] 192.168.1.234 port 24420 -> 192.168.1.230 port 4906 codec: 8 ms: 20
  263. 2018-12-05 21:21:31.866187 [DEBUG] switch_rtp.c:4137 Starting timer [soft] 160 bytes per 20ms
  264. 2018-12-05 21:21:31.866187 [DEBUG] switch_core_media.c:7180 sofia/external/06412213225@192.168.1.230:5060 Set 2833 dtmf send payload to 101
  265. 2018-12-05 21:21:31.866187 [DEBUG] switch_core_media.c:7187 sofia/external/06412213225@192.168.1.230:5060 Set 2833 dtmf receive payload to 101
  266. 2018-12-05 21:21:31.866187 [DEBUG] switch_core_media.c:7210 sofia/external/06412213225@192.168.1.230:5060 Set rtp dtmf delay to 40
  267. 2018-12-05 21:21:31.866187 [NOTICE] sofia_media.c:92 Pre-Answer sofia/external/06412213225@192.168.1.230:5060!
  268. 2018-12-05 21:21:31.866187 [DEBUG] switch_channel.c:3474 (sofia/external/06412213225@192.168.1.230:5060) Callstate Change RINGING -> EARLY
  269. 2018-12-05 21:21:31.866187 [DEBUG] switch_core_media.c:6861 Audio params are unchanged for sofia/external/06412213225@192.168.1.230:5060.
  270. 2018-12-05 21:21:31.866187 [DEBUG] mod_sofia.c:2364 Ring SDP:
  271. v=0
  272. o=FreeSWITCH 1544016871 1544016872 IN IP4 192.168.1.234
  273. s=FreeSWITCH
  274. c=IN IP4 192.168.1.234
  275. t=0 0
  276. m=audio 24420 RTP/AVP 8 101
  277. a=rtpmap:8 PCMA/8000
  278. a=rtpmap:101 telephone-event/8000
  279. a=fmtp:101 0-16
  280. a=ptime:20
  281. a=sendrecv
  282.  
  283. 2018-12-05 21:21:31.866187 [DEBUG] switch_ivr_originate.c:1273 Raw Codec Activation Success L16@8000hz 1 channel 20ms
  284. 2018-12-05 21:21:31.866187 [DEBUG] switch_core_codec.c:223 sofia/external/06412213225@192.168.1.230:5060 Push codec L16:100
  285. 2018-12-05 21:21:31.866187 [DEBUG] switch_ivr_originate.c:1342 Play Ringback Tone [%(2000,4000,440,480)]
  286. 2018-12-05 21:21:31.886186 [DEBUG] sofia.c:7084 Channel sofia/external/06412213225@192.168.1.230:5060 entering state [early][183]
  287. 2018-12-05 21:21:32.026187 [DEBUG] switch_rtp.c:7308 Correct audio ip/port confirmed.
  288. 2018-12-05 21:21:32.346156 [DEBUG] sofia.c:7084 Channel sofia/internal/400@192.168.1.249:2048 entering state [proceeding][180]
  289. 2018-12-05 21:21:33.346088 [DEBUG] sofia.c:7084 Channel sofia/internal/400@192.168.1.249:2048 entering state [proceeding][180]
  290. 2018-12-05 21:21:33.766172 [DEBUG] sofia.c:7084 Channel sofia/external/06412213225@192.168.1.230:5060 entering state [terminated][487]
  291. 2018-12-05 21:21:33.766172 [NOTICE] sofia.c:8273 Hangup sofia/external/06412213225@192.168.1.230:5060 [CS_EXECUTE] [ORIGINATOR_CANCEL]
  292. 2018-12-05 21:21:33.766172 [DEBUG] switch_core_codec.c:248 sofia/external/06412213225@192.168.1.230:5060 Restore previous codec PCMA:8.
  293. 2018-12-05 21:21:33.766172 [NOTICE] switch_ivr_originate.c:3612 Hangup sofia/internal/400@192.168.1.249:2048 [CS_CONSUME_MEDIA] [ORIGINATOR_CANCEL]
  294. 2018-12-05 21:21:33.766172 [DEBUG] switch_ivr_originate.c:3837 Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL]
  295. 2018-12-05 21:21:33.766172 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/400@192.168.1.249:2048) Running State Change CS_HANGUP (Cur 2 Tot 5)
  296. 2018-12-05 21:21:33.766172 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/400@192.168.1.249:2048) Callstate Change RINGING -> HANGUP
  297. 2018-12-05 21:21:33.766172 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [user] cause: [ORIGINATOR_CANCEL]
  298. 2018-12-05 21:21:33.766172 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 487 [ORIGINATOR_CANCEL]
  299. 2018-12-05 21:21:33.766172 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/400@192.168.1.249:2048) State HANGUP
  300. 2018-12-05 21:21:33.766172 [DEBUG] mod_sofia.c:432 sofia/internal/400@192.168.1.249:2048 Overriding SIP cause 487 with 487 from the other leg
  301. 2018-12-05 21:21:33.766172 [DEBUG] mod_sofia.c:438 Channel sofia/internal/400@192.168.1.249:2048 hanging up, cause: ORIGINATOR_CANCEL
  302. 2018-12-05 21:21:33.766172 [INFO] mod_dptools.c:3436 Originate Failed.  Cause: ORIGINATOR_CANCEL
  303. 2018-12-05 21:21:33.766172 [DEBUG] switch_core_session.c:2815 sofia/external/06412213225@192.168.1.230:5060 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  304. 2018-12-05 21:21:33.766172 [DEBUG] switch_core_state_machine.c:650 (sofia/external/06412213225@192.168.1.230:5060) State EXECUTE going to sleep
  305. 2018-12-05 21:21:33.766172 [DEBUG] switch_core_state_machine.c:584 (sofia/external/06412213225@192.168.1.230:5060) Running State Change CS_HANGUP (Cur 2 Tot 5)
  306. 2018-12-05 21:21:33.766172 [DEBUG] switch_core_state_machine.c:850 (sofia/external/06412213225@192.168.1.230:5060) Callstate Change EARLY -> HANGUP
  307. 2018-12-05 21:21:33.766172 [DEBUG] mod_sofia.c:502 Sending CANCEL to sofia/internal/400@192.168.1.249:2048
  308. 2018-12-05 21:21:33.766172 [DEBUG] switch_core_state_machine.c:852 (sofia/external/06412213225@192.168.1.230:5060) State HANGUP
  309. 2018-12-05 21:21:33.766172 [DEBUG] mod_sofia.c:438 Channel sofia/external/06412213225@192.168.1.230:5060 hanging up, cause: ORIGINATOR_CANCEL
  310. 2018-12-05 21:21:33.766172 [DEBUG] switch_core_state_machine.c:60 sofia/external/06412213225@192.168.1.230:5060 Standard HANGUP, cause: ORIGINATOR_CANCEL
  311. 2018-12-05 21:21:33.766172 [DEBUG] switch_core_state_machine.c:852 (sofia/external/06412213225@192.168.1.230:5060) State HANGUP going to sleep
  312. 2018-12-05 21:21:33.766172 [DEBUG] switch_core_state_machine.c:60 sofia/internal/400@192.168.1.249:2048 Standard HANGUP, cause: ORIGINATOR_CANCEL
  313. 2018-12-05 21:21:33.766172 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/400@192.168.1.249:2048) State HANGUP going to sleep
  314. 2018-12-05 21:21:33.766172 [DEBUG] switch_core_state_machine.c:619 (sofia/external/06412213225@192.168.1.230:5060) State Change CS_HANGUP -> CS_REPORTING
  315. 2018-12-05 21:21:33.766172 [DEBUG] switch_core_state_machine.c:584 (sofia/external/06412213225@192.168.1.230:5060) Running State Change CS_REPORTING (Cur 2 Tot 5)
  316. 2018-12-05 21:21:33.766172 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/400@192.168.1.249:2048) State Change CS_HANGUP -> CS_REPORTING
  317. 2018-12-05 21:21:33.766172 [DEBUG] switch_core_state_machine.c:938 (sofia/external/06412213225@192.168.1.230:5060) State REPORTING
  318. 2018-12-05 21:21:33.766172 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/400@192.168.1.249:2048) Running State Change CS_REPORTING (Cur 2 Tot 5)
  319. 2018-12-05 21:21:33.766172 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/400@192.168.1.249:2048) State REPORTING
  320. 2018-12-05 21:21:33.766172 [DEBUG] mod_odbc_cdr.c:309 sql INSERT INTO cdr_table_both (CallId, TEST_id) VALUES ('8c440b6d-355b-42d1-bf84-ca979d0353e5', '06412213225@192.168.1.234')
  321. 2018-12-05 21:21:33.786032 [DEBUG] mod_odbc_cdr.c:309 sql INSERT INTO cdr_table_both (CallId, TEST_id) VALUES ('6c61794b-cbfa-477f-95cc-ba006e03b6e5', '06412213225@192.168.1.230:5060')
  322. 2018-12-05 21:21:33.846177 [DEBUG] mod_odbc_cdr.c:309 sql INSERT INTO cdr_table_b_leg (TelNumberFull, CallId, orig_id, CallerID, IP, term_id, ClientId) VALUES ('400', '6c61794b-cbfa-477f-95cc-ba006e03b6e5', '8c440b6d-355b-42d1-bf84-ca979d0353e5', '06412213225', '192.168.1.249', '320a244b-736e-1237-91a6-d485646a6cbc', '8c440b6d-355b-42d1-bf84-ca979d0353e5')
  323. 2018-12-05 21:21:33.906074 [DEBUG] mod_odbc_cdr.c:309 sql INSERT INTO cdr_table_a_leg (TelNumberFull, TelNumber, CallId, sip_endpoint_disposition, orig_id, CallerID, CODEC, sip_current_application, directGateway, IPInternal, IP, term_id, ClientId) VALUES ('064114551', '064114551', '6c61794b-cbfa-477f-95cc-ba006e03b6e5', 'EARLY MEDIA', '6c61794b-cbfa-477f-95cc-ba006e03b6e5', '06412213225', 'PCMA', 'bridge', '192.168.1.234', '192.168.1.230', '192.168.1.230', 'c0c1edea111a230a', '6c61794b-cbfa-477f-95cc-ba006e03b6e5')
  324. 2018-12-05 21:21:33.966136 [DEBUG] switch_core_state_machine.c:174 sofia/internal/400@192.168.1.249:2048 Standard REPORTING, cause: ORIGINATOR_CANCEL
  325. 2018-12-05 21:21:33.966136 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/400@192.168.1.249:2048) State REPORTING going to sleep
  326. 2018-12-05 21:21:33.966136 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/400@192.168.1.249:2048) State Change CS_REPORTING -> CS_DESTROY
  327. 2018-12-05 21:21:33.966136 [DEBUG] switch_core_session.c:1665 Session 5 (sofia/internal/400@192.168.1.249:2048) Locked, Waiting on external entities
  328. 2018-12-05 21:21:33.966136 [NOTICE] switch_core_session.c:1683 Session 5 (sofia/internal/400@192.168.1.249:2048) Ended
  329. 2018-12-05 21:21:33.966136 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/400@192.168.1.249:2048 [CS_DESTROY]
  330. 2018-12-05 21:21:33.966136 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/400@192.168.1.249:2048) Running State Change CS_DESTROY (Cur 1 Tot 5)
  331. 2018-12-05 21:21:33.966136 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/400@192.168.1.249:2048) State DESTROY
  332. 2018-12-05 21:21:33.966136 [DEBUG] mod_sofia.c:343 sofia/internal/400@192.168.1.249:2048 SOFIA DESTROY
  333. 2018-12-05 21:21:33.966136 [DEBUG] switch_core_state_machine.c:181 sofia/internal/400@192.168.1.249:2048 Standard DESTROY
  334. 2018-12-05 21:21:33.966136 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/400@192.168.1.249:2048) State DESTROY going to sleep
  335. 2018-12-05 21:21:34.026171 [DEBUG] switch_core_state_machine.c:174 sofia/external/06412213225@192.168.1.230:5060 Standard REPORTING, cause: ORIGINATOR_CANCEL
  336. 2018-12-05 21:21:34.026171 [DEBUG] switch_core_state_machine.c:938 (sofia/external/06412213225@192.168.1.230:5060) State REPORTING going to sleep
  337. 2018-12-05 21:21:34.026171 [DEBUG] switch_core_state_machine.c:610 (sofia/external/06412213225@192.168.1.230:5060) State Change CS_REPORTING -> CS_DESTROY
  338. 2018-12-05 21:21:34.026171 [DEBUG] switch_core_session.c:1665 Session 4 (sofia/external/06412213225@192.168.1.230:5060) Locked, Waiting on external entities
  339. 2018-12-05 21:21:34.026171 [NOTICE] switch_core_session.c:1683 Session 4 (sofia/external/06412213225@192.168.1.230:5060) Ended
  340. 2018-12-05 21:21:34.026171 [NOTICE] switch_core_session.c:1687 Close Channel sofia/external/06412213225@192.168.1.230:5060 [CS_DESTROY]
  341. 2018-12-05 21:21:34.026171 [DEBUG] switch_core_state_machine.c:741 (sofia/external/06412213225@192.168.1.230:5060) Running State Change CS_DESTROY (Cur 0 Tot 5)
  342. 2018-12-05 21:21:34.026171 [DEBUG] switch_core_state_machine.c:751 (sofia/external/06412213225@192.168.1.230:5060) State DESTROY
  343. 2018-12-05 21:21:34.026171 [DEBUG] mod_sofia.c:343 sofia/external/06412213225@192.168.1.230:5060 SOFIA DESTROY
  344. 2018-12-05 21:21:34.026171 [DEBUG] switch_core_state_machine.c:181 sofia/external/06412213225@192.168.1.230:5060 Standard DESTROY
  345. 2018-12-05 21:21:34.026171 [DEBUG] switch_core_state_machine.c:751 (sofia/external/06412213225@192.168.1.230:5060) State DESTROY going to sleep
  346.