builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0033 starttime: 1482179335.82 results: success (0) buildid: 20161219105824 builduid: 76554646446d465093155bcd388f8786 revision: f778def55c45214a28cc397c63e866cd151b26b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-19 12:28:55.824718) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-19 12:28:55.825176) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-19 12:28:55.825449) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-19 12:28:55.855165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 12:28:55.855541) ========= 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.kPswtPMb4C/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.t9izyTOMeg/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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-12-19 12:28:55-- 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% 22.3M=0.001s 2016-12-19 12:28:56 (22.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.354544 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 12:28:56.233567) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 12:28:56.233887) ========= 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.kPswtPMb4C/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.t9izyTOMeg/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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.020088 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 12:28:56.283089) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-19 12:28:56.283448) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev f778def55c45214a28cc397c63e866cd151b26b0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev f778def55c45214a28cc397c63e866cd151b26b0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kPswtPMb4C/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.t9izyTOMeg/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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-12-19 12:28:56,359 truncating revision to first 12 chars 2016-12-19 12:28:56,359 Setting DEBUG logging. 2016-12-19 12:28:56,359 attempt 1/10 2016-12-19 12:28:56,359 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/f778def55c45?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-19 12:28:57,685 unpacking tar archive at: graphics-f778def55c45/testing/mozharness/ program finished with exit code 0 elapsedTime=1.591053 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-19 12:28:57.898204) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-19 12:28:57.898521) ========= script_repo_revision: f778def55c45214a28cc397c63e866cd151b26b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-19 12:28:57.898906) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-19 12:28:57.899185) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-19 12:28:57.918906) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-12-19 12:28:57.919304) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kPswtPMb4C/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.t9izyTOMeg/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 12:28:58 INFO - MultiFileLogger online at 20161219 12:28:58 in /builds/slave/test 12:28:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 12:28:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:28:58 INFO - {'append_to_log': False, 12:28:58 INFO - 'base_work_dir': '/builds/slave/test', 12:28:58 INFO - 'blob_upload_branch': 'Graphics', 12:28:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:28:58 INFO - 'branch': 'Graphics', 12:28:58 INFO - 'buildbot_json_path': 'buildprops.json', 12:28:58 INFO - 'config_files': ('talos/mac_config.py',), 12:28:58 INFO - 'default_actions': ('clobber', 12:28:58 INFO - 'read-buildbot-config', 12:28:58 INFO - 'download-and-extract', 12:28:58 INFO - 'populate-webroot', 12:28:58 INFO - 'create-virtualenv', 12:28:58 INFO - 'install', 12:28:58 INFO - 'run-tests'), 12:28:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:28:58 INFO - 'download_minidump_stackwalk': True, 12:28:58 INFO - 'download_symbols': 'ondemand', 12:28:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:28:58 INFO - 'tooltool.py': '/tools/tooltool.py', 12:28:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:28:58 INFO - '/tools/misc-python/virtualenv.py')}, 12:28:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:28:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:28:58 INFO - 'installer_path': 'installer.exe', 12:28:58 INFO - 'log_level': 'info', 12:28:58 INFO - 'log_name': 'talos', 12:28:58 INFO - 'log_to_console': True, 12:28:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:28:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:28:58 INFO - 'opt_config_files': (), 12:28:58 INFO - 'pip_index': False, 12:28:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:28:58 INFO - 'cmd': ('bash', 12:28:58 INFO - '-c', 12:28:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:28:58 INFO - 'enabled': True, 12:28:58 INFO - 'halt_on_failure': False, 12:28:58 INFO - 'name': 'check_screen_resolution'},), 12:28:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:28:58 INFO - 'cmd': ('bash', 12:28:58 INFO - '-c', 12:28:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:28:58 INFO - 'enabled': True, 12:28:58 INFO - 'halt_on_failure': False, 12:28:58 INFO - 'name': 'check_screen_resolution'},), 12:28:58 INFO - 'run_cmd_checks_enabled': True, 12:28:58 INFO - 'sps_profile': False, 12:28:58 INFO - 'sps_profile_interval': 0, 12:28:58 INFO - 'suite': 'dromaeojs', 12:28:58 INFO - 'system_bits': '32', 12:28:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:28:58 INFO - 'title': 't-yosemite-r7-0033', 12:28:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:28:58 INFO - 'use_talos_json': True, 12:28:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:28:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:28:58 INFO - 'work_dir': 'build'} 12:28:58 INFO - [mozharness: 2016-12-19 20:28:58.121345Z] Running clobber step. 12:28:58 INFO - Running pre-action listener: _resource_record_pre_action 12:28:58 INFO - Running main action method: clobber 12:28:58 INFO - rmtree: /builds/slave/test/build 12:28:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:29:00 INFO - Running post-action listener: _resource_record_post_action 12:29:00 INFO - [mozharness: 2016-12-19 20:29:00.251030Z] Finished clobber step (success) 12:29:00 INFO - [mozharness: 2016-12-19 20:29:00.251176Z] Running read-buildbot-config step. 12:29:00 INFO - Running pre-action listener: _resource_record_pre_action 12:29:00 INFO - Running main action method: read_buildbot_config 12:29:00 INFO - Using buildbot properties: 12:29:00 INFO - { 12:29:00 INFO - "project": "", 12:29:00 INFO - "product": "firefox", 12:29:00 INFO - "script_repo_revision": "default", 12:29:00 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 12:29:00 INFO - "repository": "", 12:29:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 12:29:00 INFO - "buildid": "20161219105824", 12:29:00 INFO - "pgo_build": "False", 12:29:00 INFO - "basedir": "/builds/slave/test", 12:29:00 INFO - "buildnumber": 0, 12:29:00 INFO - "slavename": "t-yosemite-r7-0033", 12:29:00 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:29:00 INFO - "platform": "yosemite_r7", 12:29:00 INFO - "scheduler": "tests-graphics-macosx64-talos", 12:29:00 INFO - "branch": "graphics", 12:29:00 INFO - "repo_path": "projects/graphics", 12:29:00 INFO - "revision": "f778def55c45214a28cc397c63e866cd151b26b0", 12:29:00 INFO - "stage_platform": "macosx64", 12:29:00 INFO - "builduid": "76554646446d465093155bcd388f8786", 12:29:00 INFO - "slavebuilddir": "test" 12:29:00 INFO - } 12:29:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/LhLT10P_REK5EIzBRzXAgA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 12:29:00 INFO - Running post-action listener: _resource_record_post_action 12:29:00 INFO - [mozharness: 2016-12-19 20:29:00.254524Z] Finished read-buildbot-config step (success) 12:29:00 INFO - [mozharness: 2016-12-19 20:29:00.254649Z] Running download-and-extract step. 12:29:00 INFO - Running pre-action listener: _resource_record_pre_action 12:29:00 INFO - Running main action method: download_and_extract 12:29:00 INFO - mkdir: /builds/slave/test/build/tests 12:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:00 INFO - trying https://queue.taskcluster.net/v1/task/LhLT10P_REK5EIzBRzXAgA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 12:29:00 INFO - Downloading https://queue.taskcluster.net/v1/task/LhLT10P_REK5EIzBRzXAgA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 12:29:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LhLT10P_REK5EIzBRzXAgA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 12:29:01 INFO - Downloaded 1199 bytes. 12:29:01 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 12:29:01 INFO - Using the following test package requirements: 12:29:01 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 12:29:01 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:29:01 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 12:29:01 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:29:01 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 12:29:01 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:29:01 INFO - u'jsshell-mac.zip'], 12:29:01 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:29:01 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 12:29:01 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 12:29:01 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:29:01 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 12:29:01 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:29:01 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 12:29:01 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:29:01 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 12:29:01 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:29:01 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 12:29:01 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:29:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LhLT10P_REK5EIzBRzXAgA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 12:29:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LhLT10P_REK5EIzBRzXAgA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:29:01 INFO - Fetch https://queue.taskcluster.net/v1/task/LhLT10P_REK5EIzBRzXAgA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 12:29:02 INFO - Expected file size: 16276031 12:29:02 INFO - Obtained file size: 16276031 12:29:08 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:29:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LhLT10P_REK5EIzBRzXAgA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 12:29:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LhLT10P_REK5EIzBRzXAgA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:29:08 INFO - Fetch https://queue.taskcluster.net/v1/task/LhLT10P_REK5EIzBRzXAgA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 12:29:09 INFO - Expected file size: 16276031 12:29:09 INFO - Obtained file size: 16276031 12:29:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LhLT10P_REK5EIzBRzXAgA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 12:29:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LhLT10P_REK5EIzBRzXAgA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:29:16 INFO - Fetch https://queue.taskcluster.net/v1/task/LhLT10P_REK5EIzBRzXAgA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 12:29:16 INFO - Expected file size: 14409734 12:29:16 INFO - Obtained file size: 14409734 12:29: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')]} 12:29:17 INFO - trying https://queue.taskcluster.net/v1/task/LhLT10P_REK5EIzBRzXAgA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:29:17 INFO - Downloading https://queue.taskcluster.net/v1/task/LhLT10P_REK5EIzBRzXAgA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 12:29:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LhLT10P_REK5EIzBRzXAgA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 12:29:19 INFO - Downloaded 69661849 bytes. 12:29:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LhLT10P_REK5EIzBRzXAgA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:29:19 INFO - mkdir: /builds/slave/test/properties 12:29:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:29:19 INFO - Writing to file /builds/slave/test/properties/build_url 12:29:19 INFO - Contents: 12:29:19 INFO - build_url:https://queue.taskcluster.net/v1/task/LhLT10P_REK5EIzBRzXAgA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:29:19 INFO - Running post-action listener: _resource_record_post_action 12:29:19 INFO - Running post-action listener: set_extra_try_arguments 12:29:19 INFO - [mozharness: 2016-12-19 20:29:19.945500Z] Finished download-and-extract step (success) 12:29:19 INFO - [mozharness: 2016-12-19 20:29:19.945623Z] Running populate-webroot step. 12:29:19 INFO - Running pre-action listener: _resource_record_pre_action 12:29:19 INFO - Running main action method: populate_webroot 12:29:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:29:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:29:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:29:19 INFO - '--tppagecycles', 12:29:19 INFO - '7'], 12:29:19 INFO - 'tests': ['tsvgm']}}, 12:29:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:29:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:29:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:29:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:29:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:29:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:29:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:29:19 INFO - 'talos_options': ['--disable-e10s'], 12:29:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:29:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:29:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:29:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:29:19 INFO - 'talos_options': ['--disable-e10s'], 12:29:19 INFO - 'tests': ['damp', 'tps']}, 12:29:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:29:19 INFO - 'tests': ['damp', 'tps']}, 12:29:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:29:19 INFO - 'tests': ['dromaeo_dom']}, 12:29:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:29:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:29:19 INFO - 'tests': ['basic_compositor_video']}, 12:29:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:29:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:29:19 INFO - 'tests': ['a11yr', 12:29:19 INFO - 'ts_paint', 12:29:19 INFO - 'tpaint', 12:29:19 INFO - 'sessionrestore', 12:29:19 INFO - 'sessionrestore_no_auto_restore', 12:29:19 INFO - 'tabpaint']}, 12:29:19 INFO - 'other-e10s': {'tests': ['a11yr', 12:29:19 INFO - 'ts_paint', 12:29:19 INFO - 'tpaint', 12:29:19 INFO - 'sessionrestore', 12:29:19 INFO - 'sessionrestore_no_auto_restore', 12:29:19 INFO - 'tabpaint']}, 12:29:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:29:19 INFO - 'ts_paint', 12:29:19 INFO - 'tpaint', 12:29:19 INFO - 'sessionrestore', 12:29:19 INFO - 'sessionrestore_no_auto_restore', 12:29:19 INFO - 'tabpaint']}, 12:29:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:29:19 INFO - 'ts_paint', 12:29:19 INFO - 'tpaint', 12:29:19 INFO - 'sessionrestore', 12:29:19 INFO - 'sessionrestore_no_auto_restore', 12:29:19 INFO - 'tabpaint']}, 12:29:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:29:19 INFO - 'tests': ['a11yr', 12:29:19 INFO - 'ts_paint', 12:29:19 INFO - 'tpaint', 12:29:19 INFO - 'sessionrestore', 12:29:19 INFO - 'sessionrestore_no_auto_restore', 12:29:19 INFO - 'tabpaint']}, 12:29:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:29:19 INFO - 'tests': ['a11yr', 12:29:19 INFO - 'ts_paint', 12:29:19 INFO - 'tpaint', 12:29:19 INFO - 'sessionrestore', 12:29:19 INFO - 'sessionrestore_no_auto_restore', 12:29:19 INFO - 'tabpaint']}, 12:29:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:29:19 INFO - 'tests': ['tsvgx', 12:29:19 INFO - 'tsvgr_opacity', 12:29:19 INFO - 'tart', 12:29:19 INFO - 'tscrollx', 12:29:19 INFO - 'cart', 12:29:19 INFO - 'tsvg_static']}, 12:29:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:29:19 INFO - 'tsvgr_opacity', 12:29:19 INFO - 'tart', 12:29:19 INFO - 'tscrollx', 12:29:19 INFO - 'cart', 12:29:19 INFO - 'tsvg_static']}, 12:29:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:29:19 INFO - 'talos_options': ['--disable-e10s'], 12:29:19 INFO - 'tests': ['tp5o']}, 12:29:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:29:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:29:19 INFO - 'talos_options': ['--disable-e10s', 12:29:19 INFO - '--xperf_path', 12:29:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:29:19 INFO - 'tests': ['tp5n']}, 12:29:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:29:19 INFO - 'talos_options': ['--xperf_path', 12:29:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:29:19 INFO - 'tests': ['tp5n']}}, 12:29:19 INFO - 'talos.zip': {'path': '', 12:29:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:29:19 INFO - Running post-action listener: _resource_record_post_action 12:29:19 INFO - [mozharness: 2016-12-19 20:29:19.963965Z] Finished populate-webroot step (success) 12:29:19 INFO - [mozharness: 2016-12-19 20:29:19.964080Z] Running create-virtualenv step. 12:29:19 INFO - Running pre-action listener: _resource_record_pre_action 12:29:19 INFO - Running main action method: create_virtualenv 12:29:19 INFO - Creating virtualenv /builds/slave/test/build/venv 12:29:19 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 12:29:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:29:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:29:20 INFO - Using real prefix '/tools/python27' 12:29:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:29:20 INFO - Installing distribute.............................................................................................................................................................................................done. 12:29:23 INFO - Installing pip.................done. 12:29:23 INFO - Return code: 0 12:29:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:29:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:29:23 INFO - Reading from file tmpfile_stdout 12:29:23 INFO - Output received: 12:29:23 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:29:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:29: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')]} 12:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29: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')]} 12:29:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fcbdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcc0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85f8d89030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa9bd30>, '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 0x10f9c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa90be8>, '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.kPswtPMb4C/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.t9izyTOMeg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 12:29: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', 'pip>=1.5'] in /builds/slave/test/build 12:29: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 pip>=1.5 12:29:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kPswtPMb4C/Render', 12:29:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:23 INFO - 'HOME': '/Users/cltbld', 12:29:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:23 INFO - 'LOGNAME': 'cltbld', 12:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:23 INFO - 'MOZ_NO_REMOTE': '1', 12:29:23 INFO - 'NO_EM_RESTART': '1', 12:29:23 INFO - 'PAGER': '/bin/cat', 12:29:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:23 INFO - 'PWD': '/builds/slave/test', 12:29:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:23 INFO - 'SHELL': '/bin/bash', 12:29:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t9izyTOMeg/Listeners', 12:29:23 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 12:29:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:23 INFO - 'USER': 'cltbld', 12:29:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:23 INFO - 'XPC_FLAGS': '0x0', 12:29:23 INFO - 'XPC_SERVICE_NAME': '0', 12:29:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:29:24 INFO - Cleaning up... 12:29:24 INFO - Return code: 0 12:29:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fcbdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcc0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85f8d89030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa9bd30>, '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 0x10f9c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa90be8>, '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.kPswtPMb4C/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.t9izyTOMeg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 12:29:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:29:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kPswtPMb4C/Render', 12:29:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:24 INFO - 'HOME': '/Users/cltbld', 12:29:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:24 INFO - 'LOGNAME': 'cltbld', 12:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:24 INFO - 'MOZ_NO_REMOTE': '1', 12:29:24 INFO - 'NO_EM_RESTART': '1', 12:29:24 INFO - 'PAGER': '/bin/cat', 12:29:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:24 INFO - 'PWD': '/builds/slave/test', 12:29:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:24 INFO - 'SHELL': '/bin/bash', 12:29:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t9izyTOMeg/Listeners', 12:29:24 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 12:29:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:24 INFO - 'USER': 'cltbld', 12:29:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:24 INFO - 'XPC_FLAGS': '0x0', 12:29:24 INFO - 'XPC_SERVICE_NAME': '0', 12:29:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:24 INFO - Downloading/unpacking psutil>=3.1.1 12:29:24 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 12:29:24 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 12:29:24 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 12:29:24 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 12:29:24 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 12:29:24 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 12:29:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:29:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:29:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:29:27 INFO - Installing collected packages: psutil 12:29:27 INFO - Running setup.py install for psutil 12:29:27 INFO - building 'psutil._psutil_osx' extension 12:29:27 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 12:29:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 12:29:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 12:29:28 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 12:29:28 INFO - building 'psutil._psutil_posix' extension 12:29:28 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 12:29:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:29:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:29:28 INFO - ^ 12:29:28 INFO - 1 warning generated. 12:29:28 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 12:29:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:29:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:29:28 INFO - Successfully installed psutil 12:29:28 INFO - Cleaning up... 12:29:28 INFO - Return code: 0 12:29:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:29:28 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')]} 12:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:28 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')]} 12:29:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:28 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 0x10fcbdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcc0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85f8d89030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa9bd30>, '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 0x10f9c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa90be8>, '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.kPswtPMb4C/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.t9izyTOMeg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 12:29:28 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 12:29:28 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 12:29:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kPswtPMb4C/Render', 12:29:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:28 INFO - 'HOME': '/Users/cltbld', 12:29:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:28 INFO - 'LOGNAME': 'cltbld', 12:29:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:28 INFO - 'MOZ_NO_REMOTE': '1', 12:29:28 INFO - 'NO_EM_RESTART': '1', 12:29:28 INFO - 'PAGER': '/bin/cat', 12:29:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:28 INFO - 'PWD': '/builds/slave/test', 12:29:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:28 INFO - 'SHELL': '/bin/bash', 12:29:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t9izyTOMeg/Listeners', 12:29:28 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 12:29:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:28 INFO - 'USER': 'cltbld', 12:29:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:28 INFO - 'XPC_FLAGS': '0x0', 12:29:28 INFO - 'XPC_SERVICE_NAME': '0', 12:29:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:29:28 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 12:29:28 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 12:29:28 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 12:29:28 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 12:29:28 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 12:29:28 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 12:29:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:29:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:29:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:29:31 INFO - Installing collected packages: mozsystemmonitor 12:29:31 INFO - Running setup.py install for mozsystemmonitor 12:29:31 INFO - Successfully installed mozsystemmonitor 12:29:31 INFO - Cleaning up... 12:29:31 INFO - Return code: 0 12:29:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:29:31 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')]} 12:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:31 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')]} 12:29:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:31 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 0x10fcbdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcc0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85f8d89030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa9bd30>, '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 0x10f9c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa90be8>, '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.kPswtPMb4C/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.t9izyTOMeg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 12:29:31 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 12:29:31 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 12:29:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kPswtPMb4C/Render', 12:29:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:31 INFO - 'HOME': '/Users/cltbld', 12:29:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:31 INFO - 'LOGNAME': 'cltbld', 12:29:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:31 INFO - 'MOZ_NO_REMOTE': '1', 12:29:31 INFO - 'NO_EM_RESTART': '1', 12:29:31 INFO - 'PAGER': '/bin/cat', 12:29:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:31 INFO - 'PWD': '/builds/slave/test', 12:29:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:31 INFO - 'SHELL': '/bin/bash', 12:29:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t9izyTOMeg/Listeners', 12:29:31 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 12:29:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:31 INFO - 'USER': 'cltbld', 12:29:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:31 INFO - 'XPC_FLAGS': '0x0', 12:29:31 INFO - 'XPC_SERVICE_NAME': '0', 12:29:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:32 INFO - Downloading/unpacking jsonschema==2.5.1 12:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:29:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:29:34 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 12:29:34 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 12:29:34 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 12:29:34 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 12:29:34 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 12:29:34 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 12:29:35 INFO - Downloading functools32-3.2.3-2.tar.gz 12:29:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:29:35 INFO - warning: no files found matching '*.txt' 12:29:35 INFO - no previously-included directories found matching 'build' 12:29:35 INFO - no previously-included directories found matching 'dist' 12:29:35 INFO - no previously-included directories found matching '.git*' 12:29:35 INFO - Installing collected packages: jsonschema, functools32 12:29:35 INFO - Running setup.py install for functools32 12:29:35 INFO - warning: no files found matching '*.txt' 12:29:35 INFO - no previously-included directories found matching 'build' 12:29:35 INFO - no previously-included directories found matching 'dist' 12:29:35 INFO - no previously-included directories found matching '.git*' 12:29:35 INFO - Successfully installed jsonschema functools32 12:29:35 INFO - Cleaning up... 12:29:35 INFO - Return code: 0 12:29:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:29:35 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')]} 12:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:35 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')]} 12:29:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:35 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 0x10fcbdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcc0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85f8d89030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa9bd30>, '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 0x10f9c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa90be8>, '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.kPswtPMb4C/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.t9izyTOMeg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 12:29:35 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 12:29:35 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 12:29:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kPswtPMb4C/Render', 12:29:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:35 INFO - 'HOME': '/Users/cltbld', 12:29:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:35 INFO - 'LOGNAME': 'cltbld', 12:29:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:35 INFO - 'MOZ_NO_REMOTE': '1', 12:29:35 INFO - 'NO_EM_RESTART': '1', 12:29:35 INFO - 'PAGER': '/bin/cat', 12:29:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:35 INFO - 'PWD': '/builds/slave/test', 12:29:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:35 INFO - 'SHELL': '/bin/bash', 12:29:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t9izyTOMeg/Listeners', 12:29:35 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 12:29:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:35 INFO - 'USER': 'cltbld', 12:29:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:35 INFO - 'XPC_FLAGS': '0x0', 12:29:35 INFO - 'XPC_SERVICE_NAME': '0', 12:29:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:29:35 INFO - Cleaning up... 12:29:35 INFO - Return code: 0 12:29:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:29:35 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')]} 12:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:35 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')]} 12:29:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:35 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 0x10fcbdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcc0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85f8d89030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa9bd30>, '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 0x10f9c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa90be8>, '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.kPswtPMb4C/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.t9izyTOMeg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 12:29:35 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 12:29:35 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 12:29:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kPswtPMb4C/Render', 12:29:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:35 INFO - 'HOME': '/Users/cltbld', 12:29:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:35 INFO - 'LOGNAME': 'cltbld', 12:29:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:35 INFO - 'MOZ_NO_REMOTE': '1', 12:29:35 INFO - 'NO_EM_RESTART': '1', 12:29:35 INFO - 'PAGER': '/bin/cat', 12:29:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:35 INFO - 'PWD': '/builds/slave/test', 12:29:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:35 INFO - 'SHELL': '/bin/bash', 12:29:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t9izyTOMeg/Listeners', 12:29:35 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 12:29:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:35 INFO - 'USER': 'cltbld', 12:29:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:35 INFO - 'XPC_FLAGS': '0x0', 12:29:35 INFO - 'XPC_SERVICE_NAME': '0', 12:29:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:36 INFO - Downloading/unpacking blobuploader==1.2.4 12:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:38 INFO - Downloading blobuploader-1.2.4.tar.gz 12:29:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:29:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:29:38 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 12:29:38 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 12:29:38 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 12:29:38 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 12:29:38 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 12:29:38 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 12:29:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:29:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:29: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 12:29: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 12:29: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 12:29: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 12:29: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 12:29: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 12:29:39 INFO - Downloading docopt-0.6.1.tar.gz 12:29:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:29:39 INFO - Installing collected packages: blobuploader, requests, docopt 12:29:39 INFO - Running setup.py install for blobuploader 12:29:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:29:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:29:40 INFO - Running setup.py install for requests 12:29:40 INFO - Running setup.py install for docopt 12:29:40 INFO - Successfully installed blobuploader requests docopt 12:29:40 INFO - Cleaning up... 12:29:40 INFO - Return code: 0 12:29:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:29:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:40 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 0x10fcbdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcc0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85f8d89030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa9bd30>, '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 0x10f9c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa90be8>, '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.kPswtPMb4C/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.t9izyTOMeg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 12:29:40 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 12:29:40 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 12:29:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kPswtPMb4C/Render', 12:29:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:40 INFO - 'HOME': '/Users/cltbld', 12:29:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:40 INFO - 'LOGNAME': 'cltbld', 12:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:40 INFO - 'MOZ_NO_REMOTE': '1', 12:29:40 INFO - 'NO_EM_RESTART': '1', 12:29:40 INFO - 'PAGER': '/bin/cat', 12:29:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:40 INFO - 'PWD': '/builds/slave/test', 12:29:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:40 INFO - 'SHELL': '/bin/bash', 12:29:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t9izyTOMeg/Listeners', 12:29:40 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 12:29:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:40 INFO - 'USER': 'cltbld', 12:29:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:40 INFO - 'XPC_FLAGS': '0x0', 12:29:40 INFO - 'XPC_SERVICE_NAME': '0', 12:29:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:29:41 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-ZZGqKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:29:41 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-bGLYdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:29:41 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-umrEbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:29:41 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-85yhqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:29:41 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-QLAQU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:29:41 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-G4JCX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:29:41 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-wnwvhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:29:41 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-UGH8RY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:29:42 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-zmiJy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:29:42 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-rWtnuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:29:42 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-ZL0ZLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:29:42 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-XPl_EO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:29:42 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-UyTS7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:29:42 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-oBlKq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:29:42 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-LflSVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:29:42 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-rYytNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:29:42 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-BdJsWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:29:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:29:42 INFO - Running setup.py install for manifestparser 12:29:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:29:43 INFO - Running setup.py install for mozcrash 12:29:43 INFO - Running setup.py install for mozdebug 12:29:43 INFO - Running setup.py install for mozdevice 12:29:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:29:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:29:43 INFO - Running setup.py install for mozfile 12:29:43 INFO - Running setup.py install for mozhttpd 12:29:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:29:43 INFO - Running setup.py install for mozinfo 12:29:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:29:44 INFO - Running setup.py install for mozInstall 12:29:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:29:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:29:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:29:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:29:44 INFO - Running setup.py install for mozleak 12:29:44 INFO - Running setup.py install for mozlog 12:29:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:29:44 INFO - Running setup.py install for moznetwork 12:29:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:29:44 INFO - Running setup.py install for mozprocess 12:29:44 INFO - Running setup.py install for mozprofile 12:29:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:29:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:29:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:29:44 INFO - Running setup.py install for mozrunner 12:29:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:29:45 INFO - Running setup.py install for mozscreenshot 12:29:45 INFO - Running setup.py install for moztest 12:29:45 INFO - Running setup.py install for mozversion 12:29:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:29:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:29:45 INFO - Cleaning up... 12:29:45 INFO - Return code: 0 12:29:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:45 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 0x10fcbdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcc0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85f8d89030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa9bd30>, '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 0x10f9c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa90be8>, '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.kPswtPMb4C/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.t9izyTOMeg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 12:29:45 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 12:29:45 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 12:29:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kPswtPMb4C/Render', 12:29:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:45 INFO - 'HOME': '/Users/cltbld', 12:29:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:45 INFO - 'LOGNAME': 'cltbld', 12:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:45 INFO - 'MOZ_NO_REMOTE': '1', 12:29:45 INFO - 'NO_EM_RESTART': '1', 12:29:45 INFO - 'PAGER': '/bin/cat', 12:29:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:45 INFO - 'PWD': '/builds/slave/test', 12:29:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:45 INFO - 'SHELL': '/bin/bash', 12:29:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t9izyTOMeg/Listeners', 12:29:45 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 12:29:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:45 INFO - 'USER': 'cltbld', 12:29:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:45 INFO - 'XPC_FLAGS': '0x0', 12:29:45 INFO - 'XPC_SERVICE_NAME': '0', 12:29:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:29:45 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-FfMUN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:29:45 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)) 12:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:29:45 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-SW3DLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 12:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:29:46 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-uKSPf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:29:46 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-uooYOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 12:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:29:46 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-ZyZjf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:29:46 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-7UF4nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:29:46 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-ZFvZZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:29:46 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)) 12:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:29:46 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-qsFv1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:29:46 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)) 12:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:29:46 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-adLR_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:29:46 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)) 12:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:29:46 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-SplQRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:29:46 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)) 12:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:29:46 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-1np628-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:29:46 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)) 12:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:29:47 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-WSIwlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:29:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:29:47 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-0fknjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:29:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:29:47 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-LGRnC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:29:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 12:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:29:47 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-sFYltO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:29:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:29:47 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-Q5zCKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:29:47 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)) 12:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:29:47 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-C8C_kV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:29:47 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)) 12:29:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:29:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:29:47 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)) 12:29:47 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:29:47 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:29:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:29:47 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 12:29:47 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 12:29:47 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 12:29:47 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 12:29:47 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 12:29:47 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 12:29:50 INFO - Downloading blessings-1.6.tar.gz 12:29:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:29:50 INFO - Installing collected packages: blessings 12:29:50 INFO - Running setup.py install for blessings 12:29:50 INFO - Successfully installed blessings 12:29:50 INFO - Cleaning up... 12:29:50 INFO - Return code: 0 12:29:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:29:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:29:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:29:50 INFO - Reading from file tmpfile_stdout 12:29:50 INFO - Current package versions: 12:29:50 INFO - blessings == 1.6 12:29:50 INFO - blobuploader == 1.2.4 12:29:50 INFO - docopt == 0.6.1 12:29:50 INFO - functools32 == 3.2.3-2 12:29:50 INFO - jsonschema == 2.5.1 12:29:50 INFO - manifestparser == 1.1 12:29:50 INFO - mozInstall == 1.12 12:29:50 INFO - mozcrash == 1.0 12:29:50 INFO - mozdebug == 0.1 12:29:50 INFO - mozdevice == 0.49 12:29:50 INFO - mozfile == 1.2 12:29:50 INFO - mozhttpd == 0.7 12:29:50 INFO - mozinfo == 0.9 12:29:50 INFO - mozleak == 0.1 12:29:50 INFO - mozlog == 3.4 12:29:50 INFO - moznetwork == 0.27 12:29:50 INFO - mozprocess == 0.23 12:29:50 INFO - mozprofile == 0.28 12:29:50 INFO - mozrunner == 6.13 12:29:50 INFO - mozscreenshot == 0.1 12:29:50 INFO - mozsystemmonitor == 0.3 12:29:50 INFO - moztest == 0.7 12:29:50 INFO - mozversion == 1.4 12:29:50 INFO - psutil == 3.1.1 12:29:50 INFO - requests == 1.2.3 12:29:50 INFO - wsgiref == 0.1.2 12:29:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:29:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:50 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 0x10fcbdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcc0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85f8d89030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa9bd30>, '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 0x10f9c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa90be8>, '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.kPswtPMb4C/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.t9izyTOMeg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 12:29:50 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 12:29:50 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 12:29:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kPswtPMb4C/Render', 12:29:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:50 INFO - 'HOME': '/Users/cltbld', 12:29:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:50 INFO - 'LOGNAME': 'cltbld', 12:29:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:50 INFO - 'MOZ_NO_REMOTE': '1', 12:29:50 INFO - 'NO_EM_RESTART': '1', 12:29:50 INFO - 'PAGER': '/bin/cat', 12:29:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:50 INFO - 'PWD': '/builds/slave/test', 12:29:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:50 INFO - 'SHELL': '/bin/bash', 12:29:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t9izyTOMeg/Listeners', 12:29:50 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 12:29:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:50 INFO - 'USER': 'cltbld', 12:29:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:50 INFO - 'XPC_FLAGS': '0x0', 12:29:50 INFO - 'XPC_SERVICE_NAME': '0', 12:29:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:29:51 INFO - Cleaning up... 12:29:51 INFO - Return code: 0 12:29:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:29: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')]} 12:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29: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')]} 12:29:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fcbdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcc0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85f8d89030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa9bd30>, '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 0x10f9c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa90be8>, '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.kPswtPMb4C/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.t9izyTOMeg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 12:29:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:29:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:29:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kPswtPMb4C/Render', 12:29:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:51 INFO - 'HOME': '/Users/cltbld', 12:29:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:51 INFO - 'LOGNAME': 'cltbld', 12:29:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:51 INFO - 'MOZ_NO_REMOTE': '1', 12:29:51 INFO - 'NO_EM_RESTART': '1', 12:29:51 INFO - 'PAGER': '/bin/cat', 12:29:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:51 INFO - 'PWD': '/builds/slave/test', 12:29:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:51 INFO - 'SHELL': '/bin/bash', 12:29:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t9izyTOMeg/Listeners', 12:29:51 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 12:29:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:51 INFO - 'USER': 'cltbld', 12:29:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:51 INFO - 'XPC_FLAGS': '0x0', 12:29:51 INFO - 'XPC_SERVICE_NAME': '0', 12:29:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:29:51 INFO - Cleaning up... 12:29:51 INFO - Return code: 0 12:29:51 INFO - Running post-action listener: _resource_record_post_action 12:29:51 INFO - Running post-action listener: _start_resource_monitoring 12:29:51 INFO - Starting resource monitoring. 12:29:51 INFO - [mozharness: 2016-12-19 20:29:51.392173Z] Finished create-virtualenv step (success) 12:29:51 INFO - [mozharness: 2016-12-19 20:29:51.393155Z] Running install step. 12:29:51 INFO - Running pre-action listener: _resource_record_pre_action 12:29:51 INFO - Running main action method: install 12:29:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:29:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:29:51 INFO - Reading from file tmpfile_stdout 12:29:51 INFO - Detecting whether we're running mozinstall >=1.0... 12:29:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:29:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:29:51 INFO - Reading from file tmpfile_stdout 12:29:51 INFO - Output received: 12:29:51 INFO - Usage: mozinstall [options] installer 12:29:51 INFO - Options: 12:29:51 INFO - -h, --help show this help message and exit 12:29:51 INFO - -d DEST, --destination=DEST 12:29:51 INFO - Directory to install application into. [default: 12:29:51 INFO - "/builds/slave/test"] 12:29:51 INFO - --app=APP Application being installed. [default: firefox] 12:29:51 INFO - mkdir: /builds/slave/test/build/application 12:29:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:29:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:30:13 INFO - Reading from file tmpfile_stdout 12:30:13 INFO - Output received: 12:30:13 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:30:13 INFO - Running post-action listener: _resource_record_post_action 12:30:13 INFO - [mozharness: 2016-12-19 20:30:13.270033Z] Finished install step (success) 12:30:13 INFO - [mozharness: 2016-12-19 20:30:13.270173Z] Running run-tests step. 12:30:13 INFO - Running pre-action listener: _resource_record_pre_action 12:30:13 INFO - Running main action method: run_tests 12:30:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:30:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:30:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:30:13 INFO - 2016-12-19 12:30:13.284 screenresolution[1966:12099] starting screenresolution argv=screenresolution get 12:30:13 INFO - 2016-12-19 12:30:13.287 screenresolution[1966:12099] Display 0: 1600x1200x32@60 12:30:13 INFO - 2016-12-19 12:30:13.293 screenresolution[1967:12101] starting screenresolution argv=screenresolution list 12:30:13 INFO - Available Modes on Display 0 12:30:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:30:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:30:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:30:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:30:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:30:13 INFO - Intel Iris: 12:30:13 INFO - Chipset Model: Intel Iris 12:30:13 INFO - Type: GPU 12:30:13 INFO - Bus: Built-In 12:30:13 INFO - VRAM (Dynamic, Max): 1536 MB 12:30:13 INFO - Vendor: Intel (0x8086) 12:30:13 INFO - Device ID: 0x0a2e 12:30:13 INFO - Revision ID: 0x0009 12:30:13 INFO - Displays: 12:30:13 INFO - Display: 12:30:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:30:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:30:13 INFO - Display Serial Number: 1600x1200 60 12:30:13 INFO - Main Display: Yes 12:30:13 INFO - Mirror: Off 12:30:13 INFO - Online: Yes 12:30:13 INFO - Rotation: Supported 12:30:13 INFO - Return code: 0 12:30:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:30:13 INFO - Python 2.7.3 12:30:13 INFO - Return code: 0 12:30:13 INFO - grabbing minidump binary from tooltool 12:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:30:13 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 0x10fa9bd30>, '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 0x10f9c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa90be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:30:13 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 12:30:13 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 12:30:13 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 12:30:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:30:13 INFO - Return code: 0 12:30:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:30:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:30:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:30:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:30:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:30:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LhLT10P_REK5EIzBRzXAgA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LhLT10P_REK5EIzBRzXAgA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:30:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kPswtPMb4C/Render', 12:30:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:30:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:30:13 INFO - 'HOME': '/Users/cltbld', 12:30:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:30:13 INFO - 'LOGNAME': 'cltbld', 12:30:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:30:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:13 INFO - 'MOZ_NO_REMOTE': '1', 12:30:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:30:13 INFO - 'NO_EM_RESTART': '1', 12:30:13 INFO - 'PAGER': '/bin/cat', 12:30:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:13 INFO - 'PWD': '/builds/slave/test', 12:30:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:30:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:30:13 INFO - 'SHELL': '/bin/bash', 12:30:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t9izyTOMeg/Listeners', 12:30:13 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 12:30:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:30:13 INFO - 'USER': 'cltbld', 12:30:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:30:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:13 INFO - 'XPC_FLAGS': '0x0', 12:30:13 INFO - 'XPC_SERVICE_NAME': '0', 12:30:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:30:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LhLT10P_REK5EIzBRzXAgA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:30:13 INFO - mozversion application_buildid: 20161219105824 12:30:13 INFO - mozversion application_changeset: f778def55c45214a28cc397c63e866cd151b26b0 12:30:13 INFO - mozversion application_display_name: Nightly 12:30:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:30:13 INFO - mozversion application_name: Firefox 12:30:13 INFO - mozversion application_remotingname: firefox 12:30:13 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 12:30:13 INFO - mozversion application_vendor: Mozilla 12:30:13 INFO - mozversion application_version: 53.0a1 12:30:13 INFO - mozversion platform_buildid: 20161219105824 12:30:13 INFO - mozversion platform_changeset: f778def55c45214a28cc397c63e866cd151b26b0 12:30:13 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 12:30:13 INFO - mozversion platform_version: 53.0a1 12:30:13 INFO - using testdate: 1482179413 12:30:13 INFO - actual date: 1482179413 12:30:13 INFO - starting webserver on 'localhost:49336' 12:30:13 INFO - SUITE-START | Running 2 tests 12:30:13 INFO - TEST-START | dromaeo_css 12:30:13 INFO - operating with platform_type : mac_ 12:30:13 INFO - Initialising browser for dromaeo_css test... 12:30:13 INFO - TEST-INFO | started process 1977 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpPXmprW/profile http://localhost:49336/getInfo.html) 12:30:16 INFO - PROCESS | 1977 | __metrics Screen width/height:1600/1200 12:30:16 INFO - PROCESS | 1977 | colorDepth:24 12:30:16 INFO - PROCESS | 1977 | Browser inner width/height: 1024/689 12:30:16 INFO - PROCESS | 1977 | __metrics 12:30:16 INFO - PROCESS | 1977 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:30:16 INFO - PROCESS | 1977 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:30:17 INFO - TEST-INFO | 1977: exit 0 12:30:17 INFO - Browser initialized. 12:30:17 INFO - Running cycle 1/1 for dromaeo_css test... 12:30:17 INFO - TEST-INFO | started process 1979 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpPXmprW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:30:29 INFO - PROCESS | 1979 | RSS: Main: 237072384 12:30:29 INFO - PROCESS | 1979 | 12:31:20 INFO - PROCESS | 1979 | 1482179480658 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] 12:33:33 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49336/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49336/tests/dromaeo/cssquery-ext.html) 12:33:34 INFO - PROCESS | 1979 | RSS: Main: 376418304 12:33:34 INFO - PROCESS | 1979 | 12:36:37 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49336/tests/dromaeo/cssquery-ext.html (next: http://localhost:49336/tests/dromaeo/cssquery-jquery.html) 12:36:38 INFO - PROCESS | 1979 | RSS: Main: 371585024 12:36:38 INFO - PROCESS | 1979 | 12:39:40 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49336/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49336/tests/dromaeo/cssquery-mootools.html) 12:39:41 INFO - PROCESS | 1979 | RSS: Main: 351682560 12:39:41 INFO - PROCESS | 1979 | 12:42:43 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49336/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49336/tests/dromaeo/cssquery-prototype.html) 12:42:44 INFO - PROCESS | 1979 | RSS: Main: 349794304 12:42:44 INFO - PROCESS | 1979 | 12:45:48 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49336/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49336/tests/dromaeo/cssquery-yui.html) 12:45:48 INFO - PROCESS | 1979 | RSS: Main: 338677760 12:45:48 INFO - PROCESS | 1979 | 12:48:52 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49336/tests/dromaeo/cssquery-yui.html (next: http://localhost:49336/tests/dromaeo/cssquery-dojo.html) 12:48:52 INFO - PROCESS | 1979 | RSS: Main: 477028352 12:48:52 INFO - PROCESS | 1979 | 12:48:52 INFO - PROCESS | 1979 | __start_tp_report 12:48:52 INFO - PROCESS | 1979 | _x_x_mozilla_page_load 12:48:52 INFO - PROCESS | 1979 | _x_x_mozilla_page_load_details 12:48:52 INFO - PROCESS | 1979 | |i|pagename|runs| 12:48:52 INFO - PROCESS | 1979 | |0;dojo.html;3276.164578032601;3278.2460034192136;3290.457074582693;3290.703836654702;3352.0614228016148;5452.372977107634;5500.3949565547755;5551.611387202897;5621.2692349994495;5657.745401456928;5543.861403464915;5565.721713914299;5657.0665840136435;5658.830235092943;5700.515456186229;4984.576311013569;5013.949860501403;5024.447310795809;5026.447090820006;5147.279380886679;5097.49025097491;5140.383154021504;5169.793208271664;5176.974115129419;5182;5034.09386310464;5117.616178786606;5119.8208062717995;5143.742812859361;5202.03762303975;5062.746862656889;5116.437191908887;5136.229565565195;5146.536811686966;5149.639525233235;5054.671446356012;5072.923906141411;5088.847334579968;5098.796048158069;5117.590592752608;5530.142827861688;5583.776648934037;5590;5614.522765564931;5636.633618814764;6121.755129794803;6128.509719222496;6131;6135.263768347782;6144.139820425144;6127.754889804402;6164.6917654117115;6168.629882207082;6179.6292222466345;6192.133101365767;5503.229547863302;5597.916031259534;5612.242347283105;5645.943540564624;5650.773969041193;6139.216166136444;6153.107799369066;6190.969045154746;6210.689465526705;6215.471684906744;6041.577089603774;6043.244594425697;6066.787662431793;6100.694965251809;6107.969460152671;6161.168242287324;6163.691815409212;6170.845728856814;6171.938280617136;6193.721282542297;5931.555133365015;5975.880482390327;6019.187409699722;6104.786332478342;6124.479419249414;5102.897942041139;5939.554533409925;6135.306216178427;6194.876102477925;6221.813345599639;4855.1260773061185;4887.29134275528;4890.608751299887;4907.631927605444;4929.359183306147;4261.446012018479;4367.388565600819;4368.039031413147;4390.692651514363;4424.11517696462;5492.725363731797;5561.860953476195;5572.860678482989;5576.9163462547285;5582.832515024475;6189;6196.628202307876;6218.906716399258;6228.688565571703;6230.750769969241;4758.881662809306;5456.208849716769;5657.12314591239;5668.093105103246;5686.3744988051285;5185.818496352685;5263.578913686896;5319.973400132974;5332.733363331818;5336.546393556591;6253.37466253371;6287.559870808999;6292.559520833589;6321.841953951188;6336.746530138743;6223.439890409885;6226.5641405101205;6226.844328891814;6232.376762323732;6237.594556353823;6195.473384762166;6280.057991301342;6305.054241863573;6305.621662700252;6308.936910630835;5749.1663708762835;5754.971225144015;5767.279090113736;5883.029300165596;5935.851603709942;5897.557683173865;5902.557308201988;5911.408859114226;5912.349641539513;5948.405159484017;5695.117256825199;5701.087825947829;5704.286964129484;5706.400827913009;5716.685582293014;5174.534291913746;5681.829545113653;5799.130130480462;5884.264466941632;5934.169216309807;5700.914486282626;5845.678487683048;5850.23946886902;5861.824145275478;5898.705064746659;5944.732487038007;6010.639361638316;6014.578979471395;6032.095185722177;6036.245469316335;5688.715564221689;5711.257536520226;5793.971030144822;5815.621984570989;5825.94174058271 12:48:52 INFO - PROCESS | 1979 | |1;ext.html;446.8391379103524;458.96557758168143;465.8609699285247;470.6117453101192;482.49338194895364;30409.84795076027;38473;39556.60443395562;39790;41816.79091604545;39941.80029099857;40857;41288.58711412885;41312.96717582062;41397.793011034904;8413.621387037598;9298.070192980715;9509.667161649344;9510.33427660064;9515.476648784314;8461.915380846174;11038.227324087316;11301;11330;11469;11281.605143819968;11304.265222760494;11356.772864542705;11358.03456706181;11393.54425822966;11256.718582035473;11332.546698132064;11333.716657083638;11368.26106303096;11369.147313951487;11171.273867198688;11262.324260544394;11271.774564508745;11276.267042642285;11285.71785705364;39019.41470877939;39323.8033809832;39354.40968385476;39363.606363936284;39373;3312.867485300585;3341.532185494033;3414.6585341465902;3449.292894956528;3505.4741788731894;27269.590956135675;27864;28067.719322806715;28368.574471382944;28795.28011799722;3147.339058797655;3152.0543836849083;3169.0968074098773;3184.442722523549;3255.9837200813845;494038.5298073523;494735.9999999964;495356;495980;496431;42853.1429371417;53108;53139.734301329016;53153.46846531562;53161;53369.733151333996;53434.73282633562;53503.19745203825;53540.46459535355;53669;14643.34104965279;15094.54716358511;15139.167345796088;15159.772603410958;15160.696786064216;10666.41334726582;10930.508127134299;10970.616028439126;11781.116416268815;11894.82157767634;16475.58811029734;16732.498025059267;16864.49406517782;17048.403305884236;17111.74332385015;6443.548951573439;7168.53404528704;7264.709411623476;7298.744543940937;7360.96319518399;909.6497848328441;912.8356895758694;913.7624217703445;963.8457846744627;1030.1810061001522;27475.900963961216;27585.310367240978;29066.205804276444;29670.961516347255;30152.677478197682;1044.5978298355187;1063.9254353103422;1066.4454483668603;1070.4487189097622;1115.1079136690614;13499.527516536875;13952.441902323997;13993.30033498321;14418.279086045655;14818.88858335629;631971;632523;634926;635942;636853;48329.75835120802;48872.26691599558;48898.75550622295;48924.75537622289;49137.0172596546;1232.2852745407642;1278.833751612303;1280.3790161771346;1364.938577764003;1394.6513371657086;24314;26445;27793.44413111686;28716.856415717786;29072.12783616495;38687.41968870413;39208.0197995041;48007.5199248017;48159;48196.5180348192;594089;597959;599600;601287;604460;23793;24266.87866560656;24657.876710616332;25363.112291069723;25421;41055;41586.792066039474;42247;42248.78875605725;42527.787361063;34599.96332439568;34673.65326346805;34999.4750078744;35756.64243357533;36088.81955590205;34792.652073478945;34813.303733925684;35329;35577.82211088928;35581.46627800533;34465;34497.482537761454;34937.47593786146;35042;35158.82420587983;29334.853325733235;30191.698083019768;30633;30748.692513074584;30816.075517734505;20431;23504.059837606303;23637;23814.761852381947;23958.88020559886 12:48:52 INFO - PROCESS | 1979 | |2;jquery.html;320.8524078923695;357.14107571291055;375.4255988337841;380.5433479824211;403.7029303264425;13262.20426774393;13444.932775336134;15675.60810979726;19980.100895459702;20477;19297.324593639227;19899.204031838744;20671.689924651142;20894.89552552239;21193.788062119373;5801.187833703285;6111.663858487781;6142.6314421134875;6144.047672610753;6155.753769849201;5618.381977982419;5927;5986.982213023796;5997.520198384141;5998.460138587527;5602.7758889644565;5821.126830975367;5938.020226662596;5939.406059394069;5975.492083172936;5892.852678683024;5960.433758792908;5979;5985.820425387245;5997.070454079625;5017.222330538772;5147.897042059175;5149.0731668299695;5213.713245771481;5232.790688372498;25077;25179.118730844333;25488.617670734955;25577.360565985815;25743.485130297475;2098.3914664747203;2340.2979106268053;2363.1374548289923;3056.3581647853975;3145.811251324928;14388.496402625962;15127.243637818065;15890.52328430149;15998.76001859973;16015.679686406207;1768.619746754454;1801.9369322073665;1803.071418219618;1860.7674040744907;1862.6833438315518;117541;119158.40420797841;121515.06364427156;121950;122568;8580.71289306609;10409.271351005356;10450.059494645518;10943.179261555415;10978.341299522055;13791.586252412444;13802.447902084004;13811.378487968066;13812.792808107686;13818.654533636538;8124.63439145228;8451;8494.320454363637;8589.269912057545;8647.827043459221;8517.957410213034;8526.531040792815;8530.616122274512;8702.390832641655;8721.30229581632;5479.424660410599;6521.47828173745;6620.003539057423;6620.8344791380605;6749.426298764562;1672.406295764986;1846.3630047633544;1852.8795628284117;1853.4439668099517;1854.6661600911696;846.1327139681875;947.3321308477507;978.8629591857145;992.5533509920565;1089;21780.960504652052;22127;22133.77866221317;22181.11275548992;22210.555788884132;940.2806852757645;946.7917058247175;968.912797848183;1011.9392836429838;1031.7523794289316;10302.484875756332;11615.070794336432;11812.940935295268;11813;11845.993090587397;549282;549809;559404;563043.9239019058;571229;70635.6468217666;73987;107426.46286768516;116318.85767996158;120633.79366206401;906.3474298505066;933.6032186320787;979.3193730357333;1042.4162469017224;1043.8486419469134;16015.599610009844;18042.63914721672;19921.402357929284;20309.78141311526;20490.97545122708;48731.51268487411;51836.96326073533;53344;53613;54376.45623543714;59042;67806;73354;74412;75268;7724.9227507726455;7781.455298129076;7881.881771773543;7942.960285198537;7996.280334769898;12395.380230988234;12550.121491495507;12604.054695897661;12968.935155324163;13014.284214368301;10958.28771129874;11160.944195278971;11200.38397888124;11202.327860328407;11368.658940231806;9885;10637.574497020032;10995.907366243518;11071.5571377144;11174.888251117385;11069.391183484986;11181.888181118411;11205.775884482102;11217.158713096387;11466.2546934449;7739.148693643808;7806.219378062148;7875.488093273919;7898.249666281694;7954.602269886598;10851.077658399125;10891.782164356828;11042.779144416905;11057.170712196777;11099.001089901625 12:48:52 INFO - PROCESS | 1979 | |3;mootools.html;1487.0631502153644;1526.2979029646363;1719.4068046523944;1861.5997560524484;1909.703995880639;8171.142030086837;8673.522956237404;8680.262177714894;8683.73948781536;8687.956560217199;6431.1317972073875;7830.334421574173;7833.882491762613;7923.168067352932;7934.96032519838;2039.1027947703037;2078.3972647932083;2252.6395776675736;2328.499372634883;2336.2056900653774;2339.6607491913746;2341.555104530134;2344.074090734159;2346.190564255338;2347.471818840764;2274.317704688595;2279.2022792022744;2287.4853158039473;2325.6046472099783;2337.345543247893;2283.132409684326;2305.0779688124717;2307.192482631074;2311.6070268054305;2314.4445333120016;2126.2345555600127;2189.9562008759895;2310.491691827812;2312.606856834342;2325;8147.348212143014;8280;8481.830363392759;8637.65449382024;8653.567321633893;5146.356705411824;5300.0459917214885;5314.681119132864;5318.069337865897;5319.28189694394;2939.206414268157;3421;3425.1779572902324;3510.4558793387064;3524.1365865362895;1004.3120462483149;1022.2792930983638;1038.382162613244;1039.9116075133622;1041.8958104189596;10980.780384392347;11124.944375278072;11140.220184587082;11142.442877856156;11160.497777599947;4400.141972315368;4606.677532572755;4669.322948172496;4697.553732395417;4710.128626204163;9672.56473458696;9679.903200968041;9684.273679474067;9690.51547422626;9723.611055557698;5233.345831771028;5233.973830130825;5234.031704134671;5242.554382877422;5262.894742105136;4140.15126898985;4385.728138839764;4792.856214313576;4809.398825146856;4884.3161957326;3188.6651901550467;3549.396602577516;3595.173110184672;3624.075860655516;3854.6338097880657;1062.6811956413046;1260;1260.7541529401678;1282.6344491819973;1284.3064745037575;807.4630370803468;905.7463910105181;910.2808781062886;913.8126684029758;967.1247520993512;4611.700239484423;5514.972425137848;5746.569007324468;5761.3950535194035;5931.940680593225;960.1646567486332;1005.1355833982769;1037.092544023979;1054.298891237334;1089.199438412766;3628;3708.35103856824;3721.7580857244193;3749.2630379822335;3868.3617203161725;10045.849312260321;10210.693679189637;10291.53688084038;10337.173026157889;10395.220358473145;10257.33327333721;10267.589296428208;10276.845847312296;10282.07461328484;10285.794284114276;7791.649375778104;7904.525728456311;8007.639656215484;8090.312323452455;8147.307478864244;5718.685472299064;5790.449907258803;5846.94153058464;5888.205092312483;5999.760009599741;9267.351285410226;9676.419414835133;9686.70939871805;9688.176504997155;9699.369540979813;9099.909000909905;9536.380135291183;9544.809103817746;9657.855132172883;9735.269854761063;7161.319674630901;7347.375473084848;7358.852822943404;7364.668589913574;7365.300296471826;7220.3140701633265;7467.290607392289;7473.588952607659;7860.6069696513805;7922.168172342052;7020.789376318514;7049;7240.674169662483;7274.927250727425;7339.376153027052;6906.412954898688;7097.680604372712;7155.3202445767565;7169.247229040876;7322.048133742793;6420.390062944013;6727.629980350932;6804.659767011729;6824.385805277549;6833.3166683331265;4818.301346304836;4835.95164048355;4947.233178857283;4980.576650984707;5132.153194722829;4359.564043595615;4897.3878265216845;4957.206846904623;5020.221865610836;5036.118679231193 12:48:52 INFO - PROCESS | 1979 | |4;prototype.html;349.0714698900923;356.2963147783129;361.88057940879514;374.40656559353425;376.17805095865555;4486.528914463983;4510.932336014954;5022.924656130161;5170.302009228753;5222.686638801674;4151.750894946305;4605.355250264957;5071.366079240095;5076.2385642153695;5120.871978200546;4028.3685107531423;4077.9592204077876;4082.3672330788777;4105.387259211904;4131.814068366915;3303.4053870303337;3749.144173634041;3949.743266687656;4074.7962601869935;4079.9592004079877;3645.3182285891307;4030.496187976503;4043.615856493643;4079.224947260026;4113.4035564843225;3373.3927892979254;4061.4720086388875;4065.288574499451;4072.6741860651077;4089.9591004090025;3588.026585378058;3593.568771747381;3595.7842529448317;3609.9097522561883;3618.2039951210954;3965.4844870166694;4805.630395337347;4926.901461970776;4963.60291176705;5003.124453220672;4138.703019823996;4647.838040489877;4667.13657973276;4698.130845793539;4698.929516057262;4762.38089048425;5379.444763737232;5434.402215756264;5473.877855039707;5486.451354864522;3860.1269338734405;3861.6331448512346;3945.230680017398;3962.346212874872;3970.7419017763755;5626.521745651625;5629.8592535186945;5638.04153293941;5669.574781891375;5740.799072032459;4050;4061.3095773717946;4065.573114822901;4067.654249388776;4069.4709687740997;3444.7436928811667;3843.577206507282;4030.5767894371256;4098.6516146127915;4107.9178416432105;4541.296099104644;4568.132054909556;4616.699914505613;4643.2587779582655;4649.465311489154;4739.265413860857;5269.075663006991;5364.785408583691;5465.535429488458;5472.890542189134;1257.8176164456102;1279.2218815845981;1283.7547578848503;1324.582756431721;1339.7119619281707;821.3634433314229;876.8772371867943;918.8529835226332;943.532806485921;948.7865230323122;4587.747673877902;4604.8388306409115;4776.737279449663;4779.617630589544;4821.807127714922;4897.8285759998225;5203.297554830126;5226.503482169188;5237.947620523746;5247.790088396498;4129.772862492532;4148.979255103705;4362.345648152803;4742.5020372861045;4794.736289504111;2644.6297518347446;2694.4133631713385;2729.7679697225562;2732.9912514301973;2777.680566734811;5078.603384069411;5147.433782283946;5443.673379597237;5446.7276636168035;5543.6183927804;4867.464578896319;4890.926636100461;5340.572754179656;5346.812861549827;5378.381486129067;4830.66185367028;4904.583110435581;5080.669756465818;5437.519987208111;5457.645253058538;4747.501512341154;4827.961988172559;5100.336956195671;5206.687598744087;5254.97372513135;5486.149646804752;5525.613207075467;5537.640053396677;5579;5625.634333768292;4789.640776941674;5628;5731.3408957968695;5775.66824881339;5800.738966746591;3640.8361623727524;3734.3382194922997;3744.2885851688093;3773.2830762155104;3788.4885540451687;4916.434610019894;5536.754230298151;5543.473370029841;5568.721563921868;5572.9968605651375;4660.976695116503;4769.809207631794;5361.088614935392;5389.622726409114;5488.533474654699;4366.628836548802;4385.627221686193;5098.592112630907;5411.132099987013;5510.539706977574;4655.648897306838;4746.406699162605;5108.770105345343;5315.521603055744;5361.088614935548;5174.844754657366;5365.3293338332705;5430.565554755531;5438.809641662523;5468.617196796186;4526.592606665416;5352.839414817562;5355.277037599874;5368.194770784414;5426.782928682808 12:48:52 INFO - PROCESS | 1979 | |5;yui.html;728.402709777982;749.542778904868;794.079596318088;809.9589035630214;822.4695071678764;12695.682607934807;14506.637334066654;15436.459723909666;15471.226438678063;15499.767503487443;11440.370779607118;14140.50508232212;14154.433822647108;14157.150570965723;14191.92904035481;695.839956809934;707.8230442389403;859.8495263328892;869.3523325122777;887.786931136529;711.2247650061432;867.557545651719;876.6887754847033;882.9690960816373;883.2536506651869;924.6209054287743;926.6200857648365;927.5547737086202;928.3455164109287;928.7863791327999;726.7383741852929;923.6490133749165;924.4037595750771;925.847235206197;927.1609193679731;547.9971651877095;670.0518765946181;677.4614181725491;679.3817625960402;680.73451353972;14529.346179421951;14562.126272423688;14563.854361456462;14565;14581.927090364481;13382;13423.932880335537;13431.597052088453;13437.193768373929;13481.460741570325;11324.830127548094;11568.710782230428;12264.448099835528;12567.120301578892;12757.744845103047;4282.207791558571;4516.4806047304655;4519.435070616173;4551.726896386194;4568.862934111982;100463.49768251185;100939;104947;105715;105841;10660.46697665129;10737.51681174349;10748.462576871125;10751.118554252975;10986.419937322851;19961.401157965283;20545.897270513553;21036.158553657682;21104.78895211028;21497.92510374475;7598.734044308423;7897.685024537794;7924.762257132295;8030.638621262057;8066.6773329067355;3995.615536080087;4043.353063509824;4128.2156390285745;4164.292070348048;4182.519010313853;3490.7032902203596;3570.2145527983803;3572.1783989682517;3579.749417540799;3618.927621447609;654.456800855289;663.3432901427649;666.5034549260831;670.122139996606;675.2066322071645;584.33677775724;635.8219698484431;670.6177478837113;676.7022510095542;678.7827895073627;8765.342599305077;9178.2770533161;9317.72046838596;9336.692862999185;9444.055594440639;627.3130921640796;629.2543336146681;639.2520750721667;640.3020707428832;673.8113328268092;4360.411344468456;4369.584889435499;4534.274516077412;4567.15262546766;4713.95286047142;87677.56161219154;108344.45827770968;108518.45740771246;108795;109708;91059;92307.53846230726;93870;95100.04899950912;96125.51937240409;60928.086078707965;81117;81595;81644.77532837012;84166;7229.783106506813;8540.658373664985;8554.700585479479;8853;8911;51891.740541297055;53378.93242135213;53655.19517207323;54452.72773636106;55020.44979550153;57331.706731730264;69793;72279.27720722725;72535.39381854437;73637;11577.131715121232;11762.76474470523;11870.584529541424;11927.46326415296;12141.15011949155;12135.514579416724;12313.13808033429;12439.75120497567;12906.032047596656;12918.612441626767;10454.42500662471;11725.530978760755;12179.756404871676;12406.441710123247;12495.812562811747;11343.602973895873;11849.783053214442;12100.85041921016;12204.145709800583;12408.62774116778;11857.52569897229;12088.637340879788;12182.573609923611;12272.570460033856;12428.378581070729;9082.228010619172;9877.308588398742;10093.798124037625;10207.336523125972;10514.26400151982;7213.891791623025;8997.865032024394;9116.270698343984;10211.211688105554;10337.74155646115 12:48:52 INFO - PROCESS | 1979 | __end_tp_report 12:48:52 INFO - PROCESS | 1979 | __start_cc_report 12:48:52 INFO - PROCESS | 1979 | _x_x_mozilla_cycle_collect,1436 12:48:52 INFO - PROCESS | 1979 | __end_cc_report 12:48:52 INFO - PROCESS | 1979 | __startTimestamp1482180532493__endTimestamp 12:48:52 INFO - PROCESS | 1979 | 12:48:52 INFO - PROCESS | 1979 | ------- Summary: start ------- 12:48:52 INFO - PROCESS | 1979 | Number of tests: 6 12:48:52 INFO - PROCESS | 1979 | 12:48:52 INFO - PROCESS | 1979 | [#0] dojo.html Cycles:165 Average:5611.43 Median:5704.29 stddev:630.37 (11.1%) stddev-sans-first:605.10 12:48:52 INFO - PROCESS | 1979 | Values: 3276.2 3278.2 3290.5 3290.7 3352.1 5452.4 5500.4 5551.6 5621.3 5657.7 5543.9 5565.7 5657.1 5658.8 5700.5 4984.6 5013.9 5024.4 5026.4 5147.3 5097.5 5140.4 5169.8 5177.0 5182.0 5034.1 5117.6 5119.8 5143.7 5202.0 5062.7 5116.4 5136.2 5146.5 5149.6 5054.7 5072.9 5088.8 5098.8 5117.6 5530.1 5583.8 5590.0 5614.5 5636.6 6121.8 6128.5 6131.0 6135.3 6144.1 6127.8 6164.7 6168.6 6179.6 6192.1 5503.2 5597.9 5612.2 5645.9 5650.8 6139.2 6153.1 6191.0 6210.7 6215.5 6041.6 6043.2 6066.8 6100.7 6108.0 6161.2 6163.7 6170.8 6171.9 6193.7 5931.6 5975.9 6019.2 6104.8 6124.5 5102.9 5939.6 6135.3 6194.9 6221.8 4855.1 4887.3 4890.6 4907.6 4929.4 4261.4 4367.4 4368.0 4390.7 4424.1 5492.7 5561.9 5572.9 5576.9 5582.8 6189.0 6196.6 6218.9 6228.7 6230.8 4758.9 5456.2 5657.1 5668.1 5686.4 5185.8 5263.6 5320.0 5332.7 5336.5 6253.4 6287.6 6292.6 6321.8 6336.7 6223.4 6226.6 6226.8 6232.4 6237.6 6195.5 6280.1 6305.1 6305.6 6308.9 5749.2 5755.0 5767.3 5883.0 5935.9 5897.6 5902.6 5911.4 5912.3 5948.4 5695.1 5701.1 5704.3 5706.4 5716.7 5174.5 5681.8 5799.1 5884.3 5934.2 5700.9 5845.7 5850.2 5861.8 5898.7 5944.7 6010.6 6014.6 6032.1 6036.2 5688.7 5711.3 5794.0 5815.6 5825.9 12:48:52 INFO - PROCESS | 1979 | 12:48:52 INFO - PROCESS | 1979 | [#1] ext.html Cycles:180 Average:68984.74 Median:18973.39 stddev:155158.34 (817.8%) stddev-sans-first:155508.26 12:48:52 INFO - PROCESS | 1979 | Values: 446.8 459.0 465.9 470.6 482.5 30409.8 38473.0 39556.6 39790.0 41816.8 39941.8 40857.0 41288.6 41313.0 41397.8 8413.6 9298.1 9509.7 9510.3 9515.5 8461.9 11038.2 11301.0 11330.0 11469.0 11281.6 11304.3 11356.8 11358.0 11393.5 11256.7 11332.5 11333.7 11368.3 11369.1 11171.3 11262.3 11271.8 11276.3 11285.7 39019.4 39323.8 39354.4 39363.6 39373.0 3312.9 3341.5 3414.7 3449.3 3505.5 27269.6 27864.0 28067.7 28368.6 28795.3 3147.3 3152.1 3169.1 3184.4 3256.0 494038.5 494736.0 495356.0 495980.0 496431.0 42853.1 53108.0 53139.7 53153.5 53161.0 53369.7 53434.7 53503.2 53540.5 53669.0 14643.3 15094.5 15139.2 15159.8 15160.7 10666.4 10930.5 10970.6 11781.1 11894.8 16475.6 16732.5 16864.5 17048.4 17111.7 6443.5 7168.5 7264.7 7298.7 7361.0 909.6 912.8 913.8 963.8 1030.2 27475.9 27585.3 29066.2 29671.0 30152.7 1044.6 1063.9 1066.4 1070.4 1115.1 13499.5 13952.4 13993.3 14418.3 14818.9 631971.0 632523.0 634926.0 635942.0 636853.0 48329.8 48872.3 48898.8 48924.8 49137.0 1232.3 1278.8 1280.4 1364.9 1394.7 24314.0 26445.0 27793.4 28716.9 29072.1 38687.4 39208.0 48007.5 48159.0 48196.5 594089.0 597959.0 599600.0 601287.0 604460.0 23793.0 24266.9 24657.9 25363.1 25421.0 41055.0 41586.8 42247.0 42248.8 42527.8 34600.0 34673.7 34999.5 35756.6 36088.8 34792.7 34813.3 35329.0 35577.8 35581.5 34465.0 34497.5 34937.5 35042.0 35158.8 29334.9 30191.7 30633.0 30748.7 30816.1 20431.0 23504.1 23637.0 23814.8 23958.9 12:48:52 INFO - PROCESS | 1979 | 12:48:52 INFO - PROCESS | 1979 | [#2] jquery.html Cycles:180 Average:33006.41 Median:25333.87 stddev:92915.98 (366.8%) stddev-sans-first:93144.23 12:48:52 INFO - PROCESS | 1979 | Values: 320.9 357.1 375.4 380.5 403.7 13262.2 13444.9 15675.6 19980.1 20477.0 19297.3 19899.2 20671.7 20894.9 21193.8 5801.2 6111.7 6142.6 6144.0 6155.8 5618.4 5927.0 5987.0 5997.5 5998.5 5602.8 5821.1 5938.0 5939.4 5975.5 5892.9 5960.4 5979.0 5985.8 5997.1 5017.2 5147.9 5149.1 5213.7 5232.8 25077.0 25179.1 25488.6 25577.4 25743.5 2098.4 2340.3 2363.1 3056.4 3145.8 14388.5 15127.2 15890.5 15998.8 16015.7 1768.6 1801.9 1803.1 1860.8 1862.7 117541.0 119158.4 121515.1 121950.0 122568.0 8580.7 10409.3 10450.1 10943.2 10978.3 13791.6 13802.4 13811.4 13812.8 13818.7 8124.6 8451.0 8494.3 8589.3 8647.8 8518.0 8526.5 8530.6 8702.4 8721.3 5479.4 6521.5 6620.0 6620.8 6749.4 1672.4 1846.4 1852.9 1853.4 1854.7 846.1 947.3 978.9 992.6 1089.0 21781.0 22127.0 22133.8 22181.1 22210.6 940.3 946.8 968.9 1011.9 1031.8 10302.5 11615.1 11812.9 11813.0 11846.0 549282.0 549809.0 559404.0 563043.9 571229.0 70635.6 73987.0 107426.5 116318.9 120633.8 906.3 933.6 979.3 1042.4 1043.8 16015.6 18042.6 19921.4 20309.8 20491.0 48731.5 51837.0 53344.0 53613.0 54376.5 59042.0 67806.0 73354.0 74412.0 75268.0 7724.9 7781.5 7881.9 7943.0 7996.3 12395.4 12550.1 12604.1 12968.9 13014.3 10958.3 11160.9 11200.4 11202.3 11368.7 9885.0 10637.6 10995.9 11071.6 11174.9 11069.4 11181.9 11205.8 11217.2 11466.3 7739.1 7806.2 7875.5 7898.2 7954.6 10851.1 10891.8 11042.8 11057.2 11099.0 12:48:52 INFO - PROCESS | 1979 | 12:48:52 INFO - PROCESS | 1979 | [#3] mootools.html Cycles:180 Average:5495.89 Median:4968.89 stddev:3043.25 (61.2%) stddev-sans-first:3036.88 12:48:52 INFO - PROCESS | 1979 | Values: 1487.1 1526.3 1719.4 1861.6 1909.7 8171.1 8673.5 8680.3 8683.7 8688.0 6431.1 7830.3 7833.9 7923.2 7935.0 2039.1 2078.4 2252.6 2328.5 2336.2 2339.7 2341.6 2344.1 2346.2 2347.5 2274.3 2279.2 2287.5 2325.6 2337.3 2283.1 2305.1 2307.2 2311.6 2314.4 2126.2 2190.0 2310.5 2312.6 2325.0 8147.3 8280.0 8481.8 8637.7 8653.6 5146.4 5300.0 5314.7 5318.1 5319.3 2939.2 3421.0 3425.2 3510.5 3524.1 1004.3 1022.3 1038.4 1039.9 1041.9 10980.8 11124.9 11140.2 11142.4 11160.5 4400.1 4606.7 4669.3 4697.6 4710.1 9672.6 9679.9 9684.3 9690.5 9723.6 5233.3 5234.0 5234.0 5242.6 5262.9 4140.2 4385.7 4792.9 4809.4 4884.3 3188.7 3549.4 3595.2 3624.1 3854.6 1062.7 1260.0 1260.8 1282.6 1284.3 807.5 905.7 910.3 913.8 967.1 4611.7 5515.0 5746.6 5761.4 5931.9 960.2 1005.1 1037.1 1054.3 1089.2 3628.0 3708.4 3721.8 3749.3 3868.4 10045.8 10210.7 10291.5 10337.2 10395.2 10257.3 10267.6 10276.8 10282.1 10285.8 7791.6 7904.5 8007.6 8090.3 8147.3 5718.7 5790.4 5846.9 5888.2 5999.8 9267.4 9676.4 9686.7 9688.2 9699.4 9099.9 9536.4 9544.8 9657.9 9735.3 7161.3 7347.4 7358.9 7364.7 7365.3 7220.3 7467.3 7473.6 7860.6 7922.2 7020.8 7049.0 7240.7 7274.9 7339.4 6906.4 7097.7 7155.3 7169.2 7322.0 6420.4 6727.6 6804.7 6824.4 6833.3 4818.3 4836.0 4947.2 4980.6 5132.2 4359.6 4897.4 4957.2 5020.2 5036.1 12:48:52 INFO - PROCESS | 1979 | 12:48:52 INFO - PROCESS | 1979 | [#4] prototype.html Cycles:180 Average:4371.41 Median:4773.27 stddev:1281.19 (26.8%) stddev-sans-first:1248.70 12:48:52 INFO - PROCESS | 1979 | Values: 349.1 356.3 361.9 374.4 376.2 4486.5 4510.9 5022.9 5170.3 5222.7 4151.8 4605.4 5071.4 5076.2 5120.9 4028.4 4078.0 4082.4 4105.4 4131.8 3303.4 3749.1 3949.7 4074.8 4080.0 3645.3 4030.5 4043.6 4079.2 4113.4 3373.4 4061.5 4065.3 4072.7 4090.0 3588.0 3593.6 3595.8 3609.9 3618.2 3965.5 4805.6 4926.9 4963.6 5003.1 4138.7 4647.8 4667.1 4698.1 4698.9 4762.4 5379.4 5434.4 5473.9 5486.5 3860.1 3861.6 3945.2 3962.3 3970.7 5626.5 5629.9 5638.0 5669.6 5740.8 4050.0 4061.3 4065.6 4067.7 4069.5 3444.7 3843.6 4030.6 4098.7 4107.9 4541.3 4568.1 4616.7 4643.3 4649.5 4739.3 5269.1 5364.8 5465.5 5472.9 1257.8 1279.2 1283.8 1324.6 1339.7 821.4 876.9 918.9 943.5 948.8 4587.7 4604.8 4776.7 4779.6 4821.8 4897.8 5203.3 5226.5 5237.9 5247.8 4129.8 4149.0 4362.3 4742.5 4794.7 2644.6 2694.4 2729.8 2733.0 2777.7 5078.6 5147.4 5443.7 5446.7 5543.6 4867.5 4890.9 5340.6 5346.8 5378.4 4830.7 4904.6 5080.7 5437.5 5457.6 4747.5 4828.0 5100.3 5206.7 5255.0 5486.1 5525.6 5537.6 5579.0 5625.6 4789.6 5628.0 5731.3 5775.7 5800.7 3640.8 3734.3 3744.3 3773.3 3788.5 4916.4 5536.8 5543.5 5568.7 5573.0 4661.0 4769.8 5361.1 5389.6 5488.5 4366.6 4385.6 5098.6 5411.1 5510.5 4655.6 4746.4 5108.8 5315.5 5361.1 5174.8 5365.3 5430.6 5438.8 5468.6 4526.6 5352.8 5355.3 5368.2 5426.8 12:48:52 INFO - PROCESS | 1979 | 12:48:52 INFO - PROCESS | 1979 | [#5] yui.html Cycles:180 Average:20310.43 Median:4559.44 stddev:29999.95 (658.0%) stddev-sans-first:30048.08 12:48:52 INFO - PROCESS | 1979 | Values: 728.4 749.5 794.1 810.0 822.5 12695.7 14506.6 15436.5 15471.2 15499.8 11440.4 14140.5 14154.4 14157.2 14191.9 695.8 707.8 859.8 869.4 887.8 711.2 867.6 876.7 883.0 883.3 924.6 926.6 927.6 928.3 928.8 726.7 923.6 924.4 925.8 927.2 548.0 670.1 677.5 679.4 680.7 14529.3 14562.1 14563.9 14565.0 14581.9 13382.0 13423.9 13431.6 13437.2 13481.5 11324.8 11568.7 12264.4 12567.1 12757.7 4282.2 4516.5 4519.4 4551.7 4568.9 100463.5 100939.0 104947.0 105715.0 105841.0 10660.5 10737.5 10748.5 10751.1 10986.4 19961.4 20545.9 21036.2 21104.8 21497.9 7598.7 7897.7 7924.8 8030.6 8066.7 3995.6 4043.4 4128.2 4164.3 4182.5 3490.7 3570.2 3572.2 3579.7 3618.9 654.5 663.3 666.5 670.1 675.2 584.3 635.8 670.6 676.7 678.8 8765.3 9178.3 9317.7 9336.7 9444.1 627.3 629.3 639.3 640.3 673.8 4360.4 4369.6 4534.3 4567.2 4714.0 87677.6 108344.5 108518.5 108795.0 109708.0 91059.0 92307.5 93870.0 95100.0 96125.5 60928.1 81117.0 81595.0 81644.8 84166.0 7229.8 8540.7 8554.7 8853.0 8911.0 51891.7 53378.9 53655.2 54452.7 55020.4 57331.7 69793.0 72279.3 72535.4 73637.0 11577.1 11762.8 11870.6 11927.5 12141.2 12135.5 12313.1 12439.8 12906.0 12918.6 10454.4 11725.5 12179.8 12406.4 12495.8 11343.6 11849.8 12100.9 12204.1 12408.6 11857.5 12088.6 12182.6 12272.6 12428.4 9082.2 9877.3 10093.8 10207.3 10514.3 7213.9 8997.9 9116.3 10211.2 10337.7 12:48:52 INFO - PROCESS | 1979 | -------- Summary: end -------- 12:48:52 INFO - PROCESS | 1979 | 12:48:53 INFO - TEST-INFO | 1979: exit 0 12:48:53 INFO - TEST-OK | dromaeo_css | took 1119263ms 12:48:53 INFO - TEST-START | kraken 12:48:53 INFO - operating with platform_type : mac_ 12:48:53 INFO - Initialising browser for kraken test... 12:48:53 INFO - TEST-INFO | started process 1982 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpa4QP9Y/profile http://localhost:49336/getInfo.html) 12:48:55 INFO - PROCESS | 1982 | __metrics Screen width/height:1600/1200 12:48:55 INFO - PROCESS | 1982 | colorDepth:24 12:48:55 INFO - PROCESS | 1982 | Browser inner width/height: 1024/689 12:48:55 INFO - PROCESS | 1982 | __metrics 12:48:55 INFO - PROCESS | 1982 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:48:55 INFO - PROCESS | 1982 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:48:56 INFO - TEST-INFO | 1982: exit 0 12:48:56 INFO - Browser initialized. 12:48:56 INFO - Running cycle 1/1 for kraken test... 12:48:56 INFO - TEST-INFO | started process 1983 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpa4QP9Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:49:08 INFO - PROCESS | 1983 | RSS: Main: 237268992 12:49:08 INFO - PROCESS | 1983 | 12:49:11 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49336/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49336/tests/kraken/driver.html?testName=audio-beat-detection) 12:49:12 INFO - PROCESS | 1983 | RSS: Main: 291721216 12:49:12 INFO - PROCESS | 1983 | 12:49:14 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49336/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49336/tests/kraken/driver.html?testName=audio-dft) 12:49:15 INFO - PROCESS | 1983 | RSS: Main: 292675584 12:49:15 INFO - PROCESS | 1983 | 12:49:18 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49336/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49336/tests/kraken/driver.html?testName=audio-fft) 12:49:19 INFO - PROCESS | 1983 | RSS: Main: 382894080 12:49:19 INFO - PROCESS | 1983 | 12:49:21 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49336/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49336/tests/kraken/driver.html?testName=audio-oscillator) 12:49:21 INFO - PROCESS | 1983 | RSS: Main: 285425664 12:49:21 INFO - PROCESS | 1983 | 12:49:23 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49336/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49336/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:49:24 INFO - PROCESS | 1983 | RSS: Main: 288989184 12:49:24 INFO - PROCESS | 1983 | 12:49:27 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49336/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49336/tests/kraken/driver.html?testName=imaging-darkroom) 12:49:28 INFO - PROCESS | 1983 | RSS: Main: 328773632 12:49:28 INFO - PROCESS | 1983 | 12:49:31 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49336/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49336/tests/kraken/driver.html?testName=imaging-desaturate) 12:49:31 INFO - PROCESS | 1983 | RSS: Main: 333168640 12:49:31 INFO - PROCESS | 1983 | 12:49:34 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49336/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49336/tests/kraken/driver.html?testName=json-parse-financial) 12:49:35 INFO - PROCESS | 1983 | RSS: Main: 330805248 12:49:35 INFO - PROCESS | 1983 | 12:49:36 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49336/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49336/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:49:37 INFO - PROCESS | 1983 | RSS: Main: 304939008 12:49:37 INFO - PROCESS | 1983 | 12:49:39 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49336/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49336/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:49:39 INFO - PROCESS | 1983 | RSS: Main: 307572736 12:49:39 INFO - PROCESS | 1983 | 12:49:42 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49336/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49336/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:49:42 INFO - PROCESS | 1983 | RSS: Main: 309477376 12:49:42 INFO - PROCESS | 1983 | 12:49:45 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49336/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49336/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:49:46 INFO - PROCESS | 1983 | RSS: Main: 329170944 12:49:46 INFO - PROCESS | 1983 | 12:49:49 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49336/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49336/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:49:50 INFO - PROCESS | 1983 | RSS: Main: 323588096 12:49:50 INFO - PROCESS | 1983 | 12:49:51 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49336/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49336/tests/kraken/driver.html?testName=ai-astar) 12:49:52 INFO - PROCESS | 1983 | RSS: Main: 367816704 12:49:52 INFO - PROCESS | 1983 | 12:49:52 INFO - PROCESS | 1983 | __start_tp_report 12:49:52 INFO - PROCESS | 1983 | _x_x_mozilla_page_load 12:49:52 INFO - PROCESS | 1983 | _x_x_mozilla_page_load_details 12:49:52 INFO - PROCESS | 1983 | |i|pagename|runs| 12:49:52 INFO - PROCESS | 1983 | |0;ai-astar;163;168;169;113;113;117;163;169;169;113 12:49:52 INFO - PROCESS | 1983 | |1;audio-beat-detection;138;109;111;145;110;107;105;122;124;112 12:49:52 INFO - PROCESS | 1983 | |2;audio-dft;187;183;183;184;181;184;184;183;182;183 12:49:52 INFO - PROCESS | 1983 | |3;audio-fft;79;58;58;89;60;58;59;57;72;58 12:49:52 INFO - PROCESS | 1983 | |4;audio-oscillator;90;68;85;69;68;69;83;67;69;84 12:49:52 INFO - PROCESS | 1983 | |5;imaging-gaussian-blur;107;110;108;110;108;110;111;170;112;111 12:49:52 INFO - PROCESS | 1983 | |6;imaging-darkroom;94;94;95;95;93;95;94;95;94;94 12:49:52 INFO - PROCESS | 1983 | |7;imaging-desaturate;87;86;84;87;89;87;88;87;88;83 12:49:52 INFO - PROCESS | 1983 | |8;json-parse-financial;56;56;53;53;55;54;54;54;55;55 12:49:52 INFO - PROCESS | 1983 | |9;json-stringify-tinderbox;67;74;64;69;75;75;70;72;70;70 12:49:52 INFO - PROCESS | 1983 | |10;stanford-crypto-aes;86;87;87;99;105;86;86;89;86;88 12:49:52 INFO - PROCESS | 1983 | |11;stanford-crypto-ccm;141;139;138;142;143;140;150;141;187;141 12:49:52 INFO - PROCESS | 1983 | |12;stanford-crypto-pbkdf2;167;175;171;166;172;169;167;192;223;196 12:49:52 INFO - PROCESS | 1983 | |13;stanford-crypto-sha256-iterative;65;67;67;67;67;67;66;67;65;64 12:49:52 INFO - PROCESS | 1983 | __end_tp_report 12:49:52 INFO - PROCESS | 1983 | __start_cc_report 12:49:52 INFO - PROCESS | 1983 | _x_x_mozilla_cycle_collect,2107 12:49:52 INFO - PROCESS | 1983 | __end_cc_report 12:49:52 INFO - PROCESS | 1983 | __startTimestamp1482180592101__endTimestamp 12:49:52 INFO - PROCESS | 1983 | 12:49:52 INFO - PROCESS | 1983 | ------- Summary: start ------- 12:49:52 INFO - PROCESS | 1983 | Number of tests: 14 12:49:52 INFO - PROCESS | 1983 | 12:49:52 INFO - PROCESS | 1983 | [#0] ai-astar Cycles:10 Average:145.70 Median:165.50 stddev:27.40 (16.6%) stddev-sans-first:28.34 12:49:52 INFO - PROCESS | 1983 | Values: 163.0 168.0 169.0 113.0 113.0 117.0 163.0 169.0 169.0 113.0 12:49:52 INFO - PROCESS | 1983 | 12:49:52 INFO - PROCESS | 1983 | [#1] audio-beat-detection Cycles:10 Average:118.30 Median:117.00 stddev:13.74 (11.7%) stddev-sans-first:12.59 12:49:52 INFO - PROCESS | 1983 | Values: 138.0 109.0 111.0 145.0 110.0 107.0 105.0 122.0 124.0 112.0 12:49:52 INFO - PROCESS | 1983 | 12:49:52 INFO - PROCESS | 1983 | [#2] audio-dft Cycles:10 Average:183.40 Median:183.50 stddev:1.58 (0.9%) stddev-sans-first:1.00 12:49:52 INFO - PROCESS | 1983 | Values: 187.0 183.0 183.0 184.0 181.0 184.0 184.0 183.0 182.0 183.0 12:49:52 INFO - PROCESS | 1983 | 12:49:52 INFO - PROCESS | 1983 | [#3] audio-fft Cycles:10 Average:64.80 Median:59.50 stddev:11.26 (18.9%) stddev-sans-first:10.71 12:49:52 INFO - PROCESS | 1983 | Values: 79.0 58.0 58.0 89.0 60.0 58.0 59.0 57.0 72.0 58.0 12:49:52 INFO - PROCESS | 1983 | 12:49:52 INFO - PROCESS | 1983 | [#4] audio-oscillator Cycles:10 Average:75.20 Median:76.00 stddev:9.07 (11.9%) stddev-sans-first:7.88 12:49:52 INFO - PROCESS | 1983 | Values: 90.0 68.0 85.0 69.0 68.0 69.0 83.0 67.0 69.0 84.0 12:49:52 INFO - PROCESS | 1983 | 12:49:52 INFO - PROCESS | 1983 | [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:110.50 stddev:19.14 (17.3%) stddev-sans-first:20.04 12:49:52 INFO - PROCESS | 1983 | Values: 107.0 110.0 108.0 110.0 108.0 110.0 111.0 170.0 112.0 111.0 12:49:52 INFO - PROCESS | 1983 | 12:49:52 INFO - PROCESS | 1983 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 12:49:52 INFO - PROCESS | 1983 | Values: 94.0 94.0 95.0 95.0 93.0 95.0 94.0 95.0 94.0 94.0 12:49:52 INFO - PROCESS | 1983 | 12:49:52 INFO - PROCESS | 1983 | [#7] imaging-desaturate Cycles:10 Average:86.60 Median:87.00 stddev:1.84 (2.1%) stddev-sans-first:1.94 12:49:52 INFO - PROCESS | 1983 | Values: 87.0 86.0 84.0 87.0 89.0 87.0 88.0 87.0 88.0 83.0 12:49:52 INFO - PROCESS | 1983 | 12:49:52 INFO - PROCESS | 1983 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:1.08 (2.0%) stddev-sans-first:1.00 12:49:52 INFO - PROCESS | 1983 | Values: 56.0 56.0 53.0 53.0 55.0 54.0 54.0 54.0 55.0 55.0 12:49:52 INFO - PROCESS | 1983 | 12:49:52 INFO - PROCESS | 1983 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:71.00 stddev:3.53 (5.0%) stddev-sans-first:3.50 12:49:52 INFO - PROCESS | 1983 | Values: 67.0 74.0 64.0 69.0 75.0 75.0 70.0 72.0 70.0 70.0 12:49:52 INFO - PROCESS | 1983 | 12:49:52 INFO - PROCESS | 1983 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:87.00 stddev:6.61 (7.6%) stddev-sans-first:6.86 12:49:52 INFO - PROCESS | 1983 | Values: 86.0 87.0 87.0 99.0 105.0 86.0 86.0 89.0 86.0 88.0 12:49:52 INFO - PROCESS | 1983 | 12:49:52 INFO - PROCESS | 1983 | [#11] stanford-crypto-ccm Cycles:10 Average:146.20 Median:141.50 stddev:14.70 (10.4%) stddev-sans-first:15.47 12:49:52 INFO - PROCESS | 1983 | Values: 141.0 139.0 138.0 142.0 143.0 140.0 150.0 141.0 187.0 141.0 12:49:52 INFO - PROCESS | 1983 | 12:49:52 INFO - PROCESS | 1983 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.80 Median:173.50 stddev:18.48 (10.7%) stddev-sans-first:19.01 12:49:52 INFO - PROCESS | 1983 | Values: 167.0 175.0 171.0 166.0 172.0 169.0 167.0 192.0 223.0 196.0 12:49:52 INFO - PROCESS | 1983 | 12:49:52 INFO - PROCESS | 1983 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:1.14 (1.7%) stddev-sans-first:1.12 12:49:52 INFO - PROCESS | 1983 | Values: 65.0 67.0 67.0 67.0 67.0 67.0 66.0 67.0 65.0 64.0 12:49:52 INFO - PROCESS | 1983 | -------- Summary: end -------- 12:49:52 INFO - PROCESS | 1983 | 12:49:52 INFO - TEST-INFO | 1983: exit 0 12:49:53 INFO - TEST-OK | kraken | took 59904ms 12:49:53 INFO - SUITE-END | took 1179s 12:49:53 INFO - Completed test suite (00:19:39) 12:49:53 INFO - javascript benchmark 12:49:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3276.164578032601, 3278.2460034192136, 3290.457074582693, 3290.703836654702, 3352.0614228016148, 5452.372977107634, 5500.3949565547755, 5551.611387202897, 5621.2692349994495, 5657.745401456928, 5543.861403464915, 5565.721713914299, 5657.0665840136435, 5658.830235092943, 5700.515456186229, 4984.576311013569, 5013.949860501403, 5024.447310795809, 5026.447090820006, 5147.279380886679, 5097.49025097491, 5140.383154021504, 5169.793208271664, 5176.974115129419, 5182.0, 5034.09386310464, 5117.616178786606, 5119.8208062717995, 5143.742812859361, 5202.03762303975, 5062.746862656889, 5116.437191908887, 5136.229565565195, 5146.536811686966, 5149.639525233235, 5054.671446356012, 5072.923906141411, 5088.847334579968, 5098.796048158069, 5117.590592752608, 5530.142827861688, 5583.776648934037, 5590.0, 5614.522765564931, 5636.633618814764, 6121.755129794803, 6128.509719222496, 6131.0, 6135.263768347782, 6144.139820425144, 6127.754889804402, 6164.6917654117115, 6168.629882207082, 6179.6292222466345, 6192.133101365767, 5503.229547863302, 5597.916031259534, 5612.242347283105, 5645.943540564624, 5650.773969041193, 6139.216166136444, 6153.107799369066, 6190.969045154746, 6210.689465526705, 6215.471684906744, 6041.577089603774, 6043.244594425697, 6066.787662431793, 6100.694965251809, 6107.969460152671, 6161.168242287324, 6163.691815409212, 6170.845728856814, 6171.938280617136, 6193.721282542297, 5931.555133365015, 5975.880482390327, 6019.187409699722, 6104.786332478342, 6124.479419249414, 5102.897942041139, 5939.554533409925, 6135.306216178427, 6194.876102477925, 6221.813345599639, 4855.1260773061185, 4887.29134275528, 4890.608751299887, 4907.631927605444, 4929.359183306147, 4261.446012018479, 4367.388565600819, 4368.039031413147, 4390.692651514363, 4424.11517696462, 5492.725363731797, 5561.860953476195, 5572.860678482989, 5576.9163462547285, 5582.832515024475, 6189.0, 6196.628202307876, 6218.906716399258, 6228.688565571703, 6230.750769969241, 4758.881662809306, 5456.208849716769, 5657.12314591239, 5668.093105103246, 5686.3744988051285, 5185.818496352685, 5263.578913686896, 5319.973400132974, 5332.733363331818, 5336.546393556591, 6253.37466253371, 6287.559870808999, 6292.559520833589, 6321.841953951188, 6336.746530138743, 6223.439890409885, 6226.5641405101205, 6226.844328891814, 6232.376762323732, 6237.594556353823, 6195.473384762166, 6280.057991301342, 6305.054241863573, 6305.621662700252, 6308.936910630835, 5749.1663708762835, 5754.971225144015, 5767.279090113736, 5883.029300165596, 5935.851603709942, 5897.557683173865, 5902.557308201988, 5911.408859114226, 5912.349641539513, 5948.405159484017, 5695.117256825199, 5701.087825947829, 5704.286964129484, 5706.400827913009, 5716.685582293014, 5174.534291913746, 5681.829545113653, 5799.130130480462, 5884.264466941632, 5934.169216309807, 5700.914486282626, 5845.678487683048, 5850.23946886902, 5861.824145275478, 5898.705064746659, 5944.732487038007, 6010.639361638316, 6014.578979471395, 6032.095185722177, 6036.245469316335, 5688.715564221689, 5711.257536520226, 5793.971030144822, 5815.621984570989, 5825.94174058271], "value": 5571.222793428458, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [446.8391379103524, 458.96557758168143, 465.8609699285247, 470.6117453101192, 482.49338194895364, 30409.84795076027, 38473.0, 39556.60443395562, 39790.0, 41816.79091604545, 39941.80029099857, 40857.0, 41288.58711412885, 41312.96717582062, 41397.793011034904, 8413.621387037598, 9298.070192980715, 9509.667161649344, 9510.33427660064, 9515.476648784314, 8461.915380846174, 11038.227324087316, 11301.0, 11330.0, 11469.0, 11281.605143819968, 11304.265222760494, 11356.772864542705, 11358.03456706181, 11393.54425822966, 11256.718582035473, 11332.546698132064, 11333.716657083638, 11368.26106303096, 11369.147313951487, 11171.273867198688, 11262.324260544394, 11271.774564508745, 11276.267042642285, 11285.71785705364, 39019.41470877939, 39323.8033809832, 39354.40968385476, 39363.606363936284, 39373.0, 3312.867485300585, 3341.532185494033, 3414.6585341465902, 3449.292894956528, 3505.4741788731894, 27269.590956135675, 27864.0, 28067.719322806715, 28368.574471382944, 28795.28011799722, 3147.339058797655, 3152.0543836849083, 3169.0968074098773, 3184.442722523549, 3255.9837200813845, 494038.5298073523, 494735.9999999964, 495356.0, 495980.0, 496431.0, 42853.1429371417, 53108.0, 53139.734301329016, 53153.46846531562, 53161.0, 53369.733151333996, 53434.73282633562, 53503.19745203825, 53540.46459535355, 53669.0, 14643.34104965279, 15094.54716358511, 15139.167345796088, 15159.772603410958, 15160.696786064216, 10666.41334726582, 10930.508127134299, 10970.616028439126, 11781.116416268815, 11894.82157767634, 16475.58811029734, 16732.498025059267, 16864.49406517782, 17048.403305884236, 17111.74332385015, 6443.548951573439, 7168.53404528704, 7264.709411623476, 7298.744543940937, 7360.96319518399, 909.6497848328441, 912.8356895758694, 913.7624217703445, 963.8457846744627, 1030.1810061001522, 27475.900963961216, 27585.310367240978, 29066.205804276444, 29670.961516347255, 30152.677478197682, 1044.5978298355187, 1063.9254353103422, 1066.4454483668603, 1070.4487189097622, 1115.1079136690614, 13499.527516536875, 13952.441902323997, 13993.30033498321, 14418.279086045655, 14818.88858335629, 631971.0, 632523.0, 634926.0, 635942.0, 636853.0, 48329.75835120802, 48872.26691599558, 48898.75550622295, 48924.75537622289, 49137.0172596546, 1232.2852745407642, 1278.833751612303, 1280.3790161771346, 1364.938577764003, 1394.6513371657086, 24314.0, 26445.0, 27793.44413111686, 28716.856415717786, 29072.12783616495, 38687.41968870413, 39208.0197995041, 48007.5199248017, 48159.0, 48196.5180348192, 594089.0, 597959.0, 599600.0, 601287.0, 604460.0, 23793.0, 24266.87866560656, 24657.876710616332, 25363.112291069723, 25421.0, 41055.0, 41586.792066039474, 42247.0, 42248.78875605725, 42527.787361063, 34599.96332439568, 34673.65326346805, 34999.4750078744, 35756.64243357533, 36088.81955590205, 34792.652073478945, 34813.303733925684, 35329.0, 35577.82211088928, 35581.46627800533, 34465.0, 34497.482537761454, 34937.47593786146, 35042.0, 35158.82420587983, 29334.853325733235, 30191.698083019768, 30633.0, 30748.692513074584, 30816.075517734505, 20431.0, 23504.059837606303, 23637.0, 23814.761852381947, 23958.88020559886], "value": 19097.32415092883, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.8524078923695, 357.14107571291055, 375.4255988337841, 380.5433479824211, 403.7029303264425, 13262.20426774393, 13444.932775336134, 15675.60810979726, 19980.100895459702, 20477.0, 19297.324593639227, 19899.204031838744, 20671.689924651142, 20894.89552552239, 21193.788062119373, 5801.187833703285, 6111.663858487781, 6142.6314421134875, 6144.047672610753, 6155.753769849201, 5618.381977982419, 5927.0, 5986.982213023796, 5997.520198384141, 5998.460138587527, 5602.7758889644565, 5821.126830975367, 5938.020226662596, 5939.406059394069, 5975.492083172936, 5892.852678683024, 5960.433758792908, 5979.0, 5985.820425387245, 5997.070454079625, 5017.222330538772, 5147.897042059175, 5149.0731668299695, 5213.713245771481, 5232.790688372498, 25077.0, 25179.118730844333, 25488.617670734955, 25577.360565985815, 25743.485130297475, 2098.3914664747203, 2340.2979106268053, 2363.1374548289923, 3056.3581647853975, 3145.811251324928, 14388.496402625962, 15127.243637818065, 15890.52328430149, 15998.76001859973, 16015.679686406207, 1768.619746754454, 1801.9369322073665, 1803.071418219618, 1860.7674040744907, 1862.6833438315518, 117541.0, 119158.40420797841, 121515.06364427156, 121950.0, 122568.0, 8580.71289306609, 10409.271351005356, 10450.059494645518, 10943.179261555415, 10978.341299522055, 13791.586252412444, 13802.447902084004, 13811.378487968066, 13812.792808107686, 13818.654533636538, 8124.63439145228, 8451.0, 8494.320454363637, 8589.269912057545, 8647.827043459221, 8517.957410213034, 8526.531040792815, 8530.616122274512, 8702.390832641655, 8721.30229581632, 5479.424660410599, 6521.47828173745, 6620.003539057423, 6620.8344791380605, 6749.426298764562, 1672.406295764986, 1846.3630047633544, 1852.8795628284117, 1853.4439668099517, 1854.6661600911696, 846.1327139681875, 947.3321308477507, 978.8629591857145, 992.5533509920565, 1089.0, 21780.960504652052, 22127.0, 22133.77866221317, 22181.11275548992, 22210.555788884132, 940.2806852757645, 946.7917058247175, 968.912797848183, 1011.9392836429838, 1031.7523794289316, 10302.484875756332, 11615.070794336432, 11812.940935295268, 11813.0, 11845.993090587397, 549282.0, 549809.0, 559404.0, 563043.9239019058, 571229.0, 70635.6468217666, 73987.0, 107426.46286768516, 116318.85767996158, 120633.79366206401, 906.3474298505066, 933.6032186320787, 979.3193730357333, 1042.4162469017224, 1043.8486419469134, 16015.599610009844, 18042.63914721672, 19921.402357929284, 20309.78141311526, 20490.97545122708, 48731.51268487411, 51836.96326073533, 53344.0, 53613.0, 54376.45623543714, 59042.0, 67806.0, 73354.0, 74412.0, 75268.0, 7724.9227507726455, 7781.455298129076, 7881.881771773543, 7942.960285198537, 7996.280334769898, 12395.380230988234, 12550.121491495507, 12604.054695897661, 12968.935155324163, 13014.284214368301, 10958.28771129874, 11160.944195278971, 11200.38397888124, 11202.327860328407, 11368.658940231806, 9885.0, 10637.574497020032, 10995.907366243518, 11071.5571377144, 11174.888251117385, 11069.391183484986, 11181.888181118411, 11205.775884482102, 11217.158713096387, 11466.2546934449, 7739.148693643808, 7806.219378062148, 7875.488093273919, 7898.249666281694, 7954.602269886598, 10851.077658399125, 10891.782164356828, 11042.779144416905, 11057.170712196777, 11099.001089901625], "value": 9596.175676620878, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1487.0631502153644, 1526.2979029646363, 1719.4068046523944, 1861.5997560524484, 1909.703995880639, 8171.142030086837, 8673.522956237404, 8680.262177714894, 8683.73948781536, 8687.956560217199, 6431.1317972073875, 7830.334421574173, 7833.882491762613, 7923.168067352932, 7934.96032519838, 2039.1027947703037, 2078.3972647932083, 2252.6395776675736, 2328.499372634883, 2336.2056900653774, 2339.6607491913746, 2341.555104530134, 2344.074090734159, 2346.190564255338, 2347.471818840764, 2274.317704688595, 2279.2022792022744, 2287.4853158039473, 2325.6046472099783, 2337.345543247893, 2283.132409684326, 2305.0779688124717, 2307.192482631074, 2311.6070268054305, 2314.4445333120016, 2126.2345555600127, 2189.9562008759895, 2310.491691827812, 2312.606856834342, 2325.0, 8147.348212143014, 8280.0, 8481.830363392759, 8637.65449382024, 8653.567321633893, 5146.356705411824, 5300.0459917214885, 5314.681119132864, 5318.069337865897, 5319.28189694394, 2939.206414268157, 3421.0, 3425.1779572902324, 3510.4558793387064, 3524.1365865362895, 1004.3120462483149, 1022.2792930983638, 1038.382162613244, 1039.9116075133622, 1041.8958104189596, 10980.780384392347, 11124.944375278072, 11140.220184587082, 11142.442877856156, 11160.497777599947, 4400.141972315368, 4606.677532572755, 4669.322948172496, 4697.553732395417, 4710.128626204163, 9672.56473458696, 9679.903200968041, 9684.273679474067, 9690.51547422626, 9723.611055557698, 5233.345831771028, 5233.973830130825, 5234.031704134671, 5242.554382877422, 5262.894742105136, 4140.15126898985, 4385.728138839764, 4792.856214313576, 4809.398825146856, 4884.3161957326, 3188.6651901550467, 3549.396602577516, 3595.173110184672, 3624.075860655516, 3854.6338097880657, 1062.6811956413046, 1260.0, 1260.7541529401678, 1282.6344491819973, 1284.3064745037575, 807.4630370803468, 905.7463910105181, 910.2808781062886, 913.8126684029758, 967.1247520993512, 4611.700239484423, 5514.972425137848, 5746.569007324468, 5761.3950535194035, 5931.940680593225, 960.1646567486332, 1005.1355833982769, 1037.092544023979, 1054.298891237334, 1089.199438412766, 3628.0, 3708.35103856824, 3721.7580857244193, 3749.2630379822335, 3868.3617203161725, 10045.849312260321, 10210.693679189637, 10291.53688084038, 10337.173026157889, 10395.220358473145, 10257.33327333721, 10267.589296428208, 10276.845847312296, 10282.07461328484, 10285.794284114276, 7791.649375778104, 7904.525728456311, 8007.639656215484, 8090.312323452455, 8147.307478864244, 5718.685472299064, 5790.449907258803, 5846.94153058464, 5888.205092312483, 5999.760009599741, 9267.351285410226, 9676.419414835133, 9686.70939871805, 9688.176504997155, 9699.369540979813, 9099.909000909905, 9536.380135291183, 9544.809103817746, 9657.855132172883, 9735.269854761063, 7161.319674630901, 7347.375473084848, 7358.852822943404, 7364.668589913574, 7365.300296471826, 7220.3140701633265, 7467.290607392289, 7473.588952607659, 7860.6069696513805, 7922.168172342052, 7020.789376318514, 7049.0, 7240.674169662483, 7274.927250727425, 7339.376153027052, 6906.412954898688, 7097.680604372712, 7155.3202445767565, 7169.247229040876, 7322.048133742793, 6420.390062944013, 6727.629980350932, 6804.659767011729, 6824.385805277549, 6833.3166683331265, 4818.301346304836, 4835.95164048355, 4947.233178857283, 4980.576650984707, 5132.153194722829, 4359.564043595615, 4897.3878265216845, 4957.206846904623, 5020.221865610836, 5036.118679231193], "value": 4450.021505237755, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.0714698900923, 356.2963147783129, 361.88057940879514, 374.40656559353425, 376.17805095865555, 4486.528914463983, 4510.932336014954, 5022.924656130161, 5170.302009228753, 5222.686638801674, 4151.750894946305, 4605.355250264957, 5071.366079240095, 5076.2385642153695, 5120.871978200546, 4028.3685107531423, 4077.9592204077876, 4082.3672330788777, 4105.387259211904, 4131.814068366915, 3303.4053870303337, 3749.144173634041, 3949.743266687656, 4074.7962601869935, 4079.9592004079877, 3645.3182285891307, 4030.496187976503, 4043.615856493643, 4079.224947260026, 4113.4035564843225, 3373.3927892979254, 4061.4720086388875, 4065.288574499451, 4072.6741860651077, 4089.9591004090025, 3588.026585378058, 3593.568771747381, 3595.7842529448317, 3609.9097522561883, 3618.2039951210954, 3965.4844870166694, 4805.630395337347, 4926.901461970776, 4963.60291176705, 5003.124453220672, 4138.703019823996, 4647.838040489877, 4667.13657973276, 4698.130845793539, 4698.929516057262, 4762.38089048425, 5379.444763737232, 5434.402215756264, 5473.877855039707, 5486.451354864522, 3860.1269338734405, 3861.6331448512346, 3945.230680017398, 3962.346212874872, 3970.7419017763755, 5626.521745651625, 5629.8592535186945, 5638.04153293941, 5669.574781891375, 5740.799072032459, 4050.0, 4061.3095773717946, 4065.573114822901, 4067.654249388776, 4069.4709687740997, 3444.7436928811667, 3843.577206507282, 4030.5767894371256, 4098.6516146127915, 4107.9178416432105, 4541.296099104644, 4568.132054909556, 4616.699914505613, 4643.2587779582655, 4649.465311489154, 4739.265413860857, 5269.075663006991, 5364.785408583691, 5465.535429488458, 5472.890542189134, 1257.8176164456102, 1279.2218815845981, 1283.7547578848503, 1324.582756431721, 1339.7119619281707, 821.3634433314229, 876.8772371867943, 918.8529835226332, 943.532806485921, 948.7865230323122, 4587.747673877902, 4604.8388306409115, 4776.737279449663, 4779.617630589544, 4821.807127714922, 4897.8285759998225, 5203.297554830126, 5226.503482169188, 5237.947620523746, 5247.790088396498, 4129.772862492532, 4148.979255103705, 4362.345648152803, 4742.5020372861045, 4794.736289504111, 2644.6297518347446, 2694.4133631713385, 2729.7679697225562, 2732.9912514301973, 2777.680566734811, 5078.603384069411, 5147.433782283946, 5443.673379597237, 5446.7276636168035, 5543.6183927804, 4867.464578896319, 4890.926636100461, 5340.572754179656, 5346.812861549827, 5378.381486129067, 4830.66185367028, 4904.583110435581, 5080.669756465818, 5437.519987208111, 5457.645253058538, 4747.501512341154, 4827.961988172559, 5100.336956195671, 5206.687598744087, 5254.97372513135, 5486.149646804752, 5525.613207075467, 5537.640053396677, 5579.0, 5625.634333768292, 4789.640776941674, 5628.0, 5731.3408957968695, 5775.66824881339, 5800.738966746591, 3640.8361623727524, 3734.3382194922997, 3744.2885851688093, 3773.2830762155104, 3788.4885540451687, 4916.434610019894, 5536.754230298151, 5543.473370029841, 5568.721563921868, 5572.9968605651375, 4660.976695116503, 4769.809207631794, 5361.088614935392, 5389.622726409114, 5488.533474654699, 4366.628836548802, 4385.627221686193, 5098.592112630907, 5411.132099987013, 5510.539706977574, 4655.648897306838, 4746.406699162605, 5108.770105345343, 5315.521603055744, 5361.088614935548, 5174.844754657366, 5365.3293338332705, 5430.565554755531, 5438.809641662523, 5468.617196796186, 4526.592606665416, 5352.839414817562, 5355.277037599874, 5368.194770784414, 5426.782928682808], "value": 3982.7170479967454, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.402709777982, 749.542778904868, 794.079596318088, 809.9589035630214, 822.4695071678764, 12695.682607934807, 14506.637334066654, 15436.459723909666, 15471.226438678063, 15499.767503487443, 11440.370779607118, 14140.50508232212, 14154.433822647108, 14157.150570965723, 14191.92904035481, 695.839956809934, 707.8230442389403, 859.8495263328892, 869.3523325122777, 887.786931136529, 711.2247650061432, 867.557545651719, 876.6887754847033, 882.9690960816373, 883.2536506651869, 924.6209054287743, 926.6200857648365, 927.5547737086202, 928.3455164109287, 928.7863791327999, 726.7383741852929, 923.6490133749165, 924.4037595750771, 925.847235206197, 927.1609193679731, 547.9971651877095, 670.0518765946181, 677.4614181725491, 679.3817625960402, 680.73451353972, 14529.346179421951, 14562.126272423688, 14563.854361456462, 14565.0, 14581.927090364481, 13382.0, 13423.932880335537, 13431.597052088453, 13437.193768373929, 13481.460741570325, 11324.830127548094, 11568.710782230428, 12264.448099835528, 12567.120301578892, 12757.744845103047, 4282.207791558571, 4516.4806047304655, 4519.435070616173, 4551.726896386194, 4568.862934111982, 100463.49768251185, 100939.0, 104947.0, 105715.0, 105841.0, 10660.46697665129, 10737.51681174349, 10748.462576871125, 10751.118554252975, 10986.419937322851, 19961.401157965283, 20545.897270513553, 21036.158553657682, 21104.78895211028, 21497.92510374475, 7598.734044308423, 7897.685024537794, 7924.762257132295, 8030.638621262057, 8066.6773329067355, 3995.615536080087, 4043.353063509824, 4128.2156390285745, 4164.292070348048, 4182.519010313853, 3490.7032902203596, 3570.2145527983803, 3572.1783989682517, 3579.749417540799, 3618.927621447609, 654.456800855289, 663.3432901427649, 666.5034549260831, 670.122139996606, 675.2066322071645, 584.33677775724, 635.8219698484431, 670.6177478837113, 676.7022510095542, 678.7827895073627, 8765.342599305077, 9178.2770533161, 9317.72046838596, 9336.692862999185, 9444.055594440639, 627.3130921640796, 629.2543336146681, 639.2520750721667, 640.3020707428832, 673.8113328268092, 4360.411344468456, 4369.584889435499, 4534.274516077412, 4567.15262546766, 4713.95286047142, 87677.56161219154, 108344.45827770968, 108518.45740771246, 108795.0, 109708.0, 91059.0, 92307.53846230726, 93870.0, 95100.04899950912, 96125.51937240409, 60928.086078707965, 81117.0, 81595.0, 81644.77532837012, 84166.0, 7229.783106506813, 8540.658373664985, 8554.700585479479, 8853.0, 8911.0, 51891.740541297055, 53378.93242135213, 53655.19517207323, 54452.72773636106, 55020.44979550153, 57331.706731730264, 69793.0, 72279.27720722725, 72535.39381854437, 73637.0, 11577.131715121232, 11762.76474470523, 11870.584529541424, 11927.46326415296, 12141.15011949155, 12135.514579416724, 12313.13808033429, 12439.75120497567, 12906.032047596656, 12918.612441626767, 10454.42500662471, 11725.530978760755, 12179.756404871676, 12406.441710123247, 12495.812562811747, 11343.602973895873, 11849.783053214442, 12100.85041921016, 12204.145709800583, 12408.62774116778, 11857.52569897229, 12088.637340879788, 12182.573609923611, 12272.570460033856, 12428.378581070729, 9082.228010619172, 9877.308588398742, 10093.798124037625, 10207.336523125972, 10514.26400151982, 7213.891791623025, 8997.865032024394, 9116.270698343984, 10211.211688105554, 10337.74155646115], "value": 7273.929745278553, "unit": "score"}], "name": "dromaeo_css", "value": 7132.303346483632, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 168.0, 169.0, 113.0, 113.0, 117.0, 163.0, 169.0, 169.0, 113.0], "value": 145.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 109.0, 111.0, 145.0, 110.0, 107.0, 105.0, 122.0, 124.0, 112.0], "value": 118.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 183.0, 183.0, 184.0, 181.0, 184.0, 184.0, 183.0, 182.0, 183.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 58.0, 89.0, 60.0, 58.0, 59.0, 57.0, 72.0, 58.0], "value": 64.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 68.0, 85.0, 69.0, 68.0, 69.0, 83.0, 67.0, 69.0, 84.0], "value": 75.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 108.0, 110.0, 108.0, 110.0, 111.0, 170.0, 112.0, 111.0], "value": 115.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 93.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 84.0, 87.0, 89.0, 87.0, 88.0, 87.0, 88.0, 83.0], "value": 86.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 53.0, 53.0, 55.0, 54.0, 54.0, 54.0, 55.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 74.0, 64.0, 69.0, 75.0, 75.0, 70.0, 72.0, 70.0, 70.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 87.0, 99.0, 105.0, 86.0, 86.0, 89.0, 86.0, 88.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 139.0, 138.0, 142.0, 143.0, 140.0, 150.0, 141.0, 187.0, 141.0], "value": 146.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 175.0, 171.0, 166.0, 172.0, 169.0, 167.0, 192.0, 223.0, 196.0], "value": 179.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 65.0, 64.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1491.2, "alertThreshold": 2.0}]} 12:49:53 INFO - Return code: 0 12:49:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:49:53 INFO - # TBPL SUCCESS # 12:49:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:49:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:49:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:49:53 INFO - 2016-12-19 12:49:53.440 screenresolution[1987:14139] starting screenresolution argv=screenresolution get 12:49:53 INFO - 2016-12-19 12:49:53.443 screenresolution[1987:14139] Display 0: 1600x1200x32@60 12:49:53 INFO - 2016-12-19 12:49:53.449 screenresolution[1988:14142] starting screenresolution argv=screenresolution list 12:49:53 INFO - Available Modes on Display 0 12:49:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:49:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:49:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:49:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:49:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:49:53 INFO - Intel Iris: 12:49:53 INFO - Chipset Model: Intel Iris 12:49:53 INFO - Type: GPU 12:49:53 INFO - Bus: Built-In 12:49:53 INFO - VRAM (Dynamic, Max): 1536 MB 12:49:53 INFO - Vendor: Intel (0x8086) 12:49:53 INFO - Device ID: 0x0a2e 12:49:53 INFO - Revision ID: 0x0009 12:49:53 INFO - Displays: 12:49:53 INFO - Display: 12:49:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:49:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:49:53 INFO - Display Serial Number: 1600x1200 60 12:49:53 INFO - Main Display: Yes 12:49:53 INFO - Mirror: Off 12:49:53 INFO - Online: Yes 12:49:53 INFO - Rotation: Supported 12:49:53 INFO - Return code: 0 12:49:53 INFO - Running post-action listener: _resource_record_post_action 12:49:53 INFO - [mozharness: 2016-12-19 20:49:53.685511Z] Finished run-tests step (success) 12:49:53 INFO - Running post-run listener: _resource_record_post_run 12:49:53 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 245760; Write bytes: 550760960; Read time: 3; Write time: 2032 12:49:53 INFO - TinderboxPrint: CPU usage
53.8% 12:49:53 INFO - TinderboxPrint: I/O read bytes / time
245,760 / 3 12:49:53 INFO - TinderboxPrint: I/O write bytes / time
550,760,960 / 2,032 12:49:53 INFO - TinderboxPrint: CPU idle
2,222.3 (46.2%) 12:49:53 INFO - TinderboxPrint: CPU system
963.6 (20.1%) 12:49:53 INFO - TinderboxPrint: CPU user
1,619.8 (33.7%) 12:49:53 INFO - TinderboxPrint: Swap in / out
249,339,904 / 0 12:49:53 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 228891136; Write bytes: 223131136; Read time: 16464; Write time: 467 12:49:53 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 217088; Write bytes: 298425344; Read time: 2; Write time: 1505 12:49:54 INFO - Running post-run listener: _upload_blobber_files 12:49:54 INFO - Blob upload gear active. 12:49:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:49:54 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 12:49:54 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:49:54 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:49:54 INFO - (blobuploader) - INFO - Open directory for files ... 12:49:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:49:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:49:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:49:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:49:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:49:55 INFO - (blobuploader) - INFO - Done attempting. 12:49:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:49:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:49:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:49:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:49:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:49:56 INFO - (blobuploader) - INFO - Done attempting. 12:49:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:49:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:49:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:49:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:49:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:49:57 INFO - (blobuploader) - INFO - Done attempting. 12:49:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:49:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:49:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:50:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:50:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:50:00 INFO - (blobuploader) - INFO - Done attempting. 12:50:00 INFO - (blobuploader) - INFO - Iteration through files over. 12:50:00 INFO - Return code: 0 12:50:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:50:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:50:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b09b2dced54921a2ebd6e542255afadb7408087f595024ac0262614781388ef577526ea7ee35ba838173147ef2a9f7bff09c1e688aabbe7fb7751585fb2abd43", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6b305c1bae6dfa12d1dd38593020f03004656087a8261a697f8e60d3198c2a16a7ee8c07e479b0106807cb58fbabdc00cf9e3239337a90f6fcdf35bee88c65aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/229ff1f57a243de537269a19e7f69dcd897fe03816eb2c704d80aeeb323349aed677630017444b90d9fca3611da0d20c86effa421486f0bda1cd38f16b4be25a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9dffe28b46af4e8c74cb8a2767f3f8487fb4bd8e3795f0f2ca26765bfa796651413a2cc18b51ab28f84830633ee9054804fc6a6b13e603184cef2f141ddee27f"} 12:50:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:50:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:50:00 INFO - Contents: 12:50:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b09b2dced54921a2ebd6e542255afadb7408087f595024ac0262614781388ef577526ea7ee35ba838173147ef2a9f7bff09c1e688aabbe7fb7751585fb2abd43", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6b305c1bae6dfa12d1dd38593020f03004656087a8261a697f8e60d3198c2a16a7ee8c07e479b0106807cb58fbabdc00cf9e3239337a90f6fcdf35bee88c65aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/229ff1f57a243de537269a19e7f69dcd897fe03816eb2c704d80aeeb323349aed677630017444b90d9fca3611da0d20c86effa421486f0bda1cd38f16b4be25a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9dffe28b46af4e8c74cb8a2767f3f8487fb4bd8e3795f0f2ca26765bfa796651413a2cc18b51ab28f84830633ee9054804fc6a6b13e603184cef2f141ddee27f"} 12:50:00 INFO - Running post-run listener: copy_logs_to_upload_dir 12:50:00 INFO - Copying logs to upload dir... 12:50:00 INFO - mkdir: /builds/slave/test/build/upload/logs 12:50:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.728200 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-12-19 12:50:00.689951) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 12:50:00.693400) ========= 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.kPswtPMb4C/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.t9izyTOMeg/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b09b2dced54921a2ebd6e542255afadb7408087f595024ac0262614781388ef577526ea7ee35ba838173147ef2a9f7bff09c1e688aabbe7fb7751585fb2abd43", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6b305c1bae6dfa12d1dd38593020f03004656087a8261a697f8e60d3198c2a16a7ee8c07e479b0106807cb58fbabdc00cf9e3239337a90f6fcdf35bee88c65aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/229ff1f57a243de537269a19e7f69dcd897fe03816eb2c704d80aeeb323349aed677630017444b90d9fca3611da0d20c86effa421486f0bda1cd38f16b4be25a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9dffe28b46af4e8c74cb8a2767f3f8487fb4bd8e3795f0f2ca26765bfa796651413a2cc18b51ab28f84830633ee9054804fc6a6b13e603184cef2f141ddee27f"} build_url:https://queue.taskcluster.net/v1/task/LhLT10P_REK5EIzBRzXAgA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011701 build_url: 'https://queue.taskcluster.net/v1/task/LhLT10P_REK5EIzBRzXAgA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b09b2dced54921a2ebd6e542255afadb7408087f595024ac0262614781388ef577526ea7ee35ba838173147ef2a9f7bff09c1e688aabbe7fb7751585fb2abd43", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6b305c1bae6dfa12d1dd38593020f03004656087a8261a697f8e60d3198c2a16a7ee8c07e479b0106807cb58fbabdc00cf9e3239337a90f6fcdf35bee88c65aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/229ff1f57a243de537269a19e7f69dcd897fe03816eb2c704d80aeeb323349aed677630017444b90d9fca3611da0d20c86effa421486f0bda1cd38f16b4be25a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9dffe28b46af4e8c74cb8a2767f3f8487fb4bd8e3795f0f2ca26765bfa796651413a2cc18b51ab28f84830633ee9054804fc6a6b13e603184cef2f141ddee27f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 12:50:00.729965) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 12:50:00.730348) ========= 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.kPswtPMb4C/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.t9izyTOMeg/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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.005282 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 12:50:00.780265) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 12:50:00.780732) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 12:50:00.781101) ========= ========= Total master_lag: 0.19 =========