[hylafax-users] recv: AT+FRH=3 -> v.21 timeout

[Giulio Orsero <giulioo@pobox.com>]

sending is
RCV56DPF L8570A Rev 45.0/45.0/class1
HylaFAX 4.1beta2 + some old eop patches

receiving is 
RCV56DPF L8570A Rev 47.22/47.22 /class1
HylaFAX 4.1rc2
+ 
hylafax-eom-117.patch
hylafax-tsi-52.patch
hylafax-eop-152.patch
hylafax-cid-139.patch
(numbers are bugzilla id's)

Problem is that the receiving modem always loses 5/6 seconds at start of
receiving due to v.21 carrier, then all is ok (fax received). Log is at the end.
I had this problem with rc1 (without above patches). 

The topology is complicated:
sending hylafax->modem->pabx->line->pabx->voice-over-ip->modem->recv hylafax.

I'd just like to know if this annoyance is due to the above topology or is
something between HylaFAX and the modem that is not related to line condition.

Faxes are always received ok, but I always get this timeout:

====
Jun 19 19:44:14.03: [12609]: SESSION BEGIN 00000021 3912300000000
Jun 19 19:44:14.03: [12609]: MODEM set XON/XOFF/FLUSH: input ignored, output dis
abled
Jun 19 19:44:14.03: [12609]: <-- [4:ATA\r]
Jun 19 19:44:20.11: [12609]: --> [7:CONNECT]
Jun 19 19:44:20.11: [12609]: ANSWER: FAX CONNECTION
Jun 19 19:44:20.11: [12609]: STATE CHANGE: ANSWERING -> RECEIVING
Jun 19 19:44:20.11: [12609]: sched policy=1, priority=1
Jun 19 19:44:20.11: [12609]: MODEM input buffering enabled
Jun 19 19:44:20.11: [12609]: RECV FAX: begin
Jun 19 19:44:20.11: [12609]: MODEM input buffering disabled
Jun 19 19:44:20.11: [12609]: <-- HDLC<23:FF C0 02 0C 0C 0C 0C 0C 0C 0C 0C 04 CC
4C 8C 04 9C CC D4 04 04 04 04>
Jun 19 19:44:20.11: [12609]: <-- data [23]
Jun 19 19:44:20.11: [12609]: <-- data [2]
Jun 19 19:44:21.80: [12609]: --> [7:CONNECT]
Jun 19 19:44:21.80: [12609]: <-- HDLC<10:FF C8 01 00 77 5F 01 79 03 C0>
Jun 19 19:44:21.80: [12609]: <-- data [10]
Jun 19 19:44:21.80: [12609]: <-- data [2]
Jun 19 19:44:22.35: [12609]: --> [2:OK]
Jun 19 19:44:22.35: [12609]: <-- [9:AT+FRH=3\r]
Jun 19 19:44:25.45: [12609]: --> [0:]
Jun 19 19:44:25.45: [12609]: MODEM <Empty line>
Jun 19 19:44:25.45: [12609]: MODEM TIMEOUT: waiting for v.21 carrier
Jun 19 19:44:25.45: [12609]: <-- data [1]
Jun 19 19:44:25.51: [12609]: --> [2:OK]
Jun 19 19:44:25.51: [12609]: DELAY 1500 ms
Jun 19 19:44:27.01: [12609]: <-- [9:AT+FTH=3\r]
Jun 19 19:44:27.06: [12609]: --> [7:CONNECT]
Jun 19 19:44:27.06: [12609]: <-- HDLC<23:FF C0 02 0C 0C 0C 0C 0C 0C 0C 0C 04 CC
4C 8C 04 9C CC D4 04 04 04 04>
Jun 19 19:44:27.06: [12609]: <-- data [23]
Jun 19 19:44:27.06: [12609]: <-- data [2]
Jun 19 19:44:28.85: [12609]: --> [7:CONNECT]
Jun 19 19:44:28.85: [12609]: <-- HDLC<10:FF C8 01 00 77 5F 01 79 03 C0>
Jun 19 19:44:28.85: [12609]: <-- data [10]
Jun 19 19:44:28.85: [12609]: <-- data [2]
Jun 19 19:44:29.39: [12609]: --> [2:OK]
Jun 19 19:44:29.39: [12609]: <-- [9:AT+FRH=3\r]
Jun 19 19:44:30.76: [12609]: --> [7:CONNECT]
Jun 19 19:44:32.18: [12609]: --> HDLC<25:FF C0 C2 0C EC 6C EC 4C 6C 04 9C 8C 0C
04 9C CC D4 04 04 04 04 04 04 7C B2>
Jun 19 19:44:32.19: [12609]: --> [2:OK]
Jun 19 19:44:32.19: [12609]: REMOTE TSI "+39 111 111111"
Jun 19 19:44:32.19: [12609]: <-- [9:AT+FRH=3\r]
Jun 19 19:44:32.21: [12609]: --> [7:CONNECT]
Jun 19 19:44:32.42: [12609]: --> HDLC<8:FF C8 C1 00 47 1E 36 71>
Jun 19 19:44:32.43: [12609]: --> [2:OK]
Jun 19 19:44:32.43: [12609]: REMOTE wants 14400 bit/s
Jun 19 19:44:32.43: [12609]: REMOTE wants page width 1728 pixels in 215 mm
Jun 19 19:44:32.43: [12609]: REMOTE wants unlimited page length
Jun 19 19:44:32.43: [12609]: REMOTE wants 7.7 line/mm
Jun 19 19:44:32.43: [12609]: REMOTE wants 2-D MR
Jun 19 19:44:32.43: [12609]: RECV training at v.17 14400 bit/s
Jun 19 19:44:32.43: [12609]: MODEM set XON/XOFF/DRAIN: input ignored, output gen
erated
Jun 19 19:44:32.43: [12609]: <-- [11:AT+FRM=145\r]
Jun 19 19:44:34.13: [12609]: --> [7:CONNECT]

then all is ok/normal

Sending log (clocks are in sync, allow +- 1 sec)
Jun 19 19:43:49.77: [13969]: DIAL 02222,111111111,,,,111
Jun 19 19:43:49.77: [13969]: <-- [28:ATDT02222,111111111,,,,111@\r]
Jun 19 19:44:28.51: [13969]: --> [7:CONNECT]
Jun 19 19:44:28.51: [13969]: MODEM input buffering disabled
Jun 19 19:44:29.56: [13969]: --> HDLC<25:FF C0 02 0C 0C 0C 0C 0C 0C 0C 0C 04 CC
4C 8C 04 9C CC D4 04 04 04 04 63 A8>
Jun 19 19:44:29.56: [13969]: --> [2:OK]
Jun 19 19:44:29.56: [13969]: REMOTE CSI "+39 123 00000000"
Jun 19 19:44:29.56: [13969]: <-- [9:AT+FRH=3\r]
Jun 19 19:44:29.58: [13969]: --> [7:CONNECT]
Jun 19 19:44:29.94: [13969]: --> HDLC<12:FF C8 01 00 77 5F 01 19 01 00 98 E4>
Jun 19 19:44:29.95: [13969]: --> [2:OK]
Jun 19 19:44:29.95: [13969]: REMOTE best rate 14400 bit/s
...
====

Thanks

-- 
giulioo@pobox.com


____________________ HylaFAX(tm) Users Mailing List _______________________
 To unsub: mail -s unsubscribe hylafax-users-request@hylafax.org < /dev/null