[Freeswitch-users] Can't proxy media

30 Jul 2009

      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="answer" />-->
<!--               <action application="playback"
data="silence_stream://2000"/>-->
<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

[Freeswitch-users] Can't proxy media

Stefano Marinelli