Thu Sep 13 12:57:10 MDT 2007 INFO: Profiler Event: [FETCH] at com.terraframe.mrsparkle.dataaccess.database.general.AbstractDatabase.selectEntityObjectAttributes(AbstractDatabase.java:1674) duration: 0 ms, connection-id: 30, statement-id: 9629, resultset-id: 8500
Thu Sep 13 12:57:10 MDT 2007 INFO: Profiler Event: [QUERY] at com.terraframe.mrsparkle.dataaccess.database.general.AbstractDatabase.executeBatch(AbstractDatabase.java:989) duration: 1 ms, connection-id: 30, statement-id: 9630, resultset-id: 0, message: DELETE FROM entity_attribute WHERE id = 'sp2os5ag30236ahrhfovdvmrfdnvbdgc-com.terraframe.mrsparkle.system.metadata.EntityAttribute'
Thu Sep 13 12:57:10 MDT 2007 INFO: Profiler Event: [FETCH] at com.terraframe.mrsparkle.dataaccess.database.general.AbstractDatabase.executeBatch(AbstractDatabase.java:989) duration: 0 ms, connection-id: 30, statement-id: 9630, resultset-id: 0
Thu Sep 13 12:57:10 MDT 2007 INFO: Profiler Event: [QUERY] at com.terraframe.mrsparkle.dataaccess.database.general.AbstractDatabase.executeBatch(AbstractDatabase.java:989) duration: 0 ms, connection-id: 30, statement-id: 9630, resultset-id: 0, message: DELETE FROM metadata_relationship WHERE id = 'sp2os5ag30236ahrhfovdvmrfdnvbdgc-com.terraframe.mrsparkle.system.metadata.EntityAttribute' AND seq = 1921
Thu Sep 13 12:57:10 MDT 2007 INFO: Profiler Event: [FETCH] at com.terraframe.mrsparkle.dataaccess.database.general.AbstractDatabase.executeBatch(AbstractDatabase.java:989) duration: 0 ms, connection-id: 30, statement-id: 9630, resultset-id: 0
Thu Sep 13 12:57:10 MDT 2007 INFO: Profiler Event: [QUERY] at com.terraframe.mrsparkle.dataaccess.database.general.AbstractDatabase.executeBatch(AbstractDatabase.java:989) duration: 0 ms, connection-id: 30, statement-id: 9630, resultset-id: 0, message: DELETE FROM sequence_mapping WHERE id = 'sp2os5ag30236ahrhfovdvmrfdnvbdgc-com.terraframe.mrsparkle.system.metadata.EntityAttribute'
Thu Sep 13 12:57:10 MDT 2007 INFO: Profiler Event: [FETCH] at com.terraframe.mrsparkle.dataaccess.database.general.AbstractDatabase.executeBatch(AbstractDatabase.java:989) duration: 0 ms, connection-id: 30, statement-id: 9630, resultset-id: 0
Thu Sep 13 12:57:10 MDT 2007 INFO: Profiler Event: [QUERY] at com.terraframe.mrsparkle.dataaccess.database.general.AbstractDatabase.query(AbstractDatabase.java:1555) duration: 0 ms, connection-id: 30, statement-id: 9631, resultset-id: 8504, message: SHOW INDEX FROM test
Thu Sep 13 12:57:10 MDT 2007 INFO: Profiler Event: [FETCH] at com.terraframe.mrsparkle.dataaccess.database.general.AbstractDatabase.query(AbstractDatabase.java:1555) duration: 0 ms, connection-id: 30, statement-id: 9631, resultset-id: 8504
Thu Sep 13 12:57:10 MDT 2007 WARN: Profiler Event: [WARN] at com.terraframe.mrsparkle.dataaccess.database.general.AbstractDatabase.query(AbstractDatabase.java:1555) duration: 0 ms, connection-id: 30, statement-id: 9631, resultset-id: 8504, message: The following query was executed with a bad index, use 'EXPLAIN' for more details: SHOW INDEX FROM test

Full stack trace of location where event occurred:



** BEGIN NESTED EXCEPTION **

java.lang.Throwable

STACKTRACE:

java.lang.Throwable
at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:1785)
at com.mysql.jdbc.Connection.execSQL(Connection.java:3170)
at com.mysql.jdbc.Connection.execSQL(Connection.java:3099)
at com.mysql.jdbc.Statement.executeQuery(Statement.java:1169)
at com.mysql.jdbc.jdbc2.optional.StatementWrapper.executeQuery(StatementWrapper.java:705)

...Stack trace edited for brevity.....

com.terraframe.mrsparkle.dataaccess.MasterTestSetup.tearDown(MasterTestSetup.java:143)
at junit.extensions.TestSetup$1.protect(TestSetup.java:20)
at junit.framework.TestResult.runProtected(TestResult.java:124)
at junit.extensions.TestSetup.run(TestSetup.java:23)
at junit.framework.TestSuite.runTest(TestSuite.java:208)
at junit.framework.TestSuite.run(TestSuite.java:203)
at junit.framework.TestSuite.runTest(TestSuite.java:208)
at junit.framework.TestSuite.run(TestSuite.java:203)
at junit.framework.TestSuite.runTest(TestSuite.java:208)
at junit.framework.TestSuite.run(TestSuite.java:203)
at org.eclipse.jdt.internal.junit.runner.junit3.JUnit3TestReference.run(JUnit3TestReference.java:130)
at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:460)
at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:673)
at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:386)
at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:196)


** END NESTED EXCEPTION **



Lock wait timeout exceeded; try restarting transaction - SQL Statement That caused the error: [ALTER TABLE test DROP INDEX aza1uip1xeicn3ugmjmb039hsqjk3e] - The statement that caused the error was [ALTER TABLE test DROP INDEX aza1uip1xeicn3ugmjmb039hsqjk3e]
com.terraframe.mrsparkle.dataaccess.database.DatabaseException: Lock wait timeout exceeded; try restarting transaction - SQL Statement That caused the error: [ALTER TABLE test DROP INDEX aza1uip1xeicn3ugmjmb039hsqjk3e] - The statement that caused the error was [ALTER TABLE test DROP INDEX aza1uip1xeicn3ugmjmb039hsqjk3e]
at com.terraframe.mrsparkle.dataaccess.database.DDLCommand.doIt(DDLCommand.java:72)

... STACK TRACE EDITED FOR BREVITY ...

com.terraframe.mrsparkle.dataaccess.MasterTestSetup.tearDown(MasterTestSetup.java:143)
at junit.extensions.TestSetup$1.protect(TestSetup.java:20)
at junit.framework.TestResult.runProtected(TestResult.java:124)
at junit.extensions.TestSetup.run(TestSetup.java:23)
at junit.framework.TestSuite.runTest(TestSuite.java:208)
at junit.framework.TestSuite.run(TestSuite.java:203)
at junit.framework.TestSuite.runTest(TestSuite.java:208)
at junit.framework.TestSuite.run(TestSuite.java:203)
at junit.framework.TestSuite.runTest(TestSuite.java:208)
at junit.framework.TestSuite.run(TestSuite.java:203)
at org.eclipse.jdt.internal.junit.runner.junit3.JUnit3TestReference.run(JUnit3TestReference.java:130)
at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:460)
at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:673)
at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:386)
at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:196)
Caused by: java.sql.SQLException: Lock wait timeout exceeded; try restarting transaction
at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:946)
at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:2870)
at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:1573)
at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:1665)
at com.mysql.jdbc.Connection.execSQL(Connection.java:3170)
at com.mysql.jdbc.Statement.executeUpdate(Statement.java:1316)
at com.mysql.jdbc.Statement.executeUpdate(Statement.java:1235)
at com.mysql.jdbc.jdbc2.optional.StatementWrapper.executeUpdate(StatementWrapper.java:801)
at com.terraframe.mrsparkle.dataaccess.database.DDLCommand.doIt(DDLCommand.java:64)
... 33 more
Thu Sep 13 12:58:01 MDT 2007 INFO: Profiler Event: [QUERY] at com.terraframe.mrsparkle.session.SessionManagement.ajc$afterReturning$com_terraframe_mrsparkle_session_SessionManagement$31$c78487a8(SessionManagement.aj:1212) duration: 0 ms, connection-id: 30, statement-id: 999, resultset-id: 0, message: commit
Thu Sep 13 12:58:01 MDT 2007 INFO: Profiler Event: [FETCH] at com.terraframe.mrsparkle.session.SessionManagement.ajc$afterReturning$com_terraframe_mrsparkle_session_SessionManagement$31$c78487a8(SessionManagement.aj:1212) duration: 0 ms, connection-id: 30, statement-id: 999, resultset-id: 0
Thu Sep 13 12:58:01 MDT 2007 INFO: Profiler Event: [QUERY] at com.terraframe.mrsparkle.session.SessionManagement.ajc$afterReturning$com_terraframe_mrsparkle_session_SessionManagement$31$c78487a8(SessionManagement.aj:1219) duration: 1 ms, connection-id: 30, statement-id: 999, resultset-id: 0, message: rollback
Thu Sep 13 12:58:01 MDT 2007 INFO: Profiler Event: [FETCH] at com.terraframe.mrsparkle.session.SessionManagement.ajc$afterReturning$com_terraframe_mrsparkle_session_SessionManagement$31$c78487a8(SessionManagement.aj:1219) duration: 0 ms, connection-id: 30, statement-id: 999, resultset-id: 0
Thu Sep 13 12:58:01 MDT 2007 INFO: Profiler Event: [QUERY] at org.apache.commons.dbcp.datasources.InstanceKeyDataSource.getConnection(InstanceKeyDataSource.java:653) duration: 1 ms, connection-id: 32, statement-id: 999, resultset-id: 0, message: SET NAMES latin1
Thu Sep 13 12:58:01 MDT 2007 INFO: Profiler Event: [FETCH] at org.apache.commons.dbcp.datasources.InstanceKeyDataSource.getConnection(InstanceKeyDataSource.java:653) duration: 0 ms, connection-id: 32, statement-id: 999, resultset-id: 0
Thu Sep 13 12:58:01 MDT 2007 INFO: Profiler Event: [QUERY] at org.apache.commons.dbcp.datasources.InstanceKeyDataSource.getConnection(InstanceKeyDataSource.java:653) duration: 0 ms, connection-id: 32, statement-id: 999, resultset-id: 0, message: SET character_set_results = NULL
Thu Sep 13 12:58:01 MDT 2007 INFO: Profiler Event: [FETCH] at org.apache.commons.dbcp.datasources.InstanceKeyDataSource.getConnection(InstanceKeyDataSource.java:653) duration: 0 ms, connection-id: 32, statement-id: 999, resultset-id: 0
Thu Sep 13 12:58:01 MDT 2007 INFO: Profiler Event: [QUERY] at org.apache.commons.dbcp.datasources.SharedPoolDataSource.setupDefaults(SharedPoolDataSource.java:212) duration: 1 ms, connection-id: 32, statement-id: 999, resultset-id: 0, message: SET autocommit=1
Thu Sep 13 12:58:01 MDT 2007 INFO: Profiler Event: [FETCH] at org.apache.commons.dbcp.datasources.SharedPoolDataSource.setupDefaults(SharedPoolDataSource.java:212) duration: 0 ms, connection-id: 32, statement-id: 999, resultset-id: 0
Thu Sep 13 12:58:01 MDT 2007 INFO: Profiler Event: [QUERY] at com.terraframe.mrsparkle.dataaccess.database.general.AbstractDatabase.getConnection(AbstractDatabase.java:188) duration: 0 ms, connection-id: 32, statement-id: 999, resultset-id: 0, message: SET autocommit=0
Thu Sep 13 12:58:01 MDT 2007 INFO: Profiler Event: [FETCH] at com.terraframe.mrsparkle.dataaccess.database.general.AbstractDatabase.getConnection(AbstractDatabase.java:188) duration: 0 ms, connection-id: 32, statement-id: 999, resultset-id: 0
Thu Sep 13 12:58:01 MDT 2007 INFO: Profiler Event: [QUERY] at com.terraframe.mrsparkle.dataaccess.database.general.AbstractDatabase.getConnection(AbstractDatabase.java:189) duration: 0 ms, connection-id: 32, statement-id: 999, resultset-id: 0, message: SET SESSION TRANSACTION ISOLATION LEVEL READ COMMITTED
Thu Sep 13 12:58:01 MDT 2007 INFO: Profiler Event: [FETCH] at com.terraframe.mrsparkle.dataaccess.database.general.AbstractDatabase.getConnection(AbstractDatabase.java:189) duration: 0 ms, connection-id: 32, statement-id: 999, resultset-id: 0
Thu Sep 13 12:58:01 MDT 2007 INFO: Profiler Event: [QUERY] at com.terraframe.mrsparkle.session.SessionManagement.ajc$afterReturning$com_terraframe_mrsparkle_session_SessionManagement$31$c78487a8(SessionManagement.aj:1212) duration: 0 ms, connection-id: 32, statement-id: 999, resultset-id: 0, message: commit
Thu Sep 13 12:58:01 MDT 2007 INFO: Profiler Event: [FETCH] at com.terraframe.mrsparkle.session.SessionManagement.ajc$afterReturning$com_terraframe_mrsparkle_session_SessionManagement$31$c78487a8(SessionManagement.aj:1212) duration: 0 ms, connection-id: 32, statement-id: 999, resultset-id: 0
Thu Sep 13 12:58:01 MDT 2007 INFO: Profiler Event: [QUERY] at com.terraframe.mrsparkle.session.SessionManagement.ajc$afterReturning$com_terraframe_mrsparkle_session_SessionManagement$31$c78487a8(SessionManagement.aj:1219) duration: 0 ms, connection-id: 32, statement-id: 999, resultset-id: 0, message: rollback
Thu Sep 13 12:58:01 MDT 2007 INFO: Profiler Event: [FETCH] at com.terraframe.mrsparkle.session.SessionManagement.ajc$afterReturning$com_terraframe_mrsparkle_session_SessionManagement$31$c78487a8(SessionManagement.aj:1219) duration: 0 ms, connection-id: 32, statement-id: 999, resultset-id: 0



Edited 2 time(s). Last edit at 09/13/2007 01:18PM by Nathan McEachen.