-
Bug
-
Resolution: Cannot Reproduce
-
P4
-
5.0
-
generic
-
generic
nsk/jvmti/scenarios/allocation/AP04/ap04t002 intermittent fail:
#
[2009-09-17T20:20:39.24] export CLASSPATH
[2009-09-17T20:20:39.24] export RAS_OPTIONS
[2009-09-17T20:20:39.24] export PATH
[2009-09-17T20:20:39.24] export HOME
[2009-09-17T20:20:39.24] export TESTBASE
[2009-09-17T20:20:39.24] export SHELL
[2009-09-17T20:20:39.24] export DISPLAY
[2009-09-17T20:20:39.24] export LD_LIBRARY_PATH
[2009-09-17T20:20:39.24] TEST_DEST_DIR="ap04t002"
[2009-09-17T20:20:49.51] # Actual: TEST_DEST_DIR=ap04t002
[2009-09-17T20:20:49.51] TESTNAME="${test_case_name}"
[2009-09-17T20:20:49.51] # Actual: TESTNAME=ap04t002
[2009-09-17T20:20:49.51] testName="nsk/jvmti/scenarios/allocation/AP04//ap04t002"
[2009-09-17T20:20:49.51] # Actual: testName=nsk/jvmti/scenarios/allocation/AP04//ap04t002
[2009-09-17T20:20:49.51] TESTDIR="${test_work_dir}"
[2009-09-17T20:20:49.51] # Actual: TESTDIR=/export/local/5.STT.JDK15.PROMOTION.VM+sles10_x86-i586_nsk.jvmti.testlist/results/ResultDir/ap04t002
[2009-09-17T20:20:49.51] testWorkDir="${test_work_dir}/"
[2009-09-17T20:20:49.51] # Actual: testWorkDir=/export/local/5.STT.JDK15.PROMOTION.VM+sles10_x86-i586_nsk.jvmti.testlist/results/ResultDir/ap04t002/
[2009-09-17T20:20:49.51] export testWorkDir
[2009-09-17T20:20:49.51] tlogOutFile="${test_work_dir}/${test_name}.tlog"
[2009-09-17T20:20:49.51] # Actual: tlogOutFile=/export/local/5.STT.JDK15.PROMOTION.VM+sles10_x86-i586_nsk.jvmti.testlist/results/ResultDir/ap04t002/ap04t002.tlog
[2009-09-17T20:20:49.51] testErrFile="${test_work_dir}/${test_name}.err"
[2009-09-17T20:20:49.51] # Actual: testErrFile=/export/local/5.STT.JDK15.PROMOTION.VM+sles10_x86-i586_nsk.jvmti.testlist/results/ResultDir/ap04t002/ap04t002.err
[2009-09-17T20:20:49.51] EXECUTE_CLASS="${test_name}"
[2009-09-17T20:20:49.51] # Actual: EXECUTE_CLASS=ap04t002
[2009-09-17T20:20:49.51] AGENT_LIB_PATH="${COMMON_LIBS_LOCATION}/lib/${ARCH}/nsk/jvmti/scenarios/allocation/AP04"
[2009-09-17T20:20:49.51] # Actual: AGENT_LIB_PATH=/net/vmsqe.russia/export/testbase/sqe/vm/1.5/build/execution/vm/bin/lib/linux/nsk/jvmti/scenarios/allocation/AP04
[2009-09-17T20:20:49.51] LD_LIBRARY_PATH="${AGENT_LIB_PATH}${SEPARATOR}${LD_LIBRARY_PATH}"
[2009-09-17T20:20:49.51] # Actual: LD_LIBRARY_PATH=/net/vmsqe.russia/export/testbase/sqe/vm/1.5/build/execution/vm/bin/lib/linux/nsk/jvmti/scenarios/allocation/AP04:/net/vmsqe.russia/export/testbase/sqe/vm/1.5/build/execution/vm/src/nsk/share/lib/linux:/export/jdk/jdk1.5.0_22/jre/lib/i386:/export/jdk/jdk1.5.0_22/jre/lib/i386/server
[2009-09-17T20:20:49.51] export LD_LIBRARY_PATH
[2009-09-17T20:20:49.51] JAVA_OPTS="${JAVA_OPTS} -agentlib:ap04t002=${JVMTI_TEST_KEYS} -verbose"
[2009-09-17T20:20:49.51] # Actual: JAVA_OPTS=-server -Xmixed "-agentlib:ap04t002=-waittime=2 -verbose"
[2009-09-17T20:20:49.51] EXECUTE_CLASS="nsk.jvmti.scenarios.allocation.AP04.ap04t002"
[2009-09-17T20:20:49.51] # Actual: EXECUTE_CLASS=nsk.jvmti.scenarios.allocation.AP04.ap04t002
[2009-09-17T20:20:49.51] APPLICATION_TIMEOUT="${TIMEOUT}"
[2009-09-17T20:20:49.51] # Actual: APPLICATION_TIMEOUT=25
[2009-09-17T20:20:49.51] CLASSPATH="${test_work_dir}${PS}${CLASSPATH}"
[2009-09-17T20:20:49.51] # Actual: CLASSPATH=/export/local/5.STT.JDK15.PROMOTION.VM+sles10_x86-i586_nsk.jvmti.testlist/results/ResultDir/ap04t002:/net/vmsqe.russia/export/testbase/sqe/vm/1.5/build/execution/vm/bin/classes:/export/jdk/jdk1.5.0_22/lib/tools.jar
[2009-09-17T20:20:49.51] export CLASSPATH
[2009-09-17T20:20:49.51] ${JAVA} ${JAVA_OPTS} ${EXECUTE_CLASS} ${TEST_ARGS}
[2009-09-17T20:20:49.52] # Actual: /export/jdk/jdk1.5.0_22/bin/java -server -Xmixed "-agentlib:ap04t002=-waittime=2 -verbose" nsk.jvmti.scenarios.allocation.AP04.ap04t002
[2009-09-17T20:20:49.52] - ap04t002.c, 457: setting event callbacks ...
[2009-09-17T20:20:52.47] - ap04t002.c, 465: setting event callbacks done.
[2009-09-17T20:20:52.47] - ap04t002.c, 467: enabling JVMTI events ...
[2009-09-17T20:20:52.47] - ap04t002.c, 474: enabling the events done.
[2009-09-17T20:20:52.47] - ap04t002.c, 478: agentProc has been set
[2009-09-17T20:20:52.47]
[2009-09-17T20:20:52.47] - ap04t002.c, 363: Wait for debugee start
[2009-09-17T20:20:52.47]
[2009-09-17T20:20:52.47] - ap04t002.c, 367: Find debugee class: Lnsk/jvmti/scenarios/allocation/AP04/ap04t002;
[2009-09-17T20:20:52.47] - ap04t002.c, 378: Find ID of 'root' field: [Lnsk/jvmti/scenarios/allocation/AP04/ap04t002;
[2009-09-17T20:20:52.47] - ap04t002.c, 388: Find ID of 'modified' field
[2009-09-17T20:20:52.47] - ap04t002.c, 398: Set FieldModification watchpoint for 'modified' field
[2009-09-17T20:20:52.47] - ap04t002.c, 407: Let debugee to run test cases
[2009-09-17T20:20:52.47] - ap04t002.c, 411: Wait for completion of test cases
[2009-09-17T20:20:52.47]
[2009-09-17T20:20:52.47] CASE #1:
[2009-09-17T20:20:52.47] Allocating objects...
[2009-09-17T20:20:52.47] Start heap iteration thread and field modification loop
[2009-09-17T20:20:52.47] thread1 started.
[2009-09-17T20:20:52.47] - ap04t002.c, 237: Calling IterateOverHeap...
[2009-09-17T20:20:52.47] - ap04t002.c, 245: IterateOverHeap finished.
[2009-09-17T20:20:52.47] - ap04t002.c, 247: Iterations count: 100000
[2009-09-17T20:20:52.47] - ap04t002.c, 248: Modifications count: 1921
[2009-09-17T20:20:52.47] - ap04t002.c, 251: Errors detected: 98077
[2009-09-17T20:20:52.47] # ERROR: ap04t002.c, 253: FieldMofification events detected during heap iteration: 98077
[2009-09-17T20:20:53.87] thread1 finished.
[2009-09-17T20:20:53.87] Wait for completion thread to finish
[2009-09-17T20:20:53.87] Cleaning tags and references to objects...
[2009-09-17T20:20:53.87] CASE #1 finished.
[2009-09-17T20:20:53.87]
[2009-09-17T20:20:53.87] CASE #2:
[2009-09-17T20:20:53.87] Allocating objects...
[2009-09-17T20:20:53.87] Start heap iteration thread and field modification loop
[2009-09-17T20:20:53.87] thread2 started.
[2009-09-17T20:20:53.87] - ap04t002.c, 267: Calling IterateOverReachableObjects...
[2009-09-17T20:20:53.87] - ap04t002.c, 276: IterateOverReachableObjects finished.
[2009-09-17T20:20:53.87] - ap04t002.c, 278: Iterations count: 206341
[2009-09-17T20:20:53.87] - ap04t002.c, 279: Modifications count: 39
[2009-09-17T20:20:53.87] - ap04t002.c, 282: Errors detected: 0
[2009-09-17T20:20:53.87] Wait for completion thread to finish
[2009-09-17T20:20:53.87] thread2 finished.
[2009-09-17T20:20:53.87] Cleaning tags and references to objects...
[2009-09-17T20:20:53.87] CASE #2 finished.
[2009-09-17T20:20:53.87]
[2009-09-17T20:20:53.87] CASE #3:
[2009-09-17T20:20:53.87] Allocating objects...
[2009-09-17T20:20:53.87] Start heap iteration thread and field modification loop
[2009-09-17T20:20:53.87] thread3 started.
[2009-09-17T20:20:53.87] - ap04t002.c, 339: Calling IterateOverObjectsReachableFromObject...
[2009-09-17T20:20:53.87] - ap04t002.c, 347: IterateOverObjectsReachableFromObject finished.
[2009-09-17T20:20:53.87] - ap04t002.c, 349: Iterations count: 204449
[2009-09-17T20:20:53.87] - ap04t002.c, 350: Modifications count: 306
[2009-09-17T20:20:53.87] - ap04t002.c, 353: Errors detected: 0
[2009-09-17T20:20:53.87] Wait for completion thread to finish
[2009-09-17T20:20:55.52] thread3 finished.
[2009-09-17T20:20:55.52] Cleaning tags and references to objects...
[2009-09-17T20:20:55.52] CASE #3 finished.
[2009-09-17T20:20:55.52]
[2009-09-17T20:20:55.52] CASE #4:
[2009-09-17T20:20:55.52] Allocating objects...
[2009-09-17T20:20:55.52] Start heap iteration thread and field modification loop
[2009-09-17T20:20:55.52] thread4 started.
[2009-09-17T20:20:55.52] - ap04t002.c, 298: Calling IterateOverInstancesOfClass...
[2009-09-17T20:20:55.52] - ap04t002.c, 307: IterateOverInstancesOfClass finished.
[2009-09-17T20:20:55.52] - ap04t002.c, 309: Iterations count: 100000
[2009-09-17T20:20:55.52] - ap04t002.c, 310: Modifications count: 8348
[2009-09-17T20:20:55.52] - ap04t002.c, 313: Errors detected: 0
[2009-09-17T20:20:55.52] Wait for completion thread to finish
[2009-09-17T20:20:55.52] thread4 finished.
[2009-09-17T20:20:55.52] Cleaning tags and references to objects...
[2009-09-17T20:20:55.52] CASE #4 finished.
[2009-09-17T20:20:55.52]
[2009-09-17T20:20:55.52] - ap04t002.c, 418: Let debugee to finish
[2009-09-17T20:20:55.52] # Test level exit status: 97
[2009-09-17T20:20:56.53]
#
[2009-09-17T20:20:39.24] export CLASSPATH
[2009-09-17T20:20:39.24] export RAS_OPTIONS
[2009-09-17T20:20:39.24] export PATH
[2009-09-17T20:20:39.24] export HOME
[2009-09-17T20:20:39.24] export TESTBASE
[2009-09-17T20:20:39.24] export SHELL
[2009-09-17T20:20:39.24] export DISPLAY
[2009-09-17T20:20:39.24] export LD_LIBRARY_PATH
[2009-09-17T20:20:39.24] TEST_DEST_DIR="ap04t002"
[2009-09-17T20:20:49.51] # Actual: TEST_DEST_DIR=ap04t002
[2009-09-17T20:20:49.51] TESTNAME="${test_case_name}"
[2009-09-17T20:20:49.51] # Actual: TESTNAME=ap04t002
[2009-09-17T20:20:49.51] testName="nsk/jvmti/scenarios/allocation/AP04//ap04t002"
[2009-09-17T20:20:49.51] # Actual: testName=nsk/jvmti/scenarios/allocation/AP04//ap04t002
[2009-09-17T20:20:49.51] TESTDIR="${test_work_dir}"
[2009-09-17T20:20:49.51] # Actual: TESTDIR=/export/local/5.STT.JDK15.PROMOTION.VM+sles10_x86-i586_nsk.jvmti.testlist/results/ResultDir/ap04t002
[2009-09-17T20:20:49.51] testWorkDir="${test_work_dir}/"
[2009-09-17T20:20:49.51] # Actual: testWorkDir=/export/local/5.STT.JDK15.PROMOTION.VM+sles10_x86-i586_nsk.jvmti.testlist/results/ResultDir/ap04t002/
[2009-09-17T20:20:49.51] export testWorkDir
[2009-09-17T20:20:49.51] tlogOutFile="${test_work_dir}/${test_name}.tlog"
[2009-09-17T20:20:49.51] # Actual: tlogOutFile=/export/local/5.STT.JDK15.PROMOTION.VM+sles10_x86-i586_nsk.jvmti.testlist/results/ResultDir/ap04t002/ap04t002.tlog
[2009-09-17T20:20:49.51] testErrFile="${test_work_dir}/${test_name}.err"
[2009-09-17T20:20:49.51] # Actual: testErrFile=/export/local/5.STT.JDK15.PROMOTION.VM+sles10_x86-i586_nsk.jvmti.testlist/results/ResultDir/ap04t002/ap04t002.err
[2009-09-17T20:20:49.51] EXECUTE_CLASS="${test_name}"
[2009-09-17T20:20:49.51] # Actual: EXECUTE_CLASS=ap04t002
[2009-09-17T20:20:49.51] AGENT_LIB_PATH="${COMMON_LIBS_LOCATION}/lib/${ARCH}/nsk/jvmti/scenarios/allocation/AP04"
[2009-09-17T20:20:49.51] # Actual: AGENT_LIB_PATH=/net/vmsqe.russia/export/testbase/sqe/vm/1.5/build/execution/vm/bin/lib/linux/nsk/jvmti/scenarios/allocation/AP04
[2009-09-17T20:20:49.51] LD_LIBRARY_PATH="${AGENT_LIB_PATH}${SEPARATOR}${LD_LIBRARY_PATH}"
[2009-09-17T20:20:49.51] # Actual: LD_LIBRARY_PATH=/net/vmsqe.russia/export/testbase/sqe/vm/1.5/build/execution/vm/bin/lib/linux/nsk/jvmti/scenarios/allocation/AP04:/net/vmsqe.russia/export/testbase/sqe/vm/1.5/build/execution/vm/src/nsk/share/lib/linux:/export/jdk/jdk1.5.0_22/jre/lib/i386:/export/jdk/jdk1.5.0_22/jre/lib/i386/server
[2009-09-17T20:20:49.51] export LD_LIBRARY_PATH
[2009-09-17T20:20:49.51] JAVA_OPTS="${JAVA_OPTS} -agentlib:ap04t002=${JVMTI_TEST_KEYS} -verbose"
[2009-09-17T20:20:49.51] # Actual: JAVA_OPTS=-server -Xmixed "-agentlib:ap04t002=-waittime=2 -verbose"
[2009-09-17T20:20:49.51] EXECUTE_CLASS="nsk.jvmti.scenarios.allocation.AP04.ap04t002"
[2009-09-17T20:20:49.51] # Actual: EXECUTE_CLASS=nsk.jvmti.scenarios.allocation.AP04.ap04t002
[2009-09-17T20:20:49.51] APPLICATION_TIMEOUT="${TIMEOUT}"
[2009-09-17T20:20:49.51] # Actual: APPLICATION_TIMEOUT=25
[2009-09-17T20:20:49.51] CLASSPATH="${test_work_dir}${PS}${CLASSPATH}"
[2009-09-17T20:20:49.51] # Actual: CLASSPATH=/export/local/5.STT.JDK15.PROMOTION.VM+sles10_x86-i586_nsk.jvmti.testlist/results/ResultDir/ap04t002:/net/vmsqe.russia/export/testbase/sqe/vm/1.5/build/execution/vm/bin/classes:/export/jdk/jdk1.5.0_22/lib/tools.jar
[2009-09-17T20:20:49.51] export CLASSPATH
[2009-09-17T20:20:49.51] ${JAVA} ${JAVA_OPTS} ${EXECUTE_CLASS} ${TEST_ARGS}
[2009-09-17T20:20:49.52] # Actual: /export/jdk/jdk1.5.0_22/bin/java -server -Xmixed "-agentlib:ap04t002=-waittime=2 -verbose" nsk.jvmti.scenarios.allocation.AP04.ap04t002
[2009-09-17T20:20:49.52] - ap04t002.c, 457: setting event callbacks ...
[2009-09-17T20:20:52.47] - ap04t002.c, 465: setting event callbacks done.
[2009-09-17T20:20:52.47] - ap04t002.c, 467: enabling JVMTI events ...
[2009-09-17T20:20:52.47] - ap04t002.c, 474: enabling the events done.
[2009-09-17T20:20:52.47] - ap04t002.c, 478: agentProc has been set
[2009-09-17T20:20:52.47]
[2009-09-17T20:20:52.47] - ap04t002.c, 363: Wait for debugee start
[2009-09-17T20:20:52.47]
[2009-09-17T20:20:52.47] - ap04t002.c, 367: Find debugee class: Lnsk/jvmti/scenarios/allocation/AP04/ap04t002;
[2009-09-17T20:20:52.47] - ap04t002.c, 378: Find ID of 'root' field: [Lnsk/jvmti/scenarios/allocation/AP04/ap04t002;
[2009-09-17T20:20:52.47] - ap04t002.c, 388: Find ID of 'modified' field
[2009-09-17T20:20:52.47] - ap04t002.c, 398: Set FieldModification watchpoint for 'modified' field
[2009-09-17T20:20:52.47] - ap04t002.c, 407: Let debugee to run test cases
[2009-09-17T20:20:52.47] - ap04t002.c, 411: Wait for completion of test cases
[2009-09-17T20:20:52.47]
[2009-09-17T20:20:52.47] CASE #1:
[2009-09-17T20:20:52.47] Allocating objects...
[2009-09-17T20:20:52.47] Start heap iteration thread and field modification loop
[2009-09-17T20:20:52.47] thread1 started.
[2009-09-17T20:20:52.47] - ap04t002.c, 237: Calling IterateOverHeap...
[2009-09-17T20:20:52.47] - ap04t002.c, 245: IterateOverHeap finished.
[2009-09-17T20:20:52.47] - ap04t002.c, 247: Iterations count: 100000
[2009-09-17T20:20:52.47] - ap04t002.c, 248: Modifications count: 1921
[2009-09-17T20:20:52.47] - ap04t002.c, 251: Errors detected: 98077
[2009-09-17T20:20:52.47] # ERROR: ap04t002.c, 253: FieldMofification events detected during heap iteration: 98077
[2009-09-17T20:20:53.87] thread1 finished.
[2009-09-17T20:20:53.87] Wait for completion thread to finish
[2009-09-17T20:20:53.87] Cleaning tags and references to objects...
[2009-09-17T20:20:53.87] CASE #1 finished.
[2009-09-17T20:20:53.87]
[2009-09-17T20:20:53.87] CASE #2:
[2009-09-17T20:20:53.87] Allocating objects...
[2009-09-17T20:20:53.87] Start heap iteration thread and field modification loop
[2009-09-17T20:20:53.87] thread2 started.
[2009-09-17T20:20:53.87] - ap04t002.c, 267: Calling IterateOverReachableObjects...
[2009-09-17T20:20:53.87] - ap04t002.c, 276: IterateOverReachableObjects finished.
[2009-09-17T20:20:53.87] - ap04t002.c, 278: Iterations count: 206341
[2009-09-17T20:20:53.87] - ap04t002.c, 279: Modifications count: 39
[2009-09-17T20:20:53.87] - ap04t002.c, 282: Errors detected: 0
[2009-09-17T20:20:53.87] Wait for completion thread to finish
[2009-09-17T20:20:53.87] thread2 finished.
[2009-09-17T20:20:53.87] Cleaning tags and references to objects...
[2009-09-17T20:20:53.87] CASE #2 finished.
[2009-09-17T20:20:53.87]
[2009-09-17T20:20:53.87] CASE #3:
[2009-09-17T20:20:53.87] Allocating objects...
[2009-09-17T20:20:53.87] Start heap iteration thread and field modification loop
[2009-09-17T20:20:53.87] thread3 started.
[2009-09-17T20:20:53.87] - ap04t002.c, 339: Calling IterateOverObjectsReachableFromObject...
[2009-09-17T20:20:53.87] - ap04t002.c, 347: IterateOverObjectsReachableFromObject finished.
[2009-09-17T20:20:53.87] - ap04t002.c, 349: Iterations count: 204449
[2009-09-17T20:20:53.87] - ap04t002.c, 350: Modifications count: 306
[2009-09-17T20:20:53.87] - ap04t002.c, 353: Errors detected: 0
[2009-09-17T20:20:53.87] Wait for completion thread to finish
[2009-09-17T20:20:55.52] thread3 finished.
[2009-09-17T20:20:55.52] Cleaning tags and references to objects...
[2009-09-17T20:20:55.52] CASE #3 finished.
[2009-09-17T20:20:55.52]
[2009-09-17T20:20:55.52] CASE #4:
[2009-09-17T20:20:55.52] Allocating objects...
[2009-09-17T20:20:55.52] Start heap iteration thread and field modification loop
[2009-09-17T20:20:55.52] thread4 started.
[2009-09-17T20:20:55.52] - ap04t002.c, 298: Calling IterateOverInstancesOfClass...
[2009-09-17T20:20:55.52] - ap04t002.c, 307: IterateOverInstancesOfClass finished.
[2009-09-17T20:20:55.52] - ap04t002.c, 309: Iterations count: 100000
[2009-09-17T20:20:55.52] - ap04t002.c, 310: Modifications count: 8348
[2009-09-17T20:20:55.52] - ap04t002.c, 313: Errors detected: 0
[2009-09-17T20:20:55.52] Wait for completion thread to finish
[2009-09-17T20:20:55.52] thread4 finished.
[2009-09-17T20:20:55.52] Cleaning tags and references to objects...
[2009-09-17T20:20:55.52] CASE #4 finished.
[2009-09-17T20:20:55.52]
[2009-09-17T20:20:55.52] - ap04t002.c, 418: Let debugee to finish
[2009-09-17T20:20:55.52] # Test level exit status: 97
[2009-09-17T20:20:56.53]