----------messages:(192/11622)----------
command: testng jdk.incubator.httpclient/jdk.incubator.http.RawChannelTest
reason: User specified action: run testng jdk.incubator.httpclient/jdk.incubator.http.RawChannelTest
Mode: othervm [test needs --add-modules, test or library overrides a system module]
Additional options from @modules: --add-modules jdk.incubator.httpclient
Timeout information:
Running jstack on process 16646
2017-05-12 03:06:58
Full thread dump Java HotSpot(TM) 64-Bit Server VM (9-ea+170-mach5-b2369 mixed mode):

"Attach Listener" #18 daemon prio=9 os_prio=64 tid=0x0000000000d06000 nid=0x26 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"HTTP-Cache-cleaner" #17 daemon prio=5 os_prio=64 tid=0x0000000000d03800 nid=0x25 waiting on condition [0xffff80ffb77fc000]
   java.lang.Thread.State: TIMED_WAITING (sleeping)
at java.lang.Thread.sleep(java.base@9-ea/Native Method)
at jdk.incubator.http.ConnectionPool$CacheCleaner.run(jdk.incubator.httpclient@9-ea/ConnectionPool.java:201)

"Thread-3" #16 prio=5 os_prio=64 tid=0x0000000000db7000 nid=0x24 waiting on condition [0xffff80ffb78fd000]
   java.lang.Thread.State: WAITING (parking)
at jdk.internal.misc.Unsafe.park(java.base@9-ea/Native Method)
- parking to wait for <0x00000000ff7e3408> (a java.util.concurrent.CountDownLatch$Sync)
at java.util.concurrent.locks.LockSupport.park(java.base@9-ea/LockSupport.java:192)
at java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(java.base@9-ea/AbstractQueuedSynchronizer.java:871)
at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(java.base@9-ea/AbstractQueuedSynchronizer.java:1024)
at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(java.base@9-ea/AbstractQueuedSynchronizer.java:1331)
at java.util.concurrent.CountDownLatch.await(java.base@9-ea/CountDownLatch.java:232)
at jdk.incubator.http.RawChannelTest$TestServer.writeSlowly(jdk.incubator.httpclient@9-ea/RawChannelTest.java:257)
at jdk.incubator.http.RawChannelTest$TestServer.lambda$run$1(jdk.incubator.httpclient@9-ea/RawChannelTest.java:212)
at jdk.incubator.http.RawChannelTest$TestServer$$Lambda$69/1629095335.run(jdk.incubator.httpclient@9-ea/Unknown Source)
at java.lang.Thread.run(java.base@9-ea/Thread.java:844)

"SelectorManager" #14 daemon prio=5 os_prio=64 tid=0x0000000001192800 nid=0x22 runnable [0xffff80ffb7dfe000]
   java.lang.Thread.State: RUNNABLE
at sun.nio.ch.DevPollArrayWrapper.poll0(java.base@9-ea/Native Method)
at sun.nio.ch.DevPollArrayWrapper.poll(java.base@9-ea/DevPollArrayWrapper.java:223)
at sun.nio.ch.DevPollSelectorImpl.doSelect(java.base@9-ea/DevPollSelectorImpl.java:97)
at sun.nio.ch.SelectorImpl.lockAndDoSelect(java.base@9-ea/SelectorImpl.java:86)
- locked <0x00000000fef57b20> (a sun.nio.ch.Util$2)
- locked <0x00000000fef57a90> (a java.util.Collections$UnmodifiableSet)
- locked <0x00000000fef57938> (a sun.nio.ch.DevPollSelectorImpl)
at sun.nio.ch.SelectorImpl.select(java.base@9-ea/SelectorImpl.java:97)
at jdk.incubator.http.HttpClientImpl$SelectorManager.run(jdk.incubator.httpclient@9-ea/HttpClientImpl.java:375)

"Thread-1" #13 prio=5 os_prio=64 tid=0x0000000001318800 nid=0x21 in Object.wait() [0xffff80ffb81fe000]
   java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(java.base@9-ea/Native Method)
- waiting on <0x00000000fed353f8> (a java.lang.Thread)
at java.lang.Thread.join(java.base@9-ea/Thread.java:1353)
- waiting to re-lock in wait() <0x00000000fed353f8> (a java.lang.Thread)
at java.lang.Thread.join(java.base@9-ea/Thread.java:1427)
at jdk.incubator.http.RawChannelTest$TestServer.run(jdk.incubator.httpclient@9-ea/RawChannelTest.java:225)

"MainThread" #12 prio=5 os_prio=64 tid=0x0000000000a37000 nid=0x20 waiting on condition [0xffff80ffb85f2000]
   java.lang.Thread.State: WAITING (parking)
at jdk.internal.misc.Unsafe.park(java.base@9-ea/Native Method)
- parking to wait for <0x00000000ff7e3458> (a java.util.concurrent.CountDownLatch$Sync)
at java.util.concurrent.locks.LockSupport.park(java.base@9-ea/LockSupport.java:192)
at java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(java.base@9-ea/AbstractQueuedSynchronizer.java:871)
at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(java.base@9-ea/AbstractQueuedSynchronizer.java:1024)
at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(java.base@9-ea/AbstractQueuedSynchronizer.java:1331)
at java.util.concurrent.CountDownLatch.await(java.base@9-ea/CountDownLatch.java:232)
at jdk.incubator.http.RawChannelTest.test(jdk.incubator.httpclient@9-ea/RawChannelTest.java:168)
at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:563)
at org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:85)
at org.testng.internal.Invoker.invokeMethod(Invoker.java:639)
at org.testng.internal.Invoker.invokeTestMethod(Invoker.java:821)
at org.testng.internal.Invoker.invokeTestMethods(Invoker.java:1131)
at org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:124)
at org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:108)
at org.testng.TestRunner.privateRun(TestRunner.java:773)
at org.testng.TestRunner.run(TestRunner.java:623)
at org.testng.SuiteRunner.runTest(SuiteRunner.java:357)
at org.testng.SuiteRunner.runSequentially(SuiteRunner.java:352)
at org.testng.SuiteRunner.privateRun(SuiteRunner.java:310)
at org.testng.SuiteRunner.run(SuiteRunner.java:259)
at org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52)
at org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:86)
at org.testng.TestNG.runSuitesSequentially(TestNG.java:1185)
at org.testng.TestNG.runSuitesLocally(TestNG.java:1110)
at org.testng.TestNG.run(TestNG.java:1018)
at com.sun.javatest.regtest.agent.TestNGRunner.main(TestNGRunner.java:94)
at com.sun.javatest.regtest.agent.TestNGRunner.main(TestNGRunner.java:54)
at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:563)
at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:115)
at java.lang.Thread.run(java.base@9-ea/Thread.java:844)

"Service Thread" #10 daemon prio=9 os_prio=64 tid=0x0000000000b01800 nid=0x1e runnable [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"Common-Cleaner" #9 daemon prio=8 os_prio=64 tid=0x0000000000870000 nid=0x1d in Object.wait() [0xffff80ffb88f7000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
at java.lang.Object.wait(java.base@9-ea/Native Method)
- waiting on <0x00000000fff5b8a8> (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() <0x00000000fff5b8a8> (a java.lang.ref.ReferenceQueue$Lock)
at jdk.internal.ref.CleanerImpl.run(java.base@9-ea/CleanerImpl.java:148)
at java.lang.Thread.run(java.base@9-ea/Thread.java:844)
at jdk.internal.misc.InnocuousThread.run(java.base@9-ea/InnocuousThread.java:122)

"Sweeper thread" #8 daemon prio=9 os_prio=64 tid=0x00000000007ba000 nid=0x1c runnable [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"C1 CompilerThread2" #7 daemon prio=9 os_prio=64 tid=0x00000000007b0000 nid=0x1b waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE
   No compile task

"C2 CompilerThread1" #6 daemon prio=9 os_prio=64 tid=0x00000000007ae800 nid=0x1a waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE
   No compile task

"C2 CompilerThread0" #5 daemon prio=9 os_prio=64 tid=0x00000000007ac000 nid=0x19 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE
   No compile task

"Signal Dispatcher" #4 daemon prio=9 os_prio=64 tid=0x00000000007aa800 nid=0x18 runnable [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"Finalizer" #3 daemon prio=8 os_prio=64 tid=0x000000000078d000 nid=0x17 in Object.wait() [0xffff80ffb8efd000]
   java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(java.base@9-ea/Native Method)
- waiting on <0x00000000fff0d068> (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() <0x00000000fff0d068> (a java.lang.ref.ReferenceQueue$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=64 tid=0x0000000000781800 nid=0x16 waiting on condition [0xffff80ffb8ffe000]
   java.lang.Thread.State: RUNNABLE
at java.lang.ref.Reference.waitForReferencePendingList(java.base@9-ea/Native Method)
at java.lang.ref.Reference.processPendingReferences(java.base@9-ea/Reference.java:174)
at java.lang.ref.Reference.access$000(java.base@9-ea/Reference.java:44)
at java.lang.ref.Reference$ReferenceHandler.run(java.base@9-ea/Reference.java:138)

"main" #1 prio=5 os_prio=64 tid=0x0000000000433800 nid=0x2 in Object.wait() [0xffff80ffbf51e000]
   java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(java.base@9-ea/Native Method)
- waiting on <0x00000000ffdc8000> (a java.lang.Thread)
at java.lang.Thread.join(java.base@9-ea/Thread.java:1353)
- waiting to re-lock in wait() <0x00000000ffdc8000> (a java.lang.Thread)
at java.lang.Thread.join(java.base@9-ea/Thread.java:1427)
at com.sun.javatest.regtest.agent.MainWrapper.main(MainWrapper.java:74)

"VM Thread" os_prio=64 tid=0x0000000000776000 nid=0x15 runnable

"GC Thread#0" os_prio=64 tid=0x000000000044c800 nid=0x3 runnable

"GC Thread#1" os_prio=64 tid=0x000000000044d800 nid=0x4 runnable

"GC Thread#2" os_prio=64 tid=0x000000000044f000 nid=0x5 runnable

"GC Thread#3" os_prio=64 tid=0x0000000000450800 nid=0x6 runnable

"GC Thread#4" os_prio=64 tid=0x0000000000452000 nid=0x7 runnable

"GC Thread#5" os_prio=64 tid=0x0000000000453800 nid=0x8 runnable

"GC Thread#6" os_prio=64 tid=0x0000000000455000 nid=0x9 runnable

"G1 Main Marker" os_prio=64 tid=0x000000000047c800 nid=0x12 runnable

"G1 Marker#0" os_prio=64 tid=0x000000000047e000 nid=0x13 runnable

"G1 Marker#1" os_prio=64 tid=0x000000000047f800 nid=0x14 runnable

"G1 Refine#0" os_prio=64 tid=0x0000000000460800 nid=0x10 runnable

"G1 Refine#1" os_prio=64 tid=0x000000000045f000 nid=0xf runnable

"G1 Refine#2" os_prio=64 tid=0x000000000045d000 nid=0xe runnable

"G1 Refine#3" os_prio=64 tid=0x000000000045b800 nid=0xd runnable

"G1 Refine#4" os_prio=64 tid=0x000000000045a000 nid=0xc runnable

"G1 Refine#5" os_prio=64 tid=0x0000000000458800 nid=0xb runnable

"G1 Refine#6" os_prio=64 tid=0x0000000000457000 nid=0xa runnable

"G1 Young RemSet Sampling" os_prio=64 tid=0x0000000000462000 nid=0x11 runnable

"VM Periodic Task Thread" os_prio=64 tid=0x0000000000a90800 nid=0x1f waiting on condition

JNI global references: 760

--- Timeout information end.
elapsed time (seconds): 600.595
----------configuration:(5/301)----------
Boot Layer
  add modules: jdk.incubator.httpclient
  add reads: jdk.incubator.httpclient ALL-UNNAMED
  patch: jdk.incubator.httpclient /scratch/jenkins/workspace/9-dev/testresults/solaris-x64/jdk_test.tier2/jtreg/JTwork/java/net/httpclient/whitebox/Driver.d/patches/jdk.incubator.httpclient

----------System.out:(14/782)----------
[TestNG] Running:
  java/net/httpclient/whitebox/Driver.java

Thread[MainThread,5,MainThreadGroup]: raw channel to http://127.0.0.1:48445/
Thread[MainThread,5,MainThreadGroup]: RawChannel has 321 initial bytes
Thread[SelectorManager,5,MainThreadGroup]: OP_WRITE #1
Thread[SelectorManager,5,MainThreadGroup]: OP_WRITE clogged SNDBUF with 131024 bytes
Thread[SelectorManager,5,MainThreadGroup]: OP_WRITE #2
Thread[SelectorManager,5,MainThreadGroup]: OP_WRITE clogged SNDBUF with 131024 bytes
Thread[SelectorManager,5,MainThreadGroup]: OP_WRITE #3
Thread[SelectorManager,5,MainThreadGroup]: OP_WRITE clogged SNDBUF with 131024 bytes
Thread[SelectorManager,5,MainThreadGroup]: OP_WRITE #4
Thread[Thread-2,5,MainThreadGroup]: Server read 393072 bytes
Timeout signalled after 600 seconds
----------System.err:(1/59)----------
WARNING: Using incubator modules: jdk.incubator.httpclient
----------rerun:(33/2583)*----------
HOME=/opt/mach5/mach5-one \\
JDK8_HOME=/scratch/jenkins/workspace/mach5data/install/java/re/jdk/8/promoted/latest/bundles/solaris-x64/jdk-8-solaris-x64.tar.gz/jdk1.8.0 \\
JTREG_TIMEOUT_FACTOR=5 \\
JTREG_TIMEOUT_OPTION=-timeoutFactor:5 \\
JTREG_VERBOSE=fail,error,time \\
LC_ALL=en_US.UTF-8 \\
PATH=/bin:/usr/bin \\
TZ=localtime \\
buildid=BUILD_ID \\
CLASSPATH=/scratch/jenkins/workspace/9-dev/jdk/test/java/net/httpclient/whitebox:/scratch/jenkins/workspace/mach5data/install/java/re/jtreg/4.2/promoted/all/b07/bundles/jtreg_bin-4.2.zip/jtreg/lib/javatest.jar:/scratch/jenkins/workspace/mach5data/install/java/re/jtreg/4.2/promoted/all/b07/bundles/jtreg_bin-4.2.zip/jtreg/lib/jtreg.jar \\
    /scratch/jenkins/workspace/9-dev/build/jdk/bin/java \\
        -Dtest.class.path.prefix=/scratch/jenkins/workspace/9-dev/jdk/test/java/net/httpclient/whitebox \\
        -Dtest.src=/scratch/jenkins/workspace/9-dev/jdk/test/java/net/httpclient/whitebox \\
        -Dtest.src.path=/scratch/jenkins/workspace/9-dev/jdk/test/java/net/httpclient/whitebox \\
        -Dtest.classes=/scratch/jenkins/workspace/9-dev/testresults/solaris-x64/jdk_test.tier2/jtreg/JTwork/classes/3/java/net/httpclient/whitebox \\
        -Dtest.class.path=/scratch/jenkins/workspace/9-dev/testresults/solaris-x64/jdk_test.tier2/jtreg/JTwork/classes/3/java/net/httpclient/whitebox \\
        -Dtest.vm.opts='-ea -esa -Xmx512m' \\
        -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m' \\
        -Dtest.compiler.opts= \\
        -Dtest.java.opts= \\
        -Dtest.jdk=/scratch/jenkins/workspace/9-dev/build/jdk \\
        -Dcompile.jdk=/scratch/jenkins/workspace/9-dev/build/jdk \\
        -Dtest.timeout.factor=5.0 \\
        -Dtest.modules=jdk.incubator.httpclient \\
        -Dtest.patch.path= \\
        -Xbootclasspath/a:/scratch/jenkins/workspace/mach5data/install/java/re/jtreg/4.2/promoted/all/b07/bundles/jtreg_bin-4.2.zip/jtreg/lib/testng.jar \\
        --patch-module jdk.incubator.httpclient=/scratch/jenkins/workspace/9-dev/testresults/solaris-x64/jdk_test.tier2/jtreg/JTwork/java/net/httpclient/whitebox/Driver.d/patches/jdk.incubator.httpclient \\
        --add-modules jdk.incubator.httpclient \\
        --add-reads jdk.incubator.httpclient=ALL-UNNAMED \\
        -ea \\
        -esa \\
        -Xmx512m \\
        com.sun.javatest.regtest.agent.MainWrapper /scratch/jenkins/workspace/9-dev/testresults/solaris-x64/jdk_test.tier2/jtreg/JTwork/java/net/httpclient/whitebox/Driver.d/testng.1.jta java/net/httpclient/whitebox/Driver.java false jdk.incubator.httpclient/jdk.incubator.http.RawChannelTest
result: Error. Program `/scratch/jenkins/workspace/9-dev/build/jdk/bin/java' timed out (timeout set to 600000ms, elapsed time including timeout handling was 600588ms).


test result: Error. Program `/scratch/jenkins/workspace/9-dev/build/jdk/bin/java' timed out (timeout set to 600000ms, elapsed time including timeout handling was 600588ms).