builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0238 starttime: 1479683398.84 results: success (0) buildid: 20161120125621 builduid: 89230f363a514ffd908efd7d0afaa660 revision: 1bd1dd160782df71a2f917ec8353b1d3accf2354 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-20 15:09:58.839932) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-20 15:09:58.840601) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-20 15:09:58.840902) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-20 15:09:58.886004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-20 15:09:58.886286) ========= 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.hJFsmkcIcn/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.RMbJnQfms1/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-20 15:09:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.0M=0.001s 2016-11-20 15:09:59 (14.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144055 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-20 15:09:59.052576) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-20 15:09:59.052874) ========= 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.hJFsmkcIcn/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.RMbJnQfms1/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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.021538 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-20 15:09:59.101258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-20 15:09:59.101714) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1bd1dd160782df71a2f917ec8353b1d3accf2354 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1bd1dd160782df71a2f917ec8353b1d3accf2354 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hJFsmkcIcn/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.RMbJnQfms1/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-20 15:09:59,182 truncating revision to first 12 chars 2016-11-20 15:09:59,182 Setting DEBUG logging. 2016-11-20 15:09:59,182 attempt 1/10 2016-11-20 15:09:59,182 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/1bd1dd160782?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-20 15:10:00,931 unpacking tar archive at: mozilla-beta-1bd1dd160782/testing/mozharness/ program finished with exit code 0 elapsedTime=2.020390 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-20 15:10:01.145422) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-20 15:10:01.145759) ========= script_repo_revision: 1bd1dd160782df71a2f917ec8353b1d3accf2354 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-20 15:10:01.146182) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-20 15:10:01.146460) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-20 15:10:01.166623) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-11-20 15:10:01.166936) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hJFsmkcIcn/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.RMbJnQfms1/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 15:10:01 INFO - MultiFileLogger online at 20161120 15:10:01 in /builds/slave/test 15:10:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:10:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:10:01 INFO - {'append_to_log': False, 15:10:01 INFO - 'base_work_dir': '/builds/slave/test', 15:10:01 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:10:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:10:01 INFO - 'branch': 'Mozilla-Beta', 15:10:01 INFO - 'buildbot_json_path': 'buildprops.json', 15:10:01 INFO - 'config_files': ('talos/mac_config.py',), 15:10:01 INFO - 'default_actions': ('clobber', 15:10:01 INFO - 'read-buildbot-config', 15:10:01 INFO - 'download-and-extract', 15:10:01 INFO - 'populate-webroot', 15:10:01 INFO - 'create-virtualenv', 15:10:01 INFO - 'install', 15:10:01 INFO - 'run-tests'), 15:10:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:10:01 INFO - 'download_minidump_stackwalk': True, 15:10:01 INFO - 'download_symbols': 'ondemand', 15:10:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:10:01 INFO - 'tooltool.py': '/tools/tooltool.py', 15:10:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:10:01 INFO - '/tools/misc-python/virtualenv.py')}, 15:10:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:10:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:10:01 INFO - 'installer_path': 'installer.exe', 15:10:01 INFO - 'log_level': 'info', 15:10:01 INFO - 'log_name': 'talos', 15:10:01 INFO - 'log_to_console': True, 15:10:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:10:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:10:01 INFO - 'opt_config_files': (), 15:10:01 INFO - 'pip_index': False, 15:10:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:10:01 INFO - 'cmd': ('bash', 15:10:01 INFO - '-c', 15:10:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:10:01 INFO - 'enabled': True, 15:10:01 INFO - 'halt_on_failure': False, 15:10:01 INFO - 'name': 'check_screen_resolution'},), 15:10:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:10:01 INFO - 'cmd': ('bash', 15:10:01 INFO - '-c', 15:10:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:10:01 INFO - 'enabled': True, 15:10:01 INFO - 'halt_on_failure': False, 15:10:01 INFO - 'name': 'check_screen_resolution'},), 15:10:01 INFO - 'run_cmd_checks_enabled': True, 15:10:01 INFO - 'sps_profile': False, 15:10:01 INFO - 'sps_profile_interval': 0, 15:10:01 INFO - 'suite': 'dromaeojs', 15:10:01 INFO - 'system_bits': '32', 15:10:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:10:01 INFO - 'title': 't-yosemite-r7-0238', 15:10:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:10:01 INFO - 'use_talos_json': True, 15:10:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:10:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:10:01 INFO - 'work_dir': 'build'} 15:10:01 INFO - [mozharness: 2016-11-20 23:10:01.360904Z] Running clobber step. 15:10:01 INFO - Running pre-action listener: _resource_record_pre_action 15:10:01 INFO - Running main action method: clobber 15:10:01 INFO - rmtree: /builds/slave/test/build 15:10:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:10:02 INFO - Running post-action listener: _resource_record_post_action 15:10:02 INFO - [mozharness: 2016-11-20 23:10:02.970718Z] Finished clobber step (success) 15:10:02 INFO - [mozharness: 2016-11-20 23:10:02.970902Z] Running read-buildbot-config step. 15:10:02 INFO - Running pre-action listener: _resource_record_pre_action 15:10:02 INFO - Running main action method: read_buildbot_config 15:10:02 INFO - Using buildbot properties: 15:10:02 INFO - { 15:10:02 INFO - "project": "", 15:10:02 INFO - "product": "firefox", 15:10:02 INFO - "script_repo_revision": "production", 15:10:02 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 15:10:02 INFO - "repository": "", 15:10:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 15:10:02 INFO - "buildid": "20161120125621", 15:10:02 INFO - "pgo_build": "False", 15:10:02 INFO - "basedir": "/builds/slave/test", 15:10:02 INFO - "buildnumber": 74, 15:10:02 INFO - "slavename": "t-yosemite-r7-0238", 15:10:02 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 15:10:02 INFO - "platform": "yosemite_r7", 15:10:02 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:10:02 INFO - "branch": "mozilla-beta", 15:10:02 INFO - "repo_path": "releases/mozilla-beta", 15:10:02 INFO - "revision": "1bd1dd160782df71a2f917ec8353b1d3accf2354", 15:10:02 INFO - "stage_platform": "macosx64", 15:10:02 INFO - "builduid": "89230f363a514ffd908efd7d0afaa660", 15:10:02 INFO - "slavebuilddir": "test" 15:10:02 INFO - } 15:10:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/XUh0EBK9SLqRpzMYIX1bWA/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 15:10:02 INFO - Running post-action listener: _resource_record_post_action 15:10:02 INFO - [mozharness: 2016-11-20 23:10:02.974261Z] Finished read-buildbot-config step (success) 15:10:02 INFO - [mozharness: 2016-11-20 23:10:02.974398Z] Running download-and-extract step. 15:10:02 INFO - Running pre-action listener: _resource_record_pre_action 15:10:02 INFO - Running main action method: download_and_extract 15:10:02 INFO - mkdir: /builds/slave/test/build/tests 15:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:02 INFO - trying https://queue.taskcluster.net/v1/task/XUh0EBK9SLqRpzMYIX1bWA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 15:10:02 INFO - Downloading https://queue.taskcluster.net/v1/task/XUh0EBK9SLqRpzMYIX1bWA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 15:10:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XUh0EBK9SLqRpzMYIX1bWA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 15:10:03 INFO - Downloaded 1165 bytes. 15:10:03 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 15:10:03 INFO - Using the following test package requirements: 15:10:03 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 15:10:03 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:10:03 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 15:10:03 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:10:03 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 15:10:03 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:10:03 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:10:03 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 15:10:03 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 15:10:03 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:10:03 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 15:10:03 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:10:03 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 15:10:03 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:10:03 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 15:10:03 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:10:03 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 15:10:03 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 15:10:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XUh0EBK9SLqRpzMYIX1bWA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 15:10:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XUh0EBK9SLqRpzMYIX1bWA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 15:10:03 INFO - Fetch https://queue.taskcluster.net/v1/task/XUh0EBK9SLqRpzMYIX1bWA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 15:10:04 INFO - Expected file size: 16231464 15:10:11 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 15:10:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XUh0EBK9SLqRpzMYIX1bWA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 15:10:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XUh0EBK9SLqRpzMYIX1bWA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 15:10:11 INFO - Fetch https://queue.taskcluster.net/v1/task/XUh0EBK9SLqRpzMYIX1bWA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 15:10:11 INFO - Expected file size: 16231464 15:10:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XUh0EBK9SLqRpzMYIX1bWA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 15:10:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XUh0EBK9SLqRpzMYIX1bWA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 15:10:18 INFO - Fetch https://queue.taskcluster.net/v1/task/XUh0EBK9SLqRpzMYIX1bWA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 15:10:19 INFO - Expected file size: 14414089 15:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:20 INFO - trying https://queue.taskcluster.net/v1/task/XUh0EBK9SLqRpzMYIX1bWA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 15:10:20 INFO - Downloading https://queue.taskcluster.net/v1/task/XUh0EBK9SLqRpzMYIX1bWA/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 15:10:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XUh0EBK9SLqRpzMYIX1bWA/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 15:10:23 INFO - Downloaded 86030819 bytes. 15:10:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XUh0EBK9SLqRpzMYIX1bWA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 15:10:23 INFO - mkdir: /builds/slave/test/properties 15:10:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:10:23 INFO - Writing to file /builds/slave/test/properties/build_url 15:10:23 INFO - Contents: 15:10:23 INFO - build_url:https://queue.taskcluster.net/v1/task/XUh0EBK9SLqRpzMYIX1bWA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 15:10:23 INFO - Running post-action listener: _resource_record_post_action 15:10:23 INFO - Running post-action listener: set_extra_try_arguments 15:10:23 INFO - [mozharness: 2016-11-20 23:10:23.989199Z] Finished download-and-extract step (success) 15:10:23 INFO - [mozharness: 2016-11-20 23:10:23.989316Z] Running populate-webroot step. 15:10:23 INFO - Running pre-action listener: _resource_record_pre_action 15:10:23 INFO - Running main action method: populate_webroot 15:10:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:10:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:10:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:10:23 INFO - '--tppagecycles', 15:10:23 INFO - '7'], 15:10:23 INFO - 'tests': ['tsvgm']}}, 15:10:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:10:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:10:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:10:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:10:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:10:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:10:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:23 INFO - 'talos_options': ['--disable-e10s'], 15:10:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:10:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:10:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:23 INFO - 'talos_options': ['--disable-e10s'], 15:10:24 INFO - 'tests': ['damp', 'tps']}, 15:10:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:24 INFO - 'tests': ['damp', 'tps']}, 15:10:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:10:24 INFO - 'tests': ['dromaeo_dom']}, 15:10:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:10:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:10:24 INFO - 'tests': ['basic_compositor_video']}, 15:10:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:10:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:10:24 INFO - 'tests': ['a11yr', 15:10:24 INFO - 'ts_paint', 15:10:24 INFO - 'tpaint', 15:10:24 INFO - 'sessionrestore', 15:10:24 INFO - 'sessionrestore_no_auto_restore', 15:10:24 INFO - 'tabpaint']}, 15:10:24 INFO - 'other-e10s': {'tests': ['a11yr', 15:10:24 INFO - 'ts_paint', 15:10:24 INFO - 'tpaint', 15:10:24 INFO - 'sessionrestore', 15:10:24 INFO - 'sessionrestore_no_auto_restore', 15:10:24 INFO - 'tabpaint']}, 15:10:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:10:24 INFO - 'ts_paint', 15:10:24 INFO - 'tpaint', 15:10:24 INFO - 'sessionrestore', 15:10:24 INFO - 'sessionrestore_no_auto_restore', 15:10:24 INFO - 'tabpaint']}, 15:10:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:10:24 INFO - 'ts_paint', 15:10:24 INFO - 'tpaint', 15:10:24 INFO - 'sessionrestore', 15:10:24 INFO - 'sessionrestore_no_auto_restore', 15:10:24 INFO - 'tabpaint']}, 15:10:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:10:24 INFO - 'tests': ['a11yr', 15:10:24 INFO - 'ts_paint', 15:10:24 INFO - 'tpaint', 15:10:24 INFO - 'sessionrestore', 15:10:24 INFO - 'sessionrestore_no_auto_restore', 15:10:24 INFO - 'tabpaint']}, 15:10:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:10:24 INFO - 'tests': ['a11yr', 15:10:24 INFO - 'ts_paint', 15:10:24 INFO - 'tpaint', 15:10:24 INFO - 'sessionrestore', 15:10:24 INFO - 'sessionrestore_no_auto_restore', 15:10:24 INFO - 'tabpaint']}, 15:10:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:10:24 INFO - 'tests': ['tsvgx', 15:10:24 INFO - 'tsvgr_opacity', 15:10:24 INFO - 'tart', 15:10:24 INFO - 'tscrollx', 15:10:24 INFO - 'cart']}, 15:10:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:10:24 INFO - 'tsvgr_opacity', 15:10:24 INFO - 'tart', 15:10:24 INFO - 'tscrollx', 15:10:24 INFO - 'cart']}, 15:10:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:24 INFO - 'talos_options': ['--disable-e10s'], 15:10:24 INFO - 'tests': ['tp5o']}, 15:10:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:24 INFO - 'tests': ['tp5o']}, 15:10:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:24 INFO - 'talos_options': ['--disable-e10s', 15:10:24 INFO - '--xperf_path', 15:10:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:10:24 INFO - 'tests': ['tp5n']}, 15:10:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:24 INFO - 'talos_options': ['--xperf_path', 15:10:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:10:24 INFO - 'tests': ['tp5n']}}, 15:10:24 INFO - 'talos.zip': {'path': '', 15:10:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:10:24 INFO - Running post-action listener: _resource_record_post_action 15:10:24 INFO - [mozharness: 2016-11-20 23:10:24.008008Z] Finished populate-webroot step (success) 15:10:24 INFO - [mozharness: 2016-11-20 23:10:24.008132Z] Running create-virtualenv step. 15:10:24 INFO - Running pre-action listener: _resource_record_pre_action 15:10:24 INFO - Running main action method: create_virtualenv 15:10:24 INFO - Creating virtualenv /builds/slave/test/build/venv 15:10:24 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 15:10:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:10:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:10:24 INFO - Using real prefix '/tools/python27' 15:10:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:10:24 INFO - Installing distribute.............................................................................................................................................................................................done. 15:10:27 INFO - Installing pip.................done. 15:10:27 INFO - Return code: 0 15:10:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10216e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc413c79560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f82d30>, '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 0x101de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f7ab20>, '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.hJFsmkcIcn/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.RMbJnQfms1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 15:10:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:10:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hJFsmkcIcn/Render', 15:10:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:27 INFO - 'HOME': '/Users/cltbld', 15:10:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:27 INFO - 'LOGNAME': 'cltbld', 15:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:27 INFO - 'MOZ_NO_REMOTE': '1', 15:10:27 INFO - 'NO_EM_RESTART': '1', 15:10:27 INFO - 'PAGER': '/bin/cat', 15:10:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:27 INFO - 'PWD': '/builds/slave/test', 15:10:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:27 INFO - 'SHELL': '/bin/bash', 15:10:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RMbJnQfms1/Listeners', 15:10:27 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 15:10:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:27 INFO - 'USER': 'cltbld', 15:10:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:27 INFO - 'XPC_FLAGS': '0x0', 15:10:27 INFO - 'XPC_SERVICE_NAME': '0', 15:10:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:27 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 15:10:27 INFO - Cleaning up... 15:10:27 INFO - Return code: 0 15:10:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10216e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc413c79560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f82d30>, '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 0x101de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f7ab20>, '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.hJFsmkcIcn/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.RMbJnQfms1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 15:10:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:10:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hJFsmkcIcn/Render', 15:10:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:27 INFO - 'HOME': '/Users/cltbld', 15:10:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:27 INFO - 'LOGNAME': 'cltbld', 15:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:27 INFO - 'MOZ_NO_REMOTE': '1', 15:10:27 INFO - 'NO_EM_RESTART': '1', 15:10:27 INFO - 'PAGER': '/bin/cat', 15:10:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:27 INFO - 'PWD': '/builds/slave/test', 15:10:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:27 INFO - 'SHELL': '/bin/bash', 15:10:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RMbJnQfms1/Listeners', 15:10:27 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 15:10:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:27 INFO - 'USER': 'cltbld', 15:10:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:27 INFO - 'XPC_FLAGS': '0x0', 15:10:27 INFO - 'XPC_SERVICE_NAME': '0', 15:10:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:28 INFO - Downloading/unpacking psutil>=3.1.1 15:10:28 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 15:10:28 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 15:10:28 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 15:10:28 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 15:10:28 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 15:10:28 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 15:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:10:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:10:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:10:31 INFO - Installing collected packages: psutil 15:10:31 INFO - Running setup.py install for psutil 15:10:31 INFO - building 'psutil._psutil_osx' extension 15:10:31 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 15:10:31 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 15:10:32 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 15:10:32 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 15:10:32 INFO - building 'psutil._psutil_posix' extension 15:10:32 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 15:10:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:10:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:10:32 INFO - ^ 15:10:32 INFO - 1 warning generated. 15:10:32 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 15:10:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:10:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:10:32 INFO - Successfully installed psutil 15:10:32 INFO - Cleaning up... 15:10:32 INFO - Return code: 0 15:10:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:32 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 0x10216e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc413c79560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f82d30>, '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 0x101de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f7ab20>, '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.hJFsmkcIcn/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.RMbJnQfms1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 15:10:32 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 15:10:32 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 15:10:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hJFsmkcIcn/Render', 15:10:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:32 INFO - 'HOME': '/Users/cltbld', 15:10:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:32 INFO - 'LOGNAME': 'cltbld', 15:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:32 INFO - 'MOZ_NO_REMOTE': '1', 15:10:32 INFO - 'NO_EM_RESTART': '1', 15:10:32 INFO - 'PAGER': '/bin/cat', 15:10:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:32 INFO - 'PWD': '/builds/slave/test', 15:10:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:32 INFO - 'SHELL': '/bin/bash', 15:10:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RMbJnQfms1/Listeners', 15:10:32 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 15:10:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:32 INFO - 'USER': 'cltbld', 15:10:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:32 INFO - 'XPC_FLAGS': '0x0', 15:10:32 INFO - 'XPC_SERVICE_NAME': '0', 15:10:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:10:32 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 15:10:32 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 15:10:32 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 15:10:32 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 15:10:32 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 15:10:32 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 15:10:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:10:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:10:35 INFO - Installing collected packages: mozsystemmonitor 15:10:35 INFO - Running setup.py install for mozsystemmonitor 15:10:35 INFO - Successfully installed mozsystemmonitor 15:10:35 INFO - Cleaning up... 15:10:35 INFO - Return code: 0 15:10:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10216e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc413c79560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f82d30>, '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 0x101de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f7ab20>, '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.hJFsmkcIcn/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.RMbJnQfms1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 15:10:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:10:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:10:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hJFsmkcIcn/Render', 15:10:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:35 INFO - 'HOME': '/Users/cltbld', 15:10:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:35 INFO - 'LOGNAME': 'cltbld', 15:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:35 INFO - 'MOZ_NO_REMOTE': '1', 15:10:35 INFO - 'NO_EM_RESTART': '1', 15:10:35 INFO - 'PAGER': '/bin/cat', 15:10:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:35 INFO - 'PWD': '/builds/slave/test', 15:10:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:35 INFO - 'SHELL': '/bin/bash', 15:10:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RMbJnQfms1/Listeners', 15:10:35 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 15:10:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:35 INFO - 'USER': 'cltbld', 15:10:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:35 INFO - 'XPC_FLAGS': '0x0', 15:10:35 INFO - 'XPC_SERVICE_NAME': '0', 15:10:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:35 INFO - Downloading/unpacking jsonschema==2.5.1 15:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:10:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:38 INFO - Downloading functools32-3.2.3-2.tar.gz 15:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:10:38 INFO - warning: no files found matching '*.txt' 15:10:38 INFO - no previously-included directories found matching 'build' 15:10:38 INFO - no previously-included directories found matching 'dist' 15:10:38 INFO - no previously-included directories found matching '.git*' 15:10:38 INFO - Installing collected packages: jsonschema, functools32 15:10:38 INFO - Running setup.py install for functools32 15:10:39 INFO - warning: no files found matching '*.txt' 15:10:39 INFO - no previously-included directories found matching 'build' 15:10:39 INFO - no previously-included directories found matching 'dist' 15:10:39 INFO - no previously-included directories found matching '.git*' 15:10:39 INFO - Successfully installed jsonschema functools32 15:10:39 INFO - Cleaning up... 15:10:39 INFO - Return code: 0 15:10:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10216e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc413c79560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f82d30>, '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 0x101de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f7ab20>, '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.hJFsmkcIcn/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.RMbJnQfms1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 15:10:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:10:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hJFsmkcIcn/Render', 15:10:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:39 INFO - 'HOME': '/Users/cltbld', 15:10:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:39 INFO - 'LOGNAME': 'cltbld', 15:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:39 INFO - 'MOZ_NO_REMOTE': '1', 15:10:39 INFO - 'NO_EM_RESTART': '1', 15:10:39 INFO - 'PAGER': '/bin/cat', 15:10:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:39 INFO - 'PWD': '/builds/slave/test', 15:10:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:39 INFO - 'SHELL': '/bin/bash', 15:10:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RMbJnQfms1/Listeners', 15:10:39 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 15:10:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:39 INFO - 'USER': 'cltbld', 15:10:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:39 INFO - 'XPC_FLAGS': '0x0', 15:10:39 INFO - 'XPC_SERVICE_NAME': '0', 15:10:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:10:39 INFO - Cleaning up... 15:10:39 INFO - Return code: 0 15:10:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:39 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 0x10216e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc413c79560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f82d30>, '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 0x101de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f7ab20>, '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.hJFsmkcIcn/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.RMbJnQfms1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 15:10:39 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 15:10:39 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 15:10:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hJFsmkcIcn/Render', 15:10:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:39 INFO - 'HOME': '/Users/cltbld', 15:10:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:39 INFO - 'LOGNAME': 'cltbld', 15:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:39 INFO - 'MOZ_NO_REMOTE': '1', 15:10:39 INFO - 'NO_EM_RESTART': '1', 15:10:39 INFO - 'PAGER': '/bin/cat', 15:10:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:39 INFO - 'PWD': '/builds/slave/test', 15:10:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:39 INFO - 'SHELL': '/bin/bash', 15:10:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RMbJnQfms1/Listeners', 15:10:39 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 15:10:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:39 INFO - 'USER': 'cltbld', 15:10:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:39 INFO - 'XPC_FLAGS': '0x0', 15:10:39 INFO - 'XPC_SERVICE_NAME': '0', 15:10:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:39 INFO - Downloading/unpacking blobuploader==1.2.4 15:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:42 INFO - Downloading blobuploader-1.2.4.tar.gz 15:10:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:10:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:10:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:43 INFO - Downloading docopt-0.6.1.tar.gz 15:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:10:43 INFO - Installing collected packages: blobuploader, requests, docopt 15:10:43 INFO - Running setup.py install for blobuploader 15:10:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:10:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:10:43 INFO - Running setup.py install for requests 15:10:44 INFO - Running setup.py install for docopt 15:10:44 INFO - Successfully installed blobuploader requests docopt 15:10:44 INFO - Cleaning up... 15:10:44 INFO - Return code: 0 15:10:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:44 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 0x10216e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc413c79560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f82d30>, '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 0x101de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f7ab20>, '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.hJFsmkcIcn/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.RMbJnQfms1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 15:10:44 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 15:10:44 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 15:10:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hJFsmkcIcn/Render', 15:10:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:44 INFO - 'HOME': '/Users/cltbld', 15:10:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:44 INFO - 'LOGNAME': 'cltbld', 15:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:44 INFO - 'MOZ_NO_REMOTE': '1', 15:10:44 INFO - 'NO_EM_RESTART': '1', 15:10:44 INFO - 'PAGER': '/bin/cat', 15:10:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:44 INFO - 'PWD': '/builds/slave/test', 15:10:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:44 INFO - 'SHELL': '/bin/bash', 15:10:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RMbJnQfms1/Listeners', 15:10:44 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 15:10:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:44 INFO - 'USER': 'cltbld', 15:10:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:44 INFO - 'XPC_FLAGS': '0x0', 15:10:44 INFO - 'XPC_SERVICE_NAME': '0', 15:10:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:10:44 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-65l1uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:10:44 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-07i0Ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:10:44 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-v7ntBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:10:44 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-d4lrxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:10:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-9mrsGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:10:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-wwc4eg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:10:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-J3jAKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:10:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-p65SZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:10:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-r1Vsz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:10:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-S9dplL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:10:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-bK6nQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:10:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-GAKhA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:10:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-sUnLa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:10:46 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-YzUpu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:46 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-XDnzIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:10:46 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-cXDLrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:10:46 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-mHbkyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:10:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:10:46 INFO - Running setup.py install for manifestparser 15:10:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:10:46 INFO - Running setup.py install for mozcrash 15:10:46 INFO - Running setup.py install for mozdebug 15:10:46 INFO - Running setup.py install for mozdevice 15:10:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:10:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:10:47 INFO - Running setup.py install for mozfile 15:10:47 INFO - Running setup.py install for mozhttpd 15:10:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:10:47 INFO - Running setup.py install for mozinfo 15:10:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:10:47 INFO - Running setup.py install for mozInstall 15:10:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:10:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:10:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:10:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:10:47 INFO - Running setup.py install for mozleak 15:10:47 INFO - Running setup.py install for mozlog 15:10:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:10:47 INFO - Running setup.py install for moznetwork 15:10:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:10:48 INFO - Running setup.py install for mozprocess 15:10:48 INFO - Running setup.py install for mozprofile 15:10:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:10:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:10:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:10:48 INFO - Running setup.py install for mozrunner 15:10:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:10:48 INFO - Running setup.py install for mozscreenshot 15:10:48 INFO - Running setup.py install for moztest 15:10:48 INFO - Running setup.py install for mozversion 15:10:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:10:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:10:48 INFO - Cleaning up... 15:10:49 INFO - Return code: 0 15:10:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:49 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 0x10216e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc413c79560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f82d30>, '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 0x101de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f7ab20>, '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.hJFsmkcIcn/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.RMbJnQfms1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 15:10:49 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 15:10:49 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 15:10:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hJFsmkcIcn/Render', 15:10:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:49 INFO - 'HOME': '/Users/cltbld', 15:10:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:49 INFO - 'LOGNAME': 'cltbld', 15:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:49 INFO - 'MOZ_NO_REMOTE': '1', 15:10:49 INFO - 'NO_EM_RESTART': '1', 15:10:49 INFO - 'PAGER': '/bin/cat', 15:10:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:49 INFO - 'PWD': '/builds/slave/test', 15:10:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:49 INFO - 'SHELL': '/bin/bash', 15:10:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RMbJnQfms1/Listeners', 15:10:49 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 15:10:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:49 INFO - 'USER': 'cltbld', 15:10:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:49 INFO - 'XPC_FLAGS': '0x0', 15:10:49 INFO - 'XPC_SERVICE_NAME': '0', 15:10:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:10:49 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-cEyRIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:10:49 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)) 15:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:10:49 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-6BbCXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:10:49 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)) 15:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:10:49 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-hHpS8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:10:49 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)) 15:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:10:49 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-kCWrK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:10:49 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)) 15:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:10:49 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-n0PjIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:10:49 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)) 15:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:10:49 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-ItMHAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:10:49 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)) 15:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:10:49 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-psULxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:10:50 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)) 15:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:10:50 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-CUcoZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:10:50 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)) 15:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:10:50 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-2Oau7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:10:50 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)) 15:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:10:50 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-X6UAXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:10:50 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-F0Phpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:10:50 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)) 15:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:10:50 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-zVA_9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:10:50 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-cd7fdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:10:50 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)) 15:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:10:50 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-pwoxgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:50 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-P23aal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:50 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)) 15:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:10:50 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-mKscIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:10:50 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)) 15:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:10:51 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-TKQ33X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:10:51 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)) 15:10:51 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)) 15:10:51 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)) 15:10:51 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)) 15:10:51 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)) 15:10:51 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)) 15:10:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:53 INFO - Downloading blessings-1.6.tar.gz 15:10:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:10:53 INFO - Installing collected packages: blessings 15:10:53 INFO - Running setup.py install for blessings 15:10:53 INFO - Successfully installed blessings 15:10:53 INFO - Cleaning up... 15:10:53 INFO - Return code: 0 15:10:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:10:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:10:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:10:54 INFO - Reading from file tmpfile_stdout 15:10:54 INFO - Current package versions: 15:10:54 INFO - blessings == 1.6 15:10:54 INFO - blobuploader == 1.2.4 15:10:54 INFO - docopt == 0.6.1 15:10:54 INFO - functools32 == 3.2.3-2 15:10:54 INFO - jsonschema == 2.5.1 15:10:54 INFO - manifestparser == 1.1 15:10:54 INFO - mozInstall == 1.12 15:10:54 INFO - mozcrash == 0.17 15:10:54 INFO - mozdebug == 0.1 15:10:54 INFO - mozdevice == 0.48 15:10:54 INFO - mozfile == 1.2 15:10:54 INFO - mozhttpd == 0.7 15:10:54 INFO - mozinfo == 0.9 15:10:54 INFO - mozleak == 0.1 15:10:54 INFO - mozlog == 3.4 15:10:54 INFO - moznetwork == 0.27 15:10:54 INFO - mozprocess == 0.23 15:10:54 INFO - mozprofile == 0.28 15:10:54 INFO - mozrunner == 6.12 15:10:54 INFO - mozscreenshot == 0.1 15:10:54 INFO - mozsystemmonitor == 0.3 15:10:54 INFO - moztest == 0.7 15:10:54 INFO - mozversion == 1.4 15:10:54 INFO - psutil == 3.1.1 15:10:54 INFO - requests == 1.2.3 15:10:54 INFO - wsgiref == 0.1.2 15:10:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:54 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 0x10216e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc413c79560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f82d30>, '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 0x101de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f7ab20>, '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.hJFsmkcIcn/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.RMbJnQfms1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 15:10:54 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 15:10:54 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 15:10:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hJFsmkcIcn/Render', 15:10:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:54 INFO - 'HOME': '/Users/cltbld', 15:10:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:54 INFO - 'LOGNAME': 'cltbld', 15:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:54 INFO - 'MOZ_NO_REMOTE': '1', 15:10:54 INFO - 'NO_EM_RESTART': '1', 15:10:54 INFO - 'PAGER': '/bin/cat', 15:10:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:54 INFO - 'PWD': '/builds/slave/test', 15:10:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:54 INFO - 'SHELL': '/bin/bash', 15:10:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RMbJnQfms1/Listeners', 15:10:54 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 15:10:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:54 INFO - 'USER': 'cltbld', 15:10:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:54 INFO - 'XPC_FLAGS': '0x0', 15:10:54 INFO - 'XPC_SERVICE_NAME': '0', 15:10:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:54 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)) 15:10:54 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)) 15:10:54 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)) 15:10:54 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)) 15:10:54 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)) 15:10:54 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)) 15:10:54 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)) 15:10:54 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)) 15:10:54 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)) 15:10:54 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)) 15:10:54 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)) 15:10:54 INFO - Cleaning up... 15:10:54 INFO - Return code: 0 15:10:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:10:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10216e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc413c79560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f82d30>, '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 0x101de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f7ab20>, '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.hJFsmkcIcn/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.RMbJnQfms1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 15:10:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:10:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:10:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hJFsmkcIcn/Render', 15:10:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:54 INFO - 'HOME': '/Users/cltbld', 15:10:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:54 INFO - 'LOGNAME': 'cltbld', 15:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:54 INFO - 'MOZ_NO_REMOTE': '1', 15:10:54 INFO - 'NO_EM_RESTART': '1', 15:10:54 INFO - 'PAGER': '/bin/cat', 15:10:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:54 INFO - 'PWD': '/builds/slave/test', 15:10:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:54 INFO - 'SHELL': '/bin/bash', 15:10:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RMbJnQfms1/Listeners', 15:10:54 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 15:10:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:54 INFO - 'USER': 'cltbld', 15:10:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:54 INFO - 'XPC_FLAGS': '0x0', 15:10:54 INFO - 'XPC_SERVICE_NAME': '0', 15:10:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:10:54 INFO - Cleaning up... 15:10:54 INFO - Return code: 0 15:10:54 INFO - Running post-action listener: _resource_record_post_action 15:10:54 INFO - Running post-action listener: _start_resource_monitoring 15:10:54 INFO - Starting resource monitoring. 15:10:54 INFO - [mozharness: 2016-11-20 23:10:54.790697Z] Finished create-virtualenv step (success) 15:10:54 INFO - [mozharness: 2016-11-20 23:10:54.791729Z] Running install step. 15:10:54 INFO - Running pre-action listener: _resource_record_pre_action 15:10:54 INFO - Running main action method: install 15:10:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:10:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:10:55 INFO - Reading from file tmpfile_stdout 15:10:55 INFO - Detecting whether we're running mozinstall >=1.0... 15:10:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:10:55 INFO - Reading from file tmpfile_stdout 15:10:55 INFO - Output received: 15:10:55 INFO - Usage: mozinstall [options] installer 15:10:55 INFO - Options: 15:10:55 INFO - -h, --help show this help message and exit 15:10:55 INFO - -d DEST, --destination=DEST 15:10:55 INFO - Directory to install application into. [default: 15:10:55 INFO - "/builds/slave/test"] 15:10:55 INFO - --app=APP Application being installed. [default: firefox] 15:10:55 INFO - mkdir: /builds/slave/test/build/application 15:10:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 15:11:17 INFO - Reading from file tmpfile_stdout 15:11:17 INFO - Output received: 15:11:17 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:11:17 INFO - Running post-action listener: _resource_record_post_action 15:11:17 INFO - [mozharness: 2016-11-20 23:11:17.754826Z] Finished install step (success) 15:11:17 INFO - [mozharness: 2016-11-20 23:11:17.754974Z] Running run-tests step. 15:11:17 INFO - Running pre-action listener: _resource_record_pre_action 15:11:17 INFO - Running main action method: run_tests 15:11:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:11:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:11:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:11:17 INFO - 2016-11-20 15:11:17.769 screenresolution[2520:296332] starting screenresolution argv=screenresolution get 15:11:17 INFO - 2016-11-20 15:11:17.772 screenresolution[2520:296332] Display 0: 1600x1200x32@60 15:11:17 INFO - 2016-11-20 15:11:17.778 screenresolution[2521:296334] starting screenresolution argv=screenresolution list 15:11:17 INFO - Available Modes on Display 0 15:11:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:11:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:11:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:11:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:11:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:11:18 INFO - Intel Iris: 15:11:18 INFO - Chipset Model: Intel Iris 15:11:18 INFO - Type: GPU 15:11:18 INFO - Bus: Built-In 15:11:18 INFO - VRAM (Dynamic, Max): 1536 MB 15:11:18 INFO - Vendor: Intel (0x8086) 15:11:18 INFO - Device ID: 0x0a2e 15:11:18 INFO - Revision ID: 0x0009 15:11:18 INFO - Displays: 15:11:18 INFO - Display: 15:11:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:11:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:11:18 INFO - Display Serial Number: 1600x1200 60 15:11:18 INFO - Main Display: Yes 15:11:18 INFO - Mirror: Off 15:11:18 INFO - Online: Yes 15:11:18 INFO - Rotation: Supported 15:11:18 INFO - Return code: 0 15:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:11:18 INFO - Python 2.7.3 15:11:18 INFO - Return code: 0 15:11:18 INFO - grabbing minidump binary from tooltool 15:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:18 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 0x101f82d30>, '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 0x101de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f7ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:11:18 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 15:11:18 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 15:11:18 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 15:11:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:11:18 INFO - Return code: 0 15:11:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:11:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:11:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:11:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:11:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XUh0EBK9SLqRpzMYIX1bWA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0238', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XUh0EBK9SLqRpzMYIX1bWA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0238 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:11:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hJFsmkcIcn/Render', 15:11:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:11:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:11:18 INFO - 'HOME': '/Users/cltbld', 15:11:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:11:18 INFO - 'LOGNAME': 'cltbld', 15:11:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:11:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:18 INFO - 'MOZ_NO_REMOTE': '1', 15:11:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:11:18 INFO - 'NO_EM_RESTART': '1', 15:11:18 INFO - 'PAGER': '/bin/cat', 15:11:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:18 INFO - 'PWD': '/builds/slave/test', 15:11:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:11:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:11:18 INFO - 'SHELL': '/bin/bash', 15:11:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RMbJnQfms1/Listeners', 15:11:18 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 15:11:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:11:18 INFO - 'USER': 'cltbld', 15:11:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:11:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:18 INFO - 'XPC_FLAGS': '0x0', 15:11:18 INFO - 'XPC_SERVICE_NAME': '0', 15:11:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:11:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XUh0EBK9SLqRpzMYIX1bWA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0238', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:11:18 INFO - mozversion application_buildid: 20161120125621 15:11:18 INFO - mozversion application_changeset: 1bd1dd160782df71a2f917ec8353b1d3accf2354 15:11:18 INFO - mozversion application_display_name: Firefox 15:11:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:11:18 INFO - mozversion application_name: Firefox 15:11:18 INFO - mozversion application_remotingname: firefox 15:11:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:11:18 INFO - mozversion application_vendor: Mozilla 15:11:18 INFO - mozversion application_version: 51.0 15:11:18 INFO - mozversion platform_buildid: 20161120125621 15:11:18 INFO - mozversion platform_changeset: 1bd1dd160782df71a2f917ec8353b1d3accf2354 15:11:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:11:18 INFO - mozversion platform_version: 51.0 15:11:18 INFO - using testdate: 1479683478 15:11:18 INFO - actual date: 1479683478 15:11:18 INFO - starting webserver on 'localhost:56056' 15:11:18 INFO - SUITE-START | Running 2 tests 15:11:18 INFO - TEST-START | dromaeo_css 15:11:18 INFO - operating with platform_type : mac_ 15:11:18 INFO - Initialising browser for dromaeo_css test... 15:11:18 INFO - TEST-INFO | started process 2531 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpFuGnv9/profile http://localhost:56056/getInfo.html) 15:11:20 INFO - PROCESS | 2531 | __metrics Screen width/height:1600/1200 15:11:20 INFO - PROCESS | 2531 | colorDepth:24 15:11:20 INFO - PROCESS | 2531 | Browser inner width/height: 1024/689 15:11:20 INFO - PROCESS | 2531 | __metrics 15:11:20 INFO - PROCESS | 2531 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:11:20 INFO - PROCESS | 2531 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:11:21 INFO - TEST-INFO | 2531: exit 0 15:11:21 INFO - Browser initialized. 15:11:21 INFO - Running cycle 1/1 for dromaeo_css test... 15:11:21 INFO - TEST-INFO | started process 2533 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpFuGnv9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:11:32 INFO - PROCESS | 2533 | RSS: Main: 168345600 15:11:32 INFO - PROCESS | 2533 | 15:12:26 INFO - PROCESS | 2533 | 1479683546975 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] 15:14:35 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:56056/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56056/tests/dromaeo/cssquery-ext.html) 15:14:36 INFO - PROCESS | 2533 | RSS: Main: 306749440 15:14:36 INFO - PROCESS | 2533 | 15:17:39 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:56056/tests/dromaeo/cssquery-ext.html (next: http://localhost:56056/tests/dromaeo/cssquery-jquery.html) 15:17:40 INFO - PROCESS | 2533 | RSS: Main: 299286528 15:17:40 INFO - PROCESS | 2533 | 15:20:42 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:56056/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56056/tests/dromaeo/cssquery-mootools.html) 15:20:43 INFO - PROCESS | 2533 | RSS: Main: 265506816 15:20:43 INFO - PROCESS | 2533 | 15:23:45 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:56056/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56056/tests/dromaeo/cssquery-prototype.html) 15:23:45 INFO - PROCESS | 2533 | RSS: Main: 267493376 15:23:45 INFO - PROCESS | 2533 | 15:26:48 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:56056/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56056/tests/dromaeo/cssquery-yui.html) 15:26:49 INFO - PROCESS | 2533 | RSS: Main: 257708032 15:26:49 INFO - PROCESS | 2533 | 15:29:52 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:56056/tests/dromaeo/cssquery-yui.html (next: http://localhost:56056/tests/dromaeo/cssquery-dojo.html) 15:29:52 INFO - PROCESS | 2533 | RSS: Main: 421707776 15:29:52 INFO - PROCESS | 2533 | 15:29:52 INFO - PROCESS | 2533 | __start_tp_report 15:29:52 INFO - PROCESS | 2533 | _x_x_mozilla_page_load 15:29:52 INFO - PROCESS | 2533 | _x_x_mozilla_page_load_details 15:29:52 INFO - PROCESS | 2533 | |i|pagename|runs| 15:29:52 INFO - PROCESS | 2533 | |0;dojo.html;3241.351729654069;3406.3698215830073;3419.0597585663954;3426.2462258303194;3493.912652183695;5684.2326285951385;5764.394738552449;5772.134179873021;5772.653640781556;5786.1610066540325;5766.279215098113;5822.7088645567765;5855.970720146393;5867.823965281038;5872.148538461921;5204.739763011844;5254;5265.236540701596;5297.894042119175;5305.7877684892555;5156.149235376159;5174.327337446127;5177.818776342829;5319.734013299339;5338.492843179892;5299.5230429261355;5310.70791106489;5316.20256961455;5324.227986941891;5330.093884039723;5201.479852014806;5296.894062118756;5305.310309659739;5306.814261500867;5317.787288508455;5122.1036318644465;5212.739363031871;5214.739263036871;5248.8687782805355;5293.86765330866;5867.76528938842;5869.9706501467645;5942.168096466498;5987.431194036603;6016.639001659914;5210.296609957645;6109.2528441424865;6129.601575897553;6183.567150299481;6183.721732522003;6183.1034499997695;6215.502759779207;6241.126242326078;6264.780732674334;6297.685115744241;5984.371640977678;6017.308009578955;6032.638041717511;6034.909476357858;6075.605085669417;6148.846278843064;6223.097650840603;6223.284322302993;6331.873362532816;6338.080978258126;5200.245964335226;6147.323794382614;6201.441870231701;6270.2789179244055;6272.498200143978;6208.596441231305;6268.122462855204;6294.244690637152;6296.433321001132;6299.023651334051;6138.388398386059;6223.906641400383;6236.968815155986;6301.369863013662;6307.306196318401;6234.501239900797;6279.843003924847;6287.056941458726;6291.5281353898645;6295.811125666238;5048.368953880765;5059.797608095635;5062.544371006627;5064.139096353629;5087.516685914832;4469.217886869785;4568.497465278817;4575.199340115467;4579.610733087658;4582.312653102062;5037.571806396498;5746.482816546447;5772.278465191851;5896.262967129109;5986.580939334205;6185;6237.812865614039;6243.500519958392;6260.092286618506;6261.279952805395;5973.432523910308;5978.701064946736;5983.761207106868;5990.940090599038;6052.818415447456;5371.892562148813;5373.543248823894;5433.755481003364;5457.126859702428;5513.476219759116;6400.743970241231;6494.6103233806125;6500.967495162494;6505.479561634963;6517.543771935919;6253.624782513064;6258.561900666909;6259.311475737756;6273.435390814849;6340.71466784005;5439.48324909133;6286.434220919956;6322.494200464043;6448.32292609288;6496.805095847132;6142.897836592492;6146.8321019008035;6162.907556386747;6275.090111933835;6285.59143655661;6259.467945224706;6259.718312675849;6267.96866015667;6275.592086514362;6278.434940855345;6108.602940808833;6191.102290167991;6217.813465596039;6224.37756224374;6243.125962365181;6115.755369785336;6138.508919286357;6140.692965351625;6152.846178845564;6233.096201050913;6113.908291375544;6128.325884152829;6145.047517634774;6149.96925015372;6150.384961503813;6024.969875150771;6161.6919154041225;6218.191635087591;6222.973209420395;6228.626282423069;5091.465396133352;5939.227900373096;6003.3996600339615;6070.696465176635;6096.177016102769 15:29:52 INFO - PROCESS | 2533 | |1;ext.html;509.149719967654;517.3584754903919;526.4025331249031;545.2557259341;555.8054680861701;30233.395332093343;42491.78754106229;43507;43701;46257;45591.77204113983;45908;46036.53963460364;46054.539454605445;46059.769701151534;9164.587593558272;10038;10193.235507336942;10234.897651023506;10241.795164096713;9291.39605925616;12195.451204695766;12466.314352710642;12475.875241247608;12645.241285522852;12492.312922789242;12524.686882827957;12562.24626522407;12568.057395695314;12568.560100396488;12404.62786116418;12465.501379944792;12474.18917770342;12480.812787808236;12483.126181167321;12333;12359.134860559765;12380.195287306296;12389.752204955941;12391.442385092692;43039;43260.13479730419;43434.131317373474;43454.56545434537;43488.17326873743;3416.6583341665882;3505.982470087659;3669.412893936957;3676.5036720042717;3722.181120153562;32096.839515802272;32774.180645483815;32849.83575082133;33221.6677833221;34029.82985085084;3367;3384.204711892728;3436.2096717754807;3457.3949558827103;3479.304139172176;460860;462560;511052;526059;527074;35405.93782186539;65700;66088.33911660821;66336.6683166581;66353.33646663568;36301;37624.247515049545;37682.434763478566;37683.434748478794;37696.811515942245;16351.345946162259;16515.83484165167;16523.83476165223;16524.917375413046;16547.586310342096;12742.872571274169;12947.741045179044;13997.95015373851;14103.576892693236;14135.293235338191;8058.677652893819;8305.37709671777;8312.8753068704;8320.459170153921;8373.916260837435;3387;3422.19578399081;3426.880059197916;3433.4163192257374;3462.117160124152;1023.7645341571331;1024.8923862994427;1028.2699283508794;1075.1291453922347;1088.9782204356027;31647.525287120712;31892.681073189437;31994.20014499656;32509.51235731466;32584.67415325864;1010.1161483701761;1045.9006394392673;1145.4959817680194;1200.9939950300193;1215.3862299538675;14450.494232701805;16085.276162572713;16481.34074637025;16837.831621683872;17002.319907203575;379225.2077479245;382399;385129;388140;390246;62032.689836550526;62630;62664.06003909945;62829;62836.68581657062;1276.3363051213503;1355.024382444658;1432.3124900048244;1450.4560789703862;1462.5539210540887;31096;32188;33235.335293293516;33315.66684333223;33879.32241355209;52554.948901021;53195.4680453206;53212;53276;53279;551757;551927;553812;553883;575615;25057.624135637616;25200.873995629903;27242.5913611292;27255;28286.85856570704;48493.272600910306;48535;48715.756421217666;48917.28789492351;49423.50576494189;33002.83498582492;38578.2995190334;40165;41220.79389603033;41340.48605868535;39189.41215881821;39650.2069958605;40771.796141019106;41008.97477562966;41796.3730544036;39556;41295.38056929209;41783;41839;41890.58109418867;28464.861405543546;36304.81847590745;36456.27087458289;36972.075698107765;37151.62848371482;26576.468470630865;27171.86414067917;27247.182584522496;27306.858917391404;27562 15:29:52 INFO - PROCESS | 2533 | |2;jquery.html;326.6260132148689;330.8213564675074;385.1392138570296;385.2852957763347;408.0879234909976;20251.49371265719;20994.370168894937;21368.679469807965;21967.121315147397;22184.88907555464;20829.166833326686;21195.57608847822;21575.676364854502;21833.344999649995;21852.12591496342;6068.757249710017;6077.969610151943;6179;6221.377862213765;6237.812865614016;4401.251787196168;4522.299043648223;6162.322144564095;6243.968780156116;6259.655718935457;3952.9209415811665;4475.1944649963;6826.044353790473;6934.47991400647;6935.306469353075;6605.438537724299;6791.966040169767;6925.722971081176;6928.16861976561;6930.826729331782;5926.496247818941;5926.614770039977;5929.792457263975;5931.377205393414;5939.316978547479;26342.209733707827;26646.86676566624;26838;26909.730902690917;27125.728742712716;2252.9887350563145;2307.7807608277185;2456.680631517909;2874.6837847836723;3113.7664675149454;14700.852991470163;15677;15713.450029248921;16108.59728506785;16705.582360440963;1892.8864268143955;1946.4063460644497;1954.491832123658;1979.910904009323;1990.1143990924045;76472.99999999945;80119.59641210773;88241.55879220627;125450.49099017968;129198;10457.320274182306;10674.946625266824;10848.891511084947;11268.54925802975;11396.202265841312;14156.575302740934;14281.14313141215;14301.92849035748;14306.499272525412;14306.713865722628;9044.638214471479;9099.54502274897;9105.681301154427;9126.771830704285;9205;9213.539323033821;9225.446473211628;9227.815443691223;9362.34463587556;9407.90592094084;6629.7679581214425;6649.800505984828;6693.263740988487;6706.5640733352175;6816.761413350609;1616.5150454863494;1624.813146488169;1850.287639258868;1860.2558976409543;1887.6319117771902;871.8735783311384;973.7419583810296;997.1474389397106;1002.6190047781796;1024.5543188712934;17518.21168047441;20278.594428111355;21281.893590532258;22464.77535224627;22611.660825087638;969.6170012845027;974.4835237324229;974.8732664753537;990.5988074829561;1009.2783659683215;9275.953620231856;11274.718132046764;11757.706057348463;11944.283342999448;12285.754284914252;664419;665636;667606;670013;674972;146260;146707;151687;152316.1525771121;152382.95234095477;1033.256055639938;1049.275999560301;1058.7247315697973;1059.750958524746;1064.0423618743193;19013.524661883563;19728.802711972698;20204.93275332245;20440;20547.4863128423;55107;59989;60429.69785151222;61265.69367153136;62131.06803398043;83719;86674;90370.54814725884;92515.53742231245;92797.53601231951;6811.284815094344;8145.348372130334;8278.875816862872;8340.749777506684;8406.621702023302;9059.547022648972;11397.772044558897;11584.884151158381;12771.978241740824;13266.27035513056;11028.779424411307;11498.367589782642;11742.88257117418;11960.64118076459;12014.819777703517;5219.608529360389;9435.80586761914;9625.71122866315;9673.065386922784;11335.773284534429;11014.3942083183;11552.249103808226;11769.352685602375;11889.881101189223;11958.222715523463;7216.953541736524;8160.795980100545;8294.336453083619;8554.615042322986;8598.862943756541;11530.019948304489;11625.24435911663;12048.397580120783;12056;12078.577249796215 15:29:52 INFO - PROCESS | 2533 | |3;mootools.html;1417.5038736442252;1451.4266864588485;1574.9370025198994;1791.5342011077116;1941.524326539997;8269.13174116718;8826.691065812698;9125.680601178952;9343;9370.297227707915;9249.53752312385;9323.160915517603;9346;9350.158485736283;9356.906430935689;2433.6957880264968;2463.8296809015756;2470.8641024743633;2473.863937483438;2480.52869954708;2409.9277021689377;2470.3947532854477;2474.6906636670415;2475.084218839032;2477.764612361823;2431.088341871798;2455.1161581830524;2466.5930121529927;2471.5551200783852;2472.0482614193484;2412.5657381671294;2430.732619411863;2442.145249162788;2449.461118553915;2449.963250551243;2043.3461292386442;2401.8318717689767;2428.453597940449;2428.987855060731;2429.307647320505;9165.945916219653;9310.115539023782;9359.672411465566;9360.719178424659;9371.906280937172;5445.891082178374;5666;5686.09022556389;5699.68651724155;5709.600327977043;3729.086373838427;3766.2090960898245;3820;3835.846566137351;3857.710671699606;1059.2055958031476;1064.8935106489366;1067.4075887882223;1085.91312694985;1093.6117678224275;12473.812892806525;12483.687907802287;12604.747905041939;12605.999999999909;12613.99088072952;4575.10785396851;4588.220002599566;4784.856454306307;4788.880277993078;4836.12949669063;9608.567614457366;9614.18279446241;9622.759431014141;9636.22910167199;9661.46861922601;5490.258815059916;5491.395946445888;5498.505134537831;5506.476884695948;5509.256250406224;4642.721436713808;4758.78585463655;4970.950290497121;5079.517445842639;5159.303494028333;3876.321643712339;3898.200868821885;3977.065389633434;4007.6393124618926;4010.19796040793;1063.989360106389;1172.5720112159172;1182.148852825964;1182.6511179202157;1194.1640851404052;692.4668005635632;913.6025828764509;920.3235621817959;937.4141161773891;938.8826396700413;5718.599698021098;5889.204957330706;5938.762449501972;6047.576669633084;6164.506839452833;432.8506665200501;1038.5170895533613;1057.7778666479971;1065.627030539305;1077.256692881909;3631.328204282216;3948.230095131479;4066.1461093170174;4111.938320925188;4184.8744537663915;11303.547858085749;11561.248518846249;11706.414679266003;11710.180287379802;11728.648140555797;11574.537018519333;11647.708807279716;11650.6504804856;11663;11698.649040528799;8546.2308392245;8771.473711577326;8772.254358379609;8779;8794.60424280909;5514.779408823602;5779.508741756829;6100.847478812888;6104.11490333908;6323.905141422974;10132.290739648153;10253.692389228336;10452.268341216042;10575.62985295511;10630.8405373921;10782.1913356497;10949.781004380027;10956.178286628376;10978.286411383235;10989.230753847154;7064.399526040344;7572.409793943333;7837.960810195913;7841.333486653698;8025.317847982987;8625.741227763177;8869.512176830078;8870.334724895787;8883.111688831064;8885.644574217218;7089.503734738519;7712.341846503029;7744.419168562267;7875.724349647735;8004.959975200087;7590.924090759243;7623.123340815655;7683.193264707125;7714.652840622073;7736.419768517271;7237.203907570058;7381.889271660822;7383.07711536058;7383.8154046149275;7386.593737344498;5056.7724452399;5082.923756143735;5102.566281865935;5229.92155117666;5383.488568585978;4754.23932170851;5037;5224.764885580082;5226.902350506436;5232.319798426181 15:29:52 INFO - PROCESS | 2533 | |4;prototype.html;256.874131675479;301.68323260576403;307.31162196679446;311.5700333539716;315.2921690804145;4464.5981861632445;4948.950510494894;5364.2374177298725;5473.534749546293;5487.259220005298;3989.464056338309;4207.095474472988;5113;5230.320058392414;5351.946480535194;3476.7913925164444;3635.690966267857;4086.3257562502154;4130.554305992909;4132;4025.6376926076646;4074.2666320062376;4095.4675892133982;4102.528209255929;4156.334986402177;3220.951685724716;3758.2107757370986;4012.1574469361467;4086.6730661547003;4128.50457945047;3544.503769472276;4033.4554835097474;4071.7149799514045;4086.8569600064;4114.794260286989;2924.7513961313316;3286.2441638423297;3474.9922522468455;3490.162361033359;3495.353359628477;4354.934675979863;5264.341732354334;5266.368035835686;5300.549453296474;5342.973285133549;3984.4222587724616;4419.734815911023;4467.994701192239;4596.655705590139;4648.3259927310355;4481.910361792746;5558.471945165203;5563.415841336642;5605.159226116074;5613.971930140364;3700.4264339027495;3817.4846395736777;3842.2315536892734;3850.2876967761053;3864.845406183749;4846.369971903665;5587;5843.795467158671;5871.55963302754;5882;3280.7867488613165;3737.3646480097905;3860.3051450739135;3877.360235561101;3884.7474914131058;3352.5641666583188;3375.7974521528786;3800.4299355096955;3924.6075392460525;3979.3235150024566;4441.755703436277;4611.123886461562;4621.976890115528;4642.701862578046;4651.790669419885;4263.424437700871;5018.673786203885;5540.667559946416;5623.48165995179;5641.26663533738;1112.777444511101;1143.8398624192619;1322.7023919618202;1334.6663334166458;1336.2583766009764;821.2075347289893;835.8829763833069;867.2151702709058;867.4491697771834;872.8472517309445;4221.324588065895;4452.220861349251;5275.683458992473;5343.305370301913;5394.78420863161;5276.314079169761;5302.098643230583;5345.1447768356875;5806.167929166814;5849.718609742204;4859.659823812299;5238.5023422774775;5261.237120617566;5302.28419163408;5302.522772950376;2425;2968.3618022124915;2996.310848504856;2998.7301142897245;2999.9550006749914;4996.725180115056;5392.811251606175;5790.565707571949;5957.672328021914;5978.970105149533;4886.315915771795;5623.437656234344;5726.0838265877255;5763.625364351304;5775.6823374714795;5220.895582088337;5903.675297858573;5926.9331520325895;5932.822015339547;5982.371850955761;5301.575873929999;5630.719558578782;5634.32388113429;5658.877920779708;5746.396628353963;4636.6058884995155;5113.801065541853;5596.356419011866;5617.634853734494;5629.802956896489;5283.894322113613;5535.557155427476;5928.466438020599;5986.640801551921;5993.550483713651;3673.944890826693;3788.886333410002;3799.544054713452;3825.9043523912123;3828.2917660232947;4715.986062996472;4723.692959957729;5356.0626890294825;5394.568434525307;5695.45893140151;4544.613707834871;4784.665073444965;5621.80323688669;5632.986062508624;5645.887082258249;4441.422615060022;5082.644214904921;5513.338399392099;5517.020808763223;5531.668099914018;5225.372955245395;5391.406945236099;5427.6472029317965;5433.945660543344;5441.673499590037;4619.3994780678295;5052.671576347526;5314.548263397654;5614.21401003868;5664.971675141598;4832.95167048325;5502.284702988586;5533.280673512418;5534;5549.694766787866 15:29:52 INFO - PROCESS | 2533 | |5;yui.html;713.7965679781261;773.331068625639;791.3708601661682;818.4475479051639;846.8560344741393;15865.84134158658;16947.576310592227;16947.74578381322;16971.32114715413;17606.647867042684;16988.235529401176;17340.653186936284;17556;17557.91221043893;17568.736468952975;727.5489196698028;752.8607207666599;886.6143227695941;909.6452383570413;911.9726408207764;768.2317682317682;875.4397185801092;899.6356475627381;902.251131560803;902.5803001604253;875.0811647769848;935.6117211357279;961.4519723757461;965.1554889471712;965.2760429677742;958.0754571838174;958.6021800952597;958.6500927161605;959.9952000239954;963.0465838819588;681.1927865479423;693.9861202775967;711.7722328854769;713.9821504462378;714.5355518912696;15920.442784502602;15929.761053584205;15939.84060159395;15944.521664350088;15958.680826383523;14493.637659058502;14581.44824655681;14609;14678.633034174125;15003.474878379204;10238.488075596191;12088.516459341616;12099.939500302531;12587.93706031464;13063.216207027608;3857.1707082977014;3968.146848427602;4051.574584668597;4140.60664236897;4143.274926887782;125580;125704;126658.3667081668;127879;128274;11306.491207895664;11349.09207263417;11542.480588373543;11691.408811780784;11821.822672659917;23143.537129257656;23152.884235578713;23201.071957121865;23244.41888952756;23459.530809384058;8277.95861020691;8291.751247462586;8296.792580185544;8352.791180220422;8353.749387518385;3947.230290093404;4495.955040449619;4587.61005314552;4779.665423420327;4781.737004464719;3737.2151848111657;3808.428735689669;3852.711046671455;3852.768833869977;3853.7495062820826;691.6887400669718;694.8957656351487;700.8738427083174;701.3652644356865;712.0956385390525;609.0438012320614;620.8168590265882;678.3623394009616;691.872003679321;719.989200161998;7880.330171935335;10258.128059115059;10307.742306442398;10316.226283028804;10377.481125943672;645.8062581225613;677.3362105136895;703.2124021096405;709.5033476566321;719.8524302517972;4981.452040275567;4999.400071991385;5008.373953255843;5012.348394708664;5018.5232402921665;81525.18474815294;126154;131361;152763;166966;121672;143583.82080895914;144670;146172.26913865362;148323.2583837074;112690;113949.43025284821;114449;115204;117972.41013794875;9805.117539421486;10318.845217321596;10707.785844282915;10892.455377231265;10910.78178436411;57421.13868291895;58719.706401467716;64644.6767766177;65424;67092.32907670861;83098;90322.096779034;91233;94840;96041;13641.249731264876;13814.447422103003;13910.443582256596;14001.929990349983;14029.929850350683;14309.21299328547;14474.059186152866;15061.322240499423;15625.296861641025;15887.68224635524;12395.876041239471;14507.347169377192;14634.926825365805;14716.55850324492;14977.625559360667;13533.255670938193;13592.66018349549;14139.858601413855;14593.905457090548;15194.924025379802;12483.31341776211;13414.299471591134;14198.3610737515;14864;15175.772363414337;11334;11656.417179140839;11668;12447.315397653216;12687.302198379179;10443.738906527398;12180.695482613006;12241.143119981516;12275.877241227474;12419.31693756816 15:29:52 INFO - PROCESS | 2533 | __end_tp_report 15:29:52 INFO - PROCESS | 2533 | __start_cc_report 15:29:52 INFO - PROCESS | 2533 | _x_x_mozilla_cycle_collect,1366 15:29:52 INFO - PROCESS | 2533 | __end_cc_report 15:29:52 INFO - PROCESS | 2533 | __startTimestamp1479684592903__endTimestamp 15:29:52 INFO - PROCESS | 2533 | 15:29:52 INFO - PROCESS | 2533 | ------- Summary: start ------- 15:29:52 INFO - PROCESS | 2533 | Number of tests: 6 15:29:52 INFO - PROCESS | 2533 | 15:29:52 INFO - PROCESS | 2533 | [#0] dojo.html Cycles:165 Average:5801.41 Median:6075.61 stddev:640.04 (10.5%) stddev-sans-first:609.68 15:29:52 INFO - PROCESS | 2533 | Values: 3241.4 3406.4 3419.1 3426.2 3493.9 5684.2 5764.4 5772.1 5772.7 5786.2 5766.3 5822.7 5856.0 5867.8 5872.1 5204.7 5254.0 5265.2 5297.9 5305.8 5156.1 5174.3 5177.8 5319.7 5338.5 5299.5 5310.7 5316.2 5324.2 5330.1 5201.5 5296.9 5305.3 5306.8 5317.8 5122.1 5212.7 5214.7 5248.9 5293.9 5867.8 5870.0 5942.2 5987.4 6016.6 5210.3 6109.3 6129.6 6183.6 6183.7 6183.1 6215.5 6241.1 6264.8 6297.7 5984.4 6017.3 6032.6 6034.9 6075.6 6148.8 6223.1 6223.3 6331.9 6338.1 5200.2 6147.3 6201.4 6270.3 6272.5 6208.6 6268.1 6294.2 6296.4 6299.0 6138.4 6223.9 6237.0 6301.4 6307.3 6234.5 6279.8 6287.1 6291.5 6295.8 5048.4 5059.8 5062.5 5064.1 5087.5 4469.2 4568.5 4575.2 4579.6 4582.3 5037.6 5746.5 5772.3 5896.3 5986.6 6185.0 6237.8 6243.5 6260.1 6261.3 5973.4 5978.7 5983.8 5990.9 6052.8 5371.9 5373.5 5433.8 5457.1 5513.5 6400.7 6494.6 6501.0 6505.5 6517.5 6253.6 6258.6 6259.3 6273.4 6340.7 5439.5 6286.4 6322.5 6448.3 6496.8 6142.9 6146.8 6162.9 6275.1 6285.6 6259.5 6259.7 6268.0 6275.6 6278.4 6108.6 6191.1 6217.8 6224.4 6243.1 6115.8 6138.5 6140.7 6152.8 6233.1 6113.9 6128.3 6145.0 6150.0 6150.4 6025.0 6161.7 6218.2 6223.0 6228.6 5091.5 5939.2 6003.4 6070.7 6096.2 15:29:52 INFO - PROCESS | 2533 | 15:29:52 INFO - PROCESS | 2533 | [#1] ext.html Cycles:180 Average:62997.57 Median:3470.71 stddev:129119.51 (3720.3%) stddev-sans-first:129396.49 15:29:52 INFO - PROCESS | 2533 | Values: 509.1 517.4 526.4 545.3 555.8 30233.4 42491.8 43507.0 43701.0 46257.0 45591.8 45908.0 46036.5 46054.5 46059.8 9164.6 10038.0 10193.2 10234.9 10241.8 9291.4 12195.5 12466.3 12475.9 12645.2 12492.3 12524.7 12562.2 12568.1 12568.6 12404.6 12465.5 12474.2 12480.8 12483.1 12333.0 12359.1 12380.2 12389.8 12391.4 43039.0 43260.1 43434.1 43454.6 43488.2 3416.7 3506.0 3669.4 3676.5 3722.2 32096.8 32774.2 32849.8 33221.7 34029.8 3367.0 3384.2 3436.2 3457.4 3479.3 460860.0 462560.0 511052.0 526059.0 527074.0 35405.9 65700.0 66088.3 66336.7 66353.3 36301.0 37624.2 37682.4 37683.4 37696.8 16351.3 16515.8 16523.8 16524.9 16547.6 12742.9 12947.7 13998.0 14103.6 14135.3 8058.7 8305.4 8312.9 8320.5 8373.9 3387.0 3422.2 3426.9 3433.4 3462.1 1023.8 1024.9 1028.3 1075.1 1089.0 31647.5 31892.7 31994.2 32509.5 32584.7 1010.1 1045.9 1145.5 1201.0 1215.4 14450.5 16085.3 16481.3 16837.8 17002.3 379225.2 382399.0 385129.0 388140.0 390246.0 62032.7 62630.0 62664.1 62829.0 62836.7 1276.3 1355.0 1432.3 1450.5 1462.6 31096.0 32188.0 33235.3 33315.7 33879.3 52554.9 53195.5 53212.0 53276.0 53279.0 551757.0 551927.0 553812.0 553883.0 575615.0 25057.6 25200.9 27242.6 27255.0 28286.9 48493.3 48535.0 48715.8 48917.3 49423.5 33002.8 38578.3 40165.0 41220.8 41340.5 39189.4 39650.2 40771.8 41009.0 41796.4 39556.0 41295.4 41783.0 41839.0 41890.6 28464.9 36304.8 36456.3 36972.1 37151.6 26576.5 27171.9 27247.2 27306.9 27562.0 15:29:52 INFO - PROCESS | 2533 | 15:29:52 INFO - PROCESS | 2533 | [#2] jquery.html Cycles:180 Average:37973.46 Median:27017.73 stddev:111353.90 (412.2%) stddev-sans-first:111630.39 15:29:52 INFO - PROCESS | 2533 | Values: 326.6 330.8 385.1 385.3 408.1 20251.5 20994.4 21368.7 21967.1 22184.9 20829.2 21195.6 21575.7 21833.3 21852.1 6068.8 6078.0 6179.0 6221.4 6237.8 4401.3 4522.3 6162.3 6244.0 6259.7 3952.9 4475.2 6826.0 6934.5 6935.3 6605.4 6792.0 6925.7 6928.2 6930.8 5926.5 5926.6 5929.8 5931.4 5939.3 26342.2 26646.9 26838.0 26909.7 27125.7 2253.0 2307.8 2456.7 2874.7 3113.8 14700.9 15677.0 15713.5 16108.6 16705.6 1892.9 1946.4 1954.5 1979.9 1990.1 76473.0 80119.6 88241.6 125450.5 129198.0 10457.3 10674.9 10848.9 11268.5 11396.2 14156.6 14281.1 14301.9 14306.5 14306.7 9044.6 9099.5 9105.7 9126.8 9205.0 9213.5 9225.4 9227.8 9362.3 9407.9 6629.8 6649.8 6693.3 6706.6 6816.8 1616.5 1624.8 1850.3 1860.3 1887.6 871.9 973.7 997.1 1002.6 1024.6 17518.2 20278.6 21281.9 22464.8 22611.7 969.6 974.5 974.9 990.6 1009.3 9276.0 11274.7 11757.7 11944.3 12285.8 664419.0 665636.0 667606.0 670013.0 674972.0 146260.0 146707.0 151687.0 152316.2 152383.0 1033.3 1049.3 1058.7 1059.8 1064.0 19013.5 19728.8 20204.9 20440.0 20547.5 55107.0 59989.0 60429.7 61265.7 62131.1 83719.0 86674.0 90370.5 92515.5 92797.5 6811.3 8145.3 8278.9 8340.7 8406.6 9059.5 11397.8 11584.9 12772.0 13266.3 11028.8 11498.4 11742.9 11960.6 12014.8 5219.6 9435.8 9625.7 9673.1 11335.8 11014.4 11552.2 11769.4 11889.9 11958.2 7217.0 8160.8 8294.3 8554.6 8598.9 11530.0 11625.2 12048.4 12056.0 12078.6 15:29:52 INFO - PROCESS | 2533 | 15:29:52 INFO - PROCESS | 2533 | [#3] mootools.html Cycles:180 Average:5969.28 Median:4786.87 stddev:3427.92 (71.6%) stddev-sans-first:3420.47 15:29:52 INFO - PROCESS | 2533 | Values: 1417.5 1451.4 1574.9 1791.5 1941.5 8269.1 8826.7 9125.7 9343.0 9370.3 9249.5 9323.2 9346.0 9350.2 9356.9 2433.7 2463.8 2470.9 2473.9 2480.5 2409.9 2470.4 2474.7 2475.1 2477.8 2431.1 2455.1 2466.6 2471.6 2472.0 2412.6 2430.7 2442.1 2449.5 2450.0 2043.3 2401.8 2428.5 2429.0 2429.3 9165.9 9310.1 9359.7 9360.7 9371.9 5445.9 5666.0 5686.1 5699.7 5709.6 3729.1 3766.2 3820.0 3835.8 3857.7 1059.2 1064.9 1067.4 1085.9 1093.6 12473.8 12483.7 12604.7 12606.0 12614.0 4575.1 4588.2 4784.9 4788.9 4836.1 9608.6 9614.2 9622.8 9636.2 9661.5 5490.3 5491.4 5498.5 5506.5 5509.3 4642.7 4758.8 4971.0 5079.5 5159.3 3876.3 3898.2 3977.1 4007.6 4010.2 1064.0 1172.6 1182.1 1182.7 1194.2 692.5 913.6 920.3 937.4 938.9 5718.6 5889.2 5938.8 6047.6 6164.5 432.9 1038.5 1057.8 1065.6 1077.3 3631.3 3948.2 4066.1 4111.9 4184.9 11303.5 11561.2 11706.4 11710.2 11728.6 11574.5 11647.7 11650.7 11663.0 11698.6 8546.2 8771.5 8772.3 8779.0 8794.6 5514.8 5779.5 6100.8 6104.1 6323.9 10132.3 10253.7 10452.3 10575.6 10630.8 10782.2 10949.8 10956.2 10978.3 10989.2 7064.4 7572.4 7838.0 7841.3 8025.3 8625.7 8869.5 8870.3 8883.1 8885.6 7089.5 7712.3 7744.4 7875.7 8005.0 7590.9 7623.1 7683.2 7714.7 7736.4 7237.2 7381.9 7383.1 7383.8 7386.6 5056.8 5082.9 5102.6 5229.9 5383.5 4754.2 5037.0 5224.8 5226.9 5232.3 15:29:52 INFO - PROCESS | 2533 | 15:29:52 INFO - PROCESS | 2533 | [#4] prototype.html Cycles:180 Average:4461.20 Median:5007.70 stddev:1385.04 (27.7%) stddev-sans-first:1352.50 15:29:52 INFO - PROCESS | 2533 | Values: 256.9 301.7 307.3 311.6 315.3 4464.6 4949.0 5364.2 5473.5 5487.3 3989.5 4207.1 5113.0 5230.3 5351.9 3476.8 3635.7 4086.3 4130.6 4132.0 4025.6 4074.3 4095.5 4102.5 4156.3 3221.0 3758.2 4012.2 4086.7 4128.5 3544.5 4033.5 4071.7 4086.9 4114.8 2924.8 3286.2 3475.0 3490.2 3495.4 4354.9 5264.3 5266.4 5300.5 5343.0 3984.4 4419.7 4468.0 4596.7 4648.3 4481.9 5558.5 5563.4 5605.2 5614.0 3700.4 3817.5 3842.2 3850.3 3864.8 4846.4 5587.0 5843.8 5871.6 5882.0 3280.8 3737.4 3860.3 3877.4 3884.7 3352.6 3375.8 3800.4 3924.6 3979.3 4441.8 4611.1 4622.0 4642.7 4651.8 4263.4 5018.7 5540.7 5623.5 5641.3 1112.8 1143.8 1322.7 1334.7 1336.3 821.2 835.9 867.2 867.4 872.8 4221.3 4452.2 5275.7 5343.3 5394.8 5276.3 5302.1 5345.1 5806.2 5849.7 4859.7 5238.5 5261.2 5302.3 5302.5 2425.0 2968.4 2996.3 2998.7 3000.0 4996.7 5392.8 5790.6 5957.7 5979.0 4886.3 5623.4 5726.1 5763.6 5775.7 5220.9 5903.7 5926.9 5932.8 5982.4 5301.6 5630.7 5634.3 5658.9 5746.4 4636.6 5113.8 5596.4 5617.6 5629.8 5283.9 5535.6 5928.5 5986.6 5993.6 3673.9 3788.9 3799.5 3825.9 3828.3 4716.0 4723.7 5356.1 5394.6 5695.5 4544.6 4784.7 5621.8 5633.0 5645.9 4441.4 5082.6 5513.3 5517.0 5531.7 5225.4 5391.4 5427.6 5433.9 5441.7 4619.4 5052.7 5314.5 5614.2 5665.0 4833.0 5502.3 5533.3 5534.0 5549.7 15:29:52 INFO - PROCESS | 2533 | 15:29:52 INFO - PROCESS | 2533 | [#5] yui.html Cycles:180 Average:25785.11 Median:17587.69 stddev:40699.31 (231.4%) stddev-sans-first:40769.95 15:29:52 INFO - PROCESS | 2533 | Values: 713.8 773.3 791.4 818.4 846.9 15865.8 16947.6 16947.7 16971.3 17606.6 16988.2 17340.7 17556.0 17557.9 17568.7 727.5 752.9 886.6 909.6 912.0 768.2 875.4 899.6 902.3 902.6 875.1 935.6 961.5 965.2 965.3 958.1 958.6 958.7 960.0 963.0 681.2 694.0 711.8 714.0 714.5 15920.4 15929.8 15939.8 15944.5 15958.7 14493.6 14581.4 14609.0 14678.6 15003.5 10238.5 12088.5 12099.9 12587.9 13063.2 3857.2 3968.1 4051.6 4140.6 4143.3 125580.0 125704.0 126658.4 127879.0 128274.0 11306.5 11349.1 11542.5 11691.4 11821.8 23143.5 23152.9 23201.1 23244.4 23459.5 8278.0 8291.8 8296.8 8352.8 8353.7 3947.2 4496.0 4587.6 4779.7 4781.7 3737.2 3808.4 3852.7 3852.8 3853.7 691.7 694.9 700.9 701.4 712.1 609.0 620.8 678.4 691.9 720.0 7880.3 10258.1 10307.7 10316.2 10377.5 645.8 677.3 703.2 709.5 719.9 4981.5 4999.4 5008.4 5012.3 5018.5 81525.2 126154.0 131361.0 152763.0 166966.0 121672.0 143583.8 144670.0 146172.3 148323.3 112690.0 113949.4 114449.0 115204.0 117972.4 9805.1 10318.8 10707.8 10892.5 10910.8 57421.1 58719.7 64644.7 65424.0 67092.3 83098.0 90322.1 91233.0 94840.0 96041.0 13641.2 13814.4 13910.4 14001.9 14029.9 14309.2 14474.1 15061.3 15625.3 15887.7 12395.9 14507.3 14634.9 14716.6 14977.6 13533.3 13592.7 14139.9 14593.9 15194.9 12483.3 13414.3 14198.4 14864.0 15175.8 11334.0 11656.4 11668.0 12447.3 12687.3 10443.7 12180.7 12241.1 12275.9 12419.3 15:29:52 INFO - PROCESS | 2533 | -------- Summary: end -------- 15:29:52 INFO - PROCESS | 2533 | 15:29:53 INFO - TEST-INFO | 2533: exit 0 15:29:53 INFO - TEST-OK | dromaeo_css | took 1115133ms 15:29:53 INFO - TEST-START | kraken 15:29:53 INFO - operating with platform_type : mac_ 15:29:53 INFO - Initialising browser for kraken test... 15:29:53 INFO - TEST-INFO | started process 2535 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmperbtzg/profile http://localhost:56056/getInfo.html) 15:29:55 INFO - PROCESS | 2535 | __metrics Screen width/height:1600/1200 15:29:55 INFO - PROCESS | 2535 | colorDepth:24 15:29:55 INFO - PROCESS | 2535 | Browser inner width/height: 1024/689 15:29:55 INFO - PROCESS | 2535 | __metrics 15:29:55 INFO - PROCESS | 2535 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:29:55 INFO - PROCESS | 2535 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:29:56 INFO - TEST-INFO | 2535: exit 0 15:29:56 INFO - Browser initialized. 15:29:56 INFO - Running cycle 1/1 for kraken test... 15:29:56 INFO - TEST-INFO | started process 2537 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmperbtzg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:30:08 INFO - PROCESS | 2537 | RSS: Main: 168161280 15:30:08 INFO - PROCESS | 2537 | 15:30:11 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:56056/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56056/tests/kraken/driver.html?testName=audio-beat-detection) 15:30:12 INFO - PROCESS | 2537 | RSS: Main: 219381760 15:30:12 INFO - PROCESS | 2537 | 15:30:14 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:56056/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56056/tests/kraken/driver.html?testName=audio-dft) 15:30:15 INFO - PROCESS | 2537 | RSS: Main: 229466112 15:30:15 INFO - PROCESS | 2537 | 15:30:18 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:56056/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56056/tests/kraken/driver.html?testName=audio-fft) 15:30:18 INFO - PROCESS | 2537 | RSS: Main: 326807552 15:30:18 INFO - PROCESS | 2537 | 15:30:20 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:56056/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56056/tests/kraken/driver.html?testName=audio-oscillator) 15:30:21 INFO - PROCESS | 2537 | RSS: Main: 229478400 15:30:21 INFO - PROCESS | 2537 | 15:30:23 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:56056/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56056/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:30:24 INFO - PROCESS | 2537 | RSS: Main: 229896192 15:30:24 INFO - PROCESS | 2537 | 15:30:26 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:56056/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56056/tests/kraken/driver.html?testName=imaging-darkroom) 15:30:27 INFO - PROCESS | 2537 | RSS: Main: 266027008 15:30:27 INFO - PROCESS | 2537 | 15:30:30 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:56056/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56056/tests/kraken/driver.html?testName=imaging-desaturate) 15:30:30 INFO - PROCESS | 2537 | RSS: Main: 268255232 15:30:30 INFO - PROCESS | 2537 | 15:30:33 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:56056/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56056/tests/kraken/driver.html?testName=json-parse-financial) 15:30:34 INFO - PROCESS | 2537 | RSS: Main: 269119488 15:30:34 INFO - PROCESS | 2537 | 15:30:35 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:56056/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56056/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:30:36 INFO - PROCESS | 2537 | RSS: Main: 242479104 15:30:36 INFO - PROCESS | 2537 | 15:30:38 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:56056/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56056/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:30:39 INFO - PROCESS | 2537 | RSS: Main: 243564544 15:30:39 INFO - PROCESS | 2537 | 15:30:41 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:56056/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56056/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:30:41 INFO - PROCESS | 2537 | RSS: Main: 252260352 15:30:41 INFO - PROCESS | 2537 | 15:30:44 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:56056/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56056/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:30:45 INFO - PROCESS | 2537 | RSS: Main: 266739712 15:30:45 INFO - PROCESS | 2537 | 15:30:47 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:56056/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56056/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:30:48 INFO - PROCESS | 2537 | RSS: Main: 260198400 15:30:48 INFO - PROCESS | 2537 | 15:30:50 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:56056/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56056/tests/kraken/driver.html?testName=ai-astar) 15:30:50 INFO - PROCESS | 2537 | RSS: Main: 304226304 15:30:50 INFO - PROCESS | 2537 | 15:30:50 INFO - PROCESS | 2537 | __start_tp_report 15:30:50 INFO - PROCESS | 2537 | _x_x_mozilla_page_load 15:30:50 INFO - PROCESS | 2537 | _x_x_mozilla_page_load_details 15:30:50 INFO - PROCESS | 2537 | |i|pagename|runs| 15:30:50 INFO - PROCESS | 2537 | |0;ai-astar;115;112;113;115;158;162;112;112;112;113 15:30:50 INFO - PROCESS | 2537 | |1;audio-beat-detection;146;106;106;142;106;110;132;133;141;106 15:30:50 INFO - PROCESS | 2537 | |2;audio-dft;185;185;185;181;183;182;184;185;184;182 15:30:50 INFO - PROCESS | 2537 | |3;audio-fft;82;59;59;89;59;58;59;58;81;57 15:30:50 INFO - PROCESS | 2537 | |4;audio-oscillator;89;70;91;69;68;68;91;67;68;90 15:30:50 INFO - PROCESS | 2537 | |5;imaging-gaussian-blur;92;92;130;126;91;89;92;88;91;91 15:30:50 INFO - PROCESS | 2537 | |6;imaging-darkroom;95;94;96;95;96;95;95;96;97;96 15:30:50 INFO - PROCESS | 2537 | |7;imaging-desaturate;87;87;86;85;84;86;86;84;83;82 15:30:50 INFO - PROCESS | 2537 | |8;json-parse-financial;54;53;51;52;57;55;57;55;56;55 15:30:50 INFO - PROCESS | 2537 | |9;json-stringify-tinderbox;64;65;76;71;72;68;98;95;97;83 15:30:50 INFO - PROCESS | 2537 | |10;stanford-crypto-aes;82;84;82;81;84;81;80;83;87;82 15:30:50 INFO - PROCESS | 2537 | |11;stanford-crypto-ccm;137;135;135;129;133;132;141;145;199;130 15:30:50 INFO - PROCESS | 2537 | |12;stanford-crypto-pbkdf2;164;160;159;158;163;160;168;160;160;161 15:30:50 INFO - PROCESS | 2537 | |13;stanford-crypto-sha256-iterative;66;78;82;79;81;71;64;64;65;65 15:30:50 INFO - PROCESS | 2537 | __end_tp_report 15:30:50 INFO - PROCESS | 2537 | __start_cc_report 15:30:50 INFO - PROCESS | 2537 | _x_x_mozilla_cycle_collect,1905 15:30:50 INFO - PROCESS | 2537 | __end_cc_report 15:30:50 INFO - PROCESS | 2537 | __startTimestamp1479684650613__endTimestamp 15:30:50 INFO - PROCESS | 2537 | 15:30:50 INFO - PROCESS | 2537 | ------- Summary: start ------- 15:30:50 INFO - PROCESS | 2537 | Number of tests: 14 15:30:50 INFO - PROCESS | 2537 | 15:30:50 INFO - PROCESS | 2537 | [#0] ai-astar Cycles:10 Average:122.40 Median:114.00 stddev:19.87 (17.4%) stddev-sans-first:20.90 15:30:50 INFO - PROCESS | 2537 | Values: 115.0 112.0 113.0 115.0 158.0 162.0 112.0 112.0 112.0 113.0 15:30:50 INFO - PROCESS | 2537 | 15:30:50 INFO - PROCESS | 2537 | [#1] audio-beat-detection Cycles:10 Average:122.80 Median:132.50 stddev:17.38 (13.1%) stddev-sans-first:16.28 15:30:50 INFO - PROCESS | 2537 | Values: 146.0 106.0 106.0 142.0 106.0 110.0 132.0 133.0 141.0 106.0 15:30:50 INFO - PROCESS | 2537 | 15:30:50 INFO - PROCESS | 2537 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.50 stddev:1.51 (0.8%) stddev-sans-first:1.51 15:30:50 INFO - PROCESS | 2537 | Values: 185.0 185.0 185.0 181.0 183.0 182.0 184.0 185.0 184.0 182.0 15:30:50 INFO - PROCESS | 2537 | 15:30:50 INFO - PROCESS | 2537 | [#3] audio-fft Cycles:10 Average:66.10 Median:59.00 stddev:12.54 (21.3%) stddev-sans-first:11.91 15:30:50 INFO - PROCESS | 2537 | Values: 82.0 59.0 59.0 89.0 59.0 58.0 59.0 58.0 81.0 57.0 15:30:50 INFO - PROCESS | 2537 | 15:30:50 INFO - PROCESS | 2537 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:79.50 stddev:11.36 (14.3%) stddev-sans-first:11.20 15:30:50 INFO - PROCESS | 2537 | Values: 89.0 70.0 91.0 69.0 68.0 68.0 91.0 67.0 68.0 90.0 15:30:50 INFO - PROCESS | 2537 | 15:30:50 INFO - PROCESS | 2537 | [#5] imaging-gaussian-blur Cycles:10 Average:98.20 Median:91.00 stddev:15.79 (17.4%) stddev-sans-first:16.59 15:30:50 INFO - PROCESS | 2537 | Values: 92.0 92.0 130.0 126.0 91.0 89.0 92.0 88.0 91.0 91.0 15:30:50 INFO - PROCESS | 2537 | 15:30:50 INFO - PROCESS | 2537 | [#6] imaging-darkroom Cycles:10 Average:95.50 Median:96.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 15:30:50 INFO - PROCESS | 2537 | Values: 95.0 94.0 96.0 95.0 96.0 95.0 95.0 96.0 97.0 96.0 15:30:50 INFO - PROCESS | 2537 | 15:30:50 INFO - PROCESS | 2537 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:86.00 stddev:1.70 (2.0%) stddev-sans-first:1.64 15:30:50 INFO - PROCESS | 2537 | Values: 87.0 87.0 86.0 85.0 84.0 86.0 86.0 84.0 83.0 82.0 15:30:50 INFO - PROCESS | 2537 | 15:30:50 INFO - PROCESS | 2537 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:2.01 (3.7%) stddev-sans-first:2.13 15:30:50 INFO - PROCESS | 2537 | Values: 54.0 53.0 51.0 52.0 57.0 55.0 57.0 55.0 56.0 55.0 15:30:50 INFO - PROCESS | 2537 | 15:30:50 INFO - PROCESS | 2537 | [#9] json-stringify-tinderbox Cycles:10 Average:78.90 Median:79.50 stddev:13.42 (16.9%) stddev-sans-first:13.11 15:30:50 INFO - PROCESS | 2537 | Values: 64.0 65.0 76.0 71.0 72.0 68.0 98.0 95.0 97.0 83.0 15:30:50 INFO - PROCESS | 2537 | 15:30:50 INFO - PROCESS | 2537 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.50 stddev:2.01 (2.4%) stddev-sans-first:2.12 15:30:50 INFO - PROCESS | 2537 | Values: 82.0 84.0 82.0 81.0 84.0 81.0 80.0 83.0 87.0 82.0 15:30:50 INFO - PROCESS | 2537 | 15:30:50 INFO - PROCESS | 2537 | [#11] stanford-crypto-ccm Cycles:10 Average:141.60 Median:136.00 stddev:20.75 (15.3%) stddev-sans-first:21.94 15:30:50 INFO - PROCESS | 2537 | Values: 137.0 135.0 135.0 129.0 133.0 132.0 141.0 145.0 199.0 130.0 15:30:50 INFO - PROCESS | 2537 | 15:30:50 INFO - PROCESS | 2537 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:160.50 stddev:2.95 (1.8%) stddev-sans-first:2.96 15:30:50 INFO - PROCESS | 2537 | Values: 164.0 160.0 159.0 158.0 163.0 160.0 168.0 160.0 160.0 161.0 15:30:50 INFO - PROCESS | 2537 | 15:30:50 INFO - PROCESS | 2537 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:74.50 stddev:7.65 (10.3%) stddev-sans-first:7.85 15:30:50 INFO - PROCESS | 2537 | Values: 66.0 78.0 82.0 79.0 81.0 71.0 64.0 64.0 65.0 65.0 15:30:50 INFO - PROCESS | 2537 | -------- Summary: end -------- 15:30:50 INFO - PROCESS | 2537 | 15:30:51 INFO - TEST-INFO | 2537: exit 0 15:30:51 INFO - TEST-OK | kraken | took 57891ms 15:30:51 INFO - SUITE-END | took 1173s 15:30:51 INFO - Completed test suite (00:19:33) 15:30:51 INFO - javascript benchmark 15:30:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3241.351729654069, 3406.3698215830073, 3419.0597585663954, 3426.2462258303194, 3493.912652183695, 5684.2326285951385, 5764.394738552449, 5772.134179873021, 5772.653640781556, 5786.1610066540325, 5766.279215098113, 5822.7088645567765, 5855.970720146393, 5867.823965281038, 5872.148538461921, 5204.739763011844, 5254.0, 5265.236540701596, 5297.894042119175, 5305.7877684892555, 5156.149235376159, 5174.327337446127, 5177.818776342829, 5319.734013299339, 5338.492843179892, 5299.5230429261355, 5310.70791106489, 5316.20256961455, 5324.227986941891, 5330.093884039723, 5201.479852014806, 5296.894062118756, 5305.310309659739, 5306.814261500867, 5317.787288508455, 5122.1036318644465, 5212.739363031871, 5214.739263036871, 5248.8687782805355, 5293.86765330866, 5867.76528938842, 5869.9706501467645, 5942.168096466498, 5987.431194036603, 6016.639001659914, 5210.296609957645, 6109.2528441424865, 6129.601575897553, 6183.567150299481, 6183.721732522003, 6183.1034499997695, 6215.502759779207, 6241.126242326078, 6264.780732674334, 6297.685115744241, 5984.371640977678, 6017.308009578955, 6032.638041717511, 6034.909476357858, 6075.605085669417, 6148.846278843064, 6223.097650840603, 6223.284322302993, 6331.873362532816, 6338.080978258126, 5200.245964335226, 6147.323794382614, 6201.441870231701, 6270.2789179244055, 6272.498200143978, 6208.596441231305, 6268.122462855204, 6294.244690637152, 6296.433321001132, 6299.023651334051, 6138.388398386059, 6223.906641400383, 6236.968815155986, 6301.369863013662, 6307.306196318401, 6234.501239900797, 6279.843003924847, 6287.056941458726, 6291.5281353898645, 6295.811125666238, 5048.368953880765, 5059.797608095635, 5062.544371006627, 5064.139096353629, 5087.516685914832, 4469.217886869785, 4568.497465278817, 4575.199340115467, 4579.610733087658, 4582.312653102062, 5037.571806396498, 5746.482816546447, 5772.278465191851, 5896.262967129109, 5986.580939334205, 6185.0, 6237.812865614039, 6243.500519958392, 6260.092286618506, 6261.279952805395, 5973.432523910308, 5978.701064946736, 5983.761207106868, 5990.940090599038, 6052.818415447456, 5371.892562148813, 5373.543248823894, 5433.755481003364, 5457.126859702428, 5513.476219759116, 6400.743970241231, 6494.6103233806125, 6500.967495162494, 6505.479561634963, 6517.543771935919, 6253.624782513064, 6258.561900666909, 6259.311475737756, 6273.435390814849, 6340.71466784005, 5439.48324909133, 6286.434220919956, 6322.494200464043, 6448.32292609288, 6496.805095847132, 6142.897836592492, 6146.8321019008035, 6162.907556386747, 6275.090111933835, 6285.59143655661, 6259.467945224706, 6259.718312675849, 6267.96866015667, 6275.592086514362, 6278.434940855345, 6108.602940808833, 6191.102290167991, 6217.813465596039, 6224.37756224374, 6243.125962365181, 6115.755369785336, 6138.508919286357, 6140.692965351625, 6152.846178845564, 6233.096201050913, 6113.908291375544, 6128.325884152829, 6145.047517634774, 6149.96925015372, 6150.384961503813, 6024.969875150771, 6161.6919154041225, 6218.191635087591, 6222.973209420395, 6228.626282423069, 5091.465396133352, 5939.227900373096, 6003.3996600339615, 6070.696465176635, 6096.177016102769], "value": 5761.682693587833, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.149719967654, 517.3584754903919, 526.4025331249031, 545.2557259341, 555.8054680861701, 30233.395332093343, 42491.78754106229, 43507.0, 43701.0, 46257.0, 45591.77204113983, 45908.0, 46036.53963460364, 46054.539454605445, 46059.769701151534, 9164.587593558272, 10038.0, 10193.235507336942, 10234.897651023506, 10241.795164096713, 9291.39605925616, 12195.451204695766, 12466.314352710642, 12475.875241247608, 12645.241285522852, 12492.312922789242, 12524.686882827957, 12562.24626522407, 12568.057395695314, 12568.560100396488, 12404.62786116418, 12465.501379944792, 12474.18917770342, 12480.812787808236, 12483.126181167321, 12333.0, 12359.134860559765, 12380.195287306296, 12389.752204955941, 12391.442385092692, 43039.0, 43260.13479730419, 43434.131317373474, 43454.56545434537, 43488.17326873743, 3416.6583341665882, 3505.982470087659, 3669.412893936957, 3676.5036720042717, 3722.181120153562, 32096.839515802272, 32774.180645483815, 32849.83575082133, 33221.6677833221, 34029.82985085084, 3367.0, 3384.204711892728, 3436.2096717754807, 3457.3949558827103, 3479.304139172176, 460860.0, 462560.0, 511052.0, 526059.0, 527074.0, 35405.93782186539, 65700.0, 66088.33911660821, 66336.6683166581, 66353.33646663568, 36301.0, 37624.247515049545, 37682.434763478566, 37683.434748478794, 37696.811515942245, 16351.345946162259, 16515.83484165167, 16523.83476165223, 16524.917375413046, 16547.586310342096, 12742.872571274169, 12947.741045179044, 13997.95015373851, 14103.576892693236, 14135.293235338191, 8058.677652893819, 8305.37709671777, 8312.8753068704, 8320.459170153921, 8373.916260837435, 3387.0, 3422.19578399081, 3426.880059197916, 3433.4163192257374, 3462.117160124152, 1023.7645341571331, 1024.8923862994427, 1028.2699283508794, 1075.1291453922347, 1088.9782204356027, 31647.525287120712, 31892.681073189437, 31994.20014499656, 32509.51235731466, 32584.67415325864, 1010.1161483701761, 1045.9006394392673, 1145.4959817680194, 1200.9939950300193, 1215.3862299538675, 14450.494232701805, 16085.276162572713, 16481.34074637025, 16837.831621683872, 17002.319907203575, 379225.2077479245, 382399.0, 385129.0, 388140.0, 390246.0, 62032.689836550526, 62630.0, 62664.06003909945, 62829.0, 62836.68581657062, 1276.3363051213503, 1355.024382444658, 1432.3124900048244, 1450.4560789703862, 1462.5539210540887, 31096.0, 32188.0, 33235.335293293516, 33315.66684333223, 33879.32241355209, 52554.948901021, 53195.4680453206, 53212.0, 53276.0, 53279.0, 551757.0, 551927.0, 553812.0, 553883.0, 575615.0, 25057.624135637616, 25200.873995629903, 27242.5913611292, 27255.0, 28286.85856570704, 48493.272600910306, 48535.0, 48715.756421217666, 48917.28789492351, 49423.50576494189, 33002.83498582492, 38578.2995190334, 40165.0, 41220.79389603033, 41340.48605868535, 39189.41215881821, 39650.2069958605, 40771.796141019106, 41008.97477562966, 41796.3730544036, 39556.0, 41295.38056929209, 41783.0, 41839.0, 41890.58109418867, 28464.861405543546, 36304.81847590745, 36456.27087458289, 36972.075698107765, 37151.62848371482, 26576.468470630865, 27171.86414067917, 27247.182584522496, 27306.858917391404, 27562.0], "value": 19779.21407542139, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.6260132148689, 330.8213564675074, 385.1392138570296, 385.2852957763347, 408.0879234909976, 20251.49371265719, 20994.370168894937, 21368.679469807965, 21967.121315147397, 22184.88907555464, 20829.166833326686, 21195.57608847822, 21575.676364854502, 21833.344999649995, 21852.12591496342, 6068.757249710017, 6077.969610151943, 6179.0, 6221.377862213765, 6237.812865614016, 4401.251787196168, 4522.299043648223, 6162.322144564095, 6243.968780156116, 6259.655718935457, 3952.9209415811665, 4475.1944649963, 6826.044353790473, 6934.47991400647, 6935.306469353075, 6605.438537724299, 6791.966040169767, 6925.722971081176, 6928.16861976561, 6930.826729331782, 5926.496247818941, 5926.614770039977, 5929.792457263975, 5931.377205393414, 5939.316978547479, 26342.209733707827, 26646.86676566624, 26838.0, 26909.730902690917, 27125.728742712716, 2252.9887350563145, 2307.7807608277185, 2456.680631517909, 2874.6837847836723, 3113.7664675149454, 14700.852991470163, 15677.0, 15713.450029248921, 16108.59728506785, 16705.582360440963, 1892.8864268143955, 1946.4063460644497, 1954.491832123658, 1979.910904009323, 1990.1143990924045, 76472.99999999945, 80119.59641210773, 88241.55879220627, 125450.49099017968, 129198.0, 10457.320274182306, 10674.946625266824, 10848.891511084947, 11268.54925802975, 11396.202265841312, 14156.575302740934, 14281.14313141215, 14301.92849035748, 14306.499272525412, 14306.713865722628, 9044.638214471479, 9099.54502274897, 9105.681301154427, 9126.771830704285, 9205.0, 9213.539323033821, 9225.446473211628, 9227.815443691223, 9362.34463587556, 9407.90592094084, 6629.7679581214425, 6649.800505984828, 6693.263740988487, 6706.5640733352175, 6816.761413350609, 1616.5150454863494, 1624.813146488169, 1850.287639258868, 1860.2558976409543, 1887.6319117771902, 871.8735783311384, 973.7419583810296, 997.1474389397106, 1002.6190047781796, 1024.5543188712934, 17518.21168047441, 20278.594428111355, 21281.893590532258, 22464.77535224627, 22611.660825087638, 969.6170012845027, 974.4835237324229, 974.8732664753537, 990.5988074829561, 1009.2783659683215, 9275.953620231856, 11274.718132046764, 11757.706057348463, 11944.283342999448, 12285.754284914252, 664419.0, 665636.0, 667606.0, 670013.0, 674972.0, 146260.0, 146707.0, 151687.0, 152316.1525771121, 152382.95234095477, 1033.256055639938, 1049.275999560301, 1058.7247315697973, 1059.750958524746, 1064.0423618743193, 19013.524661883563, 19728.802711972698, 20204.93275332245, 20440.0, 20547.4863128423, 55107.0, 59989.0, 60429.69785151222, 61265.69367153136, 62131.06803398043, 83719.0, 86674.0, 90370.54814725884, 92515.53742231245, 92797.53601231951, 6811.284815094344, 8145.348372130334, 8278.875816862872, 8340.749777506684, 8406.621702023302, 9059.547022648972, 11397.772044558897, 11584.884151158381, 12771.978241740824, 13266.27035513056, 11028.779424411307, 11498.367589782642, 11742.88257117418, 11960.64118076459, 12014.819777703517, 5219.608529360389, 9435.80586761914, 9625.71122866315, 9673.065386922784, 11335.773284534429, 11014.3942083183, 11552.249103808226, 11769.352685602375, 11889.881101189223, 11958.222715523463, 7216.953541736524, 8160.795980100545, 8294.336453083619, 8554.615042322986, 8598.862943756541, 11530.019948304489, 11625.24435911663, 12048.397580120783, 12056.0, 12078.577249796215], "value": 10068.272387790805, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1417.5038736442252, 1451.4266864588485, 1574.9370025198994, 1791.5342011077116, 1941.524326539997, 8269.13174116718, 8826.691065812698, 9125.680601178952, 9343.0, 9370.297227707915, 9249.53752312385, 9323.160915517603, 9346.0, 9350.158485736283, 9356.906430935689, 2433.6957880264968, 2463.8296809015756, 2470.8641024743633, 2473.863937483438, 2480.52869954708, 2409.9277021689377, 2470.3947532854477, 2474.6906636670415, 2475.084218839032, 2477.764612361823, 2431.088341871798, 2455.1161581830524, 2466.5930121529927, 2471.5551200783852, 2472.0482614193484, 2412.5657381671294, 2430.732619411863, 2442.145249162788, 2449.461118553915, 2449.963250551243, 2043.3461292386442, 2401.8318717689767, 2428.453597940449, 2428.987855060731, 2429.307647320505, 9165.945916219653, 9310.115539023782, 9359.672411465566, 9360.719178424659, 9371.906280937172, 5445.891082178374, 5666.0, 5686.09022556389, 5699.68651724155, 5709.600327977043, 3729.086373838427, 3766.2090960898245, 3820.0, 3835.846566137351, 3857.710671699606, 1059.2055958031476, 1064.8935106489366, 1067.4075887882223, 1085.91312694985, 1093.6117678224275, 12473.812892806525, 12483.687907802287, 12604.747905041939, 12605.999999999909, 12613.99088072952, 4575.10785396851, 4588.220002599566, 4784.856454306307, 4788.880277993078, 4836.12949669063, 9608.567614457366, 9614.18279446241, 9622.759431014141, 9636.22910167199, 9661.46861922601, 5490.258815059916, 5491.395946445888, 5498.505134537831, 5506.476884695948, 5509.256250406224, 4642.721436713808, 4758.78585463655, 4970.950290497121, 5079.517445842639, 5159.303494028333, 3876.321643712339, 3898.200868821885, 3977.065389633434, 4007.6393124618926, 4010.19796040793, 1063.989360106389, 1172.5720112159172, 1182.148852825964, 1182.6511179202157, 1194.1640851404052, 692.4668005635632, 913.6025828764509, 920.3235621817959, 937.4141161773891, 938.8826396700413, 5718.599698021098, 5889.204957330706, 5938.762449501972, 6047.576669633084, 6164.506839452833, 432.8506665200501, 1038.5170895533613, 1057.7778666479971, 1065.627030539305, 1077.256692881909, 3631.328204282216, 3948.230095131479, 4066.1461093170174, 4111.938320925188, 4184.8744537663915, 11303.547858085749, 11561.248518846249, 11706.414679266003, 11710.180287379802, 11728.648140555797, 11574.537018519333, 11647.708807279716, 11650.6504804856, 11663.0, 11698.649040528799, 8546.2308392245, 8771.473711577326, 8772.254358379609, 8779.0, 8794.60424280909, 5514.779408823602, 5779.508741756829, 6100.847478812888, 6104.11490333908, 6323.905141422974, 10132.290739648153, 10253.692389228336, 10452.268341216042, 10575.62985295511, 10630.8405373921, 10782.1913356497, 10949.781004380027, 10956.178286628376, 10978.286411383235, 10989.230753847154, 7064.399526040344, 7572.409793943333, 7837.960810195913, 7841.333486653698, 8025.317847982987, 8625.741227763177, 8869.512176830078, 8870.334724895787, 8883.111688831064, 8885.644574217218, 7089.503734738519, 7712.341846503029, 7744.419168562267, 7875.724349647735, 8004.959975200087, 7590.924090759243, 7623.123340815655, 7683.193264707125, 7714.652840622073, 7736.419768517271, 7237.203907570058, 7381.889271660822, 7383.07711536058, 7383.8154046149275, 7386.593737344498, 5056.7724452399, 5082.923756143735, 5102.566281865935, 5229.92155117666, 5383.488568585978, 4754.23932170851, 5037.0, 5224.764885580082, 5226.902350506436, 5232.319798426181], "value": 4741.4430846858895, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [256.874131675479, 301.68323260576403, 307.31162196679446, 311.5700333539716, 315.2921690804145, 4464.5981861632445, 4948.950510494894, 5364.2374177298725, 5473.534749546293, 5487.259220005298, 3989.464056338309, 4207.095474472988, 5113.0, 5230.320058392414, 5351.946480535194, 3476.7913925164444, 3635.690966267857, 4086.3257562502154, 4130.554305992909, 4132.0, 4025.6376926076646, 4074.2666320062376, 4095.4675892133982, 4102.528209255929, 4156.334986402177, 3220.951685724716, 3758.2107757370986, 4012.1574469361467, 4086.6730661547003, 4128.50457945047, 3544.503769472276, 4033.4554835097474, 4071.7149799514045, 4086.8569600064, 4114.794260286989, 2924.7513961313316, 3286.2441638423297, 3474.9922522468455, 3490.162361033359, 3495.353359628477, 4354.934675979863, 5264.341732354334, 5266.368035835686, 5300.549453296474, 5342.973285133549, 3984.4222587724616, 4419.734815911023, 4467.994701192239, 4596.655705590139, 4648.3259927310355, 4481.910361792746, 5558.471945165203, 5563.415841336642, 5605.159226116074, 5613.971930140364, 3700.4264339027495, 3817.4846395736777, 3842.2315536892734, 3850.2876967761053, 3864.845406183749, 4846.369971903665, 5587.0, 5843.795467158671, 5871.55963302754, 5882.0, 3280.7867488613165, 3737.3646480097905, 3860.3051450739135, 3877.360235561101, 3884.7474914131058, 3352.5641666583188, 3375.7974521528786, 3800.4299355096955, 3924.6075392460525, 3979.3235150024566, 4441.755703436277, 4611.123886461562, 4621.976890115528, 4642.701862578046, 4651.790669419885, 4263.424437700871, 5018.673786203885, 5540.667559946416, 5623.48165995179, 5641.26663533738, 1112.777444511101, 1143.8398624192619, 1322.7023919618202, 1334.6663334166458, 1336.2583766009764, 821.2075347289893, 835.8829763833069, 867.2151702709058, 867.4491697771834, 872.8472517309445, 4221.324588065895, 4452.220861349251, 5275.683458992473, 5343.305370301913, 5394.78420863161, 5276.314079169761, 5302.098643230583, 5345.1447768356875, 5806.167929166814, 5849.718609742204, 4859.659823812299, 5238.5023422774775, 5261.237120617566, 5302.28419163408, 5302.522772950376, 2425.0, 2968.3618022124915, 2996.310848504856, 2998.7301142897245, 2999.9550006749914, 4996.725180115056, 5392.811251606175, 5790.565707571949, 5957.672328021914, 5978.970105149533, 4886.315915771795, 5623.437656234344, 5726.0838265877255, 5763.625364351304, 5775.6823374714795, 5220.895582088337, 5903.675297858573, 5926.9331520325895, 5932.822015339547, 5982.371850955761, 5301.575873929999, 5630.719558578782, 5634.32388113429, 5658.877920779708, 5746.396628353963, 4636.6058884995155, 5113.801065541853, 5596.356419011866, 5617.634853734494, 5629.802956896489, 5283.894322113613, 5535.557155427476, 5928.466438020599, 5986.640801551921, 5993.550483713651, 3673.944890826693, 3788.886333410002, 3799.544054713452, 3825.9043523912123, 3828.2917660232947, 4715.986062996472, 4723.692959957729, 5356.0626890294825, 5394.568434525307, 5695.45893140151, 4544.613707834871, 4784.665073444965, 5621.80323688669, 5632.986062508624, 5645.887082258249, 4441.422615060022, 5082.644214904921, 5513.338399392099, 5517.020808763223, 5531.668099914018, 5225.372955245395, 5391.406945236099, 5427.6472029317965, 5433.945660543344, 5441.673499590037, 4619.3994780678295, 5052.671576347526, 5314.548263397654, 5614.21401003868, 5664.971675141598, 4832.95167048325, 5502.284702988586, 5533.280673512418, 5534.0, 5549.694766787866], "value": 4018.757828449244, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.7965679781261, 773.331068625639, 791.3708601661682, 818.4475479051639, 846.8560344741393, 15865.84134158658, 16947.576310592227, 16947.74578381322, 16971.32114715413, 17606.647867042684, 16988.235529401176, 17340.653186936284, 17556.0, 17557.91221043893, 17568.736468952975, 727.5489196698028, 752.8607207666599, 886.6143227695941, 909.6452383570413, 911.9726408207764, 768.2317682317682, 875.4397185801092, 899.6356475627381, 902.251131560803, 902.5803001604253, 875.0811647769848, 935.6117211357279, 961.4519723757461, 965.1554889471712, 965.2760429677742, 958.0754571838174, 958.6021800952597, 958.6500927161605, 959.9952000239954, 963.0465838819588, 681.1927865479423, 693.9861202775967, 711.7722328854769, 713.9821504462378, 714.5355518912696, 15920.442784502602, 15929.761053584205, 15939.84060159395, 15944.521664350088, 15958.680826383523, 14493.637659058502, 14581.44824655681, 14609.0, 14678.633034174125, 15003.474878379204, 10238.488075596191, 12088.516459341616, 12099.939500302531, 12587.93706031464, 13063.216207027608, 3857.1707082977014, 3968.146848427602, 4051.574584668597, 4140.60664236897, 4143.274926887782, 125580.0, 125704.0, 126658.3667081668, 127879.0, 128274.0, 11306.491207895664, 11349.09207263417, 11542.480588373543, 11691.408811780784, 11821.822672659917, 23143.537129257656, 23152.884235578713, 23201.071957121865, 23244.41888952756, 23459.530809384058, 8277.95861020691, 8291.751247462586, 8296.792580185544, 8352.791180220422, 8353.749387518385, 3947.230290093404, 4495.955040449619, 4587.61005314552, 4779.665423420327, 4781.737004464719, 3737.2151848111657, 3808.428735689669, 3852.711046671455, 3852.768833869977, 3853.7495062820826, 691.6887400669718, 694.8957656351487, 700.8738427083174, 701.3652644356865, 712.0956385390525, 609.0438012320614, 620.8168590265882, 678.3623394009616, 691.872003679321, 719.989200161998, 7880.330171935335, 10258.128059115059, 10307.742306442398, 10316.226283028804, 10377.481125943672, 645.8062581225613, 677.3362105136895, 703.2124021096405, 709.5033476566321, 719.8524302517972, 4981.452040275567, 4999.400071991385, 5008.373953255843, 5012.348394708664, 5018.5232402921665, 81525.18474815294, 126154.0, 131361.0, 152763.0, 166966.0, 121672.0, 143583.82080895914, 144670.0, 146172.26913865362, 148323.2583837074, 112690.0, 113949.43025284821, 114449.0, 115204.0, 117972.41013794875, 9805.117539421486, 10318.845217321596, 10707.785844282915, 10892.455377231265, 10910.78178436411, 57421.13868291895, 58719.706401467716, 64644.6767766177, 65424.0, 67092.32907670861, 83098.0, 90322.096779034, 91233.0, 94840.0, 96041.0, 13641.249731264876, 13814.447422103003, 13910.443582256596, 14001.929990349983, 14029.929850350683, 14309.21299328547, 14474.059186152866, 15061.322240499423, 15625.296861641025, 15887.68224635524, 12395.876041239471, 14507.347169377192, 14634.926825365805, 14716.55850324492, 14977.625559360667, 13533.255670938193, 13592.66018349549, 14139.858601413855, 14593.905457090548, 15194.924025379802, 12483.31341776211, 13414.299471591134, 14198.3610737515, 14864.0, 15175.772363414337, 11334.0, 11656.417179140839, 11668.0, 12447.315397653216, 12687.302198379179, 10443.738906527398, 12180.695482613006, 12241.143119981516, 12275.877241227474, 12419.31693756816], "value": 8259.583626782805, "unit": "score"}], "name": "dromaeo_css", "value": 7518.305941514488, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 113.0, 115.0, 158.0, 162.0, 112.0, 112.0, 112.0, 113.0], "value": 122.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 106.0, 106.0, 142.0, 106.0, 110.0, 132.0, 133.0, 141.0, 106.0], "value": 122.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 185.0, 181.0, 183.0, 182.0, 184.0, 185.0, 184.0, 182.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 59.0, 89.0, 59.0, 58.0, 59.0, 58.0, 81.0, 57.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 91.0, 69.0, 68.0, 68.0, 91.0, 67.0, 68.0, 90.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 130.0, 126.0, 91.0, 89.0, 92.0, 88.0, 91.0, 91.0], "value": 98.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 97.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 85.0, 84.0, 86.0, 86.0, 84.0, 83.0, 82.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 51.0, 52.0, 57.0, 55.0, 57.0, 55.0, 56.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 76.0, 71.0, 72.0, 68.0, 98.0, 95.0, 97.0, 83.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 82.0, 81.0, 84.0, 81.0, 80.0, 83.0, 87.0, 82.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 135.0, 129.0, 133.0, 132.0, 141.0, 145.0, 199.0, 130.0], "value": 141.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 159.0, 158.0, 163.0, 160.0, 168.0, 160.0, 160.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 78.0, 82.0, 79.0, 81.0, 71.0, 64.0, 64.0, 65.0, 65.0], "value": 71.5, "unit": "score"}], "name": "kraken", "value": 1441.1, "alertThreshold": 2.0}]} 15:30:51 INFO - Return code: 0 15:30:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:30:51 INFO - # TBPL SUCCESS # 15:30:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:30:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:30:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:30:51 INFO - 2016-11-20 15:30:51.914 screenresolution[2542:298502] starting screenresolution argv=screenresolution get 15:30:51 INFO - 2016-11-20 15:30:51.916 screenresolution[2542:298502] Display 0: 1600x1200x32@60 15:30:51 INFO - 2016-11-20 15:30:51.922 screenresolution[2543:298505] starting screenresolution argv=screenresolution list 15:30:51 INFO - Available Modes on Display 0 15:30:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:30:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:30:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:30:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:30:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:30:52 INFO - Intel Iris: 15:30:52 INFO - Chipset Model: Intel Iris 15:30:52 INFO - Type: GPU 15:30:52 INFO - Bus: Built-In 15:30:52 INFO - VRAM (Dynamic, Max): 1536 MB 15:30:52 INFO - Vendor: Intel (0x8086) 15:30:52 INFO - Device ID: 0x0a2e 15:30:52 INFO - Revision ID: 0x0009 15:30:52 INFO - Displays: 15:30:52 INFO - Display: 15:30:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:30:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:30:52 INFO - Display Serial Number: 1600x1200 60 15:30:52 INFO - Main Display: Yes 15:30:52 INFO - Mirror: Off 15:30:52 INFO - Online: Yes 15:30:52 INFO - Rotation: Supported 15:30:52 INFO - Return code: 0 15:30:52 INFO - Running post-action listener: _resource_record_post_action 15:30:52 INFO - [mozharness: 2016-11-20 23:30:52.157205Z] Finished run-tests step (success) 15:30:52 INFO - Running post-run listener: _resource_record_post_run 15:30:52 INFO - Total resource usage - Wall time: 1196s; CPU: 53.0%; Read bytes: 188416; Write bytes: 494114816; Read time: 1; Write time: 1517 15:30:52 INFO - TinderboxPrint: CPU usage
53.3% 15:30:52 INFO - TinderboxPrint: I/O read bytes / time
188,416 / 1 15:30:52 INFO - TinderboxPrint: I/O write bytes / time
494,114,816 / 1,517 15:30:52 INFO - TinderboxPrint: CPU idle
2,237.0 (46.7%) 15:30:52 INFO - TinderboxPrint: CPU system
958.6 (20.0%) 15:30:52 INFO - TinderboxPrint: CPU user
1,590.0 (33.2%) 15:30:52 INFO - TinderboxPrint: Swap in / out
194,666,496 / 0 15:30:52 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 185377280; Write bytes: 178771456; Read time: 17706; Write time: 367 15:30:52 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 188416; Write bytes: 295285248; Read time: 1; Write time: 1090 15:30:52 INFO - Running post-run listener: _upload_blobber_files 15:30:52 INFO - Blob upload gear active. 15:30:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:30:52 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 15:30:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:30:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:30:53 INFO - (blobuploader) - INFO - Open directory for files ... 15:30:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:30:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:30:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:30:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:30:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:30:54 INFO - (blobuploader) - INFO - Done attempting. 15:30:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:30:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:30:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:30:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:30:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:30:55 INFO - (blobuploader) - INFO - Done attempting. 15:30:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:30:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:30:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:30:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:30:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:30:58 INFO - (blobuploader) - INFO - Done attempting. 15:30:58 INFO - (blobuploader) - INFO - Iteration through files over. 15:30:58 INFO - Return code: 0 15:30:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:30:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:30:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b10a432a41d22aa7fc2e58e4d9f36ba012773771d467487f688f32f2a8b7a3d315c5ef36d30f981e7597b0a2bfe86f460571b541489a78a68f4aa332f08ee5b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e07d053a42e6f2a3121dfb43a58101a22ffe1f70d524fbbaa5f8a5e185b4c3d8407e3ab44a67ec6834b50dd1acf820852e5679f51a266bf68b2679f550892d41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a86c8db18c1b0b5c2978acc0c7cdf29389c60d48fc5cb9b01ddad70b8440916320fa39fb838e6b0983fb35fecedb1324c6f0c1c4a0bd52c9306069fc44104936"} 15:30:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:30:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:30:58 INFO - Contents: 15:30:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b10a432a41d22aa7fc2e58e4d9f36ba012773771d467487f688f32f2a8b7a3d315c5ef36d30f981e7597b0a2bfe86f460571b541489a78a68f4aa332f08ee5b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e07d053a42e6f2a3121dfb43a58101a22ffe1f70d524fbbaa5f8a5e185b4c3d8407e3ab44a67ec6834b50dd1acf820852e5679f51a266bf68b2679f550892d41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a86c8db18c1b0b5c2978acc0c7cdf29389c60d48fc5cb9b01ddad70b8440916320fa39fb838e6b0983fb35fecedb1324c6f0c1c4a0bd52c9306069fc44104936"} 15:30:58 INFO - Running post-run listener: copy_logs_to_upload_dir 15:30:58 INFO - Copying logs to upload dir... 15:30:58 INFO - mkdir: /builds/slave/test/build/upload/logs 15:30:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.166912 ========= master_lag: 0.30 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-11-20 15:30:58.632926) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-20 15:30:58.636370) ========= 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.hJFsmkcIcn/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.RMbJnQfms1/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b10a432a41d22aa7fc2e58e4d9f36ba012773771d467487f688f32f2a8b7a3d315c5ef36d30f981e7597b0a2bfe86f460571b541489a78a68f4aa332f08ee5b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e07d053a42e6f2a3121dfb43a58101a22ffe1f70d524fbbaa5f8a5e185b4c3d8407e3ab44a67ec6834b50dd1acf820852e5679f51a266bf68b2679f550892d41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a86c8db18c1b0b5c2978acc0c7cdf29389c60d48fc5cb9b01ddad70b8440916320fa39fb838e6b0983fb35fecedb1324c6f0c1c4a0bd52c9306069fc44104936"} build_url:https://queue.taskcluster.net/v1/task/XUh0EBK9SLqRpzMYIX1bWA/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011153 build_url: 'https://queue.taskcluster.net/v1/task/XUh0EBK9SLqRpzMYIX1bWA/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b10a432a41d22aa7fc2e58e4d9f36ba012773771d467487f688f32f2a8b7a3d315c5ef36d30f981e7597b0a2bfe86f460571b541489a78a68f4aa332f08ee5b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e07d053a42e6f2a3121dfb43a58101a22ffe1f70d524fbbaa5f8a5e185b4c3d8407e3ab44a67ec6834b50dd1acf820852e5679f51a266bf68b2679f550892d41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a86c8db18c1b0b5c2978acc0c7cdf29389c60d48fc5cb9b01ddad70b8440916320fa39fb838e6b0983fb35fecedb1324c6f0c1c4a0bd52c9306069fc44104936"}' ========= master_lag: 0.09 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-20 15:30:58.736248) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-20 15:30:58.736566) ========= 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.hJFsmkcIcn/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.RMbJnQfms1/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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.005280 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-20 15:30:58.787015) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-20 15:30:58.787322) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-20 15:30:58.787670) ========= ========= Total master_lag: 0.51 =========