builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0101 starttime: 1476151221.15 results: success (0) buildid: 20161010164823 builduid: f03f04c0bf1044128964a124329dc5d1 revision: 9a452e8fde0ffd76d25179f5d6165265444a2247 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 19:00:21.150300) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 19:00:21.150854) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 19:00:21.151186) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 19:00:21.176253) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 19:00:21.176616) ========= 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.in4b5OJtvF/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.YuADeX9xq2/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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-10 19:00:21-- 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% 26.2M=0s 2016-10-10 19:00:21 (26.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.102113 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 19:00:21.301373) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 19:00:21.301687) ========= 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.in4b5OJtvF/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.YuADeX9xq2/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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.028221 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 19:00:21.350926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-10 19:00:21.351333) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9a452e8fde0ffd76d25179f5d6165265444a2247 --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 9a452e8fde0ffd76d25179f5d6165265444a2247 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.in4b5OJtvF/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.YuADeX9xq2/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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-10 19:00:21,436 truncating revision to first 12 chars 2016-10-10 19:00:21,437 Setting DEBUG logging. 2016-10-10 19:00:21,437 attempt 1/10 2016-10-10 19:00:21,437 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9a452e8fde0f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-10 19:00:23,208 unpacking tar archive at: mozilla-aurora-9a452e8fde0f/testing/mozharness/ program finished with exit code 0 elapsedTime=2.050802 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-10 19:00:23.426012) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 19:00:23.426323) ========= script_repo_revision: 9a452e8fde0ffd76d25179f5d6165265444a2247 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 19:00:23.426726) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 19:00:23.427004) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 19:00:23.444968) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-10-10 19:00:23.445341) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.in4b5OJtvF/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.YuADeX9xq2/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 19:00:23 INFO - MultiFileLogger online at 20161010 19:00:23 in /builds/slave/test 19:00:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:00:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:00:23 INFO - {'append_to_log': False, 19:00:23 INFO - 'base_work_dir': '/builds/slave/test', 19:00:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:00:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:00:23 INFO - 'branch': 'Mozilla-Aurora', 19:00:23 INFO - 'buildbot_json_path': 'buildprops.json', 19:00:23 INFO - 'config_files': ('talos/mac_config.py',), 19:00:23 INFO - 'default_actions': ('clobber', 19:00:23 INFO - 'read-buildbot-config', 19:00:23 INFO - 'download-and-extract', 19:00:23 INFO - 'populate-webroot', 19:00:23 INFO - 'create-virtualenv', 19:00:23 INFO - 'install', 19:00:23 INFO - 'run-tests'), 19:00:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:00:23 INFO - 'download_minidump_stackwalk': True, 19:00:23 INFO - 'download_symbols': 'ondemand', 19:00:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:00:23 INFO - 'tooltool.py': '/tools/tooltool.py', 19:00:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:00:23 INFO - '/tools/misc-python/virtualenv.py')}, 19:00:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:00:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:00:23 INFO - 'installer_path': 'installer.exe', 19:00:23 INFO - 'log_level': 'info', 19:00:23 INFO - 'log_name': 'talos', 19:00:23 INFO - 'log_to_console': True, 19:00:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:00:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:00:23 INFO - 'opt_config_files': (), 19:00:23 INFO - 'pip_index': False, 19:00:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:00:23 INFO - 'cmd': ('bash', 19:00:23 INFO - '-c', 19:00:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:00:23 INFO - 'enabled': True, 19:00:23 INFO - 'halt_on_failure': False, 19:00:23 INFO - 'name': 'check_screen_resolution'},), 19:00:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:00:23 INFO - 'cmd': ('bash', 19:00:23 INFO - '-c', 19:00:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:00:23 INFO - 'enabled': True, 19:00:23 INFO - 'halt_on_failure': False, 19:00:23 INFO - 'name': 'check_screen_resolution'},), 19:00:23 INFO - 'run_cmd_checks_enabled': True, 19:00:23 INFO - 'sps_profile': False, 19:00:23 INFO - 'sps_profile_interval': 0, 19:00:23 INFO - 'suite': 'dromaeojs-e10s', 19:00:23 INFO - 'system_bits': '32', 19:00:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:00:23 INFO - 'title': 't-yosemite-r7-0101', 19:00:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:00:23 INFO - 'use_talos_json': True, 19:00:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:00:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:00:23 INFO - 'work_dir': 'build'} 19:00:23 INFO - [mozharness: 2016-10-11 02:00:23.641033Z] Running clobber step. 19:00:23 INFO - Running pre-action listener: _resource_record_pre_action 19:00:23 INFO - Running main action method: clobber 19:00:23 INFO - rmtree: /builds/slave/test/build 19:00:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:00:25 INFO - Running post-action listener: _resource_record_post_action 19:00:25 INFO - [mozharness: 2016-10-11 02:00:25.845928Z] Finished clobber step (success) 19:00:25 INFO - [mozharness: 2016-10-11 02:00:25.846049Z] Running read-buildbot-config step. 19:00:25 INFO - Running pre-action listener: _resource_record_pre_action 19:00:25 INFO - Running main action method: read_buildbot_config 19:00:25 INFO - Using buildbot properties: 19:00:25 INFO - { 19:00:25 INFO - "project": "", 19:00:25 INFO - "product": "firefox", 19:00:25 INFO - "script_repo_revision": "production", 19:00:25 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 19:00:25 INFO - "repository": "", 19:00:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 19:00:25 INFO - "buildid": "20161010164823", 19:00:25 INFO - "pgo_build": "False", 19:00:25 INFO - "basedir": "/builds/slave/test", 19:00:25 INFO - "buildnumber": 18, 19:00:25 INFO - "slavename": "t-yosemite-r7-0101", 19:00:25 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 19:00:25 INFO - "platform": "yosemite_r7", 19:00:25 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 19:00:25 INFO - "branch": "mozilla-aurora", 19:00:25 INFO - "repo_path": "releases/mozilla-aurora", 19:00:25 INFO - "revision": "9a452e8fde0ffd76d25179f5d6165265444a2247", 19:00:25 INFO - "stage_platform": "macosx64", 19:00:25 INFO - "builduid": "f03f04c0bf1044128964a124329dc5d1", 19:00:25 INFO - "slavebuilddir": "test" 19:00:25 INFO - } 19:00:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/EznbjHdzRYS4XhDIL72sqA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 19:00:25 INFO - Running post-action listener: _resource_record_post_action 19:00:25 INFO - [mozharness: 2016-10-11 02:00:25.849561Z] Finished read-buildbot-config step (success) 19:00:25 INFO - [mozharness: 2016-10-11 02:00:25.849695Z] Running download-and-extract step. 19:00:25 INFO - Running pre-action listener: _resource_record_pre_action 19:00:25 INFO - Running main action method: download_and_extract 19:00:25 INFO - mkdir: /builds/slave/test/build/tests 19:00:25 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')]} 19:00:25 INFO - trying https://queue.taskcluster.net/v1/task/EznbjHdzRYS4XhDIL72sqA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 19:00:25 INFO - Downloading https://queue.taskcluster.net/v1/task/EznbjHdzRYS4XhDIL72sqA/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 19:00:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EznbjHdzRYS4XhDIL72sqA/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 19:00:27 INFO - Downloaded 1199 bytes. 19:00:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 19:00:27 INFO - Using the following test package requirements: 19:00:27 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 19:00:27 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:00:27 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 19:00:27 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:00:27 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 19:00:27 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:00:27 INFO - u'jsshell-mac.zip'], 19:00:27 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:00:27 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 19:00:27 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 19:00:27 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:00:27 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 19:00:27 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:00:27 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 19:00:27 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:00:27 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 19:00:27 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:00:27 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 19:00:27 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 19:00:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EznbjHdzRYS4XhDIL72sqA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 19:00:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EznbjHdzRYS4XhDIL72sqA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:00:27 INFO - Fetch https://queue.taskcluster.net/v1/task/EznbjHdzRYS4XhDIL72sqA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 19:00:27 INFO - Expected file size: 16435039 19:00:34 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 19:00:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EznbjHdzRYS4XhDIL72sqA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 19:00:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EznbjHdzRYS4XhDIL72sqA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:00:34 INFO - Fetch https://queue.taskcluster.net/v1/task/EznbjHdzRYS4XhDIL72sqA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 19:00:35 INFO - Expected file size: 16435039 19:00:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EznbjHdzRYS4XhDIL72sqA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 19:00:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EznbjHdzRYS4XhDIL72sqA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 19:00:41 INFO - Fetch https://queue.taskcluster.net/v1/task/EznbjHdzRYS4XhDIL72sqA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 19:00:42 INFO - Expected file size: 14414059 19:00:44 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')]} 19:00:44 INFO - trying https://queue.taskcluster.net/v1/task/EznbjHdzRYS4XhDIL72sqA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 19:00:44 INFO - Downloading https://queue.taskcluster.net/v1/task/EznbjHdzRYS4XhDIL72sqA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 19:00:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EznbjHdzRYS4XhDIL72sqA/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 19:00:47 INFO - Downloaded 115370245 bytes. 19:00:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EznbjHdzRYS4XhDIL72sqA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 19:00:47 INFO - mkdir: /builds/slave/test/properties 19:00:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:00:47 INFO - Writing to file /builds/slave/test/properties/build_url 19:00:47 INFO - Contents: 19:00:47 INFO - build_url:https://queue.taskcluster.net/v1/task/EznbjHdzRYS4XhDIL72sqA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 19:00:47 INFO - Running post-action listener: _resource_record_post_action 19:00:47 INFO - Running post-action listener: set_extra_try_arguments 19:00:47 INFO - [mozharness: 2016-10-11 02:00:47.777718Z] Finished download-and-extract step (success) 19:00:47 INFO - [mozharness: 2016-10-11 02:00:47.777835Z] Running populate-webroot step. 19:00:47 INFO - Running pre-action listener: _resource_record_pre_action 19:00:47 INFO - Running main action method: populate_webroot 19:00:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:00:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:00:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:00:47 INFO - '--tppagecycles', 19:00:47 INFO - '7'], 19:00:47 INFO - 'tests': ['tsvgm']}}, 19:00:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:00:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:00:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:00:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:00:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:00:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:00:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:47 INFO - 'talos_options': ['--disable-e10s'], 19:00:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:47 INFO - 'talos_options': ['--disable-e10s'], 19:00:47 INFO - 'tests': ['damp', 'tps']}, 19:00:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:47 INFO - 'tests': ['damp', 'tps']}, 19:00:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:00:47 INFO - 'tests': ['dromaeo_dom']}, 19:00:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:00:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:00:47 INFO - 'tests': ['basic_compositor_video']}, 19:00:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:00:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:00:47 INFO - 'tests': ['a11yr', 19:00:47 INFO - 'ts_paint', 19:00:47 INFO - 'tpaint', 19:00:47 INFO - 'sessionrestore', 19:00:47 INFO - 'sessionrestore_no_auto_restore', 19:00:47 INFO - 'tabpaint']}, 19:00:47 INFO - 'other-e10s': {'tests': ['a11yr', 19:00:47 INFO - 'ts_paint', 19:00:47 INFO - 'tpaint', 19:00:47 INFO - 'sessionrestore', 19:00:47 INFO - 'sessionrestore_no_auto_restore', 19:00:47 INFO - 'tabpaint']}, 19:00:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:00:47 INFO - 'ts_paint', 19:00:47 INFO - 'tpaint', 19:00:47 INFO - 'sessionrestore', 19:00:47 INFO - 'sessionrestore_no_auto_restore', 19:00:47 INFO - 'tabpaint']}, 19:00:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:00:47 INFO - 'ts_paint', 19:00:47 INFO - 'tpaint', 19:00:47 INFO - 'sessionrestore', 19:00:47 INFO - 'sessionrestore_no_auto_restore', 19:00:47 INFO - 'tabpaint']}, 19:00:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:00:47 INFO - 'tests': ['a11yr', 19:00:47 INFO - 'ts_paint', 19:00:47 INFO - 'tpaint', 19:00:47 INFO - 'sessionrestore', 19:00:47 INFO - 'sessionrestore_no_auto_restore', 19:00:47 INFO - 'tabpaint']}, 19:00:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:00:47 INFO - 'tests': ['a11yr', 19:00:47 INFO - 'ts_paint', 19:00:47 INFO - 'tpaint', 19:00:47 INFO - 'sessionrestore', 19:00:47 INFO - 'sessionrestore_no_auto_restore', 19:00:47 INFO - 'tabpaint']}, 19:00:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:00:47 INFO - 'tests': ['tsvgx', 19:00:47 INFO - 'tsvgr_opacity', 19:00:47 INFO - 'tart', 19:00:47 INFO - 'tscrollx', 19:00:47 INFO - 'cart']}, 19:00:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:00:47 INFO - 'tsvgr_opacity', 19:00:47 INFO - 'tart', 19:00:47 INFO - 'tscrollx', 19:00:47 INFO - 'cart']}, 19:00:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:47 INFO - 'talos_options': ['--disable-e10s'], 19:00:47 INFO - 'tests': ['tp5o']}, 19:00:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:47 INFO - 'tests': ['tp5o']}, 19:00:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:47 INFO - 'talos_options': ['--disable-e10s', 19:00:47 INFO - '--xperf_path', 19:00:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:47 INFO - 'tests': ['tp5n']}, 19:00:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:47 INFO - 'talos_options': ['--xperf_path', 19:00:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:47 INFO - 'tests': ['tp5n']}}, 19:00:47 INFO - 'talos.zip': {'path': '', 19:00:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:00:47 INFO - Running post-action listener: _resource_record_post_action 19:00:47 INFO - [mozharness: 2016-10-11 02:00:47.796552Z] Finished populate-webroot step (success) 19:00:47 INFO - [mozharness: 2016-10-11 02:00:47.796669Z] Running create-virtualenv step. 19:00:47 INFO - Running pre-action listener: _resource_record_pre_action 19:00:47 INFO - Running main action method: create_virtualenv 19:00:47 INFO - Creating virtualenv /builds/slave/test/build/venv 19:00:47 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 19:00:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:00:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:00:47 INFO - Using real prefix '/tools/python27' 19:00:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:00:48 INFO - Installing distribute.............................................................................................................................................................................................done. 19:00:51 INFO - Installing pip.................done. 19:00:51 INFO - Return code: 0 19:00:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ff41490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feb7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c385a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd55d30>, '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 0x10fbbbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd4db20>, '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.in4b5OJtvF/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.YuADeX9xq2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 19:00:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:00:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:00:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.in4b5OJtvF/Render', 19:00:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:51 INFO - 'HOME': '/Users/cltbld', 19:00:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:51 INFO - 'LOGNAME': 'cltbld', 19:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:51 INFO - 'MOZ_NO_REMOTE': '1', 19:00:51 INFO - 'NO_EM_RESTART': '1', 19:00:51 INFO - 'PAGER': '/bin/cat', 19:00:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:51 INFO - 'PWD': '/builds/slave/test', 19:00:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:51 INFO - 'SHELL': '/bin/bash', 19:00:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YuADeX9xq2/Listeners', 19:00:51 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 19:00:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:51 INFO - 'USER': 'cltbld', 19:00:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:51 INFO - 'XPC_FLAGS': '0x0', 19:00:51 INFO - 'XPC_SERVICE_NAME': '0', 19:00:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:51 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 19:00:51 INFO - Cleaning up... 19:00:51 INFO - Return code: 0 19:00:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ff41490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feb7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c385a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd55d30>, '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 0x10fbbbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd4db20>, '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.in4b5OJtvF/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.YuADeX9xq2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 19:00:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:00:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:00:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.in4b5OJtvF/Render', 19:00:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:51 INFO - 'HOME': '/Users/cltbld', 19:00:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:51 INFO - 'LOGNAME': 'cltbld', 19:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:51 INFO - 'MOZ_NO_REMOTE': '1', 19:00:51 INFO - 'NO_EM_RESTART': '1', 19:00:51 INFO - 'PAGER': '/bin/cat', 19:00:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:51 INFO - 'PWD': '/builds/slave/test', 19:00:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:51 INFO - 'SHELL': '/bin/bash', 19:00:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YuADeX9xq2/Listeners', 19:00:51 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 19:00:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:51 INFO - 'USER': 'cltbld', 19:00:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:51 INFO - 'XPC_FLAGS': '0x0', 19:00:51 INFO - 'XPC_SERVICE_NAME': '0', 19:00:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:52 INFO - Downloading/unpacking psutil>=3.1.1 19:00:52 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 19:00:52 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 19:00:52 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 19:00:52 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 19:00:52 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 19:00:52 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 19:00:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:00:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:55 INFO - Installing collected packages: psutil 19:00:55 INFO - Running setup.py install for psutil 19:00:55 INFO - building 'psutil._psutil_osx' extension 19:00:55 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 19:00:56 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 19:00:56 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 19:00:56 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 19:00:56 INFO - building 'psutil._psutil_posix' extension 19:00:56 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 19:00:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:00:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:00:56 INFO - ^ 19:00:56 INFO - 1 warning generated. 19:00:56 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 19:00:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:56 INFO - Successfully installed psutil 19:00:56 INFO - Cleaning up... 19:00:56 INFO - Return code: 0 19:00:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:56 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 0x10ff41490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feb7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c385a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd55d30>, '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 0x10fbbbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd4db20>, '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.in4b5OJtvF/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.YuADeX9xq2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 19:00:56 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 19:00:56 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 19:00:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.in4b5OJtvF/Render', 19:00:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:56 INFO - 'HOME': '/Users/cltbld', 19:00:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:56 INFO - 'LOGNAME': 'cltbld', 19:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:56 INFO - 'MOZ_NO_REMOTE': '1', 19:00:56 INFO - 'NO_EM_RESTART': '1', 19:00:56 INFO - 'PAGER': '/bin/cat', 19:00:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:56 INFO - 'PWD': '/builds/slave/test', 19:00:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:56 INFO - 'SHELL': '/bin/bash', 19:00:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YuADeX9xq2/Listeners', 19:00:56 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 19:00:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:56 INFO - 'USER': 'cltbld', 19:00:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:56 INFO - 'XPC_FLAGS': '0x0', 19:00:56 INFO - 'XPC_SERVICE_NAME': '0', 19:00:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:00:56 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 19:00:56 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 19:00:56 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 19:00:56 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 19:00:56 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 19:00:56 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 19:00:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:00:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:00:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:00:59 INFO - Installing collected packages: mozsystemmonitor 19:00:59 INFO - Running setup.py install for mozsystemmonitor 19:00:59 INFO - Successfully installed mozsystemmonitor 19:00:59 INFO - Cleaning up... 19:00:59 INFO - Return code: 0 19:00:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:00: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')]} 19:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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')]} 19:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ff41490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feb7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c385a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd55d30>, '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 0x10fbbbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd4db20>, '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.in4b5OJtvF/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.YuADeX9xq2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 19:00:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:00:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.in4b5OJtvF/Render', 19:00:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:59 INFO - 'HOME': '/Users/cltbld', 19:00:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:59 INFO - 'LOGNAME': 'cltbld', 19:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:59 INFO - 'MOZ_NO_REMOTE': '1', 19:00:59 INFO - 'NO_EM_RESTART': '1', 19:00:59 INFO - 'PAGER': '/bin/cat', 19:00:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:59 INFO - 'PWD': '/builds/slave/test', 19:00:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:59 INFO - 'SHELL': '/bin/bash', 19:00:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YuADeX9xq2/Listeners', 19:00:59 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 19:00:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:59 INFO - 'USER': 'cltbld', 19:00:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:59 INFO - 'XPC_FLAGS': '0x0', 19:00:59 INFO - 'XPC_SERVICE_NAME': '0', 19:00:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:59 INFO - Downloading/unpacking jsonschema==2.5.1 19:00:59 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 19:00:59 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 19:00:59 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 19:00:59 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 19:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:01:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:01:02 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 19:01:02 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 19:01:02 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 19:01:02 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 19:01:02 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 19:01:02 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 19:01:02 INFO - Downloading functools32-3.2.3-2.tar.gz 19:01:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:01:02 INFO - warning: no files found matching '*.txt' 19:01:02 INFO - no previously-included directories found matching 'build' 19:01:02 INFO - no previously-included directories found matching 'dist' 19:01:02 INFO - no previously-included directories found matching '.git*' 19:01:02 INFO - Installing collected packages: jsonschema, functools32 19:01:03 INFO - Running setup.py install for functools32 19:01:03 INFO - warning: no files found matching '*.txt' 19:01:03 INFO - no previously-included directories found matching 'build' 19:01:03 INFO - no previously-included directories found matching 'dist' 19:01:03 INFO - no previously-included directories found matching '.git*' 19:01:03 INFO - Successfully installed jsonschema functools32 19:01:03 INFO - Cleaning up... 19:01:03 INFO - Return code: 0 19:01:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:01:03 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')]} 19:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:03 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')]} 19:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:03 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 0x10ff41490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feb7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c385a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd55d30>, '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 0x10fbbbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd4db20>, '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.in4b5OJtvF/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.YuADeX9xq2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 19:01:03 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 19:01:03 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 19:01:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.in4b5OJtvF/Render', 19:01:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:01:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:01:03 INFO - 'HOME': '/Users/cltbld', 19:01:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:01:03 INFO - 'LOGNAME': 'cltbld', 19:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:03 INFO - 'MOZ_NO_REMOTE': '1', 19:01:03 INFO - 'NO_EM_RESTART': '1', 19:01:03 INFO - 'PAGER': '/bin/cat', 19:01:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:03 INFO - 'PWD': '/builds/slave/test', 19:01:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:01:03 INFO - 'SHELL': '/bin/bash', 19:01:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YuADeX9xq2/Listeners', 19:01:03 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 19:01:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:01:03 INFO - 'USER': 'cltbld', 19:01:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:01:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:03 INFO - 'XPC_FLAGS': '0x0', 19:01:03 INFO - 'XPC_SERVICE_NAME': '0', 19:01:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:01:03 INFO - Cleaning up... 19:01:03 INFO - Return code: 0 19:01:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:01:03 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')]} 19:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:03 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')]} 19:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:03 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 0x10ff41490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feb7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c385a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd55d30>, '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 0x10fbbbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd4db20>, '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.in4b5OJtvF/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.YuADeX9xq2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 19:01:03 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 19:01:03 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 19:01:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.in4b5OJtvF/Render', 19:01:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:01:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:01:03 INFO - 'HOME': '/Users/cltbld', 19:01:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:01:03 INFO - 'LOGNAME': 'cltbld', 19:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:03 INFO - 'MOZ_NO_REMOTE': '1', 19:01:03 INFO - 'NO_EM_RESTART': '1', 19:01:03 INFO - 'PAGER': '/bin/cat', 19:01:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:03 INFO - 'PWD': '/builds/slave/test', 19:01:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:01:03 INFO - 'SHELL': '/bin/bash', 19:01:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YuADeX9xq2/Listeners', 19:01:03 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 19:01:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:01:03 INFO - 'USER': 'cltbld', 19:01:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:01:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:03 INFO - 'XPC_FLAGS': '0x0', 19:01:03 INFO - 'XPC_SERVICE_NAME': '0', 19:01:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:03 INFO - Downloading/unpacking blobuploader==1.2.4 19:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:06 INFO - Downloading blobuploader-1.2.4.tar.gz 19:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:01:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:01:06 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 19:01:06 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 19:01:06 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 19:01:06 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 19:01:06 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 19:01:06 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 19:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:01:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:01: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 19:01: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 19:01: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 19:01: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 19:01: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 19:01: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 19:01:07 INFO - Downloading docopt-0.6.1.tar.gz 19:01:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:01:07 INFO - Installing collected packages: blobuploader, requests, docopt 19:01:07 INFO - Running setup.py install for blobuploader 19:01:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:01:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:01:07 INFO - Running setup.py install for requests 19:01:08 INFO - Running setup.py install for docopt 19:01:08 INFO - Successfully installed blobuploader requests docopt 19:01:08 INFO - Cleaning up... 19:01:08 INFO - Return code: 0 19:01:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:01:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:08 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 0x10ff41490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feb7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c385a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd55d30>, '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 0x10fbbbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd4db20>, '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.in4b5OJtvF/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.YuADeX9xq2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 19:01:08 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 19:01:08 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 19:01:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.in4b5OJtvF/Render', 19:01:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:01:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:01:08 INFO - 'HOME': '/Users/cltbld', 19:01:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:01:08 INFO - 'LOGNAME': 'cltbld', 19:01:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:08 INFO - 'MOZ_NO_REMOTE': '1', 19:01:08 INFO - 'NO_EM_RESTART': '1', 19:01:08 INFO - 'PAGER': '/bin/cat', 19:01:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:01:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:08 INFO - 'PWD': '/builds/slave/test', 19:01:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:01:08 INFO - 'SHELL': '/bin/bash', 19:01:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YuADeX9xq2/Listeners', 19:01:08 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 19:01:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:01:08 INFO - 'USER': 'cltbld', 19:01:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:01:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:01:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:08 INFO - 'XPC_FLAGS': '0x0', 19:01:08 INFO - 'XPC_SERVICE_NAME': '0', 19:01:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:01:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:01:08 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-kWmKo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:01:08 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-gqwiS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:01:09 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Tl7Cc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:01:09 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-KEW5AB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:01:09 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-k1kEl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:01:09 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-H850Xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:01:09 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-rJDBPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:01:09 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-7We7rx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:01:09 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-f6YYfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:01:09 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-0qK9NW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:01:09 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Su3Nz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:01:09 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-eKV6DS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:01:10 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-yYJPkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:01:10 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-unkzRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:01:10 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Mj5tkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:01:10 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-HlHa9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:01:10 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-lZ5jqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:01:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:01:10 INFO - Running setup.py install for manifestparser 19:01:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:01:10 INFO - Running setup.py install for mozcrash 19:01:10 INFO - Running setup.py install for mozdebug 19:01:10 INFO - Running setup.py install for mozdevice 19:01:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:01:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:01:11 INFO - Running setup.py install for mozfile 19:01:11 INFO - Running setup.py install for mozhttpd 19:01:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:01:11 INFO - Running setup.py install for mozinfo 19:01:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:01:11 INFO - Running setup.py install for mozInstall 19:01:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:01:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:01:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:01:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:01:11 INFO - Running setup.py install for mozleak 19:01:11 INFO - Running setup.py install for mozlog 19:01:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:01:12 INFO - Running setup.py install for moznetwork 19:01:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:01:12 INFO - Running setup.py install for mozprocess 19:01:12 INFO - Running setup.py install for mozprofile 19:01:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:01:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:01:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:01:12 INFO - Running setup.py install for mozrunner 19:01:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:01:12 INFO - Running setup.py install for mozscreenshot 19:01:12 INFO - Running setup.py install for moztest 19:01:12 INFO - Running setup.py install for mozversion 19:01:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:01:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:01:13 INFO - Cleaning up... 19:01:13 INFO - Return code: 0 19:01:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:13 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 0x10ff41490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feb7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c385a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd55d30>, '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 0x10fbbbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd4db20>, '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.in4b5OJtvF/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.YuADeX9xq2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 19:01:13 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 19:01:13 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 19:01:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.in4b5OJtvF/Render', 19:01:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:01:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:01:13 INFO - 'HOME': '/Users/cltbld', 19:01:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:01:13 INFO - 'LOGNAME': 'cltbld', 19:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:13 INFO - 'MOZ_NO_REMOTE': '1', 19:01:13 INFO - 'NO_EM_RESTART': '1', 19:01:13 INFO - 'PAGER': '/bin/cat', 19:01:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:13 INFO - 'PWD': '/builds/slave/test', 19:01:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:01:13 INFO - 'SHELL': '/bin/bash', 19:01:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YuADeX9xq2/Listeners', 19:01:13 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 19:01:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:01:13 INFO - 'USER': 'cltbld', 19:01:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:01:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:13 INFO - 'XPC_FLAGS': '0x0', 19:01:13 INFO - 'XPC_SERVICE_NAME': '0', 19:01:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:01:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:01:13 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-je0RcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:01:13 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)) 19:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:01:13 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-1sRMKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:01:13 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)) 19:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:01:13 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-ik6x_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:01:13 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)) 19:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:01:13 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-JDdRta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:01:13 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)) 19:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:01:13 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-1gfcQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:01:13 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)) 19:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:01:13 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-CUFwOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:01:14 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)) 19:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:01:14 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-hjmrTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:01:14 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)) 19:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:01:14 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Snx14G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:01:14 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)) 19:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:01:14 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-6vl7tL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:01:14 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)) 19:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:01:14 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-VBuvYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:01:14 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)) 19:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:01:14 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-5zVfD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:01:14 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)) 19:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:01:14 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-eHd1Lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:01:14 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)) 19:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:01:14 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-oM4SIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:01:14 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)) 19:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:01:14 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-fGdTWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:01:14 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)) 19:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:01:14 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-X112Ai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:01:15 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)) 19:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:01:15 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-6FBvR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:01:15 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)) 19:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:01:15 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-pbSYW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:01:15 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)) 19:01:15 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)) 19:01:15 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)) 19:01:15 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)) 19:01:15 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)) 19:01:15 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)) 19:01:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:01: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 19:01: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 19:01: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 19:01: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 19:01: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 19:01: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 19:01:17 INFO - Downloading blessings-1.6.tar.gz 19:01:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:01:17 INFO - Installing collected packages: blessings 19:01:17 INFO - Running setup.py install for blessings 19:01:18 INFO - Successfully installed blessings 19:01:18 INFO - Cleaning up... 19:01:18 INFO - Return code: 0 19:01:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:01:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:01:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:01:18 INFO - Reading from file tmpfile_stdout 19:01:18 INFO - Current package versions: 19:01:18 INFO - blessings == 1.6 19:01:18 INFO - blobuploader == 1.2.4 19:01:18 INFO - docopt == 0.6.1 19:01:18 INFO - functools32 == 3.2.3-2 19:01:18 INFO - jsonschema == 2.5.1 19:01:18 INFO - manifestparser == 1.1 19:01:18 INFO - mozInstall == 1.12 19:01:18 INFO - mozcrash == 0.17 19:01:18 INFO - mozdebug == 0.1 19:01:18 INFO - mozdevice == 0.48 19:01:18 INFO - mozfile == 1.2 19:01:18 INFO - mozhttpd == 0.7 19:01:18 INFO - mozinfo == 0.9 19:01:18 INFO - mozleak == 0.1 19:01:18 INFO - mozlog == 3.4 19:01:18 INFO - moznetwork == 0.27 19:01:18 INFO - mozprocess == 0.23 19:01:18 INFO - mozprofile == 0.28 19:01:18 INFO - mozrunner == 6.12 19:01:18 INFO - mozscreenshot == 0.1 19:01:18 INFO - mozsystemmonitor == 0.3 19:01:18 INFO - moztest == 0.7 19:01:18 INFO - mozversion == 1.4 19:01:18 INFO - psutil == 3.1.1 19:01:18 INFO - requests == 1.2.3 19:01:18 INFO - wsgiref == 0.1.2 19:01:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:01: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')]} 19:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01: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')]} 19:01:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:18 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 0x10ff41490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feb7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c385a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd55d30>, '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 0x10fbbbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd4db20>, '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.in4b5OJtvF/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.YuADeX9xq2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 19:01:18 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 19:01:18 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 19:01:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.in4b5OJtvF/Render', 19:01:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:01:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:01:18 INFO - 'HOME': '/Users/cltbld', 19:01:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:01:18 INFO - 'LOGNAME': 'cltbld', 19:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:18 INFO - 'MOZ_NO_REMOTE': '1', 19:01:18 INFO - 'NO_EM_RESTART': '1', 19:01:18 INFO - 'PAGER': '/bin/cat', 19:01:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:18 INFO - 'PWD': '/builds/slave/test', 19:01:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:01:18 INFO - 'SHELL': '/bin/bash', 19:01:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YuADeX9xq2/Listeners', 19:01:18 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 19:01:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:01:18 INFO - 'USER': 'cltbld', 19:01:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:01:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:18 INFO - 'XPC_FLAGS': '0x0', 19:01:18 INFO - 'XPC_SERVICE_NAME': '0', 19:01:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:01:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:19 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)) 19:01:19 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)) 19:01:19 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)) 19:01:19 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)) 19:01:19 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)) 19:01:19 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)) 19:01:19 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)) 19:01:19 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)) 19:01:19 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)) 19:01:19 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)) 19:01:19 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)) 19:01:19 INFO - Cleaning up... 19:01:19 INFO - Return code: 0 19:01:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:01:19 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')]} 19:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:19 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')]} 19:01:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:19 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 0x10ff41490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feb7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c385a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd55d30>, '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 0x10fbbbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd4db20>, '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.in4b5OJtvF/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.YuADeX9xq2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 19:01:19 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 19:01:19 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 19:01:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.in4b5OJtvF/Render', 19:01:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:01:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:01:19 INFO - 'HOME': '/Users/cltbld', 19:01:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:01:19 INFO - 'LOGNAME': 'cltbld', 19:01:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:19 INFO - 'MOZ_NO_REMOTE': '1', 19:01:19 INFO - 'NO_EM_RESTART': '1', 19:01:19 INFO - 'PAGER': '/bin/cat', 19:01:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:01:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:19 INFO - 'PWD': '/builds/slave/test', 19:01:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:01:19 INFO - 'SHELL': '/bin/bash', 19:01:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YuADeX9xq2/Listeners', 19:01:19 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 19:01:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:01:19 INFO - 'USER': 'cltbld', 19:01:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:01:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:01:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:19 INFO - 'XPC_FLAGS': '0x0', 19:01:19 INFO - 'XPC_SERVICE_NAME': '0', 19:01:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:01:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:01:19 INFO - Cleaning up... 19:01:19 INFO - Return code: 0 19:01:19 INFO - Running post-action listener: _resource_record_post_action 19:01:19 INFO - Running post-action listener: _start_resource_monitoring 19:01:19 INFO - Starting resource monitoring. 19:01:19 INFO - [mozharness: 2016-10-11 02:01:19.403044Z] Finished create-virtualenv step (success) 19:01:19 INFO - [mozharness: 2016-10-11 02:01:19.404038Z] Running install step. 19:01:19 INFO - Running pre-action listener: _resource_record_pre_action 19:01:19 INFO - Running main action method: install 19:01:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:01:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:01:19 INFO - Reading from file tmpfile_stdout 19:01:19 INFO - Detecting whether we're running mozinstall >=1.0... 19:01:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:01:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:01:19 INFO - Reading from file tmpfile_stdout 19:01:19 INFO - Output received: 19:01:19 INFO - Usage: mozinstall [options] installer 19:01:19 INFO - Options: 19:01:19 INFO - -h, --help show this help message and exit 19:01:19 INFO - -d DEST, --destination=DEST 19:01:19 INFO - Directory to install application into. [default: 19:01:19 INFO - "/builds/slave/test"] 19:01:19 INFO - --app=APP Application being installed. [default: firefox] 19:01:19 INFO - mkdir: /builds/slave/test/build/application 19:01:19 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'] 19:01:19 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 19:01:52 INFO - Reading from file tmpfile_stdout 19:01:52 INFO - Output received: 19:01:52 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 19:01:52 INFO - Running post-action listener: _resource_record_post_action 19:01:52 INFO - [mozharness: 2016-10-11 02:01:52.136831Z] Finished install step (success) 19:01:52 INFO - [mozharness: 2016-10-11 02:01:52.136974Z] Running run-tests step. 19:01:52 INFO - Running pre-action listener: _resource_record_pre_action 19:01:52 INFO - Running main action method: run_tests 19:01:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:01:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:01:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:01:52 INFO - 2016-10-10 19:01:52.151 screenresolution[1639:7683] starting screenresolution argv=screenresolution get 19:01:52 INFO - 2016-10-10 19:01:52.153 screenresolution[1639:7683] Display 0: 1600x1200x32@60 19:01:52 INFO - 2016-10-10 19:01:52.159 screenresolution[1640:7685] starting screenresolution argv=screenresolution list 19:01:52 INFO - Available Modes on Display 0 19:01:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:01:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:01:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:01:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:01:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:01:52 INFO - Intel Iris: 19:01:52 INFO - Chipset Model: Intel Iris 19:01:52 INFO - Type: GPU 19:01:52 INFO - Bus: Built-In 19:01:52 INFO - VRAM (Dynamic, Max): 1536 MB 19:01:52 INFO - Vendor: Intel (0x8086) 19:01:52 INFO - Device ID: 0x0a2e 19:01:52 INFO - Revision ID: 0x0009 19:01:52 INFO - Displays: 19:01:52 INFO - Display: 19:01:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:01:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:01:52 INFO - Display Serial Number: 1600x1200 60 19:01:52 INFO - Main Display: Yes 19:01:52 INFO - Mirror: Off 19:01:52 INFO - Online: Yes 19:01:52 INFO - Rotation: Supported 19:01:52 INFO - Return code: 0 19:01:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:01:52 INFO - Python 2.7.3 19:01:52 INFO - Return code: 0 19:01:52 INFO - grabbing minidump binary from tooltool 19:01:52 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')]} 19:01:52 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 0x10fd55d30>, '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 0x10fbbbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd4db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:01:52 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 19:01:52 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 19:01:52 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 19:01:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:01:52 INFO - Return code: 0 19:01:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:01:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:01:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:01:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:01:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:01:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EznbjHdzRYS4XhDIL72sqA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0101', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EznbjHdzRYS4XhDIL72sqA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0101 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:01:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.in4b5OJtvF/Render', 19:01:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:01:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:01:52 INFO - 'HOME': '/Users/cltbld', 19:01:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:01:52 INFO - 'LOGNAME': 'cltbld', 19:01:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:01:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:52 INFO - 'MOZ_NO_REMOTE': '1', 19:01:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:01:52 INFO - 'NO_EM_RESTART': '1', 19:01:52 INFO - 'PAGER': '/bin/cat', 19:01:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:52 INFO - 'PWD': '/builds/slave/test', 19:01:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:01:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:01:52 INFO - 'SHELL': '/bin/bash', 19:01:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YuADeX9xq2/Listeners', 19:01:52 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 19:01:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:01:52 INFO - 'USER': 'cltbld', 19:01:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:01:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:52 INFO - 'XPC_FLAGS': '0x0', 19:01:52 INFO - 'XPC_SERVICE_NAME': '0', 19:01:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:01:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EznbjHdzRYS4XhDIL72sqA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0101', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:01:52 INFO - mozversion application_buildid: 20161010164823 19:01:52 INFO - mozversion application_changeset: 9a452e8fde0ffd76d25179f5d6165265444a2247 19:01:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:01:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:01:52 INFO - mozversion application_name: Firefox 19:01:52 INFO - mozversion application_remotingname: firefox-dev 19:01:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:01:52 INFO - mozversion application_vendor: Mozilla 19:01:52 INFO - mozversion application_version: 51.0a2 19:01:52 INFO - mozversion platform_buildid: 20161010164823 19:01:52 INFO - mozversion platform_changeset: 9a452e8fde0ffd76d25179f5d6165265444a2247 19:01:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:01:52 INFO - mozversion platform_version: 51.0a2 19:01:52 INFO - using testdate: 1476151312 19:01:52 INFO - actual date: 1476151312 19:01:52 INFO - starting webserver on 'localhost:49275' 19:01:52 INFO - SUITE-START | Running 2 tests 19:01:52 INFO - TEST-START | dromaeo_css 19:01:52 INFO - operating with platform_type : mac_ 19:01:52 INFO - Initialising browser for dromaeo_css test... 19:01:52 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpRmjJt2/profile http://localhost:49275/getInfo.html) 19:01:55 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 19:01:55 INFO - PROCESS | 1650 | colorDepth:24 19:01:55 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 19:01:55 INFO - PROCESS | 1650 | __metrics 19:01:55 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 19:01:56 INFO - TEST-INFO | 1650: exit 0 19:01:56 INFO - Browser initialized. 19:01:56 INFO - Running cycle 1/1 for dromaeo_css test... 19:01:56 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpRmjJt2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:02:08 INFO - PROCESS | 1653 | RSS: Main: 225071104 19:02:08 INFO - PROCESS | 1653 | 19:02:57 INFO - PROCESS | 1653 | 1476151377985 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] 19:05:09 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 19:05:11 INFO - PROCESS | 1653 | RSS: Main: 238866432 19:05:11 INFO - PROCESS | 1653 | 19:08:13 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 19:08:14 INFO - PROCESS | 1653 | RSS: Main: 248651776 19:08:14 INFO - PROCESS | 1653 | 19:11:16 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 19:11:16 INFO - PROCESS | 1653 | RSS: Main: 250851328 19:11:16 INFO - PROCESS | 1653 | 19:14:18 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 19:14:19 INFO - PROCESS | 1653 | RSS: Main: 251109376 19:14:19 INFO - PROCESS | 1653 | 19:17:22 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 19:17:22 INFO - PROCESS | 1653 | RSS: Main: 255602688 19:17:22 INFO - PROCESS | 1653 | 19:20:25 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 19:20:25 INFO - PROCESS | 1653 | RSS: Main: 257126400 19:20:25 INFO - PROCESS | 1653 | 19:20:25 INFO - PROCESS | 1653 | __start_tp_report 19:20:25 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 19:20:25 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 19:20:25 INFO - PROCESS | 1653 | |i|pagename|runs| 19:20:25 INFO - PROCESS | 1653 | |0;dojo.html;3001.7748668849836;3419.9911026247237;3455.222574920642;3455.568053993251;3475.322312149131;4861.829835955742;5847.502962248209;5975.790847320344;5984.730687119079;6026.156338112668;5951.839391318695;5954.345022047572;5973.761049558023;6005.87988240235;6058.303295121063;5353.277307563468;5394.8921021579545;5445.700486473243;5458.890822183554;5462.0987537056335;5431.674099554019;5471.23402723619;5478.068728316176;5479.808206712766;5484.177373393983;5321.068812957737;5374.946250537503;5460.945390546083;5476.26070480486;5517.337919449672;5383.730813459331;5386.461353864622;5403.378611459693;5441.863953401196;5488.4785945335125;5276.815311464119;5385.2999110115825;5391;5397.7031263280505;5442.809501667422;5757.712114394263;5943.31651860033;5967;6017.669028203447;6074.179985701962;6123.862238009563;6168.414000669929;6198.349173336825;6216.191895053614;6284.685765711742;6326.873462530723;6333.46165575922;6345.777897773556;6349.492040636738;6363.5863668861375;6036.0945858121195;6062.090686396988;6071.392860713938;6078.088286757022;6085.42188492097;6243.906341404882;6243.937560624427;6301.086342480315;6321.841953951188;6366.427021568081;5099.69401835891;6266.686665666698;6267.341929097471;6287.528435367366;6294.748210071546;6255.812325630239;6297.1813664223355;6309.905351419732;6312.52656050798;6328.019157030668;6176.382361763787;6194.721237544321;6204.255489341218;6249.406306400884;6253.843653908689;5339.599530035263;6251.624902505864;6291.96854015727;6293.685315734195;6297.905531417033;5043.773030213649;5044.344235249468;5044.54599086084;5054.7978080876355;5072.771725272371;4395.758233297135;4439.467263928284;4483.910321793546;4521.502634710179;4535.614472769786;6008.369121242294;6050.334463209131;6087.57386982907;6132.20254427538;6141.455323060992;6327.810165695037;6342.460890824239;6357.205349331333;6369.331220221903;6410.358964103552;5912.438318359749;5999.850003749942;6004.42957918997;6031.487323577458;6078.452939235402;5530.806421775219;5541.33503979525;5548;5566.526845218121;5577.27495425592;6502.349765023459;6506.121673574007;6512.739490420425;6520.902186467112;6537.444317232993;5093.617978651542;5714.857028594215;5741.655500669973;6241.032639940817;6311.589746666452;6390.680465976776;6397.936020639921;6413.326600707045;6423.293437721753;6430.903536447051;6260.843478913063;6275.623462592259;6280.214973128359;6294.307626161027;6300.621962682254;5850.385709500441;6136.059583474799;6206.627602343874;6217.160683307696;6302.905456418249;6201.0388389799655;6289.874202516015;6296.937030629635;6302.527310451826;6324.272708638566;6101.176341194059;6229.844253893689;6262.843428914313;6294.15028971083;6306.337834527309;5687.800926967537;5892.351841297368;6100.786472473442;6190.133381326708;6257.43683068526;6140.657627863787;6201.286852012076;6215.689215539114;6228.065790131516;6242.719077641426;6131.877362452815;6134.38656134383;6148.077788331786;6159.753609855556;6159.784407545714 19:20:25 INFO - PROCESS | 1653 | |1;ext.html;443.430192203019;467.637580874822;482.64766720294165;511.69554115301395;513.7328589133649;37783.62216377835;39854.80072599636;39880.20239595207;39929.201415971664;40054.998625034386;41981.16037679252;42452.57547424525;42467.78766106173;42513;42751.57248427515;9707.417554946707;9871.358361706501;9874.802503949917;9895;9901.405915645084;9704.272179586524;9746.46394448305;9768.365056271356;9813.950930245339;9831.557579908886;9798.804023919518;9801.656942007032;9831.164351030135;9855.310128291023;9869.309148359618;9777.364471309342;9795.853062204073;9818.558164882597;9818.607255709763;9840.557174927146;9693.22454203662;9694.466804325759;9761.267904907088;9768.462734549597;9777.560009799576;38947;39107.80446097751;39358.0160495987;39419.81740547788;39581.40627890584;3311.3708395404797;3382.4418970870024;3475.42655461851;3535.3636345457808;3560.8041557714314;29320.639984050198;29733.851330743208;30000.69999300001;30113.397732045454;30504.54243186332;3114.7508199343997;3225.2904361040532;3234.692704193098;3248.8700451982127;3267.346530693847;540439;541303.293483534;545125;545652;545759;62224.68887655533;62711.68644156841;62771.686141569;62810.685946569974;62866.37133628697;26978.190654280403;34190.31619367649;34658;35975.28049439049;36263;16961.91519042397;17005.91497042507;17143.142842857807;17170.22733976974;17222.741658874875;12990.805137922938;13134.474621015244;13143.671408214872;13190.472381104648;13199.868001320056;19081.713774293396;19114;19131.90434047821;19156.04219789005;19175;7969.242921922408;8119.3910456715985;8124.471909325875;8136.430449868452;8246.628901699438;839.7606682095574;954.4178051388648;969.4280374578891;1006.6929586476049;1032.4528000159928;25769.48461030769;27429.86285068602;29290.26774330616;30284;30701.846490767402;862.66787286895;1001.8998100189923;1046.027194708928;1055.8965880654735;1087.2878264736453;14113.647158821112;15665.216739162996;15838.970466919613;15913.602159945862;15933.601659958362;707111;717031;725479;725561;728831;55821.72089139609;56298.43701563014;56953.71523142441;57084.42915570874;57122.714386427804;1347.2859384526216;1353.5736243083397;1366.9179849209079;1370.3559327116238;1380.7790753479394;29205.561916570845;29705.405891882474;29881;29955;30469.64833868317;47832;48004;48090.519094810006;48138;48212.517874820805;600796;601573.9921300366;603028;603491;603644;26039.739602604488;26089;26413.60379594346;26490.735092648825;26511.867440663445;45910.31134532918;47001.52998470108;47030.82422939454;47441.76279118582;47466;38838.80580597079;39127;39127.2174556513;39971;40328.79835600803;38558.42162367511;39181.41227881527;39678;40433.39349909813;41641.79179104085;37262.44106338353;37967.43048854324;38063;38275.23449530938;39621.00947476336;32212.516812247366;34577.48133778045;34999.4750078744;35087.29825403529;35276.82361588176;25839.612405814303;25976.480470390863;25978.35054123662;26282;26436.339091522867 19:20:25 INFO - PROCESS | 1653 | |2;jquery.html;312.261501548837;325.8696521391443;373.24418053441775;377.83186482015515;388.9226841648633;17580.824191758096;19420;20469.897650511746;20860.165593376245;21621.567568648617;16798.83201167988;17443.389481368155;20212.494687632818;20610.48473788156;20730.170793168254;5816.796412125576;5888.499477544403;6141.385861413867;6184.96907515464;6197.380261973789;5924;6002.789902353418;6068.57519973602;6081.027035674293;6085.087236914454;5705.4579814917515;5909.349971503131;5947.553933454987;6021.668808215546;6029.336772954972;5052.343195384595;5126.256692779545;6022.247219097613;6038.305594856603;6059.606125601822;5077.543021128116;5234.842954711365;5241.895162096736;5365.624406291561;5432.674039557639;12482.188657737219;12645.304508252042;12851.742965140646;12882.67793305175;12944.093913426064;2091.602595506849;2311.1217737259904;2325.5116425550655;2378.0012394794053;2715.633389492413;9718.61125554977;9807.656732014417;9823.115919567203;10136.391816490961;10171.79656406875;1748.8076311605714;1809.84616307614;1845.2157832920955;1861.7858946221222;1899.1453845769458;113648.86351136466;114595.85404146019;115662.42168789187;125455;129926;9317.72046838596;9517.904820951702;11598.826017609743;11634.36011019402;11850.940745296219;14436.9172312077;14587.124772513684;14591.41634334636;14605.488807891672;14631;7163.928360716431;8612.526311052952;8687.695930642398;8712.69505567302;8759.2992560595;8695.782605434915;8728.519931403835;8749.868751968726;8833.160849719266;8874.334424918157;4543.636509079266;4555.749433781174;4558;4597.839075632403;4608.953910460919;1643.9917800410922;1925.1914196037699;1932.7584051993501;1965.0764140853776;1965.6953172258322;819.4182130687279;836.6778790165708;910.1614738228873;980.7940332530106;1010.1666125446536;20551.177952882015;21238.25666101679;21335.893320533298;21422.250221242182;21454.78545214528;902.4179404284331;907.9636814527345;927.2998885841147;930.4459259333174;1009.6213919780082;10759.462026898624;11083.889161108447;11159.665210043711;11167.83248251277;11253.831192532118;641640;668750;673974;679992;680619;146234;149134.25432872766;154454;155566;156685;784.6547519091581;979.3976704326788;998.6554638649654;1000.8548760429843;1007.1388962437157;15143.924280378527;19180.904095479993;19602.411927642195;19686.310979115664;19704.91622960751;47631.76184119057;54547.45452545424;58849;60463.09305360511;60480;78000;82752;84179.15820841714;86289.21422169056;87338;7671.3862890967475;8082.070561885458;8164.265216130577;8239.505629662239;8246.628901699318;10693.465326733787;12680.23918564889;12737;12788.168769029984;13137.474501019853;9657.806843863224;10917.181211409335;11048.613298534512;11059.170562207706;11551.537938482703;8816.074312197126;11078.390688512209;11284;11306.378149201873;11402.258853174517;11300.208985370946;11344.546218151181;11536.769264614828;11655.41722913834;11696.70758231051;7849.568273744999;7977.880331794911;7987.600619969095;8095.2714255717265;8384.161583841811;8275.337972962268;9954.55204515813;10249.436281004319;11136.944315278372;11140.33158010522 19:20:25 INFO - PROCESS | 1653 | |3;mootools.html;1514.666773309872;1538.653802894349;1756.8506676932461;1806.4309742431142;1855.4711907106469;8000.239977202171;8250;8518.190771876669;9094.54527273636;9123.361364704473;6816.693248803804;8793.252573531241;8813.86779198311;8917.73246802597;8929.151730585583;2377.9881100594516;2390.4262976885598;2423.1761201191593;2423.9757602423924;2427.0898413095088;2165.372042107787;2268.650153158876;2435.926922192328;2437.0373702387546;2440.4752978109705;2396.95206095878;2405.1101092595763;2419.9395015124587;2430.3924018995253;2431.9756802432016;2391.390195500154;2394.281715485356;2403.9182367934413;2405.879706014692;2410.602250628644;2242.4505996031075;2378.4410663494064;2400.2559206645997;2406.554787364343;2409.3856066703056;7931.920680793176;8208.58957052151;9004.594793234255;9019.549022548912;9038.322125840523;5320.707361095138;5493.505584497414;5497.8075767347955;5516.365617953947;5527.309086364205;3627.5828279747902;3633.1098880774116;3660.670539651444;3695.4826324314618;3701.9634502339118;1088.6516314779274;1090.2041509697885;1096.3641088168843;1097.7859317433104;1121.7027487715761;9891.653792117313;10011.59953601855;11638.359890206035;11781.646550603497;11814.527418903319;4119.7940102994735;4751.572358487683;4798.7840547175465;4856.73287969158;4957.785342591016;10050.246231532665;10147.49262536885;10150.847737283946;10155.238357123246;10190.643327483502;5421.105517589633;5444.128939369682;5446.21029950655;5449.373322068013;5470.234167216593;4420.027593929331;4544.295634176708;4805.663603547788;4932.630052746058;4970.627202959792;4039.8586049488126;4055.8986025349013;4133.400656904732;4159.771212583277;4172.374143878443;1295.7149427126017;1302.7524770293614;1315.329182117108;1317.7957416600443;1322.6296636941672;923.4690053219291;929.2380248196414;930.9022552631876;934.5420743835472;953.427943234054;5810.651360918274;5926.644401335933;6108.969455152695;6137.815865523952;6142.078688196806;438.903441242926;444.97775111244954;952.4523399045577;997.8104160209537;1063.441693111123;3946.506686664167;3972.880813575597;4049.838006479708;4084.7957602119777;4234.703570750018;10597.523111460003;10978.670639880816;11057.336559806437;11061.281016733887;11083.889161108447;10816.351018938889;10991.890081099247;11000.724981875517;11039.889601103887;11044.950729680668;8235.876461853077;8329.958350208331;8462.703805366906;8490;8531.274841638531;5927.4665280125;5932.466078052996;6020.638761674139;6025.728842202199;6041.818745437644;9877.259205559756;10052.64815731446;10194.949025254826;10354.482275886327;10355.844662330222;10462.372257664565;10575.259731819007;10584.735381615521;10621.681349559525;10625.309354892217;7001.929980700332;7240.52936559122;7468.290512401313;7647.349975252166;7802.141764406025;8384.790380240298;8613.353998450266;8618.09510001466;8661.566921654017;8671.6097775599;7466.664000120117;7558.474593112342;7604.429667774828;7701.730439434593;7712.035995500562;7431.182569917197;7494.100707915085;7509.962450187714;7650.770476885702;7663.846723065396;6952.165740111219;7051.189113252041;7101.893471598033;7104.183018952886;7115.359617634438;4986.12742770021;5027.296178534935;5119.827340717304;5237.450067742984;5253.317068781034;4256.808443619982;5086.796528138833;5135.922961155511;5167;5170.6380553360905 19:20:25 INFO - PROCESS | 1653 | |4;prototype.html;286.33570117327804;302.8955010521371;311.65406398897227;315.7063930544593;315.805779445641;4315.41741864849;5455.290812194414;5518.806841760539;5555.777768889245;5587.357453892803;4715.622750179986;4862.586680132193;5158.819441319554;5414.593905457087;5549.278593782813;3474.8957531274104;4055.776932268724;4156.605122513364;4203.138356636882;4235.639970602487;3434.879779207728;4062.796860156995;4090.6931980101463;4219.978900105511;4224.085381087056;4087.3460246360587;4157;4171;4187.309093999486;4205.537390887;4160.105577300879;4166.208420400114;4174.853880114197;4191.589835844402;4194.049766858395;3622.8913132606062;3642.653947874974;3668.1563240454843;3678.9080272993124;3685.1892583631557;4897.142999975025;5032.672876263031;5233.2935053768015;5395.946040539584;5428.9185662215095;3954.525456945185;4383.145286669101;4701.3653156824075;4779.593734532569;4779.832705855313;5502.367227768817;5790.507806836424;5796.710299431743;5802.361740208574;5827.766889324422;3563.3051554946796;3749.5875453700073;3863.536375634914;3914.4911161549103;3929.7249192556533;5456.890862182774;5610.887782244332;6029.427204415573;6101.389861013908;6141.385861413823;3408.897733068012;3474.8957531274104;3979.880603581897;3982.542007669097;4011.2378648056774;3827.3302172119766;3982.7212095153063;4013.5585085640555;4022.738521996061;4044.5753195914003;4752.405949256343;4754.548317909862;4757.619390448755;4796.712197268175;4799.616030717534;5846.649201047866;5897.734601942923;5902.61632993854;5969.552483481752;6011.879762404727;1190.8213767934878;1241.9813702794465;1243.8445194350707;1332.3072002558615;1338.2238301785137;696.8084575376063;796.7131832540397;855.0936007831718;919.9632014719471;921.5898924978454;4727.598154156866;4758.191887082887;5325.627206095536;5328;5383.4118934914295;5588.574913397058;5886.676232807236;5911.113333000085;5945.443459312451;5994.613043630335;4797.304390863305;5029.673071250357;5316.73416329182;5386.7071902743055;5413.242146099549;2312.7742296582837;2628.303499572615;2638.8020898432696;2675.622054641861;2712.715164907696;5139;5252.29094072303;5255.237990491358;5256.2904007959205;5304.681719096867;4330.35044743291;4605.746683932416;5133.897322053538;5167;5189.870253243624;4295.914081718348;4956.504349565159;4967.925481117786;5223.033738758342;5298.576113910878;4457.7771111444945;5042.924356134734;5044.94056248192;5120.718360490208;5126.436092029949;5008.84973450797;5012.298278240976;5196.870078248074;6026.337102918587;6052.818415447544;6303.49572034227;6341.3683321421095;6381.074744161978;6391.7123729433215;6399.224457570056;3983.6016398359934;3997.7001724871334;4005.9154451073096;4007.495315427858;4024.538896548907;5029.9245511318095;5288.9735551322;5695.572832037531;5964.612300200473;6028.608140470856;4758.357621721023;4851.80592776285;5047.536214497754;5399.83800485986;5552.972235138798;5206.791728330824;5214;5588.161775733673;5808;5886.470217680429;4517.819287228474;5032.817287937259;5319.25530425733;5742.7702891883855;5757.884842303214;4841.305543059901;5112.846614601568;5500.50495455411;5501;5872.588918775645;4786.617070634411;5700.486956173964;5732.398098199796;5752.252207213036;5800.274965629296 19:20:25 INFO - PROCESS | 1653 | |5;yui.html;700.8142842146829;749.3518106837583;759.9202083781203;789.7078081109989;809.1503920883072;13558.915286777059;13926.234057126854;15329.463468778595;15955.042697438133;16023.679526409465;14417.92791036046;14423.423063077464;14446.855531444682;14447.855521444782;14526;656.5010591950129;680.625655889259;811.4482152136545;822.2271065198725;842.2503971465401;836.786619412049;837.409626213518;839.1566475691951;842.540815255684;844.5397258494105;896.5338024227398;901.2339511415311;902.269161978796;903.0472851142042;904;892.7009451833611;896.0188593490118;896.0501868019854;897.4346161918015;898.3531857062904;641.4483544152025;665.6106177885943;665.9101021362103;669.364104101101;670.587588632992;14980.625484362869;15078.095314281178;15201.391944322213;15202.391904323813;15219.315130819139;14554.70890582193;14899.404023839033;14936;14958.850411495854;14964.251787410694;11703.941480292544;11738.119641026957;11779.411029448493;11894.82157767634;12360.196587221802;3274.7707660463775;3897.0841852165004;3909.4722212501233;3939.5469521005166;3969.980150099231;125267.373663132;125390;128266.358668207;132103;132542;11095.44522773858;11350.14873884462;11423.086153107732;11520.051164696333;11684.240524365889;23434.882825585762;23815;24061.63907541388;24283;24356.147534836196;7508.436867234979;7760.883586746203;7929.801754956172;7989.960050199712;8170.836583268301;4382.9780851096175;4413.426254586883;4507.954920450819;4562.087582483517;4645.976770116128;3395.422778127724;3546.308469848355;3554.2180720241504;3557.48416479609;3562.7684200526883;555.2559570175983;644.9226092868792;651.6285717141184;666.8532922756985;680.306087790451;497.31122395481793;582.2750675409143;589.0810335876047;607.1378642327905;626.5770604841714;8663.393562450568;8927.151920567536;9085.13691199335;9142.794533646833;9192.494412807226;477.6656340561621;591.8165368735706;617.7035023188895;700.6671830880393;702.7751119641767;4552.84065057728;4729.810807567727;4753.144434001843;4755.643326750507;4767.451743049524;129851;132135;133409;133505.332473337;138921.22157556794;105192.47403762932;110681.44659276652;112233;112368.43815780869;115600;94976.52511737397;105202.94797051931;105587.41618875723;106296.46851765692;114816.85183148061;9521.967476529771;9868.210543156387;10062.849057264293;10245.948770256102;10256.435896025492;63198.15608297546;65658;65962.01056984244;66683.99974000297;67227.32772672211;97203;98651.01348986418;99420.00579994108;100750;103157;13368.465261389436;13583.728325433634;14256.429742810586;14300.784433323284;14393.784093238819;14635.34140963638;14762.778558321419;14921.62695932567;15718.685626287639;15918.8408115922;13347.933260333637;13827;13913.373898174405;14236.145831250158;14862.777058344349;13638.522651707142;14257.287135643384;14257.572272831832;14358.712825743636;15065.09609423438;13926.303684815515;13950.79073813914;14037.789433158307;14332.426702932184;14479.420823166955;11401.372924489233;11412.54349826031;11592.246503977214;11729.296242225493;11884.584039558575;11417.257878237888;11500;11819.527218911147;11822.704432389259;11825.053995680497 19:20:25 INFO - PROCESS | 1653 | __end_tp_report 19:20:25 INFO - PROCESS | 1653 | __start_cc_report 19:20:25 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,364 19:20:25 INFO - PROCESS | 1653 | __end_cc_report 19:20:25 INFO - PROCESS | 1653 | __startTimestamp1476152425632__endTimestamp 19:20:25 INFO - PROCESS | 1653 | 19:20:25 INFO - PROCESS | 1653 | ------- Summary: start ------- 19:20:25 INFO - PROCESS | 1653 | Number of tests: 6 19:20:25 INFO - PROCESS | 1653 | 19:20:25 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5858.34 Median:6101.18 stddev:645.42 (10.6%) stddev-sans-first:607.26 19:20:25 INFO - PROCESS | 1653 | Values: 3001.8 3420.0 3455.2 3455.6 3475.3 4861.8 5847.5 5975.8 5984.7 6026.2 5951.8 5954.3 5973.8 6005.9 6058.3 5353.3 5394.9 5445.7 5458.9 5462.1 5431.7 5471.2 5478.1 5479.8 5484.2 5321.1 5374.9 5460.9 5476.3 5517.3 5383.7 5386.5 5403.4 5441.9 5488.5 5276.8 5385.3 5391.0 5397.7 5442.8 5757.7 5943.3 5967.0 6017.7 6074.2 6123.9 6168.4 6198.3 6216.2 6284.7 6326.9 6333.5 6345.8 6349.5 6363.6 6036.1 6062.1 6071.4 6078.1 6085.4 6243.9 6243.9 6301.1 6321.8 6366.4 5099.7 6266.7 6267.3 6287.5 6294.7 6255.8 6297.2 6309.9 6312.5 6328.0 6176.4 6194.7 6204.3 6249.4 6253.8 5339.6 6251.6 6292.0 6293.7 6297.9 5043.8 5044.3 5044.5 5054.8 5072.8 4395.8 4439.5 4483.9 4521.5 4535.6 6008.4 6050.3 6087.6 6132.2 6141.5 6327.8 6342.5 6357.2 6369.3 6410.4 5912.4 5999.9 6004.4 6031.5 6078.5 5530.8 5541.3 5548.0 5566.5 5577.3 6502.3 6506.1 6512.7 6520.9 6537.4 5093.6 5714.9 5741.7 6241.0 6311.6 6390.7 6397.9 6413.3 6423.3 6430.9 6260.8 6275.6 6280.2 6294.3 6300.6 5850.4 6136.1 6206.6 6217.2 6302.9 6201.0 6289.9 6296.9 6302.5 6324.3 6101.2 6229.8 6262.8 6294.2 6306.3 5687.8 5892.4 6100.8 6190.1 6257.4 6140.7 6201.3 6215.7 6228.1 6242.7 6131.9 6134.4 6148.1 6159.8 6159.8 19:20:25 INFO - PROCESS | 1653 | 19:20:25 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:73932.04 Median:39601.21 stddev:168011.73 (424.3%) stddev-sans-first:168392.44 19:20:25 INFO - PROCESS | 1653 | Values: 443.4 467.6 482.6 511.7 513.7 37783.6 39854.8 39880.2 39929.2 40055.0 41981.2 42452.6 42467.8 42513.0 42751.6 9707.4 9871.4 9874.8 9895.0 9901.4 9704.3 9746.5 9768.4 9814.0 9831.6 9798.8 9801.7 9831.2 9855.3 9869.3 9777.4 9795.9 9818.6 9818.6 9840.6 9693.2 9694.5 9761.3 9768.5 9777.6 38947.0 39107.8 39358.0 39419.8 39581.4 3311.4 3382.4 3475.4 3535.4 3560.8 29320.6 29733.9 30000.7 30113.4 30504.5 3114.8 3225.3 3234.7 3248.9 3267.3 540439.0 541303.3 545125.0 545652.0 545759.0 62224.7 62711.7 62771.7 62810.7 62866.4 26978.2 34190.3 34658.0 35975.3 36263.0 16961.9 17005.9 17143.1 17170.2 17222.7 12990.8 13134.5 13143.7 13190.5 13199.9 19081.7 19114.0 19131.9 19156.0 19175.0 7969.2 8119.4 8124.5 8136.4 8246.6 839.8 954.4 969.4 1006.7 1032.5 25769.5 27429.9 29290.3 30284.0 30701.8 862.7 1001.9 1046.0 1055.9 1087.3 14113.6 15665.2 15839.0 15913.6 15933.6 707111.0 717031.0 725479.0 725561.0 728831.0 55821.7 56298.4 56953.7 57084.4 57122.7 1347.3 1353.6 1366.9 1370.4 1380.8 29205.6 29705.4 29881.0 29955.0 30469.6 47832.0 48004.0 48090.5 48138.0 48212.5 600796.0 601574.0 603028.0 603491.0 603644.0 26039.7 26089.0 26413.6 26490.7 26511.9 45910.3 47001.5 47030.8 47441.8 47466.0 38838.8 39127.0 39127.2 39971.0 40328.8 38558.4 39181.4 39678.0 40433.4 41641.8 37262.4 37967.4 38063.0 38275.2 39621.0 32212.5 34577.5 34999.5 35087.3 35276.8 25839.6 25976.5 25978.4 26282.0 26436.3 19:20:25 INFO - PROCESS | 1653 | 19:20:25 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:37534.90 Median:319.07 stddev:111905.14 (35072.8%) stddev-sans-first:112184.16 19:20:25 INFO - PROCESS | 1653 | Values: 312.3 325.9 373.2 377.8 388.9 17580.8 19420.0 20469.9 20860.2 21621.6 16798.8 17443.4 20212.5 20610.5 20730.2 5816.8 5888.5 6141.4 6185.0 6197.4 5924.0 6002.8 6068.6 6081.0 6085.1 5705.5 5909.3 5947.6 6021.7 6029.3 5052.3 5126.3 6022.2 6038.3 6059.6 5077.5 5234.8 5241.9 5365.6 5432.7 12482.2 12645.3 12851.7 12882.7 12944.1 2091.6 2311.1 2325.5 2378.0 2715.6 9718.6 9807.7 9823.1 10136.4 10171.8 1748.8 1809.8 1845.2 1861.8 1899.1 113648.9 114595.9 115662.4 125455.0 129926.0 9317.7 9517.9 11598.8 11634.4 11850.9 14436.9 14587.1 14591.4 14605.5 14631.0 7163.9 8612.5 8687.7 8712.7 8759.3 8695.8 8728.5 8749.9 8833.2 8874.3 4543.6 4555.7 4558.0 4597.8 4609.0 1644.0 1925.2 1932.8 1965.1 1965.7 819.4 836.7 910.2 980.8 1010.2 20551.2 21238.3 21335.9 21422.3 21454.8 902.4 908.0 927.3 930.4 1009.6 10759.5 11083.9 11159.7 11167.8 11253.8 641640.0 668750.0 673974.0 679992.0 680619.0 146234.0 149134.3 154454.0 155566.0 156685.0 784.7 979.4 998.7 1000.9 1007.1 15143.9 19180.9 19602.4 19686.3 19704.9 47631.8 54547.5 58849.0 60463.1 60480.0 78000.0 82752.0 84179.2 86289.2 87338.0 7671.4 8082.1 8164.3 8239.5 8246.6 10693.5 12680.2 12737.0 12788.2 13137.5 9657.8 10917.2 11048.6 11059.2 11551.5 8816.1 11078.4 11284.0 11306.4 11402.3 11300.2 11344.5 11536.8 11655.4 11696.7 7849.6 7977.9 7987.6 8095.3 8384.2 8275.3 9954.6 10249.4 11136.9 11140.3 19:20:25 INFO - PROCESS | 1653 | 19:20:25 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5784.35 Median:4775.18 stddev:3225.67 (67.6%) stddev-sans-first:3218.76 19:20:25 INFO - PROCESS | 1653 | Values: 1514.7 1538.7 1756.9 1806.4 1855.5 8000.2 8250.0 8518.2 9094.5 9123.4 6816.7 8793.3 8813.9 8917.7 8929.2 2378.0 2390.4 2423.2 2424.0 2427.1 2165.4 2268.7 2435.9 2437.0 2440.5 2397.0 2405.1 2419.9 2430.4 2432.0 2391.4 2394.3 2403.9 2405.9 2410.6 2242.5 2378.4 2400.3 2406.6 2409.4 7931.9 8208.6 9004.6 9019.5 9038.3 5320.7 5493.5 5497.8 5516.4 5527.3 3627.6 3633.1 3660.7 3695.5 3702.0 1088.7 1090.2 1096.4 1097.8 1121.7 9891.7 10011.6 11638.4 11781.6 11814.5 4119.8 4751.6 4798.8 4856.7 4957.8 10050.2 10147.5 10150.8 10155.2 10190.6 5421.1 5444.1 5446.2 5449.4 5470.2 4420.0 4544.3 4805.7 4932.6 4970.6 4039.9 4055.9 4133.4 4159.8 4172.4 1295.7 1302.8 1315.3 1317.8 1322.6 923.5 929.2 930.9 934.5 953.4 5810.7 5926.6 6109.0 6137.8 6142.1 438.9 445.0 952.5 997.8 1063.4 3946.5 3972.9 4049.8 4084.8 4234.7 10597.5 10978.7 11057.3 11061.3 11083.9 10816.4 10991.9 11000.7 11039.9 11045.0 8235.9 8330.0 8462.7 8490.0 8531.3 5927.5 5932.5 6020.6 6025.7 6041.8 9877.3 10052.6 10194.9 10354.5 10355.8 10462.4 10575.3 10584.7 10621.7 10625.3 7001.9 7240.5 7468.3 7647.3 7802.1 8384.8 8613.4 8618.1 8661.6 8671.6 7466.7 7558.5 7604.4 7701.7 7712.0 7431.2 7494.1 7510.0 7650.8 7663.8 6952.2 7051.2 7101.9 7104.2 7115.4 4986.1 5027.3 5119.8 5237.5 5253.3 4256.8 5086.8 5135.9 5167.0 5170.6 19:20:25 INFO - PROCESS | 1653 | 19:20:25 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4542.31 Median:5029.80 stddev:1405.54 (27.9%) stddev-sans-first:1372.71 19:20:25 INFO - PROCESS | 1653 | Values: 286.3 302.9 311.7 315.7 315.8 4315.4 5455.3 5518.8 5555.8 5587.4 4715.6 4862.6 5158.8 5414.6 5549.3 3474.9 4055.8 4156.6 4203.1 4235.6 3434.9 4062.8 4090.7 4220.0 4224.1 4087.3 4157.0 4171.0 4187.3 4205.5 4160.1 4166.2 4174.9 4191.6 4194.0 3622.9 3642.7 3668.2 3678.9 3685.2 4897.1 5032.7 5233.3 5395.9 5428.9 3954.5 4383.1 4701.4 4779.6 4779.8 5502.4 5790.5 5796.7 5802.4 5827.8 3563.3 3749.6 3863.5 3914.5 3929.7 5456.9 5610.9 6029.4 6101.4 6141.4 3408.9 3474.9 3979.9 3982.5 4011.2 3827.3 3982.7 4013.6 4022.7 4044.6 4752.4 4754.5 4757.6 4796.7 4799.6 5846.6 5897.7 5902.6 5969.6 6011.9 1190.8 1242.0 1243.8 1332.3 1338.2 696.8 796.7 855.1 920.0 921.6 4727.6 4758.2 5325.6 5328.0 5383.4 5588.6 5886.7 5911.1 5945.4 5994.6 4797.3 5029.7 5316.7 5386.7 5413.2 2312.8 2628.3 2638.8 2675.6 2712.7 5139.0 5252.3 5255.2 5256.3 5304.7 4330.4 4605.7 5133.9 5167.0 5189.9 4295.9 4956.5 4967.9 5223.0 5298.6 4457.8 5042.9 5044.9 5120.7 5126.4 5008.8 5012.3 5196.9 6026.3 6052.8 6303.5 6341.4 6381.1 6391.7 6399.2 3983.6 3997.7 4005.9 4007.5 4024.5 5029.9 5289.0 5695.6 5964.6 6028.6 4758.4 4851.8 5047.5 5399.8 5553.0 5206.8 5214.0 5588.2 5808.0 5886.5 4517.8 5032.8 5319.3 5742.8 5757.9 4841.3 5112.8 5500.5 5501.0 5872.6 4786.6 5700.5 5732.4 5752.3 5800.3 19:20:25 INFO - PROCESS | 1653 | 19:20:25 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:24893.79 Median:23938.32 stddev:38579.96 (161.2%) stddev-sans-first:38645.43 19:20:25 INFO - PROCESS | 1653 | Values: 700.8 749.4 759.9 789.7 809.2 13558.9 13926.2 15329.5 15955.0 16023.7 14417.9 14423.4 14446.9 14447.9 14526.0 656.5 680.6 811.4 822.2 842.3 836.8 837.4 839.2 842.5 844.5 896.5 901.2 902.3 903.0 904.0 892.7 896.0 896.1 897.4 898.4 641.4 665.6 665.9 669.4 670.6 14980.6 15078.1 15201.4 15202.4 15219.3 14554.7 14899.4 14936.0 14958.9 14964.3 11703.9 11738.1 11779.4 11894.8 12360.2 3274.8 3897.1 3909.5 3939.5 3970.0 125267.4 125390.0 128266.4 132103.0 132542.0 11095.4 11350.1 11423.1 11520.1 11684.2 23434.9 23815.0 24061.6 24283.0 24356.1 7508.4 7760.9 7929.8 7990.0 8170.8 4383.0 4413.4 4508.0 4562.1 4646.0 3395.4 3546.3 3554.2 3557.5 3562.8 555.3 644.9 651.6 666.9 680.3 497.3 582.3 589.1 607.1 626.6 8663.4 8927.2 9085.1 9142.8 9192.5 477.7 591.8 617.7 700.7 702.8 4552.8 4729.8 4753.1 4755.6 4767.5 129851.0 132135.0 133409.0 133505.3 138921.2 105192.5 110681.4 112233.0 112368.4 115600.0 94976.5 105202.9 105587.4 106296.5 114816.9 9522.0 9868.2 10062.8 10245.9 10256.4 63198.2 65658.0 65962.0 66684.0 67227.3 97203.0 98651.0 99420.0 100750.0 103157.0 13368.5 13583.7 14256.4 14300.8 14393.8 14635.3 14762.8 14921.6 15718.7 15918.8 13347.9 13827.0 13913.4 14236.1 14862.8 13638.5 14257.3 14257.6 14358.7 15065.1 13926.3 13950.8 14037.8 14332.4 14479.4 11401.4 11412.5 11592.2 11729.3 11884.6 11417.3 11500.0 11819.5 11822.7 11825.1 19:20:25 INFO - PROCESS | 1653 | -------- Summary: end -------- 19:20:25 INFO - PROCESS | 1653 | 19:20:26 INFO - TEST-INFO | 1653: exit 0 19:20:26 INFO - TEST-OK | dromaeo_css | took 1113467ms 19:20:26 INFO - TEST-START | kraken 19:20:26 INFO - operating with platform_type : mac_ 19:20:26 INFO - Initialising browser for kraken test... 19:20:26 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpGzTP7m/profile http://localhost:49275/getInfo.html) 19:20:28 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 19:20:28 INFO - PROCESS | 1661 | colorDepth:24 19:20:28 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 19:20:28 INFO - PROCESS | 1661 | __metrics 19:20:28 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 19:20:29 INFO - TEST-INFO | 1661: exit 0 19:20:29 INFO - Browser initialized. 19:20:29 INFO - Running cycle 1/1 for kraken test... 19:20:29 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpGzTP7m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:20:41 INFO - PROCESS | 1663 | RSS: Main: 225267712 19:20:41 INFO - PROCESS | 1663 | 19:20:44 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 19:20:45 INFO - PROCESS | 1663 | RSS: Main: 237711360 19:20:45 INFO - PROCESS | 1663 | 19:20:47 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 19:20:48 INFO - PROCESS | 1663 | RSS: Main: 246353920 19:20:48 INFO - PROCESS | 1663 | 19:20:51 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 19:20:51 INFO - PROCESS | 1663 | RSS: Main: 249286656 19:20:51 INFO - PROCESS | 1663 | 19:20:53 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 19:20:54 INFO - PROCESS | 1663 | RSS: Main: 249253888 19:20:54 INFO - PROCESS | 1663 | 19:20:56 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:20:57 INFO - PROCESS | 1663 | RSS: Main: 250679296 19:20:57 INFO - PROCESS | 1663 | 19:21:00 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 19:21:00 INFO - PROCESS | 1663 | RSS: Main: 251219968 19:21:00 INFO - PROCESS | 1663 | 19:21:03 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 19:21:04 INFO - PROCESS | 1663 | RSS: Main: 251019264 19:21:04 INFO - PROCESS | 1663 | 19:21:07 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 19:21:08 INFO - PROCESS | 1663 | RSS: Main: 251650048 19:21:08 INFO - PROCESS | 1663 | 19:21:09 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:21:10 INFO - PROCESS | 1663 | RSS: Main: 251117568 19:21:10 INFO - PROCESS | 1663 | 19:21:12 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:21:13 INFO - PROCESS | 1663 | RSS: Main: 251170816 19:21:13 INFO - PROCESS | 1663 | 19:21:15 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:21:15 INFO - PROCESS | 1663 | RSS: Main: 251113472 19:21:15 INFO - PROCESS | 1663 | 19:21:18 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:21:19 INFO - PROCESS | 1663 | RSS: Main: 251133952 19:21:19 INFO - PROCESS | 1663 | 19:21:22 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:21:23 INFO - PROCESS | 1663 | RSS: Main: 251502592 19:21:23 INFO - PROCESS | 1663 | 19:21:24 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 19:21:25 INFO - PROCESS | 1663 | RSS: Main: 253186048 19:21:25 INFO - PROCESS | 1663 | 19:21:25 INFO - PROCESS | 1663 | __start_tp_report 19:21:25 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 19:21:25 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 19:21:25 INFO - PROCESS | 1663 | |i|pagename|runs| 19:21:25 INFO - PROCESS | 1663 | |0;ai-astar;107;119;115;133;130;117;116;119;114;144 19:21:25 INFO - PROCESS | 1663 | |1;audio-beat-detection;157;113;110;145;108;114;111;109;136;115 19:21:25 INFO - PROCESS | 1663 | |2;audio-dft;201;195;196;196;195;192;195;193;199;191 19:21:25 INFO - PROCESS | 1663 | |3;audio-fft;80;60;59;86;59;68;70;70;106;85 19:21:25 INFO - PROCESS | 1663 | |4;audio-oscillator;115;101;89;71;72;86;74;79;66;77 19:21:25 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;77;74;109;77;133;73;125;132;137;86 19:21:25 INFO - PROCESS | 1663 | |6;imaging-darkroom;98;103;174;174;100;99;99;101;100;99 19:21:25 INFO - PROCESS | 1663 | |7;imaging-desaturate;91;95;78;79;107;109;150;129;140;152 19:21:25 INFO - PROCESS | 1663 | |8;json-parse-financial;54;57;56;59;50;50;82;48;49;65 19:21:25 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;66;75;69;66;77;101;101;60;82;103 19:21:25 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;85;83;87;82;81;75;98;106;104;105 19:21:25 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;146;150;146;149;148;142;141;141;184;166 19:21:25 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;158;159;168;166;172;166;168;172;211;165 19:21:25 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;71;69;66;68;68;68;66;66;66;68 19:21:25 INFO - PROCESS | 1663 | __end_tp_report 19:21:25 INFO - PROCESS | 1663 | __start_cc_report 19:21:25 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,935 19:21:25 INFO - PROCESS | 1663 | __end_cc_report 19:21:25 INFO - PROCESS | 1663 | __startTimestamp1476152485010__endTimestamp 19:21:25 INFO - PROCESS | 1663 | 19:21:25 INFO - PROCESS | 1663 | ------- Summary: start ------- 19:21:25 INFO - PROCESS | 1663 | Number of tests: 14 19:21:25 INFO - PROCESS | 1663 | 19:21:25 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:121.40 Median:119.00 stddev:10.97 (9.2%) stddev-sans-first:10.32 19:21:25 INFO - PROCESS | 1663 | Values: 107.0 119.0 115.0 133.0 130.0 117.0 116.0 119.0 114.0 144.0 19:21:25 INFO - PROCESS | 1663 | 19:21:25 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:121.80 Median:114.50 stddev:17.55 (15.3%) stddev-sans-first:13.21 19:21:25 INFO - PROCESS | 1663 | Values: 157.0 113.0 110.0 145.0 108.0 114.0 111.0 109.0 136.0 115.0 19:21:25 INFO - PROCESS | 1663 | 19:21:25 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:195.30 Median:195.50 stddev:3.02 (1.5%) stddev-sans-first:2.40 19:21:25 INFO - PROCESS | 1663 | Values: 201.0 195.0 196.0 196.0 195.0 192.0 195.0 193.0 199.0 191.0 19:21:25 INFO - PROCESS | 1663 | 19:21:25 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:74.30 Median:70.00 stddev:15.05 (21.5%) stddev-sans-first:15.82 19:21:25 INFO - PROCESS | 1663 | Values: 80.0 60.0 59.0 86.0 59.0 68.0 70.0 70.0 106.0 85.0 19:21:25 INFO - PROCESS | 1663 | 19:21:25 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:83.00 Median:75.50 stddev:15.20 (20.1%) stddev-sans-first:10.85 19:21:25 INFO - PROCESS | 1663 | Values: 115.0 101.0 89.0 71.0 72.0 86.0 74.0 79.0 66.0 77.0 19:21:25 INFO - PROCESS | 1663 | 19:21:25 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:102.30 Median:73.50 stddev:27.48 (37.4%) stddev-sans-first:27.57 19:21:25 INFO - PROCESS | 1663 | Values: 77.0 74.0 109.0 77.0 133.0 73.0 125.0 132.0 137.0 86.0 19:21:25 INFO - PROCESS | 1663 | 19:21:25 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:114.70 Median:136.00 stddev:31.28 (23.0%) stddev-sans-first:32.59 19:21:25 INFO - PROCESS | 1663 | Values: 98.0 103.0 174.0 174.0 100.0 99.0 99.0 101.0 100.0 99.0 19:21:25 INFO - PROCESS | 1663 | 19:21:25 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:113.00 Median:115.00 stddev:28.12 (24.5%) stddev-sans-first:28.68 19:21:25 INFO - PROCESS | 1663 | Values: 91.0 95.0 78.0 79.0 107.0 109.0 150.0 129.0 140.0 152.0 19:21:25 INFO - PROCESS | 1663 | 19:21:25 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.50 stddev:10.25 (18.1%) stddev-sans-first:10.82 19:21:25 INFO - PROCESS | 1663 | Values: 54.0 57.0 56.0 59.0 50.0 50.0 82.0 48.0 49.0 65.0 19:21:25 INFO - PROCESS | 1663 | 19:21:25 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:80.00 Median:67.50 stddev:16.20 (24.0%) stddev-sans-first:16.37 19:21:25 INFO - PROCESS | 1663 | Values: 66.0 75.0 69.0 66.0 77.0 101.0 101.0 60.0 82.0 103.0 19:21:25 INFO - PROCESS | 1663 | 19:21:25 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:90.60 Median:82.50 stddev:11.50 (13.9%) stddev-sans-first:12.02 19:21:25 INFO - PROCESS | 1663 | Values: 85.0 83.0 87.0 82.0 81.0 75.0 98.0 106.0 104.0 105.0 19:21:25 INFO - PROCESS | 1663 | 19:21:25 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:151.30 Median:148.50 stddev:13.57 (9.1%) stddev-sans-first:14.26 19:21:25 INFO - PROCESS | 1663 | Values: 146.0 150.0 146.0 149.0 148.0 142.0 141.0 141.0 184.0 166.0 19:21:25 INFO - PROCESS | 1663 | 19:21:25 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:168.00 stddev:14.97 (8.9%) stddev-sans-first:15.18 19:21:25 INFO - PROCESS | 1663 | Values: 158.0 159.0 168.0 166.0 172.0 166.0 168.0 172.0 211.0 165.0 19:21:25 INFO - PROCESS | 1663 | 19:21:25 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.65 (2.4%) stddev-sans-first:1.20 19:21:25 INFO - PROCESS | 1663 | Values: 71.0 69.0 66.0 68.0 68.0 68.0 66.0 66.0 66.0 68.0 19:21:25 INFO - PROCESS | 1663 | -------- Summary: end -------- 19:21:25 INFO - PROCESS | 1663 | 19:21:25 INFO - TEST-INFO | 1663: exit 0 19:21:25 INFO - TEST-OK | kraken | took 59600ms 19:21:25 INFO - SUITE-END | took 1173s 19:21:26 INFO - Completed test suite (00:19:33) 19:21:26 INFO - javascript benchmark 19:21:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7391.097429411086, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3001.7748668849836, 3419.9911026247237, 3455.222574920642, 3455.568053993251, 3475.322312149131, 4861.829835955742, 5847.502962248209, 5975.790847320344, 5984.730687119079, 6026.156338112668, 5951.839391318695, 5954.345022047572, 5973.761049558023, 6005.87988240235, 6058.303295121063, 5353.277307563468, 5394.8921021579545, 5445.700486473243, 5458.890822183554, 5462.0987537056335, 5431.674099554019, 5471.23402723619, 5478.068728316176, 5479.808206712766, 5484.177373393983, 5321.068812957737, 5374.946250537503, 5460.945390546083, 5476.26070480486, 5517.337919449672, 5383.730813459331, 5386.461353864622, 5403.378611459693, 5441.863953401196, 5488.4785945335125, 5276.815311464119, 5385.2999110115825, 5391.0, 5397.7031263280505, 5442.809501667422, 5757.712114394263, 5943.31651860033, 5967.0, 6017.669028203447, 6074.179985701962, 6123.862238009563, 6168.414000669929, 6198.349173336825, 6216.191895053614, 6284.685765711742, 6326.873462530723, 6333.46165575922, 6345.777897773556, 6349.492040636738, 6363.5863668861375, 6036.0945858121195, 6062.090686396988, 6071.392860713938, 6078.088286757022, 6085.42188492097, 6243.906341404882, 6243.937560624427, 6301.086342480315, 6321.841953951188, 6366.427021568081, 5099.69401835891, 6266.686665666698, 6267.341929097471, 6287.528435367366, 6294.748210071546, 6255.812325630239, 6297.1813664223355, 6309.905351419732, 6312.52656050798, 6328.019157030668, 6176.382361763787, 6194.721237544321, 6204.255489341218, 6249.406306400884, 6253.843653908689, 5339.599530035263, 6251.624902505864, 6291.96854015727, 6293.685315734195, 6297.905531417033, 5043.773030213649, 5044.344235249468, 5044.54599086084, 5054.7978080876355, 5072.771725272371, 4395.758233297135, 4439.467263928284, 4483.910321793546, 4521.502634710179, 4535.614472769786, 6008.369121242294, 6050.334463209131, 6087.57386982907, 6132.20254427538, 6141.455323060992, 6327.810165695037, 6342.460890824239, 6357.205349331333, 6369.331220221903, 6410.358964103552, 5912.438318359749, 5999.850003749942, 6004.42957918997, 6031.487323577458, 6078.452939235402, 5530.806421775219, 5541.33503979525, 5548.0, 5566.526845218121, 5577.27495425592, 6502.349765023459, 6506.121673574007, 6512.739490420425, 6520.902186467112, 6537.444317232993, 5093.617978651542, 5714.857028594215, 5741.655500669973, 6241.032639940817, 6311.589746666452, 6390.680465976776, 6397.936020639921, 6413.326600707045, 6423.293437721753, 6430.903536447051, 6260.843478913063, 6275.623462592259, 6280.214973128359, 6294.307626161027, 6300.621962682254, 5850.385709500441, 6136.059583474799, 6206.627602343874, 6217.160683307696, 6302.905456418249, 6201.0388389799655, 6289.874202516015, 6296.937030629635, 6302.527310451826, 6324.272708638566, 6101.176341194059, 6229.844253893689, 6262.843428914313, 6294.15028971083, 6306.337834527309, 5687.800926967537, 5892.351841297368, 6100.786472473442, 6190.133381326708, 6257.43683068526, 6140.657627863787, 6201.286852012076, 6215.689215539114, 6228.065790131516, 6242.719077641426, 6131.877362452815, 6134.38656134383, 6148.077788331786, 6159.753609855556, 6159.784407545714], "value": 5817.772514394286, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [443.430192203019, 467.637580874822, 482.64766720294165, 511.69554115301395, 513.7328589133649, 37783.62216377835, 39854.80072599636, 39880.20239595207, 39929.201415971664, 40054.998625034386, 41981.16037679252, 42452.57547424525, 42467.78766106173, 42513.0, 42751.57248427515, 9707.417554946707, 9871.358361706501, 9874.802503949917, 9895.0, 9901.405915645084, 9704.272179586524, 9746.46394448305, 9768.365056271356, 9813.950930245339, 9831.557579908886, 9798.804023919518, 9801.656942007032, 9831.164351030135, 9855.310128291023, 9869.309148359618, 9777.364471309342, 9795.853062204073, 9818.558164882597, 9818.607255709763, 9840.557174927146, 9693.22454203662, 9694.466804325759, 9761.267904907088, 9768.462734549597, 9777.560009799576, 38947.0, 39107.80446097751, 39358.0160495987, 39419.81740547788, 39581.40627890584, 3311.3708395404797, 3382.4418970870024, 3475.42655461851, 3535.3636345457808, 3560.8041557714314, 29320.639984050198, 29733.851330743208, 30000.69999300001, 30113.397732045454, 30504.54243186332, 3114.7508199343997, 3225.2904361040532, 3234.692704193098, 3248.8700451982127, 3267.346530693847, 540439.0, 541303.293483534, 545125.0, 545652.0, 545759.0, 62224.68887655533, 62711.68644156841, 62771.686141569, 62810.685946569974, 62866.37133628697, 26978.190654280403, 34190.31619367649, 34658.0, 35975.28049439049, 36263.0, 16961.91519042397, 17005.91497042507, 17143.142842857807, 17170.22733976974, 17222.741658874875, 12990.805137922938, 13134.474621015244, 13143.671408214872, 13190.472381104648, 13199.868001320056, 19081.713774293396, 19114.0, 19131.90434047821, 19156.04219789005, 19175.0, 7969.242921922408, 8119.3910456715985, 8124.471909325875, 8136.430449868452, 8246.628901699438, 839.7606682095574, 954.4178051388648, 969.4280374578891, 1006.6929586476049, 1032.4528000159928, 25769.48461030769, 27429.86285068602, 29290.26774330616, 30284.0, 30701.846490767402, 862.66787286895, 1001.8998100189923, 1046.027194708928, 1055.8965880654735, 1087.2878264736453, 14113.647158821112, 15665.216739162996, 15838.970466919613, 15913.602159945862, 15933.601659958362, 707111.0, 717031.0, 725479.0, 725561.0, 728831.0, 55821.72089139609, 56298.43701563014, 56953.71523142441, 57084.42915570874, 57122.714386427804, 1347.2859384526216, 1353.5736243083397, 1366.9179849209079, 1370.3559327116238, 1380.7790753479394, 29205.561916570845, 29705.405891882474, 29881.0, 29955.0, 30469.64833868317, 47832.0, 48004.0, 48090.519094810006, 48138.0, 48212.517874820805, 600796.0, 601573.9921300366, 603028.0, 603491.0, 603644.0, 26039.739602604488, 26089.0, 26413.60379594346, 26490.735092648825, 26511.867440663445, 45910.31134532918, 47001.52998470108, 47030.82422939454, 47441.76279118582, 47466.0, 38838.80580597079, 39127.0, 39127.2174556513, 39971.0, 40328.79835600803, 38558.42162367511, 39181.41227881527, 39678.0, 40433.39349909813, 41641.79179104085, 37262.44106338353, 37967.43048854324, 38063.0, 38275.23449530938, 39621.00947476336, 32212.516812247366, 34577.48133778045, 34999.4750078744, 35087.29825403529, 35276.82361588176, 25839.612405814303, 25976.480470390863, 25978.35054123662, 26282.0, 26436.339091522867], "value": 19860.95122059671, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.261501548837, 325.8696521391443, 373.24418053441775, 377.83186482015515, 388.9226841648633, 17580.824191758096, 19420.0, 20469.897650511746, 20860.165593376245, 21621.567568648617, 16798.83201167988, 17443.389481368155, 20212.494687632818, 20610.48473788156, 20730.170793168254, 5816.796412125576, 5888.499477544403, 6141.385861413867, 6184.96907515464, 6197.380261973789, 5924.0, 6002.789902353418, 6068.57519973602, 6081.027035674293, 6085.087236914454, 5705.4579814917515, 5909.349971503131, 5947.553933454987, 6021.668808215546, 6029.336772954972, 5052.343195384595, 5126.256692779545, 6022.247219097613, 6038.305594856603, 6059.606125601822, 5077.543021128116, 5234.842954711365, 5241.895162096736, 5365.624406291561, 5432.674039557639, 12482.188657737219, 12645.304508252042, 12851.742965140646, 12882.67793305175, 12944.093913426064, 2091.602595506849, 2311.1217737259904, 2325.5116425550655, 2378.0012394794053, 2715.633389492413, 9718.61125554977, 9807.656732014417, 9823.115919567203, 10136.391816490961, 10171.79656406875, 1748.8076311605714, 1809.84616307614, 1845.2157832920955, 1861.7858946221222, 1899.1453845769458, 113648.86351136466, 114595.85404146019, 115662.42168789187, 125455.0, 129926.0, 9317.72046838596, 9517.904820951702, 11598.826017609743, 11634.36011019402, 11850.940745296219, 14436.9172312077, 14587.124772513684, 14591.41634334636, 14605.488807891672, 14631.0, 7163.928360716431, 8612.526311052952, 8687.695930642398, 8712.69505567302, 8759.2992560595, 8695.782605434915, 8728.519931403835, 8749.868751968726, 8833.160849719266, 8874.334424918157, 4543.636509079266, 4555.749433781174, 4558.0, 4597.839075632403, 4608.953910460919, 1643.9917800410922, 1925.1914196037699, 1932.7584051993501, 1965.0764140853776, 1965.6953172258322, 819.4182130687279, 836.6778790165708, 910.1614738228873, 980.7940332530106, 1010.1666125446536, 20551.177952882015, 21238.25666101679, 21335.893320533298, 21422.250221242182, 21454.78545214528, 902.4179404284331, 907.9636814527345, 927.2998885841147, 930.4459259333174, 1009.6213919780082, 10759.462026898624, 11083.889161108447, 11159.665210043711, 11167.83248251277, 11253.831192532118, 641640.0, 668750.0, 673974.0, 679992.0, 680619.0, 146234.0, 149134.25432872766, 154454.0, 155566.0, 156685.0, 784.6547519091581, 979.3976704326788, 998.6554638649654, 1000.8548760429843, 1007.1388962437157, 15143.924280378527, 19180.904095479993, 19602.411927642195, 19686.310979115664, 19704.91622960751, 47631.76184119057, 54547.45452545424, 58849.0, 60463.09305360511, 60480.0, 78000.0, 82752.0, 84179.15820841714, 86289.21422169056, 87338.0, 7671.3862890967475, 8082.070561885458, 8164.265216130577, 8239.505629662239, 8246.628901699318, 10693.465326733787, 12680.23918564889, 12737.0, 12788.168769029984, 13137.474501019853, 9657.806843863224, 10917.181211409335, 11048.613298534512, 11059.170562207706, 11551.537938482703, 8816.074312197126, 11078.390688512209, 11284.0, 11306.378149201873, 11402.258853174517, 11300.208985370946, 11344.546218151181, 11536.769264614828, 11655.41722913834, 11696.70758231051, 7849.568273744999, 7977.880331794911, 7987.600619969095, 8095.2714255717265, 8384.161583841811, 8275.337972962268, 9954.55204515813, 10249.436281004319, 11136.944315278372, 11140.33158010522], "value": 9405.170036290234, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1514.666773309872, 1538.653802894349, 1756.8506676932461, 1806.4309742431142, 1855.4711907106469, 8000.239977202171, 8250.0, 8518.190771876669, 9094.54527273636, 9123.361364704473, 6816.693248803804, 8793.252573531241, 8813.86779198311, 8917.73246802597, 8929.151730585583, 2377.9881100594516, 2390.4262976885598, 2423.1761201191593, 2423.9757602423924, 2427.0898413095088, 2165.372042107787, 2268.650153158876, 2435.926922192328, 2437.0373702387546, 2440.4752978109705, 2396.95206095878, 2405.1101092595763, 2419.9395015124587, 2430.3924018995253, 2431.9756802432016, 2391.390195500154, 2394.281715485356, 2403.9182367934413, 2405.879706014692, 2410.602250628644, 2242.4505996031075, 2378.4410663494064, 2400.2559206645997, 2406.554787364343, 2409.3856066703056, 7931.920680793176, 8208.58957052151, 9004.594793234255, 9019.549022548912, 9038.322125840523, 5320.707361095138, 5493.505584497414, 5497.8075767347955, 5516.365617953947, 5527.309086364205, 3627.5828279747902, 3633.1098880774116, 3660.670539651444, 3695.4826324314618, 3701.9634502339118, 1088.6516314779274, 1090.2041509697885, 1096.3641088168843, 1097.7859317433104, 1121.7027487715761, 9891.653792117313, 10011.59953601855, 11638.359890206035, 11781.646550603497, 11814.527418903319, 4119.7940102994735, 4751.572358487683, 4798.7840547175465, 4856.73287969158, 4957.785342591016, 10050.246231532665, 10147.49262536885, 10150.847737283946, 10155.238357123246, 10190.643327483502, 5421.105517589633, 5444.128939369682, 5446.21029950655, 5449.373322068013, 5470.234167216593, 4420.027593929331, 4544.295634176708, 4805.663603547788, 4932.630052746058, 4970.627202959792, 4039.8586049488126, 4055.8986025349013, 4133.400656904732, 4159.771212583277, 4172.374143878443, 1295.7149427126017, 1302.7524770293614, 1315.329182117108, 1317.7957416600443, 1322.6296636941672, 923.4690053219291, 929.2380248196414, 930.9022552631876, 934.5420743835472, 953.427943234054, 5810.651360918274, 5926.644401335933, 6108.969455152695, 6137.815865523952, 6142.078688196806, 438.903441242926, 444.97775111244954, 952.4523399045577, 997.8104160209537, 1063.441693111123, 3946.506686664167, 3972.880813575597, 4049.838006479708, 4084.7957602119777, 4234.703570750018, 10597.523111460003, 10978.670639880816, 11057.336559806437, 11061.281016733887, 11083.889161108447, 10816.351018938889, 10991.890081099247, 11000.724981875517, 11039.889601103887, 11044.950729680668, 8235.876461853077, 8329.958350208331, 8462.703805366906, 8490.0, 8531.274841638531, 5927.4665280125, 5932.466078052996, 6020.638761674139, 6025.728842202199, 6041.818745437644, 9877.259205559756, 10052.64815731446, 10194.949025254826, 10354.482275886327, 10355.844662330222, 10462.372257664565, 10575.259731819007, 10584.735381615521, 10621.681349559525, 10625.309354892217, 7001.929980700332, 7240.52936559122, 7468.290512401313, 7647.349975252166, 7802.141764406025, 8384.790380240298, 8613.353998450266, 8618.09510001466, 8661.566921654017, 8671.6097775599, 7466.664000120117, 7558.474593112342, 7604.429667774828, 7701.730439434593, 7712.035995500562, 7431.182569917197, 7494.100707915085, 7509.962450187714, 7650.770476885702, 7663.846723065396, 6952.165740111219, 7051.189113252041, 7101.893471598033, 7104.183018952886, 7115.359617634438, 4986.12742770021, 5027.296178534935, 5119.827340717304, 5237.450067742984, 5253.317068781034, 4256.808443619982, 5086.796528138833, 5135.922961155511, 5167.0, 5170.6380553360905], "value": 4644.1257234383775, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.33570117327804, 302.8955010521371, 311.65406398897227, 315.7063930544593, 315.805779445641, 4315.41741864849, 5455.290812194414, 5518.806841760539, 5555.777768889245, 5587.357453892803, 4715.622750179986, 4862.586680132193, 5158.819441319554, 5414.593905457087, 5549.278593782813, 3474.8957531274104, 4055.776932268724, 4156.605122513364, 4203.138356636882, 4235.639970602487, 3434.879779207728, 4062.796860156995, 4090.6931980101463, 4219.978900105511, 4224.085381087056, 4087.3460246360587, 4157.0, 4171.0, 4187.309093999486, 4205.537390887, 4160.105577300879, 4166.208420400114, 4174.853880114197, 4191.589835844402, 4194.049766858395, 3622.8913132606062, 3642.653947874974, 3668.1563240454843, 3678.9080272993124, 3685.1892583631557, 4897.142999975025, 5032.672876263031, 5233.2935053768015, 5395.946040539584, 5428.9185662215095, 3954.525456945185, 4383.145286669101, 4701.3653156824075, 4779.593734532569, 4779.832705855313, 5502.367227768817, 5790.507806836424, 5796.710299431743, 5802.361740208574, 5827.766889324422, 3563.3051554946796, 3749.5875453700073, 3863.536375634914, 3914.4911161549103, 3929.7249192556533, 5456.890862182774, 5610.887782244332, 6029.427204415573, 6101.389861013908, 6141.385861413823, 3408.897733068012, 3474.8957531274104, 3979.880603581897, 3982.542007669097, 4011.2378648056774, 3827.3302172119766, 3982.7212095153063, 4013.5585085640555, 4022.738521996061, 4044.5753195914003, 4752.405949256343, 4754.548317909862, 4757.619390448755, 4796.712197268175, 4799.616030717534, 5846.649201047866, 5897.734601942923, 5902.61632993854, 5969.552483481752, 6011.879762404727, 1190.8213767934878, 1241.9813702794465, 1243.8445194350707, 1332.3072002558615, 1338.2238301785137, 696.8084575376063, 796.7131832540397, 855.0936007831718, 919.9632014719471, 921.5898924978454, 4727.598154156866, 4758.191887082887, 5325.627206095536, 5328.0, 5383.4118934914295, 5588.574913397058, 5886.676232807236, 5911.113333000085, 5945.443459312451, 5994.613043630335, 4797.304390863305, 5029.673071250357, 5316.73416329182, 5386.7071902743055, 5413.242146099549, 2312.7742296582837, 2628.303499572615, 2638.8020898432696, 2675.622054641861, 2712.715164907696, 5139.0, 5252.29094072303, 5255.237990491358, 5256.2904007959205, 5304.681719096867, 4330.35044743291, 4605.746683932416, 5133.897322053538, 5167.0, 5189.870253243624, 4295.914081718348, 4956.504349565159, 4967.925481117786, 5223.033738758342, 5298.576113910878, 4457.7771111444945, 5042.924356134734, 5044.94056248192, 5120.718360490208, 5126.436092029949, 5008.84973450797, 5012.298278240976, 5196.870078248074, 6026.337102918587, 6052.818415447544, 6303.49572034227, 6341.3683321421095, 6381.074744161978, 6391.7123729433215, 6399.224457570056, 3983.6016398359934, 3997.7001724871334, 4005.9154451073096, 4007.495315427858, 4024.538896548907, 5029.9245511318095, 5288.9735551322, 5695.572832037531, 5964.612300200473, 6028.608140470856, 4758.357621721023, 4851.80592776285, 5047.536214497754, 5399.83800485986, 5552.972235138798, 5206.791728330824, 5214.0, 5588.161775733673, 5808.0, 5886.470217680429, 4517.819287228474, 5032.817287937259, 5319.25530425733, 5742.7702891883855, 5757.884842303214, 4841.305543059901, 5112.846614601568, 5500.50495455411, 5501.0, 5872.588918775645, 4786.617070634411, 5700.486956173964, 5732.398098199796, 5752.252207213036, 5800.274965629296], "value": 4087.116013130616, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.8142842146829, 749.3518106837583, 759.9202083781203, 789.7078081109989, 809.1503920883072, 13558.915286777059, 13926.234057126854, 15329.463468778595, 15955.042697438133, 16023.679526409465, 14417.92791036046, 14423.423063077464, 14446.855531444682, 14447.855521444782, 14526.0, 656.5010591950129, 680.625655889259, 811.4482152136545, 822.2271065198725, 842.2503971465401, 836.786619412049, 837.409626213518, 839.1566475691951, 842.540815255684, 844.5397258494105, 896.5338024227398, 901.2339511415311, 902.269161978796, 903.0472851142042, 904.0, 892.7009451833611, 896.0188593490118, 896.0501868019854, 897.4346161918015, 898.3531857062904, 641.4483544152025, 665.6106177885943, 665.9101021362103, 669.364104101101, 670.587588632992, 14980.625484362869, 15078.095314281178, 15201.391944322213, 15202.391904323813, 15219.315130819139, 14554.70890582193, 14899.404023839033, 14936.0, 14958.850411495854, 14964.251787410694, 11703.941480292544, 11738.119641026957, 11779.411029448493, 11894.82157767634, 12360.196587221802, 3274.7707660463775, 3897.0841852165004, 3909.4722212501233, 3939.5469521005166, 3969.980150099231, 125267.373663132, 125390.0, 128266.358668207, 132103.0, 132542.0, 11095.44522773858, 11350.14873884462, 11423.086153107732, 11520.051164696333, 11684.240524365889, 23434.882825585762, 23815.0, 24061.63907541388, 24283.0, 24356.147534836196, 7508.436867234979, 7760.883586746203, 7929.801754956172, 7989.960050199712, 8170.836583268301, 4382.9780851096175, 4413.426254586883, 4507.954920450819, 4562.087582483517, 4645.976770116128, 3395.422778127724, 3546.308469848355, 3554.2180720241504, 3557.48416479609, 3562.7684200526883, 555.2559570175983, 644.9226092868792, 651.6285717141184, 666.8532922756985, 680.306087790451, 497.31122395481793, 582.2750675409143, 589.0810335876047, 607.1378642327905, 626.5770604841714, 8663.393562450568, 8927.151920567536, 9085.13691199335, 9142.794533646833, 9192.494412807226, 477.6656340561621, 591.8165368735706, 617.7035023188895, 700.6671830880393, 702.7751119641767, 4552.84065057728, 4729.810807567727, 4753.144434001843, 4755.643326750507, 4767.451743049524, 129851.0, 132135.0, 133409.0, 133505.332473337, 138921.22157556794, 105192.47403762932, 110681.44659276652, 112233.0, 112368.43815780869, 115600.0, 94976.52511737397, 105202.94797051931, 105587.41618875723, 106296.46851765692, 114816.85183148061, 9521.967476529771, 9868.210543156387, 10062.849057264293, 10245.948770256102, 10256.435896025492, 63198.15608297546, 65658.0, 65962.01056984244, 66683.99974000297, 67227.32772672211, 97203.0, 98651.01348986418, 99420.00579994108, 100750.0, 103157.0, 13368.465261389436, 13583.728325433634, 14256.429742810586, 14300.784433323284, 14393.784093238819, 14635.34140963638, 14762.778558321419, 14921.62695932567, 15718.685626287639, 15918.8408115922, 13347.933260333637, 13827.0, 13913.373898174405, 14236.145831250158, 14862.777058344349, 13638.522651707142, 14257.287135643384, 14257.572272831832, 14358.712825743636, 15065.09609423438, 13926.303684815515, 13950.79073813914, 14037.789433158307, 14332.426702932184, 14479.420823166955, 11401.372924489233, 11412.54349826031, 11592.246503977214, 11729.296242225493, 11884.584039558575, 11417.257878237888, 11500.0, 11819.527218911147, 11822.704432389259, 11825.053995680497], "value": 7902.497028904147, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 119.0, 115.0, 133.0, 130.0, 117.0, 116.0, 119.0, 114.0, 144.0], "value": 121.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 113.0, 110.0, 145.0, 108.0, 114.0, 111.0, 109.0, 136.0, 115.0], "value": 121.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 195.0, 196.0, 196.0, 195.0, 192.0, 195.0, 193.0, 199.0, 191.0], "value": 195.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 59.0, 86.0, 59.0, 68.0, 70.0, 70.0, 106.0, 85.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 101.0, 89.0, 71.0, 72.0, 86.0, 74.0, 79.0, 66.0, 77.0], "value": 83.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 109.0, 77.0, 133.0, 73.0, 125.0, 132.0, 137.0, 86.0], "value": 102.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 103.0, 174.0, 174.0, 100.0, 99.0, 99.0, 101.0, 100.0, 99.0], "value": 114.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 95.0, 78.0, 79.0, 107.0, 109.0, 150.0, 129.0, 140.0, 152.0], "value": 113.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 56.0, 59.0, 50.0, 50.0, 82.0, 48.0, 49.0, 65.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 75.0, 69.0, 66.0, 77.0, 101.0, 101.0, 60.0, 82.0, 103.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 87.0, 82.0, 81.0, 75.0, 98.0, 106.0, 104.0, 105.0], "value": 90.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 150.0, 146.0, 149.0, 148.0, 142.0, 141.0, 141.0, 184.0, 166.0], "value": 151.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 159.0, 168.0, 166.0, 172.0, 166.0, 168.0, 172.0, 211.0, 165.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 66.0, 68.0, 68.0, 68.0, 66.0, 66.0, 66.0, 68.0], "value": 67.6, "unit": "score"}]}]} 19:21:26 INFO - Return code: 0 19:21:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:21:26 ERROR - # TBPL SUCCESS # 19:21:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:21:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:21:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:21:26 INFO - 2016-10-10 19:21:26.326 screenresolution[1668:10611] starting screenresolution argv=screenresolution get 19:21:26 INFO - 2016-10-10 19:21:26.329 screenresolution[1668:10611] Display 0: 1600x1200x32@60 19:21:26 INFO - 2016-10-10 19:21:26.334 screenresolution[1669:10614] starting screenresolution argv=screenresolution list 19:21:26 INFO - Available Modes on Display 0 19:21:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:21:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:21:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:21:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:21:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:21:26 INFO - Intel Iris: 19:21:26 INFO - Chipset Model: Intel Iris 19:21:26 INFO - Type: GPU 19:21:26 INFO - Bus: Built-In 19:21:26 INFO - VRAM (Dynamic, Max): 1536 MB 19:21:26 INFO - Vendor: Intel (0x8086) 19:21:26 INFO - Device ID: 0x0a2e 19:21:26 INFO - Revision ID: 0x0009 19:21:26 INFO - Displays: 19:21:26 INFO - Display: 19:21:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:21:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:21:26 INFO - Display Serial Number: 1600x1200 60 19:21:26 INFO - Main Display: Yes 19:21:26 INFO - Mirror: Off 19:21:26 INFO - Online: Yes 19:21:26 INFO - Rotation: Supported 19:21:26 INFO - Return code: 0 19:21:26 INFO - Running post-action listener: _resource_record_post_action 19:21:26 INFO - [mozharness: 2016-10-11 02:21:26.568957Z] Finished run-tests step (success) 19:21:26 INFO - Running post-run listener: _resource_record_post_run 19:21:26 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 37209088; Write bytes: 663194112; Read time: 392; Write time: 2015 19:21:26 INFO - TinderboxPrint: CPU usage
54.4% 19:21:26 INFO - TinderboxPrint: I/O read bytes / time
37,209,088 / 392 19:21:26 INFO - TinderboxPrint: I/O write bytes / time
663,194,112 / 2,015 19:21:26 INFO - TinderboxPrint: CPU idle
2,202.4 (45.6%) 19:21:26 INFO - TinderboxPrint: CPU system
974.7 (20.2%) 19:21:26 INFO - TinderboxPrint: CPU user
1,648.6 (34.2%) 19:21:26 INFO - TinderboxPrint: Swap in / out
400,109,568 / 0 19:21:26 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 361546240; Write bytes: 355497984; Read time: 27497; Write time: 769 19:21:26 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 30936064; Write bytes: 297509376; Read time: 306; Write time: 1211 19:21:27 INFO - Running post-run listener: _upload_blobber_files 19:21:27 INFO - Blob upload gear active. 19:21:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:21:27 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 19:21:27 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'] 19:21:27 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 19:21:27 INFO - (blobuploader) - INFO - Open directory for files ... 19:21:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:21:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:21:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:21:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:21:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:21:28 INFO - (blobuploader) - INFO - Done attempting. 19:21:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:21:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:21:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:21:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:21:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:21:29 INFO - (blobuploader) - INFO - Done attempting. 19:21:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:21:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:21:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:21:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:21:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:21:31 INFO - (blobuploader) - INFO - Done attempting. 19:21:31 INFO - (blobuploader) - INFO - Iteration through files over. 19:21:31 INFO - Return code: 0 19:21:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:21:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:21:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/675640917705c8b5b0e1a1312023b22dbe0e674cbf2fc125ac04a78e2dfeebc83102c5ebc0374c20701b659e97471f080f9e809ba824bfbe2a78ac8492c01b1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14a2c89f939ddb8126e8e7bcd6c91480bdd61366b47bb852bda0e85fb5893a38ff3db3125d9a37aab25e4dc6658d71988324b5f5ead863e57ba26ca60bd0feeb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/60f4a7bd9da76d69c6dad063bc7e0f44543a3dd1dd5f02315944a36d169673b801f8ad6ea0f93f69d74a3035fa884044d2e1742addcd9155d5a8768688021757"} 19:21:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:21:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:21:31 INFO - Contents: 19:21:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/675640917705c8b5b0e1a1312023b22dbe0e674cbf2fc125ac04a78e2dfeebc83102c5ebc0374c20701b659e97471f080f9e809ba824bfbe2a78ac8492c01b1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14a2c89f939ddb8126e8e7bcd6c91480bdd61366b47bb852bda0e85fb5893a38ff3db3125d9a37aab25e4dc6658d71988324b5f5ead863e57ba26ca60bd0feeb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/60f4a7bd9da76d69c6dad063bc7e0f44543a3dd1dd5f02315944a36d169673b801f8ad6ea0f93f69d74a3035fa884044d2e1742addcd9155d5a8768688021757"} 19:21:31 INFO - Running post-run listener: copy_logs_to_upload_dir 19:21:31 INFO - Copying logs to upload dir... 19:21:31 INFO - mkdir: /builds/slave/test/build/upload/logs 19:21:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.441389 ========= master_lag: 0.22 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-10-10 19:21:32.102312) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 19:21:32.106284) ========= 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.in4b5OJtvF/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.YuADeX9xq2/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/675640917705c8b5b0e1a1312023b22dbe0e674cbf2fc125ac04a78e2dfeebc83102c5ebc0374c20701b659e97471f080f9e809ba824bfbe2a78ac8492c01b1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14a2c89f939ddb8126e8e7bcd6c91480bdd61366b47bb852bda0e85fb5893a38ff3db3125d9a37aab25e4dc6658d71988324b5f5ead863e57ba26ca60bd0feeb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/60f4a7bd9da76d69c6dad063bc7e0f44543a3dd1dd5f02315944a36d169673b801f8ad6ea0f93f69d74a3035fa884044d2e1742addcd9155d5a8768688021757"} build_url:https://queue.taskcluster.net/v1/task/EznbjHdzRYS4XhDIL72sqA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010979 build_url: 'https://queue.taskcluster.net/v1/task/EznbjHdzRYS4XhDIL72sqA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/675640917705c8b5b0e1a1312023b22dbe0e674cbf2fc125ac04a78e2dfeebc83102c5ebc0374c20701b659e97471f080f9e809ba824bfbe2a78ac8492c01b1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14a2c89f939ddb8126e8e7bcd6c91480bdd61366b47bb852bda0e85fb5893a38ff3db3125d9a37aab25e4dc6658d71988324b5f5ead863e57ba26ca60bd0feeb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/60f4a7bd9da76d69c6dad063bc7e0f44543a3dd1dd5f02315944a36d169673b801f8ad6ea0f93f69d74a3035fa884044d2e1742addcd9155d5a8768688021757"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 19:21:32.144355) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 19:21:32.144793) ========= 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.in4b5OJtvF/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.YuADeX9xq2/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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.005102 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 19:21:32.196831) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 19:21:32.197527) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 19:21:32.198347) ========= ========= Total master_lag: 0.36 =========