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-e833d7b0-us-west1-b-g0n5 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: 19358624 kB MemAvailable: 29480468 kB ====================================================================== LOAD: ====================================================================== 2.72 3.72 3.74 2/440 3152 ====================================================================== UPTIME: ====================================================================== 2358.87 12256.34 ====================================================================== 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-arm-pnacl-subzero-pexe-clang OBJ_ROOT: /b/s/w/ir/kitchen-workdir/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/kitchen-workdir/native_client/toolchain/linux_x86/pnacl_newlib_raw/bin/pnacl-clang -std=gnu99 ASPPCOM: /b/s/w/ir/kitchen-workdir/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/kitchen-workdir/native_client/scons-out/nacl-arm-pnacl-subzero-pexe-clang/include -I/b/s/w/ir/kitchen-workdir -c -o UNKNOWN COMPILER NACL_BUILD_FAMILY: TRUSTED BUILD_TYPE: opt-linux TARGET_ROOT: /b/s/w/ir/kitchen-workdir/native_client/scons-out/opt-linux-arm OBJ_ROOT: /b/s/w/ir/kitchen-workdir/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/kitchen-workdir -c -o set BOTO_CONFIG='/home/chrome-bot/.boto' BUILDBOT_BUILDERNAME='nacl-precise_64-newlib-arm_qemu-pnacl' BUILDBOT_BUILDNUMBER='5858' BUILDBOT_GOT_REVISION='db511ff7952658efc9bf67afa8dfdac9faba2f93' BUILDBOT_MASTERNAME='tryserver.nacl' BUILDBOT_REVISION='' BUILDBOT_SLAVE_TYPE='Trybot' BUILDBUCKET_EXPERIMENTAL='TRUE' CIPD_CACHE_DIR='/b/s/cipd_cache/cache' CIPD_PROTOCOL='v2' CYGWIN='nodosfilewarning' DEVSHELL_CLIENT_PORT='44580' 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/8923957112344135536' LOGDOG_STREAM_PROJECT='nacl' LOGDOG_STREAM_SERVER_PATH='unix:/b/s/w/ir/tmp/ld.sock' LOGNAME='chrome-bot' LUCI_CONTEXT='/b/s/w/itrq7XKL/luci_context.821947723' 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/kitchen-workdir/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_VERBOSE='true' PPID='3115' PS1='$ ' PS2='> ' PS4='+ ' PWD='/b/s/w/ir/kitchen-workdir/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-e833d7b0-us-west1-b-g0n5' SWARMING_EXTERNAL_BOT_SETUP='1' SWARMING_HEADLESS='1' SWARMING_SERVER='https://chromium-swarm.appspot.com' SWARMING_TASK_ID='427bc49bac011311' TEMP='/b/s/w/ir/tmp/t/nacl_tmp/nacl-precise_64-newlib-arm_qemu-pnacl' TEMPDIR='/b/s/w/ir/tmp/t' TERM='linux' TMP='/b/s/w/ir/tmp/t/nacl_tmp/nacl-precise_64-newlib-arm_qemu-pnacl' TMPDIR='/b/s/w/ir/tmp/t/nacl_tmp/nacl-precise_64-newlib-arm_qemu-pnacl' 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/kitchen-workdir/native_client/scons-out/nacl_irt-arm OBJ_ROOT: /b/s/w/ir/kitchen-workdir/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/kitchen-workdir/native_client/toolchain/linux_x86/pnacl_newlib_raw/bin/arm-nacl-clang ASPPCOM: /b/s/w/ir/kitchen-workdir/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/kitchen-workdir/native_client/scons-out/nacl_irt-arm/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_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/kitchen-workdir/native_client/scons-out/nacl-arm-pnacl-subzero-pexe-clang/test_results/clock_cputime_test.out /b/s/w/ir/kitchen-workdir/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/kitchen-workdir/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 (15540 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.629 KB RESULT hello_world_size.out: ZIPPED_arm_pnacl_sz_newlib_static= 232.479 KB /usr/bin/python /b/s/w/ir/kitchen-workdir/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/kitchen-workdir/native_client/scons-out/opt-linux-arm/test_results/nacl_interval_multi_reg_test.out /b/s/w/ir/kitchen-workdir/native_client/toolchain/linux_x86/arm_trusted/run_under_qemu_arm /b/s/w/ir/kitchen-workdir/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/kitchen-workdir/native_client/toolchain/linux_x86/arm_trusted/run_under_qemu_arm /b/s/w/ir/kitchen-workdir/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 (6310 ms) /usr/bin/python /b/s/w/ir/kitchen-workdir/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/kitchen-workdir/native_client/scons-out/opt-linux-arm/test_results/performance_test.out /b/s/w/ir/kitchen-workdir/native_client/toolchain/linux_x86/arm_trusted/run_under_qemu_arm /b/s/w/ir/kitchen-workdir/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/kitchen-workdir/native_client/toolchain/linux_x86/arm_trusted/run_under_qemu_arm /b/s/w/ir/kitchen-workdir/native_client/scons-out/opt-linux-arm/obj/tests/performance/performance_test trusted_linux_arm TestNull: Measuring real time: 0.586 usec (5.8562e-07 sec) per iteration: 5.8562e-05 sec for 100 iterations 0.084 usec (8.40139e-08 sec) per iteration: 0.0143461 sec for 170759 iterations 0.085 usec (8.50587e-08 sec) per iteration: 0.0145245 sec for 170759 iterations 0.085 usec (8.50836e-08 sec) per iteration: 0.0145288 sec for 170759 iterations 0.081 usec (8.14476e-08 sec) per iteration: 0.0139079 sec for 170759 iterations 0.083 usec (8.322e-08 sec) per iteration: 0.0142106 sec for 170759 iterations mean: 0.083765 usec stddev: 0.001352 usec relative stddev: 1.61% RESULT TestNull: trusted_linux_arm= {0.083765, 0.001352} us TestHostSyscall: Measuring real time: 1.016 usec (1.01557e-06 sec) per iteration: 0.000101557 sec for 100 iterations 0.430 usec (4.30396e-07 sec) per iteration: 0.0423794 sec for 98466 iterations 0.429 usec (4.29307e-07 sec) per iteration: 0.0422721 sec for 98466 iterations 0.430 usec (4.29889e-07 sec) per iteration: 0.0423294 sec for 98466 iterations 0.426 usec (4.25556e-07 sec) per iteration: 0.0419028 sec for 98466 iterations 0.428 usec (4.27674e-07 sec) per iteration: 0.0421114 sec for 98466 iterations mean: 0.428564 usec stddev: 0.001761 usec relative stddev: 0.41% RESULT TestHostSyscall: trusted_linux_arm= {0.428564, 0.001761} us TestSetjmpLongjmp: Measuring real time: 2.327 usec (2.32657e-06 sec) per iteration: 0.000232657 sec for 100 iterations 0.771 usec (7.71323e-07 sec) per iteration: 0.0331522 sec for 42981 iterations 0.760 usec (7.59688e-07 sec) per iteration: 0.0326522 sec for 42981 iterations 0.776 usec (7.76101e-07 sec) per iteration: 0.0333576 sec for 42981 iterations 0.759 usec (7.58587e-07 sec) per iteration: 0.0326048 sec for 42981 iterations 0.752 usec (7.51627e-07 sec) per iteration: 0.0323057 sec for 42981 iterations mean: 0.763465 usec stddev: 0.008940 usec relative stddev: 1.17% RESULT TestSetjmpLongjmp: trusted_linux_arm= {0.763465, 0.008940} us TestClockGetTime: Measuring real time: 1.040 usec (1.04031e-06 sec) per iteration: 0.000104031 sec for 100 iterations 0.718 usec (7.17528e-07 sec) per iteration: 0.0689723 sec for 96125 iterations 0.712 usec (7.11757e-07 sec) per iteration: 0.0684177 sec for 96125 iterations 0.703 usec (7.02814e-07 sec) per iteration: 0.067558 sec for 96125 iterations 0.720 usec (7.19783e-07 sec) per iteration: 0.0691892 sec for 96125 iterations 0.727 usec (7.26892e-07 sec) per iteration: 0.0698725 sec for 96125 iterations mean: 0.715755 usec stddev: 0.008085 usec relative stddev: 1.13% RESULT TestClockGetTime: trusted_linux_arm= {0.715755, 0.008085} us TestTlsVariable: Measuring real time: 1.226 usec (1.2262e-06 sec) per iteration: 0.00012262 sec for 100 iterations 0.263 usec (2.63338e-07 sec) per iteration: 0.0214757 sec for 81552 iterations 0.268 usec (2.67525e-07 sec) per iteration: 0.0218172 sec for 81552 iterations 0.263 usec (2.63158e-07 sec) per iteration: 0.0214611 sec for 81552 iterations 0.266 usec (2.65791e-07 sec) per iteration: 0.0216758 sec for 81552 iterations 0.261 usec (2.61322e-07 sec) per iteration: 0.0213113 sec for 81552 iterations mean: 0.264227 usec stddev: 0.002177 usec relative stddev: 0.82% RESULT TestTlsVariable: trusted_linux_arm= {0.264227, 0.002177} us TestMmapAnonymous: Measuring real time: 3.934 usec (3.93389e-06 sec) per iteration: 0.000393389 sec for 100 iterations 3.074 usec (3.07418e-06 sec) per iteration: 0.0781456 sec for 25420 iterations 3.114 usec (3.11424e-06 sec) per iteration: 0.0791639 sec for 25420 iterations 3.004 usec (3.00375e-06 sec) per iteration: 0.0763553 sec for 25420 iterations 3.182 usec (3.18189e-06 sec) per iteration: 0.0808837 sec for 25420 iterations 3.125 usec (3.12451e-06 sec) per iteration: 0.079425 sec for 25420 iterations mean: 3.099712 usec stddev: 0.059060 usec relative stddev: 1.91% RESULT TestMmapAnonymous: trusted_linux_arm= {3.099712, 0.059060} us TestAtomicIncrement: Measuring real time: 0.719 usec (7.1913e-07 sec) per iteration: 7.1913e-05 sec for 100 iterations 0.339 usec (3.38769e-07 sec) per iteration: 0.0471078 sec for 139056 iterations 0.332 usec (3.31842e-07 sec) per iteration: 0.0461446 sec for 139056 iterations 0.340 usec (3.40185e-07 sec) per iteration: 0.0473047 sec for 139056 iterations 0.339 usec (3.38811e-07 sec) per iteration: 0.0471137 sec for 139056 iterations 0.335 usec (3.34693e-07 sec) per iteration: 0.046541 sec for 139056 iterations mean: 0.336860 usec stddev: 0.003111 usec relative stddev: 0.92% RESULT TestAtomicIncrement: trusted_linux_arm= {0.336860, 0.003111} us TestUncontendedMutexLock: Measuring real time: 1.780 usec (1.77958e-06 sec) per iteration: 0.000177958 sec for 100 iterations 0.900 usec (9.00493e-07 sec) per iteration: 0.0506014 sec for 56193 iterations 0.883 usec (8.82592e-07 sec) per iteration: 0.0495955 sec for 56193 iterations 0.870 usec (8.69773e-07 sec) per iteration: 0.0488752 sec for 56193 iterations 0.881 usec (8.80892e-07 sec) per iteration: 0.0494999 sec for 56193 iterations 0.895 usec (8.94975e-07 sec) per iteration: 0.0502913 sec for 56193 iterations mean: 0.885745 usec stddev: 0.010874 usec relative stddev: 1.23% RESULT TestUncontendedMutexLock: trusted_linux_arm= {0.885745, 0.010874} us TestCondvarSignalNoOp: Measuring real time: 2.004 usec (2.00417e-06 sec) per iteration: 0.000200417 sec for 100 iterations 0.736 usec (7.35912e-07 sec) per iteration: 0.0367183 sec for 49895 iterations 0.742 usec (7.42232e-07 sec) per iteration: 0.0370337 sec for 49895 iterations 0.746 usec (7.46439e-07 sec) per iteration: 0.0372436 sec for 49895 iterations 0.735 usec (7.34916e-07 sec) per iteration: 0.0366686 sec for 49895 iterations 0.732 usec (7.32202e-07 sec) per iteration: 0.0365332 sec for 49895 iterations mean: 0.738340 usec stddev: 0.005216 usec relative stddev: 0.71% RESULT TestCondvarSignalNoOp: trusted_linux_arm= {0.738340, 0.005216} us TestThreadCreateAndJoin: Measuring real time: 2830.313 usec (0.00283031 sec) per iteration: 0.283031 sec for 100 iterations 2763.715 usec (0.00276372 sec) per iteration: 0.09673 sec for 35 iterations 2758.161 usec (0.00275816 sec) per iteration: 0.0965356 sec for 35 iterations 2671.768 usec (0.00267177 sec) per iteration: 0.0935119 sec for 35 iterations 2673.072 usec (0.00267307 sec) per iteration: 0.0935575 sec for 35 iterations 2751.651 usec (0.00275165 sec) per iteration: 0.0963078 sec for 35 iterations mean: 2723.673537 usec stddev: 42.024149 usec relative stddev: 1.54% RESULT TestThreadCreateAndJoin: trusted_linux_arm= {2723.673537, 42.024149} us TestThreadWakeup: Measuring real time: 30.604 usec (3.06038e-05 sec) per iteration: 0.00306038 sec for 100 iterations 26.538 usec (2.65378e-05 sec) per iteration: 0.0866991 sec for 3267 iterations 27.905 usec (2.79046e-05 sec) per iteration: 0.0911645 sec for 3267 iterations 28.984 usec (2.8984e-05 sec) per iteration: 0.0946906 sec for 3267 iterations 29.342 usec (2.93417e-05 sec) per iteration: 0.0958592 sec for 3267 iterations 30.045 usec (3.0045e-05 sec) per iteration: 0.098157 sec for 3267 iterations mean: 28.562623 usec stddev: 1.225931 usec relative stddev: 4.29% RESULT TestThreadWakeup: trusted_linux_arm= {28.562623, 1.225931} us WARNING: should have taken less than 2.000000 secs [ OK ] pnacl_newlib.run_trusted_performance_test (3460 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