TEST_BUG: java/rmi/activation tests fails intermittently with Exception in starting ActivationGroupInit: java.rmi.activation.UnknownGroupException: group unknown

XMLWordPrintable

      ----------System.err:(75/10725)----------
      RMID: Starting rmid on port 0, at 18:27:05.075294
      JAVAVM: command = [/scratch/mesos/work_dir/slaves/65d84356-2956-4e8c-9739-ffd1fba28a28-S4/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/45f233c3-eea6-4a6c-a8c5-30d6aaf9237c/runs/b61c254d-f85c-4bde-a536-284c7c80a1f9/product/bin/java, -ea, -esa, -Djava.security.policy=/scratch/mesos/work_dir/slaves/65d84356-2956-4e8c-9739-ffd1fba28a28-S4/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/45f233c3-eea6-4a6c-a8c5-30d6aaf9237c/runs/b61c254d-f85c-4bde-a536-284c7c80a1f9/srcBundle/jdk/test/java/rmi/activation/ActivationSystem/unregisterGroup/rmid.security.policy, -Dsun.rmi.server.activation.debugExec=true, -Dtest.src=/scratch/mesos/work_dir/slaves/65d84356-2956-4e8c-9739-ffd1fba28a28-S4/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/45f233c3-eea6-4a6c-a8c5-30d6aaf9237c/runs/b61c254d-f85c-4bde-a536-284c7c80a1f9/srcBundle/jdk/test/java/rmi/activation/ActivationSystem/unregisterGroup, -Dtest.classes=/scratch/mesos/work_dir/slaves/65d84356-2956-4e8c-9739-ffd1fba28a28-S4/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/45f233c3-eea6-4a6c-a8c5-30d6aaf9237c/runs/b61c254d-f85c-4bde-a536-284c7c80a1f9/testoutput/jtreg/JTwork/classes/1/java/rmi/activation/ActivationSystem/unregisterGroup, -Djava.rmi.server.logLevel=v, -Dsun.rmi.activation.execTimeout=60000, -Dsun.rmi.transport.tcp.handshakeTimeout=5000, -classpath, /scratch/mesos/work_dir/slaves/65d84356-2956-4e8c-9739-ffd1fba28a28-S4/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/45f233c3-eea6-4a6c-a8c5-30d6aaf9237c/runs/b61c254d-f85c-4bde-a536-284c7c80a1f9/testoutput/jtreg/JTwork/classes/1/java/rmi/activation/ActivationSystem/unregisterGroup:/scratch/mesos/work_dir/slaves/65d84356-2956-4e8c-9739-ffd1fba28a28-S4/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/45f233c3-eea6-4a6c-a8c5-30d6aaf9237c/runs/b61c254d-f85c-4bde-a536-284c7c80a1f9/testoutput/jtreg/JTwork/classes/1/java/rmi/testlibrary, --add-exports=java.base/sun.nio.ch=ALL-UNNAMED, -Djava.nio.channels.spi.SelectorProvider=RMIDSelectorProvider, -Dtest.java.rmi.testlibrary.RMIDSelectorProvider.port=0, -Dtest.java.rmi.testlibrary.RMIDSelectorProvider.timeout=0, -Dsun.rmi.server.activation.disableErrRedirect=true, sun.rmi.server.Activation, -log, /scratch/mesos/work_dir/slaves/65d84356-2956-4e8c-9739-ffd1fba28a28-S4/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/45f233c3-eea6-4a6c-a8c5-30d6aaf9237c/runs/b61c254d-f85c-4bde-a536-284c7c80a1f9/testoutput/jtreg/JTwork/scratch/3/./log, -C-Dtest.src=/scratch/mesos/work_dir/slaves/65d84356-2956-4e8c-9739-ffd1fba28a28-S4/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/45f233c3-eea6-4a6c-a8c5-30d6aaf9237c/runs/b61c254d-f85c-4bde-a536-284c7c80a1f9/srcBundle/jdk/test/java/rmi/activation/ActivationSystem/unregisterGroup, -C-Dtest.classes=/scratch/mesos/work_dir/slaves/65d84356-2956-4e8c-9739-ffd1fba28a28-S4/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/45f233c3-eea6-4a6c-a8c5-30d6aaf9237c/runs/b61c254d-f85c-4bde-a536-284c7c80a1f9/testoutput/jtreg/JTwork/classes/1/java/rmi/activation/ActivationSystem/unregisterGroup, -C-ea, -C-esa, -C-Djava.rmi.server.useCodebaseOnly=false]
      RMID: Started rmid on port 50381, at 18:27:05.295832
      Mon Dec 19 18:27:05 PST 2016
      rmid startup with inherited channel: sun.nio.ch.ServerSocketChannelImpl[localhost/127.0.0.1:50381]
      RMID: looking up activation system, at 18:27:05.396689
      RMID: Started successfully after 301ms, at 18:27:05.597267
      Creating group descriptor
      Creating descriptor: 0
      Registering descriptor: 0
      Activating object: 0
      rmid: debugExec: running "/scratch/mesos/work_dir/slaves/65d84356-2956-4e8c-9739-ffd1fba28a28-S4/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/45f233c3-eea6-4a6c-a8c5-30d6aaf9237c/runs/b61c254d-f85c-4bde-a536-284c7c80a1f9/product/bin/java -Djava.security.manager=default -Djava.security.policy=/scratch/mesos/work_dir/slaves/65d84356-2956-4e8c-9739-ffd1fba28a28-S4/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/45f233c3-eea6-4a6c-a8c5-30d6aaf9237c/runs/b61c254d-f85c-4bde-a536-284c7c80a1f9/srcBundle/jdk/test/java/rmi/activation/ActivationSystem/unregisterGroup/group.security.policy -Dtest.src=/scratch/mesos/work_dir/slaves/65d84356-2956-4e8c-9739-ffd1fba28a28-S4/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/45f233c3-eea6-4a6c-a8c5-30d6aaf9237c/runs/b61c254d-f85c-4bde-a536-284c7c80a1f9/srcBundle/jdk/test/java/rmi/activation/ActivationSystem/unregisterGroup -Dtest.classes=/scratch/mesos/work_dir/slaves/65d84356-2956-4e8c-9739-ffd1fba28a28-S4/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/45f233c3-eea6-4a6c-a8c5-30d6aaf9237c/runs/b61c254d-f85c-4bde-a536-284c7c80a1f9/testoutput/jtreg/JTwork/classes/1/java/rmi/activation/ActivationSystem/unregisterGroup -ea -esa -Djava.rmi.server.useCodebaseOnly=false sun.rmi.server.ActivationGroupInit"
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err:Exception in starting ActivationGroupInit:
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err:java.rmi.activation.UnknownGroupException: group unknown
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.rmi/sun.rmi.server.Activation.getGroupEntry(Activation.java:775)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.rmi/sun.rmi.server.Activation.getGroupEntry(Activation.java:785)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.rmi/sun.rmi.server.Activation.access$200(Activation.java:135)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.rmi/sun.rmi.server.Activation$ActivationSystemImpl.activeGroup(Activation.java:556)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.base/java.lang.reflect.Method.invoke(Method.java:538)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.rmi/sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:344)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.rmi/sun.rmi.transport.Transport$1.run(Transport.java:200)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.rmi/sun.rmi.transport.Transport$1.run(Transport.java:197)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.base/java.security.AccessController.doPrivileged(Native Method)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.rmi/sun.rmi.transport.Transport.serviceCall(Transport.java:196)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.rmi/sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:567)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.rmi/sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:800)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.rmi/sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.lambda$run$0(TCPTransport.java:682)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.base/java.security.AccessController.doPrivileged(Native Method)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.rmi/sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:681)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1161)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.base/java.lang.Thread.run(Thread.java:844)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.rmi/sun.rmi.transport.StreamRemoteCall.exceptionReceivedFromServer(StreamRemoteCall.java:276)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.rmi/sun.rmi.transport.StreamRemoteCall.executeCall(StreamRemoteCall.java:253)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.rmi/sun.rmi.server.UnicastRef.invoke(UnicastRef.java:162)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.rmi/sun.rmi.server.Activation$ActivationSystemImpl_Stub.activeGroup(Unknown Source)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.rmi/java.rmi.activation.ActivationGroup.createGroup(ActivationGroup.java:330)
      Mon Dec 19 18:27:06 PST 2016:ExecGroup-0:err: at java.rmi/sun.rmi.server.ActivationGroupInit.main(ActivationGroupInit.java:71)
      TEST FAILED: test failed: not completed before timeout
      TEST FAILED:
      Test failed with: TEST FAILED: test failed: not completed before timeout
      TestFailedException: TEST FAILED: test failed: not completed before timeout
      at TestLibrary.bomb(TestLibrary.java:121)
      at UnregisterGroup.main(UnregisterGroup.java:157)
      at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
      at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
      at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
      at java.base/java.lang.reflect.Method.invoke(Method.java:538)
      at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:110)
      at java.base/java.lang.Thread.run(Thread.java:844)
      RMID: shutdown()
      RMID: ActivationSystem.shutdown()
      activation daemon shut down
      RMID: Shutdown successful after 807ms.
      RMID: Removing rmid's old log file.
      TestFailedException: TEST FAILED: ; nested exception is:
      TestFailedException: TEST FAILED: test failed: not completed before timeout
      TestFailedException: TEST FAILED: test failed: not completed before timeout
      at TestLibrary.bomb(TestLibrary.java:121)
      at UnregisterGroup.main(UnregisterGroup.java:157)
      at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
      at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
      at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
      at java.base/java.lang.reflect.Method.invoke(Method.java:538)
      at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:110)
      at java.base/java.lang.Thread.run(Thread.java:844)

      JavaTest Message: Test threw exception: TestFailedException: TEST FAILED: ; nested exception is:
      TestFailedException: TEST FAILED: test failed: not completed before timeout
      JavaTest Message: shutting down test

      STATUS:Failed.`main' threw exception: TestFailedException: TEST FAILED: ; nested exception is: TestFailedException: TEST FAILED: test failed: not completed before timeout

            Assignee:
            Mark Sheppard
            Reporter:
            Hamlin Li
            Votes:
            0 Vote for this issue
            Watchers:
            5 Start watching this issue

              Created:
              Updated: