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: 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 = 1545163299, usec = 580734 } Tue Dec 18 12:01:39 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 [68118,2579551104:16:47:15.947191] Native Client module will be loaded at base address 0x000026a000000000 Running suite of 1 benchmarks: Running Benchmark: Life (SIMD version)... RESULT BenchmarkLife: x86-64_nnacl_newlib_static= {0.139330, 0.002920} seconds --------------------------------------------------------------- Done running benchmark suite. [ OK ] nacl_newlib.run_benchmark_test (1350 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 (67110 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.856 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 [68124,2579551104:16:47:35.969902] Native Client module will be loaded at base address 0x000039f300000000 TestNull: Measuring real time: 0.006 usec (5.7e-09 sec) per iteration: 5.7e-07 sec for 100 iterations 0.002 usec (1.86e-09 sec) per iteration: 1.86e-06 sec for 1000 iterations 0.002 usec (1.6931e-09 sec) per iteration: 1.6931e-05 sec for 10000 iterations 0.002 usec (1.67384e-09 sec) per iteration: 0.0988622 sec for 59063256 iterations 0.002 usec (1.67146e-09 sec) per iteration: 0.0987217 sec for 59063256 iterations 0.002 usec (1.67321e-09 sec) per iteration: 0.0988251 sec for 59063256 iterations 0.002 usec (1.67753e-09 sec) per iteration: 0.0990804 sec for 59063256 iterations 0.002 usec (1.67127e-09 sec) per iteration: 0.0987105 sec for 59063256 iterations mean: 0.001673 usec stddev: 0.000002 usec relative stddev: 0.14% RESULT TestNull: x86-64_nnacl_newlib_static= {0.001673, 0.000002} us Measuring clock cycles: first runs (cycles): 172 24 24 24 24 24 24 24 24 24 ... slowest runs (cycles): ... 24 24 24 24 24 24 24 24 24 172 min: 24 cycles q1: 24 cycles median: 24 cycles q3: 24 cycles max: 172 cycles RESULT TestNull_CycleCount: x86-64_nnacl_newlib_static= {24, 0} count Apparent clock speed: 14342 MHz TestNaClSyscall: Measuring real time: 0.156 usec (1.5636e-07 sec) per iteration: 1.5636e-05 sec for 100 iterations 0.150 usec (1.49817e-07 sec) per iteration: 0.0958155 sec for 639549 iterations 0.150 usec (1.50022e-07 sec) per iteration: 0.0959465 sec for 639549 iterations 0.150 usec (1.49901e-07 sec) per iteration: 0.0958692 sec for 639549 iterations 0.150 usec (1.50142e-07 sec) per iteration: 0.0960232 sec for 639549 iterations 0.150 usec (1.49672e-07 sec) per iteration: 0.0957225 sec for 639549 iterations mean: 0.149911 usec stddev: 0.000162 usec relative stddev: 0.11% RESULT TestNaClSyscall: x86-64_nnacl_newlib_static= {0.149911, 0.000162} us Measuring clock cycles: first runs (cycles): 580 364 356 348 316 320 320 320 320 320 ... slowest runs (cycles): ... 324 324 324 328 328 328 348 356 364 580 min: 316 cycles q1: 320 cycles median: 320 cycles q3: 324 cycles max: 580 cycles RESULT TestNaClSyscall_CycleCount: x86-64_nnacl_newlib_static= {320, 4} count Apparent clock speed: 2135 MHz TestSetjmpLongjmp: Measuring real time: 0.019 usec (1.922e-08 sec) per iteration: 1.922e-06 sec for 100 iterations 0.014 usec (1.3959e-08 sec) per iteration: 1.3959e-05 sec for 1000 iterations 0.011 usec (1.13095e-08 sec) per iteration: 0.0810194 sec for 7163836 iterations 0.011 usec (1.12563e-08 sec) per iteration: 0.0806383 sec for 7163836 iterations 0.011 usec (1.13077e-08 sec) per iteration: 0.0810066 sec for 7163836 iterations 0.011 usec (1.12612e-08 sec) per iteration: 0.0806732 sec for 7163836 iterations 0.011 usec (1.14283e-08 sec) per iteration: 0.0818707 sec for 7163836 iterations mean: 0.011313 usec stddev: 0.000062 usec relative stddev: 0.55% RESULT TestSetjmpLongjmp: x86-64_nnacl_newlib_static= {0.011313, 0.000062} us Measuring clock cycles: first runs (cycles): 272 76 24 28 24 28 28 28 28 28 ... slowest runs (cycles): ... 28 28 28 28 28 28 28 28 76 272 min: 24 cycles q1: 24 cycles median: 28 cycles q3: 28 cycles max: 272 cycles RESULT TestSetjmpLongjmp_CycleCount: x86-64_nnacl_newlib_static= {28, 4} count Apparent clock speed: 2475 MHz TestClockGetTime: Measuring real time: 0.163 usec (1.6347e-07 sec) per iteration: 1.6347e-05 sec for 100 iterations 0.163 usec (1.62871e-07 sec) per iteration: 0.0996335 sec for 611733 iterations 0.163 usec (1.63e-07 sec) per iteration: 0.0997123 sec for 611733 iterations 0.163 usec (1.63346e-07 sec) per iteration: 0.0999242 sec for 611733 iterations 0.163 usec (1.62749e-07 sec) per iteration: 0.0995587 sec for 611733 iterations 0.163 usec (1.62792e-07 sec) per iteration: 0.0995855 sec for 611733 iterations mean: 0.162952 usec stddev: 0.000215 usec relative stddev: 0.13% RESULT TestClockGetTime: x86-64_nnacl_newlib_static= {0.162952, 0.000215} us Measuring clock cycles: first runs (cycles): 996 516 480 480 480 488 568 484 488 492 ... slowest runs (cycles): ... 496 496 496 496 496 496 516 564 568 996 min: 476 cycles q1: 488 cycles median: 488 cycles q3: 492 cycles max: 996 cycles RESULT TestClockGetTime_CycleCount: x86-64_nnacl_newlib_static= {488, 4} count Apparent clock speed: 2995 MHz TestTlsVariable: Measuring real time: 0.015 usec (1.505e-08 sec) per iteration: 1.505e-06 sec for 100 iterations 0.009 usec (9.045e-09 sec) per iteration: 9.045e-06 sec for 1000 iterations 0.008 usec (8.2293e-09 sec) per iteration: 8.2293e-05 sec for 10000 iterations 0.005 usec (5.02841e-09 sec) per iteration: 0.0611038 sec for 12151701 iterations 0.005 usec (5.05808e-09 sec) per iteration: 0.0614643 sec for 12151701 iterations 0.005 usec (5.01557e-09 sec) per iteration: 0.0609477 sec for 12151701 iterations 0.005 usec (5.01911e-09 sec) per iteration: 0.0609907 sec for 12151701 iterations 0.005 usec (5.02629e-09 sec) per iteration: 0.061078 sec for 12151701 iterations mean: 0.005029 usec stddev: 0.000015 usec relative stddev: 0.30% RESULT TestTlsVariable: x86-64_nnacl_newlib_static= {0.005029, 0.000015} us Measuring clock cycles: first runs (cycles): 280 68 72 24 24 24 24 24 24 24 ... slowest runs (cycles): ... 24 24 24 24 24 24 24 68 72 280 min: 24 cycles q1: 24 cycles median: 24 cycles q3: 24 cycles max: 280 cycles RESULT TestTlsVariable_CycleCount: x86-64_nnacl_newlib_static= {24, 0} count Apparent clock speed: 4772 MHz TestMmapAnonymous: Measuring real time: 6.949 usec (6.94936e-06 sec) per iteration: 0.000694936 sec for 100 iterations 5.263 usec (5.26275e-06 sec) per iteration: 0.0757257 sec for 14389 iterations 5.258 usec (5.25807e-06 sec) per iteration: 0.0756584 sec for 14389 iterations 5.247 usec (5.24702e-06 sec) per iteration: 0.0754994 sec for 14389 iterations 5.297 usec (5.29677e-06 sec) per iteration: 0.0762152 sec for 14389 iterations 5.292 usec (5.29214e-06 sec) per iteration: 0.0761486 sec for 14389 iterations mean: 5.271350 usec stddev: 0.019598 usec relative stddev: 0.37% RESULT TestMmapAnonymous: x86-64_nnacl_newlib_static= {5.271350, 0.019598} us Measuring clock cycles: first runs (cycles): 19488 15776 15528 15544 15584 15380 15364 15360 15416 15340 ... slowest runs (cycles): ... 23148 23440 23580 23584 23680 23700 23716 23908 24064 24324 min: 15340 cycles q1: 15456 cycles median: 15504 cycles q3: 15612 cycles max: 24324 cycles RESULT TestMmapAnonymous_CycleCount: x86-64_nnacl_newlib_static= {15504, 156} count Apparent clock speed: 2941 MHz TestAtomicIncrement: Measuring real time: 0.015 usec (1.492e-08 sec) per iteration: 1.492e-06 sec for 100 iterations 0.010 usec (1.0158e-08 sec) per iteration: 1.0158e-05 sec for 1000 iterations 0.009 usec (8.71768e-09 sec) per iteration: 0.0858209 sec for 9844457 iterations 0.009 usec (8.69433e-09 sec) per iteration: 0.085591 sec for 9844457 iterations 0.009 usec (8.72751e-09 sec) per iteration: 0.0859176 sec for 9844457 iterations 0.009 usec (8.68548e-09 sec) per iteration: 0.0855039 sec for 9844457 iterations 0.009 usec (8.70171e-09 sec) per iteration: 0.0856636 sec for 9844457 iterations mean: 0.008705 usec stddev: 0.000015 usec relative stddev: 0.18% RESULT TestAtomicIncrement: x86-64_nnacl_newlib_static= {0.008705, 0.000015} us Measuring clock cycles: first runs (cycles): 176 52 52 52 52 52 52 52 52 52 ... slowest runs (cycles): ... 52 52 52 52 52 52 52 56 68 176 min: 52 cycles q1: 52 cycles median: 52 cycles q3: 52 cycles max: 176 cycles RESULT TestAtomicIncrement_CycleCount: x86-64_nnacl_newlib_static= {52, 0} count Apparent clock speed: 5973 MHz TestUncontendedMutexLock: Measuring real time: 0.029 usec (2.888e-08 sec) per iteration: 2.888e-06 sec for 100 iterations 0.026 usec (2.5535e-08 sec) per iteration: 2.5535e-05 sec for 1000 iterations 0.022 usec (2.17693e-08 sec) per iteration: 0.0852527 sec for 3916193 iterations 0.022 usec (2.17603e-08 sec) per iteration: 0.0852174 sec for 3916193 iterations 0.022 usec (2.17263e-08 sec) per iteration: 0.0850842 sec for 3916193 iterations 0.022 usec (2.18894e-08 sec) per iteration: 0.0857233 sec for 3916193 iterations 0.022 usec (2.1738e-08 sec) per iteration: 0.0851303 sec for 3916193 iterations mean: 0.021777 usec stddev: 0.000058 usec relative stddev: 0.27% RESULT TestUncontendedMutexLock: x86-64_nnacl_newlib_static= {0.021777, 0.000058} us Measuring clock cycles: first runs (cycles): 396 120 88 92 88 92 88 92 88 92 ... slowest runs (cycles): ... 92 92 92 92 92 92 92 92 120 396 min: 88 cycles q1: 88 cycles median: 92 cycles q3: 92 cycles max: 396 cycles RESULT TestUncontendedMutexLock_CycleCount: x86-64_nnacl_newlib_static= {92, 4} count Apparent clock speed: 4225 MHz TestCondvarSignalNoOp: Measuring real time: 0.473 usec (4.7267e-07 sec) per iteration: 4.7267e-05 sec for 100 iterations 0.158 usec (1.5834e-07 sec) per iteration: 0.033499 sec for 211564 iterations 0.158 usec (1.57563e-07 sec) per iteration: 0.0333346 sec for 211564 iterations 0.157 usec (1.57349e-07 sec) per iteration: 0.0332893 sec for 211564 iterations 0.157 usec (1.57497e-07 sec) per iteration: 0.0333206 sec for 211564 iterations 0.158 usec (1.57502e-07 sec) per iteration: 0.0333218 sec for 211564 iterations mean: 0.157650 usec stddev: 0.000352 usec relative stddev: 0.22% RESULT TestCondvarSignalNoOp: x86-64_nnacl_newlib_static= {0.157650, 0.000352} us Measuring clock cycles: first runs (cycles): 740 480 460 464 460 464 460 468 464 468 ... slowest runs (cycles): ... 464 464 464 464 464 464 468 468 480 740 min: 456 cycles q1: 456 cycles median: 464 cycles q3: 464 cycles max: 740 cycles RESULT TestCondvarSignalNoOp_CycleCount: x86-64_nnacl_newlib_static= {464, 8} count Apparent clock speed: 2943 MHz TestThreadCreateAndJoin: Measuring real time: 47.194 usec (4.71944e-05 sec) per iteration: 0.00471944 sec for 100 iterations 44.066 usec (4.4066e-05 sec) per iteration: 0.0933318 sec for 2118 iterations 39.427 usec (3.9427e-05 sec) per iteration: 0.0835065 sec for 2118 iterations 44.578 usec (4.45776e-05 sec) per iteration: 0.0944153 sec for 2118 iterations 46.551 usec (4.6551e-05 sec) per iteration: 0.098595 sec for 2118 iterations 46.793 usec (4.67931e-05 sec) per iteration: 0.0991077 sec for 2118 iterations mean: 44.282937 usec stddev: 2.651726 usec relative stddev: 5.99% RESULT TestThreadCreateAndJoin: x86-64_nnacl_newlib_static= {44.282937, 2.651726} us Measuring clock cycles: first runs (cycles): 114494 149994 203183 119771 118287 248723 192248 214508 165888 142235 ... slowest runs (cycles): ... 203183 206574 206712 214508 233838 248723 249812 253488 255572 255832 min: 68526 cycles q1: 120804 cycles median: 137337 cycles q3: 146585 cycles max: 255832 cycles RESULT TestThreadCreateAndJoin_CycleCount: x86-64_nnacl_newlib_static= {137337, 25781} count Apparent clock speed: 3101 MHz TestThreadWakeup: Measuring real time: 15.742 usec (1.57418e-05 sec) per iteration: 0.00157418 sec for 100 iterations 10.051 usec (1.00512e-05 sec) per iteration: 0.0638453 sec for 6352 iterations 10.115 usec (1.01151e-05 sec) per iteration: 0.064251 sec for 6352 iterations 10.386 usec (1.03863e-05 sec) per iteration: 0.0659736 sec for 6352 iterations 10.239 usec (1.02394e-05 sec) per iteration: 0.0650408 sec for 6352 iterations 10.334 usec (1.03338e-05 sec) per iteration: 0.06564 sec for 6352 iterations mean: 10.225147 usec stddev: 0.126752 usec relative stddev: 1.24% RESULT TestThreadWakeup: x86-64_nnacl_newlib_static= {10.225147, 0.126752} us Measuring clock cycles: first runs (cycles): 36720 32444 31560 31896 34356 32492 56416 44788 56604 133008 ... slowest runs (cycles): ... 65596 65808 68476 70252 79284 79656 95064 120944 133008 134456 min: 28952 cycles q1: 30920 cycles median: 41640 cycles q3: 44788 cycles max: 134456 cycles RESULT TestThreadWakeup_CycleCount: x86-64_nnacl_newlib_static= {41640, 13868} count Apparent clock speed: 4072 MHz TestCatchingFault: Measuring real time: 17.779 usec (1.77794e-05 sec) per iteration: 0.00177794 sec for 100 iterations 15.370 usec (1.53696e-05 sec) per iteration: 0.0864385 sec for 5624 iterations 15.642 usec (1.56415e-05 sec) per iteration: 0.0879679 sec for 5624 iterations 16.925 usec (1.69245e-05 sec) per iteration: 0.0951834 sec for 5624 iterations 16.615 usec (1.66155e-05 sec) per iteration: 0.0934455 sec for 5624 iterations 15.356 usec (1.53559e-05 sec) per iteration: 0.0863614 sec for 5624 iterations mean: 15.981390 usec stddev: 0.659186 usec relative stddev: 4.12% RESULT TestCatchingFault: x86-64_nnacl_newlib_static= {15.981390, 0.659186} us Measuring clock cycles: first runs (cycles): 53360 53676 61796 45336 140212 88476 76372 66940 64776 77912 ... slowest runs (cycles): ... 65872 66940 70156 76372 77912 78436 79240 88476 91684 140212 min: 45208 cycles q1: 45780 cycles median: 46004 cycles q3: 46512 cycles max: 140212 cycles RESULT TestCatchingFault_CycleCount: x86-64_nnacl_newlib_static= {46004, 732} count Apparent clock speed: 2879 MHz TestThreadCreateAndJoinAfterSettingFaultHandler: Measuring real time: 41.351 usec (4.13508e-05 sec) per iteration: 0.00413508 sec for 100 iterations 42.016 usec (4.20158e-05 sec) per iteration: 0.101594 sec for 2418 iterations 39.243 usec (3.92432e-05 sec) per iteration: 0.09489 sec for 2418 iterations 43.494 usec (4.34941e-05 sec) per iteration: 0.105169 sec for 2418 iterations 46.557 usec (4.65567e-05 sec) per iteration: 0.112574 sec for 2418 iterations 39.855 usec (3.98554e-05 sec) per iteration: 0.0963703 sec for 2418 iterations mean: 42.233016 usec stddev: 2.642880 usec relative stddev: 6.26% RESULT TestThreadCreateAndJoinAfterSettingFaultHandler: x86-64_nnacl_newlib_static= {42.233016, 2.642880} us Measuring clock cycles: first runs (cycles): 123263 136780 122511 170852 168928 167762 137775 186758 183980 105183 ... slowest runs (cycles): ... 123263 124038 136780 137775 154179 167762 168928 170852 183980 186758 min: 98535 cycles q1: 117924 cycles median: 118350 cycles q3: 119034 cycles max: 186758 cycles RESULT TestThreadCreateAndJoinAfterSettingFaultHandler_CycleCount: x86-64_nnacl_newlib_static= {118350, 1110} count Apparent clock speed: 2802 MHz [ OK ] nacl_newlib.run_performance_test (5730 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