[Freeswitch-users] New to freeswitch: Tetris

Fri Sep 10 02:51:24 PDT 2010

On Fri, Sep 10, 2010 at 10:36 AM, David Wafula <davidwaf at gmail.com> wrote:
> Hi all,
> Am new to freeswitch and telephony. I installed freeswitch, and only changed
> acl.conf.xml to allow SIP calls from my IP address. So, my first test call
> to 9198 is not playing the song  back, here is the log. Anything more i need
> to do?

Your phone is not registered as an internal user, so you cannot call
extensions in the internal/default dialplan, but only in the public
dialplan, and 9198 is not present in that public dialplan.

If you'll try to call 1000 you'll see that your call comes though (and
will go to voicemail).

Have a look in the wiki on how to setup remote phones as "internally"
registered user.

Start from here, and explore, you'll find examples (but I cannot
remember where :) ):
http://wiki.freeswitch.org/wiki/Getting_Started_Guide#External

-giovanni

> Thanks.
>
>
> -- [NOTICE] switch_channel.c:779 New Channel
> sofia/internal/1000 at 109.74.198.135 [8452afcd-75ae-438e-adfa-59aa569d2086]
> 2010-09-10 08:29:26.774463 [DEBUG] switch_core_state_machine.c:314
> (sofia/internal/1000 at 109.74.198.135) Running State Change CS_NEW
> 2010-09-10 08:29:26.774463 [DEBUG] switch_core_state_machine.c:320
> (sofia/internal/1000 at 109.74.198.135) State NEW
> 2010-09-10 08:29:26.777617 [DEBUG] sofia.c:4331 Channel
> sofia/internal/1000 at 109.74.198.135 entering state [received][100]
> 2010-09-10 08:29:26.777617 [DEBUG] sofia.c:4342 Remote SDP:
> v=0
> o=user1 53655765 2353687637 IN IP4 41.27.242.184
> s=-
> c=IN IP4 41.27.242.184
> t=0 0
> m=audio 8000 RTP/AVP 0
> a=rtpmap:0 PCMU/8000
> 2010-09-10 08:29:26.777617 [DEBUG] sofia_glue.c:3851 Audio Codec Compare
> [PCMU:0:8000:20]/[G7221:115:32000:20]
> 2010-09-10 08:29:26.777617 [DEBUG] sofia_glue.c:3851 Audio Codec Compare
> [PCMU:0:8000:20]/[G7221:107:16000:20]
> 2010-09-10 08:29:26.777617 [DEBUG] sofia_glue.c:3851 Audio Codec Compare
> [PCMU:0:8000:20]/[G722:9:8000:20]
> 2010-09-10 08:29:26.777617 [DEBUG] sofia_glue.c:3851 Audio Codec Compare
> [PCMU:0:8000:20]/[PCMU:0:8000:20]
> 2010-09-10 08:29:26.778598 [DEBUG] sofia_glue.c:2446 Set Codec
> sofia/internal/1000 at 109.74.198.135 PCMU/8000 20 ms 160 samples
> 2010-09-10 08:29:26.778598 [DEBUG] sofia.c:4489
> (sofia/internal/1000 at 109.74.198.135) State Change CS_NEW -> CS_INIT
> 2010-09-10 08:29:26.778598 [DEBUG] switch_core_session.c:1039 Send signal
> sofia/internal/1000 at 109.74.198.135 [BREAK]
> 2010-09-10 08:29:26.778598 [DEBUG] switch_core_state_machine.c:314
> (sofia/internal/1000 at 109.74.198.135) Running State Change CS_INIT
> 2010-09-10 08:29:26.778598 [DEBUG] switch_core_state_machine.c:338
> (sofia/internal/1000 at 109.74.198.135) State INIT
> 2010-09-10 08:29:26.778598 [DEBUG] mod_sofia.c:83
> sofia/internal/1000 at 109.74.198.135 SOFIA INIT
> 2010-09-10 08:29:26.778598 [DEBUG] mod_sofia.c:119
> (sofia/internal/1000 at 109.74.198.135) State Change CS_INIT -> CS_ROUTING
> 2010-09-10 08:29:26.778598 [DEBUG] switch_core_session.c:1039 Send signal
> sofia/internal/1000 at 109.74.198.135 [BREAK]
> 2010-09-10 08:29:26.778598 [DEBUG] switch_core_state_machine.c:338
> (sofia/internal/1000 at 109.74.198.135) State INIT going to sleep
> 2010-09-10 08:29:26.778598 [DEBUG] switch_core_state_machine.c:314
> (sofia/internal/1000 at 109.74.198.135) Running State Change CS_ROUTING
> 2010-09-10 08:29:26.778598 [DEBUG] switch_channel.c:1512
> (sofia/internal/1000 at 109.74.198.135) Callstate Change DOWN -> RINGING
> 2010-09-10 08:29:26.779586 [DEBUG] switch_core_state_machine.c:341
> (sofia/internal/1000 at 109.74.198.135) State ROUTING
> 2010-09-10 08:29:26.779586 [DEBUG] mod_sofia.c:142
> sofia/internal/1000 at 109.74.198.135 SOFIA ROUTING
> 2010-09-10 08:29:26.779586 [DEBUG] switch_core_state_machine.c:77
> sofia/internal/1000 at 109.74.198.135 Standard ROUTING
> 2010-09-10 08:29:26.779586 [INFO] mod_dialplan_xml.c:331 Processing 1000
> <1000>->9198 in context public
> Dialplan: sofia/internal/1000 at 109.74.198.135 parsing [public->unloop]
> continue=false
> Dialplan: sofia/internal/1000 at 109.74.198.135 Regex (PASS) [unloop]
> ${unroll_loops}(true) =~ /^true$/ break=on-false
> Dialplan: sofia/internal/1000 at 109.74.198.135 Regex (FAIL) [unloop]
> ${sip_looped_call}() =~ /^true$/ break=on-false
> Dialplan: sofia/internal/1000 at 109.74.198.135 parsing [public->outside_call]
> continue=true
> Dialplan: sofia/internal/1000 at 109.74.198.135 Absolute Condition
> [outside_call]
> Dialplan: sofia/internal/1000 at 109.74.198.135 Action set(outside_call=true)
> Dialplan: sofia/internal/1000 at 109.74.198.135 Action
> set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
> Dialplan: sofia/internal/1000 at 109.74.198.135 parsing [public->call_debug]
> continue=true
> Dialplan: sofia/internal/1000 at 109.74.198.135 Regex (FAIL) [call_debug]
> ${call_debug}(false) =~ /^true$/ break=never
> Dialplan: sofia/internal/1000 at 109.74.198.135 parsing
> [public->public_extensions] continue=false
> Dialplan: sofia/internal/1000 at 109.74.198.135 Regex (FAIL)
> [public_extensions] destination_number(9198) =~ /^(10[01][0-9])$/
> break=on-false
> Dialplan: sofia/internal/1000 at 109.74.198.135 parsing [public->public_did]
> continue=false
> Dialplan: sofia/internal/1000 at 109.74.198.135 Regex (FAIL) [public_did]
> destination_number(9198) =~ /^(5551212)$/ break=on-false
> 2010-09-10 08:29:26.782533 [DEBUG] switch_core_state_machine.c:119
> (sofia/internal/1000 at 109.74.198.135) State Change CS_ROUTING -> CS_EXECUTE
> 2010-09-10 08:29:26.782533 [DEBUG] switch_core_session.c:1039 Send signal
> sofia/internal/1000 at 109.74.198.135 [BREAK]
> 2010-09-10 08:29:26.782533 [DEBUG] switch_core_state_machine.c:341
> (sofia/internal/1000 at 109.74.198.135) State ROUTING going to sleep
> 2010-09-10 08:29:26.782533 [DEBUG] switch_core_state_machine.c:314
> (sofia/internal/1000 at 109.74.198.135) Running State Change CS_EXECUTE
> 2010-09-10 08:29:26.782533 [DEBUG] switch_core_state_machine.c:348
> (sofia/internal/1000 at 109.74.198.135) State EXECUTE
> 2010-09-10 08:29:26.782533 [DEBUG] mod_sofia.c:235
> sofia/internal/1000 at 109.74.198.135 SOFIA EXECUTE
> 2010-09-10 08:29:26.782533 [DEBUG] switch_core_state_machine.c:157
> sofia/internal/1000 at 109.74.198.135 Standard EXECUTE
> EXECUTE sofia/internal/1000 at 109.74.198.135 set(outside_call=true)
> 2010-09-10 08:29:26.782533 [DEBUG] mod_dptools.c:854
> sofia/internal/1000 at 109.74.198.135 SET [outside_call]=[true]
> EXECUTE sofia/internal/1000 at 109.74.198.135 set(RFC2822_DATE=Fri, 10 Sep 2010
> 08:29:26 +0000)
> 2010-09-10 08:29:26.782533 [DEBUG] mod_dptools.c:854
> sofia/internal/1000 at 109.74.198.135 SET [RFC2822_DATE]=[Fri, 10 Sep 2010
> 08:29:26 +0000]
> 2010-09-10 08:29:26.782533 [NOTICE] switch_core_state_machine.c:185
> sofia/internal/1000 at 109.74.198.135 has executed the last dialplan
> instruction, hanging up.
> 2010-09-10 08:29:26.782533 [DEBUG] switch_channel.c:2317
> (sofia/internal/1000 at 109.74.198.135) Callstate Change RINGING -> HANGUP
> 2010-09-10 08:29:26.782533 [NOTICE] switch_core_state_machine.c:187 Hangup
> sofia/internal/1000 at 109.74.198.135 [CS_EXECUTE] [NORMAL_CLEARING]
> 2010-09-10 08:29:26.782533 [DEBUG] switch_channel.c:2333 Send signal
> sofia/internal/1000 at 109.74.198.135 [KILL]
> 2010-09-10 08:29:26.782533 [DEBUG] switch_core_session.c:1039 Send signal
> sofia/internal/1000 at 109.74.198.135 [BREAK]
> 2010-09-10 08:29:26.782533 [DEBUG] switch_core_state_machine.c:348
> (sofia/internal/1000 at 109.74.198.135) State EXECUTE going to sleep
> 2010-09-10 08:29:26.782533 [DEBUG] switch_core_state_machine.c:314
> (sofia/internal/1000 at 109.74.198.135) Running State Change CS_HANGUP
> 2010-09-10 08:29:26.782533 [DEBUG] switch_core_state_machine.c:535
> (sofia/internal/1000 at 109.74.198.135) State HANGUP
> 2010-09-10 08:29:26.782533 [DEBUG] mod_sofia.c:453 Channel
> sofia/internal/1000 at 109.74.198.135 hanging up, cause: NORMAL_CLEARING
> 2010-09-10 08:29:26.789460 [DEBUG] mod_sofia.c:515 Responding to INVITE
> with: 480
> 2010-09-10 08:29:26.789460 [DEBUG] switch_core_state_machine.c:46
> sofia/internal/1000 at 109.74.198.135 Standard HANGUP, cause: NORMAL_CLEARING
> 2010-09-10 08:29:26.789460 [DEBUG] switch_core_state_machine.c:535
> (sofia/internal/1000 at 109.74.198.135) State HANGUP going to sleep
> 2010-09-10 08:29:26.789460 [DEBUG] switch_core_state_machine.c:333
> (sofia/internal/1000 at 109.74.198.135) State Change CS_HANGUP -> CS_REPORTING
> 2010-09-10 08:29:26.789460 [DEBUG] switch_core_session.c:1039 Send signal
> sofia/internal/1000 at 109.74.198.135 [BREAK]
> 2010-09-10 08:29:26.789460 [DEBUG] switch_core_state_machine.c:314
> (sofia/internal/1000 at 109.74.198.135) Running State Change CS_REPORTING
> 2010-09-10 08:29:26.789460 [DEBUG] switch_core_state_machine.c:595
> (sofia/internal/1000 at 109.74.198.135) State REPORTING
> 2010-09-10 08:29:26.789460 [DEBUG] switch_core_state_machine.c:53
> sofia/internal/1000 at 109.74.198.135 Standard REPORTING, cause:
> NORMAL_CLEARING
> 2010-09-10 08:29:26.789460 [DEBUG] switch_core_state_machine.c:595
> (sofia/internal/1000 at 109.74.198.135) State REPORTING going to sleep
> 2010-09-10 08:29:26.789460 [DEBUG] switch_core_state_machine.c:327
> (sofia/internal/1000 at 109.74.198.135) State Change CS_REPORTING -> CS_DESTROY
> 2010-09-10 08:29:26.789460 [DEBUG] switch_core_session.c:1039 Send signal
> sofia/internal/1000 at 109.74.198.135 [BREAK]
> 2010-09-10 08:29:26.789460 [DEBUG] switch_core_session.c:1202 Session 22
> (sofia/internal/1000 at 109.74.198.135) Locked, Waiting on external entities
> 2010-09-10 08:29:26.789460 [NOTICE] switch_core_session.c:1220 Session 22
> (sofia/internal/1000 at 109.74.198.135) Ended
> 2010-09-10 08:29:26.789460 [NOTICE] switch_core_session.c:1222 Close Channel
> sofia/internal/1000 at 109.74.198.135 [CS_DESTROY]
> 2010-09-10 08:29:26.789460 [DEBUG] switch_core_state_machine.c:427
> (sofia/internal/1000 at 109.74.198.135) Callstate Change HANGUP -> DOWN
> 2010-09-10 08:29:26.790435 [DEBUG] switch_core_state_machine.c:430
> (sofia/internal/1000 at 109.74.198.135) Running State Change CS_DESTROY
> 2010-09-10 08:29:26.790435 [DEBUG] switch_core_state_machine.c:440
> (sofia/internal/1000 at 109.74.198.135) State DESTROY
> 2010-09-10 08:29:26.790435 [DEBUG] mod_sofia.c:358
> sofia/internal/1000 at 109.74.198.135 SOFIA DESTROY
> 2010-09-10 08:29:26.790435 [DEBUG] switch_core_state_machine.c:60
> sofia/internal/1000 at 109.74.198.135 Standard DESTROY
> 2010-09-10 08:29:26.790435 [DEBUG] switch_core_state_machine.c:440
> (sofia/internal/1000 at 109.74.198.135) State DESTROY going to sleep
> David Wafula
>
> _______________________________________________
> 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
>
>

-- 
Sincerely,

Giovanni Maruzzelli
Cell : +39-347-2665618