freeswitch@troy> pa call 1234
API CALL [pa(call 1234)] output:
SUCCESS:3:6cfde9c2-b66e-11db-bda1-ff5951079fcf


freeswitch@troy> 2007-02-07 00:45:32 [NOTICE] switch_channel.c:348 switch_channel_set_name() New Chan PortAudio/1234 [6cfde9c2-b66e-11db-bda1-ff5951079fcf]
2007-02-07 00:45:32 [NOTICE] mod_portaudio.c:1671 place_call() Channel [PortAudio/1234] has been answered
2007-02-07 00:45:32 [DEBUG] mod_portaudio.c:1672 place_call() PortAudio/1234 State Change CS_NEW -> CS_INIT
2007-02-07 00:45:32 [DEBUG] switch_core.c:3113 switch_core_session_run() (PortAudio/1234) State INIT
2007-02-07 00:45:32 [DEBUG] mod_portaudio.c:296 channel_on_init() PortAudio/1234 State Change CS_INIT -> CS_RING
2007-02-07 00:45:32 [DEBUG] switch_core.c:3149 switch_core_session_run() (PortAudio/1234) State RING
2007-02-07 00:45:32 [DEBUG] mod_portaudio.c:313 channel_on_ring() PortAudio/1234 CHANNEL RING
2007-02-07 00:45:32 [DEBUG] switch_core.c:2784 switch_core_standard_on_ring() Standard RING PortAudio/1234
2007-02-07 00:45:32 [INFO] mod_dialplan_xml.c:219 dialplan_hunt() Processing FreeSwitch->1234!
2007-02-07 00:45:32 [DEBUG] mod_dialplan_xml.c:120 parse_exten() test conditions destination_number(1234) =~ /^556$/
2007-02-07 00:45:32 [DEBUG] mod_dialplan_xml.c:122 parse_exten() Regex mismatch
2007-02-07 00:45:32 [DEBUG] mod_dialplan_xml.c:120 parse_exten() test conditions destination_number(1234) =~ /^(18(0{2}|8{2}|7{2}|6{2})\d{7})$/
2007-02-07 00:45:32 [DEBUG] mod_dialplan_xml.c:122 parse_exten() Regex mismatch
2007-02-07 00:45:32 [DEBUG] mod_dialplan_xml.c:120 parse_exten() test conditions destination_number(1234) =~ /^1234$/
2007-02-07 00:45:32 [DEBUG] mod_dialplan_xml.c:355 dialplan_hunt() PortAudio/1234 State Change CS_RING -> CS_EXECUTE
2007-02-07 00:45:32 [DEBUG] switch_core.c:3185 switch_core_session_run() (PortAudio/1234) State EXECUTE
2007-02-07 00:45:32 [DEBUG] mod_portaudio.c:330 channel_on_execute() PortAudio/1234 CHANNEL EXECUTE
2007-02-07 00:45:32 [DEBUG] switch_core.c:2843 switch_core_standard_on_execute() Standard EXECUTE
2007-02-07 00:45:32 [NOTICE] switch_core.c:2853 switch_core_standard_on_execute() Execute set(ringback=${us-ring})
2007-02-07 00:45:32 [DEBUG] switch_core.c:2874 switch_core_standard_on_execute() Expanded String set(ringback=%(2000, 4000, 440.0, 480.0))
2007-02-07 00:45:32 [DEBUG] mod_dptools.c:200 set_function() SET [ringback]=[%(2000, 4000, 440.0, 480.0)]
2007-02-07 00:45:32 [NOTICE] switch_core.c:2853 switch_core_standard_on_execute() Execute bridge(sofia/mydomain.com/1234@conference.freeswitch.org)
2007-02-07 00:45:32 [NOTICE] switch_channel.c:348 switch_channel_set_name() New Chan sofia/mydomain.com/1234@conference.freeswitch.org [6cfe46a6-b66e-11db-bda1-ff5951079fcf]
2007-02-07 00:45:32 [DEBUG] mod_sofia.c:2246 sofia_outgoing_channel() sofia/mydomain.com/1234@conference.freeswitch.org State Change CS_NEW -> CS_INIT
2007-02-07 00:45:32 [DEBUG] switch_core.c:3113 switch_core_session_run() (sofia/mydomain.com/1234@conference.freeswitch.org) State INIT
2007-02-07 00:45:32 [DEBUG] mod_sofia.c:1163 sofia_on_init() SOFIA INIT
2007-02-07 00:45:32 [DEBUG] mod_sofia.c:4613 event_callback() event [nua_i_state] status [0][INVITE sent] session: sofia/mydomain.com/1234@conference.freeswitch.org
2007-02-07 00:45:32 [DEBUG] mod_sofia.c:2721 sip_i_state() Channel sofia/mydomain.com/1234@conference.freeswitch.org entering state [calling]
2007-02-07 00:45:32 [DEBUG] mod_sofia.c:1174 sofia_on_init() sofia/mydomain.com/1234@conference.freeswitch.org State Change CS_INIT -> CS_RING
2007-02-07 00:45:32 [DEBUG] switch_core.c:3149 switch_core_session_run() (sofia/mydomain.com/1234@conference.freeswitch.org) State RING
2007-02-07 00:45:32 [DEBUG] mod_sofia.c:1189 sofia_on_ring() SOFIA RING
2007-02-07 00:45:32 [DEBUG] switch_ivr.c:2114 audio_bridge_on_ring() CUSTOM RING
2007-02-07 00:45:32 [DEBUG] switch_ivr.c:2117 audio_bridge_on_ring() sofia/mydomain.com/1234@conference.freeswitch.org State Change CS_RING -> CS_HOLD
2007-02-07 00:45:32 [DEBUG] switch_core.c:3294 switch_core_session_run() (sofia/mydomain.com/1234@conference.freeswitch.org) State HOLD
2007-02-07 00:45:32 [DEBUG] switch_ivr.c:2128 audio_bridge_on_hold() CUSTOM HOLD
2007-02-07 00:45:32 [DEBUG] switch_ivr.c:2773 switch_ivr_originate() Raw Codec Activation Success L16@8000hz 1 channel 20ms
2007-02-07 00:45:32 [DEBUG] switch_ivr.c:2818 switch_ivr_originate() Play Ringback Tone [%(2000, 4000, 440.0, 480.0)]


freeswitch@troy> 

freeswitch@troy> 

freeswitch@troy> 

freeswitch@troy> 2007-02-07 00:45:38 [DEBUG] mod_sofia.c:2721 sip_i_state() Channel sofia/mydomain.com/1234@conference.freeswitch.org entering state [ready]
2007-02-07 00:45:38 [DEBUG] mod_sofia.c:2726 sip_i_state() Remote SDP:
v=0
o=FreeSWITCH 1493077833052042156 7342643495905561639 IN IP4 208.64.200.194
s=FreeSWITCH
c=IN IP4 208.64.200.194
t=0 0
a=sendrecv
m=audio 16420 RTP/AVP 10 101
a=rtpmap:10 L16/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20

2007-02-07 00:45:38 [DEBUG] mod_sofia.c:2325 negotiate_sdp() Codec Compare [L16:10]/[L16:10]
2007-02-07 00:45:38 [INFO] mod_sofia.c:1419 tech_set_codec() Set Codec sofia/mydomain.com/1234@conference.freeswitch.org L16/8000 20 ms
2007-02-07 00:45:38 [INFO] mod_sofia.c:1472 activate_rtp() RTP [sofia/mydomain.com/1234@conference.freeswitch.org] 192.168.1.4:16386->208.64.200.194:16420 codec: 10 ms: 20
2007-02-07 00:45:38 [DEBUG] switch_rtp.c:458 switch_rtp_create() Starting timer [soft] 320 bytes per 20000ms
2007-02-07 00:45:38 [NOTICE] mod_sofia.c:2944 sip_i_state() Channel [sofia/mydomain.com/1234@conference.freeswitch.org] has been answered
2007-02-07 00:45:38 [DEBUG] switch_ivr.c:3008 switch_ivr_originate() Originate Resulted in Success: [sofia/mydomain.com/1234@conference.freeswitch.org]
2007-02-07 00:45:38 [DEBUG] mod_sofia.c:1985 sofia_receive_message() De-activate timed RTP!
2007-02-07 00:45:38 [DEBUG] switch_ivr.c:3506 switch_ivr_multi_threaded_bridge() sofia/mydomain.com/1234@conference.freeswitch.org State Change CS_HOLD -> CS_LOOPBACK
2007-02-07 00:45:38 [DEBUG] switch_core.c:3221 switch_core_session_run() (sofia/mydomain.com/1234@conference.freeswitch.org) State LOOPBACK
2007-02-07 00:45:38 [DEBUG] mod_sofia.c:1336 sofia_on_loopback() SOFIA LOOPBACK