kein Callback zwischen Linuxrechnern/E0565
Hallo Liste, ich möchte, dass Rechner A (SuSE 6.3) Rechner B (SuSE 7.1) anruft und dieser einen Rückruf auslöst. Ohne Callback klappen die Verbindungen in beide Richtungen tadellos,also gehe ich davon aus, dass alles richtig konfiguriert ist. Eine Callback-Verbindung zu einem anderen Linuxrechner C klappt tadellos (wobei B der Anrufer und C der Server ist, beide SuSE 7.1). Die Konfigurationsdateien gleichen sich bis auf die Authentifizierungseinträge und natürlich das entsprechende Device. Hat dieses Problem schon mal jemand gehabt und kann helfen? Kennt jemand diese cause- Meldung? Danke! Detlef ################################################# /var/log/messages Rechner B (Server) Jul 18 14:49:38 Rechner B kernel: isdn_net: call from Tel Rechner A,7,0 -> Tel Rechner B Jul 18 14:49:38 Rechner B kernel: ippp4: call from Tel Rechner A -> Tel Rechner B, start callback Jul 18 14:49:38 Rechner B kernel: isdn: Rejecting Call Jul 18 14:49:38 Rechner B isdnlog: Jul 18 14:49:38 * Call to tei 127 from +49 Tel Rechner A, Chemnitz on +49 Tel Rechner B, Chemnitz RING (Data) Jul 18 14:49:38 Rechner B isdnlog: Jul 18 14:49:38 * Call to tei 77 from +49 Tel Rechner A, Chemnitz on +49 Tel Rechner B, Chemnitz HANGUP Call rejected (User) Jul 18 14:49:40 Rechner B kernel: ippp4: dialing 1 Tel Rechner A... Jul 18 14:49:40 Rechner B isdnlog: Jul 18 14:49:40 * tei 77 calling +49 Tel Rechner A, Chemnitz with +49 Tel Rechner B, Chemnitz RING (Data) Jul 18 14:49:Tel Rechner B Rechner B isdnlog: Jul 18 14:49:Tel Rechner B tei 77 calling +49 Tel Rechner A, Chemnitz with +49 Tel Rechner B, Chemnitz Time:Thu Jul 18 14:49:00 2002 Jul 18 14:49:Tel Rechner B Rechner B isdnlog: Jul 18 14:49:Tel Rechner B tei 77 calling +49 Tel Rechner A, Chemnitz with +49 Tel Rechner B, Chemnitz COLP +49 Tel Rechner A, Chemnitz Jul 18 14:49:Tel Rechner B Rechner B isdnlog: Jul 18 14:49:Tel Rechner B tei 77 calling +49 Tel Rechner A, Chemnitz with +49 Tel Rechner B, Chemnitz CONNECT (Data) Jul 18 14:49:Tel Rechner B Rechner B isdnlog: Jul 18 14:49:Tel Rechner B tei 77 calling +49 Tel Rechner A, Chemnitz with +49 Tel Rechner B, Chemnitz CHARGE: 0.120 DM/90s = 0.080 DM/Min (DTAG ISDN, City, Werktag (Donnerstag), Wochentag) Jul 18 14:49:Tel Rechner B Rechner B isdnlog: Jul 18 14:49:Tel Rechner B tei 77 calling +49 Tel Rechner A, Chemnitz with +49 Tel Rechner B, Chemnitz HINT: Better use 01030:TelDaFax, 0.001 DM/1s = 0.069 DM/Min, saving 0.025 DM/Min Jul 18 14:49:Tel Rechner B Rechner B isdnlog: Jul 18 14:49:Tel Rechner B tei 77 calling +49 Tel Rechner A, Chemnitz with +49 Tel Rechner B, Chemnitz 1.CI 0.120 DM (now) Jul 18 14:49:Tel Rechner B Rechner B isdnlog: Jul 18 14:49:Tel Rechner B tei 77 calling +49 Tel Rechner A, Chemnitz with +49 Tel Rechner B, Chemnitz NEXT CI AFTER 01:30 (DTAG ISDN, City, Werktag (Donnerstag), Wochentag) Jul 18 14:49:Tel Rechner B Rechner B isdnlog: Jul 18 14:49:Tel Rechner B tei 77 calling +49 Tel Rechner A, Chemnitz with +49 Tel Rechner B, Chemnitz Normal, unspecified (Private network serving local user) Jul 18 14:49:Tel Rechner B Rechner B isdnlog: Jul 18 14:49:Tel Rechner B tei 77 calling +49 Tel Rechner A, Chemnitz with +49 Tel Rechner B, Chemnitz HANGUP (1 CI 0.120 DM) Jul 18 14:49:49 Rechner B kernel: isdn_net: local hangup ippp4 Jul 18 14:49:49 Rechner B kernel: isdn_ppp_free 3 c4a67200 c4a67200 Jul 18 14:49:49 Rechner B kernel: ippp4: Chargesum is 0 ################################################# /var/log/messages Rechner A (Anrufer) Jul 18 14:49:34 Rechner A kernel: OPEN: IP Rechner A -> IP Rechner B ICMP Jul 18 14:49:34 Rechner A kernel: ippp2: dialing 1 Tel Rechner B... Jul 18 14:49:35 Rechner A kernel: ippp2: hangup waiting for callback ... Jul 18 14:49:37 Rechner A kernel: isdn_net: call from Tel Rechner B,7,0 -> Tel Rechner A Jul 18 14:49:37 Rechner A kernel: ippp2: call from Tel Rechner B -> Tel Rechner A accepted Jul 18 14:49:37 Rechner A kernel: isdn_ppp_free 2 c3c48e00 c3c48e00 Jul 18 14:49:37 Rechner A kernel: isdn: HiSax,ch0 cause: E0565 Jul 18 14:49:44 Rechner A kernel: isdn_net: local hangup ippp2 Jul 18 14:49:44 Rechner A kernel: isdn_ppp_free 2 c3c48e00 c3c48e00 Jul 18 14:49:44 Rechner A kernel: ippp2: Chargesum is 0
On Thu, Jul 18, 2002 at 03:20:31PM +0200, Detlef Richter wrote:
Hallo Liste, ich möchte, dass Rechner A (SuSE 6.3) Rechner B (SuSE 7.1) anruft und dieser einen Rückruf auslöst. Ohne Callback klappen die Verbindungen in beide Richtungen tadellos,also gehe ich davon aus, dass alles richtig konfiguriert ist. Eine Callback-Verbindung zu einem anderen Linuxrechner C klappt tadellos (wobei B der Anrufer und C der Server ist, beide SuSE 7.1). Die Konfigurationsdateien gleichen sich bis auf die Authentifizierungseinträge und natürlich das entsprechende Device. Hat dieses Problem schon mal jemand gehabt und kann helfen? Kennt jemand diese cause- Meldung?
Ja, da ueberschneidet sich das das Auflegen und der neue Ruf. Bei callback ist das Timing sehr kritisch, haengt auch ein wenig vom Verhalten eventuell dazwischenliegenden TK Anlagen ab. Das Hauptproblem ist, das ein reinkommender Ruf beim Mehrgeraeteanschluss mindestens 4 sek stehenbleibt, auch wenn er abgewiesen wird. Normalerweise reicht es aus, wenn man auf der Rueckrufenden Seite das callback delay hoehereinstellt als auf der anderen (z.b 3 und 2), in Einzelfaellen muss man es auf der Rueckrufenden Seite auf 4 oder 5 einstellen. -- Karsten Keil SuSE Labs ISDN development
-----Ursprüngliche Nachricht----- Von: Karsten Keil [mailto:kkeil@suse.de] Gesendet: Donnerstag, 18. Juli 2002 15:50 An: suse-isdn@suse.com Betreff: Re: [suse-isdn] kein Callback zwischen Linuxrechnern/E0565 On Thu, Jul 18, 2002 at 03:20:31PM +0200, Detlef Richter wrote:
Hallo Liste, ich möchte, dass Rechner A (SuSE 6.3) Rechner B (SuSE 7.1) anruft und dieser einen Rückruf auslöst. Ohne Callback klappen die Verbindungen in beide Richtungen tadellos,also gehe ich davon aus, dass alles richtig konfiguriert ist. Eine Callback-Verbindung zu einem anderen Linuxrechner C klappt tadellos (wobei B der Anrufer und C der Server ist, beide SuSE 7.1). Die Konfigurationsdateien gleichen sich bis auf die Authentifizierungseinträge und natürlich das entsprechende Device. Hat dieses Problem schon mal jemand gehabt und kann helfen? Kennt jemand diese cause- Meldung?
Ja, da ueberschneidet sich das das Auflegen und der neue Ruf. Bei callback ist das Timing sehr kritisch, haengt auch ein wenig vom Verhalten eventuell dazwischenliegenden TK Anlagen ab. Das Hauptproblem ist, das ein reinkommender Ruf beim Mehrgeraeteanschluss mindestens 4 sek stehenbleibt, auch wenn er abgewiesen wird. Normalerweise reicht es aus, wenn man auf der Rueckrufenden Seite das callback delay hoehereinstellt als auf der anderen (z.b 3 und 2), in Einzelfaellen muss man es auf der Rueckrufenden Seite auf 4 oder 5 einstellen.
Hallo Karsten, habe heute mal ein bisschen mit den callback-delays herumgespielt, und es funktioniert auch, aber leider nur in die falsche Richtung, also wenn A der Server ist und B zuerst anruft. Anders herum kann ich das delay hochsetzen wie ich will, es klappt einfach nicht. Ich weiss langsam nicht mehr, an welcher Stelle ich noch suchen soll. Hänge mal die Logfiles mit an (Sorry dass sie so lang sind, aber ich wollte nichts Wichtiges aus Versehen rausschneiden). Logfiles 1 und 2: Rechner A callback in, cbdelay 5, Rechner B callback out, cbdelay 2 Logfiles 3 und 4: Rechner A callback out, cbdelay 2, Rechner B callback in, cbdelay 5 (hab's auch schon mit 10 versucht) Alles andere ist gleich, keine veränderten Nummern o.ä. Hast Du noch eine Idee? ################################################### Logfile 1: Rechner A, wenn A Server und B Anrufer ist: Jul 24 08:03:24 Rechner A kernel: isdn_net: call from Telnummer Rechner B,7,0 -> Telnummer Rechner A Jul 24 08:03:24 Rechner A kernel: ippp2: call from Telnummer Rechner B -> Telnummer Rechner A, start callback Jul 24 08:03:24 Rechner A kernel: isdn: Rejecting Call Jul 24 08:03:28 Rechner A kernel: ippp2: dialing 1 Telnummer Rechner B... Jul 24 08:03:29 Rechner A kernel: isdn_net: ippp2 connected Jul 24 08:03:29 Rechner A kernel: isdn_net: chargetime of ippp2 now 135778 Jul 24 08:03:29 Rechner A kernel: isdn_ppp_ioctl: minor: 2 cmd: 80047456 state: 3 Jul 24 08:03:29 Rechner A kernel: isdn_ppp_ioctl: minor: 2 cmd: c0887480 state: 3 Jul 24 08:03:29 Rechner A ipppd[136]: Local number: Telnummer Rechner A, Remote number: Telnummer Rechner B, Type: outgoing Jul 24 08:03:29 Rechner A ipppd[136]: PHASE_WAIT -> PHASE_ESTABLISHED, ifunit: 2, linkunit: 0, fd: 7 Jul 24 08:03:29 Rechner A ipppd[136]: sent [0][LCP ConfReq id=0x1 <mru 1524> <auth chap md5> <magic 0x324f469a>] Jul 24 08:03:29 Rechner A ipppd[136]: rcvd [0][LCP ConfReq id=0x1 <mru 1524> <auth chap md5> <magic 0xf384bf1f>] Jul 24 08:03:29 Rechner A ipppd[136]: sent [0][LCP ConfAck id=0x1 <mru 1524> <auth chap md5> <magic 0xf384bf1f>] Jul 24 08:03:29 Rechner A kernel: isdn_ppp_ioctl: minor: 2 cmd: 40047452 state: 3 Jul 24 08:03:29 Rechner A kernel: isdn_ppp_ioctl: minor: 2 cmd: 8004745a state: 3 Jul 24 08:03:29 Rechner A kernel: isdn_ppp_ioctl: minor: 2 cmd: 40047459 state: 3 Jul 24 08:03:29 Rechner A ipppd[136]: rcvd [0][LCP ConfAck id=0x1 <mru 1524> <auth chap md5> <magic 0x324f469a>] Jul 24 08:03:29 Rechner A ipppd[136]: lcp layer is UP Jul 24 08:03:29 Rechner A ipppd[136]: sent [0][CHAP Challenge id=0x6 <38e1c563ab0bc3c65343720b0ddee87ace13fc92da7976b3bd9aa2b21558152356275ed8a56 cef422cf50c39>, name = "xxxx"] Jul 24 08:03:29 Rechner A kernel: isdn_ppp_ioctl: minor: 2 cmd: 8004745a state: 3 Jul 24 08:03:29 Rechner A kernel: isdn_ppp_ioctl: minor: 2 cmd: 40047459 state: 3 Jul 24 08:03:29 Rechner A kernel: isdn_ppp_ioctl: minor: 2 cmd: 40047452 state: 3 Jul 24 08:03:29 Rechner A kernel: isdn_ppp_ioctl: minor: 2 cmd: 8004745a state: 3 Jul 24 08:03:29 Rechner A kernel: isdn_ppp_ioctl: minor: 2 cmd: 40047459 state: 3 Jul 24 08:03:29 Rechner A ipppd[136]: ChapSendChallenge: Sent id 6. Jul 24 08:03:29 Rechner A ipppd[136]: rcvd [0][CHAP Challenge id=0x6 <56bddd027bb224bTelnummer Rechner Bcf45b61704a557445f3f747f6cb614e8680ee67f83f9f800Telnummer Rechner Bbd7f1cb951dbe9d0f4476ea7e0e640a373687>, name = "xxxx"] Jul 24 08:03:29 Rechner A ipppd[136]: ChapReceiveChallenge: Rcvd id 6. Jul 24 08:03:29 Rechner A ipppd[136]: ChapReceiveChallenge: received name field: 'xxxx' Jul 24 08:03:29 Rechner A ipppd[136]: sent [0][CHAP Response id=0x6 <4762358ff6e50b3557b6d9d7e62c1d42>, name = "xxxx"] Jul 24 08:03:29 Rechner A ipppd[136]: rcvd [0][CHAP Response id=0x6 <787f74edf036238581342cf59e0bd9e1>, name = "xxxx"] Jul 24 08:03:29 Rechner A ipppd[136]: ChapReceiveResponse: Rcvd id 6. Jul 24 08:03:29 Rechner A ipppd[136]: ChapReceiveResponse: received name field: xxxx Jul 24 08:03:29 Rechner A ipppd[136]: sent [0][CHAP Success id=0x6 "Welcome to Rechner A."] Jul 24 08:03:29 Rechner A ipppd[136]: ChapSendStatus: Sent code 3, id 6. Jul 24 08:03:29 Rechner A ipppd[136]: rcvd [0][CHAP Success id=0x6 "Welcome to Rechner B."] Jul 24 08:03:29 Rechner A ipppd[136]: ChapReceiveSuccess: Rcvd id 6. Jul 24 08:03:29 Rechner A ipppd[136]: Remote message: Welcome to Rechner B. Jul 24 08:03:29 Rechner A ipppd[136]: MPPP negotiation, He: No We: No Jul 24 08:03:29 Rechner A ipppd[136]: Useifip for ippp2: Got IF-Src-IP: 3d32a8c0 Jul 24 08:03:29 Rechner A ipppd[136]: Useifip for ippp2: Got IF-Dst-IP: 0101a8c0 Jul 24 08:03:29 Rechner A ipppd[136]: sent [0][IPCP ConfReq id=0x1 <addr Rechner A>] Jul 24 08:03:29 Rechner A ipppd[136]: rcvd [0][IPCP ConfReq id=0x1 <addr 192.168.50.2>] Jul 24 08:03:29 Rechner A ipppd[136]: sent [0][IPCP ConfNak id=0x1 <addr Rechner B>] Jul 24 08:03:29 Rechner A ipppd[136]: rcvd [0][IPCP ConfAck id=0x1 <addr Rechner A>] Jul 24 08:03:29 Rechner A ipppd[136]: rcvd [0][IPCP ConfReq id=0x2 <addr Rechner B>] Jul 24 08:03:29 Rechner A ipppd[136]: sent [0][IPCP ConfAck id=0x2 <addr Rechner B>] Jul 24 08:03:29 Rechner A ipppd[136]: local IP address Rechner A Jul 24 08:03:29 Rechner A ipppd[136]: remote IP address Rechner B Jul 24 08:03:29 Rechner A kernel: isdn_ppp_ioctl: minor: 2 cmd: 8004745a state: 3 Jul 24 08:03:29 Rechner A kernel: isdn_ppp_ioctl: minor: 2 cmd: 40047459 state: 3 Jul 24 08:03:29 Rechner A kernel: isdn_ppp_ioctl: minor: 2 cmd: 8004745a state: 3 Jul 24 08:03:29 Rechner A kernel: isdn_ppp_ioctl: minor: 2 cmd: 40047459 state: 3 Jul 24 08:04:14 Rechner A kernel: isdn_net: local hangup ippp2 Jul 24 08:04:14 Rechner A kernel: isdn_ppp_free 3 c5e1ea00 c5e1ea00 Jul 24 08:04:14 Rechner A kernel: ippp2: Chargesum is 0 Jul 24 08:04:14 Rechner A ipppd[136]: Modem hangup Jul 24 08:04:14 Rechner A ipppd[136]: Connection terminated. ################################################ dazugehöriges Logfile 2: Rechner B: Jul 24 08:03:24 Rechner B kernel: ippp4: dialing 1 Telnummer Rechner A... Jul 24 08:03:24 Rechner B isdnlog: Jul 24 08:03:24 * tei 78 calling +49 371/Telnummer Rechner A, Chemnitz with +49 371/Telnummer Rechner B, Chemnitz RING (Data) Jul 24 08:03:27 Rechner B kernel: ippp4: hangup waiting for callback ... Jul 24 08:03:27 Rechner B isdnlog: Jul 24 08:03:27 tei 78 calling +49 371/Telnummer Rechner A, Chemnitz with +49 371/Telnummer Rechner B, Chemnitz Normal call clearing (User) Jul 24 08:03:27 Rechner B isdnlog: Jul 24 08:03:27 tei 78 calling +49 371/Telnummer Rechner A, Chemnitz with +49 371/Telnummer Rechner B, Chemnitz HANGUP Jul 24 08:03:29 Rechner B kernel: isdn_net: call from Telnummer Rechner A,7,0 -> Telnummer Rechner B Jul 24 08:03:29 Rechner B kernel: ippp4: call from Telnummer Rechner A -> Telnummer Rechner B accepted Jul 24 08:03:29 Rechner B kernel: isdn_ppp_free 2 c4a67200 c4a67200 Jul 24 08:03:29 Rechner B isdnlog: Jul 24 08:03:29 * Call to tei 127 from +49 371/Telnummer Rechner A, Chemnitz on +49 371/Telnummer Rechner B, Chemnitz RING (Data) Jul 24 08:03:29 Rechner B isdnlog: Jul 24 08:03:29 Call to tei 78 from +49 371/Telnummer Rechner A, Chemnitz on +49 371/Telnummer Rechner B, Chemnitz CONNECT (Data) Jul 24 08:03:29 Rechner B ipppd[23319]: Local number: Telnummer Rechner B, Remote number: Telnummer Rechner A, Type: incoming Jul 24 08:03:29 Rechner B ipppd[23319]: PHASE_WAIT -> PHASE_ESTABLISHED, ifunit: 4, linkunit: 0, fd: 14 Jul 24 08:03:29 Rechner B ipppd[23319]: sent [0][LCP ConfReq id=0x1 <mru 1524> <auth chap md5> <magic 0xf384bf1f>] Jul 24 08:03:29 Rechner B kernel: isdn_net: ippp4 connected Jul 24 08:03:29 Rechner B kernel: isdn_ppp_ioctl: minor: 4 cmd: 80047456 state: 3 Jul 24 08:03:29 Rechner B kernel: isdn_ppp_ioctl: minor: 4 cmd: c0887480 state: 3 Jul 24 08:03:29 Rechner B kernel: ippp4: IP frame delayed. Jul 24 08:03:29 Rechner B ipppd[23319]: rcvd [0][LCP ConfReq id=0x1 <mru 1524> <auth chap md5> <magic 0x324f469a>] Jul 24 08:03:29 Rechner B ipppd[23319]: sent [0][LCP ConfAck id=0x1 <mru 1524> <auth chap md5> <magic 0x324f469a>] Jul 24 08:03:29 Rechner B kernel: isdn_ppp_ioctl: minor: 4 cmd: 40047452 state: 3 Jul 24 08:03:29 Rechner B kernel: ippp4: IP frame delayed. Jul 24 08:03:29 Rechner B kernel: isdn_ppp_ioctl: minor: 4 cmd: 8004745a state: 3 Jul 24 08:03:29 Rechner B kernel: isdn_ppp_ioctl: minor: 4 cmd: 40047459 state: 3 Jul 24 08:03:29 Rechner B ipppd[23319]: rcvd [0][LCP ConfAck id=0x1 <mru 1524> <auth chap md5> <magic 0xf384bf1f>] Jul 24 08:03:29 Rechner B ipppd[23319]: lcp layer is UP Jul 24 08:03:29 Rechner B ipppd[23319]: sent [0][CHAP Challenge id=0x6 <56bddd027bb224bTelnummer Rechner Bcf45b61704a557445f3f747f6cb614e8680ee67f83f9f800Telnummer Rechner Bbd7f1cb951dbe9d0f4476ea7e0e640a373687>, name = "xxxx"] Jul 24 08:03:29 Rechner B ipppd[23319]: ChapSendChallenge: Sent id 6. Jul 24 08:03:29 Rechner B kernel: isdn_ppp_ioctl: minor: 4 cmd: 8004745a state: 3 Jul 24 08:03:29 Rechner B kernel: isdn_ppp_ioctl: minor: 4 cmd: 40047459 state: 3 Jul 24 08:03:29 Rechner B kernel: isdn_ppp_ioctl: minor: 4 cmd: 40047452 state: 3 Jul 24 08:03:29 Rechner B kernel: isdn_ppp_ioctl: minor: 4 cmd: 8004745a state: 3 Jul 24 08:03:29 Rechner B kernel: isdn_ppp_ioctl: minor: 4 cmd: 40047459 state: 3 Jul 24 08:03:29 Rechner B kernel: ippp4: IP frame delayed. Jul 24 08:03:29 Rechner B ipppd[23319]: rcvd [0][CHAP Challenge id=0x6 <38e1c563ab0bc3c65343720b0ddee87ace13fc92da7976b3bd9aa2b21558152356275ed8a56 cef422cf50c39>, name = "xxxx"] Jul 24 08:03:29 Rechner B ipppd[23319]: ChapReceiveChallenge: Rcvd id 6. Jul 24 08:03:29 Rechner B ipppd[23319]: ChapReceiveChallenge: received name field: 'xxxx' Jul 24 08:03:29 Rechner B ipppd[23319]: sent [0][CHAP Response id=0x6 <787f74edf036238581342cf59e0bd9e1>, name = "xxxx"] Jul 24 08:03:29 Rechner B kernel: ippp4: IP frame delayed. Jul 24 08:03:29 Rechner B ipppd[23319]: rcvd [0][CHAP Response id=0x6 <4762358ff6e50b3557b6d9d7e62c1d42>, name = "xxxx"] Jul 24 08:03:29 Rechner B ipppd[23319]: ChapReceiveResponse: Rcvd id 6. Jul 24 08:03:29 Rechner B ipppd[23319]: ChapReceiveResponse: received name field: xxxx Jul 24 08:03:29 Rechner B ipppd[23319]: sent [0][CHAP Success id=0x6 "Welcome to Rechner B."] Jul 24 08:03:29 Rechner B ipppd[23319]: ChapSendStatus: Sent code 3, id 6. Jul 24 08:03:29 Rechner B kernel: ippp4: IP frame delayed. Jul 24 08:03:29 Rechner B ipppd[23319]: rcvd [0][CHAP Success id=0x6 "Welcome to Rechner A."] Jul 24 08:03:29 Rechner B ipppd[23319]: ChapReceiveSuccess: Rcvd id 6. Jul 24 08:03:29 Rechner B ipppd[23319]: Remote message: Welcome to Rechner A. Jul 24 08:03:29 Rechner B ipppd[23319]: MPPP negotiation, He: No We: No Jul 24 08:03:29 Rechner B ipppd[23319]: Useifip for ippp4: Got IF-Src-IP: 0232a8c0 Jul 24 08:03:29 Rechner B ipppd[23319]: Useifip for ippp4: Got IF-Dst-IP: 3d32a8c0 Jul 24 08:03:29 Rechner B ipppd[23319]: sent [0][IPCP ConfReq id=0x1 <addr 192.168.50.2>] Jul 24 08:03:29 Rechner B kernel: ippp4: IP frame delayed. Jul 24 08:03:29 Rechner B ipppd[23319]: rcvd [0][IPCP ConfReq id=0x1 <addr Rechner A>] Jul 24 08:03:29 Rechner B ipppd[23319]: sent [0][IPCP ConfAck id=0x1 <addr Rechner A>] Jul 24 08:03:29 Rechner B kernel: ippp4: IP frame delayed. Jul 24 08:03:29 Rechner B ipppd[23319]: rcvd [0][IPCP ConfNak id=0x1 <addr Rechner B>] Jul 24 08:03:29 Rechner B ipppd[23319]: sent [0][IPCP ConfReq id=0x2 <addr Rechner B>] Jul 24 08:03:29 Rechner B kernel: ippp4: IP frame delayed. Jul 24 08:03:29 Rechner B ipppd[23319]: rcvd [0][IPCP ConfAck id=0x2 <addr Rechner B>] Jul 24 08:03:29 Rechner B ipppd[23319]: local IP address Rechner B Jul 24 08:03:29 Rechner B ipppd[23319]: remote IP address Rechner A Jul 24 08:03:29 Rechner B kernel: isdn_ppp_ioctl: minor: 4 cmd: 8004745a state: 3 Jul 24 08:03:29 Rechner B kernel: isdn_ppp_ioctl: minor: 4 cmd: 40047459 state: 3 Jul 24 08:03:29 Rechner B kernel: isdn_ppp_ioctl: minor: 4 cmd: 8004745a state: 3 Jul 24 08:03:29 Rechner B kernel: isdn_ppp_ioctl: minor: 4 cmd: 40047459 state: 3 Jul 24 08:04:15 Rechner B isdnlog: Jul 24 08:04:15 Call to tei 78 from +49 371/Telnummer Rechner A, Chemnitz on +49 371/Telnummer Rechner B, Chemnitz Normal call clearing (Private network serving remote user) Jul 24 08:04:15 Rechner B kernel: isdn_ppp_free 2 c4a67200 c4a67200 Jul 24 08:04:15 Rechner B kernel: ippp4: remote hangup Jul 24 08:04:15 Rechner B kernel: ippp4: Chargesum is 0 Jul 24 08:04:15 Rechner B ipppd[23319]: Modem hangup Jul 24 08:04:15 Rechner B ipppd[23319]: Connection terminated. Jul 24 08:04:15 Rechner B ipppd[23319]: taking down PHASE_DEAD link 0, linkunit: 0 Jul 24 08:04:15 Rechner B ipppd[23319]: sent [0][LCP TermReq id=0x2 6c 69 6e 6b 20 63 6c 6f 73 65 64] Jul 24 08:04:15 Rechner B ipppd[23319]: LCP is down Jul 24 08:04:15 Rechner B ipppd[23319]: closing fd 14 from unit 0 Jul 24 08:04:15 Rechner B ipppd[23319]: link 0 closed , linkunit: 0 Jul 24 08:04:15 Rechner B ipppd[23319]: reinit_unit: 0 Jul 24 08:04:15 Rechner B kernel: ippp, open, slot: 3, minor: 4, state: 0000 Jul 24 08:04:15 Rechner B kernel: ippp_ccp: allocated reset data structure c4d97800 Jul 24 08:04:15 Rechner B isdnlog: Jul 24 08:04:15 Call to tei 78 from +49 371/Telnummer Rechner A, Chemnitz on +49 371/Telnummer Rechner B, Chemnitz HANGUP ( 0:00:46 I=198.0 b O=646.0 b) ########################################################## Logfile 2: Rechner A wenn B Server und A Anrufer: Jul 24 08:06:53 Rechner A kernel: ippp2: dialing 1 Telnummer Rechner B... Jul 24 08:06:55 Rechner A kernel: ippp2: hangup waiting for callback ... Jul 24 08:06:59 Rechner A kernel: isdn_net: call from Telnummer Rechner B,7,0 -> Telnummer Rechner A Jul 24 08:06:59 Rechner A kernel: ippp2: call from Telnummer Rechner B -> Telnummer Rechner A accepted Jul 24 08:06:59 Rechner A kernel: isdn_ppp_free 2 c5e1ea00 c5e1ea00 Jul 24 08:06:59 Rechner A kernel: isdn: HiSax,ch0 cause: E0565 Jul 24 08:07:07 Rechner A kernel: isdn_net: local hangup ippp2 ########################################################## Logfile 4: Rechner B (die Zeit weicht etwas ab, aber die Ergebnisse sind die gleichen) Jul 24 08:08:26 Rechner B kernel: isdn_net: call from Telnummer Rechner A,7,0 -> Telnummer Rechner B Jul 24 08:08:26 Rechner B kernel: ippp4: call from Telnummer Rechner A -> Telnummer Rechner B, start callback Jul 24 08:08:26 Rechner B kernel: isdn: Rejecting Call Jul 24 08:08:26 Rechner B isdnlog: Jul 24 08:08:26 * Call to tei 127 from +49 371/Telnummer Rechner A, Chemnitz on +49 371/Telnummer Rechner B, Chemnitz RING (Data) Jul 24 08:08:26 Rechner B isdnlog: Jul 24 08:08:26 * Call to tei 78 from +49 371/Telnummer Rechner A, Chemnitz on +49 371/Telnummer Rechner B, Chemnitz HANGUP Call rejected (User) Jul 24 08:08:32 Rechner B kernel: ippp4: dialing 1 Telnummer Rechner A... Jul 24 08:08:32 Rechner B isdnlog: Jul 24 08:08:32 * tei 78 calling +49 371/Telnummer Rechner A, Chemnitz with +49 371/Telnummer Rechner B, Chemnitz RING (Data) Jul 24 08:08:32 Rechner B isdnlog: Jul 24 08:08:32 tei 78 calling +49 371/Telnummer Rechner A, Chemnitz with +49 371/Telnummer Rechner B, Chemnitz Time:Wed Jul 24 08:07:00 2002 Jul 24 08:08:32 Rechner B isdnlog: Jul 24 08:08:32 tei 78 calling +49 371/Telnummer Rechner A, Chemnitz with +49 371/Telnummer Rechner B, Chemnitz COLP +49 371/Telnummer Rechner A, Chemnitz Jul 24 08:08:32 Rechner B isdnlog: Jul 24 08:08:32 tei 78 calling +49 371/Telnummer Rechner A, Chemnitz with +49 371/Telnummer Rechner B, Chemnitz CONNECT (Data) Jul 24 08:08:32 Rechner B isdnlog: Jul 24 08:08:32 tei 78 calling +49 371/Telnummer Rechner A, Chemnitz with +49 371/Telnummer Rechner B, Chemnitz CHARGE: 0.120 DM/90s = 0.080 DM/Min (DTAG ISDN, City, Werktag (Mittwoch), Wochentag) Jul 24 08:08:32 Rechner B isdnlog: Jul 24 08:08:32 tei 78 calling +49 371/Telnummer Rechner A, Chemnitz with +49 371/Telnummer Rechner B, Chemnitz HINT: Better use 01030:TelDaFax, 0.001 DM/1s = 0.039 DM/Min, saving 0.055 DM/Min Jul 24 08:08:32 Rechner B isdnlog: Jul 24 08:08:32 tei 78 calling +49 371/Telnummer Rechner A, Chemnitz with +49 371/Telnummer Rechner B, Chemnitz 1.CI 0.120 DM (now) Jul 24 08:08:32 Rechner B isdnlog: Jul 24 08:08:32 tei 78 calling +49 371/Telnummer Rechner A, Chemnitz with +49 371/Telnummer Rechner B, Chemnitz NEXT CI AFTER 01:30 (DTAG ISDN, City, Werktag (Mittwoch), Wochentag) Jul 24 08:08:32 Rechner B isdnlog: Jul 24 08:08:32 tei 78 calling +49 371/Telnummer Rechner A, Chemnitz with +49 371/Telnummer Rechner B, Chemnitz Normal, unspecified (Private network serving local user) Jul 24 08:08:32 Rechner B isdnlog: Jul 24 08:08:32 tei 78 calling +49 371/Telnummer Rechner A, Chemnitz with +49 371/Telnummer Rechner B, Chemnitz HINT: Cheapest booked 01030:TelDaFax 0.100 DM (would save 0.020 DM) Jul 24 08:08:32 Rechner B isdnlog: Jul 24 08:08:32 tei 78 calling +49 371/Telnummer Rechner A, Chemnitz with +49 371/Telnummer Rechner B, Chemnitz HINT: Overall cheapest 01033:DTAG AktivPlus 0.090 DM (would save 0.030 DM) Jul 24 08:08:32 Rechner B isdnlog: Jul 24 08:08:32 tei 78 calling +49 371/Telnummer Rechner A, Chemnitz with +49 371/Telnummer Rechner B, Chemnitz HINT: LCR:FAILED Jul 24 08:08:32 Rechner B isdnlog: Jul 24 08:08:32 tei 78 calling +49 371/Telnummer Rechner A, Chemnitz with +49 371/Telnummer Rechner B, Chemnitz HANGUP (1 CI 0.120 DM) Jul 24 08:08:Telnummer Rechner B Rechner B kernel: isdn_net: local hangup ippp4 Jul 24 08:08:Telnummer Rechner B Rechner B kernel: isdn_ppp_free 3 c4a67200 c4a67200 Jul 24 08:08:Telnummer Rechner B Rechner B kernel: ippp4: Chargesum is 0
On Wed, Jul 24, 2002 at 09:37:08AM +0200, Detlef Richter wrote:
Hallo Karsten, habe heute mal ein bisschen mit den callback-delays herumgespielt, und es funktioniert auch, aber leider nur in die falsche Richtung, also wenn A der Server ist und B zuerst anruft. Anders herum kann ich das delay hochsetzen wie ich will, es klappt einfach nicht. Ich weiss langsam nicht mehr, an welcher Stelle ich noch suchen soll. Hänge mal die Logfiles mit an (Sorry dass sie so lang sind, aber ich wollte nichts Wichtiges aus Versehen rausschneiden).
Schick das besser als pmail und nicht an die Liste.
Logfiles 1 und 2: Rechner A callback in, cbdelay 5, Rechner B callback out, cbdelay 2 Logfiles 3 und 4: Rechner A callback out, cbdelay 2, Rechner B callback in, cbdelay 5 (hab's auch schon mit 10 versucht)
10 ist zwecklos 5 muss reichen.
Alles andere ist gleich, keine veränderten Nummern o.ä. Hast Du noch eine Idee?
Nein, aber vielleicht sehe ich was bei einem detailierten Log. Dazu auf beiden Seiten: killall isdnlog hisaxctrl <id> 1 0x33ff hisaxctrl <id> 11 0xf4f cat /dev/isdnctrl >/tmp/ilog Die Files direkt an mich, kann eh kein anderer lesen :-) -- Karsten Keil SuSE Labs ISDN development
participants (3)
-
Detlef Richter -
Jan Girlich -
Karsten Keil