builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0319 starttime: 1479103493.45 results: success (0) buildid: 20161113194320 builduid: 559b8267eefc4476a556556b1389230f revision: 1f41acac2aa680a42c0dc85062a0c0ff70c9b80f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-13 22:04:53.449624) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-13 22:04:53.450069) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-13 22:04:53.450384) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-13 22:04:53.475247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 22:04:53.475605) ========= 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.FtKJdh2zFC/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.JdzjZW6z25/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-13 22:04:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 190M=0s 2016-11-13 22:04:53 (190 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082659 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 22:04:53.580606) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 22:04:53.580919) ========= 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.FtKJdh2zFC/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.JdzjZW6z25/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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.024269 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 22:04:53.629818) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-13 22:04:53.630188) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1f41acac2aa680a42c0dc85062a0c0ff70c9b80f --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 1f41acac2aa680a42c0dc85062a0c0ff70c9b80f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FtKJdh2zFC/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.JdzjZW6z25/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-13 22:04:53,712 truncating revision to first 12 chars 2016-11-13 22:04:53,712 Setting DEBUG logging. 2016-11-13 22:04:53,713 attempt 1/10 2016-11-13 22:04:53,713 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1f41acac2aa6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-13 22:04:54,587 unpacking tar archive at: mozilla-aurora-1f41acac2aa6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.159187 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-13 22:04:54.812611) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-13 22:04:54.812988) ========= script_repo_revision: 1f41acac2aa680a42c0dc85062a0c0ff70c9b80f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-13 22:04:54.813449) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-13 22:04:54.813774) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-13 22:04:54.832718) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-11-13 22:04:54.833108) ========= /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.FtKJdh2zFC/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.JdzjZW6z25/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 22:04:55 INFO - MultiFileLogger online at 20161113 22:04:55 in /builds/slave/test 22:04:55 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 22:04:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:04:55 INFO - {'append_to_log': False, 22:04:55 INFO - 'base_work_dir': '/builds/slave/test', 22:04:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 22:04:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:04:55 INFO - 'branch': 'Mozilla-Aurora', 22:04:55 INFO - 'buildbot_json_path': 'buildprops.json', 22:04:55 INFO - 'config_files': ('talos/mac_config.py',), 22:04:55 INFO - 'default_actions': ('clobber', 22:04:55 INFO - 'read-buildbot-config', 22:04:55 INFO - 'download-and-extract', 22:04:55 INFO - 'populate-webroot', 22:04:55 INFO - 'create-virtualenv', 22:04:55 INFO - 'install', 22:04:55 INFO - 'run-tests'), 22:04:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:04:55 INFO - 'download_minidump_stackwalk': True, 22:04:55 INFO - 'download_symbols': 'ondemand', 22:04:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:04:55 INFO - 'tooltool.py': '/tools/tooltool.py', 22:04:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:04:55 INFO - '/tools/misc-python/virtualenv.py')}, 22:04:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:04:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:04:55 INFO - 'installer_path': 'installer.exe', 22:04:55 INFO - 'log_level': 'info', 22:04:55 INFO - 'log_name': 'talos', 22:04:55 INFO - 'log_to_console': True, 22:04:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:04:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:04:55 INFO - 'opt_config_files': (), 22:04:55 INFO - 'pip_index': False, 22:04:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:04:55 INFO - 'cmd': ('bash', 22:04:55 INFO - '-c', 22:04:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:04:55 INFO - 'enabled': True, 22:04:55 INFO - 'halt_on_failure': False, 22:04:55 INFO - 'name': 'check_screen_resolution'},), 22:04:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:04:55 INFO - 'cmd': ('bash', 22:04:55 INFO - '-c', 22:04:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:04:55 INFO - 'enabled': True, 22:04:55 INFO - 'halt_on_failure': False, 22:04:55 INFO - 'name': 'check_screen_resolution'},), 22:04:55 INFO - 'run_cmd_checks_enabled': True, 22:04:55 INFO - 'sps_profile': False, 22:04:55 INFO - 'sps_profile_interval': 0, 22:04:55 INFO - 'suite': 'dromaeojs-e10s', 22:04:55 INFO - 'system_bits': '32', 22:04:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:04:55 INFO - 'title': 't-yosemite-r7-0319', 22:04:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:04:55 INFO - 'use_talos_json': True, 22:04:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:04:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:04:55 INFO - 'work_dir': 'build'} 22:04:55 INFO - [mozharness: 2016-11-14 06:04:55.044509Z] Running clobber step. 22:04:55 INFO - Running pre-action listener: _resource_record_pre_action 22:04:55 INFO - Running main action method: clobber 22:04:55 INFO - rmtree: /builds/slave/test/build 22:04:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:04:57 INFO - Running post-action listener: _resource_record_post_action 22:04:57 INFO - [mozharness: 2016-11-14 06:04:57.374745Z] Finished clobber step (success) 22:04:57 INFO - [mozharness: 2016-11-14 06:04:57.374942Z] Running read-buildbot-config step. 22:04:57 INFO - Running pre-action listener: _resource_record_pre_action 22:04:57 INFO - Running main action method: read_buildbot_config 22:04:57 INFO - Using buildbot properties: 22:04:57 INFO - { 22:04:57 INFO - "project": "", 22:04:57 INFO - "product": "firefox", 22:04:57 INFO - "script_repo_revision": "production", 22:04:57 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 22:04:57 INFO - "repository": "", 22:04:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 22:04:57 INFO - "buildid": "20161113194320", 22:04:57 INFO - "pgo_build": "False", 22:04:57 INFO - "basedir": "/builds/slave/test", 22:04:57 INFO - "buildnumber": 22, 22:04:57 INFO - "slavename": "t-yosemite-r7-0319", 22:04:57 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 22:04:57 INFO - "platform": "yosemite_r7", 22:04:57 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 22:04:57 INFO - "branch": "mozilla-aurora", 22:04:57 INFO - "repo_path": "releases/mozilla-aurora", 22:04:57 INFO - "revision": "1f41acac2aa680a42c0dc85062a0c0ff70c9b80f", 22:04:57 INFO - "stage_platform": "macosx64", 22:04:57 INFO - "builduid": "559b8267eefc4476a556556b1389230f", 22:04:57 INFO - "slavebuilddir": "test" 22:04:57 INFO - } 22:04:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xpxast4XTOKnFbremvm4nQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 22:04:57 INFO - Running post-action listener: _resource_record_post_action 22:04:57 INFO - [mozharness: 2016-11-14 06:04:57.379019Z] Finished read-buildbot-config step (success) 22:04:57 INFO - [mozharness: 2016-11-14 06:04:57.379181Z] Running download-and-extract step. 22:04:57 INFO - Running pre-action listener: _resource_record_pre_action 22:04:57 INFO - Running main action method: download_and_extract 22:04:57 INFO - mkdir: /builds/slave/test/build/tests 22:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:04:57 INFO - trying https://queue.taskcluster.net/v1/task/Xpxast4XTOKnFbremvm4nQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 22:04:57 INFO - Downloading https://queue.taskcluster.net/v1/task/Xpxast4XTOKnFbremvm4nQ/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 22:04:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xpxast4XTOKnFbremvm4nQ/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 22:04:58 INFO - Downloaded 1199 bytes. 22:04:58 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 22:04:58 INFO - Using the following test package requirements: 22:04:58 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 22:04:58 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:04:58 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 22:04:58 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:04:58 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 22:04:58 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:04:58 INFO - u'jsshell-mac.zip'], 22:04:58 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:04:58 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 22:04:58 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 22:04:58 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:04:58 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 22:04:58 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:04:58 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 22:04:58 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:04:58 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 22:04:58 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:04:58 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 22:04:58 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 22:04:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xpxast4XTOKnFbremvm4nQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 22:04:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xpxast4XTOKnFbremvm4nQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 22:04:58 INFO - Fetch https://queue.taskcluster.net/v1/task/Xpxast4XTOKnFbremvm4nQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 22:04:58 INFO - Expected file size: 16423860 22:05:05 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 22:05:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xpxast4XTOKnFbremvm4nQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 22:05:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xpxast4XTOKnFbremvm4nQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 22:05:05 INFO - Fetch https://queue.taskcluster.net/v1/task/Xpxast4XTOKnFbremvm4nQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 22:05:06 INFO - Expected file size: 16423860 22:05:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xpxast4XTOKnFbremvm4nQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 22:05:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xpxast4XTOKnFbremvm4nQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 22:05:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Xpxast4XTOKnFbremvm4nQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 22:05:13 INFO - Expected file size: 14414089 22:05:15 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')]} 22:05:15 INFO - trying https://queue.taskcluster.net/v1/task/Xpxast4XTOKnFbremvm4nQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 22:05:15 INFO - Downloading https://queue.taskcluster.net/v1/task/Xpxast4XTOKnFbremvm4nQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 22:05:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xpxast4XTOKnFbremvm4nQ/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 22:05:18 INFO - Downloaded 115561669 bytes. 22:05:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xpxast4XTOKnFbremvm4nQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 22:05:18 INFO - mkdir: /builds/slave/test/properties 22:05:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:05:18 INFO - Writing to file /builds/slave/test/properties/build_url 22:05:18 INFO - Contents: 22:05:18 INFO - build_url:https://queue.taskcluster.net/v1/task/Xpxast4XTOKnFbremvm4nQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 22:05:18 INFO - Running post-action listener: _resource_record_post_action 22:05:18 INFO - Running post-action listener: set_extra_try_arguments 22:05:18 INFO - [mozharness: 2016-11-14 06:05:18.746259Z] Finished download-and-extract step (success) 22:05:18 INFO - [mozharness: 2016-11-14 06:05:18.746407Z] Running populate-webroot step. 22:05:18 INFO - Running pre-action listener: _resource_record_pre_action 22:05:18 INFO - Running main action method: populate_webroot 22:05:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:05:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:05:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:05:18 INFO - '--tppagecycles', 22:05:18 INFO - '7'], 22:05:18 INFO - 'tests': ['tsvgm']}}, 22:05:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:05:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:05:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:05:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:05:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:05:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:05:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:18 INFO - 'talos_options': ['--disable-e10s'], 22:05:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:05:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:05:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:18 INFO - 'talos_options': ['--disable-e10s'], 22:05:18 INFO - 'tests': ['damp', 'tps']}, 22:05:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:18 INFO - 'tests': ['damp', 'tps']}, 22:05:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:05:18 INFO - 'tests': ['dromaeo_dom']}, 22:05:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:05:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:05:18 INFO - 'tests': ['basic_compositor_video']}, 22:05:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:05:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:05:18 INFO - 'tests': ['a11yr', 22:05:18 INFO - 'ts_paint', 22:05:18 INFO - 'tpaint', 22:05:18 INFO - 'sessionrestore', 22:05:18 INFO - 'sessionrestore_no_auto_restore', 22:05:18 INFO - 'tabpaint']}, 22:05:18 INFO - 'other-e10s': {'tests': ['a11yr', 22:05:18 INFO - 'ts_paint', 22:05:18 INFO - 'tpaint', 22:05:18 INFO - 'sessionrestore', 22:05:18 INFO - 'sessionrestore_no_auto_restore', 22:05:18 INFO - 'tabpaint']}, 22:05:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:05:18 INFO - 'ts_paint', 22:05:18 INFO - 'tpaint', 22:05:18 INFO - 'sessionrestore', 22:05:18 INFO - 'sessionrestore_no_auto_restore', 22:05:18 INFO - 'tabpaint']}, 22:05:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:05:18 INFO - 'ts_paint', 22:05:18 INFO - 'tpaint', 22:05:18 INFO - 'sessionrestore', 22:05:18 INFO - 'sessionrestore_no_auto_restore', 22:05:18 INFO - 'tabpaint']}, 22:05:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:05:18 INFO - 'tests': ['a11yr', 22:05:18 INFO - 'ts_paint', 22:05:18 INFO - 'tpaint', 22:05:18 INFO - 'sessionrestore', 22:05:18 INFO - 'sessionrestore_no_auto_restore', 22:05:18 INFO - 'tabpaint']}, 22:05:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:05:18 INFO - 'tests': ['a11yr', 22:05:18 INFO - 'ts_paint', 22:05:18 INFO - 'tpaint', 22:05:18 INFO - 'sessionrestore', 22:05:18 INFO - 'sessionrestore_no_auto_restore', 22:05:18 INFO - 'tabpaint']}, 22:05:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:05:18 INFO - 'tests': ['tsvgx', 22:05:18 INFO - 'tsvgr_opacity', 22:05:18 INFO - 'tart', 22:05:18 INFO - 'tscrollx', 22:05:18 INFO - 'cart']}, 22:05:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:05:18 INFO - 'tsvgr_opacity', 22:05:18 INFO - 'tart', 22:05:18 INFO - 'tscrollx', 22:05:18 INFO - 'cart']}, 22:05:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:18 INFO - 'talos_options': ['--disable-e10s'], 22:05:18 INFO - 'tests': ['tp5o']}, 22:05:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:18 INFO - 'tests': ['tp5o']}, 22:05:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:18 INFO - 'talos_options': ['--disable-e10s', 22:05:18 INFO - '--xperf_path', 22:05:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:05:18 INFO - 'tests': ['tp5n']}, 22:05:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:18 INFO - 'talos_options': ['--xperf_path', 22:05:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:05:18 INFO - 'tests': ['tp5n']}}, 22:05:18 INFO - 'talos.zip': {'path': '', 22:05:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:05:18 INFO - Running post-action listener: _resource_record_post_action 22:05:18 INFO - [mozharness: 2016-11-14 06:05:18.765104Z] Finished populate-webroot step (success) 22:05:18 INFO - [mozharness: 2016-11-14 06:05:18.765212Z] Running create-virtualenv step. 22:05:18 INFO - Running pre-action listener: _resource_record_pre_action 22:05:18 INFO - Running main action method: create_virtualenv 22:05:18 INFO - Creating virtualenv /builds/slave/test/build/venv 22:05:18 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 22:05:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:05:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:05:18 INFO - Using real prefix '/tools/python27' 22:05:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:05:19 INFO - Installing distribute.............................................................................................................................................................................................done. 22:05:22 INFO - Installing pip.................done. 22:05:22 INFO - Return code: 0 22:05:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:05:22 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')]} 22:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:22 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')]} 22:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:22 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 0x100e33490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100da9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde635aab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c47d30>, '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 0x100aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c3fb20>, '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.FtKJdh2zFC/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.JdzjZW6z25/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 22:05:22 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 22:05:22 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 22:05:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FtKJdh2zFC/Render', 22:05:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:05:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:05:22 INFO - 'HOME': '/Users/cltbld', 22:05:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:05:22 INFO - 'LOGNAME': 'cltbld', 22:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:22 INFO - 'MOZ_NO_REMOTE': '1', 22:05:22 INFO - 'NO_EM_RESTART': '1', 22:05:22 INFO - 'PAGER': '/bin/cat', 22:05:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:22 INFO - 'PWD': '/builds/slave/test', 22:05:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:05:22 INFO - 'SHELL': '/bin/bash', 22:05:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdzjZW6z25/Listeners', 22:05:22 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 22:05:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:05:22 INFO - 'USER': 'cltbld', 22:05:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:05:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:22 INFO - 'XPC_FLAGS': '0x0', 22:05:22 INFO - 'XPC_SERVICE_NAME': '0', 22:05:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:22 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 22:05:22 INFO - Cleaning up... 22:05:22 INFO - Return code: 0 22:05:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:05:22 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')]} 22:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:22 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')]} 22:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:22 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 0x100e33490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100da9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde635aab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c47d30>, '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 0x100aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c3fb20>, '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.FtKJdh2zFC/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.JdzjZW6z25/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 22:05:22 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 22:05:22 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 22:05:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FtKJdh2zFC/Render', 22:05:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:05:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:05:22 INFO - 'HOME': '/Users/cltbld', 22:05:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:05:22 INFO - 'LOGNAME': 'cltbld', 22:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:22 INFO - 'MOZ_NO_REMOTE': '1', 22:05:22 INFO - 'NO_EM_RESTART': '1', 22:05:22 INFO - 'PAGER': '/bin/cat', 22:05:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:22 INFO - 'PWD': '/builds/slave/test', 22:05:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:05:22 INFO - 'SHELL': '/bin/bash', 22:05:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdzjZW6z25/Listeners', 22:05:22 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 22:05:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:05:22 INFO - 'USER': 'cltbld', 22:05:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:05:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:22 INFO - 'XPC_FLAGS': '0x0', 22:05:22 INFO - 'XPC_SERVICE_NAME': '0', 22:05:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:22 INFO - Downloading/unpacking psutil>=3.1.1 22:05:22 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 22:05:22 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 22:05:22 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 22:05:22 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 22:05:22 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 22:05:22 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 22:05:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:05:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:05:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:05:26 INFO - Installing collected packages: psutil 22:05:26 INFO - Running setup.py install for psutil 22:05:26 INFO - building 'psutil._psutil_osx' extension 22:05:26 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 22:05:26 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 22:05:26 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 22:05:26 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 22:05:26 INFO - building 'psutil._psutil_posix' extension 22:05:26 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 22:05:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:05:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:05:26 INFO - ^ 22:05:27 INFO - 1 warning generated. 22:05:27 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 22:05:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:05:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:05:27 INFO - Successfully installed psutil 22:05:27 INFO - Cleaning up... 22:05:27 INFO - Return code: 0 22:05:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:05:27 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')]} 22:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:27 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')]} 22:05:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:27 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 0x100e33490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100da9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde635aab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c47d30>, '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 0x100aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c3fb20>, '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.FtKJdh2zFC/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.JdzjZW6z25/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 22:05:27 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 22:05:27 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 22:05:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FtKJdh2zFC/Render', 22:05:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:05:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:05:27 INFO - 'HOME': '/Users/cltbld', 22:05:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:05:27 INFO - 'LOGNAME': 'cltbld', 22:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:27 INFO - 'MOZ_NO_REMOTE': '1', 22:05:27 INFO - 'NO_EM_RESTART': '1', 22:05:27 INFO - 'PAGER': '/bin/cat', 22:05:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:27 INFO - 'PWD': '/builds/slave/test', 22:05:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:05:27 INFO - 'SHELL': '/bin/bash', 22:05:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdzjZW6z25/Listeners', 22:05:27 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 22:05:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:05:27 INFO - 'USER': 'cltbld', 22:05:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:05:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:27 INFO - 'XPC_FLAGS': '0x0', 22:05:27 INFO - 'XPC_SERVICE_NAME': '0', 22:05:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:05: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 22:05: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 22:05: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 22:05: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 22:05: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 22:05: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 22:05:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:05:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:05:30 INFO - Installing collected packages: mozsystemmonitor 22:05:30 INFO - Running setup.py install for mozsystemmonitor 22:05:30 INFO - Successfully installed mozsystemmonitor 22:05:30 INFO - Cleaning up... 22:05:30 INFO - Return code: 0 22:05:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100e33490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100da9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde635aab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c47d30>, '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 0x100aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c3fb20>, '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.FtKJdh2zFC/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.JdzjZW6z25/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 22:05:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:05:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:05:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FtKJdh2zFC/Render', 22:05:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:05:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:05:30 INFO - 'HOME': '/Users/cltbld', 22:05:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:05:30 INFO - 'LOGNAME': 'cltbld', 22:05:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:30 INFO - 'MOZ_NO_REMOTE': '1', 22:05:30 INFO - 'NO_EM_RESTART': '1', 22:05:30 INFO - 'PAGER': '/bin/cat', 22:05:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:05:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:30 INFO - 'PWD': '/builds/slave/test', 22:05:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:05:30 INFO - 'SHELL': '/bin/bash', 22:05:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdzjZW6z25/Listeners', 22:05:30 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 22:05:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:05:30 INFO - 'USER': 'cltbld', 22:05:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:05:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:05:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:30 INFO - 'XPC_FLAGS': '0x0', 22:05:30 INFO - 'XPC_SERVICE_NAME': '0', 22:05:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:05:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:30 INFO - Downloading/unpacking jsonschema==2.5.1 22:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:05:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:05:33 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 22:05:33 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 22:05:33 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 22:05:33 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 22:05:33 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 22:05:33 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 22:05:33 INFO - Downloading functools32-3.2.3-2.tar.gz 22:05:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:05:33 INFO - warning: no files found matching '*.txt' 22:05:33 INFO - no previously-included directories found matching 'build' 22:05:33 INFO - no previously-included directories found matching 'dist' 22:05:33 INFO - no previously-included directories found matching '.git*' 22:05:33 INFO - Installing collected packages: jsonschema, functools32 22:05:33 INFO - Running setup.py install for functools32 22:05:33 INFO - warning: no files found matching '*.txt' 22:05:33 INFO - no previously-included directories found matching 'build' 22:05:33 INFO - no previously-included directories found matching 'dist' 22:05:33 INFO - no previously-included directories found matching '.git*' 22:05:33 INFO - Successfully installed jsonschema functools32 22:05:33 INFO - Cleaning up... 22:05:33 INFO - Return code: 0 22:05:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:05:33 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')]} 22:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:33 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')]} 22:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:33 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 0x100e33490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100da9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde635aab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c47d30>, '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 0x100aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c3fb20>, '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.FtKJdh2zFC/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.JdzjZW6z25/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 22:05:33 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 22:05:33 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 22:05:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FtKJdh2zFC/Render', 22:05:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:05:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:05:33 INFO - 'HOME': '/Users/cltbld', 22:05:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:05:33 INFO - 'LOGNAME': 'cltbld', 22:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:33 INFO - 'MOZ_NO_REMOTE': '1', 22:05:33 INFO - 'NO_EM_RESTART': '1', 22:05:33 INFO - 'PAGER': '/bin/cat', 22:05:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:33 INFO - 'PWD': '/builds/slave/test', 22:05:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:05:33 INFO - 'SHELL': '/bin/bash', 22:05:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdzjZW6z25/Listeners', 22:05:33 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 22:05:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:05:33 INFO - 'USER': 'cltbld', 22:05:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:05:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:33 INFO - 'XPC_FLAGS': '0x0', 22:05:33 INFO - 'XPC_SERVICE_NAME': '0', 22:05:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:05:34 INFO - Cleaning up... 22:05:34 INFO - Return code: 0 22:05:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:05: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')]} 22:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05: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')]} 22:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05: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', '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 0x100e33490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100da9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde635aab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c47d30>, '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 0x100aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c3fb20>, '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.FtKJdh2zFC/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.JdzjZW6z25/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 22:05: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:05: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 blobuploader==1.2.4 22:05:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FtKJdh2zFC/Render', 22:05:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:05:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:05:34 INFO - 'HOME': '/Users/cltbld', 22:05:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:05:34 INFO - 'LOGNAME': 'cltbld', 22:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:34 INFO - 'MOZ_NO_REMOTE': '1', 22:05:34 INFO - 'NO_EM_RESTART': '1', 22:05:34 INFO - 'PAGER': '/bin/cat', 22:05:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:34 INFO - 'PWD': '/builds/slave/test', 22:05:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:05:34 INFO - 'SHELL': '/bin/bash', 22:05:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdzjZW6z25/Listeners', 22:05:34 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 22:05:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:05:34 INFO - 'USER': 'cltbld', 22:05:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:05:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:34 INFO - 'XPC_FLAGS': '0x0', 22:05:34 INFO - 'XPC_SERVICE_NAME': '0', 22:05:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:34 INFO - Downloading/unpacking blobuploader==1.2.4 22:05: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 22:05: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 22:05: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 22:05: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 22:05: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 22:05: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 22:05:36 INFO - Downloading blobuploader-1.2.4.tar.gz 22:05:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:05:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:05:37 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 22:05:37 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 22:05:37 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 22:05:37 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 22:05:37 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 22:05:37 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 22:05:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:05:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:05:37 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 22:05:37 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 22:05:37 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 22:05:37 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 22:05:37 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 22:05:37 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 22:05:38 INFO - Downloading docopt-0.6.1.tar.gz 22:05:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:05:38 INFO - Installing collected packages: blobuploader, requests, docopt 22:05:38 INFO - Running setup.py install for blobuploader 22:05:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:05:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:05:38 INFO - Running setup.py install for requests 22:05:38 INFO - Running setup.py install for docopt 22:05:39 INFO - Successfully installed blobuploader requests docopt 22:05:39 INFO - Cleaning up... 22:05:39 INFO - Return code: 0 22:05:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:05:39 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')]} 22:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:39 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')]} 22:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:39 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 0x100e33490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100da9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde635aab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c47d30>, '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 0x100aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c3fb20>, '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.FtKJdh2zFC/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.JdzjZW6z25/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 22:05:39 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 22:05:39 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 22:05:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FtKJdh2zFC/Render', 22:05:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:05:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:05:39 INFO - 'HOME': '/Users/cltbld', 22:05:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:05:39 INFO - 'LOGNAME': 'cltbld', 22:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:39 INFO - 'MOZ_NO_REMOTE': '1', 22:05:39 INFO - 'NO_EM_RESTART': '1', 22:05:39 INFO - 'PAGER': '/bin/cat', 22:05:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:39 INFO - 'PWD': '/builds/slave/test', 22:05:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:05:39 INFO - 'SHELL': '/bin/bash', 22:05:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdzjZW6z25/Listeners', 22:05:39 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 22:05:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:05:39 INFO - 'USER': 'cltbld', 22:05:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:05:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:39 INFO - 'XPC_FLAGS': '0x0', 22:05:39 INFO - 'XPC_SERVICE_NAME': '0', 22:05:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:05:39 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-CS4hiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:05:39 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-lz_mme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:05:39 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-XgYsfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:05:39 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-e7wWse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:05:39 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-3gPqTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:05:39 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-DZY99O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:05:40 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-LRIPwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:05:40 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-XSOUql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:05:40 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-4HNbKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:05:40 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-OHAPpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:05:40 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-8bDJmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:05:40 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-U6UNH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:05:40 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-jGde_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:05:40 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-Tyqt1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:05:40 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-PSJhq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:05:40 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-pF2tZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:05:41 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-ivw68C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:05:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:05:41 INFO - Running setup.py install for manifestparser 22:05:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:05:41 INFO - Running setup.py install for mozcrash 22:05:41 INFO - Running setup.py install for mozdebug 22:05:41 INFO - Running setup.py install for mozdevice 22:05:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:05:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:05:41 INFO - Running setup.py install for mozfile 22:05:41 INFO - Running setup.py install for mozhttpd 22:05:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:05:42 INFO - Running setup.py install for mozinfo 22:05:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:05:42 INFO - Running setup.py install for mozInstall 22:05:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:05:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:05:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:05:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:05:42 INFO - Running setup.py install for mozleak 22:05:42 INFO - Running setup.py install for mozlog 22:05:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:05:42 INFO - Running setup.py install for moznetwork 22:05:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:05:42 INFO - Running setup.py install for mozprocess 22:05:42 INFO - Running setup.py install for mozprofile 22:05:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:05:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:05:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:05:43 INFO - Running setup.py install for mozrunner 22:05:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:05:43 INFO - Running setup.py install for mozscreenshot 22:05:43 INFO - Running setup.py install for moztest 22:05:43 INFO - Running setup.py install for mozversion 22:05:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:05:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:05:43 INFO - Cleaning up... 22:05:43 INFO - Return code: 0 22:05:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:43 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 0x100e33490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100da9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde635aab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c47d30>, '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 0x100aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c3fb20>, '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.FtKJdh2zFC/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.JdzjZW6z25/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 22:05:43 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 22:05:43 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 22:05:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FtKJdh2zFC/Render', 22:05:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:05:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:05:43 INFO - 'HOME': '/Users/cltbld', 22:05:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:05:43 INFO - 'LOGNAME': 'cltbld', 22:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:43 INFO - 'MOZ_NO_REMOTE': '1', 22:05:43 INFO - 'NO_EM_RESTART': '1', 22:05:43 INFO - 'PAGER': '/bin/cat', 22:05:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:43 INFO - 'PWD': '/builds/slave/test', 22:05:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:05:43 INFO - 'SHELL': '/bin/bash', 22:05:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdzjZW6z25/Listeners', 22:05:43 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 22:05:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:05:43 INFO - 'USER': 'cltbld', 22:05:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:05:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:43 INFO - 'XPC_FLAGS': '0x0', 22:05:43 INFO - 'XPC_SERVICE_NAME': '0', 22:05:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:05:43 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-oyqUa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:05:44 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)) 22:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:05:44 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-SKARVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:05:44 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)) 22:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:05:44 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-sWVQiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:05:44 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)) 22:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:05:44 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-sdX3l2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:05:44 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)) 22:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:05:44 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-wQrYic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:05:44 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)) 22:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:05:44 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-P26OAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:05:44 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)) 22:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:05:44 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-9r464L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:05:44 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)) 22:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:05:44 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-YFVhgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:05:44 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)) 22:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:05:44 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-__SOji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:05:44 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)) 22:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:05:44 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-SIfHYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:05:45 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)) 22:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:05:45 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-jciD2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:05:45 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)) 22:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:05:45 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-YOTIkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:05:45 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)) 22:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:05:45 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-tlzMXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:05:45 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)) 22:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:05:45 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-5siHzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:05:45 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)) 22:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:05:45 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-J3ygeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:05:45 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)) 22:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:05:45 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-QqIJu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:05:45 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)) 22:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:05:45 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-s07zkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:05:45 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)) 22:05:45 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)) 22:05:45 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)) 22:05:45 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)) 22:05:45 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)) 22:05:45 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)) 22:05:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:48 INFO - Downloading blessings-1.6.tar.gz 22:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:05:48 INFO - Installing collected packages: blessings 22:05:48 INFO - Running setup.py install for blessings 22:05:48 INFO - Successfully installed blessings 22:05:48 INFO - Cleaning up... 22:05:48 INFO - Return code: 0 22:05:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:05:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:05:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:05:48 INFO - Reading from file tmpfile_stdout 22:05:48 INFO - Current package versions: 22:05:48 INFO - blessings == 1.6 22:05:48 INFO - blobuploader == 1.2.4 22:05:48 INFO - docopt == 0.6.1 22:05:48 INFO - functools32 == 3.2.3-2 22:05:48 INFO - jsonschema == 2.5.1 22:05:48 INFO - manifestparser == 1.1 22:05:48 INFO - mozInstall == 1.12 22:05:48 INFO - mozcrash == 0.17 22:05:48 INFO - mozdebug == 0.1 22:05:48 INFO - mozdevice == 0.48 22:05:48 INFO - mozfile == 1.2 22:05:48 INFO - mozhttpd == 0.7 22:05:48 INFO - mozinfo == 0.9 22:05:48 INFO - mozleak == 0.1 22:05:48 INFO - mozlog == 3.4 22:05:48 INFO - moznetwork == 0.27 22:05:48 INFO - mozprocess == 0.23 22:05:48 INFO - mozprofile == 0.28 22:05:48 INFO - mozrunner == 6.12 22:05:48 INFO - mozscreenshot == 0.1 22:05:48 INFO - mozsystemmonitor == 0.3 22:05:48 INFO - moztest == 0.7 22:05:48 INFO - mozversion == 1.4 22:05:48 INFO - psutil == 3.1.1 22:05:48 INFO - requests == 1.2.3 22:05:48 INFO - wsgiref == 0.1.2 22:05:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:05:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:48 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 0x100e33490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100da9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde635aab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c47d30>, '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 0x100aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c3fb20>, '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.FtKJdh2zFC/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.JdzjZW6z25/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 22:05:48 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 22:05:48 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 22:05:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FtKJdh2zFC/Render', 22:05:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:05:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:05:48 INFO - 'HOME': '/Users/cltbld', 22:05:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:05:48 INFO - 'LOGNAME': 'cltbld', 22:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:48 INFO - 'MOZ_NO_REMOTE': '1', 22:05:48 INFO - 'NO_EM_RESTART': '1', 22:05:48 INFO - 'PAGER': '/bin/cat', 22:05:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:48 INFO - 'PWD': '/builds/slave/test', 22:05:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:05:48 INFO - 'SHELL': '/bin/bash', 22:05:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdzjZW6z25/Listeners', 22:05:48 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 22:05:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:05:48 INFO - 'USER': 'cltbld', 22:05:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:05:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:48 INFO - 'XPC_FLAGS': '0x0', 22:05:48 INFO - 'XPC_SERVICE_NAME': '0', 22:05:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:49 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)) 22:05:49 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)) 22:05:49 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)) 22:05:49 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)) 22:05:49 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)) 22:05:49 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)) 22:05:49 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)) 22:05:49 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)) 22:05:49 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)) 22:05:49 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)) 22:05:49 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)) 22:05:49 INFO - Cleaning up... 22:05:49 INFO - Return code: 0 22:05:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:05:49 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')]} 22:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:49 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')]} 22:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:49 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 0x100e33490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100da9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde635aab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c47d30>, '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 0x100aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c3fb20>, '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.FtKJdh2zFC/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.JdzjZW6z25/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 22:05:49 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 22:05:49 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 22:05:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FtKJdh2zFC/Render', 22:05:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:05:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:05:49 INFO - 'HOME': '/Users/cltbld', 22:05:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:05:49 INFO - 'LOGNAME': 'cltbld', 22:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:49 INFO - 'MOZ_NO_REMOTE': '1', 22:05:49 INFO - 'NO_EM_RESTART': '1', 22:05:49 INFO - 'PAGER': '/bin/cat', 22:05:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:49 INFO - 'PWD': '/builds/slave/test', 22:05:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:05:49 INFO - 'SHELL': '/bin/bash', 22:05:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdzjZW6z25/Listeners', 22:05:49 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 22:05:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:05:49 INFO - 'USER': 'cltbld', 22:05:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:05:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:49 INFO - 'XPC_FLAGS': '0x0', 22:05:49 INFO - 'XPC_SERVICE_NAME': '0', 22:05:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:05:49 INFO - Cleaning up... 22:05:49 INFO - Return code: 0 22:05:49 INFO - Running post-action listener: _resource_record_post_action 22:05:49 INFO - Running post-action listener: _start_resource_monitoring 22:05:49 INFO - Starting resource monitoring. 22:05:49 INFO - [mozharness: 2016-11-14 06:05:49.551306Z] Finished create-virtualenv step (success) 22:05:49 INFO - [mozharness: 2016-11-14 06:05:49.552305Z] Running install step. 22:05:49 INFO - Running pre-action listener: _resource_record_pre_action 22:05:49 INFO - Running main action method: install 22:05:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:05:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:05:49 INFO - Reading from file tmpfile_stdout 22:05:49 INFO - Detecting whether we're running mozinstall >=1.0... 22:05:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:05:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:05:49 INFO - Reading from file tmpfile_stdout 22:05:49 INFO - Output received: 22:05:49 INFO - Usage: mozinstall [options] installer 22:05:49 INFO - Options: 22:05:49 INFO - -h, --help show this help message and exit 22:05:49 INFO - -d DEST, --destination=DEST 22:05:49 INFO - Directory to install application into. [default: 22:05:49 INFO - "/builds/slave/test"] 22:05:49 INFO - --app=APP Application being installed. [default: firefox] 22:05:49 INFO - mkdir: /builds/slave/test/build/application 22:05:49 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'] 22:05:49 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 22:06:21 INFO - Reading from file tmpfile_stdout 22:06:21 INFO - Output received: 22:06:21 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 22:06:21 INFO - Running post-action listener: _resource_record_post_action 22:06:21 INFO - [mozharness: 2016-11-14 06:06:21.990554Z] Finished install step (success) 22:06:21 INFO - [mozharness: 2016-11-14 06:06:21.990684Z] Running run-tests step. 22:06:21 INFO - Running pre-action listener: _resource_record_pre_action 22:06:21 INFO - Running main action method: run_tests 22:06:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:06:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:06:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:06:22 INFO - 2016-11-13 22:06:22.005 screenresolution[1643:7675] starting screenresolution argv=screenresolution get 22:06:22 INFO - 2016-11-13 22:06:22.007 screenresolution[1643:7675] Display 0: 1600x1200x32@60 22:06:22 INFO - 2016-11-13 22:06:22.013 screenresolution[1644:7677] starting screenresolution argv=screenresolution list 22:06:22 INFO - Available Modes on Display 0 22:06:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:06:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:06:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:06:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:06:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:06:22 INFO - Intel Iris: 22:06:22 INFO - Chipset Model: Intel Iris 22:06:22 INFO - Type: GPU 22:06:22 INFO - Bus: Built-In 22:06:22 INFO - VRAM (Dynamic, Max): 1536 MB 22:06:22 INFO - Vendor: Intel (0x8086) 22:06:22 INFO - Device ID: 0x0a2e 22:06:22 INFO - Revision ID: 0x0009 22:06:22 INFO - Displays: 22:06:22 INFO - Display: 22:06:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:06:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:06:22 INFO - Display Serial Number: 1600x1200 60 22:06:22 INFO - Main Display: Yes 22:06:22 INFO - Mirror: Off 22:06:22 INFO - Online: Yes 22:06:22 INFO - Rotation: Supported 22:06:22 INFO - Return code: 0 22:06:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:06:22 INFO - Python 2.7.3 22:06:22 INFO - Return code: 0 22:06:22 INFO - grabbing minidump binary from tooltool 22:06:22 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')]} 22:06:22 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 0x100c47d30>, '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 0x100aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c3fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:06:22 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 22:06:22 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 22:06:22 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 22:06:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:06:22 INFO - Return code: 0 22:06:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:06:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:06:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:06:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:06:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:06:22 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/Xpxast4XTOKnFbremvm4nQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0319', '--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 22:06:22 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/Xpxast4XTOKnFbremvm4nQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0319 --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 22:06:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FtKJdh2zFC/Render', 22:06:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:06:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:06:22 INFO - 'HOME': '/Users/cltbld', 22:06:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:06:22 INFO - 'LOGNAME': 'cltbld', 22:06:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:06:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:22 INFO - 'MOZ_NO_REMOTE': '1', 22:06:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:06:22 INFO - 'NO_EM_RESTART': '1', 22:06:22 INFO - 'PAGER': '/bin/cat', 22:06:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:22 INFO - 'PWD': '/builds/slave/test', 22:06:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:06:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:06:22 INFO - 'SHELL': '/bin/bash', 22:06:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdzjZW6z25/Listeners', 22:06:22 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 22:06:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:06:22 INFO - 'USER': 'cltbld', 22:06:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:06:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:22 INFO - 'XPC_FLAGS': '0x0', 22:06:22 INFO - 'XPC_SERVICE_NAME': '0', 22:06:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:06:22 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/Xpxast4XTOKnFbremvm4nQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0319', '--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 22:06:22 INFO - mozversion application_buildid: 20161113194320 22:06:22 INFO - mozversion application_changeset: 1f41acac2aa680a42c0dc85062a0c0ff70c9b80f 22:06:22 INFO - mozversion application_display_name: FirefoxDeveloperEdition 22:06:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:06:22 INFO - mozversion application_name: Firefox 22:06:22 INFO - mozversion application_remotingname: firefox-dev 22:06:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:06:22 INFO - mozversion application_vendor: Mozilla 22:06:22 INFO - mozversion application_version: 51.0a2 22:06:22 INFO - mozversion platform_buildid: 20161113194320 22:06:22 INFO - mozversion platform_changeset: 1f41acac2aa680a42c0dc85062a0c0ff70c9b80f 22:06:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:06:22 INFO - mozversion platform_version: 51.0a2 22:06:22 INFO - using testdate: 1479103582 22:06:22 INFO - actual date: 1479103582 22:06:22 INFO - starting webserver on 'localhost:49275' 22:06:22 INFO - SUITE-START | Running 2 tests 22:06:22 INFO - TEST-START | dromaeo_css 22:06:22 INFO - operating with platform_type : mac_ 22:06:22 INFO - Initialising browser for dromaeo_css test... 22:06:22 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmpq_MKIg/profile http://localhost:49275/getInfo.html) 22:06:25 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 22:06:25 INFO - PROCESS | 1654 | colorDepth:24 22:06:25 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 22:06:25 INFO - PROCESS | 1654 | __metrics 22:06:25 ERROR - PROCESS | 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 22:06:26 INFO - TEST-INFO | 1654: exit 0 22:06:26 INFO - Browser initialized. 22:06:26 INFO - Running cycle 1/1 for dromaeo_css test... 22:06:26 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmpq_MKIg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:06:38 INFO - PROCESS | 1657 | RSS: Main: 225636352 22:06:38 INFO - PROCESS | 1657 | 22:07:27 INFO - PROCESS | 1657 | 1479103647837 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] 22:09:40 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 22:09:42 INFO - PROCESS | 1657 | RSS: Main: 237400064 22:09:42 INFO - PROCESS | 1657 | 22:12:44 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 22:12:44 INFO - PROCESS | 1657 | RSS: Main: 248471552 22:12:44 INFO - PROCESS | 1657 | 22:15:46 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 22:15:47 INFO - PROCESS | 1657 | RSS: Main: 251543552 22:15:47 INFO - PROCESS | 1657 | 22:18:49 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 22:18:49 INFO - PROCESS | 1657 | RSS: Main: 251731968 22:18:49 INFO - PROCESS | 1657 | 22:21:52 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 22:21:53 INFO - PROCESS | 1657 | RSS: Main: 256147456 22:21:53 INFO - PROCESS | 1657 | 22:24:55 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 22:24:56 INFO - PROCESS | 1657 | RSS: Main: 258203648 22:24:56 INFO - PROCESS | 1657 | 22:24:56 INFO - PROCESS | 1657 | __start_tp_report 22:24:56 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 22:24:56 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 22:24:56 INFO - PROCESS | 1657 | |i|pagename|runs| 22:24:56 INFO - PROCESS | 1657 | |0;dojo.html;3424.606170290417;3432.2792213635134;3453.9309213815723;3462.376772181008;3464.133966508373;5762.1356796480495;5776.4223577642215;5796.188533605298;5803.01348770709;5869.853253668661;5749.827505174841;5754.798582049629;5824.417558244173;5832.387599302076;5848.532117430606;4963.726995015273;5234.895302093956;5322.2814919985885;5366.973165134169;5373.6775793452325;5342.759575819078;5393.83818485446;5393.83818485446;5400.108982017982;5407.83776486704;5258.789648414059;5263.657862238962;5353.518183363496;5368.62419630626;5397.974384866882;4346.587074227943;5246.790128394879;5255.343082114736;5335.306410166692;5401.70290634015;5197.324347834758;5239.70115697218;5251.133562962106;5263.105272103751;5311.840644780663;5614.382417934024;5782.103773915008;5815.185873977646;5900.940990590082;5926.1110833374905;6126.908096378558;6153.907691384633;6202.968985155046;6206.038064100072;6209.472194863442;6249.531285153586;6271.435570798604;6295.2760432550385;6299.149614801989;6331.240251169889;5909.6158749681135;5917.733701983421;5926.555508336892;5931.466168044896;5970.76116955317;6196.845078872974;6239.781607643801;6242.75028998844;6247.156633854372;6256.906146407808;5388.868337649059;5873.559483038789;5996.610220335664;6172.074188871616;6182.258129024546;4591.989762252299;5674.829755107354;5868.325142608569;6306.211723534559;6317.526185536103;4764.523547645208;5471.398146203915;5823.912641310384;6143.573288550997;6166.568340216231;5444.782208711607;5941.1385349125;6221.351341894401;6229.3770622937345;6292;4941.851744447672;4954.455009948902;4956.826511072095;4966.925496117561;5002.274670172805;4376.431063961664;4382.496012958487;4412.426384569985;4423.867283981485;4429.534898835575;5917.911231331534;5921.61509501881;5924.11138329254;5952.166696662471;5952.434518720715;5199.922001169985;6246.250449945945;6299.149614802035;6303.747850086037;6327.17746692927;5716.171155182476;5726.112452569859;5739.253896993364;5784.913226301609;5803.390643982406;5405.297311349499;5410.08028635133;5411.56707463402;5428.864278392993;5465.808696695676;6269.5611307208055;6300.0234963580715;6301.054841773771;6301.275353334334;6335.239771227482;6154.892119418548;6239.563230573816;6246.46905013079;6249.843753906189;6276.058591211355;6252.5935814171935;6378.840528986812;6388.776392826228;6392.137061496638;6417.935820641734;6199.690015499297;6248.250209974832;6269.0909818075215;6276.403741644536;6311.179546658905;5209.817656382009;6122.459144589226;6335.873282534416;6354.951433013501;6361.109444677656;5050.72221027847;5871.178035075008;5878.529717622494;5919.7040147991565;5984.281886173687;5536.837264174568;5864.67744274069;5928.3775203603;5942.524598032233;5975.731092100779;5716;5778.8266352009505;5799.3040835100055;5822;5822.970885145547;6087.9391206087375;6108.847278818065;6116.785912493041;6144.815655530341;6170.382961703794;5934.881302373842;5975.910361344497;5989.940100599112;6023.427774361428;6030.185924900083 22:24:56 INFO - PROCESS | 1657 | |1;ext.html;469.6196081174249;484.5590512633504;487.8195067824903;492.8098641780101;519.5350161605363;33265.83367083161;40511.58209462669;41013.384799228;44784.776076119575;44849.32726009112;39456.80271598638;44339;44699.55300446995;44775.77612111943;44920.203191872286;8408.537530435824;8588.312934965219;8694.73915782526;9179.127982841619;9940.40357578544;9784.461854597994;9856.507174641276;9866.901330986706;9876.703698889045;9887.456189909552;9832.410055396664;9879.456629885353;9889.703308900709;9907.108360247576;9916.867873407216;9815.558299876488;9848.2613803965;9858.014198580157;9883.357581757164;9884.061014203675;9777.120059194707;9869.506524673809;9871.851922221173;9877.654282100091;9885.505724713807;34501.654983450346;42451.78774106141;42534.361984570256;42623.36064959028;42689.57310426887;3335.5663763710804;3377.932441351159;3482.9129271768156;3541.645835416438;3565.910852228715;26383.076592319176;29975.700242997726;30020.399592008038;30137.246568835955;30252.243693907607;3229.450993331139;3281.96718032819;3306.5205545196054;3309.652486488908;3325.251818340854;527927;533699;535724;535934;536339.6366036328;33554.328913421596;56199.71900140473;57220.71389643109;62357.68821155956;62591.06113408302;34346.82826585901;35561.93314200578;35854.82072589621;35954;35984.10039749027;14851.851481485262;14967.877409194354;14991.17548534841;14993;15043.247837608076;12739.42672579736;12781.785730355787;12850.871491285154;12895.742085158432;12903.225806451643;7687.077550693953;7811.062672479339;7860.449768516263;7889.408294377945;7908.683652653829;3262.967370326314;3282.0646115856866;3289.8190599517256;3289.967100328966;3317.7014068733447;881.7398867334024;913.9360244782802;998.6554638649654;1040.4121671255716;1079.7474929082384;30337.544936825965;30673.69326306753;30696.386072278878;30702.53946190809;31087.689123108932;1017.308230403318;1025.8717660292464;1050.7181238888543;1065.898739619735;1095.8684957804956;15382.615434614001;15691;15849.683006339808;15995.920020399824;16171.67656646884;703299;707167;712874;713816;717526;59724;60067.39932600706;60226.69886650539;60337.79324413575;60669.39330606638;1356.4845358763805;1358.6331690443526;1397.1407584335561;1397.6925076483158;1400.3698335749157;29659.665315061306;30496.932607358634;30577;30769.846150769103;30822.383552329276;44714;49473.25790113223;51586;51841.48158518367;52009.21986170286;614819;618354;618364;618783;621259;27029.86485067562;27123.321916952234;27359.72640273572;27598.034068807494;27601.86199068992;41969.37045944252;43603.781981089895;47848.52151478441;51708.224376633625;52795.736021319644;30625.23436914095;32587.674123258465;38632.6136738629;40080.99797504969;40822.59177408188;40398.38406463709;40667.59332406638;40755.7962210187;41641.375379369936;42192.78903605462;38729.80635096919;39440.80279598584;39618.60381396149;39712.404313934734;41309.96725081897;32641.836790815894;35930;36193.81903090468;36404.81797591101;36566.63433365632;21922.561548769256;25297.87351063233;26474.602880957187;26723.599146013214;26770.19689409321 22:24:56 INFO - PROCESS | 1657 | |2;jquery.html;364.26418634358595;366.6736604422065;374.4888227569369;381.4665046513016;390.1961958365767;20029.799702002976;20800.271990480338;21134.365969020935;21590.676139857915;21765.564688706258;20297.594048119066;20349.898250508762;20356.898215508903;20456.488587785312;20760.584788304226;5787.913181302263;5934.228550288467;6059.878802423949;6138.938610613904;6191.226096737908;3857.6720978716844;4061.57353477885;6076.6050206736645;6108.175396321484;6118.4799292060225;5819.418058194168;6092.786752463665;6122.112293717409;6169.29053158888;6182.969085154568;5973.970130149343;6055.666938318391;6072.180255665517;6104.81685549432;6166.3525329840395;5874.559408044371;5874.97062514689;5876.177335173079;5880.70596470179;5891.410858914117;24387.634185487233;24465.143719969714;24820.25539233826;25350.74649253502;25808;2164.350694791556;2322.5587138443643;2533.2526904563197;2894.3343031102754;2980.7913446058783;9747.415155090717;9863.210943124604;9875.703728888146;10107.39355638664;14665.193414362206;1883.8775479593783;1956.0610906764691;1956.6967120096408;1966.7148263501856;2006.7591888973416;104298.47850760774;108470;111764.4411777944;113995.43002284935;124237.37881310536;9399.90600094004;11065.944670276596;11231.494582743797;11570.537178512934;11772.646820595395;14530;14567.834573234115;14577.125372477685;14605.415783368759;14638.707225855636;7340.082489688789;8347.874781878276;8387.958060209781;8584.484930904166;8736.519491428033;8499.107593702696;8586.398952073296;8594.183552562497;8708.346873984476;8727.389082764146;4435.534268901783;4500.572445617661;4513.954860451419;4579.519150489217;4588.587027167571;1642.523668136251;1688.4765722626025;1767.6729804985862;1803.2426380920044;1951.4438385060473;773.6634563964693;969.4425705219527;973.73709098543;989.1295659819313;1014.4217795856291;19190.712139317922;21303.78696213049;21322.14394734102;21672.89163554172;21832.672509912365;900.2392977933636;909.3725329522608;923.1368670293298;924.2698268368049;925.8519435899436;8548.615312310962;11307;11322.32066076038;11342.489587968561;11356.602518911799;523029;575831;577590;595663;629649;130010.34994824966;131198;131653;134348;135983;848.117957324388;883.3860466975391;938.8310104181313;1027.2655051638114;1030.1398332392387;19057.14242859047;19708.50728731793;19798;19850;19894.60210795805;54754.98847563422;54834.72582637061;56212.71893640506;56218.71890640521;56702;83346.58326708328;84280.57859710662;84376.57811710902;85214.57392712997;87419;6060.545459090674;6983.476239282176;7344.522606030805;7439.665215065444;8023.077346105272;9940.850887236842;12398.81401778992;12809.487620495076;12886.67783305425;13271.800922986356;10878.836817447585;11035.889641103486;11097.667069987914;11386.032187263843;11397.316161030365;10763.94618026905;10869.456527173768;10920.617778378037;10998.285111467729;11323.32060076398;9413.670521531714;10850.40322782223;11256.324620522795;11266.267692599955;11510.02164816;6951.7914462566205;7294.708211671474;7373.668184931798;7421.703131874665;7454.142773581108;8390.286825619647;9215.76960575991;10962.725931851448;11086.445677716243;11298.152638551977 22:24:56 INFO - PROCESS | 1657 | |3;mootools.html;1426.743186226479;1507.2011833728125;1698.0745493705938;1792.704203806372;1842.0881663576524;8101.513909165455;8350.540720260384;8596.3122950164;9151.725448236546;9202.125798049183;8589.785255368619;8914.687985920495;8920.95539522303;8962.596683149257;8970.416922900024;2380.214529205367;2404.0984630763464;2406.5547873643345;2407.205622144697;2407.687000689908;2061.2785525066256;2334.5447637710654;2391.1033362489065;2405.254371144942;2409.999850062231;2377.1442280778992;2389;2394.221877889684;2404.362843846382;2407.4944261705064;2355.552445035438;2364.869932153731;2371.7746814052725;2376.7147942246957;2388.199953015742;2357.97642023581;2370.4903445759073;2371.2886134159858;2378.250850981935;2382.833201675883;7639.388848892076;8247.391758607075;8761.561921903944;8952.373333866632;9049.728508144766;5286.497782710637;5339.252504649352;5388.649737767033;5401.945980540223;5422.40353561108;3054.7708921830954;3055.3278278778857;3673.3938900081453;3681.4845921571;3713.535808023997;1080.5569716416232;1101.4878081692052;1102.2584316779469;1120.3278033180109;1124.4377811094453;11845.822312665317;11900.988415984652;11923.165378423513;11996.760064798655;12091.818622720666;4793.281007848781;4833.564979151894;4842.539958703917;4929.112759703216;4941.234108713155;8472.364572657076;8855;10106.646267380607;10232.437215953194;10300.433476158732;5356.1697936819855;5375.113106337489;5377.112776391929;5380.219868119101;5398.352197736297;4359.564043595678;4508.256137737237;4768.523147685273;4911.7544122793715;4914.483979182206;4026.6174713402766;4032.3749818778138;4124.237016152021;4158.91682166355;4162.4796900387455;1328.920264784116;1332.5669157523844;1334.5796074236584;1339.55125033115;1344.025581453458;768.9192634773381;883.1698203688512;905.3843386497246;907.7458311672742;931.9580618872031;5852.297724273029;5880.882382352329;5983.910241346383;6001.189839371629;6215.160953271341;922.5710044829186;959.29971121082;987.8863930647924;993.380789313429;1015.827309357411;3820.178661587772;3885.6502914737807;4013.458183145238;4029.2545879012478;4065.4738488046;8674.219320261207;11096.056835169102;11101.945315195044;11125.332480051062;11157.66527004191;11066.833997490045;11078.0583650389;11078.279911805706;11100.888991109985;11124.944375278234;8392.832143357098;8448.281896038905;8519.57402129891;8527.23254907049;8539.316854651614;5781;5989.580729349078;6036.124761909411;6060.272767267779;6071.39286071407;9772.26707996889;10063.798724025331;10181.440020798927;10224.23318251149;10392.948035260079;10289.97100289965;10398.480075996322;10412.68761937143;10449.21630877672;10455.94772026135;7045.225025247321;7257.310555497219;7629.389648828192;7656.966309548363;7783.221677832172;8383.66465341404;8580.613872375883;8587.441816281922;8594.484330940164;8606.053334133365;7585.582792946441;7688.077430708351;7747.767566973;7826.882596760939;7836.059672839067;7462.589557574385;7561.508501947355;7570.545767253982;7570.735024274124;7711.344535714303;7086.078809754699;7232.240614735588;7240.1311842579225;7245.855082898418;7266.781996540112;4836.419629644465;4900.534449227318;4933.925991110064;4945.851624451272;5018.44797072329;4363.650907927295;4384.298512238027;4667.673262871566;5051.87370315745;5213.478652134756 22:24:56 INFO - PROCESS | 1657 | |4;prototype.html;252.69423996963675;301.1417460238321;311.1272879572798;313.6346156727413;315.04698287679753;4275.722078064931;4557.086023869974;4740.668153229275;4972.378452693409;5160.587153027758;5258.342707161605;5393.703346315951;5498.285222921015;5502.477264659851;5522.641028333155;3642.3079614873222;4162.500499939996;4173.499180098385;4180.874573762792;4209.548170500191;3882.437046628237;4117.341225403936;4209.116085622023;4210.157968406315;4215.702442169025;4076.5923407659293;4084.530279017906;4110.609492098246;4113.4858142732155;4137.8758637240935;3278.918027049319;4023.7325242548504;4118.485189351331;4133;4149.33610622299;2823.5200015997125;3535.611082780892;3544.379733546619;3555.3955827509385;3569.7679650822615;4660.347551342815;4828.782704778258;4968.826091086795;5352.5182733553775;5372.925414916993;4693.530646935314;4699.107169637758;4716.363290955712;4726.503717109723;4734.479207287196;4482.417285752864;5138.7173705446185;5778.59549831512;5825.863956528478;5864.481311213281;3600.021812305129;3804.2201348723447;3829.9360511590894;3872.2255548890053;3896.49345585075;5113.008889799472;5751.971240143815;6041.6375017499095;6102.962496375582;6124.540659450559;3438.5014172944784;3910.550286717064;3911.2373087248284;3938.822752976123;3951.577432124433;3673.687736542424;3682.4476328550395;3831.425286207091;3953.438391835209;4063.817128229237;3915.980420097881;4422.402975598253;4616.95383046172;4655.767211639404;4696.272077827942;5024.824131155465;5086.593072554187;5682.545396368363;5684.403137670568;5794.88410231793;1284.2872205925614;1324.1194605587368;1380.2477649680948;1410.1597415372833;1410.978835317471;873.323174539724;895.1247137247456;967.8935317115112;969.418348990614;973.6466311826566;3645.143391303042;3967.5238971323624;4059.5331536873045;4092.4679791627495;4573.885652858705;4162.791860406967;4428.8997701609005;4450.062958447474;4775.4451368517675;5037.279868870769;3776.7167462440425;4352.455943007124;4454.933176002362;4504.864854054318;4582.631765652243;2433.8904749286326;2456.3736247256834;2585.0883321688943;2611.7257687942874;2614.41175735458;4663.766811659403;4864.270359446112;5054.887924656569;5150.922736158961;5160.612954028463;4258.424382978318;4876.683015603974;4987.62592805541;5092.872678183075;5113.411957624847;4562.749048802281;4629.259318509023;4896.706197628154;4930.6795058321095;5152.531528514505;4928.457869634266;4932.53140951609;4962.305277261258;4963.8262660806695;5022.974885125551;3971.5829837867764;4142.343062774914;4607.262837945913;4678.883027924329;4906.559563594952;4577.185031205718;4741.099191153669;4772.498887616889;5114;5124.9743751281;3061.7550595952716;3368.865245390157;3519.0498565387716;3566.3045706087064;3612.771657636311;4939.382577177853;4967.950320496893;4984.37695288089;5021.648484606042;5671.602987790815;4677.368555244999;4804.95195048045;4821.855344339676;5526.148740172087;5734.168545560954;5779.537636988946;5783.363829978614;5791.9131213031;5800.403749675228;5811.709414529172;4703.952960470351;4944.181816364781;5399.920015996895;5687.374388817144;5736.6558006519745;5465.945340546703;5792.364474164161;5816.941830581809;5827.310080076731;5843.386444423274;4614.723116613014;5562.332520097614;5709.143628455765;5722.370539240764;5730.424133363192 22:24:56 INFO - PROCESS | 1657 | |5;yui.html;633.1737083106544;726.3825748114103;736.2416710787887;769.4536878816041;775.3796962430055;15026;15414.460493882701;15611.921940390283;15612.453564125259;15639.530814075582;12853.614391568268;14139.717205655881;14248.857511424883;14260.500882469116;14289.07121037132;673.9326067393258;692.0622556436032;841.7096101844854;873.7029410000598;878.4948654523643;861.5993562993207;861.8707193920931;863.4301361101674;863.9654413823439;866.3112825303867;841.4908980067063;920.903305152956;922.2898368256472;928.4058202750246;929.7954450020984;894.7047474333486;912.4251721415532;916.7112359606735;916.7387294621068;917.9632814687404;676.158183062086;677.2888467109515;684.7979845945458;685.3454950522289;690.0718533572337;12678.302693351861;14675.192864392455;14760.852391476055;14775.113493190443;14789.11265324084;14027.43890244389;14485.42058317666;14550.490732824406;14664.560063198121;14681.97226194156;11514.251573647769;11928.940355298255;11943.701407464883;11948.283103013848;12365.196262242926;3749.1751814600743;3793.4499497572974;3809.142942837867;3865.729398942075;3993.121513267077;113972.4301378496;114567;120238;120248.39875800653;121624.39187804093;10963.56145754161;11018.724531886766;11106.55573777056;11155.386453745123;11207.831882521768;22242.777572224393;22253;22298.665520017214;22315.99578018993;22333.99497022638;7625.475408365255;7900.960495197487;8010.158933312035;8033.638486268132;8196.672133114727;4338.305871060616;4364.648046029728;4451;4551;4587.587117159472;3449.085992212066;3568.8750893718593;3569.8572057117944;3576.177479179751;3583.910402239913;647.3203136706439;654.8788474132206;659.3143131143653;671.2012704881175;675.6655455549535;574.3681949855126;613.736093479808;617.5522746009108;670.731707317077;706.9752558660422;9018.413803102778;9324.813503730024;9448.527573621292;9535.427874327563;9721;548.7530611224964;576.7087620751494;602.3133627664466;639.7057353617295;643.3727116061802;4596.49438561758;4600.861974140714;4607.9308810367875;4648.930266046012;4721.9055618888115;95356;99857.50071249742;161209;165078.17460912617;165747;82468;143253;144667.276663616;146122;148513;86961.56519217363;101646;102975.94048118996;107388;107636;9460.337776355589;9647.035296470296;9990.100890919852;10033.14718248957;10049.547770350206;48554.27168592403;60297;60682.39317606767;61332.69333653303;62722.68638656777;62165;86588.96938607118;88785.55607221923;90911.63632545384;94073;11893.643190704293;11899.583514576949;11977.101717371406;12114.454849531616;12375.69060773452;14190.574282771533;14423;14708.852911470749;14924.104553726811;14996.175210363535;13294.800577991144;13516.459341626618;13684.247366394944;13841.653958651113;14369.06601070927;12903.290319032543;13396.598102056954;13689.794653080013;13801.51694690681;13969.860301396857;12025.759484810429;12823.551175708806;13377.130486518345;13440;13640.522581709592;10795.40625265618;11210.853365682044;11271.943640281746;11550;11620.186586939171;11404.714882128013;11451.427428628702;11519.366434845828;11575.947222609864;11634.36011019402 22:24:56 INFO - PROCESS | 1657 | __end_tp_report 22:24:56 INFO - PROCESS | 1657 | __start_cc_report 22:24:56 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,376 22:24:56 INFO - PROCESS | 1657 | __end_cc_report 22:24:56 INFO - PROCESS | 1657 | __startTimestamp1479104696245__endTimestamp 22:24:56 INFO - PROCESS | 1657 | 22:24:56 INFO - PROCESS | 1657 | ------- Summary: start ------- 22:24:56 INFO - PROCESS | 1657 | Number of tests: 6 22:24:56 INFO - PROCESS | 1657 | 22:24:56 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5712.07 Median:5873.56 stddev:631.75 (10.8%) stddev-sans-first:607.67 22:24:56 INFO - PROCESS | 1657 | Values: 3424.6 3432.3 3453.9 3462.4 3464.1 5762.1 5776.4 5796.2 5803.0 5869.9 5749.8 5754.8 5824.4 5832.4 5848.5 4963.7 5234.9 5322.3 5367.0 5373.7 5342.8 5393.8 5393.8 5400.1 5407.8 5258.8 5263.7 5353.5 5368.6 5398.0 4346.6 5246.8 5255.3 5335.3 5401.7 5197.3 5239.7 5251.1 5263.1 5311.8 5614.4 5782.1 5815.2 5900.9 5926.1 6126.9 6153.9 6203.0 6206.0 6209.5 6249.5 6271.4 6295.3 6299.1 6331.2 5909.6 5917.7 5926.6 5931.5 5970.8 6196.8 6239.8 6242.8 6247.2 6256.9 5388.9 5873.6 5996.6 6172.1 6182.3 4592.0 5674.8 5868.3 6306.2 6317.5 4764.5 5471.4 5823.9 6143.6 6166.6 5444.8 5941.1 6221.4 6229.4 6292.0 4941.9 4954.5 4956.8 4966.9 5002.3 4376.4 4382.5 4412.4 4423.9 4429.5 5917.9 5921.6 5924.1 5952.2 5952.4 5199.9 6246.3 6299.1 6303.7 6327.2 5716.2 5726.1 5739.3 5784.9 5803.4 5405.3 5410.1 5411.6 5428.9 5465.8 6269.6 6300.0 6301.1 6301.3 6335.2 6154.9 6239.6 6246.5 6249.8 6276.1 6252.6 6378.8 6388.8 6392.1 6417.9 6199.7 6248.3 6269.1 6276.4 6311.2 5209.8 6122.5 6335.9 6355.0 6361.1 5050.7 5871.2 5878.5 5919.7 5984.3 5536.8 5864.7 5928.4 5942.5 5975.7 5716.0 5778.8 5799.3 5822.0 5823.0 6087.9 6108.8 6116.8 6144.8 6170.4 5934.9 5975.9 5989.9 6023.4 6030.2 22:24:56 INFO - PROCESS | 1657 | 22:24:56 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:73511.27 Median:40589.59 stddev:167764.09 (413.3%) stddev-sans-first:168145.08 22:24:56 INFO - PROCESS | 1657 | Values: 469.6 484.6 487.8 492.8 519.5 33265.8 40511.6 41013.4 44784.8 44849.3 39456.8 44339.0 44699.6 44775.8 44920.2 8408.5 8588.3 8694.7 9179.1 9940.4 9784.5 9856.5 9866.9 9876.7 9887.5 9832.4 9879.5 9889.7 9907.1 9916.9 9815.6 9848.3 9858.0 9883.4 9884.1 9777.1 9869.5 9871.9 9877.7 9885.5 34501.7 42451.8 42534.4 42623.4 42689.6 3335.6 3377.9 3482.9 3541.6 3565.9 26383.1 29975.7 30020.4 30137.2 30252.2 3229.5 3282.0 3306.5 3309.7 3325.3 527927.0 533699.0 535724.0 535934.0 536339.6 33554.3 56199.7 57220.7 62357.7 62591.1 34346.8 35561.9 35854.8 35954.0 35984.1 14851.9 14967.9 14991.2 14993.0 15043.2 12739.4 12781.8 12850.9 12895.7 12903.2 7687.1 7811.1 7860.4 7889.4 7908.7 3263.0 3282.1 3289.8 3290.0 3317.7 881.7 913.9 998.7 1040.4 1079.7 30337.5 30673.7 30696.4 30702.5 31087.7 1017.3 1025.9 1050.7 1065.9 1095.9 15382.6 15691.0 15849.7 15995.9 16171.7 703299.0 707167.0 712874.0 713816.0 717526.0 59724.0 60067.4 60226.7 60337.8 60669.4 1356.5 1358.6 1397.1 1397.7 1400.4 29659.7 30496.9 30577.0 30769.8 30822.4 44714.0 49473.3 51586.0 51841.5 52009.2 614819.0 618354.0 618364.0 618783.0 621259.0 27029.9 27123.3 27359.7 27598.0 27601.9 41969.4 43603.8 47848.5 51708.2 52795.7 30625.2 32587.7 38632.6 40081.0 40822.6 40398.4 40667.6 40755.8 41641.4 42192.8 38729.8 39440.8 39618.6 39712.4 41310.0 32641.8 35930.0 36193.8 36404.8 36566.6 21922.6 25297.9 26474.6 26723.6 26770.2 22:24:56 INFO - PROCESS | 1657 | 22:24:56 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:34743.37 Median:370.58 stddev:97331.99 (26264.7%) stddev-sans-first:97570.80 22:24:56 INFO - PROCESS | 1657 | Values: 364.3 366.7 374.5 381.5 390.2 20029.8 20800.3 21134.4 21590.7 21765.6 20297.6 20349.9 20356.9 20456.5 20760.6 5787.9 5934.2 6059.9 6138.9 6191.2 3857.7 4061.6 6076.6 6108.2 6118.5 5819.4 6092.8 6122.1 6169.3 6183.0 5974.0 6055.7 6072.2 6104.8 6166.4 5874.6 5875.0 5876.2 5880.7 5891.4 24387.6 24465.1 24820.3 25350.7 25808.0 2164.4 2322.6 2533.3 2894.3 2980.8 9747.4 9863.2 9875.7 10107.4 14665.2 1883.9 1956.1 1956.7 1966.7 2006.8 104298.5 108470.0 111764.4 113995.4 124237.4 9399.9 11065.9 11231.5 11570.5 11772.6 14530.0 14567.8 14577.1 14605.4 14638.7 7340.1 8347.9 8388.0 8584.5 8736.5 8499.1 8586.4 8594.2 8708.3 8727.4 4435.5 4500.6 4514.0 4579.5 4588.6 1642.5 1688.5 1767.7 1803.2 1951.4 773.7 969.4 973.7 989.1 1014.4 19190.7 21303.8 21322.1 21672.9 21832.7 900.2 909.4 923.1 924.3 925.9 8548.6 11307.0 11322.3 11342.5 11356.6 523029.0 575831.0 577590.0 595663.0 629649.0 130010.3 131198.0 131653.0 134348.0 135983.0 848.1 883.4 938.8 1027.3 1030.1 19057.1 19708.5 19798.0 19850.0 19894.6 54755.0 54834.7 56212.7 56218.7 56702.0 83346.6 84280.6 84376.6 85214.6 87419.0 6060.5 6983.5 7344.5 7439.7 8023.1 9940.9 12398.8 12809.5 12886.7 13271.8 10878.8 11035.9 11097.7 11386.0 11397.3 10763.9 10869.5 10920.6 10998.3 11323.3 9413.7 10850.4 11256.3 11266.3 11510.0 6951.8 7294.7 7373.7 7421.7 7454.1 8390.3 9215.8 10962.7 11086.4 11298.2 22:24:56 INFO - PROCESS | 1657 | 22:24:56 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5782.38 Median:4839.48 stddev:3255.20 (67.3%) stddev-sans-first:3247.87 22:24:56 INFO - PROCESS | 1657 | Values: 1426.7 1507.2 1698.1 1792.7 1842.1 8101.5 8350.5 8596.3 9151.7 9202.1 8589.8 8914.7 8921.0 8962.6 8970.4 2380.2 2404.1 2406.6 2407.2 2407.7 2061.3 2334.5 2391.1 2405.3 2410.0 2377.1 2389.0 2394.2 2404.4 2407.5 2355.6 2364.9 2371.8 2376.7 2388.2 2358.0 2370.5 2371.3 2378.3 2382.8 7639.4 8247.4 8761.6 8952.4 9049.7 5286.5 5339.3 5388.6 5401.9 5422.4 3054.8 3055.3 3673.4 3681.5 3713.5 1080.6 1101.5 1102.3 1120.3 1124.4 11845.8 11901.0 11923.2 11996.8 12091.8 4793.3 4833.6 4842.5 4929.1 4941.2 8472.4 8855.0 10106.6 10232.4 10300.4 5356.2 5375.1 5377.1 5380.2 5398.4 4359.6 4508.3 4768.5 4911.8 4914.5 4026.6 4032.4 4124.2 4158.9 4162.5 1328.9 1332.6 1334.6 1339.6 1344.0 768.9 883.2 905.4 907.7 932.0 5852.3 5880.9 5983.9 6001.2 6215.2 922.6 959.3 987.9 993.4 1015.8 3820.2 3885.7 4013.5 4029.3 4065.5 8674.2 11096.1 11101.9 11125.3 11157.7 11066.8 11078.1 11078.3 11100.9 11124.9 8392.8 8448.3 8519.6 8527.2 8539.3 5781.0 5989.6 6036.1 6060.3 6071.4 9772.3 10063.8 10181.4 10224.2 10392.9 10290.0 10398.5 10412.7 10449.2 10455.9 7045.2 7257.3 7629.4 7657.0 7783.2 8383.7 8580.6 8587.4 8594.5 8606.1 7585.6 7688.1 7747.8 7826.9 7836.1 7462.6 7561.5 7570.5 7570.7 7711.3 7086.1 7232.2 7240.1 7245.9 7266.8 4836.4 4900.5 4933.9 4945.9 5018.4 4363.7 4384.3 4667.7 5051.9 5213.5 22:24:56 INFO - PROCESS | 1657 | 22:24:56 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4312.50 Median:4678.13 stddev:1306.63 (27.9%) stddev-sans-first:1274.27 22:24:56 INFO - PROCESS | 1657 | Values: 252.7 301.1 311.1 313.6 315.0 4275.7 4557.1 4740.7 4972.4 5160.6 5258.3 5393.7 5498.3 5502.5 5522.6 3642.3 4162.5 4173.5 4180.9 4209.5 3882.4 4117.3 4209.1 4210.2 4215.7 4076.6 4084.5 4110.6 4113.5 4137.9 3278.9 4023.7 4118.5 4133.0 4149.3 2823.5 3535.6 3544.4 3555.4 3569.8 4660.3 4828.8 4968.8 5352.5 5372.9 4693.5 4699.1 4716.4 4726.5 4734.5 4482.4 5138.7 5778.6 5825.9 5864.5 3600.0 3804.2 3829.9 3872.2 3896.5 5113.0 5752.0 6041.6 6103.0 6124.5 3438.5 3910.6 3911.2 3938.8 3951.6 3673.7 3682.4 3831.4 3953.4 4063.8 3916.0 4422.4 4617.0 4655.8 4696.3 5024.8 5086.6 5682.5 5684.4 5794.9 1284.3 1324.1 1380.2 1410.2 1411.0 873.3 895.1 967.9 969.4 973.6 3645.1 3967.5 4059.5 4092.5 4573.9 4162.8 4428.9 4450.1 4775.4 5037.3 3776.7 4352.5 4454.9 4504.9 4582.6 2433.9 2456.4 2585.1 2611.7 2614.4 4663.8 4864.3 5054.9 5150.9 5160.6 4258.4 4876.7 4987.6 5092.9 5113.4 4562.7 4629.3 4896.7 4930.7 5152.5 4928.5 4932.5 4962.3 4963.8 5023.0 3971.6 4142.3 4607.3 4678.9 4906.6 4577.2 4741.1 4772.5 5114.0 5125.0 3061.8 3368.9 3519.0 3566.3 3612.8 4939.4 4968.0 4984.4 5021.6 5671.6 4677.4 4805.0 4821.9 5526.1 5734.2 5779.5 5783.4 5791.9 5800.4 5811.7 4704.0 4944.2 5399.9 5687.4 5736.7 5465.9 5792.4 5816.9 5827.3 5843.4 4614.7 5562.3 5709.1 5722.4 5730.4 22:24:56 INFO - PROCESS | 1657 | 22:24:56 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:24361.63 Median:3573.02 stddev:39215.35 (1097.5%) stddev-sans-first:39284.88 22:24:56 INFO - PROCESS | 1657 | Values: 633.2 726.4 736.2 769.5 775.4 15026.0 15414.5 15611.9 15612.5 15639.5 12853.6 14139.7 14248.9 14260.5 14289.1 673.9 692.1 841.7 873.7 878.5 861.6 861.9 863.4 864.0 866.3 841.5 920.9 922.3 928.4 929.8 894.7 912.4 916.7 916.7 918.0 676.2 677.3 684.8 685.3 690.1 12678.3 14675.2 14760.9 14775.1 14789.1 14027.4 14485.4 14550.5 14664.6 14682.0 11514.3 11928.9 11943.7 11948.3 12365.2 3749.2 3793.4 3809.1 3865.7 3993.1 113972.4 114567.0 120238.0 120248.4 121624.4 10963.6 11018.7 11106.6 11155.4 11207.8 22242.8 22253.0 22298.7 22316.0 22334.0 7625.5 7901.0 8010.2 8033.6 8196.7 4338.3 4364.6 4451.0 4551.0 4587.6 3449.1 3568.9 3569.9 3576.2 3583.9 647.3 654.9 659.3 671.2 675.7 574.4 613.7 617.6 670.7 707.0 9018.4 9324.8 9448.5 9535.4 9721.0 548.8 576.7 602.3 639.7 643.4 4596.5 4600.9 4607.9 4648.9 4721.9 95356.0 99857.5 161209.0 165078.2 165747.0 82468.0 143253.0 144667.3 146122.0 148513.0 86961.6 101646.0 102975.9 107388.0 107636.0 9460.3 9647.0 9990.1 10033.1 10049.5 48554.3 60297.0 60682.4 61332.7 62722.7 62165.0 86589.0 88785.6 90911.6 94073.0 11893.6 11899.6 11977.1 12114.5 12375.7 14190.6 14423.0 14708.9 14924.1 14996.2 13294.8 13516.5 13684.2 13841.7 14369.1 12903.3 13396.6 13689.8 13801.5 13969.9 12025.8 12823.6 13377.1 13440.0 13640.5 10795.4 11210.9 11271.9 11550.0 11620.2 11404.7 11451.4 11519.4 11575.9 11634.4 22:24:56 INFO - PROCESS | 1657 | -------- Summary: end -------- 22:24:56 INFO - PROCESS | 1657 | 22:24:56 INFO - TEST-INFO | 1657: exit 0 22:24:56 INFO - TEST-OK | dromaeo_css | took 1114259ms 22:24:56 INFO - TEST-START | kraken 22:24:56 INFO - operating with platform_type : mac_ 22:24:56 INFO - Initialising browser for kraken test... 22:24:56 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmpGoB6w_/profile http://localhost:49275/getInfo.html) 22:24:59 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 22:24:59 INFO - PROCESS | 1668 | colorDepth:24 22:24:59 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 22:24:59 INFO - PROCESS | 1668 | __metrics 22:24:59 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 22:25:00 INFO - TEST-INFO | 1668: exit 0 22:25:00 INFO - Browser initialized. 22:25:00 INFO - Running cycle 1/1 for kraken test... 22:25:00 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmpGoB6w_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:25:12 INFO - PROCESS | 1670 | RSS: Main: 226095104 22:25:12 INFO - PROCESS | 1670 | 22:25:15 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 22:25:16 INFO - PROCESS | 1670 | RSS: Main: 238301184 22:25:16 INFO - PROCESS | 1670 | 22:25:18 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 22:25:19 INFO - PROCESS | 1670 | RSS: Main: 245706752 22:25:19 INFO - PROCESS | 1670 | 22:25:22 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 22:25:23 INFO - PROCESS | 1670 | RSS: Main: 249421824 22:25:23 INFO - PROCESS | 1670 | 22:25:25 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 22:25:25 INFO - PROCESS | 1670 | RSS: Main: 249643008 22:25:25 INFO - PROCESS | 1670 | 22:25:27 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:25:28 INFO - PROCESS | 1670 | RSS: Main: 250998784 22:25:28 INFO - PROCESS | 1670 | 22:25:31 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 22:25:31 INFO - PROCESS | 1670 | RSS: Main: 251998208 22:25:31 INFO - PROCESS | 1670 | 22:25:34 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 22:25:35 INFO - PROCESS | 1670 | RSS: Main: 251998208 22:25:35 INFO - PROCESS | 1670 | 22:25:38 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 22:25:39 INFO - PROCESS | 1670 | RSS: Main: 252456960 22:25:39 INFO - PROCESS | 1670 | 22:25:40 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:25:41 INFO - PROCESS | 1670 | RSS: Main: 251445248 22:25:41 INFO - PROCESS | 1670 | 22:25:43 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:25:43 INFO - PROCESS | 1670 | RSS: Main: 251531264 22:25:43 INFO - PROCESS | 1670 | 22:25:45 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:25:46 INFO - PROCESS | 1670 | RSS: Main: 251437056 22:25:46 INFO - PROCESS | 1670 | 22:25:49 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:25:50 INFO - PROCESS | 1670 | RSS: Main: 251535360 22:25:50 INFO - PROCESS | 1670 | 22:25:53 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:25:53 INFO - PROCESS | 1670 | RSS: Main: 251908096 22:25:53 INFO - PROCESS | 1670 | 22:25:55 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 22:25:55 INFO - PROCESS | 1670 | RSS: Main: 253571072 22:25:55 INFO - PROCESS | 1670 | 22:25:55 INFO - PROCESS | 1670 | __start_tp_report 22:25:55 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 22:25:55 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 22:25:55 INFO - PROCESS | 1670 | |i|pagename|runs| 22:25:55 INFO - PROCESS | 1670 | |0;ai-astar;107;176;168;117;120;117;117;119;117;118 22:25:55 INFO - PROCESS | 1670 | |1;audio-beat-detection;143;111;112;141;109;113;110;112;136;112 22:25:55 INFO - PROCESS | 1670 | |2;audio-dft;223;229;198;197;227;280;202;198;192;198 22:25:55 INFO - PROCESS | 1670 | |3;audio-fft;81;59;60;83;59;60;58;58;77;59 22:25:55 INFO - PROCESS | 1670 | |4;audio-oscillator;80;70;89;70;72;78;109;89;104;119 22:25:55 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;89;86;88;86;89;86;89;92;88;83 22:25:55 INFO - PROCESS | 1670 | |6;imaging-darkroom;95;96;117;95;128;151;110;151;149;94 22:25:55 INFO - PROCESS | 1670 | |7;imaging-desaturate;91;91;99;91;83;144;144;90;92;91 22:25:55 INFO - PROCESS | 1670 | |8;json-parse-financial;55;55;56;56;58;59;59;58;57;58 22:25:55 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;68;76;72;81;77;73;69;75;69;68 22:25:55 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;85;86;84;87;82;83;83;84;78;87 22:25:55 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;156;141;148;154;162;144;143;144;173;157 22:25:55 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;165;168;164;161;158;212;229;211;164;164 22:25:55 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;69;68;65;70;84;92;74;67;68;64 22:25:55 INFO - PROCESS | 1670 | __end_tp_report 22:25:55 INFO - PROCESS | 1670 | __start_cc_report 22:25:55 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,951 22:25:55 INFO - PROCESS | 1670 | __end_cc_report 22:25:55 INFO - PROCESS | 1670 | __startTimestamp1479104755742__endTimestamp 22:25:55 INFO - PROCESS | 1670 | 22:25:55 INFO - PROCESS | 1670 | ------- Summary: start ------- 22:25:55 INFO - PROCESS | 1670 | Number of tests: 14 22:25:55 INFO - PROCESS | 1670 | 22:25:55 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:127.60 Median:118.50 stddev:23.74 (20.0%) stddev-sans-first:23.98 22:25:55 INFO - PROCESS | 1670 | Values: 107.0 176.0 168.0 117.0 120.0 117.0 117.0 119.0 117.0 118.0 22:25:55 INFO - PROCESS | 1670 | 22:25:55 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:119.90 Median:112.50 stddev:14.02 (12.5%) stddev-sans-first:12.12 22:25:55 INFO - PROCESS | 1670 | Values: 143.0 111.0 112.0 141.0 109.0 113.0 110.0 112.0 136.0 112.0 22:25:55 INFO - PROCESS | 1670 | 22:25:55 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:214.40 Median:212.50 stddev:26.90 (12.7%) stddev-sans-first:28.36 22:25:55 INFO - PROCESS | 1670 | Values: 223.0 229.0 198.0 197.0 227.0 280.0 202.0 198.0 192.0 198.0 22:25:55 INFO - PROCESS | 1670 | 22:25:55 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:65.40 Median:60.00 stddev:10.43 (17.4%) stddev-sans-first:9.41 22:25:55 INFO - PROCESS | 1670 | Values: 81.0 59.0 60.0 83.0 59.0 60.0 58.0 58.0 77.0 59.0 22:25:55 INFO - PROCESS | 1670 | 22:25:55 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:88.00 Median:75.00 stddev:17.41 (23.2%) stddev-sans-first:18.22 22:25:55 INFO - PROCESS | 1670 | Values: 80.0 70.0 89.0 70.0 72.0 78.0 109.0 89.0 104.0 119.0 22:25:55 INFO - PROCESS | 1670 | 22:25:55 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:88.50 stddev:2.46 (2.8%) stddev-sans-first:2.55 22:25:55 INFO - PROCESS | 1670 | Values: 89.0 86.0 88.0 86.0 89.0 86.0 89.0 92.0 88.0 83.0 22:25:55 INFO - PROCESS | 1670 | 22:25:55 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:118.60 Median:122.50 stddev:24.54 (20.0%) stddev-sans-first:24.49 22:25:55 INFO - PROCESS | 1670 | Values: 95.0 96.0 117.0 95.0 128.0 151.0 110.0 151.0 149.0 94.0 22:25:55 INFO - PROCESS | 1670 | 22:25:55 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:101.60 Median:91.00 stddev:22.67 (24.9%) stddev-sans-first:23.72 22:25:55 INFO - PROCESS | 1670 | Values: 91.0 91.0 99.0 91.0 83.0 144.0 144.0 90.0 92.0 91.0 22:25:55 INFO - PROCESS | 1670 | 22:25:55 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:58.00 stddev:1.52 (2.6%) stddev-sans-first:1.41 22:25:55 INFO - PROCESS | 1670 | Values: 55.0 55.0 56.0 56.0 58.0 59.0 59.0 58.0 57.0 58.0 22:25:55 INFO - PROCESS | 1670 | 22:25:55 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:72.80 Median:74.00 stddev:4.42 (6.0%) stddev-sans-first:4.33 22:25:55 INFO - PROCESS | 1670 | Values: 68.0 76.0 72.0 81.0 77.0 73.0 69.0 75.0 69.0 68.0 22:25:55 INFO - PROCESS | 1670 | 22:25:55 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.50 stddev:2.69 (3.2%) stddev-sans-first:2.82 22:25:55 INFO - PROCESS | 1670 | Values: 85.0 86.0 84.0 87.0 82.0 83.0 83.0 84.0 78.0 87.0 22:25:55 INFO - PROCESS | 1670 | 22:25:55 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:152.20 Median:155.00 stddev:10.17 (6.6%) stddev-sans-first:10.70 22:25:55 INFO - PROCESS | 1670 | Values: 156.0 141.0 148.0 154.0 162.0 144.0 143.0 144.0 173.0 157.0 22:25:55 INFO - PROCESS | 1670 | 22:25:55 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.60 Median:166.50 stddev:26.60 (16.0%) stddev-sans-first:27.68 22:25:55 INFO - PROCESS | 1670 | Values: 165.0 168.0 164.0 161.0 158.0 212.0 229.0 211.0 164.0 164.0 22:25:55 INFO - PROCESS | 1670 | 22:25:55 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:69.50 stddev:9.01 (13.0%) stddev-sans-first:9.49 22:25:55 INFO - PROCESS | 1670 | Values: 69.0 68.0 65.0 70.0 84.0 92.0 74.0 67.0 68.0 64.0 22:25:55 INFO - PROCESS | 1670 | -------- Summary: end -------- 22:25:55 INFO - PROCESS | 1670 | 22:25:56 INFO - TEST-INFO | 1670: exit 0 22:25:56 INFO - TEST-OK | kraken | took 59708ms 22:25:56 INFO - SUITE-END | took 1173s 22:25:56 INFO - Completed test suite (00:19:34) 22:25:56 INFO - javascript benchmark 22:25:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7249.897299659585, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3424.606170290417, 3432.2792213635134, 3453.9309213815723, 3462.376772181008, 3464.133966508373, 5762.1356796480495, 5776.4223577642215, 5796.188533605298, 5803.01348770709, 5869.853253668661, 5749.827505174841, 5754.798582049629, 5824.417558244173, 5832.387599302076, 5848.532117430606, 4963.726995015273, 5234.895302093956, 5322.2814919985885, 5366.973165134169, 5373.6775793452325, 5342.759575819078, 5393.83818485446, 5393.83818485446, 5400.108982017982, 5407.83776486704, 5258.789648414059, 5263.657862238962, 5353.518183363496, 5368.62419630626, 5397.974384866882, 4346.587074227943, 5246.790128394879, 5255.343082114736, 5335.306410166692, 5401.70290634015, 5197.324347834758, 5239.70115697218, 5251.133562962106, 5263.105272103751, 5311.840644780663, 5614.382417934024, 5782.103773915008, 5815.185873977646, 5900.940990590082, 5926.1110833374905, 6126.908096378558, 6153.907691384633, 6202.968985155046, 6206.038064100072, 6209.472194863442, 6249.531285153586, 6271.435570798604, 6295.2760432550385, 6299.149614801989, 6331.240251169889, 5909.6158749681135, 5917.733701983421, 5926.555508336892, 5931.466168044896, 5970.76116955317, 6196.845078872974, 6239.781607643801, 6242.75028998844, 6247.156633854372, 6256.906146407808, 5388.868337649059, 5873.559483038789, 5996.610220335664, 6172.074188871616, 6182.258129024546, 4591.989762252299, 5674.829755107354, 5868.325142608569, 6306.211723534559, 6317.526185536103, 4764.523547645208, 5471.398146203915, 5823.912641310384, 6143.573288550997, 6166.568340216231, 5444.782208711607, 5941.1385349125, 6221.351341894401, 6229.3770622937345, 6292.0, 4941.851744447672, 4954.455009948902, 4956.826511072095, 4966.925496117561, 5002.274670172805, 4376.431063961664, 4382.496012958487, 4412.426384569985, 4423.867283981485, 4429.534898835575, 5917.911231331534, 5921.61509501881, 5924.11138329254, 5952.166696662471, 5952.434518720715, 5199.922001169985, 6246.250449945945, 6299.149614802035, 6303.747850086037, 6327.17746692927, 5716.171155182476, 5726.112452569859, 5739.253896993364, 5784.913226301609, 5803.390643982406, 5405.297311349499, 5410.08028635133, 5411.56707463402, 5428.864278392993, 5465.808696695676, 6269.5611307208055, 6300.0234963580715, 6301.054841773771, 6301.275353334334, 6335.239771227482, 6154.892119418548, 6239.563230573816, 6246.46905013079, 6249.843753906189, 6276.058591211355, 6252.5935814171935, 6378.840528986812, 6388.776392826228, 6392.137061496638, 6417.935820641734, 6199.690015499297, 6248.250209974832, 6269.0909818075215, 6276.403741644536, 6311.179546658905, 5209.817656382009, 6122.459144589226, 6335.873282534416, 6354.951433013501, 6361.109444677656, 5050.72221027847, 5871.178035075008, 5878.529717622494, 5919.7040147991565, 5984.281886173687, 5536.837264174568, 5864.67744274069, 5928.3775203603, 5942.524598032233, 5975.731092100779, 5716.0, 5778.8266352009505, 5799.3040835100055, 5822.0, 5822.970885145547, 6087.9391206087375, 6108.847278818065, 6116.785912493041, 6144.815655530341, 6170.382961703794, 5934.881302373842, 5975.910361344497, 5989.940100599112, 6023.427774361428, 6030.185924900083], "value": 5675.818505173098, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.6196081174249, 484.5590512633504, 487.8195067824903, 492.8098641780101, 519.5350161605363, 33265.83367083161, 40511.58209462669, 41013.384799228, 44784.776076119575, 44849.32726009112, 39456.80271598638, 44339.0, 44699.55300446995, 44775.77612111943, 44920.203191872286, 8408.537530435824, 8588.312934965219, 8694.73915782526, 9179.127982841619, 9940.40357578544, 9784.461854597994, 9856.507174641276, 9866.901330986706, 9876.703698889045, 9887.456189909552, 9832.410055396664, 9879.456629885353, 9889.703308900709, 9907.108360247576, 9916.867873407216, 9815.558299876488, 9848.2613803965, 9858.014198580157, 9883.357581757164, 9884.061014203675, 9777.120059194707, 9869.506524673809, 9871.851922221173, 9877.654282100091, 9885.505724713807, 34501.654983450346, 42451.78774106141, 42534.361984570256, 42623.36064959028, 42689.57310426887, 3335.5663763710804, 3377.932441351159, 3482.9129271768156, 3541.645835416438, 3565.910852228715, 26383.076592319176, 29975.700242997726, 30020.399592008038, 30137.246568835955, 30252.243693907607, 3229.450993331139, 3281.96718032819, 3306.5205545196054, 3309.652486488908, 3325.251818340854, 527927.0, 533699.0, 535724.0, 535934.0, 536339.6366036328, 33554.328913421596, 56199.71900140473, 57220.71389643109, 62357.68821155956, 62591.06113408302, 34346.82826585901, 35561.93314200578, 35854.82072589621, 35954.0, 35984.10039749027, 14851.851481485262, 14967.877409194354, 14991.17548534841, 14993.0, 15043.247837608076, 12739.42672579736, 12781.785730355787, 12850.871491285154, 12895.742085158432, 12903.225806451643, 7687.077550693953, 7811.062672479339, 7860.449768516263, 7889.408294377945, 7908.683652653829, 3262.967370326314, 3282.0646115856866, 3289.8190599517256, 3289.967100328966, 3317.7014068733447, 881.7398867334024, 913.9360244782802, 998.6554638649654, 1040.4121671255716, 1079.7474929082384, 30337.544936825965, 30673.69326306753, 30696.386072278878, 30702.53946190809, 31087.689123108932, 1017.308230403318, 1025.8717660292464, 1050.7181238888543, 1065.898739619735, 1095.8684957804956, 15382.615434614001, 15691.0, 15849.683006339808, 15995.920020399824, 16171.67656646884, 703299.0, 707167.0, 712874.0, 713816.0, 717526.0, 59724.0, 60067.39932600706, 60226.69886650539, 60337.79324413575, 60669.39330606638, 1356.4845358763805, 1358.6331690443526, 1397.1407584335561, 1397.6925076483158, 1400.3698335749157, 29659.665315061306, 30496.932607358634, 30577.0, 30769.846150769103, 30822.383552329276, 44714.0, 49473.25790113223, 51586.0, 51841.48158518367, 52009.21986170286, 614819.0, 618354.0, 618364.0, 618783.0, 621259.0, 27029.86485067562, 27123.321916952234, 27359.72640273572, 27598.034068807494, 27601.86199068992, 41969.37045944252, 43603.781981089895, 47848.52151478441, 51708.224376633625, 52795.736021319644, 30625.23436914095, 32587.674123258465, 38632.6136738629, 40080.99797504969, 40822.59177408188, 40398.38406463709, 40667.59332406638, 40755.7962210187, 41641.375379369936, 42192.78903605462, 38729.80635096919, 39440.80279598584, 39618.60381396149, 39712.404313934734, 41309.96725081897, 32641.836790815894, 35930.0, 36193.81903090468, 36404.81797591101, 36566.63433365632, 21922.561548769256, 25297.87351063233, 26474.602880957187, 26723.599146013214, 26770.19689409321], "value": 18970.179072560186, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.26418634358595, 366.6736604422065, 374.4888227569369, 381.4665046513016, 390.1961958365767, 20029.799702002976, 20800.271990480338, 21134.365969020935, 21590.676139857915, 21765.564688706258, 20297.594048119066, 20349.898250508762, 20356.898215508903, 20456.488587785312, 20760.584788304226, 5787.913181302263, 5934.228550288467, 6059.878802423949, 6138.938610613904, 6191.226096737908, 3857.6720978716844, 4061.57353477885, 6076.6050206736645, 6108.175396321484, 6118.4799292060225, 5819.418058194168, 6092.786752463665, 6122.112293717409, 6169.29053158888, 6182.969085154568, 5973.970130149343, 6055.666938318391, 6072.180255665517, 6104.81685549432, 6166.3525329840395, 5874.559408044371, 5874.97062514689, 5876.177335173079, 5880.70596470179, 5891.410858914117, 24387.634185487233, 24465.143719969714, 24820.25539233826, 25350.74649253502, 25808.0, 2164.350694791556, 2322.5587138443643, 2533.2526904563197, 2894.3343031102754, 2980.7913446058783, 9747.415155090717, 9863.210943124604, 9875.703728888146, 10107.39355638664, 14665.193414362206, 1883.8775479593783, 1956.0610906764691, 1956.6967120096408, 1966.7148263501856, 2006.7591888973416, 104298.47850760774, 108470.0, 111764.4411777944, 113995.43002284935, 124237.37881310536, 9399.90600094004, 11065.944670276596, 11231.494582743797, 11570.537178512934, 11772.646820595395, 14530.0, 14567.834573234115, 14577.125372477685, 14605.415783368759, 14638.707225855636, 7340.082489688789, 8347.874781878276, 8387.958060209781, 8584.484930904166, 8736.519491428033, 8499.107593702696, 8586.398952073296, 8594.183552562497, 8708.346873984476, 8727.389082764146, 4435.534268901783, 4500.572445617661, 4513.954860451419, 4579.519150489217, 4588.587027167571, 1642.523668136251, 1688.4765722626025, 1767.6729804985862, 1803.2426380920044, 1951.4438385060473, 773.6634563964693, 969.4425705219527, 973.73709098543, 989.1295659819313, 1014.4217795856291, 19190.712139317922, 21303.78696213049, 21322.14394734102, 21672.89163554172, 21832.672509912365, 900.2392977933636, 909.3725329522608, 923.1368670293298, 924.2698268368049, 925.8519435899436, 8548.615312310962, 11307.0, 11322.32066076038, 11342.489587968561, 11356.602518911799, 523029.0, 575831.0, 577590.0, 595663.0, 629649.0, 130010.34994824966, 131198.0, 131653.0, 134348.0, 135983.0, 848.117957324388, 883.3860466975391, 938.8310104181313, 1027.2655051638114, 1030.1398332392387, 19057.14242859047, 19708.50728731793, 19798.0, 19850.0, 19894.60210795805, 54754.98847563422, 54834.72582637061, 56212.71893640506, 56218.71890640521, 56702.0, 83346.58326708328, 84280.57859710662, 84376.57811710902, 85214.57392712997, 87419.0, 6060.545459090674, 6983.476239282176, 7344.522606030805, 7439.665215065444, 8023.077346105272, 9940.850887236842, 12398.81401778992, 12809.487620495076, 12886.67783305425, 13271.800922986356, 10878.836817447585, 11035.889641103486, 11097.667069987914, 11386.032187263843, 11397.316161030365, 10763.94618026905, 10869.456527173768, 10920.617778378037, 10998.285111467729, 11323.32060076398, 9413.670521531714, 10850.40322782223, 11256.324620522795, 11266.267692599955, 11510.02164816, 6951.7914462566205, 7294.708211671474, 7373.668184931798, 7421.703131874665, 7454.142773581108, 8390.286825619647, 9215.76960575991, 10962.725931851448, 11086.445677716243, 11298.152638551977], "value": 9537.922713189873, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.743186226479, 1507.2011833728125, 1698.0745493705938, 1792.704203806372, 1842.0881663576524, 8101.513909165455, 8350.540720260384, 8596.3122950164, 9151.725448236546, 9202.125798049183, 8589.785255368619, 8914.687985920495, 8920.95539522303, 8962.596683149257, 8970.416922900024, 2380.214529205367, 2404.0984630763464, 2406.5547873643345, 2407.205622144697, 2407.687000689908, 2061.2785525066256, 2334.5447637710654, 2391.1033362489065, 2405.254371144942, 2409.999850062231, 2377.1442280778992, 2389.0, 2394.221877889684, 2404.362843846382, 2407.4944261705064, 2355.552445035438, 2364.869932153731, 2371.7746814052725, 2376.7147942246957, 2388.199953015742, 2357.97642023581, 2370.4903445759073, 2371.2886134159858, 2378.250850981935, 2382.833201675883, 7639.388848892076, 8247.391758607075, 8761.561921903944, 8952.373333866632, 9049.728508144766, 5286.497782710637, 5339.252504649352, 5388.649737767033, 5401.945980540223, 5422.40353561108, 3054.7708921830954, 3055.3278278778857, 3673.3938900081453, 3681.4845921571, 3713.535808023997, 1080.5569716416232, 1101.4878081692052, 1102.2584316779469, 1120.3278033180109, 1124.4377811094453, 11845.822312665317, 11900.988415984652, 11923.165378423513, 11996.760064798655, 12091.818622720666, 4793.281007848781, 4833.564979151894, 4842.539958703917, 4929.112759703216, 4941.234108713155, 8472.364572657076, 8855.0, 10106.646267380607, 10232.437215953194, 10300.433476158732, 5356.1697936819855, 5375.113106337489, 5377.112776391929, 5380.219868119101, 5398.352197736297, 4359.564043595678, 4508.256137737237, 4768.523147685273, 4911.7544122793715, 4914.483979182206, 4026.6174713402766, 4032.3749818778138, 4124.237016152021, 4158.91682166355, 4162.4796900387455, 1328.920264784116, 1332.5669157523844, 1334.5796074236584, 1339.55125033115, 1344.025581453458, 768.9192634773381, 883.1698203688512, 905.3843386497246, 907.7458311672742, 931.9580618872031, 5852.297724273029, 5880.882382352329, 5983.910241346383, 6001.189839371629, 6215.160953271341, 922.5710044829186, 959.29971121082, 987.8863930647924, 993.380789313429, 1015.827309357411, 3820.178661587772, 3885.6502914737807, 4013.458183145238, 4029.2545879012478, 4065.4738488046, 8674.219320261207, 11096.056835169102, 11101.945315195044, 11125.332480051062, 11157.66527004191, 11066.833997490045, 11078.0583650389, 11078.279911805706, 11100.888991109985, 11124.944375278234, 8392.832143357098, 8448.281896038905, 8519.57402129891, 8527.23254907049, 8539.316854651614, 5781.0, 5989.580729349078, 6036.124761909411, 6060.272767267779, 6071.39286071407, 9772.26707996889, 10063.798724025331, 10181.440020798927, 10224.23318251149, 10392.948035260079, 10289.97100289965, 10398.480075996322, 10412.68761937143, 10449.21630877672, 10455.94772026135, 7045.225025247321, 7257.310555497219, 7629.389648828192, 7656.966309548363, 7783.221677832172, 8383.66465341404, 8580.613872375883, 8587.441816281922, 8594.484330940164, 8606.053334133365, 7585.582792946441, 7688.077430708351, 7747.767566973, 7826.882596760939, 7836.059672839067, 7462.589557574385, 7561.508501947355, 7570.545767253982, 7570.735024274124, 7711.344535714303, 7086.078809754699, 7232.240614735588, 7240.1311842579225, 7245.855082898418, 7266.781996540112, 4836.419629644465, 4900.534449227318, 4933.925991110064, 4945.851624451272, 5018.44797072329, 4363.650907927295, 4384.298512238027, 4667.673262871566, 5051.87370315745, 5213.478652134756], "value": 4646.8746874398785, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [252.69423996963675, 301.1417460238321, 311.1272879572798, 313.6346156727413, 315.04698287679753, 4275.722078064931, 4557.086023869974, 4740.668153229275, 4972.378452693409, 5160.587153027758, 5258.342707161605, 5393.703346315951, 5498.285222921015, 5502.477264659851, 5522.641028333155, 3642.3079614873222, 4162.500499939996, 4173.499180098385, 4180.874573762792, 4209.548170500191, 3882.437046628237, 4117.341225403936, 4209.116085622023, 4210.157968406315, 4215.702442169025, 4076.5923407659293, 4084.530279017906, 4110.609492098246, 4113.4858142732155, 4137.8758637240935, 3278.918027049319, 4023.7325242548504, 4118.485189351331, 4133.0, 4149.33610622299, 2823.5200015997125, 3535.611082780892, 3544.379733546619, 3555.3955827509385, 3569.7679650822615, 4660.347551342815, 4828.782704778258, 4968.826091086795, 5352.5182733553775, 5372.925414916993, 4693.530646935314, 4699.107169637758, 4716.363290955712, 4726.503717109723, 4734.479207287196, 4482.417285752864, 5138.7173705446185, 5778.59549831512, 5825.863956528478, 5864.481311213281, 3600.021812305129, 3804.2201348723447, 3829.9360511590894, 3872.2255548890053, 3896.49345585075, 5113.008889799472, 5751.971240143815, 6041.6375017499095, 6102.962496375582, 6124.540659450559, 3438.5014172944784, 3910.550286717064, 3911.2373087248284, 3938.822752976123, 3951.577432124433, 3673.687736542424, 3682.4476328550395, 3831.425286207091, 3953.438391835209, 4063.817128229237, 3915.980420097881, 4422.402975598253, 4616.95383046172, 4655.767211639404, 4696.272077827942, 5024.824131155465, 5086.593072554187, 5682.545396368363, 5684.403137670568, 5794.88410231793, 1284.2872205925614, 1324.1194605587368, 1380.2477649680948, 1410.1597415372833, 1410.978835317471, 873.323174539724, 895.1247137247456, 967.8935317115112, 969.418348990614, 973.6466311826566, 3645.143391303042, 3967.5238971323624, 4059.5331536873045, 4092.4679791627495, 4573.885652858705, 4162.791860406967, 4428.8997701609005, 4450.062958447474, 4775.4451368517675, 5037.279868870769, 3776.7167462440425, 4352.455943007124, 4454.933176002362, 4504.864854054318, 4582.631765652243, 2433.8904749286326, 2456.3736247256834, 2585.0883321688943, 2611.7257687942874, 2614.41175735458, 4663.766811659403, 4864.270359446112, 5054.887924656569, 5150.922736158961, 5160.612954028463, 4258.424382978318, 4876.683015603974, 4987.62592805541, 5092.872678183075, 5113.411957624847, 4562.749048802281, 4629.259318509023, 4896.706197628154, 4930.6795058321095, 5152.531528514505, 4928.457869634266, 4932.53140951609, 4962.305277261258, 4963.8262660806695, 5022.974885125551, 3971.5829837867764, 4142.343062774914, 4607.262837945913, 4678.883027924329, 4906.559563594952, 4577.185031205718, 4741.099191153669, 4772.498887616889, 5114.0, 5124.9743751281, 3061.7550595952716, 3368.865245390157, 3519.0498565387716, 3566.3045706087064, 3612.771657636311, 4939.382577177853, 4967.950320496893, 4984.37695288089, 5021.648484606042, 5671.602987790815, 4677.368555244999, 4804.95195048045, 4821.855344339676, 5526.148740172087, 5734.168545560954, 5779.537636988946, 5783.363829978614, 5791.9131213031, 5800.403749675228, 5811.709414529172, 4703.952960470351, 4944.181816364781, 5399.920015996895, 5687.374388817144, 5736.6558006519745, 5465.945340546703, 5792.364474164161, 5816.941830581809, 5827.310080076731, 5843.386444423274, 4614.723116613014, 5562.332520097614, 5709.143628455765, 5722.370539240764, 5730.424133363192], "value": 3909.6886055040873, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.1737083106544, 726.3825748114103, 736.2416710787887, 769.4536878816041, 775.3796962430055, 15026.0, 15414.460493882701, 15611.921940390283, 15612.453564125259, 15639.530814075582, 12853.614391568268, 14139.717205655881, 14248.857511424883, 14260.500882469116, 14289.07121037132, 673.9326067393258, 692.0622556436032, 841.7096101844854, 873.7029410000598, 878.4948654523643, 861.5993562993207, 861.8707193920931, 863.4301361101674, 863.9654413823439, 866.3112825303867, 841.4908980067063, 920.903305152956, 922.2898368256472, 928.4058202750246, 929.7954450020984, 894.7047474333486, 912.4251721415532, 916.7112359606735, 916.7387294621068, 917.9632814687404, 676.158183062086, 677.2888467109515, 684.7979845945458, 685.3454950522289, 690.0718533572337, 12678.302693351861, 14675.192864392455, 14760.852391476055, 14775.113493190443, 14789.11265324084, 14027.43890244389, 14485.42058317666, 14550.490732824406, 14664.560063198121, 14681.97226194156, 11514.251573647769, 11928.940355298255, 11943.701407464883, 11948.283103013848, 12365.196262242926, 3749.1751814600743, 3793.4499497572974, 3809.142942837867, 3865.729398942075, 3993.121513267077, 113972.4301378496, 114567.0, 120238.0, 120248.39875800653, 121624.39187804093, 10963.56145754161, 11018.724531886766, 11106.55573777056, 11155.386453745123, 11207.831882521768, 22242.777572224393, 22253.0, 22298.665520017214, 22315.99578018993, 22333.99497022638, 7625.475408365255, 7900.960495197487, 8010.158933312035, 8033.638486268132, 8196.672133114727, 4338.305871060616, 4364.648046029728, 4451.0, 4551.0, 4587.587117159472, 3449.085992212066, 3568.8750893718593, 3569.8572057117944, 3576.177479179751, 3583.910402239913, 647.3203136706439, 654.8788474132206, 659.3143131143653, 671.2012704881175, 675.6655455549535, 574.3681949855126, 613.736093479808, 617.5522746009108, 670.731707317077, 706.9752558660422, 9018.413803102778, 9324.813503730024, 9448.527573621292, 9535.427874327563, 9721.0, 548.7530611224964, 576.7087620751494, 602.3133627664466, 639.7057353617295, 643.3727116061802, 4596.49438561758, 4600.861974140714, 4607.9308810367875, 4648.930266046012, 4721.9055618888115, 95356.0, 99857.50071249742, 161209.0, 165078.17460912617, 165747.0, 82468.0, 143253.0, 144667.276663616, 146122.0, 148513.0, 86961.56519217363, 101646.0, 102975.94048118996, 107388.0, 107636.0, 9460.337776355589, 9647.035296470296, 9990.100890919852, 10033.14718248957, 10049.547770350206, 48554.27168592403, 60297.0, 60682.39317606767, 61332.69333653303, 62722.68638656777, 62165.0, 86588.96938607118, 88785.55607221923, 90911.63632545384, 94073.0, 11893.643190704293, 11899.583514576949, 11977.101717371406, 12114.454849531616, 12375.69060773452, 14190.574282771533, 14423.0, 14708.852911470749, 14924.104553726811, 14996.175210363535, 13294.800577991144, 13516.459341626618, 13684.247366394944, 13841.653958651113, 14369.06601070927, 12903.290319032543, 13396.598102056954, 13689.794653080013, 13801.51694690681, 13969.860301396857, 12025.759484810429, 12823.551175708806, 13377.130486518345, 13440.0, 13640.522581709592, 10795.40625265618, 11210.853365682044, 11271.943640281746, 11550.0, 11620.186586939171, 11404.714882128013, 11451.427428628702, 11519.366434845828, 11575.947222609864, 11634.36011019402], "value": 7781.949527335512, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 176.0, 168.0, 117.0, 120.0, 117.0, 117.0, 119.0, 117.0, 118.0], "value": 127.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 111.0, 112.0, 141.0, 109.0, 113.0, 110.0, 112.0, 136.0, 112.0], "value": 119.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [223.0, 229.0, 198.0, 197.0, 227.0, 280.0, 202.0, 198.0, 192.0, 198.0], "value": 214.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 60.0, 83.0, 59.0, 60.0, 58.0, 58.0, 77.0, 59.0], "value": 65.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 70.0, 89.0, 70.0, 72.0, 78.0, 109.0, 89.0, 104.0, 119.0], "value": 88.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 86.0, 89.0, 86.0, 89.0, 92.0, 88.0, 83.0], "value": 87.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 117.0, 95.0, 128.0, 151.0, 110.0, 151.0, 149.0, 94.0], "value": 118.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 99.0, 91.0, 83.0, 144.0, 144.0, 90.0, 92.0, 91.0], "value": 101.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 56.0, 58.0, 59.0, 59.0, 58.0, 57.0, 58.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 76.0, 72.0, 81.0, 77.0, 73.0, 69.0, 75.0, 69.0, 68.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 84.0, 87.0, 82.0, 83.0, 83.0, 84.0, 78.0, 87.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 141.0, 148.0, 154.0, 162.0, 144.0, 143.0, 144.0, 173.0, 157.0], "value": 152.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 168.0, 164.0, 161.0, 158.0, 212.0, 229.0, 211.0, 164.0, 164.0], "value": 179.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 65.0, 70.0, 84.0, 92.0, 74.0, 67.0, 68.0, 64.0], "value": 72.1, "unit": "score"}]}]} 22:25:57 INFO - Return code: 0 22:25:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:25:57 ERROR - # TBPL SUCCESS # 22:25:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:25:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:25:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:25:57 INFO - 2016-11-13 22:25:57.086 screenresolution[1675:10935] starting screenresolution argv=screenresolution get 22:25:57 INFO - 2016-11-13 22:25:57.089 screenresolution[1675:10935] Display 0: 1600x1200x32@60 22:25:57 INFO - 2016-11-13 22:25:57.095 screenresolution[1676:10938] starting screenresolution argv=screenresolution list 22:25:57 INFO - Available Modes on Display 0 22:25:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:25:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:25:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:25:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:25:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:25:57 INFO - Intel Iris: 22:25:57 INFO - Chipset Model: Intel Iris 22:25:57 INFO - Type: GPU 22:25:57 INFO - Bus: Built-In 22:25:57 INFO - VRAM (Dynamic, Max): 1536 MB 22:25:57 INFO - Vendor: Intel (0x8086) 22:25:57 INFO - Device ID: 0x0a2e 22:25:57 INFO - Revision ID: 0x0009 22:25:57 INFO - Displays: 22:25:57 INFO - Display: 22:25:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:25:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:25:57 INFO - Display Serial Number: 1600x1200 60 22:25:57 INFO - Main Display: Yes 22:25:57 INFO - Mirror: Off 22:25:57 INFO - Online: Yes 22:25:57 INFO - Rotation: Supported 22:25:57 INFO - Return code: 0 22:25:57 INFO - Running post-action listener: _resource_record_post_action 22:25:57 INFO - [mozharness: 2016-11-14 06:25:57.329617Z] Finished run-tests step (success) 22:25:57 INFO - Running post-run listener: _resource_record_post_run 22:25:57 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 37528576; Write bytes: 667223040; Read time: 237; Write time: 1953 22:25:57 INFO - TinderboxPrint: CPU usage
54.4% 22:25:57 INFO - TinderboxPrint: I/O read bytes / time
37,528,576 / 237 22:25:57 INFO - TinderboxPrint: I/O write bytes / time
667,223,040 / 1,953 22:25:57 INFO - TinderboxPrint: CPU idle
2,204.5 (45.6%) 22:25:57 INFO - TinderboxPrint: CPU system
971.9 (20.1%) 22:25:57 INFO - TinderboxPrint: CPU user
1,653.3 (34.2%) 22:25:57 INFO - TinderboxPrint: Swap in / out
400,990,208 / 0 22:25:57 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 360927744; Write bytes: 356145152; Read time: 27700; Write time: 750 22:25:57 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 35492864; Write bytes: 299977728; Read time: 216; Write time: 1167 22:25:57 INFO - Running post-run listener: _upload_blobber_files 22:25:57 INFO - Blob upload gear active. 22:25:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:25:57 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 22:25:57 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'] 22:25:57 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 22:25:58 INFO - (blobuploader) - INFO - Open directory for files ... 22:25:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:25:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:25:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:25:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:25:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:25:59 INFO - (blobuploader) - INFO - Done attempting. 22:25:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:25:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:25:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:26:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:26:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:26:00 INFO - (blobuploader) - INFO - Done attempting. 22:26:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:26:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:26:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:26:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:26:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:26:03 INFO - (blobuploader) - INFO - Done attempting. 22:26:03 INFO - (blobuploader) - INFO - Iteration through files over. 22:26:03 INFO - Return code: 0 22:26:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:26:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:26:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/65264ba5a73cd543af4d493d17689ca268fb2856092fee32792308c0884ac65c75851f08b20a57bc69c78ee9d2a0a26db158a28f7b42362f8ef435b01379fd61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39d52aa1c25616453fe5660c755abbe1174389d0ace35ccfd3715862ac3fd2b51e77e885cb9e94f3726e415769ab719831449e8c5fc17d8d5d4e915b425622da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c349f1dc5ef3b1f39385d9c6358b5a18301fabdf965dfefd581d7f25639fd3dda4a87f614886fc4393b45a24ae79fe99ee03654b3c6774557a49437215a8182"} 22:26:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:26:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:26:03 INFO - Contents: 22:26:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/65264ba5a73cd543af4d493d17689ca268fb2856092fee32792308c0884ac65c75851f08b20a57bc69c78ee9d2a0a26db158a28f7b42362f8ef435b01379fd61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39d52aa1c25616453fe5660c755abbe1174389d0ace35ccfd3715862ac3fd2b51e77e885cb9e94f3726e415769ab719831449e8c5fc17d8d5d4e915b425622da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c349f1dc5ef3b1f39385d9c6358b5a18301fabdf965dfefd581d7f25639fd3dda4a87f614886fc4393b45a24ae79fe99ee03654b3c6774557a49437215a8182"} 22:26:03 INFO - Running post-run listener: copy_logs_to_upload_dir 22:26:03 INFO - Copying logs to upload dir... 22:26:03 INFO - mkdir: /builds/slave/test/build/upload/logs 22:26:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.348768 ========= master_lag: 0.38 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-11-13 22:26:03.565299) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-13 22:26:03.568319) ========= 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.FtKJdh2zFC/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.JdzjZW6z25/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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/65264ba5a73cd543af4d493d17689ca268fb2856092fee32792308c0884ac65c75851f08b20a57bc69c78ee9d2a0a26db158a28f7b42362f8ef435b01379fd61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39d52aa1c25616453fe5660c755abbe1174389d0ace35ccfd3715862ac3fd2b51e77e885cb9e94f3726e415769ab719831449e8c5fc17d8d5d4e915b425622da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c349f1dc5ef3b1f39385d9c6358b5a18301fabdf965dfefd581d7f25639fd3dda4a87f614886fc4393b45a24ae79fe99ee03654b3c6774557a49437215a8182"} build_url:https://queue.taskcluster.net/v1/task/Xpxast4XTOKnFbremvm4nQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010988 build_url: 'https://queue.taskcluster.net/v1/task/Xpxast4XTOKnFbremvm4nQ/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/65264ba5a73cd543af4d493d17689ca268fb2856092fee32792308c0884ac65c75851f08b20a57bc69c78ee9d2a0a26db158a28f7b42362f8ef435b01379fd61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39d52aa1c25616453fe5660c755abbe1174389d0ace35ccfd3715862ac3fd2b51e77e885cb9e94f3726e415769ab719831449e8c5fc17d8d5d4e915b425622da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c349f1dc5ef3b1f39385d9c6358b5a18301fabdf965dfefd581d7f25639fd3dda4a87f614886fc4393b45a24ae79fe99ee03654b3c6774557a49437215a8182"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-13 22:26:03.601422) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 22:26:03.601709) ========= 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.FtKJdh2zFC/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.JdzjZW6z25/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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.004904 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 22:26:03.649478) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-13 22:26:03.649755) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-13 22:26:03.650049) ========= ========= Total master_lag: 0.52 =========