Uploaded image for project: 'JDK'
  1. JDK
  2. JDK-8051694

TEST_BUG: java/rmi/activation/Activatable/checkAnnotations/CheckAnnotations.java fails with "timeout creating child process"

XMLWordPrintable

      TESTFAIL:java/rmi/activation/Activatable/checkAnnotations/CheckAnnotations.java

      The test java/rmi/activation/Activatable/checkAnnotations/CheckAnnotations.jtr fails in nightly intermittently. see log:
      #section:main
      ----------messages:(3/166)----------
      command: main CheckAnnotations
      reason: User specified action: run main/othervm/policy=security.policy/timeout=480 CheckAnnotations
      elapsed time (seconds): 37.488
      ----------System.out:(2/14)----------
      out-1
      out-1
      ----------System.err:(117/8569)*----------

      Regression test for bug/rfe 4109103

      RMID: starting rmid on port #60936...
      JAVAVM: command = [C:\\users\\aurora\\CommonData\\jdk\\jre\\bin\\java, -ea, -esa, -Xmx512m, -Djava.security.policy=C:\\Users\\aurora\\sandbox\\testbase\\test\\java\\rmi\\activation\\Activatable\\checkAnnotations\\rmid.security.policy, -Dsun.rmi.server.activation.debugExec=false, -Dtest.src=C:\\Users\\aurora\\sandbox\\testbase\\test\\java\\rmi\\activation\\Activatable\\checkAnnotations, -Dtest.classes=C:\\Users\\aurora\\sandbox\\gresults\\testoutput\\jdk_rmi\\JTwork\\classes\\java\\rmi\\activation\\Activatable\\checkAnnotations, -Djava.rmi.server.logLevel=v, -Dsun.rmi.activation.execTimeout=60000, sun.rmi.server.Activation, -log, C:\\Users\\aurora\\sandbox\\gresults\\testoutput\\jdk_rmi\\JTwork\\scratch\\.\\log, -port, 60936, -C-Dtest.src=C:\\Users\\aurora\\sandbox\\testbase\\test\\java\\rmi\\activation\\Activatable\\checkAnnotations, -C-Dtest.classes=C:\\Users\\aurora\\sandbox\\gresults\\testoutput\\jdk_rmi\\JTwork\\classes\\java\\rmi\\activation\\Activatable\\checkAnnotations, -C-ea, -C-esa, -C-Xmx512m, -C-Djava.rmi.server.useCodebaseOnly=false]
      RMID: finished starting rmid.
      Create activation group in this VM
      err-1
      err-1
      rmid output not yet received, retrying...
      rmid output not yet received, retrying...
      rmid output not yet received, retrying...
      rmid output not yet received, retrying...
      rmid output not yet received, retrying...
      Deactivate object via method call
      ACTIVATION_LIBRARY: inactive successful
      TEST FAILED:
      Test failed with: activation failed; nested exception is:
      java.rmi.activation.ActivationException: timeout creating child process
      java.rmi.activation.ActivateFailedException: activation failed; nested exception is:
      java.rmi.activation.ActivationException: timeout creating child process
      at sun.rmi.server.ActivatableRef.activate(ActivatableRef.java:304)
      at sun.rmi.server.ActivatableRef.invoke(ActivatableRef.java:210)
      at CheckAnnotations_Stub.printOut(CheckAnnotations_Stub.java:107)
      at CheckAnnotations.checkAnnotations(CheckAnnotations.java:155)
      at CheckAnnotations.main(CheckAnnotations.java:109)
      at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
      at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
      at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
      at java.lang.reflect.Method.invoke(Method.java:484)
      at com.sun.javatest.regtest.MainWrapper$MainThread.run(MainWrapper.java:94)
      at java.lang.Thread.run(Thread.java:745)
      Caused by: java.rmi.activation.ActivationException: timeout creating child process
      at sun.rmi.server.Activation$GroupEntry.getInstantiator(Activation.java:1298)
      at sun.rmi.server.Activation$GroupEntry.activate(Activation.java:1163)
      at sun.rmi.server.Activation$ActivatorImpl.activate(Activation.java:436)
      at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
      at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
      at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
      at java.lang.reflect.Method.invoke(Method.java:484)
      at sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:321)
      at sun.rmi.transport.Transport$1.run(Transport.java:179)
      at sun.rmi.transport.Transport$1.run(Transport.java:176)
      at java.security.AccessController.doPrivileged(Native Method)
      at sun.rmi.transport.Transport.serviceCall(Transport.java:175)
      at sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:553)
      at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:808)
      at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:667)
      at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
      at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
      at java.lang.Thread.run(Thread.java:745)
      at sun.rmi.transport.StreamRemoteCall.exceptionReceivedFromServer(StreamRemoteCall.java:276)
      at sun.rmi.transport.StreamRemoteCall.executeCall(StreamRemoteCall.java:253)
      at sun.rmi.server.UnicastRef.invoke(UnicastRef.java:162)
      at java.rmi.server.RemoteObjectInvocationHandler.invokeRemoteMethod(RemoteObjectInvocationHandler.java:194)
      at java.rmi.server.RemoteObjectInvocationHandler.invoke(RemoteObjectInvocationHandler.java:148)
      at com.sun.proxy.$Proxy1.activate(Unknown Source)
      at java.rmi.activation.ActivationID.activate(ActivationID.java:118)
      at sun.rmi.server.ActivatableRef.activate(ActivatableRef.java:277)
      ... 10 more
      rmid shut down
      RMID: testlibrary finished shutting down rmid
      RMID: RMID's process still not terminated after more than 200 milliseconds
      RMID: rmid exited on shutdown request
      ACTIVATION_LIBRARY: finished destroying rmid
      RMID: removing rmid's old log file...
      TestFailedException: TEST FAILED: ; nested exception is:
      java.rmi.activation.ActivateFailedException: activation failed; nested exception is:
      java.rmi.activation.ActivationException: timeout creating child process
      java.rmi.activation.ActivateFailedException: activation failed; nested exception is:
      java.rmi.activation.ActivationException: timeout creating child process
      at sun.rmi.server.ActivatableRef.activate(ActivatableRef.java:304)
      at sun.rmi.server.ActivatableRef.invoke(ActivatableRef.java:210)
      at CheckAnnotations_Stub.printOut(CheckAnnotations_Stub.java:107)
      at CheckAnnotations.checkAnnotations(CheckAnnotations.java:155)
      at CheckAnnotations.main(CheckAnnotations.java:109)
      at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
      at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
      at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
      at java.lang.reflect.Method.invoke(Method.java:484)
      at com.sun.javatest.regtest.MainWrapper$MainThread.run(MainWrapper.java:94)
      at java.lang.Thread.run(Thread.java:745)
      Caused by: java.rmi.activation.ActivationException: timeout creating child process
      at sun.rmi.server.Activation$GroupEntry.getInstantiator(Activation.java:1298)
      at sun.rmi.server.Activation$GroupEntry.activate(Activation.java:1163)
      at sun.rmi.server.Activation$ActivatorImpl.activate(Activation.java:436)
      at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
      at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
      at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
      at java.lang.reflect.Method.invoke(Method.java:484)
      at sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:321)
      at sun.rmi.transport.Transport$1.run(Transport.java:179)
      at sun.rmi.transport.Transport$1.run(Transport.java:176)
      at java.security.AccessController.doPrivileged(Native Method)
      at sun.rmi.transport.Transport.serviceCall(Transport.java:175)
      at sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:553)
      at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:808)
      at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:667)
      at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
      at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
      at java.lang.Thread.run(Thread.java:745)
      at sun.rmi.transport.StreamRemoteCall.exceptionReceivedFromServer(StreamRemoteCall.java:276)
      at sun.rmi.transport.StreamRemoteCall.executeCall(StreamRemoteCall.java:253)
      at sun.rmi.server.UnicastRef.invoke(UnicastRef.java:162)
      at java.rmi.server.RemoteObjectInvocationHandler.invokeRemoteMethod(RemoteObjectInvocationHandler.java:194)
      at java.rmi.server.RemoteObjectInvocationHandler.invoke(RemoteObjectInvocationHandler.java:148)
      at com.sun.proxy.$Proxy1.activate(Unknown Source)
      at java.rmi.activation.ActivationID.activate(ActivationID.java:118)
      at sun.rmi.server.ActivatableRef.activate(ActivatableRef.java:277)
      ... 10 more

      JavaTest Message: Test threw exception: TestFailedException: TEST FAILED: ; nested exception is:
      java.rmi.activation.ActivateFailedException: activation failed; nested exception is:
      java.rmi.activation.ActivationException: timeout creating child process
      JavaTest Message: shutting down test

      STATUS:Failed.`main' threw exception: TestFailedException: TEST FAILED: ; nested exception is: java.rmi.activation.ActivateFailedException: activation failed; nested exception is: java.rmi.activation.ActivationException: timeout creating child process
      ----------rerun:(24/2802)*----------
      'PATH=C:\\cygwin64\\usr\\local\\bin;C:\\cygwin64\\bin;C:\\Program Files\\Oracle\\VirtualBox;C:\\Windows\\system32;C:\\Windows;C:\\Windows\\System32\\Wbem;C:\\Windows\\System32\\WindowsPowerShell\\v1.0;C:\\Program Files\\TortoiseHg' \\
      SystemDrive=C: \\
      'SystemRoot=C:\\Windows' \\
      'TEMP=C:\\Users\\aurora\\AppData\\Local\\Temp' \\
      'TMP=C:\\Users\\aurora\\AppData\\Local\\Temp' \\
      'windir=C:\\Windows' \\
      'CLASSPATH=C:\\Users\\aurora\\CommonData\\jtreg\\lib\\javatest.jar;C:\\Users\\aurora\\CommonData\\jtreg\\lib\\jtreg.jar;C:\\Users\\aurora\\sandbox\\gresults\\testoutput\\jdk_rmi\\JTwork\\classes\\java\\rmi\\activation\\Activatable\\checkAnnotations;C:\\Users\\aurora\\sandbox\\testbase\\test\\java\\rmi\\activation\\Activatable\\checkAnnotations;C:\\Users\\aurora\\sandbox\\gresults\\testoutput\\jdk_rmi\\JTwork\\classes\\java\\rmi\\testlibrary;C:\\users\\aurora\\CommonData\\jdk\\lib\\tools.jar' \\
          'C:\\users\\aurora\\CommonData\\jdk\\bin\\java' \\
              -Dtest.vm.opts='-ea -esa -Xmx512m' \\
              -Dcompile.jdk='C:\\users\\aurora\\CommonData\\jdk' \\
              -Dtest.src.path='C:\\Users\\aurora\\sandbox\\testbase\\test\\java\\rmi\\activation\\Activatable\\checkAnnotations;C:\\Users\\aurora\\sandbox\\testbase\\test\\java\\rmi\\testlibrary' \\
              -Dtest.src='C:\\Users\\aurora\\sandbox\\testbase\\test\\java\\rmi\\activation\\Activatable\\checkAnnotations' \\
              -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m' \\
              -Dtest.class.path='C:\\Users\\aurora\\sandbox\\gresults\\testoutput\\jdk_rmi\\JTwork\\classes\\java\\rmi\\activation\\Activatable\\checkAnnotations;C:\\Users\\aurora\\sandbox\\gresults\\testoutput\\jdk_rmi\\JTwork\\classes\\java\\rmi\\testlibrary' \\
              -Dtest.timeout.factor=4.0 \\
              -Dtest.classes='C:\\Users\\aurora\\sandbox\\gresults\\testoutput\\jdk_rmi\\JTwork\\classes\\java\\rmi\\activation\\Activatable\\checkAnnotations' \\
              -Dtest.class.path.prefix='C:\\Users\\aurora\\sandbox\\gresults\\testoutput\\jdk_rmi\\JTwork\\classes\\java\\rmi\\activation\\Activatable\\checkAnnotations;C:\\Users\\aurora\\sandbox\\testbase\\test\\java\\rmi\\activation\\Activatable\\checkAnnotations;C:\\Users\\aurora\\sandbox\\gresults\\testoutput\\jdk_rmi\\JTwork\\classes\\java\\rmi\\testlibrary' \\
              -Dtest.jdk='C:\\users\\aurora\\CommonData\\jdk' \\
              -Dtest.java.opts= \\
              -Dtest.compiler.opts= \\
              -Djava.security.policy='=C:\\Users\\aurora\\sandbox\\gresults\\testoutput\\jdk_rmi\\JTwork\\scratch\\security.policy_new' \\
              -Djava.security.manager=default \\
              -ea -esa -Xmx512m \\
              com.sun.javatest.regtest.MainWrapper 'C:\\Users\\aurora\\sandbox\\gresults\\testoutput\\jdk_rmi\\JTwork\\classes\\java\\rmi\\activation\\Activatable\\checkAnnotations\\CheckAnnotations.jta'
      result: Failed. Execution failed: `main' threw exception: TestFailedException: TEST FAILED: ; nested exception is: java.rmi.activation.ActivateFailedException: activation failed; nested exception is: java.rmi.activation.ActivationException: timeout creating child process


      test result: Failed. Execution failed: `main' threw exception: TestFailedException: TEST FAILED: ; nested exception is: java.rmi.activation.ActivateFailedException: activation failed; nested exception is: java.rmi.activation.ActivationException: timeout creating child process

            Unassigned Unassigned
            ewang Eric Wang (Inactive)
            Votes:
            0 Vote for this issue
            Watchers:
            6 Start watching this issue

              Created:
              Updated:
              Resolved: