2008-03-06 12:43:02 [NOTICE] switch_channel.c:392 switch_channel_set_name() New Chan sofia/local/72@192.168.1.101:5060 [59913e1f-e136-4122-944b-cdf618b1b8f9]
2008-03-06 12:43:02 [DEBUG] sofia.c:1478 sofia_handle_sip_i_state() Channel sofia/local/72@192.168.1.101:5060 entering state [received]
2008-03-06 12:43:02 [DEBUG] sofia.c:1482 sofia_handle_sip_i_state() Remote SDP:
v=0
o=- 5516325 5516325 IN IP4 192.168.1.70
s=-
c=IN IP4 192.168.1.70
t=0 0
m=audio 16390 RTP/AVP 0 2 4 8 18 96 97 98 100 101
a=rtpmap:0 PCMU/8000
a=rtpmap:2 G726-32/8000
a=rtpmap:4 G723/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729a/8000
a=rtpmap:96 G726-40/8000
a=rtpmap:97 G726-24/8000
a=rtpmap:98 G726-16/8000
a=rtpmap:100 NSE/8000
a=fmtp:100 192-193
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20

2008-03-06 12:43:02 [DEBUG] sofia_glue.c:1434 sofia_glue_negotiate_sdp() Audio Codec Compare [PCMU:0:8000]/[PCMA:8:8000]
2008-03-06 12:43:02 [DEBUG] sofia_glue.c:1434 sofia_glue_negotiate_sdp() Audio Codec Compare [PCMU:0:8000]/[PCMU:0:8000]
2008-03-06 12:43:02 [INFO] sofia_glue.c:1509 sofia_glue_negotiate_sdp() m->m_mode == sdp_sendrecv, inactive,sendonly = 0
2008-03-06 12:43:02 [DEBUG] sofia_glue.c:1040 sofia_glue_tech_set_codec() Set Codec sofia/local/72@192.168.1.101:5060 PCMU/8000 20 ms 160 samples
2008-03-06 12:43:02 [DEBUG] sofia_glue.c:1398 sofia_glue_negotiate_sdp() Set 2833 dtmf payload to 101
2008-03-06 12:43:02 [DEBUG] sofia_glue.c:1638 sofia_glue_negotiate_sdp() neither sendonly or inactive
2008-03-06 12:43:02 [DEBUG] sofia_glue.c:1669 sofia_glue_negotiate_sdp() TFLAG_SIP_HOLD not set, doing nothing
2008-03-06 12:43:02 [DEBUG] sofia.c:1592 sofia_handle_sip_i_state() sofia/local/72@192.168.1.101:5060 State Change CS_NEW -> CS_INIT
2008-03-06 12:43:02 [DEBUG] switch_core_session.c:649 switch_core_session_signal_state_change() Kill sofia/local/72@192.168.1.101:5060 [BREAK]
2008-03-06 12:43:02 [DEBUG] switch_core_state_machine.c:397 switch_core_session_run() (sofia/local/72@192.168.1.101:5060) State INIT
2008-03-06 12:43:02 [DEBUG] mod_sofia.c:105 sofia_on_init() SOFIA INIT
2008-03-06 12:43:02 [INFO] mod_sofia.c:111 sofia_on_init() NOT calling sofia_glue_tech_absorb_sdp
2008-03-06 12:43:02 [DEBUG] mod_sofia.c:122 sofia_on_init() sofia/local/72@192.168.1.101:5060 State Change CS_INIT -> CS_RING
2008-03-06 12:43:02 [DEBUG] switch_core_session.c:649 switch_core_session_signal_state_change() Kill sofia/local/72@192.168.1.101:5060 [BREAK]
2008-03-06 12:43:02 [DEBUG] switch_core_state_machine.c:400 switch_core_session_run() (sofia/local/72@192.168.1.101:5060) State RING
2008-03-06 12:43:02 [DEBUG] mod_sofia.c:137 sofia_on_ring() SOFIA RING
2008-03-06 12:43:02 [DEBUG] switch_core_state_machine.c:64 switch_core_standard_on_ring() Standard RING sofia/local/72@192.168.1.101:5060
2008-03-06 12:43:02 [INFO] mod_dialplan_xml.c:217 dialplan_hunt() Processing Traun Leyden->7704!
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /3760/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^(.*)%23(.*)$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^\*\*8([0-3])$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^\*\*81(\d+)$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^\*\*82(\d+)$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^\*\*83(\d+)$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^\*341\*$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^\*342\*$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^\*343\*$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^\*344\*$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^\*345\*$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^\*346\*$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^\*347\*$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^(\*241\*|\*21)$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^(\*242\*|\*22)$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^(\*242\*|\*23)$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^(\*244\*|\*24)$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^(\*245\*|\*25)$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^(\*246\*|\*26)$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions ${sip_req_port}(5060) =~ /^1[23][0-9]{3}$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions ${sip_req_port}(5060) =~ /^1[23][0-9]{3}$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions ${sip_req_port}(5060) =~ /^1[23][0-9]{3}$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions caller_id_number(72) =~ /^72$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /(.*)/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:273 dialplan_hunt() sofia/local/72@192.168.1.101:5060 State Change CS_RING -> CS_EXECUTE
2008-03-06 12:43:02 [DEBUG] switch_core_session.c:649 switch_core_session_signal_state_change() Kill sofia/local/72@192.168.1.101:5060 [BREAK]
2008-03-06 12:43:02 [DEBUG] switch_core_state_machine.c:406 switch_core_session_run() (sofia/local/72@192.168.1.101:5060) State EXECUTE
2008-03-06 12:43:02 [DEBUG] mod_sofia.c:153 sofia_on_execute() SOFIA EXECUTE
2008-03-06 12:43:02 [DEBUG] switch_core_state_machine.c:121 switch_core_standard_on_execute() Standard EXECUTE
2008-03-06 12:43:02 [NOTICE] switch_core_state_machine.c:134 switch_core_standard_on_execute() Execute set(bypass_media=true)
2008-03-06 12:43:02 [DEBUG] mod_dptools.c:463 set_function() SET [bypass_media]=[true]
2008-03-06 12:43:02 [NOTICE] switch_core_state_machine.c:134 switch_core_standard_on_execute() Execute set(effective_caller_id_name=7702)
2008-03-06 12:43:02 [DEBUG] mod_dptools.c:463 set_function() SET [effective_caller_id_name]=[7702]
2008-03-06 12:43:02 [NOTICE] switch_core_state_machine.c:134 switch_core_standard_on_execute() Execute set(effective_caller_id_number=7702)
2008-03-06 12:43:02 [DEBUG] mod_dptools.c:463 set_function() SET [effective_caller_id_number]=[7702]
2008-03-06 12:43:02 [NOTICE] switch_core_state_machine.c:134 switch_core_standard_on_execute() Execute fdial(OUT_CALL|WLAN|72|sofia/gateway/gw_phone72/7704@192.168.1.250:5085)
2008-03-06 12:43:02 [DEBUG] mod_fdial.c:129 fdial_main_seperate_function_call_data() OUTGOING call ...
2008-03-06 12:43:02 [DEBUG] mod_fdial.c:314 fdial_main_seperate_parameters() FMC User id is: "72"
2008-03-06 12:43:02 [DEBUG] mod_fdial.c:326 fdial_main_seperate_parameters() FMC User domain set to default (local)
2008-03-06 12:43:02 [DEBUG] mod_fdial.c:352 fdial_main_seperate_parameters() FMC member type is: "WLAN"
2008-03-06 12:43:02 [DEBUG] mod_fdial.c:358 fdial_main_seperate_parameters() Foreign number is: "sofia/gateway/gw_phone72/7704@192.168.1.250:5085"
2008-03-06 12:43:02 [DEBUG] mod_fdial.c:1091 fdial_function() Looking for a controller for user "72"
2008-03-06 12:43:02 [DEBUG] controller.c:478 fdial_controller_find() Finding controller with hash "72@local" ... 
2008-03-06 12:43:02 [DEBUG] controller.c:478 fdial_controller_find() Finding controller with hash "72@local" ... 
2008-03-06 12:43:02 [DEBUG] mod_fdial.c:446 fdial_main_find_controller() Could not find the controller for the specified user!
2008-03-06 12:43:02 [DEBUG] config.c:99 fdial_config_get_fmc_section_for_user() Looking for fmc section for name "72" with XML_DB
2008-03-06 12:43:02 [DEBUG] config.c:158 fdial_config_get_param_from_fmc_section() fmc param [GSM]=[sofia/gateway/gw_phone72/8312954582]
2008-03-06 12:43:02 [DEBUG] config.c:158 fdial_config_get_param_from_fmc_section() fmc param [WLAN]=[sofia/local/72]
2008-03-06 12:43:02 [DEBUG] config.c:158 fdial_config_get_param_from_fmc_section() fmc param [GSM]=[sofia/gateway/gw_phone72/8312954582]
2008-03-06 12:43:02 [DEBUG] config.c:158 fdial_config_get_param_from_fmc_section() fmc param [GSM]=[sofia/gateway/gw_phone72/8312954582]
2008-03-06 12:43:02 [DEBUG] config.c:158 fdial_config_get_param_from_fmc_section() fmc param [WLAN]=[sofia/local/72]
2008-03-06 12:43:02 [DEBUG] config.c:158 fdial_config_get_param_from_fmc_section() fmc param [FMC_NUMBER]=[7702]
2008-03-06 12:43:02 [INFO] mod_fdial.c:555 fdial_main_start_fdial_call() Calling the destination number "sofia/gateway/gw_phone72/7704@192.168.1.250:5085" ... 
2008-03-06 12:43:02 [INFO] glue.c:81 fdial_glue_dial() CF_BYPASS_MEDIA is TRUE
2008-03-06 12:43:02 [INFO] switch_core_session.c:188 switch_core_session_outgoing_channel() switch_core_session_outgoing_channel
2008-03-06 12:43:02 [NOTICE] switch_channel.c:392 switch_channel_set_name() New Chan sofia/phone72/7704@192.168.1.250:5085 [4dc8367a-fb20-4ef9-ae61-267043883df8]
2008-03-06 12:43:02 [DEBUG] mod_sofia.c:1804 sofia_outgoing_channel() sofia/phone72/7704@192.168.1.250:5085 State Change CS_NEW -> CS_INIT
2008-03-06 12:43:02 [DEBUG] switch_core_session.c:649 switch_core_session_signal_state_change() Kill sofia/phone72/7704@192.168.1.250:5085 [BREAK]
2008-03-06 12:43:02 [INFO] switch_core_session.c:288 switch_core_session_outgoing_channel() set SWITCH_B_SDP_VARIABLE to SWITCH_R_SDP_VARIABLE
2008-03-06 12:43:02 [DEBUG] switch_core_state_machine.c:397 switch_core_session_run() (sofia/phone72/7704@192.168.1.250:5085) State INIT
2008-03-06 12:43:02 [DEBUG] mod_sofia.c:105 sofia_on_init() SOFIA INIT
2008-03-06 12:43:02 [INFO] mod_sofia.c:107 sofia_on_init() calling sofia_glue_tech_absorb_sdp
2008-03-06 12:43:02 [INFO] sofia_glue.c:878 sofia_glue_tech_absorb_sdp() found SWITCH_B_SDP_VARIABLE
2008-03-06 12:43:02 [INFO] sofia_glue.c:134 sofia_glue_set_local_sdp() sofia_glue_set_local_sdp. ip: (null), port: 0
2008-03-06 12:43:02 [INFO] sofia_glue.c:142 sofia_glue_set_local_sdp() !force && !ip && !sr && switch_channel_test_flag(tech_pvt->channel, CF_BYPASS_MEDIA)
2008-03-06 12:43:02 [DEBUG] sofia.c:370 sofia_event_callback() event [nua_i_state] status [0][INVITE sent] session: sofia/phone72/7704@192.168.1.250:5085
2008-03-06 12:43:02 [DEBUG] sofia.c:1478 sofia_handle_sip_i_state() Channel sofia/phone72/7704@192.168.1.250:5085 entering state [calling]
2008-03-06 12:43:02 [DEBUG] sofia.c:370 sofia_event_callback() event [nua_r_invite] status [407][Proxy Authentication Required] session: sofia/phone72/7704@192.168.1.250:5085
2008-03-06 12:43:02 [DEBUG] sofia_reg.c:931 sofia_reg_handle_sip_r_challenge() Authenticating '7702' with 'Digest:"asterisk":7702:test'.
2008-03-06 12:43:02 [DEBUG] sofia.c:370 sofia_event_callback() event [nua_i_state] status [0][INVITE sent] session: sofia/phone72/7704@192.168.1.250:5085
2008-03-06 12:43:02 [DEBUG] sofia.c:1478 sofia_handle_sip_i_state() Channel sofia/phone72/7704@192.168.1.250:5085 entering state [calling]
2008-03-06 12:43:02 [NOTICE] switch_channel.c:392 switch_channel_set_name() New Chan sofia/phone74/7702@192.168.1.250:5085 [4b37b739-7689-4fdb-915e-1cb7a197ec57]
2008-03-06 12:43:02 [DEBUG] sofia.c:1478 sofia_handle_sip_i_state() Channel sofia/phone74/7702@192.168.1.250:5085 entering state [received]
2008-03-06 12:43:02 [DEBUG] sofia.c:1482 sofia_handle_sip_i_state() Remote SDP:
v=0
o=root 3644 3644 IN IP4 192.168.1.250
s=session
c=IN IP4 192.168.1.250
t=0 0
m=audio 19242 RTP/AVP 0 3 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:3 GSM/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -

2008-03-06 12:43:02 [DEBUG] sofia_glue.c:1434 sofia_glue_negotiate_sdp() Audio Codec Compare [PCMU:0:8000]/[PCMA:8:8000]
2008-03-06 12:43:02 [DEBUG] sofia_glue.c:1434 sofia_glue_negotiate_sdp() Audio Codec Compare [GSM:3:8000]/[PCMA:8:8000]
2008-03-06 12:43:02 [DEBUG] sofia_glue.c:1434 sofia_glue_negotiate_sdp() Audio Codec Compare [PCMA:8:8000]/[PCMA:8:8000]
2008-03-06 12:43:02 [INFO] sofia_glue.c:1509 sofia_glue_negotiate_sdp() m->m_mode == sdp_sendrecv, inactive,sendonly = 0
2008-03-06 12:43:02 [DEBUG] sofia_glue.c:1040 sofia_glue_tech_set_codec() Set Codec sofia/phone74/7702@192.168.1.250:5085 PCMA/8000 20 ms 160 samples
2008-03-06 12:43:02 [DEBUG] sofia_glue.c:1398 sofia_glue_negotiate_sdp() Set 2833 dtmf payload to 101
2008-03-06 12:43:02 [DEBUG] sofia_glue.c:1638 sofia_glue_negotiate_sdp() neither sendonly or inactive
2008-03-06 12:43:02 [DEBUG] sofia_glue.c:1669 sofia_glue_negotiate_sdp() TFLAG_SIP_HOLD not set, doing nothing
2008-03-06 12:43:02 [DEBUG] sofia.c:1592 sofia_handle_sip_i_state() sofia/phone74/7702@192.168.1.250:5085 State Change CS_NEW -> CS_INIT
2008-03-06 12:43:02 [DEBUG] switch_core_session.c:649 switch_core_session_signal_state_change() Kill sofia/phone74/7702@192.168.1.250:5085 [BREAK]
2008-03-06 12:43:02 [DEBUG] switch_core_state_machine.c:397 switch_core_session_run() (sofia/phone74/7702@192.168.1.250:5085) State INIT
2008-03-06 12:43:02 [DEBUG] mod_sofia.c:105 sofia_on_init() SOFIA INIT
2008-03-06 12:43:02 [INFO] mod_sofia.c:111 sofia_on_init() NOT calling sofia_glue_tech_absorb_sdp
2008-03-06 12:43:02 [DEBUG] mod_sofia.c:122 sofia_on_init() sofia/phone74/7702@192.168.1.250:5085 State Change CS_INIT -> CS_RING
2008-03-06 12:43:02 [DEBUG] switch_core_session.c:649 switch_core_session_signal_state_change() Kill sofia/phone74/7702@192.168.1.250:5085 [BREAK]
2008-03-06 12:43:02 [DEBUG] switch_core_state_machine.c:400 switch_core_session_run() (sofia/phone74/7702@192.168.1.250:5085) State RING
2008-03-06 12:43:02 [DEBUG] mod_sofia.c:137 sofia_on_ring() SOFIA RING
2008-03-06 12:43:02 [DEBUG] switch_core_state_machine.c:64 switch_core_standard_on_ring() Standard RING sofia/phone74/7702@192.168.1.250:5085
2008-03-06 12:43:02 [INFO] mod_dialplan_xml.c:217 dialplan_hunt() Processing 7702->7704!
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /3760/
2008-03-06 12:43:02 [DEBUG] sofia.c:370 sofia_event_callback() event [nua_r_invite] status [180][Ringing] session: sofia/phone72/7704@192.168.1.250:5085
2008-03-06 12:43:02 [DEBUG] sofia.c:370 sofia_event_callback() event [nua_i_state] status [180][Ringing] session: sofia/phone72/7704@192.168.1.250:5085
2008-03-06 12:43:02 [DEBUG] sofia.c:1478 sofia_handle_sip_i_state() Channel sofia/phone72/7704@192.168.1.250:5085 entering state [proceeding]
2008-03-06 12:43:02 [NOTICE] sofia.c:1510 sofia_handle_sip_i_state() Ring-Ready sofia/phone72/7704@192.168.1.250:5085!
2008-03-06 12:43:02 [NOTICE] mod_sofia.c:1040 sofia_receive_message() Ring-Ready sofia/local/72@192.168.1.101:5060!
2008-03-06 12:43:02 [DEBUG] switch_core_session.c:352 switch_core_session_receive_message() Kill sofia/local/72@192.168.1.101:5060 [BREAK]
2008-03-06 12:43:02 [DEBUG] sofia.c:370 sofia_event_callback() event [nua_i_state] status [180][Ringing] session: sofia/local/72@192.168.1.101:5060
2008-03-06 12:43:02 [DEBUG] sofia.c:1478 sofia_handle_sip_i_state() Channel sofia/local/72@192.168.1.101:5060 entering state [early]
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^(.*)%23(.*)$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^\*\*8([0-3])$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^\*\*81(\d+)$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^\*\*82(\d+)$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^\*\*83(\d+)$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^\*341\*$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^\*342\*$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^\*343\*$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^\*344\*$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^\*345\*$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^\*346\*$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^\*347\*$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^(\*241\*|\*21)$/
2008-03-06 12:43:02 [DEBUG] mod_sofia.c:122 sofia_on_init() sofia/phone72/7704@192.168.1.250:5085 State Change CS_INIT -> CS_RING
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^(\*242\*|\*22)$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^(\*242\*|\*23)$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^(\*244\*|\*24)$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^(\*245\*|\*25)$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^(\*246\*|\*26)$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions ${sip_req_port}(12002) =~ /^1[23][0-9]{3}$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions ${fmc_id}() =~ /^$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions ${enterprise}() =~ /^$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^7702$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions ${sip_req_port}(12002) =~ /^1[23][0-9]{3}$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions ${fmc_id}() =~ /^$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions ${enterprise}() =~ /^$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^7703$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:108 parse_exten() Regex mismatch
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions ${sip_req_port}(12002) =~ /^1[23][0-9]{3}$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions ${fmc_id}() =~ /^$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions ${enterprise}() =~ /^$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:106 parse_exten() test conditions destination_number(7704) =~ /^7704$/
2008-03-06 12:43:02 [DEBUG] mod_dialplan_xml.c:273 dialplan_hunt() sofia/phone74/7702@192.168.1.250:5085 State Change CS_RING -> CS_EXECUTE
2008-03-06 12:43:02 [DEBUG] switch_core_session.c:649 switch_core_session_signal_state_change() Kill sofia/phone74/7702@192.168.1.250:5085 [BREAK]
2008-03-06 12:43:02 [DEBUG] switch_core_state_machine.c:406 switch_core_session_run() (sofia/phone74/7702@192.168.1.250:5085) State EXECUTE
2008-03-06 12:43:02 [DEBUG] mod_sofia.c:153 sofia_on_execute() SOFIA EXECUTE
2008-03-06 12:43:02 [DEBUG] switch_core_state_machine.c:121 switch_core_standard_on_execute() Standard EXECUTE
2008-03-06 12:43:02 [NOTICE] switch_core_state_machine.c:134 switch_core_standard_on_execute() Execute check_cf_always()
2008-03-06 12:43:03 [DEBUG] sofia_comdasys_callfwd.c:176 regnum_to_sip_uid() dest_num: 7704
2008-03-06 12:43:03 [DEBUG] sofia_comdasys_callfwd.c:705 check_cf() call forwarding not enabled for sip uid: 4 and cf_type: ALWAYS
2008-03-06 12:43:03 [NOTICE] switch_core_state_machine.c:134 switch_core_standard_on_execute() Execute set(bypass_media=true)
2008-03-06 12:43:03 [DEBUG] mod_dptools.c:463 set_function() SET [bypass_media]=[true]
2008-03-06 12:43:03 [NOTICE] switch_core_state_machine.c:134 switch_core_standard_on_execute() Execute fdial(INC_CALL|WLAN|74)
2008-03-06 12:43:03 [DEBUG] mod_fdial.c:122 fdial_main_seperate_function_call_data() INCOMING call ...
2008-03-06 12:43:03 [DEBUG] mod_fdial.c:314 fdial_main_seperate_parameters() FMC User id is: "74"
2008-03-06 12:43:03 [DEBUG] mod_fdial.c:326 fdial_main_seperate_parameters() FMC User domain set to default (local)
2008-03-06 12:43:03 [DEBUG] mod_fdial.c:352 fdial_main_seperate_parameters() FMC member type is: "WLAN"
2008-03-06 12:43:03 [INFO] mod_fdial.c:1004 fdial_function() Starting main fdial call for incoming...
2008-03-06 12:43:03 [DEBUG] controller.c:478 fdial_controller_find() Finding controller with hash "74@local" ... 
2008-03-06 12:43:03 [DEBUG] controller.c:478 fdial_controller_find() Finding controller with hash "74@local" ... 
2008-03-06 12:43:03 [DEBUG] mod_fdial.c:446 fdial_main_find_controller() Could not find the controller for the specified user!
2008-03-06 12:43:03 [DEBUG] config.c:99 fdial_config_get_fmc_section_for_user() Looking for fmc section for name "74" with XML_DB
2008-03-06 12:43:03 [DEBUG] config.c:158 fdial_config_get_param_from_fmc_section() fmc param [GSM]=[sofia/gateway/gw_phone74/18314642625]
2008-03-06 12:43:03 [DEBUG] config.c:158 fdial_config_get_param_from_fmc_section() fmc param [WLAN]=[sofia/local/74]
2008-03-06 12:43:03 [DEBUG] config.c:158 fdial_config_get_param_from_fmc_section() fmc param [GSM]=[sofia/gateway/gw_phone74/18314642625]
2008-03-06 12:43:03 [DEBUG] config.c:158 fdial_config_get_param_from_fmc_section() fmc param [GSM]=[sofia/gateway/gw_phone74/18314642625]
2008-03-06 12:43:03 [DEBUG] config.c:158 fdial_config_get_param_from_fmc_section() fmc param [WLAN]=[sofia/local/74]
2008-03-06 12:43:03 [DEBUG] config.c:158 fdial_config_get_param_from_fmc_section() fmc param [FMC_NUMBER]=[7704]
2008-03-06 12:43:03 [INFO] mod_fdial.c:555 fdial_main_start_fdial_call() Calling the destination number "sofia/local/74" ... 
2008-03-06 12:43:03 [INFO] glue.c:81 fdial_glue_dial() CF_BYPASS_MEDIA is TRUE
2008-03-06 12:43:03 [INFO] switch_core_session.c:188 switch_core_session_outgoing_channel() switch_core_session_outgoing_channel
2008-03-06 12:43:03 [NOTICE] switch_channel.c:392 switch_channel_set_name() New Chan sofia/local/74 [e015644a-f433-46c3-8278-f81218d2453f]
2008-03-06 12:43:03 [DEBUG] mod_sofia.c:1804 sofia_outgoing_channel() sofia/local/74 State Change CS_NEW -> CS_INIT
2008-03-06 12:43:03 [DEBUG] switch_core_session.c:649 switch_core_session_signal_state_change() Kill sofia/local/74 [BREAK]
2008-03-06 12:43:03 [INFO] switch_core_session.c:288 switch_core_session_outgoing_channel() set SWITCH_B_SDP_VARIABLE to SWITCH_R_SDP_VARIABLE
2008-03-06 12:43:03 [DEBUG] switch_core_state_machine.c:397 switch_core_session_run() (sofia/local/74) State INIT
2008-03-06 12:43:03 [DEBUG] mod_sofia.c:105 sofia_on_init() SOFIA INIT
2008-03-06 12:43:03 [INFO] mod_sofia.c:107 sofia_on_init() calling sofia_glue_tech_absorb_sdp
2008-03-06 12:43:03 [INFO] sofia_glue.c:878 sofia_glue_tech_absorb_sdp() found SWITCH_B_SDP_VARIABLE
2008-03-06 12:43:03 [INFO] sofia_glue.c:134 sofia_glue_set_local_sdp() sofia_glue_set_local_sdp. ip: (null), port: 0
2008-03-06 12:43:03 [INFO] sofia_glue.c:142 sofia_glue_set_local_sdp() !force && !ip && !sr && switch_channel_test_flag(tech_pvt->channel, CF_BYPASS_MEDIA)
2008-03-06 12:43:03 [DEBUG] sofia.c:370 sofia_event_callback() event [nua_i_state] status [0][INVITE sent] session: sofia/local/74
2008-03-06 12:43:03 [DEBUG] sofia.c:1478 sofia_handle_sip_i_state() Channel sofia/local/74 entering state [calling]
2008-03-06 12:43:03 [DEBUG] mod_sofia.c:122 sofia_on_init() sofia/local/74 State Change CS_INIT -> CS_RING
2008-03-06 12:43:03 [DEBUG] switch_core_session.c:649 switch_core_session_signal_state_change() Kill sofia/local/74 [BREAK]
2008-03-06 12:43:03 [DEBUG] switch_core_state_machine.c:400 switch_core_session_run() (sofia/local/74) State RING
2008-03-06 12:43:03 [DEBUG] mod_sofia.c:137 sofia_on_ring() SOFIA RING
2008-03-06 12:43:03 [DEBUG] glue.c:19 fdial_on_ring() CUSTOM RING
2008-03-06 12:43:03 [DEBUG] glue.c:22 fdial_on_ring() sofia/local/74 State Change CS_RING -> CS_TRANSMIT
2008-03-06 12:43:03 [DEBUG] switch_core_session.c:649 switch_core_session_signal_state_change() Kill sofia/local/74 [BREAK]
2008-03-06 12:43:03 [DEBUG] switch_core_state_machine.c:412 switch_core_session_run() (sofia/local/74) State TRANSMIT
2008-03-06 12:43:03 [DEBUG] mod_sofia.c:292 sofia_on_transmit() SOFIA TRANSMIT
2008-03-06 12:43:03 [DEBUG] switch_core_state_machine.c:198 switch_core_standard_on_transmit() Standard TRANSMIT
2008-03-06 12:43:03 [DEBUG] switch_core_session.c:649 switch_core_session_signal_state_change() Kill sofia/phone72/7704@192.168.1.250:5085 [BREAK]
2008-03-06 12:43:03 [DEBUG] switch_core_state_machine.c:400 switch_core_session_run() (sofia/phone72/7704@192.168.1.250:5085) State RING
2008-03-06 12:43:03 [DEBUG] mod_sofia.c:137 sofia_on_ring() SOFIA RING
2008-03-06 12:43:03 [DEBUG] glue.c:19 fdial_on_ring() CUSTOM RING
2008-03-06 12:43:03 [DEBUG] glue.c:22 fdial_on_ring() sofia/phone72/7704@192.168.1.250:5085 State Change CS_RING -> CS_TRANSMIT
2008-03-06 12:43:03 [DEBUG] switch_core_session.c:649 switch_core_session_signal_state_change() Kill sofia/phone72/7704@192.168.1.250:5085 [BREAK]
2008-03-06 12:43:03 [DEBUG] switch_core_state_machine.c:412 switch_core_session_run() (sofia/phone72/7704@192.168.1.250:5085) State TRANSMIT
2008-03-06 12:43:03 [DEBUG] mod_sofia.c:292 sofia_on_transmit() SOFIA TRANSMIT
2008-03-06 12:43:03 [DEBUG] switch_core_state_machine.c:198 switch_core_standard_on_transmit() Standard TRANSMIT
2008-03-06 12:43:03 [DEBUG] sofia.c:370 sofia_event_callback() event [nua_r_invite] status [180][Ringing] session: sofia/local/74
2008-03-06 12:43:03 [DEBUG] sofia.c:370 sofia_event_callback() event [nua_i_state] status [180][Ringing] session: sofia/local/74
2008-03-06 12:43:03 [DEBUG] sofia.c:1478 sofia_handle_sip_i_state() Channel sofia/local/74 entering state [proceeding]
2008-03-06 12:43:03 [NOTICE] sofia.c:1510 sofia_handle_sip_i_state() Ring-Ready sofia/local/74!
2008-03-06 12:43:03 [DEBUG] sofia.c:370 sofia_event_callback() event [nua_i_state] status [180][Ringing] session: sofia/phone74/7702@192.168.1.250:5085
2008-03-06 12:43:03 [DEBUG] sofia.c:1478 sofia_handle_sip_i_state() Channel sofia/phone74/7702@192.168.1.250:5085 entering state [early]
2008-03-06 12:43:03 [NOTICE] mod_sofia.c:1040 sofia_receive_message() Ring-Ready sofia/phone74/7702@192.168.1.250:5085!
2008-03-06 12:43:03 [DEBUG] switch_core_session.c:352 switch_core_session_receive_message() Kill sofia/phone74/7702@192.168.1.250:5085 [BREAK]
2008-03-06 12:43:06 [DEBUG] sofia.c:1478 sofia_handle_sip_i_state() Channel sofia/local/74 entering state [ready]
2008-03-06 12:43:06 [DEBUG] sofia.c:1482 sofia_handle_sip_i_state() Remote SDP:
v=0
o=74 16156984 1205031387 IN IP4 192.168.1.101
s=-
c=IN IP4 192.168.1.101
t=0 0
m=audio 8000 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20

2008-03-06 12:43:06 [DEBUG] switch_channel.c:1219 switch_channel_perform_mark_answered() Kill sofia/phone74/7702@192.168.1.250:5085 [BREAK]
2008-03-06 12:43:06 [NOTICE] sofia.c:1738 sofia_handle_sip_i_state() Channel [sofia/local/74] has been answered
2008-03-06 12:43:06 [DEBUG] switch_core_session.c:352 switch_core_session_receive_message() Kill sofia/phone74/7702@192.168.1.250:5085 [BREAK]
2008-03-06 12:43:06 [NOTICE] sofia.c:1745 sofia_handle_sip_i_state() Channel [sofia/phone74/7702@192.168.1.250:5085] has been answered
2008-03-06 12:43:06 [DEBUG] switch_ivr_originate.c:846 switch_ivr_originate() Originate Resulted in Success: [sofia/local/74]
2008-03-06 12:43:06 [INFO] mod_fdial.c:583 fdial_main_start_fdial_call() Calling peer successfully. Start a new fdial session...
2008-03-06 12:43:06 [DEBUG] glue.c:122 fdial_glue_set_bridge_variables() Setting bridge variables for transfer between "sofia/phone74/7702@192.168.1.250:5085" and "sofia/local/74"... 
2008-03-06 12:43:06 [DEBUG] alien.c:71 fdial_alien_add() (alien): "#0/74@local" -- Adding alien to the given list ...
2008-03-06 12:43:06 [DEBUG] member.c:143 fdial_member_create_thread() (wlan): "#0/74@local" -- creating member thread.
2008-03-06 12:43:06 [DEBUG] member.c:514 fdial_member_main() (alien): "#1/74@local" -- Member loop entered for channel: "sofia/phone74/7702@192.168.1.250:5085". Initializing some stuff ...
2008-03-06 12:43:06 [DEBUG] member.c:593 fdial_member_main() (alien): "#1/74@local" -- Closing the old member is not set in member! Continue ...
2008-03-06 12:43:06 [DEBUG] glue.c:295 fdial_glue_initalize_codec() Raw Codec Activation Success L16@8000hz 1 channel 20ms
2008-03-06 12:43:06 [DEBUG] member.c:1648 fdial_member_set_sln_codec() (alien): "#1/74@local" -- orig read codec settings (PCMA) :
 sps: 8000, mpf: 20000, spf: 160, bpf: 320, ebpf: 160, noc: 1, pfpp: 1, mfpp: 1
2008-03-06 12:43:06 [DEBUG] member.c:1660 fdial_member_set_sln_codec() (alien): "#1/74@local" -- new read codec settings (L16):
 sps: 8000, mpf: 20000, spf: 160, bpf: 320, ebpf: 320, noc: 1, pfpp: 1, mfpp: 1
2008-03-06 12:43:06 [DEBUG] glue.c:295 fdial_glue_initalize_codec() Raw Codec Activation Success L16@8000hz 1 channel 20ms
2008-03-06 12:43:06 [DEBUG] member.c:1701 fdial_member_set_sln_codec() (alien): "#1/74@local" -- orig write codec settings (PCMA):
 sps: 8000, mpf: 20000, spf: 160, bpf: 320, ebpf: 160, noc: 1, pfpp: 1, mfpp: 1
2008-03-06 12:43:06 [DEBUG] member.c:1713 fdial_member_set_sln_codec() (alien): "#1/74@local" -- new write codec settings (L16):
 sps: 8000, mpf: 20000, spf: 160, bpf: 320, ebpf: 320, noc: 1, pfpp: 1, mfpp: 1
2008-03-06 12:43:06 [DEBUG] member.c:139 fdial_member_create_thread() (alien): "#1/74@local" -- creating outgoing member thread.
2008-03-06 12:43:06 [INFO] member.c:621 fdial_member_main() (alien): "#1/74@local" -- Starting member loop ...
2008-03-06 12:43:06 [INFO] member.c:841 fdial_member_loop() Peer of member "#1" (type: alien) has answered. Call is up now ...

2008-03-06 12:43:06 [DEBUG] sofia.c:1478 sofia_handle_sip_i_state() Channel sofia/phone74/7702@192.168.1.250:5085 entering state [completed]
2008-03-06 12:43:06 [DEBUG] sofia.c:1478 sofia_handle_sip_i_state() Channel sofia/phone74/7702@192.168.1.250:5085 entering state [ready]
2008-03-06 12:43:06 [DEBUG] sofia.c:1478 sofia_handle_sip_i_state() Channel sofia/phone72/7704@192.168.1.250:5085 entering state [ready]
2008-03-06 12:43:06 [DEBUG] sofia.c:1482 sofia_handle_sip_i_state() Remote SDP:
v=0
o=root 3644 3644 IN IP4 192.168.1.250
s=session
c=IN IP4 192.168.1.250
t=0 0
m=audio 18930 RTP/AVP 3 0 8 101
a=rtpmap:3 GSM/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -

2008-03-06 12:43:06 [DEBUG] switch_channel.c:1219 switch_channel_perform_mark_answered() Kill sofia/local/72@192.168.1.101:5060 [BREAK]
2008-03-06 12:43:06 [NOTICE] sofia.c:1738 sofia_handle_sip_i_state() Channel [sofia/phone72/7704@192.168.1.250:5085] has been answered
2008-03-06 12:43:06 [DEBUG] switch_core_session.c:352 switch_core_session_receive_message() Kill sofia/local/72@192.168.1.101:5060 [BREAK]
2008-03-06 12:43:06 [NOTICE] sofia.c:1745 sofia_handle_sip_i_state() Channel [sofia/local/72@192.168.1.101:5060] has been answered
nta-comdasys: Setting comdasys fmc uid of call id "94cc00bf-e283bcf1@192.168.1.70", to "72"
2008-03-06 12:43:06 [DEBUG] switch_ivr_originate.c:846 switch_ivr_originate() Originate Resulted in Success: [sofia/phone72/7704@192.168.1.250:5085]
2008-03-06 12:43:06 [INFO] mod_fdial.c:583 fdial_main_start_fdial_call() Calling peer successfully. Start a new fdial session...
2008-03-06 12:43:06 [DEBUG] glue.c:122 fdial_glue_set_bridge_variables() Setting bridge variables for transfer between "sofia/local/72@192.168.1.101:5060" and "sofia/phone72/7704@192.168.1.250:5085"... 
2008-03-06 12:43:06 [DEBUG] alien.c:71 fdial_alien_add() (alien): "#0/72@local" -- Adding alien to the given list ...
2008-03-06 12:43:06 [DEBUG] member.c:143 fdial_member_create_thread() (alien): "#0/72@local" -- creating member thread.
2008-03-06 12:43:06 [DEBUG] member.c:514 fdial_member_main() (wlan): "#1/72@local" -- Member loop entered for channel: "sofia/local/72@192.168.1.101:5060". Initializing some stuff ...
2008-03-06 12:43:06 [DEBUG] mod_sofia.c:1105 sofia_receive_message() Setting the FMC UID "72" of call_id "94cc00bf-e283bcf1@192.168.1.70" to sofia_sip
2008-03-06 12:43:06 [DEBUG] switch_core_session.c:352 switch_core_session_receive_message() Kill sofia/local/72@192.168.1.101:5060 [BREAK]
2008-03-06 12:43:06 [DEBUG] member.c:593 fdial_member_main() (wlan): "#1/72@local" -- Closing the old member is not set in member! Continue ...
2008-03-06 12:43:06 [DEBUG] glue.c:295 fdial_glue_initalize_codec() Raw Codec Activation Success L16@8000hz 1 channel 20ms
2008-03-06 12:43:06 [DEBUG] member.c:1648 fdial_member_set_sln_codec() (wlan): "#1/72@local" -- orig read codec settings (PCMU) :
 sps: 8000, mpf: 20000, spf: 160, bpf: 320, ebpf: 160, noc: 1, pfpp: 1, mfpp: 1
2008-03-06 12:43:06 [DEBUG] member.c:1660 fdial_member_set_sln_codec() (wlan): "#1/72@local" -- new read codec settings (L16):
 sps: 8000, mpf: 20000, spf: 160, bpf: 320, ebpf: 320, noc: 1, pfpp: 1, mfpp: 1
2008-03-06 12:43:06 [DEBUG] glue.c:295 fdial_glue_initalize_codec() Raw Codec Activation Success L16@8000hz 1 channel 20ms
2008-03-06 12:43:06 [DEBUG] member.c:1701 fdial_member_set_sln_codec() (wlan): "#1/72@local" -- orig write codec settings (PCMU):
 sps: 8000, mpf: 20000, spf: 160, bpf: 320, ebpf: 160, noc: 1, pfpp: 1, mfpp: 1
2008-03-06 12:43:06 [DEBUG] member.c:1713 fdial_member_set_sln_codec() (wlan): "#1/72@local" -- new write codec settings (L16):
 sps: 8000, mpf: 20000, spf: 160, bpf: 320, ebpf: 320, noc: 1, pfpp: 1, mfpp: 1
2008-03-06 12:43:06 [DEBUG] member.c:139 fdial_member_create_thread() (wlan): "#1/72@local" -- creating outgoing member thread.
2008-03-06 12:43:06 [INFO] member.c:621 fdial_member_main() (wlan): "#1/72@local" -- Starting member loop ...
2008-03-06 12:43:06 [INFO] member.c:841 fdial_member_loop() Peer of member "#1" (type: wlan) has answered. Call is up now ...

2008-03-06 12:43:06 [DEBUG] sofia.c:1478 sofia_handle_sip_i_state() Channel sofia/local/72@192.168.1.101:5060 entering state [completed]
2008-03-06 12:43:06 [DEBUG] sofia.c:1478 sofia_handle_sip_i_state() Channel sofia/local/72@192.168.1.101:5060 entering state [ready]
2008-03-06 12:43:06 [DEBUG] controller.c:134 fdial_controller_thread_run() controller "74@local" loop started...
2008-03-06 12:43:06 [DEBUG] controller.c:147 fdial_controller_thread_run() setup timer successfully. interval: 10  samples: 80
2008-03-06 12:43:06 [DEBUG] member.c:514 fdial_member_main() (wlan): "#2/74@local" -- Member loop entered for channel: "sofia/local/74". Initializing some stuff ...
2008-03-06 12:43:06 [DEBUG] mod_sofia.c:1105 sofia_receive_message() Setting the FMC UID "74" of call_id "c20b43a9-6660-122b-b0bd-00123f09e397" to sofia_sip
nta-comdasys: Setting comdasys fmc uid of call id "c20b43a9-6660-122b-b0bd-00123f09e397", to "74"
2008-03-06 12:43:06 [DEBUG] switch_core_session.c:352 switch_core_session_receive_message() Kill sofia/local/74 [BREAK]
2008-03-06 12:43:06 [DEBUG] member.c:593 fdial_member_main() (wlan): "#2/74@local" -- Closing the old member is not set in member! Continue ...
Segmentation fault (core dumped)