vgetty & ppp

Philippe MALINGE (pmal@easynet.fr)
Sat, 26 Sep 1998 16:58:50 +0200


On my Linux Redhat 5.1., vgetty is running on /dev/ttyS1, when I'm doing
a PPP connection with my ISP, just after I got @IP vgetty down the line.

Why ?
I give you 2 log extracts :

  1. /var/log/vgetty.ttyS1
  2. /var/log/messages



============= Pieces of /var/log/vgetty.ttyS1

09/26 14:32:38 yS1  waiting...
09/26 14:32:55 yS1  waiting for ``RING_''
09/26 14:33:05 yS1  timeout in chat script, waiting for `RING_'
09/26 14:33:05 yS1  huh? Junk on the line?
--
09/26 14:33:05 yS1  vgetty: experimental test release 0.8.1 / 25Mar98
09/26 14:33:05 yS1  mgetty: experimental test release 1.1.14-Apr02
09/26 14:33:05 yS1  reading generic configuration from config file
/etc/mgetty+sendfax/voice.conf
09/26 14:33:05 yS1  reading program vgetty configuration from config
file /etc/mgetty+sendfax/voice.conf
09/26 14:33:05 yS1  reading port ttyS1 configuration from config file
/etc/mgetty+sendfax/voice.conf
09/26 14:33:05 yS1  check for lockfiles
09/26 14:33:05 yS1  locking the line
09/26 14:33:05 yS1  lowering DTR to reset Modem
09/26 14:33:06 yS1  WARNING: obsolete setserial spd_hi/spd_vhi used,
38400 is not real port speed
09/26 14:33:06 yS1  send: \dATQ0V1H0[0d]
09/26 14:33:06 yS1  waiting for ``OK''
09/26 14:33:26 yS1  timeout in chat script, waiting for `OK'
09/26 14:33:26 yS1  init chat timed out, trying force-init-chat
09/26 14:33:26 yS1  send: \d[10][03]\d\d\d+++\d\d\d[0d]\dATQ0V1H0[0d]
09/26 14:33:30 yS1  waiting for ``OK''
09/26 14:33:31 yS1  do_chat: error in read(): Value too large for
defined data type
09/26 14:33:31 yS1  tcsetattr failed: Invalid argument
09/26 14:33:31 yS1  init chat failed, exiting...: Interrupted system
call
09/26 14:33:31 ##### failed in mg_init_data, dev=ttyS1, pid=871

09/26 14:33:31 yS1  tio: cannot flush queue: Invalid argument
--
09/26 14:33:31 yS1  vgetty: experimental test release 0.8.1 / 25Mar98
09/26 14:33:31 yS1  mgetty: experimental test release 1.1.14-Apr02
09/26 14:33:31 yS1  reading generic configuration from config file
/etc/mgetty+sendfax/voice.conf
09/26 14:33:31 yS1  reading program vgetty configuration from config
file /etc/mgetty+sendfax/voice.conf
09/26 14:33:31 yS1  reading port ttyS1 configuration from config file
/etc/mgetty+sendfax/voice.conf
09/26 14:33:31 yS1  check for lockfiles
09/26 14:33:31 yS1  locking the line
09/26 14:33:32 yS1  WARNING: DCD line still active, check modem settings
(AT&Dx)
09/26 14:33:32 yS1  lowering DTR to reset Modem
09/26 14:33:32 yS1  TIOCMBIS failed: Input/output error
09/26 14:33:32 yS1  cannot turn off soft carrier: Input/output error


============= Pieces of /var/log/messages

Sep 26 14:33:27 surf pppd[869]: Serial connection established.
Sep 26 14:33:28 surf pppd[869]: Using interface ppp0
Sep 26 14:33:28 surf pppd[869]: Connect: ppp0 <--> /dev/modem
Sep 26 14:33:31 surf pppd[869]: local  IP address 195.114.93.102
Sep 26 14:33:31 surf pppd[869]: remote IP address 195.114.65.11
Sep 26 14:33:31 surf vgetty[871]: do_chat: error in read(): Value too
large for defined data type
Sep 26 14:33:31 surf vgetty[871]: tcsetattr failed: Invalid argument
Sep 26 14:33:31 surf vgetty[871]: init chat failed, exiting...:
Interrupted system call
Sep 26 14:33:31 surf vgetty[871]: failed in mg_init_data, dev=ttyS1,
pid=871
Sep 26 14:33:31 surf vgetty[871]: tio: cannot flush queue: Invalid
argument
Sep 26 14:33:32 surf pppd[869]: Hangup (SIGHUP)
Sep 26 14:33:32 surf pppd[869]: Modem hangup
Sep 26 14:33:32 surf pppd[869]: Connection terminated.
Sep 26 14:33:32 surf pppd[869]: Exit.
Sep 26 14:33:32 surf vgetty[873]: TIOCMBIS failed: Input/output error
Sep 26 14:33:32 surf vgetty[873]: cannot turn off soft carrier:
Input/output error
Sep 26 14:33:32 surf vgetty[873]: tcgetattr failed: Input/output error
Sep 26 14:33:32 surf vgetty[873]: cannot get TIO: Input/output error


--
Philippe MALINGE
mailto:pmal@easynet.fr