mgetty Stalled when Printing /etc/issue.net

kwong (hingkwongyu@cuhk.edu.hk)
Tue, 20 Apr 1999 05:00:18 +0000


This is a multi-part message in MIME format.
--------------97176538AAFDD0C7B869EC16
Content-Type: multipart/alternative;
 boundary="------------F9187568694B578E5D497099"


--------------F9187568694B578E5D497099
Content-Type: text/plain; charset=us-ascii
Content-Transfer-Encoding: 7bit

Hi, everybody,

I 'm running Redhat 5.1 with kernel 2.0.36-7 on a Dell OptiPlex GXi  PC
- an Intel 200 MHzs Pentium Box with 32MB  RAM.  Trying to setup a
dial-in  data connection with my home PC - another Pentium
Box , using "minicom " as  my dial-in  communication program/package.
On the server side,  Zoltrix High-Speed (14.4kbs) Fax/Modem  card  is
used , where on the calling side, Speed 56k flex external
modem is connected to my home PC - the client in this case.

The dial-in process is quite  smooth  until  "mgetty" is printing out
the /etc/issue.net file, to my home PC  at the moment that after  the
'answer-chat ' -->  ""  ATA\r  CONNECT  \c   <--  and before the  '
login prompt ' is given.

What a mercy if  someone could give hints to solve my problem ?

P.S.   Log file with only 2 invocations of the dial-in process,
/var/log_mg.ttyS1.mgetty,  and
           configuration file for mgetty,
/etc/mgetty+sendfax/mgetty.config is attached for your info.

           I'm please and ready to render further information on your
specific requests.

End of E-mail
NNNN

--------------F9187568694B578E5D497099
Content-Type: text/html; charset=us-ascii
Content-Transfer-Encoding: 7bit

<!doctype html public "-//w3c//dtd html 4.0 transitional//en">
Hi, everybody,

I 'm running Redhat 5.1 with kernel 2.0.36-7 on a Dell OptiPlex GXi  PC - an Intel 200 MHzs Pentium Box with 32MB  RAM.  Trying to setup a dial-in  data connection with my home PC - another Pentium
Box , using "minicom " as  my dial-in  communication program/package.  On the server side,  Zoltrix High-Speed (14.4kbs) Fax/Modem  card  is  used , where on the calling side, Speed 56k flex external
modem is connected to my home PC - the client in this case.

The dial-in process is quite  smooth  until  "mgetty" is printing out the /etc/issue.net file, to my home PC  at the moment that after  the  'answer-chat ' -->  ""  ATA\r  CONNECT  \c   <--  and before the  ' login prompt ' is given.

What a mercy if  someone could give hints to solve my problem ?

P.S.   Log file with only 2 invocations of the dial-in process, /var/log_mg.ttyS1.mgetty,  and
           configuration file for mgetty, /etc/mgetty+sendfax/mgetty.config is attached for your info.

           I'm please and ready to render further information on your specific requests.

End of E-mail
NNNN --------------F9187568694B578E5D497099-- --------------97176538AAFDD0C7B869EC16 Content-Type: text/plain; charset=us-ascii; name="mgetty.config" Content-Transfer-Encoding: 7bit Content-Disposition: inline; filename="mgetty.config" # # mgetty configuration file # # this is a sample configuration file, see mgetty.info for details # # comment lines start with a "#", empty lines are ignored # ----- global section ----- # # In this section, you put the global defaults, per-port stuff is below # set the global debug level to "4" (default from policy.h) debug 4 # set the local fax station id ##fax-id 49 89 xxxxxxxx # access the modem(s) with 38400 bps speed 38400 # use these options to make the /dev/tty-device owned by "uucp.uucp" # and mode "rw-rw-r--" (0664). *LEADING ZERO NEEDED!* port-owner uucp port-group uucp port-mode 0664 # use these options to make incoming faxes owned by "root.uucp" # and mode "rw-r-----" (0640). *LEADING ZERO NEEDED!* #fax-owner root #fax-group uucp #fax-mode 0640 # ----- port specific section ----- # # Here you can put things that are valid only for one line, not the others # ## Zoltrix High-Speed (14.4k bts) Fax/Modem, try data only : (max. speed 19200) port ttyS1 ## debug 9 data-only y speed 9600 ## --> Settings suggested by faqsample.config <-- ## modem-type data login-time 160 issue-file /etc/issue.net ## login-prompt \D\t\I\S\n\r answer-chat "" ATA CONNECT \c ## answer-chat "" AT&D0S0=1 CONNECT \c answer-chat-timeout 100 # Got this init chat from Len Ovens (len@studio.cbbs.org). # You need the init-chat even for *dial-in*. This is the recommended way # to init your modem. ## init-chat "" \d\d\d+++\d\d\dAT&F2w0s7=60s95=6MH#CID=0 OK <--SupraFax Modem only ## ## <<<<<<<<<<<<<<<<<<<<<< End of faqsample.config >>>>>>>>>>>>>>>>>>>>>>>>>>>> ## ##-2 to 3>>init-chat "" AT&F&C1&D2S95=3\r OK\r AT&K3\r OK\r init-chat "" \d\d\d+++\d\d\dAT&F&C1&D1S95=3\r OK\r AT&K3W0S7=60\r OK\r ## init-chat "" \d[10][03]\d\d\d+++\d\d\d[0d]AT&F&C1&D2S95=3\sH0[0d] OK\r AT&K3\r OK\r ## init-chat "" ATZ0\r OK\r\n ATM0\sE1\sQ0\sV1\sX4\r OK\r AT&K3\r OK\r\n ## -------- Some options for Rockwell Chip used by MODEM -------- ## ## speed 38400 ## switchbd 19200 ignore-carrier y toggle-dtr n ## login-time 300 ## prompt-waittime 2000 ## answer-chat-timeout 80 ## ------ Some explanation on AT-commands and escape-characters ------ ## ## S0=0|1|2|3\... Set number of ringings (RING) to be counted/waited for ## ## &C0 Data Carrier-signal Detected (DCD) from remote MODEM is ignored/detected ## (assumed active/ON) ## ## &D0 Data Terminal Ready (DTR) from local DTE is ignored/ready (assumed active/ON) ## ## \s ASCII , not a character forming part of AT-command, used for easy reading ## ## \r and \n ASCII and , not a character ..., used for ... ## ## \c ASCII , not a character ..., used to prevent ## being typed or interpreted ... ## ## -->answer-chat "" ATA\r CONNECT \c \r<-- ##(Apl.14,noon) #### Some explanation for the serial interface/port. ## &C0-->DCD State of carrier from remote modem is ignored, DCD is always on. ## &C1-->DCD turns on when the remote modem carrier signal is detected, and ## turns off when not detected. ## &D0-->DTR is ignored by the modem ; &D1-->Go to command mode on on-to-off. ## &D2-->Hung up and go to command mode on on-to-off DTR transition. Auto- ## answer is disabled if DTR is keeping low. ##-1>>answer-chat "" AT&C1\s&D0\r OK\r ATA\r CONNECT \c \r ##-2 to 2a>>answer-chat "" AT&C1\s&D1\r OK\r ATA\r CONNECT ##answer-chat "" AT&C0\s&D1\r OK\r ATA\r CONNECT\c ## answer-chat "" AT&C1\s&D1\r OK\r ATS0=1\r CONNECT \c \r term vt100 ###################################################################################### # direct connection of a VT100 terminal which doesn't like DTR drops # port ttyS0 direct y # speed 19200 speed 115200 ## toggle-dtr n ignore-carrier y login-time 160 issue-file /etc/issue.net login-prompt Dell-hkpc\t\t\D\t\I-LINE\t\S bps\n\rEnter your username: --------------97176538AAFDD0C7B869EC16 Content-Type: text/plain; charset=iso-8859-1; name="log_mg.ttyS1.mgetty" Content-Transfer-Encoding: quoted-printable Content-Disposition: inline; filename="log_mg.ttyS1.mgetty" ### Started on Apl.19, 1999 after 17:15hrs ### Debug level 9 -- 04/20 07:35:09 yS1 mgetty: experimental test release 1.1.14-Apr02 04/20 07:35:09 yS1 check for lockfiles 04/20 07:35:09 yS1 checklock: no active process has lock, will remove 04/20 07:35:09 yS1 locking the line 04/20 07:35:09 yS1 makelock(ttyS1) called 04/20 07:35:09 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:35:09 yS1 lock made 04/20 07:35:09 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR DCD 04/20 07:35:09 yS1 WARNING: DCD line still active, check modem settings = (AT&Dx) 04/20 07:35:09 yS1 tss: set speed to 9600 (015) 04/20 07:35:09 yS1 tio_set_flow_control( HARD ) 04/20 07:35:09 yS1 waiting for line to clear (VTIME), read: [16][10][02= ]"[01][02][01][06][01][00][00][00][00][ff][02][01][03][03][01][08][04][02= ]@[00][08][01][93][09][01][1d][0c][02][03]=3D[0d][02][ff][ff][10][03][c8]= v 04/20 07:35:10 yS1 send: \d\d\d+++\d\d\dAT&F&C1&D0S95=3D3[0d][0d] 04/20 07:35:13 yS1 waiting for ``OK_'' 04/20 07:35:13 yS1 got: [16][10][02]"[01][02][01][06][01][00][00][00][0= 0][ff][02][01][03][03][01][08][04][02]@[00][08][01][93][09][01][1d][0c][0= 2][03]=3D[0d] 04/20 07:35:13 yS1 CND: ___"_____[02][ff][ff][10][03][c8]v[16][10][02]= "[01][02][01][06][01][00][00][00][00][ff][02][01][03][03][01][08][04][02]= @[00][08][01][93][09][01][1d][0c][02][03]=3D[0d] 04/20 07:35:13 yS1 CND: ______v___"_____[02][ff][ff][10][03][c8]v[0d] 04/20 07:35:13 yS1 CND: ______v[0a]OK[0d] 04/20 07:35:13 yS1 CND: OK ** found ** 04/20 07:35:13 yS1 send: AT&K3W0S7=3D60[0d][0d] 04/20 07:35:13 yS1 waiting for ``OK_'' 04/20 07:35:13 yS1 got: [0a]AT&F&C1&D0S95=3D3[0d] 04/20 07:35:13 yS1 CND: AT&F&C1&D0S95=3D3[0d]AT&K3W0S7=3D60[0d] 04/20 07:35:13 yS1 CND: AT&K3W0S7=3D60[0d][0d][0a]ERROR 04/20 07:35:13 yS1 found action string: ``ERROR'' 04/20 07:35:13 yS1 init chat failed, exiting...: Invalid argument 04/20 07:35:13 ##### failed in mg_init_data, dev=3DttyS1, pid=3D1584 04/20 07:35:13 yS1 removing lock file -- 04/20 07:35:13 yS1 mgetty: experimental test release 1.1.14-Apr02 04/20 07:35:13 yS1 check for lockfiles 04/20 07:35:13 yS1 checklock: stat failed, no file 04/20 07:35:13 yS1 locking the line 04/20 07:35:13 yS1 makelock(ttyS1) called 04/20 07:35:13 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:35:13 yS1 lock made 04/20 07:35:13 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR DCD 04/20 07:35:13 yS1 WARNING: DCD line still active, check modem settings = (AT&Dx) 04/20 07:35:13 yS1 tss: set speed to 9600 (015) 04/20 07:35:13 yS1 tio_set_flow_control( HARD ) 04/20 07:35:13 yS1 waiting for line to clear (VTIME), read: = 04/20 07:35:14 yS1 send: \d\d\d+++\d\d\dAT&F&C1&D0S95=3D3[0d][0d] 04/20 07:35:17 yS1 waiting for ``OK_'' 04/20 07:35:17 yS1 got: +++AT&F&C1&D0S95=3D3[0d] 04/20 07:35:17 yS1 CND: +++AT&F&C1&D0S95=3D3[0d][0d][0a]ERROR 04/20 07:35:17 yS1 found action string: ``ERROR'' 04/20 07:35:17 yS1 init chat failed, exiting...: Invalid argument 04/20 07:35:17 ##### failed in mg_init_data, dev=3DttyS1, pid=3D1585 04/20 07:35:17 yS1 removing lock file -- 04/20 07:35:17 yS1 mgetty: experimental test release 1.1.14-Apr02 04/20 07:35:17 yS1 check for lockfiles 04/20 07:35:17 yS1 checklock: stat failed, no file 04/20 07:35:17 yS1 locking the line 04/20 07:35:17 yS1 makelock(ttyS1) called 04/20 07:35:17 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:35:17 yS1 lock made 04/20 07:35:17 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR DCD 04/20 07:35:17 yS1 WARNING: DCD line still active, check modem settings = (AT&Dx) 04/20 07:35:17 yS1 tss: set speed to 9600 (015) 04/20 07:35:17 yS1 tio_set_flow_control( HARD ) 04/20 07:35:17 yS1 waiting for line to clear (VTIME), read: = 04/20 07:35:17 yS1 send: \d\d\d+++\d\d\dAT&F&C1&D0S95=3D3[0d][0d] 04/20 07:35:21 yS1 waiting for ``OK_'' 04/20 07:35:21 yS1 got: +++AT&F&C1&D0S95=3D3[0d] 04/20 07:35:21 yS1 CND: +++AT&F&C1&D0S95=3D3[0d][0d][0a]ERROR 04/20 07:35:21 yS1 found action string: ``ERROR'' 04/20 07:35:21 yS1 init chat failed, exiting...: Invalid argument 04/20 07:35:21 ##### failed in mg_init_data, dev=3DttyS1, pid=3D1586 04/20 07:35:21 yS1 removing lock file -- 04/20 07:35:21 yS1 mgetty: experimental test release 1.1.14-Apr02 04/20 07:35:21 yS1 check for lockfiles 04/20 07:35:21 yS1 checklock: stat failed, no file 04/20 07:35:21 yS1 locking the line 04/20 07:35:21 yS1 makelock(ttyS1) called 04/20 07:35:21 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:35:21 yS1 lock made 04/20 07:35:21 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR DCD 04/20 07:35:21 yS1 WARNING: DCD line still active, check modem settings = (AT&Dx) 04/20 07:35:21 yS1 tss: set speed to 9600 (015) 04/20 07:35:21 yS1 tio_set_flow_control( HARD ) 04/20 07:35:21 yS1 waiting for line to clear (VTIME), read: = 04/20 07:35:21 yS1 send: \d\d\d+++\d\d\dAT&F&C1&D0S95=3D3[0d][0d] 04/20 07:35:24 yS1 waiting for ``OK_'' 04/20 07:35:24 yS1 got: +++AT&F&C1&D0S95=3D3[0d] 04/20 07:35:24 yS1 CND: +++AT&F&C1&D0S95=3D3[0d][0d][0a]ERROR 04/20 07:35:25 yS1 found action string: ``ERROR'' 04/20 07:35:25 yS1 init chat failed, exiting...: Invalid argument 04/20 07:35:25 ##### failed in mg_init_data, dev=3DttyS1, pid=3D1587 04/20 07:35:25 yS1 removing lock file -- 04/20 07:35:25 yS1 mgetty: experimental test release 1.1.14-Apr02 04/20 07:35:25 yS1 check for lockfiles 04/20 07:35:25 yS1 checklock: stat failed, no file 04/20 07:35:25 yS1 locking the line 04/20 07:35:25 yS1 makelock(ttyS1) called 04/20 07:35:25 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:35:25 yS1 lock made 04/20 07:35:25 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR DCD 04/20 07:35:25 yS1 WARNING: DCD line still active, check modem settings = (AT&Dx) 04/20 07:35:25 yS1 tss: set speed to 9600 (015) 04/20 07:35:25 yS1 tio_set_flow_control( HARD ) 04/20 07:35:25 yS1 waiting for line to clear (VTIME), read: = 04/20 07:35:25 yS1 send: \d\d\d+++\d\d\dAT&F&C1&D0S95=3D3[0d][0d] 04/20 07:35:28 yS1 waiting for ``OK_'' 04/20 07:35:28 yS1 got: +++AT&F&C1&D0S95=3D3[0d] 04/20 07:35:28 yS1 CND: +++AT&F&C1&D0S95=3D3[0d][0d][0a]ERROR 04/20 07:35:29 yS1 found action string: ``ERROR'' 04/20 07:35:29 yS1 init chat failed, exiting...: Invalid argument 04/20 07:35:29 ##### failed in mg_init_data, dev=3DttyS1, pid=3D1588 04/20 07:35:29 yS1 removing lock file -- 04/20 07:35:29 yS1 mgetty: experimental test release 1.1.14-Apr02 04/20 07:35:29 yS1 check for lockfiles 04/20 07:35:29 yS1 checklock: stat failed, no file 04/20 07:35:29 yS1 locking the line 04/20 07:35:29 yS1 makelock(ttyS1) called 04/20 07:35:29 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:35:29 yS1 lock made 04/20 07:35:29 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR DCD 04/20 07:35:29 yS1 WARNING: DCD line still active, check modem settings = (AT&Dx) 04/20 07:35:29 yS1 tss: set speed to 9600 (015) 04/20 07:35:29 yS1 tio_set_flow_control( HARD ) 04/20 07:35:29 yS1 waiting for line to clear (VTIME), read: = 04/20 07:35:29 yS1 send: \d\d\d+++\d\d\dAT&F&C1&D0S95=3D3[0d][0d] 04/20 07:35:32 yS1 waiting for ``OK_'' 04/20 07:35:32 yS1 got: +++AT&F&C1&D0S95=3D3[0d] 04/20 07:35:32 yS1 CND: +++AT&F&C1&D0S95=3D3[0d][0d][0a]ERROR 04/20 07:35:32 yS1 found action string: ``ERROR'' 04/20 07:35:32 yS1 init chat failed, exiting...: Invalid argument 04/20 07:35:32 ##### failed in mg_init_data, dev=3DttyS1, pid=3D1589 04/20 07:35:32 yS1 removing lock file -- 04/20 07:35:32 yS1 mgetty: experimental test release 1.1.14-Apr02 04/20 07:35:32 yS1 check for lockfiles 04/20 07:35:32 yS1 checklock: stat failed, no file 04/20 07:35:32 yS1 locking the line 04/20 07:35:32 yS1 makelock(ttyS1) called 04/20 07:35:32 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:35:32 yS1 lock made 04/20 07:35:33 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR DCD 04/20 07:35:33 yS1 WARNING: DCD line still active, check modem settings = (AT&Dx) 04/20 07:35:33 yS1 tss: set speed to 9600 (015) 04/20 07:35:33 yS1 tio_set_flow_control( HARD ) 04/20 07:35:33 yS1 waiting for line to clear (VTIME), read: = 04/20 07:35:33 yS1 send: \d\d\d+++\d\d\dAT&F&C1&D0S95=3D3[0d][0d] 04/20 07:35:36 yS1 waiting for ``OK_'' 04/20 07:35:36 yS1 got: [0d][0a]NO CARRIER 04/20 07:35:36 yS1 found action string: ``NO CARRIER'' 04/20 07:35:36 yS1 init chat failed, exiting...: Invalid argument 04/20 07:35:36 ##### failed in mg_init_data, dev=3DttyS1, pid=3D1590 04/20 07:35:36 yS1 removing lock file -- 04/20 07:35:36 yS1 mgetty: experimental test release 1.1.14-Apr02 04/20 07:35:36 yS1 check for lockfiles 04/20 07:35:36 yS1 checklock: stat failed, no file 04/20 07:35:36 yS1 locking the line 04/20 07:35:36 yS1 makelock(ttyS1) called 04/20 07:35:36 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:35:36 yS1 lock made 04/20 07:35:37 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR 04/20 07:35:37 yS1 tss: set speed to 9600 (015) 04/20 07:35:37 yS1 tio_set_flow_control( HARD ) 04/20 07:35:37 yS1 waiting for line to clear (VTIME), read: = 04/20 07:35:37 yS1 send: \d\d\d+++\d\d\dAT&F&C1&D0S95=3D3[0d][0d] 04/20 07:35:40 yS1 waiting for ``OK_'' 04/20 07:35:40 yS1 got: +++AT&F&C1&D0S95=3D3[0d] 04/20 07:35:40 yS1 CND: +++AT&F&C1&D0S95=3D3[0d][0d][0a]OK[0d] 04/20 07:35:40 yS1 CND: OK ** found ** 04/20 07:35:40 yS1 send: AT&K3W0S7=3D60[0d][0d] 04/20 07:35:40 yS1 waiting for ``OK_'' 04/20 07:35:40 yS1 got: [0a]AT&K3W0S7=3D60[0d] 04/20 07:35:40 yS1 CND: AT&K3W0S7=3D60[0d][0d][0a]OK[0d] 04/20 07:35:40 yS1 CND: OK ** found ** 04/20 07:35:40 yS1 waiting for line to clear (VTIME), read: [0a] 04/20 07:35:41 yS1 removing lock file 04/20 07:35:41 yS1 waiting... #### Set "AT&D1" to replace "AT&D0" in "init-chat" of configuration file #### /etc/mgetty+sendfax/mgetty.config : - 04/20 07:49:21 yS1 select returned 1 04/20 07:49:21 yS1 checking lockfiles, locking the line 04/20 07:49:21 yS1 makelock(ttyS1) called 04/20 07:49:21 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:49:21 yS1 lock not made: lock file exists (pid=3D1610) 04/20 07:49:21 yS1 lock file exists (dialout)! 04/20 07:49:21 yS1 lockfile found, pid=3D1610 04/20 07:49:21 yS1 looking for utmp entry... (my PID: 1591) 04/20 07:49:21 yS1 utmp + wtmp entry made 04/20 07:49:21 yS1 lockfile found, pid=3D1610 04/20 07:49:31 yS1 lockfile found, pid=3D1610 04/20 07:49:41 yS1 lockfile found, pid=3D1610 04/20 07:49:51 yS1 checklock: stat failed, no file 04/20 07:49:56 yS1 checklock: stat failed, no file -- 04/20 07:49:56 yS1 mgetty: experimental test release 1.1.14-Apr02 04/20 07:49:56 yS1 check for lockfiles 04/20 07:49:56 yS1 checklock: stat failed, no file 04/20 07:49:56 yS1 locking the line 04/20 07:49:56 yS1 makelock(ttyS1) called 04/20 07:49:56 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:49:56 yS1 lock made 04/20 07:49:57 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR 04/20 07:49:57 yS1 tss: set speed to 9600 (015) 04/20 07:49:57 yS1 tio_set_flow_control( HARD ) 04/20 07:49:57 yS1 waiting for line to clear (VTIME), read: = 04/20 07:49:57 yS1 send: \d\d\d+++\d\d\dAT&F&C1&D1S95=3D3[0d][0d] 04/20 07:50:00 yS1 waiting for ``OK_'' 04/20 07:50:00 yS1 got: +++AT&F&C1&D1S95=3D3[0d] 04/20 07:50:00 yS1 CND: +++AT&F&C1&D1S95=3D3[0d][0d][0a]OK[0d] 04/20 07:50:00 yS1 CND: OK ** found ** 04/20 07:50:00 yS1 send: AT&K3W0S7=3D60[0d][0d] 04/20 07:50:00 yS1 waiting for ``OK_'' 04/20 07:50:00 yS1 got: [0a]AT&K3W0S7=3D60[0d] 04/20 07:50:00 yS1 CND: AT&K3W0S7=3D60[0d][0d][0a]OK[0d] 04/20 07:50:00 yS1 CND: OK ** found ** 04/20 07:50:00 yS1 waiting for line to clear (VTIME), read: [0a] 04/20 07:50:00 yS1 removing lock file 04/20 07:50:00 yS1 waiting... 04/20 07:50:22 yS1 select returned 1 04/20 07:50:22 yS1 checking lockfiles, locking the line 04/20 07:50:22 yS1 makelock(ttyS1) called 04/20 07:50:22 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:50:22 yS1 lock made 04/20 07:50:22 yS1 waiting for ``RING'' 04/20 07:50:22 yS1 got: [0d][0a]RING ** found ** 04/20 07:50:22 yS1 send: ATA[0d] 04/20 07:50:22 yS1 waiting for ``CONNECT'' 04/20 07:50:22 yS1 got: [0d] 04/20 07:50:22 yS1 CND: RING[0a]ATA[0d] 04/20 07:50:22 yS1 CND: ATA[ff][0a] 04/20 07:50:27 yS1 CND: _[0a] 04/20 07:52:02 yS1 timeout in chat script, waiting for `CONNECT' 04/20 07:52:02 ##### failed timeout dev=3DttyS1, pid=3D1612, caller=3D'no= ne', conn=3D'', name=3D'' 04/20 07:52:02 yS1 removing lock file -- 04/20 07:52:02 yS1 mgetty: experimental test release 1.1.14-Apr02 04/20 07:52:02 yS1 check for lockfiles 04/20 07:52:02 yS1 checklock: stat failed, no file 04/20 07:52:02 yS1 locking the line 04/20 07:52:02 yS1 makelock(ttyS1) called 04/20 07:52:02 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:52:02 yS1 lock made 04/20 07:52:02 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR 04/20 07:52:02 yS1 tss: set speed to 9600 (015) 04/20 07:52:02 yS1 tio_set_flow_control( HARD ) 04/20 07:52:02 yS1 waiting for line to clear (VTIME), read: = 04/20 07:52:02 yS1 send: \d\d\d+++\d\d\dAT&F&C1&D1S95=3D3[0d][0d] 04/20 07:52:05 yS1 waiting for ``OK_'' 04/20 07:52:05 yS1 got: +++AT&F&C1&D1S95=3D3[0d] 04/20 07:52:06 yS1 CND: +++AT&F&C1&D1S95=3D3[0d][0d][0a]OK[0d] 04/20 07:52:06 yS1 CND: OK ** found ** 04/20 07:52:06 yS1 send: AT&K3W0S7=3D60[0d][0d] 04/20 07:52:06 yS1 waiting for ``OK_'' 04/20 07:52:06 yS1 got: [0a]AT&K3W0S7=3D60[0d] 04/20 07:52:06 yS1 CND: AT&K3W0S7=3D60[0d][0d][0a]OK[0d] 04/20 07:52:06 yS1 CND: OK ** found ** 04/20 07:52:06 yS1 waiting for line to clear (VTIME), read: [0a] 04/20 07:52:06 yS1 removing lock file 04/20 07:52:06 yS1 waiting... 04/20 07:54:55 yS1 select returned 1 04/20 07:54:55 yS1 checking lockfiles, locking the line 04/20 07:54:55 yS1 makelock(ttyS1) called 04/20 07:54:55 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:54:55 yS1 lock made 04/20 07:54:55 yS1 waiting for ``RING'' 04/20 07:54:55 yS1 got: [0d][0a]RING ** found ** 04/20 07:54:55 yS1 send: ATA[0d] 04/20 07:54:55 yS1 waiting for ``CONNECT'' 04/20 07:54:55 yS1 got: [0d] 04/20 07:54:55 yS1 CND: RING[0a]ATA[0d] 04/20 07:54:55 yS1 CND: ATA[ff][0a] 04/20 07:55:02 yS1 CND: _[0a][0a][0a][0a][0a] 04/20 07:56:35 yS1 timeout in chat script, waiting for `CONNECT' 04/20 07:56:35 ##### failed timeout dev=3DttyS1, pid=3D1613, caller=3D'no= ne', conn=3D'', name=3D'' 04/20 07:56:35 yS1 removing lock file -- 04/20 07:56:35 yS1 mgetty: experimental test release 1.1.14-Apr02 04/20 07:56:35 yS1 check for lockfiles 04/20 07:56:35 yS1 checklock: stat failed, no file 04/20 07:56:35 yS1 locking the line 04/20 07:56:35 yS1 makelock(ttyS1) called 04/20 07:56:35 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:56:35 yS1 lock made 04/20 07:56:36 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR 04/20 07:56:36 yS1 tss: set speed to 9600 (015) 04/20 07:56:36 yS1 tio_set_flow_control( HARD ) 04/20 07:56:36 yS1 waiting for line to clear (VTIME), read: = 04/20 07:56:36 yS1 send: \d\d\d+++\d\d\dAT&F&C1&D1S95=3D3[0d][0d] 04/20 07:56:39 yS1 waiting for ``OK_'' 04/20 07:56:39 yS1 got: +++AT&F&C1&D1S95=3D3[0d] 04/20 07:56:39 yS1 CND: +++AT&F&C1&D1S95=3D3[0d][0d][0a]OK[0d] 04/20 07:56:39 yS1 CND: OK ** found ** 04/20 07:56:39 yS1 send: AT&K3W0S7=3D60[0d][0d] 04/20 07:56:39 yS1 waiting for ``OK_'' 04/20 07:56:39 yS1 got: [0a]AT&K3W0S7=3D60[0d] 04/20 07:56:39 yS1 CND: AT&K3W0S7=3D60[0d][0d][0a]OK[0d] 04/20 07:56:40 yS1 CND: OK ** found ** 04/20 07:56:40 yS1 waiting for line to clear (VTIME), read: [0a] 04/20 07:56:40 yS1 removing lock file 04/20 07:56:40 yS1 waiting... 04/20 07:56:40 yS1 select returned 1 04/20 07:56:40 yS1 checking lockfiles, locking the line 04/20 07:56:40 yS1 makelock(ttyS1) called 04/20 07:56:40 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:56:40 yS1 lock made 04/20 07:56:40 yS1 waiting for ``RING'' 04/20 07:56:40 yS1 got: [0d][0a]RING ** found ** 04/20 07:56:40 yS1 send: ATA[0d] 04/20 07:56:40 yS1 waiting for ``CONNECT'' 04/20 07:56:40 yS1 got: [0d] 04/20 07:56:40 yS1 CND: RING[0a]ATA[0d] 04/20 07:56:40 yS1 CND: ATA[0d][0a]CONNECT ** found ** 04/20 07:56:54 yS1 send: = 04/20 07:56:54 yS1 waiting for line to clear (VTIME), read: 14400[0d][= 0a][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][9= 1][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91= ][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91]= [11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][= 11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][1= 1][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11= ][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11]= [91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][= 91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][9= 1][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91= ][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91]= [11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][= 11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][1= 1][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11= ][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11]= [91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][= 91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][9= 1][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91= ][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91]= [11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][= 11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][1= 1][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11= ][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11]= [91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][= 91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][9= 1][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91= ][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11][91][11] 04/20 07:56:55 yS1 clean_line: only 500 of 934 bytes logged 04/20 07:56:55 yS1 warning: carrier signal is ignored 04/20 07:56:55 yS1 looking for utmp entry... (my PID: 1614) 04/20 07:56:55 yS1 utmp + wtmp entry made 04/20 07:56:56 yS1 tio_set_flow_control( HARD ) 04/20 07:56:56 yS1 print welcome banner (/etc/issue.net) 04/20 07:56:56 yS1 getlogname (AUTO_PPP), read:[16][10][02]"[01][02][01= ][06][01][00][00][00][00][ff][02][01][03] 04/20 07:56:56 yS1 getlogname (AUTO_PPP), read:[03] 04/20 07:56:56 yS1 getlogname (AUTO_PPP), read:[01][08][04] -- 04/20 07:56:57 yS1 mgetty: experimental test release 1.1.14-Apr02 04/20 07:56:57 yS1 check for lockfiles 04/20 07:56:57 yS1 checklock: no active process has lock, will remove 04/20 07:56:57 yS1 locking the line 04/20 07:56:57 yS1 makelock(ttyS1) called 04/20 07:56:57 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:56:57 yS1 lock made 04/20 07:56:58 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR DCD 04/20 07:56:58 yS1 WARNING: DCD line still active, check modem settings = (AT&Dx) 04/20 07:56:58 yS1 tss: set speed to 9600 (015) 04/20 07:56:58 yS1 tio_set_flow_control( HARD ) 04/20 07:56:58 yS1 waiting for line to clear (VTIME), read: = 04/20 07:56:58 yS1 send: \d\d\d+++\d\d\dAT&F&C1&D1S95=3D3[0d][0d] 04/20 07:57:01 yS1 waiting for ``OK_'' 04/20 07:57:01 yS1 got: +++AT&F&C1&D1S95=3D3[0d] 04/20 07:57:01 yS1 CND: +++AT&F&C1&D1S95=3D3[0d][0d][0a]ERROR 04/20 07:57:01 yS1 found action string: ``ERROR'' 04/20 07:57:01 yS1 init chat failed, exiting...: Invalid argument 04/20 07:57:01 ##### failed in mg_init_data, dev=3DttyS1, pid=3D1615 04/20 07:57:01 yS1 removing lock file -- 04/20 07:57:01 yS1 mgetty: experimental test release 1.1.14-Apr02 04/20 07:57:01 yS1 check for lockfiles 04/20 07:57:01 yS1 checklock: stat failed, no file 04/20 07:57:01 yS1 locking the line 04/20 07:57:01 yS1 makelock(ttyS1) called 04/20 07:57:01 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:57:01 yS1 lock made 04/20 07:57:02 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR DCD 04/20 07:57:02 yS1 WARNING: DCD line still active, check modem settings = (AT&Dx) 04/20 07:57:02 yS1 tss: set speed to 9600 (015) 04/20 07:57:02 yS1 tio_set_flow_control( HARD ) 04/20 07:57:02 yS1 waiting for line to clear (VTIME), read: = 04/20 07:57:02 yS1 send: \d\d\d+++\d\d\dAT&F&C1&D1S95=3D3[0d][0d] 04/20 07:57:05 yS1 waiting for ``OK_'' 04/20 07:57:05 yS1 got: +++AT&F&C1&D1S95=3D3[0d] 04/20 07:57:05 yS1 CND: +++AT&F&C1&D1S95=3D3[0d][0d][0a]ERROR 04/20 07:57:05 yS1 found action string: ``ERROR'' 04/20 07:57:05 yS1 init chat failed, exiting...: Invalid argument 04/20 07:57:05 ##### failed in mg_init_data, dev=3DttyS1, pid=3D1616 04/20 07:57:05 yS1 removing lock file -- 04/20 07:57:05 yS1 mgetty: experimental test release 1.1.14-Apr02 04/20 07:57:05 yS1 check for lockfiles 04/20 07:57:05 yS1 checklock: stat failed, no file 04/20 07:57:05 yS1 locking the line 04/20 07:57:05 yS1 makelock(ttyS1) called 04/20 07:57:05 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:57:05 yS1 lock made 04/20 07:57:06 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR DCD 04/20 07:57:06 yS1 WARNING: DCD line still active, check modem settings = (AT&Dx) 04/20 07:57:06 yS1 tss: set speed to 9600 (015) 04/20 07:57:06 yS1 tio_set_flow_control( HARD ) 04/20 07:57:06 yS1 waiting for line to clear (VTIME), read: = 04/20 07:57:06 yS1 send: \d\d\d+++\d\d\dAT&F&C1&D1S95=3D3[0d][0d] 04/20 07:57:09 yS1 waiting for ``OK_'' 04/20 07:57:09 yS1 got: +++AT&F&C1&D1S95=3D3[0d] 04/20 07:57:09 yS1 CND: +++AT&F&C1&D1S95=3D3[0d][0d][0a]ERROR 04/20 07:57:09 yS1 found action string: ``ERROR'' 04/20 07:57:09 yS1 init chat failed, exiting...: Invalid argument 04/20 07:57:09 ##### failed in mg_init_data, dev=3DttyS1, pid=3D1617 04/20 07:57:09 yS1 removing lock file -- 04/20 07:57:09 yS1 mgetty: experimental test release 1.1.14-Apr02 04/20 07:57:09 yS1 check for lockfiles 04/20 07:57:09 yS1 checklock: stat failed, no file 04/20 07:57:09 yS1 locking the line 04/20 07:57:09 yS1 makelock(ttyS1) called 04/20 07:57:09 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:57:09 yS1 lock made 04/20 07:57:10 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR DCD 04/20 07:57:10 yS1 WARNING: DCD line still active, check modem settings = (AT&Dx) 04/20 07:57:10 yS1 tss: set speed to 9600 (015) 04/20 07:57:10 yS1 tio_set_flow_control( HARD ) 04/20 07:57:10 yS1 waiting for line to clear (VTIME), read: = 04/20 07:57:10 yS1 send: \d\d\d+++\d\d\dAT&F&C1&D1S95=3D3[0d][0d] 04/20 07:57:13 yS1 waiting for ``OK_'' 04/20 07:57:13 yS1 got: +++AT&F&C1&D1S95=3D3[0d] 04/20 07:57:13 yS1 CND: +++AT&F&C1&D1S95=3D3[0d][0d][0a]ERROR 04/20 07:57:13 yS1 found action string: ``ERROR'' 04/20 07:57:13 yS1 init chat failed, exiting...: Invalid argument 04/20 07:57:13 ##### failed in mg_init_data, dev=3DttyS1, pid=3D1618 04/20 07:57:13 yS1 removing lock file -- 04/20 07:57:13 yS1 mgetty: experimental test release 1.1.14-Apr02 04/20 07:57:13 yS1 check for lockfiles 04/20 07:57:13 yS1 checklock: stat failed, no file 04/20 07:57:13 yS1 locking the line 04/20 07:57:13 yS1 makelock(ttyS1) called 04/20 07:57:13 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:57:13 yS1 lock made 04/20 07:57:13 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR DCD 04/20 07:57:13 yS1 WARNING: DCD line still active, check modem settings = (AT&Dx) 04/20 07:57:13 yS1 tss: set speed to 9600 (015) 04/20 07:57:13 yS1 tio_set_flow_control( HARD ) 04/20 07:57:13 yS1 waiting for line to clear (VTIME), read: = 04/20 07:57:14 yS1 send: \d\d\d+++\d\d\dAT&F&C1&D1S95=3D3[0d][0d] 04/20 07:57:17 yS1 waiting for ``OK_'' 04/20 07:57:17 yS1 got: +++AT&F&C1&D1S95=3D3[0d] 04/20 07:57:17 yS1 CND: +++AT&F&C1&D1S95=3D3[0d][0d][0a]ERROR 04/20 07:57:17 yS1 found action string: ``ERROR'' 04/20 07:57:17 yS1 init chat failed, exiting...: Invalid argument 04/20 07:57:17 ##### failed in mg_init_data, dev=3DttyS1, pid=3D1619 04/20 07:57:17 yS1 removing lock file -- 04/20 07:57:17 yS1 mgetty: experimental test release 1.1.14-Apr02 04/20 07:57:17 yS1 check for lockfiles 04/20 07:57:17 yS1 checklock: stat failed, no file 04/20 07:57:17 yS1 locking the line 04/20 07:57:17 yS1 makelock(ttyS1) called 04/20 07:57:17 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:57:17 yS1 lock made 04/20 07:57:17 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR DCD 04/20 07:57:17 yS1 WARNING: DCD line still active, check modem settings = (AT&Dx) 04/20 07:57:17 yS1 tss: set speed to 9600 (015) 04/20 07:57:17 yS1 tio_set_flow_control( HARD ) 04/20 07:57:17 yS1 waiting for line to clear (VTIME), read: = 04/20 07:57:18 yS1 send: \d\d\d+++\d\d\dAT&F&C1&D1S95=3D3[0d][0d] 04/20 07:57:21 yS1 waiting for ``OK_'' 04/20 07:57:21 yS1 got: +++AT&F&C1&D1S95=3D3[0d] 04/20 07:57:21 yS1 CND: +++AT&F&C1&D1S95=3D3[0d][0d][0a]ERROR 04/20 07:57:21 yS1 found action string: ``ERROR'' 04/20 07:57:21 yS1 init chat failed, exiting...: Invalid argument 04/20 07:57:21 ##### failed in mg_init_data, dev=3DttyS1, pid=3D1620 04/20 07:57:21 yS1 removing lock file -- 04/20 07:57:21 yS1 mgetty: experimental test release 1.1.14-Apr02 04/20 07:57:21 yS1 check for lockfiles 04/20 07:57:21 yS1 checklock: stat failed, no file 04/20 07:57:21 yS1 locking the line 04/20 07:57:21 yS1 makelock(ttyS1) called 04/20 07:57:21 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:57:21 yS1 lock made 04/20 07:57:21 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR DCD 04/20 07:57:21 yS1 WARNING: DCD line still active, check modem settings = (AT&Dx) 04/20 07:57:21 yS1 tss: set speed to 9600 (015) 04/20 07:57:21 yS1 tio_set_flow_control( HARD ) 04/20 07:57:21 yS1 waiting for line to clear (VTIME), read: = 04/20 07:57:21 yS1 send: \d\d\d+++\d\d\dAT&F&C1&D1S95=3D3[0d][0d] 04/20 07:57:25 yS1 waiting for ``OK_'' 04/20 07:57:25 yS1 got: +++AT&F&C1&D1S95=3D3[0d] 04/20 07:57:25 yS1 CND: +++AT&F&C1&D1S95=3D3[0d][0d][0a]ERROR 04/20 07:57:25 yS1 found action string: ``ERROR'' 04/20 07:57:25 yS1 init chat failed, exiting...: Invalid argument 04/20 07:57:25 ##### failed in mg_init_data, dev=3DttyS1, pid=3D1621 04/20 07:57:25 yS1 removing lock file -- 04/20 07:57:25 yS1 mgetty: experimental test release 1.1.14-Apr02 04/20 07:57:25 yS1 check for lockfiles 04/20 07:57:25 yS1 checklock: stat failed, no file 04/20 07:57:25 yS1 locking the line 04/20 07:57:25 yS1 makelock(ttyS1) called 04/20 07:57:25 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:57:25 yS1 lock made 04/20 07:57:25 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR DCD 04/20 07:57:25 yS1 WARNING: DCD line still active, check modem settings = (AT&Dx) 04/20 07:57:25 yS1 tss: set speed to 9600 (015) 04/20 07:57:25 yS1 tio_set_flow_control( HARD ) 04/20 07:57:25 yS1 waiting for line to clear (VTIME), read: = 04/20 07:57:25 yS1 send: \d\d\d+++\d\d\dAT&F&C1&D1S95=3D3[0d][0d] 04/20 07:57:28 yS1 waiting for ``OK_'' 04/20 07:57:28 yS1 got: +++AT&F&C1&D1S95=3D3[0d] 04/20 07:57:28 yS1 CND: +++AT&F&C1&D1S95=3D3[0d][0d][0a]ERROR 04/20 07:57:29 yS1 found action string: ``ERROR'' 04/20 07:57:29 yS1 init chat failed, exiting...: Invalid argument 04/20 07:57:29 ##### failed in mg_init_data, dev=3DttyS1, pid=3D1622 04/20 07:57:29 yS1 removing lock file -- 04/20 07:57:29 yS1 mgetty: experimental test release 1.1.14-Apr02 04/20 07:57:29 yS1 check for lockfiles 04/20 07:57:29 yS1 checklock: stat failed, no file 04/20 07:57:29 yS1 locking the line 04/20 07:57:29 yS1 makelock(ttyS1) called 04/20 07:57:29 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 07:57:29 yS1 lock made 04/20 07:57:29 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR DCD 04/20 07:57:29 yS1 WARNING: DCD line still active, check modem settings = (AT&Dx) 04/20 07:57:29 yS1 tss: set speed to 9600 (015) 04/20 07:57:29 yS1 tio_set_flow_control( HARD ) 04/20 07:57:29 yS1 waiting for line to clear (VTIME), read: = 04/20 07:57:29 yS1 send: \d\d\d+++\d\d\dAT&F&C1&D1S95=3D3[0d][0d] 04/20 07:57:32 yS1 waiting for ``OK_'' 04/20 07:57:32 yS1 got: +++AT&F&C1&D1S95=3D3[0d] 04/20 07:57:32 yS1 CND: +++AT&F&C1&D1S95=3D3[0d][0d][0a]ERROR 04/20 07:57:33 yS1 found action string: ``ERROR'' 04/20 07:57:33 yS1 init chat failed, exiting...: Invalid argument 04/20 07:57:33 ##### failed in mg_init_data, dev=3DttyS1, pid=3D1623 04/20 07:57:33 yS1 removing lock file -- 04/20 08:02:34 yS1 mgetty: experimental test release 1.1.14-Apr02 04/20 08:02:34 yS1 check for lockfiles 04/20 08:02:34 yS1 checklock: stat failed, no file 04/20 08:02:34 yS1 locking the line 04/20 08:02:34 yS1 makelock(ttyS1) called 04/20 08:02:34 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 08:02:34 yS1 lock made 04/20 08:02:34 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR 04/20 08:02:34 yS1 tss: set speed to 9600 (015) 04/20 08:02:34 yS1 tio_set_flow_control( HARD ) 04/20 08:02:34 yS1 waiting for line to clear (VTIME), read: = 04/20 08:02:34 yS1 send: \d\d\d+++\d\d\dAT&F&C1&D1S95=3D3[0d][0d] 04/20 08:02:37 yS1 waiting for ``OK_'' 04/20 08:02:37 yS1 got: +++AT&F&C1&D1S95=3D3[0d] 04/20 08:02:37 yS1 CND: +++AT&F&C1&D1S95=3D3[0d][0d][0a]OK[0d] 04/20 08:02:38 yS1 CND: OK ** found ** 04/20 08:02:38 yS1 send: AT&K3W0S7=3D60[0d][0d] 04/20 08:02:38 yS1 waiting for ``OK_'' 04/20 08:02:38 yS1 got: [0a]AT&K3W0S7=3D60[0d] 04/20 08:02:38 yS1 CND: AT&K3W0S7=3D60[0d][0d][0a]OK[0d] 04/20 08:02:38 yS1 CND: OK ** found ** 04/20 08:02:38 yS1 waiting for line to clear (VTIME), read: [0a] 04/20 08:02:38 yS1 removing lock file 04/20 08:02:38 yS1 waiting... 04/20 09:02:38 yS1 select returned 0 04/20 09:02:38 yS1 checking if modem is still alive 04/20 09:02:38 yS1 makelock(ttyS1) called 04/20 09:02:38 yS1 do_makelock: lock=3D'/var/lock/LCK..ttyS1' 04/20 09:02:38 yS1 lock made 04/20 09:02:38 yS1 mdm_send: 'AT' 04/20 09:02:38 yS1 got:AT[0d] 04/20 09:02:38 yS1 mdm_command: string 'AT' 04/20 09:02:38 yS1 got:[0d][0a]OK[0d] 04/20 09:02:38 yS1 mdm_command: string 'OK' -> OK 04/20 09:02:38 yS1 waiting for line to clear (VTIME), read: = 04/20 09:02:39 yS1 removing lock file 04/20 09:02:39 yS1 waiting... --------------97176538AAFDD0C7B869EC16--