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=x86-64 nacl_clang=1 skip_trusted_tests=1 large_tests scons: Reading SConscript files ... ====================================================================== SCONS ARGS:['scons.py', '--verbose', '-k', '-j1', '--mode=nacl,opt-host', 'platform=x86-64', 'nacl_clang=1', 'skip_trusted_tests=1', 'large_tests'] ====================================================================== ====================================================================== Python Info: ====================================================================== linux2 2.7.6 (default, Nov 23 2017, 15:49:48) [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-vplb 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: 46038012 kB MemAvailable: 59363308 kB ====================================================================== LOAD: ====================================================================== 1.67 2.74 3.02 1/635 1582 ====================================================================== UPTIME: ====================================================================== 14289.69 198320.03 ====================================================================== 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-x86-64 OBJ_ROOT: /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl-x86-64/obj BUILD_TYPE_DESCRIPTION: NaCl module build BUILD_OS: BUILD_ARCHITECTURE: x86 BUILD_SUBARCH: 64 TARGET_OS: TARGET_ARCHITECTURE: x86 TARGET_SUBARCH: 64 CC: /b/s/w/ir/kitchen-workdir/native_client/toolchain/linux_x86/pnacl_newlib_raw/bin/x86_64-nacl-clang ASPPCOM: /b/s/w/ir/kitchen-workdir/native_client/toolchain/linux_x86/pnacl_newlib_raw/bin/x86_64-nacl-clang -m64 -D__STDC_LIMIT_MACROS=1 -D__STDC_FORMAT_MACROS=1 -D_GNU_SOURCE=1 -D_POSIX_C_SOURCE=199506 -D_XOPEN_SOURCE=600 -DDYNAMIC_ANNOTATIONS_ENABLED=1 -DDYNAMIC_ANNOTATIONS_PREFIX=NACL_ -DNACL_BUILD_ARCH=x86 -DNACL_BUILD_SUBARCH=64 -I/b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl-x86-64/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-x86-64 OBJ_ROOT: /b/s/w/ir/kitchen-workdir/native_client/scons-out/opt-linux-x86-64/obj BUILD_TYPE_DESCRIPTION: Linux opt build BUILD_OS: BUILD_ARCHITECTURE: x86 BUILD_SUBARCH: 64 TARGET_OS: TARGET_ARCHITECTURE: x86 TARGET_SUBARCH: 64 CC: gcc ASPPCOM: gcc -fPIE -m64 -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_FORTIFY_SOURCE=2 -D_POSIX_C_SOURCE=199506 -D_XOPEN_SOURCE=600 -D_GNU_SOURCE=1 -D_LARGEFILE64_SOURCE=1 -D__STDC_LIMIT_MACROS=1 -D__STDC_FORMAT_MACROS=1 -DNDEBUG -I/b/s/w/ir/kitchen-workdir -c -o set BOTO_CONFIG='/home/chrome-bot/.boto' BUILDBOT_BUILDERNAME='linux-pnacl-x86_64' BUILDBOT_BUILDNUMBER='7023' BUILDBOT_GOT_REVISION='743e540fe72edfeaead9d9c093f06ea76c49fa4c' BUILDBOT_MASTERNAME='client.nacl.toolchain' BUILDBOT_REVISION='743e540fe72edfeaead9d9c093f06ea76c49fa4c' BUILDBOT_SLAVE_TYPE='BuilderTester' BUILDBUCKET_EXPERIMENTAL='FALSE' CIPD_CACHE_DIR='/b/s/cipd_cache/cache' CIPD_PROTOCOL='v2' CYGWIN='nodosfilewarning' DEVSHELL_CLIENT_PORT='41972' 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/8923585503960917152' LOGDOG_STREAM_PROJECT='nacl' LOGDOG_STREAM_SERVER_PATH='unix:/b/s/w/ir/tmp/ld.sock' LOGNAME='chrome-bot' LUCI_CONTEXT='/b/s/w/itQHB8J0/luci_context.454335915' 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_TOOLCHAIN_DIR='linux_x86/pnacl_newlib' PNACL_VERBOSE='true' PPID='1554' 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-16-145e5bab-us-west1-c-vplb' SWARMING_EXTERNAL_BOT_SETUP='1' SWARMING_HEADLESS='1' SWARMING_SERVER='https://chromium-swarm.appspot.com' SWARMING_TASK_ID='4290e43a6873ad11' 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' gcc -v -c Using built-in specs. COLLECT_GCC=gcc Target: x86_64-linux-gnu Configured with: ../src/configure -v --with-pkgversion='Ubuntu 4.8.4-2ubuntu1~14.04.4' --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/include/c++/4.8 --libdir=/usr/lib --enable-nls --with-sysroot=/ --enable-clocale=gnu --enable-libstdcxx-debug --enable-libstdcxx-time=yes --enable-gnu-unique-object --disable-libmudflap --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-amd64/jre --enable-java-home --with-jvm-root-dir=/usr/lib/jvm/java-1.5.0-gcj-4.8-amd64 --with-jvm-jar-dir=/usr/lib/jvm-exports/java-1.5.0-gcj-4.8-amd64 --with-arch-directory=amd64 --with-ecj-jar=/usr/share/java/eclipse-ecj.jar --enable-objc-gc --enable-multiarch --disable-werror --with-arch-32=i686 --with-abi=m64 --with-multilib-list=m32,m64,mx32 --with-tune=generic --enable-checking=release --build=x86_64-linux-gnu --host=x86_64-linux-gnu --target=x86_64-linux-gnu Thread model: posix gcc version 4.8.4 (Ubuntu 4.8.4-2ubuntu1~14.04.4) gcc -print-search-dirs install: /usr/lib/gcc/x86_64-linux-gnu/4.8/ programs: =/usr/lib/gcc/x86_64-linux-gnu/4.8/:/usr/lib/gcc/x86_64-linux-gnu/4.8/:/usr/lib/gcc/x86_64-linux-gnu/:/usr/lib/gcc/x86_64-linux-gnu/4.8/:/usr/lib/gcc/x86_64-linux-gnu/:/usr/lib/gcc/x86_64-linux-gnu/4.8/../../../../x86_64-linux-gnu/bin/x86_64-linux-gnu/4.8/:/usr/lib/gcc/x86_64-linux-gnu/4.8/../../../../x86_64-linux-gnu/bin/x86_64-linux-gnu/:/usr/lib/gcc/x86_64-linux-gnu/4.8/../../../../x86_64-linux-gnu/bin/ libraries: =/usr/lib/gcc/x86_64-linux-gnu/4.8/:/usr/lib/gcc/x86_64-linux-gnu/4.8/../../../../x86_64-linux-gnu/lib/x86_64-linux-gnu/4.8/:/usr/lib/gcc/x86_64-linux-gnu/4.8/../../../../x86_64-linux-gnu/lib/x86_64-linux-gnu/:/usr/lib/gcc/x86_64-linux-gnu/4.8/../../../../x86_64-linux-gnu/lib/../lib/:/usr/lib/gcc/x86_64-linux-gnu/4.8/../../../x86_64-linux-gnu/4.8/:/usr/lib/gcc/x86_64-linux-gnu/4.8/../../../x86_64-linux-gnu/:/usr/lib/gcc/x86_64-linux-gnu/4.8/../../../../lib/:/lib/x86_64-linux-gnu/4.8/:/lib/x86_64-linux-gnu/:/lib/../lib/:/usr/lib/x86_64-linux-gnu/4.8/:/usr/lib/x86_64-linux-gnu/:/usr/lib/../lib/:/usr/lib/gcc/x86_64-linux-gnu/4.8/../../../../x86_64-linux-gnu/lib/:/usr/lib/gcc/x86_64-linux-gnu/4.8/../../../:/lib/:/usr/lib/ gcc -print-libgcc-file-name /usr/lib/gcc/x86_64-linux-gnu/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-x86-64 OBJ_ROOT: /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl_irt-x86-64/obj BUILD_TYPE_DESCRIPTION: NaCl IRT build BUILD_OS: BUILD_ARCHITECTURE: x86 BUILD_SUBARCH: 64 TARGET_OS: TARGET_ARCHITECTURE: x86 TARGET_SUBARCH: 64 CC: /b/s/w/ir/kitchen-workdir/native_client/toolchain/linux_x86/pnacl_newlib_raw/bin/x86_64-nacl-clang ASPPCOM: /b/s/w/ir/kitchen-workdir/native_client/toolchain/linux_x86/pnacl_newlib_raw/bin/x86_64-nacl-clang -m64 -D__STDC_LIMIT_MACROS=1 -D__STDC_FORMAT_MACROS=1 -D_GNU_SOURCE=1 -D_POSIX_C_SOURCE=199506 -D_XOPEN_SOURCE=600 -DDYNAMIC_ANNOTATIONS_ENABLED=1 -DDYNAMIC_ANNOTATIONS_PREFIX=NACL_ -DNACL_BUILD_ARCH=x86 -DNACL_BUILD_SUBARCH=64 -I/b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl_irt-x86-64/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_ncval_annotate_test *** BROKEN run_gdb_invalid_memory_test *** BROKEN run_nanosleep_test *** BROKEN run_timefuncs_test *** BROKEN run_raw_timefuncs_test *** BROKEN run_main_thread_pthread_exit_test2 *** BROKEN run_overflowinline_test *** BROKEN run_stack_frame_noopt_frame_test *** BROKEN run_stack_frame_noopt_noframe_test *** BROKEN run_stack_frame_opt_frame_test *** BROKEN run_stack_frame_opt_noframe_test *** BROKEN run_vla_test *** SKIPPING opt-linux-64 : run_package_version_tests *** SKIPPING opt-linux-64 : run_pynacl_tests *** SKIPPING opt-linux-64 : run_gio_test *** SKIPPING opt-linux-64 : run_gprintf_test *** SKIPPING opt-linux-64 : run_sigpipe_test *** SKIPPING opt-linux-64 : run_platform_tests *** SKIPPING opt-linux-64 : run_nacl_semaphore_test *** SKIPPING opt-linux-64 : run_nacl_host_dir_test *** SKIPPING opt-linux-64 : run_nacl_clock_test *** SKIPPING opt-linux-64 : run_nacl_clock_cputime_test *** SKIPPING opt-linux-64 : run_nacl_sync_lock_lock_test *** SKIPPING opt-linux-64 : run_nacl_sync_lock_trylock_test *** SKIPPING opt-linux-64 : run_nacl_sync_trylock_lock_test *** SKIPPING opt-linux-64 : run_nacl_sync_trylock_trylock_test *** SKIPPING opt-linux-64 : run_nacl_host_desc_mmap_test *** SKIPPING opt-linux-64 : run_nacl_host_desc_pread_pwrite_test *** SKIPPING opt-linux-64 : run_nacl_host_desc_big_file_test *** SKIPPING opt-linux-64 : run_cpu_x86_test *** SKIPPING opt-linux-64 : run_gdb_rsp_tests *** SKIPPING opt-linux-64 : run_transport_ipc_test *** SKIPPING opt-linux-64 : run_nacl_desc_quota_test *** SKIPPING opt-linux-64 : run_metadata_test *** SKIPPING opt-linux-64 : run_nacl_desc_io_alloc_ctor_test *** SKIPPING opt-linux-64 : run_nacl_fi_test *** SKIPPING opt-linux-64 : run_nacl_interval_list_test *** SKIPPING opt-linux-64 : run_nacl_interval_tree_test *** SKIPPING opt-linux-64 : run_nacl_interval_list_random_test *** SKIPPING opt-linux-64 : run_nacl_interval_tree_random_test *** SKIPPING opt-linux-64 : run_nacl_interval_multi_test *** SKIPPING opt-linux-64 : run_nacl_interval_multi_reg_test *** SKIPPING opt-linux-64 : run_nacl_base_test *** SKIPPING opt-linux-64 : run_nacl_min_max_test *** SKIPPING opt-linux-64 : run_nacl_min_max_cpp_test *** SKIPPING opt-linux-64 : run_nacl_perf_counter_test *** SKIPPING opt-linux-64 : run_platform_qual_test *** SKIPPING opt-linux-64 : run_cpuwhitelist_test *** SKIPPING opt-linux-64 : run_service_runtime_tests *** SKIPPING opt-linux-64 : run_format_string_test *** SKIPPING opt-linux-64 : run_trusted_mmap_test *** SKIPPING opt-linux-64 : run_nacl_bootstrap_prereservation_test *** BROKEN run_nacl_sync_cond_test *** SKIPPING opt-linux-64 : run_env_cleanser_test *** SKIPPING opt-linux-64 : run_nacl_resource_test *** SKIPPING opt-linux-64 : run_nacl_signal_test *** SKIPPING opt-linux-64 : run_signal_frame_test *** SKIPPING opt-linux-64 : run_check_test *** SKIPPING opt-linux-64 : run_check_test_death *** SKIPPING opt-linux-64 : run_dcheck_test_death *** SKIPPING opt-linux-64 : run_check_test_always_death *** SKIPPING opt-linux-64 : run_check_test_always_death_abort *** SKIPPING opt-linux-64 : run_dcheck_test_never_death *** SKIPPING opt-linux-64 : run_dcheck_test_always_death *** SKIPPING opt-linux-64 : run_nacl_tls_unittest *** SKIPPING opt-linux-64 : run_sel_ldr_exe_not_found_test *** SKIPPING opt-linux-64 : run_fuzz_nullptr_test *** SKIPPING opt-linux-64 : run_unaligned_data_test *** SKIPPING opt-linux-64 : run_unaligned_data_irt_test *** SKIPPING opt-linux-64 : run_hello_x32_test *** SKIPPING opt-linux-64 : run_service_runtime_hello_world_test *** SKIPPING opt-linux-64 : run_old_abi_death_test *** SKIPPING opt-linux-64 : run_integer_overflow_while_madvising_death_test *** SKIPPING opt-linux-64 : run_negative_hole_death_test *** SKIPPING opt-linux-64 : run_rodata_data_overlap_death_test *** SKIPPING opt-linux-64 : run_data_not_last_death_test SKIPPING test text_overlaps_rodata SKIPPING test text_overlaps_data *** SKIPPING opt-linux-64 : run_text_too_big_death_test *** SKIPPING opt-linux-64 : run_sel_ldr_thread_death_test *** SKIPPING opt-linux-64 : run_nacl_error_gio_test *** SKIPPING opt-linux-64 : run_nacl_error_log_test *** SKIPPING opt-linux-64 : run_dyn_array_test *** SKIPPING opt-linux-64 : run_validation_cache_test *** SKIPPING opt-linux-64 : run_validator_debug_stub_test *** SKIPPING opt-linux-64 : run_disable_nontemporals_test *** SKIPPING opt-linux-64 : run_validation_rewrite_test *** SKIPPING opt-linux-64 : run_gen_dfa_test *** SKIPPING opt-linux-64 : run_trie_test *** SKIPPING opt-linux-64 : run_proof_tools_test *** SKIPPING opt-linux-64 : run_validator_py_test *** SKIPPING opt-linux-64 : run_rdfa_targeted_tests_32 *** SKIPPING opt-linux-64 : run_dis_section_test_32 *** SKIPPING opt-linux-64 : run_spec_val_test_32 *** SKIPPING opt-linux-64 : run_rdfa_targeted_tests_64 *** SKIPPING opt-linux-64 : run_dis_section_test_64 *** SKIPPING opt-linux-64 : run_spec_val_test_64 *** SKIPPING opt-linux-64 : run_nacl_file_lock_all_test *** SKIPPING opt-linux-64 : run_nacl_file_lock_any_test *** SKIPPING opt-linux-64 : run_nacl_file_lock_t3f2_test *** SKIPPING opt-linux-64 : run_nacl_file_lock_t3f3_test *** SKIPPING opt-linux-64 : run_nacl_file_lock_all_real_test *** SKIPPING opt-linux-64 : run_nacl_file_lock_any_real_test *** SKIPPING opt-linux-64 : run_nacl_file_lock_t3f2_real_test *** SKIPPING opt-linux-64 : run_nacl_file_lock_t3f3_real_test *** SKIPPING opt-linux-64 : run_trusted_performance_test *** SKIPPING opt-linux-64 : run_python_version_test *** SKIPPING opt-linux-64 : run_seccomp_open_errno_test *** SKIPPING opt-linux-64 : run_seccomp_check_arch_test *** SKIPPING opt-linux-64 : run_tool_tests *** SKIPPING opt-linux-64 : run_nacl_close_test *** SKIPPING opt-linux-64 : run_double_nacl_close_test *** SKIPPING opt-linux-64 : run_nacl_create_memory_object_test *** SKIPPING opt-linux-64 : run_nacl_thread_create_joinable_test *** SKIPPING opt-linux-64 : run_atomic_ops_test *** SKIPPING opt-linux-64 : run_bits_test *** SKIPPING opt-linux-64 : run_kernel_version_test *** SKIPPING opt-linux-64 : run_nacl_memory_test *** SKIPPING opt-linux-64 : run_toolchain_python_tests *** SKIPPING nacl_irt-64 : run_irt_thread_test There are 13 broken tests. ====================================================================== B U I L D - O U T P U T: ====================================================================== scons: done reading SConscript files. scons: Building targets ... /usr/bin/python /b/s/w/ir/kitchen-workdir/native_client/tools/command_tester.py --name nacl_newlib.run_signal_handler_single_step_test --time_warning 2 --time_error 20 --perf_env_description x86-64_nnacl_newlib_static --subarch 64 --arch x86 --capture_output 0 --output_stamp /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl-x86-64/test_results/signal_handler_single_step.out /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl-x86-64/obj/tests/signal_handler_single_step/step_test_host /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl-x86-64/obj/tests/signal_handler_single_step/step_test_guest.nexe x86-64_nnacl_newlib_static [ RUN ] nacl_newlib.run_signal_handler_single_step_test /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl-x86-64/obj/tests/signal_handler_single_step/step_test_host /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl-x86-64/obj/tests/signal_handler_single_step/step_test_guest.nexe x86-64_nnacl_newlib_static [1597,2602760064:19:14:36.090512] Native Client module will be loaded at base address 0x00004cc300000000 Switching to untrusted: since previous switch: 137 instructions, 464 instruction bytes, 20 jumps Switching to trusted: since previous switch: 11 instructions, 48 instruction bytes, 2 jumps Switching to untrusted: since previous switch: 173 instructions, 584 instruction bytes, 16 jumps Switching to trusted: since previous switch: 9 instructions, 32 instruction bytes, 3 jumps Switching to untrusted: since previous switch: 173 instructions, 584 instruction bytes, 16 jumps Switching to trusted: since previous switch: 9 instructions, 32 instruction bytes, 3 jumps Switching to untrusted: since previous switch: 173 instructions, 584 instruction bytes, 16 jumps Switching to trusted: since previous switch: 9 instructions, 32 instruction bytes, 3 jumps Switching to untrusted: since previous switch: 173 instructions, 584 instruction bytes, 16 jumps RESULT InstructionsPerSyscall: x86-64_nnacl_newlib_static= 173 count RESULT InstructionBytesPerSyscall: x86-64_nnacl_newlib_static= 584 count RESULT JumpsPerSyscall: x86-64_nnacl_newlib_static= 16 count Switching to trusted: since previous switch: 9 instructions, 32 instruction bytes, 3 jumps [ OK ] nacl_newlib.run_signal_handler_single_step_test (0 ms) /usr/bin/python tools/command_tester.py --name nacl_newlib.run_benchmark_test --time_warning 10 --time_error 100 --perf_env_description x86-64_nnacl_newlib_static --using_nacl_signal_handler True --subarch 64 --arch x86 --capture_output 0 --output_stamp /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl-x86-64/test_results/benchmark_test.out scons-out/opt-linux-x86-64/staging/nacl_helper_bootstrap scons-out/opt-linux-x86-64/staging/sel_ldr --r_debug=0xXXXXXXXXXXXXXXXX --reserved_at_zero=0xXXXXXXXXXXXXXXXX -- scons-out/nacl-x86-64/obj/tests/benchmark/benchmark_test.nexe x86-64_nnacl_newlib_static [ RUN ] nacl_newlib.run_benchmark_test scons-out/opt-linux-x86-64/staging/nacl_helper_bootstrap scons-out/opt-linux-x86-64/staging/sel_ldr --r_debug=0xXXXXXXXXXXXXXXXX --reserved_at_zero=0xXXXXXXXXXXXXXXXX -- scons-out/nacl-x86-64/obj/tests/benchmark/benchmark_test.nexe x86-64_nnacl_newlib_static [1602,3864139648:19:14:36.316904] Native Client module will be loaded at base address 0x00004bc300000000 Running suite of 1 benchmarks: Running Benchmark: Life (SIMD version)... RESULT BenchmarkLife: x86-64_nnacl_newlib_static= {0.072280, 0.003280} seconds --------------------------------------------------------------- Done running benchmark suite. [ OK ] nacl_newlib.run_benchmark_test (1890 ms) /usr/bin/python tools/command_tester.py --name nacl_newlib.run_clock_cputime_test --time_warning 60 --time_error 600 --perf_env_description x86-64_nnacl_newlib_static --using_nacl_signal_handler True --subarch 64 --arch x86 --output_stamp /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl-x86-64/test_results/clock_cputime_test.out scons-out/opt-linux-x86-64/staging/nacl_helper_bootstrap scons-out/opt-linux-x86-64/staging/sel_ldr --r_debug=0xXXXXXXXXXXXXXXXX --reserved_at_zero=0xXXXXXXXXXXXXXXXX -- scons-out/nacl-x86-64/obj/tests/clock/clock_test.nexe -c [ RUN ] nacl_newlib.run_clock_cputime_test scons-out/opt-linux-x86-64/staging/nacl_helper_bootstrap scons-out/opt-linux-x86-64/staging/sel_ldr --r_debug=0xXXXXXXXXXXXXXXXX --reserved_at_zero=0xXXXXXXXXXXXXXXXX -- scons-out/nacl-x86-64/obj/tests/clock/clock_test.nexe -c WARNING: should have taken less than 60.000000 secs [ OK ] nacl_newlib.run_clock_cputime_test (70940 ms) doSizeCheck(["scons-out/nacl-x86-64/obj/tests/hello_world/hello_world_size.out"], ["scons-out/nacl-x86-64/obj/tests/hello_world/hello_world.nexe"]) RESULT hello_world_size.out: x86-64_nnacl_newlib_static= 525.291 KB RESULT hello_world_size.out: ZIPPED_x86-64_nnacl_newlib_static= 187.863 KB /usr/bin/python tools/command_tester.py --name nacl_newlib.run_performance_test --time_warning 10 --time_error 100 --perf_env_description x86-64_nnacl_newlib_static --using_nacl_signal_handler True --subarch 64 --arch x86 --capture_output 0 --output_stamp /b/s/w/ir/kitchen-workdir/native_client/scons-out/nacl-x86-64/test_results/performance_test.out scons-out/opt-linux-x86-64/staging/nacl_helper_bootstrap scons-out/opt-linux-x86-64/staging/sel_ldr --r_debug=0xXXXXXXXXXXXXXXXX --reserved_at_zero=0xXXXXXXXXXXXXXXXX -e -- scons-out/nacl-x86-64/obj/tests/performance/performance_test.nexe x86-64_nnacl_newlib_static [ RUN ] nacl_newlib.run_performance_test scons-out/opt-linux-x86-64/staging/nacl_helper_bootstrap scons-out/opt-linux-x86-64/staging/sel_ldr --r_debug=0xXXXXXXXXXXXXXXXX --reserved_at_zero=0xXXXXXXXXXXXXXXXX -e -- scons-out/nacl-x86-64/obj/tests/performance/performance_test.nexe x86-64_nnacl_newlib_static [1638,568379264:19:14:51.299915] Native Client module will be loaded at base address 0x0000103300000000 TestNull: Measuring real time: 0.005 usec (5.47e-09 sec) per iteration: 5.47e-07 sec for 100 iterations 0.002 usec (2.052e-09 sec) per iteration: 2.052e-06 sec for 1000 iterations 0.002 usec (1.8765e-09 sec) per iteration: 1.8765e-05 sec for 10000 iterations 0.002 usec (1.88426e-09 sec) per iteration: 0.100414 sec for 53290700 iterations 0.002 usec (1.888e-09 sec) per iteration: 0.100613 sec for 53290700 iterations 0.002 usec (1.87852e-09 sec) per iteration: 0.100108 sec for 53290700 iterations 0.002 usec (1.87745e-09 sec) per iteration: 0.10005 sec for 53290700 iterations 0.002 usec (1.88154e-09 sec) per iteration: 0.100268 sec for 53290700 iterations mean: 0.001882 usec stddev: 0.000004 usec relative stddev: 0.20% RESULT TestNull: x86-64_nnacl_newlib_static= {0.001882, 0.000004} us Measuring clock cycles: first runs (cycles): 94 26 25 29 20 24 24 50 49 24 ... slowest runs (cycles): ... 27 27 27 27 29 29 29 49 50 94 min: 20 cycles q1: 24 cycles median: 26 cycles q3: 26 cycles max: 94 cycles RESULT TestNull_CycleCount: x86-64_nnacl_newlib_static= {26, 2} count Apparent clock speed: 13815 MHz TestNaClSyscall: Measuring real time: 0.138 usec (1.3811e-07 sec) per iteration: 1.3811e-05 sec for 100 iterations 0.131 usec (1.31367e-07 sec) per iteration: 0.0951174 sec for 724060 iterations 0.119 usec (1.1855e-07 sec) per iteration: 0.0858371 sec for 724060 iterations 0.121 usec (1.21107e-07 sec) per iteration: 0.0876884 sec for 724060 iterations 0.121 usec (1.21347e-07 sec) per iteration: 0.0878622 sec for 724060 iterations 0.124 usec (1.23522e-07 sec) per iteration: 0.0894375 sec for 724060 iterations mean: 0.123178 usec stddev: 0.004387 usec relative stddev: 3.56% RESULT TestNaClSyscall: x86-64_nnacl_newlib_static= {0.123178, 0.004387} us Measuring clock cycles: first runs (cycles): 312 196 174 173 174 176 171 172 173 176 ... slowest runs (cycles): ... 176 176 176 176 176 176 176 196 207 312 min: 169 cycles q1: 172 cycles median: 174 cycles q3: 174 cycles max: 312 cycles RESULT TestNaClSyscall_CycleCount: x86-64_nnacl_newlib_static= {174, 2} count Apparent clock speed: 1413 MHz TestSetjmpLongjmp: Measuring real time: 0.015 usec (1.54e-08 sec) per iteration: 1.54e-06 sec for 100 iterations 0.013 usec (1.2776e-08 sec) per iteration: 1.2776e-05 sec for 1000 iterations 0.013 usec (1.28558e-08 sec) per iteration: 0.100625 sec for 7827175 iterations 0.013 usec (1.27779e-08 sec) per iteration: 0.100015 sec for 7827175 iterations 0.013 usec (1.29174e-08 sec) per iteration: 0.101107 sec for 7827175 iterations 0.013 usec (1.29134e-08 sec) per iteration: 0.101075 sec for 7827175 iterations 0.013 usec (1.28583e-08 sec) per iteration: 0.100644 sec for 7827175 iterations mean: 0.012865 usec stddev: 0.000051 usec relative stddev: 0.39% RESULT TestSetjmpLongjmp: x86-64_nnacl_newlib_static= {0.012865, 0.000051} us Measuring clock cycles: first runs (cycles): 220 60 41 33 33 31 29 29 28 31 ... slowest runs (cycles): ... 31 31 31 31 31 33 33 41 60 220 min: 24 cycles q1: 26 cycles median: 27 cycles q3: 29 cycles max: 220 cycles RESULT TestSetjmpLongjmp_CycleCount: x86-64_nnacl_newlib_static= {27, 3} count Apparent clock speed: 2099 MHz TestClockGetTime: Measuring real time: 0.144 usec (1.4397e-07 sec) per iteration: 1.4397e-05 sec for 100 iterations 0.154 usec (1.54472e-07 sec) per iteration: 0.107294 sec for 694589 iterations 0.153 usec (1.52716e-07 sec) per iteration: 0.106075 sec for 694589 iterations 0.151 usec (1.51341e-07 sec) per iteration: 0.10512 sec for 694589 iterations 0.151 usec (1.50508e-07 sec) per iteration: 0.104541 sec for 694589 iterations 0.150 usec (1.50021e-07 sec) per iteration: 0.104203 sec for 694589 iterations mean: 0.151812 usec stddev: 0.001614 usec relative stddev: 1.06% RESULT TestClockGetTime: x86-64_nnacl_newlib_static= {0.151812, 0.001614} us Measuring clock cycles: first runs (cycles): 657 411 411 404 409 401 401 401 398 402 ... slowest runs (cycles): ... 405 405 405 407 407 407 409 411 411 657 min: 395 cycles q1: 398 cycles median: 401 cycles q3: 403 cycles max: 657 cycles RESULT TestClockGetTime_CycleCount: x86-64_nnacl_newlib_static= {401, 5} count Apparent clock speed: 2641 MHz TestTlsVariable: Measuring real time: 0.027 usec (2.69e-08 sec) per iteration: 2.69e-06 sec for 100 iterations 0.023 usec (2.3394e-08 sec) per iteration: 2.3394e-05 sec for 1000 iterations 0.006 usec (5.71511e-09 sec) per iteration: 0.0244298 sec for 4274600 iterations 0.006 usec (5.78277e-09 sec) per iteration: 0.024719 sec for 4274600 iterations 0.006 usec (5.67502e-09 sec) per iteration: 0.0242584 sec for 4274600 iterations 0.006 usec (5.64722e-09 sec) per iteration: 0.0241396 sec for 4274600 iterations 0.006 usec (5.64398e-09 sec) per iteration: 0.0241257 sec for 4274600 iterations mean: 0.005693 usec stddev: 0.000052 usec relative stddev: 0.91% RESULT TestTlsVariable: x86-64_nnacl_newlib_static= {0.005693, 0.000052} us Measuring clock cycles: first runs (cycles): 161 58 36 29 29 35 27 29 27 29 ... slowest runs (cycles): ... 33 33 33 33 33 33 35 36 58 161 min: 22 cycles q1: 26 cycles median: 29 cycles q3: 31 cycles max: 161 cycles RESULT TestTlsVariable_CycleCount: x86-64_nnacl_newlib_static= {29, 5} count Apparent clock speed: 5094 MHz TestMmapAnonymous: Measuring real time: 1.982 usec (1.98248e-06 sec) per iteration: 0.000198248 sec for 100 iterations 1.784 usec (1.7839e-06 sec) per iteration: 0.0899818 sec for 50441 iterations 1.773 usec (1.77307e-06 sec) per iteration: 0.0894353 sec for 50441 iterations 1.778 usec (1.77771e-06 sec) per iteration: 0.0896697 sec for 50441 iterations 1.771 usec (1.77092e-06 sec) per iteration: 0.0893272 sec for 50441 iterations 1.766 usec (1.76612e-06 sec) per iteration: 0.0890849 sec for 50441 iterations mean: 1.774345 usec stddev: 0.006061 usec relative stddev: 0.34% RESULT TestMmapAnonymous: x86-64_nnacl_newlib_static= {1.774345, 0.006061} us Measuring clock cycles: first runs (cycles): 5128 3951 3917 3857 4017 3843 3859 3896 3824 3907 ... slowest runs (cycles): ... 3900 3906 3907 3909 3917 3946 3951 3966 4017 5128 min: 3792 cycles q1: 3832 cycles median: 3845 cycles q3: 3865 cycles max: 5128 cycles RESULT TestMmapAnonymous_CycleCount: x86-64_nnacl_newlib_static= {3845, 33} count Apparent clock speed: 2167 MHz TestAtomicIncrement: Measuring real time: 0.013 usec (1.265e-08 sec) per iteration: 1.265e-06 sec for 100 iterations 0.009 usec (9.084e-09 sec) per iteration: 9.084e-06 sec for 1000 iterations 0.009 usec (8.9482e-09 sec) per iteration: 8.9482e-05 sec for 10000 iterations 0.009 usec (9.40796e-09 sec) per iteration: 0.105138 sec for 11175431 iterations 0.009 usec (9.44521e-09 sec) per iteration: 0.105554 sec for 11175431 iterations 0.010 usec (9.58279e-09 sec) per iteration: 0.107092 sec for 11175431 iterations 0.010 usec (9.65583e-09 sec) per iteration: 0.107908 sec for 11175431 iterations 0.010 usec (9.5434e-09 sec) per iteration: 0.106652 sec for 11175431 iterations mean: 0.009527 usec stddev: 0.000090 usec relative stddev: 0.95% RESULT TestAtomicIncrement: x86-64_nnacl_newlib_static= {0.009527, 0.000090} us Measuring clock cycles: first runs (cycles): 126 53 52 53 52 51 50 51 50 51 ... slowest runs (cycles): ... 53 53 53 53 53 53 53 53 53 126 min: 49 cycles q1: 51 cycles median: 53 cycles q3: 53 cycles max: 126 cycles RESULT TestAtomicIncrement_CycleCount: x86-64_nnacl_newlib_static= {53, 2} count Apparent clock speed: 5563 MHz TestUncontendedMutexLock: Measuring real time: 0.028 usec (2.769e-08 sec) per iteration: 2.769e-06 sec for 100 iterations 0.024 usec (2.427e-08 sec) per iteration: 2.427e-05 sec for 1000 iterations 0.024 usec (2.42978e-08 sec) per iteration: 0.100115 sec for 4120313 iterations 0.025 usec (2.4808e-08 sec) per iteration: 0.102217 sec for 4120313 iterations 0.025 usec (2.45105e-08 sec) per iteration: 0.100991 sec for 4120313 iterations 0.025 usec (2.45619e-08 sec) per iteration: 0.101203 sec for 4120313 iterations 0.024 usec (2.43783e-08 sec) per iteration: 0.100446 sec for 4120313 iterations mean: 0.024511 usec stddev: 0.000175 usec relative stddev: 0.72% RESULT TestUncontendedMutexLock: x86-64_nnacl_newlib_static= {0.024511, 0.000175} us Measuring clock cycles: first runs (cycles): 209 110 81 84 83 84 84 83 84 84 ... slowest runs (cycles): ... 84 84 84 84 84 84 84 84 110 209 min: 81 cycles q1: 81 cycles median: 83 cycles q3: 84 cycles max: 209 cycles RESULT TestUncontendedMutexLock_CycleCount: x86-64_nnacl_newlib_static= {83, 3} count Apparent clock speed: 3386 MHz TestCondvarSignalNoOp: Measuring real time: 0.236 usec (2.36e-07 sec) per iteration: 2.36e-05 sec for 100 iterations 0.212 usec (2.11563e-07 sec) per iteration: 0.089645 sec for 423728 iterations 0.211 usec (2.10946e-07 sec) per iteration: 0.0893837 sec for 423728 iterations 0.210 usec (2.10334e-07 sec) per iteration: 0.0891244 sec for 423728 iterations 0.213 usec (2.12666e-07 sec) per iteration: 0.0901124 sec for 423728 iterations 0.212 usec (2.11817e-07 sec) per iteration: 0.0897528 sec for 423728 iterations mean: 0.211465 usec stddev: 0.000790 usec relative stddev: 0.37% RESULT TestCondvarSignalNoOp: x86-64_nnacl_newlib_static= {0.211465, 0.000790} us Measuring clock cycles: first runs (cycles): 737 548 506 497 495 493 504 497 499 499 ... slowest runs (cycles): ... 561 574 574 579 581 605 622 642 737 910 min: 470 cycles q1: 473 cycles median: 477 cycles q3: 498 cycles max: 910 cycles RESULT TestCondvarSignalNoOp_CycleCount: x86-64_nnacl_newlib_static= {477, 25} count Apparent clock speed: 2256 MHz TestThreadCreateAndJoin: Measuring real time: 61.210 usec (6.12098e-05 sec) per iteration: 0.00612097 sec for 100 iterations 44.844 usec (4.48438e-05 sec) per iteration: 0.07323 sec for 1633 iterations 40.123 usec (4.01226e-05 sec) per iteration: 0.0655202 sec for 1633 iterations 42.511 usec (4.25108e-05 sec) per iteration: 0.0694201 sec for 1633 iterations 41.540 usec (4.15396e-05 sec) per iteration: 0.0678342 sec for 1633 iterations 25.387 usec (2.53874e-05 sec) per iteration: 0.0414576 sec for 1633 iterations mean: 38.880838 usec stddev: 6.919798 usec relative stddev: 17.80% RESULT TestThreadCreateAndJoin: x86-64_nnacl_newlib_static= {38.880838, 6.919798} us Measuring clock cycles: first runs (cycles): 49529 48879 249554 79399 152622 76366 84116 49559 50173 103754 ... slowest runs (cycles): ... 71038 73465 76366 79399 84116 103754 104427 117947 152622 249554 min: 44489 cycles q1: 48094 cycles median: 49535 cycles q3: 51827 cycles max: 249554 cycles RESULT TestThreadCreateAndJoin_CycleCount: x86-64_nnacl_newlib_static= {49535, 3733} count Apparent clock speed: 1274 MHz TestThreadWakeup: Measuring real time: 12.361 usec (1.23613e-05 sec) per iteration: 0.00123613 sec for 100 iterations 14.222 usec (1.42221e-05 sec) per iteration: 0.115043 sec for 8089 iterations 15.395 usec (1.53951e-05 sec) per iteration: 0.124531 sec for 8089 iterations 15.329 usec (1.53287e-05 sec) per iteration: 0.123994 sec for 8089 iterations 15.112 usec (1.5112e-05 sec) per iteration: 0.122241 sec for 8089 iterations 14.859 usec (1.4859e-05 sec) per iteration: 0.120194 sec for 8089 iterations mean: 14.983377 usec stddev: 0.424326 usec relative stddev: 2.83% RESULT TestThreadWakeup: x86-64_nnacl_newlib_static= {14.983377, 0.424326} us Measuring clock cycles: first runs (cycles): 34876 32839 38433 32771 34055 26817 33433 33510 33142 33292 ... slowest runs (cycles): ... 34876 34986 35360 35414 36101 36341 38433 39183 39319 44539 min: 26817 cycles q1: 32684 cycles median: 33091 cycles q3: 33464 cycles max: 44539 cycles RESULT TestThreadWakeup_CycleCount: x86-64_nnacl_newlib_static= {33091, 780} count Apparent clock speed: 2209 MHz TestCatchingFault: Measuring real time: 2.970 usec (2.97048e-06 sec) per iteration: 0.000297048 sec for 100 iterations 1.724 usec (1.72425e-06 sec) per iteration: 0.058045 sec for 33664 iterations 1.725 usec (1.72497e-06 sec) per iteration: 0.0580693 sec for 33664 iterations 1.727 usec (1.72678e-06 sec) per iteration: 0.0581304 sec for 33664 iterations 1.739 usec (1.739e-06 sec) per iteration: 0.0585416 sec for 33664 iterations 1.732 usec (1.73176e-06 sec) per iteration: 0.0582978 sec for 33664 iterations mean: 1.729350 usec stddev: 0.005490 usec relative stddev: 0.32% RESULT TestCatchingFault: x86-64_nnacl_newlib_static= {1.729350, 0.005490} us Measuring clock cycles: first runs (cycles): 4371 3825 3771 3786 3759 3758 3763 3763 3760 3758 ... slowest runs (cycles): ... 3786 3790 3803 3825 3911 3981 4250 4298 4371 4728 min: 3736 cycles q1: 3753 cycles median: 3759 cycles q3: 3764 cycles max: 4728 cycles RESULT TestCatchingFault_CycleCount: x86-64_nnacl_newlib_static= {3759, 11} count Apparent clock speed: 2174 MHz TestThreadCreateAndJoinAfterSettingFaultHandler: Measuring real time: 32.419 usec (3.24191e-05 sec) per iteration: 0.00324191 sec for 100 iterations 26.711 usec (2.67105e-05 sec) per iteration: 0.0823752 sec for 3084 iterations 25.760 usec (2.57602e-05 sec) per iteration: 0.0794444 sec for 3084 iterations 31.418 usec (3.14176e-05 sec) per iteration: 0.0968917 sec for 3084 iterations 36.188 usec (3.61877e-05 sec) per iteration: 0.111603 sec for 3084 iterations 40.378 usec (4.03779e-05 sec) per iteration: 0.124525 sec for 3084 iterations mean: 32.090759 usec stddev: 5.566639 usec relative stddev: 17.35% RESULT TestThreadCreateAndJoinAfterSettingFaultHandler: x86-64_nnacl_newlib_static= {32.090759, 5.566639} us Measuring clock cycles: first runs (cycles): 78528 55329 106010 46033 48372 100630 55741 51335 49936 44154 ... slowest runs (cycles): ... 117284 118404 122927 129025 145994 152239 172678 178448 276785 410942 min: 35386 cycles q1: 49936 cycles median: 51885 cycles q3: 71615 cycles max: 410942 cycles RESULT TestThreadCreateAndJoinAfterSettingFaultHandler_CycleCount: x86-64_nnacl_newlib_static= {51885, 21679} count Apparent clock speed: 1617 MHz [ OK ] nacl_newlib.run_performance_test (6050 ms) scons: done building targets. ********************************************************************** COMMAND EXECUTION REPORT ********************************************************************** 4 command_tester.py 1 doSizeCheck 3 gcc 1 set ********************************************************************** ENVIRONMENT USAGE REPORT ********************************************************************** 5 nacl-x86-64 4 opt-linux-x86-64 Command return code: 0