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 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', '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.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 = 1554684831, usec = 268127 } Sun Apr 7 17:53:51 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 OBJ_ROOT: /b/s/w/ir/k/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/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-x86-64/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_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/k/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 [50935,2794419072:05:14:24.791475] Native Client module will be loaded at base address 0x0000640d00000000 Running suite of 1 benchmarks: Running Benchmark: Life (SIMD version)... RESULT BenchmarkLife: x86-64_nnacl_newlib_static= {0.065630, 0.001650} seconds --------------------------------------------------------------- Done running benchmark suite. [ OK ] nacl_newlib.run_benchmark_test (840 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/k/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 (66120 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= 524.896 KB RESULT hello_world_size.out: ZIPPED_x86-64_nnacl_newlib_static= 187.825 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/k/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 [50944,2794419072:05:14:38.917254] Native Client module will be loaded at base address 0x0000395400000000 TestNull: Measuring real time: 0.007 usec (7.39e-09 sec) per iteration: 7.39e-07 sec for 100 iterations 0.002 usec (2.334e-09 sec) per iteration: 2.334e-06 sec for 1000 iterations 0.002 usec (2.026e-09 sec) per iteration: 2.026e-05 sec for 10000 iterations 0.002 usec (2.00298e-09 sec) per iteration: 0.0988639 sec for 49358341 iterations 0.002 usec (1.98211e-09 sec) per iteration: 0.0978338 sec for 49358341 iterations 0.002 usec (1.98147e-09 sec) per iteration: 0.0978019 sec for 49358341 iterations 0.002 usec (2.00386e-09 sec) per iteration: 0.0989072 sec for 49358341 iterations 0.002 usec (1.98978e-09 sec) per iteration: 0.0982123 sec for 49358341 iterations mean: 0.001992 usec stddev: 0.000010 usec relative stddev: 0.49% RESULT TestNull: x86-64_nnacl_newlib_static= {0.001992, 0.000010} us Measuring clock cycles: first runs (cycles): 222 33 30 21 30 21 21 21 21 30 ... slowest runs (cycles): ... 30 30 30 30 30 30 30 30 33 222 min: 21 cycles q1: 21 cycles median: 21 cycles q3: 21 cycles max: 222 cycles RESULT TestNull_CycleCount: x86-64_nnacl_newlib_static= {21, 0} count Apparent clock speed: 10542 MHz TestNaClSyscall: Measuring real time: 0.151 usec (1.5093e-07 sec) per iteration: 1.5093e-05 sec for 100 iterations 0.155 usec (1.54518e-07 sec) per iteration: 0.102377 sec for 662558 iterations 0.156 usec (1.55878e-07 sec) per iteration: 0.103278 sec for 662558 iterations 0.156 usec (1.56214e-07 sec) per iteration: 0.103501 sec for 662558 iterations 0.154 usec (1.53673e-07 sec) per iteration: 0.101817 sec for 662558 iterations 0.165 usec (1.64731e-07 sec) per iteration: 0.109144 sec for 662558 iterations mean: 0.157003 usec stddev: 0.003972 usec relative stddev: 2.53% RESULT TestNaClSyscall: x86-64_nnacl_newlib_static= {0.157003, 0.003972} us Measuring clock cycles: first runs (cycles): 744 339 291 291 297 297 306 306 309 306 ... slowest runs (cycles): ... 309 309 309 309 309 312 312 315 339 744 min: 291 cycles q1: 297 cycles median: 306 cycles q3: 306 cycles max: 744 cycles RESULT TestNaClSyscall_CycleCount: x86-64_nnacl_newlib_static= {306, 9} count Apparent clock speed: 1949 MHz TestSetjmpLongjmp: Measuring real time: 0.017 usec (1.675e-08 sec) per iteration: 1.675e-06 sec for 100 iterations 0.012 usec (1.2387e-08 sec) per iteration: 1.2387e-05 sec for 1000 iterations 0.012 usec (1.21255e-08 sec) per iteration: 0.0978887 sec for 8072979 iterations 0.012 usec (1.20787e-08 sec) per iteration: 0.097511 sec for 8072979 iterations 0.012 usec (1.22346e-08 sec) per iteration: 0.09877 sec for 8072979 iterations 0.012 usec (1.20742e-08 sec) per iteration: 0.0974745 sec for 8072979 iterations 0.012 usec (1.20978e-08 sec) per iteration: 0.0976656 sec for 8072979 iterations mean: 0.012122 usec stddev: 0.000059 usec relative stddev: 0.49% RESULT TestSetjmpLongjmp: x86-64_nnacl_newlib_static= {0.012122, 0.000059} us Measuring clock cycles: first runs (cycles): 369 69 24 33 36 33 27 24 36 33 ... slowest runs (cycles): ... 36 36 36 36 36 36 36 36 69 369 min: 24 cycles q1: 27 cycles median: 33 cycles q3: 36 cycles max: 369 cycles RESULT TestSetjmpLongjmp_CycleCount: x86-64_nnacl_newlib_static= {33, 9} count Apparent clock speed: 2722 MHz TestClockGetTime: Measuring real time: 0.162 usec (1.6226e-07 sec) per iteration: 1.6226e-05 sec for 100 iterations 0.165 usec (1.65363e-07 sec) per iteration: 0.101912 sec for 616294 iterations 0.164 usec (1.63656e-07 sec) per iteration: 0.100861 sec for 616294 iterations 0.160 usec (1.59672e-07 sec) per iteration: 0.0984048 sec for 616294 iterations 0.163 usec (1.62689e-07 sec) per iteration: 0.100264 sec for 616294 iterations 0.167 usec (1.67154e-07 sec) per iteration: 0.103016 sec for 616294 iterations mean: 0.163707 usec stddev: 0.002528 usec relative stddev: 1.54% RESULT TestClockGetTime: x86-64_nnacl_newlib_static= {0.163707, 0.002528} us Measuring clock cycles: first runs (cycles): 1530 450 432 441 432 438 438 447 438 438 ... slowest runs (cycles): ... 444 444 444 444 447 447 450 450 450 1530 min: 432 cycles q1: 435 cycles median: 438 cycles q3: 438 cycles max: 1530 cycles RESULT TestClockGetTime_CycleCount: x86-64_nnacl_newlib_static= {438, 3} count Apparent clock speed: 2676 MHz TestTlsVariable: Measuring real time: 0.010 usec (9.55e-09 sec) per iteration: 9.55e-07 sec for 100 iterations 0.006 usec (6.265e-09 sec) per iteration: 6.265e-06 sec for 1000 iterations 0.006 usec (6.0265e-09 sec) per iteration: 6.0265e-05 sec for 10000 iterations 0.006 usec (6.02278e-09 sec) per iteration: 0.0999382 sec for 16593379 iterations 0.006 usec (6.04071e-09 sec) per iteration: 0.100236 sec for 16593379 iterations 0.006 usec (6.03802e-09 sec) per iteration: 0.100191 sec for 16593379 iterations 0.006 usec (6.02991e-09 sec) per iteration: 0.100057 sec for 16593379 iterations 0.006 usec (6.06229e-09 sec) per iteration: 0.100594 sec for 16593379 iterations mean: 0.006039 usec stddev: 0.000013 usec relative stddev: 0.22% RESULT TestTlsVariable: x86-64_nnacl_newlib_static= {0.006039, 0.000013} us Measuring clock cycles: first runs (cycles): 357 72 24 24 30 33 33 30 33 33 ... slowest runs (cycles): ... 36 36 36 36 36 36 36 36 72 357 min: 21 cycles q1: 24 cycles median: 30 cycles q3: 33 cycles max: 357 cycles RESULT TestTlsVariable_CycleCount: x86-64_nnacl_newlib_static= {30, 9} count Apparent clock speed: 4968 MHz TestMmapAnonymous: Measuring real time: 9.145 usec (9.14464e-06 sec) per iteration: 0.000914464 sec for 100 iterations 8.897 usec (8.89726e-06 sec) per iteration: 0.0972916 sec for 10935 iterations 9.890 usec (9.88983e-06 sec) per iteration: 0.108145 sec for 10935 iterations 8.829 usec (8.82928e-06 sec) per iteration: 0.0965482 sec for 10935 iterations 8.930 usec (8.92955e-06 sec) per iteration: 0.0976446 sec for 10935 iterations 9.420 usec (9.42012e-06 sec) per iteration: 0.103009 sec for 10935 iterations mean: 9.193208 usec stddev: 0.406525 usec relative stddev: 4.42% RESULT TestMmapAnonymous: x86-64_nnacl_newlib_static= {9.193208, 0.406525} us Measuring clock cycles: first runs (cycles): 35685 25203 24540 24585 24486 24651 24618 24249 24489 24021 ... slowest runs (cycles): ... 24618 24651 24669 24675 24717 25011 25203 28149 35685 116214 min: 23403 cycles q1: 23637 cycles median: 23802 cycles q3: 24225 cycles max: 116214 cycles RESULT TestMmapAnonymous_CycleCount: x86-64_nnacl_newlib_static= {23802, 588} count Apparent clock speed: 2589 MHz TestAtomicIncrement: Measuring real time: 0.014 usec (1.444e-08 sec) per iteration: 1.444e-06 sec for 100 iterations 0.010 usec (9.913e-09 sec) per iteration: 9.913e-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.6971e-09 sec) per iteration: 0.100069 sec for 10319491 iterations 0.010 usec (9.88967e-09 sec) per iteration: 0.102056 sec for 10319491 iterations 0.010 usec (9.71068e-09 sec) per iteration: 0.100209 sec for 10319491 iterations 0.010 usec (9.69491e-09 sec) per iteration: 0.100047 sec for 10319491 iterations 0.010 usec (9.695e-09 sec) per iteration: 0.100048 sec for 10319491 iterations mean: 0.009737 usec stddev: 0.000076 usec relative stddev: 0.78% RESULT TestAtomicIncrement: x86-64_nnacl_newlib_static= {0.009737, 0.000076} us Measuring clock cycles: first runs (cycles): 294 51 48 39 51 48 51 48 51 48 ... slowest runs (cycles): ... 51 51 51 51 51 51 51 51 51 294 min: 39 cycles q1: 48 cycles median: 48 cycles q3: 51 cycles max: 294 cycles RESULT TestAtomicIncrement_CycleCount: x86-64_nnacl_newlib_static= {48, 3} count Apparent clock speed: 4929 MHz TestUncontendedMutexLock: Measuring real time: 0.028 usec (2.771e-08 sec) per iteration: 2.771e-06 sec for 100 iterations 0.023 usec (2.3275e-08 sec) per iteration: 2.3275e-05 sec for 1000 iterations 0.023 usec (2.31664e-08 sec) per iteration: 0.0995332 sec for 4296455 iterations 0.023 usec (2.31387e-08 sec) per iteration: 0.0994143 sec for 4296455 iterations 0.023 usec (2.31093e-08 sec) per iteration: 0.0992881 sec for 4296455 iterations 0.023 usec (2.32763e-08 sec) per iteration: 0.100005 sec for 4296455 iterations 0.023 usec (2.31675e-08 sec) per iteration: 0.0995382 sec for 4296455 iterations mean: 0.023172 usec stddev: 0.000057 usec relative stddev: 0.24% RESULT TestUncontendedMutexLock: x86-64_nnacl_newlib_static= {0.023172, 0.000057} us Measuring clock cycles: first runs (cycles): 429 108 81 78 81 78 81 78 81 78 ... slowest runs (cycles): ... 90 90 90 90 90 90 90 90 108 429 min: 78 cycles q1: 81 cycles median: 87 cycles q3: 90 cycles max: 429 cycles RESULT TestUncontendedMutexLock_CycleCount: x86-64_nnacl_newlib_static= {87, 9} count Apparent clock speed: 3755 MHz TestCondvarSignalNoOp: Measuring real time: 0.252 usec (2.5218e-07 sec) per iteration: 2.5218e-05 sec for 100 iterations 0.164 usec (1.63734e-07 sec) per iteration: 0.0649273 sec for 396542 iterations 0.164 usec (1.63826e-07 sec) per iteration: 0.064964 sec for 396542 iterations 0.162 usec (1.6247e-07 sec) per iteration: 0.0644262 sec for 396542 iterations 0.163 usec (1.62533e-07 sec) per iteration: 0.0644512 sec for 396542 iterations 0.163 usec (1.62993e-07 sec) per iteration: 0.0646335 sec for 396542 iterations mean: 0.163111 usec stddev: 0.000576 usec relative stddev: 0.35% RESULT TestCondvarSignalNoOp: x86-64_nnacl_newlib_static= {0.163111, 0.000576} us Measuring clock cycles: first runs (cycles): 1500 432 429 435 432 432 432 432 432 432 ... slowest runs (cycles): ... 435 435 435 435 435 435 435 435 444 1500 min: 420 cycles q1: 432 cycles median: 432 cycles q3: 432 cycles max: 1500 cycles RESULT TestCondvarSignalNoOp_CycleCount: x86-64_nnacl_newlib_static= {432, 0} count Apparent clock speed: 2648 MHz TestThreadCreateAndJoin: Measuring real time: 65.322 usec (6.53218e-05 sec) per iteration: 0.00653218 sec for 100 iterations 63.382 usec (6.33821e-05 sec) per iteration: 0.0969746 sec for 1530 iterations 64.424 usec (6.44236e-05 sec) per iteration: 0.0985682 sec for 1530 iterations 64.018 usec (6.4018e-05 sec) per iteration: 0.0979476 sec for 1530 iterations 63.878 usec (6.38782e-05 sec) per iteration: 0.0977337 sec for 1530 iterations 63.787 usec (6.37866e-05 sec) per iteration: 0.0975935 sec for 1530 iterations mean: 63.897720 usec stddev: 0.337537 usec relative stddev: 0.53% RESULT TestThreadCreateAndJoin: x86-64_nnacl_newlib_static= {63.897720, 0.337537} us Measuring clock cycles: first runs (cycles): 170880 171879 180894 217470 198099 197409 178713 176019 187560 184419 ... slowest runs (cycles): ... 197409 198099 200106 201162 204621 216006 217470 224658 232419 301188 min: 149175 cycles q1: 168372 cycles median: 170919 cycles q3: 178713 cycles max: 301188 cycles RESULT TestThreadCreateAndJoin_CycleCount: x86-64_nnacl_newlib_static= {170919, 10341} count Apparent clock speed: 2675 MHz TestThreadWakeup: Measuring real time: 31.869 usec (3.18691e-05 sec) per iteration: 0.00318691 sec for 100 iterations 31.165 usec (3.1165e-05 sec) per iteration: 0.0977647 sec for 3137 iterations 31.197 usec (3.11968e-05 sec) per iteration: 0.0978643 sec for 3137 iterations 31.138 usec (3.11377e-05 sec) per iteration: 0.0976791 sec for 3137 iterations 31.180 usec (3.11804e-05 sec) per iteration: 0.0978128 sec for 3137 iterations 31.208 usec (3.12082e-05 sec) per iteration: 0.0979002 sec for 3137 iterations mean: 31.177631 usec stddev: 0.024743 usec relative stddev: 0.08% RESULT TestThreadWakeup: x86-64_nnacl_newlib_static= {31.177631, 0.024743} us Measuring clock cycles: first runs (cycles): 90663 84123 83697 86367 98187 89952 79533 81555 102381 112152 ... slowest runs (cycles): ... 92127 92325 92925 94155 94926 96951 98187 102381 112152 117711 min: 78999 cycles q1: 83397 cycles median: 84402 cycles q3: 85617 cycles max: 117711 cycles RESULT TestThreadWakeup_CycleCount: x86-64_nnacl_newlib_static= {84402, 2220} count Apparent clock speed: 2707 MHz TestCatchingFault: Measuring real time: 31.817 usec (3.18173e-05 sec) per iteration: 0.00318173 sec for 100 iterations 30.303 usec (3.03028e-05 sec) per iteration: 0.0952114 sec for 3142 iterations 30.517 usec (3.05169e-05 sec) per iteration: 0.0958841 sec for 3142 iterations 30.465 usec (3.04655e-05 sec) per iteration: 0.0957226 sec for 3142 iterations 30.485 usec (3.04854e-05 sec) per iteration: 0.0957853 sec for 3142 iterations 30.433 usec (3.04329e-05 sec) per iteration: 0.0956201 sec for 3142 iterations mean: 30.440703 usec stddev: 0.074164 usec relative stddev: 0.24% RESULT TestCatchingFault: x86-64_nnacl_newlib_static= {30.440703, 0.074164} us Measuring clock cycles: first runs (cycles): 100488 83079 81993 82953 86262 107253 87996 112611 117198 121113 ... slowest runs (cycles): ... 100488 102099 103638 105666 106671 107253 112611 117198 120810 121113 min: 79500 cycles q1: 80724 cycles median: 81153 cycles q3: 82080 cycles max: 121113 cycles RESULT TestCatchingFault_CycleCount: x86-64_nnacl_newlib_static= {81153, 1356} count Apparent clock speed: 2666 MHz TestThreadCreateAndJoinAfterSettingFaultHandler: Measuring real time: 64.830 usec (6.48299e-05 sec) per iteration: 0.00648299 sec for 100 iterations 63.883 usec (6.38832e-05 sec) per iteration: 0.0985078 sec for 1542 iterations 63.759 usec (6.37588e-05 sec) per iteration: 0.0983161 sec for 1542 iterations 65.299 usec (6.52986e-05 sec) per iteration: 0.10069 sec for 1542 iterations 67.142 usec (6.7142e-05 sec) per iteration: 0.103533 sec for 1542 iterations 63.796 usec (6.37963e-05 sec) per iteration: 0.0983739 sec for 1542 iterations mean: 64.775770 usec stddev: 1.316274 usec relative stddev: 2.03% RESULT TestThreadCreateAndJoinAfterSettingFaultHandler: x86-64_nnacl_newlib_static= {64.775770, 1.316274} us Measuring clock cycles: first runs (cycles): 169851 176808 165528 186618 184641 186987 171777 180573 173592 169308 ... slowest runs (cycles): ... 180639 181275 183972 184401 184641 185526 186039 186618 186987 190128 min: 160494 cycles q1: 167718 cycles median: 170196 cycles q3: 174027 cycles max: 190128 cycles RESULT TestThreadCreateAndJoinAfterSettingFaultHandler_CycleCount: x86-64_nnacl_newlib_static= {170196, 6309} count Apparent clock speed: 2627 MHz [ OK ] nacl_newlib.run_performance_test (6680 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