builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0246 starttime: 1473184873.27 results: success (0) buildid: 20160906073854 builduid: ad376272eeb3486192bcb9f87449fb8a revision: 37c9349b4e8167a61b08b7e119c21ea177b98942 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-06 11:01:13.272588) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-06 11:01:13.273150) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-06 11:01:13.273441) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-06 11:01:13.403528) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 11:01:13.403919) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2GMTe5weG5/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-06 11:01:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.1M=0.001s 2016-09-06 11:01:13 (19.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.462536 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 11:01:13.896731) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 11:01:13.897914) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2GMTe5weG5/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.029740 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 11:01:13.957240) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-06 11:01:13.957715) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 37c9349b4e8167a61b08b7e119c21ea177b98942 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 37c9349b4e8167a61b08b7e119c21ea177b98942 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2GMTe5weG5/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-06 11:01:14,039 truncating revision to first 12 chars 2016-09-06 11:01:14,039 Setting DEBUG logging. 2016-09-06 11:01:14,040 attempt 1/10 2016-09-06 11:01:14,040 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/37c9349b4e81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-06 11:01:14,762 unpacking tar archive at: fx-team-37c9349b4e81/testing/mozharness/ program finished with exit code 0 elapsedTime=0.981167 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-06 11:01:15.141670) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-06 11:01:15.141939) ========= script_repo_revision: 37c9349b4e8167a61b08b7e119c21ea177b98942 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-06 11:01:15.142327) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-06 11:01:15.142588) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-06 11:01:15.193080) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-09-06 11:01:15.193363) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2GMTe5weG5/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 11:01:15 INFO - MultiFileLogger online at 20160906 11:01:15 in /builds/slave/test 11:01:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:01:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:01:15 INFO - {'append_to_log': False, 11:01:15 INFO - 'base_work_dir': '/builds/slave/test', 11:01:15 INFO - 'blob_upload_branch': 'Fx-Team', 11:01:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:01:15 INFO - 'branch': 'Fx-Team', 11:01:15 INFO - 'buildbot_json_path': 'buildprops.json', 11:01:15 INFO - 'config_files': ('talos/mac_config.py',), 11:01:15 INFO - 'default_actions': ('clobber', 11:01:15 INFO - 'read-buildbot-config', 11:01:15 INFO - 'download-and-extract', 11:01:15 INFO - 'populate-webroot', 11:01:15 INFO - 'create-virtualenv', 11:01:15 INFO - 'install', 11:01:15 INFO - 'run-tests'), 11:01:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:01:15 INFO - 'download_minidump_stackwalk': True, 11:01:15 INFO - 'download_symbols': 'ondemand', 11:01:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:01:15 INFO - 'tooltool.py': '/tools/tooltool.py', 11:01:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:01:15 INFO - '/tools/misc-python/virtualenv.py')}, 11:01:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:01:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:01:15 INFO - 'installer_path': 'installer.exe', 11:01:15 INFO - 'log_level': 'info', 11:01:15 INFO - 'log_name': 'talos', 11:01:15 INFO - 'log_to_console': True, 11:01:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:01:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:01:15 INFO - 'opt_config_files': (), 11:01:15 INFO - 'pip_index': False, 11:01:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:01:15 INFO - 'cmd': ('bash', 11:01:15 INFO - '-c', 11:01:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:01:15 INFO - 'enabled': True, 11:01:15 INFO - 'halt_on_failure': False, 11:01:15 INFO - 'name': 'check_screen_resolution'},), 11:01:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:01:15 INFO - 'cmd': ('bash', 11:01:15 INFO - '-c', 11:01:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:01:15 INFO - 'enabled': True, 11:01:15 INFO - 'halt_on_failure': False, 11:01:15 INFO - 'name': 'check_screen_resolution'},), 11:01:15 INFO - 'run_cmd_checks_enabled': True, 11:01:15 INFO - 'sps_profile': False, 11:01:15 INFO - 'sps_profile_interval': 0, 11:01:15 INFO - 'suite': 'dromaeojs', 11:01:15 INFO - 'system_bits': '32', 11:01:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:01:15 INFO - 'title': 't-yosemite-r7-0246', 11:01:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:01:15 INFO - 'use_talos_json': True, 11:01:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:01:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:01:15 INFO - 'work_dir': 'build'} 11:01:15 INFO - [mozharness: 2016-09-06 18:01:15.397849Z] Running clobber step. 11:01:15 INFO - Running pre-action listener: _resource_record_pre_action 11:01:15 INFO - Running main action method: clobber 11:01:15 INFO - rmtree: /builds/slave/test/build 11:01:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:01:17 INFO - Running post-action listener: _resource_record_post_action 11:01:17 INFO - [mozharness: 2016-09-06 18:01:17.527254Z] Finished clobber step (success) 11:01:17 INFO - [mozharness: 2016-09-06 18:01:17.527667Z] Running read-buildbot-config step. 11:01:17 INFO - Running pre-action listener: _resource_record_pre_action 11:01:17 INFO - Running main action method: read_buildbot_config 11:01:17 INFO - Using buildbot properties: 11:01:17 INFO - { 11:01:17 INFO - "project": "", 11:01:17 INFO - "product": "firefox", 11:01:17 INFO - "script_repo_revision": "production", 11:01:17 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 11:01:17 INFO - "repository": "", 11:01:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 11:01:17 INFO - "buildid": "20160906073854", 11:01:17 INFO - "pgo_build": "False", 11:01:17 INFO - "basedir": "/builds/slave/test", 11:01:17 INFO - "buildnumber": 829, 11:01:17 INFO - "slavename": "t-yosemite-r7-0246", 11:01:17 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:01:17 INFO - "platform": "yosemite_r7", 11:01:17 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:01:17 INFO - "branch": "fx-team", 11:01:17 INFO - "repo_path": "integration/fx-team", 11:01:17 INFO - "revision": "37c9349b4e8167a61b08b7e119c21ea177b98942", 11:01:17 INFO - "stage_platform": "macosx64", 11:01:17 INFO - "builduid": "ad376272eeb3486192bcb9f87449fb8a", 11:01:17 INFO - "slavebuilddir": "test" 11:01:17 INFO - } 11:01:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/Lv7yCflATWaf6nS5Qd2uwA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 11:01:17 INFO - Running post-action listener: _resource_record_post_action 11:01:17 INFO - [mozharness: 2016-09-06 18:01:17.533832Z] Finished read-buildbot-config step (success) 11:01:17 INFO - [mozharness: 2016-09-06 18:01:17.534093Z] Running download-and-extract step. 11:01:17 INFO - Running pre-action listener: _resource_record_pre_action 11:01:17 INFO - Running main action method: download_and_extract 11:01:17 INFO - mkdir: /builds/slave/test/build/tests 11:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:17 INFO - trying https://queue.taskcluster.net/v1/task/Lv7yCflATWaf6nS5Qd2uwA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 11:01:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Lv7yCflATWaf6nS5Qd2uwA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:01:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lv7yCflATWaf6nS5Qd2uwA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 11:01:18 INFO - Downloaded 1199 bytes. 11:01:18 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:01:18 INFO - Using the following test package requirements: 11:01:18 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:01:18 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:01:18 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 11:01:18 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:01:18 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 11:01:18 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:01:18 INFO - u'jsshell-mac.zip'], 11:01:18 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:01:18 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 11:01:18 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:01:18 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:01:18 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 11:01:18 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:01:18 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 11:01:18 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:01:18 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 11:01:18 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:01:18 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 11:01:18 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:01:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Lv7yCflATWaf6nS5Qd2uwA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:01:18 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 11:01:26 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:01:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Lv7yCflATWaf6nS5Qd2uwA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:01:26 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 11:01:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Lv7yCflATWaf6nS5Qd2uwA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 11:01:33 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 11:01:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:35 INFO - trying https://queue.taskcluster.net/v1/task/Lv7yCflATWaf6nS5Qd2uwA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:01:35 INFO - Downloading https://queue.taskcluster.net/v1/task/Lv7yCflATWaf6nS5Qd2uwA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 11:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lv7yCflATWaf6nS5Qd2uwA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 11:01:38 INFO - Downloaded 111492158 bytes. 11:01:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Lv7yCflATWaf6nS5Qd2uwA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:01:38 INFO - mkdir: /builds/slave/test/properties 11:01:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:01:38 INFO - Writing to file /builds/slave/test/properties/build_url 11:01:38 INFO - Contents: 11:01:38 INFO - build_url:https://queue.taskcluster.net/v1/task/Lv7yCflATWaf6nS5Qd2uwA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:01:39 INFO - Running post-action listener: _resource_record_post_action 11:01:39 INFO - Running post-action listener: set_extra_try_arguments 11:01:39 INFO - [mozharness: 2016-09-06 18:01:39.570448Z] Finished download-and-extract step (success) 11:01:39 INFO - [mozharness: 2016-09-06 18:01:39.570576Z] Running populate-webroot step. 11:01:39 INFO - Running pre-action listener: _resource_record_pre_action 11:01:39 INFO - Running main action method: populate_webroot 11:01:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:01:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:01:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:01:39 INFO - '--tppagecycles', 11:01:39 INFO - '7'], 11:01:39 INFO - 'tests': ['tsvgm']}}, 11:01:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:01:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:01:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:01:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:01:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:01:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:01:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:39 INFO - 'talos_options': ['--disable-e10s'], 11:01:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:01:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:01:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:39 INFO - 'talos_options': ['--disable-e10s'], 11:01:39 INFO - 'tests': ['damp', 'tps']}, 11:01:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:39 INFO - 'tests': ['damp', 'tps']}, 11:01:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:01:39 INFO - 'tests': ['dromaeo_dom']}, 11:01:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:01:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:01:39 INFO - 'tests': ['basic_compositor_video']}, 11:01:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:01:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:01:39 INFO - 'tests': ['a11yr', 11:01:39 INFO - 'ts_paint', 11:01:39 INFO - 'tpaint', 11:01:39 INFO - 'sessionrestore', 11:01:39 INFO - 'sessionrestore_no_auto_restore', 11:01:39 INFO - 'tabpaint']}, 11:01:39 INFO - 'other-e10s': {'tests': ['a11yr', 11:01:39 INFO - 'ts_paint', 11:01:39 INFO - 'tpaint', 11:01:39 INFO - 'sessionrestore', 11:01:39 INFO - 'sessionrestore_no_auto_restore', 11:01:39 INFO - 'tabpaint']}, 11:01:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:01:39 INFO - 'ts_paint', 11:01:39 INFO - 'tpaint', 11:01:39 INFO - 'sessionrestore', 11:01:39 INFO - 'sessionrestore_no_auto_restore', 11:01:39 INFO - 'tabpaint']}, 11:01:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:01:39 INFO - 'ts_paint', 11:01:39 INFO - 'tpaint', 11:01:39 INFO - 'sessionrestore', 11:01:39 INFO - 'sessionrestore_no_auto_restore', 11:01:39 INFO - 'tabpaint']}, 11:01:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:01:39 INFO - 'tests': ['a11yr', 11:01:39 INFO - 'ts_paint', 11:01:39 INFO - 'tpaint', 11:01:39 INFO - 'sessionrestore', 11:01:39 INFO - 'sessionrestore_no_auto_restore', 11:01:39 INFO - 'tabpaint']}, 11:01:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:01:39 INFO - 'tests': ['a11yr', 11:01:39 INFO - 'ts_paint', 11:01:39 INFO - 'tpaint', 11:01:39 INFO - 'sessionrestore', 11:01:39 INFO - 'sessionrestore_no_auto_restore', 11:01:39 INFO - 'tabpaint']}, 11:01:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:01:39 INFO - 'tests': ['tsvgx', 11:01:39 INFO - 'tsvgr_opacity', 11:01:39 INFO - 'tart', 11:01:39 INFO - 'tscrollx', 11:01:39 INFO - 'cart']}, 11:01:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:01:39 INFO - 'tsvgr_opacity', 11:01:39 INFO - 'tart', 11:01:39 INFO - 'tscrollx', 11:01:39 INFO - 'cart']}, 11:01:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:39 INFO - 'talos_options': ['--disable-e10s'], 11:01:39 INFO - 'tests': ['tp5o']}, 11:01:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:39 INFO - 'tests': ['tp5o']}, 11:01:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:39 INFO - 'talos_options': ['--disable-e10s', 11:01:39 INFO - '--xperf_path', 11:01:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:01:39 INFO - 'tests': ['tp5n']}, 11:01:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:39 INFO - 'talos_options': ['--xperf_path', 11:01:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:01:39 INFO - 'tests': ['tp5n']}}, 11:01:39 INFO - 'talos.zip': {'path': '', 11:01:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:01:39 INFO - Running post-action listener: _resource_record_post_action 11:01:39 INFO - [mozharness: 2016-09-06 18:01:39.589927Z] Finished populate-webroot step (success) 11:01:39 INFO - [mozharness: 2016-09-06 18:01:39.590033Z] Running create-virtualenv step. 11:01:39 INFO - Running pre-action listener: _resource_record_pre_action 11:01:39 INFO - Running main action method: create_virtualenv 11:01:39 INFO - Creating virtualenv /builds/slave/test/build/venv 11:01:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:01:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:01:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:01:39 INFO - Using real prefix '/tools/python27' 11:01:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:01:40 INFO - Installing distribute.............................................................................................................................................................................................done. 11:01:43 INFO - Installing pip.................done. 11:01:43 INFO - Return code: 0 11:01:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1c1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e256618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f965adb6e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e125d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de8adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2GMTe5weG5/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:01:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:01:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:01:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2GMTe5weG5/Render', 11:01:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:01:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:01:43 INFO - 'HOME': '/Users/cltbld', 11:01:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:01:43 INFO - 'LOGNAME': 'cltbld', 11:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:43 INFO - 'MOZ_NO_REMOTE': '1', 11:01:43 INFO - 'NO_EM_RESTART': '1', 11:01:43 INFO - 'PAGER': '/bin/cat', 11:01:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:43 INFO - 'PWD': '/builds/slave/test', 11:01:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:01:43 INFO - 'SHELL': '/bin/bash', 11:01:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners', 11:01:43 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 11:01:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:01:43 INFO - 'USER': 'cltbld', 11:01:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:01:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:43 INFO - 'XPC_FLAGS': '0x0', 11:01:43 INFO - 'XPC_SERVICE_NAME': '0', 11:01:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:01:43 INFO - Cleaning up... 11:01:43 INFO - Return code: 0 11:01:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1c1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e256618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f965adb6e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e125d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de8adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2GMTe5weG5/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:01:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:01:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:01:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2GMTe5weG5/Render', 11:01:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:01:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:01:43 INFO - 'HOME': '/Users/cltbld', 11:01:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:01:43 INFO - 'LOGNAME': 'cltbld', 11:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:43 INFO - 'MOZ_NO_REMOTE': '1', 11:01:43 INFO - 'NO_EM_RESTART': '1', 11:01:43 INFO - 'PAGER': '/bin/cat', 11:01:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:43 INFO - 'PWD': '/builds/slave/test', 11:01:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:01:43 INFO - 'SHELL': '/bin/bash', 11:01:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners', 11:01:43 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 11:01:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:01:43 INFO - 'USER': 'cltbld', 11:01:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:01:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:43 INFO - 'XPC_FLAGS': '0x0', 11:01:43 INFO - 'XPC_SERVICE_NAME': '0', 11:01:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:43 INFO - Downloading/unpacking psutil>=3.1.1 11:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:01:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:01:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:01:47 INFO - Installing collected packages: psutil 11:01:47 INFO - Running setup.py install for psutil 11:01:47 INFO - building 'psutil._psutil_osx' extension 11:01:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:01:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:01:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:01:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 11:01:48 INFO - building 'psutil._psutil_posix' extension 11:01:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 11:01:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:01:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:01:48 INFO - ^ 11:01:48 INFO - 1 warning generated. 11:01:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 11:01:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:01:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:01:48 INFO - Successfully installed psutil 11:01:48 INFO - Cleaning up... 11:01:48 INFO - Return code: 0 11:01:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1c1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e256618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f965adb6e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e125d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de8adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2GMTe5weG5/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:01:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:01:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:01:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2GMTe5weG5/Render', 11:01:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:01:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:01:48 INFO - 'HOME': '/Users/cltbld', 11:01:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:01:48 INFO - 'LOGNAME': 'cltbld', 11:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:48 INFO - 'MOZ_NO_REMOTE': '1', 11:01:48 INFO - 'NO_EM_RESTART': '1', 11:01:48 INFO - 'PAGER': '/bin/cat', 11:01:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:48 INFO - 'PWD': '/builds/slave/test', 11:01:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:01:48 INFO - 'SHELL': '/bin/bash', 11:01:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners', 11:01:48 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 11:01:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:01:48 INFO - 'USER': 'cltbld', 11:01:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:01:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:48 INFO - 'XPC_FLAGS': '0x0', 11:01:48 INFO - 'XPC_SERVICE_NAME': '0', 11:01:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:01:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:01:51 INFO - Installing collected packages: mozsystemmonitor 11:01:51 INFO - Running setup.py install for mozsystemmonitor 11:01:51 INFO - Successfully installed mozsystemmonitor 11:01:51 INFO - Cleaning up... 11:01:51 INFO - Return code: 0 11:01:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1c1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e256618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f965adb6e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e125d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de8adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2GMTe5weG5/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:01:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:01:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:01:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2GMTe5weG5/Render', 11:01:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:01:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:01:51 INFO - 'HOME': '/Users/cltbld', 11:01:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:01:51 INFO - 'LOGNAME': 'cltbld', 11:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:51 INFO - 'MOZ_NO_REMOTE': '1', 11:01:51 INFO - 'NO_EM_RESTART': '1', 11:01:51 INFO - 'PAGER': '/bin/cat', 11:01:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:51 INFO - 'PWD': '/builds/slave/test', 11:01:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:01:51 INFO - 'SHELL': '/bin/bash', 11:01:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners', 11:01:51 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 11:01:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:01:51 INFO - 'USER': 'cltbld', 11:01:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:01:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:51 INFO - 'XPC_FLAGS': '0x0', 11:01:51 INFO - 'XPC_SERVICE_NAME': '0', 11:01:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:51 INFO - Downloading/unpacking jsonschema==2.5.1 11:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:01:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:54 INFO - Downloading functools32-3.2.3-2.tar.gz 11:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:01:54 INFO - warning: no files found matching '*.txt' 11:01:54 INFO - no previously-included directories found matching 'build' 11:01:54 INFO - no previously-included directories found matching 'dist' 11:01:54 INFO - no previously-included directories found matching '.git*' 11:01:54 INFO - Installing collected packages: jsonschema, functools32 11:01:54 INFO - Running setup.py install for functools32 11:01:54 INFO - warning: no files found matching '*.txt' 11:01:54 INFO - no previously-included directories found matching 'build' 11:01:54 INFO - no previously-included directories found matching 'dist' 11:01:54 INFO - no previously-included directories found matching '.git*' 11:01:54 INFO - Successfully installed jsonschema functools32 11:01:54 INFO - Cleaning up... 11:01:54 INFO - Return code: 0 11:01:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1c1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e256618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f965adb6e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e125d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de8adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2GMTe5weG5/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:01:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:01:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:01:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2GMTe5weG5/Render', 11:01:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:01:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:01:54 INFO - 'HOME': '/Users/cltbld', 11:01:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:01:54 INFO - 'LOGNAME': 'cltbld', 11:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:54 INFO - 'MOZ_NO_REMOTE': '1', 11:01:54 INFO - 'NO_EM_RESTART': '1', 11:01:54 INFO - 'PAGER': '/bin/cat', 11:01:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:54 INFO - 'PWD': '/builds/slave/test', 11:01:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:01:54 INFO - 'SHELL': '/bin/bash', 11:01:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners', 11:01:54 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 11:01:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:01:54 INFO - 'USER': 'cltbld', 11:01:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:01:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:54 INFO - 'XPC_FLAGS': '0x0', 11:01:54 INFO - 'XPC_SERVICE_NAME': '0', 11:01:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:01:55 INFO - Cleaning up... 11:01:55 INFO - Return code: 0 11:01:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1c1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e256618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f965adb6e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e125d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de8adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2GMTe5weG5/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:01:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:01:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2GMTe5weG5/Render', 11:01:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:01:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:01:55 INFO - 'HOME': '/Users/cltbld', 11:01:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:01:55 INFO - 'LOGNAME': 'cltbld', 11:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:55 INFO - 'MOZ_NO_REMOTE': '1', 11:01:55 INFO - 'NO_EM_RESTART': '1', 11:01:55 INFO - 'PAGER': '/bin/cat', 11:01:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:55 INFO - 'PWD': '/builds/slave/test', 11:01:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:01:55 INFO - 'SHELL': '/bin/bash', 11:01:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners', 11:01:55 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 11:01:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:01:55 INFO - 'USER': 'cltbld', 11:01:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:01:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:55 INFO - 'XPC_FLAGS': '0x0', 11:01:55 INFO - 'XPC_SERVICE_NAME': '0', 11:01:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:55 INFO - Downloading/unpacking blobuploader==1.2.4 11:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:57 INFO - Downloading blobuploader-1.2.4.tar.gz 11:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:01:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:01:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:59 INFO - Downloading docopt-0.6.1.tar.gz 11:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:01:59 INFO - Installing collected packages: blobuploader, requests, docopt 11:01:59 INFO - Running setup.py install for blobuploader 11:01:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:01:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:01:59 INFO - Running setup.py install for requests 11:01:59 INFO - Running setup.py install for docopt 11:01:59 INFO - Successfully installed blobuploader requests docopt 11:01:59 INFO - Cleaning up... 11:02:00 INFO - Return code: 0 11:02:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1c1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e256618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f965adb6e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e125d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de8adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2GMTe5weG5/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:02:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:02:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:02:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2GMTe5weG5/Render', 11:02:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:02:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:02:00 INFO - 'HOME': '/Users/cltbld', 11:02:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:02:00 INFO - 'LOGNAME': 'cltbld', 11:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:00 INFO - 'MOZ_NO_REMOTE': '1', 11:02:00 INFO - 'NO_EM_RESTART': '1', 11:02:00 INFO - 'PAGER': '/bin/cat', 11:02:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:00 INFO - 'PWD': '/builds/slave/test', 11:02:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:02:00 INFO - 'SHELL': '/bin/bash', 11:02:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners', 11:02:00 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 11:02:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:02:00 INFO - 'USER': 'cltbld', 11:02:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:02:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:00 INFO - 'XPC_FLAGS': '0x0', 11:02:00 INFO - 'XPC_SERVICE_NAME': '0', 11:02:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:02:00 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-_4099P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:02:00 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-Yu3HhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:02:00 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-eyBPjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:02:00 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-vpZ9Z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:02:00 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-ixpdL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:02:00 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-MTl9U0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:02:00 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-iI2338-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:02:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-nL9YVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:02:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-iMRt6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:02:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-YGwMac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:02:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-B2OG4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:02:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-te5okN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:02:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-A2l8JB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:02:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-t7tTN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:02:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-e4xH3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:02:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-7FcADK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:02:02 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-oxcLwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:02:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:02:02 INFO - Running setup.py install for manifestparser 11:02:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:02:02 INFO - Running setup.py install for mozcrash 11:02:02 INFO - Running setup.py install for mozdebug 11:02:02 INFO - Running setup.py install for mozdevice 11:02:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:02:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:02:02 INFO - Running setup.py install for mozfile 11:02:02 INFO - Running setup.py install for mozhttpd 11:02:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:02:02 INFO - Running setup.py install for mozinfo 11:02:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:02:03 INFO - Running setup.py install for mozInstall 11:02:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:02:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:02:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:02:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:02:03 INFO - Running setup.py install for mozleak 11:02:03 INFO - Running setup.py install for mozlog 11:02:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:02:03 INFO - Running setup.py install for moznetwork 11:02:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:02:03 INFO - Running setup.py install for mozprocess 11:02:03 INFO - Running setup.py install for mozprofile 11:02:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:02:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:02:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:02:04 INFO - Running setup.py install for mozrunner 11:02:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:02:04 INFO - Running setup.py install for mozscreenshot 11:02:04 INFO - Running setup.py install for moztest 11:02:04 INFO - Running setup.py install for mozversion 11:02:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:02:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:02:04 INFO - Cleaning up... 11:02:04 INFO - Return code: 0 11:02:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1c1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e256618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f965adb6e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e125d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de8adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2GMTe5weG5/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:02:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:02:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:02:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2GMTe5weG5/Render', 11:02:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:02:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:02:04 INFO - 'HOME': '/Users/cltbld', 11:02:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:02:04 INFO - 'LOGNAME': 'cltbld', 11:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:04 INFO - 'MOZ_NO_REMOTE': '1', 11:02:04 INFO - 'NO_EM_RESTART': '1', 11:02:04 INFO - 'PAGER': '/bin/cat', 11:02:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:04 INFO - 'PWD': '/builds/slave/test', 11:02:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:02:04 INFO - 'SHELL': '/bin/bash', 11:02:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners', 11:02:04 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 11:02:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:02:04 INFO - 'USER': 'cltbld', 11:02:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:02:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:04 INFO - 'XPC_FLAGS': '0x0', 11:02:04 INFO - 'XPC_SERVICE_NAME': '0', 11:02:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:02:04 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-nAKkZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:02:05 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-bJFOyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:02:05 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-T3YXy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:02:05 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-Vp3IcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:02:05 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-lDfBCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:02:05 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-qQux5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:02:05 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-xXXqTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:02:05 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-QUghZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:02:05 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-OL8H2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:02:05 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-hXAmmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:02:05 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-zbClCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:02:06 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-OATIGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:02:06 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-2h4sgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:02:06 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-LzwlRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:02:06 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-VpL6Yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:02:06 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-qIocwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:02:06 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-4L4YzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:02:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:09 INFO - Downloading blessings-1.6.tar.gz 11:02:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:02:09 INFO - Installing collected packages: blessings 11:02:09 INFO - Running setup.py install for blessings 11:02:09 INFO - Successfully installed blessings 11:02:09 INFO - Cleaning up... 11:02:09 INFO - Return code: 0 11:02:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:02:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:02:09 INFO - Reading from file tmpfile_stdout 11:02:09 INFO - Current package versions: 11:02:09 INFO - blessings == 1.6 11:02:09 INFO - blobuploader == 1.2.4 11:02:09 INFO - docopt == 0.6.1 11:02:09 INFO - functools32 == 3.2.3-2 11:02:09 INFO - jsonschema == 2.5.1 11:02:09 INFO - manifestparser == 1.1 11:02:09 INFO - mozInstall == 1.12 11:02:09 INFO - mozcrash == 0.17 11:02:09 INFO - mozdebug == 0.1 11:02:09 INFO - mozdevice == 0.48 11:02:09 INFO - mozfile == 1.2 11:02:09 INFO - mozhttpd == 0.7 11:02:09 INFO - mozinfo == 0.9 11:02:09 INFO - mozleak == 0.1 11:02:09 INFO - mozlog == 3.3 11:02:09 INFO - moznetwork == 0.27 11:02:09 INFO - mozprocess == 0.23 11:02:09 INFO - mozprofile == 0.28 11:02:09 INFO - mozrunner == 6.12 11:02:09 INFO - mozscreenshot == 0.1 11:02:09 INFO - mozsystemmonitor == 0.3 11:02:09 INFO - moztest == 0.7 11:02:09 INFO - mozversion == 1.4 11:02:09 INFO - psutil == 3.1.1 11:02:09 INFO - requests == 1.2.3 11:02:09 INFO - wsgiref == 0.1.2 11:02:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1c1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e256618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f965adb6e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e125d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de8adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2GMTe5weG5/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:02:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:02:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2GMTe5weG5/Render', 11:02:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:02:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:02:09 INFO - 'HOME': '/Users/cltbld', 11:02:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:02:09 INFO - 'LOGNAME': 'cltbld', 11:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:09 INFO - 'MOZ_NO_REMOTE': '1', 11:02:09 INFO - 'NO_EM_RESTART': '1', 11:02:09 INFO - 'PAGER': '/bin/cat', 11:02:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:09 INFO - 'PWD': '/builds/slave/test', 11:02:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:02:09 INFO - 'SHELL': '/bin/bash', 11:02:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners', 11:02:09 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 11:02:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:02:09 INFO - 'USER': 'cltbld', 11:02:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:02:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:09 INFO - 'XPC_FLAGS': '0x0', 11:02:09 INFO - 'XPC_SERVICE_NAME': '0', 11:02:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:02:10 INFO - Cleaning up... 11:02:10 INFO - Return code: 0 11:02:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1c1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e256618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f965adb6e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e125d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de8adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2GMTe5weG5/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:02:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:02:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2GMTe5weG5/Render', 11:02:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:02:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:02:10 INFO - 'HOME': '/Users/cltbld', 11:02:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:02:10 INFO - 'LOGNAME': 'cltbld', 11:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:10 INFO - 'MOZ_NO_REMOTE': '1', 11:02:10 INFO - 'NO_EM_RESTART': '1', 11:02:10 INFO - 'PAGER': '/bin/cat', 11:02:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:10 INFO - 'PWD': '/builds/slave/test', 11:02:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:02:10 INFO - 'SHELL': '/bin/bash', 11:02:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners', 11:02:10 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 11:02:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:02:10 INFO - 'USER': 'cltbld', 11:02:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:02:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:10 INFO - 'XPC_FLAGS': '0x0', 11:02:10 INFO - 'XPC_SERVICE_NAME': '0', 11:02:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:02:10 INFO - Cleaning up... 11:02:10 INFO - Return code: 0 11:02:10 INFO - Running post-action listener: _resource_record_post_action 11:02:10 INFO - Running post-action listener: _start_resource_monitoring 11:02:10 INFO - Starting resource monitoring. 11:02:10 INFO - [mozharness: 2016-09-06 18:02:10.432982Z] Finished create-virtualenv step (success) 11:02:10 INFO - [mozharness: 2016-09-06 18:02:10.434038Z] Running install step. 11:02:10 INFO - Running pre-action listener: _resource_record_pre_action 11:02:10 INFO - Running main action method: install 11:02:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:02:10 INFO - Reading from file tmpfile_stdout 11:02:10 INFO - Detecting whether we're running mozinstall >=1.0... 11:02:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:02:10 INFO - Reading from file tmpfile_stdout 11:02:10 INFO - Output received: 11:02:10 INFO - Usage: mozinstall [options] installer 11:02:10 INFO - Options: 11:02:10 INFO - -h, --help show this help message and exit 11:02:10 INFO - -d DEST, --destination=DEST 11:02:10 INFO - Directory to install application into. [default: 11:02:10 INFO - "/builds/slave/test"] 11:02:10 INFO - --app=APP Application being installed. [default: firefox] 11:02:10 INFO - mkdir: /builds/slave/test/build/application 11:02:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:02:45 INFO - Reading from file tmpfile_stdout 11:02:45 INFO - Output received: 11:02:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:02:45 INFO - Running post-action listener: _resource_record_post_action 11:02:45 INFO - [mozharness: 2016-09-06 18:02:45.225101Z] Finished install step (success) 11:02:45 INFO - [mozharness: 2016-09-06 18:02:45.225241Z] Running run-tests step. 11:02:45 INFO - Running pre-action listener: _resource_record_pre_action 11:02:45 INFO - Running main action method: run_tests 11:02:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:02:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:02:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:02:45 INFO - 2016-09-06 11:02:45.239 screenresolution[1646:8716] starting screenresolution argv=screenresolution get 11:02:45 INFO - 2016-09-06 11:02:45.242 screenresolution[1646:8716] Display 0: 1600x1200x32@60 11:02:45 INFO - 2016-09-06 11:02:45.247 screenresolution[1647:8718] starting screenresolution argv=screenresolution list 11:02:45 INFO - Available Modes on Display 0 11:02:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:02:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:02:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:02:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:02:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:02:45 INFO - Intel Iris: 11:02:45 INFO - Chipset Model: Intel Iris 11:02:45 INFO - Type: GPU 11:02:45 INFO - Bus: Built-In 11:02:45 INFO - VRAM (Dynamic, Max): 1536 MB 11:02:45 INFO - Vendor: Intel (0x8086) 11:02:45 INFO - Device ID: 0x0a2e 11:02:45 INFO - Revision ID: 0x0009 11:02:45 INFO - Displays: 11:02:45 INFO - Display: 11:02:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:02:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:02:45 INFO - Display Serial Number: 1600x1200 60 11:02:45 INFO - Main Display: Yes 11:02:45 INFO - Mirror: Off 11:02:45 INFO - Online: Yes 11:02:45 INFO - Rotation: Supported 11:02:45 INFO - Return code: 0 11:02:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:02:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:02:45 INFO - Python 2.7.3 11:02:45 INFO - Return code: 0 11:02:45 INFO - grabbing minidump binary from tooltool 11:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:45 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e125d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de8adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:02:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:02:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 11:02:45 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:02:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:02:45 INFO - Return code: 0 11:02:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:02:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:02:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:02:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:02:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:02:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lv7yCflATWaf6nS5Qd2uwA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0246', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:02:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Lv7yCflATWaf6nS5Qd2uwA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0246 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:02:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2GMTe5weG5/Render', 11:02:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:02:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:02:45 INFO - 'HOME': '/Users/cltbld', 11:02:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:02:45 INFO - 'LOGNAME': 'cltbld', 11:02:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:02:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:02:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:45 INFO - 'MOZ_NO_REMOTE': '1', 11:02:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:02:45 INFO - 'NO_EM_RESTART': '1', 11:02:45 INFO - 'PAGER': '/bin/cat', 11:02:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:02:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:45 INFO - 'PWD': '/builds/slave/test', 11:02:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:02:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:02:45 INFO - 'SHELL': '/bin/bash', 11:02:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners', 11:02:45 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 11:02:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:02:45 INFO - 'USER': 'cltbld', 11:02:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:02:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:02:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:45 INFO - 'XPC_FLAGS': '0x0', 11:02:45 INFO - 'XPC_SERVICE_NAME': '0', 11:02:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:02:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lv7yCflATWaf6nS5Qd2uwA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0246', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:02:45 INFO - mozversion application_buildid: 20160906073854 11:02:45 INFO - mozversion application_changeset: 37c9349b4e8167a61b08b7e119c21ea177b98942 11:02:45 INFO - mozversion application_display_name: Nightly 11:02:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:02:45 INFO - mozversion application_name: Firefox 11:02:45 INFO - mozversion application_remotingname: firefox 11:02:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:02:45 INFO - mozversion application_vendor: Mozilla 11:02:45 INFO - mozversion application_version: 51.0a1 11:02:45 INFO - mozversion platform_buildid: 20160906073854 11:02:45 INFO - mozversion platform_changeset: 37c9349b4e8167a61b08b7e119c21ea177b98942 11:02:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:02:45 INFO - mozversion platform_version: 51.0a1 11:02:45 INFO - using testdate: 1473184965 11:02:45 INFO - actual date: 1473184965 11:02:45 INFO - starting webserver on 'localhost:49271' 11:02:45 INFO - SUITE-START | Running 2 tests 11:02:45 INFO - TEST-START | dromaeo_css 11:02:45 INFO - operating with platform_type : mac_ 11:02:45 INFO - Initialising browser for dromaeo_css test... 11:02:45 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmpGoPewP/profile http://localhost:49271/getInfo.html) 11:02:48 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 11:02:48 INFO - PROCESS | 1657 | colorDepth:24 11:02:48 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 11:02:48 INFO - PROCESS | 1657 | __metrics 11:02:48 INFO - PROCESS | 1657 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:02:48 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:02:49 INFO - TEST-INFO | 1657: exit 0 11:02:49 INFO - Browser initialized. 11:02:49 INFO - Running cycle 1/1 for dromaeo_css test... 11:02:49 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmpGoPewP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:03:01 INFO - PROCESS | 1660 | RSS: Main: 232198144 11:03:01 INFO - PROCESS | 1660 | 11:03:52 INFO - PROCESS | 1660 | 1473185032329 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:06:04 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 11:06:05 INFO - PROCESS | 1660 | RSS: Main: 393850880 11:06:05 INFO - PROCESS | 1660 | 11:09:09 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 11:09:09 INFO - PROCESS | 1660 | RSS: Main: 369623040 11:09:09 INFO - PROCESS | 1660 | 11:12:12 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 11:12:12 INFO - PROCESS | 1660 | RSS: Main: 333774848 11:12:12 INFO - PROCESS | 1660 | 11:15:15 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 11:15:15 INFO - PROCESS | 1660 | RSS: Main: 336904192 11:15:15 INFO - PROCESS | 1660 | 11:18:19 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 11:18:20 INFO - PROCESS | 1660 | RSS: Main: 328855552 11:18:20 INFO - PROCESS | 1660 | 11:21:23 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 11:21:23 INFO - PROCESS | 1660 | RSS: Main: 475348992 11:21:23 INFO - PROCESS | 1660 | 11:21:23 INFO - PROCESS | 1660 | __start_tp_report 11:21:23 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 11:21:23 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 11:21:23 INFO - PROCESS | 1660 | |i|pagename|runs| 11:21:23 INFO - PROCESS | 1660 | |0;dojo.html;3294.505824126381;3364.2262279675683;3388.864445422185;3432.8798492052783;3462.809545474998;5690.4025077366905;5748.913766293504;5792.565557583182;5795.130730390443;5836.416358364167;5785.797497087592;5789.189513468107;5818.476337129658;5895.439933206349;5943.673097979609;5230.320058392404;5259.105951988171;5306.257124002643;5309.65487243328;5334.653247538917;5418.91871621926;5424.891502169954;5432.864178395552;5434.592405569579;5470.781168753265;5234.555062819665;5269.446708095633;5280.20796880471;5322.54758345543;5367.46325367464;4616.607588354994;5187.922181167285;5231.398389185217;5315.495027972336;5341.092014357569;5205.323307969939;5257.263983042377;5262.815801446969;5306.893862122774;5309.840704778824;5852.385499522574;5859.238299021143;5874.530037597025;5875.294964604275;5875.412458754133;6173.043178307369;6217.968910155466;6233.812985610439;6235.968820155916;6360.93639063608;6261.5616906816085;6305.117283580303;6324.810255692337;6327.936720632781;6348.523860710465;5850.970745146247;5874.970625146932;5879.911801322984;5881.2942446906645;5888.205092312569;5287.68273903567;5348.304720386325;6237.719302631393;6288.213973253343;6388.361163883575;6203.379662033851;6245.28179259391;6259.061140828821;6266;6286;5307;6350.33321501245;6352.333005034498;6358.141650877073;6366.172397588284;6140.87237156979;6170.753169873155;6173;6200.627962322275;6306.211723534559;5717.599768016282;5931.673757943268;6266.342034086447;6307.810765677037;6308.495320374359;5022.372203474566;5034.144195486776;5036.874078148076;5037.143685573461;5052.823151189691;4449.1101779644205;4449.933251001237;4487.618552423015;4540.659450541157;4573.49691533931;5749.108888122348;5758.078707406795;5782.045962416239;5792.652440853562;5839.532837373;6311.621302721851;6314.431701146918;6322.272938612026;6328.810135695937;6330.303666596671;5767.538596912237;5778.94221057784;5794.01501744696;5829.7376618052285;5874.588778785529;5382.757775900094;5409.269748583891;5413.918791218135;5449.700266485382;5519.806806761744;6309.589876658002;6324.114623952651;6325.082862984841;6328.873422531431;6329.810105696836;5275.261463395051;6220.03589443637;6255.5009124678345;6265.091561723433;6316.684165791784;6232.906506402498;6296.33888441707;6312.368763123651;6316.778912738032;6323.588966717149;6262.279837818527;6293.087502312231;6308.495320374451;6309.053641953744;6324.715387807468;6303.117563541016;6315.431611155018;6330.335314791881;6339.144215530844;6345.555811093179;6041.909371359346;6109.890546867989;6113.993245360445;6244.250689917239;6264.404881536247;6118.741008805671;6123.5876691309595;6148.385161483816;6181.938180618136;6185.536084793568;4509.188346097734;6140.197513349842;6142.3550527194;6161.815145545641;6162.722677479614;6055.727492262947;6202.782902598387;6262.09199666055;6273.278572964167;6281.340459251713;5912.615679980788;5936.436038576328;5985.191999080069;6068.605540640021;6071.908921366095 11:21:23 INFO - PROCESS | 1660 | |1;ext.html;502.5878779400893;517.968921864688;528.5480913818684;541.6154530283501;559.2673597587163;30835.22911927203;40802;42222.36666449998;42297.78851105748;44133;37560.43659345105;42456.938576535606;43276.350854737124;43748.56251437485;43932.12135757283;8773.166549177819;9767.902320976806;9944.055314745088;9952.800943981116;9956.203503719722;8671.869921951176;11946.984506316974;12224.266544007343;12225.20536165151;12548.435320410603;12226.20529665569;12287.692807679834;12304.200226985262;12304.81542776859;12307.69230769229;12266.448009839534;12307.138500304982;12311.999999999955;12334.876651233462;12335.383230838512;12003.399830008464;12098.274103553727;12110.273383596925;12115.939420302842;12118.757624847454;41312.96717582084;41461.79269103665;41470;41563.376549351786;41575.5448559302;3278.2132288250887;3376.426007578693;3438.277961628061;3571.6606922342594;4006.419069234974;30357.392852143053;30873;31551.368972620417;31640.208994775083;31680.524792128137;3192.5530425740417;3276.393867134564;3302.058913209724;3344.3812894614575;3382.9830850845833;445760;450772;451649;452067.73966129957;452795;58167.709161453924;58448;58453.415465844795;58619.70690146522;58725.41274587285;63817.68091159607;63898;63952.68023659852;64085;64104;16426.589335266715;16639.50081497557;16661.750073748903;16684.49946501607;16707.248173832206;11646.650600481998;11886.821697674543;12770.744585108247;12834.743305134032;12854.293013884138;14927.701445971237;15969.840301597067;16527.173641317888;17710.734338984927;18471;6226.657533835682;6271.588892499242;6620.9006864897065;6714.462842972648;6768.289329620417;839.2446797881955;860.4364141487335;935.1209862729013;949.770047788116;1060.6287799270194;28014.159575212776;29433.264168395533;29722.702772971992;30313.24216894595;30567;1022.1362948308667;1022.6457220317371;1047.6856942917095;1049.3913530152645;1076.8761592416972;14502.927485362507;14921.552353429197;15546.14496202697;15626.68746625061;15789.605259868595;648095;878351;944041;944894;946433.0713385831;58059.41940580625;58618;58736.41263587395;58812.70593647005;58877.41122588805;1253.4672764075415;1277.0677405494228;1367.4325155060537;1378.1042322490462;1408.837983631875;29498.852505737334;30651.386972260876;30967.438744543764;31787.88742394005;32260.398188431638;55935;56594.71702641625;56672.86654266974;56825;56864.71567642301;591796;596898;597308;597641;597867;25667;26118.34704132412;26193.4761304769;26446.603300950886;26508.602370964836;37766.62233377631;37895;44568.55431445774;46946.765266173454;50180.74909625429;38624.42063369108;39117.608823911396;39169.41245881257;40366.39450408187;41006;36361.45457818082;37067;39172.608273918035;40025.1994960105;40270.19459610733;38145.80927095347;38556.228875422894;38989.805050974566;39219;40743.7962810184;28966.053024939727;30629.574238682646;33600;34019.82990085133;35009.47485787766;24576.87711561502;24874.502509949336;24890.626640600767;25169.622455663546;25546.616800747634 11:21:23 INFO - PROCESS | 1660 | |2;jquery.html;361.4397683590434;371.517027863777;376.1836814113374;384.77298393947564;394.8361430006547;16544.75182872258;19229.51926201844;19773.703394449094;19931.50171245718;20459.283925062628;19680.44154259944;20039.398818035483;20245.595088098267;20305.289314873982;20790.376288711363;5763.193152958589;5805.303363596375;6033.306169790464;6041.516678665696;6144.354842741514;3865.6327648873453;6143.477804386633;6192.690365481708;6196.566240363177;6206;4082.8571000015004;5896.557758168133;6156.3843615638525;6181.721822517975;6247.0317100849215;5918.437748413894;6106.236720409949;6173.228346456693;6195.5663103582765;6204.968975155118;5950.226470558843;5960.195373624549;5962.07587823888;5962.314333851576;5965.4631083202285;13291.86708132916;23716.40708982272;24250.514989700107;24589;24654.137105201233;2280.5552917181158;2287.9199228027105;2347.2290484488403;2723.2783312422225;2846.402255526342;9401.482918439484;10295.485225738683;10898.509567069501;10960.616378426717;16174.514764557081;1645.9177041147896;1809.3034181840087;1854.2860998515534;1869.392447454569;1914.607505461391;75847;83289.91775205608;104464;107172;107606.92393076047;11114.333140011626;11295.3787541686;11370.374629395463;11403.771924561628;11612.419379031015;14096.224707641179;14123.223222722849;14173.503927362493;14208.85791142096;14271.429142834171;6988.19635741886;8589.828203436022;8596.484210947363;8713.25937295337;8714.651413943371;8465.873011904827;8475.491470511666;8476.957615212008;8630.611622477003;8674.262687671619;4415.911681766347;4499.617532509707;4508.774561271924;4527.886802829889;4609.985803123308;1753.2110550252437;1850.5651171974844;1879.7086451600023;1904.4096330137702;1905.7236700678602;721.3760097515611;744.4825846037061;773.439256539016;846.9540117954322;886.3263919421287;19570.90214548918;21004.89497552533;21185.728856268674;21372.679409808865;21475.355739327533;894.5661354243186;896.7982204004047;939.3471537281524;944.6788092048737;1042.213129087534;10344.586216551254;10965.780684386427;11119.499622517005;11155.498002589902;11183.83224251637;584144;591753;598320;598384;598508;111511;122008;122138.55722885493;124036;127677;970.6311601591491;975.512243878061;998.5720419799757;1020.994895025535;1022.7903279827766;17922.91038544799;18539;18544;18631.44105676832;18633;52889.206661899334;53347.4665253358;53847.65380865509;54308.642283941634;54541.45458545523;72766;74916;76429.61785191039;76939;77257;7080.858382832417;7308.903664450375;7431.108267007994;7872.134065252703;7969.920300796918;9966.152877005246;10450.163986881184;12795;13030.804537932128;13332.533361332307;11137.109031277316;11452.541898323974;11561.942190288995;11611.88388116108;11636.418179090842;7220.638968051681;7851.60741962911;7942.166072562298;10959.342439453658;11650.242734222249;6484.164252173082;6643.40209381158;7950.761477155695;7985.2014798519685;8259.339252859636;10363.585456581652;11051.894810518883;11902.940485297864;12000.279983201035;12271.141020128505;9534.618615255313;11087.33475991443;11779.52881884715;11979.520819167485;11987.34069626144 11:21:23 INFO - PROCESS | 1660 | |3;mootools.html;1421.2538417330902;1550.565841564362;1774.3257562126398;1942.2910637617256;1971.053894130817;8484.363672724547;9006.09939006099;9026.86459703105;9038.367314288002;9054.773630659236;7920.801979950504;8127.18728127187;8527.872081918777;8761.561921903894;8848.159424854644;2406.9398265043337;2441.2554170977846;2443.0960544598524;2444.9022039118413;2449.6937882764655;2351.576716191085;2374.2402431222017;2400.6519054737055;2401.3036219496325;2432.185217951979;2135.2419890938727;2206.1396055538353;2209.149477451185;2211.281333566589;2350.083467447697;2397.7122745270503;2427.7450867658995;2429.356220601542;2434.3183908505735;2436.951260974771;2066.6590012647894;2379.214859096494;2418.9395265118515;2420.9878950605134;2426.7451917548756;8825.867611985825;8870.778230544223;8896.332775041834;8903.332250081205;8914.375993680445;5190.039842629088;5428.131498960187;5436.836894893159;5441.428649991733;5452.318460192476;3470.5314782504292;3606.5131207286945;3655.853765849363;3677.9080522987138;3683.3001729671546;959.8625628630026;1006.4313662780505;1010.8281592129356;1078.482328482325;1099.5766629847487;11569.53721851125;11639.301641901428;11663.12526560503;11668.299902005821;11670.591529296435;4526.59260666535;4684.063187362541;4782;4797.664163508591;4803.615710743132;9845.113939745457;9859.35914165577;9866.556004979793;9877.456739879375;9889.851652225223;5347.893042139135;5397.758515541369;5403.540699040625;5410.540104091197;5413.2150838128255;4746.5253474652945;4917.704937703749;4967;4969.503049695074;4975.4278258000795;3769.151940813295;3806.371948628501;3813.656770890633;3866.130120722815;3919.0594257378025;1038.3717850700368;1174.2191442690514;1174.518447436564;1187.329159025148;1188.5542921404474;751.5227830327781;837.9078301386843;883.2315885179935;895.9283257339397;935.8783358163395;5039.622028347889;5779.913301300484;5782.855428614318;5911.586188966731;6169.629822210592;897.7117835905497;920.7293934370526;935.3265648732902;963.4700914496999;992.161623428202;3883.980580097138;3887.7084218683713;3901.6293452122004;3930.076432038526;4007.6593489553716;10660.573577056986;10746;10862.185336099825;10865.293755905841;10881.782364352668;10792.298500597437;10820.97200765926;10821.945890270656;10828.675139745821;10844.620438284623;7801.024871891013;8128.390370722102;8159.306458950937;8281.8343633127;8301.2943899768;5043.2687260347775;5266.289050978069;5818.359980402068;5958.766884249839;5979.671118088547;9688.467134307399;9693.22454203648;9752.561134748812;9979.401235925867;10131.341462805189;9905.207583393167;10164;10177.440240786827;10278.17774578047;10282.537285822305;8223.876641850258;8253.95873020631;8365.790855228668;8371.916280837357;8385.790355241168;8034.718784842503;8125.79685507867;8159.83680326402;8236.341092712688;8275.54484503358;7314.780556583311;7371.984470613814;7423.331900129015;7434.7769566913075;7631.084269887649;7280.526765760209;7327.560346379234;7375.704971801068;7434.962825185839;7453.142888567884;5426.2674538936735;6732.3267673232285;6819.795406137824;6847.554908930903;6934.791956241321;4153.584641535822;4901.191303434894;4924.9507504924495;4925.482824303396;5029.371328583927;4877.926831097608;4973.651844370859;4997;5044.041632089891;5113.284140220298 11:21:23 INFO - PROCESS | 1660 | |4;prototype.html;299.0743648408177;301.54767848227647;308.1740934296087;311.89395605494127;312.66388632220367;5307.442718514553;5326.280952071474;5339.786408543659;5407.864803379917;5436.836894893149;5083.339165908436;5309.177077552976;5358.437364076764;5361.587285721431;5412.891742165154;3134.7335476484527;3861.555921069085;3993.4608827808165;4041.3632478846116;4045.664930572904;3888.5333759948703;4078.3882417637296;4078.89802754932;4116.382542618616;4127.318992366256;3487.877924272651;4024.9798751006206;4053.7365071270274;4060.776657283863;4070.124923141524;3750.2124553843723;3813.2945405100145;4028.234635419261;4034.2334956358345;4051.8727667974254;2922.956155657667;3513.1919658478437;3524.9118772030647;3537.2748586539956;3539.7168226541817;3781.243751249761;4800.207965685658;5174.586033117379;5259.447757985433;5268.0517506848755;4402.493713222988;4610.193216187154;4657.371254880582;4690.788914498821;4712.552307530779;4775.4241100436775;5243.606729495303;5389.541888939445;5605.80379686709;5631.71841407928;3416.692497675196;3832.329342365075;3884.6403758684232;3921.156951255494;3943.132510847609;5030.496950304977;5097.490250974873;5521.503064724154;5902.557308201859;5924.644521328734;3310.30483598447;3819.9113252723396;3845.9807700961314;3861.4014827701753;3880;3352.0446672698163;3399.5240666306736;3681.318955993096;3861.0347413146715;3942.2706799242233;4182.519010313792;4231.576842315805;4596.057808149321;4614.246586297186;4629.412205540732;5143.331366922276;5507.420176885057;5601.915971260434;5613.7193140342815;5756.539476841843;1314.842218933734;1340.222670850904;1341.4298922957898;1346.1519242876925;1348.7726169185994;771.8957940677936;812.6668066092874;814.621201141472;823.1768231768232;837.7486753973783;5022.296878437021;5097.46476619957;5101.821436249714;5137.152369859006;5339.919901201485;5470.261514695465;5569.944300557024;5747.942520574825;5912.467877890925;5930.406959304035;4967.105920934194;5205.713685747321;5215.24378965048;5262.052830490472;5329;2762.5303698371326;2947.6904924982996;3037.767241077806;3082.152408087794;3108.626964764243;5196.090684130338;5450.811275403854;5986.880262394728;6090.786822461193;6158.630482171084;4752.809887604457;5266;5287.947120528823;5986.461218490357;6029.517638588903;5279.894402112013;5484.890302194013;5682.346530149003;5960.821175364746;6050.515958723292;4810.783514741915;5543.501084902378;5656.5757568181725;5843.181954526454;5890.970545147246;5539.612227144061;5676.68778217202;5720.48515633595;5798.449147330997;5847.44449277318;6034.978282275487;6075.450760056334;6124;6126.172966649446;6145.539084568764;2741.753242208211;2926.897558585439;3263.547721264015;3282.458394364903;3413.470912008543;3929.685625149924;4518.6846561533;4619;4821.927671084866;4883.853484395474;4713.2458806590785;4771.332013518179;4847.684900481458;4853.854384368475;4892.425582080766;4542.139910295951;4771.976140119416;4792.784324705466;4833.73414462208;4837.992233223173;3721.53896875908;4133.251387827061;4425.358323043205;4656.8125128092115;4659.320890487915;4839.661223714306;5332.9733351333;5600.243967064394;5764.942350576441;5821.476067153976;4605;5518.475744804237;5524.569189556582;5560.694161821139;5596.636218645775 11:21:23 INFO - PROCESS | 1660 | |5;yui.html;641.7946257197696;654.6693919570613;673.4477728262823;732.5970716106141;768.2854944901243;11793.823092653607;14614.853851461483;15183.772243416344;15198.316075776589;15663.60840978976;13824.516141935035;14143.929280353585;14165.71668566628;14172.149671019746;14241.501547445841;671.8790617688815;836.8159005018886;852.2840813716477;853.1042405474258;853.4623187391934;688.9793306200822;696.6551556979302;697.0206859362578;699.7096205074888;829.1128492513013;905.529124855075;909.940853844498;916.6241840845255;917.3395155488072;921.7280902133887;905.7011186308536;906.1120102299717;906.5920335848862;907.7049958763429;911.6672414568701;517.8679436743644;650.2035007116292;675.4191395399952;675.8344205669594;677.701811203069;14182.43270269188;14313;14319.928400357932;14358.71282574353;14367.712645747026;12194;12429.627111186679;12548.560800372034;12743.872561274362;13306.467741290337;12308.569200077955;12325.383730813424;12429.564965226264;12737.617871463779;12977.87022129776;4393.36296237047;4503.617192538638;4504;4580.679352445331;4660.18446771817;104118;110736.4463177687;111093;111303.86094016403;111575;10009.749756256006;10279.817820950537;10349.844752328721;10653.094486968694;10659.520321585547;19322.32371866978;19620;19629.116689748997;19651.803481965282;19696.803031969495;6459.515536334794;7408.814779630445;7520.435967302475;7602.885956710654;7789.883151752728;4290.141971605629;4306.590873866978;4324.35134729793;4449.510553839075;4471.1728330259;3270.460374038257;3369.1745522347182;3371.072954937412;3376.729861611065;3720.5535335759882;700.8318003679183;701.8210356359198;704.9295070492909;714.7420539849902;722.5375759513915;598.8472939400425;651.4039653716796;653.9340874374739;678.7115475922714;686.9003994420781;8557.743267701979;9079.727608171765;9090.909090909006;9215.308851836005;9225.261979041661;553.4161459660016;620.8758248350348;636.462189449914;669.2838662631035;687.189116842121;4378.321360189176;4381.759003254788;4386.18855511725;4413.271810151353;4571.131485017836;101200.49399752954;139604;147433.525664742;151071.24464377607;153326.23336883244;135331.6466835319;135773;140391.29804350913;141371;142313.44216394465;116967;117831.41084294523;118711;120011.19843221782;121665.17502237296;8528;8588.202962999825;8599;8644.394892357475;8827.426217295855;60686;63547.68226159024;64877;65445.67277163584;68531.31468685449;79233.60383198046;82565.17434825575;82929;86514.56742716246;100487.99512004787;12123.575674851338;12498.75002499963;12798.61604151877;13167.868321317048;13354.465821367425;13754.105983111065;13884.58346249614;13951.511697090553;14198.92900535532;14425.7836132456;13108.082434229895;13259.826663771179;13284.933575332061;13338.799918001432;13558.38987245596;12974.89713374336;13122.671933201746;13491.392887319898;13647.522336718168;13829;12944.676383090122;13071.019673524714;13514.256715880721;13657.590272291847;13803.964702647543;11304.830427543759;11336.12512261787;11364.54541818318;11448.141389395994;11616.361100139573;10435.478226088817;10567.94716026415;10886.426177764695;11141.777164456827;11163.49764260594 11:21:23 INFO - PROCESS | 1660 | __end_tp_report 11:21:23 INFO - PROCESS | 1660 | __start_cc_report 11:21:23 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,1502 11:21:23 INFO - PROCESS | 1660 | __end_cc_report 11:21:23 INFO - PROCESS | 1660 | __startTimestamp1473186083858__endTimestamp 11:21:23 INFO - PROCESS | 1660 | 11:21:23 INFO - PROCESS | 1660 | ------- Summary: start ------- 11:21:23 INFO - PROCESS | 1660 | Number of tests: 6 11:21:23 INFO - PROCESS | 1660 | 11:21:23 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5784.45 Median:5936.44 stddev:645.81 (10.9%) stddev-sans-first:617.55 11:21:23 INFO - PROCESS | 1660 | Values: 3294.5 3364.2 3388.9 3432.9 3462.8 5690.4 5748.9 5792.6 5795.1 5836.4 5785.8 5789.2 5818.5 5895.4 5943.7 5230.3 5259.1 5306.3 5309.7 5334.7 5418.9 5424.9 5432.9 5434.6 5470.8 5234.6 5269.4 5280.2 5322.5 5367.5 4616.6 5187.9 5231.4 5315.5 5341.1 5205.3 5257.3 5262.8 5306.9 5309.8 5852.4 5859.2 5874.5 5875.3 5875.4 6173.0 6218.0 6233.8 6236.0 6360.9 6261.6 6305.1 6324.8 6327.9 6348.5 5851.0 5875.0 5879.9 5881.3 5888.2 5287.7 5348.3 6237.7 6288.2 6388.4 6203.4 6245.3 6259.1 6266.0 6286.0 5307.0 6350.3 6352.3 6358.1 6366.2 6140.9 6170.8 6173.0 6200.6 6306.2 5717.6 5931.7 6266.3 6307.8 6308.5 5022.4 5034.1 5036.9 5037.1 5052.8 4449.1 4449.9 4487.6 4540.7 4573.5 5749.1 5758.1 5782.0 5792.7 5839.5 6311.6 6314.4 6322.3 6328.8 6330.3 5767.5 5778.9 5794.0 5829.7 5874.6 5382.8 5409.3 5413.9 5449.7 5519.8 6309.6 6324.1 6325.1 6328.9 6329.8 5275.3 6220.0 6255.5 6265.1 6316.7 6232.9 6296.3 6312.4 6316.8 6323.6 6262.3 6293.1 6308.5 6309.1 6324.7 6303.1 6315.4 6330.3 6339.1 6345.6 6041.9 6109.9 6114.0 6244.3 6264.4 6118.7 6123.6 6148.4 6181.9 6185.5 4509.2 6140.2 6142.4 6161.8 6162.7 6055.7 6202.8 6262.1 6273.3 6281.3 5912.6 5936.4 5985.2 6068.6 6071.9 11:21:23 INFO - PROCESS | 1660 | 11:21:23 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:76475.18 Median:36714.23 stddev:179619.75 (489.2%) stddev-sans-first:180033.05 11:21:23 INFO - PROCESS | 1660 | Values: 502.6 518.0 528.5 541.6 559.3 30835.2 40802.0 42222.4 42297.8 44133.0 37560.4 42456.9 43276.4 43748.6 43932.1 8773.2 9767.9 9944.1 9952.8 9956.2 8671.9 11947.0 12224.3 12225.2 12548.4 12226.2 12287.7 12304.2 12304.8 12307.7 12266.4 12307.1 12312.0 12334.9 12335.4 12003.4 12098.3 12110.3 12115.9 12118.8 41313.0 41461.8 41470.0 41563.4 41575.5 3278.2 3376.4 3438.3 3571.7 4006.4 30357.4 30873.0 31551.4 31640.2 31680.5 3192.6 3276.4 3302.1 3344.4 3383.0 445760.0 450772.0 451649.0 452067.7 452795.0 58167.7 58448.0 58453.4 58619.7 58725.4 63817.7 63898.0 63952.7 64085.0 64104.0 16426.6 16639.5 16661.8 16684.5 16707.2 11646.7 11886.8 12770.7 12834.7 12854.3 14927.7 15969.8 16527.2 17710.7 18471.0 6226.7 6271.6 6620.9 6714.5 6768.3 839.2 860.4 935.1 949.8 1060.6 28014.2 29433.3 29722.7 30313.2 30567.0 1022.1 1022.6 1047.7 1049.4 1076.9 14502.9 14921.6 15546.1 15626.7 15789.6 648095.0 878351.0 944041.0 944894.0 946433.1 58059.4 58618.0 58736.4 58812.7 58877.4 1253.5 1277.1 1367.4 1378.1 1408.8 29498.9 30651.4 30967.4 31787.9 32260.4 55935.0 56594.7 56672.9 56825.0 56864.7 591796.0 596898.0 597308.0 597641.0 597867.0 25667.0 26118.3 26193.5 26446.6 26508.6 37766.6 37895.0 44568.6 46946.8 50180.7 38624.4 39117.6 39169.4 40366.4 41006.0 36361.5 37067.0 39172.6 40025.2 40270.2 38145.8 38556.2 38989.8 39219.0 40743.8 28966.1 30629.6 33600.0 34019.8 35009.5 24576.9 24874.5 24890.6 25169.6 25546.6 11:21:23 INFO - PROCESS | 1660 | 11:21:23 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:33893.77 Median:366.48 stddev:98630.27 (26913.0%) stddev-sans-first:98874.81 11:21:23 INFO - PROCESS | 1660 | Values: 361.4 371.5 376.2 384.8 394.8 16544.8 19229.5 19773.7 19931.5 20459.3 19680.4 20039.4 20245.6 20305.3 20790.4 5763.2 5805.3 6033.3 6041.5 6144.4 3865.6 6143.5 6192.7 6196.6 6206.0 4082.9 5896.6 6156.4 6181.7 6247.0 5918.4 6106.2 6173.2 6195.6 6205.0 5950.2 5960.2 5962.1 5962.3 5965.5 13291.9 23716.4 24250.5 24589.0 24654.1 2280.6 2287.9 2347.2 2723.3 2846.4 9401.5 10295.5 10898.5 10960.6 16174.5 1645.9 1809.3 1854.3 1869.4 1914.6 75847.0 83289.9 104464.0 107172.0 107606.9 11114.3 11295.4 11370.4 11403.8 11612.4 14096.2 14123.2 14173.5 14208.9 14271.4 6988.2 8589.8 8596.5 8713.3 8714.7 8465.9 8475.5 8477.0 8630.6 8674.3 4415.9 4499.6 4508.8 4527.9 4610.0 1753.2 1850.6 1879.7 1904.4 1905.7 721.4 744.5 773.4 847.0 886.3 19570.9 21004.9 21185.7 21372.7 21475.4 894.6 896.8 939.3 944.7 1042.2 10344.6 10965.8 11119.5 11155.5 11183.8 584144.0 591753.0 598320.0 598384.0 598508.0 111511.0 122008.0 122138.6 124036.0 127677.0 970.6 975.5 998.6 1021.0 1022.8 17922.9 18539.0 18544.0 18631.4 18633.0 52889.2 53347.5 53847.7 54308.6 54541.5 72766.0 74916.0 76429.6 76939.0 77257.0 7080.9 7308.9 7431.1 7872.1 7969.9 9966.2 10450.2 12795.0 13030.8 13332.5 11137.1 11452.5 11561.9 11611.9 11636.4 7220.6 7851.6 7942.2 10959.3 11650.2 6484.2 6643.4 7950.8 7985.2 8259.3 10363.6 11051.9 11902.9 12000.3 12271.1 9534.6 11087.3 11779.5 11979.5 11987.3 11:21:23 INFO - PROCESS | 1660 | 11:21:23 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5717.76 Median:5013.19 stddev:3217.64 (64.2%) stddev-sans-first:3210.47 11:21:23 INFO - PROCESS | 1660 | Values: 1421.3 1550.6 1774.3 1942.3 1971.1 8484.4 9006.1 9026.9 9038.4 9054.8 7920.8 8127.2 8527.9 8761.6 8848.2 2406.9 2441.3 2443.1 2444.9 2449.7 2351.6 2374.2 2400.7 2401.3 2432.2 2135.2 2206.1 2209.1 2211.3 2350.1 2397.7 2427.7 2429.4 2434.3 2437.0 2066.7 2379.2 2418.9 2421.0 2426.7 8825.9 8870.8 8896.3 8903.3 8914.4 5190.0 5428.1 5436.8 5441.4 5452.3 3470.5 3606.5 3655.9 3677.9 3683.3 959.9 1006.4 1010.8 1078.5 1099.6 11569.5 11639.3 11663.1 11668.3 11670.6 4526.6 4684.1 4782.0 4797.7 4803.6 9845.1 9859.4 9866.6 9877.5 9889.9 5347.9 5397.8 5403.5 5410.5 5413.2 4746.5 4917.7 4967.0 4969.5 4975.4 3769.2 3806.4 3813.7 3866.1 3919.1 1038.4 1174.2 1174.5 1187.3 1188.6 751.5 837.9 883.2 895.9 935.9 5039.6 5779.9 5782.9 5911.6 6169.6 897.7 920.7 935.3 963.5 992.2 3884.0 3887.7 3901.6 3930.1 4007.7 10660.6 10746.0 10862.2 10865.3 10881.8 10792.3 10821.0 10821.9 10828.7 10844.6 7801.0 8128.4 8159.3 8281.8 8301.3 5043.3 5266.3 5818.4 5958.8 5979.7 9688.5 9693.2 9752.6 9979.4 10131.3 9905.2 10164.0 10177.4 10278.2 10282.5 8223.9 8254.0 8365.8 8371.9 8385.8 8034.7 8125.8 8159.8 8236.3 8275.5 7314.8 7372.0 7423.3 7434.8 7631.1 7280.5 7327.6 7375.7 7435.0 7453.1 5426.3 6732.3 6819.8 6847.6 6934.8 4153.6 4901.2 4925.0 4925.5 5029.4 4877.9 4973.7 4997.0 5044.0 5113.3 11:21:23 INFO - PROCESS | 1660 | 11:21:23 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:4430.45 Median:4835.86 stddev:1393.33 (28.8%) stddev-sans-first:1362.30 11:21:23 INFO - PROCESS | 1660 | Values: 299.1 301.5 308.2 311.9 312.7 5307.4 5326.3 5339.8 5407.9 5436.8 5083.3 5309.2 5358.4 5361.6 5412.9 3134.7 3861.6 3993.5 4041.4 4045.7 3888.5 4078.4 4078.9 4116.4 4127.3 3487.9 4025.0 4053.7 4060.8 4070.1 3750.2 3813.3 4028.2 4034.2 4051.9 2923.0 3513.2 3524.9 3537.3 3539.7 3781.2 4800.2 5174.6 5259.4 5268.1 4402.5 4610.2 4657.4 4690.8 4712.6 4775.4 5243.6 5389.5 5605.8 5631.7 3416.7 3832.3 3884.6 3921.2 3943.1 5030.5 5097.5 5521.5 5902.6 5924.6 3310.3 3819.9 3846.0 3861.4 3880.0 3352.0 3399.5 3681.3 3861.0 3942.3 4182.5 4231.6 4596.1 4614.2 4629.4 5143.3 5507.4 5601.9 5613.7 5756.5 1314.8 1340.2 1341.4 1346.2 1348.8 771.9 812.7 814.6 823.2 837.7 5022.3 5097.5 5101.8 5137.2 5339.9 5470.3 5569.9 5747.9 5912.5 5930.4 4967.1 5205.7 5215.2 5262.1 5329.0 2762.5 2947.7 3037.8 3082.2 3108.6 5196.1 5450.8 5986.9 6090.8 6158.6 4752.8 5266.0 5287.9 5986.5 6029.5 5279.9 5484.9 5682.3 5960.8 6050.5 4810.8 5543.5 5656.6 5843.2 5891.0 5539.6 5676.7 5720.5 5798.4 5847.4 6035.0 6075.5 6124.0 6126.2 6145.5 2741.8 2926.9 3263.5 3282.5 3413.5 3929.7 4518.7 4619.0 4821.9 4883.9 4713.2 4771.3 4847.7 4853.9 4892.4 4542.1 4772.0 4792.8 4833.7 4838.0 3721.5 4133.3 4425.4 4656.8 4659.3 4839.7 5333.0 5600.2 5764.9 5821.5 4605.0 5518.5 5524.6 5560.7 5596.6 11:21:23 INFO - PROCESS | 1660 | 11:21:23 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:24807.73 Median:11483.63 stddev:40084.89 (349.1%) stddev-sans-first:40156.28 11:21:23 INFO - PROCESS | 1660 | Values: 641.8 654.7 673.4 732.6 768.3 11793.8 14614.9 15183.8 15198.3 15663.6 13824.5 14143.9 14165.7 14172.1 14241.5 671.9 836.8 852.3 853.1 853.5 689.0 696.7 697.0 699.7 829.1 905.5 909.9 916.6 917.3 921.7 905.7 906.1 906.6 907.7 911.7 517.9 650.2 675.4 675.8 677.7 14182.4 14313.0 14319.9 14358.7 14367.7 12194.0 12429.6 12548.6 12743.9 13306.5 12308.6 12325.4 12429.6 12737.6 12977.9 4393.4 4503.6 4504.0 4580.7 4660.2 104118.0 110736.4 111093.0 111303.9 111575.0 10009.7 10279.8 10349.8 10653.1 10659.5 19322.3 19620.0 19629.1 19651.8 19696.8 6459.5 7408.8 7520.4 7602.9 7789.9 4290.1 4306.6 4324.4 4449.5 4471.2 3270.5 3369.2 3371.1 3376.7 3720.6 700.8 701.8 704.9 714.7 722.5 598.8 651.4 653.9 678.7 686.9 8557.7 9079.7 9090.9 9215.3 9225.3 553.4 620.9 636.5 669.3 687.2 4378.3 4381.8 4386.2 4413.3 4571.1 101200.5 139604.0 147433.5 151071.2 153326.2 135331.6 135773.0 140391.3 141371.0 142313.4 116967.0 117831.4 118711.0 120011.2 121665.2 8528.0 8588.2 8599.0 8644.4 8827.4 60686.0 63547.7 64877.0 65445.7 68531.3 79233.6 82565.2 82929.0 86514.6 100488.0 12123.6 12498.8 12798.6 13167.9 13354.5 13754.1 13884.6 13951.5 14198.9 14425.8 13108.1 13259.8 13284.9 13338.8 13558.4 12974.9 13122.7 13491.4 13647.5 13829.0 12944.7 13071.0 13514.3 13657.6 13804.0 11304.8 11336.1 11364.5 11448.1 11616.4 10435.5 10567.9 10886.4 11141.8 11163.5 11:21:23 INFO - PROCESS | 1660 | -------- Summary: end -------- 11:21:23 INFO - PROCESS | 1660 | 11:21:24 INFO - TEST-INFO | 1660: exit 0 11:21:24 INFO - TEST-OK | dromaeo_css | took 1118754ms 11:21:24 INFO - TEST-START | kraken 11:21:24 INFO - operating with platform_type : mac_ 11:21:24 INFO - Initialising browser for kraken test... 11:21:24 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmpEZxIBB/profile http://localhost:49271/getInfo.html) 11:21:26 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 11:21:26 INFO - PROCESS | 1665 | colorDepth:24 11:21:26 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 11:21:26 INFO - PROCESS | 1665 | __metrics 11:21:26 INFO - PROCESS | 1665 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:21:26 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:21:27 INFO - TEST-INFO | 1665: exit 0 11:21:27 INFO - Browser initialized. 11:21:27 INFO - Running cycle 1/1 for kraken test... 11:21:27 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmpEZxIBB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:39 INFO - PROCESS | 1666 | RSS: Main: 232402944 11:21:39 INFO - PROCESS | 1666 | 11:21:42 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 11:21:43 INFO - PROCESS | 1666 | RSS: Main: 292102144 11:21:43 INFO - PROCESS | 1666 | 11:21:45 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 11:21:46 INFO - PROCESS | 1666 | RSS: Main: 287207424 11:21:46 INFO - PROCESS | 1666 | 11:21:49 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 11:21:50 INFO - PROCESS | 1666 | RSS: Main: 377851904 11:21:50 INFO - PROCESS | 1666 | 11:21:52 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 11:21:52 INFO - PROCESS | 1666 | RSS: Main: 280633344 11:21:52 INFO - PROCESS | 1666 | 11:21:55 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:21:55 INFO - PROCESS | 1666 | RSS: Main: 285175808 11:21:55 INFO - PROCESS | 1666 | 11:21:58 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 11:21:59 INFO - PROCESS | 1666 | RSS: Main: 322715648 11:21:59 INFO - PROCESS | 1666 | 11:22:02 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 11:22:02 INFO - PROCESS | 1666 | RSS: Main: 324386816 11:22:02 INFO - PROCESS | 1666 | 11:22:05 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 11:22:06 INFO - PROCESS | 1666 | RSS: Main: 322367488 11:22:06 INFO - PROCESS | 1666 | 11:22:07 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:22:08 INFO - PROCESS | 1666 | RSS: Main: 297943040 11:22:08 INFO - PROCESS | 1666 | 11:22:10 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:22:10 INFO - PROCESS | 1666 | RSS: Main: 303599616 11:22:10 INFO - PROCESS | 1666 | 11:22:13 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:22:13 INFO - PROCESS | 1666 | RSS: Main: 303104000 11:22:13 INFO - PROCESS | 1666 | 11:22:16 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:22:17 INFO - PROCESS | 1666 | RSS: Main: 321114112 11:22:17 INFO - PROCESS | 1666 | 11:22:20 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:22:20 INFO - PROCESS | 1666 | RSS: Main: 317341696 11:22:20 INFO - PROCESS | 1666 | 11:22:22 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 11:22:22 INFO - PROCESS | 1666 | RSS: Main: 360738816 11:22:22 INFO - PROCESS | 1666 | 11:22:22 INFO - PROCESS | 1666 | __start_tp_report 11:22:22 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 11:22:22 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 11:22:22 INFO - PROCESS | 1666 | |i|pagename|runs| 11:22:22 INFO - PROCESS | 1666 | |0;ai-astar;115;115;119;115;116;114;115;113;115;125 11:22:22 INFO - PROCESS | 1666 | |1;audio-beat-detection;147;115;129;162;109;130;129;107;159;109 11:22:22 INFO - PROCESS | 1666 | |2;audio-dft;187;183;182;185;181;180;182;183;183;184 11:22:22 INFO - PROCESS | 1666 | |3;audio-fft;80;73;78;160;59;58;58;58;152;78 11:22:22 INFO - PROCESS | 1666 | |4;audio-oscillator;82;83;131;71;69;78;142;91;98;118 11:22:22 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;89;86;88;87;87;85;89;86;89;85 11:22:22 INFO - PROCESS | 1666 | |6;imaging-darkroom;94;95;95;95;95;96;102;142;94;105 11:22:22 INFO - PROCESS | 1666 | |7;imaging-desaturate;84;84;86;83;83;81;84;84;86;84 11:22:22 INFO - PROCESS | 1666 | |8;json-parse-financial;55;53;55;54;53;55;53;55;54;54 11:22:22 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;68;68;76;75;72;71;69;70;69;71 11:22:22 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;86;88;86;88;86;85;107;105;84;87 11:22:22 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;142;138;137;166;152;127;160;130;189;158 11:22:22 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;175;175;175;172;172;172;172;171;173;182 11:22:22 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;69;68;68;68;66;68;67;67;67;69 11:22:22 INFO - PROCESS | 1666 | __end_tp_report 11:22:22 INFO - PROCESS | 1666 | __start_cc_report 11:22:22 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,2059 11:22:22 INFO - PROCESS | 1666 | __end_cc_report 11:22:22 INFO - PROCESS | 1666 | __startTimestamp1473186142929__endTimestamp 11:22:22 INFO - PROCESS | 1666 | 11:22:22 INFO - PROCESS | 1666 | ------- Summary: start ------- 11:22:22 INFO - PROCESS | 1666 | Number of tests: 14 11:22:22 INFO - PROCESS | 1666 | 11:22:22 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:116.20 Median:115.00 stddev:3.46 (3.0%) stddev-sans-first:3.64 11:22:22 INFO - PROCESS | 1666 | Values: 115.0 115.0 119.0 115.0 116.0 114.0 115.0 113.0 115.0 125.0 11:22:22 INFO - PROCESS | 1666 | 11:22:22 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:129.50 stddev:20.52 (15.8%) stddev-sans-first:20.78 11:22:22 INFO - PROCESS | 1666 | Values: 147.0 115.0 129.0 162.0 109.0 130.0 129.0 107.0 159.0 109.0 11:22:22 INFO - PROCESS | 1666 | 11:22:22 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:183.00 Median:183.00 stddev:2.00 (1.1%) stddev-sans-first:1.51 11:22:22 INFO - PROCESS | 1666 | Values: 187.0 183.0 182.0 185.0 181.0 180.0 182.0 183.0 183.0 184.0 11:22:22 INFO - PROCESS | 1666 | 11:22:22 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:85.40 Median:66.00 stddev:38.36 (58.1%) stddev-sans-first:40.64 11:22:22 INFO - PROCESS | 1666 | Values: 80.0 73.0 78.0 160.0 59.0 58.0 58.0 58.0 152.0 78.0 11:22:22 INFO - PROCESS | 1666 | 11:22:22 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:80.00 stddev:25.60 (32.0%) stddev-sans-first:26.62 11:22:22 INFO - PROCESS | 1666 | Values: 82.0 83.0 131.0 71.0 69.0 78.0 142.0 91.0 98.0 118.0 11:22:22 INFO - PROCESS | 1666 | 11:22:22 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:87.50 stddev:1.60 (1.8%) stddev-sans-first:1.54 11:22:22 INFO - PROCESS | 1666 | Values: 89.0 86.0 88.0 87.0 87.0 85.0 89.0 86.0 89.0 85.0 11:22:22 INFO - PROCESS | 1666 | 11:22:22 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:101.30 Median:95.00 stddev:14.77 (15.6%) stddev-sans-first:15.43 11:22:22 INFO - PROCESS | 1666 | Values: 94.0 95.0 95.0 95.0 95.0 96.0 102.0 142.0 94.0 105.0 11:22:22 INFO - PROCESS | 1666 | 11:22:22 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:83.90 Median:84.00 stddev:1.45 (1.7%) stddev-sans-first:1.54 11:22:22 INFO - PROCESS | 1666 | Values: 84.0 84.0 86.0 83.0 83.0 81.0 84.0 84.0 86.0 84.0 11:22:22 INFO - PROCESS | 1666 | 11:22:22 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.50 stddev:0.88 (1.6%) stddev-sans-first:0.87 11:22:22 INFO - PROCESS | 1666 | Values: 55.0 53.0 55.0 54.0 53.0 55.0 53.0 55.0 54.0 54.0 11:22:22 INFO - PROCESS | 1666 | 11:22:22 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.00 stddev:2.77 (3.9%) stddev-sans-first:2.73 11:22:22 INFO - PROCESS | 1666 | Values: 68.0 68.0 76.0 75.0 72.0 71.0 69.0 70.0 69.0 71.0 11:22:22 INFO - PROCESS | 1666 | 11:22:22 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:86.00 stddev:8.43 (9.8%) stddev-sans-first:8.80 11:22:22 INFO - PROCESS | 1666 | Values: 86.0 88.0 86.0 88.0 86.0 85.0 107.0 105.0 84.0 87.0 11:22:22 INFO - PROCESS | 1666 | 11:22:22 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:149.90 Median:155.00 stddev:19.01 (12.3%) stddev-sans-first:19.94 11:22:22 INFO - PROCESS | 1666 | Values: 142.0 138.0 137.0 166.0 152.0 127.0 160.0 130.0 189.0 158.0 11:22:22 INFO - PROCESS | 1666 | 11:22:22 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:174.00 stddev:3.21 (1.8%) stddev-sans-first:3.38 11:22:22 INFO - PROCESS | 1666 | Values: 175.0 175.0 175.0 172.0 172.0 172.0 172.0 171.0 173.0 182.0 11:22:22 INFO - PROCESS | 1666 | 11:22:22 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:0.95 (1.4%) stddev-sans-first:0.88 11:22:22 INFO - PROCESS | 1666 | Values: 69.0 68.0 68.0 68.0 66.0 68.0 67.0 67.0 67.0 69.0 11:22:22 INFO - PROCESS | 1666 | -------- Summary: end -------- 11:22:22 INFO - PROCESS | 1666 | 11:22:23 INFO - TEST-INFO | 1666: exit 0 11:22:23 INFO - TEST-OK | kraken | took 59172ms 11:22:23 INFO - SUITE-END | took 1177s 11:22:24 INFO - Completed test suite (00:19:38) 11:22:24 INFO - javascript benchmark 11:22:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3294.505824126381, 3364.2262279675683, 3388.864445422185, 3432.8798492052783, 3462.809545474998, 5690.4025077366905, 5748.913766293504, 5792.565557583182, 5795.130730390443, 5836.416358364167, 5785.797497087592, 5789.189513468107, 5818.476337129658, 5895.439933206349, 5943.673097979609, 5230.320058392404, 5259.105951988171, 5306.257124002643, 5309.65487243328, 5334.653247538917, 5418.91871621926, 5424.891502169954, 5432.864178395552, 5434.592405569579, 5470.781168753265, 5234.555062819665, 5269.446708095633, 5280.20796880471, 5322.54758345543, 5367.46325367464, 4616.607588354994, 5187.922181167285, 5231.398389185217, 5315.495027972336, 5341.092014357569, 5205.323307969939, 5257.263983042377, 5262.815801446969, 5306.893862122774, 5309.840704778824, 5852.385499522574, 5859.238299021143, 5874.530037597025, 5875.294964604275, 5875.412458754133, 6173.043178307369, 6217.968910155466, 6233.812985610439, 6235.968820155916, 6360.93639063608, 6261.5616906816085, 6305.117283580303, 6324.810255692337, 6327.936720632781, 6348.523860710465, 5850.970745146247, 5874.970625146932, 5879.911801322984, 5881.2942446906645, 5888.205092312569, 5287.68273903567, 5348.304720386325, 6237.719302631393, 6288.213973253343, 6388.361163883575, 6203.379662033851, 6245.28179259391, 6259.061140828821, 6266.0, 6286.0, 5307.0, 6350.33321501245, 6352.333005034498, 6358.141650877073, 6366.172397588284, 6140.87237156979, 6170.753169873155, 6173.0, 6200.627962322275, 6306.211723534559, 5717.599768016282, 5931.673757943268, 6266.342034086447, 6307.810765677037, 6308.495320374359, 5022.372203474566, 5034.144195486776, 5036.874078148076, 5037.143685573461, 5052.823151189691, 4449.1101779644205, 4449.933251001237, 4487.618552423015, 4540.659450541157, 4573.49691533931, 5749.108888122348, 5758.078707406795, 5782.045962416239, 5792.652440853562, 5839.532837373, 6311.621302721851, 6314.431701146918, 6322.272938612026, 6328.810135695937, 6330.303666596671, 5767.538596912237, 5778.94221057784, 5794.01501744696, 5829.7376618052285, 5874.588778785529, 5382.757775900094, 5409.269748583891, 5413.918791218135, 5449.700266485382, 5519.806806761744, 6309.589876658002, 6324.114623952651, 6325.082862984841, 6328.873422531431, 6329.810105696836, 5275.261463395051, 6220.03589443637, 6255.5009124678345, 6265.091561723433, 6316.684165791784, 6232.906506402498, 6296.33888441707, 6312.368763123651, 6316.778912738032, 6323.588966717149, 6262.279837818527, 6293.087502312231, 6308.495320374451, 6309.053641953744, 6324.715387807468, 6303.117563541016, 6315.431611155018, 6330.335314791881, 6339.144215530844, 6345.555811093179, 6041.909371359346, 6109.890546867989, 6113.993245360445, 6244.250689917239, 6264.404881536247, 6118.741008805671, 6123.5876691309595, 6148.385161483816, 6181.938180618136, 6185.536084793568, 4509.188346097734, 6140.197513349842, 6142.3550527194, 6161.815145545641, 6162.722677479614, 6055.727492262947, 6202.782902598387, 6262.09199666055, 6273.278572964167, 6281.340459251713, 5912.615679980788, 5936.436038576328, 5985.191999080069, 6068.605540640021, 6071.908921366095], "value": 5745.034770857397, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.5878779400893, 517.968921864688, 528.5480913818684, 541.6154530283501, 559.2673597587163, 30835.22911927203, 40802.0, 42222.36666449998, 42297.78851105748, 44133.0, 37560.43659345105, 42456.938576535606, 43276.350854737124, 43748.56251437485, 43932.12135757283, 8773.166549177819, 9767.902320976806, 9944.055314745088, 9952.800943981116, 9956.203503719722, 8671.869921951176, 11946.984506316974, 12224.266544007343, 12225.20536165151, 12548.435320410603, 12226.20529665569, 12287.692807679834, 12304.200226985262, 12304.81542776859, 12307.69230769229, 12266.448009839534, 12307.138500304982, 12311.999999999955, 12334.876651233462, 12335.383230838512, 12003.399830008464, 12098.274103553727, 12110.273383596925, 12115.939420302842, 12118.757624847454, 41312.96717582084, 41461.79269103665, 41470.0, 41563.376549351786, 41575.5448559302, 3278.2132288250887, 3376.426007578693, 3438.277961628061, 3571.6606922342594, 4006.419069234974, 30357.392852143053, 30873.0, 31551.368972620417, 31640.208994775083, 31680.524792128137, 3192.5530425740417, 3276.393867134564, 3302.058913209724, 3344.3812894614575, 3382.9830850845833, 445760.0, 450772.0, 451649.0, 452067.73966129957, 452795.0, 58167.709161453924, 58448.0, 58453.415465844795, 58619.70690146522, 58725.41274587285, 63817.68091159607, 63898.0, 63952.68023659852, 64085.0, 64104.0, 16426.589335266715, 16639.50081497557, 16661.750073748903, 16684.49946501607, 16707.248173832206, 11646.650600481998, 11886.821697674543, 12770.744585108247, 12834.743305134032, 12854.293013884138, 14927.701445971237, 15969.840301597067, 16527.173641317888, 17710.734338984927, 18471.0, 6226.657533835682, 6271.588892499242, 6620.9006864897065, 6714.462842972648, 6768.289329620417, 839.2446797881955, 860.4364141487335, 935.1209862729013, 949.770047788116, 1060.6287799270194, 28014.159575212776, 29433.264168395533, 29722.702772971992, 30313.24216894595, 30567.0, 1022.1362948308667, 1022.6457220317371, 1047.6856942917095, 1049.3913530152645, 1076.8761592416972, 14502.927485362507, 14921.552353429197, 15546.14496202697, 15626.68746625061, 15789.605259868595, 648095.0, 878351.0, 944041.0, 944894.0, 946433.0713385831, 58059.41940580625, 58618.0, 58736.41263587395, 58812.70593647005, 58877.41122588805, 1253.4672764075415, 1277.0677405494228, 1367.4325155060537, 1378.1042322490462, 1408.837983631875, 29498.852505737334, 30651.386972260876, 30967.438744543764, 31787.88742394005, 32260.398188431638, 55935.0, 56594.71702641625, 56672.86654266974, 56825.0, 56864.71567642301, 591796.0, 596898.0, 597308.0, 597641.0, 597867.0, 25667.0, 26118.34704132412, 26193.4761304769, 26446.603300950886, 26508.602370964836, 37766.62233377631, 37895.0, 44568.55431445774, 46946.765266173454, 50180.74909625429, 38624.42063369108, 39117.608823911396, 39169.41245881257, 40366.39450408187, 41006.0, 36361.45457818082, 37067.0, 39172.608273918035, 40025.1994960105, 40270.19459610733, 38145.80927095347, 38556.228875422894, 38989.805050974566, 39219.0, 40743.7962810184, 28966.053024939727, 30629.574238682646, 33600.0, 34019.82990085133, 35009.47485787766, 24576.87711561502, 24874.502509949336, 24890.626640600767, 25169.622455663546, 25546.616800747634], "value": 20549.711511051028, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.4397683590434, 371.517027863777, 376.1836814113374, 384.77298393947564, 394.8361430006547, 16544.75182872258, 19229.51926201844, 19773.703394449094, 19931.50171245718, 20459.283925062628, 19680.44154259944, 20039.398818035483, 20245.595088098267, 20305.289314873982, 20790.376288711363, 5763.193152958589, 5805.303363596375, 6033.306169790464, 6041.516678665696, 6144.354842741514, 3865.6327648873453, 6143.477804386633, 6192.690365481708, 6196.566240363177, 6206.0, 4082.8571000015004, 5896.557758168133, 6156.3843615638525, 6181.721822517975, 6247.0317100849215, 5918.437748413894, 6106.236720409949, 6173.228346456693, 6195.5663103582765, 6204.968975155118, 5950.226470558843, 5960.195373624549, 5962.07587823888, 5962.314333851576, 5965.4631083202285, 13291.86708132916, 23716.40708982272, 24250.514989700107, 24589.0, 24654.137105201233, 2280.5552917181158, 2287.9199228027105, 2347.2290484488403, 2723.2783312422225, 2846.402255526342, 9401.482918439484, 10295.485225738683, 10898.509567069501, 10960.616378426717, 16174.514764557081, 1645.9177041147896, 1809.3034181840087, 1854.2860998515534, 1869.392447454569, 1914.607505461391, 75847.0, 83289.91775205608, 104464.0, 107172.0, 107606.92393076047, 11114.333140011626, 11295.3787541686, 11370.374629395463, 11403.771924561628, 11612.419379031015, 14096.224707641179, 14123.223222722849, 14173.503927362493, 14208.85791142096, 14271.429142834171, 6988.19635741886, 8589.828203436022, 8596.484210947363, 8713.25937295337, 8714.651413943371, 8465.873011904827, 8475.491470511666, 8476.957615212008, 8630.611622477003, 8674.262687671619, 4415.911681766347, 4499.617532509707, 4508.774561271924, 4527.886802829889, 4609.985803123308, 1753.2110550252437, 1850.5651171974844, 1879.7086451600023, 1904.4096330137702, 1905.7236700678602, 721.3760097515611, 744.4825846037061, 773.439256539016, 846.9540117954322, 886.3263919421287, 19570.90214548918, 21004.89497552533, 21185.728856268674, 21372.679409808865, 21475.355739327533, 894.5661354243186, 896.7982204004047, 939.3471537281524, 944.6788092048737, 1042.213129087534, 10344.586216551254, 10965.780684386427, 11119.499622517005, 11155.498002589902, 11183.83224251637, 584144.0, 591753.0, 598320.0, 598384.0, 598508.0, 111511.0, 122008.0, 122138.55722885493, 124036.0, 127677.0, 970.6311601591491, 975.512243878061, 998.5720419799757, 1020.994895025535, 1022.7903279827766, 17922.91038544799, 18539.0, 18544.0, 18631.44105676832, 18633.0, 52889.206661899334, 53347.4665253358, 53847.65380865509, 54308.642283941634, 54541.45458545523, 72766.0, 74916.0, 76429.61785191039, 76939.0, 77257.0, 7080.858382832417, 7308.903664450375, 7431.108267007994, 7872.134065252703, 7969.920300796918, 9966.152877005246, 10450.163986881184, 12795.0, 13030.804537932128, 13332.533361332307, 11137.109031277316, 11452.541898323974, 11561.942190288995, 11611.88388116108, 11636.418179090842, 7220.638968051681, 7851.60741962911, 7942.166072562298, 10959.342439453658, 11650.242734222249, 6484.164252173082, 6643.40209381158, 7950.761477155695, 7985.2014798519685, 8259.339252859636, 10363.585456581652, 11051.894810518883, 11902.940485297864, 12000.279983201035, 12271.141020128505, 9534.618615255313, 11087.33475991443, 11779.52881884715, 11979.520819167485, 11987.34069626144], "value": 9365.335178763678, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.2538417330902, 1550.565841564362, 1774.3257562126398, 1942.2910637617256, 1971.053894130817, 8484.363672724547, 9006.09939006099, 9026.86459703105, 9038.367314288002, 9054.773630659236, 7920.801979950504, 8127.18728127187, 8527.872081918777, 8761.561921903894, 8848.159424854644, 2406.9398265043337, 2441.2554170977846, 2443.0960544598524, 2444.9022039118413, 2449.6937882764655, 2351.576716191085, 2374.2402431222017, 2400.6519054737055, 2401.3036219496325, 2432.185217951979, 2135.2419890938727, 2206.1396055538353, 2209.149477451185, 2211.281333566589, 2350.083467447697, 2397.7122745270503, 2427.7450867658995, 2429.356220601542, 2434.3183908505735, 2436.951260974771, 2066.6590012647894, 2379.214859096494, 2418.9395265118515, 2420.9878950605134, 2426.7451917548756, 8825.867611985825, 8870.778230544223, 8896.332775041834, 8903.332250081205, 8914.375993680445, 5190.039842629088, 5428.131498960187, 5436.836894893159, 5441.428649991733, 5452.318460192476, 3470.5314782504292, 3606.5131207286945, 3655.853765849363, 3677.9080522987138, 3683.3001729671546, 959.8625628630026, 1006.4313662780505, 1010.8281592129356, 1078.482328482325, 1099.5766629847487, 11569.53721851125, 11639.301641901428, 11663.12526560503, 11668.299902005821, 11670.591529296435, 4526.59260666535, 4684.063187362541, 4782.0, 4797.664163508591, 4803.615710743132, 9845.113939745457, 9859.35914165577, 9866.556004979793, 9877.456739879375, 9889.851652225223, 5347.893042139135, 5397.758515541369, 5403.540699040625, 5410.540104091197, 5413.2150838128255, 4746.5253474652945, 4917.704937703749, 4967.0, 4969.503049695074, 4975.4278258000795, 3769.151940813295, 3806.371948628501, 3813.656770890633, 3866.130120722815, 3919.0594257378025, 1038.3717850700368, 1174.2191442690514, 1174.518447436564, 1187.329159025148, 1188.5542921404474, 751.5227830327781, 837.9078301386843, 883.2315885179935, 895.9283257339397, 935.8783358163395, 5039.622028347889, 5779.913301300484, 5782.855428614318, 5911.586188966731, 6169.629822210592, 897.7117835905497, 920.7293934370526, 935.3265648732902, 963.4700914496999, 992.161623428202, 3883.980580097138, 3887.7084218683713, 3901.6293452122004, 3930.076432038526, 4007.6593489553716, 10660.573577056986, 10746.0, 10862.185336099825, 10865.293755905841, 10881.782364352668, 10792.298500597437, 10820.97200765926, 10821.945890270656, 10828.675139745821, 10844.620438284623, 7801.024871891013, 8128.390370722102, 8159.306458950937, 8281.8343633127, 8301.2943899768, 5043.2687260347775, 5266.289050978069, 5818.359980402068, 5958.766884249839, 5979.671118088547, 9688.467134307399, 9693.22454203648, 9752.561134748812, 9979.401235925867, 10131.341462805189, 9905.207583393167, 10164.0, 10177.440240786827, 10278.17774578047, 10282.537285822305, 8223.876641850258, 8253.95873020631, 8365.790855228668, 8371.916280837357, 8385.790355241168, 8034.718784842503, 8125.79685507867, 8159.83680326402, 8236.341092712688, 8275.54484503358, 7314.780556583311, 7371.984470613814, 7423.331900129015, 7434.7769566913075, 7631.084269887649, 7280.526765760209, 7327.560346379234, 7375.704971801068, 7434.962825185839, 7453.142888567884, 5426.2674538936735, 6732.3267673232285, 6819.795406137824, 6847.554908930903, 6934.791956241321, 4153.584641535822, 4901.191303434894, 4924.9507504924495, 4925.482824303396, 5029.371328583927, 4877.926831097608, 4973.651844370859, 4997.0, 5044.041632089891, 5113.284140220298], "value": 4580.794440699764, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.0743648408177, 301.54767848227647, 308.1740934296087, 311.89395605494127, 312.66388632220367, 5307.442718514553, 5326.280952071474, 5339.786408543659, 5407.864803379917, 5436.836894893149, 5083.339165908436, 5309.177077552976, 5358.437364076764, 5361.587285721431, 5412.891742165154, 3134.7335476484527, 3861.555921069085, 3993.4608827808165, 4041.3632478846116, 4045.664930572904, 3888.5333759948703, 4078.3882417637296, 4078.89802754932, 4116.382542618616, 4127.318992366256, 3487.877924272651, 4024.9798751006206, 4053.7365071270274, 4060.776657283863, 4070.124923141524, 3750.2124553843723, 3813.2945405100145, 4028.234635419261, 4034.2334956358345, 4051.8727667974254, 2922.956155657667, 3513.1919658478437, 3524.9118772030647, 3537.2748586539956, 3539.7168226541817, 3781.243751249761, 4800.207965685658, 5174.586033117379, 5259.447757985433, 5268.0517506848755, 4402.493713222988, 4610.193216187154, 4657.371254880582, 4690.788914498821, 4712.552307530779, 4775.4241100436775, 5243.606729495303, 5389.541888939445, 5605.80379686709, 5631.71841407928, 3416.692497675196, 3832.329342365075, 3884.6403758684232, 3921.156951255494, 3943.132510847609, 5030.496950304977, 5097.490250974873, 5521.503064724154, 5902.557308201859, 5924.644521328734, 3310.30483598447, 3819.9113252723396, 3845.9807700961314, 3861.4014827701753, 3880.0, 3352.0446672698163, 3399.5240666306736, 3681.318955993096, 3861.0347413146715, 3942.2706799242233, 4182.519010313792, 4231.576842315805, 4596.057808149321, 4614.246586297186, 4629.412205540732, 5143.331366922276, 5507.420176885057, 5601.915971260434, 5613.7193140342815, 5756.539476841843, 1314.842218933734, 1340.222670850904, 1341.4298922957898, 1346.1519242876925, 1348.7726169185994, 771.8957940677936, 812.6668066092874, 814.621201141472, 823.1768231768232, 837.7486753973783, 5022.296878437021, 5097.46476619957, 5101.821436249714, 5137.152369859006, 5339.919901201485, 5470.261514695465, 5569.944300557024, 5747.942520574825, 5912.467877890925, 5930.406959304035, 4967.105920934194, 5205.713685747321, 5215.24378965048, 5262.052830490472, 5329.0, 2762.5303698371326, 2947.6904924982996, 3037.767241077806, 3082.152408087794, 3108.626964764243, 5196.090684130338, 5450.811275403854, 5986.880262394728, 6090.786822461193, 6158.630482171084, 4752.809887604457, 5266.0, 5287.947120528823, 5986.461218490357, 6029.517638588903, 5279.894402112013, 5484.890302194013, 5682.346530149003, 5960.821175364746, 6050.515958723292, 4810.783514741915, 5543.501084902378, 5656.5757568181725, 5843.181954526454, 5890.970545147246, 5539.612227144061, 5676.68778217202, 5720.48515633595, 5798.449147330997, 5847.44449277318, 6034.978282275487, 6075.450760056334, 6124.0, 6126.172966649446, 6145.539084568764, 2741.753242208211, 2926.897558585439, 3263.547721264015, 3282.458394364903, 3413.470912008543, 3929.685625149924, 4518.6846561533, 4619.0, 4821.927671084866, 4883.853484395474, 4713.2458806590785, 4771.332013518179, 4847.684900481458, 4853.854384368475, 4892.425582080766, 4542.139910295951, 4771.976140119416, 4792.784324705466, 4833.73414462208, 4837.992233223173, 3721.53896875908, 4133.251387827061, 4425.358323043205, 4656.8125128092115, 4659.320890487915, 4839.661223714306, 5332.9733351333, 5600.243967064394, 5764.942350576441, 5821.476067153976, 4605.0, 5518.475744804237, 5524.569189556582, 5560.694161821139, 5596.636218645775], "value": 3989.002549016273, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.7946257197696, 654.6693919570613, 673.4477728262823, 732.5970716106141, 768.2854944901243, 11793.823092653607, 14614.853851461483, 15183.772243416344, 15198.316075776589, 15663.60840978976, 13824.516141935035, 14143.929280353585, 14165.71668566628, 14172.149671019746, 14241.501547445841, 671.8790617688815, 836.8159005018886, 852.2840813716477, 853.1042405474258, 853.4623187391934, 688.9793306200822, 696.6551556979302, 697.0206859362578, 699.7096205074888, 829.1128492513013, 905.529124855075, 909.940853844498, 916.6241840845255, 917.3395155488072, 921.7280902133887, 905.7011186308536, 906.1120102299717, 906.5920335848862, 907.7049958763429, 911.6672414568701, 517.8679436743644, 650.2035007116292, 675.4191395399952, 675.8344205669594, 677.701811203069, 14182.43270269188, 14313.0, 14319.928400357932, 14358.71282574353, 14367.712645747026, 12194.0, 12429.627111186679, 12548.560800372034, 12743.872561274362, 13306.467741290337, 12308.569200077955, 12325.383730813424, 12429.564965226264, 12737.617871463779, 12977.87022129776, 4393.36296237047, 4503.617192538638, 4504.0, 4580.679352445331, 4660.18446771817, 104118.0, 110736.4463177687, 111093.0, 111303.86094016403, 111575.0, 10009.749756256006, 10279.817820950537, 10349.844752328721, 10653.094486968694, 10659.520321585547, 19322.32371866978, 19620.0, 19629.116689748997, 19651.803481965282, 19696.803031969495, 6459.515536334794, 7408.814779630445, 7520.435967302475, 7602.885956710654, 7789.883151752728, 4290.141971605629, 4306.590873866978, 4324.35134729793, 4449.510553839075, 4471.1728330259, 3270.460374038257, 3369.1745522347182, 3371.072954937412, 3376.729861611065, 3720.5535335759882, 700.8318003679183, 701.8210356359198, 704.9295070492909, 714.7420539849902, 722.5375759513915, 598.8472939400425, 651.4039653716796, 653.9340874374739, 678.7115475922714, 686.9003994420781, 8557.743267701979, 9079.727608171765, 9090.909090909006, 9215.308851836005, 9225.261979041661, 553.4161459660016, 620.8758248350348, 636.462189449914, 669.2838662631035, 687.189116842121, 4378.321360189176, 4381.759003254788, 4386.18855511725, 4413.271810151353, 4571.131485017836, 101200.49399752954, 139604.0, 147433.525664742, 151071.24464377607, 153326.23336883244, 135331.6466835319, 135773.0, 140391.29804350913, 141371.0, 142313.44216394465, 116967.0, 117831.41084294523, 118711.0, 120011.19843221782, 121665.17502237296, 8528.0, 8588.202962999825, 8599.0, 8644.394892357475, 8827.426217295855, 60686.0, 63547.68226159024, 64877.0, 65445.67277163584, 68531.31468685449, 79233.60383198046, 82565.17434825575, 82929.0, 86514.56742716246, 100487.99512004787, 12123.575674851338, 12498.75002499963, 12798.61604151877, 13167.868321317048, 13354.465821367425, 13754.105983111065, 13884.58346249614, 13951.511697090553, 14198.92900535532, 14425.7836132456, 13108.082434229895, 13259.826663771179, 13284.933575332061, 13338.799918001432, 13558.38987245596, 12974.89713374336, 13122.671933201746, 13491.392887319898, 13647.522336718168, 13829.0, 12944.676383090122, 13071.019673524714, 13514.256715880721, 13657.590272291847, 13803.964702647543, 11304.830427543759, 11336.12512261787, 11364.54541818318, 11448.141389395994, 11616.361100139573, 10435.478226088817, 10567.94716026415, 10886.426177764695, 11141.777164456827, 11163.49764260594], "value": 7688.990140243631, "unit": "score"}], "name": "dromaeo_css", "value": 7332.026043931793, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 119.0, 115.0, 116.0, 114.0, 115.0, 113.0, 115.0, 125.0], "value": 116.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 115.0, 129.0, 162.0, 109.0, 130.0, 129.0, 107.0, 159.0, 109.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 183.0, 182.0, 185.0, 181.0, 180.0, 182.0, 183.0, 183.0, 184.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 73.0, 78.0, 160.0, 59.0, 58.0, 58.0, 58.0, 152.0, 78.0], "value": 85.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 131.0, 71.0, 69.0, 78.0, 142.0, 91.0, 98.0, 118.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 87.0, 87.0, 85.0, 89.0, 86.0, 89.0, 85.0], "value": 87.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 102.0, 142.0, 94.0, 105.0], "value": 101.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 86.0, 83.0, 83.0, 81.0, 84.0, 84.0, 86.0, 84.0], "value": 83.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 55.0, 54.0, 53.0, 55.0, 53.0, 55.0, 54.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 76.0, 75.0, 72.0, 71.0, 69.0, 70.0, 69.0, 71.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 86.0, 88.0, 86.0, 85.0, 107.0, 105.0, 84.0, 87.0], "value": 90.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 138.0, 137.0, 166.0, 152.0, 127.0, 160.0, 130.0, 189.0, 158.0], "value": 149.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 175.0, 172.0, 172.0, 172.0, 172.0, 171.0, 173.0, 182.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 68.0, 66.0, 68.0, 67.0, 67.0, 67.0, 69.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1489.5000000000002, "alertThreshold": 2.0}]} 11:22:24 INFO - Return code: 0 11:22:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:22:24 INFO - # TBPL SUCCESS # 11:22:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:22:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:22:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:22:24 INFO - 2016-09-06 11:22:24.260 screenresolution[1670:10809] starting screenresolution argv=screenresolution get 11:22:24 INFO - 2016-09-06 11:22:24.262 screenresolution[1670:10809] Display 0: 1600x1200x32@60 11:22:24 INFO - 2016-09-06 11:22:24.268 screenresolution[1671:10812] starting screenresolution argv=screenresolution list 11:22:24 INFO - Available Modes on Display 0 11:22:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:22:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:22:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:22:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:22:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:22:24 INFO - Intel Iris: 11:22:24 INFO - Chipset Model: Intel Iris 11:22:24 INFO - Type: GPU 11:22:24 INFO - Bus: Built-In 11:22:24 INFO - VRAM (Dynamic, Max): 1536 MB 11:22:24 INFO - Vendor: Intel (0x8086) 11:22:24 INFO - Device ID: 0x0a2e 11:22:24 INFO - Revision ID: 0x0009 11:22:24 INFO - Displays: 11:22:24 INFO - Display: 11:22:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:22:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:22:24 INFO - Display Serial Number: 1600x1200 60 11:22:24 INFO - Main Display: Yes 11:22:24 INFO - Mirror: Off 11:22:24 INFO - Online: Yes 11:22:24 INFO - Rotation: Supported 11:22:24 INFO - Return code: 0 11:22:24 INFO - Running post-action listener: _resource_record_post_action 11:22:24 INFO - [mozharness: 2016-09-06 18:22:24.501920Z] Finished run-tests step (success) 11:22:24 INFO - Running post-run listener: _resource_record_post_run 11:22:24 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 31902720; Write bytes: 705375232; Read time: 198; Write time: 1972 11:22:24 INFO - TinderboxPrint: CPU usage
53.5% 11:22:24 INFO - TinderboxPrint: I/O read bytes / time
31,902,720 / 198 11:22:24 INFO - TinderboxPrint: I/O write bytes / time
705,375,232 / 1,972 11:22:24 INFO - TinderboxPrint: CPU idle
2,255.8 (46.5%) 11:22:24 INFO - TinderboxPrint: CPU system
969.1 (20.0%) 11:22:24 INFO - TinderboxPrint: CPU user
1,628.8 (33.6%) 11:22:24 INFO - TinderboxPrint: Swap in / out
434,208,768 / 0 11:22:24 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 389898752; Write bytes: 383604736; Read time: 28959; Write time: 793 11:22:24 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 30977024; Write bytes: 297530368; Read time: 186; Write time: 1117 11:22:24 INFO - Running post-run listener: _upload_blobber_files 11:22:24 INFO - Blob upload gear active. 11:22:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:22:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:22:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:22:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:22:25 INFO - (blobuploader) - INFO - Open directory for files ... 11:22:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:22:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:22:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:22:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:22:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:22:26 INFO - (blobuploader) - INFO - Done attempting. 11:22:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:22:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:22:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:22:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:22:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:22:27 INFO - (blobuploader) - INFO - Done attempting. 11:22:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:22:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:22:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:22:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:22:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:22:29 INFO - (blobuploader) - INFO - Done attempting. 11:22:29 INFO - (blobuploader) - INFO - Iteration through files over. 11:22:29 INFO - Return code: 0 11:22:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:22:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:22:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6494fea25b88039d0f060d26825e359504442c31b8b66c60e1f62ceba5ebc4d6cb32f4769ea4be53832069df44f9c800511570bf9a42be29862650cfacb5052b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a3d4528b7db3def0d2095fd7530878e9525bcc2ef8b9776be71dd06752aa5e5e8610f8c6d458773c03f2d789e5ae3513c0dfe69697e40d43d1f68be29419e42e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/620b6addcad825f9fbae754f5a76bdcdaa6a62145a81e3a8dadcf9a92d2c440fe22bbe2047bda0793bf6414a6b9c8a849b42e0462a43741691bfd764ae6af51b"} 11:22:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:22:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:22:29 INFO - Contents: 11:22:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6494fea25b88039d0f060d26825e359504442c31b8b66c60e1f62ceba5ebc4d6cb32f4769ea4be53832069df44f9c800511570bf9a42be29862650cfacb5052b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a3d4528b7db3def0d2095fd7530878e9525bcc2ef8b9776be71dd06752aa5e5e8610f8c6d458773c03f2d789e5ae3513c0dfe69697e40d43d1f68be29419e42e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/620b6addcad825f9fbae754f5a76bdcdaa6a62145a81e3a8dadcf9a92d2c440fe22bbe2047bda0793bf6414a6b9c8a849b42e0462a43741691bfd764ae6af51b"} 11:22:29 INFO - Running post-run listener: copy_logs_to_upload_dir 11:22:29 INFO - Copying logs to upload dir... 11:22:29 INFO - mkdir: /builds/slave/test/build/upload/logs 11:22:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.795855 ========= master_lag: 1.29 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-09-06 11:22:31.279595) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-06 11:22:31.282647) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2GMTe5weG5/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6494fea25b88039d0f060d26825e359504442c31b8b66c60e1f62ceba5ebc4d6cb32f4769ea4be53832069df44f9c800511570bf9a42be29862650cfacb5052b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a3d4528b7db3def0d2095fd7530878e9525bcc2ef8b9776be71dd06752aa5e5e8610f8c6d458773c03f2d789e5ae3513c0dfe69697e40d43d1f68be29419e42e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/620b6addcad825f9fbae754f5a76bdcdaa6a62145a81e3a8dadcf9a92d2c440fe22bbe2047bda0793bf6414a6b9c8a849b42e0462a43741691bfd764ae6af51b"} build_url:https://queue.taskcluster.net/v1/task/Lv7yCflATWaf6nS5Qd2uwA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010998 build_url: 'https://queue.taskcluster.net/v1/task/Lv7yCflATWaf6nS5Qd2uwA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6494fea25b88039d0f060d26825e359504442c31b8b66c60e1f62ceba5ebc4d6cb32f4769ea4be53832069df44f9c800511570bf9a42be29862650cfacb5052b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a3d4528b7db3def0d2095fd7530878e9525bcc2ef8b9776be71dd06752aa5e5e8610f8c6d458773c03f2d789e5ae3513c0dfe69697e40d43d1f68be29419e42e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/620b6addcad825f9fbae754f5a76bdcdaa6a62145a81e3a8dadcf9a92d2c440fe22bbe2047bda0793bf6414a6b9c8a849b42e0462a43741691bfd764ae6af51b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-06 11:22:31.317060) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 11:22:31.317799) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2GMTe5weG5/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.xkNhyN2uFs/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005082 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 11:22:31.370850) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-06 11:22:31.371761) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-06 11:22:31.372558) ========= ========= Total master_lag: 1.62 =========