Fax Receive Problems
Matt White (whitem@bofh.usask.ca)
Fri, 7 Feb 1997 12:31:24 -0600 (CST)
Well, I managed to get a bit farther in receiving a fax. I performed a
hard reset on my ZyXEL modem, and it now fails at a different point.
It gets connected, and the fax machine starts transmitting, but it simply
fails with +FHNG:73 (T.30 T2 timeout, expected page not received)
Does anyone have any thoughts? The modem is a ZyXEL U1496E, v6.13 ROMs
Here is a sample log:
----------------snip----------------
--
02/07 11:50:59 yS1 mgetty: experimental test release 1.1.0-Jan20
02/07 11:50:59 yS1 check for lockfiles
02/07 11:50:59 yS1 checklock: stat failed, no file
02/07 11:50:59 yS1 locking the line
02/07 11:50:59 yS1 makelock(ttyS1) called
02/07 11:50:59 yS1 do_makelock: lock='/var/lock/LCK..ttyS1'
02/07 11:50:59 yS1 lock made
02/07 11:51:00 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR
02/07 11:51:00 yS1 lowering DTR to reset Modem
02/07 11:51:00 yS1 tss: set speed to 38400 (017)
02/07 11:51:00 yS1 tio_set_flow_control( HARD )
02/07 11:51:00 yS1 waiting for line to clear (VTIME), read:
02/07 11:51:01 yS1 send: \d\d\d+++\d\d\dATS0=0Q0&D3&H3&N0&K4[0d]
02/07 11:51:04 yS1 mdm_send: 'AT+FCLASS=2.0'
02/07 11:51:04 yS1 got:+++ATS0=0Q0&D3&H3&N0&K4[0d]
02/07 11:51:04 yS1 mdm_command: string '+++ATS0=0Q0&D3&H3&N0&K4'
02/07 11:51:04 yS1 got:[0d][0a]OK[0d]
02/07 11:51:04 yS1 mdm_command: string 'OK' -> OK
02/07 11:51:04 yS1 mdm_send: 'AT+FAA=1;+FCR=1'
02/07 11:51:04 yS1 got:[0a]AT+FCLASS=2.0[0d]
02/07 11:51:04 yS1 mdm_command: string 'AT+FCLASS=2.0'
02/07 11:51:04 yS1 got:[0d][0a]OK[0d]
02/07 11:51:04 yS1 mdm_command: string 'OK' -> OK
02/07 11:51:04 yS1 mdm_send: 'AT+FBO=1'
02/07 11:51:04 yS1 got:[0a]AT+FBO=1[0d]
02/07 11:51:04 yS1 mdm_command: string 'AT+FBO=1'
02/07 11:51:04 yS1 got:[0d][0a]OK[0d]
02/07 11:51:04 yS1 mdm_command: string 'OK' -> OK
02/07 11:51:04 yS1 mdm_send: 'AT+FNR=1,1,1,0'
02/07 11:51:04 yS1 got:[0a]AT+FNR=1,1,1,0[0d]
02/07 11:51:04 yS1 mdm_command: string 'AT+FNR=1,1,1,0'
02/07 11:51:04 yS1 got:[0d][0a]OK[0d]
02/07 11:51:04 yS1 mdm_command: string 'OK' -> OK
02/07 11:51:04 yS1 mdm_send: 'AT+FLI="(306) 966-7379"'
02/07 11:51:04 yS1 got:[0a]AT+FLI="(306) 966-7379"[0d]
02/07 11:51:04 yS1 mdm_command: string 'AT+FLI="(306) 966-7379"'
02/07 11:51:04 yS1 got:[0d][0a]OK[0d]
02/07 11:51:04 yS1 mdm_command: string 'OK' -> OK
02/07 11:51:04 yS1 mdm_send: 'AT+FCC=1,5,0,2,0,0,0,0'
02/07 11:51:04 yS1 got:[0a]AT+FCC=1,5,0,2,0,0,0,0[0d]
02/07 11:51:04 yS1 mdm_command: string 'AT+FCC=1,5,0,2,0,0,0,0'
02/07 11:51:04 yS1 got:[0d][0a]OK[0d]
02/07 11:51:04 yS1 mdm_command: string 'OK' -> OK
02/07 11:51:04 yS1 waiting for line to clear (VTIME), read:
02/07 11:51:04 yS1 removing lock file
02/07 11:51:04 yS1 waiting...
02/07 11:51:51 yS1 select returned 1
02/07 11:51:51 yS1 checking lockfiles, locking the line
02/07 11:51:51 yS1 makelock(ttyS1) called
02/07 11:51:51 yS1 do_makelock: lock='/var/lock/LCK..ttyS1'
02/07 11:51:51 yS1 lock made
02/07 11:51:51 yS1 waiting for ``RING''
02/07 11:51:51 yS1 got: [0d][0a]RING ** found **
02/07 11:51:51 yS1 waiting for ``RING''
02/07 11:51:51 yS1 got: [0d]
02/07 11:51:51 yS1 CND: RING[0a][0d][0a]RING ** found **
02/07 11:51:57 yS1 send: ATA[0d]
02/07 11:51:57 yS1 waiting for ``CONNECT''
02/07 11:51:57 yS1 got: [0d]
02/07 11:51:57 yS1 CND: RING[0a]ATA[0d]
02/07 11:51:57 yS1 CND: ATA[0d][0a]+FCO[0d]
02/07 11:52:08 yS1 CND: +FCO
02/07 11:52:08 yS1 found action string: ``+FCO^M''
02/07 11:52:08 yS1 start fax receiver...
02/07 11:52:08 yS1 fax receiver: entry
02/07 11:52:08 yS1 fax_wait_for(OK)
02/07 11:52:08 yS1 got:[0a][0a][0d][0a]+FTI: 306 966 4885 [0d]
02/07 11:52:10 yS1 fax_wait_for: string '+FTI: 306 966 4885 '
02/07 11:52:10 yS1 fax_id: '+FTI: 306 966 4885 '
02/07 11:52:10 yS1 got:[0a][0a][0d][0a][0a]+FCS:1,3,0,2,0,1,0,5[0d]
02/07 11:52:10 yS1 fax_wait_for: string '+FCS:1,3,0,2,0,1,0,5'
02/07 11:52:10 yS1 transmission par.: '+FCS:1,3,0,2,0,1,0,5'
02/07 11:52:10 yS1 got:[0a][0d][0a]OK[0d]
02/07 11:52:10 yS1 fax_wait_for: string 'OK'** found **
02/07 11:52:10 yS1 tio_set_flow_control( HARD XON_IN )
02/07 11:52:10 yS1 mdm_send: 'AT+FLO=2'
02/07 11:52:10 yS1 got:[0a]AT+FLO=2[0d]
02/07 11:52:10 yS1 mdm_command: string 'AT+FLO=2'
02/07 11:52:10 yS1 got:[0d][0a]OK[0d]
02/07 11:52:10 yS1 mdm_command: string 'OK' -> OK
02/07 11:52:10 yS1 fax_send: 'AT+FDR'
02/07 11:52:10 yS1 fax_wait_for(CONNECT)
02/07 11:52:10 yS1 got:[0a]AT+FDR[0d]
02/07 11:52:10 yS1 fax_wait_for: string 'AT+FDR'
02/07 11:52:10 yS1 got:[0d][0a]+FCS:1,3,0,2,0,1,0,5[0d]
02/07 11:52:12 yS1 fax_wait_for: string '+FCS:1,3,0,2,0,1,0,5'
02/07 11:52:12 yS1 transmission par.: '+FCS:1,3,0,2,0,1,0,5'
02/07 11:52:12 yS1 got:[0a][0d][0a]+FHS:73[0d]
02/07 11:52:24 yS1 fax_wait_for: string '+FHS:73'
02/07 11:52:24 yS1 connection hangup: '+FHS:73'
02/07 11:52:24 yS1 (T.30 T2 timeout, expected page not received)** found**
02/07 11:52:24 yS1 fax_get_pages: cannot start page receive
02/07 11:52:24 yS1 fax receiver: hangup & end
02/07 11:52:24 yS1 fax_notify_mail: sending mail to: faxadmin
02/07 11:52:25 yS1 notify: '/usr/local/lib/mgetty+sendfax/new_fax 73 '3
06 966 4885 ' 0 >/dev/console 2>&1 </dev/null'
02/07 11:52:25 ##### fax dev=ttyS1, pid=5919, caller=none, name='', id='3
06 966 4885 ', +FHNG=073, pages=0, time=00:00:27
02/07 11:52:27 yS1 mdm_send: 'ATH0'
02/07 11:52:27 yS1 got:[0a][0d][0a]OK[0d]
02/07 11:52:27 yS1 mdm_command: string 'OK' -> OK
02/07 11:52:27 yS1 removing lock file
--
----------------snip----------------
---------------------------------------------------------------------
- Matt White whitem@arts.usask.ca -
- Network Technical Support http://arts.usask.ca/~whitem -
- College of Arts & Science University of Saskatchewan -
---------------------------------------------------------------------
I got into work this morning early this afternoon
Well, my boss-man nudged me, said "Son I've got to talk to you"
- John Michael Montgomery..."Beer & Bones"