Problem with callback and modeminit

Pilsl Peter (Peter.Pilsl@uw-online.de)
Fri, 12 Nov 1999 12:27:35 +0100
Messages sorted by:[ date ][ thread ][ subject ][ author ]
Hi,

we are using mgetty 1.1.20-Jan17 on SCO UnixWare 7.1.0.
mgetty works properly.
The problem is callback. Callback can`t initialize the modem. I don=B4t
understand why, because callback and mgetty are usings exactly the same
init string.
On other UnixWare 7.1.0 maschines with exactly the same mgetty and
callback configuration there isn=B4t this problem.
The mgetty log file shows the following problems:
	11/12 11:31:56 y1A  TIOCMBIS failed: No such device or address
	11/12 11:31:56 y1A  tcgetattr failed: No such device or address
	11/12 11:31:56 y1A  cannot get TIO: No such device or address
	11/12 11:31:56 y1A  mg_init_device failed, trying again
and initializes without DTR DCD.
Perhaps callback has the same problem an doesnt retry without DTR DCD.

What can I do, to get callback working?
Thanks for help.

mgetty log-file with -x 9:
=0A=
--=0A=
11/12 11:31:55 y1A  mgetty: experimental test release
1.1.20-Jan17=0A=
11/12 11:31:55 y1A   mgetty.c compiled at May 19 1999,
12:18:16=0A=
11/12 11:31:55 y1A   user id: 0, parent pid: 1=0A=
11/12 11:31:55
y1A   reading configuration data for port 'tty1A'=0A=
11/12 11:31:55 y1A
reading /usr/local/mgetty/etc/mgetty+sendfax/mgetty.config...=0A=
11/12
11:31:55 y1A   conf lib: read: 'debug 4'=0A=
11/12 11:31:55 y1A   conf lib:
read: 'fax-id 49 115 xxxxxxxx'=0A=
11/12 11:31:55 y1A   conf lib: read:
'speed 38400'=0A=
11/12 11:31:55 y1A   conf lib: read: 'port-owner
uucp'=0A=
11/12 11:31:55 y1A   conf lib: read: 'port-group uucp'=0A=
11/12
11:31:55 y1A   conf lib: read: 'port-mode 0664'=0A=
11/12 11:31:55 y1A
conf lib: read: 'port tty1A'=0A=
11/12 11:31:55 y1A   section: port tty1A,
**found**=0A=
11/12 11:31:55 y1A   conf lib: read: 'debug 5'=0A=
11/12 11:31:55
y1A   conf lib: read: 'init-chat "" \d\d\d+++\d\d\dATZ OK ATX3 OK
ATS0=3D0Q0&D3&C1 OK'=0A=
11/12 11:31:55 y1A   conf lib: read: 'data-only
y'=0A=
11/12 11:31:55 y1A   key: 'speed', type=3D0, flags=3D3, data=3D38400=0A=
11/12
11:31:55 y1A   key: 'switchbd', type=3D0, flags=3D1, data=3D0=0A=
11/12 11:31:55
y1A   key: 'direct', type=3D3, flags=3D1, data=3DFALSE=0A=
11/12 11:31:55 y1A
key: 'blocking', type=3D3, flags=3D1, data=3DFALSE=0A=
11/12 11:31:55 y1A   key:
'port-owner', type=3D1, flags=3D3, data=3Duucp=0A=
11/12 11:31:55 y1A   key:
'port-group', type=3D1, flags=3D3, data=3Duucp=0A=
11/12 11:31:55 y1A   key:
'port-mode', type=3D0, flags=3D3, data=3D436=0A=
11/12 11:31:55 y1A   key:
'toggle-dtr', type=3D3, flags=3D1, data=3DTRUE=0A=
11/12 11:31:55 y1A   key:
'toggle-dtr-waittime', type=3D0, flags=3D1, data=3D500=0A=
11/12 11:31:55 y1A
key: 'data-only', type=3D3, flags=3D2, data=3DTRUE=0A=
11/12 11:31:55 y1A   key:
'fax-only', type=3D3, flags=3D1, data=3DFALSE=0A=
11/12 11:31:55 y1A   key:
'modem-type', type=3D1, flags=3D1, data=3Dauto=0A=
11/12 11:31:55 y1A   key:
'modem-quirks', type=3D0, flags=3D0, data=3D(empty)=0A=
11/12 11:31:55 y1A   key:
'init-chat', type=3D2, flags=3D3, data=3D \d\d\d+++\d\d\dATZ OK ATX3 OK
ATS0=3D0Q0&D3&C1 OK =0A=
11/12 11:31:55 y1A   key: 'force-init-chat', type=3D2,
flags=3D1, data=3D \d=10=03\d\d\d+++\d\d\d=0A=
\dATQ0V1H0 OK =0A=
11/12 11:31:55 y1A
key: 'post-init-chat', type=3D2, flags=3D0, data=3D(empty)=0A=
11/12 11:31:55 y1A
key: 'modem-check-time', type=3D0, flags=3D1, data=3D3600=0A=
11/12 11:31:55 y1A
key: 'rings', type=3D0, flags=3D1, data=3D1=0A=
11/12 11:31:55 y1A   key:
'msn-list', type=3D2, flags=3D0, data=3D(empty)=0A=
11/12 11:31:55 y1A   key:
'get-cnd-chat', type=3D2, flags=3D0, data=3D(empty)=0A=
11/12 11:31:55 y1A   key:
'cnd-program', type=3D1, flags=3D0, data=3D(empty)=0A=
11/12 11:31:55 y1A   key:
'answer-chat', type=3D2, flags=3D1, data=3D ATA CONNECT \c =0A=
 =0A=
11/12 11:31:55
y1A   key: 'answer-chat-timeout', type=3D0, flags=3D1, data=3D80=0A=
11/12
11:31:55 y1A   key: 'autobauding', type=3D3, flags=3D1, data=3DFALSE=0A=
11/12
11:31:55 y1A   key: 'ringback', type=3D3, flags=3D1, data=3DFALSE=0A=
11/12
11:31:55 y1A   key: 'ringback-time', type=3D0, flags=3D1, data=3D30=0A=
11/12
11:31:55 y1A   key: 'ignore-carrier', type=3D3, flags=3D1, =
data=3DFALSE=0A=
11/12
11:31:55 y1A   key: 'issue-file', type=3D1, flags=3D1, =
data=3D/etc/issue=0A=
11/12
11:31:55 y1A   key: 'prompt-waittime', type=3D0, flags=3D1, =
data=3D500=0A=
11/12
11:31:55 y1A   key: 'login-prompt', type=3D1, flags=3D1, data=3D=0A=
@!login:
=0A=
11/12 11:31:55 y1A   key: 'login-time', type=3D0, flags=3D1, =
data=3D240=0A=
11/12
11:31:55 y1A   key: 'fido-send-emsi', type=3D3, flags=3D1, =
data=3DTRUE=0A=
11/12
11:31:55 y1A   key: 'fax-id', type=3D1, flags=3D3, data=3D49 115
xxxxxxxx=0A=
11/12 11:31:55 y1A   key: 'fax-min-speed', type=3D0, flags=3D1,
data=3D0=0A=
11/12 11:31:55 y1A   key: 'fax-max-speed', type=3D0, flags=3D1,
data=3D14400=0A=
11/12 11:31:55 y1A   key: 'fax-server-file', type=3D1, flags=3D0,
data=3D(empty)=0A=
11/12 11:31:55 y1A   key: 'diskspace', type=3D0, flags=3D1,
data=3D1024=0A=
11/12 11:31:55 y1A   key: 'notify', type=3D1, flags=3D1,
data=3Dfaxadmin=0A=
11/12 11:31:55 y1A   key: 'fax-owner', type=3D1, flags=3D1,
data=3Duucp=0A=
11/12 11:31:55 y1A   key: 'fax-group', type=3D1, flags=3D0,
data=3D(empty)=0A=
11/12 11:31:55 y1A   key: 'fax-mode', type=3D0, flags=3D1,
data=3D432=0A=
11/12 11:31:55 y1A   key: 'debug', type=3D0, flags=3D2,
data=3D9=0A=
11/12 11:31:55 y1A   key: 'statistics-chat', type=3D2, flags=3D0,
data=3D(empty)=0A=
11/12 11:31:55 y1A   key: 'statistics-file', type=3D1,
flags=3D0, data=3D(empty)=0A=
11/12 11:31:55 y1A   key: 'gettydefs', type=3D1,
flags=3D1, data=3Dn=0A=
11/12 11:31:55 y1A   key: 'term', type=3D1, flags=3D0,
data=3D(empty)=0A=
11/12 11:31:55 y1A  check for lockfiles=0A=
11/12 11:31:55 y1A
get_lock_name(tty1A) called=0A=
11/12 11:31:55 y1A   -> ttyname
/dev/tty1A=0A=
11/12 11:31:55 y1A   lock file:
/var/spool/locks/LK.7679.003.003=0A=
11/12 11:31:55 y1A   checklock: stat
failed, no file=0A=
11/12 11:31:55 y1A  locking the line=0A=
11/12 11:31:55 y1A
makelock(tty1A) called=0A=
11/12 11:31:55 y1A   get_lock_name(tty1A)
called=0A=
11/12 11:31:55 y1A   -> ttyname /dev/tty1A=0A=
11/12 11:31:55 y1A
lock file: /var/spool/locks/LK.7679.003.003=0A=
11/12 11:31:55 y1A
do_makelock: lock=3D'/var/spool/locks/LK.7679.003.003'=0A=
11/12 11:31:55 y1A
lock made=0A=
11/12 11:31:56 y1A   tio_get_rs232_lines: status: RTS CTS DSR
DTR DCD=0A=
11/12 11:31:56 y1A  lowering DTR to reset Modem=0A=
11/12 11:31:56
y1A  TIOCMBIS failed: No such device or address=0A=
11/12 11:31:56 y1A
tcgetattr failed: No such device or address=0A=
11/12 11:31:56 y1A  cannot
get TIO: No such device or address=0A=
11/12 11:31:56 y1A  mg_init_device
failed, trying again=0A=
11/12 11:31:56 y1A   tio_get_rs232_lines: status:
RTS CTS DSR=0A=
11/12 11:31:56 y1A  lowering DTR to reset Modem=0A=
11/12
11:31:57 y1A   tss: set speed to 38400 (017)=0A=
11/12 11:31:57 y1A
tio_set_flow_control( HARD )=0A=
11/12 11:31:57 y1A   tio_set_flow_control:
using termiox=0A=
11/12 11:31:57 y1A   waiting for line to clear (VTIME),
read: =0A=
11/12 11:31:57 y1A  send: \d\d\d+++\d\d\dATZ[0d]=0A=
11/12 11:32:00
y1A  waiting for ``OK''=0A=
11/12 11:32:00 y1A   got: [0d][0a]OK ** found
**=0A=
11/12 11:32:00 y1A  send: ATX3[0d]=0A=
11/12 11:32:00 y1A  waiting for
``OK''=0A=
11/12 11:32:00 y1A   got: [0d]=0A=
11/12 11:32:00 y1A    CND:
OK[0a]ATZ[0d]=0A=
11/12 11:32:00 y1A    CND: ATZ[0d][0a]OK ** found **=0A=
11/12
11:32:00 y1A  send: ATS0=3D0Q0&D3&C1[0d]=0A=
11/12 11:32:00 y1A  waiting for
``OK''=0A=
11/12 11:32:00 y1A   got: [0d]=0A=
11/12 11:32:00 y1A    CND:
OK[0a]ATX3[0d]=0A=
11/12 11:32:00 y1A    CND: ATX3[0d][0a]OK ** found
**=0A=
11/12 11:32:00 y1A   waiting for line to clear (VTIME), read:
[0d][0a]ATS0=3D0Q0&D3&C1[0d][0d][0a]OK[0d][0a]=0A=
11/12 11:32:01 y1A
removing lock file=0A=
11/12 11:32:01 y1A  error removing lock file (huh?!):
No such file or directory=0A=
11/12 11:32:01 y1A  waiting...=0A=
11/12 11:34:22
y1A    select returned 1=0A=
11/12 11:34:22 y1A   checking lockfiles,
locking the line=0A=
11/12 11:34:22 y1A   makelock(tty1A) called=0A=
11/12
11:34:22 y1A   get_lock_name(tty1A) called=0A=
11/12 11:34:22 y1A   ->
ttyname /dev/tty1A=0A=
11/12 11:34:22 y1A   lock file:
/var/spool/locks/LK.7679.003.003=0A=
11/12 11:34:22 y1A   do_makelock:
lock=3D'/var/spool/locks/LK.7679.003.003'=0A=
11/12 11:34:22 y1A   lock
made=0A=
11/12 11:34:22 y1A  wfr: waiting for ``RING''=0A=
11/12 11:34:22 y1A
got: [0d][0a]RING[0d]=0A=
11/12 11:34:22 y1A    CND: RING=0A=
11/12 11:34:22 y1A
wfr: rc=3D0, drn=3D0=0A=
11/12 11:34:22 y1A  send: ATA[0d]=0A=
11/12 11:34:22 y1A
waiting for ``CONNECT''=0A=
11/12 11:34:22 y1A   got: ATA[0d]=0A=
11/12 11:34:22
y1A    CND: OKATA[0d][0a]CONNECT ** found **=0A=
11/12 11:34:36 y1A  send:
=0A=
11/12 11:34:36 y1A  waiting for ``_''=0A=
11/12 11:34:36 y1A   got:
33600/LAPM/V42BIS[0d]=0A=
11/12 11:34:36 y1A    CND: CONNECT
33600/LAPM/V42BIS=0A=
11/12 11:34:36 y1A    CND: found:
33600/LAPM/V42BIS[0a] ** found **=0A=
11/12 11:34:36 y1A   waiting for line
to clear (VTIME), read: =0A=
11/12 11:34:36 y1A    looking for utmp entry...
(my PID: 17741)=0A=
11/12 11:34:36 y1A   utmp + wtmp entry made=0A=
11/12
11:34:37 y1A   tio_set_flow_control( HARD )=0A=
11/12 11:34:37 y1A
tio_set_flow_control: using termiox=0A=
11/12 11:34:37 y1A   print welcome
banner (/etc/issue)=0A=
11/12 11:34:37 y1A   getlogname (no opts),
read:l5000[0d]=0A=
11/12 11:34:51 y1A   input finished with '\r', setting
ICRNL ONLCR=0A=
11/12 11:34:51 y1A   tio_get_rs232_lines: status: RTS CTS
DSR DTR DCD=0A=
11/12 11:34:51 y1A    login: use login config file
/usr/local/mgetty/etc/mgetty+sendfax/login.config=0A=
11/12 11:34:51 y1A
login: version 2=0A=
11/12 11:34:51 y1A   match: user=3D'l5000',
key=3D'xuw0'=0A=
11/12 11:34:51 y1A   match: user=3D'l5000', key=3D'xuw1'=0A=
11/12
11:34:51 y1A   match: user=3D'l5000', key=3D'xuw2'=0A=
11/12 11:34:51 y1A
match: user=3D'l5000', key=3D'xuw4'=0A=
11/12 11:34:51 y1A   match:
user=3D'l5000', key=3D'xuw5'=0A=
11/12 11:34:51 y1A   match: user=3D'l5000',
key=3D'xuw6'=0A=
11/12 11:34:51 y1A   match: user=3D'l5000', key=3D'xuw7'=0A=
11/12
11:34:51 y1A   match: user=3D'l5000', key=3D'xuw8'=0A=
11/12 11:34:51 y1A
match: user=3D'l5000', key=3D'xuw9'=0A=
11/12 11:34:51 y1A   match:
user=3D'l5000', key=3D'xuwf0'=0A=
11/12 11:34:51 y1A   match: user=3D'l5000',
key=3D'l5000'*** hit!=0A=
11/12 11:34:51 y1A   calling login:
cmd=3D'/bin/login', argv[]=3D'login l5000'=0A=
11/12 11:34:51 ##### data
dev=3Dtty1A, pid=3D17741, caller=3D'none', conn=3D'33600/LAPM/V42BIS', =
name=3D'',
cmd=3D'/bin/login', user=3D'l5000'=0A=
=0A=
11/12 11:34:51 y1A   setenv:
'CALLER_ID=3Dnone'=0A=
11/12 11:34:51 y1A   setenv:
'CONNECT=3D33600/LAPM/V42BIS'

mgetty.callback log-file
=0A=
--=0A=
11/11 11:09:52   callback: experimental test release
1.1.20-Jan17=0A=
11/11 11:09:52    1 telephone numbers given:=0A=
11/11 11:09:52
#1: 00049811881319=0A=
11/11 11:09:52   reading default configuration=0A=
11/11
11:09:52   reading
/usr/local/mgetty/etc/mgetty+sendfax/callback.config...=0A=
11/11 11:09:52
conf lib: read: 'dialout-devices tty1A:tty1A'=0A=
11/11 11:09:52   conf lib:
read: 'retry-time 10'=0A=
11/11 11:09:52   conf lib: read: 'max-time
90'=0A=
11/11 11:09:52   conf lib: read: 'debug 0'=0A=
11/11 11:09:52   conf
lib: read: 'dial-prefix ATX3D'=0A=
11/11 11:09:52   conf lib: read:
'modem-init "" \d\d\d+++\d\d\dATZ OK ATX3 OK ATS0=3D0Q0&D3&C1 OK'=0A=
11/11
11:09:52   key: 'dialout-devices', type=3D1, flags=3D3,
data=3Dtty1A:tty1A=0A=
11/11 11:09:52   key: 'dialout-devices', type=3D1,
flags=3D4, data=3D(ignored)=0A=
11/11 11:09:52   key: 'delay', type=3D0, flags=3D1,
data=3D20=0A=
11/11 11:09:52   key: 'delay-randomize', type=3D0, flags=3D1,
data=3D10=0A=
11/11 11:09:52   key: 'retry-time', type=3D0, flags=3D3,
data=3D10=0A=
11/11 11:09:52   key: 'max-time', type=3D0, flags=3D3, data=3D90=0A=
11/11
11:09:52   key: 'modem-init', type=3D2, flags=3D3, data=3D =
\d\d\d+++\d\d\dATZ
OK ATX3 OK ATS0=3D0Q0&D3&C1 OK =0A=
11/11 11:09:52   key: 'speed', type=3D0,
flags=3D1, data=3D38400=0A=
11/11 11:09:52   key: 'dial-prefix', type=3D1,
flags=3D3, data=3DATX3D=0A=
11/11 11:09:52   key: 'autobauding', type=3D3,
flags=3D1, data=3DFALSE=0A=
11/11 11:09:52   key: 'prompt-waittime', type=3D0,
flags=3D1, data=3D300=0A=
11/11 11:09:52   key: '', type=3D3, flags=3D1,
data=3DFALSE=0A=
11/11 11:09:52   key: 'debug', type=3D0, flags=3D2, data=3D9=0A=
11/11
11:09:52  detaching from ctty...=0A=
11/11 11:09:53   delaying 10
seconds=0A=
11/11 11:10:03   cbfd: search ttys 'tty1A:tty1A'=0A=
11/11 11:10:03
cbfd: device: '/dev/tty1A'=0A=
11/11 11:10:03   makelock(tty1A) called=0A=
11/11
11:10:03   get_lock_name(tty1A) called=0A=
11/11 11:10:03   -> ttyname
/dev/tty1A=0A=
11/11 11:10:03   lock file:
/var/spool/locks/LK.7679.003.003=0A=
11/11 11:10:03   do_makelock:
lock=3D'/var/spool/locks/LK.7679.003.003'=0A=
11/11 11:10:03   lock made=0A=
11/11
11:10:03   find_mgetty: look in PID file /etc/mg-pid.tty1A=0A=
11/11
11:10:03  PID for mgetty on line tty1A: 26876=0A=
11/11 11:10:03   tss: set
speed to 38400 (017)=0A=
11/11 11:10:03   tio_set_flow_control( HARD )=0A=
11/11
11:10:03   tio_set_flow_control: using termiox=0A=
11/11 11:10:03 y1A
reading specific data for port 'tty1A'=0A=
11/11 11:10:03 y1A   reading
/usr/local/mgetty/etc/mgetty+sendfax/callback.config...=0A=
11/11 11:10:03
y1A   conf lib: read: 'dialout-devices tty1A:tty1A'=0A=
11/11 11:10:03 y1A
conf lib: read: 'retry-time 10'=0A=
11/11 11:10:03 y1A   conf lib: read:
'max-time 90'=0A=
11/11 11:10:03 y1A   conf lib: read: 'debug 0'=0A=
11/11
11:10:03 y1A   conf lib: read: 'dial-prefix ATX3D'=0A=
11/11 11:10:03 y1A
conf lib: read: 'modem-init "" \d\d\d+++\d\d\dATZ OK ATX3 OK
ATS0=3D0Q0&D3&C1 OK'=0A=
11/11 11:10:03 y1A   key: 'dialout-devices', type=3D1,
flags=3D4, data=3D(ignored)=0A=
11/11 11:10:03 y1A   key: 'delay', type=3D0,
flags=3D1, data=3D20=0A=
11/11 11:10:03 y1A   key: 'delay-randomize', type=3D0,
flags=3D1, data=3D10=0A=
11/11 11:10:03 y1A   key: 'retry-time', type=3D0,
flags=3D3, data=3D10=0A=
11/11 11:10:03 y1A   key: 'max-time', type=3D0, flags=3D3,
data=3D90=0A=
11/11 11:10:03 y1A   key: 'modem-init', type=3D2, flags=3D3, data=3D
\d\d\d+++\d\d\dATZ OK ATX3 OK ATS0=3D0Q0&D3&C1 OK =0A=
11/11 11:10:03 y1A
key: 'speed', type=3D0, flags=3D1, data=3D38400=0A=
11/11 11:10:03 y1A   key:
'dial-prefix', type=3D1, flags=3D3, data=3DATX3D=0A=
11/11 11:10:03 y1A   key:
'autobauding', type=3D3, flags=3D1, data=3DFALSE=0A=
11/11 11:10:03 y1A   key:
'prompt-waittime', type=3D0, flags=3D1, data=3D300=0A=
11/11 11:10:03 y1A   key:
'', type=3D3, flags=3D1, data=3DFALSE=0A=
11/11 11:10:03 y1A   key: 'debug',
type=3D0, flags=3D2, data=3D9=0A=
11/11 11:10:03 y1A  initializing modem...=0A=
11/11
11:10:03 y1A  send: \d\d\d+++\d\d\dATZ[0d]=0A=
11/11 11:10:06 y1A  waiting
for ``OK''=0A=
11/11 11:10:06 y1A   got: ATZ=0A=
11/11 11:10:16 y1A  timeout in
chat script, waiting for `OK'=0A=
11/11 11:10:16 y1A  Error: modem does not
answer, giving up!: Error 0
	- - - - - - - - - - - - - - -
	Peter Pilsl			Unternehmensberatung
Weihenstephan
	Tel: (0811) 881-114 		Zeppelinstr. 4, 85399
Hallbergmoos
	Fax:(0811) 881-199		http://www.uw-online.de
				 mailto:Peter.Pilsl@uw-online.de=20