freeswitchforum.com https://freeswitchforum.com/ |
|
Переадресация с IVR https://freeswitchforum.com/viewtopic.php?f=6&t=182 |
Страница 2 из 2 |
Автор: | sugiura [ 03 сен 2013 11:04 ] |
Заголовок сообщения: | Re: Переадресация с IVR |
Так ведь.. Цитата: 9090 - Set CF for my phone (from my phone) 9091 - Set CF for any extension (from any phone) 9092 - Cancel CF for my phone (from my phone) 9093 - Cancel CF for any extension (from any phone) Цитата: Go to a phone that you would like to call forward. Dial 9090 and then enter in a destination number. For a simple test, send the call to '9192' so that it does an info dump and then exits. If you call your source extension number it will "forward" to 9192, which does the info dump and hangs up. To see what's actually happening, consider an example where I used extension 1007. After setting the call forward to 9192, go to the fs_cli and type this command: Код: expand hash_dump all ${domain}-CF Цитата: You should see something like this: Код: D/10.15.128.192-CF_1001/9192 Или я что-то не так понял? Чтобы настроить переадресацию телефона 1001, надо с 1001 позвонить на 9090 и набрать номер, куда будет идти переадресация. Так? |
Автор: | Vlad1983 [ 03 сен 2013 12:05 ] |
Заголовок сообщения: | Re: Переадресация с IVR |
Код: <extension name="CF from my station"> <condition field="destination_number" expression="^(9090)$"> <action application="answer"/> <action application="log" data="INFO Set CF from ${caller_id_number}"/> <action application="play_and_get_digits" data="4 4 3 3000 # phrase:enter_dest_number ivr/ivr-that_was_an_invalid_entry.wav target_number \d+"/> <action application="hash" data="insert/${domain_name}-CF/${caller_id_number}/${target_number}"/> <action application="sleep" data="1000"/> <action application="playback" data="phrase:call_forward_set:${caller_id_number}:${target_number}"/> </condition> </extension> позвонив на 9090 должны услышать enter_dest_number (которого у вас нет), соответственно play_and_get_digits не выполняется от этого ${target_number} выходит пустой |
Автор: | sugiura [ 04 сен 2013 06:43 ] |
Заголовок сообщения: | Re: Переадресация с IVR |
Но там есть enter_dest_number, дает ввести, а по окончании произносит два номера - номер, с которого позвонил и номер, который ввел |
Автор: | Vlad1983 [ 04 сен 2013 06:52 ] |
Заголовок сообщения: | Re: Переадресация с IVR |
выкладывайте полный листинг консоли установки переадресации expand hash_dump all ${domain}-CF и полный листинг вызова на номер на котором стоит переадресация |
Автор: | sugiura [ 04 сен 2013 07:21 ] |
Заголовок сообщения: | Re: Переадресация с IVR |
Код: 2013-09-04 11:57:50.696568 [NOTICE] switch_channel.c:1030 New Channel sofia/sipinterface_1/1003@194.143.148.10 [27a796b16b9652cd5a1647e96ccb4033@10.1.4.158] 2013-09-04 11:57:50.696568 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/1003@194.143.148.10 [BREAK] 2013-09-04 11:57:50.696568 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/1003@194.143.148.10 [BREAK] 2013-09-04 11:57:50.696568 [DEBUG] switch_core_state_machine.c:418 (sofia/sipinterface_1/1003@194.143.148.10) Running State Change CS_NEW 2013-09-04 11:57:50.696568 [DEBUG] switch_core_state_machine.c:436 (sofia/sipinterface_1/1003@194.143.148.10) State NEW 2013-09-04 11:57:50.716583 [DEBUG] sofia.c:7958 1 acls to check for proxy 2013-09-04 11:57:50.716583 [DEBUG] sofia.c:7963 checking 10.1.4.158 against acl authoritative 2013-09-04 11:57:50.716583 [DEBUG] sofia.c:8003 IP 10.1.4.158 Rejected by acl "authoritative". Falling back to Digest auth. 2013-09-04 11:57:50.716583 [WARNING] sofia_reg.c:1632 SIP auth challenge (INVITE) on sofia profile 'sipinterface_1' for [9090@194.143.148.10] from ip 10.1.4.158 2013-09-04 11:57:50.716583 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/1003@194.143.148.10 [BREAK] 2013-09-04 11:57:50.716583 [DEBUG] sofia.c:1788 detaching session 27a796b16b9652cd5a1647e96ccb4033@10.1.4.158 2013-09-04 11:57:51.116570 [DEBUG] sofia.c:1880 Re-attaching to session 27a796b16b9652cd5a1647e96ccb4033@10.1.4.158 2013-09-04 11:57:51.116570 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/1003@194.143.148.10 [BREAK] 2013-09-04 11:57:51.116570 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/1003@194.143.148.10 [BREAK] 2013-09-04 11:57:51.136580 [DEBUG] sofia.c:7958 1 acls to check for proxy 2013-09-04 11:57:51.136580 [DEBUG] sofia.c:7963 checking 10.1.4.158 against acl authoritative 2013-09-04 11:57:51.136580 [DEBUG] sofia.c:8003 IP 10.1.4.158 Rejected by acl "authoritative". Falling back to Digest auth. 2013-09-04 11:57:51.136580 [DEBUG] sofia.c:5834 Channel sofia/sipinterface_1/1003@194.143.148.10 entering state [received][100] 2013-09-04 11:57:51.136580 [DEBUG] sofia.c:5844 Remote SDP: v=0 o=- 7961 0 IN IP4 10.1.4.158 s=SIP CALL c=IN IP4 10.1.4.158 t=0 0 m=audio 60000 RTP/AVP 8 0 18 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:18 G729/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 2013-09-04 11:57:51.136580 [DEBUG] sofia.c:6056 (sofia/sipinterface_1/1003@194.143.148.10) State Change CS_NEW -> CS_INIT 2013-09-04 11:57:51.136580 [DEBUG] switch_core_session.c:1341 Send signal sofia/sipinterface_1/1003@194.143.148.10 [BREAK] 2013-09-04 11:57:51.136580 [DEBUG] switch_core_state_machine.c:418 (sofia/sipinterface_1/1003@194.143.148.10) Running State Change CS_INIT 2013-09-04 11:57:51.136580 [DEBUG] switch_core_state_machine.c:457 (sofia/sipinterface_1/1003@194.143.148.10) State INIT 2013-09-04 11:57:51.136580 [DEBUG] mod_sofia.c:87 sofia/sipinterface_1/1003@194.143.148.10 SOFIA INIT 2013-09-04 11:57:51.136580 [DEBUG] mod_sofia.c:114 (sofia/sipinterface_1/1003@194.143.148.10) State Change CS_INIT -> CS_ROUTING 2013-09-04 11:57:51.136580 [DEBUG] switch_core_session.c:1341 Send signal sofia/sipinterface_1/1003@194.143.148.10 [BREAK] 2013-09-04 11:57:51.136580 [DEBUG] switch_core_state_machine.c:457 (sofia/sipinterface_1/1003@194.143.148.10) State INIT going to sleep 2013-09-04 11:57:51.136580 [DEBUG] switch_core_state_machine.c:418 (sofia/sipinterface_1/1003@194.143.148.10) Running State Change CS_ROUTING 2013-09-04 11:57:51.136580 [DEBUG] switch_channel.c:2116 (sofia/sipinterface_1/1003@194.143.148.10) Callstate Change DOWN -> RINGING 2013-09-04 11:57:51.136580 [DEBUG] switch_core_state_machine.c:473 (sofia/sipinterface_1/1003@194.143.148.10) State ROUTING 2013-09-04 11:57:51.136580 [DEBUG] mod_sofia.c:137 sofia/sipinterface_1/1003@194.143.148.10 SOFIA ROUTING 2013-09-04 11:57:51.136580 [DEBUG] switch_core_state_machine.c:117 sofia/sipinterface_1/1003@194.143.148.10 Standard ROUTING 2013-09-04 11:57:51.136580 [INFO] mod_dialplan_xml.c:558 Processing 1003 <1003>->9090 in context default Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->record_session] continue=true Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (PASS) [record_session] ${caller_id_number}(1003) =~ /^.+$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Action set(RECORD_TITLE=Recording ${destination_number} ${caller_id_number} ${strftime(%Y-%m-%d %H:%M)}) Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Action set(RECORD_SOFTWARE=FreeSWITCH) Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Action set(RECORD_ARTIST=FreeSWITCH) Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Action set(RECORD_COMMENT=FreeSWITCH) Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Action set(RECORD_DATE=${strftime(%Y-%m-%d %H:%M)}) Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Action record_session(/usr/local/freeswitch/recordings/archive/${strftime(%Y)}/${strftime(%b)}/${strftime(%d)}/${strftime(%Y%m%d_%H%M%S)}_${caller_id_number}_${destination_number}.mp3) Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Action set(RECORD_STEREO=true) Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->unloop] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->global-intercept] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [global-intercept] destination_number(9090) =~ /^886$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->group-intercept] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [group-intercept] destination_number(9090) =~ /^\*8$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->intercept-ext] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [intercept-ext] destination_number(9090) =~ /^\*\*(\d+)$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->redial] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [redial] destination_number(9090) =~ /^(redial|870)$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->global] continue=true Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [global] ${rtp_has_crypto}() =~ /^(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)$/ break=never Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (PASS) [global] ${endpoint_disposition}(DELAYED NEGOTIATION) =~ /^(DELAYED NEGOTIATION)/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [global] ${switch_r_sdp}(v=0 o=- 7961 0 IN IP4 10.1.4.158 s=SIP CALL c=IN IP4 10.1.4.158 t=0 0 m=audio 60000 RTP/AVP 8 0 18 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:18 G729/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 ) =~ /(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)/ break=never Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Absolute Condition [global] Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid}) Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number}) Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Action hash(insert/${domain_name}-last_dial/global/${uuid}) Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->call_return] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [call_return] destination_number(9090) =~ /^\*69$|^869$|^lcr$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->del-group] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [del-group] destination_number(9090) =~ /^80(\d{2})$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->add-group] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [add-group] destination_number(9090) =~ /^81(\d{2})$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->call-group-simo] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [call-group-simo] destination_number(9090) =~ /^82(\d{2})$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->call-group-order] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [call-group-order] destination_number(9090) =~ /^83(\d{2})$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->extension-intercom] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [extension-intercom] destination_number(9090) =~ /^8(10[01][0-9])$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->Local_Extension] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [Local_Extension] destination_number(9090) =~ /^(10[01][0-9])$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->Check IVR-based CF] continue=true Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (PASS) [Check IVR-based CF] destination_number(9090) =~ /^(\d+)$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Action set(dialed_number=9090) INLINE EXECUTE sofia/sipinterface_1/1003@194.143.148.10 set(dialed_number=9090) 2013-09-04 11:57:51.136580 [DEBUG] mod_dptools.c:1395 sofia/sipinterface_1/1003@194.143.148.10 SET [dialed_number]=[9090] Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Action set(cf_target=${hash(select/${domain_name}-CF/9090)}) INLINE EXECUTE sofia/sipinterface_1/1003@194.143.148.10 set(cf_target=) 2013-09-04 11:57:51.136580 [DEBUG] mod_dptools.c:1395 sofia/sipinterface_1/1003@194.143.148.10 SET [cf_target]=[UNDEF] Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [Check IVR-based CF] ${cf_target}() =~ /^(\d+)$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->Local_Extension_Skinny] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [Local_Extension_Skinny] destination_number(9090) =~ /^(11[01][0-9])$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->group_dial_sales] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [group_dial_sales] destination_number(9090) =~ /^2000$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->group_dial_support] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [group_dial_support] destination_number(9090) =~ /^2001$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->group_dial_billing] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [group_dial_billing] destination_number(9090) =~ /^2002$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->operator] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [operator] destination_number(9090) =~ /^(operator|0)$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->vmain] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [vmain] destination_number(9090) =~ /^vmain$|^4000$|^\*98$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->sip_uri] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [sip_uri] destination_number(9090) =~ /^sip:(.*)$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->nb_conferences] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [nb_conferences] destination_number(9090) =~ /^(30\d{2})$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->wb_conferences] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [wb_conferences] destination_number(9090) =~ /^(31\d{2})$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->uwb_conferences] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [uwb_conferences] destination_number(9090) =~ /^(32\d{2})$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->cdquality_conferences] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [cdquality_conferences] destination_number(9090) =~ /^(33\d{2})$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->freeswitch_public_conf_via_sip] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [freeswitch_public_conf_via_sip] destination_number(9090) =~ /^9(888|8888|1616|3232)$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->mad_boss_intercom] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [mad_boss_intercom] destination_number(9090) =~ /^0911$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->mad_boss_intercom] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [mad_boss_intercom] destination_number(9090) =~ /^0912$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->mad_boss] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [mad_boss] destination_number(9090) =~ /^0913$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->ivr_demo] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [ivr_demo] destination_number(9090) =~ /^5000$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->dynamic_conference] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [dynamic_conference] destination_number(9090) =~ /^5001$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->rtp_multicast_page] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [rtp_multicast_page] destination_number(9090) =~ /^pagegroup$|^7243$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->park] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [park] destination_number(9090) =~ /^5900$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->unpark] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [unpark] destination_number(9090) =~ /^5901$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->valet_park] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [valet_park] destination_number(9090) =~ /^(6000)$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->valet_park] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [valet_park] destination_number(9090) =~ /^(60\d[1-9])$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->park] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (PASS) [park] source(mod_sofia) =~ /mod_sofia/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [park] destination_number(9090) =~ /park\+(\d+)/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->unpark] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (PASS) [unpark] source(mod_sofia) =~ /mod_sofia/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [unpark] destination_number(9090) =~ /^parking$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->park] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (PASS) [park] source(mod_sofia) =~ /mod_sofia/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [park] destination_number(9090) =~ /callpark/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->unpark] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (PASS) [unpark] source(mod_sofia) =~ /mod_sofia/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [unpark] destination_number(9090) =~ /pickup/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->wait] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [wait] destination_number(9090) =~ /^wait$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->fax_receive] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [fax_receive] destination_number(9090) =~ /^9178$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->fax_transmit] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [fax_transmit] destination_number(9090) =~ /^9179$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->ringback_180] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [ringback_180] destination_number(9090) =~ /^9180$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->ringback_183_uk_ring] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [ringback_183_uk_ring] destination_number(9090) =~ /^9181$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->ringback_183_music_ring] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [ringback_183_music_ring] destination_number(9090) =~ /^9182$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->ringback_post_answer_uk_ring] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [ringback_post_answer_uk_ring] destination_number(9090) =~ /^9183$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->ringback_post_answer_music] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [ringback_post_answer_music] destination_number(9090) =~ /^9184$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->ClueCon] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [ClueCon] destination_number(9090) =~ /^9191$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->show_info] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [show_info] destination_number(9090) =~ /^9192$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->video_record] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [video_record] destination_number(9090) =~ /^9193$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->video_playback] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [video_playback] destination_number(9090) =~ /^9194$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->delay_echo] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [delay_echo] destination_number(9090) =~ /^9195$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->echo] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [echo] destination_number(9090) =~ /^9196$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->milliwatt] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [milliwatt] destination_number(9090) =~ /^9197$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->tone_stream] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [tone_stream] destination_number(9090) =~ /^9198$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->zrtp_enrollement] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [zrtp_enrollement] destination_number(9090) =~ /^9787$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->hold_music] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [hold_music] destination_number(9090) =~ /^9664$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->laugh break] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [laugh break] destination_number(9090) =~ /^9386$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->1001] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [1001] context(default) =~ /public/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->1002] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [1002] context(default) =~ /public/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->1003] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [1003] context(default) =~ /public/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->Time_condition1] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [Time_condition1] destination_number(9090) =~ /^9999$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->gateway1.d3] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [gateway1.d3] destination_number(9090) =~ /^(\d{3})$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->Announce Conf Count (Inline)] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (FAIL) [Announce Conf Count (Inline)] destination_number(9090) =~ /^ANNOUNCE_CONF_COUNT_PRIVATE$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 parsing [default->CF from my station] continue=false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Regex (PASS) [CF from my station] destination_number(9090) =~ /^(9090)$/ break=on-false Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Action answer() Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Action log(INFO Set CF from ${caller_id_number}) Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Action play_and_get_digits(4 4 3 3000 # phrase:enter_dest_number ivr/ivr-that_was_an_invalid_entry.wav target_number \d+) Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Action hash(insert/${domain_name}-CF/${caller_id_number}/${target_number}) Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Action sleep(1000) Dialplan: sofia/sipinterface_1/1003@194.143.148.10 Action playback(phrase:call_forward_set:${caller_id_number}:${target_number}) 2013-09-04 11:57:51.156580 [DEBUG] switch_core_state_machine.c:167 (sofia/sipinterface_1/1003@194.143.148.10) State Change CS_ROUTING -> CS_EXECUTE 2013-09-04 11:57:51.156580 [DEBUG] switch_core_session.c:1341 Send signal sofia/sipinterface_1/1003@194.143.148.10 [BREAK] 2013-09-04 11:57:51.156580 [DEBUG] switch_core_state_machine.c:473 (sofia/sipinterface_1/1003@194.143.148.10) State ROUTING going to sleep 2013-09-04 11:57:51.156580 [DEBUG] switch_core_state_machine.c:418 (sofia/sipinterface_1/1003@194.143.148.10) Running State Change CS_EXECUTE 2013-09-04 11:57:51.156580 [DEBUG] switch_core_state_machine.c:480 (sofia/sipinterface_1/1003@194.143.148.10) State EXECUTE 2013-09-04 11:57:51.156580 [DEBUG] mod_sofia.c:230 sofia/sipinterface_1/1003@194.143.148.10 SOFIA EXECUTE 2013-09-04 11:57:51.156580 [DEBUG] switch_core_state_machine.c:209 sofia/sipinterface_1/1003@194.143.148.10 Standard EXECUTE EXECUTE sofia/sipinterface_1/1003@194.143.148.10 set(RECORD_TITLE=Recording 9090 1003 2013-09-04 11:57) 2013-09-04 11:57:51.156580 [DEBUG] mod_dptools.c:1395 sofia/sipinterface_1/1003@194.143.148.10 SET [RECORD_TITLE]=[Recording 9090 1003 2013-09-04 11:57] EXECUTE sofia/sipinterface_1/1003@194.143.148.10 set(RECORD_SOFTWARE=FreeSWITCH) 2013-09-04 11:57:51.156580 [DEBUG] mod_dptools.c:1395 sofia/sipinterface_1/1003@194.143.148.10 SET [RECORD_SOFTWARE]=[FreeSWITCH] EXECUTE sofia/sipinterface_1/1003@194.143.148.10 set(RECORD_ARTIST=FreeSWITCH) 2013-09-04 11:57:51.156580 [DEBUG] mod_dptools.c:1395 sofia/sipinterface_1/1003@194.143.148.10 SET [RECORD_ARTIST]=[FreeSWITCH] EXECUTE sofia/sipinterface_1/1003@194.143.148.10 set(RECORD_COMMENT=FreeSWITCH) 2013-09-04 11:57:51.156580 [DEBUG] mod_dptools.c:1395 sofia/sipinterface_1/1003@194.143.148.10 SET [RECORD_COMMENT]=[FreeSWITCH] EXECUTE sofia/sipinterface_1/1003@194.143.148.10 set(RECORD_DATE=2013-09-04 11:57) 2013-09-04 11:57:51.156580 [DEBUG] mod_dptools.c:1395 sofia/sipinterface_1/1003@194.143.148.10 SET [RECORD_DATE]=[2013-09-04 11:57] 2013-09-04 11:57:51.156580 [DEBUG] switch_core_session.c:2597 Application record_session Requires media! pre_answering channel sofia/sipinterface_1/1003@194.143.148.10 2013-09-04 11:57:51.156580 [INFO] switch_core_session.c:2599 Sending early media 2013-09-04 11:57:51.156580 [DEBUG] switch_core_media.c:2885 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMU:0:8000:20:64000] 2013-09-04 11:57:51.156580 [DEBUG] switch_core_media.c:2885 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMA:8:8000:20:64000] 2013-09-04 11:57:51.156580 [DEBUG] switch_core_media.c:1918 Set Codec sofia/sipinterface_1/1003@194.143.148.10 PCMA/8000 20 ms 160 samples 64000 bits 2013-09-04 11:57:51.156580 [DEBUG] switch_core_codec.c:111 sofia/sipinterface_1/1003@194.143.148.10 Original read codec set to PCMA:8 2013-09-04 11:57:51.156580 [DEBUG] switch_core_media.c:3056 Set 2833 dtmf send/recv payload to 101 2013-09-04 11:57:51.156580 [INFO] switch_nat.c:590 NAT port mapping disabled 2013-09-04 11:57:51.156580 [DEBUG] switch_core_media.c:4087 AUDIO RTP [sofia/sipinterface_1/1003@194.143.148.10] 194.143.148.10 port 17598 -> 10.1.4.158 port 60000 codec: 8 ms: 20 2013-09-04 11:57:51.156580 [DEBUG] switch_rtp.c:2891 Starting timer [soft] 160 bytes per 20ms 2013-09-04 11:57:51.156580 [DEBUG] switch_core_media.c:4423 Set 2833 dtmf send payload to 101 2013-09-04 11:57:51.156580 [DEBUG] switch_core_media.c:4429 Set 2833 dtmf receive payload to 101 2013-09-04 11:57:51.156580 [NOTICE] sofia_media.c:92 Pre-Answer sofia/sipinterface_1/1003@194.143.148.10! 2013-09-04 11:57:51.156580 [DEBUG] switch_channel.c:3316 (sofia/sipinterface_1/1003@194.143.148.10) Callstate Change RINGING -> EARLY 2013-09-04 11:57:51.156580 [DEBUG] mod_sofia.c:2135 Ring SDP: v=0 o=FreeSWITCH 1378245873 1378245874 IN IP4 194.143.148.10 s=FreeSWITCH c=IN IP4 194.143.148.10 t=0 0 m=audio 17598 RTP/AVP 8 101 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - a=ptime:20 a=sendrecv 2013-09-04 11:57:51.156580 [DEBUG] switch_core_session.c:861 Send signal sofia/sipinterface_1/1003@194.143.148.10 [BREAK] EXECUTE sofia/sipinterface_1/1003@194.143.148.10 record_session(/usr/local/freeswitch/recordings/archive/2013/Sep/04/20130904_115751_1003_9090.mp3) 2013-09-04 11:57:51.156580 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/1003@194.143.148.10 [BREAK] 2013-09-04 11:57:51.156580 [DEBUG] sofia.c:5834 Channel sofia/sipinterface_1/1003@194.143.148.10 entering state [early][183] 2013-09-04 11:57:51.156580 [INFO] mod_shout.c:324 LAME 3.98.4 32bits (http://www.mp3dev.org/) 2013-09-04 11:57:51.156580 [INFO] mod_shout.c:324 Using polyphase lowpass filter, transition band: 3903 Hz - 4000 Hz 2013-09-04 11:57:51.156580 [DEBUG] switch_core_media_bug.c:532 Attaching BUG to sofia/sipinterface_1/1003@194.143.148.10 EXECUTE sofia/sipinterface_1/1003@194.143.148.10 set(RECORD_STEREO=true) 2013-09-04 11:57:51.156580 [DEBUG] mod_dptools.c:1395 sofia/sipinterface_1/1003@194.143.148.10 SET [RECORD_STEREO]=[true] EXECUTE sofia/sipinterface_1/1003@194.143.148.10 hash(insert/194.143.148.10-spymap/1003/27a796b16b9652cd5a1647e96ccb4033@10.1.4.158) EXECUTE sofia/sipinterface_1/1003@194.143.148.10 hash(insert/194.143.148.10-last_dial/1003/9090) EXECUTE sofia/sipinterface_1/1003@194.143.148.10 hash(insert/194.143.148.10-last_dial/global/27a796b16b9652cd5a1647e96ccb4033@10.1.4.158) EXECUTE sofia/sipinterface_1/1003@194.143.148.10 export(RFC2822_DATE=Wed, 04 Sep 2013 11:57:51 +0900) 2013-09-04 11:57:51.176583 [DEBUG] switch_channel.c:1222 EXPORT (export_vars) [RFC2822_DATE]=[Wed, 04 Sep 2013 11:57:51 +0900] EXECUTE sofia/sipinterface_1/1003@194.143.148.10 answer() 2013-09-04 11:57:51.176583 [DEBUG] mod_sofia.c:824 Local SDP sofia/sipinterface_1/1003@194.143.148.10: v=0 o=FreeSWITCH 1378245873 1378245875 IN IP4 194.143.148.10 s=FreeSWITCH c=IN IP4 194.143.148.10 t=0 0 m=audio 17598 RTP/AVP 8 101 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - a=ptime:20 a=sendrecv 2013-09-04 11:57:51.176583 [DEBUG] switch_core_session.c:861 Send signal sofia/sipinterface_1/1003@194.143.148.10 [BREAK] 2013-09-04 11:57:51.176583 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/1003@194.143.148.10 [BREAK] 2013-09-04 11:57:51.176583 [NOTICE] mod_dptools.c:1218 Channel [sofia/sipinterface_1/1003@194.143.148.10] has been answered 2013-09-04 11:57:51.176583 [DEBUG] switch_channel.c:3595 (sofia/sipinterface_1/1003@194.143.148.10) Callstate Change EARLY -> ACTIVE 2013-09-04 11:57:51.176583 [DEBUG] sofia.c:5834 Channel sofia/sipinterface_1/1003@194.143.148.10 entering state [completed][200] EXECUTE sofia/sipinterface_1/1003@194.143.148.10 log(INFO Set CF from 1003) 2013-09-04 11:57:51.176583 [INFO] mod_dptools.c:1588 Set CF from 1003 EXECUTE sofia/sipinterface_1/1003@194.143.148.10 play_and_get_digits(4 4 3 3000 # phrase:enter_dest_number ivr/ivr-that_was_an_invalid_entry.wav target_number \d+) 2013-09-04 11:57:51.176583 [DEBUG] switch_ivr_play_say.c:70 No language specified - Using [ru] 2013-09-04 11:57:51.196584 [DEBUG] switch_ivr_play_say.c:251 Handle sleep:[1000] (ru:ru) 2013-09-04 11:57:51.316569 [DEBUG] switch_ivr_play_say.c:251 Handle play-file:[ivr/ivr-enter_destination_telephone_number.wav] (ru:ru) 2013-09-04 11:57:51.316569 [DEBUG] switch_ivr_play_say.c:1315 Codec Activated L16@8000hz 1 channels 20ms 2013-09-04 11:57:51.536570 [DEBUG] switch_rtp.c:4918 Correct ip/port confirmed. 2013-09-04 11:57:51.536570 [DEBUG] switch_core_io.c:489 Setting BUG Codec PCMA:8 2013-09-04 11:57:51.756569 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/1003@194.143.148.10 [BREAK] 2013-09-04 11:57:51.756569 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/1003@194.143.148.10 [BREAK] 2013-09-04 11:57:51.756569 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/1003@194.143.148.10 [BREAK] 2013-09-04 11:57:51.776572 [DEBUG] sofia.c:5834 Channel sofia/sipinterface_1/1003@194.143.148.10 entering state [ready][200] 2013-09-04 11:57:54.656568 [DEBUG] switch_ivr_play_say.c:1704 done playing file /usr/local/freeswitch/sounds/ru/RU/elena/ivr/ivr-enter_destination_telephone_number.wav 2013-09-04 11:57:54.756568 [DEBUG] switch_ivr_play_say.c:251 Handle sleep:[1000] (ru:ru) 2013-09-04 11:57:55.416568 [DEBUG] switch_rtp.c:5117 RTP RECV DTMF 1:800 2013-09-04 11:57:55.416568 [DEBUG] switch_channel.c:471 RECV DTMF 1:800 2013-09-04 11:57:55.676571 [DEBUG] switch_rtp.c:5117 RTP RECV DTMF 0:800 2013-09-04 11:57:55.676571 [DEBUG] switch_channel.c:471 RECV DTMF 0:800 2013-09-04 11:57:55.976571 [DEBUG] switch_rtp.c:5117 RTP RECV DTMF 0:800 2013-09-04 11:57:55.976571 [DEBUG] switch_channel.c:471 RECV DTMF 0:800 2013-09-04 11:57:56.156571 [DEBUG] switch_rtp.c:5117 RTP RECV DTMF 1:800 2013-09-04 11:57:56.156571 [DEBUG] switch_channel.c:471 RECV DTMF 1:800 EXECUTE sofia/sipinterface_1/1003@194.143.148.10 hash(insert/194.143.148.10-CF/1003/1001) EXECUTE sofia/sipinterface_1/1003@194.143.148.10 sleep(1000) 2013-09-04 11:57:56.536572 [DEBUG] switch_rtp.c:5117 RTP RECV DTMF #:800 2013-09-04 11:57:56.536572 [DEBUG] switch_channel.c:471 RECV DTMF #:800 EXECUTE sofia/sipinterface_1/1003@194.143.148.10 playback(phrase:call_forward_set:1003:1001) 2013-09-04 11:57:56.536572 [DEBUG] switch_ivr_play_say.c:70 No language specified - Using [ru] 2013-09-04 11:57:56.556571 [DEBUG] switch_ivr_play_say.c:251 Handle sleep:[1000] (ru:ru) 2013-09-04 11:57:56.676569 [DEBUG] switch_ivr_play_say.c:251 Handle play-file:[ivr/ivr-extension_number.wav] (ru:ru) 2013-09-04 11:57:56.676569 [DEBUG] switch_ivr_play_say.c:1315 Codec Activated L16@8000hz 1 channels 20ms 2013-09-04 11:57:56.676569 [DEBUG] mod_dptools.c:2098 Digit # 2013-09-04 11:57:57.816570 [DEBUG] switch_ivr_play_say.c:1704 done playing file /usr/local/freeswitch/sounds/ru/RU/elena/ivr/ivr-extension_number.wav 2013-09-04 11:57:57.936569 [DEBUG] switch_ivr_play_say.c:251 Handle sleep:[400] (ru:ru) 2013-09-04 11:57:58.056568 [DEBUG] switch_ivr_play_say.c:251 Handle say:[1003] (ru:ru) 2013-09-04 11:57:58.056568 [INFO] mod_say_ru.c:721 ru_say!!! 1003! say_opt.gender=0 say_opt.cases=0 2013-09-04 11:57:58.056568 [DEBUG] switch_ivr_play_say.c:1315 Codec Activated L16@8000hz 1 channels 20ms 2013-09-04 11:58:00.056570 [DEBUG] switch_ivr_play_say.c:1704 done playing file file_string://digits/1f.wav!digits/thousand.wav!digits/3.wav 2013-09-04 11:58:00.156571 [DEBUG] switch_ivr_play_say.c:251 Handle sleep:[400] (ru:ru) 2013-09-04 11:58:00.256571 [DEBUG] switch_ivr_play_say.c:251 Handle play-file:[digits/2.wav] (ru:ru) 2013-09-04 11:58:00.256571 [DEBUG] switch_ivr_play_say.c:1315 Codec Activated L16@8000hz 1 channels 20ms 2013-09-04 11:58:00.836568 [DEBUG] switch_ivr_play_say.c:1704 done playing file /usr/local/freeswitch/sounds/ru/RU/elena/digits/2.wav 2013-09-04 11:58:00.936568 [DEBUG] switch_ivr_play_say.c:251 Handle sleep:[1000] (ru:ru) 2013-09-04 11:58:01.036568 [DEBUG] switch_ivr_play_say.c:251 Handle play-file:[ivr/ivr-extension_number.wav] (ru:ru) 2013-09-04 11:58:01.036568 [DEBUG] switch_ivr_play_say.c:1315 Codec Activated L16@8000hz 1 channels 20ms 2013-09-04 11:58:02.176568 [DEBUG] switch_ivr_play_say.c:1704 done playing file /usr/local/freeswitch/sounds/ru/RU/elena/ivr/ivr-extension_number.wav 2013-09-04 11:58:02.276568 [DEBUG] switch_ivr_play_say.c:251 Handle sleep:[400] (ru:ru) 2013-09-04 11:58:02.376569 [DEBUG] switch_ivr_play_say.c:251 Handle say:[1001] (ru:ru) 2013-09-04 11:58:02.376569 [INFO] mod_say_ru.c:721 ru_say!!! 1001! say_opt.gender=0 say_opt.cases=0 2013-09-04 11:58:02.376569 [DEBUG] switch_ivr_play_say.c:1315 Codec Activated L16@8000hz 1 channels 20ms 2013-09-04 11:58:04.576568 [DEBUG] switch_ivr_play_say.c:1704 done playing file file_string://digits/1f.wav!digits/thousand.wav!digits/1.wav 2013-09-04 11:58:04.676568 [DEBUG] switch_ivr_play_say.c:251 Handle sleep:[1000] (ru:ru) 2013-09-04 11:58:04.776568 [DEBUG] switch_ivr_play_say.c:251 Handle play-file:[ivr/ivr-call_forwarding_has_been_set.wav] (ru:ru) 2013-09-04 11:58:04.776568 [DEBUG] switch_ivr_play_say.c:1315 Codec Activated L16@8000hz 1 channels 20ms 2013-09-04 11:58:07.296580 [DEBUG] switch_ivr_play_say.c:1704 done playing file /usr/local/freeswitch/sounds/ru/RU/elena/ivr/ivr-call_forwarding_has_been_set.wav 2013-09-04 11:58:07.416569 [DEBUG] switch_ivr_play_say.c:251 Handle sleep:[1500] (ru:ru) 2013-09-04 11:58:07.516569 [NOTICE] switch_core_state_machine.c:264 sofia/sipinterface_1/1003@194.143.148.10 has executed the last dialplan instruction, hanging up. 2013-09-04 11:58:07.516569 [NOTICE] switch_core_state_machine.c:266 Hangup sofia/sipinterface_1/1003@194.143.148.10 [CS_EXECUTE] [NORMAL_CLEARING] 2013-09-04 11:58:07.516569 [DEBUG] switch_channel.c:3135 Send signal sofia/sipinterface_1/1003@194.143.148.10 [KILL] 2013-09-04 11:58:07.516569 [DEBUG] switch_core_session.c:1341 Send signal sofia/sipinterface_1/1003@194.143.148.10 [BREAK] 2013-09-04 11:58:07.516569 [DEBUG] switch_core_state_machine.c:480 (sofia/sipinterface_1/1003@194.143.148.10) State EXECUTE going to sleep 2013-09-04 11:58:07.516569 [DEBUG] switch_core_state_machine.c:418 (sofia/sipinterface_1/1003@194.143.148.10) Running State Change CS_HANGUP 2013-09-04 11:58:07.516569 [DEBUG] switch_ivr_async.c:1175 Stop recording file /usr/local/freeswitch/recordings/archive/2013/Sep/04/20130904_115751_1003_9090.mp3 2013-09-04 11:58:07.556570 [DEBUG] switch_core_media_bug.c:780 Removing BUG from sofia/sipinterface_1/1003@194.143.148.10 2013-09-04 11:58:07.556570 [DEBUG] switch_core_state_machine.c:681 (sofia/sipinterface_1/1003@194.143.148.10) State HANGUP 2013-09-04 11:58:07.556570 [DEBUG] mod_sofia.c:465 Channel sofia/sipinterface_1/1003@194.143.148.10 hanging up, cause: NORMAL_CLEARING 2013-09-04 11:58:07.556570 [DEBUG] mod_sofia.c:517 Sending BYE to sofia/sipinterface_1/1003@194.143.148.10 2013-09-04 11:58:07.556570 [DEBUG] switch_core_state_machine.c:48 sofia/sipinterface_1/1003@194.143.148.10 Standard HANGUP, cause: NORMAL_CLEARING 2013-09-04 11:58:07.556570 [DEBUG] switch_core_state_machine.c:681 (sofia/sipinterface_1/1003@194.143.148.10) State HANGUP going to sleep 2013-09-04 11:58:07.556570 [DEBUG] switch_core_state_machine.c:694 (sofia/sipinterface_1/1003@194.143.148.10) Callstate Change ACTIVE -> HANGUP 2013-09-04 11:58:07.556570 [DEBUG] switch_core_state_machine.c:449 (sofia/sipinterface_1/1003@194.143.148.10) State Change CS_HANGUP -> CS_REPORTING 2013-09-04 11:58:07.556570 [DEBUG] switch_core_session.c:1341 Send signal sofia/sipinterface_1/1003@194.143.148.10 [BREAK] 2013-09-04 11:58:07.556570 [DEBUG] switch_core_state_machine.c:418 (sofia/sipinterface_1/1003@194.143.148.10) Running State Change CS_REPORTING 2013-09-04 11:58:07.556570 [DEBUG] switch_core_state_machine.c:766 (sofia/sipinterface_1/1003@194.143.148.10) State REPORTING 2013-09-04 11:58:07.556570 [DEBUG] switch_core_state_machine.c:92 sofia/sipinterface_1/1003@194.143.148.10 Standard REPORTING, cause: NORMAL_CLEARING 2013-09-04 11:58:07.556570 [DEBUG] switch_core_state_machine.c:766 (sofia/sipinterface_1/1003@194.143.148.10) State REPORTING going to sleep 2013-09-04 11:58:07.556570 [DEBUG] switch_core_state_machine.c:443 (sofia/sipinterface_1/1003@194.143.148.10) State Change CS_REPORTING -> CS_DESTROY 2013-09-04 11:58:07.556570 [DEBUG] switch_core_session.c:1341 Send signal sofia/sipinterface_1/1003@194.143.148.10 [BREAK] 2013-09-04 11:58:07.556570 [DEBUG] switch_core_session.c:1549 Session 55 (sofia/sipinterface_1/1003@194.143.148.10) Locked, Waiting on external entities 2013-09-04 11:58:07.556570 [NOTICE] switch_core_session.c:1567 Session 55 (sofia/sipinterface_1/1003@194.143.148.10) Ended 2013-09-04 11:58:07.556570 [NOTICE] switch_core_session.c:1571 Close Channel sofia/sipinterface_1/1003@194.143.148.10 [CS_DESTROY] 2013-09-04 11:58:07.556570 [DEBUG] switch_core_state_machine.c:568 (sofia/sipinterface_1/1003@194.143.148.10) Callstate Change HANGUP -> DOWN 2013-09-04 11:58:07.556570 [DEBUG] switch_core_state_machine.c:571 (sofia/sipinterface_1/1003@194.143.148.10) Running State Change CS_DESTROY 2013-09-04 11:58:07.556570 [DEBUG] switch_core_state_machine.c:581 (sofia/sipinterface_1/1003@194.143.148.10) State DESTROY 2013-09-04 11:58:07.556570 [DEBUG] mod_sofia.c:375 sofia/sipinterface_1/1003@194.143.148.10 SOFIA DESTROY 2013-09-04 11:58:07.556570 [DEBUG] switch_core_state_machine.c:99 sofia/sipinterface_1/1003@194.143.148.10 Standard DESTROY 2013-09-04 11:58:07.556570 [DEBUG] switch_core_state_machine.c:581 (sofia/sipinterface_1/1003@194.143.148.10) State DESTROY going to sleep expand hash_dump all ${domain}-CF Код: D/194.143.148.10-CF_1003/1001
|
Автор: | Vlad1983 [ 04 сен 2013 07:24 ] |
Заголовок сообщения: | Re: Переадресация с IVR |
Vlad1983 писал(а): и полный листинг вызова на номер на котором стоит переадресация
|
Автор: | sugiura [ 04 сен 2013 07:29 ] |
Заголовок сообщения: | Re: Переадресация с IVR |
Да, да, просто не влезло сразу, превышен лимит символов на сообщение:) А второе сразу нельзя.. Код: 2013-09-04 12:00:56.916569 [WARNING] sofia_reg.c:1632 SIP auth challenge (REGISTER) on sofia profile 'sipinterface_1' for [1001@194.143.148.10] from ip 10.1.4.156 2013-09-04 12:00:57.516570 [WARNING] sofia_reg.c:1632 SIP auth challenge (REGISTER) on sofia profile 'sipinterface_1' for [1002@194.143.148.10] from ip 10.1.4.157 2013-09-04 12:01:06.596568 [NOTICE] switch_channel.c:1030 New Channel sofia/sipinterface_1/1002@194.143.148.10 [51d9ad582a0396635186532149bbc557@10.1.4.157] 2013-09-04 12:01:06.596568 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/1002@194.143.148.10 [BREAK] 2013-09-04 12:01:06.596568 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/1002@194.143.148.10 [BREAK] 2013-09-04 12:01:06.596568 [DEBUG] switch_core_state_machine.c:418 (sofia/sipinterface_1/1002@194.143.148.10) Running State Change CS_NEW 2013-09-04 12:01:06.596568 [DEBUG] switch_core_state_machine.c:436 (sofia/sipinterface_1/1002@194.143.148.10) State NEW 2013-09-04 12:01:06.616573 [DEBUG] sofia.c:7958 1 acls to check for proxy 2013-09-04 12:01:06.616573 [DEBUG] sofia.c:7963 checking 10.1.4.157 against acl authoritative 2013-09-04 12:01:06.616573 [DEBUG] sofia.c:8003 IP 10.1.4.157 Rejected by acl "authoritative". Falling back to Digest auth. 2013-09-04 12:01:06.616573 [WARNING] sofia_reg.c:1632 SIP auth challenge (INVITE) on sofia profile 'sipinterface_1' for [1003@194.143.148.10] from ip 10.1.4.157 2013-09-04 12:01:06.616573 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/1002@194.143.148.10 [BREAK] 2013-09-04 12:01:06.616573 [DEBUG] sofia.c:1788 detaching session 51d9ad582a0396635186532149bbc557@10.1.4.157 2013-09-04 12:01:07.056568 [DEBUG] sofia.c:1880 Re-attaching to session 51d9ad582a0396635186532149bbc557@10.1.4.157 2013-09-04 12:01:07.056568 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/1002@194.143.148.10 [BREAK] 2013-09-04 12:01:07.056568 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/1002@194.143.148.10 [BREAK] 2013-09-04 12:01:07.056568 [DEBUG] sofia.c:7958 1 acls to check for proxy 2013-09-04 12:01:07.056568 [DEBUG] sofia.c:7963 checking 10.1.4.157 against acl authoritative 2013-09-04 12:01:07.056568 [DEBUG] sofia.c:8003 IP 10.1.4.157 Rejected by acl "authoritative". Falling back to Digest auth. 2013-09-04 12:01:07.056568 [DEBUG] sofia.c:5834 Channel sofia/sipinterface_1/1002@194.143.148.10 entering state [received][100] 2013-09-04 12:01:07.056568 [DEBUG] sofia.c:5844 Remote SDP: v=0 o=- 336 0 IN IP4 10.1.4.157 s=SIP CALL c=IN IP4 10.1.4.157 t=0 0 m=audio 60000 RTP/AVP 8 0 18 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:18 G729/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 2013-09-04 12:01:07.056568 [DEBUG] sofia.c:6056 (sofia/sipinterface_1/1002@194.143.148.10) State Change CS_NEW -> CS_INIT 2013-09-04 12:01:07.056568 [DEBUG] switch_core_session.c:1341 Send signal sofia/sipinterface_1/1002@194.143.148.10 [BREAK] 2013-09-04 12:01:07.056568 [DEBUG] switch_core_state_machine.c:418 (sofia/sipinterface_1/1002@194.143.148.10) Running State Change CS_INIT 2013-09-04 12:01:07.056568 [DEBUG] switch_core_state_machine.c:457 (sofia/sipinterface_1/1002@194.143.148.10) State INIT 2013-09-04 12:01:07.056568 [DEBUG] mod_sofia.c:87 sofia/sipinterface_1/1002@194.143.148.10 SOFIA INIT 2013-09-04 12:01:07.056568 [DEBUG] mod_sofia.c:114 (sofia/sipinterface_1/1002@194.143.148.10) State Change CS_INIT -> CS_ROUTING 2013-09-04 12:01:07.056568 [DEBUG] switch_core_session.c:1341 Send signal sofia/sipinterface_1/1002@194.143.148.10 [BREAK] 2013-09-04 12:01:07.056568 [DEBUG] switch_core_state_machine.c:457 (sofia/sipinterface_1/1002@194.143.148.10) State INIT going to sleep 2013-09-04 12:01:07.056568 [DEBUG] switch_core_state_machine.c:418 (sofia/sipinterface_1/1002@194.143.148.10) Running State Change CS_ROUTING 2013-09-04 12:01:07.056568 [DEBUG] switch_channel.c:2116 (sofia/sipinterface_1/1002@194.143.148.10) Callstate Change DOWN -> RINGING 2013-09-04 12:01:07.056568 [DEBUG] switch_core_state_machine.c:473 (sofia/sipinterface_1/1002@194.143.148.10) State ROUTING 2013-09-04 12:01:07.056568 [DEBUG] mod_sofia.c:137 sofia/sipinterface_1/1002@194.143.148.10 SOFIA ROUTING 2013-09-04 12:01:07.056568 [DEBUG] switch_core_state_machine.c:117 sofia/sipinterface_1/1002@194.143.148.10 Standard ROUTING 2013-09-04 12:01:07.056568 [INFO] mod_dialplan_xml.c:558 Processing 1002 <1002>->1003 in context default Dialplan: sofia/sipinterface_1/1002@194.143.148.10 parsing [default->record_session] continue=true Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Regex (PASS) [record_session] ${caller_id_number}(1002) =~ /^.+$/ break=on-false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action set(RECORD_TITLE=Recording ${destination_number} ${caller_id_number} ${strftime(%Y-%m-%d %H:%M)}) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action set(RECORD_SOFTWARE=FreeSWITCH) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action set(RECORD_ARTIST=FreeSWITCH) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action set(RECORD_COMMENT=FreeSWITCH) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action set(RECORD_DATE=${strftime(%Y-%m-%d %H:%M)}) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action record_session(/usr/local/freeswitch/recordings/archive/${strftime(%Y)}/${strftime(%b)}/${strftime(%d)}/${strftime(%Y%m%d_%H%M%S)}_${caller_id_number}_${destination_number}.mp3) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action set(RECORD_STEREO=true) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 parsing [default->unloop] continue=false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 parsing [default->global-intercept] continue=false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Regex (FAIL) [global-intercept] destination_number(1003) =~ /^886$/ break=on-false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 parsing [default->group-intercept] continue=false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Regex (FAIL) [group-intercept] destination_number(1003) =~ /^\*8$/ break=on-false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 parsing [default->intercept-ext] continue=false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Regex (FAIL) [intercept-ext] destination_number(1003) =~ /^\*\*(\d+)$/ break=on-false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 parsing [default->redial] continue=false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Regex (FAIL) [redial] destination_number(1003) =~ /^(redial|870)$/ break=on-false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 parsing [default->global] continue=true Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Regex (FAIL) [global] ${rtp_has_crypto}() =~ /^(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)$/ break=never Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Regex (PASS) [global] ${endpoint_disposition}(DELAYED NEGOTIATION) =~ /^(DELAYED NEGOTIATION)/ break=on-false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Regex (FAIL) [global] ${switch_r_sdp}(v=0 o=- 336 0 IN IP4 10.1.4.157 s=SIP CALL c=IN IP4 10.1.4.157 t=0 0 m=audio 60000 RTP/AVP 8 0 18 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:18 G729/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 ) =~ /(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)/ break=never Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Absolute Condition [global] Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid}) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number}) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action hash(insert/${domain_name}-last_dial/global/${uuid}) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 parsing [default->call_return] continue=false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Regex (FAIL) [call_return] destination_number(1003) =~ /^\*69$|^869$|^lcr$/ break=on-false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 parsing [default->del-group] continue=false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Regex (FAIL) [del-group] destination_number(1003) =~ /^80(\d{2})$/ break=on-false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 parsing [default->add-group] continue=false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Regex (FAIL) [add-group] destination_number(1003) =~ /^81(\d{2})$/ break=on-false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 parsing [default->call-group-simo] continue=false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Regex (FAIL) [call-group-simo] destination_number(1003) =~ /^82(\d{2})$/ break=on-false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 parsing [default->call-group-order] continue=false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Regex (FAIL) [call-group-order] destination_number(1003) =~ /^83(\d{2})$/ break=on-false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 parsing [default->extension-intercom] continue=false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Regex (FAIL) [extension-intercom] destination_number(1003) =~ /^8(10[01][0-9])$/ break=on-false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 parsing [default->Local_Extension] continue=false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Regex (PASS) [Local_Extension] destination_number(1003) =~ /^(10[01][0-9])$/ break=on-false Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action export(dialed_extension=1003) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action bind_meta_app(1 b s execute_extension::dx XML features) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action bind_meta_app(2 b s record_session::/usr/local/freeswitch/recordings/${caller_id_number}.${strftime(%Y-%m-%d-%H-%M-%S)}.wav) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action bind_meta_app(3 b s execute_extension::cf XML features) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action bind_meta_app(4 b s execute_extension::att_xfer XML features) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action set(ringback=${us-ring}) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action set(transfer_ringback=local_stream://moh) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action set(call_timeout=30) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action set(hangup_after_bridge=true) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action set(continue_on_fail=true) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action hash(insert/${domain_name}-call_return/${dialed_extension}/${caller_id_number}) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action hash(insert/${domain_name}-last_dial_ext/${dialed_extension}/${uuid}) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action set(called_party_callgroup=${user_data(${dialed_extension}@${domain_name} var callgroup)}) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action hash(insert/${domain_name}-last_dial_ext/${called_party_callgroup}/${uuid}) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action hash(insert/${domain_name}-last_dial_ext/global/${uuid}) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action hash(insert/${domain_name}-last_dial/${called_party_callgroup}/${uuid}) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action bridge(user/${dialed_extension}@${domain_name}) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action answer() Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action sleep(1000) Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Action bridge(loopback/app=voicemail:default ${domain_name} ${dialed_extension}) 2013-09-04 12:01:07.056568 [DEBUG] switch_core_state_machine.c:167 (sofia/sipinterface_1/1002@194.143.148.10) State Change CS_ROUTING -> CS_EXECUTE 2013-09-04 12:01:07.056568 [DEBUG] switch_core_session.c:1341 Send signal sofia/sipinterface_1/1002@194.143.148.10 [BREAK] 2013-09-04 12:01:07.056568 [DEBUG] switch_core_state_machine.c:473 (sofia/sipinterface_1/1002@194.143.148.10) State ROUTING going to sleep 2013-09-04 12:01:07.056568 [DEBUG] switch_core_state_machine.c:418 (sofia/sipinterface_1/1002@194.143.148.10) Running State Change CS_EXECUTE 2013-09-04 12:01:07.056568 [DEBUG] switch_core_state_machine.c:480 (sofia/sipinterface_1/1002@194.143.148.10) State EXECUTE 2013-09-04 12:01:07.056568 [DEBUG] mod_sofia.c:230 sofia/sipinterface_1/1002@194.143.148.10 SOFIA EXECUTE 2013-09-04 12:01:07.056568 [DEBUG] switch_core_state_machine.c:209 sofia/sipinterface_1/1002@194.143.148.10 Standard EXECUTE EXECUTE sofia/sipinterface_1/1002@194.143.148.10 set(RECORD_TITLE=Recording 1003 1002 2013-09-04 12:01) 2013-09-04 12:01:07.056568 [DEBUG] mod_dptools.c:1395 sofia/sipinterface_1/1002@194.143.148.10 SET [RECORD_TITLE]=[Recording 1003 1002 2013-09-04 12:01] EXECUTE sofia/sipinterface_1/1002@194.143.148.10 set(RECORD_SOFTWARE=FreeSWITCH) 2013-09-04 12:01:07.056568 [DEBUG] mod_dptools.c:1395 sofia/sipinterface_1/1002@194.143.148.10 SET [RECORD_SOFTWARE]=[FreeSWITCH] EXECUTE sofia/sipinterface_1/1002@194.143.148.10 set(RECORD_ARTIST=FreeSWITCH) 2013-09-04 12:01:07.076580 [DEBUG] mod_dptools.c:1395 sofia/sipinterface_1/1002@194.143.148.10 SET [RECORD_ARTIST]=[FreeSWITCH] EXECUTE sofia/sipinterface_1/1002@194.143.148.10 set(RECORD_COMMENT=FreeSWITCH) 2013-09-04 12:01:07.076580 [DEBUG] mod_dptools.c:1395 sofia/sipinterface_1/1002@194.143.148.10 SET [RECORD_COMMENT]=[FreeSWITCH] EXECUTE sofia/sipinterface_1/1002@194.143.148.10 set(RECORD_DATE=2013-09-04 12:01) 2013-09-04 12:01:07.076580 [DEBUG] mod_dptools.c:1395 sofia/sipinterface_1/1002@194.143.148.10 SET [RECORD_DATE]=[2013-09-04 12:01] 2013-09-04 12:01:07.076580 [DEBUG] switch_core_session.c:2597 Application record_session Requires media! pre_answering channel sofia/sipinterface_1/1002@194.143.148.10 2013-09-04 12:01:07.076580 [INFO] switch_core_session.c:2599 Sending early media 2013-09-04 12:01:07.076580 [DEBUG] switch_core_media.c:2885 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMU:0:8000:20:64000] 2013-09-04 12:01:07.076580 [DEBUG] switch_core_media.c:2885 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMA:8:8000:20:64000] 2013-09-04 12:01:07.076580 [DEBUG] switch_core_media.c:1918 Set Codec sofia/sipinterface_1/1002@194.143.148.10 PCMA/8000 20 ms 160 samples 64000 bits 2013-09-04 12:01:07.076580 [DEBUG] switch_core_codec.c:111 sofia/sipinterface_1/1002@194.143.148.10 Original read codec set to PCMA:8 2013-09-04 12:01:07.076580 [DEBUG] switch_core_media.c:3056 Set 2833 dtmf send/recv payload to 101 2013-09-04 12:01:07.076580 [INFO] switch_nat.c:590 NAT port mapping disabled 2013-09-04 12:01:07.076580 [DEBUG] switch_core_media.c:4087 AUDIO RTP [sofia/sipinterface_1/1002@194.143.148.10] 194.143.148.10 port 18768 -> 10.1.4.157 port 60000 codec: 8 ms: 20 2013-09-04 12:01:07.076580 [DEBUG] switch_rtp.c:2891 Starting timer [soft] 160 bytes per 20ms 2013-09-04 12:01:07.076580 [DEBUG] switch_core_media.c:4423 Set 2833 dtmf send payload to 101 2013-09-04 12:01:07.076580 [DEBUG] switch_core_media.c:4429 Set 2833 dtmf receive payload to 101 2013-09-04 12:01:07.076580 [NOTICE] sofia_media.c:92 Pre-Answer sofia/sipinterface_1/1002@194.143.148.10! 2013-09-04 12:01:07.076580 [DEBUG] switch_channel.c:3316 (sofia/sipinterface_1/1002@194.143.148.10) Callstate Change RINGING -> EARLY 2013-09-04 12:01:07.076580 [DEBUG] mod_sofia.c:2135 Ring SDP: v=0 o=FreeSWITCH 1378244899 1378244900 IN IP4 194.143.148.10 s=FreeSWITCH c=IN IP4 194.143.148.10 t=0 0 m=audio 18768 RTP/AVP 8 101 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - a=ptime:20 a=sendrecv 2013-09-04 12:01:07.076580 [DEBUG] switch_core_session.c:861 Send signal sofia/sipinterface_1/1002@194.143.148.10 [BREAK] EXECUTE sofia/sipinterface_1/1002@194.143.148.10 record_session(/usr/local/freeswitch/recordings/archive/2013/Sep/04/20130904_120107_1002_1003.mp3) 2013-09-04 12:01:07.076580 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/1002@194.143.148.10 [BREAK] 2013-09-04 12:01:07.076580 [DEBUG] sofia.c:5834 Channel sofia/sipinterface_1/1002@194.143.148.10 entering state [early][183] 2013-09-04 12:01:07.076580 [INFO] mod_shout.c:324 LAME 3.98.4 32bits (http://www.mp3dev.org/) 2013-09-04 12:01:07.076580 [INFO] mod_shout.c:324 Using polyphase lowpass filter, transition band: 3903 Hz - 4000 Hz 2013-09-04 12:01:07.076580 [DEBUG] switch_core_media_bug.c:532 Attaching BUG to sofia/sipinterface_1/1002@194.143.148.10 EXECUTE sofia/sipinterface_1/1002@194.143.148.10 set(RECORD_STEREO=true) 2013-09-04 12:01:07.076580 [DEBUG] mod_dptools.c:1395 sofia/sipinterface_1/1002@194.143.148.10 SET [RECORD_STEREO]=[true] EXECUTE sofia/sipinterface_1/1002@194.143.148.10 hash(insert/194.143.148.10-spymap/1002/51d9ad582a0396635186532149bbc557@10.1.4.157) EXECUTE sofia/sipinterface_1/1002@194.143.148.10 hash(insert/194.143.148.10-last_dial/1002/1003) EXECUTE sofia/sipinterface_1/1002@194.143.148.10 hash(insert/194.143.148.10-last_dial/global/51d9ad582a0396635186532149bbc557@10.1.4.157) EXECUTE sofia/sipinterface_1/1002@194.143.148.10 export(RFC2822_DATE=Wed, 04 Sep 2013 12:01:07 +0900) 2013-09-04 12:01:07.076580 [DEBUG] switch_channel.c:1222 EXPORT (export_vars) [RFC2822_DATE]=[Wed, 04 Sep 2013 12:01:07 +0900] EXECUTE sofia/sipinterface_1/1002@194.143.148.10 export(dialed_extension=1003) 2013-09-04 12:01:07.076580 [DEBUG] switch_channel.c:1222 EXPORT (export_vars) [dialed_extension]=[1003] EXECUTE sofia/sipinterface_1/1002@194.143.148.10 bind_meta_app(1 b s execute_extension::dx XML features) 2013-09-04 12:01:07.076580 [INFO] switch_ivr_async.c:3628 Bound B-Leg: *1 execute_extension::dx XML features EXECUTE sofia/sipinterface_1/1002@194.143.148.10 bind_meta_app(2 b s record_session::/usr/local/freeswitch/recordings/1002.2013-09-04-12-01-07.wav) 2013-09-04 12:01:07.076580 [INFO] switch_ivr_async.c:3628 Bound B-Leg: *2 record_session::/usr/local/freeswitch/recordings/1002.2013-09-04-12-01-07.wav EXECUTE sofia/sipinterface_1/1002@194.143.148.10 bind_meta_app(3 b s execute_extension::cf XML features) 2013-09-04 12:01:07.096603 [INFO] switch_ivr_async.c:3628 Bound B-Leg: *3 execute_extension::cf XML features EXECUTE sofia/sipinterface_1/1002@194.143.148.10 bind_meta_app(4 b s execute_extension::att_xfer XML features) 2013-09-04 12:01:07.096603 [INFO] switch_ivr_async.c:3628 Bound B-Leg: *4 execute_extension::att_xfer XML features EXECUTE sofia/sipinterface_1/1002@194.143.148.10 set(ringback=%(2000,4000,440,480)) 2013-09-04 12:01:07.096603 [DEBUG] mod_dptools.c:1395 sofia/sipinterface_1/1002@194.143.148.10 SET [ringback]=[%(2000,4000,440,480)] EXECUTE sofia/sipinterface_1/1002@194.143.148.10 set(transfer_ringback=local_stream://moh) 2013-09-04 12:01:07.096603 [DEBUG] mod_dptools.c:1395 sofia/sipinterface_1/1002@194.143.148.10 SET [transfer_ringback]=[local_stream://moh] EXECUTE sofia/sipinterface_1/1002@194.143.148.10 set(call_timeout=30) 2013-09-04 12:01:07.096603 [DEBUG] mod_dptools.c:1395 sofia/sipinterface_1/1002@194.143.148.10 SET [call_timeout]=[30] EXECUTE sofia/sipinterface_1/1002@194.143.148.10 set(hangup_after_bridge=true) 2013-09-04 12:01:07.096603 [DEBUG] mod_dptools.c:1395 sofia/sipinterface_1/1002@194.143.148.10 SET [hangup_after_bridge]=[true] EXECUTE sofia/sipinterface_1/1002@194.143.148.10 set(continue_on_fail=true) 2013-09-04 12:01:07.096603 [DEBUG] mod_dptools.c:1395 sofia/sipinterface_1/1002@194.143.148.10 SET [continue_on_fail]=[true] EXECUTE sofia/sipinterface_1/1002@194.143.148.10 hash(insert/194.143.148.10-call_return/1003/1002) EXECUTE sofia/sipinterface_1/1002@194.143.148.10 hash(insert/194.143.148.10-last_dial_ext/1003/51d9ad582a0396635186532149bbc557@10.1.4.157) EXECUTE sofia/sipinterface_1/1002@194.143.148.10 set(called_party_callgroup=) 2013-09-04 12:01:07.096603 [DEBUG] mod_dptools.c:1395 sofia/sipinterface_1/1002@194.143.148.10 SET [called_party_callgroup]=[UNDEF] EXECUTE sofia/sipinterface_1/1002@194.143.148.10 hash(insert/194.143.148.10-last_dial_ext//51d9ad582a0396635186532149bbc557@10.1.4.157) EXECUTE sofia/sipinterface_1/1002@194.143.148.10 hash(insert/194.143.148.10-last_dial_ext/global/51d9ad582a0396635186532149bbc557@10.1.4.157) EXECUTE sofia/sipinterface_1/1002@194.143.148.10 hash(insert/194.143.148.10-last_dial//51d9ad582a0396635186532149bbc557@10.1.4.157) EXECUTE sofia/sipinterface_1/1002@194.143.148.10 bridge(user/1003@194.143.148.10) 2013-09-04 12:01:07.096603 [DEBUG] switch_channel.c:1176 sofia/sipinterface_1/1002@194.143.148.10 EXPORTING[export_vars] [domain_name]=[194.143.148.10] to event 2013-09-04 12:01:07.096603 [DEBUG] switch_channel.c:1176 sofia/sipinterface_1/1002@194.143.148.10 EXPORTING[export_vars] [RFC2822_DATE]=[Wed, 04 Sep 2013 12:01:07 +0900] to event 2013-09-04 12:01:07.096603 [DEBUG] switch_channel.c:1176 sofia/sipinterface_1/1002@194.143.148.10 EXPORTING[export_vars] [dialed_extension]=[1003] to event 2013-09-04 12:01:07.096603 [DEBUG] switch_ivr_originate.c:2060 Parsing global variables 2013-09-04 12:01:07.096603 [DEBUG] switch_channel.c:1176 sofia/sipinterface_1/1002@194.143.148.10 EXPORTING[export_vars] [domain_name]=[194.143.148.10] to event 2013-09-04 12:01:07.096603 [DEBUG] switch_channel.c:1176 sofia/sipinterface_1/1002@194.143.148.10 EXPORTING[export_vars] [RFC2822_DATE]=[Wed, 04 Sep 2013 12:01:07 +0900] to event 2013-09-04 12:01:07.096603 [DEBUG] switch_channel.c:1176 sofia/sipinterface_1/1002@194.143.148.10 EXPORTING[export_vars] [dialed_extension]=[1003] to event 2013-09-04 12:01:07.096603 [DEBUG] switch_ivr_originate.c:2060 Parsing global variables 2013-09-04 12:01:07.096603 [DEBUG] switch_event.c:1615 Parsing variable [sip_invite_domain]=[194.143.148.10] 2013-09-04 12:01:07.096603 [DEBUG] switch_event.c:1615 Parsing variable [leg_timeout]=[30] 2013-09-04 12:01:07.096603 [DEBUG] switch_event.c:1615 Parsing variable [presence_id]=[1003@194.143.148.10] 2013-09-04 12:01:07.096603 [NOTICE] switch_channel.c:1030 New Channel sofia/sipinterface_1/sip:1003@10.1.4.158:5060 [3e5a5da2-150e-11e3-8498-151e4fbc0d6e] 2013-09-04 12:01:07.096603 [DEBUG] mod_sofia.c:4468 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) State Change CS_NEW -> CS_INIT 2013-09-04 12:01:07.096603 [DEBUG] switch_core_session.c:1341 Send signal sofia/sipinterface_1/sip:1003@10.1.4.158:5060 [BREAK] 2013-09-04 12:01:07.096603 [DEBUG] switch_ivr_originate.c:2773 sofia/sipinterface_1/sip:1003@10.1.4.158:5060 Setting leg timeout to 30 2013-09-04 12:01:07.096603 [DEBUG] switch_core_state_machine.c:418 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) Running State Change CS_INIT 2013-09-04 12:01:07.096603 [DEBUG] switch_core_state_machine.c:457 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) State INIT 2013-09-04 12:01:07.096603 [DEBUG] mod_sofia.c:87 sofia/sipinterface_1/sip:1003@10.1.4.158:5060 SOFIA INIT 2013-09-04 12:01:07.096603 [INFO] switch_nat.c:590 NAT port mapping disabled 2013-09-04 12:01:07.096603 [DEBUG] sofia_glue.c:1190 sip:1003@10.1.4.158:5060 Setting proxy route to sofia/sipinterface_1/sip:1003@10.1.4.158:5060 2013-09-04 12:01:07.096603 [DEBUG] sofia_glue.c:1219 Local SDP: v=0 o=FreeSWITCH 1378231409 1378231410 IN IP4 194.143.148.10 s=FreeSWITCH c=IN IP4 194.143.148.10 t=0 0 m=audio 32258 RTP/AVP 8 101 13 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv 2013-09-04 12:01:07.096603 [DEBUG] mod_sofia.c:114 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) State Change CS_INIT -> CS_ROUTING 2013-09-04 12:01:07.096603 [DEBUG] switch_core_session.c:1341 Send signal sofia/sipinterface_1/sip:1003@10.1.4.158:5060 [BREAK] 2013-09-04 12:01:07.096603 [DEBUG] switch_core_state_machine.c:457 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) State INIT going to sleep 2013-09-04 12:01:07.096603 [DEBUG] switch_core_state_machine.c:418 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) Running State Change CS_ROUTING 2013-09-04 12:01:07.096603 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/sip:1003@10.1.4.158:5060 [BREAK] 2013-09-04 12:01:07.096603 [DEBUG] switch_core_state_machine.c:473 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) State ROUTING 2013-09-04 12:01:07.096603 [DEBUG] mod_sofia.c:137 sofia/sipinterface_1/sip:1003@10.1.4.158:5060 SOFIA ROUTING 2013-09-04 12:01:07.096603 [DEBUG] switch_ivr_originate.c:67 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) State Change CS_ROUTING -> CS_CONSUME_MEDIA 2013-09-04 12:01:07.096603 [DEBUG] switch_core_session.c:1341 Send signal sofia/sipinterface_1/sip:1003@10.1.4.158:5060 [BREAK] 2013-09-04 12:01:07.096603 [DEBUG] switch_core_state_machine.c:473 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) State ROUTING going to sleep 2013-09-04 12:01:07.096603 [DEBUG] switch_core_state_machine.c:418 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) Running State Change CS_CONSUME_MEDIA 2013-09-04 12:01:07.096603 [DEBUG] switch_core_state_machine.c:492 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) State CONSUME_MEDIA 2013-09-04 12:01:07.096603 [DEBUG] switch_core_state_machine.c:492 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) State CONSUME_MEDIA going to sleep 2013-09-04 12:01:07.096603 [DEBUG] sofia.c:5834 Channel sofia/sipinterface_1/sip:1003@10.1.4.158:5060 entering state [calling][0] 2013-09-04 12:01:07.496571 [DEBUG] switch_rtp.c:4918 Correct ip/port confirmed. 2013-09-04 12:01:07.496571 [DEBUG] switch_core_io.c:489 Setting BUG Codec PCMA:8 2013-09-04 12:01:07.556570 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/sip:1003@10.1.4.158:5060 [BREAK] 2013-09-04 12:01:07.556570 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/sip:1003@10.1.4.158:5060 [BREAK] 2013-09-04 12:01:07.556570 [DEBUG] sofia.c:5834 Channel sofia/sipinterface_1/sip:1003@10.1.4.158:5060 entering state [proceeding][180] 2013-09-04 12:01:07.556570 [NOTICE] sofia.c:5924 Ring-Ready sofia/sipinterface_1/sip:1003@10.1.4.158:5060! 2013-09-04 12:01:07.556570 [DEBUG] switch_channel.c:3180 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) Callstate Change DOWN -> RINGING 2013-09-04 12:01:07.596570 [DEBUG] switch_ivr_originate.c:1247 Raw Codec Activation Success L16@8000hz 1 channel 20ms 2013-09-04 12:01:07.596570 [DEBUG] switch_core_codec.c:219 sofia/sipinterface_1/1002@194.143.148.10 Push codec L16:70 2013-09-04 12:01:07.596570 [DEBUG] switch_ivr_originate.c:1315 Play Ringback Tone [%(2000,4000,440,480)] 2013-09-04 12:01:13.216568 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/1002@194.143.148.10 [BREAK] 2013-09-04 12:01:13.216568 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/1002@194.143.148.10 [BREAK] 2013-09-04 12:01:13.216568 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/1002@194.143.148.10 [BREAK] 2013-09-04 12:01:13.236573 [DEBUG] sofia.c:5834 Channel sofia/sipinterface_1/1002@194.143.148.10 entering state [terminated][487] 2013-09-04 12:01:13.236573 [NOTICE] sofia.c:6642 Hangup sofia/sipinterface_1/1002@194.143.148.10 [CS_EXECUTE] [ORIGINATOR_CANCEL] 2013-09-04 12:01:13.236573 [DEBUG] switch_channel.c:3135 Send signal sofia/sipinterface_1/1002@194.143.148.10 [KILL] 2013-09-04 12:01:13.236573 [DEBUG] switch_core_session.c:1341 Send signal sofia/sipinterface_1/1002@194.143.148.10 [BREAK] 2013-09-04 12:01:13.236573 [DEBUG] switch_core_codec.c:244 sofia/sipinterface_1/1002@194.143.148.10 Restore previous codec PCMA:8. 2013-09-04 12:01:13.236573 [NOTICE] switch_ivr_originate.c:3410 Hangup sofia/sipinterface_1/sip:1003@10.1.4.158:5060 [CS_CONSUME_MEDIA] [ORIGINATOR_CANCEL] 2013-09-04 12:01:13.236573 [DEBUG] switch_channel.c:3135 Send signal sofia/sipinterface_1/sip:1003@10.1.4.158:5060 [KILL] 2013-09-04 12:01:13.236573 [DEBUG] switch_core_session.c:1341 Send signal sofia/sipinterface_1/sip:1003@10.1.4.158:5060 [BREAK] 2013-09-04 12:01:13.236573 [DEBUG] switch_ivr_originate.c:3626 Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL] 2013-09-04 12:01:13.236573 [DEBUG] switch_core_state_machine.c:418 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) Running State Change CS_HANGUP 2013-09-04 12:01:13.236573 [DEBUG] switch_core_state_machine.c:681 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) State HANGUP 2013-09-04 12:01:13.236573 [DEBUG] mod_sofia.c:459 sofia/sipinterface_1/sip:1003@10.1.4.158:5060 Overriding SIP cause 487 with 487 from the other leg 2013-09-04 12:01:13.236573 [DEBUG] mod_sofia.c:465 Channel sofia/sipinterface_1/sip:1003@10.1.4.158:5060 hanging up, cause: ORIGINATOR_CANCEL 2013-09-04 12:01:13.236573 [NOTICE] switch_ivr_originate.c:2661 Cannot create outgoing channel of type [user] cause: [ORIGINATOR_CANCEL] 2013-09-04 12:01:13.236573 [DEBUG] switch_ivr_originate.c:3632 Originate Resulted in Error Cause: 487 [ORIGINATOR_CANCEL] 2013-09-04 12:01:13.236573 [DEBUG] mod_sofia.c:527 Sending CANCEL to sofia/sipinterface_1/sip:1003@10.1.4.158:5060 2013-09-04 12:01:13.236573 [DEBUG] switch_core_state_machine.c:48 sofia/sipinterface_1/sip:1003@10.1.4.158:5060 Standard HANGUP, cause: ORIGINATOR_CANCEL 2013-09-04 12:01:13.236573 [DEBUG] switch_core_state_machine.c:681 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) State HANGUP going to sleep 2013-09-04 12:01:13.236573 [DEBUG] switch_core_state_machine.c:694 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) Callstate Change RINGING -> HANGUP 2013-09-04 12:01:13.236573 [DEBUG] switch_core_state_machine.c:449 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) State Change CS_HANGUP -> CS_REPORTING 2013-09-04 12:01:13.236573 [DEBUG] switch_core_session.c:1341 Send signal sofia/sipinterface_1/sip:1003@10.1.4.158:5060 [BREAK] 2013-09-04 12:01:13.236573 [DEBUG] switch_core_state_machine.c:418 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) Running State Change CS_REPORTING 2013-09-04 12:01:13.236573 [DEBUG] switch_core_state_machine.c:766 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) State REPORTING 2013-09-04 12:01:13.236573 [DEBUG] switch_core_state_machine.c:92 sofia/sipinterface_1/sip:1003@10.1.4.158:5060 Standard REPORTING, cause: ORIGINATOR_CANCEL 2013-09-04 12:01:13.236573 [DEBUG] switch_core_state_machine.c:766 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) State REPORTING going to sleep 2013-09-04 12:01:13.236573 [DEBUG] switch_core_state_machine.c:443 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) State Change CS_REPORTING -> CS_DESTROY 2013-09-04 12:01:13.236573 [DEBUG] switch_core_session.c:1341 Send signal sofia/sipinterface_1/sip:1003@10.1.4.158:5060 [BREAK] 2013-09-04 12:01:13.236573 [DEBUG] switch_core_session.c:1549 Session 57 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) Locked, Waiting on external entities 2013-09-04 12:01:13.236573 [NOTICE] switch_core_session.c:1567 Session 57 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) Ended 2013-09-04 12:01:13.236573 [NOTICE] switch_core_session.c:1571 Close Channel sofia/sipinterface_1/sip:1003@10.1.4.158:5060 [CS_DESTROY] 2013-09-04 12:01:13.236573 [DEBUG] switch_core_state_machine.c:568 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) Callstate Change HANGUP -> DOWN 2013-09-04 12:01:13.236573 [DEBUG] switch_core_state_machine.c:571 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) Running State Change CS_DESTROY 2013-09-04 12:01:13.236573 [INFO] mod_dptools.c:3194 Originate Failed. Cause: ORIGINATOR_CANCEL 2013-09-04 12:01:13.236573 [DEBUG] switch_core_state_machine.c:581 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) State DESTROY 2013-09-04 12:01:13.236573 [DEBUG] mod_sofia.c:375 sofia/sipinterface_1/sip:1003@10.1.4.158:5060 SOFIA DESTROY 2013-09-04 12:01:13.236573 [DEBUG] switch_core_state_machine.c:99 sofia/sipinterface_1/sip:1003@10.1.4.158:5060 Standard DESTROY 2013-09-04 12:01:13.236573 [DEBUG] switch_core_state_machine.c:581 (sofia/sipinterface_1/sip:1003@10.1.4.158:5060) State DESTROY going to sleep 2013-09-04 12:01:13.236573 [DEBUG] switch_core_session.c:2760 sofia/sipinterface_1/1002@194.143.148.10 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already) 2013-09-04 12:01:13.236573 [DEBUG] switch_core_state_machine.c:480 (sofia/sipinterface_1/1002@194.143.148.10) State EXECUTE going to sleep 2013-09-04 12:01:13.236573 [DEBUG] switch_core_state_machine.c:418 (sofia/sipinterface_1/1002@194.143.148.10) Running State Change CS_HANGUP 2013-09-04 12:01:13.236573 [DEBUG] switch_ivr_async.c:1175 Stop recording file /usr/local/freeswitch/recordings/archive/2013/Sep/04/20130904_120107_1002_1003.mp3 2013-09-04 12:01:13.276577 [DEBUG] switch_core_media_bug.c:780 Removing BUG from sofia/sipinterface_1/1002@194.143.148.10 2013-09-04 12:01:13.276577 [DEBUG] switch_core_state_machine.c:681 (sofia/sipinterface_1/1002@194.143.148.10) State HANGUP 2013-09-04 12:01:13.276577 [DEBUG] mod_sofia.c:465 Channel sofia/sipinterface_1/1002@194.143.148.10 hanging up, cause: ORIGINATOR_CANCEL 2013-09-04 12:01:13.276577 [DEBUG] switch_core_state_machine.c:48 sofia/sipinterface_1/1002@194.143.148.10 Standard HANGUP, cause: ORIGINATOR_CANCEL 2013-09-04 12:01:13.276577 [DEBUG] switch_core_state_machine.c:681 (sofia/sipinterface_1/1002@194.143.148.10) State HANGUP going to sleep 2013-09-04 12:01:13.276577 [DEBUG] switch_core_state_machine.c:694 (sofia/sipinterface_1/1002@194.143.148.10) Callstate Change EARLY -> HANGUP 2013-09-04 12:01:13.276577 [DEBUG] switch_core_state_machine.c:449 (sofia/sipinterface_1/1002@194.143.148.10) State Change CS_HANGUP -> CS_REPORTING 2013-09-04 12:01:13.276577 [DEBUG] switch_core_session.c:1341 Send signal sofia/sipinterface_1/1002@194.143.148.10 [BREAK] 2013-09-04 12:01:13.276577 [DEBUG] switch_core_state_machine.c:418 (sofia/sipinterface_1/1002@194.143.148.10) Running State Change CS_REPORTING 2013-09-04 12:01:13.276577 [DEBUG] switch_core_state_machine.c:766 (sofia/sipinterface_1/1002@194.143.148.10) State REPORTING 2013-09-04 12:01:13.276577 [DEBUG] switch_core_state_machine.c:92 sofia/sipinterface_1/1002@194.143.148.10 Standard REPORTING, cause: ORIGINATOR_CANCEL 2013-09-04 12:01:13.276577 [DEBUG] switch_core_state_machine.c:766 (sofia/sipinterface_1/1002@194.143.148.10) State REPORTING going to sleep 2013-09-04 12:01:13.276577 [DEBUG] switch_core_state_machine.c:443 (sofia/sipinterface_1/1002@194.143.148.10) State Change CS_REPORTING -> CS_DESTROY 2013-09-04 12:01:13.276577 [DEBUG] switch_core_session.c:1341 Send signal sofia/sipinterface_1/1002@194.143.148.10 [BREAK] 2013-09-04 12:01:13.276577 [DEBUG] switch_core_session.c:1549 Session 56 (sofia/sipinterface_1/1002@194.143.148.10) Locked, Waiting on external entities 2013-09-04 12:01:13.276577 [NOTICE] switch_core_session.c:1567 Session 56 (sofia/sipinterface_1/1002@194.143.148.10) Ended 2013-09-04 12:01:13.276577 [NOTICE] switch_core_session.c:1571 Close Channel sofia/sipinterface_1/1002@194.143.148.10 [CS_DESTROY] 2013-09-04 12:01:13.276577 [DEBUG] switch_core_state_machine.c:568 (sofia/sipinterface_1/1002@194.143.148.10) Callstate Change HANGUP -> DOWN 2013-09-04 12:01:13.276577 [DEBUG] switch_core_state_machine.c:571 (sofia/sipinterface_1/1002@194.143.148.10) Running State Change CS_DESTROY 2013-09-04 12:01:13.276577 [DEBUG] switch_core_state_machine.c:581 (sofia/sipinterface_1/1002@194.143.148.10) State DESTROY 2013-09-04 12:01:13.276577 [DEBUG] mod_sofia.c:375 sofia/sipinterface_1/1002@194.143.148.10 SOFIA DESTROY 2013-09-04 12:01:13.276577 [DEBUG] switch_core_state_machine.c:99 sofia/sipinterface_1/1002@194.143.148.10 Standard DESTROY 2013-09-04 12:01:13.276577 [DEBUG] switch_core_state_machine.c:581 (sofia/sipinterface_1/1002@194.143.148.10) State DESTROY going to sleep |
Автор: | Vlad1983 [ 04 сен 2013 07:55 ] |
Заголовок сообщения: | Re: Переадресация с IVR |
приземляется на Dialplan: sofia/sipinterface_1/1002@194.143.148.10 Regex (PASS) [Local_Extension] destination_number(1003) =~ /^(10[01][0-9])$/ break=on-false <extension name="Check IVR-based CF" continue="true"> нет перед ним |
Автор: | sugiura [ 04 сен 2013 08:00 ] |
Заголовок сообщения: | Re: Переадресация с IVR |
Вот жеж... Дурная привычка складывать всё в самый низ диалплана Теперь буду знать, что положение в диалплане имеет значение:) Спасибо! |
Страница 2 из 2 | Часовой пояс: UTC + 4 часа |
Powered by phpBB® Forum Software © phpBB Group http://www.phpbb.com/ |