freeswitch@jalsot> nta: timer K fired, terminate REGISTER (74819405) outgoing_reclaim_all(bogus %p bogus %p bogus %p nta_outgoing_timer: 0/0 resent, 0/0 tout, 1/1 term, 1/1 free recv 745 bytes from udp/[192.168.1.10]:5060 at 15:11:25.671875: ------------------------------------------------------------------------ INVITE sip:667@10.23.45.9 SIP/2.0 Via: SIP/2.0/UDP 192.168.1.10:5060;branch=z9hG4bK71e5e557;rport From: "Tamas Jalsovszky, CTO" ;tag=as43d0e69f To: Contact: Call-ID: 7321958b27e2a461095ba7702adae4aa@192.168.1.10 CSeq: 102 INVITE User-Agent: eWorldComOffice Max-Forwards: 70 Date: Thu, 26 Oct 2006 15:11:32 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Content-Type: application/sdp Content-Length: 237 v=0 o=root 2611 2611 IN IP4 192.168.1.10 s=session c=IN IP4 192.168.1.10 t=0 0 m=audio 17422 RTP/AVP 3 8 101 a=rtpmap:3 GSM/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - ------------------------------------------------------------------------ nta: received INVITE sip:667@10.23.45.9 SIP/2.0 (CSeq 102) nta: canonizing sip:667@10.23.45.9 with contact nta: INVITE (102) going to a default leg nta_leg_create(bogus %p send 315 bytes to udp/[192.168.1.10]:5060 at 15:11:25.671875: ------------------------------------------------------------------------ SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.1.10:5060;branch=z9hG4bK71e5e557;rport=5060 From: "Tamas Jalsovszky, CTO" ;tag=as43d0e69f To: Call-ID: 7321958b27e2a461095ba7702adae4aa@192.168.1.10 CSeq: 102 INVITE User-Agent: FreeSWITCH(mod_sofia) Content-Length: 0 ------------------------------------------------------------------------ nta: sent 100 Trying for INVITE (102) 2006-10-26 17:11:25 [NOTICE] switch_channel.c:383 switch_channel_set_name() New Chan sofia/mytest1/202@192.168.1.10 [b5393fca-5ca8-2342-a670-162c8ed5666e] 2006-10-26 17:11:25 [DEBUG] mod_sofia.c:2322 sip_i_state() Channel sofia/mytest1 /202@192.168.1.10 entering state [received] 2006-10-26 17:11:25 [DEBUG] mod_sofia.c:2327 sip_i_state() Remote SDP: v=0 o=root 2611 2611 IN IP4 192.168.1.10 s=session c=IN IP4 192.168.1.10 t=0 0 m=audio 17422 RTP/AVP 3 8 101 a=rtpmap:3 GSM/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - 2006-10-26 17:11:25 [DEBUG] mod_sofia.c:2008 negotiate_sdp() Codec Compare [GSM: 3]/[gsm:3] 2006-10-26 17:11:25 [INFO] mod_sofia.c:1284 tech_set_codec() Set Codec sofia/myt est1/202@192.168.1.10 gsm/8000 20 ms 2006-10-26 17:11:25 [DEBUG] mod_sofia.c:2436 sip_i_state() sofia/mytest1/202@192 .168.1.10 State Change CS_NEW -> CS_INIT 2006-10-26 17:11:25 [DEBUG] switch_core.c:2762 switch_core_session_run() (sofia/ mytest1/202@192.168.1.10) State INIT 2006-10-26 17:11:25 [DEBUG] mod_sofia.c:1022 sofia_on_init() SOFIA INIT 2006-10-26 17:11:25 [DEBUG] mod_sofia.c:1039 sofia_on_init() sofia/mytest1/202@1 92.168.1.10 State Change CS_INIT -> CS_RING 2006-10-26 17:11:25 [DEBUG] switch_core.c:2798 switch_core_session_run() (sofia/ mytest1/202@192.168.1.10) State RING 2006-10-26 17:11:25 [DEBUG] mod_sofia.c:1055 sofia_on_ring() SOFIA RING 2006-10-26 17:11:25 [DEBUG] switch_core.c:2463 switch_core_standard_on_ring() St andard RING sofia/mytest1/202@192.168.1.10 2006-10-26 17:11:25 [INFO] mod_dialplan_xml.c:278 dialplan_hunt() Processing Tam as Jalsovszky, CTO->667! 2006-10-26 17:11:25 [DEBUG] mod_dialplan_xml.c:199 parse_exten() test conditions destination_number(667) =~ /^100$/ 2006-10-26 17:11:25 [DEBUG] mod_dialplan_xml.c:201 parse_exten() Regex mismatch 2006-10-26 17:11:25 [DEBUG] mod_dialplan_xml.c:199 parse_exten() test conditions destination_number(667) =~ /^202$/ 2006-10-26 17:11:25 [DEBUG] mod_dialplan_xml.c:201 parse_exten() Regex mismatch 2006-10-26 17:11:25 [DEBUG] mod_dialplan_xml.c:199 parse_exten() test conditions destination_number(667) =~ /^667$/ 2006-10-26 17:11:25 [DEBUG] mod_dialplan_xml.c:326 dialplan_hunt() sofia/mytest1 /202@192.168.1.10 State Change CS_RING -> CS_EXECUTE 2006-10-26 17:11:25 [DEBUG] switch_core.c:2834 switch_core_session_run() (sofia/ mytest1/202@192.168.1.10) State EXECUTE 2006-10-26 17:11:25 [DEBUG] mod_sofia.c:1073 sofia_on_execute() SOFIA EXECUTE 2006-10-26 17:11:25 [DEBUG] switch_core.c:2497 switch_core_standard_on_execute() Standard EXECUTE 2006-10-26 17:11:25 [NOTICE] switch_core.c:2506 switch_core_standard_on_execute( ) Execute bridge(portaudio) 2006-10-26 17:11:25 [NOTICE] switch_channel.c:383 switch_channel_set_name() New Chan PortAudio/mod_portaudio-0029 [ba839cc8-e37a-a34a-ad89-e258a2d51d54] 2006-10-26 17:11:25 [DEBUG] mod_portaudio.c:562 channel_outgoing_channel() PortA udio/mod_portaudio-0029 State Change CS_NEW -> CS_INIT 2006-10-26 17:11:25 [DEBUG] switch_core.c:2762 switch_core_session_run() (PortAu dio/mod_portaudio-0029) State INIT 2006-10-26 17:11:25 [INFO] mod_portaudio.c:793 engage_device() Loaded codec L16 8000hz 20ms on PortAudio/mod_portaudio-0029 2006-10-26 17:11:25 [DEBUG] mod_portaudio.c:154 channel_on_init() PortAudio/mod_ portaudio-0029 CHANNEL INIT 1 0 2006-10-26 17:11:25 [DEBUG] mod_portaudio.c:171 channel_on_init() BRRRRING! BRRR RING! call 0 2006-10-26 17:11:30 [DEBUG] mod_portaudio.c:171 channel_on_init() BRRRRING! BRRR RING! call 0 2006-10-26 17:11:35 [DEBUG] mod_portaudio.c:171 channel_on_init() BRRRRING! BRRR RING! call 0 2006-10-26 17:11:40 [DEBUG] mod_portaudio.c:171 channel_on_init() BRRRRING! BRRR RING! call 0 2006-10-26 17:11:45 [DEBUG] mod_portaudio.c:171 channel_on_init() BRRRRING! BRRR RING! call 0 shutdown 2006-10-26 17:11:48 [CONSOLE] switch_console.c:108 switch_console_process() Bye! 2006-10-26 17:11:48 [CONSOLE] switch_core.c:3886 switch_core_destroy() End exist ing sessions