[Freeswitch-users] Blind transfer from Bria 3

Thorleif Stene thorleifstene at gmail.com
Wed Mar 26 12:01:50 MSK 2014


Caller put into mod_fifo queue. Caller listens tp the ring tone.
Mod_fifo connects the caller tp the agent. The caller and the agent are conferencing.
The agent presses the "first" TRANSFER (telephone icon) button in Bria. Caller listens to moh. 
The agent keys in the number to transfer to and then the TRANSFER button. The agent receives "Transfer succeeded»

The caller hears the ring tone (not the transfer ring tone) because the caller is back into the control of the fifo.
It seems like the original call comes back in to the dial plan via the sofia profile..

A bit lost here. Any ideas ?

Thoreif

From the freeswitch log.

2014-03-26 09:36:20.508640 [DEBUG] sofia.c:6889 Process REFER to [73951111 at 133582]
2014-03-26 09:36:20.508640 [DEBUG] switch_ivr.c:1831 (sofia/external/73951110 at sip1.vmlab.iplink.no) State Change CS_EXCHANGE_MEDIA -> CS_ROUTING
2014-03-26 09:36:20.508640 [DEBUG] switch_core_session.c:1351 Send signal sofia/external/73951110 at sip1.vmlab.iplink.no [BREAK]
2014-03-26 09:36:20.508640 [DEBUG] switch_core_session.c:871 Send signal sofia/external/73951110 at sip1.vmlab.iplink.no [BREAK]
2014-03-26 09:36:20.508640 [NOTICE] switch_ivr.c:1838 Transfer sofia/external/73951110 at sip1.vmlab.iplink.no to XML[73951111 at 133582]
2014-03-26 09:36:20.528557 [DEBUG] switch_ivr_play_say.c:1717 done playing file local_stream://moh
2014-03-26 09:36:20.528557 [DEBUG] switch_core_session.c:871 Send signal sofia/external/73951110 at sip1.vmlab.iplink.no [BREAK]
2014-03-26 09:36:20.528557 [DEBUG] switch_ivr_bridge.c:386 Send signal sofia/internal/sip:1002 at 10.211.55.253:64608 [BREAK]
2014-03-26 09:36:20.528557 [DEBUG] switch_ivr_bridge.c:645 BRIDGE THREAD DONE [sofia/internal/sip:1002 at 10.211.55.253:64608]
2014-03-26 09:36:20.528557 [DEBUG] switch_channel.c:1952 (sofia/internal/sip:1002 at 10.211.55.253:64608) Callstate Change HELD -> UNHOLD
2014-03-26 09:36:20.528557 [DEBUG] switch_channel.c:1963 (sofia/internal/sip:1002 at 10.211.55.253:64608) Callstate Change UNHOLD -> ACTIVE
2014-03-26 09:36:20.528557 [DEBUG] switch_ivr_bridge.c:675 Send signal sofia/external/73951110 at sip1.vmlab.iplink.no [BREAK]
2014-03-26 09:36:20.528557 [DEBUG] switch_core_session.c:871 Send signal sofia/external/73951110 at sip1.vmlab.iplink.no [BREAK]
2014-03-26 09:36:20.528557 [DEBUG] switch_core_session.c:871 Send signal sofia/internal/sip:1002 at 10.211.55.253:64608 [BREAK]
2014-03-26 09:36:20.528557 [DEBUG] mod_fifo.c:3506 sofia/internal/sip:1002 at 10.211.55.253:64608 is still alive, tracking call.
2014-03-26 09:36:20.528557 [DEBUG] mod_fifo.c:2354 sofia/internal/sip:1002 at 10.211.55.253:64608 tracking call on uuid 096198194e8c47a66fd1477ceb17c16b!
2014-03-26 09:36:20.528557 [NOTICE] switch_core_state_machine.c:262 sofia/internal/sip:1002 at 10.211.55.253:64608 has executed the last dialplan instruction, hanging up.
2014-03-26 09:36:20.528557 [NOTICE] switch_core_state_machine.c:264 Hangup sofia/internal/sip:1002 at 10.211.55.253:64608 [CS_EXECUTE] [NORMAL_CLEARING]
2014-03-26 09:36:20.528557 [DEBUG] switch_channel.c:3187 Send signal sofia/internal/sip:1002 at 10.211.55.253:64608 [KILL]
2014-03-26 09:36:20.528557 [DEBUG] switch_core_session.c:1351 Send signal sofia/internal/sip:1002 at 10.211.55.253:64608 [BREAK]
2014-03-26 09:36:20.528557 [DEBUG] switch_core_state_machine.c:478 (sofia/internal/sip:1002 at 10.211.55.253:64608) State EXECUTE going to sleep
2014-03-26 09:36:20.528557 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:1002 at 10.211.55.253:64608) Running State Change CS_HANGUP
2014-03-26 09:36:20.528557 [DEBUG] mod_fifo.c:2267 sofia/internal/sip:1002 at 10.211.55.253:64608 untracking call on uuid 096198194e8c47a66fd1477ceb17c16b!
2014-03-26 09:36:20.528557 [DEBUG] switch_core_state_machine.c:678 (sofia/internal/sip:1002 at 10.211.55.253:64608) Callstate Change ACTIVE -> HANGUP
2014-03-26 09:36:20.528557 [DEBUG] switch_core_state_machine.c:680 (sofia/internal/sip:1002 at 10.211.55.253:64608) State HANGUP
2014-03-26 09:36:20.528557 [DEBUG] mod_sofia.c:506 Channel sofia/internal/sip:1002 at 10.211.55.253:64608 hanging up, cause: NORMAL_CLEARING
2014-03-26 09:36:20.528557 [DEBUG] mod_sofia.c:558 Sending BYE to sofia/internal/sip:1002 at 10.211.55.253:64608
2014-03-26 09:36:20.528557 [DEBUG] switch_core_state_machine.c:48 sofia/internal/sip:1002 at 10.211.55.253:64608 Standard HANGUP, cause: NORMAL_CLEARING
2014-03-26 09:36:20.528557 [DEBUG] switch_core_state_machine.c:680 (sofia/internal/sip:1002 at 10.211.55.253:64608) State HANGUP going to sleep
2014-03-26 09:36:20.528557 [DEBUG] switch_core_state_machine.c:447 (sofia/internal/sip:1002 at 10.211.55.253:64608) State Change CS_HANGUP -> CS_REPORTING
2014-03-26 09:36:20.528557 [DEBUG] switch_core_session.c:1351 Send signal sofia/internal/sip:1002 at 10.211.55.253:64608 [BREAK]
2014-03-26 09:36:20.528557 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:1002 at 10.211.55.253:64608) Running State Change CS_REPORTING
2014-03-26 09:36:20.528557 [DEBUG] switch_core_state_machine.c:764 (sofia/internal/sip:1002 at 10.211.55.253:64608) State REPORTING
2014-03-26 09:36:20.528557 [DEBUG] switch_core_state_machine.c:92 sofia/internal/sip:1002 at 10.211.55.253:64608 Standard REPORTING, cause: NORMAL_CLEARING
2014-03-26 09:36:20.528557 [DEBUG] switch_core_state_machine.c:764 (sofia/internal/sip:1002 at 10.211.55.253:64608) State REPORTING going to sleep
2014-03-26 09:36:20.528557 [DEBUG] switch_core_state_machine.c:441 (sofia/internal/sip:1002 at 10.211.55.253:64608) State Change CS_REPORTING -> CS_DESTROY
2014-03-26 09:36:20.528557 [DEBUG] switch_core_session.c:1351 Send signal sofia/internal/sip:1002 at 10.211.55.253:64608 [BREAK]
2014-03-26 09:36:20.528557 [DEBUG] switch_core_session.c:1559 Session 11 (sofia/internal/sip:1002 at 10.211.55.253:64608) Locked, Waiting on external entities
2014-03-26 09:36:20.588437 [DEBUG] switch_ivr_bridge.c:569 sofia/internal/sip:1002 at 10.211.55.253:64608 ending bridge by request from write function
2014-03-26 09:36:20.588437 [DEBUG] switch_ivr_bridge.c:645 BRIDGE THREAD DONE [sofia/external/73951110 at sip1.vmlab.iplink.no]
2014-03-26 09:36:20.588437 [DEBUG] switch_ivr_bridge.c:675 Send signal sofia/internal/sip:1002 at 10.211.55.253:64608 [BREAK]
2014-03-26 09:36:20.588437 [DEBUG] switch_core_state_machine.c:481 (sofia/external/73951110 at sip1.vmlab.iplink.no) State EXCHANGE_MEDIA going to sleep
2014-03-26 09:36:20.588437 [DEBUG] switch_core_state_machine.c:415 (sofia/external/73951110 at sip1.vmlab.iplink.no) Running State Change CS_ROUTING
2014-03-26 09:36:20.588437 [DEBUG] switch_channel.c:2163 (sofia/external/73951110 at sip1.vmlab.iplink.no) Callstate Change ACTIVE -> RINGING
2014-03-26 09:36:20.588437 [DEBUG] switch_core_state_machine.c:471 (sofia/external/73951110 at sip1.vmlab.iplink.no) State ROUTING
2014-03-26 09:36:20.588437 [DEBUG] mod_sofia.c:150 sofia/external/73951110 at sip1.vmlab.iplink.no SOFIA ROUTING
2014-03-26 09:36:20.588437 [DEBUG] switch_core_state_machine.c:117 sofia/external/73951110 at sip1.vmlab.iplink.no Standard ROUTING
2014-03-26 09:36:20.588437 [INFO] mod_dialplan_xml.c:558 Processing Outbound Call <1002>->73951111 in context 133582
2014-03-26 09:36:20.588437 [NOTICE] switch_core_session.c:1577 Session 11 (sofia/internal/sip:1002 at 10.211.55.253:64608) Ended
2014-03-26 09:36:20.588437 [NOTICE] switch_core_session.c:1581 Close Channel sofia/internal/sip:1002 at 10.211.55.253:64608 [CS_DESTROY]
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no parsing [133582->main] continue=true
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no Regex (FAIL) [main] destination_number(73951111) =~ /^in|^out|^custom/ break=on-false
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no ANTI-Action set(return_to_main=true) INLINE
EXECUTE sofia/external/73951110 at sip1.vmlab.iplink.no set(return_to_main=true)
2014-03-26 09:36:20.588437 [DEBUG] switch_core_state_machine.c:566 (sofia/internal/sip:1002 at 10.211.55.253:64608) Callstate Change HANGUP -> DOWN
2014-03-26 09:36:20.588437 [DEBUG] mod_dptools.c:1402 sofia/external/73951110 at sip1.vmlab.iplink.no SET [return_to_main]=[true]
2014-03-26 09:36:20.588437 [DEBUG] switch_core_state_machine.c:569 (sofia/internal/sip:1002 at 10.211.55.253:64608) Running State Change CS_DESTROY
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no ANTI-Action set(domain_name=${context}) INLINE
EXECUTE sofia/external/73951110 at sip1.vmlab.iplink.no set(domain_name=133582)
2014-03-26 09:36:20.588437 [DEBUG] switch_core_state_machine.c:579 (sofia/internal/sip:1002 at 10.211.55.253:64608) State DESTROY
2014-03-26 09:36:20.588437 [DEBUG] mod_sofia.c:399 sofia/internal/sip:1002 at 10.211.55.253:64608 SOFIA DESTROY
2014-03-26 09:36:20.588437 [DEBUG] switch_core_state_machine.c:99 sofia/internal/sip:1002 at 10.211.55.253:64608 Standard DESTROY
2014-03-26 09:36:20.588437 [DEBUG] switch_core_state_machine.c:579 (sofia/internal/sip:1002 at 10.211.55.253:64608) State DESTROY going to sleep
2014-03-26 09:36:20.588437 [DEBUG] mod_dptools.c:1402 sofia/external/73951110 at sip1.vmlab.iplink.no SET [domain_name]=[133582]
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no ANTI-Action set(domain=${context}) INLINE
EXECUTE sofia/external/73951110 at sip1.vmlab.iplink.no set(domain=133582)
2014-03-26 09:36:20.588437 [DEBUG] mod_dptools.c:1402 sofia/external/73951110 at sip1.vmlab.iplink.no SET [domain]=[133582]
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no ANTI-Action set(return_to_main=true) INLINE
EXECUTE sofia/external/73951110 at sip1.vmlab.iplink.no set(return_to_main=true)
2014-03-26 09:36:20.588437 [DEBUG] mod_dptools.c:1402 sofia/external/73951110 at sip1.vmlab.iplink.no SET [return_to_main]=[true]
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no ANTI-Action set(gateway_to_context_75400400=${domain_name}) INLINE
EXECUTE sofia/external/73951110 at sip1.vmlab.iplink.no set(gateway_to_context_75400400=133582)
2014-03-26 09:36:20.588437 [DEBUG] mod_dptools.c:1402 sofia/external/73951110 at sip1.vmlab.iplink.no SET [gateway_to_context_75400400]=[133582]
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no ANTI-Action set(gateway_to_context_31003145=${domain_name}) INLINE
EXECUTE sofia/external/73951110 at sip1.vmlab.iplink.no set(gateway_to_context_31003145=133582)
2014-03-26 09:36:20.588437 [DEBUG] mod_dptools.c:1402 sofia/external/73951110 at sip1.vmlab.iplink.no SET [gateway_to_context_31003145]=[133582]
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no ANTI-Action set(allGateways=75400400|33503300|69698800|21050869|31003145) INLINE
EXECUTE sofia/external/73951110 at sip1.vmlab.iplink.no set(allGateways=75400400|33503300|69698800|21050869|31003145)
2014-03-26 09:36:20.588437 [DEBUG] mod_dptools.c:1402 sofia/external/73951110 at sip1.vmlab.iplink.no SET [allGateways]=[75400400|33503300|69698800|21050869|31003145]
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no ANTI-Action set(defaultGateway=75400400) INLINE
EXECUTE sofia/external/73951110 at sip1.vmlab.iplink.no set(defaultGateway=75400400)
2014-03-26 09:36:20.588437 [DEBUG] mod_dptools.c:1402 sofia/external/73951110 at sip1.vmlab.iplink.no SET [defaultGateway]=[75400400]
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no ANTI-Action set(faxGateway_1=) INLINE
EXECUTE sofia/external/73951110 at sip1.vmlab.iplink.no set(faxGateway_1=)
2014-03-26 09:36:20.588437 [DEBUG] mod_dptools.c:1402 sofia/external/73951110 at sip1.vmlab.iplink.no SET [faxGateway_1]=[UNDEF]
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no ANTI-Action transfer(${destination_number} XML CallHandler) 
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no parsing [133582->customCheckMainTimeTable] continue=false
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no Regex (FAIL) [customCheckMainTimeTable] destination_number(73951111) =~ /^customCheckMainTimeTable_(\d+)$/ break=on-false
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no parsing [133582->custom_voicemail_1] continue=false
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no Regex (FAIL) [custom_voicemail_1] destination_number(73951111) =~ /^custom_voicemail_1$/ break=on-true
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no parsing [133582->inbound] continue=false
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no Regex (FAIL) [inbound] destination_number(73951111) =~ /^inbound_to_(75400400|31003145)$/ break=on-true
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no Regex (FAIL) [inbound] destination_number(73951111) =~ /^inbound_to_(\d{8})$/ break=on-true
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no parsing [133582->custom_menu_1] continue=false
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no Regex (FAIL) [custom_menu_1] destination_number(73951111) =~ /^custom_menu_1$/ break=on-true
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no parsing [133582->custom_callout_1] continue=false
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no Regex (FAIL) [custom_callout_1] destination_number(73951111) =~ /^custom_callout_1_(\d+)$/ break=on-false
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no parsing [133582->custom_queue_1] continue=false
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no Regex (FAIL) [custom_queue_1] destination_number(73951111) =~ /^custom_queue_1$/ break=on-true
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no parsing [133582->custom_queue_2] continue=false
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no Regex (FAIL) [custom_queue_2] destination_number(73951111) =~ /^custom_queue_2$/ break=on-true
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no parsing [133582->custom_queue_3] continue=false
Dialplan: sofia/external/73951110 at sip1.vmlab.iplink.no Regex (FAIL) [custom_queue_3] destination_number(73951111) =~ /^custom_queue_3$/ break=on-true


2014-03-26 09:36:20.588437 [INFO] switch_channel.c:3027 sofia/external/73951110 at sip1.vmlab.iplink.no Flipping CID from "Outbound Call" <1002> to "73951110" <73951110>  ?????????????? What happens here !!!!!!!

2014-03-26 09:36:20.588437 [DEBUG] switch_core_state_machine.c:167 (sofia/external/73951110 at sip1.vmlab.iplink.no) State Change CS_ROUTING -> CS_EXECUTE
2014-03-26 09:36:20.588437 [DEBUG] switch_core_session.c:1351 Send signal sofia/external/73951110 at sip1.vmlab.iplink.no [BREAK]
2014-03-26 09:36:20.588437 [DEBUG] switch_core_state_machine.c:471 (sofia/external/73951110 at sip1.vmlab.iplink.no) State ROUTING going to sleep
2014-03-26 09:36:20.588437 [DEBUG] switch_core_state_machine.c:415 (sofia/external/73951110 at sip1.vmlab.iplink.no) Running State Change CS_EXECUTE
2014-03-26 09:36:20.588437 [DEBUG] switch_channel.c:2165 (sofia/external/73951110 at sip1.vmlab.iplink.no) Callstate Change RINGING -> ACTIVE
2014-03-26 09:36:20.588437 [DEBUG] switch_core_state_machine.c:478 (sofia/external/73951110 at sip1.vmlab.iplink.no) State EXECUTE
2014-03-26 09:36:20.588437 [DEBUG] mod_sofia.c:243 sofia/external/73951110 at sip1.vmlab.iplink.no SOFIA EXECUTE
2014-03-26 09:36:20.588437 [DEBUG] switch_core_state_machine.c:209 sofia/external/73951110 at sip1.vmlab.iplink.no Standard EXECUTE
EXECUTE sofia/external/73951110 at sip1.vmlab.iplink.no transfer(75400400 XML CallHandler)
2014-03-26 09:36:20.588437 [DEBUG] switch_ivr.c:1831 (sofia/external/73951110 at sip1.vmlab.iplink.no) State Change CS_EXECUTE -> CS_ROUTING
2014-03-26 09:36:20.588437 [DEBUG] switch_core_session.c:1351 Send signal sofia/external/73951110 at sip1.vmlab.iplink.no [BREAK]
2014-03-26 09:36:20.588437 [DEBUG] switch_core_session.c:871 Send signal sofia/external/73951110 at sip1.vmlab.iplink.no [BREAK]
2014


-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20140326/1c1092cf/attachment-0001.html 


Join us at ClueCon 2013 Aug 6-8, 2013
More information about the FreeSWITCH-users mailing list