<div dir="ltr">I am trying to send fax to a local fax machine (Canon MX 512) on my LAN using freeswitch. The machine is connected via linksys pap2 (ATA) on LAN to freeswitch.<div><div><br></div><div>the command I am using on freeswitch console is:</div>
</div><div>/usr/local/freeswitch/bin/fs_cli -x "originate {fax_verbose=true,ignore_early_media=true,absolute_codec_string='PCMU'}user/1006 &txfax(/tmp/txfax.tiff)"<br></div><div><br></div><div>The machine in question is Canon Mx 512 in fax only mode. Note that I am able to send out fax from this machine and receive it in freeswitch using rxfax. The problem is only in sending fax to this machine using txfax. </div>
<div><br></div><div>The complete error log is at paste <a href="http://pastebin.freeswitch.org/21151">http://pastebin.freeswitch.org/21151</a></div><div>Here are some relevant snippets from error log</div><div><br></div><div>
<div>2013-07-04 21:23:09.215751 [DEBUG] mod_sofia.c:243 sofia/internal/<a href="http://sip:1006@10.2.2.159:8081">sip:1006@10.2.2.159:8081</a> SOFIA EXECUTE</div><div>2013-07-04 21:23:09.215751 [DEBUG] switch_core_state_machine.c:209 sofia/internal/<a href="http://sip:1006@10.2.2.159:8081">sip:1006@10.2.2.159:8081</a> Standard EXECUTE</div>
<div>EXECUTE sofia/internal/<a href="http://sip:1006@10.2.2.159:8081">sip:1006@10.2.2.159:8081</a> txfax(/tmp/txfax.tiff)</div><div>2013-07-04 21:23:09.215751 [DEBUG] mod_spandsp_fax.c:1387 Raw read codec activation Success L16 30000</div>
<div>2013-07-04 21:23:09.215751 [DEBUG] switch_core_codec.c:219 sofia/internal/<a href="http://sip:1006@10.2.2.159:8081">sip:1006@10.2.2.159:8081</a> Push codec L16:70</div><div>2013-07-04 21:23:09.215751 [DEBUG] mod_spandsp_fax.c:1403 Raw write codec activation Success L16</div>
<div>2013-07-04 21:23:09.265748 [DEBUG] switch_rtp.c:3706 Correct ip/port confirmed.</div><div>2013-07-04 21:23:09.265748 [DEBUG] switch_core_io.c:759 Engaging Read Buffer at 480 bytes vs 160</div><div>2013-07-04 21:23:09.475748 [WARNING] mod_sofia.c:1279 Asynchronous PTIME not supported, changing our end from 30 to 20</div>
<div>2013-07-04 21:23:09.475748 [DEBUG] sofia_glue.c:3037 Changing Codec from PCMU@30ms@8000hz to PCMU@20ms@8000hz</div><div>2013-07-04 21:23:09.535748 [DEBUG] switch_rtp.c:1873 RE-Starting timer [soft] 160 bytes per 20ms</div>
<div>2013-07-04 21:23:09.535748 [DEBUG] sofia_glue.c:3124 Set Codec sofia/internal/<a href="http://sip:1006@10.2.2.159:8081">sip:1006@10.2.2.159:8081</a> PCMU/8000 20 ms 160 samples 64000 bits</div><div>2013-07-04 21:23:09.555751 [DEBUG] switch_core_io.c:1365 Engaging Write Buffer at 320 bytes to accommodate 480->320</div>
<div>2013-07-04 21:23:12.095748 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 HDLC signal status is Carrier up (-2) in state T</div><div>2013-07-04 21:23:15.095748 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 HDLC signal status is Carrier down (-1) in state T</div>
<div>2013-07-04 21:23:15.155748 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 HDLC signal status is Carrier up (-2) in state T</div><div>2013-07-04 21:23:15.195750 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 HDLC signal status is Abort (-8) in state T</div>
<div>2013-07-04 21:23:15.235749 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 HDLC signal status is Abort (-8) in state T</div><div>2013-07-04 21:23:15.275748 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 HDLC signal status is Abort (-8) in state T</div>
<div>2013-07-04 21:23:15.315750 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 HDLC signal status is Abort (-8) in state T</div><div>2013-07-04 21:23:15.355748 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 HDLC signal status is Abort (-8) in state T</div>
<div>2013-07-04 21:23:15.395748 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 HDLC signal status is Abort (-8) in state T</div><div>2013-07-04 21:23:15.635748 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 HDLC signal status is Abort (-8) in state T</div>
<div>2013-07-04 21:23:15.715751 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 HDLC signal status is Abort (-8) in state T</div><div>2013-07-04 21:23:15.795749 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 HDLC signal status is Abort (-8) in state T</div>
<div>2013-07-04 21:23:15.915751 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 HDLC signal s</div></div><div><br></div><div>**** repeats many times ****</div><div><br></div><div><div>2013-07-04 21:23:47.035750 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 HDLC signal status is Abort (-8) in state T</div>
<div>2013-07-04 21:23:48.115755 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 HDLC signal status is Abort (-8) in state T</div><div>2013-07-04 21:23:48.135749 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 HDLC signal status is Carrier down (-1) in state T</div>
<div>2013-07-04 21:23:49.535749 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 T0 expired in state T</div><div>2013-07-04 21:23:49.535749 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 Status changing to 'Timed out waiting for initial communication'</div>
<div>2013-07-04 21:23:49.535749 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 Disconnecting</div><div>2013-07-04 21:23:49.535749 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 Changing from phase A_CNG to E</div><div>2013-07-04 21:23:49.535749 [DEBUG] mod_spandsp_fax.c:291 FLOW FAX Set rx type 0</div>
<div>2013-07-04 21:23:49.535749 [DEBUG] mod_spandsp_fax.c:291 FLOW FAX Set tx type 1</div><div>2013-07-04 21:23:49.535749 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 Changing from state T to B</div><div>2013-07-04 21:23:50.195748 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 Send complete in phase E, state B</div>
<div>2013-07-04 21:23:50.195748 [DEBUG] mod_spandsp_fax.c:511 ==============================================================================</div><div>2013-07-04 21:23:50.195748 [DEBUG] mod_spandsp_fax.c:524 Fax processing not successful - result (2) Timed out waiting for initial communication.</div>
<div>2013-07-04 21:23:50.195748 [DEBUG] mod_spandsp_fax.c:529 Remote station id: </div><div>2013-07-04 21:23:50.195748 [DEBUG] mod_spandsp_fax.c:530 Local station id: SpanDSP Fax Ident</div><div>2013-07-04 21:23:50.195748 [DEBUG] mod_spandsp_fax.c:531 Pages transferred: 0</div>
<div>2013-07-04 21:23:50.195748 [DEBUG] mod_spandsp_fax.c:533 Total fax pages: 0</div><div>2013-07-04 21:23:50.195748 [DEBUG] mod_spandsp_fax.c:534 Image resolution: 0x0</div><div>2013-07-04 21:23:50.195748 [DEBUG] mod_spandsp_fax.c:535 Transfer Rate: 14400</div>
<div>2013-07-04 21:23:50.195748 [DEBUG] mod_spandsp_fax.c:537 ECM status off</div><div>2013-07-04 21:23:50.195748 [DEBUG] mod_spandsp_fax.c:538 remote country: </div><div>2013-07-04 21:23:50.195748 [DEBUG] mod_spandsp_fax.c:539 remote vendor: </div>
<div>2013-07-04 21:23:50.195748 [DEBUG] mod_spandsp_fax.c:540 remote model: </div><div>2013-07-04 21:23:50.195748 [DEBUG] mod_spandsp_fax.c:542 ==============================================================================</div>
<div>2013-07-04 21:23:50.195748 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 Changing from state B to CALL_FINISHED</div><div>2013-07-04 21:23:50.195748 [DEBUG] mod_spandsp_fax.c:291 FLOW T.30 Changing from phase E to CALL_FINISHED</div>
<div>2013-07-04 21:23:50.195748 [DEBUG] mod_spandsp_fax.c:291 FLOW FAX Set rx type 9</div><div>2013-07-04 21:23:50.195748 [DEBUG] mod_spandsp_fax.c:291 FLOW FAX FAX exchange complete</div><div>2013-07-04 21:23:50.195748 [DEBUG] mod_spandsp_fax.c:291 FLOW FAX Set tx type 9</div>
<div>2013-07-04 21:23:50.195748 [DEBUG] mod_spandsp_fax.c:291 FLOW FAX FAX exchange complete</div><div>2013-07-04 21:23:50.215748 [DEBUG] switch_core_codec.c:244 sofia/internal/<a href="http://sip:1006@10.2.2.159:8081">sip:1006@10.2.2.159:8081</a> Restore previous codec PCMU:0.</div>
<div>2013-07-04 21:23:50.215748 [NOTICE] switch_core_state_machine.c:262 sofia/internal/<a href="http://sip:1006@10.2.2.159:8081">sip:1006@10.2.2.159:8081</a> has executed the last dialplan instruction, hanging up.</div></div>
<div><br></div><div><div><br></div></div><div></div></div>