callback mit mgetty
Thomas Mohaupt (ThoMo@gmx.de)
Fri, 07 May 1999 16:15:34 +0200
Hallo,
ich versuche seit einiger Zeit einen ppp-Server fuer callback
einzurichten.
Bekomme aber nur immer folgende Meldungen (s.u.) Bei mir zu Hause (dahin
soll zurueckgerufen werden) kommt nichts an, also kein Klingeln, nichts.
Das Modem am Server ist an einer Anlage, deshalb die "0".
Ansonsten:
SuSe 5.3
Kernel 2.0.35
PPP Dial-In klappt (fast) ohne Probleme (Fast, weil manchmal haengt so
fuer 10-20 sek. die Leitung und nichts geht rueber, danach ist wieder
alles ok.)
Hier die Meldungen:
/var/log/mgetty.callback
04/26 23:05:58 detaching from ctty...
04/26 23:06:00 delaying 27 seconds
04/26 23:06:27 cbfd: search ttys '/dev/ttyS1'
04/26 23:06:27 cbfd: device: '/dev/ttyS1'
04/26 23:06:27 makelock(ttyS1) called
04/26 23:06:27 do_makelock: lock='/var/lock/LCK..ttyS1'
04/26 23:06:27 lock made
04/26 23:06:27 find_mgetty: look in PID file /var/run/mg-pid.ttyS1
04/26 23:06:27 PID for mgetty on line ttyS1: 8252
04/26 23:06:27 tss: set speed to 38400 (017)
04/26 23:06:27 tio_set_flow_control( HARD )
04/26 23:06:27 yS1 reading specific data for port 'ttyS1'
04/26 23:06:27 yS1 reading /etc/mgetty+sendfax/callback.config...
04/26 23:06:27 yS1 conf lib: read: 'retry-time 30'
04/26 23:06:27 yS1 conf lib: read: 'max-time 90'
04/26 23:06:27 yS1 conf lib: read: 'debug 9'
04/26 23:06:27 yS1 conf lib: read: 'modem-init "" ATQ0V1H&C0X3 OK
AT+FCLASS=0 OK'
04/26 23:06:27 yS1 key: 'dialout-devices', type=1, flags=4,
data=(ignored)
04/26 23:06:27 yS1 key: 'delay', type=0, flags=1, data=20
04/26 23:06:27 yS1 key: 'delay-randomize', type=0, flags=1, data=10
04/26 23:06:27 yS1 key: 'retry-time', type=0, flags=3, data=30
04/26 23:06:27 yS1 key: 'max-time', type=0, flags=3, data=90
04/26 23:06:27 yS1 key: 'modem-init', type=2, flags=3, data=
ATQ0V1H&C0X3 OK AT+FCLASS=0 OK
04/26 23:06:27 yS1 key: 'speed', type=0, flags=1, data=38400
04/26 23:06:27 yS1 key: 'dial-prefix', type=1, flags=1, data=ATD
04/26 23:06:27 yS1 key: 'autobauding', type=3, flags=1, data=FALSE
04/26 23:06:27 yS1 key: 'prompt-waittime', type=0, flags=1, data=300
04/26 23:06:27 yS1 key: '', type=3, flags=1, data=FALSE
04/26 23:06:27 yS1 key: 'debug', type=0, flags=3, data=9
04/26 23:06:27 yS1 initializing modem...
04/26 23:06:27 yS1 send: ATQ0V1H&C0X3[0d]
04/26 23:06:27 yS1 waiting for ``OK''
04/26 23:06:27 yS1 got: [0d][0a]OK ** found **
04/26 23:06:27 yS1 send: AT+FCLASS=0[0d]
04/26 23:06:27 yS1 waiting for ``OK''
04/26 23:06:27 yS1 got: [0d][0a][0d][0a]OK ** found **
04/26 23:06:27 yS1 dialing 0112233...
04/26 23:06:27 yS1 mdm_send: 'ATD0112233'
04/26 23:06:27 yS1 got:[0d][0a][0d][0a]NO CARRIER[0d]
04/26 23:07:40 yS1 dialup: got 'NO CARRIER'
04/26 23:07:40 yS1 dialup attempt failed, try next number
04/26 23:08:10 yS1 time ran out, giving up
04/26 23:08:10 yS1 can't dial any of the given numbers, exiting: Bad
file number
/var/log/messages
Apr 26 23:05:58 eiche mgetty[8250]: data dev=ttyS1, pid=8250,
caller=none, conn='28800/REL', name='', cmd='/usr/sbin/callback',
user='callback'
Apr 26 23:06:43 eiche kernel: PPP: ppp line discipline successfully
unregistered
/var/log/mgetty.ttyS1
04/26 23:05:27 yS1 mgetty: experimental test release 1.1.8-Jul27
04/26 23:05:27 yS1 check for lockfiles
04/26 23:05:27 yS1 locking the line
04/26 23:05:27 yS1 lowering DTR to reset Modem
04/26 23:05:28 yS1 send: \dATQ0V1H0[0d]
04/26 23:05:28 yS1 waiting for ``OK'' ** found **
04/26 23:05:28 yS1 send: ATS0=0Q0&D3&C1[0d]
04/26 23:05:28 yS1 waiting for ``OK'' ** found **
04/26 23:05:28 yS1 mdm_send: 'ATI'
04/26 23:05:28 yS1 Generic Rockwell modem (33600)
04/26 23:05:28 yS1 mdm_send: 'ATI3'
04/26 23:05:29 yS1 mdm_send: 'ATI4'
04/26 23:05:29 yS1 additional info: ''
04/26 23:05:29 yS1 mdm_send: 'AT+FCLASS=2' -> OK
04/26 23:05:29 yS1 mdm_send: 'AT+FCLASS=0' -> OK
04/26 23:05:29 yS1 mdm_send: 'AT+FAA=1;+FCR=1' -> OK
04/26 23:05:29 yS1 mdm_send: 'AT+FBOR=0' -> OK
04/26 23:05:29 yS1 mdm_send: 'AT+FLID="49 89 xxxxxxxx"' -> OK
04/26 23:05:29 yS1 mdm_send: 'AT+FDCC=1,5,0,2,0,0,0,0' -> OK
04/26 23:05:29 yS1 waiting...
04/26 23:05:43 yS1 waiting for ``RING'' ** found **
04/26 23:05:43 yS1 send: ATA[0d]
04/26 23:05:43 yS1 waiting for ``CONNECT'' ** found **
04/26 23:05:57 yS1 send:
04/26 23:05:57 yS1 waiting for ``_'' ** found **
04/26 23:05:58 ##### data dev=ttyS1, pid=8250, caller=none,
conn='28800/REL', name='', cmd='/usr/sbin/callback', user='callback'
--
04/26 23:06:00 yS1 mgetty: experimental test release 1.1.8-Jul27
04/26 23:06:00 yS1 check for lockfiles
04/26 23:06:00 yS1 locking the line
04/26 23:06:00 yS1 lowering DTR to reset Modem
04/26 23:06:01 yS1 send: \dATQ0V1H0[0d]
04/26 23:06:01 yS1 waiting for ``OK'' ** found **
04/26 23:06:01 yS1 send: ATS0=0Q0&D3&C1[0d]
04/26 23:06:01 yS1 waiting for ``OK'' ** found **
04/26 23:06:01 yS1 mdm_send: 'ATI'
04/26 23:06:01 yS1 Generic Rockwell modem (33600)
04/26 23:06:01 yS1 mdm_send: 'ATI3'
04/26 23:06:02 yS1 mdm_send: 'ATI4'
04/26 23:06:02 yS1 additional info: ''
04/26 23:06:02 yS1 mdm_send: 'AT+FCLASS=2' -> OK
04/26 23:06:02 yS1 mdm_send: 'AT+FCLASS=0' -> OK
04/26 23:06:02 yS1 mdm_send: 'AT+FAA=1;+FCR=1' -> OK
04/26 23:06:02 yS1 mdm_send: 'AT+FBOR=0' -> OK
04/26 23:06:02 yS1 mdm_send: 'AT+FLID="49 89 xxxxxxxx"' -> OK
04/26 23:06:02 yS1 mdm_send: 'AT+FDCC=1,5,0,2,0,0,0,0' -> OK
04/26 23:06:02 yS1 waiting...
04/26 23:06:27 yS1 lock not made: lock file exists (pid=8251)
--
04/26 23:08:22 yS1 mgetty: experimental test release 1.1.8-Jul27
04/26 23:08:22 yS1 check for lockfiles
04/26 23:08:22 yS1 locking the line
04/26 23:08:22 yS1 lowering DTR to reset Modem
04/26 23:08:23 yS1 send: \dATQ0V1H0[0d]
04/26 23:08:23 yS1 waiting for ``OK'' ** found **
04/26 23:08:23 yS1 send: ATS0=0Q0&D3&C1[0d]
04/26 23:08:23 yS1 waiting for ``OK'' ** found **
04/26 23:08:23 yS1 mdm_send: 'ATI'
04/26 23:08:23 yS1 Generic Rockwell modem (33600)
04/26 23:08:24 yS1 mdm_send: 'ATI3'
04/26 23:08:24 yS1 mdm_send: 'ATI4'
04/26 23:08:24 yS1 additional info: ''
04/26 23:08:24 yS1 mdm_send: 'AT+FCLASS=2' -> OK
04/26 23:08:24 yS1 mdm_send: 'AT+FCLASS=0' -> OK
04/26 23:08:24 yS1 mdm_send: 'AT+FAA=1;+FCR=1' -> OK
04/26 23:08:24 yS1 mdm_send: 'AT+FBOR=0' -> OK
04/26 23:08:24 yS1 mdm_send: 'AT+FLID="49 89 xxxxxxxx"' -> OK
04/26 23:08:24 yS1 mdm_send: 'AT+FDCC=1,5,0,2,0,0,0,0' -> OK
04/26 23:08:24 yS1 waiting...
04/27 00:08:24 yS1 checking if modem is still alive
04/27 00:08:24 yS1 mdm_send: 'AT' -> OK
04/27 00:08:25 yS1 waiting...
....
05/06 16:12:33 yS1 mdm_send: 'AT' -> OK
05/06 16:12:34 yS1 waiting...
05/06 16:18:08 yS1 waiting for ``RING''
05/06 16:18:18 yS1 timeout in chat script, waiting for `RING'
05/06 16:18:18 yS1 huh? Junk on the line?
--
05/06 16:18:18 yS1 mgetty: experimental test release 1.1.8-Jul27
05/06 16:18:18 yS1 check for lockfiles
05/06 16:18:18 yS1 locking the line
05/06 16:18:18 yS1 lowering DTR to reset Modem
05/06 16:18:19 yS1 send: \dATQ0V1H0[0d]
05/06 16:18:19 yS1 waiting for ``OK'' ** found **
05/06 16:18:20 yS1 send: ATS0=0Q0&D3&C1[0d]
05/06 16:18:20 yS1 waiting for ``OK'' ** found **
05/06 16:18:20 yS1 mdm_send: 'ATI'
05/06 16:18:20 yS1 Generic Rockwell modem (33600)
05/06 16:18:20 yS1 mdm_send: 'ATI3'
05/06 16:18:20 yS1 mdm_send: 'ATI4'
05/06 16:18:20 yS1 additional info: ''
05/06 16:18:20 yS1 mdm_send: 'AT+FCLASS=2' -> OK
05/06 16:18:20 yS1 mdm_send: 'AT+FCLASS=0' -> OK
05/06 16:18:20 yS1 mdm_send: 'AT+FAA=1;+FCR=1' -> OK
05/06 16:18:20 yS1 mdm_send: 'AT+FBOR=0' -> OK
05/06 16:18:20 yS1 mdm_send: 'AT+FLID="49 89 xxxxxxxx"' -> OK
05/06 16:18:20 yS1 mdm_send: 'AT+FDCC=1,5,0,2,0,0,0,0' -> OK
05/06 16:18:21 yS1 waiting...
05/06 16:18:31 ##### failed dev=ttyS1, pid=4902, got signal 15, exiting
Der letzte Abschnitt wiederholt sich (haengt aber wahrscheinlich mit
restart zusammen ?)
Irgendeine Idee? Waere sehr schoen.
Danke.
--ThoMo