builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0212 starttime: 1493153914.09 results: success (0) buildid: 20170425121125 builduid: d22eb63f8d9a4bf48c7edc3b0ffb56e9 revision: e20007000f8e56cefca0a93788be3ac05f0823fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 13:58:34.094067) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 13:58:34.094593) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 13:58:34.094924) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 13:58:34.125565) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 13:58:34.125975) ========= 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.z5LlEe3fFP/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.Cb4dvXcywe/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-25 13:58:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.6M=0.001s 2017-04-25 13:58:34 (18.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.107940 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 13:58:34.259598) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 13:58:34.259967) ========= 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.z5LlEe3fFP/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.Cb4dvXcywe/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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.027340 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 13:58:34.311711) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-25 13:58:34.312121) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e20007000f8e56cefca0a93788be3ac05f0823fc --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-beta --rev e20007000f8e56cefca0a93788be3ac05f0823fc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.z5LlEe3fFP/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.Cb4dvXcywe/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-25 13:58:34,427 truncating revision to first 12 chars 2017-04-25 13:58:34,427 Setting DEBUG logging. 2017-04-25 13:58:34,427 attempt 1/10 2017-04-25 13:58:34,427 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e20007000f8e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-25 13:58:36,274 unpacking tar archive at: mozilla-beta-e20007000f8e/testing/mozharness/ program finished with exit code 0 elapsedTime=2.120711 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-25 13:58:36.458189) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 13:58:36.458549) ========= script_repo_revision: e20007000f8e56cefca0a93788be3ac05f0823fc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 13:58:36.458981) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 13:58:36.459334) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 13:58:36.480646) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-04-25 13:58:36.480993) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.z5LlEe3fFP/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.Cb4dvXcywe/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 13:58:36 INFO - MultiFileLogger online at 20170425 13:58:36 in /builds/slave/test 13:58:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:58:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:58:36 INFO - {'append_to_log': False, 13:58:36 INFO - 'base_work_dir': '/builds/slave/test', 13:58:36 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:58:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:58:36 INFO - 'branch': 'Mozilla-Beta', 13:58:36 INFO - 'buildbot_json_path': 'buildprops.json', 13:58:36 INFO - 'config_files': ('talos/mac_config.py',), 13:58:36 INFO - 'default_actions': ('clobber', 13:58:36 INFO - 'read-buildbot-config', 13:58:36 INFO - 'download-and-extract', 13:58:36 INFO - 'populate-webroot', 13:58:36 INFO - 'create-virtualenv', 13:58:36 INFO - 'install', 13:58:36 INFO - 'run-tests'), 13:58:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:58:36 INFO - 'download_minidump_stackwalk': True, 13:58:36 INFO - 'download_symbols': 'ondemand', 13:58:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:58:36 INFO - 'tooltool.py': '/tools/tooltool.py', 13:58:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:58:36 INFO - '/tools/misc-python/virtualenv.py')}, 13:58:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:58:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:58:36 INFO - 'gecko_profile': False, 13:58:36 INFO - 'gecko_profile_interval': 0, 13:58:36 INFO - 'installer_path': 'installer.exe', 13:58:36 INFO - 'log_level': 'info', 13:58:36 INFO - 'log_name': 'talos', 13:58:36 INFO - 'log_to_console': True, 13:58:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:58:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:58:36 INFO - 'opt_config_files': (), 13:58:36 INFO - 'pip_index': False, 13:58:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:58:36 INFO - 'cmd': ('bash', 13:58:36 INFO - '-c', 13:58:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:58:36 INFO - 'enabled': True, 13:58:36 INFO - 'halt_on_failure': False, 13:58:36 INFO - 'name': 'check_screen_resolution'},), 13:58:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:58:36 INFO - 'cmd': ('bash', 13:58:36 INFO - '-c', 13:58:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:58:36 INFO - 'enabled': True, 13:58:36 INFO - 'halt_on_failure': False, 13:58:36 INFO - 'name': 'check_screen_resolution'},), 13:58:36 INFO - 'run_cmd_checks_enabled': True, 13:58:36 INFO - 'suite': 'dromaeojs', 13:58:36 INFO - 'system_bits': '32', 13:58:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:58:36 INFO - 'title': 't-yosemite-r7-0212', 13:58:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:58:36 INFO - 'use_talos_json': True, 13:58:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:58:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:58:36 INFO - 'work_dir': 'build'} 13:58:36 INFO - [mozharness: 2017-04-25 20:58:36.705448Z] Running clobber step. 13:58:36 INFO - Running pre-action listener: _resource_record_pre_action 13:58:36 INFO - Running main action method: clobber 13:58:36 INFO - rmtree: /builds/slave/test/build 13:58:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:58:39 INFO - Running post-action listener: _resource_record_post_action 13:58:39 INFO - [mozharness: 2017-04-25 20:58:39.143451Z] Finished clobber step (success) 13:58:39 INFO - [mozharness: 2017-04-25 20:58:39.143612Z] Running read-buildbot-config step. 13:58:39 INFO - Running pre-action listener: _resource_record_pre_action 13:58:39 INFO - Running main action method: read_buildbot_config 13:58:39 INFO - Using buildbot properties: 13:58:39 INFO - { 13:58:39 INFO - "project": "", 13:58:39 INFO - "product": "firefox", 13:58:39 INFO - "script_repo_revision": "production", 13:58:39 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 13:58:39 INFO - "repository": "", 13:58:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 13:58:39 INFO - "buildid": "20170425121125", 13:58:39 INFO - "pgo_build": "False", 13:58:39 INFO - "basedir": "/builds/slave/test", 13:58:39 INFO - "buildnumber": 11, 13:58:39 INFO - "slavename": "t-yosemite-r7-0212", 13:58:39 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 13:58:39 INFO - "platform": "yosemite_r7", 13:58:39 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:58:39 INFO - "branch": "mozilla-beta", 13:58:39 INFO - "repo_path": "releases/mozilla-beta", 13:58:39 INFO - "revision": "e20007000f8e56cefca0a93788be3ac05f0823fc", 13:58:39 INFO - "stage_platform": "macosx64", 13:58:39 INFO - "builduid": "d22eb63f8d9a4bf48c7edc3b0ffb56e9", 13:58:39 INFO - "slavebuilddir": "test" 13:58:39 INFO - } 13:58:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q4mLc-7iQ8yBVdYeRHtzeA/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 13:58:39 INFO - Running post-action listener: _resource_record_post_action 13:58:39 INFO - [mozharness: 2017-04-25 20:58:39.146911Z] Finished read-buildbot-config step (success) 13:58:39 INFO - [mozharness: 2017-04-25 20:58:39.147012Z] Running download-and-extract step. 13:58:39 INFO - Running pre-action listener: _resource_record_pre_action 13:58:39 INFO - Running main action method: download_and_extract 13:58:39 INFO - mkdir: /builds/slave/test/build/tests 13:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:39 INFO - trying https://queue.taskcluster.net/v1/task/Q4mLc-7iQ8yBVdYeRHtzeA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 13:58:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Q4mLc-7iQ8yBVdYeRHtzeA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 13:58:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q4mLc-7iQ8yBVdYeRHtzeA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 13:58:40 INFO - Downloaded 1165 bytes. 13:58:40 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 13:58:40 INFO - Using the following test package requirements: 13:58:40 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 13:58:40 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:58:40 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 13:58:40 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:58:40 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 13:58:40 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:58:40 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:58:40 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 13:58:40 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 13:58:40 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:58:40 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 13:58:40 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:58:40 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 13:58:40 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:58:40 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 13:58:40 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:58:40 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 13:58:40 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 13:58:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q4mLc-7iQ8yBVdYeRHtzeA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 13:58:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q4mLc-7iQ8yBVdYeRHtzeA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 13:58:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Q4mLc-7iQ8yBVdYeRHtzeA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 13:58:42 INFO - Expected file size: 51221480 13:58:42 INFO - Obtained file size: 51221480 13:58:57 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 13:58:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q4mLc-7iQ8yBVdYeRHtzeA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 13:58:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q4mLc-7iQ8yBVdYeRHtzeA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 13:58:57 INFO - Fetch https://queue.taskcluster.net/v1/task/Q4mLc-7iQ8yBVdYeRHtzeA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 13:58:59 INFO - Expected file size: 51221480 13:58:59 INFO - Obtained file size: 51221480 13:59:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q4mLc-7iQ8yBVdYeRHtzeA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 13:59:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q4mLc-7iQ8yBVdYeRHtzeA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 13:59:14 INFO - Fetch https://queue.taskcluster.net/v1/task/Q4mLc-7iQ8yBVdYeRHtzeA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 13:59:15 INFO - Expected file size: 14404449 13:59:15 INFO - Obtained file size: 14404449 13:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:16 INFO - trying https://queue.taskcluster.net/v1/task/Q4mLc-7iQ8yBVdYeRHtzeA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 13:59:16 INFO - Downloading https://queue.taskcluster.net/v1/task/Q4mLc-7iQ8yBVdYeRHtzeA/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 13:59:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q4mLc-7iQ8yBVdYeRHtzeA/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 13:59:18 INFO - Downloaded 59533591 bytes. 13:59:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q4mLc-7iQ8yBVdYeRHtzeA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 13:59:18 INFO - mkdir: /builds/slave/test/properties 13:59:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:59:18 INFO - Writing to file /builds/slave/test/properties/build_url 13:59:18 INFO - Contents: 13:59:18 INFO - build_url:https://queue.taskcluster.net/v1/task/Q4mLc-7iQ8yBVdYeRHtzeA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 13:59:18 INFO - Running post-action listener: _resource_record_post_action 13:59:18 INFO - Running post-action listener: set_extra_try_arguments 13:59:18 INFO - [mozharness: 2017-04-25 20:59:18.682113Z] Finished download-and-extract step (success) 13:59:18 INFO - [mozharness: 2017-04-25 20:59:18.682251Z] Running populate-webroot step. 13:59:18 INFO - Running pre-action listener: _resource_record_pre_action 13:59:18 INFO - Running main action method: populate_webroot 13:59:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:59:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:59:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:59:18 INFO - '--tppagecycles', 13:59:18 INFO - '7'], 13:59:18 INFO - 'tests': ['tsvgm']}}, 13:59:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:59:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:59:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:59:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:59:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:59:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:59:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:59:18 INFO - 'talos_options': ['--disable-e10s'], 13:59:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:59:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:59:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:59:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:59:18 INFO - 'talos_options': ['--disable-e10s'], 13:59:18 INFO - 'tests': ['damp', 'tps']}, 13:59:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:59:18 INFO - 'tests': ['damp', 'tps']}, 13:59:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:59:18 INFO - 'tests': ['dromaeo_dom']}, 13:59:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:59:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:59:18 INFO - 'tests': ['basic_compositor_video']}, 13:59:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:59:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:59:18 INFO - 'tests': ['a11yr', 13:59:18 INFO - 'ts_paint', 13:59:18 INFO - 'tpaint', 13:59:18 INFO - 'sessionrestore', 13:59:18 INFO - 'sessionrestore_no_auto_restore', 13:59:18 INFO - 'tabpaint']}, 13:59:18 INFO - 'other-e10s': {'tests': ['a11yr', 13:59:18 INFO - 'ts_paint', 13:59:18 INFO - 'tpaint', 13:59:18 INFO - 'sessionrestore', 13:59:18 INFO - 'sessionrestore_no_auto_restore', 13:59:18 INFO - 'tabpaint']}, 13:59:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:59:18 INFO - 'ts_paint', 13:59:18 INFO - 'tpaint', 13:59:18 INFO - 'sessionrestore', 13:59:18 INFO - 'sessionrestore_no_auto_restore', 13:59:18 INFO - 'tabpaint']}, 13:59:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:59:18 INFO - 'ts_paint', 13:59:18 INFO - 'tpaint', 13:59:18 INFO - 'sessionrestore', 13:59:18 INFO - 'sessionrestore_no_auto_restore', 13:59:18 INFO - 'tabpaint']}, 13:59:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:59:18 INFO - 'tests': ['a11yr', 13:59:18 INFO - 'ts_paint', 13:59:18 INFO - 'tpaint', 13:59:18 INFO - 'sessionrestore', 13:59:18 INFO - 'sessionrestore_no_auto_restore', 13:59:18 INFO - 'tabpaint']}, 13:59:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:59:18 INFO - 'tests': ['a11yr', 13:59:18 INFO - 'ts_paint', 13:59:18 INFO - 'tpaint', 13:59:18 INFO - 'sessionrestore', 13:59:18 INFO - 'sessionrestore_no_auto_restore', 13:59:18 INFO - 'tabpaint']}, 13:59:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:59:18 INFO - 'tests': ['tsvgx', 13:59:18 INFO - 'tsvgr_opacity', 13:59:18 INFO - 'tart', 13:59:18 INFO - 'tscrollx', 13:59:18 INFO - 'cart', 13:59:18 INFO - 'tsvg_static']}, 13:59:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:59:18 INFO - 'tsvgr_opacity', 13:59:18 INFO - 'tart', 13:59:18 INFO - 'tscrollx', 13:59:18 INFO - 'cart', 13:59:18 INFO - 'tsvg_static']}, 13:59:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:59:18 INFO - 'talos_options': ['--disable-e10s'], 13:59:18 INFO - 'tests': ['tp5o']}, 13:59:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:59:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:59:18 INFO - 'talos_options': ['--disable-e10s', 13:59:18 INFO - '--xperf_path', 13:59:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:59:18 INFO - 'tests': ['tp5n']}, 13:59:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:59:18 INFO - 'talos_options': ['--xperf_path', 13:59:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:59:18 INFO - 'tests': ['tp5n']}}, 13:59:18 INFO - 'talos.zip': {'path': '', 13:59:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:59:18 INFO - Running post-action listener: _resource_record_post_action 13:59:18 INFO - [mozharness: 2017-04-25 20:59:18.700615Z] Finished populate-webroot step (success) 13:59:18 INFO - [mozharness: 2017-04-25 20:59:18.700731Z] Running create-virtualenv step. 13:59:18 INFO - Running pre-action listener: _resource_record_pre_action 13:59:18 INFO - Running main action method: create_virtualenv 13:59:18 INFO - Creating virtualenv /builds/slave/test/build/venv 13:59:18 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 13:59:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:59:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:59:18 INFO - Using real prefix '/tools/python27' 13:59:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:59:19 INFO - Installing distribute.............................................................................................................................................................................................done. 13:59:22 INFO - Installing pip.................done. 13:59:22 INFO - Return code: 0 13:59:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:59:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:59:22 INFO - Reading from file tmpfile_stdout 13:59:22 INFO - Output received: 13:59:22 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:59:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:59:22 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')]} 13:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:22 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')]} 13:59:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:22 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 0x1030ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6eb595c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ebbd30>, '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 0x102de2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eb0be8>, '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.z5LlEe3fFP/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.Cb4dvXcywe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 13:59:22 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 13:59:22 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 13:59:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5LlEe3fFP/Render', 13:59:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:22 INFO - 'HOME': '/Users/cltbld', 13:59:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:22 INFO - 'LOGNAME': 'cltbld', 13:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:22 INFO - 'MOZ_NO_REMOTE': '1', 13:59:22 INFO - 'NO_EM_RESTART': '1', 13:59:22 INFO - 'PAGER': '/bin/cat', 13:59:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:22 INFO - 'PWD': '/builds/slave/test', 13:59:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:22 INFO - 'SHELL': '/bin/bash', 13:59:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cb4dvXcywe/Listeners', 13:59:22 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 13:59:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:22 INFO - 'USER': 'cltbld', 13:59:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:22 INFO - 'XPC_FLAGS': '0x0', 13:59:22 INFO - 'XPC_SERVICE_NAME': '0', 13:59:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:22 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 13:59:22 INFO - Cleaning up... 13:59:23 INFO - Return code: 0 13:59:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1030ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6eb595c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ebbd30>, '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 0x102de2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eb0be8>, '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.z5LlEe3fFP/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.Cb4dvXcywe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 13:59:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:59:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:59:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5LlEe3fFP/Render', 13:59:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:23 INFO - 'HOME': '/Users/cltbld', 13:59:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:23 INFO - 'LOGNAME': 'cltbld', 13:59:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:23 INFO - 'MOZ_NO_REMOTE': '1', 13:59:23 INFO - 'NO_EM_RESTART': '1', 13:59:23 INFO - 'PAGER': '/bin/cat', 13:59:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:23 INFO - 'PWD': '/builds/slave/test', 13:59:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:23 INFO - 'SHELL': '/bin/bash', 13:59:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cb4dvXcywe/Listeners', 13:59:23 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 13:59:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:23 INFO - 'USER': 'cltbld', 13:59:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:23 INFO - 'XPC_FLAGS': '0x0', 13:59:23 INFO - 'XPC_SERVICE_NAME': '0', 13:59:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:24 INFO - Downloading/unpacking psutil>=3.1.1 13:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:59:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:59:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:59:27 INFO - Installing collected packages: psutil 13:59:27 INFO - Running setup.py install for psutil 13:59:27 INFO - building 'psutil._psutil_osx' extension 13:59:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:59:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 13:59:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 13:59:28 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 13:59:28 INFO - building 'psutil._psutil_posix' extension 13:59:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 13:59:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:59:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:59:28 INFO - ^ 13:59:28 INFO - 1 warning generated. 13:59:28 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 13:59:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:59:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:59:28 INFO - Successfully installed psutil 13:59:28 INFO - Cleaning up... 13:59:29 INFO - Return code: 0 13:59:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:59:29 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')]} 13:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:29 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')]} 13:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:29 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 0x1030ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6eb595c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ebbd30>, '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 0x102de2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eb0be8>, '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.z5LlEe3fFP/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.Cb4dvXcywe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 13:59:29 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 13:59:29 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 13:59:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5LlEe3fFP/Render', 13:59:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:29 INFO - 'HOME': '/Users/cltbld', 13:59:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:29 INFO - 'LOGNAME': 'cltbld', 13:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:29 INFO - 'MOZ_NO_REMOTE': '1', 13:59:29 INFO - 'NO_EM_RESTART': '1', 13:59:29 INFO - 'PAGER': '/bin/cat', 13:59:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:29 INFO - 'PWD': '/builds/slave/test', 13:59:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:29 INFO - 'SHELL': '/bin/bash', 13:59:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cb4dvXcywe/Listeners', 13:59:29 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 13:59:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:29 INFO - 'USER': 'cltbld', 13:59:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:29 INFO - 'XPC_FLAGS': '0x0', 13:59:29 INFO - 'XPC_SERVICE_NAME': '0', 13:59:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:59:29 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 13:59:29 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 13:59:29 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 13:59:29 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 13:59:29 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 13:59:29 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 13:59:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:59:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:59:32 INFO - Installing collected packages: mozsystemmonitor 13:59:32 INFO - Running setup.py install for mozsystemmonitor 13:59:32 INFO - Successfully installed mozsystemmonitor 13:59:32 INFO - Cleaning up... 13:59:32 INFO - Return code: 0 13:59:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:59:32 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')]} 13:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:32 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')]} 13:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:32 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 0x1030ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6eb595c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ebbd30>, '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 0x102de2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eb0be8>, '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.z5LlEe3fFP/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.Cb4dvXcywe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 13:59:32 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 13:59:32 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 13:59:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5LlEe3fFP/Render', 13:59:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:32 INFO - 'HOME': '/Users/cltbld', 13:59:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:32 INFO - 'LOGNAME': 'cltbld', 13:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:32 INFO - 'MOZ_NO_REMOTE': '1', 13:59:32 INFO - 'NO_EM_RESTART': '1', 13:59:32 INFO - 'PAGER': '/bin/cat', 13:59:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:32 INFO - 'PWD': '/builds/slave/test', 13:59:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:32 INFO - 'SHELL': '/bin/bash', 13:59:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cb4dvXcywe/Listeners', 13:59:32 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 13:59:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:32 INFO - 'USER': 'cltbld', 13:59:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:32 INFO - 'XPC_FLAGS': '0x0', 13:59:32 INFO - 'XPC_SERVICE_NAME': '0', 13:59:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:32 INFO - Downloading/unpacking jsonschema==2.5.1 13:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:59:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:59:35 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 13:59:35 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 13:59:35 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 13:59:35 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 13:59:35 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 13:59:35 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 13:59:35 INFO - Downloading functools32-3.2.3-2.tar.gz 13:59:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:59:36 INFO - warning: no files found matching '*.txt' 13:59:36 INFO - no previously-included directories found matching 'build' 13:59:36 INFO - no previously-included directories found matching 'dist' 13:59:36 INFO - no previously-included directories found matching '.git*' 13:59:36 INFO - Installing collected packages: jsonschema, functools32 13:59:36 INFO - Running setup.py install for functools32 13:59:36 INFO - warning: no files found matching '*.txt' 13:59:36 INFO - no previously-included directories found matching 'build' 13:59:36 INFO - no previously-included directories found matching 'dist' 13:59:36 INFO - no previously-included directories found matching '.git*' 13:59:36 INFO - Successfully installed jsonschema functools32 13:59:36 INFO - Cleaning up... 13:59:36 INFO - Return code: 0 13:59:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:59:36 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')]} 13:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:36 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')]} 13:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:36 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 0x1030ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6eb595c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ebbd30>, '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 0x102de2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eb0be8>, '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.z5LlEe3fFP/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.Cb4dvXcywe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 13:59:36 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 13:59:36 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 13:59:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5LlEe3fFP/Render', 13:59:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:36 INFO - 'HOME': '/Users/cltbld', 13:59:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:36 INFO - 'LOGNAME': 'cltbld', 13:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:36 INFO - 'MOZ_NO_REMOTE': '1', 13:59:36 INFO - 'NO_EM_RESTART': '1', 13:59:36 INFO - 'PAGER': '/bin/cat', 13:59:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:36 INFO - 'PWD': '/builds/slave/test', 13:59:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:36 INFO - 'SHELL': '/bin/bash', 13:59:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cb4dvXcywe/Listeners', 13:59:36 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 13:59:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:36 INFO - 'USER': 'cltbld', 13:59:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:36 INFO - 'XPC_FLAGS': '0x0', 13:59:36 INFO - 'XPC_SERVICE_NAME': '0', 13:59:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:59:36 INFO - Cleaning up... 13:59:36 INFO - Return code: 0 13:59:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:59:36 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')]} 13:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:36 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')]} 13:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:36 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 0x1030ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6eb595c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ebbd30>, '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 0x102de2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eb0be8>, '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.z5LlEe3fFP/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.Cb4dvXcywe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 13:59:36 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 13:59:36 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 13:59:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5LlEe3fFP/Render', 13:59:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:36 INFO - 'HOME': '/Users/cltbld', 13:59:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:36 INFO - 'LOGNAME': 'cltbld', 13:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:36 INFO - 'MOZ_NO_REMOTE': '1', 13:59:36 INFO - 'NO_EM_RESTART': '1', 13:59:36 INFO - 'PAGER': '/bin/cat', 13:59:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:36 INFO - 'PWD': '/builds/slave/test', 13:59:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:36 INFO - 'SHELL': '/bin/bash', 13:59:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cb4dvXcywe/Listeners', 13:59:36 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 13:59:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:36 INFO - 'USER': 'cltbld', 13:59:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:36 INFO - 'XPC_FLAGS': '0x0', 13:59:36 INFO - 'XPC_SERVICE_NAME': '0', 13:59:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:36 INFO - Downloading/unpacking blobuploader==1.2.4 13:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:39 INFO - Downloading blobuploader-1.2.4.tar.gz 13:59:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:59:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:59:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:59:40 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 13:59:40 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 13:59:40 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 13:59:40 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 13:59:40 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 13:59:40 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 13:59:40 INFO - Downloading docopt-0.6.1.tar.gz 13:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:59:40 INFO - Installing collected packages: blobuploader, requests, docopt 13:59:40 INFO - Running setup.py install for blobuploader 13:59:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:59:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:59:40 INFO - Running setup.py install for requests 13:59:41 INFO - Running setup.py install for docopt 13:59:41 INFO - Successfully installed blobuploader requests docopt 13:59:41 INFO - Cleaning up... 13:59:41 INFO - Return code: 0 13:59:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:41 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 0x1030ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6eb595c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ebbd30>, '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 0x102de2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eb0be8>, '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.z5LlEe3fFP/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.Cb4dvXcywe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 13:59:41 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 13:59:41 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 13:59:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5LlEe3fFP/Render', 13:59:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:41 INFO - 'HOME': '/Users/cltbld', 13:59:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:41 INFO - 'LOGNAME': 'cltbld', 13:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:41 INFO - 'MOZ_NO_REMOTE': '1', 13:59:41 INFO - 'NO_EM_RESTART': '1', 13:59:41 INFO - 'PAGER': '/bin/cat', 13:59:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:41 INFO - 'PWD': '/builds/slave/test', 13:59:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:41 INFO - 'SHELL': '/bin/bash', 13:59:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cb4dvXcywe/Listeners', 13:59:41 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 13:59:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:41 INFO - 'USER': 'cltbld', 13:59:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:41 INFO - 'XPC_FLAGS': '0x0', 13:59:41 INFO - 'XPC_SERVICE_NAME': '0', 13:59:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:59:41 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-omsh5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:59:42 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-5DVzgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:59:42 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-7mlezX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:59:42 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-lAyrlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:59:42 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-2uRLUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:59:42 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-AWW2hd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:59:42 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-oR8JIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:59:42 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-2qVMiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:59:42 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-JcxUDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:59:42 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-c1pn0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:59:42 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-DoJrAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:59:43 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-kWofTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:59:43 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-yIKbZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:59:43 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-Qfu4hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:59:43 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-8ev8Ls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:59:43 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-zhmkjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:59:43 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-U1DWRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:59:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:59:43 INFO - Running setup.py install for manifestparser 13:59:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:59:43 INFO - Running setup.py install for mozcrash 13:59:43 INFO - Running setup.py install for mozdebug 13:59:44 INFO - Running setup.py install for mozdevice 13:59:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:59:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:59:44 INFO - Running setup.py install for mozfile 13:59:44 INFO - Running setup.py install for mozhttpd 13:59:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:59:44 INFO - Running setup.py install for mozinfo 13:59:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:59:44 INFO - Running setup.py install for mozInstall 13:59:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:59:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:59:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:59:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:59:44 INFO - Running setup.py install for mozleak 13:59:44 INFO - Running setup.py install for mozlog 13:59:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:59:45 INFO - Running setup.py install for moznetwork 13:59:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:59:45 INFO - Running setup.py install for mozprocess 13:59:45 INFO - Running setup.py install for mozprofile 13:59:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:59:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:59:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:59:45 INFO - Running setup.py install for mozrunner 13:59:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:59:45 INFO - Running setup.py install for mozscreenshot 13:59:45 INFO - Running setup.py install for moztest 13:59:46 INFO - Running setup.py install for mozversion 13:59:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:59:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:59:46 INFO - Cleaning up... 13:59:46 INFO - Return code: 0 13:59:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:59:46 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')]} 13:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:46 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')]} 13:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:46 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 0x1030ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6eb595c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ebbd30>, '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 0x102de2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eb0be8>, '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.z5LlEe3fFP/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.Cb4dvXcywe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 13:59:46 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 13:59:46 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 13:59:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5LlEe3fFP/Render', 13:59:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:46 INFO - 'HOME': '/Users/cltbld', 13:59:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:46 INFO - 'LOGNAME': 'cltbld', 13:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:46 INFO - 'MOZ_NO_REMOTE': '1', 13:59:46 INFO - 'NO_EM_RESTART': '1', 13:59:46 INFO - 'PAGER': '/bin/cat', 13:59:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:46 INFO - 'PWD': '/builds/slave/test', 13:59:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:46 INFO - 'SHELL': '/bin/bash', 13:59:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cb4dvXcywe/Listeners', 13:59:46 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 13:59:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:46 INFO - 'USER': 'cltbld', 13:59:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:46 INFO - 'XPC_FLAGS': '0x0', 13:59:46 INFO - 'XPC_SERVICE_NAME': '0', 13:59:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:59:46 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-qYX6gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:59:46 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)) 13:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:59:46 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-fIKU_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:59:46 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-dR3zJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:59:46 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-79GrmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:59:46 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-5NxQBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:59:47 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)) 13:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:59:47 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-HjPvSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:59:47 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)) 13:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:59:47 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-PFIWVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:59:47 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)) 13:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:59:47 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-juNrnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:59:47 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)) 13:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:59:47 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-ctHDMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:59:47 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)) 13:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:59:47 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-T6sqnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:59:47 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)) 13:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:59:47 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-2UzjwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:59:47 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)) 13:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:59:47 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-7liHQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:59:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 13:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:59:47 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-Zehwkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:59:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:59:47 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-gU_uTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:59:48 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-k8CKGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:59:48 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)) 13:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:59:48 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-gN6Gbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:59:48 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-X5ISV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:59:48 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)) 13:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:59:48 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)) 13:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:59:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:59:48 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 13:59:48 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 13:59:48 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 13:59:48 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 13:59:48 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 13:59:48 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 13:59:50 INFO - Downloading blessings-1.6.tar.gz 13:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:59:51 INFO - Installing collected packages: blessings 13:59:51 INFO - Running setup.py install for blessings 13:59:51 INFO - Successfully installed blessings 13:59:51 INFO - Cleaning up... 13:59:51 INFO - Return code: 0 13:59:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:59:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:59:51 INFO - Reading from file tmpfile_stdout 13:59:51 INFO - Current package versions: 13:59:51 INFO - blessings == 1.6 13:59:51 INFO - blobuploader == 1.2.4 13:59:51 INFO - docopt == 0.6.1 13:59:51 INFO - functools32 == 3.2.3-2 13:59:51 INFO - jsonschema == 2.5.1 13:59:51 INFO - manifestparser == 1.1 13:59:51 INFO - mozInstall == 1.12 13:59:51 INFO - mozcrash == 1.0 13:59:51 INFO - mozdebug == 0.1 13:59:51 INFO - mozdevice == 0.49 13:59:51 INFO - mozfile == 1.2 13:59:51 INFO - mozhttpd == 0.7 13:59:51 INFO - mozinfo == 0.9 13:59:51 INFO - mozleak == 0.1 13:59:51 INFO - mozlog == 3.4 13:59:51 INFO - moznetwork == 0.27 13:59:51 INFO - mozprocess == 0.25 13:59:51 INFO - mozprofile == 0.28 13:59:51 INFO - mozrunner == 6.13 13:59:51 INFO - mozscreenshot == 0.1 13:59:51 INFO - mozsystemmonitor == 0.3 13:59:51 INFO - moztest == 0.8 13:59:51 INFO - mozversion == 1.4 13:59:51 INFO - psutil == 3.1.1 13:59:51 INFO - requests == 1.2.3 13:59:51 INFO - wsgiref == 0.1.2 13:59:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:59: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')]} 13:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59: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')]} 13:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:51 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 0x1030ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6eb595c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ebbd30>, '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 0x102de2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eb0be8>, '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.z5LlEe3fFP/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.Cb4dvXcywe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 13:59:51 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 13:59:51 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 13:59:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5LlEe3fFP/Render', 13:59:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:51 INFO - 'HOME': '/Users/cltbld', 13:59:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:51 INFO - 'LOGNAME': 'cltbld', 13:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:51 INFO - 'MOZ_NO_REMOTE': '1', 13:59:51 INFO - 'NO_EM_RESTART': '1', 13:59:51 INFO - 'PAGER': '/bin/cat', 13:59:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:51 INFO - 'PWD': '/builds/slave/test', 13:59:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:51 INFO - 'SHELL': '/bin/bash', 13:59:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cb4dvXcywe/Listeners', 13:59:51 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 13:59:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:51 INFO - 'USER': 'cltbld', 13:59:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:51 INFO - 'XPC_FLAGS': '0x0', 13:59:51 INFO - 'XPC_SERVICE_NAME': '0', 13:59:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:59:51 INFO - Cleaning up... 13:59:51 INFO - Return code: 0 13:59:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:59: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')]} 13:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59: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')]} 13:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1030ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6eb595c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ebbd30>, '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 0x102de2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eb0be8>, '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.z5LlEe3fFP/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.Cb4dvXcywe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 13:59:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:59:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5LlEe3fFP/Render', 13:59:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:51 INFO - 'HOME': '/Users/cltbld', 13:59:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:51 INFO - 'LOGNAME': 'cltbld', 13:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:51 INFO - 'MOZ_NO_REMOTE': '1', 13:59:51 INFO - 'NO_EM_RESTART': '1', 13:59:51 INFO - 'PAGER': '/bin/cat', 13:59:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:51 INFO - 'PWD': '/builds/slave/test', 13:59:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:51 INFO - 'SHELL': '/bin/bash', 13:59:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cb4dvXcywe/Listeners', 13:59:51 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 13:59:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:51 INFO - 'USER': 'cltbld', 13:59:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:51 INFO - 'XPC_FLAGS': '0x0', 13:59:51 INFO - 'XPC_SERVICE_NAME': '0', 13:59:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:59:52 INFO - Cleaning up... 13:59:52 INFO - Return code: 0 13:59:52 INFO - Running post-action listener: _resource_record_post_action 13:59:52 INFO - Running post-action listener: _start_resource_monitoring 13:59:52 INFO - Starting resource monitoring. 13:59:52 INFO - [mozharness: 2017-04-25 20:59:52.122560Z] Finished create-virtualenv step (success) 13:59:52 INFO - [mozharness: 2017-04-25 20:59:52.123541Z] Running install step. 13:59:52 INFO - Running pre-action listener: _resource_record_pre_action 13:59:52 INFO - Running main action method: install 13:59:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:59:52 INFO - Reading from file tmpfile_stdout 13:59:52 INFO - Detecting whether we're running mozinstall >=1.0... 13:59:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:59:52 INFO - Reading from file tmpfile_stdout 13:59:52 INFO - Output received: 13:59:52 INFO - Usage: mozinstall [options] installer 13:59:52 INFO - Options: 13:59:52 INFO - -h, --help show this help message and exit 13:59:52 INFO - -d DEST, --destination=DEST 13:59:52 INFO - Directory to install application into. [default: 13:59:52 INFO - "/builds/slave/test"] 13:59:52 INFO - --app=APP Application being installed. [default: firefox] 13:59:52 INFO - mkdir: /builds/slave/test/build/application 13:59:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:00:07 INFO - Reading from file tmpfile_stdout 14:00:07 INFO - Output received: 14:00:07 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:00:07 INFO - Running post-action listener: _resource_record_post_action 14:00:07 INFO - [mozharness: 2017-04-25 21:00:07.202214Z] Finished install step (success) 14:00:07 INFO - [mozharness: 2017-04-25 21:00:07.202334Z] Running run-tests step. 14:00:07 INFO - Running pre-action listener: _resource_record_pre_action 14:00:07 INFO - Running main action method: run_tests 14:00:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:00:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:00:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:00:07 INFO - 2017-04-25 14:00:07.216 screenresolution[1629:7604] starting screenresolution argv=screenresolution get 14:00:07 INFO - 2017-04-25 14:00:07.219 screenresolution[1629:7604] Display 0: 1600x1200x32@60 14:00:07 INFO - 2017-04-25 14:00:07.225 screenresolution[1630:7606] starting screenresolution argv=screenresolution list 14:00:07 INFO - Available Modes on Display 0 14:00:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:00:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:00:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:00:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:00:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:00:07 INFO - Intel Iris: 14:00:07 INFO - Chipset Model: Intel Iris 14:00:07 INFO - Type: GPU 14:00:07 INFO - Bus: Built-In 14:00:07 INFO - VRAM (Dynamic, Max): 1536 MB 14:00:07 INFO - Vendor: Intel (0x8086) 14:00:07 INFO - Device ID: 0x0a2e 14:00:07 INFO - Revision ID: 0x0009 14:00:07 INFO - Displays: 14:00:07 INFO - Display: 14:00:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:00:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:00:07 INFO - Display Serial Number: 1600x1200 60 14:00:07 INFO - Main Display: Yes 14:00:07 INFO - Mirror: Off 14:00:07 INFO - Online: Yes 14:00:07 INFO - Rotation: Supported 14:00:07 INFO - Return code: 0 14:00:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:00:07 INFO - Python 2.7.3 14:00:07 INFO - Return code: 0 14:00:07 INFO - grabbing minidump binary from tooltool 14:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:07 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ebbd30>, '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 0x102de2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eb0be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:00:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:00:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:00:07 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:00:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:00:07 INFO - Return code: 0 14:00:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:00:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:00:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:00:07 INFO - ENV: RUST_BACKTRACE is now 1 14:00:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:00:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:00:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q4mLc-7iQ8yBVdYeRHtzeA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0212', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q4mLc-7iQ8yBVdYeRHtzeA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0212 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:00:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5LlEe3fFP/Render', 14:00:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:00:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:00:07 INFO - 'HOME': '/Users/cltbld', 14:00:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:00:07 INFO - 'LOGNAME': 'cltbld', 14:00:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:00:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:07 INFO - 'MOZ_NO_REMOTE': '1', 14:00:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:00:07 INFO - 'NO_EM_RESTART': '1', 14:00:07 INFO - 'PAGER': '/bin/cat', 14:00:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:07 INFO - 'PWD': '/builds/slave/test', 14:00:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:00:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:00:07 INFO - 'RUST_BACKTRACE': '1', 14:00:07 INFO - 'SHELL': '/bin/bash', 14:00:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cb4dvXcywe/Listeners', 14:00:07 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 14:00:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:00:07 INFO - 'USER': 'cltbld', 14:00:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:00:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:07 INFO - 'XPC_FLAGS': '0x0', 14:00:07 INFO - 'XPC_SERVICE_NAME': '0', 14:00:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:00:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q4mLc-7iQ8yBVdYeRHtzeA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0212', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:00:07 INFO - mozversion application_buildid: 20170425121125 14:00:07 INFO - mozversion application_changeset: e20007000f8e56cefca0a93788be3ac05f0823fc 14:00:07 INFO - mozversion application_display_name: Firefox 14:00:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:00:07 INFO - mozversion application_name: Firefox 14:00:07 INFO - mozversion application_remotingname: firefox 14:00:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:00:07 INFO - mozversion application_vendor: Mozilla 14:00:07 INFO - mozversion application_version: 54.0 14:00:07 INFO - mozversion platform_buildid: 20170425121125 14:00:07 INFO - mozversion platform_changeset: e20007000f8e56cefca0a93788be3ac05f0823fc 14:00:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:00:07 INFO - mozversion platform_version: 54.0 14:00:07 INFO - using testdate: 1493154007 14:00:07 INFO - actual date: 1493154007 14:00:07 INFO - starting webserver on 'localhost:49251' 14:00:07 INFO - SUITE-START | Running 2 tests 14:00:07 INFO - TEST-START | dromaeo_css 14:00:07 INFO - operating with platform_type : mac_ 14:00:07 INFO - Initialising browser for dromaeo_css test... 14:00:07 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmph24HPZ/profile http://localhost:49251/getInfo.html) 14:00:10 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 14:00:10 INFO - PROCESS | 1640 | colorDepth:24 14:00:10 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 14:00:10 INFO - PROCESS | 1640 | __metrics 14:00:10 INFO - PROCESS | 1640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:00:10 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:00:11 INFO - TEST-INFO | 1640: exit 0 14:00:11 INFO - Browser initialized. 14:00:11 INFO - Running cycle 1/1 for dromaeo_css test... 14:00:11 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmph24HPZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:00:23 INFO - PROCESS | 1646 | RSS: Main: 165220352 14:00:23 INFO - PROCESS | 1646 | 14:03:27 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49251/tests/dromaeo/cssquery-ext.html) 14:03:28 INFO - PROCESS | 1646 | RSS: Main: 301023232 14:03:28 INFO - PROCESS | 1646 | 14:06:31 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-ext.html (next: http://localhost:49251/tests/dromaeo/cssquery-jquery.html) 14:06:32 INFO - PROCESS | 1646 | RSS: Main: 302538752 14:06:32 INFO - PROCESS | 1646 | 14:09:34 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49251/tests/dromaeo/cssquery-mootools.html) 14:09:35 INFO - PROCESS | 1646 | RSS: Main: 286912512 14:09:35 INFO - PROCESS | 1646 | 14:12:37 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49251/tests/dromaeo/cssquery-prototype.html) 14:12:38 INFO - PROCESS | 1646 | RSS: Main: 272199680 14:12:38 INFO - PROCESS | 1646 | 14:15:41 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49251/tests/dromaeo/cssquery-yui.html) 14:15:42 INFO - PROCESS | 1646 | RSS: Main: 269533184 14:15:42 INFO - PROCESS | 1646 | 14:18:45 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-yui.html (next: http://localhost:49251/tests/dromaeo/cssquery-dojo.html) 14:18:45 INFO - PROCESS | 1646 | RSS: Main: 348831744 14:18:45 INFO - PROCESS | 1646 | 14:18:45 INFO - PROCESS | 1646 | __start_tp_report 14:18:45 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 14:18:45 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 14:18:45 INFO - PROCESS | 1646 | |i|pagename|runs| 14:18:45 INFO - PROCESS | 1646 | |0;dojo.html;3463.9480407793885;3573.5711714594254;3575.874844380447;3596.496490491333;3632.4551317302403;5731.168980497825;6197.5041996640275;6208.472279856218;6219.099532424689;6238.750449982001;5627.521660658849;6238.53211009175;6248.218972628421;6266.874662506747;6279.560430769837;5486.067368547347;5513.9448605513835;5545.279113715232;5563.916541251884;5647.378788333301;5467.617266791326;5470.753816078286;5516.420775818521;5552.86117847055;5661.122526008455;5624.634398764088;5627;5628.887422251552;5631.155326700987;5672.149177623348;5604.551635869121;5613.550915926737;5616.0171969905305;5619.213310136584;5624.240727501776;5368.677879327252;5385.488378604026;5474.945250547523;5526.447355264481;5581.190727344553;6017.277926648786;6017.398260173992;6116.031445915008;6128.636540437044;6130.306415576139;6475.255345635265;6477.902831457484;6488.967555162194;6504.869902601921;6519.185101862267;6523.967380163116;6552.6068435894;6597;6604.537682362188;6617.371349721769;6107.226802228232;6128.605979006185;6284.277308109535;6293.937060629335;6315.431611154926;6767.424768894601;6779.49153813466;6813.693383797741;6818.795436136924;6833.5216534843075;6425.1968503937005;6483.578567393104;6495.772647957393;6498.967505162538;6513.023046543057;5110.335656364723;6351.333110023474;6379.138816259839;6636.800895973129;6647.169103862017;6047.576669633171;6461.224653041571;6551.770688025897;6574.605523668595;6575.145231119924;6507.926192178332;6574.506911981621;6577.34226577348;6597.538172327987;6600.53796234259;5234.42421333653;5315.920261196085;5317.7872885084935;5320.654157479828;5353.57171426285;4647.024124933734;4651.279051746985;4709.222978208557;4713.34013238147;4754.358161648202;6268.749250029948;6270.2475702915945;6300.30696623371;6304;6314.494840412756;6510.18622672166;6653.567518111307;6656.467482601381;6658.267590565034;6665.633390163491;6109.908351374733;6277.654728989858;6280.685965701697;6281.842953926189;6296.118543403927;5722.37053924068;5727.255456790591;5736.483716465538;5756.165356023437;5760.2223699800825;6676.566023208476;6769.153855768029;6803.149606299213;6880.793576192722;6912.688928998307;6609.636469994004;6667.533272670867;6669.566478178903;6673.733050677918;6674.365935236145;6849.1096157499205;6877.484188685969;6884.0018197360105;6884.277150899284;6885.242623311532;6334.271558770801;6377.330380310186;6418.101465794886;6421.101045853491;6444.420002199825;6446.033095035782;6489.3510648934725;6547.1161393211305;6568;6605.2734199239;5897.7935772247765;6402.775902843378;6406.455451286506;6416.615003099829;6429.54993150475;5605.355384130877;6349.619022858643;6366.586171898812;6375.6174629522375;6383.553151279366;6177.351378105234;6206.410391012847;6278.15244941927;6282.842928926813;6324.335944725737;6426.550141490051;6428.357164283534;6431.646259455775;6435.549511534147;6450.612963222222;6282.937170628235;6356.586821856565;6356.841078972878;6363.331850155667;6369.0764839099 14:18:45 INFO - PROCESS | 1646 | |1;ext.html;674.4199988010312;753.6420200404808;807.0275318241518;883.8541640629293;893.6380765789858;29776.553351699713;41807.954801129985;42276;42307;42393.99999999996;42773.57226427735;42983.14033719331;43205.91985200372;43260.783696081555;43293.78353108238;9770.65802696904;9939.453330066843;9943.502824858764;9952.601895924154;9959.800803983915;7912.881306780374;8095.757127286161;11718.179727419041;11851.348175850324;12229.082818788582;11950.282983021003;12082.818757718642;12098.213616114925;12105.334206618632;12108;11988.980936620354;12059.517619295219;12062.819057714141;12069.336186509738;12072.637820865388;11696.298222106616;11769.470373833197;11778.116641251854;11781.293122412682;11792.823107653392;40269.17442842925;40489.39265911013;40510.392344114865;40575.78272651825;40580.59419405827;3960.34654282046;4004.2992476316526;4010.2380547696134;4031.093004074089;4051.6353528182603;27703.03039393632;28425.715742842513;30321.848390758125;30663.693363066308;30852.53721194184;3131.5772370730115;3199.8240096794666;3322.0200040987966;3368.6631336866117;3386.102682789063;367540;373319;373414;373444;374809;52909;53022;53039.73480132574;53060.20409693858;53138.734306328224;47341.5265847344;52292.43122706325;55061.174082388796;55104;55129.72435137798;15053.247337633293;15505.612359691098;15513.844861551466;15525.534233973;15535.06789592628;11878.465469053914;13157.868421315856;13160.670983225304;13167.60497185086;13177.077604567588;10837.403942783223;10877.510512026978;13818.239996800072;13955;14008.089474184146;5995.310539287951;6104.847378815565;6153.307840343941;6162.383761623802;6167.660778657217;1091.44881834673;1099.9715266225944;1139.8461207737016;1146.7018575170348;1185.25921299188;27880.721192787812;27914.72085279121;28506.144815655563;28516.429671406455;28523.28691782722;1056.8203405420943;1059.279689810936;1196.682879037056;1264.5015060690012;1313.39583791457;13976.860231397759;14006.369713362923;14146.363413646204;14266.072705274331;14270.143791372344;503446;506377;506966;507717;508408;57242.7137864308;57273.427265727645;57475.13787293194;57511.712441438365;57513.71243143841;1439.942402303917;1488.2558720639681;1491.9403223870925;1495.5513345996158;1508.4343371235786;26042.86978565095;27257;28099.17355371894;28523.714762852935;28613.713862861106;38481.8455446337;38671;38693.613063869;38766;38789.03027424337;473373;475901;476441;477674;477696;30422.695773041985;39944.201115978096;40332.59667403406;40344;40491;31874.203144920633;40296.798516007235;40408.1918361637;52098.47901520936;52284.47715522796;33637.495437567966;33800.49299260562;33924.49113263254;33972.49041264334;35100.64899351076;33008.33983320272;33087.66912330846;33478.497822533165;33727;34214.315713685086;39395.40906886342;39993.400098997954;41060;41122.76631701054;41160.79419602883;33687;34011.31977360389;34045.14887127842;34269.65730342665;34998.650013500555;26584.734152658224;26619.600705989815;26670;26715.79778909915;27075.729242707323 14:18:45 INFO - PROCESS | 1646 | |2;jquery.html;429.2166795598034;436.2757822015453;437.6608128700258;444.7353824474438;448.6635023732199;20449.795502044995;21449.785502144994;22814.31557053291;23068.423289417773;23097.191598294063;22934.77065229347;24243.515129697396;24309.878450607768;24453.02187912486;24522.3869403265;6678.532502724811;6717.496187785923;6935.930640693604;7101.928980710204;7134.678939447737;6889.793306200822;6955.547889387173;7010.439164866824;7014.438844892396;7022.508424410294;6644.9003264950825;6859.657017149148;6927.203371612253;6933.549319294255;6940.2712715164935;6951.826204344881;7003.579785212878;7025.8594828103405;7420.591867447289;7756.224377562255;7404.259574042607;7668.923310766877;7675.424343174284;7682.8079298018;7692.4615276930635;27760.861195694095;28250.152495424965;28283.43433131326;28299.717002829915;28698.426031479252;2991.7756168287247;3053.0688140117254;3088.552159936819;3177.7457803375673;3211.4379983502795;12643.683907902285;16727.414540491147;16829;16991.15044247795;17608.767386282965;2060.783617720148;2065.5455799724036;2081.6461201595766;2086.447091520748;2115.672070829024;135892;139051.30474347665;141743;142080;158201.20899395546;16181.271842767104;19650;20491.4877128073;20564.897175514325;20636.58726825485;32723;33335.83332083373;33399;33491.66508334934;33575.328493429995;8788.340874434443;10606.681799546026;10744.355338679548;10908.34549927007;11094.44527773608;7517.060367454068;9064.00295967443;9082.000979892207;9086.045965173562;9246.445213287225;9391.62433502666;9530.761730956643;9548.90451095494;9610.615575377047;9624.181944534654;3434.5363375944426;3975.9066256779615;4054.2499637567144;4061.5882658566356;4079.265732168179;948.5020364308793;1024.9282550221562;1028.5063169678447;1047.502436342731;1054.778496515725;18203.54491137732;21944.122235110415;22196.556068878854;22275.665865012037;22321.776782232293;1061.9150467962545;1062.9627963021412;1075.2580719303655;1093;1108.7083547666878;10987.890121098846;11542.881123912182;11640.534378624929;11678.824817627743;11692;776511;776616;787936;796506;798110;119220;162330;165034.1748291275;167236;171704;1205.2888795610631;1228.6375519221851;1261.432355440074;1261.9305938173488;1262.27419233939;16072.598185045468;17734.11329433549;18179.54551136232;19311.806881931563;19452.02739862973;63541.682291588244;63544.68227658832;64067.11697973509;64301.78491075521;65386.365340864955;73359.26640733525;85520;91834;93386.53306733423;93680;11471.541138354372;11727.824082638937;11980.58067967617;12092.697682558006;12160.756784864076;10301.227407944285;11600.535978560763;12875;13189.152790774806;13219.867801321863;11419.14356423255;11617.186796924134;11831.349275789915;11834.82247766267;11863.466144023712;8707.216350528483;8725.956370218108;9812.165965892693;10465.633702820669;10563.20775941792;11722.179447438597;11759.882401175879;11922.344271065174;11988.220765650205;12017.699557511132;11697.2981621103;11726.824097638713;12051.276923384274;12080.75838483208;12094.455749491119;11578.247413918405;11590.246633968765;11640.243384180001;11740.06079513654;11809.409529523318 14:18:45 INFO - PROCESS | 1646 | |3;mootools.html;1386.5840247925619;1598.3686443854679;1627.9104649244302;1630.3560093762965;1643.8438348356906;9559.091886270802;9961.501924903752;10085.394876307417;10694.572217111325;11454.713632159179;11243.494042768074;11343.432828358591;11353.886461135386;11362.829557556643;11391.145664075186;2388.8327817052814;2436.11081955086;2439.0365805506813;2442.656538903596;2446.1805295226122;2081.739782527184;2159.8704077755306;2429.866357350345;2494.5759220932396;2519.546481633305;2438.609822428412;2441.841280316774;2460.729319774823;2465.285067330472;2467.5558399488086;2453.325335532725;2454.5336386086765;2458.5697502937005;2460.2127319257843;2461.2985299189645;2386.2244770449674;2411.180198732422;2424.5393375258645;2427.2596857958315;2431.756824317572;11453.484593193327;11534.134939879543;11538.76922461546;11549.595764148215;11642.301461912228;5956.702164891738;6136.6011209271255;6138.508919286446;6143.139960405547;6150.815475535741;3397.69420752131;3409.5567576214935;3604.42329227325;3641.5448068991377;3652.5799533053773;1204.6988252936767;1222.1444988507992;1228.2875931959531;1260.4706023470073;1267.4930027988787;12985.675358116028;15464.381424742996;15566.688666226726;15572.221388930508;15584.844151558453;4817.229243321051;5053.191489361684;5103.7192954387865;5121.3854337479;5138.818071843422;10988.395638239814;13082.28047457399;13082.738345233232;13107;13108.80336794949;6010.9699451502465;6165.630062196283;6177.96911015442;6180.969095154495;6194.659293738798;4684.578387945101;5224.7126408047925;5414.8917021659345;5437.782488700487;5502.862428439321;3625.9093522661615;3772.4718539404507;3871.5160604924386;4176.248275310473;4294.656427485794;1131.6322195286564;1148.661144962238;1153.529250205994;1164.8602167739925;1166.5100657723776;813.8209593889335;852.8294341131799;861.328164032056;871.7951281448854;895.3240303570892;5221.399539052982;6133.742582770521;6676;6782.084418603524;6822.556533825285;838.7106448275335;849.2696281198165;880.2473884828507;945.2910317262053;1004.3622299839508;4117.608827161415;4193.853215137456;4209.305464598368;4326.524082350938;4355.455568053993;13575.253361065235;14133.505327313494;14284.57146285613;14287.214203218922;14290.285485725672;13630.250336231404;13844.377003034888;14196.432142714175;14211.005229633827;14222.644433889029;8442.831143377098;10416.427096509613;10438.843417348746;10497.475126243657;10593.52329145175;6683.933160668331;6685.899711504234;6745.9662701686175;6772.627505487246;6840.179178498612;12356.876431235572;12701.872981270439;12705.047121465743;12726.17279876805;12727.427265772878;12666.936665316614;12783.105182637499;12848.100632955977;12865.935670321589;12879.420426080662;9328.02055784133;9339.252859771337;9424.057594240521;9431.62273509052;9436.197923176607;9154.221891139328;9949.751256218364;10334.844977325196;10515.94742026285;10803.837942430713;9132.49771262587;9212.815743684954;9231.399959002643;9291.581878815605;9397.342186046912;8785.912140878509;8870.77823054403;8939.642414303615;9011.279097672039;9046.954765226132;8070.798230044295;8221.218984196492;8231.300339471212;8231.629576669184;8239.917600823916;5996.820095397145;6067.575269731076;6093.573449858467;6223.751049957951;6256.624602523863;6064.575479716377;6103.145559621567;6109.11417844419;6177.62934223948;6245.9063114052415 14:18:45 INFO - PROCESS | 1646 | |4;prototype.html;386.3297179393753;386.8955382046847;387.5059299393275;392.19012738694585;392.9115948911493;4622.838200662977;4993.7003779773195;5031.861129422108;5050.621203409745;5060.367454068246;4144.544100148989;4589.495155532889;4944.381952255968;4952.479989601094;4981.277714731362;3899.610038996099;3925.8429662813455;3955.8417663293435;3978.5424676162324;3980.7213495055357;3593.7664051836678;3960.8019599020076;3964.0288129408336;3968.30554652936;3997.7401468904573;3365.326934613075;3786.9775160706595;3880.26275007749;3901.55132159801;3910.882673519785;3409.7954122752712;3688.1517251032415;3911.4328422378594;3917.6474117329576;3965.6430921217084;3080.476319025771;3463.6709512596262;3504.8072356020407;3511.0864578804612;3517.803946658123;4162.587657083471;4513.345564893105;4605.424321959755;4916.984036545035;4948.6493915390265;3845.8269377878064;4428.158649856549;4519.4802597701355;4549.772511374418;4610.792514336829;4308.4399028126145;4861.611071114302;5306.363236411656;5326.520613144836;5344.824138689482;3589.838457269429;4321.2653848845775;4328.264195086843;4342.804573794187;4355.716878402894;4707.741074240916;4837.37114175155;5335.772772262362;5727.455891690282;5749.856253593652;3817.8854634361014;3883.630915220377;4049.250888585621;4068.247374235776;4237.3558739484015;3594.964050359463;4463.553644635511;4471.128130014681;4485.75712143928;4518.43519560055;4192.685548583869;4269.658427325807;4476.776161191928;4787.904241915142;4841.491643377465;4237.855778939669;4735.857924262277;4868.3427737255015;4948.703077815343;5346;1416.8370637376627;1471.073223868977;1529.7093552225042;1539.7536394176877;1541.8282105599824;920.2408013388847;1101.124605938281;1141.8230174322994;1161.517970042423;1173.202222488699;4363.345498175299;4468.776561171993;4626.676132670748;4959.628027897922;4977.203647416396;4518.367428560005;4913.70517768935;5138.486151384906;5309.36287645485;5504.559635229172;3856.6143385661208;4662.673612847136;4960.107180707435;4974.651774375759;4992.500749924979;2336.5279873679474;2490.95018099637;2512.987435062813;2669;2733.603627474005;4504.684672072924;4685.016146609182;4992.700437973734;5523.011715782315;5706.885862282731;4815.903681926342;4949.94577250437;5064.442911279756;5587.14487003974;5679.67738872764;5039.672421292677;5356.705381204071;5439.48324909133;5534.395025442657;5551.361593416728;4303.806328715278;4935.851924442272;5176.240078373371;5219.686818790885;5420.82596400777;4763.833265835679;5219.973900130475;5302.549283310807;5380.73096345189;5470.617056805985;4884.460080758057;5023.34696489454;5321.840344789508;5378.327709036371;5387.683296182679;3870.709696772697;3986.1464419045283;4114.321137012359;4353.434053573015;4357.758038958881;5081.212412076134;5159.716215608178;5180.585553155814;5319.601029922848;5414.783408663609;4393.714408563433;4647.744374059459;5146.614003949644;5394.838154855361;5398.811041613525;4593.885152871205;4777.877198858335;5275.366955965309;5276.498732620395;5287.867803304948;4763.833265835679;4766.880827979189;4969.328830898943;5180.456052114474;5267.60492963037;4547.613452856544;5028.949710502849;5121.667091639031;5351.5183633471615;5351.919721204263;4499.020431010345;4846.5153484651255;5246.845693947325;5257.63196576236;5293.629445938747 14:18:45 INFO - PROCESS | 1646 | |5;yui.html;763.7785042337722;781.5388920536882;802.1216767639432;819.9344052475801;889.6485888074211;15092.77360839587;15514.146721930289;15531.145786981711;15547.766783498242;15555.766663500057;16164.515064548053;16178.919105404486;16184.514464566053;16311.59221019475;16388.75416868748;880.7049638371121;989.5349185882642;1008.0263223490695;1056.2025670618673;1057.9153667706603;1046.638909576195;1047.8323468245082;1049.0244073012095;1049.029647575993;1049.4805071489623;1083.4311986207226;1083.9241253112286;1083.9458027098653;1084.2464487181412;1084.262701363073;1075.198976762317;1077.3912739302268;1077.8652668416448;1078.6116997880836;1080;800.3837045474952;800.9907516529215;802.3901834605741;803.6544285957036;804.4328748232541;17456.738148927776;17639.294428222856;18000.369987050522;18227.270909163617;18453.815461845345;14685.706285874223;14793;14820.3330850112;14930.850691493055;15208.847911520854;11984.940075299568;12104.636860894187;12303.507859685602;12319.199252048587;12625;3763.419363867155;3823.235352929425;3970.1265721541213;4062.984253936516;4107.301758701028;113693;115287.99999999916;121140;123120.76879231272;124948;9989.30074894765;10225.539850706737;10232.64185753495;10266.845997310047;10549.6946141033;23697;24085.879570602036;24272.514549708907;24298.757012430004;24448;8001;8151.307138893142;8239.588020598947;8398.202170793887;8470.957645211734;4453.15390075891;4457.509673935864;4490.281554951192;4495.707778994355;4533.569310915458;3444.9827750861086;3738.4018557030745;3745.887623371303;3754.267917756066;3754.9436758448646;632.5477283742147;635.6249812610582;651.4495251512465;658.7122176145624;662.5726406467801;591.6982339007051;669.7555392281782;690.3683129936153;696.095076400677;726.8982342472058;10606.469676516142;10832.40421776794;10894.509747061402;11026.338419694845;11159.497822598003;655.7999810057883;694.4756708685012;697.2504557600599;700.2052670219338;706.7031846624327;4842.903141937141;5149.948500514947;5214.14347563334;5267.104592219332;5271.973640131775;90088.5495572518;93237.5338123305;117098.26514823598;120489;120606.79393205956;50862.74568627133;99351.51621209527;103490.96509034814;105654;108074;74751.62624186845;77728.61135694286;80614.19385806067;80869;82511.17488825035;11073.390963497084;11248.493817778057;11274.323540587591;11438.771224575628;11516.42417879086;49471.25793113034;50629.74685126551;50712.74643626758;51530.48469515257;53109.46890531045;59412.3264453092;74114.25885741289;76648.61675691586;76951.61524192343;78847;13643.433966952416;13718.93140534291;13723.862761372258;14316.785248221493;14370.209638469985;15691.372345106069;15837;15848.52454426369;15904;15975.85773164073;14739.189344586151;14930.701385972003;14936.925315373353;15064.548063558112;15264.465743698916;14098.577042688736;14230.405573525753;14764.926175369055;14895.627609309853;14905.105693658415;12898.290594017419;13749.175049496662;14845.851541484446;15118.319675614404;15137.243137843285;10252.692419227435;10344;10469.424181670081;10636.8936310639;10752.623658171926;11368.488418021374;11766.470508827295;11773.175877688822;11790.94104529472;11795.587154449553 14:18:45 INFO - PROCESS | 1646 | __end_tp_report 14:18:45 INFO - PROCESS | 1646 | __start_cc_report 14:18:45 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1467 14:18:45 INFO - PROCESS | 1646 | __end_cc_report 14:18:45 INFO - PROCESS | 1646 | __startTimestamp1493155125889__endTimestamp 14:18:45 INFO - PROCESS | 1646 | 14:18:45 INFO - PROCESS | 1646 | ------- Summary: start ------- 14:18:45 INFO - PROCESS | 1646 | Number of tests: 6 14:18:45 INFO - PROCESS | 1646 | 14:18:45 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:6099.31 Median:6314.49 stddev:675.29 (10.7%) stddev-sans-first:644.94 14:18:45 INFO - PROCESS | 1646 | Values: 3463.9 3573.6 3575.9 3596.5 3632.5 5731.2 6197.5 6208.5 6219.1 6238.8 5627.5 6238.5 6248.2 6266.9 6279.6 5486.1 5513.9 5545.3 5563.9 5647.4 5467.6 5470.8 5516.4 5552.9 5661.1 5624.6 5627.0 5628.9 5631.2 5672.1 5604.6 5613.6 5616.0 5619.2 5624.2 5368.7 5385.5 5474.9 5526.4 5581.2 6017.3 6017.4 6116.0 6128.6 6130.3 6475.3 6477.9 6489.0 6504.9 6519.2 6524.0 6552.6 6597.0 6604.5 6617.4 6107.2 6128.6 6284.3 6293.9 6315.4 6767.4 6779.5 6813.7 6818.8 6833.5 6425.2 6483.6 6495.8 6499.0 6513.0 5110.3 6351.3 6379.1 6636.8 6647.2 6047.6 6461.2 6551.8 6574.6 6575.1 6507.9 6574.5 6577.3 6597.5 6600.5 5234.4 5315.9 5317.8 5320.7 5353.6 4647.0 4651.3 4709.2 4713.3 4754.4 6268.7 6270.2 6300.3 6304.0 6314.5 6510.2 6653.6 6656.5 6658.3 6665.6 6109.9 6277.7 6280.7 6281.8 6296.1 5722.4 5727.3 5736.5 5756.2 5760.2 6676.6 6769.2 6803.1 6880.8 6912.7 6609.6 6667.5 6669.6 6673.7 6674.4 6849.1 6877.5 6884.0 6884.3 6885.2 6334.3 6377.3 6418.1 6421.1 6444.4 6446.0 6489.4 6547.1 6568.0 6605.3 5897.8 6402.8 6406.5 6416.6 6429.5 5605.4 6349.6 6366.6 6375.6 6383.6 6177.4 6206.4 6278.2 6282.8 6324.3 6426.6 6428.4 6431.6 6435.5 6450.6 6282.9 6356.6 6356.8 6363.3 6369.1 14:18:45 INFO - PROCESS | 1646 | 14:18:45 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:59621.75 Median:34028.23 stddev:120854.98 (355.2%) stddev-sans-first:121112.97 14:18:45 INFO - PROCESS | 1646 | Values: 674.4 753.6 807.0 883.9 893.6 29776.6 41808.0 42276.0 42307.0 42394.0 42773.6 42983.1 43205.9 43260.8 43293.8 9770.7 9939.5 9943.5 9952.6 9959.8 7912.9 8095.8 11718.2 11851.3 12229.1 11950.3 12082.8 12098.2 12105.3 12108.0 11989.0 12059.5 12062.8 12069.3 12072.6 11696.3 11769.5 11778.1 11781.3 11792.8 40269.2 40489.4 40510.4 40575.8 40580.6 3960.3 4004.3 4010.2 4031.1 4051.6 27703.0 28425.7 30321.8 30663.7 30852.5 3131.6 3199.8 3322.0 3368.7 3386.1 367540.0 373319.0 373414.0 373444.0 374809.0 52909.0 53022.0 53039.7 53060.2 53138.7 47341.5 52292.4 55061.2 55104.0 55129.7 15053.2 15505.6 15513.8 15525.5 15535.1 11878.5 13157.9 13160.7 13167.6 13177.1 10837.4 10877.5 13818.2 13955.0 14008.1 5995.3 6104.8 6153.3 6162.4 6167.7 1091.4 1100.0 1139.8 1146.7 1185.3 27880.7 27914.7 28506.1 28516.4 28523.3 1056.8 1059.3 1196.7 1264.5 1313.4 13976.9 14006.4 14146.4 14266.1 14270.1 503446.0 506377.0 506966.0 507717.0 508408.0 57242.7 57273.4 57475.1 57511.7 57513.7 1439.9 1488.3 1491.9 1495.6 1508.4 26042.9 27257.0 28099.2 28523.7 28613.7 38481.8 38671.0 38693.6 38766.0 38789.0 473373.0 475901.0 476441.0 477674.0 477696.0 30422.7 39944.2 40332.6 40344.0 40491.0 31874.2 40296.8 40408.2 52098.5 52284.5 33637.5 33800.5 33924.5 33972.5 35100.6 33008.3 33087.7 33478.5 33727.0 34214.3 39395.4 39993.4 41060.0 41122.8 41160.8 33687.0 34011.3 34045.1 34269.7 34998.7 26584.7 26619.6 26670.0 26715.8 27075.7 14:18:45 INFO - PROCESS | 1646 | 14:18:45 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:44226.35 Median:22298.72 stddev:130836.49 (586.7%) stddev-sans-first:131162.19 14:18:45 INFO - PROCESS | 1646 | Values: 429.2 436.3 437.7 444.7 448.7 20449.8 21449.8 22814.3 23068.4 23097.2 22934.8 24243.5 24309.9 24453.0 24522.4 6678.5 6717.5 6935.9 7101.9 7134.7 6889.8 6955.5 7010.4 7014.4 7022.5 6644.9 6859.7 6927.2 6933.5 6940.3 6951.8 7003.6 7025.9 7420.6 7756.2 7404.3 7668.9 7675.4 7682.8 7692.5 27760.9 28250.2 28283.4 28299.7 28698.4 2991.8 3053.1 3088.6 3177.7 3211.4 12643.7 16727.4 16829.0 16991.2 17608.8 2060.8 2065.5 2081.6 2086.4 2115.7 135892.0 139051.3 141743.0 142080.0 158201.2 16181.3 19650.0 20491.5 20564.9 20636.6 32723.0 33335.8 33399.0 33491.7 33575.3 8788.3 10606.7 10744.4 10908.3 11094.4 7517.1 9064.0 9082.0 9086.0 9246.4 9391.6 9530.8 9548.9 9610.6 9624.2 3434.5 3975.9 4054.2 4061.6 4079.3 948.5 1024.9 1028.5 1047.5 1054.8 18203.5 21944.1 22196.6 22275.7 22321.8 1061.9 1063.0 1075.3 1093.0 1108.7 10987.9 11542.9 11640.5 11678.8 11692.0 776511.0 776616.0 787936.0 796506.0 798110.0 119220.0 162330.0 165034.2 167236.0 171704.0 1205.3 1228.6 1261.4 1261.9 1262.3 16072.6 17734.1 18179.5 19311.8 19452.0 63541.7 63544.7 64067.1 64301.8 65386.4 73359.3 85520.0 91834.0 93386.5 93680.0 11471.5 11727.8 11980.6 12092.7 12160.8 10301.2 11600.5 12875.0 13189.2 13219.9 11419.1 11617.2 11831.3 11834.8 11863.5 8707.2 8726.0 9812.2 10465.6 10563.2 11722.2 11759.9 11922.3 11988.2 12017.7 11697.3 11726.8 12051.3 12080.8 12094.5 11578.2 11590.2 11640.2 11740.1 11809.4 14:18:45 INFO - PROCESS | 1646 | 14:18:45 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:6888.37 Median:2958.62 stddev:4318.99 (146.0%) stddev-sans-first:4311.32 14:18:45 INFO - PROCESS | 1646 | Values: 1386.6 1598.4 1627.9 1630.4 1643.8 9559.1 9961.5 10085.4 10694.6 11454.7 11243.5 11343.4 11353.9 11362.8 11391.1 2388.8 2436.1 2439.0 2442.7 2446.2 2081.7 2159.9 2429.9 2494.6 2519.5 2438.6 2441.8 2460.7 2465.3 2467.6 2453.3 2454.5 2458.6 2460.2 2461.3 2386.2 2411.2 2424.5 2427.3 2431.8 11453.5 11534.1 11538.8 11549.6 11642.3 5956.7 6136.6 6138.5 6143.1 6150.8 3397.7 3409.6 3604.4 3641.5 3652.6 1204.7 1222.1 1228.3 1260.5 1267.5 12985.7 15464.4 15566.7 15572.2 15584.8 4817.2 5053.2 5103.7 5121.4 5138.8 10988.4 13082.3 13082.7 13107.0 13108.8 6011.0 6165.6 6178.0 6181.0 6194.7 4684.6 5224.7 5414.9 5437.8 5502.9 3625.9 3772.5 3871.5 4176.2 4294.7 1131.6 1148.7 1153.5 1164.9 1166.5 813.8 852.8 861.3 871.8 895.3 5221.4 6133.7 6676.0 6782.1 6822.6 838.7 849.3 880.2 945.3 1004.4 4117.6 4193.9 4209.3 4326.5 4355.5 13575.3 14133.5 14284.6 14287.2 14290.3 13630.3 13844.4 14196.4 14211.0 14222.6 8442.8 10416.4 10438.8 10497.5 10593.5 6683.9 6685.9 6746.0 6772.6 6840.2 12356.9 12701.9 12705.0 12726.2 12727.4 12666.9 12783.1 12848.1 12865.9 12879.4 9328.0 9339.3 9424.1 9431.6 9436.2 9154.2 9949.8 10334.8 10515.9 10803.8 9132.5 9212.8 9231.4 9291.6 9397.3 8785.9 8870.8 8939.6 9011.3 9047.0 8070.8 8221.2 8231.3 8231.6 8239.9 5996.8 6067.6 6093.6 6223.8 6256.6 6064.6 6103.1 6109.1 6177.6 6245.9 14:18:45 INFO - PROCESS | 1646 | 14:18:45 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4312.84 Median:4637.21 stddev:1213.34 (26.2%) stddev-sans-first:1180.41 14:18:45 INFO - PROCESS | 1646 | Values: 386.3 386.9 387.5 392.2 392.9 4622.8 4993.7 5031.9 5050.6 5060.4 4144.5 4589.5 4944.4 4952.5 4981.3 3899.6 3925.8 3955.8 3978.5 3980.7 3593.8 3960.8 3964.0 3968.3 3997.7 3365.3 3787.0 3880.3 3901.6 3910.9 3409.8 3688.2 3911.4 3917.6 3965.6 3080.5 3463.7 3504.8 3511.1 3517.8 4162.6 4513.3 4605.4 4917.0 4948.6 3845.8 4428.2 4519.5 4549.8 4610.8 4308.4 4861.6 5306.4 5326.5 5344.8 3589.8 4321.3 4328.3 4342.8 4355.7 4707.7 4837.4 5335.8 5727.5 5749.9 3817.9 3883.6 4049.3 4068.2 4237.4 3595.0 4463.6 4471.1 4485.8 4518.4 4192.7 4269.7 4476.8 4787.9 4841.5 4237.9 4735.9 4868.3 4948.7 5346.0 1416.8 1471.1 1529.7 1539.8 1541.8 920.2 1101.1 1141.8 1161.5 1173.2 4363.3 4468.8 4626.7 4959.6 4977.2 4518.4 4913.7 5138.5 5309.4 5504.6 3856.6 4662.7 4960.1 4974.7 4992.5 2336.5 2491.0 2513.0 2669.0 2733.6 4504.7 4685.0 4992.7 5523.0 5706.9 4815.9 4949.9 5064.4 5587.1 5679.7 5039.7 5356.7 5439.5 5534.4 5551.4 4303.8 4935.9 5176.2 5219.7 5420.8 4763.8 5220.0 5302.5 5380.7 5470.6 4884.5 5023.3 5321.8 5378.3 5387.7 3870.7 3986.1 4114.3 4353.4 4357.8 5081.2 5159.7 5180.6 5319.6 5414.8 4393.7 4647.7 5146.6 5394.8 5398.8 4593.9 4777.9 5275.4 5276.5 5287.9 4763.8 4766.9 4969.3 5180.5 5267.6 4547.6 5028.9 5121.7 5351.5 5351.9 4499.0 4846.5 5246.8 5257.6 5293.6 14:18:45 INFO - PROCESS | 1646 | 14:18:45 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:21880.83 Median:15876.26 stddev:31777.65 (200.2%) stddev-sans-first:31827.24 14:18:45 INFO - PROCESS | 1646 | Values: 763.8 781.5 802.1 819.9 889.6 15092.8 15514.1 15531.1 15547.8 15555.8 16164.5 16178.9 16184.5 16311.6 16388.8 880.7 989.5 1008.0 1056.2 1057.9 1046.6 1047.8 1049.0 1049.0 1049.5 1083.4 1083.9 1083.9 1084.2 1084.3 1075.2 1077.4 1077.9 1078.6 1080.0 800.4 801.0 802.4 803.7 804.4 17456.7 17639.3 18000.4 18227.3 18453.8 14685.7 14793.0 14820.3 14930.9 15208.8 11984.9 12104.6 12303.5 12319.2 12625.0 3763.4 3823.2 3970.1 4063.0 4107.3 113693.0 115288.0 121140.0 123120.8 124948.0 9989.3 10225.5 10232.6 10266.8 10549.7 23697.0 24085.9 24272.5 24298.8 24448.0 8001.0 8151.3 8239.6 8398.2 8471.0 4453.2 4457.5 4490.3 4495.7 4533.6 3445.0 3738.4 3745.9 3754.3 3754.9 632.5 635.6 651.4 658.7 662.6 591.7 669.8 690.4 696.1 726.9 10606.5 10832.4 10894.5 11026.3 11159.5 655.8 694.5 697.3 700.2 706.7 4842.9 5149.9 5214.1 5267.1 5272.0 90088.5 93237.5 117098.3 120489.0 120606.8 50862.7 99351.5 103491.0 105654.0 108074.0 74751.6 77728.6 80614.2 80869.0 82511.2 11073.4 11248.5 11274.3 11438.8 11516.4 49471.3 50629.7 50712.7 51530.5 53109.5 59412.3 74114.3 76648.6 76951.6 78847.0 13643.4 13718.9 13723.9 14316.8 14370.2 15691.4 15837.0 15848.5 15904.0 15975.9 14739.2 14930.7 14936.9 15064.5 15264.5 14098.6 14230.4 14764.9 14895.6 14905.1 12898.3 13749.2 14845.9 15118.3 15137.2 10252.7 10344.0 10469.4 10636.9 10752.6 11368.5 11766.5 11773.2 11790.9 11795.6 14:18:45 INFO - PROCESS | 1646 | -------- Summary: end -------- 14:18:45 INFO - PROCESS | 1646 | 14:18:46 INFO - TEST-INFO | 1646: exit 0 14:18:46 INFO - TEST-OK | dromaeo_css | took 1118717ms 14:18:46 INFO - TEST-START | kraken 14:18:46 INFO - operating with platform_type : mac_ 14:18:46 INFO - Initialising browser for kraken test... 14:18:46 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmpoKYOYe/profile http://localhost:49251/getInfo.html) 14:18:48 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 14:18:48 INFO - PROCESS | 1652 | colorDepth:24 14:18:48 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 14:18:48 INFO - PROCESS | 1652 | __metrics 14:18:48 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:18:48 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:18:49 INFO - TEST-INFO | 1652: exit 0 14:18:49 INFO - Browser initialized. 14:18:49 INFO - Running cycle 1/1 for kraken test... 14:18:49 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmpoKYOYe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:19:01 INFO - PROCESS | 1654 | RSS: Main: 165273600 14:19:01 INFO - PROCESS | 1654 | 14:19:04 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-beat-detection) 14:19:05 INFO - PROCESS | 1654 | RSS: Main: 217092096 14:19:05 INFO - PROCESS | 1654 | 14:19:07 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-dft) 14:19:08 INFO - PROCESS | 1654 | RSS: Main: 233209856 14:19:08 INFO - PROCESS | 1654 | 14:19:11 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-fft) 14:19:12 INFO - PROCESS | 1654 | RSS: Main: 329822208 14:19:12 INFO - PROCESS | 1654 | 14:19:14 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-oscillator) 14:19:14 INFO - PROCESS | 1654 | RSS: Main: 229818368 14:19:14 INFO - PROCESS | 1654 | 14:19:16 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:19:17 INFO - PROCESS | 1654 | RSS: Main: 232349696 14:19:17 INFO - PROCESS | 1654 | 14:19:20 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-darkroom) 14:19:21 INFO - PROCESS | 1654 | RSS: Main: 271933440 14:19:21 INFO - PROCESS | 1654 | 14:19:24 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-desaturate) 14:19:24 INFO - PROCESS | 1654 | RSS: Main: 273461248 14:19:24 INFO - PROCESS | 1654 | 14:19:27 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49251/tests/kraken/driver.html?testName=json-parse-financial) 14:19:28 INFO - PROCESS | 1654 | RSS: Main: 268644352 14:19:28 INFO - PROCESS | 1654 | 14:19:29 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49251/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:19:30 INFO - PROCESS | 1654 | RSS: Main: 248832000 14:19:30 INFO - PROCESS | 1654 | 14:19:32 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:19:32 INFO - PROCESS | 1654 | RSS: Main: 252076032 14:19:32 INFO - PROCESS | 1654 | 14:19:35 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:19:35 INFO - PROCESS | 1654 | RSS: Main: 255823872 14:19:35 INFO - PROCESS | 1654 | 14:19:38 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:19:39 INFO - PROCESS | 1654 | RSS: Main: 262029312 14:19:39 INFO - PROCESS | 1654 | 14:19:42 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:19:42 INFO - PROCESS | 1654 | RSS: Main: 263479296 14:19:42 INFO - PROCESS | 1654 | 14:19:44 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49251/tests/kraken/driver.html?testName=ai-astar) 14:19:44 INFO - PROCESS | 1654 | RSS: Main: 308314112 14:19:44 INFO - PROCESS | 1654 | 14:19:44 INFO - PROCESS | 1654 | __start_tp_report 14:19:44 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 14:19:44 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 14:19:44 INFO - PROCESS | 1654 | |i|pagename|runs| 14:19:44 INFO - PROCESS | 1654 | |0;ai-astar;106;116;116;117;119;117;115;117;116;116 14:19:44 INFO - PROCESS | 1654 | |1;audio-beat-detection;138;135;132;140;110;116;134;121;124;107 14:19:44 INFO - PROCESS | 1654 | |2;audio-dft;185;186;182;181;187;182;183;184;184;204 14:19:44 INFO - PROCESS | 1654 | |3;audio-fft;81;58;59;93;61;58;59;58;74;59 14:19:44 INFO - PROCESS | 1654 | |4;audio-oscillator;92;70;72;71;71;99;113;99;77;83 14:19:44 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;87;89;126;136;100;86;88;87;87;88 14:19:44 INFO - PROCESS | 1654 | |6;imaging-darkroom;93;94;94;95;94;93;95;94;98;94 14:19:44 INFO - PROCESS | 1654 | |7;imaging-desaturate;83;82;83;83;82;83;84;83;84;83 14:19:44 INFO - PROCESS | 1654 | |8;json-parse-financial;62;61;62;62;63;64;62;62;64;63 14:19:44 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;57;64;54;64;60;56;59;59;57;57 14:19:44 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;84;81;85;82;83;82;86;87;82;108 14:19:44 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;132;136;149;147;138;133;123;144;166;139 14:19:44 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;209;186;162;163;158;163;162;162;161;161 14:19:44 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;64;63;63;64;63;64;63;62;60;63 14:19:44 INFO - PROCESS | 1654 | __end_tp_report 14:19:44 INFO - PROCESS | 1654 | __start_cc_report 14:19:44 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,2069 14:19:44 INFO - PROCESS | 1654 | __end_cc_report 14:19:44 INFO - PROCESS | 1654 | __startTimestamp1493155184689__endTimestamp 14:19:44 INFO - PROCESS | 1654 | 14:19:44 INFO - PROCESS | 1654 | ------- Summary: start ------- 14:19:44 INFO - PROCESS | 1654 | Number of tests: 14 14:19:44 INFO - PROCESS | 1654 | 14:19:44 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.50 stddev:3.50 (3.0%) stddev-sans-first:1.13 14:19:44 INFO - PROCESS | 1654 | Values: 106.0 116.0 116.0 117.0 119.0 117.0 115.0 117.0 116.0 116.0 14:19:44 INFO - PROCESS | 1654 | 14:19:44 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:125.70 Median:133.00 stddev:11.86 (8.9%) stddev-sans-first:11.72 14:19:44 INFO - PROCESS | 1654 | Values: 138.0 135.0 132.0 140.0 110.0 116.0 134.0 121.0 124.0 107.0 14:19:44 INFO - PROCESS | 1654 | 14:19:44 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:185.80 Median:184.50 stddev:6.66 (3.6%) stddev-sans-first:7.06 14:19:44 INFO - PROCESS | 1654 | Values: 185.0 186.0 182.0 181.0 187.0 182.0 183.0 184.0 184.0 204.0 14:19:44 INFO - PROCESS | 1654 | 14:19:44 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:66.00 Median:60.00 stddev:12.39 (20.7%) stddev-sans-first:11.90 14:19:44 INFO - PROCESS | 1654 | Values: 81.0 58.0 59.0 93.0 61.0 58.0 59.0 58.0 74.0 59.0 14:19:44 INFO - PROCESS | 1654 | 14:19:44 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:84.70 Median:80.00 stddev:15.20 (19.0%) stddev-sans-first:15.89 14:19:44 INFO - PROCESS | 1654 | Values: 92.0 70.0 72.0 71.0 71.0 99.0 113.0 99.0 77.0 83.0 14:19:44 INFO - PROCESS | 1654 | 14:19:44 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:97.40 Median:87.00 stddev:18.31 (21.0%) stddev-sans-first:19.03 14:19:44 INFO - PROCESS | 1654 | Values: 87.0 89.0 126.0 136.0 100.0 86.0 88.0 87.0 87.0 88.0 14:19:44 INFO - PROCESS | 1654 | 14:19:44 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:94.40 Median:94.00 stddev:1.43 (1.5%) stddev-sans-first:1.42 14:19:44 INFO - PROCESS | 1654 | Values: 93.0 94.0 94.0 95.0 94.0 93.0 95.0 94.0 98.0 94.0 14:19:44 INFO - PROCESS | 1654 | 14:19:44 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:83.00 Median:83.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 14:19:44 INFO - PROCESS | 1654 | Values: 83.0 82.0 83.0 83.0 82.0 83.0 84.0 83.0 84.0 83.0 14:19:44 INFO - PROCESS | 1654 | 14:19:44 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:62.50 stddev:0.97 (1.6%) stddev-sans-first:1.01 14:19:44 INFO - PROCESS | 1654 | Values: 62.0 61.0 62.0 62.0 63.0 64.0 62.0 62.0 64.0 63.0 14:19:44 INFO - PROCESS | 1654 | 14:19:44 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:3.27 (5.5%) stddev-sans-first:3.41 14:19:44 INFO - PROCESS | 1654 | Values: 57.0 64.0 54.0 64.0 60.0 56.0 59.0 59.0 57.0 57.0 14:19:44 INFO - PROCESS | 1654 | 14:19:44 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:83.50 stddev:7.97 (9.5%) stddev-sans-first:8.42 14:19:44 INFO - PROCESS | 1654 | Values: 84.0 81.0 85.0 82.0 83.0 82.0 86.0 87.0 82.0 108.0 14:19:44 INFO - PROCESS | 1654 | 14:19:44 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:141.50 stddev:11.74 (8.3%) stddev-sans-first:12.02 14:19:44 INFO - PROCESS | 1654 | Values: 132.0 136.0 149.0 147.0 138.0 133.0 123.0 144.0 166.0 139.0 14:19:44 INFO - PROCESS | 1654 | 14:19:44 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.70 Median:162.50 stddev:16.18 (10.0%) stddev-sans-first:8.30 14:19:44 INFO - PROCESS | 1654 | Values: 209.0 186.0 162.0 163.0 158.0 163.0 162.0 162.0 161.0 161.0 14:19:44 INFO - PROCESS | 1654 | 14:19:44 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.20 (1.9%) stddev-sans-first:1.20 14:19:44 INFO - PROCESS | 1654 | Values: 64.0 63.0 63.0 64.0 63.0 64.0 63.0 62.0 60.0 63.0 14:19:44 INFO - PROCESS | 1654 | -------- Summary: end -------- 14:19:44 INFO - PROCESS | 1654 | 14:19:45 INFO - TEST-INFO | 1654: exit 0 14:19:45 INFO - TEST-OK | kraken | took 58984ms 14:19:45 INFO - SUITE-END | took 1177s 14:19:45 INFO - Completed test suite (00:19:38) 14:19:45 INFO - javascript benchmark 14:19:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7883.565676728981, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3463.9480407793885, 3573.5711714594254, 3575.874844380447, 3596.496490491333, 3632.4551317302403, 5731.168980497825, 6197.5041996640275, 6208.472279856218, 6219.099532424689, 6238.750449982001, 5627.521660658849, 6238.53211009175, 6248.218972628421, 6266.874662506747, 6279.560430769837, 5486.067368547347, 5513.9448605513835, 5545.279113715232, 5563.916541251884, 5647.378788333301, 5467.617266791326, 5470.753816078286, 5516.420775818521, 5552.86117847055, 5661.122526008455, 5624.634398764088, 5627.0, 5628.887422251552, 5631.155326700987, 5672.149177623348, 5604.551635869121, 5613.550915926737, 5616.0171969905305, 5619.213310136584, 5624.240727501776, 5368.677879327252, 5385.488378604026, 5474.945250547523, 5526.447355264481, 5581.190727344553, 6017.277926648786, 6017.398260173992, 6116.031445915008, 6128.636540437044, 6130.306415576139, 6475.255345635265, 6477.902831457484, 6488.967555162194, 6504.869902601921, 6519.185101862267, 6523.967380163116, 6552.6068435894, 6597.0, 6604.537682362188, 6617.371349721769, 6107.226802228232, 6128.605979006185, 6284.277308109535, 6293.937060629335, 6315.431611154926, 6767.424768894601, 6779.49153813466, 6813.693383797741, 6818.795436136924, 6833.5216534843075, 6425.1968503937005, 6483.578567393104, 6495.772647957393, 6498.967505162538, 6513.023046543057, 5110.335656364723, 6351.333110023474, 6379.138816259839, 6636.800895973129, 6647.169103862017, 6047.576669633171, 6461.224653041571, 6551.770688025897, 6574.605523668595, 6575.145231119924, 6507.926192178332, 6574.506911981621, 6577.34226577348, 6597.538172327987, 6600.53796234259, 5234.42421333653, 5315.920261196085, 5317.7872885084935, 5320.654157479828, 5353.57171426285, 4647.024124933734, 4651.279051746985, 4709.222978208557, 4713.34013238147, 4754.358161648202, 6268.749250029948, 6270.2475702915945, 6300.30696623371, 6304.0, 6314.494840412756, 6510.18622672166, 6653.567518111307, 6656.467482601381, 6658.267590565034, 6665.633390163491, 6109.908351374733, 6277.654728989858, 6280.685965701697, 6281.842953926189, 6296.118543403927, 5722.37053924068, 5727.255456790591, 5736.483716465538, 5756.165356023437, 5760.2223699800825, 6676.566023208476, 6769.153855768029, 6803.149606299213, 6880.793576192722, 6912.688928998307, 6609.636469994004, 6667.533272670867, 6669.566478178903, 6673.733050677918, 6674.365935236145, 6849.1096157499205, 6877.484188685969, 6884.0018197360105, 6884.277150899284, 6885.242623311532, 6334.271558770801, 6377.330380310186, 6418.101465794886, 6421.101045853491, 6444.420002199825, 6446.033095035782, 6489.3510648934725, 6547.1161393211305, 6568.0, 6605.2734199239, 5897.7935772247765, 6402.775902843378, 6406.455451286506, 6416.615003099829, 6429.54993150475, 5605.355384130877, 6349.619022858643, 6366.586171898812, 6375.6174629522375, 6383.553151279366, 6177.351378105234, 6206.410391012847, 6278.15244941927, 6282.842928926813, 6324.335944725737, 6426.550141490051, 6428.357164283534, 6431.646259455775, 6435.549511534147, 6450.612963222222, 6282.937170628235, 6356.586821856565, 6356.841078972878, 6363.331850155667, 6369.0764839099], "value": 6056.7042085633575, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.4199988010312, 753.6420200404808, 807.0275318241518, 883.8541640629293, 893.6380765789858, 29776.553351699713, 41807.954801129985, 42276.0, 42307.0, 42393.99999999996, 42773.57226427735, 42983.14033719331, 43205.91985200372, 43260.783696081555, 43293.78353108238, 9770.65802696904, 9939.453330066843, 9943.502824858764, 9952.601895924154, 9959.800803983915, 7912.881306780374, 8095.757127286161, 11718.179727419041, 11851.348175850324, 12229.082818788582, 11950.282983021003, 12082.818757718642, 12098.213616114925, 12105.334206618632, 12108.0, 11988.980936620354, 12059.517619295219, 12062.819057714141, 12069.336186509738, 12072.637820865388, 11696.298222106616, 11769.470373833197, 11778.116641251854, 11781.293122412682, 11792.823107653392, 40269.17442842925, 40489.39265911013, 40510.392344114865, 40575.78272651825, 40580.59419405827, 3960.34654282046, 4004.2992476316526, 4010.2380547696134, 4031.093004074089, 4051.6353528182603, 27703.03039393632, 28425.715742842513, 30321.848390758125, 30663.693363066308, 30852.53721194184, 3131.5772370730115, 3199.8240096794666, 3322.0200040987966, 3368.6631336866117, 3386.102682789063, 367540.0, 373319.0, 373414.0, 373444.0, 374809.0, 52909.0, 53022.0, 53039.73480132574, 53060.20409693858, 53138.734306328224, 47341.5265847344, 52292.43122706325, 55061.174082388796, 55104.0, 55129.72435137798, 15053.247337633293, 15505.612359691098, 15513.844861551466, 15525.534233973, 15535.06789592628, 11878.465469053914, 13157.868421315856, 13160.670983225304, 13167.60497185086, 13177.077604567588, 10837.403942783223, 10877.510512026978, 13818.239996800072, 13955.0, 14008.089474184146, 5995.310539287951, 6104.847378815565, 6153.307840343941, 6162.383761623802, 6167.660778657217, 1091.44881834673, 1099.9715266225944, 1139.8461207737016, 1146.7018575170348, 1185.25921299188, 27880.721192787812, 27914.72085279121, 28506.144815655563, 28516.429671406455, 28523.28691782722, 1056.8203405420943, 1059.279689810936, 1196.682879037056, 1264.5015060690012, 1313.39583791457, 13976.860231397759, 14006.369713362923, 14146.363413646204, 14266.072705274331, 14270.143791372344, 503446.0, 506377.0, 506966.0, 507717.0, 508408.0, 57242.7137864308, 57273.427265727645, 57475.13787293194, 57511.712441438365, 57513.71243143841, 1439.942402303917, 1488.2558720639681, 1491.9403223870925, 1495.5513345996158, 1508.4343371235786, 26042.86978565095, 27257.0, 28099.17355371894, 28523.714762852935, 28613.713862861106, 38481.8455446337, 38671.0, 38693.613063869, 38766.0, 38789.03027424337, 473373.0, 475901.0, 476441.0, 477674.0, 477696.0, 30422.695773041985, 39944.201115978096, 40332.59667403406, 40344.0, 40491.0, 31874.203144920633, 40296.798516007235, 40408.1918361637, 52098.47901520936, 52284.47715522796, 33637.495437567966, 33800.49299260562, 33924.49113263254, 33972.49041264334, 35100.64899351076, 33008.33983320272, 33087.66912330846, 33478.497822533165, 33727.0, 34214.315713685086, 39395.40906886342, 39993.400098997954, 41060.0, 41122.76631701054, 41160.79419602883, 33687.0, 34011.31977360389, 34045.14887127842, 34269.65730342665, 34998.650013500555, 26584.734152658224, 26619.600705989815, 26670.0, 26715.79778909915, 27075.729242707323], "value": 19836.77146624268, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.2166795598034, 436.2757822015453, 437.6608128700258, 444.7353824474438, 448.6635023732199, 20449.795502044995, 21449.785502144994, 22814.31557053291, 23068.423289417773, 23097.191598294063, 22934.77065229347, 24243.515129697396, 24309.878450607768, 24453.02187912486, 24522.3869403265, 6678.532502724811, 6717.496187785923, 6935.930640693604, 7101.928980710204, 7134.678939447737, 6889.793306200822, 6955.547889387173, 7010.439164866824, 7014.438844892396, 7022.508424410294, 6644.9003264950825, 6859.657017149148, 6927.203371612253, 6933.549319294255, 6940.2712715164935, 6951.826204344881, 7003.579785212878, 7025.8594828103405, 7420.591867447289, 7756.224377562255, 7404.259574042607, 7668.923310766877, 7675.424343174284, 7682.8079298018, 7692.4615276930635, 27760.861195694095, 28250.152495424965, 28283.43433131326, 28299.717002829915, 28698.426031479252, 2991.7756168287247, 3053.0688140117254, 3088.552159936819, 3177.7457803375673, 3211.4379983502795, 12643.683907902285, 16727.414540491147, 16829.0, 16991.15044247795, 17608.767386282965, 2060.783617720148, 2065.5455799724036, 2081.6461201595766, 2086.447091520748, 2115.672070829024, 135892.0, 139051.30474347665, 141743.0, 142080.0, 158201.20899395546, 16181.271842767104, 19650.0, 20491.4877128073, 20564.897175514325, 20636.58726825485, 32723.0, 33335.83332083373, 33399.0, 33491.66508334934, 33575.328493429995, 8788.340874434443, 10606.681799546026, 10744.355338679548, 10908.34549927007, 11094.44527773608, 7517.060367454068, 9064.00295967443, 9082.000979892207, 9086.045965173562, 9246.445213287225, 9391.62433502666, 9530.761730956643, 9548.90451095494, 9610.615575377047, 9624.181944534654, 3434.5363375944426, 3975.9066256779615, 4054.2499637567144, 4061.5882658566356, 4079.265732168179, 948.5020364308793, 1024.9282550221562, 1028.5063169678447, 1047.502436342731, 1054.778496515725, 18203.54491137732, 21944.122235110415, 22196.556068878854, 22275.665865012037, 22321.776782232293, 1061.9150467962545, 1062.9627963021412, 1075.2580719303655, 1093.0, 1108.7083547666878, 10987.890121098846, 11542.881123912182, 11640.534378624929, 11678.824817627743, 11692.0, 776511.0, 776616.0, 787936.0, 796506.0, 798110.0, 119220.0, 162330.0, 165034.1748291275, 167236.0, 171704.0, 1205.2888795610631, 1228.6375519221851, 1261.432355440074, 1261.9305938173488, 1262.27419233939, 16072.598185045468, 17734.11329433549, 18179.54551136232, 19311.806881931563, 19452.02739862973, 63541.682291588244, 63544.68227658832, 64067.11697973509, 64301.78491075521, 65386.365340864955, 73359.26640733525, 85520.0, 91834.0, 93386.53306733423, 93680.0, 11471.541138354372, 11727.824082638937, 11980.58067967617, 12092.697682558006, 12160.756784864076, 10301.227407944285, 11600.535978560763, 12875.0, 13189.152790774806, 13219.867801321863, 11419.14356423255, 11617.186796924134, 11831.349275789915, 11834.82247766267, 11863.466144023712, 8707.216350528483, 8725.956370218108, 9812.165965892693, 10465.633702820669, 10563.20775941792, 11722.179447438597, 11759.882401175879, 11922.344271065174, 11988.220765650205, 12017.699557511132, 11697.2981621103, 11726.824097638713, 12051.276923384274, 12080.75838483208, 12094.455749491119, 11578.247413918405, 11590.246633968765, 11640.243384180001, 11740.06079513654, 11809.409529523318], "value": 11864.580691661724, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1386.5840247925619, 1598.3686443854679, 1627.9104649244302, 1630.3560093762965, 1643.8438348356906, 9559.091886270802, 9961.501924903752, 10085.394876307417, 10694.572217111325, 11454.713632159179, 11243.494042768074, 11343.432828358591, 11353.886461135386, 11362.829557556643, 11391.145664075186, 2388.8327817052814, 2436.11081955086, 2439.0365805506813, 2442.656538903596, 2446.1805295226122, 2081.739782527184, 2159.8704077755306, 2429.866357350345, 2494.5759220932396, 2519.546481633305, 2438.609822428412, 2441.841280316774, 2460.729319774823, 2465.285067330472, 2467.5558399488086, 2453.325335532725, 2454.5336386086765, 2458.5697502937005, 2460.2127319257843, 2461.2985299189645, 2386.2244770449674, 2411.180198732422, 2424.5393375258645, 2427.2596857958315, 2431.756824317572, 11453.484593193327, 11534.134939879543, 11538.76922461546, 11549.595764148215, 11642.301461912228, 5956.702164891738, 6136.6011209271255, 6138.508919286446, 6143.139960405547, 6150.815475535741, 3397.69420752131, 3409.5567576214935, 3604.42329227325, 3641.5448068991377, 3652.5799533053773, 1204.6988252936767, 1222.1444988507992, 1228.2875931959531, 1260.4706023470073, 1267.4930027988787, 12985.675358116028, 15464.381424742996, 15566.688666226726, 15572.221388930508, 15584.844151558453, 4817.229243321051, 5053.191489361684, 5103.7192954387865, 5121.3854337479, 5138.818071843422, 10988.395638239814, 13082.28047457399, 13082.738345233232, 13107.0, 13108.80336794949, 6010.9699451502465, 6165.630062196283, 6177.96911015442, 6180.969095154495, 6194.659293738798, 4684.578387945101, 5224.7126408047925, 5414.8917021659345, 5437.782488700487, 5502.862428439321, 3625.9093522661615, 3772.4718539404507, 3871.5160604924386, 4176.248275310473, 4294.656427485794, 1131.6322195286564, 1148.661144962238, 1153.529250205994, 1164.8602167739925, 1166.5100657723776, 813.8209593889335, 852.8294341131799, 861.328164032056, 871.7951281448854, 895.3240303570892, 5221.399539052982, 6133.742582770521, 6676.0, 6782.084418603524, 6822.556533825285, 838.7106448275335, 849.2696281198165, 880.2473884828507, 945.2910317262053, 1004.3622299839508, 4117.608827161415, 4193.853215137456, 4209.305464598368, 4326.524082350938, 4355.455568053993, 13575.253361065235, 14133.505327313494, 14284.57146285613, 14287.214203218922, 14290.285485725672, 13630.250336231404, 13844.377003034888, 14196.432142714175, 14211.005229633827, 14222.644433889029, 8442.831143377098, 10416.427096509613, 10438.843417348746, 10497.475126243657, 10593.52329145175, 6683.933160668331, 6685.899711504234, 6745.9662701686175, 6772.627505487246, 6840.179178498612, 12356.876431235572, 12701.872981270439, 12705.047121465743, 12726.17279876805, 12727.427265772878, 12666.936665316614, 12783.105182637499, 12848.100632955977, 12865.935670321589, 12879.420426080662, 9328.02055784133, 9339.252859771337, 9424.057594240521, 9431.62273509052, 9436.197923176607, 9154.221891139328, 9949.751256218364, 10334.844977325196, 10515.94742026285, 10803.837942430713, 9132.49771262587, 9212.815743684954, 9231.399959002643, 9291.581878815605, 9397.342186046912, 8785.912140878509, 8870.77823054403, 8939.642414303615, 9011.279097672039, 9046.954765226132, 8070.798230044295, 8221.218984196492, 8231.300339471212, 8231.629576669184, 8239.917600823916, 5996.820095397145, 6067.575269731076, 6093.573449858467, 6223.751049957951, 6256.624602523863, 6064.575479716377, 6103.145559621567, 6109.11417844419, 6177.62934223948, 6245.9063114052415], "value": 5231.031765072296, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.3297179393753, 386.8955382046847, 387.5059299393275, 392.19012738694585, 392.9115948911493, 4622.838200662977, 4993.7003779773195, 5031.861129422108, 5050.621203409745, 5060.367454068246, 4144.544100148989, 4589.495155532889, 4944.381952255968, 4952.479989601094, 4981.277714731362, 3899.610038996099, 3925.8429662813455, 3955.8417663293435, 3978.5424676162324, 3980.7213495055357, 3593.7664051836678, 3960.8019599020076, 3964.0288129408336, 3968.30554652936, 3997.7401468904573, 3365.326934613075, 3786.9775160706595, 3880.26275007749, 3901.55132159801, 3910.882673519785, 3409.7954122752712, 3688.1517251032415, 3911.4328422378594, 3917.6474117329576, 3965.6430921217084, 3080.476319025771, 3463.6709512596262, 3504.8072356020407, 3511.0864578804612, 3517.803946658123, 4162.587657083471, 4513.345564893105, 4605.424321959755, 4916.984036545035, 4948.6493915390265, 3845.8269377878064, 4428.158649856549, 4519.4802597701355, 4549.772511374418, 4610.792514336829, 4308.4399028126145, 4861.611071114302, 5306.363236411656, 5326.520613144836, 5344.824138689482, 3589.838457269429, 4321.2653848845775, 4328.264195086843, 4342.804573794187, 4355.716878402894, 4707.741074240916, 4837.37114175155, 5335.772772262362, 5727.455891690282, 5749.856253593652, 3817.8854634361014, 3883.630915220377, 4049.250888585621, 4068.247374235776, 4237.3558739484015, 3594.964050359463, 4463.553644635511, 4471.128130014681, 4485.75712143928, 4518.43519560055, 4192.685548583869, 4269.658427325807, 4476.776161191928, 4787.904241915142, 4841.491643377465, 4237.855778939669, 4735.857924262277, 4868.3427737255015, 4948.703077815343, 5346.0, 1416.8370637376627, 1471.073223868977, 1529.7093552225042, 1539.7536394176877, 1541.8282105599824, 920.2408013388847, 1101.124605938281, 1141.8230174322994, 1161.517970042423, 1173.202222488699, 4363.345498175299, 4468.776561171993, 4626.676132670748, 4959.628027897922, 4977.203647416396, 4518.367428560005, 4913.70517768935, 5138.486151384906, 5309.36287645485, 5504.559635229172, 3856.6143385661208, 4662.673612847136, 4960.107180707435, 4974.651774375759, 4992.500749924979, 2336.5279873679474, 2490.95018099637, 2512.987435062813, 2669.0, 2733.603627474005, 4504.684672072924, 4685.016146609182, 4992.700437973734, 5523.011715782315, 5706.885862282731, 4815.903681926342, 4949.94577250437, 5064.442911279756, 5587.14487003974, 5679.67738872764, 5039.672421292677, 5356.705381204071, 5439.48324909133, 5534.395025442657, 5551.361593416728, 4303.806328715278, 4935.851924442272, 5176.240078373371, 5219.686818790885, 5420.82596400777, 4763.833265835679, 5219.973900130475, 5302.549283310807, 5380.73096345189, 5470.617056805985, 4884.460080758057, 5023.34696489454, 5321.840344789508, 5378.327709036371, 5387.683296182679, 3870.709696772697, 3986.1464419045283, 4114.321137012359, 4353.434053573015, 4357.758038958881, 5081.212412076134, 5159.716215608178, 5180.585553155814, 5319.601029922848, 5414.783408663609, 4393.714408563433, 4647.744374059459, 5146.614003949644, 5394.838154855361, 5398.811041613525, 4593.885152871205, 4777.877198858335, 5275.366955965309, 5276.498732620395, 5287.867803304948, 4763.833265835679, 4766.880827979189, 4969.328830898943, 5180.456052114474, 5267.60492963037, 4547.613452856544, 5028.949710502849, 5121.667091639031, 5351.5183633471615, 5351.919721204263, 4499.020431010345, 4846.5153484651255, 5246.845693947325, 5257.63196576236, 5293.629445938747], "value": 3972.1202825864334, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.7785042337722, 781.5388920536882, 802.1216767639432, 819.9344052475801, 889.6485888074211, 15092.77360839587, 15514.146721930289, 15531.145786981711, 15547.766783498242, 15555.766663500057, 16164.515064548053, 16178.919105404486, 16184.514464566053, 16311.59221019475, 16388.75416868748, 880.7049638371121, 989.5349185882642, 1008.0263223490695, 1056.2025670618673, 1057.9153667706603, 1046.638909576195, 1047.8323468245082, 1049.0244073012095, 1049.029647575993, 1049.4805071489623, 1083.4311986207226, 1083.9241253112286, 1083.9458027098653, 1084.2464487181412, 1084.262701363073, 1075.198976762317, 1077.3912739302268, 1077.8652668416448, 1078.6116997880836, 1080.0, 800.3837045474952, 800.9907516529215, 802.3901834605741, 803.6544285957036, 804.4328748232541, 17456.738148927776, 17639.294428222856, 18000.369987050522, 18227.270909163617, 18453.815461845345, 14685.706285874223, 14793.0, 14820.3330850112, 14930.850691493055, 15208.847911520854, 11984.940075299568, 12104.636860894187, 12303.507859685602, 12319.199252048587, 12625.0, 3763.419363867155, 3823.235352929425, 3970.1265721541213, 4062.984253936516, 4107.301758701028, 113693.0, 115287.99999999916, 121140.0, 123120.76879231272, 124948.0, 9989.30074894765, 10225.539850706737, 10232.64185753495, 10266.845997310047, 10549.6946141033, 23697.0, 24085.879570602036, 24272.514549708907, 24298.757012430004, 24448.0, 8001.0, 8151.307138893142, 8239.588020598947, 8398.202170793887, 8470.957645211734, 4453.15390075891, 4457.509673935864, 4490.281554951192, 4495.707778994355, 4533.569310915458, 3444.9827750861086, 3738.4018557030745, 3745.887623371303, 3754.267917756066, 3754.9436758448646, 632.5477283742147, 635.6249812610582, 651.4495251512465, 658.7122176145624, 662.5726406467801, 591.6982339007051, 669.7555392281782, 690.3683129936153, 696.095076400677, 726.8982342472058, 10606.469676516142, 10832.40421776794, 10894.509747061402, 11026.338419694845, 11159.497822598003, 655.7999810057883, 694.4756708685012, 697.2504557600599, 700.2052670219338, 706.7031846624327, 4842.903141937141, 5149.948500514947, 5214.14347563334, 5267.104592219332, 5271.973640131775, 90088.5495572518, 93237.5338123305, 117098.26514823598, 120489.0, 120606.79393205956, 50862.74568627133, 99351.51621209527, 103490.96509034814, 105654.0, 108074.0, 74751.62624186845, 77728.61135694286, 80614.19385806067, 80869.0, 82511.17488825035, 11073.390963497084, 11248.493817778057, 11274.323540587591, 11438.771224575628, 11516.42417879086, 49471.25793113034, 50629.74685126551, 50712.74643626758, 51530.48469515257, 53109.46890531045, 59412.3264453092, 74114.25885741289, 76648.61675691586, 76951.61524192343, 78847.0, 13643.433966952416, 13718.93140534291, 13723.862761372258, 14316.785248221493, 14370.209638469985, 15691.372345106069, 15837.0, 15848.52454426369, 15904.0, 15975.85773164073, 14739.189344586151, 14930.701385972003, 14936.925315373353, 15064.548063558112, 15264.465743698916, 14098.577042688736, 14230.405573525753, 14764.926175369055, 14895.627609309853, 14905.105693658415, 12898.290594017419, 13749.175049496662, 14845.851541484446, 15118.319675614404, 15137.243137843285, 10252.692419227435, 10344.0, 10469.424181670081, 10636.8936310639, 10752.623658171926, 11368.488418021374, 11766.470508827295, 11773.175877688822, 11790.94104529472, 11795.587154449553], "value": 8104.403174963466, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1432.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 116.0, 117.0, 119.0, 117.0, 115.0, 117.0, 116.0, 116.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 135.0, 132.0, 140.0, 110.0, 116.0, 134.0, 121.0, 124.0, 107.0], "value": 125.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 182.0, 181.0, 187.0, 182.0, 183.0, 184.0, 184.0, 204.0], "value": 185.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 59.0, 93.0, 61.0, 58.0, 59.0, 58.0, 74.0, 59.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 70.0, 72.0, 71.0, 71.0, 99.0, 113.0, 99.0, 77.0, 83.0], "value": 84.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 126.0, 136.0, 100.0, 86.0, 88.0, 87.0, 87.0, 88.0], "value": 97.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 95.0, 94.0, 93.0, 95.0, 94.0, 98.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 83.0, 82.0, 83.0, 84.0, 83.0, 84.0, 83.0], "value": 83.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 62.0, 63.0, 64.0, 62.0, 62.0, 64.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 64.0, 54.0, 64.0, 60.0, 56.0, 59.0, 59.0, 57.0, 57.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 85.0, 82.0, 83.0, 82.0, 86.0, 87.0, 82.0, 108.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 136.0, 149.0, 147.0, 138.0, 133.0, 123.0, 144.0, 166.0, 139.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [209.0, 186.0, 162.0, 163.0, 158.0, 163.0, 162.0, 162.0, 161.0, 161.0], "value": 168.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 64.0, 63.0, 64.0, 63.0, 62.0, 60.0, 63.0], "value": 62.9, "unit": "score"}]}]} 14:19:45 INFO - Return code: 0 14:19:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:19:46 INFO - # TBPL SUCCESS # 14:19:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:19:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:19:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:19:46 INFO - 2017-04-25 14:19:46.035 screenresolution[1658:9998] starting screenresolution argv=screenresolution get 14:19:46 INFO - 2017-04-25 14:19:46.038 screenresolution[1658:9998] Display 0: 1600x1200x32@60 14:19:46 INFO - 2017-04-25 14:19:46.044 screenresolution[1659:10001] starting screenresolution argv=screenresolution list 14:19:46 INFO - Available Modes on Display 0 14:19:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:19:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:19:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:19:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:19:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:19:46 INFO - Intel Iris: 14:19:46 INFO - Chipset Model: Intel Iris 14:19:46 INFO - Type: GPU 14:19:46 INFO - Bus: Built-In 14:19:46 INFO - VRAM (Dynamic, Max): 1536 MB 14:19:46 INFO - Vendor: Intel (0x8086) 14:19:46 INFO - Device ID: 0x0a2e 14:19:46 INFO - Revision ID: 0x0009 14:19:46 INFO - Displays: 14:19:46 INFO - Display: 14:19:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:19:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:19:46 INFO - Display Serial Number: 1600x1200 60 14:19:46 INFO - Main Display: Yes 14:19:46 INFO - Mirror: Off 14:19:46 INFO - Online: Yes 14:19:46 INFO - Rotation: Supported 14:19:46 INFO - Return code: 0 14:19:46 INFO - Running post-action listener: _resource_record_post_action 14:19:46 INFO - [mozharness: 2017-04-25 21:19:46.284926Z] Finished run-tests step (success) 14:19:46 INFO - Running post-run listener: _resource_record_post_run 14:19:46 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 37958656; Write bytes: 423723008; Read time: 246; Write time: 1417 14:19:46 INFO - TinderboxPrint: CPU usage
53.6% 14:19:46 INFO - TinderboxPrint: I/O read bytes / time
37,958,656 / 246 14:19:46 INFO - TinderboxPrint: I/O write bytes / time
423,723,008 / 1,417 14:19:46 INFO - TinderboxPrint: CPU idle
2,213.6 (46.4%) 14:19:46 INFO - TinderboxPrint: CPU system
949.6 (19.9%) 14:19:46 INFO - TinderboxPrint: CPU user
1,610.5 (33.7%) 14:19:46 INFO - TinderboxPrint: Swap in / out
160,296,960 / 0 14:19:46 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 123042304; Write bytes: 122830848; Read time: 11184; Write time: 288 14:19:46 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 33989632; Write bytes: 299524096; Read time: 220; Write time: 1123 14:19:46 INFO - Running post-run listener: _upload_blobber_files 14:19:46 INFO - Blob upload gear active. 14:19:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:19:46 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 14:19:46 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:19:46 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:19:47 INFO - (blobuploader) - INFO - Open directory for files ... 14:19:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:19:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:19:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:19:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:19:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:19:48 INFO - (blobuploader) - INFO - Done attempting. 14:19:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:19:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:19:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:19:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:19:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:19:49 INFO - (blobuploader) - INFO - Done attempting. 14:19:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:19:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:19:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:19:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:19:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:19:50 INFO - (blobuploader) - INFO - Done attempting. 14:19:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:19:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:19:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:19:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:19:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:19:52 INFO - (blobuploader) - INFO - Done attempting. 14:19:52 INFO - (blobuploader) - INFO - Iteration through files over. 14:19:52 INFO - Return code: 0 14:19:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:19:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:19:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/95822bb1e0f651369ad6436c7d0ad0ce8ff6e0e86f156289ba9dc03d73d7cbc35e41d87963a678ccdb4cae426cfe919c21733eea347cc2b7ed5a07d7b5383827", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1d1aa179148451e90f74dbc9f8f9fa710a8b0d7078a1c389d251ac1549cf5dd99dd0735261ca01daf8b2ebb06cf370d106b7a32a1f1ac30acc07339b5bca46e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/18095dad4efbd6d8f2fbe4cc1a351d1bf9fb7bab9296db826bbc6da1e0299b9c168de57b399f364a58dd7195e24c7b827a28ccea418ee0bd8b2774f6cd4c7198", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a37dce542a35fdd5a4d36ae840b2d4fbf434139930f1b12dadf2a07c6befcab821c434f86e26d61112d2233b7386dc3bc4b70ab52750c252b1b4fac98a8cc0ca"} 14:19:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:19:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:19:52 INFO - Contents: 14:19:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/95822bb1e0f651369ad6436c7d0ad0ce8ff6e0e86f156289ba9dc03d73d7cbc35e41d87963a678ccdb4cae426cfe919c21733eea347cc2b7ed5a07d7b5383827", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1d1aa179148451e90f74dbc9f8f9fa710a8b0d7078a1c389d251ac1549cf5dd99dd0735261ca01daf8b2ebb06cf370d106b7a32a1f1ac30acc07339b5bca46e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/18095dad4efbd6d8f2fbe4cc1a351d1bf9fb7bab9296db826bbc6da1e0299b9c168de57b399f364a58dd7195e24c7b827a28ccea418ee0bd8b2774f6cd4c7198", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a37dce542a35fdd5a4d36ae840b2d4fbf434139930f1b12dadf2a07c6befcab821c434f86e26d61112d2233b7386dc3bc4b70ab52750c252b1b4fac98a8cc0ca"} 14:19:52 INFO - Running post-run listener: copy_logs_to_upload_dir 14:19:52 INFO - Copying logs to upload dir... 14:19:52 INFO - mkdir: /builds/slave/test/build/upload/logs 14:19:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.129662 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-04-25 14:19:52.646494) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 14:19:52.649780) ========= 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.z5LlEe3fFP/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.Cb4dvXcywe/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/95822bb1e0f651369ad6436c7d0ad0ce8ff6e0e86f156289ba9dc03d73d7cbc35e41d87963a678ccdb4cae426cfe919c21733eea347cc2b7ed5a07d7b5383827", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1d1aa179148451e90f74dbc9f8f9fa710a8b0d7078a1c389d251ac1549cf5dd99dd0735261ca01daf8b2ebb06cf370d106b7a32a1f1ac30acc07339b5bca46e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/18095dad4efbd6d8f2fbe4cc1a351d1bf9fb7bab9296db826bbc6da1e0299b9c168de57b399f364a58dd7195e24c7b827a28ccea418ee0bd8b2774f6cd4c7198", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a37dce542a35fdd5a4d36ae840b2d4fbf434139930f1b12dadf2a07c6befcab821c434f86e26d61112d2233b7386dc3bc4b70ab52750c252b1b4fac98a8cc0ca"} build_url:https://queue.taskcluster.net/v1/task/Q4mLc-7iQ8yBVdYeRHtzeA/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010980 build_url: 'https://queue.taskcluster.net/v1/task/Q4mLc-7iQ8yBVdYeRHtzeA/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/95822bb1e0f651369ad6436c7d0ad0ce8ff6e0e86f156289ba9dc03d73d7cbc35e41d87963a678ccdb4cae426cfe919c21733eea347cc2b7ed5a07d7b5383827", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1d1aa179148451e90f74dbc9f8f9fa710a8b0d7078a1c389d251ac1549cf5dd99dd0735261ca01daf8b2ebb06cf370d106b7a32a1f1ac30acc07339b5bca46e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/18095dad4efbd6d8f2fbe4cc1a351d1bf9fb7bab9296db826bbc6da1e0299b9c168de57b399f364a58dd7195e24c7b827a28ccea418ee0bd8b2774f6cd4c7198", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a37dce542a35fdd5a4d36ae840b2d4fbf434139930f1b12dadf2a07c6befcab821c434f86e26d61112d2233b7386dc3bc4b70ab52750c252b1b4fac98a8cc0ca"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 14:19:52.684904) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 14:19:52.685234) ========= 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.z5LlEe3fFP/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.Cb4dvXcywe/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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.005099 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 14:19:52.734298) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 14:19:52.734607) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 14:19:52.734932) ========= ========= Total master_lag: 0.18 =========