Hi, all i have a GrandStream 4104 perfectly working (both incoming and outgoing calls work great) with an asterisk pbx. We are trying to change the asterisk with freeswitch, but i'm exeperiencing problems in configuring freeswitch for outgoing calls, incoming calls works well. this is my configuration and what i obtain in fs_cli consolle Can someone tell me where i'm wrong? in sip_profile/internal i created a file 00_to_pstn.xml this way <include> <gateway name="gxw4104-fxo1"> <param name="username" value="1019"/> <param name="realm" value="192.168.0.3"/> <param name="sip-port" value="5060"/> <param name="rtp_ip" value="192.168.0.3"/> <param name="dtmf-type" value="rfc2833"/> <param name="expire-seconds" value="600"/> <param name="register" value="false"/> <param name="caller-id-in-from" value="true"/> </gateway> </include> in dialplan/default i created a file 00_to_pstn.xml this way <include> <extension name="gxw4104-fxo-local"> <condition field="${toll_allow}" expression="local"/> <condition field="destination_number" expression="^(\d{6,})$"> <action application="set" data="effective_caller_id_number=0321234567"/> <action application="set" data="effective_caller_id_name=ThisIsMyCompany"/> <action application="set" data="ignore_early_media=ring_ready"/> <action application="set" data="ringback=${us-ring}"/> <action application="bridge" data="sofia/internal/gxw4104-fxo1/$1@192.168.0.3:5060"/> </condition> </extension> </include> _________________________________________________________________ 2012-03-23 10:38:43.937574 [DEBUG] sofia.c:7559 IP 192.168.0.200 Rejected by acl "domains". Falling back to Digest auth. 2012-03-23 10:38:43.937574 [DEBUG] sofia.c:7559 IP 192.168.0.200 Rejected by acl "domains". Falling back to Digest auth. 2012-03-23 10:38:43.937574 [NOTICE] switch_channel.c:926 New Channel sofia/internal/1000@192.168.0.2 [fb33155c-74cb-11e1-9063-fb6a5f4599fb] 2012-03-23 10:38:43.937574 [DEBUG] sofia.c:5526 Channel sofia/internal/1000@192.168.0.2 entering state [received][100] 2012-03-23 10:38:43.937574 [DEBUG] sofia.c:5537 Remote SDP: v=0 o=- 935122583 0 IN IP4 192.168.0.200 s=SIPPER for PhonerLite c=IN IP4 192.168.0.200 t=0 0 m=audio 5062 RTP/AVP 8 3 0 101 a=rtpmap:8 PCMA/8000 a=rtpmap:3 GSM/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 2012-03-23 10:38:43.937574 [DEBUG] sofia_glue.c:4874 Audio Codec Compare [PCMA:8:8000:20:64000]/[G7221:115:32000:20:48000] 2012-03-23 10:38:43.937574 [DEBUG] sofia_glue.c:4874 Audio Codec Compare [PCMA:8:8000:20:64000]/[G7221:107:16000:20:32000] 2012-03-23 10:38:43.937574 [DEBUG] sofia_glue.c:4874 Audio Codec Compare [PCMA:8:8000:20:64000]/[G722:9:8000:20:64000] 2012-03-23 10:38:43.937574 [DEBUG] sofia_glue.c:4874 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMU:0:8000:20:64000] 2012-03-23 10:38:43.937574 [DEBUG] sofia_glue.c:4874 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMA:8:8000:20:64000] 2012-03-23 10:38:43.937574 [DEBUG] sofia_glue.c:2991 Set Codec sofia/internal/1000@192.168.0.2 PCMA/8000 20 ms 160 samples 64000 bits 2012-03-23 10:38:43.937574 [DEBUG] switch_core_codec.c:111 sofia/internal/1000@192.168.0.2 Original read codec set to PCMA:8 2012-03-23 10:38:43.937574 [DEBUG] sofia_glue.c:4995 Set 2833 dtmf send/recv payload to 101 2012-03-23 10:38:43.937574 [DEBUG] sofia.c:5749 (sofia/internal/1000@192.168.0.2) State Change CS_NEW -> CS_INIT 2012-03-23 10:38:43.937574 [DEBUG] switch_core_session.c:1180 Send signal sofia/internal/1000@192.168.0.2 [BREAK] 2012-03-23 10:38:43.937574 [DEBUG] switch_core_state_machine.c:362 (sofia/internal/1000@192.168.0.2) Running State Change CS_INIT 2012-03-23 10:38:43.937574 [DEBUG] switch_core_state_machine.c:401 (sofia/internal/1000@192.168.0.2) State INIT 2012-03-23 10:38:43.937574 [DEBUG] mod_sofia.c:85 sofia/internal/1000@192.168.0.2 SOFIA INIT 2012-03-23 10:38:43.937574 [DEBUG] mod_sofia.c:125 (sofia/internal/1000@192.168.0.2) State Change CS_INIT -> CS_ROUTING 2012-03-23 10:38:43.937574 [DEBUG] switch_core_session.c:1180 Send signal sofia/internal/1000@192.168.0.2 [BREAK] 2012-03-23 10:38:43.937574 [DEBUG] switch_core_state_machine.c:401 (sofia/internal/1000@192.168.0.2) State INIT going to sleep 2012-03-23 10:38:43.937574 [DEBUG] switch_core_state_machine.c:362 (sofia/internal/1000@192.168.0.2) Running State Change CS_ROUTING 2012-03-23 10:38:43.937574 [DEBUG] switch_channel.c:1886 (sofia/internal/1000@192.168.0.2) Callstate Change DOWN -> RINGING 2012-03-23 10:38:43.937574 [DEBUG] switch_core_state_machine.c:410 (sofia/internal/1000@192.168.0.2) State ROUTING 2012-03-23 10:38:43.937574 [DEBUG] mod_sofia.c:148 sofia/internal/1000@192.168.0.2 SOFIA ROUTING 2012-03-23 10:38:43.937574 [DEBUG] switch_core_state_machine.c:104 sofia/internal/1000@192.168.0.2 Standard ROUTING 2012-03-23 10:38:43.937574 [INFO] mod_dialplan_xml.c:485 Processing 1000 <1000>->339XXXXXXX in context default Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->unloop] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->tod_example] continue=true Dialplan: sofia/internal/1000@192.168.0.2 Date/Time Match (PASS) [tod_example] break=on-false Dialplan: sofia/internal/1000@192.168.0.2 Action set(open=true) Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->holiday_example] continue=true Dialplan: sofia/internal/1000@192.168.0.2 Date/TimeMatch (FAIL) [holiday_example] break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->global-intercept] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [global-intercept] destination_number(339XXXXXXX) =~ /^886$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->group-intercept] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [group-intercept] destination_number(339XXXXXXX) =~ /^\*8$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->intercept-ext] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [intercept-ext] destination_number(339XXXXXXX) =~ /^\*\*(\d+)$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->redial] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [redial] destination_number(339XXXXXXX) =~ /^(redial|870)$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->global] continue=true Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [global] ${sip_has_crypto}() =~ /^(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)$/ break=never Dialplan: sofia/internal/1000@192.168.0.2 Absolute Condition [global] Dialplan: sofia/internal/1000@192.168.0.2 Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid}) Dialplan: sofia/internal/1000@192.168.0.2 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number}) Dialplan: sofia/internal/1000@192.168.0.2 Action hash(insert/${domain_name}-last_dial/global/${uuid}) Dialplan: sofia/internal/1000@192.168.0.2 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->snom-demo-2] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [snom-demo-2] destination_number(339XXXXXXX) =~ /^9001$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->snom-demo-1] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [snom-demo-1] destination_number(339XXXXXXX) =~ /^9000$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->eavesdrop] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [eavesdrop] destination_number(339XXXXXXX) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->eavesdrop] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [eavesdrop] destination_number(339XXXXXXX) =~ /^779$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->call_return] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [call_return] destination_number(339XXXXXXX) =~ /^\*69$|^869$|^lcr$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->del-group] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [del-group] destination_number(339XXXXXXX) =~ /^80(\d{2})$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->add-group] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [add-group] destination_number(339XXXXXXX) =~ /^81(\d{2})$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->call-group-simo] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [call-group-simo] destination_number(339XXXXXXX) =~ /^82(\d{2})$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->call-group-order] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [call-group-order] destination_number(339XXXXXXX) =~ /^83(\d{2})$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->extension-intercom] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [extension-intercom] destination_number(339XXXXXXX) =~ /^8(10[01][0-9])$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->Local_Extension] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [Local_Extension] destination_number(339XXXXXXX) =~ /^(10[01][0-9])$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->Local_Extension_Skinny] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [Local_Extension_Skinny] destination_number(339XXXXXXX) =~ /^(11[01][0-9])$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->group_dial_sales] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [group_dial_sales] destination_number(339XXXXXXX) =~ /^2000$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->group_dial_support] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [group_dial_support] destination_number(339XXXXXXX) =~ /^2001$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->group_dial_billing] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [group_dial_billing] destination_number(339XXXXXXX) =~ /^2002$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->operator] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [operator] destination_number(339XXXXXXX) =~ /^(operator|0)$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->vmain] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [vmain] destination_number(339XXXXXXX) =~ /^vmain$|^4000$|^\*98$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->sip_uri] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [sip_uri] destination_number(339XXXXXXX) =~ /^sip:(.*)$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->nb_conferences] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [nb_conferences] destination_number(339XXXXXXX) =~ /^(30\d{2})$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->wb_conferences] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [wb_conferences] destination_number(339XXXXXXX) =~ /^(31\d{2})$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->uwb_conferences] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [uwb_conferences] destination_number(339XXXXXXX) =~ /^(32\d{2})$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->cdquality_conferences] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [cdquality_conferences] destination_number(339XXXXXXX) =~ /^(33\d{2})$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->freeswitch_public_conf_via_sip] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [freeswitch_public_conf_via_sip] destination_number(339XXXXXXX) =~ /^9(888|8888|1616|3232)$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->mad_boss_intercom] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [mad_boss_intercom] destination_number(339XXXXXXX) =~ /^0911$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->mad_boss_intercom] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [mad_boss_intercom] destination_number(339XXXXXXX) =~ /^0912$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->mad_boss] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [mad_boss] destination_number(339XXXXXXX) =~ /^0913$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->ivr_demo] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [ivr_demo] destination_number(339XXXXXXX) =~ /^5000$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->dynamic_conference] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [dynamic_conference] destination_number(339XXXXXXX) =~ /^5001$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->rtp_multicast_page] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [rtp_multicast_page] destination_number(339XXXXXXX) =~ /^pagegroup$|^7243$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->park] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [park] destination_number(339XXXXXXX) =~ /^5900$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->unpark] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [unpark] destination_number(339XXXXXXX) =~ /^5901$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->valet_park] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [valet_park] destination_number(339XXXXXXX) =~ /^(6000)$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->valet_park] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [valet_park] destination_number(339XXXXXXX) =~ /^(60\d[1-9])$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->park] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (PASS) [park] source(mod_sofia) =~ /mod_sofia/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [park] destination_number(339XXXXXXX) =~ /park\+(\d+)/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->unpark] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (PASS) [unpark] source(mod_sofia) =~ /mod_sofia/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [unpark] destination_number(339XXXXXXX) =~ /^parking$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->park] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (PASS) [park] source(mod_sofia) =~ /mod_sofia/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [park] destination_number(339XXXXXXX) =~ /callpark/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->unpark] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (PASS) [unpark] source(mod_sofia) =~ /mod_sofia/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [unpark] destination_number(339XXXXXXX) =~ /pickup/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->wait] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [wait] destination_number(339XXXXXXX) =~ /^wait$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->fax_receive] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [fax_receive] destination_number(339XXXXXXX) =~ /^9178$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->fax_transmit] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [fax_transmit] destination_number(339XXXXXXX) =~ /^9179$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->ringback_180] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [ringback_180] destination_number(339XXXXXXX) =~ /^9180$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->ringback_183_uk_ring] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [ringback_183_uk_ring] destination_number(339XXXXXXX) =~ /^9181$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->ringback_183_music_ring] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [ringback_183_music_ring] destination_number(339XXXXXXX) =~ /^9182$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->ringback_post_answer_uk_ring] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [ringback_post_answer_uk_ring] destination_number(339XXXXXXX) =~ /^9183$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->ringback_post_answer_music] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [ringback_post_answer_music] destination_number(339XXXXXXX) =~ /^9184$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->ClueCon] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [ClueCon] destination_number(339XXXXXXX) =~ /^9191$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->show_info] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [show_info] destination_number(339XXXXXXX) =~ /^9192$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->video_record] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [video_record] destination_number(339XXXXXXX) =~ /^9193$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->video_playback] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [video_playback] destination_number(339XXXXXXX) =~ /^9194$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->delay_echo] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [delay_echo] destination_number(339XXXXXXX) =~ /^9195$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->echo] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [echo] destination_number(339XXXXXXX) =~ /^9196$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->milliwatt] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [milliwatt] destination_number(339XXXXXXX) =~ /^9197$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->tone_stream] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [tone_stream] destination_number(339XXXXXXX) =~ /^9198$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->zrtp_enrollement] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [zrtp_enrollement] destination_number(339XXXXXXX) =~ /^9787$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->hold_music] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [hold_music] destination_number(339XXXXXXX) =~ /^9664$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->from_pstn] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [from_pstn] destination_number(339XXXXXXX) =~ /^0000$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->101] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [101] destination_number(339XXXXXXX) =~ /^101$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->pizza_demo] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (FAIL) [pizza_demo] destination_number(339XXXXXXX) =~ /^(pizza|74992)$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 parsing [default->gxw4104-fxo-local] continue=false Dialplan: sofia/internal/1000@192.168.0.2 Regex (PASS) [gxw4104-fxo-local] ${toll_allow}(domestic,international,local) =~ /local/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 Regex (PASS) [gxw4104-fxo-local] destination_number(339XXXXXXX) =~ /^(\d{6,})$/ break=on-false Dialplan: sofia/internal/1000@192.168.0.2 Action set(effective_caller_id_number=0321234567) Dialplan: sofia/internal/1000@192.168.0.2 Action set(effective_caller_id_name=ThisIsMyCompany) Dialplan: sofia/internal/1000@192.168.0.2 Action set(ignore_early_media=ring_ready) Dialplan: sofia/internal/1000@192.168.0.2 Action set(ringback=${us-ring}) Dialplan: sofia/internal/1000@192.168.0.2 Action bridge(sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) 2012-03-23 10:38:43.937574 [DEBUG] switch_core_state_machine.c:154 (sofia/internal/1000@192.168.0.2) State Change CS_ROUTING -> CS_EXECUTE 2012-03-23 10:38:43.937574 [DEBUG] switch_core_session.c:1180 Send signal sofia/internal/1000@192.168.0.2 [BREAK] 2012-03-23 10:38:43.937574 [DEBUG] switch_core_state_machine.c:410 (sofia/internal/1000@192.168.0.2) State ROUTING going to sleep 2012-03-23 10:38:43.937574 [DEBUG] switch_core_state_machine.c:362 (sofia/internal/1000@192.168.0.2) Running State Change CS_EXECUTE 2012-03-23 10:38:43.937574 [DEBUG] switch_core_state_machine.c:417 (sofia/internal/1000@192.168.0.2) State EXECUTE 2012-03-23 10:38:43.937574 [DEBUG] mod_sofia.c:241 sofia/internal/1000@192.168.0.2 SOFIA EXECUTE 2012-03-23 10:38:43.937574 [DEBUG] switch_core_state_machine.c:192 sofia/internal/1000@192.168.0.2 Standard EXECUTE EXECUTE sofia/internal/1000@192.168.0.2 set(open=true) 2012-03-23 10:38:43.937574 [DEBUG] mod_dptools.c:1281 sofia/internal/1000@192.168.0.2 SET [open]=[true] EXECUTE sofia/internal/1000@192.168.0.2 hash(insert/192.168.0.2-spymap/1000/fb33155c-74cb-11e1-9063-fb6a5f4599fb) EXECUTE sofia/internal/1000@192.168.0.2 hash(insert/192.168.0.2-last_dial/1000/339XXXXXXX) EXECUTE sofia/internal/1000@192.168.0.2 hash(insert/192.168.0.2-last_dial/global/fb33155c-74cb-11e1-9063-fb6a5f4599fb) EXECUTE sofia/internal/1000@192.168.0.2 export(RFC2822_DATE=Fri, 23 Mar 2012 10:38:43 +0100) 2012-03-23 10:38:43.937574 [DEBUG] switch_channel.c:1093 EXPORT (export_vars) [RFC2822_DATE]=[Fri, 23 Mar 2012 10:38:43 +0100] EXECUTE sofia/internal/1000@192.168.0.2 set(effective_caller_id_number=0321234567) 2012-03-23 10:38:43.937574 [DEBUG] mod_dptools.c:1281 sofia/internal/1000@192.168.0.2 SET [effective_caller_id_number]=[0321234567] EXECUTE sofia/internal/1000@192.168.0.2 set(effective_caller_id_name=ThisIsMyCompany) 2012-03-23 10:38:43.937574 [DEBUG] mod_dptools.c:1281 sofia/internal/1000@192.168.0.2 SET [effective_caller_id_name]=[ThisIsMyCompany] EXECUTE sofia/internal/1000@192.168.0.2 set(ignore_early_media=ring_ready) 2012-03-23 10:38:43.937574 [DEBUG] mod_dptools.c:1281 sofia/internal/1000@192.168.0.2 SET [ignore_early_media]=[ring_ready] EXECUTE sofia/internal/1000@192.168.0.2 set(ringback=%(2000,4000,440,480)) 2012-03-23 10:38:43.937574 [DEBUG] mod_dptools.c:1281 sofia/internal/1000@192.168.0.2 SET [ringback]=[%(2000,4000,440,480)] EXECUTE sofia/internal/1000@192.168.0.2 bridge(sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) 2012-03-23 10:38:43.937574 [DEBUG] switch_channel.c:1047 sofia/internal/1000@192.168.0.2 EXPORTING[export_vars] [RFC2822_DATE]=[Fri, 23 Mar 2012 10:38:43 +0100] to event 2012-03-23 10:38:43.937574 [DEBUG] switch_ivr_originate.c:1884 Parsing global variables 2012-03-23 10:38:43.937574 [NOTICE] switch_channel.c:926 New Channel sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060 [fb34cf5a-74cb-11e1-9068-fb6a5f4599fb] 2012-03-23 10:38:43.937574 [DEBUG] mod_sofia.c:4691 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) State Change CS_NEW -> CS_INIT 2012-03-23 10:38:43.937574 [DEBUG] switch_core_session.c:1180 Send signal sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060 [BREAK] 2012-03-23 10:38:43.937574 [DEBUG] switch_core_state_machine.c:362 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) Running State Change CS_INIT 2012-03-23 10:38:43.937574 [DEBUG] switch_core_state_machine.c:401 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) State INIT 2012-03-23 10:38:43.937574 [DEBUG] mod_sofia.c:85 sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060 SOFIA INIT 2012-03-23 10:38:43.937574 [DEBUG] switch_core_session.c:875 Send signal sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060 [BREAK] 2012-03-23 10:38:43.937574 [DEBUG] mod_sofia.c:125 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) State Change CS_INIT -> CS_ROUTING 2012-03-23 10:38:43.937574 [DEBUG] switch_core_session.c:1180 Send signal sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060 [BREAK] 2012-03-23 10:38:43.937574 [DEBUG] switch_core_state_machine.c:401 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) State INIT going to sleep 2012-03-23 10:38:43.937574 [DEBUG] switch_core_state_machine.c:362 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) Running State Change CS_ROUTING 2012-03-23 10:38:43.937574 [DEBUG] switch_channel.c:1886 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) Callstate Change DOWN -> RINGING 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:410 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) State ROUTING 2012-03-23 10:38:43.957579 [DEBUG] mod_sofia.c:148 sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060 SOFIA ROUTING 2012-03-23 10:38:43.957579 [DEBUG] switch_ivr_originate.c:66 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) State Change CS_ROUTING -> CS_CONSUME_MEDIA 2012-03-23 10:38:43.957579 [DEBUG] switch_core_session.c:1180 Send signal sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060 [BREAK] 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:410 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) State ROUTING going to sleep 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:362 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) Running State Change CS_CONSUME_MEDIA 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:429 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) State CONSUME_MEDIA 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:429 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) State CONSUME_MEDIA going to sleep 2012-03-23 10:38:43.957579 [DEBUG] sofia.c:5526 Channel sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060 entering state [calling][0] 2012-03-23 10:38:43.957579 [DEBUG] switch_core_session.c:875 Send signal sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060 [BREAK] 2012-03-23 10:38:43.957579 [DEBUG] switch_core_session.c:875 Send signal sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060 [BREAK] 2012-03-23 10:38:43.957579 [DEBUG] switch_core_session.c:875 Send signal sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060 [BREAK] 2012-03-23 10:38:43.957579 [DEBUG] sofia.c:5526 Channel sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060 entering state [terminated][403] 2012-03-23 10:38:43.957579 [DEBUG] switch_channel.c:2848 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) Callstate Change RINGING -> HANGUP 2012-03-23 10:38:43.957579 [NOTICE] sofia.c:6293 Hangup sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060 [CS_CONSUME_MEDIA] [CALL_REJECTED] 2012-03-23 10:38:43.957579 [DEBUG] switch_channel.c:2871 Send signal sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060 [KILL] 2012-03-23 10:38:43.957579 [DEBUG] switch_core_session.c:1180 Send signal sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060 [BREAK] 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:362 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) Running State Change CS_HANGUP 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:602 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) State HANGUP 2012-03-23 10:38:43.957579 [DEBUG] mod_sofia.c:469 Channel sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060 hanging up, cause: CALL_REJECTED 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:47 sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060 Standard HANGUP, cause: CALL_REJECTED 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:602 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) State HANGUP going to sleep 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:393 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) State Change CS_HANGUP -> CS_REPORTING 2012-03-23 10:38:43.957579 [DEBUG] switch_core_session.c:1180 Send signal sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060 [BREAK] 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:362 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) Running State Change CS_REPORTING 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) State REPORTING 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:79 sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060 Standard REPORTING, cause: CALL_REJECTED 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) State REPORTING going to sleep 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:387 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) State Change CS_REPORTING -> CS_DESTROY 2012-03-23 10:38:43.957579 [DEBUG] switch_ivr_originate.c:3364 Originate Resulted in Error Cause: 21 [CALL_REJECTED] 2012-03-23 10:38:43.957579 [INFO] mod_dptools.c:2922 Originate Failed. Cause: CALL_REJECTED 2012-03-23 10:38:43.957579 [DEBUG] switch_channel.c:2848 (sofia/internal/1000@192.168.0.2) Callstate Change RINGING -> HANGUP 2012-03-23 10:38:43.957579 [NOTICE] mod_dptools.c:3041 Hangup sofia/internal/1000@192.168.0.2 [CS_EXECUTE] [CALL_REJECTED] 2012-03-23 10:38:43.957579 [DEBUG] switch_channel.c:2871 Send signal sofia/internal/1000@192.168.0.2 [KILL] 2012-03-23 10:38:43.957579 [DEBUG] switch_core_session.c:1180 Send signal sofia/internal/1000@192.168.0.2 [BREAK] 2012-03-23 10:38:43.957579 [DEBUG] switch_core_session.c:2285 sofia/internal/1000@192.168.0.2 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already) 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:417 (sofia/internal/1000@192.168.0.2) State EXECUTE going to sleep 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:362 (sofia/internal/1000@192.168.0.2) Running State Change CS_HANGUP 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:602 (sofia/internal/1000@192.168.0.2) State HANGUP 2012-03-23 10:38:43.957579 [DEBUG] mod_sofia.c:463 sofia/internal/1000@192.168.0.2 Overriding SIP cause 603 with 403 from the other leg 2012-03-23 10:38:43.957579 [DEBUG] mod_sofia.c:469 Channel sofia/internal/1000@192.168.0.2 hanging up, cause: CALL_REJECTED 2012-03-23 10:38:43.957579 [DEBUG] mod_sofia.c:534 Responding to INVITE with: 403 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:47 sofia/internal/1000@192.168.0.2 Standard HANGUP, cause: CALL_REJECTED 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:602 (sofia/internal/1000@192.168.0.2) State HANGUP going to sleep 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:393 (sofia/internal/1000@192.168.0.2) State Change CS_HANGUP -> CS_REPORTING 2012-03-23 10:38:43.957579 [DEBUG] switch_core_session.c:1180 Send signal sofia/internal/1000@192.168.0.2 [BREAK] 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:362 (sofia/internal/1000@192.168.0.2) Running State Change CS_REPORTING 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/1000@192.168.0.2) State REPORTING 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:79 sofia/internal/1000@192.168.0.2 Standard REPORTING, cause: CALL_REJECTED 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/1000@192.168.0.2) State REPORTING going to sleep 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:387 (sofia/internal/1000@192.168.0.2) State Change CS_REPORTING -> CS_DESTROY 2012-03-23 10:38:43.957579 [DEBUG] switch_core_session.c:1180 Send signal sofia/internal/1000@192.168.0.2 [BREAK] 2012-03-23 10:38:43.957579 [DEBUG] switch_core_session.c:1380 Session 13 (sofia/internal/1000@192.168.0.2) Locked, Waiting on external entities 2012-03-23 10:38:43.957579 [NOTICE] switch_core_session.c:1398 Session 13 (sofia/internal/1000@192.168.0.2) Ended 2012-03-23 10:38:43.957579 [NOTICE] switch_core_session.c:1400 Close Channel sofia/internal/1000@192.168.0.2 [CS_DESTROY] 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:491 (sofia/internal/1000@192.168.0.2) Callstate Change HANGUP -> DOWN 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:494 (sofia/internal/1000@192.168.0.2) Running State Change CS_DESTROY 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:504 (sofia/internal/1000@192.168.0.2) State DESTROY 2012-03-23 10:38:43.957579 [DEBUG] mod_sofia.c:374 sofia/internal/1000@192.168.0.2 SOFIA DESTROY 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:86 sofia/internal/1000@192.168.0.2 Standard DESTROY 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:504 (sofia/internal/1000@192.168.0.2) State DESTROY going to sleep 2012-03-23 10:38:43.957579 [DEBUG] switch_core_session.c:1180 Send signal sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060 [BREAK] 2012-03-23 10:38:43.957579 [DEBUG] switch_core_session.c:1380 Session 14 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) Locked, Waiting on external entities 2012-03-23 10:38:43.957579 [NOTICE] switch_core_session.c:1398 Session 14 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) Ended 2012-03-23 10:38:43.957579 [NOTICE] switch_core_session.c:1400 Close Channel sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060 [CS_DESTROY] 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:491 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) Callstate Change HANGUP -> DOWN 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:494 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) Running State Change CS_DESTROY 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:504 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) State DESTROY 2012-03-23 10:38:43.957579 [DEBUG] mod_sofia.c:374 sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060 SOFIA DESTROY 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:86 sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060 Standard DESTROY 2012-03-23 10:38:43.957579 [DEBUG] switch_core_state_machine.c:504 (sofia/internal/gxw4104-fxo1/339XXXXXXX@192.168.0.3:5060) State DESTROY going to sleep freeswitch@internal> Thank's in advance Regards Accursio Avona