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] Modem frustration

On Sat, 2005-07-09 at 14:46 -0700, Lee Howard wrote:

> Some of the code here has been rewritten since 4.2.1 was released.  If 
> possible, I'd recommend updating to the latest CVS snapshot, re-running 
> faxsetup and faxaddmodem (choosing Class 1.0 and hopefully use the 
> conexant-1.0 prototype).  And then let's proceed from there to try to 
> resolve any issues like this.  If the modem truly does not respond as 
> expected to CAN, then Class1RecvAbortOK must be set to "0".  But, if 
> that's the case, then I would recommend looking for a firmware upgrade 
> for the modem or trying a different modem of yours that use Rockwell 
> chipsets.


I have the cvs compiled and functioning with four 3 accura modems and
one modemblaster.  I've had at least one error with each modem.  So lets
look at the modemblaster in this email.  I did upgrade the firmware as
well.

Here is the responses in minicom

AT+FCLASS=?
0,1,1.0,2,8,10

OK
ATt
OK
AT+FCLASS=?
0,1,1.0,2,8,10

OK
ATI1
255

OK
ATI2
OK
ATI3
ACF3_V1.088-V90_P21_FSH

OK
ATI4
a007040284C6002F

bC60000000

r1005111151012000

r3000111170000000

OK
ATI5
B5

OK
ATI6
RCV56DPF-PLL L8571A Rev 30.03/34.00
OK
ATI7
OK
ATI8
ERROR

Here is the config file

#    Comtrol RocketModem II/III
#    MultiTech MT5600ZDX
#    Zoltrix FMVSP56i3

CountryCode:      1
AreaCode:      269
FAXNumber:     269.382.0608
LongDistancePrefix:  1
InternationalPrefix: 011
DialStringRules:  etc/dialrules
ServerTracing:    1
SessionTracing:      11
RecvFileMode:     0666
LogFileMode:      0666
DeviceMode:    0600
RingsBeforeAnswer:   1
SpeakerVolume:    off
GettyArgs:     "-h %l dx_%s"
LocalIdentifier:  "Schupan Aluminum Sales"
LogFacility:      local6
TagLineFont:      etc/lutRS18.pcf
TagLineFormat:    "From %%l|%c|Page %%P of %%T"
MaxRecvPages:     25
ModemPriority:    16
ModemType:     Class1.0 # use this to supply a hint
ModemRate:     19200    # rate for DCE-DTE communication
ModemFlowControl: rtscts      # default
#
ModemNoFlowCmd:      AT&K0    # setup no flow control
ModemHardFlowCmd: AT&K3    # setup hardware flow control
ModemSoftFlowCmd: AT&K4    # setup software flow control
ModemSetupDTRCmd: AT&D2    # setup so DTR drop resets modem
ModemSetupDCDCmd: AT&C1    # setup so DCD reflects carrier (or not)
#
Class1AdaptRecvCmd:  AT+FAR=1 # reports carrier detection mismatches


Here is a log entry of an error during a send

Jul 11 08:50:18.26: [ 2970]: SESSION BEGIN 000004811 7346688401 
Jul 11 08:50:18.26: [ 2970]: HylaFAX (tm) Version 4.2.2beta1 
Jul 11 08:50:18.26: [ 2970]: SEND FAX: JOB 2431 DEST 734-668-8401 COMMID
000004811 DEVICE '/dev/ttyS15' 
Jul 11 08:50:18.26: [ 2970]: <-- [14:AT+FCLASS=1.0\r] 
Jul 11 08:50:18.31: [ 2970]: --> [2:OK] 
Jul 11 08:50:18.31: [ 2970]: DIAL 9,17346688401 
Jul 11 08:50:18.31: [ 2970]: <-- [18:ATDT9,17346688401\r] 
Jul 11 08:50:36.34: [ 2970]: --> [7:CONNECT] 
Jul 11 08:50:37.57: [ 2970]: --> [2:OK] 
Jul 11 08:50:37.57: [ 2970]: REMOTE NSF "00 00 56 55 55 00 88 B0 80 5F
00" 
Jul 11 08:50:37.57: [ 2970]: NSF remote fax equipment: Brother 
Jul 11 08:50:37.57: [ 2970]: <-- [9:AT+FRH=3\r] 
Jul 11 08:50:37.63: [ 2970]: --> [7:CONNECT] 
Jul 11 08:50:38.28: [ 2970]: --> [2:OK] 
Jul 11 08:50:38.28: [ 2970]: REMOTE CSI "7346688401" 
Jul 11 08:50:38.28: [ 2970]: <-- [9:AT+FRH=3\r] 
Jul 11 08:50:38.33: [ 2970]: --> [7:CONNECT] 
Jul 11 08:50:38.59: [ 2970]: --> [2:OK] 
Jul 11 08:50:38.60: [ 2970]: REMOTE best rate 9600 bit/s 
Jul 11 08:50:38.60: [ 2970]: REMOTE max A4 page width (215 mm) 
Jul 11 08:50:38.60: [ 2970]: REMOTE max unlimited page length 
Jul 11 08:50:38.60: [ 2970]: REMOTE best vres 15.4 line/mm 
Jul 11 08:50:38.60: [ 2970]: REMOTE best format 1-D MH 
Jul 11 08:50:38.60: [ 2970]: REMOTE supports T.30 Annex A, 256-byte ECM 
Jul 11 08:50:38.60: [ 2970]: REMOTE best 20 ms, 10 ms/scanline 
Jul 11 08:50:38.60: [ 2970]: USE 9600 bit/s 
Jul 11 08:50:38.60: [ 2970]: USE error correction mode 
Jul 11 08:50:38.60: [ 2970]: SEND file "docq/doc2431.cover;f0" 
Jul 11 08:50:38.60: [ 2970]: USE A4 page width (215 mm) 
Jul 11 08:50:38.60: [ 2970]: USE unlimited page length 
Jul 11 08:50:38.60: [ 2970]: USE 3.85 line/mm 
Jul 11 08:50:38.60: [ 2970]: USE 1-D MH 
Jul 11 08:50:38.60: [ 2970]: USE 0 ms/scanline 
Jul 11 08:50:38.60: [ 2970]: SEND training at v.29 9600 bit/s 
Jul 11 08:50:38.60: [ 2970]: <-- [9:AT+FRS=7\r] 
Jul 11 08:50:38.75: [ 2970]: --> [2:OK] 
Jul 11 08:50:38.75: [ 2970]: <-- [9:AT+FTH=3\r] 
Jul 11 08:50:38.82: [ 2970]: --> [7:CONNECT] 
Jul 11 08:50:38.82: [ 2970]: <-- data [23] 
Jul 11 08:50:38.82: [ 2970]: <-- data [2] 
Jul 11 08:50:40.61: [ 2970]: --> [7:CONNECT] 
Jul 11 08:50:40.61: [ 2970]: <-- data [7] 
Jul 11 08:50:40.61: [ 2970]: <-- data [2] 
Jul 11 08:50:41.06: [ 2970]: --> [2:OK] 
Jul 11 08:50:41.06: [ 2970]: <-- [9:AT+FTS=7\r] 
Jul 11 08:50:41.17: [ 2970]: --> [2:OK] 
Jul 11 08:50:41.18: [ 2970]: <-- [10:AT+FTM=96\r] 
Jul 11 08:50:41.25: [ 2970]: --> [7:CONNECT] 
Jul 11 08:50:41.25: [ 2970]: <-- data [1024] 
Jul 11 08:50:41.64: [ 2970]: <-- data [776] 
Jul 11 08:50:42.04: [ 2970]: <-- data [2] 
Jul 11 08:50:43.21: [ 2970]: --> [2:OK] 
Jul 11 08:50:43.21: [ 2970]: <-- [9:AT+FRH=3\r] 
Jul 11 08:50:43.82: [ 2970]: --> [7:CONNECT] 
Jul 11 08:50:44.74: [ 2970]: --> [2:OK] 
Jul 11 08:50:44.74: [ 2970]: TRAINING succeeded 
Jul 11 08:50:44.74: [ 2970]: SEND begin page 
Jul 11 08:50:44.75: [ 2970]: Reading MMR-compressed image file 
Jul 11 08:50:44.77: [ 2970]: SEND 1D RTC 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 0 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 1 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 2 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 3 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 4 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 5 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 6 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 7 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 8 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 9 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 10 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 11 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 12 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 13 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 14 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 15 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 16 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 17 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 18 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 19 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 20 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 21 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 22 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 23 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 24 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 25 
Jul 11 08:50:44.77: [ 2970]: SEND send frame number 26 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 27 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 28 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 29 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 30 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 31 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 32 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 33 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 34 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 35 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 36 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 37 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 38 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 39 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 40 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 41 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 42 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 43 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 44 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 45 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 46 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 47 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 48 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 49 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 50 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 51 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 52 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 53 
Jul 11 08:50:44.78: [ 2970]: SEND send frame number 54 
Jul 11 08:50:44.78: [ 2970]: DELAY 200 ms 
Jul 11 08:50:44.98: [ 2970]: <-- [10:AT+FTM=96\r] 
Jul 11 08:50:45.06: [ 2970]: --> [7:CONNECT] 
Jul 11 08:50:45.06: [ 2970]: <-- data [1033] 
Jul 11 08:50:45.45: [ 2970]: <-- data [1033] 
Jul 11 08:50:45.85: [ 2970]: <-- data [1033] 
Jul 11 08:50:46.81: [ 2970]: <-- data [1027] 
Jul 11 08:50:47.72: [ 2970]: <-- data [1026] 
Jul 11 08:50:48.23: [ 2970]: <-- data [1033] 
Jul 11 08:50:49.12: [ 2970]: <-- data [1030] 
Jul 11 08:50:50.03: [ 2970]: <-- data [1030] 
Jul 11 08:50:50.93: [ 2970]: <-- data [1029] 
Jul 11 08:50:51.83: [ 2970]: <-- data [1028] 
Jul 11 08:50:52.23: [ 2970]: <-- data [1027] 
Jul 11 08:50:53.13: [ 2970]: <-- data [1026] 
Jul 11 08:50:54.04: [ 2970]: <-- data [1024] 
Jul 11 08:50:54.94: [ 2970]: <-- data [1025] 
Jul 11 08:50:55.83: [ 2970]: <-- data [543] 
Jul 11 08:50:56.73: [ 2970]: <-- data [2] 
Jul 11 08:50:57.90: [ 2970]: --> [2:OK] 
Jul 11 08:50:57.90: [ 2970]: <-- [9:AT+FTS=7\r] 
Jul 11 08:50:58.04: [ 2970]: --> [2:OK] 
Jul 11 08:50:58.04: [ 2970]: <-- [9:AT+FTH=3\r] 
Jul 11 08:50:58.11: [ 2970]: --> [7:CONNECT] 
Jul 11 08:50:58.11: [ 2970]: <-- data [7] 
Jul 11 08:50:58.11: [ 2970]: <-- data [2] 
Jul 11 08:50:59.52: [ 2970]: --> [2:OK] 
Jul 11 08:50:59.52: [ 2970]: SEND send PPS (partial page signal) 
Jul 11 08:50:59.52: [ 2970]: SEND send MPS (more pages, same document) 
Jul 11 08:50:59.52: [ 2970]: <-- [9:AT+FRH=3\r] 
Jul 11 08:51:02.62: [ 2970]: --> [0:] 
Jul 11 08:51:02.62: [ 2970]: MODEM 
Jul 11 08:51:02.62: [ 2970]: <-- data [1] 
Jul 11 08:51:02.67: [ 2970]: --> [2:OK] 
Jul 11 08:51:02.67: [ 2970]: <-- [9:AT+FTH=3\r] 
Jul 11 08:51:02.74: [ 2970]: --> [7:CONNECT] 
Jul 11 08:51:02.74: [ 2970]: <-- data [7] 
Jul 11 08:51:02.74: [ 2970]: <-- data [2] 
Jul 11 08:51:04.15: [ 2970]: --> [2:OK] 
Jul 11 08:51:04.15: [ 2970]: SEND send PPS (partial page signal) 
Jul 11 08:51:04.15: [ 2970]: SEND send MPS (more pages, same document) 
Jul 11 08:51:04.15: [ 2970]: <-- [9:AT+FRH=3\r] 
Jul 11 08:51:07.25: [ 2970]: --> [0:] 
Jul 11 08:51:07.25: [ 2970]: MODEM 
Jul 11 08:51:07.25: [ 2970]: <-- data [1] 
Jul 11 08:51:07.31: [ 2970]: --> [2:OK] 
Jul 11 08:51:07.31: [ 2970]: <-- [9:AT+FTH=3\r] 
Jul 11 08:51:07.38: [ 2970]: --> [7:CONNECT] 
Jul 11 08:51:07.38: [ 2970]: <-- data [7] 
Jul 11 08:51:07.38: [ 2970]: <-- data [2] 
Jul 11 08:51:08.78: [ 2970]: --> [2:OK] 
Jul 11 08:51:08.78: [ 2970]: SEND send PPS (partial page signal) 
Jul 11 08:51:08.78: [ 2970]: SEND send MPS (more pages, same document) 
Jul 11 08:51:08.78: [ 2970]: <-- [9:AT+FRH=3\r] 
Jul 11 08:51:11.88: [ 2970]: --> [0:] 
Jul 11 08:51:11.88: [ 2970]: MODEM 
Jul 11 08:51:11.88: [ 2970]: <-- data [1] 
Jul 11 08:51:11.94: [ 2970]: --> [2:OK] 
Jul 11 08:51:11.94: [ 2970]: No response to PPS repeated 3 times. 
Jul 11 08:51:11.94: [ 2970]: SEND end page 
Jul 11 08:51:11.94: [ 2970]: <-- [9:AT+FTH=3\r] 
Jul 11 08:51:12.01: [ 2970]: --> [7:CONNECT] 
Jul 11 08:51:12.01: [ 2970]: <-- data [3] 
Jul 11 08:51:12.01: [ 2970]: <-- data [2] 
Jul 11 08:51:13.31: [ 2970]: --> [2:OK] 
Jul 11 08:51:13.31: [ 2970]: <-- [5:ATH0\r] 
Jul 11 08:51:14.26: [ 2970]: --> [2:OK] 
Jul 11 08:51:14.26: [ 2970]: SESSION END

And here is an error during a receive.

Jul 11 09:48:42.02: [ 3678]: SESSION BEGIN 000004837 2693820608 
Jul 11 09:48:42.02: [ 3678]: HylaFAX (tm) Version 4.2.2beta1 
Jul 11 09:48:42.02: [ 3678]: <-- [4:ATA\r] 
Jul 11 09:48:48.01: [ 3678]: --> [7:CONNECT] 
Jul 11 09:48:48.01: [ 3678]: ANSWER: FAX CONNECTION DEVICE
'/dev/ttyS15' 
Jul 11 09:48:48.01: [ 3678]: RECV FAX: begin 
Jul 11 09:48:48.01: [ 3678]: <-- data [37] 
Jul 11 09:48:48.01: [ 3678]: <-- data [2] 
Jul 11 09:48:50.17: [ 3678]: --> [7:CONNECT] 
Jul 11 09:48:50.17: [ 3678]: <-- data [23] 
Jul 11 09:48:50.17: [ 3678]: <-- data [2] 
Jul 11 09:48:50.99: [ 3678]: --> [7:CONNECT] 
Jul 11 09:48:50.99: [ 3678]: <-- data [10] 
Jul 11 09:48:50.99: [ 3678]: <-- data [2] 
Jul 11 09:48:51.54: [ 3678]: --> [2:OK] 
Jul 11 09:48:51.54: [ 3678]: <-- [9:AT+FRH=3\r] 
Jul 11 09:48:51.92: [ 3678]: --> [7:CONNECT] 
Jul 11 09:48:53.19: [ 3678]: --> [2:OK] 
Jul 11 09:48:53.19: [ 3678]: REMOTE TSI "" 
Jul 11 09:48:53.19: [ 3678]: <-- [9:AT+FRH=3\r] 
Jul 11 09:48:53.24: [ 3678]: --> [7:CONNECT] 
Jul 11 09:48:53.43: [ 3678]: --> [2:OK] 
Jul 11 09:48:53.43: [ 3678]: REMOTE wants 14400 bit/s 
Jul 11 09:48:53.43: [ 3678]: REMOTE wants A3 page width (303 mm) 
Jul 11 09:48:53.43: [ 3678]: REMOTE wants unlimited page length 
Jul 11 09:48:53.43: [ 3678]: REMOTE wants 7.7 line/mm 
Jul 11 09:48:53.43: [ 3678]: REMOTE wants 1-D MH 
Jul 11 09:48:53.43: [ 3678]: RECV training at v.17 14400 bit/s 
Jul 11 09:48:53.43: [ 3678]: <-- [11:AT+FRM=145\r] 
Jul 11 09:48:55.14: [ 3678]: --> [7:CONNECT] 
Jul 11 09:48:56.69: [ 3678]: RECV: TCF 2754 bytes, 0% non-zero, 2725
zero-run 
Jul 11 09:48:56.69: [ 3678]: --> [10:NO CARRIER] 
Jul 11 09:48:56.70: [ 3678]: DELAY 75 ms 
Jul 11 09:48:56.77: [ 3678]: TRAINING succeeded 
Jul 11 09:48:56.77: [ 3678]: <-- [9:AT+FTH=3\r] 
Jul 11 09:48:56.84: [ 3678]: --> [7:CONNECT] 
Jul 11 09:48:56.84: [ 3678]: <-- data [3] 
Jul 11 09:48:56.84: [ 3678]: <-- data [2] 
Jul 11 09:48:58.14: [ 3678]: --> [2:OK] 
Jul 11 09:48:58.14: [ 3678]: <-- [11:AT+FRM=146\r] 
Jul 11 09:48:58.46: [ 3678]: --> [7:CONNECT] 
Jul 11 09:48:58.46: [ 3678]: RECV: begin page 
Jul 11 09:49:22.66: [ 3678]: RECV: 2200 total lines, 2200 bad lines, 0
consecutive bad lines 
Jul 11 09:49:22.66: [ 3678]: RECV: REJECT page quality, 0% good lines
(95% required) 
Jul 11 09:49:22.66: [ 3678]: RECV: end page 
Jul 11 09:49:22.66: [ 3678]: --> [10:NO CARRIER] 
Jul 11 09:49:22.66: [ 3678]: <-- [9:AT+FRH=3\r] 
Jul 11 09:49:23.60: [ 3678]: --> [7:CONNECT] 
Jul 11 09:49:24.45: [ 3678]: --> [2:OK] 
Jul 11 09:49:24.46: [ 3678]: RECV recv EOP (no more pages or documents) 
Jul 11 09:49:24.46: [ 3678]: <-- [9:AT+FRS=7\r] 
Jul 11 09:49:24.69: [ 3678]: --> [2:OK] 
Jul 11 09:49:24.70: [ 3678]: <-- [9:AT+FTH=3\r] 
Jul 11 09:49:24.87: [ 3678]: --> [7:CONNECT] 
Jul 11 09:49:24.87: [ 3678]: <-- data [3] 
Jul 11 09:49:24.87: [ 3678]: <-- data [2] 
Jul 11 09:49:26.17: [ 3678]: --> [2:OK] 
Jul 11 09:49:26.17: [ 3678]: RECV send RTN (retrain negative) 
Jul 11 09:49:26.17: [ 3678]: <-- [9:AT+FRH=3\r] 
Jul 11 09:49:26.63: [ 3678]: --> [7:CONNECT] 
Jul 11 09:49:27.28: [ 3678]: --> [2:OK] 
Jul 11 09:49:27.28: [ 3678]: RECV recv DCN 
Jul 11 09:49:27.28: [ 3678]: RECV keeping unconfirmed page 
Jul 11 09:49:27.28: [ 3678]: RECV FAX (000004837): from , page 1 in
0:34, INF, 7.7 line/mm, 1-D MH, 14400 bit/s 
Jul 11 09:49:27.28: [ 3678]: RECV FAX (000004837):
recvq/fax000001799.tif from , route to , 1 pages in 0:39 
Jul 11 09:49:27.28: [ 3678]: RECV FAX: COMREC received DCN 
Jul 11 09:49:27.28: [ 3678]: RECV FAX (000004837): session with
terminated abnormally: COMREC received DCN 
Jul 11 09:49:27.28: [ 3678]: RECV FAX: bin/faxrcvd
"recvq/fax000001799.tif" "ttyS15" "000004837" "COMREC received DCN" 
Jul 11 09:49:27.28: [ 3678]: RECV FAX: end 
Jul 11 09:49:27.28: [ 3678]: SESSION END

Any recommendations ??

-- 
Dirk Bartley
Systems Administrator
Schupan Aluminum Sales


____________________ 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