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: 47078072 kB MemAvailable: 59930564 kB ====================================================================== LOAD: ====================================================================== 2.25 3.20 2.89 1/560 3472 ====================================================================== UPTIME: ====================================================================== 5145.13 67811.60 ====================================================================== 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='7033' BUILDBOT_GOT_REVISION='067afa275dcb4b3c6eca979ea5e3fe75073c4080' BUILDBOT_MASTERNAME='client.nacl.toolchain' BUILDBOT_REVISION='067afa275dcb4b3c6eca979ea5e3fe75073c4080' BUILDBOT_SLAVE_TYPE='BuilderTester' BUILDBUCKET_EXPERIMENTAL='FALSE' CIPD_CACHE_DIR='/b/s/cipd_cache/cache' CIPD_PROTOCOL='v2' CYGWIN='nodosfilewarning' DEVSHELL_CLIENT_PORT='41073' 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/8916917450172911808' LOGDOG_STREAM_PROJECT='nacl' LOGDOG_STREAM_SERVER_PATH='unix:/b/s/w/ir/tmp/ld.sock' LOGNAME='chrome-bot' LUCI_CONTEXT='/b/s/w/itauT5hi/luci_context.829147174' 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='3446' 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='440bed322540c511' 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 (15370 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 (7010 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.533 usec (5.3259e-07 sec) per iteration: 5.3259e-05 sec for 100 iterations 0.081 usec (8.12325e-08 sec) per iteration: 0.0152523 sec for 187761 iterations 0.081 usec (8.10815e-08 sec) per iteration: 0.0152239 sec for 187761 iterations 0.082 usec (8.1606e-08 sec) per iteration: 0.0153224 sec for 187761 iterations 0.081 usec (8.11654e-08 sec) per iteration: 0.0152397 sec for 187761 iterations 0.081 usec (8.1151e-08 sec) per iteration: 0.015237 sec for 187761 iterations mean: 0.081247 usec stddev: 0.000186 usec relative stddev: 0.23% RESULT TestNull: trusted_linux_arm= {0.081247, 0.000186} us TestHostSyscall: Measuring real time: 0.820 usec (8.2042e-07 sec) per iteration: 8.2042e-05 sec for 100 iterations 0.416 usec (4.15945e-07 sec) per iteration: 0.0506987 sec for 121888 iterations 0.420 usec (4.19876e-07 sec) per iteration: 0.0511779 sec for 121888 iterations 0.416 usec (4.1635e-07 sec) per iteration: 0.0507481 sec for 121888 iterations 0.418 usec (4.17858e-07 sec) per iteration: 0.0509319 sec for 121888 iterations 0.416 usec (4.15863e-07 sec) per iteration: 0.0506887 sec for 121888 iterations mean: 0.417178 usec stddev: 0.001528 usec relative stddev: 0.37% RESULT TestHostSyscall: trusted_linux_arm= {0.417178, 0.001528} us TestSetjmpLongjmp: Measuring real time: 2.057 usec (2.05722e-06 sec) per iteration: 0.000205722 sec for 100 iterations 0.781 usec (7.80966e-07 sec) per iteration: 0.037962 sec for 48609 iterations 0.777 usec (7.76709e-07 sec) per iteration: 0.037755 sec for 48609 iterations 0.779 usec (7.78698e-07 sec) per iteration: 0.0378517 sec for 48609 iterations 0.776 usec (7.75946e-07 sec) per iteration: 0.0377179 sec for 48609 iterations 0.778 usec (7.77605e-07 sec) per iteration: 0.0377986 sec for 48609 iterations mean: 0.777985 usec stddev: 0.001751 usec relative stddev: 0.23% RESULT TestSetjmpLongjmp: trusted_linux_arm= {0.777985, 0.001751} us TestClockGetTime: Measuring real time: 0.850 usec (8.5008e-07 sec) per iteration: 8.5008e-05 sec for 100 iterations 0.705 usec (7.04646e-07 sec) per iteration: 0.082891 sec for 117635 iterations 0.705 usec (7.04537e-07 sec) per iteration: 0.0828782 sec for 117635 iterations 0.704 usec (7.04478e-07 sec) per iteration: 0.0828712 sec for 117635 iterations 0.704 usec (7.04409e-07 sec) per iteration: 0.0828632 sec for 117635 iterations 0.704 usec (7.04135e-07 sec) per iteration: 0.0828309 sec for 117635 iterations mean: 0.704441 usec stddev: 0.000172 usec relative stddev: 0.02% RESULT TestClockGetTime: trusted_linux_arm= {0.704441, 0.000172} us TestTlsVariable: Measuring real time: 0.912 usec (9.1185e-07 sec) per iteration: 9.1185e-05 sec for 100 iterations 0.267 usec (2.66975e-07 sec) per iteration: 0.0292784 sec for 109667 iterations 0.267 usec (2.66772e-07 sec) per iteration: 0.0292561 sec for 109667 iterations 0.266 usec (2.66371e-07 sec) per iteration: 0.0292121 sec for 109667 iterations 0.268 usec (2.68188e-07 sec) per iteration: 0.0294114 sec for 109667 iterations 0.269 usec (2.68883e-07 sec) per iteration: 0.0294876 sec for 109667 iterations mean: 0.267438 usec stddev: 0.000943 usec relative stddev: 0.35% RESULT TestTlsVariable: trusted_linux_arm= {0.267438, 0.000943} us TestMmapAnonymous: Measuring real time: 3.986 usec (3.98555e-06 sec) per iteration: 0.000398555 sec for 100 iterations 3.087 usec (3.08726e-06 sec) per iteration: 0.0774593 sec for 25090 iterations 3.129 usec (3.12901e-06 sec) per iteration: 0.0785067 sec for 25090 iterations 3.190 usec (3.1902e-06 sec) per iteration: 0.0800421 sec for 25090 iterations 3.259 usec (3.25867e-06 sec) per iteration: 0.0817601 sec for 25090 iterations 3.264 usec (3.26424e-06 sec) per iteration: 0.0818999 sec for 25090 iterations mean: 3.185876 usec stddev: 0.069885 usec relative stddev: 2.19% RESULT TestMmapAnonymous: trusted_linux_arm= {3.185876, 0.069885} us TestAtomicIncrement: Measuring real time: 0.575 usec (5.7519e-07 sec) per iteration: 5.7519e-05 sec for 100 iterations 0.328 usec (3.2753e-07 sec) per iteration: 0.0569427 sec for 173855 iterations 0.324 usec (3.24475e-07 sec) per iteration: 0.0564116 sec for 173855 iterations 0.325 usec (3.24781e-07 sec) per iteration: 0.0564648 sec for 173855 iterations 0.330 usec (3.29757e-07 sec) per iteration: 0.0573299 sec for 173855 iterations 0.331 usec (3.30955e-07 sec) per iteration: 0.0575383 sec for 173855 iterations mean: 0.327500 usec stddev: 0.002591 usec relative stddev: 0.79% RESULT TestAtomicIncrement: trusted_linux_arm= {0.327500, 0.002591} us TestUncontendedMutexLock: Measuring real time: 1.475 usec (1.47518e-06 sec) per iteration: 0.000147518 sec for 100 iterations 0.903 usec (9.02602e-07 sec) per iteration: 0.0611856 sec for 67788 iterations 0.907 usec (9.07305e-07 sec) per iteration: 0.0615044 sec for 67788 iterations 0.906 usec (9.06275e-07 sec) per iteration: 0.0614346 sec for 67788 iterations 0.901 usec (9.0064e-07 sec) per iteration: 0.0610526 sec for 67788 iterations 0.903 usec (9.02794e-07 sec) per iteration: 0.0611986 sec for 67788 iterations mean: 0.903923 usec stddev: 0.002481 usec relative stddev: 0.27% RESULT TestUncontendedMutexLock: trusted_linux_arm= {0.903923, 0.002481} us TestCondvarSignalNoOp: Measuring real time: 1.768 usec (1.76782e-06 sec) per iteration: 0.000176782 sec for 100 iterations 0.729 usec (7.29075e-07 sec) per iteration: 0.0412409 sec for 56566 iterations 0.741 usec (7.40719e-07 sec) per iteration: 0.0418995 sec for 56566 iterations 0.731 usec (7.30951e-07 sec) per iteration: 0.041347 sec for 56566 iterations 0.727 usec (7.27385e-07 sec) per iteration: 0.0411452 sec for 56566 iterations 0.764 usec (7.63921e-07 sec) per iteration: 0.043212 sec for 56566 iterations mean: 0.738410 usec stddev: 0.013568 usec relative stddev: 1.84% RESULT TestCondvarSignalNoOp: trusted_linux_arm= {0.738410, 0.013568} us TestThreadCreateAndJoin: Measuring real time: 2913.824 usec (0.00291382 sec) per iteration: 0.291382 sec for 100 iterations 2809.847 usec (0.00280985 sec) per iteration: 0.0955348 sec for 34 iterations 2829.552 usec (0.00282955 sec) per iteration: 0.0962048 sec for 34 iterations 2812.893 usec (0.00281289 sec) per iteration: 0.0956383 sec for 34 iterations 2827.576 usec (0.00282758 sec) per iteration: 0.0961376 sec for 34 iterations 2819.535 usec (0.00281954 sec) per iteration: 0.0958642 sec for 34 iterations mean: 2819.880494 usec stddev: 7.776532 usec relative stddev: 0.28% RESULT TestThreadCreateAndJoin: trusted_linux_arm= {2819.880494, 7.776532} us TestThreadWakeup: Measuring real time: 30.003 usec (3.00026e-05 sec) per iteration: 0.00300026 sec for 100 iterations 27.250 usec (2.72498e-05 sec) per iteration: 0.0908234 sec for 3333 iterations 25.458 usec (2.54583e-05 sec) per iteration: 0.0848524 sec for 3333 iterations 26.169 usec (2.61691e-05 sec) per iteration: 0.0872215 sec for 3333 iterations 26.681 usec (2.66813e-05 sec) per iteration: 0.0889287 sec for 3333 iterations 25.485 usec (2.5485e-05 sec) per iteration: 0.0849417 sec for 3333 iterations mean: 26.208686 usec stddev: 0.692178 usec relative stddev: 2.64% RESULT TestThreadWakeup: trusted_linux_arm= {26.208686, 0.692178} us WARNING: should have taken less than 2.000000 secs [ OK ] pnacl_newlib.run_trusted_performance_test (3729 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