After fixing the URLPermission issue, I found that there was a ClassLoader class resolution issue with group-dl.jar, this was due to dependency resolution that previously found classes via dependency analysis of the stub class affecting the result from preferred class build tool. -Fixed build script parameters.
The next problem experienced was a deadlock preventing phoenix from shutting down, due to a lock being held while calling Runtime.removeShutdownHook. Moved call outside of lock. Many Activation tests passing now. Still some test failures in activation, will investigate later. When complete, I'll create a new issue & upload a patch to jira for jdk9 support. Including deprecation of exporters that access the jdk implementation namespace. The missing CORBA classes are the only major issue with JDK9 at this time. Regards, Peter. Sent from my Samsung device. Include original message ---- Original message ---- From: Peter <j...@zeus.net.au> Sent: 18/08/2016 10:10:58 pm To: dev@river.apache.org <dev@river.apache.org> Subject: Re: jdk9 - Connection refused to RMI Registry Nope, turns out I was using the wrong port, 1099 instead of 1098. This occurred as I had refactored Phoenix to use the rmi registry implementation, instead of its internal implementation with SunRegistryExporter and selected the default Registry port instead of the default ActivationSystem port Fixed that. The next problem is jar files that cannot be downloaded as they lack URLPermission. Fixed that by assigning URLPermission in PreferredClassLoader. Now it can't find a class, but that's probably related to dependency resolution in the build process after stub removal Added org.apache.river.phoenix.ActivationAdmin to phoenix-dl.jar Now URLPermission throwing an exception because it doesn't like Windows file urls. Fixing that now... Sent from my Samsung device. Include original message ---- Original message ---- From: Peter <j...@zeus.net.au> Sent: 18/08/2016 12:19:38 pm To: dev@river.apache.org <dev@river.apache.org> Subject: jdk9 - Connection refused to RMI Registry This bug may be related to JDK-816822 Will try running again later in security debug mode. Include original message [java] ----------------------------------------- [java] GENERAL HARNESS CONFIGURATION INFORMATION: [java] [java] Date started: [java] Thu Aug 18 07:16:52 AEST 2016 [java] Installation directory of the JSK: [java] org.apache.river.jsk.home=C:\Users\User\Documents\NetBeansProjects\River\trunk [java] Installation directory of the harness: [java] org.apache.river.qa.home=C:\Users\User\Documents\NetBeansProjects\River\trunk\qa [java] Categories being tested: [java] categories=start start_impl [java] ----------------------------------------- [java] ENVIRONMENT PROPERTIES: [java] [java] JVM information: [java] Java HotSpot(TM) 64-Bit Server VM, 9-ea+131, 64 bit VM mode [java] Oracle Corporation [java] OS information: [java] Windows 10, 10.0, amd64 [java] [java] ----------------------------------------- [java] STARTING TO RUN THE TESTS [java] [java] [java] Running org/apache/river/test/impl/start/ActivateWrapperActivateDescTest.td [java] Time is Thu Aug 18 07:16:53 AEST 2016 [java] Starting test in separate process with command: [java] 'C:\Program Files\Java\jdk-9\bin\java' -Djava.security.manager=org.apache.river.api.security.CombinerSecurityManager -Djava.security.policy=file:/C:/Users/User/Documents/NetBeansProjects/River/trunk/qa/harness/policy/defaulttest.policy -Djava.rmi.servercodebase=http://User-VAIO:9082/qa1-start-probe-dl.jar -cp C:\Users\User\Documents\NetBeansProjects\River\trunk\qa\lib\jiniharness.jar;C:\Users\User\Documents\NetBeansProjects\River\trunk\qa\lib\jinitests.jar;\mergedpolicyprovider.jar;\jsk-policy.jar;C:\Users\User\Documents\NetBeansProjects\River\trunk\lib\jsk-platform.jar;C:\Users\User\Documents\NetBeansProjects\River\trunk\lib\jsk-lib.jar;C:\Users\User\Documents\NetBeansProjects\River\trunk\lib\high-scale-lib.jar;C:\Users\User\Documents\NetBeansProjects\River\trunk\lib\custard-apple-1.0.3.jar -ea -esa -Dorg.apache.river.jskport=9080 -Dorg.apache.river.qa.port=9081 -Dorgapache.river.jsk.home=C:\Users\User\Documents\NetBeansProjects\River\trunk -Dorg.apache.river.qa.home=C:\Users\User\Documents\NetBeansProjects\River\trunk\qa -Dorg.apache.river.qa.harness.harnessJar=C:\Users\User\Documents\NetBeansProjects\River\trunk\qa\lib\jiniharness.jar -Dorg.apache.river.qa.harness.testJar=C:\Users\User\Documents\NetBeansProjects\River\trunk\qa\lib\jinitests.jar -Dorg..apache.river.qa.harness.runjiniserver=true -Dorg.apache.river.qa.harness.runkitserver=true -Djava.security.properties=file:/C:/Users/User/Documents/NetBeansProjects/River/trunk/qa/harness/trust/dynamic-policy.properties -Dorg.apache.river.qa.harness.testhosts= -Djava.util.logging.config.file=C:\Users\User\Documents\NetBeansProjects\River\trunk\qa\src\org\apache\river\test\resources\qa1.logging -Djava.rmi.server.useCodebaseOnly=false -Dnet.jini.core.lookup.ServiceRegistrar.portAbitraryIfInUse=true -Dorg.apache.river.test.home=C:\Users\User\Documents\NetBeansProjects\River\trunk\qa -Dorg.apache.river.test.port=9082 -Dorg.apache.river.qa.harness.policies=file:/C:/Users/User/Documents/NetBeansProjects/River/trunk/qa/src/org/apache/river/test/resources/jinitest.policy org.apache.river.qa.harness.MasterTest org/apache/river/test/impl/start/ActivateWrapperActivateDescTest.td [java] [java] TIME: 7:16:55 AM [java] [java] MasterTest.doTest INFO: [java] ============================== CALLING CONSTRUCT() ============================== [java] [java] [java] TIME: 7:18:59 AM [java] [java] QAConfig.activationUp SEVERE: Act System wouldn't start [java] java.rmi.activation.ActivationException: unable to obtain ActivationSystem; nested exception is: [java] java.rmi.ConnectException: Connection refused to host: 192.168.43146; nested exception is: [java] java.net.ConnectException: Connection refused: connect [java] at java.rmi.activation.ActivationGroup.getSystem(java.rmi@9-ea/ActivationGroup.java:455) [java] at org.apache.riverqa.harness.QAConfig.activationUp(QAConfig.java:1531) [java] at org.apache.river.qa.harness.ActivationSystemAdmin.start(ActivationSystemAdmin.java:271) [java] at org.apache.river.qa.harness.AdminManager.startService(AdminManager.java:639) [java] at org.apache.river.qaharness.AdminManager.startService(AdminManager.java:660) [java] at org.apache.river.qa.harness.SharedGroupAdmin.start(SharedGroupAdmin.java:173) [java] at org.apache.river.qa.harness.AdminManager.startService(AdminManager.java:639) [java] at org.apache.river.qaharness.AdminManager.startService(AdminManager.java:660) [java] at org.apache.river.test.impl.start.AbstractStartBaseTest.construct(AbstractStartBaseTest.java:65) [java] at org.apache.river.qa.harness.MasterTest.doTest(MasterTest.java:220) [java] at org.apacheriver.qa.harness.MasterTest.main(MasterTestjava:144) [java] Caused by: java.rmi.ConnectException: Connection refused to host: 192..168.43.146; nested exception is: [java] java.net.ConnectException: Connection refused: connect [java] at sun.rmi.transport.tcp.TCPEndpoint.newSocket(java.rmi@9-ea/TCPEndpoint.java:619) [java] at sun.rmi.transport.tcp.TCPChannel.createConnection(java.rmi@9-ea/TCPChannel.java:214) [java] at sun.rmi.transport.tcp.TCPChannel.newConnection(java.rmi@9-ea/TCPChannel.java:200) [java] at sun.rmi.server.UnicastRef.newCall(java.rmi@9-ea/UnicastRef.java:342) [java] at sun.rmi.registry.RegistryImpl_Stub.lookup(javarmi@9-ea/Unknown Source) [java] at java.rmi.Naming.lookup(java.rmi@9-ea/Naming.java:101) [java] at java.rmi.activation.ActivationGroup.getSystem(java.rmi@9-ea/ActivationGroup.java:452) [java] ... 10 more [java] Caused by: java.net.ConnectException: Connection refused: connect [java] at java.net.DualStackPlainSocketImpl.connect0(java.base@9-ea/Native Method) [java] at java.net.DualStackPlainSocketImpl.socketConnect(java.base@9-ea/DualStackPlainSocketImpl.java:79) [java] at java.net.AbstractPlainSocketImpl.doConnect(java.base@9-ea/AbstractPlainSocketImpl.java:400) [java] at java.net.AbstractPlainSocketImpl.connectToAddress(java.base@9-ea/AbstractPlainSocketImpl.java:243) [java] at java.net.AbstractPlainSocketImpl.connect(java.base@9-ea/AbstractPlainSocketImpl.java:225) [java] at java.net.PlainSocketImpl.connect(javabase@9-ea/PlainSocketImpl.java:148) [java] at java.net.SocksSocketImpl.connect(java.base@9-ea/SocksSocketImpl.java:402) [java] at javanet.Socket.connect(java.base@9-ea/Socket.java:591) [java] at java.net.Socket.connect(java.base@9-ea/Socket.java:540) [java] at java.net.Socket.<init>(java.base@9-ea/Socket.java:436) [java] at java.net.Socket.<init>(java.base@9-ea/Socket.java:213) [java] at sun.rmi.transport.tcp.TCPDirectSocketFactory.createSocket(java.rmi@9-ea/TCPDirectSocketFactoryjava:40) [java] at sun.rmi.transport.tcp.TCPEndpoint.newSocket(java.rmi@9-ea/TCPEndpoint.java:613) [java] ... 16 more [java] org.apache.river.qa.harness.TestException: ActivationSystemAdmin: activation system did not start [java] at org.apacheriver.qaharness.ActivationSystemAdmin.start(ActivationSystemAdmin.java:272) [java] at org.apache.river.qa.harness.AdminManager.startService(AdminManager.java:639) [java] at org.apache.river.qa.harness.AdminManager.startService(AdminManager.java:660) [java] at org.apache.river.qa.harness.SharedGroupAdmin.start(SharedGroupAdmin.java:173) [java] at org.apache.river.qa.harness.AdminManager.startService(AdminManager.java:639) [java] at org.apache.river.qa.harness.AdminManager.startService(AdminManager.java:660) [java] at org.apache.river.test.impl.start.AbstractStartBaseTest.construct(AbstractStartBaseTest.java:65) [java] at org.apache.river.qa.harness.MasterTest.doTest(MasterTest.java:220) [java] at org.apache.river.qa.harness.MasterTest.main(MasterTest.java:144) [java] MasterTest.doTest INFO: [java] ============================ CALLING TEARDOWN() ============================= [java] [java] [java] TIME: 7:19:00 AM [java] [java] Test process was destroyed and returned code 1 [java] org/apache/river/test/impl/start/ActivateWrapperActivateDescTest.td [java] Test Failed: Construct Failed: org.apache.river.qa.harness.TestException: ActivationSystemAdmin: activation system did not start [java] [java] [java] ----------------------------------------- C:\Users\User>ping 192.168.43.146 Pinging 192.168.43.146 with 32 bytes of data: Reply from 192.16843.146: bytes=32 time<1ms TTL=128 Reply from 192.168.43.146: bytes=32 time<1ms TTL=128 Reply from 192.168.43.146: bytes=32 time<1ms TTL=128 Reply from 192168.43.146: bytes=32 time<1ms TTL=128 Image PID Address Port Protocol Firewall Status java.exe 5588 IPv6 unspecified 1198 TCP Allowed, not restricted java.exe 5588 IPv6 unspecified 1099 TCP Allowed, not restricted javaexe 5588 IPv4 unspecified 1198 TCP Allowed, not restricted java.exe 5588 IPv4 unspecified 1099 TCP Allowed, not restricted C:\Users\User>jstack 5588 2016-08-18 11:50:35 Full thread dump Java HotSpot(TM) 64-Bit Server VM (9-ea+131 mixed mode): "RMI TCP Accept-1099" #21 daemon prio=5 os_prio=0 tid=0x000001cd345b1800 nid=0x16a0 runnable [0x000000822fcff000] java.lang.Thread.State: RUNNABLE at java.net.DualStackPlainSocketImpl.accept0(java.base@9-ea/Native Method) at java.net.DualStackPlainSocketImpl.socketAccept(java.base@9-ea/DualStackPlainSocketImpl.java:131) at java.net.AbstractPlainSocketImpl.accept(java.base@9-ea/AbstractPlainSocketImpl.java:459) at java.net.PlainSocketImpl.accept(java.base@9-ea/PlainSocketImpl.java:183) - locked <0x0000000088196cb8> (a java.net.SocksSocketImpl) at java.net.ServerSocket.implAccept(java.base@9-ea/ServerSocket.java:546) at java.net.ServerSocket.accept(java.base@9-ea/ServerSocket.java:514) at sun.rmi.transport.tcp.TCPTransport$AcceptLoop.executeAcceptLoop(java.rmi@9-ea/TCPTransport.java:394) at sun.rmi.transport.tcp.TCPTransport$AcceptLoop.run(java.rmi@9-ea/TCPTransport.java:366) at java.lang.Threadrun(java.base@9-ea/Thread.java:843) "(JSK) KeepAlive" #20 prio=5 os_prio=0 tid=0x000001cd34556000 nid=0x13ac waiting on condition [0x000000822fbfe000] java.lang.Thread.State: TIMED_WAITING (sleeping) at java.lang.Thread.sleep(java.base@9-ea/Native Method) at org.apache.river.jeri.internal.runtime.JvmLifeSupport$2.run(JvmLifeSupport.java:133) at java.lang.Thread.run(java.base@9-ea/Thread.java:843) "(JSK) Reaper" #19 daemon prio=5 os_prio=0 tid=0x000001cd34555000 nid=0x610 in Object.wait() [0x000000822faff000] java.langThread.State: WAITING (on object monitor) at java.lang.Object.wait(java.base@9-ea/Native Method) - waiting on <0x0000000088451d10> (a java.lang.ref.ReferenceQueue$Lock) at java.lang.ref.ReferenceQueue.remove(java.base@9-ea/ReferenceQueue.java:151) - waiting to re-lock in wait() <0x0000000088451d10> (a java.langref.ReferenceQueue$Lock) at java.lang.ref.ReferenceQueue.remove(java.base@9-ea/ReferenceQueue.java:172) at org.apache.river.jeri.internal.runtime.ImplRefManager$Reaperrun(ImplRefManager.java:426) at java.lang.Thread.run(java.base@9-ea/Thread.java:843) "(JSK) TcpServerEndpoint.LH[ServerSocket[addr=localhost/1270.0.1,localport=1198]] accept loop" #18 prio=5 os_prio=0 tid=0x000001cd3455a800 nid=0x179c runnable [0x000000822f9fe000] java.langThread.State: RUNNABLE at java.net.DualStackPlainSocketImpl.accept0(java.base@9-ea/Native Method) at java.net.DualStackPlainSocketImpl.socketAccept(java.base@9-ea/DualStackPlainSocketImpl.java:131) at java.net.AbstractPlainSocketImpl.accept(java.base@9-ea/AbstractPlainSocketImpl.java:459) at java.net.PlainSocketImpl.accept(java.base@9-ea/PlainSocketImpl.java:183) - locked <0x0000000088354b00> (a java.net.SocksSocketImpl) at java.net.ServerSocket.implAccept(java.base@9-ea/ServerSocket.java:546) at java.net.ServerSocket.accept(java.base@9-ea/ServerSocket.java:514) at net.jini.jeri.tcp.TcpServerEndpoint$LH.executeAcceptLoop(TcpServerEndpoint.java:771) at net.jini.jeri.tcp.TcpServerEndpoint$LH.access$400(TcpServerEndpoint.java:709) at net.jini.jeritcp..TcpServerEndpoint$LH$1.run(TcpServerEndpoint.java:741) at org.apache.river.thread.ThreadPool$Task.run(ThreadPool.java:172) at java.util.concurrent.Executors$RunnableAdapter.call(java.base@9-ea/Executors.java:514) at java.util.concurrent.FutureTask.run(java.base@9-ea/FutureTask.java:264) at javautil.concurrent.ThreadPoolExecutor.runWorker(java.base@9-ea/ThreadPoolExecutor.java:1158) at java.util.concurrent.ThreadPoolExecutor$Worker.run(javabase@9-ea/ThreadPoolExecutor.java:632) at java.lang.Thread.run(java.base@9-ea/Thread.java:843) "Thread-0" #14 prio=10 os_prio=2 tid=0x000001cd3441c000 nid=0x6e8 waiting on condition [0x000000822f7fe000] java.lang.Thread.State: TIMED_WAITING (parking) at jdk.internal.misc.Unsafe.park(javabase@9-ea/Native Method) - parking to wait for <0x0000000088700ae0> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) at java.util.concurrent.locks.LockSupport.parkNanos(java.base@9-ea/LockSupport.java:232) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(java.base@9-ea/AbstractQueuedSynchronizer.java:2104) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(java.base@9-ea/ScheduledThreadPoolExecutor.java:1131) at javautil.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(java.base@9-ea/ScheduledThreadPoolExecutor.java:848) at java.util.concurrent.ThreadPoolExecutor.getTask(java.base@9-ea/ThreadPoolExecutor.java:1083) at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@9-ea/ThreadPoolExecutor.java:1143) at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@9-ea/ThreadPoolExecutor.java:632) at java.lang.Threadrun(java.base@9-ea/Thread.java:843) "Service Thread" #12 daemon prio=9 os_prio=0 tid=0x000001cd342df000 nid=0x1bd4 runnable [0x0000000000000000] java.lang.Thread.State: RUNNABLE "Common-Cleaner" #11 daemon prio=8 os_prio=1 tid=0x000001cd33fb3000 nid=0x1b84 in Object.wait() [0x000000822f4ff000] java.lang.Thread.State: TIMED_WAITING (on object monitor) at javalang.Object.wait(javabase@9-ea/Native Method) - waiting on <no object reference available> at java.lang.ref.ReferenceQueue.remove(java.base@9-ea/ReferenceQueue.java:151) - waiting to re-lock in wait() <0x0000000088b439e8> (a java.lang.ref.ReferenceQueue$Lock) at jdk.internal.ref.CleanerImpl.run(java.base@9-ea/CleanerImpl.java:148) at javalang.Thread.run(java.base@9-ea/Thread.java:843) at jdk.internal.misc.InnocuousThread.run(java.base@9-ea/InnocuousThread.java:122) "Sweeper thread" #10 daemon prio=9 os_prio=2 tid=0x000001cd33f16800 nid=0x12d4 runnable [0x0000000000000000] java.lang.ThreadState: RUNNABLE "C1 CompilerThread2" #9 daemon prio=9 os_prio=2 tid=0x000001cd33f06000 nid=0x18c8 waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE No compile task "C2 CompilerThread1" #8 daemon prio=9 os_prio=2 tid=0x000001cd33f00000 nid=0x137c waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE No compile task "C2 CompilerThread0" #7 daemon prio=9 os_prio=2 tid=0x000001cd33efd000 nid=0xde8 waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE No compile task "Attach Listener" #6 daemon prio=5 os_prio=2 tid=0x000001cd33efa800 nid=0x1870 waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE "Signal Dispatcher" #5 daemon prio=9 os_prio=2 tid=0x000001cd33ee7800 nid=0x1478 runnable [0x0000000000000000] java.lang.ThreadState: RUNNABLE "Reference Pending List Locker" #4 daemon prio=9 os_prio=0 tid=0x000001cd33ee6800 nid=0xd80 waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE "Finalizer" #3 daemon prio=8 os_prio=1 tid=0x000001cd33e90800 nid=0x1eb4 in Object.wait() [0x000000822ecff000] java.lang.Thread.State: WAITING (on object monitor) at javalang.Objectwait(java.base@9-ea/Native Method) - waiting on <0x0000000088b0d4f0> (a java.lang.ref.ReferenceQueue$Lock) at java.lang.ref.ReferenceQueue.remove(java.base@9-ea/ReferenceQueue.java:151) - waiting to re-lock in wait() <0x0000000088b0d4f0> (a java.lang.refReferenceQueue$Lock) at java.lang.ref.ReferenceQueue.remove(java.base@9-ea/ReferenceQueue.java:172) at java.lang.ref.Finalizer$FinalizerThread.run(java.base@9-ea/Finalizer.java:216) "Reference Handler" #2 daemon prio=10 os_prio=2 tid=0x000001cd33e87800 nid=0xd00 in Object.wait() [0x000000822ebff000] java.lang.Thread.State: WAITING (on object monitor) at java.lang.Object.wait(java.base@9-ea/Native Method) - waiting on <0x0000000088b09248> (a java.lang.ref.Reference$Lock) at java.lang.Object.wait(java.base@9-ea/Object.java:516) at java.lang.ref.Reference.tryHandlePending(java.base@9-ea/Referencejava:193) - waiting to re-lock in wait() <0x0000000088b09248> (a java.lang.ref.Reference$Lock) at java.lang.ref.Reference$ReferenceHandler.run(java.base@9-ea/Reference.java:155) "main" #1 prio=5 os_prio=0 tid=0x000001cd11f86800 nid=0x1658 waiting on condition [0x000000822deff000] java.lang.Thread.State: TIMED_WAITING (sleeping) at javalang.Thread.sleep(java.base@9-ea/Native Method) at org.apacheriver.phoenix.Activation$2.run(Activation.java:1968) at org.apache.river.phoenix.Activation$2.run(Activation.java:1936) at org.apache.river.phoenix.Activation.main(Activation.java:1981) at org.apache.river.phoenix.Activation.main(Activation.java:1891) "VM Thread" os_prio=2 tid=0x000001cd33e7f800 nid=0x16a8 runnable "GC Thread#0" os_prio=2 tid=0x000001cd11f9d800 nid=0x1a50 runnable "GC Thread#1" os_prio=2 tid=0x000001cd11f9e800 nid=0x1d34 runnable "GC Thread#2" os_prio=2 tid=0x000001cd11fa1000 nid=0x12d0 runnable "GC Thread#3" os_prio=2 tid=0x000001cd11fa3000 nid=0x150c runnable "G1 Main Marker" os_prio=2 tid=0x000001cd1201a000 nid=0x1c1c runnable "G1 Marker#0" os_prio=2 tid=0x000001cd1201b000 nid=0xbd8 runnable "G1 Refine#0" os_prio=2 tid=0x000001cd11fb2000 nid=0x1944 runnable "G1 Refine#1" os_prio=2 tid=0x000001cd11fb0800 nid=0x1564 runnable "G1 Refine#2" os_prio=2 tid=0x000001cd11fa7800 nid=0x1808 runnable "G1 Refine#3" os_prio=2 tid=0x000001cd11fa6000 nid=0xec8 runnable "G1 Young RemSet Sampling" os_prio=2 tid=0x000001cd11fb2800 nid=0x5a8 runnable "VM Periodic Task Thread" os_prio=2 tid=0x000001cd340c9800 nid=0x1d08 waiting on condition JNI global references: 566 --- This email has been checked for viruses by Avast antivirus software. https://www.avast.com/antivirus
