builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0103 starttime: 1479758461.63 results: success (0) buildid: 20161121093909 builduid: 0a97bebe3a2641f785394484d52603a5 revision: 6296ed3dbefd133bba324230ec4f5a07d37041e1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 12:01:01.630010) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 12:01:01.630466) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 12:01:01.630778) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 12:01:01.762529) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 12:01:01.762945) ========= 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.yLWoVChwxG/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.1dP3fHYaCF/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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-11-21 12:01:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.1M=0.001s 2016-11-21 12:01:02 (14.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.624552 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 12:01:02.414034) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 12:01:02.414480) ========= 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.yLWoVChwxG/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.1dP3fHYaCF/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.019737 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 12:01:02.463722) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-21 12:01:02.464091) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6296ed3dbefd133bba324230ec4f5a07d37041e1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6296ed3dbefd133bba324230ec4f5a07d37041e1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yLWoVChwxG/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.1dP3fHYaCF/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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-11-21 12:01:02,549 truncating revision to first 12 chars 2016-11-21 12:01:02,549 Setting DEBUG logging. 2016-11-21 12:01:02,549 attempt 1/10 2016-11-21 12:01:02,549 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6296ed3dbefd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-21 12:01:03,717 unpacking tar archive at: mozilla-beta-6296ed3dbefd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.431411 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-21 12:01:03.936094) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 12:01:03.936372) ========= script_repo_revision: 6296ed3dbefd133bba324230ec4f5a07d37041e1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 12:01:03.936828) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 12:01:03.937109) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 12:01:03.960094) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-11-21 12:01:03.960554) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yLWoVChwxG/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.1dP3fHYaCF/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 12:01:04 INFO - MultiFileLogger online at 20161121 12:01:04 in /builds/slave/test 12:01:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:01:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:01:04 INFO - {'append_to_log': False, 12:01:04 INFO - 'base_work_dir': '/builds/slave/test', 12:01:04 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:01:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:01:04 INFO - 'branch': 'Mozilla-Beta', 12:01:04 INFO - 'buildbot_json_path': 'buildprops.json', 12:01:04 INFO - 'config_files': ('talos/mac_config.py',), 12:01:04 INFO - 'default_actions': ('clobber', 12:01:04 INFO - 'read-buildbot-config', 12:01:04 INFO - 'download-and-extract', 12:01:04 INFO - 'populate-webroot', 12:01:04 INFO - 'create-virtualenv', 12:01:04 INFO - 'install', 12:01:04 INFO - 'run-tests'), 12:01:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:01:04 INFO - 'download_minidump_stackwalk': True, 12:01:04 INFO - 'download_symbols': 'ondemand', 12:01:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:01:04 INFO - 'tooltool.py': '/tools/tooltool.py', 12:01:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:01:04 INFO - '/tools/misc-python/virtualenv.py')}, 12:01:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:01:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:01:04 INFO - 'installer_path': 'installer.exe', 12:01:04 INFO - 'log_level': 'info', 12:01:04 INFO - 'log_name': 'talos', 12:01:04 INFO - 'log_to_console': True, 12:01:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:01:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:01:04 INFO - 'opt_config_files': (), 12:01:04 INFO - 'pip_index': False, 12:01:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:01:04 INFO - 'cmd': ('bash', 12:01:04 INFO - '-c', 12:01:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:01:04 INFO - 'enabled': True, 12:01:04 INFO - 'halt_on_failure': False, 12:01:04 INFO - 'name': 'check_screen_resolution'},), 12:01:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:01:04 INFO - 'cmd': ('bash', 12:01:04 INFO - '-c', 12:01:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:01:04 INFO - 'enabled': True, 12:01:04 INFO - 'halt_on_failure': False, 12:01:04 INFO - 'name': 'check_screen_resolution'},), 12:01:04 INFO - 'run_cmd_checks_enabled': True, 12:01:04 INFO - 'sps_profile': False, 12:01:04 INFO - 'sps_profile_interval': 0, 12:01:04 INFO - 'suite': 'dromaeojs-e10s', 12:01:04 INFO - 'system_bits': '32', 12:01:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:01:04 INFO - 'title': 't-yosemite-r7-0103', 12:01:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:01:04 INFO - 'use_talos_json': True, 12:01:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:01:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:01:04 INFO - 'work_dir': 'build'} 12:01:04 INFO - [mozharness: 2016-11-21 20:01:04.171109Z] Running clobber step. 12:01:04 INFO - Running pre-action listener: _resource_record_pre_action 12:01:04 INFO - Running main action method: clobber 12:01:04 INFO - rmtree: /builds/slave/test/build 12:01:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:01:06 INFO - Running post-action listener: _resource_record_post_action 12:01:06 INFO - [mozharness: 2016-11-21 20:01:06.530909Z] Finished clobber step (success) 12:01:06 INFO - [mozharness: 2016-11-21 20:01:06.531198Z] Running read-buildbot-config step. 12:01:06 INFO - Running pre-action listener: _resource_record_pre_action 12:01:06 INFO - Running main action method: read_buildbot_config 12:01:06 INFO - Using buildbot properties: 12:01:06 INFO - { 12:01:06 INFO - "project": "", 12:01:06 INFO - "product": "firefox", 12:01:06 INFO - "script_repo_revision": "production", 12:01:06 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 12:01:06 INFO - "repository": "", 12:01:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 12:01:06 INFO - "buildid": "20161121093909", 12:01:06 INFO - "pgo_build": "False", 12:01:06 INFO - "basedir": "/builds/slave/test", 12:01:06 INFO - "buildnumber": 9, 12:01:06 INFO - "slavename": "t-yosemite-r7-0103", 12:01:06 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 12:01:06 INFO - "platform": "yosemite_r7", 12:01:06 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 12:01:06 INFO - "branch": "mozilla-beta", 12:01:06 INFO - "repo_path": "releases/mozilla-beta", 12:01:06 INFO - "revision": "6296ed3dbefd133bba324230ec4f5a07d37041e1", 12:01:06 INFO - "stage_platform": "macosx64", 12:01:06 INFO - "builduid": "0a97bebe3a2641f785394484d52603a5", 12:01:06 INFO - "slavebuilddir": "test" 12:01:06 INFO - } 12:01:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/WkGqPyHJQ12hJkBH9FurMg/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 12:01:06 INFO - Running post-action listener: _resource_record_post_action 12:01:06 INFO - [mozharness: 2016-11-21 20:01:06.536877Z] Finished read-buildbot-config step (success) 12:01:06 INFO - [mozharness: 2016-11-21 20:01:06.537030Z] Running download-and-extract step. 12:01:06 INFO - Running pre-action listener: _resource_record_pre_action 12:01:06 INFO - Running main action method: download_and_extract 12:01:06 INFO - mkdir: /builds/slave/test/build/tests 12:01:06 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')]} 12:01:06 INFO - trying https://queue.taskcluster.net/v1/task/WkGqPyHJQ12hJkBH9FurMg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 12:01:06 INFO - Downloading https://queue.taskcluster.net/v1/task/WkGqPyHJQ12hJkBH9FurMg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 12:01:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WkGqPyHJQ12hJkBH9FurMg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 12:01:07 INFO - Downloaded 1165 bytes. 12:01:07 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 12:01:07 INFO - Using the following test package requirements: 12:01:07 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 12:01:07 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:01:07 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 12:01:07 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:01:07 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 12:01:07 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 12:01:07 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:01:07 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 12:01:07 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 12:01:07 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:01:07 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 12:01:07 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:01:07 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 12:01:07 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:01:07 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 12:01:07 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:01:07 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 12:01:07 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 12:01:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WkGqPyHJQ12hJkBH9FurMg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 12:01:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WkGqPyHJQ12hJkBH9FurMg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 12:01:07 INFO - Fetch https://queue.taskcluster.net/v1/task/WkGqPyHJQ12hJkBH9FurMg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 12:01:08 INFO - Expected file size: 16231464 12:01:15 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 12:01:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WkGqPyHJQ12hJkBH9FurMg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 12:01:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WkGqPyHJQ12hJkBH9FurMg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 12:01:15 INFO - Fetch https://queue.taskcluster.net/v1/task/WkGqPyHJQ12hJkBH9FurMg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 12:01:15 INFO - Expected file size: 16231464 12:01:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WkGqPyHJQ12hJkBH9FurMg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 12:01:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WkGqPyHJQ12hJkBH9FurMg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 12:01:22 INFO - Fetch https://queue.taskcluster.net/v1/task/WkGqPyHJQ12hJkBH9FurMg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 12:01:22 INFO - Expected file size: 14414089 12:01:23 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')]} 12:01:23 INFO - trying https://queue.taskcluster.net/v1/task/WkGqPyHJQ12hJkBH9FurMg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:01:23 INFO - Downloading https://queue.taskcluster.net/v1/task/WkGqPyHJQ12hJkBH9FurMg/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 12:01:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WkGqPyHJQ12hJkBH9FurMg/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 12:01:26 INFO - Downloaded 86034900 bytes. 12:01:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WkGqPyHJQ12hJkBH9FurMg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:01:26 INFO - mkdir: /builds/slave/test/properties 12:01:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:01:26 INFO - Writing to file /builds/slave/test/properties/build_url 12:01:26 INFO - Contents: 12:01:26 INFO - build_url:https://queue.taskcluster.net/v1/task/WkGqPyHJQ12hJkBH9FurMg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:01:26 INFO - Running post-action listener: _resource_record_post_action 12:01:26 INFO - Running post-action listener: set_extra_try_arguments 12:01:26 INFO - [mozharness: 2016-11-21 20:01:26.629013Z] Finished download-and-extract step (success) 12:01:26 INFO - [mozharness: 2016-11-21 20:01:26.629135Z] Running populate-webroot step. 12:01:26 INFO - Running pre-action listener: _resource_record_pre_action 12:01:26 INFO - Running main action method: populate_webroot 12:01:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:01:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:01:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:01:26 INFO - '--tppagecycles', 12:01:26 INFO - '7'], 12:01:26 INFO - 'tests': ['tsvgm']}}, 12:01:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:01:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:01:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:01:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:01:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:01:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:01:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:26 INFO - 'talos_options': ['--disable-e10s'], 12:01:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:01:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:01:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:26 INFO - 'talos_options': ['--disable-e10s'], 12:01:26 INFO - 'tests': ['damp', 'tps']}, 12:01:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:26 INFO - 'tests': ['damp', 'tps']}, 12:01:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:01:26 INFO - 'tests': ['dromaeo_dom']}, 12:01:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:01:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:01:26 INFO - 'tests': ['basic_compositor_video']}, 12:01:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:01:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:01:26 INFO - 'tests': ['a11yr', 12:01:26 INFO - 'ts_paint', 12:01:26 INFO - 'tpaint', 12:01:26 INFO - 'sessionrestore', 12:01:26 INFO - 'sessionrestore_no_auto_restore', 12:01:26 INFO - 'tabpaint']}, 12:01:26 INFO - 'other-e10s': {'tests': ['a11yr', 12:01:26 INFO - 'ts_paint', 12:01:26 INFO - 'tpaint', 12:01:26 INFO - 'sessionrestore', 12:01:26 INFO - 'sessionrestore_no_auto_restore', 12:01:26 INFO - 'tabpaint']}, 12:01:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:01:26 INFO - 'ts_paint', 12:01:26 INFO - 'tpaint', 12:01:26 INFO - 'sessionrestore', 12:01:26 INFO - 'sessionrestore_no_auto_restore', 12:01:26 INFO - 'tabpaint']}, 12:01:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:01:26 INFO - 'ts_paint', 12:01:26 INFO - 'tpaint', 12:01:26 INFO - 'sessionrestore', 12:01:26 INFO - 'sessionrestore_no_auto_restore', 12:01:26 INFO - 'tabpaint']}, 12:01:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:01:26 INFO - 'tests': ['a11yr', 12:01:26 INFO - 'ts_paint', 12:01:26 INFO - 'tpaint', 12:01:26 INFO - 'sessionrestore', 12:01:26 INFO - 'sessionrestore_no_auto_restore', 12:01:26 INFO - 'tabpaint']}, 12:01:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:01:26 INFO - 'tests': ['a11yr', 12:01:26 INFO - 'ts_paint', 12:01:26 INFO - 'tpaint', 12:01:26 INFO - 'sessionrestore', 12:01:26 INFO - 'sessionrestore_no_auto_restore', 12:01:26 INFO - 'tabpaint']}, 12:01:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:01:26 INFO - 'tests': ['tsvgx', 12:01:26 INFO - 'tsvgr_opacity', 12:01:26 INFO - 'tart', 12:01:26 INFO - 'tscrollx', 12:01:26 INFO - 'cart']}, 12:01:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:01:26 INFO - 'tsvgr_opacity', 12:01:26 INFO - 'tart', 12:01:26 INFO - 'tscrollx', 12:01:26 INFO - 'cart']}, 12:01:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:26 INFO - 'talos_options': ['--disable-e10s'], 12:01:26 INFO - 'tests': ['tp5o']}, 12:01:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:26 INFO - 'tests': ['tp5o']}, 12:01:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:26 INFO - 'talos_options': ['--disable-e10s', 12:01:26 INFO - '--xperf_path', 12:01:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:01:26 INFO - 'tests': ['tp5n']}, 12:01:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:26 INFO - 'talos_options': ['--xperf_path', 12:01:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:01:26 INFO - 'tests': ['tp5n']}}, 12:01:26 INFO - 'talos.zip': {'path': '', 12:01:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:01:26 INFO - Running post-action listener: _resource_record_post_action 12:01:26 INFO - [mozharness: 2016-11-21 20:01:26.648003Z] Finished populate-webroot step (success) 12:01:26 INFO - [mozharness: 2016-11-21 20:01:26.648103Z] Running create-virtualenv step. 12:01:26 INFO - Running pre-action listener: _resource_record_pre_action 12:01:26 INFO - Running main action method: create_virtualenv 12:01:26 INFO - Creating virtualenv /builds/slave/test/build/venv 12:01:26 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 12:01:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:01:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:01:26 INFO - Using real prefix '/tools/python27' 12:01:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:01:27 INFO - Installing distribute.............................................................................................................................................................................................done. 12:01:30 INFO - Installing pip.................done. 12:01:30 INFO - Return code: 0 12:01:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:01:30 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')]} 12:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:30 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')]} 12:01:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:30 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 0x109f70490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ee6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd8ac90b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d84d30>, '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 0x109beadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d7cb20>, '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.yLWoVChwxG/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.1dP3fHYaCF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 12:01:30 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 12:01:30 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 12:01:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yLWoVChwxG/Render', 12:01:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:01:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:01:30 INFO - 'HOME': '/Users/cltbld', 12:01:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:01:30 INFO - 'LOGNAME': 'cltbld', 12:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:30 INFO - 'MOZ_NO_REMOTE': '1', 12:01:30 INFO - 'NO_EM_RESTART': '1', 12:01:30 INFO - 'PAGER': '/bin/cat', 12:01:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:30 INFO - 'PWD': '/builds/slave/test', 12:01:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:01:30 INFO - 'SHELL': '/bin/bash', 12:01:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1dP3fHYaCF/Listeners', 12:01:30 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 12:01:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:01:30 INFO - 'USER': 'cltbld', 12:01:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:01:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:30 INFO - 'XPC_FLAGS': '0x0', 12:01:30 INFO - 'XPC_SERVICE_NAME': '0', 12:01:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:30 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 12:01:30 INFO - Cleaning up... 12:01:30 INFO - Return code: 0 12:01:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:01:30 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')]} 12:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:30 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')]} 12:01:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:30 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 0x109f70490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ee6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd8ac90b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d84d30>, '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 0x109beadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d7cb20>, '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.yLWoVChwxG/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.1dP3fHYaCF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 12:01:30 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 12:01:30 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 12:01:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yLWoVChwxG/Render', 12:01:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:01:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:01:30 INFO - 'HOME': '/Users/cltbld', 12:01:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:01:30 INFO - 'LOGNAME': 'cltbld', 12:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:30 INFO - 'MOZ_NO_REMOTE': '1', 12:01:30 INFO - 'NO_EM_RESTART': '1', 12:01:30 INFO - 'PAGER': '/bin/cat', 12:01:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:30 INFO - 'PWD': '/builds/slave/test', 12:01:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:01:30 INFO - 'SHELL': '/bin/bash', 12:01:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1dP3fHYaCF/Listeners', 12:01:30 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 12:01:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:01:30 INFO - 'USER': 'cltbld', 12:01:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:01:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:30 INFO - 'XPC_FLAGS': '0x0', 12:01:30 INFO - 'XPC_SERVICE_NAME': '0', 12:01:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:30 INFO - Downloading/unpacking psutil>=3.1.1 12:01:30 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 12:01:30 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 12:01:30 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 12:01:30 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 12:01:30 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 12:01:30 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 12:01:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:01:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:01:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:01:34 INFO - Installing collected packages: psutil 12:01:34 INFO - Running setup.py install for psutil 12:01:34 INFO - building 'psutil._psutil_osx' extension 12:01:34 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 12:01:35 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 12:01:35 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 12:01:35 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 12:01:35 INFO - building 'psutil._psutil_posix' extension 12:01:35 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 12:01:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:01:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:01:35 INFO - ^ 12:01:35 INFO - 1 warning generated. 12:01:35 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 12:01:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:01:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:01:35 INFO - Successfully installed psutil 12:01:35 INFO - Cleaning up... 12:01:35 INFO - Return code: 0 12:01:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12: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')]} 12:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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')]} 12:01:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:35 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 0x109f70490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ee6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd8ac90b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d84d30>, '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 0x109beadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d7cb20>, '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.yLWoVChwxG/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.1dP3fHYaCF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 12:01:35 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 12:01:35 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 12:01:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yLWoVChwxG/Render', 12:01:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:01:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:01:35 INFO - 'HOME': '/Users/cltbld', 12:01:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:01:35 INFO - 'LOGNAME': 'cltbld', 12:01:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:35 INFO - 'MOZ_NO_REMOTE': '1', 12:01:35 INFO - 'NO_EM_RESTART': '1', 12:01:35 INFO - 'PAGER': '/bin/cat', 12:01:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:01:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:35 INFO - 'PWD': '/builds/slave/test', 12:01:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:01:35 INFO - 'SHELL': '/bin/bash', 12:01:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1dP3fHYaCF/Listeners', 12:01:35 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 12:01:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:01:35 INFO - 'USER': 'cltbld', 12:01:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:01:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:01:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:35 INFO - 'XPC_FLAGS': '0x0', 12:01:35 INFO - 'XPC_SERVICE_NAME': '0', 12:01:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:01:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:01:35 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 12:01:35 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 12:01:35 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 12:01:35 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 12:01:35 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 12:01:35 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 12:01:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:01:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:01:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:01:38 INFO - Installing collected packages: mozsystemmonitor 12:01:38 INFO - Running setup.py install for mozsystemmonitor 12:01:38 INFO - Successfully installed mozsystemmonitor 12:01:38 INFO - Cleaning up... 12:01:38 INFO - Return code: 0 12:01:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:01:38 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')]} 12:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:38 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')]} 12:01:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:38 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 0x109f70490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ee6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd8ac90b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d84d30>, '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 0x109beadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d7cb20>, '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.yLWoVChwxG/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.1dP3fHYaCF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 12:01:38 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 12:01:38 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 12:01:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yLWoVChwxG/Render', 12:01:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:01:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:01:38 INFO - 'HOME': '/Users/cltbld', 12:01:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:01:38 INFO - 'LOGNAME': 'cltbld', 12:01:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:38 INFO - 'MOZ_NO_REMOTE': '1', 12:01:38 INFO - 'NO_EM_RESTART': '1', 12:01:38 INFO - 'PAGER': '/bin/cat', 12:01:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:01:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:38 INFO - 'PWD': '/builds/slave/test', 12:01:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:01:38 INFO - 'SHELL': '/bin/bash', 12:01:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1dP3fHYaCF/Listeners', 12:01:38 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 12:01:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:01:38 INFO - 'USER': 'cltbld', 12:01:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:01:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:01:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:38 INFO - 'XPC_FLAGS': '0x0', 12:01:38 INFO - 'XPC_SERVICE_NAME': '0', 12:01:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:39 INFO - Downloading/unpacking jsonschema==2.5.1 12:01:39 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 12:01:39 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 12:01:39 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 12:01:39 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 12:01:39 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 12:01:39 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 12:01:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:01:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:01:41 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 12:01:41 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 12:01:41 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 12:01:41 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 12:01:41 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 12:01:41 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 12:01:41 INFO - Downloading functools32-3.2.3-2.tar.gz 12:01:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:01:42 INFO - warning: no files found matching '*.txt' 12:01:42 INFO - no previously-included directories found matching 'build' 12:01:42 INFO - no previously-included directories found matching 'dist' 12:01:42 INFO - no previously-included directories found matching '.git*' 12:01:42 INFO - Installing collected packages: jsonschema, functools32 12:01:42 INFO - Running setup.py install for functools32 12:01:42 INFO - warning: no files found matching '*.txt' 12:01:42 INFO - no previously-included directories found matching 'build' 12:01:42 INFO - no previously-included directories found matching 'dist' 12:01:42 INFO - no previously-included directories found matching '.git*' 12:01:42 INFO - Successfully installed jsonschema functools32 12:01:42 INFO - Cleaning up... 12:01:42 INFO - Return code: 0 12:01:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:01:42 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')]} 12:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:42 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')]} 12:01:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:42 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 0x109f70490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ee6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd8ac90b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d84d30>, '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 0x109beadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d7cb20>, '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.yLWoVChwxG/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.1dP3fHYaCF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 12:01:42 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 12:01:42 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 12:01:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yLWoVChwxG/Render', 12:01:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:01:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:01:42 INFO - 'HOME': '/Users/cltbld', 12:01:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:01:42 INFO - 'LOGNAME': 'cltbld', 12:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:42 INFO - 'MOZ_NO_REMOTE': '1', 12:01:42 INFO - 'NO_EM_RESTART': '1', 12:01:42 INFO - 'PAGER': '/bin/cat', 12:01:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:42 INFO - 'PWD': '/builds/slave/test', 12:01:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:01:42 INFO - 'SHELL': '/bin/bash', 12:01:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1dP3fHYaCF/Listeners', 12:01:42 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 12:01:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:01:42 INFO - 'USER': 'cltbld', 12:01:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:01:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:42 INFO - 'XPC_FLAGS': '0x0', 12:01:42 INFO - 'XPC_SERVICE_NAME': '0', 12:01:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:01:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:01:42 INFO - Cleaning up... 12:01:42 INFO - Return code: 0 12:01:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:01:42 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')]} 12:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:42 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')]} 12:01:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:42 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 0x109f70490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ee6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd8ac90b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d84d30>, '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 0x109beadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d7cb20>, '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.yLWoVChwxG/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.1dP3fHYaCF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 12:01:42 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 12:01:42 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 12:01:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yLWoVChwxG/Render', 12:01:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:01:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:01:42 INFO - 'HOME': '/Users/cltbld', 12:01:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:01:42 INFO - 'LOGNAME': 'cltbld', 12:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:42 INFO - 'MOZ_NO_REMOTE': '1', 12:01:42 INFO - 'NO_EM_RESTART': '1', 12:01:42 INFO - 'PAGER': '/bin/cat', 12:01:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:42 INFO - 'PWD': '/builds/slave/test', 12:01:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:01:42 INFO - 'SHELL': '/bin/bash', 12:01:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1dP3fHYaCF/Listeners', 12:01:42 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 12:01:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:01:42 INFO - 'USER': 'cltbld', 12:01:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:01:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:42 INFO - 'XPC_FLAGS': '0x0', 12:01:42 INFO - 'XPC_SERVICE_NAME': '0', 12:01:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:01:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:42 INFO - Downloading/unpacking blobuploader==1.2.4 12:01:42 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 12:01:42 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 12:01:42 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 12:01:42 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 12:01:42 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 12:01:42 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 12:01:45 INFO - Downloading blobuploader-1.2.4.tar.gz 12:01:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:01:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:01:45 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 12:01:45 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 12:01:45 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 12:01:45 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 12:01:45 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 12:01:45 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 12:01:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:01:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:01:46 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 12:01:46 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 12:01:46 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 12:01:46 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 12:01:46 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 12:01:46 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 12:01:46 INFO - Downloading docopt-0.6.1.tar.gz 12:01:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:01:46 INFO - Installing collected packages: blobuploader, requests, docopt 12:01:46 INFO - Running setup.py install for blobuploader 12:01:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:01:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:01:46 INFO - Running setup.py install for requests 12:01:47 INFO - Running setup.py install for docopt 12:01:47 INFO - Successfully installed blobuploader requests docopt 12:01:47 INFO - Cleaning up... 12:01:47 INFO - Return code: 0 12:01:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:01:47 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')]} 12:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:47 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')]} 12:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:47 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 0x109f70490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ee6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd8ac90b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d84d30>, '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 0x109beadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d7cb20>, '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.yLWoVChwxG/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.1dP3fHYaCF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 12:01:47 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 12:01:47 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 12:01:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yLWoVChwxG/Render', 12:01:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:01:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:01:47 INFO - 'HOME': '/Users/cltbld', 12:01:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:01:47 INFO - 'LOGNAME': 'cltbld', 12:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:47 INFO - 'MOZ_NO_REMOTE': '1', 12:01:47 INFO - 'NO_EM_RESTART': '1', 12:01:47 INFO - 'PAGER': '/bin/cat', 12:01:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:47 INFO - 'PWD': '/builds/slave/test', 12:01:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:01:47 INFO - 'SHELL': '/bin/bash', 12:01:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1dP3fHYaCF/Listeners', 12:01:47 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 12:01:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:01:47 INFO - 'USER': 'cltbld', 12:01:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:01:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:47 INFO - 'XPC_FLAGS': '0x0', 12:01:47 INFO - 'XPC_SERVICE_NAME': '0', 12:01:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:01:47 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-4t8EHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:01:47 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-qIqPRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:01:47 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-xSbqUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:01:48 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-ePMQwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:01:48 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-JHuMNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:01:48 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Zkvdw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:01:48 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-74SOiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:01:48 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-ICPlPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:01:48 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-hlACKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:01:48 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-ZkRYCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:01:48 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-edZ0hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:01:48 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-eAmOir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:01:49 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-nH1oSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:01:49 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-45p6CX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:01:49 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-kLmnC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:01:49 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-nhfabw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:01:49 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-NIWNXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:01:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:01:49 INFO - Running setup.py install for manifestparser 12:01:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:01:49 INFO - Running setup.py install for mozcrash 12:01:49 INFO - Running setup.py install for mozdebug 12:01:49 INFO - Running setup.py install for mozdevice 12:01:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:01:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:01:50 INFO - Running setup.py install for mozfile 12:01:50 INFO - Running setup.py install for mozhttpd 12:01:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:01:50 INFO - Running setup.py install for mozinfo 12:01:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:01:50 INFO - Running setup.py install for mozInstall 12:01:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:01:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:01:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:01:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:01:50 INFO - Running setup.py install for mozleak 12:01:50 INFO - Running setup.py install for mozlog 12:01:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:01:51 INFO - Running setup.py install for moznetwork 12:01:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:01:51 INFO - Running setup.py install for mozprocess 12:01:51 INFO - Running setup.py install for mozprofile 12:01:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:01:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:01:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:01:51 INFO - Running setup.py install for mozrunner 12:01:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:01:51 INFO - Running setup.py install for mozscreenshot 12:01:51 INFO - Running setup.py install for moztest 12:01:51 INFO - Running setup.py install for mozversion 12:01:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:01:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:01:52 INFO - Cleaning up... 12:01:52 INFO - Return code: 0 12:01:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:01:52 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')]} 12:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:52 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')]} 12:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:52 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 0x109f70490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ee6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd8ac90b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d84d30>, '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 0x109beadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d7cb20>, '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.yLWoVChwxG/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.1dP3fHYaCF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 12:01:52 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 12:01:52 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 12:01:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yLWoVChwxG/Render', 12:01:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:01:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:01:52 INFO - 'HOME': '/Users/cltbld', 12:01:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:01:52 INFO - 'LOGNAME': 'cltbld', 12:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:52 INFO - 'MOZ_NO_REMOTE': '1', 12:01:52 INFO - 'NO_EM_RESTART': '1', 12:01:52 INFO - 'PAGER': '/bin/cat', 12:01:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:52 INFO - 'PWD': '/builds/slave/test', 12:01:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:01:52 INFO - 'SHELL': '/bin/bash', 12:01:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1dP3fHYaCF/Listeners', 12:01:52 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 12:01:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:01:52 INFO - 'USER': 'cltbld', 12:01:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:01:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:52 INFO - 'XPC_FLAGS': '0x0', 12:01:52 INFO - 'XPC_SERVICE_NAME': '0', 12:01:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:01:52 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-gSTe3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:01:52 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)) 12:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:01:52 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-m8HU4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:01:52 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)) 12:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:01:52 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-kqoMKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:01:52 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)) 12:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:01:52 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-eDG0AS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:01:52 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)) 12:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:01:52 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-rVgfSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:01:52 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)) 12:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:01:52 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-OISha_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:01:53 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)) 12:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:01:53 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-IMATF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:01:53 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)) 12:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:01:53 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-mc1SuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:01:53 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)) 12:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:01:53 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-43cvRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:01:53 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)) 12:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:01:53 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-nhD9eM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 12:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:01:53 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-19znX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:01:53 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)) 12:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:01:53 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-M7DqAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:01:53 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)) 12:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:01:53 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-ApXRbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:01:53 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)) 12:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:01:53 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-e5eigf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:01:53 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)) 12:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:01:53 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-4FpyUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:01:54 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)) 12:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:01:54 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-NUifOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:01:54 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)) 12:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:01:54 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-_8yqNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:01:54 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)) 12:01:54 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)) 12:01:54 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)) 12:01:54 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)) 12:01:54 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)) 12:01:54 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)) 12:01:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12: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 12: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 12: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 12: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 12: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 12: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 12:01:56 INFO - Downloading blessings-1.6.tar.gz 12:01:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:01:56 INFO - Installing collected packages: blessings 12:01:56 INFO - Running setup.py install for blessings 12:01:57 INFO - Successfully installed blessings 12:01:57 INFO - Cleaning up... 12:01:57 INFO - Return code: 0 12:01:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:01:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:01:57 INFO - Reading from file tmpfile_stdout 12:01:57 INFO - Current package versions: 12:01:57 INFO - blessings == 1.6 12:01:57 INFO - blobuploader == 1.2.4 12:01:57 INFO - docopt == 0.6.1 12:01:57 INFO - functools32 == 3.2.3-2 12:01:57 INFO - jsonschema == 2.5.1 12:01:57 INFO - manifestparser == 1.1 12:01:57 INFO - mozInstall == 1.12 12:01:57 INFO - mozcrash == 0.17 12:01:57 INFO - mozdebug == 0.1 12:01:57 INFO - mozdevice == 0.48 12:01:57 INFO - mozfile == 1.2 12:01:57 INFO - mozhttpd == 0.7 12:01:57 INFO - mozinfo == 0.9 12:01:57 INFO - mozleak == 0.1 12:01:57 INFO - mozlog == 3.4 12:01:57 INFO - moznetwork == 0.27 12:01:57 INFO - mozprocess == 0.23 12:01:57 INFO - mozprofile == 0.28 12:01:57 INFO - mozrunner == 6.12 12:01:57 INFO - mozscreenshot == 0.1 12:01:57 INFO - mozsystemmonitor == 0.3 12:01:57 INFO - moztest == 0.7 12:01:57 INFO - mozversion == 1.4 12:01:57 INFO - psutil == 3.1.1 12:01:57 INFO - requests == 1.2.3 12:01:57 INFO - wsgiref == 0.1.2 12:01:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:01:57 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')]} 12:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:57 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')]} 12:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:57 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 0x109f70490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ee6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd8ac90b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d84d30>, '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 0x109beadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d7cb20>, '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.yLWoVChwxG/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.1dP3fHYaCF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 12:01:57 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 12:01:57 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 12:01:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yLWoVChwxG/Render', 12:01:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:01:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:01:57 INFO - 'HOME': '/Users/cltbld', 12:01:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:01:57 INFO - 'LOGNAME': 'cltbld', 12:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:57 INFO - 'MOZ_NO_REMOTE': '1', 12:01:57 INFO - 'NO_EM_RESTART': '1', 12:01:57 INFO - 'PAGER': '/bin/cat', 12:01:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:57 INFO - 'PWD': '/builds/slave/test', 12:01:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:01:57 INFO - 'SHELL': '/bin/bash', 12:01:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1dP3fHYaCF/Listeners', 12:01:57 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 12:01:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:01:57 INFO - 'USER': 'cltbld', 12:01:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:01:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:57 INFO - 'XPC_FLAGS': '0x0', 12:01:57 INFO - 'XPC_SERVICE_NAME': '0', 12:01:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:57 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)) 12:01:57 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)) 12:01:57 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)) 12:01:57 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)) 12:01:57 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)) 12:01:57 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)) 12:01:57 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)) 12:01:57 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)) 12:01:57 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)) 12:01:57 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)) 12:01:57 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)) 12:01:57 INFO - Cleaning up... 12:01:57 INFO - Return code: 0 12:01:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:01:57 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')]} 12:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:57 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')]} 12:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:57 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 0x109f70490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ee6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd8ac90b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d84d30>, '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 0x109beadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d7cb20>, '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.yLWoVChwxG/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.1dP3fHYaCF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 12:01:57 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 12:01:57 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 12:01:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yLWoVChwxG/Render', 12:01:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:01:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:01:57 INFO - 'HOME': '/Users/cltbld', 12:01:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:01:57 INFO - 'LOGNAME': 'cltbld', 12:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:57 INFO - 'MOZ_NO_REMOTE': '1', 12:01:57 INFO - 'NO_EM_RESTART': '1', 12:01:57 INFO - 'PAGER': '/bin/cat', 12:01:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:57 INFO - 'PWD': '/builds/slave/test', 12:01:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:01:57 INFO - 'SHELL': '/bin/bash', 12:01:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1dP3fHYaCF/Listeners', 12:01:57 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 12:01:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:01:57 INFO - 'USER': 'cltbld', 12:01:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:01:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:57 INFO - 'XPC_FLAGS': '0x0', 12:01:57 INFO - 'XPC_SERVICE_NAME': '0', 12:01:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:01:57 INFO - Cleaning up... 12:01:57 INFO - Return code: 0 12:01:57 INFO - Running post-action listener: _resource_record_post_action 12:01:57 INFO - Running post-action listener: _start_resource_monitoring 12:01:57 INFO - Starting resource monitoring. 12:01:57 INFO - [mozharness: 2016-11-21 20:01:57.949861Z] Finished create-virtualenv step (success) 12:01:57 INFO - [mozharness: 2016-11-21 20:01:57.950950Z] Running install step. 12:01:57 INFO - Running pre-action listener: _resource_record_pre_action 12:01:57 INFO - Running main action method: install 12:01:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:01:58 INFO - Reading from file tmpfile_stdout 12:01:58 INFO - Detecting whether we're running mozinstall >=1.0... 12:01:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:01:58 INFO - Reading from file tmpfile_stdout 12:01:58 INFO - Output received: 12:01:58 INFO - Usage: mozinstall [options] installer 12:01:58 INFO - Options: 12:01:58 INFO - -h, --help show this help message and exit 12:01:58 INFO - -d DEST, --destination=DEST 12:01:58 INFO - Directory to install application into. [default: 12:01:58 INFO - "/builds/slave/test"] 12:01:58 INFO - --app=APP Application being installed. [default: firefox] 12:01:58 INFO - mkdir: /builds/slave/test/build/application 12:01:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 12:02:20 INFO - Reading from file tmpfile_stdout 12:02:20 INFO - Output received: 12:02:20 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 12:02:20 INFO - Running post-action listener: _resource_record_post_action 12:02:20 INFO - [mozharness: 2016-11-21 20:02:20.064164Z] Finished install step (success) 12:02:20 INFO - [mozharness: 2016-11-21 20:02:20.064301Z] Running run-tests step. 12:02:20 INFO - Running pre-action listener: _resource_record_pre_action 12:02:20 INFO - Running main action method: run_tests 12:02:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:02:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:02:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:02:20 INFO - 2016-11-21 12:02:20.079 screenresolution[1907:19699] starting screenresolution argv=screenresolution get 12:02:20 INFO - 2016-11-21 12:02:20.081 screenresolution[1907:19699] Display 0: 1600x1200x32@60 12:02:20 INFO - 2016-11-21 12:02:20.087 screenresolution[1908:19702] starting screenresolution argv=screenresolution list 12:02:20 INFO - Available Modes on Display 0 12:02:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:02:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:02:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:02:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:02:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:02:20 INFO - Intel Iris: 12:02:20 INFO - Chipset Model: Intel Iris 12:02:20 INFO - Type: GPU 12:02:20 INFO - Bus: Built-In 12:02:20 INFO - VRAM (Dynamic, Max): 1536 MB 12:02:20 INFO - Vendor: Intel (0x8086) 12:02:20 INFO - Device ID: 0x0a2e 12:02:20 INFO - Revision ID: 0x0009 12:02:20 INFO - Displays: 12:02:20 INFO - Display: 12:02:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:02:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:02:20 INFO - Display Serial Number: 1600x1200 60 12:02:20 INFO - Main Display: Yes 12:02:20 INFO - Mirror: Off 12:02:20 INFO - Online: Yes 12:02:20 INFO - Rotation: Supported 12:02:20 INFO - Return code: 0 12:02:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:02:20 INFO - Python 2.7.3 12:02:20 INFO - Return code: 0 12:02:20 INFO - grabbing minidump binary from tooltool 12:02:20 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')]} 12:02:20 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 0x109d84d30>, '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 0x109beadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d7cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:02:20 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 12:02:20 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 12:02:20 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 12:02:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:02:20 INFO - Return code: 0 12:02:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:02:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:02:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:02:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:02:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:02:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WkGqPyHJQ12hJkBH9FurMg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0103', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WkGqPyHJQ12hJkBH9FurMg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0103 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:02:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yLWoVChwxG/Render', 12:02:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:02:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:02:20 INFO - 'HOME': '/Users/cltbld', 12:02:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:02:20 INFO - 'LOGNAME': 'cltbld', 12:02:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:02:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:02:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:20 INFO - 'MOZ_NO_REMOTE': '1', 12:02:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:02:20 INFO - 'NO_EM_RESTART': '1', 12:02:20 INFO - 'PAGER': '/bin/cat', 12:02:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:02:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:20 INFO - 'PWD': '/builds/slave/test', 12:02:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:02:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:02:20 INFO - 'SHELL': '/bin/bash', 12:02:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1dP3fHYaCF/Listeners', 12:02:20 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 12:02:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:02:20 INFO - 'USER': 'cltbld', 12:02:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:02:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:02:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:20 INFO - 'XPC_FLAGS': '0x0', 12:02:20 INFO - 'XPC_SERVICE_NAME': '0', 12:02:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:02:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WkGqPyHJQ12hJkBH9FurMg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0103', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:02:20 INFO - mozversion application_buildid: 20161121093909 12:02:20 INFO - mozversion application_changeset: 6296ed3dbefd133bba324230ec4f5a07d37041e1 12:02:20 INFO - mozversion application_display_name: Firefox 12:02:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:02:20 INFO - mozversion application_name: Firefox 12:02:20 INFO - mozversion application_remotingname: firefox 12:02:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:02:20 INFO - mozversion application_vendor: Mozilla 12:02:20 INFO - mozversion application_version: 51.0 12:02:20 INFO - mozversion platform_buildid: 20161121093909 12:02:20 INFO - mozversion platform_changeset: 6296ed3dbefd133bba324230ec4f5a07d37041e1 12:02:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:02:20 INFO - mozversion platform_version: 51.0 12:02:20 INFO - using testdate: 1479758540 12:02:20 INFO - actual date: 1479758540 12:02:20 INFO - starting webserver on 'localhost:56623' 12:02:20 INFO - SUITE-START | Running 2 tests 12:02:20 INFO - TEST-START | dromaeo_css 12:02:20 INFO - operating with platform_type : mac_ 12:02:20 INFO - Initialising browser for dromaeo_css test... 12:02:20 INFO - TEST-INFO | started process 1918 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmprtSXkJ/profile http://localhost:56623/getInfo.html) 12:02:23 INFO - PROCESS | 1918 | __metrics Screen width/height:1600/1200 12:02:23 INFO - PROCESS | 1918 | colorDepth:24 12:02:23 INFO - PROCESS | 1918 | Browser inner width/height: 1024/689 12:02:23 INFO - PROCESS | 1918 | __metrics 12:02:23 ERROR - PROCESS | 1918 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3015: TypeError: this.tabs is undefined 12:02:23 INFO - TEST-INFO | 1918: exit 0 12:02:23 INFO - Browser initialized. 12:02:23 INFO - Running cycle 1/1 for dromaeo_css test... 12:02:23 INFO - TEST-INFO | started process 1922 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmprtSXkJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:02:36 INFO - PROCESS | 1922 | RSS: Main: 174665728 12:02:36 INFO - PROCESS | 1922 | 12:03:25 INFO - PROCESS | 1922 | 1479758605640 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] 12:05:36 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:56623/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56623/tests/dromaeo/cssquery-ext.html) 12:05:37 INFO - PROCESS | 1922 | RSS: Main: 185921536 12:05:37 INFO - PROCESS | 1922 | 12:08:40 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:56623/tests/dromaeo/cssquery-ext.html (next: http://localhost:56623/tests/dromaeo/cssquery-jquery.html) 12:08:40 INFO - PROCESS | 1922 | RSS: Main: 197857280 12:08:40 INFO - PROCESS | 1922 | 12:11:42 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:56623/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56623/tests/dromaeo/cssquery-mootools.html) 12:11:43 INFO - PROCESS | 1922 | RSS: Main: 199778304 12:11:43 INFO - PROCESS | 1922 | 12:14:45 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:56623/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56623/tests/dromaeo/cssquery-prototype.html) 12:14:45 INFO - PROCESS | 1922 | RSS: Main: 204275712 12:14:45 INFO - PROCESS | 1922 | 12:17:48 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:56623/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56623/tests/dromaeo/cssquery-yui.html) 12:17:49 INFO - PROCESS | 1922 | RSS: Main: 207376384 12:17:49 INFO - PROCESS | 1922 | 12:20:51 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:56623/tests/dromaeo/cssquery-yui.html (next: http://localhost:56623/tests/dromaeo/cssquery-dojo.html) 12:20:51 INFO - PROCESS | 1922 | RSS: Main: 207945728 12:20:51 INFO - PROCESS | 1922 | 12:20:51 INFO - PROCESS | 1922 | __start_tp_report 12:20:51 INFO - PROCESS | 1922 | _x_x_mozilla_page_load 12:20:51 INFO - PROCESS | 1922 | _x_x_mozilla_page_load_details 12:20:51 INFO - PROCESS | 1922 | |i|pagename|runs| 12:20:51 INFO - PROCESS | 1922 | |0;dojo.html;3089.5365695145724;3167.366526694662;3548.4322508398645;3572.3034008368363;3599.748017638766;4942.802287908484;5991.730372133254;6016.548758843088;6061.605995610283;6070.726817293222;5978.850528736783;5990.1913241712355;6091.573589848701;6104.908426373608;6108.541859360555;5403.810866619679;5421.701806400646;5493.972530137344;5509.237044145855;5509.889802203954;5478.808241711541;5479.6164268501225;5492.670439773607;5494;5510.5316048135755;5332.973335133319;5368.677879327252;5451.291332126818;5467.5625949923915;5508.531774799147;5332.120200166968;5365.812196573141;5424.5660347172525;5445.945540544583;5464.808731694411;5292.20616907467;5353.063213937584;5353.170258609922;5469.453054694539;5490.615656904019;6119.571629985903;6126.632402055846;6171.444569988677;6217.844553886144;6232.968835155795;6197.225346831646;6208.81373558794;6285.151504546873;6350.428461438447;6354.5551811373225;6427.614343139427;6459.483241340681;6472.126262954488;6475.352464753534;6495.8700825983215;6015.578909476382;6093.69531523422;6179.443850053517;6190.783322583688;6196.690165491753;5439.48324909133;6382.8723425531225;6440.8389790255615;6526.869462610816;6531.706073226716;6246;6246.75012999484;6265.373462653789;6267.592606480564;6287.056941458818;6132.9980441463495;6343.27052388972;6351.142595749607;6360.268569114519;6373.808785736435;6181.134641150243;6207.286162091417;6216.7824126155365;6239.937600624026;6320.241571011508;6312.652804095727;6319.273283572356;6321.936780632227;6334.398232167937;6358.109864618957;5060.291559181717;5146.30524879144;5148.948510514847;5159.716215608102;5212.947870521246;4479.440069991251;4555.430571178603;4564.794584243717;4586.036932244199;4594.6783725139585;6079.739852968991;6127.911555504571;6154.046122850965;6163.537734669918;6178.814635560941;6332.208473940757;6405.6797160141805;6407.070974708734;6441.355864413615;6449.774257900951;6089.421504957022;6112.297085835097;6114.297368146176;6141.762184093051;6191.628502289877;5654.943450565442;5659.377468478464;5669.1496275558175;5699.74351154199;5720.970225359475;6633.767818126343;6657.367550082734;6665.433438157714;6683.131192944983;6694.464442844561;6251.71867265965;6283.465905397909;6302.1492098566105;6320.083587879823;6371.617702937839;6615.768448104293;6657.367550082734;6664.633445160563;6673.366030227121;6679.899801503078;5179.9640071985;6336.841578960379;6338.873222535616;6345.4923606112325;6348.047792830927;6029.547783916136;6122.794608433986;6175.4750846176785;6246.250449946036;6347.96826015867;4762.499937506512;4797.736124513185;4850.490698476609;6245.469135123383;6251.031090181029;6219.378062193744;6230.00319948806;6255.46828519581;6258.217722784652;6264.342244064308;5719.914201287067;6036.336003039574;6150.569460137747;6156.199694039746;6173.475254603409;4907.944791869765;5994.460498555151;6172.907406388818;6173.228346456693;6243.531735119794;6207.720652570735;6231.626102433868;6236.812895613139;6239.906401404073;6277.654728989949 12:20:51 INFO - PROCESS | 1922 | |1;ext.html;501.1155310876304;503.5669324381029;505.40109969685926;525.7397588193842;545.0978630366742;39639.801800990994;42891.92770180747;42961.92595185114;43086.13827723447;43105.137897242035;42314;43396.566034339645;43783;43894.34158487625;44018.559814401844;8427.873581896261;10068.446235457048;10228.48857557123;10237.385756854575;10241.743956401113;10012.098911097999;10077.39535627861;10083.44541050242;10083.546240419199;10093.545790439448;8617.138286171396;10142.492875356204;10154.593816247341;10175.18598512121;10183.18534517237;10052.44711540865;10095.39427634337;10097.040781125781;10098;10127.189824814071;8564.314854811662;10027.097561219525;10035.29752917296;10109.797804043952;10124.240681948882;33166.6683333166;33247.6675233247;42602.786986065184;42607.786961064994;42758.14483710339;3305.173706573357;3535.611082780892;3704.814759262053;3985.820638071265;4377.518472967971;31402.84298578515;31671;32040.679593204004;33513.659453621825;33872.49191262133;3248.4640034394297;3426.8971930842113;3428.3143371325837;3445.9483107753404;3448.517207590939;550010;554835;555705.9999999959;559085.2045739786;562840;67374;67913.98129028069;67943.66028169828;67981;68120.65939670369;35106.82446587751;36053.918382448566;36433.453498197545;37470.25059498795;38145.04637384087;17769;17885.910570447326;17916.55208619795;17922.91038544825;17966.101694915204;13498.392572334269;13519.662008449868;13557;13615.931920340336;13657.521986730615;16694.49916502507;19594.70607940882;19652.70520942187;19991.000449977444;20008.69986950197;8456.238938495564;8550.921668199444;8652.913470865336;8683.56582170889;8695.782605434788;890.4078787606298;1048.5124417146064;1071.1751950997843;1094.3215206571977;1109.9278546894427;31345.373092538022;31569;31618.367632647678;31637.892673756767;31665.683343166733;1069.8020866139789;1097.5116073347283;1181.0492553494519;1189.8647064983656;1205.5057426455112;15795;16632;16645.7515686324;16676.33294668224;16715.16424178786;756944;761916;768787;774042;775212;60629.39370606326;61282.69358653178;61402.692986534785;61462.692686536284;61493.69253153705;1428.1573871415915;1462.4223431744615;1472.698096890135;1477.290900367808;1479.186447453896;29864;31082.844585776926;31669.317955855484;31962.20094497656;32069.839650801598;51753.7412312936;52121;52473.7376313116;52482.212766809294;52696.20955685591;636882;638237;638927;641525;641922;26902;26948.32629184286;27878.58182127229;27951.72048279491;28041.71958280391;49159.75420122877;50190;50223.74888125536;50356;50642.74678626583;40725.79637101914;41540.79229603833;41760.81145226899;42671.786641066596;42986;40999;41676.58323416727;41885.16229675328;42328.15343693047;42632.57367426286;32525.34949301048;38981.6101838978;39188.216235674554;40133.799331004324;40262.39606405965;35091.82454087713;36780.26439471142;37224.62775372212;37239.88280351594;37274.627253727114;27067.86466067736;27120.32199195036;27313.726862731117;27382.726172738017;27387.86306068457 12:20:51 INFO - PROCESS | 1922 | |2;jquery.html;350.9982450087749;359.63497050493737;381.47547122706277;384.6614978818639;411.7241448229686;16246;18687.813121868778;18777.15502802374;21653.891730541327;22175.66736498954;11734.53061877524;11870.7625847483;12193.878061219386;12255.571055013077;12285.262884226953;4910.877228069291;5391.406945236021;5748.223989761371;5756.971215143918;5770.076787713967;4248.171606536726;4460.910781784362;5293.602979776513;5659.405762394951;6402.327755585667;6357.852862832881;6383.553151279412;6416.935830641703;6421.261554921174;6436.388543088423;6949.478789090813;7155.7137714491355;7163.534370265968;7173.605451700155;7173.60545170018;5982;6175.320714721377;6214.937850621526;6248.718807653621;6262.154609127755;13179.86820131796;13465;13733.725325493435;22922.426939326484;26744;2564.333273348924;2592.5592649249675;2688.2204160793344;2778.749912507884;2934.325105225789;8907.331950103768;10191.796164076677;10349.120324772404;10349.913259107836;10698.304610200312;1912.540990162365;1989.2938007007594;2009.4172689919906;2017;2050.846186536001;78963.01369183234;130263.6973630261;138509;139520.30239848836;140099.29950350284;11533.365664888344;11809.23239989398;11922.1654484187;11939.164258501994;11945.745696701895;12562.057845661611;15001.924990374979;15195.468158614616;15236.238188090772;15291.464798731991;8294.875576866352;8918;9041.00548939616;9072.183503484717;9163.541822908828;8992.100789920956;8998.955005224932;9038.367314288069;9185.95407022974;9197.356185066981;4648.744319062416;4669.322948172496;4681.063787242565;4689.929651055237;4761.119192949315;1643.498732886481;1715.8112607613152;1765.3115285038846;1971.4775584470126;2052.3068468513534;576.20771439271;716.1406312425111;720.81619187108;745.1654147354997;777.5801067423641;17487.38794142199;17548.82451175472;18239.361622343153;18276.177572009292;18438.539036524195;661.9139511863427;815.294770023925;820.3970081989733;839.7732612194674;867.1588559097665;9328.113829186217;9695.175910047585;9708;9735.756606084762;9874.210063194927;616749;619906;622245;633286;638050;118070;137529;140647;142240.28879855535;142957;1021.4228960637216;1023.155896385485;1023.9539220734936;1026.625281772148;1030.8866024737272;13812.930935345259;15508;16824.411145609844;16984.66030679404;17028.404005859735;57268.71365643145;58718.11922821247;58841.411585883594;59857.10214346876;60088;81520.77718834103;85785.57107214424;85923;85986.14013859781;88411.55794221246;5709.714514274353;7236.240194779472;7443.888341674771;7749.690012399441;7783.961080194789;10818.621348252773;11600.187986841178;12759;13569.79645305341;13762.931185344009;8532.786680333042;9088.500132492776;9542.761430964281;11673.007794337576;11678.182527223013;11104.61133860311;11366;11535.538578456768;11592;11796.997255233058;11484.483198256266;12048.638540843789;12049.156559040783;12081.939590302343;12110.818337725117;8399.622017009371;8508.361872859685;8630.741077767678;8630.741077767678;8663.91336086631;9665.371750836173;10632.52153653072;11624.302541847515;11638.70903227426;12042.63872083839 12:20:51 INFO - PROCESS | 1922 | |3;mootools.html;1530.6606719120769;1583.952481425557;1829.8444632206263;1920.654282229198;1988.6519859024677;8261.339092872578;8313;8541.658333666646;8732.694355697551;9325.81348373033;8759.167879051496;8974.237189838872;8985.775355616113;9146.679866204684;9168.54157292136;2444.877756112192;2448.963265551018;2465.469923966347;2466.1615050882697;2477.863717495537;2049.836013118947;2426.745191754867;2482.3049546127113;2489.8879550420183;2497.7127630322566;2461.729209786922;2462.91379801707;2477.2939712182033;2488.154027630605;2490.9252722418355;2445.9877700611473;2455.067074511674;2457.213691618683;2459.754024597544;2466.605343145088;2447.4860279341183;2457.103157347573;2462.938426539333;2463.716672582658;2464.0636558107803;9151.176394124494;9200.861987070199;9244.583993720298;9274.90725092754;9281.814363712756;5437.32033495813;5473.425290344497;5574.442555744434;5574.832755017356;5593.74828132735;3373.527706121145;3542.3977923753023;3602.945955810665;3747.606501317377;3792.355299599075;1093.8195197792354;1103.3876198709713;1117.4301106435696;1135.619567444907;1138.49337045015;10240.23198260126;12109.757804843943;12269.447874845653;12282.324472154029;12292.877071229263;4752.239641657318;4812.759362031955;4854.951450485521;4890.657653964259;4944.184209605375;10304.690859274233;10327.84508232377;10373.948130259301;10452.634157804441;10469.476526173661;5530.944690553123;5545.750441230154;5559.638623489541;5568.52667523257;5584.972075139598;4541.500434952152;4679.298105284167;4895.877603059952;5009.998000399862;5107.463716309734;4067.9593204068174;4086.775227362464;4201.873943781691;4209.7474151551005;4223.176480586256;1306.5753630070265;1328.408858058155;1332.1607387346103;1333.133463248896;1335.105479328852;867.8741582470633;933.0389698610442;943.3915124744501;958.8945216026232;963.802420503795;5914.757900840872;6040.275166979991;6101.176341193971;6104.298005729309;6172.814815555541;926.9397489163183;946.2524605561667;954.4750387286964;1000.849872519128;1010.6664800615779;3311.2715202655377;3570.839312230956;3802.7147963902817;4011.8997025074605;4095.2219078375015;9063;10090.44502552352;11093.278936869077;11459.427028648533;11487.195896287347;11102.61140860066;11169.664910052548;11272.71818204535;11293.774124517464;11318.377489238172;8045.396595255379;8510.78723031929;8622.482651040958;8673.739787806377;8684.305255579538;6034.577579569388;6148.231471066117;6150.507959363151;6173.753049877954;6213.316535181217;10389.272750907365;10389.324693894872;10535.683929482127;10559.732832059895;10574.471276435994;9925.851112233178;10229.693109206735;10276.640317588848;10336.896631033593;10430.478476076318;7138.500304978809;7341.853162936604;7543.698252069856;7586.924130758622;7877.094134174643;8579.056303806452;8748.037715851124;8798.868016979623;8806;8815.118488151134;7617.9619101906355;7748.496347737379;7769.72805951789;7816.140224575406;7868.095169055632;7588.506747061423;7678.462507624413;7688.692452302069;7693.153753087044;7705.49914255594;7200.675969581277;7314.451416143704;7333.743318984023;7349.265073492608;7359.705611775469;5035;5105.106606343949;5122.487751224848;5214.921776173436;5298.940211957547;5078.56832169255;5198.870028249324;5237.3453318335205;5345.064613692666;5359.678419294854 12:20:51 INFO - PROCESS | 1922 | |4;prototype.html;254.8751111955142;256.709917792894;313.1935266688278;316.552078808486;317.29876971892116;4378.496472905616;5441.564674826014;5592.580556458267;5695.8576035599135;5731.621377128492;5317.760700768465;5489.862753431166;5544.445555444454;5562.443755624446;5564.996601223556;3474.513568100468;4257.76582287974;4260.974707957354;4276.957230427694;4306.2033523798045;3705.6479634434686;3906.3749800032;4220.7256528325715;4260.190563792885;4291.377750226231;3331.883384081558;3611.7110631149444;3756.3426400379963;4151.823854751103;4167.74993500391;3731.9626803731885;3872.206197729459;4147.419361289422;4167.624913757776;4175.269327867626;3421.640727723578;3539.345221134098;3558.3061303045915;3572.2676851245433;3624.0758606555423;5471.480209380103;5500.624843789053;5512.503874651301;5527.281453411031;5544.22380866679;3799.9430008549894;4223.704340696153;4832.7825247863575;4849.744868636101;4917.72952487613;4754.66717329787;5294.708791016493;5661.2923384576925;5883.352831188566;5973.910391344133;3193.808371497694;3394.1344957036044;3867.535895692507;3936.940945885814;3986.943459983107;4978.477259887696;5296.861174847426;5588.469095435927;5670.291213598301;6249.093881387219;3880.9521429213955;3945.437963440284;3985;3989.4215338776294;4036.6770658347264;4054.6958978076764;4099.1801639672185;4110.8346573138515;4116.526599441103;4117.670586353084;3987.3420885554137;4044.8179831907637;4648.418947631546;4761.595264402565;4880.169501689012;5163.586913046947;5692.48767610917;5930.495907847881;5951.791687290924;6046.879062418727;1170.7482891178438;1308.7905935050346;1331.633800704814;1390.6036779517992;1394.2889126545535;751.4401770680769;751.7631945937012;808.6886548678801;827.1604321613567;848.974530764078;4099.1801639672185;4137.524184718735;4497.572730590588;4612.630989520831;4746.715197088186;4292.613664770123;4765.0946320199055;4786.090642777861;5152.09372532158;5152.252923326097;3773.7924414157483;3868.96131038686;4023.4166045923175;4528.686680862513;4774.4509381420885;2269.5254453171815;2341.583342078018;2471.6910386201725;2576.561984462646;2623.6851577810785;4449.2881139018245;4527.758759414111;4545.772641386807;5063.1898896176435;5090.055207214438;4251.256030194703;4542.409486766765;4586.564276393738;5149.75985446332;5201.543567801022;5175.611829112831;5426.75579598919;5611.783345578474;6342.334054924167;6458.773942911976;4709.48195698466;5717.714114294352;5985.4912332450485;5999.5800293979;6250.468710159687;5788.363280039108;6057.849008688335;6131.601445906002;6140.846478838065;6174.530187924866;5893.793717219876;5931.555133365101;6391.8721625566295;6397.840053998687;6457.61254324742;3444.2767018925306;4062.5937406259136;4078.286299897447;4080.1227736035707;4086.223617512663;4806.423229212517;5719.48524632785;5808.108567259862;5811.186433899173;6268.247810262797;5249.527542521191;5271.288376069181;5919.881602367843;6064.332923378513;6082.4685609221415;5356.276902618097;5775.21723271258;6116.256866792943;6118.357572454828;6132.693365331626;5218.991826152463;5927.14056461802;5928.103007037706;5956.583039187215;5958.880822383441;6035;6036.849078773066;6088.6042407243385;6090.878182436238;6118.479929206067;5689.203511508309;5916.290045194604;5917;5927.436893495111;5956.791512297222 12:20:51 INFO - PROCESS | 1922 | |5;yui.html;760.232165512832;788.4323287233194;804.5775967617001;833.0960907415462;877.3025444771408;12662.43019064142;14918.552443426688;15441.22793860308;16726.41457548986;16890.577735556602;12462.501499939992;15356.001859879128;15386.846131538709;15390.384384624602;15396.153211573359;813.9104698483162;871.8822958900562;908.4322298563397;940.3934462271831;950.5294879034888;696.2098018748732;726.415235735233;861.9355096455872;886.0917559501498;887.2281115429586;945.0313428735533;946.8958414574391;948.2698322291831;949.050949050949;950.8098380323928;925.6204955968021;941.8587211918199;946.0066929723831;947.729896979361;951.3435729346728;673.2627772589008;706.7385067525049;710.0414440505328;712.0423031023265;712.7398499547679;15435.768463473058;15670.529884103495;15717.842821571752;15731.842681573267;15753.448629298035;14722.969392142555;14775.40898364075;14911.403543858232;14937.477188298357;14951.177685227309;12179.39103044853;12210.32843193624;12313.507459701601;12459.875401246052;12615.306158161298;3158.7946783459;3878.5151856017997;3905.9804700976315;4009.8797036088963;4046.817893194813;123040;127189.36405318006;127568.99999999907;128264.35867820695;128684;10976.835347469794;10987.725306867393;11431.657050288504;11448;11469.942650286695;23025.963831627618;23140.537189256458;23203.419914502272;23250.418739531648;23321.06715731352;7981.441299109123;8021.15777843318;8256.917430825735;8276.29651479619;8304.086550479442;4543.114092751948;4657.1617108920045;4715.056988602293;4720.244760838249;4732.313814496947;3561.4479755637917;3692.6861216796337;3709.1654377765326;3710.888673339804;3712.7215458840697;568.8862227554506;581.6103210848742;682.1847891769288;692.342274838905;696.2098018748757;600.540586451365;610.4140025575497;634.7714822663929;652.1554586810092;658.6476235214137;8635.568221588896;9191.678291259774;9255.259579233645;9398.342116051948;9435.410705562157;579.2267323123677;629.7764293675771;644.7582156691241;644.8452371430823;648.4974145037539;4446.577575130357;4584.541545845389;4609.4699109602825;4615.976920115445;4662.167558501749;102928.97071029343;142742;160501;171569.4264586032;175583;91284.7468108237;124350;127408;135030;144071;75720.9999999989;78870.81693774599;105163;122241;131721;8893.822123557364;9886.653967111404;10116;10392.636257730943;10625.893741062491;62170;64762;67782;67874.66062669655;69593;82342.58828705818;87797.56101219454;94515;96877.0312296868;104150.4792476063;12314.876851231373;13261.336933153496;13315.001374896729;13784.104033238209;14194.148351098967;15431.305591248645;15582.14298213609;15738.449154279546;15993.360265589246;16054.67890642204;12521.74782521777;13955;14211;14326.57020289393;14859.182744949132;12523.4364453598;14100.858991409954;14392.42430302818;14841.58282227001;15124.697506050037;12991.700829916932;13436.328183590585;14334.283285835874;14400.783988239975;14616.92691536578;11604.6518604442;11898.76202475963;12047.337396442928;12078.03375729957;12222.449989750305;11904.880951190376;11916.821247681119;12021.579244726743;12194.268343899394;12285.324307163191 12:20:51 INFO - PROCESS | 1922 | __end_tp_report 12:20:51 INFO - PROCESS | 1922 | __start_cc_report 12:20:51 INFO - PROCESS | 1922 | _x_x_mozilla_cycle_collect,355 12:20:51 INFO - PROCESS | 1922 | __end_cc_report 12:20:51 INFO - PROCESS | 1922 | __startTimestamp1479759651946__endTimestamp 12:20:51 INFO - PROCESS | 1922 | 12:20:51 INFO - PROCESS | 1922 | ------- Summary: start ------- 12:20:51 INFO - PROCESS | 1922 | Number of tests: 6 12:20:51 INFO - PROCESS | 1922 | 12:20:51 INFO - PROCESS | 1922 | [#0] dojo.html Cycles:165 Average:5900.08 Median:6172.91 stddev:675.21 (10.9%) stddev-sans-first:640.28 12:20:51 INFO - PROCESS | 1922 | Values: 3089.5 3167.4 3548.4 3572.3 3599.7 4942.8 5991.7 6016.5 6061.6 6070.7 5978.9 5990.2 6091.6 6104.9 6108.5 5403.8 5421.7 5494.0 5509.2 5509.9 5478.8 5479.6 5492.7 5494.0 5510.5 5333.0 5368.7 5451.3 5467.6 5508.5 5332.1 5365.8 5424.6 5445.9 5464.8 5292.2 5353.1 5353.2 5469.5 5490.6 6119.6 6126.6 6171.4 6217.8 6233.0 6197.2 6208.8 6285.2 6350.4 6354.6 6427.6 6459.5 6472.1 6475.4 6495.9 6015.6 6093.7 6179.4 6190.8 6196.7 5439.5 6382.9 6440.8 6526.9 6531.7 6246.0 6246.8 6265.4 6267.6 6287.1 6133.0 6343.3 6351.1 6360.3 6373.8 6181.1 6207.3 6216.8 6239.9 6320.2 6312.7 6319.3 6321.9 6334.4 6358.1 5060.3 5146.3 5148.9 5159.7 5212.9 4479.4 4555.4 4564.8 4586.0 4594.7 6079.7 6127.9 6154.0 6163.5 6178.8 6332.2 6405.7 6407.1 6441.4 6449.8 6089.4 6112.3 6114.3 6141.8 6191.6 5654.9 5659.4 5669.1 5699.7 5721.0 6633.8 6657.4 6665.4 6683.1 6694.5 6251.7 6283.5 6302.1 6320.1 6371.6 6615.8 6657.4 6664.6 6673.4 6679.9 5180.0 6336.8 6338.9 6345.5 6348.0 6029.5 6122.8 6175.5 6246.3 6348.0 4762.5 4797.7 4850.5 6245.5 6251.0 6219.4 6230.0 6255.5 6258.2 6264.3 5719.9 6036.3 6150.6 6156.2 6173.5 4907.9 5994.5 6172.9 6173.2 6243.5 6207.7 6231.6 6236.8 6239.9 6277.7 12:20:51 INFO - PROCESS | 1922 | 12:20:51 INFO - PROCESS | 1922 | [#1] ext.html Cycles:180 Average:77832.36 Median:35099.32 stddev:177056.17 (504.4%) stddev-sans-first:177457.66 12:20:51 INFO - PROCESS | 1922 | Values: 501.1 503.6 505.4 525.7 545.1 39639.8 42891.9 42961.9 43086.1 43105.1 42314.0 43396.6 43783.0 43894.3 44018.6 8427.9 10068.4 10228.5 10237.4 10241.7 10012.1 10077.4 10083.4 10083.5 10093.5 8617.1 10142.5 10154.6 10175.2 10183.2 10052.4 10095.4 10097.0 10098.0 10127.2 8564.3 10027.1 10035.3 10109.8 10124.2 33166.7 33247.7 42602.8 42607.8 42758.1 3305.2 3535.6 3704.8 3985.8 4377.5 31402.8 31671.0 32040.7 33513.7 33872.5 3248.5 3426.9 3428.3 3445.9 3448.5 550010.0 554835.0 555706.0 559085.2 562840.0 67374.0 67914.0 67943.7 67981.0 68120.7 35106.8 36053.9 36433.5 37470.3 38145.0 17769.0 17885.9 17916.6 17922.9 17966.1 13498.4 13519.7 13557.0 13615.9 13657.5 16694.5 19594.7 19652.7 19991.0 20008.7 8456.2 8550.9 8652.9 8683.6 8695.8 890.4 1048.5 1071.2 1094.3 1109.9 31345.4 31569.0 31618.4 31637.9 31665.7 1069.8 1097.5 1181.0 1189.9 1205.5 15795.0 16632.0 16645.8 16676.3 16715.2 756944.0 761916.0 768787.0 774042.0 775212.0 60629.4 61282.7 61402.7 61462.7 61493.7 1428.2 1462.4 1472.7 1477.3 1479.2 29864.0 31082.8 31669.3 31962.2 32069.8 51753.7 52121.0 52473.7 52482.2 52696.2 636882.0 638237.0 638927.0 641525.0 641922.0 26902.0 26948.3 27878.6 27951.7 28041.7 49159.8 50190.0 50223.7 50356.0 50642.7 40725.8 41540.8 41760.8 42671.8 42986.0 40999.0 41676.6 41885.2 42328.2 42632.6 32525.3 38981.6 39188.2 40133.8 40262.4 35091.8 36780.3 37224.6 37239.9 37274.6 27067.9 27120.3 27313.7 27382.7 27387.9 12:20:51 INFO - PROCESS | 1922 | 12:20:51 INFO - PROCESS | 1922 | [#2] jquery.html Cycles:180 Average:36044.95 Median:370.56 stddev:104931.59 (28317.4%) stddev-sans-first:105191.72 12:20:51 INFO - PROCESS | 1922 | Values: 351.0 359.6 381.5 384.7 411.7 16246.0 18687.8 18777.2 21653.9 22175.7 11734.5 11870.8 12193.9 12255.6 12285.3 4910.9 5391.4 5748.2 5757.0 5770.1 4248.2 4460.9 5293.6 5659.4 6402.3 6357.9 6383.6 6416.9 6421.3 6436.4 6949.5 7155.7 7163.5 7173.6 7173.6 5982.0 6175.3 6214.9 6248.7 6262.2 13179.9 13465.0 13733.7 22922.4 26744.0 2564.3 2592.6 2688.2 2778.7 2934.3 8907.3 10191.8 10349.1 10349.9 10698.3 1912.5 1989.3 2009.4 2017.0 2050.8 78963.0 130263.7 138509.0 139520.3 140099.3 11533.4 11809.2 11922.2 11939.2 11945.7 12562.1 15001.9 15195.5 15236.2 15291.5 8294.9 8918.0 9041.0 9072.2 9163.5 8992.1 8999.0 9038.4 9186.0 9197.4 4648.7 4669.3 4681.1 4689.9 4761.1 1643.5 1715.8 1765.3 1971.5 2052.3 576.2 716.1 720.8 745.2 777.6 17487.4 17548.8 18239.4 18276.2 18438.5 661.9 815.3 820.4 839.8 867.2 9328.1 9695.2 9708.0 9735.8 9874.2 616749.0 619906.0 622245.0 633286.0 638050.0 118070.0 137529.0 140647.0 142240.3 142957.0 1021.4 1023.2 1024.0 1026.6 1030.9 13812.9 15508.0 16824.4 16984.7 17028.4 57268.7 58718.1 58841.4 59857.1 60088.0 81520.8 85785.6 85923.0 85986.1 88411.6 5709.7 7236.2 7443.9 7749.7 7784.0 10818.6 11600.2 12759.0 13569.8 13762.9 8532.8 9088.5 9542.8 11673.0 11678.2 11104.6 11366.0 11535.5 11592.0 11797.0 11484.5 12048.6 12049.2 12081.9 12110.8 8399.6 8508.4 8630.7 8630.7 8663.9 9665.4 10632.5 11624.3 11638.7 12042.6 12:20:51 INFO - PROCESS | 1922 | 12:20:51 INFO - PROCESS | 1922 | [#3] mootools.html Cycles:180 Average:5902.25 Median:4893.27 stddev:3293.79 (67.3%) stddev-sans-first:3286.64 12:20:51 INFO - PROCESS | 1922 | Values: 1530.7 1584.0 1829.8 1920.7 1988.7 8261.3 8313.0 8541.7 8732.7 9325.8 8759.2 8974.2 8985.8 9146.7 9168.5 2444.9 2449.0 2465.5 2466.2 2477.9 2049.8 2426.7 2482.3 2489.9 2497.7 2461.7 2462.9 2477.3 2488.2 2490.9 2446.0 2455.1 2457.2 2459.8 2466.6 2447.5 2457.1 2462.9 2463.7 2464.1 9151.2 9200.9 9244.6 9274.9 9281.8 5437.3 5473.4 5574.4 5574.8 5593.7 3373.5 3542.4 3602.9 3747.6 3792.4 1093.8 1103.4 1117.4 1135.6 1138.5 10240.2 12109.8 12269.4 12282.3 12292.9 4752.2 4812.8 4855.0 4890.7 4944.2 10304.7 10327.8 10373.9 10452.6 10469.5 5530.9 5545.8 5559.6 5568.5 5585.0 4541.5 4679.3 4895.9 5010.0 5107.5 4068.0 4086.8 4201.9 4209.7 4223.2 1306.6 1328.4 1332.2 1333.1 1335.1 867.9 933.0 943.4 958.9 963.8 5914.8 6040.3 6101.2 6104.3 6172.8 926.9 946.3 954.5 1000.8 1010.7 3311.3 3570.8 3802.7 4011.9 4095.2 9063.0 10090.4 11093.3 11459.4 11487.2 11102.6 11169.7 11272.7 11293.8 11318.4 8045.4 8510.8 8622.5 8673.7 8684.3 6034.6 6148.2 6150.5 6173.8 6213.3 10389.3 10389.3 10535.7 10559.7 10574.5 9925.9 10229.7 10276.6 10336.9 10430.5 7138.5 7341.9 7543.7 7586.9 7877.1 8579.1 8748.0 8798.9 8806.0 8815.1 7618.0 7748.5 7769.7 7816.1 7868.1 7588.5 7678.5 7688.7 7693.2 7705.5 7200.7 7314.5 7333.7 7349.3 7359.7 5035.0 5105.1 5122.5 5214.9 5298.9 5078.6 5198.9 5237.3 5345.1 5359.7 12:20:51 INFO - PROCESS | 1922 | 12:20:51 INFO - PROCESS | 1922 | [#4] prototype.html Cycles:180 Average:4558.17 Median:4864.96 stddev:1481.56 (30.5%) stddev-sans-first:1450.08 12:20:51 INFO - PROCESS | 1922 | Values: 254.9 256.7 313.2 316.6 317.3 4378.5 5441.6 5592.6 5695.9 5731.6 5317.8 5489.9 5544.4 5562.4 5565.0 3474.5 4257.8 4261.0 4277.0 4306.2 3705.6 3906.4 4220.7 4260.2 4291.4 3331.9 3611.7 3756.3 4151.8 4167.7 3732.0 3872.2 4147.4 4167.6 4175.3 3421.6 3539.3 3558.3 3572.3 3624.1 5471.5 5500.6 5512.5 5527.3 5544.2 3799.9 4223.7 4832.8 4849.7 4917.7 4754.7 5294.7 5661.3 5883.4 5973.9 3193.8 3394.1 3867.5 3936.9 3986.9 4978.5 5296.9 5588.5 5670.3 6249.1 3881.0 3945.4 3985.0 3989.4 4036.7 4054.7 4099.2 4110.8 4116.5 4117.7 3987.3 4044.8 4648.4 4761.6 4880.2 5163.6 5692.5 5930.5 5951.8 6046.9 1170.7 1308.8 1331.6 1390.6 1394.3 751.4 751.8 808.7 827.2 849.0 4099.2 4137.5 4497.6 4612.6 4746.7 4292.6 4765.1 4786.1 5152.1 5152.3 3773.8 3869.0 4023.4 4528.7 4774.5 2269.5 2341.6 2471.7 2576.6 2623.7 4449.3 4527.8 4545.8 5063.2 5090.1 4251.3 4542.4 4586.6 5149.8 5201.5 5175.6 5426.8 5611.8 6342.3 6458.8 4709.5 5717.7 5985.5 5999.6 6250.5 5788.4 6057.8 6131.6 6140.8 6174.5 5893.8 5931.6 6391.9 6397.8 6457.6 3444.3 4062.6 4078.3 4080.1 4086.2 4806.4 5719.5 5808.1 5811.2 6268.2 5249.5 5271.3 5919.9 6064.3 6082.5 5356.3 5775.2 6116.3 6118.4 6132.7 5219.0 5927.1 5928.1 5956.6 5958.9 6035.0 6036.8 6088.6 6090.9 6118.5 5689.2 5916.3 5917.0 5927.4 5956.8 12:20:51 INFO - PROCESS | 1922 | 12:20:51 INFO - PROCESS | 1922 | [#5] yui.html Cycles:180 Average:25505.51 Median:13239.93 stddev:40766.29 (307.9%) stddev-sans-first:40838.31 12:20:51 INFO - PROCESS | 1922 | Values: 760.2 788.4 804.6 833.1 877.3 12662.4 14918.6 15441.2 16726.4 16890.6 12462.5 15356.0 15386.8 15390.4 15396.2 813.9 871.9 908.4 940.4 950.5 696.2 726.4 861.9 886.1 887.2 945.0 946.9 948.3 949.1 950.8 925.6 941.9 946.0 947.7 951.3 673.3 706.7 710.0 712.0 712.7 15435.8 15670.5 15717.8 15731.8 15753.4 14723.0 14775.4 14911.4 14937.5 14951.2 12179.4 12210.3 12313.5 12459.9 12615.3 3158.8 3878.5 3906.0 4009.9 4046.8 123040.0 127189.4 127569.0 128264.4 128684.0 10976.8 10987.7 11431.7 11448.0 11469.9 23026.0 23140.5 23203.4 23250.4 23321.1 7981.4 8021.2 8256.9 8276.3 8304.1 4543.1 4657.2 4715.1 4720.2 4732.3 3561.4 3692.7 3709.2 3710.9 3712.7 568.9 581.6 682.2 692.3 696.2 600.5 610.4 634.8 652.2 658.6 8635.6 9191.7 9255.3 9398.3 9435.4 579.2 629.8 644.8 644.8 648.5 4446.6 4584.5 4609.5 4616.0 4662.2 102929.0 142742.0 160501.0 171569.4 175583.0 91284.7 124350.0 127408.0 135030.0 144071.0 75721.0 78870.8 105163.0 122241.0 131721.0 8893.8 9886.7 10116.0 10392.6 10625.9 62170.0 64762.0 67782.0 67874.7 69593.0 82342.6 87797.6 94515.0 96877.0 104150.5 12314.9 13261.3 13315.0 13784.1 14194.1 15431.3 15582.1 15738.4 15993.4 16054.7 12521.7 13955.0 14211.0 14326.6 14859.2 12523.4 14100.9 14392.4 14841.6 15124.7 12991.7 13436.3 14334.3 14400.8 14616.9 11604.7 11898.8 12047.3 12078.0 12222.4 11904.9 11916.8 12021.6 12194.3 12285.3 12:20:51 INFO - PROCESS | 1922 | -------- Summary: end -------- 12:20:51 INFO - PROCESS | 1922 | 12:20:52 INFO - TEST-INFO | 1922: exit 0 12:20:52 INFO - TEST-OK | dromaeo_css | took 1111938ms 12:20:52 INFO - TEST-START | kraken 12:20:52 INFO - operating with platform_type : mac_ 12:20:52 INFO - Initialising browser for kraken test... 12:20:52 INFO - TEST-INFO | started process 1927 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpCcVF22/profile http://localhost:56623/getInfo.html) 12:20:55 INFO - PROCESS | 1927 | __metrics Screen width/height:1600/1200 12:20:55 INFO - PROCESS | 1927 | colorDepth:24 12:20:55 INFO - PROCESS | 1927 | Browser inner width/height: 1024/689 12:20:55 INFO - PROCESS | 1927 | __metrics 12:20:55 ERROR - PROCESS | 1927 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3015: TypeError: this.tabs is undefined 12:20:55 INFO - TEST-INFO | 1927: exit 0 12:20:55 INFO - Browser initialized. 12:20:55 INFO - Running cycle 1/1 for kraken test... 12:20:55 INFO - TEST-INFO | started process 1930 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpCcVF22/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:21:07 INFO - PROCESS | 1930 | RSS: Main: 174149632 12:21:07 INFO - PROCESS | 1930 | 12:21:10 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:56623/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56623/tests/kraken/driver.html?testName=audio-beat-detection) 12:21:11 INFO - PROCESS | 1930 | RSS: Main: 186429440 12:21:11 INFO - PROCESS | 1930 | 12:21:14 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:56623/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56623/tests/kraken/driver.html?testName=audio-dft) 12:21:14 INFO - PROCESS | 1930 | RSS: Main: 195174400 12:21:14 INFO - PROCESS | 1930 | 12:21:17 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:56623/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56623/tests/kraken/driver.html?testName=audio-fft) 12:21:18 INFO - PROCESS | 1930 | RSS: Main: 198021120 12:21:18 INFO - PROCESS | 1930 | 12:21:20 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:56623/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56623/tests/kraken/driver.html?testName=audio-oscillator) 12:21:21 INFO - PROCESS | 1930 | RSS: Main: 198201344 12:21:21 INFO - PROCESS | 1930 | 12:21:23 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:56623/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56623/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:21:23 INFO - PROCESS | 1930 | RSS: Main: 199454720 12:21:23 INFO - PROCESS | 1930 | 12:21:26 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:56623/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56623/tests/kraken/driver.html?testName=imaging-darkroom) 12:21:27 INFO - PROCESS | 1930 | RSS: Main: 200265728 12:21:27 INFO - PROCESS | 1930 | 12:21:30 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:56623/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56623/tests/kraken/driver.html?testName=imaging-desaturate) 12:21:30 INFO - PROCESS | 1930 | RSS: Main: 200118272 12:21:30 INFO - PROCESS | 1930 | 12:21:33 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:56623/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56623/tests/kraken/driver.html?testName=json-parse-financial) 12:21:34 INFO - PROCESS | 1930 | RSS: Main: 200605696 12:21:34 INFO - PROCESS | 1930 | 12:21:36 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:56623/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56623/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:21:36 INFO - PROCESS | 1930 | RSS: Main: 200036352 12:21:36 INFO - PROCESS | 1930 | 12:21:38 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:56623/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56623/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:21:39 INFO - PROCESS | 1930 | RSS: Main: 200183808 12:21:39 INFO - PROCESS | 1930 | 12:21:41 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:56623/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56623/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:21:41 INFO - PROCESS | 1930 | RSS: Main: 200167424 12:21:41 INFO - PROCESS | 1930 | 12:21:44 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:56623/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56623/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:21:45 INFO - PROCESS | 1930 | RSS: Main: 200237056 12:21:45 INFO - PROCESS | 1930 | 12:21:48 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:56623/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56623/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:21:49 INFO - PROCESS | 1930 | RSS: Main: 200568832 12:21:49 INFO - PROCESS | 1930 | 12:21:50 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:56623/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56623/tests/kraken/driver.html?testName=ai-astar) 12:21:51 INFO - PROCESS | 1930 | RSS: Main: 202190848 12:21:51 INFO - PROCESS | 1930 | 12:21:51 INFO - PROCESS | 1930 | __start_tp_report 12:21:51 INFO - PROCESS | 1930 | _x_x_mozilla_page_load 12:21:51 INFO - PROCESS | 1930 | _x_x_mozilla_page_load_details 12:21:51 INFO - PROCESS | 1930 | |i|pagename|runs| 12:21:51 INFO - PROCESS | 1930 | |0;ai-astar;107;119;116;115;117;117;117;116;116;117 12:21:51 INFO - PROCESS | 1930 | |1;audio-beat-detection;142;109;110;138;112;120;142;143;161;114 12:21:51 INFO - PROCESS | 1930 | |2;audio-dft;197;207;198;198;197;197;199;195;200;199 12:21:51 INFO - PROCESS | 1930 | |3;audio-fft;82;58;60;83;61;54;67;72;99;82 12:21:51 INFO - PROCESS | 1930 | |4;audio-oscillator;72;85;120;71;69;71;100;100;101;71 12:21:51 INFO - PROCESS | 1930 | |5;imaging-gaussian-blur;89;87;88;86;89;85;90;75;137;133 12:21:51 INFO - PROCESS | 1930 | |6;imaging-darkroom;104;120;116;121;96;94;153;153;110;154 12:21:51 INFO - PROCESS | 1930 | |7;imaging-desaturate;91;146;90;90;130;81;147;76;138;82 12:21:51 INFO - PROCESS | 1930 | |8;json-parse-financial;56;54;52;54;55;58;58;57;57;56 12:21:51 INFO - PROCESS | 1930 | |9;json-stringify-tinderbox;69;71;75;77;61;91;100;88;69;68 12:21:51 INFO - PROCESS | 1930 | |10;stanford-crypto-aes;82;80;80;86;97;101;83;71;72;84 12:21:51 INFO - PROCESS | 1930 | |11;stanford-crypto-ccm;134;127;155;121;149;138;156;167;196;147 12:21:51 INFO - PROCESS | 1930 | |12;stanford-crypto-pbkdf2;161;163;162;182;219;149;226;227;158;216 12:21:51 INFO - PROCESS | 1930 | |13;stanford-crypto-sha256-iterative;65;68;67;64;67;64;65;66;66;67 12:21:51 INFO - PROCESS | 1930 | __end_tp_report 12:21:51 INFO - PROCESS | 1930 | __start_cc_report 12:21:51 INFO - PROCESS | 1930 | _x_x_mozilla_cycle_collect,891 12:21:51 INFO - PROCESS | 1930 | __end_cc_report 12:21:51 INFO - PROCESS | 1930 | __startTimestamp1479759711119__endTimestamp 12:21:51 INFO - PROCESS | 1930 | 12:21:51 INFO - PROCESS | 1930 | ------- Summary: start ------- 12:21:51 INFO - PROCESS | 1930 | Number of tests: 14 12:21:51 INFO - PROCESS | 1930 | 12:21:51 INFO - PROCESS | 1930 | [#0] ai-astar Cycles:10 Average:115.70 Median:117.00 stddev:3.23 (2.8%) stddev-sans-first:1.12 12:21:51 INFO - PROCESS | 1930 | Values: 107.0 119.0 116.0 115.0 117.0 117.0 117.0 116.0 116.0 117.0 12:21:51 INFO - PROCESS | 1930 | 12:21:51 INFO - PROCESS | 1930 | [#1] audio-beat-detection Cycles:10 Average:129.10 Median:140.00 stddev:18.24 (13.0%) stddev-sans-first:18.74 12:21:51 INFO - PROCESS | 1930 | Values: 142.0 109.0 110.0 138.0 112.0 120.0 142.0 143.0 161.0 114.0 12:21:51 INFO - PROCESS | 1930 | 12:21:51 INFO - PROCESS | 1930 | [#2] audio-dft Cycles:10 Average:198.70 Median:198.50 stddev:3.23 (1.6%) stddev-sans-first:3.37 12:21:51 INFO - PROCESS | 1930 | Values: 197.0 207.0 198.0 198.0 197.0 197.0 199.0 195.0 200.0 199.0 12:21:51 INFO - PROCESS | 1930 | 12:21:51 INFO - PROCESS | 1930 | [#3] audio-fft Cycles:10 Average:71.80 Median:77.00 stddev:14.37 (18.7%) stddev-sans-first:14.76 12:21:51 INFO - PROCESS | 1930 | Values: 82.0 58.0 60.0 83.0 61.0 54.0 67.0 72.0 99.0 82.0 12:21:51 INFO - PROCESS | 1930 | 12:21:51 INFO - PROCESS | 1930 | [#4] audio-oscillator Cycles:10 Average:86.00 Median:71.00 stddev:18.06 (25.4%) stddev-sans-first:18.43 12:21:51 INFO - PROCESS | 1930 | Values: 72.0 85.0 120.0 71.0 69.0 71.0 100.0 100.0 101.0 71.0 12:21:51 INFO - PROCESS | 1930 | 12:21:51 INFO - PROCESS | 1930 | [#5] imaging-gaussian-blur Cycles:10 Average:95.90 Median:87.50 stddev:21.06 (24.1%) stddev-sans-first:22.19 12:21:51 INFO - PROCESS | 1930 | Values: 89.0 87.0 88.0 86.0 89.0 85.0 90.0 75.0 137.0 133.0 12:21:51 INFO - PROCESS | 1930 | 12:21:51 INFO - PROCESS | 1930 | [#6] imaging-darkroom Cycles:10 Average:122.10 Median:153.00 stddev:23.37 (15.3%) stddev-sans-first:23.85 12:21:51 INFO - PROCESS | 1930 | Values: 104.0 120.0 116.0 121.0 96.0 94.0 153.0 153.0 110.0 154.0 12:21:51 INFO - PROCESS | 1930 | 12:21:51 INFO - PROCESS | 1930 | [#7] imaging-desaturate Cycles:10 Average:107.10 Median:81.50 stddev:29.26 (35.9%) stddev-sans-first:30.45 12:21:51 INFO - PROCESS | 1930 | Values: 91.0 146.0 90.0 90.0 130.0 81.0 147.0 76.0 138.0 82.0 12:21:51 INFO - PROCESS | 1930 | 12:21:51 INFO - PROCESS | 1930 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.50 stddev:1.95 (3.4%) stddev-sans-first:2.06 12:21:51 INFO - PROCESS | 1930 | Values: 56.0 54.0 52.0 54.0 55.0 58.0 58.0 57.0 57.0 56.0 12:21:51 INFO - PROCESS | 1930 | 12:21:51 INFO - PROCESS | 1930 | [#9] json-stringify-tinderbox Cycles:10 Average:76.90 Median:73.00 stddev:12.25 (16.8%) stddev-sans-first:12.66 12:21:51 INFO - PROCESS | 1930 | Values: 69.0 71.0 75.0 77.0 61.0 91.0 100.0 88.0 69.0 68.0 12:21:51 INFO - PROCESS | 1930 | 12:21:51 INFO - PROCESS | 1930 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:82.50 stddev:9.49 (11.5%) stddev-sans-first:10.05 12:21:51 INFO - PROCESS | 1930 | Values: 82.0 80.0 80.0 86.0 97.0 101.0 83.0 71.0 72.0 84.0 12:21:51 INFO - PROCESS | 1930 | 12:21:51 INFO - PROCESS | 1930 | [#11] stanford-crypto-ccm Cycles:10 Average:149.00 Median:152.00 stddev:21.69 (14.3%) stddev-sans-first:22.32 12:21:51 INFO - PROCESS | 1930 | Values: 134.0 127.0 155.0 121.0 149.0 138.0 156.0 167.0 196.0 147.0 12:21:51 INFO - PROCESS | 1930 | 12:21:51 INFO - PROCESS | 1930 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.30 Median:199.00 stddev:31.92 (16.0%) stddev-sans-first:32.51 12:21:51 INFO - PROCESS | 1930 | Values: 161.0 163.0 162.0 182.0 219.0 149.0 226.0 227.0 158.0 216.0 12:21:51 INFO - PROCESS | 1930 | 12:21:51 INFO - PROCESS | 1930 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.50 stddev:1.37 (2.1%) stddev-sans-first:1.41 12:21:51 INFO - PROCESS | 1930 | Values: 65.0 68.0 67.0 64.0 67.0 64.0 65.0 66.0 66.0 67.0 12:21:51 INFO - PROCESS | 1930 | -------- Summary: end -------- 12:21:51 INFO - PROCESS | 1930 | 12:21:51 INFO - TEST-INFO | 1930: exit 0 12:21:51 INFO - TEST-OK | kraken | took 59373ms 12:21:51 INFO - SUITE-END | took 1171s 12:21:52 INFO - Completed test suite (00:19:31) 12:21:52 INFO - javascript benchmark 12:21:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7510.762250070559, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3089.5365695145724, 3167.366526694662, 3548.4322508398645, 3572.3034008368363, 3599.748017638766, 4942.802287908484, 5991.730372133254, 6016.548758843088, 6061.605995610283, 6070.726817293222, 5978.850528736783, 5990.1913241712355, 6091.573589848701, 6104.908426373608, 6108.541859360555, 5403.810866619679, 5421.701806400646, 5493.972530137344, 5509.237044145855, 5509.889802203954, 5478.808241711541, 5479.6164268501225, 5492.670439773607, 5494.0, 5510.5316048135755, 5332.973335133319, 5368.677879327252, 5451.291332126818, 5467.5625949923915, 5508.531774799147, 5332.120200166968, 5365.812196573141, 5424.5660347172525, 5445.945540544583, 5464.808731694411, 5292.20616907467, 5353.063213937584, 5353.170258609922, 5469.453054694539, 5490.615656904019, 6119.571629985903, 6126.632402055846, 6171.444569988677, 6217.844553886144, 6232.968835155795, 6197.225346831646, 6208.81373558794, 6285.151504546873, 6350.428461438447, 6354.5551811373225, 6427.614343139427, 6459.483241340681, 6472.126262954488, 6475.352464753534, 6495.8700825983215, 6015.578909476382, 6093.69531523422, 6179.443850053517, 6190.783322583688, 6196.690165491753, 5439.48324909133, 6382.8723425531225, 6440.8389790255615, 6526.869462610816, 6531.706073226716, 6246.0, 6246.75012999484, 6265.373462653789, 6267.592606480564, 6287.056941458818, 6132.9980441463495, 6343.27052388972, 6351.142595749607, 6360.268569114519, 6373.808785736435, 6181.134641150243, 6207.286162091417, 6216.7824126155365, 6239.937600624026, 6320.241571011508, 6312.652804095727, 6319.273283572356, 6321.936780632227, 6334.398232167937, 6358.109864618957, 5060.291559181717, 5146.30524879144, 5148.948510514847, 5159.716215608102, 5212.947870521246, 4479.440069991251, 4555.430571178603, 4564.794584243717, 4586.036932244199, 4594.6783725139585, 6079.739852968991, 6127.911555504571, 6154.046122850965, 6163.537734669918, 6178.814635560941, 6332.208473940757, 6405.6797160141805, 6407.070974708734, 6441.355864413615, 6449.774257900951, 6089.421504957022, 6112.297085835097, 6114.297368146176, 6141.762184093051, 6191.628502289877, 5654.943450565442, 5659.377468478464, 5669.1496275558175, 5699.74351154199, 5720.970225359475, 6633.767818126343, 6657.367550082734, 6665.433438157714, 6683.131192944983, 6694.464442844561, 6251.71867265965, 6283.465905397909, 6302.1492098566105, 6320.083587879823, 6371.617702937839, 6615.768448104293, 6657.367550082734, 6664.633445160563, 6673.366030227121, 6679.899801503078, 5179.9640071985, 6336.841578960379, 6338.873222535616, 6345.4923606112325, 6348.047792830927, 6029.547783916136, 6122.794608433986, 6175.4750846176785, 6246.250449946036, 6347.96826015867, 4762.499937506512, 4797.736124513185, 4850.490698476609, 6245.469135123383, 6251.031090181029, 6219.378062193744, 6230.00319948806, 6255.46828519581, 6258.217722784652, 6264.342244064308, 5719.914201287067, 6036.336003039574, 6150.569460137747, 6156.199694039746, 6173.475254603409, 4907.944791869765, 5994.460498555151, 6172.907406388818, 6173.228346456693, 6243.531735119794, 6207.720652570735, 6231.626102433868, 6236.812895613139, 6239.906401404073, 6277.654728989949], "value": 5858.141893543985, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.1155310876304, 503.5669324381029, 505.40109969685926, 525.7397588193842, 545.0978630366742, 39639.801800990994, 42891.92770180747, 42961.92595185114, 43086.13827723447, 43105.137897242035, 42314.0, 43396.566034339645, 43783.0, 43894.34158487625, 44018.559814401844, 8427.873581896261, 10068.446235457048, 10228.48857557123, 10237.385756854575, 10241.743956401113, 10012.098911097999, 10077.39535627861, 10083.44541050242, 10083.546240419199, 10093.545790439448, 8617.138286171396, 10142.492875356204, 10154.593816247341, 10175.18598512121, 10183.18534517237, 10052.44711540865, 10095.39427634337, 10097.040781125781, 10098.0, 10127.189824814071, 8564.314854811662, 10027.097561219525, 10035.29752917296, 10109.797804043952, 10124.240681948882, 33166.6683333166, 33247.6675233247, 42602.786986065184, 42607.786961064994, 42758.14483710339, 3305.173706573357, 3535.611082780892, 3704.814759262053, 3985.820638071265, 4377.518472967971, 31402.84298578515, 31671.0, 32040.679593204004, 33513.659453621825, 33872.49191262133, 3248.4640034394297, 3426.8971930842113, 3428.3143371325837, 3445.9483107753404, 3448.517207590939, 550010.0, 554835.0, 555705.9999999959, 559085.2045739786, 562840.0, 67374.0, 67913.98129028069, 67943.66028169828, 67981.0, 68120.65939670369, 35106.82446587751, 36053.918382448566, 36433.453498197545, 37470.25059498795, 38145.04637384087, 17769.0, 17885.910570447326, 17916.55208619795, 17922.91038544825, 17966.101694915204, 13498.392572334269, 13519.662008449868, 13557.0, 13615.931920340336, 13657.521986730615, 16694.49916502507, 19594.70607940882, 19652.70520942187, 19991.000449977444, 20008.69986950197, 8456.238938495564, 8550.921668199444, 8652.913470865336, 8683.56582170889, 8695.782605434788, 890.4078787606298, 1048.5124417146064, 1071.1751950997843, 1094.3215206571977, 1109.9278546894427, 31345.373092538022, 31569.0, 31618.367632647678, 31637.892673756767, 31665.683343166733, 1069.8020866139789, 1097.5116073347283, 1181.0492553494519, 1189.8647064983656, 1205.5057426455112, 15795.0, 16632.0, 16645.7515686324, 16676.33294668224, 16715.16424178786, 756944.0, 761916.0, 768787.0, 774042.0, 775212.0, 60629.39370606326, 61282.69358653178, 61402.692986534785, 61462.692686536284, 61493.69253153705, 1428.1573871415915, 1462.4223431744615, 1472.698096890135, 1477.290900367808, 1479.186447453896, 29864.0, 31082.844585776926, 31669.317955855484, 31962.20094497656, 32069.839650801598, 51753.7412312936, 52121.0, 52473.7376313116, 52482.212766809294, 52696.20955685591, 636882.0, 638237.0, 638927.0, 641525.0, 641922.0, 26902.0, 26948.32629184286, 27878.58182127229, 27951.72048279491, 28041.71958280391, 49159.75420122877, 50190.0, 50223.74888125536, 50356.0, 50642.74678626583, 40725.79637101914, 41540.79229603833, 41760.81145226899, 42671.786641066596, 42986.0, 40999.0, 41676.58323416727, 41885.16229675328, 42328.15343693047, 42632.57367426286, 32525.34949301048, 38981.6101838978, 39188.216235674554, 40133.799331004324, 40262.39606405965, 35091.82454087713, 36780.26439471142, 37224.62775372212, 37239.88280351594, 37274.627253727114, 27067.86466067736, 27120.32199195036, 27313.726862731117, 27382.726172738017, 27387.86306068457], "value": 20918.401579665766, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.9982450087749, 359.63497050493737, 381.47547122706277, 384.6614978818639, 411.7241448229686, 16246.0, 18687.813121868778, 18777.15502802374, 21653.891730541327, 22175.66736498954, 11734.53061877524, 11870.7625847483, 12193.878061219386, 12255.571055013077, 12285.262884226953, 4910.877228069291, 5391.406945236021, 5748.223989761371, 5756.971215143918, 5770.076787713967, 4248.171606536726, 4460.910781784362, 5293.602979776513, 5659.405762394951, 6402.327755585667, 6357.852862832881, 6383.553151279412, 6416.935830641703, 6421.261554921174, 6436.388543088423, 6949.478789090813, 7155.7137714491355, 7163.534370265968, 7173.605451700155, 7173.60545170018, 5982.0, 6175.320714721377, 6214.937850621526, 6248.718807653621, 6262.154609127755, 13179.86820131796, 13465.0, 13733.725325493435, 22922.426939326484, 26744.0, 2564.333273348924, 2592.5592649249675, 2688.2204160793344, 2778.749912507884, 2934.325105225789, 8907.331950103768, 10191.796164076677, 10349.120324772404, 10349.913259107836, 10698.304610200312, 1912.540990162365, 1989.2938007007594, 2009.4172689919906, 2017.0, 2050.846186536001, 78963.01369183234, 130263.6973630261, 138509.0, 139520.30239848836, 140099.29950350284, 11533.365664888344, 11809.23239989398, 11922.1654484187, 11939.164258501994, 11945.745696701895, 12562.057845661611, 15001.924990374979, 15195.468158614616, 15236.238188090772, 15291.464798731991, 8294.875576866352, 8918.0, 9041.00548939616, 9072.183503484717, 9163.541822908828, 8992.100789920956, 8998.955005224932, 9038.367314288069, 9185.95407022974, 9197.356185066981, 4648.744319062416, 4669.322948172496, 4681.063787242565, 4689.929651055237, 4761.119192949315, 1643.498732886481, 1715.8112607613152, 1765.3115285038846, 1971.4775584470126, 2052.3068468513534, 576.20771439271, 716.1406312425111, 720.81619187108, 745.1654147354997, 777.5801067423641, 17487.38794142199, 17548.82451175472, 18239.361622343153, 18276.177572009292, 18438.539036524195, 661.9139511863427, 815.294770023925, 820.3970081989733, 839.7732612194674, 867.1588559097665, 9328.113829186217, 9695.175910047585, 9708.0, 9735.756606084762, 9874.210063194927, 616749.0, 619906.0, 622245.0, 633286.0, 638050.0, 118070.0, 137529.0, 140647.0, 142240.28879855535, 142957.0, 1021.4228960637216, 1023.155896385485, 1023.9539220734936, 1026.625281772148, 1030.8866024737272, 13812.930935345259, 15508.0, 16824.411145609844, 16984.66030679404, 17028.404005859735, 57268.71365643145, 58718.11922821247, 58841.411585883594, 59857.10214346876, 60088.0, 81520.77718834103, 85785.57107214424, 85923.0, 85986.14013859781, 88411.55794221246, 5709.714514274353, 7236.240194779472, 7443.888341674771, 7749.690012399441, 7783.961080194789, 10818.621348252773, 11600.187986841178, 12759.0, 13569.79645305341, 13762.931185344009, 8532.786680333042, 9088.500132492776, 9542.761430964281, 11673.007794337576, 11678.182527223013, 11104.61133860311, 11366.0, 11535.538578456768, 11592.0, 11796.997255233058, 11484.483198256266, 12048.638540843789, 12049.156559040783, 12081.939590302343, 12110.818337725117, 8399.622017009371, 8508.361872859685, 8630.741077767678, 8630.741077767678, 8663.91336086631, 9665.371750836173, 10632.52153653072, 11624.302541847515, 11638.70903227426, 12042.63872083839], "value": 9350.157225000861, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1530.6606719120769, 1583.952481425557, 1829.8444632206263, 1920.654282229198, 1988.6519859024677, 8261.339092872578, 8313.0, 8541.658333666646, 8732.694355697551, 9325.81348373033, 8759.167879051496, 8974.237189838872, 8985.775355616113, 9146.679866204684, 9168.54157292136, 2444.877756112192, 2448.963265551018, 2465.469923966347, 2466.1615050882697, 2477.863717495537, 2049.836013118947, 2426.745191754867, 2482.3049546127113, 2489.8879550420183, 2497.7127630322566, 2461.729209786922, 2462.91379801707, 2477.2939712182033, 2488.154027630605, 2490.9252722418355, 2445.9877700611473, 2455.067074511674, 2457.213691618683, 2459.754024597544, 2466.605343145088, 2447.4860279341183, 2457.103157347573, 2462.938426539333, 2463.716672582658, 2464.0636558107803, 9151.176394124494, 9200.861987070199, 9244.583993720298, 9274.90725092754, 9281.814363712756, 5437.32033495813, 5473.425290344497, 5574.442555744434, 5574.832755017356, 5593.74828132735, 3373.527706121145, 3542.3977923753023, 3602.945955810665, 3747.606501317377, 3792.355299599075, 1093.8195197792354, 1103.3876198709713, 1117.4301106435696, 1135.619567444907, 1138.49337045015, 10240.23198260126, 12109.757804843943, 12269.447874845653, 12282.324472154029, 12292.877071229263, 4752.239641657318, 4812.759362031955, 4854.951450485521, 4890.657653964259, 4944.184209605375, 10304.690859274233, 10327.84508232377, 10373.948130259301, 10452.634157804441, 10469.476526173661, 5530.944690553123, 5545.750441230154, 5559.638623489541, 5568.52667523257, 5584.972075139598, 4541.500434952152, 4679.298105284167, 4895.877603059952, 5009.998000399862, 5107.463716309734, 4067.9593204068174, 4086.775227362464, 4201.873943781691, 4209.7474151551005, 4223.176480586256, 1306.5753630070265, 1328.408858058155, 1332.1607387346103, 1333.133463248896, 1335.105479328852, 867.8741582470633, 933.0389698610442, 943.3915124744501, 958.8945216026232, 963.802420503795, 5914.757900840872, 6040.275166979991, 6101.176341193971, 6104.298005729309, 6172.814815555541, 926.9397489163183, 946.2524605561667, 954.4750387286964, 1000.849872519128, 1010.6664800615779, 3311.2715202655377, 3570.839312230956, 3802.7147963902817, 4011.8997025074605, 4095.2219078375015, 9063.0, 10090.44502552352, 11093.278936869077, 11459.427028648533, 11487.195896287347, 11102.61140860066, 11169.664910052548, 11272.71818204535, 11293.774124517464, 11318.377489238172, 8045.396595255379, 8510.78723031929, 8622.482651040958, 8673.739787806377, 8684.305255579538, 6034.577579569388, 6148.231471066117, 6150.507959363151, 6173.753049877954, 6213.316535181217, 10389.272750907365, 10389.324693894872, 10535.683929482127, 10559.732832059895, 10574.471276435994, 9925.851112233178, 10229.693109206735, 10276.640317588848, 10336.896631033593, 10430.478476076318, 7138.500304978809, 7341.853162936604, 7543.698252069856, 7586.924130758622, 7877.094134174643, 8579.056303806452, 8748.037715851124, 8798.868016979623, 8806.0, 8815.118488151134, 7617.9619101906355, 7748.496347737379, 7769.72805951789, 7816.140224575406, 7868.095169055632, 7588.506747061423, 7678.462507624413, 7688.692452302069, 7693.153753087044, 7705.49914255594, 7200.675969581277, 7314.451416143704, 7333.743318984023, 7349.265073492608, 7359.705611775469, 5035.0, 5105.106606343949, 5122.487751224848, 5214.921776173436, 5298.940211957547, 5078.56832169255, 5198.870028249324, 5237.3453318335205, 5345.064613692666, 5359.678419294854], "value": 4754.096610481458, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [254.8751111955142, 256.709917792894, 313.1935266688278, 316.552078808486, 317.29876971892116, 4378.496472905616, 5441.564674826014, 5592.580556458267, 5695.8576035599135, 5731.621377128492, 5317.760700768465, 5489.862753431166, 5544.445555444454, 5562.443755624446, 5564.996601223556, 3474.513568100468, 4257.76582287974, 4260.974707957354, 4276.957230427694, 4306.2033523798045, 3705.6479634434686, 3906.3749800032, 4220.7256528325715, 4260.190563792885, 4291.377750226231, 3331.883384081558, 3611.7110631149444, 3756.3426400379963, 4151.823854751103, 4167.74993500391, 3731.9626803731885, 3872.206197729459, 4147.419361289422, 4167.624913757776, 4175.269327867626, 3421.640727723578, 3539.345221134098, 3558.3061303045915, 3572.2676851245433, 3624.0758606555423, 5471.480209380103, 5500.624843789053, 5512.503874651301, 5527.281453411031, 5544.22380866679, 3799.9430008549894, 4223.704340696153, 4832.7825247863575, 4849.744868636101, 4917.72952487613, 4754.66717329787, 5294.708791016493, 5661.2923384576925, 5883.352831188566, 5973.910391344133, 3193.808371497694, 3394.1344957036044, 3867.535895692507, 3936.940945885814, 3986.943459983107, 4978.477259887696, 5296.861174847426, 5588.469095435927, 5670.291213598301, 6249.093881387219, 3880.9521429213955, 3945.437963440284, 3985.0, 3989.4215338776294, 4036.6770658347264, 4054.6958978076764, 4099.1801639672185, 4110.8346573138515, 4116.526599441103, 4117.670586353084, 3987.3420885554137, 4044.8179831907637, 4648.418947631546, 4761.595264402565, 4880.169501689012, 5163.586913046947, 5692.48767610917, 5930.495907847881, 5951.791687290924, 6046.879062418727, 1170.7482891178438, 1308.7905935050346, 1331.633800704814, 1390.6036779517992, 1394.2889126545535, 751.4401770680769, 751.7631945937012, 808.6886548678801, 827.1604321613567, 848.974530764078, 4099.1801639672185, 4137.524184718735, 4497.572730590588, 4612.630989520831, 4746.715197088186, 4292.613664770123, 4765.0946320199055, 4786.090642777861, 5152.09372532158, 5152.252923326097, 3773.7924414157483, 3868.96131038686, 4023.4166045923175, 4528.686680862513, 4774.4509381420885, 2269.5254453171815, 2341.583342078018, 2471.6910386201725, 2576.561984462646, 2623.6851577810785, 4449.2881139018245, 4527.758759414111, 4545.772641386807, 5063.1898896176435, 5090.055207214438, 4251.256030194703, 4542.409486766765, 4586.564276393738, 5149.75985446332, 5201.543567801022, 5175.611829112831, 5426.75579598919, 5611.783345578474, 6342.334054924167, 6458.773942911976, 4709.48195698466, 5717.714114294352, 5985.4912332450485, 5999.5800293979, 6250.468710159687, 5788.363280039108, 6057.849008688335, 6131.601445906002, 6140.846478838065, 6174.530187924866, 5893.793717219876, 5931.555133365101, 6391.8721625566295, 6397.840053998687, 6457.61254324742, 3444.2767018925306, 4062.5937406259136, 4078.286299897447, 4080.1227736035707, 4086.223617512663, 4806.423229212517, 5719.48524632785, 5808.108567259862, 5811.186433899173, 6268.247810262797, 5249.527542521191, 5271.288376069181, 5919.881602367843, 6064.332923378513, 6082.4685609221415, 5356.276902618097, 5775.21723271258, 6116.256866792943, 6118.357572454828, 6132.693365331626, 5218.991826152463, 5927.14056461802, 5928.103007037706, 5956.583039187215, 5958.880822383441, 6035.0, 6036.849078773066, 6088.6042407243385, 6090.878182436238, 6118.479929206067, 5689.203511508309, 5916.290045194604, 5917.0, 5927.436893495111, 5956.791512297222], "value": 4077.3872246294936, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.232165512832, 788.4323287233194, 804.5775967617001, 833.0960907415462, 877.3025444771408, 12662.43019064142, 14918.552443426688, 15441.22793860308, 16726.41457548986, 16890.577735556602, 12462.501499939992, 15356.001859879128, 15386.846131538709, 15390.384384624602, 15396.153211573359, 813.9104698483162, 871.8822958900562, 908.4322298563397, 940.3934462271831, 950.5294879034888, 696.2098018748732, 726.415235735233, 861.9355096455872, 886.0917559501498, 887.2281115429586, 945.0313428735533, 946.8958414574391, 948.2698322291831, 949.050949050949, 950.8098380323928, 925.6204955968021, 941.8587211918199, 946.0066929723831, 947.729896979361, 951.3435729346728, 673.2627772589008, 706.7385067525049, 710.0414440505328, 712.0423031023265, 712.7398499547679, 15435.768463473058, 15670.529884103495, 15717.842821571752, 15731.842681573267, 15753.448629298035, 14722.969392142555, 14775.40898364075, 14911.403543858232, 14937.477188298357, 14951.177685227309, 12179.39103044853, 12210.32843193624, 12313.507459701601, 12459.875401246052, 12615.306158161298, 3158.7946783459, 3878.5151856017997, 3905.9804700976315, 4009.8797036088963, 4046.817893194813, 123040.0, 127189.36405318006, 127568.99999999907, 128264.35867820695, 128684.0, 10976.835347469794, 10987.725306867393, 11431.657050288504, 11448.0, 11469.942650286695, 23025.963831627618, 23140.537189256458, 23203.419914502272, 23250.418739531648, 23321.06715731352, 7981.441299109123, 8021.15777843318, 8256.917430825735, 8276.29651479619, 8304.086550479442, 4543.114092751948, 4657.1617108920045, 4715.056988602293, 4720.244760838249, 4732.313814496947, 3561.4479755637917, 3692.6861216796337, 3709.1654377765326, 3710.888673339804, 3712.7215458840697, 568.8862227554506, 581.6103210848742, 682.1847891769288, 692.342274838905, 696.2098018748757, 600.540586451365, 610.4140025575497, 634.7714822663929, 652.1554586810092, 658.6476235214137, 8635.568221588896, 9191.678291259774, 9255.259579233645, 9398.342116051948, 9435.410705562157, 579.2267323123677, 629.7764293675771, 644.7582156691241, 644.8452371430823, 648.4974145037539, 4446.577575130357, 4584.541545845389, 4609.4699109602825, 4615.976920115445, 4662.167558501749, 102928.97071029343, 142742.0, 160501.0, 171569.4264586032, 175583.0, 91284.7468108237, 124350.0, 127408.0, 135030.0, 144071.0, 75720.9999999989, 78870.81693774599, 105163.0, 122241.0, 131721.0, 8893.822123557364, 9886.653967111404, 10116.0, 10392.636257730943, 10625.893741062491, 62170.0, 64762.0, 67782.0, 67874.66062669655, 69593.0, 82342.58828705818, 87797.56101219454, 94515.0, 96877.0312296868, 104150.4792476063, 12314.876851231373, 13261.336933153496, 13315.001374896729, 13784.104033238209, 14194.148351098967, 15431.305591248645, 15582.14298213609, 15738.449154279546, 15993.360265589246, 16054.67890642204, 12521.74782521777, 13955.0, 14211.0, 14326.57020289393, 14859.182744949132, 12523.4364453598, 14100.858991409954, 14392.42430302818, 14841.58282227001, 15124.697506050037, 12991.700829916932, 13436.328183590585, 14334.283285835874, 14400.783988239975, 14616.92691536578, 11604.6518604442, 11898.76202475963, 12047.337396442928, 12078.03375729957, 12222.449989750305, 11904.880951190376, 11916.821247681119, 12021.579244726743, 12194.268343899394, 12285.324307163191], "value": 8081.664812860922, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 119.0, 116.0, 115.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 110.0, 138.0, 112.0, 120.0, 142.0, 143.0, 161.0, 114.0], "value": 129.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 207.0, 198.0, 198.0, 197.0, 197.0, 199.0, 195.0, 200.0, 199.0], "value": 198.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 60.0, 83.0, 61.0, 54.0, 67.0, 72.0, 99.0, 82.0], "value": 71.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 85.0, 120.0, 71.0, 69.0, 71.0, 100.0, 100.0, 101.0, 71.0], "value": 86.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 86.0, 89.0, 85.0, 90.0, 75.0, 137.0, 133.0], "value": 95.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 120.0, 116.0, 121.0, 96.0, 94.0, 153.0, 153.0, 110.0, 154.0], "value": 122.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 146.0, 90.0, 90.0, 130.0, 81.0, 147.0, 76.0, 138.0, 82.0], "value": 107.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 52.0, 54.0, 55.0, 58.0, 58.0, 57.0, 57.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 75.0, 77.0, 61.0, 91.0, 100.0, 88.0, 69.0, 68.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 80.0, 86.0, 97.0, 101.0, 83.0, 71.0, 72.0, 84.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 127.0, 155.0, 121.0, 149.0, 138.0, 156.0, 167.0, 196.0, 147.0], "value": 149.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 182.0, 219.0, 149.0, 226.0, 227.0, 158.0, 216.0], "value": 186.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 67.0, 64.0, 67.0, 64.0, 65.0, 66.0, 66.0, 67.0], "value": 65.9, "unit": "score"}]}]} 12:21:52 INFO - Return code: 0 12:21:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:21:52 ERROR - # TBPL SUCCESS # 12:21:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:21:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:21:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:21:52 INFO - 2016-11-21 12:21:52.468 screenresolution[1935:22572] starting screenresolution argv=screenresolution get 12:21:52 INFO - 2016-11-21 12:21:52.471 screenresolution[1935:22572] Display 0: 1600x1200x32@60 12:21:52 INFO - 2016-11-21 12:21:52.477 screenresolution[1936:22575] starting screenresolution argv=screenresolution list 12:21:52 INFO - Available Modes on Display 0 12:21:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:21:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:21:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:21:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:21:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:21:52 INFO - Intel Iris: 12:21:52 INFO - Chipset Model: Intel Iris 12:21:52 INFO - Type: GPU 12:21:52 INFO - Bus: Built-In 12:21:52 INFO - VRAM (Dynamic, Max): 1536 MB 12:21:52 INFO - Vendor: Intel (0x8086) 12:21:52 INFO - Device ID: 0x0a2e 12:21:52 INFO - Revision ID: 0x0009 12:21:52 INFO - Displays: 12:21:52 INFO - Display: 12:21:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:21:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:21:52 INFO - Display Serial Number: 1600x1200 60 12:21:52 INFO - Main Display: Yes 12:21:52 INFO - Mirror: Off 12:21:52 INFO - Online: Yes 12:21:52 INFO - Rotation: Supported 12:21:52 INFO - Return code: 0 12:21:52 INFO - Running post-action listener: _resource_record_post_action 12:21:52 INFO - [mozharness: 2016-11-21 20:21:52.716925Z] Finished run-tests step (success) 12:21:52 INFO - Running post-run listener: _resource_record_post_run 12:21:52 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 999424; Write bytes: 497954816; Read time: 7; Write time: 1869 12:21:52 INFO - TinderboxPrint: CPU usage
54.2% 12:21:52 INFO - TinderboxPrint: I/O read bytes / time
999,424 / 7 12:21:52 INFO - TinderboxPrint: I/O write bytes / time
497,954,816 / 1,869 12:21:52 INFO - TinderboxPrint: CPU idle
2,186.8 (45.8%) 12:21:52 INFO - TinderboxPrint: CPU system
970.6 (20.3%) 12:21:52 INFO - TinderboxPrint: CPU user
1,620.3 (33.9%) 12:21:52 INFO - TinderboxPrint: Swap in / out
195,477,504 / 0 12:21:52 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 195801600; Write bytes: 195813376; Read time: 17960; Write time: 379 12:21:52 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 8192; Write bytes: 300630016; Read time: 1; Write time: 1481 12:21:53 INFO - Running post-run listener: _upload_blobber_files 12:21:53 INFO - Blob upload gear active. 12:21:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:21:53 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 12:21:53 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:21:53 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:21:53 INFO - (blobuploader) - INFO - Open directory for files ... 12:21:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:21:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:21:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:21:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:21:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:21:54 INFO - (blobuploader) - INFO - Done attempting. 12:21:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:21:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:21:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:21:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:21:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:21:55 INFO - (blobuploader) - INFO - Done attempting. 12:21:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:21:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:21:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:21:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:21:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:21:57 INFO - (blobuploader) - INFO - Done attempting. 12:21:57 INFO - (blobuploader) - INFO - Iteration through files over. 12:21:57 INFO - Return code: 0 12:21:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:21:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:21:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a406d26c4d15480da049b4c8c7f2280380f2f9bc235ccbcf381814bc51f7bfcbc135ff211f578f2e545016040e7d0970e089b5c151f2b9c5ad5ce11a72b40c65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1a41d3ef4a73bfb2b4cf269143bd8da70b46b51850fa11ec427220bcb51a43d292a58ebc9a701d281338a2c9cc850732adec33bba8d2296737094a42e2a8b9a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef0b6b02b6e8349058b7c13ff2913d180ad1c6c995e9f2bca012991fbe2b18785d37949c8c6433c6adf5ebfa786c778b22d481b6edfe37f7ed99b3fed6149838"} 12:21:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:21:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:21:57 INFO - Contents: 12:21:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a406d26c4d15480da049b4c8c7f2280380f2f9bc235ccbcf381814bc51f7bfcbc135ff211f578f2e545016040e7d0970e089b5c151f2b9c5ad5ce11a72b40c65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1a41d3ef4a73bfb2b4cf269143bd8da70b46b51850fa11ec427220bcb51a43d292a58ebc9a701d281338a2c9cc850732adec33bba8d2296737094a42e2a8b9a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef0b6b02b6e8349058b7c13ff2913d180ad1c6c995e9f2bca012991fbe2b18785d37949c8c6433c6adf5ebfa786c778b22d481b6edfe37f7ed99b3fed6149838"} 12:21:57 INFO - Running post-run listener: copy_logs_to_upload_dir 12:21:57 INFO - Copying logs to upload dir... 12:21:57 INFO - mkdir: /builds/slave/test/build/upload/logs 12:21:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.009075 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-11-21 12:21:58.020615) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 12:21:58.024103) ========= 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.yLWoVChwxG/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.1dP3fHYaCF/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a406d26c4d15480da049b4c8c7f2280380f2f9bc235ccbcf381814bc51f7bfcbc135ff211f578f2e545016040e7d0970e089b5c151f2b9c5ad5ce11a72b40c65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1a41d3ef4a73bfb2b4cf269143bd8da70b46b51850fa11ec427220bcb51a43d292a58ebc9a701d281338a2c9cc850732adec33bba8d2296737094a42e2a8b9a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef0b6b02b6e8349058b7c13ff2913d180ad1c6c995e9f2bca012991fbe2b18785d37949c8c6433c6adf5ebfa786c778b22d481b6edfe37f7ed99b3fed6149838"} build_url:https://queue.taskcluster.net/v1/task/WkGqPyHJQ12hJkBH9FurMg/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011026 build_url: 'https://queue.taskcluster.net/v1/task/WkGqPyHJQ12hJkBH9FurMg/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a406d26c4d15480da049b4c8c7f2280380f2f9bc235ccbcf381814bc51f7bfcbc135ff211f578f2e545016040e7d0970e089b5c151f2b9c5ad5ce11a72b40c65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1a41d3ef4a73bfb2b4cf269143bd8da70b46b51850fa11ec427220bcb51a43d292a58ebc9a701d281338a2c9cc850732adec33bba8d2296737094a42e2a8b9a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef0b6b02b6e8349058b7c13ff2913d180ad1c6c995e9f2bca012991fbe2b18785d37949c8c6433c6adf5ebfa786c778b22d481b6edfe37f7ed99b3fed6149838"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 12:21:58.060159) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 12:21:58.060763) ========= 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.yLWoVChwxG/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.1dP3fHYaCF/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.005256 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 12:21:58.109723) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 12:21:58.110067) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 12:21:58.110418) ========= ========= Total master_lag: 0.22 =========