Mendix 6.1 CloudFoundry staging DB error

2
We're running an implementation of Pivotal CloudFoundry at a client. It's all shiny and new, so we're still running into the occasional hitch. I've just updated one of our applications from Mendix 5.21 to Mendix 6.1. Apart from some widget issues, this went smoothly. When staging the new 6.1 release to CloudFoundry however, the log threw a long list of errors, as shown below. I'm guessing System.State is related to the new Mx6 session state handling, but I don't actually see this table in the System domain model. The application did eventually manage to stage, and seems to be running without major issues, but the log does have me somewhat concerned. Does anyone have any idea what is going on? Log: 2016-01-08T13:16:26.000+00:00 [APP] ERR ERROR: Executing execute_ddl_commands did not succeed: result: 1, message: Executing DDL commands for component MyFirstComponent failed., caused by: Error (SQL State: 42S21, Error Code: 1060) on executing: 2016-01-08T13:16:26.000+00:00 [APP] ERR All changes are rolled back. 2016-01-08T13:16:26.000+00:00 [APP] ERR ERROR: Executing start did not succeed: result: 3, message: The database has to be updated. (79325 database change queries needed) 2016-01-08T13:16:26.000+00:00 [APP] ERR ALTER TABLE `system$state` 2016-01-08T13:16:26.000+00:00 [APP] ERR ERROR: Executing execute_ddl_commands did not succeed: result: 1, message: Executing DDL commands for component MyFirstComponent failed., caused by: Error (SQL State: 42S21, Error Code: 1060) on executing: 2016-01-08T13:16:26.000+00:00 [APP] ERR ADD `createddate` DATETIME NULL 2016-01-08T13:16:26.000+00:00 [APP] ERR All changes are rolled back. 2016-01-08T13:16:26.000+00:00 [APP] ERR ERROR: Executing start did not succeed: result: 3, message: The database has to be updated. (79363 database change queries needed) 2016-01-08T13:16:26.000+00:00 [APP] ERR ERROR: Executing execute_ddl_commands did not succeed: result: 1, message: Executing DDL commands for component MyFirstComponent failed., caused by: Error (SQL State: 42S21, Error Code: 1060) on executing: 2016-01-08T13:16:26.000+00:00 [APP] ERR ALTER TABLE `system$state` 2016-01-08T13:16:26.000+00:00 [APP] ERR ERROR: Executing start did not succeed: result: 3, message: The database has to be updated. (79382 database change queries needed) 2016-01-08T13:16:26.000+00:00 [APP] ERR ERROR: Executing execute_ddl_commands did not succeed: result: 1, message: Executing DDL commands for component MyFirstComponent failed., caused by: Error (SQL State: 42S21, Error Code: 1060) on executing: 2016-01-08T13:16:26.000+00:00 [APP] ERR ALTER TABLE `system$state` 2016-01-08T13:16:26.000+00:00 [APP] ERR All changes are rolled back. 2016-01-08T13:16:26.000+00:00 [APP] ERR ERROR: Executing execute_ddl_commands did not succeed: result: 1, message: Executing DDL commands for component MyFirstComponent failed., caused by: Error (SQL State: 42S21, Error Code: 1060) on executing: 2016-01-08T13:16:26.000+00:00 [APP] ERR ERROR: Executing execute_ddl_commands did not succeed: result: 1, message: Executing DDL commands for component MyFirstComponent failed., caused by: Error (SQL State: 42S21, Error Code: 1060) on executing: 2016-01-08T13:16:26.000+00:00 [APP] ERR ALTER TABLE `system$state` 2016-01-08T13:16:26.000+00:00 [APP] ERR All changes are rolled back. 2016-01-08T13:16:26.000+00:00 [APP] ERR ERROR: Executing start did not succeed: result: 3, message: The database has to be updated. (79458 database change queries needed) 2016-01-08T13:16:26.000+00:00 [APP] ERR ALTER TABLE `system$state` 2016-01-08T13:16:26.000+00:00 [APP] ERR ADD `createddate` DATETIME NULL 2016-01-08T13:16:26.000+00:00 [APP] ERR ERROR: Executing start did not succeed: result: 3, message: The database has to be updated. (79477 database change queries needed) 2016-01-08T13:16:26.000+00:00 [APP] ERR ALTER TABLE `system$state` 2016-01-08T13:16:26.000+00:00 [APP] ERR ADD `createddate` DATETIME NULL 2016-01-08T13:16:26.000+00:00 [APP] ERR ERROR: Executing execute_ddl_commands did not succeed: result: 1, message: Executing DDL commands for component MyFirstComponent failed., caused by: Error (SQL State: 42S21, Error Code: 1060) on executing: 2016-01-08T13:16:26.000+00:00 [APP] ERR ADD `createddate` DATETIME NULL 2016-01-08T13:16:26.000+00:00 [APP] ERR ERROR: Executing start did not succeed: result: 3, message: The database has to be updated. (79515 database change queries needed) 2016-01-08T13:16:26.000+00:00 [APP] ERR All changes are rolled back. 2016-01-08T13:16:26.000+00:00 [APP] ERR ERROR: Executing execute_ddl_commands did not succeed: result: 1, message: Executing DDL commands for component MyFirstComponent failed., caused by: Error (SQL State: 42S21, Error Code: 1060) on executing: 2016-01-08T13:16:26.000+00:00 [APP] ERR ALTER TABLE `system$state` 2016-01-08T13:16:26.000+00:00 [APP] ERR ALTER TABLE `system$state` 2016-01-08T13:16:26.000+00:00 [APP] ERR ERROR: Executing start did not succeed: result: 3, message: The database has to be updated. (79572 database change queries needed)
asked
1 answers
0

The SQL error code you're getting indicates "duplicate column name", as if the database synchronization scripts were trying to add the "createddate" column to your system$state table over and over again.

I'm can't say why this happened (perhaps someone from R&D can chime in). If subsequent startups go without error (and don't ask you to synchronize the database again), then I believe you are in a safe state. If you do get errors, see if you can pull the synchronization script and share it here.

answered