builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0256 starttime: 1479248277.0 results: success (0) buildid: 20161115115349 builduid: bcb6b2599da74adbbce2d9d08ca0f296 revision: 07f57a55ee1b4d5fb5655fd4c5a9094e2d8a0f09 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 14:17:56.997408) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 14:17:56.997812) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 14:17:56.998084) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 14:17:57.022305) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 14:17:57.022592) ========= 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.FpiLYFdkYU/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.uoQR3SjNf8/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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-15 14:17:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.5M=0.001s 2016-11-15 14:17:57 (18.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117946 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 14:17:57.162491) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 14:17:57.162779) ========= 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.FpiLYFdkYU/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.uoQR3SjNf8/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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.024951 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 14:17:57.211035) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-15 14:17:57.211373) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 07f57a55ee1b4d5fb5655fd4c5a9094e2d8a0f09 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 07f57a55ee1b4d5fb5655fd4c5a9094e2d8a0f09 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FpiLYFdkYU/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.uoQR3SjNf8/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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-15 14:17:57,310 truncating revision to first 12 chars 2016-11-15 14:17:57,310 Setting DEBUG logging. 2016-11-15 14:17:57,311 attempt 1/10 2016-11-15 14:17:57,311 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/07f57a55ee1b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-15 14:17:58,391 unpacking tar archive at: mozilla-aurora-07f57a55ee1b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.356235 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-15 14:17:58.590414) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 14:17:58.590768) ========= script_repo_revision: 07f57a55ee1b4d5fb5655fd4c5a9094e2d8a0f09 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 14:17:58.591173) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 14:17:58.591454) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 14:17:58.611407) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-11-15 14:17:58.611710) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FpiLYFdkYU/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.uoQR3SjNf8/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 14:17:58 INFO - MultiFileLogger online at 20161115 14:17:58 in /builds/slave/test 14:17:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:17:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:17:58 INFO - {'append_to_log': False, 14:17:58 INFO - 'base_work_dir': '/builds/slave/test', 14:17:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:17:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:17:58 INFO - 'branch': 'Mozilla-Aurora', 14:17:58 INFO - 'buildbot_json_path': 'buildprops.json', 14:17:58 INFO - 'config_files': ('talos/mac_config.py',), 14:17:58 INFO - 'default_actions': ('clobber', 14:17:58 INFO - 'read-buildbot-config', 14:17:58 INFO - 'download-and-extract', 14:17:58 INFO - 'populate-webroot', 14:17:58 INFO - 'create-virtualenv', 14:17:58 INFO - 'install', 14:17:58 INFO - 'run-tests'), 14:17:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:17:58 INFO - 'download_minidump_stackwalk': True, 14:17:58 INFO - 'download_symbols': 'ondemand', 14:17:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:17:58 INFO - 'tooltool.py': '/tools/tooltool.py', 14:17:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:17:58 INFO - '/tools/misc-python/virtualenv.py')}, 14:17:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:17:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:17:58 INFO - 'installer_path': 'installer.exe', 14:17:58 INFO - 'log_level': 'info', 14:17:58 INFO - 'log_name': 'talos', 14:17:58 INFO - 'log_to_console': True, 14:17:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:17:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:17:58 INFO - 'opt_config_files': (), 14:17:58 INFO - 'pip_index': False, 14:17:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:17:58 INFO - 'cmd': ('bash', 14:17:58 INFO - '-c', 14:17:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:17:58 INFO - 'enabled': True, 14:17:58 INFO - 'halt_on_failure': False, 14:17:58 INFO - 'name': 'check_screen_resolution'},), 14:17:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:17:58 INFO - 'cmd': ('bash', 14:17:58 INFO - '-c', 14:17:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:17:58 INFO - 'enabled': True, 14:17:58 INFO - 'halt_on_failure': False, 14:17:58 INFO - 'name': 'check_screen_resolution'},), 14:17:58 INFO - 'run_cmd_checks_enabled': True, 14:17:58 INFO - 'sps_profile': False, 14:17:58 INFO - 'sps_profile_interval': 0, 14:17:58 INFO - 'suite': 'dromaeojs-e10s', 14:17:58 INFO - 'system_bits': '32', 14:17:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:17:58 INFO - 'title': 't-yosemite-r7-0256', 14:17:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:17:58 INFO - 'use_talos_json': True, 14:17:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:17:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:17:58 INFO - 'work_dir': 'build'} 14:17:58 INFO - [mozharness: 2016-11-15 22:17:58.816223Z] Running clobber step. 14:17:58 INFO - Running pre-action listener: _resource_record_pre_action 14:17:58 INFO - Running main action method: clobber 14:17:58 INFO - rmtree: /builds/slave/test/build 14:17:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:18:01 INFO - Running post-action listener: _resource_record_post_action 14:18:01 INFO - [mozharness: 2016-11-15 22:18:01.225732Z] Finished clobber step (success) 14:18:01 INFO - [mozharness: 2016-11-15 22:18:01.225868Z] Running read-buildbot-config step. 14:18:01 INFO - Running pre-action listener: _resource_record_pre_action 14:18:01 INFO - Running main action method: read_buildbot_config 14:18:01 INFO - Using buildbot properties: 14:18:01 INFO - { 14:18:01 INFO - "project": "", 14:18:01 INFO - "product": "firefox", 14:18:01 INFO - "script_repo_revision": "production", 14:18:01 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 14:18:01 INFO - "repository": "", 14:18:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 14:18:01 INFO - "buildid": "20161115115349", 14:18:01 INFO - "pgo_build": "False", 14:18:01 INFO - "basedir": "/builds/slave/test", 14:18:01 INFO - "buildnumber": 41, 14:18:01 INFO - "slavename": "t-yosemite-r7-0256", 14:18:01 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 14:18:01 INFO - "platform": "yosemite_r7", 14:18:01 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 14:18:01 INFO - "branch": "mozilla-aurora", 14:18:01 INFO - "repo_path": "releases/mozilla-aurora", 14:18:01 INFO - "revision": "07f57a55ee1b4d5fb5655fd4c5a9094e2d8a0f09", 14:18:01 INFO - "stage_platform": "macosx64", 14:18:01 INFO - "builduid": "bcb6b2599da74adbbce2d9d08ca0f296", 14:18:01 INFO - "slavebuilddir": "test" 14:18:01 INFO - } 14:18:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/HdnhV3ZmRi64iAGZpVSh4w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 14:18:01 INFO - Running post-action listener: _resource_record_post_action 14:18:01 INFO - [mozharness: 2016-11-15 22:18:01.229322Z] Finished read-buildbot-config step (success) 14:18:01 INFO - [mozharness: 2016-11-15 22:18:01.229441Z] Running download-and-extract step. 14:18:01 INFO - Running pre-action listener: _resource_record_pre_action 14:18:01 INFO - Running main action method: download_and_extract 14:18:01 INFO - mkdir: /builds/slave/test/build/tests 14:18:01 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')]} 14:18:01 INFO - trying https://queue.taskcluster.net/v1/task/HdnhV3ZmRi64iAGZpVSh4w/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 14:18:01 INFO - Downloading https://queue.taskcluster.net/v1/task/HdnhV3ZmRi64iAGZpVSh4w/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 14:18:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HdnhV3ZmRi64iAGZpVSh4w/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 14:18:02 INFO - Downloaded 1199 bytes. 14:18:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 14:18:02 INFO - Using the following test package requirements: 14:18:02 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 14:18:02 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 14:18:02 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 14:18:02 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 14:18:02 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 14:18:02 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 14:18:02 INFO - u'jsshell-mac.zip'], 14:18:02 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 14:18:02 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 14:18:02 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 14:18:02 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 14:18:02 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 14:18:02 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 14:18:02 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 14:18:02 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 14:18:02 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 14:18:02 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 14:18:02 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 14:18:02 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 14:18:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HdnhV3ZmRi64iAGZpVSh4w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 14:18:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HdnhV3ZmRi64iAGZpVSh4w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:18:02 INFO - Fetch https://queue.taskcluster.net/v1/task/HdnhV3ZmRi64iAGZpVSh4w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 14:18:03 INFO - Http code: 200 14:18:03 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 14:18:03 INFO - x-amz-cf-id: cskfQUPAenRtjBbxLtr8MLUNijf0ZcywN1Rd6QdBNkIEKIwvGZk-sQ== 14:18:03 INFO - x-amz-version-id: YO_0mBb2fHVXRrARdWSmP8dTgM1zB5F_ 14:18:03 INFO - Expected file size: 16327499 14:18:03 INFO - Obtained file size: 16327499 14:18:10 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 14:18:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HdnhV3ZmRi64iAGZpVSh4w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 14:18:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HdnhV3ZmRi64iAGZpVSh4w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:18:10 INFO - Fetch https://queue.taskcluster.net/v1/task/HdnhV3ZmRi64iAGZpVSh4w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 14:18:11 INFO - Http code: 200 14:18:11 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 14:18:11 INFO - x-amz-cf-id: MT26Z13Rp8grG6IwQsUnY2Dz4m-O63cA7cyPvantd-sdUgRLffz8Zw== 14:18:11 INFO - x-amz-version-id: YO_0mBb2fHVXRrARdWSmP8dTgM1zB5F_ 14:18:11 INFO - Expected file size: 16327499 14:18:11 INFO - Obtained file size: 16327499 14:18:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HdnhV3ZmRi64iAGZpVSh4w/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 14:18:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HdnhV3ZmRi64iAGZpVSh4w/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 14:18:18 INFO - Fetch https://queue.taskcluster.net/v1/task/HdnhV3ZmRi64iAGZpVSh4w/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 14:18:19 INFO - Http code: 200 14:18:19 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 14:18:19 INFO - x-amz-cf-id: foekcWJZMBIi473oGT8GUVRdJGfpop30V7dxCU7xVtr7wZnykUQU1A== 14:18:19 INFO - x-amz-version-id: p4D2L1zEt_3I_hUTahskL2skqrZHd3NC 14:18:19 INFO - Expected file size: 14409038 14:18:19 INFO - Obtained file size: 14409038 14:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:19 INFO - trying https://queue.taskcluster.net/v1/task/HdnhV3ZmRi64iAGZpVSh4w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 14:18:19 INFO - Downloading https://queue.taskcluster.net/v1/task/HdnhV3ZmRi64iAGZpVSh4w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 14:18:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HdnhV3ZmRi64iAGZpVSh4w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 14:18:22 INFO - Downloaded 114361887 bytes. 14:18:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HdnhV3ZmRi64iAGZpVSh4w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 14:18:22 INFO - mkdir: /builds/slave/test/properties 14:18:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:18:22 INFO - Writing to file /builds/slave/test/properties/build_url 14:18:22 INFO - Contents: 14:18:22 INFO - build_url:https://queue.taskcluster.net/v1/task/HdnhV3ZmRi64iAGZpVSh4w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 14:18:23 INFO - Running post-action listener: _resource_record_post_action 14:18:23 INFO - Running post-action listener: set_extra_try_arguments 14:18:23 INFO - [mozharness: 2016-11-15 22:18:23.455614Z] Finished download-and-extract step (success) 14:18:23 INFO - [mozharness: 2016-11-15 22:18:23.455739Z] Running populate-webroot step. 14:18:23 INFO - Running pre-action listener: _resource_record_pre_action 14:18:23 INFO - Running main action method: populate_webroot 14:18:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:18:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:18:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:18:23 INFO - '--tppagecycles', 14:18:23 INFO - '7'], 14:18:23 INFO - 'tests': ['tsvgm']}}, 14:18:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:18:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:18:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:18:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:18:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:18:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:18:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:23 INFO - 'talos_options': ['--disable-e10s'], 14:18:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:23 INFO - 'talos_options': ['--disable-e10s'], 14:18:23 INFO - 'tests': ['damp', 'tps']}, 14:18:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:23 INFO - 'tests': ['damp', 'tps']}, 14:18:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:18:23 INFO - 'tests': ['dromaeo_dom']}, 14:18:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:18:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:18:23 INFO - 'tests': ['basic_compositor_video']}, 14:18:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:18:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:18:23 INFO - 'tests': ['a11yr', 14:18:23 INFO - 'ts_paint', 14:18:23 INFO - 'tpaint', 14:18:23 INFO - 'sessionrestore', 14:18:23 INFO - 'sessionrestore_no_auto_restore', 14:18:23 INFO - 'tabpaint']}, 14:18:23 INFO - 'other-e10s': {'tests': ['a11yr', 14:18:23 INFO - 'ts_paint', 14:18:23 INFO - 'tpaint', 14:18:23 INFO - 'sessionrestore', 14:18:23 INFO - 'sessionrestore_no_auto_restore', 14:18:23 INFO - 'tabpaint']}, 14:18:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:18:23 INFO - 'ts_paint', 14:18:23 INFO - 'tpaint', 14:18:23 INFO - 'sessionrestore', 14:18:23 INFO - 'sessionrestore_no_auto_restore', 14:18:23 INFO - 'tabpaint']}, 14:18:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:18:23 INFO - 'ts_paint', 14:18:23 INFO - 'tpaint', 14:18:23 INFO - 'sessionrestore', 14:18:23 INFO - 'sessionrestore_no_auto_restore', 14:18:23 INFO - 'tabpaint']}, 14:18:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:18:23 INFO - 'tests': ['a11yr', 14:18:23 INFO - 'ts_paint', 14:18:23 INFO - 'tpaint', 14:18:23 INFO - 'sessionrestore', 14:18:23 INFO - 'sessionrestore_no_auto_restore', 14:18:23 INFO - 'tabpaint']}, 14:18:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:18:23 INFO - 'tests': ['a11yr', 14:18:23 INFO - 'ts_paint', 14:18:23 INFO - 'tpaint', 14:18:23 INFO - 'sessionrestore', 14:18:23 INFO - 'sessionrestore_no_auto_restore', 14:18:23 INFO - 'tabpaint']}, 14:18:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:18:23 INFO - 'tests': ['tsvgx', 14:18:23 INFO - 'tsvgr_opacity', 14:18:23 INFO - 'tart', 14:18:23 INFO - 'tscrollx', 14:18:23 INFO - 'cart']}, 14:18:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:18:23 INFO - 'tsvgr_opacity', 14:18:23 INFO - 'tart', 14:18:23 INFO - 'tscrollx', 14:18:23 INFO - 'cart']}, 14:18:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:23 INFO - 'talos_options': ['--disable-e10s'], 14:18:23 INFO - 'tests': ['tp5o']}, 14:18:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:23 INFO - 'tests': ['tp5o']}, 14:18:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:23 INFO - 'talos_options': ['--disable-e10s', 14:18:23 INFO - '--xperf_path', 14:18:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:23 INFO - 'tests': ['tp5n']}, 14:18:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:23 INFO - 'talos_options': ['--xperf_path', 14:18:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:23 INFO - 'tests': ['tp5n']}}, 14:18:23 INFO - 'talos.zip': {'path': '', 14:18:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:18:23 INFO - Running post-action listener: _resource_record_post_action 14:18:23 INFO - [mozharness: 2016-11-15 22:18:23.474375Z] Finished populate-webroot step (success) 14:18:23 INFO - [mozharness: 2016-11-15 22:18:23.474464Z] Running create-virtualenv step. 14:18:23 INFO - Running pre-action listener: _resource_record_pre_action 14:18:23 INFO - Running main action method: create_virtualenv 14:18:23 INFO - Creating virtualenv /builds/slave/test/build/venv 14:18:23 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 14:18:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:18:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:18:23 INFO - Using real prefix '/tools/python27' 14:18:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:18:24 INFO - Installing distribute.............................................................................................................................................................................................done. 14:18:27 INFO - Installing pip.................done. 14:18:27 INFO - Return code: 0 14:18:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:18:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:18:27 INFO - Reading from file tmpfile_stdout 14:18:27 INFO - Output received: 14:18:27 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:18:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:18: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')]} 14:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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')]} 14:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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 0x101dc2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff910caec50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bd6d30>, '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 0x101a3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bceb20>, '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.FpiLYFdkYU/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.uoQR3SjNf8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 14:18: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 14:18: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 14:18:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FpiLYFdkYU/Render', 14:18:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:27 INFO - 'HOME': '/Users/cltbld', 14:18:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:27 INFO - 'LOGNAME': 'cltbld', 14:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:27 INFO - 'MOZ_NO_REMOTE': '1', 14:18:27 INFO - 'NO_EM_RESTART': '1', 14:18:27 INFO - 'PAGER': '/bin/cat', 14:18:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:27 INFO - 'PWD': '/builds/slave/test', 14:18:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:27 INFO - 'SHELL': '/bin/bash', 14:18:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uoQR3SjNf8/Listeners', 14:18:27 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 14:18:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:27 INFO - 'USER': 'cltbld', 14:18:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:27 INFO - 'XPC_FLAGS': '0x0', 14:18:27 INFO - 'XPC_SERVICE_NAME': '0', 14:18:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18: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 14:18:27 INFO - Cleaning up... 14:18:27 INFO - Return code: 0 14:18:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:18: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')]} 14:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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')]} 14:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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 0x101dc2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff910caec50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bd6d30>, '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 0x101a3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bceb20>, '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.FpiLYFdkYU/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.uoQR3SjNf8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 14:18: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 14:18: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 14:18:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FpiLYFdkYU/Render', 14:18:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:27 INFO - 'HOME': '/Users/cltbld', 14:18:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:27 INFO - 'LOGNAME': 'cltbld', 14:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:27 INFO - 'MOZ_NO_REMOTE': '1', 14:18:27 INFO - 'NO_EM_RESTART': '1', 14:18:27 INFO - 'PAGER': '/bin/cat', 14:18:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:27 INFO - 'PWD': '/builds/slave/test', 14:18:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:27 INFO - 'SHELL': '/bin/bash', 14:18:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uoQR3SjNf8/Listeners', 14:18:27 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 14:18:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:27 INFO - 'USER': 'cltbld', 14:18:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:27 INFO - 'XPC_FLAGS': '0x0', 14:18:27 INFO - 'XPC_SERVICE_NAME': '0', 14:18:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:28 INFO - Downloading/unpacking psutil>=3.1.1 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:18:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:31 INFO - Installing collected packages: psutil 14:18:31 INFO - Running setup.py install for psutil 14:18:31 INFO - building 'psutil._psutil_osx' extension 14:18: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 14:18: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/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:18: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 14:18: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 14:18:32 INFO - building 'psutil._psutil_posix' extension 14:18: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 14:18:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:18:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:18:32 INFO - ^ 14:18:32 INFO - 1 warning generated. 14:18: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 14:18:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:32 INFO - Successfully installed psutil 14:18:32 INFO - Cleaning up... 14:18:32 INFO - Return code: 0 14:18:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:18: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')]} 14:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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')]} 14:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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 0x101dc2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff910caec50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bd6d30>, '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 0x101a3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bceb20>, '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.FpiLYFdkYU/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.uoQR3SjNf8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 14:18: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 14:18: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 14:18:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FpiLYFdkYU/Render', 14:18:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:32 INFO - 'HOME': '/Users/cltbld', 14:18:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:32 INFO - 'LOGNAME': 'cltbld', 14:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:32 INFO - 'MOZ_NO_REMOTE': '1', 14:18:32 INFO - 'NO_EM_RESTART': '1', 14:18:32 INFO - 'PAGER': '/bin/cat', 14:18:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:32 INFO - 'PWD': '/builds/slave/test', 14:18:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:32 INFO - 'SHELL': '/bin/bash', 14:18:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uoQR3SjNf8/Listeners', 14:18:32 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 14:18:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:32 INFO - 'USER': 'cltbld', 14:18:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:32 INFO - 'XPC_FLAGS': '0x0', 14:18:32 INFO - 'XPC_SERVICE_NAME': '0', 14:18:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:18:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:18:35 INFO - Installing collected packages: mozsystemmonitor 14:18:35 INFO - Running setup.py install for mozsystemmonitor 14:18:35 INFO - Successfully installed mozsystemmonitor 14:18:35 INFO - Cleaning up... 14:18:35 INFO - Return code: 0 14:18:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:18: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')]} 14:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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')]} 14:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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 0x101dc2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff910caec50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bd6d30>, '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 0x101a3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bceb20>, '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.FpiLYFdkYU/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.uoQR3SjNf8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 14:18: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 14:18: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 14:18:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FpiLYFdkYU/Render', 14:18:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:35 INFO - 'HOME': '/Users/cltbld', 14:18:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:35 INFO - 'LOGNAME': 'cltbld', 14:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:35 INFO - 'MOZ_NO_REMOTE': '1', 14:18:35 INFO - 'NO_EM_RESTART': '1', 14:18:35 INFO - 'PAGER': '/bin/cat', 14:18:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:35 INFO - 'PWD': '/builds/slave/test', 14:18:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:35 INFO - 'SHELL': '/bin/bash', 14:18:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uoQR3SjNf8/Listeners', 14:18:35 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 14:18:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:35 INFO - 'USER': 'cltbld', 14:18:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:35 INFO - 'XPC_FLAGS': '0x0', 14:18:35 INFO - 'XPC_SERVICE_NAME': '0', 14:18:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:36 INFO - Downloading/unpacking jsonschema==2.5.1 14:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:18:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18:38 INFO - Downloading functools32-3.2.3-2.tar.gz 14:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:18:38 INFO - warning: no files found matching '*.txt' 14:18:38 INFO - no previously-included directories found matching 'build' 14:18:38 INFO - no previously-included directories found matching 'dist' 14:18:38 INFO - no previously-included directories found matching '.git*' 14:18:38 INFO - Installing collected packages: jsonschema, functools32 14:18:39 INFO - Running setup.py install for functools32 14:18:39 INFO - warning: no files found matching '*.txt' 14:18:39 INFO - no previously-included directories found matching 'build' 14:18:39 INFO - no previously-included directories found matching 'dist' 14:18:39 INFO - no previously-included directories found matching '.git*' 14:18:39 INFO - Successfully installed jsonschema functools32 14:18:39 INFO - Cleaning up... 14:18:39 INFO - Return code: 0 14:18:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:18: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')]} 14:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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')]} 14:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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 0x101dc2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff910caec50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bd6d30>, '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 0x101a3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bceb20>, '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.FpiLYFdkYU/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.uoQR3SjNf8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 14:18: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 14:18: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 14:18:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FpiLYFdkYU/Render', 14:18:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:39 INFO - 'HOME': '/Users/cltbld', 14:18:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:39 INFO - 'LOGNAME': 'cltbld', 14:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:39 INFO - 'MOZ_NO_REMOTE': '1', 14:18:39 INFO - 'NO_EM_RESTART': '1', 14:18:39 INFO - 'PAGER': '/bin/cat', 14:18:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:39 INFO - 'PWD': '/builds/slave/test', 14:18:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:39 INFO - 'SHELL': '/bin/bash', 14:18:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uoQR3SjNf8/Listeners', 14:18:39 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 14:18:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:39 INFO - 'USER': 'cltbld', 14:18:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:39 INFO - 'XPC_FLAGS': '0x0', 14:18:39 INFO - 'XPC_SERVICE_NAME': '0', 14:18:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:18:39 INFO - Cleaning up... 14:18:39 INFO - Return code: 0 14:18:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:18: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')]} 14:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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')]} 14:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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 0x101dc2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff910caec50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bd6d30>, '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 0x101a3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bceb20>, '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.FpiLYFdkYU/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.uoQR3SjNf8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 14:18: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 14:18: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 14:18:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FpiLYFdkYU/Render', 14:18:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:39 INFO - 'HOME': '/Users/cltbld', 14:18:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:39 INFO - 'LOGNAME': 'cltbld', 14:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:39 INFO - 'MOZ_NO_REMOTE': '1', 14:18:39 INFO - 'NO_EM_RESTART': '1', 14:18:39 INFO - 'PAGER': '/bin/cat', 14:18:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:39 INFO - 'PWD': '/builds/slave/test', 14:18:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:39 INFO - 'SHELL': '/bin/bash', 14:18:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uoQR3SjNf8/Listeners', 14:18:39 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 14:18:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:39 INFO - 'USER': 'cltbld', 14:18:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:39 INFO - 'XPC_FLAGS': '0x0', 14:18:39 INFO - 'XPC_SERVICE_NAME': '0', 14:18:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:39 INFO - Downloading/unpacking blobuploader==1.2.4 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18:42 INFO - Downloading blobuploader-1.2.4.tar.gz 14:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:18:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:18:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18:43 INFO - Downloading docopt-0.6.1.tar.gz 14:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:18:43 INFO - Installing collected packages: blobuploader, requests, docopt 14:18:43 INFO - Running setup.py install for blobuploader 14:18:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:18:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:18:43 INFO - Running setup.py install for requests 14:18:44 INFO - Running setup.py install for docopt 14:18:44 INFO - Successfully installed blobuploader requests docopt 14:18:44 INFO - Cleaning up... 14:18:44 INFO - Return code: 0 14:18:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18: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')]} 14:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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')]} 14:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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 0x101dc2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff910caec50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bd6d30>, '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 0x101a3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bceb20>, '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.FpiLYFdkYU/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.uoQR3SjNf8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 14:18: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 14:18: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 14:18:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FpiLYFdkYU/Render', 14:18:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:44 INFO - 'HOME': '/Users/cltbld', 14:18:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:44 INFO - 'LOGNAME': 'cltbld', 14:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:44 INFO - 'MOZ_NO_REMOTE': '1', 14:18:44 INFO - 'NO_EM_RESTART': '1', 14:18:44 INFO - 'PAGER': '/bin/cat', 14:18:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:44 INFO - 'PWD': '/builds/slave/test', 14:18:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:44 INFO - 'SHELL': '/bin/bash', 14:18:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uoQR3SjNf8/Listeners', 14:18:44 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 14:18:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:44 INFO - 'USER': 'cltbld', 14:18:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:44 INFO - 'XPC_FLAGS': '0x0', 14:18:44 INFO - 'XPC_SERVICE_NAME': '0', 14:18:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:44 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-wOq9lE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:44 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-5_Mx7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:44 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-oUPiXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:45 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-D5iRhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:45 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-75oWai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:45 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-SlqIAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:45 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-SjUmw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:45 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-dDwHnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:45 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-deRnr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:45 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-utKNVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:45 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-4S3XT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:45 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-FdQYOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:46 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-G0rXUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:46 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-F0fq3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:46 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-ljK5I8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:46 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-ZUtfEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:46 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-jSU2ZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:18:46 INFO - Running setup.py install for manifestparser 14:18:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:18:46 INFO - Running setup.py install for mozcrash 14:18:46 INFO - Running setup.py install for mozdebug 14:18:46 INFO - Running setup.py install for mozdevice 14:18:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:18:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:18:47 INFO - Running setup.py install for mozfile 14:18:47 INFO - Running setup.py install for mozhttpd 14:18:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:18:47 INFO - Running setup.py install for mozinfo 14:18:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:18:47 INFO - Running setup.py install for mozInstall 14:18:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:18:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:18:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:18:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:18:47 INFO - Running setup.py install for mozleak 14:18:47 INFO - Running setup.py install for mozlog 14:18:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:18:48 INFO - Running setup.py install for moznetwork 14:18:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:18:48 INFO - Running setup.py install for mozprocess 14:18:48 INFO - Running setup.py install for mozprofile 14:18:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:18:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:18:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:18:48 INFO - Running setup.py install for mozrunner 14:18:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:18:48 INFO - Running setup.py install for mozscreenshot 14:18:48 INFO - Running setup.py install for moztest 14:18:48 INFO - Running setup.py install for mozversion 14:18:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:18:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:18:49 INFO - Cleaning up... 14:18:49 INFO - Return code: 0 14:18:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18: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')]} 14:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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')]} 14:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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 0x101dc2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff910caec50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bd6d30>, '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 0x101a3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bceb20>, '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.FpiLYFdkYU/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.uoQR3SjNf8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 14:18: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 14:18: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 14:18:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FpiLYFdkYU/Render', 14:18:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:49 INFO - 'HOME': '/Users/cltbld', 14:18:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:49 INFO - 'LOGNAME': 'cltbld', 14:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:49 INFO - 'MOZ_NO_REMOTE': '1', 14:18:49 INFO - 'NO_EM_RESTART': '1', 14:18:49 INFO - 'PAGER': '/bin/cat', 14:18:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:49 INFO - 'PWD': '/builds/slave/test', 14:18:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:49 INFO - 'SHELL': '/bin/bash', 14:18:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uoQR3SjNf8/Listeners', 14:18:49 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 14:18:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:49 INFO - 'USER': 'cltbld', 14:18:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:49 INFO - 'XPC_FLAGS': '0x0', 14:18:49 INFO - 'XPC_SERVICE_NAME': '0', 14:18:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:49 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-df0YeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18: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)) 14:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:49 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-2u6Z4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 14:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:49 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-TDO6yN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18: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)) 14:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:49 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-tAyUii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18: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)) 14:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:49 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-4294wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18: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)) 14:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:49 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-p7h3Bq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:50 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)) 14:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:50 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-bGVLVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18: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)) 14:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:50 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-VcPz35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18: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)) 14:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:50 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-2qEiQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18: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)) 14:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:50 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-isuSuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18: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)) 14:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:50 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-Czde8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18: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)) 14:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:50 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-GeR6AW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18: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)) 14:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:50 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-Cy8idt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18: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)) 14:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:50 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-h6JO93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 14:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:50 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-xQGbID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:51 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)) 14:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:51 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-SPge7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:51 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)) 14:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:51 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-Cghluf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18: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)) 14:18: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==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:18: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==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:18: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)) 14:18: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)) 14:18: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)) 14:18:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18:53 INFO - Downloading blessings-1.6.tar.gz 14:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:18:53 INFO - Installing collected packages: blessings 14:18:53 INFO - Running setup.py install for blessings 14:18:54 INFO - Successfully installed blessings 14:18:54 INFO - Cleaning up... 14:18:54 INFO - Return code: 0 14:18:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:18:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:18:54 INFO - Reading from file tmpfile_stdout 14:18:54 INFO - Current package versions: 14:18:54 INFO - blessings == 1.6 14:18:54 INFO - blobuploader == 1.2.4 14:18:54 INFO - docopt == 0.6.1 14:18:54 INFO - functools32 == 3.2.3-2 14:18:54 INFO - jsonschema == 2.5.1 14:18:54 INFO - manifestparser == 1.1 14:18:54 INFO - mozInstall == 1.12 14:18:54 INFO - mozcrash == 1.0 14:18:54 INFO - mozdebug == 0.1 14:18:54 INFO - mozdevice == 0.48 14:18:54 INFO - mozfile == 1.2 14:18:54 INFO - mozhttpd == 0.7 14:18:54 INFO - mozinfo == 0.9 14:18:54 INFO - mozleak == 0.1 14:18:54 INFO - mozlog == 3.4 14:18:54 INFO - moznetwork == 0.27 14:18:54 INFO - mozprocess == 0.23 14:18:54 INFO - mozprofile == 0.28 14:18:54 INFO - mozrunner == 6.13 14:18:54 INFO - mozscreenshot == 0.1 14:18:54 INFO - mozsystemmonitor == 0.3 14:18:54 INFO - moztest == 0.7 14:18:54 INFO - mozversion == 1.4 14:18:54 INFO - psutil == 3.1.1 14:18:54 INFO - requests == 1.2.3 14:18:54 INFO - wsgiref == 0.1.2 14:18:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18: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')]} 14:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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')]} 14:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:55 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 0x101dc2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff910caec50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bd6d30>, '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 0x101a3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bceb20>, '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.FpiLYFdkYU/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.uoQR3SjNf8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 14:18:55 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 14:18:55 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 14:18:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FpiLYFdkYU/Render', 14:18:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:55 INFO - 'HOME': '/Users/cltbld', 14:18:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:55 INFO - 'LOGNAME': 'cltbld', 14:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:55 INFO - 'MOZ_NO_REMOTE': '1', 14:18:55 INFO - 'NO_EM_RESTART': '1', 14:18:55 INFO - 'PAGER': '/bin/cat', 14:18:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:55 INFO - 'PWD': '/builds/slave/test', 14:18:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:55 INFO - 'SHELL': '/bin/bash', 14:18:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uoQR3SjNf8/Listeners', 14:18:55 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 14:18:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:55 INFO - 'USER': 'cltbld', 14:18:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:55 INFO - 'XPC_FLAGS': '0x0', 14:18:55 INFO - 'XPC_SERVICE_NAME': '0', 14:18:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:55 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)) 14:18:55 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)) 14:18:55 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)) 14:18:55 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)) 14:18:55 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)) 14:18:55 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)) 14:18:55 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)) 14:18:55 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)) 14:18:55 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)) 14:18:55 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)) 14:18:55 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)) 14:18:55 INFO - Cleaning up... 14:18:55 INFO - Return code: 0 14:18:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101dc2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff910caec50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bd6d30>, '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 0x101a3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bceb20>, '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.FpiLYFdkYU/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.uoQR3SjNf8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 14:18:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:18:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FpiLYFdkYU/Render', 14:18:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:55 INFO - 'HOME': '/Users/cltbld', 14:18:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:55 INFO - 'LOGNAME': 'cltbld', 14:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:55 INFO - 'MOZ_NO_REMOTE': '1', 14:18:55 INFO - 'NO_EM_RESTART': '1', 14:18:55 INFO - 'PAGER': '/bin/cat', 14:18:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:55 INFO - 'PWD': '/builds/slave/test', 14:18:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:55 INFO - 'SHELL': '/bin/bash', 14:18:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uoQR3SjNf8/Listeners', 14:18:55 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 14:18:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:55 INFO - 'USER': 'cltbld', 14:18:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:55 INFO - 'XPC_FLAGS': '0x0', 14:18:55 INFO - 'XPC_SERVICE_NAME': '0', 14:18:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:18:56 INFO - Cleaning up... 14:18:56 INFO - Return code: 0 14:18:56 INFO - Running post-action listener: _resource_record_post_action 14:18:56 INFO - Running post-action listener: _start_resource_monitoring 14:18:56 INFO - Starting resource monitoring. 14:18:56 INFO - [mozharness: 2016-11-15 22:18:56.088425Z] Finished create-virtualenv step (success) 14:18:56 INFO - [mozharness: 2016-11-15 22:18:56.089446Z] Running install step. 14:18:56 INFO - Running pre-action listener: _resource_record_pre_action 14:18:56 INFO - Running main action method: install 14:18:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:18:56 INFO - Reading from file tmpfile_stdout 14:18:56 INFO - Detecting whether we're running mozinstall >=1.0... 14:18:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:18:56 INFO - Reading from file tmpfile_stdout 14:18:56 INFO - Output received: 14:18:56 INFO - Usage: mozinstall [options] installer 14:18:56 INFO - Options: 14:18:56 INFO - -h, --help show this help message and exit 14:18:56 INFO - -d DEST, --destination=DEST 14:18:56 INFO - Directory to install application into. [default: 14:18:56 INFO - "/builds/slave/test"] 14:18:56 INFO - --app=APP Application being installed. [default: firefox] 14:18:56 INFO - mkdir: /builds/slave/test/build/application 14:18:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 14:19:28 INFO - Reading from file tmpfile_stdout 14:19:28 INFO - Output received: 14:19:28 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 14:19:28 INFO - Running post-action listener: _resource_record_post_action 14:19:28 INFO - [mozharness: 2016-11-15 22:19:28.149575Z] Finished install step (success) 14:19:28 INFO - [mozharness: 2016-11-15 22:19:28.149725Z] Running run-tests step. 14:19:28 INFO - Running pre-action listener: _resource_record_pre_action 14:19:28 INFO - Running main action method: run_tests 14:19:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:19:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:19:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:19:28 INFO - 2016-11-15 14:19:28.164 screenresolution[1625:7229] starting screenresolution argv=screenresolution get 14:19:28 INFO - 2016-11-15 14:19:28.166 screenresolution[1625:7229] Display 0: 1600x1200x32@60 14:19:28 INFO - 2016-11-15 14:19:28.172 screenresolution[1626:7231] starting screenresolution argv=screenresolution list 14:19:28 INFO - Available Modes on Display 0 14:19:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:19:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:19:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:19:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:19:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:19:28 INFO - Intel Iris: 14:19:28 INFO - Chipset Model: Intel Iris 14:19:28 INFO - Type: GPU 14:19:28 INFO - Bus: Built-In 14:19:28 INFO - VRAM (Dynamic, Max): 1536 MB 14:19:28 INFO - Vendor: Intel (0x8086) 14:19:28 INFO - Device ID: 0x0a2e 14:19:28 INFO - Revision ID: 0x0009 14:19:28 INFO - Displays: 14:19:28 INFO - Display: 14:19:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:19:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:19:28 INFO - Display Serial Number: 1600x1200 60 14:19:28 INFO - Main Display: Yes 14:19:28 INFO - Mirror: Off 14:19:28 INFO - Online: Yes 14:19:28 INFO - Rotation: Supported 14:19:28 INFO - Return code: 0 14:19:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:19:28 INFO - Python 2.7.3 14:19:28 INFO - Return code: 0 14:19:28 INFO - grabbing minidump binary from tooltool 14:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:28 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 0x101bd6d30>, '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 0x101a3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bceb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:19:28 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 14:19:28 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 14:19:28 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 14:19:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:19:28 INFO - Return code: 0 14:19:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:19:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:19:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:19:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:19:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:19:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HdnhV3ZmRi64iAGZpVSh4w/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0256', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HdnhV3ZmRi64iAGZpVSh4w/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0256 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:19:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FpiLYFdkYU/Render', 14:19:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:28 INFO - 'HOME': '/Users/cltbld', 14:19:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:28 INFO - 'LOGNAME': 'cltbld', 14:19:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:19:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:28 INFO - 'MOZ_NO_REMOTE': '1', 14:19:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:19:28 INFO - 'NO_EM_RESTART': '1', 14:19:28 INFO - 'PAGER': '/bin/cat', 14:19:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:28 INFO - 'PWD': '/builds/slave/test', 14:19:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:19:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:28 INFO - 'SHELL': '/bin/bash', 14:19:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uoQR3SjNf8/Listeners', 14:19:28 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 14:19:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:28 INFO - 'USER': 'cltbld', 14:19:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:28 INFO - 'XPC_FLAGS': '0x0', 14:19:28 INFO - 'XPC_SERVICE_NAME': '0', 14:19:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HdnhV3ZmRi64iAGZpVSh4w/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0256', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:19:28 INFO - mozversion application_buildid: 20161115115349 14:19:28 INFO - mozversion application_changeset: 07f57a55ee1b4d5fb5655fd4c5a9094e2d8a0f09 14:19:28 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:19:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:19:28 INFO - mozversion application_name: Firefox 14:19:28 INFO - mozversion application_remotingname: firefox-dev 14:19:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:19:28 INFO - mozversion application_vendor: Mozilla 14:19:28 INFO - mozversion application_version: 52.0a2 14:19:28 INFO - mozversion platform_buildid: 20161115115349 14:19:28 INFO - mozversion platform_changeset: 07f57a55ee1b4d5fb5655fd4c5a9094e2d8a0f09 14:19:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:19:28 INFO - mozversion platform_version: 52.0a2 14:19:28 INFO - using testdate: 1479248368 14:19:28 INFO - actual date: 1479248368 14:19:28 INFO - starting webserver on 'localhost:49237' 14:19:28 INFO - SUITE-START | Running 2 tests 14:19:28 INFO - TEST-START | dromaeo_css 14:19:28 INFO - operating with platform_type : mac_ 14:19:28 INFO - Initialising browser for dromaeo_css test... 14:19:28 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmpPjrJOm/profile http://localhost:49237/getInfo.html) 14:19:30 ERROR - PROCESS | 1636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 14:19:31 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 14:19:31 INFO - PROCESS | 1636 | colorDepth:24 14:19:31 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 14:19:31 INFO - PROCESS | 1636 | __metrics 14:19:31 ERROR - PROCESS | 1636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 14:19:32 INFO - TEST-INFO | 1636: exit 0 14:19:32 INFO - Browser initialized. 14:19:32 INFO - Running cycle 1/1 for dromaeo_css test... 14:19:32 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmpPjrJOm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:19:44 INFO - PROCESS | 1639 | RSS: Main: 224219136 14:19:44 INFO - PROCESS | 1639 | 14:20:34 INFO - PROCESS | 1639 | 1479248434383 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] 14:22:48 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 14:22:49 INFO - PROCESS | 1639 | RSS: Main: 235347968 14:22:49 INFO - PROCESS | 1639 | 14:25:52 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 14:25:52 INFO - PROCESS | 1639 | RSS: Main: 244785152 14:25:52 INFO - PROCESS | 1639 | 14:28:54 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 14:28:55 INFO - PROCESS | 1639 | RSS: Main: 250896384 14:28:55 INFO - PROCESS | 1639 | 14:31:57 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 14:31:57 INFO - PROCESS | 1639 | RSS: Main: 250957824 14:31:57 INFO - PROCESS | 1639 | 14:35:00 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 14:35:01 INFO - PROCESS | 1639 | RSS: Main: 255766528 14:35:01 INFO - PROCESS | 1639 | 14:38:04 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 14:38:04 INFO - PROCESS | 1639 | RSS: Main: 257032192 14:38:04 INFO - PROCESS | 1639 | 14:38:04 INFO - PROCESS | 1639 | __start_tp_report 14:38:04 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 14:38:04 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 14:38:04 INFO - PROCESS | 1639 | |i|pagename|runs| 14:38:04 INFO - PROCESS | 1639 | |0;dojo.html;2702.297402675304;2928.7217714317144;3455.084402633301;3494.3360761455306;3495.0912762681696;5905.025670764324;5961.61249518781;6003.639781613107;6004.189434426351;6018.458338749511;6027.547933904963;6045.486133678643;6093.542984276175;6112.633242005483;6119.755209791614;5430.809921652753;5435.266239057736;5485.780568777244;5509.283793106891;5512.944870551283;5488.670679759227;5499.917501237464;5520.751566179511;5530.142827861668;5542.2517960075475;5357.571394288467;5376.596755243353;5509.559235261169;5511.268280987768;5531.2809334786625;4482.484514280867;4774.522547745232;5182.782046219136;5419.512243898029;5474.151506516497;5288.524032837025;5394;5402.189671549259;5428.972855135738;5455.918161227585;6081.6351018939;6090.786822461193;6127.509799216052;6171.6297022178815;6191.721372538202;5665.376808551097;6263.060540918853;6282.277538083134;6312.305646378894;6331.366863313678;6326.177596912418;6345.904811427832;6349.555531112824;6352.396522330371;6357.968210158966;6045.3652366501765;6095.359987201368;6102.4507794298725;6117.296510901258;6138.0179171332375;6287.874242515124;6340.619562826245;6372.490200783926;6383.202099737533;6424.1327420798525;6353.745850166034;6358.968205159037;6360.681965901686;6361.01404282337;6373.968130159319;6226.283977342664;6382.234131904202;6393.2328120625825;6401.1678481798;6426.8714625707225;6242.500599951993;6269.843253918689;6284.685765711696;6327.303996560375;6350.33321501245;6243.282022567463;6270.3416141305415;6288.213973253343;6310.652914089677;6316.368363163647;5039.319691841628;5094.923576146361;5096.261042148868;5098.235264710249;5109.795608175631;4590.495045544987;4594.035252596992;4596.333531637961;4611.76941152941;4618.35343051973;4922.360093187863;5031.245313202976;5969.403059694083;5998.820035398945;6093.329733729286;6224.253089629274;6233;6272.466840318624;6318.557700960889;6336.239651241881;6043.758249670052;6110.327863934964;6124.081387791867;6132.325444201134;6165.722542485599;5466.726663666801;5526.47498487643;5550.222968784374;5564.415736347706;5574.442555744393;6400.199975003125;6428.19647544057;6431.067495213168;6504.544681872413;6518.087467754423;5002.224655178453;5272.76272567743;5339.946600533945;5782.3452121042965;6375.107484952017;5535.8892822144135;6312.274088479883;6378.202724659418;6410.070539771614;6553.803385898431;6118.345080237214;6265.997440409513;6285.811425657238;6289.905651415141;6321.33625969285;5188;6259.718312675849;6265.467435267871;6272.310045894857;6272.8118156455375;5506.504414602705;5653.745581448927;6131.132004888217;6274;6288.874222515433;4380.51814300433;5339.919901201562;6228.532860035425;6264.874702506016;6266.436020757971;5029.245613158056;5077.720725360141;6164.383561643979;6285.717142728497;6306.558540902093;6223.719932602953;6255.499560035278;6282.874342513215;6294.402031806971;6298.370162983665;6011.789587364421;6058.878822423439;6082.391760823883;6087.969560152171;6289.937100628935 14:38:04 INFO - PROCESS | 1639 | |1;ext.html;474.48044391391426;495.0840944253132;506.4960364437383;512.5515174222555;522.5714913770707;37234;39790.8062758117;39952.60047399525;40033;40067;40904;41029.79485102578;41297.793511032476;41361.58638413615;41445;9203.769905752342;9338.439693618371;9376.343655944052;9390.201832844217;9399;9167.95416022919;9242.39924404915;9253.444793312423;9257.768555786091;9284.210842078432;9130.954345228298;9185.540722963859;9231;9243.445393276392;9268.907310926872;9181.31140164487;9242.260619150486;9256.30577706668;9259.30555208362;9265.675701350488;9117.452952822852;9212.40119392244;9217.769555761093;9240.815183696355;9252.444853308823;38750.41874371887;39291.21417571661;39312.410313845314;39378;39411;3258.7230085442766;3292.3415316936707;3299.637039925606;3333.666633336647;3397.728181745479;28026.73879675399;28985.565216521558;29630.259243518867;29664.110076697732;30187.69812301871;2636.327736427218;3132.2795756975797;3182.156728466958;3192.457282262021;3223.661515540858;458318;459585;460104;462286;462464;56091;56528.717356412955;56674.149887751715;56765.43234567684;56801.43198568044;55708;55872;55988.72005640027;56014.15978760322;56223;15655.68688626244;15877.841221587867;15885.602859928595;15888.523344299689;15903.125328106833;12232.266064036186;12255.509779608894;12318.692032699075;12321.753564928651;12326.81509777354;15353.462628807938;16004;16016.199190040452;16071.35714571404;16072.437464688679;3139.4662907305815;5486.972565137149;5893.116032595145;6117.938820611737;6443.29123796382;840.6595328891808;872.1888643561549;909.8362294787001;941.5621735892843;943.4669411782321;26117.216483505526;26313.342166445993;29687.96092136765;29783;29900.40199196004;1023.892491288404;1039.7920415916847;1056.060106505211;1064.2443864855884;1078.336822853939;13222.021436003195;14210.715785684228;14796.556103316918;15178.620534486505;15281.6179595511;628408;632852;634293;636281;636932;56781.86436271251;57039.429605704245;57438.42561574414;57461.71269143711;58142;1312.6718320419895;1337.71239183576;1355.959321220365;1356.0575400097034;1366.1325058587868;22275.888620556794;28881.42237155287;29404.264893377836;29476.263093422836;30110.397792044474;50037.499625003285;50184.49815501798;50333;50392.24411633902;50438.2434263479;635310.6468935437;637259;638316;638669;640130;25754.613680794428;26208.213753587424;26212.60681089747;26269.343266417727;26352.868235658698;44247.336289955034;44346.778266108464;45301.773491132335;45410.091798163194;45638.54361456343;37643.81178094092;37962.240755185296;38156.80921595374;38234.61765382311;38767.418488723255;37729.62270377261;38598.48258557872;38679.2264154721;38704.80647596744;39058.80470597629;36341.636583634885;36974.26051478901;37385.691500797344;37493.81253093826;37933.24133517369;31947;33017.28557279298;33657.663423365455;33775.15562110967;33928;23816.16643417472;25138.497230055662;25179.992800287782;25226.49547009013;25758.484830303663 14:38:04 INFO - PROCESS | 1639 | |2;jquery.html;311.31510676511675;312.92020534763645;369.9482072509849;382.66707964071264;398.7121597240912;18582.070896455174;18764.71852922207;19995.300164494227;20001.699974500396;20259.797402025975;18996.43010709681;19243.711344329848;19740.309089181847;19894.602107957868;20091.799082009176;5595.99999999999;5888.087346461305;5890.734916928727;5892.764289428439;5902.557308201902;5460;5780.0751879699255;5840.561957853157;5855.560832937525;5876.44173803488;5508;5813.941860581383;5817.331006934193;5817.389174136718;5824.359320474744;5616.719164041802;5758.395368486333;5771.076627739583;5778.479936805707;5800.24596802413;4852.17513022787;5023.120953833101;5043;5054.418741844698;5073.568746656539;19703.211871525265;24598.877005615035;24686.876565617236;24829.5034099317;25091.87454062718;2300.7354154272307;2555.463352695936;2583.74162583742;2799.4820958122814;2853.7574306184;14346.177101082863;15159.014664046801;15256.160911149882;15539.766903496457;15574.610634734223;1805.4312891439154;1845.4186931116656;1850.9629807403776;1877.7465042219262;1897.383350411108;105491.68594312684;108208;108817;108981;109770;10666.573337066586;10863.67408977732;11149.554017839358;11293.71765705864;11638.476268567934;11356.886431135748;13725.725485490433;13855.58433246984;13875.37560809766;13878.861211387959;8286.544240066854;8489.490630562186;8496.107908669625;8511.829763404698;8564.61459234336;7701.460897737216;7915.525068495908;8416.242538171595;8437.156284371637;8533.701320453754;5816.563757718188;6371.713272902731;6752.966235168891;6778;6780;1841.2819000589782;1889;1889.0743535667425;1889.3292881027312;1895.3840001999406;847.3983471735014;903.2322525853103;909.736176508805;921.4333185091255;1007.9949600252098;20793.272235471686;21696.13215471395;21744.456388590097;21900.68595884252;22035.66946495804;935.6397786851975;952.9904700953041;984.8473486609587;990.9752256193652;992.5979978108877;9088.454692718458;10530.57877684884;11194.888051119384;11612.6516204514;11740.119491038206;493349;518201;531274;611182;613156;112741.87258127477;120252.79747202591;120292;122565.77434225722;132443;943.2029934705163;987.713563066717;1006.3106771861299;1008.2186305613062;1013.022433351819;17445.214965326337;18971.810281897004;19503.02484875722;19673;19808.801911980696;36686;45813;53668.73165634147;53959.730201350314;58956.1156582643;76777.84833227395;77652;79193.60403197947;80275.99310017296;80753.19246807457;5306.6550674206055;5877.588568800314;6264.812055638338;6852.45180385558;7454.3663788576405;9737.707868763948;11605.535778569101;12569.434375452944;12828.10203285761;13014.544490942772;9512.858456985206;10073.647422340184;10789;11082.168837337393;11138.498767555317;10907.400092994962;10919.563217471212;10957.452127393757;10958.945205273923;11141.83287250708;8361.540115293717;9085.727428177166;11086;11309.547618095514;11687.415629218674;8082.2725954664365;8177.836443271221;8208.671653133808;8209.096999330188;8234.011918569571;10248.128909042814;10873.293235939638;10879;10982.341059536453;11225.887741122484 14:38:04 INFO - PROCESS | 1639 | |3;mootools.html;1414.2504472629503;1478;1589.1656880137925;1716.3992602589103;1768.5490199998999;7638.541687498754;7882;8153;8612.39713220075;8625.353098517613;8023.919760802391;8313.334933205344;8338.874916876252;8443.324534037278;8455;2284.65730140479;2323.4307594639336;2327.534493101378;2327.9650805237934;2328.348062542491;2301.2060839010514;2339.3800642829665;2353.8116950643907;2355.211004313557;2356.0340260493203;2301.9884900575476;2302.574023805593;2324.6861673674093;2327.2552783109413;2330.766923307664;2273.090763694519;2273.4998300374054;2288.725352957639;2293.025464177726;2300.217925905192;2186.650135978252;2207.4591725027312;2209.55808838233;2217.246136313645;2222.3110835641005;8431.704890328809;8501.234888860032;8514.829703405898;8519.701810436605;8530.829383412298;5060.089183946888;5209.218617207412;5220.216967454874;5236.1098613235845;5236.528712415863;3246.318273162639;3336.249343897628;3556.413191823372;3589.6667166341826;3591.6228795976567;1034.9430781307026;1041.833306670929;1062.718379629399;1078.9730256743567;1083.2254937719567;10717.196210284183;10918.962698543626;10959.945200274027;11008.119350451865;11017.173711971554;4506.549345065468;4583.220852455091;4671.696339737974;4672.929906051412;4760.33355330254;9408.905910940939;9596.568154433067;9598;9608.087231712976;9620.903790962;4423.668224883147;4432.180046691308;5206.323177986837;5213.582913366921;5223.268742376071;3835.9424608630893;4302.7633480158265;4308.0049205883115;4734.076855013308;4797.424309082862;3187.7131058204873;3817.1602247505502;3882.941755873664;3895.4156876468755;3921.156951255494;1062.8937106289309;1249.3440943504552;1260.3887114749339;1260.6407173955379;1268.517963173988;769.2653515892309;773.9574323412154;852.139339267332;893.9394695227563;905.6422713028448;5517.144842549411;5648.152777083388;5842.444967728059;5889.234399528034;5989.371116032841;400.5773908526474;420.3421645125369;443.6783332084213;444.6331776284578;447.54350562426794;3879.262940041383;3884.8057597120596;3894.883153505399;3941.8423263069158;4002.897030543716;9862.457564834003;10167.898321016843;10407.167426605853;10417.635382761568;10468.842967355497;10111.39331640104;10265.794684106426;10272.537735801907;10303.484825758682;10474;6787.898181527281;7832.334251588565;7896.249856263646;7936.801579960432;7950.204979502004;5548.722563871871;5548.916766248429;5709.571782116275;5732.885342293214;5814.098814683731;9339.859902101338;9370.531473426438;9398.953005235204;9474.810503790024;9493.288003399635;8848.513331766815;9595.712128636153;9657.372270802376;9684.564194611401;9766.218702503924;6637.867242655217;6839.076724642109;6996.825079373057;7176.96411517939;7268.454865885185;7689.6539655714505;7864.095629002738;7873.685052598061;7874.330681892104;7912;7027.297270272932;7099.645017749195;7320.487565870338;7326.010988516482;7341.70633174667;6935.583864968118;7115.857682846417;7141.714331426685;7152.856942861218;7225.963870180615;6651.467882569286;6810.148731408574;6821.897671534832;6822.829429264109;6834.453243740588;4898.804047838046;5003.274525193754;5051.62112841531;5060.949390506048;5178.171492561172;4989.326440930428;5133.512316329943;5173.094708425935;5174.97412512935;5257.63196576236 14:38:04 INFO - PROCESS | 1639 | |4;prototype.html;298.7147274352993;300.6752707076358;305.781366323079;307.49570704045385;310.06979062811564;4922.852314430564;5209.895802083956;5326.360836699591;5377.300950876385;5455.618106732531;4458.576435238655;4891.6764536844985;5041.8487445376695;5243.659162154458;5352.2239275305055;3177.507486339621;4053.6351728344443;4065.780265920227;4075.4498142750795;4106.691998100139;3947.4868267125235;4078.5309689385654;4093.3450647896343;4096.177201145491;4102.528209255929;3485.1809824691177;3825.215830754689;4008.7372477669587;4032.334664780308;4042.454268673721;2979.5400253875555;3032.9090127296217;3295.8352082396023;4012.3379642358977;4044.4519952430073;3199.600049993751;3550.2366991097037;3560;3564.269324788412;3577.8032208228537;4019.77891215983;4462.955370446286;4840.491748366406;5067.594592432633;5069.569086627641;4606.769661516944;4620.6303495720595;4635.258358662598;4644.2801365788355;4655.813767449298;5605.663660180402;5612.971935140298;5613.382527921925;5657.943420565783;5665.943340566583;3218.6620404857385;3492.5983511895947;3626.256617393428;3831.409964864578;3909.6481316681634;5535.335759708821;5540.864122854846;5841.56188285876;5892.204552385416;5913.674747888907;3515.9121021974656;3654.9217980695225;3892.9805350973065;3902.843886244575;3921.6470517653547;3185.0604071798875;3347.916302092467;3658.579263384692;3937.263601796781;3945.2504024235304;3762.927565643833;4557.179707652588;4594.356790049395;4602.746848923274;4630.74530900797;5719.370869204384;5724.227229324071;5742.54059675225;5759.827205183851;5769.365369809318;1161.0421402342931;1163.1567113842395;1215.8176273559036;1248.2697621891114;1248.4881198708485;688.0951548713426;838.9706360277361;868.7610907000626;875.1161327059589;875.7153924974409;4854.849104016086;5040.420351659533;5044.974775126101;5065.949340506621;5077.466865979093;4647.721136731807;4853.2720091985775;5218.530332270114;5250.414297480497;5538.790519205352;4918.671958571237;4961.776720047606;4996.4503904570465;5032.7735251913755;5041.319836519361;2796.5385711357803;2888.65336159658;2890.060730262673;2890.956635650467;2905.8086184664185;5032.698038117652;5148.871278218075;5581.05122129239;5581.776728930798;5689.43105689436;5245.659032162897;5339.878625488614;5538.501534861882;5559.610827242054;5603.122953810438;4822.903541929142;5274.7626356814035;5621.634593751475;5622.85942851432;5675.3757086720425;4277.82359851031;4923.433805112315;5155.072087024371;5450.046241907729;5476.644018138808;4515.616172625364;5099.960015993633;5402.459754024566;5419.775233735921;5489.917651235155;5364.570834333166;5477.972610136924;5675.914861277167;5680.2615659965595;5726.942730572641;3279.983600081984;3445.3626079175433;3482.9202947086483;3529.8235088245997;3679.24575462035;4896.2655601660035;5136.15253483186;5379.300690910157;5492.91760623583;5518.530924871431;4491.932621010753;4843.346148269939;4906.47316631942;5218.242865137096;5364.409914909279;4911.36152300213;4924.778384972613;5123.872747995435;5234.214867769865;5272.472752724851;5204.895902082013;5329.387120481039;5382.434844341287;5475.72621368938;5580.135079062752;4971.453140154508;5094.5669618082875;5419.0245755764345;5691.715414229189;5711.457411546063;5261.736913154404;5324.707141107121;5513.696746678811;5591.440855914539;5609 14:38:04 INFO - PROCESS | 1639 | |5;yui.html;611.5871786544083;688.9493522378373;689.7723751162115;701.6632016632017;736.9263073692628;12324.075694322928;12605.936970315135;12634.73652634736;12663.936680316609;12742;11032.393218372987;13051.543195988143;13217.471301147943;13240.53658121966;13265.801012984788;778.579567033801;807.6728924785472;808.4179390838616;811.3103861717552;811.809224832164;771.2326235395789;803.6819615830043;808.3937047214589;812.3988248695952;825.6944930375739;755.9962200188992;849.1890244816217;853.2534032721369;853.9103394143588;859.1194026123243;850;851.4040171879678;851.9829603407928;855.1747563601155;856.1780690537092;626.2078470734524;630.1367127035944;633.4868756307405;633.575504412045;635.5868685354557;14268.286585670676;14297.928510357382;14314.713705725932;14318.42726290947;14329.068610540386;13359.86640133596;13493.86506134936;13583.592492225249;13613.659658508517;13683.657908552266;9592.232621390272;11315.886841131565;11363;11508.136889733303;11680.474378652896;3592.6946209572216;3615.493830863681;3632.20091579852;3635.618260082706;3660.158163622355;89699.55150224273;90064.54967725185;90190.549047255;90487.54756226177;91537;10171.7457063574;10243.641472548425;10462;10523.631672891412;10715.410652414192;19919.302824401075;20076.39770806878;20089.899550502152;20166.899165504372;20205.090770915343;7489.700411983568;7512.136104347961;7544.811379715551;7595.164531901486;7688.038995125609;4130;4178.582141785797;4225;4244.108737165168;4299.6560275178535;3289.523019162208;3304.1078908694517;3412.897613071612;3539.1329124364697;3554.449060395643;616.2450997527992;626.4643729611208;627.9120923070683;635.3551145587232;647.2621211818531;599.5593238969354;640.5996252342286;654.5254690349459;662.6951602262917;676.864627074587;7613.314801667766;8476.576171191417;9097.545122743837;9185.540722963959;9345.719628411158;641.4002907281706;649.1107183159103;658.0688326018726;666.1440049536322;676.7428377216626;4269.850555230552;4559.52125026874;4578.267477203632;4587.449506059294;4623.468301145344;91529;117441;118041;118042;122201.38899305447;64989;65040.02439963404;70234.64882675554;71199.64400177966;87420.25159496775;58553;59370;72627.27372726206;81759.59120204361;84907.57546212229;7008.299170082951;7744.419168562267;9159.816803663756;9407.43555386679;9848.409095454295;30033;42054.789726051175;45762.77118614519;45896.770516147204;54884.902301954535;37412;64357.67821161052;66441.66779166073;67708;77494;11987.460564274803;12220.327881966577;12359.876401235873;12499.562515312284;12734.87265127374;14513.564593062225;14562.41750329975;14702.264886755833;14869.925650372112;14904.403823846924;13158.473661053451;13164.14433061848;13201.339933003119;13268.800967985295;13326.800097998344;11153.526642667788;11222.49498772541;13123.671908202372;13175.729390253506;13202.801957970447;11216.66350009501;11259.549618015515;12714;12806.231626102464;13069.738605228033;10877.67366978992;11399.316041037564;11400.543978240778;11446.198766086627;11661.416929153678;10843.945780271048;11215.204759958666;11242.100631949588;11426.885731142915;11482.483288251882 14:38:04 INFO - PROCESS | 1639 | __end_tp_report 14:38:04 INFO - PROCESS | 1639 | __start_cc_report 14:38:04 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,378 14:38:04 INFO - PROCESS | 1639 | __end_cc_report 14:38:04 INFO - PROCESS | 1639 | __startTimestamp1479249484350__endTimestamp 14:38:04 INFO - PROCESS | 1639 | 14:38:04 INFO - PROCESS | 1639 | ------- Summary: start ------- 14:38:04 INFO - PROCESS | 1639 | Number of tests: 6 14:38:04 INFO - PROCESS | 1639 | 14:38:04 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5824.16 Median:6112.63 stddev:692.53 (11.3%) stddev-sans-first:649.91 14:38:04 INFO - PROCESS | 1639 | Values: 2702.3 2928.7 3455.1 3494.3 3495.1 5905.0 5961.6 6003.6 6004.2 6018.5 6027.5 6045.5 6093.5 6112.6 6119.8 5430.8 5435.3 5485.8 5509.3 5512.9 5488.7 5499.9 5520.8 5530.1 5542.3 5357.6 5376.6 5509.6 5511.3 5531.3 4482.5 4774.5 5182.8 5419.5 5474.2 5288.5 5394.0 5402.2 5429.0 5455.9 6081.6 6090.8 6127.5 6171.6 6191.7 5665.4 6263.1 6282.3 6312.3 6331.4 6326.2 6345.9 6349.6 6352.4 6358.0 6045.4 6095.4 6102.5 6117.3 6138.0 6287.9 6340.6 6372.5 6383.2 6424.1 6353.7 6359.0 6360.7 6361.0 6374.0 6226.3 6382.2 6393.2 6401.2 6426.9 6242.5 6269.8 6284.7 6327.3 6350.3 6243.3 6270.3 6288.2 6310.7 6316.4 5039.3 5094.9 5096.3 5098.2 5109.8 4590.5 4594.0 4596.3 4611.8 4618.4 4922.4 5031.2 5969.4 5998.8 6093.3 6224.3 6233.0 6272.5 6318.6 6336.2 6043.8 6110.3 6124.1 6132.3 6165.7 5466.7 5526.5 5550.2 5564.4 5574.4 6400.2 6428.2 6431.1 6504.5 6518.1 5002.2 5272.8 5339.9 5782.3 6375.1 5535.9 6312.3 6378.2 6410.1 6553.8 6118.3 6266.0 6285.8 6289.9 6321.3 5188.0 6259.7 6265.5 6272.3 6272.8 5506.5 5653.7 6131.1 6274.0 6288.9 4380.5 5339.9 6228.5 6264.9 6266.4 5029.2 5077.7 6164.4 6285.7 6306.6 6223.7 6255.5 6282.9 6294.4 6298.4 6011.8 6058.9 6082.4 6088.0 6289.9 14:38:04 INFO - PROCESS | 1639 | 14:38:04 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:70048.94 Median:39394.50 stddev:156212.75 (396.5%) stddev-sans-first:156563.62 14:38:04 INFO - PROCESS | 1639 | Values: 474.5 495.1 506.5 512.6 522.6 37234.0 39790.8 39952.6 40033.0 40067.0 40904.0 41029.8 41297.8 41361.6 41445.0 9203.8 9338.4 9376.3 9390.2 9399.0 9168.0 9242.4 9253.4 9257.8 9284.2 9131.0 9185.5 9231.0 9243.4 9268.9 9181.3 9242.3 9256.3 9259.3 9265.7 9117.5 9212.4 9217.8 9240.8 9252.4 38750.4 39291.2 39312.4 39378.0 39411.0 3258.7 3292.3 3299.6 3333.7 3397.7 28026.7 28985.6 29630.3 29664.1 30187.7 2636.3 3132.3 3182.2 3192.5 3223.7 458318.0 459585.0 460104.0 462286.0 462464.0 56091.0 56528.7 56674.1 56765.4 56801.4 55708.0 55872.0 55988.7 56014.2 56223.0 15655.7 15877.8 15885.6 15888.5 15903.1 12232.3 12255.5 12318.7 12321.8 12326.8 15353.5 16004.0 16016.2 16071.4 16072.4 3139.5 5487.0 5893.1 6117.9 6443.3 840.7 872.2 909.8 941.6 943.5 26117.2 26313.3 29688.0 29783.0 29900.4 1023.9 1039.8 1056.1 1064.2 1078.3 13222.0 14210.7 14796.6 15178.6 15281.6 628408.0 632852.0 634293.0 636281.0 636932.0 56781.9 57039.4 57438.4 57461.7 58142.0 1312.7 1337.7 1356.0 1356.1 1366.1 22275.9 28881.4 29404.3 29476.3 30110.4 50037.5 50184.5 50333.0 50392.2 50438.2 635310.6 637259.0 638316.0 638669.0 640130.0 25754.6 26208.2 26212.6 26269.3 26352.9 44247.3 44346.8 45301.8 45410.1 45638.5 37643.8 37962.2 38156.8 38234.6 38767.4 37729.6 38598.5 38679.2 38704.8 39058.8 36341.6 36974.3 37385.7 37493.8 37933.2 31947.0 33017.3 33657.7 33775.2 33928.0 23816.2 25138.5 25180.0 25226.5 25758.5 14:38:04 INFO - PROCESS | 1639 | 14:38:04 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:33226.92 Median:2569.60 stddev:92786.49 (3610.9%) stddev-sans-first:93013.87 14:38:04 INFO - PROCESS | 1639 | Values: 311.3 312.9 369.9 382.7 398.7 18582.1 18764.7 19995.3 20001.7 20259.8 18996.4 19243.7 19740.3 19894.6 20091.8 5596.0 5888.1 5890.7 5892.8 5902.6 5460.0 5780.1 5840.6 5855.6 5876.4 5508.0 5813.9 5817.3 5817.4 5824.4 5616.7 5758.4 5771.1 5778.5 5800.2 4852.2 5023.1 5043.0 5054.4 5073.6 19703.2 24598.9 24686.9 24829.5 25091.9 2300.7 2555.5 2583.7 2799.5 2853.8 14346.2 15159.0 15256.2 15539.8 15574.6 1805.4 1845.4 1851.0 1877.7 1897.4 105491.7 108208.0 108817.0 108981.0 109770.0 10666.6 10863.7 11149.6 11293.7 11638.5 11356.9 13725.7 13855.6 13875.4 13878.9 8286.5 8489.5 8496.1 8511.8 8564.6 7701.5 7915.5 8416.2 8437.2 8533.7 5816.6 6371.7 6753.0 6778.0 6780.0 1841.3 1889.0 1889.1 1889.3 1895.4 847.4 903.2 909.7 921.4 1008.0 20793.3 21696.1 21744.5 21900.7 22035.7 935.6 953.0 984.8 991.0 992.6 9088.5 10530.6 11194.9 11612.7 11740.1 493349.0 518201.0 531274.0 611182.0 613156.0 112741.9 120252.8 120292.0 122565.8 132443.0 943.2 987.7 1006.3 1008.2 1013.0 17445.2 18971.8 19503.0 19673.0 19808.8 36686.0 45813.0 53668.7 53959.7 58956.1 76777.8 77652.0 79193.6 80276.0 80753.2 5306.7 5877.6 6264.8 6852.5 7454.4 9737.7 11605.5 12569.4 12828.1 13014.5 9512.9 10073.6 10789.0 11082.2 11138.5 10907.4 10919.6 10957.5 10958.9 11141.8 8361.5 9085.7 11086.0 11309.5 11687.4 8082.3 8177.8 8208.7 8209.1 8234.0 10248.1 10873.3 10879.0 10982.3 11225.9 14:38:04 INFO - PROCESS | 1639 | 14:38:04 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5474.92 Median:5060.52 stddev:3047.95 (60.2%) stddev-sans-first:3041.22 14:38:04 INFO - PROCESS | 1639 | Values: 1414.3 1478.0 1589.2 1716.4 1768.5 7638.5 7882.0 8153.0 8612.4 8625.4 8023.9 8313.3 8338.9 8443.3 8455.0 2284.7 2323.4 2327.5 2328.0 2328.3 2301.2 2339.4 2353.8 2355.2 2356.0 2302.0 2302.6 2324.7 2327.3 2330.8 2273.1 2273.5 2288.7 2293.0 2300.2 2186.7 2207.5 2209.6 2217.2 2222.3 8431.7 8501.2 8514.8 8519.7 8530.8 5060.1 5209.2 5220.2 5236.1 5236.5 3246.3 3336.2 3556.4 3589.7 3591.6 1034.9 1041.8 1062.7 1079.0 1083.2 10717.2 10919.0 10959.9 11008.1 11017.2 4506.5 4583.2 4671.7 4672.9 4760.3 9408.9 9596.6 9598.0 9608.1 9620.9 4423.7 4432.2 5206.3 5213.6 5223.3 3835.9 4302.8 4308.0 4734.1 4797.4 3187.7 3817.2 3882.9 3895.4 3921.2 1062.9 1249.3 1260.4 1260.6 1268.5 769.3 774.0 852.1 893.9 905.6 5517.1 5648.2 5842.4 5889.2 5989.4 400.6 420.3 443.7 444.6 447.5 3879.3 3884.8 3894.9 3941.8 4002.9 9862.5 10167.9 10407.2 10417.6 10468.8 10111.4 10265.8 10272.5 10303.5 10474.0 6787.9 7832.3 7896.2 7936.8 7950.2 5548.7 5548.9 5709.6 5732.9 5814.1 9339.9 9370.5 9399.0 9474.8 9493.3 8848.5 9595.7 9657.4 9684.6 9766.2 6637.9 6839.1 6996.8 7177.0 7268.5 7689.7 7864.1 7873.7 7874.3 7912.0 7027.3 7099.6 7320.5 7326.0 7341.7 6935.6 7115.9 7141.7 7152.9 7226.0 6651.5 6810.1 6821.9 6822.8 6834.5 4898.8 5003.3 5051.6 5060.9 5178.2 4989.3 5133.5 5173.1 5175.0 5257.6 14:38:04 INFO - PROCESS | 1639 | 14:38:04 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4400.47 Median:4966.61 stddev:1364.52 (27.5%) stddev-sans-first:1333.16 14:38:04 INFO - PROCESS | 1639 | Values: 298.7 300.7 305.8 307.5 310.1 4922.9 5209.9 5326.4 5377.3 5455.6 4458.6 4891.7 5041.8 5243.7 5352.2 3177.5 4053.6 4065.8 4075.4 4106.7 3947.5 4078.5 4093.3 4096.2 4102.5 3485.2 3825.2 4008.7 4032.3 4042.5 2979.5 3032.9 3295.8 4012.3 4044.5 3199.6 3550.2 3560.0 3564.3 3577.8 4019.8 4463.0 4840.5 5067.6 5069.6 4606.8 4620.6 4635.3 4644.3 4655.8 5605.7 5613.0 5613.4 5657.9 5665.9 3218.7 3492.6 3626.3 3831.4 3909.6 5535.3 5540.9 5841.6 5892.2 5913.7 3515.9 3654.9 3893.0 3902.8 3921.6 3185.1 3347.9 3658.6 3937.3 3945.3 3762.9 4557.2 4594.4 4602.7 4630.7 5719.4 5724.2 5742.5 5759.8 5769.4 1161.0 1163.2 1215.8 1248.3 1248.5 688.1 839.0 868.8 875.1 875.7 4854.8 5040.4 5045.0 5065.9 5077.5 4647.7 4853.3 5218.5 5250.4 5538.8 4918.7 4961.8 4996.5 5032.8 5041.3 2796.5 2888.7 2890.1 2891.0 2905.8 5032.7 5148.9 5581.1 5581.8 5689.4 5245.7 5339.9 5538.5 5559.6 5603.1 4822.9 5274.8 5621.6 5622.9 5675.4 4277.8 4923.4 5155.1 5450.0 5476.6 4515.6 5100.0 5402.5 5419.8 5489.9 5364.6 5478.0 5675.9 5680.3 5726.9 3280.0 3445.4 3482.9 3529.8 3679.2 4896.3 5136.2 5379.3 5492.9 5518.5 4491.9 4843.3 4906.5 5218.2 5364.4 4911.4 4924.8 5123.9 5234.2 5272.5 5204.9 5329.4 5382.4 5475.7 5580.1 4971.5 5094.6 5419.0 5691.7 5711.5 5261.7 5324.7 5513.7 5591.4 5609.0 14:38:04 INFO - PROCESS | 1639 | 14:38:04 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:18973.67 Median:4284.75 stddev:27697.27 (646.4%) stddev-sans-first:27740.66 14:38:04 INFO - PROCESS | 1639 | Values: 611.6 688.9 689.8 701.7 736.9 12324.1 12605.9 12634.7 12663.9 12742.0 11032.4 13051.5 13217.5 13240.5 13265.8 778.6 807.7 808.4 811.3 811.8 771.2 803.7 808.4 812.4 825.7 756.0 849.2 853.3 853.9 859.1 850.0 851.4 852.0 855.2 856.2 626.2 630.1 633.5 633.6 635.6 14268.3 14297.9 14314.7 14318.4 14329.1 13359.9 13493.9 13583.6 13613.7 13683.7 9592.2 11315.9 11363.0 11508.1 11680.5 3592.7 3615.5 3632.2 3635.6 3660.2 89699.6 90064.5 90190.5 90487.5 91537.0 10171.7 10243.6 10462.0 10523.6 10715.4 19919.3 20076.4 20089.9 20166.9 20205.1 7489.7 7512.1 7544.8 7595.2 7688.0 4130.0 4178.6 4225.0 4244.1 4299.7 3289.5 3304.1 3412.9 3539.1 3554.4 616.2 626.5 627.9 635.4 647.3 599.6 640.6 654.5 662.7 676.9 7613.3 8476.6 9097.5 9185.5 9345.7 641.4 649.1 658.1 666.1 676.7 4269.9 4559.5 4578.3 4587.4 4623.5 91529.0 117441.0 118041.0 118042.0 122201.4 64989.0 65040.0 70234.6 71199.6 87420.3 58553.0 59370.0 72627.3 81759.6 84907.6 7008.3 7744.4 9159.8 9407.4 9848.4 30033.0 42054.8 45762.8 45896.8 54884.9 37412.0 64357.7 66441.7 67708.0 77494.0 11987.5 12220.3 12359.9 12499.6 12734.9 14513.6 14562.4 14702.3 14869.9 14904.4 13158.5 13164.1 13201.3 13268.8 13326.8 11153.5 11222.5 13123.7 13175.7 13202.8 11216.7 11259.5 12714.0 12806.2 13069.7 10877.7 11399.3 11400.5 11446.2 11661.4 10843.9 11215.2 11242.1 11426.9 11482.5 14:38:04 INFO - PROCESS | 1639 | -------- Summary: end -------- 14:38:04 INFO - PROCESS | 1639 | 14:38:04 INFO - TEST-INFO | 1639: exit 0 14:38:05 INFO - TEST-OK | dromaeo_css | took 1116244ms 14:38:05 INFO - TEST-START | kraken 14:38:05 INFO - operating with platform_type : mac_ 14:38:05 INFO - Initialising browser for kraken test... 14:38:05 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmpHygxrY/profile http://localhost:49237/getInfo.html) 14:38:06 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 14:38:07 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 14:38:07 INFO - PROCESS | 1652 | colorDepth:24 14:38:07 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 14:38:07 INFO - PROCESS | 1652 | __metrics 14:38:07 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 14:38:08 INFO - TEST-INFO | 1652: exit 0 14:38:08 INFO - Browser initialized. 14:38:08 INFO - Running cycle 1/1 for kraken test... 14:38:08 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmpHygxrY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:38:20 INFO - PROCESS | 1654 | RSS: Main: 224014336 14:38:20 INFO - PROCESS | 1654 | 14:38:23 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 14:38:24 INFO - PROCESS | 1654 | RSS: Main: 236802048 14:38:24 INFO - PROCESS | 1654 | 14:38:27 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 14:38:27 INFO - PROCESS | 1654 | RSS: Main: 244310016 14:38:27 INFO - PROCESS | 1654 | 14:38:31 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 14:38:31 INFO - PROCESS | 1654 | RSS: Main: 248098816 14:38:31 INFO - PROCESS | 1654 | 14:38:33 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 14:38:34 INFO - PROCESS | 1654 | RSS: Main: 249344000 14:38:34 INFO - PROCESS | 1654 | 14:38:36 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:38:37 INFO - PROCESS | 1654 | RSS: Main: 249667584 14:38:37 INFO - PROCESS | 1654 | 14:38:40 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 14:38:40 INFO - PROCESS | 1654 | RSS: Main: 253517824 14:38:40 INFO - PROCESS | 1654 | 14:38:44 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 14:38:44 INFO - PROCESS | 1654 | RSS: Main: 252862464 14:38:44 INFO - PROCESS | 1654 | 14:38:47 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 14:38:48 INFO - PROCESS | 1654 | RSS: Main: 252727296 14:38:48 INFO - PROCESS | 1654 | 14:38:50 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:38:50 INFO - PROCESS | 1654 | RSS: Main: 252043264 14:38:50 INFO - PROCESS | 1654 | 14:38:52 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:38:53 INFO - PROCESS | 1654 | RSS: Main: 252084224 14:38:53 INFO - PROCESS | 1654 | 14:38:55 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:38:56 INFO - PROCESS | 1654 | RSS: Main: 252121088 14:38:56 INFO - PROCESS | 1654 | 14:38:59 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:39:00 INFO - PROCESS | 1654 | RSS: Main: 252669952 14:39:00 INFO - PROCESS | 1654 | 14:39:03 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:39:03 INFO - PROCESS | 1654 | RSS: Main: 252264448 14:39:03 INFO - PROCESS | 1654 | 14:39:05 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 14:39:05 INFO - PROCESS | 1654 | RSS: Main: 254083072 14:39:05 INFO - PROCESS | 1654 | 14:39:05 INFO - PROCESS | 1654 | __start_tp_report 14:39:05 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 14:39:05 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 14:39:05 INFO - PROCESS | 1654 | |i|pagename|runs| 14:39:05 INFO - PROCESS | 1654 | |0;ai-astar;110;168;119;118;120;120;119;118;115;121 14:39:05 INFO - PROCESS | 1654 | |1;audio-beat-detection;153;151;115;147;116;115;135;144;179;128 14:39:05 INFO - PROCESS | 1654 | |2;audio-dft;201;196;193;203;195;195;237;196;234;291 14:39:05 INFO - PROCESS | 1654 | |3;audio-fft;82;58;69;85;60;61;66;85;105;58 14:39:05 INFO - PROCESS | 1654 | |4;audio-oscillator;88;71;89;72;71;72;85;69;71;90 14:39:05 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;138;133;90;105;126;132;84;131;137;117 14:39:05 INFO - PROCESS | 1654 | |6;imaging-darkroom;95;120;153;155;95;96;96;96;149;152 14:39:05 INFO - PROCESS | 1654 | |7;imaging-desaturate;73;75;135;100;102;120;87;145;133;79 14:39:05 INFO - PROCESS | 1654 | |8;json-parse-financial;56;57;57;57;60;60;60;59;59;58 14:39:05 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;69;76;73;83;77;75;73;73;77;74 14:39:05 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;84;84;88;86;88;90;102;107;105;72 14:39:05 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;137;155;168;161;154;172;165;161;195;169 14:39:05 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;175;171;169;165;171;169;166;176;170;174 14:39:05 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;68;67;69;66;80;91;62;75;90;95 14:39:05 INFO - PROCESS | 1654 | __end_tp_report 14:39:05 INFO - PROCESS | 1654 | __start_cc_report 14:39:05 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1007 14:39:05 INFO - PROCESS | 1654 | __end_cc_report 14:39:05 INFO - PROCESS | 1654 | __startTimestamp1479249545723__endTimestamp 14:39:05 INFO - PROCESS | 1654 | 14:39:05 INFO - PROCESS | 1654 | ------- Summary: start ------- 14:39:05 INFO - PROCESS | 1654 | Number of tests: 14 14:39:05 INFO - PROCESS | 1654 | 14:39:05 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:122.80 Median:119.50 stddev:16.20 (13.6%) stddev-sans-first:16.51 14:39:05 INFO - PROCESS | 1654 | Values: 110.0 168.0 119.0 118.0 120.0 120.0 119.0 118.0 115.0 121.0 14:39:05 INFO - PROCESS | 1654 | 14:39:05 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:145.50 stddev:20.66 (14.2%) stddev-sans-first:21.22 14:39:05 INFO - PROCESS | 1654 | Values: 153.0 151.0 115.0 147.0 116.0 115.0 135.0 144.0 179.0 128.0 14:39:05 INFO - PROCESS | 1654 | 14:39:05 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:214.10 Median:202.00 stddev:31.55 (15.6%) stddev-sans-first:33.11 14:39:05 INFO - PROCESS | 1654 | Values: 201.0 196.0 193.0 203.0 195.0 195.0 237.0 196.0 234.0 291.0 14:39:05 INFO - PROCESS | 1654 | 14:39:05 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:72.90 Median:67.50 stddev:15.71 (23.3%) stddev-sans-first:16.31 14:39:05 INFO - PROCESS | 1654 | Values: 82.0 58.0 69.0 85.0 60.0 61.0 66.0 85.0 105.0 58.0 14:39:05 INFO - PROCESS | 1654 | 14:39:05 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:78.50 stddev:8.90 (11.3%) stddev-sans-first:8.65 14:39:05 INFO - PROCESS | 1654 | Values: 88.0 71.0 89.0 72.0 71.0 72.0 85.0 69.0 71.0 90.0 14:39:05 INFO - PROCESS | 1654 | 14:39:05 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:119.30 Median:135.00 stddev:19.74 (14.6%) stddev-sans-first:19.75 14:39:05 INFO - PROCESS | 1654 | Values: 138.0 133.0 90.0 105.0 126.0 132.0 84.0 131.0 137.0 117.0 14:39:05 INFO - PROCESS | 1654 | 14:39:05 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:120.70 Median:95.00 stddev:28.19 (29.7%) stddev-sans-first:28.32 14:39:05 INFO - PROCESS | 1654 | Values: 95.0 120.0 153.0 155.0 95.0 96.0 96.0 96.0 149.0 152.0 14:39:05 INFO - PROCESS | 1654 | 14:39:05 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:104.90 Median:109.00 stddev:26.81 (24.6%) stddev-sans-first:25.83 14:39:05 INFO - PROCESS | 1654 | Values: 73.0 75.0 135.0 100.0 102.0 120.0 87.0 145.0 133.0 79.0 14:39:05 INFO - PROCESS | 1654 | 14:39:05 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:59.00 stddev:1.49 (2.5%) stddev-sans-first:1.33 14:39:05 INFO - PROCESS | 1654 | Values: 56.0 57.0 57.0 57.0 60.0 60.0 60.0 59.0 59.0 58.0 14:39:05 INFO - PROCESS | 1654 | 14:39:05 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:75.00 Median:75.50 stddev:3.68 (4.9%) stddev-sans-first:3.20 14:39:05 INFO - PROCESS | 1654 | Values: 69.0 76.0 73.0 83.0 77.0 75.0 73.0 73.0 77.0 74.0 14:39:05 INFO - PROCESS | 1654 | 14:39:05 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:90.60 Median:85.00 stddev:10.93 (12.9%) stddev-sans-first:11.32 14:39:05 INFO - PROCESS | 1654 | Values: 84.0 84.0 88.0 86.0 88.0 90.0 102.0 107.0 105.0 72.0 14:39:05 INFO - PROCESS | 1654 | 14:39:05 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:163.70 Median:166.50 stddev:14.89 (8.9%) stddev-sans-first:12.26 14:39:05 INFO - PROCESS | 1654 | Values: 137.0 155.0 168.0 161.0 154.0 172.0 165.0 161.0 195.0 169.0 14:39:05 INFO - PROCESS | 1654 | 14:39:05 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.60 Median:171.00 stddev:3.63 (2.1%) stddev-sans-first:3.48 14:39:05 INFO - PROCESS | 1654 | Values: 175.0 171.0 169.0 165.0 171.0 169.0 166.0 176.0 170.0 174.0 14:39:05 INFO - PROCESS | 1654 | 14:39:05 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.30 Median:77.50 stddev:11.96 (15.4%) stddev-sans-first:12.31 14:39:05 INFO - PROCESS | 1654 | Values: 68.0 67.0 69.0 66.0 80.0 91.0 62.0 75.0 90.0 95.0 14:39:05 INFO - PROCESS | 1654 | -------- Summary: end -------- 14:39:05 INFO - PROCESS | 1654 | 14:39:06 INFO - TEST-INFO | 1654: exit 0 14:39:06 INFO - TEST-OK | kraken | took 61616ms 14:39:06 INFO - SUITE-END | took 1177s 14:39:06 INFO - Completed test suite (00:19:38) 14:39:06 INFO - javascript benchmark 14:39:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7094.998217197482, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2702.297402675304, 2928.7217714317144, 3455.084402633301, 3494.3360761455306, 3495.0912762681696, 5905.025670764324, 5961.61249518781, 6003.639781613107, 6004.189434426351, 6018.458338749511, 6027.547933904963, 6045.486133678643, 6093.542984276175, 6112.633242005483, 6119.755209791614, 5430.809921652753, 5435.266239057736, 5485.780568777244, 5509.283793106891, 5512.944870551283, 5488.670679759227, 5499.917501237464, 5520.751566179511, 5530.142827861668, 5542.2517960075475, 5357.571394288467, 5376.596755243353, 5509.559235261169, 5511.268280987768, 5531.2809334786625, 4482.484514280867, 4774.522547745232, 5182.782046219136, 5419.512243898029, 5474.151506516497, 5288.524032837025, 5394.0, 5402.189671549259, 5428.972855135738, 5455.918161227585, 6081.6351018939, 6090.786822461193, 6127.509799216052, 6171.6297022178815, 6191.721372538202, 5665.376808551097, 6263.060540918853, 6282.277538083134, 6312.305646378894, 6331.366863313678, 6326.177596912418, 6345.904811427832, 6349.555531112824, 6352.396522330371, 6357.968210158966, 6045.3652366501765, 6095.359987201368, 6102.4507794298725, 6117.296510901258, 6138.0179171332375, 6287.874242515124, 6340.619562826245, 6372.490200783926, 6383.202099737533, 6424.1327420798525, 6353.745850166034, 6358.968205159037, 6360.681965901686, 6361.01404282337, 6373.968130159319, 6226.283977342664, 6382.234131904202, 6393.2328120625825, 6401.1678481798, 6426.8714625707225, 6242.500599951993, 6269.843253918689, 6284.685765711696, 6327.303996560375, 6350.33321501245, 6243.282022567463, 6270.3416141305415, 6288.213973253343, 6310.652914089677, 6316.368363163647, 5039.319691841628, 5094.923576146361, 5096.261042148868, 5098.235264710249, 5109.795608175631, 4590.495045544987, 4594.035252596992, 4596.333531637961, 4611.76941152941, 4618.35343051973, 4922.360093187863, 5031.245313202976, 5969.403059694083, 5998.820035398945, 6093.329733729286, 6224.253089629274, 6233.0, 6272.466840318624, 6318.557700960889, 6336.239651241881, 6043.758249670052, 6110.327863934964, 6124.081387791867, 6132.325444201134, 6165.722542485599, 5466.726663666801, 5526.47498487643, 5550.222968784374, 5564.415736347706, 5574.442555744393, 6400.199975003125, 6428.19647544057, 6431.067495213168, 6504.544681872413, 6518.087467754423, 5002.224655178453, 5272.76272567743, 5339.946600533945, 5782.3452121042965, 6375.107484952017, 5535.8892822144135, 6312.274088479883, 6378.202724659418, 6410.070539771614, 6553.803385898431, 6118.345080237214, 6265.997440409513, 6285.811425657238, 6289.905651415141, 6321.33625969285, 5188.0, 6259.718312675849, 6265.467435267871, 6272.310045894857, 6272.8118156455375, 5506.504414602705, 5653.745581448927, 6131.132004888217, 6274.0, 6288.874222515433, 4380.51814300433, 5339.919901201562, 6228.532860035425, 6264.874702506016, 6266.436020757971, 5029.245613158056, 5077.720725360141, 6164.383561643979, 6285.717142728497, 6306.558540902093, 6223.719932602953, 6255.499560035278, 6282.874342513215, 6294.402031806971, 6298.370162983665, 6011.789587364421, 6058.878822423439, 6082.391760823883, 6087.969560152171, 6289.937100628935], "value": 5780.472795754148, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.48044391391426, 495.0840944253132, 506.4960364437383, 512.5515174222555, 522.5714913770707, 37234.0, 39790.8062758117, 39952.60047399525, 40033.0, 40067.0, 40904.0, 41029.79485102578, 41297.793511032476, 41361.58638413615, 41445.0, 9203.769905752342, 9338.439693618371, 9376.343655944052, 9390.201832844217, 9399.0, 9167.95416022919, 9242.39924404915, 9253.444793312423, 9257.768555786091, 9284.210842078432, 9130.954345228298, 9185.540722963859, 9231.0, 9243.445393276392, 9268.907310926872, 9181.31140164487, 9242.260619150486, 9256.30577706668, 9259.30555208362, 9265.675701350488, 9117.452952822852, 9212.40119392244, 9217.769555761093, 9240.815183696355, 9252.444853308823, 38750.41874371887, 39291.21417571661, 39312.410313845314, 39378.0, 39411.0, 3258.7230085442766, 3292.3415316936707, 3299.637039925606, 3333.666633336647, 3397.728181745479, 28026.73879675399, 28985.565216521558, 29630.259243518867, 29664.110076697732, 30187.69812301871, 2636.327736427218, 3132.2795756975797, 3182.156728466958, 3192.457282262021, 3223.661515540858, 458318.0, 459585.0, 460104.0, 462286.0, 462464.0, 56091.0, 56528.717356412955, 56674.149887751715, 56765.43234567684, 56801.43198568044, 55708.0, 55872.0, 55988.72005640027, 56014.15978760322, 56223.0, 15655.68688626244, 15877.841221587867, 15885.602859928595, 15888.523344299689, 15903.125328106833, 12232.266064036186, 12255.509779608894, 12318.692032699075, 12321.753564928651, 12326.81509777354, 15353.462628807938, 16004.0, 16016.199190040452, 16071.35714571404, 16072.437464688679, 3139.4662907305815, 5486.972565137149, 5893.116032595145, 6117.938820611737, 6443.29123796382, 840.6595328891808, 872.1888643561549, 909.8362294787001, 941.5621735892843, 943.4669411782321, 26117.216483505526, 26313.342166445993, 29687.96092136765, 29783.0, 29900.40199196004, 1023.892491288404, 1039.7920415916847, 1056.060106505211, 1064.2443864855884, 1078.336822853939, 13222.021436003195, 14210.715785684228, 14796.556103316918, 15178.620534486505, 15281.6179595511, 628408.0, 632852.0, 634293.0, 636281.0, 636932.0, 56781.86436271251, 57039.429605704245, 57438.42561574414, 57461.71269143711, 58142.0, 1312.6718320419895, 1337.71239183576, 1355.959321220365, 1356.0575400097034, 1366.1325058587868, 22275.888620556794, 28881.42237155287, 29404.264893377836, 29476.263093422836, 30110.397792044474, 50037.499625003285, 50184.49815501798, 50333.0, 50392.24411633902, 50438.2434263479, 635310.6468935437, 637259.0, 638316.0, 638669.0, 640130.0, 25754.613680794428, 26208.213753587424, 26212.60681089747, 26269.343266417727, 26352.868235658698, 44247.336289955034, 44346.778266108464, 45301.773491132335, 45410.091798163194, 45638.54361456343, 37643.81178094092, 37962.240755185296, 38156.80921595374, 38234.61765382311, 38767.418488723255, 37729.62270377261, 38598.48258557872, 38679.2264154721, 38704.80647596744, 39058.80470597629, 36341.636583634885, 36974.26051478901, 37385.691500797344, 37493.81253093826, 37933.24133517369, 31947.0, 33017.28557279298, 33657.663423365455, 33775.15562110967, 33928.0, 23816.16643417472, 25138.497230055662, 25179.992800287782, 25226.49547009013, 25758.484830303663], "value": 19160.296459951474, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.31510676511675, 312.92020534763645, 369.9482072509849, 382.66707964071264, 398.7121597240912, 18582.070896455174, 18764.71852922207, 19995.300164494227, 20001.699974500396, 20259.797402025975, 18996.43010709681, 19243.711344329848, 19740.309089181847, 19894.602107957868, 20091.799082009176, 5595.99999999999, 5888.087346461305, 5890.734916928727, 5892.764289428439, 5902.557308201902, 5460.0, 5780.0751879699255, 5840.561957853157, 5855.560832937525, 5876.44173803488, 5508.0, 5813.941860581383, 5817.331006934193, 5817.389174136718, 5824.359320474744, 5616.719164041802, 5758.395368486333, 5771.076627739583, 5778.479936805707, 5800.24596802413, 4852.17513022787, 5023.120953833101, 5043.0, 5054.418741844698, 5073.568746656539, 19703.211871525265, 24598.877005615035, 24686.876565617236, 24829.5034099317, 25091.87454062718, 2300.7354154272307, 2555.463352695936, 2583.74162583742, 2799.4820958122814, 2853.7574306184, 14346.177101082863, 15159.014664046801, 15256.160911149882, 15539.766903496457, 15574.610634734223, 1805.4312891439154, 1845.4186931116656, 1850.9629807403776, 1877.7465042219262, 1897.383350411108, 105491.68594312684, 108208.0, 108817.0, 108981.0, 109770.0, 10666.573337066586, 10863.67408977732, 11149.554017839358, 11293.71765705864, 11638.476268567934, 11356.886431135748, 13725.725485490433, 13855.58433246984, 13875.37560809766, 13878.861211387959, 8286.544240066854, 8489.490630562186, 8496.107908669625, 8511.829763404698, 8564.61459234336, 7701.460897737216, 7915.525068495908, 8416.242538171595, 8437.156284371637, 8533.701320453754, 5816.563757718188, 6371.713272902731, 6752.966235168891, 6778.0, 6780.0, 1841.2819000589782, 1889.0, 1889.0743535667425, 1889.3292881027312, 1895.3840001999406, 847.3983471735014, 903.2322525853103, 909.736176508805, 921.4333185091255, 1007.9949600252098, 20793.272235471686, 21696.13215471395, 21744.456388590097, 21900.68595884252, 22035.66946495804, 935.6397786851975, 952.9904700953041, 984.8473486609587, 990.9752256193652, 992.5979978108877, 9088.454692718458, 10530.57877684884, 11194.888051119384, 11612.6516204514, 11740.119491038206, 493349.0, 518201.0, 531274.0, 611182.0, 613156.0, 112741.87258127477, 120252.79747202591, 120292.0, 122565.77434225722, 132443.0, 943.2029934705163, 987.713563066717, 1006.3106771861299, 1008.2186305613062, 1013.022433351819, 17445.214965326337, 18971.810281897004, 19503.02484875722, 19673.0, 19808.801911980696, 36686.0, 45813.0, 53668.73165634147, 53959.730201350314, 58956.1156582643, 76777.84833227395, 77652.0, 79193.60403197947, 80275.99310017296, 80753.19246807457, 5306.6550674206055, 5877.588568800314, 6264.812055638338, 6852.45180385558, 7454.3663788576405, 9737.707868763948, 11605.535778569101, 12569.434375452944, 12828.10203285761, 13014.544490942772, 9512.858456985206, 10073.647422340184, 10789.0, 11082.168837337393, 11138.498767555317, 10907.400092994962, 10919.563217471212, 10957.452127393757, 10958.945205273923, 11141.83287250708, 8361.540115293717, 9085.727428177166, 11086.0, 11309.547618095514, 11687.415629218674, 8082.2725954664365, 8177.836443271221, 8208.671653133808, 8209.096999330188, 8234.011918569571, 10248.128909042814, 10873.293235939638, 10879.0, 10982.341059536453, 11225.887741122484], "value": 9491.342529179145, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1414.2504472629503, 1478.0, 1589.1656880137925, 1716.3992602589103, 1768.5490199998999, 7638.541687498754, 7882.0, 8153.0, 8612.39713220075, 8625.353098517613, 8023.919760802391, 8313.334933205344, 8338.874916876252, 8443.324534037278, 8455.0, 2284.65730140479, 2323.4307594639336, 2327.534493101378, 2327.9650805237934, 2328.348062542491, 2301.2060839010514, 2339.3800642829665, 2353.8116950643907, 2355.211004313557, 2356.0340260493203, 2301.9884900575476, 2302.574023805593, 2324.6861673674093, 2327.2552783109413, 2330.766923307664, 2273.090763694519, 2273.4998300374054, 2288.725352957639, 2293.025464177726, 2300.217925905192, 2186.650135978252, 2207.4591725027312, 2209.55808838233, 2217.246136313645, 2222.3110835641005, 8431.704890328809, 8501.234888860032, 8514.829703405898, 8519.701810436605, 8530.829383412298, 5060.089183946888, 5209.218617207412, 5220.216967454874, 5236.1098613235845, 5236.528712415863, 3246.318273162639, 3336.249343897628, 3556.413191823372, 3589.6667166341826, 3591.6228795976567, 1034.9430781307026, 1041.833306670929, 1062.718379629399, 1078.9730256743567, 1083.2254937719567, 10717.196210284183, 10918.962698543626, 10959.945200274027, 11008.119350451865, 11017.173711971554, 4506.549345065468, 4583.220852455091, 4671.696339737974, 4672.929906051412, 4760.33355330254, 9408.905910940939, 9596.568154433067, 9598.0, 9608.087231712976, 9620.903790962, 4423.668224883147, 4432.180046691308, 5206.323177986837, 5213.582913366921, 5223.268742376071, 3835.9424608630893, 4302.7633480158265, 4308.0049205883115, 4734.076855013308, 4797.424309082862, 3187.7131058204873, 3817.1602247505502, 3882.941755873664, 3895.4156876468755, 3921.156951255494, 1062.8937106289309, 1249.3440943504552, 1260.3887114749339, 1260.6407173955379, 1268.517963173988, 769.2653515892309, 773.9574323412154, 852.139339267332, 893.9394695227563, 905.6422713028448, 5517.144842549411, 5648.152777083388, 5842.444967728059, 5889.234399528034, 5989.371116032841, 400.5773908526474, 420.3421645125369, 443.6783332084213, 444.6331776284578, 447.54350562426794, 3879.262940041383, 3884.8057597120596, 3894.883153505399, 3941.8423263069158, 4002.897030543716, 9862.457564834003, 10167.898321016843, 10407.167426605853, 10417.635382761568, 10468.842967355497, 10111.39331640104, 10265.794684106426, 10272.537735801907, 10303.484825758682, 10474.0, 6787.898181527281, 7832.334251588565, 7896.249856263646, 7936.801579960432, 7950.204979502004, 5548.722563871871, 5548.916766248429, 5709.571782116275, 5732.885342293214, 5814.098814683731, 9339.859902101338, 9370.531473426438, 9398.953005235204, 9474.810503790024, 9493.288003399635, 8848.513331766815, 9595.712128636153, 9657.372270802376, 9684.564194611401, 9766.218702503924, 6637.867242655217, 6839.076724642109, 6996.825079373057, 7176.96411517939, 7268.454865885185, 7689.6539655714505, 7864.095629002738, 7873.685052598061, 7874.330681892104, 7912.0, 7027.297270272932, 7099.645017749195, 7320.487565870338, 7326.010988516482, 7341.70633174667, 6935.583864968118, 7115.857682846417, 7141.714331426685, 7152.856942861218, 7225.963870180615, 6651.467882569286, 6810.148731408574, 6821.897671534832, 6822.829429264109, 6834.453243740588, 4898.804047838046, 5003.274525193754, 5051.62112841531, 5060.949390506048, 5178.171492561172, 4989.326440930428, 5133.512316329943, 5173.094708425935, 5174.97412512935, 5257.63196576236], "value": 4340.327908112773, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.7147274352993, 300.6752707076358, 305.781366323079, 307.49570704045385, 310.06979062811564, 4922.852314430564, 5209.895802083956, 5326.360836699591, 5377.300950876385, 5455.618106732531, 4458.576435238655, 4891.6764536844985, 5041.8487445376695, 5243.659162154458, 5352.2239275305055, 3177.507486339621, 4053.6351728344443, 4065.780265920227, 4075.4498142750795, 4106.691998100139, 3947.4868267125235, 4078.5309689385654, 4093.3450647896343, 4096.177201145491, 4102.528209255929, 3485.1809824691177, 3825.215830754689, 4008.7372477669587, 4032.334664780308, 4042.454268673721, 2979.5400253875555, 3032.9090127296217, 3295.8352082396023, 4012.3379642358977, 4044.4519952430073, 3199.600049993751, 3550.2366991097037, 3560.0, 3564.269324788412, 3577.8032208228537, 4019.77891215983, 4462.955370446286, 4840.491748366406, 5067.594592432633, 5069.569086627641, 4606.769661516944, 4620.6303495720595, 4635.258358662598, 4644.2801365788355, 4655.813767449298, 5605.663660180402, 5612.971935140298, 5613.382527921925, 5657.943420565783, 5665.943340566583, 3218.6620404857385, 3492.5983511895947, 3626.256617393428, 3831.409964864578, 3909.6481316681634, 5535.335759708821, 5540.864122854846, 5841.56188285876, 5892.204552385416, 5913.674747888907, 3515.9121021974656, 3654.9217980695225, 3892.9805350973065, 3902.843886244575, 3921.6470517653547, 3185.0604071798875, 3347.916302092467, 3658.579263384692, 3937.263601796781, 3945.2504024235304, 3762.927565643833, 4557.179707652588, 4594.356790049395, 4602.746848923274, 4630.74530900797, 5719.370869204384, 5724.227229324071, 5742.54059675225, 5759.827205183851, 5769.365369809318, 1161.0421402342931, 1163.1567113842395, 1215.8176273559036, 1248.2697621891114, 1248.4881198708485, 688.0951548713426, 838.9706360277361, 868.7610907000626, 875.1161327059589, 875.7153924974409, 4854.849104016086, 5040.420351659533, 5044.974775126101, 5065.949340506621, 5077.466865979093, 4647.721136731807, 4853.2720091985775, 5218.530332270114, 5250.414297480497, 5538.790519205352, 4918.671958571237, 4961.776720047606, 4996.4503904570465, 5032.7735251913755, 5041.319836519361, 2796.5385711357803, 2888.65336159658, 2890.060730262673, 2890.956635650467, 2905.8086184664185, 5032.698038117652, 5148.871278218075, 5581.05122129239, 5581.776728930798, 5689.43105689436, 5245.659032162897, 5339.878625488614, 5538.501534861882, 5559.610827242054, 5603.122953810438, 4822.903541929142, 5274.7626356814035, 5621.634593751475, 5622.85942851432, 5675.3757086720425, 4277.82359851031, 4923.433805112315, 5155.072087024371, 5450.046241907729, 5476.644018138808, 4515.616172625364, 5099.960015993633, 5402.459754024566, 5419.775233735921, 5489.917651235155, 5364.570834333166, 5477.972610136924, 5675.914861277167, 5680.2615659965595, 5726.942730572641, 3279.983600081984, 3445.3626079175433, 3482.9202947086483, 3529.8235088245997, 3679.24575462035, 4896.2655601660035, 5136.15253483186, 5379.300690910157, 5492.91760623583, 5518.530924871431, 4491.932621010753, 4843.346148269939, 4906.47316631942, 5218.242865137096, 5364.409914909279, 4911.36152300213, 4924.778384972613, 5123.872747995435, 5234.214867769865, 5272.472752724851, 5204.895902082013, 5329.387120481039, 5382.434844341287, 5475.72621368938, 5580.135079062752, 4971.453140154508, 5094.5669618082875, 5419.0245755764345, 5691.715414229189, 5711.457411546063, 5261.736913154404, 5324.707141107121, 5513.696746678811, 5591.440855914539, 5609.0], "value": 3961.754367434189, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.5871786544083, 688.9493522378373, 689.7723751162115, 701.6632016632017, 736.9263073692628, 12324.075694322928, 12605.936970315135, 12634.73652634736, 12663.936680316609, 12742.0, 11032.393218372987, 13051.543195988143, 13217.471301147943, 13240.53658121966, 13265.801012984788, 778.579567033801, 807.6728924785472, 808.4179390838616, 811.3103861717552, 811.809224832164, 771.2326235395789, 803.6819615830043, 808.3937047214589, 812.3988248695952, 825.6944930375739, 755.9962200188992, 849.1890244816217, 853.2534032721369, 853.9103394143588, 859.1194026123243, 850.0, 851.4040171879678, 851.9829603407928, 855.1747563601155, 856.1780690537092, 626.2078470734524, 630.1367127035944, 633.4868756307405, 633.575504412045, 635.5868685354557, 14268.286585670676, 14297.928510357382, 14314.713705725932, 14318.42726290947, 14329.068610540386, 13359.86640133596, 13493.86506134936, 13583.592492225249, 13613.659658508517, 13683.657908552266, 9592.232621390272, 11315.886841131565, 11363.0, 11508.136889733303, 11680.474378652896, 3592.6946209572216, 3615.493830863681, 3632.20091579852, 3635.618260082706, 3660.158163622355, 89699.55150224273, 90064.54967725185, 90190.549047255, 90487.54756226177, 91537.0, 10171.7457063574, 10243.641472548425, 10462.0, 10523.631672891412, 10715.410652414192, 19919.302824401075, 20076.39770806878, 20089.899550502152, 20166.899165504372, 20205.090770915343, 7489.700411983568, 7512.136104347961, 7544.811379715551, 7595.164531901486, 7688.038995125609, 4130.0, 4178.582141785797, 4225.0, 4244.108737165168, 4299.6560275178535, 3289.523019162208, 3304.1078908694517, 3412.897613071612, 3539.1329124364697, 3554.449060395643, 616.2450997527992, 626.4643729611208, 627.9120923070683, 635.3551145587232, 647.2621211818531, 599.5593238969354, 640.5996252342286, 654.5254690349459, 662.6951602262917, 676.864627074587, 7613.314801667766, 8476.576171191417, 9097.545122743837, 9185.540722963959, 9345.719628411158, 641.4002907281706, 649.1107183159103, 658.0688326018726, 666.1440049536322, 676.7428377216626, 4269.850555230552, 4559.52125026874, 4578.267477203632, 4587.449506059294, 4623.468301145344, 91529.0, 117441.0, 118041.0, 118042.0, 122201.38899305447, 64989.0, 65040.02439963404, 70234.64882675554, 71199.64400177966, 87420.25159496775, 58553.0, 59370.0, 72627.27372726206, 81759.59120204361, 84907.57546212229, 7008.299170082951, 7744.419168562267, 9159.816803663756, 9407.43555386679, 9848.409095454295, 30033.0, 42054.789726051175, 45762.77118614519, 45896.770516147204, 54884.902301954535, 37412.0, 64357.67821161052, 66441.66779166073, 67708.0, 77494.0, 11987.460564274803, 12220.327881966577, 12359.876401235873, 12499.562515312284, 12734.87265127374, 14513.564593062225, 14562.41750329975, 14702.264886755833, 14869.925650372112, 14904.403823846924, 13158.473661053451, 13164.14433061848, 13201.339933003119, 13268.800967985295, 13326.800097998344, 11153.526642667788, 11222.49498772541, 13123.671908202372, 13175.729390253506, 13202.801957970447, 11216.66350009501, 11259.549618015515, 12714.0, 12806.231626102464, 13069.738605228033, 10877.67366978992, 11399.316041037564, 11400.543978240778, 11446.198766086627, 11661.416929153678, 10843.945780271048, 11215.204759958666, 11242.100631949588, 11426.885731142915, 11482.483288251882], "value": 7056.070644229119, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1605.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 168.0, 119.0, 118.0, 120.0, 120.0, 119.0, 118.0, 115.0, 121.0], "value": 122.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 115.0, 147.0, 116.0, 115.0, 135.0, 144.0, 179.0, 128.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 196.0, 193.0, 203.0, 195.0, 195.0, 237.0, 196.0, 234.0, 291.0], "value": 214.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 69.0, 85.0, 60.0, 61.0, 66.0, 85.0, 105.0, 58.0], "value": 72.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 89.0, 72.0, 71.0, 72.0, 85.0, 69.0, 71.0, 90.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 133.0, 90.0, 105.0, 126.0, 132.0, 84.0, 131.0, 137.0, 117.0], "value": 119.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 120.0, 153.0, 155.0, 95.0, 96.0, 96.0, 96.0, 149.0, 152.0], "value": 120.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 135.0, 100.0, 102.0, 120.0, 87.0, 145.0, 133.0, 79.0], "value": 104.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 57.0, 60.0, 60.0, 60.0, 59.0, 59.0, 58.0], "value": 58.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 76.0, 73.0, 83.0, 77.0, 75.0, 73.0, 73.0, 77.0, 74.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 88.0, 86.0, 88.0, 90.0, 102.0, 107.0, 105.0, 72.0], "value": 90.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 155.0, 168.0, 161.0, 154.0, 172.0, 165.0, 161.0, 195.0, 169.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 171.0, 169.0, 165.0, 171.0, 169.0, 166.0, 176.0, 170.0, 174.0], "value": 170.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 66.0, 80.0, 91.0, 62.0, 75.0, 90.0, 95.0], "value": 76.3, "unit": "score"}]}]} 14:39:06 INFO - Return code: 0 14:39:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:39:07 ERROR - # TBPL SUCCESS # 14:39:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:39:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:39:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:39:07 INFO - 2016-11-15 14:39:07.027 screenresolution[1659:10383] starting screenresolution argv=screenresolution get 14:39:07 INFO - 2016-11-15 14:39:07.030 screenresolution[1659:10383] Display 0: 1600x1200x32@60 14:39:07 INFO - 2016-11-15 14:39:07.036 screenresolution[1660:10386] starting screenresolution argv=screenresolution list 14:39:07 INFO - Available Modes on Display 0 14:39:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:39:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:39:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:39:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:39:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:39:07 INFO - Intel Iris: 14:39:07 INFO - Chipset Model: Intel Iris 14:39:07 INFO - Type: GPU 14:39:07 INFO - Bus: Built-In 14:39:07 INFO - VRAM (Dynamic, Max): 1536 MB 14:39:07 INFO - Vendor: Intel (0x8086) 14:39:07 INFO - Device ID: 0x0a2e 14:39:07 INFO - Revision ID: 0x0009 14:39:07 INFO - Displays: 14:39:07 INFO - Display: 14:39:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:39:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:39:07 INFO - Display Serial Number: 1600x1200 60 14:39:07 INFO - Main Display: Yes 14:39:07 INFO - Mirror: Off 14:39:07 INFO - Online: Yes 14:39:07 INFO - Rotation: Supported 14:39:07 INFO - Return code: 0 14:39:07 INFO - Running post-action listener: _resource_record_post_action 14:39:07 INFO - [mozharness: 2016-11-15 22:39:07.275578Z] Finished run-tests step (success) 14:39:07 INFO - Running post-run listener: _resource_record_post_run 14:39:07 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 37434368; Write bytes: 658537472; Read time: 238; Write time: 1944 14:39:07 INFO - TinderboxPrint: CPU usage
54.5% 14:39:07 INFO - TinderboxPrint: I/O read bytes / time
37,434,368 / 238 14:39:07 INFO - TinderboxPrint: I/O write bytes / time
658,537,472 / 1,944 14:39:07 INFO - TinderboxPrint: CPU idle
2,201.7 (45.5%) 14:39:07 INFO - TinderboxPrint: CPU system
986.0 (20.4%) 14:39:07 INFO - TinderboxPrint: CPU user
1,654.1 (34.2%) 14:39:07 INFO - TinderboxPrint: Swap in / out
390,344,704 / 0 14:39:07 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 354191872; Write bytes: 357750784; Read time: 27609; Write time: 794 14:39:07 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 34395136; Write bytes: 298176000; Read time: 215; Write time: 1137 14:39:07 INFO - Running post-run listener: _upload_blobber_files 14:39:07 INFO - Blob upload gear active. 14:39:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:39:07 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 14:39:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:39:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:39:08 INFO - (blobuploader) - INFO - Open directory for files ... 14:39:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:39:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:39:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:39:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:39:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:39:09 INFO - (blobuploader) - INFO - Done attempting. 14:39:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:39:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:39:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:39:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:39:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:39:10 INFO - (blobuploader) - INFO - Done attempting. 14:39:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:39:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:39:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:39:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:39:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:39:12 INFO - (blobuploader) - INFO - Done attempting. 14:39:12 INFO - (blobuploader) - INFO - Iteration through files over. 14:39:12 INFO - Return code: 0 14:39:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:39:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:39:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bac0f6bb36be561ae3e175a9576c59a701b80fc0c4a552119530bf7b411deff7eaea7f3a7ecae1d6d2ab7aa9d37d04ad76c10731215c9b8e97d2b8c149c05f88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/76c385833bb56f4a343c1267d6163da66a5d8d6fbfe8694e27d2e8f497c286495934841c9902b75eb8c510f7d4c31367261015043f6cc44f3de91b450ef31b10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e986c451cd2b6e5631d45d2bc4b07a646806a21174b2b6ddab25bd9ee26e1d7c68b63be169c2c578218ad58a79cb0d62e38925a5dc4aaa68029a78d58b2248ab"} 14:39:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:39:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:39:12 INFO - Contents: 14:39:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bac0f6bb36be561ae3e175a9576c59a701b80fc0c4a552119530bf7b411deff7eaea7f3a7ecae1d6d2ab7aa9d37d04ad76c10731215c9b8e97d2b8c149c05f88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/76c385833bb56f4a343c1267d6163da66a5d8d6fbfe8694e27d2e8f497c286495934841c9902b75eb8c510f7d4c31367261015043f6cc44f3de91b450ef31b10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e986c451cd2b6e5631d45d2bc4b07a646806a21174b2b6ddab25bd9ee26e1d7c68b63be169c2c578218ad58a79cb0d62e38925a5dc4aaa68029a78d58b2248ab"} 14:39:12 INFO - Running post-run listener: copy_logs_to_upload_dir 14:39:12 INFO - Copying logs to upload dir... 14:39:12 INFO - mkdir: /builds/slave/test/build/upload/logs 14:39:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.113151 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-11-15 14:39:12.803479) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 14:39:12.806758) ========= 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.FpiLYFdkYU/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.uoQR3SjNf8/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bac0f6bb36be561ae3e175a9576c59a701b80fc0c4a552119530bf7b411deff7eaea7f3a7ecae1d6d2ab7aa9d37d04ad76c10731215c9b8e97d2b8c149c05f88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/76c385833bb56f4a343c1267d6163da66a5d8d6fbfe8694e27d2e8f497c286495934841c9902b75eb8c510f7d4c31367261015043f6cc44f3de91b450ef31b10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e986c451cd2b6e5631d45d2bc4b07a646806a21174b2b6ddab25bd9ee26e1d7c68b63be169c2c578218ad58a79cb0d62e38925a5dc4aaa68029a78d58b2248ab"} build_url:https://queue.taskcluster.net/v1/task/HdnhV3ZmRi64iAGZpVSh4w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010763 build_url: 'https://queue.taskcluster.net/v1/task/HdnhV3ZmRi64iAGZpVSh4w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bac0f6bb36be561ae3e175a9576c59a701b80fc0c4a552119530bf7b411deff7eaea7f3a7ecae1d6d2ab7aa9d37d04ad76c10731215c9b8e97d2b8c149c05f88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/76c385833bb56f4a343c1267d6163da66a5d8d6fbfe8694e27d2e8f497c286495934841c9902b75eb8c510f7d4c31367261015043f6cc44f3de91b450ef31b10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e986c451cd2b6e5631d45d2bc4b07a646806a21174b2b6ddab25bd9ee26e1d7c68b63be169c2c578218ad58a79cb0d62e38925a5dc4aaa68029a78d58b2248ab"}' ========= master_lag: 0.59 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 14:39:13.406870) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 14:39:13.407195) ========= 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.FpiLYFdkYU/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.uoQR3SjNf8/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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.005146 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 14:39:13.432601) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 14:39:13.432871) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 14:39:13.433156) ========= ========= Total master_lag: 0.76 =========