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 platform=x86-64 bitcode=1 skip_trusted_tests=1 large_tests scons: Reading SConscript files ... ====================================================================== SCONS ARGS:['scons.py', '--verbose', '-k', '-j1', '--mode=nacl,opt-host', 'platform=x86-64', 'bitcode=1', 'skip_trusted_tests=1', 'large_tests'] ====================================================================== ====================================================================== 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 = 1547758631, usec = 508552 } Thu Jan 17 12:57:11 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 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 *** SKIPPING nacl_irt-64 : run_irt_thread_test There are 8 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 --time_warning 10 --time_error 100 --perf_env_description x86-64_pnacl_newlib_static --subarch 64 --arch x86 --capture_output 0 --output_stamp /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl-x86-64-pnacl-pexe-clang/test_results/benchmark_test.out scons-out/opt-mac-x86-64/staging/sel_ldr -- scons-out/nacl-x86-64-pnacl-pexe-clang/obj/tests/benchmark/benchmark_test.nexe x86-64_pnacl_newlib_static [ RUN ] pnacl_newlib.run_benchmark_test scons-out/opt-mac-x86-64/staging/sel_ldr -- scons-out/nacl-x86-64-pnacl-pexe-clang/obj/tests/benchmark/benchmark_test.nexe x86-64_pnacl_newlib_static [32752,2865189760:17:17:39.946503] Native Client module will be loaded at base address 0x0000431000000000 Running suite of 1 benchmarks: Running Benchmark: Life (SIMD version)... RESULT BenchmarkLife: x86-64_pnacl_newlib_static= {0.049160, 0.008870} seconds --------------------------------------------------------------- Done running benchmark suite. [ OK ] pnacl_newlib.run_benchmark_test (770 ms) /b/s/w/ir/cache/vpython/7c7ecd/bin/python tools/command_tester.py --name pnacl_newlib.run_clock_cputime_test --time_warning 60 --time_error 600 --perf_env_description x86-64_pnacl_newlib_static --subarch 64 --arch x86 --output_stamp /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl-x86-64-pnacl-pexe-clang/test_results/clock_cputime_test.out scons-out/opt-mac-x86-64/staging/sel_ldr -- scons-out/nacl-x86-64-pnacl-pexe-clang/obj/tests/clock/clock_test.nexe -c [ RUN ] pnacl_newlib.run_clock_cputime_test scons-out/opt-mac-x86-64/staging/sel_ldr -- scons-out/nacl-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 (66210 ms) doSizeCheck(["scons-out/nacl-x86-64-pnacl-pexe-clang/obj/tests/hello_world/hello_world_size.out"], ["scons-out/nacl-x86-64-pnacl-pexe-clang/obj/tests/hello_world/hello_world.nonfinal.pexe"]) RESULT hello_world_size.out: x86-64_pnacl_newlib_static= 353.605 KB RESULT hello_world_size.out: ZIPPED_x86-64_pnacl_newlib_static= 232.463 KB /b/s/w/ir/cache/vpython/7c7ecd/bin/python tools/command_tester.py --name pnacl_newlib.run_performance_test --time_warning 10 --time_error 100 --perf_env_description x86-64_pnacl_newlib_static --subarch 64 --arch x86 --capture_output 0 --output_stamp /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl-x86-64-pnacl-pexe-clang/test_results/performance_test.out scons-out/opt-mac-x86-64/staging/sel_ldr -e -- scons-out/nacl-x86-64-pnacl-pexe-clang/obj/tests/performance/performance_test.nexe x86-64_pnacl_newlib_static [ RUN ] pnacl_newlib.run_performance_test scons-out/opt-mac-x86-64/staging/sel_ldr -e -- scons-out/nacl-x86-64-pnacl-pexe-clang/obj/tests/performance/performance_test.nexe x86-64_pnacl_newlib_static [32757,2865189760:17:17:54.144099] Native Client module will be loaded at base address 0x0000523300000000 TestNull: Measuring real time: 0.008 usec (8.13e-09 sec) per iteration: 8.13e-07 sec for 100 iterations 0.003 usec (2.583e-09 sec) per iteration: 2.583e-06 sec for 1000 iterations 0.002 usec (2.3558e-09 sec) per iteration: 2.3558e-05 sec for 10000 iterations 0.002 usec (1.73281e-09 sec) per iteration: 0.073555 sec for 42448425 iterations 0.002 usec (1.82355e-09 sec) per iteration: 0.0774069 sec for 42448425 iterations 0.002 usec (1.66109e-09 sec) per iteration: 0.0705105 sec for 42448425 iterations 0.002 usec (1.7648e-09 sec) per iteration: 0.0749128 sec for 42448425 iterations 0.002 usec (1.70849e-09 sec) per iteration: 0.0725226 sec for 42448425 iterations mean: 0.001738 usec stddev: 0.000054 usec relative stddev: 3.14% RESULT TestNull: x86-64_pnacl_newlib_static= {0.001738, 0.000054} us TestNaClSyscall: Measuring real time: 0.156 usec (1.5571e-07 sec) per iteration: 1.5571e-05 sec for 100 iterations 0.149 usec (1.48949e-07 sec) per iteration: 0.0956581 sec for 642219 iterations 0.165 usec (1.65186e-07 sec) per iteration: 0.106086 sec for 642219 iterations 0.154 usec (1.53571e-07 sec) per iteration: 0.0986261 sec for 642219 iterations 0.150 usec (1.503e-07 sec) per iteration: 0.0965252 sec for 642219 iterations 0.152 usec (1.51584e-07 sec) per iteration: 0.0973502 sec for 642219 iterations mean: 0.153918 usec stddev: 0.005836 usec relative stddev: 3.79% RESULT TestNaClSyscall: x86-64_pnacl_newlib_static= {0.153918, 0.005836} us TestSetjmpLongjmp: Measuring real time: 0.022 usec (2.213e-08 sec) per iteration: 2.213e-06 sec for 100 iterations 0.017 usec (1.6684e-08 sec) per iteration: 1.6684e-05 sec for 1000 iterations 0.013 usec (1.30971e-08 sec) per iteration: 0.0785012 sec for 5993766 iterations 0.012 usec (1.16864e-08 sec) per iteration: 0.0700457 sec for 5993766 iterations 0.012 usec (1.23407e-08 sec) per iteration: 0.0739671 sec for 5993766 iterations 0.012 usec (1.24047e-08 sec) per iteration: 0.0743507 sec for 5993766 iterations 0.013 usec (1.28776e-08 sec) per iteration: 0.0771854 sec for 5993766 iterations mean: 0.012481 usec stddev: 0.000489 usec relative stddev: 3.91% RESULT TestSetjmpLongjmp: x86-64_pnacl_newlib_static= {0.012481, 0.000489} us TestClockGetTime: Measuring real time: 0.163 usec (1.6267e-07 sec) per iteration: 1.6267e-05 sec for 100 iterations 0.156 usec (1.56266e-07 sec) per iteration: 0.0960631 sec for 614741 iterations 0.159 usec (1.59364e-07 sec) per iteration: 0.0979677 sec for 614741 iterations 0.156 usec (1.55788e-07 sec) per iteration: 0.0957694 sec for 614741 iterations 0.159 usec (1.5908e-07 sec) per iteration: 0.0977933 sec for 614741 iterations 0.161 usec (1.60739e-07 sec) per iteration: 0.0988129 sec for 614741 iterations mean: 0.158248 usec stddev: 0.001904 usec relative stddev: 1.20% RESULT TestClockGetTime: x86-64_pnacl_newlib_static= {0.158248, 0.001904} us TestTlsVariable: Measuring real time: 0.010 usec (1.018e-08 sec) per iteration: 1.018e-06 sec for 100 iterations 0.006 usec (6.391e-09 sec) per iteration: 6.391e-06 sec for 1000 iterations 0.006 usec (6.0338e-09 sec) per iteration: 6.0338e-05 sec for 10000 iterations 0.006 usec (5.8816e-09 sec) per iteration: 0.0974775 sec for 16573303 iterations 0.006 usec (5.95868e-09 sec) per iteration: 0.0987551 sec for 16573303 iterations 0.006 usec (6.18088e-09 sec) per iteration: 0.102438 sec for 16573303 iterations 0.006 usec (6.01872e-09 sec) per iteration: 0.09975 sec for 16573303 iterations 0.006 usec (5.9693e-09 sec) per iteration: 0.0989311 sec for 16573303 iterations mean: 0.006002 usec stddev: 0.000100 usec relative stddev: 1.66% RESULT TestTlsVariable: x86-64_pnacl_newlib_static= {0.006002, 0.000100} us TestMmapAnonymous: Measuring real time: 8.453 usec (8.45324e-06 sec) per iteration: 0.000845324 sec for 100 iterations 7.980 usec (7.97974e-06 sec) per iteration: 0.0943923 sec for 11829 iterations 8.189 usec (8.18883e-06 sec) per iteration: 0.0968657 sec for 11829 iterations 8.275 usec (8.27494e-06 sec) per iteration: 0.0978843 sec for 11829 iterations 8.270 usec (8.27014e-06 sec) per iteration: 0.0978275 sec for 11829 iterations 8.285 usec (8.28454e-06 sec) per iteration: 0.0979978 sec for 11829 iterations mean: 8.199638 usec stddev: 0.115172 usec relative stddev: 1.40% RESULT TestMmapAnonymous: x86-64_pnacl_newlib_static= {8.199638, 0.115172} us TestAtomicIncrement: Measuring real time: 0.013 usec (1.338e-08 sec) per iteration: 1.338e-06 sec for 100 iterations 0.010 usec (9.599e-09 sec) per iteration: 9.599e-06 sec for 1000 iterations 0.011 usec (1.0918e-08 sec) per iteration: 0.00010918 sec for 10000 iterations 0.010 usec (9.65047e-09 sec) per iteration: 0.0883905 sec for 9159186 iterations 0.010 usec (9.61117e-09 sec) per iteration: 0.0880305 sec for 9159186 iterations 0.010 usec (9.58477e-09 sec) per iteration: 0.0877887 sec for 9159186 iterations 0.010 usec (9.84781e-09 sec) per iteration: 0.0901979 sec for 9159186 iterations 0.010 usec (9.67819e-09 sec) per iteration: 0.0886443 sec for 9159186 iterations mean: 0.009674 usec stddev: 0.000092 usec relative stddev: 0.96% RESULT TestAtomicIncrement: x86-64_pnacl_newlib_static= {0.009674, 0.000092} us TestUncontendedMutexLock: Measuring real time: 0.028 usec (2.822e-08 sec) per iteration: 2.822e-06 sec for 100 iterations 0.024 usec (2.3957e-08 sec) per iteration: 2.3957e-05 sec for 1000 iterations 0.025 usec (2.46109e-08 sec) per iteration: 0.102729 sec for 4174145 iterations 0.024 usec (2.35309e-08 sec) per iteration: 0.0982214 sec for 4174145 iterations 0.024 usec (2.39661e-08 sec) per iteration: 0.100038 sec for 4174145 iterations 0.024 usec (2.36457e-08 sec) per iteration: 0.0987007 sec for 4174145 iterations 0.023 usec (2.3327e-08 sec) per iteration: 0.0973702 sec for 4174145 iterations mean: 0.023816 usec stddev: 0.000448 usec relative stddev: 1.88% RESULT TestUncontendedMutexLock: x86-64_pnacl_newlib_static= {0.023816, 0.000448} us TestCondvarSignalNoOp: Measuring real time: 0.286 usec (2.8617e-07 sec) per iteration: 2.8617e-05 sec for 100 iterations 0.150 usec (1.50019e-07 sec) per iteration: 0.0524229 sec for 349442 iterations 0.148 usec (1.48282e-07 sec) per iteration: 0.0518161 sec for 349442 iterations 0.151 usec (1.51188e-07 sec) per iteration: 0.0528315 sec for 349442 iterations 0.151 usec (1.51306e-07 sec) per iteration: 0.0528727 sec for 349442 iterations 0.157 usec (1.57149e-07 sec) per iteration: 0.0549146 sec for 349442 iterations mean: 0.151589 usec stddev: 0.002985 usec relative stddev: 1.97% RESULT TestCondvarSignalNoOp: x86-64_pnacl_newlib_static= {0.151589, 0.002985} us TestThreadCreateAndJoin: Measuring real time: 66.187 usec (6.61873e-05 sec) per iteration: 0.00661873 sec for 100 iterations 66.495 usec (6.64946e-05 sec) per iteration: 0.100407 sec for 1510 iterations 64.326 usec (6.43261e-05 sec) per iteration: 0.0971324 sec for 1510 iterations 63.994 usec (6.39942e-05 sec) per iteration: 0.0966312 sec for 1510 iterations 63.431 usec (6.34305e-05 sec) per iteration: 0.0957801 sec for 1510 iterations 63.978 usec (6.39776e-05 sec) per iteration: 0.0966061 sec for 1510 iterations mean: 64.444595 usec stddev: 1.064515 usec relative stddev: 1.65% RESULT TestThreadCreateAndJoin: x86-64_pnacl_newlib_static= {64.444595, 1.064515} us TestThreadWakeup: Measuring real time: 31.937 usec (3.19367e-05 sec) per iteration: 0.00319367 sec for 100 iterations 30.818 usec (3.08181e-05 sec) per iteration: 0.0964914 sec for 3131 iterations 30.954 usec (3.09536e-05 sec) per iteration: 0.0969156 sec for 3131 iterations 31.010 usec (3.10095e-05 sec) per iteration: 0.0970909 sec for 3131 iterations 31.261 usec (3.12614e-05 sec) per iteration: 0.0978795 sec for 3131 iterations 32.301 usec (3.2301e-05 sec) per iteration: 0.101134 sec for 3131 iterations mean: 31.268726 usec stddev: 0.535770 usec relative stddev: 1.71% RESULT TestThreadWakeup: x86-64_pnacl_newlib_static= {31.268726, 0.535770} us TestCatchingFault: Measuring real time: 33.696 usec (3.36963e-05 sec) per iteration: 0.00336963 sec for 100 iterations 32.178 usec (3.21781e-05 sec) per iteration: 0.0954725 sec for 2967 iterations 30.378 usec (3.0378e-05 sec) per iteration: 0.0901315 sec for 2967 iterations 30.758 usec (3.0758e-05 sec) per iteration: 0.0912589 sec for 2967 iterations 31.118 usec (3.11181e-05 sec) per iteration: 0.0923273 sec for 2967 iterations 31.124 usec (3.11243e-05 sec) per iteration: 0.0923457 sec for 2967 iterations mean: 31.111279 usec stddev: 0.600152 usec relative stddev: 1.93% RESULT TestCatchingFault: x86-64_pnacl_newlib_static= {31.111279, 0.600152} us TestThreadCreateAndJoinAfterSettingFaultHandler: Measuring real time: 61.905 usec (6.1905e-05 sec) per iteration: 0.0061905 sec for 100 iterations 61.895 usec (6.18951e-05 sec) per iteration: 0.0999605 sec for 1615 iterations 62.396 usec (6.23964e-05 sec) per iteration: 0.10077 sec for 1615 iterations 63.915 usec (6.39151e-05 sec) per iteration: 0.103223 sec for 1615 iterations 62.254 usec (6.22537e-05 sec) per iteration: 0.10054 sec for 1615 iterations 63.870 usec (6.38702e-05 sec) per iteration: 0.10315 sec for 1615 iterations mean: 62.866081 usec stddev: 0.854042 usec relative stddev: 1.36% RESULT TestThreadCreateAndJoinAfterSettingFaultHandler: x86-64_pnacl_newlib_static= {62.866081, 0.854042} us [ OK ] pnacl_newlib.run_performance_test (6210 ms) scons: done building targets. ********************************************************************** COMMAND EXECUTION REPORT ********************************************************************** 3 command_tester.py 1 doSizeCheck ********************************************************************** ENVIRONMENT USAGE REPORT ********************************************************************** 4 nacl-x86-64-pnacl-pexe-clang Command return code: 0