[
https://issues.apache.org/jira/browse/DERBY-4075?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=12681548#action_12681548
]
Myrna van Lunteren commented on DERBY-4075:
-------------------------------------------
The run on linux failed after about 15 hours with some corruption occurring:
- ERROR XSLAD: log Record at instant 6,347,963,620,272 in log file 1,478
corrupted
. Expected log record length 0, real length 32,709.
This run I ran without derby.properties, so the derby.log only has errors, not
the full statement text, but there are these details around the time of the
error:
last error recorded before the XSLAD and around it:
---------------------------------------------------------
2009-03-12 08:59:51.164 GMT Thread[Refresh Thread,5,main] (XID = 373637),
(SESSIONID = 1), (DATABASE = mailsdb), (DRDAID = null), Failed Statement is:
insert into REFRESH.ATTACH (id,attach_id,attachment) values (?,?,?) with 3
parameters begin parameter #1: 3505 :end parameter begin parameter #2: 5 :end
parameter begin parameter #3:
BLOB(org.apache.derby.iapi.types.rawtobinaryformatstr...@2a062a06)
:end parameter
ERROR 23505: The statement was aborted because it would have caused a duplicate
key value in a unique or primary key constraint or unique index identified by
'ATTACH__PK' defined on 'ATTACH'.
at
org.apache.derby.iapi.error.StandardException.newException(StandardException.java:303)
at
org.apache.derby.impl.sql.execute.IndexChanger.insertAndCheckDups(IndexChanger.java:439)
at
org.apache.derby.impl.sql.execute.IndexChanger.doInsert(IndexChanger.java:383)
at
org.apache.derby.impl.sql.execute.IndexChanger.insert(IndexChanger.java:589)
at
org.apache.derby.impl.sql.execute.IndexSetChanger.insert(IndexSetChanger.java:267)
at
org.apache.derby.impl.sql.execute.RowChangerImpl.insertRow(RowChangerImpl.java:453)
at
org.apache.derby.impl.sql.execute.InsertResultSet.normalInsertCore(InsertResultSet.java:1022)
at
org.apache.derby.impl.sql.execute.InsertResultSet.open(InsertResultSet.java:495)
at
org.apache.derby.impl.sql.GenericPreparedStatement.executeStmt(GenericPreparedStatement.java:416)
at
org.apache.derby.impl.sql.GenericPreparedStatement.execute(GenericPreparedStatement.java:297)
at
org.apache.derby.impl.jdbc.EmbedStatement.executeStatement(EmbedStatement.java:1235)
at
org.apache.derby.impl.jdbc.EmbedPreparedStatement.executeStatement(EmbedPreparedStatement.java:1648)
at
org.apache.derby.impl.jdbc.EmbedPreparedStatement.executeUpdateEmbedPreparedStatement.java:294)
at
org.apache.derbyTesting.system.mailjdbc.utils.DbTasks.insertMail(DbTasks.java:396)
at
org.apache.derbyTesting.system.mailjdbc.tasks.Refresh.insertMail(Refresh.java:99)
at
org.apache.derbyTesting.system.mailjdbc.tasks.Refresh.doWork(Refresh.java:75)
at
org.apache.derbyTesting.system.mailjdbc.tasks.Refresh.run(Refresh.java:51)
------------ BEGIN SHUTDOWN ERROR STACK -------------
ERROR XSLAD: log Record at instant 6,347,963,620,272 in log file 1,478
corrupted. Expected log record length 0, real length 32,709.
at
org.apache.derby.iapi.error.StandardException.newException(StandardException.java:373)
at
org.apache.derby.impl.store.raw.log.Scan.getNextRecordBackward(Scan.java:376)
at org.apache.derby.impl.store.raw.log.Scan.getNextRecord(Scan.java:204)
at
org.apache.derby.impl.store.raw.log.FileLogger.undo(FileLogger.java:939)
at
org.apache.derby.impl.store.raw.xact.Xact.popSavePoints(Xact.java:2209)
at
org.apache.derby.impl.store.raw.xact.Xact.rollbackToSavePoint(Xact.java:1562)
at
org.apache.derby.impl.store.access.RAMTransaction.rollbackToSavePoint(RAMTransaction.java:2022)
at
org.apache.derby.impl.sql.conn.GenericLanguageConnectionContext.internalRollbackToSavepoint(GenericLanguageConnectionContext.java:1512)
at
org.apache.derby.impl.sql.conn.GenericStatementContext.cleanupOnError(GenericStatementContext.java:578)
at
org.apache.derby.iapi.services.context.ContextManager.cleanupOnError(ContextManager.java:333)
at
org.apache.derby.impl.jdbc.TransactionResourceImpl.cleanupOnError(TransactionResourceImpl.java:419)
at
org.apache.derby.impl.jdbc.TransactionResourceImpl.handleExceptionTransactionResourceImpl.java:337)
at
org.apache.derby.impl.jdbc.EmbedConnection.handleException(EmbedConnection.java:2201)
at
org.apache.derby.impl.jdbc.ConnectionChild.handleException(ConnectionChild.java:81)
at
org.apache.derby.impl.jdbc.EmbedStatement.executeStatement(EmbedStatement.java:1323)
at
org.apache.derby.impl.jdbc.EmbedPreparedStatement.executeStatement(EmbedPreparedStatement.java:1648)
at
org.apache.derby.impl.jdbc.EmbedPreparedStatement.executeUpdate(EmbedPreparedStatement.java:294)
at
org.apache.derbyTesting.system.mailjdbc.utils.DbTasks.insertMail(DbTasks.java:396)
at
org.apache.derbyTesting.system.mailjdbc.tasks.Refresh.insertMail(Refresh.java:99)
at
org.apache.derbyTesting.system.mailjdbc.tasks.Refresh.doWork(Refresh.java:75)
at
org.apache.derbyTesting.system.mailjdbc.tasks.Refresh.run(Refresh.java:51)
------------ END SHUTDOWN ERROR STACK -------------
New exception raised during cleanup Cannot rollback transaction 373637, trying
to compensate Page Operation: Page(23062,Container(0, 1056)) pageVersion 10 :
Update Slot=0 recordId=8 operation with null
ERROR XSLA8: Cannot rollback transaction 373637, trying to compensate Page
Operation: Page(23062,Container(0, 1056)) pageVersion 10 : Update Slot=0
recordId=operation with null
at
org.apache.derby.iapi.error.StandardException.newException(StandardException.java:366)
at
org.apache.derby.impl.store.raw.log.FileLogger.undo(FileLogger.java:1046)
at
org.apache.derby.impl.store.raw.xact.Xact.popSavePoints(Xact.java:2209)
at
org.apache.derby.impl.store.raw.xact.Xact.rollbackToSavePoint(Xact.java:1562)
at
org.apache.derby.impl.store.access.RAMTransaction.rollbackToSavePoint(RAMTransaction.java:2022)
at
org.apache.derby.impl.sql.conn.GenericLanguageConnectionContext.internalRollbackToSavepoint(GenericLanguageConnectionContext.java:1512)
at org.apache.derby.impl.sql.conn.GenericStatementContext.cleanupOnError
(GenericStatementContext.java:578)
at
org.apache.derby.iapi.services.context.ContextManager.cleanupOnError(ContextManager.java:333)
at
org.apache.derby.impl.jdbc.TransactionResourceImpl.cleanupOnError(TransactionResourceImpl.java:419)
at
org.apache.derby.impl.jdbc.TransactionResourceImpl.handleExceptionTransactionResourceImpl.java:337)
at
org.apache.derby.impl.jdbc.EmbedConnection.handleException(EmbedConnection.java:2201)
at
org.apache.derby.impl.jdbc.ConnectionChild.handleException(ConnectionChild.java:81)
at
org.apache.derby.impl.jdbc.EmbedStatement.executeStatement(EmbedStatement.java:1323)
at
org.apache.derby.impl.jdbc.EmbedPreparedStatement.executeStatement(EmbedPreparedStatement.java:1648)
at
org.apache.derby.impl.jdbc.EmbedPreparedStatement.executeUpdate(EmbedPreparedStatement.java:294)
at
org.apache.derbyTesting.system.mailjdbc.utils.DbTasks.insertMail(DbTasks.java:396)
at
org.apache.derbyTesting.system.mailjdbc.tasks.Refresh.insertMail(Refresh.java:99)
at
org.apache.derbyTesting.system.mailjdbc.tasks.Refresh.doWork(Refresh.java:75)
at
org.apache.derbyTesting.system.mailjdbc.tasks.Refresh.run(Refresh.java:51)
============= end nested exception, level (1) ===========
2009-03-12 08:59:52.752 GMT:
Shutting down instance a816c00e-011f-f6a2-11a8-000000097630
----------------------------------------------------------------
2009-03-12 08:59:52.753 GMT Thread[Refresh Thread,5,main] Less severe exception
raised during cleanup (ignored) An attempt was made to close a transaction that
was still active. The transaction has been aborted.
ERROR 40XT4: An attempt was made to close a transaction that was still active.
The transaction has been aborted.
at
org.apache.derby.iapi.error.StandardException.newException(StandardException.java:276)
at org.apache.derby.impl.store.raw.xact.Xact.close(Xact.java:1136)
at
org.apache.derby.impl.store.raw.xact.XactContext.cleanupOnError(XactContext.java:140)
at
org.apache.derby.iapi.services.context.ContextManager.cleanupOnError(ContextManager.java:333)
at
org.apache.derby.impl.jdbc.TransactionResourceImpl.cleanupOnError(TransactionResourceImpl.java:419)
at
org.apache.derby.impl.jdbc.TransactionResourceImpl.handleException(TransactionResourceImpl.java:337)
at
org.apache.derby.impl.jdbc.EmbedConnection.handleException(EmbedConnection.java:2201)
at
org.apache.derby.impl.jdbc.ConnectionChild.handleException(ConnectionChild.java:81)
at
org.apache.derby.impl.jdbc.EmbedStatement.executeStatement(EmbedStatement.java:1323)
at
org.apache.derby.impl.jdbc.EmbedPreparedStatement.executeStatement(EmbedPreparedStatement.java:1648)
at
org.apache.derby.impl.jdbc.EmbedPreparedStatement.executeUpdate(EmbedPreparedStatement.java:294)
at
org.apache.derbyTesting.system.mailjdbc.utils.DbTasks.insertMail(DbTasks.java:396)
at
org.apache.derbyTesting.system.mailjdbc.tasks.Refresh.insertMail(Refresh.java:99)
at
org.apache.derbyTesting.system.mailjdbc.tasks.Refresh.doWork(Refresh.java:75)
at
org.apache.derbyTesting.system.mailjdbc.tasks.Refresh.run(Refresh.java:51)
Cleanup action completed
> ERROR XSDBB: Unknown page format at page Page(613,Container(0, 1024)) when
> running MailJdbc (Embedded) system tests
> -------------------------------------------------------------------------------------------------------------------
>
> Key: DERBY-4075
> URL: https://issues.apache.org/jira/browse/DERBY-4075
> Project: Derby
> Issue Type: Bug
> Affects Versions: 10.5.0.0
> Environment: windows 2000 professional, ibm 1.6 (sr2), revision 10.5:
> 745360
> Reporter: Myrna van Lunteren
> Priority: Blocker
> Fix For: 10.5.0.0
>
> Attachments: Activity.out, d4075_debugchange.diff, derbylog.zip,
> performance.out
>
>
> I started the org.apache.derbyTesting.system.mailJdbc Embedded test and after
> about 1 day it ran into an apparently corrupted database.
> 2009-02-19 14:02:44.221 GMT Thread[Refresh Thread,5,main] (XID = 349909),
> (SESSIONID = 1), (DATABASE = mailsdb), (DRDAID = null), Failed Statement is:
> insert into
> REFRESH.INBOX(from_name,to_name,date,Message,attach_id,size_problem) values
> (?,?,?,?,?,?) with 6 parameters begin parameter #1: ABCE :end parameter begin
> parameter #2: WXYY :end parameter begin parameter #3: 2009-02-19 06:02:43.705
> :end parameter begin parameter #4:
> CLOB(org.apache.derby.iapi.types.readertoutf8str...@41ba41ba) :end parameter
> begin parameter #5: 0 :end parameter begin parameter #6: This column is used
> only to by pass the space problem. If the problem still exists, then we are
> going to have a serious issue
> here.*****************************************************************************************************
> :end parameter
> ERROR XSDBB: Unknown page format at page Page(613,Container(0, 1024)), page
> dump follows: Hex dump:
> The error up to that point appear to me no different from other errors that
> this test is expected to produce (40001, 23505, 4XL01) except that the very
> first error is a grant error.
> I think we can't have a release until this corruption is explained away or
> fixed.
--
This message is automatically generated by JIRA.
-
You can reply to this email to add a comment to the issue online.