[hylafax-users] weird transmission error

[Matthias Reich <rei@xxxxxxxx>]

Hi folks,

I have hylafax 4.2.1 running on different debian boxes
in different sites, using the the Multitech MT 1432-BG modems.
All modems have the same firmware and the same config-file.

I have a strange but reproduceable problem with just one of my destinations

sending a fax from location A to this number is always successful.
sending the same fax from location B gives always an error.

As you can see from the logs, the whole transmission is the same,
except from the end. The receiver tells me the faxes are received correctly.

Both modems are set to
AT+FDIS=0,3,0,2,1,0,0,3

successful is :
Oct 12 10:58:33.79: [12853]: <-- [9:AT+FET=2\r]
Oct 12 10:58:37.20: [12853]: --> [14:+FHT:FF 13 2F ]
Oct 12 10:58:39.02: [12853]: --> [14:+FHR:FF 13 8C ]
Oct 12 10:58:39.02: [12853]: --> [7:+FPTS:1]
Oct 12 10:58:39.99: [12853]: --> [14:+FHT:FF 13 FB ]
Oct 12 10:58:40.46: [12853]: --> [7:+FHNG:0]

failure is:
Okt 12 11:27:01.23: [ 4333]: <-- [9:AT+FET=2\r]
Okt 12 11:27:04.46: [ 4333]: --> [14:+FHT:FF 13 2F ]
Okt 12 11:27:05.96: [ 4333]: --> [14:+FHT:FF 13 2F ]
Okt 12 11:27:07.45: [ 4333]: --> [14:+FHT:FF 13 2F ]
Okt 12 11:27:08.95: [ 4333]: --> [14:+FHT:FF 13 FB ]
Okt 12 11:27:09.42: [ 4333]: --> [8:+FHNG:54]






here is the detailed log for successful sending:

[...]
Oct 12 10:57:41.06: [12853]: DIAL XXXXXXXXXX
Oct 12 10:57:41.06: [12853]: <-- [18:ATDT0,XXXXXXXXXX\r]
Oct 12 10:57:57.94: [12853]: --> [5:+FCON]
Oct 12 10:58:05.53: [12853]: --> [74:+FHR:FF 03 40 34 31 20 31 34 34 39 20 32 
32 34 35 20 39 34 2B 20 20 20 20 ]
Oct 12 10:58:05.83: [12853]: --> [32:+FHR:FF 13 80 20 EE A8 C4 80 13 ]
Oct 12 10:58:05.83: [12853]: --> [51:+FNSF:86 00 CA 00 00 E4 01 C8 40 F0 03 18 
80 00 00 ]
Oct 12 10:58:05.83: [12853]: REMOTE NSF "86 00 CA 00 00 E4 01 C8 40 F0 03 18 
80 00 00"
Oct 12 10:58:05.83: [12853]: NSF remote fax equipment: unknown 
Oct 12 10:58:05.83: [12853]: --> [28:+FCSI:"    +49 XXXXXXXXXX"]
Oct 12 10:58:05.83: [12853]: REMOTE CSI "+49 XXXXXXXXXX"
Oct 12 10:58:05.95: [12853]: --> [21:+FDIS:1,5,0,2,1,2,1,3]
Oct 12 10:58:05.95: [12853]: --> [2:OK]
Oct 12 10:58:05.95: [12853]: REMOTE best rate 14400 bit/s
Oct 12 10:58:05.95: [12853]: REMOTE max A4 page width (215 mm)
Oct 12 10:58:05.95: [12853]: REMOTE max unlimited page length
Oct 12 10:58:05.95: [12853]: REMOTE best vres 7.7 line/mm
Oct 12 10:58:05.95: [12853]: REMOTE best format 2-D MR
Oct 12 10:58:05.95: [12853]: REMOTE supports T.30 Annex A, 256-byte ECM
Oct 12 10:58:05.95: [12853]: REMOTE best 10 ms/scanline
Oct 12 10:58:05.95: [12853]: USE 9600 bit/s
Oct 12 10:58:05.95: [12853]: USE 10 ms/scanline
Oct 12 10:58:05.95: [12853]: SEND file "docq/doc24539.ps;40"
Oct 12 10:58:05.95: [12853]: USE A4 page width (215 mm)
Oct 12 10:58:05.95: [12853]: USE unlimited page length
Oct 12 10:58:05.95: [12853]: USE 3.85 line/mm
Oct 12 10:58:05.95: [12853]: USE 2-D MR
Oct 12 10:58:05.95: [12853]: <-- [24:AT+FDIS=0,3,0,2,1,0,0,3\r]
Oct 12 10:58:06.27: [12853]: --> [2:OK]
Oct 12 10:58:06.27: [12853]: <-- [7:AT+FDT\r]
Oct 12 10:58:07.40: [12853]: --> [74:+FHT:FF 03 43 72 61 67 74 74 75 74 53 20 
4C 4E 20 47 65 20 53 4F 47 41 48 ]
Oct 12 10:58:08.20: [12853]: --> [26:+FHT:FF 13 83 00 A6 A8 00 ]
Oct 12 10:58:13.31: [12853]: --> [14:+FHR:FF 13 84 ]
Oct 12 10:58:13.31: [12853]: --> [21:+FDCS:0,3,0,2,1,0,0,3]
Oct 12 10:58:13.31: [12853]: --> [7:CONNECT]
Oct 12 10:58:13.31: [12853]: SEND wait for XON
Oct 12 10:58:13.31: [12853]: --> [1: ]
Oct 12 10:58:13.31: [12853]: SEND begin page
Oct 12 10:58:13.31: [12853]: <-- data [1030]
[...]
Oct 12 10:58:13.31: [12853]: SENT 21507 bytes of data
Oct 12 10:58:13.31: [12853]: <-- data [2]
Oct 12 10:58:13.31: [12853]: SEND end page
Oct 12 10:58:33.79: [12853]: --> [40:                                        ]
Oct 12 10:58:33.79: [12853]: --> [2:OK]
Oct 12 10:58:33.79: [12853]: SEND send EOP (no more pages or documents)
Oct 12 10:58:33.79: [12853]: <-- [9:AT+FET=2\r]
Oct 12 10:58:37.20: [12853]: --> [14:+FHT:FF 13 2F ]
Oct 12 10:58:39.02: [12853]: --> [14:+FHR:FF 13 8C ]
Oct 12 10:58:39.02: [12853]: --> [7:+FPTS:1]
Oct 12 10:58:39.99: [12853]: --> [14:+FHT:FF 13 FB ]
Oct 12 10:58:40.46: [12853]: --> [7:+FHNG:0]
Oct 12 10:58:40.46: [12853]: REMOTE HANGUP: Normal and proper end of 
connection (code 0)
Oct 12 10:58:40.46: [12853]: SEND recv MCF (message confirmation)


here is the log for the failed transmission:
[...]
Okt 12 11:23:34.88: [ 4333]: DIAL XXXXXXXXXX
Okt 12 11:23:34.88: [ 4333]: <-- [18:ATDT0,XXXXXXXXXX\r]
Okt 12 11:23:54.91: [ 4333]: --> [5:+FCON]
Okt 12 11:23:59.34: [ 4333]: --> [74:+FHR:FF 03 40 34 31 20 31 34 34 39 20 32 
32 34 35 20 39 34 2B 20 20 20 20 ]
Okt 12 11:23:59.65: [ 4333]: --> [32:+FHR:FF 13 80 20 EE A8 C4 80 13 ]
Okt 12 11:23:59.65: [ 4333]: --> [51:+FNSF:86 00 CA 00 00 E4 01 C8 40 F0 03 18 
80 00 00 ]
Okt 12 11:23:59.65: [ 4333]: REMOTE NSF "86 00 CA 00 00 E4 01 C8 40 F0 03 18 
80 00 00"
Okt 12 11:23:59.65: [ 4333]: NSF remote fax equipment: unknown 
Okt 12 11:23:59.65: [ 4333]: --> [28:+FCSI:"    +49 XXXXXXXXXX"]
Okt 12 11:23:59.65: [ 4333]: REMOTE CSI "+49 XXXXXXXXXX"
Okt 12 11:23:59.65: [ 4333]: --> [21:+FDIS:1,5,0,2,1,2,1,3]
Okt 12 11:23:59.66: [ 4333]: --> [2:OK]
Okt 12 11:23:59.66: [ 4333]: REMOTE best rate 14400 bit/s
Okt 12 11:23:59.66: [ 4333]: REMOTE max A4 page width (215 mm)
Okt 12 11:23:59.66: [ 4333]: REMOTE max unlimited page length
Okt 12 11:23:59.66: [ 4333]: REMOTE best vres 7.7 line/mm
Okt 12 11:23:59.66: [ 4333]: REMOTE best format 2-D MR
Okt 12 11:23:59.66: [ 4333]: REMOTE supports T.30 Annex A, 256-byte ECM
Okt 12 11:23:59.66: [ 4333]: REMOTE best 10 ms/scanline
Okt 12 11:23:59.66: [ 4333]: USE 9600 bit/s
Okt 12 11:23:59.66: [ 4333]: USE 10 ms/scanline
Okt 12 11:23:59.66: [ 4333]: SEND file "docq/doc29013.ps;40"
Okt 12 11:23:59.66: [ 4333]: USE A4 page width (215 mm)
Okt 12 11:23:59.66: [ 4333]: USE unlimited page length
Okt 12 11:23:59.66: [ 4333]: USE 3.85 line/mm
Okt 12 11:23:59.66: [ 4333]: USE 2-D MR
Okt 12 11:23:59.66: [ 4333]: <-- [24:AT+FDIS=0,3,0,2,1,0,0,3\r]
Okt 12 11:23:59.98: [ 4333]: --> [2:OK]
Okt 12 11:23:59.98: [ 4333]: <-- [7:AT+FDT\r]
Okt 12 11:24:01.19: [ 4333]: --> [74:+FHT:FF 03 43 4C 41 48 4C 4E 20 47 65 20 
53 4F 47 41 48 20 20 20 20 20 20 ]
Okt 12 11:24:01.99: [ 4333]: --> [26:+FHT:FF 13 83 00 A6 A8 00 ]
Okt 12 11:24:07.12: [ 4333]: --> [14:+FHR:FF 13 84 ]
Okt 12 11:24:07.12: [ 4333]: --> [21:+FDCS:0,3,0,2,1,0,0,3]
Okt 12 11:24:07.12: [ 4333]: --> [7:CONNECT]
Okt 12 11:24:07.12: [ 4333]: SEND wait for XON
Okt 12 11:24:07.12: [ 4333]: --> [1: ]
Okt 12 11:24:07.12: [ 4333]: SEND begin page
Okt 12 11:24:07.13: [ 4333]: <-- data [1032]
[...]
Okt 12 11:24:07.13: [ 4333]: SENT 205754 bytes of data
Okt 12 11:24:07.13: [ 4333]: <-- data [2]
Okt 12 11:24:07.13: [ 4333]: SEND end page
Okt 12 11:27:01.23: [ 4333]: -->[40:                                        ]
Okt 12 11:27:01.23: [ 4333]: --> [2:OK]
Okt 12 11:27:01.23: [ 4333]: SEND send EOP (no more pages or documents)
Okt 12 11:27:01.23: [ 4333]: <-- [9:AT+FET=2\r]
Okt 12 11:27:04.46: [ 4333]: --> [14:+FHT:FF 13 2F ]
Okt 12 11:27:05.96: [ 4333]: --> [14:+FHT:FF 13 2F ]
Okt 12 11:27:07.45: [ 4333]: --> [14:+FHT:FF 13 2F ]
Okt 12 11:27:08.95: [ 4333]: --> [14:+FHT:FF 13 FB ]
Okt 12 11:27:09.42: [ 4333]: --> [8:+FHNG:54]
Okt 12 11:27:09.42: [ 4333]: REMOTE HANGUP: No response to EOP repeated 3 
times (code 54)
Okt 12 11:27:09.42: [ 4333]: <-- [5:ATH0\r]
Okt 12 11:27:09.91: [ 4333]: --> [2:OK]



-- 
HAGOS eG                 phone: +49 711 7880592
Matthias Reich             fax: +49 711 7880535
Industriestr. 62           web: http://www.hagos.de
D-70565 Stuttgart         mail: rei@xxxxxxxx
Germany

Attachment: pgp00002.pgp
Description: PGP signature