Hallo isdn'ler! Auf meinem Server stürzt in letzter Zeit plötzlich das ISDN-Sytem ab, und zwar so, dass nur ein reboot hilft. Die Symptome: Zunächst laufen alle Treiber und ippd's korrekt, ich habe 2 dialin (ippp0 und ippp1) und eine dialout-Nummer (ippp2) auf zwei Leitungen konfiguriert. Irgendwann im Laufe von etwa 10 Tagen nach dem reboot passiert dann folgendes: eben noch konnte man surfen, sich einwählen etc, plötzlich sind alle isdn-Dienste tot. Alle ipppd laufen jedoch noch. Zudem versucht sich der Rechner auch bei T-Online einzuwählen. Die Verbindung wird aufgenommen, ipppd stoppt jedoch mit LCP-Timout (s.unten). Bei der Einwahl (leider auch der Fernwartung) hebt die Karte ab und die Verbindung wird erstellt, ippd stoppt jedoch auch mit LCP Timeout. Man kann die ipppd und isdnlog stoppen (mit killall), Ein rcisdn restart (suse 8.0, vanilla kernel 2.4.19) kann die isdn-Module jedoch nicht entladen. rmmod funktioniert nicht. Nur ein Reboot hilft. Ich habe anbei mal die letzte funktionierende Verbindung und weitere nicht funktionierende in einer ungekürzen Log-Datei angehängt. Meine Kommentare beginnen mit -- Hier kommt es scheinbar gleichzeitig zu einer ANwahl von t-Online und einer Einwahl. Dann legt der Server wegen huptimeout auf. Für mich sieht es dann so aus, als ob während der Auflegephase schon eine neue t-online-Vernindung gestartet wird. Danach versucht der Rechner rauszuwählen. Die Verbindung kommt zustande, wird jedoch mit LCP-fail beendet. Später kommt dann noch ein "HL driver queue full" hinzu. Was ist hier falsch und wie komme ich drumrum? Danke und Grüße Ulf -- funktionierende auswahl t-online May 21 13:56:22 gertusvr kernel: ippp2: dialing 1 0191011... May 21 13:56:22 gertusvr isdnlog: May 21 13:56:22 * tei 71 calling 0191011 with gertusvr RING (Data) May 21 13:56:24 gertusvr ipppd[544]: Local number: xxxxxx, Remote number: 0191011, Type: outgoing May 21 13:56:24 gertusvr ipppd[544]: PHASE_WAIT -> PHASE_ESTABLISHED, ifunit: 2, linkunit: 0, fd: 7 May 21 13:56:24 gertusvr kernel: isdn_net: ippp2 connected May 21 13:56:24 gertusvr isdnlog: May 21 13:56:24 tei 71 calling 0191011 with gertusvr Time:Wed May 21 12:50:00 2003 May 21 13:56:24 gertusvr isdnlog: May 21 13:56:24 tei 71 calling 0191011 with gertusvr CONNECT (Data) May 21 13:56:24 gertusvr isdnlog: May 21 13:56:24 tei 71 calling 0191011 with gertusvr INTERFACE ippp2 calling 0191011 May 21 13:56:24 gertusvr isdnlog: May 21 13:56:24 tei 71 calling 0191011 with gertusvr CHARGE: 0.015 EUR/60s = 0.015 EUR/Min (DTAG T-ISDN Standard, T-Online, täglich, eco) May 21 13:56:24 gertusvr isdnlog: May 21 13:56:24 tei 71 calling 0191011 with gertusvr 1.CI 0.015 EUR (now) May 21 13:56:24 gertusvr isdnlog: May 21 13:56:24 tei 71 calling 0191011 with gertusvr NEXT CI AFTER 01:00 (DTAG T-ISDN Standard, T-Online, täglich, eco) May 21 13:56:24 gertusvr ipppd[544]: Remote message: May 21 13:56:24 gertusvr ipppd[544]: MPPP negotiation, He: No We: No May 21 13:56:24 gertusvr ipppd[544]: CCP enabled! Trying CCP. May 21 13:56:24 gertusvr ipppd[544]: CCP: got ccp-unit 0 for link 0 (Compression Control Protocol) May 21 13:56:24 gertusvr ipppd[544]: ccp_resetci! May 21 13:56:24 gertusvr ipppd[544]: ccp_resetci! May 21 13:56:24 gertusvr kernel: Received CCP frame from peer May 21 13:56:24 gertusvr kernel: [2/2].ccp-rcv[0]: 01 01 00 09 11 05 00 01 04 May 21 13:56:24 gertusvr kernel: Received CCP frame from daemon: May 21 13:56:24 gertusvr kernel: [2/2].ccp-xmit[0]: ff 03 80 fd 01 01 00 04 May 21 13:56:24 gertusvr kernel: Received CCP frame from daemon: May 21 13:56:24 gertusvr kernel: [2/2].ccp-xmit[0]: ff 03 80 fd 04 01 00 09 11 05 00 01 04 May 21 13:56:24 gertusvr kernel: Received CCP frame from peer May 21 13:56:24 gertusvr kernel: [2/2].ccp-rcv[0]: 04 01 00 04 May 21 13:56:24 gertusvr ipppd[544]: ccp_resetci! May 21 13:56:24 gertusvr kernel: Received CCP frame from peer May 21 13:56:24 gertusvr kernel: [2/2].ccp-rcv[0]: 01 02 00 0a 11 06 00 01 01 03 May 21 13:56:24 gertusvr kernel: Received CCP frame from daemon: May 21 13:56:24 gertusvr kernel: [2/2].ccp-xmit[0]: ff 03 80 fd 01 02 00 04 May 21 13:56:24 gertusvr kernel: Received CCP frame from daemon: May 21 13:56:24 gertusvr kernel: [2/2].ccp-xmit[0]: ff 03 80 fd 04 02 00 0a 11 06 00 01 01 03 May 21 13:56:24 gertusvr ipppd[544]: local IP address 217.2.153.101 May 21 13:56:24 gertusvr ipppd[544]: remote IP address 217.5.121.177 May 21 13:56:24 gertusvr kernel: Received CCP frame from peer May 21 13:56:24 gertusvr kernel: [2/2].ccp-rcv[0]: 04 02 00 04 May 21 13:56:24 gertusvr ip-up: FW_ALLOW_INCOMING_HIGHPORTS_UDP should be set to yes, if you are running a DNS server! May 21 13:56:26 gertusvr SuSEfirewall2: Firewall rules successfully set from /etc/sysconfig/SuSEfirewall2 May 21 13:56:26 gertusvr logger: ip-up.local started with ippp2 /dev/ippp2 0 217.2.153.101 217.5.121.177 May 21 13:56:26 gertusvr logger: sending and receiving emails May 21 13:57:24 gertusvr isdnlog: May 21 13:57:24 tei 71 calling 0191011 with gertusvr 2.CI 0.030 EUR (after 0:01:00) -- einwahl von ausserhalb May 21 13:58:12 gertusvr kernel: ippp1: call from xxxxxxxxxx -> xxxxxx accepted May 21 13:58:12 gertusvr isdnlog: May 21 13:58:12 * Call to tei 127 from Gertus_NI on gertusvr RING (Data) May 21 13:58:12 gertusvr isdnlog: May 21 13:58:12 Call to tei 71 from Gertus_NI on gertusvr CONNECT (Data) May 21 13:58:12 gertusvr isdnlog: May 21 13:58:12 Call to tei 71 from Gertus_NI on gertusvr INTERFACE ippp1 called by 7663912446 May 21 13:58:12 gertusvr isdnlog: May 21 13:58:12 tei 71 calling 0191011 with gertusvr INTERFACE ippp2 calling 0191011 May 21 13:58:12 gertusvr ipppd[495]: Local number: 590049, Remote number: , Type: incoming May 21 13:58:12 gertusvr ipppd[495]: PHASE_WAIT -> PHASE_ESTABLISHED, ifunit: 1, linkunit: 0, fd: 7 May 21 13:58:12 gertusvr kernel: isdn_net: ippp1 connected May 21 13:58:16 gertusvr ipppd[495]: MPPP negotiation, He: No We: No May 21 13:58:16 gertusvr ipppd[495]: CCP enabled! Trying CCP. May 21 13:58:16 gertusvr ipppd[495]: CCP: got ccp-unit 0 for link 0 (Compression Control Protocol) May 21 13:58:16 gertusvr ipppd[495]: ccp_resetci! May 21 13:58:16 gertusvr ipppd[495]: local IP address 192.168.0.254 May 21 13:58:16 gertusvr ipppd[495]: remote IP address 192.168.1.6 May 21 13:58:16 gertusvr logger: ip-up.local started with ippp1 /dev/ippp1 0 192.168.0.254 192.168.1.6 May 21 13:58:23 gertusvr sshd[26294]: Accepted password for gertus from 192.168.1.5 port 1138 May 21 13:58:27 gertusvr isdnlog: May 21 13:58:27 tei 71 calling 0191011 with gertusvr 3.CI 0.044 EUR (after 0:02:03) May 21 13:59:00 gertusvr /USR/SBIN/CRON[26321]: (root) CMD ( rm -f /var/spool/cron/lastrun/cron.hourly) May 21 13:59:25 gertusvr isdnlog: May 21 13:59:25 tei 71 calling 0191011 with gertusvr 4.CI 0.059 EUR (after 0:03:01) May 21 13:59:25 gertusvr isdnlog: May 21 13:59:25 Call to tei 71 from Gertus_NI on gertusvr Normal call clearing (User) -- ende Einwahl von ausserhalb nMay 21 13:59:25 gertusvr ipppd[495]: Modem hangup May 21 13:59:25 gertusvr ipppd[495]: Connection terminated. May 21 13:59:25 gertusvr ipppd[495]: taking down PHASE_DEAD link 0, linkunit: 0 May 21 13:59:25 gertusvr ipppd[495]: closing fd 7 from unit 0 May 21 13:59:25 gertusvr ipppd[495]: link 0 closed , linkunit: 0 May 21 13:59:25 gertusvr ipppd[495]: reinit_unit: 0 May 21 13:59:25 gertusvr ipppd[495]: Connect[0]: /dev/ippp1, fd: 7 May 21 13:59:25 gertusvr kernel: ippp1: remote hangup May 21 13:59:25 gertusvr kernel: ippp1: Chargesum is 0 May 21 13:59:25 gertusvr kernel: ippp, open, slot: 3, minor: 1, state: 0000 May 21 13:59:25 gertusvr kernel: ippp_ccp: allocated reset data structure c1f6f000 May 21 13:59:25 gertusvr isdnlog: May 21 13:59:25 Call to tei 71 from Gertus_NI on gertusvr HANGUP ( 0:01:13 I= 7.1Kb O= 11.9Kb) May 21 13:59:25 gertusvr kernel: ippp_ccp: freeing reset data structure c4505800 May 21 13:59:25 gertusvr logger: ip-down.local started with ippp1 /dev/ippp1 0 192.168.0.254 192.168.1.6 -- hier wird scheinbar ippp2 aufgelegt. May 21 14:00:00 gertusvr ipppd[544]: Modem hangup May 21 14:00:00 gertusvr ipppd[544]: Connection terminated. May 21 14:00:00 gertusvr ipppd[544]: taking down PHASE_DEAD link 0, linkunit: 0 May 21 14:00:00 gertusvr ipppd[544]: closing fd 7 from unit 0 May 21 14:00:00 gertusvr ipppd[544]: link 0 closed , linkunit: 0 May 21 14:00:00 gertusvr ipppd[544]: reinit_unit: 0 May 21 14:00:00 gertusvr ipppd[544]: Connect[0]: /dev/ippp2, fd: 7 May 21 14:00:00 gertusvr isdnlog: May 21 14:00:00 tei 71 calling 0191011 with gertusvr Normal call clearing (User) May 21 14:00:00 gertusvr kernel: isdn_net: local hangup ippp2 May 21 14:00:00 gertusvr kernel: ippp2: Chargesum is 0 May 21 14:00:00 gertusvr kernel: ippp, open, slot: 1, minor: 2, state: 0000 May 21 14:00:00 gertusvr kernel: ippp_ccp: allocated reset data structure c5fa7000 May 21 14:00:00 gertusvr kernel: ippp_ccp: freeing reset data structure ce4c4800 May 21 14:00:00 gertusvr logger: hangup! May 21 14:00:00 gertusvr ip-down: FW_ALLOW_INCOMING_HIGHPORTS_UDP should be set to yes, if you are running a DNS server! -- und gleich wieder angewält... May 21 14:00:00 gertusvr isdnlog: May 21 14:00:00 tei 71 calling 0191011 with gertusvr HANGUP (4 CI 0.059 EUR 0:03:36 I= 46.6Kb O=488.8Kb) May 21 14:00:01 gertusvr kernel: ippp2: dialing 1 0191011... May 21 14:00:01 gertusvr isdnlog: May 21 14:00:01 * tei 71 calling 0191011 with gertusvr RING (Data) May 21 14:00:03 gertusvr ipppd[544]: Local number: xxxxxx, Remote number: 0191011, Type: outgoing May 21 14:00:03 gertusvr ipppd[544]: PHASE_WAIT -> PHASE_ESTABLISHED, ifunit: 2, linkunit: 0, fd: 7 May 21 14:00:03 gertusvr kernel: isdn_net: ippp2 connected May 21 14:00:03 gertusvr isdnlog: May 21 14:00:03 tei 71 calling 0191011 with gertusvr Time:Wed May 21 12:53:00 2003 May 21 14:00:03 gertusvr isdnlog: May 21 14:00:03 tei 71 calling 0191011 with gertusvr CONNECT (Data) May 21 14:00:03 gertusvr isdnlog: May 21 14:00:03 tei 71 calling 0191011 with gertusvr INTERFACE ippp2 calling 0191011 May 21 14:00:03 gertusvr isdnlog: May 21 14:00:03 tei 71 calling 0191011 with gertusvr CHARGE: 0.015 EUR/60s = 0.015 EUR/Min (DTAG T-ISDN Standard, T-Online, täglich, eco) May 21 14:00:03 gertusvr isdnlog: May 21 14:00:03 tei 71 calling 0191011 with gertusvr 1.CI 0.015 EUR (now) May 21 14:00:03 gertusvr isdnlog: May 21 14:00:03 tei 71 calling 0191011 with gertusvr NEXT CI AFTER 01:00 (DTAG T-ISDN Standard, T-Online, täglich, eco) May 21 14:00:03 gertusvr kernel: SuSE-FW-UNAUTHORIZED-ROUTING IN=eth0 OUT=ippp2 SRC=192.168.0.6 DST=194.25.134.88 LEN=1500 TOS=0x00 PREC=0x00 TTL=127 ID=38021 DF PROTO=TCP SPT=2020 DPT=25 WINDOW=8572 RES=0x00 ACK URGP=0 May 21 14:00:04 gertusvr SuSEfirewall2: Firewall rules successfully set from /etc/sysconfig/SuSEfirewall2 -- hier läuft erst das Skript ip-down. Die neue Verbindung scheint schon im beginn zu sein May 21 14:00:04 gertusvr logger: ip-down.local started with ippp2 /dev/ippp2 0 217.2.153.101 217.5.121.177 May 21 14:00:04 gertusvr logger: holding mail back -- und hier dann der erste fatale Fehler. Ab hier bis zum Reboot funktioniert keine isdn-Verbindung mehr May 21 14:00:33 gertusvr ipppd[544]: LCP: timeout sending Config-Requests May 21 14:00:33 gertusvr ipppd[544]: Connection terminated. May 21 14:00:33 gertusvr ipppd[544]: taking down PHASE_DEAD link 0, linkupnit: 0 May 21 14:00:33 gertusvr ipppd[544]: closing fd 7 from unit 0 May 21 14:00:33 gertusvr ipppd[544]: link 0 closed , linkunit: 0 May 21 14:00:33 gertusvr ipppd[544]: reinit_unit: 0 May 21 14:00:33 gertusvr ipppd[544]: Connect[0]: /dev/ippp2, fd: 7 May 21 14:00:33 gertusvr isdnlog: May 21 14:00:33 tei 71 calling 0191011 with gertusvr Normal call clearing (User) May 21 14:00:33 gertusvr kernel: isdn_net: local hangup ippp2 May 21 14:00:33 gertusvr kernel: ippp2: Chargesum is 0 May 21 14:00:33 gertusvr kernel: ippp_ccp: freeing reset data structure c5fa7000 May 21 14:00:33 gertusvr kernel: ippp, open, slot: 1, minor: 2, state: 0000 May 21 14:00:33 gertusvr kernel: ippp_ccp: allocated reset data structure c5fa7000 May 21 14:00:33 gertusvr isdnlog: May 21 14:00:33 tei 71 calling 0191011 with gertusvr HANGUP (1 CI 0.015 EUR 0:00:30) May 21 14:00:40 gertusvr isdnlog: May 21 14:00:40 * tei 71 calling 0191011 with gertusvr RING (Data) May 21 14:00:40 gertusvr kernel: NETDEV WATCHDOG: ippp2: transmit timed out May 21 14:00:40 gertusvr kernel: isdn_tx_timeout dev ippp2 dialstate 0 May 21 14:00:40 gertusvr kernel: ippp2: dialing 1 0191011... May 21 14:00:42 gertusvr ipppd[544]: Local number: xxxxxx, Remote number: 0191011, Type: outgoing May 21 14:00:42 gertusvr ipppd[544]: PHASE_WAIT -> PHASE_ESTABLISHED, ifunit: 2, linkunit: 0, fd: 7 May 21 14:00:42 gertusvr kernel: isdn_net: ippp2 connected May 21 14:00:42 gertusvr isdnlog: May 21 14:00:42 tei 71 calling 0191011 with gertusvr Time:Wed May 21 12:54:00 2003 May 21 14:00:42 gertusvr isdnlog: May 21 14:00:42 tei 71 calling 0191011 with gertusvr CONNECT (Data) May 21 14:00:42 gertusvr isdnlog: May 21 14:00:42 tei 71 calling 0191011 with gertusvr INTERFACE ippp2 calling 0191011 May 21 14:00:42 gertusvr isdnlog: May 21 14:00:42 tei 71 calling 0191011 with gertusvr CHARGE: 0.015 EUR/60s = 0.015 EUR/Min (DTAG T-ISDN Standard, T-Online, täglich, eco) May 21 14:00:42 gertusvr isdnlog: May 21 14:00:42 tei 71 calling 0191011 with gertusvr 1.CI 0.015 EUR (now) May 21 14:00:42 gertusvr isdnlog: May 21 14:00:42 tei 71 calling 0191011 with gertusvr NEXT CI AFTER 01:00 (DTAG T-ISDN Standard, T-Online, täglich, eco) May 21 14:01:12 gertusvr ipppd[544]: LCP: timeout sending Config-Requests May 21 14:01:12 gertusvr ipppd[544]: Connection terminated. May 21 14:01:12 gertusvr ipppd[544]: taking down PHASE_DEAD link 0, linkunit: 0 May 21 14:01:12 gertusvr ipppd[544]: closing fd 7 from unit 0 May 21 14:01:12 gertusvr ipppd[544]: link 0 closed , linkunit: 0 May 21 14:01:12 gertusvr ipppd[544]: reinit_unit: 0 May 21 14:01:12 gertusvr ipppd[544]: Connect[0]: /dev/ippp2, fd: 7 May 21 14:01:12 gertusvr isdnlog: May 21 14:01:12 tei 71 calling 0191011 with gertusvr Normal call clearing (User) May 21 14:01:12 gertusvr kernel: isdn_net: local hangup ippp2 May 21 14:01:12 gertusvr kernel: ippp2: Chargesum is 0 May 21 14:01:12 gertusvr kernel: ippp_ccp: freeing reset data structure c5fa7000 May 21 14:01:12 gertusvr kernel: ippp, open, slot: 1, minor: 2, state: 0000 May 21 14:01:12 gertusvr kernel: ippp_ccp: allocated reset data structure c5fa7000 May 21 14:01:12 gertusvr isdnlog: May 21 14:01:12 tei 71 calling 0191011 with gertusvr HANGUP (1 CI 0.015 EUR 0:00:30) May 21 14:01:20 gertusvr isdnlog: May 21 14:01:20 * tei 71 calling 0191011 with gertusvr RING (Data) May 21 14:01:20 gertusvr kernel: NETDEV WATCHDOG: ippp2: transmit timed out May 21 14:01:20 gertusvr kernel: isdn_tx_timeout dev ippp2 dialstate 0