[Freeswitch-users] No Audio

Anton Kvashenkin anton.jugatsu at gmail.com
Sat Apr 28 12:02:39 MSD 2012


What do use for PSTN termination? VOIP-gateway or just sip trunk? Show your
dialplan for outgoing to PSTN.

28 апреля 2012 г. 0:29 пользователь Alfred Ahuta <aahuta at gmail.com> написал:

> I'm experiencing No Audio when i call pstn from an extension mapped to
> X-lite. internal sip endpoints i'm able to establish 2 way audio
> but not when i call out. i'm able to establish connection without the
> audio though.
>
> below is my debug log
> 2012-04-27 12:57:13.533748 [DEBUG] sofia_glue.c:4918 Audio Codec Compare
> [PCMU:0:8000:20:64000]/[PCMU:0:8000:20:64000]
> 2012-04-27 12:57:13.533748 [DEBUG] sofia_glue.c:3017 Set Codec
> sofia/external/18178455922 PCMU/8000 20 ms 160 samples 64000 bits
> 2012-04-27 12:57:13.533748 [DEBUG] switch_core_codec.c:111
> sofia/external/18178455922 Original read codec set to PCMU:0
> 2012-04-27 12:57:13.533748 [DEBUG] sofia_glue.c:5032 Set 2833 dtmf send
> payload to 101
> 2012-04-27 12:57:13.533748 [DEBUG] sofia_glue.c:3269 AUDIO RTP
> [sofia/external/18178455922] XX.XXX.XX.149 port 26586 -> 67.215.226.150
> port 19474 codec: 0 ms: 20
> 2012-04-27 12:57:13.533748 [DEBUG] switch_rtp.c:1661 Starting timer [soft]
> 160 bytes per 20ms
> 2012-04-27 12:57:13.533748 [DEBUG] sofia_glue.c:3533 Set 2833 dtmf send
> payload to 101
> 2012-04-27 12:57:13.533748 [DEBUG] sofia_glue.c:3539 Set 2833 dtmf receive
> payload to 101
> 2012-04-27 12:57:13.533748 [NOTICE] sofia_glue.c:4063 Pre-Answer
> sofia/external/18178455922!
> 2012-04-27 12:57:13.533748 [DEBUG] switch_channel.c:2986
> (sofia/external/18178455922) Callstate Change RINGING -> EARLY
> 2012-04-27 12:57:13.533748 [INFO] switch_ivr_originate.c:3215 Sending
> early media
> 2012-04-27 12:57:13.533748 [DEBUG] sofia_glue.c:3269 AUDIO RTP
> [sofia/internal/1000 at XX.XXX.XX.149:5080] XX.XXX.XX.149 port 22578 ->
> 76.187.91.204 port 40032 codec: 0 ms: 20
> 2012-04-27 12:57:13.533748 [DEBUG] switch_rtp.c:1661 Starting timer [soft]
> 160 bytes per 20ms
> 2012-04-27 12:57:13.553797 [DEBUG] sofia_glue.c:3533 Set 2833 dtmf send
> payload to 101
> 2012-04-27 12:57:13.553797 [DEBUG] sofia_glue.c:3539 Set 2833 dtmf receive
> payload to 101
> 2012-04-27 12:57:13.553797 [DEBUG] mod_sofia.c:2582 Ring SDP:
> v=0
> o=FreeSWITCH 1335523255 1335523256 IN IP4 XX.XXX.XX.149
> s=FreeSWITCH
> c=IN IP4 XX.XXX.XX.149
> t=0 0
> m=audio 22578 RTP/AVP 0 101
> a=rtpmap:0 PCMU/8000
> a=rtpmap:101 telephone-event/8000
> a=fmtp:101 0-16
> a=silenceSupp:off - - - -
> a=ptime:20
> a=sendrecv
>
> o=root 2889 2889 IN IP4 67.215.226.150
> s=session
> c=IN IP4 67.215.226.150
> t=0 0
> m=audio 12116 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=ptime:20
>
>
>
>
>
>
> 2012-04-27 12:57:13.553797 [NOTICE] mod_sofia.c:2585 Pre-Answer
> sofia/internal/1000 at XX.XXX.XX.149:5080!
> 2012-04-27 12:57:13.553797 [DEBUG] switch_channel.c:2986
> (sofia/internal/1000 at XX.XXX.XX.149:5080) Callstate Change RINGING -> EARLY
> 2012-04-27 12:57:13.553797 [DEBUG] switch_channel.c:3028 Send signal
> sofia/internal/1000 at XX.XXX.XX.149:5080 [BREAK]
> 2012-04-27 12:57:13.553797 [DEBUG] switch_core_session.c:877 Send signal
> sofia/internal/1000 at XX.XXX.XX.149:5080 [BREAK]
> 2012-04-27 12:57:13.553797 [DEBUG] sofia.c:5554 Channel
> sofia/internal/1000 at XX.XXX.XX.149:5080 skipping state [early][183]
> 2012-04-27 12:57:13.553797 [DEBUG] switch_core_session.c:731 Send signal
> sofia/internal/1000 at XX.XXX.XX.149:5080 [BREAK]
> 2012-04-27 12:57:13.553797 [DEBUG] switch_ivr_originate.c:3266 Originate
> Resulted in Success: [sofia/external/18178455922]
> 2012-04-27 12:57:13.573784 [DEBUG] switch_core_session.c:731 Send signal
> sofia/external/18178455922 [BREAK]
> 2012-04-27 12:57:13.573784 [DEBUG] switch_core_session.c:731 Send signal
> sofia/internal/1000 at XX.XXX.XX.149:5080 [BREAK]
> 2012-04-27 12:57:13.573784 [DEBUG] switch_ivr_bridge.c:1331
> (sofia/external/18178455922) State Change CS_CONSUME_MEDIA ->
> CS_EXCHANGE_MEDIA
> 2012-04-27 12:57:13.573784 [DEBUG] switch_core_state_machine.c:362
> (sofia/external/18178455922) Running State Change CS_EXCHANGE_MEDIA
> 2012-04-27 12:57:13.573784 [DEBUG] switch_core_session.c:1182 Send signal
> sofia/external/18178455922 [BREAK]
> 2012-04-27 12:57:13.573784 [DEBUG] switch_core_state_machine.c:420
> (sofia/external/18178455922) State EXCHANGE_MEDIA
> 2012-04-27 12:57:13.573784 [DEBUG] mod_sofia.c:582 SOFIA EXCHANGE_MEDIA
> 2012-04-27 12:57:17.493751 [DEBUG] switch_core_session.c:877 Send signal
> sofia/external/18178455922 [BREAK]
> 2012-04-27 12:57:17.493751 [DEBUG] switch_core_session.c:877 Send signal
> sofia/external/18178455922 [BREAK]
> 2012-04-27 12:57:17.513750 [DEBUG] sofia.c:5561 Channel
> sofia/external/18178455922 entering state [completing][200]
> 2012-04-27 12:57:17.513750 [DEBUG] sofia.c:5572 Remote SDP:
> v=0
> o=root 2889 2890 IN IP4 67.215.226.150
> s=session
> c=IN IP4 67.215.226.150
> t=0 0
> m=audio 19474 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=ptime:20
>
> 2012-04-27 12:57:17.513750 [DEBUG] switch_core_session.c:877 Send signal
> sofia/external/18178455922 [BREAK]
> 2012-04-27 12:57:17.513750 [DEBUG] switch_core_session.c:877 Send signal
> sofia/external/18178455922 [BREAK]
> 2012-04-27 12:57:17.513750 [DEBUG] sofia.c:5561 Channel
> sofia/external/18178455922 entering state [ready][200]
> 2012-04-27 12:57:17.513750 [DEBUG] switch_channel.c:3245
> (sofia/external/18178455922) Callstate Change EARLY -> ACTIVE
> 2012-04-27 12:57:17.513750 [DEBUG] switch_channel.c:3257 Send signal
> sofia/internal/1000 at XX.XXX.XX.149:5080 [BREAK]
> 2012-04-27 12:57:17.513750 [NOTICE] sofia.c:6214 Channel
> [sofia/external/18178455922] has been answered
> 2012-04-27 12:57:17.533751 [DEBUG] mod_sofia.c:754 Local SDP
> sofia/internal/1000 at XX.XXX.XX.149:5080:
> v=0
> o=FreeSWITCH 1335523255 1335523257 IN IP4 XX.XXX.XX.149
> s=FreeSWITCH
> c=IN IP4 XX.XXX.XX.149
> t=0 0
> m=audio 22578 RTP/AVP 0 101
> a=rtpmap:0 PCMU/8000
> a=rtpmap:101 telephone-event/8000
> a=fmtp:101 0-16
> a=silenceSupp:off - - - -
> a=ptime:20
> a=sendrecv
>
> 2012-04-27 12:57:17.533751 [DEBUG] switch_core_session.c:877 Send signal
> sofia/internal/1000 at XX.XXX.XX.149:5080 [BREAK]
> 2012-04-27 12:57:17.533751 [DEBUG] sofia.c:5561 Channel
> sofia/internal/1000 at XX.XXX.XX.149:5080 entering state [completed][200]
> 2012-04-27 12:57:17.533751 [DEBUG] switch_core_session.c:731 Send signal
> sofia/internal/1000 at XX.XXX.XX.149:5080 [BREAK]
> 2012-04-27 12:57:17.533751 [DEBUG] switch_channel.c:3245
> (sofia/internal/1000 at XX.XXX.XX.149:5080) Callstate Change EARLY -> ACTIVE
> 2012-04-27 12:57:17.533751 [NOTICE] switch_ivr_bridge.c:417 Channel
> [sofia/internal/1000 at XX.XXX.XX.149:5080] has been answered
> 2012-04-27 12:57:17.693753 [DEBUG] switch_core_session.c:877 Send signal
> sofia/internal/1000 at XX.XXX.XX.149:5080 [BREAK]
> 2012-04-27 12:57:17.693753 [DEBUG] switch_core_session.c:877 Send signal
> sofia/internal/1000 at XX.XXX.XX.149:5080 [BREAK]
> 2012-04-27 12:57:17.693753 [DEBUG] switch_core_session.c:877 Send signal
> sofia/internal/1000 at XX.XXX.XX.149:5080 [BREAK]
> 2012-04-27 12:57:17.713754 [DEBUG] sofia.c:5561 Channel
> sofia/internal/1000 at XX.XXX.XX.149:5080 entering state [ready][200]
> 2012-04-27 12:57:17.713754 [DEBUG] switch_core_session.c:793 Send signal
> sofia/external/18178455922 [BREAK]
> 2012-04-27 12:57:17.713754 [DEBUG] switch_core_session.c:793 Send signal
> sofia/internal/1000 at XX.XXX.XX.149:5080 [BREAK]
> 2012-04-27 12:57:24.913748 [DEBUG] switch_core_session.c:877 Send signal
> sofia/external/18178455922 [BREAK]
> 2012-04-27 12:57:24.933750 [DEBUG] switch_channel.c:2849
> (sofia/external/18178455922) Callstate Change ACTIVE -> HANGUP
> 2012-04-27 12:57:24.933750 [NOTICE] sofia.c:636 Hangup
> sofia/external/18178455922 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
> 2012-04-27 12:57:24.933750 [DEBUG] switch_channel.c:2872 Send signal
> sofia/external/18178455922 [KILL]
> 2012-04-27 12:57:24.933750 [DEBUG] switch_core_session.c:1182 Send signal
> sofia/external/18178455922 [BREAK]
> 2012-04-27 12:57:24.933750 [DEBUG] switch_ivr_bridge.c:586 BRIDGE THREAD
> DONE [sofia/external/18178455922]
> 2012-04-27 12:57:24.933750 [DEBUG] switch_ivr_bridge.c:611 Send signal
> sofia/internal/1000 at XX.XXX.XX.149:5080 [BREAK]
> 2012-04-27 12:57:24.933750 [DEBUG] switch_core_state_machine.c:420
> (sofia/external/18178455922) State EXCHANGE_MEDIA going to sleep
> 2012-04-27 12:57:24.933750 [DEBUG] switch_core_state_machine.c:362
> (sofia/external/18178455922) Running State Change CS_HANGUP
> 2012-04-27 12:57:24.933750 [DEBUG] switch_core_state_machine.c:602
> (sofia/external/18178455922) State HANGUP
> 2012-04-27 12:57:24.933750 [DEBUG] mod_sofia.c:469 Channel
> sofia/external/18178455922 hanging up, cause: NORMAL_CLEARING
> 2012-04-27 12:57:24.933750 [DEBUG] switch_core_state_machine.c:47
> sofia/external/18178455922 Standard HANGUP, cause: NORMAL_CLEARING
> 2012-04-27 12:57:24.933750 [DEBUG] switch_core_state_machine.c:602
> (sofia/external/18178455922) State HANGUP going to sleep
> 2012-04-27 12:57:24.933750 [DEBUG] switch_core_state_machine.c:393
> (sofia/external/18178455922) State Change CS_HANGUP -> CS_REPORTING
> 2012-04-27 12:57:24.933750 [DEBUG] switch_core_session.c:1182 Send signal
> sofia/external/18178455922 [BREAK]
> 2012-04-27 12:57:24.933750 [DEBUG] switch_core_state_machine.c:362
> (sofia/external/18178455922) Running State Change CS_REPORTING
> 2012-04-27 12:57:24.933750 [DEBUG] switch_core_state_machine.c:662
> (sofia/external/18178455922) State REPORTING
> 2012-04-27 12:57:24.933750 [DEBUG] switch_core_state_machine.c:79
> sofia/external/18178455922 Standard REPORTING, cause: NORMAL_CLEARING
> 2012-04-27 12:57:24.933750 [DEBUG] switch_core_state_machine.c:662
> (sofia/external/18178455922) State REPORTING going to sleep
> 2012-04-27 12:57:24.933750 [DEBUG] switch_core_state_machine.c:387
> (sofia/external/18178455922) State Change CS_REPORTING -> CS_DESTROY
> 2012-04-27 12:57:24.933750 [DEBUG] switch_core_session.c:1182 Send signal
> sofia/external/18178455922 [BREAK]
> 2012-04-27 12:57:24.933750 [DEBUG] switch_core_session.c:1382 Session 205
> (sofia/external/18178455922) Locked, Waiting on external entities
> 2012-04-27 12:57:24.954657 [DEBUG] switch_ivr_bridge.c:586 BRIDGE THREAD
> DONE [sofia/internal/1000 at XX.XXX.XX.149:5080]
> 2012-04-27 12:57:24.954657 [DEBUG] switch_ivr_bridge.c:611 Send signal
> sofia/external/18178455922 [BREAK]
> 2012-04-27 12:57:24.954657 [DEBUG] switch_core_session.c:731 Send signal
> sofia/internal/1000 at XX.XXX.XX.149:5080 [BREAK]
> 2012-04-27 12:57:24.954657 [NOTICE] switch_core_state_machine.c:226
> sofia/internal/1000 at XX.XXX.XX.149:5080 has executed the last dialplan
> instruction, hanging up.
> 2012-04-27 12:57:24.954657 [DEBUG] switch_channel.c:2849
> (sofia/internal/1000 at XX.XXX.XX.149:5080) Callstate Change ACTIVE -> HANGUP
> 2012-04-27 12:57:24.954657 [NOTICE] switch_core_state_machine.c:228 Hangup
> sofia/internal/1000 at XX.XXX.XX.149:5080 [CS_EXECUTE] [NORMAL_CLEARING]
> 2012-04-27 12:57:24.954657 [DEBUG] switch_channel.c:2872 Send signal
> sofia/internal/1000 at XX.XXX.XX.149:5080 [KILL]
> 2012-04-27 12:57:24.954657 [DEBUG] switch_core_session.c:1182 Send signal
> sofia/internal/1000 at XX.XXX.XX.149:5080 [BREAK]
> 2012-04-27 12:57:24.954657 [DEBUG] switch_core_state_machine.c:417
> (sofia/internal/1000 at XX.XXX.XX.149:5080) State EXECUTE going to sleep
> 2012-04-27 12:57:24.954657 [DEBUG] switch_core_state_machine.c:362
> (sofia/internal/1000 at XX.XXX.XX.149:5080) Running State Change CS_HANGUP
> 2012-04-27 12:57:24.954657 [DEBUG] switch_core_state_machine.c:602
> (sofia/internal/1000 at XX.XXX.XX.149:5080) State HANGUP
> 2012-04-27 12:57:24.954657 [DEBUG] mod_sofia.c:463
> sofia/internal/1000 at XX.XXX.XX.149:5080 Overriding SIP cause 480 with 200
> from the other leg
> 2012-04-27 12:57:24.954657 [DEBUG] mod_sofia.c:469 Channel
> sofia/internal/1000 at XX.XXX.XX.149:5080 hanging up, cause: NORMAL_CLEARING
> 2012-04-27 12:57:24.954657 [DEBUG] mod_sofia.c:517 Sending BYE to
> sofia/internal/1000 at XX.XXX.XX.149:5080
> 2012-04-27 12:57:24.954657 [NOTICE] switch_core_session.c:1400 Session 205
> (sofia/external/18178455922) Ended
> 2012-04-27 12:57:24.954657 [NOTICE] switch_core_session.c:1402 Close
> Channel sofia/external/18178455922 [CS_DESTROY]
> 2012-04-27 12:57:24.954657 [DEBUG] switch_core_state_machine.c:491
> (sofia/external/18178455922) Callstate Change HANGUP -> DOWN
> 2012-04-27 12:57:24.954657 [DEBUG] switch_core_state_machine.c:494
> (sofia/external/18178455922) Running State Change CS_DESTROY
> 2012-04-27 12:57:24.954657 [DEBUG] switch_core_state_machine.c:504
> (sofia/external/18178455922) State DESTROY
> 2012-04-27 12:57:24.954657 [DEBUG] mod_sofia.c:374
> sofia/external/18178455922 SOFIA DESTROY
> 2012-04-27 12:57:24.954657 [DEBUG] switch_core_state_machine.c:86
> sofia/external/18178455922 Standard DESTROY
> 2012-04-27 12:57:24.954657 [DEBUG] switch_core_state_machine.c:504
> (sofia/external/18178455922) State DESTROY going to sleep
> 2012-04-27 12:57:24.973781 [DEBUG] switch_core_state_machine.c:47
> sofia/internal/1000 at XX.XXX.XX.149:5080 Standard HANGUP, cause:
> NORMAL_CLEARING
> 2012-04-27 12:57:24.973781 [DEBUG] switch_core_state_machine.c:602
> (sofia/internal/1000 at XX.XXX.XX.149:5080) State HANGUP going to sleep
> 2012-04-27 12:57:24.973781 [DEBUG] switch_core_state_machine.c:393
> (sofia/internal/1000 at XX.XXX.XX.149:5080) State Change CS_HANGUP ->
> CS_REPORTING
> 2012-04-27 12:57:24.973781 [DEBUG] switch_core_session.c:1182 Send signal
> sofia/internal/1000 at XX.XXX.XX.149:5080 [BREAK]
> 2012-04-27 12:57:24.973781 [DEBUG] switch_core_state_machine.c:362
> (sofia/internal/1000 at XX.XXX.XX.149:5080) Running State Change CS_REPORTING
> 2012-04-27 12:57:24.973781 [DEBUG] switch_core_state_machine.c:662
> (sofia/internal/1000 at XX.XXX.XX.149:5080) State REPORTING
> 2012-04-27 12:57:24.973781 [DEBUG] switch_core_state_machine.c:79
> sofia/internal/1000 at XX.XXX.XX.149:5080 Standard REPORTING, cause:
> NORMAL_CLEARING
> 2012-04-27 12:57:24.973781 [DEBUG] switch_core_state_machine.c:662
> (sofia/internal/1000 at XX.XXX.XX.149:5080) State REPORTING going to sleep
> 2012-04-27 12:57:24.973781 [DEBUG] switch_core_state_machine.c:387
> (sofia/internal/1000 at XX.XXX.XX.149:5080) State Change CS_REPORTING ->
> CS_DESTROY
> 2012-04-27 12:57:24.973781 [DEBUG] switch_core_session.c:1182 Send signal
> sofia/internal/1000 at XX.XXX.XX.149:5080 [BREAK]
> 2012-04-27 12:57:24.973781 [DEBUG] switch_core_session.c:1382 Session 204
> (sofia/internal/1000 at XX.XXX.XX.149:5080) Locked, Waiting on external
> entities
> 2012-04-27 12:57:24.973781 [NOTICE] switch_core_session.c:1400 Session 204
> (sofia/internal/1000 at XX.XXX.XX.149:5080) Ended
> 2012-04-27 12:57:24.995020 [NOTICE] switch_core_session.c:1402 Close
> Channel sofia/internal/1000 at XX.XXX.XX.149:5080 [CS_DESTROY]
> 2012-04-27 12:57:24.995020 [DEBUG] switch_core_state_machine.c:491
> (sofia/internal/1000 at XX.XXX.XX.149:5080) Callstate Change HANGUP -> DOWN
> 2012-04-27 12:57:24.995020 [DEBUG] switch_core_state_machine.c:494
> (sofia/internal/1000 at XX.XXX.XX.149:5080) Running State Change CS_DESTROY
> 2012-04-27 12:57:24.995020 [DEBUG] switch_core_state_machine.c:504
> (sofia/internal/1000 at XX.XXX.XX.149:5080) State DESTROY
> 2012-04-27 12:57:24.995020 [DEBUG] mod_sofia.c:374
> sofia/internal/1000 at XX.XXX.XX.149:5080 SOFIA DESTROY
> 2012-04-27 12:57:24.995020 [DEBUG] switch_core_state_machine.c:86
> sofia/internal/1000 at XX.XXX.XX.149:5080 Standard DESTROY
> 2012-04-27 12:57:24.995020 [DEBUG] switch_core_state_machine.c:504
> (sofia/internal/1000 at XX.XXX.XX.149:5080) State DESTROY going to sleep
>
>
> Alfred
>
>
> _________________________________________________________________________
> Professional FreeSWITCH Consulting Services:
> consulting at freeswitch.org
> http://www.freeswitchsolutions.com
>
> 
> 
>
> Official FreeSWITCH Sites
> http://www.freeswitch.org
> http://wiki.freeswitch.org
> http://www.cluecon.com
>
> 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
>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20120428/ef359c31/attachment-0001.html 


Join us at ClueCon 2011 Aug 9-11, 2011
More information about the FreeSWITCH-users mailing list