HylaFAX The world's most advanced open source fax server |
I've just upgraded to HylaFAX 4.1.5 on RedHat 7.3 and I'm getting "Unspecified Phase A error" on about 3 percent of outgoing calls. If I understand correctly, phase A is the modem handshake at the beginning of the call before any negotiations about the fax protocol begin. The log below doesn't support this though since the Phase A error occurs at the end of the call. Can anyone help me understand what's going on? Can I make any assumptions about whether the fax was sent successfully from the log below? Modems are Eicon Diva Server T1 PRI.
Thanks in advance,
-Chris
Mar 28 13:38:34.82: [ 1322]: SESSION BEGIN 00001779 <SNIP>
Mar 28 13:38:34.82: [ 1322]: HylaFAX (tm) Version 4.1.5
Mar 28 13:38:34.88: [ 1322]: SEND FAX: JOB 1399 DEST <SNIP> COMMID 00001779 DEVICE '/dev/fax25'
Mar 28 13:38:34.88: [ 1322]: MODEM set DTR OFF
Mar 28 13:38:34.88: [ 1322]: DELAY 75 ms
Mar 28 13:38:34.96: [ 1322]: MODEM set DTR ON
Mar 28 13:38:34.96: [ 1322]: DELAY 2600 ms
Mar 28 13:38:37.56: [ 1322]: MODEM set baud rate: 19200 baud, input flow RTS/CTS, output flow RTS/CTS
Mar 28 13:38:37.56: [ 1322]: DELAY 10 ms
Mar 28 13:38:37.57: [ 1322]: MODEM flush i/o
Mar 28 13:38:37.57: [ 1322]: <-- [4:ATZ\r]
Mar 28 13:38:37.57: [ 1322]: --> [3:ATZ]
Mar 28 13:38:37.57: [ 1322]: --> [2:OK]
Mar 28 13:38:37.57: [ 1322]: DELAY 3000 ms
Mar 28 13:38:40.57: [ 1322]: <-- [5:ATE0\r]
Mar 28 13:38:40.57: [ 1322]: --> [4:ATE0]
Mar 28 13:38:40.57: [ 1322]: --> [2:OK]
Mar 28 13:38:40.57: [ 1322]: <-- [5:ATV1\r]
Mar 28 13:38:40.57: [ 1322]: --> [2:OK]
Mar 28 13:38:40.57: [ 1322]: <-- [5:ATQ0\r]
Mar 28 13:38:40.57: [ 1322]: --> [2:OK]
Mar 28 13:38:40.57: [ 1322]: <-- [7:ATS0=1\r]
Mar 28 13:38:40.57: [ 1322]: --> [2:OK]
Mar 28 13:38:40.57: [ 1322]: <-- [7:ATS8=2\r]
Mar 28 13:38:40.57: [ 1322]: --> [2:OK]
Mar 28 13:38:40.57: [ 1322]: <-- [8:ATS7=60\r]
Mar 28 13:38:40.57: [ 1322]: --> [2:OK]
Mar 28 13:38:40.57: [ 1322]: <-- [6:AT&K3\r]
Mar 28 13:38:40.57: [ 1322]: --> [2:OK]
Mar 28 13:38:40.57: [ 1322]: <-- [12:AT+FCLASS=2\r]
Mar 28 13:38:40.57: [ 1322]: --> [2:OK]
Mar 28 13:38:40.57: [ 1322]: <-- [10:AT+FBOR=0\r]
Mar 28 13:38:40.57: [ 1322]: --> [2:OK]
Mar 28 13:38:40.57: [ 1322]: <-- [13:AT+FPHCTO=30\r]
Mar 28 13:38:40.57: [ 1322]: --> [2:OK]
Mar 28 13:38:40.57: [ 1322]: <-- [10:AT+FBUG=1\r]
Mar 28 13:38:40.57: [ 1322]: --> [2:OK]
Mar 28 13:38:40.57: [ 1322]: <-- [25:AT+FDCC=1,13,0,2,0,1,0,0\r]
Mar 28 13:38:40.57: [ 1322]: --> [2:OK]
Mar 28 13:38:40.57: [ 1322]: <-- [5:ATM0\r]
Mar 28 13:38:40.57: [ 1322]: --> [2:OK]
Mar 28 13:38:40.57: [ 1322]: STATE CHANGE: RUNNING -> SENDING
Mar 28 13:38:40.57: [ 1322]: MODEM input buffering enabled
Mar 28 13:38:40.57: [ 1322]: Apply DialString rules to <SNIP>
Mar 28 13:38:40.57: [ 1322]: --> match rule "^[+]1", result now <SNIP>
Mar 28 13:38:40.57: [ 1322]: --> return result "15105051448"
Mar 28 13:38:40.57: [ 1322]: <-- [12:AT+FCLASS=2\r]
Mar 28 13:38:40.67: [ 1322]: --> [2:OK]
Mar 28 13:38:40.67: [ 1322]: <-- [10:AT+FBOR=0\r]
Mar 28 13:38:40.77: [ 1322]: --> [2:OK]
Mar 28 13:38:40.77: [ 1322]: <-- [13:AT+FPHCTO=30\r]
Mar 28 13:38:40.87: [ 1322]: --> [2:OK]
Mar 28 13:38:40.87: [ 1322]: <-- [10:AT+FBUG=1\r]
Mar 28 13:38:40.97: [ 1322]: --> [2:OK]
Mar 28 13:38:40.97: [ 1322]: <-- [25:AT+FDCC=1,13,0,2,0,1,0,0\r]
Mar 28 13:38:41.07: [ 1322]: --> [2:OK]
Mar 28 13:38:41.07: [ 1322]: <-- [21:AT+FLID="DG Systems"\r]
Mar 28 13:38:41.17: [ 1322]: --> [2:OK]
Mar 28 13:38:41.17: [ 1322]: DIAL 15105051448
Mar 28 13:38:41.17: [ 1322]: <-- [16:ATDT15105051448\r]
Mar 28 13:39:22.92: [ 1322]: --> [5:+FCON]
Mar 28 13:39:22.92: [ 1322]: --> [8:+FCSI:""]
Mar 28 13:39:22.92: [ 1322]: REMOTE CSI ""
Mar 28 13:39:22.92: [ 1322]: --> [22:+FDIS: 1,5,0,0,0,2,0,0]
Mar 28 13:39:22.92: [ 1322]: --> [2:OK]
Mar 28 13:39:22.92: [ 1322]: REMOTE best rate 14400 bit/s
Mar 28 13:39:22.92: [ 1322]: REMOTE max page width 1728 pixels in 215 mm
Mar 28 13:39:22.92: [ 1322]: REMOTE max A4 page length (297 mm)
Mar 28 13:39:22.92: [ 1322]: REMOTE best vres 7.7 line/mm
Mar 28 13:39:22.92: [ 1322]: REMOTE best format 1-D MR
Mar 28 13:39:22.92: [ 1322]: REMOTE supports T.30 Annex C, half duplex ECM
Mar 28 13:39:22.92: [ 1322]: REMOTE best 0 ms/scanline
Mar 28 13:39:22.92: [ 1322]: USE 14400 bit/s
Mar 28 13:39:22.92: [ 1322]: USE 0 ms/scanline
Mar 28 13:39:22.92: [ 1322]: SEND file "docq/doc2600.ps;00"
Mar 28 13:39:22.93: [ 1322]: USE page width 1728 pixels in 215 mm
Mar 28 13:39:22.93: [ 1322]: USE A4 page length (297 mm)
Mar 28 13:39:22.93: [ 1322]: USE 3.85 line/mm
Mar 28 13:39:22.93: [ 1322]: USE 1-D MR
Mar 28 13:39:22.93: [ 1322]: <-- [24:AT+FDIS=0,5,0,0,0,0,0,0\r]
Mar 28 13:39:23.03: [ 1322]: --> [2:OK]
Mar 28 13:39:23.03: [ 1322]: <-- [7:AT+FDT\r]
Mar 28 13:39:23.67: [ 1322]: --> [22:+FDCS: 0,5,0,2,0,2,0,0]
Mar 28 13:39:23.90: [ 1322]: --> [7:CONNECT]
Mar 28 13:39:23.90: [ 1322]: SEND wait for XON
Mar 28 13:39:23.90: [ 1322]: --> [1:]
Mar 28 13:39:23.90: [ 1322]: SEND begin page
Mar 28 13:39:23.90: [ 1322]: <-- data [1026]
Mar 28 13:39:23.90: [ 1322]: <-- data [1026]
Mar 28 13:39:23.90: [ 1322]: <-- data [1024]
Mar 28 13:39:23.91: [ 1322]: <-- data [1027]
Mar 28 13:39:23.92: [ 1322]: <-- data [1026]
Mar 28 13:39:23.93: [ 1322]: <-- data [1025]
Mar 28 13:39:23.94: [ 1322]: <-- data [1024]
Mar 28 13:39:23.95: [ 1322]: <-- data [1024]
Mar 28 13:39:23.96: [ 1322]: <-- data [1025]
Mar 28 13:39:24.36: [ 1322]: <-- data [1025]
Mar 28 13:39:24.70: [ 1322]: <-- data [1025]
Mar 28 13:39:25.19: [ 1322]: <-- data [1025]
Mar 28 13:39:25.51: [ 1322]: <-- data [1025]
Mar 28 13:39:25.99: [ 1322]: <-- data [1025]
Mar 28 13:39:26.32: [ 1322]: <-- data [1024]
Mar 28 13:39:26.64: [ 1322]: <-- data [1024]
Mar 28 13:39:26.81: [ 1322]: <-- data [527]
Mar 28 13:39:26.97: [ 1322]: SENT 16911 bytes of data
Mar 28 13:39:26.97: [ 1322]: <-- data [2]
Mar 28 13:39:26.97: [ 1322]: SEND end page
Mar 28 13:39:27.08: [ 1322]: --> [2:OK]
Mar 28 13:39:27.08: [ 1322]: SEND send EOP (no more pages or documents)
Mar 28 13:39:27.08: [ 1322]: <-- [9:AT+FET=2\r]
Mar 28 13:39:42.62: [ 1322]: --> [9:+FHNG: 10]
Mar 28 13:39:42.62: [ 1322]: REMOTE HANGUP: Unspecified Phase A error (code 10)
Mar 28 13:39:42.62: [ 1322]: <-- [5:ATH0\r]
Mar 28 13:39:42.62: [ 1322]: --> [2:OK]
Mar 28 13:39:42.62: [ 1322]: MODEM set DTR OFF
Mar 28 13:39:42.62: [ 1322]: STATE CHANGE: SENDING -> MODEMWAIT (timeout 5)
Mar 28 13:39:42.62: [ 1322]: SESSION END
[root@shockwave log]#