builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0125 starttime: 1479014111.19 results: success (0) buildid: 20161112201320 builduid: bcd64ce7db76489e89af1cdb6447aaaf revision: 51b57560770b0d733148460981683fc1aeb0d284 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-12 21:15:11.189655) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-12 21:15:11.190104) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-12 21:15:11.190388) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-12 21:15:11.217327) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 21:15:11.217626) ========= 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.E6xu4qGYUN/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.56avqZjof7/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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-12 21:15:11-- 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% 157M=0s 2016-11-12 21:15:11 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.464712 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 21:15:11.704309) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 21:15:11.704629) ========= 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.E6xu4qGYUN/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.56avqZjof7/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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.021309 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 21:15:11.753852) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-12 21:15:11.754222) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 51b57560770b0d733148460981683fc1aeb0d284 --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 51b57560770b0d733148460981683fc1aeb0d284 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.E6xu4qGYUN/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.56avqZjof7/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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-12 21:15:11,830 truncating revision to first 12 chars 2016-11-12 21:15:11,831 Setting DEBUG logging. 2016-11-12 21:15:11,831 attempt 1/10 2016-11-12 21:15:11,831 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/51b57560770b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-12 21:15:13,568 unpacking tar archive at: mozilla-aurora-51b57560770b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.989656 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-12 21:15:13.765936) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-12 21:15:13.766266) ========= script_repo_revision: 51b57560770b0d733148460981683fc1aeb0d284 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-12 21:15:13.766657) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-12 21:15:13.766943) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-12 21:15:13.785603) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-11-12 21:15:13.786542) ========= /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.E6xu4qGYUN/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.56avqZjof7/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 21:15:13 INFO - MultiFileLogger online at 20161112 21:15:13 in /builds/slave/test 21:15:13 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 21:15:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:15:13 INFO - {'append_to_log': False, 21:15:13 INFO - 'base_work_dir': '/builds/slave/test', 21:15:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:15:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:15:13 INFO - 'branch': 'Mozilla-Aurora', 21:15:13 INFO - 'buildbot_json_path': 'buildprops.json', 21:15:13 INFO - 'config_files': ('talos/mac_config.py',), 21:15:13 INFO - 'default_actions': ('clobber', 21:15:13 INFO - 'read-buildbot-config', 21:15:13 INFO - 'download-and-extract', 21:15:13 INFO - 'populate-webroot', 21:15:13 INFO - 'create-virtualenv', 21:15:13 INFO - 'install', 21:15:13 INFO - 'run-tests'), 21:15:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:15:13 INFO - 'download_minidump_stackwalk': True, 21:15:13 INFO - 'download_symbols': 'ondemand', 21:15:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:15:13 INFO - 'tooltool.py': '/tools/tooltool.py', 21:15:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:15:13 INFO - '/tools/misc-python/virtualenv.py')}, 21:15:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:15:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:15:13 INFO - 'installer_path': 'installer.exe', 21:15:13 INFO - 'log_level': 'info', 21:15:13 INFO - 'log_name': 'talos', 21:15:13 INFO - 'log_to_console': True, 21:15:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:15:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:15:13 INFO - 'opt_config_files': (), 21:15:13 INFO - 'pip_index': False, 21:15:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:15:13 INFO - 'cmd': ('bash', 21:15:13 INFO - '-c', 21:15:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:15:13 INFO - 'enabled': True, 21:15:13 INFO - 'halt_on_failure': False, 21:15:13 INFO - 'name': 'check_screen_resolution'},), 21:15:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:15:13 INFO - 'cmd': ('bash', 21:15:13 INFO - '-c', 21:15:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:15:13 INFO - 'enabled': True, 21:15:13 INFO - 'halt_on_failure': False, 21:15:13 INFO - 'name': 'check_screen_resolution'},), 21:15:13 INFO - 'run_cmd_checks_enabled': True, 21:15:13 INFO - 'sps_profile': False, 21:15:13 INFO - 'sps_profile_interval': 0, 21:15:13 INFO - 'suite': 'dromaeojs-e10s', 21:15:13 INFO - 'system_bits': '32', 21:15:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:15:13 INFO - 'title': 't-yosemite-r7-0125', 21:15:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:15:13 INFO - 'use_talos_json': True, 21:15:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:15:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:15:13 INFO - 'work_dir': 'build'} 21:15:13 INFO - [mozharness: 2016-11-13 05:15:13.984667Z] Running clobber step. 21:15:13 INFO - Running pre-action listener: _resource_record_pre_action 21:15:13 INFO - Running main action method: clobber 21:15:13 INFO - rmtree: /builds/slave/test/build 21:15:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:15:15 INFO - Running post-action listener: _resource_record_post_action 21:15:15 INFO - [mozharness: 2016-11-13 05:15:15.655912Z] Finished clobber step (success) 21:15:15 INFO - [mozharness: 2016-11-13 05:15:15.656101Z] Running read-buildbot-config step. 21:15:15 INFO - Running pre-action listener: _resource_record_pre_action 21:15:15 INFO - Running main action method: read_buildbot_config 21:15:15 INFO - Using buildbot properties: 21:15:15 INFO - { 21:15:15 INFO - "project": "", 21:15:15 INFO - "product": "firefox", 21:15:15 INFO - "script_repo_revision": "production", 21:15:15 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 21:15:15 INFO - "repository": "", 21:15:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 21:15:15 INFO - "buildid": "20161112201320", 21:15:15 INFO - "pgo_build": "False", 21:15:15 INFO - "basedir": "/builds/slave/test", 21:15:15 INFO - "buildnumber": 18, 21:15:15 INFO - "slavename": "t-yosemite-r7-0125", 21:15:15 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 21:15:15 INFO - "platform": "yosemite_r7", 21:15:15 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 21:15:15 INFO - "branch": "mozilla-aurora", 21:15:15 INFO - "repo_path": "releases/mozilla-aurora", 21:15:15 INFO - "revision": "51b57560770b0d733148460981683fc1aeb0d284", 21:15:15 INFO - "stage_platform": "macosx64", 21:15:15 INFO - "builduid": "bcd64ce7db76489e89af1cdb6447aaaf", 21:15:15 INFO - "slavebuilddir": "test" 21:15:15 INFO - } 21:15:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/Djfj-6SnQIuxOUQhAa006Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 21:15:15 INFO - Running post-action listener: _resource_record_post_action 21:15:15 INFO - [mozharness: 2016-11-13 05:15:15.661938Z] Finished read-buildbot-config step (success) 21:15:15 INFO - [mozharness: 2016-11-13 05:15:15.662118Z] Running download-and-extract step. 21:15:15 INFO - Running pre-action listener: _resource_record_pre_action 21:15:15 INFO - Running main action method: download_and_extract 21:15:15 INFO - mkdir: /builds/slave/test/build/tests 21:15:15 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')]} 21:15:15 INFO - trying https://queue.taskcluster.net/v1/task/Djfj-6SnQIuxOUQhAa006Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 21:15:15 INFO - Downloading https://queue.taskcluster.net/v1/task/Djfj-6SnQIuxOUQhAa006Q/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 21:15:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Djfj-6SnQIuxOUQhAa006Q/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 21:15:16 INFO - Downloaded 1199 bytes. 21:15:16 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 21:15:16 INFO - Using the following test package requirements: 21:15:16 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 21:15:16 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:15:16 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 21:15:16 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:15:16 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 21:15:16 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:15:16 INFO - u'jsshell-mac.zip'], 21:15:16 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:15:16 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 21:15:16 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 21:15:16 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:15:16 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 21:15:16 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:15:16 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 21:15:16 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:15:16 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 21:15:16 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:15:16 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 21:15:16 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 21:15:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Djfj-6SnQIuxOUQhAa006Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 21:15:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Djfj-6SnQIuxOUQhAa006Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:15:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Djfj-6SnQIuxOUQhAa006Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 21:15:17 INFO - Expected file size: 16423737 21:15:24 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 21:15:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Djfj-6SnQIuxOUQhAa006Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 21:15:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Djfj-6SnQIuxOUQhAa006Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:15:24 INFO - Fetch https://queue.taskcluster.net/v1/task/Djfj-6SnQIuxOUQhAa006Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 21:15:24 INFO - Expected file size: 16423737 21:15:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Djfj-6SnQIuxOUQhAa006Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 21:15:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Djfj-6SnQIuxOUQhAa006Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 21:15:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Djfj-6SnQIuxOUQhAa006Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 21:15:32 INFO - Expected file size: 14414089 21:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:15:32 INFO - trying https://queue.taskcluster.net/v1/task/Djfj-6SnQIuxOUQhAa006Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:15:32 INFO - Downloading https://queue.taskcluster.net/v1/task/Djfj-6SnQIuxOUQhAa006Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 21:15:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Djfj-6SnQIuxOUQhAa006Q/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 21:15:35 INFO - Downloaded 115552785 bytes. 21:15:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Djfj-6SnQIuxOUQhAa006Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:15:35 INFO - mkdir: /builds/slave/test/properties 21:15:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:15:35 INFO - Writing to file /builds/slave/test/properties/build_url 21:15:35 INFO - Contents: 21:15:35 INFO - build_url:https://queue.taskcluster.net/v1/task/Djfj-6SnQIuxOUQhAa006Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:15:36 INFO - Running post-action listener: _resource_record_post_action 21:15:36 INFO - Running post-action listener: set_extra_try_arguments 21:15:36 INFO - [mozharness: 2016-11-13 05:15:36.461805Z] Finished download-and-extract step (success) 21:15:36 INFO - [mozharness: 2016-11-13 05:15:36.461911Z] Running populate-webroot step. 21:15:36 INFO - Running pre-action listener: _resource_record_pre_action 21:15:36 INFO - Running main action method: populate_webroot 21:15:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:15:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:15:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:15:36 INFO - '--tppagecycles', 21:15:36 INFO - '7'], 21:15:36 INFO - 'tests': ['tsvgm']}}, 21:15:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:15:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:15:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:15:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:15:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:15:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:15:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:36 INFO - 'talos_options': ['--disable-e10s'], 21:15:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:15:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:15:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:36 INFO - 'talos_options': ['--disable-e10s'], 21:15:36 INFO - 'tests': ['damp', 'tps']}, 21:15:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:36 INFO - 'tests': ['damp', 'tps']}, 21:15:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:15:36 INFO - 'tests': ['dromaeo_dom']}, 21:15:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:15:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:15:36 INFO - 'tests': ['basic_compositor_video']}, 21:15:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:15:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:15:36 INFO - 'tests': ['a11yr', 21:15:36 INFO - 'ts_paint', 21:15:36 INFO - 'tpaint', 21:15:36 INFO - 'sessionrestore', 21:15:36 INFO - 'sessionrestore_no_auto_restore', 21:15:36 INFO - 'tabpaint']}, 21:15:36 INFO - 'other-e10s': {'tests': ['a11yr', 21:15:36 INFO - 'ts_paint', 21:15:36 INFO - 'tpaint', 21:15:36 INFO - 'sessionrestore', 21:15:36 INFO - 'sessionrestore_no_auto_restore', 21:15:36 INFO - 'tabpaint']}, 21:15:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:15:36 INFO - 'ts_paint', 21:15:36 INFO - 'tpaint', 21:15:36 INFO - 'sessionrestore', 21:15:36 INFO - 'sessionrestore_no_auto_restore', 21:15:36 INFO - 'tabpaint']}, 21:15:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:15:36 INFO - 'ts_paint', 21:15:36 INFO - 'tpaint', 21:15:36 INFO - 'sessionrestore', 21:15:36 INFO - 'sessionrestore_no_auto_restore', 21:15:36 INFO - 'tabpaint']}, 21:15:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:15:36 INFO - 'tests': ['a11yr', 21:15:36 INFO - 'ts_paint', 21:15:36 INFO - 'tpaint', 21:15:36 INFO - 'sessionrestore', 21:15:36 INFO - 'sessionrestore_no_auto_restore', 21:15:36 INFO - 'tabpaint']}, 21:15:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:15:36 INFO - 'tests': ['a11yr', 21:15:36 INFO - 'ts_paint', 21:15:36 INFO - 'tpaint', 21:15:36 INFO - 'sessionrestore', 21:15:36 INFO - 'sessionrestore_no_auto_restore', 21:15:36 INFO - 'tabpaint']}, 21:15:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:15:36 INFO - 'tests': ['tsvgx', 21:15:36 INFO - 'tsvgr_opacity', 21:15:36 INFO - 'tart', 21:15:36 INFO - 'tscrollx', 21:15:36 INFO - 'cart']}, 21:15:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:15:36 INFO - 'tsvgr_opacity', 21:15:36 INFO - 'tart', 21:15:36 INFO - 'tscrollx', 21:15:36 INFO - 'cart']}, 21:15:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:36 INFO - 'talos_options': ['--disable-e10s'], 21:15:36 INFO - 'tests': ['tp5o']}, 21:15:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:36 INFO - 'tests': ['tp5o']}, 21:15:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:36 INFO - 'talos_options': ['--disable-e10s', 21:15:36 INFO - '--xperf_path', 21:15:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:15:36 INFO - 'tests': ['tp5n']}, 21:15:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:36 INFO - 'talos_options': ['--xperf_path', 21:15:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:15:36 INFO - 'tests': ['tp5n']}}, 21:15:36 INFO - 'talos.zip': {'path': '', 21:15:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:15:36 INFO - Running post-action listener: _resource_record_post_action 21:15:36 INFO - [mozharness: 2016-11-13 05:15:36.480857Z] Finished populate-webroot step (success) 21:15:36 INFO - [mozharness: 2016-11-13 05:15:36.480987Z] Running create-virtualenv step. 21:15:36 INFO - Running pre-action listener: _resource_record_pre_action 21:15:36 INFO - Running main action method: create_virtualenv 21:15:36 INFO - Creating virtualenv /builds/slave/test/build/venv 21:15:36 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 21:15:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:15:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:15:36 INFO - Using real prefix '/tools/python27' 21:15:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:15:37 INFO - Installing distribute.............................................................................................................................................................................................done. 21:15:40 INFO - Installing pip.................done. 21:15:40 INFO - Return code: 0 21:15:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:15:40 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')]} 21:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:40 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')]} 21:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:40 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 0x108542490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084b8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6a249d8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108356d30>, '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 0x1081bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10834eb20>, '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.E6xu4qGYUN/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.56avqZjof7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 21:15:40 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 21:15:40 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 21:15:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E6xu4qGYUN/Render', 21:15:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:40 INFO - 'HOME': '/Users/cltbld', 21:15:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:40 INFO - 'LOGNAME': 'cltbld', 21:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:40 INFO - 'MOZ_NO_REMOTE': '1', 21:15:40 INFO - 'NO_EM_RESTART': '1', 21:15:40 INFO - 'PAGER': '/bin/cat', 21:15:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:40 INFO - 'PWD': '/builds/slave/test', 21:15:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:40 INFO - 'SHELL': '/bin/bash', 21:15:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.56avqZjof7/Listeners', 21:15:40 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 21:15:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:40 INFO - 'USER': 'cltbld', 21:15:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:40 INFO - 'XPC_FLAGS': '0x0', 21:15:40 INFO - 'XPC_SERVICE_NAME': '0', 21:15:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:40 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 21:15:40 INFO - Cleaning up... 21:15:40 INFO - Return code: 0 21:15:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:15:40 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')]} 21:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:40 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')]} 21:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:40 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 0x108542490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084b8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6a249d8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108356d30>, '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 0x1081bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10834eb20>, '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.E6xu4qGYUN/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.56avqZjof7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 21:15:40 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 21:15:40 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 21:15:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E6xu4qGYUN/Render', 21:15:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:40 INFO - 'HOME': '/Users/cltbld', 21:15:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:40 INFO - 'LOGNAME': 'cltbld', 21:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:40 INFO - 'MOZ_NO_REMOTE': '1', 21:15:40 INFO - 'NO_EM_RESTART': '1', 21:15:40 INFO - 'PAGER': '/bin/cat', 21:15:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:40 INFO - 'PWD': '/builds/slave/test', 21:15:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:40 INFO - 'SHELL': '/bin/bash', 21:15:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.56avqZjof7/Listeners', 21:15:40 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 21:15:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:40 INFO - 'USER': 'cltbld', 21:15:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:40 INFO - 'XPC_FLAGS': '0x0', 21:15:40 INFO - 'XPC_SERVICE_NAME': '0', 21:15:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:40 INFO - Downloading/unpacking psutil>=3.1.1 21:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:15:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:15:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:15:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:15:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:15:44 INFO - Installing collected packages: psutil 21:15:44 INFO - Running setup.py install for psutil 21:15:44 INFO - building 'psutil._psutil_osx' extension 21:15:44 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 21:15:44 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 21:15:44 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 21:15:45 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 21:15:45 INFO - building 'psutil._psutil_posix' extension 21:15:45 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 21:15:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:15:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:15:45 INFO - ^ 21:15:45 INFO - 1 warning generated. 21:15:45 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 21:15:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:15:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:15:45 INFO - Successfully installed psutil 21:15:45 INFO - Cleaning up... 21:15:45 INFO - Return code: 0 21:15:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:15:45 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')]} 21:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:45 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')]} 21:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:45 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 0x108542490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084b8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6a249d8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108356d30>, '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 0x1081bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10834eb20>, '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.E6xu4qGYUN/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.56avqZjof7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 21:15:45 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 21:15:45 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 21:15:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E6xu4qGYUN/Render', 21:15:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:45 INFO - 'HOME': '/Users/cltbld', 21:15:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:45 INFO - 'LOGNAME': 'cltbld', 21:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:45 INFO - 'MOZ_NO_REMOTE': '1', 21:15:45 INFO - 'NO_EM_RESTART': '1', 21:15:45 INFO - 'PAGER': '/bin/cat', 21:15:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:45 INFO - 'PWD': '/builds/slave/test', 21:15:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:45 INFO - 'SHELL': '/bin/bash', 21:15:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.56avqZjof7/Listeners', 21:15:45 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 21:15:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:45 INFO - 'USER': 'cltbld', 21:15:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:45 INFO - 'XPC_FLAGS': '0x0', 21:15:45 INFO - 'XPC_SERVICE_NAME': '0', 21:15:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:15:45 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 21:15:45 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 21:15:45 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 21:15:45 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 21:15:45 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 21:15:45 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 21:15:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:15:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:15:48 INFO - Installing collected packages: mozsystemmonitor 21:15:48 INFO - Running setup.py install for mozsystemmonitor 21:15:48 INFO - Successfully installed mozsystemmonitor 21:15:48 INFO - Cleaning up... 21:15:48 INFO - Return code: 0 21:15:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:15:48 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')]} 21:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:48 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')]} 21:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:48 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 0x108542490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084b8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6a249d8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108356d30>, '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 0x1081bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10834eb20>, '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.E6xu4qGYUN/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.56avqZjof7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 21:15:48 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 21:15:48 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 21:15:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E6xu4qGYUN/Render', 21:15:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:48 INFO - 'HOME': '/Users/cltbld', 21:15:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:48 INFO - 'LOGNAME': 'cltbld', 21:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:48 INFO - 'MOZ_NO_REMOTE': '1', 21:15:48 INFO - 'NO_EM_RESTART': '1', 21:15:48 INFO - 'PAGER': '/bin/cat', 21:15:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:48 INFO - 'PWD': '/builds/slave/test', 21:15:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:48 INFO - 'SHELL': '/bin/bash', 21:15:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.56avqZjof7/Listeners', 21:15:48 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 21:15:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:48 INFO - 'USER': 'cltbld', 21:15:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:48 INFO - 'XPC_FLAGS': '0x0', 21:15:48 INFO - 'XPC_SERVICE_NAME': '0', 21:15:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:48 INFO - Downloading/unpacking jsonschema==2.5.1 21:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:15:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:15:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:15:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:15:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:15: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 21:15: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 21:15: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 21:15: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 21:15: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 21:15: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 21:15:51 INFO - Downloading functools32-3.2.3-2.tar.gz 21:15:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:15:51 INFO - warning: no files found matching '*.txt' 21:15:51 INFO - no previously-included directories found matching 'build' 21:15:51 INFO - no previously-included directories found matching 'dist' 21:15:51 INFO - no previously-included directories found matching '.git*' 21:15:51 INFO - Installing collected packages: jsonschema, functools32 21:15:51 INFO - Running setup.py install for functools32 21:15:52 INFO - warning: no files found matching '*.txt' 21:15:52 INFO - no previously-included directories found matching 'build' 21:15:52 INFO - no previously-included directories found matching 'dist' 21:15:52 INFO - no previously-included directories found matching '.git*' 21:15:52 INFO - Successfully installed jsonschema functools32 21:15:52 INFO - Cleaning up... 21:15:52 INFO - Return code: 0 21:15:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:15: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')]} 21:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15: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')]} 21:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108542490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084b8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6a249d8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108356d30>, '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 0x1081bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10834eb20>, '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.E6xu4qGYUN/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.56avqZjof7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 21:15:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:15:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:15:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E6xu4qGYUN/Render', 21:15:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:52 INFO - 'HOME': '/Users/cltbld', 21:15:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:52 INFO - 'LOGNAME': 'cltbld', 21:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:52 INFO - 'MOZ_NO_REMOTE': '1', 21:15:52 INFO - 'NO_EM_RESTART': '1', 21:15:52 INFO - 'PAGER': '/bin/cat', 21:15:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:52 INFO - 'PWD': '/builds/slave/test', 21:15:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:52 INFO - 'SHELL': '/bin/bash', 21:15:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.56avqZjof7/Listeners', 21:15:52 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 21:15:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:52 INFO - 'USER': 'cltbld', 21:15:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:52 INFO - 'XPC_FLAGS': '0x0', 21:15:52 INFO - 'XPC_SERVICE_NAME': '0', 21:15:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:15:52 INFO - Cleaning up... 21:15:52 INFO - Return code: 0 21:15:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:15: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')]} 21:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15: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')]} 21:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108542490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084b8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6a249d8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108356d30>, '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 0x1081bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10834eb20>, '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.E6xu4qGYUN/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.56avqZjof7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 21:15:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:15:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:15:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E6xu4qGYUN/Render', 21:15:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:52 INFO - 'HOME': '/Users/cltbld', 21:15:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:52 INFO - 'LOGNAME': 'cltbld', 21:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:52 INFO - 'MOZ_NO_REMOTE': '1', 21:15:52 INFO - 'NO_EM_RESTART': '1', 21:15:52 INFO - 'PAGER': '/bin/cat', 21:15:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:52 INFO - 'PWD': '/builds/slave/test', 21:15:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:52 INFO - 'SHELL': '/bin/bash', 21:15:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.56avqZjof7/Listeners', 21:15:52 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 21:15:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:52 INFO - 'USER': 'cltbld', 21:15:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:52 INFO - 'XPC_FLAGS': '0x0', 21:15:52 INFO - 'XPC_SERVICE_NAME': '0', 21:15:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:52 INFO - Downloading/unpacking blobuploader==1.2.4 21:15:52 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 21:15:52 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 21:15:52 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 21:15:52 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 21:15:52 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 21:15:52 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 21:15:55 INFO - Downloading blobuploader-1.2.4.tar.gz 21:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:15:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:15:55 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 21:15:55 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 21:15:55 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 21:15:55 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 21:15:55 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 21:15:55 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 21:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:15:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:15:55 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 21:15:55 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 21:15:55 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 21:15:55 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 21:15:55 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 21:15:55 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 21:15:56 INFO - Downloading docopt-0.6.1.tar.gz 21:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:15:56 INFO - Installing collected packages: blobuploader, requests, docopt 21:15:56 INFO - Running setup.py install for blobuploader 21:15:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:15:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:15:56 INFO - Running setup.py install for requests 21:15:57 INFO - Running setup.py install for docopt 21:15:57 INFO - Successfully installed blobuploader requests docopt 21:15:57 INFO - Cleaning up... 21:15:57 INFO - Return code: 0 21:15:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:15:57 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')]} 21:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:57 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')]} 21:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:57 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 0x108542490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084b8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6a249d8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108356d30>, '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 0x1081bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10834eb20>, '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.E6xu4qGYUN/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.56avqZjof7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 21:15:57 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 21:15:57 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 21:15:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E6xu4qGYUN/Render', 21:15:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:57 INFO - 'HOME': '/Users/cltbld', 21:15:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:57 INFO - 'LOGNAME': 'cltbld', 21:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:57 INFO - 'MOZ_NO_REMOTE': '1', 21:15:57 INFO - 'NO_EM_RESTART': '1', 21:15:57 INFO - 'PAGER': '/bin/cat', 21:15:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:57 INFO - 'PWD': '/builds/slave/test', 21:15:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:57 INFO - 'SHELL': '/bin/bash', 21:15:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.56avqZjof7/Listeners', 21:15:57 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 21:15:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:57 INFO - 'USER': 'cltbld', 21:15:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:57 INFO - 'XPC_FLAGS': '0x0', 21:15:57 INFO - 'XPC_SERVICE_NAME': '0', 21:15:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:15:57 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-qgz7d0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:15:57 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-i5NixX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:15:57 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-vLR3ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:15:57 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-Dxugz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:15:57 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-igfe4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:15:58 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-stKkRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:15:58 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-YNdPxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:15:58 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-haqyoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:15:58 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-53zh02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:15:58 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-E8YO8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:15:58 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-QUKfbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:15:58 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-lCY8d_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:15:58 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-IYo_Pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:15:58 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-_pKkyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:15:59 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-LwLu0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:15:59 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-nu21Zv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:15:59 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-58hT46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:15:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:15:59 INFO - Running setup.py install for manifestparser 21:15:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:15:59 INFO - Running setup.py install for mozcrash 21:15:59 INFO - Running setup.py install for mozdebug 21:15:59 INFO - Running setup.py install for mozdevice 21:15:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:15:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:15:59 INFO - Running setup.py install for mozfile 21:16:00 INFO - Running setup.py install for mozhttpd 21:16:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:16:00 INFO - Running setup.py install for mozinfo 21:16:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:16:00 INFO - Running setup.py install for mozInstall 21:16:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:16:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:16:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:16:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:16:00 INFO - Running setup.py install for mozleak 21:16:00 INFO - Running setup.py install for mozlog 21:16:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:16:00 INFO - Running setup.py install for moznetwork 21:16:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:16:00 INFO - Running setup.py install for mozprocess 21:16:01 INFO - Running setup.py install for mozprofile 21:16:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:16:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:16:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:16:01 INFO - Running setup.py install for mozrunner 21:16:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:16:01 INFO - Running setup.py install for mozscreenshot 21:16:01 INFO - Running setup.py install for moztest 21:16:01 INFO - Running setup.py install for mozversion 21:16:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:16:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:16:01 INFO - Cleaning up... 21:16:01 INFO - Return code: 0 21:16:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:16:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:01 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 0x108542490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084b8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6a249d8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108356d30>, '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 0x1081bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10834eb20>, '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.E6xu4qGYUN/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.56avqZjof7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 21:16:01 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 21:16:01 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 21:16:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E6xu4qGYUN/Render', 21:16:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:01 INFO - 'HOME': '/Users/cltbld', 21:16:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:01 INFO - 'LOGNAME': 'cltbld', 21:16:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:01 INFO - 'MOZ_NO_REMOTE': '1', 21:16:01 INFO - 'NO_EM_RESTART': '1', 21:16:01 INFO - 'PAGER': '/bin/cat', 21:16:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:01 INFO - 'PWD': '/builds/slave/test', 21:16:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:01 INFO - 'SHELL': '/bin/bash', 21:16:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.56avqZjof7/Listeners', 21:16:01 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 21:16:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:01 INFO - 'USER': 'cltbld', 21:16:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:01 INFO - 'XPC_FLAGS': '0x0', 21:16:01 INFO - 'XPC_SERVICE_NAME': '0', 21:16:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:16:02 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-vQBhqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:16:02 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)) 21:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:16:02 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-PGXtQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:16:02 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)) 21:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:16:02 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-zcfxZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:16:02 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)) 21:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:16:02 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-VHwcLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:16:02 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)) 21:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:16:02 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-U2lNLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:16:02 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)) 21:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:16:02 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-8WWq4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:16:02 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)) 21:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:16:02 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-nMbvIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:16:02 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)) 21:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:16:02 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-SJ5fgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:16:03 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)) 21:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:16:03 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-0_jrsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:16:03 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)) 21:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:16:03 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-QTMcKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:16:03 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)) 21:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:16:03 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-W6dUO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:16:03 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)) 21:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:16:03 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-vQnBZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:16:03 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)) 21:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:16:03 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-FlyxWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:16:03 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)) 21:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:16:03 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-vPds_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:16:03 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)) 21:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:16:03 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-91C0jO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:16:03 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)) 21:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:16:03 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-DoTwDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:16:03 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)) 21:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:16:03 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-gD9MmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:16:03 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)) 21:16:03 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)) 21:16:03 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)) 21:16:03 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)) 21:16:03 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)) 21:16:03 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)) 21:16:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:16: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 21:16: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 21:16: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 21:16: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 21:16: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 21:16: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 21:16:06 INFO - Downloading blessings-1.6.tar.gz 21:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:16:06 INFO - Installing collected packages: blessings 21:16:06 INFO - Running setup.py install for blessings 21:16:06 INFO - Successfully installed blessings 21:16:06 INFO - Cleaning up... 21:16:06 INFO - Return code: 0 21:16:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:16:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:16:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:16:07 INFO - Reading from file tmpfile_stdout 21:16:07 INFO - Current package versions: 21:16:07 INFO - blessings == 1.6 21:16:07 INFO - blobuploader == 1.2.4 21:16:07 INFO - docopt == 0.6.1 21:16:07 INFO - functools32 == 3.2.3-2 21:16:07 INFO - jsonschema == 2.5.1 21:16:07 INFO - manifestparser == 1.1 21:16:07 INFO - mozInstall == 1.12 21:16:07 INFO - mozcrash == 0.17 21:16:07 INFO - mozdebug == 0.1 21:16:07 INFO - mozdevice == 0.48 21:16:07 INFO - mozfile == 1.2 21:16:07 INFO - mozhttpd == 0.7 21:16:07 INFO - mozinfo == 0.9 21:16:07 INFO - mozleak == 0.1 21:16:07 INFO - mozlog == 3.4 21:16:07 INFO - moznetwork == 0.27 21:16:07 INFO - mozprocess == 0.23 21:16:07 INFO - mozprofile == 0.28 21:16:07 INFO - mozrunner == 6.12 21:16:07 INFO - mozscreenshot == 0.1 21:16:07 INFO - mozsystemmonitor == 0.3 21:16:07 INFO - moztest == 0.7 21:16:07 INFO - mozversion == 1.4 21:16:07 INFO - psutil == 3.1.1 21:16:07 INFO - requests == 1.2.3 21:16:07 INFO - wsgiref == 0.1.2 21:16:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:16:07 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')]} 21:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:07 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')]} 21:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:07 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 0x108542490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084b8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6a249d8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108356d30>, '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 0x1081bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10834eb20>, '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.E6xu4qGYUN/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.56avqZjof7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 21:16:07 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 21:16:07 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 21:16:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E6xu4qGYUN/Render', 21:16:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:07 INFO - 'HOME': '/Users/cltbld', 21:16:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:07 INFO - 'LOGNAME': 'cltbld', 21:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:07 INFO - 'MOZ_NO_REMOTE': '1', 21:16:07 INFO - 'NO_EM_RESTART': '1', 21:16:07 INFO - 'PAGER': '/bin/cat', 21:16:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:07 INFO - 'PWD': '/builds/slave/test', 21:16:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:07 INFO - 'SHELL': '/bin/bash', 21:16:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.56avqZjof7/Listeners', 21:16:07 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 21:16:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:07 INFO - 'USER': 'cltbld', 21:16:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:07 INFO - 'XPC_FLAGS': '0x0', 21:16:07 INFO - 'XPC_SERVICE_NAME': '0', 21:16:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:07 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)) 21:16:07 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)) 21:16:07 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)) 21:16:07 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)) 21:16:07 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)) 21:16:07 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)) 21:16:07 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)) 21:16:07 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)) 21:16:07 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)) 21:16:07 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)) 21:16:07 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)) 21:16:07 INFO - Cleaning up... 21:16:07 INFO - Return code: 0 21:16:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:16:07 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')]} 21:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:07 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')]} 21:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:07 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 0x108542490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084b8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6a249d8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108356d30>, '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 0x1081bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10834eb20>, '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.E6xu4qGYUN/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.56avqZjof7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 21:16:07 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 21:16:07 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 21:16:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E6xu4qGYUN/Render', 21:16:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:07 INFO - 'HOME': '/Users/cltbld', 21:16:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:07 INFO - 'LOGNAME': 'cltbld', 21:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:07 INFO - 'MOZ_NO_REMOTE': '1', 21:16:07 INFO - 'NO_EM_RESTART': '1', 21:16:07 INFO - 'PAGER': '/bin/cat', 21:16:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:07 INFO - 'PWD': '/builds/slave/test', 21:16:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:07 INFO - 'SHELL': '/bin/bash', 21:16:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.56avqZjof7/Listeners', 21:16:07 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 21:16:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:07 INFO - 'USER': 'cltbld', 21:16:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:07 INFO - 'XPC_FLAGS': '0x0', 21:16:07 INFO - 'XPC_SERVICE_NAME': '0', 21:16:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:16:07 INFO - Cleaning up... 21:16:07 INFO - Return code: 0 21:16:07 INFO - Running post-action listener: _resource_record_post_action 21:16:07 INFO - Running post-action listener: _start_resource_monitoring 21:16:07 INFO - Starting resource monitoring. 21:16:07 INFO - [mozharness: 2016-11-13 05:16:07.714449Z] Finished create-virtualenv step (success) 21:16:07 INFO - [mozharness: 2016-11-13 05:16:07.715461Z] Running install step. 21:16:07 INFO - Running pre-action listener: _resource_record_pre_action 21:16:07 INFO - Running main action method: install 21:16:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:16:07 INFO - Reading from file tmpfile_stdout 21:16:07 INFO - Detecting whether we're running mozinstall >=1.0... 21:16:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:16:08 INFO - Reading from file tmpfile_stdout 21:16:08 INFO - Output received: 21:16:08 INFO - Usage: mozinstall [options] installer 21:16:08 INFO - Options: 21:16:08 INFO - -h, --help show this help message and exit 21:16:08 INFO - -d DEST, --destination=DEST 21:16:08 INFO - Directory to install application into. [default: 21:16:08 INFO - "/builds/slave/test"] 21:16:08 INFO - --app=APP Application being installed. [default: firefox] 21:16:08 INFO - mkdir: /builds/slave/test/build/application 21:16:08 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'] 21:16:08 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 21:16:40 INFO - Reading from file tmpfile_stdout 21:16:40 INFO - Output received: 21:16:40 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 21:16:40 INFO - Running post-action listener: _resource_record_post_action 21:16:40 INFO - [mozharness: 2016-11-13 05:16:40.309855Z] Finished install step (success) 21:16:40 INFO - [mozharness: 2016-11-13 05:16:40.310039Z] Running run-tests step. 21:16:40 INFO - Running pre-action listener: _resource_record_pre_action 21:16:40 INFO - Running main action method: run_tests 21:16:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:16:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:16:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:16:40 INFO - 2016-11-12 21:16:40.324 screenresolution[1937:16557] starting screenresolution argv=screenresolution get 21:16:40 INFO - 2016-11-12 21:16:40.327 screenresolution[1937:16557] Display 0: 1600x1200x32@60 21:16:40 INFO - 2016-11-12 21:16:40.332 screenresolution[1938:16559] starting screenresolution argv=screenresolution list 21:16:40 INFO - Available Modes on Display 0 21:16:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:16:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:16:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:16:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:16:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:16:40 INFO - Intel Iris: 21:16:40 INFO - Chipset Model: Intel Iris 21:16:40 INFO - Type: GPU 21:16:40 INFO - Bus: Built-In 21:16:40 INFO - VRAM (Dynamic, Max): 1536 MB 21:16:40 INFO - Vendor: Intel (0x8086) 21:16:40 INFO - Device ID: 0x0a2e 21:16:40 INFO - Revision ID: 0x0009 21:16:40 INFO - Displays: 21:16:40 INFO - Display: 21:16:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:16:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:16:40 INFO - Display Serial Number: 1600x1200 60 21:16:40 INFO - Main Display: Yes 21:16:40 INFO - Mirror: Off 21:16:40 INFO - Online: Yes 21:16:40 INFO - Rotation: Supported 21:16:40 INFO - Return code: 0 21:16:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:16:40 INFO - Python 2.7.3 21:16:40 INFO - Return code: 0 21:16:40 INFO - grabbing minidump binary from tooltool 21:16:40 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')]} 21:16:40 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 0x108356d30>, '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 0x1081bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10834eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:16:40 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 21:16:40 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 21:16:40 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 21:16:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:16:40 INFO - Return code: 0 21:16:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:16:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:16:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:16:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:16:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:16:40 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/Djfj-6SnQIuxOUQhAa006Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0125', '--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 21:16:40 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/Djfj-6SnQIuxOUQhAa006Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0125 --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 21:16:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E6xu4qGYUN/Render', 21:16:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:40 INFO - 'HOME': '/Users/cltbld', 21:16:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:40 INFO - 'LOGNAME': 'cltbld', 21:16:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:16:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:40 INFO - 'MOZ_NO_REMOTE': '1', 21:16:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:16:40 INFO - 'NO_EM_RESTART': '1', 21:16:40 INFO - 'PAGER': '/bin/cat', 21:16:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:40 INFO - 'PWD': '/builds/slave/test', 21:16:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:16:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:40 INFO - 'SHELL': '/bin/bash', 21:16:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.56avqZjof7/Listeners', 21:16:40 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 21:16:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:40 INFO - 'USER': 'cltbld', 21:16:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:40 INFO - 'XPC_FLAGS': '0x0', 21:16:40 INFO - 'XPC_SERVICE_NAME': '0', 21:16:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:40 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/Djfj-6SnQIuxOUQhAa006Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0125', '--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 21:16:40 INFO - mozversion application_buildid: 20161112201320 21:16:40 INFO - mozversion application_changeset: 51b57560770b0d733148460981683fc1aeb0d284 21:16:40 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:16:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:16:40 INFO - mozversion application_name: Firefox 21:16:40 INFO - mozversion application_remotingname: firefox-dev 21:16:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:16:40 INFO - mozversion application_vendor: Mozilla 21:16:40 INFO - mozversion application_version: 51.0a2 21:16:40 INFO - mozversion platform_buildid: 20161112201320 21:16:40 INFO - mozversion platform_changeset: 51b57560770b0d733148460981683fc1aeb0d284 21:16:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:16:40 INFO - mozversion platform_version: 51.0a2 21:16:40 INFO - using testdate: 1479014200 21:16:40 INFO - actual date: 1479014200 21:16:40 INFO - starting webserver on 'localhost:50532' 21:16:40 INFO - SUITE-START | Running 2 tests 21:16:40 INFO - TEST-START | dromaeo_css 21:16:40 INFO - operating with platform_type : mac_ 21:16:40 INFO - Initialising browser for dromaeo_css test... 21:16:40 INFO - TEST-INFO | started process 1948 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmpjQ5W43/profile http://localhost:50532/getInfo.html) 21:16:43 INFO - PROCESS | 1948 | __metrics Screen width/height:1600/1200 21:16:43 INFO - PROCESS | 1948 | colorDepth:24 21:16:43 INFO - PROCESS | 1948 | Browser inner width/height: 1024/689 21:16:43 INFO - PROCESS | 1948 | __metrics 21:16:43 ERROR - PROCESS | 1948 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 21:16:44 INFO - TEST-INFO | 1948: exit 0 21:16:44 INFO - Browser initialized. 21:16:44 INFO - Running cycle 1/1 for dromaeo_css test... 21:16:44 INFO - TEST-INFO | started process 1951 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmpjQ5W43/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:16:56 INFO - PROCESS | 1951 | RSS: Main: 225726464 21:16:56 INFO - PROCESS | 1951 | 21:17:45 INFO - PROCESS | 1951 | 1479014265864 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] 21:19:59 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:50532/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50532/tests/dromaeo/cssquery-ext.html) 21:20:00 INFO - PROCESS | 1951 | RSS: Main: 234610688 21:20:00 INFO - PROCESS | 1951 | 21:23:02 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:50532/tests/dromaeo/cssquery-ext.html (next: http://localhost:50532/tests/dromaeo/cssquery-jquery.html) 21:23:03 INFO - PROCESS | 1951 | RSS: Main: 248320000 21:23:03 INFO - PROCESS | 1951 | 21:26:05 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:50532/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50532/tests/dromaeo/cssquery-mootools.html) 21:26:06 INFO - PROCESS | 1951 | RSS: Main: 251318272 21:26:06 INFO - PROCESS | 1951 | 21:29:08 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:50532/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50532/tests/dromaeo/cssquery-prototype.html) 21:29:08 INFO - PROCESS | 1951 | RSS: Main: 251437056 21:29:08 INFO - PROCESS | 1951 | 21:32:11 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:50532/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50532/tests/dromaeo/cssquery-yui.html) 21:32:12 INFO - PROCESS | 1951 | RSS: Main: 256131072 21:32:12 INFO - PROCESS | 1951 | 21:35:14 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:50532/tests/dromaeo/cssquery-yui.html (next: http://localhost:50532/tests/dromaeo/cssquery-dojo.html) 21:35:15 INFO - PROCESS | 1951 | RSS: Main: 257724416 21:35:15 INFO - PROCESS | 1951 | 21:35:15 INFO - PROCESS | 1951 | __start_tp_report 21:35:15 INFO - PROCESS | 1951 | _x_x_mozilla_page_load 21:35:15 INFO - PROCESS | 1951 | _x_x_mozilla_page_load_details 21:35:15 INFO - PROCESS | 1951 | |i|pagename|runs| 21:35:15 INFO - PROCESS | 1951 | |0;dojo.html;2910.0687779910436;3410.4884267359903;3433.433483475226;3439.1058324835535;3459.6540345965423;5822.505087067599;5885.705714714263;5901.3508514063415;5919.83288940417;5953.3748956359495;4673.112108699344;5071.644984851062;5845.035569131099;5846.853828654286;5906.793262235823;5307.73461326934;5350.8394748157425;5360.115580929142;5391.353037635489;5421.891562168754;4795.352627395292;5120.641555091145;5381.946180538183;5404.32445944257;5424.294841670578;4504.076664283831;5295.258663787054;5316.574674026088;5393.002294575516;5406.783728650849;5297.761600727977;5310.946890531084;5339.65292256006;5340.519353258186;5372.355317361902;4362.541933097043;5252.474752524717;5363.249145119687;5366.9463305366835;5455.18172274162;5522.447755224485;5731.168980497846;5951.2858456985;5959.821205363846;6024.48791852693;5096.821611243588;5097;6212.223472065992;6220.129181914535;6220.377962203788;6274.215723034621;6291.874162516724;6332.398422149889;6337.936620633827;6353.777617783356;5974.820755377345;6021;6058.969705151534;6063.363346848606;6078.361772013964;6375;6469.191351081115;6478.773242936474;6487.448566871774;6488.708008139551;6178.165947597017;6232.657203853741;6262.718177681924;6263.592866463665;6266.154069200691;6146.58628515444;6173.259208894871;6205.782797602063;6299.842503937347;6306.873862522815;6145.5698101133385;6196.535259855529;6212.347703491158;6244.094606282064;6262.937370626327;6242.843928901723;6253.312135665074;6286.371362863769;6303.991361382157;6338.778142764981;4924.704517728947;4995.625328100407;5023.372078490189;5044.117279476077;5054.570361519239;4448.488423831236;4455.821767129279;4461.709988850715;4480.260756975128;4586.220342541776;6009.579329446897;6048.667323297261;6108.419700128569;6113.052476866093;6120.051392034242;6184.072389141575;6297.27581328144;6316.336784637639;6323.27282362525;6328.746850125944;5942.346341902387;6028.457438830526;6064.666443345658;6112.633242005494;6127.662978536134;5491.945080549223;5525.475079867406;5537.446255374431;5543.861403464945;5552.139418390156;6412.743490260431;6441.066045423481;6488.188976377953;6511.38141876521;6535.771248006297;6226.283977342482;6236.844078897882;6238.594491358047;6260.7495700171485;6304.369563043842;6490.350964903472;6499.610023398611;6506.056621789909;6516.380943810331;6517.804465866032;4673.789679464364;6000.639961602318;6090.6905015420125;6326.683665816783;6331;6120.204373431426;6148.893199224182;6222.253329600477;6227.844303892439;6295.307516173309;5717.514011309086;6190.566660333733;6239.188905442445;6249.406306400884;6258.249010118633;5170.405403378509;5426.810061647823;6197.163382943245;6232.647009065698;6252.9062064069985;5396.4333744957785;5842.620229685057;5907.232059832194;6008.188894499362;6064.636121832704;6161.353057928853;6167.6916154193;6177.413145751147;6237.781677641261;6258.374162583706;6034.24571928509;6106.3089915548935;6108.821145689858;6109.465396926316;6119.479844213113 21:35:15 INFO - PROCESS | 1951 | |1;ext.html;495.3263561556283;519.9792008319668;525.6819624127403;530.4668807848112;537.3712756075391;40571.59428405719;42659.78670106649;42660.36009459857;42716;42751.78624106875;43091;43582.78208608952;43627.78186109065;43735.78132109343;43798;9882.357646752975;10044.24668149888;10046.648367307145;10064.194864410829;10068;8794.252488538483;9624.615015399411;9892.802143957117;9930;10017.14854237387;9952.5521351539;9953.502324883726;9954.65158719445;9982.301238913278;9997.15024222942;9923.454210018446;9960.950195248977;9964.850527242097;9970.700878973643;9984.051515106054;9784.461854597994;9862.211023118205;9871.2103031758;9872.259580531489;9876.80246395068;41056;41103.794481027704;41179.58820411788;41335.379969300484;41573;3247.334296469242;3375.088726043979;3411.710004649608;3421.349943510725;3831.6934645228316;30810.691893081006;31407.528887066714;31470.37059258825;31512.842435787905;31944.041678749676;3185.824779637119;3216.549683044376;3315.784474009206;3322.5182348559324;3322.5182348559565;501127;505259;507134;509229;511929;62196;62627.68686156631;62902.68548657227;63023;63132.68433657802;35531.28937421237;36855.63144368522;36910.26179476395;65206;65438.01842972359;16963.406280780113;17299.74050389245;17478.213480393413;17496.300147993938;17502.649947001242;13039.282839443731;13192.604221873358;13290.667733306746;13292.601221963163;13298.667533311746;19124.685449252644;19585.1186696599;19601.82389056661;19714;19834.60330793405;6739.59562426256;8165.305948994283;8194.09864914859;8195.664235692799;8215.465994710325;853.568947681417;963.4171326347599;980.5195454227377;988.7132731507926;1015.9586423915546;31034.91377801811;31055.68944310573;31057.844710776302;31144.065678029696;31265.687343126734;875.2517096317567;945.112680760284;954.5990683912773;972.3825370889394;978.6330126202674;15451.613709657124;16044.43844465438;16058.116803575915;16198;16305.510438537633;551756;673888;674885;677224;678063;58990.11514827281;59318;59444.405555943886;59449.40550594525;59548.40451595429;1324.5628942448968;1329.9667508312175;1345.3340596404646;1349.4197495077015;1357.0636260979893;29015.85492072526;29900.551491728078;30051.69948300489;30305;30679.539806902467;51870;52102.655380508724;52138;52175.73912130415;52240.47759522356;629707;631731;632315;632503;633079;27058.458830823667;27225.455490889675;27387.589186162622;27476.862615686794;27752.8612356945;47206;47865.5213447875;47996.760016199696;48607.5139248603;48807.267890980955;39163;39466.40800388054;39620.41518339234;39730.00674983148;41163.76508704744;32268.031959041266;38419.6158038416;40187.59812401838;40462.797686011385;40647.18705625812;39136.804315979374;39256.21487570176;39999.80000099981;40077;41509.1698166041;32728.836355818068;35793;36331.636683633886;36416.72541461036;36435.90692279236;26380.736192638597;26545.867270663523;26773.330666733487;26844.463110738066;27178.72821271762 21:35:15 INFO - PROCESS | 1951 | |2;jquery.html;299.61649089165866;372.5417736184493;376.55002272284634;385.21800744488695;401.9176068905875;19145.904270478644;19913.800861991393;20422.795772042275;20610;20827.791722082773;19149.712754308697;19538.31615893444;19744.308949186783;19884.50288742782;19896.303629372975;4676.672632915697;5074.441811400761;5221.556167725729;5366.087765079946;5535.750891209906;5137.152369858969;5323.574114070865;5346.812861549846;5471.179323101527;5475.0418676731615;5437.401885792559;5455.754491047913;5466.9179962300595;5485.533729632966;5992.250968628921;5988.041913293874;5988.1317209004665;6035.245594300713;6057.30341010785;6059.787907423219;5161.096808058574;5180.481951804827;5290;5307.416184219733;5361.035013697533;12774.297413642245;12951.935240323737;13113.803292950613;13183.736325273441;13235.272060036694;2200.0869639099756;2205.547862688145;2398.136670798511;2674.1843737660006;2694.5553983592686;9970.70087897357;10370.429626370547;11011.83482247767;15107.622309442242;15123.319450624638;1782.4296225207938;1874.4189301316499;1910.5319196796875;1970.8620396572246;1973.3586584360141;85907;95230;118965.8103418972;122457;132075.6792432073;11737.35444550558;11764.823527647091;11804.17370784037;11819.468123934443;11835;11958.342291173894;14537.273136343352;14631.85368146305;14827.258637068104;14848.5545433635;8468.915310846813;8674.826503469896;8764.8685269721;8808.986966498807;8848.849649545518;8732.694355697648;8755.212030917248;8769.561521923879;8933.731988040368;8957.507337096522;4541.818327266872;4603.355530225771;4613.284940834176;4628.328892310664;4677.204875171229;1789.1143883777613;1797.2721047975328;1820.390169293275;1864.6736821056531;1986.2849374225268;932.7388331267256;956.7703751099685;958.5638534466801;989.3223142147508;1022.1618273016204;17618.735718964224;23000.424989375064;23059.538809223723;23068.4232894179;23071.53856922852;869.7347309070794;882.3867412148495;943.1370296178919;955.9761005974767;987.8814542254976;8925;9962.452065136342;11203.047740941949;11209.271397359145;11604.941975290238;632548;640088;642166;642689;647450;141624;146915;148053;148308;150839;1028.93311934724;1033.4574348467115;1035.4615599888016;1054.093479607537;1055.984160237597;18575.628487429905;19200.71198931989;19373.903130484257;19383.709244361064;19468.902655486632;42147.513308665904;50914;51531;54992.17511737407;59202;79972.60013699894;81457.59271203843;81824;82019.7697034533;83530;4724.929126063181;5509.834704958857;6472.546921715623;6986.9650651746415;7137.393321567725;12379.071569632493;12959.287239201558;13029.08796384282;13170.670733231746;13374.732505350034;9630.903690963281;9843;10718.196135289729;10953.068989136013;11392.031677307521;5584.525315348241;6216.160818289473;9760.121589057018;11467;11526.711832204262;11323.490442929924;11388.715282117682;11416.885831141582;11476.081913446737;11476.598319058792;6966.79099627012;6993.825154371181;7418.740344087931;7450.813729656802;7483.401327893646;9324.815057168818;11227.38249396291;11523;11645.76708465843;11672.358020308964 21:35:15 INFO - PROCESS | 1951 | |3;mootools.html;1481.0891301849363;1536.162791278753;1683.882128251023;1747.0303981290388;1820.3173809821317;7957.801054973628;8215.26062654361;8437.578121093951;9009.369344145913;9047.909520904788;8332.416730828829;8720.171583699539;8739.431936924111;8757.343199260049;8779.604917778699;2344.6365813298967;2378.7264464586533;2401.8438801477937;2404.5431368040104;2410.6143017117265;2350.8707021113833;2386;2389.8924548395275;2400.087966572709;2400.195934361982;2001.3395579458743;2375.180562705864;2389.6057150570223;2409.783119519243;2417.540667273221;2349.3891588187025;2359.504504054151;2367.8816059197056;2374.691290132289;2380.166941570445;2346.8709220992837;2361.8819059046978;2371.7153941526954;2374.169040835711;2376.9881150594138;8284.420090593661;8471.576421178977;8492.490450572923;8500.277476414512;8543.829123417498;5260.263563101169;5396.703181325026;5404.027275090482;5417.079096553595;5422.701751403672;3110.860011299497;3588.982055089708;3613.1689711366535;3643.981780091109;3656.213914008501;971.6647756523988;1075.8655168103987;1085.9294145880572;1122.5902545570889;1133.104847170734;11071.446427678584;11143.72140696489;11250.324980501115;11313.830292545701;11332.603358882481;4024.738392004569;4245.80893859777;4640.373549570765;4797.088553174955;4841.588464980446;9807.411555306704;9854.556544955494;9859.75350616226;9875.703728888146;9896.960819113889;5281.815136470205;5339.41266460689;5340.813071542478;5343.625946183807;5385.973070134624;3940.1331707024983;4058.6955978301744;4623.329617205486;4855.980244148697;4865.781039853215;4036.091879327128;4040.7979601019833;4143.7928103594695;4171.457710497616;4178.770167640809;1287.976059033071;1312.2061153002487;1317.7562151001903;1323.265587598892;1328.7807511760645;652.6051738698114;819.2913130142384;891.4205766251988;930.5812384426899;933.0715937641954;5047.899042019139;5752.13717942312;5823.126531020381;5979.1629171915965;6128.509719222451;749.5802350683525;906.3157316226338;907.0702529906898;937.1986951156799;974.1476208317722;3309.834508274577;3803.1062700265416;3998.7200895937585;4035.778032208198;4135;10520.473976301155;10731.409772462433;10732.195085368628;10739.355638661706;10762.300450470695;10626.94686526578;10671.35971841692;10682.78634427307;10710.357378557312;10750.731231719114;7795.493292936055;8247.546384948766;8277.379196560281;8279.58602069894;8291.95854020726;4510.774461276857;5073.086844367902;5890;5971.58198926071;5974.940250597612;7297;8008.399370047387;8230.958845205736;9508.809823803624;10217.846732299171;8476.576171191293;9833.852492212765;9888.110070093726;9938.453385063602;10007.949960250153;6984.546004509691;7095.219525852255;7187.604681742554;7219.386352160125;7421.8144546386775;8394.538300393537;8520.957395212985;8530.829383412172;8539.82920341602;8553.61508732121;7351.522151060164;7412.9992451018425;7451;7472.991146195412;7540.095188577406;7237.601931893796;7378.852422951403;7402.074740657418;7408;7424.814379640552;6204.968975155095;6949.65251737401;7046.753363632249;7124.3944264738075;7137.678804453708;4779.4742578317055;4801.807927682854;4804.2073057945045;4825.951740482691;4868.829590964441;4639.30410438437;4744.644151688706;4949.950500494949;5080.542751152414;5121.462246464217 21:35:15 INFO - PROCESS | 1951 | |4;prototype.html;299.8380874327863;299.98950036748704;302.5703501028539;307.60011984420254;312.34719436377964;4024.517057953046;5296.443873393291;5364.275822763926;5398.109311963526;5510.421405752399;4372.409724687166;5100.77046532906;5236.397814251362;5460.6177567570285;5483.533899618537;3945.8618948336816;4160.958390416103;4165.416841642173;4183.832646694129;4197.559256278093;3749.531308586427;3852.383618621021;4139.9793001035105;4142.316517774563;4230.894227644303;3233.676632336759;3398.8640454381793;4107.732997355177;4116.850609283901;4142.627163555279;3385.695287424119;3893.7079719020903;4133.937990930139;4155.2728272552185;4160.687948403852;3028.803127796686;3523.3305671922253;3559.715222782171;3583.677469027774;3584.7849129052343;5061.2661164131;5362.436944120889;5364.463553644643;5418.91871621926;5500.559955203574;3948.763074215556;4291;4363.3018717005125;4725.243960966229;4729.533844508213;4772.570468657837;5080;5567.248421463091;5760.567957403169;5798.985177593946;3749.6625303722794;3788.71681415928;3869.8839034829;3878.5733569307354;3914.2562913046713;5227.386306846577;5583.162525621149;6028.849278768066;6064.696765161724;6105.389461053904;3414.3342048300838;3431.553897993245;3738.813059347076;3837.2517359115263;3936.7441116327345;3172.0642410488963;3365.192353835062;3962.920741585152;3977.7016723745833;4029.294873397144;3976.699339548168;4116.127162141279;4672.7570766032495;4681.859544213679;4698.275000499702;4369.3227549729845;5128.384558864021;5217.295665085165;5588.9720551397795;5872.941270587325;1146.3351256271342;1270.2568997136593;1317.5191055264759;1329.9933500332436;1366.3236697834636;861.4142383179499;888.6667499687617;905.8278927003848;912.977175570616;914.401067300919;5368.4631536846;5446.183072539151;5447.237386765856;5463.448758307053;5465.371482279509;5849;5853.678047707332;5856.502197313191;5872.618279811799;5964.135200395918;5149.536541711264;5182.352205974254;5384.461553844584;5430.2531253435;5432.864178395572;2157.62990501033;2402.9879850600637;2524.9873750631127;2570.151849889532;2606.543854825398;4309.461317335333;4896.804127834918;5078.060558796635;5079.339685840817;5103.8724031898755;4352.325389564622;4365.804692416014;4402.933955990663;4468;5082.796688132507;4538.434240187196;4891.853244402745;4955.4548999610015;5096.872578185575;5203.609729270244;4170.97811036298;4312.072904325585;4873.561379475864;4947.3073769671555;5001.624878134082;4377.649788016887;4602.723836569817;4728.905421891612;4867.805287788448;4906.258278311148;4502.977485112553;4556.567126123013;5118.769655365592;5131.3842338918075;5161.612879034013;3425.899560897392;3436.7766095203733;3439.518467414514;3459.823659955627;3477.8434970425888;4585.6102231310715;4809.591184749335;5005.549500544968;5009.966976583885;5073.59411247092;5647.435256474319;5855.092460668603;5893.882122357614;5946.643201407929;5969.582129251085;5217.739113044408;5743.1385292206505;5897.587168898308;5929.940700592939;6075;4386.6223008282805;5233.476652334736;5344.171653393731;5452.645578037414;5742.497076783243;5051.4695956924;5067.23991401278;5391.568674505952;5511.751971161388;5946.226990491382;4789.281607758725;5284.497972692588;5714.714264286686;5821.854453638523;5833.883322333614 21:35:15 INFO - PROCESS | 1951 | |5;yui.html;718.787957552522;730.9086364204476;768.0322793280465;768.2509553185648;789.8499285135828;15010.174440405774;15238.314275857585;15680.607984800386;15725.056496610197;15944.362225510966;14130.364133613986;14399.424023039066;14404.41551429342;14415.990880638334;14463.638409039779;675.1021141881287;703.3775109028495;837.9036410812759;877.5480627476854;887.6493784954939;784.4822417204646;860.2558786649535;871.3987348729388;883.7878909061843;888.4092078767612;913.2921985461287;926.7173512078813;939.4034787909658;939.8590211468266;944.3625552751865;908.3278374003256;910.9544522773868;919.2508105893676;931.4364809290383;933.8412469880137;689.9103116594861;693.2893783871522;694.8818700820822;699.2972063076576;699.5837476701405;14875.925620371938;14952.700945981129;14980.775288370683;14995.250237488082;14999.700005999819;14498.71002579953;14601.70796584073;14623.63440913975;14663.266836658124;14846.925765371105;11171.106311495061;11558.711032224177;11672.824907626393;11674.29954202742;12118.697032574168;3487.9361794652623;3699.0567405311745;3743.5320584926885;3861.0733423978045;3882.2817778710746;115221;116067;120059.39970300092;125258.37370813178;126266.10600840994;10472.633457829092;10767.515461804081;10890.782184356269;10940.03767946471;11271.211015228855;23231.651525227135;23238.65142022871;23334.64998025031;23343.949522271538;23706.644400334008;7769.572673503011;7966.482178658484;7987.800304992422;8084.797880052928;8187.0994190638985;4443.200223959719;4452.933206001848;4648.1168577970075;4689.179393606105;4738;3525.2949410117567;3609.5307610011055;3636.9272614547563;3642.85428582859;3645.2345007548183;533.5278278723358;632.8133200705803;647.1942431672504;651.46905272203;663.6714826161082;567.7274908044162;568.1109064314335;605.8969975104243;656.3141517114626;671.4359937652298;8724.171203735636;9156.267498600097;10261.58953641846;10268.64059757905;10348.430836304076;505.87858913860407;660.0956689335641;665.2250128600224;678.8506528563709;681.4139839737821;4121.29937910556;4147.585241475888;4732.95267047332;4777.259524773665;4810.6151507879285;99127.50436247773;99192.5040374808;155111;157677;176175;127161;130938.34530827285;139290;143661;146286;76758.61620691861;85015;97342.99999999859;102631;113263.86736132533;8796.252318552739;9178.632854685738;9201.723948281562;9226.769330766516;9306.674266400643;50868;61835.38164618296;64630.353696462436;65458.34541654713;66791.66604167143;86016;99141.50429247807;99411;103368.48315758373;106484.9351506475;12811.10322277469;13052.15161014531;13127.343632818513;13256;13498.662533436349;14162.433502659778;14601.707965840837;14790.260486975392;15257.6185595361;15883.920580397024;12921.870781292067;13534.526291579747;14401.855981440052;14645.414183432544;14841.183734894685;11510.53957841677;13557.134275600582;14059.325072711767;14186.503472378417;14345.139291642536;13331.600051998455;13370.799438008244;13417.530386436429;13689.520866770014;13917;11519.942400287944;11538.192326537062;11748.765024699287;11791.938725514745;12058.336791476553;11536.307821530734;11616.244944078608;11881;11885.405729713653;11888.405579721153 21:35:15 INFO - PROCESS | 1951 | __end_tp_report 21:35:15 INFO - PROCESS | 1951 | __start_cc_report 21:35:15 INFO - PROCESS | 1951 | _x_x_mozilla_cycle_collect,355 21:35:15 INFO - PROCESS | 1951 | __end_cc_report 21:35:15 INFO - PROCESS | 1951 | __startTimestamp1479015315159__endTimestamp 21:35:15 INFO - PROCESS | 1951 | 21:35:15 INFO - PROCESS | 1951 | ------- Summary: start ------- 21:35:15 INFO - PROCESS | 1951 | Number of tests: 6 21:35:15 INFO - PROCESS | 1951 | 21:35:15 INFO - PROCESS | 1951 | [#0] dojo.html Cycles:165 Average:5795.56 Median:6078.36 stddev:687.46 (11.3%) stddev-sans-first:651.24 21:35:15 INFO - PROCESS | 1951 | Values: 2910.1 3410.5 3433.4 3439.1 3459.7 5822.5 5885.7 5901.4 5919.8 5953.4 4673.1 5071.6 5845.0 5846.9 5906.8 5307.7 5350.8 5360.1 5391.4 5421.9 4795.4 5120.6 5381.9 5404.3 5424.3 4504.1 5295.3 5316.6 5393.0 5406.8 5297.8 5310.9 5339.7 5340.5 5372.4 4362.5 5252.5 5363.2 5366.9 5455.2 5522.4 5731.2 5951.3 5959.8 6024.5 5096.8 5097.0 6212.2 6220.1 6220.4 6274.2 6291.9 6332.4 6337.9 6353.8 5974.8 6021.0 6059.0 6063.4 6078.4 6375.0 6469.2 6478.8 6487.4 6488.7 6178.2 6232.7 6262.7 6263.6 6266.2 6146.6 6173.3 6205.8 6299.8 6306.9 6145.6 6196.5 6212.3 6244.1 6262.9 6242.8 6253.3 6286.4 6304.0 6338.8 4924.7 4995.6 5023.4 5044.1 5054.6 4448.5 4455.8 4461.7 4480.3 4586.2 6009.6 6048.7 6108.4 6113.1 6120.1 6184.1 6297.3 6316.3 6323.3 6328.7 5942.3 6028.5 6064.7 6112.6 6127.7 5491.9 5525.5 5537.4 5543.9 5552.1 6412.7 6441.1 6488.2 6511.4 6535.8 6226.3 6236.8 6238.6 6260.7 6304.4 6490.4 6499.6 6506.1 6516.4 6517.8 4673.8 6000.6 6090.7 6326.7 6331.0 6120.2 6148.9 6222.3 6227.8 6295.3 5717.5 6190.6 6239.2 6249.4 6258.2 5170.4 5426.8 6197.2 6232.6 6252.9 5396.4 5842.6 5907.2 6008.2 6064.6 6161.4 6167.7 6177.4 6237.8 6258.4 6034.2 6106.3 6108.8 6109.5 6119.5 21:35:15 INFO - PROCESS | 1951 | 21:35:15 INFO - PROCESS | 1951 | [#1] ext.html Cycles:180 Average:72827.78 Median:41171.68 stddev:160666.84 (390.2%) stddev-sans-first:161025.76 21:35:15 INFO - PROCESS | 1951 | Values: 495.3 520.0 525.7 530.5 537.4 40571.6 42659.8 42660.4 42716.0 42751.8 43091.0 43582.8 43627.8 43735.8 43798.0 9882.4 10044.2 10046.6 10064.2 10068.0 8794.3 9624.6 9892.8 9930.0 10017.1 9952.6 9953.5 9954.7 9982.3 9997.2 9923.5 9961.0 9964.9 9970.7 9984.1 9784.5 9862.2 9871.2 9872.3 9876.8 41056.0 41103.8 41179.6 41335.4 41573.0 3247.3 3375.1 3411.7 3421.3 3831.7 30810.7 31407.5 31470.4 31512.8 31944.0 3185.8 3216.5 3315.8 3322.5 3322.5 501127.0 505259.0 507134.0 509229.0 511929.0 62196.0 62627.7 62902.7 63023.0 63132.7 35531.3 36855.6 36910.3 65206.0 65438.0 16963.4 17299.7 17478.2 17496.3 17502.6 13039.3 13192.6 13290.7 13292.6 13298.7 19124.7 19585.1 19601.8 19714.0 19834.6 6739.6 8165.3 8194.1 8195.7 8215.5 853.6 963.4 980.5 988.7 1016.0 31034.9 31055.7 31057.8 31144.1 31265.7 875.3 945.1 954.6 972.4 978.6 15451.6 16044.4 16058.1 16198.0 16305.5 551756.0 673888.0 674885.0 677224.0 678063.0 58990.1 59318.0 59444.4 59449.4 59548.4 1324.6 1330.0 1345.3 1349.4 1357.1 29015.9 29900.6 30051.7 30305.0 30679.5 51870.0 52102.7 52138.0 52175.7 52240.5 629707.0 631731.0 632315.0 632503.0 633079.0 27058.5 27225.5 27387.6 27476.9 27752.9 47206.0 47865.5 47996.8 48607.5 48807.3 39163.0 39466.4 39620.4 39730.0 41163.8 32268.0 38419.6 40187.6 40462.8 40647.2 39136.8 39256.2 39999.8 40077.0 41509.2 32728.8 35793.0 36331.6 36416.7 36435.9 26380.7 26545.9 26773.3 26844.5 27178.7 21:35:15 INFO - PROCESS | 1951 | 21:35:15 INFO - PROCESS | 1951 | [#2] jquery.html Cycles:180 Average:36189.75 Median:336.08 stddev:107132.58 (31877.2%) stddev-sans-first:107399.22 21:35:15 INFO - PROCESS | 1951 | Values: 299.6 372.5 376.6 385.2 401.9 19145.9 19913.8 20422.8 20610.0 20827.8 19149.7 19538.3 19744.3 19884.5 19896.3 4676.7 5074.4 5221.6 5366.1 5535.8 5137.2 5323.6 5346.8 5471.2 5475.0 5437.4 5455.8 5466.9 5485.5 5992.3 5988.0 5988.1 6035.2 6057.3 6059.8 5161.1 5180.5 5290.0 5307.4 5361.0 12774.3 12951.9 13113.8 13183.7 13235.3 2200.1 2205.5 2398.1 2674.2 2694.6 9970.7 10370.4 11011.8 15107.6 15123.3 1782.4 1874.4 1910.5 1970.9 1973.4 85907.0 95230.0 118965.8 122457.0 132075.7 11737.4 11764.8 11804.2 11819.5 11835.0 11958.3 14537.3 14631.9 14827.3 14848.6 8468.9 8674.8 8764.9 8809.0 8848.8 8732.7 8755.2 8769.6 8933.7 8957.5 4541.8 4603.4 4613.3 4628.3 4677.2 1789.1 1797.3 1820.4 1864.7 1986.3 932.7 956.8 958.6 989.3 1022.2 17618.7 23000.4 23059.5 23068.4 23071.5 869.7 882.4 943.1 956.0 987.9 8925.0 9962.5 11203.0 11209.3 11604.9 632548.0 640088.0 642166.0 642689.0 647450.0 141624.0 146915.0 148053.0 148308.0 150839.0 1028.9 1033.5 1035.5 1054.1 1056.0 18575.6 19200.7 19373.9 19383.7 19468.9 42147.5 50914.0 51531.0 54992.2 59202.0 79972.6 81457.6 81824.0 82019.8 83530.0 4724.9 5509.8 6472.5 6987.0 7137.4 12379.1 12959.3 13029.1 13170.7 13374.7 9630.9 9843.0 10718.2 10953.1 11392.0 5584.5 6216.2 9760.1 11467.0 11526.7 11323.5 11388.7 11416.9 11476.1 11476.6 6966.8 6993.8 7418.7 7450.8 7483.4 9324.8 11227.4 11523.0 11645.8 11672.4 21:35:15 INFO - PROCESS | 1951 | 21:35:15 INFO - PROCESS | 1951 | [#3] mootools.html Cycles:180 Average:5603.82 Median:5060.49 stddev:3112.39 (61.5%) stddev-sans-first:3105.70 21:35:15 INFO - PROCESS | 1951 | Values: 1481.1 1536.2 1683.9 1747.0 1820.3 7957.8 8215.3 8437.6 9009.4 9047.9 8332.4 8720.2 8739.4 8757.3 8779.6 2344.6 2378.7 2401.8 2404.5 2410.6 2350.9 2386.0 2389.9 2400.1 2400.2 2001.3 2375.2 2389.6 2409.8 2417.5 2349.4 2359.5 2367.9 2374.7 2380.2 2346.9 2361.9 2371.7 2374.2 2377.0 8284.4 8471.6 8492.5 8500.3 8543.8 5260.3 5396.7 5404.0 5417.1 5422.7 3110.9 3589.0 3613.2 3644.0 3656.2 971.7 1075.9 1085.9 1122.6 1133.1 11071.4 11143.7 11250.3 11313.8 11332.6 4024.7 4245.8 4640.4 4797.1 4841.6 9807.4 9854.6 9859.8 9875.7 9897.0 5281.8 5339.4 5340.8 5343.6 5386.0 3940.1 4058.7 4623.3 4856.0 4865.8 4036.1 4040.8 4143.8 4171.5 4178.8 1288.0 1312.2 1317.8 1323.3 1328.8 652.6 819.3 891.4 930.6 933.1 5047.9 5752.1 5823.1 5979.2 6128.5 749.6 906.3 907.1 937.2 974.1 3309.8 3803.1 3998.7 4035.8 4135.0 10520.5 10731.4 10732.2 10739.4 10762.3 10626.9 10671.4 10682.8 10710.4 10750.7 7795.5 8247.5 8277.4 8279.6 8292.0 4510.8 5073.1 5890.0 5971.6 5974.9 7297.0 8008.4 8231.0 9508.8 10217.8 8476.6 9833.9 9888.1 9938.5 10007.9 6984.5 7095.2 7187.6 7219.4 7421.8 8394.5 8521.0 8530.8 8539.8 8553.6 7351.5 7413.0 7451.0 7473.0 7540.1 7237.6 7378.9 7402.1 7408.0 7424.8 6205.0 6949.7 7046.8 7124.4 7137.7 4779.5 4801.8 4804.2 4826.0 4868.8 4639.3 4744.6 4950.0 5080.5 5121.5 21:35:15 INFO - PROCESS | 1951 | 21:35:15 INFO - PROCESS | 1951 | [#4] prototype.html Cycles:180 Average:4381.07 Median:4838.70 stddev:1368.81 (28.3%) stddev-sans-first:1337.94 21:35:15 INFO - PROCESS | 1951 | Values: 299.8 300.0 302.6 307.6 312.3 4024.5 5296.4 5364.3 5398.1 5510.4 4372.4 5100.8 5236.4 5460.6 5483.5 3945.9 4161.0 4165.4 4183.8 4197.6 3749.5 3852.4 4140.0 4142.3 4230.9 3233.7 3398.9 4107.7 4116.9 4142.6 3385.7 3893.7 4133.9 4155.3 4160.7 3028.8 3523.3 3559.7 3583.7 3584.8 5061.3 5362.4 5364.5 5418.9 5500.6 3948.8 4291.0 4363.3 4725.2 4729.5 4772.6 5080.0 5567.2 5760.6 5799.0 3749.7 3788.7 3869.9 3878.6 3914.3 5227.4 5583.2 6028.8 6064.7 6105.4 3414.3 3431.6 3738.8 3837.3 3936.7 3172.1 3365.2 3962.9 3977.7 4029.3 3976.7 4116.1 4672.8 4681.9 4698.3 4369.3 5128.4 5217.3 5589.0 5872.9 1146.3 1270.3 1317.5 1330.0 1366.3 861.4 888.7 905.8 913.0 914.4 5368.5 5446.2 5447.2 5463.4 5465.4 5849.0 5853.7 5856.5 5872.6 5964.1 5149.5 5182.4 5384.5 5430.3 5432.9 2157.6 2403.0 2525.0 2570.2 2606.5 4309.5 4896.8 5078.1 5079.3 5103.9 4352.3 4365.8 4402.9 4468.0 5082.8 4538.4 4891.9 4955.5 5096.9 5203.6 4171.0 4312.1 4873.6 4947.3 5001.6 4377.6 4602.7 4728.9 4867.8 4906.3 4503.0 4556.6 5118.8 5131.4 5161.6 3425.9 3436.8 3439.5 3459.8 3477.8 4585.6 4809.6 5005.5 5010.0 5073.6 5647.4 5855.1 5893.9 5946.6 5969.6 5217.7 5743.1 5897.6 5929.9 6075.0 4386.6 5233.5 5344.2 5452.6 5742.5 5051.5 5067.2 5391.6 5511.8 5946.2 4789.3 5284.5 5714.7 5821.9 5833.9 21:35:15 INFO - PROCESS | 1951 | 21:35:15 INFO - PROCESS | 1951 | [#5] yui.html Cycles:180 Average:24988.49 Median:3506.62 stddev:39930.81 (1138.7%) stddev-sans-first:40001.25 21:35:15 INFO - PROCESS | 1951 | Values: 718.8 730.9 768.0 768.3 789.8 15010.2 15238.3 15680.6 15725.1 15944.4 14130.4 14399.4 14404.4 14416.0 14463.6 675.1 703.4 837.9 877.5 887.6 784.5 860.3 871.4 883.8 888.4 913.3 926.7 939.4 939.9 944.4 908.3 911.0 919.3 931.4 933.8 689.9 693.3 694.9 699.3 699.6 14875.9 14952.7 14980.8 14995.3 14999.7 14498.7 14601.7 14623.6 14663.3 14846.9 11171.1 11558.7 11672.8 11674.3 12118.7 3487.9 3699.1 3743.5 3861.1 3882.3 115221.0 116067.0 120059.4 125258.4 126266.1 10472.6 10767.5 10890.8 10940.0 11271.2 23231.7 23238.7 23334.6 23343.9 23706.6 7769.6 7966.5 7987.8 8084.8 8187.1 4443.2 4452.9 4648.1 4689.2 4738.0 3525.3 3609.5 3636.9 3642.9 3645.2 533.5 632.8 647.2 651.5 663.7 567.7 568.1 605.9 656.3 671.4 8724.2 9156.3 10261.6 10268.6 10348.4 505.9 660.1 665.2 678.9 681.4 4121.3 4147.6 4733.0 4777.3 4810.6 99127.5 99192.5 155111.0 157677.0 176175.0 127161.0 130938.3 139290.0 143661.0 146286.0 76758.6 85015.0 97343.0 102631.0 113263.9 8796.3 9178.6 9201.7 9226.8 9306.7 50868.0 61835.4 64630.4 65458.3 66791.7 86016.0 99141.5 99411.0 103368.5 106484.9 12811.1 13052.2 13127.3 13256.0 13498.7 14162.4 14601.7 14790.3 15257.6 15883.9 12921.9 13534.5 14401.9 14645.4 14841.2 11510.5 13557.1 14059.3 14186.5 14345.1 13331.6 13370.8 13417.5 13689.5 13917.0 11519.9 11538.2 11748.8 11791.9 12058.3 11536.3 11616.2 11881.0 11885.4 11888.4 21:35:15 INFO - PROCESS | 1951 | -------- Summary: end -------- 21:35:15 INFO - PROCESS | 1951 | 21:35:15 INFO - TEST-INFO | 1951: exit 0 21:35:15 INFO - TEST-OK | dromaeo_css | took 1114856ms 21:35:15 INFO - TEST-START | kraken 21:35:15 INFO - operating with platform_type : mac_ 21:35:15 INFO - Initialising browser for kraken test... 21:35:15 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmpG9G6ee/profile http://localhost:50532/getInfo.html) 21:35:18 INFO - PROCESS | 1958 | __metrics Screen width/height:1600/1200 21:35:18 INFO - PROCESS | 1958 | colorDepth:24 21:35:18 INFO - PROCESS | 1958 | Browser inner width/height: 1024/689 21:35:18 INFO - PROCESS | 1958 | __metrics 21:35:18 ERROR - PROCESS | 1958 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 21:35:19 INFO - TEST-INFO | 1958: exit 0 21:35:19 INFO - Browser initialized. 21:35:19 INFO - Running cycle 1/1 for kraken test... 21:35:19 INFO - TEST-INFO | started process 1960 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmpG9G6ee/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:35:31 INFO - PROCESS | 1960 | RSS: Main: 225300480 21:35:31 INFO - PROCESS | 1960 | 21:35:34 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50532/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50532/tests/kraken/driver.html?testName=audio-beat-detection) 21:35:35 INFO - PROCESS | 1960 | RSS: Main: 238157824 21:35:35 INFO - PROCESS | 1960 | 21:35:37 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50532/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50532/tests/kraken/driver.html?testName=audio-dft) 21:35:38 INFO - PROCESS | 1960 | RSS: Main: 245694464 21:35:38 INFO - PROCESS | 1960 | 21:35:41 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50532/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50532/tests/kraken/driver.html?testName=audio-fft) 21:35:42 INFO - PROCESS | 1960 | RSS: Main: 249421824 21:35:42 INFO - PROCESS | 1960 | 21:35:44 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50532/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50532/tests/kraken/driver.html?testName=audio-oscillator) 21:35:44 INFO - PROCESS | 1960 | RSS: Main: 249970688 21:35:44 INFO - PROCESS | 1960 | 21:35:46 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50532/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50532/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:35:47 INFO - PROCESS | 1960 | RSS: Main: 249856000 21:35:47 INFO - PROCESS | 1960 | 21:35:50 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50532/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50532/tests/kraken/driver.html?testName=imaging-darkroom) 21:35:50 INFO - PROCESS | 1960 | RSS: Main: 252141568 21:35:50 INFO - PROCESS | 1960 | 21:35:54 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50532/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50532/tests/kraken/driver.html?testName=imaging-desaturate) 21:35:54 INFO - PROCESS | 1960 | RSS: Main: 252170240 21:35:54 INFO - PROCESS | 1960 | 21:35:57 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50532/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50532/tests/kraken/driver.html?testName=json-parse-financial) 21:35:58 INFO - PROCESS | 1960 | RSS: Main: 252444672 21:35:58 INFO - PROCESS | 1960 | 21:35:59 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50532/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50532/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:36:00 INFO - PROCESS | 1960 | RSS: Main: 252092416 21:36:00 INFO - PROCESS | 1960 | 21:36:02 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50532/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50532/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:36:02 INFO - PROCESS | 1960 | RSS: Main: 252174336 21:36:02 INFO - PROCESS | 1960 | 21:36:05 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50532/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50532/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:36:05 INFO - PROCESS | 1960 | RSS: Main: 252174336 21:36:05 INFO - PROCESS | 1960 | 21:36:08 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50532/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50532/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:36:09 INFO - PROCESS | 1960 | RSS: Main: 252174336 21:36:09 INFO - PROCESS | 1960 | 21:36:12 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50532/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50532/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:36:13 INFO - PROCESS | 1960 | RSS: Main: 252461056 21:36:13 INFO - PROCESS | 1960 | 21:36:14 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50532/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50532/tests/kraken/driver.html?testName=ai-astar) 21:36:15 INFO - PROCESS | 1960 | RSS: Main: 254128128 21:36:15 INFO - PROCESS | 1960 | 21:36:15 INFO - PROCESS | 1960 | __start_tp_report 21:36:15 INFO - PROCESS | 1960 | _x_x_mozilla_page_load 21:36:15 INFO - PROCESS | 1960 | _x_x_mozilla_page_load_details 21:36:15 INFO - PROCESS | 1960 | |i|pagename|runs| 21:36:15 INFO - PROCESS | 1960 | |0;ai-astar;87;168;174;141;118;134;175;155;120;120 21:36:15 INFO - PROCESS | 1960 | |1;audio-beat-detection;139;113;111;143;114;119;141;139;140;110 21:36:15 INFO - PROCESS | 1960 | |2;audio-dft;198;197;202;201;199;192;199;198;192;193 21:36:15 INFO - PROCESS | 1960 | |3;audio-fft;73;61;79;113;58;57;58;58;77;59 21:36:15 INFO - PROCESS | 1960 | |4;audio-oscillator;89;95;107;102;74;70;88;69;70;85 21:36:15 INFO - PROCESS | 1960 | |5;imaging-gaussian-blur;90;87;88;87;89;86;93;86;90;86 21:36:15 INFO - PROCESS | 1960 | |6;imaging-darkroom;96;97;96;153;110;152;106;153;153;108 21:36:15 INFO - PROCESS | 1960 | |7;imaging-desaturate;91;92;91;99;107;144;90;89;90;93 21:36:15 INFO - PROCESS | 1960 | |8;json-parse-financial;56;55;56;57;58;58;57;59;59;59 21:36:15 INFO - PROCESS | 1960 | |9;json-stringify-tinderbox;72;76;75;80;77;71;71;70;72;73 21:36:15 INFO - PROCESS | 1960 | |10;stanford-crypto-aes;102;102;108;103;86;85;87;85;85;88 21:36:15 INFO - PROCESS | 1960 | |11;stanford-crypto-ccm;139;141;152;133;149;155;157;162;207;150 21:36:15 INFO - PROCESS | 1960 | |12;stanford-crypto-pbkdf2;170;198;159;191;235;229;154;223;166;222 21:36:15 INFO - PROCESS | 1960 | |13;stanford-crypto-sha256-iterative;67;67;69;70;67;69;66;68;64;81 21:36:15 INFO - PROCESS | 1960 | __end_tp_report 21:36:15 INFO - PROCESS | 1960 | __start_cc_report 21:36:15 INFO - PROCESS | 1960 | _x_x_mozilla_cycle_collect,944 21:36:15 INFO - PROCESS | 1960 | __end_cc_report 21:36:15 INFO - PROCESS | 1960 | __startTimestamp1479015375191__endTimestamp 21:36:15 INFO - PROCESS | 1960 | 21:36:15 INFO - PROCESS | 1960 | ------- Summary: start ------- 21:36:15 INFO - PROCESS | 1960 | Number of tests: 14 21:36:15 INFO - PROCESS | 1960 | 21:36:15 INFO - PROCESS | 1960 | [#0] ai-astar Cycles:10 Average:139.20 Median:161.50 stddev:28.89 (17.9%) stddev-sans-first:23.68 21:36:15 INFO - PROCESS | 1960 | Values: 87.0 168.0 174.0 141.0 118.0 134.0 175.0 155.0 120.0 120.0 21:36:15 INFO - PROCESS | 1960 | 21:36:15 INFO - PROCESS | 1960 | [#1] audio-beat-detection Cycles:10 Average:126.90 Median:139.00 stddev:14.46 (10.4%) stddev-sans-first:14.66 21:36:15 INFO - PROCESS | 1960 | Values: 139.0 113.0 111.0 143.0 114.0 119.0 141.0 139.0 140.0 110.0 21:36:15 INFO - PROCESS | 1960 | 21:36:15 INFO - PROCESS | 1960 | [#2] audio-dft Cycles:10 Average:197.10 Median:198.50 stddev:3.60 (1.8%) stddev-sans-first:3.81 21:36:15 INFO - PROCESS | 1960 | Values: 198.0 197.0 202.0 201.0 199.0 192.0 199.0 198.0 192.0 193.0 21:36:15 INFO - PROCESS | 1960 | 21:36:15 INFO - PROCESS | 1960 | [#3] audio-fft Cycles:10 Average:69.30 Median:60.00 stddev:17.59 (29.3%) stddev-sans-first:18.61 21:36:15 INFO - PROCESS | 1960 | Values: 73.0 61.0 79.0 113.0 58.0 57.0 58.0 58.0 77.0 59.0 21:36:15 INFO - PROCESS | 1960 | 21:36:15 INFO - PROCESS | 1960 | [#4] audio-oscillator Cycles:10 Average:84.90 Median:79.50 stddev:13.84 (17.4%) stddev-sans-first:14.60 21:36:15 INFO - PROCESS | 1960 | Values: 89.0 95.0 107.0 102.0 74.0 70.0 88.0 69.0 70.0 85.0 21:36:15 INFO - PROCESS | 1960 | 21:36:15 INFO - PROCESS | 1960 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:88.50 stddev:2.30 (2.6%) stddev-sans-first:2.35 21:36:15 INFO - PROCESS | 1960 | Values: 90.0 87.0 88.0 87.0 89.0 86.0 93.0 86.0 90.0 86.0 21:36:15 INFO - PROCESS | 1960 | 21:36:15 INFO - PROCESS | 1960 | [#6] imaging-darkroom Cycles:10 Average:122.40 Median:153.00 stddev:26.57 (17.4%) stddev-sans-first:26.41 21:36:15 INFO - PROCESS | 1960 | Values: 96.0 97.0 96.0 153.0 110.0 152.0 106.0 153.0 153.0 108.0 21:36:15 INFO - PROCESS | 1960 | 21:36:15 INFO - PROCESS | 1960 | [#7] imaging-desaturate Cycles:10 Average:98.60 Median:91.00 stddev:16.87 (18.5%) stddev-sans-first:17.67 21:36:15 INFO - PROCESS | 1960 | Values: 91.0 92.0 91.0 99.0 107.0 144.0 90.0 89.0 90.0 93.0 21:36:15 INFO - PROCESS | 1960 | 21:36:15 INFO - PROCESS | 1960 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:58.00 stddev:1.43 (2.5%) stddev-sans-first:1.42 21:36:15 INFO - PROCESS | 1960 | Values: 56.0 55.0 56.0 57.0 58.0 58.0 57.0 59.0 59.0 59.0 21:36:15 INFO - PROCESS | 1960 | 21:36:15 INFO - PROCESS | 1960 | [#9] json-stringify-tinderbox Cycles:10 Average:73.70 Median:74.00 stddev:3.20 (4.3%) stddev-sans-first:3.33 21:36:15 INFO - PROCESS | 1960 | Values: 72.0 76.0 75.0 80.0 77.0 71.0 71.0 70.0 72.0 73.0 21:36:15 INFO - PROCESS | 1960 | 21:36:15 INFO - PROCESS | 1960 | [#10] stanford-crypto-aes Cycles:10 Average:93.10 Median:85.00 stddev:9.36 (11.0%) stddev-sans-first:9.36 21:36:15 INFO - PROCESS | 1960 | Values: 102.0 102.0 108.0 103.0 86.0 85.0 87.0 85.0 85.0 88.0 21:36:15 INFO - PROCESS | 1960 | 21:36:15 INFO - PROCESS | 1960 | [#11] stanford-crypto-ccm Cycles:10 Average:154.50 Median:153.50 stddev:20.44 (13.3%) stddev-sans-first:20.90 21:36:15 INFO - PROCESS | 1960 | Values: 139.0 141.0 152.0 133.0 149.0 155.0 157.0 162.0 207.0 150.0 21:36:15 INFO - PROCESS | 1960 | 21:36:15 INFO - PROCESS | 1960 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.70 Median:210.00 stddev:31.16 (14.8%) stddev-sans-first:31.74 21:36:15 INFO - PROCESS | 1960 | Values: 170.0 198.0 159.0 191.0 235.0 229.0 154.0 223.0 166.0 222.0 21:36:15 INFO - PROCESS | 1960 | 21:36:15 INFO - PROCESS | 1960 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.50 stddev:4.61 (6.7%) stddev-sans-first:4.85 21:36:15 INFO - PROCESS | 1960 | Values: 67.0 67.0 69.0 70.0 67.0 69.0 66.0 68.0 64.0 81.0 21:36:15 INFO - PROCESS | 1960 | -------- Summary: end -------- 21:36:15 INFO - PROCESS | 1960 | 21:36:15 INFO - TEST-INFO | 1960: exit 0 21:36:15 INFO - TEST-OK | kraken | took 60211ms 21:36:15 INFO - SUITE-END | took 1175s 21:36:16 INFO - Completed test suite (00:19:35) 21:36:16 INFO - javascript benchmark 21:36:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7319.855106377015, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2910.0687779910436, 3410.4884267359903, 3433.433483475226, 3439.1058324835535, 3459.6540345965423, 5822.505087067599, 5885.705714714263, 5901.3508514063415, 5919.83288940417, 5953.3748956359495, 4673.112108699344, 5071.644984851062, 5845.035569131099, 5846.853828654286, 5906.793262235823, 5307.73461326934, 5350.8394748157425, 5360.115580929142, 5391.353037635489, 5421.891562168754, 4795.352627395292, 5120.641555091145, 5381.946180538183, 5404.32445944257, 5424.294841670578, 4504.076664283831, 5295.258663787054, 5316.574674026088, 5393.002294575516, 5406.783728650849, 5297.761600727977, 5310.946890531084, 5339.65292256006, 5340.519353258186, 5372.355317361902, 4362.541933097043, 5252.474752524717, 5363.249145119687, 5366.9463305366835, 5455.18172274162, 5522.447755224485, 5731.168980497846, 5951.2858456985, 5959.821205363846, 6024.48791852693, 5096.821611243588, 5097.0, 6212.223472065992, 6220.129181914535, 6220.377962203788, 6274.215723034621, 6291.874162516724, 6332.398422149889, 6337.936620633827, 6353.777617783356, 5974.820755377345, 6021.0, 6058.969705151534, 6063.363346848606, 6078.361772013964, 6375.0, 6469.191351081115, 6478.773242936474, 6487.448566871774, 6488.708008139551, 6178.165947597017, 6232.657203853741, 6262.718177681924, 6263.592866463665, 6266.154069200691, 6146.58628515444, 6173.259208894871, 6205.782797602063, 6299.842503937347, 6306.873862522815, 6145.5698101133385, 6196.535259855529, 6212.347703491158, 6244.094606282064, 6262.937370626327, 6242.843928901723, 6253.312135665074, 6286.371362863769, 6303.991361382157, 6338.778142764981, 4924.704517728947, 4995.625328100407, 5023.372078490189, 5044.117279476077, 5054.570361519239, 4448.488423831236, 4455.821767129279, 4461.709988850715, 4480.260756975128, 4586.220342541776, 6009.579329446897, 6048.667323297261, 6108.419700128569, 6113.052476866093, 6120.051392034242, 6184.072389141575, 6297.27581328144, 6316.336784637639, 6323.27282362525, 6328.746850125944, 5942.346341902387, 6028.457438830526, 6064.666443345658, 6112.633242005494, 6127.662978536134, 5491.945080549223, 5525.475079867406, 5537.446255374431, 5543.861403464945, 5552.139418390156, 6412.743490260431, 6441.066045423481, 6488.188976377953, 6511.38141876521, 6535.771248006297, 6226.283977342482, 6236.844078897882, 6238.594491358047, 6260.7495700171485, 6304.369563043842, 6490.350964903472, 6499.610023398611, 6506.056621789909, 6516.380943810331, 6517.804465866032, 4673.789679464364, 6000.639961602318, 6090.6905015420125, 6326.683665816783, 6331.0, 6120.204373431426, 6148.893199224182, 6222.253329600477, 6227.844303892439, 6295.307516173309, 5717.514011309086, 6190.566660333733, 6239.188905442445, 6249.406306400884, 6258.249010118633, 5170.405403378509, 5426.810061647823, 6197.163382943245, 6232.647009065698, 6252.9062064069985, 5396.4333744957785, 5842.620229685057, 5907.232059832194, 6008.188894499362, 6064.636121832704, 6161.353057928853, 6167.6916154193, 6177.413145751147, 6237.781677641261, 6258.374162583706, 6034.24571928509, 6106.3089915548935, 6108.821145689858, 6109.465396926316, 6119.479844213113], "value": 5752.24939307966, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.3263561556283, 519.9792008319668, 525.6819624127403, 530.4668807848112, 537.3712756075391, 40571.59428405719, 42659.78670106649, 42660.36009459857, 42716.0, 42751.78624106875, 43091.0, 43582.78208608952, 43627.78186109065, 43735.78132109343, 43798.0, 9882.357646752975, 10044.24668149888, 10046.648367307145, 10064.194864410829, 10068.0, 8794.252488538483, 9624.615015399411, 9892.802143957117, 9930.0, 10017.14854237387, 9952.5521351539, 9953.502324883726, 9954.65158719445, 9982.301238913278, 9997.15024222942, 9923.454210018446, 9960.950195248977, 9964.850527242097, 9970.700878973643, 9984.051515106054, 9784.461854597994, 9862.211023118205, 9871.2103031758, 9872.259580531489, 9876.80246395068, 41056.0, 41103.794481027704, 41179.58820411788, 41335.379969300484, 41573.0, 3247.334296469242, 3375.088726043979, 3411.710004649608, 3421.349943510725, 3831.6934645228316, 30810.691893081006, 31407.528887066714, 31470.37059258825, 31512.842435787905, 31944.041678749676, 3185.824779637119, 3216.549683044376, 3315.784474009206, 3322.5182348559324, 3322.5182348559565, 501127.0, 505259.0, 507134.0, 509229.0, 511929.0, 62196.0, 62627.68686156631, 62902.68548657227, 63023.0, 63132.68433657802, 35531.28937421237, 36855.63144368522, 36910.26179476395, 65206.0, 65438.01842972359, 16963.406280780113, 17299.74050389245, 17478.213480393413, 17496.300147993938, 17502.649947001242, 13039.282839443731, 13192.604221873358, 13290.667733306746, 13292.601221963163, 13298.667533311746, 19124.685449252644, 19585.1186696599, 19601.82389056661, 19714.0, 19834.60330793405, 6739.59562426256, 8165.305948994283, 8194.09864914859, 8195.664235692799, 8215.465994710325, 853.568947681417, 963.4171326347599, 980.5195454227377, 988.7132731507926, 1015.9586423915546, 31034.91377801811, 31055.68944310573, 31057.844710776302, 31144.065678029696, 31265.687343126734, 875.2517096317567, 945.112680760284, 954.5990683912773, 972.3825370889394, 978.6330126202674, 15451.613709657124, 16044.43844465438, 16058.116803575915, 16198.0, 16305.510438537633, 551756.0, 673888.0, 674885.0, 677224.0, 678063.0, 58990.11514827281, 59318.0, 59444.405555943886, 59449.40550594525, 59548.40451595429, 1324.5628942448968, 1329.9667508312175, 1345.3340596404646, 1349.4197495077015, 1357.0636260979893, 29015.85492072526, 29900.551491728078, 30051.69948300489, 30305.0, 30679.539806902467, 51870.0, 52102.655380508724, 52138.0, 52175.73912130415, 52240.47759522356, 629707.0, 631731.0, 632315.0, 632503.0, 633079.0, 27058.458830823667, 27225.455490889675, 27387.589186162622, 27476.862615686794, 27752.8612356945, 47206.0, 47865.5213447875, 47996.760016199696, 48607.5139248603, 48807.267890980955, 39163.0, 39466.40800388054, 39620.41518339234, 39730.00674983148, 41163.76508704744, 32268.031959041266, 38419.6158038416, 40187.59812401838, 40462.797686011385, 40647.18705625812, 39136.804315979374, 39256.21487570176, 39999.80000099981, 40077.0, 41509.1698166041, 32728.836355818068, 35793.0, 36331.636683633886, 36416.72541461036, 36435.90692279236, 26380.736192638597, 26545.867270663523, 26773.330666733487, 26844.463110738066, 27178.72821271762], "value": 20351.61219321179, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.61649089165866, 372.5417736184493, 376.55002272284634, 385.21800744488695, 401.9176068905875, 19145.904270478644, 19913.800861991393, 20422.795772042275, 20610.0, 20827.791722082773, 19149.712754308697, 19538.31615893444, 19744.308949186783, 19884.50288742782, 19896.303629372975, 4676.672632915697, 5074.441811400761, 5221.556167725729, 5366.087765079946, 5535.750891209906, 5137.152369858969, 5323.574114070865, 5346.812861549846, 5471.179323101527, 5475.0418676731615, 5437.401885792559, 5455.754491047913, 5466.9179962300595, 5485.533729632966, 5992.250968628921, 5988.041913293874, 5988.1317209004665, 6035.245594300713, 6057.30341010785, 6059.787907423219, 5161.096808058574, 5180.481951804827, 5290.0, 5307.416184219733, 5361.035013697533, 12774.297413642245, 12951.935240323737, 13113.803292950613, 13183.736325273441, 13235.272060036694, 2200.0869639099756, 2205.547862688145, 2398.136670798511, 2674.1843737660006, 2694.5553983592686, 9970.70087897357, 10370.429626370547, 11011.83482247767, 15107.622309442242, 15123.319450624638, 1782.4296225207938, 1874.4189301316499, 1910.5319196796875, 1970.8620396572246, 1973.3586584360141, 85907.0, 95230.0, 118965.8103418972, 122457.0, 132075.6792432073, 11737.35444550558, 11764.823527647091, 11804.17370784037, 11819.468123934443, 11835.0, 11958.342291173894, 14537.273136343352, 14631.85368146305, 14827.258637068104, 14848.5545433635, 8468.915310846813, 8674.826503469896, 8764.8685269721, 8808.986966498807, 8848.849649545518, 8732.694355697648, 8755.212030917248, 8769.561521923879, 8933.731988040368, 8957.507337096522, 4541.818327266872, 4603.355530225771, 4613.284940834176, 4628.328892310664, 4677.204875171229, 1789.1143883777613, 1797.2721047975328, 1820.390169293275, 1864.6736821056531, 1986.2849374225268, 932.7388331267256, 956.7703751099685, 958.5638534466801, 989.3223142147508, 1022.1618273016204, 17618.735718964224, 23000.424989375064, 23059.538809223723, 23068.4232894179, 23071.53856922852, 869.7347309070794, 882.3867412148495, 943.1370296178919, 955.9761005974767, 987.8814542254976, 8925.0, 9962.452065136342, 11203.047740941949, 11209.271397359145, 11604.941975290238, 632548.0, 640088.0, 642166.0, 642689.0, 647450.0, 141624.0, 146915.0, 148053.0, 148308.0, 150839.0, 1028.93311934724, 1033.4574348467115, 1035.4615599888016, 1054.093479607537, 1055.984160237597, 18575.628487429905, 19200.71198931989, 19373.903130484257, 19383.709244361064, 19468.902655486632, 42147.513308665904, 50914.0, 51531.0, 54992.17511737407, 59202.0, 79972.60013699894, 81457.59271203843, 81824.0, 82019.7697034533, 83530.0, 4724.929126063181, 5509.834704958857, 6472.546921715623, 6986.9650651746415, 7137.393321567725, 12379.071569632493, 12959.287239201558, 13029.08796384282, 13170.670733231746, 13374.732505350034, 9630.903690963281, 9843.0, 10718.196135289729, 10953.068989136013, 11392.031677307521, 5584.525315348241, 6216.160818289473, 9760.121589057018, 11467.0, 11526.711832204262, 11323.490442929924, 11388.715282117682, 11416.885831141582, 11476.081913446737, 11476.598319058792, 6966.79099627012, 6993.825154371181, 7418.740344087931, 7450.813729656802, 7483.401327893646, 9324.815057168818, 11227.38249396291, 11523.0, 11645.76708465843, 11672.358020308964], "value": 9304.713604190612, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1481.0891301849363, 1536.162791278753, 1683.882128251023, 1747.0303981290388, 1820.3173809821317, 7957.801054973628, 8215.26062654361, 8437.578121093951, 9009.369344145913, 9047.909520904788, 8332.416730828829, 8720.171583699539, 8739.431936924111, 8757.343199260049, 8779.604917778699, 2344.6365813298967, 2378.7264464586533, 2401.8438801477937, 2404.5431368040104, 2410.6143017117265, 2350.8707021113833, 2386.0, 2389.8924548395275, 2400.087966572709, 2400.195934361982, 2001.3395579458743, 2375.180562705864, 2389.6057150570223, 2409.783119519243, 2417.540667273221, 2349.3891588187025, 2359.504504054151, 2367.8816059197056, 2374.691290132289, 2380.166941570445, 2346.8709220992837, 2361.8819059046978, 2371.7153941526954, 2374.169040835711, 2376.9881150594138, 8284.420090593661, 8471.576421178977, 8492.490450572923, 8500.277476414512, 8543.829123417498, 5260.263563101169, 5396.703181325026, 5404.027275090482, 5417.079096553595, 5422.701751403672, 3110.860011299497, 3588.982055089708, 3613.1689711366535, 3643.981780091109, 3656.213914008501, 971.6647756523988, 1075.8655168103987, 1085.9294145880572, 1122.5902545570889, 1133.104847170734, 11071.446427678584, 11143.72140696489, 11250.324980501115, 11313.830292545701, 11332.603358882481, 4024.738392004569, 4245.80893859777, 4640.373549570765, 4797.088553174955, 4841.588464980446, 9807.411555306704, 9854.556544955494, 9859.75350616226, 9875.703728888146, 9896.960819113889, 5281.815136470205, 5339.41266460689, 5340.813071542478, 5343.625946183807, 5385.973070134624, 3940.1331707024983, 4058.6955978301744, 4623.329617205486, 4855.980244148697, 4865.781039853215, 4036.091879327128, 4040.7979601019833, 4143.7928103594695, 4171.457710497616, 4178.770167640809, 1287.976059033071, 1312.2061153002487, 1317.7562151001903, 1323.265587598892, 1328.7807511760645, 652.6051738698114, 819.2913130142384, 891.4205766251988, 930.5812384426899, 933.0715937641954, 5047.899042019139, 5752.13717942312, 5823.126531020381, 5979.1629171915965, 6128.509719222451, 749.5802350683525, 906.3157316226338, 907.0702529906898, 937.1986951156799, 974.1476208317722, 3309.834508274577, 3803.1062700265416, 3998.7200895937585, 4035.778032208198, 4135.0, 10520.473976301155, 10731.409772462433, 10732.195085368628, 10739.355638661706, 10762.300450470695, 10626.94686526578, 10671.35971841692, 10682.78634427307, 10710.357378557312, 10750.731231719114, 7795.493292936055, 8247.546384948766, 8277.379196560281, 8279.58602069894, 8291.95854020726, 4510.774461276857, 5073.086844367902, 5890.0, 5971.58198926071, 5974.940250597612, 7297.0, 8008.399370047387, 8230.958845205736, 9508.809823803624, 10217.846732299171, 8476.576171191293, 9833.852492212765, 9888.110070093726, 9938.453385063602, 10007.949960250153, 6984.546004509691, 7095.219525852255, 7187.604681742554, 7219.386352160125, 7421.8144546386775, 8394.538300393537, 8520.957395212985, 8530.829383412172, 8539.82920341602, 8553.61508732121, 7351.522151060164, 7412.9992451018425, 7451.0, 7472.991146195412, 7540.095188577406, 7237.601931893796, 7378.852422951403, 7402.074740657418, 7408.0, 7424.814379640552, 6204.968975155095, 6949.65251737401, 7046.753363632249, 7124.3944264738075, 7137.678804453708, 4779.4742578317055, 4801.807927682854, 4804.2073057945045, 4825.951740482691, 4868.829590964441, 4639.30410438437, 4744.644151688706, 4949.950500494949, 5080.542751152414, 5121.462246464217], "value": 4523.22216392282, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.8380874327863, 299.98950036748704, 302.5703501028539, 307.60011984420254, 312.34719436377964, 4024.517057953046, 5296.443873393291, 5364.275822763926, 5398.109311963526, 5510.421405752399, 4372.409724687166, 5100.77046532906, 5236.397814251362, 5460.6177567570285, 5483.533899618537, 3945.8618948336816, 4160.958390416103, 4165.416841642173, 4183.832646694129, 4197.559256278093, 3749.531308586427, 3852.383618621021, 4139.9793001035105, 4142.316517774563, 4230.894227644303, 3233.676632336759, 3398.8640454381793, 4107.732997355177, 4116.850609283901, 4142.627163555279, 3385.695287424119, 3893.7079719020903, 4133.937990930139, 4155.2728272552185, 4160.687948403852, 3028.803127796686, 3523.3305671922253, 3559.715222782171, 3583.677469027774, 3584.7849129052343, 5061.2661164131, 5362.436944120889, 5364.463553644643, 5418.91871621926, 5500.559955203574, 3948.763074215556, 4291.0, 4363.3018717005125, 4725.243960966229, 4729.533844508213, 4772.570468657837, 5080.0, 5567.248421463091, 5760.567957403169, 5798.985177593946, 3749.6625303722794, 3788.71681415928, 3869.8839034829, 3878.5733569307354, 3914.2562913046713, 5227.386306846577, 5583.162525621149, 6028.849278768066, 6064.696765161724, 6105.389461053904, 3414.3342048300838, 3431.553897993245, 3738.813059347076, 3837.2517359115263, 3936.7441116327345, 3172.0642410488963, 3365.192353835062, 3962.920741585152, 3977.7016723745833, 4029.294873397144, 3976.699339548168, 4116.127162141279, 4672.7570766032495, 4681.859544213679, 4698.275000499702, 4369.3227549729845, 5128.384558864021, 5217.295665085165, 5588.9720551397795, 5872.941270587325, 1146.3351256271342, 1270.2568997136593, 1317.5191055264759, 1329.9933500332436, 1366.3236697834636, 861.4142383179499, 888.6667499687617, 905.8278927003848, 912.977175570616, 914.401067300919, 5368.4631536846, 5446.183072539151, 5447.237386765856, 5463.448758307053, 5465.371482279509, 5849.0, 5853.678047707332, 5856.502197313191, 5872.618279811799, 5964.135200395918, 5149.536541711264, 5182.352205974254, 5384.461553844584, 5430.2531253435, 5432.864178395572, 2157.62990501033, 2402.9879850600637, 2524.9873750631127, 2570.151849889532, 2606.543854825398, 4309.461317335333, 4896.804127834918, 5078.060558796635, 5079.339685840817, 5103.8724031898755, 4352.325389564622, 4365.804692416014, 4402.933955990663, 4468.0, 5082.796688132507, 4538.434240187196, 4891.853244402745, 4955.4548999610015, 5096.872578185575, 5203.609729270244, 4170.97811036298, 4312.072904325585, 4873.561379475864, 4947.3073769671555, 5001.624878134082, 4377.649788016887, 4602.723836569817, 4728.905421891612, 4867.805287788448, 4906.258278311148, 4502.977485112553, 4556.567126123013, 5118.769655365592, 5131.3842338918075, 5161.612879034013, 3425.899560897392, 3436.7766095203733, 3439.518467414514, 3459.823659955627, 3477.8434970425888, 4585.6102231310715, 4809.591184749335, 5005.549500544968, 5009.966976583885, 5073.59411247092, 5647.435256474319, 5855.092460668603, 5893.882122357614, 5946.643201407929, 5969.582129251085, 5217.739113044408, 5743.1385292206505, 5897.587168898308, 5929.940700592939, 6075.0, 4386.6223008282805, 5233.476652334736, 5344.171653393731, 5452.645578037414, 5742.497076783243, 5051.4695956924, 5067.23991401278, 5391.568674505952, 5511.751971161388, 5946.226990491382, 4789.281607758725, 5284.497972692588, 5714.714264286686, 5821.854453638523, 5833.883322333614], "value": 3952.8002230595457, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.787957552522, 730.9086364204476, 768.0322793280465, 768.2509553185648, 789.8499285135828, 15010.174440405774, 15238.314275857585, 15680.607984800386, 15725.056496610197, 15944.362225510966, 14130.364133613986, 14399.424023039066, 14404.41551429342, 14415.990880638334, 14463.638409039779, 675.1021141881287, 703.3775109028495, 837.9036410812759, 877.5480627476854, 887.6493784954939, 784.4822417204646, 860.2558786649535, 871.3987348729388, 883.7878909061843, 888.4092078767612, 913.2921985461287, 926.7173512078813, 939.4034787909658, 939.8590211468266, 944.3625552751865, 908.3278374003256, 910.9544522773868, 919.2508105893676, 931.4364809290383, 933.8412469880137, 689.9103116594861, 693.2893783871522, 694.8818700820822, 699.2972063076576, 699.5837476701405, 14875.925620371938, 14952.700945981129, 14980.775288370683, 14995.250237488082, 14999.700005999819, 14498.71002579953, 14601.70796584073, 14623.63440913975, 14663.266836658124, 14846.925765371105, 11171.106311495061, 11558.711032224177, 11672.824907626393, 11674.29954202742, 12118.697032574168, 3487.9361794652623, 3699.0567405311745, 3743.5320584926885, 3861.0733423978045, 3882.2817778710746, 115221.0, 116067.0, 120059.39970300092, 125258.37370813178, 126266.10600840994, 10472.633457829092, 10767.515461804081, 10890.782184356269, 10940.03767946471, 11271.211015228855, 23231.651525227135, 23238.65142022871, 23334.64998025031, 23343.949522271538, 23706.644400334008, 7769.572673503011, 7966.482178658484, 7987.800304992422, 8084.797880052928, 8187.0994190638985, 4443.200223959719, 4452.933206001848, 4648.1168577970075, 4689.179393606105, 4738.0, 3525.2949410117567, 3609.5307610011055, 3636.9272614547563, 3642.85428582859, 3645.2345007548183, 533.5278278723358, 632.8133200705803, 647.1942431672504, 651.46905272203, 663.6714826161082, 567.7274908044162, 568.1109064314335, 605.8969975104243, 656.3141517114626, 671.4359937652298, 8724.171203735636, 9156.267498600097, 10261.58953641846, 10268.64059757905, 10348.430836304076, 505.87858913860407, 660.0956689335641, 665.2250128600224, 678.8506528563709, 681.4139839737821, 4121.29937910556, 4147.585241475888, 4732.95267047332, 4777.259524773665, 4810.6151507879285, 99127.50436247773, 99192.5040374808, 155111.0, 157677.0, 176175.0, 127161.0, 130938.34530827285, 139290.0, 143661.0, 146286.0, 76758.61620691861, 85015.0, 97342.99999999859, 102631.0, 113263.86736132533, 8796.252318552739, 9178.632854685738, 9201.723948281562, 9226.769330766516, 9306.674266400643, 50868.0, 61835.38164618296, 64630.353696462436, 65458.34541654713, 66791.66604167143, 86016.0, 99141.50429247807, 99411.0, 103368.48315758373, 106484.9351506475, 12811.10322277469, 13052.15161014531, 13127.343632818513, 13256.0, 13498.662533436349, 14162.433502659778, 14601.707965840837, 14790.260486975392, 15257.6185595361, 15883.920580397024, 12921.870781292067, 13534.526291579747, 14401.855981440052, 14645.414183432544, 14841.183734894685, 11510.53957841677, 13557.134275600582, 14059.325072711767, 14186.503472378417, 14345.139291642536, 13331.600051998455, 13370.799438008244, 13417.530386436429, 13689.520866770014, 13917.0, 11519.942400287944, 11538.192326537062, 11748.765024699287, 11791.938725514745, 12058.336791476553, 11536.307821530734, 11616.244944078608, 11881.0, 11885.405729713653, 11888.405579721153], "value": 7897.21922203155, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1568.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 168.0, 174.0, 141.0, 118.0, 134.0, 175.0, 155.0, 120.0, 120.0], "value": 139.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 113.0, 111.0, 143.0, 114.0, 119.0, 141.0, 139.0, 140.0, 110.0], "value": 126.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 197.0, 202.0, 201.0, 199.0, 192.0, 199.0, 198.0, 192.0, 193.0], "value": 197.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 61.0, 79.0, 113.0, 58.0, 57.0, 58.0, 58.0, 77.0, 59.0], "value": 69.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 95.0, 107.0, 102.0, 74.0, 70.0, 88.0, 69.0, 70.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 88.0, 87.0, 89.0, 86.0, 93.0, 86.0, 90.0, 86.0], "value": 88.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 153.0, 110.0, 152.0, 106.0, 153.0, 153.0, 108.0], "value": 122.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 91.0, 99.0, 107.0, 144.0, 90.0, 89.0, 90.0, 93.0], "value": 98.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 57.0, 58.0, 58.0, 57.0, 59.0, 59.0, 59.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 75.0, 80.0, 77.0, 71.0, 71.0, 70.0, 72.0, 73.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 102.0, 108.0, 103.0, 86.0, 85.0, 87.0, 85.0, 85.0, 88.0], "value": 93.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 141.0, 152.0, 133.0, 149.0, 155.0, 157.0, 162.0, 207.0, 150.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 198.0, 159.0, 191.0, 235.0, 229.0, 154.0, 223.0, 166.0, 222.0], "value": 194.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 69.0, 70.0, 67.0, 69.0, 66.0, 68.0, 64.0, 81.0], "value": 68.8, "unit": "score"}]}]} 21:36:16 INFO - Return code: 0 21:36:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:36:16 ERROR - # TBPL SUCCESS # 21:36:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:36:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:36:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:36:16 INFO - 2016-11-12 21:36:16.488 screenresolution[1965:19273] starting screenresolution argv=screenresolution get 21:36:16 INFO - 2016-11-12 21:36:16.491 screenresolution[1965:19273] Display 0: 1600x1200x32@60 21:36:16 INFO - 2016-11-12 21:36:16.497 screenresolution[1966:19276] starting screenresolution argv=screenresolution list 21:36:16 INFO - Available Modes on Display 0 21:36:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:36:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:36:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:36:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:36:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:36:16 INFO - Intel Iris: 21:36:16 INFO - Chipset Model: Intel Iris 21:36:16 INFO - Type: GPU 21:36:16 INFO - Bus: Built-In 21:36:16 INFO - VRAM (Dynamic, Max): 1536 MB 21:36:16 INFO - Vendor: Intel (0x8086) 21:36:16 INFO - Device ID: 0x0a2e 21:36:16 INFO - Revision ID: 0x0009 21:36:16 INFO - Displays: 21:36:16 INFO - Display: 21:36:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:36:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:36:16 INFO - Display Serial Number: 1600x1200 60 21:36:16 INFO - Main Display: Yes 21:36:16 INFO - Mirror: Off 21:36:16 INFO - Online: Yes 21:36:16 INFO - Rotation: Supported 21:36:16 INFO - Return code: 0 21:36:16 INFO - Running post-action listener: _resource_record_post_action 21:36:16 INFO - [mozharness: 2016-11-13 05:36:16.731483Z] Finished run-tests step (success) 21:36:16 INFO - Running post-run listener: _resource_record_post_run 21:36:16 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 520192; Write bytes: 666898432; Read time: 7; Write time: 2017 21:36:16 INFO - TinderboxPrint: CPU usage
54.3% 21:36:16 INFO - TinderboxPrint: I/O read bytes / time
520,192 / 7 21:36:16 INFO - TinderboxPrint: I/O write bytes / time
666,898,432 / 2,017 21:36:16 INFO - TinderboxPrint: CPU idle
2,206.6 (45.6%) 21:36:16 INFO - TinderboxPrint: CPU system
980.3 (20.3%) 21:36:16 INFO - TinderboxPrint: CPU user
1,646.9 (34.1%) 21:36:16 INFO - TinderboxPrint: Swap in / out
363,798,528 / 0 21:36:16 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 358625792; Write bytes: 357176832; Read time: 27507; Write time: 688 21:36:16 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 520192; Write bytes: 298723840; Read time: 7; Write time: 1292 21:36:17 INFO - Running post-run listener: _upload_blobber_files 21:36:17 INFO - Blob upload gear active. 21:36:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:36:17 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 21:36:17 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'] 21:36:17 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 21:36:17 INFO - (blobuploader) - INFO - Open directory for files ... 21:36:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:36:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:36:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:36:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:36:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:36:18 INFO - (blobuploader) - INFO - Done attempting. 21:36:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:36:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:36:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:36:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:36:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:36:19 INFO - (blobuploader) - INFO - Done attempting. 21:36:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:36:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:36:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:36:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:36:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:36:21 INFO - (blobuploader) - INFO - Done attempting. 21:36:21 INFO - (blobuploader) - INFO - Iteration through files over. 21:36:21 INFO - Return code: 0 21:36:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:36:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:36:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/987d0c69a33b0cea972417a65b3604105619fe9623940eff452125e43a91b9bf353038b99f83897f2f99c5c30bf39497a6ecc4642aa83bbeae2202540164c87e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ceeacf25a3ae908924c7359b1e53944ac6077fa77e0b8cb63ff05dce2d1c05b86a3eda6091d2c4ad5c5d88fffba6897900b0a472bd8782901aa667301320b2f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de240b63e6ea53ded74b5b42c6fd787809b1e61040f1491d450a56da27b858a34bdb1b211c379a2cabad3feb562b98e3f6f01b562bde0caefe7b646c767e7a11"} 21:36:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:36:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:36:21 INFO - Contents: 21:36:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/987d0c69a33b0cea972417a65b3604105619fe9623940eff452125e43a91b9bf353038b99f83897f2f99c5c30bf39497a6ecc4642aa83bbeae2202540164c87e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ceeacf25a3ae908924c7359b1e53944ac6077fa77e0b8cb63ff05dce2d1c05b86a3eda6091d2c4ad5c5d88fffba6897900b0a472bd8782901aa667301320b2f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de240b63e6ea53ded74b5b42c6fd787809b1e61040f1491d450a56da27b858a34bdb1b211c379a2cabad3feb562b98e3f6f01b562bde0caefe7b646c767e7a11"} 21:36:21 INFO - Running post-run listener: copy_logs_to_upload_dir 21:36:21 INFO - Copying logs to upload dir... 21:36:21 INFO - mkdir: /builds/slave/test/build/upload/logs 21:36:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.082690 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-11-12 21:36:21.908298) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-12 21:36:21.911373) ========= 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.E6xu4qGYUN/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.56avqZjof7/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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/987d0c69a33b0cea972417a65b3604105619fe9623940eff452125e43a91b9bf353038b99f83897f2f99c5c30bf39497a6ecc4642aa83bbeae2202540164c87e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ceeacf25a3ae908924c7359b1e53944ac6077fa77e0b8cb63ff05dce2d1c05b86a3eda6091d2c4ad5c5d88fffba6897900b0a472bd8782901aa667301320b2f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de240b63e6ea53ded74b5b42c6fd787809b1e61040f1491d450a56da27b858a34bdb1b211c379a2cabad3feb562b98e3f6f01b562bde0caefe7b646c767e7a11"} build_url:https://queue.taskcluster.net/v1/task/Djfj-6SnQIuxOUQhAa006Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/Djfj-6SnQIuxOUQhAa006Q/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/987d0c69a33b0cea972417a65b3604105619fe9623940eff452125e43a91b9bf353038b99f83897f2f99c5c30bf39497a6ecc4642aa83bbeae2202540164c87e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ceeacf25a3ae908924c7359b1e53944ac6077fa77e0b8cb63ff05dce2d1c05b86a3eda6091d2c4ad5c5d88fffba6897900b0a472bd8782901aa667301320b2f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de240b63e6ea53ded74b5b42c6fd787809b1e61040f1491d450a56da27b858a34bdb1b211c379a2cabad3feb562b98e3f6f01b562bde0caefe7b646c767e7a11"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-12 21:36:21.943973) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 21:36:21.944291) ========= 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.E6xu4qGYUN/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.56avqZjof7/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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.005080 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 21:36:21.992777) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-12 21:36:21.993096) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-12 21:36:21.993395) ========= ========= Total master_lag: 0.18 =========