builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0082 starttime: 1477880636.17 results: success (0) buildid: 20161030172021 builduid: 1d2f4e1446184a688bf4f6759e720439 revision: b7070c905172e3ead8ee610fff35f86bf9ff9c42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 19:23:56.168820) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 19:23:56.169285) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 19:23:56.169574) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 19:23:56.194462) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 19:23:56.194791) ========= 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.0Ddloed5wu/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.pJl21xQl8s/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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-30 19:23:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 143M=0s 2016-10-30 19:23:56 (143 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.307281 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 19:23:56.524877) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 19:23:56.525254) ========= 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.0Ddloed5wu/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.pJl21xQl8s/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.027035 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 19:23:56.574809) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-30 19:23:56.575198) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b7070c905172e3ead8ee610fff35f86bf9ff9c42 --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 b7070c905172e3ead8ee610fff35f86bf9ff9c42 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0Ddloed5wu/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.pJl21xQl8s/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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-30 19:23:56,651 truncating revision to first 12 chars 2016-10-30 19:23:56,651 Setting DEBUG logging. 2016-10-30 19:23:56,651 attempt 1/10 2016-10-30 19:23:56,651 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b7070c905172?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-30 19:23:57,743 unpacking tar archive at: mozilla-aurora-b7070c905172/testing/mozharness/ program finished with exit code 0 elapsedTime=1.343923 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-30 19:23:57.941520) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 19:23:57.941821) ========= script_repo_revision: b7070c905172e3ead8ee610fff35f86bf9ff9c42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 19:23:57.942236) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 19:23:57.942510) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 19:23:57.985991) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-30 19:23:57.986365) ========= /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.0Ddloed5wu/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.pJl21xQl8s/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 19:23:58 INFO - MultiFileLogger online at 20161030 19:23:58 in /builds/slave/test 19:23:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:23:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:23:58 INFO - {'append_to_log': False, 19:23:58 INFO - 'base_work_dir': '/builds/slave/test', 19:23:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:23:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:23:58 INFO - 'branch': 'Mozilla-Aurora', 19:23:58 INFO - 'buildbot_json_path': 'buildprops.json', 19:23:58 INFO - 'config_files': ('talos/mac_config.py',), 19:23:58 INFO - 'default_actions': ('clobber', 19:23:58 INFO - 'read-buildbot-config', 19:23:58 INFO - 'download-and-extract', 19:23:58 INFO - 'populate-webroot', 19:23:58 INFO - 'create-virtualenv', 19:23:58 INFO - 'install', 19:23:58 INFO - 'run-tests'), 19:23:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:23:58 INFO - 'download_minidump_stackwalk': True, 19:23:58 INFO - 'download_symbols': 'ondemand', 19:23:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:23:58 INFO - 'tooltool.py': '/tools/tooltool.py', 19:23:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:23:58 INFO - '/tools/misc-python/virtualenv.py')}, 19:23:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:23:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:23:58 INFO - 'installer_path': 'installer.exe', 19:23:58 INFO - 'log_level': 'info', 19:23:58 INFO - 'log_name': 'talos', 19:23:58 INFO - 'log_to_console': True, 19:23:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:23:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:23:58 INFO - 'opt_config_files': (), 19:23:58 INFO - 'pip_index': False, 19:23:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:23:58 INFO - 'cmd': ('bash', 19:23:58 INFO - '-c', 19:23:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:23:58 INFO - 'enabled': True, 19:23:58 INFO - 'halt_on_failure': False, 19:23:58 INFO - 'name': 'check_screen_resolution'},), 19:23:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:23:58 INFO - 'cmd': ('bash', 19:23:58 INFO - '-c', 19:23:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:23:58 INFO - 'enabled': True, 19:23:58 INFO - 'halt_on_failure': False, 19:23:58 INFO - 'name': 'check_screen_resolution'},), 19:23:58 INFO - 'run_cmd_checks_enabled': True, 19:23:58 INFO - 'sps_profile': False, 19:23:58 INFO - 'sps_profile_interval': 0, 19:23:58 INFO - 'suite': 'dromaeojs-e10s', 19:23:58 INFO - 'system_bits': '32', 19:23:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:23:58 INFO - 'title': 't-yosemite-r7-0082', 19:23:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:23:58 INFO - 'use_talos_json': True, 19:23:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:23:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:23:58 INFO - 'work_dir': 'build'} 19:23:58 INFO - [mozharness: 2016-10-31 02:23:58.183514Z] Running clobber step. 19:23:58 INFO - Running pre-action listener: _resource_record_pre_action 19:23:58 INFO - Running main action method: clobber 19:23:58 INFO - rmtree: /builds/slave/test/build 19:23:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:24:00 INFO - Running post-action listener: _resource_record_post_action 19:24:00 INFO - [mozharness: 2016-10-31 02:24:00.406986Z] Finished clobber step (success) 19:24:00 INFO - [mozharness: 2016-10-31 02:24:00.407095Z] Running read-buildbot-config step. 19:24:00 INFO - Running pre-action listener: _resource_record_pre_action 19:24:00 INFO - Running main action method: read_buildbot_config 19:24:00 INFO - Using buildbot properties: 19:24:00 INFO - { 19:24:00 INFO - "project": "", 19:24:00 INFO - "product": "firefox", 19:24:00 INFO - "script_repo_revision": "production", 19:24:00 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 19:24:00 INFO - "repository": "", 19:24:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 19:24:00 INFO - "buildid": "20161030172021", 19:24:00 INFO - "pgo_build": "False", 19:24:00 INFO - "basedir": "/builds/slave/test", 19:24:00 INFO - "buildnumber": 25, 19:24:00 INFO - "slavename": "t-yosemite-r7-0082", 19:24:00 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 19:24:00 INFO - "platform": "yosemite_r7", 19:24:00 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 19:24:00 INFO - "branch": "mozilla-aurora", 19:24:00 INFO - "repo_path": "releases/mozilla-aurora", 19:24:00 INFO - "revision": "b7070c905172e3ead8ee610fff35f86bf9ff9c42", 19:24:00 INFO - "stage_platform": "macosx64", 19:24:00 INFO - "builduid": "1d2f4e1446184a688bf4f6759e720439", 19:24:00 INFO - "slavebuilddir": "test" 19:24:00 INFO - } 19:24:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/WZAEwcKWQjeNLBtC9q2aGg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 19:24:00 INFO - Running post-action listener: _resource_record_post_action 19:24:00 INFO - [mozharness: 2016-10-31 02:24:00.410158Z] Finished read-buildbot-config step (success) 19:24:00 INFO - [mozharness: 2016-10-31 02:24:00.410263Z] Running download-and-extract step. 19:24:00 INFO - Running pre-action listener: _resource_record_pre_action 19:24:00 INFO - Running main action method: download_and_extract 19:24:00 INFO - mkdir: /builds/slave/test/build/tests 19:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:00 INFO - trying https://queue.taskcluster.net/v1/task/WZAEwcKWQjeNLBtC9q2aGg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 19:24:00 INFO - Downloading https://queue.taskcluster.net/v1/task/WZAEwcKWQjeNLBtC9q2aGg/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 19:24:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WZAEwcKWQjeNLBtC9q2aGg/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 19:24:01 INFO - Downloaded 1199 bytes. 19:24:01 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 19:24:01 INFO - Using the following test package requirements: 19:24:01 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 19:24:01 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:24:01 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 19:24:01 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:24:01 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 19:24:01 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:24:01 INFO - u'jsshell-mac.zip'], 19:24:01 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:24:01 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 19:24:01 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 19:24:01 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:24:01 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 19:24:01 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:24:01 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 19:24:01 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:24:01 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 19:24:01 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:24:01 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 19:24:01 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 19:24:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WZAEwcKWQjeNLBtC9q2aGg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 19:24:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WZAEwcKWQjeNLBtC9q2aGg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:24:01 INFO - Fetch https://queue.taskcluster.net/v1/task/WZAEwcKWQjeNLBtC9q2aGg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 19:24:01 INFO - Expected file size: 16421479 19:24: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 19:24:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WZAEwcKWQjeNLBtC9q2aGg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 19:24:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WZAEwcKWQjeNLBtC9q2aGg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:24:08 INFO - Fetch https://queue.taskcluster.net/v1/task/WZAEwcKWQjeNLBtC9q2aGg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 19:24:09 INFO - Expected file size: 16421479 19:24:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WZAEwcKWQjeNLBtC9q2aGg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 19:24:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WZAEwcKWQjeNLBtC9q2aGg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 19:24:16 INFO - Fetch https://queue.taskcluster.net/v1/task/WZAEwcKWQjeNLBtC9q2aGg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 19:24:16 INFO - Expected file size: 14414089 19:24: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')]} 19:24:17 INFO - trying https://queue.taskcluster.net/v1/task/WZAEwcKWQjeNLBtC9q2aGg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 19:24:17 INFO - Downloading https://queue.taskcluster.net/v1/task/WZAEwcKWQjeNLBtC9q2aGg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 19:24:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WZAEwcKWQjeNLBtC9q2aGg/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 19:24:20 INFO - Downloaded 115418791 bytes. 19:24:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WZAEwcKWQjeNLBtC9q2aGg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 19:24:20 INFO - mkdir: /builds/slave/test/properties 19:24:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:24:20 INFO - Writing to file /builds/slave/test/properties/build_url 19:24:20 INFO - Contents: 19:24:20 INFO - build_url:https://queue.taskcluster.net/v1/task/WZAEwcKWQjeNLBtC9q2aGg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 19:24:20 INFO - Running post-action listener: _resource_record_post_action 19:24:20 INFO - Running post-action listener: set_extra_try_arguments 19:24:20 INFO - [mozharness: 2016-10-31 02:24:20.952571Z] Finished download-and-extract step (success) 19:24:20 INFO - [mozharness: 2016-10-31 02:24:20.952694Z] Running populate-webroot step. 19:24:20 INFO - Running pre-action listener: _resource_record_pre_action 19:24:20 INFO - Running main action method: populate_webroot 19:24:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:24:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:24:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:24:20 INFO - '--tppagecycles', 19:24:20 INFO - '7'], 19:24:20 INFO - 'tests': ['tsvgm']}}, 19:24:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:24:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:24:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:24:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:24:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:24:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:24:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:20 INFO - 'talos_options': ['--disable-e10s'], 19:24:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:24:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:24:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:20 INFO - 'talos_options': ['--disable-e10s'], 19:24:20 INFO - 'tests': ['damp', 'tps']}, 19:24:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:20 INFO - 'tests': ['damp', 'tps']}, 19:24:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:24:20 INFO - 'tests': ['dromaeo_dom']}, 19:24:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:24:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:24:20 INFO - 'tests': ['basic_compositor_video']}, 19:24:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:24:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:24:20 INFO - 'tests': ['a11yr', 19:24:20 INFO - 'ts_paint', 19:24:20 INFO - 'tpaint', 19:24:20 INFO - 'sessionrestore', 19:24:20 INFO - 'sessionrestore_no_auto_restore', 19:24:20 INFO - 'tabpaint']}, 19:24:20 INFO - 'other-e10s': {'tests': ['a11yr', 19:24:20 INFO - 'ts_paint', 19:24:20 INFO - 'tpaint', 19:24:20 INFO - 'sessionrestore', 19:24:20 INFO - 'sessionrestore_no_auto_restore', 19:24:20 INFO - 'tabpaint']}, 19:24:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:24:20 INFO - 'ts_paint', 19:24:20 INFO - 'tpaint', 19:24:20 INFO - 'sessionrestore', 19:24:20 INFO - 'sessionrestore_no_auto_restore', 19:24:20 INFO - 'tabpaint']}, 19:24:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:24:20 INFO - 'ts_paint', 19:24:20 INFO - 'tpaint', 19:24:20 INFO - 'sessionrestore', 19:24:20 INFO - 'sessionrestore_no_auto_restore', 19:24:20 INFO - 'tabpaint']}, 19:24:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:24:20 INFO - 'tests': ['a11yr', 19:24:20 INFO - 'ts_paint', 19:24:20 INFO - 'tpaint', 19:24:20 INFO - 'sessionrestore', 19:24:20 INFO - 'sessionrestore_no_auto_restore', 19:24:20 INFO - 'tabpaint']}, 19:24:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:24:20 INFO - 'tests': ['a11yr', 19:24:20 INFO - 'ts_paint', 19:24:20 INFO - 'tpaint', 19:24:20 INFO - 'sessionrestore', 19:24:20 INFO - 'sessionrestore_no_auto_restore', 19:24:20 INFO - 'tabpaint']}, 19:24:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:24:20 INFO - 'tests': ['tsvgx', 19:24:20 INFO - 'tsvgr_opacity', 19:24:20 INFO - 'tart', 19:24:20 INFO - 'tscrollx', 19:24:20 INFO - 'cart']}, 19:24:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:24:20 INFO - 'tsvgr_opacity', 19:24:20 INFO - 'tart', 19:24:20 INFO - 'tscrollx', 19:24:20 INFO - 'cart']}, 19:24:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:20 INFO - 'talos_options': ['--disable-e10s'], 19:24:20 INFO - 'tests': ['tp5o']}, 19:24:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:20 INFO - 'tests': ['tp5o']}, 19:24:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:20 INFO - 'talos_options': ['--disable-e10s', 19:24:20 INFO - '--xperf_path', 19:24:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:24:20 INFO - 'tests': ['tp5n']}, 19:24:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:20 INFO - 'talos_options': ['--xperf_path', 19:24:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:24:20 INFO - 'tests': ['tp5n']}}, 19:24:20 INFO - 'talos.zip': {'path': '', 19:24:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:24:20 INFO - Running post-action listener: _resource_record_post_action 19:24:20 INFO - [mozharness: 2016-10-31 02:24:20.971636Z] Finished populate-webroot step (success) 19:24:20 INFO - [mozharness: 2016-10-31 02:24:20.971770Z] Running create-virtualenv step. 19:24:20 INFO - Running pre-action listener: _resource_record_pre_action 19:24:20 INFO - Running main action method: create_virtualenv 19:24:20 INFO - Creating virtualenv /builds/slave/test/build/venv 19:24: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 19:24:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:24:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:24:21 INFO - Using real prefix '/tools/python27' 19:24:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:24:21 INFO - Installing distribute.............................................................................................................................................................................................done. 19:24:24 INFO - Installing pip.................done. 19:24:24 INFO - Return code: 0 19:24:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:24: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')]} 19:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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')]} 19:24:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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 0x10e659490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5cf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a0d8cbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e46dd30>, '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 0x10e2d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e465b20>, '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.0Ddloed5wu/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.pJl21xQl8s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 19:24: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 19:24: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 19:24:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Ddloed5wu/Render', 19:24:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:24:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:24:24 INFO - 'HOME': '/Users/cltbld', 19:24:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:24:24 INFO - 'LOGNAME': 'cltbld', 19:24:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:24 INFO - 'MOZ_NO_REMOTE': '1', 19:24:24 INFO - 'NO_EM_RESTART': '1', 19:24:24 INFO - 'PAGER': '/bin/cat', 19:24:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:24:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:24 INFO - 'PWD': '/builds/slave/test', 19:24:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:24:24 INFO - 'SHELL': '/bin/bash', 19:24:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pJl21xQl8s/Listeners', 19:24:24 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 19:24:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:24:24 INFO - 'USER': 'cltbld', 19:24:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:24:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:24:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:24 INFO - 'XPC_FLAGS': '0x0', 19:24:24 INFO - 'XPC_SERVICE_NAME': '0', 19:24:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:24:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24: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 19:24:24 INFO - Cleaning up... 19:24:24 INFO - Return code: 0 19:24:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:24: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')]} 19:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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')]} 19:24:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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 0x10e659490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5cf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a0d8cbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e46dd30>, '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 0x10e2d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e465b20>, '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.0Ddloed5wu/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.pJl21xQl8s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 19:24: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 19:24: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 19:24:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Ddloed5wu/Render', 19:24:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:24:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:24:24 INFO - 'HOME': '/Users/cltbld', 19:24:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:24:24 INFO - 'LOGNAME': 'cltbld', 19:24:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:24 INFO - 'MOZ_NO_REMOTE': '1', 19:24:24 INFO - 'NO_EM_RESTART': '1', 19:24:24 INFO - 'PAGER': '/bin/cat', 19:24:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:24:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:24 INFO - 'PWD': '/builds/slave/test', 19:24:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:24:24 INFO - 'SHELL': '/bin/bash', 19:24:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pJl21xQl8s/Listeners', 19:24:24 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 19:24:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:24:24 INFO - 'USER': 'cltbld', 19:24:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:24:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:24:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:24 INFO - 'XPC_FLAGS': '0x0', 19:24:24 INFO - 'XPC_SERVICE_NAME': '0', 19:24:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:24:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:25 INFO - Downloading/unpacking psutil>=3.1.1 19:24: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 19:24: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 19:24: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 19:24: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 19:24: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 19:24: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 19:24:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:24:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:24:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:24:28 INFO - Installing collected packages: psutil 19:24:28 INFO - Running setup.py install for psutil 19:24:28 INFO - building 'psutil._psutil_osx' extension 19:24: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 19:24: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 19:24: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 19:24: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 19:24:29 INFO - building 'psutil._psutil_posix' extension 19:24: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 19:24:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:24:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:24:29 INFO - ^ 19:24:29 INFO - 1 warning generated. 19:24: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 19:24:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:24:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:24:29 INFO - Successfully installed psutil 19:24:29 INFO - Cleaning up... 19:24:29 INFO - Return code: 0 19:24:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:24: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')]} 19:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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')]} 19:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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 0x10e659490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5cf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a0d8cbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e46dd30>, '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 0x10e2d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e465b20>, '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.0Ddloed5wu/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.pJl21xQl8s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 19:24: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 19:24: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 19:24:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Ddloed5wu/Render', 19:24:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:24:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:24:29 INFO - 'HOME': '/Users/cltbld', 19:24:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:24:29 INFO - 'LOGNAME': 'cltbld', 19:24:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:29 INFO - 'MOZ_NO_REMOTE': '1', 19:24:29 INFO - 'NO_EM_RESTART': '1', 19:24:29 INFO - 'PAGER': '/bin/cat', 19:24:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:24:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:29 INFO - 'PWD': '/builds/slave/test', 19:24:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:24:29 INFO - 'SHELL': '/bin/bash', 19:24:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pJl21xQl8s/Listeners', 19:24:29 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 19:24:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:24:29 INFO - 'USER': 'cltbld', 19:24:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:24:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:24:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:29 INFO - 'XPC_FLAGS': '0x0', 19:24:29 INFO - 'XPC_SERVICE_NAME': '0', 19:24:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:24:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:24: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 19:24: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 19:24: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 19:24: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 19:24: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 19:24: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 19:24:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:24:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:24:32 INFO - Installing collected packages: mozsystemmonitor 19:24:32 INFO - Running setup.py install for mozsystemmonitor 19:24:32 INFO - Successfully installed mozsystemmonitor 19:24:32 INFO - Cleaning up... 19:24:32 INFO - Return code: 0 19:24:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:24: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')]} 19:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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')]} 19:24:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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 0x10e659490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5cf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a0d8cbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e46dd30>, '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 0x10e2d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e465b20>, '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.0Ddloed5wu/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.pJl21xQl8s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 19:24: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 19:24: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 19:24:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Ddloed5wu/Render', 19:24:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:24:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:24:32 INFO - 'HOME': '/Users/cltbld', 19:24:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:24:32 INFO - 'LOGNAME': 'cltbld', 19:24:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:32 INFO - 'MOZ_NO_REMOTE': '1', 19:24:32 INFO - 'NO_EM_RESTART': '1', 19:24:32 INFO - 'PAGER': '/bin/cat', 19:24:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:24:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:32 INFO - 'PWD': '/builds/slave/test', 19:24:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:24:32 INFO - 'SHELL': '/bin/bash', 19:24:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pJl21xQl8s/Listeners', 19:24:32 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 19:24:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:24:32 INFO - 'USER': 'cltbld', 19:24:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:24:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:24:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:32 INFO - 'XPC_FLAGS': '0x0', 19:24:32 INFO - 'XPC_SERVICE_NAME': '0', 19:24:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:24:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:32 INFO - Downloading/unpacking jsonschema==2.5.1 19:24: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 19:24: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 19:24: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 19:24: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 19:24: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 19:24: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 19:24:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:24:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:24: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 19:24: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 19:24: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 19:24: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 19:24: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 19:24: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 19:24:35 INFO - Downloading functools32-3.2.3-2.tar.gz 19:24:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:24:35 INFO - warning: no files found matching '*.txt' 19:24:36 INFO - no previously-included directories found matching 'build' 19:24:36 INFO - no previously-included directories found matching 'dist' 19:24:36 INFO - no previously-included directories found matching '.git*' 19:24:36 INFO - Installing collected packages: jsonschema, functools32 19:24:36 INFO - Running setup.py install for functools32 19:24:36 INFO - warning: no files found matching '*.txt' 19:24:36 INFO - no previously-included directories found matching 'build' 19:24:36 INFO - no previously-included directories found matching 'dist' 19:24:36 INFO - no previously-included directories found matching '.git*' 19:24:36 INFO - Successfully installed jsonschema functools32 19:24:36 INFO - Cleaning up... 19:24:36 INFO - Return code: 0 19:24:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:24: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')]} 19:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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')]} 19:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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 0x10e659490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5cf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a0d8cbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e46dd30>, '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 0x10e2d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e465b20>, '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.0Ddloed5wu/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.pJl21xQl8s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 19:24: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 19:24: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 19:24:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Ddloed5wu/Render', 19:24:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:24:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:24:36 INFO - 'HOME': '/Users/cltbld', 19:24:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:24:36 INFO - 'LOGNAME': 'cltbld', 19:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:36 INFO - 'MOZ_NO_REMOTE': '1', 19:24:36 INFO - 'NO_EM_RESTART': '1', 19:24:36 INFO - 'PAGER': '/bin/cat', 19:24:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:36 INFO - 'PWD': '/builds/slave/test', 19:24:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:24:36 INFO - 'SHELL': '/bin/bash', 19:24:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pJl21xQl8s/Listeners', 19:24:36 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 19:24:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:24:36 INFO - 'USER': 'cltbld', 19:24:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:24:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:36 INFO - 'XPC_FLAGS': '0x0', 19:24:36 INFO - 'XPC_SERVICE_NAME': '0', 19:24:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:24:36 INFO - Cleaning up... 19:24:36 INFO - Return code: 0 19:24:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:24: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')]} 19:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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')]} 19:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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 0x10e659490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5cf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a0d8cbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e46dd30>, '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 0x10e2d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e465b20>, '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.0Ddloed5wu/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.pJl21xQl8s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 19:24: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 19:24: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 19:24:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Ddloed5wu/Render', 19:24:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:24:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:24:36 INFO - 'HOME': '/Users/cltbld', 19:24:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:24:36 INFO - 'LOGNAME': 'cltbld', 19:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:36 INFO - 'MOZ_NO_REMOTE': '1', 19:24:36 INFO - 'NO_EM_RESTART': '1', 19:24:36 INFO - 'PAGER': '/bin/cat', 19:24:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:36 INFO - 'PWD': '/builds/slave/test', 19:24:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:24:36 INFO - 'SHELL': '/bin/bash', 19:24:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pJl21xQl8s/Listeners', 19:24:36 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 19:24:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:24:36 INFO - 'USER': 'cltbld', 19:24:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:24:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:36 INFO - 'XPC_FLAGS': '0x0', 19:24:36 INFO - 'XPC_SERVICE_NAME': '0', 19:24:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:36 INFO - Downloading/unpacking blobuploader==1.2.4 19:24: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 19:24: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 19:24: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 19:24: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 19:24: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 19:24: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 19:24:39 INFO - Downloading blobuploader-1.2.4.tar.gz 19:24:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:24:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:24: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 19:24: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 19:24: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 19:24: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 19:24: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 19:24: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 19:24:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:24:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:24: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 19:24: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 19:24: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 19:24: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 19:24: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 19:24: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 19:24:40 INFO - Downloading docopt-0.6.1.tar.gz 19:24:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:24:40 INFO - Installing collected packages: blobuploader, requests, docopt 19:24:40 INFO - Running setup.py install for blobuploader 19:24:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:24:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:24:40 INFO - Running setup.py install for requests 19:24:41 INFO - Running setup.py install for docopt 19:24:41 INFO - Successfully installed blobuploader requests docopt 19:24:41 INFO - Cleaning up... 19:24:41 INFO - Return code: 0 19:24:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:24: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')]} 19:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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')]} 19:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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 0x10e659490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5cf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a0d8cbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e46dd30>, '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 0x10e2d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e465b20>, '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.0Ddloed5wu/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.pJl21xQl8s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 19:24: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 19:24: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 19:24:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Ddloed5wu/Render', 19:24:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:24:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:24:41 INFO - 'HOME': '/Users/cltbld', 19:24:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:24:41 INFO - 'LOGNAME': 'cltbld', 19:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:41 INFO - 'MOZ_NO_REMOTE': '1', 19:24:41 INFO - 'NO_EM_RESTART': '1', 19:24:41 INFO - 'PAGER': '/bin/cat', 19:24:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:41 INFO - 'PWD': '/builds/slave/test', 19:24:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:24:41 INFO - 'SHELL': '/bin/bash', 19:24:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pJl21xQl8s/Listeners', 19:24:41 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 19:24:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:24:41 INFO - 'USER': 'cltbld', 19:24:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:24:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:41 INFO - 'XPC_FLAGS': '0x0', 19:24:41 INFO - 'XPC_SERVICE_NAME': '0', 19:24:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:24:41 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Xi5Jn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:24:41 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-tqaPX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:24:42 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-AJGzAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:24:42 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-TwRHxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:24:42 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-qMfh86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:24:42 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-kbYw6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:24:42 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-yvrOp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:24:42 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Szf1HT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:24:42 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-HOR6VH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:24:42 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-ziC7C8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:24:42 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-wUXeOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:24:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-n24_Jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:24:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-XaeYso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:24:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-M090qO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-mfyq8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:24:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-L8Lb8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:24:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-sYjSEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:24:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:24:43 INFO - Running setup.py install for manifestparser 19:24:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:24:43 INFO - Running setup.py install for mozcrash 19:24:43 INFO - Running setup.py install for mozdebug 19:24:44 INFO - Running setup.py install for mozdevice 19:24:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:24:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:24:44 INFO - Running setup.py install for mozfile 19:24:44 INFO - Running setup.py install for mozhttpd 19:24:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:24:44 INFO - Running setup.py install for mozinfo 19:24:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:24:44 INFO - Running setup.py install for mozInstall 19:24:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:24:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:24:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:24:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:24:44 INFO - Running setup.py install for mozleak 19:24:44 INFO - Running setup.py install for mozlog 19:24:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:24:45 INFO - Running setup.py install for moznetwork 19:24:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:24:45 INFO - Running setup.py install for mozprocess 19:24:45 INFO - Running setup.py install for mozprofile 19:24:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:24:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:24:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:24:45 INFO - Running setup.py install for mozrunner 19:24:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:24:45 INFO - Running setup.py install for mozscreenshot 19:24:45 INFO - Running setup.py install for moztest 19:24:46 INFO - Running setup.py install for mozversion 19:24:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:24:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:24:46 INFO - Cleaning up... 19:24:46 INFO - Return code: 0 19:24:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:24: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')]} 19:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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')]} 19:24:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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 0x10e659490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5cf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a0d8cbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e46dd30>, '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 0x10e2d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e465b20>, '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.0Ddloed5wu/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.pJl21xQl8s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 19:24: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 19:24: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 19:24:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Ddloed5wu/Render', 19:24:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:24:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:24:46 INFO - 'HOME': '/Users/cltbld', 19:24:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:24:46 INFO - 'LOGNAME': 'cltbld', 19:24:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:46 INFO - 'MOZ_NO_REMOTE': '1', 19:24:46 INFO - 'NO_EM_RESTART': '1', 19:24:46 INFO - 'PAGER': '/bin/cat', 19:24:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:24:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:46 INFO - 'PWD': '/builds/slave/test', 19:24:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:24:46 INFO - 'SHELL': '/bin/bash', 19:24:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pJl21xQl8s/Listeners', 19:24:46 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 19:24:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:24:46 INFO - 'USER': 'cltbld', 19:24:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:24:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:24:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:46 INFO - 'XPC_FLAGS': '0x0', 19:24:46 INFO - 'XPC_SERVICE_NAME': '0', 19:24:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:24:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:24:46 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-c_uf3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:24:47 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)) 19:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:24:47 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-mvULj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:24:47 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)) 19:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:24:47 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-ebumdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:24:47 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)) 19:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:24:47 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-AS2Gqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:24:47 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)) 19:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:24:47 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-QHSu6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:24:47 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)) 19:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:24:47 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-CqD6pX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:24:47 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)) 19:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:24:47 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-wU7F4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:24: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)) 19:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:24:47 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-9dcCBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:24: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)) 19:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:24:47 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-qDt87C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:24: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)) 19:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:24:47 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-1bMZPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:24: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)) 19:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:24:47 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-RlIRN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:24:48 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)) 19:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:24:48 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-pngSFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:24:48 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)) 19:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:24:48 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-_RHBoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:24:48 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)) 19:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:24:48 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-qHdIP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:24:48 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)) 19:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:48 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-HBI6hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:48 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)) 19:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:24:48 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-p2aSlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:24: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)) 19:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:24:48 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-b7_Qse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:24: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)) 19:24: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)) 19:24: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)) 19:24: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)) 19:24: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)) 19:24: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)) 19:24:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:24: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 19:24: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 19:24: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 19:24: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 19:24: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 19:24: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 19:24:51 INFO - Downloading blessings-1.6.tar.gz 19:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:24:51 INFO - Installing collected packages: blessings 19:24:51 INFO - Running setup.py install for blessings 19:24:51 INFO - Successfully installed blessings 19:24:51 INFO - Cleaning up... 19:24:51 INFO - Return code: 0 19:24:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:24:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:24:52 INFO - Reading from file tmpfile_stdout 19:24:52 INFO - Current package versions: 19:24:52 INFO - blessings == 1.6 19:24:52 INFO - blobuploader == 1.2.4 19:24:52 INFO - docopt == 0.6.1 19:24:52 INFO - functools32 == 3.2.3-2 19:24:52 INFO - jsonschema == 2.5.1 19:24:52 INFO - manifestparser == 1.1 19:24:52 INFO - mozInstall == 1.12 19:24:52 INFO - mozcrash == 0.17 19:24:52 INFO - mozdebug == 0.1 19:24:52 INFO - mozdevice == 0.48 19:24:52 INFO - mozfile == 1.2 19:24:52 INFO - mozhttpd == 0.7 19:24:52 INFO - mozinfo == 0.9 19:24:52 INFO - mozleak == 0.1 19:24:52 INFO - mozlog == 3.4 19:24:52 INFO - moznetwork == 0.27 19:24:52 INFO - mozprocess == 0.23 19:24:52 INFO - mozprofile == 0.28 19:24:52 INFO - mozrunner == 6.12 19:24:52 INFO - mozscreenshot == 0.1 19:24:52 INFO - mozsystemmonitor == 0.3 19:24:52 INFO - moztest == 0.7 19:24:52 INFO - mozversion == 1.4 19:24:52 INFO - psutil == 3.1.1 19:24:52 INFO - requests == 1.2.3 19:24:52 INFO - wsgiref == 0.1.2 19:24:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:24: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')]} 19:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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')]} 19:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:52 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 0x10e659490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5cf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a0d8cbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e46dd30>, '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 0x10e2d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e465b20>, '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.0Ddloed5wu/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.pJl21xQl8s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 19:24:52 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 19:24:52 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 19:24:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Ddloed5wu/Render', 19:24:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:24:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:24:52 INFO - 'HOME': '/Users/cltbld', 19:24:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:24:52 INFO - 'LOGNAME': 'cltbld', 19:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:52 INFO - 'MOZ_NO_REMOTE': '1', 19:24:52 INFO - 'NO_EM_RESTART': '1', 19:24:52 INFO - 'PAGER': '/bin/cat', 19:24:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:52 INFO - 'PWD': '/builds/slave/test', 19:24:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:24:52 INFO - 'SHELL': '/bin/bash', 19:24:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pJl21xQl8s/Listeners', 19:24:52 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 19:24:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:24:52 INFO - 'USER': 'cltbld', 19:24:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:24:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:52 INFO - 'XPC_FLAGS': '0x0', 19:24:52 INFO - 'XPC_SERVICE_NAME': '0', 19:24:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:52 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)) 19:24:52 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)) 19:24:52 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)) 19:24:52 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)) 19:24:52 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)) 19:24:52 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)) 19:24:52 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)) 19:24:52 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)) 19:24:52 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)) 19:24:52 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)) 19:24:52 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)) 19:24:52 INFO - Cleaning up... 19:24:52 INFO - Return code: 0 19:24:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:24: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')]} 19:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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')]} 19:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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 0x10e659490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5cf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a0d8cbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e46dd30>, '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 0x10e2d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e465b20>, '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.0Ddloed5wu/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.pJl21xQl8s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 19:24: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 19:24: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 19:24:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Ddloed5wu/Render', 19:24:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:24:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:24:52 INFO - 'HOME': '/Users/cltbld', 19:24:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:24:52 INFO - 'LOGNAME': 'cltbld', 19:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:52 INFO - 'MOZ_NO_REMOTE': '1', 19:24:52 INFO - 'NO_EM_RESTART': '1', 19:24:52 INFO - 'PAGER': '/bin/cat', 19:24:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:52 INFO - 'PWD': '/builds/slave/test', 19:24:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:24:52 INFO - 'SHELL': '/bin/bash', 19:24:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pJl21xQl8s/Listeners', 19:24:52 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 19:24:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:24:52 INFO - 'USER': 'cltbld', 19:24:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:24:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:52 INFO - 'XPC_FLAGS': '0x0', 19:24:52 INFO - 'XPC_SERVICE_NAME': '0', 19:24:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:24:52 INFO - Cleaning up... 19:24:52 INFO - Return code: 0 19:24:52 INFO - Running post-action listener: _resource_record_post_action 19:24:52 INFO - Running post-action listener: _start_resource_monitoring 19:24:52 INFO - Starting resource monitoring. 19:24:52 INFO - [mozharness: 2016-10-31 02:24:52.829480Z] Finished create-virtualenv step (success) 19:24:52 INFO - [mozharness: 2016-10-31 02:24:52.830425Z] Running install step. 19:24:52 INFO - Running pre-action listener: _resource_record_pre_action 19:24:52 INFO - Running main action method: install 19:24:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:24:53 INFO - Reading from file tmpfile_stdout 19:24:53 INFO - Detecting whether we're running mozinstall >=1.0... 19:24:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:24:53 INFO - Reading from file tmpfile_stdout 19:24:53 INFO - Output received: 19:24:53 INFO - Usage: mozinstall [options] installer 19:24:53 INFO - Options: 19:24:53 INFO - -h, --help show this help message and exit 19:24:53 INFO - -d DEST, --destination=DEST 19:24:53 INFO - Directory to install application into. [default: 19:24:53 INFO - "/builds/slave/test"] 19:24:53 INFO - --app=APP Application being installed. [default: firefox] 19:24:53 INFO - mkdir: /builds/slave/test/build/application 19:24:53 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'] 19:24:53 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 19:25:25 INFO - Reading from file tmpfile_stdout 19:25:25 INFO - Output received: 19:25:25 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 19:25:25 INFO - Running post-action listener: _resource_record_post_action 19:25:25 INFO - [mozharness: 2016-10-31 02:25:25.257393Z] Finished install step (success) 19:25:25 INFO - [mozharness: 2016-10-31 02:25:25.257538Z] Running run-tests step. 19:25:25 INFO - Running pre-action listener: _resource_record_pre_action 19:25:25 INFO - Running main action method: run_tests 19:25:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:25:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:25:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:25:25 INFO - 2016-10-30 19:25:25.272 screenresolution[1645:7774] starting screenresolution argv=screenresolution get 19:25:25 INFO - 2016-10-30 19:25:25.274 screenresolution[1645:7774] Display 0: 1600x1200x32@60 19:25:25 INFO - 2016-10-30 19:25:25.280 screenresolution[1646:7776] starting screenresolution argv=screenresolution list 19:25:25 INFO - Available Modes on Display 0 19:25:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:25:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:25:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:25:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:25:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:25:25 INFO - Intel Iris: 19:25:25 INFO - Chipset Model: Intel Iris 19:25:25 INFO - Type: GPU 19:25:25 INFO - Bus: Built-In 19:25:25 INFO - VRAM (Dynamic, Max): 1536 MB 19:25:25 INFO - Vendor: Intel (0x8086) 19:25:25 INFO - Device ID: 0x0a2e 19:25:25 INFO - Revision ID: 0x0009 19:25:25 INFO - Displays: 19:25:25 INFO - Display: 19:25:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:25:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:25:25 INFO - Display Serial Number: 1600x1200 60 19:25:25 INFO - Main Display: Yes 19:25:25 INFO - Mirror: Off 19:25:25 INFO - Online: Yes 19:25:25 INFO - Rotation: Supported 19:25:25 INFO - Return code: 0 19:25:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:25:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:25:25 INFO - Python 2.7.3 19:25:25 INFO - Return code: 0 19:25:25 INFO - grabbing minidump binary from tooltool 19:25: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')]} 19:25: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 0x10e46dd30>, '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 0x10e2d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e465b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:25: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 19:25: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 19:25: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 19:25:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:25:25 INFO - Return code: 0 19:25:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:25:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:25:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:25:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:25:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:25: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/WZAEwcKWQjeNLBtC9q2aGg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--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 19:25: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/WZAEwcKWQjeNLBtC9q2aGg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0082 --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 19:25:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Ddloed5wu/Render', 19:25:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:25:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:25:25 INFO - 'HOME': '/Users/cltbld', 19:25:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:25:25 INFO - 'LOGNAME': 'cltbld', 19:25:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:25:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:25:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:25 INFO - 'MOZ_NO_REMOTE': '1', 19:25:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:25:25 INFO - 'NO_EM_RESTART': '1', 19:25:25 INFO - 'PAGER': '/bin/cat', 19:25:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:25:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:25 INFO - 'PWD': '/builds/slave/test', 19:25:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:25:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:25:25 INFO - 'SHELL': '/bin/bash', 19:25:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pJl21xQl8s/Listeners', 19:25:25 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 19:25:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:25:25 INFO - 'USER': 'cltbld', 19:25:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:25:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:25:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:25 INFO - 'XPC_FLAGS': '0x0', 19:25:25 INFO - 'XPC_SERVICE_NAME': '0', 19:25:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:25: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/WZAEwcKWQjeNLBtC9q2aGg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--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 19:25:25 INFO - mozversion application_buildid: 20161030172021 19:25:25 INFO - mozversion application_changeset: b7070c905172e3ead8ee610fff35f86bf9ff9c42 19:25:25 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:25:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:25:25 INFO - mozversion application_name: Firefox 19:25:25 INFO - mozversion application_remotingname: firefox-dev 19:25:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:25:25 INFO - mozversion application_vendor: Mozilla 19:25:25 INFO - mozversion application_version: 51.0a2 19:25:25 INFO - mozversion platform_buildid: 20161030172021 19:25:25 INFO - mozversion platform_changeset: b7070c905172e3ead8ee610fff35f86bf9ff9c42 19:25:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:25:25 INFO - mozversion platform_version: 51.0a2 19:25:25 INFO - using testdate: 1477880725 19:25:25 INFO - actual date: 1477880725 19:25:25 INFO - starting webserver on 'localhost:49280' 19:25:25 INFO - SUITE-START | Running 2 tests 19:25:25 INFO - TEST-START | dromaeo_css 19:25:25 INFO - operating with platform_type : mac_ 19:25:25 INFO - Initialising browser for dromaeo_css test... 19:25:25 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmp2Pmxxi/profile http://localhost:49280/getInfo.html) 19:25:28 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 19:25:28 INFO - PROCESS | 1656 | colorDepth:24 19:25:28 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 19:25:28 INFO - PROCESS | 1656 | __metrics 19:25:28 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 19:25:29 INFO - TEST-INFO | 1656: exit 0 19:25:29 INFO - Browser initialized. 19:25:29 INFO - Running cycle 1/1 for dromaeo_css test... 19:25:29 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmp2Pmxxi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:25:41 INFO - PROCESS | 1659 | RSS: Main: 225607680 19:25:41 INFO - PROCESS | 1659 | 19:26:31 INFO - PROCESS | 1659 | 1477880791117 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] 19:28:44 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 19:28:46 INFO - PROCESS | 1659 | RSS: Main: 235085824 19:28:46 INFO - PROCESS | 1659 | 19:31:48 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 19:31:49 INFO - PROCESS | 1659 | RSS: Main: 248152064 19:31:49 INFO - PROCESS | 1659 | 19:34:51 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 19:34:51 INFO - PROCESS | 1659 | RSS: Main: 251236352 19:34:51 INFO - PROCESS | 1659 | 19:37:53 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 19:37:54 INFO - PROCESS | 1659 | RSS: Main: 251547648 19:37:54 INFO - PROCESS | 1659 | 19:40:57 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 19:40:57 INFO - PROCESS | 1659 | RSS: Main: 256847872 19:40:57 INFO - PROCESS | 1659 | 19:44:00 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 19:44:00 INFO - PROCESS | 1659 | RSS: Main: 258318336 19:44:00 INFO - PROCESS | 1659 | 19:44:00 INFO - PROCESS | 1659 | __start_tp_report 19:44:00 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 19:44:00 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 19:44:00 INFO - PROCESS | 1659 | |i|pagename|runs| 19:44:00 INFO - PROCESS | 1659 | |0;dojo.html;3177.6663450337714;3443.776154549954;3458.6541345865417;3463.9307213855723;3467.913302167444;4862.2220444728855;5919.911201331984;5936.228290322263;5971.790987315445;5991.460768530831;5805.970970145143;5945.88108237835;5953.732082056318;5955.672438015908;5979.252593425822;5315.01672190645;5372.355317361922;5422.15956526739;5422.647527910693;5449;5392.433794451585;5397.217403476494;5404.675719456845;5422.132458806592;5465.398806131322;5215.400228973679;5278.551323137519;5419.729013549327;5432.239486471897;5440.319960004999;5361.865953351158;5370.462953704638;5388.973055134699;5389.922015596896;5391.299131112969;5202.687838729688;5356.9732151339385;5357.357117145929;5370.758315875795;5395.190721391823;4346.56534346566;5500.064988951848;5952.58331916766;5961.225040744675;5981.342052374235;4974.303597496353;5368.489993450616;6273.811785646392;6300.21247344082;6302;6157.291911430153;6240.750369985195;6259.280182778948;6272.3100458949475;6331.715072821734;5874.0014197586515;5959.582829201958;6006.039033754622;6045;6054.485368743618;5767;5769.942300577024;6193.4425901669065;6250.374962503804;6445.16212892321;5404.54061404785;6106.572539922163;6160.860240855456;6208.9689551551955;6255.593386429959;6248.0003199487865;6270.2789179244055;6325.620462772248;6341.302456729756;6349.238091429058;6207.193064901534;6300;6323.715432805535;6325.4939604832425;6326.5255105867245;6171.59884607499;6223.377662233831;6273.309935907047;6279.591826531261;6315.147455093595;5011.974940125276;5013.298138260647;5035.471275516092;5040.067587496325;5041.697498150123;4431.091626216617;4506.662000349987;4522.208613492626;4529.297958816389;4555.863324100283;5815.621984570989;5926.644401335848;5978.790742323998;5996.16053752475;6086.573939824169;6301.6219026858535;6303.117563541108;6318.336574659686;6320.304766475684;6353.872922541524;6019.398060193946;6040.60736052164;6073.271207455134;6079.8480037998515;6095.451409373178;5431.2396264522995;5450.127979523258;5494.560435165257;5498.010358135574;5526.032944234743;6446.645434501053;6510.902336465051;6513.283538810632;6532.902006469812;6546.738130474728;6244.687765611792;6332.620042797447;6334.461570766352;6341;6351.428371446592;6310.684465776784;6334.841628959313;6353.7140828661895;6371.585846919936;6463.903041454288;5911.201987731602;6314.052892066226;6325;6335.081413194969;6336.809895703136;6173.166622505904;6242.843928901813;6328.14570033058;6328.272248691275;6354.90467642995;6120.357362476876;6161.168242287234;6176.258848938156;6223.471004964629;6286.497080233662;6244.375562443719;6254;6290.21372328459;6299.433051025429;6317;5952.345242023461;6133.539984501091;6165.938340616716;6189.04069869171;6205.348438414082;6081.756729730761;6128.53367901495;6170.197874276315;6179.660118693515;6217.253929528486;6131.376666649982;6140.4473597376455;6142.32434432221;6170.136180934763;6170.382961703794 19:44:00 INFO - PROCESS | 1659 | |1;ext.html;475.18031395842166;477.6871149397145;516.4319248826293;542.7503348459709;545.3918880448301;27965;42372.72881813543;42374;44636.776816115875;45024;32914.17714557131;36531.81734091326;38390.23219535615;43330.133397332036;43861.12277754451;8327.83344333113;9653.17947974423;9837.90162098377;9866;9866.457344846067;9108.316876234308;9226.40028398152;9818.263630227726;9913.306068575203;9937.354071985334;9902.455364954925;9930.05664461875;9943.552540135712;9943.900560994405;9944;9912.653057143001;9922.801543969152;9925.106740393363;9942.950285248528;9968.102870741595;9836.901630983743;9899.307048506607;9903.25725570585;9905.851412228822;9908.851367229498;41463.37804932929;41876.58123418757;42324.78837605823;42351.57648423507;42477;3336.3225144793632;3564.198055437506;3568.91077723059;4032.697547683906;4135.648469880064;30694.84652576745;32026.83986580052;32068.518972215435;32342.353152937045;32493.187670308194;3242.238074052596;3306.8511916963794;3307.2889328794186;3322.368749937504;3333.0500807269814;526493;530824;531689;531885;532081;33722.831385843405;60584.394156058755;61074;61093.69453152706;61139.08291375544;34248.97253082412;35657;35850;36028.459573106426;36056.45915311272;12175.573854915036;14912.254387280593;15059.397624094914;15244.771328430083;15269.236538173047;10950.452477376259;12788.232706037481;12861.485540578458;12873.549425770241;12891.35543222835;7046.471514636422;7758;7789.065312162464;7842.490238134503;7939.722109726132;2854.7716182705335;3221.2430078931434;3221.4362486564755;3224.290656055664;3250.317433338978;903.5075883643431;916.3356566489242;1047.6123834181249;1072.7961687279392;1110.2838669058413;26710.328967103524;27567.44865102687;30229.09312720622;30666.846665766527;31832.363352732817;986.6842610364614;1042.9414144643192;1065.840123981409;1077.6551503518956;1126.4086354663702;15809.604759880865;16274.75587866183;16339.346426142822;16378.181090945405;16655.6668866622;719260;719867;727598;728998;732743;60719.39280607137;60777.69611152005;61209.69395152996;61260;61278;1376.8898488120926;1385.757492438819;1411.6047506698142;1413.9717205656034;1421.4243231491262;30425.391492170475;31211.531827022158;31321.8433907829;31749.20626984344;31775.205619859687;52833.20750188827;53416.73291633517;53478.73260633672;53483;53512;650340.7482962555;654278;656954;660054;661444;27117.186484405498;27506.449871002867;27524.862375687993;27526.724732753217;27566.5865012021;35415.468767967985;47567.52432475631;47992;48721.51278487311;49001.509984901124;39393.63648177156;39849.60150398575;40089.59910400975;40428.393574097;41403.378949316386;39807;39826.80086599549;40234.597654023084;40748;41098.383524246565;38928.6107138925;39238.607613923494;40053;40214.994625134605;41264.587354127274;32229.838850805594;35811.462828058124;35815.46276805902;36049;36353;26331.078412256244;26724.465510690065;26895.65521723945;26986.425881718827;27083.45833083288 19:44:00 INFO - PROCESS | 1659 | |2;jquery.html;345.48867675839756;373.54054512949057;381.06638735099017;383.331087252744;400.2155774681624;19774.11016504257;20814.063367148476;20856.47858803531;21209.57580848384;21515.784842151574;20179;20549.794502054974;20656.380308590728;20823.687644685306;20906.05922733477;5758.712064396764;5894.823155305347;6032.396760323976;6120.357362476942;6122.63264204147;3893.669038131748;4085.142120154771;6088.695565221743;6119.296280927683;6123.173371594845;5771.365149833536;6085.391460853902;6144.0783882417545;6165.815025549218;6181.81454556364;5954.077118046688;6005.009173486348;6099.085137229406;6104.08438734189;6166.290876549187;5875.823725288248;5886.646801191942;5895.35151133375;5898.911516327258;5905.734241959122;10955.56177752889;11649.359285239309;21285.893570532047;24949.376265593506;25197.874010630014;1984.8908310042941;2345.0736958901307;2355.2934119764004;2448.926532204037;2550.655661485694;8375.20435558621;10027.047430494164;10371.636992705295;10460.843087353696;14327.638874306924;1705.3008266610755;1824.8813827101196;1841.7881943576526;1930.7779605345424;1933.5069557262948;122317;125694.37152814177;125769;127008;128964.35517822445;9705.320627556004;11190.888091118984;11621.535138594361;11635.360055197045;11690.181687281978;14527.78208326876;14528.927355363156;14536.563903082924;14542.636434089232;14564.053336533092;8326.916730832614;8559.74320770378;8571.442856214326;8651.956740216385;8721.694740684046;8416.368772342099;8540.060593334729;8549.444286121383;8670.393072484865;8681.04508504064;4440.600345968878;4486.259767138451;4511.917139886469;4544.431946006749;4622.9768851156205;1575.850294222047;1661.2773443552094;1668.7663727078218;1778.510909499898;1988.3140316590752;812.4353574265829;890.123228619809;896.914793094655;930.5486838883136;947.9810403791886;16258.51224463268;20252.594948100956;20509.692354614694;20593.279235226695;20679.069441875152;898.9415687980392;908.6637943960777;936.4287784451479;942.072059021863;981.259149342242;10785.29895556802;10997.890021099847;11015.339079655247;11049.944750276198;11063.280886742335;475405;477700;481316;643696;645987;116705;117216;129809.35095324463;133474.33262833624;136611;950.6245033211843;967.1489089601106;1005.7535903703639;1010.6614284214724;1013.5084484025242;17919.46241612754;18440.262389504805;18593.07034648289;18598.907005465426;18672.25310987545;52436.47563524316;52644.94710105853;53038.67403314948;53850.115245966204;56349;71034.28965710277;72755.63622181855;73536.63231684022;73652.63173684098;74772;7197.820054498679;7269.781906542812;7307.561546307238;7552.055993000875;8147.981502312211;8522.786930326543;12011.63965081049;12044.457999390224;12271.815922760987;12371.938140309241;10211.387316761018;10253.74365640865;10388.896111038794;10646.84029739539;10691.732706682084;10364.222683298633;10581;10609.416482093558;10638;10665.733356666145;10706.678799636024;10727.678169654922;10760.623378181726;10794.298370605886;11146.386948717898;7683.346915512244;7930.088039875488;8018.797180422983;8081.83836323282;8167.469114507538;10007.249456290661;10609.681709548726;10687.30532515384;10699.304545204537;10732.731681707708 19:44:00 INFO - PROCESS | 1659 | |3;mootools.html;1392.1368751374146;1545.7526795712686;1748.0298434368929;1844.5941892783583;1893.5834116494366;7927.691930831405;8014.998125234346;8557.358198135142;9153.176214140725;9290.21033212177;7845.37237021037;8847.867281990775;8870.112988701127;8945.731628051153;8967.686130985418;2368.1593034472817;2415.625578035407;2417.1177520205088;2428.138011006094;2432.8905199266073;2033;2390.988045059772;2425.1148330859196;2429.1983645397063;2431.7203521595065;2127.2129312154525;2353.4234112642425;2402.3633737059695;2415.4323733922515;2431.9756802431925;2387.510560335127;2390.474095698952;2402.25530085674;2404.651325557793;2416.854988700666;2376.5009348036933;2396.161343529768;2397.568437681217;2400.6399040143942;2410.9397265068337;8211.83576328476;8604.795328653994;8886.06696296886;9011.143941325563;9079.727608171765;5303.814366497154;5424.620276580641;5431.592630552725;5443.455654434564;5443.482869127427;3095.520194369876;3644.4351125575577;3668.926621467556;3693.3905905525826;3709.3694072007825;1093.8632670916136;1099.4667586220676;1099.8625171853519;1110.3171549497001;1111.8554587903602;11689.473973671205;11786.941065294704;11803.586874459354;11907.34509601963;11913.642590722293;3945.151792364655;4624.583787459078;4884.096442158212;4887.218045112836;4902.975485122623;10043.648472303434;10117.291789574807;10137.189024877993;10143.985601439945;10165.186785057325;5408.729563521808;5423;5436.401995780461;5436.510714035756;5438.15708565173;4406.625436837905;4568.6116680081905;4804.2073057945745;4920.114379411741;4987.501249875056;4017.7589344639414;4024.1348110156455;4093.7953102344763;4131.814068366931;4135.0902801383645;1076.8007918535095;1278.4055414232241;1281.6603600045996;1286.0611753420055;1289.1233960906486;859.282499113235;878.3939082033377;904.8099899021279;918.1736437206567;941.3739862991171;5814.825555233349;6021.759129634853;6111.174991376196;6154.230721159855;6174.448567818444;444.9644028477714;447.4988013424985;461.22053729197546;468.94841567427557;469.9801430894966;3972.8808135755394;4011.6590089842107;4017.819198136091;4032.6370626643156;4054.189162167578;10450.425226612457;10964.068054215322;10990.285631433931;11012;11039.724006899893;10939.070179034712;10944.781104377867;10960;10989.230753847154;11004.614838480615;8202.466839655403;8246.670133194724;8290.295324897452;8408.495490270481;8425.368097392597;5747.5689323300085;5770.538356931352;5936.851578710567;5942.6731529766275;6067.787627433018;9985.850212246967;10003.34978226413;10184.083432491112;10231.43727095017;10231.94884025605;10094.495275236355;10183.79632407333;10187.235957303381;10315.329503582543;10538.947305263424;5710.657360558213;6820.31796820314;6961.338672826276;7577.962110189414;7722.575258360844;7691.538507689333;8545.700900468702;8599.742007739778;8604.870926936226;8790.648374064966;7410.4442166836625;7508.249175082667;7651.846963060819;7727.459077864495;7764.456488046008;7374.410047196104;7475.439342049477;7488.700451981859;7497.650422923926;7508.0239568855695;6964.721411143498;7110.608916509642;7135.500514963903;7138.286171382821;7150.320719531636;3952.8418863245147;4410.272305069628;4995.100881841304;5003.199488082035;5154.020736060136;4488.775561221991;5054.69671819692;5104.872378190575;5229.947700522946;5231.0845602018735 19:44:00 INFO - PROCESS | 1659 | |4;prototype.html;304.4611038461921;305.1227720304126;312.9530570414438;317.7156444981743;317.80931441135306;4667.29990501425;5458.789190377904;5467.0705979983395;5534.837684086342;5642.68965206914;4765.332853400527;4905.96974635327;5192.792288308473;5297.284866543016;5481.260029895963;3992.3612222044408;4170.937435938464;4216.756056963203;4257.467816522934;4262.424572682695;3746.7939263340504;3886.3587508061137;3978.547830042028;4226.788660566975;4278.807453664577;4163.188178305231;4177.892858392528;4195.559466256045;4207.936880946788;4249.766262855542;3698.815059247027;3919.686904886866;3952.960470395288;3998.6601138903084;4188.32986722126;3411.573553305837;3588.1567831559564;3632.673059424638;3643.3786964800674;3659.304732100919;4272.893177670552;4566;5270.209468579706;5361.437049109865;5403.51368376844;4208.431861698662;4614.653900957442;4840.201366774478;4843.757812109416;4880.829170979035;5048.7223202723835;5748.367679555246;5885.676287804169;5887.293524777011;5921.61509501881;3657.7073834093208;3898.707596930213;3928.2339943710986;3930.567637559866;3932.410138479251;6266.467350275232;6282.591631543935;6284.560080794392;6329.303776584572;6330.588511746721;3352.7150192233444;3380.7802492837886;4001.91996160081;4018.738781979162;4026.7583944963394;3309.9007029789145;3389.9491507627404;3633.509476220729;3840.9807950960067;4106.07613287014;3997.7801220932547;4730.432348118179;4777.631769602422;4844.539768721966;4852.684575502652;4746.0745154694505;4885.413750349981;5114.156164232934;5900.468957793819;5973.761049557969;1149.9252548584316;1240.6588188248124;1331.633800704814;1375.69734658375;1390.7344316671781;802.4342838298985;850.6937502499095;894.8881389826272;903.1420150856712;929.3540989012571;4214.536400995888;4692.451491007959;5242.112839377821;5340.706261155596;5592.384837667853;6000.009998350223;6045.697715114226;6046.758129674852;6060.424259695322;6146.569740118238;4090.3046482098116;5059.684482034624;5234.377721055488;5520.447955204448;5535.640183388067;2506.0578052009837;2541.377362546188;2550.477152183798;2708.3635345693747;2739.3974524902756;4447.844325448594;4918.803247870045;5119.897602048012;5251.293329667873;5350.394881535523;4360.454943132108;4734.786934587952;5151;5155.510226528474;5173.258173168227;4623.838165664186;4892.730899800546;4965.8013679452415;5215.791368345223;5223.921641175385;4574.61115805147;4695.741734204652;5033.194688849767;5043.402647636397;5057.69653820772;5021.949780502148;5061.204096927305;5361.758720857492;5604.8318550443555;6203;5742.684152371659;6237.251529816451;6330.8100756977365;6407.807765767035;6501.804945851442;3341.348437054751;3703.2778608171147;4153.1070819773895;4270.338097594878;4293.5706429356815;4950.727709975986;5926.466618004228;6077.453029227391;6120.8775824484155;6166.969165154145;5561.416051314553;5574.738777814861;5805.8548536286935;5904.202932604044;5923.526117910471;5847.1229315603;5850.707464626837;5905.8188362328565;5936.7143649696045;5953.523718102628;5492.340919089735;5706.629069110494;5766;5774.152271273152;5899.852503687443;5237.607179461479;5717.056685646821;5922.78582890515;5923.259592550931;5936.050231962865;5408;5508.457631863084;5784.21913041734;5811.5541610668715;5890.970545147418 19:44:00 INFO - PROCESS | 1659 | |5;yui.html;628.8019273928712;729.3654520567108;753.2580408297829;771.0939645916051;800.3397197312219;15003;15615.453459128932;15693.136877471748;15698.37206511741;15732.921335393336;13911.234882081482;14139.434422623108;14255.144691318503;14271;14411.495597654084;863.8315528471951;869.4739682492096;879.248242752447;883.7392969074139;885.9734207973771;861.1388611388611;880.7005618089848;882.5851849630695;884.9026607073249;886.9068747781487;897.2866571076011;912.4662072687486;927.420362273579;931.0270767048451;935.111643938258;858.107568129145;915.0163574157774;919.5218486387041;921.5162039929024;922.5940586142076;683.665004147969;686.605202008842;687.2714922182453;688.0470548290654;689.0594338727651;10265.332753371007;13957.860421395859;14122.082064665763;14163.929180354135;14174.220417877013;10846.891531084668;10944.56221751129;12835.807462888064;13370.933145334211;13790.793138102936;11281.379524126252;11680.707982300426;11943.522259109624;11991.820122698167;12027.458764355624;3149.6062992125985;3221.25911040462;3377.3414184234084;3857.40210267409;3860.7297489175767;99841.5007924963;108964;109333.45333273282;111120.44439777831;115622;10129.936356682441;10407.53166107527;10754.03213710754;11108.444577771079;11569.76860462786;21192;21759.67360489594;22522;22720.772792272197;22760.31719048431;8121.187881211831;8162.6734930602115;8186.959065204635;8213.425060245725;8538.829223415496;4548;4551.52209018055;4626.352310676508;4638.304254361873;4650.279206722963;3638.290533346025;3742.5134732484603;3745.606711295329;3747.3816820224356;3753.60587138352;506.8732816795801;507.908576456234;511.39655206855525;512.9923051154236;513.3429210610425;620.4354037825648;637.3912913167914;663.3598577372859;696.6586372677351;718.0629278791123;9034.954825225963;9456.621735130655;9614.759631009141;9741.123298903132;9820.44412514538;653.5947712418331;669.7890164598136;678.5962352400314;682.1405029662661;688.7072993977539;4614.307853821886;4732.290156476556;4736.4316282046375;4745.691530050535;4746.952530474651;95932.52033739787;128716.42567148792;161110;167765;174083.12958435126;91019.08980910106;94695.52652236832;139702;140991.99999999796;147640;75261.62369188228;119197;123152.38423807823;123325;129955;9693.137103329937;10217.33587316822;10301.175905927657;10331;10431.843522347323;50165.244216453706;65363.673181633785;65513.67243163754;66155.33844661685;67568.3243167562;94260;94383;100920.9907900941;101792.49103754434;102745.48627256816;12762.298073605669;13016.934915325362;13041.608751737464;13228.537001204912;13412.530561430303;14100.36548355306;14301.026487259925;14991.475298364505;15058.247087645794;15448.995815271972;13128.34358282063;13339;13748.450061997808;13919.4432222714;14534.709305814036;11261.436928153724;11416.915393037649;11515.596954106566;12103.697407564881;13969.95225358082;10554.525046372779;11572.942135289606;12004;12024.398780061138;12060;11381.601643942422;11614.896584824428;11649.301041937511;11858;12126;11465.713357166138;11566.190366674253;11763.823542646696;11817.881821182022;11849.289042657469 19:44:00 INFO - PROCESS | 1659 | __end_tp_report 19:44:00 INFO - PROCESS | 1659 | __start_cc_report 19:44:00 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,361 19:44:00 INFO - PROCESS | 1659 | __end_cc_report 19:44:00 INFO - PROCESS | 1659 | __startTimestamp1477881840906__endTimestamp 19:44:00 INFO - PROCESS | 1659 | 19:44:00 INFO - PROCESS | 1659 | ------- Summary: start ------- 19:44:00 INFO - PROCESS | 1659 | Number of tests: 6 19:44:00 INFO - PROCESS | 1659 | 19:44:00 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5834.91 Median:6095.45 stddev:652.43 (10.7%) stddev-sans-first:620.24 19:44:00 INFO - PROCESS | 1659 | Values: 3177.7 3443.8 3458.7 3463.9 3467.9 4862.2 5919.9 5936.2 5971.8 5991.5 5806.0 5945.9 5953.7 5955.7 5979.3 5315.0 5372.4 5422.2 5422.6 5449.0 5392.4 5397.2 5404.7 5422.1 5465.4 5215.4 5278.6 5419.7 5432.2 5440.3 5361.9 5370.5 5389.0 5389.9 5391.3 5202.7 5357.0 5357.4 5370.8 5395.2 4346.6 5500.1 5952.6 5961.2 5981.3 4974.3 5368.5 6273.8 6300.2 6302.0 6157.3 6240.8 6259.3 6272.3 6331.7 5874.0 5959.6 6006.0 6045.0 6054.5 5767.0 5769.9 6193.4 6250.4 6445.2 5404.5 6106.6 6160.9 6209.0 6255.6 6248.0 6270.3 6325.6 6341.3 6349.2 6207.2 6300.0 6323.7 6325.5 6326.5 6171.6 6223.4 6273.3 6279.6 6315.1 5012.0 5013.3 5035.5 5040.1 5041.7 4431.1 4506.7 4522.2 4529.3 4555.9 5815.6 5926.6 5978.8 5996.2 6086.6 6301.6 6303.1 6318.3 6320.3 6353.9 6019.4 6040.6 6073.3 6079.8 6095.5 5431.2 5450.1 5494.6 5498.0 5526.0 6446.6 6510.9 6513.3 6532.9 6546.7 6244.7 6332.6 6334.5 6341.0 6351.4 6310.7 6334.8 6353.7 6371.6 6463.9 5911.2 6314.1 6325.0 6335.1 6336.8 6173.2 6242.8 6328.1 6328.3 6354.9 6120.4 6161.2 6176.3 6223.5 6286.5 6244.4 6254.0 6290.2 6299.4 6317.0 5952.3 6133.5 6165.9 6189.0 6205.3 6081.8 6128.5 6170.2 6179.7 6217.3 6131.4 6140.4 6142.3 6170.1 6170.4 19:44:00 INFO - PROCESS | 1659 | 19:44:00 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:75065.46 Median:22133.65 stddev:172581.82 (779.7%) stddev-sans-first:172975.09 19:44:00 INFO - PROCESS | 1659 | Values: 475.2 477.7 516.4 542.8 545.4 27965.0 42372.7 42374.0 44636.8 45024.0 32914.2 36531.8 38390.2 43330.1 43861.1 8327.8 9653.2 9837.9 9866.0 9866.5 9108.3 9226.4 9818.3 9913.3 9937.4 9902.5 9930.1 9943.6 9943.9 9944.0 9912.7 9922.8 9925.1 9943.0 9968.1 9836.9 9899.3 9903.3 9905.9 9908.9 41463.4 41876.6 42324.8 42351.6 42477.0 3336.3 3564.2 3568.9 4032.7 4135.6 30694.8 32026.8 32068.5 32342.4 32493.2 3242.2 3306.9 3307.3 3322.4 3333.1 526493.0 530824.0 531689.0 531885.0 532081.0 33722.8 60584.4 61074.0 61093.7 61139.1 34249.0 35657.0 35850.0 36028.5 36056.5 12175.6 14912.3 15059.4 15244.8 15269.2 10950.5 12788.2 12861.5 12873.5 12891.4 7046.5 7758.0 7789.1 7842.5 7939.7 2854.8 3221.2 3221.4 3224.3 3250.3 903.5 916.3 1047.6 1072.8 1110.3 26710.3 27567.4 30229.1 30666.8 31832.4 986.7 1042.9 1065.8 1077.7 1126.4 15809.6 16274.8 16339.3 16378.2 16655.7 719260.0 719867.0 727598.0 728998.0 732743.0 60719.4 60777.7 61209.7 61260.0 61278.0 1376.9 1385.8 1411.6 1414.0 1421.4 30425.4 31211.5 31321.8 31749.2 31775.2 52833.2 53416.7 53478.7 53483.0 53512.0 650340.7 654278.0 656954.0 660054.0 661444.0 27117.2 27506.4 27524.9 27526.7 27566.6 35415.5 47567.5 47992.0 48721.5 49001.5 39393.6 39849.6 40089.6 40428.4 41403.4 39807.0 39826.8 40234.6 40748.0 41098.4 38928.6 39238.6 40053.0 40215.0 41264.6 32229.8 35811.5 35815.5 36049.0 36353.0 26331.1 26724.5 26895.7 26986.4 27083.5 19:44:00 INFO - PROCESS | 1659 | 19:44:00 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:33318.59 Median:2402.11 stddev:92663.09 (3857.6%) stddev-sans-first:92889.96 19:44:00 INFO - PROCESS | 1659 | Values: 345.5 373.5 381.1 383.3 400.2 19774.1 20814.1 20856.5 21209.6 21515.8 20179.0 20549.8 20656.4 20823.7 20906.1 5758.7 5894.8 6032.4 6120.4 6122.6 3893.7 4085.1 6088.7 6119.3 6123.2 5771.4 6085.4 6144.1 6165.8 6181.8 5954.1 6005.0 6099.1 6104.1 6166.3 5875.8 5886.6 5895.4 5898.9 5905.7 10955.6 11649.4 21285.9 24949.4 25197.9 1984.9 2345.1 2355.3 2448.9 2550.7 8375.2 10027.0 10371.6 10460.8 14327.6 1705.3 1824.9 1841.8 1930.8 1933.5 122317.0 125694.4 125769.0 127008.0 128964.4 9705.3 11190.9 11621.5 11635.4 11690.2 14527.8 14528.9 14536.6 14542.6 14564.1 8326.9 8559.7 8571.4 8652.0 8721.7 8416.4 8540.1 8549.4 8670.4 8681.0 4440.6 4486.3 4511.9 4544.4 4623.0 1575.9 1661.3 1668.8 1778.5 1988.3 812.4 890.1 896.9 930.5 948.0 16258.5 20252.6 20509.7 20593.3 20679.1 898.9 908.7 936.4 942.1 981.3 10785.3 10997.9 11015.3 11049.9 11063.3 475405.0 477700.0 481316.0 643696.0 645987.0 116705.0 117216.0 129809.4 133474.3 136611.0 950.6 967.1 1005.8 1010.7 1013.5 17919.5 18440.3 18593.1 18598.9 18672.3 52436.5 52644.9 53038.7 53850.1 56349.0 71034.3 72755.6 73536.6 73652.6 74772.0 7197.8 7269.8 7307.6 7552.1 8148.0 8522.8 12011.6 12044.5 12271.8 12371.9 10211.4 10253.7 10388.9 10646.8 10691.7 10364.2 10581.0 10609.4 10638.0 10665.7 10706.7 10727.7 10760.6 10794.3 11146.4 7683.3 7930.1 8018.8 8081.8 8167.5 10007.2 10609.7 10687.3 10699.3 10732.7 19:44:00 INFO - PROCESS | 1659 | 19:44:00 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5749.45 Median:4528.69 stddev:3266.76 (72.1%) stddev-sans-first:3259.51 19:44:00 INFO - PROCESS | 1659 | Values: 1392.1 1545.8 1748.0 1844.6 1893.6 7927.7 8015.0 8557.4 9153.2 9290.2 7845.4 8847.9 8870.1 8945.7 8967.7 2368.2 2415.6 2417.1 2428.1 2432.9 2033.0 2391.0 2425.1 2429.2 2431.7 2127.2 2353.4 2402.4 2415.4 2432.0 2387.5 2390.5 2402.3 2404.7 2416.9 2376.5 2396.2 2397.6 2400.6 2410.9 8211.8 8604.8 8886.1 9011.1 9079.7 5303.8 5424.6 5431.6 5443.5 5443.5 3095.5 3644.4 3668.9 3693.4 3709.4 1093.9 1099.5 1099.9 1110.3 1111.9 11689.5 11786.9 11803.6 11907.3 11913.6 3945.2 4624.6 4884.1 4887.2 4903.0 10043.6 10117.3 10137.2 10144.0 10165.2 5408.7 5423.0 5436.4 5436.5 5438.2 4406.6 4568.6 4804.2 4920.1 4987.5 4017.8 4024.1 4093.8 4131.8 4135.1 1076.8 1278.4 1281.7 1286.1 1289.1 859.3 878.4 904.8 918.2 941.4 5814.8 6021.8 6111.2 6154.2 6174.4 445.0 447.5 461.2 468.9 470.0 3972.9 4011.7 4017.8 4032.6 4054.2 10450.4 10964.1 10990.3 11012.0 11039.7 10939.1 10944.8 10960.0 10989.2 11004.6 8202.5 8246.7 8290.3 8408.5 8425.4 5747.6 5770.5 5936.9 5942.7 6067.8 9985.9 10003.3 10184.1 10231.4 10231.9 10094.5 10183.8 10187.2 10315.3 10538.9 5710.7 6820.3 6961.3 7578.0 7722.6 7691.5 8545.7 8599.7 8604.9 8790.6 7410.4 7508.2 7651.8 7727.5 7764.5 7374.4 7475.4 7488.7 7497.7 7508.0 6964.7 7110.6 7135.5 7138.3 7150.3 3952.8 4410.3 4995.1 5003.2 5154.0 4488.8 5054.7 5104.9 5229.9 5231.1 19:44:00 INFO - PROCESS | 1659 | 19:44:00 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4574.46 Median:5027.57 stddev:1447.65 (28.8%) stddev-sans-first:1415.79 19:44:00 INFO - PROCESS | 1659 | Values: 304.5 305.1 313.0 317.7 317.8 4667.3 5458.8 5467.1 5534.8 5642.7 4765.3 4906.0 5192.8 5297.3 5481.3 3992.4 4170.9 4216.8 4257.5 4262.4 3746.8 3886.4 3978.5 4226.8 4278.8 4163.2 4177.9 4195.6 4207.9 4249.8 3698.8 3919.7 3953.0 3998.7 4188.3 3411.6 3588.2 3632.7 3643.4 3659.3 4272.9 4566.0 5270.2 5361.4 5403.5 4208.4 4614.7 4840.2 4843.8 4880.8 5048.7 5748.4 5885.7 5887.3 5921.6 3657.7 3898.7 3928.2 3930.6 3932.4 6266.5 6282.6 6284.6 6329.3 6330.6 3352.7 3380.8 4001.9 4018.7 4026.8 3309.9 3389.9 3633.5 3841.0 4106.1 3997.8 4730.4 4777.6 4844.5 4852.7 4746.1 4885.4 5114.2 5900.5 5973.8 1149.9 1240.7 1331.6 1375.7 1390.7 802.4 850.7 894.9 903.1 929.4 4214.5 4692.5 5242.1 5340.7 5592.4 6000.0 6045.7 6046.8 6060.4 6146.6 4090.3 5059.7 5234.4 5520.4 5535.6 2506.1 2541.4 2550.5 2708.4 2739.4 4447.8 4918.8 5119.9 5251.3 5350.4 4360.5 4734.8 5151.0 5155.5 5173.3 4623.8 4892.7 4965.8 5215.8 5223.9 4574.6 4695.7 5033.2 5043.4 5057.7 5021.9 5061.2 5361.8 5604.8 6203.0 5742.7 6237.3 6330.8 6407.8 6501.8 3341.3 3703.3 4153.1 4270.3 4293.6 4950.7 5926.5 6077.5 6120.9 6167.0 5561.4 5574.7 5805.9 5904.2 5923.5 5847.1 5850.7 5905.8 5936.7 5953.5 5492.3 5706.6 5766.0 5774.2 5899.9 5237.6 5717.1 5922.8 5923.3 5936.1 5408.0 5508.5 5784.2 5811.6 5891.0 19:44:00 INFO - PROCESS | 1659 | 19:44:00 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:24821.13 Median:22740.54 stddev:40131.96 (176.5%) stddev-sans-first:40203.43 19:44:00 INFO - PROCESS | 1659 | Values: 628.8 729.4 753.3 771.1 800.3 15003.0 15615.5 15693.1 15698.4 15732.9 13911.2 14139.4 14255.1 14271.0 14411.5 863.8 869.5 879.2 883.7 886.0 861.1 880.7 882.6 884.9 886.9 897.3 912.5 927.4 931.0 935.1 858.1 915.0 919.5 921.5 922.6 683.7 686.6 687.3 688.0 689.1 10265.3 13957.9 14122.1 14163.9 14174.2 10846.9 10944.6 12835.8 13370.9 13790.8 11281.4 11680.7 11943.5 11991.8 12027.5 3149.6 3221.3 3377.3 3857.4 3860.7 99841.5 108964.0 109333.5 111120.4 115622.0 10129.9 10407.5 10754.0 11108.4 11569.8 21192.0 21759.7 22522.0 22720.8 22760.3 8121.2 8162.7 8187.0 8213.4 8538.8 4548.0 4551.5 4626.4 4638.3 4650.3 3638.3 3742.5 3745.6 3747.4 3753.6 506.9 507.9 511.4 513.0 513.3 620.4 637.4 663.4 696.7 718.1 9035.0 9456.6 9614.8 9741.1 9820.4 653.6 669.8 678.6 682.1 688.7 4614.3 4732.3 4736.4 4745.7 4747.0 95932.5 128716.4 161110.0 167765.0 174083.1 91019.1 94695.5 139702.0 140992.0 147640.0 75261.6 119197.0 123152.4 123325.0 129955.0 9693.1 10217.3 10301.2 10331.0 10431.8 50165.2 65363.7 65513.7 66155.3 67568.3 94260.0 94383.0 100921.0 101792.5 102745.5 12762.3 13016.9 13041.6 13228.5 13412.5 14100.4 14301.0 14991.5 15058.2 15449.0 13128.3 13339.0 13748.5 13919.4 14534.7 11261.4 11416.9 11515.6 12103.7 13970.0 10554.5 11572.9 12004.0 12024.4 12060.0 11381.6 11614.9 11649.3 11858.0 12126.0 11465.7 11566.2 11763.8 11817.9 11849.3 19:44:00 INFO - PROCESS | 1659 | -------- Summary: end -------- 19:44:00 INFO - PROCESS | 1659 | 19:44:01 INFO - TEST-INFO | 1659: exit 0 19:44:01 INFO - TEST-OK | dromaeo_css | took 1115708ms 19:44:01 INFO - TEST-START | kraken 19:44:01 INFO - operating with platform_type : mac_ 19:44:01 INFO - Initialising browser for kraken test... 19:44:01 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpn1hfXH/profile http://localhost:49280/getInfo.html) 19:44:04 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 19:44:04 INFO - PROCESS | 1672 | colorDepth:24 19:44:04 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 19:44:04 INFO - PROCESS | 1672 | __metrics 19:44:04 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 19:44:04 INFO - TEST-INFO | 1672: exit 0 19:44:04 INFO - Browser initialized. 19:44:04 INFO - Running cycle 1/1 for kraken test... 19:44:04 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpn1hfXH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:44:16 INFO - PROCESS | 1674 | RSS: Main: 225247232 19:44:16 INFO - PROCESS | 1674 | 19:44:19 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 19:44:20 INFO - PROCESS | 1674 | RSS: Main: 237912064 19:44:20 INFO - PROCESS | 1674 | 19:44:23 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 19:44:23 INFO - PROCESS | 1674 | RSS: Main: 245366784 19:44:23 INFO - PROCESS | 1674 | 19:44:27 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 19:44:27 INFO - PROCESS | 1674 | RSS: Main: 249114624 19:44:27 INFO - PROCESS | 1674 | 19:44:29 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 19:44:30 INFO - PROCESS | 1674 | RSS: Main: 249671680 19:44:30 INFO - PROCESS | 1674 | 19:44:32 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:44:33 INFO - PROCESS | 1674 | RSS: Main: 250875904 19:44:33 INFO - PROCESS | 1674 | 19:44:35 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 19:44:36 INFO - PROCESS | 1674 | RSS: Main: 251539456 19:44:36 INFO - PROCESS | 1674 | 19:44:39 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 19:44:40 INFO - PROCESS | 1674 | RSS: Main: 251105280 19:44:40 INFO - PROCESS | 1674 | 19:44:43 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 19:44:44 INFO - PROCESS | 1674 | RSS: Main: 251461632 19:44:44 INFO - PROCESS | 1674 | 19:44:45 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:44:46 INFO - PROCESS | 1674 | RSS: Main: 250949632 19:44:46 INFO - PROCESS | 1674 | 19:44:48 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:44:48 INFO - PROCESS | 1674 | RSS: Main: 251080704 19:44:48 INFO - PROCESS | 1674 | 19:44:51 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:44:51 INFO - PROCESS | 1674 | RSS: Main: 251113472 19:44:51 INFO - PROCESS | 1674 | 19:44:54 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:44:55 INFO - PROCESS | 1674 | RSS: Main: 251445248 19:44:55 INFO - PROCESS | 1674 | 19:44:58 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:44:59 INFO - PROCESS | 1674 | RSS: Main: 251424768 19:44:59 INFO - PROCESS | 1674 | 19:45:00 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 19:45:01 INFO - PROCESS | 1674 | RSS: Main: 252772352 19:45:01 INFO - PROCESS | 1674 | 19:45:01 INFO - PROCESS | 1674 | __start_tp_report 19:45:01 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 19:45:01 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 19:45:01 INFO - PROCESS | 1674 | |i|pagename|runs| 19:45:01 INFO - PROCESS | 1674 | |0;ai-astar;106;120;125;118;120;119;119;118;119;119 19:45:01 INFO - PROCESS | 1674 | |1;audio-beat-detection;144;111;119;150;113;113;114;113;138;112 19:45:01 INFO - PROCESS | 1674 | |2;audio-dft;198;217;196;198;201;193;285;252;192;198 19:45:01 INFO - PROCESS | 1674 | |3;audio-fft;109;83;80;105;68;62;61;60;82;73 19:45:01 INFO - PROCESS | 1674 | |4;audio-oscillator;81;71;90;83;101;103;125;71;71;87 19:45:01 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;136;133;87;86;88;85;87;85;89;76 19:45:01 INFO - PROCESS | 1674 | |6;imaging-darkroom;105;153;153;94;96;130;151;96;108;151 19:45:01 INFO - PROCESS | 1674 | |7;imaging-desaturate;99;94;77;146;147;96;102;100;97;92 19:45:01 INFO - PROCESS | 1674 | |8;json-parse-financial;56;57;58;58;60;59;61;62;59;60 19:45:01 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;74;70;85;90;104;71;73;71;66;71 19:45:01 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;85;84;84;86;90;84;90;74;107;96 19:45:01 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;133;142;142;139;138;144;163;148;196;279 19:45:01 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;166;158;231;224;167;166;167;164;168;166 19:45:01 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;68;67;68;66;84;86;88;87;75;68 19:45:01 INFO - PROCESS | 1674 | __end_tp_report 19:45:01 INFO - PROCESS | 1674 | __start_cc_report 19:45:01 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,964 19:45:01 INFO - PROCESS | 1674 | __end_cc_report 19:45:01 INFO - PROCESS | 1674 | __startTimestamp1477881901172__endTimestamp 19:45:01 INFO - PROCESS | 1674 | 19:45:01 INFO - PROCESS | 1674 | ------- Summary: start ------- 19:45:01 INFO - PROCESS | 1674 | Number of tests: 14 19:45:01 INFO - PROCESS | 1674 | 19:45:01 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:118.30 Median:119.00 stddev:4.76 (4.0%) stddev-sans-first:2.12 19:45:01 INFO - PROCESS | 1674 | Values: 106.0 120.0 125.0 118.0 120.0 119.0 119.0 118.0 119.0 119.0 19:45:01 INFO - PROCESS | 1674 | 19:45:01 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:122.70 Median:116.50 stddev:15.11 (13.0%) stddev-sans-first:13.93 19:45:01 INFO - PROCESS | 1674 | Values: 144.0 111.0 119.0 150.0 113.0 113.0 114.0 113.0 138.0 112.0 19:45:01 INFO - PROCESS | 1674 | 19:45:01 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:213.00 Median:199.50 stddev:31.04 (15.6%) stddev-sans-first:32.44 19:45:01 INFO - PROCESS | 1674 | Values: 198.0 217.0 196.0 198.0 201.0 193.0 285.0 252.0 192.0 198.0 19:45:01 INFO - PROCESS | 1674 | 19:45:01 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:78.30 Median:70.50 stddev:17.41 (24.7%) stddev-sans-first:14.50 19:45:01 INFO - PROCESS | 1674 | Values: 109.0 83.0 80.0 105.0 68.0 62.0 61.0 60.0 82.0 73.0 19:45:01 INFO - PROCESS | 1674 | 19:45:01 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:88.30 Median:76.00 stddev:17.35 (22.8%) stddev-sans-first:18.20 19:45:01 INFO - PROCESS | 1674 | Values: 81.0 71.0 90.0 83.0 101.0 103.0 125.0 71.0 71.0 87.0 19:45:01 INFO - PROCESS | 1674 | 19:45:01 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:95.20 Median:86.50 stddev:21.03 (24.3%) stddev-sans-first:16.32 19:45:01 INFO - PROCESS | 1674 | Values: 136.0 133.0 87.0 86.0 88.0 85.0 87.0 85.0 89.0 76.0 19:45:01 INFO - PROCESS | 1674 | 19:45:01 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:123.70 Median:153.00 stddev:26.37 (17.2%) stddev-sans-first:27.09 19:45:01 INFO - PROCESS | 1674 | Values: 105.0 153.0 153.0 94.0 96.0 130.0 151.0 96.0 108.0 151.0 19:45:01 INFO - PROCESS | 1674 | 19:45:01 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:105.00 Median:93.00 stddev:22.93 (24.7%) stddev-sans-first:24.22 19:45:01 INFO - PROCESS | 1674 | Values: 99.0 94.0 77.0 146.0 147.0 96.0 102.0 100.0 97.0 92.0 19:45:01 INFO - PROCESS | 1674 | 19:45:01 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:59.50 stddev:1.83 (3.1%) stddev-sans-first:1.58 19:45:01 INFO - PROCESS | 1674 | Values: 56.0 57.0 58.0 58.0 60.0 59.0 61.0 62.0 59.0 60.0 19:45:01 INFO - PROCESS | 1674 | 19:45:01 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:77.50 Median:72.00 stddev:11.84 (16.4%) stddev-sans-first:12.49 19:45:01 INFO - PROCESS | 1674 | Values: 74.0 70.0 85.0 90.0 104.0 71.0 73.0 71.0 66.0 71.0 19:45:01 INFO - PROCESS | 1674 | 19:45:01 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:85.50 stddev:8.76 (10.2%) stddev-sans-first:9.22 19:45:01 INFO - PROCESS | 1674 | Values: 85.0 84.0 84.0 86.0 90.0 84.0 90.0 74.0 107.0 96.0 19:45:01 INFO - PROCESS | 1674 | 19:45:01 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:162.40 Median:146.00 stddev:44.86 (30.7%) stddev-sans-first:46.30 19:45:01 INFO - PROCESS | 1674 | Values: 133.0 142.0 142.0 139.0 138.0 144.0 163.0 148.0 196.0 279.0 19:45:01 INFO - PROCESS | 1674 | 19:45:01 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.70 Median:167.00 stddev:26.45 (15.8%) stddev-sans-first:27.71 19:45:01 INFO - PROCESS | 1674 | Values: 166.0 158.0 231.0 224.0 167.0 166.0 167.0 164.0 168.0 166.0 19:45:01 INFO - PROCESS | 1674 | 19:45:01 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.70 Median:79.50 stddev:9.44 (11.9%) stddev-sans-first:9.59 19:45:01 INFO - PROCESS | 1674 | Values: 68.0 67.0 68.0 66.0 84.0 86.0 88.0 87.0 75.0 68.0 19:45:01 INFO - PROCESS | 1674 | -------- Summary: end -------- 19:45:01 INFO - PROCESS | 1674 | 19:45:01 INFO - TEST-INFO | 1674: exit 0 19:45:01 INFO - TEST-OK | kraken | took 60427ms 19:45:01 INFO - SUITE-END | took 1176s 19:45:02 INFO - Completed test suite (00:19:36) 19:45:02 INFO - javascript benchmark 19:45:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7297.009138488048, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3177.6663450337714, 3443.776154549954, 3458.6541345865417, 3463.9307213855723, 3467.913302167444, 4862.2220444728855, 5919.911201331984, 5936.228290322263, 5971.790987315445, 5991.460768530831, 5805.970970145143, 5945.88108237835, 5953.732082056318, 5955.672438015908, 5979.252593425822, 5315.01672190645, 5372.355317361922, 5422.15956526739, 5422.647527910693, 5449.0, 5392.433794451585, 5397.217403476494, 5404.675719456845, 5422.132458806592, 5465.398806131322, 5215.400228973679, 5278.551323137519, 5419.729013549327, 5432.239486471897, 5440.319960004999, 5361.865953351158, 5370.462953704638, 5388.973055134699, 5389.922015596896, 5391.299131112969, 5202.687838729688, 5356.9732151339385, 5357.357117145929, 5370.758315875795, 5395.190721391823, 4346.56534346566, 5500.064988951848, 5952.58331916766, 5961.225040744675, 5981.342052374235, 4974.303597496353, 5368.489993450616, 6273.811785646392, 6300.21247344082, 6302.0, 6157.291911430153, 6240.750369985195, 6259.280182778948, 6272.3100458949475, 6331.715072821734, 5874.0014197586515, 5959.582829201958, 6006.039033754622, 6045.0, 6054.485368743618, 5767.0, 5769.942300577024, 6193.4425901669065, 6250.374962503804, 6445.16212892321, 5404.54061404785, 6106.572539922163, 6160.860240855456, 6208.9689551551955, 6255.593386429959, 6248.0003199487865, 6270.2789179244055, 6325.620462772248, 6341.302456729756, 6349.238091429058, 6207.193064901534, 6300.0, 6323.715432805535, 6325.4939604832425, 6326.5255105867245, 6171.59884607499, 6223.377662233831, 6273.309935907047, 6279.591826531261, 6315.147455093595, 5011.974940125276, 5013.298138260647, 5035.471275516092, 5040.067587496325, 5041.697498150123, 4431.091626216617, 4506.662000349987, 4522.208613492626, 4529.297958816389, 4555.863324100283, 5815.621984570989, 5926.644401335848, 5978.790742323998, 5996.16053752475, 6086.573939824169, 6301.6219026858535, 6303.117563541108, 6318.336574659686, 6320.304766475684, 6353.872922541524, 6019.398060193946, 6040.60736052164, 6073.271207455134, 6079.8480037998515, 6095.451409373178, 5431.2396264522995, 5450.127979523258, 5494.560435165257, 5498.010358135574, 5526.032944234743, 6446.645434501053, 6510.902336465051, 6513.283538810632, 6532.902006469812, 6546.738130474728, 6244.687765611792, 6332.620042797447, 6334.461570766352, 6341.0, 6351.428371446592, 6310.684465776784, 6334.841628959313, 6353.7140828661895, 6371.585846919936, 6463.903041454288, 5911.201987731602, 6314.052892066226, 6325.0, 6335.081413194969, 6336.809895703136, 6173.166622505904, 6242.843928901813, 6328.14570033058, 6328.272248691275, 6354.90467642995, 6120.357362476876, 6161.168242287234, 6176.258848938156, 6223.471004964629, 6286.497080233662, 6244.375562443719, 6254.0, 6290.21372328459, 6299.433051025429, 6317.0, 5952.345242023461, 6133.539984501091, 6165.938340616716, 6189.04069869171, 6205.348438414082, 6081.756729730761, 6128.53367901495, 6170.197874276315, 6179.660118693515, 6217.253929528486, 6131.376666649982, 6140.4473597376455, 6142.32434432221, 6170.136180934763, 6170.382961703794], "value": 5794.814265084711, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.18031395842166, 477.6871149397145, 516.4319248826293, 542.7503348459709, 545.3918880448301, 27965.0, 42372.72881813543, 42374.0, 44636.776816115875, 45024.0, 32914.17714557131, 36531.81734091326, 38390.23219535615, 43330.133397332036, 43861.12277754451, 8327.83344333113, 9653.17947974423, 9837.90162098377, 9866.0, 9866.457344846067, 9108.316876234308, 9226.40028398152, 9818.263630227726, 9913.306068575203, 9937.354071985334, 9902.455364954925, 9930.05664461875, 9943.552540135712, 9943.900560994405, 9944.0, 9912.653057143001, 9922.801543969152, 9925.106740393363, 9942.950285248528, 9968.102870741595, 9836.901630983743, 9899.307048506607, 9903.25725570585, 9905.851412228822, 9908.851367229498, 41463.37804932929, 41876.58123418757, 42324.78837605823, 42351.57648423507, 42477.0, 3336.3225144793632, 3564.198055437506, 3568.91077723059, 4032.697547683906, 4135.648469880064, 30694.84652576745, 32026.83986580052, 32068.518972215435, 32342.353152937045, 32493.187670308194, 3242.238074052596, 3306.8511916963794, 3307.2889328794186, 3322.368749937504, 3333.0500807269814, 526493.0, 530824.0, 531689.0, 531885.0, 532081.0, 33722.831385843405, 60584.394156058755, 61074.0, 61093.69453152706, 61139.08291375544, 34248.97253082412, 35657.0, 35850.0, 36028.459573106426, 36056.45915311272, 12175.573854915036, 14912.254387280593, 15059.397624094914, 15244.771328430083, 15269.236538173047, 10950.452477376259, 12788.232706037481, 12861.485540578458, 12873.549425770241, 12891.35543222835, 7046.471514636422, 7758.0, 7789.065312162464, 7842.490238134503, 7939.722109726132, 2854.7716182705335, 3221.2430078931434, 3221.4362486564755, 3224.290656055664, 3250.317433338978, 903.5075883643431, 916.3356566489242, 1047.6123834181249, 1072.7961687279392, 1110.2838669058413, 26710.328967103524, 27567.44865102687, 30229.09312720622, 30666.846665766527, 31832.363352732817, 986.6842610364614, 1042.9414144643192, 1065.840123981409, 1077.6551503518956, 1126.4086354663702, 15809.604759880865, 16274.75587866183, 16339.346426142822, 16378.181090945405, 16655.6668866622, 719260.0, 719867.0, 727598.0, 728998.0, 732743.0, 60719.39280607137, 60777.69611152005, 61209.69395152996, 61260.0, 61278.0, 1376.8898488120926, 1385.757492438819, 1411.6047506698142, 1413.9717205656034, 1421.4243231491262, 30425.391492170475, 31211.531827022158, 31321.8433907829, 31749.20626984344, 31775.205619859687, 52833.20750188827, 53416.73291633517, 53478.73260633672, 53483.0, 53512.0, 650340.7482962555, 654278.0, 656954.0, 660054.0, 661444.0, 27117.186484405498, 27506.449871002867, 27524.862375687993, 27526.724732753217, 27566.5865012021, 35415.468767967985, 47567.52432475631, 47992.0, 48721.51278487311, 49001.509984901124, 39393.63648177156, 39849.60150398575, 40089.59910400975, 40428.393574097, 41403.378949316386, 39807.0, 39826.80086599549, 40234.597654023084, 40748.0, 41098.383524246565, 38928.6107138925, 39238.607613923494, 40053.0, 40214.994625134605, 41264.587354127274, 32229.838850805594, 35811.462828058124, 35815.46276805902, 36049.0, 36353.0, 26331.078412256244, 26724.465510690065, 26895.65521723945, 26986.425881718827, 27083.45833083288], "value": 19163.92528609251, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.48867675839756, 373.54054512949057, 381.06638735099017, 383.331087252744, 400.2155774681624, 19774.11016504257, 20814.063367148476, 20856.47858803531, 21209.57580848384, 21515.784842151574, 20179.0, 20549.794502054974, 20656.380308590728, 20823.687644685306, 20906.05922733477, 5758.712064396764, 5894.823155305347, 6032.396760323976, 6120.357362476942, 6122.63264204147, 3893.669038131748, 4085.142120154771, 6088.695565221743, 6119.296280927683, 6123.173371594845, 5771.365149833536, 6085.391460853902, 6144.0783882417545, 6165.815025549218, 6181.81454556364, 5954.077118046688, 6005.009173486348, 6099.085137229406, 6104.08438734189, 6166.290876549187, 5875.823725288248, 5886.646801191942, 5895.35151133375, 5898.911516327258, 5905.734241959122, 10955.56177752889, 11649.359285239309, 21285.893570532047, 24949.376265593506, 25197.874010630014, 1984.8908310042941, 2345.0736958901307, 2355.2934119764004, 2448.926532204037, 2550.655661485694, 8375.20435558621, 10027.047430494164, 10371.636992705295, 10460.843087353696, 14327.638874306924, 1705.3008266610755, 1824.8813827101196, 1841.7881943576526, 1930.7779605345424, 1933.5069557262948, 122317.0, 125694.37152814177, 125769.0, 127008.0, 128964.35517822445, 9705.320627556004, 11190.888091118984, 11621.535138594361, 11635.360055197045, 11690.181687281978, 14527.78208326876, 14528.927355363156, 14536.563903082924, 14542.636434089232, 14564.053336533092, 8326.916730832614, 8559.74320770378, 8571.442856214326, 8651.956740216385, 8721.694740684046, 8416.368772342099, 8540.060593334729, 8549.444286121383, 8670.393072484865, 8681.04508504064, 4440.600345968878, 4486.259767138451, 4511.917139886469, 4544.431946006749, 4622.9768851156205, 1575.850294222047, 1661.2773443552094, 1668.7663727078218, 1778.510909499898, 1988.3140316590752, 812.4353574265829, 890.123228619809, 896.914793094655, 930.5486838883136, 947.9810403791886, 16258.51224463268, 20252.594948100956, 20509.692354614694, 20593.279235226695, 20679.069441875152, 898.9415687980392, 908.6637943960777, 936.4287784451479, 942.072059021863, 981.259149342242, 10785.29895556802, 10997.890021099847, 11015.339079655247, 11049.944750276198, 11063.280886742335, 475405.0, 477700.0, 481316.0, 643696.0, 645987.0, 116705.0, 117216.0, 129809.35095324463, 133474.33262833624, 136611.0, 950.6245033211843, 967.1489089601106, 1005.7535903703639, 1010.6614284214724, 1013.5084484025242, 17919.46241612754, 18440.262389504805, 18593.07034648289, 18598.907005465426, 18672.25310987545, 52436.47563524316, 52644.94710105853, 53038.67403314948, 53850.115245966204, 56349.0, 71034.28965710277, 72755.63622181855, 73536.63231684022, 73652.63173684098, 74772.0, 7197.820054498679, 7269.781906542812, 7307.561546307238, 7552.055993000875, 8147.981502312211, 8522.786930326543, 12011.63965081049, 12044.457999390224, 12271.815922760987, 12371.938140309241, 10211.387316761018, 10253.74365640865, 10388.896111038794, 10646.84029739539, 10691.732706682084, 10364.222683298633, 10581.0, 10609.416482093558, 10638.0, 10665.733356666145, 10706.678799636024, 10727.678169654922, 10760.623378181726, 10794.298370605886, 11146.386948717898, 7683.346915512244, 7930.088039875488, 8018.797180422983, 8081.83836323282, 8167.469114507538, 10007.249456290661, 10609.681709548726, 10687.30532515384, 10699.304545204537, 10732.731681707708], "value": 9346.557300942166, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1392.1368751374146, 1545.7526795712686, 1748.0298434368929, 1844.5941892783583, 1893.5834116494366, 7927.691930831405, 8014.998125234346, 8557.358198135142, 9153.176214140725, 9290.21033212177, 7845.37237021037, 8847.867281990775, 8870.112988701127, 8945.731628051153, 8967.686130985418, 2368.1593034472817, 2415.625578035407, 2417.1177520205088, 2428.138011006094, 2432.8905199266073, 2033.0, 2390.988045059772, 2425.1148330859196, 2429.1983645397063, 2431.7203521595065, 2127.2129312154525, 2353.4234112642425, 2402.3633737059695, 2415.4323733922515, 2431.9756802431925, 2387.510560335127, 2390.474095698952, 2402.25530085674, 2404.651325557793, 2416.854988700666, 2376.5009348036933, 2396.161343529768, 2397.568437681217, 2400.6399040143942, 2410.9397265068337, 8211.83576328476, 8604.795328653994, 8886.06696296886, 9011.143941325563, 9079.727608171765, 5303.814366497154, 5424.620276580641, 5431.592630552725, 5443.455654434564, 5443.482869127427, 3095.520194369876, 3644.4351125575577, 3668.926621467556, 3693.3905905525826, 3709.3694072007825, 1093.8632670916136, 1099.4667586220676, 1099.8625171853519, 1110.3171549497001, 1111.8554587903602, 11689.473973671205, 11786.941065294704, 11803.586874459354, 11907.34509601963, 11913.642590722293, 3945.151792364655, 4624.583787459078, 4884.096442158212, 4887.218045112836, 4902.975485122623, 10043.648472303434, 10117.291789574807, 10137.189024877993, 10143.985601439945, 10165.186785057325, 5408.729563521808, 5423.0, 5436.401995780461, 5436.510714035756, 5438.15708565173, 4406.625436837905, 4568.6116680081905, 4804.2073057945745, 4920.114379411741, 4987.501249875056, 4017.7589344639414, 4024.1348110156455, 4093.7953102344763, 4131.814068366931, 4135.0902801383645, 1076.8007918535095, 1278.4055414232241, 1281.6603600045996, 1286.0611753420055, 1289.1233960906486, 859.282499113235, 878.3939082033377, 904.8099899021279, 918.1736437206567, 941.3739862991171, 5814.825555233349, 6021.759129634853, 6111.174991376196, 6154.230721159855, 6174.448567818444, 444.9644028477714, 447.4988013424985, 461.22053729197546, 468.94841567427557, 469.9801430894966, 3972.8808135755394, 4011.6590089842107, 4017.819198136091, 4032.6370626643156, 4054.189162167578, 10450.425226612457, 10964.068054215322, 10990.285631433931, 11012.0, 11039.724006899893, 10939.070179034712, 10944.781104377867, 10960.0, 10989.230753847154, 11004.614838480615, 8202.466839655403, 8246.670133194724, 8290.295324897452, 8408.495490270481, 8425.368097392597, 5747.5689323300085, 5770.538356931352, 5936.851578710567, 5942.6731529766275, 6067.787627433018, 9985.850212246967, 10003.34978226413, 10184.083432491112, 10231.43727095017, 10231.94884025605, 10094.495275236355, 10183.79632407333, 10187.235957303381, 10315.329503582543, 10538.947305263424, 5710.657360558213, 6820.31796820314, 6961.338672826276, 7577.962110189414, 7722.575258360844, 7691.538507689333, 8545.700900468702, 8599.742007739778, 8604.870926936226, 8790.648374064966, 7410.4442166836625, 7508.249175082667, 7651.846963060819, 7727.459077864495, 7764.456488046008, 7374.410047196104, 7475.439342049477, 7488.700451981859, 7497.650422923926, 7508.0239568855695, 6964.721411143498, 7110.608916509642, 7135.500514963903, 7138.286171382821, 7150.320719531636, 3952.8418863245147, 4410.272305069628, 4995.100881841304, 5003.199488082035, 5154.020736060136, 4488.775561221991, 5054.69671819692, 5104.872378190575, 5229.947700522946, 5231.0845602018735], "value": 4538.412888066743, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.4611038461921, 305.1227720304126, 312.9530570414438, 317.7156444981743, 317.80931441135306, 4667.29990501425, 5458.789190377904, 5467.0705979983395, 5534.837684086342, 5642.68965206914, 4765.332853400527, 4905.96974635327, 5192.792288308473, 5297.284866543016, 5481.260029895963, 3992.3612222044408, 4170.937435938464, 4216.756056963203, 4257.467816522934, 4262.424572682695, 3746.7939263340504, 3886.3587508061137, 3978.547830042028, 4226.788660566975, 4278.807453664577, 4163.188178305231, 4177.892858392528, 4195.559466256045, 4207.936880946788, 4249.766262855542, 3698.815059247027, 3919.686904886866, 3952.960470395288, 3998.6601138903084, 4188.32986722126, 3411.573553305837, 3588.1567831559564, 3632.673059424638, 3643.3786964800674, 3659.304732100919, 4272.893177670552, 4566.0, 5270.209468579706, 5361.437049109865, 5403.51368376844, 4208.431861698662, 4614.653900957442, 4840.201366774478, 4843.757812109416, 4880.829170979035, 5048.7223202723835, 5748.367679555246, 5885.676287804169, 5887.293524777011, 5921.61509501881, 3657.7073834093208, 3898.707596930213, 3928.2339943710986, 3930.567637559866, 3932.410138479251, 6266.467350275232, 6282.591631543935, 6284.560080794392, 6329.303776584572, 6330.588511746721, 3352.7150192233444, 3380.7802492837886, 4001.91996160081, 4018.738781979162, 4026.7583944963394, 3309.9007029789145, 3389.9491507627404, 3633.509476220729, 3840.9807950960067, 4106.07613287014, 3997.7801220932547, 4730.432348118179, 4777.631769602422, 4844.539768721966, 4852.684575502652, 4746.0745154694505, 4885.413750349981, 5114.156164232934, 5900.468957793819, 5973.761049557969, 1149.9252548584316, 1240.6588188248124, 1331.633800704814, 1375.69734658375, 1390.7344316671781, 802.4342838298985, 850.6937502499095, 894.8881389826272, 903.1420150856712, 929.3540989012571, 4214.536400995888, 4692.451491007959, 5242.112839377821, 5340.706261155596, 5592.384837667853, 6000.009998350223, 6045.697715114226, 6046.758129674852, 6060.424259695322, 6146.569740118238, 4090.3046482098116, 5059.684482034624, 5234.377721055488, 5520.447955204448, 5535.640183388067, 2506.0578052009837, 2541.377362546188, 2550.477152183798, 2708.3635345693747, 2739.3974524902756, 4447.844325448594, 4918.803247870045, 5119.897602048012, 5251.293329667873, 5350.394881535523, 4360.454943132108, 4734.786934587952, 5151.0, 5155.510226528474, 5173.258173168227, 4623.838165664186, 4892.730899800546, 4965.8013679452415, 5215.791368345223, 5223.921641175385, 4574.61115805147, 4695.741734204652, 5033.194688849767, 5043.402647636397, 5057.69653820772, 5021.949780502148, 5061.204096927305, 5361.758720857492, 5604.8318550443555, 6203.0, 5742.684152371659, 6237.251529816451, 6330.8100756977365, 6407.807765767035, 6501.804945851442, 3341.348437054751, 3703.2778608171147, 4153.1070819773895, 4270.338097594878, 4293.5706429356815, 4950.727709975986, 5926.466618004228, 6077.453029227391, 6120.8775824484155, 6166.969165154145, 5561.416051314553, 5574.738777814861, 5805.8548536286935, 5904.202932604044, 5923.526117910471, 5847.1229315603, 5850.707464626837, 5905.8188362328565, 5936.7143649696045, 5953.523718102628, 5492.340919089735, 5706.629069110494, 5766.0, 5774.152271273152, 5899.852503687443, 5237.607179461479, 5717.056685646821, 5922.78582890515, 5923.259592550931, 5936.050231962865, 5408.0, 5508.457631863084, 5784.21913041734, 5811.5541610668715, 5890.970545147418], "value": 4113.700933468654, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.8019273928712, 729.3654520567108, 753.2580408297829, 771.0939645916051, 800.3397197312219, 15003.0, 15615.453459128932, 15693.136877471748, 15698.37206511741, 15732.921335393336, 13911.234882081482, 14139.434422623108, 14255.144691318503, 14271.0, 14411.495597654084, 863.8315528471951, 869.4739682492096, 879.248242752447, 883.7392969074139, 885.9734207973771, 861.1388611388611, 880.7005618089848, 882.5851849630695, 884.9026607073249, 886.9068747781487, 897.2866571076011, 912.4662072687486, 927.420362273579, 931.0270767048451, 935.111643938258, 858.107568129145, 915.0163574157774, 919.5218486387041, 921.5162039929024, 922.5940586142076, 683.665004147969, 686.605202008842, 687.2714922182453, 688.0470548290654, 689.0594338727651, 10265.332753371007, 13957.860421395859, 14122.082064665763, 14163.929180354135, 14174.220417877013, 10846.891531084668, 10944.56221751129, 12835.807462888064, 13370.933145334211, 13790.793138102936, 11281.379524126252, 11680.707982300426, 11943.522259109624, 11991.820122698167, 12027.458764355624, 3149.6062992125985, 3221.25911040462, 3377.3414184234084, 3857.40210267409, 3860.7297489175767, 99841.5007924963, 108964.0, 109333.45333273282, 111120.44439777831, 115622.0, 10129.936356682441, 10407.53166107527, 10754.03213710754, 11108.444577771079, 11569.76860462786, 21192.0, 21759.67360489594, 22522.0, 22720.772792272197, 22760.31719048431, 8121.187881211831, 8162.6734930602115, 8186.959065204635, 8213.425060245725, 8538.829223415496, 4548.0, 4551.52209018055, 4626.352310676508, 4638.304254361873, 4650.279206722963, 3638.290533346025, 3742.5134732484603, 3745.606711295329, 3747.3816820224356, 3753.60587138352, 506.8732816795801, 507.908576456234, 511.39655206855525, 512.9923051154236, 513.3429210610425, 620.4354037825648, 637.3912913167914, 663.3598577372859, 696.6586372677351, 718.0629278791123, 9034.954825225963, 9456.621735130655, 9614.759631009141, 9741.123298903132, 9820.44412514538, 653.5947712418331, 669.7890164598136, 678.5962352400314, 682.1405029662661, 688.7072993977539, 4614.307853821886, 4732.290156476556, 4736.4316282046375, 4745.691530050535, 4746.952530474651, 95932.52033739787, 128716.42567148792, 161110.0, 167765.0, 174083.12958435126, 91019.08980910106, 94695.52652236832, 139702.0, 140991.99999999796, 147640.0, 75261.62369188228, 119197.0, 123152.38423807823, 123325.0, 129955.0, 9693.137103329937, 10217.33587316822, 10301.175905927657, 10331.0, 10431.843522347323, 50165.244216453706, 65363.673181633785, 65513.67243163754, 66155.33844661685, 67568.3243167562, 94260.0, 94383.0, 100920.9907900941, 101792.49103754434, 102745.48627256816, 12762.298073605669, 13016.934915325362, 13041.608751737464, 13228.537001204912, 13412.530561430303, 14100.36548355306, 14301.026487259925, 14991.475298364505, 15058.247087645794, 15448.995815271972, 13128.34358282063, 13339.0, 13748.450061997808, 13919.4432222714, 14534.709305814036, 11261.436928153724, 11416.915393037649, 11515.596954106566, 12103.697407564881, 13969.95225358082, 10554.525046372779, 11572.942135289606, 12004.0, 12024.398780061138, 12060.0, 11381.601643942422, 11614.896584824428, 11649.301041937511, 11858.0, 12126.0, 11465.713357166138, 11566.190366674253, 11763.823542646696, 11817.881821182022, 11849.289042657469], "value": 7789.560948903023, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1584.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 120.0, 125.0, 118.0, 120.0, 119.0, 119.0, 118.0, 119.0, 119.0], "value": 118.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 111.0, 119.0, 150.0, 113.0, 113.0, 114.0, 113.0, 138.0, 112.0], "value": 122.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 217.0, 196.0, 198.0, 201.0, 193.0, 285.0, 252.0, 192.0, 198.0], "value": 213.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 83.0, 80.0, 105.0, 68.0, 62.0, 61.0, 60.0, 82.0, 73.0], "value": 78.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 71.0, 90.0, 83.0, 101.0, 103.0, 125.0, 71.0, 71.0, 87.0], "value": 88.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 133.0, 87.0, 86.0, 88.0, 85.0, 87.0, 85.0, 89.0, 76.0], "value": 95.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 153.0, 153.0, 94.0, 96.0, 130.0, 151.0, 96.0, 108.0, 151.0], "value": 123.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 77.0, 146.0, 147.0, 96.0, 102.0, 100.0, 97.0, 92.0], "value": 105.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 58.0, 60.0, 59.0, 61.0, 62.0, 59.0, 60.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 70.0, 85.0, 90.0, 104.0, 71.0, 73.0, 71.0, 66.0, 71.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 86.0, 90.0, 84.0, 90.0, 74.0, 107.0, 96.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 142.0, 142.0, 139.0, 138.0, 144.0, 163.0, 148.0, 196.0, 279.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 158.0, 231.0, 224.0, 167.0, 166.0, 167.0, 164.0, 168.0, 166.0], "value": 177.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 66.0, 84.0, 86.0, 88.0, 87.0, 75.0, 68.0], "value": 75.7, "unit": "score"}]}]} 19:45:02 INFO - Return code: 0 19:45:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:45:02 ERROR - # TBPL SUCCESS # 19:45:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:45:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:45:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:45:02 INFO - 2016-10-30 19:45:02.491 screenresolution[1679:11031] starting screenresolution argv=screenresolution get 19:45:02 INFO - 2016-10-30 19:45:02.494 screenresolution[1679:11031] Display 0: 1600x1200x32@60 19:45:02 INFO - 2016-10-30 19:45:02.499 screenresolution[1680:11034] starting screenresolution argv=screenresolution list 19:45:02 INFO - Available Modes on Display 0 19:45:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:45:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:45:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:45:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:45:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:45:02 INFO - Intel Iris: 19:45:02 INFO - Chipset Model: Intel Iris 19:45:02 INFO - Type: GPU 19:45:02 INFO - Bus: Built-In 19:45:02 INFO - VRAM (Dynamic, Max): 1536 MB 19:45:02 INFO - Vendor: Intel (0x8086) 19:45:02 INFO - Device ID: 0x0a2e 19:45:02 INFO - Revision ID: 0x0009 19:45:02 INFO - Displays: 19:45:02 INFO - Display: 19:45:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:45:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:45:02 INFO - Display Serial Number: 1600x1200 60 19:45:02 INFO - Main Display: Yes 19:45:02 INFO - Mirror: Off 19:45:02 INFO - Online: Yes 19:45:02 INFO - Rotation: Supported 19:45:02 INFO - Return code: 0 19:45:02 INFO - Running post-action listener: _resource_record_post_action 19:45:02 INFO - [mozharness: 2016-10-31 02:45:02.732820Z] Finished run-tests step (success) 19:45:02 INFO - Running post-run listener: _resource_record_post_run 19:45:02 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 38716416; Write bytes: 667379712; Read time: 424; Write time: 1975 19:45:02 INFO - TinderboxPrint: CPU usage
54.5% 19:45:02 INFO - TinderboxPrint: I/O read bytes / time
38,716,416 / 424 19:45:02 INFO - TinderboxPrint: I/O write bytes / time
667,379,712 / 1,975 19:45:02 INFO - TinderboxPrint: CPU idle
2,203.2 (45.5%) 19:45:02 INFO - TinderboxPrint: CPU system
981.4 (20.3%) 19:45:02 INFO - TinderboxPrint: CPU user
1,653.1 (34.2%) 19:45:02 INFO - TinderboxPrint: Swap in / out
402,120,704 / 0 19:45:02 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 360753664; Write bytes: 355563520; Read time: 27660; Write time: 701 19:45:02 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 36697088; Write bytes: 300670976; Read time: 401; Write time: 1237 19:45:03 INFO - Running post-run listener: _upload_blobber_files 19:45:03 INFO - Blob upload gear active. 19:45:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:45:03 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 19:45:03 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'] 19:45:03 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 19:45:03 INFO - (blobuploader) - INFO - Open directory for files ... 19:45:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:45:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:45:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:45:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:45:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:45:04 INFO - (blobuploader) - INFO - Done attempting. 19:45:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:45:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:45:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:45:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:45:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:45:05 INFO - (blobuploader) - INFO - Done attempting. 19:45:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:45:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:45:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:45:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:45:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:45:07 INFO - (blobuploader) - INFO - Done attempting. 19:45:07 INFO - (blobuploader) - INFO - Iteration through files over. 19:45:07 INFO - Return code: 0 19:45:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:45:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:45:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00bdc2a0841e2b2487d1cb28d880bd9b11da7343f9dd3d1316ecfab7061ed7803a432bffbcb266a1d25db9dd6806f6df38cd41518ed202600c167f3cbe2bcd93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4eac7335e56dd3b21a2da5fb7526286aa8741994ce0bf2b28fab794d67f83a9458c2bdbcd2c8a589507d2d19a70078bf6577d0caf435aab7b5fe6282f4884efb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0170dd466edb43cf725e9e5eb609442026c9ca192bd503d91777c6969a1c54d7e8d23515a44ae2d44ed4d40b68508d3794e9bc670c73434d0ccfc1bfb6d41f2f"} 19:45:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:45:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:45:07 INFO - Contents: 19:45:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00bdc2a0841e2b2487d1cb28d880bd9b11da7343f9dd3d1316ecfab7061ed7803a432bffbcb266a1d25db9dd6806f6df38cd41518ed202600c167f3cbe2bcd93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4eac7335e56dd3b21a2da5fb7526286aa8741994ce0bf2b28fab794d67f83a9458c2bdbcd2c8a589507d2d19a70078bf6577d0caf435aab7b5fe6282f4884efb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0170dd466edb43cf725e9e5eb609442026c9ca192bd503d91777c6969a1c54d7e8d23515a44ae2d44ed4d40b68508d3794e9bc670c73434d0ccfc1bfb6d41f2f"} 19:45:07 INFO - Running post-run listener: copy_logs_to_upload_dir 19:45:07 INFO - Copying logs to upload dir... 19:45:07 INFO - mkdir: /builds/slave/test/build/upload/logs 19:45:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.944628 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-30 19:45:07.970990) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 19:45:07.974592) ========= 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.0Ddloed5wu/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.pJl21xQl8s/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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/00bdc2a0841e2b2487d1cb28d880bd9b11da7343f9dd3d1316ecfab7061ed7803a432bffbcb266a1d25db9dd6806f6df38cd41518ed202600c167f3cbe2bcd93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4eac7335e56dd3b21a2da5fb7526286aa8741994ce0bf2b28fab794d67f83a9458c2bdbcd2c8a589507d2d19a70078bf6577d0caf435aab7b5fe6282f4884efb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0170dd466edb43cf725e9e5eb609442026c9ca192bd503d91777c6969a1c54d7e8d23515a44ae2d44ed4d40b68508d3794e9bc670c73434d0ccfc1bfb6d41f2f"} build_url:https://queue.taskcluster.net/v1/task/WZAEwcKWQjeNLBtC9q2aGg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011155 build_url: 'https://queue.taskcluster.net/v1/task/WZAEwcKWQjeNLBtC9q2aGg/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/00bdc2a0841e2b2487d1cb28d880bd9b11da7343f9dd3d1316ecfab7061ed7803a432bffbcb266a1d25db9dd6806f6df38cd41518ed202600c167f3cbe2bcd93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4eac7335e56dd3b21a2da5fb7526286aa8741994ce0bf2b28fab794d67f83a9458c2bdbcd2c8a589507d2d19a70078bf6577d0caf435aab7b5fe6282f4884efb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0170dd466edb43cf725e9e5eb609442026c9ca192bd503d91777c6969a1c54d7e8d23515a44ae2d44ed4d40b68508d3794e9bc670c73434d0ccfc1bfb6d41f2f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 19:45:08.008441) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 19:45:08.008836) ========= 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.0Ddloed5wu/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.pJl21xQl8s/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.004974 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 19:45:08.058113) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 19:45:08.058456) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 19:45:08.058855) ========= ========= Total master_lag: 0.17 =========