47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [NOTICE] switch_channel.c:1104 New Channel sofia/external/9185330000@45.55.163.124 [47ac4b3e-74e3-11e7-b726-c1f435f54e69]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] switch_core_state_machine.c:584 (sofia/external/9185330000@45.55.163.124) Running State Change CS_NEW (Cur 1 Tot 176)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] sofia.c:10067 sofia/external/9185330000@45.55.163.124 receiving invite from 45.55.163.124:5060 version: 1.9.0 git 144d373 2017-07-28 23:05:50Z 32bit
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] sofia.c:7283 Channel sofia/external/9185330000@45.55.163.124 entering state [received][100]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] sofia.c:7293 Remote SDP:
47ac4b3e-74e3-11e7-b726-c1f435f54e69 v=0
47ac4b3e-74e3-11e7-b726-c1f435f54e69 o=yate 1501390516 1501390516 IN IP4 45.55.163.124
47ac4b3e-74e3-11e7-b726-c1f435f54e69 s=SIP Call
47ac4b3e-74e3-11e7-b726-c1f435f54e69 c=IN IP4 45.55.163.124
47ac4b3e-74e3-11e7-b726-c1f435f54e69 t=0 0
47ac4b3e-74e3-11e7-b726-c1f435f54e69 m=audio 24486 RTP/AVP 0 3 101
47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=rtpmap:0 PCMU/8000
47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=rtpmap:3 GSM/8000
47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=rtpmap:101 telephone-event/8000
47ac4b3e-74e3-11e7-b726-c1f435f54e69 
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] sofia.c:7685 (sofia/external/9185330000@45.55.163.124) State Change CS_NEW -> CS_INIT
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] switch_core_state_machine.c:603 (sofia/external/9185330000@45.55.163.124) State NEW
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] switch_core_state_machine.c:584 (sofia/external/9185330000@45.55.163.124) Running State Change CS_INIT (Cur 1 Tot 176)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] switch_core_state_machine.c:627 (sofia/external/9185330000@45.55.163.124) State INIT
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] mod_sofia.c:93 sofia/external/9185330000@45.55.163.124 SOFIA INIT
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] switch_core_state_machine.c:40 sofia/external/9185330000@45.55.163.124 Standard INIT
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] switch_core_state_machine.c:48 (sofia/external/9185330000@45.55.163.124) State Change CS_INIT -> CS_ROUTING
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] switch_core_state_machine.c:627 (sofia/external/9185330000@45.55.163.124) State INIT going to sleep
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] switch_core_state_machine.c:584 (sofia/external/9185330000@45.55.163.124) Running State Change CS_ROUTING (Cur 1 Tot 176)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] switch_channel.c:2249 (sofia/external/9185330000@45.55.163.124) Callstate Change DOWN -> RINGING
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] switch_core_state_machine.c:643 (sofia/external/9185330000@45.55.163.124) State ROUTING
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] mod_sofia.c:154 sofia/external/9185330000@45.55.163.124 SOFIA ROUTING
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] switch_core_state_machine.c:236 sofia/external/9185330000@45.55.163.124 Standard ROUTING
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [INFO] mod_dialplan_xml.c:637 Processing TULSA, OK <9185330000>->1121300000005740 in context public
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [public->unloop] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [public->outside_call] continue=true
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Absolute Condition [outside_call]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action set(outside_call=true)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [public->call_debug] continue=true
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [public->public_extensions] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [public_extensions] destination_number(1121300000005740) =~ /^(10[01][0-9])$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [public->public_did] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [public_did] destination_number(1121300000005740) =~ /^15123330880$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [public->public_did] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [public_did] destination_number(1121300000005740) =~ /^17023024016$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [public->public_did] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [public_did] destination_number(1121300000005740) =~ /^883510009027723$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [public->public_did] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [public_did] destination_number(1121300000005740) =~ /^\+12109412600$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [public->public_did] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (PASS) [public_did] destination_number(1121300000005740) =~ /^1121300000005740$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action set(domain_name=192.168.0.137)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action transfer(2001 XML default)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] switch_core_state_machine.c:286 (sofia/external/9185330000@45.55.163.124) State Change CS_ROUTING -> CS_EXECUTE
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] switch_core_state_machine.c:643 (sofia/external/9185330000@45.55.163.124) State ROUTING going to sleep
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] switch_core_state_machine.c:584 (sofia/external/9185330000@45.55.163.124) Running State Change CS_EXECUTE (Cur 1 Tot 176)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] switch_core_state_machine.c:650 (sofia/external/9185330000@45.55.163.124) State EXECUTE
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] mod_sofia.c:209 sofia/external/9185330000@45.55.163.124 SOFIA EXECUTE
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] switch_core_state_machine.c:328 sofia/external/9185330000@45.55.163.124 Standard EXECUTE
47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 set(outside_call=true)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] mod_dptools.c:1588 SET sofia/external/9185330000@45.55.163.124 [outside_call]=[true]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 export(RFC2822_DATE=Sat, 29 Jul 2017 21:55:16 -0700)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [RFC2822_DATE]=[Sat, 29 Jul 2017 21:55:16 -0700]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 set(domain_name=192.168.0.137)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] mod_dptools.c:1588 SET sofia/external/9185330000@45.55.163.124 [domain_name]=[192.168.0.137]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 transfer(2001 XML default)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] switch_ivr.c:2194 (sofia/external/9185330000@45.55.163.124) State Change CS_EXECUTE -> CS_ROUTING
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [NOTICE] switch_ivr.c:2201 Transfer sofia/external/9185330000@45.55.163.124 to XML[2001@default]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] switch_core_state_machine.c:650 (sofia/external/9185330000@45.55.163.124) State EXECUTE going to sleep
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] switch_core_state_machine.c:584 (sofia/external/9185330000@45.55.163.124) Running State Change CS_ROUTING (Cur 1 Tot 176)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] switch_core_state_machine.c:643 (sofia/external/9185330000@45.55.163.124) State ROUTING
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] mod_sofia.c:145 Call appears to be already acknowledged
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] mod_sofia.c:154 sofia/external/9185330000@45.55.163.124 SOFIA ROUTING
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] switch_core_state_machine.c:236 sofia/external/9185330000@45.55.163.124 Standard ROUTING
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [INFO] mod_dialplan_xml.c:637 Processing TULSA, OK <9185330000>->2001 in context default
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->unloop] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->tod_example] continue=true
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Date/TimeMatch (FAIL) [tod_example] break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->holiday_example] continue=true
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Date/TimeMatch (FAIL) [holiday_example] break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->global-intercept] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [global-intercept] destination_number(2001) =~ /^886$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->group-intercept] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [group-intercept] destination_number(2001) =~ /^\*8$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->intercept-ext] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [intercept-ext] destination_number(2001) =~ /^\*\*(\d+)$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->redial] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [redial] destination_number(2001) =~ /^(redial|870)$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->global] continue=true
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [global] ${default_password}() =~ /^1234$/ break=never
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 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
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (PASS) [global] ${endpoint_disposition}(DELAYED NEGOTIATION) =~ /^(DELAYED NEGOTIATION)/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [global] ${switch_r_sdp}(v=0
47ac4b3e-74e3-11e7-b726-c1f435f54e69 o=yate 1501390516 1501390516 IN IP4 45.55.163.124
47ac4b3e-74e3-11e7-b726-c1f435f54e69 s=SIP Call
47ac4b3e-74e3-11e7-b726-c1f435f54e69 c=IN IP4 45.55.163.124
47ac4b3e-74e3-11e7-b726-c1f435f54e69 t=0 0
47ac4b3e-74e3-11e7-b726-c1f435f54e69 m=audio 24486 RTP/AVP 0 3 101
47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=rtpmap:0 PCMU/8000
47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=rtpmap:3 GSM/8000
47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=rtpmap:101 telephone-event/8000
47ac4b3e-74e3-11e7-b726-c1f435f54e69 ) =~ /(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)/ break=never
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Absolute Condition [global]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid})
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action hash(insert/${domain_name}-last_dial/global/${uuid})
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->snom-demo-2] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [snom-demo-2] destination_number(2001) =~ /^9001$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->snom-demo-1] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [snom-demo-1] destination_number(2001) =~ /^9000$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->eavesdrop] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [eavesdrop] destination_number(2001) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->eavesdrop] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [eavesdrop] destination_number(2001) =~ /^779$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->call_return] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [call_return] destination_number(2001) =~ /^\*69$|^869$|^lcr$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->del-group] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [del-group] destination_number(2001) =~ /^80(\d{2})$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->add-group] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [add-group] destination_number(2001) =~ /^81(\d{2})$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->call-group-simo] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [call-group-simo] destination_number(2001) =~ /^82(\d{2})$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->call-group-order] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [call-group-order] destination_number(2001) =~ /^83(\d{2})$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->extension-intercom] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [extension-intercom] destination_number(2001) =~ /^8(10[01][0-9])$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->Local_Extension] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [Local_Extension] destination_number(2001) =~ /^(26[01][0-9]|phone|mobile)$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->Local_Extension_Skinny] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [Local_Extension_Skinny] destination_number(2001) =~ /^(11[01][0-9])$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->group_dial_sales] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [group_dial_sales] destination_number(2001) =~ /^2000$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->group_dial_support] continue=false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (PASS) [group_dial_support] destination_number(2001) =~ /^2001$/ break=on-false
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action set(ringback=local_stream://custom)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action playback({timeout=6000})
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action set(call_timeout=20)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action set(continue_on_fail=true)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action set(hangup_after_bridge=true)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action bridge({ignore_early_media=true}group/support@${domain_name})
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action answer()
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action sleep(2000)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action voicemail(default ${domain_name} 2600)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_state_machine.c:286 (sofia/external/9185330000@45.55.163.124) State Change CS_ROUTING -> CS_EXECUTE
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_state_machine.c:643 (sofia/external/9185330000@45.55.163.124) State ROUTING going to sleep
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_state_machine.c:584 (sofia/external/9185330000@45.55.163.124) Running State Change CS_EXECUTE (Cur 1 Tot 176)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_state_machine.c:650 (sofia/external/9185330000@45.55.163.124) State EXECUTE
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] mod_sofia.c:209 sofia/external/9185330000@45.55.163.124 SOFIA EXECUTE
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_state_machine.c:328 sofia/external/9185330000@45.55.163.124 Standard EXECUTE
47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 hash(insert/192.168.0.137-spymap/9185330000/47ac4b3e-74e3-11e7-b726-c1f435f54e69)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 hash(insert/192.168.0.137-last_dial/9185330000/2001)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 hash(insert/192.168.0.137-last_dial/global/47ac4b3e-74e3-11e7-b726-c1f435f54e69)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 export(RFC2822_DATE=Sat, 29 Jul 2017 21:55:16 -0700)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [RFC2822_DATE]=[Sat, 29 Jul 2017 21:55:16 -0700]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 set(ringback=local_stream://custom)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] mod_dptools.c:1588 SET sofia/external/9185330000@45.55.163.124 [ringback]=[local_stream://custom]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_session.c:2708 Application playback Requires media! pre_answering channel sofia/external/9185330000@45.55.163.124
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [INFO] switch_core_session.c:2710 Sending early media
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5115 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5115 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5115 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5170 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5115 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5115 Audio Codec Compare [GSM:3:8000:20:13200:1]/[opus:116:48000:20:0:1]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5115 Audio Codec Compare [GSM:3:8000:20:13200:1]/[G722:9:8000:20:64000:1]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5115 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMU:0:8000:20:64000:1]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5115 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMA:8:8000:20:64000:1]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5031 Set telephone-event payload to 101@8000
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:3430 Set Codec sofia/external/9185330000@45.55.163.124 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_codec.c:111 sofia/external/9185330000@45.55.163.124 Original read codec set to PCMU:0
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5374 Set telephone-event payload to 101@8000
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5432 sofia/external/9185330000@45.55.163.124 Set 2833 dtmf send payload to 101 recv payload to 101
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.862450 [DEBUG] switch_core_media.c:8149 AUDIO RTP [sofia/external/9185330000@45.55.163.124] 192.168.0.137 port 18342 -> 45.55.163.124 port 24486 codec: 0 ms: 20
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.862450 [DEBUG] switch_rtp.c:4164 Starting timer [soft] 160 bytes per 20ms
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.862450 [DEBUG] switch_core_media.c:8452 sofia/external/9185330000@45.55.163.124 Set 2833 dtmf send payload to 101
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.862450 [DEBUG] switch_core_media.c:8459 sofia/external/9185330000@45.55.163.124 Set 2833 dtmf receive payload to 101
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.862450 [DEBUG] switch_core_media.c:8482 sofia/external/9185330000@45.55.163.124 Set rtp dtmf delay to 40
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.862450 [NOTICE] sofia_media.c:92 Pre-Answer sofia/external/9185330000@45.55.163.124!
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.862450 [DEBUG] switch_channel.c:3482 (sofia/external/9185330000@45.55.163.124) Callstate Change RINGING -> EARLY
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.862450 [DEBUG] switch_core_media.c:8132 Audio params are unchanged for sofia/external/9185330000@45.55.163.124.
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.862450 [DEBUG] mod_sofia.c:2512 Ring SDP:
47ac4b3e-74e3-11e7-b726-c1f435f54e69 v=0
47ac4b3e-74e3-11e7-b726-c1f435f54e69 o=FreeSWITCH 1501372174 1501372175 IN IP4 freeswitch.example.com
47ac4b3e-74e3-11e7-b726-c1f435f54e69 s=FreeSWITCH
47ac4b3e-74e3-11e7-b726-c1f435f54e69 c=IN IP4 freeswitch.example.com
47ac4b3e-74e3-11e7-b726-c1f435f54e69 t=0 0
47ac4b3e-74e3-11e7-b726-c1f435f54e69 m=audio 18342 RTP/AVP 0 101
47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=rtpmap:0 PCMU/8000
47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=rtpmap:101 telephone-event/8000
47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=fmtp:101 0-16
47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=ptime:20
47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=sendrecv
47ac4b3e-74e3-11e7-b726-c1f435f54e69 
47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 playback({timeout=6000})
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.862450 [DEBUG] sofia.c:7283 Channel sofia/external/9185330000@45.55.163.124 entering state [early][183]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 set(call_timeout=20)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.882464 [DEBUG] mod_dptools.c:1588 SET sofia/external/9185330000@45.55.163.124 [call_timeout]=[20]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 set(continue_on_fail=true)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.882464 [DEBUG] mod_dptools.c:1588 SET sofia/external/9185330000@45.55.163.124 [continue_on_fail]=[true]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 set(hangup_after_bridge=true)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.882464 [DEBUG] mod_dptools.c:1588 SET sofia/external/9185330000@45.55.163.124 [hangup_after_bridge]=[true]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 bridge({ignore_early_media=true}group/support@192.168.0.137)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.882464 [DEBUG] switch_channel.c:1250 sofia/external/9185330000@45.55.163.124 EXPORTING[export_vars] [RFC2822_DATE]=[Sat, 29 Jul 2017 21:55:16 -0700] to event
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.882464 [DEBUG] switch_channel.c:1250 sofia/external/9185330000@45.55.163.124 EXPORTING[export_vars] [RFC2822_DATE]=[Sat, 29 Jul 2017 21:55:16 -0700] to event
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.882464 [DEBUG] switch_ivr_originate.c:2147 Parsing global variables
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [DEBUG] switch_channel.c:1250 sofia/external/9185330000@45.55.163.124 EXPORTING[export_vars] [RFC2822_DATE]=[Sat, 29 Jul 2017 21:55:16 -0700] to event
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [DEBUG] switch_channel.c:1250 sofia/external/9185330000@45.55.163.124 EXPORTING[export_vars] [RFC2822_DATE]=[Sat, 29 Jul 2017 21:55:16 -0700] to event
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [DEBUG] switch_ivr_originate.c:2147 Parsing global variables
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [DEBUG] switch_ivr_originate.c:2674 Parsing session specific variables
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [DEBUG] switch_ivr_originate.c:2674 Parsing session specific variables
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [NOTICE] switch_ivr_originate.c:2856 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [DEBUG] switch_ivr_originate.c:2674 Parsing session specific variables
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [NOTICE] switch_ivr_originate.c:2856 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [DEBUG] switch_ivr_originate.c:2674 Parsing session specific variables
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [NOTICE] switch_ivr_originate.c:2856 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [DEBUG] switch_ivr_originate.c:2674 Parsing session specific variables
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [DEBUG] switch_ivr_originate.c:2674 Parsing session specific variables
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [NOTICE] switch_ivr_originate.c:2856 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:17.062449 [DEBUG] switch_ivr_originate.c:1278 Raw Codec Activation Success L16@8000hz 1 channel 20ms
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:17.062449 [DEBUG] switch_core_codec.c:223 sofia/external/9185330000@45.55.163.124 Push codec L16:100
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:17.062449 [DEBUG] switch_ivr_originate.c:1310 Play Ringback File [local_stream://custom]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:18.902480 [DEBUG] switch_core_codec.c:248 sofia/external/9185330000@45.55.163.124 Restore previous codec PCMU:0.
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:18.902480 [DEBUG] switch_core_media.c:8132 Audio params are unchanged for sofia/external/9185330000@45.55.163.124.
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:18.902480 [DEBUG] mod_sofia.c:881 Local SDP sofia/external/9185330000@45.55.163.124:
47ac4b3e-74e3-11e7-b726-c1f435f54e69 v=0
47ac4b3e-74e3-11e7-b726-c1f435f54e69 o=FreeSWITCH 1501372174 1501372176 IN IP4 freeswitch.example.com
47ac4b3e-74e3-11e7-b726-c1f435f54e69 s=FreeSWITCH
47ac4b3e-74e3-11e7-b726-c1f435f54e69 c=IN IP4 freeswitch.example.com
47ac4b3e-74e3-11e7-b726-c1f435f54e69 t=0 0
47ac4b3e-74e3-11e7-b726-c1f435f54e69 m=audio 18342 RTP/AVP 0 101
47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=rtpmap:0 PCMU/8000
47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=rtpmap:101 telephone-event/8000
47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=fmtp:101 0-16
47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=ptime:20
47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=sendrecv
47ac4b3e-74e3-11e7-b726-c1f435f54e69 
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:18.902480 [NOTICE] switch_ivr_originate.c:3652 Channel [sofia/external/9185330000@45.55.163.124] has been answered
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:18.902480 [DEBUG] switch_channel.c:3781 (sofia/external/9185330000@45.55.163.124) Callstate Change EARLY -> ACTIVE
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:18.902480 [DEBUG] sofia.c:7283 Channel sofia/external/9185330000@45.55.163.124 entering state [completed][200]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:18.902480 [DEBUG] switch_ivr_originate.c:3710 Originate Resulted in Success: [sofia/internal/2600@192.168.0.12]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:18.922489 [DEBUG] switch_ivr_originate.c:3710 Originate Resulted in Success: [sofia/internal/2600@192.168.0.12]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.142441 [DEBUG] sofia.c:7283 Channel sofia/external/9185330000@45.55.163.124 entering state [ready][200]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.282437 [NOTICE] sofia.c:1079 Hangup sofia/external/9185330000@45.55.163.124 [CS_EXECUTE] [NORMAL_CLEARING]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_ivr_bridge.c:917 BRIDGE THREAD DONE [sofia/external/9185330000@45.55.163.124]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_ivr_bridge.c:1846 sofia/external/9185330000@45.55.163.124 skip receive message [TRANSFER] (channel is hungup already)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_core_session.c:2885 sofia/external/9185330000@45.55.163.124 skip receive message [PHONE_EVENT] (channel is hungup already)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_core_state_machine.c:650 (sofia/external/9185330000@45.55.163.124) State EXECUTE going to sleep
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_core_state_machine.c:584 (sofia/external/9185330000@45.55.163.124) Running State Change CS_HANGUP (Cur 2 Tot 178)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_core_state_machine.c:850 (sofia/external/9185330000@45.55.163.124) Callstate Change ACTIVE -> HANGUP
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_core_state_machine.c:852 (sofia/external/9185330000@45.55.163.124) State HANGUP
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] mod_sofia.c:449 Channel sofia/external/9185330000@45.55.163.124 hanging up, cause: NORMAL_CLEARING
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_core_state_machine.c:60 sofia/external/9185330000@45.55.163.124 Standard HANGUP, cause: NORMAL_CLEARING
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_core_state_machine.c:852 (sofia/external/9185330000@45.55.163.124) State HANGUP going to sleep
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_core_state_machine.c:619 (sofia/external/9185330000@45.55.163.124) State Change CS_HANGUP -> CS_REPORTING
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_core_state_machine.c:584 (sofia/external/9185330000@45.55.163.124) Running State Change CS_REPORTING (Cur 2 Tot 178)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_core_state_machine.c:938 (sofia/external/9185330000@45.55.163.124) State REPORTING
"2017-07-29 21:55:19",3, 0, 1,"NORMAL_CLEARING","47ac4b3e-74e3-11e7-b726-c1f435f54e69","47ccf19a-74e3-11e7-b73b-c1f435f54e69","","PCMU","PCMU",
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.322454 [DEBUG] switch_core_state_machine.c:174 sofia/external/9185330000@45.55.163.124 Standard REPORTING, cause: NORMAL_CLEARING
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.322454 [DEBUG] switch_core_state_machine.c:938 (sofia/external/9185330000@45.55.163.124) State REPORTING going to sleep
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.322454 [DEBUG] switch_core_state_machine.c:610 (sofia/external/9185330000@45.55.163.124) State Change CS_REPORTING -> CS_DESTROY
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.322454 [DEBUG] switch_core_session.c:1713 Session 176 (sofia/external/9185330000@45.55.163.124) Locked, Waiting on external entities
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.322454 [NOTICE] switch_core_session.c:1731 Session 176 (sofia/external/9185330000@45.55.163.124) Ended
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.322454 [NOTICE] switch_core_session.c:1735 Close Channel sofia/external/9185330000@45.55.163.124 [CS_DESTROY]
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.322454 [DEBUG] switch_core_state_machine.c:741 (sofia/external/9185330000@45.55.163.124) Running State Change CS_DESTROY (Cur 0 Tot 178)
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.322454 [DEBUG] switch_core_state_machine.c:751 (sofia/external/9185330000@45.55.163.124) State DESTROY
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.322454 [DEBUG] mod_sofia.c:354 sofia/external/9185330000@45.55.163.124 SOFIA DESTROY
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.482441 [DEBUG] switch_core_state_machine.c:181 sofia/external/9185330000@45.55.163.124 Standard DESTROY
47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.482441 [DEBUG] switch_core_state_machine.c:751 (sofia/external/9185330000@45.55.163.124) State DESTROY going to sleep