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.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 = 1547635608, usec = 594848 } Wed Jan 16 02:46:48 2019 ====================================================================== 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 [10679,2894697344:15:34:45.595663] Native Client module will be loaded at base address 0x00006bab00000000 Running suite of 1 benchmarks: Running Benchmark: Life (SIMD version)... RESULT BenchmarkLife: x86-64_nnacl_newlib_static= {0.065050, 0.001350} seconds --------------------------------------------------------------- Done running benchmark suite. [ OK ] nacl_newlib.run_benchmark_test (850 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 (66199 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= 525.260 KB RESULT hello_world_size.out: ZIPPED_x86-64_nnacl_newlib_static= 187.859 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 [10684,2894697344:15:34:59.736296] Native Client module will be loaded at base address 0x0000292000000000 TestNull: Measuring real time: 0.007 usec (7.46e-09 sec) per iteration: 7.46e-07 sec for 100 iterations 0.002 usec (2.289e-09 sec) per iteration: 2.289e-06 sec for 1000 iterations 0.002 usec (2.0331e-09 sec) per iteration: 2.0331e-05 sec for 10000 iterations 0.002 usec (2.09699e-09 sec) per iteration: 0.103142 sec for 49185972 iterations 0.002 usec (2.05494e-09 sec) per iteration: 0.101074 sec for 49185972 iterations 0.002 usec (1.98221e-09 sec) per iteration: 0.0974969 sec for 49185972 iterations 0.002 usec (2.07226e-09 sec) per iteration: 0.101926 sec for 49185972 iterations 0.002 usec (2.00538e-09 sec) per iteration: 0.0986364 sec for 49185972 iterations mean: 0.002042 usec stddev: 0.000042 usec relative stddev: 2.08% RESULT TestNull: x86-64_nnacl_newlib_static= {0.002042, 0.000042} us Measuring clock cycles: first runs (cycles): 267 21 30 30 27 30 18 21 18 21 ... slowest runs (cycles): ... 30 30 30 30 30 30 30 30 30 267 min: 18 cycles q1: 18 cycles median: 21 cycles q3: 27 cycles max: 267 cycles RESULT TestNull_CycleCount: x86-64_nnacl_newlib_static= {21, 9} count Apparent clock speed: 10282 MHz TestNaClSyscall: Measuring real time: 0.158 usec (1.583e-07 sec) per iteration: 1.583e-05 sec for 100 iterations 0.152 usec (1.52312e-07 sec) per iteration: 0.0962169 sec for 631711 iterations 0.163 usec (1.62507e-07 sec) per iteration: 0.102657 sec for 631711 iterations 0.157 usec (1.56985e-07 sec) per iteration: 0.0991689 sec for 631711 iterations 0.160 usec (1.59816e-07 sec) per iteration: 0.100957 sec for 631711 iterations 0.155 usec (1.55396e-07 sec) per iteration: 0.0981653 sec for 631711 iterations mean: 0.157403 usec stddev: 0.003521 usec relative stddev: 2.24% RESULT TestNaClSyscall: x86-64_nnacl_newlib_static= {0.157403, 0.003521} us Measuring clock cycles: first runs (cycles): 714 297 288 291 291 288 297 300 300 300 ... slowest runs (cycles): ... 300 300 300 300 300 300 300 300 300 714 min: 288 cycles q1: 291 cycles median: 291 cycles q3: 300 cycles max: 714 cycles RESULT TestNaClSyscall_CycleCount: x86-64_nnacl_newlib_static= {291, 9} count Apparent clock speed: 1849 MHz TestSetjmpLongjmp: Measuring real time: 0.017 usec (1.653e-08 sec) per iteration: 1.653e-06 sec for 100 iterations 0.012 usec (1.2428e-08 sec) per iteration: 1.2428e-05 sec for 1000 iterations 0.012 usec (1.19296e-08 sec) per iteration: 0.0959898 sec for 8046346 iterations 0.012 usec (1.23074e-08 sec) per iteration: 0.0990298 sec for 8046346 iterations 0.012 usec (1.18689e-08 sec) per iteration: 0.0955014 sec for 8046346 iterations 0.012 usec (1.21752e-08 sec) per iteration: 0.0979662 sec for 8046346 iterations 0.012 usec (1.20291e-08 sec) per iteration: 0.0967903 sec for 8046346 iterations mean: 0.012062 usec stddev: 0.000161 usec relative stddev: 1.33% RESULT TestSetjmpLongjmp: x86-64_nnacl_newlib_static= {0.012062, 0.000161} us Measuring clock cycles: first runs (cycles): 471 57 33 21 24 33 33 33 30 24 ... slowest runs (cycles): ... 33 33 33 33 33 33 33 33 57 471 min: 21 cycles q1: 24 cycles median: 30 cycles q3: 33 cycles max: 471 cycles RESULT TestSetjmpLongjmp_CycleCount: x86-64_nnacl_newlib_static= {30, 9} count Apparent clock speed: 2487 MHz TestClockGetTime: Measuring real time: 0.162 usec (1.6237e-07 sec) per iteration: 1.6237e-05 sec for 100 iterations 0.160 usec (1.60077e-07 sec) per iteration: 0.0985874 sec for 615877 iterations 0.170 usec (1.7025e-07 sec) per iteration: 0.104853 sec for 615877 iterations 0.175 usec (1.74517e-07 sec) per iteration: 0.107481 sec for 615877 iterations 0.167 usec (1.66744e-07 sec) per iteration: 0.102694 sec for 615877 iterations 0.159 usec (1.58963e-07 sec) per iteration: 0.0979017 sec for 615877 iterations mean: 0.166110 usec stddev: 0.005928 usec relative stddev: 3.57% RESULT TestClockGetTime: x86-64_nnacl_newlib_static= {0.166110, 0.005928} us Measuring clock cycles: first runs (cycles): 1656 450 435 438 435 435 435 447 435 435 ... slowest runs (cycles): ... 447 447 447 447 450 450 450 450 450 1656 min: 432 cycles q1: 435 cycles median: 438 cycles q3: 438 cycles max: 1656 cycles RESULT TestClockGetTime_CycleCount: x86-64_nnacl_newlib_static= {438, 3} count Apparent clock speed: 2637 MHz TestTlsVariable: Measuring real time: 0.010 usec (1.014e-08 sec) per iteration: 1.014e-06 sec for 100 iterations 0.006 usec (6.299e-09 sec) per iteration: 6.299e-06 sec for 1000 iterations 0.006 usec (6.0281e-09 sec) per iteration: 6.0281e-05 sec for 10000 iterations 0.006 usec (6.10488e-09 sec) per iteration: 0.101274 sec for 16588974 iterations 0.006 usec (6.09503e-09 sec) per iteration: 0.10111 sec for 16588974 iterations 0.006 usec (5.96141e-09 sec) per iteration: 0.0988936 sec for 16588974 iterations 0.006 usec (6.02697e-09 sec) per iteration: 0.0999812 sec for 16588974 iterations 0.006 usec (6.06278e-09 sec) per iteration: 0.100575 sec for 16588974 iterations mean: 0.006050 usec stddev: 0.000052 usec relative stddev: 0.86% RESULT TestTlsVariable: x86-64_nnacl_newlib_static= {0.006050, 0.000052} us Measuring clock cycles: first runs (cycles): 345 69 30 27 33 30 27 21 18 21 ... slowest runs (cycles): ... 30 30 30 30 30 30 30 33 69 345 min: 18 cycles q1: 18 cycles median: 21 cycles q3: 27 cycles max: 345 cycles RESULT TestTlsVariable_CycleCount: x86-64_nnacl_newlib_static= {21, 9} count Apparent clock speed: 3471 MHz TestMmapAnonymous: Measuring real time: 9.318 usec (9.31842e-06 sec) per iteration: 0.000931842 sec for 100 iterations 9.347 usec (9.34656e-06 sec) per iteration: 0.100298 sec for 10731 iterations 8.734 usec (8.73391e-06 sec) per iteration: 0.0937236 sec for 10731 iterations 8.723 usec (8.72276e-06 sec) per iteration: 0.093604 sec for 10731 iterations 8.750 usec (8.74993e-06 sec) per iteration: 0.0938955 sec for 10731 iterations 8.718 usec (8.7178e-06 sec) per iteration: 0.0935507 sec for 10731 iterations mean: 8.854191 usec stddev: 0.246433 usec relative stddev: 2.78% RESULT TestMmapAnonymous: x86-64_nnacl_newlib_static= {8.854191, 0.246433} us Measuring clock cycles: first runs (cycles): 33336 23760 22908 23016 22596 22746 22908 23154 23010 63912 ... slowest runs (cycles): ... 23661 23664 23739 23739 23751 23760 23760 23775 33336 63912 min: 22596 cycles q1: 23217 cycles median: 23319 cycles q3: 23448 cycles max: 63912 cycles RESULT TestMmapAnonymous_CycleCount: x86-64_nnacl_newlib_static= {23319, 231} count Apparent clock speed: 2634 MHz TestAtomicIncrement: Measuring real time: 0.015 usec (1.465e-08 sec) per iteration: 1.465e-06 sec for 100 iterations 0.010 usec (9.924e-09 sec) per iteration: 9.924e-06 sec for 1000 iterations 0.010 usec (9.6915e-09 sec) per iteration: 9.6915e-05 sec for 10000 iterations 0.010 usec (9.84182e-09 sec) per iteration: 0.101551 sec for 10318320 iterations 0.009 usec (9.38298e-09 sec) per iteration: 0.0968166 sec for 10318320 iterations 0.010 usec (9.62191e-09 sec) per iteration: 0.0992819 sec for 10318320 iterations 0.010 usec (9.65007e-09 sec) per iteration: 0.0995725 sec for 10318320 iterations 0.010 usec (9.66406e-09 sec) per iteration: 0.0997168 sec for 10318320 iterations mean: 0.009632 usec stddev: 0.000147 usec relative stddev: 1.52% RESULT TestAtomicIncrement: x86-64_nnacl_newlib_static= {0.009632, 0.000147} us Measuring clock cycles: first runs (cycles): 339 51 51 39 51 51 51 51 51 51 ... slowest runs (cycles): ... 51 51 51 51 51 51 51 51 51 339 min: 39 cycles q1: 51 cycles median: 51 cycles q3: 51 cycles max: 339 cycles RESULT TestAtomicIncrement_CycleCount: x86-64_nnacl_newlib_static= {51, 0} count Apparent clock speed: 5295 MHz TestUncontendedMutexLock: Measuring real time: 0.028 usec (2.772e-08 sec) per iteration: 2.772e-06 sec for 100 iterations 0.027 usec (2.6714e-08 sec) per iteration: 2.6714e-05 sec for 1000 iterations 0.023 usec (2.29482e-08 sec) per iteration: 0.0859034 sec for 3743355 iterations 0.023 usec (2.29568e-08 sec) per iteration: 0.0859355 sec for 3743355 iterations 0.023 usec (2.32288e-08 sec) per iteration: 0.0869535 sec for 3743355 iterations 0.023 usec (2.29362e-08 sec) per iteration: 0.0858584 sec for 3743355 iterations 0.024 usec (2.40433e-08 sec) per iteration: 0.0900026 sec for 3743355 iterations mean: 0.023223 usec stddev: 0.000425 usec relative stddev: 1.83% RESULT TestUncontendedMutexLock: x86-64_nnacl_newlib_static= {0.023223, 0.000425} us Measuring clock cycles: first runs (cycles): 483 111 81 81 81 81 81 81 81 81 ... slowest runs (cycles): ... 90 90 90 90 90 90 90 90 111 483 min: 78 cycles q1: 81 cycles median: 87 cycles q3: 90 cycles max: 483 cycles RESULT TestUncontendedMutexLock_CycleCount: x86-64_nnacl_newlib_static= {87, 9} count Apparent clock speed: 3746 MHz TestCondvarSignalNoOp: Measuring real time: 0.296 usec (2.9603e-07 sec) per iteration: 2.9603e-05 sec for 100 iterations 0.162 usec (1.62431e-07 sec) per iteration: 0.0548697 sec for 337803 iterations 0.162 usec (1.62068e-07 sec) per iteration: 0.054747 sec for 337803 iterations 0.161 usec (1.61005e-07 sec) per iteration: 0.0543881 sec for 337803 iterations 0.162 usec (1.6219e-07 sec) per iteration: 0.0547882 sec for 337803 iterations 0.163 usec (1.63159e-07 sec) per iteration: 0.0551157 sec for 337803 iterations mean: 0.162171 usec stddev: 0.000695 usec relative stddev: 0.43% RESULT TestCondvarSignalNoOp: x86-64_nnacl_newlib_static= {0.162171, 0.000695} us Measuring clock cycles: first runs (cycles): 1335 435 432 432 432 435 432 432 435 432 ... slowest runs (cycles): ... 435 435 435 435 435 435 435 435 444 1335 min: 432 cycles q1: 432 cycles median: 432 cycles q3: 432 cycles max: 1335 cycles RESULT TestCondvarSignalNoOp_CycleCount: x86-64_nnacl_newlib_static= {432, 0} count Apparent clock speed: 2664 MHz TestThreadCreateAndJoin: Measuring real time: 67.413 usec (6.74131e-05 sec) per iteration: 0.00674132 sec for 100 iterations 69.445 usec (6.94452e-05 sec) per iteration: 0.102987 sec for 1483 iterations 64.866 usec (6.48664e-05 sec) per iteration: 0.0961968 sec for 1483 iterations 64.740 usec (6.47397e-05 sec) per iteration: 0.096009 sec for 1483 iterations 64.767 usec (6.47672e-05 sec) per iteration: 0.0960497 sec for 1483 iterations 64.821 usec (6.48205e-05 sec) per iteration: 0.0961288 sec for 1483 iterations mean: 65.727793 usec stddev: 1.859191 usec relative stddev: 2.83% RESULT TestThreadCreateAndJoin: x86-64_nnacl_newlib_static= {65.727793, 1.859191} us Measuring clock cycles: first runs (cycles): 176583 195312 208296 183849 190662 244836 186561 178023 176931 177303 ... slowest runs (cycles): ... 190662 190791 195312 202728 208296 212112 215382 218952 244836 252237 min: 166383 cycles q1: 170046 cycles median: 174327 cycles q3: 176760 cycles max: 252237 cycles RESULT TestThreadCreateAndJoin_CycleCount: x86-64_nnacl_newlib_static= {174327, 6714} count Apparent clock speed: 2652 MHz TestThreadWakeup: Measuring real time: 31.182 usec (3.11823e-05 sec) per iteration: 0.00311823 sec for 100 iterations 33.374 usec (3.33742e-05 sec) per iteration: 0.106998 sec for 3206 iterations 31.446 usec (3.1446e-05 sec) per iteration: 0.100816 sec for 3206 iterations 31.527 usec (3.15268e-05 sec) per iteration: 0.101075 sec for 3206 iterations 32.660 usec (3.26605e-05 sec) per iteration: 0.104709 sec for 3206 iterations 32.023 usec (3.2023e-05 sec) per iteration: 0.102666 sec for 3206 iterations mean: 32.206080 usec stddev: 0.727135 usec relative stddev: 2.26% RESULT TestThreadWakeup: x86-64_nnacl_newlib_static= {32.206080, 0.727135} us Measuring clock cycles: first runs (cycles): 86610 86559 87756 88368 98748 93615 105837 96102 100329 80898 ... slowest runs (cycles): ... 98091 98748 100329 100779 105837 112782 114888 116052 122835 129462 min: 80898 cycles q1: 83970 cycles median: 84717 cycles q3: 87057 cycles max: 129462 cycles RESULT TestThreadWakeup_CycleCount: x86-64_nnacl_newlib_static= {84717, 3087} count Apparent clock speed: 2630 MHz TestCatchingFault: Measuring real time: 32.262 usec (3.22617e-05 sec) per iteration: 0.00322617 sec for 100 iterations 31.372 usec (3.13722e-05 sec) per iteration: 0.0972226 sec for 3099 iterations 30.904 usec (3.0904e-05 sec) per iteration: 0.0957716 sec for 3099 iterations 31.306 usec (3.13061e-05 sec) per iteration: 0.0970175 sec for 3099 iterations 30.983 usec (3.09826e-05 sec) per iteration: 0.0960151 sec for 3099 iterations 31.650 usec (3.16499e-05 sec) per iteration: 0.0980832 sec for 3099 iterations mean: 31.242978 usec stddev: 0.271657 usec relative stddev: 0.87% RESULT TestCatchingFault: x86-64_nnacl_newlib_static= {31.242978, 0.271657} us Measuring clock cycles: first runs (cycles): 102384 84696 84003 134916 103632 97338 162444 113418 95109 109530 ... slowest runs (cycles): ... 102384 103632 106866 109530 113418 120930 134916 139470 153015 162444 min: 80535 cycles q1: 81252 cycles median: 81918 cycles q3: 83193 cycles max: 162444 cycles RESULT TestCatchingFault_CycleCount: x86-64_nnacl_newlib_static= {81918, 1941} count Apparent clock speed: 2622 MHz TestThreadCreateAndJoinAfterSettingFaultHandler: Measuring real time: 68.266 usec (6.82662e-05 sec) per iteration: 0.00682662 sec for 100 iterations 64.901 usec (6.49006e-05 sec) per iteration: 0.0950145 sec for 1464 iterations 63.888 usec (6.38879e-05 sec) per iteration: 0.0935318 sec for 1464 iterations 66.133 usec (6.61326e-05 sec) per iteration: 0.0968181 sec for 1464 iterations 65.399 usec (6.53991e-05 sec) per iteration: 0.0957443 sec for 1464 iterations 63.704 usec (6.3704e-05 sec) per iteration: 0.0932626 sec for 1464 iterations mean: 64.804823 usec stddev: 0.914098 usec relative stddev: 1.41% RESULT TestThreadCreateAndJoinAfterSettingFaultHandler: x86-64_nnacl_newlib_static= {64.804823, 0.914098} us Measuring clock cycles: first runs (cycles): 173565 181785 171594 204216 224067 184080 204723 180168 174720 176145 ... slowest runs (cycles): ... 181785 184080 189453 193041 204063 204216 204723 209934 212664 224067 min: 162147 cycles q1: 165276 cycles median: 166569 cycles q3: 171489 cycles max: 224067 cycles RESULT TestThreadCreateAndJoinAfterSettingFaultHandler_CycleCount: x86-64_nnacl_newlib_static= {166569, 6213} count Apparent clock speed: 2570 MHz [ OK ] nacl_newlib.run_performance_test (6520 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