Back to build
Raw log | Switch to full mode | Login

Running command: /b/s/w/ir/cache/vpython/7c7ecd/bin/python scons.py --verbose -k -j1 --mode=nacl,dbg-host,nacl_irt_test platform=x86-64 --clang large_tests_irt scons: Reading SConscript files ... ====================================================================== SCONS ARGS:['scons.py', '--verbose', '-k', '-j1', '--mode=nacl,dbg-host,nacl_irt_test', 'platform=x86-64', '--clang', 'large_tests_irt'] ====================================================================== ====================================================================== Python Info: ====================================================================== darwin 2.7.14+chromium14 (6cc0aad35b-dirty:6cc0aad35b, Oct 3 2017, 17:23:56) [GCC 4.2.1 Compatible Apple LLVM 8.0.0 (clang-800.0.38)] ====================================================================== ENV: ====================================================================== PATH /b/s/w/ir/cache/vpython/7c7ecd/bin:/b/s/w/ir/cipd_bin_packages:/b/s/w/ir/cipd_bin_packages/bin:/b/s/cipd_cache/bin:/opt/local/bin:/opt/local/sbin:/usr/local/sbin:/usr/local/git/bin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/b/s/w/ir/kitchen-checkout/depot_tools ====================================================================== OS: ====================================================================== kern.ostype: Darwin kern.osrelease: 17.7.0 kern.osrevision: 199506 kern.version: Darwin Kernel Version 17.7.0: Thu Jun 21 22:53:14 PDT 2018; root:xnu-4570.71.2~1/RELEASE_X86_64 kern.posix1version: 200112 kern.osversion: 17G65 kern.osproductversion: 10.13.6 ====================================================================== CPU: ====================================================================== hw.machine: x86_64 hw.model: Macmini7,1 hw.ncpu: 4 hw.ncpu: 4 hw.activecpu: 4 hw.physicalcpu: 2 hw.physicalcpu_max: 2 hw.logicalcpu: 4 hw.logicalcpu_max: 4 hw.cputype: 7 hw.cpusubtype: 8 hw.cpu64bit_capable: 1 hw.cpufamily: 280134364 hw.cpufrequency: 3000000000 hw.cpufrequency_min: 3000000000 hw.cpufrequency_max: 3000000000 hw.cputhreadtype: 1 ====================================================================== RAM: ====================================================================== hw.memsize: 17179869184 ====================================================================== LOAD: ====================================================================== TBD ====================================================================== UPTIME: ====================================================================== kern.boottime: { sec = 1552674630, usec = 596376 } Fri Mar 15 11:30:30 2019 ====================================================================== The following environments have been configured ====================================================================== NACL_BUILD_FAMILY: UNTRUSTED BUILD_TYPE: nacl TARGET_ROOT: /b/s/w/ir/k/native_client/scons-out/nacl-x86-64 OBJ_ROOT: /b/s/w/ir/k/native_client/scons-out/nacl-x86-64/obj BUILD_TYPE_DESCRIPTION: NaCl module build BUILD_OS: BUILD_ARCHITECTURE: x86 BUILD_SUBARCH: 64 TARGET_OS: TARGET_ARCHITECTURE: x86 TARGET_SUBARCH: 64 CC: /b/s/w/ir/k/native_client/toolchain/mac_x86/pnacl_newlib_raw/bin/x86_64-nacl-clang ASPPCOM: /b/s/w/ir/k/native_client/toolchain/mac_x86/pnacl_newlib_raw/bin/x86_64-nacl-clang -m64 -D__STDC_LIMIT_MACROS=1 -D__STDC_FORMAT_MACROS=1 -D_GNU_SOURCE=1 -D_POSIX_C_SOURCE=199506 -D_XOPEN_SOURCE=600 -DDYNAMIC_ANNOTATIONS_ENABLED=1 -DDYNAMIC_ANNOTATIONS_PREFIX=NACL_ -DNACL_BUILD_ARCH=x86 -DNACL_BUILD_SUBARCH=64 -I/b/s/w/ir/k/native_client/scons-out/nacl-x86-64/include -I/b/s/w/ir/k -c -o UNKNOWN COMPILER NACL_BUILD_FAMILY: TRUSTED BUILD_TYPE: dbg-mac TARGET_ROOT: /b/s/w/ir/k/native_client/scons-out/dbg-mac-x86-64 OBJ_ROOT: /b/s/w/ir/k/native_client/scons-out/dbg-mac-x86-64/obj BUILD_TYPE_DESCRIPTION: MacOS dbg build BUILD_OS: BUILD_ARCHITECTURE: x86 BUILD_SUBARCH: 64 TARGET_OS: TARGET_ARCHITECTURE: x86 TARGET_SUBARCH: 64 CC: /b/s/w/ir/k/third_party/llvm-build/Release+Asserts/bin/clang ASPPCOM: /b/s/w/ir/k/third_party/llvm-build/Release+Asserts/bin/clang -isysroot /b/s/w/ir/cache/osx_sdk/XCode.app/Contents/Developer/Platforms/MacOSX.platform/Developer/SDKs/MacOSX10.13.sdk -mmacosx-version-min=10.6 -m64 -D__STDC_LIMIT_MACROS=1 -D__STDC_FORMAT_MACROS=1 -D_DEBUG -I/b/s/w/ir/k -c -o UNKNOWN COMPILER NACL_BUILD_FAMILY: UNTRUSTED_IRT_TESTS BUILD_TYPE: nacl_irt_test TARGET_ROOT: /b/s/w/ir/k/native_client/scons-out/nacl_irt_test-x86-64 OBJ_ROOT: /b/s/w/ir/k/native_client/scons-out/nacl_irt_test-x86-64/obj BUILD_TYPE_DESCRIPTION: NaCl tests build with IRT BUILD_OS: BUILD_ARCHITECTURE: x86 BUILD_SUBARCH: 64 TARGET_OS: TARGET_ARCHITECTURE: x86 TARGET_SUBARCH: 64 CC: /b/s/w/ir/k/native_client/toolchain/mac_x86/pnacl_newlib_raw/bin/x86_64-nacl-clang ASPPCOM: /b/s/w/ir/k/native_client/toolchain/mac_x86/pnacl_newlib_raw/bin/x86_64-nacl-clang -m64 -D__STDC_LIMIT_MACROS=1 -D__STDC_FORMAT_MACROS=1 -D_GNU_SOURCE=1 -D_POSIX_C_SOURCE=199506 -D_XOPEN_SOURCE=600 -DDYNAMIC_ANNOTATIONS_ENABLED=1 -DDYNAMIC_ANNOTATIONS_PREFIX=NACL_ -DNACL_BUILD_ARCH=x86 -DNACL_BUILD_SUBARCH=64 -Iscons-out/nacl-x86-64/include -I/b/s/w/ir/k -c -o UNKNOWN COMPILER NACL_BUILD_FAMILY: UNTRUSTED_IRT BUILD_TYPE: nacl_irt TARGET_ROOT: /b/s/w/ir/k/native_client/scons-out/nacl_irt-x86-64 OBJ_ROOT: /b/s/w/ir/k/native_client/scons-out/nacl_irt-x86-64/obj BUILD_TYPE_DESCRIPTION: NaCl IRT build BUILD_OS: BUILD_ARCHITECTURE: x86 BUILD_SUBARCH: 64 TARGET_OS: TARGET_ARCHITECTURE: x86 TARGET_SUBARCH: 64 CC: /b/s/w/ir/k/native_client/toolchain/mac_x86/pnacl_newlib_raw/bin/x86_64-nacl-clang ASPPCOM: /b/s/w/ir/k/native_client/toolchain/mac_x86/pnacl_newlib_raw/bin/x86_64-nacl-clang -m64 -D__STDC_LIMIT_MACROS=1 -D__STDC_FORMAT_MACROS=1 -D_GNU_SOURCE=1 -D_POSIX_C_SOURCE=199506 -D_XOPEN_SOURCE=600 -DDYNAMIC_ANNOTATIONS_ENABLED=1 -DDYNAMIC_ANNOTATIONS_PREFIX=NACL_ -DNACL_BUILD_ARCH=x86 -DNACL_BUILD_SUBARCH=64 -I/b/s/w/ir/k/native_client/scons-out/nacl_irt-x86-64/include -I/b/s/w/ir/k -I/b/s/w/ir/k/native_client/src/untrusted/pthread -c -o UNKNOWN COMPILER *** BROKEN run_ncval_annotate_test *** BROKEN run_gdb_invalid_memory_test *** BROKEN run_nanosleep_test *** BROKEN run_timefuncs_test *** BROKEN run_raw_timefuncs_test *** BROKEN run_main_thread_pthread_exit_test2 *** BROKEN run_overflowinline_test *** BROKEN run_stack_frame_noopt_frame_test *** BROKEN run_stack_frame_noopt_noframe_test *** BROKEN run_stack_frame_opt_frame_test *** BROKEN run_stack_frame_opt_noframe_test *** BROKEN run_vla_test *** BROKEN run_nacl_sync_cond_test SKIPPING test text_overlaps_rodata SKIPPING test text_overlaps_data *** BROKEN run_gdb_invalid_memory_test_irt *** BROKEN run_nanosleep_test_irt *** BROKEN run_timefuncs_test_irt *** BROKEN run_raw_timefuncs_test_irt *** BROKEN run_main_thread_pthread_exit_test2_irt *** BROKEN run_overflowinline_test_irt *** BROKEN run_stack_frame_noopt_frame_test_irt *** BROKEN run_stack_frame_noopt_noframe_test_irt *** BROKEN run_stack_frame_opt_frame_test_irt *** BROKEN run_stack_frame_opt_noframe_test_irt *** BROKEN run_vla_test_irt There are 24 broken tests. ====================================================================== B U I L D - O U T P U T: ====================================================================== scons: done reading SConscript files. scons: Building targets ... /b/s/w/ir/cache/vpython/7c7ecd/bin/python tools/command_tester.py --name nacl_newlib.run_benchmark_test_irt --time_warning 10 --time_error 100 --perf_env_description x86-64_with_irt_nnacl_newlib_static --subarch 64 --arch x86 --capture_output 0 --output_stamp /b/s/w/ir/k/native_client/scons-out/nacl_irt_test-x86-64/test_results/benchmark_test.out scons-out/dbg-mac-x86-64/staging/sel_ldr -B scons-out/nacl_irt-x86-64/staging/irt_core.nexe -- scons-out/nacl_irt_test-x86-64/obj/tests/benchmark/benchmark_test.nexe x86-64_with_irt_nnacl_newlib_static [ RUN ] nacl_newlib.run_benchmark_test_irt scons-out/dbg-mac-x86-64/staging/sel_ldr -B scons-out/nacl_irt-x86-64/staging/irt_core.nexe -- scons-out/nacl_irt_test-x86-64/obj/tests/benchmark/benchmark_test.nexe x86-64_with_irt_nnacl_newlib_static [19469,2962969472:12:32:09.089919] Native Client module will be loaded at base address 0x000015ab00000000 Running suite of 1 benchmarks: Running Benchmark: Life (SIMD version)... RESULT BenchmarkLife: x86-64_with_irt_nnacl_newlib_static= {0.131170, 0.000770} seconds --------------------------------------------------------------- Done running benchmark suite. [ OK ] nacl_newlib.run_benchmark_test_irt (1330 ms) /b/s/w/ir/cache/vpython/7c7ecd/bin/python tools/command_tester.py --name nacl_newlib.run_clock_cputime_test_irt --time_warning 60 --time_error 600 --perf_env_description x86-64_with_irt_nnacl_newlib_static --subarch 64 --arch x86 --output_stamp /b/s/w/ir/k/native_client/scons-out/nacl_irt_test-x86-64/test_results/clock_cputime_test.out scons-out/dbg-mac-x86-64/staging/sel_ldr -B scons-out/nacl_irt-x86-64/staging/irt_core.nexe -- scons-out/nacl_irt_test-x86-64/obj/tests/clock/clock_test.nexe -c [ RUN ] nacl_newlib.run_clock_cputime_test_irt scons-out/dbg-mac-x86-64/staging/sel_ldr -B scons-out/nacl_irt-x86-64/staging/irt_core.nexe -- scons-out/nacl_irt_test-x86-64/obj/tests/clock/clock_test.nexe -c [ OK ] nacl_newlib.run_clock_cputime_test_irt (59180 ms) doSizeCheck(["scons-out/nacl_irt_test-x86-64/obj/tests/hello_world/hello_world_size.out"], ["scons-out/nacl_irt_test-x86-64/obj/tests/hello_world/hello_world.nexe"]) RESULT hello_world_size.out: x86-64_with_irt_nnacl_newlib_static= 526.596 KB RESULT hello_world_size.out: ZIPPED_x86-64_with_irt_nnacl_newlib_static= 187.013 KB /b/s/w/ir/cache/vpython/7c7ecd/bin/python tools/command_tester.py --name nacl_newlib.run_performance_test_irt --time_warning 10 --time_error 100 --perf_env_description x86-64_with_irt_nnacl_newlib_static --subarch 64 --arch x86 --capture_output 0 --output_stamp /b/s/w/ir/k/native_client/scons-out/nacl_irt_test-x86-64/test_results/performance_test.out scons-out/dbg-mac-x86-64/staging/sel_ldr -e -B scons-out/nacl_irt-x86-64/staging/irt_core.nexe -- scons-out/nacl_irt_test-x86-64/obj/tests/performance/performance_test.nexe x86-64_with_irt_nnacl_newlib_static [ RUN ] nacl_newlib.run_performance_test_irt scons-out/dbg-mac-x86-64/staging/sel_ldr -e -B scons-out/nacl_irt-x86-64/staging/irt_core.nexe -- scons-out/nacl_irt_test-x86-64/obj/tests/performance/performance_test.nexe x86-64_with_irt_nnacl_newlib_static [19474,2962969472:12:32:26.619298] Native Client module will be loaded at base address 0x0000532e00000000 TestNull: Measuring real time: 0.007 usec (7.1e-09 sec) per iteration: 7.1e-07 sec for 100 iterations 0.002 usec (1.794e-09 sec) per iteration: 1.794e-06 sec for 1000 iterations 0.002 usec (1.5121e-09 sec) per iteration: 1.5121e-05 sec for 10000 iterations 0.001 usec (1.45569e-09 sec) per iteration: 0.0962693 sec for 66133192 iterations 0.001 usec (1.47006e-09 sec) per iteration: 0.0972197 sec for 66133192 iterations 0.001 usec (1.45249e-09 sec) per iteration: 0.0960579 sec for 66133192 iterations 0.001 usec (1.47221e-09 sec) per iteration: 0.097362 sec for 66133192 iterations 0.001 usec (1.46065e-09 sec) per iteration: 0.0965972 sec for 66133192 iterations mean: 0.001462 usec stddev: 0.000008 usec relative stddev: 0.53% RESULT TestNull: x86-64_with_irt_nnacl_newlib_static= {0.001462, 0.000008} us Measuring clock cycles: first runs (cycles): 150 33 18 18 27 18 18 27 18 18 ... slowest runs (cycles): ... 27 27 27 27 27 27 27 27 33 150 min: 18 cycles q1: 18 cycles median: 18 cycles q3: 27 cycles max: 150 cycles RESULT TestNull_CycleCount: x86-64_with_irt_nnacl_newlib_static= {18, 9} count Apparent clock speed: 12310 MHz TestNaClSyscall: Measuring real time: 0.239 usec (2.3877e-07 sec) per iteration: 2.3877e-05 sec for 100 iterations 0.150 usec (1.50276e-07 sec) per iteration: 0.0629375 sec for 418813 iterations 0.153 usec (1.5297e-07 sec) per iteration: 0.0640657 sec for 418813 iterations 0.152 usec (1.52184e-07 sec) per iteration: 0.0637367 sec for 418813 iterations 0.151 usec (1.51368e-07 sec) per iteration: 0.063395 sec for 418813 iterations 0.150 usec (1.50227e-07 sec) per iteration: 0.0629171 sec for 418813 iterations mean: 0.151405 usec stddev: 0.001070 usec relative stddev: 0.71% RESULT TestNaClSyscall: x86-64_with_irt_nnacl_newlib_static= {0.151405, 0.001070} us Measuring clock cycles: first runs (cycles): 753 510 498 510 465 471 468 456 459 459 ... slowest runs (cycles): ... 471 474 477 498 507 507 510 510 525 753 min: 453 cycles q1: 459 cycles median: 465 cycles q3: 468 cycles max: 753 cycles RESULT TestNaClSyscall_CycleCount: x86-64_with_irt_nnacl_newlib_static= {465, 9} count Apparent clock speed: 3071 MHz TestSetjmpLongjmp: Measuring real time: 0.019 usec (1.881e-08 sec) per iteration: 1.881e-06 sec for 100 iterations 0.013 usec (1.302e-08 sec) per iteration: 1.302e-05 sec for 1000 iterations 0.010 usec (9.78193e-09 sec) per iteration: 0.07513 sec for 7680491 iterations 0.010 usec (9.86198e-09 sec) per iteration: 0.0757448 sec for 7680491 iterations 0.010 usec (9.79341e-09 sec) per iteration: 0.0752182 sec for 7680491 iterations 0.010 usec (9.80326e-09 sec) per iteration: 0.0752939 sec for 7680491 iterations 0.010 usec (9.98667e-09 sec) per iteration: 0.0767025 sec for 7680491 iterations mean: 0.009845 usec stddev: 0.000076 usec relative stddev: 0.77% RESULT TestSetjmpLongjmp: x86-64_with_irt_nnacl_newlib_static= {0.009845, 0.000076} us Measuring clock cycles: first runs (cycles): 201 30 30 27 30 30 30 30 30 30 ... slowest runs (cycles): ... 30 30 30 30 30 30 30 30 30 201 min: 18 cycles q1: 21 cycles median: 21 cycles q3: 30 cycles max: 201 cycles RESULT TestSetjmpLongjmp_CycleCount: x86-64_with_irt_nnacl_newlib_static= {21, 9} count Apparent clock speed: 2133 MHz TestClockGetTime: Measuring real time: 0.289 usec (2.8856e-07 sec) per iteration: 2.8856e-05 sec for 100 iterations 0.260 usec (2.60326e-07 sec) per iteration: 0.0902156 sec for 346548 iterations 0.259 usec (2.58965e-07 sec) per iteration: 0.0897439 sec for 346548 iterations 0.258 usec (2.58036e-07 sec) per iteration: 0.089422 sec for 346548 iterations 0.259 usec (2.5922e-07 sec) per iteration: 0.089832 sec for 346548 iterations 0.258 usec (2.58495e-07 sec) per iteration: 0.089581 sec for 346548 iterations mean: 0.259009 usec stddev: 0.000774 usec relative stddev: 0.30% RESULT TestClockGetTime: x86-64_with_irt_nnacl_newlib_static= {0.259009, 0.000774} us Measuring clock cycles: first runs (cycles): 1380 864 942 819 783 777 780 780 795 780 ... slowest runs (cycles): ... 834 846 858 858 861 864 864 942 948 1380 min: 756 cycles q1: 771 cycles median: 777 cycles q3: 780 cycles max: 1380 cycles RESULT TestClockGetTime_CycleCount: x86-64_with_irt_nnacl_newlib_static= {777, 9} count Apparent clock speed: 3000 MHz TestTlsVariable: Measuring real time: 0.015 usec (1.501e-08 sec) per iteration: 1.501e-06 sec for 100 iterations 0.008 usec (8.279e-09 sec) per iteration: 8.279e-06 sec for 1000 iterations 0.006 usec (6.0208e-09 sec) per iteration: 6.0208e-05 sec for 10000 iterations 0.004 usec (4.38559e-09 sec) per iteration: 0.0728406 sec for 16609088 iterations 0.004 usec (4.36304e-09 sec) per iteration: 0.0724662 sec for 16609088 iterations 0.004 usec (4.3745e-09 sec) per iteration: 0.0726565 sec for 16609088 iterations 0.004 usec (4.37352e-09 sec) per iteration: 0.0726401 sec for 16609088 iterations 0.004 usec (4.33334e-09 sec) per iteration: 0.0719728 sec for 16609088 iterations mean: 0.004366 usec stddev: 0.000018 usec relative stddev: 0.41% RESULT TestTlsVariable: x86-64_with_irt_nnacl_newlib_static= {0.004366, 0.000018} us Measuring clock cycles: first runs (cycles): 210 60 45 27 18 18 27 18 18 27 ... slowest runs (cycles): ... 27 27 27 27 27 27 27 45 60 210 min: 18 cycles q1: 18 cycles median: 18 cycles q3: 27 cycles max: 210 cycles RESULT TestTlsVariable_CycleCount: x86-64_with_irt_nnacl_newlib_static= {18, 9} count Apparent clock speed: 4123 MHz TestMmapAnonymous: Measuring real time: 7.274 usec (7.27441e-06 sec) per iteration: 0.000727441 sec for 100 iterations 5.200 usec (5.20049e-06 sec) per iteration: 0.0714859 sec for 13746 iterations 5.253 usec (5.25285e-06 sec) per iteration: 0.0722057 sec for 13746 iterations 5.213 usec (5.21256e-06 sec) per iteration: 0.0716519 sec for 13746 iterations 5.197 usec (5.19718e-06 sec) per iteration: 0.0714404 sec for 13746 iterations 5.186 usec (5.186e-06 sec) per iteration: 0.0712868 sec for 13746 iterations mean: 5.209818 usec stddev: 0.023123 usec relative stddev: 0.44% RESULT TestMmapAnonymous: x86-64_with_irt_nnacl_newlib_static= {5.209818, 0.023123} us Measuring clock cycles: first runs (cycles): 19362 16080 15822 15774 15789 15756 15678 15843 15687 19950 ... slowest runs (cycles): ... 26088 26406 26766 26835 26988 27315 41502 42558 51186 64563 min: 14997 cycles q1: 15210 cycles median: 15444 cycles q3: 19362 cycles max: 64563 cycles RESULT TestMmapAnonymous_CycleCount: x86-64_with_irt_nnacl_newlib_static= {15444, 4152} count Apparent clock speed: 2964 MHz TestAtomicIncrement: Measuring real time: 0.016 usec (1.628e-08 sec) per iteration: 1.628e-06 sec for 100 iterations 0.008 usec (7.96e-09 sec) per iteration: 7.96e-06 sec for 1000 iterations 0.009 usec (9.0488e-09 sec) per iteration: 9.0488e-05 sec for 10000 iterations 0.008 usec (7.58231e-09 sec) per iteration: 0.0837936 sec for 11051189 iterations 0.008 usec (7.62152e-09 sec) per iteration: 0.0842269 sec for 11051189 iterations 0.008 usec (7.64752e-09 sec) per iteration: 0.0845142 sec for 11051189 iterations 0.008 usec (7.55503e-09 sec) per iteration: 0.0834921 sec for 11051189 iterations 0.008 usec (7.54419e-09 sec) per iteration: 0.0833723 sec for 11051189 iterations mean: 0.007590 usec stddev: 0.000039 usec relative stddev: 0.52% RESULT TestAtomicIncrement: x86-64_with_irt_nnacl_newlib_static= {0.007590, 0.000039} us Measuring clock cycles: first runs (cycles): 132 39 39 48 48 48 48 48 48 48 ... slowest runs (cycles): ... 48 48 48 48 48 48 48 48 51 132 min: 39 cycles q1: 48 cycles median: 48 cycles q3: 48 cycles max: 132 cycles RESULT TestAtomicIncrement_CycleCount: x86-64_with_irt_nnacl_newlib_static= {48, 0} count Apparent clock speed: 6324 MHz TestUncontendedMutexLock: Measuring real time: 0.030 usec (2.998e-08 sec) per iteration: 2.998e-06 sec for 100 iterations 0.022 usec (2.1898e-08 sec) per iteration: 2.1898e-05 sec for 1000 iterations 0.019 usec (1.91567e-08 sec) per iteration: 0.0874813 sec for 4566627 iterations 0.019 usec (1.89804e-08 sec) per iteration: 0.0866764 sec for 4566627 iterations 0.019 usec (1.89e-08 sec) per iteration: 0.0863093 sec for 4566627 iterations 0.019 usec (1.91278e-08 sec) per iteration: 0.0873497 sec for 4566627 iterations 0.019 usec (1.88222e-08 sec) per iteration: 0.0859538 sec for 4566627 iterations mean: 0.018997 usec stddev: 0.000129 usec relative stddev: 0.68% RESULT TestUncontendedMutexLock: x86-64_with_irt_nnacl_newlib_static= {0.018997, 0.000129} us Measuring clock cycles: first runs (cycles): 294 96 78 84 78 75 87 75 78 75 ... slowest runs (cycles): ... 87 87 87 87 87 87 87 87 96 294 min: 75 cycles q1: 75 cycles median: 78 cycles q3: 84 cycles max: 294 cycles RESULT TestUncontendedMutexLock_CycleCount: x86-64_with_irt_nnacl_newlib_static= {78, 9} count Apparent clock speed: 4106 MHz TestCondvarSignalNoOp: Measuring real time: 0.296 usec (2.9566e-07 sec) per iteration: 2.9566e-05 sec for 100 iterations 0.206 usec (2.06279e-07 sec) per iteration: 0.0697689 sec for 338226 iterations 0.204 usec (2.04078e-07 sec) per iteration: 0.0690246 sec for 338226 iterations 0.206 usec (2.05626e-07 sec) per iteration: 0.069548 sec for 338226 iterations 0.206 usec (2.06493e-07 sec) per iteration: 0.0698414 sec for 338226 iterations 0.207 usec (2.07357e-07 sec) per iteration: 0.0701335 sec for 338226 iterations mean: 0.205967 usec stddev: 0.001094 usec relative stddev: 0.53% RESULT TestCondvarSignalNoOp: x86-64_with_irt_nnacl_newlib_static= {0.205967, 0.001094} us Measuring clock cycles: first runs (cycles): 1671 987 951 912 906 873 915 885 870 909 ... slowest runs (cycles): ... 957 963 963 966 972 984 987 999 1053 1671 min: 744 cycles q1: 873 cycles median: 912 cycles q3: 933 cycles max: 1671 cycles RESULT TestCondvarSignalNoOp_CycleCount: x86-64_with_irt_nnacl_newlib_static= {912, 60} count Apparent clock speed: 4428 MHz TestThreadCreateAndJoin: Measuring real time: 71.516 usec (7.15156e-05 sec) per iteration: 0.00715156 sec for 100 iterations 46.559 usec (4.65592e-05 sec) per iteration: 0.0650898 sec for 1398 iterations 46.845 usec (4.68449e-05 sec) per iteration: 0.0654892 sec for 1398 iterations 45.759 usec (4.57591e-05 sec) per iteration: 0.0639713 sec for 1398 iterations 45.730 usec (4.57296e-05 sec) per iteration: 0.06393 sec for 1398 iterations 46.394 usec (4.63944e-05 sec) per iteration: 0.0648594 sec for 1398 iterations mean: 46.257445 usec stddev: 0.443137 usec relative stddev: 0.96% RESULT TestThreadCreateAndJoin: x86-64_with_irt_nnacl_newlib_static= {46.257445, 0.443137} us Measuring clock cycles: first runs (cycles): 137151 250302 177060 194919 208497 152391 139248 140871 137967 131295 ... slowest runs (cycles): ... 157161 157524 177060 194919 202017 207495 208497 250302 294048 296619 min: 129267 cycles q1: 131637 cycles median: 136071 cycles q3: 140871 cycles max: 296619 cycles RESULT TestThreadCreateAndJoin_CycleCount: x86-64_with_irt_nnacl_newlib_static= {136071, 9234} count Apparent clock speed: 2942 MHz TestThreadWakeup: Measuring real time: 12.223 usec (1.2223e-05 sec) per iteration: 0.0012223 sec for 100 iterations 9.759 usec (9.75883e-06 sec) per iteration: 0.079837 sec for 8181 iterations 9.726 usec (9.72596e-06 sec) per iteration: 0.0795681 sec for 8181 iterations 9.708 usec (9.70804e-06 sec) per iteration: 0.0794215 sec for 8181 iterations 10.595 usec (1.05946e-05 sec) per iteration: 0.0866743 sec for 8181 iterations 9.799 usec (9.79882e-06 sec) per iteration: 0.0801641 sec for 8181 iterations mean: 9.917250 usec stddev: 0.340079 usec relative stddev: 3.43% RESULT TestThreadWakeup: x86-64_with_irt_nnacl_newlib_static= {9.917250, 0.340079} us Measuring clock cycles: first runs (cycles): 57273 51864 34884 52203 51132 40380 159294 158517 119430 34179 ... slowest runs (cycles): ... 34179 34884 40380 51132 51864 52203 57273 119430 158517 159294 min: 27687 cycles q1: 28146 cycles median: 28563 cycles q3: 29157 cycles max: 159294 cycles RESULT TestThreadWakeup_CycleCount: x86-64_with_irt_nnacl_newlib_static= {28563, 1011} count Apparent clock speed: 2880 MHz TestCatchingFault: Measuring real time: 16.249 usec (1.62489e-05 sec) per iteration: 0.00162489 sec for 100 iterations 14.188 usec (1.41885e-05 sec) per iteration: 0.0873157 sec for 6154 iterations 14.176 usec (1.4176e-05 sec) per iteration: 0.0872388 sec for 6154 iterations 14.124 usec (1.41241e-05 sec) per iteration: 0.08692 sec for 6154 iterations 16.627 usec (1.66269e-05 sec) per iteration: 0.102322 sec for 6154 iterations 14.652 usec (1.46517e-05 sec) per iteration: 0.0901667 sec for 6154 iterations mean: 14.753435 usec stddev: 0.955922 usec relative stddev: 6.48% RESULT TestCatchingFault: x86-64_with_irt_nnacl_newlib_static= {14.753435, 0.955922} us Measuring clock cycles: first runs (cycles): 64377 54954 47550 86565 51210 89169 66411 67695 62172 78123 ... slowest runs (cycles): ... 54954 62172 64377 66411 67392 67695 78123 79236 86565 89169 min: 41718 cycles q1: 42087 cycles median: 42291 cycles q3: 43284 cycles max: 89169 cycles RESULT TestCatchingFault_CycleCount: x86-64_with_irt_nnacl_newlib_static= {42291, 1197} count Apparent clock speed: 2867 MHz TestThreadCreateAndJoinAfterSettingFaultHandler: Measuring real time: 47.333 usec (4.7333e-05 sec) per iteration: 0.0047333 sec for 100 iterations 46.287 usec (4.62874e-05 sec) per iteration: 0.097759 sec for 2112 iterations 46.578 usec (4.65785e-05 sec) per iteration: 0.0983737 sec for 2112 iterations 46.343 usec (4.63429e-05 sec) per iteration: 0.0978763 sec for 2112 iterations 46.906 usec (4.69062e-05 sec) per iteration: 0.0990658 sec for 2112 iterations 46.294 usec (4.6294e-05 sec) per iteration: 0.097773 sec for 2112 iterations mean: 46.481796 usec stddev: 0.237388 usec relative stddev: 0.51% RESULT TestThreadCreateAndJoinAfterSettingFaultHandler: x86-64_with_irt_nnacl_newlib_static= {46.481796, 0.237388} us Measuring clock cycles: first runs (cycles): 139617 236991 208269 205059 210510 189432 155058 146472 143166 132591 ... slowest runs (cycles): ... 189453 190731 193401 204999 205059 208269 210510 236991 294840 296133 min: 128853 cycles q1: 132630 cycles median: 137034 cycles q3: 143166 cycles max: 296133 cycles RESULT TestThreadCreateAndJoinAfterSettingFaultHandler_CycleCount: x86-64_with_irt_nnacl_newlib_static= {137034, 10536} count Apparent clock speed: 2948 MHz [ OK ] nacl_newlib.run_performance_test_irt (5940 ms) scons: done building targets. ********************************************************************** COMMAND EXECUTION REPORT ********************************************************************** 3 command_tester.py 1 doSizeCheck ********************************************************************** ENVIRONMENT USAGE REPORT ********************************************************************** 4 nacl_irt_test-x86-64 Command return code: 0