[Freeswitch-users] T38 Configuration

Robert Craig craig.robert at hotmail.com
Sun Jan 13 00:05:48 MSK 2013


What did you do on the config side to get it to work? I've tried both an Ata and a fax to email extension and they both fail in both directions.

Robert

On Jan 12, 2013, at 2:04 PM, "George Assaad" <gassaad at emassembly.com> wrote:

> I use Fusion successfully to send / receive fax.
> The way it works: 
> ATA --->FaxServer.
> After successful receipt, Fax Server---> DID where you have dialled originally.
> 
> Cheers,
> 
> George
> 
> 
> On Fri, Jan 11, 2013 at 4:31 PM, Robert Craig <craig.robert at hotmail.com> wrote:
>> Did anyone see the issue or what I may have missed in the config? As mentioned earlier, I thought it would after a fresh install. Any help is appreciated.
>> 
>> Robert
>> 
>> 
>> From: craig.robert at hotmail.com
>> To: freeswitch-users at lists.freeswitch.org
>> Date: Thu, 10 Jan 2013 13:43:09 -0700
>> 
>> Subject: Re: [Freeswitch-users] T38 Configuration
>> 
>> 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 at flowroute.com) State DESTROY going to sleep 
>> 2013-01-10 13:39:53.162506 [DEBUG] switch_core_state_machine.c:99 sofia/external/+14792460547 at flowroute.com Standard DESTROY 
>> 2013-01-10 13:39:53.162506 [DEBUG] mod_sofia.c:396 sofia/external/+14792460547 at flowroute.com SOFIA DESTROY 
>> 2013-01-10 13:39:53.162506 [DEBUG] switch_core_state_machine.c:569 (sofia/external/+14792460547 at flowroute.com) State DESTROY 
>> 2013-01-10 13:39:53.162506 [DEBUG] switch_core_state_machine.c:559 (sofia/external/+14792460547 at flowroute.com) Running State Change CS_DESTROY 
>> 2013-01-10 13:39:53.162506 [DEBUG] switch_core_state_machine.c:556 (sofia/external/+14792460547 at flowroute.com) Callstate Change HANGUP -> DOWN 
>> 2013-01-10 13:39:53.162506 [NOTICE] switch_core_session.c:1510 Close Channel sofia/external/+14792460547 at flowroute.com [CS_DESTROY] 
>> 2013-01-10 13:39:53.162506 [NOTICE] switch_core_session.c:1506 Session 26 (sofia/external/+14792460547 at flowroute.com) Ended 
>> 2013-01-10 13:39:53.162506 [DEBUG] switch_core_session.c:1488 Session 26 (sofia/external/+14792460547 at 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 at flowroute.com [BREAK] 
>> 2013-01-10 13:39:53.162506 [DEBUG] switch_core_state_machine.c:440 (sofia/external/+14792460547 at 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 at flowroute.com) State REPORTING going to sleep 
>> 2013-01-10 13:39:53.162506 [DEBUG] switch_core_state_machine.c:92 sofia/external/+14792460547 at flowroute.com Standard REPORTING, cause: NORMAL_CLEARING 
>> 2013-01-10 13:39:53.066135 [DEBUG] switch_core_state_machine.c:749 (sofia/external/+14792460547 at flowroute.com) State REPORTING 
>> 2013-01-10 13:39:53.066135 [DEBUG] switch_core_state_machine.c:415 (sofia/external/+14792460547 at 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 at flowroute.com [BREAK] 
>> 2013-01-10 13:39:53.066135 [DEBUG] switch_core_state_machine.c:446 (sofia/external/+14792460547 at 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 at 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 at flowroute.com) State HANGUP going to sleep 
>> 2013-01-10 13:39:52.216151 [DEBUG] switch_core_state_machine.c:48 sofia/external/+14792460547 at 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 at flowroute.com 
>> 2013-01-10 13:39:52.216151 [DEBUG] mod_sofia.c:503 Channel sofia/external/+14792460547 at flowroute.com hanging up, cause: NORMAL_CLEARING 
>> 2013-01-10 13:39:52.216151 [DEBUG] switch_core_state_machine.c:667 (sofia/external/+14792460547 at flowroute.com) State HANGUP 
>> 2013-01-10 13:39:52.216151 [DEBUG] switch_core_state_machine.c:415 (sofia/external/+14792460547 at flowroute.com) Running State Change CS_HANGUP 
>> 2013-01-10 13:39:52.216151 [DEBUG] switch_core_state_machine.c:477 (sofia/external/+14792460547 at flowroute.com) State EXECUTE going to sleep 
>> 2013-01-10 13:39:52.216151 [DEBUG] switch_core_session.c:2687 sofia/external/+14792460547 at 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 at flowroute.com [BREAK] 
>> 2013-01-10 13:39:52.216151 [DEBUG] switch_channel.c:3017 Send signal sofia/external/+14792460547 at flowroute.com [KILL] 
>> 2013-01-10 13:39:52.216151 [NOTICE] mod_dptools.c:1150 Hangup sofia/external/+14792460547 at flowroute.com [CS_EXECUTE] [NORMAL_CLEARING] 
>> 2013-01-10 13:39:52.216151 [DEBUG] switch_channel.c:2994 (sofia/external/+14792460547 at flowroute.com) Callstate Change ACTIVE -> HANGUP 
>> EXECUTE sofia/external/+14792460547 at flowroute.com hangup() 
>> 2013-01-10 13:39:52.216151 [DEBUG] switch_core_codec.c:244 sofia/external/+14792460547 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at flowroute.com entering state [ready][200] 
>> 2013-01-10 13:39:29.566140 [DEBUG] switch_core_session.c:975 Send signal sofia/external/+14792460547 at flowroute.com [BREAK] 
>> 2013-01-10 13:39:29.566140 [DEBUG] switch_core_session.c:975 Send signal sofia/external/+14792460547 at 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 at flowroute.com entering state [completing][200] 
>> 2013-01-10 13:39:29.566140 [INFO] sofia.c:931 sofia/external/+14792460547 at 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 at flowroute.com [BREAK] 
>> 2013-01-10 13:39:29.556130 [DEBUG] switch_core_session.c:975 Send signal sofia/external/+14792460547 at flowroute.com [BREAK] 
>> 2013-01-10 13:39:29.266195 [DEBUG] sofia.c:5603 Channel sofia/external/+14792460547 at flowroute.com entering state [calling][0] 
>> 2013-01-10 13:39:29.256196 [DEBUG] switch_core_session.c:975 Send signal sofia/external/+14792460547 at 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 at 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 at 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 at 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 at flowroute.com entering state [ready][200] 
>> 2013-01-10 13:39:26.096329 [DEBUG] switch_core_session.c:975 Send signal sofia/external/+14792460547 at flowroute.com [BREAK] 
>> 2013-01-10 13:39:26.096329 [DEBUG] switch_core_session.c:975 Send signal sofia/external/+14792460547 at flowroute.com [BREAK] 
>> 2013-01-10 13:39:26.096329 [DEBUG] switch_core_session.c:975 Send signal sofia/external/+14792460547 at flowroute.com [BREAK] 
>> 2013-01-10 13:39:26.016177 [DEBUG] switch_ivr_play_say.c:1309 Codec Activated L16 at 8000hz 1 channels 20ms 
>> EXECUTE sofia/external/+14792460547 at flowroute.com playback(silence_stream://2000) 
>> 2013-01-10 13:39:26.016177 [DEBUG] mod_dptools.c:1344 sofia/external/+14792460547 at flowroute.com SET [last_fax]=[+14792460547-2013-01-10-13-39-26] 
>> EXECUTE sofia/external/+14792460547 at 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 at flowroute.com SET [fax_enable_t38_request]=[true] 
>> EXECUTE sofia/external/+14792460547 at flowroute.com set(fax_enable_t38_request=true) 
>> 2013-01-10 13:39:26.006127 [DEBUG] mod_dptools.c:1344 sofia/external/+14792460547 at flowroute.com SET [fax_enable_t38]=[true] 
>> 2013-01-10 13:39:26.006127 [DEBUG] sofia.c:5603 Channel sofia/external/+14792460547 at flowroute.com entering state [completed][200] 
>> EXECUTE sofia/external/+14792460547 at 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 at flowroute.com [BREAK] 
>> 2013-01-10 13:39:26.006127 [NOTICE] mod_dptools.c:1176 Channel [sofia/external/+14792460547 at flowroute.com] has been answered 
>> 2013-01-10 13:39:26.006127 [DEBUG] switch_channel.c:3395 (sofia/external/+14792460547 at flowroute.com) Callstate Change RINGING -> ACTIVE 
>> 2013-01-10 13:39:26.006127 [DEBUG] switch_core_session.c:830 Send signal sofia/external/+14792460547 at 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 at flowroute.com: 
>> 2013-01-10 13:39:26.006127 [DEBUG] sofia_glue.c:3645 sofia/external/+14792460547 at 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 at 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 at flowroute.com answer() 
>> 2013-01-10 13:39:25.816280 [DEBUG] mod_dptools.c:1344 sofia/external/+14792460547 at flowroute.com SET [api_hangup_hook]=[system /usr/bin/php /var/www/html/fusionpbx/secure/fax_to_email.php email=robert.l.craig at 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 at flowroute.com set(api_hangup_hook=system /usr/bin/php /var/www/html/fusionpbx/secure/fax_to_email.php email=robert.l.craig at 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 at flowroute.com SET [RFC2822_DATE]=[Thu, 10 Jan 2013 13:39:25 -0700] 
>> EXECUTE sofia/external/+14792460547 at flowroute.com set(RFC2822_DATE=Thu, 10 Jan 2013 13:39:25 -0700) 
>> EXECUTE sofia/external/+14792460547 at flowroute.com hash(insert/192.168.4.15-last_dial/global/d276f012-5b65-11e2-beae-8564ff827a25) 
>> EXECUTE sofia/external/+14792460547 at flowroute.com hash(insert/192.168.4.15-last_dial/+14792460547/3150) 
>> EXECUTE sofia/external/+14792460547 at 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 at flowroute.com SET [call_direction]=[local] 
>> EXECUTE sofia/external/+14792460547 at flowroute.com set(call_direction=local) 
>> 2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:209 sofia/external/+14792460547 at flowroute.com Standard EXECUTE 
>> 2013-01-10 13:39:25.816280 [DEBUG] mod_sofia.c:242 sofia/external/+14792460547 at flowroute.com SOFIA EXECUTE 
>> 2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:477 (sofia/external/+14792460547 at flowroute.com) State EXECUTE 
>> 2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:415 (sofia/external/+14792460547 at flowroute.com) Running State Change CS_EXECUTE 
>> 2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:470 (sofia/external/+14792460547 at 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 at flowroute.com [BREAK] 
>> 2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:167 (sofia/external/+14792460547 at flowroute.com) State Change CS_ROUTING -> CS_EXECUTE 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Action hangup() 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Action rxfax(/usr/local/freeswitch/storage/fax/3150/inbox/${last_fax}.tif) 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Action playback(silence_stream://2000) 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Action set(last_fax=${caller_id_number}-${strftime(%Y-%m-%d-%H-%M-%S)}) 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Action set(fax_enable_t38_request=true) 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Action set(fax_enable_t38=true) 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Action answer() 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Action set(api_hangup_hook=system /usr/bin/php /var/www/html/fusionpbx/secure/fax_to_email.php email=robert.l.craig at 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 at flowroute.com Regex (PASS) [Test Fax] destination_number(3150) =~ /^3150$/ break=on-false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com parsing [default->Test Fax] continue=false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Regex (FAIL) [vmain_user] destination_number(3150) =~ /^\*97$/ break=on-false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com parsing [default->vmain_user] continue=false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Regex (FAIL) [vmain] destination_number(3150) =~ /^vmain$|^\*4000$|^\*98$/ break=on-false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com parsing [default->vmain] continue=false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Regex (FAIL) [send_to_voicemail] destination_number(3150) =~ /^\*99(\d{2,7})$/ break=on-false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com parsing [default->send_to_voicemail] continue=false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Regex (FAIL) [extension-intercom] destination_number(3150) =~ /^\*8(\d{2,7})$/ break=on-false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com parsing [default->extension-intercom] continue=false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Regex (FAIL) [intercept-ext] destination_number(3150) =~ /^\*\*(\d+)$/ break=on-false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com parsing [default->intercept-ext] continue=false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Regex (FAIL) [call_return] destination_number(3150) =~ /^\*69$|^lcr$/ break=on-false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com parsing [default->call_return] continue=false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Regex (FAIL) [call_privacy] destination_number(3150) =~ /^\*67(\d+)$/ break=on-false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com parsing [default->call_privacy] continue=false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Action hash(insert/${domain_name}-last_dial/global/${uuid}) 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number}) 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid}) 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Absolute Condition [global] 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never 
>> Dialplan: sofia/external/+14792460547 at flowroute.com parsing [default->global] continue=true 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Regex (FAIL) [redial] destination_number(3150) =~ /^(redial|\*870)$/ break=on-false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com parsing [default->redial] continue=false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Regex (FAIL) [group-intercept] destination_number(3150) =~ /^\*8$/ break=on-false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com parsing [default->group-intercept] continue=false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com ANTI-Action set(call_direction=local) 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Regex (FAIL) [call-direction] ${call_direction}() =~ /^(inbound|outbound|local)$/ break=on-false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com parsing [default->call-direction] continue=true 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Regex (FAIL) [Flowroute.11d] destination_number(3150) =~ /^\+?(\d{11})$/ break=on-false 
>> Dialplan: sofia/external/+14792460547 at 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 at flowroute.com Standard ROUTING 
>> 2013-01-10 13:39:25.816280 [DEBUG] mod_sofia.c:149 sofia/external/+14792460547 at flowroute.com SOFIA ROUTING 
>> 2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:470 (sofia/external/+14792460547 at flowroute.com) State ROUTING 
>> 2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:415 (sofia/external/+14792460547 at flowroute.com) Running State Change CS_ROUTING 
>> 2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:477 (sofia/external/+14792460547 at flowroute.com) State EXECUTE going to sleep 
>> 2013-01-10 13:39:25.816280 [NOTICE] switch_ivr.c:1781 Transfer sofia/external/+14792460547 at flowroute.com to XML[3150 at default] 
>> 2013-01-10 13:39:25.816280 [DEBUG] switch_core_session.c:830 Send signal sofia/external/+14792460547 at flowroute.com [BREAK] 
>> 2013-01-10 13:39:25.816280 [DEBUG] switch_core_session.c:1283 Send signal sofia/external/+14792460547 at flowroute.com [BREAK] 
>> 2013-01-10 13:39:25.816280 [DEBUG] switch_ivr.c:1774 (sofia/external/+14792460547 at flowroute.com) State Change CS_EXECUTE -> CS_ROUTING 
>> EXECUTE sofia/external/+14792460547 at 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 at 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 at flowroute.com SET [outside_call]=[true] 
>> EXECUTE sofia/external/+14792460547 at flowroute.com set(outside_call=true) 
>> 2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:209 sofia/external/+14792460547 at flowroute.com Standard EXECUTE 
>> 2013-01-10 13:39:25.816280 [DEBUG] mod_sofia.c:242 sofia/external/+14792460547 at flowroute.com SOFIA EXECUTE 
>> 2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:477 (sofia/external/+14792460547 at flowroute.com) State EXECUTE 
>> 2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:415 (sofia/external/+14792460547 at flowroute.com) Running State Change CS_EXECUTE 
>> 2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:470 (sofia/external/+14792460547 at 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 at flowroute.com [BREAK] 
>> 2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:167 (sofia/external/+14792460547 at flowroute.com) State Change CS_ROUTING -> CS_EXECUTE 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Action transfer(3150 XML default) 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Regex (PASS) [Test_Number] destination_number(15203039810) =~ /^15203039810$/ break=on-false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Regex (PASS) [Test_Number] context(public) =~ /public/ break=on-false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com parsing [public->Test_Number] continue=false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never 
>> Dialplan: sofia/external/+14792460547 at flowroute.com parsing [public->call_debug] continue=true 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Action set(outside_call=true) 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Absolute Condition [outside_call] 
>> Dialplan: sofia/external/+14792460547 at flowroute.com parsing [public->outside_call] continue=true 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false 
>> Dialplan: sofia/external/+14792460547 at flowroute.com Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false 
>> Dialplan: sofia/external/+14792460547 at 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 at flowroute.com Standard ROUTING 
>> 2013-01-10 13:39:25.816280 [DEBUG] mod_sofia.c:149 sofia/external/+14792460547 at flowroute.com SOFIA ROUTING 
>> 2013-01-10 13:39:25.816280 [DEBUG] switch_core_state_machine.c:470 (sofia/external/+14792460547 at flowroute.com) State ROUTING 
>> 2013-01-10 13:39:25.806120 [DEBUG] switch_channel.c:2003 (sofia/external/+14792460547 at flowroute.com) Callstate Change DOWN -> RINGING 
>> 2013-01-10 13:39:25.806120 [DEBUG] switch_core_state_machine.c:415 (sofia/external/+14792460547 at flowroute.com) Running State Change CS_ROUTING 
>> 2013-01-10 13:39:25.806120 [DEBUG] switch_core_state_machine.c:454 (sofia/external/+14792460547 at 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 at flowroute.com [BREAK] 
>> 2013-01-10 13:39:25.806120 [DEBUG] mod_sofia.c:126 (sofia/external/+14792460547 at flowroute.com) State Change CS_INIT -> CS_ROUTING 
>> 2013-01-10 13:39:25.806120 [DEBUG] mod_sofia.c:86 sofia/external/+14792460547 at flowroute.com SOFIA INIT 
>> 2013-01-10 13:39:25.806120 [DEBUG] switch_core_state_machine.c:454 (sofia/external/+14792460547 at flowroute.com) State INIT 
>> 2013-01-10 13:39:25.806120 [DEBUG] switch_core_state_machine.c:415 (sofia/external/+14792460547 at 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 at flowroute.com [BREAK] 
>> 2013-01-10 13:39:25.806120 [DEBUG] sofia.c:5831 (sofia/external/+14792460547 at 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 at 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 at 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 at flowroute.com entering state [received][100] 
>> 2013-01-10 13:39:25.786370 [DEBUG] switch_core_state_machine.c:433 (sofia/external/+14792460547 at flowroute.com) State NEW 
>> 2013-01-10 13:39:25.786370 [DEBUG] switch_core_state_machine.c:415 (sofia/external/+14792460547 at 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 at flowroute.com [BREAK] 
>> 2013-01-10 13:39:25.786370 [DEBUG] switch_core_session.c:975 Send signal sofia/external/+14792460547 at flowroute.com [BREAK] 
>> 2013-01-10 13:39:25.786370 [NOTICE] switch_channel.c:968 New Channel sofia/external/+14792460547 at flowroute.com [d276f012-5b65-11e2-beae-8564ff827a25]
>> 
>> Robert 
>> 
>> 
>> 
>> Date: Thu, 10 Jan 2013 09:47:18 -0800
>> From: msc at freeswitch.org
>> To: freeswitch-users at 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 at 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 at freeswitch.org
>> http://www.freeswitchsolutions.com
>> 
>> 
>> 
>> 
>> Official FreeSWITCH Sites
>> http://www.freeswitch.org
>> http://wiki.freeswitch.org
>> http://www.cluecon.com
>> 
>> FreeSWITCH-users mailing list
>> FreeSWITCH-users at 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 at freeswitch.org http://www.freeswitchsolutions.com   Official FreeSWITCH Sites http://www.freeswitch.org http://wiki.freeswitch.org http://www.cluecon.com FreeSWITCH-users mailing list FreeSWITCH-users at lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org
>> 
>> _________________________________________________________________________ Professional FreeSWITCH Consulting Services: consulting at freeswitch.org http://www.freeswitchsolutions.com   Official FreeSWITCH Sites http://www.freeswitch.org http://wiki.freeswitch.org http://www.cluecon.com FreeSWITCH-users mailing list FreeSWITCH-users at lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org
>> 
>> _________________________________________________________________________
>> Professional FreeSWITCH Consulting Services:
>> consulting at freeswitch.org
>> http://www.freeswitchsolutions.com
>> 
>> 
>> 
>> 
>> Official FreeSWITCH Sites
>> http://www.freeswitch.org
>> http://wiki.freeswitch.org
>> http://www.cluecon.com
>> 
>> FreeSWITCH-users mailing list
>> FreeSWITCH-users at lists.freeswitch.org
>> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
>> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
>> http://www.freeswitch.org
> 
> _________________________________________________________________________
> Professional FreeSWITCH Consulting Services:
> consulting at freeswitch.org
> http://www.freeswitchsolutions.com
> 
> 
> 
> 
> Official FreeSWITCH Sites
> http://www.freeswitch.org
> http://wiki.freeswitch.org
> http://www.cluecon.com
> 
> FreeSWITCH-users mailing list
> FreeSWITCH-users at lists.freeswitch.org
> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
> http://www.freeswitch.org
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20130112/103b2e25/attachment-0001.html 
-------------- next part --------------
_________________________________________________________________________
Professional FreeSWITCH Consulting Services:
consulting at freeswitch.org
http://www.freeswitchsolutions.com




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

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


Join us at ClueCon 2011 Aug 9-11, 2011
More information about the FreeSWITCH-users mailing list