builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0038 starttime: 1484668312.54 results: success (0) buildid: 20170117064027 builduid: 34b3b6bdad2d42a79d940cc5532111a6 revision: c52fa5ad5b28d10afb19beb3d2d9e7769d3b74d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 07:51:52.538368) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 07:51:52.544744) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 07:51:52.545022) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 07:51:52.704774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 07:51:52.705065) ========= 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.Jzh1m6M4R6/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.PJRz6Ug4EV/Listeners TMPDIR=/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 --2017-01-17 07:51:52-- 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% 13.0M=0.001s 2017-01-17 07:51:53 (13.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.465402 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 07:51:53.197917) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 07:51:53.198245) ========= 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.Jzh1m6M4R6/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.PJRz6Ug4EV/Listeners TMPDIR=/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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.019643 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 07:51:53.259901) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 07:51:53.260246) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev c52fa5ad5b28d10afb19beb3d2d9e7769d3b74d6 --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 c52fa5ad5b28d10afb19beb3d2d9e7769d3b74d6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Jzh1m6M4R6/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.PJRz6Ug4EV/Listeners TMPDIR=/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 2017-01-17 07:51:53,344 truncating revision to first 12 chars 2017-01-17 07:51:53,344 Setting DEBUG logging. 2017-01-17 07:51:53,345 attempt 1/10 2017-01-17 07:51:53,345 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/c52fa5ad5b28?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-17 07:51:53,962 unpacking tar archive at: graphics-c52fa5ad5b28/testing/mozharness/ program finished with exit code 0 elapsedTime=0.878333 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 07:51:54.166032) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 07:51:54.166343) ========= script_repo_revision: c52fa5ad5b28d10afb19beb3d2d9e7769d3b74d6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 07:51:54.166737) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 07:51:54.166996) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 07:51:54.192686) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-17 07:51:54.193050) ========= /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.Jzh1m6M4R6/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.PJRz6Ug4EV/Listeners TMPDIR=/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 07:51:54 INFO - MultiFileLogger online at 20170117 07:51:54 in /builds/slave/test 07:51:54 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 07:51:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:51:54 INFO - {'append_to_log': False, 07:51:54 INFO - 'base_work_dir': '/builds/slave/test', 07:51:54 INFO - 'blob_upload_branch': 'Graphics', 07:51:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:51:54 INFO - 'branch': 'Graphics', 07:51:54 INFO - 'buildbot_json_path': 'buildprops.json', 07:51:54 INFO - 'config_files': ('talos/mac_config.py',), 07:51:54 INFO - 'default_actions': ('clobber', 07:51:54 INFO - 'read-buildbot-config', 07:51:54 INFO - 'download-and-extract', 07:51:54 INFO - 'populate-webroot', 07:51:54 INFO - 'create-virtualenv', 07:51:54 INFO - 'install', 07:51:54 INFO - 'run-tests'), 07:51:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:51:54 INFO - 'download_minidump_stackwalk': True, 07:51:54 INFO - 'download_symbols': 'ondemand', 07:51:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:51:54 INFO - 'tooltool.py': '/tools/tooltool.py', 07:51:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:51:54 INFO - '/tools/misc-python/virtualenv.py')}, 07:51:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:51:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:51:54 INFO - 'installer_path': 'installer.exe', 07:51:54 INFO - 'log_level': 'info', 07:51:54 INFO - 'log_name': 'talos', 07:51:54 INFO - 'log_to_console': True, 07:51:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:51:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:51:54 INFO - 'opt_config_files': (), 07:51:54 INFO - 'pip_index': False, 07:51:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:51:54 INFO - 'cmd': ('bash', 07:51:54 INFO - '-c', 07:51:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:51:54 INFO - 'enabled': True, 07:51:54 INFO - 'halt_on_failure': False, 07:51:54 INFO - 'name': 'check_screen_resolution'},), 07:51:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:51:54 INFO - 'cmd': ('bash', 07:51:54 INFO - '-c', 07:51:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:51:54 INFO - 'enabled': True, 07:51:54 INFO - 'halt_on_failure': False, 07:51:54 INFO - 'name': 'check_screen_resolution'},), 07:51:54 INFO - 'run_cmd_checks_enabled': True, 07:51:54 INFO - 'sps_profile': False, 07:51:54 INFO - 'sps_profile_interval': 0, 07:51:54 INFO - 'suite': 'dromaeojs', 07:51:54 INFO - 'system_bits': '32', 07:51:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:51:54 INFO - 'title': 't-yosemite-r7-0038', 07:51:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:51:54 INFO - 'use_talos_json': True, 07:51:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:51:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:51:54 INFO - 'work_dir': 'build'} 07:51:54 INFO - [mozharness: 2017-01-17 15:51:54.389831Z] Running clobber step. 07:51:54 INFO - Running pre-action listener: _resource_record_pre_action 07:51:54 INFO - Running main action method: clobber 07:51:54 INFO - rmtree: /builds/slave/test/build 07:51:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:51:55 INFO - Running post-action listener: _resource_record_post_action 07:51:55 INFO - [mozharness: 2017-01-17 15:51:55.855288Z] Finished clobber step (success) 07:51:55 INFO - [mozharness: 2017-01-17 15:51:55.855454Z] Running read-buildbot-config step. 07:51:55 INFO - Running pre-action listener: _resource_record_pre_action 07:51:55 INFO - Running main action method: read_buildbot_config 07:51:55 INFO - Using buildbot properties: 07:51:55 INFO - { 07:51:55 INFO - "project": "", 07:51:55 INFO - "product": "firefox", 07:51:55 INFO - "script_repo_revision": "default", 07:51:55 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 07:51:55 INFO - "repository": "", 07:51:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 07:51:55 INFO - "buildid": "20170117064027", 07:51:55 INFO - "pgo_build": "False", 07:51:55 INFO - "basedir": "/builds/slave/test", 07:51:55 INFO - "buildnumber": 3, 07:51:55 INFO - "slavename": "t-yosemite-r7-0038", 07:51:55 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 07:51:55 INFO - "platform": "yosemite_r7", 07:51:55 INFO - "scheduler": "tests-graphics-macosx64-talos", 07:51:55 INFO - "branch": "graphics", 07:51:55 INFO - "repo_path": "projects/graphics", 07:51:55 INFO - "revision": "c52fa5ad5b28d10afb19beb3d2d9e7769d3b74d6", 07:51:55 INFO - "stage_platform": "macosx64", 07:51:55 INFO - "builduid": "34b3b6bdad2d42a79d940cc5532111a6", 07:51:55 INFO - "slavebuilddir": "test" 07:51:55 INFO - } 07:51:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/da6ZwgDjRv-bTs8GIH_wGQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 07:51:55 INFO - Running post-action listener: _resource_record_post_action 07:51:55 INFO - [mozharness: 2017-01-17 15:51:55.858960Z] Finished read-buildbot-config step (success) 07:51:55 INFO - [mozharness: 2017-01-17 15:51:55.859056Z] Running download-and-extract step. 07:51:55 INFO - Running pre-action listener: _resource_record_pre_action 07:51:55 INFO - Running main action method: download_and_extract 07:51:55 INFO - mkdir: /builds/slave/test/build/tests 07:51:55 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')]} 07:51:55 INFO - trying https://queue.taskcluster.net/v1/task/da6ZwgDjRv-bTs8GIH_wGQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 07:51:55 INFO - Downloading https://queue.taskcluster.net/v1/task/da6ZwgDjRv-bTs8GIH_wGQ/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 07:51:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/da6ZwgDjRv-bTs8GIH_wGQ/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 07:51:56 INFO - Downloaded 1199 bytes. 07:51:56 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:51:56 INFO - Using the following test package requirements: 07:51:56 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:51:56 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:51:56 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 07:51:56 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:51:56 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 07:51:56 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:51:56 INFO - u'jsshell-mac.zip'], 07:51:56 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:51:56 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 07:51:56 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:51:56 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:51:56 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 07:51:56 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:51:56 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 07:51:56 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:51:56 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 07:51:56 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:51:56 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 07:51:56 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:51:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/da6ZwgDjRv-bTs8GIH_wGQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:51:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/da6ZwgDjRv-bTs8GIH_wGQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:51:56 INFO - Fetch https://queue.taskcluster.net/v1/task/da6ZwgDjRv-bTs8GIH_wGQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:51:58 INFO - Expected file size: 16326421 07:51:58 INFO - Obtained file size: 16326421 07:52:05 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 07:52:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/da6ZwgDjRv-bTs8GIH_wGQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:52:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/da6ZwgDjRv-bTs8GIH_wGQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:52:05 INFO - Fetch https://queue.taskcluster.net/v1/task/da6ZwgDjRv-bTs8GIH_wGQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:52:06 INFO - Expected file size: 16326421 07:52:06 INFO - Obtained file size: 16326421 07:52:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/da6ZwgDjRv-bTs8GIH_wGQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 07:52:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/da6ZwgDjRv-bTs8GIH_wGQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:52:13 INFO - Fetch https://queue.taskcluster.net/v1/task/da6ZwgDjRv-bTs8GIH_wGQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 07:52:14 INFO - Expected file size: 14403463 07:52:14 INFO - Obtained file size: 14403463 07:52:14 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')]} 07:52:14 INFO - trying https://queue.taskcluster.net/v1/task/da6ZwgDjRv-bTs8GIH_wGQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:52:14 INFO - Downloading https://queue.taskcluster.net/v1/task/da6ZwgDjRv-bTs8GIH_wGQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 07:52:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/da6ZwgDjRv-bTs8GIH_wGQ/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 07:52:16 INFO - Downloaded 70308917 bytes. 07:52:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/da6ZwgDjRv-bTs8GIH_wGQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:52:16 INFO - mkdir: /builds/slave/test/properties 07:52:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:52:16 INFO - Writing to file /builds/slave/test/properties/build_url 07:52:16 INFO - Contents: 07:52:16 INFO - build_url:https://queue.taskcluster.net/v1/task/da6ZwgDjRv-bTs8GIH_wGQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:52:17 INFO - Running post-action listener: _resource_record_post_action 07:52:17 INFO - Running post-action listener: set_extra_try_arguments 07:52:17 INFO - [mozharness: 2017-01-17 15:52:17.575079Z] Finished download-and-extract step (success) 07:52:17 INFO - [mozharness: 2017-01-17 15:52:17.575182Z] Running populate-webroot step. 07:52:17 INFO - Running pre-action listener: _resource_record_pre_action 07:52:17 INFO - Running main action method: populate_webroot 07:52:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:52:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:52:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:52:17 INFO - '--tppagecycles', 07:52:17 INFO - '7'], 07:52:17 INFO - 'tests': ['tsvgm']}}, 07:52:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:52:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:52:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:52:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:52:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:52:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:52:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:52:17 INFO - 'talos_options': ['--disable-e10s'], 07:52:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:52:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:52:17 INFO - 'talos_options': ['--disable-e10s'], 07:52:17 INFO - 'tests': ['damp', 'tps']}, 07:52:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:52:17 INFO - 'tests': ['damp', 'tps']}, 07:52:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:52:17 INFO - 'tests': ['dromaeo_dom']}, 07:52:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:52:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:52:17 INFO - 'tests': ['basic_compositor_video']}, 07:52:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:52:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:52:17 INFO - 'tests': ['a11yr', 07:52:17 INFO - 'ts_paint', 07:52:17 INFO - 'tpaint', 07:52:17 INFO - 'sessionrestore', 07:52:17 INFO - 'sessionrestore_no_auto_restore', 07:52:17 INFO - 'tabpaint']}, 07:52:17 INFO - 'other-e10s': {'tests': ['a11yr', 07:52:17 INFO - 'ts_paint', 07:52:17 INFO - 'tpaint', 07:52:17 INFO - 'sessionrestore', 07:52:17 INFO - 'sessionrestore_no_auto_restore', 07:52:17 INFO - 'tabpaint']}, 07:52:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:52:17 INFO - 'ts_paint', 07:52:17 INFO - 'tpaint', 07:52:17 INFO - 'sessionrestore', 07:52:17 INFO - 'sessionrestore_no_auto_restore', 07:52:17 INFO - 'tabpaint']}, 07:52:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:52:17 INFO - 'ts_paint', 07:52:17 INFO - 'tpaint', 07:52:17 INFO - 'sessionrestore', 07:52:17 INFO - 'sessionrestore_no_auto_restore', 07:52:17 INFO - 'tabpaint']}, 07:52:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:52:17 INFO - 'tests': ['a11yr', 07:52:17 INFO - 'ts_paint', 07:52:17 INFO - 'tpaint', 07:52:17 INFO - 'sessionrestore', 07:52:17 INFO - 'sessionrestore_no_auto_restore', 07:52:17 INFO - 'tabpaint']}, 07:52:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:52:17 INFO - 'tests': ['a11yr', 07:52:17 INFO - 'ts_paint', 07:52:17 INFO - 'tpaint', 07:52:17 INFO - 'sessionrestore', 07:52:17 INFO - 'sessionrestore_no_auto_restore', 07:52:17 INFO - 'tabpaint']}, 07:52:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:52:17 INFO - 'tests': ['tsvgx', 07:52:17 INFO - 'tsvgr_opacity', 07:52:17 INFO - 'tart', 07:52:17 INFO - 'tscrollx', 07:52:17 INFO - 'cart', 07:52:17 INFO - 'tsvg_static']}, 07:52:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:52:17 INFO - 'tsvgr_opacity', 07:52:17 INFO - 'tart', 07:52:17 INFO - 'tscrollx', 07:52:17 INFO - 'cart', 07:52:17 INFO - 'tsvg_static']}, 07:52:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:52:17 INFO - 'talos_options': ['--disable-e10s'], 07:52:17 INFO - 'tests': ['tp5o']}, 07:52:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:52:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:52:17 INFO - 'talos_options': ['--disable-e10s', 07:52:17 INFO - '--xperf_path', 07:52:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:17 INFO - 'tests': ['tp5n']}, 07:52:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:52:17 INFO - 'talos_options': ['--xperf_path', 07:52:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:17 INFO - 'tests': ['tp5n']}}, 07:52:17 INFO - 'talos.zip': {'path': '', 07:52:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:52:17 INFO - Running post-action listener: _resource_record_post_action 07:52:17 INFO - [mozharness: 2017-01-17 15:52:17.593565Z] Finished populate-webroot step (success) 07:52:17 INFO - [mozharness: 2017-01-17 15:52:17.593696Z] Running create-virtualenv step. 07:52:17 INFO - Running pre-action listener: _resource_record_pre_action 07:52:17 INFO - Running main action method: create_virtualenv 07:52:17 INFO - Creating virtualenv /builds/slave/test/build/venv 07:52:17 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 07:52:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:52:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:52:17 INFO - Using real prefix '/tools/python27' 07:52:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:52:18 INFO - Installing distribute.............................................................................................................................................................................................done. 07:52:21 INFO - Installing pip.................done. 07:52:21 INFO - Return code: 0 07:52:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:52:21 INFO - Reading from file tmpfile_stdout 07:52:21 INFO - Output received: 07:52:21 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) 07:52:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:52:21 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')]} 07:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:21 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')]} 07:52:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:21 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 0x10a1adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3895a4560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8bd30>, '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 0x109eb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f80be8>, '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.Jzh1m6M4R6/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.PJRz6Ug4EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 07:52:21 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 07:52:21 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 07:52:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jzh1m6M4R6/Render', 07:52:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:21 INFO - 'HOME': '/Users/cltbld', 07:52:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:21 INFO - 'LOGNAME': 'cltbld', 07:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:21 INFO - 'MOZ_NO_REMOTE': '1', 07:52:21 INFO - 'NO_EM_RESTART': '1', 07:52:21 INFO - 'PAGER': '/bin/cat', 07:52:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:21 INFO - 'PWD': '/builds/slave/test', 07:52:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:21 INFO - 'SHELL': '/bin/bash', 07:52:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PJRz6Ug4EV/Listeners', 07:52:21 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 07:52:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:21 INFO - 'USER': 'cltbld', 07:52:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:21 INFO - 'XPC_FLAGS': '0x0', 07:52:21 INFO - 'XPC_SERVICE_NAME': '0', 07:52:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:21 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 07:52:21 INFO - Cleaning up... 07:52:21 INFO - Return code: 0 07:52:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:52:21 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')]} 07:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:21 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')]} 07:52:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:21 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 0x10a1adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3895a4560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8bd30>, '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 0x109eb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f80be8>, '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.Jzh1m6M4R6/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.PJRz6Ug4EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 07:52:21 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 07:52:21 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 07:52:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jzh1m6M4R6/Render', 07:52:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:21 INFO - 'HOME': '/Users/cltbld', 07:52:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:21 INFO - 'LOGNAME': 'cltbld', 07:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:21 INFO - 'MOZ_NO_REMOTE': '1', 07:52:21 INFO - 'NO_EM_RESTART': '1', 07:52:21 INFO - 'PAGER': '/bin/cat', 07:52:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:21 INFO - 'PWD': '/builds/slave/test', 07:52:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:21 INFO - 'SHELL': '/bin/bash', 07:52:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PJRz6Ug4EV/Listeners', 07:52:21 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 07:52:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:21 INFO - 'USER': 'cltbld', 07:52:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:21 INFO - 'XPC_FLAGS': '0x0', 07:52:21 INFO - 'XPC_SERVICE_NAME': '0', 07:52:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:22 INFO - Downloading/unpacking psutil>=3.1.1 07:52:22 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 07:52:22 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 07:52:22 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 07:52:22 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 07:52:22 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 07:52:22 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 07:52:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:52:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:52:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:52:25 INFO - Installing collected packages: psutil 07:52:25 INFO - Running setup.py install for psutil 07:52:26 INFO - building 'psutil._psutil_osx' extension 07:52:26 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 07:52:26 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 07:52:26 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 07:52:26 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 07:52:26 INFO - building 'psutil._psutil_posix' extension 07:52:26 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 07:52:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:52:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:52:26 INFO - ^ 07:52:26 INFO - 1 warning generated. 07:52:26 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 07:52:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:52:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:52:26 INFO - Successfully installed psutil 07:52:26 INFO - Cleaning up... 07:52:26 INFO - Return code: 0 07:52:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3895a4560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8bd30>, '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 0x109eb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f80be8>, '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.Jzh1m6M4R6/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.PJRz6Ug4EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 07:52:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:52:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jzh1m6M4R6/Render', 07:52:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:26 INFO - 'HOME': '/Users/cltbld', 07:52:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:26 INFO - 'LOGNAME': 'cltbld', 07:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:26 INFO - 'MOZ_NO_REMOTE': '1', 07:52:26 INFO - 'NO_EM_RESTART': '1', 07:52:26 INFO - 'PAGER': '/bin/cat', 07:52:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:26 INFO - 'PWD': '/builds/slave/test', 07:52:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:26 INFO - 'SHELL': '/bin/bash', 07:52:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PJRz6Ug4EV/Listeners', 07:52:26 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 07:52:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:26 INFO - 'USER': 'cltbld', 07:52:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:26 INFO - 'XPC_FLAGS': '0x0', 07:52:26 INFO - 'XPC_SERVICE_NAME': '0', 07:52:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:52:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:52:29 INFO - Installing collected packages: mozsystemmonitor 07:52:29 INFO - Running setup.py install for mozsystemmonitor 07:52:30 INFO - Successfully installed mozsystemmonitor 07:52:30 INFO - Cleaning up... 07:52:30 INFO - Return code: 0 07:52:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:52:30 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')]} 07:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:30 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')]} 07:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:30 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 0x10a1adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3895a4560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8bd30>, '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 0x109eb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f80be8>, '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.Jzh1m6M4R6/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.PJRz6Ug4EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 07:52:30 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 07:52:30 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 07:52:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jzh1m6M4R6/Render', 07:52:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:30 INFO - 'HOME': '/Users/cltbld', 07:52:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:30 INFO - 'LOGNAME': 'cltbld', 07:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:30 INFO - 'MOZ_NO_REMOTE': '1', 07:52:30 INFO - 'NO_EM_RESTART': '1', 07:52:30 INFO - 'PAGER': '/bin/cat', 07:52:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:30 INFO - 'PWD': '/builds/slave/test', 07:52:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:30 INFO - 'SHELL': '/bin/bash', 07:52:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PJRz6Ug4EV/Listeners', 07:52:30 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 07:52:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:30 INFO - 'USER': 'cltbld', 07:52:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:30 INFO - 'XPC_FLAGS': '0x0', 07:52:30 INFO - 'XPC_SERVICE_NAME': '0', 07:52:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:30 INFO - Downloading/unpacking jsonschema==2.5.1 07:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:52:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:52:33 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 07:52:33 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 07:52:33 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 07:52:33 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 07:52:33 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 07:52:33 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 07:52:33 INFO - Downloading functools32-3.2.3-2.tar.gz 07:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:52:33 INFO - warning: no files found matching '*.txt' 07:52:33 INFO - no previously-included directories found matching 'build' 07:52:33 INFO - no previously-included directories found matching 'dist' 07:52:33 INFO - no previously-included directories found matching '.git*' 07:52:33 INFO - Installing collected packages: jsonschema, functools32 07:52:33 INFO - Running setup.py install for functools32 07:52:33 INFO - warning: no files found matching '*.txt' 07:52:33 INFO - no previously-included directories found matching 'build' 07:52:33 INFO - no previously-included directories found matching 'dist' 07:52:33 INFO - no previously-included directories found matching '.git*' 07:52:33 INFO - Successfully installed jsonschema functools32 07:52:33 INFO - Cleaning up... 07:52:33 INFO - Return code: 0 07:52:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:52:33 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')]} 07:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:33 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')]} 07:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:33 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 0x10a1adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3895a4560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8bd30>, '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 0x109eb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f80be8>, '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.Jzh1m6M4R6/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.PJRz6Ug4EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 07:52:33 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 07:52:33 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 07:52:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jzh1m6M4R6/Render', 07:52:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:33 INFO - 'HOME': '/Users/cltbld', 07:52:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:33 INFO - 'LOGNAME': 'cltbld', 07:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:33 INFO - 'MOZ_NO_REMOTE': '1', 07:52:33 INFO - 'NO_EM_RESTART': '1', 07:52:33 INFO - 'PAGER': '/bin/cat', 07:52:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:33 INFO - 'PWD': '/builds/slave/test', 07:52:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:33 INFO - 'SHELL': '/bin/bash', 07:52:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PJRz6Ug4EV/Listeners', 07:52:33 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 07:52:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:33 INFO - 'USER': 'cltbld', 07:52:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:33 INFO - 'XPC_FLAGS': '0x0', 07:52:33 INFO - 'XPC_SERVICE_NAME': '0', 07:52:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:52:34 INFO - Cleaning up... 07:52:34 INFO - Return code: 0 07:52:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:52:34 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')]} 07:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:34 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')]} 07:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:34 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 0x10a1adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3895a4560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8bd30>, '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 0x109eb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f80be8>, '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.Jzh1m6M4R6/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.PJRz6Ug4EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 07:52:34 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 07:52:34 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 07:52:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jzh1m6M4R6/Render', 07:52:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:34 INFO - 'HOME': '/Users/cltbld', 07:52:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:34 INFO - 'LOGNAME': 'cltbld', 07:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:34 INFO - 'MOZ_NO_REMOTE': '1', 07:52:34 INFO - 'NO_EM_RESTART': '1', 07:52:34 INFO - 'PAGER': '/bin/cat', 07:52:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:34 INFO - 'PWD': '/builds/slave/test', 07:52:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:34 INFO - 'SHELL': '/bin/bash', 07:52:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PJRz6Ug4EV/Listeners', 07:52:34 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 07:52:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:34 INFO - 'USER': 'cltbld', 07:52:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:34 INFO - 'XPC_FLAGS': '0x0', 07:52:34 INFO - 'XPC_SERVICE_NAME': '0', 07:52:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:34 INFO - Downloading/unpacking blobuploader==1.2.4 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52:36 INFO - Downloading blobuploader-1.2.4.tar.gz 07:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:52:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:52:37 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 07:52:37 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 07:52:37 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 07:52:37 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 07:52:37 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 07:52:37 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 07:52:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:52:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:52:37 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 07:52:37 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 07:52:37 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 07:52:37 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 07:52:37 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 07:52:37 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 07:52:38 INFO - Downloading docopt-0.6.1.tar.gz 07:52:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:52:38 INFO - Installing collected packages: blobuploader, requests, docopt 07:52:38 INFO - Running setup.py install for blobuploader 07:52:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:52:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:52:38 INFO - Running setup.py install for requests 07:52:38 INFO - Running setup.py install for docopt 07:52:39 INFO - Successfully installed blobuploader requests docopt 07:52:39 INFO - Cleaning up... 07:52:39 INFO - Return code: 0 07:52:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52:39 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')]} 07:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:39 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')]} 07:52:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:39 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 0x10a1adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3895a4560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8bd30>, '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 0x109eb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f80be8>, '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.Jzh1m6M4R6/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.PJRz6Ug4EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 07:52:39 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 07:52:39 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 07:52:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jzh1m6M4R6/Render', 07:52:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:39 INFO - 'HOME': '/Users/cltbld', 07:52:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:39 INFO - 'LOGNAME': 'cltbld', 07:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:39 INFO - 'MOZ_NO_REMOTE': '1', 07:52:39 INFO - 'NO_EM_RESTART': '1', 07:52:39 INFO - 'PAGER': '/bin/cat', 07:52:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:39 INFO - 'PWD': '/builds/slave/test', 07:52:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:39 INFO - 'SHELL': '/bin/bash', 07:52:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PJRz6Ug4EV/Listeners', 07:52:39 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 07:52:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:39 INFO - 'USER': 'cltbld', 07:52:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:39 INFO - 'XPC_FLAGS': '0x0', 07:52:39 INFO - 'XPC_SERVICE_NAME': '0', 07:52:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:52:39 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-Es58Rx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:52:39 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-VH3AOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:52:39 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-0vzSsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:52:39 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-ErtJc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:52:39 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-NcivVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:52:39 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-Ei0wjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:52:40 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-idlC6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:52:40 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-aWD56n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:52:40 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-3A2UT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:52:40 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-nJk_AC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:52:40 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-kpt8UE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:52:40 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-KoBieZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:52:40 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-zDB9Mc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:52:40 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-CH0I2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:40 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-Ut09CE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:52:40 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-_DFNsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:52:41 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-s0OHit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:52:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:52:41 INFO - Running setup.py install for manifestparser 07:52:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:52:41 INFO - Running setup.py install for mozcrash 07:52:41 INFO - Running setup.py install for mozdebug 07:52:41 INFO - Running setup.py install for mozdevice 07:52:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:52:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:52:41 INFO - Running setup.py install for mozfile 07:52:41 INFO - Running setup.py install for mozhttpd 07:52:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:52:42 INFO - Running setup.py install for mozinfo 07:52:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:52:42 INFO - Running setup.py install for mozInstall 07:52:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:52:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:52:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:52:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:52:42 INFO - Running setup.py install for mozleak 07:52:42 INFO - Running setup.py install for mozlog 07:52:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:52:42 INFO - Running setup.py install for moznetwork 07:52:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:52:42 INFO - Running setup.py install for mozprocess 07:52:42 INFO - Running setup.py install for mozprofile 07:52:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:52:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:52:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:52:43 INFO - Running setup.py install for mozrunner 07:52:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:52:43 INFO - Running setup.py install for mozscreenshot 07:52:43 INFO - Running setup.py install for moztest 07:52:43 INFO - Running setup.py install for mozversion 07:52:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:52:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:52:43 INFO - Cleaning up... 07:52:43 INFO - Return code: 0 07:52:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:43 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 0x10a1adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3895a4560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8bd30>, '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 0x109eb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f80be8>, '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.Jzh1m6M4R6/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.PJRz6Ug4EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 07:52:43 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 07:52:43 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 07:52:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jzh1m6M4R6/Render', 07:52:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:43 INFO - 'HOME': '/Users/cltbld', 07:52:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:43 INFO - 'LOGNAME': 'cltbld', 07:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:43 INFO - 'MOZ_NO_REMOTE': '1', 07:52:43 INFO - 'NO_EM_RESTART': '1', 07:52:43 INFO - 'PAGER': '/bin/cat', 07:52:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:43 INFO - 'PWD': '/builds/slave/test', 07:52:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:43 INFO - 'SHELL': '/bin/bash', 07:52:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PJRz6Ug4EV/Listeners', 07:52:43 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 07:52:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:43 INFO - 'USER': 'cltbld', 07:52:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:43 INFO - 'XPC_FLAGS': '0x0', 07:52:43 INFO - 'XPC_SERVICE_NAME': '0', 07:52:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:52:44 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-6UAX2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:52:44 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)) 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:52:44 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-UFzjfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:52:44 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)) 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:52:44 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-nCTDAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:52:44 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)) 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:52:44 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-_od1e5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:52:44 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)) 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:52:44 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-e6INlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:52:44 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)) 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:52:44 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-GMqsDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:52:44 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)) 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:52:44 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-beWcfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:52:44 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)) 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:52:44 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-J7lGPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:52:44 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)) 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:52:44 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-g06Kue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:52:45 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)) 07:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:52:45 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-rDXuHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:52:45 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)) 07:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:52:45 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-bIZHiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:52:45 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)) 07:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:52:45 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-tHiayc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:52:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 07:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:52:45 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-QPCy68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:52:45 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)) 07:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:52:45 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-EbIa0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:52:45 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)) 07:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:45 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-y8SiVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:45 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)) 07:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:52:45 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-KATzb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:52:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 07:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:52:45 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-R4lGrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:52:45 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)) 07:52:45 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)) 07:52:45 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)) 07:52:45 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)) 07:52:45 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)) 07:52:45 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)) 07:52:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:48 INFO - Downloading blessings-1.6.tar.gz 07:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:52:48 INFO - Installing collected packages: blessings 07:52:48 INFO - Running setup.py install for blessings 07:52:48 INFO - Successfully installed blessings 07:52:48 INFO - Cleaning up... 07:52:48 INFO - Return code: 0 07:52:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:52:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:52:49 INFO - Reading from file tmpfile_stdout 07:52:49 INFO - Current package versions: 07:52:49 INFO - blessings == 1.6 07:52:49 INFO - blobuploader == 1.2.4 07:52:49 INFO - docopt == 0.6.1 07:52:49 INFO - functools32 == 3.2.3-2 07:52:49 INFO - jsonschema == 2.5.1 07:52:49 INFO - manifestparser == 1.1 07:52:49 INFO - mozInstall == 1.12 07:52:49 INFO - mozcrash == 1.0 07:52:49 INFO - mozdebug == 0.1 07:52:49 INFO - mozdevice == 0.49 07:52:49 INFO - mozfile == 1.2 07:52:49 INFO - mozhttpd == 0.7 07:52:49 INFO - mozinfo == 0.9 07:52:49 INFO - mozleak == 0.1 07:52:49 INFO - mozlog == 3.4 07:52:49 INFO - moznetwork == 0.27 07:52:49 INFO - mozprocess == 0.24 07:52:49 INFO - mozprofile == 0.28 07:52:49 INFO - mozrunner == 6.13 07:52:49 INFO - mozscreenshot == 0.1 07:52:49 INFO - mozsystemmonitor == 0.3 07:52:49 INFO - moztest == 0.8 07:52:49 INFO - mozversion == 1.4 07:52:49 INFO - psutil == 3.1.1 07:52:49 INFO - requests == 1.2.3 07:52:49 INFO - wsgiref == 0.1.2 07:52:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52:49 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')]} 07:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:49 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')]} 07:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:49 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 0x10a1adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3895a4560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8bd30>, '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 0x109eb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f80be8>, '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.Jzh1m6M4R6/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.PJRz6Ug4EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 07:52:49 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 07:52:49 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 07:52:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jzh1m6M4R6/Render', 07:52:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:49 INFO - 'HOME': '/Users/cltbld', 07:52:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:49 INFO - 'LOGNAME': 'cltbld', 07:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:49 INFO - 'MOZ_NO_REMOTE': '1', 07:52:49 INFO - 'NO_EM_RESTART': '1', 07:52:49 INFO - 'PAGER': '/bin/cat', 07:52:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:49 INFO - 'PWD': '/builds/slave/test', 07:52:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:49 INFO - 'SHELL': '/bin/bash', 07:52:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PJRz6Ug4EV/Listeners', 07:52:49 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 07:52:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:49 INFO - 'USER': 'cltbld', 07:52:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:49 INFO - 'XPC_FLAGS': '0x0', 07:52:49 INFO - 'XPC_SERVICE_NAME': '0', 07:52:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:49 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)) 07:52:49 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)) 07:52:49 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)) 07:52:49 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)) 07:52:49 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)) 07:52:49 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)) 07:52:49 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)) 07:52:49 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)) 07:52:49 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)) 07:52:49 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)) 07:52:49 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)) 07:52:49 INFO - Cleaning up... 07:52:49 INFO - Return code: 0 07:52:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:52:49 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')]} 07:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:49 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')]} 07:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:49 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 0x10a1adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3895a4560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8bd30>, '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 0x109eb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f80be8>, '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.Jzh1m6M4R6/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.PJRz6Ug4EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 07:52:49 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 07:52:49 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 07:52:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jzh1m6M4R6/Render', 07:52:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:49 INFO - 'HOME': '/Users/cltbld', 07:52:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:49 INFO - 'LOGNAME': 'cltbld', 07:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:49 INFO - 'MOZ_NO_REMOTE': '1', 07:52:49 INFO - 'NO_EM_RESTART': '1', 07:52:49 INFO - 'PAGER': '/bin/cat', 07:52:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:49 INFO - 'PWD': '/builds/slave/test', 07:52:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:49 INFO - 'SHELL': '/bin/bash', 07:52:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PJRz6Ug4EV/Listeners', 07:52:49 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 07:52:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:49 INFO - 'USER': 'cltbld', 07:52:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:49 INFO - 'XPC_FLAGS': '0x0', 07:52:49 INFO - 'XPC_SERVICE_NAME': '0', 07:52:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:52:49 INFO - Cleaning up... 07:52:49 INFO - Return code: 0 07:52:49 INFO - Running post-action listener: _resource_record_post_action 07:52:49 INFO - Running post-action listener: _start_resource_monitoring 07:52:49 INFO - Starting resource monitoring. 07:52:49 INFO - [mozharness: 2017-01-17 15:52:49.716167Z] Finished create-virtualenv step (success) 07:52:49 INFO - [mozharness: 2017-01-17 15:52:49.717127Z] Running install step. 07:52:49 INFO - Running pre-action listener: _resource_record_pre_action 07:52:49 INFO - Running main action method: install 07:52:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:52:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:52:49 INFO - Reading from file tmpfile_stdout 07:52:49 INFO - Detecting whether we're running mozinstall >=1.0... 07:52:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:52:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:52:50 INFO - Reading from file tmpfile_stdout 07:52:50 INFO - Output received: 07:52:50 INFO - Usage: mozinstall [options] installer 07:52:50 INFO - Options: 07:52:50 INFO - -h, --help show this help message and exit 07:52:50 INFO - -d DEST, --destination=DEST 07:52:50 INFO - Directory to install application into. [default: 07:52:50 INFO - "/builds/slave/test"] 07:52:50 INFO - --app=APP Application being installed. [default: firefox] 07:52:50 INFO - mkdir: /builds/slave/test/build/application 07:52:50 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'] 07:52:50 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 07:53:12 INFO - Reading from file tmpfile_stdout 07:53:12 INFO - Output received: 07:53:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:53:12 INFO - Running post-action listener: _resource_record_post_action 07:53:12 INFO - [mozharness: 2017-01-17 15:53:12.127964Z] Finished install step (success) 07:53:12 INFO - [mozharness: 2017-01-17 15:53:12.128110Z] Running run-tests step. 07:53:12 INFO - Running pre-action listener: _resource_record_pre_action 07:53:12 INFO - Running main action method: run_tests 07:53:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:53:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:53:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:53:12 INFO - 2017-01-17 07:53:12.142 screenresolution[1918:19904] starting screenresolution argv=screenresolution get 07:53:12 INFO - 2017-01-17 07:53:12.145 screenresolution[1918:19904] Display 0: 1600x1200x32@60 07:53:12 INFO - 2017-01-17 07:53:12.150 screenresolution[1919:19907] starting screenresolution argv=screenresolution list 07:53:12 INFO - Available Modes on Display 0 07:53:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:53:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:53:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:53:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:53:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:53:12 INFO - Intel Iris: 07:53:12 INFO - Chipset Model: Intel Iris 07:53:12 INFO - Type: GPU 07:53:12 INFO - Bus: Built-In 07:53:12 INFO - VRAM (Dynamic, Max): 1536 MB 07:53:12 INFO - Vendor: Intel (0x8086) 07:53:12 INFO - Device ID: 0x0a2e 07:53:12 INFO - Revision ID: 0x0009 07:53:12 INFO - Displays: 07:53:12 INFO - Display: 07:53:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:53:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:53:12 INFO - Display Serial Number: 1600x1200 60 07:53:12 INFO - Main Display: Yes 07:53:12 INFO - Mirror: Off 07:53:12 INFO - Online: Yes 07:53:12 INFO - Rotation: Supported 07:53:12 INFO - Return code: 0 07:53:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:53:12 INFO - Python 2.7.3 07:53:12 INFO - Return code: 0 07:53:12 INFO - grabbing minidump binary from tooltool 07:53:12 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')]} 07:53:12 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 0x109f8bd30>, '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 0x109eb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f80be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:53:12 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 07:53:12 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 07:53:12 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 07:53:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:53:12 INFO - Return code: 0 07:53:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:53:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:53:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:53:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:53:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:53:12 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/da6ZwgDjRv-bTs8GIH_wGQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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 07:53:12 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/da6ZwgDjRv-bTs8GIH_wGQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0038 --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 07:53:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jzh1m6M4R6/Render', 07:53:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:12 INFO - 'HOME': '/Users/cltbld', 07:53:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:12 INFO - 'LOGNAME': 'cltbld', 07:53:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:53:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:53:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:12 INFO - 'MOZ_NO_REMOTE': '1', 07:53:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:53:12 INFO - 'NO_EM_RESTART': '1', 07:53:12 INFO - 'PAGER': '/bin/cat', 07:53:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:12 INFO - 'PWD': '/builds/slave/test', 07:53:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:53:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:12 INFO - 'SHELL': '/bin/bash', 07:53:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PJRz6Ug4EV/Listeners', 07:53:12 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 07:53:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:12 INFO - 'USER': 'cltbld', 07:53:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:12 INFO - 'XPC_FLAGS': '0x0', 07:53:12 INFO - 'XPC_SERVICE_NAME': '0', 07:53:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:12 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/da6ZwgDjRv-bTs8GIH_wGQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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 07:53:12 INFO - mozversion application_buildid: 20170117064027 07:53:12 INFO - mozversion application_changeset: c52fa5ad5b28d10afb19beb3d2d9e7769d3b74d6 07:53:12 INFO - mozversion application_display_name: Nightly 07:53:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:53:12 INFO - mozversion application_name: Firefox 07:53:12 INFO - mozversion application_remotingname: firefox 07:53:12 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 07:53:12 INFO - mozversion application_vendor: Mozilla 07:53:12 INFO - mozversion application_version: 53.0a1 07:53:12 INFO - mozversion platform_buildid: 20170117064027 07:53:12 INFO - mozversion platform_changeset: c52fa5ad5b28d10afb19beb3d2d9e7769d3b74d6 07:53:12 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 07:53:12 INFO - mozversion platform_version: 53.0a1 07:53:12 INFO - using testdate: 1484668392 07:53:12 INFO - actual date: 1484668392 07:53:12 INFO - starting webserver on 'localhost:55656' 07:53:12 INFO - SUITE-START | Running 2 tests 07:53:12 INFO - TEST-START | dromaeo_css 07:53:12 INFO - operating with platform_type : mac_ 07:53:12 INFO - Initialising browser for dromaeo_css test... 07:53:12 INFO - TEST-INFO | started process 1929 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/tmpGwkkUk/profile http://localhost:55656/getInfo.html) 07:53:15 INFO - PROCESS | 1929 | __metrics Screen width/height:1600/1200 07:53:15 INFO - PROCESS | 1929 | colorDepth:24 07:53:15 INFO - PROCESS | 1929 | Browser inner width/height: 1024/689 07:53:15 INFO - PROCESS | 1929 | __metrics 07:53:15 INFO - PROCESS | 1929 | 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" 07:53:15 INFO - PROCESS | 1929 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:53:15 INFO - TEST-INFO | 1929: exit 0 07:53:15 INFO - Browser initialized. 07:53:15 INFO - Running cycle 1/1 for dromaeo_css test... 07:53:15 INFO - TEST-INFO | started process 1931 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/tmpGwkkUk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:53:28 INFO - PROCESS | 1931 | RSS: Main: 227037184 07:53:28 INFO - PROCESS | 1931 | 07:56:31 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:55656/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55656/tests/dromaeo/cssquery-ext.html) 07:56:34 INFO - PROCESS | 1931 | RSS: Main: 459182080 07:56:34 INFO - PROCESS | 1931 | 07:58:17 INFO - PROCESS | 1931 | ************************* 07:58:17 INFO - PROCESS | 1931 | A coding exception was thrown and uncaught in a Task. 07:58:17 INFO - PROCESS | 1931 | 07:58:17 ERROR - PROCESS | 1931 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:58:17 INFO - PROCESS | 1931 | Full stack: 07:58:17 INFO - PROCESS | 1931 | ************************* 07:59:37 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:55656/tests/dromaeo/cssquery-ext.html (next: http://localhost:55656/tests/dromaeo/cssquery-jquery.html) 07:59:37 INFO - PROCESS | 1931 | RSS: Main: 371884032 07:59:37 INFO - PROCESS | 1931 | 08:02:40 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:55656/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55656/tests/dromaeo/cssquery-mootools.html) 08:02:40 INFO - PROCESS | 1931 | RSS: Main: 362504192 08:02:40 INFO - PROCESS | 1931 | 08:05:43 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:55656/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55656/tests/dromaeo/cssquery-prototype.html) 08:05:43 INFO - PROCESS | 1931 | RSS: Main: 338505728 08:05:43 INFO - PROCESS | 1931 | 08:08:47 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:55656/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55656/tests/dromaeo/cssquery-yui.html) 08:08:47 INFO - PROCESS | 1931 | RSS: Main: 326647808 08:08:47 INFO - PROCESS | 1931 | 08:11:51 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:55656/tests/dromaeo/cssquery-yui.html (next: http://localhost:55656/tests/dromaeo/cssquery-dojo.html) 08:11:51 INFO - PROCESS | 1931 | RSS: Main: 402223104 08:11:51 INFO - PROCESS | 1931 | 08:11:51 INFO - PROCESS | 1931 | __start_tp_report 08:11:51 INFO - PROCESS | 1931 | _x_x_mozilla_page_load 08:11:51 INFO - PROCESS | 1931 | _x_x_mozilla_page_load_details 08:11:51 INFO - PROCESS | 1931 | |i|pagename|runs| 08:11:51 INFO - PROCESS | 1931 | |0;dojo.html;3082.522209057594;3313.2545177335096;3318.784279021862;3337.0489410518;3407.1993081625815;5460.918086228709;5518.227448157261;5540.2243685884005;5608.803691870786;5629.859253518659;5548.140038294071;5549.306336707911;5585.245991791117;5601;5670.914936275959;5086.389633243997;5147.7426128693605;5159.948400515985;5171.87070323243;5184.351956005499;5121.385433747955;5173.560247378978;5205.27126202332;5208.088584497697;5226.294450249225;5196.818111366122;5208.322918020652;5217.869553261161;5222.216667499867;5264.184051472028;5042.294078828967;5060;5071.39143302806;5092.414372347191;5171.637985341028;5085.288059671649;5107.61692873036;5139.17773156297;5179.352580927384;5202.479752024805;5539.279893613845;5573.749181286852;5606.887862242773;5614.1859430382365;5637.126245431965;6034.064719968368;6089.360617135181;6197.969010154966;6221.4089661482085;6222.937770622327;5112.207607820794;6149.86227547905;6200.410960958701;6212.192414986068;6229.127922090911;5759.395263497272;5768.3366412862215;5804.651720896717;5805.100209467497;5827.970860145672;6150.753969841246;6308.179936608303;6312.084747711556;6331.556791024676;6363.61818290904;5875.559333050039;5922.822315330547;6116.418940200674;6119.938800612026;6128.142060111588;5969.462748352582;5991;6006.399360063959;6115.4190351916495;6140.87237156979;5826.359100498942;5856.941430585724;5863;5902.734376953047;5968;6061.848453788691;6121.877562448815;6128.717018009172;6140.166841500592;6201.348858369896;4885.462599114095;5002.324686167321;5002.699838009731;5005.4744251853035;5036.269740887551;4382.561743825592;4406.801693923781;4413;4449.822007119679;4466.955330446719;5871.383504732027;5889.469947704727;5896.233489646319;5897.5871688982215;5913.674747888907;6084.209052823193;6116.26604807426;6214.844628884314;6284.874302514016;6303.527235457359;5688.914666279927;5730.19777231188;5735.627184233012;5748.9425105748405;5855.853603659857;5424.213489044067;5487.506124448819;5498.670079795225;5499.615026948075;5502.064649009598;6280.9685951569945;6296.811095667137;6329.082283068929;6340.270868850049;6342.23893132827;6198.721057552511;6276.089966954674;6283.528735344776;6292.968535157295;6293.244810622755;6260.373962603703;6272.435480806566;6287.937120628735;6290.874182516232;6322.778702745381;6179.351168127282;6192.256929168529;6201.410865967726;6203.627782333075;6203.937960620517;6187.226596675416;6218.751249950133;6246.406591373812;6256.092866534418;6286.874262514632;5787.2187254720075;5852.502537284378;5853.824385268449;5922.022866227025;6032.3967603239325;5949.613275137102;6046.183765191643;6073.119397687222;6086.873928323097;6089.69551522431;5642.984262832565;5671.234383358359;5725.570582206435;5795.33353664334;5839.824805255849;5914.201582786441;5941.613795103477;5951.642901425928;5979.880402392015;5985.341612422543;5810.128480727755;5815.302163740378;5815.621984570989;5818.970905145447;5823.097419899922 08:11:51 INFO - PROCESS | 1931 | |1;ext.html;448.91470620582066;458.53458739379533;467.22440748357724;496.06491763026696;542.4350748091756;31959.68040319599;34459.4831077534;36569.81715091424;40059.59940400595;42419;43087.78456107715;43396.783016084875;43565.7821710891;43573.7209930113;43636.78181609095;8529.061803201643;9392.201662858648;9607.711768646952;9614.855777163348;9618.519074046304;8490.150984901522;11223.551057957713;11489.195756297062;11519.942400287986;11697;11493.023093037102;11546.07631389491;11636;11639.6508104757;11642.767144657102;8561.571921403905;11567.958883700465;11576.594819181288;11628.6511404658;11651.650450486413;8516.318694504425;11157.442127893653;11436.02793762523;11485;11672.474738636696;40618.59381406178;41260.79369603163;41262;41264.58735412668;41268.58731412677;4017.678585713136;4033.838646454138;4070.5522392536795;4071.246819338432;4089.672826173899;29649.703502965127;30735.538966915516;30941.84529077363;30957.65368099557;31052.8447357764;2793.986030069857;3118.7349075328398;3250.626177989514;3308.2556424804466;3309.0238379678053;473007;475763;477968;479341;480003;56020.15969760457;56250;56516.15225771617;56522.15216771752;56598;62807;62876;62923.37076629267;62988;63145.737085258035;15588.610284742745;16099.356025758838;16114.033158010558;16115.516534503984;16159.838401616069;11062.336259824275;11411.543538258542;12456.252624842538;12545.937270313772;12582.24506529611;12358.691032724253;14500.347484363228;16164.949278296874;16214.918925405298;16675.749863752055;6288.811335659938;6312.684365781693;7405.555666660018;7467.439942004371;7567.3189412952;894.338189739601;899.7885496908222;900.9864852027225;931.753085432361;944.9763755906157;29523.52156866619;29921.41669073637;29954;30065.849670751508;30204;1061.2783307351076;1072.3190773858655;1099.384344766933;1112.2992514715838;1227.9570215042431;12538.749225015448;12872.742545149045;15117.319720612599;15259.389624415122;15778.9211053944;618651;619908;622312;622337;622705;61027;61221;61314;61415.464613385026;61545;1450.470578238935;1461.2328527523136;1481.866632003125;1502.3089378885616;1510.1392206442442;23835.617799460528;29166;29512.409751805273;29728.702712972594;30090;50649.240261395375;50994.74502627463;51173;51234.48765512297;51239.23141152811;539180;543518;543855;545465;546063;32483.675163248066;37191.88424347274;39512.60487395089;40292;40379.59620403876;46472.53527464682;46576.53423465722;47684.52315476801;47687.807804805154;48125.75937120292;38687.61312386952;38873.02817429587;39159.77653631285;39253;40420.989475263355;38200;38802.223955521295;39168.60831391763;39479.01302467461;40059.59940400675;37339.439908400855;37516.62483375241;38036;38088.04779880525;38322.85031449061;32163.678363217005;34074;34154.65845341515;34429.311413772084;34457.48313775245;21343.67984480203;22739.658905116106;24171.63742543828;24663.136790212255;24970.37574060663 08:11:51 INFO - PROCESS | 1931 | |2;jquery.html;370.44988192534066;389.61038961038946;396.81548080142727;397.91842672252193;419.97900104994744;14629.853701462982;15650.686986260267;16038.83961160388;20591.27930522432;20799.896000519977;20548.89725551374;21118.472038199016;21195.47011324718;21730.348089557338;21801.781982180175;5286.4449232830575;5468.589855760814;5472.671639701631;5659.349174844904;6097.542684298695;3954.1498577805764;5950.55370847186;6042.033274676052;6045.516358691316;6048.879022419549;4142.378643203529;5842.620229685078;6125.785597504088;6133.264008319008;6208.286047104573;5598.300212473441;5850.531957443394;6167.414095660905;6192.8761424771255;6209.59637623553;5824.271966004249;5829.8251052468495;5829.941700582982;5841.0362290222065;5847.2983242010805;13375.665608359772;13379.732405351935;13383.665408364772;13529.729405411936;13547.187168769906;2561.1932241343916;2568.7431256874165;2650.3904102056636;2667.066526715634;2667.399835037101;9981.151602113829;10001.549930253155;10053.346532475365;10418.27072104953;10551.155907527456;1823.8632102592358;1873.9156737946826;1880.125741530195;1881.4825922871182;1904.5333893196116;135221;142153.99999999895;143613;146265;147630;11331;11569.6529104127;11661.533538658528;11851.762964740657;11938.64184074479;14969.251537423086;15384.769228461582;15409.075455472708;15464.14947177916;15465.149416782186;8505.659773608986;8660.48037117775;8664.09027052163;8687.826243475096;8833.381663283508;7082.858342833115;8461.323094152453;8488.193621605938;8583.785405364915;8627.78430539229;3722.571904231048;4654.581087702123;4672.439307283148;4743.762811859393;4756.9286460703115;1918.0889077688266;2001.899905004744;2002.9799702003086;2008.3874418302557;2015.6271089848426;964.840801267797;980.3774603127066;994.955227014786;1008.4554340655964;1021.918246540275;20887.74673519594;21420.29186522296;21437.892810535846;21627.02678379477;21872.12511499554;956.6412595276771;980.7253968888723;1015.1523477896039;1024.4109636958628;1026.461107918349;10567.94716026415;10940.43047244802;11009.504572294267;11022.50398732059;11045.779084418427;694322;708112;708229;726473;733958;118894.21658675127;133855;140474;147491;150370;988.4316518002178;988.7577543501889;1010.7422607235108;1012.018342208057;1013.0123129948241;17808;18245.4526364204;18269;18420.263189472807;18445.446636600922;47934.76032619815;53268.73365633147;53971.92056158934;54228;54459.72770136124;80813;84144.57927710323;87002.6949595744;88671;89580.656290157;6617.8014659560295;7465.253474652492;7755.844883102193;7837.255460731221;7914.960425197837;10697.786044279226;11911.3448760319;12182.208156469802;12202.450889709808;12286.631401057983;8631.870521942301;10049.949750251202;10082.54628541732;10246.077852993267;10448;8767.386282960386;10079.395236285847;10339.431331276552;10551;10622.575096996034;7499.737509187371;10244;10608.89391106079;10653.680389588324;10728.51721672511;7588.59610971972;7665.195154508696;7666.808329791576;7894.526328420313;7925.643346049557;7693.269139431745;9475.905240947777;10013.599456021677;10096.545655445669;10171.186305095722 08:11:51 INFO - PROCESS | 1931 | |3;mootools.html;1351.452661672023;1456.191813543483;1466.1276540458423;1491.343808724162;1491.3810768531057;7992.720254791084;8417.032041315251;8424.199701028409;8436.240738333549;8441.029281632615;7460.6642701078445;7673.539587624747;7700.8459830803495;8006.719764808233;8223.958880205606;2288.9198878039274;2337.801286890616;2344.9882750586307;2350.059976009601;2351.400392899808;2329.440934175794;2356.564035653401;2370.4429459077105;2371.7983971362455;2373.264288070695;2311;2319.083961835074;2326.5695846268495;2360.9291721248305;2362.4684445999596;2300.217925905192;2305.1586171047447;2333.300009997011;2335.521218150292;2343.4610039690883;2295.632698768189;2352.7294361148515;2358.13927916311;2359.1035406545575;2365.6924599801914;8344.04043534989;8417.410781245315;8419.579021048923;8444.662213511452;8456.704015359433;5012.248162775612;5175.689458632456;5176.870578235536;5182.32629758129;5197.246399272122;3273.165342837561;3373.308471763283;3498.912527186815;3549.591796943333;3560.2701446203464;1214.3867346989714;1227.743425463758;1233.2477188914754;1234.5247079874223;1278.9616311510576;10722.892771072346;10824.567017319298;10825.83761243582;10830.079443247334;10834.945825270903;4069.8197522718674;4232.470941132358;4588.197065513522;4659.091477161921;4675.672702910763;9477.099675530813;9480.95259523698;9482.573284202228;9484.810303793885;9496.050394960448;5091.643584949092;5164.509371609691;5165.1219292720325;5168.2764412982215;5171.2501687255135;3851.9807400963377;4224.5353011168745;4613.930791038137;4725.621950243973;4734.905301893943;3792.943105853414;3820.331441997639;3888;3894.065424298148;3937.310970580137;1249.8187762774528;1251.6120002799162;1254.4006391850464;1266.9429875655617;1269.3335998600808;884.9424787388799;905.7101727447154;910.7358865928807;932.5570354081757;934.6349577236057;5341.839744807662;5444.210295575611;5545.916811247835;5572.3034620672415;5663.433656634386;576.533008263308;582.6416753696531;585.7217821534737;592.8073376152768;600.6605270247372;3683.9263214735556;3702.407614781622;3740.551133863954;3741.869034583831;3805.1438426353848;9624.566894489764;9936.105750482491;10060.849087263698;10070.748231294276;10105.848412273821;7839.33365663925;9750.268729845147;9756;10039.146672532917;10043.899561004442;7697.846043079107;7702.383809295355;7785.922140778633;7878.369730421553;7888.526688398714;5355.973220133875;5375.81184658535;5395.3525576931015;5441.7551210196425;5463.945360546344;8829.779255518664;8984.123658890623;9203.217726493323;9355.25157987373;9378.343515953818;9132.726018219464;9292.535373231447;9448.48033358172;9461.95269023678;9538.38000529991;6652.101966234496;6774.830629234309;6863.553868998499;7206.927930720625;7347.889781653173;8007.0391553014015;8068.11250762404;8137.145599711945;8155.021397432346;8155.306798922158;7098.609576473344;7264.237255088351;7264.600446975256;7296.452766042462;7357.668904899399;6995.265497122932;7023.367896889305;7049.154101507646;7211.963940180265;7214.206437291999;6342.112104305309;6463.450606698295;6466.838329041811;6468.288488266381;6472.223333200046;4911.877203069952;4945.332380128781;5014.473480284663;5027;5065.29085927963;4871.3667223260745;4963.925541116959;5037.445880953019;5092.083424983391;5180.554930970862 08:11:51 INFO - PROCESS | 1931 | |4;prototype.html;292.40933314704296;313.6330493322812;356.9321390084894;362.3568166504454;373.61761482514703;4107.815148318326;4803.855884323476;4896.485868983759;4928.334674818899;5017.42299635542;4332.350147477872;4884.365032545764;4948.430930443;4953.702777833332;5071.873203169923;3553.5202747629064;4056.452378928851;4071.5928407159195;4074.327735923569;4076.0421300994244;3637.909052273701;3974.682025437958;4026.3356546169994;4089.26393249215;4093.8157782899693;3401.812900290483;3694.408894576868;3998.8805932855635;4071.4707088078508;4116.876493705194;3042.9045543604507;3812.684623804783;4009.7594144351433;4023.275810354135;4095.6313931746135;3069.754419646423;3614.34941710492;3617.602063772983;3619.8597441805746;3622.590977000292;4827.782749776268;4846.369971903665;5059.507445303644;5085.618578606583;5119.795208191668;4613.238815595423;4624.913145410826;4642.79107440166;4692.202325604621;4713.505081966378;5222.0678349011105;5402.594805389572;5407.729613519308;5445.9727701361635;5530.198121272393;3293.818839963801;3482.077249528877;3516.5955915069585;3865.8067096645054;4004.2592120457807;4839.685420447695;5051.292819005343;5482.930828488486;5580.972095139539;5748.367679555287;3443.810590417551;3946.5264168299987;4074.8777536673947;4084.387341898739;4097.467329247238;3615.584207816135;3662.4323229898873;4075.673946084306;4167.854125105607;4190.28765109932;3422.880199193066;3844.3272427325105;4220.472440944882;4270.679699022524;4496.887577810516;5488.91766623501;5512.283403157564;5531.972340138354;5541.750621222055;5548.334199896039;1079.266099052636;1148.4544841200363;1175.3887978251262;1252.634628255188;1259.8866102050858;770.7495064104188;786.1902240692096;791.8636756254792;817.7097130518699;836.93304535637;4289.67827412939;4591.586757191869;4724.929126063112;4936.408385597519;5073.264376665363;4327.82688692455;5422;5444.700541470178;5495.862603434866;5501.78960628661;4824.469308376076;4838.685500432215;4890.413150421972;4988.301637770715;5066.949330506648;2568.678915135608;2698.6371882199364;2785.6796468405987;2801.9265743350184;2809.3678922242334;4893.559579637849;5068.477408201265;5569.860753481114;5614.24207731951;5618.97190514053;4548.95451045492;4705;4991.401031876198;5146.202338637517;5370.838874833761;4709.858704238878;5043.5460808527405;5226.45122262157;5484.270695926808;5683.9715801420725;4488.438945131858;4776.689515181502;5086.923696144635;5135.301504444478;5191.22131680251;4644.814207431665;5014.598832093497;5276.868078298074;5292.761825717929;5302.867428314169;4698.812047518061;5616.185653080199;5629.986602411605;5642.971785141048;5661.85845353853;2901.4632293025857;3351.815650139168;3426.623071462187;3485.919364996758;3529.347070791912;5135.17701216063;5535.225068490495;5561.721913904369;5593.594754255547;5626;4774.092922344882;5207.27098206259;5390.460953904735;5410.648307859977;5418.970395624819;4332.935005974849;4569.794359253775;5069.188929771219;5370.650907690988;5396.7571459283645;5034.59723222134;5203.531682148625;5268.920966185587;5279;5352.785888564569;5188.558972487381;5295.2403793307185;5364.049772625119;5376.247325374373;5397.326828683121;4850.005748821412;5000.874453466583;5189.455107213839;5305.1776974569;5309.628326017141 08:11:51 INFO - PROCESS | 1931 | |5;yui.html;670.7048898484667;739.1499775258449;776.9184235655256;809.8096947217407;816.2123550773505;14334.283285835692;14876.404943802236;15404;15993.840061599394;16001.67996640068;14637.487687930925;14788.778168327484;14796.778048329285;14804.481843135465;14806.25968701566;684.2268236892305;706.5654622407234;707.5683832861951;849.2441726863096;861.1173547114196;867.9001914779786;870.4603146049458;874.9825003499926;880.4761167105562;881.1056777370974;893.8793262909489;893.8837951066384;910.026271889079;932.6689025395989;937.2595649436937;928.9489078100702;929.6839074714629;929.8000929800091;930.093159169804;930.939488933224;537.3444397834636;553.2310088976326;675.9594424334556;692.536000879407;698.671624336561;14964.700705985928;14999.775003374958;15013.873959452976;15021;15025.849741502663;13438;13611.795823062663;13674.863251367458;13739.862601373958;13752.381142848595;12508.49966001368;12519.874801251963;12529.561465348668;12795.360231988363;12939.87060129396;4289.4852617685765;4547.749873756942;4591.4260717410325;4604.447466304065;4608.216603177468;106866.46566767195;109887.90112098856;112059;113577.43211283891;113893.4305328468;10346;10992.340459572451;11023.850349181832;11054.557817687364;11261.380624065756;19889.900550497154;21717.782822171892;21733.67399489009;21785.019674114705;21786.34640960742;7511.286427789351;7748.535087894745;7753.147153813076;7813.453058285979;7835.529868207926;4225.19721252961;4266.722663026893;4333;4430.136123455895;4431.534688857623;3400.1159698478573;3499.090236538518;3502.2995400919917;3504.684578387957;3509.894703158909;616.1435604509735;620.2494981072862;621.1521273461692;636.5575924732267;638.4828289085856;622.862970146567;629.3171908479351;656.5043392238829;663.2505269046044;664.7725293699118;9618.374805637612;9622.855657165148;9660.71017869465;9678.70963871085;9713.90286097144;620.6245221640933;631.4443289904855;641.131267133028;651.9804405867832;659.4164164714263;4627.167109920179;4684.625229981593;4695.5304469552775;4697.78859951303;4720.669553131248;81903.5904820472;86848.26303473895;88121.23757524813;90661.54669226611;109812;77052;83368.16422850464;83522.58238708768;87987;90480.71347157443;77896.83154752683;78825;79791;79915.80126298226;80783.19216807757;10690.037896589345;10849.728756781144;10972.451377430936;10980.066694330751;11116.555337786398;47442.76278618585;47722.52277477181;48313.27530087122;48357.03285934191;50186.498135018184;45947.540524594326;62787.68606157123;64678.353216467236;65439.69120617656;66217;11568.421578921188;11581.247218930743;11594.304341739522;11609.187356885275;11639.359835209145;12298.446569904554;14283.943578174885;15036.473723419627;15123;15343.38626454974;13669.43711740415;14056;14092.859071409155;14177.929110354382;14217.21805300677;13897.235652039235;14063.789043164565;14074.78887816704;14292.928535357256;14457.493987710379;13409.262490562722;13715.083102838284;13720.039597228497;13807.930960345135;13840.653983650489;11191;11397.316161030365;11754.941225293818;11875.259293322575;11963.222390544586;10997.945010274898;11282.153838462313;11320.320780753182;11438.695045879029;11468.197226194086 08:11:51 INFO - PROCESS | 1931 | __end_tp_report 08:11:51 INFO - PROCESS | 1931 | __start_cc_report 08:11:51 INFO - PROCESS | 1931 | _x_x_mozilla_cycle_collect,2751 08:11:51 INFO - PROCESS | 1931 | __end_cc_report 08:11:51 INFO - PROCESS | 1931 | __startTimestamp1484669511684__endTimestamp 08:11:51 INFO - PROCESS | 1931 | 08:11:51 INFO - PROCESS | 1931 | ------- Summary: start ------- 08:11:51 INFO - PROCESS | 1931 | Number of tests: 6 08:11:51 INFO - PROCESS | 1931 | 08:11:51 INFO - PROCESS | 1931 | [#0] dojo.html Cycles:165 Average:5685.52 Median:5852.50 stddev:629.43 (10.8%) stddev-sans-first:597.32 08:11:51 INFO - PROCESS | 1931 | Values: 3082.5 3313.3 3318.8 3337.0 3407.2 5460.9 5518.2 5540.2 5608.8 5629.9 5548.1 5549.3 5585.2 5601.0 5670.9 5086.4 5147.7 5159.9 5171.9 5184.4 5121.4 5173.6 5205.3 5208.1 5226.3 5196.8 5208.3 5217.9 5222.2 5264.2 5042.3 5060.0 5071.4 5092.4 5171.6 5085.3 5107.6 5139.2 5179.4 5202.5 5539.3 5573.7 5606.9 5614.2 5637.1 6034.1 6089.4 6198.0 6221.4 6222.9 5112.2 6149.9 6200.4 6212.2 6229.1 5759.4 5768.3 5804.7 5805.1 5828.0 6150.8 6308.2 6312.1 6331.6 6363.6 5875.6 5922.8 6116.4 6119.9 6128.1 5969.5 5991.0 6006.4 6115.4 6140.9 5826.4 5856.9 5863.0 5902.7 5968.0 6061.8 6121.9 6128.7 6140.2 6201.3 4885.5 5002.3 5002.7 5005.5 5036.3 4382.6 4406.8 4413.0 4449.8 4467.0 5871.4 5889.5 5896.2 5897.6 5913.7 6084.2 6116.3 6214.8 6284.9 6303.5 5688.9 5730.2 5735.6 5748.9 5855.9 5424.2 5487.5 5498.7 5499.6 5502.1 6281.0 6296.8 6329.1 6340.3 6342.2 6198.7 6276.1 6283.5 6293.0 6293.2 6260.4 6272.4 6287.9 6290.9 6322.8 6179.4 6192.3 6201.4 6203.6 6203.9 6187.2 6218.8 6246.4 6256.1 6286.9 5787.2 5852.5 5853.8 5922.0 6032.4 5949.6 6046.2 6073.1 6086.9 6089.7 5643.0 5671.2 5725.6 5795.3 5839.8 5914.2 5941.6 5951.6 5979.9 5985.3 5810.1 5815.3 5815.6 5819.0 5823.1 08:11:51 INFO - PROCESS | 1931 | 08:11:51 INFO - PROCESS | 1931 | [#1] ext.html Cycles:180 Average:68690.78 Median:39016.40 stddev:146829.76 (376.3%) stddev-sans-first:147152.26 08:11:51 INFO - PROCESS | 1931 | Values: 448.9 458.5 467.2 496.1 542.4 31959.7 34459.5 36569.8 40059.6 42419.0 43087.8 43396.8 43565.8 43573.7 43636.8 8529.1 9392.2 9607.7 9614.9 9618.5 8490.2 11223.6 11489.2 11519.9 11697.0 11493.0 11546.1 11636.0 11639.7 11642.8 8561.6 11568.0 11576.6 11628.7 11651.7 8516.3 11157.4 11436.0 11485.0 11672.5 40618.6 41260.8 41262.0 41264.6 41268.6 4017.7 4033.8 4070.6 4071.2 4089.7 29649.7 30735.5 30941.8 30957.7 31052.8 2794.0 3118.7 3250.6 3308.3 3309.0 473007.0 475763.0 477968.0 479341.0 480003.0 56020.2 56250.0 56516.2 56522.2 56598.0 62807.0 62876.0 62923.4 62988.0 63145.7 15588.6 16099.4 16114.0 16115.5 16159.8 11062.3 11411.5 12456.3 12545.9 12582.2 12358.7 14500.3 16164.9 16214.9 16675.7 6288.8 6312.7 7405.6 7467.4 7567.3 894.3 899.8 901.0 931.8 945.0 29523.5 29921.4 29954.0 30065.8 30204.0 1061.3 1072.3 1099.4 1112.3 1228.0 12538.7 12872.7 15117.3 15259.4 15778.9 618651.0 619908.0 622312.0 622337.0 622705.0 61027.0 61221.0 61314.0 61415.5 61545.0 1450.5 1461.2 1481.9 1502.3 1510.1 23835.6 29166.0 29512.4 29728.7 30090.0 50649.2 50994.7 51173.0 51234.5 51239.2 539180.0 543518.0 543855.0 545465.0 546063.0 32483.7 37191.9 39512.6 40292.0 40379.6 46472.5 46576.5 47684.5 47687.8 48125.8 38687.6 38873.0 39159.8 39253.0 40421.0 38200.0 38802.2 39168.6 39479.0 40059.6 37339.4 37516.6 38036.0 38088.0 38322.9 32163.7 34074.0 34154.7 34429.3 34457.5 21343.7 22739.7 24171.6 24663.1 24970.4 08:11:51 INFO - PROCESS | 1931 | 08:11:51 INFO - PROCESS | 1931 | [#2] jquery.html Cycles:180 Average:38913.03 Median:21836.95 stddev:119241.95 (546.1%) stddev-sans-first:119541.34 08:11:51 INFO - PROCESS | 1931 | Values: 370.4 389.6 396.8 397.9 420.0 14629.9 15650.7 16038.8 20591.3 20799.9 20548.9 21118.5 21195.5 21730.3 21801.8 5286.4 5468.6 5472.7 5659.3 6097.5 3954.1 5950.6 6042.0 6045.5 6048.9 4142.4 5842.6 6125.8 6133.3 6208.3 5598.3 5850.5 6167.4 6192.9 6209.6 5824.3 5829.8 5829.9 5841.0 5847.3 13375.7 13379.7 13383.7 13529.7 13547.2 2561.2 2568.7 2650.4 2667.1 2667.4 9981.2 10001.5 10053.3 10418.3 10551.2 1823.9 1873.9 1880.1 1881.5 1904.5 135221.0 142154.0 143613.0 146265.0 147630.0 11331.0 11569.7 11661.5 11851.8 11938.6 14969.3 15384.8 15409.1 15464.1 15465.1 8505.7 8660.5 8664.1 8687.8 8833.4 7082.9 8461.3 8488.2 8583.8 8627.8 3722.6 4654.6 4672.4 4743.8 4756.9 1918.1 2001.9 2003.0 2008.4 2015.6 964.8 980.4 995.0 1008.5 1021.9 20887.7 21420.3 21437.9 21627.0 21872.1 956.6 980.7 1015.2 1024.4 1026.5 10567.9 10940.4 11009.5 11022.5 11045.8 694322.0 708112.0 708229.0 726473.0 733958.0 118894.2 133855.0 140474.0 147491.0 150370.0 988.4 988.8 1010.7 1012.0 1013.0 17808.0 18245.5 18269.0 18420.3 18445.4 47934.8 53268.7 53971.9 54228.0 54459.7 80813.0 84144.6 87002.7 88671.0 89580.7 6617.8 7465.3 7755.8 7837.3 7915.0 10697.8 11911.3 12182.2 12202.5 12286.6 8631.9 10049.9 10082.5 10246.1 10448.0 8767.4 10079.4 10339.4 10551.0 10622.6 7499.7 10244.0 10608.9 10653.7 10728.5 7588.6 7665.2 7666.8 7894.5 7925.6 7693.3 9475.9 10013.6 10096.5 10171.2 08:11:51 INFO - PROCESS | 1931 | 08:11:51 INFO - PROCESS | 1931 | [#3] mootools.html Cycles:180 Average:5411.56 Median:5176.28 stddev:2953.90 (57.1%) stddev-sans-first:2946.42 08:11:51 INFO - PROCESS | 1931 | Values: 1351.5 1456.2 1466.1 1491.3 1491.4 7992.7 8417.0 8424.2 8436.2 8441.0 7460.7 7673.5 7700.8 8006.7 8224.0 2288.9 2337.8 2345.0 2350.1 2351.4 2329.4 2356.6 2370.4 2371.8 2373.3 2311.0 2319.1 2326.6 2360.9 2362.5 2300.2 2305.2 2333.3 2335.5 2343.5 2295.6 2352.7 2358.1 2359.1 2365.7 8344.0 8417.4 8419.6 8444.7 8456.7 5012.2 5175.7 5176.9 5182.3 5197.2 3273.2 3373.3 3498.9 3549.6 3560.3 1214.4 1227.7 1233.2 1234.5 1279.0 10722.9 10824.6 10825.8 10830.1 10834.9 4069.8 4232.5 4588.2 4659.1 4675.7 9477.1 9481.0 9482.6 9484.8 9496.1 5091.6 5164.5 5165.1 5168.3 5171.3 3852.0 4224.5 4613.9 4725.6 4734.9 3792.9 3820.3 3888.0 3894.1 3937.3 1249.8 1251.6 1254.4 1266.9 1269.3 884.9 905.7 910.7 932.6 934.6 5341.8 5444.2 5545.9 5572.3 5663.4 576.5 582.6 585.7 592.8 600.7 3683.9 3702.4 3740.6 3741.9 3805.1 9624.6 9936.1 10060.8 10070.7 10105.8 7839.3 9750.3 9756.0 10039.1 10043.9 7697.8 7702.4 7785.9 7878.4 7888.5 5356.0 5375.8 5395.4 5441.8 5463.9 8829.8 8984.1 9203.2 9355.3 9378.3 9132.7 9292.5 9448.5 9462.0 9538.4 6652.1 6774.8 6863.6 7206.9 7347.9 8007.0 8068.1 8137.1 8155.0 8155.3 7098.6 7264.2 7264.6 7296.5 7357.7 6995.3 7023.4 7049.2 7212.0 7214.2 6342.1 6463.5 6466.8 6468.3 6472.2 4911.9 4945.3 5014.5 5027.0 5065.3 4871.4 4963.9 5037.4 5092.1 5180.6 08:11:51 INFO - PROCESS | 1931 | 08:11:51 INFO - PROCESS | 1931 | [#4] prototype.html Cycles:180 Average:4328.26 Median:4843.03 stddev:1313.41 (27.1%) stddev-sans-first:1281.69 08:11:51 INFO - PROCESS | 1931 | Values: 292.4 313.6 356.9 362.4 373.6 4107.8 4803.9 4896.5 4928.3 5017.4 4332.4 4884.4 4948.4 4953.7 5071.9 3553.5 4056.5 4071.6 4074.3 4076.0 3637.9 3974.7 4026.3 4089.3 4093.8 3401.8 3694.4 3998.9 4071.5 4116.9 3042.9 3812.7 4009.8 4023.3 4095.6 3069.8 3614.3 3617.6 3619.9 3622.6 4827.8 4846.4 5059.5 5085.6 5119.8 4613.2 4624.9 4642.8 4692.2 4713.5 5222.1 5402.6 5407.7 5446.0 5530.2 3293.8 3482.1 3516.6 3865.8 4004.3 4839.7 5051.3 5482.9 5581.0 5748.4 3443.8 3946.5 4074.9 4084.4 4097.5 3615.6 3662.4 4075.7 4167.9 4190.3 3422.9 3844.3 4220.5 4270.7 4496.9 5488.9 5512.3 5532.0 5541.8 5548.3 1079.3 1148.5 1175.4 1252.6 1259.9 770.7 786.2 791.9 817.7 836.9 4289.7 4591.6 4724.9 4936.4 5073.3 4327.8 5422.0 5444.7 5495.9 5501.8 4824.5 4838.7 4890.4 4988.3 5066.9 2568.7 2698.6 2785.7 2801.9 2809.4 4893.6 5068.5 5569.9 5614.2 5619.0 4549.0 4705.0 4991.4 5146.2 5370.8 4709.9 5043.5 5226.5 5484.3 5684.0 4488.4 4776.7 5086.9 5135.3 5191.2 4644.8 5014.6 5276.9 5292.8 5302.9 4698.8 5616.2 5630.0 5643.0 5661.9 2901.5 3351.8 3426.6 3485.9 3529.3 5135.2 5535.2 5561.7 5593.6 5626.0 4774.1 5207.3 5390.5 5410.6 5419.0 4332.9 4569.8 5069.2 5370.7 5396.8 5034.6 5203.5 5268.9 5279.0 5352.8 5188.6 5295.2 5364.0 5376.2 5397.3 4850.0 5000.9 5189.5 5305.2 5309.6 08:11:51 INFO - PROCESS | 1931 | 08:11:51 INFO - PROCESS | 1931 | [#5] yui.html Cycles:180 Average:20076.97 Median:4430.84 stddev:28497.49 (643.2%) stddev-sans-first:28540.18 08:11:51 INFO - PROCESS | 1931 | Values: 670.7 739.1 776.9 809.8 816.2 14334.3 14876.4 15404.0 15993.8 16001.7 14637.5 14788.8 14796.8 14804.5 14806.3 684.2 706.6 707.6 849.2 861.1 867.9 870.5 875.0 880.5 881.1 893.9 893.9 910.0 932.7 937.3 928.9 929.7 929.8 930.1 930.9 537.3 553.2 676.0 692.5 698.7 14964.7 14999.8 15013.9 15021.0 15025.8 13438.0 13611.8 13674.9 13739.9 13752.4 12508.5 12519.9 12529.6 12795.4 12939.9 4289.5 4547.7 4591.4 4604.4 4608.2 106866.5 109887.9 112059.0 113577.4 113893.4 10346.0 10992.3 11023.9 11054.6 11261.4 19889.9 21717.8 21733.7 21785.0 21786.3 7511.3 7748.5 7753.1 7813.5 7835.5 4225.2 4266.7 4333.0 4430.1 4431.5 3400.1 3499.1 3502.3 3504.7 3509.9 616.1 620.2 621.2 636.6 638.5 622.9 629.3 656.5 663.3 664.8 9618.4 9622.9 9660.7 9678.7 9713.9 620.6 631.4 641.1 652.0 659.4 4627.2 4684.6 4695.5 4697.8 4720.7 81903.6 86848.3 88121.2 90661.5 109812.0 77052.0 83368.2 83522.6 87987.0 90480.7 77896.8 78825.0 79791.0 79915.8 80783.2 10690.0 10849.7 10972.5 10980.1 11116.6 47442.8 47722.5 48313.3 48357.0 50186.5 45947.5 62787.7 64678.4 65439.7 66217.0 11568.4 11581.2 11594.3 11609.2 11639.4 12298.4 14283.9 15036.5 15123.0 15343.4 13669.4 14056.0 14092.9 14177.9 14217.2 13897.2 14063.8 14074.8 14292.9 14457.5 13409.3 13715.1 13720.0 13807.9 13840.7 11191.0 11397.3 11754.9 11875.3 11963.2 10997.9 11282.2 11320.3 11438.7 11468.2 08:11:51 INFO - PROCESS | 1931 | -------- Summary: end -------- 08:11:51 INFO - PROCESS | 1931 | 08:11:52 INFO - TEST-INFO | 1931: exit 0 08:11:52 INFO - TEST-OK | dromaeo_css | took 1119571ms 08:11:52 INFO - TEST-START | kraken 08:11:52 INFO - operating with platform_type : mac_ 08:11:52 INFO - Initialising browser for kraken test... 08:11:52 INFO - TEST-INFO | started process 1935 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/tmpk7IiY3/profile http://localhost:55656/getInfo.html) 08:11:54 INFO - PROCESS | 1935 | __metrics Screen width/height:1600/1200 08:11:54 INFO - PROCESS | 1935 | colorDepth:24 08:11:54 INFO - PROCESS | 1935 | Browser inner width/height: 1024/689 08:11:54 INFO - PROCESS | 1935 | __metrics 08:11:54 INFO - PROCESS | 1935 | 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" 08:11:54 INFO - PROCESS | 1935 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:11:55 INFO - TEST-INFO | 1935: exit 0 08:11:55 INFO - Browser initialized. 08:11:55 INFO - Running cycle 1/1 for kraken test... 08:11:55 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/tmpk7IiY3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:07 INFO - PROCESS | 1936 | RSS: Main: 235835392 08:12:07 INFO - PROCESS | 1936 | 08:12:10 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:55656/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55656/tests/kraken/driver.html?testName=audio-beat-detection) 08:12:11 INFO - PROCESS | 1936 | RSS: Main: 287191040 08:12:11 INFO - PROCESS | 1936 | 08:12:13 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:55656/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55656/tests/kraken/driver.html?testName=audio-dft) 08:12:14 INFO - PROCESS | 1936 | RSS: Main: 286654464 08:12:14 INFO - PROCESS | 1936 | 08:12:17 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:55656/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55656/tests/kraken/driver.html?testName=audio-fft) 08:12:18 INFO - PROCESS | 1936 | RSS: Main: 380723200 08:12:18 INFO - PROCESS | 1936 | 08:12:20 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:55656/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55656/tests/kraken/driver.html?testName=audio-oscillator) 08:12:20 INFO - PROCESS | 1936 | RSS: Main: 282886144 08:12:20 INFO - PROCESS | 1936 | 08:12:22 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:55656/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55656/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:12:23 INFO - PROCESS | 1936 | RSS: Main: 286617600 08:12:23 INFO - PROCESS | 1936 | 08:12:26 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:55656/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55656/tests/kraken/driver.html?testName=imaging-darkroom) 08:12:26 INFO - PROCESS | 1936 | RSS: Main: 326987776 08:12:26 INFO - PROCESS | 1936 | 08:12:29 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:55656/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55656/tests/kraken/driver.html?testName=imaging-desaturate) 08:12:30 INFO - PROCESS | 1936 | RSS: Main: 330137600 08:12:30 INFO - PROCESS | 1936 | 08:12:33 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:55656/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55656/tests/kraken/driver.html?testName=json-parse-financial) 08:12:33 INFO - PROCESS | 1936 | RSS: Main: 329719808 08:12:33 INFO - PROCESS | 1936 | 08:12:35 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:55656/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55656/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:12:35 INFO - PROCESS | 1936 | RSS: Main: 302956544 08:12:35 INFO - PROCESS | 1936 | 08:12:37 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:55656/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55656/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:12:38 INFO - PROCESS | 1936 | RSS: Main: 307814400 08:12:38 INFO - PROCESS | 1936 | 08:12:40 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:55656/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55656/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:12:41 INFO - PROCESS | 1936 | RSS: Main: 308572160 08:12:41 INFO - PROCESS | 1936 | 08:12:44 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:55656/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:12:45 INFO - PROCESS | 1936 | RSS: Main: 324263936 08:12:45 INFO - PROCESS | 1936 | 08:12:48 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:55656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:12:48 INFO - PROCESS | 1936 | RSS: Main: 317820928 08:12:48 INFO - PROCESS | 1936 | 08:12:50 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:55656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55656/tests/kraken/driver.html?testName=ai-astar) 08:12:50 INFO - PROCESS | 1936 | RSS: Main: 361582592 08:12:50 INFO - PROCESS | 1936 | 08:12:50 INFO - PROCESS | 1936 | __start_tp_report 08:12:50 INFO - PROCESS | 1936 | _x_x_mozilla_page_load 08:12:50 INFO - PROCESS | 1936 | _x_x_mozilla_page_load_details 08:12:50 INFO - PROCESS | 1936 | |i|pagename|runs| 08:12:50 INFO - PROCESS | 1936 | |0;ai-astar;113;113;111;112;111;112;111;113;111;113 08:12:50 INFO - PROCESS | 1936 | |1;audio-beat-detection;148;112;110;149;111;110;111;110;132;107 08:12:50 INFO - PROCESS | 1936 | |2;audio-dft;186;184;184;183;183;185;179;181;182;184 08:12:50 INFO - PROCESS | 1936 | |3;audio-fft;79;58;59;88;59;59;58;58;75;59 08:12:50 INFO - PROCESS | 1936 | |4;audio-oscillator;88;70;86;69;69;69;82;68;68;83 08:12:50 INFO - PROCESS | 1936 | |5;imaging-gaussian-blur;88;84;87;83;87;84;88;84;88;86 08:12:50 INFO - PROCESS | 1936 | |6;imaging-darkroom;96;97;97;97;97;96;97;97;97;96 08:12:50 INFO - PROCESS | 1936 | |7;imaging-desaturate;86;96;141;84;86;85;88;86;85;85 08:12:50 INFO - PROCESS | 1936 | |8;json-parse-financial;56;55;57;55;59;56;56;56;56;55 08:12:50 INFO - PROCESS | 1936 | |9;json-stringify-tinderbox;75;82;74;74;72;71;70;72;70;72 08:12:50 INFO - PROCESS | 1936 | |10;stanford-crypto-aes;88;87;85;88;88;87;84;89;89;91 08:12:50 INFO - PROCESS | 1936 | |11;stanford-crypto-ccm;141;141;140;142;141;142;146;158;205;153 08:12:50 INFO - PROCESS | 1936 | |12;stanford-crypto-pbkdf2;170;173;173;206;238;171;173;173;182;237 08:12:50 INFO - PROCESS | 1936 | |13;stanford-crypto-sha256-iterative;66;67;65;65;65;67;67;66;65;66 08:12:50 INFO - PROCESS | 1936 | __end_tp_report 08:12:50 INFO - PROCESS | 1936 | __start_cc_report 08:12:50 INFO - PROCESS | 1936 | _x_x_mozilla_cycle_collect,1954 08:12:50 INFO - PROCESS | 1936 | __end_cc_report 08:12:50 INFO - PROCESS | 1936 | __startTimestamp1484669570726__endTimestamp 08:12:50 INFO - PROCESS | 1936 | 08:12:50 INFO - PROCESS | 1936 | ------- Summary: start ------- 08:12:50 INFO - PROCESS | 1936 | Number of tests: 14 08:12:50 INFO - PROCESS | 1936 | 08:12:50 INFO - PROCESS | 1936 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.50 stddev:0.94 (0.8%) stddev-sans-first:0.93 08:12:50 INFO - PROCESS | 1936 | Values: 113.0 113.0 111.0 112.0 111.0 112.0 111.0 113.0 111.0 113.0 08:12:50 INFO - PROCESS | 1936 | 08:12:50 INFO - PROCESS | 1936 | [#1] audio-beat-detection Cycles:10 Average:120.00 Median:111.50 stddev:16.55 (14.8%) stddev-sans-first:14.11 08:12:50 INFO - PROCESS | 1936 | Values: 148.0 112.0 110.0 149.0 111.0 110.0 111.0 110.0 132.0 107.0 08:12:50 INFO - PROCESS | 1936 | 08:12:50 INFO - PROCESS | 1936 | [#2] audio-dft Cycles:10 Average:183.10 Median:184.00 stddev:2.02 (1.1%) stddev-sans-first:1.86 08:12:50 INFO - PROCESS | 1936 | Values: 186.0 184.0 184.0 183.0 183.0 185.0 179.0 181.0 182.0 184.0 08:12:50 INFO - PROCESS | 1936 | 08:12:50 INFO - PROCESS | 1936 | [#3] audio-fft Cycles:10 Average:65.20 Median:59.00 stddev:11.13 (18.9%) stddev-sans-first:10.63 08:12:50 INFO - PROCESS | 1936 | Values: 79.0 58.0 59.0 88.0 59.0 59.0 58.0 58.0 75.0 59.0 08:12:50 INFO - PROCESS | 1936 | 08:12:50 INFO - PROCESS | 1936 | [#4] audio-oscillator Cycles:10 Average:75.20 Median:76.00 stddev:8.39 (11.0%) stddev-sans-first:7.51 08:12:50 INFO - PROCESS | 1936 | Values: 88.0 70.0 86.0 69.0 69.0 69.0 82.0 68.0 68.0 83.0 08:12:50 INFO - PROCESS | 1936 | 08:12:50 INFO - PROCESS | 1936 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:87.00 stddev:1.97 (2.3%) stddev-sans-first:1.94 08:12:50 INFO - PROCESS | 1936 | Values: 88.0 84.0 87.0 83.0 87.0 84.0 88.0 84.0 88.0 86.0 08:12:50 INFO - PROCESS | 1936 | 08:12:50 INFO - PROCESS | 1936 | [#6] imaging-darkroom Cycles:10 Average:96.70 Median:97.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 08:12:50 INFO - PROCESS | 1936 | Values: 96.0 97.0 97.0 97.0 97.0 96.0 97.0 97.0 97.0 96.0 08:12:50 INFO - PROCESS | 1936 | 08:12:50 INFO - PROCESS | 1936 | [#7] imaging-desaturate Cycles:10 Average:92.20 Median:86.00 stddev:17.49 (20.3%) stddev-sans-first:18.40 08:12:50 INFO - PROCESS | 1936 | Values: 86.0 96.0 141.0 84.0 86.0 85.0 88.0 86.0 85.0 85.0 08:12:50 INFO - PROCESS | 1936 | 08:12:50 INFO - PROCESS | 1936 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:1.20 (2.1%) stddev-sans-first:1.27 08:12:50 INFO - PROCESS | 1936 | Values: 56.0 55.0 57.0 55.0 59.0 56.0 56.0 56.0 56.0 55.0 08:12:50 INFO - PROCESS | 1936 | 08:12:50 INFO - PROCESS | 1936 | [#9] json-stringify-tinderbox Cycles:10 Average:73.20 Median:73.00 stddev:3.52 (4.8%) stddev-sans-first:3.67 08:12:50 INFO - PROCESS | 1936 | Values: 75.0 82.0 74.0 74.0 72.0 71.0 70.0 72.0 70.0 72.0 08:12:50 INFO - PROCESS | 1936 | 08:12:50 INFO - PROCESS | 1936 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:88.00 stddev:2.01 (2.3%) stddev-sans-first:2.13 08:12:50 INFO - PROCESS | 1936 | Values: 88.0 87.0 85.0 88.0 88.0 87.0 84.0 89.0 89.0 91.0 08:12:50 INFO - PROCESS | 1936 | 08:12:50 INFO - PROCESS | 1936 | [#11] stanford-crypto-ccm Cycles:10 Average:150.90 Median:144.00 stddev:19.94 (13.8%) stddev-sans-first:20.82 08:12:50 INFO - PROCESS | 1936 | Values: 141.0 141.0 140.0 142.0 141.0 142.0 146.0 158.0 205.0 153.0 08:12:50 INFO - PROCESS | 1936 | 08:12:50 INFO - PROCESS | 1936 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.60 Median:177.50 stddev:27.38 (15.4%) stddev-sans-first:28.11 08:12:50 INFO - PROCESS | 1936 | Values: 170.0 173.0 173.0 206.0 238.0 171.0 173.0 173.0 182.0 237.0 08:12:50 INFO - PROCESS | 1936 | 08:12:50 INFO - PROCESS | 1936 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 08:12:50 INFO - PROCESS | 1936 | Values: 66.0 67.0 65.0 65.0 65.0 67.0 67.0 66.0 65.0 66.0 08:12:50 INFO - PROCESS | 1936 | -------- Summary: end -------- 08:12:50 INFO - PROCESS | 1936 | 08:12:51 INFO - TEST-INFO | 1936: exit 0 08:12:51 INFO - TEST-OK | kraken | took 59475ms 08:12:51 INFO - SUITE-END | took 1179s 08:12:51 INFO - Completed test suite (00:19:39) 08:12:51 INFO - javascript benchmark 08:12:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3082.522209057594, 3313.2545177335096, 3318.784279021862, 3337.0489410518, 3407.1993081625815, 5460.918086228709, 5518.227448157261, 5540.2243685884005, 5608.803691870786, 5629.859253518659, 5548.140038294071, 5549.306336707911, 5585.245991791117, 5601.0, 5670.914936275959, 5086.389633243997, 5147.7426128693605, 5159.948400515985, 5171.87070323243, 5184.351956005499, 5121.385433747955, 5173.560247378978, 5205.27126202332, 5208.088584497697, 5226.294450249225, 5196.818111366122, 5208.322918020652, 5217.869553261161, 5222.216667499867, 5264.184051472028, 5042.294078828967, 5060.0, 5071.39143302806, 5092.414372347191, 5171.637985341028, 5085.288059671649, 5107.61692873036, 5139.17773156297, 5179.352580927384, 5202.479752024805, 5539.279893613845, 5573.749181286852, 5606.887862242773, 5614.1859430382365, 5637.126245431965, 6034.064719968368, 6089.360617135181, 6197.969010154966, 6221.4089661482085, 6222.937770622327, 5112.207607820794, 6149.86227547905, 6200.410960958701, 6212.192414986068, 6229.127922090911, 5759.395263497272, 5768.3366412862215, 5804.651720896717, 5805.100209467497, 5827.970860145672, 6150.753969841246, 6308.179936608303, 6312.084747711556, 6331.556791024676, 6363.61818290904, 5875.559333050039, 5922.822315330547, 6116.418940200674, 6119.938800612026, 6128.142060111588, 5969.462748352582, 5991.0, 6006.399360063959, 6115.4190351916495, 6140.87237156979, 5826.359100498942, 5856.941430585724, 5863.0, 5902.734376953047, 5968.0, 6061.848453788691, 6121.877562448815, 6128.717018009172, 6140.166841500592, 6201.348858369896, 4885.462599114095, 5002.324686167321, 5002.699838009731, 5005.4744251853035, 5036.269740887551, 4382.561743825592, 4406.801693923781, 4413.0, 4449.822007119679, 4466.955330446719, 5871.383504732027, 5889.469947704727, 5896.233489646319, 5897.5871688982215, 5913.674747888907, 6084.209052823193, 6116.26604807426, 6214.844628884314, 6284.874302514016, 6303.527235457359, 5688.914666279927, 5730.19777231188, 5735.627184233012, 5748.9425105748405, 5855.853603659857, 5424.213489044067, 5487.506124448819, 5498.670079795225, 5499.615026948075, 5502.064649009598, 6280.9685951569945, 6296.811095667137, 6329.082283068929, 6340.270868850049, 6342.23893132827, 6198.721057552511, 6276.089966954674, 6283.528735344776, 6292.968535157295, 6293.244810622755, 6260.373962603703, 6272.435480806566, 6287.937120628735, 6290.874182516232, 6322.778702745381, 6179.351168127282, 6192.256929168529, 6201.410865967726, 6203.627782333075, 6203.937960620517, 6187.226596675416, 6218.751249950133, 6246.406591373812, 6256.092866534418, 6286.874262514632, 5787.2187254720075, 5852.502537284378, 5853.824385268449, 5922.022866227025, 6032.3967603239325, 5949.613275137102, 6046.183765191643, 6073.119397687222, 6086.873928323097, 6089.69551522431, 5642.984262832565, 5671.234383358359, 5725.570582206435, 5795.33353664334, 5839.824805255849, 5914.201582786441, 5941.613795103477, 5951.642901425928, 5979.880402392015, 5985.341612422543, 5810.128480727755, 5815.302163740378, 5815.621984570989, 5818.970905145447, 5823.097419899922], "value": 5644.828377956875, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.91470620582066, 458.53458739379533, 467.22440748357724, 496.06491763026696, 542.4350748091756, 31959.68040319599, 34459.4831077534, 36569.81715091424, 40059.59940400595, 42419.0, 43087.78456107715, 43396.783016084875, 43565.7821710891, 43573.7209930113, 43636.78181609095, 8529.061803201643, 9392.201662858648, 9607.711768646952, 9614.855777163348, 9618.519074046304, 8490.150984901522, 11223.551057957713, 11489.195756297062, 11519.942400287986, 11697.0, 11493.023093037102, 11546.07631389491, 11636.0, 11639.6508104757, 11642.767144657102, 8561.571921403905, 11567.958883700465, 11576.594819181288, 11628.6511404658, 11651.650450486413, 8516.318694504425, 11157.442127893653, 11436.02793762523, 11485.0, 11672.474738636696, 40618.59381406178, 41260.79369603163, 41262.0, 41264.58735412668, 41268.58731412677, 4017.678585713136, 4033.838646454138, 4070.5522392536795, 4071.246819338432, 4089.672826173899, 29649.703502965127, 30735.538966915516, 30941.84529077363, 30957.65368099557, 31052.8447357764, 2793.986030069857, 3118.7349075328398, 3250.626177989514, 3308.2556424804466, 3309.0238379678053, 473007.0, 475763.0, 477968.0, 479341.0, 480003.0, 56020.15969760457, 56250.0, 56516.15225771617, 56522.15216771752, 56598.0, 62807.0, 62876.0, 62923.37076629267, 62988.0, 63145.737085258035, 15588.610284742745, 16099.356025758838, 16114.033158010558, 16115.516534503984, 16159.838401616069, 11062.336259824275, 11411.543538258542, 12456.252624842538, 12545.937270313772, 12582.24506529611, 12358.691032724253, 14500.347484363228, 16164.949278296874, 16214.918925405298, 16675.749863752055, 6288.811335659938, 6312.684365781693, 7405.555666660018, 7467.439942004371, 7567.3189412952, 894.338189739601, 899.7885496908222, 900.9864852027225, 931.753085432361, 944.9763755906157, 29523.52156866619, 29921.41669073637, 29954.0, 30065.849670751508, 30204.0, 1061.2783307351076, 1072.3190773858655, 1099.384344766933, 1112.2992514715838, 1227.9570215042431, 12538.749225015448, 12872.742545149045, 15117.319720612599, 15259.389624415122, 15778.9211053944, 618651.0, 619908.0, 622312.0, 622337.0, 622705.0, 61027.0, 61221.0, 61314.0, 61415.464613385026, 61545.0, 1450.470578238935, 1461.2328527523136, 1481.866632003125, 1502.3089378885616, 1510.1392206442442, 23835.617799460528, 29166.0, 29512.409751805273, 29728.702712972594, 30090.0, 50649.240261395375, 50994.74502627463, 51173.0, 51234.48765512297, 51239.23141152811, 539180.0, 543518.0, 543855.0, 545465.0, 546063.0, 32483.675163248066, 37191.88424347274, 39512.60487395089, 40292.0, 40379.59620403876, 46472.53527464682, 46576.53423465722, 47684.52315476801, 47687.807804805154, 48125.75937120292, 38687.61312386952, 38873.02817429587, 39159.77653631285, 39253.0, 40420.989475263355, 38200.0, 38802.223955521295, 39168.60831391763, 39479.01302467461, 40059.59940400675, 37339.439908400855, 37516.62483375241, 38036.0, 38088.04779880525, 38322.85031449061, 32163.678363217005, 34074.0, 34154.65845341515, 34429.311413772084, 34457.48313775245, 21343.67984480203, 22739.658905116106, 24171.63742543828, 24663.136790212255, 24970.37574060663], "value": 20210.291260475737, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.44988192534066, 389.61038961038946, 396.81548080142727, 397.91842672252193, 419.97900104994744, 14629.853701462982, 15650.686986260267, 16038.83961160388, 20591.27930522432, 20799.896000519977, 20548.89725551374, 21118.472038199016, 21195.47011324718, 21730.348089557338, 21801.781982180175, 5286.4449232830575, 5468.589855760814, 5472.671639701631, 5659.349174844904, 6097.542684298695, 3954.1498577805764, 5950.55370847186, 6042.033274676052, 6045.516358691316, 6048.879022419549, 4142.378643203529, 5842.620229685078, 6125.785597504088, 6133.264008319008, 6208.286047104573, 5598.300212473441, 5850.531957443394, 6167.414095660905, 6192.8761424771255, 6209.59637623553, 5824.271966004249, 5829.8251052468495, 5829.941700582982, 5841.0362290222065, 5847.2983242010805, 13375.665608359772, 13379.732405351935, 13383.665408364772, 13529.729405411936, 13547.187168769906, 2561.1932241343916, 2568.7431256874165, 2650.3904102056636, 2667.066526715634, 2667.399835037101, 9981.151602113829, 10001.549930253155, 10053.346532475365, 10418.27072104953, 10551.155907527456, 1823.8632102592358, 1873.9156737946826, 1880.125741530195, 1881.4825922871182, 1904.5333893196116, 135221.0, 142153.99999999895, 143613.0, 146265.0, 147630.0, 11331.0, 11569.6529104127, 11661.533538658528, 11851.762964740657, 11938.64184074479, 14969.251537423086, 15384.769228461582, 15409.075455472708, 15464.14947177916, 15465.149416782186, 8505.659773608986, 8660.48037117775, 8664.09027052163, 8687.826243475096, 8833.381663283508, 7082.858342833115, 8461.323094152453, 8488.193621605938, 8583.785405364915, 8627.78430539229, 3722.571904231048, 4654.581087702123, 4672.439307283148, 4743.762811859393, 4756.9286460703115, 1918.0889077688266, 2001.899905004744, 2002.9799702003086, 2008.3874418302557, 2015.6271089848426, 964.840801267797, 980.3774603127066, 994.955227014786, 1008.4554340655964, 1021.918246540275, 20887.74673519594, 21420.29186522296, 21437.892810535846, 21627.02678379477, 21872.12511499554, 956.6412595276771, 980.7253968888723, 1015.1523477896039, 1024.4109636958628, 1026.461107918349, 10567.94716026415, 10940.43047244802, 11009.504572294267, 11022.50398732059, 11045.779084418427, 694322.0, 708112.0, 708229.0, 726473.0, 733958.0, 118894.21658675127, 133855.0, 140474.0, 147491.0, 150370.0, 988.4316518002178, 988.7577543501889, 1010.7422607235108, 1012.018342208057, 1013.0123129948241, 17808.0, 18245.4526364204, 18269.0, 18420.263189472807, 18445.446636600922, 47934.76032619815, 53268.73365633147, 53971.92056158934, 54228.0, 54459.72770136124, 80813.0, 84144.57927710323, 87002.6949595744, 88671.0, 89580.656290157, 6617.8014659560295, 7465.253474652492, 7755.844883102193, 7837.255460731221, 7914.960425197837, 10697.786044279226, 11911.3448760319, 12182.208156469802, 12202.450889709808, 12286.631401057983, 8631.870521942301, 10049.949750251202, 10082.54628541732, 10246.077852993267, 10448.0, 8767.386282960386, 10079.395236285847, 10339.431331276552, 10551.0, 10622.575096996034, 7499.737509187371, 10244.0, 10608.89391106079, 10653.680389588324, 10728.51721672511, 7588.59610971972, 7665.195154508696, 7666.808329791576, 7894.526328420313, 7925.643346049557, 7693.269139431745, 9475.905240947777, 10013.599456021677, 10096.545655445669, 10171.186305095722], "value": 9443.525823141441, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.452661672023, 1456.191813543483, 1466.1276540458423, 1491.343808724162, 1491.3810768531057, 7992.720254791084, 8417.032041315251, 8424.199701028409, 8436.240738333549, 8441.029281632615, 7460.6642701078445, 7673.539587624747, 7700.8459830803495, 8006.719764808233, 8223.958880205606, 2288.9198878039274, 2337.801286890616, 2344.9882750586307, 2350.059976009601, 2351.400392899808, 2329.440934175794, 2356.564035653401, 2370.4429459077105, 2371.7983971362455, 2373.264288070695, 2311.0, 2319.083961835074, 2326.5695846268495, 2360.9291721248305, 2362.4684445999596, 2300.217925905192, 2305.1586171047447, 2333.300009997011, 2335.521218150292, 2343.4610039690883, 2295.632698768189, 2352.7294361148515, 2358.13927916311, 2359.1035406545575, 2365.6924599801914, 8344.04043534989, 8417.410781245315, 8419.579021048923, 8444.662213511452, 8456.704015359433, 5012.248162775612, 5175.689458632456, 5176.870578235536, 5182.32629758129, 5197.246399272122, 3273.165342837561, 3373.308471763283, 3498.912527186815, 3549.591796943333, 3560.2701446203464, 1214.3867346989714, 1227.743425463758, 1233.2477188914754, 1234.5247079874223, 1278.9616311510576, 10722.892771072346, 10824.567017319298, 10825.83761243582, 10830.079443247334, 10834.945825270903, 4069.8197522718674, 4232.470941132358, 4588.197065513522, 4659.091477161921, 4675.672702910763, 9477.099675530813, 9480.95259523698, 9482.573284202228, 9484.810303793885, 9496.050394960448, 5091.643584949092, 5164.509371609691, 5165.1219292720325, 5168.2764412982215, 5171.2501687255135, 3851.9807400963377, 4224.5353011168745, 4613.930791038137, 4725.621950243973, 4734.905301893943, 3792.943105853414, 3820.331441997639, 3888.0, 3894.065424298148, 3937.310970580137, 1249.8187762774528, 1251.6120002799162, 1254.4006391850464, 1266.9429875655617, 1269.3335998600808, 884.9424787388799, 905.7101727447154, 910.7358865928807, 932.5570354081757, 934.6349577236057, 5341.839744807662, 5444.210295575611, 5545.916811247835, 5572.3034620672415, 5663.433656634386, 576.533008263308, 582.6416753696531, 585.7217821534737, 592.8073376152768, 600.6605270247372, 3683.9263214735556, 3702.407614781622, 3740.551133863954, 3741.869034583831, 3805.1438426353848, 9624.566894489764, 9936.105750482491, 10060.849087263698, 10070.748231294276, 10105.848412273821, 7839.33365663925, 9750.268729845147, 9756.0, 10039.146672532917, 10043.899561004442, 7697.846043079107, 7702.383809295355, 7785.922140778633, 7878.369730421553, 7888.526688398714, 5355.973220133875, 5375.81184658535, 5395.3525576931015, 5441.7551210196425, 5463.945360546344, 8829.779255518664, 8984.123658890623, 9203.217726493323, 9355.25157987373, 9378.343515953818, 9132.726018219464, 9292.535373231447, 9448.48033358172, 9461.95269023678, 9538.38000529991, 6652.101966234496, 6774.830629234309, 6863.553868998499, 7206.927930720625, 7347.889781653173, 8007.0391553014015, 8068.11250762404, 8137.145599711945, 8155.021397432346, 8155.306798922158, 7098.609576473344, 7264.237255088351, 7264.600446975256, 7296.452766042462, 7357.668904899399, 6995.265497122932, 7023.367896889305, 7049.154101507646, 7211.963940180265, 7214.206437291999, 6342.112104305309, 6463.450606698295, 6466.838329041811, 6468.288488266381, 6472.223333200046, 4911.877203069952, 4945.332380128781, 5014.473480284663, 5027.0, 5065.29085927963, 4871.3667223260745, 4963.925541116959, 5037.445880953019, 5092.083424983391, 5180.554930970862], "value": 4366.439902701975, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.40933314704296, 313.6330493322812, 356.9321390084894, 362.3568166504454, 373.61761482514703, 4107.815148318326, 4803.855884323476, 4896.485868983759, 4928.334674818899, 5017.42299635542, 4332.350147477872, 4884.365032545764, 4948.430930443, 4953.702777833332, 5071.873203169923, 3553.5202747629064, 4056.452378928851, 4071.5928407159195, 4074.327735923569, 4076.0421300994244, 3637.909052273701, 3974.682025437958, 4026.3356546169994, 4089.26393249215, 4093.8157782899693, 3401.812900290483, 3694.408894576868, 3998.8805932855635, 4071.4707088078508, 4116.876493705194, 3042.9045543604507, 3812.684623804783, 4009.7594144351433, 4023.275810354135, 4095.6313931746135, 3069.754419646423, 3614.34941710492, 3617.602063772983, 3619.8597441805746, 3622.590977000292, 4827.782749776268, 4846.369971903665, 5059.507445303644, 5085.618578606583, 5119.795208191668, 4613.238815595423, 4624.913145410826, 4642.79107440166, 4692.202325604621, 4713.505081966378, 5222.0678349011105, 5402.594805389572, 5407.729613519308, 5445.9727701361635, 5530.198121272393, 3293.818839963801, 3482.077249528877, 3516.5955915069585, 3865.8067096645054, 4004.2592120457807, 4839.685420447695, 5051.292819005343, 5482.930828488486, 5580.972095139539, 5748.367679555287, 3443.810590417551, 3946.5264168299987, 4074.8777536673947, 4084.387341898739, 4097.467329247238, 3615.584207816135, 3662.4323229898873, 4075.673946084306, 4167.854125105607, 4190.28765109932, 3422.880199193066, 3844.3272427325105, 4220.472440944882, 4270.679699022524, 4496.887577810516, 5488.91766623501, 5512.283403157564, 5531.972340138354, 5541.750621222055, 5548.334199896039, 1079.266099052636, 1148.4544841200363, 1175.3887978251262, 1252.634628255188, 1259.8866102050858, 770.7495064104188, 786.1902240692096, 791.8636756254792, 817.7097130518699, 836.93304535637, 4289.67827412939, 4591.586757191869, 4724.929126063112, 4936.408385597519, 5073.264376665363, 4327.82688692455, 5422.0, 5444.700541470178, 5495.862603434866, 5501.78960628661, 4824.469308376076, 4838.685500432215, 4890.413150421972, 4988.301637770715, 5066.949330506648, 2568.678915135608, 2698.6371882199364, 2785.6796468405987, 2801.9265743350184, 2809.3678922242334, 4893.559579637849, 5068.477408201265, 5569.860753481114, 5614.24207731951, 5618.97190514053, 4548.95451045492, 4705.0, 4991.401031876198, 5146.202338637517, 5370.838874833761, 4709.858704238878, 5043.5460808527405, 5226.45122262157, 5484.270695926808, 5683.9715801420725, 4488.438945131858, 4776.689515181502, 5086.923696144635, 5135.301504444478, 5191.22131680251, 4644.814207431665, 5014.598832093497, 5276.868078298074, 5292.761825717929, 5302.867428314169, 4698.812047518061, 5616.185653080199, 5629.986602411605, 5642.971785141048, 5661.85845353853, 2901.4632293025857, 3351.815650139168, 3426.623071462187, 3485.919364996758, 3529.347070791912, 5135.17701216063, 5535.225068490495, 5561.721913904369, 5593.594754255547, 5626.0, 4774.092922344882, 5207.27098206259, 5390.460953904735, 5410.648307859977, 5418.970395624819, 4332.935005974849, 4569.794359253775, 5069.188929771219, 5370.650907690988, 5396.7571459283645, 5034.59723222134, 5203.531682148625, 5268.920966185587, 5279.0, 5352.785888564569, 5188.558972487381, 5295.2403793307185, 5364.049772625119, 5376.247325374373, 5397.326828683121, 4850.005748821412, 5000.874453466583, 5189.455107213839, 5305.1776974569, 5309.628326017141], "value": 3914.8949283636466, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.7048898484667, 739.1499775258449, 776.9184235655256, 809.8096947217407, 816.2123550773505, 14334.283285835692, 14876.404943802236, 15404.0, 15993.840061599394, 16001.67996640068, 14637.487687930925, 14788.778168327484, 14796.778048329285, 14804.481843135465, 14806.25968701566, 684.2268236892305, 706.5654622407234, 707.5683832861951, 849.2441726863096, 861.1173547114196, 867.9001914779786, 870.4603146049458, 874.9825003499926, 880.4761167105562, 881.1056777370974, 893.8793262909489, 893.8837951066384, 910.026271889079, 932.6689025395989, 937.2595649436937, 928.9489078100702, 929.6839074714629, 929.8000929800091, 930.093159169804, 930.939488933224, 537.3444397834636, 553.2310088976326, 675.9594424334556, 692.536000879407, 698.671624336561, 14964.700705985928, 14999.775003374958, 15013.873959452976, 15021.0, 15025.849741502663, 13438.0, 13611.795823062663, 13674.863251367458, 13739.862601373958, 13752.381142848595, 12508.49966001368, 12519.874801251963, 12529.561465348668, 12795.360231988363, 12939.87060129396, 4289.4852617685765, 4547.749873756942, 4591.4260717410325, 4604.447466304065, 4608.216603177468, 106866.46566767195, 109887.90112098856, 112059.0, 113577.43211283891, 113893.4305328468, 10346.0, 10992.340459572451, 11023.850349181832, 11054.557817687364, 11261.380624065756, 19889.900550497154, 21717.782822171892, 21733.67399489009, 21785.019674114705, 21786.34640960742, 7511.286427789351, 7748.535087894745, 7753.147153813076, 7813.453058285979, 7835.529868207926, 4225.19721252961, 4266.722663026893, 4333.0, 4430.136123455895, 4431.534688857623, 3400.1159698478573, 3499.090236538518, 3502.2995400919917, 3504.684578387957, 3509.894703158909, 616.1435604509735, 620.2494981072862, 621.1521273461692, 636.5575924732267, 638.4828289085856, 622.862970146567, 629.3171908479351, 656.5043392238829, 663.2505269046044, 664.7725293699118, 9618.374805637612, 9622.855657165148, 9660.71017869465, 9678.70963871085, 9713.90286097144, 620.6245221640933, 631.4443289904855, 641.131267133028, 651.9804405867832, 659.4164164714263, 4627.167109920179, 4684.625229981593, 4695.5304469552775, 4697.78859951303, 4720.669553131248, 81903.5904820472, 86848.26303473895, 88121.23757524813, 90661.54669226611, 109812.0, 77052.0, 83368.16422850464, 83522.58238708768, 87987.0, 90480.71347157443, 77896.83154752683, 78825.0, 79791.0, 79915.80126298226, 80783.19216807757, 10690.037896589345, 10849.728756781144, 10972.451377430936, 10980.066694330751, 11116.555337786398, 47442.76278618585, 47722.52277477181, 48313.27530087122, 48357.03285934191, 50186.498135018184, 45947.540524594326, 62787.68606157123, 64678.353216467236, 65439.69120617656, 66217.0, 11568.421578921188, 11581.247218930743, 11594.304341739522, 11609.187356885275, 11639.359835209145, 12298.446569904554, 14283.943578174885, 15036.473723419627, 15123.0, 15343.38626454974, 13669.43711740415, 14056.0, 14092.859071409155, 14177.929110354382, 14217.21805300677, 13897.235652039235, 14063.789043164565, 14074.78887816704, 14292.928535357256, 14457.493987710379, 13409.262490562722, 13715.083102838284, 13720.039597228497, 13807.930960345135, 13840.653983650489, 11191.0, 11397.316161030365, 11754.941225293818, 11875.259293322575, 11963.222390544586, 10997.945010274898, 11282.153838462313, 11320.320780753182, 11438.695045879029, 11468.197226194086], "value": 7494.766350161399, "unit": "score"}], "name": "dromaeo_css", "value": 7189.007057415789, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 111.0, 112.0, 111.0, 112.0, 111.0, 113.0, 111.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 112.0, 110.0, 149.0, 111.0, 110.0, 111.0, 110.0, 132.0, 107.0], "value": 120.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 184.0, 183.0, 183.0, 185.0, 179.0, 181.0, 182.0, 184.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 59.0, 88.0, 59.0, 59.0, 58.0, 58.0, 75.0, 59.0], "value": 65.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 86.0, 69.0, 69.0, 69.0, 82.0, 68.0, 68.0, 83.0], "value": 75.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 87.0, 83.0, 87.0, 84.0, 88.0, 84.0, 88.0, 86.0], "value": 85.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 97.0, 97.0, 96.0, 97.0, 97.0, 97.0, 96.0], "value": 96.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 96.0, 141.0, 84.0, 86.0, 85.0, 88.0, 86.0, 85.0, 85.0], "value": 92.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 57.0, 55.0, 59.0, 56.0, 56.0, 56.0, 56.0, 55.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 82.0, 74.0, 74.0, 72.0, 71.0, 70.0, 72.0, 70.0, 72.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 85.0, 88.0, 88.0, 87.0, 84.0, 89.0, 89.0, 91.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 141.0, 140.0, 142.0, 141.0, 142.0, 146.0, 158.0, 205.0, 153.0], "value": 150.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 173.0, 173.0, 206.0, 238.0, 171.0, 173.0, 173.0, 182.0, 237.0], "value": 189.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 65.0, 65.0, 67.0, 67.0, 66.0, 65.0, 66.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1453.6000000000001, "alertThreshold": 2.0}]} 08:12:51 INFO - Return code: 0 08:12:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:12:52 ERROR - # TBPL SUCCESS # 08:12:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:12:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:12:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:12:52 INFO - 2017-01-17 08:12:52.034 screenresolution[1940:21862] starting screenresolution argv=screenresolution get 08:12:52 INFO - 2017-01-17 08:12:52.036 screenresolution[1940:21862] Display 0: 1600x1200x32@60 08:12:52 INFO - 2017-01-17 08:12:52.043 screenresolution[1941:21865] starting screenresolution argv=screenresolution list 08:12:52 INFO - Available Modes on Display 0 08:12:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:12:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:12:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:12:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:12:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:12:52 INFO - Intel Iris: 08:12:52 INFO - Chipset Model: Intel Iris 08:12:52 INFO - Type: GPU 08:12:52 INFO - Bus: Built-In 08:12:52 INFO - VRAM (Dynamic, Max): 1536 MB 08:12:52 INFO - Vendor: Intel (0x8086) 08:12:52 INFO - Device ID: 0x0a2e 08:12:52 INFO - Revision ID: 0x0009 08:12:52 INFO - Displays: 08:12:52 INFO - Display: 08:12:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:12:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:12:52 INFO - Display Serial Number: 1600x1200 60 08:12:52 INFO - Main Display: Yes 08:12:52 INFO - Mirror: Off 08:12:52 INFO - Online: Yes 08:12:52 INFO - Rotation: Supported 08:12:52 INFO - Return code: 0 08:12:52 INFO - Running post-action listener: _resource_record_post_action 08:12:52 INFO - [mozharness: 2017-01-17 16:12:52.296692Z] Finished run-tests step (success) 08:12:52 INFO - Running post-run listener: _resource_record_post_run 08:12:52 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 401408; Write bytes: 552140288; Read time: 6; Write time: 1666 08:12:52 INFO - TinderboxPrint: CPU usage
53.7% 08:12:52 INFO - TinderboxPrint: I/O read bytes / time
401,408 / 6 08:12:52 INFO - TinderboxPrint: I/O write bytes / time
552,140,288 / 1,666 08:12:52 INFO - TinderboxPrint: CPU idle
2,227.8 (46.3%) 08:12:52 INFO - TinderboxPrint: CPU system
961.0 (20.0%) 08:12:52 INFO - TinderboxPrint: CPU user
1,621.0 (33.7%) 08:12:52 INFO - TinderboxPrint: Swap in / out
252,760,064 / 0 08:12:52 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 245905920; Write bytes: 241579520; Read time: 17926; Write time: 549 08:12:52 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 401408; Write bytes: 294844416; Read time: 6; Write time: 1077 08:12:52 INFO - Running post-run listener: _upload_blobber_files 08:12:52 INFO - Blob upload gear active. 08:12:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:12:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:12:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:12:53 INFO - (blobuploader) - INFO - Open directory for files ... 08:12:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:12:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:12:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:54 INFO - (blobuploader) - INFO - Done attempting. 08:12:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:12:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:12:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:55 INFO - (blobuploader) - INFO - Done attempting. 08:12:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:12:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:12:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:56 INFO - (blobuploader) - INFO - Done attempting. 08:12:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:12:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:12:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:58 INFO - (blobuploader) - INFO - Done attempting. 08:12:58 INFO - (blobuploader) - INFO - Iteration through files over. 08:12:58 INFO - Return code: 0 08:12:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:12:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:12:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8f7bb2092c81f39392327b0efcd09d140800bbb85295b1bca194094237f80bbfeb5744b007d58a0820320cf0aa036e6e520186e221c0c779e98f3730d2fc0ea1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7c2d962e9cf21b01155642911a8b8b0066e76f68c8540759ca9929be51d484806ded357a702bce4c9a95fbc8b5b6591058e12855360b49c4ceb414e850a9d298", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4e793380e6982a83017605052402924e75e55929c9c0640e264c1e843543a789e58d29f4c5b771159302b84ee62ec0b44101e8894cba1d60062f34a1641bbb75", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5e6e5ebf69dc94d4d836f8fbd25b49729f69db5bac44714344d0af30ae93b79e2b8976d803740c51907e6e6ebc4173a5b55b1c680b5fd151d4584352f4d795b4"} 08:12:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:12:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:12:58 INFO - Contents: 08:12:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8f7bb2092c81f39392327b0efcd09d140800bbb85295b1bca194094237f80bbfeb5744b007d58a0820320cf0aa036e6e520186e221c0c779e98f3730d2fc0ea1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7c2d962e9cf21b01155642911a8b8b0066e76f68c8540759ca9929be51d484806ded357a702bce4c9a95fbc8b5b6591058e12855360b49c4ceb414e850a9d298", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4e793380e6982a83017605052402924e75e55929c9c0640e264c1e843543a789e58d29f4c5b771159302b84ee62ec0b44101e8894cba1d60062f34a1641bbb75", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5e6e5ebf69dc94d4d836f8fbd25b49729f69db5bac44714344d0af30ae93b79e2b8976d803740c51907e6e6ebc4173a5b55b1c680b5fd151d4584352f4d795b4"} 08:12:58 INFO - Running post-run listener: copy_logs_to_upload_dir 08:12:58 INFO - Copying logs to upload dir... 08:12:58 INFO - mkdir: /builds/slave/test/build/upload/logs 08:12:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.585413 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-17 08:12:58.818015) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 08:12:58.822026) ========= 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.Jzh1m6M4R6/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.PJRz6Ug4EV/Listeners TMPDIR=/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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/8f7bb2092c81f39392327b0efcd09d140800bbb85295b1bca194094237f80bbfeb5744b007d58a0820320cf0aa036e6e520186e221c0c779e98f3730d2fc0ea1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7c2d962e9cf21b01155642911a8b8b0066e76f68c8540759ca9929be51d484806ded357a702bce4c9a95fbc8b5b6591058e12855360b49c4ceb414e850a9d298", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4e793380e6982a83017605052402924e75e55929c9c0640e264c1e843543a789e58d29f4c5b771159302b84ee62ec0b44101e8894cba1d60062f34a1641bbb75", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5e6e5ebf69dc94d4d836f8fbd25b49729f69db5bac44714344d0af30ae93b79e2b8976d803740c51907e6e6ebc4173a5b55b1c680b5fd151d4584352f4d795b4"} build_url:https://queue.taskcluster.net/v1/task/da6ZwgDjRv-bTs8GIH_wGQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/da6ZwgDjRv-bTs8GIH_wGQ/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/8f7bb2092c81f39392327b0efcd09d140800bbb85295b1bca194094237f80bbfeb5744b007d58a0820320cf0aa036e6e520186e221c0c779e98f3730d2fc0ea1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7c2d962e9cf21b01155642911a8b8b0066e76f68c8540759ca9929be51d484806ded357a702bce4c9a95fbc8b5b6591058e12855360b49c4ceb414e850a9d298", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4e793380e6982a83017605052402924e75e55929c9c0640e264c1e843543a789e58d29f4c5b771159302b84ee62ec0b44101e8894cba1d60062f34a1641bbb75", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5e6e5ebf69dc94d4d836f8fbd25b49729f69db5bac44714344d0af30ae93b79e2b8976d803740c51907e6e6ebc4173a5b55b1c680b5fd151d4584352f4d795b4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 08:12:58.855626) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 08:12:58.855937) ========= 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.Jzh1m6M4R6/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.PJRz6Ug4EV/Listeners TMPDIR=/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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.004498 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 08:12:58.904336) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 08:12:58.904882) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 08:12:58.905585) ========= ========= Total master_lag: 0.20 =========