On Thu, Apr 30, 2009 at 1:17 AM, Scott Shen <sshen@oa.com.au> wrote:

I am using FS r13096, sometimes uuid_bridge will hangup both legs with no obvious reason( see the debug log below )

The scenario is

1.       Caller(8002) Connects to Callee(7001)

2.       8002 then is parked by using uuid_park ( hence, 7001 is released )

3.       now using a simple lua script ( as listed below ) to re-connect 7001 back to the parked call

4.       most of the time, the re-connect will success, however, sometimes it will drop both legs.

local api = freeswitch.API();

-- Invite the requestor

local ses = freeswitch.Session("user/" .. requestor);

if ses:ready() then

        ses:answer();

        -- Get the UUID of this leg

        local uuid = ses:getVariable("uuid");

        -- Bridge it to the parked id

        freeswitch.consoleLog("info", "uuid_bridge " .. parkedid .. " " .. uuid .. "\n");

        api:execute("uuid_bridge", parkedid .. " " .. uuid );

end

2009-04-30 15:42:25 [DEBUG] sofia_glue.c:2929 sofia_glue_negotiate_sdp() Audio Codec Compare [PCMA:8:8000:0]/[PCMA:8:8000:20]

2009-04-30 15:42:25 [DEBUG] sofia_glue.c:1912 sofia_glue_tech_set_codec() Set Codec sofia/internal/sip:7001@192.168.0.31:5340 PCMA/8000 20 ms 160 samples

2009-04-30 15:42:25 [DEBUG] sofia_glue.c:2889 sofia_glue_negotiate_sdp() Set 2833 dtmf payload to 101

2009-04-30 15:42:25 [DEBUG] sofia_glue.c:2146 sofia_glue_activate_rtp() AUDIO RTP [sofia/internal/sip:7001@192.168.0.31:5340] 192.168.0.137 port 28890 -> 192.168.0.31 port 7360 codec: 8 ms: 20

2009-04-30 15:42:25 [DEBUG] switch_rtp.c:900 switch_rtp_create() Starting timer [soft] 160 bytes per 20ms

2009-04-30 15:42:25 [NOTICE] sofia.c:3399 sofia_handle_sip_i_state() Channel [sofia/internal/sip:7001@192.168.0.31:5340] has been answered

2009-04-30 15:42:25 [DEBUG] switch_channel.c:182 switch_channel_audio_sync() sofia/internal/sip:7001@192.168.0.31:5340 receive message [AUDIO_SYNC]

2009-04-30 15:42:25 [DEBUG] switch_ivr_originate.c:2016 switch_ivr_originate() Originate Resulted in Success: [sofia/internal/sip:7001@192.168.0.31:5340]

2009-04-30 15:42:25 [DEBUG] switch_channel.c:182 switch_channel_audio_sync() sofia/internal/sip:7001@192.168.0.31:5340 receive message [AUDIO_SYNC]

2009-04-30 15:42:25 [DEBUG] switch_ivr_originate.c:2016 switch_ivr_originate() Originate Resulted in Success: [sofia/internal/sip:7001@192.168.0.31:5340]

2009-04-30 15:42:25 [DEBUG] switch_channel.c:182 switch_channel_audio_sync() sofia/internal/sip:7001@192.168.0.31:5340 receive message [AUDIO_SYNC]

2009-04-30 15:42:25 [DEBUG] switch_cpp.cpp:496 CoreSession() (sofia/internal/sip:7001@192.168.0.31:5340) State Change CS_CONSUME_MEDIA -> CS_SOFT_EXECUTE

2009-04-30 15:42:25 [DEBUG] switch_core_session.c:869 switch_core_session_signal_state_change() Send signal sofia/internal/sip:7001@192.168.0.31:5340 [BREAK]

2009-04-30 15:42:25 [INFO] switch_cpp.cpp:1122 console_log() uuid_bridge 87d70dc0-96aa-4185-9614-f742a9564f30 723ee9d3-6a30-485f-8069-c535f4946e98

2009-04-30 15:42:25 [DEBUG] switch_ivr_bridge.c:1164 switch_ivr_uuid_bridge() (sofia/internal/8002@192.168.0.137) State Change CS_PARK -> CS_HIBERNATE

2009-04-30 15:42:25 [DEBUG] switch_core_state_machine.c:517 switch_core_session_run() (sofia/internal/sip:7001@192.168.0.31:5340) State CONSUME_MEDIA going to sleep

2009-04-30 15:42:25 [DEBUG] switch_core_state_machine.c:397 switch_core_session_run() (sofia/internal/sip:7001@192.168.0.31:5340) Running State Change CS_SOFT_EXECUTE

2009-04-30 15:42:25 [DEBUG] switch_core_state_machine.c:514 switch_core_session_run() (sofia/internal/8002@192.168.0.137) State PARK going to sleep

2009-04-30 15:42:25 [DEBUG] switch_core_state_machine.c:511 switch_core_session_run() (sofia/internal/sip:7001@192.168.0.31:5340) State SOFT_EXECUTE

2009-04-30 15:42:25 [DEBUG] mod_sofia.c:430 sofia_on_soft_execute() SOFIA TRANSMIT

2009-04-30 15:42:25 [DEBUG] switch_ivr_bridge.c:604 uuid_bridge_on_soft_execute() sofia/internal/sip:7001@192.168.0.31:5340 CUSTOM SOFT_EXECUTE

2009-04-30 15:42:25 [DEBUG] switch_core_state_machine.c:192 switch_core_standard_on_soft_execute() sofia/internal/sip:7001@192.168.0.31:5340 Standard SOFT_EXECUTE

2009-04-30 15:42:25 [DEBUG] switch_core_state_machine.c:511 switch_core_session_run() (sofia/internal/sip:7001@192.168.0.31:5340) State SOFT_EXECUTE going to sleep

2009-04-30 15:42:25 [DEBUG] switch_core_session.c:869 switch_core_session_signal_state_change() Send signal sofia/internal/8002@192.168.0.137 [BREAK]

2009-04-30 15:42:25 [DEBUG] switch_core_state_machine.c:397 switch_core_session_run() (sofia/internal/8002@192.168.0.137) Running State Change CS_HIBERNATE

2009-04-30 15:42:25 [DEBUG] switch_core_state_machine.c:520 switch_core_session_run() (sofia/internal/8002@192.168.0.137) State HIBERNATE

2009-04-30 15:42:25 [DEBUG] mod_sofia.c:160 sofia_on_hibernate() sofia/internal/8002@192.168.0.137 SOFIA HIBERNATE

2009-04-30 15:42:25 [DEBUG] switch_ivr_bridge.c:594 uuid_bridge_on_hibernate() (sofia/internal/8002@192.168.0.137) State Change CS_HIBERNATE -> CS_RESET

2009-04-30 15:42:25 [DEBUG] switch_core_session.c:869 switch_core_session_signal_state_change() Send signal sofia/internal/8002@192.168.0.137 [BREAK]

2009-04-30 15:42:25 [DEBUG] switch_core_state_machine.c:520 switch_core_session_run() (sofia/internal/8002@192.168.0.137) State HIBERNATE going to sleep

2009-04-30 15:42:25 [DEBUG] switch_core_state_machine.c:397 switch_core_session_run() (sofia/internal/8002@192.168.0.137) Running State Change CS_RESET

2009-04-30 15:42:25 [DEBUG] switch_core_state_machine.c:501 switch_core_session_run() (sofia/internal/8002@192.168.0.137) State RESET

2009-04-30 15:42:25 [DEBUG] mod_sofia.c:145 sofia_on_reset() sofia/internal/8002@192.168.0.137 SOFIA RESET

2009-04-30 15:42:25 [DEBUG] switch_ivr_bridge.c:581 uuid_bridge_on_reset() sofia/internal/8002@192.168.0.137 CUSTOM RESET

2009-04-30 15:42:25 [DEBUG] switch_ivr_bridge.c:586 uuid_bridge_on_reset() (sofia/internal/8002@192.168.0.137) State Change CS_RESET -> CS_SOFT_EXECUTE

2009-04-30 15:42:25 [DEBUG] switch_core_session.c:869 switch_core_session_signal_state_change() Send signal sofia/internal/8002@192.168.0.137 [BREAK]

2009-04-30 15:42:25 [DEBUG] switch_core_state_machine.c:501 switch_core_session_run() (sofia/internal/8002@192.168.0.137) State RESET going to sleep

2009-04-30 15:42:25 [DEBUG] switch_core_state_machine.c:397 switch_core_session_run() (sofia/internal/8002@192.168.0.137) Running State Change CS_SOFT_EXECUTE

2009-04-30 15:42:25 [DEBUG] switch_core_state_machine.c:511 switch_core_session_run() (sofia/internal/8002@192.168.0.137) State SOFT_EXECUTE

2009-04-30 15:42:25 [DEBUG] mod_sofia.c:430 sofia_on_soft_execute() SOFIA TRANSMIT

2009-04-30 15:42:25 [DEBUG] switch_ivr_bridge.c:604 uuid_bridge_on_soft_execute() sofia/internal/8002@192.168.0.137 CUSTOM SOFT_EXECUTE

2009-04-30 15:42:25 [DEBUG] switch_ivr_bridge.c:1166 switch_ivr_uuid_bridge() (sofia/internal/sip:7001@192.168.0.31:5340) State Change CS_SOFT_EXECUTE -> CS_HIBERNATE

2009-04-30 15:42:25 [DEBUG] switch_core_session.c:869 switch_core_session_signal_state_change() Send signal sofia/internal/sip:7001@192.168.0.31:5340 [BREAK]

2009-04-30 15:42:25 [DEBUG] switch_core_state_machine.c:397 switch_core_session_run() (sofia/internal/sip:7001@192.168.0.31:5340) Running State Change CS_HIBERNATE

2009-04-30 15:42:25 [DEBUG] switch_core_state_machine.c:520 switch_core_session_run() (sofia/internal/sip:7001@192.168.0.31:5340) State HIBERNATE

2009-04-30 15:42:25 [DEBUG] mod_sofia.c:160 sofia_on_hibernate() sofia/internal/sip:7001@192.168.0.31:5340 SOFIA HIBERNATE

2009-04-30 15:42:25 [DEBUG] switch_core_state_machine.c:212 switch_core_standard_on_hibernate() sofia/internal/sip:7001@192.168.0.31:5340 Standard HIBERNATE

2009-04-30 15:42:25 [DEBUG] switch_core_state_machine.c:520 switch_core_session_run() (sofia/internal/sip:7001@192.168.0.31:5340) State HIBERNATE going to sleep

2009-04-30 15:42:25 [DEBUG] switch_cpp.cpp:916 destroy() destroy/unlink session from object

2009-04-30 15:42:25 [NOTICE] switch_cpp.cpp:919 destroy() Hangup sofia/internal/sip:7001@192.168.0.31:5340 [CS_HIBERNATE] [NORMAL_CLEARING]

2009-04-30 15:42:25 [DEBUG] switch_channel.c:1617 switch_channel_perform_hangup() Send signal sofia/internal/sip:7001@192.168.0.31:5340 [KILL]

2009-04-30 15:42:25 [DEBUG] switch_core_session.c:869 switch_core_session_signal_state_change() Send signal sofia/internal/sip:7001@192.168.0.31:5340 [BREAK]

2009-04-30 15:42:25 [DEBUG] switch_core_state_machine.c:397 switch_core_session_run() (sofia/internal/sip:7001@192.168.0.31:5340) Running State Change CS_HANGUP

2009-04-30 15:42:25 [DEBUG] switch_core_state_machine.c:448 switch_core_session_run() (sofia/internal/sip:7001@192.168.0.31:5340) State HANGUP

2009-04-30 15:42:25 [DEBUG] mod_sofia.c:315 sofia_on_hangup() Channel sofia/internal/sip:7001@192.168.0.31:5340 hanging up, cause: NORMAL_CLEARING

2009-04-30 15:42:25 [DEBUG] mod_sofia.c:370 sofia_on_hangup() Sending BYE to sofia/internal/sip:7001@192.168.0.31:5340

_______________________________________________
Freeswitch-dev mailing list
Freeswitch-dev@lists.freeswitch.org
http://lists.freeswitch.org/mailman/listinfo/freeswitch-dev
UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-dev
http://www.freeswitch.org