builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0090 starttime: 1467139284.51 results: success (0) buildid: 20160628092022 builduid: 473e175aabb640198c0553202ffc4580 revision: 4aeee4260fcd87d5616203937177dbe949a46dc9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 11:41:24.514461) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 11:41:24.515025) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 11:41:24.515327) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 11:41:24.542817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 11:41:24.543098) ========= 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.TCmctXps7E/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.d7n0cT1kPo/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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-06-28 11:41:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.1M=0.001s 2016-06-28 11:41:24 (16.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164347 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 11:41:24.735439) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 11:41:24.735753) ========= 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.TCmctXps7E/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.d7n0cT1kPo/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.027768 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 11:41:24.836314) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 11:41:24.836893) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4aeee4260fcd87d5616203937177dbe949a46dc9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4aeee4260fcd87d5616203937177dbe949a46dc9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TCmctXps7E/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.d7n0cT1kPo/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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-06-28 11:41:24,911 truncating revision to first 12 chars 2016-06-28 11:41:24,911 Setting DEBUG logging. 2016-06-28 11:41:24,911 attempt 1/10 2016-06-28 11:41:24,912 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4aeee4260fcd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 11:41:25,939 unpacking tar archive at: fx-team-4aeee4260fcd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.296790 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 11:41:26.155557) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 11:41:26.155863) ========= script_repo_revision: 4aeee4260fcd87d5616203937177dbe949a46dc9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 11:41:26.156252) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 11:41:26.156546) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 11:41:26.175494) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 11 secs) (at 2016-06-28 11:41:26.175788) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TCmctXps7E/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.d7n0cT1kPo/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 11:41:26 INFO - MultiFileLogger online at 20160628 11:41:26 in /builds/slave/test 11:41:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:41:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:41:26 INFO - {'append_to_log': False, 11:41:26 INFO - 'base_work_dir': '/builds/slave/test', 11:41:26 INFO - 'blob_upload_branch': 'Fx-Team', 11:41:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:41:26 INFO - 'branch': 'Fx-Team', 11:41:26 INFO - 'buildbot_json_path': 'buildprops.json', 11:41:26 INFO - 'config_files': ('talos/mac_config.py',), 11:41:26 INFO - 'default_actions': ('clobber', 11:41:26 INFO - 'read-buildbot-config', 11:41:26 INFO - 'download-and-extract', 11:41:26 INFO - 'populate-webroot', 11:41:26 INFO - 'create-virtualenv', 11:41:26 INFO - 'install', 11:41:26 INFO - 'run-tests'), 11:41:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:41:26 INFO - 'download_minidump_stackwalk': True, 11:41:26 INFO - 'download_symbols': 'ondemand', 11:41:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:41:26 INFO - 'tooltool.py': '/tools/tooltool.py', 11:41:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:41:26 INFO - '/tools/misc-python/virtualenv.py')}, 11:41:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:41:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:41:26 INFO - 'installer_path': 'installer.exe', 11:41:26 INFO - 'log_level': 'info', 11:41:26 INFO - 'log_name': 'talos', 11:41:26 INFO - 'log_to_console': True, 11:41:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:41:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:41:26 INFO - 'opt_config_files': (), 11:41:26 INFO - 'pip_index': False, 11:41:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:41:26 INFO - 'cmd': ('bash', 11:41:26 INFO - '-c', 11:41:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:41:26 INFO - 'enabled': True, 11:41:26 INFO - 'halt_on_failure': False, 11:41:26 INFO - 'name': 'check_screen_resolution'},), 11:41:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:41:26 INFO - 'cmd': ('bash', 11:41:26 INFO - '-c', 11:41:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:41:26 INFO - 'enabled': True, 11:41:26 INFO - 'halt_on_failure': False, 11:41:26 INFO - 'name': 'check_screen_resolution'},), 11:41:26 INFO - 'run_cmd_checks_enabled': True, 11:41:26 INFO - 'sps_profile': False, 11:41:26 INFO - 'sps_profile_interval': 0, 11:41:26 INFO - 'suite': 'dromaeojs-e10s', 11:41:26 INFO - 'system_bits': '32', 11:41:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:41:26 INFO - 'title': 't-yosemite-r7-0090', 11:41:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:41:26 INFO - 'use_talos_json': True, 11:41:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:41:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:41:26 INFO - 'work_dir': 'build'} 11:41:26 INFO - ##### 11:41:26 INFO - ##### Running clobber step. 11:41:26 INFO - ##### 11:41:26 INFO - Running pre-action listener: _resource_record_pre_action 11:41:26 INFO - Running main action method: clobber 11:41:26 INFO - rmtree: /builds/slave/test/build 11:41:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:41:28 INFO - Running post-action listener: _resource_record_post_action 11:41:28 INFO - ##### 11:41:28 INFO - ##### Finished clobber step (success) 11:41:28 INFO - ##### 11:41:28 INFO - ##### 11:41:28 INFO - ##### Running read-buildbot-config step. 11:41:28 INFO - ##### 11:41:28 INFO - Running pre-action listener: _resource_record_pre_action 11:41:28 INFO - Running main action method: read_buildbot_config 11:41:28 INFO - Using buildbot properties: 11:41:28 INFO - { 11:41:28 INFO - "project": "", 11:41:28 INFO - "product": "firefox", 11:41:28 INFO - "script_repo_revision": "production", 11:41:28 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 11:41:28 INFO - "repository": "", 11:41:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 11:41:28 INFO - "buildid": "20160628092022", 11:41:28 INFO - "pgo_build": "False", 11:41:28 INFO - "basedir": "/builds/slave/test", 11:41:28 INFO - "buildnumber": 58, 11:41:28 INFO - "slavename": "t-yosemite-r7-0090", 11:41:28 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 11:41:28 INFO - "platform": "yosemite_r7", 11:41:28 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 11:41:28 INFO - "branch": "fx-team", 11:41:28 INFO - "repo_path": "integration/fx-team", 11:41:28 INFO - "revision": "4aeee4260fcd87d5616203937177dbe949a46dc9", 11:41:28 INFO - "stage_platform": "macosx64", 11:41:28 INFO - "builduid": "473e175aabb640198c0553202ffc4580", 11:41:28 INFO - "slavebuilddir": "test" 11:41:28 INFO - } 11:41:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 11:41:28 INFO - Running post-action listener: _resource_record_post_action 11:41:28 INFO - ##### 11:41:28 INFO - ##### Finished read-buildbot-config step (success) 11:41:28 INFO - ##### 11:41:28 INFO - ##### 11:41:28 INFO - ##### Running download-and-extract step. 11:41:28 INFO - ##### 11:41:28 INFO - Running pre-action listener: _resource_record_pre_action 11:41:28 INFO - Running main action method: download_and_extract 11:41:28 INFO - mkdir: /builds/slave/test/build/tests 11:41:28 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:41:28 INFO - https://queue.taskcluster.net/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:41:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 11:41:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 11:41:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 11:41:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 11:41:40 INFO - Downloaded 1199 bytes. 11:41:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 11:41:40 INFO - Using the following test package requirements: 11:41:40 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 11:41:40 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:41:40 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 11:41:40 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:41:40 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 11:41:40 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:41:40 INFO - u'jsshell-mac.zip'], 11:41:40 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:41:40 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 11:41:40 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 11:41:40 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:41:40 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 11:41:40 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:41:40 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 11:41:40 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:41:40 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 11:41:40 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:41:40 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 11:41:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:41:40 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:41:40 INFO - https://queue.taskcluster.net/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:41:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:41:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:41:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:41:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:41:43 INFO - Downloaded 18786895 bytes. 11:41:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:41:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:41:46 INFO - Return code: 0 11:41:46 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:41:46 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:41:46 INFO - https://queue.taskcluster.net/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:41:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:41:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:41:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:41:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:41:47 INFO - Downloaded 18786895 bytes. 11:41:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:41:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:41:51 INFO - Return code: 0 11:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:41:51 INFO - https://queue.taskcluster.net/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:41:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 11:41:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 11:41:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 11:41:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:41:58 INFO - Downloaded 14405245 bytes. 11:41:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:41:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:41:58 INFO - Return code: 0 11:41:58 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:41:58 INFO - https://queue.taskcluster.net/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:41:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 11:41:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 11:41:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 11:41:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 11:45:49 INFO - Downloaded 112374178 bytes. 11:45:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 11:45:49 INFO - mkdir: /builds/slave/test/properties 11:45:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:45:49 INFO - Writing to file /builds/slave/test/properties/build_url 11:45:49 INFO - Contents: 11:45:49 INFO - build_url:https://queue.taskcluster.net/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 11:45:51 INFO - Running post-action listener: _resource_record_post_action 11:45:51 INFO - Running post-action listener: set_extra_try_arguments 11:45:51 INFO - ##### 11:45:51 INFO - ##### Finished download-and-extract step (success) 11:45:51 INFO - ##### 11:45:51 INFO - ##### 11:45:51 INFO - ##### Running populate-webroot step. 11:45:51 INFO - ##### 11:45:51 INFO - Running pre-action listener: _resource_record_pre_action 11:45:51 INFO - Running main action method: populate_webroot 11:45:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:45:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:45:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:45:51 INFO - '--tppagecycles', 11:45:51 INFO - '7'], 11:45:51 INFO - 'tests': ['tsvgm']}}, 11:45:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:45:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:45:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:45:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:45:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:45:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:45:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:51 INFO - 'talos_options': ['--disable-e10s'], 11:45:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:45:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:45:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:51 INFO - 'talos_options': ['--disable-e10s'], 11:45:51 INFO - 'tests': ['damp', 'tps']}, 11:45:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:51 INFO - 'tests': ['damp', 'tps']}, 11:45:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:45:51 INFO - 'tests': ['dromaeo_dom']}, 11:45:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:45:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:45:51 INFO - 'tests': ['basic_compositor_video']}, 11:45:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:45:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:45:51 INFO - 'tests': ['a11yr', 11:45:51 INFO - 'ts_paint', 11:45:51 INFO - 'tpaint', 11:45:51 INFO - 'sessionrestore', 11:45:51 INFO - 'sessionrestore_no_auto_restore', 11:45:51 INFO - 'tabpaint']}, 11:45:51 INFO - 'other-e10s': {'tests': ['a11yr', 11:45:51 INFO - 'ts_paint', 11:45:51 INFO - 'tpaint', 11:45:51 INFO - 'sessionrestore', 11:45:51 INFO - 'sessionrestore_no_auto_restore', 11:45:51 INFO - 'tabpaint']}, 11:45:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:45:51 INFO - 'ts_paint', 11:45:51 INFO - 'tpaint', 11:45:51 INFO - 'sessionrestore', 11:45:51 INFO - 'sessionrestore_no_auto_restore', 11:45:51 INFO - 'tabpaint']}, 11:45:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:45:51 INFO - 'ts_paint', 11:45:51 INFO - 'tpaint', 11:45:51 INFO - 'sessionrestore', 11:45:51 INFO - 'sessionrestore_no_auto_restore', 11:45:51 INFO - 'tabpaint']}, 11:45:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:45:51 INFO - 'tests': ['a11yr', 11:45:51 INFO - 'ts_paint', 11:45:51 INFO - 'tpaint', 11:45:51 INFO - 'sessionrestore', 11:45:51 INFO - 'sessionrestore_no_auto_restore', 11:45:51 INFO - 'tabpaint']}, 11:45:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:45:51 INFO - 'tests': ['a11yr', 11:45:51 INFO - 'ts_paint', 11:45:51 INFO - 'tpaint', 11:45:51 INFO - 'sessionrestore', 11:45:51 INFO - 'sessionrestore_no_auto_restore', 11:45:51 INFO - 'tabpaint']}, 11:45:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:45:51 INFO - 'tests': ['tsvgx', 11:45:51 INFO - 'tsvgr_opacity', 11:45:51 INFO - 'tart', 11:45:51 INFO - 'tscrollx', 11:45:51 INFO - 'cart']}, 11:45:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:45:51 INFO - 'tsvgr_opacity', 11:45:51 INFO - 'tart', 11:45:51 INFO - 'tscrollx', 11:45:51 INFO - 'cart']}, 11:45:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:51 INFO - 'talos_options': ['--disable-e10s'], 11:45:51 INFO - 'tests': ['tp5o']}, 11:45:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:51 INFO - 'tests': ['tp5o']}, 11:45:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:51 INFO - 'talos_options': ['--disable-e10s', 11:45:51 INFO - '--xperf_path', 11:45:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:45:51 INFO - 'tests': ['tp5n']}, 11:45:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:51 INFO - 'talos_options': ['--xperf_path', 11:45:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:45:51 INFO - 'tests': ['tp5n']}}, 11:45:51 INFO - 'talos.zip': {'path': '', 11:45:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:45:51 INFO - Running post-action listener: _resource_record_post_action 11:45:51 INFO - ##### 11:45:51 INFO - ##### Finished populate-webroot step (success) 11:45:51 INFO - ##### 11:45:51 INFO - ##### 11:45:51 INFO - ##### Running create-virtualenv step. 11:45:51 INFO - ##### 11:45:51 INFO - Running pre-action listener: _resource_record_pre_action 11:45:51 INFO - Running main action method: create_virtualenv 11:45:51 INFO - Creating virtualenv /builds/slave/test/build/venv 11:45:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:45:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:45:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:45:51 INFO - Using real prefix '/tools/python27' 11:45:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:45:52 INFO - Installing distribute.............................................................................................................................................................................................done. 11:45:55 INFO - Installing pip.................done. 11:45:55 INFO - Return code: 0 11:45:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107902a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107997618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe263da22b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107866d30>, '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 0x1075cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10785eb20>, '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.TCmctXps7E/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.d7n0cT1kPo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:45:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:45:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:45:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TCmctXps7E/Render', 11:45:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:55 INFO - 'HOME': '/Users/cltbld', 11:45:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:55 INFO - 'LOGNAME': 'cltbld', 11:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:55 INFO - 'MOZ_NO_REMOTE': '1', 11:45:55 INFO - 'NO_EM_RESTART': '1', 11:45:55 INFO - 'PAGER': '/bin/cat', 11:45:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:55 INFO - 'PWD': '/builds/slave/test', 11:45:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:55 INFO - 'SHELL': '/bin/bash', 11:45:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d7n0cT1kPo/Listeners', 11:45:55 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 11:45:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:55 INFO - 'USER': 'cltbld', 11:45:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:55 INFO - 'XPC_FLAGS': '0x0', 11:45:55 INFO - 'XPC_SERVICE_NAME': '0', 11:45:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:45:55 INFO - Cleaning up... 11:45:55 INFO - Return code: 0 11:45:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107902a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107997618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe263da22b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107866d30>, '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 0x1075cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10785eb20>, '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.TCmctXps7E/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.d7n0cT1kPo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:45:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:45:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:45:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TCmctXps7E/Render', 11:45:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:55 INFO - 'HOME': '/Users/cltbld', 11:45:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:55 INFO - 'LOGNAME': 'cltbld', 11:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:55 INFO - 'MOZ_NO_REMOTE': '1', 11:45:55 INFO - 'NO_EM_RESTART': '1', 11:45:55 INFO - 'PAGER': '/bin/cat', 11:45:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:55 INFO - 'PWD': '/builds/slave/test', 11:45:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:55 INFO - 'SHELL': '/bin/bash', 11:45:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d7n0cT1kPo/Listeners', 11:45:55 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 11:45:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:55 INFO - 'USER': 'cltbld', 11:45:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:55 INFO - 'XPC_FLAGS': '0x0', 11:45:55 INFO - 'XPC_SERVICE_NAME': '0', 11:45:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:55 INFO - Downloading/unpacking psutil>=3.1.1 11:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:45:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:45:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:45:59 INFO - Installing collected packages: psutil 11:45:59 INFO - Running setup.py install for psutil 11:45:59 INFO - building 'psutil._psutil_osx' extension 11:45:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:45:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:45:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:45:59 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 11:45:59 INFO - building 'psutil._psutil_posix' extension 11:45:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 11:46:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:46:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:46:00 INFO - ^ 11:46:00 INFO - 1 warning generated. 11:46:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 11:46:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:46:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:46:00 INFO - Successfully installed psutil 11:46:00 INFO - Cleaning up... 11:46:00 INFO - Return code: 0 11:46:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:00 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 0x107902a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107997618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe263da22b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107866d30>, '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 0x1075cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10785eb20>, '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.TCmctXps7E/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.d7n0cT1kPo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:46:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:46:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TCmctXps7E/Render', 11:46:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:46:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:46:00 INFO - 'HOME': '/Users/cltbld', 11:46:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:46:00 INFO - 'LOGNAME': 'cltbld', 11:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:00 INFO - 'MOZ_NO_REMOTE': '1', 11:46:00 INFO - 'NO_EM_RESTART': '1', 11:46:00 INFO - 'PAGER': '/bin/cat', 11:46:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:00 INFO - 'PWD': '/builds/slave/test', 11:46:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:46:00 INFO - 'SHELL': '/bin/bash', 11:46:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d7n0cT1kPo/Listeners', 11:46:00 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 11:46:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:46:00 INFO - 'USER': 'cltbld', 11:46:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:46:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:00 INFO - 'XPC_FLAGS': '0x0', 11:46:00 INFO - 'XPC_SERVICE_NAME': '0', 11:46:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:46:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:46:03 INFO - Installing collected packages: mozsystemmonitor 11:46:03 INFO - Running setup.py install for mozsystemmonitor 11:46:03 INFO - Successfully installed mozsystemmonitor 11:46:03 INFO - Cleaning up... 11:46:03 INFO - Return code: 0 11:46:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:46:03 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:03 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:03 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 0x107902a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107997618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe263da22b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107866d30>, '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 0x1075cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10785eb20>, '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.TCmctXps7E/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.d7n0cT1kPo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:46:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:46:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TCmctXps7E/Render', 11:46:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:46:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:46:03 INFO - 'HOME': '/Users/cltbld', 11:46:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:46:03 INFO - 'LOGNAME': 'cltbld', 11:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:03 INFO - 'MOZ_NO_REMOTE': '1', 11:46:03 INFO - 'NO_EM_RESTART': '1', 11:46:03 INFO - 'PAGER': '/bin/cat', 11:46:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:03 INFO - 'PWD': '/builds/slave/test', 11:46:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:46:03 INFO - 'SHELL': '/bin/bash', 11:46:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d7n0cT1kPo/Listeners', 11:46:03 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 11:46:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:46:03 INFO - 'USER': 'cltbld', 11:46:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:46:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:03 INFO - 'XPC_FLAGS': '0x0', 11:46:03 INFO - 'XPC_SERVICE_NAME': '0', 11:46:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:03 INFO - Downloading/unpacking jsonschema==2.5.1 11:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:46:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:06 INFO - Downloading functools32-3.2.3-2.tar.gz 11:46:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:46:06 INFO - warning: no files found matching '*.txt' 11:46:06 INFO - no previously-included directories found matching 'build' 11:46:06 INFO - no previously-included directories found matching 'dist' 11:46:06 INFO - no previously-included directories found matching '.git*' 11:46:06 INFO - Installing collected packages: jsonschema, functools32 11:46:06 INFO - Running setup.py install for functools32 11:46:06 INFO - warning: no files found matching '*.txt' 11:46:06 INFO - no previously-included directories found matching 'build' 11:46:06 INFO - no previously-included directories found matching 'dist' 11:46:06 INFO - no previously-included directories found matching '.git*' 11:46:06 INFO - Successfully installed jsonschema functools32 11:46:06 INFO - Cleaning up... 11:46:06 INFO - Return code: 0 11:46:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:06 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 0x107902a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107997618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe263da22b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107866d30>, '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 0x1075cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10785eb20>, '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.TCmctXps7E/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.d7n0cT1kPo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:46:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:46:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:46:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TCmctXps7E/Render', 11:46:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:46:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:46:06 INFO - 'HOME': '/Users/cltbld', 11:46:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:46:06 INFO - 'LOGNAME': 'cltbld', 11:46:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:06 INFO - 'MOZ_NO_REMOTE': '1', 11:46:06 INFO - 'NO_EM_RESTART': '1', 11:46:06 INFO - 'PAGER': '/bin/cat', 11:46:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:46:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:06 INFO - 'PWD': '/builds/slave/test', 11:46:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:46:06 INFO - 'SHELL': '/bin/bash', 11:46:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d7n0cT1kPo/Listeners', 11:46:06 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 11:46:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:46:06 INFO - 'USER': 'cltbld', 11:46:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:46:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:46:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:06 INFO - 'XPC_FLAGS': '0x0', 11:46:06 INFO - 'XPC_SERVICE_NAME': '0', 11:46:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:07 INFO - Downloading/unpacking blobuploader==1.2.4 11:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:09 INFO - Downloading blobuploader-1.2.4.tar.gz 11:46:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:46:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:46:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:10 INFO - Downloading docopt-0.6.1.tar.gz 11:46:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:46:10 INFO - Installing collected packages: blobuploader, requests, docopt 11:46:10 INFO - Running setup.py install for blobuploader 11:46:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:46:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:46:10 INFO - Running setup.py install for requests 11:46:11 INFO - Running setup.py install for docopt 11:46:11 INFO - Successfully installed blobuploader requests docopt 11:46:11 INFO - Cleaning up... 11:46:11 INFO - Return code: 0 11:46:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:46:11 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:11 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:11 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 0x107902a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107997618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe263da22b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107866d30>, '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 0x1075cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10785eb20>, '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.TCmctXps7E/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.d7n0cT1kPo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:46:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:46:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TCmctXps7E/Render', 11:46:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:46:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:46:11 INFO - 'HOME': '/Users/cltbld', 11:46:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:46:11 INFO - 'LOGNAME': 'cltbld', 11:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:11 INFO - 'MOZ_NO_REMOTE': '1', 11:46:11 INFO - 'NO_EM_RESTART': '1', 11:46:11 INFO - 'PAGER': '/bin/cat', 11:46:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:11 INFO - 'PWD': '/builds/slave/test', 11:46:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:46:11 INFO - 'SHELL': '/bin/bash', 11:46:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d7n0cT1kPo/Listeners', 11:46:11 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 11:46:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:46:11 INFO - 'USER': 'cltbld', 11:46:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:46:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:11 INFO - 'XPC_FLAGS': '0x0', 11:46:11 INFO - 'XPC_SERVICE_NAME': '0', 11:46:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:46:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:46:11 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-msroiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:46:11 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-rssZFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:46:12 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-klq41x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:46:12 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-3vp06C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:46:12 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-i1r95M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:46:12 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-4ug9gF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:46:12 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-E8kZwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:46:12 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-durPkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:46:12 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-8hVGF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:46:12 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-CSmbrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:46:12 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-XCnBK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:46:12 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-rr88rC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:46:13 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-A6hLFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:46:13 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-GblbBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:46:13 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-Z_ZKPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:46:13 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-VbXYyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:46:13 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-L5IZcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:46:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:46:13 INFO - Running setup.py install for manifestparser 11:46:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:46:13 INFO - Running setup.py install for mozcrash 11:46:13 INFO - Running setup.py install for mozdebug 11:46:13 INFO - Running setup.py install for mozdevice 11:46:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:46:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:46:14 INFO - Running setup.py install for mozfile 11:46:14 INFO - Running setup.py install for mozhttpd 11:46:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:46:14 INFO - Running setup.py install for mozinfo 11:46:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:46:14 INFO - Running setup.py install for mozInstall 11:46:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:46:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:46:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:46:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:46:14 INFO - Running setup.py install for mozleak 11:46:14 INFO - Running setup.py install for mozlog 11:46:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:46:15 INFO - Running setup.py install for moznetwork 11:46:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:46:15 INFO - Running setup.py install for mozprocess 11:46:15 INFO - Running setup.py install for mozprofile 11:46:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:46:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:46:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:46:15 INFO - Running setup.py install for mozrunner 11:46:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:46:15 INFO - Running setup.py install for mozscreenshot 11:46:15 INFO - Running setup.py install for moztest 11:46:15 INFO - Running setup.py install for mozversion 11:46:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:46:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:46:16 INFO - Cleaning up... 11:46:16 INFO - Return code: 0 11:46:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:46:16 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:16 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:16 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 0x107902a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107997618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe263da22b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107866d30>, '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 0x1075cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10785eb20>, '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.TCmctXps7E/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.d7n0cT1kPo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:46:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:46:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:46:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TCmctXps7E/Render', 11:46:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:46:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:46:16 INFO - 'HOME': '/Users/cltbld', 11:46:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:46:16 INFO - 'LOGNAME': 'cltbld', 11:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:16 INFO - 'MOZ_NO_REMOTE': '1', 11:46:16 INFO - 'NO_EM_RESTART': '1', 11:46:16 INFO - 'PAGER': '/bin/cat', 11:46:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:46:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:16 INFO - 'PWD': '/builds/slave/test', 11:46:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:46:16 INFO - 'SHELL': '/bin/bash', 11:46:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d7n0cT1kPo/Listeners', 11:46:16 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 11:46:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:46:16 INFO - 'USER': 'cltbld', 11:46:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:46:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:16 INFO - 'XPC_FLAGS': '0x0', 11:46:16 INFO - 'XPC_SERVICE_NAME': '0', 11:46:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:46:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:46:16 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-OQvn03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:46:16 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-BSEIjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:46:16 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-LSObDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:46:16 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-X1byo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:46:16 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-a7Aaoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:46:16 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-OdpvZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:46:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:46:17 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-oiRjPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:46:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:46:17 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-jcHNty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:46:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:46:17 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-jHvKoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:46:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:46:17 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-5Brnhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:46:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:46:17 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-5JQHAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:46:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:46:17 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-SHjgo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:46:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:46:17 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-3ZdayP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:46:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:46:17 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-uRLxYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:46:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:46:17 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-tBdxyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:46:18 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-pPq6Y3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:46:18 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-a_nzUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:46:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:20 INFO - Downloading blessings-1.6.tar.gz 11:46:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:46:20 INFO - Installing collected packages: blessings 11:46:20 INFO - Running setup.py install for blessings 11:46:20 INFO - Successfully installed blessings 11:46:20 INFO - Cleaning up... 11:46:20 INFO - Return code: 0 11:46:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:46:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:46:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:46:21 INFO - Reading from file tmpfile_stdout 11:46:21 INFO - Current package versions: 11:46:21 INFO - blessings == 1.6 11:46:21 INFO - blobuploader == 1.2.4 11:46:21 INFO - docopt == 0.6.1 11:46:21 INFO - functools32 == 3.2.3-2 11:46:21 INFO - jsonschema == 2.5.1 11:46:21 INFO - manifestparser == 1.1 11:46:21 INFO - mozInstall == 1.12 11:46:21 INFO - mozcrash == 0.17 11:46:21 INFO - mozdebug == 0.1 11:46:21 INFO - mozdevice == 0.48 11:46:21 INFO - mozfile == 1.2 11:46:21 INFO - mozhttpd == 0.7 11:46:21 INFO - mozinfo == 0.9 11:46:21 INFO - mozleak == 0.1 11:46:21 INFO - mozlog == 3.2 11:46:21 INFO - moznetwork == 0.27 11:46:21 INFO - mozprocess == 0.22 11:46:21 INFO - mozprofile == 0.28 11:46:21 INFO - mozrunner == 6.11 11:46:21 INFO - mozscreenshot == 0.1 11:46:21 INFO - mozsystemmonitor == 0.3 11:46:21 INFO - moztest == 0.7 11:46:21 INFO - mozversion == 1.4 11:46:21 INFO - psutil == 3.1.1 11:46:21 INFO - requests == 1.2.3 11:46:21 INFO - wsgiref == 0.1.2 11:46:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:46:21 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:21 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:21 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 0x107902a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107997618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe263da22b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107866d30>, '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 0x1075cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10785eb20>, '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.TCmctXps7E/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.d7n0cT1kPo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:46:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:46:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TCmctXps7E/Render', 11:46:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:46:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:46:21 INFO - 'HOME': '/Users/cltbld', 11:46:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:46:21 INFO - 'LOGNAME': 'cltbld', 11:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:21 INFO - 'MOZ_NO_REMOTE': '1', 11:46:21 INFO - 'NO_EM_RESTART': '1', 11:46:21 INFO - 'PAGER': '/bin/cat', 11:46:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:21 INFO - 'PWD': '/builds/slave/test', 11:46:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:46:21 INFO - 'SHELL': '/bin/bash', 11:46:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d7n0cT1kPo/Listeners', 11:46:21 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 11:46:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:46:21 INFO - 'USER': 'cltbld', 11:46:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:46:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:21 INFO - 'XPC_FLAGS': '0x0', 11:46:21 INFO - 'XPC_SERVICE_NAME': '0', 11:46:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:46:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:46:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:46:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:46:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:46:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:46:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:46:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:46:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:46:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:46:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:46:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:46:21 INFO - Cleaning up... 11:46:21 INFO - Return code: 0 11:46:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:46:21 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:21 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:21 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 0x107902a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107997618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe263da22b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107866d30>, '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 0x1075cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10785eb20>, '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.TCmctXps7E/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.d7n0cT1kPo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:46:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:46:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TCmctXps7E/Render', 11:46:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:46:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:46:21 INFO - 'HOME': '/Users/cltbld', 11:46:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:46:21 INFO - 'LOGNAME': 'cltbld', 11:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:21 INFO - 'MOZ_NO_REMOTE': '1', 11:46:21 INFO - 'NO_EM_RESTART': '1', 11:46:21 INFO - 'PAGER': '/bin/cat', 11:46:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:21 INFO - 'PWD': '/builds/slave/test', 11:46:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:46:21 INFO - 'SHELL': '/bin/bash', 11:46:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d7n0cT1kPo/Listeners', 11:46:21 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 11:46:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:46:21 INFO - 'USER': 'cltbld', 11:46:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:46:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:21 INFO - 'XPC_FLAGS': '0x0', 11:46:21 INFO - 'XPC_SERVICE_NAME': '0', 11:46:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:46:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:46:21 INFO - Cleaning up... 11:46:21 INFO - Return code: 0 11:46:21 INFO - Running post-action listener: _resource_record_post_action 11:46:21 INFO - Running post-action listener: _start_resource_monitoring 11:46:21 INFO - Starting resource monitoring. 11:46:21 INFO - ##### 11:46:21 INFO - ##### Finished create-virtualenv step (success) 11:46:21 INFO - ##### 11:46:21 INFO - ##### 11:46:21 INFO - ##### Running install step. 11:46:21 INFO - ##### 11:46:21 INFO - Running pre-action listener: _resource_record_pre_action 11:46:21 INFO - Running main action method: install 11:46:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:46:22 INFO - Reading from file tmpfile_stdout 11:46:22 INFO - Detecting whether we're running mozinstall >=1.0... 11:46:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:46:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:46:22 INFO - Reading from file tmpfile_stdout 11:46:22 INFO - Output received: 11:46:22 INFO - Usage: mozinstall [options] installer 11:46:22 INFO - Options: 11:46:22 INFO - -h, --help show this help message and exit 11:46:22 INFO - -d DEST, --destination=DEST 11:46:22 INFO - Directory to install application into. [default: 11:46:22 INFO - "/builds/slave/test"] 11:46:22 INFO - --app=APP Application being installed. [default: firefox] 11:46:22 INFO - mkdir: /builds/slave/test/build/application 11:46:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:46:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:46:57 INFO - Reading from file tmpfile_stdout 11:46:57 INFO - Output received: 11:46:57 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:46:57 INFO - Running post-action listener: _resource_record_post_action 11:46:57 INFO - ##### 11:46:57 INFO - ##### Finished install step (success) 11:46:57 INFO - ##### 11:46:57 INFO - ##### 11:46:57 INFO - ##### Running run-tests step. 11:46:57 INFO - ##### 11:46:57 INFO - Running pre-action listener: _resource_record_pre_action 11:46:57 INFO - Running main action method: run_tests 11:46:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:46:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:46:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:46:57 INFO - 2016-06-28 11:46:57.029 screenresolution[1641:8275] starting screenresolution argv=screenresolution get 11:46:57 INFO - 2016-06-28 11:46:57.031 screenresolution[1641:8275] Display 0: 1600x1200x32@60 11:46:57 INFO - 2016-06-28 11:46:57.037 screenresolution[1642:8277] starting screenresolution argv=screenresolution list 11:46:57 INFO - Available Modes on Display 0 11:46:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:46:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:46:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:46:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:46:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:46:57 INFO - Intel Iris: 11:46:57 INFO - Chipset Model: Intel Iris 11:46:57 INFO - Type: GPU 11:46:57 INFO - Bus: Built-In 11:46:57 INFO - VRAM (Dynamic, Max): 1536 MB 11:46:57 INFO - Vendor: Intel (0x8086) 11:46:57 INFO - Device ID: 0x0a2e 11:46:57 INFO - Revision ID: 0x0009 11:46:57 INFO - Displays: 11:46:57 INFO - Display: 11:46:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:46:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:46:57 INFO - Display Serial Number: 1600x1200 60 11:46:57 INFO - Main Display: Yes 11:46:57 INFO - Mirror: Off 11:46:57 INFO - Online: Yes 11:46:57 INFO - Rotation: Supported 11:46:57 INFO - Return code: 0 11:46:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:46:57 INFO - Python 2.7.3 11:46:57 INFO - Return code: 0 11:46:57 INFO - grabbing minidump binary from tooltool 11:46: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:57 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 0x107866d30>, '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 0x1075cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10785eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:46:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:46:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 11:46:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:46:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:46:57 INFO - Return code: 0 11:46:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:46:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:46:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:46:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:46:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:46:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0090', '--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 11:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0090 --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 11:46:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TCmctXps7E/Render', 11:46:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:46:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:46:57 INFO - 'HOME': '/Users/cltbld', 11:46:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:46:57 INFO - 'LOGNAME': 'cltbld', 11:46:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:46:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:57 INFO - 'MOZ_NO_REMOTE': '1', 11:46:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:46:57 INFO - 'NO_EM_RESTART': '1', 11:46:57 INFO - 'PAGER': '/bin/cat', 11:46:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:57 INFO - 'PWD': '/builds/slave/test', 11:46:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:46:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:46:57 INFO - 'SHELL': '/bin/bash', 11:46:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d7n0cT1kPo/Listeners', 11:46:57 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 11:46:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:46:57 INFO - 'USER': 'cltbld', 11:46:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:46:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:57 INFO - 'XPC_FLAGS': '0x0', 11:46:57 INFO - 'XPC_SERVICE_NAME': '0', 11:46:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:46:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0090', '--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 11:46:57 INFO - mozversion application_buildid: 20160628092022 11:46:57 INFO - mozversion application_changeset: 4aeee4260fcd87d5616203937177dbe949a46dc9 11:46:57 INFO - mozversion application_display_name: Nightly 11:46:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:46:57 INFO - mozversion application_name: Firefox 11:46:57 INFO - mozversion application_remotingname: firefox 11:46:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:46:57 INFO - mozversion application_vendor: Mozilla 11:46:57 INFO - mozversion application_version: 50.0a1 11:46:57 INFO - mozversion platform_buildid: 20160628092022 11:46:57 INFO - mozversion platform_changeset: 4aeee4260fcd87d5616203937177dbe949a46dc9 11:46:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:46:57 INFO - mozversion platform_version: 50.0a1 11:46:57 INFO - using testdate: 1467139617 11:46:57 INFO - actual date: 1467139617 11:46:57 INFO - starting webserver on 'localhost:49266' 11:46:57 INFO - SUITE-START | Running 2 tests 11:46:57 INFO - TEST-START | dromaeo_css 11:46:57 INFO - operating with platform_type : mac_ 11:46:57 INFO - Initialising browser for dromaeo_css test... 11:46:57 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpAst9OL/profile http://localhost:49266/getInfo.html) 11:47:00 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 11:47:00 INFO - PROCESS | 1652 | colorDepth:24 11:47:00 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 11:47:00 INFO - PROCESS | 1652 | __metrics 11:47:00 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 11:47:01 INFO - TEST-INFO | 1652: exit 0 11:47:01 INFO - Browser initialized. 11:47:01 INFO - Running cycle 1/1 for dromaeo_css test... 11:47:01 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpAst9OL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:47:13 INFO - PROCESS | 1656 | RSS: Main: 254976000 11:47:13 INFO - PROCESS | 1656 | 11:48:03 INFO - PROCESS | 1656 | 1467139683292 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:50:14 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 11:50:15 INFO - PROCESS | 1656 | RSS: Main: 267444224 11:50:15 INFO - PROCESS | 1656 | 11:53:17 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 11:53:18 INFO - PROCESS | 1656 | RSS: Main: 278716416 11:53:18 INFO - PROCESS | 1656 | 11:56:20 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 11:56:20 INFO - PROCESS | 1656 | RSS: Main: 280903680 11:56:20 INFO - PROCESS | 1656 | 11:59:22 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 11:59:23 INFO - PROCESS | 1656 | RSS: Main: 282099712 11:59:23 INFO - PROCESS | 1656 | 12:02:26 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 12:02:26 INFO - PROCESS | 1656 | RSS: Main: 286011392 12:02:26 INFO - PROCESS | 1656 | 12:05:29 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 12:05:29 INFO - PROCESS | 1656 | RSS: Main: 286105600 12:05:29 INFO - PROCESS | 1656 | 12:05:29 INFO - PROCESS | 1656 | __start_tp_report 12:05:29 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 12:05:29 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 12:05:29 INFO - PROCESS | 1656 | |i|pagename|runs| 12:05:29 INFO - PROCESS | 1656 | |0;dojo.html;2930.4871647461696;3351.0784534253085;3429.6055953565346;3462.3421549905515;3483.8954831355054;5887.676177810219;5936.347001829795;5994.58037937344;6008.922460520864;6060.333363330041;5793;5897;5958.43394877487;5975.1933488978975;6064.151018857364;4433.847199728078;5288.735563221823;5395.514403703666;5409.080456322435;5455.208994695767;434.6544360118738;5295.867603309929;5344.5724342052545;5409.107497262967;5423.050966080939;5312.335958005249;5338.145896656516;5375.516203541681;5380.24676545284;5386.326709161355;5370;5436.293281873332;5441.83674489766;5462.153366228241;5492.588055895823;5247.501487358695;5250.18622113573;5296.179092240709;5308.416074231832;5364.302640656729;5866.384029676908;5929.110633404981;5933.080372542219;5953.642781433128;6061.909071363889;6190.195274614316;6211.751529938797;6254.874902501924;6265.530085243625;6272.843178920518;6170.475509581691;6200.813975580695;6238.1578486904145;6296.307406185316;6297.149884765544;6012.008018676913;6073.635581865102;6081.513478921675;6086.513078953673;6088.330283668793;6204;6271.937280627135;6454.225492940877;6454.451371633464;6462.321456247027;6177.444030037318;6258.061290806324;6265.65538895356;6281.089242059968;6308.653024083719;6215.06773983906;6228.844278893064;6282.2147231596055;6326.746930122744;6333.841653958688;6180.505559555225;6186.81439556814;6212.099245609361;6223.377662233831;6266.968665156645;6129.603311142676;6189.721462534197;6194.163787888668;6205.6586887721605;6236.095766113888;4998.2002879539095;5020.7740651670765;5027.095122877844;5028.34631497903;5037.143685573461;3853.788041657736;4378.956210437918;4473.932891006638;4497.482789479186;4539.75031373271;5993.101034844721;6057.787977420858;6111.5110791137495;6113.3198322145345;6138.355472675305;6275.811725648238;6333.873322533524;6334.651594162273;6359.841003974938;6379.71291291893;5308.893822123536;6007.849803754941;6074.301455332693;6081.17904082952;6108.511319094462;5544.417836127229;5570.498655120978;5578.693171875586;5591.412901645269;5597.440255974451;6541.967290163519;6553.246376666649;6553.246376666649;6563.146790917151;6576.145101136822;5322.866928326823;6161.537884658758;6165.753369865155;6217.751289948533;6247.781327653511;5669.801556945487;5819.447152520504;6474.320196379501;6511;6520.967395162994;5100.566451851634;6200.650140201954;6219.751209951552;6266.216722909637;6286.5599408041;5623.943760562342;6093.725782339717;6225.439710426083;6236.781712640217;6262.5929314594405;6236.345183755821;6240.625562466085;6242.438180563771;6256.593321434092;6275.686215689106;6123.618175568127;6207.844803879939;6268.52986026059;6274.74901003973;6293.213348331458;5032.6980381177245;6033.607815491979;6122.081687746873;6166.290876549254;6188.009918413032;6211.81364559064;6227.50179985591;6242.5942313749465;6254.437100660963;6272.529560282906;5931.377205393372;6117.3402608778015;6137.631742095488;6148.292946311052;6199.504039676905 12:05:29 INFO - PROCESS | 1656 | |1;ext.html;472.4212839271892;525.2541391224462;529.7616072767256;545.6316986034426;566.6005466146368;37966;43597.564024359745;43621.78189109058;43633.99999999996;43794.343084853754;44323;44408.55591444085;44790.55209447905;44819.77590112045;44923.32615010769;8185;9777.511124443767;9959.302848800588;10032.147267482273;10115.533247679083;9767.120959113678;9843.803123937518;9870.60517579296;9871.802563948717;9896.208303335752;9886.950565247163;9902.207823374112;9908.752281192956;9926.156276716487;9960.20318374532;9863.358881672668;9894.356866803706;9899.851502227473;9920.10719035283;9935.403875767404;9830;9900.752481188028;9915.355501892425;9916.405015699082;9917.553710083064;41791.7910410446;41860.79069604663;42097.57902420967;42133.78933105346;42280.15439691189;3067.3558552703958;3440.8795692150657;3449;3965.861194858195;4188.7905604719945;32259;32731.34537309264;32891;32924.34151316984;33873.32253354919;3061.7698328263673;3277.2298509850166;3340.4321265384942;3342.665733426662;3362.5124356968104;470721;471316;544559;545927.999999996;548975;66403.00395494071;67065;67149;67156;67434;30060.398792024036;36616.63383366132;37055.62944370576;38409.42385864214;38456.03859903469;16764;16766.580835478966;16804.495865124067;16931.91534042322;16944.89858159216;13241;13338.73322533544;13339.599812005656;13342;13380.130291531214;17275;17738.467845964642;20051.197952081755;20681.58636827255;20755.377338679864;7921.445498815027;8094.838103237902;8131.064927533291;8144.14486478923;8203.671853125927;865.5845194306768;891.3715830339595;1019.3578045831078;1120.6581992492368;1166.6150170443902;27247.455050898872;30653.386932261677;31452.685473144975;31683.257420841615;32035.679643203268;1055.4933631856752;1065.7761870007384;1078.9352638841694;1158.7578036499401;1173.524722487394;16587.92178508417;16600.916995414944;17421.390251341396;17662;17995.550111247325;720043;720944;726386;726877;729637;54852.72573637106;63143;64430;65263;65364;1390.9513167039106;1420.4744244629553;1449.166729130754;1452.869241768267;1457.242234038294;29073.98241061553;31798;32873.67126328706;33301;33346.499802503466;56069;56274.718626406604;56965;56979;57110.714446427504;539474;541825;544087;545952;656432;28208.166469180258;28230.576541351486;28379;28661.856690716413;28760.993365232116;50463;51088.48911510837;51330.97338053293;51805.7409712949;52228.605140665735;41863.162736745704;42091.15817683691;42229.36655950102;42943;43014.56985430106;32976.010719678445;40757;40759.777206683844;40776.59223407728;41208.58791412047;34268.82865585656;39994.000149996486;40204.79897600493;41087;41172.38241426441;32379.028629141165;33696;33947;36595.45106823453;36709.81645091758;26460.8676956614;26697.065602703813;26787;27023.864880676258;27276 12:05:29 INFO - PROCESS | 1656 | |2;jquery.html;377.58654273570437;378.22463948904755;381.3459916243643;393.57690482731033;402.97380670256433;20347.49131271717;21223.469413264676;21630.459238519044;22142.446438839015;22150.33548993529;16036.679266414665;20404.285849995253;21023.57952840946;22131.889340553316;22201.666974995387;5336.786528538873;6013.51891848651;6071.089336599523;6074.908876366858;6079.331273559905;5500.1749737539285;5835.824925252249;5896.646201227919;6178.907316390258;6192.535559833008;5465.289512363407;5949.048152295633;6095.756169753205;6120.387961203888;6156.5998210116195;5182.300389447433;6028.2766068072115;6099.817005489843;6105.32841387447;6123.081537769348;4424.292113261863;5312.707801070939;5329.067413202674;5330.440303768088;5330.946690533084;26281.474370512482;27476;27598;27619.03333383342;27681;2248.2693124734365;2297.5060362022077;2357.116081469449;2392.9760702392928;3080.368524452482;16191.595210119724;16317.265723042492;16402.67194656112;16404.507864764077;16472.917635411864;1909.446260584429;1975.3481351154228;1975.7135215393687;1991.9402417927486;2001.3495613925531;117497;122123.38938305252;122452;122589.38705306506;124248.75751242462;11003.284786488852;11435.771284574428;11483;11485.598004069818;11585.6524304271;14074.577762667137;14129.78805317921;14139.929300353639;14183;14201.573952781433;7409.370203532652;8861;8909.910900890907;8917.821643567093;9026.86459703105;9028.006919238878;9038.051004644549;9050.773730656787;9141.405808622418;9183.357164998386;6792.76225332111;6810.489213308922;6904.653592549505;6926.168859736864;6999.510034297652;1849.1493912799995;1882.4258601126514;1882.4352694191962;1889.9433017009512;1899.5061284066242;848.1815048478124;922.1516205091332;932.4032619123766;937.2876613773581;996.4718699089494;22796.860156992083;23271.534569308857;23458.827058647;23510.882445587664;23667.644985325234;947.2185447006248;958.8705524754208;962.259060523407;968.3657204530903;1070.3952266969138;10429.5828166874;12164.81752773709;12222.449989750483;12484.687882803002;12491.000719942384;250392;251701.74149129138;469090;645111;646048;121196;127022;127718.36140819422;129346;129808;1027.2963020331097;1028.1517747857897;1063.1707268330715;1080.044160917578;1085.6525911708336;16058.956167849052;17169.656606868044;19857.503562411057;20182.69725954141;20502.897485513073;43660.56339436565;50283;52857.7357113212;53698.65753356197;54360.18459723186;72088.1164753404;75566;75633.24366756262;75816.24183758312;76969.61515192388;8262.462939908886;8286.212809783061;8327.708530201415;8609.612567434606;8971.699103630068;9681.564329605044;10775.892241077803;13585.660358491117;13725.176489410667;14094.788578171541;9506.47714375716;11704.473298701749;11764.117691173367;11804.586839460577;12014;10387;11632.243904146204;11722.824157637471;11736.178467507192;11868.465919033837;11981.880181198076;12012.459439325427;12051.879481205076;12052.337121458404;12060.336681482602;8308.750737477885;8365.707200247962;8559.657613695632;8577.185167409087;8608.48349099056;9590.856137158087;11702.648920532058;11868.228565143238;11958.521659133885;11964.880351196725 12:05:29 INFO - PROCESS | 1656 | |3;mootools.html;1518.2788175616581;1554.8056492938383;1627.9186040697962;1668.8915220510667;1838.5495553589374;8122.837543249147;8652.870206946885;8668.523231222289;9152;9155.587998540073;8772.649094036247;8810.691625793099;8921.241694455979;8930.776730581723;8945.910540894589;2333.055112679359;2371.7983971362455;2374.4063984004;2376.572217000939;2380.5238952209543;2325.662778897059;2332.603457412244;2352.5177338645535;2368.159303447277;2371.229350461107;2345.472268739537;2345.6833327500826;2352.4706940938236;2358.5282943411385;2367.3726462487452;2035.155410504639;2333.9299821005397;2349.166046053652;2350.8707021113833;2363.5745565798147;1989.980100198994;2314.479242170515;2328.639060945556;2332.4518738096535;2342.8945697443655;8946.597403116875;8954.507502087383;8985.191332780016;9021.954890225506;9060.365774395796;5155.793768249303;5332.893342133174;5342.839714808562;5351.170568561879;5362.383325917531;3494.2487365216602;3564.928701425957;3649;3658.304922064799;3694.6305369463107;1082.1342925659442;1094.3324572011068;1103.5751235774205;1115.4255558387438;1116.0680831505701;11762.353070581115;11913.285202887768;11927.582534611334;11927.940360298144;11959;3782.432635104701;4191.601797829201;4294.754521188883;4418.7127836690515;4433.4236549249035;10045.447500387549;10050.246231532665;10083.596656133672;10099.899001009895;10165.339252948535;5336.439673834269;5346.304980352529;5350.571954243729;5362.195670649356;5375.354957405137;4063.9390409143884;4192.350185721218;4418.624416924533;4860.9513904861205;4861.124997500484;3537.5931767846514;3968.4840970674204;4025.3156963316305;4070.5929407059057;4083.3466645336603;1109.606089838112;1279.9168054076456;1290.6515240884908;1301.5509649171022;1302.7459645369063;920.6593560382568;929.2426672262085;929.8330595103102;944.8252073366449;975.673149494913;5998.340182579913;6001.549883758736;6068.787592434243;6132.17215675878;6168.506519478431;417.7493503897637;421.3784667615243;431.95680431956555;432.5458268817729;432.95453977332556;3947.9013024674614;4059.0258337998666;4134.049168691157;4144.316187829035;4151.854685086068;10539;10787.975142361463;10942.45287735626;10944.671659850217;10953.507092180871;10659.467026648637;10912.945435272773;10934.289271197347;10961.451927403597;11011.449427528592;8242.093369729326;8340.708075217339;8375.953005874266;8403.991521017395;8484.236418722345;5910.965581023218;5958.986972214647;5965.075413310944;5968.943944567717;6041.033434650435;10144.28989970695;10177.033181847713;10177.08406243412;10202.38785672862;10309.639162629272;9740.805183896424;10121.797564048826;10271;10307.381557106597;10439.321444106108;7077.327653872874;7228.63856807147;7513;7747.690092396241;7774.339181169664;8552.315814734682;8622.180892815173;8641.827163456821;8666.480011199348;8677.739667809976;7522.924770752223;7680.884786728316;7729.884051739116;7743.690252389842;7800.92199078002;7358.77923662291;7521.962390188014;7549.660265287966;7646.9617651911385;7652.426068044808;7034.085568876013;7109.182444019004;7109.644517774194;7111.43108551325;7115.501914865909;4979.825706100269;5108.489151084862;5111.642185047011;5183.533481986639;5224.634275600672;5184.377874655065;5208.817691380935;5232.215167724872;5252.133397989442;5327.600429967691 12:05:29 INFO - PROCESS | 1656 | |4;prototype.html;293.3399850336742;300.2089494182828;306.3321958131274;309.3380166443809;313.49527261109625;4881.365422495075;4929.781598280774;4954.232094025432;5258.158694608864;5436.646617969835;4468.575485328888;4615.568934016231;5405.243265942771;5474.644148130379;5507.256520369759;3337.449320862067;3410.334984677989;3419.6238413774463;3940.034691500586;4251.787410629471;3431.575896003156;3681.208540163864;3905.7461265017682;3928.7249892507534;4240.618344349008;3457.239407330396;3994.7403418777685;4060.2894493463673;4068.7965601719943;4071.5928407159345;3475.2354482013916;3571.2678900825267;3634.7637403568683;3935.862244821432;4075.086313285985;3509.7543171977973;3511.8244087795765;3528.8235588220487;3537.398642230827;3539.6460353964653;4899.730514821684;4966;4977.800887964513;4998.450170481244;5261.394939581959;4212.49450065994;4527.501974782771;4600.975570748893;4619.422572178478;4631.976840115778;4563.771811409416;5158.323544847939;5284.682919024833;5289;5421.972890135524;3665.5234819473562;3838.769673819552;3864.420336949452;3873.573906870242;3977.781222032787;4845.951540484585;5034.0686972910125;5137.12668846297;5999.580029397944;6097.69511524422;3249.951250731241;3484.564429446319;3653.488511608377;3919.8040097994985;4077.980504873722;3455.568053993251;3685.0787303174206;4109.671226301889;4127.195196936628;4137.386419296477;4441.489228738672;4754.690945088558;4797.328374027639;4800.5199480051715;4806.759662016885;5753.51095156908;5834.445727655866;5853.707314634251;5856.8535786604825;5897.52819774417;1173.9823902641467;1267.9746405071846;1330.5010621017118;1377.937992790327;1408.767328587486;833.441594131933;848.3086284677968;855.3755758296478;874.191372979991;878.3807415771865;4270.139006865407;4304.653963589851;4524.25349817283;4540.84107056258;4544.841200429835;4803.615710743132;5029.321041659402;5040.747962601855;5061.5950723942;5065.44195181431;4203.642690371353;4257.765822879772;4349.543297953733;4357.629601483909;4652.209124448784;1975.9506012349807;2311.7457079721216;2449.35092200567;2527.8892125075768;2666.613361052242;4559.71700375729;4787.468010236691;5163.586913046947;5219.060569097599;5219.791208351623;4415.66882483815;4573.291139873325;5148.948510514847;5160.225966105039;5216.4522725114075;5585.273914391103;5977.551683623833;6191.071339299051;6223.813285601439;6230.283517395467;5776.653400795965;5970.701464926649;5975.37258587842;5989.460948514655;6013.579049466495;4487.329337743299;4853.427683327701;5177.343250160064;5295.4439783822145;5897.233359663216;5120.3358908354185;5370.731463426735;5535.667859928417;5806.416144815516;6196.47329976939;3669.5779985300965;3828;3881.592432794516;3915.92168156641;3933.0924501617264;4750.477447480705;4778.880527986828;4972.0801651694555;5269.552088072557;6003;4982.62630302736;5298.436961096563;5725.799597014085;5730.997075511852;5740.851829634006;4749.667523273338;5325.2810870531985;5710.828675139753;5712.37163911961;5735.655860648374;4626.583607475343;4820.39745031871;4896.1921282987905;5447.346318441812;5663.9716801415725;5160.638755287094;5406.8648283791645;5518.862028449321;5621.213030175697;5769.653820770599;4986.429274778433;5034.924476132935;5036.773345199402;5541.944580554143;5636.126400407943 12:05:29 INFO - PROCESS | 1656 | |5;yui.html;682.7269092363057;730.2952650692081;737.3879679865712;789.0491957191581;866.1208872993913;14946.252687365615;15405.460808871692;15793.28930198141;16172.757408638865;16173.110478923654;14482.348294326754;14579.708405831903;15166.317515711791;15195.92402037991;15282.388704451809;722.8915662650618;891.933105017123;903.1871315815753;922.2253307221932;924.5053896165552;883.0595415882065;909.8271328447607;922.2345453273766;927.1933417926414;927.8144371125768;974.1476208317722;975.1223898491379;978.5743201707245;978.6721448314787;978.9902100979006;949.4730424614336;959.688101367055;972.7616733900239;974.2644303550809;974.4932635029816;682.8941514065327;705.6894966214849;718.7556230881526;719.2232389019898;720.6432815756234;13541.59375218745;15805.288762005737;15888.205589720583;15933.362665493367;15985.92007039969;15007.474738384213;15038.774418383733;15050.849491505054;15055.698886022219;15073.472428464951;11912.285262884168;12031.338276394796;12086.718165960629;12467.376631168405;12495;3824.694024478035;3865.323568375523;3978.2640211560665;4099.446574712406;4122.59831657235;118179;118518;119486;119991.40004299923;120116;11315.83026254607;11620.941895290469;11686.824697629543;11781.293122412682;11957;24857;24893.004279828965;24906.875465622557;24913;25021.374465638506;7493.66278517468;8275.379346549033;8495.40532162755;8638.13618638131;8724.302055835518;4484.417025786692;4681.157391669532;4705.788239529161;4739.004808990082;4840.95159048405;3701.722370822199;3798.3352913240074;3835.32881745699;3836.9831994521473;3841.5006049213425;613.7882430561449;648.5427773419727;671.6876652356677;674.3492529708855;694.7707256605308;618.5639124417276;620.4230066038538;688.4939569416475;692.9930700693029;698.1866125963196;7798.610069496503;9035.45787252767;9052.27581793455;9360.953195234117;9658.613655453702;585.2216551985848;587.823652904127;672.5661948043485;684.7979845945458;690.2579726793717;4525.434320709911;4735.905281894343;4736.928946065812;4739.9763001185465;4745.572898439157;94506;121553.39223304004;154573;156797;162896.185519074;118439;131216.3439182798;137191.94212086828;138418;144909;85326.57336713401;113744;117091.82908170809;117336.39954006797;118122.8187718129;9334.486603236886;9736.707898763048;10036.247281454067;10082.596696132367;10142.746431339276;62904.427389315635;64389.678051609444;64475.67762161347;65349.67325163344;65967.34032659612;62841;73883;89757;91376.08623913676;93674.53162734142;13319.467221311039;13754.793678095037;13857.37641806101;13882;14154.363053662815;14107.365168567234;14239.715205696035;14696.11823290606;15208.239588020333;15708.68582628364;13562.660933476742;13952.37214325378;14081.788773168206;14181.432742690176;14361.425542978583;14216.21810800416;14486.85513144855;14529.78205326942;14647.853521464649;15361.385544578092;14012.159270443806;14322.212278324376;14374.640633984234;14417.351219194952;14561.199134047729;11316.94341528287;11357;11440.313581185155;11718.824217636571;11981.341026243641;10731.731706707395;11618;11633.096218644703;11751.76496470083;11914.225575337576 12:05:29 INFO - PROCESS | 1656 | __end_tp_report 12:05:29 INFO - PROCESS | 1656 | __start_cc_report 12:05:29 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,433 12:05:29 INFO - PROCESS | 1656 | __end_cc_report 12:05:29 INFO - PROCESS | 1656 | __startTimestamp1467140729731__endTimestamp 12:05:29 INFO - PROCESS | 1656 | 12:05:29 INFO - PROCESS | 1656 | ------- Summary: start ------- 12:05:29 INFO - PROCESS | 1656 | Number of tests: 6 12:05:29 INFO - PROCESS | 1656 | 12:05:29 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5807.00 Median:6113.32 stddev:789.49 (12.9%) stddev-sans-first:758.98 12:05:29 INFO - PROCESS | 1656 | Values: 2930.5 3351.1 3429.6 3462.3 3483.9 5887.7 5936.3 5994.6 6008.9 6060.3 5793.0 5897.0 5958.4 5975.2 6064.2 4433.8 5288.7 5395.5 5409.1 5455.2 434.7 5295.9 5344.6 5409.1 5423.1 5312.3 5338.1 5375.5 5380.2 5386.3 5370.0 5436.3 5441.8 5462.2 5492.6 5247.5 5250.2 5296.2 5308.4 5364.3 5866.4 5929.1 5933.1 5953.6 6061.9 6190.2 6211.8 6254.9 6265.5 6272.8 6170.5 6200.8 6238.2 6296.3 6297.1 6012.0 6073.6 6081.5 6086.5 6088.3 6204.0 6271.9 6454.2 6454.5 6462.3 6177.4 6258.1 6265.7 6281.1 6308.7 6215.1 6228.8 6282.2 6326.7 6333.8 6180.5 6186.8 6212.1 6223.4 6267.0 6129.6 6189.7 6194.2 6205.7 6236.1 4998.2 5020.8 5027.1 5028.3 5037.1 3853.8 4379.0 4473.9 4497.5 4539.8 5993.1 6057.8 6111.5 6113.3 6138.4 6275.8 6333.9 6334.7 6359.8 6379.7 5308.9 6007.8 6074.3 6081.2 6108.5 5544.4 5570.5 5578.7 5591.4 5597.4 6542.0 6553.2 6553.2 6563.1 6576.1 5322.9 6161.5 6165.8 6217.8 6247.8 5669.8 5819.4 6474.3 6511.0 6521.0 5100.6 6200.7 6219.8 6266.2 6286.6 5623.9 6093.7 6225.4 6236.8 6262.6 6236.3 6240.6 6242.4 6256.6 6275.7 6123.6 6207.8 6268.5 6274.7 6293.2 5032.7 6033.6 6122.1 6166.3 6188.0 6211.8 6227.5 6242.6 6254.4 6272.5 5931.4 6117.3 6137.6 6148.3 6199.5 12:05:29 INFO - PROCESS | 1656 | 12:05:29 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:73647.74 Median:41826.29 stddev:163198.94 (390.2%) stddev-sans-first:163564.28 12:05:29 INFO - PROCESS | 1656 | Values: 472.4 525.3 529.8 545.6 566.6 37966.0 43597.6 43621.8 43634.0 43794.3 44323.0 44408.6 44790.6 44819.8 44923.3 8185.0 9777.5 9959.3 10032.1 10115.5 9767.1 9843.8 9870.6 9871.8 9896.2 9887.0 9902.2 9908.8 9926.2 9960.2 9863.4 9894.4 9899.9 9920.1 9935.4 9830.0 9900.8 9915.4 9916.4 9917.6 41791.8 41860.8 42097.6 42133.8 42280.2 3067.4 3440.9 3449.0 3965.9 4188.8 32259.0 32731.3 32891.0 32924.3 33873.3 3061.8 3277.2 3340.4 3342.7 3362.5 470721.0 471316.0 544559.0 545928.0 548975.0 66403.0 67065.0 67149.0 67156.0 67434.0 30060.4 36616.6 37055.6 38409.4 38456.0 16764.0 16766.6 16804.5 16931.9 16944.9 13241.0 13338.7 13339.6 13342.0 13380.1 17275.0 17738.5 20051.2 20681.6 20755.4 7921.4 8094.8 8131.1 8144.1 8203.7 865.6 891.4 1019.4 1120.7 1166.6 27247.5 30653.4 31452.7 31683.3 32035.7 1055.5 1065.8 1078.9 1158.8 1173.5 16587.9 16600.9 17421.4 17662.0 17995.6 720043.0 720944.0 726386.0 726877.0 729637.0 54852.7 63143.0 64430.0 65263.0 65364.0 1391.0 1420.5 1449.2 1452.9 1457.2 29074.0 31798.0 32873.7 33301.0 33346.5 56069.0 56274.7 56965.0 56979.0 57110.7 539474.0 541825.0 544087.0 545952.0 656432.0 28208.2 28230.6 28379.0 28661.9 28761.0 50463.0 51088.5 51331.0 51805.7 52228.6 41863.2 42091.2 42229.4 42943.0 43014.6 32976.0 40757.0 40759.8 40776.6 41208.6 34268.8 39994.0 40204.8 41087.0 41172.4 32379.0 33696.0 33947.0 36595.5 36709.8 26460.9 26697.1 26787.0 27023.9 27276.0 12:05:29 INFO - PROCESS | 1656 | 12:05:29 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:31426.44 Median:13030.31 stddev:82577.91 (633.7%) stddev-sans-first:82776.66 12:05:29 INFO - PROCESS | 1656 | Values: 377.6 378.2 381.3 393.6 403.0 20347.5 21223.5 21630.5 22142.4 22150.3 16036.7 20404.3 21023.6 22131.9 22201.7 5336.8 6013.5 6071.1 6074.9 6079.3 5500.2 5835.8 5896.6 6178.9 6192.5 5465.3 5949.0 6095.8 6120.4 6156.6 5182.3 6028.3 6099.8 6105.3 6123.1 4424.3 5312.7 5329.1 5330.4 5330.9 26281.5 27476.0 27598.0 27619.0 27681.0 2248.3 2297.5 2357.1 2393.0 3080.4 16191.6 16317.3 16402.7 16404.5 16472.9 1909.4 1975.3 1975.7 1991.9 2001.3 117497.0 122123.4 122452.0 122589.4 124248.8 11003.3 11435.8 11483.0 11485.6 11585.7 14074.6 14129.8 14139.9 14183.0 14201.6 7409.4 8861.0 8909.9 8917.8 9026.9 9028.0 9038.1 9050.8 9141.4 9183.4 6792.8 6810.5 6904.7 6926.2 6999.5 1849.1 1882.4 1882.4 1889.9 1899.5 848.2 922.2 932.4 937.3 996.5 22796.9 23271.5 23458.8 23510.9 23667.6 947.2 958.9 962.3 968.4 1070.4 10429.6 12164.8 12222.4 12484.7 12491.0 250392.0 251701.7 469090.0 645111.0 646048.0 121196.0 127022.0 127718.4 129346.0 129808.0 1027.3 1028.2 1063.2 1080.0 1085.7 16059.0 17169.7 19857.5 20182.7 20502.9 43660.6 50283.0 52857.7 53698.7 54360.2 72088.1 75566.0 75633.2 75816.2 76969.6 8262.5 8286.2 8327.7 8609.6 8971.7 9681.6 10775.9 13585.7 13725.2 14094.8 9506.5 11704.5 11764.1 11804.6 12014.0 10387.0 11632.2 11722.8 11736.2 11868.5 11981.9 12012.5 12051.9 12052.3 12060.3 8308.8 8365.7 8559.7 8577.2 8608.5 9590.9 11702.6 11868.2 11958.5 11964.9 12:05:29 INFO - PROCESS | 1656 | 12:05:29 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5775.52 Median:2363.36 stddev:3299.71 (139.6%) stddev-sans-first:3293.46 12:05:29 INFO - PROCESS | 1656 | Values: 1518.3 1554.8 1627.9 1668.9 1838.5 8122.8 8652.9 8668.5 9152.0 9155.6 8772.6 8810.7 8921.2 8930.8 8945.9 2333.1 2371.8 2374.4 2376.6 2380.5 2325.7 2332.6 2352.5 2368.2 2371.2 2345.5 2345.7 2352.5 2358.5 2367.4 2035.2 2333.9 2349.2 2350.9 2363.6 1990.0 2314.5 2328.6 2332.5 2342.9 8946.6 8954.5 8985.2 9022.0 9060.4 5155.8 5332.9 5342.8 5351.2 5362.4 3494.2 3564.9 3649.0 3658.3 3694.6 1082.1 1094.3 1103.6 1115.4 1116.1 11762.4 11913.3 11927.6 11927.9 11959.0 3782.4 4191.6 4294.8 4418.7 4433.4 10045.4 10050.2 10083.6 10099.9 10165.3 5336.4 5346.3 5350.6 5362.2 5375.4 4063.9 4192.4 4418.6 4861.0 4861.1 3537.6 3968.5 4025.3 4070.6 4083.3 1109.6 1279.9 1290.7 1301.6 1302.7 920.7 929.2 929.8 944.8 975.7 5998.3 6001.5 6068.8 6132.2 6168.5 417.7 421.4 432.0 432.5 433.0 3947.9 4059.0 4134.0 4144.3 4151.9 10539.0 10788.0 10942.5 10944.7 10953.5 10659.5 10912.9 10934.3 10961.5 11011.4 8242.1 8340.7 8376.0 8404.0 8484.2 5911.0 5959.0 5965.1 5968.9 6041.0 10144.3 10177.0 10177.1 10202.4 10309.6 9740.8 10121.8 10271.0 10307.4 10439.3 7077.3 7228.6 7513.0 7747.7 7774.3 8552.3 8622.2 8641.8 8666.5 8677.7 7522.9 7680.9 7729.9 7743.7 7800.9 7358.8 7522.0 7549.7 7647.0 7652.4 7034.1 7109.2 7109.6 7111.4 7115.5 4979.8 5108.5 5111.6 5183.5 5224.6 5184.4 5208.8 5232.2 5252.1 5327.6 12:05:29 INFO - PROCESS | 1656 | 12:05:29 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4390.15 Median:4802.07 stddev:1374.55 (28.6%) stddev-sans-first:1343.57 12:05:29 INFO - PROCESS | 1656 | Values: 293.3 300.2 306.3 309.3 313.5 4881.4 4929.8 4954.2 5258.2 5436.6 4468.6 4615.6 5405.2 5474.6 5507.3 3337.4 3410.3 3419.6 3940.0 4251.8 3431.6 3681.2 3905.7 3928.7 4240.6 3457.2 3994.7 4060.3 4068.8 4071.6 3475.2 3571.3 3634.8 3935.9 4075.1 3509.8 3511.8 3528.8 3537.4 3539.6 4899.7 4966.0 4977.8 4998.5 5261.4 4212.5 4527.5 4601.0 4619.4 4632.0 4563.8 5158.3 5284.7 5289.0 5422.0 3665.5 3838.8 3864.4 3873.6 3977.8 4846.0 5034.1 5137.1 5999.6 6097.7 3250.0 3484.6 3653.5 3919.8 4078.0 3455.6 3685.1 4109.7 4127.2 4137.4 4441.5 4754.7 4797.3 4800.5 4806.8 5753.5 5834.4 5853.7 5856.9 5897.5 1174.0 1268.0 1330.5 1377.9 1408.8 833.4 848.3 855.4 874.2 878.4 4270.1 4304.7 4524.3 4540.8 4544.8 4803.6 5029.3 5040.7 5061.6 5065.4 4203.6 4257.8 4349.5 4357.6 4652.2 1976.0 2311.7 2449.4 2527.9 2666.6 4559.7 4787.5 5163.6 5219.1 5219.8 4415.7 4573.3 5148.9 5160.2 5216.5 5585.3 5977.6 6191.1 6223.8 6230.3 5776.7 5970.7 5975.4 5989.5 6013.6 4487.3 4853.4 5177.3 5295.4 5897.2 5120.3 5370.7 5535.7 5806.4 6196.5 3669.6 3828.0 3881.6 3915.9 3933.1 4750.5 4778.9 4972.1 5269.6 6003.0 4982.6 5298.4 5725.8 5731.0 5740.9 4749.7 5325.3 5710.8 5712.4 5735.7 4626.6 4820.4 4896.2 5447.3 5664.0 5160.6 5406.9 5518.9 5621.2 5769.7 4986.4 5034.9 5036.8 5541.9 5636.1 12:05:29 INFO - PROCESS | 1656 | 12:05:29 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:25130.92 Median:14361.55 stddev:39608.15 (275.8%) stddev-sans-first:39676.72 12:05:29 INFO - PROCESS | 1656 | Values: 682.7 730.3 737.4 789.0 866.1 14946.3 15405.5 15793.3 16172.8 16173.1 14482.3 14579.7 15166.3 15195.9 15282.4 722.9 891.9 903.2 922.2 924.5 883.1 909.8 922.2 927.2 927.8 974.1 975.1 978.6 978.7 979.0 949.5 959.7 972.8 974.3 974.5 682.9 705.7 718.8 719.2 720.6 13541.6 15805.3 15888.2 15933.4 15985.9 15007.5 15038.8 15050.8 15055.7 15073.5 11912.3 12031.3 12086.7 12467.4 12495.0 3824.7 3865.3 3978.3 4099.4 4122.6 118179.0 118518.0 119486.0 119991.4 120116.0 11315.8 11620.9 11686.8 11781.3 11957.0 24857.0 24893.0 24906.9 24913.0 25021.4 7493.7 8275.4 8495.4 8638.1 8724.3 4484.4 4681.2 4705.8 4739.0 4841.0 3701.7 3798.3 3835.3 3837.0 3841.5 613.8 648.5 671.7 674.3 694.8 618.6 620.4 688.5 693.0 698.2 7798.6 9035.5 9052.3 9361.0 9658.6 585.2 587.8 672.6 684.8 690.3 4525.4 4735.9 4736.9 4740.0 4745.6 94506.0 121553.4 154573.0 156797.0 162896.2 118439.0 131216.3 137191.9 138418.0 144909.0 85326.6 113744.0 117091.8 117336.4 118122.8 9334.5 9736.7 10036.2 10082.6 10142.7 62904.4 64389.7 64475.7 65349.7 65967.3 62841.0 73883.0 89757.0 91376.1 93674.5 13319.5 13754.8 13857.4 13882.0 14154.4 14107.4 14239.7 14696.1 15208.2 15708.7 13562.7 13952.4 14081.8 14181.4 14361.4 14216.2 14486.9 14529.8 14647.9 15361.4 14012.2 14322.2 14374.6 14417.4 14561.2 11316.9 11357.0 11440.3 11718.8 11981.3 10731.7 11618.0 11633.1 11751.8 11914.2 12:05:29 INFO - PROCESS | 1656 | -------- Summary: end -------- 12:05:29 INFO - PROCESS | 1656 | 12:05:30 INFO - TEST-INFO | 1656: exit 0 12:05:30 INFO - TEST-OK | dromaeo_css | took 1112694ms 12:05:30 INFO - TEST-START | kraken 12:05:30 INFO - operating with platform_type : mac_ 12:05:30 INFO - Initialising browser for kraken test... 12:05:30 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpfwQGRR/profile http://localhost:49266/getInfo.html) 12:05:33 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 12:05:33 INFO - PROCESS | 1665 | colorDepth:24 12:05:33 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 12:05:33 INFO - PROCESS | 1665 | __metrics 12:05:33 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 12:05:34 INFO - TEST-INFO | 1665: exit 0 12:05:34 INFO - Browser initialized. 12:05:34 INFO - Running cycle 1/1 for kraken test... 12:05:34 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpfwQGRR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:05:46 INFO - PROCESS | 1667 | RSS: Main: 255184896 12:05:46 INFO - PROCESS | 1667 | 12:05:48 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 12:05:49 INFO - PROCESS | 1667 | RSS: Main: 268242944 12:05:49 INFO - PROCESS | 1667 | 12:05:52 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 12:05:52 INFO - PROCESS | 1667 | RSS: Main: 271745024 12:05:52 INFO - PROCESS | 1667 | 12:05:56 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 12:05:57 INFO - PROCESS | 1667 | RSS: Main: 272248832 12:05:57 INFO - PROCESS | 1667 | 12:05:59 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 12:05:59 INFO - PROCESS | 1667 | RSS: Main: 273289216 12:05:59 INFO - PROCESS | 1667 | 12:06:02 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:06:02 INFO - PROCESS | 1667 | RSS: Main: 273879040 12:06:02 INFO - PROCESS | 1667 | 12:06:05 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 12:06:06 INFO - PROCESS | 1667 | RSS: Main: 274006016 12:06:06 INFO - PROCESS | 1667 | 12:06:09 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 12:06:09 INFO - PROCESS | 1667 | RSS: Main: 274280448 12:06:09 INFO - PROCESS | 1667 | 12:06:12 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 12:06:13 INFO - PROCESS | 1667 | RSS: Main: 274489344 12:06:13 INFO - PROCESS | 1667 | 12:06:14 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:06:15 INFO - PROCESS | 1667 | RSS: Main: 274341888 12:06:15 INFO - PROCESS | 1667 | 12:06:17 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:06:18 INFO - PROCESS | 1667 | RSS: Main: 274751488 12:06:18 INFO - PROCESS | 1667 | 12:06:20 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:06:21 INFO - PROCESS | 1667 | RSS: Main: 274829312 12:06:21 INFO - PROCESS | 1667 | 12:06:24 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:06:24 INFO - PROCESS | 1667 | RSS: Main: 275124224 12:06:24 INFO - PROCESS | 1667 | 12:06:27 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:06:28 INFO - PROCESS | 1667 | RSS: Main: 274657280 12:06:28 INFO - PROCESS | 1667 | 12:06:29 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 12:06:30 INFO - PROCESS | 1667 | RSS: Main: 275464192 12:06:30 INFO - PROCESS | 1667 | 12:06:30 INFO - PROCESS | 1667 | __start_tp_report 12:06:30 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 12:06:30 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 12:06:30 INFO - PROCESS | 1667 | |i|pagename|runs| 12:06:30 INFO - PROCESS | 1667 | |0;ai-astar;105;165;103;115;115;117;112;116;116;115 12:06:30 INFO - PROCESS | 1667 | |1;audio-beat-detection;136;109;135;188;144;163;137;148;173;142 12:06:30 INFO - PROCESS | 1667 | |2;audio-dft;249;217;212;245;192;236;268;272;198;225 12:06:30 INFO - PROCESS | 1667 | |3;audio-fft;71;85;70;157;80;79;84;59;129;60 12:06:30 INFO - PROCESS | 1667 | |4;audio-oscillator;69;72;130;70;74;90;142;95;63;120 12:06:30 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;89;87;89;87;109;111;89;87;90;103 12:06:30 INFO - PROCESS | 1667 | |6;imaging-darkroom;102;150;117;147;96;95;96;96;96;95 12:06:30 INFO - PROCESS | 1667 | |7;imaging-desaturate;97;95;91;91;94;96;91;137;145;91 12:06:30 INFO - PROCESS | 1667 | |8;json-parse-financial;57;58;54;57;56;57;58;55;58;57 12:06:30 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;68;71;71;78;78;74;76;69;71;70 12:06:30 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;86;97;112;83;85;97;87;89;107;85 12:06:30 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;136;147;142;165;159;145;158;147;156;162 12:06:30 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;169;172;169;163;171;163;168;164;168;163 12:06:30 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;70;66;67;66;68;67;68;69;66;68 12:06:30 INFO - PROCESS | 1667 | __end_tp_report 12:06:30 INFO - PROCESS | 1667 | __start_cc_report 12:06:30 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1129 12:06:30 INFO - PROCESS | 1667 | __end_cc_report 12:06:30 INFO - PROCESS | 1667 | __startTimestamp1467140790124__endTimestamp 12:06:30 INFO - PROCESS | 1667 | 12:06:30 INFO - PROCESS | 1667 | ------- Summary: start ------- 12:06:30 INFO - PROCESS | 1667 | Number of tests: 14 12:06:30 INFO - PROCESS | 1667 | 12:06:30 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:117.90 Median:115.50 stddev:17.24 (14.9%) stddev-sans-first:17.64 12:06:30 INFO - PROCESS | 1667 | Values: 105.0 165.0 103.0 115.0 115.0 117.0 112.0 116.0 116.0 115.0 12:06:30 INFO - PROCESS | 1667 | 12:06:30 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:146.00 stddev:22.25 (15.2%) stddev-sans-first:23.20 12:06:30 INFO - PROCESS | 1667 | Values: 136.0 109.0 135.0 188.0 144.0 163.0 137.0 148.0 173.0 142.0 12:06:30 INFO - PROCESS | 1667 | 12:06:30 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:231.40 Median:240.50 stddev:27.48 (11.4%) stddev-sans-first:28.40 12:06:30 INFO - PROCESS | 1667 | Values: 249.0 217.0 212.0 245.0 192.0 236.0 268.0 272.0 198.0 225.0 12:06:30 INFO - PROCESS | 1667 | 12:06:30 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:87.40 Median:75.00 stddev:31.35 (41.8%) stddev-sans-first:32.69 12:06:30 INFO - PROCESS | 1667 | Values: 71.0 85.0 70.0 157.0 80.0 79.0 84.0 59.0 129.0 60.0 12:06:30 INFO - PROCESS | 1667 | 12:06:30 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:71.00 stddev:28.51 (40.2%) stddev-sans-first:28.95 12:06:30 INFO - PROCESS | 1667 | Values: 69.0 72.0 130.0 70.0 74.0 90.0 142.0 95.0 63.0 120.0 12:06:30 INFO - PROCESS | 1667 | 12:06:30 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:94.10 Median:88.00 stddev:9.62 (10.9%) stddev-sans-first:10.02 12:06:30 INFO - PROCESS | 1667 | Values: 89.0 87.0 89.0 87.0 109.0 111.0 89.0 87.0 90.0 103.0 12:06:30 INFO - PROCESS | 1667 | 12:06:30 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:109.00 Median:95.50 stddev:21.87 (22.9%) stddev-sans-first:23.05 12:06:30 INFO - PROCESS | 1667 | Values: 102.0 150.0 117.0 147.0 96.0 95.0 96.0 96.0 96.0 95.0 12:06:30 INFO - PROCESS | 1667 | 12:06:30 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:102.80 Median:92.50 stddev:20.35 (22.0%) stddev-sans-first:21.47 12:06:30 INFO - PROCESS | 1667 | Values: 97.0 95.0 91.0 91.0 94.0 96.0 91.0 137.0 145.0 91.0 12:06:30 INFO - PROCESS | 1667 | 12:06:30 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:1.34 (2.3%) stddev-sans-first:1.41 12:06:30 INFO - PROCESS | 1667 | Values: 57.0 58.0 54.0 57.0 56.0 57.0 58.0 55.0 58.0 57.0 12:06:30 INFO - PROCESS | 1667 | 12:06:30 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:72.60 Median:72.50 stddev:3.66 (5.0%) stddev-sans-first:3.48 12:06:30 INFO - PROCESS | 1667 | Values: 68.0 71.0 71.0 78.0 78.0 74.0 76.0 69.0 71.0 70.0 12:06:30 INFO - PROCESS | 1667 | 12:06:30 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:92.80 Median:86.50 stddev:10.10 (11.7%) stddev-sans-first:10.41 12:06:30 INFO - PROCESS | 1667 | Values: 86.0 97.0 112.0 83.0 85.0 97.0 87.0 89.0 107.0 85.0 12:06:30 INFO - PROCESS | 1667 | 12:06:30 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:151.70 Median:157.00 stddev:9.57 (6.1%) stddev-sans-first:8.29 12:06:30 INFO - PROCESS | 1667 | Values: 136.0 147.0 142.0 165.0 159.0 145.0 158.0 147.0 156.0 162.0 12:06:30 INFO - PROCESS | 1667 | 12:06:30 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:168.50 stddev:3.46 (2.1%) stddev-sans-first:3.60 12:06:30 INFO - PROCESS | 1667 | Values: 169.0 172.0 169.0 163.0 171.0 163.0 168.0 164.0 168.0 163.0 12:06:30 INFO - PROCESS | 1667 | 12:06:30 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.35 (2.0%) stddev-sans-first:1.09 12:06:30 INFO - PROCESS | 1667 | Values: 70.0 66.0 67.0 66.0 68.0 67.0 68.0 69.0 66.0 68.0 12:06:30 INFO - PROCESS | 1667 | -------- Summary: end -------- 12:06:30 INFO - PROCESS | 1667 | 12:06:30 INFO - TEST-INFO | 1667: exit 0 12:06:30 INFO - TEST-OK | kraken | took 60579ms 12:06:30 INFO - SUITE-END | took 1173s 12:06:31 INFO - Completed test suite (00:19:33) 12:06:31 INFO - javascript benchmark 12:06:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7463.983163728739, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2930.4871647461696, 3351.0784534253085, 3429.6055953565346, 3462.3421549905515, 3483.8954831355054, 5887.676177810219, 5936.347001829795, 5994.58037937344, 6008.922460520864, 6060.333363330041, 5793.0, 5897.0, 5958.43394877487, 5975.1933488978975, 6064.151018857364, 4433.847199728078, 5288.735563221823, 5395.514403703666, 5409.080456322435, 5455.208994695767, 434.6544360118738, 5295.867603309929, 5344.5724342052545, 5409.107497262967, 5423.050966080939, 5312.335958005249, 5338.145896656516, 5375.516203541681, 5380.24676545284, 5386.326709161355, 5370.0, 5436.293281873332, 5441.83674489766, 5462.153366228241, 5492.588055895823, 5247.501487358695, 5250.18622113573, 5296.179092240709, 5308.416074231832, 5364.302640656729, 5866.384029676908, 5929.110633404981, 5933.080372542219, 5953.642781433128, 6061.909071363889, 6190.195274614316, 6211.751529938797, 6254.874902501924, 6265.530085243625, 6272.843178920518, 6170.475509581691, 6200.813975580695, 6238.1578486904145, 6296.307406185316, 6297.149884765544, 6012.008018676913, 6073.635581865102, 6081.513478921675, 6086.513078953673, 6088.330283668793, 6204.0, 6271.937280627135, 6454.225492940877, 6454.451371633464, 6462.321456247027, 6177.444030037318, 6258.061290806324, 6265.65538895356, 6281.089242059968, 6308.653024083719, 6215.06773983906, 6228.844278893064, 6282.2147231596055, 6326.746930122744, 6333.841653958688, 6180.505559555225, 6186.81439556814, 6212.099245609361, 6223.377662233831, 6266.968665156645, 6129.603311142676, 6189.721462534197, 6194.163787888668, 6205.6586887721605, 6236.095766113888, 4998.2002879539095, 5020.7740651670765, 5027.095122877844, 5028.34631497903, 5037.143685573461, 3853.788041657736, 4378.956210437918, 4473.932891006638, 4497.482789479186, 4539.75031373271, 5993.101034844721, 6057.787977420858, 6111.5110791137495, 6113.3198322145345, 6138.355472675305, 6275.811725648238, 6333.873322533524, 6334.651594162273, 6359.841003974938, 6379.71291291893, 5308.893822123536, 6007.849803754941, 6074.301455332693, 6081.17904082952, 6108.511319094462, 5544.417836127229, 5570.498655120978, 5578.693171875586, 5591.412901645269, 5597.440255974451, 6541.967290163519, 6553.246376666649, 6553.246376666649, 6563.146790917151, 6576.145101136822, 5322.866928326823, 6161.537884658758, 6165.753369865155, 6217.751289948533, 6247.781327653511, 5669.801556945487, 5819.447152520504, 6474.320196379501, 6511.0, 6520.967395162994, 5100.566451851634, 6200.650140201954, 6219.751209951552, 6266.216722909637, 6286.5599408041, 5623.943760562342, 6093.725782339717, 6225.439710426083, 6236.781712640217, 6262.5929314594405, 6236.345183755821, 6240.625562466085, 6242.438180563771, 6256.593321434092, 6275.686215689106, 6123.618175568127, 6207.844803879939, 6268.52986026059, 6274.74901003973, 6293.213348331458, 5032.6980381177245, 6033.607815491979, 6122.081687746873, 6166.290876549254, 6188.009918413032, 6211.81364559064, 6227.50179985591, 6242.5942313749465, 6254.437100660963, 6272.529560282906, 5931.377205393372, 6117.3402608778015, 6137.631742095488, 6148.292946311052, 6199.504039676905], "value": 5758.156183591425, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.4212839271892, 525.2541391224462, 529.7616072767256, 545.6316986034426, 566.6005466146368, 37966.0, 43597.564024359745, 43621.78189109058, 43633.99999999996, 43794.343084853754, 44323.0, 44408.55591444085, 44790.55209447905, 44819.77590112045, 44923.32615010769, 8185.0, 9777.511124443767, 9959.302848800588, 10032.147267482273, 10115.533247679083, 9767.120959113678, 9843.803123937518, 9870.60517579296, 9871.802563948717, 9896.208303335752, 9886.950565247163, 9902.207823374112, 9908.752281192956, 9926.156276716487, 9960.20318374532, 9863.358881672668, 9894.356866803706, 9899.851502227473, 9920.10719035283, 9935.403875767404, 9830.0, 9900.752481188028, 9915.355501892425, 9916.405015699082, 9917.553710083064, 41791.7910410446, 41860.79069604663, 42097.57902420967, 42133.78933105346, 42280.15439691189, 3067.3558552703958, 3440.8795692150657, 3449.0, 3965.861194858195, 4188.7905604719945, 32259.0, 32731.34537309264, 32891.0, 32924.34151316984, 33873.32253354919, 3061.7698328263673, 3277.2298509850166, 3340.4321265384942, 3342.665733426662, 3362.5124356968104, 470721.0, 471316.0, 544559.0, 545927.999999996, 548975.0, 66403.00395494071, 67065.0, 67149.0, 67156.0, 67434.0, 30060.398792024036, 36616.63383366132, 37055.62944370576, 38409.42385864214, 38456.03859903469, 16764.0, 16766.580835478966, 16804.495865124067, 16931.91534042322, 16944.89858159216, 13241.0, 13338.73322533544, 13339.599812005656, 13342.0, 13380.130291531214, 17275.0, 17738.467845964642, 20051.197952081755, 20681.58636827255, 20755.377338679864, 7921.445498815027, 8094.838103237902, 8131.064927533291, 8144.14486478923, 8203.671853125927, 865.5845194306768, 891.3715830339595, 1019.3578045831078, 1120.6581992492368, 1166.6150170443902, 27247.455050898872, 30653.386932261677, 31452.685473144975, 31683.257420841615, 32035.679643203268, 1055.4933631856752, 1065.7761870007384, 1078.9352638841694, 1158.7578036499401, 1173.524722487394, 16587.92178508417, 16600.916995414944, 17421.390251341396, 17662.0, 17995.550111247325, 720043.0, 720944.0, 726386.0, 726877.0, 729637.0, 54852.72573637106, 63143.0, 64430.0, 65263.0, 65364.0, 1390.9513167039106, 1420.4744244629553, 1449.166729130754, 1452.869241768267, 1457.242234038294, 29073.98241061553, 31798.0, 32873.67126328706, 33301.0, 33346.499802503466, 56069.0, 56274.718626406604, 56965.0, 56979.0, 57110.714446427504, 539474.0, 541825.0, 544087.0, 545952.0, 656432.0, 28208.166469180258, 28230.576541351486, 28379.0, 28661.856690716413, 28760.993365232116, 50463.0, 51088.48911510837, 51330.97338053293, 51805.7409712949, 52228.605140665735, 41863.162736745704, 42091.15817683691, 42229.36655950102, 42943.0, 43014.56985430106, 32976.010719678445, 40757.0, 40759.777206683844, 40776.59223407728, 41208.58791412047, 34268.82865585656, 39994.000149996486, 40204.79897600493, 41087.0, 41172.38241426441, 32379.028629141165, 33696.0, 33947.0, 36595.45106823453, 36709.81645091758, 26460.8676956614, 26697.065602703813, 26787.0, 27023.864880676258, 27276.0], "value": 20697.787904911824, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.58654273570437, 378.22463948904755, 381.3459916243643, 393.57690482731033, 402.97380670256433, 20347.49131271717, 21223.469413264676, 21630.459238519044, 22142.446438839015, 22150.33548993529, 16036.679266414665, 20404.285849995253, 21023.57952840946, 22131.889340553316, 22201.666974995387, 5336.786528538873, 6013.51891848651, 6071.089336599523, 6074.908876366858, 6079.331273559905, 5500.1749737539285, 5835.824925252249, 5896.646201227919, 6178.907316390258, 6192.535559833008, 5465.289512363407, 5949.048152295633, 6095.756169753205, 6120.387961203888, 6156.5998210116195, 5182.300389447433, 6028.2766068072115, 6099.817005489843, 6105.32841387447, 6123.081537769348, 4424.292113261863, 5312.707801070939, 5329.067413202674, 5330.440303768088, 5330.946690533084, 26281.474370512482, 27476.0, 27598.0, 27619.03333383342, 27681.0, 2248.2693124734365, 2297.5060362022077, 2357.116081469449, 2392.9760702392928, 3080.368524452482, 16191.595210119724, 16317.265723042492, 16402.67194656112, 16404.507864764077, 16472.917635411864, 1909.446260584429, 1975.3481351154228, 1975.7135215393687, 1991.9402417927486, 2001.3495613925531, 117497.0, 122123.38938305252, 122452.0, 122589.38705306506, 124248.75751242462, 11003.284786488852, 11435.771284574428, 11483.0, 11485.598004069818, 11585.6524304271, 14074.577762667137, 14129.78805317921, 14139.929300353639, 14183.0, 14201.573952781433, 7409.370203532652, 8861.0, 8909.910900890907, 8917.821643567093, 9026.86459703105, 9028.006919238878, 9038.051004644549, 9050.773730656787, 9141.405808622418, 9183.357164998386, 6792.76225332111, 6810.489213308922, 6904.653592549505, 6926.168859736864, 6999.510034297652, 1849.1493912799995, 1882.4258601126514, 1882.4352694191962, 1889.9433017009512, 1899.5061284066242, 848.1815048478124, 922.1516205091332, 932.4032619123766, 937.2876613773581, 996.4718699089494, 22796.860156992083, 23271.534569308857, 23458.827058647, 23510.882445587664, 23667.644985325234, 947.2185447006248, 958.8705524754208, 962.259060523407, 968.3657204530903, 1070.3952266969138, 10429.5828166874, 12164.81752773709, 12222.449989750483, 12484.687882803002, 12491.000719942384, 250392.0, 251701.74149129138, 469090.0, 645111.0, 646048.0, 121196.0, 127022.0, 127718.36140819422, 129346.0, 129808.0, 1027.2963020331097, 1028.1517747857897, 1063.1707268330715, 1080.044160917578, 1085.6525911708336, 16058.956167849052, 17169.656606868044, 19857.503562411057, 20182.69725954141, 20502.897485513073, 43660.56339436565, 50283.0, 52857.7357113212, 53698.65753356197, 54360.18459723186, 72088.1164753404, 75566.0, 75633.24366756262, 75816.24183758312, 76969.61515192388, 8262.462939908886, 8286.212809783061, 8327.708530201415, 8609.612567434606, 8971.699103630068, 9681.564329605044, 10775.892241077803, 13585.660358491117, 13725.176489410667, 14094.788578171541, 9506.47714375716, 11704.473298701749, 11764.117691173367, 11804.586839460577, 12014.0, 10387.0, 11632.243904146204, 11722.824157637471, 11736.178467507192, 11868.465919033837, 11981.880181198076, 12012.459439325427, 12051.879481205076, 12052.337121458404, 12060.336681482602, 8308.750737477885, 8365.707200247962, 8559.657613695632, 8577.185167409087, 8608.48349099056, 9590.856137158087, 11702.648920532058, 11868.228565143238, 11958.521659133885, 11964.880351196725], "value": 9948.699842385146, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.2788175616581, 1554.8056492938383, 1627.9186040697962, 1668.8915220510667, 1838.5495553589374, 8122.837543249147, 8652.870206946885, 8668.523231222289, 9152.0, 9155.587998540073, 8772.649094036247, 8810.691625793099, 8921.241694455979, 8930.776730581723, 8945.910540894589, 2333.055112679359, 2371.7983971362455, 2374.4063984004, 2376.572217000939, 2380.5238952209543, 2325.662778897059, 2332.603457412244, 2352.5177338645535, 2368.159303447277, 2371.229350461107, 2345.472268739537, 2345.6833327500826, 2352.4706940938236, 2358.5282943411385, 2367.3726462487452, 2035.155410504639, 2333.9299821005397, 2349.166046053652, 2350.8707021113833, 2363.5745565798147, 1989.980100198994, 2314.479242170515, 2328.639060945556, 2332.4518738096535, 2342.8945697443655, 8946.597403116875, 8954.507502087383, 8985.191332780016, 9021.954890225506, 9060.365774395796, 5155.793768249303, 5332.893342133174, 5342.839714808562, 5351.170568561879, 5362.383325917531, 3494.2487365216602, 3564.928701425957, 3649.0, 3658.304922064799, 3694.6305369463107, 1082.1342925659442, 1094.3324572011068, 1103.5751235774205, 1115.4255558387438, 1116.0680831505701, 11762.353070581115, 11913.285202887768, 11927.582534611334, 11927.940360298144, 11959.0, 3782.432635104701, 4191.601797829201, 4294.754521188883, 4418.7127836690515, 4433.4236549249035, 10045.447500387549, 10050.246231532665, 10083.596656133672, 10099.899001009895, 10165.339252948535, 5336.439673834269, 5346.304980352529, 5350.571954243729, 5362.195670649356, 5375.354957405137, 4063.9390409143884, 4192.350185721218, 4418.624416924533, 4860.9513904861205, 4861.124997500484, 3537.5931767846514, 3968.4840970674204, 4025.3156963316305, 4070.5929407059057, 4083.3466645336603, 1109.606089838112, 1279.9168054076456, 1290.6515240884908, 1301.5509649171022, 1302.7459645369063, 920.6593560382568, 929.2426672262085, 929.8330595103102, 944.8252073366449, 975.673149494913, 5998.340182579913, 6001.549883758736, 6068.787592434243, 6132.17215675878, 6168.506519478431, 417.7493503897637, 421.3784667615243, 431.95680431956555, 432.5458268817729, 432.95453977332556, 3947.9013024674614, 4059.0258337998666, 4134.049168691157, 4144.316187829035, 4151.854685086068, 10539.0, 10787.975142361463, 10942.45287735626, 10944.671659850217, 10953.507092180871, 10659.467026648637, 10912.945435272773, 10934.289271197347, 10961.451927403597, 11011.449427528592, 8242.093369729326, 8340.708075217339, 8375.953005874266, 8403.991521017395, 8484.236418722345, 5910.965581023218, 5958.986972214647, 5965.075413310944, 5968.943944567717, 6041.033434650435, 10144.28989970695, 10177.033181847713, 10177.08406243412, 10202.38785672862, 10309.639162629272, 9740.805183896424, 10121.797564048826, 10271.0, 10307.381557106597, 10439.321444106108, 7077.327653872874, 7228.63856807147, 7513.0, 7747.690092396241, 7774.339181169664, 8552.315814734682, 8622.180892815173, 8641.827163456821, 8666.480011199348, 8677.739667809976, 7522.924770752223, 7680.884786728316, 7729.884051739116, 7743.690252389842, 7800.92199078002, 7358.77923662291, 7521.962390188014, 7549.660265287966, 7646.9617651911385, 7652.426068044808, 7034.085568876013, 7109.182444019004, 7109.644517774194, 7111.43108551325, 7115.501914865909, 4979.825706100269, 5108.489151084862, 5111.642185047011, 5183.533481986639, 5224.634275600672, 5184.377874655065, 5208.817691380935, 5232.215167724872, 5252.133397989442, 5327.600429967691], "value": 4534.568427225507, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.3399850336742, 300.2089494182828, 306.3321958131274, 309.3380166443809, 313.49527261109625, 4881.365422495075, 4929.781598280774, 4954.232094025432, 5258.158694608864, 5436.646617969835, 4468.575485328888, 4615.568934016231, 5405.243265942771, 5474.644148130379, 5507.256520369759, 3337.449320862067, 3410.334984677989, 3419.6238413774463, 3940.034691500586, 4251.787410629471, 3431.575896003156, 3681.208540163864, 3905.7461265017682, 3928.7249892507534, 4240.618344349008, 3457.239407330396, 3994.7403418777685, 4060.2894493463673, 4068.7965601719943, 4071.5928407159345, 3475.2354482013916, 3571.2678900825267, 3634.7637403568683, 3935.862244821432, 4075.086313285985, 3509.7543171977973, 3511.8244087795765, 3528.8235588220487, 3537.398642230827, 3539.6460353964653, 4899.730514821684, 4966.0, 4977.800887964513, 4998.450170481244, 5261.394939581959, 4212.49450065994, 4527.501974782771, 4600.975570748893, 4619.422572178478, 4631.976840115778, 4563.771811409416, 5158.323544847939, 5284.682919024833, 5289.0, 5421.972890135524, 3665.5234819473562, 3838.769673819552, 3864.420336949452, 3873.573906870242, 3977.781222032787, 4845.951540484585, 5034.0686972910125, 5137.12668846297, 5999.580029397944, 6097.69511524422, 3249.951250731241, 3484.564429446319, 3653.488511608377, 3919.8040097994985, 4077.980504873722, 3455.568053993251, 3685.0787303174206, 4109.671226301889, 4127.195196936628, 4137.386419296477, 4441.489228738672, 4754.690945088558, 4797.328374027639, 4800.5199480051715, 4806.759662016885, 5753.51095156908, 5834.445727655866, 5853.707314634251, 5856.8535786604825, 5897.52819774417, 1173.9823902641467, 1267.9746405071846, 1330.5010621017118, 1377.937992790327, 1408.767328587486, 833.441594131933, 848.3086284677968, 855.3755758296478, 874.191372979991, 878.3807415771865, 4270.139006865407, 4304.653963589851, 4524.25349817283, 4540.84107056258, 4544.841200429835, 4803.615710743132, 5029.321041659402, 5040.747962601855, 5061.5950723942, 5065.44195181431, 4203.642690371353, 4257.765822879772, 4349.543297953733, 4357.629601483909, 4652.209124448784, 1975.9506012349807, 2311.7457079721216, 2449.35092200567, 2527.8892125075768, 2666.613361052242, 4559.71700375729, 4787.468010236691, 5163.586913046947, 5219.060569097599, 5219.791208351623, 4415.66882483815, 4573.291139873325, 5148.948510514847, 5160.225966105039, 5216.4522725114075, 5585.273914391103, 5977.551683623833, 6191.071339299051, 6223.813285601439, 6230.283517395467, 5776.653400795965, 5970.701464926649, 5975.37258587842, 5989.460948514655, 6013.579049466495, 4487.329337743299, 4853.427683327701, 5177.343250160064, 5295.4439783822145, 5897.233359663216, 5120.3358908354185, 5370.731463426735, 5535.667859928417, 5806.416144815516, 6196.47329976939, 3669.5779985300965, 3828.0, 3881.592432794516, 3915.92168156641, 3933.0924501617264, 4750.477447480705, 4778.880527986828, 4972.0801651694555, 5269.552088072557, 6003.0, 4982.62630302736, 5298.436961096563, 5725.799597014085, 5730.997075511852, 5740.851829634006, 4749.667523273338, 5325.2810870531985, 5710.828675139753, 5712.37163911961, 5735.655860648374, 4626.583607475343, 4820.39745031871, 4896.1921282987905, 5447.346318441812, 5663.9716801415725, 5160.638755287094, 5406.8648283791645, 5518.862028449321, 5621.213030175697, 5769.653820770599, 4986.429274778433, 5034.924476132935, 5036.773345199402, 5541.944580554143, 5636.126400407943], "value": 3956.803640815269, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.7269092363057, 730.2952650692081, 737.3879679865712, 789.0491957191581, 866.1208872993913, 14946.252687365615, 15405.460808871692, 15793.28930198141, 16172.757408638865, 16173.110478923654, 14482.348294326754, 14579.708405831903, 15166.317515711791, 15195.92402037991, 15282.388704451809, 722.8915662650618, 891.933105017123, 903.1871315815753, 922.2253307221932, 924.5053896165552, 883.0595415882065, 909.8271328447607, 922.2345453273766, 927.1933417926414, 927.8144371125768, 974.1476208317722, 975.1223898491379, 978.5743201707245, 978.6721448314787, 978.9902100979006, 949.4730424614336, 959.688101367055, 972.7616733900239, 974.2644303550809, 974.4932635029816, 682.8941514065327, 705.6894966214849, 718.7556230881526, 719.2232389019898, 720.6432815756234, 13541.59375218745, 15805.288762005737, 15888.205589720583, 15933.362665493367, 15985.92007039969, 15007.474738384213, 15038.774418383733, 15050.849491505054, 15055.698886022219, 15073.472428464951, 11912.285262884168, 12031.338276394796, 12086.718165960629, 12467.376631168405, 12495.0, 3824.694024478035, 3865.323568375523, 3978.2640211560665, 4099.446574712406, 4122.59831657235, 118179.0, 118518.0, 119486.0, 119991.40004299923, 120116.0, 11315.83026254607, 11620.941895290469, 11686.824697629543, 11781.293122412682, 11957.0, 24857.0, 24893.004279828965, 24906.875465622557, 24913.0, 25021.374465638506, 7493.66278517468, 8275.379346549033, 8495.40532162755, 8638.13618638131, 8724.302055835518, 4484.417025786692, 4681.157391669532, 4705.788239529161, 4739.004808990082, 4840.95159048405, 3701.722370822199, 3798.3352913240074, 3835.32881745699, 3836.9831994521473, 3841.5006049213425, 613.7882430561449, 648.5427773419727, 671.6876652356677, 674.3492529708855, 694.7707256605308, 618.5639124417276, 620.4230066038538, 688.4939569416475, 692.9930700693029, 698.1866125963196, 7798.610069496503, 9035.45787252767, 9052.27581793455, 9360.953195234117, 9658.613655453702, 585.2216551985848, 587.823652904127, 672.5661948043485, 684.7979845945458, 690.2579726793717, 4525.434320709911, 4735.905281894343, 4736.928946065812, 4739.9763001185465, 4745.572898439157, 94506.0, 121553.39223304004, 154573.0, 156797.0, 162896.185519074, 118439.0, 131216.3439182798, 137191.94212086828, 138418.0, 144909.0, 85326.57336713401, 113744.0, 117091.82908170809, 117336.39954006797, 118122.8187718129, 9334.486603236886, 9736.707898763048, 10036.247281454067, 10082.596696132367, 10142.746431339276, 62904.427389315635, 64389.678051609444, 64475.67762161347, 65349.67325163344, 65967.34032659612, 62841.0, 73883.0, 89757.0, 91376.08623913676, 93674.53162734142, 13319.467221311039, 13754.793678095037, 13857.37641806101, 13882.0, 14154.363053662815, 14107.365168567234, 14239.715205696035, 14696.11823290606, 15208.239588020333, 15708.68582628364, 13562.660933476742, 13952.37214325378, 14081.788773168206, 14181.432742690176, 14361.425542978583, 14216.21810800416, 14486.85513144855, 14529.78205326942, 14647.853521464649, 15361.385544578092, 14012.159270443806, 14322.212278324376, 14374.640633984234, 14417.351219194952, 14561.199134047729, 11316.94341528287, 11357.0, 11440.313581185155, 11718.824217636571, 11981.341026243641, 10731.731706707395, 11618.0, 11633.096218644703, 11751.76496470083, 11914.225575337576], "value": 8126.805046295711, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 165.0, 103.0, 115.0, 115.0, 117.0, 112.0, 116.0, 116.0, 115.0], "value": 117.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 109.0, 135.0, 188.0, 144.0, 163.0, 137.0, 148.0, 173.0, 142.0], "value": 147.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [249.0, 217.0, 212.0, 245.0, 192.0, 236.0, 268.0, 272.0, 198.0, 225.0], "value": 231.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 85.0, 70.0, 157.0, 80.0, 79.0, 84.0, 59.0, 129.0, 60.0], "value": 87.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 130.0, 70.0, 74.0, 90.0, 142.0, 95.0, 63.0, 120.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 87.0, 109.0, 111.0, 89.0, 87.0, 90.0, 103.0], "value": 94.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 150.0, 117.0, 147.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 109.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 91.0, 91.0, 94.0, 96.0, 91.0, 137.0, 145.0, 91.0], "value": 102.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 54.0, 57.0, 56.0, 57.0, 58.0, 55.0, 58.0, 57.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 71.0, 78.0, 78.0, 74.0, 76.0, 69.0, 71.0, 70.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 97.0, 112.0, 83.0, 85.0, 97.0, 87.0, 89.0, 107.0, 85.0], "value": 92.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 147.0, 142.0, 165.0, 159.0, 145.0, 158.0, 147.0, 156.0, 162.0], "value": 151.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 172.0, 169.0, 163.0, 171.0, 163.0, 168.0, 164.0, 168.0, 163.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 67.0, 66.0, 68.0, 67.0, 68.0, 69.0, 66.0, 68.0], "value": 67.5, "unit": "score"}]}]} 12:06:31 INFO - Return code: 0 12:06:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:06:31 ERROR - # TBPL SUCCESS # 12:06:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:06:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:06:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:06:31 INFO - 2016-06-28 12:06:31.473 screenresolution[1672:11191] starting screenresolution argv=screenresolution get 12:06:31 INFO - 2016-06-28 12:06:31.475 screenresolution[1672:11191] Display 0: 1600x1200x32@60 12:06:31 INFO - 2016-06-28 12:06:31.481 screenresolution[1673:11194] starting screenresolution argv=screenresolution list 12:06:31 INFO - Available Modes on Display 0 12:06:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:06:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:06:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:06:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:06:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:06:31 INFO - Intel Iris: 12:06:31 INFO - Chipset Model: Intel Iris 12:06:31 INFO - Type: GPU 12:06:31 INFO - Bus: Built-In 12:06:31 INFO - VRAM (Dynamic, Max): 1536 MB 12:06:31 INFO - Vendor: Intel (0x8086) 12:06:31 INFO - Device ID: 0x0a2e 12:06:31 INFO - Revision ID: 0x0009 12:06:31 INFO - Displays: 12:06:31 INFO - Display: 12:06:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:06:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:06:31 INFO - Display Serial Number: 1600x1200 60 12:06:31 INFO - Main Display: Yes 12:06:31 INFO - Mirror: Off 12:06:31 INFO - Online: Yes 12:06:31 INFO - Rotation: Supported 12:06:31 INFO - Return code: 0 12:06:31 INFO - Running post-action listener: _resource_record_post_action 12:06:31 INFO - ##### 12:06:31 INFO - ##### Finished run-tests step (success) 12:06:31 INFO - ##### 12:06:31 INFO - Running post-run listener: _resource_record_post_run 12:06:31 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 32755200; Write bytes: 711127040; Read time: 318; Write time: 2084 12:06:31 INFO - TinderboxPrint: CPU usage
54.7% 12:06:31 INFO - TinderboxPrint: I/O read bytes / time
32,755,200 / 318 12:06:31 INFO - TinderboxPrint: I/O write bytes / time
711,127,040 / 2,084 12:06:31 INFO - TinderboxPrint: CPU idle
2,192.9 (45.3%) 12:06:31 INFO - TinderboxPrint: CPU system
977.0 (20.2%) 12:06:31 INFO - TinderboxPrint: CPU user
1,667.8 (34.5%) 12:06:31 INFO - TinderboxPrint: Swap in / out
436,035,584 / 0 12:06:31 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 404687360; Write bytes: 399734784; Read time: 31051; Write time: 787 12:06:31 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 29249024; Write bytes: 299538432; Read time: 289; Write time: 1264 12:06:32 INFO - Running post-run listener: _upload_blobber_files 12:06:32 INFO - Blob upload gear active. 12:06:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:06:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:06:32 INFO - (blobuploader) - INFO - Open directory for files ... 12:06:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:06:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:06:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:06:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:06:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:06:33 INFO - (blobuploader) - INFO - Done attempting. 12:06:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:06:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:06:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:06:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:06:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:06:34 INFO - (blobuploader) - INFO - Done attempting. 12:06:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:06:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:06:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:06:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:06:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:06:37 INFO - (blobuploader) - INFO - Done attempting. 12:06:37 INFO - (blobuploader) - INFO - Iteration through files over. 12:06:37 INFO - Return code: 0 12:06:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:06:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:06:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c4ca9be50d826837dcd723825f26e144ced2aa5313350daff6c8a99df08b4606d307ec62979bf0aa86951b60486d6fe1b94ac75ddd4a5e1b53ac63bc5328d13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b600fb560346232d51d0d556499dcdc561181c587067c51fcbaa25531022de69d73fbb35f9f154f830a89fbabb5590fc5929f9d0c53030ef5a744a9b7659c3fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e2fa9f4621e35da578dd22d9a79fcdc4cd9a9f3ef3f2e8bde3e6d6bad112747da0601d6ee21d14f860143d232e32f0be25c07ff8f433546bcd6da1ae7d09f5f"} 12:06:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:06:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:06:37 INFO - Contents: 12:06:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c4ca9be50d826837dcd723825f26e144ced2aa5313350daff6c8a99df08b4606d307ec62979bf0aa86951b60486d6fe1b94ac75ddd4a5e1b53ac63bc5328d13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b600fb560346232d51d0d556499dcdc561181c587067c51fcbaa25531022de69d73fbb35f9f154f830a89fbabb5590fc5929f9d0c53030ef5a744a9b7659c3fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e2fa9f4621e35da578dd22d9a79fcdc4cd9a9f3ef3f2e8bde3e6d6bad112747da0601d6ee21d14f860143d232e32f0be25c07ff8f433546bcd6da1ae7d09f5f"} 12:06:37 INFO - Running post-run listener: copy_logs_to_upload_dir 12:06:37 INFO - Copying logs to upload dir... 12:06:37 INFO - mkdir: /builds/slave/test/build/upload/logs 12:06:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1511.221738 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 11 secs) (at 2016-06-28 12:06:37.438645) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 12:06:37.442586) ========= 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.TCmctXps7E/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.d7n0cT1kPo/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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/Fx-Team/sha512/7c4ca9be50d826837dcd723825f26e144ced2aa5313350daff6c8a99df08b4606d307ec62979bf0aa86951b60486d6fe1b94ac75ddd4a5e1b53ac63bc5328d13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b600fb560346232d51d0d556499dcdc561181c587067c51fcbaa25531022de69d73fbb35f9f154f830a89fbabb5590fc5929f9d0c53030ef5a744a9b7659c3fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e2fa9f4621e35da578dd22d9a79fcdc4cd9a9f3ef3f2e8bde3e6d6bad112747da0601d6ee21d14f860143d232e32f0be25c07ff8f433546bcd6da1ae7d09f5f"} build_url:https://queue.taskcluster.net/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011022 build_url: 'https://queue.taskcluster.net/v1/task/SlG31YBlQSWrgCBNYS6DPA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c4ca9be50d826837dcd723825f26e144ced2aa5313350daff6c8a99df08b4606d307ec62979bf0aa86951b60486d6fe1b94ac75ddd4a5e1b53ac63bc5328d13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b600fb560346232d51d0d556499dcdc561181c587067c51fcbaa25531022de69d73fbb35f9f154f830a89fbabb5590fc5929f9d0c53030ef5a744a9b7659c3fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e2fa9f4621e35da578dd22d9a79fcdc4cd9a9f3ef3f2e8bde3e6d6bad112747da0601d6ee21d14f860143d232e32f0be25c07ff8f433546bcd6da1ae7d09f5f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 12:06:37.474152) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:06:37.474476) ========= 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.TCmctXps7E/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.d7n0cT1kPo/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.004915 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:06:37.523233) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 12:06:37.523541) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 12:06:37.523851) ========= ========= Total master_lag: 0.23 =========