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 --clang nacl_clang=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', '--clang', 'nacl_clang=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 = 1544200471, usec = 196703 } Fri Dec 7 08:34:31 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 OBJ_ROOT: /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl-x86-64/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/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-x86-64/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_gdb_invalid_memory_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_stack_frame_noopt_frame_test *** BROKEN run_stack_frame_noopt_noframe_test *** BROKEN run_stack_frame_opt_frame_test *** BROKEN run_stack_frame_opt_noframe_test *** BROKEN run_vla_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 13 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 nacl_newlib.run_benchmark_test --time_warning 10 --time_error 100 --perf_env_description x86-64_nnacl_newlib_static --subarch 64 --arch x86 --capture_output 0 --output_stamp /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl-x86-64/test_results/benchmark_test.out scons-out/opt-mac-x86-64/staging/sel_ldr -- scons-out/nacl-x86-64/obj/tests/benchmark/benchmark_test.nexe x86-64_nnacl_newlib_static [ RUN ] nacl_newlib.run_benchmark_test scons-out/opt-mac-x86-64/staging/sel_ldr -- scons-out/nacl-x86-64/obj/tests/benchmark/benchmark_test.nexe x86-64_nnacl_newlib_static [48624,2528035712:12:29:47.540960] Native Client module will be loaded at base address 0x00001a4600000000 Running suite of 1 benchmarks: Running Benchmark: Life (SIMD version)... RESULT BenchmarkLife: x86-64_nnacl_newlib_static= {0.066210, 0.021830} seconds --------------------------------------------------------------- Done running benchmark suite. [ OK ] nacl_newlib.run_benchmark_test (880 ms) /b/s/w/ir/cache/vpython/7c7ecd/bin/python tools/command_tester.py --name nacl_newlib.run_clock_cputime_test --time_warning 60 --time_error 600 --perf_env_description x86-64_nnacl_newlib_static --subarch 64 --arch x86 --output_stamp /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl-x86-64/test_results/clock_cputime_test.out scons-out/opt-mac-x86-64/staging/sel_ldr -- scons-out/nacl-x86-64/obj/tests/clock/clock_test.nexe -c [ RUN ] nacl_newlib.run_clock_cputime_test scons-out/opt-mac-x86-64/staging/sel_ldr -- scons-out/nacl-x86-64/obj/tests/clock/clock_test.nexe -c WARNING: should have taken less than 60.000000 secs [ OK ] nacl_newlib.run_clock_cputime_test (66100 ms) doSizeCheck(["scons-out/nacl-x86-64/obj/tests/hello_world/hello_world_size.out"], ["scons-out/nacl-x86-64/obj/tests/hello_world/hello_world.nexe"]) RESULT hello_world_size.out: x86-64_nnacl_newlib_static= 528.080 KB RESULT hello_world_size.out: ZIPPED_x86-64_nnacl_newlib_static= 187.899 KB /b/s/w/ir/cache/vpython/7c7ecd/bin/python tools/command_tester.py --name nacl_newlib.run_performance_test --time_warning 10 --time_error 100 --perf_env_description x86-64_nnacl_newlib_static --subarch 64 --arch x86 --capture_output 0 --output_stamp /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl-x86-64/test_results/performance_test.out scons-out/opt-mac-x86-64/staging/sel_ldr -e -- scons-out/nacl-x86-64/obj/tests/performance/performance_test.nexe x86-64_nnacl_newlib_static [ RUN ] nacl_newlib.run_performance_test scons-out/opt-mac-x86-64/staging/sel_ldr -e -- scons-out/nacl-x86-64/obj/tests/performance/performance_test.nexe x86-64_nnacl_newlib_static [48629,2528035712:12:30:01.645604] Native Client module will be loaded at base address 0x00004d7d00000000 TestNull: Measuring real time: 0.007 usec (6.79e-09 sec) per iteration: 6.79e-07 sec for 100 iterations 0.002 usec (2.259e-09 sec) per iteration: 2.259e-06 sec for 1000 iterations 0.003 usec (2.5622e-09 sec) per iteration: 2.5622e-05 sec for 10000 iterations 0.002 usec (2.03185e-09 sec) per iteration: 0.0793008 sec for 39028959 iterations 0.002 usec (1.97584e-09 sec) per iteration: 0.0771149 sec for 39028959 iterations 0.002 usec (2.00546e-09 sec) per iteration: 0.0782709 sec for 39028959 iterations 0.002 usec (2.02074e-09 sec) per iteration: 0.0788674 sec for 39028959 iterations 0.002 usec (2.01183e-09 sec) per iteration: 0.0785196 sec for 39028959 iterations mean: 0.002009 usec stddev: 0.000019 usec relative stddev: 0.94% RESULT TestNull: x86-64_nnacl_newlib_static= {0.002009, 0.000019} us Measuring clock cycles: first runs (cycles): 261 18 30 30 30 30 21 21 21 21 ... slowest runs (cycles): ... 30 30 30 30 30 30 30 30 30 261 min: 18 cycles q1: 21 cycles median: 21 cycles q3: 30 cycles max: 261 cycles RESULT TestNull_CycleCount: x86-64_nnacl_newlib_static= {21, 9} count Apparent clock speed: 10452 MHz TestNaClSyscall: Measuring real time: 0.159 usec (1.5921e-07 sec) per iteration: 1.5921e-05 sec for 100 iterations 0.158 usec (1.58154e-07 sec) per iteration: 0.0993365 sec for 628101 iterations 0.152 usec (1.5194e-07 sec) per iteration: 0.0954339 sec for 628101 iterations 0.156 usec (1.556e-07 sec) per iteration: 0.0977326 sec for 628101 iterations 0.154 usec (1.54058e-07 sec) per iteration: 0.0967641 sec for 628101 iterations 0.156 usec (1.55656e-07 sec) per iteration: 0.0977677 sec for 628101 iterations mean: 0.155082 usec stddev: 0.002047 usec relative stddev: 1.32% RESULT TestNaClSyscall: x86-64_nnacl_newlib_static= {0.155082, 0.002047} us Measuring clock cycles: first runs (cycles): 753 300 276 279 291 291 291 291 291 276 ... slowest runs (cycles): ... 294 294 294 294 294 294 297 300 300 753 min: 273 cycles q1: 276 cycles median: 291 cycles q3: 291 cycles max: 753 cycles RESULT TestNaClSyscall_CycleCount: x86-64_nnacl_newlib_static= {291, 15} count Apparent clock speed: 1876 MHz TestSetjmpLongjmp: Measuring real time: 0.016 usec (1.623e-08 sec) per iteration: 1.623e-06 sec for 100 iterations 0.012 usec (1.2401e-08 sec) per iteration: 1.2401e-05 sec for 1000 iterations 0.012 usec (1.19857e-08 sec) per iteration: 0.0966514 sec for 8063865 iterations 0.012 usec (1.19615e-08 sec) per iteration: 0.0964562 sec for 8063865 iterations 0.013 usec (1.25248e-08 sec) per iteration: 0.100999 sec for 8063865 iterations 0.012 usec (1.23067e-08 sec) per iteration: 0.0992394 sec for 8063865 iterations 0.012 usec (1.20022e-08 sec) per iteration: 0.0967843 sec for 8063865 iterations mean: 0.012156 usec stddev: 0.000223 usec relative stddev: 1.84% RESULT TestSetjmpLongjmp: x86-64_nnacl_newlib_static= {0.012156, 0.000223} us Measuring clock cycles: first runs (cycles): 414 57 33 24 21 24 33 33 33 24 ... slowest runs (cycles): ... 36 36 36 36 36 36 36 36 57 414 min: 21 cycles q1: 24 cycles median: 33 cycles q3: 33 cycles max: 414 cycles RESULT TestSetjmpLongjmp_CycleCount: x86-64_nnacl_newlib_static= {33, 9} count Apparent clock speed: 2715 MHz TestClockGetTime: Measuring real time: 0.164 usec (1.6396e-07 sec) per iteration: 1.6396e-05 sec for 100 iterations 0.157 usec (1.57001e-07 sec) per iteration: 0.0957556 sec for 609904 iterations 0.157 usec (1.57231e-07 sec) per iteration: 0.0958958 sec for 609904 iterations 0.155 usec (1.55454e-07 sec) per iteration: 0.0948123 sec for 609904 iterations 0.153 usec (1.52753e-07 sec) per iteration: 0.0931648 sec for 609904 iterations 0.160 usec (1.59543e-07 sec) per iteration: 0.0973062 sec for 609904 iterations mean: 0.156397 usec stddev: 0.002242 usec relative stddev: 1.43% RESULT TestClockGetTime: x86-64_nnacl_newlib_static= {0.156397, 0.002242} us Measuring clock cycles: first runs (cycles): 1221 426 399 405 408 405 408 405 405 402 ... slowest runs (cycles): ... 405 405 405 405 408 408 408 411 426 1221 min: 390 cycles q1: 399 cycles median: 402 cycles q3: 405 cycles max: 1221 cycles RESULT TestClockGetTime_CycleCount: x86-64_nnacl_newlib_static= {402, 6} count Apparent clock speed: 2570 MHz TestTlsVariable: Measuring real time: 0.010 usec (9.74e-09 sec) per iteration: 9.74e-07 sec for 100 iterations 0.006 usec (6.267e-09 sec) per iteration: 6.267e-06 sec for 1000 iterations 0.006 usec (6.0273e-09 sec) per iteration: 6.0273e-05 sec for 10000 iterations 0.006 usec (5.93671e-09 sec) per iteration: 0.0984969 sec for 16591176 iterations 0.006 usec (6.23836e-09 sec) per iteration: 0.103502 sec for 16591176 iterations 0.006 usec (6.4074e-09 sec) per iteration: 0.106306 sec for 16591176 iterations 0.006 usec (5.91318e-09 sec) per iteration: 0.0981067 sec for 16591176 iterations 0.006 usec (5.85125e-09 sec) per iteration: 0.0970792 sec for 16591176 iterations mean: 0.006069 usec stddev: 0.000216 usec relative stddev: 3.55% RESULT TestTlsVariable: x86-64_nnacl_newlib_static= {0.006069, 0.000216} us Measuring clock cycles: first runs (cycles): 336 63 24 24 27 21 24 24 21 24 ... slowest runs (cycles): ... 24 24 24 24 24 24 24 27 63 336 min: 21 cycles q1: 24 cycles median: 24 cycles q3: 24 cycles max: 336 cycles RESULT TestTlsVariable_CycleCount: x86-64_nnacl_newlib_static= {24, 0} count Apparent clock speed: 3954 MHz TestMmapAnonymous: Measuring real time: 10.151 usec (1.01507e-05 sec) per iteration: 0.00101507 sec for 100 iterations 8.273 usec (8.27274e-06 sec) per iteration: 0.0814948 sec for 9851 iterations 8.140 usec (8.13988e-06 sec) per iteration: 0.080186 sec for 9851 iterations 8.530 usec (8.53008e-06 sec) per iteration: 0.0840298 sec for 9851 iterations 8.745 usec (8.7448e-06 sec) per iteration: 0.086145 sec for 9851 iterations 8.375 usec (8.37498e-06 sec) per iteration: 0.0825019 sec for 9851 iterations mean: 8.412497 usec stddev: 0.209527 usec relative stddev: 2.49% RESULT TestMmapAnonymous: x86-64_nnacl_newlib_static= {8.412497, 0.209527} us Measuring clock cycles: first runs (cycles): 31044 62583 23523 23217 23304 23232 23019 23076 22977 23115 ... slowest runs (cycles): ... 23148 23160 23217 23232 23268 23304 23313 23523 31044 62583 min: 22761 cycles q1: 22854 cycles median: 22920 cycles q3: 23028 cycles max: 62583 cycles RESULT TestMmapAnonymous_CycleCount: x86-64_nnacl_newlib_static= {22920, 174} count Apparent clock speed: 2725 MHz TestAtomicIncrement: Measuring real time: 0.014 usec (1.4e-08 sec) per iteration: 1.4e-06 sec for 100 iterations 0.010 usec (9.912e-09 sec) per iteration: 9.912e-06 sec for 1000 iterations 0.010 usec (9.6904e-09 sec) per iteration: 9.6904e-05 sec for 10000 iterations 0.010 usec (9.62335e-09 sec) per iteration: 0.0993081 sec for 10319491 iterations 0.009 usec (9.32156e-09 sec) per iteration: 0.0961938 sec for 10319491 iterations 0.009 usec (9.39783e-09 sec) per iteration: 0.0969808 sec for 10319491 iterations 0.011 usec (1.0879e-08 sec) per iteration: 0.112266 sec for 10319491 iterations 0.010 usec (9.55788e-09 sec) per iteration: 0.0986324 sec for 10319491 iterations mean: 0.009756 usec stddev: 0.000572 usec relative stddev: 5.86% RESULT TestAtomicIncrement: x86-64_nnacl_newlib_static= {0.009756, 0.000572} us Measuring clock cycles: first runs (cycles): 270 51 39 48 51 48 51 48 51 48 ... slowest runs (cycles): ... 51 51 51 51 51 51 51 54 72 270 min: 39 cycles q1: 48 cycles median: 51 cycles q3: 51 cycles max: 270 cycles RESULT TestAtomicIncrement_CycleCount: x86-64_nnacl_newlib_static= {51, 3} count Apparent clock speed: 5228 MHz TestUncontendedMutexLock: Measuring real time: 0.028 usec (2.8e-08 sec) per iteration: 2.8e-06 sec for 100 iterations 0.023 usec (2.3269e-08 sec) per iteration: 2.3269e-05 sec for 1000 iterations 0.024 usec (2.43618e-08 sec) per iteration: 0.104696 sec for 4297563 iterations 0.024 usec (2.3794e-08 sec) per iteration: 0.102256 sec for 4297563 iterations 0.023 usec (2.27436e-08 sec) per iteration: 0.0977421 sec for 4297563 iterations 0.023 usec (2.29304e-08 sec) per iteration: 0.0985449 sec for 4297563 iterations 0.023 usec (2.27195e-08 sec) per iteration: 0.0976385 sec for 4297563 iterations mean: 0.023310 usec stddev: 0.000656 usec relative stddev: 2.82% RESULT TestUncontendedMutexLock: x86-64_nnacl_newlib_static= {0.023310, 0.000656} us Measuring clock cycles: first runs (cycles): 465 111 90 90 90 90 90 90 81 81 ... slowest runs (cycles): ... 90 90 90 90 90 90 90 90 111 465 min: 81 cycles q1: 81 cycles median: 90 cycles q3: 90 cycles max: 465 cycles RESULT TestUncontendedMutexLock_CycleCount: x86-64_nnacl_newlib_static= {90, 9} count Apparent clock speed: 3861 MHz TestCondvarSignalNoOp: Measuring real time: 0.288 usec (2.8817e-07 sec) per iteration: 2.8817e-05 sec for 100 iterations 0.158 usec (1.57934e-07 sec) per iteration: 0.0548056 sec for 347017 iterations 0.157 usec (1.56523e-07 sec) per iteration: 0.0543162 sec for 347017 iterations 0.153 usec (1.53268e-07 sec) per iteration: 0.0531866 sec for 347017 iterations 0.156 usec (1.55689e-07 sec) per iteration: 0.0540266 sec for 347017 iterations 0.156 usec (1.55856e-07 sec) per iteration: 0.0540847 sec for 347017 iterations mean: 0.155854 usec stddev: 0.001516 usec relative stddev: 0.97% RESULT TestCondvarSignalNoOp: x86-64_nnacl_newlib_static= {0.155854, 0.001516} us Measuring clock cycles: first runs (cycles): 1455 438 435 438 435 438 438 438 444 435 ... slowest runs (cycles): ... 444 444 444 444 444 447 447 447 447 1455 min: 435 cycles q1: 435 cycles median: 435 cycles q3: 438 cycles max: 1455 cycles RESULT TestCondvarSignalNoOp_CycleCount: x86-64_nnacl_newlib_static= {435, 3} count Apparent clock speed: 2791 MHz TestThreadCreateAndJoin: Measuring real time: 66.971 usec (6.69714e-05 sec) per iteration: 0.00669714 sec for 100 iterations 64.446 usec (6.44457e-05 sec) per iteration: 0.0962175 sec for 1493 iterations 62.496 usec (6.2496e-05 sec) per iteration: 0.0933066 sec for 1493 iterations 63.482 usec (6.34822e-05 sec) per iteration: 0.094779 sec for 1493 iterations 64.625 usec (6.46253e-05 sec) per iteration: 0.0964855 sec for 1493 iterations 64.257 usec (6.42567e-05 sec) per iteration: 0.0959352 sec for 1493 iterations mean: 63.861182 usec stddev: 0.786021 usec relative stddev: 1.23% RESULT TestThreadCreateAndJoin: x86-64_nnacl_newlib_static= {63.861182, 0.786021} us Measuring clock cycles: first runs (cycles): 239274 204819 221343 260460 360639 198513 192753 175842 173496 172278 ... slowest runs (cycles): ... 190122 192753 198513 201435 204819 208815 221343 239274 260460 360639 min: 167436 cycles q1: 170112 cycles median: 171180 cycles q3: 173103 cycles max: 360639 cycles RESULT TestThreadCreateAndJoin_CycleCount: x86-64_nnacl_newlib_static= {171180, 2991} count Apparent clock speed: 2681 MHz TestThreadWakeup: Measuring real time: 31.057 usec (3.10572e-05 sec) per iteration: 0.00310572 sec for 100 iterations 30.654 usec (3.06544e-05 sec) per iteration: 0.0986766 sec for 3219 iterations 31.293 usec (3.12926e-05 sec) per iteration: 0.100731 sec for 3219 iterations 30.839 usec (3.08395e-05 sec) per iteration: 0.0992723 sec for 3219 iterations 30.356 usec (3.03565e-05 sec) per iteration: 0.0977174 sec for 3219 iterations 30.351 usec (3.03511e-05 sec) per iteration: 0.0977001 sec for 3219 iterations mean: 30.698809 usec stddev: 0.349983 usec relative stddev: 1.14% RESULT TestThreadWakeup: x86-64_nnacl_newlib_static= {30.698809, 0.349983} us Measuring clock cycles: first runs (cycles): 122946 178377 59868 104787 99906 138357 83007 92178 75324 91929 ... slowest runs (cycles): ... 99135 99906 104106 104712 104787 122946 129888 135831 138357 178377 min: 59868 cycles q1: 82305 cycles median: 82992 cycles q3: 83967 cycles max: 178377 cycles RESULT TestThreadWakeup_CycleCount: x86-64_nnacl_newlib_static= {82992, 1662} count Apparent clock speed: 2703 MHz TestCatchingFault: Measuring real time: 32.733 usec (3.27331e-05 sec) per iteration: 0.00327331 sec for 100 iterations 30.815 usec (3.08154e-05 sec) per iteration: 0.0941412 sec for 3055 iterations 29.846 usec (2.98459e-05 sec) per iteration: 0.0911792 sec for 3055 iterations 30.931 usec (3.09307e-05 sec) per iteration: 0.0944932 sec for 3055 iterations 30.673 usec (3.06727e-05 sec) per iteration: 0.093705 sec for 3055 iterations 30.402 usec (3.04023e-05 sec) per iteration: 0.092879 sec for 3055 iterations mean: 30.533392 usec stddev: 0.386416 usec relative stddev: 1.27% RESULT TestCatchingFault: x86-64_nnacl_newlib_static= {30.533392, 0.386416} us Measuring clock cycles: first runs (cycles): 103029 86844 104700 129552 115323 98889 111288 109071 106959 99006 ... slowest runs (cycles): ... 99006 100311 102927 103029 104700 106959 109071 111288 115323 129552 min: 79788 cycles q1: 80946 cycles median: 81453 cycles q3: 82353 cycles max: 129552 cycles RESULT TestCatchingFault_CycleCount: x86-64_nnacl_newlib_static= {81453, 1407} count Apparent clock speed: 2668 MHz TestThreadCreateAndJoinAfterSettingFaultHandler: Measuring real time: 64.848 usec (6.48478e-05 sec) per iteration: 0.00648478 sec for 100 iterations 63.502 usec (6.35021e-05 sec) per iteration: 0.0979202 sec for 1542 iterations 65.745 usec (6.57449e-05 sec) per iteration: 0.101379 sec for 1542 iterations 63.409 usec (6.34094e-05 sec) per iteration: 0.0977773 sec for 1542 iterations 61.123 usec (6.11232e-05 sec) per iteration: 0.094252 sec for 1542 iterations 64.473 usec (6.44728e-05 sec) per iteration: 0.099417 sec for 1542 iterations mean: 63.650450 usec stddev: 1.518544 usec relative stddev: 2.39% RESULT TestThreadCreateAndJoinAfterSettingFaultHandler: x86-64_nnacl_newlib_static= {63.650450, 1.518544} us Measuring clock cycles: first runs (cycles): 171093 234096 176736 221955 193497 193200 231093 195504 177396 174231 ... slowest runs (cycles): ... 193200 193497 195504 200736 205365 208167 208803 221955 231093 234096 min: 159816 cycles q1: 167334 cycles median: 168831 cycles q3: 171090 cycles max: 234096 cycles RESULT TestThreadCreateAndJoinAfterSettingFaultHandler_CycleCount: x86-64_nnacl_newlib_static= {168831, 3756} count Apparent clock speed: 2652 MHz [ OK ] nacl_newlib.run_performance_test (6350 ms) scons: done building targets. ********************************************************************** COMMAND EXECUTION REPORT ********************************************************************** 3 command_tester.py 1 doSizeCheck ********************************************************************** ENVIRONMENT USAGE REPORT ********************************************************************** 4 nacl-x86-64 Command return code: 0