[Freeswitch-users] RTP to caller not received

Tue Apr 15 22:46:18 MSD 2014

Looks like the user/1000 dialstring is failing to match a registered
endpoint so the bridge fails, and it falls back to voicemail.

On 15 April 2014 19:35, Adelia C. <hexade at hotmail.com> wrote:

> I have a fresh Freeswitch + FusionPBX install, added extension 1000, the
> softphone registeres.
>
> My test call to 9664 has no RTP in the "PBX -> softphone"direction (I
> can't hear the IVR).
> I can see RTP in the reverse direction (the softclient -> PBX).
> I opened all ports/protocols to my softclient IP on the PBX server
> firewall.
>
> I am looking at pcaps on both servers (softclient and PBX) and they are
> similar (RTP to softclient is absent in both).
>
> These are my Freeswitch logs, can you tell what I am doing wrong? I am
> trying to only configure through FusionPBX.
> Thank you!
> A.C.
>
>
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 2014-04-15 10:37:09.803038 [NOTICE]
> switch_ivr_originate.c:2670 Cannot create outgoing channel of type [user]
> cause: [SUBSCRIBER_ABSENT]
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 2014-04-15 10:37:09.803038 [DEBUG]
> switch_ivr_originate.c:3657 Originate Resulted in Error Cause: 20
> [SUBSCRIBER_ABSENT]
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 2014-04-15 10:37:09.803038 [INFO]
> mod_dptools.c:3201 Originate Failed. Cause: SUBSCRIBER_ABSENT
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 EXECUTE sofia/internal/
> 1000 at 10.50.1.57 answer()
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 2014-04-15 10:37:09.803038 [DEBUG]
> sofia_glue.c:3449 AUDIO RTP [sofia/internal/1000 at 10.50.1.57] 10.50.1.57
> port 27358 -> 10.50.1.151 port 49168 codec: 3 ms: 20
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 2014-04-15 10:37:09.803038 [DEBUG]
> switch_rtp.c:2040 Starting timer [soft] 160 bytes per 20ms
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 2014-04-15 10:37:09.803038 [DEBUG]
> sofia_glue.c:3716 Set 2833 dtmf send payload to 101
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 2014-04-15 10:37:09.803038 [DEBUG]
> sofia_glue.c:3722 Set 2833 dtmf receive payload to 101
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 2014-04-15 10:37:09.803038 [DEBUG]
> sofia_glue.c:3749 sofia/internal/1000 at 10.50.1.57 Set rtp dtmf delay to 40
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 2014-04-15 10:37:09.803038 [DEBUG]
> mod_sofia.c:866 Local SDP sofia/internal/1000 at 10.50.1.57:
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 v=0
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 o=FreeSWITCH 1397556071 1397556072 IN
> IP4 10.50.1.57
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 s=FreeSWITCH
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 c=IN IP4 10.50.1.57
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 t=0 0
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 m=audio 27358 RTP/AVP 3 101
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 a=rtpmap:3 GSM/8000
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 a=rtpmap:101 telephone-event/8000
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 a=fmtp:101 0-16
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 a=ptime:20
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 a=sendrecv
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 2014-04-15 10:37:09.803038 [DEBUG]
> switch_core_session.c:1016 Send signal sofia/internal/1000 at 10.50.1.57[BREAK]
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 2014-04-15 10:37:09.803038 [DEBUG]
> sofia.c:5815 Channel sofia/internal/1000 at 10.50.1.57 entering state
> [completed][200]
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 2014-04-15 10:37:09.803038 [DEBUG]
> switch_core_session.c:871 Send signal sofia/internal/1000 at 10.50.1.57[BREAK]
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 2014-04-15 10:37:09.803038 [NOTICE]
> mod_dptools.c:1225 Channel [sofia/internal/1000 at 10.50.1.57] has been
> answered
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 2014-04-15 10:37:09.803038 [DEBUG]
> switch_core_session.c:1016 Send signal sofia/internal/1000 at 10.50.1.57[BREAK]
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 2014-04-15 10:37:09.803038 [DEBUG]
> switch_core_session.c:1016 Send signal sofia/internal/1000 at 10.50.1.57[BREAK]
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 2014-04-15 10:37:09.803038 [DEBUG]
> switch_core_session.c:1016 Send signal sofia/internal/1000 at 10.50.1.57[BREAK]
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 2014-04-15 10:37:09.803038 [DEBUG]
> switch_channel.c:3647 (sofia/internal/1000 at 10.50.1.57) Callstate Change
> RINGING -> ACTIVE
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 2014-04-15 10:37:09.803038 [DEBUG]
> sofia.c:5815 Channel sofia/internal/1000 at 10.50.1.57 entering state
> [ready][200]
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 EXECUTE sofia/internal/
> 1000 at 10.50.1.57 sleep(1000)
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 2014-04-15 10:37:09.842988 [DEBUG]
> switch_rtp.c:3757 Correct ip/port confirmed.
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 EXECUTE sofia/internal/
> 1000 at 10.50.1.57 set(voicemail_action=save)
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 2014-04-15 10:37:10.821249 [DEBUG]
> mod_dptools.c:1402 sofia/internal/1000 at 10.50.1.57 SET
> [voicemail_action]=[save]
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 EXECUTE sofia/internal/
> 1000 at 10.50.1.57 set(voicemail_id=9664)
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 2014-04-15 10:37:10.821249 [DEBUG]
> mod_dptools.c:1402 sofia/internal/1000 at 10.50.1.57 SET
> [voicemail_id]=[9664]
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 EXECUTE sofia/internal/
> 1000 at 10.50.1.57 set(voicemail_profile=default)
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 2014-04-15 10:37:10.821249 [DEBUG]
> mod_dptools.c:1402 sofia/internal/1000 at 10.50.1.57 SET
> [voicemail_profile]=[default]
> 9235e58e-c4c4-11e3-82c4-d3e7bac25629 EXECUTE sofia/internal/
> 1000 at 10.50.1.57 lua(app.lua voicemail)
> 2014-04-15 10:37:10.821249 [DEBUG] freeswitch_lua.cpp:360 DBH handle
> 0x7f22c40c5e60 Connected.
>
>
> _________________________________________________________________________
> 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/20140415/57ea3231/attachment.html 