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 use_sz=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', 'use_sz=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.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: 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 = 1554554965, usec = 343233 } Sat Apr 6 05:49:25 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-pnacl-subzero-pexe-clang OBJ_ROOT: /b/s/w/ir/k/native_client/scons-out/nacl-x86-64-pnacl-subzero-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/k/native_client/toolchain/mac_x86/pnacl_newlib_raw/bin/pnacl-clang -std=gnu99 ASPPCOM: /b/s/w/ir/k/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/k/native_client/scons-out/nacl-x86-64-pnacl-subzero-pexe-clang/include -I/b/s/w/ir/k -c -o UNKNOWN COMPILER NACL_BUILD_FAMILY: TRUSTED BUILD_TYPE: opt-mac TARGET_ROOT: /b/s/w/ir/k/native_client/scons-out/opt-mac-x86-64 OBJ_ROOT: /b/s/w/ir/k/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/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 -DNDEBUG -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_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_sz_newlib_static --subarch 64 --arch x86 --time_error 1000 --capture_output 0 --output_stamp /b/s/w/ir/k/native_client/scons-out/nacl-x86-64-pnacl-subzero-pexe-clang/test_results/benchmark_test.out scons-out/opt-mac-x86-64/staging/sel_ldr -- scons-out/nacl-x86-64-pnacl-subzero-pexe-clang/obj/tests/benchmark/benchmark_test.nexe x86-64_pnacl_sz_newlib_static [ RUN ] pnacl_newlib.run_benchmark_test scons-out/opt-mac-x86-64/staging/sel_ldr -- scons-out/nacl-x86-64-pnacl-subzero-pexe-clang/obj/tests/benchmark/benchmark_test.nexe x86-64_pnacl_sz_newlib_static [21542,2646807424:07:57:47.920008] Native Client module will be loaded at base address 0x0000759d00000000 Running suite of 1 benchmarks: Running Benchmark: Life (SIMD version)... RESULT BenchmarkLife: x86-64_pnacl_sz_newlib_static= {2.325690, 0.046240} seconds --------------------------------------------------------------- Done running benchmark suite. WARNING: should have taken less than 10.000000 secs [ OK ] pnacl_newlib.run_benchmark_test (55100 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_sz_newlib_static --subarch 64 --arch x86 --output_stamp /b/s/w/ir/k/native_client/scons-out/nacl-x86-64-pnacl-subzero-pexe-clang/test_results/clock_cputime_test.out scons-out/opt-mac-x86-64/staging/sel_ldr -- scons-out/nacl-x86-64-pnacl-subzero-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-subzero-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 (68890 ms) doSizeCheck(["scons-out/nacl-x86-64-pnacl-subzero-pexe-clang/obj/tests/hello_world/hello_world_size.out"], ["scons-out/nacl-x86-64-pnacl-subzero-pexe-clang/obj/tests/hello_world/hello_world.nonfinal.pexe"]) RESULT hello_world_size.out: x86-64_pnacl_sz_newlib_static= 353.305 KB RESULT hello_world_size.out: ZIPPED_x86-64_pnacl_sz_newlib_static= 232.315 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_sz_newlib_static --subarch 64 --arch x86 --capture_output 0 --output_stamp /b/s/w/ir/k/native_client/scons-out/nacl-x86-64-pnacl-subzero-pexe-clang/test_results/performance_test.out scons-out/opt-mac-x86-64/staging/sel_ldr -e -- scons-out/nacl-x86-64-pnacl-subzero-pexe-clang/obj/tests/performance/performance_test.nexe x86-64_pnacl_sz_newlib_static [ RUN ] pnacl_newlib.run_performance_test scons-out/opt-mac-x86-64/staging/sel_ldr -e -- scons-out/nacl-x86-64-pnacl-subzero-pexe-clang/obj/tests/performance/performance_test.nexe x86-64_pnacl_sz_newlib_static [21548,2646807424:07:58:09.378505] Native Client module will be loaded at base address 0x0000675300000000 TestNull: Measuring real time: 0.008 usec (7.57e-09 sec) per iteration: 7.57e-07 sec for 100 iterations 0.002 usec (2.254e-09 sec) per iteration: 2.254e-06 sec for 1000 iterations 0.001 usec (1.4143e-09 sec) per iteration: 1.4143e-05 sec for 10000 iterations 0.002 usec (1.71283e-09 sec) per iteration: 0.121108 sec for 70706356 iterations 0.002 usec (1.77787e-09 sec) per iteration: 0.125707 sec for 70706356 iterations 0.002 usec (1.77754e-09 sec) per iteration: 0.125683 sec for 70706356 iterations 0.002 usec (1.70607e-09 sec) per iteration: 0.12063 sec for 70706356 iterations 0.002 usec (1.65536e-09 sec) per iteration: 0.117044 sec for 70706356 iterations mean: 0.001726 usec stddev: 0.000047 usec relative stddev: 2.71% RESULT TestNull: x86-64_pnacl_sz_newlib_static= {0.001726, 0.000047} us TestNaClSyscall: Measuring real time: 0.117 usec (1.1678e-07 sec) per iteration: 1.1678e-05 sec for 100 iterations 0.110 usec (1.09652e-07 sec) per iteration: 0.0938963 sec for 856311 iterations 0.110 usec (1.10288e-07 sec) per iteration: 0.0944408 sec for 856311 iterations 0.110 usec (1.10069e-07 sec) per iteration: 0.0942534 sec for 856311 iterations 0.110 usec (1.10008e-07 sec) per iteration: 0.0942011 sec for 856311 iterations 0.110 usec (1.10164e-07 sec) per iteration: 0.094335 sec for 856311 iterations mean: 0.110036 usec stddev: 0.000214 usec relative stddev: 0.19% RESULT TestNaClSyscall: x86-64_pnacl_sz_newlib_static= {0.110036, 0.000214} us TestSetjmpLongjmp: Measuring real time: 0.017 usec (1.745e-08 sec) per iteration: 1.745e-06 sec for 100 iterations 0.012 usec (1.1863e-08 sec) per iteration: 1.1863e-05 sec for 1000 iterations 0.013 usec (1.26799e-08 sec) per iteration: 0.106886 sec for 8429570 iterations 0.013 usec (1.26732e-08 sec) per iteration: 0.10683 sec for 8429570 iterations 0.012 usec (1.1635e-08 sec) per iteration: 0.0980782 sec for 8429570 iterations 0.012 usec (1.16213e-08 sec) per iteration: 0.0979625 sec for 8429570 iterations 0.012 usec (1.15371e-08 sec) per iteration: 0.0972529 sec for 8429570 iterations mean: 0.012029 usec stddev: 0.000530 usec relative stddev: 4.40% RESULT TestSetjmpLongjmp: x86-64_pnacl_sz_newlib_static= {0.012029, 0.000530} us TestClockGetTime: Measuring real time: 0.164 usec (1.6373e-07 sec) per iteration: 1.6373e-05 sec for 100 iterations 0.156 usec (1.5645e-07 sec) per iteration: 0.0955536 sec for 610761 iterations 0.158 usec (1.57893e-07 sec) per iteration: 0.0964349 sec for 610761 iterations 0.156 usec (1.55943e-07 sec) per iteration: 0.0952439 sec for 610761 iterations 0.157 usec (1.56649e-07 sec) per iteration: 0.0956748 sec for 610761 iterations 0.158 usec (1.57508e-07 sec) per iteration: 0.0961998 sec for 610761 iterations mean: 0.156889 usec stddev: 0.000712 usec relative stddev: 0.45% RESULT TestClockGetTime: x86-64_pnacl_sz_newlib_static= {0.156889, 0.000712} us TestTlsVariable: Measuring real time: 0.011 usec (1.132e-08 sec) per iteration: 1.132e-06 sec for 100 iterations 0.006 usec (6.28e-09 sec) per iteration: 6.28e-06 sec for 1000 iterations 0.006 usec (6.0285e-09 sec) per iteration: 6.0285e-05 sec for 10000 iterations 0.006 usec (6.01442e-09 sec) per iteration: 0.0997665 sec for 16587874 iterations 0.006 usec (6.01989e-09 sec) per iteration: 0.0998571 sec for 16587874 iterations 0.006 usec (6.02088e-09 sec) per iteration: 0.0998736 sec for 16587874 iterations 0.006 usec (6.03348e-09 sec) per iteration: 0.100083 sec for 16587874 iterations 0.006 usec (5.99158e-09 sec) per iteration: 0.0993875 sec for 16587874 iterations mean: 0.006016 usec stddev: 0.000014 usec relative stddev: 0.23% RESULT TestTlsVariable: x86-64_pnacl_sz_newlib_static= {0.006016, 0.000014} us TestMmapAnonymous: Measuring real time: 9.362 usec (9.362e-06 sec) per iteration: 0.0009362 sec for 100 iterations 9.093 usec (9.09262e-06 sec) per iteration: 0.0971183 sec for 10681 iterations 9.070 usec (9.06985e-06 sec) per iteration: 0.0968751 sec for 10681 iterations 9.141 usec (9.14144e-06 sec) per iteration: 0.0976397 sec for 10681 iterations 9.145 usec (9.14471e-06 sec) per iteration: 0.0976747 sec for 10681 iterations 9.065 usec (9.06546e-06 sec) per iteration: 0.0968282 sec for 10681 iterations mean: 9.102816 usec stddev: 0.034155 usec relative stddev: 0.38% RESULT TestMmapAnonymous: x86-64_pnacl_sz_newlib_static= {9.102816, 0.034155} us TestAtomicIncrement: Measuring real time: 0.013 usec (1.255e-08 sec) per iteration: 1.255e-06 sec for 100 iterations 0.010 usec (9.875e-09 sec) per iteration: 9.875e-06 sec for 1000 iterations 0.010 usec (9.6862e-09 sec) per iteration: 9.6862e-05 sec for 10000 iterations 0.010 usec (9.69484e-09 sec) per iteration: 0.100089 sec for 10323966 iterations 0.010 usec (9.6985e-09 sec) per iteration: 0.100127 sec for 10323966 iterations 0.010 usec (9.78996e-09 sec) per iteration: 0.101071 sec for 10323966 iterations 0.010 usec (9.86119e-09 sec) per iteration: 0.101807 sec for 10323966 iterations 0.010 usec (9.79601e-09 sec) per iteration: 0.101134 sec for 10323966 iterations mean: 0.009768 usec stddev: 0.000063 usec relative stddev: 0.65% RESULT TestAtomicIncrement: x86-64_pnacl_sz_newlib_static= {0.009768, 0.000063} us TestUncontendedMutexLock: Measuring real time: 0.028 usec (2.813e-08 sec) per iteration: 2.813e-06 sec for 100 iterations 0.022 usec (2.1615e-08 sec) per iteration: 2.1615e-05 sec for 1000 iterations 0.022 usec (2.15075e-08 sec) per iteration: 0.0995028 sec for 4626416 iterations 0.022 usec (2.15458e-08 sec) per iteration: 0.0996799 sec for 4626416 iterations 0.021 usec (2.14987e-08 sec) per iteration: 0.099462 sec for 4626416 iterations 0.021 usec (2.13434e-08 sec) per iteration: 0.0987434 sec for 4626416 iterations 0.021 usec (2.13447e-08 sec) per iteration: 0.0987496 sec for 4626416 iterations mean: 0.021448 usec stddev: 0.000086 usec relative stddev: 0.40% RESULT TestUncontendedMutexLock: x86-64_pnacl_sz_newlib_static= {0.021448, 0.000086} us TestCondvarSignalNoOp: Measuring real time: 0.301 usec (3.0096e-07 sec) per iteration: 3.0096e-05 sec for 100 iterations 0.160 usec (1.59767e-07 sec) per iteration: 0.0530857 sec for 332270 iterations 0.160 usec (1.59713e-07 sec) per iteration: 0.0530677 sec for 332270 iterations 0.177 usec (1.76563e-07 sec) per iteration: 0.0586667 sec for 332270 iterations 0.172 usec (1.71669e-07 sec) per iteration: 0.0570406 sec for 332270 iterations 0.160 usec (1.59744e-07 sec) per iteration: 0.0530783 sec for 332270 iterations mean: 0.165491 usec stddev: 0.007210 usec relative stddev: 4.36% RESULT TestCondvarSignalNoOp: x86-64_pnacl_sz_newlib_static= {0.165491, 0.007210} us TestThreadCreateAndJoin: Measuring real time: 75.354 usec (7.53542e-05 sec) per iteration: 0.00753542 sec for 100 iterations 80.377 usec (8.03775e-05 sec) per iteration: 0.106661 sec for 1327 iterations 80.413 usec (8.04125e-05 sec) per iteration: 0.106707 sec for 1327 iterations 71.602 usec (7.16024e-05 sec) per iteration: 0.0950164 sec for 1327 iterations 79.370 usec (7.937e-05 sec) per iteration: 0.105324 sec for 1327 iterations 90.407 usec (9.04074e-05 sec) per iteration: 0.119971 sec for 1327 iterations mean: 80.433970 usec stddev: 5.976663 usec relative stddev: 7.43% RESULT TestThreadCreateAndJoin: x86-64_pnacl_sz_newlib_static= {80.433970, 5.976663} us TestThreadWakeup: Measuring real time: 35.137 usec (3.51367e-05 sec) per iteration: 0.00351367 sec for 100 iterations 36.168 usec (3.61677e-05 sec) per iteration: 0.102933 sec for 2846 iterations 33.857 usec (3.38568e-05 sec) per iteration: 0.0963564 sec for 2846 iterations 34.951 usec (3.49508e-05 sec) per iteration: 0.0994701 sec for 2846 iterations 33.473 usec (3.34731e-05 sec) per iteration: 0.0952644 sec for 2846 iterations 34.007 usec (3.40066e-05 sec) per iteration: 0.0967829 sec for 2846 iterations mean: 34.491018 usec stddev: 0.969114 usec relative stddev: 2.81% RESULT TestThreadWakeup: x86-64_pnacl_sz_newlib_static= {34.491018, 0.969114} us TestCatchingFault: Measuring real time: 38.259 usec (3.8259e-05 sec) per iteration: 0.0038259 sec for 100 iterations 36.567 usec (3.65673e-05 sec) per iteration: 0.0955504 sec for 2613 iterations 37.328 usec (3.73285e-05 sec) per iteration: 0.0975394 sec for 2613 iterations 35.656 usec (3.56561e-05 sec) per iteration: 0.0931693 sec for 2613 iterations 35.766 usec (3.57661e-05 sec) per iteration: 0.0934568 sec for 2613 iterations 37.098 usec (3.70984e-05 sec) per iteration: 0.0969381 sec for 2613 iterations mean: 36.483275 usec stddev: 0.678002 usec relative stddev: 1.86% RESULT TestCatchingFault: x86-64_pnacl_sz_newlib_static= {36.483275, 0.678002} us TestThreadCreateAndJoinAfterSettingFaultHandler: Measuring real time: 72.630 usec (7.26299e-05 sec) per iteration: 0.00726299 sec for 100 iterations 72.405 usec (7.24047e-05 sec) per iteration: 0.0996288 sec for 1376 iterations 79.004 usec (7.90035e-05 sec) per iteration: 0.108709 sec for 1376 iterations 73.163 usec (7.31629e-05 sec) per iteration: 0.100672 sec for 1376 iterations 78.932 usec (7.8932e-05 sec) per iteration: 0.10861 sec for 1376 iterations 71.557 usec (7.15569e-05 sec) per iteration: 0.0984623 sec for 1376 iterations mean: 75.012012 usec stddev: 3.269668 usec relative stddev: 4.36% RESULT TestThreadCreateAndJoinAfterSettingFaultHandler: x86-64_pnacl_sz_newlib_static= {75.012012, 3.269668} us [ OK ] pnacl_newlib.run_performance_test (6689 ms) scons: done building targets. ********************************************************************** COMMAND EXECUTION REPORT ********************************************************************** 3 command_tester.py 1 doSizeCheck ********************************************************************** ENVIRONMENT USAGE REPORT ********************************************************************** 4 nacl-x86-64-pnacl-subzero-pexe-clang Command return code: 0