builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0085 starttime: 1476995395.55 results: success (0) buildid: 20161020114750 builduid: 72c1fb1ee31a407695b87b4ef392cc61 revision: 44754fcbce505bb509c290657231d65918f819af ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 13:29:55.546552) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 13:29:55.546950) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 13:29:55.547240) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 13:29:55.582797) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-20 13:29:55.583061) ========= 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.JseymRzYMU/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.CRYqU9kOHc/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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-10-20 13:29:55-- 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% 63.1M=0s 2016-10-20 13:29:55 (63.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.350974 ========= master_lag: 2.62 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-20 13:29:58.552913) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 13:29:58.553234) ========= 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.JseymRzYMU/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.CRYqU9kOHc/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.021756 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 13:29:58.598102) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 13:29:58.598435) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 44754fcbce505bb509c290657231d65918f819af --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-aurora --rev 44754fcbce505bb509c290657231d65918f819af --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JseymRzYMU/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.CRYqU9kOHc/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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-10-20 13:29:58,655 truncating revision to first 12 chars 2016-10-20 13:29:58,655 Setting DEBUG logging. 2016-10-20 13:29:58,655 attempt 1/10 2016-10-20 13:29:58,655 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/44754fcbce50?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 13:29:59,870 unpacking tar archive at: mozilla-aurora-44754fcbce50/testing/mozharness/ program finished with exit code 0 elapsedTime=1.494333 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 13:30:00.114712) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 13:30:00.115046) ========= script_repo_revision: 44754fcbce505bb509c290657231d65918f819af ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 13:30:00.115461) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 13:30:00.115734) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 13:30:00.134111) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-10-20 13:30:00.134460) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JseymRzYMU/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.CRYqU9kOHc/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 13:30:00 INFO - MultiFileLogger online at 20161020 13:30:00 in /builds/slave/test 13:30:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:30:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:30:00 INFO - {'append_to_log': False, 13:30:00 INFO - 'base_work_dir': '/builds/slave/test', 13:30:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:30:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:30:00 INFO - 'branch': 'Mozilla-Aurora', 13:30:00 INFO - 'buildbot_json_path': 'buildprops.json', 13:30:00 INFO - 'config_files': ('talos/mac_config.py',), 13:30:00 INFO - 'default_actions': ('clobber', 13:30:00 INFO - 'read-buildbot-config', 13:30:00 INFO - 'download-and-extract', 13:30:00 INFO - 'populate-webroot', 13:30:00 INFO - 'create-virtualenv', 13:30:00 INFO - 'install', 13:30:00 INFO - 'run-tests'), 13:30:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:30:00 INFO - 'download_minidump_stackwalk': True, 13:30:00 INFO - 'download_symbols': 'ondemand', 13:30:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:30:00 INFO - 'tooltool.py': '/tools/tooltool.py', 13:30:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:30:00 INFO - '/tools/misc-python/virtualenv.py')}, 13:30:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:30:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:30:00 INFO - 'installer_path': 'installer.exe', 13:30:00 INFO - 'log_level': 'info', 13:30:00 INFO - 'log_name': 'talos', 13:30:00 INFO - 'log_to_console': True, 13:30:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:30:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:30:00 INFO - 'opt_config_files': (), 13:30:00 INFO - 'pip_index': False, 13:30:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:30:00 INFO - 'cmd': ('bash', 13:30:00 INFO - '-c', 13:30:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:30:00 INFO - 'enabled': True, 13:30:00 INFO - 'halt_on_failure': False, 13:30:00 INFO - 'name': 'check_screen_resolution'},), 13:30:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:30:00 INFO - 'cmd': ('bash', 13:30:00 INFO - '-c', 13:30:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:30:00 INFO - 'enabled': True, 13:30:00 INFO - 'halt_on_failure': False, 13:30:00 INFO - 'name': 'check_screen_resolution'},), 13:30:00 INFO - 'run_cmd_checks_enabled': True, 13:30:00 INFO - 'sps_profile': False, 13:30:00 INFO - 'sps_profile_interval': 0, 13:30:00 INFO - 'suite': 'dromaeojs-e10s', 13:30:00 INFO - 'system_bits': '32', 13:30:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:30:00 INFO - 'title': 't-yosemite-r7-0085', 13:30:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:30:00 INFO - 'use_talos_json': True, 13:30:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:30:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:30:00 INFO - 'work_dir': 'build'} 13:30:00 INFO - [mozharness: 2016-10-20 20:30:00.323901Z] Running clobber step. 13:30:00 INFO - Running pre-action listener: _resource_record_pre_action 13:30:00 INFO - Running main action method: clobber 13:30:00 INFO - rmtree: /builds/slave/test/build 13:30:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:30:02 INFO - Running post-action listener: _resource_record_post_action 13:30:02 INFO - [mozharness: 2016-10-20 20:30:02.126488Z] Finished clobber step (success) 13:30:02 INFO - [mozharness: 2016-10-20 20:30:02.126763Z] Running read-buildbot-config step. 13:30:02 INFO - Running pre-action listener: _resource_record_pre_action 13:30:02 INFO - Running main action method: read_buildbot_config 13:30:02 INFO - Using buildbot properties: 13:30:02 INFO - { 13:30:02 INFO - "project": "", 13:30:02 INFO - "product": "firefox", 13:30:02 INFO - "script_repo_revision": "production", 13:30:02 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 13:30:02 INFO - "repository": "", 13:30:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 13:30:02 INFO - "buildid": "20161020114750", 13:30:02 INFO - "pgo_build": "False", 13:30:02 INFO - "basedir": "/builds/slave/test", 13:30:02 INFO - "buildnumber": 7, 13:30:02 INFO - "slavename": "t-yosemite-r7-0085", 13:30:02 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 13:30:02 INFO - "platform": "yosemite_r7", 13:30:02 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:30:02 INFO - "branch": "mozilla-aurora", 13:30:02 INFO - "repo_path": "releases/mozilla-aurora", 13:30:02 INFO - "revision": "44754fcbce505bb509c290657231d65918f819af", 13:30:02 INFO - "stage_platform": "macosx64", 13:30:02 INFO - "builduid": "72c1fb1ee31a407695b87b4ef392cc61", 13:30:02 INFO - "slavebuilddir": "test" 13:30:02 INFO - } 13:30:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/Cy-BrosuTouPrG3l19ShUA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 13:30:02 INFO - Running post-action listener: _resource_record_post_action 13:30:02 INFO - [mozharness: 2016-10-20 20:30:02.132654Z] Finished read-buildbot-config step (success) 13:30:02 INFO - [mozharness: 2016-10-20 20:30:02.132888Z] Running download-and-extract step. 13:30:02 INFO - Running pre-action listener: _resource_record_pre_action 13:30:02 INFO - Running main action method: download_and_extract 13:30:02 INFO - mkdir: /builds/slave/test/build/tests 13:30:02 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')]} 13:30:02 INFO - trying https://queue.taskcluster.net/v1/task/Cy-BrosuTouPrG3l19ShUA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 13:30:02 INFO - Downloading https://queue.taskcluster.net/v1/task/Cy-BrosuTouPrG3l19ShUA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 13:30:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cy-BrosuTouPrG3l19ShUA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 13:30:03 INFO - Downloaded 1199 bytes. 13:30:03 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 13:30:03 INFO - Using the following test package requirements: 13:30:03 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 13:30:03 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:30:03 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 13:30:03 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:30:03 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 13:30:03 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:30:03 INFO - u'jsshell-mac.zip'], 13:30:03 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:30:03 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 13:30:03 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 13:30:03 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:30:03 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 13:30:03 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:30:03 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 13:30:03 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:30:03 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 13:30:03 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:30:03 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 13:30:03 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:30:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Cy-BrosuTouPrG3l19ShUA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 13:30:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cy-BrosuTouPrG3l19ShUA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:30:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Cy-BrosuTouPrG3l19ShUA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 13:30:03 INFO - Expected file size: 16436360 13:30:10 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 13:30:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Cy-BrosuTouPrG3l19ShUA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 13:30:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cy-BrosuTouPrG3l19ShUA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:30:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Cy-BrosuTouPrG3l19ShUA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 13:30:11 INFO - Expected file size: 16436360 13:30:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Cy-BrosuTouPrG3l19ShUA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 13:30:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cy-BrosuTouPrG3l19ShUA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 13:30:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Cy-BrosuTouPrG3l19ShUA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 13:30:18 INFO - Expected file size: 14414081 13:30:19 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')]} 13:30:19 INFO - trying https://queue.taskcluster.net/v1/task/Cy-BrosuTouPrG3l19ShUA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 13:30:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Cy-BrosuTouPrG3l19ShUA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 13:30:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cy-BrosuTouPrG3l19ShUA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 13:30:22 INFO - Downloaded 115422419 bytes. 13:30:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Cy-BrosuTouPrG3l19ShUA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 13:30:22 INFO - mkdir: /builds/slave/test/properties 13:30:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:30:22 INFO - Writing to file /builds/slave/test/properties/build_url 13:30:22 INFO - Contents: 13:30:22 INFO - build_url:https://queue.taskcluster.net/v1/task/Cy-BrosuTouPrG3l19ShUA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 13:30:22 INFO - Running post-action listener: _resource_record_post_action 13:30:22 INFO - Running post-action listener: set_extra_try_arguments 13:30:22 INFO - [mozharness: 2016-10-20 20:30:22.944140Z] Finished download-and-extract step (success) 13:30:22 INFO - [mozharness: 2016-10-20 20:30:22.944294Z] Running populate-webroot step. 13:30:22 INFO - Running pre-action listener: _resource_record_pre_action 13:30:22 INFO - Running main action method: populate_webroot 13:30:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:30:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:30:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:30:22 INFO - '--tppagecycles', 13:30:22 INFO - '7'], 13:30:22 INFO - 'tests': ['tsvgm']}}, 13:30:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:30:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:30:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:30:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:30:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:30:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:30:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:22 INFO - 'talos_options': ['--disable-e10s'], 13:30:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:30:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:30:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:22 INFO - 'talos_options': ['--disable-e10s'], 13:30:22 INFO - 'tests': ['damp', 'tps']}, 13:30:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:22 INFO - 'tests': ['damp', 'tps']}, 13:30:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:30:22 INFO - 'tests': ['dromaeo_dom']}, 13:30:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:30:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:30:22 INFO - 'tests': ['basic_compositor_video']}, 13:30:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:30:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:30:22 INFO - 'tests': ['a11yr', 13:30:22 INFO - 'ts_paint', 13:30:22 INFO - 'tpaint', 13:30:22 INFO - 'sessionrestore', 13:30:22 INFO - 'sessionrestore_no_auto_restore', 13:30:22 INFO - 'tabpaint']}, 13:30:22 INFO - 'other-e10s': {'tests': ['a11yr', 13:30:22 INFO - 'ts_paint', 13:30:22 INFO - 'tpaint', 13:30:22 INFO - 'sessionrestore', 13:30:22 INFO - 'sessionrestore_no_auto_restore', 13:30:22 INFO - 'tabpaint']}, 13:30:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:30:22 INFO - 'ts_paint', 13:30:22 INFO - 'tpaint', 13:30:22 INFO - 'sessionrestore', 13:30:22 INFO - 'sessionrestore_no_auto_restore', 13:30:22 INFO - 'tabpaint']}, 13:30:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:30:22 INFO - 'ts_paint', 13:30:22 INFO - 'tpaint', 13:30:22 INFO - 'sessionrestore', 13:30:22 INFO - 'sessionrestore_no_auto_restore', 13:30:22 INFO - 'tabpaint']}, 13:30:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:30:22 INFO - 'tests': ['a11yr', 13:30:22 INFO - 'ts_paint', 13:30:22 INFO - 'tpaint', 13:30:22 INFO - 'sessionrestore', 13:30:22 INFO - 'sessionrestore_no_auto_restore', 13:30:22 INFO - 'tabpaint']}, 13:30:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:30:22 INFO - 'tests': ['a11yr', 13:30:22 INFO - 'ts_paint', 13:30:22 INFO - 'tpaint', 13:30:22 INFO - 'sessionrestore', 13:30:22 INFO - 'sessionrestore_no_auto_restore', 13:30:22 INFO - 'tabpaint']}, 13:30:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:30:22 INFO - 'tests': ['tsvgx', 13:30:22 INFO - 'tsvgr_opacity', 13:30:22 INFO - 'tart', 13:30:22 INFO - 'tscrollx', 13:30:22 INFO - 'cart']}, 13:30:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:30:22 INFO - 'tsvgr_opacity', 13:30:22 INFO - 'tart', 13:30:22 INFO - 'tscrollx', 13:30:22 INFO - 'cart']}, 13:30:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:22 INFO - 'talos_options': ['--disable-e10s'], 13:30:22 INFO - 'tests': ['tp5o']}, 13:30:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:22 INFO - 'tests': ['tp5o']}, 13:30:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:22 INFO - 'talos_options': ['--disable-e10s', 13:30:22 INFO - '--xperf_path', 13:30:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:30:22 INFO - 'tests': ['tp5n']}, 13:30:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:22 INFO - 'talos_options': ['--xperf_path', 13:30:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:30:22 INFO - 'tests': ['tp5n']}}, 13:30:22 INFO - 'talos.zip': {'path': '', 13:30:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:30:22 INFO - Running post-action listener: _resource_record_post_action 13:30:22 INFO - [mozharness: 2016-10-20 20:30:22.962700Z] Finished populate-webroot step (success) 13:30:22 INFO - [mozharness: 2016-10-20 20:30:22.962841Z] Running create-virtualenv step. 13:30:22 INFO - Running pre-action listener: _resource_record_pre_action 13:30:22 INFO - Running main action method: create_virtualenv 13:30:22 INFO - Creating virtualenv /builds/slave/test/build/venv 13:30:22 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 13:30:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:30:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:30:23 INFO - Using real prefix '/tools/python27' 13:30:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:30:23 INFO - Installing distribute.............................................................................................................................................................................................done. 13:30:26 INFO - Installing pip.................done. 13:30:26 INFO - Return code: 0 13:30:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:30:26 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')]} 13:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:26 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')]} 13:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:26 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 0x10f499490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f40f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc2d96ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2add30>, '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 0x10f113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a5b20>, '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.JseymRzYMU/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.CRYqU9kOHc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 13:30:26 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 13:30:26 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 13:30:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JseymRzYMU/Render', 13:30:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:26 INFO - 'HOME': '/Users/cltbld', 13:30:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:26 INFO - 'LOGNAME': 'cltbld', 13:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:26 INFO - 'MOZ_NO_REMOTE': '1', 13:30:26 INFO - 'NO_EM_RESTART': '1', 13:30:26 INFO - 'PAGER': '/bin/cat', 13:30:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:26 INFO - 'PWD': '/builds/slave/test', 13:30:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:26 INFO - 'SHELL': '/bin/bash', 13:30:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CRYqU9kOHc/Listeners', 13:30:26 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 13:30:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:26 INFO - 'USER': 'cltbld', 13:30:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:26 INFO - 'XPC_FLAGS': '0x0', 13:30:26 INFO - 'XPC_SERVICE_NAME': '0', 13:30:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:26 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 13:30:26 INFO - Cleaning up... 13:30:26 INFO - Return code: 0 13:30:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:30:26 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')]} 13:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:26 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')]} 13:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:26 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 0x10f499490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f40f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc2d96ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2add30>, '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 0x10f113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a5b20>, '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.JseymRzYMU/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.CRYqU9kOHc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 13:30:26 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 13:30:26 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 13:30:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JseymRzYMU/Render', 13:30:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:26 INFO - 'HOME': '/Users/cltbld', 13:30:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:26 INFO - 'LOGNAME': 'cltbld', 13:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:26 INFO - 'MOZ_NO_REMOTE': '1', 13:30:26 INFO - 'NO_EM_RESTART': '1', 13:30:26 INFO - 'PAGER': '/bin/cat', 13:30:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:26 INFO - 'PWD': '/builds/slave/test', 13:30:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:26 INFO - 'SHELL': '/bin/bash', 13:30:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CRYqU9kOHc/Listeners', 13:30:26 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 13:30:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:26 INFO - 'USER': 'cltbld', 13:30:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:26 INFO - 'XPC_FLAGS': '0x0', 13:30:26 INFO - 'XPC_SERVICE_NAME': '0', 13:30:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:27 INFO - Downloading/unpacking psutil>=3.1.1 13:30:27 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 13:30:27 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 13:30:27 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 13:30:27 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 13:30:27 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 13:30:27 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 13:30:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:30:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:30:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:30:30 INFO - Installing collected packages: psutil 13:30:30 INFO - Running setup.py install for psutil 13:30:30 INFO - building 'psutil._psutil_osx' extension 13:30:30 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 13:30:30 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 13:30:30 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 13:30:30 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 13:30:30 INFO - building 'psutil._psutil_posix' extension 13:30:30 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 13:30:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:30:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:30:30 INFO - ^ 13:30:30 INFO - 1 warning generated. 13:30:30 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 13:30:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:30:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:30:30 INFO - Successfully installed psutil 13:30:30 INFO - Cleaning up... 13:30:31 INFO - Return code: 0 13:30:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:30:31 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')]} 13:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:31 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')]} 13:30:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:31 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 0x10f499490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f40f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc2d96ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2add30>, '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 0x10f113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a5b20>, '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.JseymRzYMU/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.CRYqU9kOHc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 13:30:31 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 13:30:31 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 13:30:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JseymRzYMU/Render', 13:30:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:31 INFO - 'HOME': '/Users/cltbld', 13:30:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:31 INFO - 'LOGNAME': 'cltbld', 13:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:31 INFO - 'MOZ_NO_REMOTE': '1', 13:30:31 INFO - 'NO_EM_RESTART': '1', 13:30:31 INFO - 'PAGER': '/bin/cat', 13:30:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:31 INFO - 'PWD': '/builds/slave/test', 13:30:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:31 INFO - 'SHELL': '/bin/bash', 13:30:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CRYqU9kOHc/Listeners', 13:30:31 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 13:30:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:31 INFO - 'USER': 'cltbld', 13:30:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:31 INFO - 'XPC_FLAGS': '0x0', 13:30:31 INFO - 'XPC_SERVICE_NAME': '0', 13:30:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:30:31 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 13:30:31 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 13:30:31 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 13:30:31 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 13:30:31 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 13:30:31 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 13:30:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:30:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:30:33 INFO - Installing collected packages: mozsystemmonitor 13:30:33 INFO - Running setup.py install for mozsystemmonitor 13:30:34 INFO - Successfully installed mozsystemmonitor 13:30:34 INFO - Cleaning up... 13:30:34 INFO - Return code: 0 13:30:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:30:34 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')]} 13:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:34 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')]} 13:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:34 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 0x10f499490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f40f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc2d96ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2add30>, '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 0x10f113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a5b20>, '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.JseymRzYMU/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.CRYqU9kOHc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 13:30:34 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 13:30:34 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 13:30:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JseymRzYMU/Render', 13:30:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:34 INFO - 'HOME': '/Users/cltbld', 13:30:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:34 INFO - 'LOGNAME': 'cltbld', 13:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:34 INFO - 'MOZ_NO_REMOTE': '1', 13:30:34 INFO - 'NO_EM_RESTART': '1', 13:30:34 INFO - 'PAGER': '/bin/cat', 13:30:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:34 INFO - 'PWD': '/builds/slave/test', 13:30:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:34 INFO - 'SHELL': '/bin/bash', 13:30:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CRYqU9kOHc/Listeners', 13:30:34 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 13:30:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:34 INFO - 'USER': 'cltbld', 13:30:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:34 INFO - 'XPC_FLAGS': '0x0', 13:30:34 INFO - 'XPC_SERVICE_NAME': '0', 13:30:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:34 INFO - Downloading/unpacking jsonschema==2.5.1 13:30:34 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 13:30:34 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 13:30:34 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 13:30:34 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 13:30:34 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 13:30:34 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 13:30:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:30:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:30:36 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 13:30:36 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 13:30:36 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 13:30:36 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 13:30:36 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 13:30:36 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 13:30:37 INFO - Downloading functools32-3.2.3-2.tar.gz 13:30:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:30:37 INFO - warning: no files found matching '*.txt' 13:30:37 INFO - no previously-included directories found matching 'build' 13:30:37 INFO - no previously-included directories found matching 'dist' 13:30:37 INFO - no previously-included directories found matching '.git*' 13:30:37 INFO - Installing collected packages: jsonschema, functools32 13:30:37 INFO - Running setup.py install for functools32 13:30:37 INFO - warning: no files found matching '*.txt' 13:30:37 INFO - no previously-included directories found matching 'build' 13:30:37 INFO - no previously-included directories found matching 'dist' 13:30:37 INFO - no previously-included directories found matching '.git*' 13:30:37 INFO - Successfully installed jsonschema functools32 13:30:37 INFO - Cleaning up... 13:30:37 INFO - Return code: 0 13:30:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:30:37 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')]} 13:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:37 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')]} 13:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:37 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 0x10f499490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f40f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc2d96ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2add30>, '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 0x10f113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a5b20>, '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.JseymRzYMU/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.CRYqU9kOHc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 13:30:37 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 13:30:37 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 13:30:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JseymRzYMU/Render', 13:30:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:37 INFO - 'HOME': '/Users/cltbld', 13:30:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:37 INFO - 'LOGNAME': 'cltbld', 13:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:37 INFO - 'MOZ_NO_REMOTE': '1', 13:30:37 INFO - 'NO_EM_RESTART': '1', 13:30:37 INFO - 'PAGER': '/bin/cat', 13:30:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:37 INFO - 'PWD': '/builds/slave/test', 13:30:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:37 INFO - 'SHELL': '/bin/bash', 13:30:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CRYqU9kOHc/Listeners', 13:30:37 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 13:30:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:37 INFO - 'USER': 'cltbld', 13:30:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:37 INFO - 'XPC_FLAGS': '0x0', 13:30:37 INFO - 'XPC_SERVICE_NAME': '0', 13:30:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:30:37 INFO - Cleaning up... 13:30:37 INFO - Return code: 0 13:30:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:30:37 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')]} 13:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:37 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')]} 13:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:37 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 0x10f499490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f40f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc2d96ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2add30>, '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 0x10f113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a5b20>, '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.JseymRzYMU/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.CRYqU9kOHc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 13:30:37 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 13:30:37 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 13:30:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JseymRzYMU/Render', 13:30:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:37 INFO - 'HOME': '/Users/cltbld', 13:30:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:37 INFO - 'LOGNAME': 'cltbld', 13:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:37 INFO - 'MOZ_NO_REMOTE': '1', 13:30:37 INFO - 'NO_EM_RESTART': '1', 13:30:37 INFO - 'PAGER': '/bin/cat', 13:30:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:37 INFO - 'PWD': '/builds/slave/test', 13:30:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:37 INFO - 'SHELL': '/bin/bash', 13:30:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CRYqU9kOHc/Listeners', 13:30:37 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 13:30:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:37 INFO - 'USER': 'cltbld', 13:30:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:37 INFO - 'XPC_FLAGS': '0x0', 13:30:37 INFO - 'XPC_SERVICE_NAME': '0', 13:30:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:38 INFO - Downloading/unpacking blobuploader==1.2.4 13:30:38 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 13:30:38 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 13:30:38 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 13:30:38 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 13:30:38 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 13:30:38 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 13:30:40 INFO - Downloading blobuploader-1.2.4.tar.gz 13:30:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:30:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:30:40 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 13:30:40 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 13:30:40 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 13:30:40 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 13:30:40 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 13:30:40 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 13:30:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:30:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:30: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 13:30: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 13:30: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 13:30: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 13:30: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 13:30: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 13:30:41 INFO - Downloading docopt-0.6.1.tar.gz 13:30:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:30:41 INFO - Installing collected packages: blobuploader, requests, docopt 13:30:41 INFO - Running setup.py install for blobuploader 13:30:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:30:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:30:42 INFO - Running setup.py install for requests 13:30:42 INFO - Running setup.py install for docopt 13:30:42 INFO - Successfully installed blobuploader requests docopt 13:30:42 INFO - Cleaning up... 13:30:42 INFO - Return code: 0 13:30:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:30: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')]} 13:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30: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')]} 13:30:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:42 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 0x10f499490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f40f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc2d96ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2add30>, '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 0x10f113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a5b20>, '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.JseymRzYMU/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.CRYqU9kOHc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 13:30:42 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 13:30:42 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 13:30:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JseymRzYMU/Render', 13:30:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:42 INFO - 'HOME': '/Users/cltbld', 13:30:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:42 INFO - 'LOGNAME': 'cltbld', 13:30:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:42 INFO - 'MOZ_NO_REMOTE': '1', 13:30:42 INFO - 'NO_EM_RESTART': '1', 13:30:42 INFO - 'PAGER': '/bin/cat', 13:30:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:42 INFO - 'PWD': '/builds/slave/test', 13:30:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:42 INFO - 'SHELL': '/bin/bash', 13:30:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CRYqU9kOHc/Listeners', 13:30:42 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 13:30:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:42 INFO - 'USER': 'cltbld', 13:30:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:42 INFO - 'XPC_FLAGS': '0x0', 13:30:42 INFO - 'XPC_SERVICE_NAME': '0', 13:30:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:30:43 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-OY5sGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:30:43 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-xu8cUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:30:43 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-5WLe1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:30:43 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-_Bbl9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:30:43 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-8_pPWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:30:43 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-68L2b6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:30:43 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-VUclbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:30:43 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-vOda7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:30:43 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-8fqEMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:30:44 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-SfxJl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:30:44 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-2K0v3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:30:44 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-lGp3Qe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:30:44 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-KMAOLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:30:44 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-6oqReU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:30:44 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-qjBZNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:30:44 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-YCJySi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:30:44 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-_S31bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:30:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:30:44 INFO - Running setup.py install for manifestparser 13:30:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:30:44 INFO - Running setup.py install for mozcrash 13:30:45 INFO - Running setup.py install for mozdebug 13:30:45 INFO - Running setup.py install for mozdevice 13:30:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:30:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:30:45 INFO - Running setup.py install for mozfile 13:30:45 INFO - Running setup.py install for mozhttpd 13:30:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:30:45 INFO - Running setup.py install for mozinfo 13:30:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:30:45 INFO - Running setup.py install for mozInstall 13:30:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:30:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:30:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:30:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:30:46 INFO - Running setup.py install for mozleak 13:30:46 INFO - Running setup.py install for mozlog 13:30:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:30:46 INFO - Running setup.py install for moznetwork 13:30:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:30:46 INFO - Running setup.py install for mozprocess 13:30:46 INFO - Running setup.py install for mozprofile 13:30:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:30:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:30:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:30:46 INFO - Running setup.py install for mozrunner 13:30:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:30:46 INFO - Running setup.py install for mozscreenshot 13:30:47 INFO - Running setup.py install for moztest 13:30:47 INFO - Running setup.py install for mozversion 13:30:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:30:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:30:47 INFO - Cleaning up... 13:30:47 INFO - Return code: 0 13:30:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:30: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')]} 13:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30: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')]} 13:30:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:47 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 0x10f499490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f40f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc2d96ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2add30>, '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 0x10f113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a5b20>, '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.JseymRzYMU/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.CRYqU9kOHc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 13:30:47 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 13:30:47 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 13:30:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JseymRzYMU/Render', 13:30:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:47 INFO - 'HOME': '/Users/cltbld', 13:30:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:47 INFO - 'LOGNAME': 'cltbld', 13:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:47 INFO - 'MOZ_NO_REMOTE': '1', 13:30:47 INFO - 'NO_EM_RESTART': '1', 13:30:47 INFO - 'PAGER': '/bin/cat', 13:30:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:47 INFO - 'PWD': '/builds/slave/test', 13:30:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:47 INFO - 'SHELL': '/bin/bash', 13:30:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CRYqU9kOHc/Listeners', 13:30:47 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 13:30:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:47 INFO - 'USER': 'cltbld', 13:30:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:47 INFO - 'XPC_FLAGS': '0x0', 13:30:47 INFO - 'XPC_SERVICE_NAME': '0', 13:30:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:30:47 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-lqLGNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:30:47 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)) 13:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:30:47 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-mcnjGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:30:47 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)) 13:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:30:47 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-NwZgPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:30:48 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)) 13:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:30:48 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-bbb0mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:30:48 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)) 13:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:30:48 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-QTIGv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:30:48 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)) 13:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:30:48 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-ziwpRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:30:48 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)) 13:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:30:48 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-gFudsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:30:48 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)) 13:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:30:48 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-daC3_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:30:48 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)) 13:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:30:48 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-r7wgME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:30:48 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)) 13:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:30:48 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-xSfhBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:30:48 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)) 13:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:30:48 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-4KsS7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:30:48 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)) 13:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:30:48 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-fhqtNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:30:48 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)) 13:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:30:48 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-mW0RQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:30:49 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)) 13:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:30:49 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-AlW8Y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:30:49 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)) 13:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:30:49 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-qLRe4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:30:49 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)) 13:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:30:49 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-XMALl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:30:49 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)) 13:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:30:49 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-6SUhUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:30:49 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)) 13:30:49 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)) 13:30:49 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)) 13:30:49 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)) 13:30:49 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)) 13:30:49 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)) 13:30:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:30:49 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 13:30:49 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 13:30:49 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 13:30:49 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 13:30:49 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 13:30:49 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 13:30:51 INFO - Downloading blessings-1.6.tar.gz 13:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:30:52 INFO - Installing collected packages: blessings 13:30:52 INFO - Running setup.py install for blessings 13:30:52 INFO - Successfully installed blessings 13:30:52 INFO - Cleaning up... 13:30:52 INFO - Return code: 0 13:30:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:30:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:30:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:30:52 INFO - Reading from file tmpfile_stdout 13:30:52 INFO - Current package versions: 13:30:52 INFO - blessings == 1.6 13:30:52 INFO - blobuploader == 1.2.4 13:30:52 INFO - docopt == 0.6.1 13:30:52 INFO - functools32 == 3.2.3-2 13:30:52 INFO - jsonschema == 2.5.1 13:30:52 INFO - manifestparser == 1.1 13:30:52 INFO - mozInstall == 1.12 13:30:52 INFO - mozcrash == 0.17 13:30:52 INFO - mozdebug == 0.1 13:30:52 INFO - mozdevice == 0.48 13:30:52 INFO - mozfile == 1.2 13:30:52 INFO - mozhttpd == 0.7 13:30:52 INFO - mozinfo == 0.9 13:30:52 INFO - mozleak == 0.1 13:30:52 INFO - mozlog == 3.4 13:30:52 INFO - moznetwork == 0.27 13:30:52 INFO - mozprocess == 0.23 13:30:52 INFO - mozprofile == 0.28 13:30:52 INFO - mozrunner == 6.12 13:30:52 INFO - mozscreenshot == 0.1 13:30:52 INFO - mozsystemmonitor == 0.3 13:30:52 INFO - moztest == 0.7 13:30:52 INFO - mozversion == 1.4 13:30:52 INFO - psutil == 3.1.1 13:30:52 INFO - requests == 1.2.3 13:30:52 INFO - wsgiref == 0.1.2 13:30:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:30: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')]} 13:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30: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')]} 13:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:52 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 0x10f499490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f40f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc2d96ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2add30>, '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 0x10f113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a5b20>, '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.JseymRzYMU/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.CRYqU9kOHc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 13:30:52 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 13:30:52 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 13:30:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JseymRzYMU/Render', 13:30:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:52 INFO - 'HOME': '/Users/cltbld', 13:30:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:52 INFO - 'LOGNAME': 'cltbld', 13:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:52 INFO - 'MOZ_NO_REMOTE': '1', 13:30:52 INFO - 'NO_EM_RESTART': '1', 13:30:52 INFO - 'PAGER': '/bin/cat', 13:30:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:52 INFO - 'PWD': '/builds/slave/test', 13:30:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:52 INFO - 'SHELL': '/bin/bash', 13:30:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CRYqU9kOHc/Listeners', 13:30:52 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 13:30:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:52 INFO - 'USER': 'cltbld', 13:30:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:52 INFO - 'XPC_FLAGS': '0x0', 13:30:52 INFO - 'XPC_SERVICE_NAME': '0', 13:30:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:53 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)) 13:30:53 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)) 13:30:53 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)) 13:30:53 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)) 13:30:53 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)) 13:30:53 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)) 13:30:53 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)) 13:30:53 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)) 13:30:53 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)) 13:30:53 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)) 13:30:53 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)) 13:30:53 INFO - Cleaning up... 13:30:53 INFO - Return code: 0 13:30:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:30:53 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')]} 13:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:53 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')]} 13:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:53 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 0x10f499490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f40f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc2d96ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2add30>, '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 0x10f113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a5b20>, '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.JseymRzYMU/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.CRYqU9kOHc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 13:30:53 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 13:30:53 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 13:30:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JseymRzYMU/Render', 13:30:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:53 INFO - 'HOME': '/Users/cltbld', 13:30:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:53 INFO - 'LOGNAME': 'cltbld', 13:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:53 INFO - 'MOZ_NO_REMOTE': '1', 13:30:53 INFO - 'NO_EM_RESTART': '1', 13:30:53 INFO - 'PAGER': '/bin/cat', 13:30:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:53 INFO - 'PWD': '/builds/slave/test', 13:30:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:53 INFO - 'SHELL': '/bin/bash', 13:30:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CRYqU9kOHc/Listeners', 13:30:53 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 13:30:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:53 INFO - 'USER': 'cltbld', 13:30:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:53 INFO - 'XPC_FLAGS': '0x0', 13:30:53 INFO - 'XPC_SERVICE_NAME': '0', 13:30:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:30:53 INFO - Cleaning up... 13:30:53 INFO - Return code: 0 13:30:53 INFO - Running post-action listener: _resource_record_post_action 13:30:53 INFO - Running post-action listener: _start_resource_monitoring 13:30:53 INFO - Starting resource monitoring. 13:30:53 INFO - [mozharness: 2016-10-20 20:30:53.539607Z] Finished create-virtualenv step (success) 13:30:53 INFO - [mozharness: 2016-10-20 20:30:53.540550Z] Running install step. 13:30:53 INFO - Running pre-action listener: _resource_record_pre_action 13:30:53 INFO - Running main action method: install 13:30:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:30:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:30:53 INFO - Reading from file tmpfile_stdout 13:30:53 INFO - Detecting whether we're running mozinstall >=1.0... 13:30:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:30:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:30:53 INFO - Reading from file tmpfile_stdout 13:30:53 INFO - Output received: 13:30:53 INFO - Usage: mozinstall [options] installer 13:30:53 INFO - Options: 13:30:53 INFO - -h, --help show this help message and exit 13:30:53 INFO - -d DEST, --destination=DEST 13:30:53 INFO - Directory to install application into. [default: 13:30:53 INFO - "/builds/slave/test"] 13:30:53 INFO - --app=APP Application being installed. [default: firefox] 13:30:53 INFO - mkdir: /builds/slave/test/build/application 13:30:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:30:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 13:31:25 INFO - Reading from file tmpfile_stdout 13:31:25 INFO - Output received: 13:31:25 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:31:25 INFO - Running post-action listener: _resource_record_post_action 13:31:25 INFO - [mozharness: 2016-10-20 20:31:25.867012Z] Finished install step (success) 13:31:25 INFO - [mozharness: 2016-10-20 20:31:25.867159Z] Running run-tests step. 13:31:25 INFO - Running pre-action listener: _resource_record_pre_action 13:31:25 INFO - Running main action method: run_tests 13:31:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:31:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:31:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:31:25 INFO - 2016-10-20 13:31:25.881 screenresolution[1938:11262] starting screenresolution argv=screenresolution get 13:31:25 INFO - 2016-10-20 13:31:25.884 screenresolution[1938:11262] Display 0: 1600x1200x32@60 13:31:25 INFO - 2016-10-20 13:31:25.889 screenresolution[1939:11264] starting screenresolution argv=screenresolution list 13:31:25 INFO - Available Modes on Display 0 13:31:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:31:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:31:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:31:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:31:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:31:26 INFO - Intel Iris: 13:31:26 INFO - Chipset Model: Intel Iris 13:31:26 INFO - Type: GPU 13:31:26 INFO - Bus: Built-In 13:31:26 INFO - VRAM (Dynamic, Max): 1536 MB 13:31:26 INFO - Vendor: Intel (0x8086) 13:31:26 INFO - Device ID: 0x0a2e 13:31:26 INFO - Revision ID: 0x0009 13:31:26 INFO - Displays: 13:31:26 INFO - Display: 13:31:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:31:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:31:26 INFO - Display Serial Number: 1600x1200 60 13:31:26 INFO - Main Display: Yes 13:31:26 INFO - Mirror: Off 13:31:26 INFO - Online: Yes 13:31:26 INFO - Rotation: Supported 13:31:26 INFO - Return code: 0 13:31:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:31:26 INFO - Python 2.7.3 13:31:26 INFO - Return code: 0 13:31:26 INFO - grabbing minidump binary from tooltool 13:31:26 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')]} 13:31:26 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 0x10f2add30>, '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 0x10f113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:31:26 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 13:31:26 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 13:31:26 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 13:31:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:31:26 INFO - Return code: 0 13:31:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:31:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:31:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:31:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:31:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:31:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cy-BrosuTouPrG3l19ShUA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0085', '--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 13:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Cy-BrosuTouPrG3l19ShUA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0085 --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 13:31:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JseymRzYMU/Render', 13:31:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:31:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:31:26 INFO - 'HOME': '/Users/cltbld', 13:31:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:31:26 INFO - 'LOGNAME': 'cltbld', 13:31:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:31:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:26 INFO - 'MOZ_NO_REMOTE': '1', 13:31:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:31:26 INFO - 'NO_EM_RESTART': '1', 13:31:26 INFO - 'PAGER': '/bin/cat', 13:31:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:26 INFO - 'PWD': '/builds/slave/test', 13:31:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:31:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:31:26 INFO - 'SHELL': '/bin/bash', 13:31:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CRYqU9kOHc/Listeners', 13:31:26 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 13:31:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:31:26 INFO - 'USER': 'cltbld', 13:31:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:31:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:26 INFO - 'XPC_FLAGS': '0x0', 13:31:26 INFO - 'XPC_SERVICE_NAME': '0', 13:31:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:31:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cy-BrosuTouPrG3l19ShUA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0085', '--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 13:31:26 INFO - mozversion application_buildid: 20161020114750 13:31:26 INFO - mozversion application_changeset: 44754fcbce505bb509c290657231d65918f819af 13:31:26 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:31:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:31:26 INFO - mozversion application_name: Firefox 13:31:26 INFO - mozversion application_remotingname: firefox-dev 13:31:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:31:26 INFO - mozversion application_vendor: Mozilla 13:31:26 INFO - mozversion application_version: 51.0a2 13:31:26 INFO - mozversion platform_buildid: 20161020114750 13:31:26 INFO - mozversion platform_changeset: 44754fcbce505bb509c290657231d65918f819af 13:31:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:31:26 INFO - mozversion platform_version: 51.0a2 13:31:26 INFO - using testdate: 1476995486 13:31:26 INFO - actual date: 1476995486 13:31:26 INFO - starting webserver on 'localhost:50539' 13:31:26 INFO - SUITE-START | Running 2 tests 13:31:26 INFO - TEST-START | dromaeo_css 13:31:26 INFO - operating with platform_type : mac_ 13:31:26 INFO - Initialising browser for dromaeo_css test... 13:31:26 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmp5nKj8j/profile http://localhost:50539/getInfo.html) 13:31:29 INFO - PROCESS | 1949 | __metrics Screen width/height:1600/1200 13:31:29 INFO - PROCESS | 1949 | colorDepth:24 13:31:29 INFO - PROCESS | 1949 | Browser inner width/height: 1024/689 13:31:29 INFO - PROCESS | 1949 | __metrics 13:31:29 ERROR - PROCESS | 1949 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 13:31:29 INFO - TEST-INFO | 1949: exit 0 13:31:29 INFO - Browser initialized. 13:31:29 INFO - Running cycle 1/1 for dromaeo_css test... 13:31:29 INFO - TEST-INFO | started process 1952 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmp5nKj8j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:31:41 INFO - PROCESS | 1952 | RSS: Main: 225021952 13:31:41 INFO - PROCESS | 1952 | 13:32:31 INFO - PROCESS | 1952 | 1476995551345 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] 13:34:43 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:50539/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50539/tests/dromaeo/cssquery-ext.html) 13:34:45 INFO - PROCESS | 1952 | RSS: Main: 237555712 13:34:45 INFO - PROCESS | 1952 | 13:37:47 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:50539/tests/dromaeo/cssquery-ext.html (next: http://localhost:50539/tests/dromaeo/cssquery-jquery.html) 13:37:47 INFO - PROCESS | 1952 | RSS: Main: 249208832 13:37:47 INFO - PROCESS | 1952 | 13:40:49 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:50539/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50539/tests/dromaeo/cssquery-mootools.html) 13:40:50 INFO - PROCESS | 1952 | RSS: Main: 251432960 13:40:50 INFO - PROCESS | 1952 | 13:43:52 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:50539/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50539/tests/dromaeo/cssquery-prototype.html) 13:43:52 INFO - PROCESS | 1952 | RSS: Main: 251731968 13:43:52 INFO - PROCESS | 1952 | 13:46:55 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:50539/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50539/tests/dromaeo/cssquery-yui.html) 13:46:56 INFO - PROCESS | 1952 | RSS: Main: 256409600 13:46:56 INFO - PROCESS | 1952 | 13:49:58 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:50539/tests/dromaeo/cssquery-yui.html (next: http://localhost:50539/tests/dromaeo/cssquery-dojo.html) 13:49:59 INFO - PROCESS | 1952 | RSS: Main: 257777664 13:49:59 INFO - PROCESS | 1952 | 13:49:59 INFO - PROCESS | 1952 | __start_tp_report 13:49:59 INFO - PROCESS | 1952 | _x_x_mozilla_page_load 13:49:59 INFO - PROCESS | 1952 | _x_x_mozilla_page_load_details 13:49:59 INFO - PROCESS | 1952 | |i|pagename|runs| 13:49:59 INFO - PROCESS | 1952 | |0;dojo.html;3337.399268131736;3393.1856354474935;3414.9317013659743;3428.434308339124;3433.9484907726387;4202.243596152692;5703.344115426717;5823.854403639901;5858.443447872451;5920.792772252972;5801.854953626162;5830.621009634371;5849.327327357355;5883.88232235355;5896.734646940888;5287.550558202548;5298.417174110845;5340.412554618989;5353.08997470429;5357.08929481989;5370.516653501184;5395.7032363220005;5398;5405.675659460425;5415.187721841716;5273.1826566882;5299.54953828923;5359.5712343012465;5369.5972802039805;5386.569074474052;4619.792109355087;5049.040682270375;5338.866528336784;5344.064788661969;5379.784808607651;5291.920621190647;5311.150215965427;5330.307060082203;5369.6509726867625;5401.405845357008;5653.971730141364;5932.169496270526;5957.791477298274;5980.760769569212;6007.038873780218;6123.557162997608;6194.81415557534;6208.50331973441;6230.158928544633;6255.874882502325;6303.842403939892;6310.558260921737;6365.936340636581;6376.29860715321;6382.712777925005;5929.407059294036;6063.818085457443;6069.332373438918;6072.696365181723;6082.96958515209;6315.989441689308;6368.713407896656;6415.326390728999;6423.068655044993;6444.613323200623;6255.843603909848;6275.215598050244;6278.6860656966965;6285.560010799291;6295.496360291166;6176.4441200292185;6178.165947597106;6243.219597550306;6317.494600432046;6327.96836015817;5687.829365119053;5875.8248350330105;6293.087502312139;6295.811125666238;6298.8425289367215;5675.404082571271;6272.498200143978;6280.685965701697;6284.937150628527;6302.747890084437;4781.95218047822;4900.264960255919;4931.852044438672;5025.901352213849;5053.267276244924;4454.688171828006;4483.865484035484;4511.3458548510935;4544.500104988449;4550.385697930803;5890.941090589039;5997.760089596367;6002.069679199731;6016.368281330485;6016.669083200466;6146.61701117254;6290.339514351019;6301.653409062454;6307.779227727007;6316.842078948063;5919.644821310735;5959.7914073008105;5974.970125149346;5983.922893879057;6002.849928751729;5473.06957817172;5492.615516913777;5502.0371434998715;5523.696196709139;5531.834044978657;6281.654509002049;6331.145295385249;6340.080688300171;6341.0805433212845;6342.5243106767175;4570.4972453030805;5349.893002140013;6214.564980451325;6266.216722909637;6283.8114856554375;5066.316047333563;5165.690058596496;6342.682865856596;6347.143135676624;6360.650164241011;4962.032403681247;5453.209284653783;6277.246730392382;6307;6327.936720632735;6184.103305020657;6230.563860529719;6231.719572619334;6299.748010079546;6304.338044505261;6115.301188035945;6146.262448506208;6198.81403557894;6205.348438413902;6213.099100630293;5117.820876269461;5588.714595642944;6151.138840562236;6195.566310358232;6219.937800622117;5317.548008419173;5893.5874488785375;5965.970170149121;6041.939580604314;6051.152838602688;6114.479856340571;6121.3572574879;6125.785597504066;6134.938650613437;6245.5628106032145;6080.858333083529;6085.6348619083;6104.145419641165;6106.358832322542;6109.6475967989745 13:49:59 INFO - PROCESS | 1952 | |1;ext.html;477.9318223769874;494.04402481198883;511.07495433265814;523.2648129378225;527.3961314295132;35825;41610.79194604026;41651;41654.375184372184;41678;42129.7893510532;42610.93472663185;42687.14625707492;42774.50289239877;42847.78576107115;9773.951130244339;9952.452615106165;9961.800763984716;10000.59997600095;10001.399916005026;9879.06148915852;9959.302848800588;9961.153301969342;9965.003499650049;9990.800183996316;9955.701328960144;10007.849882251772;10012.399256044624;10024.348417352885;10064.748381290454;9911.355761875491;9938.9503052485;9969;9974.152197063295;10003.549840257134;9818.852717209247;9913.801723965553;9924.156446701967;9934.45360505172;9937.155341795957;34739.826300868335;38330.616693832984;40269.39595906064;40308.387664493384;40419.98950026243;3187.4900015997328;3315.4032274190636;3346.0129261867564;3367.6295607483157;3750.249950010009;27533.86233068822;29415;29828.806847726282;30744.84627576848;31125.844370778228;2978.6447166539174;3292.539044533767;3292.5719656444508;3300.785448945835;3318.2533929865585;414958.999999997;470839;486259;505554;509388;61822.38177618256;61847.07229391473;62527;62548;62591;34293.314133717686;35041.474377884355;35045.29909401797;64960;65245.34754652488;16883.746743798853;16930.492085237463;16967.830321696623;16982.915085424494;17038.233279502452;13011.869881301254;13109.27898965547;13116;13139.802902956464;13156.539521116714;19131.426057218305;19140.8085919139;19143.80856191448;19149.85100893951;19161.233550658097;6374.07575901501;6395.16862807832;7851.646675899598;8013;8044.557549334726;858.8153546987428;1008.0927165551062;1032.3754128752148;1035.30634474902;1111.9610813621484;25140.874295628404;27709.86145069302;27817.443651126865;30095.645695943735;30826.845865770527;881.7619242804535;904.7692838326317;1005.4118340770731;1018.8130827585779;1026.2405819693522;15357.769633455508;15785.68428631421;15858.444954426539;15948.920255398882;16114.919425402797;682107;699098;700263;701595;705053;57347;57377.713111434176;57484.71257643685;57545.424545754846;57727;1356.9958230909056;1359.232033900843;1379.9379027943567;1385.1273697570466;1398.979015314771;29502.704972950854;29935.70064299416;30207.199009502427;30218.697813021587;30381.784728610608;49063.018739625724;49180.75409622929;49536.256956146404;49538;49565.50434495609;581068;583924.0803796124;583970.0801496136;584921;585742;26291.474170516864;26407.867960660074;26738.064167754037;26871;27536.862315689094;46903.53096468992;46923.53076469192;47237;47273.29090063583;47652.761736192486;38364.65723699657;38581.2283754329;39034.6096539031;39093;40071;39093.21813563656;39297.01757455972;39362.409563855996;40341.59658403378;40501.79749101236;32527.024189274358;32802;37276.884933374335;38348.80825595854;38441.84674459771;33893.152671183416;34060.31879362449;34802.651973479944;35091.298174036885;35386;25692.100776472733;26104.34739131537;26118.216453506426;26155.869220653774;26354.472910542067 13:49:59 INFO - PROCESS | 1952 | |2;jquery.html;362.25375726004427;372.8098669678464;385.5931991748704;392.992140157197;408.07774429788685;19033.619327613458;20491.282805101826;21539.2461263856;21682.457938551543;21791.237306694267;11475.426228688553;11803.940980295109;11958.7608247835;11986.861248181409;12056.156069075168;5347.54545863602;5616.831495055155;5645.1814486899375;5653.180288858113;5661.46216109471;5527.695976721278;5632.239647647577;5759.942400576004;6045.516358691316;6086.360932102132;6043.546733994946;6098.451139397475;6109.816705498843;6112.052631842072;6132.846678833021;5840;6031.457168854802;6064.3935606439445;6103.755849766004;6135.049067394539;5184.196449550326;5797.652140871562;5852.76588936442;5886;5903.586748927577;24346.756532434625;24982.500349992897;25154.371140721447;25704.871475642503;25746.485070298488;2156.223759446598;2166.458385403649;2168.945776355588;2207.404000919759;2764.7926405519665;9296.442213467213;9745.658901938468;10117.696469105938;10351;10386.480675966171;1793.820617938209;1819.1540933466001;1869;1879.473747350744;1892.8201820826998;121493;128860;131642;133496.88864168;134073;9438.858417123749;11563.537458501565;11843.170978031627;11892.583759568373;11950.641480755417;14651.194184319966;14669.266536673123;14697.77953330701;14702.26488675562;14706.485273015607;7562.016937798051;7717;7740.458167928191;7800.609969501502;7850.861625064334;7257.2742725727;7288.08898887639;7294.343509084208;7413.518121322205;7418;3790.6209379061875;4548.499665036843;4557.407537020233;4560.885977850514;4564.360989461478;1904.5809921817179;1918.611328895534;1936.5933154037527;1952.4728323352615;1985.186073709772;788.9763307100797;839.5802098950525;908.2869947091501;919.7557958581041;1017.049059129716;20439.79560204379;21177.364679059654;21186.57626847485;21336.359909202747;21477.422709274986;960.3229723045237;984.3208186351395;984.5815528400544;986.5807032011367;1003.9419190659265;8069.87895181561;11200.327980321206;11215.271007384494;11219.326840389604;11237.662870113909;607761;610596;612381;629787;632104;139140;140122.2993885024;140358;142224;147640;930.544033423631;937.7608709778963;946.4226821638795;946.9195118415012;984.832972927098;17691.911540442215;18488.075596219867;18854.71717924205;18953.620927581094;18961.810381896004;54890.725546372014;56691.433085668614;56831.715841422185;56900;56920.430795693166;75254.24745752472;76068.61965690136;78753.60623196847;81573.18939178735;82863;6935.306469353024;7900.091489478784;7960.880586791087;8048.154943730824;8172.101068882299;10290.897091028994;12408.75182496363;12626.810597841224;12806.935965320114;13074.607761767162;10791.298565593212;11099.334039957628;11301.547938082385;11393.316401015965;11408.714782130513;7959.9602001989615;10536.683899483029;10641.048034934498;10737.194710396907;11160.832587511357;9471.810563788547;9485.241180705665;9765;10441.008104230086;11300.717482063013;7255.310745479171;7326.120865496175;7421;7433.405327573673;7440.55356678601;9304.860427093734;9998.950005250219;10358.015988481082;10860.715976184014;11259.09927205838 13:49:59 INFO - PROCESS | 1952 | |3;mootools.html;1219.5121951219512;1336.0180267503385;1593.760935859621;1743.7096548554073;1813.8276863697945;7577.431692623055;7988.241117093867;8246.793830154234;9082.455052696834;9104.681336153237;8569.828603427928;8843;8860.202581767655;8927.37508374414;8933.642654293837;2387.9493023069836;2403.3270684208364;2415.311636183688;2415.903363865443;2419.7822196002357;2380.785729284364;2411.6141417373224;2423.6122220444645;2426.4783071639595;2432.0879670123704;2398.7121545414575;2402.5795485790004;2411.9758802411925;2429.927102186937;2436.549238390903;2384.463495713468;2391.0316321889663;2401.2436082634003;2401.927942161738;2405.7594240575977;2376.4296568823356;2383.9868056076098;2387.0809738250723;2392.138830021191;2398.484325869946;8864.379493435463;8939;8944.821103577957;8978.775530611721;8978.86531702025;5251.947480525184;5408.810691625774;5412.134058550652;5420.945790542083;5430.456954304577;3560.12776869666;3665.7433979621437;3697.001809511417;3716.832742526593;3722.050877026368;1088.2871719024051;1108.3073079325422;1109.018518611027;1132.8923752243525;1138.772245550893;11722.706932326675;11802.645920622395;11864.822027669592;11872.881271187263;11882.940585297105;4711.976440117846;4734.841099629612;4753.168195565762;4873.926891096637;4909.459959404463;10008.699739007841;10095;10102.898971010343;10103.14123299513;10127.936566660543;4444.933326000112;5382.703951282717;5413.648112872651;5423.186522021729;5429.049916264638;4421.602055814992;4563.498015218323;4809.44691360498;4923.163062279421;4959.256111583291;3991.0621004064024;3992.7005474589523;4081.9387709184384;4129.97935010323;4134;1323.4838413018738;1339.9330033498286;1341.3025226881966;1341.7718987772103;1352.837659480849;762.9237076292326;857.9571021448903;903.8418276801665;908.1599520443564;910.9225715814098;5713;5740.196372507852;5779.971100144472;5814.912776308359;5962.493188078975;875.4528419737663;955.3121752338305;968.7190714692802;977.0815433492494;992.1219720547223;3759.3045286622064;3891.8443262269757;3937.9803100984313;3938.15329704115;3998.8600398985895;10688.732781680364;11007.174461915389;11033.503492342863;11035.172362072877;11040.116790656888;10874.130069594414;10884.129269658408;10926.836097458545;10932.234743568033;10941;6092.786752463642;7790.805229869298;8193.877091843628;8243.093259741423;8251.092379838214;6008.669523176092;6011.939880601313;6068.969655151696;6076.361981992004;6176.548511099798;10019.148372388428;10080.243981701255;10225.744356390853;10294.639687610897;10310.123639490726;9984.201263899016;10389.9480502597;10502;10534.262601617813;10551.525181367011;7008.053912721921;7225.988361629481;7440.404767618469;7586.582737949466;7723.150453450228;7041.3310735480045;7055.4708396871465;7080.610566418691;8425.946756655418;8527.275181609384;7365.852682946418;7554.433417493819;7575.924240757742;7595.848083038198;7650.502717323357;7208.86601939825;7246.60143692102;7307.378872795872;7389.076365454318;7427.442941779496;6923.446124310144;7003.7548685795755;7025.156981162293;7111.53775004623;7117.217106118426;4651.023285110165;4954.529319714621;5008.774605142705;5013.749312534285;5043.697378157322;3843.7309388342546;4939;5068.594512438923;5102.209157580581;5120.667156634807 13:49:59 INFO - PROCESS | 1952 | |4;prototype.html;279.92508766337266;301.07869918050767;304.8445292900621;308.34322892239527;311.2266018942928;4825.927611085832;4836.0741751240475;5136.2038883972955;5196.9480305196985;5342.652727572705;4484.618807401366;5307.73461326934;5401.70290634015;5515.4760297771745;5521.834344969658;3356.281412056236;3579.6062433132333;3871.4967054283043;4065.6137666921595;4144.088300573869;3521.7710848794873;3790.393537034075;3836.693064554829;3986.2625414298304;4134.586541345871;4129.339305711087;4132.648724858391;4152.709310348277;4167.395727619493;4170.374443833434;4121.032856343428;4137.751734895901;4174.352975288835;4175.478065241845;4186.91626167475;3055.3736484020947;3096.6710785905016;3527.171114788023;3631.6005239423644;3649.872254471081;4329.740215587043;4458.554144585515;4527.841525546623;4995.975020124876;5291.523762861361;4143.969454967075;4706.129366067288;4753.882837533177;4792.640551958582;4802.30366596845;4721.669483136182;4799.880002999953;5760.711964401763;5893;5916.674582897982;3317.6350601434065;3598.1649358826926;3890.9688932432928;3939.7045221608496;3957.663598594123;5297.947020529784;5785.566082543826;6033.728482218266;6108;6131.202943617302;2996.835174065404;3970.900727481778;3972.662323702518;3994.6404823565435;3994.7003974702016;3874.5931677174053;3962.9603703963166;4031.899202519902;4045.59544045599;4073.572274911151;4176.909087275455;4570.954290457053;4724.126036683225;4739.691920025256;4744;4875.366202393737;5622.4417889860015;5790.855228619234;5964.850878728066;5972.40275972408;1151.7235863392725;1274.7896597061567;1280.417410078412;1352.4657760184673;1374.9037567370187;882.8455020371538;915.5056269614333;917.3945196170629;920.6420529718745;927.8608208768603;4571.439993603526;4857.8299759508245;5452.672839629635;5463.590230732631;5497.543151064971;4936.851894443173;5292.947070529322;5706.28671416073;5945.851353716192;5987.341392446828;4699.154152252559;4780.235162374003;5405.135178371442;5431.864203394946;5445.754941027663;2114.9108209272235;2267.6031694453736;2323.6630688550404;2495.90016399342;2619.5592424166634;4451.484911025261;4652.116097941381;5220.738963051832;5544.500994910478;6165.938340616626;5234.816781412708;6077.845209410198;6251.468625166912;6291.591046581958;6332.525060620472;6234.410225392496;6276.905846412307;6284.905726414107;6301.306856245901;6317.431431171217;5645.322561292671;5695.629784064023;5746.741396637245;6068.848278793065;6076.270847498328;5075.741295123635;5990.341062483036;6043.7884674036195;6072.931136138709;6122.081687746873;5209.635325527328;5908.527317814651;6170.784022559189;6195.876082478415;6269.589342397924;4000.239954408653;4010.57888921659;4010.6791456682813;4020.1356708307853;4062.7968601570396;5282.181261904411;5355.678659280456;6080.7567697291615;6206.255249369924;6209.968950155401;5541.889162216814;5855.238818953509;5949.3455719871645;5965.970170149121;5985.191999080243;4912.305254687128;5127.46161653021;5847.736851841592;5941.870400071908;5988.5508586855285;5456.03582710232;5493.917591236214;5641.915371269352;5645.858853528694;5804.506616937608;5885.234919460443;6013.128096425906;6018.067199584071;6022.036474164112;6034.155218269358;4618.976905115453;5592.133219351007;5707.514861236841;5886.852063847508;5914.674692891932 13:49:59 INFO - PROCESS | 1952 | |5;yui.html;662.6454846657037;682.5972676121088;731.4067655125808;750.9924900750991;795.9880601790974;12496.937515312411;14849.851501484982;15514.991525550831;15547.067175969436;15570.53288401347;13965.790513142285;14041.92979035106;14044.438222471115;14052;14089.718205635882;613.4540259169343;666.3170250493247;691.1913061717802;801.1988011988012;832.7376876283981;683.9179298484189;835.578033093287;838.2078935406043;838.3335248477475;842.5787106446777;857.8798968144465;872.7381785464368;875.5972252763736;898.0839543665458;905.2622112977901;871.2420194430822;898.4070513461116;899.9235065019449;900.0189793125459;900.1223806788395;657.2605818454239;666.1340257665016;666.5900471210219;667.1327274543074;667.212689026948;14524;14623.415063397451;14818.925905370512;14847.406103755837;14865.925670371578;14570.198639074846;14592.343344549521;14613.050151740103;14674.119552826865;14886.70226595462;11579.36313502757;11872.465739041678;11985.640430787003;12066.698332541757;12388;3727.273181729564;3752.512173417438;3769.4345848122725;3782.3380908340932;3858.594847540996;130058;130495.6950430493;131019;132494;134091.32954335166;10724.195685323632;10803.379493075945;11191.440427978569;11406.828897566544;11622;23224.53550928972;23408.297751067494;23580.88209558941;23627.936742846614;23833.285001449636;8016.358691304682;8023.358131349478;8042.678292868337;8167.346612271004;8269.62786674601;4370.344448332776;4425.75658338788;4509.391232183613;4535.795889184995;4594.770261486912;3549.3078849624076;3599.460080987873;3627.4196128619296;3637.3452778500123;3655.5613326401003;635.8124353315783;644.9129367535417;651.1047309948821;651.2152855808833;655.5542231282774;565.8670212500059;640.8429934666036;641.6631268584031;665.4044630056072;683.8085336105898;9143.725688229364;9738;9789.706308810748;9806.901930980599;9917.900820991697;549.2201074474256;581.9185314056035;630.8517498387876;632.8261075704594;670.7992693079333;4544.795484203219;4545.0909818036525;4800.4479484859685;4802.159622066124;4833.468318484964;136193.31903340618;138383.6161638391;176078.1196094037;178051;181021;111516.88483115227;145723;148662;152024;153989;125753;129954.35022825014;129959.70040299665;129964;131327.03009454865;8904.082203830294;9215.308851836005;9216.2626989842;9242.861357079515;9312.813743725223;57302;62306.44233894189;70338.64830675814;71341.57316853738;72321.6383918077;79283.81074284005;97598;108284.45857770661;108628;109785.90214097757;11907;12060.216085954386;12117.515299387926;12194.81707774402;12497.18768280059;12827;12831;13020.609381718563;13563.186208827501;13871.098378605358;12099.33453660057;12121.575744848888;12299.385030748606;12304.876951230373;12351.876481235073;12062.51749929993;12087.39563021863;12313.199642023239;12327.69180770488;12848.164869283466;10416;11653.067754579783;12057.794220577873;12133.817992730294;12224;8385.245327920517;9064.821573195706;9733.707988760349;9815.509224538602;10647.94676026615;9833.606655733976;10457.379837097798;10670.413127278074;10691.839622405514;10700.732481688021 13:49:59 INFO - PROCESS | 1952 | __end_tp_report 13:49:59 INFO - PROCESS | 1952 | __start_cc_report 13:49:59 INFO - PROCESS | 1952 | _x_x_mozilla_cycle_collect,368 13:49:59 INFO - PROCESS | 1952 | __end_cc_report 13:49:59 INFO - PROCESS | 1952 | __startTimestamp1476996599076__endTimestamp 13:49:59 INFO - PROCESS | 1952 | 13:49:59 INFO - PROCESS | 1952 | ------- Summary: start ------- 13:49:59 INFO - PROCESS | 1952 | Number of tests: 6 13:49:59 INFO - PROCESS | 1952 | 13:49:59 INFO - PROCESS | 1952 | [#0] dojo.html Cycles:165 Average:5767.39 Median:6007.04 stddev:660.65 (11.0%) stddev-sans-first:634.58 13:49:59 INFO - PROCESS | 1952 | Values: 3337.4 3393.2 3414.9 3428.4 3433.9 4202.2 5703.3 5823.9 5858.4 5920.8 5801.9 5830.6 5849.3 5883.9 5896.7 5287.6 5298.4 5340.4 5353.1 5357.1 5370.5 5395.7 5398.0 5405.7 5415.2 5273.2 5299.5 5359.6 5369.6 5386.6 4619.8 5049.0 5338.9 5344.1 5379.8 5291.9 5311.2 5330.3 5369.7 5401.4 5654.0 5932.2 5957.8 5980.8 6007.0 6123.6 6194.8 6208.5 6230.2 6255.9 6303.8 6310.6 6365.9 6376.3 6382.7 5929.4 6063.8 6069.3 6072.7 6083.0 6316.0 6368.7 6415.3 6423.1 6444.6 6255.8 6275.2 6278.7 6285.6 6295.5 6176.4 6178.2 6243.2 6317.5 6328.0 5687.8 5875.8 6293.1 6295.8 6298.8 5675.4 6272.5 6280.7 6284.9 6302.7 4782.0 4900.3 4931.9 5025.9 5053.3 4454.7 4483.9 4511.3 4544.5 4550.4 5890.9 5997.8 6002.1 6016.4 6016.7 6146.6 6290.3 6301.7 6307.8 6316.8 5919.6 5959.8 5975.0 5983.9 6002.8 5473.1 5492.6 5502.0 5523.7 5531.8 6281.7 6331.1 6340.1 6341.1 6342.5 4570.5 5349.9 6214.6 6266.2 6283.8 5066.3 5165.7 6342.7 6347.1 6360.7 4962.0 5453.2 6277.2 6307.0 6327.9 6184.1 6230.6 6231.7 6299.7 6304.3 6115.3 6146.3 6198.8 6205.3 6213.1 5117.8 5588.7 6151.1 6195.6 6219.9 5317.5 5893.6 5966.0 6041.9 6051.2 6114.5 6121.4 6125.8 6134.9 6245.6 6080.9 6085.6 6104.1 6106.4 6109.6 13:49:59 INFO - PROCESS | 1952 | 13:49:59 INFO - PROCESS | 1952 | [#1] ext.html Cycles:180 Average:71304.28 Median:38511.54 stddev:158927.86 (412.7%) stddev-sans-first:159284.73 13:49:59 INFO - PROCESS | 1952 | Values: 477.9 494.0 511.1 523.3 527.4 35825.0 41610.8 41651.0 41654.4 41678.0 42129.8 42610.9 42687.1 42774.5 42847.8 9774.0 9952.5 9961.8 10000.6 10001.4 9879.1 9959.3 9961.2 9965.0 9990.8 9955.7 10007.8 10012.4 10024.3 10064.7 9911.4 9939.0 9969.0 9974.2 10003.5 9818.9 9913.8 9924.2 9934.5 9937.2 34739.8 38330.6 40269.4 40308.4 40420.0 3187.5 3315.4 3346.0 3367.6 3750.2 27533.9 29415.0 29828.8 30744.8 31125.8 2978.6 3292.5 3292.6 3300.8 3318.3 414959.0 470839.0 486259.0 505554.0 509388.0 61822.4 61847.1 62527.0 62548.0 62591.0 34293.3 35041.5 35045.3 64960.0 65245.3 16883.7 16930.5 16967.8 16982.9 17038.2 13011.9 13109.3 13116.0 13139.8 13156.5 19131.4 19140.8 19143.8 19149.9 19161.2 6374.1 6395.2 7851.6 8013.0 8044.6 858.8 1008.1 1032.4 1035.3 1112.0 25140.9 27709.9 27817.4 30095.6 30826.8 881.8 904.8 1005.4 1018.8 1026.2 15357.8 15785.7 15858.4 15948.9 16114.9 682107.0 699098.0 700263.0 701595.0 705053.0 57347.0 57377.7 57484.7 57545.4 57727.0 1357.0 1359.2 1379.9 1385.1 1399.0 29502.7 29935.7 30207.2 30218.7 30381.8 49063.0 49180.8 49536.3 49538.0 49565.5 581068.0 583924.1 583970.1 584921.0 585742.0 26291.5 26407.9 26738.1 26871.0 27536.9 46903.5 46923.5 47237.0 47273.3 47652.8 38364.7 38581.2 39034.6 39093.0 40071.0 39093.2 39297.0 39362.4 40341.6 40501.8 32527.0 32802.0 37276.9 38348.8 38441.8 33893.2 34060.3 34802.7 35091.3 35386.0 25692.1 26104.3 26118.2 26155.9 26354.5 13:49:59 INFO - PROCESS | 1952 | 13:49:59 INFO - PROCESS | 1952 | [#2] jquery.html Cycles:180 Average:36034.40 Median:389.29 stddev:103835.62 (26672.9%) stddev-sans-first:104092.36 13:49:59 INFO - PROCESS | 1952 | Values: 362.3 372.8 385.6 393.0 408.1 19033.6 20491.3 21539.2 21682.5 21791.2 11475.4 11803.9 11958.8 11986.9 12056.2 5347.5 5616.8 5645.2 5653.2 5661.5 5527.7 5632.2 5759.9 6045.5 6086.4 6043.5 6098.5 6109.8 6112.1 6132.8 5840.0 6031.5 6064.4 6103.8 6135.0 5184.2 5797.7 5852.8 5886.0 5903.6 24346.8 24982.5 25154.4 25704.9 25746.5 2156.2 2166.5 2168.9 2207.4 2764.8 9296.4 9745.7 10117.7 10351.0 10386.5 1793.8 1819.2 1869.0 1879.5 1892.8 121493.0 128860.0 131642.0 133496.9 134073.0 9438.9 11563.5 11843.2 11892.6 11950.6 14651.2 14669.3 14697.8 14702.3 14706.5 7562.0 7717.0 7740.5 7800.6 7850.9 7257.3 7288.1 7294.3 7413.5 7418.0 3790.6 4548.5 4557.4 4560.9 4564.4 1904.6 1918.6 1936.6 1952.5 1985.2 789.0 839.6 908.3 919.8 1017.0 20439.8 21177.4 21186.6 21336.4 21477.4 960.3 984.3 984.6 986.6 1003.9 8069.9 11200.3 11215.3 11219.3 11237.7 607761.0 610596.0 612381.0 629787.0 632104.0 139140.0 140122.3 140358.0 142224.0 147640.0 930.5 937.8 946.4 946.9 984.8 17691.9 18488.1 18854.7 18953.6 18961.8 54890.7 56691.4 56831.7 56900.0 56920.4 75254.2 76068.6 78753.6 81573.2 82863.0 6935.3 7900.1 7960.9 8048.2 8172.1 10290.9 12408.8 12626.8 12806.9 13074.6 10791.3 11099.3 11301.5 11393.3 11408.7 7960.0 10536.7 10641.0 10737.2 11160.8 9471.8 9485.2 9765.0 10441.0 11300.7 7255.3 7326.1 7421.0 7433.4 7440.6 9304.9 9999.0 10358.0 10860.7 11259.1 13:49:59 INFO - PROCESS | 1952 | 13:49:59 INFO - PROCESS | 1952 | [#3] mootools.html Cycles:180 Average:5733.76 Median:4744.00 stddev:3228.47 (68.1%) stddev-sans-first:3219.70 13:49:59 INFO - PROCESS | 1952 | Values: 1219.5 1336.0 1593.8 1743.7 1813.8 7577.4 7988.2 8246.8 9082.5 9104.7 8569.8 8843.0 8860.2 8927.4 8933.6 2387.9 2403.3 2415.3 2415.9 2419.8 2380.8 2411.6 2423.6 2426.5 2432.1 2398.7 2402.6 2412.0 2429.9 2436.5 2384.5 2391.0 2401.2 2401.9 2405.8 2376.4 2384.0 2387.1 2392.1 2398.5 8864.4 8939.0 8944.8 8978.8 8978.9 5251.9 5408.8 5412.1 5420.9 5430.5 3560.1 3665.7 3697.0 3716.8 3722.1 1088.3 1108.3 1109.0 1132.9 1138.8 11722.7 11802.6 11864.8 11872.9 11882.9 4712.0 4734.8 4753.2 4873.9 4909.5 10008.7 10095.0 10102.9 10103.1 10127.9 4444.9 5382.7 5413.6 5423.2 5429.0 4421.6 4563.5 4809.4 4923.2 4959.3 3991.1 3992.7 4081.9 4130.0 4134.0 1323.5 1339.9 1341.3 1341.8 1352.8 762.9 858.0 903.8 908.2 910.9 5713.0 5740.2 5780.0 5814.9 5962.5 875.5 955.3 968.7 977.1 992.1 3759.3 3891.8 3938.0 3938.2 3998.9 10688.7 11007.2 11033.5 11035.2 11040.1 10874.1 10884.1 10926.8 10932.2 10941.0 6092.8 7790.8 8193.9 8243.1 8251.1 6008.7 6011.9 6069.0 6076.4 6176.5 10019.1 10080.2 10225.7 10294.6 10310.1 9984.2 10389.9 10502.0 10534.3 10551.5 7008.1 7226.0 7440.4 7586.6 7723.2 7041.3 7055.5 7080.6 8425.9 8527.3 7365.9 7554.4 7575.9 7595.8 7650.5 7208.9 7246.6 7307.4 7389.1 7427.4 6923.4 7003.8 7025.2 7111.5 7117.2 4651.0 4954.5 5008.8 5013.7 5043.7 3843.7 4939.0 5068.6 5102.2 5120.7 13:49:59 INFO - PROCESS | 1952 | 13:49:59 INFO - PROCESS | 1952 | [#4] prototype.html Cycles:180 Average:4623.55 Median:5131.83 stddev:1497.79 (29.2%) stddev-sans-first:1466.08 13:49:59 INFO - PROCESS | 1952 | Values: 279.9 301.1 304.8 308.3 311.2 4825.9 4836.1 5136.2 5196.9 5342.7 4484.6 5307.7 5401.7 5515.5 5521.8 3356.3 3579.6 3871.5 4065.6 4144.1 3521.8 3790.4 3836.7 3986.3 4134.6 4129.3 4132.6 4152.7 4167.4 4170.4 4121.0 4137.8 4174.4 4175.5 4186.9 3055.4 3096.7 3527.2 3631.6 3649.9 4329.7 4458.6 4527.8 4996.0 5291.5 4144.0 4706.1 4753.9 4792.6 4802.3 4721.7 4799.9 5760.7 5893.0 5916.7 3317.6 3598.2 3891.0 3939.7 3957.7 5297.9 5785.6 6033.7 6108.0 6131.2 2996.8 3970.9 3972.7 3994.6 3994.7 3874.6 3963.0 4031.9 4045.6 4073.6 4176.9 4571.0 4724.1 4739.7 4744.0 4875.4 5622.4 5790.9 5964.9 5972.4 1151.7 1274.8 1280.4 1352.5 1374.9 882.8 915.5 917.4 920.6 927.9 4571.4 4857.8 5452.7 5463.6 5497.5 4936.9 5292.9 5706.3 5945.9 5987.3 4699.2 4780.2 5405.1 5431.9 5445.8 2114.9 2267.6 2323.7 2495.9 2619.6 4451.5 4652.1 5220.7 5544.5 6165.9 5234.8 6077.8 6251.5 6291.6 6332.5 6234.4 6276.9 6284.9 6301.3 6317.4 5645.3 5695.6 5746.7 6068.8 6076.3 5075.7 5990.3 6043.8 6072.9 6122.1 5209.6 5908.5 6170.8 6195.9 6269.6 4000.2 4010.6 4010.7 4020.1 4062.8 5282.2 5355.7 6080.8 6206.3 6210.0 5541.9 5855.2 5949.3 5966.0 5985.2 4912.3 5127.5 5847.7 5941.9 5988.6 5456.0 5493.9 5641.9 5645.9 5804.5 5885.2 6013.1 6018.1 6022.0 6034.2 4619.0 5592.1 5707.5 5886.9 5914.7 13:49:59 INFO - PROCESS | 1952 | 13:49:59 INFO - PROCESS | 1952 | [#5] yui.html Cycles:180 Average:26929.69 Median:3632.38 stddev:45106.49 (1241.8%) stddev-sans-first:45189.91 13:49:59 INFO - PROCESS | 1952 | Values: 662.6 682.6 731.4 751.0 796.0 12496.9 14849.9 15515.0 15547.1 15570.5 13965.8 14041.9 14044.4 14052.0 14089.7 613.5 666.3 691.2 801.2 832.7 683.9 835.6 838.2 838.3 842.6 857.9 872.7 875.6 898.1 905.3 871.2 898.4 899.9 900.0 900.1 657.3 666.1 666.6 667.1 667.2 14524.0 14623.4 14818.9 14847.4 14865.9 14570.2 14592.3 14613.1 14674.1 14886.7 11579.4 11872.5 11985.6 12066.7 12388.0 3727.3 3752.5 3769.4 3782.3 3858.6 130058.0 130495.7 131019.0 132494.0 134091.3 10724.2 10803.4 11191.4 11406.8 11622.0 23224.5 23408.3 23580.9 23627.9 23833.3 8016.4 8023.4 8042.7 8167.3 8269.6 4370.3 4425.8 4509.4 4535.8 4594.8 3549.3 3599.5 3627.4 3637.3 3655.6 635.8 644.9 651.1 651.2 655.6 565.9 640.8 641.7 665.4 683.8 9143.7 9738.0 9789.7 9806.9 9917.9 549.2 581.9 630.9 632.8 670.8 4544.8 4545.1 4800.4 4802.2 4833.5 136193.3 138383.6 176078.1 178051.0 181021.0 111516.9 145723.0 148662.0 152024.0 153989.0 125753.0 129954.4 129959.7 129964.0 131327.0 8904.1 9215.3 9216.3 9242.9 9312.8 57302.0 62306.4 70338.6 71341.6 72321.6 79283.8 97598.0 108284.5 108628.0 109785.9 11907.0 12060.2 12117.5 12194.8 12497.2 12827.0 12831.0 13020.6 13563.2 13871.1 12099.3 12121.6 12299.4 12304.9 12351.9 12062.5 12087.4 12313.2 12327.7 12848.2 10416.0 11653.1 12057.8 12133.8 12224.0 8385.2 9064.8 9733.7 9815.5 10647.9 9833.6 10457.4 10670.4 10691.8 10700.7 13:49:59 INFO - PROCESS | 1952 | -------- Summary: end -------- 13:49:59 INFO - PROCESS | 1952 | 13:49:59 INFO - TEST-INFO | 1952: exit 0 13:49:59 INFO - TEST-OK | dromaeo_css | took 1113335ms 13:49:59 INFO - TEST-START | kraken 13:49:59 INFO - operating with platform_type : mac_ 13:49:59 INFO - Initialising browser for kraken test... 13:49:59 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpZxGoZd/profile http://localhost:50539/getInfo.html) 13:50:02 INFO - PROCESS | 1958 | __metrics Screen width/height:1600/1200 13:50:02 INFO - PROCESS | 1958 | colorDepth:24 13:50:02 INFO - PROCESS | 1958 | Browser inner width/height: 1024/689 13:50:02 INFO - PROCESS | 1958 | __metrics 13:50:02 ERROR - PROCESS | 1958 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 13:50:03 INFO - TEST-INFO | 1958: exit 0 13:50:03 INFO - Browser initialized. 13:50:03 INFO - Running cycle 1/1 for kraken test... 13:50:03 INFO - TEST-INFO | started process 1960 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpZxGoZd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:50:15 INFO - PROCESS | 1960 | RSS: Main: 224829440 13:50:15 INFO - PROCESS | 1960 | 13:50:18 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50539/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50539/tests/kraken/driver.html?testName=audio-beat-detection) 13:50:19 INFO - PROCESS | 1960 | RSS: Main: 237441024 13:50:19 INFO - PROCESS | 1960 | 13:50:21 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50539/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50539/tests/kraken/driver.html?testName=audio-dft) 13:50:22 INFO - PROCESS | 1960 | RSS: Main: 244940800 13:50:22 INFO - PROCESS | 1960 | 13:50:25 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50539/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50539/tests/kraken/driver.html?testName=audio-fft) 13:50:26 INFO - PROCESS | 1960 | RSS: Main: 248786944 13:50:26 INFO - PROCESS | 1960 | 13:50:28 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50539/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50539/tests/kraken/driver.html?testName=audio-oscillator) 13:50:29 INFO - PROCESS | 1960 | RSS: Main: 250114048 13:50:29 INFO - PROCESS | 1960 | 13:50:31 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50539/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50539/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:50:31 INFO - PROCESS | 1960 | RSS: Main: 250159104 13:50:31 INFO - PROCESS | 1960 | 13:50:34 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50539/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50539/tests/kraken/driver.html?testName=imaging-darkroom) 13:50:35 INFO - PROCESS | 1960 | RSS: Main: 250482688 13:50:35 INFO - PROCESS | 1960 | 13:50:38 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50539/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50539/tests/kraken/driver.html?testName=imaging-desaturate) 13:50:38 INFO - PROCESS | 1960 | RSS: Main: 250458112 13:50:38 INFO - PROCESS | 1960 | 13:50:41 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50539/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50539/tests/kraken/driver.html?testName=json-parse-financial) 13:50:42 INFO - PROCESS | 1960 | RSS: Main: 250826752 13:50:42 INFO - PROCESS | 1960 | 13:50:43 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50539/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50539/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:50:44 INFO - PROCESS | 1960 | RSS: Main: 250499072 13:50:44 INFO - PROCESS | 1960 | 13:50:46 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50539/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50539/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:50:46 INFO - PROCESS | 1960 | RSS: Main: 250580992 13:50:46 INFO - PROCESS | 1960 | 13:50:49 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50539/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50539/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:50:49 INFO - PROCESS | 1960 | RSS: Main: 250576896 13:50:49 INFO - PROCESS | 1960 | 13:50:52 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50539/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50539/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:50:53 INFO - PROCESS | 1960 | RSS: Main: 251187200 13:50:53 INFO - PROCESS | 1960 | 13:50:56 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50539/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50539/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:50:57 INFO - PROCESS | 1960 | RSS: Main: 251199488 13:50:57 INFO - PROCESS | 1960 | 13:50:59 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50539/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50539/tests/kraken/driver.html?testName=ai-astar) 13:50:59 INFO - PROCESS | 1960 | RSS: Main: 252530688 13:50:59 INFO - PROCESS | 1960 | 13:50:59 INFO - PROCESS | 1960 | __start_tp_report 13:50:59 INFO - PROCESS | 1960 | _x_x_mozilla_page_load 13:50:59 INFO - PROCESS | 1960 | _x_x_mozilla_page_load_details 13:50:59 INFO - PROCESS | 1960 | |i|pagename|runs| 13:50:59 INFO - PROCESS | 1960 | |0;ai-astar;108;131;118;106;172;173;173;117;116;118 13:50:59 INFO - PROCESS | 1960 | |1;audio-beat-detection;146;100;144;176;144;124;110;110;136;110 13:50:59 INFO - PROCESS | 1960 | |2;audio-dft;278;255;204;195;199;201;194;198;190;201 13:50:59 INFO - PROCESS | 1960 | |3;audio-fft;77;54;62;99;86;76;75;50;93;75 13:50:59 INFO - PROCESS | 1960 | |4;audio-oscillator;85;71;89;74;69;72;114;57;74;118 13:50:59 INFO - PROCESS | 1960 | |5;imaging-gaussian-blur;84;86;88;85;88;84;88;86;88;85 13:50:59 INFO - PROCESS | 1960 | |6;imaging-darkroom;99;99;98;100;105;99;134;173;98;145 13:50:59 INFO - PROCESS | 1960 | |7;imaging-desaturate;89;101;91;143;90;89;91;90;90;91 13:50:59 INFO - PROCESS | 1960 | |8;json-parse-financial;58;56;56;56;60;60;58;60;59;59 13:50:59 INFO - PROCESS | 1960 | |9;json-stringify-tinderbox;70;71;79;79;68;69;70;72;70;70 13:50:59 INFO - PROCESS | 1960 | |10;stanford-crypto-aes;85;87;84;84;77;97;109;104;83;86 13:50:59 INFO - PROCESS | 1960 | |11;stanford-crypto-ccm;136;166;162;153;166;152;154;182;197;152 13:50:59 INFO - PROCESS | 1960 | |12;stanford-crypto-pbkdf2;168;169;226;193;168;169;169;165;170;166 13:50:59 INFO - PROCESS | 1960 | |13;stanford-crypto-sha256-iterative;67;72;82;95;90;90;84;66;79;87 13:50:59 INFO - PROCESS | 1960 | __end_tp_report 13:50:59 INFO - PROCESS | 1960 | __start_cc_report 13:50:59 INFO - PROCESS | 1960 | _x_x_mozilla_cycle_collect,955 13:50:59 INFO - PROCESS | 1960 | __end_cc_report 13:50:59 INFO - PROCESS | 1960 | __startTimestamp1476996659333__endTimestamp 13:50:59 INFO - PROCESS | 1960 | 13:50:59 INFO - PROCESS | 1960 | ------- Summary: start ------- 13:50:59 INFO - PROCESS | 1960 | Number of tests: 14 13:50:59 INFO - PROCESS | 1960 | 13:50:59 INFO - PROCESS | 1960 | [#0] ai-astar Cycles:10 Average:133.20 Median:124.50 stddev:28.03 (22.5%) stddev-sans-first:28.21 13:50:59 INFO - PROCESS | 1960 | Values: 108.0 131.0 118.0 106.0 172.0 173.0 173.0 117.0 116.0 118.0 13:50:59 INFO - PROCESS | 1960 | 13:50:59 INFO - PROCESS | 1960 | [#1] audio-beat-detection Cycles:10 Average:130.00 Median:140.00 stddev:23.42 (16.7%) stddev-sans-first:24.11 13:50:59 INFO - PROCESS | 1960 | Values: 146.0 100.0 144.0 176.0 144.0 124.0 110.0 110.0 136.0 110.0 13:50:59 INFO - PROCESS | 1960 | 13:50:59 INFO - PROCESS | 1960 | [#2] audio-dft Cycles:10 Average:211.50 Median:201.00 stddev:29.76 (14.8%) stddev-sans-first:19.55 13:50:59 INFO - PROCESS | 1960 | Values: 278.0 255.0 204.0 195.0 199.0 201.0 194.0 198.0 190.0 201.0 13:50:59 INFO - PROCESS | 1960 | 13:50:59 INFO - PROCESS | 1960 | [#3] audio-fft Cycles:10 Average:74.70 Median:76.50 stddev:15.85 (20.7%) stddev-sans-first:16.79 13:50:59 INFO - PROCESS | 1960 | Values: 77.0 54.0 62.0 99.0 86.0 76.0 75.0 50.0 93.0 75.0 13:50:59 INFO - PROCESS | 1960 | 13:50:59 INFO - PROCESS | 1960 | [#4] audio-oscillator Cycles:10 Average:82.30 Median:73.00 stddev:19.78 (27.1%) stddev-sans-first:20.95 13:50:59 INFO - PROCESS | 1960 | Values: 85.0 71.0 89.0 74.0 69.0 72.0 114.0 57.0 74.0 118.0 13:50:59 INFO - PROCESS | 1960 | 13:50:59 INFO - PROCESS | 1960 | [#5] imaging-gaussian-blur Cycles:10 Average:86.20 Median:87.00 stddev:1.69 (1.9%) stddev-sans-first:1.59 13:50:59 INFO - PROCESS | 1960 | Values: 84.0 86.0 88.0 85.0 88.0 84.0 88.0 86.0 88.0 85.0 13:50:59 INFO - PROCESS | 1960 | 13:50:59 INFO - PROCESS | 1960 | [#6] imaging-darkroom Cycles:10 Average:115.00 Median:98.00 stddev:26.45 (27.0%) stddev-sans-first:27.41 13:50:59 INFO - PROCESS | 1960 | Values: 99.0 99.0 98.0 100.0 105.0 99.0 134.0 173.0 98.0 145.0 13:50:59 INFO - PROCESS | 1960 | 13:50:59 INFO - PROCESS | 1960 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:90.00 stddev:16.71 (18.6%) stddev-sans-first:17.50 13:50:59 INFO - PROCESS | 1960 | Values: 89.0 101.0 91.0 143.0 90.0 89.0 91.0 90.0 90.0 91.0 13:50:59 INFO - PROCESS | 1960 | 13:50:59 INFO - PROCESS | 1960 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:59.00 stddev:1.69 (2.9%) stddev-sans-first:1.79 13:50:59 INFO - PROCESS | 1960 | Values: 58.0 56.0 56.0 56.0 60.0 60.0 58.0 60.0 59.0 59.0 13:50:59 INFO - PROCESS | 1960 | 13:50:59 INFO - PROCESS | 1960 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:70.50 stddev:3.94 (5.6%) stddev-sans-first:4.12 13:50:59 INFO - PROCESS | 1960 | Values: 70.0 71.0 79.0 79.0 68.0 69.0 70.0 72.0 70.0 70.0 13:50:59 INFO - PROCESS | 1960 | 13:50:59 INFO - PROCESS | 1960 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:84.50 stddev:10.24 (12.1%) stddev-sans-first:10.73 13:50:59 INFO - PROCESS | 1960 | Values: 85.0 87.0 84.0 84.0 77.0 97.0 109.0 104.0 83.0 86.0 13:50:59 INFO - PROCESS | 1960 | 13:50:59 INFO - PROCESS | 1960 | [#11] stanford-crypto-ccm Cycles:10 Average:162.00 Median:164.00 stddev:17.25 (10.5%) stddev-sans-first:15.52 13:50:59 INFO - PROCESS | 1960 | Values: 136.0 166.0 162.0 153.0 166.0 152.0 154.0 182.0 197.0 152.0 13:50:59 INFO - PROCESS | 1960 | 13:50:59 INFO - PROCESS | 1960 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:169.00 stddev:19.21 (11.4%) stddev-sans-first:20.14 13:50:59 INFO - PROCESS | 1960 | Values: 168.0 169.0 226.0 193.0 168.0 169.0 169.0 165.0 170.0 166.0 13:50:59 INFO - PROCESS | 1960 | 13:50:59 INFO - PROCESS | 1960 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.20 Median:85.50 stddev:10.05 (11.8%) stddev-sans-first:9.26 13:50:59 INFO - PROCESS | 1960 | Values: 67.0 72.0 82.0 95.0 90.0 90.0 84.0 66.0 79.0 87.0 13:50:59 INFO - PROCESS | 1960 | -------- Summary: end -------- 13:50:59 INFO - PROCESS | 1960 | 13:51:00 INFO - TEST-INFO | 1960: exit 0 13:51:00 INFO - TEST-OK | kraken | took 60319ms 13:51:00 INFO - SUITE-END | took 1173s 13:51:00 INFO - Completed test suite (00:19:34) 13:51:00 INFO - javascript benchmark 13:51:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7359.477595722755, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3337.399268131736, 3393.1856354474935, 3414.9317013659743, 3428.434308339124, 3433.9484907726387, 4202.243596152692, 5703.344115426717, 5823.854403639901, 5858.443447872451, 5920.792772252972, 5801.854953626162, 5830.621009634371, 5849.327327357355, 5883.88232235355, 5896.734646940888, 5287.550558202548, 5298.417174110845, 5340.412554618989, 5353.08997470429, 5357.08929481989, 5370.516653501184, 5395.7032363220005, 5398.0, 5405.675659460425, 5415.187721841716, 5273.1826566882, 5299.54953828923, 5359.5712343012465, 5369.5972802039805, 5386.569074474052, 4619.792109355087, 5049.040682270375, 5338.866528336784, 5344.064788661969, 5379.784808607651, 5291.920621190647, 5311.150215965427, 5330.307060082203, 5369.6509726867625, 5401.405845357008, 5653.971730141364, 5932.169496270526, 5957.791477298274, 5980.760769569212, 6007.038873780218, 6123.557162997608, 6194.81415557534, 6208.50331973441, 6230.158928544633, 6255.874882502325, 6303.842403939892, 6310.558260921737, 6365.936340636581, 6376.29860715321, 6382.712777925005, 5929.407059294036, 6063.818085457443, 6069.332373438918, 6072.696365181723, 6082.96958515209, 6315.989441689308, 6368.713407896656, 6415.326390728999, 6423.068655044993, 6444.613323200623, 6255.843603909848, 6275.215598050244, 6278.6860656966965, 6285.560010799291, 6295.496360291166, 6176.4441200292185, 6178.165947597106, 6243.219597550306, 6317.494600432046, 6327.96836015817, 5687.829365119053, 5875.8248350330105, 6293.087502312139, 6295.811125666238, 6298.8425289367215, 5675.404082571271, 6272.498200143978, 6280.685965701697, 6284.937150628527, 6302.747890084437, 4781.95218047822, 4900.264960255919, 4931.852044438672, 5025.901352213849, 5053.267276244924, 4454.688171828006, 4483.865484035484, 4511.3458548510935, 4544.500104988449, 4550.385697930803, 5890.941090589039, 5997.760089596367, 6002.069679199731, 6016.368281330485, 6016.669083200466, 6146.61701117254, 6290.339514351019, 6301.653409062454, 6307.779227727007, 6316.842078948063, 5919.644821310735, 5959.7914073008105, 5974.970125149346, 5983.922893879057, 6002.849928751729, 5473.06957817172, 5492.615516913777, 5502.0371434998715, 5523.696196709139, 5531.834044978657, 6281.654509002049, 6331.145295385249, 6340.080688300171, 6341.0805433212845, 6342.5243106767175, 4570.4972453030805, 5349.893002140013, 6214.564980451325, 6266.216722909637, 6283.8114856554375, 5066.316047333563, 5165.690058596496, 6342.682865856596, 6347.143135676624, 6360.650164241011, 4962.032403681247, 5453.209284653783, 6277.246730392382, 6307.0, 6327.936720632735, 6184.103305020657, 6230.563860529719, 6231.719572619334, 6299.748010079546, 6304.338044505261, 6115.301188035945, 6146.262448506208, 6198.81403557894, 6205.348438413902, 6213.099100630293, 5117.820876269461, 5588.714595642944, 6151.138840562236, 6195.566310358232, 6219.937800622117, 5317.548008419173, 5893.5874488785375, 5965.970170149121, 6041.939580604314, 6051.152838602688, 6114.479856340571, 6121.3572574879, 6125.785597504066, 6134.938650613437, 6245.5628106032145, 6080.858333083529, 6085.6348619083, 6104.145419641165, 6106.358832322542, 6109.6475967989745], "value": 5728.892067168303, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.9318223769874, 494.04402481198883, 511.07495433265814, 523.2648129378225, 527.3961314295132, 35825.0, 41610.79194604026, 41651.0, 41654.375184372184, 41678.0, 42129.7893510532, 42610.93472663185, 42687.14625707492, 42774.50289239877, 42847.78576107115, 9773.951130244339, 9952.452615106165, 9961.800763984716, 10000.59997600095, 10001.399916005026, 9879.06148915852, 9959.302848800588, 9961.153301969342, 9965.003499650049, 9990.800183996316, 9955.701328960144, 10007.849882251772, 10012.399256044624, 10024.348417352885, 10064.748381290454, 9911.355761875491, 9938.9503052485, 9969.0, 9974.152197063295, 10003.549840257134, 9818.852717209247, 9913.801723965553, 9924.156446701967, 9934.45360505172, 9937.155341795957, 34739.826300868335, 38330.616693832984, 40269.39595906064, 40308.387664493384, 40419.98950026243, 3187.4900015997328, 3315.4032274190636, 3346.0129261867564, 3367.6295607483157, 3750.249950010009, 27533.86233068822, 29415.0, 29828.806847726282, 30744.84627576848, 31125.844370778228, 2978.6447166539174, 3292.539044533767, 3292.5719656444508, 3300.785448945835, 3318.2533929865585, 414958.999999997, 470839.0, 486259.0, 505554.0, 509388.0, 61822.38177618256, 61847.07229391473, 62527.0, 62548.0, 62591.0, 34293.314133717686, 35041.474377884355, 35045.29909401797, 64960.0, 65245.34754652488, 16883.746743798853, 16930.492085237463, 16967.830321696623, 16982.915085424494, 17038.233279502452, 13011.869881301254, 13109.27898965547, 13116.0, 13139.802902956464, 13156.539521116714, 19131.426057218305, 19140.8085919139, 19143.80856191448, 19149.85100893951, 19161.233550658097, 6374.07575901501, 6395.16862807832, 7851.646675899598, 8013.0, 8044.557549334726, 858.8153546987428, 1008.0927165551062, 1032.3754128752148, 1035.30634474902, 1111.9610813621484, 25140.874295628404, 27709.86145069302, 27817.443651126865, 30095.645695943735, 30826.845865770527, 881.7619242804535, 904.7692838326317, 1005.4118340770731, 1018.8130827585779, 1026.2405819693522, 15357.769633455508, 15785.68428631421, 15858.444954426539, 15948.920255398882, 16114.919425402797, 682107.0, 699098.0, 700263.0, 701595.0, 705053.0, 57347.0, 57377.713111434176, 57484.71257643685, 57545.424545754846, 57727.0, 1356.9958230909056, 1359.232033900843, 1379.9379027943567, 1385.1273697570466, 1398.979015314771, 29502.704972950854, 29935.70064299416, 30207.199009502427, 30218.697813021587, 30381.784728610608, 49063.018739625724, 49180.75409622929, 49536.256956146404, 49538.0, 49565.50434495609, 581068.0, 583924.0803796124, 583970.0801496136, 584921.0, 585742.0, 26291.474170516864, 26407.867960660074, 26738.064167754037, 26871.0, 27536.862315689094, 46903.53096468992, 46923.53076469192, 47237.0, 47273.29090063583, 47652.761736192486, 38364.65723699657, 38581.2283754329, 39034.6096539031, 39093.0, 40071.0, 39093.21813563656, 39297.01757455972, 39362.409563855996, 40341.59658403378, 40501.79749101236, 32527.024189274358, 32802.0, 37276.884933374335, 38348.80825595854, 38441.84674459771, 33893.152671183416, 34060.31879362449, 34802.651973479944, 35091.298174036885, 35386.0, 25692.100776472733, 26104.34739131537, 26118.216453506426, 26155.869220653774, 26354.472910542067], "value": 19950.725331586335, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.25375726004427, 372.8098669678464, 385.5931991748704, 392.992140157197, 408.07774429788685, 19033.619327613458, 20491.282805101826, 21539.2461263856, 21682.457938551543, 21791.237306694267, 11475.426228688553, 11803.940980295109, 11958.7608247835, 11986.861248181409, 12056.156069075168, 5347.54545863602, 5616.831495055155, 5645.1814486899375, 5653.180288858113, 5661.46216109471, 5527.695976721278, 5632.239647647577, 5759.942400576004, 6045.516358691316, 6086.360932102132, 6043.546733994946, 6098.451139397475, 6109.816705498843, 6112.052631842072, 6132.846678833021, 5840.0, 6031.457168854802, 6064.3935606439445, 6103.755849766004, 6135.049067394539, 5184.196449550326, 5797.652140871562, 5852.76588936442, 5886.0, 5903.586748927577, 24346.756532434625, 24982.500349992897, 25154.371140721447, 25704.871475642503, 25746.485070298488, 2156.223759446598, 2166.458385403649, 2168.945776355588, 2207.404000919759, 2764.7926405519665, 9296.442213467213, 9745.658901938468, 10117.696469105938, 10351.0, 10386.480675966171, 1793.820617938209, 1819.1540933466001, 1869.0, 1879.473747350744, 1892.8201820826998, 121493.0, 128860.0, 131642.0, 133496.88864168, 134073.0, 9438.858417123749, 11563.537458501565, 11843.170978031627, 11892.583759568373, 11950.641480755417, 14651.194184319966, 14669.266536673123, 14697.77953330701, 14702.26488675562, 14706.485273015607, 7562.016937798051, 7717.0, 7740.458167928191, 7800.609969501502, 7850.861625064334, 7257.2742725727, 7288.08898887639, 7294.343509084208, 7413.518121322205, 7418.0, 3790.6209379061875, 4548.499665036843, 4557.407537020233, 4560.885977850514, 4564.360989461478, 1904.5809921817179, 1918.611328895534, 1936.5933154037527, 1952.4728323352615, 1985.186073709772, 788.9763307100797, 839.5802098950525, 908.2869947091501, 919.7557958581041, 1017.049059129716, 20439.79560204379, 21177.364679059654, 21186.57626847485, 21336.359909202747, 21477.422709274986, 960.3229723045237, 984.3208186351395, 984.5815528400544, 986.5807032011367, 1003.9419190659265, 8069.87895181561, 11200.327980321206, 11215.271007384494, 11219.326840389604, 11237.662870113909, 607761.0, 610596.0, 612381.0, 629787.0, 632104.0, 139140.0, 140122.2993885024, 140358.0, 142224.0, 147640.0, 930.544033423631, 937.7608709778963, 946.4226821638795, 946.9195118415012, 984.832972927098, 17691.911540442215, 18488.075596219867, 18854.71717924205, 18953.620927581094, 18961.810381896004, 54890.725546372014, 56691.433085668614, 56831.715841422185, 56900.0, 56920.430795693166, 75254.24745752472, 76068.61965690136, 78753.60623196847, 81573.18939178735, 82863.0, 6935.306469353024, 7900.091489478784, 7960.880586791087, 8048.154943730824, 8172.101068882299, 10290.897091028994, 12408.75182496363, 12626.810597841224, 12806.935965320114, 13074.607761767162, 10791.298565593212, 11099.334039957628, 11301.547938082385, 11393.316401015965, 11408.714782130513, 7959.9602001989615, 10536.683899483029, 10641.048034934498, 10737.194710396907, 11160.832587511357, 9471.810563788547, 9485.241180705665, 9765.0, 10441.008104230086, 11300.717482063013, 7255.310745479171, 7326.120865496175, 7421.0, 7433.405327573673, 7440.55356678601, 9304.860427093734, 9998.950005250219, 10358.015988481082, 10860.715976184014, 11259.09927205838], "value": 9334.452049192956, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1219.5121951219512, 1336.0180267503385, 1593.760935859621, 1743.7096548554073, 1813.8276863697945, 7577.431692623055, 7988.241117093867, 8246.793830154234, 9082.455052696834, 9104.681336153237, 8569.828603427928, 8843.0, 8860.202581767655, 8927.37508374414, 8933.642654293837, 2387.9493023069836, 2403.3270684208364, 2415.311636183688, 2415.903363865443, 2419.7822196002357, 2380.785729284364, 2411.6141417373224, 2423.6122220444645, 2426.4783071639595, 2432.0879670123704, 2398.7121545414575, 2402.5795485790004, 2411.9758802411925, 2429.927102186937, 2436.549238390903, 2384.463495713468, 2391.0316321889663, 2401.2436082634003, 2401.927942161738, 2405.7594240575977, 2376.4296568823356, 2383.9868056076098, 2387.0809738250723, 2392.138830021191, 2398.484325869946, 8864.379493435463, 8939.0, 8944.821103577957, 8978.775530611721, 8978.86531702025, 5251.947480525184, 5408.810691625774, 5412.134058550652, 5420.945790542083, 5430.456954304577, 3560.12776869666, 3665.7433979621437, 3697.001809511417, 3716.832742526593, 3722.050877026368, 1088.2871719024051, 1108.3073079325422, 1109.018518611027, 1132.8923752243525, 1138.772245550893, 11722.706932326675, 11802.645920622395, 11864.822027669592, 11872.881271187263, 11882.940585297105, 4711.976440117846, 4734.841099629612, 4753.168195565762, 4873.926891096637, 4909.459959404463, 10008.699739007841, 10095.0, 10102.898971010343, 10103.14123299513, 10127.936566660543, 4444.933326000112, 5382.703951282717, 5413.648112872651, 5423.186522021729, 5429.049916264638, 4421.602055814992, 4563.498015218323, 4809.44691360498, 4923.163062279421, 4959.256111583291, 3991.0621004064024, 3992.7005474589523, 4081.9387709184384, 4129.97935010323, 4134.0, 1323.4838413018738, 1339.9330033498286, 1341.3025226881966, 1341.7718987772103, 1352.837659480849, 762.9237076292326, 857.9571021448903, 903.8418276801665, 908.1599520443564, 910.9225715814098, 5713.0, 5740.196372507852, 5779.971100144472, 5814.912776308359, 5962.493188078975, 875.4528419737663, 955.3121752338305, 968.7190714692802, 977.0815433492494, 992.1219720547223, 3759.3045286622064, 3891.8443262269757, 3937.9803100984313, 3938.15329704115, 3998.8600398985895, 10688.732781680364, 11007.174461915389, 11033.503492342863, 11035.172362072877, 11040.116790656888, 10874.130069594414, 10884.129269658408, 10926.836097458545, 10932.234743568033, 10941.0, 6092.786752463642, 7790.805229869298, 8193.877091843628, 8243.093259741423, 8251.092379838214, 6008.669523176092, 6011.939880601313, 6068.969655151696, 6076.361981992004, 6176.548511099798, 10019.148372388428, 10080.243981701255, 10225.744356390853, 10294.639687610897, 10310.123639490726, 9984.201263899016, 10389.9480502597, 10502.0, 10534.262601617813, 10551.525181367011, 7008.053912721921, 7225.988361629481, 7440.404767618469, 7586.582737949466, 7723.150453450228, 7041.3310735480045, 7055.4708396871465, 7080.610566418691, 8425.946756655418, 8527.275181609384, 7365.852682946418, 7554.433417493819, 7575.924240757742, 7595.848083038198, 7650.502717323357, 7208.86601939825, 7246.60143692102, 7307.378872795872, 7389.076365454318, 7427.442941779496, 6923.446124310144, 7003.7548685795755, 7025.156981162293, 7111.53775004623, 7117.217106118426, 4651.023285110165, 4954.529319714621, 5008.774605142705, 5013.749312534285, 5043.697378157322, 3843.7309388342546, 4939.0, 5068.594512438923, 5102.209157580581, 5120.667156634807], "value": 4614.756235943662, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.92508766337266, 301.07869918050767, 304.8445292900621, 308.34322892239527, 311.2266018942928, 4825.927611085832, 4836.0741751240475, 5136.2038883972955, 5196.9480305196985, 5342.652727572705, 4484.618807401366, 5307.73461326934, 5401.70290634015, 5515.4760297771745, 5521.834344969658, 3356.281412056236, 3579.6062433132333, 3871.4967054283043, 4065.6137666921595, 4144.088300573869, 3521.7710848794873, 3790.393537034075, 3836.693064554829, 3986.2625414298304, 4134.586541345871, 4129.339305711087, 4132.648724858391, 4152.709310348277, 4167.395727619493, 4170.374443833434, 4121.032856343428, 4137.751734895901, 4174.352975288835, 4175.478065241845, 4186.91626167475, 3055.3736484020947, 3096.6710785905016, 3527.171114788023, 3631.6005239423644, 3649.872254471081, 4329.740215587043, 4458.554144585515, 4527.841525546623, 4995.975020124876, 5291.523762861361, 4143.969454967075, 4706.129366067288, 4753.882837533177, 4792.640551958582, 4802.30366596845, 4721.669483136182, 4799.880002999953, 5760.711964401763, 5893.0, 5916.674582897982, 3317.6350601434065, 3598.1649358826926, 3890.9688932432928, 3939.7045221608496, 3957.663598594123, 5297.947020529784, 5785.566082543826, 6033.728482218266, 6108.0, 6131.202943617302, 2996.835174065404, 3970.900727481778, 3972.662323702518, 3994.6404823565435, 3994.7003974702016, 3874.5931677174053, 3962.9603703963166, 4031.899202519902, 4045.59544045599, 4073.572274911151, 4176.909087275455, 4570.954290457053, 4724.126036683225, 4739.691920025256, 4744.0, 4875.366202393737, 5622.4417889860015, 5790.855228619234, 5964.850878728066, 5972.40275972408, 1151.7235863392725, 1274.7896597061567, 1280.417410078412, 1352.4657760184673, 1374.9037567370187, 882.8455020371538, 915.5056269614333, 917.3945196170629, 920.6420529718745, 927.8608208768603, 4571.439993603526, 4857.8299759508245, 5452.672839629635, 5463.590230732631, 5497.543151064971, 4936.851894443173, 5292.947070529322, 5706.28671416073, 5945.851353716192, 5987.341392446828, 4699.154152252559, 4780.235162374003, 5405.135178371442, 5431.864203394946, 5445.754941027663, 2114.9108209272235, 2267.6031694453736, 2323.6630688550404, 2495.90016399342, 2619.5592424166634, 4451.484911025261, 4652.116097941381, 5220.738963051832, 5544.500994910478, 6165.938340616626, 5234.816781412708, 6077.845209410198, 6251.468625166912, 6291.591046581958, 6332.525060620472, 6234.410225392496, 6276.905846412307, 6284.905726414107, 6301.306856245901, 6317.431431171217, 5645.322561292671, 5695.629784064023, 5746.741396637245, 6068.848278793065, 6076.270847498328, 5075.741295123635, 5990.341062483036, 6043.7884674036195, 6072.931136138709, 6122.081687746873, 5209.635325527328, 5908.527317814651, 6170.784022559189, 6195.876082478415, 6269.589342397924, 4000.239954408653, 4010.57888921659, 4010.6791456682813, 4020.1356708307853, 4062.7968601570396, 5282.181261904411, 5355.678659280456, 6080.7567697291615, 6206.255249369924, 6209.968950155401, 5541.889162216814, 5855.238818953509, 5949.3455719871645, 5965.970170149121, 5985.191999080243, 4912.305254687128, 5127.46161653021, 5847.736851841592, 5941.870400071908, 5988.5508586855285, 5456.03582710232, 5493.917591236214, 5641.915371269352, 5645.858853528694, 5804.506616937608, 5885.234919460443, 6013.128096425906, 6018.067199584071, 6022.036474164112, 6034.155218269358, 4618.976905115453, 5592.133219351007, 5707.514861236841, 5886.852063847508, 5914.674692891932], "value": 4142.594881737877, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.6454846657037, 682.5972676121088, 731.4067655125808, 750.9924900750991, 795.9880601790974, 12496.937515312411, 14849.851501484982, 15514.991525550831, 15547.067175969436, 15570.53288401347, 13965.790513142285, 14041.92979035106, 14044.438222471115, 14052.0, 14089.718205635882, 613.4540259169343, 666.3170250493247, 691.1913061717802, 801.1988011988012, 832.7376876283981, 683.9179298484189, 835.578033093287, 838.2078935406043, 838.3335248477475, 842.5787106446777, 857.8798968144465, 872.7381785464368, 875.5972252763736, 898.0839543665458, 905.2622112977901, 871.2420194430822, 898.4070513461116, 899.9235065019449, 900.0189793125459, 900.1223806788395, 657.2605818454239, 666.1340257665016, 666.5900471210219, 667.1327274543074, 667.212689026948, 14524.0, 14623.415063397451, 14818.925905370512, 14847.406103755837, 14865.925670371578, 14570.198639074846, 14592.343344549521, 14613.050151740103, 14674.119552826865, 14886.70226595462, 11579.36313502757, 11872.465739041678, 11985.640430787003, 12066.698332541757, 12388.0, 3727.273181729564, 3752.512173417438, 3769.4345848122725, 3782.3380908340932, 3858.594847540996, 130058.0, 130495.6950430493, 131019.0, 132494.0, 134091.32954335166, 10724.195685323632, 10803.379493075945, 11191.440427978569, 11406.828897566544, 11622.0, 23224.53550928972, 23408.297751067494, 23580.88209558941, 23627.936742846614, 23833.285001449636, 8016.358691304682, 8023.358131349478, 8042.678292868337, 8167.346612271004, 8269.62786674601, 4370.344448332776, 4425.75658338788, 4509.391232183613, 4535.795889184995, 4594.770261486912, 3549.3078849624076, 3599.460080987873, 3627.4196128619296, 3637.3452778500123, 3655.5613326401003, 635.8124353315783, 644.9129367535417, 651.1047309948821, 651.2152855808833, 655.5542231282774, 565.8670212500059, 640.8429934666036, 641.6631268584031, 665.4044630056072, 683.8085336105898, 9143.725688229364, 9738.0, 9789.706308810748, 9806.901930980599, 9917.900820991697, 549.2201074474256, 581.9185314056035, 630.8517498387876, 632.8261075704594, 670.7992693079333, 4544.795484203219, 4545.0909818036525, 4800.4479484859685, 4802.159622066124, 4833.468318484964, 136193.31903340618, 138383.6161638391, 176078.1196094037, 178051.0, 181021.0, 111516.88483115227, 145723.0, 148662.0, 152024.0, 153989.0, 125753.0, 129954.35022825014, 129959.70040299665, 129964.0, 131327.03009454865, 8904.082203830294, 9215.308851836005, 9216.2626989842, 9242.861357079515, 9312.813743725223, 57302.0, 62306.44233894189, 70338.64830675814, 71341.57316853738, 72321.6383918077, 79283.81074284005, 97598.0, 108284.45857770661, 108628.0, 109785.90214097757, 11907.0, 12060.216085954386, 12117.515299387926, 12194.81707774402, 12497.18768280059, 12827.0, 12831.0, 13020.609381718563, 13563.186208827501, 13871.098378605358, 12099.33453660057, 12121.575744848888, 12299.385030748606, 12304.876951230373, 12351.876481235073, 12062.51749929993, 12087.39563021863, 12313.199642023239, 12327.69180770488, 12848.164869283466, 10416.0, 11653.067754579783, 12057.794220577873, 12133.817992730294, 12224.0, 8385.245327920517, 9064.821573195706, 9733.707988760349, 9815.509224538602, 10647.94676026615, 9833.606655733976, 10457.379837097798, 10670.413127278074, 10691.839622405514, 10700.732481688021], "value": 7789.288947986673, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1568.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 131.0, 118.0, 106.0, 172.0, 173.0, 173.0, 117.0, 116.0, 118.0], "value": 133.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 100.0, 144.0, 176.0, 144.0, 124.0, 110.0, 110.0, 136.0, 110.0], "value": 130.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [278.0, 255.0, 204.0, 195.0, 199.0, 201.0, 194.0, 198.0, 190.0, 201.0], "value": 211.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 54.0, 62.0, 99.0, 86.0, 76.0, 75.0, 50.0, 93.0, 75.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 89.0, 74.0, 69.0, 72.0, 114.0, 57.0, 74.0, 118.0], "value": 82.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 88.0, 85.0, 88.0, 84.0, 88.0, 86.0, 88.0, 85.0], "value": 86.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 99.0, 98.0, 100.0, 105.0, 99.0, 134.0, 173.0, 98.0, 145.0], "value": 115.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 101.0, 91.0, 143.0, 90.0, 89.0, 91.0, 90.0, 90.0, 91.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 56.0, 56.0, 60.0, 60.0, 58.0, 60.0, 59.0, 59.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 79.0, 79.0, 68.0, 69.0, 70.0, 72.0, 70.0, 70.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 84.0, 84.0, 77.0, 97.0, 109.0, 104.0, 83.0, 86.0], "value": 89.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 166.0, 162.0, 153.0, 166.0, 152.0, 154.0, 182.0, 197.0, 152.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 226.0, 193.0, 168.0, 169.0, 169.0, 165.0, 170.0, 166.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 82.0, 95.0, 90.0, 90.0, 84.0, 66.0, 79.0, 87.0], "value": 81.2, "unit": "score"}]}]} 13:51:00 INFO - Return code: 0 13:51:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:51:00 ERROR - # TBPL SUCCESS # 13:51:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:51:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:51:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:51:00 INFO - 2016-10-20 13:51:00.627 screenresolution[1965:13933] starting screenresolution argv=screenresolution get 13:51:00 INFO - 2016-10-20 13:51:00.629 screenresolution[1965:13933] Display 0: 1600x1200x32@60 13:51:00 INFO - 2016-10-20 13:51:00.635 screenresolution[1966:13936] starting screenresolution argv=screenresolution list 13:51:00 INFO - Available Modes on Display 0 13:51:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:51:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:51:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:51:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:51:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:51:00 INFO - Intel Iris: 13:51:00 INFO - Chipset Model: Intel Iris 13:51:00 INFO - Type: GPU 13:51:00 INFO - Bus: Built-In 13:51:00 INFO - VRAM (Dynamic, Max): 1536 MB 13:51:00 INFO - Vendor: Intel (0x8086) 13:51:00 INFO - Device ID: 0x0a2e 13:51:00 INFO - Revision ID: 0x0009 13:51:00 INFO - Displays: 13:51:00 INFO - Display: 13:51:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:51:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:51:00 INFO - Display Serial Number: 1600x1200 60 13:51:00 INFO - Main Display: Yes 13:51:00 INFO - Mirror: Off 13:51:00 INFO - Online: Yes 13:51:00 INFO - Rotation: Supported 13:51:00 INFO - Return code: 0 13:51:00 INFO - Running post-action listener: _resource_record_post_action 13:51:00 INFO - [mozharness: 2016-10-20 20:51:00.876349Z] Finished run-tests step (success) 13:51:00 INFO - Running post-run listener: _resource_record_post_run 13:51:00 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 647168; Write bytes: 663454208; Read time: 11; Write time: 1845 13:51:00 INFO - TinderboxPrint: CPU usage
54.1% 13:51:00 INFO - TinderboxPrint: I/O read bytes / time
647,168 / 11 13:51:00 INFO - TinderboxPrint: I/O write bytes / time
663,454,208 / 1,845 13:51:00 INFO - TinderboxPrint: CPU idle
2,216.1 (45.9%) 13:51:00 INFO - TinderboxPrint: CPU system
976.2 (20.2%) 13:51:00 INFO - TinderboxPrint: CPU user
1,633.5 (33.9%) 13:51:00 INFO - TinderboxPrint: Swap in / out
364,490,752 / 0 13:51:00 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 360505856; Write bytes: 356226560; Read time: 27588; Write time: 679 13:51:00 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 606208; Write bytes: 295922688; Read time: 10; Write time: 1132 13:51:01 INFO - Running post-run listener: _upload_blobber_files 13:51:01 INFO - Blob upload gear active. 13:51:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:51:01 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 13:51:01 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:51:01 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:51:01 INFO - (blobuploader) - INFO - Open directory for files ... 13:51:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:51:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:51:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:51:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:51:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:51:02 INFO - (blobuploader) - INFO - Done attempting. 13:51:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:51:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:51:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:51:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:51:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:51:03 INFO - (blobuploader) - INFO - Done attempting. 13:51:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:51:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:51:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:51:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:51:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:51:06 INFO - (blobuploader) - INFO - Done attempting. 13:51:06 INFO - (blobuploader) - INFO - Iteration through files over. 13:51:06 INFO - Return code: 0 13:51:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:51:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:51:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42802f4c8ad5b59e1c1b01257ed1c0577a6760e6792963025ca77152d1322740896537f2a3e223e1b43893f29dfdd256e8f8a4915f95f137e3c2bc97395ac53b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/535ebcb2cf63161a3d41420f0b11d6150e69b804f615b4b5908bfd7189d75753153aa409d8ff2eb47dae86f3270c4a143101895e05e108a66376f10b8bbdd366", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4705440ff1057c3f40bb1d3e51e902d71e7499d98014d247e8cd5256acfb71a2692b72aceb8aa913acc42d5849aa8c4b37972d610e89b443087423d9a0724c5c"} 13:51:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:51:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:51:06 INFO - Contents: 13:51:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42802f4c8ad5b59e1c1b01257ed1c0577a6760e6792963025ca77152d1322740896537f2a3e223e1b43893f29dfdd256e8f8a4915f95f137e3c2bc97395ac53b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/535ebcb2cf63161a3d41420f0b11d6150e69b804f615b4b5908bfd7189d75753153aa409d8ff2eb47dae86f3270c4a143101895e05e108a66376f10b8bbdd366", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4705440ff1057c3f40bb1d3e51e902d71e7499d98014d247e8cd5256acfb71a2692b72aceb8aa913acc42d5849aa8c4b37972d610e89b443087423d9a0724c5c"} 13:51:06 INFO - Running post-run listener: copy_logs_to_upload_dir 13:51:06 INFO - Copying logs to upload dir... 13:51:06 INFO - mkdir: /builds/slave/test/build/upload/logs 13:51:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.942768 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-10-20 13:51:06.110741) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 13:51:06.114635) ========= 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.JseymRzYMU/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.CRYqU9kOHc/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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-Aurora/sha512/42802f4c8ad5b59e1c1b01257ed1c0577a6760e6792963025ca77152d1322740896537f2a3e223e1b43893f29dfdd256e8f8a4915f95f137e3c2bc97395ac53b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/535ebcb2cf63161a3d41420f0b11d6150e69b804f615b4b5908bfd7189d75753153aa409d8ff2eb47dae86f3270c4a143101895e05e108a66376f10b8bbdd366", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4705440ff1057c3f40bb1d3e51e902d71e7499d98014d247e8cd5256acfb71a2692b72aceb8aa913acc42d5849aa8c4b37972d610e89b443087423d9a0724c5c"} build_url:https://queue.taskcluster.net/v1/task/Cy-BrosuTouPrG3l19ShUA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010963 build_url: 'https://queue.taskcluster.net/v1/task/Cy-BrosuTouPrG3l19ShUA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42802f4c8ad5b59e1c1b01257ed1c0577a6760e6792963025ca77152d1322740896537f2a3e223e1b43893f29dfdd256e8f8a4915f95f137e3c2bc97395ac53b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/535ebcb2cf63161a3d41420f0b11d6150e69b804f615b4b5908bfd7189d75753153aa409d8ff2eb47dae86f3270c4a143101895e05e108a66376f10b8bbdd366", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4705440ff1057c3f40bb1d3e51e902d71e7499d98014d247e8cd5256acfb71a2692b72aceb8aa913acc42d5849aa8c4b37972d610e89b443087423d9a0724c5c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 13:51:06.146616) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 13:51:06.146950) ========= 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.JseymRzYMU/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.CRYqU9kOHc/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.005252 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 13:51:06.194732) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 13:51:06.195023) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 13:51:06.195335) ========= ========= Total master_lag: 2.76 =========