Hi Steve, Thanks for the answers.
Comments inline. 2009/5/20 Steve Underwood <ste...@coppice.org>: > Did you draw that arrow in the wrong direction? The side answering the > call should send the first V.21 signal. No. That's what the wireshark trace shows. >> The relevant information in the asterisk configuration files is: >> >> extensions.conf >> >> [fax-in] >> exten => 99999,1,Set(INCOMING_FAXFILE=/root/santi/fax/incoming.tif) >> exten => 99999,n,Answer() >> exten => 99999,n,Wait(3) >> exten => 99999,n,ReceiveFax(${INCOMING_FAXFILE}) > Try changing that Wait(3) to Wait(6). It seems some T.38 boxes act > strangely if the T.38 negotiation occurs too soon after the call starts. > I am not clear why, though I have tried to find suitable test cases to > pin this down. Changed that, but no luck, same problem. What it is strange to me is that receiving faxes always work for me in the case that the calling part (CISCO) sends the re-INVITE but it doesn't if its the receiver of the fax (asterisk) that sends this re-INVITE. I thought the standard said that the re-INVITE should be sent by the receiver ot the fax. This is part of the log file with debug level set to 4 showing the start of the T.38 negotiation. The setup is tried 4 times before dropping the call. I hope this helps to shed some light on the issue. May 20 16:39:58 server asterisk[2456]: VERBOSE[25323]: -- Executing [99...@fax-in:5] ReceiveFAX("SIP/10.100.27.254-b7b27f60", "/tmp/incoming1242830392.464.tif") in new stack May 20 16:39:58 server asterisk[2456]: DEBUG[25323]: channel.c:3385 in set_format: Set channel SIP/10.100.27.254-b7b27f60 to read format slin May 20 16:39:58 server asterisk[2456]: DEBUG[25323]: channel.c:3385 in set_format: Set channel SIP/10.100.27.254-b7b27f60 to write format slin May 20 16:39:58 server asterisk[2456]: DEBUG[25323]: app_fax.c:363 in transmit_audio: Setting up CNG detection on SIP/10.100.27.254-b7b27f60 May 20 16:39:58 server asterisk[2456]: DEBUG[25323]: dsp.c:408 in ast_tone_detect_init: Setup tone 1100 Hz, 500 ms, block_size=160, hits_required=21 May 20 16:39:58 server asterisk[2456]: DEBUG[25323]: dsp.c:408 in ast_tone_detect_init: Setup tone 2100 Hz, 2600 ms, block_size=160, hits_required=116 May 20 16:39:58 server asterisk[2456]: DEBUG[25323]: channel.c:2241 in ast_settimeout: Scheduling timer at 160 sample intervals May 20 16:39:58 server asterisk[2456]: DEBUG[25323]: channel.c:2352 in ast_read_generator_actions: Generator got voice, switching to phase locked mode May 20 16:39:58 server asterisk[2456]: DEBUG[25323]: channel.c:2241 in ast_settimeout: Scheduling timer at 0 sample intervals May 20 16:39:58 server asterisk[2456]: DEBUG[25323]: rtp.c:3189 in ast_rtp_write: Ooh, format changed from unknown to alaw May 20 16:39:58 server asterisk[2456]: DEBUG[25323]: rtp.c:3205 in ast_rtp_write: Created smoother: format: 8 ms: 20 len: 160 May 20 16:39:59 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 HDLC carrier up in state 1 May 20 16:39:59 server asterisk[2456]: DEBUG[25323]: dsp.c:526 in tone_detect: 1100 Hz done detected May 20 16:39:59 server asterisk[2456]: DEBUG[25323]: app_fax.c:398 in transmit_audio: Fax tone detected. Requesting T38 May 20 16:39:59 server asterisk[2456]: DEBUG[25323]: chan_sip.c:3953 in change_t38_state: T38 state changed to 2 on channel SIP/10.100.27.254-b7b27f60 May 20 16:39:59 server asterisk[2456]: DEBUG[25323]: chan_sip.c:8126 in t38_get_rate: T38MaxBitRate 9600 found May 20 16:39:59 server asterisk[2456]: DEBUG[25323]: chan_sip.c:2360 in initialize_initreq: Initializing already initialized SIP dialog e9c2bf4f-448211de-b049f119-6b05d...@10.100.27.254 (presumably reinvite) May 20 16:39:59 server asterisk[2456]: DEBUG[25323]: chan_sip.c:2598 in __sip_xmit: Trying to put 'INVITE sip' onto UDP socket destined for 10.100.27.254:5060 May 20 16:39:59 server asterisk[2456]: DEBUG[25323]: rtp.c:1100 in ast_rtcp_read: Got RTCP report of 72 bytes May 20 16:39:59 server asterisk[2456]: DEBUG[2577]: chan_sip.c:3115 in __sip_semi_ack: (Provisional) Stopping retransmission (but retaining packet) on 'e9c2bf4f-448211de-b049f119-6b05d...@10.100.27.254' Request 102: Found May 20 16:39:59 server asterisk[2456]: DEBUG[2577]: chan_sip.c:14927 in handle_response_invite: SIP response 100 to RE-invite on outgoing call e9c2bf4f-448211de-b049f119-6b05d...@10.100.27.254 May 20 16:39:59 server asterisk[2456]: DEBUG[2577]: chan_sip.c:3040 in __sip_ack: Acked pending invite 102 May 20 16:39:59 server asterisk[2456]: DEBUG[2577]: chan_sip.c:3075 in __sip_ack: Stopping retransmission on 'e9c2bf4f-448211de-b049f119-6b05d...@10.100.27.254' of Request 102: Match Found May 20 16:39:59 server asterisk[2456]: DEBUG[2577]: chan_sip.c:14927 in handle_response_invite: SIP response 200 to RE-invite on outgoing call e9c2bf4f-448211de-b049f119-6b05d...@10.100.27.254 May 20 16:39:59 server asterisk[2456]: DEBUG[2577]: chan_sip.c:6990 in process_sdp: FaxVersion: 0 May 20 16:39:59 server asterisk[2456]: DEBUG[2577]: chan_sip.c:6967 in process_sdp: T38MaxBitRate: 9600 May 20 16:39:59 server asterisk[2456]: DEBUG[2577]: chan_sip.c:7032 in process_sdp: RateManagement: transferredTCF May 20 16:39:59 server asterisk[2456]: DEBUG[2577]: chan_sip.c:6964 in process_sdp: MaxBufferSize:200 May 20 16:39:59 server asterisk[2456]: DEBUG[2577]: chan_sip.c:6997 in process_sdp: FaxMaxDatagram: 72 May 20 16:39:59 server asterisk[2456]: DEBUG[2577]: chan_sip.c:3953 in change_t38_state: T38 state changed to 5 on channel SIP/10.100.27.254-b7b27f60 May 20 16:39:59 server asterisk[2456]: DEBUG[2577]: chan_sip.c:7112 in process_sdp: Have T.38 but no audio codecs, accepting offer anyway May 20 16:39:59 server asterisk[2456]: DEBUG[2577]: chan_sip.c:4524 in update_call_counter: Updating call counter for incoming call May 20 16:39:59 server asterisk[2456]: DEBUG[2577]: chan_sip.c:2598 in __sip_xmit: Trying to put 'ACK sip:97' onto UDP socket destined for 10.100.27.254:5060 May 20 16:39:59 server asterisk[2456]: DEBUG[25323]: app_fax.c:430 in transmit_audio: T38 negotiated, finishing audio loop May 20 16:39:59 server asterisk[2456]: DEBUG[25323]: app_fax.c:448 in transmit_audio: Loop finished, res=1 May 20 16:39:59 server asterisk[2456]: DEBUG[25323]: channel.c:2241 in ast_settimeout: Scheduling timer at 0 sample intervals May 20 16:39:59 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 Changing from state 1 to 32 May 20 16:39:59 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 Changing from phase T30_PHASE_A_CED to T30_PHASE_CALL_FINISHED May 20 16:39:59 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW FAX Set rx type 13 May 20 16:39:59 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW FAX FAX exchange complete May 20 16:39:59 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW FAX Set tx type 13 May 20 16:39:59 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW FAX FAX exchange complete May 20 16:39:59 server asterisk[2456]: DEBUG[25323]: channel.c:3385 in set_format: Set channel SIP/10.100.27.254-b7b27f60 to write format alaw May 20 16:39:59 server asterisk[2456]: DEBUG[25323]: channel.c:3385 in set_format: Set channel SIP/10.100.27.254-b7b27f60 to read format alaw May 20 16:39:59 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 0: indicator no-signal May 20 16:39:59 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Rx 0: IFP 00 May 20 16:39:59 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Rx 0: indicator no-signal May 20 16:39:59 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 No signal is present May 20 16:40:00 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 1: indicator ced May 20 16:40:00 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Rx 1: IFP 00 May 20 16:40:00 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Rx 1: indicator no-signal May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 Send complete in phase T30_PHASE_A_CED, state 1 May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 Starting answer mode May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 Changing from phase T30_PHASE_A_CED to T30_PHASE_B_TX May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38T Set rx type 0 May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38T Set tx type 4 May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 Changing from state 1 to 17 May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 DIS: May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... ...1= Store and forward Internet fax (T.37): Set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... .1..= Real-time Internet fax (T.38): Set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... 0...= 3G mobile network: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 ..0. ....= V.8 capabilities: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .0.. ....= Preferred octets: 256 octets May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... ...0= Ready to transmit a fax document (polling): Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... ..1.= Can receive fax: Set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 ..10 11..= Supported data signalling rates: V.27 ter, V.29, and V.17 May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .1.. ....= R8x7.7lines/mm and/or 200x200pels/25.4mm: Set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 1... ....= 2-D coding: Set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... ..00= Recording width: 215mm +- 1% May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... 10..= Recording length: Unlimited May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .111 ....= Receiver's minimum scan line time: 0ms at 3.85 l/mm; T7.7 = T3.85 May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 1... ....= Extension indicator: Set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... ..0.= Compressed/uncompressed mode: Compressed May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... .1..= Error correction mode (ECM): ECM May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .1.. ....= T.6 coding: Set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 1... ....= Extension indicator: Set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... ...0= "Field not valid" supported: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... ..0.= Multiple selective polling: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... .0..= Polled sub-address: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... 0...= T.43 coding: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 ...0 ....= Plane interleave: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 ..0. ....= Voice coding with 32kbit/s ADPCM (Rec. G.726): Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .0.. ....= Reserved for the use of extended voice coding set: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 1... ....= Extension indicator: Set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... ...1= R8x15.4lines/mm: Set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... ..0.= 300x300pels/25.4mm: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... .0..= R16x15.4lines/mm and/or 400x400pels/25.4mm: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... 0...= Inch-based resolution preferred: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 ...1 ....= Metric-based resolution preferred: Set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 ..0. ....= Minimum scan line time for higher resolutions: T15.4 = T7.7 May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .0.. ....= Selective polling: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 1... ....= Extension indicator: Set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... ...0= Sub-addressing: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... ..0.= Password: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... .0..= Ready to transmit a data file (polling): Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 ...0 ....= Binary file transfer (BFT): Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 ..0. ....= Document transfer mode (DTM): Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .0.. ....= Electronic data interchange (EDI): Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 1... ....= Extension indicator: Set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... ...0= Basic transfer mode (BTM): Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... .0..= Ready to transfer a character or mixed mode document (polling): Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... 0...= Character mode: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 ..0. ....= Mixed mode (Annex E/T.4): Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 1... ....= Extension indicator: Set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... ...0= Processable mode 26 (Rec. T.505): Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... ..0.= Digital network capability: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... .0..= Duplex capability: Half only May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... 0...= JPEG coding: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 ...0 ....= Full colour mode: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .0.. ....= 12bits/pel component: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 1... ....= Extension indicator: Set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... ...0= No subsampling (1:1:1): Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... ..0.= Custom illuminant: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... .0..= Custom gamut range: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .... 1...= North American Letter (215.9mm x 279.4mm): Set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 ...1 ....= North American Legal (215.9mm x 355.6mm): Set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 ..0. ....= Single-progression sequential coding (Rec. T.85) basic: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 .0.. ....= Single-progression sequential coding (Rec. T.85) optional L0: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 0... ....= Extension indicator: Not set May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 Tx: DIS with final frame tag May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 Tx: ff 13 80 05 ee f8 c4 80 91 80 80 80 18 May 20 16:40:03 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 2: indicator v21-preamble May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 3: (0) data v21/hdlc-data + 1 byte(s) May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 3: IFP c0 01 80 00 00 ff May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 4: (0) data v21/hdlc-data + 1 byte(s) May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 4: IFP c0 01 80 00 00 c8 May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 5: (0) data v21/hdlc-data + 1 byte(s) May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 5: IFP c0 01 80 00 00 01 May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 6: (0) data v21/hdlc-data + 1 byte(s) May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 6: IFP c0 01 80 00 00 a0 May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 7: (0) data v21/hdlc-data + 1 byte(s) May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 7: IFP c0 01 80 00 00 77 May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 8: (0) data v21/hdlc-data + 1 byte(s) May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 8: IFP c0 01 80 00 00 1f May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 9: (0) data v21/hdlc-data + 1 byte(s) May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 9: IFP c0 01 80 00 00 23 May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 10: (0) data v21/hdlc-data + 1 byte(s) May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 10: IFP c0 01 80 00 00 01 May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 11: (0) data v21/hdlc-data + 1 byte(s) May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 11: IFP c0 01 80 00 00 89 May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 12: (0) data v21/hdlc-data + 1 byte(s) May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 12: IFP c0 01 80 00 00 01 May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 13: (0) data v21/hdlc-data + 1 byte(s) May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 13: IFP c0 01 80 00 00 01 May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 14: (0) data v21/hdlc-data + 1 byte(s) May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 14: IFP c0 01 80 00 00 01 May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 15: (0) data v21/hdlc-data + 1 byte(s) May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 15: IFP c0 01 80 00 00 18 May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 Send complete in phase T30_PHASE_B_TX, state 17 May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 16: (0) data v21/hdlc-fcs-OK-sig-end + 0 byte(s) May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 16: IFP c0 01 40 May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38 Tx 17: indicator no-signal May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 Send complete in phase T30_PHASE_B_TX, state 17 May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 Changing from phase T30_PHASE_B_TX to T30_PHASE_B_RX May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38T Set rx type 4 May 20 16:40:04 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38T Set tx type 0 May 20 16:40:08 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 T4 expired in phase T30_PHASE_B_RX, state 17 May 20 16:40:08 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.30 Changing from phase T30_PHASE_B_RX to T30_PHASE_B_TX May 20 16:40:08 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38T Set rx type 0 May 20 16:40:08 server asterisk[2456]: DEBUG[25323]: app_fax.c:129 in span_message: FLOW T.38T Set tx type 4 > Why turn off ECM? Turned it on. Best regards, Santiago Gimeno _______________________________________________ -- Bandwidth and Colocation Provided by http://www.api-digital.com -- asterisk-users mailing list To UNSUBSCRIBE or update options visit: http://lists.digium.com/mailman/listinfo/asterisk-users