ACTION: main -- Error. Program `/opt/jprt/T/T1/171537.kab/testproduct/linux_x64_2.6-fastdebug/bin/java' timed out!
REASON: User specified action: run main/othervm -Xmx384M -XX:+UseG1GC TestGCOld 50 1 20 10 10000
TIME: 491.457 seconds
messages:
command: main -Xmx384M -XX:+UseG1GC TestGCOld 50 1 20 10 10000
reason: User specified action: run main/othervm -Xmx384M -XX:+UseG1GC TestGCOld 50 1 20 10 10000
Timeout information:
Running jstack on process 8671
2015-12-16 11:02:37
Full thread dump Java HotSpot(TM) 64-Bit Server VM (9-internal+0-2015-12-16-171537.kab.hs-rt mixed mode):

"Attach Listener" #13 daemon prio=9 os_prio=0 tid=0x00002b72ac001000 nid=0x22e1 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE
   JavaThread state: _thread_blocked
Thread: 0x00002b72ac001000 [0x22e1] State: _at_safepoint _has_called_back 0 _at_poll_safepoint 0
   JavaThread state: _thread_blocked

"MainThread" #12 prio=5 os_prio=0 tid=0x00002b7240308000 nid=0x21f9 runnable [0x00002b7285c96000]
   java.lang.Thread.State: RUNNABLE
   JavaThread state: _thread_blocked
Thread: 0x00002b7240308000 [0x21f9] State: _call_back _has_called_back 1 _at_poll_safepoint 0
   JavaThread state: _thread_blocked
at TestGCOld.doYoungGenAlloc(TestGCOld.java:328)
at TestGCOld.doStep(TestGCOld.java:345)
at TestGCOld.main(TestGCOld.java:384)
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:520)
at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:92)
at java.lang.Thread.run(Thread.java:747)

"Service Thread" #10 daemon prio=9 os_prio=0 tid=0x00002b72402af800 nid=0x21f7 runnable [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE
   JavaThread state: _thread_blocked
Thread: 0x00002b72402af800 [0x21f7] State: _at_safepoint _has_called_back 0 _at_poll_safepoint 0
   JavaThread state: _thread_blocked

"Sweeper thread" #9 daemon prio=9 os_prio=0 tid=0x00002b724028b800 nid=0x21f6 runnable [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE
   JavaThread state: _thread_blocked
Thread: 0x00002b724028b800 [0x21f6] State: _at_safepoint _has_called_back 0 _at_poll_safepoint 0
   JavaThread state: _thread_blocked

"C1 CompilerThread2" #8 daemon prio=9 os_prio=0 tid=0x00002b7240289000 nid=0x21f5 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE
   JavaThread state: _thread_blocked
Thread: 0x00002b7240289000 [0x21f5] State: _at_safepoint _has_called_back 0 _at_poll_safepoint 0
   JavaThread state: _thread_blocked

"C2 CompilerThread1" #7 daemon prio=9 os_prio=0 tid=0x00002b7240286800 nid=0x21f4 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE
   JavaThread state: _thread_blocked
Thread: 0x00002b7240286800 [0x21f4] State: _at_safepoint _has_called_back 0 _at_poll_safepoint 0
   JavaThread state: _thread_blocked

"C2 CompilerThread0" #6 daemon prio=9 os_prio=0 tid=0x00002b7240284000 nid=0x21f3 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE
   JavaThread state: _thread_blocked
Thread: 0x00002b7240284000 [0x21f3] State: _at_safepoint _has_called_back 0 _at_poll_safepoint 0
   JavaThread state: _thread_blocked

"Signal Dispatcher" #5 daemon prio=9 os_prio=0 tid=0x00002b7240281800 nid=0x21f2 runnable [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE
   JavaThread state: _thread_blocked
Thread: 0x00002b7240281800 [0x21f2] State: _at_safepoint _has_called_back 0 _at_poll_safepoint 0
   JavaThread state: _thread_blocked

"Surrogate Locker Thread (Concurrent GC)" #4 daemon prio=9 os_prio=0 tid=0x00002b7240273000 nid=0x21f1 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE
   JavaThread state: _thread_blocked
Thread: 0x00002b7240273000 [0x21f1] State: _at_safepoint _has_called_back 0 _at_poll_safepoint 0
   JavaThread state: _thread_blocked

"Finalizer" #3 daemon prio=8 os_prio=0 tid=0x00002b724023f800 nid=0x21f0 in Object.wait() [0x00002b729c200000]
   java.lang.Thread.State: WAITING (on object monitor)
   JavaThread state: _thread_blocked
Thread: 0x00002b724023f800 [0x21f0] State: _at_safepoint _has_called_back 0 _at_poll_safepoint 0
   JavaThread state: _thread_blocked
at java.lang.Object.wait(Native Method)
- waiting on <0x00000000e85b8db8> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:150)
- waiting to re-lock in wait() <0x00000000e85b8db8> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:171)
at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:217)

"Reference Handler" #2 daemon prio=10 os_prio=0 tid=0x00002b724023d800 nid=0x21ef in Object.wait() [0x00002b729c0ff000]
   java.lang.Thread.State: WAITING (on object monitor)
   JavaThread state: _thread_blocked
Thread: 0x00002b724023d800 [0x21ef] State: _at_safepoint _has_called_back 0 _at_poll_safepoint 0
   JavaThread state: _thread_blocked
at java.lang.Object.wait(Native Method)
- waiting on <0x00000000e85b8f70> (a java.lang.ref.Reference$Lock)
at java.lang.Object.wait(Object.java:516)
at java.lang.ref.Reference.tryHandlePending(Reference.java:193)
- waiting to re-lock in wait() <0x00000000e85b8f70> (a java.lang.ref.Reference$Lock)
at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:155)

"main" #1 prio=5 os_prio=0 tid=0x00002b724001a800 nid=0x21e2 in Object.wait() [0x00002b723dd60000]
   java.lang.Thread.State: WAITING (on object monitor)
   JavaThread state: _thread_blocked
Thread: 0x00002b724001a800 [0x21e2] State: _at_safepoint _has_called_back 0 _at_poll_safepoint 0
   JavaThread state: _thread_blocked
at java.lang.Object.wait(Native Method)
- waiting on <0x00000000e85b7e68> (a java.lang.Thread)
at java.lang.Thread.join(Thread.java:1252)
- waiting to re-lock in wait() <0x00000000e85b7e68> (a java.lang.Thread)
at java.lang.Thread.join(Thread.java:1326)
at com.sun.javatest.regtest.agent.MainWrapper.main(MainWrapper.java:69)

"VM Thread" os_prio=0 tid=0x00002b7240225000 nid=0x21ee runnable

"GC Thread#0" os_prio=0 tid=0x00002b724003a800 nid=0x21e3 runnable

"GC Thread#1" os_prio=0 tid=0x00002b724003c000 nid=0x21e4 runnable

"GC Thread#2" os_prio=0 tid=0x00002b724003e000 nid=0x21e5 runnable

"GC Thread#3" os_prio=0 tid=0x00002b7240040000 nid=0x21e6 runnable

"G1 Main Marker" os_prio=0 tid=0x00002b724006d000 nid=0x21ec runnable

"G1 Marker#0" os_prio=0 tid=0x00002b724006f800 nid=0x21ed runnable

"G1 Refine#0" os_prio=0 tid=0x00002b7240049000 nid=0x21ea runnable

"G1 Refine#1" os_prio=0 tid=0x00002b7240047000 nid=0x21e9 runnable

"G1 Refine#2" os_prio=0 tid=0x00002b7240045000 nid=0x21e8 runnable

"G1 Refine#3" os_prio=0 tid=0x00002b7240042800 nid=0x21e7 runnable

"G1 Young RemSet Sampling" os_prio=0 tid=0x00002b724004b000 nid=0x21eb runnable

"VM Periodic Task Thread" os_prio=0 tid=0x00002b72402b1000 nid=0x21f8 waiting on condition

Compiler thread printing unimplemented.

JNI global references: 9

--- Timeout information end.
elapsed time (seconds): 491.457
STDOUT:
50 megabytes of live storage
1 work units per step
promotion ratio is 1:20
pointer mutation rate is 10
10000 steps
Timeout signalled after 480 seconds
STDERR:
Allocating 152 trees.
  (49804320 bytes)
  (2490216 nodes)
Initialization complete...
rerun:
HOME=/opt/jprt/jprtadm \
LANG=C \
LC_ALL=C \
LC_CTYPE= \
PATH=/bin:/usr/bin \
CLASSPATH=/opt/jprt/products/T1/jtreg4.1-latest/jtreg/lib/javatest.jar:/opt/jprt/products/T1/jtreg4.1-latest/jtreg/lib/jtreg.jar:/opt/jprt/T/T1/171537.kab/s/hotspot/build/linux-x86_64/testoutput/JTwork/classes/stress/gc:/opt/jprt/T/T1/171537.kab/s/hotspot/test/stress/gc \
    /opt/jprt/T/T1/171537.kab/testproduct/linux_x64_2.6-fastdebug/bin/java \
        -Dtest.class.path.prefix=/opt/jprt/T/T1/171537.kab/s/hotspot/build/linux-x86_64/testoutput/JTwork/classes/stress/gc:/opt/jprt/T/T1/171537.kab/s/hotspot/test/stress/gc \
        -Dtest.src=/opt/jprt/T/T1/171537.kab/s/hotspot/test/stress/gc \
        -Dtest.src.path=/opt/jprt/T/T1/171537.kab/s/hotspot/test/stress/gc \
        -Dtest.classes=/opt/jprt/T/T1/171537.kab/s/hotspot/build/linux-x86_64/testoutput/JTwork/classes/stress/gc \
        -Dtest.class.path=/opt/jprt/T/T1/171537.kab/s/hotspot/build/linux-x86_64/testoutput/JTwork/classes/stress/gc \
        -Dtest.vm.opts='-Duser.home=/opt/jprt/T/T1/171537.kab -Djava.io.tmpdir=/opt/jprt/T/T1/171537.kab/io/linux_x64_2.6-fastdebug-c2-hotspot_gc_gcold -server -server' \
        -Dtest.tool.vm.opts='-J-Duser.home=/opt/jprt/T/T1/171537.kab -J-Djava.io.tmpdir=/opt/jprt/T/T1/171537.kab/io/linux_x64_2.6-fastdebug-c2-hotspot_gc_gcold -J-server -J-server' \
        -Dtest.compiler.opts= \
        -Dtest.java.opts='-Duser.home=/opt/jprt/T/T1/171537.kab -Djava.io.tmpdir=/opt/jprt/T/T1/171537.kab/io/linux_x64_2.6-fastdebug-c2-hotspot_gc_gcold -server' \
        -Dtest.jdk=/opt/jprt/T/T1/171537.kab/testproduct/linux_x64_2.6-fastdebug \
        -Dcompile.jdk=/opt/jprt/T/T1/171537.kab/testproduct/linux_x64_2.6-fastdebug \
        -Dtest.timeout.factor=4.0 \
        -Dtest.nativepath=/opt/jprt/T/T1/171537.kab/bundles/testBundle/hotspot/jtreg/native \
        -Duser.home=/opt/jprt/T/T1/171537.kab -Djava.io.tmpdir=/opt/jprt/T/T1/171537.kab/io/linux_x64_2.6-fastdebug-c2-hotspot_gc_gcold -server -server -Duser.home=/opt/jprt/T/T1/171537.kab -Djava.io.tmpdir=/opt/jprt/T/T1/171537.kab/io/linux_x64_2.6-fastdebug-c2-hotspot_gc_gcold -server -Djava.library.path=/opt/jprt/T/T1/171537.kab/bundles/testBundle/hotspot/jtreg/native -Xmx384M -XX:+UseG1GC \
        com.sun.javatest.regtest.agent.MainWrapper /opt/jprt/T/T1/171537.kab/s/hotspot/build/linux-x86_64/testoutput/JTwork/classes/stress/gc/TestGCOld.jta 50 1 20 10 10000

TEST RESULT: Error. Program `/opt/jprt/T/T1/171537.kab/testproduct/linux_x64_2.6-fastdebug/bin/java' timed out!