Sending fax problem getting an error fax_result_text: 'Bad TIFF/F header - incorrect values in fields'

Status
Not open for further replies.
A

ankitv

New Member
Jul 15, 2019
1
0
1
37
Hello All,

I have configured freeswitch with version 1.6.stable version and used fusionpbx 4.3.2. Installed mod_spandsp module successfully and required packages without an error. While send a fax from the fax server under application menu getting an error like fax_result_text: 'Bad TIFF/F header - incorrect values in fields'
Below is the call log .

Can you please help me out to resolve this issue.?

==============================================================================================================

2019-08-27 08:19:49.194840 [DEBUG] switch_core_media.c:4041 sofia/external/18XXXXXXXXX@term.skyetel.com:5060 T38 ACCEPT on request
2019-08-27 08:19:49.194840 [DEBUG] switch_core_media.c:4146 sofia/external/18XXXXXXXXX@term.skyetel.com:5060 T38 IS POSSIBLE on request
2019-08-27 08:19:49.214839 [DEBUG] mod_spandsp_fax.c:1040 T38 SDP Origin = Sonus_UAC
2019-08-27 08:19:49.214839 [DEBUG] mod_spandsp_fax.c:1041 T38FaxVersion = 0
2019-08-27 08:19:49.214839 [DEBUG] mod_spandsp_fax.c:1042 T38MaxBitRate = 14400
2019-08-27 08:19:49.214839 [DEBUG] mod_spandsp_fax.c:1043 T38FaxFillBitRemoval = 0
2019-08-27 08:19:49.214839 [DEBUG] mod_spandsp_fax.c:1044 T38FaxTranscodingMMR = 0
2019-08-27 08:19:49.214839 [DEBUG] mod_spandsp_fax.c:1045 T38FaxTranscodingJBIG = 0
2019-08-27 08:19:49.214839 [DEBUG] mod_spandsp_fax.c:1046 T38FaxRateManagement = 'transferredTCF'
2019-08-27 08:19:49.214839 [DEBUG] mod_spandsp_fax.c:1047 T38FaxMaxBuffer = 262
2019-08-27 08:19:49.214839 [DEBUG] mod_spandsp_fax.c:1048 T38FaxMaxDatagram = 176
2019-08-27 08:19:49.214839 [DEBUG] mod_spandsp_fax.c:1049 T38FaxUdpEC = 't38UDPRedundancy'
2019-08-27 08:19:49.214839 [DEBUG] mod_spandsp_fax.c:1050 T38VendorInfo = ''
2019-08-27 08:19:49.214839 [DEBUG] mod_spandsp_fax.c:1051 ip = '67.231.13.15'
2019-08-27 08:19:49.214839 [DEBUG] mod_spandsp_fax.c:1053 port = 43954
2019-08-27 08:19:49.214839 [DEBUG] switch_core_media.c:9751 Remote address:port [67.231.13.15:43954] has not changed.
2019-08-27 08:19:49.214839 [DEBUG] switch_core_media.c:9390 sofia/external/18XXXXXXXXX@term.skyetel.com:5060 image media sdp:
v=0
o=FreeSWITCH 1566873352 1566873354 IN IP4 52.44.100.170
s=FreeSWITCH
c=IN IP4 52.44.100.170
t=0 0
m=image 20634 udptl t38
a=T38FaxVersion:0
a=T38MaxBitRate:14400
a=T38FaxRateManagement:transferredTCF
a=T38FaxMaxBuffer:262
a=T38FaxMaxDatagram:400
a=T38FaxUdpEC:t38UDPRedundancy

2019-08-27 08:19:49.214839 [DEBUG] switch_core_media.c:9751 Remote address:port [67.231.13.15:43954] has not changed.
2019-08-27 08:19:49.214839 [DEBUG] sofia.c:7084 Channel sofia/external/18XXXXXXX@term.skyetel.com:5060 entering state [completed][200]
2019-08-27 08:19:49.334838 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 No signal is present
2019-08-27 08:19:49.374839 [DEBUG] sofia.c:7084 Channel sofia/external/18XXXXXXX@term.skyetel.com:5060 entering state [ready][200]
2019-08-27 08:19:49.634841 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 A signal is present
2019-08-27 08:19:49.634841 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 HDLC signal status is Carrier up (-2) in state T
2019-08-27 08:19:49.634841 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 HDLC signal status is Framing OK (-6) in state T
2019-08-27 08:19:49.634841 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 Changing from phase A_CNG to B_RX
2019-08-27 08:19:49.634841 [DEBUG] mod_spandsp_fax.c:276 FLOW T.38T Set rx type 4
2019-08-27 08:19:49.634841 [DEBUG] mod_spandsp_fax.c:276 FLOW T.38T Set tx type 0
2019-08-27 08:19:50.654840 [DEBUG] mod_spandsp_fax.c:276 FLOW T.38T Type CSI - CRC OK (clean)
2019-08-27 08:19:50.654840 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 Stop none (0 remaining)
2019-08-27 08:19:50.654840 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 Rx: CSI without final frame tag
2019-08-27 08:19:50.654840 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 Rx: ff 03 40 32 32 4e 41 52 54 58 41 46 20 20 20 20 20 20 20 20 20 20 20
2019-08-27 08:19:50.654840 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 Remote gave CSI as: "FAXTRAN22"
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.38T Type DIS - CRC OK, sig end (clean)
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 Stop none (0 remaining)
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 Rx: DIS with final frame tag
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 Rx: ff 13 80 00 6e f8 80 80 90 00
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 Rx final frame in state T
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 Queuing phase B_TX
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 DIS:
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .... ...0= Store and forward Internet fax (T.37): Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .... .0..= Real-time Internet fax (T.38): Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .... 0...= 3G mobile network: Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 ..0. ....= V.8 capabilities: Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .0.. ....= Preferred octets: 256 octets
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .... ...0= Ready to transmit a fax document (polling): Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .... ..1.= Can receive fax: Set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 ..10 11..= Supported data signalling rates: V.27 ter, V.29, and V.17
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .1.. ....= R8x7.7lines/mm and/or 200x200pels/25.4mm: Set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 0... ....= 2-D coding: Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .... ..00= Recording width: 215mm +- 1%
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .... 10..= Recording length: Unlimited
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .111 ....= Receiver's minimum scan line time: 0ms at 3.85 l/mm; T7.7 = T3.85
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 1... ....= Extension indicator: Set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .... ..0.= Compressed/uncompressed mode: Compressed
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .... .0..= Error correction mode (ECM): Non-ECM
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .0.. ....= T.6 coding: Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 1... ....= Extension indicator: Set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .... ...0= "Field not valid" supported: Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .... ..0.= Multiple selective polling: Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .... .0..= Polled sub-address: Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .... 0...= T.43 coding: Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 ...0 ....= Plane interleave: Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 ..0. ....= Voice coding with 32kbit/s ADPCM (Rec. G.726): Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .0.. ....= Reserved for the use of extended voice coding set: Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 1... ....= Extension indicator: Set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .... ...0= R8x15.4lines/mm: Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .... ..0.= 300x300pels/25.4mm: Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .... .0..= R16x15.4lines/mm and/or 400x400pels/25.4mm: Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .... 0...= Inch-based resolution preferred: Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 ...1 ....= Metric-based resolution preferred: Set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 ..0. ....= Minimum scan line time for higher resolutions: T15.4 = T7.7
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .0.. ....= Selective polling: Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 1... ....= Extension indicator: Set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .... ...0= Sub-addressing: Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .... ..0.= Password: Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .... .0..= Ready to transmit a data file (polling): Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 ...0 ....= Binary file transfer (BFT): Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 ..0. ....= Document transfer mode (DTM): Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 .0.. ....= Electronic data interchange (EDI): Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 0... ....= Extension indicator: Not set
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:317 === Negotiation Result =======================================================
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:318 Remote station id: FAXTRAN22
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:319 Local station id: FROM: AAA 123456
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:320 Transfer Rate: 14400
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:322 ECM status off
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:323 remote country:
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:324 remote vendor:
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:325 remote model:
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:327 ==============================================================================
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 Trying to send file '/usr/local/freeswitch/storage/fax/vipul.test.co/7000/temp/59e84bd6-f87e-40d3-a443-4570ab5e7d63.tif'
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 Start sending document
2019-08-27 08:19:51.014835 [WARNING] mod_spandsp_fax.c:276 WARNING T.30 Cannot negotiate an image format
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 Status changing to 'Bad TIFF/F header - incorrect values in fields'
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 Flushing queued phase B_TX
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 Queuing phase D_TX
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 Changing from state T to C
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 Tx: DCN with final frame tag
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 Tx: ff 13 fb
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 HDLC signal status is Carrier down (-1) in state C
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 Changing from phase B_RX to D_TX
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.38T Set rx type 0
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.38T Set tx type 4
2019-08-27 08:19:51.014835 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 No signal is present

2019-08-27 08:19:52.774837 [NOTICE] sofia.c:1012 Hangup sofia/external/1XXXXXXXX@term.skyetel.com:5060 [CS_EXECUTE] [NORMAL_CLEARING]
2019-08-27 08:19:52.774837 [DEBUG] mod_spandsp_fax.c:496 ==============================================================================
2019-08-27 08:19:52.774837 [DEBUG] mod_spandsp_fax.c:508 Fax processing not successful - result (46) Bad TIFF/F header - incorrect values in fields.
2019-08-27 08:19:52.774837 [DEBUG] mod_spandsp_fax.c:513 Remote station id: FAXTRAN22
2019-08-27 08:19:52.774837 [DEBUG] mod_spandsp_fax.c:514 Local station id: FROM: AAA 123456
2019-08-27 08:19:52.774837 [DEBUG] mod_spandsp_fax.c:515 Pages transferred: 0
2019-08-27 08:19:52.774837 [DEBUG] mod_spandsp_fax.c:517 Total fax pages: 1
2019-08-27 08:19:52.774837 [DEBUG] mod_spandsp_fax.c:518 Image resolution: 0x0
2019-08-27 08:19:52.774837 [DEBUG] mod_spandsp_fax.c:519 Transfer Rate: 14400
2019-08-27 08:19:52.774837 [DEBUG] mod_spandsp_fax.c:521 ECM status off
2019-08-27 08:19:52.774837 [DEBUG] mod_spandsp_fax.c:522 remote country:
2019-08-27 08:19:52.774837 [DEBUG] mod_spandsp_fax.c:523 remote vendor:
2019-08-27 08:19:52.774837 [DEBUG] mod_spandsp_fax.c:524 remote model:
2019-08-27 08:19:52.774837 [DEBUG] mod_spandsp_fax.c:526 ==============================================================================
2019-08-27 08:19:52.774837 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 Changing from state B to CALL_FINISHED
2019-08-27 08:19:52.774837 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 Changing from phase E to CALL_FINISHED
2019-08-27 08:19:52.774837 [DEBUG] mod_spandsp_fax.c:276 FLOW T.38T Set rx type 9
2019-08-27 08:19:52.774837 [DEBUG] mod_spandsp_fax.c:276 FLOW T.38T Set tx type 9
2019-08-27 08:19:52.774837 [DEBUG] mod_spandsp_fax.c:276 FLOW T.38T FAX exchange complete
2019-08-27 08:19:52.774837 [DEBUG] mod_spandsp_fax.c:276 FLOW T.30 Call completed


2019-08-27 08:19:53.394843 [INFO] switch_cpp.cpp:1365 [FAX] Success: '0'
2019-08-27 08:19:53.394843 [INFO] switch_cpp.cpp:1365 [FAX] fax_result_text: 'Bad TIFF/F header - incorrect values in fields'
2019-08-27 08:19:53.394843 [INFO] switch_cpp.cpp:1365 [FAX] fax_file: '/usr/local/freeswitch/storage/fax/vipul.test.co/7000/temp/59e84bd6-f87e-40d3-a443-4570ab5e7d63.tif'
2019-08-27 08:19:53.394843 [INFO] switch_cpp.cpp:1365 [FAX] uuid: '55f07112-09bf-4a6d-8681-b2ff38c97b88'
2019-08-27 08:19:53.394843 [INFO] switch_cpp.cpp:1365 [FAX] fax_retry_attempts: 2
2019-08-27 08:19:53.394843 [INFO] switch_cpp.cpp:1365 [FAX] fax_retry_limit: 20
2019-08-27 08:19:53.394843 [INFO] switch_cpp.cpp:1365 [FAX] fax_retry_sleep: 30
2019-08-27 08:19:53.394843 [INFO] switch_cpp.cpp:1365 [FAX] fax_uri: '[origination_caller_id_number=16XXXXXXX]sofia/external/18XXXXXXXX@term.skyetel.com:5060'
2019-08-27 08:19:53.394843 [INFO] switch_cpp.cpp:1365 [FAX] accountcode: 'vipul.test.co'
2019-08-27 08:19:53.394843 [INFO] switch_cpp.cpp:1365 [FAX] origination_caller_id_name: President Patel
2019-08-27 08:19:53.394843 [INFO] switch_cpp.cpp:1365 [FAX] origination_caller_id_number: 16XXXXXX
2019-08-27 08:19:53.394843 [INFO] switch_cpp.cpp:1365 [FAX] fax_result_code: 46
2019-08-27 08:19:53.394843 [INFO] switch_cpp.cpp:1365 [FAX] mailfrom_address: pbx@cloudext.co
2019-08-27 08:19:53.394843 [INFO] switch_cpp.cpp:1365 [FAX] mailto_address: presidentpatel@gmail.com
2019-08-27 08:19:53.394843 [INFO] switch_cpp.cpp:1365 [FAX] hangup_cause_q850: '16'
2019-08-27 08:19:53.394843 [INFO] switch_cpp.cpp:1365 [FAX] Last Fax Failed, try a different way. Wait first.
 
Status
Not open for further replies.
Top Bottom