blind transfer from SIP phone

classic Classic list List threaded Threaded
1 message Options
Reply | Threaded
Open this post in threaded view
|

blind transfer from SIP phone

John Burke
Hello!

I am running into an issue while trying to perform a blind transfer with my Adhearsion application.  Here is the scenario:

(1)  Caller A dials Caller B ----> dialplan routes to <action application="rayo"> where I have a controller bridge the two extensions.

(2) From Caller A's phone, a blind transfer for Caller B to Caller C is initiated (A hangs up, outbound call originated to C).

(3) The dialplan routes the initiated call to <action application="rayo">.  However, freeswitch fails to connect to Adhearsion via mod_rayo and therefore nothing is executing in the controllers.  You can see in this step that the mod_rayo never "has control of call" as is normally logged by FS.

I have successfully been able to make attended transfers work using the same application that fails in the above scenario.  My attended transfer is:  Caller A has an active call with Caller B and Caller C at the same time... and when Caller A hangs up B/C are connected.  Again, the transfer is initiated from Caller A's SIP phone and the SIP refer is handled just fine.

Any thoughts on why I can't get mod_rayo to take control of the call in step 3???

Thanks for the help!
John


I attached full logs if interested... but the portion of interest in the FS logs I pasted below.

Successful connection to mod_rayo (step 1):
2017-07-13 16:47:01.575482 [INFO] mod_dialplan_xml.c:637 Processing test-freeswitchPBX <1015>->1002 in context default
Dialplan: sofia/external/1015@192.168.20.32 parsing [john-test->john-test-extension] continue=false
Dialplan: sofia/external/1015@192.168.20.32 Absolute Condition [john-test-extension]
Dialplan: sofia/external/1015@192.168.20.32 Action rayo() 
2017-07-13 16:47:01.575482 [DEBUG] switch_core_state_machine.c:286 (sofia/external/1015@192.168.20.32) State Change CS_ROUTING -> CS_EXECUTE
2017-07-13 16:47:01.575482 [DEBUG] switch_core_state_machine.c:643 (sofia/external/1015@192.168.20.32) State ROUTING going to sleep
2017-07-13 16:47:01.575482 [DEBUG] switch_core_state_machine.c:584 (sofia/external/1015@192.168.20.32) Running State Change CS_EXECUTE (Cur 1 Tot 17)
2017-07-13 16:47:01.575482 [DEBUG] switch_core_state_machine.c:650 (sofia/external/1015@192.168.20.32) State EXECUTE
2017-07-13 16:47:01.575482 [DEBUG] mod_sofia.c:198 sofia/external/1015@192.168.20.32 SOFIA EXECUTE
2017-07-13 16:47:01.575482 [DEBUG] switch_core_state_machine.c:328 sofia/external/1015@192.168.20.32 Standard EXECUTE
EXECUTE sofia/external/1015@192.168.20.32 rayo()
2017-07-13 16:47:01.575482 [DEBUG] mod_rayo.c:4088 Init cd961030-6814-11e7-8943-9ffd0e4c2e7c@192.168.20.32
2017-07-13 16:47:01.575482 [DEBUG] mod_rayo.c:3696 got event CHANNEL_EXECUTE 
2017-07-13 16:47:01.575482 [DEBUG] mod_rayo.c:4098 Offering call for Rayo 3PCC
2017-07-13 16:47:01.575482 [DEBUG] mod_rayo.c:842 Locate (jid) usera@192.168.20.32/wahoo-john-19152: ref count = 2
2017-07-13 16:47:01.575482 [DEBUG] mod_rayo.c:3907 Deliver cd961030-6814-11e7-8943-9ffd0e4c2e7c@192.168.20.32 => usera@192.168.20.32/wahoo-john-19152 <presence from='cd961030-6814-11e7-8943-9ffd0e4c2e7c@192.168.20.32' to='usera@192.168.20.32/wahoo-john-19152'><c xmlns='http://jabber.org/protocol/caps' hash='sha-1' node='urn:xmpp:rayo:call:1' ver='L9rOKMEJl9rssEggArljiapRd9k='/><offer xmlns='urn:xmpp:rayo:1' from='sip:1015@192.168.20.32' to='sip:1002@192.168.20.32'><header name='from' value='&quot;test-freeswitchPBX&quot; &lt;sip:1015@192.168.20.32&gt;;tag=e6814c01'/><header name='to' value='&lt;sip:1002@192.168.20.32&gt;'/><header name='via' value='SIP/2.0/UDP 192.168.51.2:58901;branch=z9hG4bK-524287-1---e59dda1644c15b03;rport=58901'/></offer><delay xmlns='urn:xmpp:delay' stamp='2017-07-13T21:47:01Z'/></presence>
2017-07-13 16:47:01.575482 [DEBUG] mod_rayo.c:849 Release usera@192.168.20.32/wahoo-john-19152: ref count = 1
2017-07-13 16:47:01.575482 [DEBUG] mod_rayo.c:3696 got event CHANNEL_PARK 
2017-07-13 16:47:01.575482 [DEBUG] xmpp_streams.c:192 usera@192.168.20.32/wahoo-john-19152, 192.168.20.137:44768, c2s_in SEND <presence from='cd961030-6814-11e7-8943-9ffd0e4c2e7c@192.168.20.32' to='usera@192.168.20.32/wahoo-john-19152'><c xmlns='http://jabber.org/protocol/caps' hash='sha-1' node='urn:xmpp:rayo:call:1' ver='L9rOKMEJl9rssEggArljiapRd9k='/><offer xmlns='urn:xmpp:rayo:1' from='sip:1015@192.168.20.32' to='sip:1002@192.168.20.32'><header name='from' value='&quot;test-freeswitchPBX&quot; &lt;sip:1015@192.168.20.32&gt;;tag=e6814c01'/><header name='to' value='&lt;sip:1002@192.168.20.32&gt;'/><header name='via' value='SIP/2.0/UDP 192.168.51.2:58901;branch=z9hG4bK-524287-1---e59dda1644c15b03;rport=58901'/></offer><delay xmlns='urn:xmpp:delay' stamp='2017-07-13T21:47:01Z'/></presence>
2017-07-13 16:47:01.615456 [DEBUG] xmpp_streams.c:192 usera@192.168.20.32/wahoo-john-19152, 192.168.20.137:44768, c2s_in RECV <iq type="set" to="cd961030-6814-11e7-8943-9ffd0e4c2e7c@192.168.20.32" id="f14cb3d7-e165-4a3b-9567-bb7468516f5a"><accept xmlns="urn:xmpp:rayo:1"/></iq>
2017-07-13 16:47:01.615456 [DEBUG] xmpp_streams.c:1073 usera@192.168.20.32/wahoo-john-19152, 192.168.20.137:44768, state = READY, node type = NODE_NORMAL
2017-07-13 16:47:01.615456 [DEBUG] mod_rayo.c:4199 Lock usera@192.168.20.32/wahoo-john-19152: ref count = 2
2017-07-13 16:47:01.615456 [DEBUG] mod_rayo.c:3145 usera@192.168.20.32/wahoo-john-19152, recv iq, availability = ONLINE
2017-07-13 16:47:01.615456 [DEBUG] mod_rayo.c:4283 Release usera@192.168.20.32/wahoo-john-19152: ref count = 1
2017-07-13 16:47:01.615456 [DEBUG] mod_rayo.c:842 Locate (jid) cd961030-6814-11e7-8943-9ffd0e4c2e7c@192.168.20.32: ref count = 2
2017-07-13 16:47:01.615456 [DEBUG] mod_rayo.c:3148 Deliver usera@192.168.20.32/wahoo-john-19152 => cd961030-6814-11e7-8943-9ffd0e4c2e7c@192.168.20.32 <iq type='set' to='cd961030-6814-11e7-8943-9ffd0e4c2e7c@192.168.20.32' id='f14cb3d7-e165-4a3b-9567-bb7468516f5a' from='usera@192.168.20.32/wahoo-john-19152'><accept xmlns='urn:xmpp:rayo:1'/></iq>
2017-07-13 16:47:01.615456 [DEBUG] mod_rayo.c:723 cd961030-6814-11e7-8943-9ffd0e4c2e7c@192.168.20.32, looking for CALL::set:urn:xmpp:rayo:1:accept command
2017-07-13 16:47:01.615456 [INFO] mod_rayo.c:1713 usera@192.168.20.32/wahoo-john-19152 has control of call

Failed connection to mod_rayo (step 3):
2017-07-13 16:47:09.435451 [INFO] mod_dialplan_xml.c:637 Processing Outbound Call <1002>->1011 in context default
Dialplan: sofia/external/1002@192.168.20.112:5060 parsing [default->eaves] continue=false
Dialplan: sofia/external/1002@192.168.20.112:5060 Regex (PASS) [eaves] destination_number(1011) =~ /^.*$/ break=on-false
Dialplan: sofia/external/1002@192.168.20.112:5060 Action sleep(5000) 
Dialplan: sofia/external/1002@192.168.20.112:5060 Action rayo() 
2017-07-13 16:47:09.435451 [DEBUG] switch_core_state_machine.c:286 (sofia/external/1002@192.168.20.112:5060) State Change CS_ROUTING -> CS_EXECUTE
2017-07-13 16:47:09.435451 [DEBUG] switch_core_state_machine.c:643 (sofia/external/1002@192.168.20.112:5060) State ROUTING going to sleep
2017-07-13 16:47:09.435451 [DEBUG] switch_core_state_machine.c:584 (sofia/external/1002@192.168.20.112:5060) Running State Change CS_EXECUTE (Cur 2 Tot 18)
2017-07-13 16:47:09.435451 [DEBUG] switch_core_state_machine.c:650 (sofia/external/1002@192.168.20.112:5060) State EXECUTE
2017-07-13 16:47:09.435451 [DEBUG] mod_sofia.c:198 sofia/external/1002@192.168.20.112:5060 SOFIA EXECUTE
2017-07-13 16:47:09.435451 [DEBUG] switch_core_state_machine.c:328 sofia/external/1002@192.168.20.112:5060 Standard EXECUTE
EXECUTE sofia/external/1002@192.168.20.112:5060 sleep(5000)
2017-07-13 16:47:09.435451 [DEBUG] mod_rayo.c:3696 got event CHANNEL_EXECUTE 
2017-07-13 16:47:09.435451 [DEBUG] switch_ivr.c:195 Codec Activated L16@8000hz 1 channels 20ms
2017-07-13 16:47:09.435451 [DEBUG] mod_rayo.c:3701 usera@192.168.20.32/wahoo-john-19152 rayo event CHANNEL_EXECUTE
2017-07-13 16:47:09.435451 [DEBUG] mod_rayo.c:3703 Locate (jid) usera@192.168.20.32/wahoo-john-19152: ref count = 2
2017-07-13 16:47:09.435451 [DEBUG] mod_rayo.c:3624 Locate (id) 0bf19fba-a590-4de7-a991-c3f2fa23fc68@192.168.20.32: ref count = 2
2017-07-13 16:47:09.435451 [DEBUG] mod_rayo.c:3626 Application sleep execute
2017-07-13 16:47:09.435451 [DEBUG] mod_rayo.c:3627 Release 0bf19fba-a590-4de7-a991-c3f2fa23fc68@192.168.20.32: ref count = 1
2017-07-13 16:47:09.435451 [DEBUG] mod_rayo.c:3711 Release usera@192.168.20.32/wahoo-john-19152: ref count = 1
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:3696 got event CHANNEL_EXECUTE_COMPLETE 
EXECUTE sofia/external/1002@192.168.20.112:5060 rayo()
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:3701 usera@192.168.20.32/wahoo-john-19152 rayo event CHANNEL_EXECUTE_COMPLETE
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:3703 Locate (jid) usera@192.168.20.32/wahoo-john-19152: ref count = 2
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:3638 Locate (id) 0bf19fba-a590-4de7-a991-c3f2fa23fc68@192.168.20.32: ref count = 2
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:3641 Application sleep execute complete: _none_ 
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:3644 Release 0bf19fba-a590-4de7-a991-c3f2fa23fc68@192.168.20.32: ref count = 1
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:3711 Release usera@192.168.20.32/wahoo-john-19152: ref count = 1
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:4044 Locate (id) 0bf19fba-a590-4de7-a991-c3f2fa23fc68@192.168.20.32: ref count = 2
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:4050 Release 0bf19fba-a590-4de7-a991-c3f2fa23fc68@192.168.20.32: ref count = 1
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:3696 got event CHANNEL_EXECUTE 
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:3701 usera@192.168.20.32/wahoo-john-19152 rayo event CHANNEL_EXECUTE
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:3703 Locate (jid) usera@192.168.20.32/wahoo-john-19152: ref count = 2
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:3624 Locate (id) 0bf19fba-a590-4de7-a991-c3f2fa23fc68@192.168.20.32: ref count = 2
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:3626 Application rayo execute
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:3627 Release 0bf19fba-a590-4de7-a991-c3f2fa23fc68@192.168.20.32: ref count = 1
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:3711 Release usera@192.168.20.32/wahoo-john-19152: ref count = 1
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:3696 got event CHANNEL_PARK 
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:3701 usera@192.168.20.32/wahoo-john-19152 rayo event CHANNEL_PARK
2017-07-13 16:47:14.435479 [DEBUG] switch_ivr.c:980 Codec Activated L16@8000hz 1 channels 20ms
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:3703 Locate (jid) usera@192.168.20.32/wahoo-john-19152: ref count = 2
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:3585 Locate (id) 0bf19fba-a590-4de7-a991-c3f2fa23fc68@192.168.20.32: ref count = 2
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:3613 Release 0bf19fba-a590-4de7-a991-c3f2fa23fc68@192.168.20.32: ref count = 1
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:3711 Release usera@192.168.20.32/wahoo-john-19152: ref count = 1
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:842 Locate (jid) usera@192.168.20.32/wahoo-john-19152: ref count = 2
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:3611 Deliver 0bf19fba-a590-4de7-a991-c3f2fa23fc68@192.168.20.32 => usera@192.168.20.32/wahoo-john-19152 <presence from='0bf19fba-a590-4de7-a991-c3f2fa23fc68@192.168.20.32' to='usera@192.168.20.32/wahoo-john-19152'><unjoined xmlns='urn:xmpp:rayo:1' call-uri='xmpp:cd961030-6814-11e7-8943-9ffd0e4c2e7c@192.168.20.32'/><delay xmlns='urn:xmpp:delay' stamp='2017-07-13T21:47:14Z'/></presence>
2017-07-13 16:47:14.435479 [DEBUG] mod_rayo.c:849 Release usera@192.168.20.32/wahoo-john-19152: ref count = 1
2017-07-13 16:47:14.435479 [DEBUG] xmpp_streams.c:192 usera@192.168.20.32/wahoo-john-19152, 192.168.20.137:44768, c2s_in SEND <presence from='0bf19fba-a590-4de7-a991-c3f2fa23fc68@192.168.20.32' to='usera@192.168.20.32/wahoo-john-19152'><unjoined xmlns='urn:xmpp:rayo:1' call-uri='xmpp:cd961030-6814-11e7-8943-9ffd0e4c2e7c@192.168.20.32'/><delay xmlns='urn:xmpp:delay' stamp='2017-07-13T21:47:14Z'/></presence>

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.

ahn_log (17K) Download Attachment
FS_log (73K) Download Attachment