builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0188 starttime: 1477994781.1 results: success (0) buildid: 20161101004006 builduid: d941da38c1884f398fecd9bbcdecb6ae revision: d9ce0a0617634b3d5d8fec265a394e4128df84c2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-01 03:06:21.096537) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-01 03:06:21.097004) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-01 03:06:21.097303) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-01 03:06:21.159335) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 03:06:21.159649) ========= 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.UuYob3ZAS2/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.Si0tSz24aj/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-01 03:06:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 26.2M=0s 2016-11-01 03:06:21 (26.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.522338 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 03:06:21.704829) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 03:06:21.705128) ========= 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.UuYob3ZAS2/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.Si0tSz24aj/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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.026383 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 03:06:21.755912) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 03:06:21.756262) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d9ce0a0617634b3d5d8fec265a394e4128df84c2 --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 d9ce0a0617634b3d5d8fec265a394e4128df84c2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UuYob3ZAS2/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.Si0tSz24aj/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-01 03:06:21,835 truncating revision to first 12 chars 2016-11-01 03:06:21,835 Setting DEBUG logging. 2016-11-01 03:06:21,835 attempt 1/10 2016-11-01 03:06:21,835 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d9ce0a061763?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-01 03:06:22,376 unpacking tar archive at: mozilla-aurora-d9ce0a061763/testing/mozharness/ program finished with exit code 0 elapsedTime=0.969532 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 03:06:22.748084) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-01 03:06:22.748617) ========= script_repo_revision: d9ce0a0617634b3d5d8fec265a394e4128df84c2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-01 03:06:22.749360) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-01 03:06:22.749839) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-01 03:06:22.770808) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-01 03:06:22.771352) ========= /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.UuYob3ZAS2/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.Si0tSz24aj/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 03:06:22 INFO - MultiFileLogger online at 20161101 03:06:22 in /builds/slave/test 03:06:22 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 03:06:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:06:22 INFO - {'append_to_log': False, 03:06:22 INFO - 'base_work_dir': '/builds/slave/test', 03:06:22 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:06:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:06:22 INFO - 'branch': 'Mozilla-Aurora', 03:06:22 INFO - 'buildbot_json_path': 'buildprops.json', 03:06:22 INFO - 'config_files': ('talos/mac_config.py',), 03:06:22 INFO - 'default_actions': ('clobber', 03:06:22 INFO - 'read-buildbot-config', 03:06:22 INFO - 'download-and-extract', 03:06:22 INFO - 'populate-webroot', 03:06:22 INFO - 'create-virtualenv', 03:06:22 INFO - 'install', 03:06:22 INFO - 'run-tests'), 03:06:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:06:22 INFO - 'download_minidump_stackwalk': True, 03:06:22 INFO - 'download_symbols': 'ondemand', 03:06:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:06:22 INFO - 'tooltool.py': '/tools/tooltool.py', 03:06:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:06:22 INFO - '/tools/misc-python/virtualenv.py')}, 03:06:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:06:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:06:22 INFO - 'installer_path': 'installer.exe', 03:06:22 INFO - 'log_level': 'info', 03:06:22 INFO - 'log_name': 'talos', 03:06:22 INFO - 'log_to_console': True, 03:06:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:06:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:06:22 INFO - 'opt_config_files': (), 03:06:22 INFO - 'pip_index': False, 03:06:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:06:22 INFO - 'cmd': ('bash', 03:06:22 INFO - '-c', 03:06:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:06:22 INFO - 'enabled': True, 03:06:22 INFO - 'halt_on_failure': False, 03:06:22 INFO - 'name': 'check_screen_resolution'},), 03:06:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:06:22 INFO - 'cmd': ('bash', 03:06:22 INFO - '-c', 03:06:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:06:22 INFO - 'enabled': True, 03:06:22 INFO - 'halt_on_failure': False, 03:06:22 INFO - 'name': 'check_screen_resolution'},), 03:06:22 INFO - 'run_cmd_checks_enabled': True, 03:06:22 INFO - 'sps_profile': False, 03:06:22 INFO - 'sps_profile_interval': 0, 03:06:22 INFO - 'suite': 'dromaeojs-e10s', 03:06:22 INFO - 'system_bits': '32', 03:06:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:06:22 INFO - 'title': 't-yosemite-r7-0188', 03:06:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:06:22 INFO - 'use_talos_json': True, 03:06:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:06:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:06:22 INFO - 'work_dir': 'build'} 03:06:22 INFO - [mozharness: 2016-11-01 10:06:22.971561Z] Running clobber step. 03:06:22 INFO - Running pre-action listener: _resource_record_pre_action 03:06:22 INFO - Running main action method: clobber 03:06:22 INFO - rmtree: /builds/slave/test/build 03:06:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:06:25 INFO - Running post-action listener: _resource_record_post_action 03:06:25 INFO - [mozharness: 2016-11-01 10:06:25.153941Z] Finished clobber step (success) 03:06:25 INFO - [mozharness: 2016-11-01 10:06:25.154090Z] Running read-buildbot-config step. 03:06:25 INFO - Running pre-action listener: _resource_record_pre_action 03:06:25 INFO - Running main action method: read_buildbot_config 03:06:25 INFO - Using buildbot properties: 03:06:25 INFO - { 03:06:25 INFO - "project": "", 03:06:25 INFO - "product": "firefox", 03:06:25 INFO - "script_repo_revision": "production", 03:06:25 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:06:25 INFO - "repository": "", 03:06:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:06:25 INFO - "buildid": "20161101004006", 03:06:25 INFO - "stage_platform": "macosx64", 03:06:25 INFO - "basedir": "/builds/slave/test", 03:06:25 INFO - "nightly_build": "True", 03:06:25 INFO - "buildnumber": 26, 03:06:25 INFO - "slavename": "t-yosemite-r7-0188", 03:06:25 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 03:06:25 INFO - "platform": "yosemite_r7", 03:06:25 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:06:25 INFO - "branch": "mozilla-aurora", 03:06:25 INFO - "repo_path": "releases/mozilla-aurora", 03:06:25 INFO - "revision": "d9ce0a0617634b3d5d8fec265a394e4128df84c2", 03:06:25 INFO - "pgo_build": "False", 03:06:25 INFO - "builduid": "d941da38c1884f398fecd9bbcdecb6ae", 03:06:25 INFO - "slavebuilddir": "test" 03:06:25 INFO - } 03:06:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/QtTVM1l0TLOgy-TwzC6akw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:06:25 INFO - Running post-action listener: _resource_record_post_action 03:06:25 INFO - [mozharness: 2016-11-01 10:06:25.157637Z] Finished read-buildbot-config step (success) 03:06:25 INFO - [mozharness: 2016-11-01 10:06:25.157770Z] Running download-and-extract step. 03:06:25 INFO - Running pre-action listener: _resource_record_pre_action 03:06:25 INFO - Running main action method: download_and_extract 03:06:25 INFO - mkdir: /builds/slave/test/build/tests 03:06: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')]} 03:06:25 INFO - trying https://queue.taskcluster.net/v1/task/QtTVM1l0TLOgy-TwzC6akw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:06:25 INFO - Downloading https://queue.taskcluster.net/v1/task/QtTVM1l0TLOgy-TwzC6akw/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 03:06:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QtTVM1l0TLOgy-TwzC6akw/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 03:06:26 INFO - Downloaded 1199 bytes. 03:06:26 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:06:26 INFO - Using the following test package requirements: 03:06:26 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:06:26 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:06:26 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:06:26 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:06:26 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:06:26 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:06:26 INFO - u'jsshell-mac.zip'], 03:06:26 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:06:26 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:06:26 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:06:26 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:06:26 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:06:26 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:06:26 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:06:26 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:06:26 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:06:26 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:06:26 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:06:26 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:06:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QtTVM1l0TLOgy-TwzC6akw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:06:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QtTVM1l0TLOgy-TwzC6akw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:06:26 INFO - Fetch https://queue.taskcluster.net/v1/task/QtTVM1l0TLOgy-TwzC6akw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:06:26 INFO - Expected file size: 16421667 03:06:33 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 03:06:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QtTVM1l0TLOgy-TwzC6akw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:06:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QtTVM1l0TLOgy-TwzC6akw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:06:33 INFO - Fetch https://queue.taskcluster.net/v1/task/QtTVM1l0TLOgy-TwzC6akw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:06:34 INFO - Expected file size: 16421667 03:06:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QtTVM1l0TLOgy-TwzC6akw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:06:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QtTVM1l0TLOgy-TwzC6akw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:06:41 INFO - Fetch https://queue.taskcluster.net/v1/task/QtTVM1l0TLOgy-TwzC6akw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:06:42 INFO - Expected file size: 14414089 03:06:43 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')]} 03:06:43 INFO - trying https://queue.taskcluster.net/v1/task/QtTVM1l0TLOgy-TwzC6akw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:06:43 INFO - Downloading https://queue.taskcluster.net/v1/task/QtTVM1l0TLOgy-TwzC6akw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:06:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QtTVM1l0TLOgy-TwzC6akw/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 03:06:46 INFO - Downloaded 115533734 bytes. 03:06:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QtTVM1l0TLOgy-TwzC6akw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:06:46 INFO - mkdir: /builds/slave/test/properties 03:06:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:06:46 INFO - Writing to file /builds/slave/test/properties/build_url 03:06:46 INFO - Contents: 03:06:46 INFO - build_url:https://queue.taskcluster.net/v1/task/QtTVM1l0TLOgy-TwzC6akw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:06:46 INFO - Running post-action listener: _resource_record_post_action 03:06:46 INFO - Running post-action listener: set_extra_try_arguments 03:06:46 INFO - [mozharness: 2016-11-01 10:06:46.826144Z] Finished download-and-extract step (success) 03:06:46 INFO - [mozharness: 2016-11-01 10:06:46.826280Z] Running populate-webroot step. 03:06:46 INFO - Running pre-action listener: _resource_record_pre_action 03:06:46 INFO - Running main action method: populate_webroot 03:06:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:06:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:06:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:06:46 INFO - '--tppagecycles', 03:06:46 INFO - '7'], 03:06:46 INFO - 'tests': ['tsvgm']}}, 03:06:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:06:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:06:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:06:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:06:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:06:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:06:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:46 INFO - 'talos_options': ['--disable-e10s'], 03:06:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:06:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:06:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:46 INFO - 'talos_options': ['--disable-e10s'], 03:06:46 INFO - 'tests': ['damp', 'tps']}, 03:06:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:46 INFO - 'tests': ['damp', 'tps']}, 03:06:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:06:46 INFO - 'tests': ['dromaeo_dom']}, 03:06:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:06:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:06:46 INFO - 'tests': ['basic_compositor_video']}, 03:06:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:06:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:06:46 INFO - 'tests': ['a11yr', 03:06:46 INFO - 'ts_paint', 03:06:46 INFO - 'tpaint', 03:06:46 INFO - 'sessionrestore', 03:06:46 INFO - 'sessionrestore_no_auto_restore', 03:06:46 INFO - 'tabpaint']}, 03:06:46 INFO - 'other-e10s': {'tests': ['a11yr', 03:06:46 INFO - 'ts_paint', 03:06:46 INFO - 'tpaint', 03:06:46 INFO - 'sessionrestore', 03:06:46 INFO - 'sessionrestore_no_auto_restore', 03:06:46 INFO - 'tabpaint']}, 03:06:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:06:46 INFO - 'ts_paint', 03:06:46 INFO - 'tpaint', 03:06:46 INFO - 'sessionrestore', 03:06:46 INFO - 'sessionrestore_no_auto_restore', 03:06:46 INFO - 'tabpaint']}, 03:06:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:06:46 INFO - 'ts_paint', 03:06:46 INFO - 'tpaint', 03:06:46 INFO - 'sessionrestore', 03:06:46 INFO - 'sessionrestore_no_auto_restore', 03:06:46 INFO - 'tabpaint']}, 03:06:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:06:46 INFO - 'tests': ['a11yr', 03:06:46 INFO - 'ts_paint', 03:06:46 INFO - 'tpaint', 03:06:46 INFO - 'sessionrestore', 03:06:46 INFO - 'sessionrestore_no_auto_restore', 03:06:46 INFO - 'tabpaint']}, 03:06:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:06:46 INFO - 'tests': ['a11yr', 03:06:46 INFO - 'ts_paint', 03:06:46 INFO - 'tpaint', 03:06:46 INFO - 'sessionrestore', 03:06:46 INFO - 'sessionrestore_no_auto_restore', 03:06:46 INFO - 'tabpaint']}, 03:06:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:06:46 INFO - 'tests': ['tsvgx', 03:06:46 INFO - 'tsvgr_opacity', 03:06:46 INFO - 'tart', 03:06:46 INFO - 'tscrollx', 03:06:46 INFO - 'cart']}, 03:06:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:06:46 INFO - 'tsvgr_opacity', 03:06:46 INFO - 'tart', 03:06:46 INFO - 'tscrollx', 03:06:46 INFO - 'cart']}, 03:06:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:46 INFO - 'talos_options': ['--disable-e10s'], 03:06:46 INFO - 'tests': ['tp5o']}, 03:06:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:46 INFO - 'tests': ['tp5o']}, 03:06:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:46 INFO - 'talos_options': ['--disable-e10s', 03:06:46 INFO - '--xperf_path', 03:06:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:06:46 INFO - 'tests': ['tp5n']}, 03:06:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:46 INFO - 'talos_options': ['--xperf_path', 03:06:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:06:46 INFO - 'tests': ['tp5n']}}, 03:06:46 INFO - 'talos.zip': {'path': '', 03:06:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:06:46 INFO - Running post-action listener: _resource_record_post_action 03:06:46 INFO - [mozharness: 2016-11-01 10:06:46.846058Z] Finished populate-webroot step (success) 03:06:46 INFO - [mozharness: 2016-11-01 10:06:46.846172Z] Running create-virtualenv step. 03:06:46 INFO - Running pre-action listener: _resource_record_pre_action 03:06:46 INFO - Running main action method: create_virtualenv 03:06:46 INFO - Creating virtualenv /builds/slave/test/build/venv 03:06:46 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 03:06:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:06:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:06:46 INFO - Using real prefix '/tools/python27' 03:06:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:06:47 INFO - Installing distribute.............................................................................................................................................................................................done. 03:06:50 INFO - Installing pip.................done. 03:06:50 INFO - Return code: 0 03:06:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:06:50 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')]} 03:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:50 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')]} 03:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:50 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 0x1035c3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103539570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff739c9d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033d7d30>, '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 0x10323ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033cfb20>, '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.UuYob3ZAS2/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.Si0tSz24aj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 03:06:50 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 03:06:50 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 03:06:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UuYob3ZAS2/Render', 03:06:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:06:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:06:50 INFO - 'HOME': '/Users/cltbld', 03:06:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:06:50 INFO - 'LOGNAME': 'cltbld', 03:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:50 INFO - 'MOZ_NO_REMOTE': '1', 03:06:50 INFO - 'NO_EM_RESTART': '1', 03:06:50 INFO - 'PAGER': '/bin/cat', 03:06:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:50 INFO - 'PWD': '/builds/slave/test', 03:06:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:06:50 INFO - 'SHELL': '/bin/bash', 03:06:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Si0tSz24aj/Listeners', 03:06:50 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 03:06:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:06:50 INFO - 'USER': 'cltbld', 03:06:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:06:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:50 INFO - 'XPC_FLAGS': '0x0', 03:06:50 INFO - 'XPC_SERVICE_NAME': '0', 03:06:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:51 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 03:06:51 INFO - Cleaning up... 03:06:51 INFO - Return code: 0 03:06:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:51 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 0x1035c3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103539570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff739c9d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033d7d30>, '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 0x10323ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033cfb20>, '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.UuYob3ZAS2/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.Si0tSz24aj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 03:06:51 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 03:06:51 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 03:06:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UuYob3ZAS2/Render', 03:06:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:06:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:06:51 INFO - 'HOME': '/Users/cltbld', 03:06:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:06:51 INFO - 'LOGNAME': 'cltbld', 03:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:51 INFO - 'MOZ_NO_REMOTE': '1', 03:06:51 INFO - 'NO_EM_RESTART': '1', 03:06:51 INFO - 'PAGER': '/bin/cat', 03:06:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:51 INFO - 'PWD': '/builds/slave/test', 03:06:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:06:51 INFO - 'SHELL': '/bin/bash', 03:06:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Si0tSz24aj/Listeners', 03:06:51 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 03:06:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:06:51 INFO - 'USER': 'cltbld', 03:06:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:06:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:51 INFO - 'XPC_FLAGS': '0x0', 03:06:51 INFO - 'XPC_SERVICE_NAME': '0', 03:06:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:51 INFO - Downloading/unpacking psutil>=3.1.1 03:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:06:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:06:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:06:55 INFO - Installing collected packages: psutil 03:06:55 INFO - Running setup.py install for psutil 03:06:55 INFO - building 'psutil._psutil_osx' extension 03:06:55 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 03:06:55 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 03:06:55 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 03:06:55 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 03:06:56 INFO - building 'psutil._psutil_posix' extension 03:06:56 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 03:06:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:06:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:06:56 INFO - ^ 03:06:56 INFO - 1 warning generated. 03:06:56 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 03:06:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:06:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:06:56 INFO - Successfully installed psutil 03:06:56 INFO - Cleaning up... 03:06:56 INFO - Return code: 0 03:06:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:06:56 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')]} 03:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:56 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')]} 03:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:56 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 0x1035c3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103539570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff739c9d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033d7d30>, '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 0x10323ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033cfb20>, '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.UuYob3ZAS2/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.Si0tSz24aj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 03:06:56 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 03:06:56 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 03:06:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UuYob3ZAS2/Render', 03:06:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:06:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:06:56 INFO - 'HOME': '/Users/cltbld', 03:06:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:06:56 INFO - 'LOGNAME': 'cltbld', 03:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:56 INFO - 'MOZ_NO_REMOTE': '1', 03:06:56 INFO - 'NO_EM_RESTART': '1', 03:06:56 INFO - 'PAGER': '/bin/cat', 03:06:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:56 INFO - 'PWD': '/builds/slave/test', 03:06:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:06:56 INFO - 'SHELL': '/bin/bash', 03:06:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Si0tSz24aj/Listeners', 03:06:56 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 03:06:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:06:56 INFO - 'USER': 'cltbld', 03:06:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:06:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:56 INFO - 'XPC_FLAGS': '0x0', 03:06:56 INFO - 'XPC_SERVICE_NAME': '0', 03:06:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:06:56 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 03:06:56 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 03:06:56 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 03:06:56 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 03:06:56 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 03:06:56 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 03:06:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:06:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:06:59 INFO - Installing collected packages: mozsystemmonitor 03:06:59 INFO - Running setup.py install for mozsystemmonitor 03:06:59 INFO - Successfully installed mozsystemmonitor 03:06:59 INFO - Cleaning up... 03:06:59 INFO - Return code: 0 03:06:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:59 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 0x1035c3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103539570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff739c9d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033d7d30>, '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 0x10323ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033cfb20>, '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.UuYob3ZAS2/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.Si0tSz24aj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 03:06:59 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 03:06:59 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 03:06:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UuYob3ZAS2/Render', 03:06:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:06:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:06:59 INFO - 'HOME': '/Users/cltbld', 03:06:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:06:59 INFO - 'LOGNAME': 'cltbld', 03:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:59 INFO - 'MOZ_NO_REMOTE': '1', 03:06:59 INFO - 'NO_EM_RESTART': '1', 03:06:59 INFO - 'PAGER': '/bin/cat', 03:06:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:59 INFO - 'PWD': '/builds/slave/test', 03:06:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:06:59 INFO - 'SHELL': '/bin/bash', 03:06:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Si0tSz24aj/Listeners', 03:06:59 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 03:06:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:06:59 INFO - 'USER': 'cltbld', 03:06:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:06:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:59 INFO - 'XPC_FLAGS': '0x0', 03:06:59 INFO - 'XPC_SERVICE_NAME': '0', 03:06:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:06:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:59 INFO - Downloading/unpacking jsonschema==2.5.1 03:06:59 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 03:06:59 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 03:06:59 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 03:06:59 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 03:06:59 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 03:06:59 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 03:07:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:07:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:07:02 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 03:07:02 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 03:07:02 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 03:07:02 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 03:07:02 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 03:07:02 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 03:07:02 INFO - Downloading functools32-3.2.3-2.tar.gz 03:07:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:07:02 INFO - warning: no files found matching '*.txt' 03:07:02 INFO - no previously-included directories found matching 'build' 03:07:02 INFO - no previously-included directories found matching 'dist' 03:07:02 INFO - no previously-included directories found matching '.git*' 03:07:02 INFO - Installing collected packages: jsonschema, functools32 03:07:02 INFO - Running setup.py install for functools32 03:07:02 INFO - warning: no files found matching '*.txt' 03:07:02 INFO - no previously-included directories found matching 'build' 03:07:02 INFO - no previously-included directories found matching 'dist' 03:07:02 INFO - no previously-included directories found matching '.git*' 03:07:02 INFO - Successfully installed jsonschema functools32 03:07:02 INFO - Cleaning up... 03:07:03 INFO - Return code: 0 03:07:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1035c3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103539570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff739c9d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033d7d30>, '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 0x10323ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033cfb20>, '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.UuYob3ZAS2/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.Si0tSz24aj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 03:07:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:07:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UuYob3ZAS2/Render', 03:07:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:03 INFO - 'HOME': '/Users/cltbld', 03:07:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:03 INFO - 'LOGNAME': 'cltbld', 03:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:03 INFO - 'MOZ_NO_REMOTE': '1', 03:07:03 INFO - 'NO_EM_RESTART': '1', 03:07:03 INFO - 'PAGER': '/bin/cat', 03:07:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:03 INFO - 'PWD': '/builds/slave/test', 03:07:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:03 INFO - 'SHELL': '/bin/bash', 03:07:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Si0tSz24aj/Listeners', 03:07:03 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 03:07:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:03 INFO - 'USER': 'cltbld', 03:07:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:03 INFO - 'XPC_FLAGS': '0x0', 03:07:03 INFO - 'XPC_SERVICE_NAME': '0', 03:07:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:07:03 INFO - Cleaning up... 03:07:03 INFO - Return code: 0 03:07:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1035c3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103539570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff739c9d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033d7d30>, '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 0x10323ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033cfb20>, '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.UuYob3ZAS2/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.Si0tSz24aj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 03:07:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:07:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UuYob3ZAS2/Render', 03:07:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:03 INFO - 'HOME': '/Users/cltbld', 03:07:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:03 INFO - 'LOGNAME': 'cltbld', 03:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:03 INFO - 'MOZ_NO_REMOTE': '1', 03:07:03 INFO - 'NO_EM_RESTART': '1', 03:07:03 INFO - 'PAGER': '/bin/cat', 03:07:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:03 INFO - 'PWD': '/builds/slave/test', 03:07:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:03 INFO - 'SHELL': '/bin/bash', 03:07:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Si0tSz24aj/Listeners', 03:07:03 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 03:07:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:03 INFO - 'USER': 'cltbld', 03:07:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:03 INFO - 'XPC_FLAGS': '0x0', 03:07:03 INFO - 'XPC_SERVICE_NAME': '0', 03:07:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:06 INFO - Downloading blobuploader-1.2.4.tar.gz 03:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:07:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:07:06 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 03:07:06 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 03:07:06 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 03:07:06 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 03:07:06 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 03:07:06 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 03:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:07:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:07:06 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 03:07:06 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 03:07:06 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 03:07:06 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 03:07:06 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 03:07:06 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 03:07:07 INFO - Downloading docopt-0.6.1.tar.gz 03:07:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:07:07 INFO - Installing collected packages: blobuploader, requests, docopt 03:07:07 INFO - Running setup.py install for blobuploader 03:07:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:07:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:07:07 INFO - Running setup.py install for requests 03:07:08 INFO - Running setup.py install for docopt 03:07:08 INFO - Successfully installed blobuploader requests docopt 03:07:08 INFO - Cleaning up... 03:07:08 INFO - Return code: 0 03:07:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:08 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')]} 03:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:08 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')]} 03:07:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:08 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 0x1035c3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103539570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff739c9d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033d7d30>, '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 0x10323ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033cfb20>, '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.UuYob3ZAS2/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.Si0tSz24aj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 03:07:08 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 03:07:08 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 03:07:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UuYob3ZAS2/Render', 03:07:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:08 INFO - 'HOME': '/Users/cltbld', 03:07:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:08 INFO - 'LOGNAME': 'cltbld', 03:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:08 INFO - 'MOZ_NO_REMOTE': '1', 03:07:08 INFO - 'NO_EM_RESTART': '1', 03:07:08 INFO - 'PAGER': '/bin/cat', 03:07:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:08 INFO - 'PWD': '/builds/slave/test', 03:07:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:08 INFO - 'SHELL': '/bin/bash', 03:07:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Si0tSz24aj/Listeners', 03:07:08 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 03:07:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:08 INFO - 'USER': 'cltbld', 03:07:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:08 INFO - 'XPC_FLAGS': '0x0', 03:07:08 INFO - 'XPC_SERVICE_NAME': '0', 03:07:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:07:08 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-f0sPul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:07:08 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-SuQjUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:07:08 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-Y8x7C_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:07:08 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-AP7bWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:07:09 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-SGsesq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:07:09 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-obo5Gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:07:09 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-bexDzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:07:09 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-SP3gPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:07:09 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-0qbYlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:07:09 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-FOR4zB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:07:09 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-RTZ7UY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:07:09 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-7TID00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:07:09 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-OrbMCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:07:10 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-K0kTvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:10 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-xzZCmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:07:10 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-YcOUtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:07:10 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-ctDZP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:07:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:07:10 INFO - Running setup.py install for manifestparser 03:07:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:07:10 INFO - Running setup.py install for mozcrash 03:07:10 INFO - Running setup.py install for mozdebug 03:07:10 INFO - Running setup.py install for mozdevice 03:07:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:07:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:07:11 INFO - Running setup.py install for mozfile 03:07:11 INFO - Running setup.py install for mozhttpd 03:07:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:07:11 INFO - Running setup.py install for mozinfo 03:07:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:07:11 INFO - Running setup.py install for mozInstall 03:07:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:07:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:07:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:07:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:07:11 INFO - Running setup.py install for mozleak 03:07:11 INFO - Running setup.py install for mozlog 03:07:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:07:11 INFO - Running setup.py install for moznetwork 03:07:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:07:12 INFO - Running setup.py install for mozprocess 03:07:12 INFO - Running setup.py install for mozprofile 03:07:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:07:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:07:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:07:12 INFO - Running setup.py install for mozrunner 03:07:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:07:12 INFO - Running setup.py install for mozscreenshot 03:07:12 INFO - Running setup.py install for moztest 03:07:12 INFO - Running setup.py install for mozversion 03:07:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:07:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:07:13 INFO - Cleaning up... 03:07:13 INFO - Return code: 0 03:07:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:13 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')]} 03:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:13 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')]} 03:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:13 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 0x1035c3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103539570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff739c9d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033d7d30>, '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 0x10323ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033cfb20>, '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.UuYob3ZAS2/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.Si0tSz24aj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 03:07:13 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 03:07:13 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 03:07:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UuYob3ZAS2/Render', 03:07:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:13 INFO - 'HOME': '/Users/cltbld', 03:07:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:13 INFO - 'LOGNAME': 'cltbld', 03:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:13 INFO - 'MOZ_NO_REMOTE': '1', 03:07:13 INFO - 'NO_EM_RESTART': '1', 03:07:13 INFO - 'PAGER': '/bin/cat', 03:07:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:13 INFO - 'PWD': '/builds/slave/test', 03:07:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:13 INFO - 'SHELL': '/bin/bash', 03:07:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Si0tSz24aj/Listeners', 03:07:13 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 03:07:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:13 INFO - 'USER': 'cltbld', 03:07:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:13 INFO - 'XPC_FLAGS': '0x0', 03:07:13 INFO - 'XPC_SERVICE_NAME': '0', 03:07:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:07:13 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-xrU1n9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:07:13 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)) 03:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:07:13 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-jRZHzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:07:13 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)) 03:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:07:13 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-uXg3SP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:07:13 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)) 03:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:07:13 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-XzEPW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:07:13 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)) 03:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:07:13 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-P1TxOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:07:13 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)) 03:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:07:13 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-VHN10l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:07:13 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)) 03:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:07:13 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-JGAsYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:07:14 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)) 03:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:07:14 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-xdqMQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:07:14 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)) 03:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:07:14 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-MnlFch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:07:14 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)) 03:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:07:14 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-DocfIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:07:14 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)) 03:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:07:14 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-kAoB_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:07:14 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)) 03:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:07:14 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-LKUgkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:07:14 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)) 03:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:07:14 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-zHEj8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:07:14 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)) 03:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:07:14 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-iqWxHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:07:14 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)) 03:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:14 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-RZEmEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:14 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)) 03:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:07:14 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-H1ctXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:07:15 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)) 03:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:07:15 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-t0v4HP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:07:15 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)) 03:07:15 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)) 03:07:15 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)) 03:07:15 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)) 03:07:15 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)) 03:07:15 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)) 03:07:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:07:15 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 03:07:15 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 03:07:15 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 03:07:15 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 03:07:15 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 03:07:15 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 03:07:17 INFO - Downloading blessings-1.6.tar.gz 03:07:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:07:17 INFO - Installing collected packages: blessings 03:07:17 INFO - Running setup.py install for blessings 03:07:17 INFO - Successfully installed blessings 03:07:17 INFO - Cleaning up... 03:07:18 INFO - Return code: 0 03:07:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:07:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:07:18 INFO - Reading from file tmpfile_stdout 03:07:18 INFO - Current package versions: 03:07:18 INFO - blessings == 1.6 03:07:18 INFO - blobuploader == 1.2.4 03:07:18 INFO - docopt == 0.6.1 03:07:18 INFO - functools32 == 3.2.3-2 03:07:18 INFO - jsonschema == 2.5.1 03:07:18 INFO - manifestparser == 1.1 03:07:18 INFO - mozInstall == 1.12 03:07:18 INFO - mozcrash == 0.17 03:07:18 INFO - mozdebug == 0.1 03:07:18 INFO - mozdevice == 0.48 03:07:18 INFO - mozfile == 1.2 03:07:18 INFO - mozhttpd == 0.7 03:07:18 INFO - mozinfo == 0.9 03:07:18 INFO - mozleak == 0.1 03:07:18 INFO - mozlog == 3.4 03:07:18 INFO - moznetwork == 0.27 03:07:18 INFO - mozprocess == 0.23 03:07:18 INFO - mozprofile == 0.28 03:07:18 INFO - mozrunner == 6.12 03:07:18 INFO - mozscreenshot == 0.1 03:07:18 INFO - mozsystemmonitor == 0.3 03:07:18 INFO - moztest == 0.7 03:07:18 INFO - mozversion == 1.4 03:07:18 INFO - psutil == 3.1.1 03:07:18 INFO - requests == 1.2.3 03:07:18 INFO - wsgiref == 0.1.2 03:07:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:18 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 0x1035c3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103539570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff739c9d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033d7d30>, '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 0x10323ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033cfb20>, '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.UuYob3ZAS2/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.Si0tSz24aj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 03:07:18 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 03:07:18 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 03:07:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UuYob3ZAS2/Render', 03:07:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:18 INFO - 'HOME': '/Users/cltbld', 03:07:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:18 INFO - 'LOGNAME': 'cltbld', 03:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:18 INFO - 'MOZ_NO_REMOTE': '1', 03:07:18 INFO - 'NO_EM_RESTART': '1', 03:07:18 INFO - 'PAGER': '/bin/cat', 03:07:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:18 INFO - 'PWD': '/builds/slave/test', 03:07:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:18 INFO - 'SHELL': '/bin/bash', 03:07:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Si0tSz24aj/Listeners', 03:07:18 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 03:07:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:18 INFO - 'USER': 'cltbld', 03:07:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:18 INFO - 'XPC_FLAGS': '0x0', 03:07:18 INFO - 'XPC_SERVICE_NAME': '0', 03:07:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:18 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)) 03:07:18 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)) 03:07:18 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)) 03:07:18 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)) 03:07:18 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)) 03:07:18 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)) 03:07:18 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)) 03:07:18 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)) 03:07:18 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)) 03:07:18 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)) 03:07:18 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)) 03:07:18 INFO - Cleaning up... 03:07:18 INFO - Return code: 0 03:07:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:18 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 0x1035c3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103539570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff739c9d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033d7d30>, '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 0x10323ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033cfb20>, '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.UuYob3ZAS2/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.Si0tSz24aj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 03:07:18 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 03:07:18 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 03:07:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UuYob3ZAS2/Render', 03:07:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:18 INFO - 'HOME': '/Users/cltbld', 03:07:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:18 INFO - 'LOGNAME': 'cltbld', 03:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:18 INFO - 'MOZ_NO_REMOTE': '1', 03:07:18 INFO - 'NO_EM_RESTART': '1', 03:07:18 INFO - 'PAGER': '/bin/cat', 03:07:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:18 INFO - 'PWD': '/builds/slave/test', 03:07:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:18 INFO - 'SHELL': '/bin/bash', 03:07:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Si0tSz24aj/Listeners', 03:07:18 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 03:07:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:18 INFO - 'USER': 'cltbld', 03:07:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:18 INFO - 'XPC_FLAGS': '0x0', 03:07:18 INFO - 'XPC_SERVICE_NAME': '0', 03:07:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:07:18 INFO - Cleaning up... 03:07:18 INFO - Return code: 0 03:07:18 INFO - Running post-action listener: _resource_record_post_action 03:07:18 INFO - Running post-action listener: _start_resource_monitoring 03:07:18 INFO - Starting resource monitoring. 03:07:18 INFO - [mozharness: 2016-11-01 10:07:18.901475Z] Finished create-virtualenv step (success) 03:07:18 INFO - [mozharness: 2016-11-01 10:07:18.902427Z] Running install step. 03:07:18 INFO - Running pre-action listener: _resource_record_pre_action 03:07:18 INFO - Running main action method: install 03:07:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:07:19 INFO - Reading from file tmpfile_stdout 03:07:19 INFO - Detecting whether we're running mozinstall >=1.0... 03:07:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:07:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:07:19 INFO - Reading from file tmpfile_stdout 03:07:19 INFO - Output received: 03:07:19 INFO - Usage: mozinstall [options] installer 03:07:19 INFO - Options: 03:07:19 INFO - -h, --help show this help message and exit 03:07:19 INFO - -d DEST, --destination=DEST 03:07:19 INFO - Directory to install application into. [default: 03:07:19 INFO - "/builds/slave/test"] 03:07:19 INFO - --app=APP Application being installed. [default: firefox] 03:07:19 INFO - mkdir: /builds/slave/test/build/application 03:07:19 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'] 03:07:19 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 03:07:51 INFO - Reading from file tmpfile_stdout 03:07:51 INFO - Output received: 03:07:51 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:07:51 INFO - Running post-action listener: _resource_record_post_action 03:07:51 INFO - [mozharness: 2016-11-01 10:07:51.817383Z] Finished install step (success) 03:07:51 INFO - [mozharness: 2016-11-01 10:07:51.817497Z] Running run-tests step. 03:07:51 INFO - Running pre-action listener: _resource_record_pre_action 03:07:51 INFO - Running main action method: run_tests 03:07:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:07:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:07:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:07:51 INFO - 2016-11-01 03:07:51.832 screenresolution[1646:8826] starting screenresolution argv=screenresolution get 03:07:51 INFO - 2016-11-01 03:07:51.834 screenresolution[1646:8826] Display 0: 1600x1200x32@60 03:07:51 INFO - 2016-11-01 03:07:51.840 screenresolution[1647:8828] starting screenresolution argv=screenresolution list 03:07:51 INFO - Available Modes on Display 0 03:07:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:07:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:07:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:07:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:07:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:07:52 INFO - Intel Iris: 03:07:52 INFO - Chipset Model: Intel Iris 03:07:52 INFO - Type: GPU 03:07:52 INFO - Bus: Built-In 03:07:52 INFO - VRAM (Dynamic, Max): 1536 MB 03:07:52 INFO - Vendor: Intel (0x8086) 03:07:52 INFO - Device ID: 0x0a2e 03:07:52 INFO - Revision ID: 0x0009 03:07:52 INFO - Displays: 03:07:52 INFO - Display: 03:07:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:07:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:07:52 INFO - Display Serial Number: 1600x1200 60 03:07:52 INFO - Main Display: Yes 03:07:52 INFO - Mirror: Off 03:07:52 INFO - Online: Yes 03:07:52 INFO - Rotation: Supported 03:07:52 INFO - Return code: 0 03:07:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:07:52 INFO - Python 2.7.3 03:07:52 INFO - Return code: 0 03:07:52 INFO - grabbing minidump binary from tooltool 03:07: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')]} 03:07:52 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 0x1033d7d30>, '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 0x10323ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033cfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:07:52 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 03:07:52 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 03:07:52 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 03:07:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:07:52 INFO - Return code: 0 03:07:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:07:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:07:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:07:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:07:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:07:52 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/QtTVM1l0TLOgy-TwzC6akw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0188', '--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 03:07:52 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/QtTVM1l0TLOgy-TwzC6akw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0188 --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 03:07:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UuYob3ZAS2/Render', 03:07:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:52 INFO - 'HOME': '/Users/cltbld', 03:07:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:52 INFO - 'LOGNAME': 'cltbld', 03:07:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:07:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:52 INFO - 'MOZ_NO_REMOTE': '1', 03:07:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:07:52 INFO - 'NO_EM_RESTART': '1', 03:07:52 INFO - 'PAGER': '/bin/cat', 03:07:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:52 INFO - 'PWD': '/builds/slave/test', 03:07:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:07:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:52 INFO - 'SHELL': '/bin/bash', 03:07:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Si0tSz24aj/Listeners', 03:07:52 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 03:07:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:52 INFO - 'USER': 'cltbld', 03:07:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:52 INFO - 'XPC_FLAGS': '0x0', 03:07:52 INFO - 'XPC_SERVICE_NAME': '0', 03:07:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:52 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/QtTVM1l0TLOgy-TwzC6akw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0188', '--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 03:07:52 INFO - mozversion application_buildid: 20161101004006 03:07:52 INFO - mozversion application_changeset: d9ce0a0617634b3d5d8fec265a394e4128df84c2 03:07:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:07:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:07:52 INFO - mozversion application_name: Firefox 03:07:52 INFO - mozversion application_remotingname: firefox-dev 03:07:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:07:52 INFO - mozversion application_vendor: Mozilla 03:07:52 INFO - mozversion application_version: 51.0a2 03:07:52 INFO - mozversion platform_buildid: 20161101004006 03:07:52 INFO - mozversion platform_changeset: d9ce0a0617634b3d5d8fec265a394e4128df84c2 03:07:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:07:52 INFO - mozversion platform_version: 51.0a2 03:07:52 INFO - using testdate: 1477994872 03:07:52 INFO - actual date: 1477994872 03:07:52 INFO - starting webserver on 'localhost:49281' 03:07:52 INFO - SUITE-START | Running 2 tests 03:07:52 INFO - TEST-START | dromaeo_css 03:07:52 INFO - operating with platform_type : mac_ 03:07:52 INFO - Initialising browser for dromaeo_css test... 03:07:52 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmp5L3Y76/profile http://localhost:49281/getInfo.html) 03:07:55 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 03:07:55 INFO - PROCESS | 1657 | colorDepth:24 03:07:55 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 03:07:55 INFO - PROCESS | 1657 | __metrics 03:07:55 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 03:07:55 INFO - TEST-INFO | 1657: exit 0 03:07:55 INFO - Browser initialized. 03:07:55 INFO - Running cycle 1/1 for dromaeo_css test... 03:07:55 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmp5L3Y76/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:08 INFO - PROCESS | 1662 | RSS: Main: 225431552 03:08:08 INFO - PROCESS | 1662 | 03:08:57 INFO - PROCESS | 1662 | 1477994937771 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] 03:11:10 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49281/tests/dromaeo/cssquery-ext.html) 03:11:12 INFO - PROCESS | 1662 | RSS: Main: 237125632 03:11:12 INFO - PROCESS | 1662 | 03:14:14 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-ext.html (next: http://localhost:49281/tests/dromaeo/cssquery-jquery.html) 03:14:15 INFO - PROCESS | 1662 | RSS: Main: 249290752 03:14:15 INFO - PROCESS | 1662 | 03:17:17 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49281/tests/dromaeo/cssquery-mootools.html) 03:17:17 INFO - PROCESS | 1662 | RSS: Main: 251928576 03:17:17 INFO - PROCESS | 1662 | 03:20:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49281/tests/dromaeo/cssquery-prototype.html) 03:20:20 INFO - PROCESS | 1662 | RSS: Main: 252166144 03:20:20 INFO - PROCESS | 1662 | 03:23:22 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49281/tests/dromaeo/cssquery-yui.html) 03:23:23 INFO - PROCESS | 1662 | RSS: Main: 256585728 03:23:23 INFO - PROCESS | 1662 | 03:26:26 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-yui.html (next: http://localhost:49281/tests/dromaeo/cssquery-dojo.html) 03:26:26 INFO - PROCESS | 1662 | RSS: Main: 258203648 03:26:26 INFO - PROCESS | 1662 | 03:26:26 INFO - PROCESS | 1662 | __start_tp_report 03:26:26 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 03:26:26 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 03:26:26 INFO - PROCESS | 1662 | |i|pagename|runs| 03:26:26 INFO - PROCESS | 1662 | |0;dojo.html;3349.380364632543;3462.463318185682;3470.3753324401596;3472.635373285805;3512.279982603565;5956.957532431823;6007.849803754908;6032.69836508175;6032.8190154295335;6050.42520960508;5964.612300200484;5991.011483105282;5997.040473524237;6057.818265452032;6076.210092687945;5326.440723724011;5422.996745602057;5424;5486;5587.525060369873;5409.43200963899;5502.174673798922;5502.752376143063;5507.118860982244;5511.53151982082;5385.111456609655;5410.648307859996;5487.807926722566;5494.2857428534235;5502.504774570288;5467.015937131335;5505.9724701376435;5544.63959842609;5568.972155139239;5601.019821531216;5370.140777475585;5489.972550137264;5492.890142197134;5501.559875209973;5526.696031718254;5753.453421924911;6003.519718422515;6043.214382130339;6116;6121.724522396503;6150.354212807681;6209.441150296495;6245.718942647592;6251.968740156316;6357.93642063578;6443.9355606443805;6444.903326450107;6447.484201263887;6479.222493300834;6487.253965793947;4962.727050012284;6123;6123.540734444934;6127.264728232641;6133.509319254449;6321;6395.072714456378;6433.356664333529;6524.836879077966;6535.0850880876715;6210.596311239755;6264.21697287839;6266.216722909637;6268.905966410507;6271.341509141565;6415.582987105823;6417;6417.2299324081405;6457.2896981332015;6457.967710161419;6128.900367973304;6168.9691551542855;6170.167027451326;6205.720742566505;6299.307076221612;6293.527985401113;6295.307516173218;6295.905561416583;6313.179286692701;6319.304876463585;5050.747462626854;5093.2105523643895;5100.591952643779;5103.948960510422;5144.356955380577;4417.779111044435;4485.618722408566;4535.569120933506;4538.682292239511;4539.933115717804;5276.997370499593;6059.909101363483;6125.173101631222;6136.386361363828;6137.009281402767;6410.839729006812;6446.645434501053;6454.290028096905;6454.580452270588;6464.515161362822;5925.4370834770625;5976;6002.6698531580305;6005.939940600625;6039.577229593886;5289.233061206103;5590;5597.328320601554;5630.23991761107;5647.604667673223;6585.539012269191;6594.208694956636;6597.406233439014;6604.108445360007;6622.569532980341;6171.59884607499;6251.6561589113035;6346.460550853045;6366.77716279928;6378.936210637834;6630.535862489773;6633.933660663524;6634.800955971328;6647.60114393138;6649.102371179829;5191.870203244949;6328.778492752732;6342.207224096988;6358.459530939922;6378.170837791057;6174.475169610633;6251.843703907439;6392.808215753535;6420.518461115342;6448.64532450701;6051.848703782441;6115.514161902999;6180.103884936569;6200.844978875564;6215.471684906653;6209.813705588839;6221;6223.128761973418;6241.344658810941;6245.750849830143;5332.813351532678;5995.6702381367695;6037.486813620716;6163.476104531165;6241.500679945502;6118.619179173164;6140.412224875342;6194.690265486798;6206.906896396467;6223.595466294676;6109.511239100772;6136.325004249618;6139.048447490646;6148.077788331607;6209.316975132641 03:26:26 INFO - PROCESS | 1662 | |1;ext.html;433.2029066517607;456.5274940436649;528.8942211557687;529.9735013249336;547.1109447148385;40405.79797101014;42090.78954605226;42091.15817683652;42151.789241053826;42285.78857105714;33876.15309617261;35527.822360888225;35851.10372240695;43607.34588981168;44040.67877963658;9966.202703783698;10146.949265253663;10147.238957078212;10162.745931351701;10166.949165254164;9982.50087495626;10052.396856188616;10054.195664346835;10083.19334453242;10112.59549618018;8672.826543469128;10061.14480269178;10083.899161008369;10110.342827716211;10119.342242754234;9714.077162669535;9947.253955953332;9950.203983681287;10027.147692446115;10079.94160613136;8678.652853885837;9845.90154098457;9992;9995.850062249072;10005.149562287213;41107.1778564427;41113.1777364454;41258.793706031276;41408;41443.7927810362;3337.1823903143886;3537.6108628050893;3537.7700449470703;3825.8660946866726;3968.503937007874;30193.547096793565;30218.54672179919;31828.20429489258;32363.19092022695;32405.189870253198;3101.2246938265434;3289.967100329014;3300.950485742716;3367.8316084195694;3400.931981360384;389563;432289;433447.8327608342;477407;483170.9999999965;32944.67055329416;60258.39741602528;60738;61000.69499652562;61027.69486152541;33999;34242.14394640154;34350;34385;34450.310993780484;15387.076775393512;15417.229138543027;15448.459303924308;15475.535733928;15475.690486190213;13054.282014489105;13068.150570212905;13146;13179.879710224739;13204.207747535178;7813.960930195312;7826.608669566499;7829.882551761728;7872.881906771403;7905.56519391439;3240.8055516669074;3267.101547074526;3275.737940964717;3302.7688061835443;3306.57014588102;937.0910217089412;958.6884262614678;959.827231098409;992.9702108936743;1050.112654806687;30449.543256851164;30846.228844279074;30935.381292374026;31357.686423135932;31441;1042.9843552346722;1076.0315715855793;1077.4289626497969;1089.145021158387;1143.6626195272415;13129.67175820593;15944.521664350088;16024.679506410039;16106.75839862403;16281.023138611721;594689;601505;602336;603010;603040;58617.706911466026;59323;59407;59506.40493595095;59537;1337.458329376604;1374.71131062476;1385.7990591363994;1398.1890503508143;1399.818023656918;29844;30645;30696.53955190629;30783.69216307808;31234.21914452157;48557.75721121372;51280.48719512757;51414.74292628513;51698.74150629223;51906;406525;455809;484516.5774171107;512421;535310;22526.662100068184;26358.341041474116;26495.867520662272;26593.202203933914;26782.732172678025;45728;46532.30201546912;47714;47959.56121316366;48083.797905052656;34202.14494637654;34605;38193.42709859299;38608;40869;39410.80294598509;39521;39614;40521.594784051784;40781.79609101936;38078.80960595179;38423.42364864473;39005.21989560136;39103.608963909996;40554.59445405626;31828.72685092663;35508.934731958085;35609.82195089111;35875.28249435049;36087.09782255465;26240.507151820548;26373.340666482723;26434.86782566075;26486.205413837615;27020.72979270261 03:26:26 INFO - PROCESS | 1662 | |2;jquery.html;365.7366695978895;374.87629082402793;374.9906252343693;375.2195433498323;397.6659605931017;19442.805571944275;20654.48363790906;20959.895200523995;21053.578928421422;21220.681689774665;20216.292429764962;20384.184632614713;20406.081726322314;20497.897510512463;20649.896750516265;5605.047141985852;5873.530117590582;5876.147958546008;5925.437083477084;6116.663583502906;3901.804909754515;4126.5254495732925;5104.3619547556555;6219.502439804804;6299.307076221612;5931.317898441691;6185.783497577586;6220.564560480768;6254.43710066094;6275.717592708316;6020.0367941129425;6163.476104531098;6232.594881332721;6237.313895471494;6254.874902501924;6034.1853849730605;6070.6661133637635;6077.665728384937;6086.482648974842;6107;23633.409164770845;24129.517409651886;25353.492930141292;26080.087196948014;26269.605955910676;2224.443889027743;2238.171876405724;2311.3412677386864;3067.524533697258;3087.7375423089065;9570.952145239298;9700.660476883275;10375.221858360654;10391.37651740898;10425.843612345821;1704.7272436410115;1819.8635102367375;1841.2174825699024;1860.9906950465297;1884.3969929622526;128659.35670321682;131871;133663;134755;139904.30047849697;11511.654650360502;11529.192956492965;11751.941240293743;11833.467493962793;11858.525658973544;14655;14827.77758333626;14835.851641483663;14841.183734894468;14869.47956821506;7170.354668079898;8583.484990900566;8627.22354988054;8760.605772740242;8857.11428857109;7056.15326160864;8665.306775457948;8791.736247912573;8891.932968043746;8915.687950921687;4516.548345165457;4517.34498497716;4567.337736028324;4580.083983203373;4624.190766615896;1589.8489643483852;1681.3946979087518;1879.774427068733;1948.9415317540497;1960.7647082350209;841.5876220651836;924.8843894513186;935.1163150822543;980.6028558433845;1021.6322124035341;20942;21019.68470472944;21050.2632407865;21081;21121.894390528258;842.9704960326482;917.7613820406609;940.9435433873853;1007.4358359318805;1040.095117247999;10828.025477707044;11191.888081119085;11204.383758893338;11230.494627741771;11264.267822591506;598553;606375;606772;618136;621122;126786;127318;128697.35651321683;134092;135483;968.951552422376;971.062924278075;974.0016483104732;981.1218959031627;981.6269817469316;14138;14426.783598246244;18623.44129676112;18858;18956.052197390352;52895.735521322145;53222.467775321755;53460.46539534555;54023;54844.90310193854;74152.62923685563;77010.6149469249;79292;79355.23497071191;79529.8070528931;5833.329167145833;6220.502359811295;7228.385587225145;7457.291557302047;7779.883301750591;9319.347645664739;12140.02879769634;12779.36103194855;12820.487180513048;13215.471381145031;8701.956490217508;10865.402402867918;10993;11191.72020699489;11209.943950280196;10705.357678539312;10909.618163364245;11477.727433946739;11690.240134391237;11907.761844762883;11111.333320000502;11373.943130284295;11422.543098275975;11466.426678665866;11674.649760507198;8280.337572994267;8327.50034997902;8433.662653493791;8451.619677114668;8556.229939305493;9458.734730360567;11028.944855275673;11407.600733974272;11632.185746997968;11723.237989530653 03:26:26 INFO - PROCESS | 1662 | |3;mootools.html;1485.2944851195684;1529.6023034011155;1710.2816816936886;1791.5700231944338;1803.3958623861006;8022.518648881057;8295.377846661495;8483.91516084839;9077.72766816995;9089.227415669668;8197.631106600202;8358;8496.107908669594;8811.118888111185;8826.029136794947;2390.3665528634883;2414.7343792182846;2417.371483414316;2419.7096348438213;2424.9393765155924;2386.820988425875;2410.602250628653;2417.891194896225;2428.5871401861637;2438.1588352018525;2403.4472071423584;2414.517096580682;2420.782129608335;2425.369403954967;2428.659987601737;1985.1959956217754;2385.5228954209056;2390.4023994001586;2406.42245860993;2414.468816860288;2381.1784934197676;2388;2401.5317013182434;2402.759724027601;2405.9759402406103;8960.8655870162;9006.234470070052;9032.548372581345;9042.954785226098;9043.547822608909;4824.421069471651;4843.927341089887;5265.6840589564745;5311.521963023347;5402.972985135049;3546.85812567497;3712.9628703713156;3735.7198210134347;3765.7740535567955;3797.0886987123167;1076.5478499030348;1100.4772732951865;1108.130117857486;1124.415304041902;1133.0369186191754;11672.299662020307;11798.469068891834;11865.52537898483;11875.406229688568;11880;3996.960030399659;4612.331211974312;4830.806767729251;4849.2726091085915;4877.097736918681;8973.788538547344;9289.21041711462;9623.903760962441;9953.153981911473;9991.600335986624;5333;5401.2168235606405;5424.538914192259;5429.267048948421;5438.592105592096;4033.4554835097474;4354.390385346054;4532.682712210114;4908.950910490921;4960.801567937314;4002.699797515198;4029.15387768566;4093.3246014407887;4127.587241275908;4159.625633692982;1190.0657983482924;1203.8022167942777;1252.2861968677948;1305.1777380250383;1306.399056434051;786.7757689058591;830.3066939105794;855.6534603485599;887.5384799904014;963.450833025183;5551.195076713934;5970.462658360769;5992.101184822312;6042.425969532887;6234.5635805494085;437.2370213976631;437.457552634737;447.961923236522;457.1337315786566;462.15425770839283;3508.4035713928693;3557.964420355763;4117.258893399157;4164.8542301019315;4234.978825105916;10146.188304935587;10796.406197659047;10835.67492975212;10885.074768644596;10902.5093870776;10463.319884207502;10705.518251678694;10853.511591978222;10926.726831829268;10940.781184376427;8192.34461243099;8332.791680208044;8354.66581336752;8368.958155209306;8376.455530390384;5932.940670593239;5979.820605381846;6005.759769609167;6049;6086.513078953584;9698.46658433793;9915.702528924145;10019.649312274036;10083.697489075339;10141.138003269805;10322.380657160595;10358.274920755775;10413.062824345845;10426.061654451136;10441.791164176826;6854.725810967506;7079.327463890922;7309.232530584212;7557;7640.388768898363;8278.337732981467;8606.311495080254;8616.827663446571;8633.654653813777;8651.52416617067;7490.925090749023;7602.697731453079;7652.923470765221;7684.269994350528;7758.806029849299;7413.518121322097;7414.073240844895;7429.33136017761;7552.697892084255;7583.2416758323725;6367.745290188341;7011.878099504055;7175.174854891546;7184.317489838457;7184.425245980205;4960.553550180501;4985.92802547454;5084.9745751271;5098.2862399263395;5169.457206993212;5049.2930989660745;5073.16292811682;5098.592112630907;5153.974230128825;5192.766325515286 03:26:26 INFO - PROCESS | 1662 | |4;prototype.html;299.9055297581263;300.6227184882972;308.41709169669326;312.12760334864055;314.1392584318965;5410.756515956781;5549.972250138754;5567.693776842272;5663.43365663434;5738.671570489122;4309.00524135725;5234.618248696844;5410.215518749788;5502.669839809614;5540.670239142607;3675.026118078711;4240.533541310446;4241.766702831343;4253.1493701259715;4277.422547956033;3943.5267767867754;4177.644900183488;4233.534311225762;4258.254805409057;4264.21112094262;3516.525269088666;3931.842726290959;4068.7386910057976;4136.937945930814;4142.9378559321485;3547.5742910850736;4021.698372622036;4121.423000779893;4172.561881002496;4182.762222211133;3605.56733192016;3613.8554457821656;3615.566132064143;3621.764585301947;3633.7274704397278;5220.425753167148;5274.709890955995;5339.385970613391;5383.650062745909;5390.1914712793005;4765.856194513327;4767.856964291077;4772.260299653559;4785.832495862663;4794.640401969831;4591.966807468293;4834.927476087862;5795.855103622401;5854.443827836349;5899.233099697012;3293.390722716305;3655.798931058791;3896.597224998998;3906.746061505993;3920.7843568603716;5160.380754309469;5813.82558523245;6199.597026193283;6273.749050037993;6286.779962701284;3525.2420729543273;3630.09247688078;3931.8427262909736;3981.8452648732123;4028.569857700533;3588.7308451865692;3864.942025869614;3987.501562304712;4048.3117869962175;4079.939215803853;4390.780460977002;4692.0146769178855;4779.402574678165;4826.32431459596;4847.279215878312;5265.578293860636;5925.259342582177;5926.348101708809;5965.791197308074;5973.970130149321;1255.9874401256054;1275.5089290623177;1356.647271709343;1376.9535153283377;1385.1550554161954;721.9241979592172;786.2334224131426;802.9237222463856;817.2726273616486;836.5775283481803;4302.9887976325535;4327.6970612057485;4618.122556714214;4650.651201159926;4684.079527393752;4709.599684026827;4732.491779356947;5046.646734728533;5073.898522029613;5089.643724939218;4142.233686767958;4446.799894004777;4517.751523666164;4608.193566125915;4644.491974333822;2145.881976491277;2252.054137262354;2659.8138130331076;2667.519846427662;2691.6097165910833;4502.099580083996;4589.862304130881;5180.6891586504935;5201.033013472125;5235.424103348629;4386.71486353386;4564.124601501033;4720.88197795051;5080.872978175501;5100.285959965608;4048.1903619276263;4442.600165985077;4657.254839225708;4817.566419022375;5151.356080489939;4535.97732011351;4905.975470122627;5053.0798296647035;5068.594512438923;5102.020424069232;4395.110102655889;4979.676321039121;4981.381051158315;5000.824971125993;5036.370453693288;4534.365188873627;4917.459079501324;5116.897662046813;5234.790608375774;5382.219578161066;2812.7749780017957;2829.5755636654667;3124.8438577381535;3200.535922291301;3275.6724327568004;4332.588404101605;4353.564643535621;4960.379952505937;4972.2790195422185;5002.973795612783;4522.63818894481;5269.101993903414;5308.044551980526;5328.7602057906715;5359;5835.212246346859;5848.625572990259;5849.853753656193;5854.619449735754;5859.154366374579;5320.201969704575;5376.9941393661975;5472.452754724496;5750.91684903723;5774.220480235283;4928.866360737123;5815.127730840408;5840;5840.707964601668;5942.762289508544;4558.88602784933;4797.9040419192115;5347.812826551052;5505.421930697219;5520.696361700145 03:26:26 INFO - PROCESS | 1662 | |5;yui.html;640.3404493371827;706.7667669669006;762.2453770766939;778.1673609238111;798.0184373220939;15361.769573456393;15749.527514174564;15766.132862692548;15790.131542765157;15862.762058569131;15312.923435382807;15710.135942523186;15868.761968570481;16363.672726545492;16413.83586164138;836.6904245429184;857.1813917708573;857.7341024282462;859.2438653984485;860.1527495417009;668.1547841979899;688.1570076656106;818.6479813680115;842.1620487614832;849.7026040885702;899.7840518275599;900.9909900901006;902.7878448564582;902.8826252587187;904.8371293167228;894.932880034;896.3949334199422;896.6996056321141;898.1736802142012;899.0694631056857;648.060312546809;668.2949488289852;668.4017804065335;669.1334721535623;670.9094272273229;15129.546113616609;15256.923715381463;15503.224838758017;15529.689406211926;15559.144247066406;14307.856921430757;14328.49850255236;14371.856281437156;14424.711505769827;14474.71050578993;11650;11882;12010.459529321202;12055.819162712478;12479.875201247962;3681.1349332906743;3710.091027698204;3730.608286129944;3800.2209547043067;3835.5013848199833;87289.69065464023;87953.56023219907;96612;114568.42715786451;127708.08437873346;10650.360978341325;10869.076128529005;10871.83692244617;10902.236843420884;10912.454377281105;21895.890520547295;22178.33464996053;22274.777252227595;22313;22378;6877.552959057645;7669.540344046747;7863.764087077397;7946.682132714743;8032.0763112241675;4427.645788336926;4459.9331010034875;4560.703554268962;4564.817407303671;4587.105514424722;3632.364336241147;3752.587215406303;3753.4557489163917;3762.3227818992295;3765.1151979284846;645.8675971425846;668.0747165176266;676.6481429656551;689.3898899474002;694.5173104692191;610.7740136149653;661.1372159332118;662.159057996342;672.9528932974645;688.4182865478663;9192.586333615003;9849.704508864745;9898.901010989943;9905.2571057171;9962.252831037702;583.7168973048068;625.252822876658;631.4790298004165;671.32196481553;696.4915611603558;4618.699784513996;4673.5860708807195;4743.335932969387;4804.591609713144;4873.1959226727195;122735;143545;168834;173422;184081;138262;140464.29767851095;144198;145193.27403362916;151644.2417787904;76679;96042;108888;123298.38350808188;131010;7975.481593696391;9302.069793020644;9962.950185249318;10033.297669163088;10217.1826253901;54167.72916135394;54547;58250.708746455995;63322.68338658277;65406;91107;91992.62011069973;93772.53113734387;95047.04952950381;96262.03737962531;12959.157654752411;12981.221126732426;12995.675108121994;13016.674583135497;13064.538681261489;14286.42854285817;14346.354414051602;15110.471133510275;15171.848281517043;15658.45195418155;13077.476900923857;13143.93428032892;13806.03357764987;14649.414023439369;14823;13044.128050056126;13995.300234988006;14040.859591403956;14058.437662493387;14188.432462701376;12611.87388126107;12911.612651620466;13151.34243287851;13529.120607160503;13974.441022358991;10977.615783447542;11018;11388.145889058189;11422.828657569977;11543;10369.325993810378;11445.484953177294;11741.29552226869;11763.176577639826;11803.822942655695 03:26:26 INFO - PROCESS | 1662 | __end_tp_report 03:26:26 INFO - PROCESS | 1662 | __start_cc_report 03:26:26 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,379 03:26:26 INFO - PROCESS | 1662 | __end_cc_report 03:26:26 INFO - PROCESS | 1662 | __startTimestamp1477995986253__endTimestamp 03:26:26 INFO - PROCESS | 1662 | 03:26:26 INFO - PROCESS | 1662 | ------- Summary: start ------- 03:26:26 INFO - PROCESS | 1662 | Number of tests: 6 03:26:26 INFO - PROCESS | 1662 | 03:26:26 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5918.92 Median:6136.33 stddev:648.86 (10.6%) stddev-sans-first:618.75 03:26:26 INFO - PROCESS | 1662 | Values: 3349.4 3462.5 3470.4 3472.6 3512.3 5957.0 6007.8 6032.7 6032.8 6050.4 5964.6 5991.0 5997.0 6057.8 6076.2 5326.4 5423.0 5424.0 5486.0 5587.5 5409.4 5502.2 5502.8 5507.1 5511.5 5385.1 5410.6 5487.8 5494.3 5502.5 5467.0 5506.0 5544.6 5569.0 5601.0 5370.1 5490.0 5492.9 5501.6 5526.7 5753.5 6003.5 6043.2 6116.0 6121.7 6150.4 6209.4 6245.7 6252.0 6357.9 6443.9 6444.9 6447.5 6479.2 6487.3 4962.7 6123.0 6123.5 6127.3 6133.5 6321.0 6395.1 6433.4 6524.8 6535.1 6210.6 6264.2 6266.2 6268.9 6271.3 6415.6 6417.0 6417.2 6457.3 6458.0 6128.9 6169.0 6170.2 6205.7 6299.3 6293.5 6295.3 6295.9 6313.2 6319.3 5050.7 5093.2 5100.6 5103.9 5144.4 4417.8 4485.6 4535.6 4538.7 4539.9 5277.0 6059.9 6125.2 6136.4 6137.0 6410.8 6446.6 6454.3 6454.6 6464.5 5925.4 5976.0 6002.7 6005.9 6039.6 5289.2 5590.0 5597.3 5630.2 5647.6 6585.5 6594.2 6597.4 6604.1 6622.6 6171.6 6251.7 6346.5 6366.8 6378.9 6630.5 6633.9 6634.8 6647.6 6649.1 5191.9 6328.8 6342.2 6358.5 6378.2 6174.5 6251.8 6392.8 6420.5 6448.6 6051.8 6115.5 6180.1 6200.8 6215.5 6209.8 6221.0 6223.1 6241.3 6245.8 5332.8 5995.7 6037.5 6163.5 6241.5 6118.6 6140.4 6194.7 6206.9 6223.6 6109.5 6136.3 6139.0 6148.1 6209.3 03:26:26 INFO - PROCESS | 1662 | 03:26:26 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:63996.94 Median:35568.82 stddev:136958.43 (385.1%) stddev-sans-first:137259.49 03:26:26 INFO - PROCESS | 1662 | Values: 433.2 456.5 528.9 530.0 547.1 40405.8 42090.8 42091.2 42151.8 42285.8 33876.2 35527.8 35851.1 43607.3 44040.7 9966.2 10146.9 10147.2 10162.7 10166.9 9982.5 10052.4 10054.2 10083.2 10112.6 8672.8 10061.1 10083.9 10110.3 10119.3 9714.1 9947.3 9950.2 10027.1 10079.9 8678.7 9845.9 9992.0 9995.9 10005.1 41107.2 41113.2 41258.8 41408.0 41443.8 3337.2 3537.6 3537.8 3825.9 3968.5 30193.5 30218.5 31828.2 32363.2 32405.2 3101.2 3290.0 3301.0 3367.8 3400.9 389563.0 432289.0 433447.8 477407.0 483171.0 32944.7 60258.4 60738.0 61000.7 61027.7 33999.0 34242.1 34350.0 34385.0 34450.3 15387.1 15417.2 15448.5 15475.5 15475.7 13054.3 13068.2 13146.0 13179.9 13204.2 7814.0 7826.6 7829.9 7872.9 7905.6 3240.8 3267.1 3275.7 3302.8 3306.6 937.1 958.7 959.8 993.0 1050.1 30449.5 30846.2 30935.4 31357.7 31441.0 1043.0 1076.0 1077.4 1089.1 1143.7 13129.7 15944.5 16024.7 16106.8 16281.0 594689.0 601505.0 602336.0 603010.0 603040.0 58617.7 59323.0 59407.0 59506.4 59537.0 1337.5 1374.7 1385.8 1398.2 1399.8 29844.0 30645.0 30696.5 30783.7 31234.2 48557.8 51280.5 51414.7 51698.7 51906.0 406525.0 455809.0 484516.6 512421.0 535310.0 22526.7 26358.3 26495.9 26593.2 26782.7 45728.0 46532.3 47714.0 47959.6 48083.8 34202.1 34605.0 38193.4 38608.0 40869.0 39410.8 39521.0 39614.0 40521.6 40781.8 38078.8 38423.4 39005.2 39103.6 40554.6 31828.7 35508.9 35609.8 35875.3 36087.1 26240.5 26373.3 26434.9 26486.2 27020.7 03:26:26 INFO - PROCESS | 1662 | 03:26:26 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:35834.89 Median:14668.57 stddev:102207.58 (696.8%) stddev-sans-first:102459.60 03:26:26 INFO - PROCESS | 1662 | Values: 365.7 374.9 375.0 375.2 397.7 19442.8 20654.5 20959.9 21053.6 21220.7 20216.3 20384.2 20406.1 20497.9 20649.9 5605.0 5873.5 5876.1 5925.4 6116.7 3901.8 4126.5 5104.4 6219.5 6299.3 5931.3 6185.8 6220.6 6254.4 6275.7 6020.0 6163.5 6232.6 6237.3 6254.9 6034.2 6070.7 6077.7 6086.5 6107.0 23633.4 24129.5 25353.5 26080.1 26269.6 2224.4 2238.2 2311.3 3067.5 3087.7 9571.0 9700.7 10375.2 10391.4 10425.8 1704.7 1819.9 1841.2 1861.0 1884.4 128659.4 131871.0 133663.0 134755.0 139904.3 11511.7 11529.2 11751.9 11833.5 11858.5 14655.0 14827.8 14835.9 14841.2 14869.5 7170.4 8583.5 8627.2 8760.6 8857.1 7056.2 8665.3 8791.7 8891.9 8915.7 4516.5 4517.3 4567.3 4580.1 4624.2 1589.8 1681.4 1879.8 1948.9 1960.8 841.6 924.9 935.1 980.6 1021.6 20942.0 21019.7 21050.3 21081.0 21121.9 843.0 917.8 940.9 1007.4 1040.1 10828.0 11191.9 11204.4 11230.5 11264.3 598553.0 606375.0 606772.0 618136.0 621122.0 126786.0 127318.0 128697.4 134092.0 135483.0 969.0 971.1 974.0 981.1 981.6 14138.0 14426.8 18623.4 18858.0 18956.1 52895.7 53222.5 53460.5 54023.0 54844.9 74152.6 77010.6 79292.0 79355.2 79529.8 5833.3 6220.5 7228.4 7457.3 7779.9 9319.3 12140.0 12779.4 12820.5 13215.5 8702.0 10865.4 10993.0 11191.7 11209.9 10705.4 10909.6 11477.7 11690.2 11907.8 11111.3 11373.9 11422.5 11466.4 11674.6 8280.3 8327.5 8433.7 8451.6 8556.2 9458.7 11028.9 11407.6 11632.2 11723.2 03:26:26 INFO - PROCESS | 1662 | 03:26:26 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5737.16 Median:4846.60 stddev:3235.33 (66.8%) stddev-sans-first:3228.63 03:26:26 INFO - PROCESS | 1662 | Values: 1485.3 1529.6 1710.3 1791.6 1803.4 8022.5 8295.4 8483.9 9077.7 9089.2 8197.6 8358.0 8496.1 8811.1 8826.0 2390.4 2414.7 2417.4 2419.7 2424.9 2386.8 2410.6 2417.9 2428.6 2438.2 2403.4 2414.5 2420.8 2425.4 2428.7 1985.2 2385.5 2390.4 2406.4 2414.5 2381.2 2388.0 2401.5 2402.8 2406.0 8960.9 9006.2 9032.5 9043.0 9043.5 4824.4 4843.9 5265.7 5311.5 5403.0 3546.9 3713.0 3735.7 3765.8 3797.1 1076.5 1100.5 1108.1 1124.4 1133.0 11672.3 11798.5 11865.5 11875.4 11880.0 3997.0 4612.3 4830.8 4849.3 4877.1 8973.8 9289.2 9623.9 9953.2 9991.6 5333.0 5401.2 5424.5 5429.3 5438.6 4033.5 4354.4 4532.7 4909.0 4960.8 4002.7 4029.2 4093.3 4127.6 4159.6 1190.1 1203.8 1252.3 1305.2 1306.4 786.8 830.3 855.7 887.5 963.5 5551.2 5970.5 5992.1 6042.4 6234.6 437.2 437.5 448.0 457.1 462.2 3508.4 3558.0 4117.3 4164.9 4235.0 10146.2 10796.4 10835.7 10885.1 10902.5 10463.3 10705.5 10853.5 10926.7 10940.8 8192.3 8332.8 8354.7 8369.0 8376.5 5932.9 5979.8 6005.8 6049.0 6086.5 9698.5 9915.7 10019.6 10083.7 10141.1 10322.4 10358.3 10413.1 10426.1 10441.8 6854.7 7079.3 7309.2 7557.0 7640.4 8278.3 8606.3 8616.8 8633.7 8651.5 7490.9 7602.7 7652.9 7684.3 7758.8 7413.5 7414.1 7429.3 7552.7 7583.2 6367.7 7011.9 7175.2 7184.3 7184.4 4960.6 4985.9 5085.0 5098.3 5169.5 5049.3 5073.2 5098.6 5154.0 5192.8 03:26:26 INFO - PROCESS | 1662 | 03:26:26 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4368.58 Median:4749.17 stddev:1353.41 (28.5%) stddev-sans-first:1322.30 03:26:26 INFO - PROCESS | 1662 | Values: 299.9 300.6 308.4 312.1 314.1 5410.8 5550.0 5567.7 5663.4 5738.7 4309.0 5234.6 5410.2 5502.7 5540.7 3675.0 4240.5 4241.8 4253.1 4277.4 3943.5 4177.6 4233.5 4258.3 4264.2 3516.5 3931.8 4068.7 4136.9 4142.9 3547.6 4021.7 4121.4 4172.6 4182.8 3605.6 3613.9 3615.6 3621.8 3633.7 5220.4 5274.7 5339.4 5383.7 5390.2 4765.9 4767.9 4772.3 4785.8 4794.6 4592.0 4834.9 5795.9 5854.4 5899.2 3293.4 3655.8 3896.6 3906.7 3920.8 5160.4 5813.8 6199.6 6273.7 6286.8 3525.2 3630.1 3931.8 3981.8 4028.6 3588.7 3864.9 3987.5 4048.3 4079.9 4390.8 4692.0 4779.4 4826.3 4847.3 5265.6 5925.3 5926.3 5965.8 5974.0 1256.0 1275.5 1356.6 1377.0 1385.2 721.9 786.2 802.9 817.3 836.6 4303.0 4327.7 4618.1 4650.7 4684.1 4709.6 4732.5 5046.6 5073.9 5089.6 4142.2 4446.8 4517.8 4608.2 4644.5 2145.9 2252.1 2659.8 2667.5 2691.6 4502.1 4589.9 5180.7 5201.0 5235.4 4386.7 4564.1 4720.9 5080.9 5100.3 4048.2 4442.6 4657.3 4817.6 5151.4 4536.0 4906.0 5053.1 5068.6 5102.0 4395.1 4979.7 4981.4 5000.8 5036.4 4534.4 4917.5 5116.9 5234.8 5382.2 2812.8 2829.6 3124.8 3200.5 3275.7 4332.6 4353.6 4960.4 4972.3 5003.0 4522.6 5269.1 5308.0 5328.8 5359.0 5835.2 5848.6 5849.9 5854.6 5859.2 5320.2 5377.0 5472.5 5750.9 5774.2 4928.9 5815.1 5840.0 5840.7 5942.8 4558.9 4797.9 5347.8 5505.4 5520.7 03:26:26 INFO - PROCESS | 1662 | 03:26:26 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:25384.62 Median:3741.60 stddev:41408.52 (1106.7%) stddev-sans-first:41483.01 03:26:26 INFO - PROCESS | 1662 | Values: 640.3 706.8 762.2 778.2 798.0 15361.8 15749.5 15766.1 15790.1 15862.8 15312.9 15710.1 15868.8 16363.7 16413.8 836.7 857.2 857.7 859.2 860.2 668.2 688.2 818.6 842.2 849.7 899.8 901.0 902.8 902.9 904.8 894.9 896.4 896.7 898.2 899.1 648.1 668.3 668.4 669.1 670.9 15129.5 15256.9 15503.2 15529.7 15559.1 14307.9 14328.5 14371.9 14424.7 14474.7 11650.0 11882.0 12010.5 12055.8 12479.9 3681.1 3710.1 3730.6 3800.2 3835.5 87289.7 87953.6 96612.0 114568.4 127708.1 10650.4 10869.1 10871.8 10902.2 10912.5 21895.9 22178.3 22274.8 22313.0 22378.0 6877.6 7669.5 7863.8 7946.7 8032.1 4427.6 4459.9 4560.7 4564.8 4587.1 3632.4 3752.6 3753.5 3762.3 3765.1 645.9 668.1 676.6 689.4 694.5 610.8 661.1 662.2 673.0 688.4 9192.6 9849.7 9898.9 9905.3 9962.3 583.7 625.3 631.5 671.3 696.5 4618.7 4673.6 4743.3 4804.6 4873.2 122735.0 143545.0 168834.0 173422.0 184081.0 138262.0 140464.3 144198.0 145193.3 151644.2 76679.0 96042.0 108888.0 123298.4 131010.0 7975.5 9302.1 9963.0 10033.3 10217.2 54167.7 54547.0 58250.7 63322.7 65406.0 91107.0 91992.6 93772.5 95047.0 96262.0 12959.2 12981.2 12995.7 13016.7 13064.5 14286.4 14346.4 15110.5 15171.8 15658.5 13077.5 13143.9 13806.0 14649.4 14823.0 13044.1 13995.3 14040.9 14058.4 14188.4 12611.9 12911.6 13151.3 13529.1 13974.4 10977.6 11018.0 11388.1 11422.8 11543.0 10369.3 11445.5 11741.3 11763.2 11803.8 03:26:26 INFO - PROCESS | 1662 | -------- Summary: end -------- 03:26:26 INFO - PROCESS | 1662 | 03:26:26 INFO - TEST-INFO | 1662: exit 0 03:26:26 INFO - TEST-OK | dromaeo_css | took 1114423ms 03:26:26 INFO - TEST-START | kraken 03:26:26 INFO - operating with platform_type : mac_ 03:26:26 INFO - Initialising browser for kraken test... 03:26:26 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmpjkEaML/profile http://localhost:49281/getInfo.html) 03:26:29 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 03:26:29 INFO - PROCESS | 1671 | colorDepth:24 03:26:29 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 03:26:29 INFO - PROCESS | 1671 | __metrics 03:26:29 ERROR - PROCESS | 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 03:26:30 INFO - TEST-INFO | 1671: exit 0 03:26:30 INFO - Browser initialized. 03:26:30 INFO - Running cycle 1/1 for kraken test... 03:26:30 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmpjkEaML/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:42 INFO - PROCESS | 1674 | RSS: Main: 225398784 03:26:42 INFO - PROCESS | 1674 | 03:26:45 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection) 03:26:46 INFO - PROCESS | 1674 | RSS: Main: 237977600 03:26:46 INFO - PROCESS | 1674 | 03:26:48 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-dft) 03:26:49 INFO - PROCESS | 1674 | RSS: Main: 245444608 03:26:49 INFO - PROCESS | 1674 | 03:26:52 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-fft) 03:26:53 INFO - PROCESS | 1674 | RSS: Main: 249479168 03:26:53 INFO - PROCESS | 1674 | 03:26:55 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator) 03:26:56 INFO - PROCESS | 1674 | RSS: Main: 250220544 03:26:56 INFO - PROCESS | 1674 | 03:26:58 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:26:58 INFO - PROCESS | 1674 | RSS: Main: 250200064 03:26:58 INFO - PROCESS | 1674 | 03:27:01 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom) 03:27:02 INFO - PROCESS | 1674 | RSS: Main: 250875904 03:27:02 INFO - PROCESS | 1674 | 03:27:05 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate) 03:27:05 INFO - PROCESS | 1674 | RSS: Main: 251674624 03:27:05 INFO - PROCESS | 1674 | 03:27:08 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial) 03:27:09 INFO - PROCESS | 1674 | RSS: Main: 252170240 03:27:09 INFO - PROCESS | 1674 | 03:27:11 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:27:11 INFO - PROCESS | 1674 | RSS: Main: 251310080 03:27:11 INFO - PROCESS | 1674 | 03:27:13 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:27:14 INFO - PROCESS | 1674 | RSS: Main: 251387904 03:27:14 INFO - PROCESS | 1674 | 03:27:16 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:27:17 INFO - PROCESS | 1674 | RSS: Main: 251437056 03:27:17 INFO - PROCESS | 1674 | 03:27:20 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:27:21 INFO - PROCESS | 1674 | RSS: Main: 251805696 03:27:21 INFO - PROCESS | 1674 | 03:27:23 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:27:24 INFO - PROCESS | 1674 | RSS: Main: 251736064 03:27:24 INFO - PROCESS | 1674 | 03:27:26 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49281/tests/kraken/driver.html?testName=ai-astar) 03:27:26 INFO - PROCESS | 1674 | RSS: Main: 253562880 03:27:26 INFO - PROCESS | 1674 | 03:27:26 INFO - PROCESS | 1674 | __start_tp_report 03:27:26 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 03:27:26 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 03:27:26 INFO - PROCESS | 1674 | |i|pagename|runs| 03:27:26 INFO - PROCESS | 1674 | |0;ai-astar;105;118;115;119;118;118;119;118;108;168 03:27:26 INFO - PROCESS | 1674 | |1;audio-beat-detection;145;114;109;142;117;139;110;119;171;137 03:27:26 INFO - PROCESS | 1674 | |2;audio-dft;209;200;198;201;199;275;249;195;199;198 03:27:26 INFO - PROCESS | 1674 | |3;audio-fft;79;58;60;89;60;64;67;86;106;80 03:27:26 INFO - PROCESS | 1674 | |4;audio-oscillator;83;71;88;74;68;69;89;70;72;86 03:27:26 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;119;131;134;133;132;89;93;91;93;89 03:27:26 INFO - PROCESS | 1674 | |6;imaging-darkroom;102;103;103;130;130;102;103;110;104;105 03:27:26 INFO - PROCESS | 1674 | |7;imaging-desaturate;78;152;145;92;87;94;91;91;91;91 03:27:26 INFO - PROCESS | 1674 | |8;json-parse-financial;56;57;58;57;60;60;60;60;61;60 03:27:26 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;68;91;108;116;85;72;70;72;72;70 03:27:26 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;80;84;86;73;75;99;104;101;104;77 03:27:26 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;164;165;149;155;142;159;152;158;201;149 03:27:26 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;167;166;163;166;163;169;167;167;171;166 03:27:26 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;69;81;94;98;69;67;66;70;68;66 03:27:26 INFO - PROCESS | 1674 | __end_tp_report 03:27:26 INFO - PROCESS | 1674 | __start_cc_report 03:27:26 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,974 03:27:26 INFO - PROCESS | 1674 | __end_cc_report 03:27:26 INFO - PROCESS | 1674 | __startTimestamp1477996046530__endTimestamp 03:27:26 INFO - PROCESS | 1674 | 03:27:26 INFO - PROCESS | 1674 | ------- Summary: start ------- 03:27:26 INFO - PROCESS | 1674 | Number of tests: 14 03:27:26 INFO - PROCESS | 1674 | 03:27:26 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:120.60 Median:118.00 stddev:17.36 (14.7%) stddev-sans-first:17.47 03:27:26 INFO - PROCESS | 1674 | Values: 105.0 118.0 115.0 119.0 118.0 118.0 119.0 118.0 108.0 168.0 03:27:26 INFO - PROCESS | 1674 | 03:27:26 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:130.30 Median:138.00 stddev:19.91 (14.4%) stddev-sans-first:20.39 03:27:26 INFO - PROCESS | 1674 | Values: 145.0 114.0 109.0 142.0 117.0 139.0 110.0 119.0 171.0 137.0 03:27:26 INFO - PROCESS | 1674 | 03:27:26 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:212.30 Median:200.50 stddev:27.14 (13.5%) stddev-sans-first:28.76 03:27:26 INFO - PROCESS | 1674 | Values: 209.0 200.0 198.0 201.0 199.0 275.0 249.0 195.0 199.0 198.0 03:27:26 INFO - PROCESS | 1674 | 03:27:26 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:74.90 Median:73.00 stddev:15.79 (21.6%) stddev-sans-first:16.67 03:27:26 INFO - PROCESS | 1674 | Values: 79.0 58.0 60.0 89.0 60.0 64.0 67.0 86.0 106.0 80.0 03:27:26 INFO - PROCESS | 1674 | 03:27:26 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:78.50 stddev:8.47 (10.8%) stddev-sans-first:8.70 03:27:26 INFO - PROCESS | 1674 | Values: 83.0 71.0 88.0 74.0 68.0 69.0 89.0 70.0 72.0 86.0 03:27:26 INFO - PROCESS | 1674 | 03:27:26 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:89.00 stddev:20.90 (23.5%) stddev-sans-first:21.93 03:27:26 INFO - PROCESS | 1674 | Values: 119.0 131.0 134.0 133.0 132.0 89.0 93.0 91.0 93.0 89.0 03:27:26 INFO - PROCESS | 1674 | 03:27:26 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:109.20 Median:104.50 stddev:11.20 (10.7%) stddev-sans-first:11.58 03:27:26 INFO - PROCESS | 1674 | Values: 102.0 103.0 103.0 130.0 130.0 102.0 103.0 110.0 104.0 105.0 03:27:26 INFO - PROCESS | 1674 | 03:27:26 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:101.20 Median:91.00 stddev:25.37 (27.9%) stddev-sans-first:25.48 03:27:26 INFO - PROCESS | 1674 | Values: 78.0 152.0 145.0 92.0 87.0 94.0 91.0 91.0 91.0 91.0 03:27:26 INFO - PROCESS | 1674 | 03:27:26 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:60.00 stddev:1.73 (2.9%) stddev-sans-first:1.48 03:27:26 INFO - PROCESS | 1674 | Values: 56.0 57.0 58.0 57.0 60.0 60.0 60.0 60.0 61.0 60.0 03:27:26 INFO - PROCESS | 1674 | 03:27:26 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:82.40 Median:72.00 stddev:17.33 (24.1%) stddev-sans-first:17.59 03:27:26 INFO - PROCESS | 1674 | Values: 68.0 91.0 108.0 116.0 85.0 72.0 70.0 72.0 72.0 70.0 03:27:26 INFO - PROCESS | 1674 | 03:27:26 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:78.50 stddev:12.47 (15.9%) stddev-sans-first:12.86 03:27:26 INFO - PROCESS | 1674 | Values: 80.0 84.0 86.0 73.0 75.0 99.0 104.0 101.0 104.0 77.0 03:27:26 INFO - PROCESS | 1674 | 03:27:26 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:159.40 Median:158.50 stddev:16.26 (10.3%) stddev-sans-first:17.16 03:27:26 INFO - PROCESS | 1674 | Values: 164.0 165.0 149.0 155.0 142.0 159.0 152.0 158.0 201.0 149.0 03:27:26 INFO - PROCESS | 1674 | 03:27:26 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:167.00 stddev:2.42 (1.4%) stddev-sans-first:2.55 03:27:26 INFO - PROCESS | 1674 | Values: 167.0 166.0 163.0 166.0 163.0 169.0 167.0 167.0 171.0 166.0 03:27:26 INFO - PROCESS | 1674 | 03:27:26 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.80 Median:69.50 stddev:12.01 (17.3%) stddev-sans-first:12.55 03:27:26 INFO - PROCESS | 1674 | Values: 69.0 81.0 94.0 98.0 69.0 67.0 66.0 70.0 68.0 66.0 03:27:26 INFO - PROCESS | 1674 | -------- Summary: end -------- 03:27:26 INFO - PROCESS | 1674 | 03:27:27 INFO - TEST-INFO | 1674: exit 0 03:27:27 INFO - TEST-OK | kraken | took 60677ms 03:27:27 INFO - SUITE-END | took 1175s 03:27:27 INFO - Completed test suite (00:19:35) 03:27:27 INFO - javascript benchmark 03:27:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7283.932629362397, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3349.380364632543, 3462.463318185682, 3470.3753324401596, 3472.635373285805, 3512.279982603565, 5956.957532431823, 6007.849803754908, 6032.69836508175, 6032.8190154295335, 6050.42520960508, 5964.612300200484, 5991.011483105282, 5997.040473524237, 6057.818265452032, 6076.210092687945, 5326.440723724011, 5422.996745602057, 5424.0, 5486.0, 5587.525060369873, 5409.43200963899, 5502.174673798922, 5502.752376143063, 5507.118860982244, 5511.53151982082, 5385.111456609655, 5410.648307859996, 5487.807926722566, 5494.2857428534235, 5502.504774570288, 5467.015937131335, 5505.9724701376435, 5544.63959842609, 5568.972155139239, 5601.019821531216, 5370.140777475585, 5489.972550137264, 5492.890142197134, 5501.559875209973, 5526.696031718254, 5753.453421924911, 6003.519718422515, 6043.214382130339, 6116.0, 6121.724522396503, 6150.354212807681, 6209.441150296495, 6245.718942647592, 6251.968740156316, 6357.93642063578, 6443.9355606443805, 6444.903326450107, 6447.484201263887, 6479.222493300834, 6487.253965793947, 4962.727050012284, 6123.0, 6123.540734444934, 6127.264728232641, 6133.509319254449, 6321.0, 6395.072714456378, 6433.356664333529, 6524.836879077966, 6535.0850880876715, 6210.596311239755, 6264.21697287839, 6266.216722909637, 6268.905966410507, 6271.341509141565, 6415.582987105823, 6417.0, 6417.2299324081405, 6457.2896981332015, 6457.967710161419, 6128.900367973304, 6168.9691551542855, 6170.167027451326, 6205.720742566505, 6299.307076221612, 6293.527985401113, 6295.307516173218, 6295.905561416583, 6313.179286692701, 6319.304876463585, 5050.747462626854, 5093.2105523643895, 5100.591952643779, 5103.948960510422, 5144.356955380577, 4417.779111044435, 4485.618722408566, 4535.569120933506, 4538.682292239511, 4539.933115717804, 5276.997370499593, 6059.909101363483, 6125.173101631222, 6136.386361363828, 6137.009281402767, 6410.839729006812, 6446.645434501053, 6454.290028096905, 6454.580452270588, 6464.515161362822, 5925.4370834770625, 5976.0, 6002.6698531580305, 6005.939940600625, 6039.577229593886, 5289.233061206103, 5590.0, 5597.328320601554, 5630.23991761107, 5647.604667673223, 6585.539012269191, 6594.208694956636, 6597.406233439014, 6604.108445360007, 6622.569532980341, 6171.59884607499, 6251.6561589113035, 6346.460550853045, 6366.77716279928, 6378.936210637834, 6630.535862489773, 6633.933660663524, 6634.800955971328, 6647.60114393138, 6649.102371179829, 5191.870203244949, 6328.778492752732, 6342.207224096988, 6358.459530939922, 6378.170837791057, 6174.475169610633, 6251.843703907439, 6392.808215753535, 6420.518461115342, 6448.64532450701, 6051.848703782441, 6115.514161902999, 6180.103884936569, 6200.844978875564, 6215.471684906653, 6209.813705588839, 6221.0, 6223.128761973418, 6241.344658810941, 6245.750849830143, 5332.813351532678, 5995.6702381367695, 6037.486813620716, 6163.476104531165, 6241.500679945502, 6118.619179173164, 6140.412224875342, 6194.690265486798, 6206.906896396467, 6223.595466294676, 6109.511239100772, 6136.325004249618, 6139.048447490646, 6148.077788331607, 6209.316975132641], "value": 5878.400416535585, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.2029066517607, 456.5274940436649, 528.8942211557687, 529.9735013249336, 547.1109447148385, 40405.79797101014, 42090.78954605226, 42091.15817683652, 42151.789241053826, 42285.78857105714, 33876.15309617261, 35527.822360888225, 35851.10372240695, 43607.34588981168, 44040.67877963658, 9966.202703783698, 10146.949265253663, 10147.238957078212, 10162.745931351701, 10166.949165254164, 9982.50087495626, 10052.396856188616, 10054.195664346835, 10083.19334453242, 10112.59549618018, 8672.826543469128, 10061.14480269178, 10083.899161008369, 10110.342827716211, 10119.342242754234, 9714.077162669535, 9947.253955953332, 9950.203983681287, 10027.147692446115, 10079.94160613136, 8678.652853885837, 9845.90154098457, 9992.0, 9995.850062249072, 10005.149562287213, 41107.1778564427, 41113.1777364454, 41258.793706031276, 41408.0, 41443.7927810362, 3337.1823903143886, 3537.6108628050893, 3537.7700449470703, 3825.8660946866726, 3968.503937007874, 30193.547096793565, 30218.54672179919, 31828.20429489258, 32363.19092022695, 32405.189870253198, 3101.2246938265434, 3289.967100329014, 3300.950485742716, 3367.8316084195694, 3400.931981360384, 389563.0, 432289.0, 433447.8327608342, 477407.0, 483170.9999999965, 32944.67055329416, 60258.39741602528, 60738.0, 61000.69499652562, 61027.69486152541, 33999.0, 34242.14394640154, 34350.0, 34385.0, 34450.310993780484, 15387.076775393512, 15417.229138543027, 15448.459303924308, 15475.535733928, 15475.690486190213, 13054.282014489105, 13068.150570212905, 13146.0, 13179.879710224739, 13204.207747535178, 7813.960930195312, 7826.608669566499, 7829.882551761728, 7872.881906771403, 7905.56519391439, 3240.8055516669074, 3267.101547074526, 3275.737940964717, 3302.7688061835443, 3306.57014588102, 937.0910217089412, 958.6884262614678, 959.827231098409, 992.9702108936743, 1050.112654806687, 30449.543256851164, 30846.228844279074, 30935.381292374026, 31357.686423135932, 31441.0, 1042.9843552346722, 1076.0315715855793, 1077.4289626497969, 1089.145021158387, 1143.6626195272415, 13129.67175820593, 15944.521664350088, 16024.679506410039, 16106.75839862403, 16281.023138611721, 594689.0, 601505.0, 602336.0, 603010.0, 603040.0, 58617.706911466026, 59323.0, 59407.0, 59506.40493595095, 59537.0, 1337.458329376604, 1374.71131062476, 1385.7990591363994, 1398.1890503508143, 1399.818023656918, 29844.0, 30645.0, 30696.53955190629, 30783.69216307808, 31234.21914452157, 48557.75721121372, 51280.48719512757, 51414.74292628513, 51698.74150629223, 51906.0, 406525.0, 455809.0, 484516.5774171107, 512421.0, 535310.0, 22526.662100068184, 26358.341041474116, 26495.867520662272, 26593.202203933914, 26782.732172678025, 45728.0, 46532.30201546912, 47714.0, 47959.56121316366, 48083.797905052656, 34202.14494637654, 34605.0, 38193.42709859299, 38608.0, 40869.0, 39410.80294598509, 39521.0, 39614.0, 40521.594784051784, 40781.79609101936, 38078.80960595179, 38423.42364864473, 39005.21989560136, 39103.608963909996, 40554.59445405626, 31828.72685092663, 35508.934731958085, 35609.82195089111, 35875.28249435049, 36087.09782255465, 26240.507151820548, 26373.340666482723, 26434.86782566075, 26486.205413837615, 27020.72979270261], "value": 18733.993788791147, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.7366695978895, 374.87629082402793, 374.9906252343693, 375.2195433498323, 397.6659605931017, 19442.805571944275, 20654.48363790906, 20959.895200523995, 21053.578928421422, 21220.681689774665, 20216.292429764962, 20384.184632614713, 20406.081726322314, 20497.897510512463, 20649.896750516265, 5605.047141985852, 5873.530117590582, 5876.147958546008, 5925.437083477084, 6116.663583502906, 3901.804909754515, 4126.5254495732925, 5104.3619547556555, 6219.502439804804, 6299.307076221612, 5931.317898441691, 6185.783497577586, 6220.564560480768, 6254.43710066094, 6275.717592708316, 6020.0367941129425, 6163.476104531098, 6232.594881332721, 6237.313895471494, 6254.874902501924, 6034.1853849730605, 6070.6661133637635, 6077.665728384937, 6086.482648974842, 6107.0, 23633.409164770845, 24129.517409651886, 25353.492930141292, 26080.087196948014, 26269.605955910676, 2224.443889027743, 2238.171876405724, 2311.3412677386864, 3067.524533697258, 3087.7375423089065, 9570.952145239298, 9700.660476883275, 10375.221858360654, 10391.37651740898, 10425.843612345821, 1704.7272436410115, 1819.8635102367375, 1841.2174825699024, 1860.9906950465297, 1884.3969929622526, 128659.35670321682, 131871.0, 133663.0, 134755.0, 139904.30047849697, 11511.654650360502, 11529.192956492965, 11751.941240293743, 11833.467493962793, 11858.525658973544, 14655.0, 14827.77758333626, 14835.851641483663, 14841.183734894468, 14869.47956821506, 7170.354668079898, 8583.484990900566, 8627.22354988054, 8760.605772740242, 8857.11428857109, 7056.15326160864, 8665.306775457948, 8791.736247912573, 8891.932968043746, 8915.687950921687, 4516.548345165457, 4517.34498497716, 4567.337736028324, 4580.083983203373, 4624.190766615896, 1589.8489643483852, 1681.3946979087518, 1879.774427068733, 1948.9415317540497, 1960.7647082350209, 841.5876220651836, 924.8843894513186, 935.1163150822543, 980.6028558433845, 1021.6322124035341, 20942.0, 21019.68470472944, 21050.2632407865, 21081.0, 21121.894390528258, 842.9704960326482, 917.7613820406609, 940.9435433873853, 1007.4358359318805, 1040.095117247999, 10828.025477707044, 11191.888081119085, 11204.383758893338, 11230.494627741771, 11264.267822591506, 598553.0, 606375.0, 606772.0, 618136.0, 621122.0, 126786.0, 127318.0, 128697.35651321683, 134092.0, 135483.0, 968.951552422376, 971.062924278075, 974.0016483104732, 981.1218959031627, 981.6269817469316, 14138.0, 14426.783598246244, 18623.44129676112, 18858.0, 18956.052197390352, 52895.735521322145, 53222.467775321755, 53460.46539534555, 54023.0, 54844.90310193854, 74152.62923685563, 77010.6149469249, 79292.0, 79355.23497071191, 79529.8070528931, 5833.329167145833, 6220.502359811295, 7228.385587225145, 7457.291557302047, 7779.883301750591, 9319.347645664739, 12140.02879769634, 12779.36103194855, 12820.487180513048, 13215.471381145031, 8701.956490217508, 10865.402402867918, 10993.0, 11191.72020699489, 11209.943950280196, 10705.357678539312, 10909.618163364245, 11477.727433946739, 11690.240134391237, 11907.761844762883, 11111.333320000502, 11373.943130284295, 11422.543098275975, 11466.426678665866, 11674.649760507198, 8280.337572994267, 8327.50034997902, 8433.662653493791, 8451.619677114668, 8556.229939305493, 9458.734730360567, 11028.944855275673, 11407.600733974272, 11632.185746997968, 11723.237989530653], "value": 9592.26977386727, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1485.2944851195684, 1529.6023034011155, 1710.2816816936886, 1791.5700231944338, 1803.3958623861006, 8022.518648881057, 8295.377846661495, 8483.91516084839, 9077.72766816995, 9089.227415669668, 8197.631106600202, 8358.0, 8496.107908669594, 8811.118888111185, 8826.029136794947, 2390.3665528634883, 2414.7343792182846, 2417.371483414316, 2419.7096348438213, 2424.9393765155924, 2386.820988425875, 2410.602250628653, 2417.891194896225, 2428.5871401861637, 2438.1588352018525, 2403.4472071423584, 2414.517096580682, 2420.782129608335, 2425.369403954967, 2428.659987601737, 1985.1959956217754, 2385.5228954209056, 2390.4023994001586, 2406.42245860993, 2414.468816860288, 2381.1784934197676, 2388.0, 2401.5317013182434, 2402.759724027601, 2405.9759402406103, 8960.8655870162, 9006.234470070052, 9032.548372581345, 9042.954785226098, 9043.547822608909, 4824.421069471651, 4843.927341089887, 5265.6840589564745, 5311.521963023347, 5402.972985135049, 3546.85812567497, 3712.9628703713156, 3735.7198210134347, 3765.7740535567955, 3797.0886987123167, 1076.5478499030348, 1100.4772732951865, 1108.130117857486, 1124.415304041902, 1133.0369186191754, 11672.299662020307, 11798.469068891834, 11865.52537898483, 11875.406229688568, 11880.0, 3996.960030399659, 4612.331211974312, 4830.806767729251, 4849.2726091085915, 4877.097736918681, 8973.788538547344, 9289.21041711462, 9623.903760962441, 9953.153981911473, 9991.600335986624, 5333.0, 5401.2168235606405, 5424.538914192259, 5429.267048948421, 5438.592105592096, 4033.4554835097474, 4354.390385346054, 4532.682712210114, 4908.950910490921, 4960.801567937314, 4002.699797515198, 4029.15387768566, 4093.3246014407887, 4127.587241275908, 4159.625633692982, 1190.0657983482924, 1203.8022167942777, 1252.2861968677948, 1305.1777380250383, 1306.399056434051, 786.7757689058591, 830.3066939105794, 855.6534603485599, 887.5384799904014, 963.450833025183, 5551.195076713934, 5970.462658360769, 5992.101184822312, 6042.425969532887, 6234.5635805494085, 437.2370213976631, 437.457552634737, 447.961923236522, 457.1337315786566, 462.15425770839283, 3508.4035713928693, 3557.964420355763, 4117.258893399157, 4164.8542301019315, 4234.978825105916, 10146.188304935587, 10796.406197659047, 10835.67492975212, 10885.074768644596, 10902.5093870776, 10463.319884207502, 10705.518251678694, 10853.511591978222, 10926.726831829268, 10940.781184376427, 8192.34461243099, 8332.791680208044, 8354.66581336752, 8368.958155209306, 8376.455530390384, 5932.940670593239, 5979.820605381846, 6005.759769609167, 6049.0, 6086.513078953584, 9698.46658433793, 9915.702528924145, 10019.649312274036, 10083.697489075339, 10141.138003269805, 10322.380657160595, 10358.274920755775, 10413.062824345845, 10426.061654451136, 10441.791164176826, 6854.725810967506, 7079.327463890922, 7309.232530584212, 7557.0, 7640.388768898363, 8278.337732981467, 8606.311495080254, 8616.827663446571, 8633.654653813777, 8651.52416617067, 7490.925090749023, 7602.697731453079, 7652.923470765221, 7684.269994350528, 7758.806029849299, 7413.518121322097, 7414.073240844895, 7429.33136017761, 7552.697892084255, 7583.2416758323725, 6367.745290188341, 7011.878099504055, 7175.174854891546, 7184.317489838457, 7184.425245980205, 4960.553550180501, 4985.92802547454, 5084.9745751271, 5098.2862399263395, 5169.457206993212, 5049.2930989660745, 5073.16292811682, 5098.592112630907, 5153.974230128825, 5192.766325515286], "value": 4531.07066218699, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.9055297581263, 300.6227184882972, 308.41709169669326, 312.12760334864055, 314.1392584318965, 5410.756515956781, 5549.972250138754, 5567.693776842272, 5663.43365663434, 5738.671570489122, 4309.00524135725, 5234.618248696844, 5410.215518749788, 5502.669839809614, 5540.670239142607, 3675.026118078711, 4240.533541310446, 4241.766702831343, 4253.1493701259715, 4277.422547956033, 3943.5267767867754, 4177.644900183488, 4233.534311225762, 4258.254805409057, 4264.21112094262, 3516.525269088666, 3931.842726290959, 4068.7386910057976, 4136.937945930814, 4142.9378559321485, 3547.5742910850736, 4021.698372622036, 4121.423000779893, 4172.561881002496, 4182.762222211133, 3605.56733192016, 3613.8554457821656, 3615.566132064143, 3621.764585301947, 3633.7274704397278, 5220.425753167148, 5274.709890955995, 5339.385970613391, 5383.650062745909, 5390.1914712793005, 4765.856194513327, 4767.856964291077, 4772.260299653559, 4785.832495862663, 4794.640401969831, 4591.966807468293, 4834.927476087862, 5795.855103622401, 5854.443827836349, 5899.233099697012, 3293.390722716305, 3655.798931058791, 3896.597224998998, 3906.746061505993, 3920.7843568603716, 5160.380754309469, 5813.82558523245, 6199.597026193283, 6273.749050037993, 6286.779962701284, 3525.2420729543273, 3630.09247688078, 3931.8427262909736, 3981.8452648732123, 4028.569857700533, 3588.7308451865692, 3864.942025869614, 3987.501562304712, 4048.3117869962175, 4079.939215803853, 4390.780460977002, 4692.0146769178855, 4779.402574678165, 4826.32431459596, 4847.279215878312, 5265.578293860636, 5925.259342582177, 5926.348101708809, 5965.791197308074, 5973.970130149321, 1255.9874401256054, 1275.5089290623177, 1356.647271709343, 1376.9535153283377, 1385.1550554161954, 721.9241979592172, 786.2334224131426, 802.9237222463856, 817.2726273616486, 836.5775283481803, 4302.9887976325535, 4327.6970612057485, 4618.122556714214, 4650.651201159926, 4684.079527393752, 4709.599684026827, 4732.491779356947, 5046.646734728533, 5073.898522029613, 5089.643724939218, 4142.233686767958, 4446.799894004777, 4517.751523666164, 4608.193566125915, 4644.491974333822, 2145.881976491277, 2252.054137262354, 2659.8138130331076, 2667.519846427662, 2691.6097165910833, 4502.099580083996, 4589.862304130881, 5180.6891586504935, 5201.033013472125, 5235.424103348629, 4386.71486353386, 4564.124601501033, 4720.88197795051, 5080.872978175501, 5100.285959965608, 4048.1903619276263, 4442.600165985077, 4657.254839225708, 4817.566419022375, 5151.356080489939, 4535.97732011351, 4905.975470122627, 5053.0798296647035, 5068.594512438923, 5102.020424069232, 4395.110102655889, 4979.676321039121, 4981.381051158315, 5000.824971125993, 5036.370453693288, 4534.365188873627, 4917.459079501324, 5116.897662046813, 5234.790608375774, 5382.219578161066, 2812.7749780017957, 2829.5755636654667, 3124.8438577381535, 3200.535922291301, 3275.6724327568004, 4332.588404101605, 4353.564643535621, 4960.379952505937, 4972.2790195422185, 5002.973795612783, 4522.63818894481, 5269.101993903414, 5308.044551980526, 5328.7602057906715, 5359.0, 5835.212246346859, 5848.625572990259, 5849.853753656193, 5854.619449735754, 5859.154366374579, 5320.201969704575, 5376.9941393661975, 5472.452754724496, 5750.91684903723, 5774.220480235283, 4928.866360737123, 5815.127730840408, 5840.0, 5840.707964601668, 5942.762289508544, 4558.88602784933, 4797.9040419192115, 5347.812826551052, 5505.421930697219, 5520.696361700145], "value": 3937.509556377328, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.3404493371827, 706.7667669669006, 762.2453770766939, 778.1673609238111, 798.0184373220939, 15361.769573456393, 15749.527514174564, 15766.132862692548, 15790.131542765157, 15862.762058569131, 15312.923435382807, 15710.135942523186, 15868.761968570481, 16363.672726545492, 16413.83586164138, 836.6904245429184, 857.1813917708573, 857.7341024282462, 859.2438653984485, 860.1527495417009, 668.1547841979899, 688.1570076656106, 818.6479813680115, 842.1620487614832, 849.7026040885702, 899.7840518275599, 900.9909900901006, 902.7878448564582, 902.8826252587187, 904.8371293167228, 894.932880034, 896.3949334199422, 896.6996056321141, 898.1736802142012, 899.0694631056857, 648.060312546809, 668.2949488289852, 668.4017804065335, 669.1334721535623, 670.9094272273229, 15129.546113616609, 15256.923715381463, 15503.224838758017, 15529.689406211926, 15559.144247066406, 14307.856921430757, 14328.49850255236, 14371.856281437156, 14424.711505769827, 14474.71050578993, 11650.0, 11882.0, 12010.459529321202, 12055.819162712478, 12479.875201247962, 3681.1349332906743, 3710.091027698204, 3730.608286129944, 3800.2209547043067, 3835.5013848199833, 87289.69065464023, 87953.56023219907, 96612.0, 114568.42715786451, 127708.08437873346, 10650.360978341325, 10869.076128529005, 10871.83692244617, 10902.236843420884, 10912.454377281105, 21895.890520547295, 22178.33464996053, 22274.777252227595, 22313.0, 22378.0, 6877.552959057645, 7669.540344046747, 7863.764087077397, 7946.682132714743, 8032.0763112241675, 4427.645788336926, 4459.9331010034875, 4560.703554268962, 4564.817407303671, 4587.105514424722, 3632.364336241147, 3752.587215406303, 3753.4557489163917, 3762.3227818992295, 3765.1151979284846, 645.8675971425846, 668.0747165176266, 676.6481429656551, 689.3898899474002, 694.5173104692191, 610.7740136149653, 661.1372159332118, 662.159057996342, 672.9528932974645, 688.4182865478663, 9192.586333615003, 9849.704508864745, 9898.901010989943, 9905.2571057171, 9962.252831037702, 583.7168973048068, 625.252822876658, 631.4790298004165, 671.32196481553, 696.4915611603558, 4618.699784513996, 4673.5860708807195, 4743.335932969387, 4804.591609713144, 4873.1959226727195, 122735.0, 143545.0, 168834.0, 173422.0, 184081.0, 138262.0, 140464.29767851095, 144198.0, 145193.27403362916, 151644.2417787904, 76679.0, 96042.0, 108888.0, 123298.38350808188, 131010.0, 7975.481593696391, 9302.069793020644, 9962.950185249318, 10033.297669163088, 10217.1826253901, 54167.72916135394, 54547.0, 58250.708746455995, 63322.68338658277, 65406.0, 91107.0, 91992.62011069973, 93772.53113734387, 95047.04952950381, 96262.03737962531, 12959.157654752411, 12981.221126732426, 12995.675108121994, 13016.674583135497, 13064.538681261489, 14286.42854285817, 14346.354414051602, 15110.471133510275, 15171.848281517043, 15658.45195418155, 13077.476900923857, 13143.93428032892, 13806.03357764987, 14649.414023439369, 14823.0, 13044.128050056126, 13995.300234988006, 14040.859591403956, 14058.437662493387, 14188.432462701376, 12611.87388126107, 12911.612651620466, 13151.34243287851, 13529.120607160503, 13974.441022358991, 10977.615783447542, 11018.0, 11388.145889058189, 11422.828657569977, 11543.0, 10369.325993810378, 11445.484953177294, 11741.29552226869, 11763.176577639826, 11803.822942655695], "value": 7923.491662782323, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1566.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 115.0, 119.0, 118.0, 118.0, 119.0, 118.0, 108.0, 168.0], "value": 120.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 114.0, 109.0, 142.0, 117.0, 139.0, 110.0, 119.0, 171.0, 137.0], "value": 130.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [209.0, 200.0, 198.0, 201.0, 199.0, 275.0, 249.0, 195.0, 199.0, 198.0], "value": 212.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 60.0, 89.0, 60.0, 64.0, 67.0, 86.0, 106.0, 80.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 71.0, 88.0, 74.0, 68.0, 69.0, 89.0, 70.0, 72.0, 86.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 131.0, 134.0, 133.0, 132.0, 89.0, 93.0, 91.0, 93.0, 89.0], "value": 110.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 103.0, 103.0, 130.0, 130.0, 102.0, 103.0, 110.0, 104.0, 105.0], "value": 109.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 152.0, 145.0, 92.0, 87.0, 94.0, 91.0, 91.0, 91.0, 91.0], "value": 101.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 57.0, 60.0, 60.0, 60.0, 60.0, 61.0, 60.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 91.0, 108.0, 116.0, 85.0, 72.0, 70.0, 72.0, 72.0, 70.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 86.0, 73.0, 75.0, 99.0, 104.0, 101.0, 104.0, 77.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 149.0, 155.0, 142.0, 159.0, 152.0, 158.0, 201.0, 149.0], "value": 159.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 163.0, 166.0, 163.0, 169.0, 167.0, 167.0, 171.0, 166.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 81.0, 94.0, 98.0, 69.0, 67.0, 66.0, 70.0, 68.0, 66.0], "value": 74.8, "unit": "score"}]}]} 03:27:27 INFO - Return code: 0 03:27:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:27:27 ERROR - # TBPL SUCCESS # 03:27:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:27:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:27:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:27:27 INFO - 2016-11-01 03:27:27.873 screenresolution[1679:11819] starting screenresolution argv=screenresolution get 03:27:27 INFO - 2016-11-01 03:27:27.875 screenresolution[1679:11819] Display 0: 1600x1200x32@60 03:27:27 INFO - 2016-11-01 03:27:27.882 screenresolution[1680:11822] starting screenresolution argv=screenresolution list 03:27:27 INFO - Available Modes on Display 0 03:27:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:27:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:27:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:27:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:27:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:27:28 INFO - Intel Iris: 03:27:28 INFO - Chipset Model: Intel Iris 03:27:28 INFO - Type: GPU 03:27:28 INFO - Bus: Built-In 03:27:28 INFO - VRAM (Dynamic, Max): 1536 MB 03:27:28 INFO - Vendor: Intel (0x8086) 03:27:28 INFO - Device ID: 0x0a2e 03:27:28 INFO - Revision ID: 0x0009 03:27:28 INFO - Displays: 03:27:28 INFO - Display: 03:27:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:27:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:27:28 INFO - Display Serial Number: 1600x1200 60 03:27:28 INFO - Main Display: Yes 03:27:28 INFO - Mirror: Off 03:27:28 INFO - Online: Yes 03:27:28 INFO - Rotation: Supported 03:27:28 INFO - Return code: 0 03:27:28 INFO - Running post-action listener: _resource_record_post_action 03:27:28 INFO - [mozharness: 2016-11-01 10:27:28.129423Z] Finished run-tests step (success) 03:27:28 INFO - Running post-run listener: _resource_record_post_run 03:27:28 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 32926720; Write bytes: 668185088; Read time: 320; Write time: 1928 03:27:28 INFO - TinderboxPrint: CPU usage
54.4% 03:27:28 INFO - TinderboxPrint: I/O read bytes / time
32,926,720 / 320 03:27:28 INFO - TinderboxPrint: I/O write bytes / time
668,185,088 / 1,928 03:27:28 INFO - TinderboxPrint: CPU idle
2,205.1 (45.6%) 03:27:28 INFO - TinderboxPrint: CPU system
978.5 (20.2%) 03:27:28 INFO - TinderboxPrint: CPU user
1,650.1 (34.1%) 03:27:28 INFO - TinderboxPrint: Swap in / out
393,023,488 / 0 03:27:28 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 354507264; Write bytes: 357382144; Read time: 27607; Write time: 672 03:27:28 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 31976448; Write bytes: 300648960; Read time: 302; Write time: 1212 03:27:28 INFO - Running post-run listener: _upload_blobber_files 03:27:28 INFO - Blob upload gear active. 03:27:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:27:28 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 03:27:28 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'] 03:27:28 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 03:27:29 INFO - (blobuploader) - INFO - Open directory for files ... 03:27:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:27:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:27:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:30 INFO - (blobuploader) - INFO - Done attempting. 03:27:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:27:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:27:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:30 INFO - (blobuploader) - INFO - Done attempting. 03:27:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:27:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:27:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:33 INFO - (blobuploader) - INFO - Done attempting. 03:27:33 INFO - (blobuploader) - INFO - Iteration through files over. 03:27:33 INFO - Return code: 0 03:27:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:27:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:27:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e3b691876771a832b9397f3e06f7da8760e78f2e1af1c45317287658f6ff9c77f3496ee3d70e323897acd9c6f3cb1b51d5bde18864b6deac18628818bafe50b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2b69f97892bf8eb4040606810782cb8eab2af2dc6f55c029367af852476dc5bf260fdbef035a41fcf7a705a2cf27e87792e4206ca20eafbd9b27b7e66e08df23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67fcbab8153c238219831bfac76a9b14c29d8379bd49a6dbde75ed8f77c7aeeab2343f2c67031bdd4b90d38e5da0da850950f3df63baf3babd4d0094da8b36fc"} 03:27:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:27:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:27:33 INFO - Contents: 03:27:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e3b691876771a832b9397f3e06f7da8760e78f2e1af1c45317287658f6ff9c77f3496ee3d70e323897acd9c6f3cb1b51d5bde18864b6deac18628818bafe50b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2b69f97892bf8eb4040606810782cb8eab2af2dc6f55c029367af852476dc5bf260fdbef035a41fcf7a705a2cf27e87792e4206ca20eafbd9b27b7e66e08df23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67fcbab8153c238219831bfac76a9b14c29d8379bd49a6dbde75ed8f77c7aeeab2343f2c67031bdd4b90d38e5da0da850950f3df63baf3babd4d0094da8b36fc"} 03:27:33 INFO - Running post-run listener: copy_logs_to_upload_dir 03:27:33 INFO - Copying logs to upload dir... 03:27:33 INFO - mkdir: /builds/slave/test/build/upload/logs 03:27:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.441056 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-01 03:27:33.249710) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-01 03:27:33.253715) ========= 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.UuYob3ZAS2/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.Si0tSz24aj/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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/5e3b691876771a832b9397f3e06f7da8760e78f2e1af1c45317287658f6ff9c77f3496ee3d70e323897acd9c6f3cb1b51d5bde18864b6deac18628818bafe50b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2b69f97892bf8eb4040606810782cb8eab2af2dc6f55c029367af852476dc5bf260fdbef035a41fcf7a705a2cf27e87792e4206ca20eafbd9b27b7e66e08df23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67fcbab8153c238219831bfac76a9b14c29d8379bd49a6dbde75ed8f77c7aeeab2343f2c67031bdd4b90d38e5da0da850950f3df63baf3babd4d0094da8b36fc"} build_url:https://queue.taskcluster.net/v1/task/QtTVM1l0TLOgy-TwzC6akw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011223 build_url: 'https://queue.taskcluster.net/v1/task/QtTVM1l0TLOgy-TwzC6akw/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/5e3b691876771a832b9397f3e06f7da8760e78f2e1af1c45317287658f6ff9c77f3496ee3d70e323897acd9c6f3cb1b51d5bde18864b6deac18628818bafe50b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2b69f97892bf8eb4040606810782cb8eab2af2dc6f55c029367af852476dc5bf260fdbef035a41fcf7a705a2cf27e87792e4206ca20eafbd9b27b7e66e08df23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67fcbab8153c238219831bfac76a9b14c29d8379bd49a6dbde75ed8f77c7aeeab2343f2c67031bdd4b90d38e5da0da850950f3df63baf3babd4d0094da8b36fc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-01 03:27:33.287001) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 03:27:33.287339) ========= 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.UuYob3ZAS2/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.Si0tSz24aj/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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.005272 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 03:27:33.336246) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-01 03:27:33.336585) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-01 03:27:33.336959) ========= ========= Total master_lag: 0.17 =========