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-c-cfkp 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: 19306016 kB MemAvailable: 29477672 kB ====================================================================== LOAD: ====================================================================== 2.84 2.28 2.78 1/436 31007 ====================================================================== UPTIME: ====================================================================== 4427.16 28299.44 ====================================================================== 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='5856' BUILDBOT_GOT_REVISION='787866ca5f2a69470998b1e07cfc1426e2a41260' 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='38435' 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/8924043730302541664' LOGDOG_STREAM_PROJECT='nacl' LOGDOG_STREAM_SERVER_PATH='unix:/b/s/w/ir/tmp/ld.sock' LOGNAME='chrome-bot' LUCI_CONTEXT='/b/s/w/itWaIwIS/luci_context.776363416' 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='30981' 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-c-cfkp' SWARMING_EXTERNAL_BOT_SETUP='1' SWARMING_HEADLESS='1' SWARMING_SERVER='https://chromium-swarm.appspot.com' SWARMING_TASK_ID='4276d82e27f29611' 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 (16700 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 (6220 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.512 usec (5.1162e-07 sec) per iteration: 5.1162e-05 sec for 100 iterations 0.087 usec (8.65154e-08 sec) per iteration: 0.01691 sec for 195457 iterations 0.085 usec (8.54025e-08 sec) per iteration: 0.0166925 sec for 195457 iterations 0.087 usec (8.65142e-08 sec) per iteration: 0.0169098 sec for 195457 iterations 0.085 usec (8.53932e-08 sec) per iteration: 0.0166907 sec for 195457 iterations 0.085 usec (8.51711e-08 sec) per iteration: 0.0166473 sec for 195457 iterations mean: 0.085799 usec stddev: 0.000590 usec relative stddev: 0.69% RESULT TestNull: trusted_linux_arm= {0.085799, 0.000590} us TestHostSyscall: Measuring real time: 0.820 usec (8.201e-07 sec) per iteration: 8.201e-05 sec for 100 iterations 0.415 usec (4.14957e-07 sec) per iteration: 0.0505982 sec for 121936 iterations 0.412 usec (4.11975e-07 sec) per iteration: 0.0502346 sec for 121936 iterations 0.412 usec (4.12388e-07 sec) per iteration: 0.050285 sec for 121936 iterations 0.415 usec (4.14534e-07 sec) per iteration: 0.0505466 sec for 121936 iterations 0.414 usec (4.14175e-07 sec) per iteration: 0.0505028 sec for 121936 iterations mean: 0.413606 usec stddev: 0.001196 usec relative stddev: 0.29% RESULT TestHostSyscall: trusted_linux_arm= {0.413606, 0.001196} us TestSetjmpLongjmp: Measuring real time: 1.999 usec (1.99866e-06 sec) per iteration: 0.000199866 sec for 100 iterations 0.761 usec (7.60884e-07 sec) per iteration: 0.0380693 sec for 50033 iterations 0.810 usec (8.09954e-07 sec) per iteration: 0.0405244 sec for 50033 iterations 0.757 usec (7.5685e-07 sec) per iteration: 0.0378675 sec for 50033 iterations 0.759 usec (7.59437e-07 sec) per iteration: 0.0379969 sec for 50033 iterations 0.755 usec (7.55394e-07 sec) per iteration: 0.0377946 sec for 50033 iterations mean: 0.768504 usec stddev: 0.020814 usec relative stddev: 2.71% RESULT TestSetjmpLongjmp: trusted_linux_arm= {0.768504, 0.020814} us TestClockGetTime: Measuring real time: 0.868 usec (8.6847e-07 sec) per iteration: 8.6847e-05 sec for 100 iterations 0.728 usec (7.28305e-07 sec) per iteration: 0.0838607 sec for 115145 iterations 0.725 usec (7.2477e-07 sec) per iteration: 0.0834537 sec for 115145 iterations 0.727 usec (7.2672e-07 sec) per iteration: 0.0836781 sec for 115145 iterations 0.727 usec (7.27125e-07 sec) per iteration: 0.0837248 sec for 115145 iterations 0.725 usec (7.25195e-07 sec) per iteration: 0.0835025 sec for 115145 iterations mean: 0.726423 usec stddev: 0.001293 usec relative stddev: 0.18% RESULT TestClockGetTime: trusted_linux_arm= {0.726423, 0.001293} us TestTlsVariable: Measuring real time: 1.006 usec (1.00588e-06 sec) per iteration: 0.000100588 sec for 100 iterations 0.265 usec (2.64791e-07 sec) per iteration: 0.0263242 sec for 99415 iterations 0.267 usec (2.67357e-07 sec) per iteration: 0.0265793 sec for 99415 iterations 0.266 usec (2.65864e-07 sec) per iteration: 0.0264308 sec for 99415 iterations 0.265 usec (2.64814e-07 sec) per iteration: 0.0263265 sec for 99415 iterations 0.264 usec (2.64054e-07 sec) per iteration: 0.026251 sec for 99415 iterations mean: 0.265376 usec stddev: 0.001146 usec relative stddev: 0.43% RESULT TestTlsVariable: trusted_linux_arm= {0.265376, 0.001146} us TestMmapAnonymous: Measuring real time: 4.169 usec (4.16904e-06 sec) per iteration: 0.000416904 sec for 100 iterations 3.118 usec (3.11818e-06 sec) per iteration: 0.0747926 sec for 23986 iterations 3.175 usec (3.17536e-06 sec) per iteration: 0.0761641 sec for 23986 iterations 3.191 usec (3.19074e-06 sec) per iteration: 0.0765332 sec for 23986 iterations 3.190 usec (3.18986e-06 sec) per iteration: 0.0765119 sec for 23986 iterations 3.214 usec (3.21376e-06 sec) per iteration: 0.0770852 sec for 23986 iterations mean: 3.177578 usec stddev: 0.032145 usec relative stddev: 1.01% RESULT TestMmapAnonymous: trusted_linux_arm= {3.177578, 0.032145} us TestAtomicIncrement: Measuring real time: 0.577 usec (5.7667e-07 sec) per iteration: 5.7667e-05 sec for 100 iterations 0.338 usec (3.38214e-07 sec) per iteration: 0.0586493 sec for 173409 iterations 0.355 usec (3.55327e-07 sec) per iteration: 0.0616169 sec for 173409 iterations 0.338 usec (3.38354e-07 sec) per iteration: 0.0586736 sec for 173409 iterations 0.339 usec (3.38728e-07 sec) per iteration: 0.0587384 sec for 173409 iterations 0.338 usec (3.37735e-07 sec) per iteration: 0.0585663 sec for 173409 iterations mean: 0.341671 usec stddev: 0.006835 usec relative stddev: 2.00% RESULT TestAtomicIncrement: trusted_linux_arm= {0.341671, 0.006835} us TestUncontendedMutexLock: Measuring real time: 1.552 usec (1.55163e-06 sec) per iteration: 0.000155163 sec for 100 iterations 0.905 usec (9.05073e-07 sec) per iteration: 0.0583302 sec for 64448 iterations 0.910 usec (9.10419e-07 sec) per iteration: 0.0586747 sec for 64448 iterations 0.909 usec (9.09204e-07 sec) per iteration: 0.0585964 sec for 64448 iterations 0.908 usec (9.07771e-07 sec) per iteration: 0.0585041 sec for 64448 iterations 0.908 usec (9.07886e-07 sec) per iteration: 0.0585114 sec for 64448 iterations mean: 0.908071 usec stddev: 0.001784 usec relative stddev: 0.20% RESULT TestUncontendedMutexLock: trusted_linux_arm= {0.908071, 0.001784} us TestCondvarSignalNoOp: Measuring real time: 1.647 usec (1.64692e-06 sec) per iteration: 0.000164692 sec for 100 iterations 0.739 usec (7.38948e-07 sec) per iteration: 0.0448682 sec for 60719 iterations 0.740 usec (7.40164e-07 sec) per iteration: 0.044942 sec for 60719 iterations 0.741 usec (7.41348e-07 sec) per iteration: 0.0450139 sec for 60719 iterations 0.750 usec (7.49761e-07 sec) per iteration: 0.0455247 sec for 60719 iterations 0.743 usec (7.42932e-07 sec) per iteration: 0.0451101 sec for 60719 iterations mean: 0.742631 usec stddev: 0.003801 usec relative stddev: 0.51% RESULT TestCondvarSignalNoOp: trusted_linux_arm= {0.742631, 0.003801} us TestThreadCreateAndJoin: Measuring real time: 3103.915 usec (0.00310392 sec) per iteration: 0.310392 sec for 100 iterations 3000.633 usec (0.00300063 sec) per iteration: 0.0960203 sec for 32 iterations 3076.879 usec (0.00307688 sec) per iteration: 0.0984601 sec for 32 iterations 3000.125 usec (0.00300012 sec) per iteration: 0.096004 sec for 32 iterations 3020.769 usec (0.00302077 sec) per iteration: 0.0966646 sec for 32 iterations 3160.892 usec (0.00316089 sec) per iteration: 0.101149 sec for 32 iterations mean: 3051.859506 usec stddev: 61.288386 usec relative stddev: 2.01% RESULT TestThreadCreateAndJoin: trusted_linux_arm= {3051.859506, 61.288386} us TestThreadWakeup: Measuring real time: 35.010 usec (3.50098e-05 sec) per iteration: 0.00350098 sec for 100 iterations 28.602 usec (2.86023e-05 sec) per iteration: 0.0816882 sec for 2856 iterations 28.537 usec (2.85366e-05 sec) per iteration: 0.0815007 sec for 2856 iterations 28.312 usec (2.8312e-05 sec) per iteration: 0.080859 sec for 2856 iterations 29.383 usec (2.93833e-05 sec) per iteration: 0.0839187 sec for 2856 iterations 29.482 usec (2.94819e-05 sec) per iteration: 0.0842004 sec for 2856 iterations mean: 28.863236 usec stddev: 0.475794 usec relative stddev: 1.65% RESULT TestThreadWakeup: trusted_linux_arm= {28.863236, 0.475794} us WARNING: should have taken less than 2.000000 secs [ OK ] pnacl_newlib.run_trusted_performance_test (3740 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