Hilfe - pppd friert freetz-box ein

[peter_kre]

Moin moin,

ich habe eine gefreezte 16MB 7270 mit freetz 1.2 TRUNK (1.1.2 selber Effekt !)

Als Pakete habe ich im wesentlichen syslogd, iptables, ppp, pptp drauf. svn update ist von heute, also aktuell.

Leider bringt der pppd beim Aufbau einer pptp Verbindung zu einem entfernten Windows PPTP Server die Box so sehr durcheinander, das sie glatt einfriert und nur noch durch Reset wieder zum Leben erweckt werden kann. Ich weiß nicht, wie ich weiter debuggen soll, denn alle telnet Sitzungen hängen und auch das http-Gui funktioniert nicht mehr, nachdem ich pppd nodetach call dun gestartet habe.

Ausgabe von pppd dryrun

Feb  9 21:26:16 fritz daemon.info pppd[1843]: pppd options in effect:
Feb  9 21:26:16 fritz daemon.info pppd[1843]: debug             # (from /etc/ppp/options.pptp)
Feb  9 21:26:16 fritz daemon.info pppd[1843]: kdebug 7          # (from /etc/ppp/peers/dun)
Feb  9 21:26:16 fritz daemon.info pppd[1843]: nodetach          # (from command line)
Feb  9 21:26:16 fritz daemon.info pppd[1843]: dryrun            # (from command line)
Feb  9 21:26:16 fritz daemon.info pppd[1843]: noauth            # (from /etc/ppp/options.pptp)
Feb  9 21:26:16 fritz daemon.info pppd[1843]: refuse-pap                # (from /etc/ppp/peers/dun)
Feb  9 21:26:16 fritz daemon.info pppd[1843]: refuse-chap               # (from /etc/ppp/peers/dun)
Feb  9 21:26:16 fritz daemon.info pppd[1843]: refuse-mschap             # (from /etc/ppp/peers/dun)
Feb  9 21:26:16 fritz daemon.info pppd[1843]: refuse-eap                # (from /etc/ppp/peers/dun)
Feb  9 21:26:16 fritz daemon.info pppd[1843]: user abcdefg         # (from /etc/ppp/peers/dun)
Feb  9 21:26:16 fritz daemon.info pppd[1843]: password ??????           # (from /etc/ppp/peers/dun)
Feb  9 21:26:16 fritz daemon.info pppd[1843]: remotename pptp           # (from /etc/ppp/peers/dun)
Feb  9 21:26:16 fritz daemon.info pppd[1843]:           # (from /etc/ppp/options.pptp)
Feb  9 21:26:16 fritz daemon.info pppd[1843]: pty pptp a.b.c.d --nolaunchpppd              # (from /etc/ppp/peers/dun)
Feb  9 21:26:16 fritz daemon.info pppd[1843]: ipcp-accept-local         # (from /etc/ppp/peers/dun)
Feb  9 21:26:16 fritz daemon.info pppd[1843]: ipcp-accept-remote                # (from /etc/ppp/peers/dun)
Feb  9 21:26:16 fritz daemon.info pppd[1843]: ipparam pptp              # (from /etc/ppp/peers/dun)
Feb  9 21:26:16 fritz daemon.info pppd[1843]: nodefaultroute            # (from /etc/ppp/peers/dun)
Feb  9 21:26:16 fritz daemon.info pppd[1843]: noproxyarp                # (from /etc/ppp/peers/dun)
Feb  9 21:26:16 fritz daemon.info pppd[1843]: mppe xxx # [don't know how to print value]                # (from /etc/ppp/options.pptp)
Feb  9 21:26:16 fritz daemon.info pppd[1843]: Exit.

Hier ein Abschnitt aus der Console:

/var/mod/root # pppd nodetach  call dun       
using channel 1
Using interface ppp0
Connect: ppp0 <--> /dev/pts/3
sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0xecaf0896> <pcomp> <accomp>]
rcvd [LCP ConfReq id=0x1 <mru 1000> <asyncmap 0x0> <auth chap MS-v2> <magic 0x634c4866> <pcomp> <accomp>]
sent [LCP ConfAck id=0x1 <mru 1000> <asyncmap 0x0> <auth chap MS-v2> <magic 0x634c4866> <pcomp> <accomp>]
rcvd [LCP ConfReq id=0x1 <mru 1000> <asyncmap 0x0> <auth chap MS-v2> <magic 0x634c4866> <pcomp> <accomp>]
sent [LCP ConfAck id=0x1 <mru 1000> <asyncmap 0x0> <auth chap MS-v2> <magic 0x634c4866> <pcomp> <accomp>]
rcvd [LCP ConfAck id=0x1 <asyncmap 0x0> <magic 0xecaf0896> <pcomp> <accomp>]
rcvd [LCP EchoReq id=0x0 magic=0x634c4866]
sent [LCP EchoRep id=0x0 magic=0xecaf0896]
rcvd [CHAP Challenge id=0x4b <f081dd02f6398ae16595620a93248807>, name = "YYYYYYYYYY"]
sent [CHAP Response id=0x4b <4ef631f9fc20f12ca94206746bea1c45000000000000000082370c122ec99adb6e24d943d6badf4a64632b9ecf538fe400>, name = "XXXXXXXXXXXXX"]
rcvd [CHAP Success id=0x4b "S=2603EC6399D1E39C730DF3A79495791B4B8379BC M=Access granted"]
CHAP authentication succeeded
sent [CCP ConfReq id=0x1 <mppe +H +M +S +L -D +C>]
rcvd [CCP ConfReq id=0x1 <mppe +H -M +S +L -D -C>]
sent [CCP ConfNak id=0x1 <mppe +H -M +S -L -D -C>]
rcvd [CCP ConfNak id=0x1 <mppe +H -M +S -L -D -C>]
sent [CCP ConfReq id=0x2 <mppe +H -M +S -L -D -C>]
rcvd [CCP ConfReq id=0x2 <mppe +H -M +S -L -D -C>]
sent [CCP ConfAck id=0x2 <mppe +H -M +S -L -D -C>]
rcvd [CCP ConfAck id=0x2 <mppe +H -M +S -L -D -C>]
MPPE 128-bit stateless compression enabled
sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 192.168.69.254>]
rcvd [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 192.168.44.11>]
sent [IPCP ConfAck id=0x1 <compress VJ 0f 01> <addr 192.168.44.11>]
rcvd [IPCP ConfNak id=0x1 <addr 192.168.45.11>]
sent [IPCP ConfReq id=0x2 <compress VJ 0f 01> <addr 192.168.45.11>]
rcvd [IPCP ConfAck id=0x2 <compress VJ 0f 01> <addr 192.168.45.11>]
local  IP address 192.168.45.11
remote IP address 192.168.44.11

und /var/log/messages

Feb  9 21:27:18 fritz daemon.notice pppd[1844]: pppd 2.4.5 started by root, uid 0
Feb  9 21:27:18 fritz daemon.debug pppd[1844]: using channel 1
Feb  9 21:27:18 fritz daemon.info pppd[1844]: Using interface ppp0
Feb  9 21:27:18 fritz daemon.notice pppd[1844]: Connect: ppp0 <--> /dev/pts/3
Feb  9 21:27:18 fritz daemon.notice pptp[1846]: anon log[main:pptp.c:314]: The synchronous pptp option is NOT activated
Feb  9 21:27:18 fritz daemon.notice pptp[1853]: anon log[ctrlp_rep:pptp_ctrl.c:251]: Sent control packet type is 1 'Start-Control-Connection-Request'
Feb  9 21:27:19 fritz daemon.notice pptp[1853]: anon log[ctrlp_disp:pptp_ctrl.c:739]: Received Start Control Connection Reply
Feb  9 21:27:19 fritz daemon.notice pptp[1853]: anon log[ctrlp_disp:pptp_ctrl.c:773]: Client connection established.
Feb  9 21:27:19 fritz daemon.debug pppd[1844]: sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0xecaf0896> <pcomp> <accomp>]
Feb  9 21:27:19 fritz daemon.notice pptp[1853]: anon log[ctrlp_rep:pptp_ctrl.c:251]: Sent control packet type is 7 'Outgoing-Call-Request'
Feb  9 21:27:20 fritz daemon.notice pptp[1853]: anon log[ctrlp_disp:pptp_ctrl.c:858]: Received Outgoing Call Reply.
Feb  9 21:27:20 fritz daemon.notice pptp[1853]: anon log[ctrlp_disp:pptp_ctrl.c:897]: Outgoing call established (call ID 0, peer's call ID 14208).
Feb  9 21:27:20 fritz daemon.debug pppd[1844]: rcvd [LCP ConfReq id=0x1 <mru 1000> <asyncmap 0x0> <auth chap MS-v2> <magic 0x634c4866> <pcomp> <accomp>]
Feb  9 21:27:20 fritz daemon.debug pppd[1844]: sent [LCP ConfAck id=0x1 <mru 1000> <asyncmap 0x0> <auth chap MS-v2> <magic 0x634c4866> <pcomp> <accomp>]

cat /dev/debug gibt leider gar nichts her !

Die letzte Meldung ist remote IP address 192.168.44.11, danach ist die Box absolut nicht mehr erreichbar. Erst ausschalten weckt sie wieder auf.

iptables an- oder abschalten bringt überhaupt nichts.

freetz 1.1.2 verhält sich übrigens ganz genau so !

Hat jemand noch eine Idee, wo ich zusätzliche Debug Informationen herkriegen könnte bzw. wie ich sehen könnte, warum gleich die ganze Box inklusive Telefonie einfriert ?

Einen schönen Abend,

Peter

 

[peter_kre]

Habe gerade per tcpdump versucht herauszufinden, ob die Box kurz vor dem Komplettaufhänger noch seltsame Pakete verschickt - nichts...

 

[peter_kre]

strace bringt leider auch keine neuen Erkenntnisse, die Ausgabe bleibt mitten in der Zeile stehen, weil sich die ganze Box einfach aufhängt

ioctl(10, PPPIOCSMAXCID, 0x7ff3b974)    = 0
ioctl(10, PPPIOCGFLAGS or JFFS_PRINT_HASH, 0x7ff3b928) = 0
ioctl(10, PPPIOCSFLAGS, 0x7ff3b928)     = 0
ioctl(6, 0x8912, {160, {{"lo", {AF_INET, inet_addr("127.0.0.1")}}, {"eth0", {AF_INET, inet_addr("192.168.69.254")}}, {"eth0:0", {AF_INET, inet_addr("169.254.1.1")}}, {"wlan", {AF_INET, inet_addr("192.168.182.1")}}, {"dsl", {AF_INET, inet_addr("169.254.2.1")}}}}) = 0
ioctl(6, 0x8916, 0x7ff3b8d0)            = 0
ioctl(6, 0x8918, 0x7ff3b8d0)            = 0
ioctl(6, 0x891c, 0x7ff3b8d0)            = 0
stat64(0x43c844, 0x7ff3b748)            = -1 ENOENT (No such file or directory)
ioctl(6, 0x8913, {ifr_name="ppp0", ifr_flags=IFF_POINTOPOINT|IFF_NOARP|IFF_MULTICAST}) = 0
ioctl(6, 0x8914

 

[RalfFriedl]

Du könntest eine serielle Konsole anschließen. Damit wäre aber vermutlich die Garantie weg.

 

[markuschen]

Mit den Logs kann man leider nicht so viel anfangen, mein pptp und ppp läuft absolut problemlos -> mit bis zu 6 Clients gleichzeitig (Win XP und Windows 7)!

 

[cuma]

Ist in deinem Freetz die libpcap 1.0 drin? Die wird mindestens von knockd, tcpdump und nmap genutzt. Ich hatte damit einige probleme. VIELLEICHT hat es damit was zu tun

Ticket im Trac: #608

 

[peter_kre]

[Edit frank_m24: Mehrere Beiträge zusammengefasst. Man kann seine Beiträge auch editieren.]
Danke für die Hinweise !

libpcap.so.1.0 ist in /usr/lib installiert, aber ldd behauptet, die wird weder von pppd noch von pptp benutzt. Und tcpdump läuft eigentlich prima.

Über die serielle Console habe ich auch schon nachgedacht, muss mir allerdings erst ein serial->usb Kabel in der Bucht besorgen. Anleitung zum löten gibt's ja im Netz.

[Beitrag 2:]
Wenn ich Dich richtig verstehe, kommst Du mit Deinen Windows PC von aussen per pptpd auf die Box. Ich will anders herum mit der Box auf einen pptp Server tunneln !