builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0284 starttime: 1477485443.8 results: success (0) buildid: 20161025185822 builduid: 597bb44274da41c9a5d57fe3793b73d1 revision: b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 05:37:23.804428) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 05:37:23.804975) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 05:37:23.805258) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 05:37:23.918710) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 05:37:23.919008) ========= 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.Z9qKcDLj23/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.xvCn07FoJx/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-26 05:37:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 48.6M=0s 2016-10-26 05:37:24 (48.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141450 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 05:37:24.084956) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 05:37:24.085370) ========= 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.Z9qKcDLj23/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.xvCn07FoJx/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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.024666 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 05:37:24.134898) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-26 05:37:24.135324) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z9qKcDLj23/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.xvCn07FoJx/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-26 05:37:24,219 truncating revision to first 12 chars 2016-10-26 05:37:24,219 Setting DEBUG logging. 2016-10-26 05:37:24,219 attempt 1/10 2016-10-26 05:37:24,219 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b1b18f25c0ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 05:37:25,784 unpacking tar archive at: fx-team-b1b18f25c0ea/testing/mozharness/ program finished with exit code 0 elapsedTime=2.000248 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-26 05:37:26.158389) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 05:37:26.158705) ========= script_repo_revision: b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 05:37:26.159107) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 05:37:26.159378) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 05:37:26.177048) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-26 05:37:26.177390) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z9qKcDLj23/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.xvCn07FoJx/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 05:37:26 INFO - MultiFileLogger online at 20161026 05:37:26 in /builds/slave/test 05:37:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:37:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:37:26 INFO - {'append_to_log': False, 05:37:26 INFO - 'base_work_dir': '/builds/slave/test', 05:37:26 INFO - 'blob_upload_branch': 'Fx-Team', 05:37:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:37:26 INFO - 'branch': 'Fx-Team', 05:37:26 INFO - 'buildbot_json_path': 'buildprops.json', 05:37:26 INFO - 'config_files': ('talos/mac_config.py',), 05:37:26 INFO - 'default_actions': ('clobber', 05:37:26 INFO - 'read-buildbot-config', 05:37:26 INFO - 'download-and-extract', 05:37:26 INFO - 'populate-webroot', 05:37:26 INFO - 'create-virtualenv', 05:37:26 INFO - 'install', 05:37:26 INFO - 'run-tests'), 05:37:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:37:26 INFO - 'download_minidump_stackwalk': True, 05:37:26 INFO - 'download_symbols': 'ondemand', 05:37:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:37:26 INFO - 'tooltool.py': '/tools/tooltool.py', 05:37:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:37:26 INFO - '/tools/misc-python/virtualenv.py')}, 05:37:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:37:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:37:26 INFO - 'installer_path': 'installer.exe', 05:37:26 INFO - 'log_level': 'info', 05:37:26 INFO - 'log_name': 'talos', 05:37:26 INFO - 'log_to_console': True, 05:37:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:37:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:37:26 INFO - 'opt_config_files': (), 05:37:26 INFO - 'pip_index': False, 05:37:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:37:26 INFO - 'cmd': ('bash', 05:37:26 INFO - '-c', 05:37:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:37:26 INFO - 'enabled': True, 05:37:26 INFO - 'halt_on_failure': False, 05:37:26 INFO - 'name': 'check_screen_resolution'},), 05:37:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:37:26 INFO - 'cmd': ('bash', 05:37:26 INFO - '-c', 05:37:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:37:26 INFO - 'enabled': True, 05:37:26 INFO - 'halt_on_failure': False, 05:37:26 INFO - 'name': 'check_screen_resolution'},), 05:37:26 INFO - 'run_cmd_checks_enabled': True, 05:37:26 INFO - 'sps_profile': False, 05:37:26 INFO - 'sps_profile_interval': 0, 05:37:26 INFO - 'suite': 'dromaeojs', 05:37:26 INFO - 'system_bits': '32', 05:37:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:37:26 INFO - 'title': 't-yosemite-r7-0284', 05:37:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:37:26 INFO - 'use_talos_json': True, 05:37:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:37:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:37:26 INFO - 'work_dir': 'build'} 05:37:26 INFO - [mozharness: 2016-10-26 12:37:26.388899Z] Running clobber step. 05:37:26 INFO - Running pre-action listener: _resource_record_pre_action 05:37:26 INFO - Running main action method: clobber 05:37:26 INFO - rmtree: /builds/slave/test/build 05:37:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:37:28 INFO - Running post-action listener: _resource_record_post_action 05:37:28 INFO - [mozharness: 2016-10-26 12:37:28.503959Z] Finished clobber step (success) 05:37:28 INFO - [mozharness: 2016-10-26 12:37:28.504198Z] Running read-buildbot-config step. 05:37:28 INFO - Running pre-action listener: _resource_record_pre_action 05:37:28 INFO - Running main action method: read_buildbot_config 05:37:28 INFO - Using buildbot properties: 05:37:28 INFO - { 05:37:28 INFO - "project": "", 05:37:28 INFO - "product": "firefox", 05:37:28 INFO - "script_repo_revision": "production", 05:37:28 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 05:37:28 INFO - "repository": "", 05:37:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 05:37:28 INFO - "buildid": "20161025185822", 05:37:28 INFO - "pgo_build": "False", 05:37:28 INFO - "basedir": "/builds/slave/test", 05:37:28 INFO - "buildnumber": 26, 05:37:28 INFO - "slavename": "t-yosemite-r7-0284", 05:37:28 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 05:37:28 INFO - "platform": "yosemite_r7", 05:37:28 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:37:28 INFO - "branch": "fx-team", 05:37:28 INFO - "repo_path": "integration/fx-team", 05:37:28 INFO - "revision": "b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1", 05:37:28 INFO - "stage_platform": "macosx64", 05:37:28 INFO - "builduid": "597bb44274da41c9a5d57fe3793b73d1", 05:37:28 INFO - "slavebuilddir": "test" 05:37:28 INFO - } 05:37:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ti88ZL1iQmeBR1QqwBzmMA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:37:28 INFO - Running post-action listener: _resource_record_post_action 05:37:28 INFO - [mozharness: 2016-10-26 12:37:28.512240Z] Finished read-buildbot-config step (success) 05:37:28 INFO - [mozharness: 2016-10-26 12:37:28.512457Z] Running download-and-extract step. 05:37:28 INFO - Running pre-action listener: _resource_record_pre_action 05:37:28 INFO - Running main action method: download_and_extract 05:37:28 INFO - mkdir: /builds/slave/test/build/tests 05:37:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:28 INFO - trying https://queue.taskcluster.net/v1/task/Ti88ZL1iQmeBR1QqwBzmMA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:37:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Ti88ZL1iQmeBR1QqwBzmMA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:37:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ti88ZL1iQmeBR1QqwBzmMA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 05:37:30 INFO - Downloaded 1199 bytes. 05:37:30 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:37:30 INFO - Using the following test package requirements: 05:37:30 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:37:30 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:37:30 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:37:30 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:37:30 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:37:30 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:37:30 INFO - u'jsshell-mac.zip'], 05:37:30 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:37:30 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:37:30 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:37:30 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:37:30 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:37:30 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:37:30 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:37:30 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:37:30 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:37:30 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:37:30 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:37:30 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:37:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ti88ZL1iQmeBR1QqwBzmMA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:37:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ti88ZL1iQmeBR1QqwBzmMA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:37:30 INFO - Fetch https://queue.taskcluster.net/v1/task/Ti88ZL1iQmeBR1QqwBzmMA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:37:30 INFO - Http code: 200 05:37:30 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 05:37:30 INFO - x-amz-cf-id: 1s51MxDtpcnCYTiS2fC_xtu68a1C8cRMIZXN5RkDTBb09mt6DYRUDA== 05:37:30 INFO - x-amz-version-id: m0xOcBGqqv0MOgpPsX9fI9CpxiTvSkOZ 05:37:30 INFO - Expected file size: 16423362 05:37:30 INFO - Obtained file size: 16423362 05:37:37 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:37:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ti88ZL1iQmeBR1QqwBzmMA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:37:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ti88ZL1iQmeBR1QqwBzmMA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:37:37 INFO - Fetch https://queue.taskcluster.net/v1/task/Ti88ZL1iQmeBR1QqwBzmMA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:37:38 INFO - Http code: 200 05:37:38 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 05:37:38 INFO - x-amz-cf-id: 41429QWzKQJUCP47BEZu2G7iE2YM87bNPwT0KcAIu-sK1Ol_5an33Q== 05:37:38 INFO - x-amz-version-id: m0xOcBGqqv0MOgpPsX9fI9CpxiTvSkOZ 05:37:38 INFO - Expected file size: 16423362 05:37:38 INFO - Obtained file size: 16423362 05:37:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ti88ZL1iQmeBR1QqwBzmMA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:37:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ti88ZL1iQmeBR1QqwBzmMA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:37:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Ti88ZL1iQmeBR1QqwBzmMA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:37:45 INFO - Http code: 200 05:37:45 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 05:37:45 INFO - x-amz-cf-id: BtlYCXjesdTTvsBKJCrPFNZbt4d4UJq8_0gt-Wn0gxcA-CPYShFUBQ== 05:37:45 INFO - x-amz-version-id: BBSq4.5gYhV_V2QsJwf74wEF2YXjLqJo 05:37:45 INFO - Expected file size: 14409028 05:37:45 INFO - Obtained file size: 14409028 05:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:45 INFO - trying https://queue.taskcluster.net/v1/task/Ti88ZL1iQmeBR1QqwBzmMA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:37:45 INFO - Downloading https://queue.taskcluster.net/v1/task/Ti88ZL1iQmeBR1QqwBzmMA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:37:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ti88ZL1iQmeBR1QqwBzmMA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 05:37:48 INFO - Downloaded 111194726 bytes. 05:37:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ti88ZL1iQmeBR1QqwBzmMA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:37:48 INFO - mkdir: /builds/slave/test/properties 05:37:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:37:48 INFO - Writing to file /builds/slave/test/properties/build_url 05:37:48 INFO - Contents: 05:37:48 INFO - build_url:https://queue.taskcluster.net/v1/task/Ti88ZL1iQmeBR1QqwBzmMA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:37:49 INFO - Running post-action listener: _resource_record_post_action 05:37:49 INFO - Running post-action listener: set_extra_try_arguments 05:37:49 INFO - [mozharness: 2016-10-26 12:37:49.980629Z] Finished download-and-extract step (success) 05:37:49 INFO - [mozharness: 2016-10-26 12:37:49.980768Z] Running populate-webroot step. 05:37:49 INFO - Running pre-action listener: _resource_record_pre_action 05:37:49 INFO - Running main action method: populate_webroot 05:37:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:37:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:37:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:37:49 INFO - '--tppagecycles', 05:37:49 INFO - '7'], 05:37:49 INFO - 'tests': ['tsvgm']}}, 05:37:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:37:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:37:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:37:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:37:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:37:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:37:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:49 INFO - 'talos_options': ['--disable-e10s'], 05:37:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:49 INFO - 'talos_options': ['--disable-e10s'], 05:37:49 INFO - 'tests': ['damp', 'tps']}, 05:37:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:49 INFO - 'tests': ['damp', 'tps']}, 05:37:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:37:49 INFO - 'tests': ['dromaeo_dom']}, 05:37:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:37:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:37:49 INFO - 'tests': ['basic_compositor_video']}, 05:37:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:37:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:37:49 INFO - 'tests': ['a11yr', 05:37:49 INFO - 'ts_paint', 05:37:49 INFO - 'tpaint', 05:37:49 INFO - 'sessionrestore', 05:37:49 INFO - 'sessionrestore_no_auto_restore', 05:37:49 INFO - 'tabpaint']}, 05:37:49 INFO - 'other-e10s': {'tests': ['a11yr', 05:37:49 INFO - 'ts_paint', 05:37:49 INFO - 'tpaint', 05:37:49 INFO - 'sessionrestore', 05:37:49 INFO - 'sessionrestore_no_auto_restore', 05:37:49 INFO - 'tabpaint']}, 05:37:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:37:49 INFO - 'ts_paint', 05:37:49 INFO - 'tpaint', 05:37:49 INFO - 'sessionrestore', 05:37:49 INFO - 'sessionrestore_no_auto_restore', 05:37:49 INFO - 'tabpaint']}, 05:37:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:37:49 INFO - 'ts_paint', 05:37:49 INFO - 'tpaint', 05:37:49 INFO - 'sessionrestore', 05:37:49 INFO - 'sessionrestore_no_auto_restore', 05:37:49 INFO - 'tabpaint']}, 05:37:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:37:49 INFO - 'tests': ['a11yr', 05:37:49 INFO - 'ts_paint', 05:37:49 INFO - 'tpaint', 05:37:49 INFO - 'sessionrestore', 05:37:49 INFO - 'sessionrestore_no_auto_restore', 05:37:49 INFO - 'tabpaint']}, 05:37:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:37:49 INFO - 'tests': ['a11yr', 05:37:49 INFO - 'ts_paint', 05:37:49 INFO - 'tpaint', 05:37:49 INFO - 'sessionrestore', 05:37:49 INFO - 'sessionrestore_no_auto_restore', 05:37:49 INFO - 'tabpaint']}, 05:37:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:37:49 INFO - 'tests': ['tsvgx', 05:37:49 INFO - 'tsvgr_opacity', 05:37:49 INFO - 'tart', 05:37:49 INFO - 'tscrollx', 05:37:49 INFO - 'cart']}, 05:37:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:37:49 INFO - 'tsvgr_opacity', 05:37:49 INFO - 'tart', 05:37:49 INFO - 'tscrollx', 05:37:49 INFO - 'cart']}, 05:37:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:49 INFO - 'talos_options': ['--disable-e10s'], 05:37:49 INFO - 'tests': ['tp5o']}, 05:37:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:49 INFO - 'tests': ['tp5o']}, 05:37:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:49 INFO - 'talos_options': ['--disable-e10s', 05:37:49 INFO - '--xperf_path', 05:37:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:49 INFO - 'tests': ['tp5n']}, 05:37:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:49 INFO - 'talos_options': ['--xperf_path', 05:37:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:49 INFO - 'tests': ['tp5n']}}, 05:37:49 INFO - 'talos.zip': {'path': '', 05:37:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:37:49 INFO - Running post-action listener: _resource_record_post_action 05:37:49 INFO - [mozharness: 2016-10-26 12:37:49.999180Z] Finished populate-webroot step (success) 05:37:49 INFO - [mozharness: 2016-10-26 12:37:49.999320Z] Running create-virtualenv step. 05:37:49 INFO - Running pre-action listener: _resource_record_pre_action 05:37:49 INFO - Running main action method: create_virtualenv 05:37:49 INFO - Creating virtualenv /builds/slave/test/build/venv 05:37:49 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 05:37:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:37:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:37:50 INFO - Using real prefix '/tools/python27' 05:37:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:37:50 INFO - Installing distribute.............................................................................................................................................................................................done. 05:37:53 INFO - Installing pip.................done. 05:37:53 INFO - Return code: 0 05:37:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:37:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:37:54 INFO - Reading from file tmpfile_stdout 05:37:54 INFO - Output received: 05:37:54 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) 05:37:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:37:54 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')]} 05:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:54 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')]} 05:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:54 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 0x1079f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10796a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed19d35a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107808d30>, '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 0x10762edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107800b20>, '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.Z9qKcDLj23/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.xvCn07FoJx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 05:37:54 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 05:37:54 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 05:37:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9qKcDLj23/Render', 05:37:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:54 INFO - 'HOME': '/Users/cltbld', 05:37:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:54 INFO - 'LOGNAME': 'cltbld', 05:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:54 INFO - 'MOZ_NO_REMOTE': '1', 05:37:54 INFO - 'NO_EM_RESTART': '1', 05:37:54 INFO - 'PAGER': '/bin/cat', 05:37:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:54 INFO - 'PWD': '/builds/slave/test', 05:37:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:54 INFO - 'SHELL': '/bin/bash', 05:37:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xvCn07FoJx/Listeners', 05:37:54 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 05:37:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:54 INFO - 'USER': 'cltbld', 05:37:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:54 INFO - 'XPC_FLAGS': '0x0', 05:37:54 INFO - 'XPC_SERVICE_NAME': '0', 05:37:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:54 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 05:37:54 INFO - Cleaning up... 05:37:54 INFO - Return code: 0 05:37:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:37:54 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')]} 05:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:54 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')]} 05:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:54 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 0x1079f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10796a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed19d35a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107808d30>, '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 0x10762edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107800b20>, '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.Z9qKcDLj23/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.xvCn07FoJx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 05:37:54 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 05:37:54 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 05:37:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9qKcDLj23/Render', 05:37:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:54 INFO - 'HOME': '/Users/cltbld', 05:37:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:54 INFO - 'LOGNAME': 'cltbld', 05:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:54 INFO - 'MOZ_NO_REMOTE': '1', 05:37:54 INFO - 'NO_EM_RESTART': '1', 05:37:54 INFO - 'PAGER': '/bin/cat', 05:37:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:54 INFO - 'PWD': '/builds/slave/test', 05:37:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:54 INFO - 'SHELL': '/bin/bash', 05:37:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xvCn07FoJx/Listeners', 05:37:54 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 05:37:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:54 INFO - 'USER': 'cltbld', 05:37:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:54 INFO - 'XPC_FLAGS': '0x0', 05:37:54 INFO - 'XPC_SERVICE_NAME': '0', 05:37:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:54 INFO - Downloading/unpacking psutil>=3.1.1 05:37:54 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 05:37:54 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 05:37:54 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 05:37:54 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 05:37:54 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 05:37:54 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 05:37:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:37:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:58 INFO - Installing collected packages: psutil 05:37:58 INFO - Running setup.py install for psutil 05:37:58 INFO - building 'psutil._psutil_osx' extension 05:37:58 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 05:37:59 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 05:37:59 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 05:37:59 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 05:37:59 INFO - building 'psutil._psutil_posix' extension 05:37:59 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 05:37:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:37:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:37:59 INFO - ^ 05:37:59 INFO - 1 warning generated. 05:37:59 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 05:37:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:59 INFO - Successfully installed psutil 05:37:59 INFO - Cleaning up... 05:37:59 INFO - Return code: 0 05:37:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1079f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10796a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed19d35a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107808d30>, '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 0x10762edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107800b20>, '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.Z9qKcDLj23/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.xvCn07FoJx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 05:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:37:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9qKcDLj23/Render', 05:37:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:59 INFO - 'HOME': '/Users/cltbld', 05:37:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:59 INFO - 'LOGNAME': 'cltbld', 05:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:59 INFO - 'MOZ_NO_REMOTE': '1', 05:37:59 INFO - 'NO_EM_RESTART': '1', 05:37:59 INFO - 'PAGER': '/bin/cat', 05:37:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:59 INFO - 'PWD': '/builds/slave/test', 05:37:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:59 INFO - 'SHELL': '/bin/bash', 05:37:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xvCn07FoJx/Listeners', 05:37:59 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 05:37:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:59 INFO - 'USER': 'cltbld', 05:37:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:59 INFO - 'XPC_FLAGS': '0x0', 05:37:59 INFO - 'XPC_SERVICE_NAME': '0', 05:37:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:38:00 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 05:38:00 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 05:38:00 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 05:38:00 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 05:38:00 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 05:38:00 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 05:38:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:38:02 INFO - Installing collected packages: mozsystemmonitor 05:38:02 INFO - Running setup.py install for mozsystemmonitor 05:38:02 INFO - Successfully installed mozsystemmonitor 05:38:02 INFO - Cleaning up... 05:38:02 INFO - Return code: 0 05:38:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:38:02 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')]} 05:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:02 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')]} 05:38:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:02 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 0x1079f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10796a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed19d35a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107808d30>, '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 0x10762edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107800b20>, '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.Z9qKcDLj23/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.xvCn07FoJx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 05:38:02 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 05:38:02 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 05:38:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9qKcDLj23/Render', 05:38:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:02 INFO - 'HOME': '/Users/cltbld', 05:38:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:02 INFO - 'LOGNAME': 'cltbld', 05:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:02 INFO - 'MOZ_NO_REMOTE': '1', 05:38:02 INFO - 'NO_EM_RESTART': '1', 05:38:02 INFO - 'PAGER': '/bin/cat', 05:38:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:02 INFO - 'PWD': '/builds/slave/test', 05:38:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:02 INFO - 'SHELL': '/bin/bash', 05:38:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xvCn07FoJx/Listeners', 05:38:02 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 05:38:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:02 INFO - 'USER': 'cltbld', 05:38:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:02 INFO - 'XPC_FLAGS': '0x0', 05:38:02 INFO - 'XPC_SERVICE_NAME': '0', 05:38:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:03 INFO - Downloading/unpacking jsonschema==2.5.1 05:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:38:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:38:05 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 05:38:05 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 05:38:05 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 05:38:05 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 05:38:05 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 05:38:05 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 05:38:06 INFO - Downloading functools32-3.2.3-2.tar.gz 05:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:38:06 INFO - warning: no files found matching '*.txt' 05:38:06 INFO - no previously-included directories found matching 'build' 05:38:06 INFO - no previously-included directories found matching 'dist' 05:38:06 INFO - no previously-included directories found matching '.git*' 05:38:06 INFO - Installing collected packages: jsonschema, functools32 05:38:06 INFO - Running setup.py install for functools32 05:38:06 INFO - warning: no files found matching '*.txt' 05:38:06 INFO - no previously-included directories found matching 'build' 05:38:06 INFO - no previously-included directories found matching 'dist' 05:38:06 INFO - no previously-included directories found matching '.git*' 05:38:06 INFO - Successfully installed jsonschema functools32 05:38:06 INFO - Cleaning up... 05:38:06 INFO - Return code: 0 05:38:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:38:06 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')]} 05:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:06 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')]} 05:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:06 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 0x1079f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10796a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed19d35a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107808d30>, '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 0x10762edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107800b20>, '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.Z9qKcDLj23/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.xvCn07FoJx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 05:38:06 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 05:38:06 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 05:38:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9qKcDLj23/Render', 05:38:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:06 INFO - 'HOME': '/Users/cltbld', 05:38:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:06 INFO - 'LOGNAME': 'cltbld', 05:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:06 INFO - 'MOZ_NO_REMOTE': '1', 05:38:06 INFO - 'NO_EM_RESTART': '1', 05:38:06 INFO - 'PAGER': '/bin/cat', 05:38:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:06 INFO - 'PWD': '/builds/slave/test', 05:38:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:06 INFO - 'SHELL': '/bin/bash', 05:38:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xvCn07FoJx/Listeners', 05:38:06 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 05:38:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:06 INFO - 'USER': 'cltbld', 05:38:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:06 INFO - 'XPC_FLAGS': '0x0', 05:38:06 INFO - 'XPC_SERVICE_NAME': '0', 05:38:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:38:06 INFO - Cleaning up... 05:38:06 INFO - Return code: 0 05:38:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:38:06 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')]} 05:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:06 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')]} 05:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:06 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 0x1079f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10796a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed19d35a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107808d30>, '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 0x10762edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107800b20>, '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.Z9qKcDLj23/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.xvCn07FoJx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 05:38:06 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 05:38:06 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 05:38:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9qKcDLj23/Render', 05:38:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:06 INFO - 'HOME': '/Users/cltbld', 05:38:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:06 INFO - 'LOGNAME': 'cltbld', 05:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:06 INFO - 'MOZ_NO_REMOTE': '1', 05:38:06 INFO - 'NO_EM_RESTART': '1', 05:38:06 INFO - 'PAGER': '/bin/cat', 05:38:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:06 INFO - 'PWD': '/builds/slave/test', 05:38:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:06 INFO - 'SHELL': '/bin/bash', 05:38:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xvCn07FoJx/Listeners', 05:38:06 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 05:38:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:06 INFO - 'USER': 'cltbld', 05:38:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:06 INFO - 'XPC_FLAGS': '0x0', 05:38:06 INFO - 'XPC_SERVICE_NAME': '0', 05:38:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:07 INFO - Downloading/unpacking blobuploader==1.2.4 05:38:07 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 05:38:07 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 05:38:07 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 05:38:07 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 05:38:07 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 05:38:07 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 05:38:09 INFO - Downloading blobuploader-1.2.4.tar.gz 05:38:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:38:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:38:09 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 05:38:09 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 05:38:09 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 05:38:09 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 05:38:09 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 05:38:09 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 05:38:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:38:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:38:10 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 05:38:10 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 05:38:10 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 05:38:10 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 05:38:10 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 05:38:10 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 05:38:10 INFO - Downloading docopt-0.6.1.tar.gz 05:38:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:38:10 INFO - Installing collected packages: blobuploader, requests, docopt 05:38:10 INFO - Running setup.py install for blobuploader 05:38:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:38:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:38:10 INFO - Running setup.py install for requests 05:38:11 INFO - Running setup.py install for docopt 05:38:11 INFO - Successfully installed blobuploader requests docopt 05:38:11 INFO - Cleaning up... 05:38:11 INFO - Return code: 0 05:38:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38:11 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')]} 05:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:11 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')]} 05:38:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:11 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 0x1079f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10796a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed19d35a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107808d30>, '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 0x10762edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107800b20>, '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.Z9qKcDLj23/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.xvCn07FoJx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 05:38:11 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 05:38:11 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 05:38:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9qKcDLj23/Render', 05:38:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:11 INFO - 'HOME': '/Users/cltbld', 05:38:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:11 INFO - 'LOGNAME': 'cltbld', 05:38:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:11 INFO - 'MOZ_NO_REMOTE': '1', 05:38:11 INFO - 'NO_EM_RESTART': '1', 05:38:11 INFO - 'PAGER': '/bin/cat', 05:38:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:11 INFO - 'PWD': '/builds/slave/test', 05:38:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:11 INFO - 'SHELL': '/bin/bash', 05:38:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xvCn07FoJx/Listeners', 05:38:11 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 05:38:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:11 INFO - 'USER': 'cltbld', 05:38:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:11 INFO - 'XPC_FLAGS': '0x0', 05:38:11 INFO - 'XPC_SERVICE_NAME': '0', 05:38:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:38:11 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-tqJXDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:38:12 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-j6vn0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:38:12 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-9zXLQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:38:12 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-XuOA9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:38:12 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-kagciI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:38:12 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-Ic_d54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:38:12 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-FEWdWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:38:12 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-uPx2yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:38:12 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-qR55fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:38:12 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-NuFzkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:38:12 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-WORnd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:38:13 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-yQvxIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:38:13 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-8t43Xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:38:13 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-0LKBHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:13 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-5ksViM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:38:13 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-kgvfzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:38:13 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-8Z7iz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:38:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:38:13 INFO - Running setup.py install for manifestparser 05:38:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:38:13 INFO - Running setup.py install for mozcrash 05:38:13 INFO - Running setup.py install for mozdebug 05:38:14 INFO - Running setup.py install for mozdevice 05:38:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:38:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:38:14 INFO - Running setup.py install for mozfile 05:38:14 INFO - Running setup.py install for mozhttpd 05:38:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:38:14 INFO - Running setup.py install for mozinfo 05:38:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:38:14 INFO - Running setup.py install for mozInstall 05:38:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:38:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:38:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:38:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:38:14 INFO - Running setup.py install for mozleak 05:38:14 INFO - Running setup.py install for mozlog 05:38:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:38:15 INFO - Running setup.py install for moznetwork 05:38:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:38:15 INFO - Running setup.py install for mozprocess 05:38:15 INFO - Running setup.py install for mozprofile 05:38:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:38:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:38:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:38:15 INFO - Running setup.py install for mozrunner 05:38:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:38:15 INFO - Running setup.py install for mozscreenshot 05:38:15 INFO - Running setup.py install for moztest 05:38:16 INFO - Running setup.py install for mozversion 05:38:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:38:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:38:16 INFO - Cleaning up... 05:38:16 INFO - Return code: 0 05:38:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:16 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 0x1079f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10796a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed19d35a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107808d30>, '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 0x10762edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107800b20>, '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.Z9qKcDLj23/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.xvCn07FoJx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 05:38:16 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 05:38:16 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 05:38:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9qKcDLj23/Render', 05:38:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:16 INFO - 'HOME': '/Users/cltbld', 05:38:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:16 INFO - 'LOGNAME': 'cltbld', 05:38:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:16 INFO - 'MOZ_NO_REMOTE': '1', 05:38:16 INFO - 'NO_EM_RESTART': '1', 05:38:16 INFO - 'PAGER': '/bin/cat', 05:38:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:16 INFO - 'PWD': '/builds/slave/test', 05:38:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:16 INFO - 'SHELL': '/bin/bash', 05:38:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xvCn07FoJx/Listeners', 05:38:16 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 05:38:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:16 INFO - 'USER': 'cltbld', 05:38:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:16 INFO - 'XPC_FLAGS': '0x0', 05:38:16 INFO - 'XPC_SERVICE_NAME': '0', 05:38:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:38:16 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-DtL23Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:38:16 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)) 05:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:38:16 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-Z8it1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:38:16 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-OQVtaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:38:16 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)) 05:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:38:16 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-ZIpTy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:38:16 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-TfkPwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:38:17 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)) 05:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:38:17 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-8nxI49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:38:17 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)) 05:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:38:17 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-CcDuD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:38:17 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)) 05:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:38:17 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-_Ah6rr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:38:17 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)) 05:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:38:17 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-O7f45f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:38:17 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)) 05:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:38:17 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-S0ZWLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:38:17 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)) 05:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:38:17 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-JqnkP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:38:17 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)) 05:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:38:17 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-A_zGqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:38:17 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-HHV4Uu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:38:17 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)) 05:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:38:17 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-zJTiym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:18 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-GuXctm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:18 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)) 05:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:38:18 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-Eu4cAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:38:18 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-vfHuWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:38:18 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)) 05:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:38:18 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)) 05:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:38:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:38:18 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 05:38:18 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 05:38:18 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 05:38:18 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 05:38:18 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 05:38:18 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 05:38:20 INFO - Downloading blessings-1.6.tar.gz 05:38:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:38:21 INFO - Installing collected packages: blessings 05:38:21 INFO - Running setup.py install for blessings 05:38:21 INFO - Successfully installed blessings 05:38:21 INFO - Cleaning up... 05:38:21 INFO - Return code: 0 05:38:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:38:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:38:21 INFO - Reading from file tmpfile_stdout 05:38:21 INFO - Current package versions: 05:38:21 INFO - blessings == 1.6 05:38:21 INFO - blobuploader == 1.2.4 05:38:21 INFO - docopt == 0.6.1 05:38:21 INFO - functools32 == 3.2.3-2 05:38:21 INFO - jsonschema == 2.5.1 05:38:21 INFO - manifestparser == 1.1 05:38:21 INFO - mozInstall == 1.12 05:38:21 INFO - mozcrash == 0.17 05:38:21 INFO - mozdebug == 0.1 05:38:21 INFO - mozdevice == 0.48 05:38:21 INFO - mozfile == 1.2 05:38:21 INFO - mozhttpd == 0.7 05:38:21 INFO - mozinfo == 0.9 05:38:21 INFO - mozleak == 0.1 05:38:21 INFO - mozlog == 3.4 05:38:21 INFO - moznetwork == 0.27 05:38:21 INFO - mozprocess == 0.23 05:38:21 INFO - mozprofile == 0.28 05:38:21 INFO - mozrunner == 6.12 05:38:21 INFO - mozscreenshot == 0.1 05:38:21 INFO - mozsystemmonitor == 0.3 05:38:21 INFO - moztest == 0.7 05:38:21 INFO - mozversion == 1.4 05:38:21 INFO - psutil == 3.1.1 05:38:21 INFO - requests == 1.2.3 05:38:21 INFO - wsgiref == 0.1.2 05:38:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38: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')]} 05:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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')]} 05:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:21 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 0x1079f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10796a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed19d35a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107808d30>, '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 0x10762edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107800b20>, '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.Z9qKcDLj23/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.xvCn07FoJx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 05:38:21 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 05:38:21 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 05:38:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9qKcDLj23/Render', 05:38:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:21 INFO - 'HOME': '/Users/cltbld', 05:38:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:21 INFO - 'LOGNAME': 'cltbld', 05:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:21 INFO - 'MOZ_NO_REMOTE': '1', 05:38:21 INFO - 'NO_EM_RESTART': '1', 05:38:21 INFO - 'PAGER': '/bin/cat', 05:38:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:21 INFO - 'PWD': '/builds/slave/test', 05:38:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:21 INFO - 'SHELL': '/bin/bash', 05:38:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xvCn07FoJx/Listeners', 05:38:21 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 05:38:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:21 INFO - 'USER': 'cltbld', 05:38:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:21 INFO - 'XPC_FLAGS': '0x0', 05:38:21 INFO - 'XPC_SERVICE_NAME': '0', 05:38:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:21 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)) 05:38:21 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)) 05:38:21 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)) 05:38:21 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)) 05:38:21 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)) 05:38:21 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)) 05:38:21 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)) 05:38:21 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)) 05:38:21 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)) 05:38:21 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)) 05:38:21 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)) 05:38:21 INFO - Cleaning up... 05:38:21 INFO - Return code: 0 05:38:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:38: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')]} 05:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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')]} 05:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1079f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10796a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed19d35a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107808d30>, '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 0x10762edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107800b20>, '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.Z9qKcDLj23/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.xvCn07FoJx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 05:38: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', 'jsonschema'] in /builds/slave/test/build 05:38: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 jsonschema 05:38:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9qKcDLj23/Render', 05:38:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:21 INFO - 'HOME': '/Users/cltbld', 05:38:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:21 INFO - 'LOGNAME': 'cltbld', 05:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:21 INFO - 'MOZ_NO_REMOTE': '1', 05:38:21 INFO - 'NO_EM_RESTART': '1', 05:38:21 INFO - 'PAGER': '/bin/cat', 05:38:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:21 INFO - 'PWD': '/builds/slave/test', 05:38:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:21 INFO - 'SHELL': '/bin/bash', 05:38:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xvCn07FoJx/Listeners', 05:38:21 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 05:38:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:21 INFO - 'USER': 'cltbld', 05:38:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:21 INFO - 'XPC_FLAGS': '0x0', 05:38:21 INFO - 'XPC_SERVICE_NAME': '0', 05:38:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:38:22 INFO - Cleaning up... 05:38:22 INFO - Return code: 0 05:38:22 INFO - Running post-action listener: _resource_record_post_action 05:38:22 INFO - Running post-action listener: _start_resource_monitoring 05:38:22 INFO - Starting resource monitoring. 05:38:22 INFO - [mozharness: 2016-10-26 12:38:22.086724Z] Finished create-virtualenv step (success) 05:38:22 INFO - [mozharness: 2016-10-26 12:38:22.087725Z] Running install step. 05:38:22 INFO - Running pre-action listener: _resource_record_pre_action 05:38:22 INFO - Running main action method: install 05:38:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:38:22 INFO - Reading from file tmpfile_stdout 05:38:22 INFO - Detecting whether we're running mozinstall >=1.0... 05:38:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:38:22 INFO - Reading from file tmpfile_stdout 05:38:22 INFO - Output received: 05:38:22 INFO - Usage: mozinstall [options] installer 05:38:22 INFO - Options: 05:38:22 INFO - -h, --help show this help message and exit 05:38:22 INFO - -d DEST, --destination=DEST 05:38:22 INFO - Directory to install application into. [default: 05:38:22 INFO - "/builds/slave/test"] 05:38:22 INFO - --app=APP Application being installed. [default: firefox] 05:38:22 INFO - mkdir: /builds/slave/test/build/application 05:38:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:38:56 INFO - Reading from file tmpfile_stdout 05:38:56 INFO - Output received: 05:38:56 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:38:56 INFO - Running post-action listener: _resource_record_post_action 05:38:56 INFO - [mozharness: 2016-10-26 12:38:56.375230Z] Finished install step (success) 05:38:56 INFO - [mozharness: 2016-10-26 12:38:56.375371Z] Running run-tests step. 05:38:56 INFO - Running pre-action listener: _resource_record_pre_action 05:38:56 INFO - Running main action method: run_tests 05:38:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:38:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:38:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:38:56 INFO - 2016-10-26 05:38:56.389 screenresolution[1657:9276] starting screenresolution argv=screenresolution get 05:38:56 INFO - 2016-10-26 05:38:56.392 screenresolution[1657:9276] Display 0: 1600x1200x32@60 05:38:56 INFO - 2016-10-26 05:38:56.398 screenresolution[1658:9278] starting screenresolution argv=screenresolution list 05:38:56 INFO - Available Modes on Display 0 05:38:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:38:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:38:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:38:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:38:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:38:56 INFO - Intel Iris: 05:38:56 INFO - Chipset Model: Intel Iris 05:38:56 INFO - Type: GPU 05:38:56 INFO - Bus: Built-In 05:38:56 INFO - VRAM (Dynamic, Max): 1536 MB 05:38:56 INFO - Vendor: Intel (0x8086) 05:38:56 INFO - Device ID: 0x0a2e 05:38:56 INFO - Revision ID: 0x0009 05:38:56 INFO - Displays: 05:38:56 INFO - Display: 05:38:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:38:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:38:56 INFO - Display Serial Number: 1600x1200 60 05:38:56 INFO - Main Display: Yes 05:38:56 INFO - Mirror: Off 05:38:56 INFO - Online: Yes 05:38:56 INFO - Rotation: Supported 05:38:56 INFO - Return code: 0 05:38:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:38:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:38:56 INFO - Python 2.7.3 05:38:56 INFO - Return code: 0 05:38:56 INFO - grabbing minidump binary from tooltool 05:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:56 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 0x107808d30>, '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 0x10762edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107800b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:38:56 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 05:38:56 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 05:38:56 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 05:38:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:38:56 INFO - Return code: 0 05:38:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:38:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:38:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:38:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:38:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:38:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ti88ZL1iQmeBR1QqwBzmMA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0284', '--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 05:38:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ti88ZL1iQmeBR1QqwBzmMA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0284 --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 05:38:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9qKcDLj23/Render', 05:38:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:56 INFO - 'HOME': '/Users/cltbld', 05:38:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:56 INFO - 'LOGNAME': 'cltbld', 05:38:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:38:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:56 INFO - 'MOZ_NO_REMOTE': '1', 05:38:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:38:56 INFO - 'NO_EM_RESTART': '1', 05:38:56 INFO - 'PAGER': '/bin/cat', 05:38:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:56 INFO - 'PWD': '/builds/slave/test', 05:38:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:38:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:56 INFO - 'SHELL': '/bin/bash', 05:38:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xvCn07FoJx/Listeners', 05:38:56 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 05:38:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:56 INFO - 'USER': 'cltbld', 05:38:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:56 INFO - 'XPC_FLAGS': '0x0', 05:38:56 INFO - 'XPC_SERVICE_NAME': '0', 05:38:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ti88ZL1iQmeBR1QqwBzmMA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0284', '--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 05:38:56 INFO - mozversion application_buildid: 20161025185822 05:38:56 INFO - mozversion application_changeset: b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 05:38:56 INFO - mozversion application_display_name: Nightly 05:38:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:38:56 INFO - mozversion application_name: Firefox 05:38:56 INFO - mozversion application_remotingname: firefox 05:38:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:38:56 INFO - mozversion application_vendor: Mozilla 05:38:56 INFO - mozversion application_version: 52.0a1 05:38:56 INFO - mozversion platform_buildid: 20161025185822 05:38:56 INFO - mozversion platform_changeset: b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 05:38:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:38:56 INFO - mozversion platform_version: 52.0a1 05:38:56 INFO - using testdate: 1477485536 05:38:56 INFO - actual date: 1477485536 05:38:56 INFO - starting webserver on 'localhost:49278' 05:38:56 INFO - SUITE-START | Running 2 tests 05:38:56 INFO - TEST-START | dromaeo_css 05:38:56 INFO - operating with platform_type : mac_ 05:38:56 INFO - Initialising browser for dromaeo_css test... 05:38:56 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/tmp8L7MIW/profile http://localhost:49278/getInfo.html) 05:38:59 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 05:38:59 INFO - PROCESS | 1668 | colorDepth:24 05:38:59 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 05:38:59 INFO - PROCESS | 1668 | __metrics 05:38:59 INFO - PROCESS | 1668 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:38:59 INFO - PROCESS | 1668 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:39:00 INFO - TEST-INFO | 1668: exit 0 05:39:00 INFO - Browser initialized. 05:39:00 INFO - Running cycle 1/1 for dromaeo_css test... 05:39:00 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/tmp8L7MIW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:39:11 INFO - PROCESS | 1671 | RSS: Main: 239693824 05:39:11 INFO - PROCESS | 1671 | 05:40:03 INFO - PROCESS | 1671 | 1477485603558 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:42:16 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 05:42:18 INFO - PROCESS | 1671 | RSS: Main: 389980160 05:42:18 INFO - PROCESS | 1671 | 05:45:20 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 05:45:21 INFO - PROCESS | 1671 | RSS: Main: 381104128 05:45:21 INFO - PROCESS | 1671 | 05:48:23 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 05:48:24 INFO - PROCESS | 1671 | RSS: Main: 366505984 05:48:24 INFO - PROCESS | 1671 | 05:51:26 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 05:51:27 INFO - PROCESS | 1671 | RSS: Main: 338128896 05:51:27 INFO - PROCESS | 1671 | 05:54:30 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 05:54:31 INFO - PROCESS | 1671 | RSS: Main: 330940416 05:54:31 INFO - PROCESS | 1671 | 05:57:34 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 05:57:34 INFO - PROCESS | 1671 | RSS: Main: 481492992 05:57:34 INFO - PROCESS | 1671 | 05:57:34 INFO - PROCESS | 1671 | __start_tp_report 05:57:34 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 05:57:34 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 05:57:34 INFO - PROCESS | 1671 | |i|pagename|runs| 05:57:34 INFO - PROCESS | 1671 | |0;dojo.html;3356.563646725927;3364.8149351785655;3366.2257680733433;3390.5761779777526;3418.589769227693;5595.7481913313895;5714.71426428679;5725.312962444507;5783.450572195645;5800.216970708958;5695.914561281584;5721.31344238692;5728.627639203449;5731;5735.971320143404;5162.63861529694;5211.635185537014;5212.192110222922;5249.028929648009;5253.4221235664045;5289.576833853283;5301;5302.549283310923;5314.9468505314835;5314.9468505314835;5210.296609957645;5279.102552566073;5293;5301.3108295921475;5315.787368505275;5323.361196656426;5323.547498462596;5330.253764472957;5341.412444631087;5408.134698448269;5129.102407078746;5130.204818253177;5203.297554830087;5251.55361794248;5268.789248430058;5675.262215911905;5729.427057294279;5771.336296325934;5778.682172480512;5806.680632565207;6249.87500249997;6280.2777680566405;6291.43377096059;6293.087502312139;6306.905396419057;6110.856892744153;6202.937970620281;6208.910520404343;6299.748010079637;6312.400321969406;5771.451712087303;5841.824745257564;5851.61964472308;5868.941310586925;5920.407959204045;6244.65654389013;6263;6280.685965701697;6282.403171698681;6290;6032.969835150796;6131.448169664663;6193.071039344134;6206.162168107338;6227.314995350508;6186.4741496972365;6186.783462578788;6192.442680158807;6221.004639257697;6231.781887633911;6153.323134455206;6238.469730072995;6244.375562443719;6256.968715156395;6266.655333956676;6132.601380910227;6231.470325022424;6258.593191442542;6262.405071518198;6273.560850740404;4840.419149701988;4900.044491324157;4914.189158788831;4925.40895092584;4960.479149689303;4403.097365040223;4451.643868490513;4461.57615026572;4471.083427897273;4487.798049087799;5816.534677225812;5838.036723940502;5857.179994800731;5871.911921321183;5899.498542623839;6238.112591542365;6245.28179259391;6276.215473065867;6291.6854157291955;6307.653079080695;5676.914846277309;5757.309122905278;5830.41695830422;5839.795607153814;5849.766009359663;5349.973250133802;5379.67721936685;5416.891662166735;5430.294061771944;5454.7818087276855;6234.2830574482705;6290.874182516324;6299.370062993756;6323.747050117944;6327.810165695037;6258.906116408167;6268.341824108403;6299.30707622152;6324.051392291193;6328.7152078157515;5365.382980957083;6205.906911396242;6235.75056997715;6264.029075493306;6283.7800676976085;6205.720742566686;6211.472024877936;6234.719437625408;6242;6255.40573645503;5784.2769653793275;6268.811935641756;6297.653629050446;6306.211723534559;6306.369363063657;5967.373425790403;6022.638641681513;6039.909401359071;6077.24034495688;6166.920788862021;6081.604695694766;6099.703252314951;6128.130920069243;6143.907841382294;6161.168242287413;5998.130271110752;5998.520118390606;6006.429389208019;6026.276846778414;6031.276246850406;5955.553333499918;6075.1798507200965;6095.9390406097145;6101.908471372844;6108.664023478751;5845.947729408747;5904.025835737227;5921.733521991607;5985;5996.430339117776 05:57:34 INFO - PROCESS | 1671 | |1;ext.html;505.4187684163212;512.6385897941951;517.6997341541907;520.9531142197203;536.6109570561343;28563.714362856364;34946.650533494656;39088.41367379488;39921.60078399215;39952;40985.97535061625;41334.79332603333;41372.58627413725;41410.792946035304;41506;9363.906360936371;9527.190188833958;9544.665936692218;9552.283578731589;9552.952235238814;9415;9516.191123754454;9517.857232141523;9524.095210954949;9527.904720952805;9515.476648784314;9522.428654280731;9543.284253680968;9567.091126342986;9576.61693532258;8136.755897323031;9473;9473.336866419353;9520.8571871422;9521.476318802463;9321;9371.062893710574;9381.812363752755;9384.67153649619;9422.764430889283;38874;39396.40905386421;39417.80291098555;39420.60579394227;39532.407013894815;3357.932841343184;3395.9320813583836;3547.3082748863726;3729.7948612826285;3826.2730081284744;27913.860430697718;30210.54684179739;30311.393772124433;30337;30755.692443075506;3144.606924134483;3167.651558328582;3205.4390481665614;3237.7409807215367;3275.737940964717;472677;473987;474723;474819;475011;54918;55180.724096379265;55191.72404137954;55296.17055744167;55405.72297138489;33830.830845845616;34316.313673726385;34601.307973840885;35136.12159695977;57595;15273.312700928485;15390.615234619;15393.461228856937;15397.384104635914;15414.845851541566;12453.25280483174;12567.18313309632;12575;12578.748425031448;12587.74824503523;18465.7230141548;18468.445946621356;18519.259229630934;18724.812751872578;18770.061496925373;7755.379569634416;7815.882761758465;7840.686372545034;7892.9478335632;7976.361891048702;889.5774507109071;995.4972738767021;1037.5538518437145;1071.2019545438543;1127.1715289262386;29136.854315728287;29223.415531689247;29603.407931841244;29909.25226869302;30057.54913676253;1015.7155996321042;1042.635077722791;1049.2340591368343;1067.6209945469402;1071.5285274479204;13224.867751322556;14243.002989790615;14679.55961321162;15229.086254824524;15799;615982;616768;620378;620600;620972;55239.72380138154;55797;55832.441675583534;55991.44008559944;56024.43975560274;1159.4087015622263;1229.1150371732338;1266.4174479739238;1385.6882201504782;1401.6706074072586;28840.278993025342;29897.402051958405;30325.090247292617;30678.079657610306;30937;53611.19583206177;54367.45632543624;54381;54413.455865442425;54484.72757636345;592408;598457;598995;599841;600514;34252.31495370129;35013;35091.12272193113;35959.82020089883;41520;43979.78010109929;44455.33317000183;44827;45246.868828279556;45381.77309113433;36884.446733299555;36910.63089369072;37161.256774864894;38157.80921095377;38618.80690596641;37114.628853712195;37282.81358593189;37622.62377376191;38216;38426.0393490165;35428.29143417066;36180.27639447249;37413.25173496569;37534.74513568048;37564.436533452565;31491.37017259688;33233.83383083069;33349.499757503174;33415.83292083621;33512.66487335096;24755.752442475346;24984.75015249897;25506.48987020212;25741.871290643427;25970.439420752376 05:57:34 INFO - PROCESS | 1671 | |2;jquery.html;352.17590837440383;353.2722591461589;374.7152164355091;377.87530115062026;401.80311647292837;15275.923620381896;15373.769393459093;16328.591785205375;17581.648367032652;18153.27386904522;18636.34772782953;20811.791882081176;21418.143274269012;21596.8920155399;21728.674069888963;5798.449147330997;5833.474987251147;5878.941210587882;5882.441168089024;5888.9988701920565;4892.828750993716;6475.805725828209;6563.3764792344655;6594.340565943391;6615.140031795884;4950.257461380804;6441.967790161043;6543.247526534462;6563.081168636395;6573.309802470743;6471.352864713538;6520.608763474207;6523.5107366947195;6532.934670653304;6542.345765423467;4862.854114376574;4959.132151873408;5225.451327610622;5269.736513174326;5299.920501192485;12611.74776504474;12669.683257918534;12706.618801435972;12846.807297890538;12865.67835804103;2157.2341818654468;2271.3867255840833;2295.01314434793;2575.549278876189;2678.9196324110308;9006.369554131214;9624.855627165598;10114.494275286206;10169.084782369548;12596.559120430833;1727.550836782433;1791.8745687801859;1806.2594336322045;1814.954626134344;1817.1277786662477;115406.42296788462;116490.41754791171;118480;119463.46720167578;121212.39393803063;11328.263662861887;11460.312381256985;11563.42182890852;11564.653060408202;11678.532858685558;14458.783118253235;14487.565373038826;14503.85496145046;14507.709845803025;14537.491187808588;6140.416660417253;7836.568988705562;8335.749927502186;8490.575471226413;8612.956935215283;8358.373122015752;8397.370197235232;8414.747557573282;8556.443831150955;8586.356023298278;4415.2494076006515;4493.303537951622;4500.639948804088;4564.497905230422;4590.862274131781;1733.2806885142525;1737.8696597754965;1804.3233787329752;1906.2851430713483;1907.637548865711;701.0431601324922;821.5317269156643;942.5381563034201;994.5524513968743;1061.1722856172198;20269;21992.78007219939;21999.450013749465;22049;22089;891.888513935758;929.4469790474657;967.3615413826841;981.5239608789731;1012.3875055591409;8513.659453621909;10141.391516509033;11395.829062564067;11436.771264574829;11448.713782155513;498902;551422;552934.2353288208;569407;570259;112575.35875010633;119236;122451;122587;125318;947.4741518457322;960.1214888377197;981.0238812381726;981.5975450065439;984.1536278800226;15031.323590438238;18928.621427571095;19171.424857254304;19211.711824322367;19259.325923592605;50382.49617503778;51586.48413515967;51777.18779842687;52977.65695352967;53250;74917.62541187259;78196.60901695455;78390;79140.60429697814;81308;8011.879821802561;8011.959940200495;8148.674053037812;8205.220504052344;8215.876761848696;11303.321800691985;12773.443552054885;12865.485380584672;13039.608811735663;13555.254461004739;9615.56729947168;9643.9035609643;11064.723381915517;11213.196700824794;11228.214025018171;11007.724806879893;11019.338839669645;11200.43997800123;11634.476448559666;11696.181267311207;11442.526248775515;11481.598144064918;11518.020968217796;11599.6520104397;11601.01391381742;7376.7786966391095;7486.812829679084;7807.687692492236;8005;8301.916980830356;9403.670871519464;11001.669949901516;11247.606333778278;11264.436778160894;11315.547378104784 05:57:34 INFO - PROCESS | 1671 | |3;mootools.html;1363.5227670315392;1538.2462593329271;1742.1985886492214;1884.896330701811;1948.181763659262;6954.687039083241;7830.725924592641;8402.831943361129;8932.062133475989;8935.463872167675;7953.125156232824;8479.915200848005;8679.175478329564;8682.782930426742;8802.987656419513;2297.1041293895396;2310.549442858643;2331.755165707602;2332.5218330242346;2332.7550607186254;2029.9289524866633;2115.3653903828867;2259.1641092795608;2299.8620082795;2322.628379459287;2082.979170208301;2234.597772400967;2302.3898666853297;2305.4812667149927;2305.8501197422115;2256.8871556422114;2271.9886400567975;2278.79490845823;2281.5208806150727;2316.467212541108;2133.1040962795664;2278.1229226747823;2279.179495381661;2280.5438912217624;2283.7716228377194;8018.879716804253;8758.036615972302;8769.561521923879;8786.60460279289;8789.077146899548;5130.563902068328;5304.92042619361;5312.256284120226;5313;5323.307969963918;3497.090756403353;3518.8768393106375;3583.229605634775;3618.4391419330045;3634.1096431374217;1042.5725452564488;1055.883852776194;1075.4031512510553;1083.2579682917149;1089.4988305379534;11424.828627570592;11493.827592586118;11497.540098396054;11514.539418423254;11549.538018479334;4360.978195109004;4579.725216486955;4631.374764406829;4663.836765713251;4674.11191873543;9741;9745.366551174151;9754.804903901882;9756.219502439788;9809.068138526829;5284.550813180923;5286.365636123613;5287.127623942083;5289.761960711778;5292.52367286946;4579.610733087658;4589.678722489393;4747.643926705442;4853.781579828917;4868.732219727949;3707.5921648618632;3748.9625103748613;3822.4075268333454;3863.594322596087;3868;1159.918805683594;1205.3250179899285;1253.078986944595;1261.6782720406238;1268.3594784633701;747.2938073520471;800.6797281087612;827.2916427577154;888.3603805260202;903.7017784131352;5648.576356773258;5670.319561652628;5807.593468457252;5878.617889837147;6016.608920420159;921.1479381572019;964.2237998411347;978.8091322192104;994.7065615643403;1025.8409946458312;3120.8127512349333;3881.0805990557214;3991.980040099781;4049;4060.269151552749;9114.635414583476;10336.586536538454;10589.417582033062;10608.734781630366;10617.575296988189;10403.271770976111;10534.683959481228;10535.157187424988;10536.525856336484;10542.947285263524;7806.687732490636;8196.221358970888;8212.34301255898;8324.167583241628;8330.208630180123;5785.9874521957645;5790.739416726342;5807.651540907559;5988.550858685703;6120.357362476876;9909.851352229867;10021.949890250502;10024.498775061364;10059.899401005896;10064.54709538058;9829.4102353859;9923.900760992297;9980.451075190935;10241.18070554339;10250.077493025663;6654.90017649726;7061.646917653994;7473.925260747323;7478.06524184477;7499.325060744341;8030.638621262174;8101.513909165469;8109.8378032440205;8188.385871059813;8212.97337832771;7341;7416.7033318666645;7418.480706350504;7470.140933792466;7549.962250188714;7167.7132914682825;7207.279272072751;7221.241769614115;7258.927410726036;7303.926960730325;6684.665766711742;6778.966105169443;6779.254282029072;6849.315068493111;6864.553804002724;4959.578435832995;4969.180085285887;5016.1221786188;5059.241113832954;5162.174052151638;4293.291606884954;4965.577925876341;5055.898882022412;5128.512791284822;5140.64015518925 05:57:34 INFO - PROCESS | 1671 | |4;prototype.html;299.51329090228376;301.8867924528302;308.33707528813056;314.770217741049;317.39219394858816;4634.58288754012;5151.896962060757;5335.33308336458;5370.919436208455;5463.235147079402;5167.509086636773;5202.661826981243;5243.187305967581;5269.104252277112;5295.8146464873735;3872.9031774205587;4080.0411903202726;4087;4108.486439195093;4119.949412899721;3893.5133108361456;4103.671706263507;4107.815148318333;4123.216588848124;4137.420761093449;4075.7962101894936;4102;4109.958900411002;4114.218298523271;4115.32097203961;3426.760126791138;4063.187362527506;4067.1458993611377;4068.837246510136;4083.734557253769;2996.3258266889993;3550.3076900004507;3558.466230065485;3562;3566.857325706969;4652.790624421909;4723.905521889577;4774.830166609203;5183.300254465675;5257.290265814105;4668.416447944007;4668.906621867578;4685.835995740167;4712.717236965793;4735.763211839394;5089.3638295213095;5546.86132846678;5554.889022195536;5562.9443705563235;5574.331080270353;3598.316319899237;3626.6581364894896;3690.538682664667;3924.1759230561615;3969.583193764642;5871.2073870027425;5884.440978107073;5891.440313170285;5916.349201587822;5923.970380148115;3984.5019372578427;3996.741026576619;4002.8398864045694;4002.899927501836;4010.2581022510344;3851.3645248533676;4024.7987600619854;4028.436018957348;4034.9105741449644;4063.512378514597;4230.196262710076;4310.353446982915;4592.759954812182;4617.676762626584;4723.078999595046;5553.361363443175;5558.527525160326;5581.804636837691;5584.21820945068;5598.888022239533;1105.170942090841;1122.966311010671;1301.4468850738588;1338.056670047614;1347.4273433790795;810.5582457560644;838.1325328285195;844.160060739568;845.8731190321378;848.0925409811442;4378.56214378566;4386.8903277417685;4389.495208051051;4391.780410979438;4395.604395604347;4016.561699322265;4325.005248792795;4404.031113155101;4633.397658304466;4719.422160504305;3723.343112314994;3842.423636454554;4285.450157156487;4308;4349.521552629209;2095.3190213180474;2224.353978056259;2255.943601409945;2528.595424732034;2560.8975640974527;4478.865634030984;4909.846186146253;4947.455779864212;4958.727270000185;4974.751262436864;4020.6128885534445;4227.894302642459;4354.651627869763;4868.85958556736;4895.657303988758;4038.51537815464;4493.73037617744;4536.61438777701;4716.57550820421;4885.8990634026995;3872.7289089763444;4613.607843333354;4718.457377401505;4738.223166312633;4769.976150119227;3958.8614398495915;4056.484979312845;4414.117176564636;4503.234450143549;4724.149653062482;3838.405047217686;4093.549709532009;4172.624463798273;4385.552767586625;4915.754212289443;3364.158960259935;3389.9830500848325;3404.4552871540436;3415.684961289872;3445.9655403445645;4636.768161591975;4748.791811807526;4757.5727281814625;4758.714477131245;4760.001598657144;4348.217320882271;4804.8798780030775;5440.4015558287765;5445.428230035947;5501.834944951658;5377.865553361197;5546.639468434539;5561.249231353877;5578.609497335147;5580.330360356783;4616.376789133558;4643.8374656886845;5058.696478211319;5217.582593392443;5526.419725928719;4957.900841983213;5264.1834669865575;5415.970965516539;5615.989121958087;5673.744681489426;5550.916736248879;5560.388357280777;5563.221149039218;5571.721413929368;5636.098224284095 05:57:34 INFO - PROCESS | 1671 | |5;yui.html;703.3810246982655;720.1214518287687;746.4364404874319;774.3882332956964;827.598614671884;14881.404743810235;15453.613659658486;15466.458673946414;15471.226438678077;15483.458078967238;13907.652308692288;14078.64803379916;14084;14087.506937257198;14098.083624564397;693.9063226464414;713.9214686384494;718.1203026292802;864.7621903976394;865.1564724393697;884.8274586455643;884.9469031858077;894.9642014319419;899.6806133822464;900.8423525882944;959.3236768078488;962.0235461007084;962.475450879269;964.84080126779;965.3918031640092;687.5084314715003;752.3417010116149;950.6102497975796;951.1439704266181;952.4237836109193;557.1225320120826;558.3578884283066;559.2980809084573;675.587891386254;697.9232284448707;14496.20270885101;14565.271736413242;14575.052621579669;14585.854141458556;14586;13498.52755153565;13641.522546710918;13680;13693.383797729126;13903.79144312836;12189.268643881396;12242.510299588006;12252.264864108092;12458.190217635825;12771.361431928366;4409.801558929824;4448.644108471314;4519.615832654228;4572.0855828834365;4658.18481765693;98007;100373.4943975841;100906.49211995392;100920.49539752254;101733;10884.183686223565;10959;10966.506507207196;10994.395308257963;11285.097192224603;21125.26061587837;21327.893360533097;21376.14495420197;21421.143154273967;21617.67573486399;6025.3372129065765;7478.364339031244;7607.391408687292;7703.768886933289;7915.0897646771355;3702.889133260011;4277.871663850089;4292.978535107304;4308.482982042175;4322.69741118125;3381.526586277923;3516.2791627716256;3528.752987290865;3530.1880567469625;3534.6465353464446;552.4199590430113;652.2433976587231;659.1134923527848;665.6438805239173;665.9300773418818;529.796028529019;568.9829305120853;605.3280858247342;610.1938262742244;617.2962822382488;7573;7784.13120347547;8461.576921153917;8724.258438032712;8739.596610932045;520.4795204795205;558.4080874273284;615.5844804756771;656.2748163279603;677.9559478403204;3510.2552370341987;4145.150244199932;4319.97840010798;4412.4705035395955;4555.794989225493;97560;99872;100776;101957.4706379405;101961.49019254856;84563;86086.70869936956;87047.1295287039;90832;93098.53450732703;84676.57661711652;87168.56415717881;87307;87621;89713.55143224243;7820.72627458059;8049.51702897828;8135.227153420416;8245.175482451707;8423.70517031901;51170;53017.20474192967;53746;54329.456705432436;55879.44120558743;68647.65676171587;75504.62247688726;76346.6182669083;76638.46723065396;78011;12561.937190313989;12702.36488175569;12726.872731272939;12994.545190918272;13567.52513662017;13435.328233588478;13992;15043.473478428203;15190.316435760638;15229;13059.085863989429;13278;13291.933540332624;13678.316084195949;13910.652233694238;10569.63006294776;13076.616915422886;13113.27876966776;13303.26832024248;13365.933170334087;12888;12990.935045325092;13012.496332652137;13042.54351097745;13535.59393218205;9165.725028249164;10509.684709458728;10794.676159715222;11363.022941970245;11434.142439316918;9714.708558743248;11138.777224455627;11328.716782080513;11398.430078495876;11445.656630301104 05:57:34 INFO - PROCESS | 1671 | __end_tp_report 05:57:34 INFO - PROCESS | 1671 | __start_cc_report 05:57:34 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1641 05:57:34 INFO - PROCESS | 1671 | __end_cc_report 05:57:34 INFO - PROCESS | 1671 | __startTimestamp1477486654837__endTimestamp 05:57:34 INFO - PROCESS | 1671 | 05:57:34 INFO - PROCESS | 1671 | ------- Summary: start ------- 05:57:34 INFO - PROCESS | 1671 | Number of tests: 6 05:57:34 INFO - PROCESS | 1671 | 05:57:34 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5767.98 Median:5985.00 stddev:629.25 (10.5%) stddev-sans-first:602.07 05:57:34 INFO - PROCESS | 1671 | Values: 3356.6 3364.8 3366.2 3390.6 3418.6 5595.7 5714.7 5725.3 5783.5 5800.2 5695.9 5721.3 5728.6 5731.0 5736.0 5162.6 5211.6 5212.2 5249.0 5253.4 5289.6 5301.0 5302.5 5314.9 5314.9 5210.3 5279.1 5293.0 5301.3 5315.8 5323.4 5323.5 5330.3 5341.4 5408.1 5129.1 5130.2 5203.3 5251.6 5268.8 5675.3 5729.4 5771.3 5778.7 5806.7 6249.9 6280.3 6291.4 6293.1 6306.9 6110.9 6202.9 6208.9 6299.7 6312.4 5771.5 5841.8 5851.6 5868.9 5920.4 6244.7 6263.0 6280.7 6282.4 6290.0 6033.0 6131.4 6193.1 6206.2 6227.3 6186.5 6186.8 6192.4 6221.0 6231.8 6153.3 6238.5 6244.4 6257.0 6266.7 6132.6 6231.5 6258.6 6262.4 6273.6 4840.4 4900.0 4914.2 4925.4 4960.5 4403.1 4451.6 4461.6 4471.1 4487.8 5816.5 5838.0 5857.2 5871.9 5899.5 6238.1 6245.3 6276.2 6291.7 6307.7 5676.9 5757.3 5830.4 5839.8 5849.8 5350.0 5379.7 5416.9 5430.3 5454.8 6234.3 6290.9 6299.4 6323.7 6327.8 6258.9 6268.3 6299.3 6324.1 6328.7 5365.4 6205.9 6235.8 6264.0 6283.8 6205.7 6211.5 6234.7 6242.0 6255.4 5784.3 6268.8 6297.7 6306.2 6306.4 5967.4 6022.6 6039.9 6077.2 6166.9 6081.6 6099.7 6128.1 6143.9 6161.2 5998.1 5998.5 6006.4 6026.3 6031.3 5955.6 6075.2 6095.9 6101.9 6108.7 5845.9 5904.0 5921.7 5985.0 5996.4 05:57:34 INFO - PROCESS | 1671 | 05:57:34 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:68910.64 Median:21126.16 stddev:151663.00 (717.9%) stddev-sans-first:152001.49 05:57:34 INFO - PROCESS | 1671 | Values: 505.4 512.6 517.7 521.0 536.6 28563.7 34946.7 39088.4 39921.6 39952.0 40986.0 41334.8 41372.6 41410.8 41506.0 9363.9 9527.2 9544.7 9552.3 9553.0 9415.0 9516.2 9517.9 9524.1 9527.9 9515.5 9522.4 9543.3 9567.1 9576.6 8136.8 9473.0 9473.3 9520.9 9521.5 9321.0 9371.1 9381.8 9384.7 9422.8 38874.0 39396.4 39417.8 39420.6 39532.4 3357.9 3395.9 3547.3 3729.8 3826.3 27913.9 30210.5 30311.4 30337.0 30755.7 3144.6 3167.7 3205.4 3237.7 3275.7 472677.0 473987.0 474723.0 474819.0 475011.0 54918.0 55180.7 55191.7 55296.2 55405.7 33830.8 34316.3 34601.3 35136.1 57595.0 15273.3 15390.6 15393.5 15397.4 15414.8 12453.3 12567.2 12575.0 12578.7 12587.7 18465.7 18468.4 18519.3 18724.8 18770.1 7755.4 7815.9 7840.7 7892.9 7976.4 889.6 995.5 1037.6 1071.2 1127.2 29136.9 29223.4 29603.4 29909.3 30057.5 1015.7 1042.6 1049.2 1067.6 1071.5 13224.9 14243.0 14679.6 15229.1 15799.0 615982.0 616768.0 620378.0 620600.0 620972.0 55239.7 55797.0 55832.4 55991.4 56024.4 1159.4 1229.1 1266.4 1385.7 1401.7 28840.3 29897.4 30325.1 30678.1 30937.0 53611.2 54367.5 54381.0 54413.5 54484.7 592408.0 598457.0 598995.0 599841.0 600514.0 34252.3 35013.0 35091.1 35959.8 41520.0 43979.8 44455.3 44827.0 45246.9 45381.8 36884.4 36910.6 37161.3 38157.8 38618.8 37114.6 37282.8 37622.6 38216.0 38426.0 35428.3 36180.3 37413.3 37534.7 37564.4 31491.4 33233.8 33349.5 33415.8 33512.7 24755.8 24984.8 25506.5 25741.9 25970.4 05:57:34 INFO - PROCESS | 1671 | 05:57:34 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:32986.47 Median:1515.55 stddev:92026.46 (6072.2%) stddev-sans-first:92251.99 05:57:34 INFO - PROCESS | 1671 | Values: 352.2 353.3 374.7 377.9 401.8 15275.9 15373.8 16328.6 17581.6 18153.3 18636.3 20811.8 21418.1 21596.9 21728.7 5798.4 5833.5 5878.9 5882.4 5889.0 4892.8 6475.8 6563.4 6594.3 6615.1 4950.3 6442.0 6543.2 6563.1 6573.3 6471.4 6520.6 6523.5 6532.9 6542.3 4862.9 4959.1 5225.5 5269.7 5299.9 12611.7 12669.7 12706.6 12846.8 12865.7 2157.2 2271.4 2295.0 2575.5 2678.9 9006.4 9624.9 10114.5 10169.1 12596.6 1727.6 1791.9 1806.3 1815.0 1817.1 115406.4 116490.4 118480.0 119463.5 121212.4 11328.3 11460.3 11563.4 11564.7 11678.5 14458.8 14487.6 14503.9 14507.7 14537.5 6140.4 7836.6 8335.7 8490.6 8613.0 8358.4 8397.4 8414.7 8556.4 8586.4 4415.2 4493.3 4500.6 4564.5 4590.9 1733.3 1737.9 1804.3 1906.3 1907.6 701.0 821.5 942.5 994.6 1061.2 20269.0 21992.8 21999.5 22049.0 22089.0 891.9 929.4 967.4 981.5 1012.4 8513.7 10141.4 11395.8 11436.8 11448.7 498902.0 551422.0 552934.2 569407.0 570259.0 112575.4 119236.0 122451.0 122587.0 125318.0 947.5 960.1 981.0 981.6 984.2 15031.3 18928.6 19171.4 19211.7 19259.3 50382.5 51586.5 51777.2 52977.7 53250.0 74917.6 78196.6 78390.0 79140.6 81308.0 8011.9 8012.0 8148.7 8205.2 8215.9 11303.3 12773.4 12865.5 13039.6 13555.3 9615.6 9643.9 11064.7 11213.2 11228.2 11007.7 11019.3 11200.4 11634.5 11696.2 11442.5 11481.6 11518.0 11599.7 11601.0 7376.8 7486.8 7807.7 8005.0 8301.9 9403.7 11001.7 11247.6 11264.4 11315.5 05:57:34 INFO - PROCESS | 1671 | 05:57:34 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:5618.52 Median:5036.01 stddev:3147.05 (62.5%) stddev-sans-first:3139.63 05:57:34 INFO - PROCESS | 1671 | Values: 1363.5 1538.2 1742.2 1884.9 1948.2 6954.7 7830.7 8402.8 8932.1 8935.5 7953.1 8479.9 8679.2 8682.8 8803.0 2297.1 2310.5 2331.8 2332.5 2332.8 2029.9 2115.4 2259.2 2299.9 2322.6 2083.0 2234.6 2302.4 2305.5 2305.9 2256.9 2272.0 2278.8 2281.5 2316.5 2133.1 2278.1 2279.2 2280.5 2283.8 8018.9 8758.0 8769.6 8786.6 8789.1 5130.6 5304.9 5312.3 5313.0 5323.3 3497.1 3518.9 3583.2 3618.4 3634.1 1042.6 1055.9 1075.4 1083.3 1089.5 11424.8 11493.8 11497.5 11514.5 11549.5 4361.0 4579.7 4631.4 4663.8 4674.1 9741.0 9745.4 9754.8 9756.2 9809.1 5284.6 5286.4 5287.1 5289.8 5292.5 4579.6 4589.7 4747.6 4853.8 4868.7 3707.6 3749.0 3822.4 3863.6 3868.0 1159.9 1205.3 1253.1 1261.7 1268.4 747.3 800.7 827.3 888.4 903.7 5648.6 5670.3 5807.6 5878.6 6016.6 921.1 964.2 978.8 994.7 1025.8 3120.8 3881.1 3992.0 4049.0 4060.3 9114.6 10336.6 10589.4 10608.7 10617.6 10403.3 10534.7 10535.2 10536.5 10542.9 7806.7 8196.2 8212.3 8324.2 8330.2 5786.0 5790.7 5807.7 5988.6 6120.4 9909.9 10021.9 10024.5 10059.9 10064.5 9829.4 9923.9 9980.5 10241.2 10250.1 6654.9 7061.6 7473.9 7478.1 7499.3 8030.6 8101.5 8109.8 8188.4 8213.0 7341.0 7416.7 7418.5 7470.1 7550.0 7167.7 7207.3 7221.2 7258.9 7303.9 6684.7 6779.0 6779.3 6849.3 6864.6 4959.6 4969.2 5016.1 5059.2 5162.2 4293.3 4965.6 5055.9 5128.5 5140.6 05:57:34 INFO - PROCESS | 1671 | 05:57:34 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:4229.18 Median:4519.92 stddev:1280.89 (28.3%) stddev-sans-first:1250.06 05:57:34 INFO - PROCESS | 1671 | Values: 299.5 301.9 308.3 314.8 317.4 4634.6 5151.9 5335.3 5370.9 5463.2 5167.5 5202.7 5243.2 5269.1 5295.8 3872.9 4080.0 4087.0 4108.5 4119.9 3893.5 4103.7 4107.8 4123.2 4137.4 4075.8 4102.0 4110.0 4114.2 4115.3 3426.8 4063.2 4067.1 4068.8 4083.7 2996.3 3550.3 3558.5 3562.0 3566.9 4652.8 4723.9 4774.8 5183.3 5257.3 4668.4 4668.9 4685.8 4712.7 4735.8 5089.4 5546.9 5554.9 5562.9 5574.3 3598.3 3626.7 3690.5 3924.2 3969.6 5871.2 5884.4 5891.4 5916.3 5924.0 3984.5 3996.7 4002.8 4002.9 4010.3 3851.4 4024.8 4028.4 4034.9 4063.5 4230.2 4310.4 4592.8 4617.7 4723.1 5553.4 5558.5 5581.8 5584.2 5598.9 1105.2 1123.0 1301.4 1338.1 1347.4 810.6 838.1 844.2 845.9 848.1 4378.6 4386.9 4389.5 4391.8 4395.6 4016.6 4325.0 4404.0 4633.4 4719.4 3723.3 3842.4 4285.5 4308.0 4349.5 2095.3 2224.4 2255.9 2528.6 2560.9 4478.9 4909.8 4947.5 4958.7 4974.8 4020.6 4227.9 4354.7 4868.9 4895.7 4038.5 4493.7 4536.6 4716.6 4885.9 3872.7 4613.6 4718.5 4738.2 4770.0 3958.9 4056.5 4414.1 4503.2 4724.1 3838.4 4093.5 4172.6 4385.6 4915.8 3364.2 3390.0 3404.5 3415.7 3446.0 4636.8 4748.8 4757.6 4758.7 4760.0 4348.2 4804.9 5440.4 5445.4 5501.8 5377.9 5546.6 5561.2 5578.6 5580.3 4616.4 4643.8 5058.7 5217.6 5526.4 4957.9 5264.2 5416.0 5616.0 5673.7 5550.9 5560.4 5563.2 5571.7 5636.1 05:57:34 INFO - PROCESS | 1671 | 05:57:34 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:20630.41 Median:4484.13 stddev:29782.65 (664.2%) stddev-sans-first:29828.61 05:57:34 INFO - PROCESS | 1671 | Values: 703.4 720.1 746.4 774.4 827.6 14881.4 15453.6 15466.5 15471.2 15483.5 13907.7 14078.6 14084.0 14087.5 14098.1 693.9 713.9 718.1 864.8 865.2 884.8 884.9 895.0 899.7 900.8 959.3 962.0 962.5 964.8 965.4 687.5 752.3 950.6 951.1 952.4 557.1 558.4 559.3 675.6 697.9 14496.2 14565.3 14575.1 14585.9 14586.0 13498.5 13641.5 13680.0 13693.4 13903.8 12189.3 12242.5 12252.3 12458.2 12771.4 4409.8 4448.6 4519.6 4572.1 4658.2 98007.0 100373.5 100906.5 100920.5 101733.0 10884.2 10959.0 10966.5 10994.4 11285.1 21125.3 21327.9 21376.1 21421.1 21617.7 6025.3 7478.4 7607.4 7703.8 7915.1 3702.9 4277.9 4293.0 4308.5 4322.7 3381.5 3516.3 3528.8 3530.2 3534.6 552.4 652.2 659.1 665.6 665.9 529.8 569.0 605.3 610.2 617.3 7573.0 7784.1 8461.6 8724.3 8739.6 520.5 558.4 615.6 656.3 678.0 3510.3 4145.2 4320.0 4412.5 4555.8 97560.0 99872.0 100776.0 101957.5 101961.5 84563.0 86086.7 87047.1 90832.0 93098.5 84676.6 87168.6 87307.0 87621.0 89713.6 7820.7 8049.5 8135.2 8245.2 8423.7 51170.0 53017.2 53746.0 54329.5 55879.4 68647.7 75504.6 76346.6 76638.5 78011.0 12561.9 12702.4 12726.9 12994.5 13567.5 13435.3 13992.0 15043.5 15190.3 15229.0 13059.1 13278.0 13291.9 13678.3 13910.7 10569.6 13076.6 13113.3 13303.3 13365.9 12888.0 12990.9 13012.5 13042.5 13535.6 9165.7 10509.7 10794.7 11363.0 11434.1 9714.7 11138.8 11328.7 11398.4 11445.7 05:57:34 INFO - PROCESS | 1671 | -------- Summary: end -------- 05:57:34 INFO - PROCESS | 1671 | 05:57:35 INFO - TEST-INFO | 1671: exit 0 05:57:35 INFO - TEST-OK | dromaeo_css | took 1118525ms 05:57:35 INFO - TEST-START | kraken 05:57:35 INFO - operating with platform_type : mac_ 05:57:35 INFO - Initialising browser for kraken test... 05:57:35 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/tmpOtWWeS/profile http://localhost:49278/getInfo.html) 05:57:38 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 05:57:38 INFO - PROCESS | 1676 | colorDepth:24 05:57:38 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 05:57:38 INFO - PROCESS | 1676 | __metrics 05:57:38 INFO - PROCESS | 1676 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:57:38 INFO - PROCESS | 1676 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:57:38 INFO - TEST-INFO | 1676: exit 0 05:57:38 INFO - Browser initialized. 05:57:38 INFO - Running cycle 1/1 for kraken test... 05:57:38 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/tmpOtWWeS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:50 INFO - PROCESS | 1677 | RSS: Main: 231452672 05:57:50 INFO - PROCESS | 1677 | 05:57:53 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 05:57:54 INFO - PROCESS | 1677 | RSS: Main: 290131968 05:57:54 INFO - PROCESS | 1677 | 05:57:56 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 05:57:57 INFO - PROCESS | 1677 | RSS: Main: 290758656 05:57:57 INFO - PROCESS | 1677 | 05:58:00 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 05:58:01 INFO - PROCESS | 1677 | RSS: Main: 382177280 05:58:01 INFO - PROCESS | 1677 | 05:58:03 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 05:58:04 INFO - PROCESS | 1677 | RSS: Main: 283312128 05:58:04 INFO - PROCESS | 1677 | 05:58:06 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:58:06 INFO - PROCESS | 1677 | RSS: Main: 288727040 05:58:06 INFO - PROCESS | 1677 | 05:58:09 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 05:58:10 INFO - PROCESS | 1677 | RSS: Main: 325844992 05:58:10 INFO - PROCESS | 1677 | 05:58:12 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 05:58:13 INFO - PROCESS | 1677 | RSS: Main: 328470528 05:58:13 INFO - PROCESS | 1677 | 05:58:16 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 05:58:16 INFO - PROCESS | 1677 | RSS: Main: 327569408 05:58:16 INFO - PROCESS | 1677 | 05:58:18 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:58:19 INFO - PROCESS | 1677 | RSS: Main: 302239744 05:58:19 INFO - PROCESS | 1677 | 05:58:21 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:58:21 INFO - PROCESS | 1677 | RSS: Main: 303616000 05:58:21 INFO - PROCESS | 1677 | 05:58:23 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:58:24 INFO - PROCESS | 1677 | RSS: Main: 306200576 05:58:24 INFO - PROCESS | 1677 | 05:58:27 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:58:28 INFO - PROCESS | 1677 | RSS: Main: 313585664 05:58:28 INFO - PROCESS | 1677 | 05:58:31 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:58:31 INFO - PROCESS | 1677 | RSS: Main: 313438208 05:58:31 INFO - PROCESS | 1677 | 05:58:33 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 05:58:33 INFO - PROCESS | 1677 | RSS: Main: 357412864 05:58:33 INFO - PROCESS | 1677 | 05:58:33 INFO - PROCESS | 1677 | __start_tp_report 05:58:33 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 05:58:33 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 05:58:33 INFO - PROCESS | 1677 | |i|pagename|runs| 05:58:33 INFO - PROCESS | 1677 | |0;ai-astar;102;112;112;112;112;112;111;112;111;111 05:58:33 INFO - PROCESS | 1677 | |1;audio-beat-detection;149;112;112;148;114;114;111;112;142;109 05:58:33 INFO - PROCESS | 1677 | |2;audio-dft;181;184;181;182;182;182;183;182;185;181 05:58:33 INFO - PROCESS | 1677 | |3;audio-fft;80;61;60;87;62;58;73;82;97;62 05:58:33 INFO - PROCESS | 1677 | |4;audio-oscillator;88;71;89;70;67;68;91;67;68;89 05:58:33 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;88;83;128;98;87;86;89;86;89;85 05:58:33 INFO - PROCESS | 1677 | |6;imaging-darkroom;96;97;96;97;96;96;97;96;95;95 05:58:33 INFO - PROCESS | 1677 | |7;imaging-desaturate;83;80;79;79;82;81;85;86;81;80 05:58:33 INFO - PROCESS | 1677 | |8;json-parse-financial;57;55;56;55;53;54;52;53;53;73 05:58:33 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;67;76;66;75;71;67;69;68;66;69 05:58:33 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;86;87;86;89;86;87;88;84;89;87 05:58:33 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;150;162;156;159;161;158;150;145;177;148 05:58:33 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;171;171;171;170;230;211;170;170;169;172 05:58:33 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;68;70;70;69;70;78;87;88;70;68 05:58:33 INFO - PROCESS | 1677 | __end_tp_report 05:58:33 INFO - PROCESS | 1677 | __start_cc_report 05:58:33 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1983 05:58:33 INFO - PROCESS | 1677 | __end_cc_report 05:58:33 INFO - PROCESS | 1677 | __startTimestamp1477486713908__endTimestamp 05:58:33 INFO - PROCESS | 1677 | 05:58:33 INFO - PROCESS | 1677 | ------- Summary: start ------- 05:58:33 INFO - PROCESS | 1677 | Number of tests: 14 05:58:33 INFO - PROCESS | 1677 | 05:58:33 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:3.09 (2.8%) stddev-sans-first:0.50 05:58:33 INFO - PROCESS | 1677 | Values: 102.0 112.0 112.0 112.0 112.0 112.0 111.0 112.0 111.0 111.0 05:58:33 INFO - PROCESS | 1677 | 05:58:33 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:122.30 Median:114.00 stddev:16.74 (14.7%) stddev-sans-first:14.71 05:58:33 INFO - PROCESS | 1677 | Values: 149.0 112.0 112.0 148.0 114.0 114.0 111.0 112.0 142.0 109.0 05:58:33 INFO - PROCESS | 1677 | 05:58:33 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:182.30 Median:182.00 stddev:1.34 (0.7%) stddev-sans-first:1.33 05:58:33 INFO - PROCESS | 1677 | Values: 181.0 184.0 181.0 182.0 182.0 182.0 183.0 182.0 185.0 181.0 05:58:33 INFO - PROCESS | 1677 | 05:58:33 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:72.20 Median:76.50 stddev:13.64 (17.8%) stddev-sans-first:14.18 05:58:33 INFO - PROCESS | 1677 | Values: 80.0 61.0 60.0 87.0 62.0 58.0 73.0 82.0 97.0 62.0 05:58:33 INFO - PROCESS | 1677 | 05:58:33 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:76.80 Median:79.50 stddev:10.81 (13.6%) stddev-sans-first:10.68 05:58:33 INFO - PROCESS | 1677 | Values: 88.0 71.0 89.0 70.0 67.0 68.0 91.0 67.0 68.0 89.0 05:58:33 INFO - PROCESS | 1677 | 05:58:33 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:91.90 Median:87.50 stddev:13.30 (15.2%) stddev-sans-first:14.04 05:58:33 INFO - PROCESS | 1677 | Values: 88.0 83.0 128.0 98.0 87.0 86.0 89.0 86.0 89.0 85.0 05:58:33 INFO - PROCESS | 1677 | 05:58:33 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 05:58:33 INFO - PROCESS | 1677 | Values: 96.0 97.0 96.0 97.0 96.0 96.0 97.0 96.0 95.0 95.0 05:58:33 INFO - PROCESS | 1677 | 05:58:33 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:81.60 Median:81.50 stddev:2.41 (3.0%) stddev-sans-first:2.51 05:58:33 INFO - PROCESS | 1677 | Values: 83.0 80.0 79.0 79.0 82.0 81.0 85.0 86.0 81.0 80.0 05:58:33 INFO - PROCESS | 1677 | 05:58:33 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:55.00 stddev:6.14 (11.2%) stddev-sans-first:6.50 05:58:33 INFO - PROCESS | 1677 | Values: 57.0 55.0 56.0 55.0 53.0 54.0 52.0 53.0 53.0 73.0 05:58:33 INFO - PROCESS | 1677 | 05:58:33 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.00 stddev:3.57 (5.2%) stddev-sans-first:3.67 05:58:33 INFO - PROCESS | 1677 | Values: 67.0 76.0 66.0 75.0 71.0 67.0 69.0 68.0 66.0 69.0 05:58:33 INFO - PROCESS | 1677 | 05:58:33 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:87.00 stddev:1.52 (1.8%) stddev-sans-first:1.58 05:58:33 INFO - PROCESS | 1677 | Values: 86.0 87.0 86.0 89.0 86.0 87.0 88.0 84.0 89.0 87.0 05:58:33 INFO - PROCESS | 1677 | 05:58:33 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:156.60 Median:158.50 stddev:9.24 (5.8%) stddev-sans-first:9.49 05:58:33 INFO - PROCESS | 1677 | Values: 150.0 162.0 156.0 159.0 161.0 158.0 150.0 145.0 177.0 148.0 05:58:33 INFO - PROCESS | 1677 | 05:58:33 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.50 Median:171.00 stddev:21.57 (12.6%) stddev-sans-first:22.60 05:58:33 INFO - PROCESS | 1677 | Values: 171.0 171.0 171.0 170.0 230.0 211.0 170.0 170.0 169.0 172.0 05:58:33 INFO - PROCESS | 1677 | 05:58:33 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.80 Median:70.00 stddev:7.76 (11.1%) stddev-sans-first:7.94 05:58:33 INFO - PROCESS | 1677 | Values: 68.0 70.0 70.0 69.0 70.0 78.0 87.0 88.0 70.0 68.0 05:58:33 INFO - PROCESS | 1677 | -------- Summary: end -------- 05:58:33 INFO - PROCESS | 1677 | 05:58:34 INFO - TEST-INFO | 1677: exit 0 05:58:34 INFO - TEST-OK | kraken | took 59382ms 05:58:34 INFO - SUITE-END | took 1177s 05:58:35 INFO - Completed test suite (00:19:38) 05:58:35 INFO - javascript benchmark 05:58:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3356.563646725927, 3364.8149351785655, 3366.2257680733433, 3390.5761779777526, 3418.589769227693, 5595.7481913313895, 5714.71426428679, 5725.312962444507, 5783.450572195645, 5800.216970708958, 5695.914561281584, 5721.31344238692, 5728.627639203449, 5731.0, 5735.971320143404, 5162.63861529694, 5211.635185537014, 5212.192110222922, 5249.028929648009, 5253.4221235664045, 5289.576833853283, 5301.0, 5302.549283310923, 5314.9468505314835, 5314.9468505314835, 5210.296609957645, 5279.102552566073, 5293.0, 5301.3108295921475, 5315.787368505275, 5323.361196656426, 5323.547498462596, 5330.253764472957, 5341.412444631087, 5408.134698448269, 5129.102407078746, 5130.204818253177, 5203.297554830087, 5251.55361794248, 5268.789248430058, 5675.262215911905, 5729.427057294279, 5771.336296325934, 5778.682172480512, 5806.680632565207, 6249.87500249997, 6280.2777680566405, 6291.43377096059, 6293.087502312139, 6306.905396419057, 6110.856892744153, 6202.937970620281, 6208.910520404343, 6299.748010079637, 6312.400321969406, 5771.451712087303, 5841.824745257564, 5851.61964472308, 5868.941310586925, 5920.407959204045, 6244.65654389013, 6263.0, 6280.685965701697, 6282.403171698681, 6290.0, 6032.969835150796, 6131.448169664663, 6193.071039344134, 6206.162168107338, 6227.314995350508, 6186.4741496972365, 6186.783462578788, 6192.442680158807, 6221.004639257697, 6231.781887633911, 6153.323134455206, 6238.469730072995, 6244.375562443719, 6256.968715156395, 6266.655333956676, 6132.601380910227, 6231.470325022424, 6258.593191442542, 6262.405071518198, 6273.560850740404, 4840.419149701988, 4900.044491324157, 4914.189158788831, 4925.40895092584, 4960.479149689303, 4403.097365040223, 4451.643868490513, 4461.57615026572, 4471.083427897273, 4487.798049087799, 5816.534677225812, 5838.036723940502, 5857.179994800731, 5871.911921321183, 5899.498542623839, 6238.112591542365, 6245.28179259391, 6276.215473065867, 6291.6854157291955, 6307.653079080695, 5676.914846277309, 5757.309122905278, 5830.41695830422, 5839.795607153814, 5849.766009359663, 5349.973250133802, 5379.67721936685, 5416.891662166735, 5430.294061771944, 5454.7818087276855, 6234.2830574482705, 6290.874182516324, 6299.370062993756, 6323.747050117944, 6327.810165695037, 6258.906116408167, 6268.341824108403, 6299.30707622152, 6324.051392291193, 6328.7152078157515, 5365.382980957083, 6205.906911396242, 6235.75056997715, 6264.029075493306, 6283.7800676976085, 6205.720742566686, 6211.472024877936, 6234.719437625408, 6242.0, 6255.40573645503, 5784.2769653793275, 6268.811935641756, 6297.653629050446, 6306.211723534559, 6306.369363063657, 5967.373425790403, 6022.638641681513, 6039.909401359071, 6077.24034495688, 6166.920788862021, 6081.604695694766, 6099.703252314951, 6128.130920069243, 6143.907841382294, 6161.168242287413, 5998.130271110752, 5998.520118390606, 6006.429389208019, 6026.276846778414, 6031.276246850406, 5955.553333499918, 6075.1798507200965, 6095.9390406097145, 6101.908471372844, 6108.664023478751, 5845.947729408747, 5904.025835737227, 5921.733521991607, 5985.0, 5996.430339117776], "value": 5727.666565404005, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.4187684163212, 512.6385897941951, 517.6997341541907, 520.9531142197203, 536.6109570561343, 28563.714362856364, 34946.650533494656, 39088.41367379488, 39921.60078399215, 39952.0, 40985.97535061625, 41334.79332603333, 41372.58627413725, 41410.792946035304, 41506.0, 9363.906360936371, 9527.190188833958, 9544.665936692218, 9552.283578731589, 9552.952235238814, 9415.0, 9516.191123754454, 9517.857232141523, 9524.095210954949, 9527.904720952805, 9515.476648784314, 9522.428654280731, 9543.284253680968, 9567.091126342986, 9576.61693532258, 8136.755897323031, 9473.0, 9473.336866419353, 9520.8571871422, 9521.476318802463, 9321.0, 9371.062893710574, 9381.812363752755, 9384.67153649619, 9422.764430889283, 38874.0, 39396.40905386421, 39417.80291098555, 39420.60579394227, 39532.407013894815, 3357.932841343184, 3395.9320813583836, 3547.3082748863726, 3729.7948612826285, 3826.2730081284744, 27913.860430697718, 30210.54684179739, 30311.393772124433, 30337.0, 30755.692443075506, 3144.606924134483, 3167.651558328582, 3205.4390481665614, 3237.7409807215367, 3275.737940964717, 472677.0, 473987.0, 474723.0, 474819.0, 475011.0, 54918.0, 55180.724096379265, 55191.72404137954, 55296.17055744167, 55405.72297138489, 33830.830845845616, 34316.313673726385, 34601.307973840885, 35136.12159695977, 57595.0, 15273.312700928485, 15390.615234619, 15393.461228856937, 15397.384104635914, 15414.845851541566, 12453.25280483174, 12567.18313309632, 12575.0, 12578.748425031448, 12587.74824503523, 18465.7230141548, 18468.445946621356, 18519.259229630934, 18724.812751872578, 18770.061496925373, 7755.379569634416, 7815.882761758465, 7840.686372545034, 7892.9478335632, 7976.361891048702, 889.5774507109071, 995.4972738767021, 1037.5538518437145, 1071.2019545438543, 1127.1715289262386, 29136.854315728287, 29223.415531689247, 29603.407931841244, 29909.25226869302, 30057.54913676253, 1015.7155996321042, 1042.635077722791, 1049.2340591368343, 1067.6209945469402, 1071.5285274479204, 13224.867751322556, 14243.002989790615, 14679.55961321162, 15229.086254824524, 15799.0, 615982.0, 616768.0, 620378.0, 620600.0, 620972.0, 55239.72380138154, 55797.0, 55832.441675583534, 55991.44008559944, 56024.43975560274, 1159.4087015622263, 1229.1150371732338, 1266.4174479739238, 1385.6882201504782, 1401.6706074072586, 28840.278993025342, 29897.402051958405, 30325.090247292617, 30678.079657610306, 30937.0, 53611.19583206177, 54367.45632543624, 54381.0, 54413.455865442425, 54484.72757636345, 592408.0, 598457.0, 598995.0, 599841.0, 600514.0, 34252.31495370129, 35013.0, 35091.12272193113, 35959.82020089883, 41520.0, 43979.78010109929, 44455.33317000183, 44827.0, 45246.868828279556, 45381.77309113433, 36884.446733299555, 36910.63089369072, 37161.256774864894, 38157.80921095377, 38618.80690596641, 37114.628853712195, 37282.81358593189, 37622.62377376191, 38216.0, 38426.0393490165, 35428.29143417066, 36180.27639447249, 37413.25173496569, 37534.74513568048, 37564.436533452565, 31491.37017259688, 33233.83383083069, 33349.499757503174, 33415.83292083621, 33512.66487335096, 24755.752442475346, 24984.75015249897, 25506.48987020212, 25741.871290643427, 25970.439420752376], "value": 19593.369055809402, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.17590837440383, 353.2722591461589, 374.7152164355091, 377.87530115062026, 401.80311647292837, 15275.923620381896, 15373.769393459093, 16328.591785205375, 17581.648367032652, 18153.27386904522, 18636.34772782953, 20811.791882081176, 21418.143274269012, 21596.8920155399, 21728.674069888963, 5798.449147330997, 5833.474987251147, 5878.941210587882, 5882.441168089024, 5888.9988701920565, 4892.828750993716, 6475.805725828209, 6563.3764792344655, 6594.340565943391, 6615.140031795884, 4950.257461380804, 6441.967790161043, 6543.247526534462, 6563.081168636395, 6573.309802470743, 6471.352864713538, 6520.608763474207, 6523.5107366947195, 6532.934670653304, 6542.345765423467, 4862.854114376574, 4959.132151873408, 5225.451327610622, 5269.736513174326, 5299.920501192485, 12611.74776504474, 12669.683257918534, 12706.618801435972, 12846.807297890538, 12865.67835804103, 2157.2341818654468, 2271.3867255840833, 2295.01314434793, 2575.549278876189, 2678.9196324110308, 9006.369554131214, 9624.855627165598, 10114.494275286206, 10169.084782369548, 12596.559120430833, 1727.550836782433, 1791.8745687801859, 1806.2594336322045, 1814.954626134344, 1817.1277786662477, 115406.42296788462, 116490.41754791171, 118480.0, 119463.46720167578, 121212.39393803063, 11328.263662861887, 11460.312381256985, 11563.42182890852, 11564.653060408202, 11678.532858685558, 14458.783118253235, 14487.565373038826, 14503.85496145046, 14507.709845803025, 14537.491187808588, 6140.416660417253, 7836.568988705562, 8335.749927502186, 8490.575471226413, 8612.956935215283, 8358.373122015752, 8397.370197235232, 8414.747557573282, 8556.443831150955, 8586.356023298278, 4415.2494076006515, 4493.303537951622, 4500.639948804088, 4564.497905230422, 4590.862274131781, 1733.2806885142525, 1737.8696597754965, 1804.3233787329752, 1906.2851430713483, 1907.637548865711, 701.0431601324922, 821.5317269156643, 942.5381563034201, 994.5524513968743, 1061.1722856172198, 20269.0, 21992.78007219939, 21999.450013749465, 22049.0, 22089.0, 891.888513935758, 929.4469790474657, 967.3615413826841, 981.5239608789731, 1012.3875055591409, 8513.659453621909, 10141.391516509033, 11395.829062564067, 11436.771264574829, 11448.713782155513, 498902.0, 551422.0, 552934.2353288208, 569407.0, 570259.0, 112575.35875010633, 119236.0, 122451.0, 122587.0, 125318.0, 947.4741518457322, 960.1214888377197, 981.0238812381726, 981.5975450065439, 984.1536278800226, 15031.323590438238, 18928.621427571095, 19171.424857254304, 19211.711824322367, 19259.325923592605, 50382.49617503778, 51586.48413515967, 51777.18779842687, 52977.65695352967, 53250.0, 74917.62541187259, 78196.60901695455, 78390.0, 79140.60429697814, 81308.0, 8011.879821802561, 8011.959940200495, 8148.674053037812, 8205.220504052344, 8215.876761848696, 11303.321800691985, 12773.443552054885, 12865.485380584672, 13039.608811735663, 13555.254461004739, 9615.56729947168, 9643.9035609643, 11064.723381915517, 11213.196700824794, 11228.214025018171, 11007.724806879893, 11019.338839669645, 11200.43997800123, 11634.476448559666, 11696.181267311207, 11442.526248775515, 11481.598144064918, 11518.020968217796, 11599.6520104397, 11601.01391381742, 7376.7786966391095, 7486.812829679084, 7807.687692492236, 8005.0, 8301.916980830356, 9403.670871519464, 11001.669949901516, 11247.606333778278, 11264.436778160894, 11315.547378104784], "value": 9279.937624195345, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.5227670315392, 1538.2462593329271, 1742.1985886492214, 1884.896330701811, 1948.181763659262, 6954.687039083241, 7830.725924592641, 8402.831943361129, 8932.062133475989, 8935.463872167675, 7953.125156232824, 8479.915200848005, 8679.175478329564, 8682.782930426742, 8802.987656419513, 2297.1041293895396, 2310.549442858643, 2331.755165707602, 2332.5218330242346, 2332.7550607186254, 2029.9289524866633, 2115.3653903828867, 2259.1641092795608, 2299.8620082795, 2322.628379459287, 2082.979170208301, 2234.597772400967, 2302.3898666853297, 2305.4812667149927, 2305.8501197422115, 2256.8871556422114, 2271.9886400567975, 2278.79490845823, 2281.5208806150727, 2316.467212541108, 2133.1040962795664, 2278.1229226747823, 2279.179495381661, 2280.5438912217624, 2283.7716228377194, 8018.879716804253, 8758.036615972302, 8769.561521923879, 8786.60460279289, 8789.077146899548, 5130.563902068328, 5304.92042619361, 5312.256284120226, 5313.0, 5323.307969963918, 3497.090756403353, 3518.8768393106375, 3583.229605634775, 3618.4391419330045, 3634.1096431374217, 1042.5725452564488, 1055.883852776194, 1075.4031512510553, 1083.2579682917149, 1089.4988305379534, 11424.828627570592, 11493.827592586118, 11497.540098396054, 11514.539418423254, 11549.538018479334, 4360.978195109004, 4579.725216486955, 4631.374764406829, 4663.836765713251, 4674.11191873543, 9741.0, 9745.366551174151, 9754.804903901882, 9756.219502439788, 9809.068138526829, 5284.550813180923, 5286.365636123613, 5287.127623942083, 5289.761960711778, 5292.52367286946, 4579.610733087658, 4589.678722489393, 4747.643926705442, 4853.781579828917, 4868.732219727949, 3707.5921648618632, 3748.9625103748613, 3822.4075268333454, 3863.594322596087, 3868.0, 1159.918805683594, 1205.3250179899285, 1253.078986944595, 1261.6782720406238, 1268.3594784633701, 747.2938073520471, 800.6797281087612, 827.2916427577154, 888.3603805260202, 903.7017784131352, 5648.576356773258, 5670.319561652628, 5807.593468457252, 5878.617889837147, 6016.608920420159, 921.1479381572019, 964.2237998411347, 978.8091322192104, 994.7065615643403, 1025.8409946458312, 3120.8127512349333, 3881.0805990557214, 3991.980040099781, 4049.0, 4060.269151552749, 9114.635414583476, 10336.586536538454, 10589.417582033062, 10608.734781630366, 10617.575296988189, 10403.271770976111, 10534.683959481228, 10535.157187424988, 10536.525856336484, 10542.947285263524, 7806.687732490636, 8196.221358970888, 8212.34301255898, 8324.167583241628, 8330.208630180123, 5785.9874521957645, 5790.739416726342, 5807.651540907559, 5988.550858685703, 6120.357362476876, 9909.851352229867, 10021.949890250502, 10024.498775061364, 10059.899401005896, 10064.54709538058, 9829.4102353859, 9923.900760992297, 9980.451075190935, 10241.18070554339, 10250.077493025663, 6654.90017649726, 7061.646917653994, 7473.925260747323, 7478.06524184477, 7499.325060744341, 8030.638621262174, 8101.513909165469, 8109.8378032440205, 8188.385871059813, 8212.97337832771, 7341.0, 7416.7033318666645, 7418.480706350504, 7470.140933792466, 7549.962250188714, 7167.7132914682825, 7207.279272072751, 7221.241769614115, 7258.927410726036, 7303.926960730325, 6684.665766711742, 6778.966105169443, 6779.254282029072, 6849.315068493111, 6864.553804002724, 4959.578435832995, 4969.180085285887, 5016.1221786188, 5059.241113832954, 5162.174052151638, 4293.291606884954, 4965.577925876341, 5055.898882022412, 5128.512791284822, 5140.64015518925], "value": 4514.485840623136, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.51329090228376, 301.8867924528302, 308.33707528813056, 314.770217741049, 317.39219394858816, 4634.58288754012, 5151.896962060757, 5335.33308336458, 5370.919436208455, 5463.235147079402, 5167.509086636773, 5202.661826981243, 5243.187305967581, 5269.104252277112, 5295.8146464873735, 3872.9031774205587, 4080.0411903202726, 4087.0, 4108.486439195093, 4119.949412899721, 3893.5133108361456, 4103.671706263507, 4107.815148318333, 4123.216588848124, 4137.420761093449, 4075.7962101894936, 4102.0, 4109.958900411002, 4114.218298523271, 4115.32097203961, 3426.760126791138, 4063.187362527506, 4067.1458993611377, 4068.837246510136, 4083.734557253769, 2996.3258266889993, 3550.3076900004507, 3558.466230065485, 3562.0, 3566.857325706969, 4652.790624421909, 4723.905521889577, 4774.830166609203, 5183.300254465675, 5257.290265814105, 4668.416447944007, 4668.906621867578, 4685.835995740167, 4712.717236965793, 4735.763211839394, 5089.3638295213095, 5546.86132846678, 5554.889022195536, 5562.9443705563235, 5574.331080270353, 3598.316319899237, 3626.6581364894896, 3690.538682664667, 3924.1759230561615, 3969.583193764642, 5871.2073870027425, 5884.440978107073, 5891.440313170285, 5916.349201587822, 5923.970380148115, 3984.5019372578427, 3996.741026576619, 4002.8398864045694, 4002.899927501836, 4010.2581022510344, 3851.3645248533676, 4024.7987600619854, 4028.436018957348, 4034.9105741449644, 4063.512378514597, 4230.196262710076, 4310.353446982915, 4592.759954812182, 4617.676762626584, 4723.078999595046, 5553.361363443175, 5558.527525160326, 5581.804636837691, 5584.21820945068, 5598.888022239533, 1105.170942090841, 1122.966311010671, 1301.4468850738588, 1338.056670047614, 1347.4273433790795, 810.5582457560644, 838.1325328285195, 844.160060739568, 845.8731190321378, 848.0925409811442, 4378.56214378566, 4386.8903277417685, 4389.495208051051, 4391.780410979438, 4395.604395604347, 4016.561699322265, 4325.005248792795, 4404.031113155101, 4633.397658304466, 4719.422160504305, 3723.343112314994, 3842.423636454554, 4285.450157156487, 4308.0, 4349.521552629209, 2095.3190213180474, 2224.353978056259, 2255.943601409945, 2528.595424732034, 2560.8975640974527, 4478.865634030984, 4909.846186146253, 4947.455779864212, 4958.727270000185, 4974.751262436864, 4020.6128885534445, 4227.894302642459, 4354.651627869763, 4868.85958556736, 4895.657303988758, 4038.51537815464, 4493.73037617744, 4536.61438777701, 4716.57550820421, 4885.8990634026995, 3872.7289089763444, 4613.607843333354, 4718.457377401505, 4738.223166312633, 4769.976150119227, 3958.8614398495915, 4056.484979312845, 4414.117176564636, 4503.234450143549, 4724.149653062482, 3838.405047217686, 4093.549709532009, 4172.624463798273, 4385.552767586625, 4915.754212289443, 3364.158960259935, 3389.9830500848325, 3404.4552871540436, 3415.684961289872, 3445.9655403445645, 4636.768161591975, 4748.791811807526, 4757.5727281814625, 4758.714477131245, 4760.001598657144, 4348.217320882271, 4804.8798780030775, 5440.4015558287765, 5445.428230035947, 5501.834944951658, 5377.865553361197, 5546.639468434539, 5561.249231353877, 5578.609497335147, 5580.330360356783, 4616.376789133558, 4643.8374656886845, 5058.696478211319, 5217.582593392443, 5526.419725928719, 4957.900841983213, 5264.1834669865575, 5415.970965516539, 5615.989121958087, 5673.744681489426, 5550.916736248879, 5560.388357280777, 5563.221149039218, 5571.721413929368, 5636.098224284095], "value": 3826.14303845698, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.3810246982655, 720.1214518287687, 746.4364404874319, 774.3882332956964, 827.598614671884, 14881.404743810235, 15453.613659658486, 15466.458673946414, 15471.226438678077, 15483.458078967238, 13907.652308692288, 14078.64803379916, 14084.0, 14087.506937257198, 14098.083624564397, 693.9063226464414, 713.9214686384494, 718.1203026292802, 864.7621903976394, 865.1564724393697, 884.8274586455643, 884.9469031858077, 894.9642014319419, 899.6806133822464, 900.8423525882944, 959.3236768078488, 962.0235461007084, 962.475450879269, 964.84080126779, 965.3918031640092, 687.5084314715003, 752.3417010116149, 950.6102497975796, 951.1439704266181, 952.4237836109193, 557.1225320120826, 558.3578884283066, 559.2980809084573, 675.587891386254, 697.9232284448707, 14496.20270885101, 14565.271736413242, 14575.052621579669, 14585.854141458556, 14586.0, 13498.52755153565, 13641.522546710918, 13680.0, 13693.383797729126, 13903.79144312836, 12189.268643881396, 12242.510299588006, 12252.264864108092, 12458.190217635825, 12771.361431928366, 4409.801558929824, 4448.644108471314, 4519.615832654228, 4572.0855828834365, 4658.18481765693, 98007.0, 100373.4943975841, 100906.49211995392, 100920.49539752254, 101733.0, 10884.183686223565, 10959.0, 10966.506507207196, 10994.395308257963, 11285.097192224603, 21125.26061587837, 21327.893360533097, 21376.14495420197, 21421.143154273967, 21617.67573486399, 6025.3372129065765, 7478.364339031244, 7607.391408687292, 7703.768886933289, 7915.0897646771355, 3702.889133260011, 4277.871663850089, 4292.978535107304, 4308.482982042175, 4322.69741118125, 3381.526586277923, 3516.2791627716256, 3528.752987290865, 3530.1880567469625, 3534.6465353464446, 552.4199590430113, 652.2433976587231, 659.1134923527848, 665.6438805239173, 665.9300773418818, 529.796028529019, 568.9829305120853, 605.3280858247342, 610.1938262742244, 617.2962822382488, 7573.0, 7784.13120347547, 8461.576921153917, 8724.258438032712, 8739.596610932045, 520.4795204795205, 558.4080874273284, 615.5844804756771, 656.2748163279603, 677.9559478403204, 3510.2552370341987, 4145.150244199932, 4319.97840010798, 4412.4705035395955, 4555.794989225493, 97560.0, 99872.0, 100776.0, 101957.4706379405, 101961.49019254856, 84563.0, 86086.70869936956, 87047.1295287039, 90832.0, 93098.53450732703, 84676.57661711652, 87168.56415717881, 87307.0, 87621.0, 89713.55143224243, 7820.72627458059, 8049.51702897828, 8135.227153420416, 8245.175482451707, 8423.70517031901, 51170.0, 53017.20474192967, 53746.0, 54329.456705432436, 55879.44120558743, 68647.65676171587, 75504.62247688726, 76346.6182669083, 76638.46723065396, 78011.0, 12561.937190313989, 12702.36488175569, 12726.872731272939, 12994.545190918272, 13567.52513662017, 13435.328233588478, 13992.0, 15043.473478428203, 15190.316435760638, 15229.0, 13059.085863989429, 13278.0, 13291.933540332624, 13678.316084195949, 13910.652233694238, 10569.63006294776, 13076.616915422886, 13113.27876966776, 13303.26832024248, 13365.933170334087, 12888.0, 12990.935045325092, 13012.496332652137, 13042.54351097745, 13535.59393218205, 9165.725028249164, 10509.684709458728, 10794.676159715222, 11363.022941970245, 11434.142439316918, 9714.708558743248, 11138.777224455627, 11328.716782080513, 11398.430078495876, 11445.656630301104], "value": 7356.490331693024, "unit": "score"}], "name": "dromaeo_css", "value": 7138.715834861276, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 112.0, 112.0, 112.0, 112.0, 111.0, 112.0, 111.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 112.0, 112.0, 148.0, 114.0, 114.0, 111.0, 112.0, 142.0, 109.0], "value": 122.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 184.0, 181.0, 182.0, 182.0, 182.0, 183.0, 182.0, 185.0, 181.0], "value": 182.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 61.0, 60.0, 87.0, 62.0, 58.0, 73.0, 82.0, 97.0, 62.0], "value": 72.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 89.0, 70.0, 67.0, 68.0, 91.0, 67.0, 68.0, 89.0], "value": 76.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 83.0, 128.0, 98.0, 87.0, 86.0, 89.0, 86.0, 89.0, 85.0], "value": 91.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 95.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 79.0, 79.0, 82.0, 81.0, 85.0, 86.0, 81.0, 80.0], "value": 81.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 56.0, 55.0, 53.0, 54.0, 52.0, 53.0, 53.0, 73.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 76.0, 66.0, 75.0, 71.0, 67.0, 69.0, 68.0, 66.0, 69.0], "value": 69.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 86.0, 89.0, 86.0, 87.0, 88.0, 84.0, 89.0, 87.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 162.0, 156.0, 159.0, 161.0, 158.0, 150.0, 145.0, 177.0, 148.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 171.0, 170.0, 230.0, 211.0, 170.0, 170.0, 169.0, 172.0], "value": 180.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 70.0, 69.0, 70.0, 78.0, 87.0, 88.0, 70.0, 68.0], "value": 73.8, "unit": "score"}], "name": "kraken", "value": 1457.1999999999998, "alertThreshold": 2.0}]} 05:58:35 INFO - Return code: 0 05:58:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:58:35 INFO - # TBPL SUCCESS # 05:58:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:58:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:58:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:58:35 INFO - 2016-10-26 05:58:35.204 screenresolution[1681:11337] starting screenresolution argv=screenresolution get 05:58:35 INFO - 2016-10-26 05:58:35.208 screenresolution[1681:11337] Display 0: 1600x1200x32@60 05:58:35 INFO - 2016-10-26 05:58:35.214 screenresolution[1682:11340] starting screenresolution argv=screenresolution list 05:58:35 INFO - Available Modes on Display 0 05:58:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:58:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:58:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:58:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:58:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:58:35 INFO - Intel Iris: 05:58:35 INFO - Chipset Model: Intel Iris 05:58:35 INFO - Type: GPU 05:58:35 INFO - Bus: Built-In 05:58:35 INFO - VRAM (Dynamic, Max): 1536 MB 05:58:35 INFO - Vendor: Intel (0x8086) 05:58:35 INFO - Device ID: 0x0a2e 05:58:35 INFO - Revision ID: 0x0009 05:58:35 INFO - Displays: 05:58:35 INFO - Display: 05:58:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:58:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:58:35 INFO - Display Serial Number: 1600x1200 60 05:58:35 INFO - Main Display: Yes 05:58:35 INFO - Mirror: Off 05:58:35 INFO - Online: Yes 05:58:35 INFO - Rotation: Supported 05:58:35 INFO - Return code: 0 05:58:35 INFO - Running post-action listener: _resource_record_post_action 05:58:35 INFO - [mozharness: 2016-10-26 12:58:35.454202Z] Finished run-tests step (success) 05:58:35 INFO - Running post-run listener: _resource_record_post_run 05:58:35 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 31345664; Write bytes: 704138752; Read time: 194; Write time: 1967 05:58:35 INFO - TinderboxPrint: CPU usage
53.7% 05:58:35 INFO - TinderboxPrint: I/O read bytes / time
31,345,664 / 194 05:58:35 INFO - TinderboxPrint: I/O write bytes / time
704,138,752 / 1,967 05:58:35 INFO - TinderboxPrint: CPU idle
2,243.9 (46.3%) 05:58:35 INFO - TinderboxPrint: CPU system
968.0 (20.0%) 05:58:35 INFO - TinderboxPrint: CPU user
1,637.9 (33.8%) 05:58:35 INFO - TinderboxPrint: Swap in / out
431,280,128 / 0 05:58:35 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 401517056; Write bytes: 396088832; Read time: 29765; Write time: 835 05:58:35 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 29166592; Write bytes: 295639040; Read time: 174; Write time: 1098 05:58:35 INFO - Running post-run listener: _upload_blobber_files 05:58:35 INFO - Blob upload gear active. 05:58:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:58:35 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 05:58:35 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:58:35 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:58:36 INFO - (blobuploader) - INFO - Open directory for files ... 05:58:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:58:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:58:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:37 INFO - (blobuploader) - INFO - Done attempting. 05:58:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:58:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:58:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:38 INFO - (blobuploader) - INFO - Done attempting. 05:58:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:58:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:58:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:40 INFO - (blobuploader) - INFO - Done attempting. 05:58:40 INFO - (blobuploader) - INFO - Iteration through files over. 05:58:40 INFO - Return code: 0 05:58:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:58:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:58:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0123f338ff59a2138ef2f3772e1090b84c23061c855321336f401963a0d3827e17419949f9332089f6887e8d4eeb6aee618cb3260312f1823ec0e8a653f5cf7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25e423910249444b2c0619211a1c1fdb73f76935158447518b579b183e2735790b48f3f7c815b2f54f229d87a46fcbbb2bcbce62d6974f5cff3b1fcb6f3dca70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f2b0f180efe8bea42cb96c400bd8146f6f2c910acc0597077e6dd92863e0e22e869e366f328c2e4b7b476f827e9119f3f50fc4fa10910dd5f5bccdbebdacc95"} 05:58:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:58:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:58:40 INFO - Contents: 05:58:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0123f338ff59a2138ef2f3772e1090b84c23061c855321336f401963a0d3827e17419949f9332089f6887e8d4eeb6aee618cb3260312f1823ec0e8a653f5cf7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25e423910249444b2c0619211a1c1fdb73f76935158447518b579b183e2735790b48f3f7c815b2f54f229d87a46fcbbb2bcbce62d6974f5cff3b1fcb6f3dca70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f2b0f180efe8bea42cb96c400bd8146f6f2c910acc0597077e6dd92863e0e22e869e366f328c2e4b7b476f827e9119f3f50fc4fa10910dd5f5bccdbebdacc95"} 05:58:40 INFO - Running post-run listener: copy_logs_to_upload_dir 05:58:40 INFO - Copying logs to upload dir... 05:58:40 INFO - mkdir: /builds/slave/test/build/upload/logs 05:58:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.392023 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-26 05:58:40.630392) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 05:58:40.633437) ========= 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.Z9qKcDLj23/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.xvCn07FoJx/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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/Fx-Team/sha512/0123f338ff59a2138ef2f3772e1090b84c23061c855321336f401963a0d3827e17419949f9332089f6887e8d4eeb6aee618cb3260312f1823ec0e8a653f5cf7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25e423910249444b2c0619211a1c1fdb73f76935158447518b579b183e2735790b48f3f7c815b2f54f229d87a46fcbbb2bcbce62d6974f5cff3b1fcb6f3dca70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f2b0f180efe8bea42cb96c400bd8146f6f2c910acc0597077e6dd92863e0e22e869e366f328c2e4b7b476f827e9119f3f50fc4fa10910dd5f5bccdbebdacc95"} build_url:https://queue.taskcluster.net/v1/task/Ti88ZL1iQmeBR1QqwBzmMA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011184 build_url: 'https://queue.taskcluster.net/v1/task/Ti88ZL1iQmeBR1QqwBzmMA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0123f338ff59a2138ef2f3772e1090b84c23061c855321336f401963a0d3827e17419949f9332089f6887e8d4eeb6aee618cb3260312f1823ec0e8a653f5cf7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25e423910249444b2c0619211a1c1fdb73f76935158447518b579b183e2735790b48f3f7c815b2f54f229d87a46fcbbb2bcbce62d6974f5cff3b1fcb6f3dca70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f2b0f180efe8bea42cb96c400bd8146f6f2c910acc0597077e6dd92863e0e22e869e366f328c2e4b7b476f827e9119f3f50fc4fa10910dd5f5bccdbebdacc95"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 05:58:40.668466) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 05:58:40.668806) ========= 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.Z9qKcDLj23/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.xvCn07FoJx/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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.005171 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 05:58:40.717709) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 05:58:40.718008) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 05:58:40.721352) ========= ========= Total master_lag: 0.20 =========