Kernel differences affect pptpd? LCP terminated by peer on ARM board

[Karl Hiramoto]

Hi all,

I have a machine with  kernel 2.6.11  on an ARM big endian board.   and
poptop 1.3.4 giving me problems.      The same code on an x86 machine
with kernel 2.6.16  works perfectly.

The same code on an ARM big endian with kernel 2.6.16  works too.  
Trying to figure out why it's failing on  kernel 2.6.11 (which  I need
to work)

I have several patches i am using:
http://karl.hiramoto.org/kh_gentoo_embedded/net-dialup/pptpd/files/

Windows XP client reports:
Error 778:  It was not possible to verify the identity of the server.

Can anyone help me identify the problem in the debug   messages in the logs?

9052 Dec 28 2007 11:02:43     Info   3 pptpd   [766] pptpd startup.
Version 1.3.4. Compiled Dec 28 2007  09:22:31
9053 Dec 28 2007 11:02:43     Info   3 pptpd   [766] MGR: Maximum of 100
connections reduced to 51, not enough IP addresses given
9054 Dec 28 2007 11:02:44     Info   3 pptpd   [768] MGR: Manager
process started
9055 Dec 28 2007 11:02:44     Info   3 pptpd   [768] MGR: Maximum of 51
connections available
9056 Dec 28 2007 11:02:55    Debug   3 pptpd   [769] MGR: Launching
/bin/pptpctrl to handle client
9057 Dec 28 2007 11:02:55    Debug   3 pptpd   [769] CTRL: local address
= 10.1.1.1
9058 Dec 28 2007 11:02:56    Debug   3 pptpd   [769] CTRL: remote
address = 10.1.1.100
9059 Dec 28 2007 11:02:56    Debug   3 pptpd   [769] CTRL: pppd options
file = /tmp/ppp/options.pptpd
9060 Dec 28 2007 11:02:56     Info   3 pptpd   [769] CTRL: Client
172.16.3.21 control connection started
9061 Dec 28 2007 11:02:57    Debug   3 pptpd   [769] CTRL: Received PPTP
Control Message (type: 1)
9062 Dec 28 2007 11:02:57    Debug   3 pptpd   [769] CTRL: Made a START
CTRL CONN RPLY packet
9063 Dec 28 2007 11:02:57    Debug   3 pptpd   [769] CTRL: I wrote 156
bytes to the client.
9064 Dec 28 2007 11:02:58    Debug   3 pptpd   [769] CTRL: Sent packet
to client
9065 Dec 28 2007 11:02:58    Debug   3 pptpd   [769] CTRL: Received PPTP
Control Message (type: 7)
9066 Dec 28 2007 11:02:59    Debug   3 pptpd   [769] CTRL: Set
parameters to 100000000 maxbps, 64 window size
9067 Dec 28 2007 11:02:59    Debug   3 pptpd   [769] CTRL: Made a OUT
CALL RPLY packet
9068 Dec 28 2007 11:02:59     Info   3 pptpd   [769] CTRL: Starting call
(launching pppd, opening GRE)
9069 Dec 28 2007 11:03:00    Debug   3 pptpd   [769] CTRL: pty_fd = 9
9070 Dec 28 2007 11:03:00    Debug   3 pptpd   [769] CTRL: tty_fd = 10
9071 Dec 28 2007 11:03:00    Debug   3 pptpd   [770] CTRL (PPPD
Launcher): program binary = 260
9072 Dec 28 2007 11:03:01    Debug   3 pptpd   [769] CTRL: I wrote 32
bytes to the client.
9073 Dec 28 2007 11:03:01    Debug   3 pptpd   [770] CTRL (PPPD
Launcher): local address = 10.1.1.1
9074 Dec 28 2007 11:03:02    Debug   3 pptpd   [769] CTRL: Sent packet
to client
9075 Dec 28 2007 11:03:02    Debug   3 pptpd   [770] CTRL (PPPD
Launcher): remote address = 10.1.1.100
9076 Dec 28 2007 11:03:02    Debug   3 pptpd   [769] CTRL: Received PPTP
Control Message (type: 15)
9077 Dec 28 2007 11:03:03   Notice   3 pppd    [770] pppd 2.4.3 started
by root, uid 0
9078 Dec 28 2007 11:03:03    Debug   3 pptpd   [769] CTRL: Got a SET
LINK INFO packet with standard ACCMs
9079 Dec 28 2007 11:03:04    Debug   3 pppd    [770] using channel 2
9080 Dec 28 2007 11:03:04   Notice   1 hotplug       running net mode
9081 Dec 28 2007 11:03:04     Info   3 pppd    [770] Using interface ppp260
9082 Dec 28 2007 11:03:05   Notice   3 pppd    [770] Connect: ppp260
<--> /dev/pts/1
9083 Dec 28 2007 11:03:05    Debug   3 pppd    [770] sent [LCP ConfReq
id=0x1 <asyncmap 0x0> <auth chap MS-v2> <magic 0x24184417> <pcomp> <accomp>]
9084 Dec 28 2007 11:03:06    Debug   3 pptpd   [769] GRE: accepting
packet #0
9085 Dec 28 2007 11:03:06    Debug   3 pptpd   [769] GRE: accepting
packet #1
9086 Dec 28 2007 11:03:07    Debug   3 pppd    [770] rcvd [LCP ConfReq
id=0x0 <mru 1400> <magic 0x2c37525d> <pcomp> <accomp> <callback CBCP>]
9087 Dec 28 2007 11:03:07    Debug   3 pptpd   [769] GRE: accepting
packet #2
9088 Dec 28 2007 11:03:07    Debug   3 pppd    [770] sent [LCP ConfRej
id=0x0 <callback CBCP>]
9089 Dec 28 2007 11:03:08    Debug   3 pptpd   [769] GRE: accepting
packet #3
9090 Dec 28 2007 11:03:08    Debug   3 pppd    [770] rcvd [LCP ConfReq
id=0x1 <mru 1400> <magic 0x2c37525d> <pcomp> <accomp> <callback CBCP>]
9091 Dec 28 2007 11:03:09    Debug   3 pppd    [770] sent [LCP ConfRej
id=0x1 <callback CBCP>]
9092 Dec 28 2007 11:03:09    Debug   3 pppd    [770] sent [LCP ConfReq
id=0x1 <asyncmap 0x0> <auth chap MS-v2> <magic 0x24184417> <pcomp> <accomp>]
9093 Dec 28 2007 11:03:10    Debug   3 pptpd   [769] GRE: accepting
packet #4
9094 Dec 28 2007 11:03:10    Debug   3 pppd    [770] rcvd [LCP ConfAck
id=0x1 <asyncmap 0x0> <auth chap MS-v2> <magic 0x24184417> <pcomp> <accomp>]
9095 Dec 28 2007 11:03:10    Debug   3 pptpd   [769] GRE: accepting
packet #5
9096 Dec 28 2007 11:03:10    Debug   3 pppd    [770] rcvd [LCP ConfReq
id=0x2 <mru 1400> <magic 0x2c37525d> <pcomp> <accomp> <callback CBCP>]
9097 Dec 28 2007 11:03:11    Debug   3 pppd    [770] sent [LCP ConfRej
id=0x2 <callback CBCP>]
9098 Dec 28 2007 11:03:11    Debug   3 pppd    [770] rcvd [LCP ConfReq
id=0x3 <mru 1400> <magic 0x2c37525d> <pcomp> <accomp> <callback CBCP>]
9099 Dec 28 2007 11:03:12    Debug   3 pppd    [770] sent [LCP ConfRej
id=0x3 <callback CBCP>]
9100 Dec 28 2007 11:03:12    Debug   3 pppd    [770] rcvd [LCP ConfAck
id=0x1 <asyncmap 0x0> <auth chap MS-v2> <magic 0x24184417> <pcomp> <accomp>]
9101 Dec 28 2007 11:03:12    Debug   3 pptpd   [769] GRE: accepting
packet #6
9102 Dec 28 2007 11:03:13    Debug   3 pppd    [770] sent [LCP ConfReq
id=0x1 <asyncmap 0x0> <auth chap MS-v2> <magic 0x24184417> <pcomp> <accomp>]
9103 Dec 28 2007 11:03:13    Debug   3 pppd    [770] rcvd [LCP ConfReq
id=0x4 <mru 1400> <magic 0x2c37525d> <pcomp> <accomp>]
9104 Dec 28 2007 11:03:13    Debug   3 pptpd   [769] GRE: accepting
packet #7
9105 Dec 28 2007 11:03:14    Debug   3 pppd    [770] sent [LCP ConfAck
id=0x4 <mru 1400> <magic 0x2c37525d> <pcomp> <accomp>]
9106 Dec 28 2007 11:03:14    Debug   3 pppd    [770] rcvd [LCP ConfAck
id=0x1 <asyncmap 0x0> <auth chap MS-v2> <magic 0x24184417> <pcomp> <accomp>]
9107 Dec 28 2007 11:03:14    Debug   3 pptpd   [769] GRE: accepting
packet #8
9108 Dec 28 2007 11:03:15    Debug   3 pppd    [770] sent [LCP EchoReq
id=0x0 magic=0x24184417]
9109 Dec 28 2007 11:03:15    Debug   3 pptpd   [769] CTRL: Received PPTP
Control Message (type: 15)
9110 Dec 28 2007 11:03:15    Debug   3 pppd    [770] sent [CHAP
Challenge id=0x2b <d280e6fa5a9666dd91fcccb5ce8d8009>, name = "pptp"]
9111 Dec 28 2007 11:03:15    Error   3 pptpd   [769] CTRL: Ignored a SET
LINK INFO packet with real ACCMs!
9112 Dec 28 2007 11:03:16    Debug   3 pppd    [770] rcvd [LCP code=0xc
id=0x5 2c 37 52 5d 4d 53 52 41 53 56 35 2e 31 30]
9113 Dec 28 2007 11:03:16    Debug   3 pptpd   [769] GRE: accepting
packet #9
9114 Dec 28 2007 11:03:17    Debug   3 pppd    [770] sent [LCP CodeRej
id=0x2 0c 05 00 12 2c 37 52 5d 4d 53 52 41 53 56 35 2e 31 30]
9115 Dec 28 2007 11:03:17    Debug   3 pptpd   [769] GRE: accepting
packet #10
9116 Dec 28 2007 11:03:17    Debug   3 pppd    [770] rcvd [LCP code=0xc
id=0x6 2c 37 52 5d 4d 53 52 41 53 2d 30 2d 4c 41 42 2d 58 50 2d 56 4d 31]
9117 Dec 28 2007 11:03:17    Debug   3 pptpd   [769] GRE: accepting
packet #11
9118 Dec 28 2007 11:03:18    Debug   3 pppd    [770] sent [LCP CodeRej
id=0x3 0c 06 00 1a 2c 37 52 5d 4d 53 52 41 53 2d 30 2d 4c 41 42 2d 58 50
2d 56 4d 31]
9119 Dec 28 2007 11:03:19    Debug   3 pppd    [770] rcvd [LCP EchoRep
id=0x0 magic=0x2c37525d]
9120 Dec 28 2007 11:03:19    Debug   3 pppd    [770] sent [CHAP
Challenge id=0x2b <d280e6fa5a9666dd91fcccb5ce8d8009>, name = "pptp"]
9121 Dec 28 2007 11:03:19    Debug   3 pptpd   [769] GRE: accepting
packet #12
9122 Dec 28 2007 11:03:19    Debug   3 pppd    [770] rcvd [CHAP Response
id=0x2b
<b0991711ca0176852489a704b403485e00000000000000006312ae8a313999ba0cafd35ddde5cfef31f117581be4a31e00>,
name = "karl"]
9123 Dec 28 2007 11:03:20    Debug   3 pptpd   [769] GRE: accepting
packet #13
9124 Dec 28 2007 11:03:20    Debug   3 pppd    [770] sent [CHAP Success
id=0x2b "S=A9B203924AC4B94C8F4947A3B402248565DEAE07 M=Access granted"]
9125 Dec 28 2007 11:03:20    Debug   3 pptpd   [769] GRE: accepting
packet #14
9126 Dec 28 2007 11:03:21    Debug   3 pppd    [770] Script
/etc/ppp/auth-up started (pid 776)
9127 Dec 28 2007 11:03:21    Debug   3 pptpd   [769] CTRL: Received PPTP
Control Message (type: 15)
9128 Dec 28 2007 11:03:22    Debug   3 pppd    [770] sent [CCP ConfReq
id=0x1 <mppe +H -M +S -L -D -C>]
9129 Dec 28 2007 11:03:22    Debug   3 pptpd   [769] CTRL: Got a SET
LINK INFO packet with standard ACCMs
9130 Dec 28 2007 11:03:22    Debug   3 pppd    [770] Script
/etc/ppp/auth-up finished (pid 776), status = 0x0
9131 Dec 28 2007 11:03:23    Debug   3 pppd    [770] rcvd [CHAP Response
id=0x2b
<b0991711ca0176852489a704b403485e00000000000000006312ae8a313999ba0cafd35ddde5cfef31f117581be4a31e00>,
name = "karl"]
9132 Dec 28 2007 11:03:23    Debug   3 pppd    [770] sent [CHAP Success
id=0x2b "S=A9B203924AC4B94C8F4947A3B402248565DEAE07 M=Access granted"]
9133 Dec 28 2007 11:03:23    Debug   3 pppd    [770] rcvd [CHAP Response
id=0x2b
<d606887b25b6d9e1f516ae98652171ac0000000000000000da028d044b534370e36bec409d806ea1c5b1268fc4157e3f00>,
name = "karl"]
9134 Dec 28 2007 11:03:24    Debug   3 pppd    [770] sent [CHAP Success
id=0x2b "S=A9B203924AC4B94C8F4947A3B402248565DEAE07 M=Access granted"]
9135 Dec 28 2007 11:03:24    Debug   3 pptpd   [769] GRE: accepting
packet #15
9136 Dec 28 2007 11:03:25    Debug   3 pppd    [770] rcvd [LCP TermReq
id=0x7 ",7R]\000<\315t\000\000\003\n"]
9137 Dec 28 2007 11:03:25     Info   3 pppd    [770] LCP terminated by
peer (,7R]^@<M-Mt^@^@^C^J)
9138 Dec 28 2007 11:03:25    Debug   3 pppd    [770] sent [LCP TermAck
id=0x7]
9139 Dec 28 2007 11:03:26    Debug   3 pppd    [770] rcvd [LCP TermReq
id=0x8 ",7R]\000<\315t\000\000\003\n"]
9140 Dec 28 2007 11:03:26    Debug   3 pppd    [770] sent [LCP TermAck
id=0x8]
9141 Dec 28 2007 11:03:26    Debug   3 pptpd   [769] CTRL: Received PPTP
Control Message (type: 12)
9142 Dec 28 2007 11:03:27    Debug   3 pptpd   [769] CTRL: Made a CALL
DISCONNECT RPLY packet
9143 Dec 28 2007 11:03:27    Debug   3 pptpd   [769] CTRL: Received CALL
CLR request (closing call)
9144 Dec 28 2007 11:03:27    Debug   3 pptpd   [769] CTRL: Reaping child
PPP[770]
9145 Dec 28 2007 11:03:28   Notice   3 pppd    [770] Modem hangup
9146 Dec 28 2007 11:03:28   Notice   3 pppd    [770] Connection terminated.
9147 Dec 28 2007 11:03:28     Info   3 pppd    [770] Connect time 0.4
minutes.
9148 Dec 28 2007 11:03:29     Info   3 pppd    [770] Sent 10 bytes,
received 0 bytes.
9149 Dec 28 2007 11:03:29   Notice   1 hotplug       running net mode
9150 Dec 28 2007 11:03:30     Info   3 pppd    [770] Exit.
9151 Dec 28 2007 11:03:31     Info   3 pptpd   [769] CTRL: Client
172.16.3.21 control connection finished
9152 Dec 28 2007 11:03:31    Debug   3 pptpd   [769] CTRL: Exiting with
active call
9153 Dec 28 2007 11:03:32    Error   3 pptpd   [769] CTRL: Asked to free
call when no call open, not handled well
9154 Dec 28 2007 11:03:32    Debug   3 pptpd   [769] CTRL: Made a CALL
DISCONNECT RPLY packet
9155 Dec 28 2007 11:03:32    Error   3 pptpd   [769] CTRL: Couldn't
write packet to client.
9156 Dec 28 2007 11:03:33    Debug   3 pptpd   [769] CTRL: Made a STOP
CTRL REQ packet
9157 Dec 28 2007 11:03:33    Error   3 pptpd   [769] CTRL: Couldn't
write packet to client.
9158 Dec 28 2007 11:03:34    Debug   3 pptpd   [769] CTRL: Exiting now
9159 Dec 28 2007 11:03:35    Debug   3 pptpd   [768] MGR: Reaped child 769


--
Thanks

-------------------------------------------------------------------------
This SF.net email is sponsored by: Microsoft
Defy all challenges. Microsoft(R) Visual Studio 2005.
http://clk.atdmt.com/MRT/go/vse0120000070mrt/direct/01/
_______________________________________________
Poptop-server mailing list
Poptop-server@...
https://lists.sourceforge.net/lists/listinfo/poptop-server

[Pim Zandbergen]

Karl Hiramoto wrote:
> Hi all,
>
> I have a machine with  kernel 2.6.11  on an ARM big endian board.   and
> poptop 1.3.4 giving me problems.      The same code on an x86 machine
> with kernel 2.6.16  works perfectly.
>  
Are you using winbind authentication?
If so, which version of samba do you use?

Pim


-------------------------------------------------------------------------
This SF.Net email is sponsored by the Moblin Your Move Developer's challenge
Build the coolest Linux based applications with Moblin SDK & win great prizes
Grand prize is a trip for two to an Open Source event anywhere in the world
http://moblin-contest.org/redirect.php?banner_id=100&url=/
_______________________________________________
Poptop-server mailing list
Poptop-server@...
https://lists.sourceforge.net/lists/listinfo/poptop-server