PCMCIA, ECO II 56K Fax/Modem: Fax/Data distinguishing does not work
Thomas Ziegler (zie@goldmund.johannis.nbg.de)
Wed, 11 Aug 1999 00:32:14 +0200
PCMCIA Modem ECO II 56K Fax/Modem
Manufacturer: AnyCom
German Dealer: RFI
Chipset: Docu says Lucent
Error: Dialin with fax does not work (see log-faxin-error)
But: Dialin with /etc/answer set to 'fax' works (see log-faxin-faxonly)
Error: Fax-Polling works neither as a server (see log-poll-server)
nor as a client (see log-poll-client)
But: The german dealer says he's sure, that polling is supported
What I can see from the log files is, that an incomming fax call is
recognized as a data call. This takes rather long. When the welcome
banner is presented, the calling modem had hung up long ago.
Polling modes are recognized as 'not working'.
Maybe there is a chance get the modem working with some special
configuration. Otherwise I have to return it.
Any other hints for a working and cheap 56k-PCMCIA-Modem?
Thanks in advance
Thomas
--
Dr.-Ing. Thomas Ziegler, Schweinauerstr. 65, 90439 Nürnberg
Phone +49 911 6599595, FAX +49 911 6599596
--- log-faxin-error ---
08/10 15:54:37 yS1 mgetty: experimental test release 1.1.21-Jul24
08/10 15:54:37 yS1 check for lockfiles
08/10 15:54:37 yS1 checklock: stat failed, no file
08/10 15:54:37 yS1 locking the line
08/10 15:54:37 yS1 makelock(ttyS1) called
08/10 15:54:37 yS1 do_makelock: lock='/var/lock/LCK..ttyS1'
08/10 15:54:37 yS1 lock made
08/10 15:54:38 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR
08/10 15:54:38 yS1 lowering DTR to reset Modem
08/10 15:54:38 yS1 tss: set speed to 19200 (016)
08/10 15:54:38 yS1 tio_set_flow_control( HARD )
08/10 15:54:38 yS1 waiting for line to clear (VTIME), read: [0d][0a]OK[0d][0a]
08/10 15:54:38 yS1 send: \dATQ0V1H0[0d]
08/10 15:54:39 yS1 waiting for ``OK''
08/10 15:54:39 yS1 got: ATQ0V1H0[0d]
08/10 15:54:39 yS1 CND: ATQ0V1H0[0d][0a]OK ** found **
08/10 15:54:39 yS1 send: ATS0=0Q0&D3&C1[0d]
08/10 15:54:39 yS1 waiting for ``OK''
08/10 15:54:39 yS1 got: [0d]
08/10 15:54:39 yS1 CND: OK[0a]ATS0=0Q0&D3&C1[0d]
08/10 15:54:39 yS1 CND: ATS0=0Q0&D3&C1[0d][0a]OK ** found **
08/10 15:54:39 yS1 mdm_send: 'ATI'
08/10 15:54:39 yS1 got:[0d][0a]ATI[0d]
08/10 15:54:39 yS1 got:[0d][0a]AnyCom ECO 56K II PC Card Fax/Modem VER 2.04 [0d]
08/10 15:54:39 yS1 mdm_gis: string 1: 'AnyCom ECO 56K II PC Card Fax/Modem VER 2.04 '
08/10 15:54:39 yS1 got:[0a][0d][0a]OK[0d]
08/10 15:54:39 yS1 mdm_identify: string 'AnyCom ECO 56K II PC Card Fax/Modem VER 2.04 '
08/10 15:54:39 yS1 non-numeric ID string: 'AnyCom ECO 56K II PC Card Fax/Modem VER 2.04 '
08/10 15:54:39 yS1 mdm_send: 'AT+FCLASS=2.0'
08/10 15:54:39 yS1 got:[0a]AT+FCLASS=2.0[0d]
08/10 15:54:39 yS1 mdm_command: string 'AT+FCLASS=2.0'
08/10 15:54:39 yS1 got:[0d][0a]ERROR[0d]
08/10 15:54:39 yS1 mdm_command: string 'ERROR' -> ERROR
08/10 15:54:39 yS1 mdm_send: 'AT+FCLASS=2'
08/10 15:54:39 yS1 got:[0a]AT+FCLASS=2[0d]
08/10 15:54:39 yS1 mdm_command: string 'AT+FCLASS=2'
08/10 15:54:39 yS1 got:[0d][0a]OK[0d]
08/10 15:54:39 yS1 mdm_command: string 'OK' -> OK
08/10 15:54:39 yS1 mdm_send: 'AT+FCLASS=0'
08/10 15:54:39 yS1 got:[0a]AT+FCLASS=0[0d]
08/10 15:54:39 yS1 mdm_command: string 'AT+FCLASS=0'
08/10 15:54:39 yS1 got:[0d][0a]OK[0d]
08/10 15:54:39 yS1 mdm_command: string 'OK' -> OK
08/10 15:54:39 yS1 mdm_send: 'AT+FAA=1;+FCR=1'
08/10 15:54:39 yS1 got:[0a]AT+FAA=1;+FCR=1[0d]
08/10 15:54:39 yS1 mdm_command: string 'AT+FAA=1;+FCR=1'
08/10 15:54:39 yS1 got:[0d][0a]OK[0d]
08/10 15:54:39 yS1 mdm_command: string 'OK' -> OK
08/10 15:54:40 yS1 mdm_send: 'AT+FBOR=0'
08/10 15:54:40 yS1 got:[0a]AT+FBOR=0[0d]
08/10 15:54:40 yS1 mdm_command: string 'AT+FBOR=0'
08/10 15:54:40 yS1 got:[0d][0a]OK[0d]
08/10 15:54:40 yS1 mdm_command: string 'OK' -> OK
08/10 15:54:40 yS1 mdm_send: 'AT+FLID="*Notebook*"'
08/10 15:54:40 yS1 got:[0a]AT+FLID="*Notebook*"[0d]
08/10 15:54:40 yS1 mdm_command: string 'AT+FLID="*Notebook*"' 08/10 15:54:40 yS1 got:[0d][0a]OK[0d]
08/10 15:54:40 yS1 mdm_command: string 'OK' -> OK
08/10 15:54:40 yS1 mdm_send: 'AT+FDCC=1,5,0,2,0,0,0,0'
08/10 15:54:40 yS1 got:[0a]AT+FDCC=1,5,0,2,0,0,0,0[0d]
08/10 15:54:40 yS1 mdm_command: string 'AT+FDCC=1,5,0,2,0,0,0,0'
08/10 15:54:40 yS1 got:[0d][0a]OK[0d]
08/10 15:54:40 yS1 mdm_command: string 'OK' -> OK
08/10 15:54:40 yS1 waiting for line to clear (VTIME), read:
08/10 15:54:40 yS1 removing lock file
08/10 15:54:40 yS1 waiting...
08/10 16:54:40 yS1 select returned 0
08/10 16:54:40 yS1 checking if modem is still alive
08/10 16:54:40 yS1 makelock(ttyS1) called
08/10 16:54:40 yS1 do_makelock: lock='/var/lock/LCK..ttyS1'
08/10 16:54:40 yS1 lock made
08/10 16:54:40 yS1 mdm_send: 'AT'
08/10 16:54:40 yS1 got:[0a]AT[0d]
08/10 16:54:40 yS1 mdm_command: string 'AT'
08/10 16:54:40 yS1 got:[0d][0a]OK[0d]
08/10 16:54:40 yS1 mdm_command: string 'OK' -> OK
08/10 16:54:40 yS1 waiting for line to clear (VTIME), read:
08/10 16:54:41 yS1 removing lock file
08/10 16:54:41 yS1 waiting...
08/10 17:17:11 yS1 select returned 1
08/10 17:17:11 yS1 checking lockfiles, locking the line
08/10 17:17:11 yS1 makelock(ttyS1) called
08/10 17:17:11 yS1 do_makelock: lock='/var/lock/LCK..ttyS1'
08/10 17:17:11 yS1 lock made
08/10 17:17:11 yS1 wfr: waiting for ``RING''
08/10 17:17:11 yS1 got: [0a][0d][0a]RING[0d]
08/10 17:17:11 yS1 CND: RING
08/10 17:17:11 yS1 wfr: rc=0, drn=0
08/10 17:17:11 yS1 send: ATA[0d]
08/10 17:17:11 yS1 waiting for ``CONNECT''
08/10 17:17:11 yS1 got: ATA[0d]
08/10 17:17:11 yS1 CND: OKATA[0d][0a]CONNECT ** found **
08/10 17:17:30 yS1 send:
08/10 17:17:30 yS1 waiting for ``_''
08/10 17:17:30 yS1 got: 19200 NoEC[0d]
08/10 17:17:30 yS1 CND: CONNECT 19200 NoEC
08/10 17:17:30 yS1 CND: found: 19200 NoEC[0a] ** found **
08/10 17:17:30 yS1 waiting for line to clear (VTIME), read:
08/10 17:17:30 yS1 looking for utmp entry... (my PID: 472)
08/10 17:17:30 yS1 utmp + wtmp entry made
08/10 17:17:31 yS1 tio_set_flow_control( HARD )
08/10 17:17:31 yS1 print welcome banner (/etc/issue)
08/10 17:17:31 yS1 getlogname (no opts), read:[ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff
][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff][ff]
08/10 17:18:17 ##### failed dev=ttyS1, pid=472, got signal 1, exiting
08/10 17:18:17 yS1 removing lock file
--- log-faxin-faxonly ---
08/10 15:52:58 yS1 mgetty: experimental test release 1.1.21-Jul24
08/10 15:52:58 yS1 check for lockfiles
08/10 15:52:58 yS1 checklock: stat failed, no file
08/10 15:52:58 yS1 locking the line
08/10 15:52:58 yS1 makelock(ttyS1) called
08/10 15:52:58 yS1 do_makelock: lock='/var/lock/LCK..ttyS1'
08/10 15:52:58 yS1 lock made
08/10 15:52:58 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR
08/10 15:52:58 yS1 lowering DTR to reset Modem
08/10 15:52:59 yS1 tss: set speed to 19200 (016)
08/10 15:52:59 yS1 tio_set_flow_control( HARD )
08/10 15:52:59 yS1 waiting for line to clear (VTIME), read: K[0d][0a]
08/10 15:52:59 yS1 send: \dATQ0V1H0[0d]
08/10 15:52:59 yS1 waiting for ``OK''
08/10 15:52:59 yS1 got: ATQ0V1H0[0d]
08/10 15:52:59 yS1 CND: ATQ0V1H0[0d][0a]OK ** found **
08/10 15:53:00 yS1 send: ATS0=0Q0&D3&C1[0d]
08/10 15:53:00 yS1 waiting for ``OK''
08/10 15:53:00 yS1 got: [0d]
08/10 15:53:00 yS1 CND: OK[0a]ATS0=0Q0&D3&C1[0d]
08/10 15:53:00 yS1 CND: ATS0=0Q0&D3&C1[0d][0a]OK ** found **
08/10 15:53:00 yS1 mdm_send: 'ATI'
08/10 15:53:00 yS1 got:[0d][0a]ATI[0d]
08/10 15:53:00 yS1 got:[0d][0a]AnyCom ECO 56K II PC Card Fax/Modem VER 2.04 [0d]
08/10 15:53:00 yS1 mdm_gis: string 1: 'AnyCom ECO 56K II PC Card Fax/Modem VER 2.04 '
08/10 15:53:00 yS1 got:[0a][0d][0a]OK[0d]
08/10 15:53:00 yS1 mdm_identify: string 'AnyCom ECO 56K II PC Card Fax/Modem VER 2.04 '
08/10 15:53:00 yS1 non-numeric ID string: 'AnyCom ECO 56K II PC Card Fax/Modem VER 2.04 '
08/10 15:53:00 yS1 mdm_send: 'AT+FCLASS=2.0'
08/10 15:53:00 yS1 got:[0a]AT+FCLASS=2.0[0d]
08/10 15:53:00 yS1 mdm_command: string 'AT+FCLASS=2.0'
08/10 15:53:00 yS1 got:[0d][0a]ERROR[0d]
08/10 15:53:00 yS1 mdm_command: string 'ERROR' -> ERROR
08/10 15:53:00 yS1 mdm_send: 'AT+FCLASS=2'
08/10 15:53:00 yS1 got:[0a]AT+FCLASS=2[0d]
08/10 15:53:00 yS1 mdm_command: string 'AT+FCLASS=2'
08/10 15:53:00 yS1 got:[0d][0a]OK[0d]
08/10 15:53:00 yS1 mdm_command: string 'OK' -> OK
08/10 15:53:00 yS1 mdm_send: 'AT+FCLASS=0'
08/10 15:53:00 yS1 got:[0a]AT+FCLASS=0[0d]
08/10 15:53:00 yS1 mdm_command: string 'AT+FCLASS=0'
08/10 15:53:00 yS1 got:[0d][0a]OK[0d]
08/10 15:53:00 yS1 mdm_command: string 'OK' -> OK
08/10 15:53:00 yS1 mdm_send: 'AT+FAA=1;+FCR=1'
08/10 15:53:00 yS1 got:[0a]AT+FAA=1;+FCR=1[0d]
08/10 15:53:00 yS1 mdm_command: string 'AT+FAA=1;+FCR=1'
08/10 15:53:00 yS1 got:[0d][0a]OK[0d]
08/10 15:53:00 yS1 mdm_command: string 'OK' -> OK
08/10 15:53:00 yS1 mdm_send: 'AT+FBOR=0'
08/10 15:53:00 yS1 got:[0a]AT+FBOR=0[0d]
08/10 15:53:00 yS1 mdm_command: string 'AT+FBOR=0'
08/10 15:53:00 yS1 got:[0d][0a]OK[0d]
08/10 15:53:00 yS1 mdm_command: string 'OK' -> OK
08/10 15:53:00 yS1 mdm_send: 'AT+FLID="*Notebook*"'
08/10 15:53:00 yS1 got:[0a]AT+FLID="*Notebook*"[0d]
08/10 15:53:00 yS1 mdm_command: string 'AT+FLID="*Notebook*"'
08/10 15:53:00 yS1 got:[0d][0a]OK[0d]
08/10 15:53:00 yS1 mdm_command: string 'OK' -> OK
08/10 15:53:00 yS1 mdm_send: 'AT+FDCC=1,5,0,2,0,0,0,0'
08/10 15:53:00 yS1 got:[0a]AT+FDCC=1,5,0,2,0,0,0,0[0d]
08/10 15:53:00 yS1 mdm_command: string 'AT+FDCC=1,5,0,2,0,0,0,0'
08/10 15:53:00 yS1 got:[0d][0a]OK[0d]
08/10 15:53:00 yS1 mdm_command: string 'OK' -> OK
08/10 15:53:00 yS1 waiting for line to clear (VTIME), read:
08/10 15:53:00 yS1 removing lock file
08/10 15:53:00 yS1 waiting...
08/10 15:53:40 yS1 select returned 1
08/10 15:53:40 yS1 checking lockfiles, locking the line
08/10 15:53:40 yS1 makelock(ttyS1) called
08/10 15:53:40 yS1 do_makelock: lock='/var/lock/LCK..ttyS1'
08/10 15:53:40 yS1 lock made
08/10 15:53:40 yS1 wfr: waiting for ``RING''
08/10 15:53:40 yS1 got: [0a][0d][0a]RING[0d]
08/10 15:53:40 yS1 CND: RING
08/10 15:53:40 yS1 wfr: rc=0, drn=0
08/10 15:53:40 yS1 send: ATA[0d]
08/10 15:53:40 yS1 waiting for ``CONNECT''
08/10 15:53:40 yS1 got: ATA[0d]
08/10 15:53:40 yS1 CND: OKATA[0d][0a]+FCON
08/10 15:53:53 yS1 found action string: ``+FCON''
08/10 15:53:53 yS1 start fax receiver...
08/10 15:53:53 yS1 fax receiver: entry
08/10 15:53:53 yS1 fax_wait_for(OK)
08/10 15:53:53 yS1 got:[0a][0d][0a][0d][0a]+FTSI:"+49 911 6599596 "[0d]
08/10 15:53:53 yS1 fax_wait_for: string '+FTSI:"+49 911 6599596 "'
08/10 15:53:53 yS1 fax_id: '+FTSI:"+49 911 6599596 "'
08/10 15:53:53 yS1 got:[0a][0d][0a]+FDCS:1,5,0,2,0,0,0,0[0d]
08/10 15:53:53 yS1 fax_wait_for: string '+FDCS:1,5,0,2,0,0,0,0'
08/10 15:53:53 yS1 transmission par.: '+FDCS:1,5,0,2,0,0,0,0'
08/10 15:53:53 yS1 got:[0a][0d][0a]OK[0d]
08/10 15:53:53 yS1 fax_wait_for: string 'OK'** found **
08/10 15:53:53 yS1 looking for utmp entry... (my PID: 464)
08/10 15:53:53 yS1 utmp + wtmp entry made
08/10 15:53:53 yS1 tio_set_flow_control( HARD XON_IN )
08/10 15:53:54 yS1 fax_send: 'AT+FDR'
08/10 15:53:54 yS1 fax_wait_for(CONNECT)
08/10 15:53:54 yS1 got:[0a]AT+FDR[0d]
08/10 15:53:54 yS1 fax_wait_for: string 'AT+FDR'
08/10 15:53:54 yS1 got:[0d][0a]+FCFR[0d]
08/10 15:53:58 yS1 fax_wait_for: string '+FCFR'
08/10 15:53:58 yS1 got:[0a][0d][0a]CONNECT[0d]
08/10 15:53:59 yS1 fax_wait_for: string 'CONNECT'** found **
08/10 15:53:59 yS1 sending DC2
08/10 15:53:59 yS1 fax_get_page_data: wait for EOL, got: [0a][00]
08/10 15:53:59 yS1 fax_get_page_data: receiving /var/spool/fax/incoming/ff7b02ee4S1-+49-911-6599596.01...
08/10 15:54:27 yS1 fax_get_page_data: page end, bytes received: 51059
08/10 15:54:27 yS1 fax_wait_for(OK)
08/10 15:54:27 yS1 got:[0d][0a]+FPTS:1,1660[0d]
08/10 15:54:27 yS1 fax_wait_for: string '+FPTS:1,1660'
08/10 15:54:27 yS1 page status: +FPTS:1,1660
08/10 15:54:27 yS1 got:[0a][0d][0a]+FET:2[0d]
08/10 15:54:33 yS1 fax_wait_for: string '+FET:2'
08/10 15:54:33 yS1 got:[0a][0d][0a]OK[0d]
08/10 15:54:33 yS1 fax_wait_for: string 'OK'** found **
08/10 15:54:33 yS1 fax_send: 'AT+FDR'
08/10 15:54:33 yS1 fax_wait_for(CONNECT)
08/10 15:54:33 yS1 got:[0a]AT+FDR[0d]
08/10 15:54:33 yS1 fax_wait_for: string 'AT+FDR'
08/10 15:54:33 yS1 got:[0d][0a]+FHNG:0[0d]
08/10 15:54:35 yS1 fax_wait_for: string '+FHNG:0'
08/10 15:54:35 yS1 connection hangup: '+FHNG:0'
08/10 15:54:35 yS1 (Normal and proper end of connection)** found **
08/10 15:54:35 yS1 fax receiver: hangup & end
08/10 15:54:35 yS1 fax_notify_mail: sending mail to: faxadmin
08/10 15:54:36 yS1 fax_notify_mail: mailer exit status: 18176_
08/10 15:54:36 yS1 notify: '/usr/local/lib/mgetty+sendfax/new_fax 0 '+49 911 6599596 ' 1
/var/spool/fax/incoming/ff7b02ee4S1-+49-911-6599596.01 >/dev/console 2>&1 </dev/null'
08/10 15:54:36 ##### fax dev=ttyS1, pid=464, caller='none', name='', id='+49 911 6599596 ',
+FHNG=000, pages=1/0, time=00:00:55
08/10 15:54:36 yS1 setenv: 'CALLER_ID=none'
08/10 15:54:36 yS1 setenv: 'CALLED_ID='
08/10 15:54:36 yS1 setenv: 'CONNECT='
08/10 15:54:36 yS1 system() failed: Operation not permitted
08/10 15:54:37 yS1 mdm_send: 'ATH0'
08/10 15:54:37 yS1 got:[0a][0d][0a]OK[0d]
08/10 15:54:37 yS1 mdm_command: string 'OK' -> OK
08/10 15:54:37 yS1 removing lock file
--- log-poll-server ---
08/10 19:19:02 yS1 mgetty: experimental test release 1.1.21-Jul24
08/10 19:19:02 yS1 set modem_quirks: 0x0001
08/10 19:19:02 yS1 check for lockfiles
08/10 19:19:02 yS1 checklock: stat failed, no file
08/10 19:19:02 yS1 locking the line
08/10 19:19:02 yS1 makelock(ttyS1) called
08/10 19:19:02 yS1 do_makelock: lock='/var/lock/LCK..ttyS1'
08/10 19:19:02 yS1 lock made
08/10 19:19:02 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR
08/10 19:19:02 yS1 lowering DTR to reset Modem
08/10 19:19:03 yS1 tss: set speed to 19200 (016)
08/10 19:19:03 yS1 tio_set_flow_control( HARD )
08/10 19:19:03 yS1 waiting for line to clear (VTIME), read: K[0d][0a]
08/10 19:19:03 yS1 send: ATQ0V1E0[0d]
08/10 19:19:03 yS1 waiting for ``OK''
08/10 19:19:03 yS1 got: [0d][0a]OK ** found **
08/10 19:19:03 yS1 send: AT&K3s0=0[0d]
08/10 19:19:03 yS1 waiting for ``OK''
08/10 19:19:03 yS1 got: [0d]
08/10 19:19:03 yS1 CND: OK[0a][0d][0a]OK ** found **
08/10 19:19:03 yS1 mdm_send: 'ATI'
08/10 19:19:03 yS1 got:[0d][0a][0d][0a]AnyCom ECO 56K II PC Card Fax/Modem VER 2.04 [0d]
08/10 19:19:03 yS1 mdm_gis: string 1: 'AnyCom ECO 56K II PC Card Fax/Modem VER 2.04 '
08/10 19:19:03 yS1 got:[0a][0d][0a]OK[0d]
08/10 19:19:03 yS1 mdm_identify: string 'AnyCom ECO 56K II PC Card Fax/Modem VER 2.04 '
08/10 19:19:03 yS1 non-numeric ID string: 'AnyCom ECO 56K II PC Card Fax/Modem VER 2.04 '
08/10 19:19:03 yS1 modem quirks: 0001
08/10 19:19:03 yS1 mdm_send: 'AT+FCLASS=2.0'
08/10 19:19:03 yS1 got:[0a][0d][0a]ERROR[0d]
08/10 19:19:03 yS1 mdm_command: string 'ERROR' -> ERROR
08/10 19:19:03 yS1 mdm_send: 'AT+FCLASS=2'
08/10 19:19:03 yS1 got:[0a][0d][0a]OK[0d]
08/10 19:19:03 yS1 mdm_command: string 'OK' -> OK
08/10 19:19:03 yS1 mdm_send: 'AT+FAA=1;+FCR=1'
08/10 19:19:03 yS1 got:[0a][0d][0a]OK[0d]
08/10 19:19:03 yS1 mdm_command: string 'OK' -> OK
08/10 19:19:03 yS1 mdm_send: 'AT+FBOR=0'
08/10 19:19:03 yS1 got:[0a][0d][0a]OK[0d]
08/10 19:19:03 yS1 mdm_command: string 'OK' -> OK
08/10 19:19:03 yS1 mdm_send: 'AT+FLID="987654321"'
08/10 19:19:03 yS1 got:[0a][0d][0a]OK[0d]
08/10 19:19:03 yS1 mdm_command: string 'OK' -> OK
08/10 19:19:03 yS1 mdm_send: 'AT+FDCC=1,5,0,2,0,0,0,0'
08/10 19:19:03 yS1 got:[0a][0d][0a]OK[0d]
08/10 19:19:03 yS1 mdm_command: string 'OK' -> OK
08/10 19:19:04 yS1 mdm_send: 'AT+FLPL=1'
08/10 19:19:04 yS1 got:[0a][0d][0a]ERROR[0d]
08/10 19:19:04 yS1 mdm_command: string 'ERROR' -> ERROR
08/10 19:19:04 yS1 faxpoll_server_init: no polling available
08/10 19:19:04 yS1 waiting for line to clear (VTIME), read:
08/10 19:19:04 yS1 removing lock file
08/10 19:19:04 yS1 waiting...
08/10 19:19:20 yS1 select returned 1
08/10 19:19:20 yS1 checking lockfiles, locking the line
08/10 19:19:20 yS1 makelock(ttyS1) called
08/10 19:19:20 yS1 do_makelock: lock='/var/lock/LCK..ttyS1'
08/10 19:19:20 yS1 lock made
08/10 19:19:20 yS1 wfr: waiting for ``RING''
08/10 19:19:20 yS1 got: [0a][0d][0a]RING[0d]
08/10 19:19:20 yS1 CND: RING
08/10 19:19:20 yS1 wfr: rc=0, drn=0
08/10 19:19:20 yS1 send: ATA[0d]
08/10 19:19:20 yS1 waiting for ``CONNECT''
08/10 19:19:20 yS1 got: [0d]
08/10 19:20:06 yS1 CND: OK[0a]+FHNG:
08/10 19:20:06 yS1 found action string: ``+FHNG:''
08/10 19:20:06 ##### failed A_FAIL dev=ttyS1, pid=539, caller='none', conn='', name=''
08/10 19:20:06 yS1 removing lock file
--- log-poll-client ---
08/10 19:24:16 sendfax: experimental test release 1.1.21-Jul24
08/10 19:24:16 sendfax.c compiled at Aug 10 1999, 13:23:04
08/10 19:24:16 sending fax to *12
08/10 19:24:16 makelock(ttyS1) called
08/10 19:24:16 do_makelock: lock='/var/lock/LCK..ttyS1'
08/10 19:24:16 lock made
08/10 19:24:16 tss: set speed to 38400 (017)
08/10 19:24:16 tio_set_flow_control( HARD )
08/10 19:24:16 yS1 fax_open_device succeeded, ttyS1 -> 4
08/10 19:24:16 yS1 reading specific data for port 'ttyS1'
08/10 19:24:16 yS1 reading /usr/local/etc/mgetty+sendfax/sendfax.config...
08/10 19:24:16 yS1 conf lib: read: 'verbose y'
08/10 19:24:16 yS1 conf lib: read: 'debug 9'
08/10 19:24:16 yS1 conf lib: read: 'fax-devices ttyS1:ttyS0'
08/10 19:24:16 yS1 conf lib: read: 'fax-id 987654321'
08/10 19:24:16 yS1 conf lib: read: 'dial-prefix ATX3DT'
08/10 19:24:16 yS1 conf lib: read: 'max-tries 3'
08/10 19:24:16 yS1 conf lib: read: 'max-tries-continue y'
08/10 19:24:16 yS1 key: 'fax-devices', type=1, flags=4, data=(ignored)
08/10 19:24:16 yS1 key: 'modem-init', type=1, flags=0, data=(empty)
08/10 19:24:16 yS1 key: 'modem-handshake', type=1, flags=0, data=(empty)
08/10 19:24:16 yS1 key: 'modem-type', type=1, flags=1, data=auto
08/10 19:24:16 yS1 key: 'modem-quirks', type=0, flags=0, data=(empty)
08/10 19:24:16 yS1 key: 'fax-send-flow', type=4, flags=1, data=7
08/10 19:24:16 yS1 key: 'fax-rec-flow', type=4, flags=1, data=7
08/10 19:24:16 yS1 key: 'max-tries', type=0, flags=3, data=3
08/10 19:24:16 yS1 key: 'max-tries-continue', type=3, flags=3, data=TRUE
08/10 19:24:16 yS1 key: 'speed', type=0, flags=1, data=38400
08/10 19:24:16 yS1 key: 'switchbd', type=0, flags=1, data=0
08/10 19:24:16 yS1 key: 'open-delay', type=0, flags=0, data=(empty)
08/10 19:24:16 yS1 key: 'ignore-carrier', type=3, flags=1, data=TRUE
08/10 19:24:16 yS1 key: 'dial-prefix', type=1, flags=3, data=ATX3DT
08/10 19:24:16 yS1 key: 'fax-id', type=1, flags=3, data=987654321
08/10 19:24:16 yS1 key: 'poll-dir', type=1, flags=1, data=.
08/10 19:24:16 yS1 key: 'normal-res', type=3, flags=1, data=FALSE
08/10 19:24:16 yS1 key: 'fax-min-speed', type=0, flags=1, data=0
08/10 19:24:16 yS1 key: 'fax-max-speed', type=0, flags=1, data=14400
08/10 19:24:16 yS1 key: 'debug', type=0, flags=3, data=9
08/10 19:24:16 yS1 key: 'verbose', type=3, flags=3, data=TRUE
08/10 19:24:16 yS1 key: '', type=3, flags=2, data=TRUE
08/10 19:24:16 yS1 key: 'page-header', type=1, flags=0, data=(empty)
08/10 19:24:16 yS1 key: '', type=3, flags=1, data=FALSE
08/10 19:24:16 yS1 key: '', type=3, flags=1, data=FALSE
08/10 19:24:16 yS1 key: '', type=1, flags=1, data=
08/10 19:24:16 yS1 tss: set speed to 38400 (017)
08/10 19:24:16 yS1 mdm_send: 'ATV1Q0'
08/10 19:24:16 yS1 got:[0d][0a]OK[0d]
08/10 19:24:16 yS1 mdm_command: string 'OK' -> OK
08/10 19:24:16 yS1 mdm_send: 'ATI'
08/10 19:24:16 yS1 got:[0a][0d][0a]AnyCom ECO 56K II PC Card Fax/Modem VER 2.04 [0d]
08/10 19:24:16 yS1 mdm_gis: string 1: 'AnyCom ECO 56K II PC Card Fax/Modem VER 2.04 '
08/10 19:24:16 yS1 got:[0a][0d][0a]OK[0d]
08/10 19:24:16 yS1 mdm_identify: string 'AnyCom ECO 56K II PC Card Fax/Modem VER 2.04 '
08/10 19:24:16 yS1 non-numeric ID string: 'AnyCom ECO 56K II PC Card Fax/Modem VER 2.04 '
08/10 19:24:16 yS1 mdm_send: 'AT+FCLASS=2.0'
08/10 19:24:16 yS1 got:[0a][0d][0a]ERROR[0d]
08/10 19:24:16 yS1 mdm_command: string 'ERROR' -> ERROR 08/10 19:24:16 yS1 mdm_send: 'AT+FCLASS=2'
08/10 19:24:16 yS1 got:[0a][0d][0a]OK[0d]
08/10 19:24:16 yS1 mdm_command: string 'OK' -> OK
08/10 19:24:16 yS1 mdm_send: 'AT+FLID="987654321"'
08/10 19:24:16 yS1 got:[0a][0d][0a]OK[0d]
08/10 19:24:16 yS1 mdm_command: string 'OK' -> OK
08/10 19:24:16 yS1 mdm_send: 'AT+FDCC=1,5,0,2,0,0,0,0'
08/10 19:24:16 yS1 got:[0a][0d][0a]OK[0d]
08/10 19:24:16 yS1 mdm_command: string 'OK' -> OK
08/10 19:24:16 yS1 mdm_send: 'AT+FBOR=0'
08/10 19:24:16 yS1 got:[0a][0d][0a]OK[0d]
08/10 19:24:16 yS1 mdm_command: string 'OK' -> OK
08/10 19:24:16 yS1 mdm_send: 'AT+FCIG="987654321"'
08/10 19:24:16 yS1 got:[0a][0d][0a]ERROR[0d]
08/10 19:24:16 yS1 mdm_command: string 'ERROR' -> ERROR
08/10 19:24:16 yS1 cannot enable polling
08/10 19:24:17 yS1 fax_send: 'ATX3DT*12'
08/10 19:24:17 yS1 fax_wait_for(OK)
08/10 19:24:17 yS1 got:[0a]
[0d][0a]+FHNG:20[0d]
08/10 19:24:41 yS1 fax_wait_for: string '+FHNG:20'
08/10 19:24:41 yS1 connection hangup: '+FHNG:20'
08/10 19:24:41 yS1 (Unspecified Transmit Phase B error)
08/10 19:24:41 yS1 got:[0a][0d][0a]OK[0d]
08/10 19:24:42 yS1 fax_wait_for: string 'OK'** found **
08/10 19:24:42 ##### failed dialing, phone="*12", +FHS:20, dev=ttyS1, time=26s, acct=""
08/10 19:24:42 yS1 fax_send: 'AT+FCLASS=0'
08/10 19:24:43 yS1 removing lock file