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@133582]
2014-03-26 09:36:20.508640 [DEBUG] switch_ivr.c:1831 (sofia/external/73951110(a)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(a)sip1.vmlab.iplink.no [BREAK]
2014-03-26 09:36:20.508640 [DEBUG] switch_core_session.c:871 Send signal sofia/external/73951110(a)sip1.vmlab.iplink.no [BREAK]
2014-03-26 09:36:20.508640 [NOTICE] switch_ivr.c:1838 Transfer sofia/external/73951110(a)sip1.vmlab.iplink.no to XML[73951111@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(a)sip1.vmlab.iplink.no [BREAK]
2014-03-26 09:36:20.528557 [DEBUG] switch_ivr_bridge.c:386 Send signal sofia/internal/sip:1002@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@10.211.55.253:64608]
2014-03-26 09:36:20.528557 [DEBUG] switch_channel.c:1952 (sofia/internal/sip:1002@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@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(a)sip1.vmlab.iplink.no [BREAK]
2014-03-26 09:36:20.528557 [DEBUG] switch_core_session.c:871 Send signal sofia/external/73951110(a)sip1.vmlab.iplink.no [BREAK]
2014-03-26 09:36:20.528557 [DEBUG] switch_core_session.c:871 Send signal sofia/internal/sip:1002@10.211.55.253:64608 [BREAK]
2014-03-26 09:36:20.528557 [DEBUG] mod_fifo.c:3506 sofia/internal/sip:1002@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@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@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@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@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@10.211.55.253:64608 [BREAK]
2014-03-26 09:36:20.528557 [DEBUG] switch_core_state_machine.c:478 (sofia/internal/sip:1002@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@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@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@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@10.211.55.253:64608) State HANGUP
2014-03-26 09:36:20.528557 [DEBUG] mod_sofia.c:506 Channel sofia/internal/sip:1002@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@10.211.55.253:64608
2014-03-26 09:36:20.528557 [DEBUG] switch_core_state_machine.c:48 sofia/internal/sip:1002@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@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@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@10.211.55.253:64608 [BREAK]
2014-03-26 09:36:20.528557 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:1002@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@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@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@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@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@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@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@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(a)sip1.vmlab.iplink.no]
2014-03-26 09:36:20.588437 [DEBUG] switch_ivr_bridge.c:675 Send signal sofia/internal/sip:1002@10.211.55.253:64608 [BREAK]
2014-03-26 09:36:20.588437 [DEBUG] switch_core_state_machine.c:481 (sofia/external/73951110(a)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(a)sip1.vmlab.iplink.no) Running State Change CS_ROUTING
2014-03-26 09:36:20.588437 [DEBUG] switch_channel.c:2163 (sofia/external/73951110(a)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(a)sip1.vmlab.iplink.no) State ROUTING
2014-03-26 09:36:20.588437 [DEBUG] mod_sofia.c:150 sofia/external/73951110(a)sip1.vmlab.iplink.no SOFIA ROUTING
2014-03-26 09:36:20.588437 [DEBUG] switch_core_state_machine.c:117 sofia/external/73951110(a)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@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@10.211.55.253:64608 [CS_DESTROY]
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no parsing [133582->main] continue=true
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no Regex (FAIL) [main] destination_number(73951111) =~ /^in|^out|^custom/ break=on-false
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no ANTI-Action set(return_to_main=true) INLINE
EXECUTE sofia/external/73951110(a)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@10.211.55.253:64608) Callstate Change HANGUP -> DOWN
2014-03-26 09:36:20.588437 [DEBUG] mod_dptools.c:1402 sofia/external/73951110(a)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@10.211.55.253:64608) Running State Change CS_DESTROY
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no ANTI-Action set(domain_name=${context}) INLINE
EXECUTE sofia/external/73951110(a)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@10.211.55.253:64608) State DESTROY
2014-03-26 09:36:20.588437 [DEBUG] mod_sofia.c:399 sofia/internal/sip:1002@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@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@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(a)sip1.vmlab.iplink.no SET [domain_name]=[133582]
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no ANTI-Action set(domain=${context}) INLINE
EXECUTE sofia/external/73951110(a)sip1.vmlab.iplink.no set(domain=133582)
2014-03-26 09:36:20.588437 [DEBUG] mod_dptools.c:1402 sofia/external/73951110(a)sip1.vmlab.iplink.no SET [domain]=[133582]
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no ANTI-Action set(return_to_main=true) INLINE
EXECUTE sofia/external/73951110(a)sip1.vmlab.iplink.no set(return_to_main=true)
2014-03-26 09:36:20.588437 [DEBUG] mod_dptools.c:1402 sofia/external/73951110(a)sip1.vmlab.iplink.no SET [return_to_main]=[true]
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no ANTI-Action set(gateway_to_context_75400400=${domain_name}) INLINE
EXECUTE sofia/external/73951110(a)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(a)sip1.vmlab.iplink.no SET [gateway_to_context_75400400]=[133582]
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no ANTI-Action set(gateway_to_context_31003145=${domain_name}) INLINE
EXECUTE sofia/external/73951110(a)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(a)sip1.vmlab.iplink.no SET [gateway_to_context_31003145]=[133582]
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no ANTI-Action set(allGateways=75400400|33503300|69698800|21050869|31003145) INLINE
EXECUTE sofia/external/73951110(a)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(a)sip1.vmlab.iplink.no SET [allGateways]=[75400400|33503300|69698800|21050869|31003145]
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no ANTI-Action set(defaultGateway=75400400) INLINE
EXECUTE sofia/external/73951110(a)sip1.vmlab.iplink.no set(defaultGateway=75400400)
2014-03-26 09:36:20.588437 [DEBUG] mod_dptools.c:1402 sofia/external/73951110(a)sip1.vmlab.iplink.no SET [defaultGateway]=[75400400]
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no ANTI-Action set(faxGateway_1=) INLINE
EXECUTE sofia/external/73951110(a)sip1.vmlab.iplink.no set(faxGateway_1=)
2014-03-26 09:36:20.588437 [DEBUG] mod_dptools.c:1402 sofia/external/73951110(a)sip1.vmlab.iplink.no SET [faxGateway_1]=[UNDEF]
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no ANTI-Action transfer(${destination_number} XML CallHandler)
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no parsing [133582->customCheckMainTimeTable] continue=false
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no Regex (FAIL) [customCheckMainTimeTable] destination_number(73951111) =~ /^customCheckMainTimeTable_(\d+)$/ break=on-false
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no parsing [133582->custom_voicemail_1] continue=false
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no Regex (FAIL) [custom_voicemail_1] destination_number(73951111) =~ /^custom_voicemail_1$/ break=on-true
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no parsing [133582->inbound] continue=false
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no Regex (FAIL) [inbound] destination_number(73951111) =~ /^inbound_to_(75400400|31003145)$/ break=on-true
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no Regex (FAIL) [inbound] destination_number(73951111) =~ /^inbound_to_(\d{8})$/ break=on-true
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no parsing [133582->custom_menu_1] continue=false
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no Regex (FAIL) [custom_menu_1] destination_number(73951111) =~ /^custom_menu_1$/ break=on-true
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no parsing [133582->custom_callout_1] continue=false
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no Regex (FAIL) [custom_callout_1] destination_number(73951111) =~ /^custom_callout_1_(\d+)$/ break=on-false
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no parsing [133582->custom_queue_1] continue=false
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no Regex (FAIL) [custom_queue_1] destination_number(73951111) =~ /^custom_queue_1$/ break=on-true
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no parsing [133582->custom_queue_2] continue=false
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no Regex (FAIL) [custom_queue_2] destination_number(73951111) =~ /^custom_queue_2$/ break=on-true
Dialplan: sofia/external/73951110(a)sip1.vmlab.iplink.no parsing [133582->custom_queue_3] continue=false
Dialplan: sofia/external/73951110(a)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(a)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(a)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(a)sip1.vmlab.iplink.no [BREAK]
2014-03-26 09:36:20.588437 [DEBUG] switch_core_state_machine.c:471 (sofia/external/73951110(a)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(a)sip1.vmlab.iplink.no) Running State Change CS_EXECUTE
2014-03-26 09:36:20.588437 [DEBUG] switch_channel.c:2165 (sofia/external/73951110(a)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(a)sip1.vmlab.iplink.no) State EXECUTE
2014-03-26 09:36:20.588437 [DEBUG] mod_sofia.c:243 sofia/external/73951110(a)sip1.vmlab.iplink.no SOFIA EXECUTE
2014-03-26 09:36:20.588437 [DEBUG] switch_core_state_machine.c:209 sofia/external/73951110(a)sip1.vmlab.iplink.no Standard EXECUTE
EXECUTE sofia/external/73951110(a)sip1.vmlab.iplink.no transfer(75400400 XML CallHandler)
2014-03-26 09:36:20.588437 [DEBUG] switch_ivr.c:1831 (sofia/external/73951110(a)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(a)sip1.vmlab.iplink.no [BREAK]
2014-03-26 09:36:20.588437 [DEBUG] switch_core_session.c:871 Send signal sofia/external/73951110(a)sip1.vmlab.iplink.no [BREAK]
2014