builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0060 starttime: 1477351847.63 results: success (0) buildid: 20161024140622 builduid: 26397ab0c33c4500915c55f624c972a3 revision: bf9235ab0289e3fc88cc0fdba9f02ba7983aa695 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 16:30:47.627680) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 16:30:47.628163) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 16:30:47.628576) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 16:30:47.652576) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 16:30:47.652921) ========= 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.ua8ZwN23JU/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.dU3XWJehCy/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-24 16:30:47-- 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% 12.7M=0.001s 2016-10-24 16:30:47 (12.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116252 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 16:30:47.790850) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 16:30:47.791156) ========= 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.ua8ZwN23JU/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.dU3XWJehCy/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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.020698 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 16:30:47.840170) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 16:30:47.840573) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bf9235ab0289e3fc88cc0fdba9f02ba7983aa695 --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 bf9235ab0289e3fc88cc0fdba9f02ba7983aa695 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ua8ZwN23JU/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.dU3XWJehCy/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-24 16:30:47,921 truncating revision to first 12 chars 2016-10-24 16:30:47,921 Setting DEBUG logging. 2016-10-24 16:30:47,921 attempt 1/10 2016-10-24 16:30:47,921 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bf9235ab0289?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 16:30:49,108 unpacking tar archive at: mozilla-aurora-bf9235ab0289/testing/mozharness/ program finished with exit code 0 elapsedTime=1.459737 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 16:30:49.322366) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 16:30:49.322728) ========= script_repo_revision: bf9235ab0289e3fc88cc0fdba9f02ba7983aa695 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 16:30:49.323102) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 16:30:49.323842) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 16:30:49.346565) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-24 16:30:49.346928) ========= /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.ua8ZwN23JU/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.dU3XWJehCy/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 16:30:49 INFO - MultiFileLogger online at 20161024 16:30:49 in /builds/slave/test 16:30:49 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 16:30:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:30:49 INFO - {'append_to_log': False, 16:30:49 INFO - 'base_work_dir': '/builds/slave/test', 16:30:49 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:30:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:30:49 INFO - 'branch': 'Mozilla-Aurora', 16:30:49 INFO - 'buildbot_json_path': 'buildprops.json', 16:30:49 INFO - 'config_files': ('talos/mac_config.py',), 16:30:49 INFO - 'default_actions': ('clobber', 16:30:49 INFO - 'read-buildbot-config', 16:30:49 INFO - 'download-and-extract', 16:30:49 INFO - 'populate-webroot', 16:30:49 INFO - 'create-virtualenv', 16:30:49 INFO - 'install', 16:30:49 INFO - 'run-tests'), 16:30:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:30:49 INFO - 'download_minidump_stackwalk': True, 16:30:49 INFO - 'download_symbols': 'ondemand', 16:30:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:30:49 INFO - 'tooltool.py': '/tools/tooltool.py', 16:30:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:30:49 INFO - '/tools/misc-python/virtualenv.py')}, 16:30:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:30:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:30:49 INFO - 'installer_path': 'installer.exe', 16:30:49 INFO - 'log_level': 'info', 16:30:49 INFO - 'log_name': 'talos', 16:30:49 INFO - 'log_to_console': True, 16:30:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:30:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:30:49 INFO - 'opt_config_files': (), 16:30:49 INFO - 'pip_index': False, 16:30:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:30:49 INFO - 'cmd': ('bash', 16:30:49 INFO - '-c', 16:30:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:30:49 INFO - 'enabled': True, 16:30:49 INFO - 'halt_on_failure': False, 16:30:49 INFO - 'name': 'check_screen_resolution'},), 16:30:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:30:49 INFO - 'cmd': ('bash', 16:30:49 INFO - '-c', 16:30:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:30:49 INFO - 'enabled': True, 16:30:49 INFO - 'halt_on_failure': False, 16:30:49 INFO - 'name': 'check_screen_resolution'},), 16:30:49 INFO - 'run_cmd_checks_enabled': True, 16:30:49 INFO - 'sps_profile': False, 16:30:49 INFO - 'sps_profile_interval': 0, 16:30:49 INFO - 'suite': 'dromaeojs-e10s', 16:30:49 INFO - 'system_bits': '32', 16:30:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:30:49 INFO - 'title': 't-yosemite-r7-0060', 16:30:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:30:49 INFO - 'use_talos_json': True, 16:30:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:30:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:30:49 INFO - 'work_dir': 'build'} 16:30:49 INFO - [mozharness: 2016-10-24 23:30:49.555756Z] Running clobber step. 16:30:49 INFO - Running pre-action listener: _resource_record_pre_action 16:30:49 INFO - Running main action method: clobber 16:30:49 INFO - rmtree: /builds/slave/test/build 16:30:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:30:51 INFO - Running post-action listener: _resource_record_post_action 16:30:51 INFO - [mozharness: 2016-10-24 23:30:51.025025Z] Finished clobber step (success) 16:30:51 INFO - [mozharness: 2016-10-24 23:30:51.025187Z] Running read-buildbot-config step. 16:30:51 INFO - Running pre-action listener: _resource_record_pre_action 16:30:51 INFO - Running main action method: read_buildbot_config 16:30:51 INFO - Using buildbot properties: 16:30:51 INFO - { 16:30:51 INFO - "project": "", 16:30:51 INFO - "product": "firefox", 16:30:51 INFO - "script_repo_revision": "production", 16:30:51 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 16:30:51 INFO - "repository": "", 16:30:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 16:30:51 INFO - "buildid": "20161024140622", 16:30:51 INFO - "pgo_build": "False", 16:30:51 INFO - "basedir": "/builds/slave/test", 16:30:51 INFO - "buildnumber": 18, 16:30:51 INFO - "slavename": "t-yosemite-r7-0060", 16:30:51 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 16:30:51 INFO - "platform": "yosemite_r7", 16:30:51 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:30:51 INFO - "branch": "mozilla-aurora", 16:30:51 INFO - "repo_path": "releases/mozilla-aurora", 16:30:51 INFO - "revision": "bf9235ab0289e3fc88cc0fdba9f02ba7983aa695", 16:30:51 INFO - "stage_platform": "macosx64", 16:30:51 INFO - "builduid": "26397ab0c33c4500915c55f624c972a3", 16:30:51 INFO - "slavebuilddir": "test" 16:30:51 INFO - } 16:30:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/WC1P55XORRylbGVOut0Z5A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 16:30:51 INFO - Running post-action listener: _resource_record_post_action 16:30:51 INFO - [mozharness: 2016-10-24 23:30:51.028593Z] Finished read-buildbot-config step (success) 16:30:51 INFO - [mozharness: 2016-10-24 23:30:51.028732Z] Running download-and-extract step. 16:30:51 INFO - Running pre-action listener: _resource_record_pre_action 16:30:51 INFO - Running main action method: download_and_extract 16:30:51 INFO - mkdir: /builds/slave/test/build/tests 16:30:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:51 INFO - trying https://queue.taskcluster.net/v1/task/WC1P55XORRylbGVOut0Z5A/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 16:30:51 INFO - Downloading https://queue.taskcluster.net/v1/task/WC1P55XORRylbGVOut0Z5A/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 16:30:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WC1P55XORRylbGVOut0Z5A/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 16:30:52 INFO - Downloaded 1199 bytes. 16:30:52 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 16:30:52 INFO - Using the following test package requirements: 16:30:52 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:30:52 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:30:52 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 16:30:52 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:30:52 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 16:30:52 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:30:52 INFO - u'jsshell-mac.zip'], 16:30:52 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:30:52 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 16:30:52 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:30:52 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:30:52 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 16:30:52 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:30:52 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 16:30:52 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:30:52 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 16:30:52 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:30:52 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 16:30:52 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:30:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WC1P55XORRylbGVOut0Z5A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:30:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WC1P55XORRylbGVOut0Z5A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:30:52 INFO - Fetch https://queue.taskcluster.net/v1/task/WC1P55XORRylbGVOut0Z5A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:30:53 INFO - Expected file size: 16438616 16:31:00 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 16:31:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WC1P55XORRylbGVOut0Z5A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:31:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WC1P55XORRylbGVOut0Z5A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:31:00 INFO - Fetch https://queue.taskcluster.net/v1/task/WC1P55XORRylbGVOut0Z5A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:31:00 INFO - Expected file size: 16438616 16:31:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WC1P55XORRylbGVOut0Z5A/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 16:31:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WC1P55XORRylbGVOut0Z5A/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:31:07 INFO - Fetch https://queue.taskcluster.net/v1/task/WC1P55XORRylbGVOut0Z5A/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 16:31:07 INFO - Expected file size: 14414081 16:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:08 INFO - trying https://queue.taskcluster.net/v1/task/WC1P55XORRylbGVOut0Z5A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:31:08 INFO - Downloading https://queue.taskcluster.net/v1/task/WC1P55XORRylbGVOut0Z5A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 16:31:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WC1P55XORRylbGVOut0Z5A/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 16:31:11 INFO - Downloaded 115439382 bytes. 16:31:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WC1P55XORRylbGVOut0Z5A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:31:11 INFO - mkdir: /builds/slave/test/properties 16:31:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:31:11 INFO - Writing to file /builds/slave/test/properties/build_url 16:31:11 INFO - Contents: 16:31:11 INFO - build_url:https://queue.taskcluster.net/v1/task/WC1P55XORRylbGVOut0Z5A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:31:12 INFO - Running post-action listener: _resource_record_post_action 16:31:12 INFO - Running post-action listener: set_extra_try_arguments 16:31:12 INFO - [mozharness: 2016-10-24 23:31:12.085341Z] Finished download-and-extract step (success) 16:31:12 INFO - [mozharness: 2016-10-24 23:31:12.085486Z] Running populate-webroot step. 16:31:12 INFO - Running pre-action listener: _resource_record_pre_action 16:31:12 INFO - Running main action method: populate_webroot 16:31:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:31:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:31:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:31:12 INFO - '--tppagecycles', 16:31:12 INFO - '7'], 16:31:12 INFO - 'tests': ['tsvgm']}}, 16:31:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:31:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:31:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:31:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:31:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:31:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:31:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:12 INFO - 'talos_options': ['--disable-e10s'], 16:31:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:12 INFO - 'talos_options': ['--disable-e10s'], 16:31:12 INFO - 'tests': ['damp', 'tps']}, 16:31:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:12 INFO - 'tests': ['damp', 'tps']}, 16:31:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:31:12 INFO - 'tests': ['dromaeo_dom']}, 16:31:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:31:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:31:12 INFO - 'tests': ['basic_compositor_video']}, 16:31:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:31:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:31:12 INFO - 'tests': ['a11yr', 16:31:12 INFO - 'ts_paint', 16:31:12 INFO - 'tpaint', 16:31:12 INFO - 'sessionrestore', 16:31:12 INFO - 'sessionrestore_no_auto_restore', 16:31:12 INFO - 'tabpaint']}, 16:31:12 INFO - 'other-e10s': {'tests': ['a11yr', 16:31:12 INFO - 'ts_paint', 16:31:12 INFO - 'tpaint', 16:31:12 INFO - 'sessionrestore', 16:31:12 INFO - 'sessionrestore_no_auto_restore', 16:31:12 INFO - 'tabpaint']}, 16:31:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:31:12 INFO - 'ts_paint', 16:31:12 INFO - 'tpaint', 16:31:12 INFO - 'sessionrestore', 16:31:12 INFO - 'sessionrestore_no_auto_restore', 16:31:12 INFO - 'tabpaint']}, 16:31:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:31:12 INFO - 'ts_paint', 16:31:12 INFO - 'tpaint', 16:31:12 INFO - 'sessionrestore', 16:31:12 INFO - 'sessionrestore_no_auto_restore', 16:31:12 INFO - 'tabpaint']}, 16:31:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:31:12 INFO - 'tests': ['a11yr', 16:31:12 INFO - 'ts_paint', 16:31:12 INFO - 'tpaint', 16:31:12 INFO - 'sessionrestore', 16:31:12 INFO - 'sessionrestore_no_auto_restore', 16:31:12 INFO - 'tabpaint']}, 16:31:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:31:12 INFO - 'tests': ['a11yr', 16:31:12 INFO - 'ts_paint', 16:31:12 INFO - 'tpaint', 16:31:12 INFO - 'sessionrestore', 16:31:12 INFO - 'sessionrestore_no_auto_restore', 16:31:12 INFO - 'tabpaint']}, 16:31:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:31:12 INFO - 'tests': ['tsvgx', 16:31:12 INFO - 'tsvgr_opacity', 16:31:12 INFO - 'tart', 16:31:12 INFO - 'tscrollx', 16:31:12 INFO - 'cart']}, 16:31:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:31:12 INFO - 'tsvgr_opacity', 16:31:12 INFO - 'tart', 16:31:12 INFO - 'tscrollx', 16:31:12 INFO - 'cart']}, 16:31:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:12 INFO - 'talos_options': ['--disable-e10s'], 16:31:12 INFO - 'tests': ['tp5o']}, 16:31:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:12 INFO - 'tests': ['tp5o']}, 16:31:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:12 INFO - 'talos_options': ['--disable-e10s', 16:31:12 INFO - '--xperf_path', 16:31:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:12 INFO - 'tests': ['tp5n']}, 16:31:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:12 INFO - 'talos_options': ['--xperf_path', 16:31:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:12 INFO - 'tests': ['tp5n']}}, 16:31:12 INFO - 'talos.zip': {'path': '', 16:31:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:31:12 INFO - Running post-action listener: _resource_record_post_action 16:31:12 INFO - [mozharness: 2016-10-24 23:31:12.104001Z] Finished populate-webroot step (success) 16:31:12 INFO - [mozharness: 2016-10-24 23:31:12.104117Z] Running create-virtualenv step. 16:31:12 INFO - Running pre-action listener: _resource_record_pre_action 16:31:12 INFO - Running main action method: create_virtualenv 16:31:12 INFO - Creating virtualenv /builds/slave/test/build/venv 16:31:12 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 16:31:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:31:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:31:12 INFO - Using real prefix '/tools/python27' 16:31:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:31:12 INFO - Installing distribute.............................................................................................................................................................................................done. 16:31:15 INFO - Installing pip.................done. 16:31:15 INFO - Return code: 0 16:31:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:31: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')]} 16:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31: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')]} 16:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:15 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 0x10ea1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e994570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbec25a1b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e832d30>, '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 0x10e698db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e82ab20>, '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.ua8ZwN23JU/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.dU3XWJehCy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 16:31:15 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 16:31:15 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 16:31:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ua8ZwN23JU/Render', 16:31:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:15 INFO - 'HOME': '/Users/cltbld', 16:31:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:15 INFO - 'LOGNAME': 'cltbld', 16:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:15 INFO - 'MOZ_NO_REMOTE': '1', 16:31:15 INFO - 'NO_EM_RESTART': '1', 16:31:15 INFO - 'PAGER': '/bin/cat', 16:31:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:15 INFO - 'PWD': '/builds/slave/test', 16:31:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:15 INFO - 'SHELL': '/bin/bash', 16:31:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dU3XWJehCy/Listeners', 16:31:15 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 16:31:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:15 INFO - 'USER': 'cltbld', 16:31:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:15 INFO - 'XPC_FLAGS': '0x0', 16:31:15 INFO - 'XPC_SERVICE_NAME': '0', 16:31:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:16 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 16:31:16 INFO - Cleaning up... 16:31:16 INFO - Return code: 0 16:31:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:31:16 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')]} 16:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:16 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')]} 16:31:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:16 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 0x10ea1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e994570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbec25a1b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e832d30>, '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 0x10e698db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e82ab20>, '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.ua8ZwN23JU/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.dU3XWJehCy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 16:31:16 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 16:31:16 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 16:31:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ua8ZwN23JU/Render', 16:31:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:16 INFO - 'HOME': '/Users/cltbld', 16:31:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:16 INFO - 'LOGNAME': 'cltbld', 16:31:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:16 INFO - 'MOZ_NO_REMOTE': '1', 16:31:16 INFO - 'NO_EM_RESTART': '1', 16:31:16 INFO - 'PAGER': '/bin/cat', 16:31:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:16 INFO - 'PWD': '/builds/slave/test', 16:31:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:16 INFO - 'SHELL': '/bin/bash', 16:31:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dU3XWJehCy/Listeners', 16:31:16 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 16:31:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:16 INFO - 'USER': 'cltbld', 16:31:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:16 INFO - 'XPC_FLAGS': '0x0', 16:31:16 INFO - 'XPC_SERVICE_NAME': '0', 16:31:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:16 INFO - Downloading/unpacking psutil>=3.1.1 16:31:16 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 16:31:16 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 16:31:16 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 16:31:16 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 16:31:16 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 16:31:16 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 16:31:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:31:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:19 INFO - Installing collected packages: psutil 16:31:19 INFO - Running setup.py install for psutil 16:31:19 INFO - building 'psutil._psutil_osx' extension 16:31:19 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 16:31:19 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 16:31:19 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 16:31:19 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 16:31:19 INFO - building 'psutil._psutil_posix' extension 16:31:19 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 16:31:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:31:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:31:19 INFO - ^ 16:31:19 INFO - 1 warning generated. 16:31:20 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 16:31:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:20 INFO - Successfully installed psutil 16:31:20 INFO - Cleaning up... 16:31:20 INFO - Return code: 0 16:31:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:31:20 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')]} 16:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:20 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')]} 16:31:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:20 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 0x10ea1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e994570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbec25a1b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e832d30>, '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 0x10e698db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e82ab20>, '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.ua8ZwN23JU/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.dU3XWJehCy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 16:31:20 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 16:31:20 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 16:31:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ua8ZwN23JU/Render', 16:31:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:20 INFO - 'HOME': '/Users/cltbld', 16:31:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:20 INFO - 'LOGNAME': 'cltbld', 16:31:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:20 INFO - 'MOZ_NO_REMOTE': '1', 16:31:20 INFO - 'NO_EM_RESTART': '1', 16:31:20 INFO - 'PAGER': '/bin/cat', 16:31:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:20 INFO - 'PWD': '/builds/slave/test', 16:31:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:20 INFO - 'SHELL': '/bin/bash', 16:31:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dU3XWJehCy/Listeners', 16:31:20 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 16:31:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:20 INFO - 'USER': 'cltbld', 16:31:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:20 INFO - 'XPC_FLAGS': '0x0', 16:31:20 INFO - 'XPC_SERVICE_NAME': '0', 16:31:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:31:20 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 16:31:20 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 16:31:20 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 16:31:20 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 16:31:20 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 16:31:20 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 16:31:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:31:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:31:23 INFO - Installing collected packages: mozsystemmonitor 16:31:23 INFO - Running setup.py install for mozsystemmonitor 16:31:23 INFO - Successfully installed mozsystemmonitor 16:31:23 INFO - Cleaning up... 16:31:23 INFO - Return code: 0 16:31:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:31:23 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')]} 16:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:23 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')]} 16:31:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:23 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 0x10ea1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e994570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbec25a1b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e832d30>, '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 0x10e698db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e82ab20>, '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.ua8ZwN23JU/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.dU3XWJehCy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 16:31:23 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 16:31:23 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 16:31:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ua8ZwN23JU/Render', 16:31:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:23 INFO - 'HOME': '/Users/cltbld', 16:31:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:23 INFO - 'LOGNAME': 'cltbld', 16:31:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:23 INFO - 'MOZ_NO_REMOTE': '1', 16:31:23 INFO - 'NO_EM_RESTART': '1', 16:31:23 INFO - 'PAGER': '/bin/cat', 16:31:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:23 INFO - 'PWD': '/builds/slave/test', 16:31:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:23 INFO - 'SHELL': '/bin/bash', 16:31:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dU3XWJehCy/Listeners', 16:31:23 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 16:31:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:23 INFO - 'USER': 'cltbld', 16:31:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:23 INFO - 'XPC_FLAGS': '0x0', 16:31:23 INFO - 'XPC_SERVICE_NAME': '0', 16:31:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:23 INFO - Downloading/unpacking jsonschema==2.5.1 16:31:23 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 16:31:23 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 16:31:23 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 16:31:23 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 16:31:23 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 16:31:23 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 16:31:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:31:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:31:26 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 16:31:26 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 16:31:26 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 16:31:26 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 16:31:26 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 16:31:26 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 16:31:26 INFO - Downloading functools32-3.2.3-2.tar.gz 16:31:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:31:26 INFO - warning: no files found matching '*.txt' 16:31:26 INFO - no previously-included directories found matching 'build' 16:31:26 INFO - no previously-included directories found matching 'dist' 16:31:26 INFO - no previously-included directories found matching '.git*' 16:31:26 INFO - Installing collected packages: jsonschema, functools32 16:31:26 INFO - Running setup.py install for functools32 16:31:26 INFO - warning: no files found matching '*.txt' 16:31:26 INFO - no previously-included directories found matching 'build' 16:31:26 INFO - no previously-included directories found matching 'dist' 16:31:26 INFO - no previously-included directories found matching '.git*' 16:31:26 INFO - Successfully installed jsonschema functools32 16:31:26 INFO - Cleaning up... 16:31:26 INFO - Return code: 0 16:31:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:31:26 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')]} 16:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:26 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')]} 16:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:26 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 0x10ea1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e994570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbec25a1b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e832d30>, '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 0x10e698db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e82ab20>, '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.ua8ZwN23JU/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.dU3XWJehCy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 16:31:26 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 16:31:26 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 16:31:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ua8ZwN23JU/Render', 16:31:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:26 INFO - 'HOME': '/Users/cltbld', 16:31:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:26 INFO - 'LOGNAME': 'cltbld', 16:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:26 INFO - 'MOZ_NO_REMOTE': '1', 16:31:26 INFO - 'NO_EM_RESTART': '1', 16:31:26 INFO - 'PAGER': '/bin/cat', 16:31:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:26 INFO - 'PWD': '/builds/slave/test', 16:31:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:26 INFO - 'SHELL': '/bin/bash', 16:31:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dU3XWJehCy/Listeners', 16:31:26 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 16:31:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:26 INFO - 'USER': 'cltbld', 16:31:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:26 INFO - 'XPC_FLAGS': '0x0', 16:31:26 INFO - 'XPC_SERVICE_NAME': '0', 16:31:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:31:27 INFO - Cleaning up... 16:31:27 INFO - Return code: 0 16:31:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ea1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e994570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbec25a1b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e832d30>, '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 0x10e698db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e82ab20>, '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.ua8ZwN23JU/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.dU3XWJehCy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 16:31:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:31:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:31:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ua8ZwN23JU/Render', 16:31:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:27 INFO - 'HOME': '/Users/cltbld', 16:31:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:27 INFO - 'LOGNAME': 'cltbld', 16:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:27 INFO - 'MOZ_NO_REMOTE': '1', 16:31:27 INFO - 'NO_EM_RESTART': '1', 16:31:27 INFO - 'PAGER': '/bin/cat', 16:31:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:27 INFO - 'PWD': '/builds/slave/test', 16:31:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:27 INFO - 'SHELL': '/bin/bash', 16:31:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dU3XWJehCy/Listeners', 16:31:27 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 16:31:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:27 INFO - 'USER': 'cltbld', 16:31:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:27 INFO - 'XPC_FLAGS': '0x0', 16:31:27 INFO - 'XPC_SERVICE_NAME': '0', 16:31:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:27 INFO - Downloading/unpacking blobuploader==1.2.4 16:31:27 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 16:31:27 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 16:31:27 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 16:31:27 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 16:31:27 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 16:31:27 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 16:31:30 INFO - Downloading blobuploader-1.2.4.tar.gz 16:31:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:31:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:31:30 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 16:31:30 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 16:31:30 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 16:31:30 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 16:31:30 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 16:31:30 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 16:31:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:31:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:31:30 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 16:31:30 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 16:31:30 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 16:31:30 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 16:31:30 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 16:31:30 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 16:31:31 INFO - Downloading docopt-0.6.1.tar.gz 16:31:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:31:31 INFO - Installing collected packages: blobuploader, requests, docopt 16:31:31 INFO - Running setup.py install for blobuploader 16:31:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:31:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:31:31 INFO - Running setup.py install for requests 16:31:31 INFO - Running setup.py install for docopt 16:31:32 INFO - Successfully installed blobuploader requests docopt 16:31:32 INFO - Cleaning up... 16:31:32 INFO - Return code: 0 16:31:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31: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')]} 16:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31: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')]} 16:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:32 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 0x10ea1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e994570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbec25a1b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e832d30>, '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 0x10e698db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e82ab20>, '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.ua8ZwN23JU/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.dU3XWJehCy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 16:31:32 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 16:31:32 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 16:31:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ua8ZwN23JU/Render', 16:31:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:32 INFO - 'HOME': '/Users/cltbld', 16:31:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:32 INFO - 'LOGNAME': 'cltbld', 16:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:32 INFO - 'MOZ_NO_REMOTE': '1', 16:31:32 INFO - 'NO_EM_RESTART': '1', 16:31:32 INFO - 'PAGER': '/bin/cat', 16:31:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:32 INFO - 'PWD': '/builds/slave/test', 16:31:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:32 INFO - 'SHELL': '/bin/bash', 16:31:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dU3XWJehCy/Listeners', 16:31:32 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 16:31:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:32 INFO - 'USER': 'cltbld', 16:31:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:32 INFO - 'XPC_FLAGS': '0x0', 16:31:32 INFO - 'XPC_SERVICE_NAME': '0', 16:31:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:32 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-v2CVwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:32 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-ucVtp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:32 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-y0cuOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:32 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-vxlr5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:32 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-otuD4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:33 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-SThYSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:33 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-TlEDmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:33 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-kzMj3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:33 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-FOH5lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:33 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-VM4V9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:33 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-A0OKN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:33 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-9W5GM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:33 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-WVwjcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:33 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-EgCDWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:33 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-yDL3mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:34 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-Di_UnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:34 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-q0OhKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:31:34 INFO - Running setup.py install for manifestparser 16:31:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:31:34 INFO - Running setup.py install for mozcrash 16:31:34 INFO - Running setup.py install for mozdebug 16:31:34 INFO - Running setup.py install for mozdevice 16:31:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:31:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:31:34 INFO - Running setup.py install for mozfile 16:31:35 INFO - Running setup.py install for mozhttpd 16:31:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:31:35 INFO - Running setup.py install for mozinfo 16:31:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:31:35 INFO - Running setup.py install for mozInstall 16:31:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:31:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:31:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:31:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:31:35 INFO - Running setup.py install for mozleak 16:31:35 INFO - Running setup.py install for mozlog 16:31:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:31:35 INFO - Running setup.py install for moznetwork 16:31:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:31:35 INFO - Running setup.py install for mozprocess 16:31:36 INFO - Running setup.py install for mozprofile 16:31:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:31:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:31:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:31:36 INFO - Running setup.py install for mozrunner 16:31:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:31:36 INFO - Running setup.py install for mozscreenshot 16:31:36 INFO - Running setup.py install for moztest 16:31:36 INFO - Running setup.py install for mozversion 16:31:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:31:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:31:36 INFO - Cleaning up... 16:31:36 INFO - Return code: 0 16:31:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:36 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 0x10ea1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e994570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbec25a1b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e832d30>, '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 0x10e698db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e82ab20>, '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.ua8ZwN23JU/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.dU3XWJehCy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 16:31:36 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 16:31:36 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 16:31:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ua8ZwN23JU/Render', 16:31:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:36 INFO - 'HOME': '/Users/cltbld', 16:31:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:36 INFO - 'LOGNAME': 'cltbld', 16:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:36 INFO - 'MOZ_NO_REMOTE': '1', 16:31:36 INFO - 'NO_EM_RESTART': '1', 16:31:36 INFO - 'PAGER': '/bin/cat', 16:31:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:36 INFO - 'PWD': '/builds/slave/test', 16:31:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:36 INFO - 'SHELL': '/bin/bash', 16:31:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dU3XWJehCy/Listeners', 16:31:36 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 16:31:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:36 INFO - 'USER': 'cltbld', 16:31:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:36 INFO - 'XPC_FLAGS': '0x0', 16:31:36 INFO - 'XPC_SERVICE_NAME': '0', 16:31:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:37 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-mpZBkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:37 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)) 16:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:37 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-ANjHal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:37 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)) 16:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:37 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-wEze2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:37 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)) 16:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:37 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-Uwtby5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:37 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)) 16:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:37 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-nkfJ5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:37 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)) 16:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:37 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-T1vvL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:37 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)) 16:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:37 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-ZcHFAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:37 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)) 16:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:37 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-cX1Hde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:38 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)) 16:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:38 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-E5G7ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:38 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)) 16:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:38 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-94I97V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:38 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)) 16:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:38 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-zpAPcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:38 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)) 16:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:38 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-er9Smy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:38 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)) 16:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:38 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-LK3fZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:38 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)) 16:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:38 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-9iOdFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:38 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)) 16:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:38 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-y6ebZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:38 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)) 16:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:38 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-Gn4cR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:38 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)) 16:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:38 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-AJFWxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:39 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)) 16:31:39 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)) 16:31:39 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)) 16:31:39 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)) 16:31:39 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)) 16:31:39 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)) 16:31:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:41 INFO - Downloading blessings-1.6.tar.gz 16:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:31:41 INFO - Installing collected packages: blessings 16:31:41 INFO - Running setup.py install for blessings 16:31:41 INFO - Successfully installed blessings 16:31:41 INFO - Cleaning up... 16:31:41 INFO - Return code: 0 16:31:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:31:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:42 INFO - Reading from file tmpfile_stdout 16:31:42 INFO - Current package versions: 16:31:42 INFO - blessings == 1.6 16:31:42 INFO - blobuploader == 1.2.4 16:31:42 INFO - docopt == 0.6.1 16:31:42 INFO - functools32 == 3.2.3-2 16:31:42 INFO - jsonschema == 2.5.1 16:31:42 INFO - manifestparser == 1.1 16:31:42 INFO - mozInstall == 1.12 16:31:42 INFO - mozcrash == 0.17 16:31:42 INFO - mozdebug == 0.1 16:31:42 INFO - mozdevice == 0.48 16:31:42 INFO - mozfile == 1.2 16:31:42 INFO - mozhttpd == 0.7 16:31:42 INFO - mozinfo == 0.9 16:31:42 INFO - mozleak == 0.1 16:31:42 INFO - mozlog == 3.4 16:31:42 INFO - moznetwork == 0.27 16:31:42 INFO - mozprocess == 0.23 16:31:42 INFO - mozprofile == 0.28 16:31:42 INFO - mozrunner == 6.12 16:31:42 INFO - mozscreenshot == 0.1 16:31:42 INFO - mozsystemmonitor == 0.3 16:31:42 INFO - moztest == 0.7 16:31:42 INFO - mozversion == 1.4 16:31:42 INFO - psutil == 3.1.1 16:31:42 INFO - requests == 1.2.3 16:31:42 INFO - wsgiref == 0.1.2 16:31:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:42 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')]} 16:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:42 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')]} 16:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:42 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 0x10ea1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e994570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbec25a1b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e832d30>, '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 0x10e698db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e82ab20>, '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.ua8ZwN23JU/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.dU3XWJehCy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 16:31:42 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 16:31:42 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 16:31:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ua8ZwN23JU/Render', 16:31:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:42 INFO - 'HOME': '/Users/cltbld', 16:31:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:42 INFO - 'LOGNAME': 'cltbld', 16:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:42 INFO - 'MOZ_NO_REMOTE': '1', 16:31:42 INFO - 'NO_EM_RESTART': '1', 16:31:42 INFO - 'PAGER': '/bin/cat', 16:31:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:42 INFO - 'PWD': '/builds/slave/test', 16:31:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:42 INFO - 'SHELL': '/bin/bash', 16:31:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dU3XWJehCy/Listeners', 16:31:42 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 16:31:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:42 INFO - 'USER': 'cltbld', 16:31:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:42 INFO - 'XPC_FLAGS': '0x0', 16:31:42 INFO - 'XPC_SERVICE_NAME': '0', 16:31:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:42 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)) 16:31:42 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)) 16:31:42 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)) 16:31:42 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)) 16:31:42 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)) 16:31:42 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)) 16:31:42 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)) 16:31:42 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)) 16:31:42 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)) 16:31:42 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)) 16:31:42 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)) 16:31:42 INFO - Cleaning up... 16:31:42 INFO - Return code: 0 16:31:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:31:42 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')]} 16:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:42 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')]} 16:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:42 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 0x10ea1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e994570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbec25a1b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e832d30>, '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 0x10e698db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e82ab20>, '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.ua8ZwN23JU/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.dU3XWJehCy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 16:31:42 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 16:31:42 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 16:31:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ua8ZwN23JU/Render', 16:31:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:42 INFO - 'HOME': '/Users/cltbld', 16:31:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:42 INFO - 'LOGNAME': 'cltbld', 16:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:42 INFO - 'MOZ_NO_REMOTE': '1', 16:31:42 INFO - 'NO_EM_RESTART': '1', 16:31:42 INFO - 'PAGER': '/bin/cat', 16:31:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:42 INFO - 'PWD': '/builds/slave/test', 16:31:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:42 INFO - 'SHELL': '/bin/bash', 16:31:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dU3XWJehCy/Listeners', 16:31:42 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 16:31:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:42 INFO - 'USER': 'cltbld', 16:31:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:42 INFO - 'XPC_FLAGS': '0x0', 16:31:42 INFO - 'XPC_SERVICE_NAME': '0', 16:31:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:31:42 INFO - Cleaning up... 16:31:42 INFO - Return code: 0 16:31:42 INFO - Running post-action listener: _resource_record_post_action 16:31:42 INFO - Running post-action listener: _start_resource_monitoring 16:31:42 INFO - Starting resource monitoring. 16:31:42 INFO - [mozharness: 2016-10-24 23:31:42.801466Z] Finished create-virtualenv step (success) 16:31:42 INFO - [mozharness: 2016-10-24 23:31:42.802510Z] Running install step. 16:31:42 INFO - Running pre-action listener: _resource_record_pre_action 16:31:42 INFO - Running main action method: install 16:31:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:43 INFO - Reading from file tmpfile_stdout 16:31:43 INFO - Detecting whether we're running mozinstall >=1.0... 16:31:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:31:43 INFO - Reading from file tmpfile_stdout 16:31:43 INFO - Output received: 16:31:43 INFO - Usage: mozinstall [options] installer 16:31:43 INFO - Options: 16:31:43 INFO - -h, --help show this help message and exit 16:31:43 INFO - -d DEST, --destination=DEST 16:31:43 INFO - Directory to install application into. [default: 16:31:43 INFO - "/builds/slave/test"] 16:31:43 INFO - --app=APP Application being installed. [default: firefox] 16:31:43 INFO - mkdir: /builds/slave/test/build/application 16:31:43 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'] 16:31:43 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 16:32:16 INFO - Reading from file tmpfile_stdout 16:32:16 INFO - Output received: 16:32:16 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:32:16 INFO - Running post-action listener: _resource_record_post_action 16:32:16 INFO - [mozharness: 2016-10-24 23:32:16.755785Z] Finished install step (success) 16:32:16 INFO - [mozharness: 2016-10-24 23:32:16.755937Z] Running run-tests step. 16:32:16 INFO - Running pre-action listener: _resource_record_pre_action 16:32:16 INFO - Running main action method: run_tests 16:32:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:32:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:32:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:32:16 INFO - 2016-10-24 16:32:16.770 screenresolution[1944:16682] starting screenresolution argv=screenresolution get 16:32:16 INFO - 2016-10-24 16:32:16.773 screenresolution[1944:16682] Display 0: 1600x1200x32@60 16:32:16 INFO - 2016-10-24 16:32:16.779 screenresolution[1945:16684] starting screenresolution argv=screenresolution list 16:32:16 INFO - Available Modes on Display 0 16:32:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:32:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:32:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:32:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:32:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:32:17 INFO - Intel Iris: 16:32:17 INFO - Chipset Model: Intel Iris 16:32:17 INFO - Type: GPU 16:32:17 INFO - Bus: Built-In 16:32:17 INFO - VRAM (Dynamic, Max): 1536 MB 16:32:17 INFO - Vendor: Intel (0x8086) 16:32:17 INFO - Device ID: 0x0a2e 16:32:17 INFO - Revision ID: 0x0009 16:32:17 INFO - Displays: 16:32:17 INFO - Display: 16:32:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:32:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:32:17 INFO - Display Serial Number: 1600x1200 60 16:32:17 INFO - Main Display: Yes 16:32:17 INFO - Mirror: Off 16:32:17 INFO - Online: Yes 16:32:17 INFO - Rotation: Supported 16:32:17 INFO - Return code: 0 16:32:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:32:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:32:17 INFO - Python 2.7.3 16:32:17 INFO - Return code: 0 16:32:17 INFO - grabbing minidump binary from tooltool 16:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:17 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 0x10e832d30>, '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 0x10e698db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e82ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:32:17 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 16:32:17 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 16:32:17 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 16:32:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:32:17 INFO - Return code: 0 16:32:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:32:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:32:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:32:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:32:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:32:17 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/WC1P55XORRylbGVOut0Z5A/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0060', '--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 16:32:17 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/WC1P55XORRylbGVOut0Z5A/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0060 --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 16:32:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ua8ZwN23JU/Render', 16:32:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:17 INFO - 'HOME': '/Users/cltbld', 16:32:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:17 INFO - 'LOGNAME': 'cltbld', 16:32:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:32:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:32:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:17 INFO - 'MOZ_NO_REMOTE': '1', 16:32:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:32:17 INFO - 'NO_EM_RESTART': '1', 16:32:17 INFO - 'PAGER': '/bin/cat', 16:32:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:17 INFO - 'PWD': '/builds/slave/test', 16:32:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:32:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:17 INFO - 'SHELL': '/bin/bash', 16:32:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dU3XWJehCy/Listeners', 16:32:17 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 16:32:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:17 INFO - 'USER': 'cltbld', 16:32:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:17 INFO - 'XPC_FLAGS': '0x0', 16:32:17 INFO - 'XPC_SERVICE_NAME': '0', 16:32:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:17 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/WC1P55XORRylbGVOut0Z5A/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0060', '--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 16:32:17 INFO - mozversion application_buildid: 20161024140622 16:32:17 INFO - mozversion application_changeset: bf9235ab0289e3fc88cc0fdba9f02ba7983aa695 16:32:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:32:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:32:17 INFO - mozversion application_name: Firefox 16:32:17 INFO - mozversion application_remotingname: firefox-dev 16:32:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:32:17 INFO - mozversion application_vendor: Mozilla 16:32:17 INFO - mozversion application_version: 51.0a2 16:32:17 INFO - mozversion platform_buildid: 20161024140622 16:32:17 INFO - mozversion platform_changeset: bf9235ab0289e3fc88cc0fdba9f02ba7983aa695 16:32:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:32:17 INFO - mozversion platform_version: 51.0a2 16:32:17 INFO - using testdate: 1477351937 16:32:17 INFO - actual date: 1477351937 16:32:17 INFO - starting webserver on 'localhost:53248' 16:32:17 INFO - SUITE-START | Running 2 tests 16:32:17 INFO - TEST-START | dromaeo_css 16:32:17 INFO - operating with platform_type : mac_ 16:32:17 INFO - Initialising browser for dromaeo_css test... 16:32:17 INFO - TEST-INFO | started process 1955 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmpMhMw46/profile http://localhost:53248/getInfo.html) 16:32:20 INFO - PROCESS | 1955 | __metrics Screen width/height:1600/1200 16:32:20 INFO - PROCESS | 1955 | colorDepth:24 16:32:20 INFO - PROCESS | 1955 | Browser inner width/height: 1024/689 16:32:20 INFO - PROCESS | 1955 | __metrics 16:32:20 ERROR - PROCESS | 1955 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 16:32:20 INFO - TEST-INFO | 1955: exit 0 16:32:20 INFO - Browser initialized. 16:32:20 INFO - Running cycle 1/1 for dromaeo_css test... 16:32:20 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmpMhMw46/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:32:32 INFO - PROCESS | 1958 | RSS: Main: 225710080 16:32:32 INFO - PROCESS | 1958 | 16:33:22 INFO - PROCESS | 1958 | 1477352002468 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] 16:35:34 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:53248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53248/tests/dromaeo/cssquery-ext.html) 16:35:36 INFO - PROCESS | 1958 | RSS: Main: 238546944 16:35:36 INFO - PROCESS | 1958 | 16:38:38 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:53248/tests/dromaeo/cssquery-ext.html (next: http://localhost:53248/tests/dromaeo/cssquery-jquery.html) 16:38:38 INFO - PROCESS | 1958 | RSS: Main: 249044992 16:38:38 INFO - PROCESS | 1958 | 16:41:40 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:53248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53248/tests/dromaeo/cssquery-mootools.html) 16:41:41 INFO - PROCESS | 1958 | RSS: Main: 251490304 16:41:41 INFO - PROCESS | 1958 | 16:44:43 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:53248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53248/tests/dromaeo/cssquery-prototype.html) 16:44:43 INFO - PROCESS | 1958 | RSS: Main: 251858944 16:44:43 INFO - PROCESS | 1958 | 16:47:46 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:53248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53248/tests/dromaeo/cssquery-yui.html) 16:47:47 INFO - PROCESS | 1958 | RSS: Main: 256327680 16:47:47 INFO - PROCESS | 1958 | 16:50:49 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:53248/tests/dromaeo/cssquery-yui.html (next: http://localhost:53248/tests/dromaeo/cssquery-dojo.html) 16:50:50 INFO - PROCESS | 1958 | RSS: Main: 258879488 16:50:50 INFO - PROCESS | 1958 | 16:50:50 INFO - PROCESS | 1958 | __start_tp_report 16:50:50 INFO - PROCESS | 1958 | _x_x_mozilla_page_load 16:50:50 INFO - PROCESS | 1958 | _x_x_mozilla_page_load_details 16:50:50 INFO - PROCESS | 1958 | |i|pagename|runs| 16:50:50 INFO - PROCESS | 1958 | |0;dojo.html;2932.706729327067;3433.776804507707;3436.295559410321;3464.61889192189;3474.0099071764544;4475.709078909868;5787.681677507735;5848.327442344132;5876.177335173079;5919.822405327842;5864.3256025557075;5912.3496415394275;5931.733072011759;5975.402459754023;5992.370801065891;5391.245225668409;5394.595405344595;5399.37907140678;5435.211894275328;5446;5151.587872970172;5448.182772584124;5472.644278121929;5474.39781624021;5483.862903427406;3941.7977516857345;4300.505441874193;5227;5266.552343050846;5424.159255315432;5345.732713364355;5360.571154307646;5407.053765591045;5452.972735136339;5495.890082198333;5313.362396512443;5351.866203344908;5384.246205531229;5384.865378365533;5420.783168673288;4717.693349932278;5534.7270127870415;5670.971645141748;6016.578839481238;6023;6186.969065154691;6222.5644204905675;6262.655553944532;6271.498280137624;6321.399467050623;6296.87406251877;6311.779087731908;6317.74729010839;6323.30443651198;6337.239531256233;6004.159417681528;6010.729517171738;6013.128096425994;6028.125921741323;6055.545834062463;6200.224971878515;6205.596636218631;6296.275928268216;6322.241331040304;6335.619862808247;6229.501639868799;6326.841828954313;6334.809955701337;6337.556371054075;6349.587276826992;6296.811095667137;6316.30520642729;6328.6835658216905;6329.525285603599;6344;6172.506199504029;6223.875522489525;6247.531435142382;6253.6560489172625;6258.43674069336;6272;6311.558190926591;6316;6335.619862808247;6337.588056776295;5018.824341148115;5026;5027.547520723079;5031.84904452867;5058.772355244023;4373.562643735601;4436.157130145262;4454.354118652842;4525.072360166158;4532.957419793466;5948.464638182584;5983.19226904371;6002.699865006733;6067.484263837535;6083.148359229712;6272.225995924391;6295.905561416583;6332.176817013851;6333.588316759396;6337.271213810379;5816.243888294579;5911.881762364728;5927.407259274038;5978.730957106941;5996.4603185713495;5553.416891226444;5555.777768889199;5561.63849349791;5584.413636568183;5586.664800112007;6441.935580644134;6455.903161452582;6467;6484.124643173205;6486.513511486563;6177.722002509808;6187.321763625538;6271.749130034747;6304.495640348853;6327.493800495858;6463.612183269019;6466.159399278064;6496.1230233919705;6511.153550038464;6527.836804079746;6321.620702757849;6322.715477803418;6338.366163383625;6355;6355.618662880242;6235.501159907287;6238.064290356483;6257.217847769029;6319.210098737658;6332.176817013943;6191.1641928339095;6262.968685156728;6263.62418254888;6282.308946016026;6291.087792270187;6272.686365681607;6279.215098112736;6279.748810047547;6287.30839607652;6355;5841.386654401226;5896.292444906639;5974.731137098928;5995.100734889801;6142.846428839315;6117.522930757332;6144.109104179958;6158.568900176944;6177.598456100339;6297.960836462115;5545.861353466195;5684.374718781013;6132.233470816148;6158.722857471335;6158.969205153946 16:50:50 INFO - PROCESS | 1958 | |1;ext.html;453.7186944094662;492.13138810000356;495.9906590089169;500.6020213929926;515.6699712184201;35767.64232357679;37572.624273757254;39751.80124099375;42076.368854467204;42155.57844421555;30426.695733042718;43617.56382436175;43653.345199822026;43825.34261986065;43890;9656.275779316544;9790.510474476248;9836.458994755285;9861.408315501058;9874.60501579936;9702.223822094216;9798;9833.65582204623;9834.459104749236;9840.360376575536;9800.803983920317;9818;9825.508724563742;9838.852417213748;9860.457674827881;9745.122938935494;9800.36297640651;9802.754931126708;9804.31369804114;9828.655997040141;9657.855132173023;9718.173955213815;9726.9513652432;9750.414975101447;9752;41073.58926410728;41083.58916410828;41461.585384146376;41561.79219103915;41802;3471.2710330830555;3492.3713731528314;3519.0322661268356;3787.299349620329;4002.3596224603925;30401.391972160654;31107.68892311093;31412.842935785175;31707.04878853615;32778.83610581932;3167.192365946692;3251.6098068231727;3267;3275.148461400029;3377.290768938526;368627;375646;380650;381169.9999999972;382434.08782955905;61458;61735;61849.69075154595;62018.68990655018;62130;34586.7894623692;35131.473027904605;35159;36650.266994659956;56257.43742562522;17083.40208092711;17248.655026899392;17255.74116388255;17258.964462132313;17259.22333494996;13197.47210111604;13204.669883252996;13322.200667959953;13327.200367977952;13340.399682014333;17358.218880150424;19497.317593884145;19498.220071197276;19525.902370488056;19541;8010.919890801134;8144.796380090545;8287.922570065854;8300.916990830014;8322.543554877871;848.8132610825609;907.9001309855911;910.3763921713647;997.7056768253383;1016.7153197104823;29373.503252223374;29792;30561.694383055885;31024.68975310263;31109.066727998197;1013.9442330671736;1064.2177999170603;1094.2941802537318;1095.3756358875523;1147.9655610331704;15297.082175069532;15879.047257164608;15976;16015.199240037951;16162.919185404233;640231;700863;701349;701623;703731;57933.71033144807;57975.71012144996;58555.70722146362;58630;58638;1318.4923804335208;1327.5818117293022;1340.2293681133192;1348.7639663058926;1358.3344161360862;29533.409331813673;29784.851075744482;30250.84874575701;30513.237169070064;31899.521507177877;57059.71470142623;57821.71089144528;57893.4210657888;57900;57948.13077803752;634503;641394.5511907061;641982.7900860466;643419;644260;36193.63806361903;37442.812785935894;40854.1829163421;42080.581538939194;44123;47700.522994770996;47903;48345.27482087842;48632.51367486421;49703;33009.33981320408;38985;40141.397879031254;40154.59845401509;41300.38049429321;39772.80113599414;39867.60132398639;40315.798421007705;40946.59053409547;41137.79431102825;33197.33605327928;38716.225675486894;39113.41329880111;39463.80268098641;39576;33278.83360583182;34956.65043349534;35309.823450882584;35903.102422439646;36062.45906311355;25591.976320946953;25792.61311080373;26012.08957686472;26051.827667754616;26557.7344226563 16:50:50 INFO - PROCESS | 1958 | |2;jquery.html;351.2360615660938;361.9438986957023;370.8942951258891;377.95464544254696;389.2526349409134;20062.799372006277;20505.692414613794;20535.38393848187;20969;21283.25508607199;17372.739408908878;17901.64196716068;18028.18873150708;18358.541036474096;19841.900790496027;5802.274715660543;5891.998360278762;5924.940750592493;6128.754849806002;6181.227346581677;5923.378045305246;6093.299270583873;6095.055266433687;6101.2983506896835;6117.724702388403;5820.38885916979;6012.518998480133;6055.7274922628585;6062.666553339564;6072.149899014142;6013.879722405572;6028.577999540034;6062.757489700407;6063.757449702007;6072.180255665473;5089.618278629117;5245.947540524584;5260.579153667697;5274.498922602346;5302.125149350352;25815.35461613456;25852.87073564639;25934.87032564844;26168.82240299191;26310.473790524084;2365.3140589229274;2382.4996750682203;2404.278716385095;2507.9874600627063;3117.3297740985795;14891.553253402415;15689.063510220343;15704.293306801108;15804;16155.676886462323;1815.8456531194865;1878.7839398469077;1905.3045638342044;1943.9028048597654;1972.8224459798687;89584.10415895823;90459.19081618331;91834.62248066285;109042.3643645346;119481;10576.206784491194;10800.757912839967;10835.620753273597;10841.349519028883;11334.489947952361;12300;13701.794473082911;13827.654308642364;13832.03175777706;13855.722885542435;8589.441686290496;8773.166549177819;8823.55882205887;8934.151255630704;8936.687215947411;7596.51867885768;8891.91108088911;8988.55057247135;9011.026361300756;9133;6548;6692.230393504809;6719.42884854783;6737.427318677869;6771.661416929134;1857.7027675571844;1897.5920177161977;1900.9334673286369;1920.3278852401547;1922.7596550431197;864.9481031138151;928.7028150991617;937.4937533731709;1011.9810977100731;1024.806100892452;22191.22330718417;22414.32757017292;22435.32694019182;22599.20902768395;22667.433314167276;932.6036434515304;957.1146689312358;961.9807603847884;972.3436680240951;981.7972983095651;10044.799104017879;10614.73463163427;11005.62429696288;11297.604583839526;11395.145364097725;568441;570975;573192;596933;600772;126397;128827;130096;142057;145553;956.168133723651;979.9608015679436;994.3387647214521;997.875265591801;1007.7077647482148;18241.45275641733;18996.905015475386;19332.4200273992;19422.320218792276;19442.90278548598;53793.38619841411;54958;55076.449235507134;55143.448565513834;56903.86192276214;79017.60491197737;79953.20046799458;82403;82834.3433131322;84393.73409398741;6853.383195512428;7234.638268086469;7274.236205198378;7302.452316076209;7795.688172473265;8136.918630813616;12303.138780285293;12341.568045118378;12656.810147847973;12718.173318734624;10436.478176091317;10513.474326283807;10660.62687805923;10750.892491074988;10915.563377464812;10503.212259080447;10640.89359106399;10716;10745.409002504937;10791.514381852678;10661.786764264827;10718.35689858611;10880.401577912975;11090.611828586283;11133.610323638957;6864.965675171592;7128.322809333105;7279.308465695751;7338.743143989935;7406.962965185355;8957.193852553302;10514.94742526313;10888;10934.671959841218;10964.56141754321 16:50:50 INFO - PROCESS | 1958 | |3;mootools.html;1440.1790979141888;1485.1757274712534;1645.884788064836;1660.3358656537384;1758.3669878843623;7190;7205.847064469686;7997.800054998614;8605.65577376905;8956.32827537934;8570.614322355494;8918.375713700027;8946.373753837233;9042.683506077288;9046.819063618741;2341.3678306857137;2390.95218095638;2392.7846493815555;2398.0168131066266;2399.124319623342;2006.7692215395198;2373.976260237401;2408.3256688127353;2411.4333131714034;2426.8786560671983;2338.4270853640883;2346.002948746776;2359.929202123939;2361.2207971369407;2367.0413482539598;2099.8635088719184;2312.9653055204185;2362.7519110493495;2367.715874095111;2374.7269064057596;2302.1597117052156;2344.6365813298967;2358.858468491896;2366.0890557135453;2367.727711313187;8942.64229430822;9088.818223635557;9096.135867092682;9129.132732390412;9139.360244782867;5253.975474782419;5300.787968481256;5407.675539467645;5411.891762164734;5439.619226654136;3521.295740851814;3608.4226523756074;3694.131879008431;3711.3876210425246;3718;1047.6333283350843;1072.6138590107555;1082.8700555933337;1092.0881064311309;1110.2394859521253;11721.4139293035;11798.174127810971;11818.054555635614;11848.585299514476;11859.46632401544;4705.4588722296685;4763.095011947719;4772.543847562037;4841.370621819141;4924.8768780780765;10108.797824043479;10209.183265338903;10211.336263142872;10218.437985910847;10230.846537301946;5382.165764306539;5418.729063546807;5423.3491980962535;5426.457354264542;5430.728463576885;4425.114977004612;4569.588737013684;4818.373611430492;4925.950740492621;4939.802407903716;4014.297497937908;4068.5524592294823;4082.1631565528996;4136.420901073792;4174.812133454002;1189.4885199364358;1242.9993854946854;1293.8641442648575;1301.947922083125;1311.1346511302495;856.3277826905849;860.5138096975189;872.7905302727427;912.9452232865916;932.8554074118523;5740.942590574125;5900.557458190653;6027.939720602825;6055.333913269536;6197.225346831646;776.2703059124518;923.4182465046978;947.7820101376584;961.4904100826573;984.0848011349514;3999.960000400017;4098.692598055158;4145.2124096421585;4153.190127925026;4154.584541545882;10735.302205356784;11026.724331891766;11107.055900248408;11115.166362522681;11155.27490713101;10888.727781805519;10973.231873768918;10974.945125274482;11056.723581910517;11085.279456835442;7915.802104947423;8317.085120636724;8343.332533397313;8367.205115514016;8394.496330220207;6103.41311259067;6135.1717518136265;6163.537734669828;6186.257649082139;6206.131141640264;8597.785055373666;10221.846672299773;10246.948765256126;10394.532246048795;10397.58409663605;7900.644470998704;8321.625526851185;8888;10496.055355018085;10648.467576621293;7105.253948335557;7330.853382932418;7570.697172113054;7732.265434783687;7910;8440.83118337642;8728.214460698568;8736.606852691772;8740.956295218482;8778.648854045767;7587.506812057199;7603.011608491082;7663.923360766321;7780.2219778021745;7811.375089992901;7482.962585187257;7539.8492030157995;7547.358474529727;7611.581363025087;7705.460617756928;7031.261717519586;7177.4616903731385;7183.676734547063;7192;7210.242924492853;4984.750762461935;5013.39839219296;5059.367579052619;5178.404483484297;5295.099833028317;4707.882302942454;4767.547083027107;4828.130936431336;5157.432682404858;5288.338957630296 16:50:50 INFO - PROCESS | 1958 | |4;prototype.html;260.57786386054596;295.38854571037945;303.7524417599656;309.5789725972678;311.7552721113926;5249.790008399669;5381.48875856794;5494.697791621459;5569.6658200508;5575.330960284767;4262.403263543099;4473.329000649904;5262.473752624735;5476.603466116145;5525.861853453665;4187.895302617429;4201.495820501529;4215.662746980234;4218.198542276973;4233.364995250721;3961.9603803962023;4156.2726522858375;4242.30002049663;4248.702590818644;4261.829526818923;4061.776602286873;4116.917661646765;4134.4831896013;4137.565555616662;4159.875203743877;4117.505899292074;4140.855070072563;4170.749755014694;4174.205091810521;4181.310083836163;3110.5334199869976;3269.29710112327;3457.858906560829;3576.213233088716;3602.1534939289245;4816.54242846929;5209.218617207412;5347.4919882611475;5358.356997160366;5406.135018397077;3948.4669569608022;4369.759663218521;4724.244120940633;4730.550597693214;4747.287906813971;5099.184130539133;5134.974325128351;5754.856128596777;5816.243888294537;5821.446962538552;3077.0307003517764;3236.514522821572;3882.941755873664;3904.297226499229;3909.3745000799736;6075.878482430327;6086.8782624347705;6107.114468402056;6138.815835524942;6142.771445710831;3541.203229273393;3675.9632403676155;3980.24375368679;3985.3025720498795;3994.7603143811466;3860.8069596520063;3963.742356746802;3973.741531943778;4028.8388464461677;4039.7778122203563;4335.653147748172;4723.574878260973;4723.763811809465;4742.810287588458;4753;4609.53904609543;5858.765649373977;5867.6772777497645;5874.1776151338845;5906.497947674496;1048.9370637761606;1251.2930194440112;1287.795910823383;1297.6820678933723;1365.283226306197;692.435664933088;765.9808504787425;777.1956025513566;807.8707406814881;832.5379414425053;3870.7871067091583;4436.911261774811;4582.862514124582;4628.930566041512;4647.488776234612;4714.114354258324;4982.377202849644;4986;5001.924971125436;5024.045431368028;3757.8538545743263;3872.728908976401;4079.8168531126234;4352.2818734909015;4535.433070866142;2491.2650768023477;2752.8073034887366;3000.639923209229;3056.938861222763;3108.689131086873;5053.494650534917;6062.787802426982;6111.308117611208;6159.291681456601;6193.473554747897;4855.684380515255;5803.88392232153;6017.458428741346;6118.10338794975;6121.877562448815;5569.387367389503;5702.37273899879;6068.783544721305;6148.354422785633;6184.928049103601;4772.737499437564;5594.999575303677;5963.628365475878;5988.520918326611;6046.546509011754;5203.24552939814;5269.841904742864;5358.820120306167;5624.915626265692;5972.701364931823;6253.6560489173535;6301.495880329654;6308.621482711052;6330.430261276507;6333.145025421509;3346.263821959165;3578;3876.3059673526627;3939.980300098481;4081.3469844825872;5000.524950129732;5947.851303717442;6087.543434242361;6095.9390406097145;6098.414412252758;5018.799248030038;5561.721913904208;5652.936678112542;5810.360860305447;5844.795432159854;5556.444355564411;5577.191307260506;5839.708014599338;5855.3559108497175;5872.1778950946045;4245.787710614395;4595.586397224266;5467.507924286833;5491.450854914477;5586.631275337569;5291;5754.2519472469985;5817.738201780845;5841.386654401226;5898.35118136996;4613.838515651936;4982.327385803015;5371.785128594813;5698.572607054404;5728.226689396878 16:50:50 INFO - PROCESS | 1958 | |5;yui.html;642.5823214910308;703.6903762344568;705.3017512662462;744.8622004929085;756.7540549321468;15081.321340539675;15568.84431155688;15776.290066946985;15790.368385264575;15820.762688559666;14053.578392648236;14278.928605356985;14281.92859035706;14295.428182872673;14330.928345358285;654.195339732131;678.1082876018045;826.5330088499978;836.1554829622095;851.3870013590237;830.0661755525034;833.2792134803412;833.4082801211117;834.0700119366923;835.3859912963967;878.3324673248313;891.7235656946335;892.295086881363;894.6510860764307;895.4090300401737;865.926396256319;866.3718803867209;889.7108439757072;890.7060669978924;891.2157301574605;637.0857819029707;637.9011253255753;638.6423602782456;640.4012248547623;641.211310088589;14497;14622.341994610268;14798.926005370013;14822;14855.108693478425;14616.561503154817;14634;14660.926695366456;14699;14754.188519631416;11252.54989800407;11521.42392880361;11624.6512604622;11735.941320293345;12034.33811140387;3746.6440688134585;3751.718621103428;3781.300459415017;3799.3351163546267;3908.2965066288057;116525;123238;123523.3823830884;124465;124784;10775.137988961022;10935.56257749697;11269.830952535718;11280.830787538194;11400.600978965696;19323.710144347846;20280.49298767513;23460.178893738637;23494.882525587604;23549.646755298683;6657.533972621967;8142.307903828122;8165.428420010661;8196.098429172785;8384.706535271236;4322.37325587788;4452.065066336041;4475.5748203920575;4484.887877803016;4615.884602884955;3677.2461645362637;3779.622037796253;3799.8670046548236;3803.4294855771855;3813.7512005055673;587.4477990688739;660.9438197753149;667.3726696904894;669.5614372585964;682.8497730499381;612.470213265531;653.444572113709;659.33736594722;671.3554987212331;671.8488340123433;7011.789646310619;7436.96281518589;9584.28117891161;9597;9603.37578057424;584.6229182177472;629.4366541945025;661.4939571228015;663.8539521305402;673.9494537909676;4486.3494793254795;4710.905781884343;4724.645651576146;4761.547652973031;4785.377900872864;89356;121107;127417;134858;144188;126676.36661816816;131335.68664313236;131808;132127;136828;111447.88552114375;115781;116034.41982790032;117418;118383.40808295904;8875.689350872688;8960.507172105597;9019.639214431349;9032.554791233371;9039;59040.1143982832;61285;61675.691621541606;61776.69111654413;64689.676551618824;85187.14812851792;90068;94724;95962;96023.51988240294;11803;12063.396830158632;12074.102863065149;12131;12510.18683785551;12780.105392622427;12820.423080961566;12870.485180592672;13252.072354935062;13401.66495837612;10352.948235258775;12049.277043377426;12073;12644.747105058032;12780.872191277967;12026.879731202576;12034.338111403607;12037.518499259932;12275.815862762245;12337;12023.338716370683;12155.453004614637;12276.938615306866;12466;12535.811962820382;9842.409455432697;9879.950600246953;10066.094051535398;10290.536925838205;10471.842922356323;7930.286274235346;8866.64533418656;9175.311851611023;9913.256505761952;10078.445685487368 16:50:50 INFO - PROCESS | 1958 | __end_tp_report 16:50:50 INFO - PROCESS | 1958 | __start_cc_report 16:50:50 INFO - PROCESS | 1958 | _x_x_mozilla_cycle_collect,379 16:50:50 INFO - PROCESS | 1958 | __end_cc_report 16:50:50 INFO - PROCESS | 1958 | __startTimestamp1477353050177__endTimestamp 16:50:50 INFO - PROCESS | 1958 | 16:50:50 INFO - PROCESS | 1958 | ------- Summary: start ------- 16:50:50 INFO - PROCESS | 1958 | Number of tests: 6 16:50:50 INFO - PROCESS | 1958 | 16:50:50 INFO - PROCESS | 1958 | [#0] dojo.html Cycles:165 Average:5840.36 Median:6132.23 stddev:687.35 (11.2%) stddev-sans-first:650.51 16:50:50 INFO - PROCESS | 1958 | Values: 2932.7 3433.8 3436.3 3464.6 3474.0 4475.7 5787.7 5848.3 5876.2 5919.8 5864.3 5912.3 5931.7 5975.4 5992.4 5391.2 5394.6 5399.4 5435.2 5446.0 5151.6 5448.2 5472.6 5474.4 5483.9 3941.8 4300.5 5227.0 5266.6 5424.2 5345.7 5360.6 5407.1 5453.0 5495.9 5313.4 5351.9 5384.2 5384.9 5420.8 4717.7 5534.7 5671.0 6016.6 6023.0 6187.0 6222.6 6262.7 6271.5 6321.4 6296.9 6311.8 6317.7 6323.3 6337.2 6004.2 6010.7 6013.1 6028.1 6055.5 6200.2 6205.6 6296.3 6322.2 6335.6 6229.5 6326.8 6334.8 6337.6 6349.6 6296.8 6316.3 6328.7 6329.5 6344.0 6172.5 6223.9 6247.5 6253.7 6258.4 6272.0 6311.6 6316.0 6335.6 6337.6 5018.8 5026.0 5027.5 5031.8 5058.8 4373.6 4436.2 4454.4 4525.1 4533.0 5948.5 5983.2 6002.7 6067.5 6083.1 6272.2 6295.9 6332.2 6333.6 6337.3 5816.2 5911.9 5927.4 5978.7 5996.5 5553.4 5555.8 5561.6 5584.4 5586.7 6441.9 6455.9 6467.0 6484.1 6486.5 6177.7 6187.3 6271.7 6304.5 6327.5 6463.6 6466.2 6496.1 6511.2 6527.8 6321.6 6322.7 6338.4 6355.0 6355.6 6235.5 6238.1 6257.2 6319.2 6332.2 6191.2 6263.0 6263.6 6282.3 6291.1 6272.7 6279.2 6279.7 6287.3 6355.0 5841.4 5896.3 5974.7 5995.1 6142.8 6117.5 6144.1 6158.6 6177.6 6298.0 5545.9 5684.4 6132.2 6158.7 6159.0 16:50:50 INFO - PROCESS | 1958 | 16:50:50 INFO - PROCESS | 1958 | [#1] ext.html Cycles:180 Average:70562.85 Median:40148.00 stddev:157027.16 (391.1%) stddev-sans-first:157379.44 16:50:50 INFO - PROCESS | 1958 | Values: 453.7 492.1 496.0 500.6 515.7 35767.6 37572.6 39751.8 42076.4 42155.6 30426.7 43617.6 43653.3 43825.3 43890.0 9656.3 9790.5 9836.5 9861.4 9874.6 9702.2 9798.0 9833.7 9834.5 9840.4 9800.8 9818.0 9825.5 9838.9 9860.5 9745.1 9800.4 9802.8 9804.3 9828.7 9657.9 9718.2 9727.0 9750.4 9752.0 41073.6 41083.6 41461.6 41561.8 41802.0 3471.3 3492.4 3519.0 3787.3 4002.4 30401.4 31107.7 31412.8 31707.0 32778.8 3167.2 3251.6 3267.0 3275.1 3377.3 368627.0 375646.0 380650.0 381170.0 382434.1 61458.0 61735.0 61849.7 62018.7 62130.0 34586.8 35131.5 35159.0 36650.3 56257.4 17083.4 17248.7 17255.7 17259.0 17259.2 13197.5 13204.7 13322.2 13327.2 13340.4 17358.2 19497.3 19498.2 19525.9 19541.0 8010.9 8144.8 8287.9 8300.9 8322.5 848.8 907.9 910.4 997.7 1016.7 29373.5 29792.0 30561.7 31024.7 31109.1 1013.9 1064.2 1094.3 1095.4 1148.0 15297.1 15879.0 15976.0 16015.2 16162.9 640231.0 700863.0 701349.0 701623.0 703731.0 57933.7 57975.7 58555.7 58630.0 58638.0 1318.5 1327.6 1340.2 1348.8 1358.3 29533.4 29784.9 30250.8 30513.2 31899.5 57059.7 57821.7 57893.4 57900.0 57948.1 634503.0 641394.6 641982.8 643419.0 644260.0 36193.6 37442.8 40854.2 42080.6 44123.0 47700.5 47903.0 48345.3 48632.5 49703.0 33009.3 38985.0 40141.4 40154.6 41300.4 39772.8 39867.6 40315.8 40946.6 41137.8 33197.3 38716.2 39113.4 39463.8 39576.0 33278.8 34956.7 35309.8 35903.1 36062.5 25592.0 25792.6 26012.1 26051.8 26557.7 16:50:50 INFO - PROCESS | 1958 | 16:50:50 INFO - PROCESS | 1958 | [#2] jquery.html Cycles:180 Average:34529.81 Median:26239.65 stddev:97193.71 (370.4%) stddev-sans-first:97432.48 16:50:50 INFO - PROCESS | 1958 | Values: 351.2 361.9 370.9 378.0 389.3 20062.8 20505.7 20535.4 20969.0 21283.3 17372.7 17901.6 18028.2 18358.5 19841.9 5802.3 5892.0 5924.9 6128.8 6181.2 5923.4 6093.3 6095.1 6101.3 6117.7 5820.4 6012.5 6055.7 6062.7 6072.1 6013.9 6028.6 6062.8 6063.8 6072.2 5089.6 5245.9 5260.6 5274.5 5302.1 25815.4 25852.9 25934.9 26168.8 26310.5 2365.3 2382.5 2404.3 2508.0 3117.3 14891.6 15689.1 15704.3 15804.0 16155.7 1815.8 1878.8 1905.3 1943.9 1972.8 89584.1 90459.2 91834.6 109042.4 119481.0 10576.2 10800.8 10835.6 10841.3 11334.5 12300.0 13701.8 13827.7 13832.0 13855.7 8589.4 8773.2 8823.6 8934.2 8936.7 7596.5 8891.9 8988.6 9011.0 9133.0 6548.0 6692.2 6719.4 6737.4 6771.7 1857.7 1897.6 1900.9 1920.3 1922.8 864.9 928.7 937.5 1012.0 1024.8 22191.2 22414.3 22435.3 22599.2 22667.4 932.6 957.1 962.0 972.3 981.8 10044.8 10614.7 11005.6 11297.6 11395.1 568441.0 570975.0 573192.0 596933.0 600772.0 126397.0 128827.0 130096.0 142057.0 145553.0 956.2 980.0 994.3 997.9 1007.7 18241.5 18996.9 19332.4 19422.3 19442.9 53793.4 54958.0 55076.4 55143.4 56903.9 79017.6 79953.2 82403.0 82834.3 84393.7 6853.4 7234.6 7274.2 7302.5 7795.7 8136.9 12303.1 12341.6 12656.8 12718.2 10436.5 10513.5 10660.6 10750.9 10915.6 10503.2 10640.9 10716.0 10745.4 10791.5 10661.8 10718.4 10880.4 11090.6 11133.6 6865.0 7128.3 7279.3 7338.7 7407.0 8957.2 10514.9 10888.0 10934.7 10964.6 16:50:50 INFO - PROCESS | 1958 | 16:50:50 INFO - PROCESS | 1958 | [#3] mootools.html Cycles:180 Average:5777.09 Median:4883.12 stddev:3237.83 (66.3%) stddev-sans-first:3230.51 16:50:50 INFO - PROCESS | 1958 | Values: 1440.2 1485.2 1645.9 1660.3 1758.4 7190.0 7205.8 7997.8 8605.7 8956.3 8570.6 8918.4 8946.4 9042.7 9046.8 2341.4 2391.0 2392.8 2398.0 2399.1 2006.8 2374.0 2408.3 2411.4 2426.9 2338.4 2346.0 2359.9 2361.2 2367.0 2099.9 2313.0 2362.8 2367.7 2374.7 2302.2 2344.6 2358.9 2366.1 2367.7 8942.6 9088.8 9096.1 9129.1 9139.4 5254.0 5300.8 5407.7 5411.9 5439.6 3521.3 3608.4 3694.1 3711.4 3718.0 1047.6 1072.6 1082.9 1092.1 1110.2 11721.4 11798.2 11818.1 11848.6 11859.5 4705.5 4763.1 4772.5 4841.4 4924.9 10108.8 10209.2 10211.3 10218.4 10230.8 5382.2 5418.7 5423.3 5426.5 5430.7 4425.1 4569.6 4818.4 4926.0 4939.8 4014.3 4068.6 4082.2 4136.4 4174.8 1189.5 1243.0 1293.9 1301.9 1311.1 856.3 860.5 872.8 912.9 932.9 5740.9 5900.6 6027.9 6055.3 6197.2 776.3 923.4 947.8 961.5 984.1 4000.0 4098.7 4145.2 4153.2 4154.6 10735.3 11026.7 11107.1 11115.2 11155.3 10888.7 10973.2 10974.9 11056.7 11085.3 7915.8 8317.1 8343.3 8367.2 8394.5 6103.4 6135.2 6163.5 6186.3 6206.1 8597.8 10221.8 10246.9 10394.5 10397.6 7900.6 8321.6 8888.0 10496.1 10648.5 7105.3 7330.9 7570.7 7732.3 7910.0 8440.8 8728.2 8736.6 8741.0 8778.6 7587.5 7603.0 7663.9 7780.2 7811.4 7483.0 7539.8 7547.4 7611.6 7705.5 7031.3 7177.5 7183.7 7192.0 7210.2 4984.8 5013.4 5059.4 5178.4 5295.1 4707.9 4767.5 4828.1 5157.4 5288.3 16:50:50 INFO - PROCESS | 1958 | 16:50:50 INFO - PROCESS | 1958 | [#4] prototype.html Cycles:180 Average:4566.16 Median:4982.35 stddev:1461.82 (29.3%) stddev-sans-first:1429.75 16:50:50 INFO - PROCESS | 1958 | Values: 260.6 295.4 303.8 309.6 311.8 5249.8 5381.5 5494.7 5569.7 5575.3 4262.4 4473.3 5262.5 5476.6 5525.9 4187.9 4201.5 4215.7 4218.2 4233.4 3962.0 4156.3 4242.3 4248.7 4261.8 4061.8 4116.9 4134.5 4137.6 4159.9 4117.5 4140.9 4170.7 4174.2 4181.3 3110.5 3269.3 3457.9 3576.2 3602.2 4816.5 5209.2 5347.5 5358.4 5406.1 3948.5 4369.8 4724.2 4730.6 4747.3 5099.2 5135.0 5754.9 5816.2 5821.4 3077.0 3236.5 3882.9 3904.3 3909.4 6075.9 6086.9 6107.1 6138.8 6142.8 3541.2 3676.0 3980.2 3985.3 3994.8 3860.8 3963.7 3973.7 4028.8 4039.8 4335.7 4723.6 4723.8 4742.8 4753.0 4609.5 5858.8 5867.7 5874.2 5906.5 1048.9 1251.3 1287.8 1297.7 1365.3 692.4 766.0 777.2 807.9 832.5 3870.8 4436.9 4582.9 4628.9 4647.5 4714.1 4982.4 4986.0 5001.9 5024.0 3757.9 3872.7 4079.8 4352.3 4535.4 2491.3 2752.8 3000.6 3056.9 3108.7 5053.5 6062.8 6111.3 6159.3 6193.5 4855.7 5803.9 6017.5 6118.1 6121.9 5569.4 5702.4 6068.8 6148.4 6184.9 4772.7 5595.0 5963.6 5988.5 6046.5 5203.2 5269.8 5358.8 5624.9 5972.7 6253.7 6301.5 6308.6 6330.4 6333.1 3346.3 3578.0 3876.3 3940.0 4081.3 5000.5 5947.9 6087.5 6095.9 6098.4 5018.8 5561.7 5652.9 5810.4 5844.8 5556.4 5577.2 5839.7 5855.4 5872.2 4245.8 4595.6 5467.5 5491.5 5586.6 5291.0 5754.3 5817.7 5841.4 5898.4 4613.8 4982.3 5371.8 5698.6 5728.2 16:50:50 INFO - PROCESS | 1958 | 16:50:50 INFO - PROCESS | 1958 | [#5] yui.html Cycles:180 Average:24483.10 Median:3808.59 stddev:39206.89 (1029.4%) stddev-sans-first:39276.02 16:50:50 INFO - PROCESS | 1958 | Values: 642.6 703.7 705.3 744.9 756.8 15081.3 15568.8 15776.3 15790.4 15820.8 14053.6 14278.9 14281.9 14295.4 14330.9 654.2 678.1 826.5 836.2 851.4 830.1 833.3 833.4 834.1 835.4 878.3 891.7 892.3 894.7 895.4 865.9 866.4 889.7 890.7 891.2 637.1 637.9 638.6 640.4 641.2 14497.0 14622.3 14798.9 14822.0 14855.1 14616.6 14634.0 14660.9 14699.0 14754.2 11252.5 11521.4 11624.7 11735.9 12034.3 3746.6 3751.7 3781.3 3799.3 3908.3 116525.0 123238.0 123523.4 124465.0 124784.0 10775.1 10935.6 11269.8 11280.8 11400.6 19323.7 20280.5 23460.2 23494.9 23549.6 6657.5 8142.3 8165.4 8196.1 8384.7 4322.4 4452.1 4475.6 4484.9 4615.9 3677.2 3779.6 3799.9 3803.4 3813.8 587.4 660.9 667.4 669.6 682.8 612.5 653.4 659.3 671.4 671.8 7011.8 7437.0 9584.3 9597.0 9603.4 584.6 629.4 661.5 663.9 673.9 4486.3 4710.9 4724.6 4761.5 4785.4 89356.0 121107.0 127417.0 134858.0 144188.0 126676.4 131335.7 131808.0 132127.0 136828.0 111447.9 115781.0 116034.4 117418.0 118383.4 8875.7 8960.5 9019.6 9032.6 9039.0 59040.1 61285.0 61675.7 61776.7 64689.7 85187.1 90068.0 94724.0 95962.0 96023.5 11803.0 12063.4 12074.1 12131.0 12510.2 12780.1 12820.4 12870.5 13252.1 13401.7 10352.9 12049.3 12073.0 12644.7 12780.9 12026.9 12034.3 12037.5 12275.8 12337.0 12023.3 12155.5 12276.9 12466.0 12535.8 9842.4 9880.0 10066.1 10290.5 10471.8 7930.3 8866.6 9175.3 9913.3 10078.4 16:50:50 INFO - PROCESS | 1958 | -------- Summary: end -------- 16:50:50 INFO - PROCESS | 1958 | 16:50:50 INFO - TEST-INFO | 1958: exit 0 16:50:50 INFO - TEST-OK | dromaeo_css | took 1113385ms 16:50:50 INFO - TEST-START | kraken 16:50:50 INFO - operating with platform_type : mac_ 16:50:50 INFO - Initialising browser for kraken test... 16:50:50 INFO - TEST-INFO | started process 1965 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmp7KtG9z/profile http://localhost:53248/getInfo.html) 16:50:53 INFO - PROCESS | 1965 | __metrics Screen width/height:1600/1200 16:50:53 INFO - PROCESS | 1965 | colorDepth:24 16:50:53 INFO - PROCESS | 1965 | Browser inner width/height: 1024/689 16:50:53 INFO - PROCESS | 1965 | __metrics 16:50:53 ERROR - PROCESS | 1965 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 16:50:54 INFO - TEST-INFO | 1965: exit 0 16:50:54 INFO - Browser initialized. 16:50:54 INFO - Running cycle 1/1 for kraken test... 16:50:54 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmp7KtG9z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:51:06 INFO - PROCESS | 1967 | RSS: Main: 225001472 16:51:06 INFO - PROCESS | 1967 | 16:51:09 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:53248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53248/tests/kraken/driver.html?testName=audio-beat-detection) 16:51:10 INFO - PROCESS | 1967 | RSS: Main: 237797376 16:51:10 INFO - PROCESS | 1967 | 16:51:13 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:53248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53248/tests/kraken/driver.html?testName=audio-dft) 16:51:13 INFO - PROCESS | 1967 | RSS: Main: 245350400 16:51:13 INFO - PROCESS | 1967 | 16:51:17 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:53248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53248/tests/kraken/driver.html?testName=audio-fft) 16:51:17 INFO - PROCESS | 1967 | RSS: Main: 249208832 16:51:17 INFO - PROCESS | 1967 | 16:51:19 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:53248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53248/tests/kraken/driver.html?testName=audio-oscillator) 16:51:20 INFO - PROCESS | 1967 | RSS: Main: 249417728 16:51:20 INFO - PROCESS | 1967 | 16:51:22 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:53248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:51:22 INFO - PROCESS | 1967 | RSS: Main: 250765312 16:51:22 INFO - PROCESS | 1967 | 16:51:25 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:53248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53248/tests/kraken/driver.html?testName=imaging-darkroom) 16:51:26 INFO - PROCESS | 1967 | RSS: Main: 251777024 16:51:26 INFO - PROCESS | 1967 | 16:51:29 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:53248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53248/tests/kraken/driver.html?testName=imaging-desaturate) 16:51:30 INFO - PROCESS | 1967 | RSS: Main: 251752448 16:51:30 INFO - PROCESS | 1967 | 16:51:32 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:53248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53248/tests/kraken/driver.html?testName=json-parse-financial) 16:51:33 INFO - PROCESS | 1967 | RSS: Main: 252223488 16:51:33 INFO - PROCESS | 1967 | 16:51:35 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:53248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:51:35 INFO - PROCESS | 1967 | RSS: Main: 251912192 16:51:35 INFO - PROCESS | 1967 | 16:51:37 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:53248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53248/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:51:38 INFO - PROCESS | 1967 | RSS: Main: 252194816 16:51:38 INFO - PROCESS | 1967 | 16:51:40 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:53248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:51:41 INFO - PROCESS | 1967 | RSS: Main: 251736064 16:51:41 INFO - PROCESS | 1967 | 16:51:44 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:53248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:51:45 INFO - PROCESS | 1967 | RSS: Main: 252088320 16:51:45 INFO - PROCESS | 1967 | 16:51:47 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:53248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:51:48 INFO - PROCESS | 1967 | RSS: Main: 252149760 16:51:48 INFO - PROCESS | 1967 | 16:51:50 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:53248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53248/tests/kraken/driver.html?testName=ai-astar) 16:51:50 INFO - PROCESS | 1967 | RSS: Main: 253558784 16:51:50 INFO - PROCESS | 1967 | 16:51:50 INFO - PROCESS | 1967 | __start_tp_report 16:51:50 INFO - PROCESS | 1967 | _x_x_mozilla_page_load 16:51:50 INFO - PROCESS | 1967 | _x_x_mozilla_page_load_details 16:51:50 INFO - PROCESS | 1967 | |i|pagename|runs| 16:51:50 INFO - PROCESS | 1967 | |0;ai-astar;113;117;172;164;119;119;118;119;119;121 16:51:50 INFO - PROCESS | 1967 | |1;audio-beat-detection;143;109;109;145;138;144;110;146;180;135 16:51:50 INFO - PROCESS | 1967 | |2;audio-dft;200;199;198;201;187;197;199;200;202;211 16:51:50 INFO - PROCESS | 1967 | |3;audio-fft;78;61;59;84;59;61;60;60;79;58 16:51:50 INFO - PROCESS | 1967 | |4;audio-oscillator;82;70;90;72;69;70;88;69;71;89 16:51:50 INFO - PROCESS | 1967 | |5;imaging-gaussian-blur;94;98;137;90;93;92;94;91;93;90 16:51:50 INFO - PROCESS | 1967 | |6;imaging-darkroom;99;116;153;103;152;155;111;99;97;117 16:51:50 INFO - PROCESS | 1967 | |7;imaging-desaturate;92;93;101;90;94;90;99;95;121;91 16:51:50 INFO - PROCESS | 1967 | |8;json-parse-financial;76;89;83;56;60;59;60;59;59;59 16:51:50 INFO - PROCESS | 1967 | |9;json-stringify-tinderbox;69;59;79;117;111;107;81;70;69;71 16:51:50 INFO - PROCESS | 1967 | |10;stanford-crypto-aes;85;85;87;100;99;83;89;85;85;85 16:51:50 INFO - PROCESS | 1967 | |11;stanford-crypto-ccm;163;162;133;142;141;140;149;169;205;159 16:51:50 INFO - PROCESS | 1967 | |12;stanford-crypto-pbkdf2;154;170;168;173;173;176;169;172;170;173 16:51:50 INFO - PROCESS | 1967 | |13;stanford-crypto-sha256-iterative;70;70;69;70;70;84;78;70;68;70 16:51:50 INFO - PROCESS | 1967 | __end_tp_report 16:51:50 INFO - PROCESS | 1967 | __start_cc_report 16:51:50 INFO - PROCESS | 1967 | _x_x_mozilla_cycle_collect,976 16:51:50 INFO - PROCESS | 1967 | __end_cc_report 16:51:50 INFO - PROCESS | 1967 | __startTimestamp1477353110581__endTimestamp 16:51:50 INFO - PROCESS | 1967 | 16:51:50 INFO - PROCESS | 1967 | ------- Summary: start ------- 16:51:50 INFO - PROCESS | 1967 | Number of tests: 14 16:51:50 INFO - PROCESS | 1967 | 16:51:50 INFO - PROCESS | 1967 | [#0] ai-astar Cycles:10 Average:128.10 Median:119.00 stddev:21.22 (17.8%) stddev-sans-first:21.79 16:51:50 INFO - PROCESS | 1967 | Values: 113.0 117.0 172.0 164.0 119.0 119.0 118.0 119.0 119.0 121.0 16:51:50 INFO - PROCESS | 1967 | 16:51:50 INFO - PROCESS | 1967 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:143.50 stddev:22.03 (15.4%) stddev-sans-first:23.22 16:51:50 INFO - PROCESS | 1967 | Values: 143.0 109.0 109.0 145.0 138.0 144.0 110.0 146.0 180.0 135.0 16:51:50 INFO - PROCESS | 1967 | 16:51:50 INFO - PROCESS | 1967 | [#2] audio-dft Cycles:10 Average:199.40 Median:200.00 stddev:5.83 (2.9%) stddev-sans-first:6.18 16:51:50 INFO - PROCESS | 1967 | Values: 200.0 199.0 198.0 201.0 187.0 197.0 199.0 200.0 202.0 211.0 16:51:50 INFO - PROCESS | 1967 | 16:51:50 INFO - PROCESS | 1967 | [#3] audio-fft Cycles:10 Average:65.90 Median:61.00 stddev:10.12 (16.6%) stddev-sans-first:9.74 16:51:50 INFO - PROCESS | 1967 | Values: 78.0 61.0 59.0 84.0 59.0 61.0 60.0 60.0 79.0 58.0 16:51:50 INFO - PROCESS | 1967 | 16:51:50 INFO - PROCESS | 1967 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:77.00 stddev:9.10 (11.8%) stddev-sans-first:9.48 16:51:50 INFO - PROCESS | 1967 | Values: 82.0 70.0 90.0 72.0 69.0 70.0 88.0 69.0 71.0 89.0 16:51:50 INFO - PROCESS | 1967 | 16:51:50 INFO - PROCESS | 1967 | [#5] imaging-gaussian-blur Cycles:10 Average:97.20 Median:93.00 stddev:14.18 (15.2%) stddev-sans-first:14.99 16:51:50 INFO - PROCESS | 1967 | Values: 94.0 98.0 137.0 90.0 93.0 92.0 94.0 91.0 93.0 90.0 16:51:50 INFO - PROCESS | 1967 | 16:51:50 INFO - PROCESS | 1967 | [#6] imaging-darkroom Cycles:10 Average:120.20 Median:154.00 stddev:23.91 (15.5%) stddev-sans-first:24.09 16:51:50 INFO - PROCESS | 1967 | Values: 99.0 116.0 153.0 103.0 152.0 155.0 111.0 99.0 97.0 117.0 16:51:50 INFO - PROCESS | 1967 | 16:51:50 INFO - PROCESS | 1967 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:92.50 stddev:9.32 (10.1%) stddev-sans-first:9.74 16:51:50 INFO - PROCESS | 1967 | Values: 92.0 93.0 101.0 90.0 94.0 90.0 99.0 95.0 121.0 91.0 16:51:50 INFO - PROCESS | 1967 | 16:51:50 INFO - PROCESS | 1967 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:60.00 stddev:11.95 (19.9%) stddev-sans-first:12.12 16:51:50 INFO - PROCESS | 1967 | Values: 76.0 89.0 83.0 56.0 60.0 59.0 60.0 59.0 59.0 59.0 16:51:50 INFO - PROCESS | 1967 | 16:51:50 INFO - PROCESS | 1967 | [#9] json-stringify-tinderbox Cycles:10 Average:83.30 Median:69.50 stddev:20.59 (29.6%) stddev-sans-first:21.18 16:51:50 INFO - PROCESS | 1967 | Values: 69.0 59.0 79.0 117.0 111.0 107.0 81.0 70.0 69.0 71.0 16:51:50 INFO - PROCESS | 1967 | 16:51:50 INFO - PROCESS | 1967 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:85.00 stddev:6.11 (7.2%) stddev-sans-first:6.36 16:51:50 INFO - PROCESS | 1967 | Values: 85.0 85.0 87.0 100.0 99.0 83.0 89.0 85.0 85.0 85.0 16:51:50 INFO - PROCESS | 1967 | 16:51:50 INFO - PROCESS | 1967 | [#11] stanford-crypto-ccm Cycles:10 Average:156.30 Median:160.50 stddev:20.86 (13.0%) stddev-sans-first:21.99 16:51:50 INFO - PROCESS | 1967 | Values: 163.0 162.0 133.0 142.0 141.0 140.0 149.0 169.0 205.0 159.0 16:51:50 INFO - PROCESS | 1967 | 16:51:50 INFO - PROCESS | 1967 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.80 Median:172.50 stddev:6.03 (3.5%) stddev-sans-first:2.51 16:51:50 INFO - PROCESS | 1967 | Values: 154.0 170.0 168.0 173.0 173.0 176.0 169.0 172.0 170.0 173.0 16:51:50 INFO - PROCESS | 1967 | 16:51:50 INFO - PROCESS | 1967 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:70.00 stddev:5.04 (7.2%) stddev-sans-first:5.30 16:51:50 INFO - PROCESS | 1967 | Values: 70.0 70.0 69.0 70.0 70.0 84.0 78.0 70.0 68.0 70.0 16:51:50 INFO - PROCESS | 1967 | -------- Summary: end -------- 16:51:50 INFO - PROCESS | 1967 | 16:51:51 INFO - TEST-INFO | 1967: exit 0 16:51:51 INFO - TEST-OK | kraken | took 60653ms 16:51:51 INFO - SUITE-END | took 1174s 16:51:51 INFO - Completed test suite (00:19:34) 16:51:51 INFO - javascript benchmark 16:51:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7401.933071572246, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2932.706729327067, 3433.776804507707, 3436.295559410321, 3464.61889192189, 3474.0099071764544, 4475.709078909868, 5787.681677507735, 5848.327442344132, 5876.177335173079, 5919.822405327842, 5864.3256025557075, 5912.3496415394275, 5931.733072011759, 5975.402459754023, 5992.370801065891, 5391.245225668409, 5394.595405344595, 5399.37907140678, 5435.211894275328, 5446.0, 5151.587872970172, 5448.182772584124, 5472.644278121929, 5474.39781624021, 5483.862903427406, 3941.7977516857345, 4300.505441874193, 5227.0, 5266.552343050846, 5424.159255315432, 5345.732713364355, 5360.571154307646, 5407.053765591045, 5452.972735136339, 5495.890082198333, 5313.362396512443, 5351.866203344908, 5384.246205531229, 5384.865378365533, 5420.783168673288, 4717.693349932278, 5534.7270127870415, 5670.971645141748, 6016.578839481238, 6023.0, 6186.969065154691, 6222.5644204905675, 6262.655553944532, 6271.498280137624, 6321.399467050623, 6296.87406251877, 6311.779087731908, 6317.74729010839, 6323.30443651198, 6337.239531256233, 6004.159417681528, 6010.729517171738, 6013.128096425994, 6028.125921741323, 6055.545834062463, 6200.224971878515, 6205.596636218631, 6296.275928268216, 6322.241331040304, 6335.619862808247, 6229.501639868799, 6326.841828954313, 6334.809955701337, 6337.556371054075, 6349.587276826992, 6296.811095667137, 6316.30520642729, 6328.6835658216905, 6329.525285603599, 6344.0, 6172.506199504029, 6223.875522489525, 6247.531435142382, 6253.6560489172625, 6258.43674069336, 6272.0, 6311.558190926591, 6316.0, 6335.619862808247, 6337.588056776295, 5018.824341148115, 5026.0, 5027.547520723079, 5031.84904452867, 5058.772355244023, 4373.562643735601, 4436.157130145262, 4454.354118652842, 4525.072360166158, 4532.957419793466, 5948.464638182584, 5983.19226904371, 6002.699865006733, 6067.484263837535, 6083.148359229712, 6272.225995924391, 6295.905561416583, 6332.176817013851, 6333.588316759396, 6337.271213810379, 5816.243888294579, 5911.881762364728, 5927.407259274038, 5978.730957106941, 5996.4603185713495, 5553.416891226444, 5555.777768889199, 5561.63849349791, 5584.413636568183, 5586.664800112007, 6441.935580644134, 6455.903161452582, 6467.0, 6484.124643173205, 6486.513511486563, 6177.722002509808, 6187.321763625538, 6271.749130034747, 6304.495640348853, 6327.493800495858, 6463.612183269019, 6466.159399278064, 6496.1230233919705, 6511.153550038464, 6527.836804079746, 6321.620702757849, 6322.715477803418, 6338.366163383625, 6355.0, 6355.618662880242, 6235.501159907287, 6238.064290356483, 6257.217847769029, 6319.210098737658, 6332.176817013943, 6191.1641928339095, 6262.968685156728, 6263.62418254888, 6282.308946016026, 6291.087792270187, 6272.686365681607, 6279.215098112736, 6279.748810047547, 6287.30839607652, 6355.0, 5841.386654401226, 5896.292444906639, 5974.731137098928, 5995.100734889801, 6142.846428839315, 6117.522930757332, 6144.109104179958, 6158.568900176944, 6177.598456100339, 6297.960836462115, 5545.861353466195, 5684.374718781013, 6132.233470816148, 6158.722857471335, 6158.969205153946], "value": 5795.191611728679, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [453.7186944094662, 492.13138810000356, 495.9906590089169, 500.6020213929926, 515.6699712184201, 35767.64232357679, 37572.624273757254, 39751.80124099375, 42076.368854467204, 42155.57844421555, 30426.695733042718, 43617.56382436175, 43653.345199822026, 43825.34261986065, 43890.0, 9656.275779316544, 9790.510474476248, 9836.458994755285, 9861.408315501058, 9874.60501579936, 9702.223822094216, 9798.0, 9833.65582204623, 9834.459104749236, 9840.360376575536, 9800.803983920317, 9818.0, 9825.508724563742, 9838.852417213748, 9860.457674827881, 9745.122938935494, 9800.36297640651, 9802.754931126708, 9804.31369804114, 9828.655997040141, 9657.855132173023, 9718.173955213815, 9726.9513652432, 9750.414975101447, 9752.0, 41073.58926410728, 41083.58916410828, 41461.585384146376, 41561.79219103915, 41802.0, 3471.2710330830555, 3492.3713731528314, 3519.0322661268356, 3787.299349620329, 4002.3596224603925, 30401.391972160654, 31107.68892311093, 31412.842935785175, 31707.04878853615, 32778.83610581932, 3167.192365946692, 3251.6098068231727, 3267.0, 3275.148461400029, 3377.290768938526, 368627.0, 375646.0, 380650.0, 381169.9999999972, 382434.08782955905, 61458.0, 61735.0, 61849.69075154595, 62018.68990655018, 62130.0, 34586.7894623692, 35131.473027904605, 35159.0, 36650.266994659956, 56257.43742562522, 17083.40208092711, 17248.655026899392, 17255.74116388255, 17258.964462132313, 17259.22333494996, 13197.47210111604, 13204.669883252996, 13322.200667959953, 13327.200367977952, 13340.399682014333, 17358.218880150424, 19497.317593884145, 19498.220071197276, 19525.902370488056, 19541.0, 8010.919890801134, 8144.796380090545, 8287.922570065854, 8300.916990830014, 8322.543554877871, 848.8132610825609, 907.9001309855911, 910.3763921713647, 997.7056768253383, 1016.7153197104823, 29373.503252223374, 29792.0, 30561.694383055885, 31024.68975310263, 31109.066727998197, 1013.9442330671736, 1064.2177999170603, 1094.2941802537318, 1095.3756358875523, 1147.9655610331704, 15297.082175069532, 15879.047257164608, 15976.0, 16015.199240037951, 16162.919185404233, 640231.0, 700863.0, 701349.0, 701623.0, 703731.0, 57933.71033144807, 57975.71012144996, 58555.70722146362, 58630.0, 58638.0, 1318.4923804335208, 1327.5818117293022, 1340.2293681133192, 1348.7639663058926, 1358.3344161360862, 29533.409331813673, 29784.851075744482, 30250.84874575701, 30513.237169070064, 31899.521507177877, 57059.71470142623, 57821.71089144528, 57893.4210657888, 57900.0, 57948.13077803752, 634503.0, 641394.5511907061, 641982.7900860466, 643419.0, 644260.0, 36193.63806361903, 37442.812785935894, 40854.1829163421, 42080.581538939194, 44123.0, 47700.522994770996, 47903.0, 48345.27482087842, 48632.51367486421, 49703.0, 33009.33981320408, 38985.0, 40141.397879031254, 40154.59845401509, 41300.38049429321, 39772.80113599414, 39867.60132398639, 40315.798421007705, 40946.59053409547, 41137.79431102825, 33197.33605327928, 38716.225675486894, 39113.41329880111, 39463.80268098641, 39576.0, 33278.83360583182, 34956.65043349534, 35309.823450882584, 35903.102422439646, 36062.45906311355, 25591.976320946953, 25792.61311080373, 26012.08957686472, 26051.827667754616, 26557.7344226563], "value": 20293.328237853104, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.2360615660938, 361.9438986957023, 370.8942951258891, 377.95464544254696, 389.2526349409134, 20062.799372006277, 20505.692414613794, 20535.38393848187, 20969.0, 21283.25508607199, 17372.739408908878, 17901.64196716068, 18028.18873150708, 18358.541036474096, 19841.900790496027, 5802.274715660543, 5891.998360278762, 5924.940750592493, 6128.754849806002, 6181.227346581677, 5923.378045305246, 6093.299270583873, 6095.055266433687, 6101.2983506896835, 6117.724702388403, 5820.38885916979, 6012.518998480133, 6055.7274922628585, 6062.666553339564, 6072.149899014142, 6013.879722405572, 6028.577999540034, 6062.757489700407, 6063.757449702007, 6072.180255665473, 5089.618278629117, 5245.947540524584, 5260.579153667697, 5274.498922602346, 5302.125149350352, 25815.35461613456, 25852.87073564639, 25934.87032564844, 26168.82240299191, 26310.473790524084, 2365.3140589229274, 2382.4996750682203, 2404.278716385095, 2507.9874600627063, 3117.3297740985795, 14891.553253402415, 15689.063510220343, 15704.293306801108, 15804.0, 16155.676886462323, 1815.8456531194865, 1878.7839398469077, 1905.3045638342044, 1943.9028048597654, 1972.8224459798687, 89584.10415895823, 90459.19081618331, 91834.62248066285, 109042.3643645346, 119481.0, 10576.206784491194, 10800.757912839967, 10835.620753273597, 10841.349519028883, 11334.489947952361, 12300.0, 13701.794473082911, 13827.654308642364, 13832.03175777706, 13855.722885542435, 8589.441686290496, 8773.166549177819, 8823.55882205887, 8934.151255630704, 8936.687215947411, 7596.51867885768, 8891.91108088911, 8988.55057247135, 9011.026361300756, 9133.0, 6548.0, 6692.230393504809, 6719.42884854783, 6737.427318677869, 6771.661416929134, 1857.7027675571844, 1897.5920177161977, 1900.9334673286369, 1920.3278852401547, 1922.7596550431197, 864.9481031138151, 928.7028150991617, 937.4937533731709, 1011.9810977100731, 1024.806100892452, 22191.22330718417, 22414.32757017292, 22435.32694019182, 22599.20902768395, 22667.433314167276, 932.6036434515304, 957.1146689312358, 961.9807603847884, 972.3436680240951, 981.7972983095651, 10044.799104017879, 10614.73463163427, 11005.62429696288, 11297.604583839526, 11395.145364097725, 568441.0, 570975.0, 573192.0, 596933.0, 600772.0, 126397.0, 128827.0, 130096.0, 142057.0, 145553.0, 956.168133723651, 979.9608015679436, 994.3387647214521, 997.875265591801, 1007.7077647482148, 18241.45275641733, 18996.905015475386, 19332.4200273992, 19422.320218792276, 19442.90278548598, 53793.38619841411, 54958.0, 55076.449235507134, 55143.448565513834, 56903.86192276214, 79017.60491197737, 79953.20046799458, 82403.0, 82834.3433131322, 84393.73409398741, 6853.383195512428, 7234.638268086469, 7274.236205198378, 7302.452316076209, 7795.688172473265, 8136.918630813616, 12303.138780285293, 12341.568045118378, 12656.810147847973, 12718.173318734624, 10436.478176091317, 10513.474326283807, 10660.62687805923, 10750.892491074988, 10915.563377464812, 10503.212259080447, 10640.89359106399, 10716.0, 10745.409002504937, 10791.514381852678, 10661.786764264827, 10718.35689858611, 10880.401577912975, 11090.611828586283, 11133.610323638957, 6864.965675171592, 7128.322809333105, 7279.308465695751, 7338.743143989935, 7406.962965185355, 8957.193852553302, 10514.94742526313, 10888.0, 10934.671959841218, 10964.56141754321], "value": 9693.914056836287, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.1790979141888, 1485.1757274712534, 1645.884788064836, 1660.3358656537384, 1758.3669878843623, 7190.0, 7205.847064469686, 7997.800054998614, 8605.65577376905, 8956.32827537934, 8570.614322355494, 8918.375713700027, 8946.373753837233, 9042.683506077288, 9046.819063618741, 2341.3678306857137, 2390.95218095638, 2392.7846493815555, 2398.0168131066266, 2399.124319623342, 2006.7692215395198, 2373.976260237401, 2408.3256688127353, 2411.4333131714034, 2426.8786560671983, 2338.4270853640883, 2346.002948746776, 2359.929202123939, 2361.2207971369407, 2367.0413482539598, 2099.8635088719184, 2312.9653055204185, 2362.7519110493495, 2367.715874095111, 2374.7269064057596, 2302.1597117052156, 2344.6365813298967, 2358.858468491896, 2366.0890557135453, 2367.727711313187, 8942.64229430822, 9088.818223635557, 9096.135867092682, 9129.132732390412, 9139.360244782867, 5253.975474782419, 5300.787968481256, 5407.675539467645, 5411.891762164734, 5439.619226654136, 3521.295740851814, 3608.4226523756074, 3694.131879008431, 3711.3876210425246, 3718.0, 1047.6333283350843, 1072.6138590107555, 1082.8700555933337, 1092.0881064311309, 1110.2394859521253, 11721.4139293035, 11798.174127810971, 11818.054555635614, 11848.585299514476, 11859.46632401544, 4705.4588722296685, 4763.095011947719, 4772.543847562037, 4841.370621819141, 4924.8768780780765, 10108.797824043479, 10209.183265338903, 10211.336263142872, 10218.437985910847, 10230.846537301946, 5382.165764306539, 5418.729063546807, 5423.3491980962535, 5426.457354264542, 5430.728463576885, 4425.114977004612, 4569.588737013684, 4818.373611430492, 4925.950740492621, 4939.802407903716, 4014.297497937908, 4068.5524592294823, 4082.1631565528996, 4136.420901073792, 4174.812133454002, 1189.4885199364358, 1242.9993854946854, 1293.8641442648575, 1301.947922083125, 1311.1346511302495, 856.3277826905849, 860.5138096975189, 872.7905302727427, 912.9452232865916, 932.8554074118523, 5740.942590574125, 5900.557458190653, 6027.939720602825, 6055.333913269536, 6197.225346831646, 776.2703059124518, 923.4182465046978, 947.7820101376584, 961.4904100826573, 984.0848011349514, 3999.960000400017, 4098.692598055158, 4145.2124096421585, 4153.190127925026, 4154.584541545882, 10735.302205356784, 11026.724331891766, 11107.055900248408, 11115.166362522681, 11155.27490713101, 10888.727781805519, 10973.231873768918, 10974.945125274482, 11056.723581910517, 11085.279456835442, 7915.802104947423, 8317.085120636724, 8343.332533397313, 8367.205115514016, 8394.496330220207, 6103.41311259067, 6135.1717518136265, 6163.537734669828, 6186.257649082139, 6206.131141640264, 8597.785055373666, 10221.846672299773, 10246.948765256126, 10394.532246048795, 10397.58409663605, 7900.644470998704, 8321.625526851185, 8888.0, 10496.055355018085, 10648.467576621293, 7105.253948335557, 7330.853382932418, 7570.697172113054, 7732.265434783687, 7910.0, 8440.83118337642, 8728.214460698568, 8736.606852691772, 8740.956295218482, 8778.648854045767, 7587.506812057199, 7603.011608491082, 7663.923360766321, 7780.2219778021745, 7811.375089992901, 7482.962585187257, 7539.8492030157995, 7547.358474529727, 7611.581363025087, 7705.460617756928, 7031.261717519586, 7177.4616903731385, 7183.676734547063, 7192.0, 7210.242924492853, 4984.750762461935, 5013.39839219296, 5059.367579052619, 5178.404483484297, 5295.099833028317, 4707.882302942454, 4767.547083027107, 4828.130936431336, 5157.432682404858, 5288.338957630296], "value": 4633.326565038291, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [260.57786386054596, 295.38854571037945, 303.7524417599656, 309.5789725972678, 311.7552721113926, 5249.790008399669, 5381.48875856794, 5494.697791621459, 5569.6658200508, 5575.330960284767, 4262.403263543099, 4473.329000649904, 5262.473752624735, 5476.603466116145, 5525.861853453665, 4187.895302617429, 4201.495820501529, 4215.662746980234, 4218.198542276973, 4233.364995250721, 3961.9603803962023, 4156.2726522858375, 4242.30002049663, 4248.702590818644, 4261.829526818923, 4061.776602286873, 4116.917661646765, 4134.4831896013, 4137.565555616662, 4159.875203743877, 4117.505899292074, 4140.855070072563, 4170.749755014694, 4174.205091810521, 4181.310083836163, 3110.5334199869976, 3269.29710112327, 3457.858906560829, 3576.213233088716, 3602.1534939289245, 4816.54242846929, 5209.218617207412, 5347.4919882611475, 5358.356997160366, 5406.135018397077, 3948.4669569608022, 4369.759663218521, 4724.244120940633, 4730.550597693214, 4747.287906813971, 5099.184130539133, 5134.974325128351, 5754.856128596777, 5816.243888294537, 5821.446962538552, 3077.0307003517764, 3236.514522821572, 3882.941755873664, 3904.297226499229, 3909.3745000799736, 6075.878482430327, 6086.8782624347705, 6107.114468402056, 6138.815835524942, 6142.771445710831, 3541.203229273393, 3675.9632403676155, 3980.24375368679, 3985.3025720498795, 3994.7603143811466, 3860.8069596520063, 3963.742356746802, 3973.741531943778, 4028.8388464461677, 4039.7778122203563, 4335.653147748172, 4723.574878260973, 4723.763811809465, 4742.810287588458, 4753.0, 4609.53904609543, 5858.765649373977, 5867.6772777497645, 5874.1776151338845, 5906.497947674496, 1048.9370637761606, 1251.2930194440112, 1287.795910823383, 1297.6820678933723, 1365.283226306197, 692.435664933088, 765.9808504787425, 777.1956025513566, 807.8707406814881, 832.5379414425053, 3870.7871067091583, 4436.911261774811, 4582.862514124582, 4628.930566041512, 4647.488776234612, 4714.114354258324, 4982.377202849644, 4986.0, 5001.924971125436, 5024.045431368028, 3757.8538545743263, 3872.728908976401, 4079.8168531126234, 4352.2818734909015, 4535.433070866142, 2491.2650768023477, 2752.8073034887366, 3000.639923209229, 3056.938861222763, 3108.689131086873, 5053.494650534917, 6062.787802426982, 6111.308117611208, 6159.291681456601, 6193.473554747897, 4855.684380515255, 5803.88392232153, 6017.458428741346, 6118.10338794975, 6121.877562448815, 5569.387367389503, 5702.37273899879, 6068.783544721305, 6148.354422785633, 6184.928049103601, 4772.737499437564, 5594.999575303677, 5963.628365475878, 5988.520918326611, 6046.546509011754, 5203.24552939814, 5269.841904742864, 5358.820120306167, 5624.915626265692, 5972.701364931823, 6253.6560489173535, 6301.495880329654, 6308.621482711052, 6330.430261276507, 6333.145025421509, 3346.263821959165, 3578.0, 3876.3059673526627, 3939.980300098481, 4081.3469844825872, 5000.524950129732, 5947.851303717442, 6087.543434242361, 6095.9390406097145, 6098.414412252758, 5018.799248030038, 5561.721913904208, 5652.936678112542, 5810.360860305447, 5844.795432159854, 5556.444355564411, 5577.191307260506, 5839.708014599338, 5855.3559108497175, 5872.1778950946045, 4245.787710614395, 4595.586397224266, 5467.507924286833, 5491.450854914477, 5586.631275337569, 5291.0, 5754.2519472469985, 5817.738201780845, 5841.386654401226, 5898.35118136996, 4613.838515651936, 4982.327385803015, 5371.785128594813, 5698.572607054404, 5728.226689396878], "value": 4087.6502192591597, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.5823214910308, 703.6903762344568, 705.3017512662462, 744.8622004929085, 756.7540549321468, 15081.321340539675, 15568.84431155688, 15776.290066946985, 15790.368385264575, 15820.762688559666, 14053.578392648236, 14278.928605356985, 14281.92859035706, 14295.428182872673, 14330.928345358285, 654.195339732131, 678.1082876018045, 826.5330088499978, 836.1554829622095, 851.3870013590237, 830.0661755525034, 833.2792134803412, 833.4082801211117, 834.0700119366923, 835.3859912963967, 878.3324673248313, 891.7235656946335, 892.295086881363, 894.6510860764307, 895.4090300401737, 865.926396256319, 866.3718803867209, 889.7108439757072, 890.7060669978924, 891.2157301574605, 637.0857819029707, 637.9011253255753, 638.6423602782456, 640.4012248547623, 641.211310088589, 14497.0, 14622.341994610268, 14798.926005370013, 14822.0, 14855.108693478425, 14616.561503154817, 14634.0, 14660.926695366456, 14699.0, 14754.188519631416, 11252.54989800407, 11521.42392880361, 11624.6512604622, 11735.941320293345, 12034.33811140387, 3746.6440688134585, 3751.718621103428, 3781.300459415017, 3799.3351163546267, 3908.2965066288057, 116525.0, 123238.0, 123523.3823830884, 124465.0, 124784.0, 10775.137988961022, 10935.56257749697, 11269.830952535718, 11280.830787538194, 11400.600978965696, 19323.710144347846, 20280.49298767513, 23460.178893738637, 23494.882525587604, 23549.646755298683, 6657.533972621967, 8142.307903828122, 8165.428420010661, 8196.098429172785, 8384.706535271236, 4322.37325587788, 4452.065066336041, 4475.5748203920575, 4484.887877803016, 4615.884602884955, 3677.2461645362637, 3779.622037796253, 3799.8670046548236, 3803.4294855771855, 3813.7512005055673, 587.4477990688739, 660.9438197753149, 667.3726696904894, 669.5614372585964, 682.8497730499381, 612.470213265531, 653.444572113709, 659.33736594722, 671.3554987212331, 671.8488340123433, 7011.789646310619, 7436.96281518589, 9584.28117891161, 9597.0, 9603.37578057424, 584.6229182177472, 629.4366541945025, 661.4939571228015, 663.8539521305402, 673.9494537909676, 4486.3494793254795, 4710.905781884343, 4724.645651576146, 4761.547652973031, 4785.377900872864, 89356.0, 121107.0, 127417.0, 134858.0, 144188.0, 126676.36661816816, 131335.68664313236, 131808.0, 132127.0, 136828.0, 111447.88552114375, 115781.0, 116034.41982790032, 117418.0, 118383.40808295904, 8875.689350872688, 8960.507172105597, 9019.639214431349, 9032.554791233371, 9039.0, 59040.1143982832, 61285.0, 61675.691621541606, 61776.69111654413, 64689.676551618824, 85187.14812851792, 90068.0, 94724.0, 95962.0, 96023.51988240294, 11803.0, 12063.396830158632, 12074.102863065149, 12131.0, 12510.18683785551, 12780.105392622427, 12820.423080961566, 12870.485180592672, 13252.072354935062, 13401.66495837612, 10352.948235258775, 12049.277043377426, 12073.0, 12644.747105058032, 12780.872191277967, 12026.879731202576, 12034.338111403607, 12037.518499259932, 12275.815862762245, 12337.0, 12023.338716370683, 12155.453004614637, 12276.938615306866, 12466.0, 12535.811962820382, 9842.409455432697, 9879.950600246953, 10066.094051535398, 10290.536925838205, 10471.842922356323, 7930.286274235346, 8866.64533418656, 9175.311851611023, 9913.256505761952, 10078.445685487368], "value": 7616.193145888957, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1555.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 172.0, 164.0, 119.0, 119.0, 118.0, 119.0, 119.0, 121.0], "value": 128.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 109.0, 109.0, 145.0, 138.0, 144.0, 110.0, 146.0, 180.0, 135.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 199.0, 198.0, 201.0, 187.0, 197.0, 199.0, 200.0, 202.0, 211.0], "value": 199.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 61.0, 59.0, 84.0, 59.0, 61.0, 60.0, 60.0, 79.0, 58.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 70.0, 90.0, 72.0, 69.0, 70.0, 88.0, 69.0, 71.0, 89.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 98.0, 137.0, 90.0, 93.0, 92.0, 94.0, 91.0, 93.0, 90.0], "value": 97.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 116.0, 153.0, 103.0, 152.0, 155.0, 111.0, 99.0, 97.0, 117.0], "value": 120.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 101.0, 90.0, 94.0, 90.0, 99.0, 95.0, 121.0, 91.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 89.0, 83.0, 56.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 59.0, 79.0, 117.0, 111.0, 107.0, 81.0, 70.0, 69.0, 71.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 87.0, 100.0, 99.0, 83.0, 89.0, 85.0, 85.0, 85.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 133.0, 142.0, 141.0, 140.0, 149.0, 169.0, 205.0, 159.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 170.0, 168.0, 173.0, 173.0, 176.0, 169.0, 172.0, 170.0, 173.0], "value": 169.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 70.0, 70.0, 84.0, 78.0, 70.0, 68.0, 70.0], "value": 71.9, "unit": "score"}]}]} 16:51:51 INFO - Return code: 0 16:51:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:51:51 ERROR - # TBPL SUCCESS # 16:51:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:51:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:51:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:51:51 INFO - 2016-10-24 16:51:51.921 screenresolution[1972:19585] starting screenresolution argv=screenresolution get 16:51:51 INFO - 2016-10-24 16:51:51.924 screenresolution[1972:19585] Display 0: 1600x1200x32@60 16:51:51 INFO - 2016-10-24 16:51:51.930 screenresolution[1973:19588] starting screenresolution argv=screenresolution list 16:51:51 INFO - Available Modes on Display 0 16:51:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:51:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:51:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:51:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:51:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:51:52 INFO - Intel Iris: 16:51:52 INFO - Chipset Model: Intel Iris 16:51:52 INFO - Type: GPU 16:51:52 INFO - Bus: Built-In 16:51:52 INFO - VRAM (Dynamic, Max): 1536 MB 16:51:52 INFO - Vendor: Intel (0x8086) 16:51:52 INFO - Device ID: 0x0a2e 16:51:52 INFO - Revision ID: 0x0009 16:51:52 INFO - Displays: 16:51:52 INFO - Display: 16:51:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:51:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:51:52 INFO - Display Serial Number: 1600x1200 60 16:51:52 INFO - Main Display: Yes 16:51:52 INFO - Mirror: Off 16:51:52 INFO - Online: Yes 16:51:52 INFO - Rotation: Supported 16:51:52 INFO - Return code: 0 16:51:52 INFO - Running post-action listener: _resource_record_post_action 16:51:52 INFO - [mozharness: 2016-10-24 23:51:52.168089Z] Finished run-tests step (success) 16:51:52 INFO - Running post-run listener: _resource_record_post_run 16:51:52 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 962560; Write bytes: 663007232; Read time: 14; Write time: 1955 16:51:52 INFO - TinderboxPrint: CPU usage
54.4% 16:51:52 INFO - TinderboxPrint: I/O read bytes / time
962,560 / 14 16:51:52 INFO - TinderboxPrint: I/O write bytes / time
663,007,232 / 1,955 16:51:52 INFO - TinderboxPrint: CPU idle
2,205.5 (45.6%) 16:51:52 INFO - TinderboxPrint: CPU system
981.8 (20.3%) 16:51:52 INFO - TinderboxPrint: CPU user
1,646.5 (34.1%) 16:51:52 INFO - TinderboxPrint: Swap in / out
364,847,104 / 0 16:51:52 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 354380288; Write bytes: 355526656; Read time: 28693; Write time: 640 16:51:52 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 962560; Write bytes: 297293824; Read time: 14; Write time: 1279 16:51:52 INFO - Running post-run listener: _upload_blobber_files 16:51:52 INFO - Blob upload gear active. 16:51:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:51:52 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 16:51:52 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'] 16:51:52 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 16:51:53 INFO - (blobuploader) - INFO - Open directory for files ... 16:51:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:51:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:51:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:53 INFO - (blobuploader) - INFO - Done attempting. 16:51:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:51:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:51:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:54 INFO - (blobuploader) - INFO - Done attempting. 16:51:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:51:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:51:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:57 INFO - (blobuploader) - INFO - Done attempting. 16:51:57 INFO - (blobuploader) - INFO - Iteration through files over. 16:51:57 INFO - Return code: 0 16:51:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:51:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:51:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f555da63c451e08a6a5c71181ed8bed5f6f16fee29ef2054277df3067485a3e67d13d2a2981605bf965f44a531f9e7885d6b1150f28441325ff40df695c143f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/544e4ac49ecf6ce304918a88d86551a6533102ae209f1c8d7244824b9e018503f34723129cdbb5297f4329e1c5d6f29b0e1c497151ea0cdb34f0d19ea654f329", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bfe6f254f1eb06443ec25f5099304fc036cf1045f93dda1783809ee1a26c253418755de89722d8052c584275250d9819c6275c4d154aae66be779f04e108d269"} 16:51:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:51:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:51:57 INFO - Contents: 16:51:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f555da63c451e08a6a5c71181ed8bed5f6f16fee29ef2054277df3067485a3e67d13d2a2981605bf965f44a531f9e7885d6b1150f28441325ff40df695c143f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/544e4ac49ecf6ce304918a88d86551a6533102ae209f1c8d7244824b9e018503f34723129cdbb5297f4329e1c5d6f29b0e1c497151ea0cdb34f0d19ea654f329", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bfe6f254f1eb06443ec25f5099304fc036cf1045f93dda1783809ee1a26c253418755de89722d8052c584275250d9819c6275c4d154aae66be779f04e108d269"} 16:51:57 INFO - Running post-run listener: copy_logs_to_upload_dir 16:51:57 INFO - Copying logs to upload dir... 16:51:57 INFO - mkdir: /builds/slave/test/build/upload/logs 16:51:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.763652 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-24 16:51:57.149550) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 16:51:57.152669) ========= 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.ua8ZwN23JU/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.dU3XWJehCy/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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/f555da63c451e08a6a5c71181ed8bed5f6f16fee29ef2054277df3067485a3e67d13d2a2981605bf965f44a531f9e7885d6b1150f28441325ff40df695c143f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/544e4ac49ecf6ce304918a88d86551a6533102ae209f1c8d7244824b9e018503f34723129cdbb5297f4329e1c5d6f29b0e1c497151ea0cdb34f0d19ea654f329", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bfe6f254f1eb06443ec25f5099304fc036cf1045f93dda1783809ee1a26c253418755de89722d8052c584275250d9819c6275c4d154aae66be779f04e108d269"} build_url:https://queue.taskcluster.net/v1/task/WC1P55XORRylbGVOut0Z5A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010856 build_url: 'https://queue.taskcluster.net/v1/task/WC1P55XORRylbGVOut0Z5A/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/f555da63c451e08a6a5c71181ed8bed5f6f16fee29ef2054277df3067485a3e67d13d2a2981605bf965f44a531f9e7885d6b1150f28441325ff40df695c143f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/544e4ac49ecf6ce304918a88d86551a6533102ae209f1c8d7244824b9e018503f34723129cdbb5297f4329e1c5d6f29b0e1c497151ea0cdb34f0d19ea654f329", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bfe6f254f1eb06443ec25f5099304fc036cf1045f93dda1783809ee1a26c253418755de89722d8052c584275250d9819c6275c4d154aae66be779f04e108d269"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 16:51:57.186210) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 16:51:57.186562) ========= 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.ua8ZwN23JU/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.dU3XWJehCy/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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.005313 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 16:51:57.235650) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 16:51:57.235990) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 16:51:57.236350) ========= ========= Total master_lag: 0.18 =========