Sound issue on bridging one inbound gateway call to another gateway
Hello everybody, I need to bridge an inbound call from a gateway number to another gateway number (same provider). Call is made, but there is no sound exchange, nor any ringback while calling "GATEWAY_1_NUMBER". Here is the public dialplan (in /usr/local/freeswitch/conf/dialplan/public/.): <include> <extension name="EXT_NAME"> <condition field="destination_number" expression="^(GATEWAY_1_NUMBER)$"> <action application="bridge" data="sofia/gateway/GATEWAY_2_NAME/FIXED_NUMBER"/> </condition> </extension> </include> I have searched in this mailing list's archives but have not found any answer. Is there anyone who knows what appends and what can I do to make it work. Thanks in advance, TB -- View this message in context: http://freeswitch-users.2379917.n2.nabble.com/Sound-issue-on-bridging-one-in... Sent from the freeswitch-users mailing list archive at Nabble.com.
On 25.10.2013 12:07, obbyone wrote:
I need to bridge an inbound call from a gateway number to another gateway number (same provider). Call is made, but there is no sound exchange, nor any ringback while calling "GATEWAY_1_NUMBER".
Hi. Read this page https://wiki.freeswitch.org/wiki/Bypass_Media and related pages to understand how RTP works and why you have this problem. -- Mimiko desu.
Hy, I see no answer so maybe you need some more informations : I put here the logs... <<< 2013-10-25 11:22:42.752485 [NOTICE] switch_channel.c:1034 New Channel sofia/external/<nb_caller>@<my_provider> [495c9dd1-1713-4dd1-b41d-cf1a53537e52] 2013-10-25 11:22:42.752485 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:22:42.752485 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:22:42.752485 [DEBUG] switch_core_state_machine.c:418 (sofia/external/<nb_caller>@<my_provider>) Running State Change CS_NEW 2013-10-25 11:22:42.752485 [DEBUG] switch_core_state_machine.c:436 (sofia/external/<nb_caller>@<my_provider>) State NEW 2013-10-25 11:22:42.772480 [DEBUG] sofia.c:5834 Channel sofia/external/<nb_caller>@<my_provider> entering state [received][100] 2013-10-25 11:22:42.772480 [DEBUG] sofia.c:5844 Remote SDP: v=0 o=cp10 138269296293 138269296293 IN IP4 10.7.1.129 s=SIP Call c=IN IP4 91.121.128.144 t=0 0 m=audio 38132 RTP/AVP 18 4 0 8 125 111 101 b=AS:21 a=rtpmap:18 G729/8000/1 a=fmtp:18 annexb=no a=rtpmap:4 G723/8000/1 a=fmtp:4 annexa=no a=rtpmap:0 PCMU/8000/1 a=rtpmap:8 PCMA/8000/1 a=rtpmap:125 CLEARMODE/8000/1 a=rtpmap:111 iLBC/8000/1 a=fmtp:111 mode=30 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 a=ptime:30 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [G729:18:8000:30:8000]/[G7221:115:32000:20:48000] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [G729:18:8000:30:8000]/[G7221:107:16000:20:32000] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [G729:18:8000:30:8000]/[G722:9:8000:20:64000] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [G729:18:8000:30:8000]/[PCMU:0:8000:20:64000] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [G729:18:8000:30:8000]/[PCMA:8:8000:20:64000] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [G729:18:8000:30:8000]/[GSM:3:8000:20:13200] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [G723:4:8000:30:6300]/[G7221:115:32000:20:48000] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [G723:4:8000:30:6300]/[G7221:107:16000:20:32000] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [G723:4:8000:30:6300]/[G722:9:8000:20:64000] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [G723:4:8000:30:6300]/[PCMU:0:8000:20:64000] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [G723:4:8000:30:6300]/[PCMA:8:8000:20:64000] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [G723:4:8000:30:6300]/[GSM:3:8000:20:13200] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [PCMU:0:8000:30:64000]/[G7221:115:32000:20:48000] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [PCMU:0:8000:30:64000]/[G7221:107:16000:20:32000] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [PCMU:0:8000:30:64000]/[G722:9:8000:20:64000] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [PCMU:0:8000:30:64000]/[PCMU:0:8000:20:64000] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [PCMU:0:8000:30:64000]/[PCMA:8:8000:20:64000] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [PCMU:0:8000:30:64000]/[GSM:3:8000:20:13200] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [PCMA:8:8000:30:64000]/[G7221:115:32000:20:48000] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [PCMA:8:8000:30:64000]/[G7221:107:16000:20:32000] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [PCMA:8:8000:30:64000]/[G722:9:8000:20:64000] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [PCMA:8:8000:30:64000]/[PCMU:0:8000:20:64000] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [PCMA:8:8000:30:64000]/[PCMA:8:8000:20:64000] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:1913 Set Codec sofia/external/<nb_caller>@<my_provider> PCMA/8000 20 ms 160 samples 64000 bits 2013-10-25 11:22:42.782468 [DEBUG] switch_core_codec.c:111 sofia/external/<nb_caller>@<my_provider> Original read codec set to PCMA:8 2013-10-25 11:22:42.782468 [DEBUG] switch_core_media.c:3051 Set 2833 dtmf send/recv payload to 101 2013-10-25 11:22:42.782468 [DEBUG] sofia.c:6076 (sofia/external/<nb_caller>@<my_provider>) State Change CS_NEW -> CS_INIT 2013-10-25 11:22:42.782468 [DEBUG] switch_core_session.c:1345 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_state_machine.c:418 (sofia/external/<nb_caller>@<my_provider>) Running State Change CS_INIT 2013-10-25 11:22:42.782468 [DEBUG] switch_core_state_machine.c:457 (sofia/external/<nb_caller>@<my_provider>) State INIT 2013-10-25 11:22:42.782468 [DEBUG] mod_sofia.c:87 sofia/external/<nb_caller>@<my_provider> SOFIA INIT 2013-10-25 11:22:42.782468 [DEBUG] mod_sofia.c:114 (sofia/external/<nb_caller>@<my_provider>) State Change CS_INIT -> CS_ROUTING 2013-10-25 11:22:42.782468 [DEBUG] switch_core_session.c:1345 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_state_machine.c:457 (sofia/external/<nb_caller>@<my_provider>) State INIT going to sleep 2013-10-25 11:22:42.782468 [DEBUG] switch_core_state_machine.c:418 (sofia/external/<nb_caller>@<my_provider>) Running State Change CS_ROUTING 2013-10-25 11:22:42.782468 [DEBUG] switch_channel.c:2120 (sofia/external/<nb_caller>@<my_provider>) Callstate Change DOWN -> RINGING 2013-10-25 11:22:42.782468 [DEBUG] switch_core_state_machine.c:473 (sofia/external/<nb_caller>@<my_provider>) State ROUTING 2013-10-25 11:22:42.782468 [DEBUG] mod_sofia.c:137 sofia/external/<nb_caller>@<my_provider> SOFIA ROUTING 2013-10-25 11:22:42.782468 [DEBUG] switch_core_state_machine.c:117 sofia/external/<nb_caller>@<my_provider> Standard ROUTING 2013-10-25 11:22:42.782468 [INFO] mod_dialplan_xml.c:558 Processing <nb_caller> <<nb_caller>>-><inbound_gateway_number> in context public Dialplan: sofia/external/<nb_caller>@<my_provider> parsing [public->unloop] continue=false Dialplan: sofia/external/<nb_caller>@<my_provider> Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false Dialplan: sofia/external/<nb_caller>@<my_provider> Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false Dialplan: sofia/external/<nb_caller>@<my_provider> parsing [public->outside_call] continue=true Dialplan: sofia/external/<nb_caller>@<my_provider> Absolute Condition [outside_call] Dialplan: sofia/external/<nb_caller>@<my_provider> Action set(outside_call=true) Dialplan: sofia/external/<nb_caller>@<my_provider> parsing [public->call_debug] continue=true Dialplan: sofia/external/<nb_caller>@<my_provider> Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never Dialplan: sofia/external/<nb_caller>@<my_provider> parsing [public->public_extensions] continue=false Dialplan: sofia/external/<nb_caller>@<my_provider> Regex (FAIL) [public_extensions] destination_number(<inbound_gateway_number>) =~ /^(10[01][0-9])$/ break=on-false Dialplan: sofia/external/<nb_caller>@<my_provider> parsing [public->public_did] continue=false Dialplan: sofia/external/<nb_caller>@<my_provider> Regex (FAIL) [public_did] destination_number(<inbound_gateway_number>) =~ /^(5551212)$/ break=on-false Dialplan: sofia/external/<nb_caller>@<my_provider> parsing [public->public_openIP] continue=false Dialplan: sofia/external/<nb_caller>@<my_provider> Regex (FAIL) [public_openIP] destination_number(<inbound_gateway_number>) =~ /^(970710200)$/ break=on-false Dialplan: sofia/external/<nb_caller>@<my_provider> parsing [public->public_ovh] continue=false Dialplan: sofia/external/<nb_caller>@<my_provider> Regex (FAIL) [public_ovh] destination_number(<inbound_gateway_number>) =~ /^(<outbound_gateway_number>)$/ break=on-false Dialplan: sofia/external/<nb_caller>@<my_provider> parsing [public->transfert_08] continue=false Dialplan: sofia/external/<nb_caller>@<my_provider> Regex (PASS) [transfert_08] destination_number(<inbound_gateway_number>) =~ /^(<inbound_gateway_number>)$/ break=on-false Dialplan: sofia/external/<nb_caller>@<my_provider> Action ring_ready() Dialplan: sofia/external/<nb_caller>@<my_provider> Action bridge(sofia/gateway/outbound02_ovh/<nb_callee>) 2013-10-25 11:22:42.782468 [DEBUG] switch_core_state_machine.c:167 (sofia/external/<nb_caller>@<my_provider>) State Change CS_ROUTING -> CS_EXECUTE 2013-10-25 11:22:42.782468 [DEBUG] switch_core_session.c:1345 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_state_machine.c:473 (sofia/external/<nb_caller>@<my_provider>) State ROUTING going to sleep 2013-10-25 11:22:42.782468 [DEBUG] switch_core_state_machine.c:418 (sofia/external/<nb_caller>@<my_provider>) Running State Change CS_EXECUTE 2013-10-25 11:22:42.782468 [DEBUG] switch_core_state_machine.c:480 (sofia/external/<nb_caller>@<my_provider>) State EXECUTE 2013-10-25 11:22:42.782468 [DEBUG] mod_sofia.c:230 sofia/external/<nb_caller>@<my_provider> SOFIA EXECUTE 2013-10-25 11:22:42.782468 [DEBUG] switch_core_state_machine.c:209 sofia/external/<nb_caller>@<my_provider> Standard EXECUTE EXECUTE sofia/external/<nb_caller>@<my_provider> set(outside_call=true) 2013-10-25 11:22:42.782468 [DEBUG] mod_dptools.c:1395 sofia/external/<nb_caller>@<my_provider> SET [outside_call]=[true] EXECUTE sofia/external/<nb_caller>@<my_provider> ring_ready() 2013-10-25 11:22:42.782468 [NOTICE] mod_sofia.c:2078 Ring-Ready sofia/external/<nb_caller>@<my_provider>! 2013-10-25 11:22:42.782468 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:22:42.782468 [DEBUG] sofia.c:5834 Channel sofia/external/<nb_caller>@<my_provider> entering state [early][180] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_session.c:865 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:22:42.782468 [NOTICE] mod_dptools.c:941 Ring Ready sofia/external/<nb_caller>@<my_provider>! EXECUTE sofia/external/<nb_caller>@<my_provider> bridge(sofia/gateway/outbound02_ovh/<nb_callee>) 2013-10-25 11:22:42.782468 [DEBUG] switch_ivr_originate.c:2060 Parsing global variables 2013-10-25 11:22:42.782468 [NOTICE] switch_channel.c:1034 New Channel sofia/external/<nb_callee> [e564400f-6932-4d3b-b3cb-ba0c7fdac9df] 2013-10-25 11:22:42.782468 [DEBUG] mod_sofia.c:4480 (sofia/external/<nb_callee>) State Change CS_NEW -> CS_INIT 2013-10-25 11:22:42.782468 [DEBUG] switch_core_session.c:1345 Send signal sofia/external/<nb_callee> [BREAK] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_state_machine.c:418 (sofia/external/<nb_callee>) Running State Change CS_INIT 2013-10-25 11:22:42.782468 [DEBUG] switch_core_state_machine.c:457 (sofia/external/<nb_callee>) State INIT 2013-10-25 11:22:42.782468 [DEBUG] mod_sofia.c:87 sofia/external/<nb_callee> SOFIA INIT 2013-10-25 11:22:42.782468 [DEBUG] sofia_glue.c:1225 Local SDP: v=0 o=FreeSWITCH 1382661558 1382661559 IN IP4 91.204.116.116 s=FreeSWITCH c=IN IP4 91.204.116.116 t=0 0 m=audio 31404 RTP/AVP 8 0 3 101 13 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv 2013-10-25 11:22:42.782468 [DEBUG] mod_sofia.c:114 (sofia/external/<nb_callee>) State Change CS_INIT -> CS_ROUTING 2013-10-25 11:22:42.782468 [DEBUG] switch_core_session.c:1345 Send signal sofia/external/<nb_callee> [BREAK] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_state_machine.c:457 (sofia/external/<nb_callee>) State INIT going to sleep 2013-10-25 11:22:42.782468 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_callee> [BREAK] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_state_machine.c:418 (sofia/external/<nb_callee>) Running State Change CS_ROUTING 2013-10-25 11:22:42.782468 [DEBUG] switch_core_state_machine.c:473 (sofia/external/<nb_callee>) State ROUTING 2013-10-25 11:22:42.782468 [DEBUG] mod_sofia.c:137 sofia/external/<nb_callee> SOFIA ROUTING 2013-10-25 11:22:42.782468 [DEBUG] switch_ivr_originate.c:67 (sofia/external/<nb_callee>) State Change CS_ROUTING -> CS_CONSUME_MEDIA 2013-10-25 11:22:42.782468 [DEBUG] switch_core_session.c:1345 Send signal sofia/external/<nb_callee> [BREAK] 2013-10-25 11:22:42.782468 [DEBUG] switch_core_state_machine.c:473 (sofia/external/<nb_callee>) State ROUTING going to sleep 2013-10-25 11:22:42.782468 [DEBUG] switch_core_state_machine.c:418 (sofia/external/<nb_callee>) Running State Change CS_CONSUME_MEDIA 2013-10-25 11:22:42.782468 [DEBUG] switch_core_state_machine.c:492 (sofia/external/<nb_callee>) State CONSUME_MEDIA 2013-10-25 11:22:42.782468 [DEBUG] switch_core_state_machine.c:492 (sofia/external/<nb_callee>) State CONSUME_MEDIA going to sleep 2013-10-25 11:22:42.782468 [DEBUG] sofia.c:5834 Channel sofia/external/<nb_callee> entering state [calling][0] 2013-10-25 11:22:42.792471 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_callee> [BREAK] 2013-10-25 11:22:42.792471 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_callee> [BREAK] 2013-10-25 11:22:42.792471 [DEBUG] sofia.c:5834 Channel sofia/external/<nb_callee> entering state [calling][0] 2013-10-25 11:22:47.812527 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_callee> [BREAK] 2013-10-25 11:22:47.812527 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_callee> [BREAK] 2013-10-25 11:22:47.812527 [DEBUG] sofia.c:5834 Channel sofia/external/<nb_callee> entering state [proceeding][180] 2013-10-25 11:22:47.812527 [DEBUG] sofia.c:5844 Remote SDP: v=0 o=cp10 138269296200 138269296201 IN IP4 10.7.1.133 s=SIP Call c=IN IP4 91.121.128.146 t=0 0 m=audio 33910 RTP/AVP 0 8 101 b=AS:77 a=rtpmap:0 PCMU/8000/1 a=rtpmap:8 PCMA/8000/1 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 a=ptime:30 2013-10-25 11:22:47.812527 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [PCMU:0:8000:30:64000]/[PCMA:8:8000:20:64000] 2013-10-25 11:22:47.812527 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [PCMU:0:8000:30:64000]/[PCMU:0:8000:20:64000] 2013-10-25 11:22:47.812527 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [PCMU:0:8000:30:64000]/[GSM:3:8000:20:13200] 2013-10-25 11:22:47.812527 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [PCMA:8:8000:30:64000]/[PCMA:8:8000:20:64000] 2013-10-25 11:22:47.812527 [DEBUG] switch_core_media.c:1913 Set Codec sofia/external/<nb_callee> PCMA/8000 20 ms 160 samples 64000 bits 2013-10-25 11:22:47.812527 [DEBUG] switch_core_codec.c:111 sofia/external/<nb_callee> Original read codec set to PCMA:8 2013-10-25 11:22:47.812527 [DEBUG] switch_core_media.c:3042 Set 2833 dtmf send payload to 101 2013-10-25 11:22:47.812527 [DEBUG] switch_core_media.c:4098 AUDIO RTP [sofia/external/<nb_callee>] 91.204.116.116 port 31404 -> 91.121.128.146 port 33910 codec: 8 ms: 20 2013-10-25 11:22:47.812527 [DEBUG] switch_rtp.c:2881 Starting timer [soft] 160 bytes per 20ms 2013-10-25 11:22:47.812527 [DEBUG] switch_core_media.c:4440 Set 2833 dtmf send payload to 101 2013-10-25 11:22:47.812527 [DEBUG] switch_core_media.c:4446 Set 2833 dtmf receive payload to 101 2013-10-25 11:22:47.812527 [NOTICE] sofia_media.c:92 Pre-Answer sofia/external/<nb_callee>! 2013-10-25 11:22:47.812527 [DEBUG] switch_channel.c:3328 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:22:47.812527 [DEBUG] switch_channel.c:3332 (sofia/external/<nb_callee>) Callstate Change DOWN -> EARLY 2013-10-25 11:22:47.822472 [INFO] switch_ivr_originate.c:3443 Sending early media 2013-10-25 11:22:47.822472 [DEBUG] switch_core_media.c:4098 AUDIO RTP [sofia/external/<nb_caller>@<my_provider>] 91.204.116.116 port 28082 -> 91.121.128.144 port 38132 codec: 8 ms: 20 2013-10-25 11:22:47.822472 [DEBUG] switch_rtp.c:2881 Starting timer [soft] 160 bytes per 20ms 2013-10-25 11:22:47.822472 [DEBUG] switch_core_media.c:4440 Set 2833 dtmf send payload to 101 2013-10-25 11:22:47.822472 [DEBUG] switch_core_media.c:4446 Set 2833 dtmf receive payload to 101 2013-10-25 11:22:47.822472 [DEBUG] mod_sofia.c:2143 Ring SDP: v=0 o=FreeSWITCH 1382664885 1382664886 IN IP4 91.204.116.116 s=FreeSWITCH c=IN IP4 91.204.116.116 t=0 0 m=audio 28082 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 2013-10-25 11:22:47.822472 [NOTICE] mod_sofia.c:2146 Pre-Answer sofia/external/<nb_caller>@<my_provider>! 2013-10-25 11:22:47.822472 [DEBUG] switch_channel.c:3332 (sofia/external/<nb_caller>@<my_provider>) Callstate Change RINGING -> EARLY 2013-10-25 11:22:47.822472 [DEBUG] switch_core_session.c:865 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:22:47.822472 [DEBUG] switch_ivr_originate.c:3494 Originate Resulted in Success: [sofia/external/<nb_callee>] 2013-10-25 11:22:47.822472 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:22:47.822472 [DEBUG] sofia.c:5834 Channel sofia/external/<nb_caller>@<my_provider> entering state [early][183] 2013-10-25 11:22:47.822472 [DEBUG] switch_core_session.c:865 Send signal sofia/external/<nb_callee> [BREAK] 2013-10-25 11:22:47.822472 [DEBUG] switch_core_session.c:865 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:22:47.822472 [DEBUG] switch_ivr_bridge.c:1440 (sofia/external/<nb_callee>) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA 2013-10-25 11:22:47.822472 [DEBUG] switch_core_session.c:1345 Send signal sofia/external/<nb_callee> [BREAK] 2013-10-25 11:22:47.822472 [DEBUG] switch_core_state_machine.c:418 (sofia/external/<nb_callee>) Running State Change CS_EXCHANGE_MEDIA 2013-10-25 11:22:47.822472 [DEBUG] switch_core_state_machine.c:483 (sofia/external/<nb_callee>) State EXCHANGE_MEDIA 2013-10-25 11:22:47.822472 [DEBUG] mod_sofia.c:644 SOFIA EXCHANGE_MEDIA 2013-10-25 11:22:55.972482 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_callee> [BREAK] 2013-10-25 11:22:55.972482 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_callee> [BREAK] 2013-10-25 11:22:55.992491 [DEBUG] sofia.c:5834 Channel sofia/external/<nb_callee> entering state [completing][200] 2013-10-25 11:22:55.992491 [DEBUG] sofia.c:5841 Duplicate SDP v=0 o=cp10 138269296200 138269296201 IN IP4 10.7.1.133 s=SIP Call c=IN IP4 91.121.128.146 t=0 0 m=audio 33910 RTP/AVP 0 8 101 b=AS:77 a=rtpmap:0 PCMU/8000/1 a=rtpmap:8 PCMA/8000/1 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 a=ptime:30 2013-10-25 11:22:55.992491 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_callee> [BREAK] 2013-10-25 11:22:55.992491 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_callee> [BREAK] 2013-10-25 11:22:55.992491 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_callee> [BREAK] 2013-10-25 11:22:55.992491 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_callee> [BREAK] 2013-10-25 11:22:55.992491 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_callee> [BREAK] 2013-10-25 11:22:56.012473 [DEBUG] sofia.c:5834 Channel sofia/external/<nb_callee> entering state [ready][200] 2013-10-25 11:22:56.012473 [DEBUG] switch_channel.c:3567 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:22:56.012473 [NOTICE] sofia.c:6526 Channel [sofia/external/<nb_callee>] has been answered 2013-10-25 11:22:56.012473 [DEBUG] switch_channel.c:3613 (sofia/external/<nb_callee>) Callstate Change EARLY -> ACTIVE 2013-10-25 11:22:56.012473 [DEBUG] sofia.c:5834 Channel sofia/external/<nb_callee> entering state [ready][200] 2013-10-25 11:22:56.012473 [DEBUG] sofia.c:5844 Remote SDP: v=0 o=cp10 138269296200 138269296202 IN IP4 10.7.1.133 s=SIP Call c=IN IP4 91.121.128.146 t=0 0 m=audio 33910 RTP/AVP 0 8 101 b=AS:77 a=rtpmap:0 PCMU/8000/1 a=rtpmap:8 PCMA/8000/1 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 a=ptime:30 2013-10-25 11:22:56.012473 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [PCMU:0:8000:30:64000]/[PCMA:8:8000:20:64000] 2013-10-25 11:22:56.012473 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [PCMA:8:8000:30:64000]/[PCMA:8:8000:20:64000] 2013-10-25 11:22:56.012473 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [telephone-event:101:8000:30:0]/[PCMA:8:8000:20:64000] 2013-10-25 11:22:56.012473 [DEBUG] switch_core_media.c:2961 Substituting codec PCMA@30i@8000h 2013-10-25 11:22:56.012473 [DEBUG] switch_core_media.c:1822 Changing Codec from PCMA@20ms@8000hz to PCMA@30ms@8000hz 2013-10-25 11:22:56.032474 [DEBUG] mod_sofia.c:824 Local SDP sofia/external/<nb_caller>@<my_provider>: v=0 o=FreeSWITCH 1382664885 1382664887 IN IP4 91.204.116.116 s=FreeSWITCH c=IN IP4 91.204.116.116 t=0 0 m=audio 28082 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 2013-10-25 11:22:56.032474 [DEBUG] switch_core_session.c:865 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:22:56.032474 [NOTICE] switch_ivr_bridge.c:484 Channel [sofia/external/<nb_caller>@<my_provider>] has been answered 2013-10-25 11:22:56.032474 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:22:56.032474 [DEBUG] switch_channel.c:3613 (sofia/external/<nb_caller>@<my_provider>) Callstate Change EARLY -> ACTIVE 2013-10-25 11:22:56.032474 [DEBUG] sofia.c:5834 Channel sofia/external/<nb_caller>@<my_provider> entering state [completed][200] 2013-10-25 11:22:56.032474 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:22:56.032474 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:22:56.032474 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:22:56.052478 [DEBUG] sofia.c:5834 Channel sofia/external/<nb_caller>@<my_provider> entering state [ready][200] 2013-10-25 11:22:56.052478 [DEBUG] switch_core_session.c:927 Send signal sofia/external/<nb_callee> [BREAK] 2013-10-25 11:22:56.052478 [DEBUG] switch_core_session.c:927 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:22:56.052478 [DEBUG] switch_rtp.c:2764 RE-Starting timer [soft] 240 bytes per 30ms 2013-10-25 11:22:56.052478 [DEBUG] switch_core_media.c:1913 Set Codec sofia/external/<nb_callee> PCMA/8000 30 ms 240 samples 64000 bits 2013-10-25 11:22:56.052478 [DEBUG] switch_core_codec.c:123 sofia/external/<nb_callee> Original read codec replaced with PCMA:8 2013-10-25 11:22:56.052478 [DEBUG] switch_core_media.c:3042 Set 2833 dtmf send payload to 101 2013-10-25 11:22:56.052478 [DEBUG] sofia.c:6429 Processing updated SDP 2013-10-25 11:22:56.052478 [DEBUG] switch_core_media.c:4068 Audio params are unchanged for sofia/external/<nb_callee>. 2013-10-25 11:22:56.052478 [DEBUG] switch_core_media.c:4078 sofia/external/<nb_callee> Setting audio receive payload in Re-INVITE to 8 2013-10-25 11:22:56.052478 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:22:56.052478 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:22:56.052478 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:22:56.072495 [DEBUG] sofia.c:5834 Channel sofia/external/<nb_caller>@<my_provider> entering state [ready][200] 2013-10-25 11:22:56.072495 [DEBUG] sofia.c:5844 Remote SDP: v=0 o=cp10 138269296293 138269296295 IN IP4 10.7.1.129 s=SIP Call c=IN IP4 91.121.128.144 t=0 0 m=audio 38132 RTP/AVP 8 101 b=AS:77 a=rtpmap:8 PCMA/8000/1 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 a=ptime:30 2013-10-25 11:22:56.072495 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [PCMA:8:8000:30:64000]/[PCMA:8:8000:20:64000] 2013-10-25 11:22:56.072495 [DEBUG] switch_core_media.c:2880 Audio Codec Compare [telephone-event:101:8000:30:0]/[PCMA:8:8000:20:64000] 2013-10-25 11:22:56.072495 [DEBUG] switch_core_media.c:2961 Substituting codec PCMA@30i@8000h 2013-10-25 11:22:56.072495 [DEBUG] switch_core_media.c:1822 Changing Codec from PCMA@20ms@8000hz to PCMA@30ms@8000hz 2013-10-25 11:22:56.112493 [DEBUG] switch_rtp.c:2764 RE-Starting timer [soft] 240 bytes per 30ms 2013-10-25 11:22:56.112493 [DEBUG] switch_core_media.c:1913 Set Codec sofia/external/<nb_caller>@<my_provider> PCMA/8000 30 ms 240 samples 64000 bits 2013-10-25 11:22:56.112493 [DEBUG] switch_core_codec.c:123 sofia/external/<nb_caller>@<my_provider> Original read codec replaced with PCMA:8 2013-10-25 11:22:56.112493 [DEBUG] switch_core_media.c:3051 Set 2833 dtmf send/recv payload to 101 2013-10-25 11:22:56.112493 [DEBUG] sofia.c:6429 Processing updated SDP 2013-10-25 11:22:56.112493 [DEBUG] switch_core_media.c:4068 Audio params are unchanged for sofia/external/<nb_caller>@<my_provider>. 2013-10-25 11:22:56.112493 [DEBUG] switch_core_media.c:4078 sofia/external/<nb_caller>@<my_provider> Setting audio receive payload in Re-INVITE to 8 2013-10-25 11:23:11.432467 [DEBUG] switch_core_session.c:1010 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:23:11.462472 [NOTICE] sofia.c:715 Hangup sofia/external/<nb_caller>@<my_provider> [CS_EXECUTE] [NORMAL_CLEARING] 2013-10-25 11:23:11.462472 [DEBUG] switch_channel.c:3139 Send signal sofia/external/<nb_caller>@<my_provider> [KILL] 2013-10-25 11:23:11.462472 [DEBUG] switch_core_session.c:1345 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:23:11.462472 [DEBUG] switch_ivr_bridge.c:647 BRIDGE THREAD DONE [sofia/external/<nb_caller>@<my_provider>] 2013-10-25 11:23:11.462472 [DEBUG] switch_ivr_bridge.c:672 Send signal sofia/external/<nb_callee> [BREAK] 2013-10-25 11:23:11.492469 [DEBUG] switch_ivr_bridge.c:647 BRIDGE THREAD DONE [sofia/external/<nb_callee>] 2013-10-25 11:23:11.492469 [DEBUG] switch_ivr_bridge.c:672 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:23:11.492469 [NOTICE] switch_ivr_bridge.c:735 Hangup sofia/external/<nb_callee> [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING] 2013-10-25 11:23:11.492469 [DEBUG] switch_channel.c:3139 Send signal sofia/external/<nb_callee> [KILL] 2013-10-25 11:23:11.492469 [DEBUG] switch_core_session.c:1345 Send signal sofia/external/<nb_callee> [BREAK] 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:483 (sofia/external/<nb_callee>) State EXCHANGE_MEDIA going to sleep 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:418 (sofia/external/<nb_callee>) Running State Change CS_HANGUP 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:681 (sofia/external/<nb_callee>) State HANGUP 2013-10-25 11:23:11.492469 [DEBUG] mod_sofia.c:459 sofia/external/<nb_callee> Overriding SIP cause 480 with 200 from the other leg 2013-10-25 11:23:11.492469 [DEBUG] mod_sofia.c:465 Channel sofia/external/<nb_callee> hanging up, cause: NORMAL_CLEARING 2013-10-25 11:23:11.492469 [DEBUG] mod_sofia.c:517 Sending BYE to sofia/external/<nb_callee> 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:48 sofia/external/<nb_callee> Standard HANGUP, cause: NORMAL_CLEARING 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:681 (sofia/external/<nb_callee>) State HANGUP going to sleep 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:694 (sofia/external/<nb_callee>) Callstate Change ACTIVE -> HANGUP 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:449 (sofia/external/<nb_callee>) State Change CS_HANGUP -> CS_REPORTING 2013-10-25 11:23:11.492469 [DEBUG] switch_core_session.c:1345 Send signal sofia/external/<nb_callee> [BREAK] 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:418 (sofia/external/<nb_callee>) Running State Change CS_REPORTING 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:766 (sofia/external/<nb_callee>) State REPORTING 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:92 sofia/external/<nb_callee> Standard REPORTING, cause: NORMAL_CLEARING 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:766 (sofia/external/<nb_callee>) State REPORTING going to sleep 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:443 (sofia/external/<nb_callee>) State Change CS_REPORTING -> CS_DESTROY 2013-10-25 11:23:11.492469 [DEBUG] switch_core_session.c:1345 Send signal sofia/external/<nb_callee> [BREAK] 2013-10-25 11:23:11.492469 [DEBUG] switch_core_session.c:1553 Session 605 (sofia/external/<nb_callee>) Locked, Waiting on external entities 2013-10-25 11:23:11.492469 [DEBUG] switch_ivr_bridge.c:1541 sofia/external/<nb_caller>@<my_provider> skip receive message [UNBRIDGE] (channel is hungup already) 2013-10-25 11:23:11.492469 [NOTICE] switch_core_session.c:1571 Session 605 (sofia/external/<nb_callee>) Ended 2013-10-25 11:23:11.492469 [NOTICE] switch_core_session.c:1575 Close Channel sofia/external/<nb_callee> [CS_DESTROY] 2013-10-25 11:23:11.492469 [DEBUG] switch_core_session.c:2814 sofia/external/<nb_caller>@<my_provider> skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already) 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:480 (sofia/external/<nb_caller>@<my_provider>) State EXECUTE going to sleep 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:418 (sofia/external/<nb_caller>@<my_provider>) Running State Change CS_HANGUP 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:681 (sofia/external/<nb_caller>@<my_provider>) State HANGUP 2013-10-25 11:23:11.492469 [DEBUG] mod_sofia.c:465 Channel sofia/external/<nb_caller>@<my_provider> hanging up, cause: NORMAL_CLEARING 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:48 sofia/external/<nb_caller>@<my_provider> Standard HANGUP, cause: NORMAL_CLEARING 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:681 (sofia/external/<nb_caller>@<my_provider>) State HANGUP going to sleep 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:568 (sofia/external/<nb_callee>) Callstate Change HANGUP -> DOWN 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:694 (sofia/external/<nb_caller>@<my_provider>) Callstate Change ACTIVE -> HANGUP 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:449 (sofia/external/<nb_caller>@<my_provider>) State Change CS_HANGUP -> CS_REPORTING 2013-10-25 11:23:11.492469 [DEBUG] switch_core_session.c:1345 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:418 (sofia/external/<nb_caller>@<my_provider>) Running State Change CS_REPORTING 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:571 (sofia/external/<nb_callee>) Running State Change CS_DESTROY 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:766 (sofia/external/<nb_caller>@<my_provider>) State REPORTING 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:581 (sofia/external/<nb_callee>) State DESTROY 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:92 sofia/external/<nb_caller>@<my_provider> Standard REPORTING, cause: NORMAL_CLEARING 2013-10-25 11:23:11.492469 [DEBUG] mod_sofia.c:375 sofia/external/<nb_callee> SOFIA DESTROY 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:766 (sofia/external/<nb_caller>@<my_provider>) State REPORTING going to sleep 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:99 sofia/external/<nb_callee> Standard DESTROY 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:581 (sofia/external/<nb_callee>) State DESTROY going to sleep 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:443 (sofia/external/<nb_caller>@<my_provider>) State Change CS_REPORTING -> CS_DESTROY 2013-10-25 11:23:11.492469 [DEBUG] switch_core_session.c:1345 Send signal sofia/external/<nb_caller>@<my_provider> [BREAK] 2013-10-25 11:23:11.492469 [DEBUG] switch_core_session.c:1553 Session 604 (sofia/external/<nb_caller>@<my_provider>) Locked, Waiting on external entities 2013-10-25 11:23:11.492469 [NOTICE] switch_core_session.c:1571 Session 604 (sofia/external/<nb_caller>@<my_provider>) Ended 2013-10-25 11:23:11.492469 [NOTICE] switch_core_session.c:1575 Close Channel sofia/external/<nb_caller>@<my_provider> [CS_DESTROY] 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:568 (sofia/external/<nb_caller>@<my_provider>) Callstate Change HANGUP -> DOWN 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:571 (sofia/external/<nb_caller>@<my_provider>) Running State Change CS_DESTROY 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:581 (sofia/external/<nb_caller>@<my_provider>) State DESTROY 2013-10-25 11:23:11.492469 [DEBUG] mod_sofia.c:375 sofia/external/<nb_caller>@<my_provider> SOFIA DESTROY 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:99 sofia/external/<nb_caller>@<my_provider> Standard DESTROY 2013-10-25 11:23:11.492469 [DEBUG] switch_core_state_machine.c:581 (sofia/external/<nb_caller>@<my_provider>) State DESTROY going to sleep
If someone understand what happens... Thanks in advance... Obbyone -- View this message in context: http://freeswitch-users.2379917.n2.nabble.com/Sound-issue-on-bridging-one-in... Sent from the freeswitch-users mailing list archive at Nabble.com.
participants (2)
-
Mimiko
-
obbyone