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 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', '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.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 = 1547805457, usec = 125033 } Fri Jan 18 01:57:37 2019 ====================================================================== 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 [60704,2729120640:06:41:56.481738] Native Client module will be loaded at base address 0x0000283c00000000 Running suite of 1 benchmarks: Running Benchmark: Life (SIMD version)... RESULT BenchmarkLife: x86-64_with_irt_pnacl_newlib_static= {0.124790, 0.003050} seconds --------------------------------------------------------------- Done running benchmark suite. [ OK ] pnacl_newlib.run_benchmark_test_irt (1270 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 (67110 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= 358.977 KB RESULT hello_world_size.out: ZIPPED_x86-64_with_irt_pnacl_newlib_static= 239.559 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 [60714,2729120640:06:42:16.523752] Native Client module will be loaded at base address 0x0000358a00000000 TestNull: Measuring real time: 0.006 usec (5.64e-09 sec) per iteration: 5.64e-07 sec for 100 iterations 0.002 usec (1.927e-09 sec) per iteration: 1.927e-06 sec for 1000 iterations 0.002 usec (1.7894e-09 sec) per iteration: 1.7894e-05 sec for 10000 iterations 0.001 usec (1.48693e-09 sec) per iteration: 0.0830963 sec for 55884654 iterations 0.001 usec (1.47291e-09 sec) per iteration: 0.082313 sec for 55884654 iterations 0.001 usec (1.44263e-09 sec) per iteration: 0.0806206 sec for 55884654 iterations 0.001 usec (1.49908e-09 sec) per iteration: 0.0837758 sec for 55884654 iterations 0.001 usec (1.48927e-09 sec) per iteration: 0.0832276 sec for 55884654 iterations mean: 0.001478 usec stddev: 0.000020 usec relative stddev: 1.33% RESULT TestNull: x86-64_with_irt_pnacl_newlib_static= {0.001478, 0.000020} us TestNaClSyscall: Measuring real time: 0.110 usec (1.1017e-07 sec) per iteration: 1.1017e-05 sec for 100 iterations 0.102 usec (1.02296e-07 sec) per iteration: 0.0928528 sec for 907688 iterations 0.104 usec (1.03665e-07 sec) per iteration: 0.0940957 sec for 907688 iterations 0.102 usec (1.02349e-07 sec) per iteration: 0.0929009 sec for 907688 iterations 0.103 usec (1.02669e-07 sec) per iteration: 0.0931915 sec for 907688 iterations 0.102 usec (1.02158e-07 sec) per iteration: 0.0927275 sec for 907688 iterations mean: 0.102627 usec stddev: 0.000545 usec relative stddev: 0.53% RESULT TestNaClSyscall: x86-64_with_irt_pnacl_newlib_static= {0.102627, 0.000545} us TestSetjmpLongjmp: Measuring real time: 0.015 usec (1.485e-08 sec) per iteration: 1.485e-06 sec for 100 iterations 0.011 usec (1.1161e-08 sec) per iteration: 1.1161e-05 sec for 1000 iterations 0.011 usec (1.09724e-08 sec) per iteration: 0.0983099 sec for 8959770 iterations 0.011 usec (1.09332e-08 sec) per iteration: 0.0979587 sec for 8959770 iterations 0.011 usec (1.09584e-08 sec) per iteration: 0.0981851 sec for 8959770 iterations 0.011 usec (1.09651e-08 sec) per iteration: 0.0982451 sec for 8959770 iterations 0.011 usec (1.09386e-08 sec) per iteration: 0.0980072 sec for 8959770 iterations mean: 0.010954 usec stddev: 0.000015 usec relative stddev: 0.14% RESULT TestSetjmpLongjmp: x86-64_with_irt_pnacl_newlib_static= {0.010954, 0.000015} us TestClockGetTime: Measuring real time: 0.162 usec (1.6167e-07 sec) per iteration: 1.6167e-05 sec for 100 iterations 0.159 usec (1.58675e-07 sec) per iteration: 0.0981476 sec for 618543 iterations 0.158 usec (1.58104e-07 sec) per iteration: 0.097794 sec for 618543 iterations 0.159 usec (1.58718e-07 sec) per iteration: 0.098174 sec for 618543 iterations 0.158 usec (1.57774e-07 sec) per iteration: 0.0975899 sec for 618543 iterations 0.159 usec (1.58855e-07 sec) per iteration: 0.0982587 sec for 618543 iterations mean: 0.158425 usec stddev: 0.000415 usec relative stddev: 0.26% RESULT TestClockGetTime: x86-64_with_irt_pnacl_newlib_static= {0.158425, 0.000415} us TestTlsVariable: Measuring real time: 0.009 usec (9.08e-09 sec) per iteration: 9.08e-07 sec for 100 iterations 0.006 usec (6.207e-09 sec) per iteration: 6.207e-06 sec for 1000 iterations 0.006 usec (6.0302e-09 sec) per iteration: 6.0302e-05 sec for 10000 iterations 0.006 usec (6.03029e-09 sec) per iteration: 0.100001 sec for 16583197 iterations 0.006 usec (6.04025e-09 sec) per iteration: 0.100167 sec for 16583197 iterations 0.006 usec (6.02251e-09 sec) per iteration: 0.0998725 sec for 16583197 iterations 0.006 usec (6.05291e-09 sec) per iteration: 0.100377 sec for 16583197 iterations 0.006 usec (6.02146e-09 sec) per iteration: 0.099855 sec for 16583197 iterations mean: 0.006033 usec stddev: 0.000012 usec relative stddev: 0.20% RESULT TestTlsVariable: x86-64_with_irt_pnacl_newlib_static= {0.006033, 0.000012} us TestMmapAnonymous: Measuring real time: 5.965 usec (5.96502e-06 sec) per iteration: 0.000596502 sec for 100 iterations 5.003 usec (5.00346e-06 sec) per iteration: 0.083878 sec for 16764 iterations 4.956 usec (4.95559e-06 sec) per iteration: 0.0830755 sec for 16764 iterations 5.060 usec (5.06031e-06 sec) per iteration: 0.0848311 sec for 16764 iterations 4.977 usec (4.97689e-06 sec) per iteration: 0.0834326 sec for 16764 iterations 4.980 usec (4.98041e-06 sec) per iteration: 0.0834916 sec for 16764 iterations mean: 4.995333 usec stddev: 0.035863 usec relative stddev: 0.72% RESULT TestMmapAnonymous: x86-64_with_irt_pnacl_newlib_static= {4.995333, 0.035863} us TestAtomicIncrement: Measuring real time: 0.012 usec (1.24e-08 sec) per iteration: 1.24e-06 sec for 100 iterations 0.009 usec (8.868e-09 sec) per iteration: 8.868e-06 sec for 1000 iterations 0.009 usec (9.4367e-09 sec) per iteration: 9.4367e-05 sec for 10000 iterations 0.009 usec (8.69092e-09 sec) per iteration: 0.0920971 sec for 10596924 iterations 0.009 usec (8.70119e-09 sec) per iteration: 0.0922058 sec for 10596924 iterations 0.009 usec (8.68903e-09 sec) per iteration: 0.092077 sec for 10596924 iterations 0.009 usec (8.72183e-09 sec) per iteration: 0.0924246 sec for 10596924 iterations 0.009 usec (8.68531e-09 sec) per iteration: 0.0920376 sec for 10596924 iterations mean: 0.008698 usec stddev: 0.000013 usec relative stddev: 0.15% RESULT TestAtomicIncrement: x86-64_with_irt_pnacl_newlib_static= {0.008698, 0.000013} us TestUncontendedMutexLock: Measuring real time: 0.025 usec (2.538e-08 sec) per iteration: 2.538e-06 sec for 100 iterations 0.022 usec (2.2201e-08 sec) per iteration: 2.2201e-05 sec for 1000 iterations 0.022 usec (2.21173e-08 sec) per iteration: 0.0996231 sec for 4504301 iterations 0.022 usec (2.20595e-08 sec) per iteration: 0.0993624 sec for 4504301 iterations 0.022 usec (2.21171e-08 sec) per iteration: 0.0996222 sec for 4504301 iterations 0.022 usec (2.20908e-08 sec) per iteration: 0.0995036 sec for 4504301 iterations 0.022 usec (2.21469e-08 sec) per iteration: 0.0997564 sec for 4504301 iterations mean: 0.022106 usec stddev: 0.000029 usec relative stddev: 0.13% RESULT TestUncontendedMutexLock: x86-64_with_irt_pnacl_newlib_static= {0.022106, 0.000029} us TestCondvarSignalNoOp: Measuring real time: 0.242 usec (2.4234e-07 sec) per iteration: 2.4234e-05 sec for 100 iterations 0.149 usec (1.48825e-07 sec) per iteration: 0.0614117 sec for 412643 iterations 0.149 usec (1.48987e-07 sec) per iteration: 0.0614784 sec for 412643 iterations 0.149 usec (1.49342e-07 sec) per iteration: 0.0616249 sec for 412643 iterations 0.149 usec (1.48765e-07 sec) per iteration: 0.0613867 sec for 412643 iterations 0.149 usec (1.48853e-07 sec) per iteration: 0.0614233 sec for 412643 iterations mean: 0.148954 usec stddev: 0.000207 usec relative stddev: 0.14% RESULT TestCondvarSignalNoOp: x86-64_with_irt_pnacl_newlib_static= {0.148954, 0.000207} us TestThreadCreateAndJoin: Measuring real time: 49.848 usec (4.98476e-05 sec) per iteration: 0.00498476 sec for 100 iterations 46.594 usec (4.65943e-05 sec) per iteration: 0.0934681 sec for 2006 iterations 46.774 usec (4.67745e-05 sec) per iteration: 0.0938296 sec for 2006 iterations 47.650 usec (4.76504e-05 sec) per iteration: 0.0955867 sec for 2006 iterations 47.280 usec (4.72805e-05 sec) per iteration: 0.0948447 sec for 2006 iterations 43.437 usec (4.34368e-05 sec) per iteration: 0.0871342 sec for 2006 iterations mean: 46.347285 usec stddev: 1.502216 usec relative stddev: 3.24% RESULT TestThreadCreateAndJoin: x86-64_with_irt_pnacl_newlib_static= {46.347285, 1.502216} us TestThreadWakeup: Measuring real time: 12.546 usec (1.25455e-05 sec) per iteration: 0.00125455 sec for 100 iterations 10.627 usec (1.06269e-05 sec) per iteration: 0.0846962 sec for 7970 iterations 10.244 usec (1.0244e-05 sec) per iteration: 0.0816443 sec for 7970 iterations 10.479 usec (1.04791e-05 sec) per iteration: 0.0835185 sec for 7970 iterations 10.384 usec (1.03843e-05 sec) per iteration: 0.0827629 sec for 7970 iterations 10.382 usec (1.03821e-05 sec) per iteration: 0.082745 sec for 7970 iterations mean: 10.423262 usec stddev: 0.126447 usec relative stddev: 1.21% RESULT TestThreadWakeup: x86-64_with_irt_pnacl_newlib_static= {10.423262, 0.126447} us TestCatchingFault: Measuring real time: 18.520 usec (1.85195e-05 sec) per iteration: 0.00185195 sec for 100 iterations 15.256 usec (1.52556e-05 sec) per iteration: 0.0823648 sec for 5399 iterations 16.357 usec (1.63567e-05 sec) per iteration: 0.08831 sec for 5399 iterations 15.263 usec (1.52627e-05 sec) per iteration: 0.0824034 sec for 5399 iterations 15.528 usec (1.55276e-05 sec) per iteration: 0.0838334 sec for 5399 iterations 15.188 usec (1.51881e-05 sec) per iteration: 0.0820007 sec for 5399 iterations mean: 15.518142 usec stddev: 0.435067 usec relative stddev: 2.80% RESULT TestCatchingFault: x86-64_with_irt_pnacl_newlib_static= {15.518142, 0.435067} us TestThreadCreateAndJoinAfterSettingFaultHandler: Measuring real time: 35.681 usec (3.56812e-05 sec) per iteration: 0.00356812 sec for 100 iterations 44.002 usec (4.40022e-05 sec) per iteration: 0.123294 sec for 2802 iterations 39.336 usec (3.93358e-05 sec) per iteration: 0.110219 sec for 2802 iterations 45.194 usec (4.5194e-05 sec) per iteration: 0.126634 sec for 2802 iterations 44.431 usec (4.44313e-05 sec) per iteration: 0.124497 sec for 2802 iterations 46.373 usec (4.63728e-05 sec) per iteration: 0.129937 sec for 2802 iterations mean: 43.867212 usec stddev: 2.404534 usec relative stddev: 5.48% RESULT TestThreadCreateAndJoinAfterSettingFaultHandler: x86-64_with_irt_pnacl_newlib_static= {43.867212, 2.404534} us [ OK ] pnacl_newlib.run_performance_test_irt (6300 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