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,opt-host,nacl_irt_test platform=x86-64 --clang bitcode=1 skip_trusted_tests=1 large_tests_irt scons: Reading SConscript files ... ====================================================================== SCONS ARGS:['scons.py', '--verbose', '-k', '-j1', '--mode=nacl,opt-host,nacl_irt_test', 'platform=x86-64', '--clang', 'bitcode=1', 'skip_trusted_tests=1', '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.5.0 kern.osrevision: 199506 kern.version: Darwin Kernel Version 17.5.0: Mon Mar 5 22:24:32 PST 2018; root:xnu-4570.51.1~1/RELEASE_X86_64 kern.posix1version: 200112 kern.osversion: 17E199 kern.osproductversion: 10.13.4 ====================================================================== CPU: ====================================================================== hw.machine: x86_64 hw.model: VMware7,1 hw.ncpu: 8 hw.ncpu: 8 hw.activecpu: 8 hw.physicalcpu: 8 hw.physicalcpu_max: 8 hw.logicalcpu: 8 hw.logicalcpu_max: 8 hw.cputype: 7 hw.cpusubtype: 4 hw.cpu64bit_capable: 1 hw.cpufamily: 526772277 hw.cpufrequency: 2574000000 hw.cpufrequency_min: 2574000000 hw.cpufrequency_max: 2574000000 ====================================================================== RAM: ====================================================================== hw.memsize: 17179869184 ====================================================================== LOAD: ====================================================================== TBD ====================================================================== UPTIME: ====================================================================== kern.boottime: { sec = 1544200471, usec = 196703 } Fri Dec 7 08:34:31 2018 ====================================================================== The following environments have been configured ====================================================================== NACL_BUILD_FAMILY: UNTRUSTED BUILD_TYPE: nacl TARGET_ROOT: /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl-x86-64-pnacl-pexe-clang OBJ_ROOT: /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl-x86-64-pnacl-pexe-clang/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/kitchen-workdir/native_client/toolchain/mac_x86/pnacl_newlib_raw/bin/pnacl-clang -std=gnu99 ASPPCOM: /b/s/w/ir/kitchen-workdir/native_client/toolchain/mac_x86/pnacl_newlib_raw/bin/pnacl-clang -std=gnu99 -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/kitchen-workdir/native_client/scons-out/nacl-x86-64-pnacl-pexe-clang/include -I/b/s/w/ir/kitchen-workdir -c -o UNKNOWN COMPILER NACL_BUILD_FAMILY: TRUSTED BUILD_TYPE: opt-mac TARGET_ROOT: /b/s/w/ir/kitchen-workdir/native_client/scons-out/opt-mac-x86-64 OBJ_ROOT: /b/s/w/ir/kitchen-workdir/native_client/scons-out/opt-mac-x86-64/obj BUILD_TYPE_DESCRIPTION: MacOS opt build BUILD_OS: BUILD_ARCHITECTURE: x86 BUILD_SUBARCH: 64 TARGET_OS: TARGET_ARCHITECTURE: x86 TARGET_SUBARCH: 64 CC: /b/s/w/ir/kitchen-workdir/third_party/llvm-build/Release+Asserts/bin/clang ASPPCOM: /b/s/w/ir/kitchen-workdir/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 -DNDEBUG -I/b/s/w/ir/kitchen-workdir -c -o UNKNOWN COMPILER NACL_BUILD_FAMILY: UNTRUSTED_IRT_TESTS BUILD_TYPE: nacl_irt_test TARGET_ROOT: /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl_irt_test-x86-64-pnacl-pexe-clang OBJ_ROOT: /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl_irt_test-x86-64-pnacl-pexe-clang/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/kitchen-workdir/native_client/toolchain/mac_x86/pnacl_newlib_raw/bin/pnacl-clang -std=gnu99 ASPPCOM: /b/s/w/ir/kitchen-workdir/native_client/toolchain/mac_x86/pnacl_newlib_raw/bin/pnacl-clang -std=gnu99 -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-pnacl-pexe-clang/include -I/b/s/w/ir/kitchen-workdir -c -o UNKNOWN COMPILER NACL_BUILD_FAMILY: UNTRUSTED_IRT BUILD_TYPE: nacl_irt TARGET_ROOT: /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl_irt-x86-64 OBJ_ROOT: /b/s/w/ir/kitchen-workdir/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/kitchen-workdir/native_client/toolchain/mac_x86/pnacl_newlib_raw/bin/x86_64-nacl-clang ASPPCOM: /b/s/w/ir/kitchen-workdir/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/kitchen-workdir/native_client/scons-out/nacl_irt-x86-64/include -I/b/s/w/ir/kitchen-workdir -I/b/s/w/ir/kitchen-workdir/native_client/src/untrusted/pthread -c -o UNKNOWN COMPILER *** BROKEN run_ncval_annotate_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_initfini_static_test *** SKIPPING opt-mac-64 : run_package_version_tests *** SKIPPING opt-mac-64 : run_pynacl_tests *** SKIPPING opt-mac-64 : run_gio_test *** SKIPPING opt-mac-64 : run_gprintf_test *** SKIPPING opt-mac-64 : run_sigpipe_test *** SKIPPING opt-mac-64 : run_platform_tests *** SKIPPING opt-mac-64 : run_nacl_semaphore_test *** SKIPPING opt-mac-64 : run_nacl_host_dir_test *** SKIPPING opt-mac-64 : run_nacl_clock_test *** SKIPPING opt-mac-64 : run_nacl_clock_cputime_test *** SKIPPING opt-mac-64 : run_nacl_sync_lock_lock_test *** SKIPPING opt-mac-64 : run_nacl_sync_lock_trylock_test *** SKIPPING opt-mac-64 : run_nacl_sync_trylock_lock_test *** SKIPPING opt-mac-64 : run_nacl_sync_trylock_trylock_test *** SKIPPING opt-mac-64 : run_nacl_host_desc_mmap_test *** SKIPPING opt-mac-64 : run_nacl_host_desc_pread_pwrite_test *** SKIPPING opt-mac-64 : run_nacl_host_desc_big_file_test *** SKIPPING opt-mac-64 : run_cpu_x86_test *** SKIPPING opt-mac-64 : run_gdb_rsp_tests *** SKIPPING opt-mac-64 : run_transport_ipc_test *** SKIPPING opt-mac-64 : run_nacl_desc_quota_test *** SKIPPING opt-mac-64 : run_metadata_test *** SKIPPING opt-mac-64 : run_nacl_desc_io_alloc_ctor_test *** SKIPPING opt-mac-64 : run_nacl_fi_test *** SKIPPING opt-mac-64 : run_nacl_interval_list_test *** SKIPPING opt-mac-64 : run_nacl_interval_tree_test *** SKIPPING opt-mac-64 : run_nacl_interval_list_random_test *** SKIPPING opt-mac-64 : run_nacl_interval_tree_random_test *** SKIPPING opt-mac-64 : run_nacl_interval_multi_test *** SKIPPING opt-mac-64 : run_nacl_interval_multi_reg_test *** SKIPPING opt-mac-64 : run_nacl_base_test *** SKIPPING opt-mac-64 : run_nacl_min_max_test *** SKIPPING opt-mac-64 : run_nacl_min_max_cpp_test *** SKIPPING opt-mac-64 : run_nacl_perf_counter_test *** SKIPPING opt-mac-64 : run_platform_qual_test *** SKIPPING opt-mac-64 : run_cpuwhitelist_test *** SKIPPING opt-mac-64 : run_service_runtime_tests *** SKIPPING opt-mac-64 : run_format_string_test *** SKIPPING opt-mac-64 : run_trusted_mmap_test *** BROKEN run_nacl_sync_cond_test *** SKIPPING opt-mac-64 : run_env_cleanser_test *** SKIPPING opt-mac-64 : run_nacl_resource_test *** SKIPPING opt-mac-64 : run_check_test *** SKIPPING opt-mac-64 : run_check_test_death *** SKIPPING opt-mac-64 : run_dcheck_test_death *** SKIPPING opt-mac-64 : run_check_test_always_death *** SKIPPING opt-mac-64 : run_check_test_always_death_abort *** SKIPPING opt-mac-64 : run_dcheck_test_never_death *** SKIPPING opt-mac-64 : run_dcheck_test_always_death *** SKIPPING opt-mac-64 : run_sel_ldr_exe_not_found_test *** SKIPPING opt-mac-64 : run_fuzz_nullptr_test *** SKIPPING opt-mac-64 : run_unaligned_data_test *** SKIPPING opt-mac-64 : run_unaligned_data_irt_test *** SKIPPING opt-mac-64 : run_hello_x32_test *** SKIPPING opt-mac-64 : run_service_runtime_hello_world_test *** SKIPPING opt-mac-64 : run_old_abi_death_test *** SKIPPING opt-mac-64 : run_integer_overflow_while_madvising_death_test *** SKIPPING opt-mac-64 : run_negative_hole_death_test *** SKIPPING opt-mac-64 : run_rodata_data_overlap_death_test *** SKIPPING opt-mac-64 : run_data_not_last_death_test SKIPPING test text_overlaps_rodata SKIPPING test text_overlaps_data *** SKIPPING opt-mac-64 : run_text_too_big_death_test *** SKIPPING opt-mac-64 : run_sel_ldr_thread_death_test *** SKIPPING opt-mac-64 : run_nacl_error_gio_test *** SKIPPING opt-mac-64 : run_nacl_error_log_test *** SKIPPING opt-mac-64 : run_dyn_array_test *** SKIPPING opt-mac-64 : run_validation_cache_test *** SKIPPING opt-mac-64 : run_validator_debug_stub_test *** SKIPPING opt-mac-64 : run_disable_nontemporals_test *** SKIPPING opt-mac-64 : run_validation_rewrite_test *** SKIPPING opt-mac-64 : run_gen_dfa_test *** SKIPPING opt-mac-64 : run_trie_test *** SKIPPING opt-mac-64 : run_proof_tools_test *** SKIPPING opt-mac-64 : run_validator_py_test *** SKIPPING opt-mac-64 : run_rdfa_targeted_tests_32 *** SKIPPING opt-mac-64 : run_dis_section_test_32 *** SKIPPING opt-mac-64 : run_spec_val_test_32 *** SKIPPING opt-mac-64 : run_rdfa_targeted_tests_64 *** SKIPPING opt-mac-64 : run_dis_section_test_64 *** SKIPPING opt-mac-64 : run_spec_val_test_64 *** SKIPPING opt-mac-64 : run_nacl_file_lock_all_test *** SKIPPING opt-mac-64 : run_nacl_file_lock_any_test *** SKIPPING opt-mac-64 : run_nacl_file_lock_t3f2_test *** SKIPPING opt-mac-64 : run_nacl_file_lock_t3f3_test *** SKIPPING opt-mac-64 : run_nacl_file_lock_all_real_test *** SKIPPING opt-mac-64 : run_nacl_file_lock_any_real_test *** SKIPPING opt-mac-64 : run_nacl_file_lock_t3f2_real_test *** SKIPPING opt-mac-64 : run_nacl_file_lock_t3f3_real_test *** SKIPPING opt-mac-64 : run_trusted_performance_test *** SKIPPING opt-mac-64 : run_python_version_test *** SKIPPING opt-mac-64 : run_tool_tests *** SKIPPING opt-mac-64 : run_nacl_close_test *** SKIPPING opt-mac-64 : run_double_nacl_close_test *** SKIPPING opt-mac-64 : run_nacl_create_memory_object_test *** SKIPPING opt-mac-64 : run_nacl_thread_create_joinable_test *** SKIPPING opt-mac-64 : run_atomic_ops_test *** SKIPPING opt-mac-64 : run_bits_test *** SKIPPING opt-mac-64 : run_kernel_version_test *** SKIPPING opt-mac-64 : run_nacl_memory_test *** SKIPPING opt-mac-64 : run_toolchain_python_tests *** 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_initfini_static_test_irt *** SKIPPING nacl_irt-64 : run_irt_thread_test There are 14 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 pnacl_newlib.run_benchmark_test_irt --time_warning 10 --time_error 100 --perf_env_description x86-64_with_irt_pnacl_newlib_static --subarch 64 --arch x86 --capture_output 0 --output_stamp /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl_irt_test-x86-64-pnacl-pexe-clang/test_results/benchmark_test.out scons-out/opt-mac-x86-64/staging/sel_ldr -B scons-out/nacl_irt-x86-64/staging/irt_core.nexe -- scons-out/nacl_irt_test-x86-64-pnacl-pexe-clang/obj/tests/benchmark/benchmark_test.nexe x86-64_with_irt_pnacl_newlib_static [ RUN ] pnacl_newlib.run_benchmark_test_irt scons-out/opt-mac-x86-64/staging/sel_ldr -B scons-out/nacl_irt-x86-64/staging/irt_core.nexe -- scons-out/nacl_irt_test-x86-64-pnacl-pexe-clang/obj/tests/benchmark/benchmark_test.nexe x86-64_with_irt_pnacl_newlib_static [45056,2528035712:12:26:52.384671] Native Client module will be loaded at base address 0x00005d9300000000 Running suite of 1 benchmarks: Running Benchmark: Life (SIMD version)... RESULT BenchmarkLife: x86-64_with_irt_pnacl_newlib_static= {0.049050, 0.002490} seconds --------------------------------------------------------------- Done running benchmark suite. [ OK ] pnacl_newlib.run_benchmark_test_irt (780 ms) /b/s/w/ir/cache/vpython/7c7ecd/bin/python tools/command_tester.py --name pnacl_newlib.run_clock_cputime_test_irt --time_warning 60 --time_error 600 --perf_env_description x86-64_with_irt_pnacl_newlib_static --subarch 64 --arch x86 --output_stamp /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl_irt_test-x86-64-pnacl-pexe-clang/test_results/clock_cputime_test.out scons-out/opt-mac-x86-64/staging/sel_ldr -B scons-out/nacl_irt-x86-64/staging/irt_core.nexe -- scons-out/nacl_irt_test-x86-64-pnacl-pexe-clang/obj/tests/clock/clock_test.nexe -c [ RUN ] pnacl_newlib.run_clock_cputime_test_irt scons-out/opt-mac-x86-64/staging/sel_ldr -B scons-out/nacl_irt-x86-64/staging/irt_core.nexe -- scons-out/nacl_irt_test-x86-64-pnacl-pexe-clang/obj/tests/clock/clock_test.nexe -c WARNING: should have taken less than 60.000000 secs [ OK ] pnacl_newlib.run_clock_cputime_test_irt (66220 ms) doSizeCheck(["scons-out/nacl_irt_test-x86-64-pnacl-pexe-clang/obj/tests/hello_world/hello_world_size.out"], ["scons-out/nacl_irt_test-x86-64-pnacl-pexe-clang/obj/tests/hello_world/hello_world.nonfinal.pexe"]) RESULT hello_world_size.out: x86-64_with_irt_pnacl_newlib_static= 359.402 KB RESULT hello_world_size.out: ZIPPED_x86-64_with_irt_pnacl_newlib_static= 239.881 KB /b/s/w/ir/cache/vpython/7c7ecd/bin/python tools/command_tester.py --name pnacl_newlib.run_performance_test_irt --time_warning 10 --time_error 100 --perf_env_description x86-64_with_irt_pnacl_newlib_static --subarch 64 --arch x86 --capture_output 0 --output_stamp /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl_irt_test-x86-64-pnacl-pexe-clang/test_results/performance_test.out scons-out/opt-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-pnacl-pexe-clang/obj/tests/performance/performance_test.nexe x86-64_with_irt_pnacl_newlib_static [ RUN ] pnacl_newlib.run_performance_test_irt scons-out/opt-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-pnacl-pexe-clang/obj/tests/performance/performance_test.nexe x86-64_with_irt_pnacl_newlib_static [45061,2528035712:12:27:06.422163] Native Client module will be loaded at base address 0x00000e8800000000 TestNull: Measuring real time: 0.008 usec (7.84e-09 sec) per iteration: 7.84e-07 sec for 100 iterations 0.003 usec (2.568e-09 sec) per iteration: 2.568e-06 sec for 1000 iterations 0.002 usec (2.3595e-09 sec) per iteration: 2.3595e-05 sec for 10000 iterations 0.002 usec (2.06638e-09 sec) per iteration: 0.087577 sec for 42381860 iterations 0.002 usec (2.03235e-09 sec) per iteration: 0.086135 sec for 42381860 iterations 0.002 usec (2.08163e-09 sec) per iteration: 0.0882232 sec for 42381860 iterations 0.002 usec (2.01835e-09 sec) per iteration: 0.0855413 sec for 42381860 iterations 0.002 usec (2.06976e-09 sec) per iteration: 0.0877203 sec for 42381860 iterations mean: 0.002054 usec stddev: 0.000024 usec relative stddev: 1.17% RESULT TestNull: x86-64_with_irt_pnacl_newlib_static= {0.002054, 0.000024} us TestNaClSyscall: Measuring real time: 0.157 usec (1.571e-07 sec) per iteration: 1.571e-05 sec for 100 iterations 0.151 usec (1.5116e-07 sec) per iteration: 0.0962192 sec for 636537 iterations 0.148 usec (1.47621e-07 sec) per iteration: 0.0939663 sec for 636537 iterations 0.149 usec (1.49171e-07 sec) per iteration: 0.094953 sec for 636537 iterations 0.149 usec (1.48757e-07 sec) per iteration: 0.0946896 sec for 636537 iterations 0.148 usec (1.48442e-07 sec) per iteration: 0.0944885 sec for 636537 iterations mean: 0.149030 usec stddev: 0.001180 usec relative stddev: 0.79% RESULT TestNaClSyscall: x86-64_with_irt_pnacl_newlib_static= {0.149030, 0.001180} us TestSetjmpLongjmp: Measuring real time: 0.018 usec (1.755e-08 sec) per iteration: 1.755e-06 sec for 100 iterations 0.012 usec (1.2295e-08 sec) per iteration: 1.2295e-05 sec for 1000 iterations 0.012 usec (1.19322e-08 sec) per iteration: 0.0970495 sec for 8133387 iterations 0.012 usec (1.189e-08 sec) per iteration: 0.0967061 sec for 8133387 iterations 0.012 usec (1.20191e-08 sec) per iteration: 0.097756 sec for 8133387 iterations 0.012 usec (1.18617e-08 sec) per iteration: 0.0964755 sec for 8133387 iterations 0.012 usec (1.18262e-08 sec) per iteration: 0.0961873 sec for 8133387 iterations mean: 0.011906 usec stddev: 0.000066 usec relative stddev: 0.56% RESULT TestSetjmpLongjmp: x86-64_with_irt_pnacl_newlib_static= {0.011906, 0.000066} us TestClockGetTime: Measuring real time: 0.164 usec (1.641e-07 sec) per iteration: 1.641e-05 sec for 100 iterations 0.158 usec (1.58145e-07 sec) per iteration: 0.0963712 sec for 609384 iterations 0.158 usec (1.58467e-07 sec) per iteration: 0.0965676 sec for 609384 iterations 0.159 usec (1.59026e-07 sec) per iteration: 0.096908 sec for 609384 iterations 0.157 usec (1.57089e-07 sec) per iteration: 0.0957274 sec for 609384 iterations 0.161 usec (1.60598e-07 sec) per iteration: 0.0978661 sec for 609384 iterations mean: 0.158665 usec stddev: 0.001154 usec relative stddev: 0.73% RESULT TestClockGetTime: x86-64_with_irt_pnacl_newlib_static= {0.158665, 0.001154} us TestTlsVariable: Measuring real time: 0.010 usec (9.53e-09 sec) per iteration: 9.53e-07 sec for 100 iterations 0.011 usec (1.0727e-08 sec) per iteration: 1.0727e-05 sec for 1000 iterations 0.006 usec (5.77176e-09 sec) per iteration: 0.0538059 sec for 9322270 iterations 0.006 usec (5.79492e-09 sec) per iteration: 0.0540218 sec for 9322270 iterations 0.006 usec (5.85582e-09 sec) per iteration: 0.0545895 sec for 9322270 iterations 0.006 usec (5.97288e-09 sec) per iteration: 0.0556808 sec for 9322270 iterations 0.006 usec (6.02826e-09 sec) per iteration: 0.0561971 sec for 9322270 iterations mean: 0.005885 usec stddev: 0.000100 usec relative stddev: 1.70% RESULT TestTlsVariable: x86-64_with_irt_pnacl_newlib_static= {0.005885, 0.000100} us TestMmapAnonymous: Measuring real time: 8.968 usec (8.968e-06 sec) per iteration: 0.0008968 sec for 100 iterations 8.649 usec (8.64865e-06 sec) per iteration: 0.0964324 sec for 11150 iterations 8.555 usec (8.55506e-06 sec) per iteration: 0.095389 sec for 11150 iterations 8.790 usec (8.78999e-06 sec) per iteration: 0.0980084 sec for 11150 iterations 8.495 usec (8.49466e-06 sec) per iteration: 0.0947155 sec for 11150 iterations 8.607 usec (8.60733e-06 sec) per iteration: 0.0959717 sec for 11150 iterations mean: 8.619139 usec stddev: 0.099801 usec relative stddev: 1.16% RESULT TestMmapAnonymous: x86-64_with_irt_pnacl_newlib_static= {8.619139, 0.099801} us TestAtomicIncrement: Measuring real time: 0.016 usec (1.585e-08 sec) per iteration: 1.585e-06 sec for 100 iterations 0.010 usec (1.0143e-08 sec) per iteration: 1.0143e-05 sec for 1000 iterations 0.010 usec (9.6711e-09 sec) per iteration: 0.0953475 sec for 9859016 iterations 0.010 usec (9.96931e-09 sec) per iteration: 0.0982876 sec for 9859016 iterations 0.010 usec (9.64533e-09 sec) per iteration: 0.0950934 sec for 9859016 iterations 0.010 usec (9.63895e-09 sec) per iteration: 0.0950306 sec for 9859016 iterations 0.011 usec (1.08271e-08 sec) per iteration: 0.106744 sec for 9859016 iterations mean: 0.009950 usec stddev: 0.000455 usec relative stddev: 4.58% RESULT TestAtomicIncrement: x86-64_with_irt_pnacl_newlib_static= {0.009950, 0.000455} us TestUncontendedMutexLock: Measuring real time: 0.028 usec (2.793e-08 sec) per iteration: 2.793e-06 sec for 100 iterations 0.024 usec (2.3956e-08 sec) per iteration: 2.3956e-05 sec for 1000 iterations 0.023 usec (2.34527e-08 sec) per iteration: 0.0978992 sec for 4174319 iterations 0.024 usec (2.35793e-08 sec) per iteration: 0.0984277 sec for 4174319 iterations 0.023 usec (2.30743e-08 sec) per iteration: 0.0963196 sec for 4174319 iterations 0.023 usec (2.34148e-08 sec) per iteration: 0.0977408 sec for 4174319 iterations 0.023 usec (2.30044e-08 sec) per iteration: 0.0960278 sec for 4174319 iterations mean: 0.023305 usec stddev: 0.000225 usec relative stddev: 0.96% RESULT TestUncontendedMutexLock: x86-64_with_irt_pnacl_newlib_static= {0.023305, 0.000225} us TestCondvarSignalNoOp: Measuring real time: 0.296 usec (2.9646e-07 sec) per iteration: 2.9646e-05 sec for 100 iterations 0.154 usec (1.53975e-07 sec) per iteration: 0.0519378 sec for 337313 iterations 0.155 usec (1.5538e-07 sec) per iteration: 0.0524117 sec for 337313 iterations 0.156 usec (1.556e-07 sec) per iteration: 0.0524858 sec for 337313 iterations 0.153 usec (1.53159e-07 sec) per iteration: 0.0516625 sec for 337313 iterations 0.154 usec (1.53737e-07 sec) per iteration: 0.0518576 sec for 337313 iterations mean: 0.154370 usec stddev: 0.000954 usec relative stddev: 0.62% RESULT TestCondvarSignalNoOp: x86-64_with_irt_pnacl_newlib_static= {0.154370, 0.000954} us TestThreadCreateAndJoin: Measuring real time: 69.050 usec (6.90495e-05 sec) per iteration: 0.00690495 sec for 100 iterations 65.379 usec (6.53794e-05 sec) per iteration: 0.0946693 sec for 1448 iterations 64.351 usec (6.43509e-05 sec) per iteration: 0.0931801 sec for 1448 iterations 67.623 usec (6.76234e-05 sec) per iteration: 0.0979187 sec for 1448 iterations 68.261 usec (6.82612e-05 sec) per iteration: 0.0988423 sec for 1448 iterations 71.731 usec (7.17311e-05 sec) per iteration: 0.103867 sec for 1448 iterations mean: 67.469201 usec stddev: 2.565387 usec relative stddev: 3.80% RESULT TestThreadCreateAndJoin: x86-64_with_irt_pnacl_newlib_static= {67.469201, 2.565387} us TestThreadWakeup: Measuring real time: 32.998 usec (3.29985e-05 sec) per iteration: 0.00329985 sec for 100 iterations 29.940 usec (2.99402e-05 sec) per iteration: 0.0907189 sec for 3030 iterations 29.401 usec (2.94007e-05 sec) per iteration: 0.0890842 sec for 3030 iterations 30.619 usec (3.06195e-05 sec) per iteration: 0.092777 sec for 3030 iterations 30.373 usec (3.03734e-05 sec) per iteration: 0.0920313 sec for 3030 iterations 30.936 usec (3.09355e-05 sec) per iteration: 0.0937347 sec for 3030 iterations mean: 30.253867 usec stddev: 0.536441 usec relative stddev: 1.77% RESULT TestThreadWakeup: x86-64_with_irt_pnacl_newlib_static= {30.253867, 0.536441} us TestCatchingFault: Measuring real time: 33.437 usec (3.34366e-05 sec) per iteration: 0.00334366 sec for 100 iterations 31.142 usec (3.11421e-05 sec) per iteration: 0.0931148 sec for 2990 iterations 31.051 usec (3.10506e-05 sec) per iteration: 0.0928412 sec for 2990 iterations 30.880 usec (3.08803e-05 sec) per iteration: 0.0923322 sec for 2990 iterations 30.830 usec (3.08302e-05 sec) per iteration: 0.0921822 sec for 2990 iterations 30.824 usec (3.08237e-05 sec) per iteration: 0.0921629 sec for 2990 iterations mean: 30.945370 usec stddev: 0.128103 usec relative stddev: 0.41% RESULT TestCatchingFault: x86-64_with_irt_pnacl_newlib_static= {30.945370, 0.128103} us TestThreadCreateAndJoinAfterSettingFaultHandler: Measuring real time: 64.499 usec (6.44988e-05 sec) per iteration: 0.00644988 sec for 100 iterations 63.731 usec (6.37309e-05 sec) per iteration: 0.0987828 sec for 1550 iterations 63.809 usec (6.38086e-05 sec) per iteration: 0.0989033 sec for 1550 iterations 64.372 usec (6.43719e-05 sec) per iteration: 0.0997764 sec for 1550 iterations 64.580 usec (6.45802e-05 sec) per iteration: 0.100099 sec for 1550 iterations 63.739 usec (6.37389e-05 sec) per iteration: 0.0987952 sec for 1550 iterations mean: 64.046086 usec stddev: 0.358222 usec relative stddev: 0.56% RESULT TestThreadCreateAndJoinAfterSettingFaultHandler: x86-64_with_irt_pnacl_newlib_static= {64.046086, 0.358222} us [ OK ] pnacl_newlib.run_performance_test_irt (6110 ms) scons: done building targets. ********************************************************************** COMMAND EXECUTION REPORT ********************************************************************** 3 command_tester.py 1 doSizeCheck ********************************************************************** ENVIRONMENT USAGE REPORT ********************************************************************** 4 nacl_irt_test-x86-64-pnacl-pexe-clang Command return code: 0