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

Running command: /usr/bin/python scons.py --verbose -k -j1 --mode=nacl,opt-host platform=arm bitcode=1 use_sz=1 large_tests scons: Reading SConscript files ... ====================================================================== SCONS ARGS:['scons.py', '--verbose', '-k', '-j1', '--mode=nacl,opt-host', 'platform=arm', 'bitcode=1', 'use_sz=1', 'large_tests'] ====================================================================== ====================================================================== Python Info: ====================================================================== linux2 2.7.6 (default, Nov 13 2018, 12:45:42) [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 gce-trusty-16-145e5bab-us-west1-c-d756 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 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: 61847552 kB MemFree: 44498004 kB MemAvailable: 59321360 kB ====================================================================== LOAD: ====================================================================== 1.88 2.01 2.46 1/586 17381 ====================================================================== UPTIME: ====================================================================== 18681.94 278382.27 ====================================================================== 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-arm-pnacl-subzero-pexe-clang OBJ_ROOT: /b/s/w/ir/k/native_client/scons-out/nacl-arm-pnacl-subzero-pexe-clang/obj BUILD_TYPE_DESCRIPTION: NaCl module build BUILD_OS: BUILD_ARCHITECTURE: arm BUILD_SUBARCH: 32 TARGET_OS: TARGET_ARCHITECTURE: arm TARGET_SUBARCH: 32 CC: /b/s/w/ir/k/native_client/toolchain/linux_x86/pnacl_newlib_raw/bin/pnacl-clang -std=gnu99 ASPPCOM: /b/s/w/ir/k/native_client/toolchain/linux_x86/pnacl_newlib_raw/bin/pnacl-clang -std=gnu99 -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=arm -DNACL_BUILD_SUBARCH=32 -I/b/s/w/ir/k/native_client/scons-out/nacl-arm-pnacl-subzero-pexe-clang/include -I/b/s/w/ir/k -c -o UNKNOWN COMPILER NACL_BUILD_FAMILY: TRUSTED BUILD_TYPE: opt-linux TARGET_ROOT: /b/s/w/ir/k/native_client/scons-out/opt-linux-arm OBJ_ROOT: /b/s/w/ir/k/native_client/scons-out/opt-linux-arm/obj BUILD_TYPE_DESCRIPTION: Linux opt build BUILD_OS: BUILD_ARCHITECTURE: arm BUILD_SUBARCH: 32 TARGET_OS: TARGET_ARCHITECTURE: arm TARGET_SUBARCH: 32 CC: arm-linux-gnueabihf-gcc ASPPCOM: arm-linux-gnueabihf-gcc -fPIC -march=armv7-a -Wall -pedantic -Wextra -Wno-long-long -Wswitch-enum -Wsign-compare -Wundef -fdiagnostics-show-option -fvisibility=hidden -fstack-protector -Werror -Wno-variadic-macros --param ssp-buffer-size=4 -O2 -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 set BOTO_CONFIG='/home/chrome-bot/.boto' BUILDBOT_BUILDERNAME='linux-pnacl-x86_64' BUILDBOT_BUILDNUMBER='7030' BUILDBOT_GOT_REVISION='7d24fb15d81f95ed30dde0c04b68584749709657' BUILDBOT_MASTERNAME='client.nacl.toolchain' BUILDBOT_REVISION='7d24fb15d81f95ed30dde0c04b68584749709657' BUILDBOT_SLAVE_TYPE='BuilderTester' BUILDBUCKET_EXPERIMENTAL='FALSE' CIPD_CACHE_DIR='/b/s/cipd_cache/cache' CIPD_PROTOCOL='v2' CYGWIN='nodosfilewarning' DEVSHELL_CLIENT_PORT='44518' 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' HOST_ARCH='x86_64' 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/8918612060171329952' LOGDOG_STREAM_PROJECT='nacl' LOGDOG_STREAM_SERVER_PATH='unix:/b/s/w/ir/tmp/ld.sock' LOGNAME='chrome-bot' LUCI_CONTEXT='/b/s/w/it0lV5Lt/luci_context.791121765' MAC_CHROMIUM_TMPDIR='/b/s/w/ir/tmp/t' MAIL='/var/mail/chrome-bot' NATIVE_PYTHON='python' NOCONTROL_GOMA='1' NO_GCE_CHECK='False' OLDPWD='/b/s/w/ir/k/native_client' OPTIND='1' 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' PNACL_BUILDBOT='true' PNACL_TOOLCHAIN_DIR='linux_x86/pnacl_newlib' PNACL_VERBOSE='true' PPID='17355' 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='2' SUDO_COMMAND='/usr/bin/python /b/s/swarming_bot.zip start_bot' SUDO_GID='0' SUDO_UID='0' SUDO_USER='root' SWARMING_BOT_ID='gce-trusty-16-145e5bab-us-west1-c-d756' SWARMING_EXTERNAL_BOT_SETUP='1' SWARMING_HEADLESS='1' SWARMING_SERVER='https://chromium-swarm.appspot.com' SWARMING_TASK_ID='43ab995b70551d11' TEMP='/b/s/w/ir/tmp/t/nacl_tmp/linux-pnacl-x86_64' TEMPDIR='/b/s/w/ir/tmp/t' TERM='linux' TMP='/b/s/w/ir/tmp/t/nacl_tmp/linux-pnacl-x86_64' TMPDIR='/b/s/w/ir/tmp/t/nacl_tmp/linux-pnacl-x86_64' USER='chrome-bot' USERNAME='chrome-bot' VIRTUAL_ENV='/b/s/w/ir/cache/vpython/b574a6' VPYTHON_VIRTUALENV_ROOT='/b/s/w/ir/cache/vpython' _='buildbot/buildbot_pnacl.py' arm-linux-gnueabihf-gcc -v -c Using built-in specs. COLLECT_GCC=arm-linux-gnueabihf-gcc Target: arm-linux-gnueabihf Configured with: ../src/configure -v --with-pkgversion='Ubuntu/Linaro 4.8.4-2ubuntu1~14.04.1' --with-bugurl=file:///usr/share/doc/gcc-4.8/README.Bugs --enable-languages=c,c++,java,go,d,fortran,objc,obj-c++ --prefix=/usr --program-suffix=-4.8 --enable-shared --enable-linker-build-id --libexecdir=/usr/lib --without-included-gettext --enable-threads=posix --with-gxx-include-dir=/usr/arm-linux-gnueabihf/include/c++/4.8.4 --libdir=/usr/lib --enable-nls --with-sysroot=/ --enable-clocale=gnu --enable-libstdcxx-debug --enable-libstdcxx-time=yes --enable-gnu-unique-object --disable-libmudflap --disable-libitm --disable-libquadmath --enable-plugin --with-system-zlib --disable-browser-plugin --enable-java-awt=gtk --enable-gtk-cairo --with-java-home=/usr/lib/jvm/java-1.5.0-gcj-4.8-armhf-cross/jre --enable-java-home --with-jvm-root-dir=/usr/lib/jvm/java-1.5.0-gcj-4.8-armhf-cross --with-jvm-jar-dir=/usr/lib/jvm-exports/java-1.5.0-gcj-4.8-armhf-cross --with-arch-directory=arm --with-ecj-jar=/usr/share/java/eclipse-ecj.jar --disable-libgcj --enable-objc-gc --enable-multiarch --enable-multilib --disable-sjlj-exceptions --with-arch=armv7-a --with-fpu=vfpv3-d16 --with-float=hard --with-mode=thumb --disable-werror --enable-checking=release --build=x86_64-linux-gnu --host=x86_64-linux-gnu --target=arm-linux-gnueabihf --program-prefix=arm-linux-gnueabihf- --includedir=/usr/arm-linux-gnueabihf/include Thread model: posix gcc version 4.8.4 (Ubuntu/Linaro 4.8.4-2ubuntu1~14.04.1) arm-linux-gnueabihf-gcc -print-search-dirs install: /usr/lib/gcc-cross/arm-linux-gnueabihf/4.8/ programs: =/usr/lib/gcc-cross/arm-linux-gnueabihf/4.8/:/usr/lib/gcc-cross/arm-linux-gnueabihf/4.8/:/usr/lib/gcc-cross/arm-linux-gnueabihf/:/usr/lib/gcc-cross/arm-linux-gnueabihf/4.8/:/usr/lib/gcc-cross/arm-linux-gnueabihf/:/usr/lib/gcc-cross/arm-linux-gnueabihf/4.8/../../../../arm-linux-gnueabihf/bin/arm-linux-gnueabihf/4.8/:/usr/lib/gcc-cross/arm-linux-gnueabihf/4.8/../../../../arm-linux-gnueabihf/bin/arm-linux-gnueabihf/:/usr/lib/gcc-cross/arm-linux-gnueabihf/4.8/../../../../arm-linux-gnueabihf/bin/ libraries: =/usr/lib/gcc-cross/arm-linux-gnueabihf/4.8/:/usr/lib/gcc-cross/arm-linux-gnueabihf/4.8/../../../../arm-linux-gnueabihf/lib/arm-linux-gnueabihf/4.8/:/usr/lib/gcc-cross/arm-linux-gnueabihf/4.8/../../../../arm-linux-gnueabihf/lib/arm-linux-gnueabihf/:/usr/lib/gcc-cross/arm-linux-gnueabihf/4.8/../../../../arm-linux-gnueabihf/lib/../lib/:/lib/arm-linux-gnueabihf/4.8/:/lib/arm-linux-gnueabihf/:/lib/../lib/:/usr/lib/arm-linux-gnueabihf/4.8/:/usr/lib/arm-linux-gnueabihf/:/usr/lib/../lib/:/usr/lib/gcc-cross/arm-linux-gnueabihf/4.8/../../../../arm-linux-gnueabihf/lib/:/lib/:/usr/lib/ arm-linux-gnueabihf-gcc -print-libgcc-file-name /usr/lib/gcc-cross/arm-linux-gnueabihf/4.8/libgcc.a NACL_BUILD_FAMILY: UNTRUSTED_IRT BUILD_TYPE: nacl_irt TARGET_ROOT: /b/s/w/ir/k/native_client/scons-out/nacl_irt-arm OBJ_ROOT: /b/s/w/ir/k/native_client/scons-out/nacl_irt-arm/obj BUILD_TYPE_DESCRIPTION: NaCl IRT build BUILD_OS: BUILD_ARCHITECTURE: arm BUILD_SUBARCH: 32 TARGET_OS: TARGET_ARCHITECTURE: arm TARGET_SUBARCH: 32 CC: /b/s/w/ir/k/native_client/toolchain/linux_x86/pnacl_newlib_raw/bin/arm-nacl-clang ASPPCOM: /b/s/w/ir/k/native_client/toolchain/linux_x86/pnacl_newlib_raw/bin/arm-nacl-clang -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=arm -DNACL_BUILD_SUBARCH=32 -I/b/s/w/ir/k/native_client/scons-out/nacl_irt-arm/include -I/b/s/w/ir/k -I/b/s/w/ir/k/native_client/src/untrusted/pthread -c -o UNKNOWN COMPILER *** BROKEN run_multidomain_test *** BROKEN run_benchmark_test *** SKIPPING opt-linux-32 : run_egyptian_cotton_test *** BROKEN run_gdb_stepi_after_break_test *** BROKEN run_gdb_print_symbol_test *** BROKEN run_gdb_stack_trace_test *** BROKEN run_gdb_step_from_func_start_test *** BROKEN run_gdb_change_variable_test *** BROKEN run_gdb_break_continue_thread_test *** BROKEN run_nanosleep_test *** BROKEN run_nullptr_test *** BROKEN run_performance_test *** BROKEN run_pnacl_dynamic_loading_test *** BROKEN run_pll_symbols_test *** BROKEN run_pll_loader_test *** BROKEN run_pll_hello_world_test *** BROKEN run_pll_dependencies_test *** BROKEN run_timefuncs_test *** BROKEN run_raw_timefuncs_test *** BROKEN run_main_thread_pthread_exit_test2 *** SKIPPING opt-linux-32 : run_many_threads_sequential_test *** BROKEN run_overflowinline_test *** BROKEN run_initfini_static_test *** BROKEN run_sigpipe_test *** BROKEN run_nacl_clock_cputime_test *** BROKEN run_nacl_host_desc_big_file_test *** BROKEN run_nacl_sync_cond_test There are 25 broken tests. ====================================================================== B U I L D - O U T P U T: ====================================================================== scons: done reading SConscript files. scons: Building targets ... /usr/bin/python tools/command_tester.py --name pnacl_newlib.run_clock_cputime_test --time_warning 60 --time_error 600 --perf_env_description arm_pnacl_sz_newlib_static --using_nacl_signal_handler True --subarch 32 --arch arm --output_stamp /b/s/w/ir/k/native_client/scons-out/nacl-arm-pnacl-subzero-pexe-clang/test_results/clock_cputime_test.out /b/s/w/ir/k/native_client/toolchain/linux_x86/arm_trusted/run_under_qemu_arm scons-out/opt-linux-arm/staging/nacl_helper_bootstrap scons-out/opt-linux-arm/staging/sel_ldr --r_debug=0xXXXXXXXXXXXXXXXX --reserved_at_zero=0xXXXXXXXXXXXXXXXX -Q -- scons-out/nacl-arm-pnacl-subzero-pexe-clang/obj/tests/clock/clock_test.nexe -c [ RUN ] pnacl_newlib.run_clock_cputime_test /b/s/w/ir/k/native_client/toolchain/linux_x86/arm_trusted/run_under_qemu_arm scons-out/opt-linux-arm/staging/nacl_helper_bootstrap scons-out/opt-linux-arm/staging/sel_ldr --r_debug=0xXXXXXXXXXXXXXXXX --reserved_at_zero=0xXXXXXXXXXXXXXXXX -Q -- scons-out/nacl-arm-pnacl-subzero-pexe-clang/obj/tests/clock/clock_test.nexe -c [ OK ] pnacl_newlib.run_clock_cputime_test (14580 ms) doSizeCheck(["scons-out/nacl-arm-pnacl-subzero-pexe-clang/obj/tests/hello_world/hello_world_size.out"], ["scons-out/nacl-arm-pnacl-subzero-pexe-clang/obj/tests/hello_world/hello_world.nonfinal.pexe"]) RESULT hello_world_size.out: arm_pnacl_sz_newlib_static= 353.012 KB RESULT hello_world_size.out: ZIPPED_arm_pnacl_sz_newlib_static= 232.174 KB /usr/bin/python /b/s/w/ir/k/native_client/tools/command_tester.py --name pnacl_newlib.run_nacl_interval_multi_reg_test --time_warning 60 --time_error 600 --perf_env_description trusted_linux_arm --subarch 32 --arch arm --output_stamp /b/s/w/ir/k/native_client/scons-out/opt-linux-arm/test_results/nacl_interval_multi_reg_test.out /b/s/w/ir/k/native_client/toolchain/linux_x86/arm_trusted/run_under_qemu_arm /b/s/w/ir/k/native_client/scons-out/opt-linux-arm/obj/src/trusted/interval_multiset/nacl_interval_test -k NaClIntervalListMultiset -k NaClIntervalRangeTree -c 1000000 [ RUN ] pnacl_newlib.run_nacl_interval_multi_reg_test /b/s/w/ir/k/native_client/toolchain/linux_x86/arm_trusted/run_under_qemu_arm /b/s/w/ir/k/native_client/scons-out/opt-linux-arm/obj/src/trusted/interval_multiset/nacl_interval_test -k NaClIntervalListMultiset -k NaClIntervalRangeTree -c 1000000 [ OK ] pnacl_newlib.run_nacl_interval_multi_reg_test (7140 ms) /usr/bin/python /b/s/w/ir/k/native_client/tools/command_tester.py --name pnacl_newlib.run_trusted_performance_test --time_warning 2 --time_error 20 --perf_env_description trusted_linux_arm --subarch 32 --arch arm --capture_output 0 --output_stamp /b/s/w/ir/k/native_client/scons-out/opt-linux-arm/test_results/performance_test.out /b/s/w/ir/k/native_client/toolchain/linux_x86/arm_trusted/run_under_qemu_arm /b/s/w/ir/k/native_client/scons-out/opt-linux-arm/obj/tests/performance/performance_test trusted_linux_arm [ RUN ] pnacl_newlib.run_trusted_performance_test /b/s/w/ir/k/native_client/toolchain/linux_x86/arm_trusted/run_under_qemu_arm /b/s/w/ir/k/native_client/scons-out/opt-linux-arm/obj/tests/performance/performance_test trusted_linux_arm TestNull: Measuring real time: 0.521 usec (5.2058e-07 sec) per iteration: 5.2058e-05 sec for 100 iterations 0.085 usec (8.45843e-08 sec) per iteration: 0.016248 sec for 192093 iterations 0.084 usec (8.40717e-08 sec) per iteration: 0.0161496 sec for 192093 iterations 0.084 usec (8.44905e-08 sec) per iteration: 0.01623 sec for 192093 iterations 0.084 usec (8.40251e-08 sec) per iteration: 0.0161406 sec for 192093 iterations 0.085 usec (8.51652e-08 sec) per iteration: 0.0163596 sec for 192093 iterations mean: 0.084467 usec stddev: 0.000413 usec relative stddev: 0.49% RESULT TestNull: trusted_linux_arm= {0.084467, 0.000413} us TestHostSyscall: Measuring real time: 0.821 usec (8.2117e-07 sec) per iteration: 8.2117e-05 sec for 100 iterations 0.408 usec (4.08249e-07 sec) per iteration: 0.0497153 sec for 121777 iterations 0.420 usec (4.1978e-07 sec) per iteration: 0.0511195 sec for 121777 iterations 0.417 usec (4.17418e-07 sec) per iteration: 0.050832 sec for 121777 iterations 0.410 usec (4.09562e-07 sec) per iteration: 0.0498752 sec for 121777 iterations 0.409 usec (4.0869e-07 sec) per iteration: 0.0497691 sec for 121777 iterations mean: 0.412740 usec stddev: 0.004860 usec relative stddev: 1.18% RESULT TestHostSyscall: trusted_linux_arm= {0.412740, 0.004860} us TestSetjmpLongjmp: Measuring real time: 2.129 usec (2.12925e-06 sec) per iteration: 0.000212925 sec for 100 iterations 0.753 usec (7.52735e-07 sec) per iteration: 0.0353515 sec for 46964 iterations 0.753 usec (7.52997e-07 sec) per iteration: 0.0353638 sec for 46964 iterations 0.753 usec (7.53015e-07 sec) per iteration: 0.0353646 sec for 46964 iterations 0.753 usec (7.53116e-07 sec) per iteration: 0.0353694 sec for 46964 iterations 0.752 usec (7.51981e-07 sec) per iteration: 0.035316 sec for 46964 iterations mean: 0.752769 usec stddev: 0.000414 usec relative stddev: 0.05% RESULT TestSetjmpLongjmp: trusted_linux_arm= {0.752769, 0.000414} us TestClockGetTime: Measuring real time: 0.848 usec (8.483e-07 sec) per iteration: 8.483e-05 sec for 100 iterations 0.748 usec (7.47777e-07 sec) per iteration: 0.0881495 sec for 117882 iterations 0.712 usec (7.11664e-07 sec) per iteration: 0.0838924 sec for 117882 iterations 0.719 usec (7.1895e-07 sec) per iteration: 0.0847513 sec for 117882 iterations 0.713 usec (7.12743e-07 sec) per iteration: 0.0840195 sec for 117882 iterations 0.726 usec (7.26347e-07 sec) per iteration: 0.0856233 sec for 117882 iterations mean: 0.723496 usec stddev: 0.013221 usec relative stddev: 1.83% RESULT TestClockGetTime: trusted_linux_arm= {0.723496, 0.013221} us TestTlsVariable: Measuring real time: 0.942 usec (9.419e-07 sec) per iteration: 9.419e-05 sec for 100 iterations 0.265 usec (2.65148e-07 sec) per iteration: 0.0281502 sec for 106168 iterations 0.268 usec (2.68303e-07 sec) per iteration: 0.0284852 sec for 106168 iterations 0.266 usec (2.6559e-07 sec) per iteration: 0.0281972 sec for 106168 iterations 0.266 usec (2.65613e-07 sec) per iteration: 0.0281996 sec for 106168 iterations 0.266 usec (2.66026e-07 sec) per iteration: 0.0282435 sec for 106168 iterations mean: 0.266136 usec stddev: 0.001118 usec relative stddev: 0.42% RESULT TestTlsVariable: trusted_linux_arm= {0.266136, 0.001118} us TestMmapAnonymous: Measuring real time: 4.197 usec (4.1975e-06 sec) per iteration: 0.00041975 sec for 100 iterations 3.193 usec (3.19274e-06 sec) per iteration: 0.0760605 sec for 23823 iterations 3.266 usec (3.26633e-06 sec) per iteration: 0.0778137 sec for 23823 iterations 3.276 usec (3.27595e-06 sec) per iteration: 0.0780428 sec for 23823 iterations 3.330 usec (3.32963e-06 sec) per iteration: 0.0793219 sec for 23823 iterations 3.273 usec (3.27342e-06 sec) per iteration: 0.0779826 sec for 23823 iterations mean: 3.267611 usec stddev: 0.043722 usec relative stddev: 1.34% RESULT TestMmapAnonymous: trusted_linux_arm= {3.267611, 0.043722} us TestAtomicIncrement: Measuring real time: 0.596 usec (5.9555e-07 sec) per iteration: 5.9555e-05 sec for 100 iterations 0.338 usec (3.38371e-07 sec) per iteration: 0.0568166 sec for 167912 iterations 0.338 usec (3.38061e-07 sec) per iteration: 0.0567645 sec for 167912 iterations 0.341 usec (3.40984e-07 sec) per iteration: 0.0572554 sec for 167912 iterations 0.340 usec (3.40209e-07 sec) per iteration: 0.0571252 sec for 167912 iterations 0.341 usec (3.40593e-07 sec) per iteration: 0.0571896 sec for 167912 iterations mean: 0.339644 usec stddev: 0.001195 usec relative stddev: 0.35% RESULT TestAtomicIncrement: trusted_linux_arm= {0.339644, 0.001195} us TestUncontendedMutexLock: Measuring real time: 1.459 usec (1.45926e-06 sec) per iteration: 0.000145926 sec for 100 iterations 0.914 usec (9.14037e-07 sec) per iteration: 0.0626362 sec for 68527 iterations 0.901 usec (9.01405e-07 sec) per iteration: 0.0617706 sec for 68527 iterations 0.901 usec (9.00606e-07 sec) per iteration: 0.0617158 sec for 68527 iterations 0.901 usec (9.01406e-07 sec) per iteration: 0.0617707 sec for 68527 iterations 0.901 usec (9.01417e-07 sec) per iteration: 0.0617714 sec for 68527 iterations mean: 0.903774 usec stddev: 0.005141 usec relative stddev: 0.57% RESULT TestUncontendedMutexLock: trusted_linux_arm= {0.903774, 0.005141} us TestCondvarSignalNoOp: Measuring real time: 1.876 usec (1.87566e-06 sec) per iteration: 0.000187566 sec for 100 iterations 0.757 usec (7.56949e-07 sec) per iteration: 0.040356 sec for 53314 iterations 0.745 usec (7.45203e-07 sec) per iteration: 0.0397297 sec for 53314 iterations 0.746 usec (7.46467e-07 sec) per iteration: 0.0397971 sec for 53314 iterations 0.750 usec (7.50032e-07 sec) per iteration: 0.0399872 sec for 53314 iterations 0.747 usec (7.4742e-07 sec) per iteration: 0.0398479 sec for 53314 iterations mean: 0.749214 usec stddev: 0.004180 usec relative stddev: 0.56% RESULT TestCondvarSignalNoOp: trusted_linux_arm= {0.749214, 0.004180} us TestThreadCreateAndJoin: Measuring real time: 3032.010 usec (0.00303201 sec) per iteration: 0.303201 sec for 100 iterations 3043.843 usec (0.00304384 sec) per iteration: 0.097403 sec for 32 iterations 3142.074 usec (0.00314207 sec) per iteration: 0.100546 sec for 32 iterations 2943.345 usec (0.00294335 sec) per iteration: 0.094187 sec for 32 iterations 3047.145 usec (0.00304714 sec) per iteration: 0.0975086 sec for 32 iterations 2990.180 usec (0.00299018 sec) per iteration: 0.0956858 sec for 32 iterations mean: 3033.317338 usec stddev: 66.461632 usec relative stddev: 2.19% RESULT TestThreadCreateAndJoin: trusted_linux_arm= {3033.317338, 66.461632} us TestThreadWakeup: Measuring real time: 38.214 usec (3.82144e-05 sec) per iteration: 0.00382144 sec for 100 iterations 29.678 usec (2.9678e-05 sec) per iteration: 0.0776376 sec for 2616 iterations 29.287 usec (2.92873e-05 sec) per iteration: 0.0766156 sec for 2616 iterations 27.223 usec (2.72232e-05 sec) per iteration: 0.071216 sec for 2616 iterations 24.057 usec (2.40573e-05 sec) per iteration: 0.0629339 sec for 2616 iterations 24.447 usec (2.44469e-05 sec) per iteration: 0.063953 sec for 2616 iterations mean: 26.938541 usec stddev: 2.350000 usec relative stddev: 8.72% RESULT TestThreadWakeup: trusted_linux_arm= {26.938541, 2.350000} us WARNING: should have taken less than 2.000000 secs [ OK ] pnacl_newlib.run_trusted_performance_test (3600 ms) scons: done building targets. ********************************************************************** COMMAND EXECUTION REPORT ********************************************************************** 3 arm-linux-gnueabihf-gcc 3 command_tester.py 1 doSizeCheck 1 set ********************************************************************** ENVIRONMENT USAGE REPORT ********************************************************************** 2 nacl-arm-pnacl-subzero-pexe-clang 6 opt-linux-arm Command return code: 0