Thanks for the quick response. Below is the capture from the log viewer. In this test, I am using a remote fax machine (line from Cox with physical machine) faxing into the "email server" where I created an extension for fax-to-email. Calling number is 1479-246-0547.

2013-01-10 13:39:53.162506 [DEBUG] switch_core_state_machine.c:569 (sofia/external/+14792460547@flowroute.com) State DESTROY going to sleep 
2013-01-10 13:39:53.162506 [DEBUG] switch_core_state_machine.c:99 sofia/external/+14792460547@flowroute.com Standard DESTROY 
2013-01-10 13:39:53.162506 [DEBUG] mod_sofia.c:396 sofia/external/+14792460547@flowroute.com SOFIA DESTROY 
2013-01-10 13:39:53.162506 [DEBUG] switch_core_state_machine.c:569 (sofia/external/+14792460547@flowroute.com) State DESTROY 
2013-01-10 13:39:53.162506 [DEBUG] switch_core_state_machine.c:559 (sofia/external/+14792460547@flowroute.com) Running State Change CS_DESTROY 
2013-01-10 13:39:53.162506 [DEBUG] switch_core_state_machine.c:556 (sofia/external/+14792460547@flowroute.com) Callstate Change HANGUP -> DOWN 
2013-01-10 13:39:53.162506 [NOTICE] switch_core_session.c:1510 Close Channel sofia/external/+14792460547@flowroute.com [CS_DESTROY] 
2013-01-10 13:39:53.162506 [NOTICE] switch_core_session.c:1506 Session 26 (sofia/external/+14792460547@flowroute.com) Ended 
2013-01-10 13:39:53.162506 [DEBUG] switch_core_session.c:1488 Session 26 (sofia/external/+14792460547@flowroute.com) Locked, Waiting on external entities 
2013-01-10 13:39:53.162506 [DEBUG] switch_core_session.c:1283 Send signal sofia/external/+14792460547@flowroute.com [BREAK] 
2013-01-10 13:39:53.162506 [DEBUG] switch_core_state_machine.c:440 (sofia/external/+14792460547@flowroute.com) State Change CS_REPORTING -> CS_DESTROY 
2013-01-10 13:39:53.162506 [DEBUG] switch_core_state_machine.c:749 (sofia/external/+14792460547@flowroute.com) State REPORTING going to sleep 
2013-01-10 13:39:53.162506 [DEBUG] switch_core_state_machine.c:92 sofia/external/+14792460547@flowroute.com Standard REPORTING, cause: NORMAL_CLEARING 
2013-01-10 13:39:53.066135 [DEBUG] switch_core_state_machine.c:749 (sofia/external/+14792460547@flowroute.com) State REPORTING 
2013-01-10 13:39:53.066135 [DEBUG] switch_core_state_machine.c:415 (sofia/external/+14792460547@flowroute.com) Running State Change CS_REPORTING 
2013-01-10 13:39:53.066135 [DEBUG] switch_core_session.c:1283 Send signal sofia/external/+14792460547@flowroute.com [BREAK] 
2013-01-10 13:39:53.066135 [DEBUG] switch_core_state_machine.c:446 (sofia/external/+14792460547@flowroute.com) State Change CS_HANGUP -> CS_REPORTING 

2013-01-10 13:39:53.066135 [DEBUG] switch_core_state_machine.c:599 Hangup Command with no Session system(/usr/bin/php /var/www/html/fusionpbx/secure/fax_to_email.php email=robert.l.craig@craignetwork.com extension=3150 name=+14792460547-2013-01-10-13-39-26 messages='result: Disconnected after permitted retries sender:ATW-4792460547 pages:0' domain=192.168.4.15 caller_id_name='' caller_id_number=): 
2013-01-10 13:39:52.216151 [DEBUG] switch_core_state_machine.c:667 (sofia/external/+14792460547@flowroute.com) State HANGUP going to sleep 
2013-01-10 13:39:52.216151 [DEBUG] switch_core_state_machine.c:48 sofia/external/+14792460547@flowroute.com Standard HANGUP, cause: NORMAL_CLEARING 
2013-01-10 13:39:52.216151 [DEBUG] mod_sofia.c:552 Sending BYE to sofia/external/+14792460547@flowroute.com 
2013-01-10 13:39:52.216151 [DEBUG] mod_sofia.c:503 Channel sofia/external/+14792460547@flowroute.com hanging up, cause: NORMAL_CLEARING 
2013-01-10 13:39:52.216151 [DEBUG] switch_core_state_machine.c:667 (sofia/external/+14792460547@flowroute.com) State HANGUP 
2013-01-10 13:39:52.216151 [DEBUG] switch_core_state_machine.c:415 (sofia/external/+14792460547@flowroute.com) Running State Change CS_HANGUP 
2013-01-10 13:39:52.216151 [DEBUG] switch_core_state_machine.c:477 (sofia/external/+14792460547@flowroute.com) State EXECUTE going to sleep 
2013-01-10 13:39:52.216151 [DEBUG] switch_core_session.c:2687 sofia/external/+14792460547@flowroute.com skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already) 
2013-01-10 13:39:52.216151 [DEBUG] switch_core_session.c:1283 Send signal sofia/external/+14792460547@flowroute.com [BREAK] 
2013-01-10 13:39:52.216151 [DEBUG] switch_channel.c:3017 Send signal sofia/external/+14792460547@flowroute.com [KILL] 
2013-01-10 13:39:52.216151 [NOTICE] mod_dptools.c:1150 Hangup sofia/external/+14792460547@flowroute.com [CS_EXECUTE] [NORMAL_CLEARING] 
2013-01-10 13:39:52.216151 [DEBUG] switch_channel.c:2994 (sofia/external/+14792460547@flowroute.com) Callstate Change ACTIVE -> HANGUP 
EXECUTE sofia/external/+14792460547@flowroute.com hangup() 
2013-01-10 13:39:52.216151 [DEBUG] switch_core_codec.c:244 sofia/external/+14792460547@flowroute.com Restore previous codec PCMU:0. 
2013-01-10 13:39:52.216151 [DEBUG] mod_spandsp_fax.c:518 ============================================================================== 
2013-01-10 13:39:52.216151 [DEBUG] mod_spandsp_fax.c:516 remote model: 
2013-01-10 13:39:52.216151 [DEBUG] mod_spandsp_fax.c:515 remote vendor: 
2013-01-10 13:39:52.216151 [DEBUG] mod_spandsp_fax.c:514 remote country: 
2013-01-10 13:39:52.216151 [DEBUG] mod_spandsp_fax.c:513 ECM status off 
2013-01-10 13:39:52.216151 [DEBUG] mod_spandsp_fax.c:511 Transfer Rate: 14400 
2013-01-10 13:39:52.216151 [DEBUG] mod_spandsp_fax.c:510 Image resolution: 0x0 
2013-01-10 13:39:52.216151 [DEBUG] mod_spandsp_fax.c:509 Total fax pages: 0 
2013-01-10 13:39:52.216151 [DEBUG] mod_spandsp_fax.c:507 Pages transferred: 0 
2013-01-10 13:39:52.216151 [DEBUG] mod_spandsp_fax.c:506 Local station id: SpanDSP Fax Ident 
2013-01-10 13:39:52.216151 [DEBUG] mod_spandsp_fax.c:505 Remote station id: ATW-4792460547 
2013-01-10 13:39:52.216151 [DEBUG] mod_spandsp_fax.c:500 Fax processing not successful - result (48) Disconnected after permitted retries. 
2013-01-10 13:39:52.216151 [DEBUG] mod_spandsp_fax.c:487 ============================================================================== 
2013-01-10 13:39:38.766190 [DEBUG] switch_rtp.c:3624 Correct ip/port confirmed. 
2013-01-10 13:39:29.576127 [DEBUG] switch_core_session.c:975 Send signal sofia/external/+14792460547@flowroute.com [BREAK] 

a=T38FaxUdpEC:t38UDPRedundancy 
a=T38FaxMaxDatagram:400 
a=T38FaxMaxBuffer:2000 
a=T38FaxRateManagement:transferredTCF 
a=T38FaxFillBitRemoval 
a=T38MaxBitRate:9600 
a=T38FaxVersion:0 
m=image 27588 udptl t38 
t=0 0 
c=IN IP4 72.201.112.131 
s=FreeSWITCH 
o=FreeSWITCH 1357822778 1357822782 IN IP4 72.201.112.131 
v=0 
2013-01-10 13:39:29.576127 [DEBUG] sofia_glue.c:173 sofia/external/+14792460547@flowroute.com image media sdp: 
2013-01-10 13:39:29.576127 [DEBUG] mod_sofia.c:1487 Remote address:port [66.42.121.5:31632] has not changed. 
2013-01-10 13:39:29.576127 [DEBUG] mod_sofia.c:1487 Remote address:port [66.42.121.5:31632] has not changed. 
2013-01-10 13:39:29.576127 [DEBUG] switch_core_session.c:975 Send signal sofia/external/+14792460547@flowroute.com [BREAK] 

a=T38FaxUdpEC:t38UDPRedundancy 
a=T38FaxMaxDatagram:400 
a=T38FaxMaxBuffer:2000 
a=T38FaxRateManagement:transferredTCF 
a=T38FaxFillBitRemoval 
a=T38MaxBitRate:9600 
a=T38FaxVersion:0 
m=image 27588 udptl t38 
t=0 0 
c=IN IP4 72.201.112.131 
s=FreeSWITCH 
o=FreeSWITCH 1357822778 1357822781 IN IP4 72.201.112.131 
v=0 
2013-01-10 13:39:29.576127 [DEBUG] sofia_glue.c:173 sofia/external/+14792460547@flowroute.com image media sdp: 
2013-01-10 13:39:29.576127 [DEBUG] mod_sofia.c:1487 Remote address:port [66.42.121.5:31632] has not changed. 
2013-01-10 13:39:29.576127 [DEBUG] mod_sofia.c:1487 Remote address:port [66.42.121.5:31632] has not changed. 
2013-01-10 13:39:29.576127 [DEBUG] sofia_glue.c:3645 sofia/external/+14792460547@flowroute.com Set rtp dtmf delay to 40 
2013-01-10 13:39:29.576127 [DEBUG] sofia_glue.c:3618 Set 2833 dtmf receive payload to 101 
2013-01-10 13:39:29.576127 [DEBUG] sofia_glue.c:3612 Set 2833 dtmf send payload to 101 
2013-01-10 13:39:29.576127 [ERR] sofia_glue.c:3549 Invalid Jitterbuffer spec [0] must be between 20 and 10000 
2013-01-10 13:39:29.576127 [DEBUG] switch_rtp.c:1928 Starting timer [soft] 160 bytes per 20ms 
2013-01-10 13:39:29.576127 [DEBUG] sofia_glue.c:3348 AUDIO RTP [sofia/external/+14792460547@flowroute.com] 192.168.4.15 port 27588 -> 66.42.121.5 port 31632 codec: 0 ms: 20 
2013-01-10 13:39:29.566140 [DEBUG] sofia.c:5603 Channel sofia/external/+14792460547@flowroute.com entering state [ready][200] 
2013-01-10 13:39:29.566140 [DEBUG] switch_core_session.c:975 Send signal sofia/external/+14792460547@flowroute.com [BREAK] 
2013-01-10 13:39:29.566140 [DEBUG] switch_core_session.c:975 Send signal sofia/external/+14792460547@flowroute.com [BREAK] 

a=T38FaxRateManagement:transferredTCF 
m=image 31632 udptl t38 
t=0 0 
c=IN IP4 66.42.121.5 
s=- 
o=- 275426305 1357849876 IN IP4 66.42.121.5 
v=0 
2013-01-10 13:39:29.566140 [DEBUG] sofia.c:5614 Remote SDP: 
2013-01-10 13:39:29.566140 [DEBUG] sofia.c:5603 Channel sofia/external/+14792460547@flowroute.com entering state [completing][200] 
2013-01-10 13:39:29.566140 [INFO] sofia.c:931 sofia/external/+14792460547@flowroute.com Update Callee ID to "+14792460547" <+14792460547> 
2013-01-10 13:39:29.556130 [DEBUG] switch_core_session.c:975 Send signal sofia/external/+14792460547@flowroute.com [BREAK] 
2013-01-10 13:39:29.556130 [DEBUG] switch_core_session.c:975 Send signal sofia/external/+14792460547@flowroute.com [BREAK] 
2013-01-10 13:39:29.266195 [DEBUG] sofia.c:5603 Channel sofia/external/+14792460547@flowroute.com entering state [calling][0] 
2013-01-10 13:39:29.256196 [DEBUG] switch_core_session.c:975 Send signal sofia/external/+14792460547@flowroute.com [BREAK] 

a=T38FaxUdpEC:t38UDPRedundancy 
a=T38FaxMaxDatagram:400 
a=T38FaxMaxBuffer:2000 
a=T38FaxRateManagement:transferredTCF 
a=T38FaxFillBitRemoval 
a=T38MaxBitRate:9600 
a=T38FaxVersion:0 
m=image 27588 udptl t38 
t=0 0 
c=IN IP4 72.201.112.131 
s=FreeSWITCH 
o=FreeSWITCH 1357822778 1357822780 IN IP4 72.201.112.131 
v=0 
2013-01-10 13:39:29.256196 [DEBUG] sofia_glue.c:2647 Local SDP: 

a=T38FaxUdpEC:t38UDPRedundancy 
a=T38FaxMaxDatagram:400 
a=T38FaxMaxBuffer:2000 
a=T38FaxRateManagement:transferredTCF 
a=T38FaxFillBitRemoval 
a=T38MaxBitRate:9600 
a=T38FaxVersion:0 
m=image 27588 udptl t38 
t=0 0 
c=IN IP4 72.201.112.131 
s=FreeSWITCH 
o=FreeSWITCH 1357822778 1357822780 IN IP4 72.201.112.131 
v=0 
2013-01-10 13:39:29.256196 [DEBUG] sofia_glue.c:173 sofia/external/+14792460547@flowroute.com image media sdp: 
2013-01-10 13:39:27.996269 [DEBUG] mod_spandsp_fax.c:1379 Raw write codec activation Success L16 
2013-01-10 13:39:27.996269 [DEBUG] switch_core_codec.c:219 sofia/external/+14792460547@flowroute.com Push codec L16:70 
2013-01-10 13:39:27.996269 [DEBUG] mod_spandsp_fax.c:1363 Raw read codec activation Success L16 20000 
EXECUTE sofia/external/+14792460547@flowroute.com rxfax(/usr/local/freeswitch/storage/fax/3150/inbox/+14792460547-2013-01-10-13-39-26.tif) 
2013-01-10 13:39:27.996269 [DEBUG] switch_ivr_play_say.c:1682 done playing file silence_stream://2000 
2013-01-10 13:39:26.256197 [DEBUG] switch_rtp.c:3624 Correct ip/port confirmed. 
2013-01-10 13:39:26.116239 [DEBUG] sofia.c:5603 Channel sofia/external/+14792460547@flowroute.com entering state [ready][200] 
2013-01-10 13:39:26.096329 [DEBUG] switch_core_session.c:975 Send signal sofia/external/+14792460547@flowroute.com [BREAK] 
2013-01-10 13:39:26.096329 [DEBUG] switch_core_session.c:975 Send signal sofia/external/+14792460547@flowroute.com [BREAK] 
2013-01-10 13:39:26.096329 [DEBUG] switch_core_session.c:975 Send signal sofia/external/+14792460547@flowroute.com [BREAK] 
2013-01-10 13:39:26.016177 [DEBUG] switch_ivr_play_say.c:1309 Codec Activated L16@8000hz 1 channels 20ms 
EXECUTE sofia/external/+14792460547@flowroute.com playback(silence_stream://2000) 
2013-01-10 13:39:26.016177 [DEBUG] mod_dptools.c:1344 sofia/external/+14792460547@flowroute.com SET [last_fax]=[+14792460547-2013-01-10-13-39-26] 
EXECUTE sofia/external/+14792460547@flowroute.com set(last_fax=+14792460547-2013-01-10-13-39-26) 
2013-01-10 13:39:26.016177 [DEBUG] mod_dptools.c:1344 sofia/external/+14792460547@flowroute.com SET [fax_enable_t38_request]=[true] 
EXECUTE sofia/external/+14792460547@flowroute.com set(fax_enable_t38_request=true) 
2013-01-10 13:39:26.006127 [DEBUG] mod_dptools.c:1344 sofia/external/+14792460547@flowroute.com SET [fax_enable_t38]=[true] 
2013-01-10 13:39:26.006127 [DEBUG] sofia.c:5603 Channel sofia/external/+14792460547@flowroute.com entering state [completed][200] 
EXECUTE sofia/external/+14792460547@flowroute.com set(fax_enable_t38=true) 
2013-01-10 13:39:26.006127 [DEBUG] switch_core_session.c:975 Send signal sofia/external/+14792460547@flowroute.com [BREAK] 
2013-01-10 13:39:26.006127 [NOTICE] mod_dptools.c:1176 Channel [sofia/external/+14792460547@flowroute.com] has been answered 
2013-01-10 13:39:26.006127 [DEBUG] switch_channel.c:3395 (sofia/external/+14792460547@flowroute.com) Callstate Change RINGING -> ACTIVE 
2013-01-10 13:39:26.006127 [DEBUG] switch_core_session.c:830 Send signal sofia/external/+14792460547@flowroute.com [BREAK] 

a=sendrecv 
a=ptime:20 
a=silenceSupp:off - - - - 
a=fmtp:101 0-16 
a=rtpmap:101 telephone-event/8000 
a=rtpmap:0 PCMU/8000 
m=audio 27588 RTP/AVP 0 101 
t=0 0 
c=IN IP4 72.201.112.131 
s=FreeSWITCH 
o=FreeSWITCH 1357822778 1357822779 IN IP4 72.201.112.131 
v=0 
2013-01-10 13:39:26.006127 [DEBUG] mod_sofia.c:856 Local SDP sofia/external/+14792460547@flowroute.com: 
2013-01-10 13:39:26.006127 [DEBUG] sofia_glue.c:3645 sofia/external/+14792460547@flowroute.com Set rtp dtmf delay to 40 
2013-01-10 13:39:26.006127 [DEBUG] sofia_glue.c:3618 Set 2833 dtmf receive payload to 101 
2013-01-10 13:39:26.006127 [DEBUG] sofia_glue.c:3612 Set 2833 dtmf send payload to 101 
2013-01-10 13:39:26.006127 [DEBUG] switch_rtp.c:1928 Starting timer [soft] 160 bytes per 20ms 
2013-01-10 13:39:26.006127 [DEBUG] sofia_glue.c:3348 AUDIO RTP [sofia/external/+14792460547@flowroute.com] 192.168.4.15 port 27588 -> 66.42.121.5 port 31632 codec: 0 ms: 20 
2013-01-10 13:39:26.006127 [DEBUG] sofia_glue.c:1046 STUN Success [72.201.112.131]:[27588] 
EXECUTE sofia/external/+14792460547@flowroute.com answer() 
2013-01-10 13:39:25.816280 [DEBUG] mod_dptools.c:1344 sofia/external/+14792460547@flowroute.com SET [api_hangup_hook]=[system /usr/bin/php /var/www/html/fusionpbx/secure/fax_to_email.php email=robert.l.craig@craignetwork.com extension=3150 name=${last_fax} messages='result: ${fax_result_text} sender:${fax_remote_station_id} pages:${fax_document_total_pages}' domain=192.168.4.15 caller_id_name='${caller_id_name}' caller_id_number=${caller_id_number}] 
EXECUTE sofia/external/+14792460547@flowroute.com set(api_hangup_hook=system /usr/bin/php /var/www/html/fusionpbx/secure/fax_to_email.php email=robert.l.craig@craignetwork.com extension=3150 name=\${last_fax} messages='result: \${fax_result_text} sender:\${fax_remote_station_id} pages:\${fax_document_total_pages}' domain=192.168.4.15 caller_id_name='\${caller_id_name}' caller_id_number=\${caller_id_number}) 
2013-01-10 13:39:25.816280 [DEBUG] mod_dptools.c:1344 sofia/external/+14792460547@flowroute.com SET [RFC2822_DATE]=[Thu, 10 Jan 2013 13:39:25 -0700] 
EXECUTE sofia/external/+14792460547@flowroute.com set(RFC2822_DATE=Thu, 10 Jan 2013 13:39:25 -0700) 
EXECUTE sofia/external/+14792460547@flowroute.com hash(insert/192.168.4.15-last_dial/global/d276f012-5b65-11e2-beae-8564ff827a25) 
EXECUTE sofia/external/+14792460547@flowroute.com hash(insert/192.168.4.15-last_dial/+14792460547/3150) 
EXECUTE sofia/external/+14792460547@flowroute.com hash(insert/192.168.4.15-spymap/+14792460547/d276f012-5b65-11e2-beae-8564ff827a25) 
2013-01-10 13:39:25.816280 [DEBUG] mod_dptools.c:1344 sofia/external/+14792460547@flowroute.com SET [call_direction]=[local] 
EXECUTE sofia/external/+14792460547@flowroute.com set(call_direction=local) 
2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:209 sofia/external/+14792460547@flowroute.com Standard EXECUTE 
2013-01-10 13:39:25.816280 [DEBUG] mod_sofia.c:242 sofia/external/+14792460547@flowroute.com SOFIA EXECUTE 
2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:477 (sofia/external/+14792460547@flowroute.com) State EXECUTE 
2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:415 (sofia/external/+14792460547@flowroute.com) Running State Change CS_EXECUTE 
2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:470 (sofia/external/+14792460547@flowroute.com) State ROUTING going to sleep 
2013-01-10 13:39:25.816280 [DEBUG] switch_core_session.c:1283 Send signal sofia/external/+14792460547@flowroute.com [BREAK] 
2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:167 (sofia/external/+14792460547@flowroute.com) State Change CS_ROUTING -> CS_EXECUTE 
Dialplan: sofia/external/+14792460547@flowroute.com Action hangup() 
Dialplan: sofia/external/+14792460547@flowroute.com Action rxfax(/usr/local/freeswitch/storage/fax/3150/inbox/${last_fax}.tif) 
Dialplan: sofia/external/+14792460547@flowroute.com Action playback(silence_stream://2000) 
Dialplan: sofia/external/+14792460547@flowroute.com Action set(last_fax=${caller_id_number}-${strftime(%Y-%m-%d-%H-%M-%S)}) 
Dialplan: sofia/external/+14792460547@flowroute.com Action set(fax_enable_t38_request=true) 
Dialplan: sofia/external/+14792460547@flowroute.com Action set(fax_enable_t38=true) 
Dialplan: sofia/external/+14792460547@flowroute.com Action answer() 
Dialplan: sofia/external/+14792460547@flowroute.com Action set(api_hangup_hook=system /usr/bin/php /var/www/html/fusionpbx/secure/fax_to_email.php email=robert.l.craig@craignetwork.com extension=3150 name=\\\${last_fax} messages='result: \\\${fax_result_text} sender:\\\${fax_remote_station_id} pages:\\\${fax_document_total_pages}' domain=192.168.4.15 caller_id_name='\\\${caller_id_name}' caller_id_number=\\\${caller_id_number}) 
Dialplan: sofia/external/+14792460547@flowroute.com Regex (PASS) [Test Fax] destination_number(3150) =~ /^3150$/ break=on-false 
Dialplan: sofia/external/+14792460547@flowroute.com parsing [default->Test Fax] continue=false 
Dialplan: sofia/external/+14792460547@flowroute.com Regex (FAIL) [vmain_user] destination_number(3150) =~ /^\*97$/ break=on-false 
Dialplan: sofia/external/+14792460547@flowroute.com parsing [default->vmain_user] continue=false 
Dialplan: sofia/external/+14792460547@flowroute.com Regex (FAIL) [vmain] destination_number(3150) =~ /^vmain$|^\*4000$|^\*98$/ break=on-false 
Dialplan: sofia/external/+14792460547@flowroute.com parsing [default->vmain] continue=false 
Dialplan: sofia/external/+14792460547@flowroute.com Regex (FAIL) [send_to_voicemail] destination_number(3150) =~ /^\*99(\d{2,7})$/ break=on-false 
Dialplan: sofia/external/+14792460547@flowroute.com parsing [default->send_to_voicemail] continue=false 
Dialplan: sofia/external/+14792460547@flowroute.com Regex (FAIL) [extension-intercom] destination_number(3150) =~ /^\*8(\d{2,7})$/ break=on-false 
Dialplan: sofia/external/+14792460547@flowroute.com parsing [default->extension-intercom] continue=false 
Dialplan: sofia/external/+14792460547@flowroute.com Regex (FAIL) [intercept-ext] destination_number(3150) =~ /^\*\*(\d+)$/ break=on-false 
Dialplan: sofia/external/+14792460547@flowroute.com parsing [default->intercept-ext] continue=false 
Dialplan: sofia/external/+14792460547@flowroute.com Regex (FAIL) [call_return] destination_number(3150) =~ /^\*69$|^lcr$/ break=on-false 
Dialplan: sofia/external/+14792460547@flowroute.com parsing [default->call_return] continue=false 
Dialplan: sofia/external/+14792460547@flowroute.com Regex (FAIL) [call_privacy] destination_number(3150) =~ /^\*67(\d+)$/ break=on-false 
Dialplan: sofia/external/+14792460547@flowroute.com parsing [default->call_privacy] continue=false 
Dialplan: sofia/external/+14792460547@flowroute.com Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) 
Dialplan: sofia/external/+14792460547@flowroute.com Action hash(insert/${domain_name}-last_dial/global/${uuid}) 
Dialplan: sofia/external/+14792460547@flowroute.com Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number}) 
Dialplan: sofia/external/+14792460547@flowroute.com Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid}) 
Dialplan: sofia/external/+14792460547@flowroute.com Absolute Condition [global] 
Dialplan: sofia/external/+14792460547@flowroute.com Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never 
Dialplan: sofia/external/+14792460547@flowroute.com parsing [default->global] continue=true 
Dialplan: sofia/external/+14792460547@flowroute.com Regex (FAIL) [redial] destination_number(3150) =~ /^(redial|\*870)$/ break=on-false 
Dialplan: sofia/external/+14792460547@flowroute.com parsing [default->redial] continue=false 
Dialplan: sofia/external/+14792460547@flowroute.com Regex (FAIL) [group-intercept] destination_number(3150) =~ /^\*8$/ break=on-false 
Dialplan: sofia/external/+14792460547@flowroute.com parsing [default->group-intercept] continue=false 
Dialplan: sofia/external/+14792460547@flowroute.com ANTI-Action set(call_direction=local) 
Dialplan: sofia/external/+14792460547@flowroute.com Regex (FAIL) [call-direction] ${call_direction}() =~ /^(inbound|outbound|local)$/ break=on-false 
Dialplan: sofia/external/+14792460547@flowroute.com parsing [default->call-direction] continue=true 
Dialplan: sofia/external/+14792460547@flowroute.com Regex (FAIL) [Flowroute.11d] destination_number(3150) =~ /^\+?(\d{11})$/ break=on-false 
Dialplan: sofia/external/+14792460547@flowroute.com parsing [default->Flowroute.11d] continue=false 
2013-01-10 13:39:25.816280 [INFO] mod_dialplan_xml.c:498 Processing +14792460547 <+14792460547>->3150 in context default 
2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:117 sofia/external/+14792460547@flowroute.com Standard ROUTING 
2013-01-10 13:39:25.816280 [DEBUG] mod_sofia.c:149 sofia/external/+14792460547@flowroute.com SOFIA ROUTING 
2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:470 (sofia/external/+14792460547@flowroute.com) State ROUTING 
2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:415 (sofia/external/+14792460547@flowroute.com) Running State Change CS_ROUTING 
2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:477 (sofia/external/+14792460547@flowroute.com) State EXECUTE going to sleep 
2013-01-10 13:39:25.816280 [NOTICE] switch_ivr.c:1781 Transfer sofia/external/+14792460547@flowroute.com to XML[3150@default] 
2013-01-10 13:39:25.816280 [DEBUG] switch_core_session.c:830 Send signal sofia/external/+14792460547@flowroute.com [BREAK] 
2013-01-10 13:39:25.816280 [DEBUG] switch_core_session.c:1283 Send signal sofia/external/+14792460547@flowroute.com [BREAK] 
2013-01-10 13:39:25.816280 [DEBUG] switch_ivr.c:1774 (sofia/external/+14792460547@flowroute.com) State Change CS_EXECUTE -> CS_ROUTING 
EXECUTE sofia/external/+14792460547@flowroute.com transfer(3150 XML default) 
2013-01-10 13:39:25.816280 [DEBUG] switch_channel.c:1135 EXPORT (export_vars) [RFC2822_DATE]=[Thu, 10 Jan 2013 13:39:25 -0700] 
EXECUTE sofia/external/+14792460547@flowroute.com export(RFC2822_DATE=Thu, 10 Jan 2013 13:39:25 -0700) 
2013-01-10 13:39:25.816280 [DEBUG] mod_dptools.c:1344 sofia/external/+14792460547@flowroute.com SET [outside_call]=[true] 
EXECUTE sofia/external/+14792460547@flowroute.com set(outside_call=true) 
2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:209 sofia/external/+14792460547@flowroute.com Standard EXECUTE 
2013-01-10 13:39:25.816280 [DEBUG] mod_sofia.c:242 sofia/external/+14792460547@flowroute.com SOFIA EXECUTE 
2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:477 (sofia/external/+14792460547@flowroute.com) State EXECUTE 
2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:415 (sofia/external/+14792460547@flowroute.com) Running State Change CS_EXECUTE 
2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:470 (sofia/external/+14792460547@flowroute.com) State ROUTING going to sleep 
2013-01-10 13:39:25.816280 [DEBUG] switch_core_session.c:1283 Send signal sofia/external/+14792460547@flowroute.com [BREAK] 
2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:167 (sofia/external/+14792460547@flowroute.com) State Change CS_ROUTING -> CS_EXECUTE 
Dialplan: sofia/external/+14792460547@flowroute.com Action transfer(3150 XML default) 
Dialplan: sofia/external/+14792460547@flowroute.com Regex (PASS) [Test_Number] destination_number(15203039810) =~ /^15203039810$/ break=on-false 
Dialplan: sofia/external/+14792460547@flowroute.com Regex (PASS) [Test_Number] context(public) =~ /public/ break=on-false 
Dialplan: sofia/external/+14792460547@flowroute.com parsing [public->Test_Number] continue=false 
Dialplan: sofia/external/+14792460547@flowroute.com Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never 
Dialplan: sofia/external/+14792460547@flowroute.com parsing [public->call_debug] continue=true 
Dialplan: sofia/external/+14792460547@flowroute.com Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) 
Dialplan: sofia/external/+14792460547@flowroute.com Action set(outside_call=true) 
Dialplan: sofia/external/+14792460547@flowroute.com Absolute Condition [outside_call] 
Dialplan: sofia/external/+14792460547@flowroute.com parsing [public->outside_call] continue=true 
Dialplan: sofia/external/+14792460547@flowroute.com Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false 
Dialplan: sofia/external/+14792460547@flowroute.com Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false 
Dialplan: sofia/external/+14792460547@flowroute.com parsing [public->unloop] continue=false 
2013-01-10 13:39:25.816280 [INFO] mod_dialplan_xml.c:498 Processing +14792460547 <+14792460547>->15203039810 in context public 
2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:117 sofia/external/+14792460547@flowroute.com Standard ROUTING 
2013-01-10 13:39:25.816280 [DEBUG] mod_sofia.c:149 sofia/external/+14792460547@flowroute.com SOFIA ROUTING 
2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:470 (sofia/external/+14792460547@flowroute.com) State ROUTING 
2013-01-10 13:39:25.806120 [DEBUG] switch_channel.c:2003 (sofia/external/+14792460547@flowroute.com) Callstate Change DOWN -> RINGING 
2013-01-10 13:39:25.806120 [DEBUG] switch_core_state_machine.c:415 (sofia/external/+14792460547@flowroute.com) Running State Change CS_ROUTING 
2013-01-10 13:39:25.806120 [DEBUG] switch_core_state_machine.c:454 (sofia/external/+14792460547@flowroute.com) State INIT going to sleep 
2013-01-10 13:39:25.806120 [DEBUG] switch_core_session.c:1283 Send signal sofia/external/+14792460547@flowroute.com [BREAK] 
2013-01-10 13:39:25.806120 [DEBUG] mod_sofia.c:126 (sofia/external/+14792460547@flowroute.com) State Change CS_INIT -> CS_ROUTING 
2013-01-10 13:39:25.806120 [DEBUG] mod_sofia.c:86 sofia/external/+14792460547@flowroute.com SOFIA INIT 
2013-01-10 13:39:25.806120 [DEBUG] switch_core_state_machine.c:454 (sofia/external/+14792460547@flowroute.com) State INIT 
2013-01-10 13:39:25.806120 [DEBUG] switch_core_state_machine.c:415 (sofia/external/+14792460547@flowroute.com) Running State Change CS_INIT 
2013-01-10 13:39:25.806120 [DEBUG] switch_core_session.c:1283 Send signal sofia/external/+14792460547@flowroute.com [BREAK] 
2013-01-10 13:39:25.806120 [DEBUG] sofia.c:5831 (sofia/external/+14792460547@flowroute.com) State Change CS_NEW -> CS_INIT 
2013-01-10 13:39:25.806120 [DEBUG] sofia_glue.c:5263 Set 2833 dtmf send/recv payload to 101 
2013-01-10 13:39:25.806120 [DEBUG] switch_core_codec.c:111 sofia/external/+14792460547@flowroute.com Original read codec set to PCMU:0 
2013-01-10 13:39:25.806120 [DEBUG] sofia_glue.c:3093 Set Codec sofia/external/+14792460547@flowroute.com PCMU/8000 20 ms 160 samples 64000 bits 
2013-01-10 13:39:25.806120 [DEBUG] sofia_glue.c:5134 Audio Codec Compare [PCMU:0:8000:20:64000]/[PCMU:0:8000:20:64000] 
2013-01-10 13:39:25.806120 [DEBUG] sofia_glue.c:5134 Audio Codec Compare [PCMU:0:8000:20:64000]/[G722:9:8000:20:64000] 

a=ptime:20 
a=fmtp:101 0-15 
a=rtpmap:101 telephone-event/8000 
a=fmtp:18 annexb=no 
a=rtpmap:18 G729/8000 
m=audio 31632 RTP/AVP 0 18 101 
t=0 0 
c=IN IP4 66.42.121.5 
s=- 
o=- 275426305 1357849875 IN IP4 66.42.121.5 
v=0 
2013-01-10 13:39:25.806120 [DEBUG] sofia.c:5614 Remote SDP: 
2013-01-10 13:39:25.806120 [DEBUG] sofia.c:5603 Channel sofia/external/+14792460547@flowroute.com entering state [received][100] 
2013-01-10 13:39:25.786370 [DEBUG] switch_core_state_machine.c:433 (sofia/external/+14792460547@flowroute.com) State NEW 
2013-01-10 13:39:25.786370 [DEBUG] switch_core_state_machine.c:415 (sofia/external/+14792460547@flowroute.com) Running State Change CS_NEW 
2013-01-10 13:39:25.786370 [DEBUG] switch_core_session.c:975 Send signal sofia/external/+14792460547@flowroute.com [BREAK] 
2013-01-10 13:39:25.786370 [DEBUG] switch_core_session.c:975 Send signal sofia/external/+14792460547@flowroute.com [BREAK] 
2013-01-10 13:39:25.786370 [NOTICE] switch_channel.c:968 New Channel sofia/external/+14792460547@flowroute.com [d276f012-5b65-11e2-beae-8564ff827a25]

Robert 



Date: Thu, 10 Jan 2013 09:47:18 -0800
From: msc@freeswitch.org
To: freeswitch-users@lists.freeswitch.org
Subject: Re: [Freeswitch-users] T38 Configuration

Can you pastebin a console debug log w/ sip trace of a call failing to negotiate t.38 correctly? That might help us figure out where to look.
-MC

On Wed, Jan 9, 2013 at 7:42 PM, Robert Craig <craig.robert@hotmail.com> wrote:
Just installed FusionPBX using the script built for a Centos 6 install. Everything works great in regards to calls, but my main goal of this project was to utilize the fax capabilities of Freeswitch/FusionPBX. I have tried many things in media bypass, routing to a fax extension, using an ATA, etc., but I can't get T38 to negotiate correctly. Can someone point me in the right direction as to where I should begin? I am guessing it isn't supposed to work right out of the box. I am using Flowroute as my provider right now and the have confirmed that they utilize T38 in both directions. Thanks!


Robert

_________________________________________________________________________
Professional FreeSWITCH Consulting Services:
consulting@freeswitch.org
http://www.freeswitchsolutions.com

FreeSWITCH-powered IP PBX: The CudaTel Communication Server
http://www.cudatel.com

Official FreeSWITCH Sites
http://www.freeswitch.org
http://wiki.freeswitch.org
http://www.cluecon.com

FreeSWITCH-users mailing list
FreeSWITCH-users@lists.freeswitch.org
http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
http://www.freeswitch.org




--
Michael S Collins
Twitter: @mercutioviz
http://www.FreeSWITCH.org
http://www.ClueCon.com
http://www.OSTAG.org


_________________________________________________________________________ Professional FreeSWITCH Consulting Services: consulting@freeswitch.org http://www.freeswitchsolutions.com FreeSWITCH-powered IP PBX: The CudaTel Communication Server http://www.cudatel.com Official FreeSWITCH Sites http://www.freeswitch.org http://wiki.freeswitch.org http://www.cluecon.com FreeSWITCH-users mailing list FreeSWITCH-users@lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org