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.2.0 kern.osrevision: 199506 kern.version: Darwin Kernel Version 17.2.0: Fri Sep 29 18:27:05 PDT 2017; root:xnu-4570.20.62~3/RELEASE_X86_64 kern.posix1version: 200112 kern.osversion: 17B1002 ====================================================================== 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 = 1552934317, usec = 778909 } Mon Mar 18 11:38:37 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 [1602,2972603200:15:07:05.429547] Native Client module will be loaded at base address 0x000029ad00000000 Running suite of 1 benchmarks: Running Benchmark: Life (SIMD version)... RESULT BenchmarkLife: x86-64_pnacl_sz_newlib_static= {4.186710, 0.038240} seconds --------------------------------------------------------------- Done running benchmark suite. WARNING: should have taken less than 10.000000 secs [ OK ] pnacl_newlib.run_benchmark_test (47640 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 [ OK ] pnacl_newlib.run_clock_cputime_test (59070 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 [1613,2972603200:15:07:34.884101] Native Client module will be loaded at base address 0x000022f200000000 TestNull: Measuring real time: 0.005 usec (4.84e-09 sec) per iteration: 4.84e-07 sec for 100 iterations 0.002 usec (1.63e-09 sec) per iteration: 1.63e-06 sec for 1000 iterations 0.001 usec (1.4932e-09 sec) per iteration: 1.4932e-05 sec for 10000 iterations 0.001 usec (1.39658e-09 sec) per iteration: 0.0935294 sec for 66970265 iterations 0.001 usec (1.33347e-09 sec) per iteration: 0.0893031 sec for 66970265 iterations 0.001 usec (1.32171e-09 sec) per iteration: 0.0885152 sec for 66970265 iterations 0.001 usec (1.36218e-09 sec) per iteration: 0.0912255 sec for 66970265 iterations 0.001 usec (1.32879e-09 sec) per iteration: 0.0889896 sec for 66970265 iterations mean: 0.001349 usec stddev: 0.000028 usec relative stddev: 2.05% RESULT TestNull: x86-64_pnacl_sz_newlib_static= {0.001349, 0.000028} us TestNaClSyscall: Measuring real time: 0.094 usec (9.359e-08 sec) per iteration: 9.359e-06 sec for 100 iterations 0.216 usec (2.16228e-07 sec) per iteration: 0.000216228 sec for 1000 iterations 0.088 usec (8.76004e-08 sec) per iteration: 0.0405129 sec for 462474 iterations 0.088 usec (8.75961e-08 sec) per iteration: 0.0405109 sec for 462474 iterations 0.088 usec (8.76394e-08 sec) per iteration: 0.0405309 sec for 462474 iterations 0.088 usec (8.83154e-08 sec) per iteration: 0.0408436 sec for 462474 iterations 0.087 usec (8.74072e-08 sec) per iteration: 0.0404236 sec for 462474 iterations mean: 0.087712 usec stddev: 0.000312 usec relative stddev: 0.36% RESULT TestNaClSyscall: x86-64_pnacl_sz_newlib_static= {0.087712, 0.000312} us TestSetjmpLongjmp: Measuring real time: 0.012 usec (1.245e-08 sec) per iteration: 1.245e-06 sec for 100 iterations 0.010 usec (9.882e-09 sec) per iteration: 9.882e-06 sec for 1000 iterations 0.020 usec (2.03501e-08 sec) per iteration: 0.000203501 sec for 10000 iterations 0.009 usec (9.48501e-09 sec) per iteration: 0.0466091 sec for 4913980 iterations 0.009 usec (9.49362e-09 sec) per iteration: 0.0466515 sec for 4913980 iterations 0.010 usec (9.51753e-09 sec) per iteration: 0.0467689 sec for 4913980 iterations 0.009 usec (9.49528e-09 sec) per iteration: 0.0466596 sec for 4913980 iterations 0.010 usec (9.52403e-09 sec) per iteration: 0.0468009 sec for 4913980 iterations mean: 0.009503 usec stddev: 0.000015 usec relative stddev: 0.16% RESULT TestSetjmpLongjmp: x86-64_pnacl_sz_newlib_static= {0.009503, 0.000015} us TestClockGetTime: Measuring real time: 0.140 usec (1.3998e-07 sec) per iteration: 1.3998e-05 sec for 100 iterations 0.134 usec (1.34052e-07 sec) per iteration: 0.095765 sec for 714387 iterations 0.134 usec (1.34491e-07 sec) per iteration: 0.0960788 sec for 714387 iterations 0.134 usec (1.34362e-07 sec) per iteration: 0.0959862 sec for 714387 iterations 0.134 usec (1.33877e-07 sec) per iteration: 0.0956401 sec for 714387 iterations 0.134 usec (1.34353e-07 sec) per iteration: 0.0959803 sec for 714387 iterations mean: 0.134227 usec stddev: 0.000227 usec relative stddev: 0.17% RESULT TestClockGetTime: x86-64_pnacl_sz_newlib_static= {0.134227, 0.000227} us TestTlsVariable: Measuring real time: 0.007 usec (7.2e-09 sec) per iteration: 7.2e-07 sec for 100 iterations 0.005 usec (4.918e-09 sec) per iteration: 4.918e-06 sec for 1000 iterations 0.012 usec (1.17826e-08 sec) per iteration: 0.000117826 sec for 10000 iterations 0.005 usec (4.61673e-09 sec) per iteration: 0.0391826 sec for 8487091 iterations 0.005 usec (4.5917e-09 sec) per iteration: 0.0389702 sec for 8487091 iterations 0.005 usec (4.59942e-09 sec) per iteration: 0.0390357 sec for 8487091 iterations 0.005 usec (4.64238e-09 sec) per iteration: 0.0394003 sec for 8487091 iterations 0.005 usec (4.60339e-09 sec) per iteration: 0.0390694 sec for 8487091 iterations mean: 0.004611 usec stddev: 0.000018 usec relative stddev: 0.39% RESULT TestTlsVariable: x86-64_pnacl_sz_newlib_static= {0.004611, 0.000018} us TestMmapAnonymous: Measuring real time: 5.155 usec (5.1548e-06 sec) per iteration: 0.00051548 sec for 100 iterations 2.714 usec (2.71398e-06 sec) per iteration: 0.0526484 sec for 19399 iterations 2.719 usec (2.71926e-06 sec) per iteration: 0.0527509 sec for 19399 iterations 2.793 usec (2.7934e-06 sec) per iteration: 0.0541891 sec for 19399 iterations 2.787 usec (2.78727e-06 sec) per iteration: 0.0540702 sec for 19399 iterations 2.781 usec (2.78069e-06 sec) per iteration: 0.0539426 sec for 19399 iterations mean: 2.758918 usec stddev: 0.034811 usec relative stddev: 1.26% RESULT TestMmapAnonymous: x86-64_pnacl_sz_newlib_static= {2.758918, 0.034811} us TestAtomicIncrement: Measuring real time: 0.094 usec (9.393e-08 sec) per iteration: 9.393e-06 sec for 100 iterations 0.035 usec (3.5324e-08 sec) per iteration: 3.5324e-05 sec for 1000 iterations 0.008 usec (7.51325e-09 sec) per iteration: 0.0212695 sec for 2830936 iterations 0.008 usec (7.58773e-09 sec) per iteration: 0.0214804 sec for 2830936 iterations 0.007 usec (7.48935e-09 sec) per iteration: 0.0212019 sec for 2830936 iterations 0.007 usec (7.44831e-09 sec) per iteration: 0.0210857 sec for 2830936 iterations 0.008 usec (7.55583e-09 sec) per iteration: 0.0213901 sec for 2830936 iterations mean: 0.007519 usec stddev: 0.000049 usec relative stddev: 0.65% RESULT TestAtomicIncrement: x86-64_pnacl_sz_newlib_static= {0.007519, 0.000049} us TestUncontendedMutexLock: Measuring real time: 0.021 usec (2.115e-08 sec) per iteration: 2.115e-06 sec for 100 iterations 0.018 usec (1.7565e-08 sec) per iteration: 1.7565e-05 sec for 1000 iterations 0.017 usec (1.6912e-08 sec) per iteration: 0.0962826 sec for 5693139 iterations 0.017 usec (1.6981e-08 sec) per iteration: 0.0966754 sec for 5693139 iterations 0.017 usec (1.69821e-08 sec) per iteration: 0.0966816 sec for 5693139 iterations 0.017 usec (1.6923e-08 sec) per iteration: 0.0963448 sec for 5693139 iterations 0.017 usec (1.69646e-08 sec) per iteration: 0.0965819 sec for 5693139 iterations mean: 0.016953 usec stddev: 0.000029 usec relative stddev: 0.17% RESULT TestUncontendedMutexLock: x86-64_pnacl_sz_newlib_static= {0.016953, 0.000029} us TestCondvarSignalNoOp: Measuring real time: 0.194 usec (1.9377e-07 sec) per iteration: 1.9377e-05 sec for 100 iterations 0.124 usec (1.24443e-07 sec) per iteration: 0.0642218 sec for 516075 iterations 0.124 usec (1.2413e-07 sec) per iteration: 0.0640603 sec for 516075 iterations 0.125 usec (1.24707e-07 sec) per iteration: 0.064358 sec for 516075 iterations 0.124 usec (1.24226e-07 sec) per iteration: 0.0641099 sec for 516075 iterations 0.125 usec (1.24651e-07 sec) per iteration: 0.0643292 sec for 516075 iterations mean: 0.124431 usec stddev: 0.000227 usec relative stddev: 0.18% RESULT TestCondvarSignalNoOp: x86-64_pnacl_sz_newlib_static= {0.124431, 0.000227} us TestThreadCreateAndJoin: Measuring real time: 33.137 usec (3.31371e-05 sec) per iteration: 0.00331371 sec for 100 iterations 18.077 usec (1.80769e-05 sec) per iteration: 0.0545381 sec for 3017 iterations 18.215 usec (1.8215e-05 sec) per iteration: 0.0549546 sec for 3017 iterations 18.039 usec (1.80389e-05 sec) per iteration: 0.0544233 sec for 3017 iterations 18.046 usec (1.80455e-05 sec) per iteration: 0.0544434 sec for 3017 iterations 18.027 usec (1.80275e-05 sec) per iteration: 0.0543889 sec for 3017 iterations mean: 18.080762 usec stddev: 0.069077 usec relative stddev: 0.38% RESULT TestThreadCreateAndJoin: x86-64_pnacl_sz_newlib_static= {18.080762, 0.069077} us TestThreadWakeup: Measuring real time: 7.800 usec (7.8e-06 sec) per iteration: 0.00078 sec for 100 iterations 6.786 usec (6.78586e-06 sec) per iteration: 0.0869947 sec for 12820 iterations 6.796 usec (6.79612e-06 sec) per iteration: 0.0871262 sec for 12820 iterations 6.750 usec (6.74999e-06 sec) per iteration: 0.0865348 sec for 12820 iterations 6.703 usec (6.70341e-06 sec) per iteration: 0.0859377 sec for 12820 iterations 8.035 usec (8.03475e-06 sec) per iteration: 0.103006 sec for 12820 iterations mean: 7.014025 usec stddev: 0.511396 usec relative stddev: 7.29% RESULT TestThreadWakeup: x86-64_pnacl_sz_newlib_static= {7.014025, 0.511396} us TestCatchingFault: Measuring real time: 9.260 usec (9.25978e-06 sec) per iteration: 0.000925978 sec for 100 iterations 8.039 usec (8.03881e-06 sec) per iteration: 0.0868111 sec for 10799 iterations 8.009 usec (8.00926e-06 sec) per iteration: 0.086492 sec for 10799 iterations 8.334 usec (8.33404e-06 sec) per iteration: 0.0899993 sec for 10799 iterations 8.640 usec (8.64045e-06 sec) per iteration: 0.0933082 sec for 10799 iterations 8.575 usec (8.57524e-06 sec) per iteration: 0.0926041 sec for 10799 iterations mean: 8.319562 usec stddev: 0.262167 usec relative stddev: 3.15% RESULT TestCatchingFault: x86-64_pnacl_sz_newlib_static= {8.319562, 0.262167} us TestThreadCreateAndJoinAfterSettingFaultHandler: Measuring real time: 31.639 usec (3.16386e-05 sec) per iteration: 0.00316386 sec for 100 iterations 19.219 usec (1.92187e-05 sec) per iteration: 0.060731 sec for 3160 iterations 18.025 usec (1.80254e-05 sec) per iteration: 0.0569603 sec for 3160 iterations 18.073 usec (1.80726e-05 sec) per iteration: 0.0571093 sec for 3160 iterations 18.085 usec (1.80849e-05 sec) per iteration: 0.0571483 sec for 3160 iterations 18.032 usec (1.80321e-05 sec) per iteration: 0.0569814 sec for 3160 iterations mean: 18.286725 usec stddev: 0.466536 usec relative stddev: 2.55% RESULT TestThreadCreateAndJoinAfterSettingFaultHandler: x86-64_pnacl_sz_newlib_static= {18.286725, 0.466536} us [ OK ] pnacl_newlib.run_performance_test (4439 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