Thanks Bernt. Sorry about the test hang, I should have made sure that
test does not hang on errors, I will fix the test. From the
stack/messages, I could not figure out why the backup is failing
while doing a simple file copy. For some unknown reason the FileUtil
routine that is used to copy just returns false on IOExceptions.
Are there any other errors in the derby.log file ? Does the disk that
is used to run the tests has enough space, I am sure it has.
I will also run it few times on my linux machine and see if I can
reproduce this error. Please log a Jira entry.
Thanks
-suresh
Bernt M. Johnsen wrote:
The problem is intermittent, but happens in 1 out of 2-3 runs. A
file-copy fails, an exception is thrown and then it hangs. See the
attached file.
Platform:
Linux atum01 2.6.13-1.1532_FC4 #1 Thu Oct 20 01:30:08 EDT 2005 i686 i686 i386 GNU/Linux
Java HotSpot(TM) Client VM (1.4.2_02-b03 mixed mode)
Bernt M. Johnsen wrote (2006-02-22 21:21:47):
Suresh Thalamati wrote (2006-02-22 12:00:21):
I just ran the test with latest revision 379848, it passed. I am
interested to know why the test is hanging in your environment. Is it
hanging when you run it seperately, if it is could please post the
stack dump for the hang.
Ok. I'll run it separately and try to get an stackdump.
Thanks
-suresh
Bernt M. Johnsen wrote:
(Have done two attempts to run derbyall now)
Anyone else who sees this?
--
Bernt Marius Johnsen, Database Technology Group,
Staff Engineer, Technical Lead Derby/Java DB
Sun Microsystems, Trondheim, Norway
------------------------------------------------------------------------
Begin Online Backup Test3
Initial Setup Complete
Begin Install Jar Test
ERROR XSRSA: Cannot backup the database when unlogged operations are uncommitted. Please commit the transactions with backup blocking operations.
Backup-1 Started
The transaction that was blocking the backup has ended
Backup-1 Completed
Backup-2 Started
Started obtest_customer.jar addition in seperate thread
The transaction that was blocking the backup has ended
Backup-2 Completed
obtest_customer.jar addition is complete
No of rows in table t1: 5
No of rows in table customer: 3
database shutdown properly
Restored From the Backup
No of rows in table t1: 5
No of rows in table customer: 2
database shutdown properly
End Of Install Jar Test.
Begin Remove Jar Test
ERROR XSRSA: Cannot backup the database when unlogged operations are uncommitted. Please commit the transactions with backup blocking operations.
Backup-3 Started
The transaction that was blocking the backup has ended
ERROR XSRS5: Error copying file (during backup) from
/export/home/tmp/DevDerby/test-20060223T102940-380071M/OnlineBackupTest3/wombat/jar/APP
to extinout/onlinebackuptest/wombat/jar/APP.
ERROR XSRS5: Error copying file (during backup) from
/export/home/tmp/DevDerby/test-20060223T102940-380071M/OnlineBackupTest3/wombat/jar/APP
to extinout/onlinebackuptest/wombat/jar/APP.
at
org.apache.derby.iapi.error.StandardException.newException(StandardException.java:322)
at org.apache.derby.impl.store.raw.RawStore.backup(RawStore.java:685)
at org.apache.derby.impl.store.raw.RawStore.backup(RawStore.java:533)
at
org.apache.derby.impl.store.access.RAMAccessManager.backup(RAMAccessManager.java:932)
at org.apache.derby.impl.db.BasicDatabase.backup(BasicDatabase.java:335)
at
org.apache.derby.catalog.SystemProcedures.SYSCS_BACKUP_DATABASE(SystemProcedures.java:708)
at
org.apache.derby.exe.ace50d80a4x0109x963ex1827xffff89e80d520.g0(Unknown Source)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:324)
at
org.apache.derby.impl.services.reflect.ReflectMethod.invoke(ReflectMethod.java:45)
at
org.apache.derby.impl.sql.execute.CallStatementResultSet.open(CallStatementResultSet.java:67)
at
org.apache.derby.impl.sql.GenericPreparedStatement.execute(GenericPreparedStatement.java:359)
at
org.apache.derby.impl.jdbc.EmbedStatement.executeStatement(EmbedStatement.java:1142)
at
org.apache.derby.impl.jdbc.EmbedPreparedStatement.executeStatement(EmbedPreparedStatement.java:1421)
at
org.apache.derby.impl.jdbc.EmbedCallableStatement.executeStatement(EmbedCallableStatement.java:109)
at
org.apache.derby.impl.jdbc.EmbedPreparedStatement.execute(EmbedPreparedStatement.java:1105)
at
org.apache.derbyTesting.functionTests.tests.store.OnlineBackup.performBackup(OnlineBackup.java:81)
at
org.apache.derbyTesting.functionTests.tests.store.OnlineBackup.run(OnlineBackup.java:59)
at java.lang.Thread.run(Thread.java:534)
Full thread dump Java HotSpot(TM) Client VM (1.4.2_02-b03 mixed mode):
"derby.rawStoreDaemon" daemon prio=1 tid=0x0a2500c0 nid=0x852 in Object.wait()
[aa809000..aa80923c]
at java.lang.Object.wait(Native Method)
- waiting on <0xac016550> (a
org.apache.derby.impl.services.daemon.BasicDaemon)
at
org.apache.derby.impl.services.daemon.BasicDaemon.rest(BasicDaemon.java:561)
- locked <0xac016550> (a
org.apache.derby.impl.services.daemon.BasicDaemon)
at
org.apache.derby.impl.services.daemon.BasicDaemon.run(BasicDaemon.java:378)
at java.lang.Thread.run(Thread.java:534)
"Thread-0" daemon prio=1 tid=0x0a0fbd70 nid=0x852 in Object.wait()
[aa88a000..aa88a23c]
at java.lang.Object.wait(Native Method)
- waiting on <0xabe855f0> (a java.util.TaskQueue)
at java.lang.Object.wait(Object.java:429)
at java.util.TimerThread.mainLoop(Timer.java:403)
- locked <0xabe855f0> (a java.util.TaskQueue)
at java.util.TimerThread.run(Timer.java:382)
"derby.antiGC" daemon prio=1 tid=0x0a08ed50 nid=0x852 in Object.wait()
[aa939000..aa93923c]
at java.lang.Object.wait(Native Method)
- waiting on <0xabe7eb28> (a
org.apache.derby.impl.services.monitor.AntiGC)
at java.lang.Object.wait(Object.java:429)
at
org.apache.derby.impl.services.monitor.AntiGC.run(BaseMonitor.java:2189)
- locked <0xabe7eb28> (a org.apache.derby.impl.services.monitor.AntiGC)
at java.lang.Thread.run(Thread.java:534)
"Signal Dispatcher" daemon prio=1 tid=0x09f73ce0 nid=0x852 waiting on condition
[0..0]
"Finalizer" daemon prio=1 tid=0x09f6ef20 nid=0x852 in Object.wait()
[ab7fd000..ab7fd23c]
at java.lang.Object.wait(Native Method)
- waiting on <0xabe6fbb8> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:111)
- locked <0xabe6fbb8> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:127)
at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:159)
"Reference Handler" daemon prio=1 tid=0x09f6e2c0 nid=0x852 in Object.wait()
[ab87e000..ab87e23c]
at java.lang.Object.wait(Native Method)
- waiting on <0xabe6fc20> (a java.lang.ref.Reference$Lock)
at java.lang.Object.wait(Object.java:429)
at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:115)
- locked <0xabe6fc20> (a java.lang.ref.Reference$Lock)
"main" prio=1 tid=0x09f38420 nid=0x852 in Object.wait() [bf918000..bf918a1c]
at java.lang.Object.wait(Native Method)
- waiting on <0xac078d38> (a
org.apache.derbyTesting.functionTests.tests.store.OnlineBackup)
at java.lang.Object.wait(Object.java:429)
at
org.apache.derbyTesting.functionTests.tests.store.OnlineBackup.waitForBackupToEnd(OnlineBackup.java:118)
- locked <0xac078d38> (a
org.apache.derbyTesting.functionTests.tests.store.OnlineBackup)
at
org.apache.derbyTesting.functionTests.tests.store.OnlineBackupTest3.removeJarTest(OnlineBackupTest3.java:419)
at
org.apache.derbyTesting.functionTests.tests.store.OnlineBackupTest3.runTest(OnlineBackupTest3.java:95)
at
org.apache.derbyTesting.functionTests.tests.store.OnlineBackupTest3.main(OnlineBackupTest3.java:50)
"VM Thread" prio=1 tid=0x09f6cf08 nid=0x852 runnable
"VM Periodic Task Thread" prio=1 tid=0x09f766e0 nid=0x852 waiting on condition
"Suspend Checker Thread" prio=1 tid=0x09f732f8 nid=0x852 runnable
