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 = 1545161621, usec = 509533 } Tue Dec 18 11:33:41 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 [73568,2557584256:17:50:04.084959] Native Client module will be loaded at base address 0x000044a900000000 Running suite of 1 benchmarks: Running Benchmark: Life (SIMD version)... RESULT BenchmarkLife: x86-64_nnacl_newlib_static= {0.141260, 0.004010} seconds --------------------------------------------------------------- Done running benchmark suite. [ OK ] nacl_newlib.run_benchmark_test (1310 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 [73578,2557584256:17:50:23.858183] Native Client module will be loaded at base address 0x000039d900000000 TestNull: Measuring real time: 0.006 usec (5.52e-09 sec) per iteration: 5.52e-07 sec for 100 iterations 0.002 usec (1.865e-09 sec) per iteration: 1.865e-06 sec for 1000 iterations 0.002 usec (1.6932e-09 sec) per iteration: 1.6932e-05 sec for 10000 iterations 0.002 usec (1.68115e-09 sec) per iteration: 0.0992886 sec for 59059768 iterations 0.002 usec (1.67599e-09 sec) per iteration: 0.0989835 sec for 59059768 iterations 0.002 usec (1.67188e-09 sec) per iteration: 0.0987409 sec for 59059768 iterations 0.002 usec (1.67138e-09 sec) per iteration: 0.0987116 sec for 59059768 iterations 0.002 usec (1.67124e-09 sec) per iteration: 0.0987031 sec for 59059768 iterations mean: 0.001674 usec stddev: 0.000004 usec relative stddev: 0.23% RESULT TestNull: x86-64_nnacl_newlib_static= {0.001674, 0.000004} us Measuring clock cycles: first runs (cycles): 176 40 24 24 24 24 24 24 24 24 ... slowest runs (cycles): ... 24 24 24 24 24 24 24 24 40 176 min: 24 cycles q1: 24 cycles median: 24 cycles q3: 24 cycles max: 176 cycles RESULT TestNull_CycleCount: x86-64_nnacl_newlib_static= {24, 0} count Apparent clock speed: 14334 MHz TestNaClSyscall: Measuring real time: 0.153 usec (1.5288e-07 sec) per iteration: 1.5288e-05 sec for 100 iterations 0.150 usec (1.49969e-07 sec) per iteration: 0.0980961 sec for 654107 iterations 0.152 usec (1.51698e-07 sec) per iteration: 0.0992264 sec for 654107 iterations 0.150 usec (1.49813e-07 sec) per iteration: 0.0979936 sec for 654107 iterations 0.150 usec (1.50087e-07 sec) per iteration: 0.098173 sec for 654107 iterations 0.150 usec (1.49783e-07 sec) per iteration: 0.0979741 sec for 654107 iterations mean: 0.150270 usec stddev: 0.000722 usec relative stddev: 0.48% RESULT TestNaClSyscall: x86-64_nnacl_newlib_static= {0.150270, 0.000722} us Measuring clock cycles: first runs (cycles): 504 356 352 352 320 324 320 324 320 324 ... slowest runs (cycles): ... 332 332 332 332 332 336 352 352 356 504 min: 320 cycles q1: 320 cycles median: 324 cycles q3: 324 cycles max: 504 cycles RESULT TestNaClSyscall_CycleCount: x86-64_nnacl_newlib_static= {324, 4} count Apparent clock speed: 2156 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.2756e-08 sec) per iteration: 1.2756e-05 sec for 1000 iterations 0.011 usec (1.1271e-08 sec) per iteration: 0.0883587 sec for 7839448 iterations 0.011 usec (1.12688e-08 sec) per iteration: 0.0883414 sec for 7839448 iterations 0.011 usec (1.12621e-08 sec) per iteration: 0.0882883 sec for 7839448 iterations 0.011 usec (1.12861e-08 sec) per iteration: 0.0884768 sec for 7839448 iterations 0.011 usec (1.12488e-08 sec) per iteration: 0.0881847 sec for 7839448 iterations mean: 0.011267 usec stddev: 0.000012 usec relative stddev: 0.11% RESULT TestSetjmpLongjmp: x86-64_nnacl_newlib_static= {0.011267, 0.000012} us Measuring clock cycles: first runs (cycles): 388 104 88 48 48 36 52 40 44 44 ... slowest runs (cycles): ... 60 64 64 64 64 68 68 88 104 388 min: 36 cycles q1: 44 cycles median: 52 cycles q3: 56 cycles max: 388 cycles RESULT TestSetjmpLongjmp_CycleCount: x86-64_nnacl_newlib_static= {52, 12} count Apparent clock speed: 4615 MHz TestClockGetTime: Measuring real time: 0.990 usec (9.902e-07 sec) per iteration: 9.902e-05 sec for 100 iterations 0.163 usec (1.63135e-07 sec) per iteration: 0.0164749 sec for 100989 iterations 0.167 usec (1.67197e-07 sec) per iteration: 0.0168851 sec for 100989 iterations 0.162 usec (1.62213e-07 sec) per iteration: 0.0163818 sec for 100989 iterations 0.163 usec (1.63033e-07 sec) per iteration: 0.0164646 sec for 100989 iterations 0.162 usec (1.62272e-07 sec) per iteration: 0.0163877 sec for 100989 iterations mean: 0.163570 usec stddev: 0.001852 usec relative stddev: 1.13% RESULT TestClockGetTime: x86-64_nnacl_newlib_static= {0.163570, 0.001852} us Measuring clock cycles: first runs (cycles): 864 512 472 480 476 492 484 472 476 496 ... slowest runs (cycles): ... 540 540 540 540 540 560 560 564 568 864 min: 472 cycles q1: 484 cycles median: 488 cycles q3: 496 cycles max: 864 cycles RESULT TestClockGetTime_CycleCount: x86-64_nnacl_newlib_static= {488, 12} count Apparent clock speed: 2983 MHz TestTlsVariable: Measuring real time: 0.014 usec (1.39e-08 sec) per iteration: 1.39e-06 sec for 100 iterations 0.009 usec (8.782e-09 sec) per iteration: 8.782e-06 sec for 1000 iterations 0.009 usec (8.5356e-09 sec) per iteration: 8.5356e-05 sec for 10000 iterations 0.005 usec (5.03999e-09 sec) per iteration: 0.0590468 sec for 11715638 iterations 0.005 usec (5.02002e-09 sec) per iteration: 0.0588127 sec for 11715638 iterations 0.005 usec (5.01457e-09 sec) per iteration: 0.0587489 sec for 11715638 iterations 0.005 usec (5.01353e-09 sec) per iteration: 0.0587367 sec for 11715638 iterations 0.005 usec (5.03403e-09 sec) per iteration: 0.0589768 sec for 11715638 iterations mean: 0.005024 usec stddev: 0.000011 usec relative stddev: 0.21% RESULT TestTlsVariable: x86-64_nnacl_newlib_static= {0.005024, 0.000011} us Measuring clock cycles: first runs (cycles): 288 64 44 24 24 24 24 24 24 24 ... slowest runs (cycles): ... 24 24 24 24 24 24 24 44 64 288 min: 24 cycles q1: 24 cycles median: 24 cycles q3: 24 cycles max: 288 cycles RESULT TestTlsVariable_CycleCount: x86-64_nnacl_newlib_static= {24, 0} count Apparent clock speed: 4777 MHz TestMmapAnonymous: Measuring real time: 6.910 usec (6.90978e-06 sec) per iteration: 0.000690978 sec for 100 iterations 4.972 usec (4.97182e-06 sec) per iteration: 0.0719522 sec for 14472 iterations 4.958 usec (4.95792e-06 sec) per iteration: 0.071751 sec for 14472 iterations 5.003 usec (5.00266e-06 sec) per iteration: 0.0723984 sec for 14472 iterations 4.972 usec (4.97219e-06 sec) per iteration: 0.0719576 sec for 14472 iterations 4.992 usec (4.99218e-06 sec) per iteration: 0.0722469 sec for 14472 iterations mean: 4.979355 usec stddev: 0.015969 usec relative stddev: 0.32% RESULT TestMmapAnonymous: x86-64_nnacl_newlib_static= {4.979355, 0.015969} us Measuring clock cycles: first runs (cycles): 19184 15280 14652 14744 14720 14832 14876 14636 14676 14660 ... slowest runs (cycles): ... 24852 25444 27516 35344 61340 69848 69892 87524 99276 146156 min: 14636 cycles q1: 14876 cycles median: 14968 cycles q3: 15072 cycles max: 146156 cycles RESULT TestMmapAnonymous_CycleCount: x86-64_nnacl_newlib_static= {14968, 196} count Apparent clock speed: 3006 MHz TestAtomicIncrement: Measuring real time: 0.016 usec (1.559e-08 sec) per iteration: 1.559e-06 sec for 100 iterations 0.022 usec (2.2322e-08 sec) per iteration: 2.2322e-05 sec for 1000 iterations 0.009 usec (8.7452e-09 sec) per iteration: 0.0391775 sec for 4479885 iterations 0.009 usec (8.74796e-09 sec) per iteration: 0.0391898 sec for 4479885 iterations 0.009 usec (8.70173e-09 sec) per iteration: 0.0389827 sec for 4479885 iterations 0.009 usec (8.6983e-09 sec) per iteration: 0.0389674 sec for 4479885 iterations 0.009 usec (8.69275e-09 sec) per iteration: 0.0389425 sec for 4479885 iterations mean: 0.008717 usec stddev: 0.000024 usec relative stddev: 0.28% RESULT TestAtomicIncrement: x86-64_nnacl_newlib_static= {0.008717, 0.000024} us Measuring clock cycles: first runs (cycles): 208 52 52 52 52 52 52 52 52 52 ... slowest runs (cycles): ... 52 52 52 52 52 52 52 52 56 208 min: 52 cycles q1: 52 cycles median: 52 cycles q3: 52 cycles max: 208 cycles RESULT TestAtomicIncrement_CycleCount: x86-64_nnacl_newlib_static= {52, 0} count Apparent clock speed: 5965 MHz TestUncontendedMutexLock: Measuring real time: 0.032 usec (3.212e-08 sec) per iteration: 3.212e-06 sec for 100 iterations 0.096 usec (9.6487e-08 sec) per iteration: 9.6487e-05 sec for 1000 iterations 0.022 usec (2.20726e-08 sec) per iteration: 0.0228762 sec for 1036409 iterations 0.022 usec (2.18022e-08 sec) per iteration: 0.022596 sec for 1036409 iterations 0.022 usec (2.1893e-08 sec) per iteration: 0.0226901 sec for 1036409 iterations 0.022 usec (2.17559e-08 sec) per iteration: 0.022548 sec for 1036409 iterations 0.022 usec (2.17555e-08 sec) per iteration: 0.0225476 sec for 1036409 iterations mean: 0.021856 usec stddev: 0.000119 usec relative stddev: 0.55% RESULT TestUncontendedMutexLock: x86-64_nnacl_newlib_static= {0.021856, 0.000119} us Measuring clock cycles: first runs (cycles): 312 120 88 92 88 92 88 92 88 92 ... slowest runs (cycles): ... 92 92 92 92 92 92 92 92 120 312 min: 88 cycles q1: 88 cycles median: 92 cycles q3: 92 cycles max: 312 cycles RESULT TestUncontendedMutexLock_CycleCount: x86-64_nnacl_newlib_static= {92, 4} count Apparent clock speed: 4209 MHz TestCondvarSignalNoOp: Measuring real time: 1.353 usec (1.35342e-06 sec) per iteration: 0.000135342 sec for 100 iterations 0.185 usec (1.85319e-07 sec) per iteration: 0.0136925 sec for 73886 iterations 0.158 usec (1.58375e-07 sec) per iteration: 0.0117017 sec for 73886 iterations 0.158 usec (1.58108e-07 sec) per iteration: 0.011682 sec for 73886 iterations 0.159 usec (1.59062e-07 sec) per iteration: 0.0117525 sec for 73886 iterations 0.158 usec (1.58169e-07 sec) per iteration: 0.0116864 sec for 73886 iterations mean: 0.163807 usec stddev: 0.010762 usec relative stddev: 6.57% RESULT TestCondvarSignalNoOp: x86-64_nnacl_newlib_static= {0.163807, 0.010762} us Measuring clock cycles: first runs (cycles): 824 476 476 456 456 460 456 460 460 460 ... slowest runs (cycles): ... 468 468 468 472 476 476 476 476 568 824 min: 456 cycles q1: 460 cycles median: 460 cycles q3: 464 cycles max: 824 cycles RESULT TestCondvarSignalNoOp_CycleCount: x86-64_nnacl_newlib_static= {460, 4} count Apparent clock speed: 2808 MHz TestThreadCreateAndJoin: Measuring real time: 49.720 usec (4.97198e-05 sec) per iteration: 0.00497198 sec for 100 iterations 45.032 usec (4.50322e-05 sec) per iteration: 0.0905597 sec for 2011 iterations 38.633 usec (3.86329e-05 sec) per iteration: 0.0776907 sec for 2011 iterations 38.243 usec (3.8243e-05 sec) per iteration: 0.0769067 sec for 2011 iterations 38.334 usec (3.83345e-05 sec) per iteration: 0.0770906 sec for 2011 iterations 39.187 usec (3.91875e-05 sec) per iteration: 0.078806 sec for 2011 iterations mean: 39.885995 usec stddev: 2.594152 usec relative stddev: 6.50% RESULT TestThreadCreateAndJoin: x86-64_nnacl_newlib_static= {39.885995, 2.594152} us Measuring clock cycles: first runs (cycles): 121635 185864 129684 272552 110132 125644 177840 158948 91776 78036 ... slowest runs (cycles): ... 121635 121878 125644 129684 144967 152288 158948 177840 185864 272552 min: 73676 cycles q1: 110132 cycles median: 117663 cycles q3: 118530 cycles max: 272552 cycles RESULT TestThreadCreateAndJoin_CycleCount: x86-64_nnacl_newlib_static= {117663, 8398} count Apparent clock speed: 2950 MHz TestThreadWakeup: Measuring real time: 12.724 usec (1.27241e-05 sec) per iteration: 0.00127241 sec for 100 iterations 10.127 usec (1.01266e-05 sec) per iteration: 0.0795848 sec for 7859 iterations 10.321 usec (1.03212e-05 sec) per iteration: 0.0811142 sec for 7859 iterations 10.242 usec (1.0242e-05 sec) per iteration: 0.0804922 sec for 7859 iterations 10.336 usec (1.03357e-05 sec) per iteration: 0.0812286 sec for 7859 iterations 10.345 usec (1.03452e-05 sec) per iteration: 0.0813031 sec for 7859 iterations mean: 10.274154 usec stddev: 0.082300 usec relative stddev: 0.80% RESULT TestThreadWakeup: x86-64_nnacl_newlib_static= {10.274154, 0.082300} us Measuring clock cycles: first runs (cycles): 37848 31484 31824 61276 43504 44864 115712 56008 45748 136108 ... slowest runs (cycles): ... 44864 45748 56008 56788 58324 61276 88040 97736 115712 136108 min: 29636 cycles q1: 30324 cycles median: 31128 cycles q3: 31700 cycles max: 136108 cycles RESULT TestThreadWakeup_CycleCount: x86-64_nnacl_newlib_static= {31128, 1376} count Apparent clock speed: 3030 MHz TestCatchingFault: Measuring real time: 17.107 usec (1.71069e-05 sec) per iteration: 0.00171069 sec for 100 iterations 15.169 usec (1.51687e-05 sec) per iteration: 0.0886612 sec for 5845 iterations 15.188 usec (1.51878e-05 sec) per iteration: 0.0887727 sec for 5845 iterations 15.413 usec (1.54128e-05 sec) per iteration: 0.0900878 sec for 5845 iterations 15.180 usec (1.51797e-05 sec) per iteration: 0.0887252 sec for 5845 iterations 15.384 usec (1.53837e-05 sec) per iteration: 0.0899177 sec for 5845 iterations mean: 15.266538 usec stddev: 0.108101 usec relative stddev: 0.71% RESULT TestCatchingFault: x86-64_nnacl_newlib_static= {15.266538, 0.108101} us Measuring clock cycles: first runs (cycles): 53872 67120 45820 82152 94280 140860 84144 109924 83004 64520 ... slowest runs (cycles): ... 61784 64520 67120 82152 83004 83844 84144 94280 109924 140860 min: 44804 cycles q1: 45104 cycles median: 45296 cycles q3: 46064 cycles max: 140860 cycles RESULT TestCatchingFault_CycleCount: x86-64_nnacl_newlib_static= {45296, 960} count Apparent clock speed: 2967 MHz TestThreadCreateAndJoinAfterSettingFaultHandler: Measuring real time: 38.819 usec (3.88189e-05 sec) per iteration: 0.00388189 sec for 100 iterations 39.962 usec (3.99615e-05 sec) per iteration: 0.102941 sec for 2576 iterations 45.095 usec (4.50949e-05 sec) per iteration: 0.116164 sec for 2576 iterations 45.304 usec (4.53041e-05 sec) per iteration: 0.116703 sec for 2576 iterations 41.702 usec (4.17021e-05 sec) per iteration: 0.107425 sec for 2576 iterations 38.546 usec (3.85457e-05 sec) per iteration: 0.0992937 sec for 2576 iterations mean: 42.121668 usec stddev: 2.705469 usec relative stddev: 6.42% RESULT TestThreadCreateAndJoinAfterSettingFaultHandler: x86-64_nnacl_newlib_static= {42.121668, 2.705469} us Measuring clock cycles: first runs (cycles): 103376 83148 217980 138096 287376 169284 176016 142432 134193 118710 ... slowest runs (cycles): ... 135765 138096 138708 142432 165689 169284 173613 176016 217980 287376 min: 73148 cycles q1: 117048 cycles median: 117987 cycles q3: 118767 cycles max: 287376 cycles RESULT TestThreadCreateAndJoinAfterSettingFaultHandler_CycleCount: x86-64_nnacl_newlib_static= {117987, 1719} count Apparent clock speed: 2801 MHz [ OK ] nacl_newlib.run_performance_test (4750 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