[Freeswitch-users] Both phone rang, but no voice

[Adeel Ansari]

Below is the log in debug mode.


==========
freeswitch at gnome> originate sofia/gateway/gizmo1/01160176905074
&bridge(sofia/gateway/gizmo2/01160122263828)
2008-08-21 15:15:54 [NOTICE] switch_channel.c:535 switch_channel_set_name()
New Channel sofia/external/01160176905074
[fdf9aab4-6f50-11dd-8cbb-f7afdd15cc69]
2008-08-21 15:15:54 [DEBUG] mod_sofia.c:2020 sofia_outgoing_channel()
sofia/external/01160176905074 State Change CS_NEW -> CS_INIT
2008-08-21 15:15:54 [DEBUG] switch_core_session.c:727
switch_core_session_signal_state_change() Kill sofia/external/01160176905074
[BREAK]
2008-08-21 15:15:54 [DEBUG] switch_core_state_machine.c:365
switch_core_session_run() sofia/external/01160176905074 Running State Change
CS_INIT
2008-08-21 15:15:54 [DEBUG] switch_core_state_machine.c:415
switch_core_session_run() (sofia/external/01160176905074) State INIT
2008-08-21 15:15:54 [DEBUG] mod_sofia.c:80 sofia_on_init()
sofia/external/01160176905074 SOFIA INIT
2008-08-21 15:15:54 [DEBUG] mod_sofia.c:107 sofia_on_init()
sofia/external/01160176905074 State Change CS_INIT -> CS_ROUTING
2008-08-21 15:15:54 [DEBUG] switch_core_session.c:727
switch_core_session_signal_state_change() Kill sofia/external/01160176905074
[BREAK]
2008-08-21 15:15:54 [DEBUG] switch_core_state_machine.c:415
switch_core_session_run() (sofia/external/01160176905074) State INIT going
to sleep
2008-08-21 15:15:54 [DEBUG] switch_core_state_machine.c:365
switch_core_session_run() sofia/external/01160176905074 Running State Change
CS_ROUTING
2008-08-21 15:15:54 [DEBUG] switch_core_state_machine.c:420
switch_core_session_run() (sofia/external/01160176905074) State ROUTING
2008-08-21 15:15:54 [DEBUG] mod_sofia.c:119 sofia_on_routing()
sofia/external/01160176905074 SOFIA ROUTING
2008-08-21 15:15:54 [DEBUG] switch_ivr_originate.c:57 originate_on_routing()
sofia/external/01160176905074 State Change CS_ROUTING -> CS_CONSUME_MEDIA
2008-08-21 15:15:54 [DEBUG] switch_core_session.c:727
switch_core_session_signal_state_change() Kill sofia/external/01160176905074
[BREAK]
2008-08-21 15:15:54 [DEBUG] switch_core_state_machine.c:420
switch_core_session_run() (sofia/external/01160176905074) State ROUTING
going to sleep
2008-08-21 15:15:54 [DEBUG] switch_core_state_machine.c:365
switch_core_session_run() sofia/external/01160176905074 Running State Change
CS_CONSUME_MEDIA
2008-08-21 15:15:54 [DEBUG] switch_core_state_machine.c:442
switch_core_session_run() (sofia/external/01160176905074) State
CONSUME_MEDIA
2008-08-21 15:15:54 [DEBUG] sofia.c:200 sofia_event_callback() event
[nua_i_state] status [0][INVITE sent] session: sofia/external/01160176905074
2008-08-21 15:15:54 [DEBUG] sofia.c:2145 sofia_handle_sip_i_state() Channel
sofia/external/01160176905074 entering state [calling]
2008-08-21 15:15:54 [DEBUG] sofia.c:200 sofia_event_callback() event
[nua_r_invite] status [401][Unauthorized] session:
sofia/external/01160176905074
2008-08-21 15:15:54 [DEBUG] sofia_reg.c:1098
sofia_reg_handle_sip_r_challenge() Authenticating 'FreeSWITCH' with
'Digest:"proxy01.sipphone.com":dasbit102:102'.
2008-08-21 15:15:54 [DEBUG] sofia.c:200 sofia_event_callback() event
[nua_i_state] status [0][INVITE sent] session: sofia/external/01160176905074
2008-08-21 15:15:54 [DEBUG] sofia.c:2145 sofia_handle_sip_i_state() Channel
sofia/external/01160176905074 entering state [calling]
2008-08-21 15:15:56 [DEBUG] sofia.c:2145 sofia_handle_sip_i_state() Channel
sofia/external/01160176905074 entering state [ready]
2008-08-21 15:15:56 [DEBUG] sofia.c:2149 sofia_handle_sip_i_state() Remote
SDP:
v=0
o=root 7709 7709 IN IP4 130.94.88.90
s=session
c=IN IP4 130.94.88.90
t=0 0
m=audio 19672 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -

2008-08-21 15:15:56 [DEBUG] sofia_glue.c:2297 sofia_glue_negotiate_sdp()
Audio Codec Compare [PCMU:0:8000]/[PCMU:0:8000]
2008-08-21 15:15:56 [DEBUG] sofia_glue.c:1547 sofia_glue_tech_set_codec()
Set Codec sofia/external/01160176905074 PCMU/8000 20 ms 160 samples
2008-08-21 15:15:56 [DEBUG] sofia_glue.c:2260 sofia_glue_negotiate_sdp() Set
2833 dtmf payload to 101
2008-08-21 15:15:56 [DEBUG] sofia_glue.c:1756 sofia_glue_activate_rtp()
AUDIO RTP [sofia/external/01160176905074] 192.168.253.101 port 31444 ->
130.94.88.90 port 19672 codec: 0 ms: 20
2008-08-21 15:15:56 [DEBUG] switch_rtp.c:813 switch_rtp_create() Starting
timer [soft] 160 bytes per 20000ms
2008-08-21 15:15:56 [DEBUG] switch_ivr_originate.c:1370
switch_ivr_originate() Originate Resulted in Success:
[sofia/external/01160176905074]
2008-08-21 15:15:56 [DEBUG] mod_commands.c:1612 originate_function()
sofia/external/01160176905074 State Change CS_CONSUME_MEDIA -> CS_EXECUTE
2008-08-21 15:15:56 [DEBUG] switch_core_session.c:727
switch_core_session_signal_state_change() Kill sofia/external/01160176905074
[BREAK]
2008-08-21 15:15:56 [NOTICE] sofia.c:2507 sofia_handle_sip_i_state() Channel
[sofia/external/01160176905074] has been answered
API CALL [originate(sofia/gateway/gizmo1/01160176905074
&bridge(sofia/gateway/gizmo2/01160122263828))] output:
+OK fdf9aab4-6f50-11dd-8cbb-f7afdd15cc69

freeswitch at gnome> 2008-08-21 15:15:56 [DEBUG]
switch_core_state_machine.c:442 switch_core_session_run()
(sofia/external/01160176905074) State CONSUME_MEDIA going to sleep
2008-08-21 15:15:56 [DEBUG] switch_core_state_machine.c:365
switch_core_session_run() sofia/external/01160176905074 Running State Change
CS_EXECUTE
2008-08-21 15:15:56 [DEBUG] switch_core_state_machine.c:430
switch_core_session_run() (sofia/external/01160176905074) State EXECUTE
2008-08-21 15:15:56 [DEBUG] mod_sofia.c:156 sofia_on_execute()
sofia/external/01160176905074 SOFIA EXECUTE
2008-08-21 15:15:56 [DEBUG] switch_core_state_machine.c:129
switch_core_standard_on_execute() Standard EXECUTE
2008-08-21 15:15:56 [DEBUG] switch_core_state_machine.c:140
switch_core_standard_on_execute() sofia/external/01160176905074 Execute
bridge(sofia/gateway/gizmo2/01160122263828)
2008-08-21 15:15:56 [NOTICE] switch_channel.c:535 switch_channel_set_name()
New Channel sofia/external/01160122263828
[ff8093e8-6f50-11dd-8cbb-f7afdd15cc69]
2008-08-21 15:15:56 [DEBUG] mod_sofia.c:2020 sofia_outgoing_channel()
sofia/external/01160122263828 State Change CS_NEW -> CS_INIT
2008-08-21 15:15:56 [DEBUG] switch_core_session.c:727
switch_core_session_signal_state_change() Kill sofia/external/01160122263828
[BREAK]
2008-08-21 15:15:56 [DEBUG] switch_core_state_machine.c:365
switch_core_session_run() sofia/external/01160122263828 Running State Change
CS_INIT
2008-08-21 15:15:56 [DEBUG] switch_core_state_machine.c:415
switch_core_session_run() (sofia/external/01160122263828) State INIT
2008-08-21 15:15:56 [DEBUG] mod_sofia.c:80 sofia_on_init()
sofia/external/01160122263828 SOFIA INIT
2008-08-21 15:15:56 [DEBUG] mod_sofia.c:107 sofia_on_init()
sofia/external/01160122263828 State Change CS_INIT -> CS_ROUTING
2008-08-21 15:15:56 [DEBUG] switch_core_session.c:727
switch_core_session_signal_state_change() Kill sofia/external/01160122263828
[BREAK]
2008-08-21 15:15:56 [DEBUG] switch_core_state_machine.c:415
switch_core_session_run() (sofia/external/01160122263828) State INIT going
to sleep
2008-08-21 15:15:56 [DEBUG] switch_core_state_machine.c:365
switch_core_session_run() sofia/external/01160122263828 Running State Change
CS_ROUTING
2008-08-21 15:15:56 [DEBUG] switch_core_state_machine.c:420
switch_core_session_run() (sofia/external/01160122263828) State ROUTING
2008-08-21 15:15:56 [DEBUG] mod_sofia.c:119 sofia_on_routing()
sofia/external/01160122263828 SOFIA ROUTING
2008-08-21 15:15:56 [DEBUG] switch_ivr_originate.c:57 originate_on_routing()
sofia/external/01160122263828 State Change CS_ROUTING -> CS_CONSUME_MEDIA
2008-08-21 15:15:56 [DEBUG] switch_core_session.c:727
switch_core_session_signal_state_change() Kill sofia/external/01160122263828
[BREAK]
2008-08-21 15:15:56 [DEBUG] switch_core_state_machine.c:420
switch_core_session_run() (sofia/external/01160122263828) State ROUTING
going to sleep
2008-08-21 15:15:56 [DEBUG] switch_core_state_machine.c:365
switch_core_session_run() sofia/external/01160122263828 Running State Change
CS_CONSUME_MEDIA
2008-08-21 15:15:56 [DEBUG] switch_core_state_machine.c:442
switch_core_session_run() (sofia/external/01160122263828) State
CONSUME_MEDIA
2008-08-21 15:15:56 [DEBUG] sofia.c:200 sofia_event_callback() event
[nua_i_state] status [0][INVITE sent] session: sofia/external/01160122263828
2008-08-21 15:15:56 [DEBUG] sofia.c:2145 sofia_handle_sip_i_state() Channel
sofia/external/01160122263828 entering state [calling]
2008-08-21 15:15:56 [DEBUG] sofia.c:200 sofia_event_callback() event
[nua_r_invite] status [401][Unauthorized] session:
sofia/external/01160122263828
2008-08-21 15:15:56 [DEBUG] sofia_reg.c:1098
sofia_reg_handle_sip_r_challenge() Authenticating 'FreeSWITCH' with
'Digest:"proxy01.sipphone.com":dasbit103:103'.
2008-08-21 15:15:56 [DEBUG] sofia.c:200 sofia_event_callback() event
[nua_i_state] status [0][INVITE sent] session: sofia/external/01160122263828
2008-08-21 15:15:56 [DEBUG] sofia.c:2145 sofia_handle_sip_i_state() Channel
sofia/external/01160122263828 entering state [calling]
2008-08-21 15:15:58 [DEBUG] sofia.c:2145 sofia_handle_sip_i_state() Channel
sofia/external/01160122263828 entering state [ready]
2008-08-21 15:15:58 [DEBUG] sofia.c:2149 sofia_handle_sip_i_state() Remote
SDP:
v=0
o=root 9902 9902 IN IP4 130.94.88.93
s=session
c=IN IP4 130.94.88.93
t=0 0
m=audio 10116 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -

2008-08-21 15:15:58 [DEBUG] sofia_glue.c:2297 sofia_glue_negotiate_sdp()
Audio Codec Compare [PCMU:0:8000]/[PCMU:0:8000]
2008-08-21 15:15:58 [DEBUG] sofia_glue.c:1547 sofia_glue_tech_set_codec()
Set Codec sofia/external/01160122263828 PCMU/8000 20 ms 160 samples
2008-08-21 15:15:58 [DEBUG] sofia_glue.c:2260 sofia_glue_negotiate_sdp() Set
2833 dtmf payload to 101
2008-08-21 15:15:58 [DEBUG] sofia_glue.c:1756 sofia_glue_activate_rtp()
AUDIO RTP [sofia/external/01160122263828] 192.168.253.101 port 23678 ->
130.94.88.93 port 10116 codec: 0 ms: 20
2008-08-21 15:15:58 [DEBUG] switch_rtp.c:813 switch_rtp_create() Starting
timer [soft] 160 bytes per 20000ms
2008-08-21 15:15:58 [DEBUG] switch_channel.c:1541
switch_channel_perform_mark_answered() Kill sofia/external/01160176905074
[BREAK]
2008-08-21 15:15:58 [NOTICE] sofia.c:2507 sofia_handle_sip_i_state() Channel
[sofia/external/01160122263828] has been answered
2008-08-21 15:15:58 [DEBUG] switch_ivr_originate.c:1370
switch_ivr_originate() Originate Resulted in Success:
[sofia/external/01160122263828]
2008-08-21 15:15:58 [DEBUG] switch_core_session.c:435
switch_core_session_receive_message() Kill sofia/external/01160122263828
[BREAK]
2008-08-21 15:15:58 [DEBUG] switch_core_session.c:435
switch_core_session_receive_message() Kill sofia/external/01160176905074
[BREAK]
2008-08-21 15:15:58 [DEBUG] switch_ivr_bridge.c:778
switch_ivr_multi_threaded_bridge() sofia/external/01160122263828 State
Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
2008-08-21 15:15:58 [DEBUG] switch_core_session.c:727
switch_core_session_signal_state_change() Kill sofia/external/01160122263828
[BREAK]
2008-08-21 15:15:58 [DEBUG] switch_core_state_machine.c:442
switch_core_session_run() (sofia/external/01160122263828) State
CONSUME_MEDIA going to sleep
2008-08-21 15:15:58 [DEBUG] switch_core_state_machine.c:365
switch_core_session_run() sofia/external/01160122263828 Running State Change
CS_EXCHANGE_MEDIA
2008-08-21 15:15:58 [DEBUG] switch_core_state_machine.c:433
switch_core_session_run() (sofia/external/01160122263828) State
EXCHANGE_MEDIA
2008-08-21 15:15:58 [DEBUG] mod_sofia.c:365 sofia_on_exchange_media() SOFIA
LOOPBACK
==========

Thanks.

On Thu, Aug 21, 2008 at 3:07 PM, Jonas Gauffin <jonas.gauffin at gmail.com>wrote:

> Show us logs of a call attempt.
>
> On Thu, Aug 21, 2008 at 8:42 AM, Adeel Ansari <adeel.gnome at gmail.com>
> wrote:
> > 5080 and 5060 both are open. Moreover, other PBX is working fine on 5060.
> >
> > Further, I have tried by setting the parameters sip-ip and rtp-ip to
> auto;
> > ext-sip-ip and ext-sip-ip to my public ip. Nothing is working. Both the
> > phone rang always, but no voice.
> >
> > Anyother suggestions??
> > Thanks.
> >
> > On Thu, Aug 21, 2008 at 1:01 PM, Brian West <brian at freeswitch.org>
> wrote:
> >>
> >> Chech and see if a firewall is on!  Also are you behind nat?
> >> /b
> >>
> >> Sent from my iPhone
> >> On Aug 20, 2008, at 11:27 PM, "Adeel Ansari" <adeel.gnome at gmail.com>
> >> wrote:
> >>
> >> Hi all,
> >>
> >> I have tried the command below,
> >>
> >> ====
> >> originate sofia/gateway/gizmo1/01160176xxxxxx
> >> &bridge(sofia/gateway/gizmo2/01160122xxxxxx)
> >> ====
> >>
> >> Its working, phone rang, but no voice. Am I missing something?
> >>
> >> Thanks.
> >>
> >> --
> >> Best,
> >> Adeel Ansari
> >>
> >> http://www.linkedin.com/in/adeelansari
> >>
> >> _______________________________________________
> >> Freeswitch-users mailing list
> >> Freeswitch-users at lists.freeswitch.org
> >> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
> >> UNSUBSCRIBE:
> http://lists.freeswitch.org/mailman/options/freeswitch-users
> >> http://www.freeswitch.org
> >>
> >> _______________________________________________
> >> Freeswitch-users mailing list
> >> Freeswitch-users at lists.freeswitch.org
> >> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
> >> UNSUBSCRIBE:
> http://lists.freeswitch.org/mailman/options/freeswitch-users
> >> http://www.freeswitch.org
> >>
> >
> >
> >
> > --
> > Best,
> > Adeel Ansari
> >
> > http://www.linkedin.com/in/adeelansari
> >
> > _______________________________________________
> > Freeswitch-users mailing list
> > Freeswitch-users at lists.freeswitch.org
> > http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
> > UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
> > http://www.freeswitch.org
> >
> >
>
> _______________________________________________
> Freeswitch-users mailing list
> Freeswitch-users at lists.freeswitch.org
> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
> http://www.freeswitch.org
>



-- 
Best,
Adeel Ansari

http://www.linkedin.com/in/adeelansari
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20080821/54b77b9b/attachment-0002.html