Error receiving FAX

Gabor Csuri (gcsuri.log@dunaferr.hu)
Thu, 16 Apr 1998 14:55:31 +0200


Hi All !

I have a MultiTech MultiModem MT2834ZDXI with 0313A firmware
and mgetty+sendfax 1.1.14-Apr02 release (but I tried older 
versions too) and RedHat Linux 5.0 with 2.0.33 kernel.

I can't receive FAX with Linux!
But the modem works fine with Micro$oft Exchange.

I send the both of log file:

mgetty.ttyS0 :

04/16 13:20:55 yS0  mgetty: experimental test release 1.1.14-Apr02
04/16 13:20:55 yS0   mgetty.c compiled at Apr 15 1998, 12:35:51
04/16 13:20:55 yS0   user id: 0, parent pid: 1
04/16 13:20:55 yS0   reading configuration data for port 'ttyS0'
04/16 13:20:55 yS0   reading /etc/mgetty+sendfax/mgetty.config...
04/16 13:20:55 yS0   conf lib: read: 'debug 9'
04/16 13:20:55 yS0   conf lib: read: 'fax-id +36 25 483924'
04/16 13:20:55 yS0   conf lib: read: 'speed 115200'
04/16 13:20:55 yS0   conf lib: read: 'port ttyS0'
04/16 13:20:55 yS0   section: port ttyS0, **found**
04/16 13:20:55 yS0   conf lib: read: 'debug 9'
04/16 13:20:55 yS0   conf lib: read: 'speed 115200'
04/16 13:20:55 yS0   conf lib: read: 'init-chat ""
AT&FE0X4S0=0S25=20S7=55S30=0M1&E1&E15&E4X4'
04/16 13:20:55 yS0   conf lib: read: 'modem-type cls2'
04/16 13:20:55 yS0   key: 'speed', type=0, flags=3, data=115200
04/16 13:20:55 yS0   key: 'switchbd', type=0, flags=1, data=0
04/16 13:20:55 yS0   key: 'direct', type=3, flags=1, data=FALSE
04/16 13:20:55 yS0   key: 'blocking', type=3, flags=1, data=FALSE
04/16 13:20:55 yS0   key: 'port-owner', type=1, flags=1, data=uucp
04/16 13:20:55 yS0   key: 'port-group', type=1, flags=1, data=modem
04/16 13:20:55 yS0   key: 'port-mode', type=0, flags=1, data=432
04/16 13:20:55 yS0   key: 'toggle-dtr', type=3, flags=1, data=TRUE
04/16 13:20:55 yS0   key: 'toggle-dtr-waittime', type=0, flags=1,
data=500
04/16 13:20:55 yS0   key: 'data-only', type=3, flags=1, data=FALSE
04/16 13:20:55 yS0   key: 'fax-only', type=3, flags=1, data=FALSE
04/16 13:20:55 yS0   key: 'modem-type', type=1, flags=3, data=cls2
04/16 13:20:55 yS0   key: 'modem-quirks', type=0, flags=0, data=(empty)
04/16 13:20:55 yS0   key: 'init-chat', type=2, flags=3, data=
AT&FE0X4S0=0S25=20S7=55S30=0M1&E1&E15&E4X4 
04/16 13:20:55 yS0   key: 'force-init-chat', type=2, flags=1, data=
\d\d\d\d+++\\dATQ0V1H0 OK 
04/16 13:20:55 yS0   key: 'modem-check-time', type=0, flags=1, data=3600
04/16 13:20:55 yS0   key: 'rings', type=0, flags=1, data=1
04/16 13:20:55 yS0   key: 'get-cnd-chat', type=2, flags=0, data=(empty)
04/16 13:20:55 yS0   key: 'answer-chat', type=2, flags=1, data= ATA
CONNECT \c  
04/16 13:20:55 yS0   key: 'answer-chat-timeout', type=0, flags=1,
data=80
04/16 13:20:55 yS0   key: 'autobauding', type=3, flags=1, data=FALSE
04/16 13:20:55 yS0   key: 'ringback', type=3, flags=1, data=FALSE
04/16 13:20:55 yS0   key: 'ringback-time', type=0, flags=1, data=30
04/16 13:20:55 yS0   key: 'ignore-carrier', type=3, flags=1, data=FALSE
04/16 13:20:55 yS0   key: 'issue-file', type=1, flags=1, data=/etc/issue
04/16 13:20:55 yS0   key: 'prompt-waittime', type=0, flags=1, data=500
04/16 13:20:55 yS0   key: 'login-prompt', type=1, flags=1, data=@!login: 
04/16 13:20:55 yS0   key: 'login-time', type=0, flags=1, data=240
04/16 13:20:55 yS0   key: 'fido-send-emsi', type=3, flags=1, data=TRUE
04/16 13:20:55 yS0   key: 'fax-id', type=1, flags=3, data=+36 25 483924
04/16 13:20:55 yS0   key: 'fax-server-file', type=1, flags=0,
data=(empty)
04/16 13:20:55 yS0   key: 'diskspace', type=0, flags=1, data=1024
04/16 13:20:55 yS0   key: 'notify', type=1, flags=1, data=faxadmin
04/16 13:20:55 yS0   key: 'fax-owner', type=1, flags=1, data=uucp
04/16 13:20:55 yS0   key: 'fax-group', type=1, flags=0, data=(empty)
04/16 13:20:55 yS0   key: 'fax-mode', type=0, flags=1, data=432
04/16 13:20:55 yS0   key: 'debug', type=0, flags=2, data=9
04/16 13:20:55 yS0   key: 'statistics-chat', type=2, flags=0,
data=(empty)
04/16 13:20:55 yS0   key: 'statistics-file', type=1, flags=0,
data=(empty)
04/16 13:20:55 yS0   key: 'gettydefs', type=1, flags=1, data=n
04/16 13:20:55 yS0   key: 'term', type=1, flags=0, data=(empty)
04/16 13:20:55 yS0  check for lockfiles
04/16 13:20:55 yS0   checklock: stat failed, no file
04/16 13:20:55 yS0  locking the line
04/16 13:20:55 yS0   makelock(ttyS0) called
04/16 13:20:55 yS0   do_makelock: lock='/var/lock/LCK..ttyS0'
04/16 13:20:55 yS0   lock made
04/16 13:20:55 yS0   tio_get_rs232_lines: status: RTS CTS DTR
04/16 13:20:55 yS0  WARNING: DSR is off - modem turned off or bad cable?
04/16 13:20:55 yS0  lowering DTR to reset Modem
04/16 13:20:56 yS0   tss: set speed to 115200 (10002)
04/16 13:20:56 yS0   tio_set_flow_control( HARD )
04/16 13:20:56 yS0   waiting for line to clear (VTIME), read: 
04/16 13:20:56 yS0  send: AT&FE0X4S0=0S25=20S7=55S30=0M1&E1&E15&E4X4[0d]
04/16 13:20:56 yS0  mdm_send: 'AT+FCLASS=2'
04/16 13:20:56 yS0    got:AT&FE0X4S0=0S25=20S7=55S30=0M1&E1&E15&E4X4[0d]
04/16 13:20:56 yS0   mdm_command: string
'AT&FE0X4S0=0S25=20S7=55S30=0M1&E1&E15&E4X4'
04/16 13:20:56 yS0    got:AT+FCLA[0d]
04/16 13:20:56 yS0   mdm_command: string 'AT+FCLA'
04/16 13:20:56 yS0    got:[0d][0a]OK[0d]
04/16 13:20:56 yS0   mdm_command: string 'OK' -> OK
04/16 13:20:57 yS0  mdm_send: 'AT+FCLASS=0'
04/16 13:20:57 yS0    got:[0a]AT+FCLASS=0[0d]
04/16 13:20:57 yS0   mdm_command: string 'AT+FCLASS=0'
04/16 13:20:57 yS0    got:[0d][0a]OK[0d]
04/16 13:20:57 yS0   mdm_command: string 'OK' -> OK
04/16 13:20:57 yS0  mdm_send: 'AT+FAA=1;+FCR=1'
04/16 13:20:57 yS0    got:[0a]AT+FAA=1;+FCR=1[0d]
04/16 13:20:57 yS0   mdm_command: string 'AT+FAA=1;+FCR=1'
04/16 13:20:57 yS0    got:[0d][0a]OK[0d]
04/16 13:20:57 yS0   mdm_command: string 'OK' -> OK
04/16 13:20:57 yS0  mdm_send: 'AT+FBOR=0'
04/16 13:20:57 yS0    got:[0a]AT+FBOR=0[0d]
04/16 13:20:57 yS0   mdm_command: string 'AT+FBOR=0'
04/16 13:20:57 yS0    got:[0d][0a]OK[0d]
04/16 13:20:57 yS0   mdm_command: string 'OK' -> OK
04/16 13:20:57 yS0  mdm_send: 'AT+FLID="+36 25 483924"'
04/16 13:20:57 yS0    got:[0a]AT+FLID="+36 25 483924"[0d]
04/16 13:20:57 yS0   mdm_command: string 'AT+FLID="+36 25 483924"'
04/16 13:20:57 yS0    got:[0d][0a]OK[0d]
04/16 13:20:57 yS0   mdm_command: string 'OK' -> OK
04/16 13:20:57 yS0  mdm_send: 'AT+FDCC=1,5,0,2,0,0,0,0'
04/16 13:20:57 yS0    got:[0a]AT+FDCC=1,5,0,2,0,0,0,0[0d]
04/16 13:20:57 yS0   mdm_command: string 'AT+FDCC=1,5,0,2,0,0,0,0'
04/16 13:20:57 yS0    got:[0d][0a]OK[0d]
04/16 13:20:58 yS0   mdm_command: string 'OK' -> OK
04/16 13:20:58 yS0   waiting for line to clear (VTIME), read: 
04/16 13:20:58 yS0   removing lock file
04/16 13:20:58 yS0  waiting...
04/16 13:30:46 yS0    select returned 1
04/16 13:30:46 yS0   checking lockfiles, locking the line
04/16 13:30:46 yS0   makelock(ttyS0) called
04/16 13:30:46 yS0   do_makelock: lock='/var/lock/LCK..ttyS0'
04/16 13:30:46 yS0   lock made
04/16 13:30:46 yS0  waiting for ``RING''
04/16 13:30:46 yS0   got: [0d][0a]RING ** found **
04/16 13:30:46 yS0    CND: check no: 'none'
04/16 13:30:46 yS0    CND: check vs: all
04/16 13:30:46 yS0  send: ATA[0d]
04/16 13:30:46 yS0  waiting for ``CONNECT''
04/16 13:30:46 yS0   got: [0d]
04/16 13:30:46 yS0    CND: RING[0a]AT[fd][0d]
04/16 13:30:53 yS0    CND: AT_[0a]+FCON
04/16 13:30:53 yS0  found action string: ``+FCON''
04/16 13:30:53 yS0  start fax receiver...
04/16 13:30:53 yS0   fax receiver: entry
04/16 13:30:53 yS0  fax_wait_for(OK)
04/16 13:30:53 yS0    got:[0a][0d][0a][0d][0a]+FTSI:"      +36 25
482213"[0d]
04/16 13:31:01 yS0   fax_wait_for: string '+FTSI:"      +36 25 482 213"'
04/16 13:31:01 yS0  fax_id: '+FTSI:"      +36 25 482 213"'
04/16 13:31:01 yS0    got:[0a][0d][0a]+FDCS:1,5,0,0,0,0,0,0[0d]
04/16 13:31:01 yS0   fax_wait_for: string '+FDCS:1,5,0,0,0,0,0,0'
04/16 13:31:01 yS0  transmission par.: '+FDCS:1,5,0,0,0,0,0,0'
04/16 13:31:01 yS0    got:[0a][0d][0a]OK[0d]
04/16 13:31:01 yS0   fax_wait_for: string 'OK'** found **
04/16 13:31:01 yS0    looking for utmp entry... (my PID: 22897)
04/16 13:31:01 yS0   utmp + wtmp entry made
04/16 13:31:01 yS0   tio_set_flow_control( HARD XON_IN )
04/16 13:31:01 yS0  fax_send: 'AT+FDR'
04/16 13:31:01 yS0  fax_wait_for(CONNECT)
04/16 13:31:01 yS0    got:[0a]AT+FDR[0d]
04/16 13:31:01 yS0   fax_wait_for: string 'AT+FDR'
04/16 13:31:01 yS0    got:[0d][0a]+FHNG:73[0d]           <<====
!!!!!!!!!!!
04/16 13:31:45 yS0   fax_wait_for: string '+FHNG:73'
04/16 13:31:45 yS0  connection hangup: '+FHNG:73'
04/16 13:31:45 yS0   (T.30 T2 timeout, expected page not
received)**found **
04/16 13:31:45 yS0  fax_get_pages: cannot start page receive
04/16 13:31:45 yS0   fax receiver: hangup & end
04/16 13:31:45 yS0   fax_notify_mail: sending mail to: faxadmin
04/16 13:31:45 yS0   notify: '/usr/lib/mgetty+sendfax/new_fax 73 '_     
+36 25 482 213_' 0 >/dev/console 2>&1 </dev/null'
04/16 13:31:45 ##### fax dev=ttyS0, pid=22897, caller='none', name='',
id='_      +36 25 482 213_', +FHNG=073, pages=0, time=00:00:59

04/16 13:31:46 yS0  mdm_send: 'ATH0'
04/16 13:31:46 yS0    got:[0a][0d][0a]OK[0d]
04/16 13:31:46 yS0   mdm_command: string 'OK' -> OK
04/16 13:31:46 yS0   removing lock file

And the FAX was not received ! 



Modemlog.txt from Win95 :

04-16-1998 13:11:49.15 - MT2834ZDXI  V.34  in use.
04-16-1998 13:11:49.16 - Modem type: MT2834ZDXI  V.34 
04-16-1998 13:11:49.16 - Modem inf path: MDMMTSZ5.INF
04-16-1998 13:11:49.16 - Modem inf section: Modem10
04-16-1998 13:11:49.39 - 115200,N,8,1
04-16-1998 13:11:49.53 - 115200,N,8,1
04-16-1998 13:11:49.56 - WARNING: Unable to load the 'SpeakerVolume_Med'
string.
04-16-1998 13:11:49.56 - WARNING: Unable to load the
'SpeedNegotiation_On' string.
04-16-1998 13:11:49.56 - Initializing modem.
04-16-1998 13:11:49.56 - Send: AT<cr>
04-16-1998 13:11:49.56 - Recv: AT<cr>
04-16-1998 13:11:49.71 - Recv: <cr><lf>OK<cr><lf>
04-16-1998 13:11:49.71 - Interpreted response: Ok
04-16-1998 13:11:49.71 - Send: AT &F E0 x4 S0=0 S25=20<cr>
04-16-1998 13:11:49.71 - Recv: AT &F E0 x4 S0=0 S25=20<cr>
04-16-1998 13:11:50.04 - Recv: <cr><lf>OK<cr><lf>
04-16-1998 13:11:50.04 - Interpreted response: Ok
04-16-1998 13:11:50.04 - Send: ATS7=55S30=0M1&E1&E15&E4X4<cr>
04-16-1998 13:11:50.20 - Recv: <cr><lf>OK<cr><lf>
04-16-1998 13:11:50.20 - Interpreted response: Ok
04-16-1998 13:11:51.34 - 2400,N,8,1
04-16-1998 13:11:51.59 - 2400,N,8,1
04-16-1998 13:11:51.59 - 2400,N,8,1
04-16-1998 13:11:53.66 - 115200,N,8,1
04-16-1998 13:11:53.90 - Initializing modem.
04-16-1998 13:11:53.90 - Send: AT<cr>
04-16-1998 13:11:54.05 - Recv: <cr><lf>OK<cr><lf>
04-16-1998 13:11:54.05 - Interpreted response: Ok
04-16-1998 13:11:54.05 - Send: AT &F E0 x4 S0=0 S25=20<cr>
04-16-1998 13:11:54.39 - Recv: <cr><lf>OK<cr><lf>
04-16-1998 13:11:54.39 - Interpreted response: Ok
04-16-1998 13:11:54.39 - Send: ATS7=55S30=0M1&E1&E15&E4X4<cr>
04-16-1998 13:11:54.56 - Recv: <cr><lf>OK<cr><lf>
04-16-1998 13:11:54.56 - Interpreted response: Ok
04-16-1998 13:11:55.01 - Waiting for a call.
04-16-1998 13:11:55.01 - Send: ATS0=0<cr>
04-16-1998 13:11:55.16 - Recv: <cr><lf>OK<cr><lf>
04-16-1998 13:11:55.16 - Interpreted response: Ok
04-16-1998 13:12:29.50 - Recv: <cr><lf>RING<cr><lf>
04-16-1998 13:12:29.50 - Interpreted response: Ring
04-16-1998 13:12:34.65 - Recv: <cr><lf>RING<cr><lf>
04-16-1998 13:12:34.65 - Interpreted response: Ring
04-16-1998 13:12:39.76 - Recv: <cr><lf>RING<cr><lf>
04-16-1998 13:12:39.76 - Interpreted response: Ring
04-16-1998 13:12:44.91 - Recv: <cr><lf>RING<cr><lf>
04-16-1998 13:12:44.91 - Interpreted response: Ring
04-16-1998 13:12:46.04 - 2400,N,8,1
04-16-1998 13:12:46.24 - 2400,N,8,1
04-16-1998 13:12:46.24 - 2400,N,8,1
04-16-1998 13:12:48.49 - 19200,N,8,1
04-16-1998 13:12:49.54 - 19200,N,8,1
04-16-1998 13:13:16.60 - 19200,N,8,1
04-16-1998 13:13:31.55 - 19200,N,8,1
04-16-1998 13:13:32.98 - 2400,N,8,1
04-16-1998 13:13:33.85 - 115200,N,8,1
04-16-1998 13:13:34.40 - Initializing modem.
04-16-1998 13:13:34.40 - Send: AT<cr>
04-16-1998 13:13:34.55 - Recv: <cr><lf>OK<cr><lf>
04-16-1998 13:13:34.55 - Interpreted response: Ok
04-16-1998 13:13:34.55 - Send: AT &F E0 x4 S0=0 S25=20<cr>
04-16-1998 13:13:34.89 - Recv: <cr><lf>OK<cr><lf>
04-16-1998 13:13:34.89 - Interpreted response: Ok
04-16-1998 13:13:34.89 - Send: ATS7=55S30=0M1&E1&E15&E4X4<cr>
04-16-1998 13:13:35.04 - Recv: <cr><lf>OK<cr><lf>
04-16-1998 13:13:35.04 - Interpreted response: Ok
04-16-1998 13:13:35.04 - Waiting for a call.
04-16-1998 13:13:35.04 - Send: ATS0=0<cr>
04-16-1998 13:13:35.19 - Recv: <cr><lf>OK<cr><lf>
04-16-1998 13:13:35.19 - Interpreted response: Ok
04-16-1998 13:14:19.44 - Initializing modem.
04-16-1998 13:14:19.44 - Send: AT<cr>
04-16-1998 13:14:19.59 - Recv: <cr><lf>OK<cr><lf>
04-16-1998 13:14:19.59 - Interpreted response: Ok
04-16-1998 13:14:19.59 - Send: AT &F E0 x4 S0=0 S25=20<cr>
04-16-1998 13:14:19.93 - Recv: <cr><lf>OK<cr><lf>
04-16-1998 13:14:19.93 - Interpreted response: Ok
04-16-1998 13:14:19.93 - Send: ATS7=55S30=0M1&E1&E15&E4X4<cr>
04-16-1998 13:14:20.08 - Recv: <cr><lf>OK<cr><lf>
04-16-1998 13:14:20.08 - Interpreted response: Ok
04-16-1998 13:14:20.08 - Waiting for a call.
04-16-1998 13:14:20.08 - Send: ATS0=0<cr>
04-16-1998 13:14:20.25 - Recv: <cr><lf>OK<cr><lf>
04-16-1998 13:14:20.25 - Interpreted response: Ok
04-16-1998 13:14:22.46 - Hanging up the modem.
04-16-1998 13:14:22.55 - Session Statistics:
04-16-1998 13:14:22.55 -                Reads : 12844 bytes
04-16-1998 13:14:22.55 -                Writes: 522 bytes
04-16-1998 13:14:22.55 - MT2834ZDXI  V.34  closed.

And the FAX is received!!!

I used the same init string, same port speed and the same modem!!!
I tried some other init string for Linux, like AT&FX4S0=0&D3&C1,
but I can't receive FAX !!!

Why? Please Help !

Thank You!

       \\\|///
      \\ _ _ //
       ( @ @ )
+---o00o-(_)-o00o----------------------------+
| Csuri Gabor                                |
| snail-mail:      2400  Dunaujvaros         |
|                  Nap u. 4. 1/1.            |
|                  HUNGARY                   |
| Office phone:    +36 25 482651             |
| e-mail:   mailto:gcsuri.log@dunaferr.hu    |
+------------Oooo----------------------------+
      oooO  (   )
      (   )  ) /
       \ (   (_)
        \_)