rendered paste bodyfreeswitch@zoe> pa indev #9
API CALL [pa(indev #9)] output:
indev set to 9
freeswitch@zoe> pa outdev #9
API CALL [pa(outdev #9)] output:
outdev set to 9
freeswitch@zoe> pa call 1234
2007-10-07 10:55:26 [NOTICE] switch_channel.c:389 switch_channel_set_name() New Chan PortAudio/1234 [7c43ba02-74fe-11dc-b9e7-8be1c40990d1]
API CALL [pa(call 1234)] output:
SUCCESS:1:7c43ba02-74fe-11dc-b9e7-8be1c40990d1
freeswitch@zoe> 2007-10-07 10:55:26 [NOTICE] mod_portaudio.c:1617 place_call() Channel [PortAudio/1234] has been answered
2007-10-07 10:55:26 [DEBUG] mod_portaudio.c:1618 place_call() PortAudio/1234 State Change CS_NEW -> CS_INIT
2007-10-07 10:55:26 [DEBUG] switch_core_session.c:625 switch_core_session_signal_state_change() Kill PortAudio/1234 [BREAK]
2007-10-07 10:55:26 [DEBUG] mod_portaudio.c:476 channel_kill_channel() PortAudio/1234 CHANNEL KILL
2007-10-07 10:55:26 [DEBUG] switch_core_state_machine.c:397 switch_core_session_run() (PortAudio/1234) State INIT
2007-10-07 10:55:26 [DEBUG] mod_portaudio.c:296 channel_on_init() PortAudio/1234 State Change CS_INIT -> CS_RING
2007-10-07 10:55:26 [DEBUG] switch_core_session.c:625 switch_core_session_signal_state_change() Kill PortAudio/1234 [BREAK]
2007-10-07 10:55:26 [DEBUG] mod_portaudio.c:476 channel_kill_channel() PortAudio/1234 CHANNEL KILL
2007-10-07 10:55:26 [DEBUG] switch_core_state_machine.c:400 switch_core_session_run() (PortAudio/1234) State RING
2007-10-07 10:55:26 [DEBUG] mod_portaudio.c:313 channel_on_ring() PortAudio/1234 CHANNEL RING
2007-10-07 10:55:26 [DEBUG] switch_core_state_machine.c:64 switch_core_standard_on_ring() Standard RING PortAudio/1234
2007-10-07 10:55:26 [INFO] mod_dialplan_xml.c:315 dialplan_hunt() Processing FreeSwitch->1234!
2007-10-07 10:55:26 [DEBUG] mod_dialplan_xml.c:116 parse_exten() test conditions destination_number(1234) =~ /^556$/
2007-10-07 10:55:26 [DEBUG] mod_dialplan_xml.c:118 parse_exten() Regex mismatch
2007-10-07 10:55:26 [DEBUG] mod_dialplan_xml.c:116 parse_exten() test conditions destination_number(1234) =~ /^9193$/
2007-10-07 10:55:26 [DEBUG] mod_dialplan_xml.c:118 parse_exten() Regex mismatch
2007-10-07 10:55:26 [DEBUG] mod_dialplan_xml.c:116 parse_exten() test conditions destination_number(1234) =~ /^9192$/
2007-10-07 10:55:26 [DEBUG] mod_dialplan_xml.c:118 parse_exten() Regex mismatch
2007-10-07 10:55:26 [DEBUG] mod_dialplan_xml.c:116 parse_exten() test conditions destination_number(1234) =~ /^9191$/
2007-10-07 10:55:26 [DEBUG] mod_dialplan_xml.c:118 parse_exten() Regex mismatch
2007-10-07 10:55:26 [DEBUG] mod_dialplan_xml.c:116 parse_exten() test conditions destination_number(1234) =~ /^(18(0{2}|8{2}|7{2}|6{2})\d{7})$/
2007-10-07 10:55:26 [DEBUG] mod_dialplan_xml.c:118 parse_exten() Regex mismatch
2007-10-07 10:55:26 [DEBUG] mod_dialplan_xml.c:116 parse_exten() test conditions source(mod_portaudio) =~ /mod_portaudio/
2007-10-07 10:55:26 [DEBUG] mod_dialplan_xml.c:116 parse_exten() test conditions destination_number(1234) =~ /^1234$/
2007-10-07 10:55:26 [DEBUG] mod_dialplan_xml.c:371 dialplan_hunt() PortAudio/1234 State Change CS_RING -> CS_EXECUTE
2007-10-07 10:55:26 [DEBUG] switch_core_session.c:625 switch_core_session_signal_state_change() Kill PortAudio/1234 [BREAK]
2007-10-07 10:55:26 [DEBUG] mod_portaudio.c:476 channel_kill_channel() PortAudio/1234 CHANNEL KILL
2007-10-07 10:55:26 [DEBUG] switch_core_state_machine.c:406 switch_core_session_run() (PortAudio/1234) State EXECUTE
2007-10-07 10:55:26 [DEBUG] mod_portaudio.c:330 channel_on_execute() PortAudio/1234 CHANNEL EXECUTE
2007-10-07 10:55:26 [DEBUG] switch_core_state_machine.c:121 switch_core_standard_on_execute() Standard EXECUTE
2007-10-07 10:55:26 [NOTICE] switch_core_state_machine.c:134 switch_core_standard_on_execute() Execute export(absolute_codec_string=PCMU@20i)
2007-10-07 10:55:26 [DEBUG] mod_dptools.c:475 export_function() EXPORT [absolute_codec_string]=[PCMU@20i]
2007-10-07 10:55:26 [NOTICE] switch_core_state_machine.c:134 switch_core_standard_on_execute() Execute export(nolocal:jitterbuffer_msec=180)
2007-10-07 10:55:26 [DEBUG] mod_dptools.c:475 export_function() EXPORT (REMOTE ONLY) [jitterbuffer_msec]=[180]
2007-10-07 10:55:26 [NOTICE] switch_core_state_machine.c:134 switch_core_standard_on_execute() Execute set(ringback=${us-ring})
2007-10-07 10:55:26 [DEBUG] switch_core_state_machine.c:158 switch_core_standard_on_execute() Expanded String set(ringback=%(2000, 4000, 440.0, 480.0))
2007-10-07 10:55:26 [DEBUG] mod_dptools.c:358 set_function() SET [ringback]=[%(2000, 4000, 440.0, 480.0)]
2007-10-07 10:55:26 [NOTICE] switch_core_state_machine.c:134 switch_core_standard_on_execute() Execute bridge(sofia/mydomain.com/1234@conference.freeswitch.org)
2007-10-07 10:55:26 [NOTICE] switch_channel.c:389 switch_channel_set_name() New Chan sofia/mydomain.com/1234@conference.freeswitch.org [7c4a0722-74fe-11dc-b9e7-8be1c40990d1]
2007-10-07 10:55:26 [DEBUG] mod_sofia.c:1482 sofia_outgoing_channel() sofia/mydomain.com/1234@conference.freeswitch.org State Change CS_NEW -> CS_INIT
2007-10-07 10:55:26 [DEBUG] switch_core_session.c:625 switch_core_session_signal_state_change() Kill sofia/mydomain.com/1234@conference.freeswitch.org [BREAK]
2007-10-07 10:55:26 [DEBUG] switch_core_state_machine.c:397 switch_core_session_run() (sofia/mydomain.com/1234@conference.freeswitch.org) State INIT
2007-10-07 10:55:26 [DEBUG] mod_sofia.c:92 sofia_on_init() SOFIA INIT
2007-10-07 10:55:26 [DEBUG] sofia.c:105 sofia_event_callback() event [nua_i_state] status [0][INVITE sent] session: sofia/mydomain.com/1234@conference.freeswitch.org
2007-10-07 10:55:26 [DEBUG] sofia.c:1087 sofia_handle_sip_i_state() Channel sofia/mydomain.com/1234@conference.freeswitch.org entering state [calling]
2007-10-07 10:55:26 [DEBUG] mod_sofia.c:105 sofia_on_init() sofia/mydomain.com/1234@conference.freeswitch.org State Change CS_INIT -> CS_RING
2007-10-07 10:55:26 [DEBUG] switch_core_session.c:625 switch_core_session_signal_state_change() Kill sofia/mydomain.com/1234@conference.freeswitch.org [BREAK]
2007-10-07 10:55:26 [DEBUG] switch_core_state_machine.c:400 switch_core_session_run() (sofia/mydomain.com/1234@conference.freeswitch.org) State RING
2007-10-07 10:55:26 [DEBUG] mod_sofia.c:120 sofia_on_ring() SOFIA RING
2007-10-07 10:55:26 [DEBUG] switch_ivr_originate.c:48 originate_on_ring() sofia/mydomain.com/1234@conference.freeswitch.org State Change CS_RING -> CS_HOLD
2007-10-07 10:55:26 [DEBUG] switch_core_session.c:625 switch_core_session_signal_state_change() Kill sofia/mydomain.com/1234@conference.freeswitch.org [BREAK]
2007-10-07 10:55:26 [DEBUG] switch_core_state_machine.c:415 switch_core_session_run() (sofia/mydomain.com/1234@conference.freeswitch.org) State HOLD
2007-10-07 10:55:26 [DEBUG] switch_core_state_machine.c:204 switch_core_standard_on_hold() Standard HOLD
2007-10-07 10:55:27 [DEBUG] switch_ivr_originate.c:618 switch_ivr_originate() Raw Codec Activation Success L16@8000hz 1 channel 20ms
2007-10-07 10:55:27 [DEBUG] switch_ivr_originate.c:666 switch_ivr_originate() Play Ringback Tone [%(2000, 4000, 440.0, 480.0)]
2007-10-07 10:55:59 [DEBUG] sofia.c:105 sofia_event_callback() event [nua_r_invite] status [408][Request Timeout] session: sofia/mydomain.com/1234@conference.freeswitch.org
2007-10-07 10:55:59 [DEBUG] sofia.c:105 sofia_event_callback() event [nua_i_state] status [408][Request Timeout] session: sofia/mydomain.com/1234@conference.freeswitch.org
2007-10-07 10:55:59 [DEBUG] sofia.c:1087 sofia_handle_sip_i_state() Channel sofia/mydomain.com/1234@conference.freeswitch.org entering state [terminated]
2007-10-07 10:55:59 [NOTICE] sofia.c:1410 sofia_handle_sip_i_state() Hangup sofia/mydomain.com/1234@conference.freeswitch.org [CS_HOLD] [RECOVERY_ON_TIMER_EXPIRE]
2007-10-07 10:55:59 [DEBUG] switch_channel.c:1070 switch_channel_perform_hangup() Kill sofia/mydomain.com/1234@conference.freeswitch.org [KILL]
2007-10-07 10:55:59 [DEBUG] switch_core_session.c:625 switch_core_session_signal_state_change() Kill sofia/mydomain.com/1234@conference.freeswitch.org [BREAK]
2007-10-07 10:55:59 [DEBUG] switch_core_state_machine.c:394 switch_core_session_run() (sofia/mydomain.com/1234@conference.freeswitch.org) State HANGUP
2007-10-07 10:55:59 [DEBUG] mod_sofia.c:217 sofia_on_hangup() Channel sofia/mydomain.com/1234@conference.freeswitch.org hanging up, cause: RECOVERY_ON_TIMER_EXPIRE
2007-10-07 10:55:59 [DEBUG] switch_core_state_machine.c:45 switch_core_standard_on_hangup() Standard HANGUP sofia/mydomain.com/1234@conference.freeswitch.org, cause: RECOVERY_ON_TIMER_EXPIRE
2007-10-07 10:55:59 [DEBUG] switch_core_session.c:683 switch_core_session_thread() Session 8 (sofia/mydomain.com/1234@conference.freeswitch.org) Locked, Waiting on external entities
2007-10-07 10:55:59 [DEBUG] switch_ivr_originate.c:871 switch_ivr_originate() Originate Resulted in Error Cause: 102 [RECOVERY_ON_TIMER_EXPIRE]
2007-10-07 10:55:59 [INFO] mod_dptools.c:1183 audio_bridge_function() Originate Failed. Cause: RECOVERY_ON_TIMER_EXPIRE
2007-10-07 10:55:59 [NOTICE] mod_dptools.c:1187 audio_bridge_function() Hangup PortAudio/1234 [CS_EXECUTE] [RECOVERY_ON_TIMER_EXPIRE]
2007-10-07 10:55:59 [DEBUG] switch_channel.c:1070 switch_channel_perform_hangup() Kill PortAudio/1234 [KILL]
2007-10-07 10:55:59 [DEBUG] mod_portaudio.c:476 channel_kill_channel() PortAudio/1234 CHANNEL KILL
2007-10-07 10:55:59 [DEBUG] switch_core_session.c:625 switch_core_session_signal_state_change() Kill PortAudio/1234 [BREAK]
2007-10-07 10:55:59 [DEBUG] mod_portaudio.c:476 channel_kill_channel() PortAudio/1234 CHANNEL KILL
2007-10-07 10:55:59 [DEBUG] switch_core_state_machine.c:394 switch_core_session_run() (PortAudio/1234) State HANGUP
2007-10-07 10:55:59 [DEBUG] mod_portaudio.c:422 remove_pvt() No more channels, deactivating audio
2007-10-07 10:55:59 [INFO] switch_core_session.c:689 switch_core_session_thread() Session 8 (sofia/mydomain.com/1234@conference.freeswitch.org) Ended
2007-10-07 10:55:59 [NOTICE] switch_core_session.c:691 switch_core_session_thread() Close Channel sofia/mydomain.com/1234@conference.freeswitch.org [CS_HANGUP]
2007-10-07 10:55:59 [DEBUG] mod_portaudio.c:452 channel_on_hangup() PortAudio/1234 CHANNEL HANGUP
2007-10-07 10:55:59 [DEBUG] switch_core_state_machine.c:45 switch_core_standard_on_hangup() Standard HANGUP PortAudio/1234, cause: RECOVERY_ON_TIMER_EXPIRE
2007-10-07 10:55:59 [DEBUG] switch_core_session.c:683 switch_core_session_thread() Session 7 (PortAudio/1234) Locked, Waiting on external entities
2007-10-07 10:55:59 [INFO] switch_core_session.c:689 switch_core_session_thread() Session 7 (PortAudio/1234) Ended
2007-10-07 10:55:59 [NOTICE] switch_core_session.c:691 switch_core_session_thread() Close Channel PortAudio/1234 [CS_HANGUP]