HylaFAX The world's most advanced open source fax server
[Date Prev][Date Next][Thread Prev][Thread Next] [Date Index] [Thread Index]

Re: [hylafax-users] T.30 T1 timeout question

Lee Howard wrote on 17/03/05 05:09 PM:

marthter wrote:

Mar 17 08:30:13.74: [ 7547]: <-- [14:AT+FCLASS=1.0\r]
Mar 17 08:30:13.84: [ 7547]: --> [2:OK]
Mar 17 08:30:13.84: [ 7547]: <-- [14:AT+F34=14,1,2\r]
Mar 17 08:30:13.95: [ 7547]: --> [2:OK]
Mar 17 08:30:13.96: [ 7547]: DIAL 4161234567
Mar 17 08:30:13.96: [ 7547]: <-- [15:ATDT4161234567\r]
Mar 17 08:30:32.98: [ 7547]: --> [8:+F34:6,1]
Mar 17 08:30:32.98: [ 7547]: V.8 handshaking succeeded, V.34-Fax (SuperG3) capability enabled.
Mar 17 08:30:32.98: [ 7547]: Primary channel rate: 14400 bit/s, Control channel rate: 1200 bit/s.
Mar 17 08:30:32.98: [ 7547]: --> [7:CONNECT]
Mar 17 08:30:32.99: [ 7547]: Control channel selected
Mar 17 08:30:32.99: [ 7547]: EOT received (end of transmission)


Mar 17 01:11:29.70: [ 4739]: SESSION BEGIN 000023371 14161234567
Mar 17 01:11:29.71: [ 4739]: HylaFAX (tm) Version 4.2.1
Mar 17 01:11:29.71: [ 4739]: SEND FAX: JOB 24829 DEST 416-123-4567 COMMID 000023371 DEVICE '/dev/ttyS5'
Mar 17 01:11:29.71: [ 4739]: <-- [14:AT+FCLASS=1.0\r]
Mar 17 01:11:29.82: [ 4739]: --> [2:OK]
Mar 17 01:11:29.82: [ 4739]: <-- [14:AT+F34=14,1,2\r]
Mar 17 01:11:29.93: [ 4739]: --> [2:OK]
Mar 17 01:11:29.93: [ 4739]: DIAL 4161234567
Mar 17 01:11:29.93: [ 4739]: <-- [15:ATDT4161234567\r]
Mar 17 01:12:20.21: [ 4739]: --> [2:]
Mar 17 01:12:20.22: [ 4739]: SEND FAILED: JOB 24829 DEST 416-123-4567 ERR Unknown problem (check modem power)


Does it work if you send without V.34-Fax? ('sendfax -B 14400')

Lee.


Thank you for the suggestion. Yes it seems to work (see log file below).

sendfax -B 14400 -t 1 -T 1 -vv -n -d 416-123-4567 ~/a.txt

So is this likely a crappy Brother modem or noisy line to the destination? (I notice it even didn't like 14400 and retrained to 12000; is that relevant?) I looked in /var/spool/hylafax/info/[destinationNumber] and it says:

supportsVRes:3
supports2DEncoding:yes
supportsMMR:yes
hasV34Trouble:no
supportsPostScript:no
supportsBatching:yes
calledBefore:yes
maxPageWidth:1728
maxPageLength:65535
maxSignallingRate:"33600"
minScanlineTime:"10ms"
remoteCSI:"4161234567"
sendFailures:0
lastSendFailure:"No answer (T.30 T1 timeout)"
dialFailures:0
lastDialFailure:"No carrier detected"
&pagingProtocol:"ixo"


Notably, whatever is setting "hasV34Trouble:no" seems to not have interpreted the above errors as V34 trouble.

(For the longest time I couldn't find which man page is relevant for this /var/spool/hylafax/info directory (though I vaguely remember reading about it long ago). Finally I started doing 'man hfaxd | tail' and then 'man ___ |grep info' on all the "SEE ALSO" items and eventually found 'man hylafax-info' whew!)

The only thing it says about this is:

hasV34Trouble boolean there is difficulty sending to this destination with V.34

So this is a flag about whether it did or didn't have trouble, but it doesn't explicitly say what programs read this flag or what is done differently when it is set/unset.

So I googled hasV34Trouble and I take it from this thread (http://www.hylafax.org/archive/2005-03/msg00014.php) that automatically interpreting the trouble is troublesome. And I guess from the man page that I should put "&hasV34Trouble:yes" and it will not even try V34 in the future? How long are info/[destNumber] files kept around?

I just tested it with that "&hasV34Trouble::yes" setting (using sendfax without the "-B 14400") and the log file looked almost identical to the one below (aside from frame 23 had to be re-sent twice).

Any other comments about this (maybe better automatic detection of the trouble) or is this the recommended solution?

Thank you for your insight Lee.

Martin



Mar 19 14:19:58.79: [ 4447]: SESSION BEGIN 000024160 14161234567
Mar 19 14:19:58.79: [ 4447]: HylaFAX (tm) Version 4.2.1
Mar 19 14:19:58.79: [ 4447]: SEND FAX: JOB 25648 DEST 416-123-4567 COMMID 000024160 DEVICE '/dev/ttyS5'
Mar 19 14:19:58.80: [ 4447]: <-- [14:AT+FCLASS=1.0\r]
Mar 19 14:19:58.90: [ 4447]: --> [2:OK]
Mar 19 14:19:58.91: [ 4447]: DIAL 4161234567
Mar 19 14:19:58.91: [ 4447]: <-- [15:ATDT4161234567\r]
Mar 19 14:20:12.16: [ 4447]: --> [7:CONNECT]
Mar 19 14:20:13.54: [ 4447]: --> [2:OK]
Mar 19 14:20:13.54: [ 4447]: REMOTE NSF "00 00 56 55 55 00 8C 90 80 A7 1D"
Mar 19 14:20:13.54: [ 4447]: NSF remote fax equipment: Brother
Mar 19 14:20:13.54: [ 4447]: <-- [9:AT+FRH=3\r]
Mar 19 14:20:13.55: [ 4447]: --> [7:CONNECT]
Mar 19 14:20:14.24: [ 4447]: --> [2:OK]
Mar 19 14:20:14.24: [ 4447]: REMOTE CSI "4161234567"
Mar 19 14:20:14.24: [ 4447]: <-- [9:AT+FRH=3\r]
Mar 19 14:20:14.25: [ 4447]: --> [7:CONNECT]
Mar 19 14:20:14.67: [ 4447]: --> [2:OK]
Mar 19 14:20:14.67: [ 4447]: REMOTE best rate 33600 bit/s
Mar 19 14:20:14.67: [ 4447]: REMOTE max A4 page width (215 mm)
Mar 19 14:20:14.67: [ 4447]: REMOTE max unlimited page length
Mar 19 14:20:14.67: [ 4447]: REMOTE best vres 15.4 line/mm
Mar 19 14:20:14.67: [ 4447]: REMOTE best format 2-D MMR
Mar 19 14:20:14.67: [ 4447]: REMOTE supports T.30 Annex A, 256-byte ECM
Mar 19 14:20:14.68: [ 4447]: REMOTE best 10 ms/scanline
Mar 19 14:20:14.68: [ 4447]: USE 14400 bit/s
Mar 19 14:20:14.68: [ 4447]: USE error correction mode
Mar 19 14:20:14.68: [ 4447]: USE 0 ms/scanline
Mar 19 14:20:14.68: [ 4447]: SEND file "docq/doc28390.ps;c1"
Mar 19 14:20:14.68: [ 4447]: USE A4 page width (215 mm)
Mar 19 14:20:14.68: [ 4447]: USE unlimited page length
Mar 19 14:20:14.68: [ 4447]: USE 7.7 line/mm
Mar 19 14:20:14.68: [ 4447]: USE 2-D MMR
Mar 19 14:20:14.68: [ 4447]: SEND training at v.17 14400 bit/s
Mar 19 14:20:14.68: [ 4447]: <-- [9:AT+FTH=3\r]
Mar 19 14:20:15.64: [ 4447]: --> [7:CONNECT]
Mar 19 14:20:15.64: [ 4447]: <-- data [23]
Mar 19 14:20:15.64: [ 4447]: <-- data [2]
Mar 19 14:20:15.65: [ 4447]: --> [7:CONNECT]
Mar 19 14:20:15.65: [ 4447]: <-- data [7]
Mar 19 14:20:15.65: [ 4447]: <-- data [2]
Mar 19 14:20:16.85: [ 4447]: --> [2:OK]
Mar 19 14:20:16.85: [ 4447]: <-- [9:AT+FTS=7\r]
Mar 19 14:20:16.91: [ 4447]: --> [2:OK]
Mar 19 14:20:16.91: [ 4447]: <-- [11:AT+FTM=145\r]
Mar 19 14:20:16.92: [ 4447]: --> [7:CONNECT]
Mar 19 14:20:16.92: [ 4447]: DELAY 400 ms
Mar 19 14:20:17.32: [ 4447]: <-- data [1024]
Mar 19 14:20:17.32: [ 4447]: <-- data [1024]
Mar 19 14:20:17.32: [ 4447]: <-- data [652]
Mar 19 14:20:17.32: [ 4447]: <-- data [2]
Mar 19 14:20:20.09: [ 4447]: --> [2:OK]
Mar 19 14:20:20.09: [ 4447]: <-- [9:AT+FRH=3\r]
Mar 19 14:20:20.30: [ 4447]: --> [7:CONNECT]
Mar 19 14:20:21.49: [ 4447]: --> [2:OK]
Mar 19 14:20:21.49: [ 4447]: SEND training at v.17 12000 bit/s
Mar 19 14:20:21.49: [ 4447]: <-- [9:AT+FTH=3\r]
Mar 19 14:20:22.45: [ 4447]: --> [7:CONNECT]
Mar 19 14:20:22.45: [ 4447]: <-- data [23]
Mar 19 14:20:22.45: [ 4447]: <-- data [2]
Mar 19 14:20:22.46: [ 4447]: --> [7:CONNECT]
Mar 19 14:20:22.46: [ 4447]: <-- data [7]
Mar 19 14:20:22.46: [ 4447]: <-- data [2]
Mar 19 14:20:23.66: [ 4447]: --> [2:OK]
Mar 19 14:20:23.66: [ 4447]: <-- [9:AT+FTS=7\r]
Mar 19 14:20:23.72: [ 4447]: --> [2:OK]
Mar 19 14:20:23.72: [ 4447]: <-- [11:AT+FTM=121\r]
Mar 19 14:20:23.73: [ 4447]: --> [7:CONNECT]
Mar 19 14:20:23.73: [ 4447]: DELAY 400 ms
Mar 19 14:20:24.13: [ 4447]: <-- data [1024]
Mar 19 14:20:24.13: [ 4447]: <-- data [1024]
Mar 19 14:20:24.13: [ 4447]: <-- data [202]
Mar 19 14:20:24.13: [ 4447]: <-- data [2]
Mar 19 14:20:26.90: [ 4447]: --> [2:OK]
Mar 19 14:20:26.90: [ 4447]: <-- [9:AT+FRH=3\r]
Mar 19 14:20:27.10: [ 4447]: --> [7:CONNECT]
Mar 19 14:20:28.32: [ 4447]: --> [2:OK]
Mar 19 14:20:28.32: [ 4447]: TRAINING succeeded
Mar 19 14:20:28.32: [ 4447]: SEND begin page
Mar 19 14:20:28.41: [ 4447]: SEND EOFB
Mar 19 14:20:28.42: [ 4447]: SEND send frame number 0
Mar 19 14:20:28.42: [ 4447]: SEND send frame number 1
Mar 19 14:20:28.42: [ 4447]: SEND send frame number 2
Mar 19 14:20:28.42: [ 4447]: SEND send frame number 3
Mar 19 14:20:28.42: [ 4447]: SEND send frame number 4
Mar 19 14:20:28.42: [ 4447]: SEND send frame number 5
Mar 19 14:20:28.42: [ 4447]: SEND send frame number 6
Mar 19 14:20:28.42: [ 4447]: SEND send frame number 7
Mar 19 14:20:28.43: [ 4447]: SEND send frame number 8
Mar 19 14:20:28.43: [ 4447]: SEND send frame number 9
Mar 19 14:20:28.43: [ 4447]: SEND send frame number 10
Mar 19 14:20:28.43: [ 4447]: SEND send frame number 11
Mar 19 14:20:28.43: [ 4447]: SEND send frame number 12
Mar 19 14:20:28.43: [ 4447]: SEND send frame number 13
Mar 19 14:20:28.43: [ 4447]: SEND send frame number 14
Mar 19 14:20:28.44: [ 4447]: SEND send frame number 15
Mar 19 14:20:28.44: [ 4447]: SEND send frame number 16
Mar 19 14:20:28.44: [ 4447]: SEND send frame number 17
Mar 19 14:20:28.44: [ 4447]: SEND send frame number 18
Mar 19 14:20:28.44: [ 4447]: SEND send frame number 19
Mar 19 14:20:28.44: [ 4447]: SEND send frame number 20
Mar 19 14:20:28.44: [ 4447]: SEND send frame number 21
Mar 19 14:20:28.44: [ 4447]: SEND send frame number 22
Mar 19 14:20:28.45: [ 4447]: SEND send frame number 23
Mar 19 14:20:28.45: [ 4447]: DELAY 200 ms
Mar 19 14:20:28.64: [ 4447]: <-- [11:AT+FTM=122\r]
Mar 19 14:20:28.65: [ 4447]: --> [7:CONNECT]
Mar 19 14:20:28.65: [ 4447]: DELAY 400 ms
Mar 19 14:20:29.05: [ 4447]: <-- data [1028]
Mar 19 14:20:29.05: [ 4447]: <-- data [1029]
Mar 19 14:20:29.05: [ 4447]: <-- data [1031]
Mar 19 14:20:29.05: [ 4447]: <-- data [1030]
Mar 19 14:20:29.06: [ 4447]: <-- data [1037]
Mar 19 14:20:29.07: [ 4447]: <-- data [1035]
Mar 19 14:20:29.15: [ 4447]: <-- data [635]
Mar 19 14:20:29.53: [ 4447]: <-- data [2]
Mar 19 14:20:33.66: [ 4447]: --> [2:OK]
Mar 19 14:20:33.66: [ 4447]: <-- [9:AT+FTS=7\r]
Mar 19 14:20:33.72: [ 4447]: --> [2:OK]
Mar 19 14:20:33.72: [ 4447]: <-- [9:AT+FTH=3\r]
Mar 19 14:20:34.68: [ 4447]: --> [7:CONNECT]
Mar 19 14:20:34.68: [ 4447]: <-- data [7]
Mar 19 14:20:34.68: [ 4447]: <-- data [2]
Mar 19 14:20:35.18: [ 4447]: --> [2:OK]
Mar 19 14:20:35.18: [ 4447]: SEND send PPS (partial page signal)
Mar 19 14:20:35.18: [ 4447]: SEND send MPS (more pages, same document)
Mar 19 14:20:35.18: [ 4447]: <-- [9:AT+FRH=3\r]
Mar 19 14:20:35.27: [ 4447]: --> [7:CONNECT]
Mar 19 14:20:37.41: [ 4447]: --> [2:OK]
Mar 19 14:20:37.41: [ 4447]: SEND recv PPR (partial page request)
Mar 19 14:20:37.41: [ 4447]: <-- [9:AT+FRS=7\r]
Mar 19 14:20:37.55: [ 4447]: --> [2:OK]
Mar 19 14:20:37.55: [ 4447]: SEND send frame number 23
Mar 19 14:20:37.56: [ 4447]: SEND send frame number 23
Mar 19 14:20:37.56: [ 4447]: DELAY 200 ms
Mar 19 14:20:37.75: [ 4447]: <-- [11:AT+FTM=122\r]
Mar 19 14:20:37.76: [ 4447]: --> [7:CONNECT]
Mar 19 14:20:37.76: [ 4447]: DELAY 400 ms
Mar 19 14:20:38.16: [ 4447]: <-- data [859]
Mar 19 14:20:38.16: [ 4447]: <-- data [2]
Mar 19 14:20:38.82: [ 4447]: --> [2:OK]
Mar 19 14:20:38.82: [ 4447]: <-- [9:AT+FTS=7\r]
Mar 19 14:20:38.88: [ 4447]: --> [2:OK]
Mar 19 14:20:38.88: [ 4447]: <-- [9:AT+FTH=3\r]
Mar 19 14:20:39.84: [ 4447]: --> [7:CONNECT]
Mar 19 14:20:39.84: [ 4447]: <-- data [7]
Mar 19 14:20:39.84: [ 4447]: <-- data [2]
Mar 19 14:20:40.34: [ 4447]: --> [2:OK]
Mar 19 14:20:40.34: [ 4447]: SEND send PPS (partial page signal)
Mar 19 14:20:40.34: [ 4447]: SEND send MPS (more pages, same document)
Mar 19 14:20:40.34: [ 4447]: <-- [9:AT+FRH=3\r]
Mar 19 14:20:40.49: [ 4447]: --> [7:CONNECT]
Mar 19 14:20:41.54: [ 4447]: --> [2:OK]
Mar 19 14:20:41.54: [ 4447]: SEND recv MCF (message confirmation)
Mar 19 14:20:41.54: [ 4447]: <-- [9:AT+FRS=7\r]
Mar 19 14:20:41.68: [ 4447]: --> [2:OK]
Mar 19 14:20:41.68: [ 4447]: SEND end page
Mar 19 14:20:41.69: [ 4447]: SEND FAX (000024160): FROM root@xxxxxxxxxxxxxxx TO 416-123-4567 (page 1 of 2 sent in 0:27)
Mar 19 14:20:41.69: [ 4447]: SEND begin page
Mar 19 14:20:41.74: [ 4447]: SEND EOFB
Mar 19 14:20:41.74: [ 4447]: SEND send frame number 0
Mar 19 14:20:41.75: [ 4447]: SEND send frame number 1
Mar 19 14:20:41.75: [ 4447]: SEND send frame number 2
Mar 19 14:20:41.75: [ 4447]: SEND send frame number 3
Mar 19 14:20:41.75: [ 4447]: SEND send frame number 4
Mar 19 14:20:41.75: [ 4447]: SEND send frame number 5
Mar 19 14:20:41.75: [ 4447]: SEND send frame number 6
Mar 19 14:20:41.75: [ 4447]: SEND send frame number 7
Mar 19 14:20:41.76: [ 4447]: SEND send frame number 8
Mar 19 14:20:41.76: [ 4447]: SEND send frame number 9
Mar 19 14:20:41.76: [ 4447]: SEND send frame number 10
Mar 19 14:20:41.76: [ 4447]: SEND send frame number 11
Mar 19 14:20:41.76: [ 4447]: SEND send frame number 12
Mar 19 14:20:41.76: [ 4447]: SEND send frame number 13
Mar 19 14:20:41.76: [ 4447]: DELAY 200 ms
Mar 19 14:20:41.95: [ 4447]: <-- [11:AT+FTM=122\r]
Mar 19 14:20:41.96: [ 4447]: --> [7:CONNECT]
Mar 19 14:20:41.96: [ 4447]: DELAY 400 ms
Mar 19 14:20:42.36: [ 4447]: <-- data [1028]
Mar 19 14:20:42.36: [ 4447]: <-- data [1030]
Mar 19 14:20:42.36: [ 4447]: <-- data [1036]
Mar 19 14:20:42.36: [ 4447]: <-- data [1013]
Mar 19 14:20:42.37: [ 4447]: <-- data [2]
Mar 19 14:20:45.17: [ 4447]: --> [2:OK]
Mar 19 14:20:45.17: [ 4447]: <-- [9:AT+FTS=9\r]
Mar 19 14:20:45.25: [ 4447]: --> [2:OK]
Mar 19 14:20:45.25: [ 4447]: <-- [9:AT+FTH=3\r]
Mar 19 14:20:46.21: [ 4447]: --> [7:CONNECT]
Mar 19 14:20:46.21: [ 4447]: <-- data [7]
Mar 19 14:20:46.21: [ 4447]: <-- data [2]
Mar 19 14:20:46.71: [ 4447]: --> [2:OK]
Mar 19 14:20:46.71: [ 4447]: SEND send PPS (partial page signal)
Mar 19 14:20:46.71: [ 4447]: SEND send EOP (no more pages or documents)
Mar 19 14:20:46.71: [ 4447]: <-- [9:AT+FRH=3\r]
Mar 19 14:20:46.88: [ 4447]: --> [7:CONNECT]
Mar 19 14:20:47.91: [ 4447]: --> [2:OK]
Mar 19 14:20:47.91: [ 4447]: SEND recv MCF (message confirmation)
Mar 19 14:20:47.91: [ 4447]: <-- [9:AT+FRS=7\r]
Mar 19 14:20:48.05: [ 4447]: --> [2:OK]
Mar 19 14:20:48.05: [ 4447]: SEND end page
Mar 19 14:20:48.06: [ 4447]: SEND FAX (000024160): FROM root@xxxxxxxxxxxxxxx TO 416-123-4567 (page 2 of 2 sent in 0:07)
Mar 19 14:20:48.06: [ 4447]: SEND FAX (000024160): FROM root@xxxxxxxxxxxxxxx TO 416-123-4567 (docq/doc28390.ps;c1 sent in 0:34)
Mar 19 14:20:49.08: [ 4447]: <-- [9:AT+FTH=3\r]
Mar 19 14:20:50.03: [ 4447]: --> [7:CONNECT]
Mar 19 14:20:50.03: [ 4447]: <-- data [3]
Mar 19 14:20:50.03: [ 4447]: <-- data [2]
Mar 19 14:20:50.42: [ 4447]: --> [2:OK]
Mar 19 14:20:50.42: [ 4447]: <-- [5:ATH0\r]
Mar 19 14:20:50.78: [ 4447]: --> [2:OK]
Mar 19 14:20:50.78: [ 4447]: SESSION END



Martin


____________________ HylaFAX(tm) Users Mailing List _______________________
 To subscribe/unsubscribe, click http://lists.hylafax.org/cgi-bin/lsg2.cgi
On UNIX: mail -s unsubscribe hylafax-users-request@xxxxxxxxxxx < /dev/null
 *To learn about commercial HylaFAX(tm) support, mail sales@xxxxxxxxx*

Project hosted by iFAX Solutions