3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.977537 [DEBUG] mod_dptools.c:1672 SET sofia/internal/804@ [from_user_exists]=[true] 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [user_exists] ${user_exists}(false) =~ /^true$/ break=on-false 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ parsing [->caller-details] continue=true 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (PASS) [caller-details] ${caller_destination}() =~ /^$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Action set(caller_destination=${destination_number}) INLINE 3465da31-4fcf-4e1f-9c82-6f3f344950eb EXECUTE [depth=0] sofia/internal/804@ set(caller_destination=0033413615600) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] mod_dptools.c:1672 SET sofia/internal/804@ [caller_destination]=[0033413615600] 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Action set(caller_id_name=${caller_id_name}) INLINE 3465da31-4fcf-4e1f-9c82-6f3f344950eb EXECUTE [depth=0] sofia/internal/804@ set(caller_id_name=804) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] mod_dptools.c:1672 SET sofia/internal/804@ [caller_id_name]=[804] 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Action set(caller_id_number=${caller_id_number}) 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ parsing [->call-direction] continue=true 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [call-direction] ${call_direction}() =~ /^(inbound|outbound|local)$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ ANTI-Action export(call_direction=local) INLINE 3465da31-4fcf-4e1f-9c82-6f3f344950eb EXECUTE [depth=0] sofia/internal/804@ export(call_direction=local) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [call_direction]=[local] 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ parsing [->global-variables] continue=true 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (PASS) [global-variables] () =~ // break=on-false 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ parsing [->domain-variables] continue=true 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (PASS) [domain-variables] () =~ // break=on-false 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Action export(origination_callee_id_name=${destination_number}) 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ parsing [->is_loopback] continue=true 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [is_loopback] ${is_follow_me_loopback}() =~ /true/ break=on-false 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ parsing [->user_record] continue=true 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [user_record] ${call_direction}(local) =~ /^inbound$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [user_record] ${call_direction}(local) =~ /^outbound$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (PASS) [user_record] ${call_direction}(local) =~ /^local$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Action set(from_user_record=${user_data ${sip_from_user}@${sip_from_host} var user_record}) INLINE 3465da31-4fcf-4e1f-9c82-6f3f344950eb EXECUTE [depth=0] sofia/internal/804@ set(from_user_record=) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] mod_dptools.c:1672 SET sofia/internal/804@ [from_user_record]=[UNDEF] 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [user_record] ${call_direction}(local) =~ /^inbound$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [user_record] ${call_direction}(local) =~ /^outbound$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (PASS) [user_record] ${call_direction}(local) =~ /^local$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ parsing [->redial] continue=true 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [redial] destination_number(0033413615600) =~ /^(redial|\*870)$/ break=on-true 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (PASS) [redial] () =~ // break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number}) 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ parsing [->speed_dial] continue=false 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [speed_dial] destination_number(0033413615600) =~ /^\*0(.*)$/ break=on-false 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ parsing [->user_hold_music] continue=true 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [user_hold_music] ${hold_music}(local_stream://default) =~ /^$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (FAIL) [user_hold_music] ${user_exists}(false) =~ /true/ break=on-false 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ parsing [->default_caller_id] continue=true 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (PASS) [default_caller_id] ${emergency_caller_id_number}() =~ /^$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Action set(emergency_caller_id_name=${default_emergency_caller_id_name}) INLINE 3465da31-4fcf-4e1f-9c82-6f3f344950eb EXECUTE [depth=0] sofia/internal/804@ set(emergency_caller_id_name=) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] mod_dptools.c:1672 SET sofia/internal/804@ [emergency_caller_id_name]=[UNDEF] 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Action set(emergency_caller_id_number=${default_emergency_caller_id_number}) INLINE 3465da31-4fcf-4e1f-9c82-6f3f344950eb EXECUTE [depth=0] sofia/internal/804@ set(emergency_caller_id_number=) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] mod_dptools.c:1672 SET sofia/internal/804@ [emergency_caller_id_number]=[UNDEF] 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (PASS) [default_caller_id] ${outbound_caller_id_number}() =~ /^$/ break=never 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Action set(outbound_caller_id_name=${default_outbound_caller_id_name}) INLINE 3465da31-4fcf-4e1f-9c82-6f3f344950eb EXECUTE [depth=0] sofia/internal/804@ set(outbound_caller_id_name=) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] mod_dptools.c:1672 SET sofia/internal/804@ [outbound_caller_id_name]=[UNDEF] 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Action set(outbound_caller_id_number=${default_outbound_caller_id_number}) INLINE 3465da31-4fcf-4e1f-9c82-6f3f344950eb EXECUTE [depth=0] sofia/internal/804@ set(outbound_caller_id_number=) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] mod_dptools.c:1672 SET sofia/internal/804@ [outbound_caller_id_number]=[UNDEF] 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ parsing [->siptrunk.ovh.net.00d917] continue=false 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (PASS) [siptrunk.ovh.net.00d917] ${user_exists}(false) =~ /false/ break=on-false 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Regex (PASS) [siptrunk.ovh.net.00d917] destination_number(0033413615600) =~ /^(00\d{9,17})$/ break=on-false 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Action set(sip_h_X-accountcode=${accountcode}) 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Action export(call_direction=outbound) 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Action unset(call_timeout) 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Action set(hangup_after_bridge=true) 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Action set(effective_caller_id_name=${outbound_caller_id_name}) 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Action set(effective_caller_id_number=${outbound_caller_id_number}) 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Action set(inherit_codec=true) 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Action set(ignore_display_updates=true) 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Action set(callee_id_number=0033413615600) 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Action set(continue_on_fail=true) 3465da31-4fcf-4e1f-9c82-6f3f344950eb Dialplan: sofia/internal/804@ Action bridge(sofia/gateway/4c6e40b3-0661-4998-ab4c-1a75b574d87e/0033413615600) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] switch_core_state_machine.c:287 (sofia/internal/804@) State Change CS_ROUTING -> CS_EXECUTE 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] switch_core_state_machine.c:644 (sofia/internal/804@) State ROUTING going to sleep 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/804@) Running State Change CS_EXECUTE (Cur 1 Tot 9) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] switch_core_state_machine.c:651 (sofia/internal/804@) State EXECUTE 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] mod_sofia.c:209 sofia/internal/804@ SOFIA EXECUTE 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] switch_core_state_machine.c:329 sofia/internal/804@ Standard EXECUTE 3465da31-4fcf-4e1f-9c82-6f3f344950eb EXECUTE [depth=0] sofia/internal/804@ set(caller_id_number=804) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] mod_dptools.c:1672 SET sofia/internal/804@ [caller_id_number]=[804] 3465da31-4fcf-4e1f-9c82-6f3f344950eb EXECUTE [depth=0] sofia/internal/804@ set(RFC2822_DATE=Tue, 20 Oct 2020 12:06:37 +0200) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] mod_dptools.c:1672 SET sofia/internal/804@ [RFC2822_DATE]=[Tue, 20 Oct 2020 12:06:37 +0200] 3465da31-4fcf-4e1f-9c82-6f3f344950eb EXECUTE [depth=0] sofia/internal/804@ export(origination_callee_id_name=0033413615600) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [origination_callee_id_name]=[0033413615600] 3465da31-4fcf-4e1f-9c82-6f3f344950eb EXECUTE [depth=0] sofia/internal/804@ hash(insert/-last_dial/804/0033413615600) 3465da31-4fcf-4e1f-9c82-6f3f344950eb EXECUTE [depth=0] sofia/internal/804@ set(sip_h_X-accountcode=) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] mod_dptools.c:1672 SET sofia/internal/804@ [sip_h_X-accountcode]=[UNDEF] 3465da31-4fcf-4e1f-9c82-6f3f344950eb EXECUTE [depth=0] sofia/internal/804@ export(call_direction=outbound) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [call_direction]=[outbound] 3465da31-4fcf-4e1f-9c82-6f3f344950eb EXECUTE [depth=0] sofia/internal/804@ unset(call_timeout) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] mod_dptools.c:1817 UNSET [call_timeout] 3465da31-4fcf-4e1f-9c82-6f3f344950eb EXECUTE [depth=0] sofia/internal/804@ set(hangup_after_bridge=true) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] mod_dptools.c:1672 SET sofia/internal/804@ [hangup_after_bridge]=[true] 3465da31-4fcf-4e1f-9c82-6f3f344950eb EXECUTE [depth=0] sofia/internal/804@ set(effective_caller_id_name=) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] mod_dptools.c:1672 SET sofia/internal/804@ [effective_caller_id_name]=[UNDEF] 3465da31-4fcf-4e1f-9c82-6f3f344950eb EXECUTE [depth=0] sofia/internal/804@ set(effective_caller_id_number=) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] mod_dptools.c:1672 SET sofia/internal/804@ [effective_caller_id_number]=[UNDEF] 3465da31-4fcf-4e1f-9c82-6f3f344950eb EXECUTE [depth=0] sofia/internal/804@ set(inherit_codec=true) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] mod_dptools.c:1672 SET sofia/internal/804@ [inherit_codec]=[true] 3465da31-4fcf-4e1f-9c82-6f3f344950eb EXECUTE [depth=0] sofia/internal/804@ set(ignore_display_updates=true) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] mod_dptools.c:1672 SET sofia/internal/804@ [ignore_display_updates]=[true] 3465da31-4fcf-4e1f-9c82-6f3f344950eb EXECUTE [depth=0] sofia/internal/804@ set(callee_id_number=0033413615600) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] mod_dptools.c:1672 SET sofia/internal/804@ [callee_id_number]=[0033413615600] 3465da31-4fcf-4e1f-9c82-6f3f344950eb EXECUTE [depth=0] sofia/internal/804@ set(continue_on_fail=true) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] mod_dptools.c:1672 SET sofia/internal/804@ [continue_on_fail]=[true] 3465da31-4fcf-4e1f-9c82-6f3f344950eb EXECUTE [depth=0] sofia/internal/804@ bridge(sofia/gateway/4c6e40b3-0661-4998-ab4c-1a75b574d87e/0033413615600) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] switch_channel.c:1264 sofia/internal/804@ EXPORTING[export_vars] [domain_name]=[] to event 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] switch_channel.c:1264 sofia/internal/804@ EXPORTING[export_vars] [call_direction]=[outbound] to event 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] switch_channel.c:1264 sofia/internal/804@ EXPORTING[export_vars] [origination_callee_id_name]=[0033413615600] to event 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] switch_channel.c:1264 sofia/internal/804@ EXPORTING[export_vars] [call_direction]=[outbound] to event 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:37.997527 [DEBUG] switch_ivr_originate.c:2242 Parsing global variables e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:37.997527 [NOTICE] switch_channel.c:1118 New Channel sofia/external/0033413615600 [e014fdca-fa9a-471f-ad6b-8a977d5da23c] e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:37.997527 [DEBUG] mod_sofia.c:5089 (sofia/external/0033413615600) State Change CS_NEW -> CS_INIT e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:37.997527 [DEBUG] switch_core_state_machine.c:585 (sofia/external/0033413615600) Running State Change CS_INIT (Cur 2 Tot 10) e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:37.997527 [DEBUG] switch_core_state_machine.c:628 (sofia/external/0033413615600) State INIT e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:37.997527 [DEBUG] mod_sofia.c:93 sofia/external/0033413615600 SOFIA INIT e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:37.997527 [DEBUG] sofia_glue.c:1618 sofia/external/0033413615600 sending invite version: 1.10.3 -release-15-129de34d84 64bit e014fdca-fa9a-471f-ad6b-8a977d5da23c Local SDP: e014fdca-fa9a-471f-ad6b-8a977d5da23c v=0 e014fdca-fa9a-471f-ad6b-8a977d5da23c o=FreeSWITCH 1603160761 1603160762 IN IP4 93.93.191.249 e014fdca-fa9a-471f-ad6b-8a977d5da23c s=FreeSWITCH e014fdca-fa9a-471f-ad6b-8a977d5da23c c=IN IP4 93.93.191.249 e014fdca-fa9a-471f-ad6b-8a977d5da23c t=0 0 e014fdca-fa9a-471f-ad6b-8a977d5da23c m=audio 27636 RTP/AVP 8 0 101 e014fdca-fa9a-471f-ad6b-8a977d5da23c a=rtpmap:8 PCMA/8000 e014fdca-fa9a-471f-ad6b-8a977d5da23c a=rtpmap:0 PCMU/8000 e014fdca-fa9a-471f-ad6b-8a977d5da23c a=rtpmap:101 telephone-event/8000 e014fdca-fa9a-471f-ad6b-8a977d5da23c a=fmtp:101 0-16 e014fdca-fa9a-471f-ad6b-8a977d5da23c a=silenceSupp:off - - - - e014fdca-fa9a-471f-ad6b-8a977d5da23c a=ptime:20 e014fdca-fa9a-471f-ad6b-8a977d5da23c a=sendrecv e014fdca-fa9a-471f-ad6b-8a977d5da23c e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:37.997527 [DEBUG] switch_core_state_machine.c:40 sofia/external/0033413615600 Standard INIT e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:37.997527 [DEBUG] switch_core_state_machine.c:48 (sofia/external/0033413615600) State Change CS_INIT -> CS_ROUTING e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:37.997527 [DEBUG] switch_core_state_machine.c:628 (sofia/external/0033413615600) State INIT going to sleep e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:37.997527 [DEBUG] switch_core_state_machine.c:585 (sofia/external/0033413615600) Running State Change CS_ROUTING (Cur 2 Tot 10) e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:37.997527 [DEBUG] switch_core_state_machine.c:644 (sofia/external/0033413615600) State ROUTING e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:37.997527 [DEBUG] mod_sofia.c:154 sofia/external/0033413615600 SOFIA ROUTING e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:37.997527 [DEBUG] switch_ivr_originate.c:67 (sofia/external/0033413615600) State Change CS_ROUTING -> CS_CONSUME_MEDIA e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:37.997527 [DEBUG] switch_core_state_machine.c:644 (sofia/external/0033413615600) State ROUTING going to sleep e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:37.997527 [DEBUG] switch_core_state_machine.c:585 (sofia/external/0033413615600) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 10) e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:37.997527 [DEBUG] switch_core_state_machine.c:663 (sofia/external/0033413615600) State CONSUME_MEDIA e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:37.997527 [DEBUG] switch_core_state_machine.c:663 (sofia/external/0033413615600) State CONSUME_MEDIA going to sleep e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:37.997527 [DEBUG] sofia.c:7325 Channel sofia/external/0033413615600 entering state [calling][0] e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.057551 [DEBUG] sofia.c:7325 Channel sofia/external/0033413615600 entering state [calling][0] e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.077550 [DEBUG] sofia.c:6501 Remote Reason: 1 e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.077550 [DEBUG] sofia.c:7325 Channel sofia/external/0033413615600 entering state [terminated][403] e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.077550 [NOTICE] sofia.c:8558 Hangup sofia/external/0033413615600 [CS_CONSUME_MEDIA] [UNALLOCATED_NUMBER] e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:585 (sofia/external/0033413615600) Running State Change CS_HANGUP (Cur 2 Tot 10) e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:848 (sofia/external/0033413615600) Callstate Change DOWN -> HANGUP e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:850 (sofia/external/0033413615600) State HANGUP e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.077550 [DEBUG] mod_sofia.c:453 Channel sofia/external/0033413615600 hanging up, cause: UNALLOCATED_NUMBER e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:60 sofia/external/0033413615600 Standard HANGUP, cause: UNALLOCATED_NUMBER e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:850 (sofia/external/0033413615600) State HANGUP going to sleep e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:620 (sofia/external/0033413615600) State Change CS_HANGUP -> CS_REPORTING e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:585 (sofia/external/0033413615600) Running State Change CS_REPORTING (Cur 2 Tot 10) e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:936 (sofia/external/0033413615600) State REPORTING e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:174 sofia/external/0033413615600 Standard REPORTING, cause: UNALLOCATED_NUMBER e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:936 (sofia/external/0033413615600) State REPORTING going to sleep e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:611 (sofia/external/0033413615600) State Change CS_REPORTING -> CS_DESTROY e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.077550 [DEBUG] switch_core_session.c:1726 Session 10 (sofia/external/0033413615600) Locked, Waiting on external entities 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.077550 [DEBUG] switch_ivr_originate.c:3995 Originate Resulted in Error Cause: 1 [UNALLOCATED_NUMBER] e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.077550 [NOTICE] switch_core_session.c:1744 Session 10 (sofia/external/0033413615600) Ended e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.077550 [NOTICE] switch_core_session.c:1748 Close Channel sofia/external/0033413615600 [CS_DESTROY] e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:739 (sofia/external/0033413615600) Running State Change CS_DESTROY (Cur 1 Tot 10) e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:749 (sofia/external/0033413615600) State DESTROY e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.077550 [DEBUG] mod_sofia.c:364 sofia/external/0033413615600 SOFIA DESTROY 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.077550 [INFO] mod_dptools.c:3631 Originate Failed. Cause: UNALLOCATED_NUMBER e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:181 sofia/external/0033413615600 Standard DESTROY e014fdca-fa9a-471f-ad6b-8a977d5da23c 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:749 (sofia/external/0033413615600) State DESTROY going to sleep 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.077550 [NOTICE] switch_core_state_machine.c:386 sofia/internal/804@ has executed the last dialplan instruction, hanging up. 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.077550 [NOTICE] switch_core_state_machine.c:388 Hangup sofia/internal/804@ [CS_EXECUTE] [NORMAL_CLEARING] 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:651 (sofia/internal/804@) State EXECUTE going to sleep 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/804@) Running State Change CS_HANGUP (Cur 1 Tot 10) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:848 (sofia/internal/804@) Callstate Change RINGING -> HANGUP 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/804@) State HANGUP 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.077550 [DEBUG] mod_sofia.c:447 sofia/internal/804@ Overriding SIP cause 480 with 403 from the other leg 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.077550 [DEBUG] mod_sofia.c:453 Channel sofia/internal/804@ hanging up, cause: NORMAL_CLEARING 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.077550 [DEBUG] mod_sofia.c:598 Responding to INVITE with: 403 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:60 sofia/internal/804@ Standard HANGUP, cause: NORMAL_CLEARING 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/804@) State HANGUP going to sleep 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:620 (sofia/internal/804@) State Change CS_HANGUP -> CS_REPORTING 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/804@) Running State Change CS_REPORTING (Cur 1 Tot 10) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.077550 [DEBUG] switch_core_state_machine.c:936 (sofia/internal/804@) State REPORTING 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.137522 [DEBUG] switch_core_state_machine.c:174 sofia/internal/804@ Standard REPORTING, cause: NORMAL_CLEARING 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.137522 [DEBUG] switch_core_state_machine.c:936 (sofia/internal/804@) State REPORTING going to sleep 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.137522 [DEBUG] switch_core_state_machine.c:611 (sofia/internal/804@) State Change CS_REPORTING -> CS_DESTROY 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.137522 [DEBUG] switch_core_session.c:1726 Session 9 (sofia/internal/804@) Locked, Waiting on external entities 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.137522 [NOTICE] switch_core_session.c:1744 Session 9 (sofia/internal/804@) Ended 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.137522 [NOTICE] switch_core_session.c:1748 Close Channel sofia/internal/804@ [CS_DESTROY] 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.137522 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/804@) Running State Change CS_DESTROY (Cur 0 Tot 10) 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.137522 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/804@) State DESTROY 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.137522 [DEBUG] mod_sofia.c:364 sofia/internal/804@ SOFIA DESTROY 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.137522 [DEBUG] switch_core_state_machine.c:181 sofia/internal/804@ Standard DESTROY 3465da31-4fcf-4e1f-9c82-6f3f344950eb 2020-10-20 12:06:38.137522 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/804@) State DESTROY going to sleep