I have a problem that appears to be with uuid_bridge
I have an lua event handler that is trying to control calls.
on an incoming event "RECV_INFO" I would like to switch calls that the user is on (implement call waiting)

I have 3 call legs.

a b and c

a an incoming call bridged to b
b is an outgoing call bridged to a
c anunanswered incomming call and is in ringing state.

I want a to go on hold and b,c bridged
what I get is B on holdA with silence and C still ringing. (the only sip packets sent are a reinvite to A to setting a=sendonly)

I have the uuid ofcalls a b and c are stored in a_uuid b_uuid and c_uuid respectively

my code looks like this:

function logger(message)
freeswitch.console_log("debug","callwaiting.lua:" .. message .."\n");
end

local name = event:getHeader("Event-Name")
if ( name == "RECV_INFO") then
        local api = freeswitch.API();

        local sip_original_user = event:getHeader("SIP-From-User");
        local b_uuid = event:getHeader("Caller-Unique-ID");
        local a_uuid = event:getHeader("Other-Leg-Unique-ID");
        local c_uuid = api:execute("hash","select/"..sip_original_user.."/4");

logger("a_uuid:"..a_uuid.."\n")
logger("b_uuid:"..b_uuid.."\n")
logger("c_uuid:"..c_uuid.."\n")

        api:execute("uuid_park", a_uuid);
        api:execute("uuid_park", b_uuid);
        api:execute("uuid_hold", a_uuid);
        api:execute("uuid_bridge", b_uuid .. " " .. c_uuid);
end

logs
A invites in
2014-03-07 10:19:45.751614 [NOTICE] switch_channel.c:1055 New Channel sofia/external/6499196120@172.20.1.201:5061 [6ed900e4-2f0e-4a92-8b3e-f10c990d007a]
invite out to B
2014-03-07 10:19:45.791753 [NOTICE] switch_channel.c:1055 New Channel sofia/external/6492810587@10.15.1.2 [67701a09-90d9-4b0e-a114-d7726ad8666b]
incoming call from C
2014-03-07 10:19:58.871603 [NOTICE] switch_channel.c:1055 New Channel sofia/external/6499744915@172.20.1.201:5061 [ed3aabd0-9f2e-4b2d-a9c6-a468e9e2966e]

logs report that the a_uid b_uuid and c_uuuid are the correct values.
2014-03-07 10:20:03.151602 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:a_uuid:6ed900e4-2f0e-4a92-8b3e-f10c990d007a
2014-03-07 10:20:03.151602 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:b_uuid:67701a09-90d9-4b0e-a114-d7726ad8666b
2014-03-07 10:20:03.151602 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:c_uuid:ed3aabd0-9f2e-4b2d-a9c6-a468e9e2966e


----------------------------------------------------
freeswitch@internal>
tport.c:2757 tport_wakeup_pri() tport_wakeup_pri(0x1eb4080): events IN
tport.c:2872 tport_recv_event() tport_recv_event(0x1eb4080)
tport.c:3213 tport_recv_iovec() tport_recv_iovec(0x1eb4080) msg 0x7ff1000346c0 from (udp/172.20.1.204:5066) has 511 bytes, veclen = 1
recv 511 bytes from udp/[10.15.1.2]:5060 at 21:40:15.032473:
------------------------------------------------------------------------
   INFO sip:mod_sofia@172.20.1.204:5066 SIP/2.0
   Via: SIP/2.0/UDP 10.15.1.2:5060;branch=z9hG4bKsj7nji107oa0fl40r561.1
   From: <sip:6492810587@10.15.1.2>;tag=SDu03v199-0082-0000017d-0558i0
   To: "Anonymous" <sip:6499196120@172.20.1.204>;tag=UHmc2KHB3923D
   Call-ID: b4407d44-201a-1232-1f9d-000c2963be0e
   CSeq: 1 INFO
   Max-Forwards: 28
   Contact: "6492810587" <sip:6492810587@10.15.1.2:5060;transport=udp>
   Date: Thu, 06 Mar 2014 21:35:25 GMT
   Content-Type: application/broadsoft
   Content-Length: 17

   event flashhook
------------------------------------------------------------------------
tport.c:3031 tport_deliver() tport_deliver(0x1eb4080): msg 0x7ff1000346c0 (511 bytes) from udp/10.15.1.2:5066/sip next=(nil)
nta.c:2812 agent_recv_request() nta: received INFO sip:mod_sofia@172.20.1.204:5066 SIP/2.0 (CSeq 1)
nta.c:3171 agent_aliases() nta: canonizing sip:mod_sofia@172.20.1.204:5066 with contact
nta.c:2988 agent_recv_request() nta: INFO (1) going to existing leg
nua_server.c:102 nua_stack_process_request() nua: nua_stack_process_request: entering
nua_stack.c:271 nua_stack_event() nua(0x2006920): event i_info 100 Trying
nua_stack.c:359 nua_application_event() nua: nua_application_event: entering
2014-03-07 10:20:03.151602 [DEBUG] switch_core_session.c:1049 Send signal sofia/external/6492810587@10.15.1.2 [BREAK]
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
2014-03-07 10:20:03.151602 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua'
2014-03-07 10:20:03.151602 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua
2014-03-07 10:20:03.151602 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:a_uuid:6ed900e4-2f0e-4a92-8b3e-f10c990d007a

2014-03-07 10:20:03.151602 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:b_uuid:67701a09-90d9-4b0e-a114-d7726ad8666b

2014-03-07 10:20:03.151602 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:c_uuid:ed3aabd0-9f2e-4b2d-a9c6-a468e9e2966e

2014-03-07 10:20:03.151602 [DEBUG] switch_ivr.c:2891 (sofia/external/6499196120@172.20.1.201:5061) State Change CS_EXECUTE -> CS_PARK
2014-03-07 10:20:03.151602 [DEBUG] switch_core_session.c:1384 Send signal sofia/external/6499196120@172.20.1.201:5061 [BREAK]
2014-03-07 10:20:03.151602 [DEBUG] switch_ivr.c:2891 (sofia/external/6492810587@10.15.1.2) State Change CS_EXCHANGE_MEDIA -> CS_PARK
2014-03-07 10:20:03.151602 [DEBUG] switch_core_session.c:1384 Send signal sofia/external/6492810587@10.15.1.2 [BREAK]
2014-03-07 10:20:03.151602 [DEBUG] switch_channel.c:1789 (sofia/external/6499196120@172.20.1.201:5061) Callstate Change ACTIVE -> HELD
2014-03-07 10:20:03.151602 [DEBUG] sofia_glue.c:1225 sofia/external/6499196120@172.20.1.201:5061 sending invite version: 1.5.8b git bf9e3a1 2014-02-19 21:13:51Z 64bit
Local SDP:
v=0
o=FreeSWITCH 1394123290 1394123292 IN IP4 172.20.1.204
s=FreeSWITCH
c=IN IP4 172.20.1.204
t=0 0
m=audio 17500 RTP/AVP 8 101
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv

nua.c:633 nua_invite() nua: nua_invite: entering
nua_stack.c:529 nua_signal() nua(0x7ff100007ce0): sent signal r_invite
2014-03-07 10:20:03.151602 [DEBUG] switch_core_session.c:904 Send signal sofia/external/6499196120@172.20.1.201:5061 [BREAK]
2014-03-07 10:20:03.151602 [DEBUG] switch_core_session.c:1184 Send signal sofia/external/6492810587@10.15.1.2 [BREAK]
2014-03-07 10:20:03.151602 [INFO] switch_channel.c:3057 sofia/external/6492810587@10.15.1.2 Flipping CID from "Anonymous" <6499196120> to "Outbound Call" <6492810587>
2014-03-07 10:20:03.151602 [DEBUG] switch_ivr_bridge.c:1846 (sofia/external/6492810587@10.15.1.2) State Change CS_PARK -> CS_HIBERNATE
2014-03-07 10:20:03.151602 [DEBUG] switch_core_session.c:1384 Send signal sofia/external/6492810587@10.15.1.2 [BREAK]
2014-03-07 10:20:03.151602 [DEBUG] switch_ivr_bridge.c:1848 (sofia/external/6499744915@172.20.1.201:5061) State Change CS_PARK -> CS_HIBERNATE
2014-03-07 10:20:03.151602 [DEBUG] switch_core_session.c:1384 Send signal sofia/external/6499744915@172.20.1.201:5061 [BREAK]
nua_stack.c:569 nua_stack_signal() nua(0x7ff100007ce0): recv signal r_invite
nua_params.c:480 nua_stack_set_params() nua: nua_stack_set_params: entering
soa.c:405 soa_set_params() soa_set_params(static::0x7ff1000085e0, ...) called
soa.c:1052 soa_set_user_sdp() soa_set_user_sdp(static::0x7ff1000085e0, (nil), 0x2039637, -1) called
soa.c:1302 soa_init_offer_answer() soa_init_offer_answer(static::0x7ff1000085e0) called
soa.c:1426 soa_generate_offer() soa_generate_offer(static::0x7ff1000085e0, 0) called
soa_static.c:1137 offer_answer_step() soa_static_offer_answer_action(0x7ff1000085e0, soa_generate_offer): called
soa_static.c:1196 offer_answer_step() soa_static(0x7ff1000085e0, soa_generate_offer): upgrade with local description
soa_static.c:1020 soa_sdp_mode_set() soa_sdp_mode_set(0x7ff10e3a0a40, (nil), "*"): called
soa_static.c:1020 soa_sdp_mode_set() soa_sdp_mode_set(0x7ff10e3a0a40, (nil), "*"): called
soa_static.c:1425 offer_answer_step() soa_static(0x7ff1000085e0, soa_generate_offer): storing local description
soa.c:1270 soa_get_local_sdp() soa_get_local_sdp(static::0x7ff1000085e0, [(nil)], [0x7ff10e3a2b68], [0x7ff10e3a2b64]) called
nta.c:2663 nta_tpn_by_url() nta: selecting scheme sip
tport.c:3265 tport_tsend() tport_tsend(0x1eb4080) tpn = */172.20.1.201:5061
tport.c:4054 tport_resolve() tport_resolve addrinfo = 172.20.1.201:5061
tport.c:4688 tport_by_addrinfo() tport_by_addrinfo(0x1eb4080): not found by name */172.20.1.201:5061
tport.c:3602 tport_vsend() tport_vsend(0x1eb4080): 961 bytes of 961 to udp/172.20.1.201:5061
tport.c:3500 tport_send_msg() tport_vsend returned 961
send 961 bytes to udp/[172.20.1.201]:5061 at 21:40:15.045585:
------------------------------------------------------------------------
   INVITE sip:6499196120@172.20.1.201:5061 SIP/2.0
   Via: SIP/2.0/UDP 172.20.1.204:5066;rport;branch=z9hG4bKQ3Qym8BcyZU8K
   Max-Forwards: 69
   From: <sip:6492810587@172.20.1.204:5066>;tag=t8tK0r0750cHj
   To: "Anonymous" <sip:6499196120@172.20.1.201:5061>;tag=as02ccecfe
   Call-ID: 419a7a7d150b4049389c91f1109676d4@172.20.1.201
   CSeq: 56734943 INVITE
   Contact: <sip:6492810587@172.20.1.204:5066;transport=udp>
   User-Agent: FreeSWITCH-mod_sofia/1.5.8b+git~20140219T211351Z~bf9e3a1f9e~64bit
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
   Supported: timer, path, replaces
   Content-Type: application/sdp
   Content-Disposition: session
   Content-Length: 232
   X-FS-Support: update_display,send_info

   v=0
   o=FreeSWITCH 1394123290 1394123292 IN IP4 172.20.1.204
   s=FreeSWITCH
   c=IN IP4 172.20.1.204
   t=0 0
   m=audio 17500 RTP/AVP 8 101
   a=rtpmap:8 PCMA/8000
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-16
   a=sendonly
   a=ptime:20
------------------------------------------------------------------------
nta.c:8190 outgoing_send() nta: sent INVITE (56734943) to */172.20.1.201:5061
tport.c:4168 tport_pend() tport_pend(0x1eb4080): pending 0x7ff10004f7e0 for udp/172.20.1.204:5066 (already 0)
nua_session.c:4143 signal_call_state_change() nua(0x7ff100007ce0): ready call updated: calling sent offer
soa.c:1270 soa_get_local_sdp() soa_get_local_sdp(static::0x7ff1000085e0, [0x7ff10e3a2b58], [0x7ff10e3a2b60], [(nil)]) called
nua_stack.c:269 nua_stack_event() nua(0x7ff100007ce0): event i_state INVITE sent
2014-03-07 10:20:03.151602 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua'
2014-03-07 10:20:03.151602 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua
2014-03-07 10:20:03.151602 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:API uuid:
nua_stack.c:359 nua_application_event() nua: nua_application_event: entering
2014-03-07 10:20:03.151602 [DEBUG] switch_core_session.c:1049 Send signal sofia/external/6499196120@172.20.1.201:5061 [BREAK]
tport.c:2757 tport_wakeup_pri() tport_wakeup_pri(0x1eb4080): events IN
tport.c:2872 tport_recv_event() tport_recv_event(0x1eb4080)
tport.c:3213 tport_recv_iovec() tport_recv_iovec(0x1eb4080) msg 0x7ff100055140 from (udp/172.20.1.204:5066) has 515 bytes, veclen = 1
recv 515 bytes from udp/[172.20.1.201]:5061 at 21:40:15.046966:
------------------------------------------------------------------------
   SIP/2.0 100 Trying
   Via: SIP/2.0/UDP 172.20.1.204:5066;branch=z9hG4bKQ3Qym8BcyZU8K;received=172.20.1.204;rport=5066
   From: <sip:6492810587@172.20.1.204:5066>;tag=t8tK0r0750cHj
   To: "Anonymous" <sip:6499196120@172.20.1.201:5061>;tag=as02ccecfe
   Call-ID: 419a7a7d150b4049389c91f1109676d4@172.20.1.201
   CSeq: 56734943 INVITE
   Server: iTalk
   Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
   Supported: replaces, timer
   Contact: <sip:6499196120@172.20.1.201:5061>
   Content-Length: 0

------------------------------------------------------------------------
tport.c:3031 tport_deliver() tport_deliver(0x1eb4080): msg 0x7ff100055140 (515 bytes) from udp/172.20.1.201:5066/sip next=(nil)
nta.c:3222 agent_recv_response() nta: received 100 Trying for INVITE (56734943)
nta.c:3285 agent_recv_response() nta: 100 Trying is going to a transaction
nta.c:9450 outgoing_estimate_delay() nta_outgoing: RTT is 1.549 ms
tport.c:4230 tport_release() tport_release(0x1eb4080): 0x7ff10004f7e0 by 0x7ff1000296f0 with 0x7ff100055140 (preliminary)
tport.c:2757 tport_wakeup_pri() tport_wakeup_pri(0x1eb4080): events IN
tport.c:2872 tport_recv_event() tport_recv_event(0x1eb4080)
tport.c:3213 tport_recv_iovec() tport_recv_iovec(0x1eb4080) msg 0x7ff100055140 from (udp/172.20.1.204:5066) has 765 bytes, veclen = 1
recv 765 bytes from udp/[172.20.1.201]:5061 at 21:40:15.047085:
------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP 172.20.1.204:5066;branch=z9hG4bKQ3Qym8BcyZU8K;received=172.20.1.204;rport=5066
   From: <sip:6492810587@172.20.1.204:5066>;tag=t8tK0r0750cHj
   To: "Anonymous" <sip:6499196120@172.20.1.201:5061>;tag=as02ccecfe
   Call-ID: 419a7a7d150b4049389c91f1109676d4@172.20.1.201
   CSeq: 56734943 INVITE
   Server: iTalk
   Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
   Supported: replaces, timer
   Contact: <sip:6499196120@172.20.1.201:5061>
   Content-Type: application/sdp
   Content-Length: 221

   v=0
   o=root 1737995898 1737995899 IN IP4 172.20.1.201
   s=iTalk
   c=IN IP4 172.20.1.201
   t=0 0
   m=audio 10418 RTP/AVP 8 101
   a=rtpmap:8 PCMA/8000
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-16
   a=ptime:20
   a=recvonly
------------------------------------------------------------------------
tport.c:3031 tport_deliver() tport_deliver(0x1eb4080): msg 0x7ff100055140 (765 bytes) from udp/172.20.1.201:5066/sip next=(nil)
nta.c:3222 agent_recv_response() nta: received 200 OK for INVITE (56734943)
nta.c:3285 agent_recv_response() nta: 200 OK is going to a transaction
tport.c:4230 tport_release() tport_release(0x1eb4080): 0x7ff10004f7e0 by 0x7ff1000296f0 with 0x7ff100055140
soa.c:1171 soa_set_remote_sdp() soa_set_remote_sdp(static::0x7ff1000085e0, (nil), 0x7ff100058790, 221) called
soa.c:1595 soa_process_answer() soa_process_answer(static::0x7ff1000085e0) called
soa_static.c:1137 offer_answer_step() soa_static_offer_answer_action(0x7ff1000085e0, soa_process_answer): called
soa_static.c:1020 soa_sdp_mode_set() soa_sdp_mode_set(0x7ff100050010, 0x7ff10005cbf0, "*"): called
soa_static.c:1283 offer_answer_step() soa_static(0x7ff1000085e0, soa_process_answer): upgrade codecs with remote description
soa.c:1730 soa_activate() soa_activate(static::0x7ff1000085e0, (nil)) called
nua_session.c:988 nua_session_client_response() nua(0x7ff100007ce0): INVITE: processed SDP answer in 200 OK
nua_stack.c:271 nua_stack_event() nua(0x7ff100007ce0): event r_invite 200 OK
nua_session.c:4143 signal_call_state_change() nua(0x7ff100007ce0): ready call updated: completing received answer
soa.c:1098 soa_get_remote_sdp() soa_get_remote_sdp(static::0x7ff1000085e0, [0x7ff10e3a23a8], [0x7ff10e3a23b0], [(nil)]) called
soa.c:616 soa_get_params() soa_get_params(static::0x7ff1000085e0, ...) called
nua_stack.c:271 nua_stack_event() nua(0x7ff100007ce0): event i_state 200 OK
2014-03-07 10:20:03.151602 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua'
2014-03-07 10:20:03.151602 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua
2014-03-07 10:20:03.151602 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:API uuid:
nua_stack.c:359 nua_application_event() nua: nua_application_event: entering
2014-03-07 10:20:03.172884 [DEBUG] switch_core_session.c:1049 Send signal sofia/external/6499196120@172.20.1.201:5061 [BREAK]
nua_stack.c:359 nua_application_event() nua: nua_application_event: entering
2014-03-07 10:20:03.172884 [DEBUG] switch_core_session.c:1049 Send signal sofia/external/6499196120@172.20.1.201:5061 [BREAK]
2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua'
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:API uuid:
2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua'
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_CALLSTATE6ed900e4-2f0e-4a92-8b3e-f10c990d007a->Channel-Call-State:HELD

2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_CALLSTATE6ed900e4-2f0e-4a92-8b3e-f10c990d007a->Original-Channel-Call-State:ACTIVE

2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua'
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:CHANNEL_HOLD uuid:6ed900e4-2f0e-4a92-8b3e-f10c990d007a
2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua'
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:API uuid:
2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua'
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:CALL_UPDATE uuid:67701a09-90d9-4b0e-a114-d7726ad8666b
2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua'
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:API uuid:
2014-03-07 10:20:03.172884 [DEBUG] sofia.c:7858 dispatched freeswitch event for INFO
nua.c:879 nua_respond() nua: nua_respond: entering
nua_stack.c:573 nua_stack_signal() nua(0x2006920): recv signal r_respond 200 OK
nua_params.c:480 nua_stack_set_params() nua: nua_stack_set_params: entering
soa.c:405 soa_set_params() soa_set_params(static::0x7ff100006590, ...) called
tport.c:3265 tport_tsend() tport_tsend(0x1eb4080) tpn = UDP/10.15.1.2:5060
tport.c:4054 tport_resolve() tport_resolve addrinfo = 10.15.1.2:5060
tport.c:4688 tport_by_addrinfo() tport_by_addrinfo(0x1eb4080): not found by name UDP/10.15.1.2:5060
tport.c:3602 tport_vsend() tport_vsend(0x1eb4080): 505 bytes of 505 to udp/10.15.1.2:5060
tport.c:3500 tport_send_msg() tport_vsend returned 505
send 505 bytes to udp/[10.15.1.2]:5060 at 21:40:15.056080:
------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP 10.15.1.2:5060;branch=z9hG4bKsj7nji107oa0fl40r561.1
   From: <sip:6492810587@10.15.1.2>;tag=SDu03v199-0082-0000017d-0558i0
   To: "Anonymous" <sip:6499196120@172.20.1.204>;tag=UHmc2KHB3923D
   Call-ID: b4407d44-201a-1232-1f9d-000c2963be0e
   CSeq: 1 INFO
   User-Agent: FreeSWITCH-mod_sofia/1.5.8b+git~20140219T211351Z~bf9e3a1f9e~64bit
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
   Supported: timer, path, replaces
   Content-Length: 0

------------------------------------------------------------------------
nta.c:6690 incoming_reply() nta: sent 200 OK for INFO (1)
nua_stack.c:529 nua_signal() nua(0x2006920): sent signal r_respond
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:647 BRIDGE THREAD DONE [sofia/external/6492810587@10.15.1.2]
2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:672 Send signal sofia/external/6499196120@172.20.1.201:5061 [BREAK]
2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:533 (sofia/external/6492810587@10.15.1.2) State EXCHANGE_MEDIA going to sleep
2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:467 (sofia/external/6492810587@10.15.1.2) Running State Change CS_HIBERNATE
2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua'
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_STATE:67701a09-90d9-4b0e-a114-d7726ad8666b->CS_HIBERNATE

2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:545 (sofia/external/6492810587@10.15.1.2) State HIBERNATE
2014-03-07 10:20:03.172884 [DEBUG] mod_sofia.c:160 sofia/external/6492810587@10.15.1.2 SOFIA HIBERNATE
2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:816 (sofia/external/6492810587@10.15.1.2) State Change CS_HIBERNATE -> CS_RESET
2014-03-07 10:20:03.172884 [DEBUG] switch_core_session.c:1384 Send signal sofia/external/6492810587@10.15.1.2 [BREAK]
2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:545 (sofia/external/6492810587@10.15.1.2) State HIBERNATE going to sleep
2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:467 (sofia/external/6492810587@10.15.1.2) Running State Change CS_RESET
2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua'
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_STATE:67701a09-90d9-4b0e-a114-d7726ad8666b->CS_RESET

2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:526 (sofia/external/6492810587@10.15.1.2) State RESET
2014-03-07 10:20:03.172884 [DEBUG] mod_sofia.c:141 sofia/external/6492810587@10.15.1.2 SOFIA RESET
2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:801 sofia/external/6492810587@10.15.1.2 CUSTOM RESET
2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:808 (sofia/external/6492810587@10.15.1.2) State Change CS_RESET -> CS_SOFT_EXECUTE
2014-03-07 10:20:03.172884 [DEBUG] switch_core_session.c:1384 Send signal sofia/external/6492810587@10.15.1.2 [BREAK]
2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:526 (sofia/external/6492810587@10.15.1.2) State RESET going to sleep
2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:467 (sofia/external/6492810587@10.15.1.2) Running State Change CS_SOFT_EXECUTE
2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua'
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_STATE:67701a09-90d9-4b0e-a114-d7726ad8666b->CS_SOFT_EXECUTE

2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:536 (sofia/external/6492810587@10.15.1.2) State SOFT_EXECUTE
2014-03-07 10:20:03.172884 [DEBUG] mod_sofia.c:598 SOFIA SOFT_EXECUTE
2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:826 sofia/external/6492810587@10.15.1.2 CUSTOM SOFT_EXECUTE
2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:647 BRIDGE THREAD DONE [sofia/external/6499196120@172.20.1.201:5061]
2014-03-07 10:20:03.172884 [NOTICE] switch_ivr_bridge.c:660 Hangup sofia/external/6492810587@10.15.1.2 [CS_SOFT_EXECUTE] [NORMAL_CLEARING]
2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua'
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:CHANNEL_HANGUP uuid:67701a09-90d9-4b0e-a114-d7726ad8666b
2014-03-07 10:20:03.172884 [DEBUG] switch_channel.c:3212 Send signal sofia/external/6492810587@10.15.1.2 [KILL]
2014-03-07 10:20:03.172884 [DEBUG] switch_core_session.c:1384 Send signal sofia/external/6492810587@10.15.1.2 [BREAK]
2014-03-07 10:20:03.172884 [DEBUG] switch_channel.c:1963 (sofia/external/6499196120@172.20.1.201:5061) Callstate Change HELD -> UNHOLD
2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua'
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_CALLSTATE6ed900e4-2f0e-4a92-8b3e-f10c990d007a->Channel-Call-State:UNHOLD

2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_CALLSTATE6ed900e4-2f0e-4a92-8b3e-f10c990d007a->Original-Channel-Call-State:HELD

2014-03-07 10:20:03.172884 [DEBUG] switch_channel.c:1974 (sofia/external/6499196120@172.20.1.201:5061) Callstate Change UNHOLD -> ACTIVE
2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua'
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_CALLSTATE6ed900e4-2f0e-4a92-8b3e-f10c990d007a->Channel-Call-State:ACTIVE

2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_CALLSTATE6ed900e4-2f0e-4a92-8b3e-f10c990d007a->Original-Channel-Call-State:UNHOLD

2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:672 Send signal sofia/external/6492810587@10.15.1.2 [BREAK]
2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua'
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:CHANNEL_UNBRIDGE uuid:6ed900e4-2f0e-4a92-8b3e-f10c990d007a
2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:1538 sofia/external/6492810587@10.15.1.2 skip receive message [UNBRIDGE] (channel is hungup already)
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
2014-03-07 10:20:03.172884 [DEBUG] sofia.c:5931 Channel sofia/external/6499196120@172.20.1.201:5061 entering state [calling][0]
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
2014-03-07 10:20:03.172884 [DEBUG] sofia.c:5931 Channel sofia/external/6499196120@172.20.1.201:5061 entering state [completing][200]
2014-03-07 10:20:03.172884 [DEBUG] sofia.c:5941 Remote SDP:
v=0
o=root 1737995898 1737995899 IN IP4 172.20.1.201
s=iTalk
c=IN IP4 172.20.1.201
t=0 0
m=audio 10418 RTP/AVP 8 101
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=recvonly
a=ptime:20

nua.c:639 nua_ack() nua: nua_ack: entering
nua_stack.c:569 nua_stack_signal() nua(0x7ff100007ce0): recv signal r_ack
nua_params.c:480 nua_stack_set_params() nua: nua_stack_set_params: entering
soa.c:405 soa_set_params() soa_set_params(static::0x7ff1000085e0, ...) called
soa.c:1730 soa_activate() soa_activate(static::0x7ff1000085e0, (nil)) called
nta.c:2663 nta_tpn_by_url() nta: selecting scheme sip
tport.c:3265 tport_tsend() tport_tsend(0x1eb4080) tpn = */172.20.1.201:5061
tport.c:4054 tport_resolve() tport_resolve addrinfo = 172.20.1.201:5061
tport.c:4688 tport_by_addrinfo() tport_by_addrinfo(0x1eb4080): not found by name */172.20.1.201:5061
tport.c:3602 tport_vsend() tport_vsend(0x1eb4080): 358 bytes of 358 to udp/172.20.1.201:5061
tport.c:3500 tport_send_msg() tport_vsend returned 358
send 358 bytes to udp/[172.20.1.201]:5061 at 21:40:15.062583:
------------------------------------------------------------------------
   ACK sip:6499196120@172.20.1.201:5061 SIP/2.0
   Via: SIP/2.0/UDP 172.20.1.204:5066;rport;branch=z9hG4bKrcHQp3vFU8HUF
   Max-Forwards: 70
   From: <sip:6492810587@172.20.1.204:5066>;tag=t8tK0r0750cHj
   To: "Anonymous" <sip:6499196120@172.20.1.201:5061>;tag=as02ccecfe
   Call-ID: 419a7a7d150b4049389c91f1109676d4@172.20.1.201
   CSeq: 56734943 ACK
   Content-Length: 0

------------------------------------------------------------------------
nta.c:8190 outgoing_send() nta: sent ACK (56734943) to */172.20.1.201:5061
nua_session.c:4143 signal_call_state_change() nua(0x7ff100007ce0): ready call updated: ready
nua_stack.c:271 nua_stack_event() nua(0x7ff100007ce0): event i_state 200 ACK sent
nua_stack.c:271 nua_stack_event() nua(0x7ff100007ce0): event i_active 200 Call active
nua_stack.c:359 nua_application_event() nua: nua_application_event: entering
2014-03-07 10:20:03.172884 [DEBUG] switch_core_session.c:1049 Send signal sofia/external/6499196120@172.20.1.201:5061 [BREAK]
nua_stack.c:359 nua_application_event() nua: nua_application_event: entering
2014-03-07 10:20:03.172884 [DEBUG] switch_core_session.c:1049 Send signal sofia/external/6499196120@172.20.1.201:5061 [BREAK]
nua_stack.c:529 nua_signal() nua(0x7ff100007ce0): sent signal r_ack
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
2014-03-07 10:20:03.172884 [DEBUG] sofia.c:5931 Channel sofia/external/6499196120@172.20.1.201:5061 entering state [ready][200]
2014-03-07 10:20:03.172884 [DEBUG] switch_core_media.c:3191 Audio Codec Compare [PCMA:8:8000:20:64000]/[G722:9:8000:20:64000]
2014-03-07 10:20:03.172884 [DEBUG] switch_core_media.c:3191 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMU:0:8000:20:64000]
2014-03-07 10:20:03.172884 [DEBUG] switch_core_media.c:3191 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMA:8:8000:20:64000]
2014-03-07 10:20:03.172884 [DEBUG] switch_core_media.c:3245 Audio Codec Compare [PCMA:8:8000:20:64000] ++++ is saved as a match
2014-03-07 10:20:03.172884 [DEBUG] switch_core_media.c:3191 Audio Codec Compare [PCMA:8:8000:20:64000]/[GSM:3:8000:20:13200]
2014-03-07 10:20:03.172884 [DEBUG] switch_core_media.c:3117 Set telephone-event payload to 101
2014-03-07 10:20:03.172884 [DEBUG] switch_core_media.c:3427 Set 2833 dtmf send/recv payload to 101
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
2014-03-07 10:20:03.172884 [DEBUG] switch_core_session.c:904 Send signal sofia/external/6499196120@172.20.1.201:5061 [BREAK]
2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua'
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:CHANNEL_EXECUTE_COMPLETE uuid:6ed900e4-2f0e-4a92-8b3e-f10c990d007a
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:CHANNEL_EXECUTE_COMPLETEapp:bridge data:sofia/external/6492810587@10.15.1.2
2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:530 (sofia/external/6499196120@172.20.1.201:5061) State EXECUTE going to sleep
2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:467 (sofia/external/6499196120@172.20.1.201:5061) Running State Change CS_PARK
2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua'
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_STATE:6ed900e4-2f0e-4a92-8b3e-f10c990d007a->CS_PARK

2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:539 (sofia/external/6499196120@172.20.1.201:5061) State PARK
2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:334 sofia/external/6499196120@172.20.1.201:5061 Standard PARK
2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua'
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:CHANNEL_PARK uuid:6ed900e4-2f0e-4a92-8b3e-f10c990d007a
2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua'
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:CHANNEL_UNPARK uuid:ed3aabd0-9f2e-4b2d-a9c6-a468e9e2966e
2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:539 (sofia/external/6499744915@172.20.1.201:5061) State PARK going to sleep
2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:467 (sofia/external/6499744915@172.20.1.201:5061) Running State Change CS_HIBERNATE
2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua'
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_STATE:ed3aabd0-9f2e-4b2d-a9c6-a468e9e2966e->CS_HIBERNATE

2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:545 (sofia/external/6499744915@172.20.1.201:5061) State HIBERNATE
2014-03-07 10:20:03.172884 [DEBUG] mod_sofia.c:160 sofia/external/6499744915@172.20.1.201:5061 SOFIA HIBERNATE
2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:816 (sofia/external/6499744915@172.20.1.201:5061) State Change CS_HIBERNATE -> CS_RESET
2014-03-07 10:20:03.172884 [DEBUG] switch_core_session.c:1384 Send signal sofia/external/6499744915@172.20.1.201:5061 [BREAK]
2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:545 (sofia/external/6499744915@172.20.1.201:5061) State HIBERNATE going to sleep
2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:467 (sofia/external/6499744915@172.20.1.201:5061) Running State Change CS_RESET
2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua'
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua
2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_STATE:ed3aabd0-9f2e-4b2d-a9c6-a468e9e2966e->CS_RESET

2014-03-07 10:20:03.191760 [DEBUG] switch_core_state_machine.c:526 (sofia/external/6499744915@172.20.1.201:5061) State RESET
2014-03-07 10:20:03.191760 [DEBUG] mod_sofia.c:141 sofia/external/6499744915@172.20.1.201:5061 SOFIA RESET
2014-03-07 10:20:03.191760 [DEBUG] switch_ivr_bridge.c:801 sofia/external/6499744915@172.20.1.201:5061 CUSTOM RESET
2014-03-07 10:20:03.191760 [DEBUG] switch_core_state_machine.c:116 sofia/external/6499744915@172.20.1.201:5061 Standard RESET
2014-03-07 10:20:03.191760 [DEBUG] switch_core_state_machine.c:526 (sofia/external/6499744915@172.20.1.201:5061) State RESET going to sleep
2014-03-07 10:20:03.191760 [DEBUG] switch_core_media.c:2063 Already using PCMA
2014-03-07 10:20:03.191760 [DEBUG] switch_ivr_originate.c:859 (sofia/external/6499744915@172.20.1.201:5061) State Change CS_RESET -> CS_SOFT_EXECUTE
2014-03-07 10:20:03.191760 [DEBUG] switch_core_session.c:1384 Send signal sofia/external/6499744915@172.20.1.201:5061 [BREAK]
2014-03-07 10:20:03.191760 [DEBUG] switch_core_state_machine.c:467 (sofia/external/6499744915@172.20.1.201:5061) Running State Change CS_SOFT_EXECUTE
2014-03-07 10:20:03.191760 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua'
2014-03-07 10:20:03.191760 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua
2014-03-07 10:20:03.191760 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_STATE:ed3aabd0-9f2e-4b2d-a9c6-a468e9e2966e->CS_SOFT_EXECUTE

2014-03-07 10:20:03.191760 [DEBUG] switch_core_state_machine.c:536 (sofia/external/6499744915@172.20.1.201:5061) State SOFT_EXECUTE
2014-03-07 10:20:03.191760 [DEBUG] mod_sofia.c:598 SOFIA SOFT_EXECUTE
2014-03-07 10:20:03.191760 [DEBUG] switch_ivr_bridge.c:826 sofia/external/6499744915@172.20.1.201:5061 CUSTOM SOFT_EXECUTE
2014-03-07 10:20:03.191760 [DEBUG] switch_core_state_machine.c:328 sofia/external/6499744915@172.20.1.201:5061 Standard SOFT_EXECUTE
2014-03-07 10:20:03.191760 [DEBUG] switch_core_state_machine.c:536 (sofia/external/6499744915@172.20.1.201:5061) State SOFT_EXECUTE going to sleep
nta.c:8987 outgoing_timer_dk() nta: timer K fired, terminate INFO (56734935)
nta.c:8685 outgoing_reclaim_queued() outgoing_reclaim_all((nil), (nil), 0x7ff10e3a2d40)
nta.c:8815 _nta_outgoing_timer() nta_outgoing_timer: 0/0 resent, 0/2 tout, 1/3 term, 1/5 free
nta.c:1294 agent_timer() nta: timer set next to 14232 ms
freeswitch@internal>
freeswitch@internal>
freeswitch@internal>
freeswitch@internal>
freeswitch@internal> /exit





Kevin Stewart
Senior VOIP Network Engineer
Direct: +64 9 919 6120
Mobile: 021 879057
Fax: +64 9 919 6121


 

Kevin Stewart
Senior VOIP Network Engineer
Direct:
+64 9 919 6120
Mobile:
 021 879057
Fax:
+64 9 919 6121
www.callplus.co.nz 100% Kiwi owned www.slingshot.co.nz
This message and any attachments contain privileged and confidential information. If you are not the intended recipient of
this message, you are hereby notified that any use, dissemination, distribution or reproduction of this message is prohibited.
If you have received this message in error please notify the sender immediately via email and then destroy this message
and any attachments.