Back to build
Raw log | Switch to full mode | Login

Running command: /b/s/w/ir/cache/vpython/b574a6/bin/python scons.py --verbose -k -j1 --mode=nacl,opt-host,nacl_irt_test platform=x86-32 --clang --nacl_glibc breakpad_tools_dir=breakpad-out large_tests_irt scons: Reading SConscript files ... ====================================================================== SCONS ARGS:['scons.py', '--verbose', '-k', '-j1', '--mode=nacl,opt-host,nacl_irt_test', 'platform=x86-32', '--clang', '--nacl_glibc', 'breakpad_tools_dir=breakpad-out', 'large_tests_irt'] ====================================================================== ====================================================================== Python Info: ====================================================================== linux2 2.7.14+chromium14 (df075345c7-dirty:df075345c7, Oct 3 2017, 17:29:00) [GCC 4.8.4] ====================================================================== ENV: ====================================================================== PATH /b/s/w/ir/cache/vpython/b574a6/bin:/b/s/w/ir/cipd_bin_packages:/b/s/w/ir/cipd_bin_packages/bin:/b/s/cipd_cache/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/snap/bin:/b/s/w/ir/kitchen-checkout/depot_tools ====================================================================== OS: ====================================================================== Linux luci-flex-try-trusty-3-oss1 4.4.0-78-generic #99~14.04.2-Ubuntu SMP Thu Apr 27 18:49:46 UTC 2017 x86_64 x86_64 x86_64 GNU/Linux ====================================================================== CPU: ====================================================================== model name : Intel(R) Xeon(R) CPU @ 2.20GHz stepping : 0 cpu MHz : 2200.000 model name : Intel(R) Xeon(R) CPU @ 2.20GHz stepping : 0 cpu MHz : 2200.000 model name : Intel(R) Xeon(R) CPU @ 2.20GHz stepping : 0 cpu MHz : 2200.000 model name : Intel(R) Xeon(R) CPU @ 2.20GHz stepping : 0 cpu MHz : 2200.000 model name : Intel(R) Xeon(R) CPU @ 2.20GHz stepping : 0 cpu MHz : 2200.000 model name : Intel(R) Xeon(R) CPU @ 2.20GHz stepping : 0 cpu MHz : 2200.000 model name : Intel(R) Xeon(R) CPU @ 2.20GHz stepping : 0 cpu MHz : 2200.000 model name : Intel(R) Xeon(R) CPU @ 2.20GHz stepping : 0 cpu MHz : 2200.000 ====================================================================== RAM: ====================================================================== MemTotal: 30882896 kB MemFree: 22600892 kB MemAvailable: 29446752 kB ====================================================================== LOAD: ====================================================================== 1.24 1.75 0.93 2/410 6108 ====================================================================== UPTIME: ====================================================================== 3854.93 29632.00 ====================================================================== The following environments have been configured ====================================================================== NACL_BUILD_FAMILY: UNTRUSTED BUILD_TYPE: nacl TARGET_ROOT: /b/s/w/ir/k/native_client/scons-out/nacl-x86-32-glibc OBJ_ROOT: /b/s/w/ir/k/native_client/scons-out/nacl-x86-32-glibc/obj BUILD_TYPE_DESCRIPTION: NaCl module build BUILD_OS: BUILD_ARCHITECTURE: x86 BUILD_SUBARCH: 32 TARGET_OS: TARGET_ARCHITECTURE: x86 TARGET_SUBARCH: 32 CC: /b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/x86_64-nacl-gcc ASPPCOM: /b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/x86_64-nacl-gcc -m32 -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=32 -I/b/s/w/ir/k/native_client/scons-out/nacl-x86-32-glibc/include -I/b/s/w/ir/k -c -o set BOTO_CONFIG='/home/chrome-bot/.boto' BUILDBOT_BUILDERNAME='nacl-precise32_glibc_opt' BUILDBOT_BUILDNUMBER='6978' BUILDBOT_GOT_REVISION='1ed9878b8eb68c1e0d0268754dafcf83e747fa8f' BUILDBOT_MASTERNAME='tryserver.nacl' BUILDBOT_REVISION='' BUILDBOT_SLAVE_TYPE='Trybot' BUILDBUCKET_EXPERIMENTAL='FALSE' CIPD_CACHE_DIR='/b/s/cipd_cache/cache' CIPD_PROTOCOL='v2' CYGWIN='nodosfilewarning' DEVSHELL_CLIENT_PORT='36111' DOCKER_CONFIG='/b/s/w/ir/tmp/docker_cfg_task' DOCKER_TMPDIR='/b/s/w/ir/tmp/docker_tmp_task' GIT_CONFIG_NOSYSTEM='1' GIT_TERMINAL_PROMPT='0' GOMA_DIR='/b/s/w/ir/cache/goma/client' GOMA_TMP_DIR='/b/s/w/ir/tmp/rt/goma' GSUTIL='/b/s/w/ir/kitchen-checkout/depot_tools/gsutil.py' HOME='/home/chrome-bot' IFS=' ' INFRA_GIT_WRAPPER_HOME='/b/s/w/ir/tmp/git_home_task' LOGDOG_COORDINATOR_HOST='logs.chromium.org' LOGDOG_STREAM_PREFIX='buildbucket/cr-buildbucket.appspot.com/8918839819004129584' LOGDOG_STREAM_PROJECT='nacl' LOGDOG_STREAM_SERVER_PATH='unix:/b/s/w/ir/tmp/ld.sock' LOGNAME='chrome-bot' LUCI_CONTEXT='/b/s/w/itZrNroy/luci_context.290160727' MAC_CHROMIUM_TMPDIR='/b/s/w/ir/tmp/t' MAIL='/var/mail/chrome-bot' NATIVE_PYTHON='python' NOCONTROL_GOMA='1' NO_GCE_CHECK='False' OPTIND='1' PATH='/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin:/b/s/w/ir/cache/vpython/b574a6/bin:/b/s/w/ir/cipd_bin_packages:/b/s/w/ir/cipd_bin_packages/bin:/b/s/cipd_cache/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/snap/bin:/b/s/w/ir/kitchen-checkout/depot_tools' PPID='6082' PS1='$ ' PS2='> ' PS4='+ ' PWD='/b/s/w/ir/k/native_client' PYTHONDONTWRITEBYTECODE='1' PYTHONIOENCODING='UTF-8' PYTHONNOUSERSITE='1' PYTHONPATH='/b/s/w/ir/kitchen-checkout/build/scripts:/b/s/w/ir/kitchen-checkout/build/site_config' PYTHONUNBUFFERED='1' QEMU_PREFIX_HOOK='' RUNTEST='/b/s/w/ir/kitchen-checkout/build/scripts/slave/runtest.py' SHELL='/bin/bash' SHLVL='1' SUDO_COMMAND='/usr/bin/python /b/s/swarming_bot.zip start_bot' SUDO_GID='0' SUDO_UID='0' SUDO_USER='root' SWARMING_BOT_ID='luci-flex-try-trusty-3-oss1' SWARMING_EXTERNAL_BOT_SETUP='1' SWARMING_HEADLESS='1' SWARMING_SERVER='https://chromium-swarm.appspot.com' SWARMING_TASK_ID='439ea70b95ab3b11' TEMP='/b/s/w/ir/tmp/t/nacl_tmp/nacl-precise32_glibc_opt' TEMPDIR='/b/s/w/ir/tmp/t' TERM='linux' TMP='/b/s/w/ir/tmp/t/nacl_tmp/nacl-precise32_glibc_opt' TMPDIR='/b/s/w/ir/tmp/t/nacl_tmp/nacl-precise32_glibc_opt' USER='chrome-bot' USERNAME='chrome-bot' VIRTUAL_ENV='/b/s/w/ir/cache/vpython/b574a6' VPYTHON_VIRTUALENV_ROOT='/b/s/w/ir/cache/vpython' _='/b/s/w/ir/cipd_bin_packages/vpython' /b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/x86_64-nacl-gcc -v -c Using built-in specs. Target: x86_64-nacl Configured with: /mnt/data/b/build/slave/nacl-toolchain/build/native_client/tools/SRC/gcc/configure CC='gcc -m32' CFLAGS='-O2 -g -Dinhibit_libc -D__gthr_posix_h' LDFLAGS=-s 'CFLAGS_FOR_TARGET=-O2 -g ' 'CXXFLAGS_FOR_TARGET=-O2 -g ' --prefix=/mnt/data/b/build/slave/nacl-toolchain/build/native_client/tools/toolchain/linux_x86 --disable-decimal-float --disable-libgomp --disable-libmudflap --disable-libssp --disable-libstdcxx-pch --target=x86_64-nacl --enable-linker-build-id --with-gmp=/mnt/data/b/build/slave/nacl-toolchain/build/native_client/tools/BUILD/.gcc-extra-install-gmp --with-mpfr=/mnt/data/b/build/slave/nacl-toolchain/build/native_client/tools/BUILD/.gcc-extra-install-mpfr --with-ppl=/mnt/data/b/build/slave/nacl-toolchain/build/native_client/tools/BUILD/.gcc-extra-install-ppl --with-host-libstdcxx='-lpwl -Wl,-Bstatic -lstdc++ -Wl,-Bdynamic -lm' --with-cloog=/mnt/data/b/build/slave/nacl-toolchain/build/native_client/tools/BUILD/.gcc-extra-install-cloog-ppl --disable-ppl-version-check --enable-shared --enable-languages=c,c++,objc,obj-c++,fortran --enable-threads=posix --enable-tls Thread model: posix gcc version 4.4.3 20150713 (Native Client 9ff1dc0c05b45941b86bed303a87a9eac17192ea, Git Commit f80d6b9ee7f94755c697ffb7194fb01dd0c537dd) (GCC) /b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/x86_64-nacl-gcc -print-search-dirs install: /b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/../lib/gcc/x86_64-nacl/4.4.3/ programs: =/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/../libexec/gcc/x86_64-nacl/4.4.3/:/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/../libexec/gcc/:/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/../lib/gcc/x86_64-nacl/4.4.3/../../../../x86_64-nacl/bin/x86_64-nacl/4.4.3/:/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/../lib/gcc/x86_64-nacl/4.4.3/../../../../x86_64-nacl/bin/ libraries: =/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/../lib/gcc/x86_64-nacl/4.4.3/:/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/../lib/gcc/:/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/../lib/gcc/x86_64-nacl/4.4.3/../../../../x86_64-nacl/lib/x86_64-nacl/4.4.3/:/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/../lib/gcc/x86_64-nacl/4.4.3/../../../../x86_64-nacl/lib/../lib64/:/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/../lib/gcc/x86_64-nacl/4.4.3/../../../../x86_64-nacl/lib/ /b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/x86_64-nacl-gcc -print-libgcc-file-name /b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/../lib/gcc/x86_64-nacl/4.4.3/libgcc.a NACL_BUILD_FAMILY: TRUSTED BUILD_TYPE: opt-linux TARGET_ROOT: /b/s/w/ir/k/native_client/scons-out/opt-linux-x86-32 OBJ_ROOT: /b/s/w/ir/k/native_client/scons-out/opt-linux-x86-32/obj BUILD_TYPE_DESCRIPTION: Linux opt build BUILD_OS: BUILD_ARCHITECTURE: x86 BUILD_SUBARCH: 32 TARGET_OS: TARGET_ARCHITECTURE: x86 TARGET_SUBARCH: 32 CC: /b/s/w/ir/k/third_party/llvm-build/Release+Asserts/bin/clang ASPPCOM: /b/s/w/ir/k/third_party/llvm-build/Release+Asserts/bin/clang -fPIE -m32 -Wall -pedantic -Wextra -Wno-long-long -Wswitch-enum -Wsign-compare -Wundef -fdiagnostics-show-option -fvisibility=hidden -fstack-protector -Werror -Wno-variadic-macros -Wno-covered-switch-default -Wno-c++11-extensions -O2 -D_FORTIFY_SOURCE=2 -D_POSIX_C_SOURCE=199506 -D_XOPEN_SOURCE=600 -D_GNU_SOURCE=1 -D_LARGEFILE64_SOURCE=1 -D__STDC_LIMIT_MACROS=1 -D__STDC_FORMAT_MACROS=1 -DNDEBUG -I/b/s/w/ir/k -c -o UNKNOWN COMPILER NACL_BUILD_FAMILY: UNTRUSTED_IRT_TESTS BUILD_TYPE: nacl_irt_test TARGET_ROOT: /b/s/w/ir/k/native_client/scons-out/nacl_irt_test-x86-32-glibc OBJ_ROOT: /b/s/w/ir/k/native_client/scons-out/nacl_irt_test-x86-32-glibc/obj BUILD_TYPE_DESCRIPTION: NaCl tests build with IRT BUILD_OS: BUILD_ARCHITECTURE: x86 BUILD_SUBARCH: 32 TARGET_OS: TARGET_ARCHITECTURE: x86 TARGET_SUBARCH: 32 CC: /b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/x86_64-nacl-gcc ASPPCOM: /b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/x86_64-nacl-gcc -m32 -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=32 -Iscons-out/nacl-x86-32-glibc/include -I/b/s/w/ir/k -c -o set BOTO_CONFIG='/home/chrome-bot/.boto' BUILDBOT_BUILDERNAME='nacl-precise32_glibc_opt' BUILDBOT_BUILDNUMBER='6978' BUILDBOT_GOT_REVISION='1ed9878b8eb68c1e0d0268754dafcf83e747fa8f' BUILDBOT_MASTERNAME='tryserver.nacl' BUILDBOT_REVISION='' BUILDBOT_SLAVE_TYPE='Trybot' BUILDBUCKET_EXPERIMENTAL='FALSE' CIPD_CACHE_DIR='/b/s/cipd_cache/cache' CIPD_PROTOCOL='v2' CYGWIN='nodosfilewarning' DEVSHELL_CLIENT_PORT='36111' DOCKER_CONFIG='/b/s/w/ir/tmp/docker_cfg_task' DOCKER_TMPDIR='/b/s/w/ir/tmp/docker_tmp_task' GIT_CONFIG_NOSYSTEM='1' GIT_TERMINAL_PROMPT='0' GOMA_DIR='/b/s/w/ir/cache/goma/client' GOMA_TMP_DIR='/b/s/w/ir/tmp/rt/goma' GSUTIL='/b/s/w/ir/kitchen-checkout/depot_tools/gsutil.py' HOME='/home/chrome-bot' IFS=' ' INFRA_GIT_WRAPPER_HOME='/b/s/w/ir/tmp/git_home_task' LOGDOG_COORDINATOR_HOST='logs.chromium.org' LOGDOG_STREAM_PREFIX='buildbucket/cr-buildbucket.appspot.com/8918839819004129584' LOGDOG_STREAM_PROJECT='nacl' LOGDOG_STREAM_SERVER_PATH='unix:/b/s/w/ir/tmp/ld.sock' LOGNAME='chrome-bot' LUCI_CONTEXT='/b/s/w/itZrNroy/luci_context.290160727' MAC_CHROMIUM_TMPDIR='/b/s/w/ir/tmp/t' MAIL='/var/mail/chrome-bot' NATIVE_PYTHON='python' NOCONTROL_GOMA='1' NO_GCE_CHECK='False' OPTIND='1' PATH='/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin:/b/s/w/ir/cache/vpython/b574a6/bin:/b/s/w/ir/cipd_bin_packages:/b/s/w/ir/cipd_bin_packages/bin:/b/s/cipd_cache/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/snap/bin:/b/s/w/ir/kitchen-checkout/depot_tools' PPID='6082' PS1='$ ' PS2='> ' PS4='+ ' PWD='/b/s/w/ir/k/native_client' PYTHONDONTWRITEBYTECODE='1' PYTHONIOENCODING='UTF-8' PYTHONNOUSERSITE='1' PYTHONPATH='/b/s/w/ir/kitchen-checkout/build/scripts:/b/s/w/ir/kitchen-checkout/build/site_config' PYTHONUNBUFFERED='1' QEMU_PREFIX_HOOK='' RUNTEST='/b/s/w/ir/kitchen-checkout/build/scripts/slave/runtest.py' SHELL='/bin/bash' SHLVL='1' SUDO_COMMAND='/usr/bin/python /b/s/swarming_bot.zip start_bot' SUDO_GID='0' SUDO_UID='0' SUDO_USER='root' SWARMING_BOT_ID='luci-flex-try-trusty-3-oss1' SWARMING_EXTERNAL_BOT_SETUP='1' SWARMING_HEADLESS='1' SWARMING_SERVER='https://chromium-swarm.appspot.com' SWARMING_TASK_ID='439ea70b95ab3b11' TEMP='/b/s/w/ir/tmp/t/nacl_tmp/nacl-precise32_glibc_opt' TEMPDIR='/b/s/w/ir/tmp/t' TERM='linux' TMP='/b/s/w/ir/tmp/t/nacl_tmp/nacl-precise32_glibc_opt' TMPDIR='/b/s/w/ir/tmp/t/nacl_tmp/nacl-precise32_glibc_opt' USER='chrome-bot' USERNAME='chrome-bot' VIRTUAL_ENV='/b/s/w/ir/cache/vpython/b574a6' VPYTHON_VIRTUALENV_ROOT='/b/s/w/ir/cache/vpython' _='/b/s/w/ir/cipd_bin_packages/vpython' /b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/x86_64-nacl-gcc -v -c Using built-in specs. Target: x86_64-nacl Configured with: /mnt/data/b/build/slave/nacl-toolchain/build/native_client/tools/SRC/gcc/configure CC='gcc -m32' CFLAGS='-O2 -g -Dinhibit_libc -D__gthr_posix_h' LDFLAGS=-s 'CFLAGS_FOR_TARGET=-O2 -g ' 'CXXFLAGS_FOR_TARGET=-O2 -g ' --prefix=/mnt/data/b/build/slave/nacl-toolchain/build/native_client/tools/toolchain/linux_x86 --disable-decimal-float --disable-libgomp --disable-libmudflap --disable-libssp --disable-libstdcxx-pch --target=x86_64-nacl --enable-linker-build-id --with-gmp=/mnt/data/b/build/slave/nacl-toolchain/build/native_client/tools/BUILD/.gcc-extra-install-gmp --with-mpfr=/mnt/data/b/build/slave/nacl-toolchain/build/native_client/tools/BUILD/.gcc-extra-install-mpfr --with-ppl=/mnt/data/b/build/slave/nacl-toolchain/build/native_client/tools/BUILD/.gcc-extra-install-ppl --with-host-libstdcxx='-lpwl -Wl,-Bstatic -lstdc++ -Wl,-Bdynamic -lm' --with-cloog=/mnt/data/b/build/slave/nacl-toolchain/build/native_client/tools/BUILD/.gcc-extra-install-cloog-ppl --disable-ppl-version-check --enable-shared --enable-languages=c,c++,objc,obj-c++,fortran --enable-threads=posix --enable-tls Thread model: posix gcc version 4.4.3 20150713 (Native Client 9ff1dc0c05b45941b86bed303a87a9eac17192ea, Git Commit f80d6b9ee7f94755c697ffb7194fb01dd0c537dd) (GCC) /b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/x86_64-nacl-gcc -print-search-dirs install: /b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/../lib/gcc/x86_64-nacl/4.4.3/ programs: =/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/../libexec/gcc/x86_64-nacl/4.4.3/:/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/../libexec/gcc/:/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/../lib/gcc/x86_64-nacl/4.4.3/../../../../x86_64-nacl/bin/x86_64-nacl/4.4.3/:/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/../lib/gcc/x86_64-nacl/4.4.3/../../../../x86_64-nacl/bin/ libraries: =/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/../lib/gcc/x86_64-nacl/4.4.3/:/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/../lib/gcc/:/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/../lib/gcc/x86_64-nacl/4.4.3/../../../../x86_64-nacl/lib/x86_64-nacl/4.4.3/:/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/../lib/gcc/x86_64-nacl/4.4.3/../../../../x86_64-nacl/lib/../lib64/:/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/../lib/gcc/x86_64-nacl/4.4.3/../../../../x86_64-nacl/lib/ /b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/x86_64-nacl-gcc -print-libgcc-file-name /b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/bin/../lib/gcc/x86_64-nacl/4.4.3/libgcc.a NACL_BUILD_FAMILY: UNTRUSTED_IRT BUILD_TYPE: nacl_irt TARGET_ROOT: /b/s/w/ir/k/native_client/scons-out/nacl_irt-x86-32 OBJ_ROOT: /b/s/w/ir/k/native_client/scons-out/nacl_irt-x86-32/obj BUILD_TYPE_DESCRIPTION: NaCl IRT build BUILD_OS: BUILD_ARCHITECTURE: x86 BUILD_SUBARCH: 32 TARGET_OS: TARGET_ARCHITECTURE: x86 TARGET_SUBARCH: 32 CC: /b/s/w/ir/k/native_client/toolchain/linux_x86/pnacl_newlib_raw/bin/x86_64-nacl-clang ASPPCOM: /b/s/w/ir/k/native_client/toolchain/linux_x86/pnacl_newlib_raw/bin/x86_64-nacl-clang -m32 -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=32 -I/b/s/w/ir/k/native_client/scons-out/nacl_irt-x86-32/include -I/b/s/w/ir/k -I/b/s/w/ir/k/native_client/src/untrusted/pthread -c -o UNKNOWN COMPILER *** BROKEN run_barebones_addr_modes_test *** BROKEN run_barebones_exit_test *** BROKEN run_barebones_fib_test *** BROKEN run_barebones_hello_world_test *** BROKEN run_barebones_negindex_test *** BROKEN run_barebones_only_bss_test *** BROKEN run_barebones_regs_test *** BROKEN run_barebones_reloc_test *** BROKEN run_barebones_switch_test *** BROKEN run_barebones_vtable_test *** BROKEN run_barebones_vaarg_test *** BROKEN run_custom_desc_test *** BROKEN run_faulted_thread_queue_test *** BROKEN run_minnacl_test *** BROKEN run_minnacl_separate_thread_test *** BROKEN run_multidomain_test *** BROKEN run_pwrite_test *** BROKEN run_signal_handler_single_step_test *** BROKEN run_signal_handler_regs_single_step_test *** BROKEN run_thread_suspension_test *** BROKEN run_crash_in_syscall_test *** BROKEN run_log_fatal_in_syscall_test *** BROKEN run_check_failure_in_syscall_test *** BROKEN run_jump_to_zero_in_syscall_test *** BROKEN run_jump_into_sandbox_in_syscall_crash_test *** BROKEN run_debug_stub_test *** BROKEN run_dynamic_load_test *** BROKEN run_write_to_dyncode_before_alloc_test *** BROKEN run_write_to_dyncode_after_alloc_test *** BROKEN run_dyncode_debug_mode_test *** BROKEN run_dyncode_demand_alloc_test *** BROKEN run_dyncode_disabled_test *** BROKEN run_dyncode_syscall_disabled_test *** BROKEN run_dynamic_modify_test *** BROKEN run_dir_test *** SKIPPING opt-linux-32 : run_abi_test *** BROKEN run_wcstoll_test *** BROKEN run_iconv_test *** BROKEN run_mmap_prot_exec_test *** BROKEN run_mmap_prot_exec_disabled_test *** BROKEN run_nanosleep_test *** BROKEN run_sel_main_chrome_test *** BROKEN run_sel_main_chrome_vcache_test *** BROKEN run_sel_main_chrome_irt_optional_with_seg_gap_test *** SKIPPING opt-linux-32 : run_sysbasic_test *** BROKEN run_getpid_test *** BROKEN run_getpid_disabled_test *** BROKEN run_syscall_secure_test *** SKIPPING opt-linux-32 : run_sysbrk_test *** BROKEN run_timefuncs_test *** BROKEN run_raw_timefuncs_test *** BROKEN run_file_access_enabled_test *** BROKEN run_file_access_disabled_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_nacl_sync_cond_test *** BROKEN run_debug_stub_test_irt *** BROKEN run_dynamic_load_test_irt *** BROKEN run_write_to_dyncode_before_alloc_test_irt *** BROKEN run_write_to_dyncode_after_alloc_test_irt *** BROKEN run_dyncode_debug_mode_test_irt *** BROKEN run_dyncode_demand_alloc_test_irt *** BROKEN run_dyncode_syscall_disabled_test_irt *** BROKEN run_dynamic_modify_test_irt *** BROKEN run_glibc_static_hello_test_irt *** BROKEN run_dir_test_irt *** SKIPPING nacl_irt_test-32 : run_abi_test_irt *** BROKEN run_wcstoll_test_irt *** BROKEN run_iconv_test_irt *** BROKEN run_mmap_prot_exec_test_irt *** BROKEN run_mmap_prot_exec_disabled_test_irt *** BROKEN run_nanosleep_test_irt *** BROKEN run_sel_main_chrome_test_irt *** BROKEN run_sel_main_chrome_vcache_test_irt *** BROKEN run_sel_main_chrome_irt_optional_with_seg_gap_test_irt *** SKIPPING nacl_irt_test-32 : run_sysbasic_test_irt *** BROKEN run_getpid_disabled_test_irt *** BROKEN run_syscall_secure_test_irt *** SKIPPING nacl_irt_test-32 : run_sysbrk_test_irt *** BROKEN run_timefuncs_test_irt *** BROKEN run_raw_timefuncs_test_irt *** BROKEN run_file_access_enabled_test_irt *** BROKEN run_file_access_disabled_test_irt *** BROKEN run_stack_frame_noopt_frame_test_irt *** BROKEN run_stack_frame_noopt_noframe_test_irt *** BROKEN run_stack_frame_opt_frame_test_irt *** BROKEN run_stack_frame_opt_noframe_test_irt There are 83 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/b574a6/bin/python tools/command_tester.py --name nacl_glibc.run_benchmark_test_irt --time_warning 10 --time_error 100 --perf_env_description x86-32_with_irt_nnacl_glibc_dynamic --using_nacl_signal_handler True --subarch 32 --arch x86 --capture_output 0 --output_stamp /b/s/w/ir/k/native_client/scons-out/nacl_irt_test-x86-32-glibc/test_results/benchmark_test.out scons-out/opt-linux-x86-32/staging/nacl_helper_bootstrap scons-out/opt-linux-x86-32/staging/sel_ldr --r_debug=0xXXXXXXXXXXXXXXXX --reserved_at_zero=0xXXXXXXXXXXXXXXXX -a -B scons-out/nacl_irt-x86-32/staging/irt_core.nexe -- /b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/x86_64-nacl/lib32/runnable-ld.so --library-path scons-out/nacl-x86-32-glibc/lib:/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/x86_64-nacl/lib32 scons-out/nacl_irt_test-x86-32-glibc/obj/tests/benchmark/benchmark_test.nexe x86-32_with_irt_nnacl_glibc_dynamic [ RUN ] nacl_glibc.run_benchmark_test_irt scons-out/opt-linux-x86-32/staging/nacl_helper_bootstrap scons-out/opt-linux-x86-32/staging/sel_ldr --r_debug=0xXXXXXXXXXXXXXXXX --reserved_at_zero=0xXXXXXXXXXXXXXXXX -a -B scons-out/nacl_irt-x86-32/staging/irt_core.nexe -- /b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/x86_64-nacl/lib32/runnable-ld.so --library-path scons-out/nacl-x86-32-glibc/lib:/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/x86_64-nacl/lib32 scons-out/nacl_irt_test-x86-32-glibc/obj/tests/benchmark/benchmark_test.nexe x86-32_with_irt_nnacl_glibc_dynamic DEBUG MODE ENABLED (bypass acl) [6132,4147918592:02:38:09.223371] BYPASSING ALL ACL CHECKS [6132,4147918592:02:38:09.223535] Native Client module will be loaded at base address 0x0000000000000000 Running suite of 1 benchmarks: Running Benchmark: Life (scalar version)... RESULT BenchmarkLife: x86-32_with_irt_nnacl_glibc_dynamic= {0.414426, 0.019052} seconds --------------------------------------------------------------- Done running benchmark suite. [ OK ] nacl_glibc.run_benchmark_test_irt (7010 ms) /b/s/w/ir/cache/vpython/b574a6/bin/python tools/command_tester.py --name nacl_glibc.run_clock_cputime_test_irt --time_warning 60 --time_error 600 --perf_env_description x86-32_with_irt_nnacl_glibc_dynamic --using_nacl_signal_handler True --subarch 32 --arch x86 --output_stamp /b/s/w/ir/k/native_client/scons-out/nacl_irt_test-x86-32-glibc/test_results/clock_cputime_test.out scons-out/opt-linux-x86-32/staging/nacl_helper_bootstrap scons-out/opt-linux-x86-32/staging/sel_ldr --r_debug=0xXXXXXXXXXXXXXXXX --reserved_at_zero=0xXXXXXXXXXXXXXXXX -a -B scons-out/nacl_irt-x86-32/staging/irt_core.nexe -- /b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/x86_64-nacl/lib32/runnable-ld.so --library-path scons-out/nacl-x86-32-glibc/lib:/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/x86_64-nacl/lib32 scons-out/nacl_irt_test-x86-32-glibc/obj/tests/clock/clock_test.nexe -c [ RUN ] nacl_glibc.run_clock_cputime_test_irt scons-out/opt-linux-x86-32/staging/nacl_helper_bootstrap scons-out/opt-linux-x86-32/staging/sel_ldr --r_debug=0xXXXXXXXXXXXXXXXX --reserved_at_zero=0xXXXXXXXXXXXXXXXX -a -B scons-out/nacl_irt-x86-32/staging/irt_core.nexe -- /b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/x86_64-nacl/lib32/runnable-ld.so --library-path scons-out/nacl-x86-32-glibc/lib:/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/x86_64-nacl/lib32 scons-out/nacl_irt_test-x86-32-glibc/obj/tests/clock/clock_test.nexe -c [ OK ] nacl_glibc.run_clock_cputime_test_irt (54870 ms) doSizeCheck(["scons-out/nacl_irt_test-x86-32-glibc/obj/tests/hello_world/hello_world_size.out"], ["scons-out/nacl_irt_test-x86-32-glibc/obj/tests/hello_world/hello_world.nexe"]) RESULT hello_world_size.out: x86-32_with_irt_nnacl_glibc_dynamic= 137.770 KB RESULT hello_world_size.out: ZIPPED_x86-32_with_irt_nnacl_glibc_dynamic= 5.066 KB /b/s/w/ir/cache/vpython/b574a6/bin/python tools/command_tester.py --name nacl_glibc.run_performance_test_irt --time_warning 10 --time_error 100 --perf_env_description x86-32_with_irt_nnacl_glibc_dynamic --using_nacl_signal_handler True --subarch 32 --arch x86 --capture_output 0 --output_stamp /b/s/w/ir/k/native_client/scons-out/nacl_irt_test-x86-32-glibc/test_results/performance_test.out scons-out/opt-linux-x86-32/staging/nacl_helper_bootstrap scons-out/opt-linux-x86-32/staging/sel_ldr --r_debug=0xXXXXXXXXXXXXXXXX --reserved_at_zero=0xXXXXXXXXXXXXXXXX -e -a -B scons-out/nacl_irt-x86-32/staging/irt_core.nexe -- /b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/x86_64-nacl/lib32/runnable-ld.so --library-path scons-out/nacl-x86-32-glibc/lib:/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/x86_64-nacl/lib32 scons-out/nacl_irt_test-x86-32-glibc/obj/tests/performance/performance_test.nexe x86-32_with_irt_nnacl_glibc_dynamic [ RUN ] nacl_glibc.run_performance_test_irt scons-out/opt-linux-x86-32/staging/nacl_helper_bootstrap scons-out/opt-linux-x86-32/staging/sel_ldr --r_debug=0xXXXXXXXXXXXXXXXX --reserved_at_zero=0xXXXXXXXXXXXXXXXX -e -a -B scons-out/nacl_irt-x86-32/staging/irt_core.nexe -- /b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/x86_64-nacl/lib32/runnable-ld.so --library-path scons-out/nacl-x86-32-glibc/lib:/b/s/w/ir/k/native_client/toolchain/linux_x86/nacl_x86_glibc_raw/x86_64-nacl/lib32 scons-out/nacl_irt_test-x86-32-glibc/obj/tests/performance/performance_test.nexe x86-32_with_irt_nnacl_glibc_dynamic DEBUG MODE ENABLED (bypass acl) [6162,4147463936:02:38:21.071686] BYPASSING ALL ACL CHECKS [6162,4147463936:02:38:21.071794] Native Client module will be loaded at base address 0x0000000000000000 TestNull: Measuring real time: 0.015 usec (1.47e-08 sec) per iteration: 1.47e-06 sec for 100 iterations 0.003 usec (2.728e-09 sec) per iteration: 2.728e-06 sec for 1000 iterations 0.002 usec (2.278e-09 sec) per iteration: 2.278e-05 sec for 10000 iterations 0.002 usec (2.29303e-09 sec) per iteration: 0.10066 sec for 43898156 iterations 0.002 usec (2.29312e-09 sec) per iteration: 0.100664 sec for 43898156 iterations 0.002 usec (2.29378e-09 sec) per iteration: 0.100693 sec for 43898156 iterations 0.002 usec (2.2778e-09 sec) per iteration: 0.0999913 sec for 43898156 iterations 0.002 usec (2.37773e-09 sec) per iteration: 0.104378 sec for 43898156 iterations mean: 0.002307 usec stddev: 0.000036 usec relative stddev: 1.55% RESULT TestNull: x86-32_with_irt_nnacl_glibc_dynamic= {0.002307, 0.000036} us Measuring clock cycles: first runs (cycles): 92 22 24 22 25 22 24 24 26 24 ... slowest runs (cycles): ... 25 25 25 25 26 26 26 27 27 92 min: 20 cycles q1: 22 cycles median: 24 cycles q3: 24 cycles max: 92 cycles RESULT TestNull_CycleCount: x86-32_with_irt_nnacl_glibc_dynamic= {24, 2} count Apparent clock speed: 10403 MHz TestNaClSyscall: Measuring real time: 0.247 usec (2.4689e-07 sec) per iteration: 2.4689e-05 sec for 100 iterations 0.248 usec (2.47638e-07 sec) per iteration: 0.100303 sec for 405038 iterations 0.248 usec (2.47788e-07 sec) per iteration: 0.100364 sec for 405038 iterations 0.243 usec (2.42849e-07 sec) per iteration: 0.098363 sec for 405038 iterations 0.243 usec (2.43057e-07 sec) per iteration: 0.0984473 sec for 405038 iterations 0.243 usec (2.42775e-07 sec) per iteration: 0.098333 sec for 405038 iterations mean: 0.244821 usec stddev: 0.002363 usec relative stddev: 0.97% RESULT TestNaClSyscall: x86-32_with_irt_nnacl_glibc_dynamic= {0.244821, 0.002363} us Measuring clock cycles: first runs (cycles): 625 543 535 530 530 533 532 530 533 530 ... slowest runs (cycles): ... 533 533 534 535 535 535 543 625 665 669 min: 528 cycles q1: 530 cycles median: 530 cycles q3: 532 cycles max: 669 cycles RESULT TestNaClSyscall_CycleCount: x86-32_with_irt_nnacl_glibc_dynamic= {530, 2} count Apparent clock speed: 2165 MHz TestSetjmpLongjmp: Measuring real time: 0.320 usec (3.2022e-07 sec) per iteration: 3.2022e-05 sec for 100 iterations 0.024 usec (2.42097e-08 sec) per iteration: 0.00756033 sec for 312285 iterations 0.024 usec (2.43984e-08 sec) per iteration: 0.00761925 sec for 312285 iterations 0.024 usec (2.43787e-08 sec) per iteration: 0.0076131 sec for 312285 iterations 0.024 usec (2.41796e-08 sec) per iteration: 0.00755092 sec for 312285 iterations 0.025 usec (2.46637e-08 sec) per iteration: 0.00770209 sec for 312285 iterations mean: 0.024366 usec stddev: 0.000173 usec relative stddev: 0.71% RESULT TestSetjmpLongjmp: x86-32_with_irt_nnacl_glibc_dynamic= {0.024366, 0.000173} us Measuring clock cycles: first runs (cycles): 251 101 64 64 57 57 55 57 57 55 ... slowest runs (cycles): ... 64 64 64 64 64 99 101 136 251 334 min: 52 cycles q1: 57 cycles median: 57 cycles q3: 59 cycles max: 334 cycles RESULT TestSetjmpLongjmp_CycleCount: x86-32_with_irt_nnacl_glibc_dynamic= {57, 2} count Apparent clock speed: 2339 MHz TestClockGetTime: Measuring real time: 0.468 usec (4.6832e-07 sec) per iteration: 4.6832e-05 sec for 100 iterations 0.472 usec (4.72488e-07 sec) per iteration: 0.10089 sec for 213529 iterations 0.481 usec (4.81339e-07 sec) per iteration: 0.10278 sec for 213529 iterations 0.475 usec (4.74871e-07 sec) per iteration: 0.101399 sec for 213529 iterations 0.472 usec (4.71706e-07 sec) per iteration: 0.100723 sec for 213529 iterations 0.471 usec (4.71368e-07 sec) per iteration: 0.100651 sec for 213529 iterations mean: 0.474354 usec stddev: 0.003700 usec relative stddev: 0.78% RESULT TestClockGetTime: x86-32_with_irt_nnacl_glibc_dynamic= {0.474354, 0.003700} us Measuring clock cycles: first runs (cycles): 1483 1193 1029 1025 1030 1029 1027 1142 1113 1030 ... slowest runs (cycles): ... 1038 1043 1062 1062 1062 1070 1113 1142 1193 1483 min: 1018 cycles q1: 1023 cycles median: 1025 cycles q3: 1029 cycles max: 1483 cycles RESULT TestClockGetTime_CycleCount: x86-32_with_irt_nnacl_glibc_dynamic= {1025, 6} count Apparent clock speed: 2161 MHz TestTlsVariable: Measuring real time: 0.008 usec (8.49e-09 sec) per iteration: 8.49e-07 sec for 100 iterations 0.003 usec (3.113e-09 sec) per iteration: 3.113e-06 sec for 1000 iterations 0.003 usec (2.6487e-09 sec) per iteration: 2.6487e-05 sec for 10000 iterations 0.003 usec (2.65106e-09 sec) per iteration: 0.100089 sec for 37754370 iterations 0.003 usec (2.65902e-09 sec) per iteration: 0.10039 sec for 37754370 iterations 0.003 usec (2.6675e-09 sec) per iteration: 0.10071 sec for 37754370 iterations 0.003 usec (2.66357e-09 sec) per iteration: 0.100561 sec for 37754370 iterations 0.003 usec (2.81713e-09 sec) per iteration: 0.106359 sec for 37754370 iterations mean: 0.002692 usec stddev: 0.000063 usec relative stddev: 2.34% RESULT TestTlsVariable: x86-32_with_irt_nnacl_glibc_dynamic= {0.002692, 0.000063} us Measuring clock cycles: first runs (cycles): 125 24 40 30 51 31 33 39 24 53 ... slowest runs (cycles): ... 31 31 31 33 33 39 40 51 53 125 min: 19 cycles q1: 22 cycles median: 24 cycles q3: 25 cycles max: 125 cycles RESULT TestTlsVariable_CycleCount: x86-32_with_irt_nnacl_glibc_dynamic= {24, 3} count Apparent clock speed: 8916 MHz TestMmapAnonymous: Measuring real time: 6.025 usec (6.02493e-06 sec) per iteration: 0.000602493 sec for 100 iterations 5.508 usec (5.50795e-06 sec) per iteration: 0.0914155 sec for 16597 iterations 5.491 usec (5.49141e-06 sec) per iteration: 0.091141 sec for 16597 iterations 5.253 usec (5.25339e-06 sec) per iteration: 0.0871904 sec for 16597 iterations 5.282 usec (5.28151e-06 sec) per iteration: 0.0876572 sec for 16597 iterations 5.453 usec (5.45294e-06 sec) per iteration: 0.0905025 sec for 16597 iterations mean: 5.397441 usec stddev: 0.107997 usec relative stddev: 2.00% RESULT TestMmapAnonymous: x86-32_with_irt_nnacl_glibc_dynamic= {5.397441, 0.107997} us Measuring clock cycles: first runs (cycles): 13401 11076 10893 10753 10718 10726 10823 10727 10748 10658 ... slowest runs (cycles): ... 10885 10893 10896 11072 11076 11402 13401 16094 21037 28884 min: 10594 cycles q1: 10715 cycles median: 10742 cycles q3: 10772 cycles max: 28884 cycles RESULT TestMmapAnonymous_CycleCount: x86-32_with_irt_nnacl_glibc_dynamic= {10742, 57} count Apparent clock speed: 1990 MHz TestAtomicIncrement: Measuring real time: 0.025 usec (2.525e-08 sec) per iteration: 2.525e-06 sec for 100 iterations 0.010 usec (9.798e-09 sec) per iteration: 9.798e-06 sec for 1000 iterations 0.009 usec (9.3326e-09 sec) per iteration: 9.3326e-05 sec for 10000 iterations 0.010 usec (9.50004e-09 sec) per iteration: 0.101794 sec for 10715127 iterations 0.009 usec (9.43618e-09 sec) per iteration: 0.10111 sec for 10715127 iterations 0.010 usec (9.69549e-09 sec) per iteration: 0.103888 sec for 10715127 iterations 0.009 usec (9.47108e-09 sec) per iteration: 0.101484 sec for 10715127 iterations 0.010 usec (9.54315e-09 sec) per iteration: 0.102256 sec for 10715127 iterations mean: 0.009529 usec stddev: 0.000090 usec relative stddev: 0.95% RESULT TestAtomicIncrement: x86-32_with_irt_nnacl_glibc_dynamic= {0.009529, 0.000090} us Measuring clock cycles: first runs (cycles): 116 60 53 55 57 58 53 53 53 53 ... slowest runs (cycles): ... 53 53 53 53 55 57 57 58 60 116 min: 50 cycles q1: 51 cycles median: 53 cycles q3: 53 cycles max: 116 cycles RESULT TestAtomicIncrement_CycleCount: x86-32_with_irt_nnacl_glibc_dynamic= {53, 2} count Apparent clock speed: 5562 MHz TestUncontendedMutexLock: Measuring real time: 0.067 usec (6.677e-08 sec) per iteration: 6.677e-06 sec for 100 iterations 0.028 usec (2.7572e-08 sec) per iteration: 2.7572e-05 sec for 1000 iterations 0.028 usec (2.80734e-08 sec) per iteration: 0.101819 sec for 3626867 iterations 0.028 usec (2.80329e-08 sec) per iteration: 0.101672 sec for 3626867 iterations 0.029 usec (2.87859e-08 sec) per iteration: 0.104403 sec for 3626867 iterations 0.028 usec (2.78839e-08 sec) per iteration: 0.101131 sec for 3626867 iterations 0.029 usec (2.85876e-08 sec) per iteration: 0.103683 sec for 3626867 iterations mean: 0.028273 usec stddev: 0.000350 usec relative stddev: 1.24% RESULT TestUncontendedMutexLock: x86-32_with_irt_nnacl_glibc_dynamic= {0.028273, 0.000350} us Measuring clock cycles: first runs (cycles): 213 92 92 90 90 99 90 90 90 90 ... slowest runs (cycles): ... 94 94 95 95 95 95 96 97 99 213 min: 88 cycles q1: 90 cycles median: 90 cycles q3: 90 cycles max: 213 cycles RESULT TestUncontendedMutexLock_CycleCount: x86-32_with_irt_nnacl_glibc_dynamic= {90, 0} count Apparent clock speed: 3183 MHz TestCondvarSignalNoOp: Measuring real time: 0.047 usec (4.719e-08 sec) per iteration: 4.719e-06 sec for 100 iterations 0.022 usec (2.2089e-08 sec) per iteration: 2.2089e-05 sec for 1000 iterations 0.022 usec (2.23327e-08 sec) per iteration: 0.101103 sec for 4527140 iterations 0.022 usec (2.2105e-08 sec) per iteration: 0.100073 sec for 4527140 iterations 0.022 usec (2.20768e-08 sec) per iteration: 0.0999447 sec for 4527140 iterations 0.023 usec (2.26031e-08 sec) per iteration: 0.102327 sec for 4527140 iterations 0.023 usec (2.30328e-08 sec) per iteration: 0.104273 sec for 4527140 iterations mean: 0.022430 usec stddev: 0.000356 usec relative stddev: 1.59% RESULT TestCondvarSignalNoOp: x86-32_with_irt_nnacl_glibc_dynamic= {0.022430, 0.000356} us Measuring clock cycles: first runs (cycles): 642 93 80 77 81 81 79 77 77 83 ... slowest runs (cycles): ... 86 86 86 86 86 93 416 440 448 642 min: 77 cycles q1: 77 cycles median: 79 cycles q3: 81 cycles max: 642 cycles RESULT TestCondvarSignalNoOp_CycleCount: x86-32_with_irt_nnacl_glibc_dynamic= {79, 4} count Apparent clock speed: 3522 MHz TestThreadCreateAndJoin: Measuring real time: 124.997 usec (0.000124997 sec) per iteration: 0.0124997 sec for 100 iterations 131.529 usec (0.000131529 sec) per iteration: 0.105223 sec for 800 iterations 120.501 usec (0.000120501 sec) per iteration: 0.0964011 sec for 800 iterations 115.585 usec (0.000115585 sec) per iteration: 0.092468 sec for 800 iterations 109.383 usec (0.000109383 sec) per iteration: 0.0875068 sec for 800 iterations 125.933 usec (0.000125933 sec) per iteration: 0.100746 sec for 800 iterations mean: 120.586373 usec stddev: 7.731176 usec relative stddev: 6.41% RESULT TestThreadCreateAndJoin: x86-32_with_irt_nnacl_glibc_dynamic= {120.586373, 7.731176} us Measuring clock cycles: first runs (cycles): 137440 219006 242235 239892 200353 202485 282029 174246 219964 177752 ... slowest runs (cycles): ... 243399 247167 257076 260701 260831 282029 337101 380636 429662 765015 min: 137440 cycles q1: 174246 cycles median: 183337 cycles q3: 204852 cycles max: 765015 cycles RESULT TestThreadCreateAndJoin_CycleCount: x86-32_with_irt_nnacl_glibc_dynamic= {183337, 30606} count Apparent clock speed: 1520 MHz TestThreadWakeup: Measuring real time: 21.480 usec (2.14798e-05 sec) per iteration: 0.00214798 sec for 100 iterations 21.193 usec (2.11926e-05 sec) per iteration: 0.0986514 sec for 4655 iterations 21.313 usec (2.13126e-05 sec) per iteration: 0.09921 sec for 4655 iterations 20.647 usec (2.06466e-05 sec) per iteration: 0.0961097 sec for 4655 iterations 21.021 usec (2.10215e-05 sec) per iteration: 0.0978549 sec for 4655 iterations 20.654 usec (2.06539e-05 sec) per iteration: 0.0961438 sec for 4655 iterations mean: 20.965403 usec stddev: 0.273492 usec relative stddev: 1.30% RESULT TestThreadWakeup: x86-32_with_irt_nnacl_glibc_dynamic= {20.965403, 0.273492} us Measuring clock cycles: first runs (cycles): 49740 44762 71591 34968 49558 43884 48130 45365 46814 45618 ... slowest runs (cycles): ... 51826 51891 52268 52470 57952 59019 66676 71591 77911 95129 min: 34561 cycles q1: 45134 cycles median: 46161 cycles q3: 49558 cycles max: 95129 cycles RESULT TestThreadWakeup_CycleCount: x86-32_with_irt_nnacl_glibc_dynamic= {46161, 4424} count Apparent clock speed: 2202 MHz TestCatchingFault: Measuring real time: 4.033 usec (4.03341e-06 sec) per iteration: 0.000403341 sec for 100 iterations 2.341 usec (2.3415e-06 sec) per iteration: 0.0580504 sec for 24792 iterations 2.332 usec (2.33199e-06 sec) per iteration: 0.0578148 sec for 24792 iterations 2.328 usec (2.32821e-06 sec) per iteration: 0.057721 sec for 24792 iterations 2.492 usec (2.49197e-06 sec) per iteration: 0.061781 sec for 24792 iterations 2.323 usec (2.32282e-06 sec) per iteration: 0.0575874 sec for 24792 iterations mean: 2.363300 usec stddev: 0.064625 usec relative stddev: 2.73% RESULT TestCatchingFault: x86-32_with_irt_nnacl_glibc_dynamic= {2.363300, 0.064625} us Measuring clock cycles: first runs (cycles): 7257 5251 5053 5000 5040 5015 5007 5015 5044 15436 ... slowest runs (cycles): ... 5722 5724 5733 5788 5808 5867 6141 7257 15436 29867 min: 4973 cycles q1: 4998 cycles median: 5015 cycles q3: 5403 cycles max: 29867 cycles RESULT TestCatchingFault_CycleCount: x86-32_with_irt_nnacl_glibc_dynamic= {5015, 405} count Apparent clock speed: 2122 MHz TestThreadCreateAndJoinAfterSettingFaultHandler: Measuring real time: 98.254 usec (9.82541e-05 sec) per iteration: 0.00982541 sec for 100 iterations 116.293 usec (0.000116293 sec) per iteration: 0.11827 sec for 1017 iterations 116.497 usec (0.000116497 sec) per iteration: 0.118478 sec for 1017 iterations 104.270 usec (0.00010427 sec) per iteration: 0.106042 sec for 1017 iterations 97.914 usec (9.79136e-05 sec) per iteration: 0.0995781 sec for 1017 iterations 104.342 usec (0.000104342 sec) per iteration: 0.106116 sec for 1017 iterations mean: 107.863169 usec stddev: 7.347375 usec relative stddev: 6.81% RESULT TestThreadCreateAndJoinAfterSettingFaultHandler: x86-32_with_irt_nnacl_glibc_dynamic= {107.863169, 7.347375} us Measuring clock cycles: first runs (cycles): 141902 208336 171879 178111 168165 203333 261407 190333 205100 179844 ... slowest runs (cycles): ... 335532 336546 338383 345605 349529 378301 423705 444033 577677 677670 min: 137143 cycles q1: 186531 cycles median: 205100 cycles q3: 264805 cycles max: 677670 cycles RESULT TestThreadCreateAndJoinAfterSettingFaultHandler_CycleCount: x86-32_with_irt_nnacl_glibc_dynamic= {205100, 78274} count Apparent clock speed: 1901 MHz [ OK ] nacl_glibc.run_performance_test_irt (5860 ms) scons: done building targets. ********************************************************************** COMMAND EXECUTION REPORT ********************************************************************** 3 command_tester.py 1 doSizeCheck 2 set 6 x86_64-nacl-gcc ********************************************************************** ENVIRONMENT USAGE REPORT ********************************************************************** 4 nacl-x86-32-glibc 8 nacl_irt_test-x86-32-glibc Command return code: 0