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: 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 = 1545161621, usec = 509533 } Tue Dec 18 11:33:41 2018 ====================================================================== The following environments have been configured ====================================================================== NACL_BUILD_FAMILY: UNTRUSTED BUILD_TYPE: nacl TARGET_ROOT: /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl-x86-64-pnacl-subzero-pexe-clang OBJ_ROOT: /b/s/w/ir/kitchen-workdir/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/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-subzero-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_sz_newlib_static --subarch 64 --arch x86 --time_error 1000 --capture_output 0 --output_stamp /b/s/w/ir/kitchen-workdir/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 [62557,2557584256:17:35:42.817031] Native Client module will be loaded at base address 0x00007b2200000000 Running suite of 1 benchmarks: Running Benchmark: Life (SIMD version)... RESULT BenchmarkLife: x86-64_pnacl_sz_newlib_static= {4.649020, 0.018530} seconds --------------------------------------------------------------- Done running benchmark suite. WARNING: should have taken less than 10.000000 secs [ OK ] pnacl_newlib.run_benchmark_test (54260 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/kitchen-workdir/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 (67100 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.605 KB RESULT hello_world_size.out: ZIPPED_x86-64_pnacl_sz_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_sz_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-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 [62569,2557584256:17:36:16.372352] Native Client module will be loaded at base address 0x000036c700000000 TestNull: Measuring real time: 0.007 usec (7.16e-09 sec) per iteration: 7.16e-07 sec for 100 iterations 0.002 usec (1.849e-09 sec) per iteration: 1.849e-06 sec for 1000 iterations 0.001 usec (1.3524e-09 sec) per iteration: 1.3524e-05 sec for 10000 iterations 0.001 usec (1.45915e-09 sec) per iteration: 0.107894 sec for 73942620 iterations 0.001 usec (1.41741e-09 sec) per iteration: 0.104807 sec for 73942620 iterations 0.001 usec (1.42629e-09 sec) per iteration: 0.105463 sec for 73942620 iterations 0.001 usec (1.41383e-09 sec) per iteration: 0.104542 sec for 73942620 iterations 0.001 usec (1.40334e-09 sec) per iteration: 0.103767 sec for 73942620 iterations mean: 0.001424 usec stddev: 0.000019 usec relative stddev: 1.34% RESULT TestNull: x86-64_pnacl_sz_newlib_static= {0.001424, 0.000019} us TestNaClSyscall: Measuring real time: 0.110 usec (1.0976e-07 sec) per iteration: 1.0976e-05 sec for 100 iterations 0.104 usec (1.03625e-07 sec) per iteration: 0.0944105 sec for 911078 iterations 0.103 usec (1.03464e-07 sec) per iteration: 0.0942639 sec for 911078 iterations 0.103 usec (1.03456e-07 sec) per iteration: 0.0942567 sec for 911078 iterations 0.103 usec (1.03478e-07 sec) per iteration: 0.0942769 sec for 911078 iterations 0.104 usec (1.03633e-07 sec) per iteration: 0.0944179 sec for 911078 iterations mean: 0.103531 usec stddev: 0.000080 usec relative stddev: 0.08% RESULT TestNaClSyscall: x86-64_pnacl_sz_newlib_static= {0.103531, 0.000080} us TestSetjmpLongjmp: Measuring real time: 0.014 usec (1.429e-08 sec) per iteration: 1.429e-06 sec for 100 iterations 0.014 usec (1.4091e-08 sec) per iteration: 1.4091e-05 sec for 1000 iterations 0.011 usec (1.10605e-08 sec) per iteration: 0.0784934 sec for 7096728 iterations 0.011 usec (1.10861e-08 sec) per iteration: 0.0786748 sec for 7096728 iterations 0.011 usec (1.10739e-08 sec) per iteration: 0.0785883 sec for 7096728 iterations 0.011 usec (1.10368e-08 sec) per iteration: 0.0783252 sec for 7096728 iterations 0.011 usec (1.10727e-08 sec) per iteration: 0.0785801 sec for 7096728 iterations mean: 0.011066 usec stddev: 0.000017 usec relative stddev: 0.15% RESULT TestSetjmpLongjmp: x86-64_pnacl_sz_newlib_static= {0.011066, 0.000017} us TestClockGetTime: Measuring real time: 0.160 usec (1.6035e-07 sec) per iteration: 1.6035e-05 sec for 100 iterations 0.157 usec (1.57423e-07 sec) per iteration: 0.0981745 sec for 623635 iterations 0.158 usec (1.57854e-07 sec) per iteration: 0.0984436 sec for 623635 iterations 0.158 usec (1.57927e-07 sec) per iteration: 0.0984887 sec for 623635 iterations 0.157 usec (1.57399e-07 sec) per iteration: 0.0981596 sec for 623635 iterations 0.158 usec (1.57705e-07 sec) per iteration: 0.0983505 sec for 623635 iterations mean: 0.157662 usec stddev: 0.000217 usec relative stddev: 0.14% RESULT TestClockGetTime: x86-64_pnacl_sz_newlib_static= {0.157662, 0.000217} us TestTlsVariable: Measuring real time: 0.009 usec (9.02e-09 sec) per iteration: 9.02e-07 sec for 100 iterations 0.006 usec (5.577e-09 sec) per iteration: 5.577e-06 sec for 1000 iterations 0.007 usec (6.9634e-09 sec) per iteration: 6.9634e-05 sec for 10000 iterations 0.005 usec (5.42136e-09 sec) per iteration: 0.077855 sec for 14360800 iterations 0.005 usec (5.37701e-09 sec) per iteration: 0.0772181 sec for 14360800 iterations 0.005 usec (5.43005e-09 sec) per iteration: 0.0779798 sec for 14360800 iterations 0.005 usec (5.38553e-09 sec) per iteration: 0.0773405 sec for 14360800 iterations 0.005 usec (5.37365e-09 sec) per iteration: 0.0771699 sec for 14360800 iterations mean: 0.005398 usec stddev: 0.000023 usec relative stddev: 0.44% RESULT TestTlsVariable: x86-64_pnacl_sz_newlib_static= {0.005398, 0.000023} us TestMmapAnonymous: Measuring real time: 5.957 usec (5.95691e-06 sec) per iteration: 0.000595691 sec for 100 iterations 4.932 usec (4.93154e-06 sec) per iteration: 0.0827858 sec for 16787 iterations 4.937 usec (4.93735e-06 sec) per iteration: 0.0828832 sec for 16787 iterations 4.948 usec (4.94752e-06 sec) per iteration: 0.083054 sec for 16787 iterations 5.087 usec (5.08698e-06 sec) per iteration: 0.0853952 sec for 16787 iterations 4.901 usec (4.90087e-06 sec) per iteration: 0.0822708 sec for 16787 iterations mean: 4.960851 usec stddev: 0.064956 usec relative stddev: 1.31% RESULT TestMmapAnonymous: x86-64_pnacl_sz_newlib_static= {4.960851, 0.064956} us TestAtomicIncrement: Measuring real time: 0.013 usec (1.335e-08 sec) per iteration: 1.335e-06 sec for 100 iterations 0.009 usec (8.861e-09 sec) per iteration: 8.861e-06 sec for 1000 iterations 0.010 usec (9.7484e-09 sec) per iteration: 9.7484e-05 sec for 10000 iterations 0.009 usec (8.68673e-09 sec) per iteration: 0.0891093 sec for 10258093 iterations 0.009 usec (8.70141e-09 sec) per iteration: 0.0892599 sec for 10258093 iterations 0.009 usec (8.71601e-09 sec) per iteration: 0.0894096 sec for 10258093 iterations 0.009 usec (8.6917e-09 sec) per iteration: 0.0891603 sec for 10258093 iterations 0.009 usec (8.72654e-09 sec) per iteration: 0.0895176 sec for 10258093 iterations mean: 0.008704 usec stddev: 0.000015 usec relative stddev: 0.17% RESULT TestAtomicIncrement: x86-64_pnacl_sz_newlib_static= {0.008704, 0.000015} us TestUncontendedMutexLock: Measuring real time: 0.024 usec (2.42e-08 sec) per iteration: 2.42e-06 sec for 100 iterations 0.020 usec (1.9931e-08 sec) per iteration: 1.9931e-05 sec for 1000 iterations 0.020 usec (1.97346e-08 sec) per iteration: 0.0990148 sec for 5017309 iterations 0.020 usec (1.97514e-08 sec) per iteration: 0.099099 sec for 5017309 iterations 0.020 usec (1.97122e-08 sec) per iteration: 0.0989024 sec for 5017309 iterations 0.020 usec (1.97267e-08 sec) per iteration: 0.098975 sec for 5017309 iterations 0.020 usec (1.97434e-08 sec) per iteration: 0.0990586 sec for 5017309 iterations mean: 0.019734 usec stddev: 0.000014 usec relative stddev: 0.07% RESULT TestUncontendedMutexLock: x86-64_pnacl_sz_newlib_static= {0.019734, 0.000014} us TestCondvarSignalNoOp: Measuring real time: 0.220 usec (2.2046e-07 sec) per iteration: 2.2046e-05 sec for 100 iterations 0.152 usec (1.52208e-07 sec) per iteration: 0.0690412 sec for 453597 iterations 0.152 usec (1.5218e-07 sec) per iteration: 0.0690284 sec for 453597 iterations 0.152 usec (1.52363e-07 sec) per iteration: 0.0691115 sec for 453597 iterations 0.155 usec (1.55111e-07 sec) per iteration: 0.0703577 sec for 453597 iterations 0.153 usec (1.52592e-07 sec) per iteration: 0.0692153 sec for 453597 iterations mean: 0.152891 usec stddev: 0.001120 usec relative stddev: 0.73% RESULT TestCondvarSignalNoOp: x86-64_pnacl_sz_newlib_static= {0.152891, 0.001120} us TestThreadCreateAndJoin: Measuring real time: 54.316 usec (5.43155e-05 sec) per iteration: 0.00543155 sec for 100 iterations 44.791 usec (4.4791e-05 sec) per iteration: 0.0824603 sec for 1841 iterations 44.673 usec (4.46732e-05 sec) per iteration: 0.0822433 sec for 1841 iterations 41.603 usec (4.16029e-05 sec) per iteration: 0.0765909 sec for 1841 iterations 38.833 usec (3.88328e-05 sec) per iteration: 0.0714912 sec for 1841 iterations 40.588 usec (4.05883e-05 sec) per iteration: 0.0747231 sec for 1841 iterations mean: 42.097647 usec stddev: 2.326786 usec relative stddev: 5.53% RESULT TestThreadCreateAndJoin: x86-64_pnacl_sz_newlib_static= {42.097647, 2.326786} us TestThreadWakeup: Measuring real time: 13.733 usec (1.37326e-05 sec) per iteration: 0.00137326 sec for 100 iterations 11.359 usec (1.13586e-05 sec) per iteration: 0.0827019 sec for 7281 iterations 11.761 usec (1.1761e-05 sec) per iteration: 0.0856315 sec for 7281 iterations 11.459 usec (1.14592e-05 sec) per iteration: 0.0834347 sec for 7281 iterations 11.521 usec (1.15213e-05 sec) per iteration: 0.0838863 sec for 7281 iterations 11.586 usec (1.15857e-05 sec) per iteration: 0.0843553 sec for 7281 iterations mean: 11.537142 usec stddev: 0.134648 usec relative stddev: 1.17% RESULT TestThreadWakeup: x86-64_pnacl_sz_newlib_static= {11.537142, 0.134648} us TestCatchingFault: Measuring real time: 17.208 usec (1.72076e-05 sec) per iteration: 0.00172076 sec for 100 iterations 15.174 usec (1.51738e-05 sec) per iteration: 0.088175 sec for 5811 iterations 15.212 usec (1.52116e-05 sec) per iteration: 0.0883944 sec for 5811 iterations 15.291 usec (1.52914e-05 sec) per iteration: 0.0888586 sec for 5811 iterations 15.221 usec (1.52212e-05 sec) per iteration: 0.0884502 sec for 5811 iterations 15.797 usec (1.57973e-05 sec) per iteration: 0.091798 sec for 5811 iterations mean: 15.339053 usec stddev: 0.232250 usec relative stddev: 1.51% RESULT TestCatchingFault: x86-64_pnacl_sz_newlib_static= {15.339053, 0.232250} us TestThreadCreateAndJoinAfterSettingFaultHandler: Measuring real time: 39.353 usec (3.93529e-05 sec) per iteration: 0.00393529 sec for 100 iterations 39.187 usec (3.91875e-05 sec) per iteration: 0.0995754 sec for 2541 iterations 38.267 usec (3.8267e-05 sec) per iteration: 0.0972364 sec for 2541 iterations 38.219 usec (3.82194e-05 sec) per iteration: 0.0971154 sec for 2541 iterations 38.480 usec (3.84798e-05 sec) per iteration: 0.0977771 sec for 2541 iterations 38.085 usec (3.80845e-05 sec) per iteration: 0.0967727 sec for 2541 iterations mean: 38.447627 usec stddev: 0.391151 usec relative stddev: 1.02% RESULT TestThreadCreateAndJoinAfterSettingFaultHandler: x86-64_pnacl_sz_newlib_static= {38.447627, 0.391151} us [ OK ] pnacl_newlib.run_performance_test (6130 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