July 2009 - FreeSWITCH-users - FreeSWITCH Mailing Lists

FreeSWITCH FYI: Interview With Anthony
by Michael Collins 30 Jul '09

30 Jul '09

FYI, BandwidthU's interview with Anthony has been posted. Click here<http://digg.com/d3yzzj>to visit part 3 of the interview which has links to parts one and two. Also, be sure to Digg it! Thanks, Michael

1 0

voip-voip echo cancel possible
by DA 30 Jul '09

30 Jul '09

We have a carrier that we receive calls from over SIP. They are getting the call from the PSTN and then sending to us as sip. We then get other calls to our FS via sip from other carriers that are also from the PSTN. We bridge these calls in FS. All connections to FS are sip. So. Party1--PSTN--Carrier1--FS--Carrier2--PSTN-party2 Problem is that Party2 hears echo of themselves. We chased it down and Carrier1 says it is because Party1's carrier is setting a bit in the ss7 connection that they are doing echo cancel (when in fact, they are not). So Carrier1 does not do any EC on the call before passing it to us. Is there any way that I could do the EC on this call in FS? >From what I have read on the list, it looks like the Zaptel Hardware or OSLEC type of EC would not work here since there is no zaptel/t1 connection involved with FS.

5 5

Can't proxy media
by Stefano Marinelli 30 Jul '09

30 Jul '09

Hi, I'm trying to proxy-media a call from my FS to my Callweaver. It's a fax T38 call. It seems that my carrier drops the call if t38 is not negotiated and doesn't go on with g711 (will post about it in some minutes, with details). So I decided to try to proxy-media from FS to CW but it fails: here's my dialplan: <include> <extension name="MYPHONENUMBER"> <condition field="destination_number" expression="^(MYPHONENUMBER)$"> <action application="set" data="domain_name=$${domain}"/> <action application="set" data="proxy_media=true"/>   <action application="bridge" data="sofia/gateway/callweaverfaxin369/faxin"/> <action application="hangup"/> </condition> </extension> </include> here's the log: 2009-07-30 16:01:37.24041 [NOTICE] switch_channel.c:602 New Channel sofia/external/002@CALLWEAVER_IP [7f3c5d6e-7d11-11de-a359-63ab50bb1362] 2009-07-30 16:01:37.24041 [DEBUG] sofia.c:3289 Channel sofia/external/002@CALLWEAVER_IP entering state [received][100] 2009-07-30 16:01:37.24041 [DEBUG] sofia.c:3296 Remote SDP: v=0 o=root 13583 13583 IN IP4 CALLWEAVER_IP s=session c=IN IP4 CALLWEAVER_IP t=0 0 m=audio 10028 RTP/AVP 8 0 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - 2009-07-30 16:01:37.24041 [DEBUG] sofia_glue.c:3071 Audio Codec Compare [PCMA:8:8000:0]/[PCMU:0:8000:20] 2009-07-30 16:01:37.24041 [DEBUG] sofia_glue.c:3071 Audio Codec Compare [PCMA:8:8000:0]/[PCMA:8:8000:20] 2009-07-30 16:01:37.24041 [DEBUG] sofia_glue.c:2029 Set Codec sofia/external/002@CALLWEAVER_IP PCMA/8000 20 ms 160 samples 2009-07-30 16:01:37.24041 [DEBUG] sofia_glue.c:3031 Set 2833 dtmf payload to 101 2009-07-30 16:01:37.24041 [DEBUG] sofia.c:3455 (sofia/external/002@CALLWEAVER_IP) State Change CS_NEW -> CS_INIT 2009-07-30 16:01:37.24041 [DEBUG] switch_core_session.c:932 Send signal sofia/external/002@CALLWEAVER_IP [BREAK] 2009-07-30 16:01:37.24041 [DEBUG] switch_core_state_machine.c:398 (sofia/external/002@CALLWEAVER_IP) Running State Change CS_INIT 2009-07-30 16:01:37.24041 [DEBUG] switch_core_state_machine.c:481 (sofia/external/002@CALLWEAVER_IP) State INIT 2009-07-30 16:01:37.24041 [DEBUG] mod_sofia.c:83 sofia/external/002@CALLWEAVER_IP SOFIA INIT 2009-07-30 16:01:37.24041 [DEBUG] mod_sofia.c:111 (sofia/external/002@CALLWEAVER_IP) State Change CS_INIT -> CS_ROUTING 2009-07-30 16:01:37.24041 [DEBUG] switch_core_session.c:932 Send signal sofia/external/002@CALLWEAVER_IP [BREAK] 2009-07-30 16:01:37.24041 [DEBUG] switch_core_state_machine.c:481 (sofia/external/002@CALLWEAVER_IP) State INIT going to sleep 2009-07-30 16:01:37.24041 [DEBUG] switch_core_state_machine.c:398 (sofia/external/002@CALLWEAVER_IP) Running State Change CS_ROUTING 2009-07-30 16:01:37.24041 [DEBUG] switch_core_state_machine.c:484 (sofia/external/002@CALLWEAVER_IP) State ROUTING 2009-07-30 16:01:37.24041 [DEBUG] mod_sofia.c:130 sofia/external/002@CALLWEAVER_IP SOFIA ROUTING 2009-07-30 16:01:37.24041 [DEBUG] switch_core_state_machine.c:78 sofia/external/002@CALLWEAVER_IP Standard ROUTING 2009-07-30 16:01:37.24041 [INFO] mod_dialplan_xml.c:315 Processing 002->MYEXT in context public Dialplan: sofia/external/002@CALLWEAVER_IP parsing [public->unloop] continue=false Dialplan: sofia/external/002@CALLWEAVER_IP Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false Dialplan: sofia/external/002@CALLWEAVER_IP Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false Dialplan: sofia/external/002@CALLWEAVER_IP parsing [public->outside_call] continue=true Dialplan: sofia/external/002@CALLWEAVER_IP Absolute Condition [outside_call] Dialplan: sofia/external/002@CALLWEAVER_IP Action set(outside_call=true) Dialplan: sofia/external/002@CALLWEAVER_IP parsing [public->call_debug] continue=true Dialplan: sofia/external/002@CALLWEAVER_IP Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never Dialplan: sofia/external/002@CALLWEAVER_IP parsing [public->public_extensions] continue=false Dialplan: sofia/external/002@CALLWEAVER_IP Regex (FAIL) [public_extensions] destination_number(MYEXT) =~ /^(10[01][0-9])$/ break=on-false Dialplan: sofia/external/002@CALLWEAVER_IP parsing [public->MYEXT] continue=false Dialplan: sofia/external/002@CALLWEAVER_IP Regex (PASS) [MYEXT] destination_number(MYEXT) =~ /^(MYEXT)$/ break=on-false Dialplan: sofia/external/002@CALLWEAVER_IP Action set(domain_name=FREESWITCH_IP) Dialplan: sofia/external/002@CALLWEAVER_IP Action set(proxy_media=true) Dialplan: sofia/external/002@CALLWEAVER_IP Action answer() Dialplan: sofia/external/002@CALLWEAVER_IP Action bridge(sofia/gateway/callweaverfaxin369/faxin) Dialplan: sofia/external/002@CALLWEAVER_IP Action hangup() 2009-07-30 16:01:37.24041 [DEBUG] switch_core_state_machine.c:114 (sofia/external/002@CALLWEAVER_IP) State Change CS_ROUTING -> CS_EXECUTE 2009-07-30 16:01:37.24041 [DEBUG] switch_core_session.c:932 Send signal sofia/external/002@CALLWEAVER_IP [BREAK] 2009-07-30 16:01:37.24041 [DEBUG] switch_core_state_machine.c:484 (sofia/external/002@CALLWEAVER_IP) State ROUTING going to sleep 2009-07-30 16:01:37.24041 [DEBUG] switch_core_state_machine.c:398 (sofia/external/002@CALLWEAVER_IP) Running State Change CS_EXECUTE 2009-07-30 16:01:37.24041 [DEBUG] switch_core_state_machine.c:491 (sofia/external/002@CALLWEAVER_IP) State EXECUTE 2009-07-30 16:01:37.24041 [DEBUG] mod_sofia.c:173 sofia/external/002@CALLWEAVER_IP SOFIA EXECUTE 2009-07-30 16:01:37.24041 [DEBUG] switch_core_state_machine.c:151 sofia/external/002@CALLWEAVER_IP Standard EXECUTE EXECUTE sofia/external/002@CALLWEAVER_IP set(outside_call=true) 2009-07-30 16:01:37.24041 [DEBUG] mod_dptools.c:748 sofia/external/002@CALLWEAVER_IP SET [outside_call]=[true] EXECUTE sofia/external/002@CALLWEAVER_IP set(domain_name=FREESWITCH_IP) 2009-07-30 16:01:37.24041 [DEBUG] mod_dptools.c:748 sofia/external/002@CALLWEAVER_IP SET [domain_name]=[FREESWITCH_IP] EXECUTE sofia/external/002@CALLWEAVER_IP set(proxy_media=true) 2009-07-30 16:01:37.24041 [DEBUG] mod_dptools.c:748 sofia/external/002@CALLWEAVER_IP SET [proxy_media]=[true] EXECUTE sofia/external/002@CALLWEAVER_IP answer() 2009-07-30 16:01:37.24041 [DEBUG] mod_dptools.c:649 sofia/external/002@CALLWEAVER_IP receive message [ANSWER] 2009-07-30 16:01:37.24041 [DEBUG] sofia_glue.c:2263 AUDIO RTP [sofia/external/002@CALLWEAVER_IP] FREESWITCH_IP port 24044 -> CALLWEAVER_IP port 10028 codec: 8 ms: 20 2009-07-30 16:01:37.24041 [DEBUG] switch_rtp.c:1138 Starting timer [soft] 160 bytes per 20ms 2009-07-30 16:01:37.30479 [DEBUG] mod_sofia.c:552 Local SDP sofia/external/002@CALLWEAVER_IP: v=0 o=FreeSWITCH 1248938453 1248938454 IN IP4 FREESWITCH_IP s=FreeSWITCH c=IN IP4 FREESWITCH_IP t=0 0 m=audio 24044 RTP/AVP 8 101 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - a=ptime:20 a=sendrecv 2009-07-30 16:01:37.30479 [DEBUG] switch_core_session.c:630 Send signal sofia/external/002@CALLWEAVER_IP [BREAK] 2009-07-30 16:01:37.30479 [NOTICE] mod_dptools.c:649 Channel [sofia/external/002@CALLWEAVER_IP] has been answered 2009-07-30 16:01:37.30479 [DEBUG] switch_channel.c:182 sofia/external/002@CALLWEAVER_IP receive message [AUDIO_SYNC] EXECUTE sofia/external/002@CALLWEAVER_IP bridge(sofia/gateway/callweaverfaxin369/faxin) 2009-07-30 16:01:37.30479 [NOTICE] switch_channel.c:602 New Channel sofia/external/faxin [7f3d2a46-7d11-11de-a359-63ab50bb1362] 2009-07-30 16:01:37.30479 [DEBUG] mod_sofia.c:2762 (sofia/external/faxin) State Change CS_NEW -> CS_INIT 2009-07-30 16:01:37.30479 [DEBUG] switch_core_session.c:932 Send signal sofia/external/faxin [BREAK] 2009-07-30 16:01:37.30479 [DEBUG] sofia.c:3289 Channel sofia/external/002@CALLWEAVER_IP entering state [completed][200] 2009-07-30 16:01:37.30479 [DEBUG] switch_core_state_machine.c:398 (sofia/external/faxin) Running State Change CS_INIT 2009-07-30 16:01:37.30479 [DEBUG] switch_core_state_machine.c:481 (sofia/external/faxin) State INIT 2009-07-30 16:01:37.30479 [DEBUG] mod_sofia.c:83 sofia/external/faxin SOFIA INIT 2009-07-30 16:01:37.30479 [DEBUG] sofia_glue.c:1290 sofia/external/faxin Patched SDP --- v=0 o=root 13583 13583 IN IP4 CALLWEAVER_IP s=session c=IN IP4 CALLWEAVER_IP t=0 0 m=audio 10028 RTP/AVP 8 0 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - +++ v=0 o=root 13583 13583 IN IP4 CALLWEAVER_IP s=session c=IN IP4 FREESWITCH_IP t=0 0 m=audio 19818 RTP/AVP 8 0 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - 2009-07-30 16:01:37.30479 [DEBUG] mod_sofia.c:111 (sofia/external/faxin) State Change CS_INIT -> CS_ROUTING 2009-07-30 16:01:37.30479 [DEBUG] switch_core_session.c:932 Send signal sofia/external/faxin [BREAK] 2009-07-30 16:01:37.30479 [DEBUG] switch_core_state_machine.c:481 (sofia/external/faxin) State INIT going to sleep 2009-07-30 16:01:37.30479 [DEBUG] switch_core_state_machine.c:398 (sofia/external/faxin) Running State Change CS_ROUTING 2009-07-30 16:01:37.30479 [DEBUG] switch_core_state_machine.c:484 (sofia/external/faxin) State ROUTING 2009-07-30 16:01:37.30479 [DEBUG] mod_sofia.c:130 sofia/external/faxin SOFIA ROUTING 2009-07-30 16:01:37.30479 [DEBUG] switch_ivr_originate.c:63 (sofia/external/faxin) State Change CS_ROUTING -> CS_CONSUME_MEDIA 2009-07-30 16:01:37.30479 [DEBUG] switch_core_session.c:932 Send signal sofia/external/faxin [BREAK] 2009-07-30 16:01:37.30479 [DEBUG] switch_core_state_machine.c:484 (sofia/external/faxin) State ROUTING going to sleep 2009-07-30 16:01:37.30479 [DEBUG] switch_core_state_machine.c:398 (sofia/external/faxin) Running State Change CS_CONSUME_MEDIA 2009-07-30 16:01:37.30479 [DEBUG] switch_core_state_machine.c:503 (sofia/external/faxin) State CONSUME_MEDIA 2009-07-30 16:01:37.30479 [DEBUG] sofia.c:3289 Channel sofia/external/faxin entering state [calling][0] 2009-07-30 16:01:37.30479 [DEBUG] sofia.c:3289 Channel sofia/external/002@CALLWEAVER_IP entering state [ready][200] 2009-07-30 16:01:37.30479 [DEBUG] sofia.c:3289 Channel sofia/external/faxin entering state [calling][0] 2009-07-30 16:01:37.35118 [DEBUG] sofia.c:3289 Channel sofia/external/faxin entering state [proceeding][180] 2009-07-30 16:01:37.35118 [NOTICE] sofia.c:3353 Ring-Ready sofia/external/faxin! 2009-07-30 16:01:37.35118 [DEBUG] switch_ivr_originate.c:1854 sofia/external/002@CALLWEAVER_IP receive message [RINGING] 2009-07-30 16:01:37.35118 [DEBUG] switch_core_session.c:630 Send signal sofia/external/002@CALLWEAVER_IP [BREAK] 2009-07-30 16:01:40.36030 [DEBUG] sofia.c:3289 Channel sofia/external/faxin entering state [ready][200] 2009-07-30 16:01:40.36030 [DEBUG] sofia.c:3296 Remote SDP: v=0 o=root 13583 13583 IN IP4 CALLWEAVER_IP s=session c=IN IP4 CALLWEAVER_IP t=0 0 m=audio 10288 RTP/AVP 8 0 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - 2009-07-30 16:01:40.36030 [DEBUG] switch_channel.c:1891 Send signal sofia/external/002@CALLWEAVER_IP [BREAK] 2009-07-30 16:01:40.36030 [NOTICE] sofia.c:3759 Channel [sofia/external/faxin] has been answered 2009-07-30 16:01:40.36030 [DEBUG] sofia_glue.c:2029 Set Codec sofia/external/faxin PROXY/8000 20 ms 160 samples 2009-07-30 16:01:40.36030 [DEBUG] sofia_glue.c:2306 PROXY AUDIO RTP [sofia/external/faxin] FREESWITCH_IP:19818->CALLWEAVER_IP:10288 codec: 0 ms: 20 2009-07-30 16:01:40.36030 [DEBUG] switch_rtp.c:1146 Not using a timer 2009-07-30 16:01:40.36030 [DEBUG] switch_ivr_originate.c:2061 Originate Resulted in Success: [sofia/external/faxin] 2009-07-30 16:01:40.36030 [DEBUG] switch_channel.c:182 sofia/external/faxin receive message [AUDIO_SYNC] 2009-07-30 16:01:40.36030 [DEBUG] switch_channel.c:182 sofia/external/002@CALLWEAVER_IP receive message [AUDIO_SYNC] 2009-07-30 16:01:40.36030 [DEBUG] switch_ivr_bridge.c:891 sofia/external/faxin receive message [BRIDGE] 2009-07-30 16:01:40.36030 [DEBUG] switch_core_session.c:630 Send signal sofia/external/faxin [BREAK] 2009-07-30 16:01:40.36030 [DEBUG] switch_ivr_bridge.c:898 sofia/external/002@CALLWEAVER_IP receive message [BRIDGE] 2009-07-30 16:01:40.36030 [DEBUG] switch_core_session.c:630 Send signal sofia/external/002@CALLWEAVER_IP [BREAK] 2009-07-30 16:01:40.36030 [DEBUG] switch_ivr_bridge.c:942 (sofia/external/faxin) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA 2009-07-30 16:01:40.36030 [DEBUG] switch_core_session.c:932 Send signal sofia/external/faxin [BREAK] 2009-07-30 16:01:40.36030 [DEBUG] sofia_glue.c:2442 Set comfort noise payload to 13 2009-07-30 16:01:40.40647 [DEBUG] switch_core_state_machine.c:503 (sofia/external/faxin) State CONSUME_MEDIA going to sleep 2009-07-30 16:01:40.40647 [DEBUG] switch_core_state_machine.c:398 (sofia/external/faxin) Running State Change CS_EXCHANGE_MEDIA 2009-07-30 16:01:40.40647 [DEBUG] switch_core_state_machine.c:494 (sofia/external/faxin) State EXCHANGE_MEDIA 2009-07-30 16:01:40.40647 [DEBUG] mod_sofia.c:450 SOFIA LOOPBACK 2009-07-30 16:01:40.72020 [DEBUG] switch_core_io.c:649 sofia/external/faxin receive message [TRANSCODING_NECESSARY] 2009-07-30 16:01:40.72020 [ERR] switch_core_io.c:874 Codec PROXY PASS-THROUGH encoder error! 2009-07-30 16:01:40.72020 [DEBUG] switch_ivr_bridge.c:371 sofia/external/faxin ending bridge by request from write function 2009-07-30 16:01:40.72020 [DEBUG] switch_ivr_bridge.c:426 sofia/external/002@CALLWEAVER_IP receive message [UNBRIDGE] 2009-07-30 16:01:40.72020 [DEBUG] switch_core_session.c:630 Send signal sofia/external/002@CALLWEAVER_IP [BREAK] 2009-07-30 16:01:40.72020 [DEBUG] switch_ivr_bridge.c:452 BRIDGE THREAD DONE [sofia/external/002@CALLWEAVER_IP] 2009-07-30 16:01:40.72020 [DEBUG] switch_ivr_bridge.c:456 Send signal sofia/external/faxin [BREAK] 2009-07-30 16:01:40.72020 [DEBUG] switch_ivr_bridge.c:426 sofia/external/faxin receive message [UNBRIDGE] 2009-07-30 16:01:40.72020 [DEBUG] switch_core_session.c:630 Send signal sofia/external/faxin [BREAK] 2009-07-30 16:01:40.72020 [DEBUG] switch_ivr_bridge.c:452 BRIDGE THREAD DONE [sofia/external/faxin] 2009-07-30 16:01:40.72020 [DEBUG] switch_ivr_bridge.c:456 Send signal sofia/external/002@CALLWEAVER_IP [BREAK] 2009-07-30 16:01:40.72020 [NOTICE] switch_ivr_bridge.c:505 Hangup sofia/external/faxin [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING] 2009-07-30 16:01:40.72020 [DEBUG] switch_channel.c:1683 Send signal sofia/external/faxin [KILL] 2009-07-30 16:01:40.72020 [DEBUG] switch_core_session.c:932 Send signal sofia/external/faxin [BREAK] 2009-07-30 16:01:40.72020 [DEBUG] switch_core_state_machine.c:494 (sofia/external/faxin) State EXCHANGE_MEDIA going to sleep 2009-07-30 16:01:40.72020 [DEBUG] switch_core_state_machine.c:398 (sofia/external/faxin) Running State Change CS_HANGUP 2009-07-30 16:01:40.72020 [DEBUG] switch_core_state_machine.c:434 (sofia/external/faxin) State HANGUP 2009-07-30 16:01:40.72020 [DEBUG] mod_sofia.c:338 Channel sofia/external/faxin hanging up, cause: NORMAL_CLEARING 2009-07-30 16:01:40.72020 [DEBUG] mod_sofia.c:396 Sending BYE to sofia/external/faxin 2009-07-30 16:01:40.72020 [DEBUG] switch_core_state_machine.c:46 sofia/external/faxin Standard HANGUP, cause: NORMAL_CLEARING 2009-07-30 16:01:40.72020 [DEBUG] switch_core_state_machine.c:434 (sofia/external/faxin) State HANGUP going to sleep 2009-07-30 16:01:40.72020 [DEBUG] switch_core_state_machine.c:476 (sofia/external/faxin) State Change CS_HANGUP -> CS_REPORTING 2009-07-30 16:01:40.72020 [DEBUG] switch_core_session.c:932 Send signal sofia/external/faxin [BREAK] 2009-07-30 16:01:40.72020 [DEBUG] switch_core_state_machine.c:398 (sofia/external/faxin) Running State Change CS_REPORTING 2009-07-30 16:01:40.72020 [DEBUG] switch_core_state_machine.c:612 (sofia/external/faxin) State REPORTING 2009-07-30 16:01:40.72020 [DEBUG] switch_core_state_machine.c:53 sofia/external/faxin Standard REPORTING, cause: NORMAL_CLEARING 2009-07-30 16:01:40.72020 [DEBUG] switch_core_state_machine.c:612 (sofia/external/faxin) State REPORTING going to sleep 2009-07-30 16:01:40.72020 [DEBUG] switch_core_state_machine.c:411 (sofia/external/faxin) State Change CS_REPORTING -> CS_DESTROY 2009-07-30 16:01:40.72020 [DEBUG] switch_core_session.c:1066 Session 3 (sofia/external/faxin) Locked, Waiting on external entities EXECUTE sofia/external/002@CALLWEAVER_IP hangup() 2009-07-30 16:01:40.74216 [NOTICE] mod_dptools.c:633 Hangup sofia/external/002@CALLWEAVER_IP [CS_EXECUTE] [NORMAL_CLEARING] 2009-07-30 16:01:40.74216 [DEBUG] switch_channel.c:1683 Send signal sofia/external/002@CALLWEAVER_IP [KILL] 2009-07-30 16:01:40.74216 [DEBUG] switch_core_session.c:932 Send signal sofia/external/002@CALLWEAVER_IP [BREAK] 2009-07-30 16:01:40.74216 [DEBUG] switch_core_state_machine.c:491 (sofia/external/002@CALLWEAVER_IP) State EXECUTE going to sleep 2009-07-30 16:01:40.74216 [DEBUG] switch_core_state_machine.c:398 (sofia/external/002@CALLWEAVER_IP) Running State Change CS_HANGUP 2009-07-30 16:01:40.74216 [DEBUG] switch_core_state_machine.c:434 (sofia/external/002@CALLWEAVER_IP) State HANGUP 2009-07-30 16:01:40.74216 [DEBUG] mod_sofia.c:338 Channel sofia/external/002@CALLWEAVER_IP hanging up, cause: NORMAL_CLEARING 2009-07-30 16:01:40.74216 [DEBUG] mod_sofia.c:396 Sending BYE to sofia/external/002@CALLWEAVER_IP 2009-07-30 16:01:40.74216 [DEBUG] switch_core_state_machine.c:46 sofia/external/002@CALLWEAVER_IP Standard HANGUP, cause: NORMAL_CLEARING 2009-07-30 16:01:40.74216 [DEBUG] switch_core_state_machine.c:434 (sofia/external/002@CALLWEAVER_IP) State HANGUP going to sleep 2009-07-30 16:01:40.74216 [DEBUG] switch_core_state_machine.c:476 (sofia/external/002@CALLWEAVER_IP) State Change CS_HANGUP -> CS_REPORTING 2009-07-30 16:01:40.74216 [DEBUG] switch_core_session.c:932 Send signal sofia/external/002@CALLWEAVER_IP [BREAK] 2009-07-30 16:01:40.74216 [DEBUG] switch_core_state_machine.c:398 (sofia/external/002@CALLWEAVER_IP) Running State Change CS_REPORTING 2009-07-30 16:01:40.74216 [DEBUG] switch_core_state_machine.c:612 (sofia/external/002@CALLWEAVER_IP) State REPORTING 2009-07-30 16:01:40.74216 [DEBUG] switch_core_state_machine.c:53 sofia/external/002@CALLWEAVER_IP Standard REPORTING, cause: NORMAL_CLEARING 2009-07-30 16:01:40.74216 [DEBUG] switch_core_state_machine.c:612 (sofia/external/002@CALLWEAVER_IP) State REPORTING going to sleep 2009-07-30 16:01:40.74216 [DEBUG] switch_core_state_machine.c:411 (sofia/external/002@CALLWEAVER_IP) State Change CS_REPORTING -> CS_DESTROY 2009-07-30 16:01:40.74216 [DEBUG] switch_core_session.c:1066 Session 2 (sofia/external/002@CALLWEAVER_IP) Locked, Waiting on external entities 2009-07-30 16:01:40.74216 [NOTICE] switch_core_session.c:1084 Session 2 (sofia/external/002@CALLWEAVER_IP) Ended 2009-07-30 16:01:40.74216 [NOTICE] switch_core_session.c:1086 Close Channel sofia/external/002@CALLWEAVER_IP [CS_DESTROY] 2009-07-30 16:01:40.74216 [DEBUG] switch_core_state_machine.c:564 (sofia/external/002@CALLWEAVER_IP) State DESTROY 2009-07-30 16:01:40.74216 [DEBUG] mod_sofia.c:255 sofia/external/002@CALLWEAVER_IP SOFIA DESTROY 2009-07-30 16:01:40.74216 [DEBUG] switch_core_state_machine.c:60 sofia/external/002@CALLWEAVER_IP Standard DESTROY 2009-07-30 16:01:40.74216 [DEBUG] switch_core_state_machine.c:564 (sofia/external/002@CALLWEAVER_IP) State DESTROY going to sleep 2009-07-30 16:01:40.74216 [NOTICE] switch_core_session.c:1084 Session 3 (sofia/external/faxin) Ended 2009-07-30 16:01:40.74216 [NOTICE] switch_core_session.c:1086 Close Channel sofia/external/faxin [CS_DESTROY] 2009-07-30 16:01:40.74216 [DEBUG] switch_core_state_machine.c:564 (sofia/external/faxin) State DESTROY 2009-07-30 16:01:40.74216 [DEBUG] mod_sofia.c:255 sofia/external/faxin SOFIA DESTROY 2009-07-30 16:01:40.74216 [DEBUG] switch_core_state_machine.c:60 sofia/external/faxin Standard DESTROY 2009-07-30 16:01:40.74216 [DEBUG] switch_core_state_machine.c:564 (sofia/external/faxin) State DESTROY going to sleep Any idea? Stefano

3 4

Problems with rxfax (doesn't work)
by Stefano Marinelli 30 Jul '09

30 Jul '09

Hi. I'm trying to receive a fax using Freeswitch. It's a SIP channel. I know there's no T38 support (yet) but I think I can get decent result with G711 (as I got with Asterisk and Callweaver on non-T38 providers). In FS, all fails just some seconds after the channel has been answered. Here's the log: recv 1080 bytes from udp/[83.211.227.21]:5060 at 09:23:03.446391: ------------------------------------------------------------------------ INVITE sip:gw+eutelia-MYPHONENUMBER@MYSERVERIP:5080;transport=udp SIP/2.0 Record-Route: <sip:83.211.227.21;ftag=B4CC80D8-658;lr=on> Via: SIP/2.0/UDP 83.211.227.21;branch=z9hG4bK23d3.d38ffb01.0 Via: SIP/2.0/UDP 83.211.2.218:5060;rport=56225;x-route-tag="tgrp:Slot6";branch=z9hG4bK1D6C891C4A From: <sip:83.211.2.218>;tag=B4CC80D8-658 To: <sip:MYPHONENUMBER@voip.eutelia.it> Call-ID: 6AB06A2F-7C2111DE-AC2B92F2-3F8F6970(a)83.211.2.218 User-Agent: Cisco-SIPGateway/IOS-12.x CSeq: 101 INVITE Max-Forwards: 9 Contact: <sip:83.211.2.218:5060> Expires: 180 Allow-Events: telephone-event Content-Type: application/sdp Content-Length: 419 P-hint: 2 Niente 2 v=0 o=CiscoSystemsSIP-GW-UserAgent 6035 7635 IN IP4 83.211.2.218 s=SIP Call c=IN IP4 83.211.223.198 t=0 0 m=audio 64720 RTP/AVP 18 8 0 4 3 125 101 c=IN IP4 83.211.223.198 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=yes a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:4 G723/8000 a=fmtp:4 bitrate=5.3;annexa=no a=rtpmap:3 GSM/8000 a=rtpmap:125 X-CCD/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 ------------------------------------------------------------------------ send 469 bytes to udp/[83.211.227.21]:5060 at 09:23:03.446769: ------------------------------------------------------------------------ SIP/2.0 100 Trying Via: SIP/2.0/UDP 83.211.227.21;branch=z9hG4bK23d3.d38ffb01.0 Via: SIP/2.0/UDP 83.211.2.218:5060;rport=56225;x-route-tag="tgrp:Slot6";branch=z9hG4bK1D6C891C4A Record-Route: <sip:83.211.227.21;ftag=B4CC80D8-658;lr=on> From: <sip:83.211.2.218>;tag=B4CC80D8-658 To: <sip:MYPHONENUMBER@voip.eutelia.it> Call-ID: 6AB06A2F-7C2111DE-AC2B92F2-3F8F6970(a)83.211.2.218 CSeq: 101 INVITE User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-14423 Content-Length: 0 ------------------------------------------------------------------------ 2009-07-30 11:23:03.522325 [NOTICE] switch_channel.c:602 New Channel sofia/external/nobody(a)83.211.2.218 [952a66b0-7cea-11de-8429-253fe7587d86] 2009-07-30 11:23:03.522325 [DEBUG] sofia.c:3289 Channel sofia/external/nobody(a)83.211.2.218 entering state [received][100] 2009-07-30 11:23:03.522325 [DEBUG] sofia.c:3296 Remote SDP: v=0 o=CiscoSystemsSIP-GW-UserAgent 6035 7635 IN IP4 83.211.2.218 s=SIP Call c=IN IP4 83.211.223.198 t=0 0 m=audio 64720 RTP/AVP 18 8 0 4 3 125 101 c=IN IP4 83.211.223.198 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=yes a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:4 G723/8000 a=fmtp:4 bitrate=5.3;annexa=no a=rtpmap:3 GSM/8000 a=rtpmap:125 X-CCD/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 2009-07-30 11:23:03.522325 [DEBUG] sofia_glue.c:2811 Activate Buggy RFC2833 Mode! 2009-07-30 11:23:03.522325 [DEBUG] sofia_glue.c:3071 Audio Codec Compare [G729:18:8000:0]/[PCMU:0:8000:20] 2009-07-30 11:23:03.522325 [DEBUG] sofia_glue.c:3071 Audio Codec Compare [G729:18:8000:0]/[PCMA:8:8000:20] 2009-07-30 11:23:03.522325 [DEBUG] sofia_glue.c:3071 Audio Codec Compare [G729:18:8000:0]/[GSM:3:8000:20] 2009-07-30 11:23:03.522325 [DEBUG] sofia_glue.c:3071 Audio Codec Compare [PCMA:8:8000:0]/[PCMU:0:8000:20] 2009-07-30 11:23:03.522325 [DEBUG] sofia_glue.c:3071 Audio Codec Compare [PCMA:8:8000:0]/[PCMA:8:8000:20] 2009-07-30 11:23:03.522325 [DEBUG] sofia_glue.c:2029 Set Codec sofia/external/nobody(a)83.211.2.218 PCMA/8000 20 ms 160 samples 2009-07-30 11:23:03.522325 [DEBUG] sofia_glue.c:3031 Set 2833 dtmf payload to 101 2009-07-30 11:23:03.522325 [DEBUG] sofia.c:3455 (sofia/external/nobody(a)83.211.2.218) State Change CS_NEW -> CS_INIT 2009-07-30 11:23:03.522325 [DEBUG] switch_core_session.c:932 Send signal sofia/external/nobody(a)83.211.2.218 [BREAK] 2009-07-30 11:23:03.522325 [DEBUG] switch_core_state_machine.c:398 (sofia/external/nobody(a)83.211.2.218) Running State Change CS_INIT 2009-07-30 11:23:03.522325 [DEBUG] switch_core_state_machine.c:481 (sofia/external/nobody(a)83.211.2.218) State INIT 2009-07-30 11:23:03.522325 [DEBUG] mod_sofia.c:83 sofia/external/nobody(a)83.211.2.218 SOFIA INIT 2009-07-30 11:23:03.522325 [DEBUG] mod_sofia.c:111 (sofia/external/nobody(a)83.211.2.218) State Change CS_INIT -> CS_ROUTING 2009-07-30 11:23:03.522325 [DEBUG] switch_core_session.c:932 Send signal sofia/external/nobody(a)83.211.2.218 [BREAK] 2009-07-30 11:23:03.522325 [DEBUG] switch_core_state_machine.c:481 (sofia/external/nobody(a)83.211.2.218) State INIT going to sleep 2009-07-30 11:23:03.522325 [DEBUG] switch_core_state_machine.c:398 (sofia/external/nobody(a)83.211.2.218) Running State Change CS_ROUTING 2009-07-30 11:23:03.522325 [DEBUG] switch_core_state_machine.c:484 (sofia/external/nobody(a)83.211.2.218) State ROUTING 2009-07-30 11:23:03.522325 [DEBUG] mod_sofia.c:130 sofia/external/nobody(a)83.211.2.218 SOFIA ROUTING 2009-07-30 11:23:03.522325 [DEBUG] switch_core_state_machine.c:78 sofia/external/nobody(a)83.211.2.218 Standard ROUTING 2009-07-30 11:23:03.522325 [INFO] mod_dialplan_xml.c:315 Processing unknown->MYPHONENUMBER in context public Dialplan: sofia/external/nobody(a)83.211.2.218 parsing [public->unloop] continue=false Dialplan: sofia/external/nobody(a)83.211.2.218 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false Dialplan: sofia/external/nobody(a)83.211.2.218 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false Dialplan: sofia/external/nobody(a)83.211.2.218 parsing [public->outside_call] continue=true Dialplan: sofia/external/nobody(a)83.211.2.218 Absolute Condition [outside_call] Dialplan: sofia/external/nobody(a)83.211.2.218 Action set(outside_call=true) Dialplan: sofia/external/nobody(a)83.211.2.218 parsing [public->call_debug] continue=true Dialplan: sofia/external/nobody(a)83.211.2.218 Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never Dialplan: sofia/external/nobody(a)83.211.2.218 parsing [public->public_extensions] continue=false Dialplan: sofia/external/nobody(a)83.211.2.218 Regex (FAIL) [public_extensions] destination_number(MYPHONENUMBER) =~ /^(10[01][0-9])$/ break=on-false Dialplan: sofia/external/nobody(a)83.211.2.218 parsing [public->MYPHONENUMBER] continue=false Dialplan: sofia/external/nobody(a)83.211.2.218 Regex (PASS) [MYPHONENUMBER] destination_number(MYPHONENUMBER) =~ /^(MYPHONENUMBER)$/ break=on-false Dialplan: sofia/external/nobody(a)83.211.2.218 Action set(domain_name=MYSERVERIP) Dialplan: sofia/external/nobody(a)83.211.2.218 Action answer() Dialplan: sofia/external/nobody(a)83.211.2.218 Action playback(silence_stream://2000) Dialplan: sofia/external/nobody(a)83.211.2.218 Action rxfax(/tmp/rxfax.tiff) Dialplan: sofia/external/nobody(a)83.211.2.218 Action hangup() 2009-07-30 11:23:03.522325 [DEBUG] switch_core_state_machine.c:114 (sofia/external/nobody(a)83.211.2.218) State Change CS_ROUTING -> CS_EXECUTE 2009-07-30 11:23:03.522325 [DEBUG] switch_core_session.c:932 Send signal sofia/external/nobody(a)83.211.2.218 [BREAK] 2009-07-30 11:23:03.522325 [DEBUG] switch_core_state_machine.c:484 (sofia/external/nobody(a)83.211.2.218) State ROUTING going to sleep 2009-07-30 11:23:03.522325 [DEBUG] switch_core_state_machine.c:398 (sofia/external/nobody(a)83.211.2.218) Running State Change CS_EXECUTE 2009-07-30 11:23:03.522325 [DEBUG] switch_core_state_machine.c:491 (sofia/external/nobody(a)83.211.2.218) State EXECUTE 2009-07-30 11:23:03.522325 [DEBUG] mod_sofia.c:173 sofia/external/nobody(a)83.211.2.218 SOFIA EXECUTE 2009-07-30 11:23:03.522325 [DEBUG] switch_core_state_machine.c:151 sofia/external/nobody(a)83.211.2.218 Standard EXECUTE EXECUTE sofia/external/nobody(a)83.211.2.218 set(outside_call=true) 2009-07-30 11:23:03.522325 [DEBUG] mod_dptools.c:748 sofia/external/nobody(a)83.211.2.218 SET [outside_call]=[true] EXECUTE sofia/external/nobody(a)83.211.2.218 set(domain_name=MYSERVERIP) 2009-07-30 11:23:03.522325 [DEBUG] mod_dptools.c:748 sofia/external/nobody(a)83.211.2.218 SET [domain_name]=[MYSERVERIP] EXECUTE sofia/external/nobody(a)83.211.2.218 answer() 2009-07-30 11:23:03.522325 [DEBUG] mod_dptools.c:649 sofia/external/nobody(a)83.211.2.218 receive message [ANSWER] 2009-07-30 11:23:03.522325 [DEBUG] sofia_glue.c:2263 AUDIO RTP [sofia/external/nobody(a)83.211.2.218] MYSERVERIP port 23414 -> 83.211.223.198 port 64720 codec: 8 ms: 20 2009-07-30 11:23:03.522325 [DEBUG] switch_rtp.c:1138 Starting timer [soft] 160 bytes per 20ms 2009-07-30 11:23:03.522325 [DEBUG] mod_sofia.c:552 Local SDP sofia/external/nobody(a)83.211.2.218: v=0 o=FreeSWITCH 1248922369 1248922370 IN IP4 MYSERVERIP s=FreeSWITCH c=IN IP4 MYSERVERIP t=0 0 m=audio 23414 RTP/AVP 8 101 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - a=ptime:20 a=sendrecv 2009-07-30 11:23:03.522325 [DEBUG] switch_core_session.c:630 Send signal sofia/external/nobody(a)83.211.2.218 [BREAK] 2009-07-30 11:23:03.522325 [NOTICE] mod_dptools.c:649 Channel [sofia/external/nobody(a)83.211.2.218] has been answered 2009-07-30 11:23:03.522325 [DEBUG] switch_channel.c:182 sofia/external/nobody(a)83.211.2.218 receive message [AUDIO_SYNC] EXECUTE sofia/external/nobody(a)83.211.2.218 playback(silence_stream://2000) 2009-07-30 11:23:03.522325 [DEBUG] switch_ivr_play_say.c:1097 Codec Activated L16@8000hz 1 channels 20ms 2009-07-30 11:23:03.522325 [DEBUG] switch_core_io.c:649 sofia/external/nobody(a)83.211.2.218 receive message [TRANSCODING_NECESSARY] send 1057 bytes to udp/[83.211.227.21]:5060 at 09:23:03.456354: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 83.211.227.21;branch=z9hG4bK23d3.d38ffb01.0 Via: SIP/2.0/UDP 83.211.2.218:5060;rport=56225;x-route-tag="tgrp:Slot6";branch=z9hG4bK1D6C891C4A Record-Route: <sip:83.211.227.21;ftag=B4CC80D8-658;lr=on> From: <sip:83.211.2.218>;tag=B4CC80D8-658 To: <sip:MYPHONENUMBER@voip.eutelia.it>;tag=Q62jtZFSj1vXD Call-ID: 6AB06A2F-7C2111DE-AC2B92F2-3F8F6970(a)83.211.2.218 CSeq: 101 INVITE Contact: <sip:MYPHONENUMBER@MYSERVERIP:5080;transport=udp> User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-14423 Accept: application/sdp Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO Supported: timer, precondition, path, replaces Allow-Events: talk, refer Content-Type: application/sdp Content-Disposition: session Content-Length: 245 v=0 o=FreeSWITCH 1248922369 1248922370 IN IP4 MYSERVERIP s=FreeSWITCH c=IN IP4 MYSERVERIP t=0 0 m=audio 23414 RTP/AVP 8 101 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - a=ptime:20 ------------------------------------------------------------------------ 2009-07-30 11:23:03.522325 [DEBUG] sofia.c:3289 Channel sofia/external/nobody(a)83.211.2.218 entering state [completed][200] recv 490 bytes from udp/[83.211.227.21]:5060 at 09:23:03.546934: ------------------------------------------------------------------------ ACK sip:MYPHONENUMBER@MYSERVERIP:5080;transport=udp SIP/2.0 Record-Route: <sip:83.211.227.21;ftag=B4CC80D8-658;lr=on> Via: SIP/2.0/UDP 83.211.227.21;branch=0 Via: SIP/2.0/UDP 83.211.2.218:5060;rport=56225;x-route-tag="tgrp:Slot6";branch=z9hG4bK1D6C8B3B5 From: <sip:83.211.2.218>;tag=B4CC80D8-658 To: <sip:MYPHONENUMBER@voip.eutelia.it>;tag=Q62jtZFSj1vXD Call-ID: 6AB06A2F-7C2111DE-AC2B92F2-3F8F6970(a)83.211.2.218 Max-Forwards: 9 CSeq: 101 ACK Content-Length: 0 P-hint: rr-enforced ------------------------------------------------------------------------ 2009-07-30 11:23:03.622342 [DEBUG] sofia.c:3289 Channel sofia/external/nobody(a)83.211.2.218 entering state [ready][200] 2009-07-30 11:23:05.534318 [DEBUG] switch_ivr_play_say.c:1391 done playing file EXECUTE sofia/external/nobody(a)83.211.2.218 rxfax(/tmp/rxfax.tiff) 2009-07-30 11:23:05.534318 [DEBUG] mod_fax.c:591 Raw read codec activation Success L16 20000 2009-07-30 11:23:05.534318 [DEBUG] mod_fax.c:607 Raw write codec activation Success L16 2009-07-30 11:23:05.534318 [DEBUG] switch_channel.c:182 sofia/external/nobody(a)83.211.2.218 receive message [AUDIO_SYNC] 2009-07-30 11:23:05.574318 [DEBUG] switch_core_io.c:232 sofia/external/nobody(a)83.211.2.218 receive message [TRANSCODING_NECESSARY] recv 1065 bytes from udp/[83.211.227.21]:5060 at 09:23:17.425349: ------------------------------------------------------------------------ INVITE sip:MYPHONENUMBER@MYSERVERIP:5080;transport=udp SIP/2.0 Record-Route: <sip:83.211.227.21;ftag=B4CC80D8-658;lr=on> Via: SIP/2.0/UDP 83.211.227.21;branch=z9hG4bKf2d3.3af41733.0 Via: SIP/2.0/UDP 83.211.2.218:5060;rport=56225;x-route-tag="tgrp:Slot6";branch=z9hG4bK1D6CB02556 From: <sip:83.211.2.218>;tag=B4CC80D8-658 To: <sip:MYPHONENUMBER@voip.eutelia.it>;tag=Q62jtZFSj1vXD Call-ID: 6AB06A2F-7C2111DE-AC2B92F2-3F8F6970(a)83.211.2.218 User-Agent: Cisco-SIPGateway/IOS-12.x CSeq: 102 INVITE Max-Forwards: 9 Contact: <sip:83.211.2.218:5060> Expires: 180 Allow-Events: telephone-event Content-Type: application/sdp Content-Length: 396 P-hint: rr-enforced v=0 o=CiscoSystemsSIP-GW-UserAgent 6035 7636 IN IP4 83.211.2.218 s=SIP Call c=IN IP4 83.211.2.219 t=0 0 m=image 16962 udptl t38 c=IN IP4 83.211.2.219 a=T38FaxVersion:0 a=T38MaxBitRate:14400 a=T38FaxFillBitRemoval:0 a=T38FaxTranscodingMMR:0 a=T38FaxTranscodingJBIG:0 a=T38FaxRateManagement:transferredTCF a=T38FaxMaxBuffer:200 a=T38FaxMaxDatagram:72 a=T38FaxUdpEC:t38UDPRedundancy ------------------------------------------------------------------------ send 487 bytes to udp/[83.211.227.21]:5060 at 09:23:17.425685: ------------------------------------------------------------------------ SIP/2.0 100 Trying Via: SIP/2.0/UDP 83.211.227.21;branch=z9hG4bKf2d3.3af41733.0 Via: SIP/2.0/UDP 83.211.2.218:5060;rport=56225;x-route-tag="tgrp:Slot6";branch=z9hG4bK1D6CB02556 Record-Route: <sip:83.211.227.21;ftag=B4CC80D8-658;lr=on> From: <sip:83.211.2.218>;tag=B4CC80D8-658 To: <sip:MYPHONENUMBER@voip.eutelia.it>;tag=Q62jtZFSj1vXD Call-ID: 6AB06A2F-7C2111DE-AC2B92F2-3F8F6970(a)83.211.2.218 CSeq: 102 INVITE User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-14423 Content-Length: 0 ------------------------------------------------------------------------ 2009-07-30 11:23:17.502330 [DEBUG] sofia.c:3289 Channel sofia/external/nobody(a)83.211.2.218 entering state [received][100] 2009-07-30 11:23:17.502330 [DEBUG] sofia.c:3296 Remote SDP: v=0 o=CiscoSystemsSIP-GW-UserAgent 6035 7636 IN IP4 83.211.2.218 s=SIP Call c=IN IP4 83.211.2.219 t=0 0 m=image 16962 udptl t38 c=IN IP4 83.211.2.219 a=T38FaxVersion:0 a=T38MaxBitRate:14400 a=T38FaxFillBitRemoval:0 a=T38FaxTranscodingMMR:0 a=T38FaxTranscodingJBIG:0 a=T38FaxRateManagement:transferredTCF a=T38FaxMaxBuffer:200 a=T38FaxMaxDatagram:72 a=T38FaxUdpEC:t38UDPRedundancy 2009-07-30 11:23:17.502330 [DEBUG] sofia_glue.c:2811 Activate Buggy RFC2833 Mode! 2009-07-30 11:23:17.502330 [ERR] sofia.c:3657 Reinvite Codec Error! send 622 bytes to udp/[83.211.227.21]:5060 at 09:23:17.425932: ------------------------------------------------------------------------ SIP/2.0 488 Not Acceptable Here Via: SIP/2.0/UDP 83.211.227.21;branch=z9hG4bKf2d3.3af41733.0 Via: SIP/2.0/UDP 83.211.2.218:5060;rport=56225;x-route-tag="tgrp:Slot6";branch=z9hG4bK1D6CB02556 From: <sip:83.211.2.218>;tag=B4CC80D8-658 To: <sip:MYPHONENUMBER@voip.eutelia.it>;tag=Q62jtZFSj1vXD Call-ID: 6AB06A2F-7C2111DE-AC2B92F2-3F8F6970(a)83.211.2.218 CSeq: 102 INVITE User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-14423 Accept: application/sdp Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO Supported: timer, precondition, path, replaces Content-Length: 0 ------------------------------------------------------------------------ 2009-07-30 11:23:17.502330 [DEBUG] sofia.c:3289 Channel sofia/external/nobody(a)83.211.2.218 entering state [ready][488] recv 418 bytes from udp/[83.211.227.21]:5060 at 09:23:17.483358: ------------------------------------------------------------------------ ACK sip:MYPHONENUMBER@MYSERVERIP:5080;transport=udp SIP/2.0 Via: SIP/2.0/UDP 83.211.227.21;branch=z9hG4bKf2d3.3af41733.0 From: <sip:83.211.2.218>;tag=B4CC80D8-658 Call-ID: 6AB06A2F-7C2111DE-AC2B92F2-3F8F6970(a)83.211.2.218 To: <sip:MYPHONENUMBER@voip.eutelia.it>;tag=Q62jtZFSj1vXD CSeq: 102 ACK Route: <sip:83.211.227.21;ftag=B4CC80D8-658;lr=on> User-Agent: SPS EUT RM GW 01 (0.9.6 (i386/linux)) Content-Length: 0 ------------------------------------------------------------------------ recv 851 bytes from udp/[83.211.227.21]:5060 at 09:23:17.521157: ------------------------------------------------------------------------ INVITE sip:MYPHONENUMBER@MYSERVERIP:5080;transport=udp SIP/2.0 Record-Route: <sip:83.211.227.21;ftag=B4CC80D8-658;lr=on> Via: SIP/2.0/UDP 83.211.227.21;branch=z9hG4bK03d3.99198e36.0 Via: SIP/2.0/UDP 83.211.2.218:5060;rport=56225;x-route-tag="tgrp:Slot6";branch=z9hG4bK1D6CB16EB From: <sip:83.211.2.218>;tag=B4CC80D8-658 To: <sip:MYPHONENUMBER@voip.eutelia.it>;tag=Q62jtZFSj1vXD Call-ID: 6AB06A2F-7C2111DE-AC2B92F2-3F8F6970(a)83.211.2.218 User-Agent: Cisco-SIPGateway/IOS-12.x CSeq: 103 INVITE Max-Forwards: 9 Contact: <sip:83.211.2.218:5060> Expires: 180 Allow-Events: telephone-event Content-Type: application/sdp Content-Length: 183 P-hint: rr-enforced v=0 o=CiscoSystemsSIP-GW-UserAgent 6035 7637 IN IP4 83.211.2.218 s=SIP Call c=IN IP4 83.211.2.219 t=0 0 m=audio 16962 RTP/AVP 8 a=rtpmap:8 PCMA/8000 a=silenceSupp:off - - - - ------------------------------------------------------------------------ send 486 bytes to udp/[83.211.227.21]:5060 at 09:23:17.521462: ------------------------------------------------------------------------ SIP/2.0 100 Trying Via: SIP/2.0/UDP 83.211.227.21;branch=z9hG4bK03d3.99198e36.0 Via: SIP/2.0/UDP 83.211.2.218:5060;rport=56225;x-route-tag="tgrp:Slot6";branch=z9hG4bK1D6CB16EB Record-Route: <sip:83.211.227.21;ftag=B4CC80D8-658;lr=on> From: <sip:83.211.2.218>;tag=B4CC80D8-658 To: <sip:MYPHONENUMBER@voip.eutelia.it>;tag=Q62jtZFSj1vXD Call-ID: 6AB06A2F-7C2111DE-AC2B92F2-3F8F6970(a)83.211.2.218 CSeq: 103 INVITE User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-14423 Content-Length: 0 ------------------------------------------------------------------------ 2009-07-30 11:23:17.598335 [DEBUG] sofia.c:3289 Channel sofia/external/nobody(a)83.211.2.218 entering state [received][100] 2009-07-30 11:23:17.598335 [DEBUG] sofia.c:3296 Remote SDP: v=0 o=CiscoSystemsSIP-GW-UserAgent 6035 7637 IN IP4 83.211.2.218 s=SIP Call c=IN IP4 83.211.2.219 t=0 0 m=audio 16962 RTP/AVP 8 a=rtpmap:8 PCMA/8000 a=silenceSupp:off - - - - 2009-07-30 11:23:17.598335 [DEBUG] sofia_glue.c:2811 Activate Buggy RFC2833 Mode! 2009-07-30 11:23:17.598335 [DEBUG] sofia_glue.c:2253 Audio params are unchanged for sofia/external/nobody(a)83.211.2.218. 2009-07-30 11:23:17.598335 [DEBUG] sofia.c:3655 Processing Reinvite send 1029 bytes to udp/[83.211.227.21]:5060 at 09:23:17.521790: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 83.211.227.21;branch=z9hG4bK03d3.99198e36.0 Via: SIP/2.0/UDP 83.211.2.218:5060;rport=56225;x-route-tag="tgrp:Slot6";branch=z9hG4bK1D6CB16EB Record-Route: <sip:83.211.227.21;ftag=B4CC80D8-658;lr=on> From: <sip:83.211.2.218>;tag=B4CC80D8-658 To: <sip:MYPHONENUMBER@voip.eutelia.it>;tag=Q62jtZFSj1vXD Call-ID: 6AB06A2F-7C2111DE-AC2B92F2-3F8F6970(a)83.211.2.218 CSeq: 103 INVITE Contact: <sip:MYPHONENUMBER@MYSERVERIP:5080;transport=udp> User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-14423 Accept: application/sdp Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO Supported: timer, precondition, path, replaces Content-Type: application/sdp Content-Disposition: session Content-Length: 245 v=0 o=FreeSWITCH 1248922369 1248922370 IN IP4 MYSERVERIP s=FreeSWITCH c=IN IP4 MYSERVERIP t=0 0 m=audio 23414 RTP/AVP 8 101 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - a=ptime:20 ------------------------------------------------------------------------ 2009-07-30 11:23:17.598335 [DEBUG] sofia.c:3289 Channel sofia/external/nobody(a)83.211.2.218 entering state [completed][200] recv 491 bytes from udp/[83.211.227.21]:5060 at 09:23:17.587996: ------------------------------------------------------------------------ ACK sip:MYPHONENUMBER@MYSERVERIP:5080;transport=udp SIP/2.0 Record-Route: <sip:83.211.227.21;ftag=B4CC80D8-658;lr=on> Via: SIP/2.0/UDP 83.211.227.21;branch=0 Via: SIP/2.0/UDP 83.211.2.218:5060;rport=56225;x-route-tag="tgrp:Slot6";branch=z9hG4bK1D6CB21B82 From: <sip:83.211.2.218>;tag=B4CC80D8-658 To: <sip:MYPHONENUMBER@voip.eutelia.it>;tag=Q62jtZFSj1vXD Call-ID: 6AB06A2F-7C2111DE-AC2B92F2-3F8F6970(a)83.211.2.218 Max-Forwards: 9 CSeq: 103 ACK Content-Length: 0 P-hint: rr-enforced ------------------------------------------------------------------------ 2009-07-30 11:23:17.666336 [DEBUG] sofia.c:3289 Channel sofia/external/nobody(a)83.211.2.218 entering state [ready][200] recv 575 bytes from udp/[83.211.227.21]:5060 at 09:24:12.888160: ------------------------------------------------------------------------ BYE sip:MYPHONENUMBER@MYSERVERIP:5080;transport=udp SIP/2.0 Record-Route: <sip:83.211.227.21;ftag=B4CC80D8-658;lr=on> Via: SIP/2.0/UDP 83.211.227.21;branch=z9hG4bKd2d3.e46ab944.0 Via: SIP/2.0/UDP 83.211.2.218:5060;rport=56225;x-route-tag="tgrp:Slot6";branch=z9hG4bK1D6D231283 From: <sip:83.211.2.218>;tag=B4CC80D8-658 To: <sip:MYPHONENUMBER@voip.eutelia.it>;tag=Q62jtZFSj1vXD Call-ID: 6AB06A2F-7C2111DE-AC2B92F2-3F8F6970(a)83.211.2.218 User-Agent: Cisco-SIPGateway/IOS-12.x Max-Forwards: 9 CSeq: 104 BYE Reason: Q.850;cause=16 Content-Length: 0 P-hint: rr-enforced ------------------------------------------------------------------------ 2009-07-30 11:24:12.966321 [NOTICE] sofia.c:322 Hangup sofia/external/nobody(a)83.211.2.218 [CS_EXECUTE] [NORMAL_CLEARING] 2009-07-30 11:24:12.966321 [DEBUG] switch_channel.c:1683 Send signal sofia/external/nobody(a)83.211.2.218 [KILL] 2009-07-30 11:24:12.966321 [DEBUG] switch_core_session.c:932 Send signal sofia/external/nobody(a)83.211.2.218 [BREAK] send 577 bytes to udp/[83.211.227.21]:5060 at 09:24:12.888613: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 83.211.227.21;branch=z9hG4bKd2d3.e46ab944.0 Via: SIP/2.0/UDP 83.211.2.218:5060;rport=56225;x-route-tag="tgrp:Slot6";branch=z9hG4bK1D6D231283 From: <sip:83.211.2.218>;tag=B4CC80D8-658 To: <sip:MYPHONENUMBER@voip.eutelia.it>;tag=Q62jtZFSj1vXD Call-ID: 6AB06A2F-7C2111DE-AC2B92F2-3F8F6970(a)83.211.2.218 CSeq: 104 BYE User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-14423 Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO Supported: timer, precondition, path, replaces Content-Length: 0 ------------------------------------------------------------------------ 2009-07-30 11:24:12.974320 [DEBUG] mod_fax.c:167 ============================================================================== 2009-07-30 11:24:12.974320 [DEBUG] mod_fax.c:180 Fax processing not successful - result (49) The call dropped prematurely. 2009-07-30 11:24:12.974320 [DEBUG] mod_fax.c:185 Remote station id: 12345 2009-07-30 11:24:12.974320 [DEBUG] mod_fax.c:186 Local station id: SpanDSP Fax Ident 2009-07-30 11:24:12.974320 [DEBUG] mod_fax.c:187 Pages transferred: 0 2009-07-30 11:24:12.974320 [DEBUG] mod_fax.c:189 Total fax pages: 0 2009-07-30 11:24:12.974320 [DEBUG] mod_fax.c:190 Image resolution: 8031x3850 2009-07-30 11:24:12.974320 [DEBUG] mod_fax.c:191 Transfer Rate: 4800 2009-07-30 11:24:12.974320 [DEBUG] mod_fax.c:193 ECM status on 2009-07-30 11:24:12.974320 [DEBUG] mod_fax.c:194 remote country: 2009-07-30 11:24:12.974320 [DEBUG] mod_fax.c:195 remote vendor: 2009-07-30 11:24:12.974320 [DEBUG] mod_fax.c:196 remote model: 2009-07-30 11:24:12.974320 [DEBUG] mod_fax.c:198 ============================================================================== 2009-07-30 11:24:12.974320 [DEBUG] switch_core_codec.c:122 Restore original codec. 2009-07-30 11:24:12.974320 [DEBUG] switch_core_state_machine.c:491 (sofia/external/nobody(a)83.211.2.218) State EXECUTE going to sleep 2009-07-30 11:24:12.974320 [DEBUG] switch_core_state_machine.c:398 (sofia/external/nobody(a)83.211.2.218) Running State Change CS_HANGUP 2009-07-30 11:24:12.974320 [DEBUG] switch_core_state_machine.c:434 (sofia/external/nobody(a)83.211.2.218) State HANGUP 2009-07-30 11:24:12.974320 [DEBUG] mod_sofia.c:338 Channel sofia/external/nobody(a)83.211.2.218 hanging up, cause: NORMAL_CLEARING 2009-07-30 11:24:12.974320 [DEBUG] switch_core_state_machine.c:46 sofia/external/nobody(a)83.211.2.218 Standard HANGUP, cause: NORMAL_CLEARING 2009-07-30 11:24:12.974320 [DEBUG] switch_core_state_machine.c:434 (sofia/external/nobody(a)83.211.2.218) State HANGUP going to sleep 2009-07-30 11:24:12.974320 [DEBUG] switch_core_state_machine.c:476 (sofia/external/nobody(a)83.211.2.218) State Change CS_HANGUP -> CS_REPORTING 2009-07-30 11:24:12.974320 [DEBUG] switch_core_session.c:932 Send signal sofia/external/nobody(a)83.211.2.218 [BREAK] 2009-07-30 11:24:12.974320 [DEBUG] switch_core_state_machine.c:398 (sofia/external/nobody(a)83.211.2.218) Running State Change CS_REPORTING 2009-07-30 11:24:12.974320 [DEBUG] switch_core_state_machine.c:612 (sofia/external/nobody(a)83.211.2.218) State REPORTING 2009-07-30 11:24:12.974320 [DEBUG] switch_core_state_machine.c:53 sofia/external/nobody(a)83.211.2.218 Standard REPORTING, cause: NORMAL_CLEARING 2009-07-30 11:24:12.974320 [DEBUG] switch_core_state_machine.c:612 (sofia/external/nobody(a)83.211.2.218) State REPORTING going to sleep 2009-07-30 11:24:12.974320 [DEBUG] switch_core_state_machine.c:411 (sofia/external/nobody(a)83.211.2.218) State Change CS_REPORTING -> CS_DESTROY 2009-07-30 11:24:12.974320 [DEBUG] switch_core_session.c:1066 Session 3 (sofia/external/nobody(a)83.211.2.218) Locked, Waiting on external entities 2009-07-30 11:24:12.974320 [NOTICE] switch_core_session.c:1084 Session 3 (sofia/external/nobody(a)83.211.2.218) Ended 2009-07-30 11:24:12.974320 [NOTICE] switch_core_session.c:1086 Close Channel sofia/external/nobody(a)83.211.2.218 [CS_DESTROY] 2009-07-30 11:24:12.974320 [DEBUG] switch_core_state_machine.c:564 (sofia/external/nobody(a)83.211.2.218) State DESTROY 2009-07-30 11:24:12.974320 [DEBUG] mod_sofia.c:255 sofia/external/nobody(a)83.211.2.218 SOFIA DESTROY 2009-07-30 11:24:12.974320 [DEBUG] switch_core_state_machine.c:60 sofia/external/nobody(a)83.211.2.218 Standard DESTROY 2009-07-30 11:24:12.974320 [DEBUG] switch_core_state_machine.c:564 (sofia/external/nobody(a)83.211.2.218) State DESTROY going to sleep Any idea? Thank you. Stefano

2 1

SIP instant messaging presence signaling doesn't work.
by Gregory Charles 30 Jul '09

30 Jul '09

Hi Mike, I configured the following lines into intenal.xml <param name="manage-presence" value="true"/> <param name="manage-shared-appearance" value="true"/> <param name="dbname" value="share_presence"/> <param name="presence-hosts" value="$${domain}"/> SIP presence signalling is no stille take into account with softphone. But I have this error that I see with Wireshark "481 Call_Leg/Transaction doesn't exist" when I connect my softphone to my freeswitch server. Have you an idea? Thanks. G.C. > You must turn on the option to manage presence in the sip profile. > Mike > On Jul 28, 2009, at 5:43 AM, Gregory Charles <gregory.charles at > sogeti.com> wrote: > Hi everybody, > > I intend to use Freeswitch with two Ekiga Softphones. SIP Instant > messaging works between the two softphones but SIP presence signaling > is not managed by the softphones. I try to use other softphones > (QuteCom and SIPCommunicator) and it is the same. I have the following > error in my FreeSwitch console: > > [WARNING] sofia.c:75 sofia_handle_sip_r_notify() delete > subscriptions for failed notify > > Is there any special configuration for SIP instant messaging presence? > > Thanks. > > G.C. > Hi everybody, > > I intend to use Freeswitch with two Ekiga Softphones. SIP Instant > messaging works between the two softphones but SIP presence > signaling is not managed by the softphones. I try to use other > softphones (QuteCom and SIPCommunicator) and it is the same. I have > the following error in my FreeSwitch console: > > [WARNING] sofia.c:75 sofia_handle_sip_r_notify() delete > subscriptions for failed notify > > Is there any special configuration for SIP instant messaging presence? > > Thanks. > > G.C. > > _______________________________________________ > FreeSWITCH-users mailing list > FreeSWITCH-users at lists.freeswitch.org > http://lists.freeswitch.org/mailman/listinfo/freeswitch-users[1] > UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users > http://www.freeswitch.org[2] Liens: ------ [1] http://lists.freeswitch.org/mailman/listinfo/freeswitch-users [2] http://www.freeswitch.org

1 0

Cisco 7945/7965 CPE Compatibility with Freeswitch
by Pat Jensen 30 Jul '09

30 Jul '09

Hello, I have had great success bringing up Freeswitch in my lab with various makes/models of SIP hardware CPE, and I am starting to delve into some more complex scenarios. I have two questions specific to Cisco's current generation IP handsets (7965/7945): 1. Is integration of busy lamp fields working on the Cisco 7945/7965? It seems the Asterisk folks are in the process of putting a patch together for 1.6 that uses SIP TCP as a path way, and that Cisco may have some "extensions" required to make them work. If they are supported on Freeswitch, could someone post an XML phone / corresponding Freeswitch directory.xml configuration that is known working? I've attempted what I think is correct based on the SIP deployment guides and the Wiki's, but my BLF speed dial buttons and call logs do not show any presence information. <callLogBlfEnabled>1</callLogBlfEnabled> - tried 1 and 2 here <line button="5"> <featureID>21</featureID> <featureLabel>Phil 5000</featureLabel> <speedDialNumber>5000</speedDialNumber> </line> 2. Is it possible to send a dialed name from Freeswitch back to the IP phone as feedback when a number is dialed out, similar to native CallManager Express/UCM functionality? I've noticed that my Linksys SPA962 will support this without any configuration changes required. This behavior seems to be vendor implementation specific - I'm not sure where this information is hiding so I can't refer to it by it's SIP header to ask as an educated question. I appreciate any help or guidance you can give me, even if it's RTFM :) Thanks folks. Regards, Pat

2 1

codec problem with fifo
by Juan Backson 30 Jul '09

30 Jul '09

Hi, I am trying to use the fifo app, but I am hitting on the following error. Does anyone know how to resolve the "No code is found" error? Dialplan: sofia/internal/1000(a)192.168.1.102 Regex (PASS) [internal-call] destination_number(5501) =~ /^(.*)$/ break=on-false Dialplan: sofia/internal/1000(a)192.168.1.102 Action fifo(in inbound-1) 2009-07-31 01:09:40.426542 [DEBUG] switch_core_state_machine.c:114 (sofia/internal/1000(a)192.168.1.102) State Change CS_ROUTING -> CS_EXECUTE 2009-07-31 01:09:40.426542 [DEBUG] switch_core_session.c:932 Send signal sofia/internal/1000(a)192.168.1.102 [BREAK] 2009-07-31 01:09:40.426542 [DEBUG] switch_core_state_machine.c:484 (sofia/internal/1000(a)192.168.1.102) State ROUTING going to sleep 2009-07-31 01:09:40.426542 [DEBUG] switch_core_state_machine.c:398 (sofia/internal/1000(a)192.168.1.102) Running State Change CS_EXECUTE 2009-07-31 01:09:40.426542 [DEBUG] switch_core_state_machine.c:491 (sofia/internal/1000(a)192.168.1.102) State EXECUTE 2009-07-31 01:09:40.427552 [DEBUG] mod_sofia.c:173 sofia/internal/ 1000(a)192.168.1.102 SOFIA EXECUTE 2009-07-31 01:09:40.427552 [DEBUG] switch_core_state_machine.c:151 sofia/internal/1000(a)192.168.1.102 Standard EXECUTE 2009-07-31 01:09:40.427552 [DEBUG] switch_core_session.c:1388 Application fifo Requires media! pre_answering channel sofia/internal/1000(a)192.168.1.102 2009-07-31 01:09:40.427552 [DEBUG] switch_core_session.c:1390 sofia/internal/1000(a)192.168.1.102 receive message [PROGRESS] 2009-07-31 01:09:40.427552 [INFO] switch_core_session.c:1390 Sending early media 2009-07-31 01:09:40.427552 [ERR] sofia_glue.c:1959 No audio codec available 2009-07-31 01:09:40.427552 [DEBUG] switch_core_session.c:630 Send signal sofia/internal/1000(a)192.168.1.102 [BREAK] 2009-07-31 01:09:40.427552 [NOTICE] switch_channel.c:1815 Hangup sofia/internal/1000(a)192.168.1.102 [CS_EXECUTE] [INCOMPATIBLE_DESTINATION] 2009-07-31 01:09:40.427552 [DEBUG] switch_channel.c:1683 Send signal sofia/internal/1000(a)192.168.1.102 [KILL] 2009-07-31 01:09:40.428540 [DEBUG] switch_core_session.c:932 Send signal sofia/internal/1000(a)192.168.1.102 [BREAK] 2009-07-31 01:09:40.428540 [DEBUG] switch_core_session.c:1391 Well, that didn't work very well did it? ... 2009-07-31 01:09:40.428540 [DEBUG] switch_core_state_machine.c:491 (sofia/internal/1000(a)192.168.1.102) State EXECUTE going to sleep 2009-07-31 01:09:40.428540 [DEBUG] switch_core_state_machine.c:398 (sofia/internal/1000(a)192.168.1.102) Running State Change CS_HANGUP Thanks, JB

2 1

Enable sip communication between two Freeswitch servers
by Gregory Charles 30 Jul '09

30 Jul '09

Hello world, I have two freeswitch servers that I want to interconnect. Each one of them has their own sip domain and we want to enable sip communications between them. All the PC can ping together. Client #1 ------- Freeswitch #1 --(gateway)--- Freeswitch #2 ------ Client# 2. We have configured a sip gateway on Freeswitch #1 server with the configuration below: C:\Program Files\FreeSWITCH\conf\sip_profiles\external\gw.xml <include> <gateway name="gw"> <param name="username" value="3000"/> <param name="realm" value="192.168.2.10"/> <param name="from-domain" value="192.168.2.10"/> <param name="password" value="2009"/> <param name="expire-seconds" value="3600"/> <param name="register-transport" value="udp"/> <param name="retry-seconds" value="30"/> <param name="ping" value="25"/> </gateway> </include> C:\Program Files\FreeSWITCH\conf\dialplan\default\01_example.com.xml <include> <extension name="gw">  <condition field="destination_number" expression="^(30[0-2][0-9])$"> <action application="bridge" data="sofia/gateway/gw/$1(a)192.168.2.10"/[1]> </condition> </extension> </include> In the Freeswitch #2 server, we have configured the 3000 extension: C:\Program Files\FreeSWITCH\conf\directory\default\3000.xml <include> <user id="3000" mailbox="3000"> <params> <param name="password" value="1234"/> <param name="vm-password" value="1000"/> </params> <variables> <variable name="toll_allow" value="domestic,international,local"/> <variable name="accountcode" value="3000"/> <variable name="user_context" value="default"/> <variable name="effective_caller_id_name" value="Extension 3000"/> <variable name="effective_caller_id_number" value="3000"/> <variable name="outbound_caller_id_name" value="$${outbound_caller_name}"/> <variable name="outbound_caller_id_number" value="$${outbound_caller_id}"/> <variable name="callgroup" value="techsupport"/> </variables> </user> </include> We have our gateway working. >>sofia status gateway gw But we can't do a call between client#1 and client#2. ================================================================================================= Name gw Scheme Digest Realm 10.0.2.10 Username 3000 Password yes From <sip:3000@192.168.2.10;transport=udp> Contact <sip:gw+gw@192.168.1.10:5080;transport=udp> Exten 3000 To sip:3000@192.168.2.10 Proxy sip:192.168.2.10 Context public Expires 3600 Freq 3600 Ping 1248881849 PingFreq 25 State REGED Status UP CallsIN 0 CallsOUT 19 ================================================================================================= We have the following debug when we make a call. 2009-07-29 17:19:52 [DEBUG] sofia_glue.c:2566 sofia_glue_negotiate_sdp() Set 2833 dtmf payload to 101 2009-07-29 17:19:52 [DEBUG] sofia.c:2962 sofia_handle_sip_i_state() (sofia/internal/1311(a)192.168.1.10) State Change CS_NEW -> CS_INIT 2009-07-29 17:19:52 [DEBUG] switch_core_session.c:868 switch_core_session_signal_state_change() Send signal sofia/internal/1311(a)192.168.1.10 [BREAK] 2009-07-29 17:19:52 [DEBUG] switch_core_state_machine.c:390 switch_core_session_run() (sofia/internal/1311(a)192.168.1.10) Running State Change CS_INIT 2009-07-29 17:19:52 [DEBUG] switch_core_state_machine.c:469 switch_core_session_run() (sofia/internal/1311(a)192.168.1.10) State INIT 2009-07-29 17:19:52 [DEBUG] mod_sofia.c:83 sofia_on_init() sofia/internal/1311(a)192.168.1.10 SOFIA INIT 2009-07-29 17:19:52 [DEBUG] mod_sofia.c:111 sofia_on_init() (sofia/internal/1311(a)192.168.1.10) State Change CS_INIT -> CS_ROUTING 2009-07-29 17:19:52 [DEBUG] switch_core_session.c:868 switch_core_session_signal_state_change() Send signal sofia/internal/1311(a)192.168.1.10 [BREAK] 2009-07-29 17:19:52 [DEBUG] switch_core_state_machine.c:469 switch_core_session_run() (sofia/internal/1311(a)192.168.1.10) State INIT going to sleep 2009-07-29 17:19:52 [DEBUG] switch_core_state_machine.c:390 switch_core_session_run() (sofia/internal/1311(a)192.168.1.10) Running State Change CS_ROUTING 2009-07-29 17:19:52 [DEBUG] switch_core_state_machine.c:472 switch_core_session_run() (sofia/internal/1311(a)192.168.1.10) State ROUTING 2009-07-29 17:19:52 [DEBUG] mod_sofia.c:130 sofia_on_routing() sofia/internal/1311(a)192.168.1.10 SOFIA ROUTING 2009-07-29 17:19:52 [DEBUG] switch_core_state_machine.c:71 switch_core_standard_on_routing() sofia/internal/1311(a)192.168.1.10 Standard ROUTING 2009-07-29 17:19:52 [INFO] mod_dialplan_xml.c:252 dialplan_hunt() Processing Chewaka (test)->3021 in context default Dialplan: sofia/internal/1311(a)192.168.1.10 parsing [default->unloop] continue=false Dialplan: sofia/internal/1311(a)192.168.1.10 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false Dialplan: sofia/internal/1311(a)192.168.1.10 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false Dialplan: sofia/internal/1311(a)192.168.1.10 parsing [default->global] continue=true Dialplan: sofia/internal/1311(a)192.168.1.10 Regex (FAIL) [global] ${network_addr}(10.3.1.12) =~ /^$/ break=never Dialplan: sofia/internal/1311(a)192.168.1.10 ANTI-Action set(use_profile=${cond(${acl(${network_addr} rfc1918)} == true ? nat : default)}) Dialplan: sofia/internal/1311(a)192.168.1.10 Regex (PASS) [global] ${numbering_plan}() =~ /^$/ break=never Dialplan: sofia/internal/1311(a)192.168.1.10 Action set_user(default@${domain_name}) Dialplan: sofia/internal/1311(a)192.168.1.10 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never Dialplan: sofia/internal/1311(a)192.168.1.10 Regex (FAIL) [global] ${sip_has_crypto}() =~ /^(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)$/ break=never Dialplan: sofia/internal/1311(a)192.168.1.10 Absolute Condition [global] Dialplan: sofia/internal/1311(a)192.168.1.10 Action db(insert/${domain_name}-spymap/${caller_id_number}/${uuid}) Dialplan: sofia/internal/1311(a)192.168.1.10 Action db(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number}) Dialplan: sofia/internal/1311(a)192.168.1.10 Action db(insert/${domain_name}-last_dial/global/${uuid}) Dialplan: sofia/internal/1311(a)192.168.1.10 parsing [default->Local_Extension] continue=false Dialplan: sofia/internal/1311(a)192.168.1.10 Regex (FAIL) [Local_Extension] destination_number(3021) =~ /^(130[0-8] && 131[0-9])$/ break=on-false Dialplan: sofia/internal/1311(a)192.168.1.10 parsing [default->IFAU_global_demonstrator_Conference_Room] continue=false Dialplan: sofia/internal/1311(a)192.168.1.10 Regex (FAIL) [IFAU_global_demonstrator_Conference_Room] destination_number(3021) =~ /^1309$/ break=on-false Dialplan: sofia/internal/1311(a)192.168.1.10 parsing [default->gw] continue=false Dialplan: sofia/internal/1311(a)192.168.1.10 Regex (PASS) [gw] destination_number(3021) =~ /^(30[0-2][0-9])$/ break=on-false Dialplan: sofia/internal/1311(a)192.168.1.10 Action bridge(sofia/gateway/gw/3021(a)192.168.2.10) 2009-07-29 17:19:52 [DEBUG] switch_core_state_machine.c:107 switch_core_standard_on_routing() (sofia/internal/1311(a)192.168.1.10) State Change CS_ROUTING -> CS_EXEC UTE 2009-07-29 17:19:52 [DEBUG] switch_core_session.c:868 switch_core_session_signal_state_change() Send signal sofia/internal/1311(a)192.168.1.10 [BREAK] 2009-07-29 17:19:52 [DEBUG] switch_core_state_machine.c:472 switch_core_session_run() (sofia/internal/1311(a)192.168.1.10) State ROUTING going to sleep 2009-07-29 17:19:52 [DEBUG] switch_core_state_machine.c:390 switch_core_session_run() (sofia/internal/1311(a)192.168.1.10) Running State Change CS_EXECUTE 2009-07-29 17:19:52 [DEBUG] switch_core_state_machine.c:479 switch_core_session_run() (sofia/internal/1311(a)192.168.1.10) State EXECUTE 2009-07-29 17:19:52 [DEBUG] mod_sofia.c:173 sofia_on_execute() sofia/internal/1311(a)192.168.1.10 SOFIA EXECUTE 2009-07-29 17:19:52 [DEBUG] switch_core_state_machine.c:144 switch_core_standard_on_execute() sofia/internal/1311(a)192.168.1.10 Standard EXECUTE EXECUTE sofia/internal/1311(a)192.168.1.10 set(use_profile=default) 2009-07-29 17:19:52 [DEBUG] mod_dptools.c:747 set_function() sofia/internal/1311(a)192.168.1.10 SET [use_profile]=[default] EXECUTE sofia/internal/1311(a)192.168.1.10 set_user(default(a)192.168.1.10) 2009-07-29 17:19:52 [WARNING] switch_ivr.c:2042 switch_ivr_set_user() can't find user [default(a)192.168.1.10] EXECUTE sofia/internal/1311(a)192.168.1.10 db(insert/192.168.1.10-spymap/1311/d851bbd1-c09c-474b-b1df-d433420b132b) EXECUTE sofia/internal/1311(a)192.168.1.10 db(insert/192.168.1.10-last_dial/1311/3021) EXECUTE sofia/internal/1311(a)192.168.1.10 db(insert/192.168.1.10-last_dial/global/d851bbd1-c09c-474b-b1df-d433420b132b) EXECUTE sofia/internal/1311(a)192.168.1.10 bridge(sofia/gateway/gw/3021(a)192.168.2.10) 2009-07-29 17:19:52 [NOTICE] switch_channel.c:592 switch_channel_set_name() New Channel sofia/external/3021(a)192.168.2.10 [35a85e69-d109-134f-81d3-1d21016f43e5] 2009-07-29 17:19:52 [DEBUG] mod_sofia.c:2567 sofia_outgoing_channel() (sofia/external/3021(a)192.168.2.10) State Change CS_NEW -> CS_INIT 2009-07-29 17:19:52 [DEBUG] switch_core_session.c:868 switch_core_session_signal_state_change() Send signal sofia/external/3021(a)192.168.2.10 [BREAK] 2009-07-29 17:19:52 [DEBUG] switch_core_state_machine.c:390 switch_core_session_run() (sofia/external/3021(a)192.168.2.10) Running State Change CS_INIT 2009-07-29 17:19:52 [DEBUG] switch_core_state_machine.c:469 switch_core_session_run() (sofia/external/3021(a)192.168.2.10) State INIT 2009-07-29 17:19:52 [DEBUG] mod_sofia.c:83 sofia_on_init() sofia/external/3021(a)192.168.2.10 SOFIA INIT 2009-07-29 17:20:18 [ERR] sofia_glue.c:568 sofia_glue_ext_address_lookup() STUN Failed! stun.freeswitch.org:3478 [Timeout] 2009-07-29 17:20:18 [NOTICE] mod_sofia.c:103 sofia_on_init() Hangup sofia/external/3021(a)192.168.2.10 [CS_INIT] [DESTINATION_OUT_OF_ORDER] 2009-07-29 17:20:18 [DEBUG] switch_channel.c:1612 switch_channel_perform_hangup() Send signal sofia/external/3021(a)192.168.2.10 [KILL] 2009-07-29 17:20:18 [DEBUG] switch_core_session.c:868 switch_core_session_signal_state_change() Send signal sofia/external/3021(a)192.168.2.10 [BREAK] With Wireshark, we have seen two sip error frame : "407 Proxy authentication required" and "502 bad gateway". What I must do to make calls between the two sip domains ? Best regards. G.C. Liens: ------ [1] mailto:sofia/gateway/gw/$1@192.168.2.10

2 1

SIP trunk (PBX - FreeSwitch) routing problem.
by julien 30 Jul '09

30 Jul '09

I'm currently trying to connect FreeSwitch to a PBX (Alcatel-Lucent), thanks to a SIP trunk. SIP trunks are available and working on the PBX thanks to a recent update. My problem is that I can't call phones linked to the PBX. When I try to call 300, I've got this message in freeswitch console : 2009-07-27 17:38:48.514105 [NOTICE] switch_channel.c:602 New Channel sofia/internal/[EMAIL PROTECTED] [93d5a10e-7ac3-11de-b456-e5e56113066d] 2009-07-27 17:38:48.516907 [INFO] mod_dialplan_xml.c:252 Processing jgonzalez jgonzalez->300 in context default 2009-07-27 17:38:48.521084 [NOTICE] switch_channel.c:602 New Channel sofia/external/[EMAIL PROTECTED] [93d69816-7ac3-11de-b456-e5e56113066d] 2009-07-27 17:38:48.636073 [NOTICE] sofia.c:3775 Hangup sofia/external/[EMAIL PROTECTED] [CS_CONSUME_MEDIA] [NO_ROUTE_DESTINATION] 2009-07-27 17:38:48.636073 [INFO] mod_dptools.c:2091 Originate Failed. Cause: NO_ROUTE_DESTINATION 2009-07-27 17:38:48.637788 [NOTICE] mod_dptools.c:633 Hangup sofia/internal/[EMAIL PROTECTED] [CS_EXECUTE] [NORMAL_CLEARING] 2009-07-27 17:38:48.639047 [NOTICE] switch_core_session.c:1085 Session 15 (sofia/internal/[EMAIL PROTECTED]) Ended 2009-07-27 17:38:48.639047 [NOTICE] switch_core_session.c:1087 Close Channel sofia/internal/[EMAIL PROTECTED] [CS_DESTROY] 2009-07-27 17:38:48.643042 [NOTICE] switch_core_session.c:1085 Session 16 (sofia/external/[EMAIL PROTECTED]) Ended 2009-07-27 17:38:48.643042 [NOTICE] switch_core_session.c:1087 Close Channel sofia/external/[EMAIL PROTECTED] [CS_DESTROY] I've defined, in sip_profiles/external, a gateway to the PBX this way : <include> <gateway name="pbxlyon"> <param name="username" value="pbxlyon"/> <param name="realm" value="[PBX IP address]"/> <param name="password" value="pbxlyon"/> <param name="register" value="false"/> <param name="register-transport" value="udp"/> <param name="retry_seconds" value="30"/> </gateway> </include> And in the dialplan default.xml : <extension name="pbxlyon"> <condition field="destination_number" expression="300"> <action application="set" data="hangup_after_bridge=true"/> <action application="set" data="continue_on_fail=true"/> <action application="bridge" data="sofia/gateway/pbxlyon/300"/> <action application="hangup"/> </condition> </extension> (for the moment, I'm trying only with the number 300 which is a correct number of the phone system). As you can see, I'm far from being an expert of FreeSwitch, SIP or even VoIP in general. I'm learning. I hope you can help me. Regards, Julien Gonzalez.

4 10

Methods in the ESL connection
by Thangappan.M 30 Jul '09

30 Jul '09

Dear all, For implementing a IVR I planned to use event outbound socket.For that I am in the process of analyzing the /libs/esl/perl/server2.pl code.In that they created a object for ESL::ESLconnection package then they called some of the methods like getInfo,sendRecv ...etc using that object. So here is my question, where can I get all the methods of ESL connection and its explanation.This methods will be useful for me to implement my own IVR. -- Regards, Thangappan.M

2 2