[hylafax-users] excessive "delay 1500 ms" errors

[mnoel@xxxxxxxxxxx]

I'm running a couple of hylafax servers and things are working great for the most part.   I'm using the t38modem.

 

I have noticed that for some inbound calls the fax never comes though.  It seems that the faxmodem answers but then the call gets dropped after several seconds.  In almost all cases I see a long sequence of "DELAY 1500 ms" errors.  I've pasted a complete log file below for reference. 

 

This seems to be isolated to particular callers since I am often receiving "good" faxes at the same time that these bad ones are coming in.  I am seeing this behavior on both my fax servers.

 

What might the problem be?  What can I do to try to fix this.

 

-Mike Noel

 

Apr 22 19:11:54.96: [10928]: SESSION BEGIN 000400296
Apr 22 19:11:54.96: [10928]: HylaFAX (tm) Version 4.2.0
Apr 22
19:11:54.96: [10928]: <-- [4:ATA\r]
Apr 22 19:11:59.32: [10928]:
--> [7:CONNECT]
Apr 22 19:11:59.32: [10928]: ANSWER: FAX
CONNECTION  DEVICE '/dev/ttyxd'
Apr 22 19:11:59.32: [10928]:
STATE CHANGE: ANSWERING -> RECEIVING
Apr 22 19:11:59.32: [10928]:
MODEM input buffering enabled
Apr 22 19:11:59.32: [10928]: RECV FAX:
begin
Apr 22 19:11:59.32: [10928]: MODEM input buffering
disabled
Apr 22 19:11:59.32: [10928]: <-- HDLC<32:FF C0 04 AD
00 55 12 9E 36 86 62 82 1A 04 14 2E B6 94 04 6A A6 4E CE 96 F6 76 04 2C
74 4C 74 0C>
Apr 22 19:11:59.32: [10928]: <-- data [32]
Apr
22 19:11:59.32: [10928]: <-- data [2]
Apr 22 19:12:01.11:
[10928]: --> [7:CONNECT]
Apr 22 19:12:01.11: [10928]: <--
HDLC<23:FF C0 02 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04
04 04 04>
Apr 22 19:12:01.11: [10928]: <-- data [23]
Apr 22
19:12:01.11: [10928]: <-- data [2]
Apr 22 19:12:01.83: [10928]:
--> [7:CONNECT]
Apr 22 19:12:01.83: [10928]: <-- HDLC<10:FF
C8 01 00 76 5F 23 01 FB C0>
Apr 22 19:12:01.83: [10928]: <--
data [10]
Apr 22 19:12:01.83: [10928]: <-- data [2]
Apr 22
19:12:02.24: [10928]: --> [2:OK]
Apr 22 19:12:02.24: [10928]:
<-- [9:AT+FRH=3\r]
Apr 22 19:12:03.07: [10928]: -->
[7:CONNECT]
Apr 22 19:12:08.07: [10928]: MODEM TIMEOUT: receiving
HDLC frame data
Apr 22 19:12:08.07: [10928]: <-- data [1]
Apr
22 19:12:08.07: [10928]: --> [5:ERROR]
Apr 22 19:12:08.07:
[10928]: MODEM Command error
Apr 22 19:12:08.07: [10928]: DELAY 1500
ms
Apr 22 19:12:09.57: [10928]: <-- [9:AT+FTH=3\r]
Apr 22
19:12:12.56: [10928]: --> [0:]
Apr 22 19:12:12.56: [10928]: MODEM
TIMEOUT: sending HDLC frame
Apr 22 19:12:12.56: [10928]: DELAY 1500
ms
Apr 22 19:12:14.06: [10928]: <-- [9:AT+FTH=3\r]
Apr 22
19:12:14.16: [10928]: --> [5:ERROR]
Apr 22 19:12:14.16: [10928]:
DELAY 1500 ms
Apr 22 19:12:15.66: [10928]: <--
[9:AT+FTH=3\r]
Apr 22 19:12:15.76: [10928]: --> [5:ERROR]
Apr
22 19:12:15.76: [10928]: DELAY 1500 ms
Apr 22 19:12:17.26: [10928]:
<-- [9:AT+FTH=3\r]
Apr 22 19:12:17.36: [10928]: -->
[5:ERROR]
Apr 22 19:12:17.36: [10928]: DELAY 1500 ms
Apr 22
19:12:18.86: [10928]: <-- [9:AT+FTH=3\r]
Apr 22 19:12:18.96:
[10928]: --> [5:ERROR]
Apr 22 19:12:18.96: [10928]: DELAY 1500
ms
Apr 22 19:12:20.46: [10928]: <-- [9:AT+FTH=3\r]
Apr 22
19:12:20.56: [10928]: --> [5:ERROR]
Apr 22 19:12:20.56: [10928]:
DELAY 1500 ms
Apr 22 19:12:22.06: [10928]: <--
[9:AT+FTH=3\r]
Apr 22 19:12:22.16: [10928]: --> [5:ERROR]
Apr
22 19:12:22.16: [10928]: DELAY 1500 ms
Apr 22 19:12:23.66: [10928]:
<-- [9:AT+FTH=3\r]
Apr 22 19:12:23.76: [10928]: -->
[5:ERROR]
Apr 22 19:12:23.76: [10928]: DELAY 1500 ms
Apr 22
19:12:25.26: [10928]: <-- [9:AT+FTH=3\r]
Apr 22 19:12:25.36:
[10928]: --> [5:ERROR]
Apr 22 19:12:25.36: [10928]: DELAY 1500
ms
Apr 22 19:12:26.86: [10928]: <-- [9:AT+FTH=3\r]
Apr 22
19:12:26.96: [10928]: --> [5:ERROR]
Apr 22 19:12:26.96: [10928]:
DELAY 1500 ms
Apr 22 19:12:28.46: [10928]: <--
[9:AT+FTH=3\r]
Apr 22 19:12:28.56: [10928]: --> [5:ERROR]
Apr
22 19:12:28.56: [10928]: DELAY 1500 ms
Apr 22 19:12:30.06: [10928]:
<-- [9:AT+FTH=3\r]
Apr 22 19:12:30.16: [10928]: -->
[5:ERROR]
Apr 22 19:12:30.16: [10928]: DELAY 1500 ms
Apr 22
19:12:31.66: [10928]: <-- [9:AT+FTH=3\r]
Apr 22 19:12:31.76:
[10928]: --> [5:ERROR]
Apr 22 19:12:31.76: [10928]: DELAY 1500
ms
Apr 22 19:12:33.26: [10928]: <-- [9:AT+FTH=3\r]
Apr 22
19:12:33.36: [10928]: --> [5:ERROR]
Apr 22 19:12:33.36: [10928]:
DELAY 1500 ms
Apr 22 19:12:34.86: [10928]: <--
[9:AT+FTH=3\r]
Apr 22 19:12:34.96: [10928]: --> [5:ERROR]
Apr
22 19:12:34.96: [10928]: DELAY 1500 ms
Apr 22 19:12:36.46: [10928]:
<-- [9:AT+FTH=3\r]
Apr 22 19:12:36.56: [10928]: -->
[5:ERROR]
Apr 22 19:12:36.56: [10928]: DELAY 1500 ms
Apr 22
19:12:38.06: [10928]: <-- [9:AT+FTH=3\r]
Apr 22 19:12:38.16:
[10928]: --> [5:ERROR]
Apr 22 19:12:38.16: [10928]: RECV FAX: No
answer (T.30 T1 timeout)
Apr 22 19:12:38.16: [10928]: RECV FAX:
end
Apr 22 19:12:38.16: [10928]: SESSION END

 

____________________ HylaFAX(tm) Users Mailing List _______________________
  To subscribe/unsubscribe, click http://lists.hylafax.org/cgi-bin/lsg2.cgi
 On UNIX: mail -s unsubscribe hylafax-users-request@xxxxxxxxxxx < /dev/null
  *To learn about commercial HylaFAX(tm) support, mail sales@xxxxxxxxx*