Outbound call not working

Status
Not open for further replies.
R

Rufus

New Member
Jan 31, 2020
6
0
1
34
Hello,

I have two subnets one from provider and the other internally. Incoming calls are working perfectly but outbound calls have never worked. I have gone through the forums and implemented some like adding calling limit to 1 or 100 but am still stuck. Below is my log from a test call

on_number(0724816442) =~ /^att_xfer$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->extension-to-voicemail] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [extension-to-voicemail] ${user_exists}(false) =~ /^true$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->send_to_voicemail] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [send_to_voicemail] destination_number(0724816442) =~ /^\*99(\d{2,10})$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->send_to_voicemail] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [send_to_voicemail] destination_number(0724816442) =~ /^\*99(\d{2,10})$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->extension-to-voicemail] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [extension-to-voicemail] ${user_exists}(false) =~ /^true$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->xfer_vm] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [xfer_vm] destination_number(0724816442) =~ /^xfer_vm$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->vmain] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [vmain] destination_number(0724816442) =~ /^vmain$|^\*4000$|^\*98$/ break=never
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [vmain] destination_number(0724816442) =~ /^(vmain$|^\*4000$|^\*98)(\d{2,12})$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->xfer_vm] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [xfer_vm] destination_number(0724816442) =~ /^xfer_vm$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->vmain] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [vmain] destination_number(0724816442) =~ /^vmain$|^\*4000$|^\*98$/ break=never
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [vmain] destination_number(0724816442) =~ /^(vmain$|^\*4000$|^\*98)(\d{2,12})$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->vmain_user] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [vmain_user] destination_number(0724816442) =~ /^\*97$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->is_transfer] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [is_transfer] destination_number(0724816442) =~ /^is_transfer$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->vmain_user] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [vmain_user] destination_number(0724816442) =~ /^\*97$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->is_transfer] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [is_transfer] destination_number(0724816442) =~ /^is_transfer$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->cf] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [cf] destination_number(0724816442) =~ /^cf$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->cf] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [cf] destination_number(0724816442) =~ /^cf$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->delay_echo] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [delay_echo] destination_number(0724816442) =~ /^\*9195$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->delay_echo] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [delay_echo] destination_number(0724816442) =~ /^\*9195$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->echo] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [echo] destination_number(0724816442) =~ /^\*9196$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->echo] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [echo] destination_number(0724816442) =~ /^\*9196$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->is_zrtp_secure] continue=true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [is_zrtp_secure] ${zrtp_secure_media_confirmed}() =~ /^true$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 ANTI-Action eval(not_secure)
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->milliwatt] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [milliwatt] destination_number(0724816442) =~ /^\*9197$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->is_zrtp_secure] continue=true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [is_zrtp_secure] ${zrtp_secure_media_confirmed}() =~ /^true$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 ANTI-Action eval(not_secure)
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->milliwatt] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [milliwatt] destination_number(0724816442) =~ /^\*9197$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->tone_stream] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [tone_stream] destination_number(0724816442) =~ /^\*9198$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->is_secure] continue=true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [is_secure] ${sip_via_protocol}(udp) =~ /tls/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->tone_stream] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [tone_stream] destination_number(0724816442) =~ /^\*9198$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->is_secure] continue=true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [is_secure] ${sip_via_protocol}(udp) =~ /tls/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->hold_music] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [hold_music] destination_number(0724816442) =~ /^\*9664$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->hold_music] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [hold_music] destination_number(0724816442) =~ /^\*9664$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->recordings] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [recordings] destination_number(0724816442) =~ /^\*(732)$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->recordings] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [recordings] destination_number(0724816442) =~ /^\*(732)$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->directory] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [directory] destination_number(0724816442) =~ /^\*411$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->directory] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [directory] destination_number(0724816442) =~ /^\*411$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->wake-up] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [wake-up] destination_number(0724816442) =~ /^\*(925)$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->wake-up] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [wake-up] destination_number(0724816442) =~ /^\*(925)$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->valet_park] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [valet_park] destination_number(0724816442) =~ /^(park\+)?\*(59[0-9][0-9])$/ break=never
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [valet_park] ${sip_h_Referred-By}() =~ /sip:(.*)@.*/ break=never
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [valet_park] destination_number(0724816442) =~ /^(park\+)?\*(59[0-9][0-9])$/ break=never
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [valet_park] destination_number(0724816442) =~ /^(park\+)?\*(59[0-9][0-9])$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->valet_park] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [valet_park] destination_number(0724816442) =~ /^(park\+)?\*(59[0-9][0-9])$/ break=never
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [valet_park] ${sip_h_Referred-By}() =~ /sip:(.*)@.*/ break=never
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [valet_park] destination_number(0724816442) =~ /^(park\+)?\*(59[0-9][0-9])$/ break=never
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [valet_park] destination_number(0724816442) =~ /^(park\+)?\*(59[0-9][0-9])$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->operator] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [operator] destination_number(0724816442) =~ /^0$|^operator$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->operator] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [operator] destination_number(0724816442) =~ /^0$|^operator$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->operator-forward] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [operator-forward] destination_number(0724816442) =~ /^\*000$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->operator-forward] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [operator-forward] destination_number(0724816442) =~ /^\*000$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->do-not-disturb] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [do-not-disturb] destination_number(0724816442) =~ /^\*77$/ break=on-true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [do-not-disturb] destination_number(0724816442) =~ /^\*78$|\*363$/ break=on-true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [do-not-disturb] destination_number(0724816442) =~ /^\*79$/ break=on-true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [do-not-disturb] destination_number(0724816442) =~ /^dnd\+500$/ break=on-true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->do-not-disturb] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [do-not-disturb] destination_number(0724816442) =~ /^\*77$/ break=on-true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [do-not-disturb] destination_number(0724816442) =~ /^\*78$|\*363$/ break=on-true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [do-not-disturb] destination_number(0724816442) =~ /^\*79$/ break=on-true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [do-not-disturb] destination_number(0724816442) =~ /^dnd\+500$/ break=on-true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->call-forward] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [call-forward] destination_number(0724816442) =~ /^\*72$/ break=on-true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [call-forward] destination_number(0724816442) =~ /^\*73$/ break=on-true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [call-forward] destination_number(0724816442) =~ /^\*74$/ break=on-true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [call-forward] destination_number(0724816442) =~ /^forward\+(\Q500\E)(?:\/(\d+))?$/ break=on-true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->call-forward] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [call-forward] destination_number(0724816442) =~ /^\*72$/ break=on-true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [call-forward] destination_number(0724816442) =~ /^\*73$/ break=on-true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [call-forward] destination_number(0724816442) =~ /^\*74$/ break=on-true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [call-forward] destination_number(0724816442) =~ /^forward\+(\Q500\E)(?:\/(\d+))?$/ break=on-true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->call forward all] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [call forward all] ${user_exists}(false) =~ /true/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->follow-me] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [follow-me] destination_number(0724816442) =~ /^\*21$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->follow-me] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [follow-me] destination_number(0724816442) =~ /^\*21$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->clear_sip_auto_answer] continue=true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [clear_sip_auto_answer] ${click_to_call}() =~ /true/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->talking clock date and time] continue=true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [talking clock date and time] destination_number(0724816442) =~ /^\*9172$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->clear_sip_auto_answer] continue=true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [clear_sip_auto_answer] ${click_to_call}() =~ /true/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->talking clock time] continue=true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [talking clock time] destination_number(0724816442) =~ /^\*9170$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->talking clock date] continue=true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [talking clock date] destination_number(0724816442) =~ /^\*9171$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->call_screen] continue=true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [call_screen] ${call_screen_enabled}(false) =~ /^true$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->call_screen] continue=true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [call_screen] ${call_screen_enabled}(false) =~ /^true$/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->local_extension] continue=true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [local_extension] ${user_exists}(false) =~ /true/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->local_extension] continue=true
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [local_extension] ${user_exists}(false) =~ /true/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->voicemail] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [voicemail] ${user_exists}(false) =~ /true/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->voicemail] continue=false
a08df345-2201-437c-94c2-e0a1823333ef Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [voicemail] ${user_exists}(false) =~ /true/ break=on-false
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.227583 [DEBUG] switch_core_state_machine.c:287 (sofia/internal/500@192.168.0.71:5064) State Change CS_ROUTING -> CS_EXECUTE
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.227583 [DEBUG] switch_core_state_machine.c:644 (sofia/internal/500@192.168.0.71:5064) State ROUTING going to sleep
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.227583 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/500@192.168.0.71:5064) Running State Change CS_EXECUTE (Cur 1 Tot 38203)
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.227583 [DEBUG] switch_core_state_machine.c:651 (sofia/internal/500@192.168.0.71:5064) State EXECUTE
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.227583 [DEBUG] mod_sofia.c:209 sofia/internal/500@192.168.0.71:5064 SOFIA EXECUTE
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.227583 [DEBUG] switch_core_state_machine.c:329 sofia/internal/500@192.168.0.71:5064 Standard EXECUTE
a08df345-2201-437c-94c2-e0a1823333ef EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(caller_id_number=500)
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.227583 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [caller_id_number]=[500]
a08df345-2201-437c-94c2-e0a1823333ef EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 export(origination_callee_id_name=0724816442)
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.227583 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [origination_callee_id_name]=[0724816442]
a08df345-2201-437c-94c2-e0a1823333ef EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(RFC2822_DATE=Mon, 13 Sep 2021 14:09:41 +0300)
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.227583 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [RFC2822_DATE]=[Mon, 13 Sep 2021 14:09:41 +0300]
a08df345-2201-437c-94c2-e0a1823333ef EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 export(origination_callee_id_name=0724816442)
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.227583 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [origination_callee_id_name]=[0724816442]
a08df345-2201-437c-94c2-e0a1823333ef EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(RFC2822_DATE=Mon, 13 Sep 2021 14:09:41 +0300)
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.227583 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [RFC2822_DATE]=[Mon, 13 Sep 2021 14:09:41 +0300]
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.227583 [INFO] switch_ivr_async.c:2645 Sending early media
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.227583 [DEBUG] switch_core_media.c:8659 AUDIO RTP [sofia/internal/500@192.168.0.71:5064] 192.168.0.71 port 17294 -> 192.168.0.111 port 8000 codec: 9 ms: 20
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.227583 [DEBUG] switch_rtp.c:4408 Starting timer [soft] 160 bytes per 20ms
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.227583 [DEBUG] switch_core_media.c:8973 sofia/internal/500@192.168.0.71:5064 Set 2833 dtmf send payload to 101
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.227583 [DEBUG] switch_core_media.c:8980 sofia/internal/500@192.168.0.71:5064 Set 2833 dtmf receive payload to 101
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.227583 [DEBUG] switch_core_media.c:9003 sofia/internal/500@192.168.0.71:5064 Set rtp dtmf delay to 40
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.227583 [DEBUG] mod_sofia.c:2593 Ring SDP:
a08df345-2201-437c-94c2-e0a1823333ef v=0
a08df345-2201-437c-94c2-e0a1823333ef o=FreeSWITCH 1631514087 1631514088 IN IP4 192.168.0.71
a08df345-2201-437c-94c2-e0a1823333ef s=FreeSWITCH
a08df345-2201-437c-94c2-e0a1823333ef c=IN IP4 192.168.0.71
a08df345-2201-437c-94c2-e0a1823333ef t=0 0
a08df345-2201-437c-94c2-e0a1823333ef m=audio 17294 RTP/AVP 9 101
a08df345-2201-437c-94c2-e0a1823333ef a=rtpmap:9 G722/8000
a08df345-2201-437c-94c2-e0a1823333ef a=rtpmap:101 telephone-event/8000
a08df345-2201-437c-94c2-e0a1823333ef a=fmtp:101 0-16
a08df345-2201-437c-94c2-e0a1823333ef a=ptime:20
a08df345-2201-437c-94c2-e0a1823333ef a=sendrecv
a08df345-2201-437c-94c2-e0a1823333ef
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.227583 [NOTICE] mod_sofia.c:2596 Pre-Answer sofia/internal/500@192.168.0.71:5064!
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.227583 [DEBUG] switch_channel.c:3565 (sofia/internal/500@192.168.0.71:5064) Callstate Change RINGING -> EARLY
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.247551 [DEBUG] switch_ivr_async.c:1352 Record session sample rate: 16000 -> 16000
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.247551 [DEBUG] switch_core_media_bug.c:970 Attaching BUG to sofia/internal/500@192.168.0.71:5064
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.247551 [DEBUG] sofia.c:7301 Channel sofia/internal/500@192.168.0.71:5064 entering state [early][183]
a08df345-2201-437c-94c2-e0a1823333ef EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(+OK Success
a08df345-2201-437c-94c2-e0a1823333ef )
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.247551 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [+OK Success
a08df345-2201-437c-94c2-e0a1823333ef ]=[UNDEF]
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.247551 [WARNING] switch_ivr_async.c:2662 Already recording [/var/lib/freeswitch/recordings/192.168.0.71/archive/2021/Sep/13/a08df345-2201-437c-94c2-e0a1823333ef.wav]
a08df345-2201-437c-94c2-e0a1823333ef EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(+OK Success
a08df345-2201-437c-94c2-e0a1823333ef )
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.247551 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [+OK Success
a08df345-2201-437c-94c2-e0a1823333ef ]=[UNDEF]
a08df345-2201-437c-94c2-e0a1823333ef EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 hash(insert/192.168.0.71-last_dial/500/0724816442)
a08df345-2201-437c-94c2-e0a1823333ef EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 hash(insert/192.168.0.71-last_dial/500/0724816442)
a08df345-2201-437c-94c2-e0a1823333ef EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 eval(not_secure)
a08df345-2201-437c-94c2-e0a1823333ef EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 eval(not_secure)
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.247551 [NOTICE] switch_core_state_machine.c:386 sofia/internal/500@192.168.0.71:5064 has executed the last dialplan instruction, hanging up.
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.247551 [NOTICE] switch_core_state_machine.c:388 Hangup sofia/internal/500@192.168.0.71:5064 [CS_EXECUTE] [NORMAL_CLEARING]
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.247551 [DEBUG] switch_core_state_machine.c:651 (sofia/internal/500@192.168.0.71:5064) State EXECUTE going to sleep
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.247551 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/500@192.168.0.71:5064) Running State Change CS_HANGUP (Cur 1 Tot 38203)
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.247551 [DEBUG] switch_channel.c:3604 sofia/internal/500@192.168.0.71:5064 skip receive message [AUDIO_SYNC] (channel is hungup already)
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.247551 [DEBUG] switch_ivr_async.c:1446 Stop recording file /var/lib/freeswitch/recordings/192.168.0.71/archive/2021/Sep/13/a08df345-2201-437c-94c2-e0a1823333ef.wav
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.247551 [DEBUG] switch_ivr_async.c:1521 Channel is hung up
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.247551 [DEBUG] switch_core_media_bug.c:1295 Removing BUG from sofia/internal/500@192.168.0.71:5064
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.247551 [DEBUG] switch_core_state_machine.c:848 (sofia/internal/500@192.168.0.71:5064) Callstate Change EARLY -> HANGUP
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.247551 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/500@192.168.0.71:5064) State HANGUP
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.247551 [DEBUG] mod_sofia.c:453 Channel sofia/internal/500@192.168.0.71:5064 hanging up, cause: NORMAL_CLEARING
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.247551 [DEBUG] mod_sofia.c:598 Responding to INVITE with: 480
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.247551 [DEBUG] switch_core_state_machine.c:60 sofia/internal/500@192.168.0.71:5064 Standard HANGUP, cause: NORMAL_CLEARING
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.247551 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/500@192.168.0.71:5064) State HANGUP going to sleep
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.247551 [DEBUG] switch_core_state_machine.c:620 (sofia/internal/500@192.168.0.71:5064) State Change CS_HANGUP -> CS_REPORTING
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.247551 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/500@192.168.0.71:5064) Running State Change CS_REPORTING (Cur 1 Tot 38203)
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.247551 [DEBUG] switch_core_state_machine.c:936 (sofia/internal/500@192.168.0.71:5064) State REPORTING
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.287538 [DEBUG] switch_core_state_machine.c:174 sofia/internal/500@192.168.0.71:5064 Standard REPORTING, cause: NORMAL_CLEARING
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.287538 [DEBUG] switch_core_state_machine.c:936 (sofia/internal/500@192.168.0.71:5064) State REPORTING going to sleep
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.287538 [DEBUG] switch_core_state_machine.c:611 (sofia/internal/500@192.168.0.71:5064) State Change CS_REPORTING -> CS_DESTROY
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.287538 [DEBUG] switch_core_session.c:1726 Session 38203 (sofia/internal/500@192.168.0.71:5064) Locked, Waiting on external entities
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.287538 [NOTICE] switch_core_session.c:1744 Session 38203 (sofia/internal/500@192.168.0.71:5064) Ended
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.287538 [NOTICE] switch_core_session.c:1748 Close Channel sofia/internal/500@192.168.0.71:5064 [CS_DESTROY]
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.287538 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/500@192.168.0.71:5064) Running State Change CS_DESTROY (Cur 0 Tot 38203)
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.287538 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/500@192.168.0.71:5064) State DESTROY
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.287538 [DEBUG] mod_sofia.c:364 sofia/internal/500@192.168.0.71:5064 SOFIA DESTROY
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.287538 [DEBUG] switch_core_state_machine.c:181 sofia/internal/500@192.168.0.71:5064 Standard DESTROY
a08df345-2201-437c-94c2-e0a1823333ef 2021-09-13 14:09:41.287538 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/500@192.168.0.71:5064) State DESTROY going to sleep
 
sfer]=[true]
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action set(record_append=true) INLINE
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(record_append=true)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [record_append]=[true]
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action set(record_in_progress=true) INLINE
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(record_in_progress=true)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [record_in_progress]=[true]
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action set(${uuid_record ${uuid} start ${record_path}/${record_name}})
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->redial] continue=true
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [redial] destination_number(0724816442) =~ /^(redial|\*870)$/ break=on-true
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (PASS) [redial] () =~ // break=never
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->redial] continue=true
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [redial] destination_number(0724816442) =~ /^(redial|\*870)$/ break=on-true
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (PASS) [redial] () =~ // break=never
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->speed_dial] continue=false
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [speed_dial] destination_number(0724816442) =~ /^\*0(.*)$/ break=on-false
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->speed_dial] continue=false
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (FAIL) [speed_dial] destination_number(0724816442) =~ /^\*0(.*)$/ break=on-false
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->default_caller_id] continue=true
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (PASS) [default_caller_id] ${emergency_caller_id_number}() =~ /^$/ break=never
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action set(emergency_caller_id_name=${default_emergency_caller_id_name}) INLINE
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(emergency_caller_id_name=)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [emergency_caller_id_name]=[UNDEF]
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action set(emergency_caller_id_number=${default_emergency_caller_id_number}) INLINE
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(emergency_caller_id_number=)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [emergency_caller_id_number]=[UNDEF]
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (PASS) [default_caller_id] ${outbound_caller_id_number}() =~ /^$/ break=never
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action set(outbound_caller_id_name=${default_outbound_caller_id_name}) INLINE
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(outbound_caller_id_name=)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [outbound_caller_id_name]=[UNDEF]
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action set(outbound_caller_id_number=${default_outbound_caller_id_number}) INLINE
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(outbound_caller_id_number=)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [outbound_caller_id_number]=[UNDEF]
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->default_caller_id] continue=true
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (PASS) [default_caller_id] ${emergency_caller_id_number}() =~ /^$/ break=never
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action set(emergency_caller_id_name=${default_emergency_caller_id_name}) INLINE
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(emergency_caller_id_name=)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [emergency_caller_id_name]=[UNDEF]
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action set(emergency_caller_id_number=${default_emergency_caller_id_number}) INLINE
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(emergency_caller_id_number=)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [emergency_caller_id_number]=[UNDEF]
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (PASS) [default_caller_id] ${outbound_caller_id_number}() =~ /^$/ break=never
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action set(outbound_caller_id_name=${default_outbound_caller_id_name}) INLINE
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(outbound_caller_id_name=)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [outbound_caller_id_name]=[UNDEF]
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action set(outbound_caller_id_number=${default_outbound_caller_id_number}) INLINE
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(outbound_caller_id_number=)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [outbound_caller_id_number]=[UNDEF]
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 parsing [192.168.0.71->Safaricom.10d] continue=false
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (PASS) [Safaricom.10d] ${user_exists}(false) =~ /false/ break=on-false
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Regex (PASS) [Safaricom.10d] destination_number(0724816442) =~ /^(\d{10})$/ break=on-false
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action set(sip_h_X-accountcode=${accountcode})
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action export(call_direction=outbound)
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action unset(call_timeout)
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action set(hangup_after_bridge=true)
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action set(effective_caller_id_name=${outbound_caller_id_name})
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action set(effective_caller_id_number=${outbound_caller_id_number})
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action set(inherit_codec=true)
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action set(ignore_display_updates=true)
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action set(callee_id_number=0724816442)
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action set(continue_on_fail=true)
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action limit(hash ${domain_name} outbound 1 !USER_BUSY)
c78a04e9-586e-47a8-b30c-db6090ae5e36 Dialplan: sofia/internal/500@192.168.0.71:5064 Action bridge(sofia/gateway/ec149e9c-2277-478a-8321-a5d9ee0a70ac/0724816442)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] switch_core_state_machine.c:287 (sofia/internal/500@192.168.0.71:5064) State Change CS_ROUTING -> CS_EXECUTE
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] switch_core_state_machine.c:644 (sofia/internal/500@192.168.0.71:5064) State ROUTING going to sleep
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/500@192.168.0.71:5064) Running State Change CS_EXECUTE (Cur 1 Tot 38211)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] switch_core_state_machine.c:651 (sofia/internal/500@192.168.0.71:5064) State EXECUTE
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] mod_sofia.c:209 sofia/internal/500@192.168.0.71:5064 SOFIA EXECUTE
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] switch_core_state_machine.c:329 sofia/internal/500@192.168.0.71:5064 Standard EXECUTE
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(caller_id_number=500)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [caller_id_number]=[500]
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 export(origination_callee_id_name=0724816442)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [origination_callee_id_name]=[0724816442]
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(RFC2822_DATE=Mon, 13 Sep 2021 14:34:49 +0300)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [RFC2822_DATE]=[Mon, 13 Sep 2021 14:34:49 +0300]
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 export(origination_callee_id_name=0724816442)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [origination_callee_id_name]=[0724816442]
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(RFC2822_DATE=Mon, 13 Sep 2021 14:34:49 +0300)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [RFC2822_DATE]=[Mon, 13 Sep 2021 14:34:49 +0300]
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [INFO] switch_ivr_async.c:2645 Sending early media
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] switch_core_media.c:8659 AUDIO RTP [sofia/internal/500@192.168.0.71:5064] 192.168.0.71 port 22776 -> 192.168.0.111 port 8000 codec: 9 ms: 20
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] switch_rtp.c:4408 Starting timer [soft] 160 bytes per 20ms
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] switch_core_media.c:8973 sofia/internal/500@192.168.0.71:5064 Set 2833 dtmf send payload to 101
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] switch_core_media.c:8980 sofia/internal/500@192.168.0.71:5064 Set 2833 dtmf receive payload to 101
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] switch_core_media.c:9003 sofia/internal/500@192.168.0.71:5064 Set rtp dtmf delay to 40
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] mod_sofia.c:2593 Ring SDP:
c78a04e9-586e-47a8-b30c-db6090ae5e36 v=0
c78a04e9-586e-47a8-b30c-db6090ae5e36 o=FreeSWITCH 1631510113 1631510114 IN IP4 192.168.0.71
c78a04e9-586e-47a8-b30c-db6090ae5e36 s=FreeSWITCH
c78a04e9-586e-47a8-b30c-db6090ae5e36 c=IN IP4 192.168.0.71
c78a04e9-586e-47a8-b30c-db6090ae5e36 t=0 0
c78a04e9-586e-47a8-b30c-db6090ae5e36 m=audio 22776 RTP/AVP 9 101
c78a04e9-586e-47a8-b30c-db6090ae5e36 a=rtpmap:9 G722/8000
c78a04e9-586e-47a8-b30c-db6090ae5e36 a=rtpmap:101 telephone-event/8000
c78a04e9-586e-47a8-b30c-db6090ae5e36 a=fmtp:101 0-16
c78a04e9-586e-47a8-b30c-db6090ae5e36 a=ptime:20
c78a04e9-586e-47a8-b30c-db6090ae5e36 a=sendrecv
c78a04e9-586e-47a8-b30c-db6090ae5e36
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [NOTICE] mod_sofia.c:2596 Pre-Answer sofia/internal/500@192.168.0.71:5064!
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.687586 [DEBUG] switch_channel.c:3565 (sofia/internal/500@192.168.0.71:5064) Callstate Change RINGING -> EARLY
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] switch_ivr_async.c:1352 Record session sample rate: 16000 -> 16000
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] switch_core_media_bug.c:970 Attaching BUG to sofia/internal/500@192.168.0.71:5064
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] sofia.c:7301 Channel sofia/internal/500@192.168.0.71:5064 entering state [early][183]
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(+OK Success
c78a04e9-586e-47a8-b30c-db6090ae5e36 )
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [+OK Success
c78a04e9-586e-47a8-b30c-db6090ae5e36 ]=[UNDEF]
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [WARNING] switch_ivr_async.c:2662 Already recording [/var/lib/freeswitch/recordings/192.168.0.71/archive/2021/Sep/13/c78a04e9-586e-47a8-b30c-db6090ae5e36.wav]
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(+OK Success
c78a04e9-586e-47a8-b30c-db6090ae5e36 )
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [+OK Success
c78a04e9-586e-47a8-b30c-db6090ae5e36 ]=[UNDEF]
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 hash(insert/192.168.0.71-last_dial/500/0724816442)
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 hash(insert/192.168.0.71-last_dial/500/0724816442)
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(sip_h_X-accountcode=)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [sip_h_X-accountcode]=[UNDEF]
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 export(call_direction=outbound)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [call_direction]=[outbound]
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 unset(call_timeout)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] mod_dptools.c:1817 UNSET [call_timeout]
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(hangup_after_bridge=true)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [hangup_after_bridge]=[true]
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(effective_caller_id_name=)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [effective_caller_id_name]=[UNDEF]
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(effective_caller_id_number=)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [effective_caller_id_number]=[UNDEF]
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(inherit_codec=true)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [inherit_codec]=[true]
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(ignore_display_updates=true)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [ignore_display_updates]=[true]
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(callee_id_number=0724816442)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [callee_id_number]=[0724816442]
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 set(continue_on_fail=true)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] mod_dptools.c:1672 SET sofia/internal/500@192.168.0.71:5064 [continue_on_fail]=[true]
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 limit(hash 192.168.0.71 outbound 1 !USER_BUSY)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] switch_limit.c:124 incr called: 192.168.0.71_outbound max:1, interval:0
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] mod_hash.c:196 Usage for 192.168.0.71_outbound is now 1/1
c78a04e9-586e-47a8-b30c-db6090ae5e36 EXECUTE [depth=0] sofia/internal/500@192.168.0.71:5064 bridge(sofia/gateway/ec149e9c-2277-478a-8321-a5d9ee0a70ac/0724816442)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] switch_channel.c:1264 sofia/internal/500@192.168.0.71:5064 EXPORTING[export_vars] [domain_name]=[192.168.0.71] to event
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] switch_channel.c:1264 sofia/internal/500@192.168.0.71:5064 EXPORTING[export_vars] [call_direction]=[outbound] to event
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] switch_channel.c:1264 sofia/internal/500@192.168.0.71:5064 EXPORTING[export_vars] [origination_callee_id_name]=[0724816442] to event
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] switch_channel.c:1264 sofia/internal/500@192.168.0.71:5064 EXPORTING[export_vars] [origination_callee_id_name]=[0724816442] to event
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] switch_channel.c:1264 sofia/internal/500@192.168.0.71:5064 EXPORTING[export_vars] [call_direction]=[outbound] to event
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] switch_ivr_originate.c:2212 Parsing global variables
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:49.707585 [NOTICE] switch_channel.c:1118 New Channel sofia/external/0724816442 [36fa2b14-ac5a-493a-9dfe-73eb98f5bf02]
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:49.707585 [DEBUG] mod_sofia.c:5089 (sofia/external/0724816442) State Change CS_NEW -> CS_INIT
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:49.707585 [DEBUG] switch_core_state_machine.c:585 (sofia/external/0724816442) Running State Change CS_INIT (Cur 2 Tot 38212)
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:49.707585 [DEBUG] switch_core_state_machine.c:628 (sofia/external/0724816442) State INIT
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:49.707585 [DEBUG] mod_sofia.c:93 sofia/external/0724816442 SOFIA INIT
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:49.707585 [DEBUG] sofia_glue.c:1618 sofia/external/0724816442 sending invite version: 1.10.2 -release-13-f7bdd3845a 64bit
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 Local SDP:
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 v=0
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 o=FreeSWITCH 1631500391 1631500392 IN IP4 10.221.6.218
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 s=FreeSWITCH
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 c=IN IP4 10.221.6.218
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 t=0 0
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 m=audio 32498 RTP/AVP 9 0 8 101 13
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 a=rtpmap:9 G722/8000
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 a=rtpmap:0 PCMU/8000
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 a=rtpmap:8 PCMA/8000
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 a=rtpmap:101 telephone-event/8000
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 a=fmtp:101 0-16
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 a=rtpmap:13 CN/8000
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 a=ptime:20
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 a=sendrecv
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:49.707585 [DEBUG] switch_core_state_machine.c:40 sofia/external/0724816442 Standard INIT
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:49.707585 [DEBUG] switch_core_state_machine.c:48 (sofia/external/0724816442) State Change CS_INIT -> CS_ROUTING
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:49.707585 [DEBUG] switch_core_state_machine.c:628 (sofia/external/0724816442) State INIT going to sleep
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:49.707585 [DEBUG] switch_core_state_machine.c:585 (sofia/external/0724816442) Running State Change CS_ROUTING (Cur 2 Tot 38212)
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:49.707585 [DEBUG] sofia.c:7301 Channel sofia/external/0724816442 entering state [calling][0]
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:49.707585 [DEBUG] switch_core_state_machine.c:644 (sofia/external/0724816442) State ROUTING
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:49.707585 [DEBUG] mod_sofia.c:154 sofia/external/0724816442 SOFIA ROUTING
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:49.707585 [DEBUG] switch_ivr_originate.c:67 (sofia/external/0724816442) State Change CS_ROUTING -> CS_CONSUME_MEDIA
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:49.707585 [DEBUG] switch_core_state_machine.c:644 (sofia/external/0724816442) State ROUTING going to sleep
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:49.707585 [DEBUG] switch_core_state_machine.c:585 (sofia/external/0724816442) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 38212)
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:49.707585 [DEBUG] switch_core_state_machine.c:663 (sofia/external/0724816442) State CONSUME_MEDIA
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:49.707585 [DEBUG] switch_core_state_machine.c:663 (sofia/external/0724816442) State CONSUME_MEDIA going to sleep
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:49.707585 [DEBUG] switch_ivr_async.c:1641 No silence detection configured; assuming start of speech
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:52.767622 [DEBUG] sofia.c:7301 Channel sofia/external/0724816442 entering state [terminated][503]
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:52.767622 [NOTICE] sofia.c:8534 Hangup sofia/external/0724816442 [CS_CONSUME_MEDIA] [NORMAL_TEMPORARY_FAILURE]
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:52.787593 [DEBUG] switch_core_state_machine.c:585 (sofia/external/0724816442) Running State Change CS_HANGUP (Cur 2 Tot 38212)
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:52.787593 [DEBUG] switch_core_state_machine.c:848 (sofia/external/0724816442) Callstate Change DOWN -> HANGUP
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:52.787593 [DEBUG] switch_core_state_machine.c:850 (sofia/external/0724816442) State HANGUP
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:52.787593 [DEBUG] mod_sofia.c:453 Channel sofia/external/0724816442 hanging up, cause: NORMAL_TEMPORARY_FAILURE
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:52.787593 [DEBUG] switch_core_state_machine.c:60 sofia/external/0724816442 Standard HANGUP, cause: NORMAL_TEMPORARY_FAILURE
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:52.787593 [DEBUG] switch_core_state_machine.c:850 (sofia/external/0724816442) State HANGUP going to sleep
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:52.787593 [DEBUG] switch_core_state_machine.c:620 (sofia/external/0724816442) State Change CS_HANGUP -> CS_REPORTING
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:52.787593 [DEBUG] switch_core_state_machine.c:585 (sofia/external/0724816442) Running State Change CS_REPORTING (Cur 2 Tot 38212)
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:52.787593 [DEBUG] switch_core_state_machine.c:936 (sofia/external/0724816442) State REPORTING
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:52.787593 [DEBUG] switch_core_state_machine.c:174 sofia/external/0724816442 Standard REPORTING, cause: NORMAL_TEMPORARY_FAILURE
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:52.787593 [DEBUG] switch_core_state_machine.c:936 (sofia/external/0724816442) State REPORTING going to sleep
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:52.787593 [DEBUG] switch_core_state_machine.c:611 (sofia/external/0724816442) State Change CS_REPORTING -> CS_DESTROY
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:52.787593 [DEBUG] switch_core_session.c:1726 Session 38212 (sofia/external/0724816442) Locked, Waiting on external entities
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.787593 [DEBUG] switch_ivr_originate.c:3952 Originate Resulted in Error Cause: 41 [NORMAL_TEMPORARY_FAILURE]
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:52.787593 [NOTICE] switch_core_session.c:1744 Session 38212 (sofia/external/0724816442) Ended
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:52.787593 [NOTICE] switch_core_session.c:1748 Close Channel sofia/external/0724816442 [CS_DESTROY]
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:52.787593 [DEBUG] switch_core_state_machine.c:739 (sofia/external/0724816442) Running State Change CS_DESTROY (Cur 1 Tot 38212)
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:52.787593 [DEBUG] switch_core_state_machine.c:749 (sofia/external/0724816442) State DESTROY
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:52.787593 [DEBUG] mod_sofia.c:364 sofia/external/0724816442 SOFIA DESTROY
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:52.787593 [DEBUG] switch_core_state_machine.c:181 sofia/external/0724816442 Standard DESTROY
36fa2b14-ac5a-493a-9dfe-73eb98f5bf02 2021-09-13 14:34:52.787593 [DEBUG] switch_core_state_machine.c:749 (sofia/external/0724816442) State DESTROY going to sleep
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.787593 [INFO] mod_dptools.c:3631 Originate Failed. Cause: NORMAL_TEMPORARY_FAILURE
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.787593 [NOTICE] switch_core_state_machine.c:386 sofia/internal/500@192.168.0.71:5064 has executed the last dialplan instruction, hanging up.
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.787593 [NOTICE] switch_core_state_machine.c:388 Hangup sofia/internal/500@192.168.0.71:5064 [CS_EXECUTE] [NORMAL_CLEARING]
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.787593 [DEBUG] mod_hash.c:297 Usage for 192.168.0.71_outbound is now 0
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.787593 [DEBUG] switch_core_state_machine.c:651 (sofia/internal/500@192.168.0.71:5064) State EXECUTE going to sleep
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.787593 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/500@192.168.0.71:5064) Running State Change CS_HANGUP (Cur 1 Tot 38212)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.787593 [DEBUG] switch_ivr_async.c:1446 Stop recording file /var/lib/freeswitch/recordings/192.168.0.71/archive/2021/Sep/13/c78a04e9-586e-47a8-b30c-db6090ae5e36.wav
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.807598 [DEBUG] switch_ivr_async.c:1521 Channel is hung up
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.807598 [DEBUG] switch_core_media_bug.c:1295 Removing BUG from sofia/internal/500@192.168.0.71:5064
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.807598 [DEBUG] switch_core_state_machine.c:848 (sofia/internal/500@192.168.0.71:5064) Callstate Change EARLY -> HANGUP
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.807598 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/500@192.168.0.71:5064) State HANGUP
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.807598 [DEBUG] mod_sofia.c:447 sofia/internal/500@192.168.0.71:5064 Overriding SIP cause 480 with 503 from the other leg
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.807598 [DEBUG] mod_sofia.c:453 Channel sofia/internal/500@192.168.0.71:5064 hanging up, cause: NORMAL_CLEARING
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.807598 [DEBUG] mod_sofia.c:598 Responding to INVITE with: 503
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.807598 [DEBUG] switch_core_state_machine.c:60 sofia/internal/500@192.168.0.71:5064 Standard HANGUP, cause: NORMAL_CLEARING
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.807598 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/500@192.168.0.71:5064) State HANGUP going to sleep
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.807598 [DEBUG] switch_core_state_machine.c:620 (sofia/internal/500@192.168.0.71:5064) State Change CS_HANGUP -> CS_REPORTING
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.807598 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/500@192.168.0.71:5064) Running State Change CS_REPORTING (Cur 1 Tot 38212)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.807598 [DEBUG] switch_core_state_machine.c:936 (sofia/internal/500@192.168.0.71:5064) State REPORTING
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.867565 [DEBUG] switch_core_state_machine.c:174 sofia/internal/500@192.168.0.71:5064 Standard REPORTING, cause: NORMAL_CLEARING
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.867565 [DEBUG] switch_core_state_machine.c:936 (sofia/internal/500@192.168.0.71:5064) State REPORTING going to sleep
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.867565 [DEBUG] switch_core_state_machine.c:611 (sofia/internal/500@192.168.0.71:5064) State Change CS_REPORTING -> CS_DESTROY
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.867565 [DEBUG] switch_core_session.c:1726 Session 38211 (sofia/internal/500@192.168.0.71:5064) Locked, Waiting on external entities
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.867565 [NOTICE] switch_core_session.c:1744 Session 38211 (sofia/internal/500@192.168.0.71:5064) Ended
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.867565 [NOTICE] switch_core_session.c:1748 Close Channel sofia/internal/500@192.168.0.71:5064 [CS_DESTROY]
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.867565 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/500@192.168.0.71:5064) Running State Change CS_DESTROY (Cur 0 Tot 38212)
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.867565 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/500@192.168.0.71:5064) State DESTROY
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.867565 [DEBUG] mod_sofia.c:364 sofia/internal/500@192.168.0.71:5064 SOFIA DESTROY
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.867565 [DEBUG] switch_core_state_machine.c:181 sofia/internal/500@192.168.0.71:5064 Standard DESTROY
c78a04e9-586e-47a8-b30c-db6090ae5e36 2021-09-13 14:34:52.867565 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/500@192.168.0.71:5064) State DESTROY going to sleep
 
Status
Not open for further replies.
Top Bottom