[hylafax-users] Sending fails with Asterisk/iaxmodem loopback

["Stefan Unterhofer" <stefan.unterhofer@xxxxxxxxxxxxxx>]

Hello,

In order to do some Hylafax testing i set up a Asterisk server with two iaxmodems and let Hylafax send faxes from one modem to the other. (both modems are managed by the same Hylafax instance).
The connection works, but sending always fails with "RSPREC error/got DCN".

Here are the Hylafax log files:

##########################################
iaxmodem 1 (sending):
#########################################
Feb 27 13:16:58.34: [ 9494]: SESSION BEGIN 000000024 43200
Feb 27 13:16:58.34: [ 9494]: HylaFAX (tm) Version 5.0.4
Feb 27 13:16:58.34: [ 9494]: SEND FAX: JOB 49 DEST 1200 COMMID 000000024 DEVICE '/dev/ttyIAX' FROM 'stefan <
stefan.unterhofer@xxxxxxxxxxxxxx>' USER stefan
Feb 27 13:16:58.34: [ 9494]: STATE CHANGE: RUNNING -> SENDING
Feb 27 13:16:58.34: [ 9494]: <-- [12:AT+FCLASS=1\r]
Feb 27 13:16:58.34: [ 9494]: --> [2:OK]
Feb 27 13:16:58.34: [ 9494]: MODEM set XON/XOFF/FLUSH: input ignored, output disabled
Feb 27 13:16:58.34: [ 9494]: DIAL 1200
Feb 27 13:16:58.34: [ 9494]: <-- [9:ATDT1200\r]
Feb 27 13:17:01.56: [ 9494]: --> [7:CONNECT]
Feb 27 13:17:03.22: [ 9494]: --> HDLC<34:FF C0 04 B5 00 AA 12 9E 36 86 62 82 1A 04 14 2E B6 94 04 6A A6 4E CE 96 F6 76 04 AC 74 0C 74 2C 23 76>
Feb 27 13:17:03.22: [ 9494]: --> [2:OK]
Feb 27 13:17:03.22
: [ 9494]: REMOTE NSF "AD 00 55 48 79 6C 61 46 41 58 20 28 74 6D 29 20 56 65 72 73 69 6F 6E 20 35 2E 30 2E 34"
Feb 27 13:17:03.22: [ 9494]: NSF remote fax equipment: HylaFAX
Feb 27 13:17:03.22: [ 9494]: NSF remote station ID: "HylaFAX (tm) Version 
5.0.4"
Feb 27 13:17:03.22: [ 9494]: <-- [9:AT+FRH=3\r]
Feb 27 13:17:03.24: [ 9494]: --> [7:CONNECT]
Feb 27 13:17:03.98: [ 9494]: --> HDLC<25:FF C0 02 B6 A6 26 F6 B6 1A 82 92 04 04 04 04 04 04 04 04 04 04 04 04 2A 64>
Feb 27 13:17:03.98: [ 9494]: --> [2:OK]
Feb 27 13:17:03.98: [ 9494]: REMOTE CSI "IAXmodem"
Feb 27 13:17:03.98: [ 9494]: <-- [9:AT+FRH=3\r]
Feb 27 13:17:04.00: [ 9494]: --> [7:CONNECT]
Feb 27 13:17:
04.46: [ 9494]: --> HDLC<15:FF C8 01 00 73 5F 23 01 FB C1 01 01 18 90 61>
Feb 27 13:17:04.54: [ 9494]: --> [2:OK]
Feb 27 13:17:04.54: [ 9494]: REMOTE best rate 9600 bit/s
Feb 27 13:17:04.54: [ 9494]: REMOTE max A3 page width (303 mm)
Feb 27 13:17:04.54: [ 9494]: REMOTE max unlimited page length
Feb 27 13:17:04.54: [ 9494]: REMOTE best vres R16 x 15.4 line/mm
Feb 27 13:17:04.54: [ 9494]: REMOTE format support: MH, MR, MMR
Feb 27 13:17:04.55
: [ 9494]: REMOTE supports T.30 Annex A, 256-byte ECM
Feb 27 13:17:04.55: [ 9494]: REMOTE best 0 ms/scanline
Feb 27 13:17:04.55: [ 9494]: USE 9600 bit/s
Feb 27 13:17:04.55: [ 9494]: USE error correction mode
Feb 27 13:17:
04.55: [ 9494]: <-- [9:AT+FRS=7\r]
Feb 27 13:17:04.60: [ 9494]: --> [2:OK]
Feb 27 13:17:04.60: [ 9494]: <-- [9:AT+FTH=3\r]
Feb 27 13:17:04.62: [ 9494]: --> [7:CONNECT]
Feb 27 13:17:04.62: [ 9494]: <-- HDLC<3:FF C8 DF>
Feb 27 13:17:04.62: [ 9494]: <-- data [3]
Feb 27 13:17:04.62: [ 9494]: <-- data [2]
Feb 27 13:17:05.72: [ 9494]: --> [2:OK]
Feb 27 13:17:05.72: [ 9494]: MODEM input buffering enabled
Feb 27 13:17:
05.72: [ 9494]: <-- [5:ATH0\r]
Feb 27 13:17:05.83: [ 9494]: --> [2:OK]
Feb 27 13:17:05.83: [ 9494]: MODEM set DTR OFF
Feb 27 13:17:05.83: [ 9494]: MODEM set baud rate: 0 baud (flow control unchanged)
Feb 27 13:17:
05.83: [ 9494]: STATE CHANGE: SENDING -> MODEMWAIT (timeout 5)
Feb 27 13:17:05.83: [ 9494]: SESSION END

####################################
iaxmodem 2 (receiving)
####################################

Feb 27 13:16:58.54: [ 8601]: SESSION BEGIN 000000025 431111112
Feb 27 13:16:58.54: [ 8601]: HylaFAX (tm) Version 5.0.4
Feb 27 13:16:58.54: [ 8601]: CallID: '1100' 'IAXModem 1' '<NONE>' 's'
Feb 27 13:16:58.54: [ 8601]: MODEM set XON/XOFF/FLUSH: input ignored, output disabled
Feb 27 13:16:58.54: [ 8601]: <-- [4:ATA\r]
Feb 27 13:17:02.26: [ 8601]: --> [7:CONNECT]
Feb 27 13:17:02.26: [ 8601]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyIAX2'
Feb 27 13:17:02.26: [ 8601]: STATE CHANGE: ANSWERING -> RECEIVING
Feb 27 13:17:02.26: [ 8601]: RECV FAX: begin
Feb 27 13:17:02.26: [ 8601]: <-- HDLC<32:FF C0 04 B5 00 AA 12 9E 36 86 62 82 1A 04 14 2E B6 94 04 6A A6 4E CE 96 F6 76 04 AC 74 0C 74 2C>
Feb 27 13:17:02.26: [ 8601]: <-- data [32]
Feb 27 13:17:02.26: [ 8601]: <-- data [2]
Feb 27 13:17:03.18: [ 8601]: --> [7:CONNECT]
Feb 27 13:17:03.18: [ 8601]: <-- HDLC<23:FF C0 02 B6 A6 26 F6 B6 1A 82 92 04 04 04 04 04 04 04 04 04 04 04 04>
Feb 27 13:17:03.18: [ 8601]: <-- data [23]
Feb 27 13:17:03.18: [ 8601]: <-- data [2]
Feb 27 13:17:03.94: [ 8601]: --> [7:CONNECT]
Feb 27 13:17:03.94: [ 8601]: <-- HDLC<13:FF C8 01 00 73 5F 23 01 FB C1 01 01 18>
Feb 27 13:17:03.94: [ 8601]: <-- data [13]
Feb 27 13:17:03.94: [ 8601]: <-- data [2]
Feb 27 13:17:04.52: [ 8601]: --> [2:OK]
Feb 27 13:17:04.52: [ 8601]: <-- [9:AT+FRH=3\r]
Feb 27 13:17:04.78: [ 8601]: --> [7:CONNECT]
Feb 27 13:17:05.68: [ 8601]: --> HDLC<5:FF C8 DF 59 6F>
Feb 27 13:17:05.76: [ 8601]: --> [2:OK]
Feb 27 13:17:05.76: [ 8601]: RECV FAX: RSPREC error/got DCN
Feb 27 13:17:05.76: [ 8601]: RECV FAX: end
Feb 27 13:17:05.76: [ 8601]: SESSION END

Anyone knows how to correct this?

Thanks,

Stefan