builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0243 starttime: 1477354238.31 results: success (0) buildid: 20161024160022 builduid: 221169c159df458cbb2e0db7f20f1772 revision: 8da98b978cfc0ce47aa7d40bb98edf91075e098e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 17:10:38.311453) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 17:10:38.311898) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 17:10:38.312175) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 17:10:38.338076) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:10:38.338612) ========= 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.uNK22YLExK/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.rLGtuoQ82o/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-24 17:10:38-- 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% 20.4M=0.001s 2016-10-24 17:10:38 (20.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125575 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:10:38.486785) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:10:38.487122) ========= 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.uNK22YLExK/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.rLGtuoQ82o/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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.025672 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:10:38.535665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:10:38.536034) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8da98b978cfc0ce47aa7d40bb98edf91075e098e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8da98b978cfc0ce47aa7d40bb98edf91075e098e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uNK22YLExK/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.rLGtuoQ82o/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-24 17:10:38,619 truncating revision to first 12 chars 2016-10-24 17:10:38,620 Setting DEBUG logging. 2016-10-24 17:10:38,620 attempt 1/10 2016-10-24 17:10:38,620 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8da98b978cfc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 17:10:38,920 unpacking tar archive at: mozilla-aurora-8da98b978cfc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.585689 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:10:39.142972) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 17:10:39.143272) ========= script_repo_revision: 8da98b978cfc0ce47aa7d40bb98edf91075e098e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 17:10:39.143657) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 17:10:39.143949) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 17:10:39.162404) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-24 17:10:39.162911) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uNK22YLExK/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.rLGtuoQ82o/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 17:10:39 INFO - MultiFileLogger online at 20161024 17:10:39 in /builds/slave/test 17:10:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 17:10:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:10:39 INFO - {'append_to_log': False, 17:10:39 INFO - 'base_work_dir': '/builds/slave/test', 17:10:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:10:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:10:39 INFO - 'branch': 'Mozilla-Aurora', 17:10:39 INFO - 'buildbot_json_path': 'buildprops.json', 17:10:39 INFO - 'config_files': ('talos/mac_config.py',), 17:10:39 INFO - 'default_actions': ('clobber', 17:10:39 INFO - 'read-buildbot-config', 17:10:39 INFO - 'download-and-extract', 17:10:39 INFO - 'populate-webroot', 17:10:39 INFO - 'create-virtualenv', 17:10:39 INFO - 'install', 17:10:39 INFO - 'run-tests'), 17:10:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:10:39 INFO - 'download_minidump_stackwalk': True, 17:10:39 INFO - 'download_symbols': 'ondemand', 17:10:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:10:39 INFO - 'tooltool.py': '/tools/tooltool.py', 17:10:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:10:39 INFO - '/tools/misc-python/virtualenv.py')}, 17:10:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:10:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:10:39 INFO - 'installer_path': 'installer.exe', 17:10:39 INFO - 'log_level': 'info', 17:10:39 INFO - 'log_name': 'talos', 17:10:39 INFO - 'log_to_console': True, 17:10:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:10:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:10:39 INFO - 'opt_config_files': (), 17:10:39 INFO - 'pip_index': False, 17:10:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:10:39 INFO - 'cmd': ('bash', 17:10:39 INFO - '-c', 17:10:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:10:39 INFO - 'enabled': True, 17:10:39 INFO - 'halt_on_failure': False, 17:10:39 INFO - 'name': 'check_screen_resolution'},), 17:10:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:10:39 INFO - 'cmd': ('bash', 17:10:39 INFO - '-c', 17:10:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:10:39 INFO - 'enabled': True, 17:10:39 INFO - 'halt_on_failure': False, 17:10:39 INFO - 'name': 'check_screen_resolution'},), 17:10:39 INFO - 'run_cmd_checks_enabled': True, 17:10:39 INFO - 'sps_profile': False, 17:10:39 INFO - 'sps_profile_interval': 0, 17:10:39 INFO - 'suite': 'dromaeojs', 17:10:39 INFO - 'system_bits': '32', 17:10:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:10:39 INFO - 'title': 't-yosemite-r7-0243', 17:10:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:10:39 INFO - 'use_talos_json': True, 17:10:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:10:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:10:39 INFO - 'work_dir': 'build'} 17:10:39 INFO - [mozharness: 2016-10-25 00:10:39.361202Z] Running clobber step. 17:10:39 INFO - Running pre-action listener: _resource_record_pre_action 17:10:39 INFO - Running main action method: clobber 17:10:39 INFO - rmtree: /builds/slave/test/build 17:10:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:10:41 INFO - Running post-action listener: _resource_record_post_action 17:10:41 INFO - [mozharness: 2016-10-25 00:10:41.452156Z] Finished clobber step (success) 17:10:41 INFO - [mozharness: 2016-10-25 00:10:41.452416Z] Running read-buildbot-config step. 17:10:41 INFO - Running pre-action listener: _resource_record_pre_action 17:10:41 INFO - Running main action method: read_buildbot_config 17:10:41 INFO - Using buildbot properties: 17:10:41 INFO - { 17:10:41 INFO - "project": "", 17:10:41 INFO - "product": "firefox", 17:10:41 INFO - "script_repo_revision": "production", 17:10:41 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 17:10:41 INFO - "repository": "", 17:10:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 17:10:41 INFO - "buildid": "20161024160022", 17:10:41 INFO - "pgo_build": "False", 17:10:41 INFO - "basedir": "/builds/slave/test", 17:10:41 INFO - "buildnumber": 4, 17:10:41 INFO - "slavename": "t-yosemite-r7-0243", 17:10:41 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 17:10:41 INFO - "platform": "yosemite_r7", 17:10:41 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 17:10:41 INFO - "branch": "mozilla-aurora", 17:10:41 INFO - "repo_path": "releases/mozilla-aurora", 17:10:41 INFO - "revision": "8da98b978cfc0ce47aa7d40bb98edf91075e098e", 17:10:41 INFO - "stage_platform": "macosx64", 17:10:41 INFO - "builduid": "221169c159df458cbb2e0db7f20f1772", 17:10:41 INFO - "slavebuilddir": "test" 17:10:41 INFO - } 17:10:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/AK9iXXhxTiCCgjkfXP7Osg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 17:10:41 INFO - Running post-action listener: _resource_record_post_action 17:10:41 INFO - [mozharness: 2016-10-25 00:10:41.458167Z] Finished read-buildbot-config step (success) 17:10:41 INFO - [mozharness: 2016-10-25 00:10:41.458321Z] Running download-and-extract step. 17:10:41 INFO - Running pre-action listener: _resource_record_pre_action 17:10:41 INFO - Running main action method: download_and_extract 17:10:41 INFO - mkdir: /builds/slave/test/build/tests 17:10:41 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')]} 17:10:41 INFO - trying https://queue.taskcluster.net/v1/task/AK9iXXhxTiCCgjkfXP7Osg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 17:10:41 INFO - Downloading https://queue.taskcluster.net/v1/task/AK9iXXhxTiCCgjkfXP7Osg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 17:10:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AK9iXXhxTiCCgjkfXP7Osg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 17:10:42 INFO - Downloaded 1199 bytes. 17:10:42 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 17:10:42 INFO - Using the following test package requirements: 17:10:42 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 17:10:42 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 17:10:42 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 17:10:42 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 17:10:42 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 17:10:42 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 17:10:42 INFO - u'jsshell-mac.zip'], 17:10:42 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 17:10:42 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 17:10:42 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 17:10:42 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 17:10:42 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 17:10:42 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 17:10:42 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 17:10:42 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 17:10:42 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 17:10:42 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 17:10:42 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 17:10:42 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 17:10:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AK9iXXhxTiCCgjkfXP7Osg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 17:10:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AK9iXXhxTiCCgjkfXP7Osg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 17:10:42 INFO - Fetch https://queue.taskcluster.net/v1/task/AK9iXXhxTiCCgjkfXP7Osg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 17:10:44 INFO - Expected file size: 16438498 17:10:51 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 17:10:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AK9iXXhxTiCCgjkfXP7Osg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 17:10:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AK9iXXhxTiCCgjkfXP7Osg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 17:10:51 INFO - Fetch https://queue.taskcluster.net/v1/task/AK9iXXhxTiCCgjkfXP7Osg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 17:10:52 INFO - Expected file size: 16438498 17:10:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AK9iXXhxTiCCgjkfXP7Osg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 17:10:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AK9iXXhxTiCCgjkfXP7Osg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 17:10:58 INFO - Fetch https://queue.taskcluster.net/v1/task/AK9iXXhxTiCCgjkfXP7Osg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 17:10:59 INFO - Expected file size: 14414081 17:10: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')]} 17:10:59 INFO - trying https://queue.taskcluster.net/v1/task/AK9iXXhxTiCCgjkfXP7Osg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 17:10:59 INFO - Downloading https://queue.taskcluster.net/v1/task/AK9iXXhxTiCCgjkfXP7Osg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 17:10:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AK9iXXhxTiCCgjkfXP7Osg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 17:11:02 INFO - Downloaded 115432728 bytes. 17:11:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AK9iXXhxTiCCgjkfXP7Osg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 17:11:02 INFO - mkdir: /builds/slave/test/properties 17:11:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:11:02 INFO - Writing to file /builds/slave/test/properties/build_url 17:11:02 INFO - Contents: 17:11:02 INFO - build_url:https://queue.taskcluster.net/v1/task/AK9iXXhxTiCCgjkfXP7Osg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 17:11:03 INFO - Running post-action listener: _resource_record_post_action 17:11:03 INFO - Running post-action listener: set_extra_try_arguments 17:11:03 INFO - [mozharness: 2016-10-25 00:11:03.524108Z] Finished download-and-extract step (success) 17:11:03 INFO - [mozharness: 2016-10-25 00:11:03.524224Z] Running populate-webroot step. 17:11:03 INFO - Running pre-action listener: _resource_record_pre_action 17:11:03 INFO - Running main action method: populate_webroot 17:11:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:11:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:11:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:11:03 INFO - '--tppagecycles', 17:11:03 INFO - '7'], 17:11:03 INFO - 'tests': ['tsvgm']}}, 17:11:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:11:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:11:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:11:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:11:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:11:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:11:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:03 INFO - 'talos_options': ['--disable-e10s'], 17:11:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:11:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:11:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:03 INFO - 'talos_options': ['--disable-e10s'], 17:11:03 INFO - 'tests': ['damp', 'tps']}, 17:11:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:03 INFO - 'tests': ['damp', 'tps']}, 17:11:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:11:03 INFO - 'tests': ['dromaeo_dom']}, 17:11:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:11:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:11:03 INFO - 'tests': ['basic_compositor_video']}, 17:11:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:11:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:11:03 INFO - 'tests': ['a11yr', 17:11:03 INFO - 'ts_paint', 17:11:03 INFO - 'tpaint', 17:11:03 INFO - 'sessionrestore', 17:11:03 INFO - 'sessionrestore_no_auto_restore', 17:11:03 INFO - 'tabpaint']}, 17:11:03 INFO - 'other-e10s': {'tests': ['a11yr', 17:11:03 INFO - 'ts_paint', 17:11:03 INFO - 'tpaint', 17:11:03 INFO - 'sessionrestore', 17:11:03 INFO - 'sessionrestore_no_auto_restore', 17:11:03 INFO - 'tabpaint']}, 17:11:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:11:03 INFO - 'ts_paint', 17:11:03 INFO - 'tpaint', 17:11:03 INFO - 'sessionrestore', 17:11:03 INFO - 'sessionrestore_no_auto_restore', 17:11:03 INFO - 'tabpaint']}, 17:11:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:11:03 INFO - 'ts_paint', 17:11:03 INFO - 'tpaint', 17:11:03 INFO - 'sessionrestore', 17:11:03 INFO - 'sessionrestore_no_auto_restore', 17:11:03 INFO - 'tabpaint']}, 17:11:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:11:03 INFO - 'tests': ['a11yr', 17:11:03 INFO - 'ts_paint', 17:11:03 INFO - 'tpaint', 17:11:03 INFO - 'sessionrestore', 17:11:03 INFO - 'sessionrestore_no_auto_restore', 17:11:03 INFO - 'tabpaint']}, 17:11:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:11:03 INFO - 'tests': ['a11yr', 17:11:03 INFO - 'ts_paint', 17:11:03 INFO - 'tpaint', 17:11:03 INFO - 'sessionrestore', 17:11:03 INFO - 'sessionrestore_no_auto_restore', 17:11:03 INFO - 'tabpaint']}, 17:11:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:11:03 INFO - 'tests': ['tsvgx', 17:11:03 INFO - 'tsvgr_opacity', 17:11:03 INFO - 'tart', 17:11:03 INFO - 'tscrollx', 17:11:03 INFO - 'cart']}, 17:11:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:11:03 INFO - 'tsvgr_opacity', 17:11:03 INFO - 'tart', 17:11:03 INFO - 'tscrollx', 17:11:03 INFO - 'cart']}, 17:11:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:03 INFO - 'talos_options': ['--disable-e10s'], 17:11:03 INFO - 'tests': ['tp5o']}, 17:11:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:03 INFO - 'tests': ['tp5o']}, 17:11:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:03 INFO - 'talos_options': ['--disable-e10s', 17:11:03 INFO - '--xperf_path', 17:11:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:11:03 INFO - 'tests': ['tp5n']}, 17:11:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:03 INFO - 'talos_options': ['--xperf_path', 17:11:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:11:03 INFO - 'tests': ['tp5n']}}, 17:11:03 INFO - 'talos.zip': {'path': '', 17:11:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:11:03 INFO - Running post-action listener: _resource_record_post_action 17:11:03 INFO - [mozharness: 2016-10-25 00:11:03.542846Z] Finished populate-webroot step (success) 17:11:03 INFO - [mozharness: 2016-10-25 00:11:03.542978Z] Running create-virtualenv step. 17:11:03 INFO - Running pre-action listener: _resource_record_pre_action 17:11:03 INFO - Running main action method: create_virtualenv 17:11:03 INFO - Creating virtualenv /builds/slave/test/build/venv 17:11:03 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 17:11:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:11:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:11:03 INFO - Using real prefix '/tools/python27' 17:11:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:11:04 INFO - Installing distribute.............................................................................................................................................................................................done. 17:11:07 INFO - Installing pip.................done. 17:11:07 INFO - Return code: 0 17:11:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107ba7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b1d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe20a56d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079bbd30>, '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 0x107821db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079b3b20>, '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.uNK22YLExK/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.rLGtuoQ82o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 17:11:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:11:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNK22YLExK/Render', 17:11:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:07 INFO - 'HOME': '/Users/cltbld', 17:11:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:07 INFO - 'LOGNAME': 'cltbld', 17:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:07 INFO - 'MOZ_NO_REMOTE': '1', 17:11:07 INFO - 'NO_EM_RESTART': '1', 17:11:07 INFO - 'PAGER': '/bin/cat', 17:11:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:07 INFO - 'PWD': '/builds/slave/test', 17:11:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:07 INFO - 'SHELL': '/bin/bash', 17:11:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rLGtuoQ82o/Listeners', 17:11:07 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 17:11:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:07 INFO - 'USER': 'cltbld', 17:11:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:07 INFO - 'XPC_FLAGS': '0x0', 17:11:07 INFO - 'XPC_SERVICE_NAME': '0', 17:11:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:07 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 17:11:07 INFO - Cleaning up... 17:11:07 INFO - Return code: 0 17:11:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107ba7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b1d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe20a56d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079bbd30>, '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 0x107821db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079b3b20>, '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.uNK22YLExK/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.rLGtuoQ82o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 17:11:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:11:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNK22YLExK/Render', 17:11:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:07 INFO - 'HOME': '/Users/cltbld', 17:11:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:07 INFO - 'LOGNAME': 'cltbld', 17:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:07 INFO - 'MOZ_NO_REMOTE': '1', 17:11:07 INFO - 'NO_EM_RESTART': '1', 17:11:07 INFO - 'PAGER': '/bin/cat', 17:11:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:07 INFO - 'PWD': '/builds/slave/test', 17:11:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:07 INFO - 'SHELL': '/bin/bash', 17:11:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rLGtuoQ82o/Listeners', 17:11:07 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 17:11:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:07 INFO - 'USER': 'cltbld', 17:11:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:07 INFO - 'XPC_FLAGS': '0x0', 17:11:07 INFO - 'XPC_SERVICE_NAME': '0', 17:11:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:07 INFO - Downloading/unpacking psutil>=3.1.1 17:11: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 17:11: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 17:11: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 17:11: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 17:11: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 17:11: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 17:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:11:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:11:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:11:10 INFO - Installing collected packages: psutil 17:11:10 INFO - Running setup.py install for psutil 17:11:10 INFO - building 'psutil._psutil_osx' extension 17:11:10 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 17:11:11 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 17:11:11 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 17:11:11 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 17:11:11 INFO - building 'psutil._psutil_posix' extension 17:11:11 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 17:11:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:11:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:11:11 INFO - ^ 17:11:11 INFO - 1 warning generated. 17:11:11 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 17:11:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:11:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:11:11 INFO - Successfully installed psutil 17:11:11 INFO - Cleaning up... 17:11:11 INFO - Return code: 0 17:11:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:11: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')]} 17:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11: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')]} 17:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:11 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 0x107ba7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b1d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe20a56d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079bbd30>, '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 0x107821db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079b3b20>, '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.uNK22YLExK/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.rLGtuoQ82o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 17:11:11 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 17:11:11 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 17:11:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNK22YLExK/Render', 17:11:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:11 INFO - 'HOME': '/Users/cltbld', 17:11:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:11 INFO - 'LOGNAME': 'cltbld', 17:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:11 INFO - 'MOZ_NO_REMOTE': '1', 17:11:11 INFO - 'NO_EM_RESTART': '1', 17:11:11 INFO - 'PAGER': '/bin/cat', 17:11:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:11 INFO - 'PWD': '/builds/slave/test', 17:11:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:11 INFO - 'SHELL': '/bin/bash', 17:11:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rLGtuoQ82o/Listeners', 17:11:11 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 17:11:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:11 INFO - 'USER': 'cltbld', 17:11:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:11 INFO - 'XPC_FLAGS': '0x0', 17:11:11 INFO - 'XPC_SERVICE_NAME': '0', 17:11:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:11:12 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 17:11:12 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 17:11:12 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 17:11:12 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 17:11:12 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 17:11:12 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 17:11:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:11:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:11:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:11:14 INFO - Installing collected packages: mozsystemmonitor 17:11:14 INFO - Running setup.py install for mozsystemmonitor 17:11:14 INFO - Successfully installed mozsystemmonitor 17:11:14 INFO - Cleaning up... 17:11:14 INFO - Return code: 0 17:11:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:11:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:14 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 0x107ba7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b1d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe20a56d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079bbd30>, '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 0x107821db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079b3b20>, '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.uNK22YLExK/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.rLGtuoQ82o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 17:11:14 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 17:11:14 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 17:11:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNK22YLExK/Render', 17:11:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:14 INFO - 'HOME': '/Users/cltbld', 17:11:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:14 INFO - 'LOGNAME': 'cltbld', 17:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:14 INFO - 'MOZ_NO_REMOTE': '1', 17:11:14 INFO - 'NO_EM_RESTART': '1', 17:11:14 INFO - 'PAGER': '/bin/cat', 17:11:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:14 INFO - 'PWD': '/builds/slave/test', 17:11:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:14 INFO - 'SHELL': '/bin/bash', 17:11:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rLGtuoQ82o/Listeners', 17:11:14 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 17:11:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:14 INFO - 'USER': 'cltbld', 17:11:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:14 INFO - 'XPC_FLAGS': '0x0', 17:11:14 INFO - 'XPC_SERVICE_NAME': '0', 17:11:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:15 INFO - Downloading/unpacking jsonschema==2.5.1 17:11:15 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 17:11:15 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 17:11:15 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 17:11:15 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 17:11:15 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 17:11:15 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 17:11:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:11:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:11:17 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 17:11:17 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 17:11:17 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 17:11:17 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 17:11:17 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 17:11:17 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 17:11:18 INFO - Downloading functools32-3.2.3-2.tar.gz 17:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:11:18 INFO - warning: no files found matching '*.txt' 17:11:18 INFO - no previously-included directories found matching 'build' 17:11:18 INFO - no previously-included directories found matching 'dist' 17:11:18 INFO - no previously-included directories found matching '.git*' 17:11:18 INFO - Installing collected packages: jsonschema, functools32 17:11:18 INFO - Running setup.py install for functools32 17:11:18 INFO - warning: no files found matching '*.txt' 17:11:18 INFO - no previously-included directories found matching 'build' 17:11:18 INFO - no previously-included directories found matching 'dist' 17:11:18 INFO - no previously-included directories found matching '.git*' 17:11:18 INFO - Successfully installed jsonschema functools32 17:11:18 INFO - Cleaning up... 17:11:18 INFO - Return code: 0 17:11:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:11:18 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')]} 17:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:18 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')]} 17:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:18 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 0x107ba7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b1d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe20a56d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079bbd30>, '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 0x107821db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079b3b20>, '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.uNK22YLExK/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.rLGtuoQ82o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 17:11:18 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 17:11:18 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 17:11:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNK22YLExK/Render', 17:11:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:18 INFO - 'HOME': '/Users/cltbld', 17:11:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:18 INFO - 'LOGNAME': 'cltbld', 17:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:18 INFO - 'MOZ_NO_REMOTE': '1', 17:11:18 INFO - 'NO_EM_RESTART': '1', 17:11:18 INFO - 'PAGER': '/bin/cat', 17:11:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:18 INFO - 'PWD': '/builds/slave/test', 17:11:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:18 INFO - 'SHELL': '/bin/bash', 17:11:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rLGtuoQ82o/Listeners', 17:11:18 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 17:11:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:18 INFO - 'USER': 'cltbld', 17:11:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:18 INFO - 'XPC_FLAGS': '0x0', 17:11:18 INFO - 'XPC_SERVICE_NAME': '0', 17:11:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:11:18 INFO - Cleaning up... 17:11:18 INFO - Return code: 0 17:11:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:11:18 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')]} 17:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:18 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')]} 17:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:18 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 0x107ba7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b1d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe20a56d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079bbd30>, '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 0x107821db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079b3b20>, '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.uNK22YLExK/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.rLGtuoQ82o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 17:11:18 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 17:11:18 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 17:11:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNK22YLExK/Render', 17:11:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:18 INFO - 'HOME': '/Users/cltbld', 17:11:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:18 INFO - 'LOGNAME': 'cltbld', 17:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:18 INFO - 'MOZ_NO_REMOTE': '1', 17:11:18 INFO - 'NO_EM_RESTART': '1', 17:11:18 INFO - 'PAGER': '/bin/cat', 17:11:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:18 INFO - 'PWD': '/builds/slave/test', 17:11:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:18 INFO - 'SHELL': '/bin/bash', 17:11:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rLGtuoQ82o/Listeners', 17:11:18 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 17:11:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:18 INFO - 'USER': 'cltbld', 17:11:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:18 INFO - 'XPC_FLAGS': '0x0', 17:11:18 INFO - 'XPC_SERVICE_NAME': '0', 17:11:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:19 INFO - Downloading/unpacking blobuploader==1.2.4 17:11:19 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 17:11:19 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 17:11:19 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 17:11:19 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 17:11:19 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 17:11:19 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 17:11:21 INFO - Downloading blobuploader-1.2.4.tar.gz 17:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:11:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:11:21 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 17:11:21 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 17:11:21 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 17:11:21 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 17:11:21 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 17:11:21 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 17:11:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:11:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:22 INFO - Downloading docopt-0.6.1.tar.gz 17:11:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:11:22 INFO - Installing collected packages: blobuploader, requests, docopt 17:11:22 INFO - Running setup.py install for blobuploader 17:11:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:11:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:11:22 INFO - Running setup.py install for requests 17:11:23 INFO - Running setup.py install for docopt 17:11:23 INFO - Successfully installed blobuploader requests docopt 17:11:23 INFO - Cleaning up... 17:11:23 INFO - Return code: 0 17:11:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:23 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 0x107ba7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b1d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe20a56d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079bbd30>, '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 0x107821db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079b3b20>, '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.uNK22YLExK/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.rLGtuoQ82o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 17:11:23 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 17:11:23 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 17:11:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNK22YLExK/Render', 17:11:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:23 INFO - 'HOME': '/Users/cltbld', 17:11:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:23 INFO - 'LOGNAME': 'cltbld', 17:11:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:23 INFO - 'MOZ_NO_REMOTE': '1', 17:11:23 INFO - 'NO_EM_RESTART': '1', 17:11:23 INFO - 'PAGER': '/bin/cat', 17:11:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:23 INFO - 'PWD': '/builds/slave/test', 17:11:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:23 INFO - 'SHELL': '/bin/bash', 17:11:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rLGtuoQ82o/Listeners', 17:11:23 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 17:11:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:23 INFO - 'USER': 'cltbld', 17:11:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:23 INFO - 'XPC_FLAGS': '0x0', 17:11:23 INFO - 'XPC_SERVICE_NAME': '0', 17:11:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:11:23 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-isztV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:11:24 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-W9IIA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:11:24 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-O8ZgYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:11:24 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-mNK12F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:11:24 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-VSkikg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:11:24 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-DwkkAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:11:24 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-QaW7mF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:11:24 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-FQL7l0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:11:24 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-l4I6zR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:11:24 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-Qh1nW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:11:24 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-HkUgXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:11:25 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-k127vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:11:25 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-7bySEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:11:25 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-pOfrWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:25 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-ON3x1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:11:25 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-zRBMHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:11:25 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-3ovsBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:11:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:11:25 INFO - Running setup.py install for manifestparser 17:11:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:11:25 INFO - Running setup.py install for mozcrash 17:11:26 INFO - Running setup.py install for mozdebug 17:11:26 INFO - Running setup.py install for mozdevice 17:11:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:11:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:11:26 INFO - Running setup.py install for mozfile 17:11:26 INFO - Running setup.py install for mozhttpd 17:11:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:11:26 INFO - Running setup.py install for mozinfo 17:11:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:11:26 INFO - Running setup.py install for mozInstall 17:11:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:11:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:11:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:11:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:11:26 INFO - Running setup.py install for mozleak 17:11:27 INFO - Running setup.py install for mozlog 17:11:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:11:27 INFO - Running setup.py install for moznetwork 17:11:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:11:27 INFO - Running setup.py install for mozprocess 17:11:27 INFO - Running setup.py install for mozprofile 17:11:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:11:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:11:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:11:27 INFO - Running setup.py install for mozrunner 17:11:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:11:27 INFO - Running setup.py install for mozscreenshot 17:11:28 INFO - Running setup.py install for moztest 17:11:28 INFO - Running setup.py install for mozversion 17:11:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:11:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:11:28 INFO - Cleaning up... 17:11:28 INFO - Return code: 0 17:11:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:11: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')]} 17:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11: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')]} 17:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:28 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 0x107ba7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b1d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe20a56d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079bbd30>, '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 0x107821db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079b3b20>, '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.uNK22YLExK/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.rLGtuoQ82o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 17:11:28 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 17:11:28 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 17:11:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNK22YLExK/Render', 17:11:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:28 INFO - 'HOME': '/Users/cltbld', 17:11:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:28 INFO - 'LOGNAME': 'cltbld', 17:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:28 INFO - 'MOZ_NO_REMOTE': '1', 17:11:28 INFO - 'NO_EM_RESTART': '1', 17:11:28 INFO - 'PAGER': '/bin/cat', 17:11:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:28 INFO - 'PWD': '/builds/slave/test', 17:11:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:28 INFO - 'SHELL': '/bin/bash', 17:11:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rLGtuoQ82o/Listeners', 17:11:28 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 17:11:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:28 INFO - 'USER': 'cltbld', 17:11:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:28 INFO - 'XPC_FLAGS': '0x0', 17:11:28 INFO - 'XPC_SERVICE_NAME': '0', 17:11:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:11:28 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-BxBIJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:11:28 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)) 17:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:11:28 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-8NCFUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:11:28 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)) 17:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:11:28 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-duummb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:11:28 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)) 17:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:11:28 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-VAfh_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:11:29 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)) 17:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:11:29 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-6Gc_oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:11:29 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)) 17:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:11:29 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-sRGDXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:11:29 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)) 17:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:11:29 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-ALI8O8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:11:29 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)) 17:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:11:29 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-_CXV9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:11:29 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)) 17:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:11:29 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-MddBLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:11:29 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)) 17:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:11:29 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-bdCsMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:11:29 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)) 17:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:11:29 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-KXEuS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:11:29 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)) 17:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:11:29 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-6ts19y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:11:29 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)) 17:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:11:29 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-iz2pv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:11:29 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)) 17:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:11:30 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-k5soc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:11:30 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)) 17:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:30 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-1Jl_aG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:30 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)) 17:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:11:30 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-lhOO2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:11:30 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)) 17:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:11:30 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-yUQCmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:11:30 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)) 17:11:30 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)) 17:11:30 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)) 17:11:30 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)) 17:11:30 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)) 17:11:30 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)) 17:11:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:32 INFO - Downloading blessings-1.6.tar.gz 17:11:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:11:32 INFO - Installing collected packages: blessings 17:11:32 INFO - Running setup.py install for blessings 17:11:33 INFO - Successfully installed blessings 17:11:33 INFO - Cleaning up... 17:11:33 INFO - Return code: 0 17:11:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:11:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:11:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:11:33 INFO - Reading from file tmpfile_stdout 17:11:33 INFO - Current package versions: 17:11:33 INFO - blessings == 1.6 17:11:33 INFO - blobuploader == 1.2.4 17:11:33 INFO - docopt == 0.6.1 17:11:33 INFO - functools32 == 3.2.3-2 17:11:33 INFO - jsonschema == 2.5.1 17:11:33 INFO - manifestparser == 1.1 17:11:33 INFO - mozInstall == 1.12 17:11:33 INFO - mozcrash == 0.17 17:11:33 INFO - mozdebug == 0.1 17:11:33 INFO - mozdevice == 0.48 17:11:33 INFO - mozfile == 1.2 17:11:33 INFO - mozhttpd == 0.7 17:11:33 INFO - mozinfo == 0.9 17:11:33 INFO - mozleak == 0.1 17:11:33 INFO - mozlog == 3.4 17:11:33 INFO - moznetwork == 0.27 17:11:33 INFO - mozprocess == 0.23 17:11:33 INFO - mozprofile == 0.28 17:11:33 INFO - mozrunner == 6.12 17:11:33 INFO - mozscreenshot == 0.1 17:11:33 INFO - mozsystemmonitor == 0.3 17:11:33 INFO - moztest == 0.7 17:11:33 INFO - mozversion == 1.4 17:11:33 INFO - psutil == 3.1.1 17:11:33 INFO - requests == 1.2.3 17:11:33 INFO - wsgiref == 0.1.2 17:11:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:33 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 0x107ba7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b1d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe20a56d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079bbd30>, '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 0x107821db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079b3b20>, '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.uNK22YLExK/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.rLGtuoQ82o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 17:11:33 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 17:11:33 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 17:11:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNK22YLExK/Render', 17:11:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:33 INFO - 'HOME': '/Users/cltbld', 17:11:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:33 INFO - 'LOGNAME': 'cltbld', 17:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:33 INFO - 'MOZ_NO_REMOTE': '1', 17:11:33 INFO - 'NO_EM_RESTART': '1', 17:11:33 INFO - 'PAGER': '/bin/cat', 17:11:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:33 INFO - 'PWD': '/builds/slave/test', 17:11:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:33 INFO - 'SHELL': '/bin/bash', 17:11:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rLGtuoQ82o/Listeners', 17:11:33 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 17:11:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:33 INFO - 'USER': 'cltbld', 17:11:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:33 INFO - 'XPC_FLAGS': '0x0', 17:11:33 INFO - 'XPC_SERVICE_NAME': '0', 17:11:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:33 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)) 17:11:33 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)) 17:11:33 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)) 17:11:33 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)) 17:11:33 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)) 17:11:33 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)) 17:11:33 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)) 17:11:33 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)) 17:11:33 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)) 17:11:33 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)) 17:11:33 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)) 17:11:33 INFO - Cleaning up... 17:11:33 INFO - Return code: 0 17:11:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107ba7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b1d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe20a56d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079bbd30>, '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 0x107821db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079b3b20>, '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.uNK22YLExK/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.rLGtuoQ82o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 17:11:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:11:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:11:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNK22YLExK/Render', 17:11:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:33 INFO - 'HOME': '/Users/cltbld', 17:11:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:33 INFO - 'LOGNAME': 'cltbld', 17:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:33 INFO - 'MOZ_NO_REMOTE': '1', 17:11:33 INFO - 'NO_EM_RESTART': '1', 17:11:33 INFO - 'PAGER': '/bin/cat', 17:11:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:33 INFO - 'PWD': '/builds/slave/test', 17:11:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:33 INFO - 'SHELL': '/bin/bash', 17:11:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rLGtuoQ82o/Listeners', 17:11:33 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 17:11:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:33 INFO - 'USER': 'cltbld', 17:11:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:33 INFO - 'XPC_FLAGS': '0x0', 17:11:33 INFO - 'XPC_SERVICE_NAME': '0', 17:11:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:11:34 INFO - Cleaning up... 17:11:34 INFO - Return code: 0 17:11:34 INFO - Running post-action listener: _resource_record_post_action 17:11:34 INFO - Running post-action listener: _start_resource_monitoring 17:11:34 INFO - Starting resource monitoring. 17:11:34 INFO - [mozharness: 2016-10-25 00:11:34.165831Z] Finished create-virtualenv step (success) 17:11:34 INFO - [mozharness: 2016-10-25 00:11:34.166813Z] Running install step. 17:11:34 INFO - Running pre-action listener: _resource_record_pre_action 17:11:34 INFO - Running main action method: install 17:11:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:11:34 INFO - Reading from file tmpfile_stdout 17:11:34 INFO - Detecting whether we're running mozinstall >=1.0... 17:11:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:11:34 INFO - Reading from file tmpfile_stdout 17:11:34 INFO - Output received: 17:11:34 INFO - Usage: mozinstall [options] installer 17:11:34 INFO - Options: 17:11:34 INFO - -h, --help show this help message and exit 17:11:34 INFO - -d DEST, --destination=DEST 17:11:34 INFO - Directory to install application into. [default: 17:11:34 INFO - "/builds/slave/test"] 17:11:34 INFO - --app=APP Application being installed. [default: firefox] 17:11:34 INFO - mkdir: /builds/slave/test/build/application 17:11:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 17:12:07 INFO - Reading from file tmpfile_stdout 17:12:07 INFO - Output received: 17:12:07 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 17:12:07 INFO - Running post-action listener: _resource_record_post_action 17:12:07 INFO - [mozharness: 2016-10-25 00:12:07.028498Z] Finished install step (success) 17:12:07 INFO - [mozharness: 2016-10-25 00:12:07.028641Z] Running run-tests step. 17:12:07 INFO - Running pre-action listener: _resource_record_pre_action 17:12:07 INFO - Running main action method: run_tests 17:12:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:12:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:12:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:12:07 INFO - 2016-10-24 17:12:07.043 screenresolution[1637:7535] starting screenresolution argv=screenresolution get 17:12:07 INFO - 2016-10-24 17:12:07.045 screenresolution[1637:7535] Display 0: 1600x1200x32@60 17:12:07 INFO - 2016-10-24 17:12:07.051 screenresolution[1638:7538] starting screenresolution argv=screenresolution list 17:12:07 INFO - Available Modes on Display 0 17:12:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:12:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:12:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:12:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:12:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:12:07 INFO - Intel Iris: 17:12:07 INFO - Chipset Model: Intel Iris 17:12:07 INFO - Type: GPU 17:12:07 INFO - Bus: Built-In 17:12:07 INFO - VRAM (Dynamic, Max): 1536 MB 17:12:07 INFO - Vendor: Intel (0x8086) 17:12:07 INFO - Device ID: 0x0a2e 17:12:07 INFO - Revision ID: 0x0009 17:12:07 INFO - Displays: 17:12:07 INFO - Display: 17:12:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:12:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:12:07 INFO - Display Serial Number: 1600x1200 60 17:12:07 INFO - Main Display: Yes 17:12:07 INFO - Mirror: Off 17:12:07 INFO - Online: Yes 17:12:07 INFO - Rotation: Supported 17:12:07 INFO - Return code: 0 17:12:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:12:07 INFO - Python 2.7.3 17:12:07 INFO - Return code: 0 17:12:07 INFO - grabbing minidump binary from tooltool 17:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:12:07 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 0x1079bbd30>, '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 0x107821db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079b3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:12:07 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 17:12:07 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 17:12:07 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 17:12:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:12:07 INFO - Return code: 0 17:12:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:12:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:12:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:12:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:12:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:12:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AK9iXXhxTiCCgjkfXP7Osg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0243', '--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 17:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AK9iXXhxTiCCgjkfXP7Osg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0243 --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 17:12:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNK22YLExK/Render', 17:12:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:12:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:12:07 INFO - 'HOME': '/Users/cltbld', 17:12:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:12:07 INFO - 'LOGNAME': 'cltbld', 17:12:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:12:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:07 INFO - 'MOZ_NO_REMOTE': '1', 17:12:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:12:07 INFO - 'NO_EM_RESTART': '1', 17:12:07 INFO - 'PAGER': '/bin/cat', 17:12:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:07 INFO - 'PWD': '/builds/slave/test', 17:12:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:12:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:12:07 INFO - 'SHELL': '/bin/bash', 17:12:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rLGtuoQ82o/Listeners', 17:12:07 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 17:12:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:12:07 INFO - 'USER': 'cltbld', 17:12:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:12:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:07 INFO - 'XPC_FLAGS': '0x0', 17:12:07 INFO - 'XPC_SERVICE_NAME': '0', 17:12:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:12:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AK9iXXhxTiCCgjkfXP7Osg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0243', '--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 17:12:07 INFO - mozversion application_buildid: 20161024160022 17:12:07 INFO - mozversion application_changeset: 8da98b978cfc0ce47aa7d40bb98edf91075e098e 17:12:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:12:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:12:07 INFO - mozversion application_name: Firefox 17:12:07 INFO - mozversion application_remotingname: firefox-dev 17:12:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:12:07 INFO - mozversion application_vendor: Mozilla 17:12:07 INFO - mozversion application_version: 51.0a2 17:12:07 INFO - mozversion platform_buildid: 20161024160022 17:12:07 INFO - mozversion platform_changeset: 8da98b978cfc0ce47aa7d40bb98edf91075e098e 17:12:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:12:07 INFO - mozversion platform_version: 51.0a2 17:12:07 INFO - using testdate: 1477354327 17:12:07 INFO - actual date: 1477354327 17:12:07 INFO - starting webserver on 'localhost:49273' 17:12:07 INFO - SUITE-START | Running 2 tests 17:12:07 INFO - TEST-START | dromaeo_css 17:12:07 INFO - operating with platform_type : mac_ 17:12:07 INFO - Initialising browser for dromaeo_css test... 17:12:07 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/tmpVEBIYb/profile http://localhost:49273/getInfo.html) 17:12:10 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 17:12:10 INFO - PROCESS | 1648 | colorDepth:24 17:12:10 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 17:12:10 INFO - PROCESS | 1648 | __metrics 17:12:10 INFO - PROCESS | 1648 | 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" 17:12:10 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:12:10 INFO - TEST-INFO | 1648: exit 0 17:12:10 INFO - Browser initialized. 17:12:10 INFO - Running cycle 1/1 for dromaeo_css test... 17:12:10 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/tmpVEBIYb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:12:22 INFO - PROCESS | 1650 | RSS: Main: 219799552 17:12:22 INFO - PROCESS | 1650 | 17:13:14 INFO - PROCESS | 1650 | 1477354394109 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] 17:15:25 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 17:15:27 INFO - PROCESS | 1650 | RSS: Main: 366096384 17:15:27 INFO - PROCESS | 1650 | 17:18:30 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 17:18:31 INFO - PROCESS | 1650 | RSS: Main: 350449664 17:18:31 INFO - PROCESS | 1650 | 17:21:33 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 17:21:33 INFO - PROCESS | 1650 | RSS: Main: 325730304 17:21:33 INFO - PROCESS | 1650 | 17:24:36 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 17:24:36 INFO - PROCESS | 1650 | RSS: Main: 312467456 17:24:36 INFO - PROCESS | 1650 | 17:27:40 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 17:27:40 INFO - PROCESS | 1650 | RSS: Main: 311812096 17:27:40 INFO - PROCESS | 1650 | 17:30:43 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 17:30:44 INFO - PROCESS | 1650 | RSS: Main: 570208256 17:30:44 INFO - PROCESS | 1650 | 17:30:44 INFO - PROCESS | 1650 | __start_tp_report 17:30:44 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 17:30:44 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 17:30:44 INFO - PROCESS | 1650 | |i|pagename|runs| 17:30:44 INFO - PROCESS | 1650 | |0;dojo.html;3007.744341730953;3298.472244440889;3319.2033911861154;3347.928662827896;3354.1446931032583;5722.170285308628;5729.28383952006;5748.856278593027;5764;5794.5943783935145;5757.395473475288;5827.854303642401;5832.445917637829;5834.416558344164;5840.620359676618;5197.168453047494;5205.453427390117;5264.236685680574;5266.210068489719;5307.310049693534;5164.845054648366;5191.013707395602;5193.844184674447;5250.684958902459;5382.085045542248;5242.135047717141;5329.520343169114;5336.893262134755;5344.679319240858;5355.437679043703;4358.956410435902;5314.73426328682;5332.520073193412;5348.759305831247;5376.193570964387;5099.209622508517;5216.7913283468615;5271.262023316739;5280.49835265653;5305.867353316198;5587.273654424899;5694.77220911163;5703.686297253649;5704.999999999958;5724.856878578027;5889.057750759858;6124.229237387393;6198.4731297839735;6227.283862355796;6229.4393504584805;5215.6609820361555;6251.687415629246;6252.749890004395;6266.404691554295;6272.153259310026;5680.091185410314;5929.8814023719715;5935.52515798735;5955.731992060368;5961.642301461926;6193.659348735863;6228.377162283826;6264.436200741864;6264.718087686065;6304.369563043659;6233.283172435228;6246.46905013079;6248.562600617913;6252.093446450239;6254.937450625435;6286.4342209201395;6296.370362963667;6310.242770867433;6326.746930122836;6333.68331583419;5009.323741294878;6127.111568822585;6128.631388773761;6152.630842149396;6206.162168107247;6108.159949115189;6170.5372097092895;6180.042093475518;6182.072689096672;6190.288116866528;4824.131656301899;4843.75781210938;4890.1931181355385;4909.018196360742;4916.918277978839;4369.847055353111;4393.846215382447;4394.055278115156;4395.978020109943;4401.735895846259;5777.884442311214;5789.45000224978;5832.854178645568;5869.236999190163;5959.940400595939;6217.028081239776;6219.471344935731;6227.595206311576;6237.750489980441;6265.843353916189;5865.472107510344;5874.206982057368;5878.794242201502;5880.117982302603;5910.113482977587;5324.121519949243;5349.732513374393;5389.595780316492;5391.406945236021;5449.182622606561;6298.118263443122;6299.5275354348605;6357.809265722036;6359;6382.585131966407;6243.406876346739;6243.438090571689;6252.499800015897;6255.78104766331;6256.655883926428;6192.442680158807;6222.564420490703;6253.937460625336;6329.715162817776;6340.968295158495;6204.7828326008375;6238.594491358047;6258.311585725475;6305.653189074645;6306.810795676137;6092.878142437038;6237.8752424950335;6277.466415354746;6281.623102613858;6290.025046117859;6030.668313242813;6129.84675383119;6170.012797952486;6224.128621992834;6224.128621993015;6050.757969681339;6109.283207920342;6140.074827791203;6144.064619644798;6221.502279817694;6099.024156135175;6101.294003060948;6108.226837060667;6110.514619590966;6122.387761223842;6181.84545386369;6209.130721698875;6209.720562574605;6220.72006759706;6239.1577137085915;5848.181254624441;5908.350081490947;5908.3500814911185;5942.959982003219;6019.307779605227 17:30:44 INFO - PROCESS | 1650 | |1;ext.html;484.5663131497308;536.6109570561343;546.923430719699;548.0108404330184;549.2886711708338;30293.69706302936;31059.912903048396;32314;40607.79696101523;41227.969300767494;42930.57069429305;43274.350884736676;43298.56701432985;43340;43511.34732979;9708.271879609023;9876.308658393915;9894.703158905244;9897.010298970117;9897.307188496809;7851.8037049073655;8568.314534837229;8963.64145434185;9062.864057039149;9085.727428177166;8972.057933916944;11880.940595297012;12195.45120469581;12203.328816915066;12414.565490207844;12231.143819932608;12288.938555307255;12312.076594255423;12312.445939932724;12314.630561083182;8683.175098365646;11988.220765650205;12080.395980200954;12082.818757718642;12099;31148.688513114805;39844.20311593781;39930;40028.799856000536;42657.786711066554;2881.222070041098;3339.632640409553;3598.6401359863803;3998.8800335989968;4063.6545893599077;29743.553846692317;29808.403831923457;31505.21236969071;32225.516617250527;32242.87149949764;3100.2137907430015;3325.617553981275;3349.3301339731906;3383.898483045488;3425.657434256579;511437.8856211465;514130;514359;514544;517242.41378792864;43108.13783724308;50858.237126443135;56809;58201.70899145477;58590;59538;63389.68305158445;63431.04853427202;63465.68267158635;63673;16328.67342653164;16352.591185220464;16450.83549164493;16495.17524123813;16502.17489125539;13009.479620815251;13109.737805244033;13116.540921067908;13123.60629181126;13136.934315328554;14220.360083796253;14482.637934051732;15980.200989950456;16044.75932861008;16071.714262858943;6290.937090629035;6571.967140164268;6613.933860661332;6626.768063117768;6640.501962352843;803.3171803966582;937.7340590203307;971.9028097190366;993.1855878179823;1000.9849852252222;29301.706982930325;30143.849280753457;30179.396412071637;30648.540271895938;30781;788.8658927982257;913.2925580494241;1077.224398433127;1088.6679562733284;1093.4642025407652;14634.780478292834;15374.9231253843;15432.768508472382;15461.845381546265;15758.527244182693;692298;696937;700301;702359;704006;49926;49959.0008199834;50932.236016459785;50968.490315097115;58942;1386.272207091285;1388.6042477893955;1406.5217825939026;1408.556304763996;1410.6684929041871;27909.58135628008;29974.400511989203;30409.543856841723;31161.220969475038;31286;44140;50152.749236253585;50352;50659;50698;653180;669079;680882;902423;905636.4718176367;25253.87373063123;25420.110296139548;25523.36191595225;25782.484350313265;25846;45697.77151114223;45749.85625359393;45884.54115458803;45888.08223835572;47007.824804380165;31112.377752444372;37643.05892352713;38198;38201.61798381981;38315.808420957714;37423.812880935424;38057.80971095127;38434.42348364721;39371;39457.81626551208;36665;36985.445218321205;37106.07234819043;37466.875993720234;37660.62339376571;30946.381072378877;32908.34183316368;32923;33024.834875825465;33202;22212.44468888226;24490.510189795747;25046.74953250517;25336.60648664341;25791.355216119748 17:30:44 INFO - PROCESS | 1650 | |2;jquery.html;351.9120219945014;370.3370965970912;375.7520036775727;383.3100419245359;404.4156194299237;15382.384704611803;15531;20139.899300503515;21886.343409697696;22155.556888862255;19740.901295493502;20405.183792648313;20462.795372046276;20620.1751929923;21008.8949555252;5241.3186285782795;5550.611457197998;5550.72246387681;5555.583331250152;5561.082421400464;5492.423295553969;5578.219049333096;5997.700114994254;6271.15339429178;6321.620702757827;6300.086487459315;6357.809265722036;6363.109164716943;6369.299377068519;6371.649559274261;6053.303870054934;6148.600340977844;6206.441420272175;6206.534509911775;6216.005439129763;5838.357780644125;5995.250593675791;6061.151438798572;6072.392760723937;6078.057901025348;13345.065845390827;13413.061085724003;13585.049046566744;13602.931985340108;13609.251491167981;1815.5551889786955;2179.574982878339;2201.119552179125;2320.8955596998176;2358.1274928276475;9829.459379734111;9975.301728878982;10425.270231083752;10533.31533450331;13644.863551364459;1637.9517109050216;1880.858935579837;1890.7825600055894;1955.878783074813;1959.5395082155683;114837.56809415808;118894;123110.38444807718;138136;138173;11555.537778488766;11633.917011991829;11657.76684466306;11775.646730598095;11985.161038727205;13221.471141154438;13759.312034398441;13774.449022039005;13788.724225515634;14535.418583256764;8576.670616054522;8613.96632404103;8695.913040869511;8782.341324400695;8823.602937867812;8209.917900820916;8611.6985905493;8720.912790872137;8731.650733970697;8820.25027872638;4511.390962220124;4578.954210457853;4579.22153233951;4593.324092754348;4648.5119062498625;1731.5151757507917;1801.6937120689515;1918.1272521003189;1924.5669724312197;1974.407677696714;846.2003406780657;945.839207334741;977.1840513171582;1013.9290249682451;1027.5530144387214;20938.37184884456;21385;21428.464288392915;21472.57054858894;21533.89233053856;908.895477020138;948.6821914658528;956.4261443134064;957.5164541906292;973.7711637765119;10986.615468458725;11246;11429.97130258264;11488.655340339803;11536.365499897418;519177;522115;524183;586568.06715967;591189;134419.65580344267;140192;142684;147356;149761.25119374334;801.3268854162532;988.7577543501889;1016.4714348538719;1017.0998666180484;1017.4759998600726;19085.427437176906;19770.70343944813;19803.40589782309;19837.504062398555;19896.801031989497;54735;57500;57784.71107644435;58010;58816.82366352734;83151;84821.15178848132;85509.57245213733;86308;87861;8010.319122874621;8070.031596208258;8122.715704950535;8218.547979861165;8262.091169971178;8641.913580864111;10763.94618026905;11822.763544729229;11923.463444145207;12202.572909948109;9061.229795467196;10934.070603998749;10943.507542160463;10976.341419514854;11285.661430157108;10761.946190268998;11037.724056898642;11088.556457741923;11119.767476702698;11156.776864462503;10891.836622450828;11130.443477825915;11138.498767555317;11174.832377514182;11365.261258018203;6982.755603553851;7391.8152046199275;7462.96268518654;8025.438219324591;8200.876986845084;9615.326927115315;10144.847827282449;10649.840252396065;11251.774964500828;11750.764984700087 17:30:44 INFO - PROCESS | 1650 | |3;mootools.html;1349.7705390083686;1532.6934613077387;1542.344503585976;1749.2041121289815;1901.9144138513775;7865.174156713541;8370.53962032088;8533.232009119185;8780.297576193905;8784.78038049049;8639.913600863989;8728.389012769108;8732.91267087329;8741.16958888906;8760.386772925898;2346.1319311854595;2371.5256948610263;2374.881255937205;2376.0377047295788;2376.572217000939;2320.385097949045;2374.584447721642;2377.9643305350432;2383.892724827387;2389.9641505377435;2330.871802050895;2351.811855051592;2373.169390713254;2377.702787151606;2382.28531440568;2316.814654827627;2346.21401830387;2349.447879748258;2351.106579499779;2351.130081869702;2303.3090072978207;2338;2338.1699496678602;2338.3101984914492;2339.0526836631193;8702.042775294713;8788.384813063089;8824.249938755214;8843.292536597057;8875.556222188929;5228.79084836606;5421.430749771257;5424.240606315119;5467.480589344006;5468.507834294893;3637.8726744563814;3672.5042119314085;3737.8975450376124;3747.4191500317493;3755.75587586806;1094.1301665176204;1095.802755504009;1096.1450068946235;1108.772701596171;1111.0389513071136;11654.475548600334;11698.41507924609;11767.646970590897;11768.235064720851;11792.882071179265;4136.607022332873;4213.578642135823;4442.089371678798;4627.30590411441;4635;9182.311326650395;9198.942121656095;9201.769955751026;9212.953935230415;9253.49105799174;5264.868378290574;5273.2617433559335;5278;5282.445343238982;5290.867728306823;4302.935455968163;4453.688241823042;4465.799039043251;4608.907821843612;4963.8262660806695;3759;3824.0248736572553;3828.578856325802;3874.1089549403796;3874.2638898609175;998.9250806189565;1165.6736113888126;1168.5033860609376;1168.8422063021383;1184.6150001249457;675.7803713793037;820.7948012996751;843.0473564871655;850.7405241401432;859;5303.416624171416;5344.144936810092;5354.4645535446925;5679.602427830012;5872.823815285548;434.926062569364;436.47622852577035;444.7531619950958;450.4639479019956;469.0806020200377;3282.9343413131605;3867.16855875988;3870.4000879863665;3889.6888248940018;3917.9216415671526;10504.632337868137;11025.558977640805;11030.172737044593;11031.779364412827;11034.172437067253;10948.34309941406;10962.671119866416;10969.561217551369;10977.780444391068;11000.009999099959;7405.703771849066;7426.331630153312;8146.470479418819;8267.255946964802;8280.461769985051;5013.39839219296;5582.609217354746;5669.829905102689;5852.005159122874;5862.736176872137;9819.06718861707;10111.292209545261;10150.289479736348;10170.982901709769;10240.283180177315;9882.209423245979;9997.950010249902;10172.982701730063;10182.592696292066;10267.94866025695;7543.321101100927;7727.729529466442;7728.613569321399;7732.38140948734;7735.651895664596;8291.08798032204;8295.585220738818;8296.460730052528;8353.749387518385;8381.245687888118;7351.301626345488;7474.177840437439;7546.358559522502;7578.696852125853;7672;7367.5211111277595;7370.815729606803;7421.4062874968795;7430.814229644302;7540.8491830164185;6961.199462061725;7040.295970402919;7103.289671032855;7120.679569419285;7194.856102877809;3999.940000900047;4860.997323720597;4898.24077268024;5004.17431123875;5102.979404119117;5001.399832020181;5046.596272298134;5066.417362003417;5077.822276220315;5105.566026887756 17:30:44 INFO - PROCESS | 1650 | |4;prototype.html;296.69292282487623;303.95288730246807;306.4132186862158;308.64197530864203;311.9594452721146;5258.395284542279;5301.284326615906;5333.706646134461;5339.733013349327;5349.491798279162;4508.571685689854;4672.976635116828;5230;5244.947550524494;5292.338457692788;3161.668024857391;3216.5979252593365;3393.9151521212043;3866.8624571708283;4046.271671099201;3553.7157027437743;3575.570931488225;3710.3877860153043;4112.794360281989;4140.979295103521;3218.7585931055146;4066.227416790815;4072.287349713803;4073.002114481956;4095.7133000689964;3513.789172649649;3710.239400922804;4019.618136277049;4058.559211479941;4101.2931465232805;3155.353152603711;3531.5632213772674;3544.3442963051916;3558.4128618777872;3572.356975744365;3833.5399752029657;3844.692424606025;5118.950615123891;5185.196294574347;5273.209018647233;4309.698321117523;4665.276882083249;4693.178693728584;4698.318743782167;4711.8350857719815;5028.019536190444;5264;5618.859528511779;5619.904118696856;5684.658920464785;3248.59392575928;3862.5364956205153;3868.226354729037;3868.2263547290654;3880.1657643606477;4725.669203155746;5490.313710786152;5554.666719996813;5875.265591801025;6000.689734452224;3953.486046813896;3978.76127432355;4041.211963667057;4056.3104272273786;4060.5330387005283;3811.7522361047;4108.67130629549;4109.3425051991535;4112.979435102805;4125.257453658371;4380.76580943721;4725.5983241424865;4740.099381117577;4753.904921901542;4765.404324459442;5480.835574932758;5635.633683810621;5639;5688.146777983336;5690.459406356389;1199.3868247207492;1241.4971936365787;1377.1874593989594;1402.5903966513588;1408.295852073963;808.7290757596271;846.9957650211833;858.8539948208819;860.0238729042456;865.8960924688952;4165.437960764713;4550.453945526558;4841.419029716386;5052.267421223902;5369.067135831097;4858.295547145714;5071.366079240095;5718.628289161275;5796.62321949072;5829;4116.876493705194;5244.265802787613;5274.841754747364;5294.7617357219015;5374.838754837361;2414.7102347718387;2940.294329360938;2968.6289213848268;3055.663876973531;3069.1891783847636;4788.688735232199;5549.750261238173;5986.880262394815;5996.730147143389;6020.307664618537;4835.95164048362;5938.6436813791315;5948.193156379921;5987.533463859022;6007.978643630593;5217.765200565984;5456.809011684572;5919.076300202538;5927.044075455089;5984.3417224105315;4802.831900883452;5355.544778693855;5773.364929857797;5785.247917770663;5901.049475262369;4529.411176547028;5016.749162541932;5701.945140149086;5734.569907256889;5734.827955161351;5849.678267695318;5932.2584676915385;5953.910691339547;5988.850278743066;6031.4270144336215;2916.241777137917;3014.5930299410174;3317;3322.0467643504153;3348.949765753467;5376.462353764592;5857.326407463026;5878.059510478303;5902.468777810018;5945.464908158114;5480.753366098615;5647.237622921018;5659.3491748447805;5675.722962333607;5721.2836149154255;5415.566754659697;5653.95401850659;5660.924424359358;5702.258706368146;5738.971305143447;5050.696958182521;5430.375506816608;5562.694051827189;5584.329880414376;5605.943940560705;4391.451068616423;5320.201969704575;5461.945380546303;5584.497395234448;5663.886722265449;5165.9483405165465;5483.945160548344;5532.253145825423;5533.916991245215;5538.418466061005 17:30:44 INFO - PROCESS | 1650 | |5;yui.html;697.3897839390534;732.2933369298626;769.3869164616124;792.385900926782;808.1675873849935;15179.544613661581;16264.674706505863;16280.348786048573;16409.671806563863;16496.175191240436;13353.399097040632;13416.329183540833;13423.127496712706;13425.530106446276;13427.060105792598;678.8438659108408;697.191258140557;854.0477367734977;854.6837670062085;871.542440218887;863.753830158405;864.1099667342647;866.679328648401;866.6966561703385;869.7086476030537;921.6313474610176;921.6451666108563;923.5751554285036;923.8752768376283;929.3169520402532;714.7069701422417;734.904462419882;738.3539403022355;739.8150462384403;914.6890057380489;552.3178874090495;667.0361327881213;683.2518392360407;685.2120061928772;695.9699644526079;15205.771913421308;15221.238938053164;15236;15246.466373676869;15269.38922443101;13897.86102138986;13941.675540823606;14116.15303081808;14287;14442.638934026734;11833.585824496187;12508.937455312756;12704.74590508194;12886.484540618365;13173.60479185626;4457.375967364572;4457.77711114443;4591.173588754023;4608.331791890158;4642.535746425364;119777.40111299475;119883;120058;123921.38039309836;125506;10568.418736969386;10916.890831091747;10938.56245750177;11205;11333.659990200307;22065;22072.33782986513;22090.33728988133;22093.668594971088;22104.44738881541;7732.149463559004;7791.92208077912;8021.462373527099;8212.63043163059;8235.794105147419;4418.403515525427;4452.243118669834;4452.910941781146;4491.461024676994;4585.266357382803;3493.318802833423;3637.1452708613456;3639.70882329413;3642.1805093853673;3645.4167333227088;608.6561092982539;632.7405763636887;651.1079820645746;654.6955665615417;657.6810247030187;527.4435470578577;527.7255826969954;563.5407143178296;564.1650357470966;633.1610615933906;8753.80242357757;9102.362834601647;9170.403923744936;9198.126178013077;9472.336936414385;534.8716308086109;558.4750334685464;566.6543408520799;590.4213870407025;624.9283624783827;3730.6082861299174;4006.358982562776;4227.387028880857;4354.738715677069;4455.643548516111;91677.62483562752;143679.2816035934;144119;158238.2088089575;160996.17011489675;138664;139453;143772;147655;149003;104421;104861.47569262257;106259.93740062656;109386.99999999841;115724.42137789258;8973.933379246622;9858.654947076819;9924;10050.798984020425;10121.898781012096;56670.716646416506;56884.43115568791;57564.42435575591;57584;58484.4151558496;78856.60571697105;79934.600326998;83757.48727538183;84002.73995889944;85188.29623407622;10075.949620251851;12072.879271207175;12655.493780248687;12846.100772945803;13209.735805284034;13988.440462381797;14717.852821471648;14987;15302.617434564225;15585;12929.418176181905;13254.933725331312;13664.726705465637;13964.301784910916;14140.01019928595;11438.428078596204;13183.14309569875;13213.669658258235;13938.93030534841;14053.929730351692;12652.746945060862;13683.384247708678;14176.716465670423;14187.219702916025;14208.005439619128;10686.786264274826;11129.83305250438;11575.71060723455;11827.586034488751;11949.641510754343;8888.777780555538;10298.22763292741;11038.454616353878;11538.192326537062;11557.768844623228 17:30:44 INFO - PROCESS | 1650 | __end_tp_report 17:30:44 INFO - PROCESS | 1650 | __start_cc_report 17:30:44 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1350 17:30:44 INFO - PROCESS | 1650 | __end_cc_report 17:30:44 INFO - PROCESS | 1650 | __startTimestamp1477355444099__endTimestamp 17:30:44 INFO - PROCESS | 1650 | 17:30:44 INFO - PROCESS | 1650 | ------- Summary: start ------- 17:30:44 INFO - PROCESS | 1650 | Number of tests: 6 17:30:44 INFO - PROCESS | 1650 | 17:30:44 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5763.19 Median:6019.31 stddev:664.28 (11.0%) stddev-sans-first:630.17 17:30:44 INFO - PROCESS | 1650 | Values: 3007.7 3298.5 3319.2 3347.9 3354.1 5722.2 5729.3 5748.9 5764.0 5794.6 5757.4 5827.9 5832.4 5834.4 5840.6 5197.2 5205.5 5264.2 5266.2 5307.3 5164.8 5191.0 5193.8 5250.7 5382.1 5242.1 5329.5 5336.9 5344.7 5355.4 4359.0 5314.7 5332.5 5348.8 5376.2 5099.2 5216.8 5271.3 5280.5 5305.9 5587.3 5694.8 5703.7 5705.0 5724.9 5889.1 6124.2 6198.5 6227.3 6229.4 5215.7 6251.7 6252.7 6266.4 6272.2 5680.1 5929.9 5935.5 5955.7 5961.6 6193.7 6228.4 6264.4 6264.7 6304.4 6233.3 6246.5 6248.6 6252.1 6254.9 6286.4 6296.4 6310.2 6326.7 6333.7 5009.3 6127.1 6128.6 6152.6 6206.2 6108.2 6170.5 6180.0 6182.1 6190.3 4824.1 4843.8 4890.2 4909.0 4916.9 4369.8 4393.8 4394.1 4396.0 4401.7 5777.9 5789.5 5832.9 5869.2 5959.9 6217.0 6219.5 6227.6 6237.8 6265.8 5865.5 5874.2 5878.8 5880.1 5910.1 5324.1 5349.7 5389.6 5391.4 5449.2 6298.1 6299.5 6357.8 6359.0 6382.6 6243.4 6243.4 6252.5 6255.8 6256.7 6192.4 6222.6 6253.9 6329.7 6341.0 6204.8 6238.6 6258.3 6305.7 6306.8 6092.9 6237.9 6277.5 6281.6 6290.0 6030.7 6129.8 6170.0 6224.1 6224.1 6050.8 6109.3 6140.1 6144.1 6221.5 6099.0 6101.3 6108.2 6110.5 6122.4 6181.8 6209.1 6209.7 6220.7 6239.2 5848.2 5908.4 5908.4 5943.0 6019.3 17:30:44 INFO - PROCESS | 1650 | 17:30:44 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:77066.29 Median:37651.84 stddev:180298.27 (478.9%) stddev-sans-first:180712.37 17:30:44 INFO - PROCESS | 1650 | Values: 484.6 536.6 546.9 548.0 549.3 30293.7 31059.9 32314.0 40607.8 41228.0 42930.6 43274.4 43298.6 43340.0 43511.3 9708.3 9876.3 9894.7 9897.0 9897.3 7851.8 8568.3 8963.6 9062.9 9085.7 8972.1 11880.9 12195.5 12203.3 12414.6 12231.1 12288.9 12312.1 12312.4 12314.6 8683.2 11988.2 12080.4 12082.8 12099.0 31148.7 39844.2 39930.0 40028.8 42657.8 2881.2 3339.6 3598.6 3998.9 4063.7 29743.6 29808.4 31505.2 32225.5 32242.9 3100.2 3325.6 3349.3 3383.9 3425.7 511437.9 514130.0 514359.0 514544.0 517242.4 43108.1 50858.2 56809.0 58201.7 58590.0 59538.0 63389.7 63431.0 63465.7 63673.0 16328.7 16352.6 16450.8 16495.2 16502.2 13009.5 13109.7 13116.5 13123.6 13136.9 14220.4 14482.6 15980.2 16044.8 16071.7 6290.9 6572.0 6613.9 6626.8 6640.5 803.3 937.7 971.9 993.2 1001.0 29301.7 30143.8 30179.4 30648.5 30781.0 788.9 913.3 1077.2 1088.7 1093.5 14634.8 15374.9 15432.8 15461.8 15758.5 692298.0 696937.0 700301.0 702359.0 704006.0 49926.0 49959.0 50932.2 50968.5 58942.0 1386.3 1388.6 1406.5 1408.6 1410.7 27909.6 29974.4 30409.5 31161.2 31286.0 44140.0 50152.7 50352.0 50659.0 50698.0 653180.0 669079.0 680882.0 902423.0 905636.5 25253.9 25420.1 25523.4 25782.5 25846.0 45697.8 45749.9 45884.5 45888.1 47007.8 31112.4 37643.1 38198.0 38201.6 38315.8 37423.8 38057.8 38434.4 39371.0 39457.8 36665.0 36985.4 37106.1 37466.9 37660.6 30946.4 32908.3 32923.0 33024.8 33202.0 22212.4 24490.5 25046.7 25336.6 25791.4 17:30:44 INFO - PROCESS | 1650 | 17:30:44 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:34282.16 Median:12043.73 stddev:93123.08 (773.2%) stddev-sans-first:93349.46 17:30:44 INFO - PROCESS | 1650 | Values: 351.9 370.3 375.8 383.3 404.4 15382.4 15531.0 20139.9 21886.3 22155.6 19740.9 20405.2 20462.8 20620.2 21008.9 5241.3 5550.6 5550.7 5555.6 5561.1 5492.4 5578.2 5997.7 6271.2 6321.6 6300.1 6357.8 6363.1 6369.3 6371.6 6053.3 6148.6 6206.4 6206.5 6216.0 5838.4 5995.3 6061.2 6072.4 6078.1 13345.1 13413.1 13585.0 13602.9 13609.3 1815.6 2179.6 2201.1 2320.9 2358.1 9829.5 9975.3 10425.3 10533.3 13644.9 1638.0 1880.9 1890.8 1955.9 1959.5 114837.6 118894.0 123110.4 138136.0 138173.0 11555.5 11633.9 11657.8 11775.6 11985.2 13221.5 13759.3 13774.4 13788.7 14535.4 8576.7 8614.0 8695.9 8782.3 8823.6 8209.9 8611.7 8720.9 8731.7 8820.3 4511.4 4579.0 4579.2 4593.3 4648.5 1731.5 1801.7 1918.1 1924.6 1974.4 846.2 945.8 977.2 1013.9 1027.6 20938.4 21385.0 21428.5 21472.6 21533.9 908.9 948.7 956.4 957.5 973.8 10986.6 11246.0 11430.0 11488.7 11536.4 519177.0 522115.0 524183.0 586568.1 591189.0 134419.7 140192.0 142684.0 147356.0 149761.3 801.3 988.8 1016.5 1017.1 1017.5 19085.4 19770.7 19803.4 19837.5 19896.8 54735.0 57500.0 57784.7 58010.0 58816.8 83151.0 84821.2 85509.6 86308.0 87861.0 8010.3 8070.0 8122.7 8218.5 8262.1 8641.9 10763.9 11822.8 11923.5 12202.6 9061.2 10934.1 10943.5 10976.3 11285.7 10761.9 11037.7 11088.6 11119.8 11156.8 10891.8 11130.4 11138.5 11174.8 11365.3 6982.8 7391.8 7463.0 8025.4 8200.9 9615.3 10144.8 10649.8 11251.8 11750.8 17:30:44 INFO - PROCESS | 1650 | 17:30:44 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5660.50 Median:2665.04 stddev:3239.22 (121.5%) stddev-sans-first:3232.11 17:30:44 INFO - PROCESS | 1650 | Values: 1349.8 1532.7 1542.3 1749.2 1901.9 7865.2 8370.5 8533.2 8780.3 8784.8 8639.9 8728.4 8732.9 8741.2 8760.4 2346.1 2371.5 2374.9 2376.0 2376.6 2320.4 2374.6 2378.0 2383.9 2390.0 2330.9 2351.8 2373.2 2377.7 2382.3 2316.8 2346.2 2349.4 2351.1 2351.1 2303.3 2338.0 2338.2 2338.3 2339.1 8702.0 8788.4 8824.2 8843.3 8875.6 5228.8 5421.4 5424.2 5467.5 5468.5 3637.9 3672.5 3737.9 3747.4 3755.8 1094.1 1095.8 1096.1 1108.8 1111.0 11654.5 11698.4 11767.6 11768.2 11792.9 4136.6 4213.6 4442.1 4627.3 4635.0 9182.3 9198.9 9201.8 9213.0 9253.5 5264.9 5273.3 5278.0 5282.4 5290.9 4302.9 4453.7 4465.8 4608.9 4963.8 3759.0 3824.0 3828.6 3874.1 3874.3 998.9 1165.7 1168.5 1168.8 1184.6 675.8 820.8 843.0 850.7 859.0 5303.4 5344.1 5354.5 5679.6 5872.8 434.9 436.5 444.8 450.5 469.1 3282.9 3867.2 3870.4 3889.7 3917.9 10504.6 11025.6 11030.2 11031.8 11034.2 10948.3 10962.7 10969.6 10977.8 11000.0 7405.7 7426.3 8146.5 8267.3 8280.5 5013.4 5582.6 5669.8 5852.0 5862.7 9819.1 10111.3 10150.3 10171.0 10240.3 9882.2 9998.0 10173.0 10182.6 10267.9 7543.3 7727.7 7728.6 7732.4 7735.7 8291.1 8295.6 8296.5 8353.7 8381.2 7351.3 7474.2 7546.4 7578.7 7672.0 7367.5 7370.8 7421.4 7430.8 7540.8 6961.2 7040.3 7103.3 7120.7 7194.9 3999.9 4861.0 4898.2 5004.2 5103.0 5001.4 5046.6 5066.4 5077.8 5105.6 17:30:44 INFO - PROCESS | 1650 | 17:30:44 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4508.83 Median:5142.45 stddev:1429.65 (27.8%) stddev-sans-first:1398.27 17:30:44 INFO - PROCESS | 1650 | Values: 296.7 304.0 306.4 308.6 312.0 5258.4 5301.3 5333.7 5339.7 5349.5 4508.6 4673.0 5230.0 5244.9 5292.3 3161.7 3216.6 3393.9 3866.9 4046.3 3553.7 3575.6 3710.4 4112.8 4141.0 3218.8 4066.2 4072.3 4073.0 4095.7 3513.8 3710.2 4019.6 4058.6 4101.3 3155.4 3531.6 3544.3 3558.4 3572.4 3833.5 3844.7 5119.0 5185.2 5273.2 4309.7 4665.3 4693.2 4698.3 4711.8 5028.0 5264.0 5618.9 5619.9 5684.7 3248.6 3862.5 3868.2 3868.2 3880.2 4725.7 5490.3 5554.7 5875.3 6000.7 3953.5 3978.8 4041.2 4056.3 4060.5 3811.8 4108.7 4109.3 4113.0 4125.3 4380.8 4725.6 4740.1 4753.9 4765.4 5480.8 5635.6 5639.0 5688.1 5690.5 1199.4 1241.5 1377.2 1402.6 1408.3 808.7 847.0 858.9 860.0 865.9 4165.4 4550.5 4841.4 5052.3 5369.1 4858.3 5071.4 5718.6 5796.6 5829.0 4116.9 5244.3 5274.8 5294.8 5374.8 2414.7 2940.3 2968.6 3055.7 3069.2 4788.7 5549.8 5986.9 5996.7 6020.3 4836.0 5938.6 5948.2 5987.5 6008.0 5217.8 5456.8 5919.1 5927.0 5984.3 4802.8 5355.5 5773.4 5785.2 5901.0 4529.4 5016.7 5701.9 5734.6 5734.8 5849.7 5932.3 5953.9 5988.9 6031.4 2916.2 3014.6 3317.0 3322.0 3348.9 5376.5 5857.3 5878.1 5902.5 5945.5 5480.8 5647.2 5659.3 5675.7 5721.3 5415.6 5654.0 5660.9 5702.3 5739.0 5050.7 5430.4 5562.7 5584.3 5605.9 4391.5 5320.2 5461.9 5584.5 5663.9 5165.9 5483.9 5532.3 5533.9 5538.4 17:30:44 INFO - PROCESS | 1650 | 17:30:44 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:24938.79 Median:3565.23 stddev:40322.48 (1131.0%) stddev-sans-first:40394.51 17:30:44 INFO - PROCESS | 1650 | Values: 697.4 732.3 769.4 792.4 808.2 15179.5 16264.7 16280.3 16409.7 16496.2 13353.4 13416.3 13423.1 13425.5 13427.1 678.8 697.2 854.0 854.7 871.5 863.8 864.1 866.7 866.7 869.7 921.6 921.6 923.6 923.9 929.3 714.7 734.9 738.4 739.8 914.7 552.3 667.0 683.3 685.2 696.0 15205.8 15221.2 15236.0 15246.5 15269.4 13897.9 13941.7 14116.2 14287.0 14442.6 11833.6 12508.9 12704.7 12886.5 13173.6 4457.4 4457.8 4591.2 4608.3 4642.5 119777.4 119883.0 120058.0 123921.4 125506.0 10568.4 10916.9 10938.6 11205.0 11333.7 22065.0 22072.3 22090.3 22093.7 22104.4 7732.1 7791.9 8021.5 8212.6 8235.8 4418.4 4452.2 4452.9 4491.5 4585.3 3493.3 3637.1 3639.7 3642.2 3645.4 608.7 632.7 651.1 654.7 657.7 527.4 527.7 563.5 564.2 633.2 8753.8 9102.4 9170.4 9198.1 9472.3 534.9 558.5 566.7 590.4 624.9 3730.6 4006.4 4227.4 4354.7 4455.6 91677.6 143679.3 144119.0 158238.2 160996.2 138664.0 139453.0 143772.0 147655.0 149003.0 104421.0 104861.5 106259.9 109387.0 115724.4 8973.9 9858.7 9924.0 10050.8 10121.9 56670.7 56884.4 57564.4 57584.0 58484.4 78856.6 79934.6 83757.5 84002.7 85188.3 10075.9 12072.9 12655.5 12846.1 13209.7 13988.4 14717.9 14987.0 15302.6 15585.0 12929.4 13254.9 13664.7 13964.3 14140.0 11438.4 13183.1 13213.7 13938.9 14053.9 12652.7 13683.4 14176.7 14187.2 14208.0 10686.8 11129.8 11575.7 11827.6 11949.6 8888.8 10298.2 11038.5 11538.2 11557.8 17:30:44 INFO - PROCESS | 1650 | -------- Summary: end -------- 17:30:44 INFO - PROCESS | 1650 | 17:30:44 INFO - TEST-INFO | 1650: exit 0 17:30:44 INFO - TEST-OK | dromaeo_css | took 1117107ms 17:30:44 INFO - TEST-START | kraken 17:30:44 INFO - operating with platform_type : mac_ 17:30:44 INFO - Initialising browser for kraken test... 17:30:44 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/tmpt4pJjr/profile http://localhost:49273/getInfo.html) 17:30:47 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 17:30:47 INFO - PROCESS | 1661 | colorDepth:24 17:30:47 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 17:30:47 INFO - PROCESS | 1661 | __metrics 17:30:47 INFO - PROCESS | 1661 | 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" 17:30:47 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:30:47 INFO - TEST-INFO | 1661: exit 0 17:30:47 INFO - Browser initialized. 17:30:47 INFO - Running cycle 1/1 for kraken test... 17:30:47 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/tmpt4pJjr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:30:59 INFO - PROCESS | 1662 | RSS: Main: 219529216 17:30:59 INFO - PROCESS | 1662 | 17:31:02 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 17:31:03 INFO - PROCESS | 1662 | RSS: Main: 269549568 17:31:03 INFO - PROCESS | 1662 | 17:31:05 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 17:31:06 INFO - PROCESS | 1662 | RSS: Main: 280129536 17:31:06 INFO - PROCESS | 1662 | 17:31:09 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 17:31:10 INFO - PROCESS | 1662 | RSS: Main: 374800384 17:31:10 INFO - PROCESS | 1662 | 17:31:12 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 17:31:12 INFO - PROCESS | 1662 | RSS: Main: 280481792 17:31:12 INFO - PROCESS | 1662 | 17:31:14 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:31:15 INFO - PROCESS | 1662 | RSS: Main: 281055232 17:31:15 INFO - PROCESS | 1662 | 17:31:17 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 17:31:18 INFO - PROCESS | 1662 | RSS: Main: 318341120 17:31:18 INFO - PROCESS | 1662 | 17:31:21 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 17:31:22 INFO - PROCESS | 1662 | RSS: Main: 319369216 17:31:22 INFO - PROCESS | 1662 | 17:31:24 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 17:31:25 INFO - PROCESS | 1662 | RSS: Main: 317739008 17:31:25 INFO - PROCESS | 1662 | 17:31:26 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:31:27 INFO - PROCESS | 1662 | RSS: Main: 290111488 17:31:27 INFO - PROCESS | 1662 | 17:31:29 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:31:30 INFO - PROCESS | 1662 | RSS: Main: 295641088 17:31:30 INFO - PROCESS | 1662 | 17:31:32 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:31:32 INFO - PROCESS | 1662 | RSS: Main: 298205184 17:31:32 INFO - PROCESS | 1662 | 17:31:35 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:31:36 INFO - PROCESS | 1662 | RSS: Main: 315645952 17:31:36 INFO - PROCESS | 1662 | 17:31:39 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:31:39 INFO - PROCESS | 1662 | RSS: Main: 309047296 17:31:39 INFO - PROCESS | 1662 | 17:31:41 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 17:31:41 INFO - PROCESS | 1662 | RSS: Main: 353390592 17:31:41 INFO - PROCESS | 1662 | 17:31:41 INFO - PROCESS | 1662 | __start_tp_report 17:31:41 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 17:31:41 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 17:31:41 INFO - PROCESS | 1662 | |i|pagename|runs| 17:31:41 INFO - PROCESS | 1662 | |0;ai-astar;115;113;115;114;115;114;113;114;113;113 17:31:41 INFO - PROCESS | 1662 | |1;audio-beat-detection;141;109;111;140;109;108;107;106;138;110 17:31:41 INFO - PROCESS | 1662 | |2;audio-dft;183;186;182;183;183;182;182;183;182;183 17:31:41 INFO - PROCESS | 1662 | |3;audio-fft;79;57;59;88;61;60;58;58;83;57 17:31:41 INFO - PROCESS | 1662 | |4;audio-oscillator;83;70;92;68;67;68;91;67;68;90 17:31:41 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;88;85;88;86;88;86;89;87;89;88 17:31:41 INFO - PROCESS | 1662 | |6;imaging-darkroom;96;98;97;97;95;98;97;97;96;97 17:31:41 INFO - PROCESS | 1662 | |7;imaging-desaturate;84;84;84;86;84;88;86;85;85;85 17:31:41 INFO - PROCESS | 1662 | |8;json-parse-financial;57;54;54;54;55;57;58;58;57;56 17:31:41 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;64;70;71;74;71;69;67;68;70;68 17:31:41 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;82;83;82;82;82;81;82;81;82;81 17:31:41 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;139;139;144;144;145;140;136;145;197;150 17:31:41 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;160;165;162;161;165;161;164;156;201;221 17:31:41 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;67;66;67;67;66;66;66;65;66;64 17:31:41 INFO - PROCESS | 1662 | __end_tp_report 17:31:41 INFO - PROCESS | 1662 | __start_cc_report 17:31:41 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1922 17:31:41 INFO - PROCESS | 1662 | __end_cc_report 17:31:41 INFO - PROCESS | 1662 | __startTimestamp1477355501864__endTimestamp 17:31:41 INFO - PROCESS | 1662 | 17:31:41 INFO - PROCESS | 1662 | ------- Summary: start ------- 17:31:41 INFO - PROCESS | 1662 | Number of tests: 14 17:31:41 INFO - PROCESS | 1662 | 17:31:41 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:0.88 (0.8%) stddev-sans-first:0.83 17:31:41 INFO - PROCESS | 1662 | Values: 115.0 113.0 115.0 114.0 115.0 114.0 113.0 114.0 113.0 113.0 17:31:41 INFO - PROCESS | 1662 | 17:31:41 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:117.90 Median:110.50 stddev:15.10 (13.7%) stddev-sans-first:13.51 17:31:41 INFO - PROCESS | 1662 | Values: 141.0 109.0 111.0 140.0 109.0 108.0 107.0 106.0 138.0 110.0 17:31:41 INFO - PROCESS | 1662 | 17:31:41 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:182.90 Median:183.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 17:31:41 INFO - PROCESS | 1662 | Values: 183.0 186.0 182.0 183.0 183.0 182.0 182.0 183.0 182.0 183.0 17:31:41 INFO - PROCESS | 1662 | 17:31:41 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:66.00 Median:60.50 stddev:12.21 (20.2%) stddev-sans-first:12.01 17:31:41 INFO - PROCESS | 1662 | Values: 79.0 57.0 59.0 88.0 61.0 60.0 58.0 58.0 83.0 57.0 17:31:41 INFO - PROCESS | 1662 | 17:31:41 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:76.40 Median:76.50 stddev:11.13 (14.5%) stddev-sans-first:11.54 17:31:41 INFO - PROCESS | 1662 | Values: 83.0 70.0 92.0 68.0 67.0 68.0 91.0 67.0 68.0 90.0 17:31:41 INFO - PROCESS | 1662 | 17:31:41 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:88.00 stddev:1.35 (1.5%) stddev-sans-first:1.41 17:31:41 INFO - PROCESS | 1662 | Values: 88.0 85.0 88.0 86.0 88.0 86.0 89.0 87.0 89.0 88.0 17:31:41 INFO - PROCESS | 1662 | 17:31:41 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:96.80 Median:97.00 stddev:0.92 (0.9%) stddev-sans-first:0.93 17:31:41 INFO - PROCESS | 1662 | Values: 96.0 98.0 97.0 97.0 95.0 98.0 97.0 97.0 96.0 97.0 17:31:41 INFO - PROCESS | 1662 | 17:31:41 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:1.29 (1.5%) stddev-sans-first:1.30 17:31:41 INFO - PROCESS | 1662 | Values: 84.0 84.0 84.0 86.0 84.0 88.0 86.0 85.0 85.0 85.0 17:31:41 INFO - PROCESS | 1662 | 17:31:41 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:57.00 stddev:1.63 (2.9%) stddev-sans-first:1.69 17:31:41 INFO - PROCESS | 1662 | Values: 57.0 54.0 54.0 54.0 55.0 57.0 58.0 58.0 57.0 56.0 17:31:41 INFO - PROCESS | 1662 | 17:31:41 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:70.00 stddev:2.70 (3.9%) stddev-sans-first:2.11 17:31:41 INFO - PROCESS | 1662 | Values: 64.0 70.0 71.0 74.0 71.0 69.0 67.0 68.0 70.0 68.0 17:31:41 INFO - PROCESS | 1662 | 17:31:41 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:0.63 (0.8%) stddev-sans-first:0.67 17:31:41 INFO - PROCESS | 1662 | Values: 82.0 83.0 82.0 82.0 82.0 81.0 82.0 81.0 82.0 81.0 17:31:41 INFO - PROCESS | 1662 | 17:31:41 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:147.90 Median:144.50 stddev:17.72 (12.3%) stddev-sans-first:18.50 17:31:41 INFO - PROCESS | 1662 | Values: 139.0 139.0 144.0 144.0 145.0 140.0 136.0 145.0 197.0 150.0 17:31:41 INFO - PROCESS | 1662 | 17:31:41 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:164.50 stddev:21.46 (13.0%) stddev-sans-first:22.35 17:31:41 INFO - PROCESS | 1662 | Values: 160.0 165.0 162.0 161.0 165.0 161.0 164.0 156.0 201.0 221.0 17:31:41 INFO - PROCESS | 1662 | 17:31:41 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:0.94 (1.4%) stddev-sans-first:0.93 17:31:41 INFO - PROCESS | 1662 | Values: 67.0 66.0 67.0 67.0 66.0 66.0 66.0 65.0 66.0 64.0 17:31:41 INFO - PROCESS | 1662 | -------- Summary: end -------- 17:31:41 INFO - PROCESS | 1662 | 17:31:42 INFO - TEST-INFO | 1662: exit 0 17:31:42 INFO - TEST-OK | kraken | took 57977ms 17:31:42 INFO - SUITE-END | took 1175s 17:31:43 INFO - Completed test suite (00:19:35) 17:31:43 INFO - javascript benchmark 17:31:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3007.744341730953, 3298.472244440889, 3319.2033911861154, 3347.928662827896, 3354.1446931032583, 5722.170285308628, 5729.28383952006, 5748.856278593027, 5764.0, 5794.5943783935145, 5757.395473475288, 5827.854303642401, 5832.445917637829, 5834.416558344164, 5840.620359676618, 5197.168453047494, 5205.453427390117, 5264.236685680574, 5266.210068489719, 5307.310049693534, 5164.845054648366, 5191.013707395602, 5193.844184674447, 5250.684958902459, 5382.085045542248, 5242.135047717141, 5329.520343169114, 5336.893262134755, 5344.679319240858, 5355.437679043703, 4358.956410435902, 5314.73426328682, 5332.520073193412, 5348.759305831247, 5376.193570964387, 5099.209622508517, 5216.7913283468615, 5271.262023316739, 5280.49835265653, 5305.867353316198, 5587.273654424899, 5694.77220911163, 5703.686297253649, 5704.999999999958, 5724.856878578027, 5889.057750759858, 6124.229237387393, 6198.4731297839735, 6227.283862355796, 6229.4393504584805, 5215.6609820361555, 6251.687415629246, 6252.749890004395, 6266.404691554295, 6272.153259310026, 5680.091185410314, 5929.8814023719715, 5935.52515798735, 5955.731992060368, 5961.642301461926, 6193.659348735863, 6228.377162283826, 6264.436200741864, 6264.718087686065, 6304.369563043659, 6233.283172435228, 6246.46905013079, 6248.562600617913, 6252.093446450239, 6254.937450625435, 6286.4342209201395, 6296.370362963667, 6310.242770867433, 6326.746930122836, 6333.68331583419, 5009.323741294878, 6127.111568822585, 6128.631388773761, 6152.630842149396, 6206.162168107247, 6108.159949115189, 6170.5372097092895, 6180.042093475518, 6182.072689096672, 6190.288116866528, 4824.131656301899, 4843.75781210938, 4890.1931181355385, 4909.018196360742, 4916.918277978839, 4369.847055353111, 4393.846215382447, 4394.055278115156, 4395.978020109943, 4401.735895846259, 5777.884442311214, 5789.45000224978, 5832.854178645568, 5869.236999190163, 5959.940400595939, 6217.028081239776, 6219.471344935731, 6227.595206311576, 6237.750489980441, 6265.843353916189, 5865.472107510344, 5874.206982057368, 5878.794242201502, 5880.117982302603, 5910.113482977587, 5324.121519949243, 5349.732513374393, 5389.595780316492, 5391.406945236021, 5449.182622606561, 6298.118263443122, 6299.5275354348605, 6357.809265722036, 6359.0, 6382.585131966407, 6243.406876346739, 6243.438090571689, 6252.499800015897, 6255.78104766331, 6256.655883926428, 6192.442680158807, 6222.564420490703, 6253.937460625336, 6329.715162817776, 6340.968295158495, 6204.7828326008375, 6238.594491358047, 6258.311585725475, 6305.653189074645, 6306.810795676137, 6092.878142437038, 6237.8752424950335, 6277.466415354746, 6281.623102613858, 6290.025046117859, 6030.668313242813, 6129.84675383119, 6170.012797952486, 6224.128621992834, 6224.128621993015, 6050.757969681339, 6109.283207920342, 6140.074827791203, 6144.064619644798, 6221.502279817694, 6099.024156135175, 6101.294003060948, 6108.226837060667, 6110.514619590966, 6122.387761223842, 6181.84545386369, 6209.130721698875, 6209.720562574605, 6220.72006759706, 6239.1577137085915, 5848.181254624441, 5908.350081490947, 5908.3500814911185, 5942.959982003219, 6019.307779605227], "value": 5718.856513387273, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.5663131497308, 536.6109570561343, 546.923430719699, 548.0108404330184, 549.2886711708338, 30293.69706302936, 31059.912903048396, 32314.0, 40607.79696101523, 41227.969300767494, 42930.57069429305, 43274.350884736676, 43298.56701432985, 43340.0, 43511.34732979, 9708.271879609023, 9876.308658393915, 9894.703158905244, 9897.010298970117, 9897.307188496809, 7851.8037049073655, 8568.314534837229, 8963.64145434185, 9062.864057039149, 9085.727428177166, 8972.057933916944, 11880.940595297012, 12195.45120469581, 12203.328816915066, 12414.565490207844, 12231.143819932608, 12288.938555307255, 12312.076594255423, 12312.445939932724, 12314.630561083182, 8683.175098365646, 11988.220765650205, 12080.395980200954, 12082.818757718642, 12099.0, 31148.688513114805, 39844.20311593781, 39930.0, 40028.799856000536, 42657.786711066554, 2881.222070041098, 3339.632640409553, 3598.6401359863803, 3998.8800335989968, 4063.6545893599077, 29743.553846692317, 29808.403831923457, 31505.21236969071, 32225.516617250527, 32242.87149949764, 3100.2137907430015, 3325.617553981275, 3349.3301339731906, 3383.898483045488, 3425.657434256579, 511437.8856211465, 514130.0, 514359.0, 514544.0, 517242.41378792864, 43108.13783724308, 50858.237126443135, 56809.0, 58201.70899145477, 58590.0, 59538.0, 63389.68305158445, 63431.04853427202, 63465.68267158635, 63673.0, 16328.67342653164, 16352.591185220464, 16450.83549164493, 16495.17524123813, 16502.17489125539, 13009.479620815251, 13109.737805244033, 13116.540921067908, 13123.60629181126, 13136.934315328554, 14220.360083796253, 14482.637934051732, 15980.200989950456, 16044.75932861008, 16071.714262858943, 6290.937090629035, 6571.967140164268, 6613.933860661332, 6626.768063117768, 6640.501962352843, 803.3171803966582, 937.7340590203307, 971.9028097190366, 993.1855878179823, 1000.9849852252222, 29301.706982930325, 30143.849280753457, 30179.396412071637, 30648.540271895938, 30781.0, 788.8658927982257, 913.2925580494241, 1077.224398433127, 1088.6679562733284, 1093.4642025407652, 14634.780478292834, 15374.9231253843, 15432.768508472382, 15461.845381546265, 15758.527244182693, 692298.0, 696937.0, 700301.0, 702359.0, 704006.0, 49926.0, 49959.0008199834, 50932.236016459785, 50968.490315097115, 58942.0, 1386.272207091285, 1388.6042477893955, 1406.5217825939026, 1408.556304763996, 1410.6684929041871, 27909.58135628008, 29974.400511989203, 30409.543856841723, 31161.220969475038, 31286.0, 44140.0, 50152.749236253585, 50352.0, 50659.0, 50698.0, 653180.0, 669079.0, 680882.0, 902423.0, 905636.4718176367, 25253.87373063123, 25420.110296139548, 25523.36191595225, 25782.484350313265, 25846.0, 45697.77151114223, 45749.85625359393, 45884.54115458803, 45888.08223835572, 47007.824804380165, 31112.377752444372, 37643.05892352713, 38198.0, 38201.61798381981, 38315.808420957714, 37423.812880935424, 38057.80971095127, 38434.42348364721, 39371.0, 39457.81626551208, 36665.0, 36985.445218321205, 37106.07234819043, 37466.875993720234, 37660.62339376571, 30946.381072378877, 32908.34183316368, 32923.0, 33024.834875825465, 33202.0, 22212.44468888226, 24490.510189795747, 25046.74953250517, 25336.60648664341, 25791.355216119748], "value": 20044.821355506752, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.9120219945014, 370.3370965970912, 375.7520036775727, 383.3100419245359, 404.4156194299237, 15382.384704611803, 15531.0, 20139.899300503515, 21886.343409697696, 22155.556888862255, 19740.901295493502, 20405.183792648313, 20462.795372046276, 20620.1751929923, 21008.8949555252, 5241.3186285782795, 5550.611457197998, 5550.72246387681, 5555.583331250152, 5561.082421400464, 5492.423295553969, 5578.219049333096, 5997.700114994254, 6271.15339429178, 6321.620702757827, 6300.086487459315, 6357.809265722036, 6363.109164716943, 6369.299377068519, 6371.649559274261, 6053.303870054934, 6148.600340977844, 6206.441420272175, 6206.534509911775, 6216.005439129763, 5838.357780644125, 5995.250593675791, 6061.151438798572, 6072.392760723937, 6078.057901025348, 13345.065845390827, 13413.061085724003, 13585.049046566744, 13602.931985340108, 13609.251491167981, 1815.5551889786955, 2179.574982878339, 2201.119552179125, 2320.8955596998176, 2358.1274928276475, 9829.459379734111, 9975.301728878982, 10425.270231083752, 10533.31533450331, 13644.863551364459, 1637.9517109050216, 1880.858935579837, 1890.7825600055894, 1955.878783074813, 1959.5395082155683, 114837.56809415808, 118894.0, 123110.38444807718, 138136.0, 138173.0, 11555.537778488766, 11633.917011991829, 11657.76684466306, 11775.646730598095, 11985.161038727205, 13221.471141154438, 13759.312034398441, 13774.449022039005, 13788.724225515634, 14535.418583256764, 8576.670616054522, 8613.96632404103, 8695.913040869511, 8782.341324400695, 8823.602937867812, 8209.917900820916, 8611.6985905493, 8720.912790872137, 8731.650733970697, 8820.25027872638, 4511.390962220124, 4578.954210457853, 4579.22153233951, 4593.324092754348, 4648.5119062498625, 1731.5151757507917, 1801.6937120689515, 1918.1272521003189, 1924.5669724312197, 1974.407677696714, 846.2003406780657, 945.839207334741, 977.1840513171582, 1013.9290249682451, 1027.5530144387214, 20938.37184884456, 21385.0, 21428.464288392915, 21472.57054858894, 21533.89233053856, 908.895477020138, 948.6821914658528, 956.4261443134064, 957.5164541906292, 973.7711637765119, 10986.615468458725, 11246.0, 11429.97130258264, 11488.655340339803, 11536.365499897418, 519177.0, 522115.0, 524183.0, 586568.06715967, 591189.0, 134419.65580344267, 140192.0, 142684.0, 147356.0, 149761.25119374334, 801.3268854162532, 988.7577543501889, 1016.4714348538719, 1017.0998666180484, 1017.4759998600726, 19085.427437176906, 19770.70343944813, 19803.40589782309, 19837.504062398555, 19896.801031989497, 54735.0, 57500.0, 57784.71107644435, 58010.0, 58816.82366352734, 83151.0, 84821.15178848132, 85509.57245213733, 86308.0, 87861.0, 8010.319122874621, 8070.031596208258, 8122.715704950535, 8218.547979861165, 8262.091169971178, 8641.913580864111, 10763.94618026905, 11822.763544729229, 11923.463444145207, 12202.572909948109, 9061.229795467196, 10934.070603998749, 10943.507542160463, 10976.341419514854, 11285.661430157108, 10761.946190268998, 11037.724056898642, 11088.556457741923, 11119.767476702698, 11156.776864462503, 10891.836622450828, 11130.443477825915, 11138.498767555317, 11174.832377514182, 11365.261258018203, 6982.755603553851, 7391.8152046199275, 7462.96268518654, 8025.438219324591, 8200.876986845084, 9615.326927115315, 10144.847827282449, 10649.840252396065, 11251.774964500828, 11750.764984700087], "value": 9464.72452743305, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.7705390083686, 1532.6934613077387, 1542.344503585976, 1749.2041121289815, 1901.9144138513775, 7865.174156713541, 8370.53962032088, 8533.232009119185, 8780.297576193905, 8784.78038049049, 8639.913600863989, 8728.389012769108, 8732.91267087329, 8741.16958888906, 8760.386772925898, 2346.1319311854595, 2371.5256948610263, 2374.881255937205, 2376.0377047295788, 2376.572217000939, 2320.385097949045, 2374.584447721642, 2377.9643305350432, 2383.892724827387, 2389.9641505377435, 2330.871802050895, 2351.811855051592, 2373.169390713254, 2377.702787151606, 2382.28531440568, 2316.814654827627, 2346.21401830387, 2349.447879748258, 2351.106579499779, 2351.130081869702, 2303.3090072978207, 2338.0, 2338.1699496678602, 2338.3101984914492, 2339.0526836631193, 8702.042775294713, 8788.384813063089, 8824.249938755214, 8843.292536597057, 8875.556222188929, 5228.79084836606, 5421.430749771257, 5424.240606315119, 5467.480589344006, 5468.507834294893, 3637.8726744563814, 3672.5042119314085, 3737.8975450376124, 3747.4191500317493, 3755.75587586806, 1094.1301665176204, 1095.802755504009, 1096.1450068946235, 1108.772701596171, 1111.0389513071136, 11654.475548600334, 11698.41507924609, 11767.646970590897, 11768.235064720851, 11792.882071179265, 4136.607022332873, 4213.578642135823, 4442.089371678798, 4627.30590411441, 4635.0, 9182.311326650395, 9198.942121656095, 9201.769955751026, 9212.953935230415, 9253.49105799174, 5264.868378290574, 5273.2617433559335, 5278.0, 5282.445343238982, 5290.867728306823, 4302.935455968163, 4453.688241823042, 4465.799039043251, 4608.907821843612, 4963.8262660806695, 3759.0, 3824.0248736572553, 3828.578856325802, 3874.1089549403796, 3874.2638898609175, 998.9250806189565, 1165.6736113888126, 1168.5033860609376, 1168.8422063021383, 1184.6150001249457, 675.7803713793037, 820.7948012996751, 843.0473564871655, 850.7405241401432, 859.0, 5303.416624171416, 5344.144936810092, 5354.4645535446925, 5679.602427830012, 5872.823815285548, 434.926062569364, 436.47622852577035, 444.7531619950958, 450.4639479019956, 469.0806020200377, 3282.9343413131605, 3867.16855875988, 3870.4000879863665, 3889.6888248940018, 3917.9216415671526, 10504.632337868137, 11025.558977640805, 11030.172737044593, 11031.779364412827, 11034.172437067253, 10948.34309941406, 10962.671119866416, 10969.561217551369, 10977.780444391068, 11000.009999099959, 7405.703771849066, 7426.331630153312, 8146.470479418819, 8267.255946964802, 8280.461769985051, 5013.39839219296, 5582.609217354746, 5669.829905102689, 5852.005159122874, 5862.736176872137, 9819.06718861707, 10111.292209545261, 10150.289479736348, 10170.982901709769, 10240.283180177315, 9882.209423245979, 9997.950010249902, 10172.982701730063, 10182.592696292066, 10267.94866025695, 7543.321101100927, 7727.729529466442, 7728.613569321399, 7732.38140948734, 7735.651895664596, 8291.08798032204, 8295.585220738818, 8296.460730052528, 8353.749387518385, 8381.245687888118, 7351.301626345488, 7474.177840437439, 7546.358559522502, 7578.696852125853, 7672.0, 7367.5211111277595, 7370.815729606803, 7421.4062874968795, 7430.814229644302, 7540.8491830164185, 6961.199462061725, 7040.295970402919, 7103.289671032855, 7120.679569419285, 7194.856102877809, 3999.940000900047, 4860.997323720597, 4898.24077268024, 5004.17431123875, 5102.979404119117, 5001.399832020181, 5046.596272298134, 5066.417362003417, 5077.822276220315, 5105.566026887756], "value": 4444.552452491571, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.69292282487623, 303.95288730246807, 306.4132186862158, 308.64197530864203, 311.9594452721146, 5258.395284542279, 5301.284326615906, 5333.706646134461, 5339.733013349327, 5349.491798279162, 4508.571685689854, 4672.976635116828, 5230.0, 5244.947550524494, 5292.338457692788, 3161.668024857391, 3216.5979252593365, 3393.9151521212043, 3866.8624571708283, 4046.271671099201, 3553.7157027437743, 3575.570931488225, 3710.3877860153043, 4112.794360281989, 4140.979295103521, 3218.7585931055146, 4066.227416790815, 4072.287349713803, 4073.002114481956, 4095.7133000689964, 3513.789172649649, 3710.239400922804, 4019.618136277049, 4058.559211479941, 4101.2931465232805, 3155.353152603711, 3531.5632213772674, 3544.3442963051916, 3558.4128618777872, 3572.356975744365, 3833.5399752029657, 3844.692424606025, 5118.950615123891, 5185.196294574347, 5273.209018647233, 4309.698321117523, 4665.276882083249, 4693.178693728584, 4698.318743782167, 4711.8350857719815, 5028.019536190444, 5264.0, 5618.859528511779, 5619.904118696856, 5684.658920464785, 3248.59392575928, 3862.5364956205153, 3868.226354729037, 3868.2263547290654, 3880.1657643606477, 4725.669203155746, 5490.313710786152, 5554.666719996813, 5875.265591801025, 6000.689734452224, 3953.486046813896, 3978.76127432355, 4041.211963667057, 4056.3104272273786, 4060.5330387005283, 3811.7522361047, 4108.67130629549, 4109.3425051991535, 4112.979435102805, 4125.257453658371, 4380.76580943721, 4725.5983241424865, 4740.099381117577, 4753.904921901542, 4765.404324459442, 5480.835574932758, 5635.633683810621, 5639.0, 5688.146777983336, 5690.459406356389, 1199.3868247207492, 1241.4971936365787, 1377.1874593989594, 1402.5903966513588, 1408.295852073963, 808.7290757596271, 846.9957650211833, 858.8539948208819, 860.0238729042456, 865.8960924688952, 4165.437960764713, 4550.453945526558, 4841.419029716386, 5052.267421223902, 5369.067135831097, 4858.295547145714, 5071.366079240095, 5718.628289161275, 5796.62321949072, 5829.0, 4116.876493705194, 5244.265802787613, 5274.841754747364, 5294.7617357219015, 5374.838754837361, 2414.7102347718387, 2940.294329360938, 2968.6289213848268, 3055.663876973531, 3069.1891783847636, 4788.688735232199, 5549.750261238173, 5986.880262394815, 5996.730147143389, 6020.307664618537, 4835.95164048362, 5938.6436813791315, 5948.193156379921, 5987.533463859022, 6007.978643630593, 5217.765200565984, 5456.809011684572, 5919.076300202538, 5927.044075455089, 5984.3417224105315, 4802.831900883452, 5355.544778693855, 5773.364929857797, 5785.247917770663, 5901.049475262369, 4529.411176547028, 5016.749162541932, 5701.945140149086, 5734.569907256889, 5734.827955161351, 5849.678267695318, 5932.2584676915385, 5953.910691339547, 5988.850278743066, 6031.4270144336215, 2916.241777137917, 3014.5930299410174, 3317.0, 3322.0467643504153, 3348.949765753467, 5376.462353764592, 5857.326407463026, 5878.059510478303, 5902.468777810018, 5945.464908158114, 5480.753366098615, 5647.237622921018, 5659.3491748447805, 5675.722962333607, 5721.2836149154255, 5415.566754659697, 5653.95401850659, 5660.924424359358, 5702.258706368146, 5738.971305143447, 5050.696958182521, 5430.375506816608, 5562.694051827189, 5584.329880414376, 5605.943940560705, 4391.451068616423, 5320.201969704575, 5461.945380546303, 5584.497395234448, 5663.886722265449, 5165.9483405165465, 5483.945160548344, 5532.253145825423, 5533.916991245215, 5538.418466061005], "value": 4055.008743677411, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.3897839390534, 732.2933369298626, 769.3869164616124, 792.385900926782, 808.1675873849935, 15179.544613661581, 16264.674706505863, 16280.348786048573, 16409.671806563863, 16496.175191240436, 13353.399097040632, 13416.329183540833, 13423.127496712706, 13425.530106446276, 13427.060105792598, 678.8438659108408, 697.191258140557, 854.0477367734977, 854.6837670062085, 871.542440218887, 863.753830158405, 864.1099667342647, 866.679328648401, 866.6966561703385, 869.7086476030537, 921.6313474610176, 921.6451666108563, 923.5751554285036, 923.8752768376283, 929.3169520402532, 714.7069701422417, 734.904462419882, 738.3539403022355, 739.8150462384403, 914.6890057380489, 552.3178874090495, 667.0361327881213, 683.2518392360407, 685.2120061928772, 695.9699644526079, 15205.771913421308, 15221.238938053164, 15236.0, 15246.466373676869, 15269.38922443101, 13897.86102138986, 13941.675540823606, 14116.15303081808, 14287.0, 14442.638934026734, 11833.585824496187, 12508.937455312756, 12704.74590508194, 12886.484540618365, 13173.60479185626, 4457.375967364572, 4457.77711114443, 4591.173588754023, 4608.331791890158, 4642.535746425364, 119777.40111299475, 119883.0, 120058.0, 123921.38039309836, 125506.0, 10568.418736969386, 10916.890831091747, 10938.56245750177, 11205.0, 11333.659990200307, 22065.0, 22072.33782986513, 22090.33728988133, 22093.668594971088, 22104.44738881541, 7732.149463559004, 7791.92208077912, 8021.462373527099, 8212.63043163059, 8235.794105147419, 4418.403515525427, 4452.243118669834, 4452.910941781146, 4491.461024676994, 4585.266357382803, 3493.318802833423, 3637.1452708613456, 3639.70882329413, 3642.1805093853673, 3645.4167333227088, 608.6561092982539, 632.7405763636887, 651.1079820645746, 654.6955665615417, 657.6810247030187, 527.4435470578577, 527.7255826969954, 563.5407143178296, 564.1650357470966, 633.1610615933906, 8753.80242357757, 9102.362834601647, 9170.403923744936, 9198.126178013077, 9472.336936414385, 534.8716308086109, 558.4750334685464, 566.6543408520799, 590.4213870407025, 624.9283624783827, 3730.6082861299174, 4006.358982562776, 4227.387028880857, 4354.738715677069, 4455.643548516111, 91677.62483562752, 143679.2816035934, 144119.0, 158238.2088089575, 160996.17011489675, 138664.0, 139453.0, 143772.0, 147655.0, 149003.0, 104421.0, 104861.47569262257, 106259.93740062656, 109386.99999999841, 115724.42137789258, 8973.933379246622, 9858.654947076819, 9924.0, 10050.798984020425, 10121.898781012096, 56670.716646416506, 56884.43115568791, 57564.42435575591, 57584.0, 58484.4151558496, 78856.60571697105, 79934.600326998, 83757.48727538183, 84002.73995889944, 85188.29623407622, 10075.949620251851, 12072.879271207175, 12655.493780248687, 12846.100772945803, 13209.735805284034, 13988.440462381797, 14717.852821471648, 14987.0, 15302.617434564225, 15585.0, 12929.418176181905, 13254.933725331312, 13664.726705465637, 13964.301784910916, 14140.01019928595, 11438.428078596204, 13183.14309569875, 13213.669658258235, 13938.93030534841, 14053.929730351692, 12652.746945060862, 13683.384247708678, 14176.716465670423, 14187.219702916025, 14208.005439619128, 10686.786264274826, 11129.83305250438, 11575.71060723455, 11827.586034488751, 11949.641510754343, 8888.777780555538, 10298.22763292741, 11038.454616353878, 11538.192326537062, 11557.768844623228], "value": 7760.676949170725, "unit": "score"}], "name": "dromaeo_css", "value": 7303.5002108360395, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 115.0, 114.0, 115.0, 114.0, 113.0, 114.0, 113.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 109.0, 111.0, 140.0, 109.0, 108.0, 107.0, 106.0, 138.0, 110.0], "value": 117.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 182.0, 183.0, 183.0, 182.0, 182.0, 183.0, 182.0, 183.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 57.0, 59.0, 88.0, 61.0, 60.0, 58.0, 58.0, 83.0, 57.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 70.0, 92.0, 68.0, 67.0, 68.0, 91.0, 67.0, 68.0, 90.0], "value": 76.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 86.0, 88.0, 86.0, 89.0, 87.0, 89.0, 88.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 97.0, 97.0, 95.0, 98.0, 97.0, 97.0, 96.0, 97.0], "value": 96.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 86.0, 84.0, 88.0, 86.0, 85.0, 85.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 54.0, 54.0, 55.0, 57.0, 58.0, 58.0, 57.0, 56.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 71.0, 74.0, 71.0, 69.0, 67.0, 68.0, 70.0, 68.0], "value": 69.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 82.0, 82.0, 82.0, 81.0, 82.0, 81.0, 82.0, 81.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 139.0, 144.0, 144.0, 145.0, 140.0, 136.0, 145.0, 197.0, 150.0], "value": 147.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 165.0, 162.0, 161.0, 165.0, 161.0, 164.0, 156.0, 201.0, 221.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 67.0, 66.0, 66.0, 66.0, 65.0, 66.0, 64.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1418.9, "alertThreshold": 2.0}]} 17:31:43 INFO - Return code: 0 17:31:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:31:43 INFO - # TBPL SUCCESS # 17:31:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:31:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:31:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:31:43 INFO - 2016-10-24 17:31:43.214 screenresolution[1666:10144] starting screenresolution argv=screenresolution get 17:31:43 INFO - 2016-10-24 17:31:43.217 screenresolution[1666:10144] Display 0: 1600x1200x32@60 17:31:43 INFO - 2016-10-24 17:31:43.223 screenresolution[1667:10147] starting screenresolution argv=screenresolution list 17:31:43 INFO - Available Modes on Display 0 17:31:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:31:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:31:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:31:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:31:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:31:43 INFO - Intel Iris: 17:31:43 INFO - Chipset Model: Intel Iris 17:31:43 INFO - Type: GPU 17:31:43 INFO - Bus: Built-In 17:31:43 INFO - VRAM (Dynamic, Max): 1536 MB 17:31:43 INFO - Vendor: Intel (0x8086) 17:31:43 INFO - Device ID: 0x0a2e 17:31:43 INFO - Revision ID: 0x0009 17:31:43 INFO - Displays: 17:31:43 INFO - Display: 17:31:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:31:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:31:43 INFO - Display Serial Number: 1600x1200 60 17:31:43 INFO - Main Display: Yes 17:31:43 INFO - Mirror: Off 17:31:43 INFO - Online: Yes 17:31:43 INFO - Rotation: Supported 17:31:43 INFO - Return code: 0 17:31:43 INFO - Running post-action listener: _resource_record_post_action 17:31:43 INFO - [mozharness: 2016-10-25 00:31:43.460809Z] Finished run-tests step (success) 17:31:43 INFO - Running post-run listener: _resource_record_post_run 17:31:43 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 37688320; Write bytes: 662341120; Read time: 242; Write time: 1918 17:31:43 INFO - TinderboxPrint: CPU usage
53.4% 17:31:43 INFO - TinderboxPrint: I/O read bytes / time
37,688,320 / 242 17:31:43 INFO - TinderboxPrint: I/O write bytes / time
662,341,120 / 1,918 17:31:43 INFO - TinderboxPrint: CPU idle
2,250.4 (46.6%) 17:31:43 INFO - TinderboxPrint: CPU system
965.7 (20.0%) 17:31:43 INFO - TinderboxPrint: CPU user
1,617.6 (33.5%) 17:31:43 INFO - TinderboxPrint: Swap in / out
401,428,480 / 0 17:31:43 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 355037696; Write bytes: 355309568; Read time: 27214; Write time: 761 17:31:43 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 36729856; Write bytes: 296844800; Read time: 230; Write time: 1124 17:31:43 INFO - Running post-run listener: _upload_blobber_files 17:31:43 INFO - Blob upload gear active. 17:31:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:31:43 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 17:31:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:31:44 INFO - (blobuploader) - INFO - Open directory for files ... 17:31:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:31:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:31:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:31:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:31:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:31:45 INFO - (blobuploader) - INFO - Done attempting. 17:31:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:31:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:31:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:31:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:31:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:31:46 INFO - (blobuploader) - INFO - Done attempting. 17:31:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:31:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:31:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:31:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:31:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:31:48 INFO - (blobuploader) - INFO - Done attempting. 17:31:48 INFO - (blobuploader) - INFO - Iteration through files over. 17:31:48 INFO - Return code: 0 17:31:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:31:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:31:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03bf023a3d84da5fb3acec260b49c6c6e7deb2f691ef79a9a1a997732f695a12e0e7bbb758c81ef78ae9bad1f1a308831171645a5794e8622dbbec32d963b86d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3cfe3ab83a7950a9ab5c76ace8416c404a96baeb50fe673ab079a7f9631a81e785ca5b9af1316f478364a2d351759708da3f106eb77cfd70386f1889bd89c110", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc46fb21b6ea8a0959b57354d3d02531900c98868c2bdec9bdc1e077f2bf89cc146cfbe89488a4241d56ed743080c39b39c45aecca79a1ef064fdf08c92f73a0"} 17:31:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:31:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:31:48 INFO - Contents: 17:31:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03bf023a3d84da5fb3acec260b49c6c6e7deb2f691ef79a9a1a997732f695a12e0e7bbb758c81ef78ae9bad1f1a308831171645a5794e8622dbbec32d963b86d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3cfe3ab83a7950a9ab5c76ace8416c404a96baeb50fe673ab079a7f9631a81e785ca5b9af1316f478364a2d351759708da3f106eb77cfd70386f1889bd89c110", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc46fb21b6ea8a0959b57354d3d02531900c98868c2bdec9bdc1e077f2bf89cc146cfbe89488a4241d56ed743080c39b39c45aecca79a1ef064fdf08c92f73a0"} 17:31:48 INFO - Running post-run listener: copy_logs_to_upload_dir 17:31:48 INFO - Copying logs to upload dir... 17:31:48 INFO - mkdir: /builds/slave/test/build/upload/logs 17:31:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.501620 ========= master_lag: 2.56 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-24 17:31:51.226934) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 17:31:51.228180) ========= 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.uNK22YLExK/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.rLGtuoQ82o/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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/Mozilla-Aurora/sha512/03bf023a3d84da5fb3acec260b49c6c6e7deb2f691ef79a9a1a997732f695a12e0e7bbb758c81ef78ae9bad1f1a308831171645a5794e8622dbbec32d963b86d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3cfe3ab83a7950a9ab5c76ace8416c404a96baeb50fe673ab079a7f9631a81e785ca5b9af1316f478364a2d351759708da3f106eb77cfd70386f1889bd89c110", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc46fb21b6ea8a0959b57354d3d02531900c98868c2bdec9bdc1e077f2bf89cc146cfbe89488a4241d56ed743080c39b39c45aecca79a1ef064fdf08c92f73a0"} build_url:https://queue.taskcluster.net/v1/task/AK9iXXhxTiCCgjkfXP7Osg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011099 build_url: 'https://queue.taskcluster.net/v1/task/AK9iXXhxTiCCgjkfXP7Osg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03bf023a3d84da5fb3acec260b49c6c6e7deb2f691ef79a9a1a997732f695a12e0e7bbb758c81ef78ae9bad1f1a308831171645a5794e8622dbbec32d963b86d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3cfe3ab83a7950a9ab5c76ace8416c404a96baeb50fe673ab079a7f9631a81e785ca5b9af1316f478364a2d351759708da3f106eb77cfd70386f1889bd89c110", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc46fb21b6ea8a0959b57354d3d02531900c98868c2bdec9bdc1e077f2bf89cc146cfbe89488a4241d56ed743080c39b39c45aecca79a1ef064fdf08c92f73a0"}' ========= master_lag: 0.27 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 17:31:51.507982) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:31:51.508326) ========= 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.uNK22YLExK/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.rLGtuoQ82o/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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.005007 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:31:51.533359) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 17:31:51.533640) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 17:31:51.533955) ========= ========= Total master_lag: 2.92 =========