Hi Andy,
I attached a patch to JDO-166 implementing the test case
(DeleteCallback). If you adjust TCK debug logging, then the lifecycle
listener logs events as they arrive. Attached you find a log file.
Regards,
Michael
Hi Michael,
Is the different event handling concerning relationships intentional?
Impossible to comment without having a case in front of me that I can see what
is being performed. I dont know what relationships you have between those
objects and what is having makePersistent/deletePersistent called on it at
what point in the listing.
JPOX doesn't have any "different handling" for particular cases. It simply
fires events when an object is migrated between states.
When no relationships are involved then the events will always go in pairs
since nothing else is happening in between. It doesn't have to navigate
around to anything related to check if it should update that too.
When relationships are involved then it may start doing something and find
that the field has a related object, so has to navigate through the field and
perform the necessary operation on the related object. Consequently the other
object will likely finish its operation before the original object finishes,
and so the events won't go in pairs necessarily. For example, if you ask to
delete an object, and it has a related field that has changes not yet
flushed to the datastore, then the store events will then get fired on that,
before any delete happens on the requested object.
--
-------------------------------------------------------------------
Michael Watzek [EMAIL PROTECTED] Engineering GmbH
mailto:[EMAIL PROTECTED] Buelowstr. 66
Tel.: ++49/30/235 520 36 10783 Berlin - Germany
Fax.: ++49/30/217 520 12 http://www.spree.de/
-------------------------------------------------------------------
19:27:24,312 (main) DEBUG [org.apache.jdo.tck] - inserted [Company(1, name Sun
Microsystems, Inc., founded 11/Apr/1952)]
19:27:26,812 (main) DEBUG [org.apache.jdo.tck] - inserted [PrimitiveTypes(1),
PrimitiveTypes(2), PCClass(1), PCClass(2), PrimitiveTypes(3)]
19:27:26,843 (main) DEBUG [org.apache.jdo.tck] - Executing API query: SELECT
FROM org.apache.jdo.tck.pc.company.Person
19:27:26,953 (main) DEBUG [org.apache.jdo.tck] - Query result:
[FullTimeEmployee(5, emp5Last, emp5First, born 5/Jul/1962, phone
{work=126456-3,home=3363}, hired 15/Aug/1998, weeklyhours 0.0, $45000.0),
FullTimeEmployee(1, emp1Last, emp1First, born 10/Jun/1970, phone
{work=123456-1,home=1111}, hired 1/Jan/1999, weeklyhours 40.0, $20000.0),
FullTimeEmployee(2, emp2Last, emp2First, born 22/Dez/1975, phone
{work=123456-2,home=2222}, hired 1/Jul/2003, weeklyhours 40.0, $10000.0),
PartTimeEmployee(3, emp3Last, emp3First, born 5/Sep/1972, phone
{work=123456-3,home=3333}, hired 15/Aug/2002, weeklyhours 19.0, $15000.0),
PartTimeEmployee(4, emp4Last, emp4First, born 6/Sep/1973, phone
{work=124456-3,home=3343}, hired 15/Apr/2001, weeklyhours 0.0, $13000.0)]
19:27:26,968 (main) DEBUG [org.apache.jdo.tck] - Calling
JDOHelper.makeDirty(FullTimeEmployee(5, emp5Last, emp5First, born 5/Jul/1962,
phone {work=126456-3,home=3363}, hired 15/Aug/1998, weeklyhours 0.0, $45000.0),
"middlename")
19:27:26,968 (main) DEBUG [org.apache.jdo.tck] - Calling
JDOHelper.makeDirty(FullTimeEmployee(1, emp1Last, emp1First, born 10/Jun/1970,
phone {work=123456-1,home=1111}, hired 1/Jan/1999, weeklyhours 40.0, $20000.0),
"middlename")
19:27:26,968 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 5
19:27:26,984 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 5
19:27:26,984 (main) DEBUG [org.apache.jdo.tck] - Calling
JDOHelper.makeDirty(FullTimeEmployee(2, emp2Last, emp2First, born 22/Dez/1975,
phone {work=123456-2,home=2222}, hired 1/Jul/2003, weeklyhours 40.0, $10000.0),
"middlename")
19:27:26,984 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 1
19:27:26,984 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 1
19:27:26,984 (main) DEBUG [org.apache.jdo.tck] - Calling
JDOHelper.makeDirty(PartTimeEmployee(3, emp3Last, emp3First, born 5/Sep/1972,
phone {work=123456-3,home=3333}, hired 15/Aug/2002, weeklyhours 19.0,
$15000.0), "middlename")
19:27:26,984 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 2
19:27:27,000 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 2
19:27:27,000 (main) DEBUG [org.apache.jdo.tck] - Calling
JDOHelper.makeDirty(PartTimeEmployee(4, emp4Last, emp4First, born 6/Sep/1973,
phone {work=124456-3,home=3343}, hired 15/Apr/2001, weeklyhours 0.0, $13000.0),
"middlename")
19:27:27,000 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 3
19:27:27,000 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 3
19:27:27,000 (main) DEBUG [org.apache.jdo.tck] - Deleting persistent by API
query: SELECT FROM org.apache.jdo.tck.pc.company.Person
19:27:27,000 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 4
19:27:27,000 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 4
19:27:27,015 (main) DEBUG [org.apache.jdo.tck] - preDelete event:
org.apache.jdo.tck.pc.company.Person$Oid: 5
19:27:27,109 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 1
19:27:27,125 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 1
19:27:27,140 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 2
19:27:27,140 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 2
19:27:27,140 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 3
19:27:27,140 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 3
19:27:27,156 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 4
19:27:27,156 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 4
19:27:27,296 (main) DEBUG [org.apache.jdo.tck] - postDelete event:
org.apache.jdo.tck.pc.company.Person$Oid: 5
19:27:27,296 (main) DEBUG [org.apache.jdo.tck] - preDelete event:
org.apache.jdo.tck.pc.company.Person$Oid: 1
19:27:27,343 (main) DEBUG [org.apache.jdo.tck] - postDelete event:
org.apache.jdo.tck.pc.company.Person$Oid: 1
19:27:27,343 (main) DEBUG [org.apache.jdo.tck] - preDelete event:
org.apache.jdo.tck.pc.company.Person$Oid: 2
19:27:27,390 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 3
19:27:27,406 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 3
19:27:27,406 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 4
19:27:27,406 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 4
19:27:27,437 (main) DEBUG [org.apache.jdo.tck] - postDelete event:
org.apache.jdo.tck.pc.company.Person$Oid: 2
19:27:27,437 (main) DEBUG [org.apache.jdo.tck] - preDelete event:
org.apache.jdo.tck.pc.company.Person$Oid: 3
19:27:27,500 (main) DEBUG [org.apache.jdo.tck] - postDelete event:
org.apache.jdo.tck.pc.company.Person$Oid: 3
19:27:27,500 (main) DEBUG [org.apache.jdo.tck] - preDelete event:
org.apache.jdo.tck.pc.company.Person$Oid: 4
19:27:27,546 (main) DEBUG [org.apache.jdo.tck] - postDelete event:
org.apache.jdo.tck.pc.company.Person$Oid: 4
19:27:27,546 (main) DEBUG [org.apache.jdo.tck] - 5 objects deleted.
19:27:27,546 (main) DEBUG [org.apache.jdo.tck] - Verifying callbacks and states.
19:27:27,546 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.company.Person$Oid: 5
19:27:27,546 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.company.Person$Oid: 1
19:27:27,546 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.company.Person$Oid: 2
19:27:27,546 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.company.Person$Oid: 3
19:27:27,546 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.company.Person$Oid: 4
19:27:27,546 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.company.Person$Oid: 1
19:27:27,546 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.company.Person$Oid: 2
19:27:27,546 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.company.Person$Oid: 3
19:27:27,546 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.company.Person$Oid: 4
19:27:27,546 (main) DEBUG [org.apache.jdo.tck] - Verifying delete event on
org.apache.jdo.tck.pc.company.Person$Oid: 5
19:27:27,546 (main) DEBUG [org.apache.jdo.tck] - Verifying delete event on
org.apache.jdo.tck.pc.company.Person$Oid: 1
19:27:27,546 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.company.Person$Oid: 3
19:27:27,546 (main) DEBUG [org.apache.jdo.tck] - PC instances must not be
flushed after the delete has been executed.
19:27:27,593 (main) INFO [org.apache.jdo.tck] - Exception during setUp or
runtest:
junit.framework.AssertionFailedError: Assertion A14.8-4 (DeleteCallback)
failed:
PC instances must not be flushed after the delete has been executed.
at junit.framework.Assert.fail(Assert.java:47)
at org.apache.jdo.tck.JDO_Test.fail(JDO_Test.java:546)
at
org.apache.jdo.tck.query.delete.DeleteCallback$LifecycleVerifyer.verifyCallbacksAndStates(DeleteCallback.java:328)
at
org.apache.jdo.tck.query.delete.DeleteCallback.queryUpdateDeleteVerify(DeleteCallback.java:243)
at
org.apache.jdo.tck.query.delete.DeleteCallback.testRelationshipsAPI(DeleteCallback.java:131)
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 junit.framework.TestCase.runTest(TestCase.java:154)
at org.apache.jdo.tck.JDO_Test.runBare(JDO_Test.java:204)
at junit.framework.TestResult$1.protect(TestResult.java:106)
at junit.framework.TestResult.runProtected(TestResult.java:124)
at junit.framework.TestResult.run(TestResult.java:109)
at junit.framework.TestCase.run(TestCase.java:118)
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.textui.TestRunner.doRun(TestRunner.java:116)
at junit.textui.TestRunner.doRun(TestRunner.java:109)
at
org.apache.jdo.tck.util.BatchTestRunner.start(BatchTestRunner.java:120)
at org.apache.jdo.tck.util.BatchTestRunner.main(BatchTestRunner.java:95)
19:27:28,437 (main) DEBUG [org.apache.jdo.tck] - Free memory: 739880
19:27:30,125 (main) DEBUG [org.apache.jdo.tck] - inserted [Company(1, name Sun
Microsystems, Inc., founded 11/Apr/1952)]
19:27:31,500 (main) DEBUG [org.apache.jdo.tck] - inserted [PrimitiveTypes(1),
PrimitiveTypes(2), PCClass(1), PCClass(2), PrimitiveTypes(3)]
19:27:31,500 (main) DEBUG [org.apache.jdo.tck] - Executing single string query:
SELECT FROM org.apache.jdo.tck.pc.company.Person
19:27:31,562 (main) DEBUG [org.apache.jdo.tck] - Query result:
[FullTimeEmployee(5, emp5Last, emp5First, born 5/Jul/1962, phone
{work=126456-3,home=3363}, hired 15/Aug/1998, weeklyhours 0.0, $45000.0),
FullTimeEmployee(1, emp1Last, emp1First, born 10/Jun/1970, phone
{work=123456-1,home=1111}, hired 1/Jan/1999, weeklyhours 40.0, $20000.0),
FullTimeEmployee(2, emp2Last, emp2First, born 22/Dez/1975, phone
{work=123456-2,home=2222}, hired 1/Jul/2003, weeklyhours 40.0, $10000.0),
PartTimeEmployee(3, emp3Last, emp3First, born 5/Sep/1972, phone
{work=123456-3,home=3333}, hired 15/Aug/2002, weeklyhours 19.0, $15000.0),
PartTimeEmployee(4, emp4Last, emp4First, born 6/Sep/1973, phone
{work=124456-3,home=3343}, hired 15/Apr/2001, weeklyhours 0.0, $13000.0)]
19:27:31,562 (main) DEBUG [org.apache.jdo.tck] - Calling
JDOHelper.makeDirty(FullTimeEmployee(5, emp5Last, emp5First, born 5/Jul/1962,
phone {work=126456-3,home=3363}, hired 15/Aug/1998, weeklyhours 0.0, $45000.0),
"middlename")
19:27:31,562 (main) DEBUG [org.apache.jdo.tck] - Calling
JDOHelper.makeDirty(FullTimeEmployee(1, emp1Last, emp1First, born 10/Jun/1970,
phone {work=123456-1,home=1111}, hired 1/Jan/1999, weeklyhours 40.0, $20000.0),
"middlename")
19:27:31,562 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 5
19:27:31,578 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 5
19:27:31,578 (main) DEBUG [org.apache.jdo.tck] - Calling
JDOHelper.makeDirty(FullTimeEmployee(2, emp2Last, emp2First, born 22/Dez/1975,
phone {work=123456-2,home=2222}, hired 1/Jul/2003, weeklyhours 40.0, $10000.0),
"middlename")
19:27:31,578 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 1
19:27:31,578 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 1
19:27:31,578 (main) DEBUG [org.apache.jdo.tck] - Calling
JDOHelper.makeDirty(PartTimeEmployee(3, emp3Last, emp3First, born 5/Sep/1972,
phone {work=123456-3,home=3333}, hired 15/Aug/2002, weeklyhours 19.0,
$15000.0), "middlename")
19:27:31,578 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 2
19:27:31,578 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 2
19:27:31,578 (main) DEBUG [org.apache.jdo.tck] - Calling
JDOHelper.makeDirty(PartTimeEmployee(4, emp4Last, emp4First, born 6/Sep/1973,
phone {work=124456-3,home=3343}, hired 15/Apr/2001, weeklyhours 0.0, $13000.0),
"middlename")
19:27:31,578 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 3
19:27:31,593 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 3
19:27:31,593 (main) DEBUG [org.apache.jdo.tck] - Deleting persistent by single
string query: SELECT FROM org.apache.jdo.tck.pc.company.Person
19:27:31,593 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 4
19:27:31,593 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 4
19:27:31,609 (main) DEBUG [org.apache.jdo.tck] - preDelete event:
org.apache.jdo.tck.pc.company.Person$Oid: 5
19:27:31,656 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 1
19:27:31,671 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 1
19:27:31,671 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 2
19:27:31,671 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 2
19:27:31,671 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 3
19:27:31,671 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 3
19:27:31,687 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 4
19:27:31,687 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 4
19:27:31,828 (main) DEBUG [org.apache.jdo.tck] - postDelete event:
org.apache.jdo.tck.pc.company.Person$Oid: 5
19:27:31,828 (main) DEBUG [org.apache.jdo.tck] - preDelete event:
org.apache.jdo.tck.pc.company.Person$Oid: 1
19:27:31,859 (main) DEBUG [org.apache.jdo.tck] - postDelete event:
org.apache.jdo.tck.pc.company.Person$Oid: 1
19:27:31,859 (main) DEBUG [org.apache.jdo.tck] - preDelete event:
org.apache.jdo.tck.pc.company.Person$Oid: 2
19:27:31,906 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 3
19:27:31,906 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 3
19:27:31,906 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 4
19:27:31,906 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.company.Person$Oid: 4
19:27:31,937 (main) DEBUG [org.apache.jdo.tck] - postDelete event:
org.apache.jdo.tck.pc.company.Person$Oid: 2
19:27:31,937 (main) DEBUG [org.apache.jdo.tck] - preDelete event:
org.apache.jdo.tck.pc.company.Person$Oid: 3
19:27:31,984 (main) DEBUG [org.apache.jdo.tck] - postDelete event:
org.apache.jdo.tck.pc.company.Person$Oid: 3
19:27:31,984 (main) DEBUG [org.apache.jdo.tck] - preDelete event:
org.apache.jdo.tck.pc.company.Person$Oid: 4
19:27:32,031 (main) DEBUG [org.apache.jdo.tck] - postDelete event:
org.apache.jdo.tck.pc.company.Person$Oid: 4
19:27:32,031 (main) DEBUG [org.apache.jdo.tck] - 5 objects deleted.
19:27:32,031 (main) DEBUG [org.apache.jdo.tck] - Verifying callbacks and states.
19:27:32,031 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.company.Person$Oid: 5
19:27:32,031 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.company.Person$Oid: 1
19:27:32,031 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.company.Person$Oid: 2
19:27:32,031 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.company.Person$Oid: 3
19:27:32,031 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.company.Person$Oid: 4
19:27:32,031 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.company.Person$Oid: 1
19:27:32,031 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.company.Person$Oid: 2
19:27:32,031 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.company.Person$Oid: 3
19:27:32,031 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.company.Person$Oid: 4
19:27:32,031 (main) DEBUG [org.apache.jdo.tck] - Verifying delete event on
org.apache.jdo.tck.pc.company.Person$Oid: 5
19:27:32,031 (main) DEBUG [org.apache.jdo.tck] - Verifying delete event on
org.apache.jdo.tck.pc.company.Person$Oid: 1
19:27:32,031 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.company.Person$Oid: 3
19:27:32,031 (main) DEBUG [org.apache.jdo.tck] - PC instances must not be
flushed after the delete has been executed.
19:27:32,078 (main) INFO [org.apache.jdo.tck] - Exception during setUp or
runtest:
junit.framework.AssertionFailedError: Assertion A14.8-4 (DeleteCallback)
failed:
PC instances must not be flushed after the delete has been executed.
at junit.framework.Assert.fail(Assert.java:47)
at org.apache.jdo.tck.JDO_Test.fail(JDO_Test.java:546)
at
org.apache.jdo.tck.query.delete.DeleteCallback$LifecycleVerifyer.verifyCallbacksAndStates(DeleteCallback.java:328)
at
org.apache.jdo.tck.query.delete.DeleteCallback.queryUpdateDeleteVerify(DeleteCallback.java:243)
at
org.apache.jdo.tck.query.delete.DeleteCallback.testRelationshipsSingleString(DeleteCallback.java:136)
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 junit.framework.TestCase.runTest(TestCase.java:154)
at org.apache.jdo.tck.JDO_Test.runBare(JDO_Test.java:204)
at junit.framework.TestResult$1.protect(TestResult.java:106)
at junit.framework.TestResult.runProtected(TestResult.java:124)
at junit.framework.TestResult.run(TestResult.java:109)
at junit.framework.TestCase.run(TestCase.java:118)
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.textui.TestRunner.doRun(TestRunner.java:116)
at junit.textui.TestRunner.doRun(TestRunner.java:109)
at
org.apache.jdo.tck.util.BatchTestRunner.start(BatchTestRunner.java:120)
at org.apache.jdo.tck.util.BatchTestRunner.main(BatchTestRunner.java:95)
19:27:32,703 (main) DEBUG [org.apache.jdo.tck] - Free memory: 1260464
19:27:34,218 (main) DEBUG [org.apache.jdo.tck] - inserted [Company(1, name Sun
Microsystems, Inc., founded 11/Apr/1952)]
19:27:35,171 (main) DEBUG [org.apache.jdo.tck] - inserted [PrimitiveTypes(1),
PrimitiveTypes(2), PCClass(1), PCClass(2), PrimitiveTypes(3)]
19:27:35,171 (main) DEBUG [org.apache.jdo.tck] - Executing API query: SELECT
FROM org.apache.jdo.tck.pc.mylib.PrimitiveTypes
19:27:35,171 (main) DEBUG [org.apache.jdo.tck] - Query result:
[PrimitiveTypes(1), PrimitiveTypes(2), PrimitiveTypes(3)]
19:27:35,187 (main) DEBUG [org.apache.jdo.tck] - Calling
JDOHelper.makeDirty(PrimitiveTypes(1), "stringNull")
19:27:35,187 (main) DEBUG [org.apache.jdo.tck] - Calling
JDOHelper.makeDirty(PrimitiveTypes(2), "stringNull")
19:27:35,187 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 1
19:27:35,203 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 1
19:27:35,203 (main) DEBUG [org.apache.jdo.tck] - Calling
JDOHelper.makeDirty(PrimitiveTypes(3), "stringNull")
19:27:35,203 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 2
19:27:35,203 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 2
19:27:35,203 (main) DEBUG [org.apache.jdo.tck] - Deleting persistent by API
query: SELECT FROM org.apache.jdo.tck.pc.mylib.PrimitiveTypes
19:27:35,203 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 3
19:27:35,203 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 3
19:27:35,218 (main) DEBUG [org.apache.jdo.tck] - preDelete event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 1
19:27:35,218 (main) DEBUG [org.apache.jdo.tck] - postDelete event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 1
19:27:35,218 (main) DEBUG [org.apache.jdo.tck] - preDelete event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 2
19:27:35,218 (main) DEBUG [org.apache.jdo.tck] - postDelete event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 2
19:27:35,218 (main) DEBUG [org.apache.jdo.tck] - preDelete event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 3
19:27:35,218 (main) DEBUG [org.apache.jdo.tck] - postDelete event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 3
19:27:35,218 (main) DEBUG [org.apache.jdo.tck] - 3 objects deleted.
19:27:35,218 (main) DEBUG [org.apache.jdo.tck] - Verifying callbacks and states.
19:27:35,218 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 1
19:27:35,218 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 2
19:27:35,218 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 3
19:27:35,218 (main) DEBUG [org.apache.jdo.tck] - Verifying delete event on
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 1
19:27:35,218 (main) DEBUG [org.apache.jdo.tck] - Verifying delete event on
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 2
19:27:35,218 (main) DEBUG [org.apache.jdo.tck] - Verifying delete event on
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 3
19:27:35,937 (main) DEBUG [org.apache.jdo.tck] - Free memory: 3037888
19:27:37,046 (main) DEBUG [org.apache.jdo.tck] - inserted [Company(1, name Sun
Microsystems, Inc., founded 11/Apr/1952)]
19:27:38,234 (main) DEBUG [org.apache.jdo.tck] - inserted [PrimitiveTypes(1),
PrimitiveTypes(2), PCClass(1), PCClass(2), PrimitiveTypes(3)]
19:27:38,250 (main) DEBUG [org.apache.jdo.tck] - Executing single string query:
SELECT FROM org.apache.jdo.tck.pc.mylib.PrimitiveTypes
19:27:38,250 (main) DEBUG [org.apache.jdo.tck] - Query result:
[PrimitiveTypes(1), PrimitiveTypes(2), PrimitiveTypes(3)]
19:27:38,265 (main) DEBUG [org.apache.jdo.tck] - Calling
JDOHelper.makeDirty(PrimitiveTypes(1), "stringNull")
19:27:38,265 (main) DEBUG [org.apache.jdo.tck] - Calling
JDOHelper.makeDirty(PrimitiveTypes(2), "stringNull")
19:27:38,265 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 1
19:27:38,265 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 1
19:27:38,265 (main) DEBUG [org.apache.jdo.tck] - Calling
JDOHelper.makeDirty(PrimitiveTypes(3), "stringNull")
19:27:38,265 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 2
19:27:38,281 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 2
19:27:38,281 (main) DEBUG [org.apache.jdo.tck] - Deleting persistent by single
string query: SELECT FROM org.apache.jdo.tck.pc.mylib.PrimitiveTypes
19:27:38,281 (main) DEBUG [org.apache.jdo.tck] - preStore event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 3
19:27:38,281 (main) DEBUG [org.apache.jdo.tck] - postStore event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 3
19:27:38,281 (main) DEBUG [org.apache.jdo.tck] - preDelete event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 1
19:27:38,281 (main) DEBUG [org.apache.jdo.tck] - postDelete event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 1
19:27:38,281 (main) DEBUG [org.apache.jdo.tck] - preDelete event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 2
19:27:38,281 (main) DEBUG [org.apache.jdo.tck] - postDelete event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 2
19:27:38,281 (main) DEBUG [org.apache.jdo.tck] - preDelete event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 3
19:27:38,296 (main) DEBUG [org.apache.jdo.tck] - postDelete event:
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 3
19:27:38,296 (main) DEBUG [org.apache.jdo.tck] - 3 objects deleted.
19:27:38,296 (main) DEBUG [org.apache.jdo.tck] - Verifying callbacks and states.
19:27:38,296 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 1
19:27:38,296 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 2
19:27:38,296 (main) DEBUG [org.apache.jdo.tck] - Verifying store event on
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 3
19:27:38,296 (main) DEBUG [org.apache.jdo.tck] - Verifying delete event on
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 1
19:27:38,296 (main) DEBUG [org.apache.jdo.tck] - Verifying delete event on
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 2
19:27:38,296 (main) DEBUG [org.apache.jdo.tck] - Verifying delete event on
org.apache.jdo.tck.pc.mylib.PrimitiveTypes$Oid: 3
19:27:39,093 (main) DEBUG [org.apache.jdo.tck] - Free memory: 6087240
19:27:40,187 (main) DEBUG [org.apache.jdo.tck] - inserted [Company(1, name Sun
Microsystems, Inc., founded 11/Apr/1952)]
19:27:41,078 (main) DEBUG [org.apache.jdo.tck] - Deleting persistent by API
query: SELECT UNIQUE FROM org.apache.jdo.tck.pc.company.FullTimeEmployee WHERE
salary > 1000 & projects.contains(project) & project.budget > limit VARIABLES
Project project PARAMETERS BigDecimal limit IMPORTS import
org.apache.jdo.tck.pc.company.Project; import java.math.BigDecimal;
19:27:41,421 (main) DEBUG [org.apache.jdo.tck] - 3 objects deleted.
19:27:41,500 (main) DEBUG [org.apache.jdo.tck] - Query result: null
19:27:41,906 (main) DEBUG [org.apache.jdo.tck] - Free memory: 3292496
19:27:42,953 (main) DEBUG [org.apache.jdo.tck] - inserted [Company(1, name Sun
Microsystems, Inc., founded 11/Apr/1952)]
19:27:43,593 (main) DEBUG [org.apache.jdo.tck] - Deleting persistent by single
string query: SELECT UNIQUE FROM org.apache.jdo.tck.pc.company.FullTimeEmployee
WHERE salary > 1000 & projects.contains(project) & project.budget > limit
VARIABLES Project project PARAMETERS BigDecimal limit IMPORTS import
org.apache.jdo.tck.pc.company.Project; import java.math.BigDecimal;
19:27:43,906 (main) DEBUG [org.apache.jdo.tck] - 3 objects deleted.
19:27:43,921 (main) DEBUG [org.apache.jdo.tck] - Query result: null
19:27:44,125 (main) DEBUG [org.apache.jdo.tck] - Free memory: 1444368
19:27:45,375 (main) DEBUG [org.apache.jdo.tck] - inserted [Company(1, name Sun
Microsystems, Inc., founded 11/Apr/1952)]
19:27:45,703 (main) DEBUG [org.apache.jdo.tck] - Deleting persistent by API
query: SELECT firstname, lastname FROM org.apache.jdo.tck.pc.company.Person
19:27:45,703 (main) DEBUG [org.apache.jdo.tck] - Deleting persistent by API
query: SELECT INTO org.apache.jdo.tck.query.result.classes.FullName FROM
org.apache.jdo.tck.pc.company.Person
19:27:45,703 (main) DEBUG [org.apache.jdo.tck] - Deleting persistent by API
query: SELECT firstname, lastname INTO
org.apache.jdo.tck.query.result.classes.FullName FROM
org.apache.jdo.tck.pc.company.Person
19:27:45,703 (main) DEBUG [org.apache.jdo.tck] - Deleting persistent by API
query: SELECT FROM org.apache.jdo.tck.pc.company.Person GROUP BY lastname
19:27:45,703 (main) DEBUG [org.apache.jdo.tck] - Deleting persistent by API
query: SELECT lastname FROM org.apache.jdo.tck.pc.company.Person GROUP BY
lastname
19:27:45,718 (main) DEBUG [org.apache.jdo.tck] - Deleting persistent by API
query: SELECT FROM org.apache.jdo.tck.pc.company.Person ORDER BY lastname
19:27:45,718 (main) DEBUG [org.apache.jdo.tck] - Deleting persistent by API
query: SELECT FROM org.apache.jdo.tck.pc.company.Person RANGE 0,5
19:27:46,078 (main) DEBUG [org.apache.jdo.tck] - 5 objects deleted.
19:27:46,078 (main) DEBUG [org.apache.jdo.tck] - deletePersistentAll must throw
JDOUserException: SELECT FROM org.apache.jdo.tck.pc.company.Person RANGE 0,5
19:27:46,125 (main) INFO [org.apache.jdo.tck] - Exception during setUp or
runtest:
junit.framework.AssertionFailedError: Assertion A14.8-1 (DeleteQueryElements)
failed:
deletePersistentAll must throw JDOUserException: SELECT FROM
org.apache.jdo.tck.pc.company.Person RANGE 0,5
at junit.framework.Assert.fail(Assert.java:47)
at org.apache.jdo.tck.JDO_Test.fail(JDO_Test.java:546)
at org.apache.jdo.tck.query.QueryTest.delete(QueryTest.java:1304)
at org.apache.jdo.tck.query.QueryTest.delete(QueryTest.java:1248)
at
org.apache.jdo.tck.query.QueryTest.deletePersistentAllByAPIQuery(QueryTest.java:1195)
at
org.apache.jdo.tck.query.delete.DeleteQueryElements.testNegative(DeleteQueryElements.java:218)
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 junit.framework.TestCase.runTest(TestCase.java:154)
at org.apache.jdo.tck.JDO_Test.runBare(JDO_Test.java:204)
at junit.framework.TestResult$1.protect(TestResult.java:106)
at junit.framework.TestResult.runProtected(TestResult.java:124)
at junit.framework.TestResult.run(TestResult.java:109)
at junit.framework.TestCase.run(TestCase.java:118)
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.textui.TestRunner.doRun(TestRunner.java:116)
at junit.textui.TestRunner.doRun(TestRunner.java:109)
at
org.apache.jdo.tck.util.BatchTestRunner.start(BatchTestRunner.java:120)
at org.apache.jdo.tck.util.BatchTestRunner.main(BatchTestRunner.java:95)
19:27:46,625 (main) DEBUG [org.apache.jdo.tck] - Free memory: 5253200
19:27:47,546 (main) DEBUG [org.apache.jdo.tck] - inserted [Company(1, name Sun
Microsystems, Inc., founded 11/Apr/1952)]
19:27:48,437 (main) DEBUG [org.apache.jdo.tck] - Deleting persistent by API
query: SELECT FROM org.apache.jdo.tck.pc.company.Person
19:27:48,937 (main) DEBUG [org.apache.jdo.tck] - 5 objects deleted.
19:27:48,968 (main) DEBUG [org.apache.jdo.tck] - Query result: []
19:27:49,312 (main) DEBUG [org.apache.jdo.tck] - Free memory: 3093360
19:27:50,625 (main) DEBUG [org.apache.jdo.tck] - inserted [Company(1, name Sun
Microsystems, Inc., founded 11/Apr/1952)]
19:27:51,078 (main) DEBUG [org.apache.jdo.tck] - Deleting persistent by single
string query: SELECT FROM org.apache.jdo.tck.pc.company.Person
19:27:51,296 (main) DEBUG [org.apache.jdo.tck] - 5 objects deleted.
19:27:51,953 (main) DEBUG [org.apache.jdo.tck] - Query result: []
19:27:52,078 (main) DEBUG [org.apache.jdo.tck] - Free memory: 5954280
19:27:52,906 (main) DEBUG [org.apache.jdo.tck] - inserted [Company(1, name Sun
Microsystems, Inc., founded 11/Apr/1952)]
19:27:53,578 (main) DEBUG [org.apache.jdo.tck] - Deleting persistent by API
query: SELECT FROM org.apache.jdo.tck.pc.company.Person WHERE firstname ==
param PARAMETERS String param
19:27:53,656 (main) DEBUG [org.apache.jdo.tck] - 1 objects deleted.
19:27:53,687 (main) DEBUG [org.apache.jdo.tck] - Query result: []
19:27:54,203 (main) DEBUG [org.apache.jdo.tck] - Free memory: 4101704
19:27:55,203 (main) DEBUG [org.apache.jdo.tck] - inserted [Company(1, name Sun
Microsystems, Inc., founded 11/Apr/1952)]
19:27:55,546 (main) DEBUG [org.apache.jdo.tck] - Deleting persistent by single
string query: SELECT FROM org.apache.jdo.tck.pc.company.Person WHERE firstname
== param PARAMETERS String param
19:27:55,609 (main) DEBUG [org.apache.jdo.tck] - 1 objects deleted.
19:27:55,609 (main) DEBUG [org.apache.jdo.tck] - Query result: []
19:27:56,000 (main) DEBUG [org.apache.jdo.tck] - Free memory: 2364904
19:27:56,687 (main) DEBUG [org.apache.jdo.tck] - inserted [Company(1, name Sun
Microsystems, Inc., founded 11/Apr/1952)]
19:27:57,687 (main) DEBUG [org.apache.jdo.tck] - Deleting persistent by API
query: SELECT FROM org.apache.jdo.tck.pc.company.Person WHERE firstname ==
param PARAMETERS String param
19:27:57,734 (main) DEBUG [org.apache.jdo.tck] - 1 objects deleted.
19:27:57,750 (main) DEBUG [org.apache.jdo.tck] - Query result: []
19:27:58,265 (main) DEBUG [org.apache.jdo.tck] - Free memory: 7065952
19:27:59,234 (main) DEBUG [org.apache.jdo.tck] - inserted [Company(1, name Sun
Microsystems, Inc., founded 11/Apr/1952)]
19:27:59,593 (main) DEBUG [org.apache.jdo.tck] - Deleting persistent by single
string query: SELECT FROM org.apache.jdo.tck.pc.company.Person WHERE firstname
== param PARAMETERS String param
19:27:59,640 (main) DEBUG [org.apache.jdo.tck] - 1 objects deleted.
19:27:59,671 (main) DEBUG [org.apache.jdo.tck] - Query result: []
19:27:59,984 (main) DEBUG [org.apache.jdo.tck] - Free memory: 5628536
