- FreeSWITCH-users - FreeSWITCH Mailing Lists

High cpu usage on EC2 Centos 5.4
by paul gore 22 Jul '10

22 Jul '10

Apparently high CPU usage only starts happening after "reloadxml" command has been used several times in a row. The issue gets cleared after FS shutdown and restart. Looks like a bug to me.

4 10

uuid_exists not behaving as expected
by Phillip Jones 22 Jul '10

22 Jul '10

Hi there, If I call uuid_exists from fs_cli I get a true or false response. uuid_exists 9797297 -- > false If I make the same call from my script (mod_managed) I get no response: apiResult = fsApi.Execute("uuid_exists", "979878686"); ---> empty string and the console shows an error switch_cpp:195 object is not initalized Calling a valid uuid from my script however does behave as expected and returns true. This is not a huge issue - but I just want to check that receiving this error is ok, as I call uuid_exist frequently. Thanks Pj

2 2

Fwd: Not able to do outbound call
by ovvenkat 22 Jul '10

22 Jul '10

Hi Michel, Here is the output of fs_cli 2010-07-22 16:47:27.308819 [WARNING] ozmod_sangoma_boost.c:1663 RX EVENT: CALL_START:(80) [w1g2] CSid=0 Seq=10 Cn=[N/A] Cd=[1100] Ci=[9677012480] Rdnis=[] 2010-07-22 16:47:27.308819 [DEBUG] ozmod_sangoma_boost.c:880 Changing state on 1:2 from DOWN to RING 2010-07-22 16:47:27.308819 [DEBUG] ozmod_sangoma_boost.c:1174 1:2 STATE [RING] 2010-07-22 16:47:27.308819 [DEBUG] mod_openzap.c:1934 got clear channel sig [START] 2010-07-22 16:47:27.308819 [DEBUG] mod_openzap.c:403 Set codec PCMA 20ms 2010-07-22 16:47:27.308819 [DEBUG] mod_openzap.c:1439 Connect inbound channel OpenZAP/1:2/1100 2010-07-22 16:47:27.308819 [NOTICE] switch_channel.c:776 New Channel OpenZAP/1:2/1100 [08de1301-c6c6-4103-bc88-96c444124035] 2010-07-22 16:47:27.308819 [DEBUG] mod_openzap.c:1450 (OpenZAP/1:2/1100) State Change CS_NEW -> CS_INIT 2010-07-22 16:47:27.308819 [DEBUG] switch_core_session.c:1027 Send signal OpenZAP/1:2/1100 [BREAK] 2010-07-22 16:47:27.312160 [DEBUG] switch_core_state_machine.c:314 (OpenZAP/1:2/1100) Running State Change CS_INIT 2010-07-22 16:47:27.312160 [DEBUG] switch_core_state_machine.c:338 (OpenZAP/1:2/1100) State INIT 2010-07-22 16:47:27.312160 [DEBUG] mod_openzap.c:431 (OpenZAP/1:2/1100) State Change CS_INIT -> CS_ROUTING 2010-07-22 16:47:27.312160 [DEBUG] switch_core_session.c:1027 Send signal OpenZAP/1:2/1100 [BREAK] 2010-07-22 16:47:27.312160 [DEBUG] switch_core_state_machine.c:338 (OpenZAP/1:2/1100) State INIT going to sleep 2010-07-22 16:47:27.312160 [DEBUG] switch_core_state_machine.c:314 (OpenZAP/1:2/1100) Running State Change CS_ROUTING 2010-07-22 16:47:27.312160 [DEBUG] switch_channel.c:1471 (OpenZAP/1:2/1100) Callstate Change DOWN -> RINGING 2010-07-22 16:47:27.312160 [DEBUG] switch_core_state_machine.c:341 (OpenZAP/1:2/1100) State ROUTING 2010-07-22 16:47:27.312160 [DEBUG] mod_openzap.c:454 OpenZAP/1:2/1100 CHANNEL ROUTING 2010-07-22 16:47:27.312160 [DEBUG] switch_core_state_machine.c:77 OpenZAP/1:2/1100 Standard ROUTING 2010-07-22 16:47:27.312160 [INFO] mod_dialplan_xml.c:331 Processing 9677012480->1100 in context default Dialplan: OpenZAP/1:2/1100 parsing [default->unloop] continue=false Dialplan: OpenZAP/1:2/1100 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->tod_example] continue=true Dialplan: OpenZAP/1:2/1100 Date/Time Match (PASS) [tod_example] break=on-false Dialplan: OpenZAP/1:2/1100 Action set(open=true) Dialplan: OpenZAP/1:2/1100 parsing [default->holiday_example] continue=true Dialplan: OpenZAP/1:2/1100 Date/Time Match (FAIL) [holiday_example] break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->global-intercept] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [global-intercept] destination_number(1100) =~ /^886$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->outgoing] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [outgoing] destination_number(1100) =~ /^(\d)$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->priout] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [priout] destination_number(1100) =~ /^(09677012480)$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->group-intercept] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [group-intercept] destination_number(1100) =~ /^\*8$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->intercept-ext] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [intercept-ext] destination_number(1100) =~ /^\*\*(\d+)$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->redial] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [redial] destination_number(1100) =~ /^(redial|870)$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->global] continue=true Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [global] ${sip_has_crypto}() =~ /^(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)$/ break=never Dialplan: OpenZAP/1:2/1100 Absolute Condition [global] Dialplan: OpenZAP/1:2/1100 Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid}) Dialplan: OpenZAP/1:2/1100 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number}) Dialplan: OpenZAP/1:2/1100 Action hash(insert/${domain_name}-last_dial/global/${uuid}) Dialplan: OpenZAP/1:2/1100 parsing [default->snom-demo-2] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [snom-demo-2] destination_number(1100) =~ /^9001$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->snom-demo-1] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [snom-demo-1] destination_number(1100) =~ /^9000$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->eavesdrop] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [eavesdrop] destination_number(1100) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->eavesdrop] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [eavesdrop] destination_number(1100) =~ /^779$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->call_return] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [call_return] destination_number(1100) =~ /^\*69$|^869$|^lcr$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->del-group] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [del-group] destination_number(1100) =~ /^80(\d{2})$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->add-group] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [add-group] destination_number(1100) =~ /^81(\d{2})$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->call-group-simo] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [call-group-simo] destination_number(1100) =~ /^82(\d{2})$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->call-group-order] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [call-group-order] destination_number(1100) =~ /^83(\d{2})$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->extension-intercom] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [extension-intercom] destination_number(1100) =~ /^8(10[01][0-9])$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->Local_Extension] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [Local_Extension] destination_number(1100) =~ /^(10[01][0-9])$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->Local_Extension_Skinny] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [Local_Extension_Skinny] destination_number(1100) =~ /^(20[01][0-9])$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->group_dial_sales] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [group_dial_sales] destination_number(1100) =~ /^2000$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->group_dial_support] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [group_dial_support] destination_number(1100) =~ /^2001$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->group_dial_billing] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [group_dial_billing] destination_number(1100) =~ /^2002$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->operator] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [operator] destination_number(1100) =~ /^(operator|0)$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->vmain] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [vmain] destination_number(1100) =~ /^vmain$|^4000$|^\*98$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->sip_uri] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [sip_uri] destination_number(1100) =~ /^sip:(.*)$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->nb_conferences] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [nb_conferences] destination_number(1100) =~ /^(30\d{2})$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->wb_conferences] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [wb_conferences] destination_number(1100) =~ /^(31\d{2})$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->uwb_conferences] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [uwb_conferences] destination_number(1100) =~ /^(32\d{2})$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->cdquality_conferences] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [cdquality_conferences] destination_number(1100) =~ /^(33\d{2})$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->freeswitch_public_conf_via_sip] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [freeswitch_public_conf_via_sip] destination_number(1100) =~ /^9(888|8888|1616|3232)$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->mad_boss_intercom] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [mad_boss_intercom] destination_number(1100) =~ /^0911$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->mad_boss_intercom] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [mad_boss_intercom] destination_number(1100) =~ /^0912$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->mad_boss] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [mad_boss] destination_number(1100) =~ /^0913$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->ivr_demo] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [ivr_demo] destination_number(1100) =~ /^5000$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->dynamic_conference] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [dynamic_conference] destination_number(1100) =~ /^5001$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->rtp_multicast_page] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [rtp_multicast_page] destination_number(1100) =~ /^pagegroup$|^7243$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->park] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [park] destination_number(1100) =~ /^5900$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->unpark] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [unpark] destination_number(1100) =~ /^5901$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->valet_park] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [valet_park] destination_number(1100) =~ /^(6000)$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->valet_park] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [valet_park] destination_number(1100) =~ /^(60\d[1-9])$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->park] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [park] source(mod_openzap) =~ /mod_sofia/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->unpark] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [unpark] source(mod_openzap) =~ /mod_sofia/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->park] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [park] source(mod_openzap) =~ /mod_sofia/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->unpark] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [unpark] source(mod_openzap) =~ /mod_sofia/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->wait] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [wait] destination_number(1100) =~ /^wait$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->fax_receive] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [fax_receive] destination_number(1100) =~ /^9178$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->fax_transmit] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [fax_transmit] destination_number(1100) =~ /^9179$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->ringback_180] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [ringback_180] destination_number(1100) =~ /^9180$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->ringback_183_uk_ring] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [ringback_183_uk_ring] destination_number(1100) =~ /^9181$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->ringback_183_music_ring] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [ringback_183_music_ring] destination_number(1100) =~ /^9182$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->ringback_post_answer_uk_ring] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [ringback_post_answer_uk_ring] destination_number(1100) =~ /^9183$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->ringback_post_answer_music] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [ringback_post_answer_music] destination_number(1100) =~ /^9184$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->ClueCon] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [ClueCon] destination_number(1100) =~ /^9191$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->show_info] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [show_info] destination_number(1100) =~ /^9192$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->video_record] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [video_record] destination_number(1100) =~ /^9193$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->video_playback] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [video_playback] destination_number(1100) =~ /^9194$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->delay_echo] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [delay_echo] destination_number(1100) =~ /^9195$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->echo] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [echo] destination_number(1100) =~ /^9196$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->milliwatt] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [milliwatt] destination_number(1100) =~ /^9197$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->tone_stream] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [tone_stream] destination_number(1100) =~ /^9198$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->zrtp_enrollement] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [zrtp_enrollement] destination_number(1100) =~ /^9787$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->hold_music] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [hold_music] destination_number(1100) =~ /^9664$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->pizza_demo] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [pizza_demo] destination_number(1100) =~ /^(pizza|74992)$/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->local.example.com] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [local.example.com] ${toll_allow}() =~ /local/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->domestic.example.com] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [domestic.example.com] ${toll_allow}() =~ /domestic/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->international.example.com] continue=false Dialplan: OpenZAP/1:2/1100 Regex (FAIL) [international.example.com] ${toll_allow}() =~ /international/ break=on-false Dialplan: OpenZAP/1:2/1100 parsing [default->enum] continue=false Dialplan: OpenZAP/1:2/1100 Regex (PASS) [enum] ${module_exists(mod_enum)}(true) =~ /true/ break=on-false Dialplan: OpenZAP/1:2/1100 Regex (PASS) [enum] destination_number(1100) =~ /^(.*)$/ break=on-false Dialplan: OpenZAP/1:2/1100 Action transfer(1100 enum) 2010-07-22 16:47:27.312160 [DEBUG] switch_core_state_machine.c:119 (OpenZAP/1:2/1100) State Change CS_ROUTING -> CS_EXECUTE 2010-07-22 16:47:27.312160 [DEBUG] switch_core_session.c:1027 Send signal OpenZAP/1:2/1100 [BREAK] 2010-07-22 16:47:27.312160 [DEBUG] switch_core_state_machine.c:341 (OpenZAP/1:2/1100) State ROUTING going to sleep 2010-07-22 16:47:27.312160 [DEBUG] switch_core_state_machine.c:314 (OpenZAP/1:2/1100) Running State Change CS_EXECUTE 2010-07-22 16:47:27.312160 [DEBUG] switch_core_state_machine.c:348 (OpenZAP/1:2/1100) State EXECUTE 2010-07-22 16:47:27.312160 [DEBUG] mod_openzap.c:471 OpenZAP/1:2/1100 CHANNEL EXECUTE 2010-07-22 16:47:27.312160 [DEBUG] switch_core_state_machine.c:157 OpenZAP/1:2/1100 Standard EXECUTE EXECUTE OpenZAP/1:2/1100 set(open=true) 2010-07-22 16:47:27.312160 [DEBUG] mod_dptools.c:854 OpenZAP/1:2/1100 SET [open]=[true] EXECUTE OpenZAP/1:2/1100 hash(insert/192.168.1.110-spymap/9677012480/08de1301-c6c6-4103-bc88-96c444124035) EXECUTE OpenZAP/1:2/1100 hash(insert/192.168.1.110-last_dial/9677012480/1100) EXECUTE OpenZAP/1:2/1100 hash(insert/192.168.1.110-last_dial/global/08de1301-c6c6-4103-bc88-96c444124035) EXECUTE OpenZAP/1:2/1100 transfer(1100 enum) 2010-07-22 16:47:27.312160 [DEBUG] switch_ivr.c:1469 (OpenZAP/1:2/1100) State Change CS_EXECUTE -> CS_ROUTING 2010-07-22 16:47:27.312160 [DEBUG] switch_core_session.c:1027 Send signal OpenZAP/1:2/1100 [BREAK] 2010-07-22 16:47:27.312160 [DEBUG] switch_core_session.c:647 Send signal OpenZAP/1:2/1100 [BREAK] 2010-07-22 16:47:27.312160 [NOTICE] switch_ivr.c:1475 Transfer OpenZAP/1:2/1100 to enum[1100@default] 2010-07-22 16:47:27.312160 [DEBUG] switch_core_state_machine.c:348 (OpenZAP/1:2/1100) State EXECUTE going to sleep 2010-07-22 16:47:27.312160 [DEBUG] switch_core_state_machine.c:314 (OpenZAP/1:2/1100) Running State Change CS_ROUTING 2010-07-22 16:47:27.312160 [DEBUG] switch_core_state_machine.c:341 (OpenZAP/1:2/1100) State ROUTING 2010-07-22 16:47:27.312160 [DEBUG] mod_openzap.c:454 OpenZAP/1:2/1100 CHANNEL ROUTING 2010-07-22 16:47:27.312160 [DEBUG] switch_core_state_machine.c:77 OpenZAP/1:2/1100 Standard ROUTING 2010-07-22 16:47:27.312160 [DEBUG] mod_enum.c:576 ENUM Lookup on 1100 2010-07-22 16:47:27.928811 [DEBUG] mod_enum.c:204 Unable to lookup NAPTR record for 0.0.1.1.e164.org: valid domain but no data of requested type 2010-07-22 16:47:27.928811 [INFO] switch_core_state_machine.c:142 No Route, Aborting 2010-07-22 16:47:27.928811 [DEBUG] switch_channel.c:2261 (OpenZAP/1:2/1100) Callstate Change RINGING -> HANGUP 2010-07-22 16:47:27.928811 [NOTICE] switch_core_state_machine.c:143 Hangup OpenZAP/1:2/1100 [CS_ROUTING] [NO_ROUTE_DESTINATION] 2010-07-22 16:47:27.928811 [DEBUG] switch_channel.c:2277 Send signal OpenZAP/1:2/1100 [KILL] 2010-07-22 16:47:27.928811 [DEBUG] switch_core_session.c:1027 Send signal OpenZAP/1:2/1100 [BREAK] 2010-07-22 16:47:27.928811 [DEBUG] switch_core_state_machine.c:341 (OpenZAP/1:2/1100) State ROUTING going to sleep 2010-07-22 16:47:27.928811 [DEBUG] switch_core_state_machine.c:314 (OpenZAP/1:2/1100) Running State Change CS_HANGUP 2010-07-22 16:47:27.928811 [DEBUG] switch_core_state_machine.c:500 (OpenZAP/1:2/1100) State HANGUP 2010-07-22 16:47:27.928811 [DEBUG] mod_openzap.c:540 Changing state on 1:2 from RING to HANGUP 2010-07-22 16:47:27.928811 [DEBUG] mod_openzap.c:556 OpenZAP/1:2/1100 CHANNEL HANGUP 2010-07-22 16:47:27.928811 [DEBUG] switch_core_state_machine.c:46 OpenZAP/1:2/1100 Standard HANGUP, cause: NO_ROUTE_DESTINATION 2010-07-22 16:47:27.928811 [DEBUG] switch_core_state_machine.c:500 (OpenZAP/1:2/1100) State HANGUP going to sleep 2010-07-22 16:47:27.928811 [DEBUG] switch_core_state_machine.c:333 (OpenZAP/1:2/1100) State Change CS_HANGUP -> CS_REPORTING 2010-07-22 16:47:27.928811 [DEBUG] switch_core_session.c:1027 Send signal OpenZAP/1:2/1100 [BREAK] 2010-07-22 16:47:27.928811 [DEBUG] switch_core_state_machine.c:314 (OpenZAP/1:2/1100) Running State Change CS_REPORTING 2010-07-22 16:47:27.928811 [DEBUG] switch_core_state_machine.c:591 (OpenZAP/1:2/1100) State REPORTING 2010-07-22 16:47:27.928811 [DEBUG] switch_core_state_machine.c:53 OpenZAP/1:2/1100 Standard REPORTING, cause: NO_ROUTE_DESTINATION 2010-07-22 16:47:27.928811 [DEBUG] switch_core_state_machine.c:591 (OpenZAP/1:2/1100) State REPORTING going to sleep 2010-07-22 16:47:27.928811 [DEBUG] switch_core_state_machine.c:327 (OpenZAP/1:2/1100) State Change CS_REPORTING -> CS_DESTROY 2010-07-22 16:47:27.928811 [DEBUG] switch_core_session.c:1027 Send signal OpenZAP/1:2/1100 [BREAK] 2010-07-22 16:47:27.928811 [DEBUG] switch_core_session.c:1175 Session 21 (OpenZAP/1:2/1100) Locked, Waiting on external entities 2010-07-22 16:47:27.928811 [NOTICE] switch_core_session.c:1193 Session 21 (OpenZAP/1:2/1100) Ended 2010-07-22 16:47:27.928811 [NOTICE] switch_core_session.c:1195 Close Channel OpenZAP/1:2/1100 [CS_DESTROY] 2010-07-22 16:47:27.928811 [DEBUG] switch_core_state_machine.c:427 (OpenZAP/1:2/1100) Callstate Change HANGUP -> DOWN 2010-07-22 16:47:27.928811 [DEBUG] switch_core_state_machine.c:430 (OpenZAP/1:2/1100) Running State Change CS_DESTROY 2010-07-22 16:47:27.928811 [DEBUG] switch_core_state_machine.c:440 (OpenZAP/1:2/1100) State DESTROY 2010-07-22 16:47:27.928811 [DEBUG] switch_core_state_machine.c:60 OpenZAP/1:2/1100 Standard DESTROY 2010-07-22 16:47:27.928811 [DEBUG] switch_core_state_machine.c:440 (OpenZAP/1:2/1100) State DESTROY going to sleep 2010-07-22 16:47:27.932812 [DEBUG] ozmod_sangoma_boost.c:1174 1:2 STATE [HANGUP] 2010-07-22 16:47:27.932812 [WARNING] sangoma_boost_client.c:221 TX EVENT (N): CALL_START_NACK:(82) [w1g2] Rc=3 CSid=0 Seq=5 2010-07-22 16:47:27.932812 [WARNING] ozmod_sangoma_boost.c:1663 RX EVENT (N): CALL_START_NACK_ACK:(83) [w1g2] Rc=0 CSid=0 Seq=11 2010-07-22 16:47:27.932812 [DEBUG] ozmod_sangoma_boost.c:570 Changing state on 1:2 from HANGUP to HANGUP_COMPLETE 2010-07-22 16:47:27.932812 [DEBUG] ozmod_sangoma_boost.c:1174 1:2 STATE [HANGUP_COMPLETE] 2010-07-22 16:47:27.932812 [DEBUG] ozmod_sangoma_boost.c:1314 Changing state on 1:2 from HANGUP_COMPLETE to DOWN 2010-07-22 16:47:27.932812 [DEBUG] ozmod_sangoma_boost.c:1174 1:2 STATE [DOWN] 2010-07-22 16:47:27.932812 [DEBUG] zap_io.c:1388 channel done 1:2 2010-07-22 16:47:31.665774 [DEBUG] switch_nat.c:299 got UPnP keep alive packet: NOTIFY * HTTP/1.1 Host: 239.255.255.250:1900 NT:urn:schemas-upnp-org:service:WANIPConnection:1 NTS: ssdp:alive USN:uuid:33333333-0000-c0a8-0101-efefefef803b::urn:schemas-upnp-org:service:WANIPConnection:1 Location:http://192.168.1.1:80/DeviceDescription.xml Cache-Control:max-age=480 Server:Allegro-Software-RomUpnp/4.07 UPnP/1.0 IGD/1.00 Regards, Venkat. On Wed, Jul 21, 2010 at 10:27 PM, Michael Collins <msc(a)freeswitch.org>wrote: > > > On Wed, Jul 21, 2010 at 9:35 AM, ovvenkat <ovvenkatesan(a)gmail.com> wrote: > >> Hi Nazim, >> >> Do I need to add this into my deafult.xml file or public.xml file? >> >> I have added bellow code into default.xml file >> >> >> <extension name="Voicepulse"> >> <condition field="destination_number" expression="xxxxyyyxx"> >> // xxxyyyxx -- > my PRI number >> <action application="transfer" data="1000 XML default"/> >> </condition> >> </extension> >> >> After adding this rules, when I am trying to call from mobile to >> freeSwitch, its says that, number is busy. >> >> then, I changed this code from *default.xml* to *public.xml* file. >> >> Still, no luck :( >> > > You still need to get a log of the call - it will have the details on what > exactly is happening with the call. Once we have the log on pastebin we can > offer some specific suggestions. > -MC > > > _______________________________________________ > FreeSWITCH-users mailing list > FreeSWITCH-users(a)lists.freeswitch.org > http://lists.freeswitch.org/mailman/listinfo/freeswitch-users > UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users > http://www.freeswitch.org > > Regards venki.

3 2

Unstable hangup hook in javascript
by xuyan yang 22 Jul '10

22 Jul '10

Hi, I have tested the hangup hook function using the following javascript. During the speech in the call I hangup the call to see the result. Sometimes hangup function works, but sometimes it did not. The chance of fail is about 1 out of 10. I am running windows XP, FS git version cloned and compiled at end of Jun. Does anyone meet the same problem? Or do I make some mistake in the script? Thanks. ////test.js function on_hangup(session, how){ console_log("notice","hangup!!!!!!!!!!!!!\n"); } session = new Session("sofia/gateway/12voip-out/*********"); session.waitForAnswer(); session.execute("set","continue_on_fail=true"); var res=session.setHangupHook(on_hangup); console_log("notice","res:"+res+"\n"); session.execute("speak", "This is an example of flite text to speech engine. We can test the work of hanguphook."); session.execute("speak","you are calling from " + session.caller_id_num + " You are calling " + session.destination ); session.hangup();

3 2

REFER
by Ken Fulmer 22 Jul '10

22 Jul '10

Does any documentation exist for the following dial-plan example? <extension name="refer"> <condition field="${sip_refer_to}"> <expression><![CDATA[<sip:${destination_number}@${domain_name}>]]></expressi on> </condition> <condition field="${sip_refer_to}"> <expression><![CDATA[<sip:(.*)@(.*)>]]></expression> <action application="set" data="refer_user=$1"/> <action application="set" data="refer_domain=$2"/> <action application="info"/> <action application="bridge" data="sofia/${use_profile}/${refer_user}@${refer_domain}"/> </condition> </extension> We have a FS gateway in front of a sipXecs PBX. When calls are transferred, we hear music on hold until the call actually transfers. Then we get dead air until the new user picks up. We need the remote phone to hear ringback when calls are transferred. Thanks, Ken Fulmer

1 0

Voicemail Question
by Michael Gende 22 Jul '10

22 Jul '10

Hello All, Looks like I've managed to screw this up pretty well. Here's the deal: Set up phones and they register/send/receive calls. But, I can't get any voice mail. I cal leave voice mail, but if one tries to go get it, it says you have zero messages. I know this has something to do with the domain the user has and the one voicemail is trying to get things from. Clues? Flames? Open to both. Mike

4 3

Polycom uses second line on multi-line phone
by Yehavi Bourvine 22 Jul '10

22 Jul '10

I have a Polycom-550 phone (version 3.2.3) which has a few lines registered on it. When a new call is dialled it usually seizes the first line, except one case. The possiblities are: - When you pickup the handset or press the speaker button - the first line is used. - When you dial the digits and then press "dial" or lift the handset the first line is used. - When you dial the digits and press the speaker button the phone behaves as follows: - A call is generated on the first line. - After getting "Trying" the call is cancelled by the phone. - The phone dials the number via the second extension. - All this process is done in a fraction of a second. This happens on all our phones, so it seems like a configuration issue or some bug; I can't find any parameter that might control it. BTW, we have call.stickyAutoLineSeize set to 1. any idea? Thanks, __Yehavi:

1 0

Mod_voicemail
by Peder 22 Jul '10

22 Jul '10

Is there some reason "vm_message_ext" uses the "_" in its name, whereas all of the other variables related to voicemail, vm-attach-file, vm-keep-local-after-email, vm-email-all-messages, vm-mailto, etc, all use "-"? The wiki shows vm-message-ext and vm_message_ext, but from checking the source I think the vm-message-ext is invalid. Peder

1 0

dial tone appears on the background after holding and un-holding
by Yehavi Bourvine 22 Jul '10

22 Jul '10

Hello, I have some odd and sporadic problem with Polycom phones and shared lines. It happens quite rarely to users and I did not manage so far to regenerate it at my lab. There are a few Polycom 550 phones (version 3.2.3) who share the same extension number. The user answers the line on one phone, put it on hold and unhold on another phone. Sometimes, after doing the unhold he hears a dial tone in the background. After 20-30 seconds this dialtone dissapears. The other side does not hear it. Anyone had such an incidence and can shed some light? BTW, the FreeSwitch version is 1.0.6 Thanks! __Yehavi:

1 0

Not able to do outbound call
by ovvenkat 21 Jul '10

21 Jul '10

Hi to all, I am very new to this world. I am not able to do outbound call using Sangoma A101 card and freeSwitch. Here is the procedure I have followed *openzap.conf* [span wanpipe smg_prid] name => smg_prid trunk_type =>e1 b-channel => 1:1-15 d-chennel => 1:16 b-channel => 1:17-31 I have one span in *openzap.conf.xml* <configuration name="openzap.conf" description="OpenZAP Configuration"> <settings> <param name="debug" value="0"/> </settings> <boot_spans> <span id="smg_prid"/> <param name="node" value="cpe"/> <param name="switch" value="ni1"> <param name="dialplan" value="XML"> <param name="context" value="default"> </span> <boot_spans> <analog_spans> </analog_spans> </configuration > </analog_spans> *My Dial plan is *added one extension in default.xml file <extension name="outgoing-pri"> <condition field="destination_number" expression="12345"> <action application="bridge" data="OpenZAP/smg_prid/a/<my number>@g1"/> </condition> </extension> When i trying to call "12345" I am getting following output in *fs_cli* , 2010-07-19 01:50:17.531933 [DEBUG] sofia.c:5992 IP 192.168.1.100 Rejected by acl "domains". Falling back to Digest auth. 2010-07-19 01:50:17.562934 [DEBUG] sofia.c:5992 IP 192.168.1.100 Rejected by acl "domains". Falling back to Digest auth. 2010-07-19 01:50:17.581933 [NOTICE] switch_channel.c:776 New Channel sofia/internal/1000(a)192.168.1.110 [36c842f2-8078-4ca0-a6e0-36f5d65f81f8] 2010-07-19 01:50:17.583936 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/1000(a)192.168.1.110) Running State Change CS_NEW 2010-07-19 01:50:17.583936 [DEBUG] switch_core_state_machine.c:320 (sofia/internal/1000(a)192.168.1.110) State NEW 2010-07-19 01:50:17.615937 [DEBUG] sofia.c:4310 Channel sofia/internal/ 1000(a)192.168.1.110 entering state [received][100] 2010-07-19 01:50:17.615937 [DEBUG] sofia.c:4321 Remote SDP: v=0 o=- 4 2 IN IP4 192.168.1.100 s=CounterPath X-Lite 3.0 c=IN IP4 192.168.1.100 t=0 0 m=audio 36422 RTP/AVP 107 0 8 101 a=rtpmap:107 BV32/16000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 a=alt:1 1 : hH//orIg hS6anlnf 192.168.1.100 36422 2010-07-19 01:50:17.615937 [DEBUG] sofia_glue.c:3859 Audio Codec Compare [BV32:107:16000:20]/[G7221:115:32000:20] 2010-07-19 01:50:17.615937 [DEBUG] sofia_glue.c:3859 Audio Codec Compare [BV32:107:16000:20]/[G7221:107:16000:20] 2010-07-19 01:50:17.615937 [DEBUG] sofia_glue.c:3859 Audio Codec Compare [BV32:107:16000:20]/[G722:9:8000:20] 2010-07-19 01:50:17.615937 [DEBUG] sofia_glue.c:3859 Audio Codec Compare [BV32:107:16000:20]/[PCMU:0:8000:20] 2010-07-19 01:50:17.615937 [DEBUG] sofia_glue.c:3859 Audio Codec Compare [BV32:107:16000:20]/[PCMA:8:8000:20] 2010-07-19 01:50:17.615937 [DEBUG] sofia_glue.c:3859 Audio Codec Compare [BV32:107:16000:20]/[GSM:3:8000:20] 2010-07-19 01:50:17.615937 [DEBUG] sofia_glue.c:3859 Audio Codec Compare [PCMU:0:8000:20]/[G7221:115:32000:20] 2010-07-19 01:50:17.615937 [DEBUG] sofia_glue.c:3859 Audio Codec Compare [PCMU:0:8000:20]/[G7221:107:16000:20] 2010-07-19 01:50:17.615937 [DEBUG] sofia_glue.c:3859 Audio Codec Compare [PCMU:0:8000:20]/[G722:9:8000:20] 2010-07-19 01:50:17.615937 [DEBUG] sofia_glue.c:3859 Audio Codec Compare [PCMU:0:8000:20]/[PCMU:0:8000:20] 2010-07-19 01:50:17.615937 [DEBUG] sofia_glue.c:2442 Set Codec sofia/internal/1000(a)192.168.1.110 PCMU/8000 20 ms 160 samples 2010-07-19 01:50:17.615937 [DEBUG] sofia_glue.c:3798 Set 2833 dtmf send/recv payload to 101 2010-07-19 01:50:17.615937 [DEBUG] sofia.c:4468 (sofia/internal/ 1000(a)192.168.1.110) State Change CS_NEW -> CS_INIT 2010-07-19 01:50:17.615937 [DEBUG] switch_core_session.c:1027 Send signal sofia/internal/1000(a)192.168.1.110 [BREAK] 2010-07-19 01:50:17.617033 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/1000(a)192.168.1.110) Running State Change CS_INIT 2010-07-19 01:50:17.617033 [DEBUG] switch_core_state_machine.c:338 (sofia/internal/1000(a)192.168.1.110) State INIT 2010-07-19 01:50:17.617033 [DEBUG] mod_sofia.c:83 sofia/internal/ 1000(a)192.168.1.110 SOFIA INIT 2010-07-19 01:50:17.617033 [DEBUG] mod_sofia.c:119 (sofia/internal/ 1000(a)192.168.1.110) State Change CS_INIT -> CS_ROUTING 2010-07-19 01:50:17.617033 [DEBUG] switch_core_session.c:1027 Send signal sofia/internal/1000(a)192.168.1.110 [BREAK] 2010-07-19 01:50:17.617033 [DEBUG] switch_core_state_machine.c:338 (sofia/internal/1000(a)192.168.1.110) State INIT going to sleep 2010-07-19 01:50:17.617033 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/1000(a)192.168.1.110) Running State Change CS_ROUTING 2010-07-19 01:50:17.617033 [DEBUG] switch_channel.c:1471 (sofia/internal/ 1000(a)192.168.1.110) Callstate Change DOWN -> RINGING 2010-07-19 01:50:17.617033 [DEBUG] switch_core_state_machine.c:341 (sofia/internal/1000(a)192.168.1.110) State ROUTING 2010-07-19 01:50:17.617033 [DEBUG] mod_sofia.c:142 sofia/internal/ 1000(a)192.168.1.110 SOFIA ROUTING 2010-07-19 01:50:17.617033 [DEBUG] switch_core_state_machine.c:77 sofia/internal/1000(a)192.168.1.110 Standard ROUTING 2010-07-19 01:50:17.617033 [INFO] mod_dialplan_xml.c:331 Processing 1000->12345 in context default Dialplan: sofia/internal/1000(a)192.168.1.110 parsing [default->unloop] continue=false Dialplan: sofia/internal/1000(a)192.168.1.110 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false Dialplan: sofia/internal/1000(a)192.168.1.110 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false Dialplan: sofia/internal/1000(a)192.168.1.110 parsing [default->outgoing-pri] continue=false Dialplan: sofia/internal/1000(a)192.168.1.110 Regex (PASS) [outgoing-pri] destination_number(12345) =~ /12345/ break=on-false Dialplan: sofia/internal/1000(a)192.168.1.110 Action bridge(OpenZAP/smg_prid/a/09677012480@g1) 2010-07-19 01:50:17.618002 [DEBUG] switch_core_state_machine.c:119 (sofia/internal/1000(a)192.168.1.110) State Change CS_ROUTING -> CS_EXECUTE 2010-07-19 01:50:17.618002 [DEBUG] switch_core_session.c:1027 Send signal sofia/internal/1000(a)192.168.1.110 [BREAK] 2010-07-19 01:50:17.618002 [DEBUG] switch_core_state_machine.c:341 (sofia/internal/1000(a)192.168.1.110) State ROUTING going to sleep 2010-07-19 01:50:17.618002 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/1000(a)192.168.1.110) Running State Change CS_EXECUTE 2010-07-19 01:50:17.618002 [DEBUG] switch_core_state_machine.c:348 (sofia/internal/1000(a)192.168.1.110) State EXECUTE 2010-07-19 01:50:17.618002 [DEBUG] mod_sofia.c:235 sofia/internal/ 1000(a)192.168.1.110 SOFIA EXECUTE 2010-07-19 01:50:17.618002 [DEBUG] switch_core_state_machine.c:157 sofia/internal/1000(a)192.168.1.110 Standard EXECUTE EXECUTE sofia/internal/1000@192.168.1.110bridge(OpenZAP/smg_prid/a/09677012480@g1 ) 2010-07-19 01:50:17.619035 [DEBUG] mod_openzap.c:403 Set codec PCMA 20ms 2010-07-19 01:50:17.619035 [DEBUG] mod_openzap.c:1317 Connect outbound channel OpenZAP/1:1/09677012480@g1 2010-07-19 01:50:17.619035 [NOTICE] switch_channel.c:776 New Channel OpenZAP/1:1/09677012480@g1 [36c14872-c8e1-4fa4-94ea-8c075d5133d2] 2010-07-19 01:50:17.619035 [DEBUG] mod_openzap.c:1331 (OpenZAP/1:1/09677012480@g1) State Change CS_NEW -> CS_INIT 2010-07-19 01:50:17.619035 [DEBUG] switch_core_session.c:1027 Send signal OpenZAP/1:1/09677012480@g1 [BREAK] 2010-07-19 01:50:17.619035 [DEBUG] ozmod_analog.c:59 Changing state on 1:1 from DOWN to DIALING 2010-07-19 01:50:17.620937 [DEBUG] ozmod_analog.c:293 ANALOG CHANNEL thread starting. 2010-07-19 01:50:17.620937 [DEBUG] ozmod_analog.c:464 Executing state handler on 1:1 for DIALING 2010-07-19 01:50:17.633931 [DEBUG] switch_core_state_machine.c:314 (OpenZAP/1:1/09677012480@g1) Running State Change CS_INIT 2010-07-19 01:50:17.633931 [DEBUG] switch_core_state_machine.c:338 (OpenZAP/1:1/09677012480@g1) State INIT 2010-07-19 01:50:17.633931 [DEBUG] mod_openzap.c:431 (OpenZAP/1:1/09677012480@g1) State Change CS_INIT -> CS_ROUTING 2010-07-19 01:50:17.633931 [DEBUG] switch_core_session.c:1027 Send signal OpenZAP/1:1/09677012480@g1 [BREAK] 2010-07-19 01:50:17.633931 [DEBUG] switch_core_state_machine.c:338 (OpenZAP/1:1/09677012480@g1) State INIT going to sleep 2010-07-19 01:50:17.633931 [DEBUG] switch_core_state_machine.c:314 (OpenZAP/1:1/09677012480@g1) Running State Change CS_ROUTING 2010-07-19 01:50:17.633931 [DEBUG] switch_channel.c:1471 (OpenZAP/1:1/09677012480@g1) Callstate Change DOWN -> RINGING 2010-07-19 01:50:17.633931 [DEBUG] switch_core_state_machine.c:341 (OpenZAP/1:1/09677012480@g1) State ROUTING 2010-07-19 01:50:17.633931 [DEBUG] mod_openzap.c:454 OpenZAP/1:1/09677012480@g1 CHANNEL ROUTING 2010-07-19 01:50:17.633931 [DEBUG] switch_ivr_originate.c:64 (OpenZAP/1:1/09677012480@g1) State Change CS_ROUTING -> CS_CONSUME_MEDIA 2010-07-19 01:50:17.633931 [DEBUG] switch_core_session.c:1027 Send signal OpenZAP/1:1/09677012480@g1 [BREAK] 2010-07-19 01:50:17.633931 [DEBUG] switch_core_state_machine.c:341 (OpenZAP/1:1/09677012480@g1) State ROUTING going to sleep 2010-07-19 01:50:17.633931 [DEBUG] switch_core_state_machine.c:314 (OpenZAP/1:1/09677012480@g1) Running State Change CS_CONSUME_MEDIA 2010-07-19 01:50:17.633931 [DEBUG] switch_core_state_machine.c:360 (OpenZAP/1:1/09677012480@g1) State CONSUME_MEDIA 2010-07-19 01:50:17.633931 [DEBUG] switch_core_state_machine.c:360 (OpenZAP/1:1/09677012480@g1) State CONSUME_MEDIA going to sleep 2010-07-19 01:50:47.638427 [DEBUG] ozmod_analog.c:354 Changing state on 1:1 from DIALING to BUSY 2010-07-19 01:50:47.658427 [DEBUG] ozmod_analog.c:464 Executing state handler on 1:1 for BUSY 2010-07-19 01:50:47.658427 [DEBUG] ozmod_analog.c:593 Changing state on 1:1 from BUSY to DOWN 2010-07-19 01:50:47.678427 [DEBUG] ozmod_analog.c:464 Executing state handler on 1:1 for DOWN 2010-07-19 01:50:47.678427 [WARNING] mod_openzap.c:2038 Unhandled analog channel type 0 for channel 1:1 2010-07-19 01:50:47.678427 [DEBUG] zap_io.c:1388 channel done 1:1 2010-07-19 01:50:47.678427 [DEBUG] ozmod_analog.c:778 ANALOG CHANNEL 1:1 thread ended. 2010-07-19 01:51:16.667683 [DEBUG] sofia.c:4310 Channel sofia/internal/ 1000(a)192.168.1.110 entering state [terminated][487] 2010-07-19 01:51:16.667683 [DEBUG] switch_channel.c:2261 (sofia/internal/ 1000(a)192.168.1.110) Callstate Change RINGING -> HANGUP 2010-07-19 01:51:16.667683 [NOTICE] sofia.c:4924 Hangup sofia/internal/ 1000(a)192.168.1.110 [CS_EXECUTE] [ORIGINATOR_CANCEL] 2010-07-19 01:51:16.667683 [DEBUG] switch_channel.c:2277 Send signal sofia/internal/1000(a)192.168.1.110 [KILL] 2010-07-19 01:51:16.667683 [DEBUG] switch_core_session.c:1027 Send signal sofia/internal/1000(a)192.168.1.110 [BREAK] 2010-07-19 01:51:16.667683 [DEBUG] switch_channel.c:2261 (OpenZAP/1:1/09677012480@g1) Callstate Change RINGING -> HANGUP 2010-07-19 01:51:16.667683 [NOTICE] switch_ivr_originate.c:3220 Hangup OpenZAP/1:1/09677012480@g1 [CS_CONSUME_MEDIA] [ORIGINATOR_CANCEL] 2010-07-19 01:51:16.667683 [DEBUG] switch_channel.c:2277 Send signal OpenZAP/1:1/09677012480@g1 [KILL] 2010-07-19 01:51:16.667683 [DEBUG] switch_core_session.c:1027 Send signal OpenZAP/1:1/09677012480@g1 [BREAK] 2010-07-19 01:51:16.667683 [DEBUG] switch_ivr_originate.c:3363 Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL] 2010-07-19 01:51:16.667683 [INFO] mod_dptools.c:2382 Originate Failed. Cause: ORIGINATOR_CANCEL 2010-07-19 01:51:16.667683 [DEBUG] switch_core_state_machine.c:314 (OpenZAP/1:1/09677012480@g1) Running State Change CS_HANGUP 2010-07-19 01:51:16.669919 [DEBUG] switch_core_state_machine.c:348 (sofia/internal/1000(a)192.168.1.110) State EXECUTE going to sleep 2010-07-19 01:51:16.669919 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/1000(a)192.168.1.110) Running State Change CS_HANGUP 2010-07-19 01:51:16.669919 [DEBUG] switch_core_state_machine.c:500 (OpenZAP/1:1/09677012480@g1) State HANGUP 2010-07-19 01:51:16.669919 [DEBUG] mod_openzap.c:556 OpenZAP/1:1/09677012480@g1 CHANNEL HANGUP 2010-07-19 01:51:16.669919 [DEBUG] switch_core_state_machine.c:46 OpenZAP/1:1/09677012480@g1 Standard HANGUP, cause: ORIGINATOR_CANCEL 2010-07-19 01:51:16.669919 [DEBUG] switch_core_state_machine.c:500 (OpenZAP/1:1/09677012480@g1) State HANGUP going to sleep 2010-07-19 01:51:16.669919 [DEBUG] switch_core_state_machine.c:333 (OpenZAP/1:1/09677012480@g1) State Change CS_HANGUP -> CS_REPORTING 2010-07-19 01:51:16.669919 [DEBUG] switch_core_session.c:1027 Send signal OpenZAP/1:1/09677012480@g1 [BREAK] 2010-07-19 01:51:16.669919 [DEBUG] switch_core_state_machine.c:314 (OpenZAP/1:1/09677012480@g1) Running State Change CS_REPORTING 2010-07-19 01:51:16.669919 [DEBUG] switch_core_state_machine.c:591 (OpenZAP/1:1/09677012480@g1) State REPORTING 2010-07-19 01:51:16.669919 [DEBUG] switch_core_state_machine.c:53 OpenZAP/1:1/09677012480@g1 Standard REPORTING, cause: ORIGINATOR_CANCEL 2010-07-19 01:51:16.669919 [DEBUG] switch_core_state_machine.c:591 (OpenZAP/1:1/09677012480@g1) State REPORTING going to sleep 2010-07-19 01:51:16.669919 [DEBUG] switch_core_state_machine.c:327 (OpenZAP/1:1/09677012480@g1) State Change CS_REPORTING -> CS_DESTROY 2010-07-19 01:51:16.669919 [DEBUG] switch_core_session.c:1027 Send signal OpenZAP/1:1/09677012480@g1 [BREAK] 2010-07-19 01:51:16.669919 [DEBUG] switch_core_session.c:1175 Session 33 (OpenZAP/1:1/09677012480@g1) Locked, Waiting on external entities 2010-07-19 01:51:16.669919 [NOTICE] switch_core_session.c:1193 Session 33 (OpenZAP/1:1/09677012480@g1) Ended 2010-07-19 01:51:16.669919 [NOTICE] switch_core_session.c:1195 Close Channel OpenZAP/1:1/09677012480@g1 [CS_DESTROY] 2010-07-19 01:51:16.669919 [DEBUG] switch_core_state_machine.c:500 (sofia/internal/1000(a)192.168.1.110) State HANGUP 2010-07-19 01:51:16.669919 [DEBUG] mod_sofia.c:449 sofia/internal/ 1000(a)192.168.1.110 Overriding SIP cause 487 with 487 from the other leg 2010-07-19 01:51:16.669919 [DEBUG] mod_sofia.c:455 Channel sofia/internal/ 1000(a)192.168.1.110 hanging up, cause: ORIGINATOR_CANCEL 2010-07-19 01:51:16.669919 [DEBUG] switch_core_state_machine.c:427 (OpenZAP/1:1/09677012480@g1) Callstate Change HANGUP -> DOWN 2010-07-19 01:51:16.669919 [DEBUG] switch_core_state_machine.c:430 (OpenZAP/1:1/09677012480@g1) Running State Change CS_DESTROY 2010-07-19 01:51:16.669919 [DEBUG] switch_core_state_machine.c:440 (OpenZAP/1:1/09677012480@g1) State DESTROY 2010-07-19 01:51:16.669919 [DEBUG] switch_core_state_machine.c:60 OpenZAP/1:1/09677012480@g1 Standard DESTROY 2010-07-19 01:51:16.669919 [DEBUG] switch_core_state_machine.c:440 (OpenZAP/1:1/09677012480@g1) State DESTROY going to sleep 2010-07-19 01:51:16.699683 [DEBUG] switch_core_state_machine.c:46 sofia/internal/1000(a)192.168.1.110 Standard HANGUP, cause: ORIGINATOR_CANCEL 2010-07-19 01:51:16.699683 [DEBUG] switch_core_state_machine.c:500 (sofia/internal/1000(a)192.168.1.110) State HANGUP going to sleep 2010-07-19 01:51:16.701682 [DEBUG] switch_core_state_machine.c:333 (sofia/internal/1000(a)192.168.1.110) State Change CS_HANGUP -> CS_REPORTING 2010-07-19 01:51:16.701682 [DEBUG] switch_core_session.c:1027 Send signal sofia/internal/1000(a)192.168.1.110 [BREAK] 2010-07-19 01:51:16.701682 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/1000(a)192.168.1.110) Running State Change CS_REPORTING 2010-07-19 01:51:16.701682 [DEBUG] switch_core_state_machine.c:591 (sofia/internal/1000(a)192.168.1.110) State REPORTING 2010-07-19 01:51:16.701682 [DEBUG] switch_core_state_machine.c:53 sofia/internal/1000(a)192.168.1.110 Standard REPORTING, cause: ORIGINATOR_CANCEL 2010-07-19 01:51:16.701682 [DEBUG] switch_core_state_machine.c:591 (sofia/internal/1000(a)192.168.1.110) State REPORTING going to sleep 2010-07-19 01:51:16.701682 [DEBUG] switch_core_state_machine.c:327 (sofia/internal/1000(a)192.168.1.110) State Change CS_REPORTING -> CS_DESTROY 2010-07-19 01:51:16.701682 [DEBUG] switch_core_session.c:1027 Send signal sofia/internal/1000(a)192.168.1.110 [BREAK] 2010-07-19 01:51:16.701682 [DEBUG] switch_core_session.c:1175 Session 32 (sofia/internal/1000(a)192.168.1.110) Locked, Waiting on external entities 2010-07-19 01:51:16.701682 [NOTICE] switch_core_session.c:1193 Session 32 (sofia/internal/1000(a)192.168.1.110) Ended 2010-07-19 01:51:16.701682 [NOTICE] switch_core_session.c:1195 Close Channel sofia/internal/1000(a)192.168.1.110 [CS_DESTROY] 2010-07-19 01:51:16.701682 [DEBUG] switch_core_state_machine.c:427 (sofia/internal/1000(a)192.168.1.110) Callstate Change HANGUP -> DOWN 2010-07-19 01:51:16.701682 [DEBUG] switch_core_state_machine.c:430 (sofia/internal/1000(a)192.168.1.110) Running State Change CS_DESTROY 2010-07-19 01:51:16.701682 [DEBUG] switch_core_state_machine.c:440 (sofia/internal/1000(a)192.168.1.110) State DESTROY 2010-07-19 01:51:16.701682 [DEBUG] mod_sofia.c:360 sofia/internal/ 1000(a)192.168.1.110 SOFIA DESTROY 2010-07-19 01:51:16.701682 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1000(a)192.168.1.110 Standard DESTROY 2010-07-19 01:51:16.701682 [DEBUG] switch_core_state_machine.c:440 (sofia/internal/1000(a)192.168.1.110) State DESTROY going to sleep Thanks in advance, Regards, Venkat.

4 7