You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@river.apache.org by Peter Firmstone <ji...@zeus.net.au> on 2014/05/23 07:17:09 UTC
Remaining test failures - suspect concurrency / race condition
I've seen this test fail on Java 8 on Windows 32 bit and Java 7 on Linux
(Jenkins).
This test relates to ServiceDiscoveryManager.
The test doesn't fail consistently.
Running com/sun/jini/test/impl/servicediscovery/event/ReRegisterBadEquals.td
Time is Wed Feb 26 14:39:57 UTC 2014
Starting test in separate process with command:
/home/jenkins/tools/java/jdk1.7.0_25-32/jre/bin/java -Djava.security.manager=org.apache.river.api.security.CombinerSecurityManager -Djava.security.policy=file:/home/jenkins/jenkins-slave/workspace/river-qa-refactoring-jdk7/trunk/qa/harness/policy/defaulttest.policy -Djava.rmi.server.codebase=http://minerva:9082/qa1-servicediscovery-dl.jar -cp /home/jenkins/jenkins-slave/workspace/river-qa-refactoring-jdk7/trunk/qa/lib/jiniharness.jar:/home/jenkins/jenkins-slave/workspace/river-qa-refactoring-jdk7/trunk/qa/lib/jinitests.jar:/home/jenkins/jenkins-slave/workspace/river-qa-refactoring-jdk7/trunk/lib/jsk-platform.jar:/home/jenkins/jenkins-slave/workspace/river-qa-refactoring-jdk7/trunk/lib/jsk-lib.jar:/home/jenkins/jenkins-slave/workspace/river-qa-refactoring-jdk7/trunk/lib/high-scale-lib.jar:/home/jenkins/jenkins-slave/workspace/river-qa-refactoring-jdk7/trunk/lib/custard-apple-1.0.3.jar -ea -esa -Djava.ext.dirs=/home/jenkins/tools/java/jdk1.7.0_25-32/jre/lib/ext:/usr/java/packages/lib/ext:/home/jenkins/jenkins-slave/workspace/river-qa-refactoring-jdk7/trunk/qa/lib-ext:/home/jenkins/jenkins-slave/workspace/river-qa-refactoring-jdk7/trunk/lib-ext -Dcom.sun.jini.jsk.port=9080 -Dcom.sun.jini.qa.port=9081 -Dcom.sun.jini.jsk.home=/home/jenkins/jenkins-slave/workspace/river-qa-refactoring-jdk7/trunk -Dcom.sun.jini.qa.home=/home/jenkins/jenkins-slave/workspace/river-qa-refactoring-jdk7/trunk/qa -Dcom.sun.jini.qa.harness.harnessJar=/home/jenkins/jenkins-slave/workspace/river-qa-refactoring-jdk7/trunk/qa/lib/jiniharness.jar -Dcom.sun.jini.qa.harness.testJar=/home/jenkins/jenkins-slave/workspace/river-qa-refactoring-jdk7/trunk/qa/lib/jinitests.jar -Dcom.sun.jini.qa.harness.runjiniserver=true -Dcom.sun.jini.qa.harness.runkitserver=true -Djava.security.properties=file:/home/jenkins/jenkins-slave/workspace/river-qa-refactoring-jdk7/trunk/qa/harness/trust/dynamic-policy.properties -Dcom.sun.jini.qa.harness.testhosts= -Djava.util.logging.config.file=/home/jenkins/jenkins-slave/workspace/river-qa-refactoring-jdk7/trunk/qa/src/com/sun/jini/test/resources/qa1.logging -Djava.rmi.server.useCodebaseOnly=false -Dnet.jini.core.lookup.ServiceRegistrar.portAbitraryIfInUse=true -Dcom.sun.jini.test.home=/home/jenkins/jenkins-slave/workspace/river-qa-refactoring-jdk7/trunk/qa -Dcom.sun.jini.test.port=9082 -Dcom.sun.jini.qa.harness.policies=file:/home/jenkins/jenkins-slave/workspace/river-qa-refactoring-jdk7/trunk/qa/src/com/sun/jini/test/resources/jinitest.policy -Djava.ext.dirs=/home/jenkins/tools/java/jdk1.7.0_25-32/jre/lib/ext:/usr/java/packages/lib/ext:/home/jenkins/jenkins-slave/workspace/river-qa-refactoring-jdk7/trunk/qa/lib-ext:/home/jenkins/jenkins-slave/workspace/river-qa-refactoring-jdk7/trunk/lib-ext com.sun.jini.qa.harness.MasterTest com/sun/jini/test/impl/servicediscovery/event/ReRegisterBadEquals.td
TIME: 2:39:57 PM
MasterTest.doTest INFO:
============================== CALLING CONSTRUCT() ==============================
Feb 26, 2014 2:39:58 PM com.sun.jini.tool.ClassServer run
INFO: ClassServer started [[/home/jenkins/jenkins-slave/workspace/river-qa-refactoring-jdk7/trunk/qa/lib/], port 9081]
Feb 26, 2014 2:39:58 PM com.sun.jini.tool.ClassServer run
INFO: ClassServer started [[/home/jenkins/jenkins-slave/workspace/river-qa-refactoring-jdk7/trunk/lib-dl/], port 9080]
Feb 26, 2014 2:39:58 PM com.sun.jini.tool.ClassServer run
INFO: ClassServer started [[/home/jenkins/jenkins-slave/workspace/river-qa-refactoring-jdk7/trunk/qa/lib/], port 9082]
MasterTest.doTest INFO:
=============================== CALLING RUN() ===============================
com.sun.jini.qa.harness.TestException: -- failure -- nAdded = 3, nAddedExpected = 4, nRemoved = 1, nRemovedExpected = 2
at com.sun.jini.test.impl.servicediscovery.event.ReRegisterGoodEquals.applyTestDef(ReRegisterGoodEquals.java:131)
at com.sun.jini.test.spec.servicediscovery.AbstractBaseTest.run(AbstractBaseTest.java:552)
at com.sun.jini.qa.harness.MasterTest.doTest(MasterTest.java:256)
at com.sun.jini.qa.harness.MasterTest.main(MasterTest.java:144)
TIME: 2:41:11 PM
MasterTest.doTest INFO:
============================ CALLING TEARDOWN() =============================
Feb 26, 2014 2:41:21 PM com.sun.jini.tool.ClassServer terminate
INFO: ClassServer terminated [port 9082]
Feb 26, 2014 2:41:21 PM com.sun.jini.tool.ClassServer terminate
INFO: ClassServer terminated [port 9080]
Feb 26, 2014 2:41:21 PM com.sun.jini.tool.ClassServer terminate
INFO: ClassServer terminated [port 9082]
Feb 26, 2014 2:41:21 PM com.sun.jini.tool.ClassServer terminate
INFO: ClassServer terminated [port 9081]
Feb 26, 2014 2:41:21 PM com.sun.jini.tool.ClassServer terminate
INFO: ClassServer terminated [port 9080]
Feb 26, 2014 2:41:21 PM com.sun.jini.tool.ClassServer terminate
INFO: ClassServer terminated [port 9081]
TIME: 2:41:21 PM
Test process was destroyed and returned code 1
com/sun/jini/test/impl/servicediscovery/event/ReRegisterBadEquals.td
Test Failed: Test Failed: com.sun.jini.qa.harness.TestException: -- failure -- nAdded = 3, nAddedExpected = 4, nRemoved = 1, nRemovedExpected = 2
ant -f
C:\\Users\\peter\\Documents\\NetBeansProjects\\peterConcurrentPolicy
qa.run-tests
qa.run-tests:
qa.james-brown:
Deleting directory
C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa\soul
Created dir:
C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa\soul
Creating
C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa\soul\soul.201405231406005750
qa.run-tests:
-----------------------------------------
CONFIGURATION FILE:
C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa\src\com\sun\jini\test\resources\qaHarness.prop
-----------------------------------------
SETTING UP THE TEST LIST:
Adding test:
com/sun/jini/test/impl/servicediscovery/event/ReRegisterBadEquals.td
Adding test:
com/sun/jini/test/impl/servicediscovery/event/ReRegisterGoodEquals.td
-----------------------------------------
GENERAL HARNESS CONFIGURATION INFORMATION:
Date started:
Fri May 23 14:06:12 EST 2014
Installation directory of the JSK:
com.sun.jini.jsk.home=C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy
Installation directory of the harness:
com.sun.jini.qa.home=C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa
Categories being tested:
categories=No Categories
-----------------------------------------
ENVIRONMENT PROPERTIES:
JVM information:
Java HotSpot(TM) Client VM, 25.0-b70, 32 bit VM mode
Oracle Corporation
OS information:
Windows 7, 6.1, x86
-----------------------------------------
STARTING TO RUN THE TESTS
Running com/sun/jini/test/impl/servicediscovery/event/ReRegisterBadEquals.td
Time is Fri May 23 14:06:12 EST 2014
Starting test in separate process with command:
'C:\Program Files\Java\jdk1.8.0\jre\bin\java'
-Djava.security.manager=org.apache.river.api.security.CombinerSecurityManager
-Djava.security.policy=file:/C:/Users/peter/Documents/NetBeansProjects/peterConcurrentPolicy/qa/harness/policy/defaulttest.policy
-Djava.rmi.server.codebase=http://medusa:9082/qa1-servicediscovery-dl.jar -cp
C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa\lib\jiniharness.jar;C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa\lib\jinitests.jar;C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\lib\jsk-platform.jar;C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\lib\jsk-lib.jar;C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\lib\high-scale-lib.jar;C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\lib\custard-apple-1.0.3.jar
-ea -esa '-Djava.ext.dirs=C:\Program
Files\Java\jdk1.8.0\jre\lib\ext;C:\windows\Sun\Java\lib\ext;C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa\lib-ext;C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\lib-ext'
-Dcom.sun.jini.jsk.port=9080 -Dcom.sun.jini.qa.port=9081
-Dcom.sun.jini.jsk.home=C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy
-Dcom.sun.jini.qa.home=C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa
-Dcom.sun.jini.qa.harness.harnessJar=C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa\lib\jiniharness.jar
-Dcom.sun.jini.qa.harness.testJar=C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa\lib\jinitests.jar
-Dcom.sun.jini.qa.harness.runjiniserver=true
-Dcom.sun.jini.qa.harness.runkitserver=true
-Djava.security.properties=file:/C:/Users/peter/Documents/NetBeansProjects/peterConcurrentPolicy/qa/harness/trust/dynamic-policy.properties
-Dcom.sun.jini.qa.harness.testhosts=
-Djava.util.logging.config.file=C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa\src\com\sun\jini\test\resources\qa1.logging
-Djava.rmi.server.useCodebaseOnly=false
-Dnet.jini.core.lookup.ServiceRegistrar.portAbitraryIfInUse=true
-Dcom.sun.jini.test.home=C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa
-Dcom.sun.jini.test.port=9082
-Dcom.sun.jini.qa.harness.policies=file:/C:/Users/peter/Documents/NetBeansProjects/peterConcurrentPolicy/qa/src/com/sun/jini/test/resources/jinitest.policy
'-Djava.ext.dirs=C:\Program
Files\Java\jdk1.8.0\jre\lib\ext;C:\windows\Sun\Java\lib\ext;C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa\lib-ext;C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\lib-ext'
com.sun.jini.qa.harness.MasterTest
com/sun/jini/test/impl/servicediscovery/event/ReRegisterBadEquals.td
TIME: 2:06:14 PM
MasterTest.doTest INFO:
============================== CALLING CONSTRUCT()
==============================
May 23, 2014 2:06:15 PM com.sun.jini.tool.ClassServer run
INFO: ClassServer started
[[C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa\lib\],
port 9081]
May 23, 2014 2:06:15 PM com.sun.jini.tool.ClassServer run
INFO: ClassServer started
[[C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa\lib\],
port 9082]
May 23, 2014 2:06:15 PM com.sun.jini.tool.ClassServer run
INFO: ClassServer started
[[C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\lib-dl\],
port 9080]
TIME: 2:09:22 PM
MasterTest.doTest INFO:
=============================== CALLING RUN()
===============================
com.sun.jini.qa.harness.TestException: -- failure -- nAdded = 3,
nAddedExpected = 4, nRemoved = 1, nRemovedExpected = 2
at
com.sun.jini.test.impl.servicediscovery.event.ReRegisterGoodEquals.applyTestDef(ReRegisterGoodEquals.java:131)
at
com.sun.jini.test.spec.servicediscovery.AbstractBaseTest.run(AbstractBaseTest.java:552)
at com.sun.jini.qa.harness.MasterTest.doTest(MasterTest.java:256)
at com.sun.jini.qa.harness.MasterTest.main(MasterTest.java:144)
TIME: 2:10:38 PM
MasterTest.doTest INFO:
============================ CALLING TEARDOWN()
=============================
TIME: 2:10:56 PM
NonActivatableGroupAdmin.stop INFO: Nonactivatable group process did not
exit
May 23, 2014 2:10:56 PM com.sun.jini.tool.ClassServer terminate
INFO: ClassServer terminated [port 9080]
May 23, 2014 2:10:56 PM com.sun.jini.tool.ClassServer terminate
INFO: ClassServer terminated [port 9080]
May 23, 2014 2:10:56 PM com.sun.jini.tool.ClassServer terminate
INFO: ClassServer terminated [port 9082]
May 23, 2014 2:10:56 PM com.sun.jini.tool.ClassServer terminate
INFO: ClassServer terminated [port 9082]
May 23, 2014 2:10:56 PM com.sun.jini.tool.ClassServer terminate
INFO: ClassServer terminated [port 9081]
May 23, 2014 2:10:56 PM com.sun.jini.tool.ClassServer terminate
INFO: ClassServer terminated [port 9081]
TIME: 2:11:01 PM
Test process was destroyed and returned code 1
com/sun/jini/test/impl/servicediscovery/event/ReRegisterBadEquals.td
Test Failed: Test Failed: com.sun.jini.qa.harness.TestException: --
failure -- nAdded = 3, nAddedExpected = 4, nRemoved = 1,
nRemovedExpected = 2
-----------------------------------------
Running
com/sun/jini/test/impl/servicediscovery/event/ReRegisterGoodEquals.td
Time is Fri May 23 14:11:06 EST 2014
Starting test in separate process with command:
'C:\Program Files\Java\jdk1.8.0\jre\bin\java'
-Djava.security.manager=org.apache.river.api.security.CombinerSecurityManager
-Djava.security.policy=file:/C:/Users/peter/Documents/NetBeansProjects/peterConcurrentPolicy/qa/harness/policy/defaulttest.policy
-Djava.rmi.server.codebase=http://medusa:9082/qa1-servicediscovery-dl.jar -cp
C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa\lib\jiniharness.jar;C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa\lib\jinitests.jar;C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\lib\jsk-platform.jar;C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\lib\jsk-lib.jar;C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\lib\high-scale-lib.jar;C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\lib\custard-apple-1.0.3.jar
-ea -esa '-Djava.ext.dirs=C:\Program
Files\Java\jdk1.8.0\jre\lib\ext;C:\windows\Sun\Java\lib\ext;C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa\lib-ext;C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\lib-ext'
-Dcom.sun.jini.jsk.port=9080 -Dcom.sun.jini.qa.port=9081
-Dcom.sun.jini.jsk.home=C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy
-Dcom.sun.jini.qa.home=C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa
-Dcom.sun.jini.qa.harness.harnessJar=C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa\lib\jiniharness.jar
-Dcom.sun.jini.qa.harness.testJar=C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa\lib\jinitests.jar
-Dcom.sun.jini.qa.harness.runjiniserver=true
-Dcom.sun.jini.qa.harness.runkitserver=true
-Djava.security.properties=file:/C:/Users/peter/Documents/NetBeansProjects/peterConcurrentPolicy/qa/harness/trust/dynamic-policy.properties
-Dcom.sun.jini.qa.harness.testhosts=
-Djava.util.logging.config.file=C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa\src\com\sun\jini\test\resources\qa1.logging
-Djava.rmi.server.useCodebaseOnly=false
-Dnet.jini.core.lookup.ServiceRegistrar.portAbitraryIfInUse=true
-Dcom.sun.jini.test.home=C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa
-Dcom.sun.jini.test.port=9082
-Dcom.sun.jini.qa.harness.policies=file:/C:/Users/peter/Documents/NetBeansProjects/peterConcurrentPolicy/qa/src/com/sun/jini/test/resources/jinitest.policy
'-Djava.ext.dirs=C:\Program
Files\Java\jdk1.8.0\jre\lib\ext;C:\windows\Sun\Java\lib\ext;C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa\lib-ext;C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\lib-ext'
com.sun.jini.qa.harness.MasterTest
com/sun/jini/test/impl/servicediscovery/event/ReRegisterGoodEquals.td
TIME: 2:11:11 PM
MasterTest.doTest INFO:
============================== CALLING CONSTRUCT()
==============================
May 23, 2014 2:11:12 PM com.sun.jini.tool.ClassServer run
INFO: ClassServer started
[[C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\lib-dl\],
port 9080]
May 23, 2014 2:11:12 PM com.sun.jini.tool.ClassServer run
INFO: ClassServer started
[[C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa\lib\],
port 9081]
May 23, 2014 2:11:12 PM com.sun.jini.tool.ClassServer run
INFO: ClassServer started
[[C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa\lib\],
port 9082]
TIME: 2:14:25 PM
MasterTest.doTest INFO:
=============================== CALLING RUN()
===============================
TIME: 2:15:43 PM
MasterTest.doTest INFO:
============================ CALLING TEARDOWN()
=============================
TIME: 2:16:02 PM
NonActivatableGroupAdmin.stop INFO: Nonactivatable group process did not
exit
May 23, 2014 2:16:02 PM com.sun.jini.tool.ClassServer terminate
INFO: ClassServer terminated [port 9080]
May 23, 2014 2:16:02 PM com.sun.jini.tool.ClassServer terminate
INFO: ClassServer terminated [port 9082]
May 23, 2014 2:16:02 PM com.sun.jini.tool.ClassServer terminate
INFO: ClassServer terminated [port 9082]
May 23, 2014 2:16:02 PM com.sun.jini.tool.ClassServer terminate
INFO: ClassServer terminated [port 9081]
May 23, 2014 2:16:02 PM com.sun.jini.tool.ClassServer terminate
INFO: ClassServer terminated [port 9080]
TIME: 2:16:07 PM
Test process was destroyed and returned code 0
com/sun/jini/test/impl/servicediscovery/event/ReRegisterGoodEquals.td
Test Passed: OK
-----------------------------------------
SUMMARY =================================
com/sun/jini/test/impl/servicediscovery/event/ReRegisterBadEquals.td
Test Failed: Test Failed: com.sun.jini.qa.harness.TestException: --
failure -- nAdded = 3, nAddedExpected = 4, nRemoved = 1,
nRemovedExpected = 2
-----------------------------------------
com/sun/jini/test/impl/servicediscovery/event/ReRegisterGoodEquals.td
Test Passed: OK
-----------------------------------------
# of tests started = 2
# of tests completed = 2
# of tests passed = 1
# of tests failed = 1
-----------------------------------------
Date finished:
Fri May 23 14:16:12 EST 2014
Time elapsed:
600 seconds
Java Result: 1
qa.collect-result:
C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\build.xml:2121:
The following error occurred while executing this line:
C:\Users\peter\Documents\NetBeansProjects\peterConcurrentPolicy\qa\build.xml:357:
condition satisfied
BUILD FAILED (total time: 10 minutes 7 seconds)