Re: [hylafax-users] incoming fax call lasts forever

[Andrew <andrew@xxxxxxxxxxx>]

Hi Aidan,

Thanks for the quick reply.  I have attached the log as below. You can see the big gap at 02:12:13.50 (where the RECV starts). It is only ended when the other end hits 'cancel'.

Any hints greatly appreciated!

Thanks,
Andrew.

log# cat c000000001
Aug 28 02:11:37.13: [ 4185]: SESSION BEGIN 000000001 61262xxxxx
Aug 28 02:11:37.13: [ 4185]: HylaFAX (tm) Version 4.3.1
Aug 28 02:11:37.13: [ 4185]: <-- [4:ATA\r]
Aug 28 02:11:46.31: [ 4185]: --> [7:CONNECT]
Aug 28 02:11:46.31: [ 4185]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyUSB0'
Aug 28 02:11:46.31: [ 4185]: RECV FAX: begin
Aug 28 02:11:46.32: [ 4185]: <-- data [32]
Aug 28 02:11:46.32: [ 4185]: <-- data [2]
Aug 28 02:11:46.34: [ 4185]: --> [7:CONNECT]
Aug 28 02:11:46.34: [ 4185]: <-- data [23]
Aug 28 02:11:46.34: [ 4185]: <-- data [2]
Aug 28 02:11:46.36: [ 4185]: --> [7:CONNECT]
Aug 28 02:11:46.36: [ 4185]: <-- data [13]
Aug 28 02:11:46.36: [ 4185]: <-- data [2]
Aug 28 02:11:49.57: [ 4185]: --> [2:OK]
Aug 28 02:11:49.57: [ 4185]: <-- [9:AT+FRH=3\r]
Aug 28 02:11:50.03: [ 4185]: --> [7:CONNECT]
Aug 28 02:11:54.68: [ 4185]: --> [2:OK]
Aug 28 02:11:54.68: [ 4185]: HDLC frame too short (0 bytes)
Aug 28 02:11:54.68: [ 4185]: <-- [9:AT+FRS=7\r]
Aug 28 02:11:54.69: [ 4185]: --> [2:OK]
Aug 28 02:11:54.69: [ 4185]: <-- [9:AT+FTH=3\r]
Aug 28 02:11:54.74: [ 4185]: --> [7:CONNECT]
Aug 28 02:11:54.74: [ 4185]: <-- data [3]
Aug 28 02:11:54.74: [ 4185]: <-- data [2]
Aug 28 02:11:56.05: [ 4185]: --> [2:OK]
Aug 28 02:11:56.05: [ 4185]: RECV send CRP (command repeat)
Aug 28 02:11:56.05: [ 4185]: <-- [9:AT+FRH=3\r]
Aug 28 02:11:56.24: [ 4185]: --> [7:CONNECT]
Aug 28 02:11:56.53: [ 4185]: --> [2:OK]
Aug 28 02:11:56.53: [ 4185]: DELAY 1500 ms
Aug 28 02:11:58.03: [ 4185]: <-- [9:AT+FTH=3\r]
Aug 28 02:11:58.08: [ 4185]: --> [7:CONNECT]
Aug 28 02:11:58.08: [ 4185]: <-- data [32]
Aug 28 02:11:58.08: [ 4185]: <-- data [2]
Aug 28 02:11:58.10: [ 4185]: --> [7:CONNECT]
Aug 28 02:11:58.10: [ 4185]: <-- data [23]
Aug 28 02:11:58.11: [ 4185]: <-- data [2]
Aug 28 02:11:58.13: [ 4185]: --> [7:CONNECT]
Aug 28 02:11:58.13: [ 4185]: <-- data [13]
Aug 28 02:11:58.13: [ 4185]: <-- data [2]
Aug 28 02:12:01.34: [ 4185]: --> [2:OK]
Aug 28 02:12:01.34: [ 4185]: <-- [9:AT+FRH=3\r]
Aug 28 02:12:05.02: [ 4185]: --> [7:CONNECT]
Aug 28 02:12:06.61: [ 4185]: --> [2:OK]
Aug 28 02:12:06.61: [ 4185]: REMOTE TSI "1300720xxx"
Aug 28 02:12:06.61: [ 4185]: <-- [9:AT+FRH=3\r]
Aug 28 02:12:06.63: [ 4185]: --> [7:CONNECT]
Aug 28 02:12:06.96: [ 4185]: --> [2:OK]
Aug 28 02:12:06.96: [ 4185]: REMOTE wants 14400 bit/s
Aug 28 02:12:06.96: [ 4185]: REMOTE wants A4 page width (215 mm)
Aug 28 02:12:06.96: [ 4185]: REMOTE wants unlimited page length
Aug 28 02:12:06.96: [ 4185]: REMOTE wants 7.7 line/mm
Aug 28 02:12:06.96: [ 4185]: REMOTE wants 2-D MR
Aug 28 02:12:06.96: [ 4185]: RECV training at v.17 14400 bit/s
Aug 28 02:12:06.96: [ 4185]: <-- [11:AT+FRM=145\r]
Aug 28 02:12:08.66: [ 4185]: --> [7:CONNECT]
Aug 28 02:12:10.44: [ 4185]: RECV: TCF 2520 bytes, 0% non-zero, 2520 zero-run
Aug 28 02:12:10.44: [ 4185]: --> [10:NO CARRIER]
Aug 28 02:12:10.44: [ 4185]: <-- [9:AT+FRS=7\r]
Aug 28 02:12:10.46: [ 4185]: --> [2:OK]
Aug 28 02:12:10.46: [ 4185]: TRAINING succeeded
Aug 28 02:12:10.46: [ 4185]: <-- [9:AT+FTH=3\r]
Aug 28 02:12:10.50: [ 4185]: --> [7:CONNECT]
Aug 28 02:12:10.51: [ 4185]: <-- data [3]
Aug 28 02:12:10.51: [ 4185]: <-- data [2]
Aug 28 02:12:11.82: [ 4185]: --> [2:OK]
Aug 28 02:12:11.82: [ 4185]: <-- [11:AT+FRM=146\r]
Aug 28 02:12:13.50: [ 4185]: --> [7:CONNECT]
Aug 28 02:12:13.50: [ 4185]: RECV: begin page
Aug 28 02:21:41.86: [ 4185]: RECV: 2268 total lines, 0 bad lines, 0 consecutive bad lines
Aug 28 02:21:41.86: [ 4185]: RECV: end page
Aug 28 02:21:41.96: [ 4185]: --> [10:NO CARRIER]
Aug 28 02:21:41.96: [ 4185]: <-- [9:AT+FRH=3\r]
Aug 28 02:21:42.21: [ 4185]: --> [7:CONNECT]
Aug 28 02:21:43.32: [ 4185]: --> [2:OK]
Aug 28 02:21:43.32: [ 4185]: RECV recv EOP (no more pages or documents)
Aug 28 02:21:43.32: [ 4185]: <-- [9:AT+FRS=7\r]
Aug 28 02:21:43.43: [ 4185]: --> [2:OK]
Aug 28 02:21:43.43: [ 4185]: <-- [9:AT+FTH=3\r]
Aug 28 02:21:43.58: [ 4185]: --> [7:CONNECT]
Aug 28 02:21:43.58: [ 4185]: <-- data [3]
Aug 28 02:21:43.58: [ 4185]: <-- data [2]
Aug 28 02:21:44.89: [ 4185]: --> [2:OK]
Aug 28 02:21:44.89: [ 4185]: RECV send MCF (message confirmation)
Aug 28 02:21:44.89: [ 4185]: RECV FAX (000000001): from 1300720069, page 1 in 9:55, INF, 7.7 line/mm, 2-D MR, 14400 bit/s
Aug 28 02:21:44.90: [ 4185]: RECV FAX (000000001): recvq/fax000000001.tif from 1300720069, route to <unspecified>, 1 pages in 9:58
Aug 28 02:21:44.90: [ 4185]: <-- [9:AT+FRH=3\r]
Aug 28 02:21:45.31: [ 4185]: --> [7:CONNECT]
Aug 28 02:21:50.00: [ 4185]: --> [2:OK]
Aug 28 02:21:50.00: [ 4185]: HDLC frame too short (0 bytes)
Aug 28 02:21:50.00: [ 4185]: <-- [9:AT+FRS=7\r]
Aug 28 02:21:50.11: [ 4185]: --> [2:OK]
Aug 28 02:21:50.11: [ 4185]: <-- [9:AT+FTH=3\r]
Aug 28 02:21:50.26: [ 4185]: --> [7:CONNECT]
Aug 28 02:21:50.26: [ 4185]: <-- data [3]
Aug 28 02:21:50.26: [ 4185]: <-- data [2]
Aug 28 02:21:51.57: [ 4185]: --> [2:OK]
Aug 28 02:21:51.57: [ 4185]: RECV send CRP (command repeat)
Aug 28 02:21:51.57: [ 4185]: <-- [9:AT+FRH=3\r]
Aug 28 02:21:56.61: [ 4185]: --> [2:OK]
Aug 28 02:21:56.61: [ 4185]: RECV FAX: bin/faxrcvd "recvq/fax000000001.tif" "ttyUSB0" "000000001" ""
Aug 28 02:21:56.61: [ 4185]: RECV FAX: end
Aug 28 02:21:56.61: [ 4185]: SESSION END


Aidan Van Dyk wrote:

* Andrew <andrew@xxxxxxxxxxx> [080826 02:57]:
  

Hi All,

I am new to HylaFax, and am using the hylafax package (I believe v4.4)
that comes with Debian Stable.

I am able to receive a fax, however the call does not terminate (it
basically sits there forever on a single page... 10-15 minutes+ before I
get the sender to press cancel on the sending fax).  Once the sender
presses cancel, the fax is stored in the queue (and no error messages in
Syslog).   The sender is using a standard fax (and I have tried a few
senders) - always the same problem.

Other information: I am in Australia (not sure if that is relevant to
modem settings).


Any advice on where I should start troubleshooting?
    

Look at the logs in $SPOOL/log.  There is 1 log per fax session, and
they should contain details of the incoming session.  If there aren't
any details in it, alter the SessionLogging optoin for the per-device
config file:
	/var/spool/hylafax/etc/config.<device>



  

____________________ 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*