Re: [hylafax-users] High Error Rate

["Darren Nickerson" <darren.nickerson@xxxxxxxx>]

Albert,

 

If you're able to generate a reproducible failure during a fax conversation with any remote device such as this Intuity Fax destination, it's possible to capture extremely detailed TTY traces and even audio recordings from the diva and escalate the problem to Eicon for support. First though, you should try to make sure you have your own Asterisk setup in a healthy state. Things to check:

 

1. Any IRQ conflicts, or missed interrupts on the Digium T1 card?

2. Is the fax T1 connected to the PSTN (TDM) bridged through asterisk, or are you actually sending and receiving over VoIP?

3. Can you correlate problematic faxing to any significant load (or other event) on your Asterisk box?

4. Are you sure your T1 network is correctly synced with (slaved to) the telco's clock? If not, you'll have significant fax reliability issues.

 

A useful (but probably disruptive and difficult) test if you have a real TDM circuit from the phone company would be to plug that T1/PRI into the Diva directly, eliminating Asterisk, and see if you still have problems sending/receiving.

 

Hope this helps a bit - you have a lot of variables here, and I don't think it makes much sense digging deeply into Diva fax protocol analyses until you're confident Asterisk is healthy first.

 

-Darren

 

----- Original Message -----

From: Albert Jumaquio

To: hylafax-users@xxxxxxxxxxx

Sent: Tuesday, November 15, 2005 1:03 PM

Subject: [hylafax-users] High Error Rate

We've been using Hylafax 4.2.2 for quite a while now and just recently errors on sending and receiving faxes has increased. It may be because of the increase of usage of the asterisk VOIP network where the fax modem is connected to for that's the only change that happened. Can i determine this through the error logs? Mostly it's a communication failure during phase (x). Here's an example of a sending failure

Nov 15 09:44:11.25: [25509]: SESSION BEGIN 000004999 16503178763450
Nov 15 09:44:11.25: [25509]: HylaFAX (tm) Version 4.2.2
Nov 15 09:44:11.25: [25509]: SEND FAX: JOB 1314 DEST 317-876-3450 COMMID 000004999 DEVICE '/dev/ttyds06'
Nov 15 09:44:11.25: [25509]: <-- [10:AT+FBOR=0\r]
Nov 15 09:44:11.25: [25509]: --> [2:OK]
Nov 15 09:44:11.25: [25509]: <-- [13:AT+FPHCTO=30\r]
Nov 15 09:44:11.25: [25509]: --> [5:ERROR]
Nov 15 09:44:11.25: [25509]: MODEM Command error
Nov 15 09:44:11.25: [25509]: <-- [24:AT+FDCC=1,D,2,2,0,2,0,0\r]
Nov 15 09:44:11.25: [25509]: --> [2:OK]
Nov 15 09:44:11.25: [25509]: DIAL 3178763450
Nov 15 09:44:11.25: [25509]: <-- [22:ATS0=255;DT3178763450\r]
Nov 15 09:44:30.70: [25509]: --> [5:+FCON]
Nov 15 09:44:30.70: [25509]: --> [28:+FCSI:"INTUITY..FAX        "]
Nov 15 09:44:30.70: [25509]: REMOTE CSI "INTUITY..FAX"
Nov 15 09:44:30.70: [25509]: --> [22:+FDIS: 1,3,0,2,0,0,0,0]
Nov 15 09:44:30.70: [25509]: --> [2:OK]
Nov 15 09:44:30.70: [25509]: REMOTE best rate 9600 bit/s
Nov 15 09:44:30.70: [25509]: REMOTE max A4 page width (215 mm)
Nov 15 09:44:30.70: [25509]: REMOTE max unlimited page length
Nov 15 09:44:30.70: [25509]: REMOTE best vres 7.7 line/mm
Nov 15 09:44:30.70: [25509]: REMOTE best format 1-D MH
Nov 15 09:44:30.70: [25509]: REMOTE best 0 ms/scanline
Nov 15 09:44:30.70: [25509]: USE 9600 bit/s
Nov 15 09:44:30.70: [25509]: SEND file "docq/doc2382.ps;31"
Nov 15 09:44:30.70: [25509]: USE A4 page width (215 mm)
Nov 15 09:44:30.70: [25509]: USE unlimited page length
Nov 15 09:44:30.70: [25509]: USE 7.7 line/mm
Nov 15 09:44:30.70: [25509]: USE 1-D MH
Nov 15 09:44:30.70: [25509]: USE 0 ms/scanline
Nov 15 09:44:30.70: [25509]: <-- [24:AT+FDIS=1,3,0,2,0,0,0,0\r]
Nov 15 09:44:30.70: [25509]: --> [2:OK]
Nov 15 09:44:30.70: [25509]: <-- [7:AT+FDT\r]
Nov 15 09:44:36.06: [25509]: --> [22:+FDCS: 1,3,0,2,0,0,0,0]
Nov 15 09:44:36.27: [25509]: --> [7:CONNECT]
Nov 15 09:44:36.27: [25509]: SEND wait for XON
Nov 15 09:44:36.29: [25509]: --> [1:]
Nov 15 09:44:36.29: [25509]: SEND begin page
Nov 15 09:44:38.35: [25509]: SENT 45518 bytes of data
Nov 15 09:44:38.35: [25509]: SEND end page
Nov 15 09:45:14.18: [25509]: --> [2:OK]
Nov 15 09:45:14.18: [25509]: SEND send EOP (no more pages or documents)
Nov 15 09:45:14.18: [25509]: <-- [9:AT+FET=2\r]
Nov 15 09:45:18.91: [25509]: --> [8:+FPTS: 2]
Nov 15 09:45:18.91: [25509]: --> [8:+FHNG: 0]
Nov 15 09:45:18.91: [25509]: REMOTE HANGUP: Normal and proper end of connection (code 0)
Nov 15 09:45:18.91: [25509]: SEND recv RTN (retrain negative)
Nov 15 09:45:18.91: [25509]: SEND: Communication failure during Phase B/C (modem protocol botch); Giving up after 3 attempts to send same page "docq/doc2382.ps;31", dirnum 0
Nov 15 09:45:18.91: [25509]: <-- [5:ATH0\r]
Nov 15 09:45:18.91: [25509]: --> [2:OK]
Nov 15 09:45:18.91: [25509]: SESSION END

And a receiving failure

Nov 15 08:13:31.54: [ 1233]: SESSION BEGIN 000004943 16503507101
Nov 15 08:13:31.54: [ 1233]: HylaFAX (tm) Version 4.2.2
Nov 15 08:13:31.54: [ 1233]: <-- [11:ATS0=255;A\r]
Nov 15 08:13:31.54: [ 1233]: --> [16:CID: 02152712093]
Nov 15 08:13:31.54: [ 1233]: --> [9:DAD: 7268]
Nov 15 08:13:31.54: [ 1233]: --> [4:RING]
Nov 15 08:13:44.05: [ 1233]: --> [5:+FCON]
Nov 15 08:13:44.05: [ 1233]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyds01'
Nov 15 08:13:44.05: [ 1233]: RECV FAX: begin
Nov 15 08:13:44.05: [ 1233]: --> [26:+FTSI:        215 271 2093]
Nov 15 08:13:44.05: [ 1233]: REMOTE TSI "215 271 2093"
Nov 15 08:13:44.05: [ 1233]: --> [22:+FDCS: 1,1,0,2,0,2,0,0]
Nov 15 08:13:44.05: [ 1233]: REMOTE wants 4800 bit/s
Nov 15 08:13:44.05: [ 1233]: REMOTE wants A4 page width (215 mm)
Nov 15 08:13:44.05: [ 1233]: REMOTE wants unlimited page length
Nov 15 08:13:44.05: [ 1233]: REMOTE wants 7.7 line/mm
Nov 15 08:13:44.05: [ 1233]: REMOTE wants 1-D MH
Nov 15 08:13:44.05: [ 1233]: REMOTE wants T.30 Annex C, half duplex ECM
Nov 15 08:13:44.05: [ 1233]: --> [2:OK]
Nov 15 08:13:44.05: [ 1233]: <-- [7:AT+FDR\r]
Nov 15 08:13:44.05: [ 1233]: --> [5:+FCFR]
Nov 15 08:13:44.05: [ 1233]: --> [22:+FDCS: 1,1,0,2,0,2,0,0]
Nov 15 08:13:44.05: [ 1233]: REMOTE wants 4800 bit/s
Nov 15 08:13:44.05: [ 1233]: REMOTE wants A4 page width (215 mm)
Nov 15 08:13:44.05: [ 1233]: REMOTE wants unlimited page length
Nov 15 08:13:44.05: [ 1233]: REMOTE wants 7.7 line/mm
Nov 15 08:13:44.05: [ 1233]: REMOTE wants 1-D MH
Nov 15 08:13:44.05: [ 1233]: REMOTE wants T.30 Annex C, half duplex ECM
Nov 15 08:13:44.05: [ 1233]: --> [7:CONNECT]
Nov 15 08:13:44.05: [ 1233]: RECV: begin page
Nov 15 08:13:44.05: [ 1233]: RECV: send trigger 021
Nov 15 08:13:44.05: [ 1233]: Copy quality checking performed by host
Nov 15 08:14:20.61: [ 1233]: --> [10:+FPTS: 2,0]
Nov 15 08:14:20.61: [ 1233]: --> [7:+FET: 2]
Nov 15 08:14:20.61: [ 1233]: RECV recv EOP (no more pages or documents)
Nov 15 08:14:20.61: [ 1233]: --> [2:OK]
Nov 15 08:14:20.61: [ 1233]: RECV send RTN (retrain negative)
Nov 15 08:14:20.61: [ 1233]: <-- [10:AT+FPTS=2\r]
Nov 15 08:14:20.61: [ 1233]: --> [2:OK]
Nov 15 08:14:20.61: [ 1233]: <-- [7:AT+FDR\r]
Nov 15 08:14:20.61: [ 1233]: --> [10:+FHNG: 100]
Nov 15 08:14:20.61: [ 1233]: REMOTE HANGUP: Unspecified Phase D error (code 100)
Nov 15 08:14:20.61: [ 1233]: RECV keeping unconfirmed page
Nov 15 08:14:20.61: [ 1233]: RECV FAX (000004943): from 215 271 2093, page 1 in 0:36, INF, 7.7 line/mm, 1-D MH, 4800 bit/s
Nov 15 08:14:20.62: [ 1233]: RECV FAX (000004943): recvq/fax000000196.tif from 215 271 2093, route to <unspecified>, 1 pages in 0:36
Nov 15 08:14:20.62: [ 1233]: RECV FAX: Unspecified Phase D error
Nov 15 08:14:20.62: [ 1233]: RECV FAX (000004943): session with 215 271 2093 terminated abnormally: Unspecified Phase D error
Nov 15 08:14:20.62: [ 1233]: RECV FAX: bin/faxrcvd "recvq/fax000000196.tif" "ttyds01" "000004943" "Unspecified Phase D error" "02152712093" "7268"
Nov 15 08:14:20.62: [ 1233]: RECV FAX: end
Nov 15 08:14:20.62: [ 1233]: SESSION END

--
Albert F. Jumaquio

IT HELPDESK TECHNICIAN
   
Tel:       650-287-2318
Fax:      650-523-8637
email:   albert@xxxxxxxxxxxx
YM ID:  albert_fj