builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0111 starttime: 1476345294.69 results: success (0) buildid: 20161012235124 builduid: 2479c69aff984630a05ddba7bef0987c revision: 604ee41918125b1287978e3193a93bc99791ff47 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 00:54:54.691676) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 00:54:54.692111) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 00:54:54.692396) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 00:54:54.717422) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 00:54:54.717889) ========= 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.0OjNNbiZXj/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.WdaGyDBGYP/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-13 00:54:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 166M=0s 2016-10-13 00:54:54 (166 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134948 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 00:54:54.875862) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 00:54:54.876190) ========= 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.0OjNNbiZXj/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.WdaGyDBGYP/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.028793 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 00:54:54.925106) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-13 00:54:54.925565) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 604ee41918125b1287978e3193a93bc99791ff47 --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 604ee41918125b1287978e3193a93bc99791ff47 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0OjNNbiZXj/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.WdaGyDBGYP/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-13 00:54:55,002 truncating revision to first 12 chars 2016-10-13 00:54:55,002 Setting DEBUG logging. 2016-10-13 00:54:55,002 attempt 1/10 2016-10-13 00:54:55,002 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/604ee4191812?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 00:54:57,067 unpacking tar archive at: mozilla-aurora-604ee4191812/testing/mozharness/ program finished with exit code 0 elapsedTime=2.346324 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-13 00:54:57.291327) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 00:54:57.291676) ========= script_repo_revision: 604ee41918125b1287978e3193a93bc99791ff47 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 00:54:57.292113) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 00:54:57.292482) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 00:54:57.311654) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-13 00:54:57.312051) ========= /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.0OjNNbiZXj/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.WdaGyDBGYP/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 00:54:57 INFO - MultiFileLogger online at 20161013 00:54:57 in /builds/slave/test 00:54:57 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 00:54:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:54:57 INFO - {'append_to_log': False, 00:54:57 INFO - 'base_work_dir': '/builds/slave/test', 00:54:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 00:54:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:54:57 INFO - 'branch': 'Mozilla-Aurora', 00:54:57 INFO - 'buildbot_json_path': 'buildprops.json', 00:54:57 INFO - 'config_files': ('talos/mac_config.py',), 00:54:57 INFO - 'default_actions': ('clobber', 00:54:57 INFO - 'read-buildbot-config', 00:54:57 INFO - 'download-and-extract', 00:54:57 INFO - 'populate-webroot', 00:54:57 INFO - 'create-virtualenv', 00:54:57 INFO - 'install', 00:54:57 INFO - 'run-tests'), 00:54:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:54:57 INFO - 'download_minidump_stackwalk': True, 00:54:57 INFO - 'download_symbols': 'ondemand', 00:54:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:54:57 INFO - 'tooltool.py': '/tools/tooltool.py', 00:54:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:54:57 INFO - '/tools/misc-python/virtualenv.py')}, 00:54:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:54:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:54:57 INFO - 'installer_path': 'installer.exe', 00:54:57 INFO - 'log_level': 'info', 00:54:57 INFO - 'log_name': 'talos', 00:54:57 INFO - 'log_to_console': True, 00:54:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:54:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:54:57 INFO - 'opt_config_files': (), 00:54:57 INFO - 'pip_index': False, 00:54:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:54:57 INFO - 'cmd': ('bash', 00:54:57 INFO - '-c', 00:54:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:54:57 INFO - 'enabled': True, 00:54:57 INFO - 'halt_on_failure': False, 00:54:57 INFO - 'name': 'check_screen_resolution'},), 00:54:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:54:57 INFO - 'cmd': ('bash', 00:54:57 INFO - '-c', 00:54:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:54:57 INFO - 'enabled': True, 00:54:57 INFO - 'halt_on_failure': False, 00:54:57 INFO - 'name': 'check_screen_resolution'},), 00:54:57 INFO - 'run_cmd_checks_enabled': True, 00:54:57 INFO - 'sps_profile': False, 00:54:57 INFO - 'sps_profile_interval': 0, 00:54:57 INFO - 'suite': 'dromaeojs-e10s', 00:54:57 INFO - 'system_bits': '32', 00:54:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:54:57 INFO - 'title': 't-yosemite-r7-0111', 00:54:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:54:57 INFO - 'use_talos_json': True, 00:54:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:54:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:54:57 INFO - 'work_dir': 'build'} 00:54:57 INFO - [mozharness: 2016-10-13 07:54:57.512196Z] Running clobber step. 00:54:57 INFO - Running pre-action listener: _resource_record_pre_action 00:54:57 INFO - Running main action method: clobber 00:54:57 INFO - rmtree: /builds/slave/test/build 00:54:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:54:59 INFO - Running post-action listener: _resource_record_post_action 00:54:59 INFO - [mozharness: 2016-10-13 07:54:59.762485Z] Finished clobber step (success) 00:54:59 INFO - [mozharness: 2016-10-13 07:54:59.762604Z] Running read-buildbot-config step. 00:54:59 INFO - Running pre-action listener: _resource_record_pre_action 00:54:59 INFO - Running main action method: read_buildbot_config 00:54:59 INFO - Using buildbot properties: 00:54:59 INFO - { 00:54:59 INFO - "project": "", 00:54:59 INFO - "product": "firefox", 00:54:59 INFO - "script_repo_revision": "production", 00:54:59 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 00:54:59 INFO - "repository": "", 00:54:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 00:54:59 INFO - "buildid": "20161012235124", 00:54:59 INFO - "pgo_build": "False", 00:54:59 INFO - "basedir": "/builds/slave/test", 00:54:59 INFO - "buildnumber": 0, 00:54:59 INFO - "slavename": "t-yosemite-r7-0111", 00:54:59 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 00:54:59 INFO - "platform": "yosemite_r7", 00:54:59 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 00:54:59 INFO - "branch": "mozilla-aurora", 00:54:59 INFO - "repo_path": "releases/mozilla-aurora", 00:54:59 INFO - "revision": "604ee41918125b1287978e3193a93bc99791ff47", 00:54:59 INFO - "stage_platform": "macosx64", 00:54:59 INFO - "builduid": "2479c69aff984630a05ddba7bef0987c", 00:54:59 INFO - "slavebuilddir": "test" 00:54:59 INFO - } 00:54:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/GnmLZ4UZT7uY1SQDtIbKwg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 00:54:59 INFO - Running post-action listener: _resource_record_post_action 00:54:59 INFO - [mozharness: 2016-10-13 07:54:59.765776Z] Finished read-buildbot-config step (success) 00:54:59 INFO - [mozharness: 2016-10-13 07:54:59.765880Z] Running download-and-extract step. 00:54:59 INFO - Running pre-action listener: _resource_record_pre_action 00:54:59 INFO - Running main action method: download_and_extract 00:54:59 INFO - mkdir: /builds/slave/test/build/tests 00:54:59 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')]} 00:54:59 INFO - trying https://queue.taskcluster.net/v1/task/GnmLZ4UZT7uY1SQDtIbKwg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 00:54:59 INFO - Downloading https://queue.taskcluster.net/v1/task/GnmLZ4UZT7uY1SQDtIbKwg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 00:54:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GnmLZ4UZT7uY1SQDtIbKwg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 00:55:00 INFO - Downloaded 1199 bytes. 00:55:00 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 00:55:00 INFO - Using the following test package requirements: 00:55:00 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 00:55:00 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 00:55:00 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 00:55:00 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 00:55:00 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 00:55:00 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 00:55:00 INFO - u'jsshell-mac.zip'], 00:55:00 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 00:55:00 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 00:55:00 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 00:55:00 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 00:55:00 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 00:55:00 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 00:55:00 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 00:55:00 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 00:55:00 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 00:55:00 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 00:55:00 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 00:55:00 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 00:55:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GnmLZ4UZT7uY1SQDtIbKwg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 00:55:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GnmLZ4UZT7uY1SQDtIbKwg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 00:55:00 INFO - Fetch https://queue.taskcluster.net/v1/task/GnmLZ4UZT7uY1SQDtIbKwg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 00:55:01 INFO - Expected file size: 16434916 00:55:08 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 00:55:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GnmLZ4UZT7uY1SQDtIbKwg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 00:55:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GnmLZ4UZT7uY1SQDtIbKwg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 00:55:08 INFO - Fetch https://queue.taskcluster.net/v1/task/GnmLZ4UZT7uY1SQDtIbKwg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 00:55:09 INFO - Expected file size: 16434916 00:55:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GnmLZ4UZT7uY1SQDtIbKwg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 00:55:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GnmLZ4UZT7uY1SQDtIbKwg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 00:55:15 INFO - Fetch https://queue.taskcluster.net/v1/task/GnmLZ4UZT7uY1SQDtIbKwg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 00:55:16 INFO - Expected file size: 14414059 00:55:17 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')]} 00:55:17 INFO - trying https://queue.taskcluster.net/v1/task/GnmLZ4UZT7uY1SQDtIbKwg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 00:55:17 INFO - Downloading https://queue.taskcluster.net/v1/task/GnmLZ4UZT7uY1SQDtIbKwg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 00:55:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GnmLZ4UZT7uY1SQDtIbKwg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 00:55:20 INFO - Downloaded 115371644 bytes. 00:55:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GnmLZ4UZT7uY1SQDtIbKwg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 00:55:20 INFO - mkdir: /builds/slave/test/properties 00:55:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:55:20 INFO - Writing to file /builds/slave/test/properties/build_url 00:55:20 INFO - Contents: 00:55:20 INFO - build_url:https://queue.taskcluster.net/v1/task/GnmLZ4UZT7uY1SQDtIbKwg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 00:55:20 INFO - Running post-action listener: _resource_record_post_action 00:55:20 INFO - Running post-action listener: set_extra_try_arguments 00:55:20 INFO - [mozharness: 2016-10-13 07:55:20.855291Z] Finished download-and-extract step (success) 00:55:20 INFO - [mozharness: 2016-10-13 07:55:20.855416Z] Running populate-webroot step. 00:55:20 INFO - Running pre-action listener: _resource_record_pre_action 00:55:20 INFO - Running main action method: populate_webroot 00:55:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:55:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:55:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:55:20 INFO - '--tppagecycles', 00:55:20 INFO - '7'], 00:55:20 INFO - 'tests': ['tsvgm']}}, 00:55:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:55:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:55:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:55:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:55:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:55:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:55:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:20 INFO - 'talos_options': ['--disable-e10s'], 00:55:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:55:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:55:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:20 INFO - 'talos_options': ['--disable-e10s'], 00:55:20 INFO - 'tests': ['damp', 'tps']}, 00:55:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:20 INFO - 'tests': ['damp', 'tps']}, 00:55:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:55:20 INFO - 'tests': ['dromaeo_dom']}, 00:55:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:55:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:55:20 INFO - 'tests': ['basic_compositor_video']}, 00:55:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:55:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:55:20 INFO - 'tests': ['a11yr', 00:55:20 INFO - 'ts_paint', 00:55:20 INFO - 'tpaint', 00:55:20 INFO - 'sessionrestore', 00:55:20 INFO - 'sessionrestore_no_auto_restore', 00:55:20 INFO - 'tabpaint']}, 00:55:20 INFO - 'other-e10s': {'tests': ['a11yr', 00:55:20 INFO - 'ts_paint', 00:55:20 INFO - 'tpaint', 00:55:20 INFO - 'sessionrestore', 00:55:20 INFO - 'sessionrestore_no_auto_restore', 00:55:20 INFO - 'tabpaint']}, 00:55:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:55:20 INFO - 'ts_paint', 00:55:20 INFO - 'tpaint', 00:55:20 INFO - 'sessionrestore', 00:55:20 INFO - 'sessionrestore_no_auto_restore', 00:55:20 INFO - 'tabpaint']}, 00:55:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:55:20 INFO - 'ts_paint', 00:55:20 INFO - 'tpaint', 00:55:20 INFO - 'sessionrestore', 00:55:20 INFO - 'sessionrestore_no_auto_restore', 00:55:20 INFO - 'tabpaint']}, 00:55:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:55:20 INFO - 'tests': ['a11yr', 00:55:20 INFO - 'ts_paint', 00:55:20 INFO - 'tpaint', 00:55:20 INFO - 'sessionrestore', 00:55:20 INFO - 'sessionrestore_no_auto_restore', 00:55:20 INFO - 'tabpaint']}, 00:55:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:55:20 INFO - 'tests': ['a11yr', 00:55:20 INFO - 'ts_paint', 00:55:20 INFO - 'tpaint', 00:55:20 INFO - 'sessionrestore', 00:55:20 INFO - 'sessionrestore_no_auto_restore', 00:55:20 INFO - 'tabpaint']}, 00:55:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:55:20 INFO - 'tests': ['tsvgx', 00:55:20 INFO - 'tsvgr_opacity', 00:55:20 INFO - 'tart', 00:55:20 INFO - 'tscrollx', 00:55:20 INFO - 'cart']}, 00:55:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:55:20 INFO - 'tsvgr_opacity', 00:55:20 INFO - 'tart', 00:55:20 INFO - 'tscrollx', 00:55:20 INFO - 'cart']}, 00:55:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:20 INFO - 'talos_options': ['--disable-e10s'], 00:55:20 INFO - 'tests': ['tp5o']}, 00:55:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:20 INFO - 'tests': ['tp5o']}, 00:55:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:20 INFO - 'talos_options': ['--disable-e10s', 00:55:20 INFO - '--xperf_path', 00:55:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:55:20 INFO - 'tests': ['tp5n']}, 00:55:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:20 INFO - 'talos_options': ['--xperf_path', 00:55:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:55:20 INFO - 'tests': ['tp5n']}}, 00:55:20 INFO - 'talos.zip': {'path': '', 00:55:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:55:20 INFO - Running post-action listener: _resource_record_post_action 00:55:20 INFO - [mozharness: 2016-10-13 07:55:20.873885Z] Finished populate-webroot step (success) 00:55:20 INFO - [mozharness: 2016-10-13 07:55:20.874024Z] Running create-virtualenv step. 00:55:20 INFO - Running pre-action listener: _resource_record_pre_action 00:55:20 INFO - Running main action method: create_virtualenv 00:55:20 INFO - Creating virtualenv /builds/slave/test/build/venv 00:55:20 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 00:55:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:55:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:55:21 INFO - Using real prefix '/tools/python27' 00:55:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:55:21 INFO - Installing distribute.............................................................................................................................................................................................done. 00:55:24 INFO - Installing pip.................done. 00:55:24 INFO - Return code: 0 00:55:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:55:24 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')]} 00:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:24 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')]} 00:55:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:24 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 0x10d6fb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d671570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ba34a57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d50fd30>, '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 0x10d375db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d507b20>, '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.0OjNNbiZXj/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.WdaGyDBGYP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 00:55:24 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 00:55:24 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 00:55:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0OjNNbiZXj/Render', 00:55:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:55:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:55:24 INFO - 'HOME': '/Users/cltbld', 00:55:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:55:24 INFO - 'LOGNAME': 'cltbld', 00:55:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:24 INFO - 'MOZ_NO_REMOTE': '1', 00:55:24 INFO - 'NO_EM_RESTART': '1', 00:55:24 INFO - 'PAGER': '/bin/cat', 00:55:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:55:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:24 INFO - 'PWD': '/builds/slave/test', 00:55:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:55:24 INFO - 'SHELL': '/bin/bash', 00:55:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WdaGyDBGYP/Listeners', 00:55:24 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 00:55:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:55:24 INFO - 'USER': 'cltbld', 00:55:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:55:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:55:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:24 INFO - 'XPC_FLAGS': '0x0', 00:55:24 INFO - 'XPC_SERVICE_NAME': '0', 00:55:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:55:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:24 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 00:55:24 INFO - Cleaning up... 00:55:24 INFO - Return code: 0 00:55:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:55:24 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')]} 00:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:24 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')]} 00:55:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:24 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 0x10d6fb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d671570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ba34a57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d50fd30>, '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 0x10d375db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d507b20>, '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.0OjNNbiZXj/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.WdaGyDBGYP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 00:55:24 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 00:55:24 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 00:55:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0OjNNbiZXj/Render', 00:55:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:55:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:55:24 INFO - 'HOME': '/Users/cltbld', 00:55:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:55:24 INFO - 'LOGNAME': 'cltbld', 00:55:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:24 INFO - 'MOZ_NO_REMOTE': '1', 00:55:24 INFO - 'NO_EM_RESTART': '1', 00:55:24 INFO - 'PAGER': '/bin/cat', 00:55:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:55:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:24 INFO - 'PWD': '/builds/slave/test', 00:55:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:55:24 INFO - 'SHELL': '/bin/bash', 00:55:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WdaGyDBGYP/Listeners', 00:55:24 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 00:55:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:55:24 INFO - 'USER': 'cltbld', 00:55:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:55:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:55:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:24 INFO - 'XPC_FLAGS': '0x0', 00:55:24 INFO - 'XPC_SERVICE_NAME': '0', 00:55:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:55:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:25 INFO - Downloading/unpacking psutil>=3.1.1 00:55:25 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 00:55:25 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 00:55:25 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 00:55:25 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 00:55:25 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 00:55:25 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 00:55:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:55:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:55:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:55:28 INFO - Installing collected packages: psutil 00:55:28 INFO - Running setup.py install for psutil 00:55:28 INFO - building 'psutil._psutil_osx' extension 00:55:28 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 00:55:29 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 00:55:29 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 00:55:29 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 00:55:29 INFO - building 'psutil._psutil_posix' extension 00:55:29 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 00:55:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:55:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:55:29 INFO - ^ 00:55:29 INFO - 1 warning generated. 00:55:29 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 00:55:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:55:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:55:29 INFO - Successfully installed psutil 00:55:29 INFO - Cleaning up... 00:55:29 INFO - Return code: 0 00:55:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:55:29 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')]} 00:55:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:29 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')]} 00:55:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:29 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 0x10d6fb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d671570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ba34a57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d50fd30>, '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 0x10d375db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d507b20>, '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.0OjNNbiZXj/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.WdaGyDBGYP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 00:55:29 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 00:55:29 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 00:55:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0OjNNbiZXj/Render', 00:55:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:55:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:55:29 INFO - 'HOME': '/Users/cltbld', 00:55:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:55:29 INFO - 'LOGNAME': 'cltbld', 00:55:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:29 INFO - 'MOZ_NO_REMOTE': '1', 00:55:29 INFO - 'NO_EM_RESTART': '1', 00:55:29 INFO - 'PAGER': '/bin/cat', 00:55:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:55:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:29 INFO - 'PWD': '/builds/slave/test', 00:55:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:55:29 INFO - 'SHELL': '/bin/bash', 00:55:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WdaGyDBGYP/Listeners', 00:55:29 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 00:55:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:55:29 INFO - 'USER': 'cltbld', 00:55:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:55:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:55:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:29 INFO - 'XPC_FLAGS': '0x0', 00:55:29 INFO - 'XPC_SERVICE_NAME': '0', 00:55:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:55:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:55:29 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 00:55:29 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 00:55:29 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 00:55:29 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 00:55:29 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 00:55:29 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 00:55:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:55:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:55:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:55:32 INFO - Installing collected packages: mozsystemmonitor 00:55:32 INFO - Running setup.py install for mozsystemmonitor 00:55:32 INFO - Successfully installed mozsystemmonitor 00:55:32 INFO - Cleaning up... 00:55:32 INFO - Return code: 0 00:55:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:55: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')]} 00:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55: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')]} 00:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55: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', '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 0x10d6fb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d671570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ba34a57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d50fd30>, '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 0x10d375db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d507b20>, '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.0OjNNbiZXj/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.WdaGyDBGYP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 00:55: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:55: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 jsonschema==2.5.1 00:55:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0OjNNbiZXj/Render', 00:55:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:55:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:55:32 INFO - 'HOME': '/Users/cltbld', 00:55:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:55:32 INFO - 'LOGNAME': 'cltbld', 00:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:32 INFO - 'MOZ_NO_REMOTE': '1', 00:55:32 INFO - 'NO_EM_RESTART': '1', 00:55:32 INFO - 'PAGER': '/bin/cat', 00:55:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:32 INFO - 'PWD': '/builds/slave/test', 00:55:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:55:32 INFO - 'SHELL': '/bin/bash', 00:55:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WdaGyDBGYP/Listeners', 00:55:32 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 00:55:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:55:32 INFO - 'USER': 'cltbld', 00:55:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:55:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:32 INFO - 'XPC_FLAGS': '0x0', 00:55:32 INFO - 'XPC_SERVICE_NAME': '0', 00:55:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:32 INFO - Downloading/unpacking jsonschema==2.5.1 00:55: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 00:55: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 00:55: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 00:55: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 00:55: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 00:55: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 00:55:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:55:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:55:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:55:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:55:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:55:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:55:35 INFO - Downloading functools32-3.2.3-2.tar.gz 00:55:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:55:36 INFO - warning: no files found matching '*.txt' 00:55:36 INFO - no previously-included directories found matching 'build' 00:55:36 INFO - no previously-included directories found matching 'dist' 00:55:36 INFO - no previously-included directories found matching '.git*' 00:55:36 INFO - Installing collected packages: jsonschema, functools32 00:55:36 INFO - Running setup.py install for functools32 00:55:36 INFO - warning: no files found matching '*.txt' 00:55:36 INFO - no previously-included directories found matching 'build' 00:55:36 INFO - no previously-included directories found matching 'dist' 00:55:36 INFO - no previously-included directories found matching '.git*' 00:55:36 INFO - Successfully installed jsonschema functools32 00:55:36 INFO - Cleaning up... 00:55:36 INFO - Return code: 0 00:55:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:55:36 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')]} 00:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:36 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')]} 00:55:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:36 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 0x10d6fb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d671570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ba34a57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d50fd30>, '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 0x10d375db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d507b20>, '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.0OjNNbiZXj/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.WdaGyDBGYP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 00:55:36 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 00:55:36 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 00:55:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0OjNNbiZXj/Render', 00:55:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:55:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:55:36 INFO - 'HOME': '/Users/cltbld', 00:55:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:55:36 INFO - 'LOGNAME': 'cltbld', 00:55:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:36 INFO - 'MOZ_NO_REMOTE': '1', 00:55:36 INFO - 'NO_EM_RESTART': '1', 00:55:36 INFO - 'PAGER': '/bin/cat', 00:55:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:55:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:36 INFO - 'PWD': '/builds/slave/test', 00:55:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:55:36 INFO - 'SHELL': '/bin/bash', 00:55:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WdaGyDBGYP/Listeners', 00:55:36 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 00:55:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:55:36 INFO - 'USER': 'cltbld', 00:55:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:55:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:55:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:36 INFO - 'XPC_FLAGS': '0x0', 00:55:36 INFO - 'XPC_SERVICE_NAME': '0', 00:55:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:55:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:55:36 INFO - Cleaning up... 00:55:36 INFO - Return code: 0 00:55:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:55:36 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')]} 00:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:36 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')]} 00:55:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:36 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 0x10d6fb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d671570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ba34a57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d50fd30>, '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 0x10d375db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d507b20>, '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.0OjNNbiZXj/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.WdaGyDBGYP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 00:55:36 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 00:55:36 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 00:55:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0OjNNbiZXj/Render', 00:55:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:55:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:55:36 INFO - 'HOME': '/Users/cltbld', 00:55:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:55:36 INFO - 'LOGNAME': 'cltbld', 00:55:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:36 INFO - 'MOZ_NO_REMOTE': '1', 00:55:36 INFO - 'NO_EM_RESTART': '1', 00:55:36 INFO - 'PAGER': '/bin/cat', 00:55:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:55:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:36 INFO - 'PWD': '/builds/slave/test', 00:55:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:55:36 INFO - 'SHELL': '/bin/bash', 00:55:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WdaGyDBGYP/Listeners', 00:55:36 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 00:55:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:55:36 INFO - 'USER': 'cltbld', 00:55:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:55:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:55:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:36 INFO - 'XPC_FLAGS': '0x0', 00:55:36 INFO - 'XPC_SERVICE_NAME': '0', 00:55:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:55:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:36 INFO - Downloading/unpacking blobuploader==1.2.4 00:55: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 00:55: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 00:55: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 00:55: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 00:55: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 00:55: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 00:55:39 INFO - Downloading blobuploader-1.2.4.tar.gz 00:55:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:55:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:55: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 00:55: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 00:55: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 00:55: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 00:55: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 00:55: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 00:55:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:55:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:55:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:55:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:55:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:55:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:55:40 INFO - Downloading docopt-0.6.1.tar.gz 00:55:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:55:40 INFO - Installing collected packages: blobuploader, requests, docopt 00:55:40 INFO - Running setup.py install for blobuploader 00:55:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:55:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:55:40 INFO - Running setup.py install for requests 00:55:41 INFO - Running setup.py install for docopt 00:55:41 INFO - Successfully installed blobuploader requests docopt 00:55:41 INFO - Cleaning up... 00:55:41 INFO - Return code: 0 00:55:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:55:41 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')]} 00:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:41 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')]} 00:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:41 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 0x10d6fb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d671570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ba34a57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d50fd30>, '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 0x10d375db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d507b20>, '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.0OjNNbiZXj/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.WdaGyDBGYP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 00:55:41 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 00:55:41 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 00:55:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0OjNNbiZXj/Render', 00:55:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:55:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:55:41 INFO - 'HOME': '/Users/cltbld', 00:55:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:55:41 INFO - 'LOGNAME': 'cltbld', 00:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:41 INFO - 'MOZ_NO_REMOTE': '1', 00:55:41 INFO - 'NO_EM_RESTART': '1', 00:55:41 INFO - 'PAGER': '/bin/cat', 00:55:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:41 INFO - 'PWD': '/builds/slave/test', 00:55:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:55:41 INFO - 'SHELL': '/bin/bash', 00:55:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WdaGyDBGYP/Listeners', 00:55:41 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 00:55:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:55:41 INFO - 'USER': 'cltbld', 00:55:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:55:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:41 INFO - 'XPC_FLAGS': '0x0', 00:55:41 INFO - 'XPC_SERVICE_NAME': '0', 00:55:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:55:41 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-4NeeF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:55:41 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-1AdTWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:55:41 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-mJQABf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:55:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-rRsPS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:55:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-PVoy_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:55:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-ALiptb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:55:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-hctSZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:55:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-4QxeVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:55:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-3YhYLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:55:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-LwehCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:55:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-ITw7dB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:55:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-sjwQ8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:55:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-nnJaTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:55:43 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Y5GNSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:55:43 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-dDRcUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:55:43 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-53jBOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:55:43 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-sznvle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:55:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:55:43 INFO - Running setup.py install for manifestparser 00:55:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:55:43 INFO - Running setup.py install for mozcrash 00:55:43 INFO - Running setup.py install for mozdebug 00:55:43 INFO - Running setup.py install for mozdevice 00:55:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:55:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:55:44 INFO - Running setup.py install for mozfile 00:55:44 INFO - Running setup.py install for mozhttpd 00:55:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:55:44 INFO - Running setup.py install for mozinfo 00:55:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:55:44 INFO - Running setup.py install for mozInstall 00:55:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:55:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:55:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:55:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:55:44 INFO - Running setup.py install for mozleak 00:55:44 INFO - Running setup.py install for mozlog 00:55:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:55:44 INFO - Running setup.py install for moznetwork 00:55:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:55:45 INFO - Running setup.py install for mozprocess 00:55:45 INFO - Running setup.py install for mozprofile 00:55:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:55:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:55:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:55:45 INFO - Running setup.py install for mozrunner 00:55:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:55:45 INFO - Running setup.py install for mozscreenshot 00:55:45 INFO - Running setup.py install for moztest 00:55:45 INFO - Running setup.py install for mozversion 00:55:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:55:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:55:46 INFO - Cleaning up... 00:55:46 INFO - Return code: 0 00:55:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:46 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 0x10d6fb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d671570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ba34a57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d50fd30>, '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 0x10d375db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d507b20>, '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.0OjNNbiZXj/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.WdaGyDBGYP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 00:55:46 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 00:55:46 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 00:55:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0OjNNbiZXj/Render', 00:55:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:55:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:55:46 INFO - 'HOME': '/Users/cltbld', 00:55:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:55:46 INFO - 'LOGNAME': 'cltbld', 00:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:46 INFO - 'MOZ_NO_REMOTE': '1', 00:55:46 INFO - 'NO_EM_RESTART': '1', 00:55:46 INFO - 'PAGER': '/bin/cat', 00:55:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:46 INFO - 'PWD': '/builds/slave/test', 00:55:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:55:46 INFO - 'SHELL': '/bin/bash', 00:55:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WdaGyDBGYP/Listeners', 00:55:46 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 00:55:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:55:46 INFO - 'USER': 'cltbld', 00:55:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:55:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:46 INFO - 'XPC_FLAGS': '0x0', 00:55:46 INFO - 'XPC_SERVICE_NAME': '0', 00:55:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:55:46 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-LjjKsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:55:46 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)) 00:55:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:55:46 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-n9SPsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:55:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:55:46 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-YkbQDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:55:46 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)) 00:55:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:55:46 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-L04JTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:55:46 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)) 00:55:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:55:46 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-FriPJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:55:46 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)) 00:55:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:55:46 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-OIrR9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:55:46 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)) 00:55:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:55:46 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Ksm3mE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:55:47 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)) 00:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:55:47 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-4WppUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:55:47 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)) 00:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:55:47 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Wi3Pan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:55:47 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)) 00:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:55:47 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-CnhOqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:55:47 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)) 00:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:55:47 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-85RpHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:55:47 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)) 00:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:55:47 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-o_VsGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:55:47 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)) 00:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:55:47 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-xNl6yi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:55:47 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)) 00:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:55:47 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Oe2Gee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:55:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:55:47 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-D11VWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:55:47 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)) 00:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:55:47 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-XgzgCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:55:48 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)) 00:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:55:48 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-sncCps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:55:48 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)) 00:55:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:55:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:55:48 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)) 00:55:48 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)) 00:55:48 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)) 00:55:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:55:48 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 00:55:48 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 00:55:48 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 00:55:48 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 00:55:48 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 00:55:48 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 00:55:50 INFO - Downloading blessings-1.6.tar.gz 00:55:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:55:50 INFO - Installing collected packages: blessings 00:55:50 INFO - Running setup.py install for blessings 00:55:50 INFO - Successfully installed blessings 00:55:50 INFO - Cleaning up... 00:55:51 INFO - Return code: 0 00:55:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:55:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:55:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:55:51 INFO - Reading from file tmpfile_stdout 00:55:51 INFO - Current package versions: 00:55:51 INFO - blessings == 1.6 00:55:51 INFO - blobuploader == 1.2.4 00:55:51 INFO - docopt == 0.6.1 00:55:51 INFO - functools32 == 3.2.3-2 00:55:51 INFO - jsonschema == 2.5.1 00:55:51 INFO - manifestparser == 1.1 00:55:51 INFO - mozInstall == 1.12 00:55:51 INFO - mozcrash == 0.17 00:55:51 INFO - mozdebug == 0.1 00:55:51 INFO - mozdevice == 0.48 00:55:51 INFO - mozfile == 1.2 00:55:51 INFO - mozhttpd == 0.7 00:55:51 INFO - mozinfo == 0.9 00:55:51 INFO - mozleak == 0.1 00:55:51 INFO - mozlog == 3.4 00:55:51 INFO - moznetwork == 0.27 00:55:51 INFO - mozprocess == 0.23 00:55:51 INFO - mozprofile == 0.28 00:55:51 INFO - mozrunner == 6.12 00:55:51 INFO - mozscreenshot == 0.1 00:55:51 INFO - mozsystemmonitor == 0.3 00:55:51 INFO - moztest == 0.7 00:55:51 INFO - mozversion == 1.4 00:55:51 INFO - psutil == 3.1.1 00:55:51 INFO - requests == 1.2.3 00:55:51 INFO - wsgiref == 0.1.2 00:55:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:51 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 0x10d6fb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d671570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ba34a57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d50fd30>, '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 0x10d375db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d507b20>, '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.0OjNNbiZXj/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.WdaGyDBGYP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 00:55:51 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 00:55:51 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 00:55:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0OjNNbiZXj/Render', 00:55:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:55:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:55:51 INFO - 'HOME': '/Users/cltbld', 00:55:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:55:51 INFO - 'LOGNAME': 'cltbld', 00:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:51 INFO - 'MOZ_NO_REMOTE': '1', 00:55:51 INFO - 'NO_EM_RESTART': '1', 00:55:51 INFO - 'PAGER': '/bin/cat', 00:55:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:51 INFO - 'PWD': '/builds/slave/test', 00:55:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:55:51 INFO - 'SHELL': '/bin/bash', 00:55:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WdaGyDBGYP/Listeners', 00:55:51 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 00:55:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:55:51 INFO - 'USER': 'cltbld', 00:55:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:55:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:51 INFO - 'XPC_FLAGS': '0x0', 00:55:51 INFO - 'XPC_SERVICE_NAME': '0', 00:55:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:51 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)) 00:55:51 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)) 00:55:51 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)) 00:55:51 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)) 00:55:51 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)) 00:55:51 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)) 00:55:51 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)) 00:55:51 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)) 00:55:51 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)) 00:55:51 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)) 00:55:51 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)) 00:55:51 INFO - Cleaning up... 00:55:52 INFO - Return code: 0 00:55:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:52 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 0x10d6fb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d671570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ba34a57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d50fd30>, '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 0x10d375db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d507b20>, '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.0OjNNbiZXj/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.WdaGyDBGYP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 00:55:52 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 00:55:52 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 00:55:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0OjNNbiZXj/Render', 00:55:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:55:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:55:52 INFO - 'HOME': '/Users/cltbld', 00:55:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:55:52 INFO - 'LOGNAME': 'cltbld', 00:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:52 INFO - 'MOZ_NO_REMOTE': '1', 00:55:52 INFO - 'NO_EM_RESTART': '1', 00:55:52 INFO - 'PAGER': '/bin/cat', 00:55:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:52 INFO - 'PWD': '/builds/slave/test', 00:55:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:55:52 INFO - 'SHELL': '/bin/bash', 00:55:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WdaGyDBGYP/Listeners', 00:55:52 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 00:55:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:55:52 INFO - 'USER': 'cltbld', 00:55:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:55:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:52 INFO - 'XPC_FLAGS': '0x0', 00:55:52 INFO - 'XPC_SERVICE_NAME': '0', 00:55:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:55:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:55:52 INFO - Cleaning up... 00:55:52 INFO - Return code: 0 00:55:52 INFO - Running post-action listener: _resource_record_post_action 00:55:52 INFO - Running post-action listener: _start_resource_monitoring 00:55:52 INFO - Starting resource monitoring. 00:55:52 INFO - [mozharness: 2016-10-13 07:55:52.291409Z] Finished create-virtualenv step (success) 00:55:52 INFO - [mozharness: 2016-10-13 07:55:52.292364Z] Running install step. 00:55:52 INFO - Running pre-action listener: _resource_record_pre_action 00:55:52 INFO - Running main action method: install 00:55:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:55:52 INFO - Reading from file tmpfile_stdout 00:55:52 INFO - Detecting whether we're running mozinstall >=1.0... 00:55:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:55:52 INFO - Reading from file tmpfile_stdout 00:55:52 INFO - Output received: 00:55:52 INFO - Usage: mozinstall [options] installer 00:55:52 INFO - Options: 00:55:52 INFO - -h, --help show this help message and exit 00:55:52 INFO - -d DEST, --destination=DEST 00:55:52 INFO - Directory to install application into. [default: 00:55:52 INFO - "/builds/slave/test"] 00:55:52 INFO - --app=APP Application being installed. [default: firefox] 00:55:52 INFO - mkdir: /builds/slave/test/build/application 00:55:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 00:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 00:56:24 INFO - Reading from file tmpfile_stdout 00:56:24 INFO - Output received: 00:56:24 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 00:56:24 INFO - Running post-action listener: _resource_record_post_action 00:56:24 INFO - [mozharness: 2016-10-13 07:56:24.830197Z] Finished install step (success) 00:56:24 INFO - [mozharness: 2016-10-13 07:56:24.830343Z] Running run-tests step. 00:56:24 INFO - Running pre-action listener: _resource_record_pre_action 00:56:24 INFO - Running main action method: run_tests 00:56:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:56:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:56:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:56:24 INFO - 2016-10-13 00:56:24.845 screenresolution[1636:7523] starting screenresolution argv=screenresolution get 00:56:24 INFO - 2016-10-13 00:56:24.847 screenresolution[1636:7523] Display 0: 1600x1200x32@60 00:56:24 INFO - 2016-10-13 00:56:24.853 screenresolution[1637:7525] starting screenresolution argv=screenresolution list 00:56:24 INFO - Available Modes on Display 0 00:56:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:56:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:56:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:56:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:56:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:56:25 INFO - Intel Iris: 00:56:25 INFO - Chipset Model: Intel Iris 00:56:25 INFO - Type: GPU 00:56:25 INFO - Bus: Built-In 00:56:25 INFO - VRAM (Dynamic, Max): 1536 MB 00:56:25 INFO - Vendor: Intel (0x8086) 00:56:25 INFO - Device ID: 0x0a2e 00:56:25 INFO - Revision ID: 0x0009 00:56:25 INFO - Displays: 00:56:25 INFO - Display: 00:56:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:56:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:56:25 INFO - Display Serial Number: 1600x1200 60 00:56:25 INFO - Main Display: Yes 00:56:25 INFO - Mirror: Off 00:56:25 INFO - Online: Yes 00:56:25 INFO - Rotation: Supported 00:56:25 INFO - Return code: 0 00:56:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:56:25 INFO - Python 2.7.3 00:56:25 INFO - Return code: 0 00:56:25 INFO - grabbing minidump binary from tooltool 00:56:25 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')]} 00:56:25 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 0x10d50fd30>, '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 0x10d375db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d507b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:56:25 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 00:56:25 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 00:56:25 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 00:56:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:56:25 INFO - Return code: 0 00:56:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:56:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:56:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:56:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:56:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:56:25 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/GnmLZ4UZT7uY1SQDtIbKwg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--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 00:56:25 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/GnmLZ4UZT7uY1SQDtIbKwg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0111 --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 00:56:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0OjNNbiZXj/Render', 00:56:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:56:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:56:25 INFO - 'HOME': '/Users/cltbld', 00:56:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:56:25 INFO - 'LOGNAME': 'cltbld', 00:56:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:56:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:25 INFO - 'MOZ_NO_REMOTE': '1', 00:56:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:56:25 INFO - 'NO_EM_RESTART': '1', 00:56:25 INFO - 'PAGER': '/bin/cat', 00:56:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:25 INFO - 'PWD': '/builds/slave/test', 00:56:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:56:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:56:25 INFO - 'SHELL': '/bin/bash', 00:56:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WdaGyDBGYP/Listeners', 00:56:25 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 00:56:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:56:25 INFO - 'USER': 'cltbld', 00:56:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:56:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:25 INFO - 'XPC_FLAGS': '0x0', 00:56:25 INFO - 'XPC_SERVICE_NAME': '0', 00:56:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:56:25 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/GnmLZ4UZT7uY1SQDtIbKwg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--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 00:56:25 INFO - mozversion application_buildid: 20161012235124 00:56:25 INFO - mozversion application_changeset: 604ee41918125b1287978e3193a93bc99791ff47 00:56:25 INFO - mozversion application_display_name: FirefoxDeveloperEdition 00:56:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:56:25 INFO - mozversion application_name: Firefox 00:56:25 INFO - mozversion application_remotingname: firefox-dev 00:56:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:56:25 INFO - mozversion application_vendor: Mozilla 00:56:25 INFO - mozversion application_version: 51.0a2 00:56:25 INFO - mozversion platform_buildid: 20161012235124 00:56:25 INFO - mozversion platform_changeset: 604ee41918125b1287978e3193a93bc99791ff47 00:56:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:56:25 INFO - mozversion platform_version: 51.0a2 00:56:25 INFO - using testdate: 1476345385 00:56:25 INFO - actual date: 1476345385 00:56:25 INFO - starting webserver on 'localhost:49267' 00:56:25 INFO - SUITE-START | Running 2 tests 00:56:25 INFO - TEST-START | dromaeo_css 00:56:25 INFO - operating with platform_type : mac_ 00:56:25 INFO - Initialising browser for dromaeo_css test... 00:56:25 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpfBfgYx/profile http://localhost:49267/getInfo.html) 00:56:28 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 00:56:28 INFO - PROCESS | 1647 | colorDepth:24 00:56:28 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 00:56:28 INFO - PROCESS | 1647 | __metrics 00:56:28 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 00:56:28 INFO - TEST-INFO | 1647: exit 0 00:56:28 INFO - Browser initialized. 00:56:28 INFO - Running cycle 1/1 for dromaeo_css test... 00:56:28 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpfBfgYx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:56:40 INFO - PROCESS | 1650 | RSS: Main: 225378304 00:56:40 INFO - PROCESS | 1650 | 00:57:30 INFO - PROCESS | 1650 | 1476345450593 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] 00:59:42 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 00:59:44 INFO - PROCESS | 1650 | RSS: Main: 236929024 00:59:44 INFO - PROCESS | 1650 | 01:02:46 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 01:02:46 INFO - PROCESS | 1650 | RSS: Main: 248938496 01:02:46 INFO - PROCESS | 1650 | 01:05:48 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 01:05:49 INFO - PROCESS | 1650 | RSS: Main: 251273216 01:05:49 INFO - PROCESS | 1650 | 01:08:51 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 01:08:51 INFO - PROCESS | 1650 | RSS: Main: 251523072 01:08:51 INFO - PROCESS | 1650 | 01:11:54 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 01:11:55 INFO - PROCESS | 1650 | RSS: Main: 256974848 01:11:55 INFO - PROCESS | 1650 | 01:14:57 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 01:14:58 INFO - PROCESS | 1650 | RSS: Main: 258691072 01:14:58 INFO - PROCESS | 1650 | 01:14:58 INFO - PROCESS | 1650 | __start_tp_report 01:14:58 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 01:14:58 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 01:14:58 INFO - PROCESS | 1650 | |i|pagename|runs| 01:14:58 INFO - PROCESS | 1650 | |0;dojo.html;3450.8274586270686;3465.116395319193;3471.1669199392154;3474.992252246848;3487.7384196185276;5878.853028674285;5949.25634295713;5967.224260846089;5974.253218347707;5974.402559744034;5892.351841297454;5897.233359663249;5929.140274660172;5980.88038239235;6002.549808764338;5323.893522129555;5387.326584176978;5393.083175860093;5415.729213539327;5454.318210223722;5428.185772134192;5436.619436639437;5440.646357986738;5442.12925931851;5450.31871016123;4952.678075925071;4976.377952755905;5317.627766056377;5364.517193452589;5430.268387442497;4400.537943515917;4470.307102399117;5338.492843179911;5385.5960802939935;5400.162974738922;5279.049771041211;5306.628536002481;5332.066888294533;5433.891322173535;5440.020796256672;5717.313922329306;5964.910526342108;5973.044312909914;6051.939480605181;6056.424639659225;6151.507879369639;6205.503559715212;6222.937770622327;6228.719707613168;6268.373162683695;6262.499000079983;6276.905846412307;6342.87314253717;6367.981123020295;6368.968155159241;5959.135925290809;6062.787802426894;6065.393460653988;6070.726817293233;6094.756209751649;5397.136458166675;5628.887422251532;5691.430856914359;6370.904436433457;6460.224773027267;6270.341614130451;6282.748690052346;6294.244690637152;6300.117983482316;6300.527460440485;6133.365267548864;6155.753769849156;6214.067889816563;6329.525285603599;6377.553571249968;6171.5988460750805;6220.657863817533;6240;6250.593711408744;6263.561550691499;6235.750569977241;6271.592346497463;6272.937270627326;6280.371962803683;6284.402981716729;4951.356323677899;5000.824971125993;5001.074801161724;5059.620528460307;5075;4456.68803183774;4486.7083639563325;4506.459224893034;4536.659750518725;4553.157665831765;6009.45914867664;6009.579329446984;6032.668203248863;6061.909071363845;6073.180120683651;6201.379862013762;6357.682115894187;6357.936420635827;6358.713857876314;6410.1987251593555;5870.3249126350165;5929.229200203946;5947.821565353046;5987.9101813472835;6080.361562035922;5529.557635389159;5529.695866727368;5557.527610153183;5564.8330550083565;5566.192902029183;6337.112804207414;6381.329960354189;6416.326285740117;6419.743210271537;6442.742290308429;6222.284437289589;6224.502039836711;6248.531360148098;6268.937310627018;6269.0909818075215;6379.5215358847345;6385.10608514799;6393.936060639334;6400.295967443484;6425.421712045938;6265.373462653698;6280.780172693934;6298.968505157445;6306.527010474325;6309.400606942333;4989.775460104376;6113.144159817718;6120.17377654011;6261.186045814015;6273.62358258506;6181.196444462371;6277.278113016879;6279.560430769802;6285.654289014148;6286.968565157145;6206.782762603287;6231.906521402092;6251.812445626639;6255.280642726145;6280.214973128359;5632.605717599728;5686.232358631697;6121.204243448323;6171.9074213887725;6208.192934918432;6167.444929956146;6204;6259.499240060693;6273.686315684106;6292.3078461368295;6176.783812566719;6177.598456100519;6190.288116866618;6197.380261973766;6224.035274532454 01:14:58 INFO - PROCESS | 1650 | |1;ext.html;489.00243503253364;498.0536979738494;510.3951817096739;520.9687418754872;530.8513616187469;37593.43609845851;41660.79169604148;41694.791526042405;41789.582104178946;41820.16359672808;31554.211144721336;32100.03699889007;33378.49932251018;41258.55595054174;42778.78610606951;9613.038696130383;9862.211023118169;9866.309358344919;9873.851892221623;9880;9780.804383912318;9865.457399843006;9895.208383329353;9910.20718342531;9929.056739609725;9913.35563188394;9920;9962.501874906262;9978.20174386051;9982.301238913278;8643.697470588562;9659.661911833087;9858.359206651545;9879.753006174831;9912.55393507294;9696.127348538595;9738.464384458852;9762.9511852441;9832;9833.31166818323;40378.79810600958;40468.595314046775;40914;40991.38512922308;41104.177916441506;3265.673432656739;3413.0784688134063;3437.1063523483826;3439.5528581284525;3864.188520410717;30585;30834.074977750704;31922.20194495133;32476.350472990645;33063.50404743931;3327.1349449143154;3332.350191712617;3339.4156022696175;3339.8664053437833;3388.81361525116;516408;518367;523880;523997;527344;67776;68911;69025;69095.65452172708;69375.3062469379;36685.81657091698;36903.81548092242;37495.62504374976;38934.415983760264;39014.4147837777;17632.471025869243;17840.910795446198;17876.821231787777;17885.7317140243;17924.103794810206;13439.462421503225;13499.662508437172;13501.189928604315;13501.729965400637;13537.932310338385;21018.579628407348;21177.576448471253;21295.254666086614;21300.78699213019;21337;7460.328570428687;9044.8643270351;9045.77385565366;9055;9068.410553314014;719.6829801463309;910.7358865928938;978.500964508106;1053.1364281289423;1067.5516283160935;21567.67648485274;27695.58456623112;29682.81268749226;30041.549376759365;30289.24276893051;1081.0324759340504;1093.1746531368924;1136.9147313951487;1152.1071169843271;1177.2877409167502;15526.990745601499;15904.681906362039;15939.36242550285;16214.918925405298;16233.756493652605;685104.1489585041;695601;697164;697556;698071;59458.70270648619;59983.700081499315;60699.69650151721;60888.08667869985;60933.78132437415;1174.7298121432118;1353.3098119958893;1383.557261676254;1394.979075313851;1402.3829515013565;24155.879220603783;31423.685763142075;32532.837335814118;32916.83541582277;33484.16289592682;47289.05421891612;58562.4143758574;58909.41090589039;59292.11061834162;59315.81368372695;633749;641384;641387;642042.9489262806;642627;44420.55579444293;44614.77692611646;45778;46062.07875842397;46285.76857115693;40377;48459;49206.50793492019;49384.76538086433;49618;40375;40421.797891010356;40784.79607601943;41025;42249.73250802481;40108.1978360437;40325.39511907265;40807.14805692086;41258.793706031276;41432.964175895846;38630.6136938627;39830.80084599558;39848.800755997196;39914.2017159661;41494;27630;29923.95266165674;30384.392312154076;35787;36500.26999460049;24157.637635435833;26088.8695556521;26513.469730604895;26559.734402655726;27024 01:14:58 INFO - PROCESS | 1650 | |2;jquery.html;378.10955200502815;378.32091395944275;383.925134598753;387.58721961111416;400.4293881219262;18648.160832762525;19623.90188049058;21092.367228983137;21333.25333613324;21362.038708258147;11457.427128643556;12045.217060891036;12060.396980151001;12068.336241506713;18958.336458223966;5324.54741346985;5632.7183640818;5635.971820140914;5641.12562552805;5663.575231857607;5324.307839980797;5466.453354664522;5518.641288316247;5541.556675465953;5632.493075623193;5378.623496355257;5459.836204913859;5494.752736126884;5511.724413779315;5519.917201241985;5236.869078273055;5408.783648654049;5990.790322338719;6113.388661133896;6183.690815459254;4633.4671512775785;5377.166539186433;5435.646682965595;5441.891162176735;5454.61817672763;13084.084114112016;13166.473341066347;13231.27228002469;13256.138351007154;13402.46390144393;2324.5467133908896;2347.976520234793;2349.6592994015773;2366.2782851230368;2370.4903445759073;9832.360896541773;10100.191984641284;10119.544620492095;10389.79220415595;10514.789704205874;1824.8722589418746;1824.9817501825078;1908.5610309628723;1920.9903950480298;1933.0914470199125;115331.42334288359;120975;126679;127511;128489;10022.3485473444;10045.79908401828;11829.053675705924;11874.46564904564;11994.640160795016;14832.851671483362;14856.405743770345;14870.256487175599;14897.404103835725;14918.776218356734;8540.615672294762;8822.955885220661;8848.380613357003;8890.155435233642;8915.242204412698;8809.344236265542;8815.515146666867;8831.425957312755;8953.194212520773;9039.050899655573;4486.1924853526025;4530.546945305443;4574.519675434098;4601.562851529099;4621.838235661736;1601.3594562175224;1711.6662250861211;1982.0585222019427;1985.0868600443957;1994.6436423232342;374.2141502844006;403.0769537758559;405.8234667919405;429.5554101504927;822.0751654388813;11547.422628868691;11785.3518056506;11809.350485723196;11918;12096.153269271243;366.83859101995034;434.6283927242226;436.3934131557138;442.25259311763017;451.821530495459;6000.129981152709;6136.693165341804;10929.071028962468;11701.590444334408;11734;647076;649342;654047;660205;660270;122414.38792805979;124756.37621812015;127621.3618931918;128272;128632;971.3589031239349;991.6231831903974;1008.742770593494;1015.1827778638119;1016.11090295991;15465;17483.737743933598;18830.24679012824;19414.708779368037;19498.805011950266;39002.804985974886;50636.24045639245;54992.45007549873;55395.16907246314;55727.721361392934;82601.58699206465;82852.58573707093;82913.17086829296;84944;85560;8184;8210.137935516923;11986.981106606036;12286.815697764361;12877.613671589866;12828.55100071493;13139.474421023053;13146.737065258832;13870.375833087333;14043.578692639237;11697.649070527897;11730.824037639613;11855.525778968744;11878.406079695807;12063.939680301542;11627.88372116268;11634.53461861516;11806.173567850168;11821.40892955366;12162.817557736464;8043.477173983672;8068.354531637572;11909.22590031645;11948.402579870797;12218.633440996784;12598.874011260137;12681.746365072462;12728.299943503196;12748.553800616934;12796.168249063781;11789.882101178879;11850.881491184979;11935.283882967049;12003.8654658483;12130.878691212974 01:14:58 INFO - PROCESS | 1650 | |3;mootools.html;1365.1331404558105;1517.8709809666177;1528.0984219310612;1702.4211767998877;1862.5902301493666;7979;8270.4624199427;8523.19029692179;9024;9060.592273347707;8462.323014158868;8796.78008049799;8823.95588022059;8891.555422228896;8971.506567138806;2383.4756353602265;2390.3546042568496;2400.2799160251943;2425.4057755849753;2434.160214725917;2396.364963284731;2412.107520217522;2415.9758402416014;2435.585950388438;2444.10790061628;2411.5176964607062;2417.295806456444;2425.4785221177444;2438.9512209755794;2442.9755702443013;2376.536575367804;2386.188695843413;2393.844400113987;2395.724491683444;2401.0515846240637;2222.766609506011;2275.442516583431;2368.360542653491;2385.8210634202333;2390.5816482115733;7561.432892533027;8942.150495702897;9004.729858104267;9006.234470070052;9009.144131307516;5000.949990500085;5049.2426136079885;5403.621746477748;5414.07960646687;5509.614326997112;3469.548958635361;3638.43604241343;3643.5081264029545;3649.5073165122635;3677.17263615687;1021.9386836789816;1065.6110519660347;1070.4968664727567;1113.8941800528937;1136.8919952604572;11641.76716465666;11735;11781.469833857496;11809.586664466702;11828.526858925632;3707.870224542182;3917.2948869203246;4250.808713607895;4293.914121717548;4907.411110666671;10018.949905250427;10105.797884042278;10118.241131915136;10120.342177758423;10134.645287414905;5410.783568657288;5461.644993075437;5474.2609747683555;5479.068558345091;5485.4788795064405;4415.801288942005;4584.33527138563;4850.442199147073;4970.751462426864;4998.400191976913;3719.702423806089;3880.8835734927998;4007.73949693269;4096.672266218696;4131.483564554431;1307.4247331174254;1315.0137396952287;1321.0818481155504;1327.7145413736093;1342.1142046249624;926.2543652359915;937.920276776468;943.3160958305311;946.682861241478;952.2953014769021;5754.280714910637;5896.557758168155;5947.167396564484;6128.019516877367;6191.040388739752;441.67978215793937;441.80118946474215;451.52815308003215;451.94124763781156;986.6645340584092;3944.822482988215;4042.9601881002623;4108.815103320298;4193.35003074524;4196.391523229115;10527.631532896312;10798.892011079946;10801.67594972152;10869.021788039114;10872.402017889091;10768.623098191525;10782.73043173927;10832.78334433307;10845;10870.347779133277;7759.30166285037;8102.594870256581;8190.303824175012;8233.8353232935;8299.99999999988;5897.764089436375;5952.107183922446;5985.910211346921;6080.452759251689;6111.847203819762;9821.607135714492;9939.453330066915;9968;10036.447995360326;10077.14344280715;9743.415395076318;10284.331518451278;10287.22845786584;10297.53661085238;10306.948465257627;6963.651817409211;7157.606331651809;7411.703531858665;7558.281963213486;7695.769126926201;8364.079951205242;8372.539510326747;8533.615987280464;8551.828963420821;8552.016518100498;7392.112946446461;7424.220456852169;7564.130125035691;7665.041869766279;7719.92280077192;7368.852622947618;7494.362979146834;7510.136334321623;7542.208068152765;7550.169481357156;6800.081988931431;6804.591724496546;6809.455243580601;6970.825729356807;6989.37095661393;5015.323490361622;5046.899062018812;5170.182250673317;5224.2947202127225;5251.658642188246;4574.199515084913;4946.961138161027;5075.264086707333;5176.197689358005;5179.48205179479 01:14:58 INFO - PROCESS | 1650 | |4;prototype.html;267.78175786733823;306.8895197728818;314.9889753858614;316.8130802826335;317.3684368107465;4663.463701674308;4939.57960599306;5246.317978662778;5623.409541998088;5666.631668941521;4367.519572846984;4606.608438282741;5069.695818250908;5326.520613144816;5553.4724201200925;4042.3330150525203;4198.097409057053;4281;4283.850065247717;4285.442892423996;3407.8466469008954;3808.371618682914;4151.8546850860075;4264.381664658623;4312.956870431302;3660.5790334111653;4224.345226489899;4224.788760561975;4232.957670423287;4253.553376895427;3470.4967779671933;3744.764227804818;3796.7152463565067;4210.242156411845;4224.38746381776;3701.648343407372;3703.6296370362747;3706.369917114097;3717.052151701299;3725.925481490355;5101.132807422747;5426.782928682848;5472.345912232564;5474.479924407175;5512.862178445531;4849.3453383793085;4850.514948505156;4856.465788763233;4859.740220797346;4870.488598697121;5349.983503134392;5442.91835622466;5860.150278209636;5980.744043750818;6103.230063281643;3345.866165353383;3739.925201495982;3948.6841052715713;3949.012746813297;3951.229510245503;4682.906341873144;5099.796008159669;5410.567154627621;5441.455854414567;6274.87450250997;3548.3967725486727;4011.910828661972;4020.2160578686876;4027.5368332641533;4043.6765058795227;3953.9011524711536;4015.357542793139;4088.8364465421646;4096.09885825118;4108.979455102705;4048.655864251513;4222.809973551198;4784.918560426226;4815.109204797053;4822.348982887335;4481.512760418;5185.844424667266;5805;6036.42653947883;6037.098314031066;1248.5630029489605;1299.4996926183487;1378.2281922123643;1378.2832926878168;1385.88220001301;737.7270409948246;819.4837252530867;835.5836856528126;837.7193640130503;845.2519520224522;4060.634542891154;4109.56849530795;4472.59746622799;4603.58567728906;4693.319468677023;4213.4522512073845;4693.043382668965;4775.2359622460235;5065.442801291855;5112.389597276846;3985.114513349461;4053.5541090480024;4112.018786379851;4661.254199328091;4686.74222917736;2604.9088281910044;2806.733360330765;3214.942436840424;3243.5459035735016;3263.2215442583847;6048.364921683248;6231.968840155861;6299.6850157491945;6344.302126766144;6379.671419931784;5155.871103222449;6073.51411887048;6133.478654314344;6212;6412.871742565216;5151.665141765773;5752.395998420189;6007.678310771623;6134.877302453926;6235.285296543487;4794.640401969936;5064.797408103635;5875.706214689334;5990.7903223386975;6107.4197951194565;5252.739342557835;5701.5505619101505;5852.385499522489;6008.648054187773;6036.215292012011;4967.230079337564;5850.765969361178;5890.263717035371;5963.703973969966;6206.162168107428;3067.831269280122;3788.204477059738;3994.840206391712;4014.8193331300745;4028.637422631977;5857.853553661193;6038.788642397495;6079.665618391031;6113.043825975645;6185.443310102112;5629.437056294338;5756.539476841759;5859.560532959959;5862.267216597926;5952.987992041277;5296.311479507639;5468.753906074316;5885.61743486672;5903.350631430625;5928.525717942641;5686.715664216856;5794.4205579443405;5811.7643533799;5835.045259837832;5851.414858514115;5900.822975310747;5932.644041357532;5945.762169513344;5969.611975221596;6001.969990150022;5687.639170419477;5828.970855145697;5843.853903652443;5885.588008839341;5902.5277977762535 01:14:58 INFO - PROCESS | 1650 | |5;yui.html;723.2044750774149;750.7297372945739;764.7132325377984;795.5664163031147;834.1366685480527;14891.255437228136;15484.380624775009;15532.378704851792;15536.22318884057;15649.530514084581;13150.473981040746;13162.736745265089;13207.6698082548;13213.207207567553;13319.733605327887;819.3035919468464;843.7679638099542;876.0932434929849;877.5656050255133;882.1707594860842;847.1697736218479;868.9261412779921;869.1742844297911;870.5473153959937;872.0538216035577;915.8488849339851;917.7200953709116;917.7659696777313;917.898521773874;921.4195057114042;854.8803167556547;908.3777612335538;909.5452273863068;916.6241840845222;917.3165991336464;499.4381321013859;621.1242148570539;659.4559488422024;682.1916029505053;682.1950098883316;14970.775438368433;15463.690726185525;15470.5358839235;15473.922630386889;15483.458078967295;11435.942820285845;14061.437542498288;14165.008449408546;14488.710225795425;14874.405023799036;10570.52432640533;11218.382988935606;11704.53181872724;11988.940055299754;12018.699532511757;3765.246950609889;3830.291396091732;3852.903677408059;3931.272714547818;3933.8819835404984;126483;129430.05854912184;130478;131350.34324828314;132563;10846.891531084588;11079.556817727362;11133.832992505118;11134.443277836075;11215.831762523569;22573.54852902933;22705;22797.430064248525;22992.4251893704;23108;7918.960405197937;7929.853595800801;7937.642806073741;7944.205579442125;7976.282134607914;3760.7555508891833;4284.614384705392;4302.247106756305;4396.296592545177;4517.141743068806;3405.438102713025;3464.393731097098;3498.4577390504514;3548.237129017222;3554.5023696682483;661.4576047640984;686.3959715450371;718.0916141081536;718.9676464559003;722.5664601239214;500.4495055438988;558.8770470496485;567.5573053018652;586.4253032028636;589.3428826858022;8462.661493540189;9232.522796352552;9581.856272155923;9640.75898102553;9649.372790768577;529.8577307233292;592.5911171089507;618.7061145955635;637.4067557185732;647.3267801486495;4292.91414171721;4321.7406955582765;4491.348754430589;4513.458384993756;4576.839810606612;162183;162191;164842;165099.1745041267;169372;129361.3531932353;139800;139912;141875;144014;70246.64876675584;78562.6071869637;99561.50219248858;117647;120544.3972780148;7198.71205151788;9131.269498439977;9362.157405833508;9380.67167649129;9571.521423928914;63148;63814.68092659507;64531.677341612994;64779;66947.66526167338;100332.49833750784;103114;103332.48333758283;104222.47888760507;105395;12475.251484910934;12719.80920286215;12836.358182091044;13086.018548609083;13611.319434028457;12039.337836419081;14045.929770351082;14682.33929473155;14755.040922340013;15547.766783498482;11871.99088077523;12643.241405515699;13177.538786142823;13460.788529032434;13655.931720341334;12948.611541653765;13551.53947125448;13612.251326177155;13838;13899.30503474802;12008.819867701817;12169.939150304192;12207.816882746589;12233.755324893631;12235.571754988532;9086.227670647804;10588.894111058791;10985.231033827555;11212.607558735404;11798.41007949582;8953.910460895308;9454.716358509255;10654.414007229367;11132.833007504732;11333.659990200307 01:14:58 INFO - PROCESS | 1650 | __end_tp_report 01:14:58 INFO - PROCESS | 1650 | __start_cc_report 01:14:58 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,361 01:14:58 INFO - PROCESS | 1650 | __end_cc_report 01:14:58 INFO - PROCESS | 1650 | __startTimestamp1476346498089__endTimestamp 01:14:58 INFO - PROCESS | 1650 | 01:14:58 INFO - PROCESS | 1650 | ------- Summary: start ------- 01:14:58 INFO - PROCESS | 1650 | Number of tests: 6 01:14:58 INFO - PROCESS | 1650 | 01:14:58 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5843.79 Median:6120.17 stddev:647.49 (10.6%) stddev-sans-first:621.67 01:14:58 INFO - PROCESS | 1650 | Values: 3450.8 3465.1 3471.2 3475.0 3487.7 5878.9 5949.3 5967.2 5974.3 5974.4 5892.4 5897.2 5929.1 5980.9 6002.5 5323.9 5387.3 5393.1 5415.7 5454.3 5428.2 5436.6 5440.6 5442.1 5450.3 4952.7 4976.4 5317.6 5364.5 5430.3 4400.5 4470.3 5338.5 5385.6 5400.2 5279.0 5306.6 5332.1 5433.9 5440.0 5717.3 5964.9 5973.0 6051.9 6056.4 6151.5 6205.5 6222.9 6228.7 6268.4 6262.5 6276.9 6342.9 6368.0 6369.0 5959.1 6062.8 6065.4 6070.7 6094.8 5397.1 5628.9 5691.4 6370.9 6460.2 6270.3 6282.7 6294.2 6300.1 6300.5 6133.4 6155.8 6214.1 6329.5 6377.6 6171.6 6220.7 6240.0 6250.6 6263.6 6235.8 6271.6 6272.9 6280.4 6284.4 4951.4 5000.8 5001.1 5059.6 5075.0 4456.7 4486.7 4506.5 4536.7 4553.2 6009.5 6009.6 6032.7 6061.9 6073.2 6201.4 6357.7 6357.9 6358.7 6410.2 5870.3 5929.2 5947.8 5987.9 6080.4 5529.6 5529.7 5557.5 5564.8 5566.2 6337.1 6381.3 6416.3 6419.7 6442.7 6222.3 6224.5 6248.5 6268.9 6269.1 6379.5 6385.1 6393.9 6400.3 6425.4 6265.4 6280.8 6299.0 6306.5 6309.4 4989.8 6113.1 6120.2 6261.2 6273.6 6181.2 6277.3 6279.6 6285.7 6287.0 6206.8 6231.9 6251.8 6255.3 6280.2 5632.6 5686.2 6121.2 6171.9 6208.2 6167.4 6204.0 6259.5 6273.7 6292.3 6176.8 6177.6 6190.3 6197.4 6224.0 01:14:58 INFO - PROCESS | 1650 | 01:14:58 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:74965.34 Median:41008.19 stddev:166796.56 (406.7%) stddev-sans-first:167170.73 01:14:58 INFO - PROCESS | 1650 | Values: 489.0 498.1 510.4 521.0 530.9 37593.4 41660.8 41694.8 41789.6 41820.2 31554.2 32100.0 33378.5 41258.6 42778.8 9613.0 9862.2 9866.3 9873.9 9880.0 9780.8 9865.5 9895.2 9910.2 9929.1 9913.4 9920.0 9962.5 9978.2 9982.3 8643.7 9659.7 9858.4 9879.8 9912.6 9696.1 9738.5 9763.0 9832.0 9833.3 40378.8 40468.6 40914.0 40991.4 41104.2 3265.7 3413.1 3437.1 3439.6 3864.2 30585.0 30834.1 31922.2 32476.4 33063.5 3327.1 3332.4 3339.4 3339.9 3388.8 516408.0 518367.0 523880.0 523997.0 527344.0 67776.0 68911.0 69025.0 69095.7 69375.3 36685.8 36903.8 37495.6 38934.4 39014.4 17632.5 17840.9 17876.8 17885.7 17924.1 13439.5 13499.7 13501.2 13501.7 13537.9 21018.6 21177.6 21295.3 21300.8 21337.0 7460.3 9044.9 9045.8 9055.0 9068.4 719.7 910.7 978.5 1053.1 1067.6 21567.7 27695.6 29682.8 30041.5 30289.2 1081.0 1093.2 1136.9 1152.1 1177.3 15527.0 15904.7 15939.4 16214.9 16233.8 685104.1 695601.0 697164.0 697556.0 698071.0 59458.7 59983.7 60699.7 60888.1 60933.8 1174.7 1353.3 1383.6 1395.0 1402.4 24155.9 31423.7 32532.8 32916.8 33484.2 47289.1 58562.4 58909.4 59292.1 59315.8 633749.0 641384.0 641387.0 642042.9 642627.0 44420.6 44614.8 45778.0 46062.1 46285.8 40377.0 48459.0 49206.5 49384.8 49618.0 40375.0 40421.8 40784.8 41025.0 42249.7 40108.2 40325.4 40807.1 41258.8 41433.0 38630.6 39830.8 39848.8 39914.2 41494.0 27630.0 29924.0 30384.4 35787.0 36500.3 24157.6 26088.9 26513.5 26559.7 27024.0 01:14:58 INFO - PROCESS | 1650 | 01:14:58 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:36189.11 Median:1983.57 stddev:108952.81 (5492.8%) stddev-sans-first:109225.27 01:14:58 INFO - PROCESS | 1650 | Values: 378.1 378.3 383.9 387.6 400.4 18648.2 19623.9 21092.4 21333.3 21362.0 11457.4 12045.2 12060.4 12068.3 18958.3 5324.5 5632.7 5636.0 5641.1 5663.6 5324.3 5466.5 5518.6 5541.6 5632.5 5378.6 5459.8 5494.8 5511.7 5519.9 5236.9 5408.8 5990.8 6113.4 6183.7 4633.5 5377.2 5435.6 5441.9 5454.6 13084.1 13166.5 13231.3 13256.1 13402.5 2324.5 2348.0 2349.7 2366.3 2370.5 9832.4 10100.2 10119.5 10389.8 10514.8 1824.9 1825.0 1908.6 1921.0 1933.1 115331.4 120975.0 126679.0 127511.0 128489.0 10022.3 10045.8 11829.1 11874.5 11994.6 14832.9 14856.4 14870.3 14897.4 14918.8 8540.6 8823.0 8848.4 8890.2 8915.2 8809.3 8815.5 8831.4 8953.2 9039.1 4486.2 4530.5 4574.5 4601.6 4621.8 1601.4 1711.7 1982.1 1985.1 1994.6 374.2 403.1 405.8 429.6 822.1 11547.4 11785.4 11809.4 11918.0 12096.2 366.8 434.6 436.4 442.3 451.8 6000.1 6136.7 10929.1 11701.6 11734.0 647076.0 649342.0 654047.0 660205.0 660270.0 122414.4 124756.4 127621.4 128272.0 128632.0 971.4 991.6 1008.7 1015.2 1016.1 15465.0 17483.7 18830.2 19414.7 19498.8 39002.8 50636.2 54992.5 55395.2 55727.7 82601.6 82852.6 82913.2 84944.0 85560.0 8184.0 8210.1 11987.0 12286.8 12877.6 12828.6 13139.5 13146.7 13870.4 14043.6 11697.6 11730.8 11855.5 11878.4 12063.9 11627.9 11634.5 11806.2 11821.4 12162.8 8043.5 8068.4 11909.2 11948.4 12218.6 12598.9 12681.7 12728.3 12748.6 12796.2 11789.9 11850.9 11935.3 12003.9 12130.9 01:14:58 INFO - PROCESS | 1650 | 01:14:58 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5736.92 Median:4579.27 stddev:3232.09 (70.6%) stddev-sans-first:3224.45 01:14:58 INFO - PROCESS | 1650 | Values: 1365.1 1517.9 1528.1 1702.4 1862.6 7979.0 8270.5 8523.2 9024.0 9060.6 8462.3 8796.8 8824.0 8891.6 8971.5 2383.5 2390.4 2400.3 2425.4 2434.2 2396.4 2412.1 2416.0 2435.6 2444.1 2411.5 2417.3 2425.5 2439.0 2443.0 2376.5 2386.2 2393.8 2395.7 2401.1 2222.8 2275.4 2368.4 2385.8 2390.6 7561.4 8942.2 9004.7 9006.2 9009.1 5000.9 5049.2 5403.6 5414.1 5509.6 3469.5 3638.4 3643.5 3649.5 3677.2 1021.9 1065.6 1070.5 1113.9 1136.9 11641.8 11735.0 11781.5 11809.6 11828.5 3707.9 3917.3 4250.8 4293.9 4907.4 10018.9 10105.8 10118.2 10120.3 10134.6 5410.8 5461.6 5474.3 5479.1 5485.5 4415.8 4584.3 4850.4 4970.8 4998.4 3719.7 3880.9 4007.7 4096.7 4131.5 1307.4 1315.0 1321.1 1327.7 1342.1 926.3 937.9 943.3 946.7 952.3 5754.3 5896.6 5947.2 6128.0 6191.0 441.7 441.8 451.5 451.9 986.7 3944.8 4043.0 4108.8 4193.4 4196.4 10527.6 10798.9 10801.7 10869.0 10872.4 10768.6 10782.7 10832.8 10845.0 10870.3 7759.3 8102.6 8190.3 8233.8 8300.0 5897.8 5952.1 5985.9 6080.5 6111.8 9821.6 9939.5 9968.0 10036.4 10077.1 9743.4 10284.3 10287.2 10297.5 10306.9 6963.7 7157.6 7411.7 7558.3 7695.8 8364.1 8372.5 8533.6 8551.8 8552.0 7392.1 7424.2 7564.1 7665.0 7719.9 7368.9 7494.4 7510.1 7542.2 7550.2 6800.1 6804.6 6809.5 6970.8 6989.4 5015.3 5046.9 5170.2 5224.3 5251.7 4574.2 4947.0 5075.3 5176.2 5179.5 01:14:58 INFO - PROCESS | 1650 | 01:14:58 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4623.09 Median:5016.01 stddev:1464.04 (29.2%) stddev-sans-first:1431.18 01:14:58 INFO - PROCESS | 1650 | Values: 267.8 306.9 315.0 316.8 317.4 4663.5 4939.6 5246.3 5623.4 5666.6 4367.5 4606.6 5069.7 5326.5 5553.5 4042.3 4198.1 4281.0 4283.9 4285.4 3407.8 3808.4 4151.9 4264.4 4313.0 3660.6 4224.3 4224.8 4233.0 4253.6 3470.5 3744.8 3796.7 4210.2 4224.4 3701.6 3703.6 3706.4 3717.1 3725.9 5101.1 5426.8 5472.3 5474.5 5512.9 4849.3 4850.5 4856.5 4859.7 4870.5 5350.0 5442.9 5860.2 5980.7 6103.2 3345.9 3739.9 3948.7 3949.0 3951.2 4682.9 5099.8 5410.6 5441.5 6274.9 3548.4 4011.9 4020.2 4027.5 4043.7 3953.9 4015.4 4088.8 4096.1 4109.0 4048.7 4222.8 4784.9 4815.1 4822.3 4481.5 5185.8 5805.0 6036.4 6037.1 1248.6 1299.5 1378.2 1378.3 1385.9 737.7 819.5 835.6 837.7 845.3 4060.6 4109.6 4472.6 4603.6 4693.3 4213.5 4693.0 4775.2 5065.4 5112.4 3985.1 4053.6 4112.0 4661.3 4686.7 2604.9 2806.7 3214.9 3243.5 3263.2 6048.4 6232.0 6299.7 6344.3 6379.7 5155.9 6073.5 6133.5 6212.0 6412.9 5151.7 5752.4 6007.7 6134.9 6235.3 4794.6 5064.8 5875.7 5990.8 6107.4 5252.7 5701.6 5852.4 6008.6 6036.2 4967.2 5850.8 5890.3 5963.7 6206.2 3067.8 3788.2 3994.8 4014.8 4028.6 5857.9 6038.8 6079.7 6113.0 6185.4 5629.4 5756.5 5859.6 5862.3 5953.0 5296.3 5468.8 5885.6 5903.4 5928.5 5686.7 5794.4 5811.8 5835.0 5851.4 5900.8 5932.6 5945.8 5969.6 6002.0 5687.6 5829.0 5843.9 5885.6 5902.5 01:14:58 INFO - PROCESS | 1650 | 01:14:58 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:26061.14 Median:3481.43 stddev:43164.32 (1239.8%) stddev-sans-first:43243.48 01:14:58 INFO - PROCESS | 1650 | Values: 723.2 750.7 764.7 795.6 834.1 14891.3 15484.4 15532.4 15536.2 15649.5 13150.5 13162.7 13207.7 13213.2 13319.7 819.3 843.8 876.1 877.6 882.2 847.2 868.9 869.2 870.5 872.1 915.8 917.7 917.8 917.9 921.4 854.9 908.4 909.5 916.6 917.3 499.4 621.1 659.5 682.2 682.2 14970.8 15463.7 15470.5 15473.9 15483.5 11435.9 14061.4 14165.0 14488.7 14874.4 10570.5 11218.4 11704.5 11988.9 12018.7 3765.2 3830.3 3852.9 3931.3 3933.9 126483.0 129430.1 130478.0 131350.3 132563.0 10846.9 11079.6 11133.8 11134.4 11215.8 22573.5 22705.0 22797.4 22992.4 23108.0 7919.0 7929.9 7937.6 7944.2 7976.3 3760.8 4284.6 4302.2 4396.3 4517.1 3405.4 3464.4 3498.5 3548.2 3554.5 661.5 686.4 718.1 719.0 722.6 500.4 558.9 567.6 586.4 589.3 8462.7 9232.5 9581.9 9640.8 9649.4 529.9 592.6 618.7 637.4 647.3 4292.9 4321.7 4491.3 4513.5 4576.8 162183.0 162191.0 164842.0 165099.2 169372.0 129361.4 139800.0 139912.0 141875.0 144014.0 70246.6 78562.6 99561.5 117647.0 120544.4 7198.7 9131.3 9362.2 9380.7 9571.5 63148.0 63814.7 64531.7 64779.0 66947.7 100332.5 103114.0 103332.5 104222.5 105395.0 12475.3 12719.8 12836.4 13086.0 13611.3 12039.3 14045.9 14682.3 14755.0 15547.8 11872.0 12643.2 13177.5 13460.8 13655.9 12948.6 13551.5 13612.3 13838.0 13899.3 12008.8 12169.9 12207.8 12233.8 12235.6 9086.2 10588.9 10985.2 11212.6 11798.4 8953.9 9454.7 10654.4 11132.8 11333.7 01:14:58 INFO - PROCESS | 1650 | -------- Summary: end -------- 01:14:58 INFO - PROCESS | 1650 | 01:14:58 INFO - TEST-INFO | 1650: exit 0 01:14:58 INFO - TEST-OK | dromaeo_css | took 1113251ms 01:14:58 INFO - TEST-START | kraken 01:14:58 INFO - operating with platform_type : mac_ 01:14:58 INFO - Initialising browser for kraken test... 01:14:58 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmppwmXWp/profile http://localhost:49267/getInfo.html) 01:15:01 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 01:15:01 INFO - PROCESS | 1661 | colorDepth:24 01:15:01 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 01:15:01 INFO - PROCESS | 1661 | __metrics 01:15:01 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 01:15:01 INFO - TEST-INFO | 1661: exit 0 01:15:01 INFO - Browser initialized. 01:15:01 INFO - Running cycle 1/1 for kraken test... 01:15:01 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmppwmXWp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:15:13 INFO - PROCESS | 1663 | RSS: Main: 224808960 01:15:13 INFO - PROCESS | 1663 | 01:15:16 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 01:15:17 INFO - PROCESS | 1663 | RSS: Main: 237441024 01:15:17 INFO - PROCESS | 1663 | 01:15:20 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 01:15:20 INFO - PROCESS | 1663 | RSS: Main: 244858880 01:15:20 INFO - PROCESS | 1663 | 01:15:24 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 01:15:24 INFO - PROCESS | 1663 | RSS: Main: 248594432 01:15:24 INFO - PROCESS | 1663 | 01:15:26 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 01:15:27 INFO - PROCESS | 1663 | RSS: Main: 248909824 01:15:27 INFO - PROCESS | 1663 | 01:15:29 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:15:29 INFO - PROCESS | 1663 | RSS: Main: 250306560 01:15:29 INFO - PROCESS | 1663 | 01:15:32 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 01:15:33 INFO - PROCESS | 1663 | RSS: Main: 250957824 01:15:33 INFO - PROCESS | 1663 | 01:15:36 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 01:15:37 INFO - PROCESS | 1663 | RSS: Main: 250720256 01:15:37 INFO - PROCESS | 1663 | 01:15:39 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 01:15:40 INFO - PROCESS | 1663 | RSS: Main: 251166720 01:15:40 INFO - PROCESS | 1663 | 01:15:42 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:15:42 INFO - PROCESS | 1663 | RSS: Main: 250707968 01:15:42 INFO - PROCESS | 1663 | 01:15:44 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:15:45 INFO - PROCESS | 1663 | RSS: Main: 250728448 01:15:45 INFO - PROCESS | 1663 | 01:15:47 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:15:48 INFO - PROCESS | 1663 | RSS: Main: 250806272 01:15:48 INFO - PROCESS | 1663 | 01:15:51 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:15:51 INFO - PROCESS | 1663 | RSS: Main: 250830848 01:15:51 INFO - PROCESS | 1663 | 01:15:54 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:15:55 INFO - PROCESS | 1663 | RSS: Main: 251129856 01:15:55 INFO - PROCESS | 1663 | 01:15:57 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 01:15:57 INFO - PROCESS | 1663 | RSS: Main: 252465152 01:15:57 INFO - PROCESS | 1663 | 01:15:57 INFO - PROCESS | 1663 | __start_tp_report 01:15:57 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 01:15:57 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 01:15:57 INFO - PROCESS | 1663 | |i|pagename|runs| 01:15:57 INFO - PROCESS | 1663 | |0;ai-astar;107;110;154;123;171;174;125;119;117;117 01:15:57 INFO - PROCESS | 1663 | |1;audio-beat-detection;146;109;113;145;114;111;105;113;135;114 01:15:57 INFO - PROCESS | 1663 | |2;audio-dft;193;202;221;281;204;192;198;197;194;202 01:15:57 INFO - PROCESS | 1663 | |3;audio-fft;84;59;59;75;51;58;68;84;104;60 01:15:57 INFO - PROCESS | 1663 | |4;audio-oscillator;85;73;88;72;74;70;87;70;70;86 01:15:57 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;110;87;90;86;89;86;100;113;89;86 01:15:57 INFO - PROCESS | 1663 | |6;imaging-darkroom;154;152;96;95;95;95;117;123;95;94 01:15:57 INFO - PROCESS | 1663 | |7;imaging-desaturate;107;93;91;90;113;93;92;93;90;111 01:15:57 INFO - PROCESS | 1663 | |8;json-parse-financial;56;54;56;56;60;59;58;59;60;59 01:15:57 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;64;85;58;83;114;109;104;63;85;102 01:15:57 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;81;76;96;105;77;94;100;105;108;80 01:15:57 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;139;138;139;139;173;145;142;143;166;139 01:15:57 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;171;168;166;168;168;169;166;173;166;199 01:15:57 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;68;69;69;68;70;67;68;67;68;66 01:15:57 INFO - PROCESS | 1663 | __end_tp_report 01:15:57 INFO - PROCESS | 1663 | __start_cc_report 01:15:57 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,941 01:15:57 INFO - PROCESS | 1663 | __end_cc_report 01:15:57 INFO - PROCESS | 1663 | __startTimestamp1476346557411__endTimestamp 01:15:57 INFO - PROCESS | 1663 | 01:15:57 INFO - PROCESS | 1663 | ------- Summary: start ------- 01:15:57 INFO - PROCESS | 1663 | Number of tests: 14 01:15:57 INFO - PROCESS | 1663 | 01:15:57 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:131.70 Median:124.00 stddev:25.00 (20.2%) stddev-sans-first:24.87 01:15:57 INFO - PROCESS | 1663 | Values: 107.0 110.0 154.0 123.0 171.0 174.0 125.0 119.0 117.0 117.0 01:15:57 INFO - PROCESS | 1663 | 01:15:57 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:120.50 Median:114.00 stddev:15.35 (13.5%) stddev-sans-first:13.22 01:15:57 INFO - PROCESS | 1663 | Values: 146.0 109.0 113.0 145.0 114.0 111.0 105.0 113.0 135.0 114.0 01:15:57 INFO - PROCESS | 1663 | 01:15:57 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:208.40 Median:202.00 stddev:26.84 (13.3%) stddev-sans-first:27.88 01:15:57 INFO - PROCESS | 1663 | Values: 193.0 202.0 221.0 281.0 204.0 192.0 198.0 197.0 194.0 202.0 01:15:57 INFO - PROCESS | 1663 | 01:15:57 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:70.20 Median:64.00 stddev:16.41 (25.6%) stddev-sans-first:16.63 01:15:57 INFO - PROCESS | 1663 | Values: 84.0 59.0 59.0 75.0 51.0 58.0 68.0 84.0 104.0 60.0 01:15:57 INFO - PROCESS | 1663 | 01:15:57 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:79.50 stddev:7.89 (9.9%) stddev-sans-first:7.89 01:15:57 INFO - PROCESS | 1663 | Values: 85.0 73.0 88.0 72.0 74.0 70.0 87.0 70.0 70.0 86.0 01:15:57 INFO - PROCESS | 1663 | 01:15:57 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:93.60 Median:86.50 stddev:10.32 (11.9%) stddev-sans-first:9.08 01:15:57 INFO - PROCESS | 1663 | Values: 110.0 87.0 90.0 86.0 89.0 86.0 100.0 113.0 89.0 86.0 01:15:57 INFO - PROCESS | 1663 | 01:15:57 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:111.60 Median:95.00 stddev:24.14 (25.4%) stddev-sans-first:20.15 01:15:57 INFO - PROCESS | 1663 | Values: 154.0 152.0 96.0 95.0 95.0 95.0 117.0 123.0 95.0 94.0 01:15:57 INFO - PROCESS | 1663 | 01:15:57 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:91.50 stddev:9.18 (10.0%) stddev-sans-first:9.04 01:15:57 INFO - PROCESS | 1663 | Values: 107.0 93.0 91.0 90.0 113.0 93.0 92.0 93.0 90.0 111.0 01:15:57 INFO - PROCESS | 1663 | 01:15:57 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:59.00 stddev:2.06 (3.5%) stddev-sans-first:2.09 01:15:57 INFO - PROCESS | 1663 | Values: 56.0 54.0 56.0 56.0 60.0 59.0 58.0 59.0 60.0 59.0 01:15:57 INFO - PROCESS | 1663 | 01:15:57 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:86.70 Median:63.50 stddev:20.27 (31.9%) stddev-sans-first:19.76 01:15:57 INFO - PROCESS | 1663 | Values: 64.0 85.0 58.0 83.0 114.0 109.0 104.0 63.0 85.0 102.0 01:15:57 INFO - PROCESS | 1663 | 01:15:57 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:78.50 stddev:12.58 (16.0%) stddev-sans-first:12.67 01:15:57 INFO - PROCESS | 1663 | Values: 81.0 76.0 96.0 105.0 77.0 94.0 100.0 105.0 108.0 80.0 01:15:57 INFO - PROCESS | 1663 | 01:15:57 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:146.30 Median:142.50 stddev:12.53 (8.8%) stddev-sans-first:13.01 01:15:57 INFO - PROCESS | 1663 | Values: 139.0 138.0 139.0 139.0 173.0 145.0 142.0 143.0 166.0 139.0 01:15:57 INFO - PROCESS | 1663 | 01:15:57 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:168.50 stddev:9.96 (5.9%) stddev-sans-first:10.56 01:15:57 INFO - PROCESS | 1663 | Values: 171.0 168.0 166.0 168.0 168.0 169.0 166.0 173.0 166.0 199.0 01:15:57 INFO - PROCESS | 1663 | 01:15:57 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.15 (1.7%) stddev-sans-first:1.22 01:15:57 INFO - PROCESS | 1663 | Values: 68.0 69.0 69.0 68.0 70.0 67.0 68.0 67.0 68.0 66.0 01:15:57 INFO - PROCESS | 1663 | -------- Summary: end -------- 01:15:57 INFO - PROCESS | 1663 | 01:15:58 INFO - TEST-INFO | 1663: exit 0 01:15:58 INFO - TEST-OK | kraken | took 59534ms 01:15:58 INFO - SUITE-END | took 1172s 01:15:58 INFO - Completed test suite (00:19:33) 01:15:58 INFO - javascript benchmark 01:15:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7360.721274213821, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3450.8274586270686, 3465.116395319193, 3471.1669199392154, 3474.992252246848, 3487.7384196185276, 5878.853028674285, 5949.25634295713, 5967.224260846089, 5974.253218347707, 5974.402559744034, 5892.351841297454, 5897.233359663249, 5929.140274660172, 5980.88038239235, 6002.549808764338, 5323.893522129555, 5387.326584176978, 5393.083175860093, 5415.729213539327, 5454.318210223722, 5428.185772134192, 5436.619436639437, 5440.646357986738, 5442.12925931851, 5450.31871016123, 4952.678075925071, 4976.377952755905, 5317.627766056377, 5364.517193452589, 5430.268387442497, 4400.537943515917, 4470.307102399117, 5338.492843179911, 5385.5960802939935, 5400.162974738922, 5279.049771041211, 5306.628536002481, 5332.066888294533, 5433.891322173535, 5440.020796256672, 5717.313922329306, 5964.910526342108, 5973.044312909914, 6051.939480605181, 6056.424639659225, 6151.507879369639, 6205.503559715212, 6222.937770622327, 6228.719707613168, 6268.373162683695, 6262.499000079983, 6276.905846412307, 6342.87314253717, 6367.981123020295, 6368.968155159241, 5959.135925290809, 6062.787802426894, 6065.393460653988, 6070.726817293233, 6094.756209751649, 5397.136458166675, 5628.887422251532, 5691.430856914359, 6370.904436433457, 6460.224773027267, 6270.341614130451, 6282.748690052346, 6294.244690637152, 6300.117983482316, 6300.527460440485, 6133.365267548864, 6155.753769849156, 6214.067889816563, 6329.525285603599, 6377.553571249968, 6171.5988460750805, 6220.657863817533, 6240.0, 6250.593711408744, 6263.561550691499, 6235.750569977241, 6271.592346497463, 6272.937270627326, 6280.371962803683, 6284.402981716729, 4951.356323677899, 5000.824971125993, 5001.074801161724, 5059.620528460307, 5075.0, 4456.68803183774, 4486.7083639563325, 4506.459224893034, 4536.659750518725, 4553.157665831765, 6009.45914867664, 6009.579329446984, 6032.668203248863, 6061.909071363845, 6073.180120683651, 6201.379862013762, 6357.682115894187, 6357.936420635827, 6358.713857876314, 6410.1987251593555, 5870.3249126350165, 5929.229200203946, 5947.821565353046, 5987.9101813472835, 6080.361562035922, 5529.557635389159, 5529.695866727368, 5557.527610153183, 5564.8330550083565, 5566.192902029183, 6337.112804207414, 6381.329960354189, 6416.326285740117, 6419.743210271537, 6442.742290308429, 6222.284437289589, 6224.502039836711, 6248.531360148098, 6268.937310627018, 6269.0909818075215, 6379.5215358847345, 6385.10608514799, 6393.936060639334, 6400.295967443484, 6425.421712045938, 6265.373462653698, 6280.780172693934, 6298.968505157445, 6306.527010474325, 6309.400606942333, 4989.775460104376, 6113.144159817718, 6120.17377654011, 6261.186045814015, 6273.62358258506, 6181.196444462371, 6277.278113016879, 6279.560430769802, 6285.654289014148, 6286.968565157145, 6206.782762603287, 6231.906521402092, 6251.812445626639, 6255.280642726145, 6280.214973128359, 5632.605717599728, 5686.232358631697, 6121.204243448323, 6171.9074213887725, 6208.192934918432, 6167.444929956146, 6204.0, 6259.499240060693, 6273.686315684106, 6292.3078461368295, 6176.783812566719, 6177.598456100519, 6190.288116866618, 6197.380261973766, 6224.035274532454], "value": 5803.54215598697, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.00243503253364, 498.0536979738494, 510.3951817096739, 520.9687418754872, 530.8513616187469, 37593.43609845851, 41660.79169604148, 41694.791526042405, 41789.582104178946, 41820.16359672808, 31554.211144721336, 32100.03699889007, 33378.49932251018, 41258.55595054174, 42778.78610606951, 9613.038696130383, 9862.211023118169, 9866.309358344919, 9873.851892221623, 9880.0, 9780.804383912318, 9865.457399843006, 9895.208383329353, 9910.20718342531, 9929.056739609725, 9913.35563188394, 9920.0, 9962.501874906262, 9978.20174386051, 9982.301238913278, 8643.697470588562, 9659.661911833087, 9858.359206651545, 9879.753006174831, 9912.55393507294, 9696.127348538595, 9738.464384458852, 9762.9511852441, 9832.0, 9833.31166818323, 40378.79810600958, 40468.595314046775, 40914.0, 40991.38512922308, 41104.177916441506, 3265.673432656739, 3413.0784688134063, 3437.1063523483826, 3439.5528581284525, 3864.188520410717, 30585.0, 30834.074977750704, 31922.20194495133, 32476.350472990645, 33063.50404743931, 3327.1349449143154, 3332.350191712617, 3339.4156022696175, 3339.8664053437833, 3388.81361525116, 516408.0, 518367.0, 523880.0, 523997.0, 527344.0, 67776.0, 68911.0, 69025.0, 69095.65452172708, 69375.3062469379, 36685.81657091698, 36903.81548092242, 37495.62504374976, 38934.415983760264, 39014.4147837777, 17632.471025869243, 17840.910795446198, 17876.821231787777, 17885.7317140243, 17924.103794810206, 13439.462421503225, 13499.662508437172, 13501.189928604315, 13501.729965400637, 13537.932310338385, 21018.579628407348, 21177.576448471253, 21295.254666086614, 21300.78699213019, 21337.0, 7460.328570428687, 9044.8643270351, 9045.77385565366, 9055.0, 9068.410553314014, 719.6829801463309, 910.7358865928938, 978.500964508106, 1053.1364281289423, 1067.5516283160935, 21567.67648485274, 27695.58456623112, 29682.81268749226, 30041.549376759365, 30289.24276893051, 1081.0324759340504, 1093.1746531368924, 1136.9147313951487, 1152.1071169843271, 1177.2877409167502, 15526.990745601499, 15904.681906362039, 15939.36242550285, 16214.918925405298, 16233.756493652605, 685104.1489585041, 695601.0, 697164.0, 697556.0, 698071.0, 59458.70270648619, 59983.700081499315, 60699.69650151721, 60888.08667869985, 60933.78132437415, 1174.7298121432118, 1353.3098119958893, 1383.557261676254, 1394.979075313851, 1402.3829515013565, 24155.879220603783, 31423.685763142075, 32532.837335814118, 32916.83541582277, 33484.16289592682, 47289.05421891612, 58562.4143758574, 58909.41090589039, 59292.11061834162, 59315.81368372695, 633749.0, 641384.0, 641387.0, 642042.9489262806, 642627.0, 44420.55579444293, 44614.77692611646, 45778.0, 46062.07875842397, 46285.76857115693, 40377.0, 48459.0, 49206.50793492019, 49384.76538086433, 49618.0, 40375.0, 40421.797891010356, 40784.79607601943, 41025.0, 42249.73250802481, 40108.1978360437, 40325.39511907265, 40807.14805692086, 41258.793706031276, 41432.964175895846, 38630.6136938627, 39830.80084599558, 39848.800755997196, 39914.2017159661, 41494.0, 27630.0, 29923.95266165674, 30384.392312154076, 35787.0, 36500.26999460049, 24157.637635435833, 26088.8695556521, 26513.469730604895, 26559.734402655726, 27024.0], "value": 20672.59840612871, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.10955200502815, 378.32091395944275, 383.925134598753, 387.58721961111416, 400.4293881219262, 18648.160832762525, 19623.90188049058, 21092.367228983137, 21333.25333613324, 21362.038708258147, 11457.427128643556, 12045.217060891036, 12060.396980151001, 12068.336241506713, 18958.336458223966, 5324.54741346985, 5632.7183640818, 5635.971820140914, 5641.12562552805, 5663.575231857607, 5324.307839980797, 5466.453354664522, 5518.641288316247, 5541.556675465953, 5632.493075623193, 5378.623496355257, 5459.836204913859, 5494.752736126884, 5511.724413779315, 5519.917201241985, 5236.869078273055, 5408.783648654049, 5990.790322338719, 6113.388661133896, 6183.690815459254, 4633.4671512775785, 5377.166539186433, 5435.646682965595, 5441.891162176735, 5454.61817672763, 13084.084114112016, 13166.473341066347, 13231.27228002469, 13256.138351007154, 13402.46390144393, 2324.5467133908896, 2347.976520234793, 2349.6592994015773, 2366.2782851230368, 2370.4903445759073, 9832.360896541773, 10100.191984641284, 10119.544620492095, 10389.79220415595, 10514.789704205874, 1824.8722589418746, 1824.9817501825078, 1908.5610309628723, 1920.9903950480298, 1933.0914470199125, 115331.42334288359, 120975.0, 126679.0, 127511.0, 128489.0, 10022.3485473444, 10045.79908401828, 11829.053675705924, 11874.46564904564, 11994.640160795016, 14832.851671483362, 14856.405743770345, 14870.256487175599, 14897.404103835725, 14918.776218356734, 8540.615672294762, 8822.955885220661, 8848.380613357003, 8890.155435233642, 8915.242204412698, 8809.344236265542, 8815.515146666867, 8831.425957312755, 8953.194212520773, 9039.050899655573, 4486.1924853526025, 4530.546945305443, 4574.519675434098, 4601.562851529099, 4621.838235661736, 1601.3594562175224, 1711.6662250861211, 1982.0585222019427, 1985.0868600443957, 1994.6436423232342, 374.2141502844006, 403.0769537758559, 405.8234667919405, 429.5554101504927, 822.0751654388813, 11547.422628868691, 11785.3518056506, 11809.350485723196, 11918.0, 12096.153269271243, 366.83859101995034, 434.6283927242226, 436.3934131557138, 442.25259311763017, 451.821530495459, 6000.129981152709, 6136.693165341804, 10929.071028962468, 11701.590444334408, 11734.0, 647076.0, 649342.0, 654047.0, 660205.0, 660270.0, 122414.38792805979, 124756.37621812015, 127621.3618931918, 128272.0, 128632.0, 971.3589031239349, 991.6231831903974, 1008.742770593494, 1015.1827778638119, 1016.11090295991, 15465.0, 17483.737743933598, 18830.24679012824, 19414.708779368037, 19498.805011950266, 39002.804985974886, 50636.24045639245, 54992.45007549873, 55395.16907246314, 55727.721361392934, 82601.58699206465, 82852.58573707093, 82913.17086829296, 84944.0, 85560.0, 8184.0, 8210.137935516923, 11986.981106606036, 12286.815697764361, 12877.613671589866, 12828.55100071493, 13139.474421023053, 13146.737065258832, 13870.375833087333, 14043.578692639237, 11697.649070527897, 11730.824037639613, 11855.525778968744, 11878.406079695807, 12063.939680301542, 11627.88372116268, 11634.53461861516, 11806.173567850168, 11821.40892955366, 12162.817557736464, 8043.477173983672, 8068.354531637572, 11909.22590031645, 11948.402579870797, 12218.633440996784, 12598.874011260137, 12681.746365072462, 12728.299943503196, 12748.553800616934, 12796.168249063781, 11789.882101178879, 11850.881491184979, 11935.283882967049, 12003.8654658483, 12130.878691212974], "value": 8976.75130667244, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1365.1331404558105, 1517.8709809666177, 1528.0984219310612, 1702.4211767998877, 1862.5902301493666, 7979.0, 8270.4624199427, 8523.19029692179, 9024.0, 9060.592273347707, 8462.323014158868, 8796.78008049799, 8823.95588022059, 8891.555422228896, 8971.506567138806, 2383.4756353602265, 2390.3546042568496, 2400.2799160251943, 2425.4057755849753, 2434.160214725917, 2396.364963284731, 2412.107520217522, 2415.9758402416014, 2435.585950388438, 2444.10790061628, 2411.5176964607062, 2417.295806456444, 2425.4785221177444, 2438.9512209755794, 2442.9755702443013, 2376.536575367804, 2386.188695843413, 2393.844400113987, 2395.724491683444, 2401.0515846240637, 2222.766609506011, 2275.442516583431, 2368.360542653491, 2385.8210634202333, 2390.5816482115733, 7561.432892533027, 8942.150495702897, 9004.729858104267, 9006.234470070052, 9009.144131307516, 5000.949990500085, 5049.2426136079885, 5403.621746477748, 5414.07960646687, 5509.614326997112, 3469.548958635361, 3638.43604241343, 3643.5081264029545, 3649.5073165122635, 3677.17263615687, 1021.9386836789816, 1065.6110519660347, 1070.4968664727567, 1113.8941800528937, 1136.8919952604572, 11641.76716465666, 11735.0, 11781.469833857496, 11809.586664466702, 11828.526858925632, 3707.870224542182, 3917.2948869203246, 4250.808713607895, 4293.914121717548, 4907.411110666671, 10018.949905250427, 10105.797884042278, 10118.241131915136, 10120.342177758423, 10134.645287414905, 5410.783568657288, 5461.644993075437, 5474.2609747683555, 5479.068558345091, 5485.4788795064405, 4415.801288942005, 4584.33527138563, 4850.442199147073, 4970.751462426864, 4998.400191976913, 3719.702423806089, 3880.8835734927998, 4007.73949693269, 4096.672266218696, 4131.483564554431, 1307.4247331174254, 1315.0137396952287, 1321.0818481155504, 1327.7145413736093, 1342.1142046249624, 926.2543652359915, 937.920276776468, 943.3160958305311, 946.682861241478, 952.2953014769021, 5754.280714910637, 5896.557758168155, 5947.167396564484, 6128.019516877367, 6191.040388739752, 441.67978215793937, 441.80118946474215, 451.52815308003215, 451.94124763781156, 986.6645340584092, 3944.822482988215, 4042.9601881002623, 4108.815103320298, 4193.35003074524, 4196.391523229115, 10527.631532896312, 10798.892011079946, 10801.67594972152, 10869.021788039114, 10872.402017889091, 10768.623098191525, 10782.73043173927, 10832.78334433307, 10845.0, 10870.347779133277, 7759.30166285037, 8102.594870256581, 8190.303824175012, 8233.8353232935, 8299.99999999988, 5897.764089436375, 5952.107183922446, 5985.910211346921, 6080.452759251689, 6111.847203819762, 9821.607135714492, 9939.453330066915, 9968.0, 10036.447995360326, 10077.14344280715, 9743.415395076318, 10284.331518451278, 10287.22845786584, 10297.53661085238, 10306.948465257627, 6963.651817409211, 7157.606331651809, 7411.703531858665, 7558.281963213486, 7695.769126926201, 8364.079951205242, 8372.539510326747, 8533.615987280464, 8551.828963420821, 8552.016518100498, 7392.112946446461, 7424.220456852169, 7564.130125035691, 7665.041869766279, 7719.92280077192, 7368.852622947618, 7494.362979146834, 7510.136334321623, 7542.208068152765, 7550.169481357156, 6800.081988931431, 6804.591724496546, 6809.455243580601, 6970.825729356807, 6989.37095661393, 5015.323490361622, 5046.899062018812, 5170.182250673317, 5224.2947202127225, 5251.658642188246, 4574.199515084913, 4946.961138161027, 5075.264086707333, 5176.197689358005, 5179.48205179479], "value": 4561.847657760777, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [267.78175786733823, 306.8895197728818, 314.9889753858614, 316.8130802826335, 317.3684368107465, 4663.463701674308, 4939.57960599306, 5246.317978662778, 5623.409541998088, 5666.631668941521, 4367.519572846984, 4606.608438282741, 5069.695818250908, 5326.520613144816, 5553.4724201200925, 4042.3330150525203, 4198.097409057053, 4281.0, 4283.850065247717, 4285.442892423996, 3407.8466469008954, 3808.371618682914, 4151.8546850860075, 4264.381664658623, 4312.956870431302, 3660.5790334111653, 4224.345226489899, 4224.788760561975, 4232.957670423287, 4253.553376895427, 3470.4967779671933, 3744.764227804818, 3796.7152463565067, 4210.242156411845, 4224.38746381776, 3701.648343407372, 3703.6296370362747, 3706.369917114097, 3717.052151701299, 3725.925481490355, 5101.132807422747, 5426.782928682848, 5472.345912232564, 5474.479924407175, 5512.862178445531, 4849.3453383793085, 4850.514948505156, 4856.465788763233, 4859.740220797346, 4870.488598697121, 5349.983503134392, 5442.91835622466, 5860.150278209636, 5980.744043750818, 6103.230063281643, 3345.866165353383, 3739.925201495982, 3948.6841052715713, 3949.012746813297, 3951.229510245503, 4682.906341873144, 5099.796008159669, 5410.567154627621, 5441.455854414567, 6274.87450250997, 3548.3967725486727, 4011.910828661972, 4020.2160578686876, 4027.5368332641533, 4043.6765058795227, 3953.9011524711536, 4015.357542793139, 4088.8364465421646, 4096.09885825118, 4108.979455102705, 4048.655864251513, 4222.809973551198, 4784.918560426226, 4815.109204797053, 4822.348982887335, 4481.512760418, 5185.844424667266, 5805.0, 6036.42653947883, 6037.098314031066, 1248.5630029489605, 1299.4996926183487, 1378.2281922123643, 1378.2832926878168, 1385.88220001301, 737.7270409948246, 819.4837252530867, 835.5836856528126, 837.7193640130503, 845.2519520224522, 4060.634542891154, 4109.56849530795, 4472.59746622799, 4603.58567728906, 4693.319468677023, 4213.4522512073845, 4693.043382668965, 4775.2359622460235, 5065.442801291855, 5112.389597276846, 3985.114513349461, 4053.5541090480024, 4112.018786379851, 4661.254199328091, 4686.74222917736, 2604.9088281910044, 2806.733360330765, 3214.942436840424, 3243.5459035735016, 3263.2215442583847, 6048.364921683248, 6231.968840155861, 6299.6850157491945, 6344.302126766144, 6379.671419931784, 5155.871103222449, 6073.51411887048, 6133.478654314344, 6212.0, 6412.871742565216, 5151.665141765773, 5752.395998420189, 6007.678310771623, 6134.877302453926, 6235.285296543487, 4794.640401969936, 5064.797408103635, 5875.706214689334, 5990.7903223386975, 6107.4197951194565, 5252.739342557835, 5701.5505619101505, 5852.385499522489, 6008.648054187773, 6036.215292012011, 4967.230079337564, 5850.765969361178, 5890.263717035371, 5963.703973969966, 6206.162168107428, 3067.831269280122, 3788.204477059738, 3994.840206391712, 4014.8193331300745, 4028.637422631977, 5857.853553661193, 6038.788642397495, 6079.665618391031, 6113.043825975645, 6185.443310102112, 5629.437056294338, 5756.539476841759, 5859.560532959959, 5862.267216597926, 5952.987992041277, 5296.311479507639, 5468.753906074316, 5885.61743486672, 5903.350631430625, 5928.525717942641, 5686.715664216856, 5794.4205579443405, 5811.7643533799, 5835.045259837832, 5851.414858514115, 5900.822975310747, 5932.644041357532, 5945.762169513344, 5969.611975221596, 6001.969990150022, 5687.639170419477, 5828.970855145697, 5843.853903652443, 5885.588008839341, 5902.5277977762535], "value": 4151.535914568972, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.2044750774149, 750.7297372945739, 764.7132325377984, 795.5664163031147, 834.1366685480527, 14891.255437228136, 15484.380624775009, 15532.378704851792, 15536.22318884057, 15649.530514084581, 13150.473981040746, 13162.736745265089, 13207.6698082548, 13213.207207567553, 13319.733605327887, 819.3035919468464, 843.7679638099542, 876.0932434929849, 877.5656050255133, 882.1707594860842, 847.1697736218479, 868.9261412779921, 869.1742844297911, 870.5473153959937, 872.0538216035577, 915.8488849339851, 917.7200953709116, 917.7659696777313, 917.898521773874, 921.4195057114042, 854.8803167556547, 908.3777612335538, 909.5452273863068, 916.6241840845222, 917.3165991336464, 499.4381321013859, 621.1242148570539, 659.4559488422024, 682.1916029505053, 682.1950098883316, 14970.775438368433, 15463.690726185525, 15470.5358839235, 15473.922630386889, 15483.458078967295, 11435.942820285845, 14061.437542498288, 14165.008449408546, 14488.710225795425, 14874.405023799036, 10570.52432640533, 11218.382988935606, 11704.53181872724, 11988.940055299754, 12018.699532511757, 3765.246950609889, 3830.291396091732, 3852.903677408059, 3931.272714547818, 3933.8819835404984, 126483.0, 129430.05854912184, 130478.0, 131350.34324828314, 132563.0, 10846.891531084588, 11079.556817727362, 11133.832992505118, 11134.443277836075, 11215.831762523569, 22573.54852902933, 22705.0, 22797.430064248525, 22992.4251893704, 23108.0, 7918.960405197937, 7929.853595800801, 7937.642806073741, 7944.205579442125, 7976.282134607914, 3760.7555508891833, 4284.614384705392, 4302.247106756305, 4396.296592545177, 4517.141743068806, 3405.438102713025, 3464.393731097098, 3498.4577390504514, 3548.237129017222, 3554.5023696682483, 661.4576047640984, 686.3959715450371, 718.0916141081536, 718.9676464559003, 722.5664601239214, 500.4495055438988, 558.8770470496485, 567.5573053018652, 586.4253032028636, 589.3428826858022, 8462.661493540189, 9232.522796352552, 9581.856272155923, 9640.75898102553, 9649.372790768577, 529.8577307233292, 592.5911171089507, 618.7061145955635, 637.4067557185732, 647.3267801486495, 4292.91414171721, 4321.7406955582765, 4491.348754430589, 4513.458384993756, 4576.839810606612, 162183.0, 162191.0, 164842.0, 165099.1745041267, 169372.0, 129361.3531932353, 139800.0, 139912.0, 141875.0, 144014.0, 70246.64876675584, 78562.6071869637, 99561.50219248858, 117647.0, 120544.3972780148, 7198.71205151788, 9131.269498439977, 9362.157405833508, 9380.67167649129, 9571.521423928914, 63148.0, 63814.68092659507, 64531.677341612994, 64779.0, 66947.66526167338, 100332.49833750784, 103114.0, 103332.48333758283, 104222.47888760507, 105395.0, 12475.251484910934, 12719.80920286215, 12836.358182091044, 13086.018548609083, 13611.319434028457, 12039.337836419081, 14045.929770351082, 14682.33929473155, 14755.040922340013, 15547.766783498482, 11871.99088077523, 12643.241405515699, 13177.538786142823, 13460.788529032434, 13655.931720341334, 12948.611541653765, 13551.53947125448, 13612.251326177155, 13838.0, 13899.30503474802, 12008.819867701817, 12169.939150304192, 12207.816882746589, 12233.755324893631, 12235.571754988532, 9086.227670647804, 10588.894111058791, 10985.231033827555, 11212.607558735404, 11798.41007949582, 8953.910460895308, 9454.716358509255, 10654.414007229367, 11132.833007504732, 11333.659990200307], "value": 7796.8565196266845, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 154.0, 123.0, 171.0, 174.0, 125.0, 119.0, 117.0, 117.0], "value": 131.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 109.0, 113.0, 145.0, 114.0, 111.0, 105.0, 113.0, 135.0, 114.0], "value": 120.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 202.0, 221.0, 281.0, 204.0, 192.0, 198.0, 197.0, 194.0, 202.0], "value": 208.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 59.0, 75.0, 51.0, 58.0, 68.0, 84.0, 104.0, 60.0], "value": 70.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 73.0, 88.0, 72.0, 74.0, 70.0, 87.0, 70.0, 70.0, 86.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 87.0, 90.0, 86.0, 89.0, 86.0, 100.0, 113.0, 89.0, 86.0], "value": 93.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 152.0, 96.0, 95.0, 95.0, 95.0, 117.0, 123.0, 95.0, 94.0], "value": 111.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 93.0, 91.0, 90.0, 113.0, 93.0, 92.0, 93.0, 90.0, 111.0], "value": 97.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 56.0, 56.0, 60.0, 59.0, 58.0, 59.0, 60.0, 59.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 85.0, 58.0, 83.0, 114.0, 109.0, 104.0, 63.0, 85.0, 102.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 76.0, 96.0, 105.0, 77.0, 94.0, 100.0, 105.0, 108.0, 80.0], "value": 92.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 139.0, 139.0, 173.0, 145.0, 142.0, 143.0, 166.0, 139.0], "value": 146.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 168.0, 166.0, 168.0, 168.0, 169.0, 166.0, 173.0, 166.0, 199.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 68.0, 70.0, 67.0, 68.0, 67.0, 68.0, 66.0], "value": 68.0, "unit": "score"}]}]} 01:15:58 INFO - Return code: 0 01:15:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:15:58 ERROR - # TBPL SUCCESS # 01:15:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:15:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:15:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:15:58 INFO - 2016-10-13 01:15:58.767 screenresolution[1668:10658] starting screenresolution argv=screenresolution get 01:15:58 INFO - 2016-10-13 01:15:58.770 screenresolution[1668:10658] Display 0: 1600x1200x32@60 01:15:58 INFO - 2016-10-13 01:15:58.776 screenresolution[1669:10661] starting screenresolution argv=screenresolution list 01:15:58 INFO - Available Modes on Display 0 01:15:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:15:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:15:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:15:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:15:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:15:59 INFO - Intel Iris: 01:15:59 INFO - Chipset Model: Intel Iris 01:15:59 INFO - Type: GPU 01:15:59 INFO - Bus: Built-In 01:15:59 INFO - VRAM (Dynamic, Max): 1536 MB 01:15:59 INFO - Vendor: Intel (0x8086) 01:15:59 INFO - Device ID: 0x0a2e 01:15:59 INFO - Revision ID: 0x0009 01:15:59 INFO - Displays: 01:15:59 INFO - Display: 01:15:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:15:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:15:59 INFO - Display Serial Number: 1600x1200 60 01:15:59 INFO - Main Display: Yes 01:15:59 INFO - Mirror: Off 01:15:59 INFO - Online: Yes 01:15:59 INFO - Rotation: Supported 01:15:59 INFO - Return code: 0 01:15:59 INFO - Running post-action listener: _resource_record_post_action 01:15:59 INFO - [mozharness: 2016-10-13 08:15:59.009648Z] Finished run-tests step (success) 01:15:59 INFO - Running post-run listener: _resource_record_post_run 01:15:59 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 36750336; Write bytes: 665203712; Read time: 370; Write time: 1933 01:15:59 INFO - TinderboxPrint: CPU usage
54.4% 01:15:59 INFO - TinderboxPrint: I/O read bytes / time
36,750,336 / 370 01:15:59 INFO - TinderboxPrint: I/O write bytes / time
665,203,712 / 1,933 01:15:59 INFO - TinderboxPrint: CPU idle
2,199.7 (45.6%) 01:15:59 INFO - TinderboxPrint: CPU system
977.6 (20.3%) 01:15:59 INFO - TinderboxPrint: CPU user
1,648.4 (34.2%) 01:15:59 INFO - TinderboxPrint: Swap in / out
399,900,672 / 0 01:15:59 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 358343168; Write bytes: 356247552; Read time: 27543; Write time: 696 01:15:59 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 34763776; Write bytes: 297925632; Read time: 347; Write time: 1200 01:15:59 INFO - Running post-run listener: _upload_blobber_files 01:15:59 INFO - Blob upload gear active. 01:15:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:15:59 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 01:15:59 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'] 01:15:59 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 01:15:59 INFO - (blobuploader) - INFO - Open directory for files ... 01:15:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:15:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:15:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:16:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:16:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:16:00 INFO - (blobuploader) - INFO - Done attempting. 01:16:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:16:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:16:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:16:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:16:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:16:01 INFO - (blobuploader) - INFO - Done attempting. 01:16:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:16:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:16:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:16:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:16:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:16:03 INFO - (blobuploader) - INFO - Done attempting. 01:16:03 INFO - (blobuploader) - INFO - Iteration through files over. 01:16:03 INFO - Return code: 0 01:16:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:16:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:16:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/593ca858a996a927d691c58f109fb45cca9d63d80578e0ea7c83da713b6e995176952221b0850e1abcbeffe2c8752e618f8750230fdd8f0f1cd4e40439a972b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41b19d808fd6ce3a701b337be479263d651f26908f0983ccf1c1fa41efdfd42995a31b1c5a15df4035c6dcf44382887637d5f8ee98c2173f68075720455e36f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3978de271ff02ec087bb8e86dc472ad646b49a07d663ec6560b750d4c16932a205979cd0379ad3922b68cafa34e4b0402f78da9c48799893b5ae3d4d0138e0cf"} 01:16:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:16:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:16:03 INFO - Contents: 01:16:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/593ca858a996a927d691c58f109fb45cca9d63d80578e0ea7c83da713b6e995176952221b0850e1abcbeffe2c8752e618f8750230fdd8f0f1cd4e40439a972b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41b19d808fd6ce3a701b337be479263d651f26908f0983ccf1c1fa41efdfd42995a31b1c5a15df4035c6dcf44382887637d5f8ee98c2173f68075720455e36f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3978de271ff02ec087bb8e86dc472ad646b49a07d663ec6560b750d4c16932a205979cd0379ad3922b68cafa34e4b0402f78da9c48799893b5ae3d4d0138e0cf"} 01:16:03 INFO - Running post-run listener: copy_logs_to_upload_dir 01:16:03 INFO - Copying logs to upload dir... 01:16:03 INFO - mkdir: /builds/slave/test/build/upload/logs 01:16:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.478191 ========= master_lag: 0.98 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-13 01:16:04.767239) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 01:16:04.770738) ========= 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.0OjNNbiZXj/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.WdaGyDBGYP/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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/593ca858a996a927d691c58f109fb45cca9d63d80578e0ea7c83da713b6e995176952221b0850e1abcbeffe2c8752e618f8750230fdd8f0f1cd4e40439a972b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41b19d808fd6ce3a701b337be479263d651f26908f0983ccf1c1fa41efdfd42995a31b1c5a15df4035c6dcf44382887637d5f8ee98c2173f68075720455e36f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3978de271ff02ec087bb8e86dc472ad646b49a07d663ec6560b750d4c16932a205979cd0379ad3922b68cafa34e4b0402f78da9c48799893b5ae3d4d0138e0cf"} build_url:https://queue.taskcluster.net/v1/task/GnmLZ4UZT7uY1SQDtIbKwg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011103 build_url: 'https://queue.taskcluster.net/v1/task/GnmLZ4UZT7uY1SQDtIbKwg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/593ca858a996a927d691c58f109fb45cca9d63d80578e0ea7c83da713b6e995176952221b0850e1abcbeffe2c8752e618f8750230fdd8f0f1cd4e40439a972b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41b19d808fd6ce3a701b337be479263d651f26908f0983ccf1c1fa41efdfd42995a31b1c5a15df4035c6dcf44382887637d5f8ee98c2173f68075720455e36f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3978de271ff02ec087bb8e86dc472ad646b49a07d663ec6560b750d4c16932a205979cd0379ad3922b68cafa34e4b0402f78da9c48799893b5ae3d4d0138e0cf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 01:16:04.806059) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 01:16:04.806715) ========= 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.0OjNNbiZXj/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.WdaGyDBGYP/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.005199 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 01:16:04.858127) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 01:16:04.858520) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 01:16:04.859008) ========= ========= Total master_lag: 1.11 =========