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 = 1550358341, usec = 843724 } Sat Feb 16 15:05:41 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 [41042,2832876416:19:13:45.394133] Native Client module will be loaded at base address 0x00005c6200000000 Running suite of 1 benchmarks: Running Benchmark: Life (SIMD version)... RESULT BenchmarkLife: x86-64_nnacl_newlib_static= {0.141010, 0.003240} seconds --------------------------------------------------------------- Done running benchmark suite. [ OK ] nacl_newlib.run_benchmark_test (1380 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 (67360 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 [41752,2832876416:19:14:09.522429] Native Client module will be loaded at base address 0x000007ed00000000 TestNull: Measuring real time: 0.005 usec (5.33e-09 sec) per iteration: 5.33e-07 sec for 100 iterations 0.002 usec (1.863e-09 sec) per iteration: 1.863e-06 sec for 1000 iterations 0.002 usec (1.6916e-09 sec) per iteration: 1.6916e-05 sec for 10000 iterations 0.002 usec (1.67835e-09 sec) per iteration: 0.0992167 sec for 59115630 iterations 0.002 usec (1.67169e-09 sec) per iteration: 0.0988233 sec for 59115630 iterations 0.002 usec (1.67854e-09 sec) per iteration: 0.0992277 sec for 59115630 iterations 0.002 usec (1.67648e-09 sec) per iteration: 0.0991059 sec for 59115630 iterations 0.002 usec (1.67082e-09 sec) per iteration: 0.0987713 sec for 59115630 iterations mean: 0.001675 usec stddev: 0.000003 usec relative stddev: 0.20% RESULT TestNull: x86-64_nnacl_newlib_static= {0.001675, 0.000003} us Measuring clock cycles: first runs (cycles): 160 40 24 24 24 24 24 24 24 24 ... slowest runs (cycles): ... 24 24 24 24 24 24 24 24 40 160 min: 24 cycles q1: 24 cycles median: 24 cycles q3: 24 cycles max: 160 cycles RESULT TestNull_CycleCount: x86-64_nnacl_newlib_static= {24, 0} count Apparent clock speed: 14327 MHz TestNaClSyscall: Measuring real time: 0.154 usec (1.5436e-07 sec) per iteration: 1.5436e-05 sec for 100 iterations 0.150 usec (1.50277e-07 sec) per iteration: 0.0973552 sec for 647836 iterations 0.150 usec (1.49884e-07 sec) per iteration: 0.0971003 sec for 647836 iterations 0.150 usec (1.49751e-07 sec) per iteration: 0.0970142 sec for 647836 iterations 0.150 usec (1.50001e-07 sec) per iteration: 0.0971759 sec for 647836 iterations 0.151 usec (1.5066e-07 sec) per iteration: 0.0976028 sec for 647836 iterations mean: 0.150115 usec stddev: 0.000323 usec relative stddev: 0.22% RESULT TestNaClSyscall: x86-64_nnacl_newlib_static= {0.150115, 0.000323} us Measuring clock cycles: first runs (cycles): 588 368 364 316 316 332 324 320 320 324 ... slowest runs (cycles): ... 332 332 332 332 336 348 364 368 412 588 min: 316 cycles q1: 320 cycles median: 324 cycles q3: 328 cycles max: 588 cycles RESULT TestNaClSyscall_CycleCount: x86-64_nnacl_newlib_static= {324, 8} count Apparent clock speed: 2158 MHz TestSetjmpLongjmp: Measuring real time: 0.015 usec (1.499e-08 sec) per iteration: 1.499e-06 sec for 100 iterations 0.013 usec (1.3474e-08 sec) per iteration: 1.3474e-05 sec for 1000 iterations 0.011 usec (1.12691e-08 sec) per iteration: 0.0836362 sec for 7421701 iterations 0.011 usec (1.12695e-08 sec) per iteration: 0.0836389 sec for 7421701 iterations 0.011 usec (1.13034e-08 sec) per iteration: 0.0838904 sec for 7421701 iterations 0.011 usec (1.1267e-08 sec) per iteration: 0.0836202 sec for 7421701 iterations 0.011 usec (1.12526e-08 sec) per iteration: 0.0835135 sec for 7421701 iterations mean: 0.011272 usec stddev: 0.000017 usec relative stddev: 0.15% RESULT TestSetjmpLongjmp: x86-64_nnacl_newlib_static= {0.011272, 0.000017} us Measuring clock cycles: first runs (cycles): 296 60 24 60 28 28 24 28 24 28 ... slowest runs (cycles): ... 28 28 28 28 28 28 28 60 60 296 min: 24 cycles q1: 28 cycles median: 28 cycles q3: 28 cycles max: 296 cycles RESULT TestSetjmpLongjmp_CycleCount: x86-64_nnacl_newlib_static= {28, 0} count Apparent clock speed: 2484 MHz TestClockGetTime: Measuring real time: 0.235 usec (2.3537e-07 sec) per iteration: 2.3537e-05 sec for 100 iterations 0.162 usec (1.62395e-07 sec) per iteration: 0.0689953 sec for 424862 iterations 0.163 usec (1.62613e-07 sec) per iteration: 0.069088 sec for 424862 iterations 0.162 usec (1.61947e-07 sec) per iteration: 0.0688053 sec for 424862 iterations 0.163 usec (1.62979e-07 sec) per iteration: 0.0692438 sec for 424862 iterations 0.162 usec (1.61964e-07 sec) per iteration: 0.0688123 sec for 424862 iterations mean: 0.162380 usec stddev: 0.000393 usec relative stddev: 0.24% RESULT TestClockGetTime: x86-64_nnacl_newlib_static= {0.162380, 0.000393} us Measuring clock cycles: first runs (cycles): 952 524 476 492 472 504 484 488 492 488 ... slowest runs (cycles): ... 496 496 496 500 500 504 524 548 568 952 min: 472 cycles q1: 488 cycles median: 492 cycles q3: 496 cycles max: 952 cycles RESULT TestClockGetTime_CycleCount: x86-64_nnacl_newlib_static= {492, 8} count Apparent clock speed: 3030 MHz TestTlsVariable: Measuring real time: 0.014 usec (1.438e-08 sec) per iteration: 1.438e-06 sec for 100 iterations 0.009 usec (8.904e-09 sec) per iteration: 8.904e-06 sec for 1000 iterations 0.007 usec (7.111e-09 sec) per iteration: 7.111e-05 sec for 10000 iterations 0.005 usec (5.06327e-09 sec) per iteration: 0.0712034 sec for 14062719 iterations 0.005 usec (5.01306e-09 sec) per iteration: 0.0704973 sec for 14062719 iterations 0.005 usec (5.04708e-09 sec) per iteration: 0.0709756 sec for 14062719 iterations 0.005 usec (5.0129e-09 sec) per iteration: 0.070495 sec for 14062719 iterations 0.005 usec (5.01922e-09 sec) per iteration: 0.0705839 sec for 14062719 iterations mean: 0.005031 usec stddev: 0.000020 usec relative stddev: 0.41% RESULT TestTlsVariable: x86-64_nnacl_newlib_static= {0.005031, 0.000020} us Measuring clock cycles: first runs (cycles): 244 76 24 24 24 24 24 24 24 24 ... slowest runs (cycles): ... 24 24 24 24 24 24 24 24 76 244 min: 24 cycles q1: 24 cycles median: 24 cycles q3: 24 cycles max: 244 cycles RESULT TestTlsVariable_CycleCount: x86-64_nnacl_newlib_static= {24, 0} count Apparent clock speed: 4770 MHz TestMmapAnonymous: Measuring real time: 6.458 usec (6.45786e-06 sec) per iteration: 0.000645786 sec for 100 iterations 4.786 usec (4.7857e-06 sec) per iteration: 0.0741065 sec for 15485 iterations 4.777 usec (4.77681e-06 sec) per iteration: 0.0739689 sec for 15485 iterations 4.799 usec (4.79866e-06 sec) per iteration: 0.0743073 sec for 15485 iterations 4.775 usec (4.77506e-06 sec) per iteration: 0.0739418 sec for 15485 iterations 4.790 usec (4.78953e-06 sec) per iteration: 0.0741658 sec for 15485 iterations mean: 4.785152 usec stddev: 0.008642 usec relative stddev: 0.18% RESULT TestMmapAnonymous: x86-64_nnacl_newlib_static= {4.785152, 0.008642} us Measuring clock cycles: first runs (cycles): 31136 24348 23632 22840 80016 65864 29340 24464 23180 24244 ... slowest runs (cycles): ... 24464 24828 25224 27272 29340 31136 33744 65864 80016 100460 min: 14096 cycles q1: 14228 cycles median: 21380 cycles q3: 23164 cycles max: 100460 cycles RESULT TestMmapAnonymous_CycleCount: x86-64_nnacl_newlib_static= {21380, 8936} count Apparent clock speed: 4468 MHz TestAtomicIncrement: Measuring real time: 0.017 usec (1.695e-08 sec) per iteration: 1.695e-06 sec for 100 iterations 0.010 usec (1.0219e-08 sec) per iteration: 1.0219e-05 sec for 1000 iterations 0.009 usec (8.77674e-09 sec) per iteration: 0.0858865 sec for 9785693 iterations 0.009 usec (8.72788e-09 sec) per iteration: 0.0854083 sec for 9785693 iterations 0.009 usec (8.68928e-09 sec) per iteration: 0.0850306 sec for 9785693 iterations 0.009 usec (8.69459e-09 sec) per iteration: 0.0850826 sec for 9785693 iterations 0.009 usec (8.6852e-09 sec) per iteration: 0.0849907 sec for 9785693 iterations mean: 0.008715 usec stddev: 0.000034 usec relative stddev: 0.40% RESULT TestAtomicIncrement: x86-64_nnacl_newlib_static= {0.008715, 0.000034} us Measuring clock cycles: first runs (cycles): 204 52 52 52 52 60 52 52 52 52 ... slowest runs (cycles): ... 52 52 52 52 52 60 60 60 60 204 min: 52 cycles q1: 52 cycles median: 52 cycles q3: 52 cycles max: 204 cycles RESULT TestAtomicIncrement_CycleCount: x86-64_nnacl_newlib_static= {52, 0} count Apparent clock speed: 5967 MHz TestUncontendedMutexLock: Measuring real time: 0.030 usec (3.018e-08 sec) per iteration: 3.018e-06 sec for 100 iterations 0.026 usec (2.6297e-08 sec) per iteration: 2.6297e-05 sec for 1000 iterations 0.022 usec (2.1822e-08 sec) per iteration: 0.0829828 sec for 3802715 iterations 0.022 usec (2.17289e-08 sec) per iteration: 0.0826286 sec for 3802715 iterations 0.022 usec (2.17837e-08 sec) per iteration: 0.082837 sec for 3802715 iterations 0.022 usec (2.1751e-08 sec) per iteration: 0.0827128 sec for 3802715 iterations 0.022 usec (2.24542e-08 sec) per iteration: 0.0853867 sec for 3802715 iterations mean: 0.021908 usec stddev: 0.000275 usec relative stddev: 1.25% RESULT TestUncontendedMutexLock: x86-64_nnacl_newlib_static= {0.021908, 0.000275} us Measuring clock cycles: first runs (cycles): 316 120 88 92 88 92 88 92 88 92 ... slowest runs (cycles): ... 92 92 92 92 92 92 92 92 120 316 min: 88 cycles q1: 88 cycles median: 92 cycles q3: 92 cycles max: 316 cycles RESULT TestUncontendedMutexLock_CycleCount: x86-64_nnacl_newlib_static= {92, 4} count Apparent clock speed: 4199 MHz TestCondvarSignalNoOp: Measuring real time: 0.324 usec (3.2365e-07 sec) per iteration: 3.2365e-05 sec for 100 iterations 0.158 usec (1.58228e-07 sec) per iteration: 0.0488884 sec for 308975 iterations 0.158 usec (1.57684e-07 sec) per iteration: 0.0487205 sec for 308975 iterations 0.158 usec (1.57923e-07 sec) per iteration: 0.0487942 sec for 308975 iterations 0.159 usec (1.58682e-07 sec) per iteration: 0.0490286 sec for 308975 iterations 0.158 usec (1.57947e-07 sec) per iteration: 0.0488015 sec for 308975 iterations mean: 0.158093 usec stddev: 0.000341 usec relative stddev: 0.22% RESULT TestCondvarSignalNoOp: x86-64_nnacl_newlib_static= {0.158093, 0.000341} us Measuring clock cycles: first runs (cycles): 820 532 472 472 456 456 460 460 456 460 ... slowest runs (cycles): ... 464 464 464 464 468 472 472 532 564 820 min: 452 cycles q1: 460 cycles median: 460 cycles q3: 464 cycles max: 820 cycles RESULT TestCondvarSignalNoOp_CycleCount: x86-64_nnacl_newlib_static= {460, 4} count Apparent clock speed: 2910 MHz TestThreadCreateAndJoin: Measuring real time: 52.658 usec (5.26579e-05 sec) per iteration: 0.00526579 sec for 100 iterations 45.757 usec (4.57575e-05 sec) per iteration: 0.0868935 sec for 1899 iterations 41.432 usec (4.14316e-05 sec) per iteration: 0.0786785 sec for 1899 iterations 43.982 usec (4.39819e-05 sec) per iteration: 0.0835217 sec for 1899 iterations 45.844 usec (4.58442e-05 sec) per iteration: 0.0870581 sec for 1899 iterations 42.293 usec (4.2293e-05 sec) per iteration: 0.0803144 sec for 1899 iterations mean: 43.861643 usec stddev: 1.783539 usec relative stddev: 4.07% RESULT TestThreadCreateAndJoin: x86-64_nnacl_newlib_static= {43.861643, 1.783539} us Measuring clock cycles: first runs (cycles): 105067 82904 193412 199048 302908 135261 138483 122715 118995 119190 ... slowest runs (cycles): ... 122715 123996 125934 126327 135261 138483 144181 193412 199048 302908 min: 82904 cycles q1: 117831 cycles median: 118551 cycles q3: 119160 cycles max: 302908 cycles RESULT TestThreadCreateAndJoin_CycleCount: x86-64_nnacl_newlib_static= {118551, 1329} count Apparent clock speed: 2703 MHz TestThreadWakeup: Measuring real time: 12.913 usec (1.29132e-05 sec) per iteration: 0.00129132 sec for 100 iterations 10.402 usec (1.04015e-05 sec) per iteration: 0.0805494 sec for 7744 iterations 10.361 usec (1.03612e-05 sec) per iteration: 0.0802375 sec for 7744 iterations 10.301 usec (1.03014e-05 sec) per iteration: 0.079774 sec for 7744 iterations 10.359 usec (1.03592e-05 sec) per iteration: 0.0802219 sec for 7744 iterations 10.356 usec (1.03557e-05 sec) per iteration: 0.0801944 sec for 7744 iterations mean: 10.355812 usec stddev: 0.031914 usec relative stddev: 0.31% RESULT TestThreadWakeup: x86-64_nnacl_newlib_static= {10.355812, 0.031914} us Measuring clock cycles: first runs (cycles): 60756 56216 46484 179336 53532 34928 56148 62356 58536 50440 ... slowest runs (cycles): ... 46484 50440 53532 56148 56216 58536 60756 61828 62356 179336 min: 29672 cycles q1: 30428 cycles median: 31028 cycles q3: 31976 cycles max: 179336 cycles RESULT TestThreadWakeup_CycleCount: x86-64_nnacl_newlib_static= {31028, 1548} count Apparent clock speed: 2996 MHz TestCatchingFault: Measuring real time: 17.650 usec (1.76498e-05 sec) per iteration: 0.00176498 sec for 100 iterations 15.224 usec (1.52244e-05 sec) per iteration: 0.0862464 sec for 5665 iterations 15.252 usec (1.52517e-05 sec) per iteration: 0.0864007 sec for 5665 iterations 15.494 usec (1.54937e-05 sec) per iteration: 0.0877717 sec for 5665 iterations 15.843 usec (1.5843e-05 sec) per iteration: 0.0897507 sec for 5665 iterations 15.284 usec (1.5284e-05 sec) per iteration: 0.0865837 sec for 5665 iterations mean: 15.419356 usec stddev: 0.232144 usec relative stddev: 1.51% RESULT TestCatchingFault: x86-64_nnacl_newlib_static= {15.419356, 0.232144} us Measuring clock cycles: first runs (cycles): 68824 58400 57852 50144 54724 61752 49148 99008 67892 57928 ... slowest runs (cycles): ... 58400 61752 67892 68824 68952 90276 98520 99008 101376 117056 min: 44784 cycles q1: 45168 cycles median: 45396 cycles q3: 45812 cycles max: 117056 cycles RESULT TestCatchingFault_CycleCount: x86-64_nnacl_newlib_static= {45396, 644} count Apparent clock speed: 2944 MHz TestThreadCreateAndJoinAfterSettingFaultHandler: Measuring real time: 33.698 usec (3.36984e-05 sec) per iteration: 0.00336984 sec for 100 iterations 38.598 usec (3.85979e-05 sec) per iteration: 0.11452 sec for 2967 iterations 38.479 usec (3.84795e-05 sec) per iteration: 0.114169 sec for 2967 iterations 40.847 usec (4.08467e-05 sec) per iteration: 0.121192 sec for 2967 iterations 38.724 usec (3.8724e-05 sec) per iteration: 0.114894 sec for 2967 iterations 41.517 usec (4.15173e-05 sec) per iteration: 0.123182 sec for 2967 iterations mean: 39.633086 usec stddev: 1.284673 usec relative stddev: 3.24% RESULT TestThreadCreateAndJoinAfterSettingFaultHandler: x86-64_nnacl_newlib_static= {39.633086, 1.284673} us Measuring clock cycles: first runs (cycles): 76953 140886 178822 247916 135908 253992 117028 126845 127164 119100 ... slowest runs (cycles): ... 126237 126845 127164 135908 140886 148173 166493 178822 247916 253992 min: 76953 cycles q1: 117240 cycles median: 117726 cycles q3: 118281 cycles max: 253992 cycles RESULT TestThreadCreateAndJoinAfterSettingFaultHandler_CycleCount: x86-64_nnacl_newlib_static= {117726, 1041} count Apparent clock speed: 2970 MHz [ OK ] nacl_newlib.run_performance_test (5859 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