builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0063 starttime: 1492636174.23 results: success (0) buildid: 20170419124120 builduid: 7d603aadfed24fcebb19fff0cd525122 revision: e1a3ba300627bf1e8edc606ee3591a24ac8a994a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-19 14:09:34.228234) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-19 14:09:34.228628) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-19 14:09:34.228917) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-19 14:09:34.820743) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-04-19 14:09:34.821189) ========= 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.1gELGd2uox/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.eVmepHBRN9/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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-19 14:09:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 215M=0s 2017-04-19 14:09:34 (215 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097618 ========= master_lag: 4.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-04-19 14:09:38.979816) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 14:09:38.980167) ========= 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.1gELGd2uox/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.eVmepHBRN9/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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.028374 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 14:09:39.031368) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 14:09:39.031716) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e1a3ba300627bf1e8edc606ee3591a24ac8a994a --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 e1a3ba300627bf1e8edc606ee3591a24ac8a994a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1gELGd2uox/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.eVmepHBRN9/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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-19 14:09:39,152 truncating revision to first 12 chars 2017-04-19 14:09:39,152 Setting DEBUG logging. 2017-04-19 14:09:39,152 attempt 1/10 2017-04-19 14:09:39,153 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e1a3ba300627?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-19 14:09:39,621 unpacking tar archive at: mozilla-beta-e1a3ba300627/testing/mozharness/ program finished with exit code 0 elapsedTime=0.736381 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 14:09:39.791302) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-19 14:09:39.791606) ========= script_repo_revision: e1a3ba300627bf1e8edc606ee3591a24ac8a994a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-19 14:09:39.792049) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-19 14:09:39.792316) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-19 14:09:39.812000) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-19 14:09:39.812390) ========= /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.1gELGd2uox/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.eVmepHBRN9/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 14:09:40 INFO - MultiFileLogger online at 20170419 14:09:40 in /builds/slave/test 14:09:40 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 14:09:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:09:40 INFO - {'append_to_log': False, 14:09:40 INFO - 'base_work_dir': '/builds/slave/test', 14:09:40 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:09:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:09:40 INFO - 'branch': 'Mozilla-Beta', 14:09:40 INFO - 'buildbot_json_path': 'buildprops.json', 14:09:40 INFO - 'config_files': ('talos/mac_config.py',), 14:09:40 INFO - 'default_actions': ('clobber', 14:09:40 INFO - 'read-buildbot-config', 14:09:40 INFO - 'download-and-extract', 14:09:40 INFO - 'populate-webroot', 14:09:40 INFO - 'create-virtualenv', 14:09:40 INFO - 'install', 14:09:40 INFO - 'run-tests'), 14:09:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:09:40 INFO - 'download_minidump_stackwalk': True, 14:09:40 INFO - 'download_symbols': 'ondemand', 14:09:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:09:40 INFO - 'tooltool.py': '/tools/tooltool.py', 14:09:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:09:40 INFO - '/tools/misc-python/virtualenv.py')}, 14:09:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:09:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:09:40 INFO - 'gecko_profile': False, 14:09:40 INFO - 'gecko_profile_interval': 0, 14:09:40 INFO - 'installer_path': 'installer.exe', 14:09:40 INFO - 'log_level': 'info', 14:09:40 INFO - 'log_name': 'talos', 14:09:40 INFO - 'log_to_console': True, 14:09:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:09:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:09:40 INFO - 'opt_config_files': (), 14:09:40 INFO - 'pip_index': False, 14:09:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:09:40 INFO - 'cmd': ('bash', 14:09:40 INFO - '-c', 14:09:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:09:40 INFO - 'enabled': True, 14:09:40 INFO - 'halt_on_failure': False, 14:09:40 INFO - 'name': 'check_screen_resolution'},), 14:09:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:09:40 INFO - 'cmd': ('bash', 14:09:40 INFO - '-c', 14:09:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:09:40 INFO - 'enabled': True, 14:09:40 INFO - 'halt_on_failure': False, 14:09:40 INFO - 'name': 'check_screen_resolution'},), 14:09:40 INFO - 'run_cmd_checks_enabled': True, 14:09:40 INFO - 'suite': 'dromaeojs', 14:09:40 INFO - 'system_bits': '32', 14:09:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:09:40 INFO - 'title': 't-yosemite-r7-0063', 14:09:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:09:40 INFO - 'use_talos_json': True, 14:09:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:09:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:09:40 INFO - 'work_dir': 'build'} 14:09:40 INFO - [mozharness: 2017-04-19 21:09:40.043385Z] Running clobber step. 14:09:40 INFO - Running pre-action listener: _resource_record_pre_action 14:09:40 INFO - Running main action method: clobber 14:09:40 INFO - rmtree: /builds/slave/test/build 14:09:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:09:42 INFO - Running post-action listener: _resource_record_post_action 14:09:42 INFO - [mozharness: 2017-04-19 21:09:42.505476Z] Finished clobber step (success) 14:09:42 INFO - [mozharness: 2017-04-19 21:09:42.505603Z] Running read-buildbot-config step. 14:09:42 INFO - Running pre-action listener: _resource_record_pre_action 14:09:42 INFO - Running main action method: read_buildbot_config 14:09:42 INFO - Using buildbot properties: 14:09:42 INFO - { 14:09:42 INFO - "project": "", 14:09:42 INFO - "product": "firefox", 14:09:42 INFO - "script_repo_revision": "production", 14:09:42 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 14:09:42 INFO - "repository": "", 14:09:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 14:09:42 INFO - "buildid": "20170419124120", 14:09:42 INFO - "pgo_build": "False", 14:09:42 INFO - "basedir": "/builds/slave/test", 14:09:42 INFO - "buildnumber": 1, 14:09:42 INFO - "slavename": "t-yosemite-r7-0063", 14:09:42 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 14:09:42 INFO - "platform": "yosemite_r7", 14:09:42 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:09:42 INFO - "branch": "mozilla-beta", 14:09:42 INFO - "repo_path": "releases/mozilla-beta", 14:09:42 INFO - "revision": "e1a3ba300627bf1e8edc606ee3591a24ac8a994a", 14:09:42 INFO - "stage_platform": "macosx64", 14:09:42 INFO - "builduid": "7d603aadfed24fcebb19fff0cd525122", 14:09:42 INFO - "slavebuilddir": "test" 14:09:42 INFO - } 14:09:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/MHFkCzUVTp-DT-SXzYzY-Q/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 14:09:42 INFO - Running post-action listener: _resource_record_post_action 14:09:42 INFO - [mozharness: 2017-04-19 21:09:42.508984Z] Finished read-buildbot-config step (success) 14:09:42 INFO - [mozharness: 2017-04-19 21:09:42.509110Z] Running download-and-extract step. 14:09:42 INFO - Running pre-action listener: _resource_record_pre_action 14:09:42 INFO - Running main action method: download_and_extract 14:09:42 INFO - mkdir: /builds/slave/test/build/tests 14:09:42 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:09:42 INFO - trying https://queue.taskcluster.net/v1/task/MHFkCzUVTp-DT-SXzYzY-Q/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 14:09:42 INFO - Downloading https://queue.taskcluster.net/v1/task/MHFkCzUVTp-DT-SXzYzY-Q/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 14:09:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MHFkCzUVTp-DT-SXzYzY-Q/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 14:09:43 INFO - Downloaded 1165 bytes. 14:09:43 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 14:09:43 INFO - Using the following test package requirements: 14:09:43 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 14:09:43 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:09:43 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 14:09:43 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:09:43 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 14:09:43 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:09:43 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:09:43 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 14:09:43 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 14:09:43 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:09:43 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 14:09:43 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:09:43 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 14:09:43 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:09:43 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 14:09:43 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:09:43 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 14:09:43 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 14:09:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MHFkCzUVTp-DT-SXzYzY-Q/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 14:09:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MHFkCzUVTp-DT-SXzYzY-Q/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 14:09:43 INFO - Fetch https://queue.taskcluster.net/v1/task/MHFkCzUVTp-DT-SXzYzY-Q/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 14:09:45 INFO - Expected file size: 51221102 14:09:45 INFO - Obtained file size: 51221102 14:10:00 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 14:10:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MHFkCzUVTp-DT-SXzYzY-Q/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 14:10:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MHFkCzUVTp-DT-SXzYzY-Q/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 14:10:00 INFO - Fetch https://queue.taskcluster.net/v1/task/MHFkCzUVTp-DT-SXzYzY-Q/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 14:10:02 INFO - Expected file size: 51221102 14:10:02 INFO - Obtained file size: 51221102 14:10:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MHFkCzUVTp-DT-SXzYzY-Q/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 14:10:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MHFkCzUVTp-DT-SXzYzY-Q/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 14:10:17 INFO - Fetch https://queue.taskcluster.net/v1/task/MHFkCzUVTp-DT-SXzYzY-Q/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 14:10:19 INFO - Expected file size: 14404424 14:10:19 INFO - Obtained file size: 14404424 14:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:19 INFO - trying https://queue.taskcluster.net/v1/task/MHFkCzUVTp-DT-SXzYzY-Q/artifacts/public/build/firefox-54.0.en-US.mac.dmg 14:10:19 INFO - Downloading https://queue.taskcluster.net/v1/task/MHFkCzUVTp-DT-SXzYzY-Q/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 14:10:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MHFkCzUVTp-DT-SXzYzY-Q/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 14:10:21 INFO - Downloaded 59193517 bytes. 14:10:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MHFkCzUVTp-DT-SXzYzY-Q/artifacts/public/build/firefox-54.0.en-US.mac.dmg 14:10:21 INFO - mkdir: /builds/slave/test/properties 14:10:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:10:21 INFO - Writing to file /builds/slave/test/properties/build_url 14:10:21 INFO - Contents: 14:10:21 INFO - build_url:https://queue.taskcluster.net/v1/task/MHFkCzUVTp-DT-SXzYzY-Q/artifacts/public/build/firefox-54.0.en-US.mac.dmg 14:10:22 INFO - Running post-action listener: _resource_record_post_action 14:10:22 INFO - Running post-action listener: set_extra_try_arguments 14:10:22 INFO - [mozharness: 2017-04-19 21:10:22.177735Z] Finished download-and-extract step (success) 14:10:22 INFO - [mozharness: 2017-04-19 21:10:22.177877Z] Running populate-webroot step. 14:10:22 INFO - Running pre-action listener: _resource_record_pre_action 14:10:22 INFO - Running main action method: populate_webroot 14:10:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:10:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:10:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:10:22 INFO - '--tppagecycles', 14:10:22 INFO - '7'], 14:10:22 INFO - 'tests': ['tsvgm']}}, 14:10:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:10:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:10:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:10:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:10:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:10:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:10:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:10:22 INFO - 'talos_options': ['--disable-e10s'], 14:10:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:10:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:10:22 INFO - 'talos_options': ['--disable-e10s'], 14:10:22 INFO - 'tests': ['damp', 'tps']}, 14:10:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:10:22 INFO - 'tests': ['damp', 'tps']}, 14:10:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:10:22 INFO - 'tests': ['dromaeo_dom']}, 14:10:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:10:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:10:22 INFO - 'tests': ['basic_compositor_video']}, 14:10:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:10:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:10:22 INFO - 'tests': ['a11yr', 14:10:22 INFO - 'ts_paint', 14:10:22 INFO - 'tpaint', 14:10:22 INFO - 'sessionrestore', 14:10:22 INFO - 'sessionrestore_no_auto_restore', 14:10:22 INFO - 'tabpaint']}, 14:10:22 INFO - 'other-e10s': {'tests': ['a11yr', 14:10:22 INFO - 'ts_paint', 14:10:22 INFO - 'tpaint', 14:10:22 INFO - 'sessionrestore', 14:10:22 INFO - 'sessionrestore_no_auto_restore', 14:10:22 INFO - 'tabpaint']}, 14:10:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:10:22 INFO - 'ts_paint', 14:10:22 INFO - 'tpaint', 14:10:22 INFO - 'sessionrestore', 14:10:22 INFO - 'sessionrestore_no_auto_restore', 14:10:22 INFO - 'tabpaint']}, 14:10:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:10:22 INFO - 'ts_paint', 14:10:22 INFO - 'tpaint', 14:10:22 INFO - 'sessionrestore', 14:10:22 INFO - 'sessionrestore_no_auto_restore', 14:10:22 INFO - 'tabpaint']}, 14:10:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:10:22 INFO - 'tests': ['a11yr', 14:10:22 INFO - 'ts_paint', 14:10:22 INFO - 'tpaint', 14:10:22 INFO - 'sessionrestore', 14:10:22 INFO - 'sessionrestore_no_auto_restore', 14:10:22 INFO - 'tabpaint']}, 14:10:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:10:22 INFO - 'tests': ['a11yr', 14:10:22 INFO - 'ts_paint', 14:10:22 INFO - 'tpaint', 14:10:22 INFO - 'sessionrestore', 14:10:22 INFO - 'sessionrestore_no_auto_restore', 14:10:22 INFO - 'tabpaint']}, 14:10:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:10:22 INFO - 'tests': ['tsvgx', 14:10:22 INFO - 'tsvgr_opacity', 14:10:22 INFO - 'tart', 14:10:22 INFO - 'tscrollx', 14:10:22 INFO - 'cart', 14:10:22 INFO - 'tsvg_static']}, 14:10:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:10:22 INFO - 'tsvgr_opacity', 14:10:22 INFO - 'tart', 14:10:22 INFO - 'tscrollx', 14:10:22 INFO - 'cart', 14:10:22 INFO - 'tsvg_static']}, 14:10:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:10:22 INFO - 'talos_options': ['--disable-e10s'], 14:10:22 INFO - 'tests': ['tp5o']}, 14:10:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:10:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:10:22 INFO - 'talos_options': ['--disable-e10s', 14:10:22 INFO - '--xperf_path', 14:10:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:10:22 INFO - 'tests': ['tp5n']}, 14:10:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:10:22 INFO - 'talos_options': ['--xperf_path', 14:10:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:10:22 INFO - 'tests': ['tp5n']}}, 14:10:22 INFO - 'talos.zip': {'path': '', 14:10:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:10:22 INFO - Running post-action listener: _resource_record_post_action 14:10:22 INFO - [mozharness: 2017-04-19 21:10:22.196138Z] Finished populate-webroot step (success) 14:10:22 INFO - [mozharness: 2017-04-19 21:10:22.196271Z] Running create-virtualenv step. 14:10:22 INFO - Running pre-action listener: _resource_record_pre_action 14:10:22 INFO - Running main action method: create_virtualenv 14:10:22 INFO - Creating virtualenv /builds/slave/test/build/venv 14:10:22 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 14:10:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:10:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:10:22 INFO - Using real prefix '/tools/python27' 14:10:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:10:23 INFO - Installing distribute.............................................................................................................................................................................................done. 14:10:25 INFO - Installing pip.................done. 14:10:25 INFO - Return code: 0 14:10:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:10:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:10:26 INFO - Reading from file tmpfile_stdout 14:10:26 INFO - Output received: 14:10:26 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) 14:10:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:10:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100faab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94304a4d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d88d30>, '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 0x100cafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d7dbe8>, '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.1gELGd2uox/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.eVmepHBRN9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 14:10:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:10:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:10:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gELGd2uox/Render', 14:10:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:26 INFO - 'HOME': '/Users/cltbld', 14:10:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:26 INFO - 'LOGNAME': 'cltbld', 14:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:26 INFO - 'MOZ_NO_REMOTE': '1', 14:10:26 INFO - 'NO_EM_RESTART': '1', 14:10:26 INFO - 'PAGER': '/bin/cat', 14:10:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:26 INFO - 'PWD': '/builds/slave/test', 14:10:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:26 INFO - 'SHELL': '/bin/bash', 14:10:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eVmepHBRN9/Listeners', 14:10:26 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 14:10:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:26 INFO - 'USER': 'cltbld', 14:10:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:26 INFO - 'XPC_FLAGS': '0x0', 14:10:26 INFO - 'XPC_SERVICE_NAME': '0', 14:10:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:27 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 14:10:27 INFO - Cleaning up... 14:10:27 INFO - Return code: 0 14:10:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:10:27 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:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:27 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:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:27 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 0x100faab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94304a4d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d88d30>, '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 0x100cafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d7dbe8>, '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.1gELGd2uox/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.eVmepHBRN9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 14:10:27 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 14:10:27 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 14:10:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gELGd2uox/Render', 14:10:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:27 INFO - 'HOME': '/Users/cltbld', 14:10:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:27 INFO - 'LOGNAME': 'cltbld', 14:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:27 INFO - 'MOZ_NO_REMOTE': '1', 14:10:27 INFO - 'NO_EM_RESTART': '1', 14:10:27 INFO - 'PAGER': '/bin/cat', 14:10:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:27 INFO - 'PWD': '/builds/slave/test', 14:10:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:27 INFO - 'SHELL': '/bin/bash', 14:10:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eVmepHBRN9/Listeners', 14:10:27 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 14:10:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:27 INFO - 'USER': 'cltbld', 14:10:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:27 INFO - 'XPC_FLAGS': '0x0', 14:10:27 INFO - 'XPC_SERVICE_NAME': '0', 14:10:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:27 INFO - Downloading/unpacking psutil>=3.1.1 14:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:10:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:31 INFO - Installing collected packages: psutil 14:10:31 INFO - Running setup.py install for psutil 14:10:31 INFO - building 'psutil._psutil_osx' extension 14:10:31 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 14:10:32 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 14:10:32 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 14:10:32 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 14:10:32 INFO - building 'psutil._psutil_posix' extension 14:10:32 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 14:10:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:10:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:10:32 INFO - ^ 14:10:32 INFO - 1 warning generated. 14:10:32 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 14:10:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:32 INFO - Successfully installed psutil 14:10:32 INFO - Cleaning up... 14:10:32 INFO - Return code: 0 14:10:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:10: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')]} 14:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100faab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94304a4d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d88d30>, '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 0x100cafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d7dbe8>, '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.1gELGd2uox/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.eVmepHBRN9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 14:10: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:10: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 mozsystemmonitor==0.3 14:10:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gELGd2uox/Render', 14:10:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:32 INFO - 'HOME': '/Users/cltbld', 14:10:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:32 INFO - 'LOGNAME': 'cltbld', 14:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:32 INFO - 'MOZ_NO_REMOTE': '1', 14:10:32 INFO - 'NO_EM_RESTART': '1', 14:10:32 INFO - 'PAGER': '/bin/cat', 14:10:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:32 INFO - 'PWD': '/builds/slave/test', 14:10:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:32 INFO - 'SHELL': '/bin/bash', 14:10:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eVmepHBRN9/Listeners', 14:10:32 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 14:10:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:32 INFO - 'USER': 'cltbld', 14:10:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:32 INFO - 'XPC_FLAGS': '0x0', 14:10:32 INFO - 'XPC_SERVICE_NAME': '0', 14:10:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:10:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:10:35 INFO - Installing collected packages: mozsystemmonitor 14:10:35 INFO - Running setup.py install for mozsystemmonitor 14:10:35 INFO - Successfully installed mozsystemmonitor 14:10:35 INFO - Cleaning up... 14:10:35 INFO - Return code: 0 14:10:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:10:35 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:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:35 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:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:35 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 0x100faab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94304a4d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d88d30>, '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 0x100cafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d7dbe8>, '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.1gELGd2uox/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.eVmepHBRN9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 14:10:35 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 14:10:35 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 14:10:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gELGd2uox/Render', 14:10:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:35 INFO - 'HOME': '/Users/cltbld', 14:10:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:35 INFO - 'LOGNAME': 'cltbld', 14:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:35 INFO - 'MOZ_NO_REMOTE': '1', 14:10:35 INFO - 'NO_EM_RESTART': '1', 14:10:35 INFO - 'PAGER': '/bin/cat', 14:10:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:35 INFO - 'PWD': '/builds/slave/test', 14:10:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:35 INFO - 'SHELL': '/bin/bash', 14:10:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eVmepHBRN9/Listeners', 14:10:35 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 14:10:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:35 INFO - 'USER': 'cltbld', 14:10:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:35 INFO - 'XPC_FLAGS': '0x0', 14:10:35 INFO - 'XPC_SERVICE_NAME': '0', 14:10:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:36 INFO - Downloading/unpacking jsonschema==2.5.1 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:10:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:10:38 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 14:10:38 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 14:10:38 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 14:10:38 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 14:10:38 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 14:10:38 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 14:10:39 INFO - Downloading functools32-3.2.3-2.tar.gz 14:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:10:39 INFO - warning: no files found matching '*.txt' 14:10:39 INFO - no previously-included directories found matching 'build' 14:10:39 INFO - no previously-included directories found matching 'dist' 14:10:39 INFO - no previously-included directories found matching '.git*' 14:10:39 INFO - Installing collected packages: jsonschema, functools32 14:10:39 INFO - Running setup.py install for functools32 14:10:39 INFO - warning: no files found matching '*.txt' 14:10:39 INFO - no previously-included directories found matching 'build' 14:10:39 INFO - no previously-included directories found matching 'dist' 14:10:39 INFO - no previously-included directories found matching '.git*' 14:10:39 INFO - Successfully installed jsonschema functools32 14:10:39 INFO - Cleaning up... 14:10:39 INFO - Return code: 0 14:10:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:10: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')]} 14:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:39 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 0x100faab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94304a4d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d88d30>, '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 0x100cafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d7dbe8>, '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.1gELGd2uox/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.eVmepHBRN9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 14:10:39 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 14:10:39 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 14:10:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gELGd2uox/Render', 14:10:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:39 INFO - 'HOME': '/Users/cltbld', 14:10:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:39 INFO - 'LOGNAME': 'cltbld', 14:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:39 INFO - 'MOZ_NO_REMOTE': '1', 14:10:39 INFO - 'NO_EM_RESTART': '1', 14:10:39 INFO - 'PAGER': '/bin/cat', 14:10:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:39 INFO - 'PWD': '/builds/slave/test', 14:10:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:39 INFO - 'SHELL': '/bin/bash', 14:10:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eVmepHBRN9/Listeners', 14:10:39 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 14:10:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:39 INFO - 'USER': 'cltbld', 14:10:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:39 INFO - 'XPC_FLAGS': '0x0', 14:10:39 INFO - 'XPC_SERVICE_NAME': '0', 14:10:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:10:39 INFO - Cleaning up... 14:10:39 INFO - Return code: 0 14:10:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:10: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')]} 14:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:39 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 0x100faab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94304a4d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d88d30>, '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 0x100cafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d7dbe8>, '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.1gELGd2uox/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.eVmepHBRN9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 14:10:39 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 14:10:39 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 14:10:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gELGd2uox/Render', 14:10:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:39 INFO - 'HOME': '/Users/cltbld', 14:10:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:39 INFO - 'LOGNAME': 'cltbld', 14:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:39 INFO - 'MOZ_NO_REMOTE': '1', 14:10:39 INFO - 'NO_EM_RESTART': '1', 14:10:39 INFO - 'PAGER': '/bin/cat', 14:10:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:39 INFO - 'PWD': '/builds/slave/test', 14:10:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:39 INFO - 'SHELL': '/bin/bash', 14:10:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eVmepHBRN9/Listeners', 14:10:39 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 14:10:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:39 INFO - 'USER': 'cltbld', 14:10:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:39 INFO - 'XPC_FLAGS': '0x0', 14:10:39 INFO - 'XPC_SERVICE_NAME': '0', 14:10:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:40 INFO - Downloading/unpacking blobuploader==1.2.4 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10:42 INFO - Downloading blobuploader-1.2.4.tar.gz 14:10:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:10:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:10:42 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 14:10:42 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 14:10:42 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 14:10:42 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 14:10:42 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 14:10:42 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 14:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:10:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:10:43 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 14:10:43 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 14:10:43 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 14:10:43 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 14:10:43 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 14:10:43 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 14:10:44 INFO - Downloading docopt-0.6.1.tar.gz 14:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:10:44 INFO - Installing collected packages: blobuploader, requests, docopt 14:10:44 INFO - Running setup.py install for blobuploader 14:10:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:10:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:10:44 INFO - Running setup.py install for requests 14:10:44 INFO - Running setup.py install for docopt 14:10:44 INFO - Successfully installed blobuploader requests docopt 14:10:44 INFO - Cleaning up... 14:10:45 INFO - Return code: 0 14:10:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:45 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 0x100faab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94304a4d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d88d30>, '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 0x100cafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d7dbe8>, '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.1gELGd2uox/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.eVmepHBRN9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 14:10:45 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 14:10:45 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 14:10:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gELGd2uox/Render', 14:10:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:45 INFO - 'HOME': '/Users/cltbld', 14:10:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:45 INFO - 'LOGNAME': 'cltbld', 14:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:45 INFO - 'MOZ_NO_REMOTE': '1', 14:10:45 INFO - 'NO_EM_RESTART': '1', 14:10:45 INFO - 'PAGER': '/bin/cat', 14:10:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:45 INFO - 'PWD': '/builds/slave/test', 14:10:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:45 INFO - 'SHELL': '/bin/bash', 14:10:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eVmepHBRN9/Listeners', 14:10:45 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 14:10:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:45 INFO - 'USER': 'cltbld', 14:10:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:45 INFO - 'XPC_FLAGS': '0x0', 14:10:45 INFO - 'XPC_SERVICE_NAME': '0', 14:10:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:10:45 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-WOLorz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:10:45 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-k3HpxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:10:45 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-FKMSc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:10:45 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-inc5XI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:10:45 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-0r8x8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:10:45 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-jlQYK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:10:45 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-E_towl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:10:46 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-SdE_oY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:10:46 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-xDk1kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:10:46 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-bafnjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:10:46 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-UzJeN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:10:46 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-w_8OWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:10:46 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-WKCeqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:10:46 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-W5Qiht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:46 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-ZtIhlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:10:46 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-kf47Eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:10:46 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-_ra2qG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:10:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:10:47 INFO - Running setup.py install for manifestparser 14:10:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:10:47 INFO - Running setup.py install for mozcrash 14:10:47 INFO - Running setup.py install for mozdebug 14:10:47 INFO - Running setup.py install for mozdevice 14:10:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:10:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:10:47 INFO - Running setup.py install for mozfile 14:10:47 INFO - Running setup.py install for mozhttpd 14:10:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:10:47 INFO - Running setup.py install for mozinfo 14:10:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:10:48 INFO - Running setup.py install for mozInstall 14:10:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:10:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:10:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:10:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:10:48 INFO - Running setup.py install for mozleak 14:10:48 INFO - Running setup.py install for mozlog 14:10:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:10:48 INFO - Running setup.py install for moznetwork 14:10:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:10:48 INFO - Running setup.py install for mozprocess 14:10:48 INFO - Running setup.py install for mozprofile 14:10:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:10:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:10:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:10:49 INFO - Running setup.py install for mozrunner 14:10:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:10:49 INFO - Running setup.py install for mozscreenshot 14:10:49 INFO - Running setup.py install for moztest 14:10:49 INFO - Running setup.py install for mozversion 14:10:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:10:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:10:49 INFO - Cleaning up... 14:10:49 INFO - Return code: 0 14:10:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:49 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 0x100faab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94304a4d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d88d30>, '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 0x100cafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d7dbe8>, '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.1gELGd2uox/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.eVmepHBRN9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 14:10:49 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 14:10:49 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 14:10:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gELGd2uox/Render', 14:10:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:49 INFO - 'HOME': '/Users/cltbld', 14:10:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:49 INFO - 'LOGNAME': 'cltbld', 14:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:49 INFO - 'MOZ_NO_REMOTE': '1', 14:10:49 INFO - 'NO_EM_RESTART': '1', 14:10:49 INFO - 'PAGER': '/bin/cat', 14:10:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:49 INFO - 'PWD': '/builds/slave/test', 14:10:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:49 INFO - 'SHELL': '/bin/bash', 14:10:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eVmepHBRN9/Listeners', 14:10:49 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 14:10:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:49 INFO - 'USER': 'cltbld', 14:10:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:49 INFO - 'XPC_FLAGS': '0x0', 14:10:49 INFO - 'XPC_SERVICE_NAME': '0', 14:10:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:10:49 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-24gMGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:10:50 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)) 14:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:10:50 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-NyZK2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:10:50 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)) 14:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:10:50 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-9Th7jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:10:50 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)) 14:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:10:50 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-WAgusi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:10:50 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)) 14:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:10:50 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-LibQSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:10:50 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)) 14:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:10:50 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-o_LgUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:10:50 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)) 14:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:10:50 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-Hd67Zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:10:50 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)) 14:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:10:50 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-Gm2jxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:10:50 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)) 14:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:10:50 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-H8gcTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:10:50 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)) 14:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:10:50 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-zgrxdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:10:51 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)) 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:10:51 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-YPJk0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:10:51 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)) 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:10:51 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-4EOQDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:10:51 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)) 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:10:51 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-sWZPji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:10:51 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)) 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:10:51 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-uMz96o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:10:51 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)) 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:51 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-qa_Cto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:51 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)) 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:10:51 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-YPOb9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:10:51 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)) 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:10:51 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-x0l3eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:10:51 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)) 14:10:51 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)) 14:10:51 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)) 14:10:51 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)) 14:10:51 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)) 14:10:51 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)) 14:10:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:10:51 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 14:10:51 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 14:10:51 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 14:10:51 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 14:10:51 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 14:10:51 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 14:10:54 INFO - Downloading blessings-1.6.tar.gz 14:10:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:10:54 INFO - Installing collected packages: blessings 14:10:54 INFO - Running setup.py install for blessings 14:10:54 INFO - Successfully installed blessings 14:10:54 INFO - Cleaning up... 14:10:54 INFO - Return code: 0 14:10:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:10:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:10:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:10:55 INFO - Reading from file tmpfile_stdout 14:10:55 INFO - Current package versions: 14:10:55 INFO - blessings == 1.6 14:10:55 INFO - blobuploader == 1.2.4 14:10:55 INFO - docopt == 0.6.1 14:10:55 INFO - functools32 == 3.2.3-2 14:10:55 INFO - jsonschema == 2.5.1 14:10:55 INFO - manifestparser == 1.1 14:10:55 INFO - mozInstall == 1.12 14:10:55 INFO - mozcrash == 1.0 14:10:55 INFO - mozdebug == 0.1 14:10:55 INFO - mozdevice == 0.49 14:10:55 INFO - mozfile == 1.2 14:10:55 INFO - mozhttpd == 0.7 14:10:55 INFO - mozinfo == 0.9 14:10:55 INFO - mozleak == 0.1 14:10:55 INFO - mozlog == 3.4 14:10:55 INFO - moznetwork == 0.27 14:10:55 INFO - mozprocess == 0.25 14:10:55 INFO - mozprofile == 0.28 14:10:55 INFO - mozrunner == 6.13 14:10:55 INFO - mozscreenshot == 0.1 14:10:55 INFO - mozsystemmonitor == 0.3 14:10:55 INFO - moztest == 0.8 14:10:55 INFO - mozversion == 1.4 14:10:55 INFO - psutil == 3.1.1 14:10:55 INFO - requests == 1.2.3 14:10:55 INFO - wsgiref == 0.1.2 14:10:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:55 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 0x100faab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94304a4d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d88d30>, '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 0x100cafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d7dbe8>, '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.1gELGd2uox/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.eVmepHBRN9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 14:10:55 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 14:10:55 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 14:10:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gELGd2uox/Render', 14:10:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:55 INFO - 'HOME': '/Users/cltbld', 14:10:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:55 INFO - 'LOGNAME': 'cltbld', 14:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:55 INFO - 'MOZ_NO_REMOTE': '1', 14:10:55 INFO - 'NO_EM_RESTART': '1', 14:10:55 INFO - 'PAGER': '/bin/cat', 14:10:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:55 INFO - 'PWD': '/builds/slave/test', 14:10:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:55 INFO - 'SHELL': '/bin/bash', 14:10:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eVmepHBRN9/Listeners', 14:10:55 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 14:10:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:55 INFO - 'USER': 'cltbld', 14:10:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:55 INFO - 'XPC_FLAGS': '0x0', 14:10:55 INFO - 'XPC_SERVICE_NAME': '0', 14:10:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:55 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)) 14:10:55 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)) 14:10:55 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)) 14:10:55 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)) 14:10:55 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)) 14:10:55 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)) 14:10:55 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)) 14:10:55 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)) 14:10:55 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)) 14:10:55 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)) 14:10:55 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)) 14:10:55 INFO - Cleaning up... 14:10:55 INFO - Return code: 0 14:10:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:55 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 0x100faab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94304a4d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d88d30>, '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 0x100cafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d7dbe8>, '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.1gELGd2uox/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.eVmepHBRN9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 14:10:55 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 14:10:55 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 14:10:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gELGd2uox/Render', 14:10:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:55 INFO - 'HOME': '/Users/cltbld', 14:10:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:55 INFO - 'LOGNAME': 'cltbld', 14:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:55 INFO - 'MOZ_NO_REMOTE': '1', 14:10:55 INFO - 'NO_EM_RESTART': '1', 14:10:55 INFO - 'PAGER': '/bin/cat', 14:10:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:55 INFO - 'PWD': '/builds/slave/test', 14:10:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:55 INFO - 'SHELL': '/bin/bash', 14:10:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eVmepHBRN9/Listeners', 14:10:55 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 14:10:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:55 INFO - 'USER': 'cltbld', 14:10:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:55 INFO - 'XPC_FLAGS': '0x0', 14:10:55 INFO - 'XPC_SERVICE_NAME': '0', 14:10:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:10:55 INFO - Cleaning up... 14:10:55 INFO - Return code: 0 14:10:55 INFO - Running post-action listener: _resource_record_post_action 14:10:55 INFO - Running post-action listener: _start_resource_monitoring 14:10:55 INFO - Starting resource monitoring. 14:10:55 INFO - [mozharness: 2017-04-19 21:10:55.622505Z] Finished create-virtualenv step (success) 14:10:55 INFO - [mozharness: 2017-04-19 21:10:55.623458Z] Running install step. 14:10:55 INFO - Running pre-action listener: _resource_record_pre_action 14:10:55 INFO - Running main action method: install 14:10:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:10:55 INFO - Reading from file tmpfile_stdout 14:10:55 INFO - Detecting whether we're running mozinstall >=1.0... 14:10:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:10:55 INFO - Reading from file tmpfile_stdout 14:10:55 INFO - Output received: 14:10:55 INFO - Usage: mozinstall [options] installer 14:10:55 INFO - Options: 14:10:55 INFO - -h, --help show this help message and exit 14:10:55 INFO - -d DEST, --destination=DEST 14:10:55 INFO - Directory to install application into. [default: 14:10:55 INFO - "/builds/slave/test"] 14:10:55 INFO - --app=APP Application being installed. [default: firefox] 14:10:55 INFO - mkdir: /builds/slave/test/build/application 14:10:55 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'] 14:10:55 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:11:10 INFO - Reading from file tmpfile_stdout 14:11:10 INFO - Output received: 14:11:10 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:11:10 INFO - Running post-action listener: _resource_record_post_action 14:11:10 INFO - [mozharness: 2017-04-19 21:11:10.771853Z] Finished install step (success) 14:11:10 INFO - [mozharness: 2017-04-19 21:11:10.772023Z] Running run-tests step. 14:11:10 INFO - Running pre-action listener: _resource_record_pre_action 14:11:10 INFO - Running main action method: run_tests 14:11:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:11:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:11:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:11:10 INFO - 2017-04-19 14:11:10.786 screenresolution[1652:7354] starting screenresolution argv=screenresolution get 14:11:10 INFO - 2017-04-19 14:11:10.789 screenresolution[1652:7354] Display 0: 1600x1200x32@60 14:11:10 INFO - 2017-04-19 14:11:10.794 screenresolution[1653:7356] starting screenresolution argv=screenresolution list 14:11:10 INFO - Available Modes on Display 0 14:11:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:11:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:11:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:11:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:11:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:11:11 INFO - Intel Iris: 14:11:11 INFO - Chipset Model: Intel Iris 14:11:11 INFO - Type: GPU 14:11:11 INFO - Bus: Built-In 14:11:11 INFO - VRAM (Dynamic, Max): 1536 MB 14:11:11 INFO - Vendor: Intel (0x8086) 14:11:11 INFO - Device ID: 0x0a2e 14:11:11 INFO - Revision ID: 0x0009 14:11:11 INFO - Displays: 14:11:11 INFO - Display: 14:11:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:11:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:11:11 INFO - Display Serial Number: 1600x1200 60 14:11:11 INFO - Main Display: Yes 14:11:11 INFO - Mirror: Off 14:11:11 INFO - Online: Yes 14:11:11 INFO - Rotation: Supported 14:11:11 INFO - Return code: 0 14:11:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:11:11 INFO - Python 2.7.3 14:11:11 INFO - Return code: 0 14:11:11 INFO - grabbing minidump binary from tooltool 14:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:11 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 0x100d88d30>, '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 0x100cafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d7dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:11:11 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:11:11 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:11:11 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:11:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:11:11 INFO - Return code: 0 14:11:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:11:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:11:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:11:11 INFO - ENV: RUST_BACKTRACE is now 1 14:11:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:11:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:11:11 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/MHFkCzUVTp-DT-SXzYzY-Q/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0063', '--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:11:11 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/MHFkCzUVTp-DT-SXzYzY-Q/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0063 --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:11:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gELGd2uox/Render', 14:11:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:11 INFO - 'HOME': '/Users/cltbld', 14:11:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:11 INFO - 'LOGNAME': 'cltbld', 14:11:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:11:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:11 INFO - 'MOZ_NO_REMOTE': '1', 14:11:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:11:11 INFO - 'NO_EM_RESTART': '1', 14:11:11 INFO - 'PAGER': '/bin/cat', 14:11:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:11 INFO - 'PWD': '/builds/slave/test', 14:11:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:11:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:11 INFO - 'RUST_BACKTRACE': '1', 14:11:11 INFO - 'SHELL': '/bin/bash', 14:11:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eVmepHBRN9/Listeners', 14:11:11 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 14:11:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:11 INFO - 'USER': 'cltbld', 14:11:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:11 INFO - 'XPC_FLAGS': '0x0', 14:11:11 INFO - 'XPC_SERVICE_NAME': '0', 14:11:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:11 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/MHFkCzUVTp-DT-SXzYzY-Q/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0063', '--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:11:11 INFO - mozversion application_buildid: 20170419124120 14:11:11 INFO - mozversion application_changeset: e1a3ba300627bf1e8edc606ee3591a24ac8a994a 14:11:11 INFO - mozversion application_display_name: Firefox 14:11:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:11:11 INFO - mozversion application_name: Firefox 14:11:11 INFO - mozversion application_remotingname: firefox 14:11:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:11:11 INFO - mozversion application_vendor: Mozilla 14:11:11 INFO - mozversion application_version: 54.0 14:11:11 INFO - mozversion platform_buildid: 20170419124120 14:11:11 INFO - mozversion platform_changeset: e1a3ba300627bf1e8edc606ee3591a24ac8a994a 14:11:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:11:11 INFO - mozversion platform_version: 54.0 14:11:11 INFO - using testdate: 1492636271 14:11:11 INFO - actual date: 1492636271 14:11:11 INFO - starting webserver on 'localhost:49238' 14:11:11 INFO - SUITE-START | Running 2 tests 14:11:11 INFO - TEST-START | dromaeo_css 14:11:11 INFO - operating with platform_type : mac_ 14:11:11 INFO - Initialising browser for dromaeo_css test... 14:11:11 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpQtGXYG/profile http://localhost:49238/getInfo.html) 14:11:13 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 14:11:13 INFO - PROCESS | 1664 | colorDepth:24 14:11:13 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 14:11:13 INFO - PROCESS | 1664 | __metrics 14:11:13 INFO - PROCESS | 1664 | 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:11:13 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:11:14 INFO - TEST-INFO | 1664: exit 0 14:11:14 INFO - Browser initialized. 14:11:14 INFO - Running cycle 1/1 for dromaeo_css test... 14:11:14 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpQtGXYG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:11:26 INFO - PROCESS | 1667 | RSS: Main: 165003264 14:11:26 INFO - PROCESS | 1667 | 14:14:29 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49238/tests/dromaeo/cssquery-ext.html) 14:14:32 INFO - PROCESS | 1667 | RSS: Main: 401133568 14:14:32 INFO - PROCESS | 1667 | 14:17:35 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-ext.html (next: http://localhost:49238/tests/dromaeo/cssquery-jquery.html) 14:17:36 INFO - PROCESS | 1667 | RSS: Main: 304373760 14:17:36 INFO - PROCESS | 1667 | 14:20:38 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49238/tests/dromaeo/cssquery-mootools.html) 14:20:39 INFO - PROCESS | 1667 | RSS: Main: 288174080 14:20:39 INFO - PROCESS | 1667 | 14:23:41 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49238/tests/dromaeo/cssquery-prototype.html) 14:23:42 INFO - PROCESS | 1667 | RSS: Main: 282349568 14:23:42 INFO - PROCESS | 1667 | 14:26:46 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49238/tests/dromaeo/cssquery-yui.html) 14:26:46 INFO - PROCESS | 1667 | RSS: Main: 264298496 14:26:46 INFO - PROCESS | 1667 | 14:29:50 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-yui.html (next: http://localhost:49238/tests/dromaeo/cssquery-dojo.html) 14:29:50 INFO - PROCESS | 1667 | RSS: Main: 363360256 14:29:50 INFO - PROCESS | 1667 | 14:29:50 INFO - PROCESS | 1667 | __start_tp_report 14:29:50 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 14:29:50 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 14:29:50 INFO - PROCESS | 1667 | |i|pagename|runs| 14:29:50 INFO - PROCESS | 1667 | |0;dojo.html;2974.628171478565;3566.536350274462;3568.0901370150614;3590.712742980562;3605.7836529808214;6202.813915582534;6244.843878903019;6250.968745156268;6295.244570651523;6300.968495157524;6171.4445699887;6231.634309848493;6243.375662433755;6258.311585725578;6274.152989346437;5516.227728118067;5538.667679939206;5557.972210138943;5575.498205161534;5637.859053523674;5419.59353048521;5428.4300148484435;5428.61999660024;5616.550675945915;5645.943540564604;5532.446755324456;5536.640118392292;5539.473749993744;5546.556275497971;5549.667019978794;5497.752601132958;5523.558115350803;5525.944740552583;5537.446255374451;5539.612227144102;5367.677939323653;5448;5465.344158700942;5465.945340546584;5481.150421684645;6181.505479561624;6183.258009038944;6196.969015154896;6202.968985155046;6204.441600255998;6355.3009168991375;6422.550421470499;6453.806385808433;6534.24856141545;6537.705803238818;6636.900446493307;6648.069270302161;6648.66756662165;6651.76718814844;6654.733810647568;6294.685265736694;6327.620342779448;6336.429721325103;6372.012338087604;6393.456556192683;6428.517861160338;6487;6494.870102597922;6662.900056499157;6685.130932978682;6233.470155036782;6457.192850893638;6480.060391243338;6484.708188131451;6504.837379065561;6632.237292711304;6642.070110184578;6645.900311495331;6653.434458071021;6657.334266573401;6323.52573556985;6368.363163683594;6418.903716444257;6503.739850405931;6541.34586541342;6474.5791523550815;6528.151340325728;6545.083688283644;6545.280019197884;6589.472842172615;4840.298156767249;5230.947690523122;5278.630495865253;5288.286081379041;5293.894122117613;4616.307553866947;4666.416697912761;4672.182368085571;4714.151452738472;4719.362886010414;6155.661438620829;6203.503719702503;6251.9687401562705;6306.306306306395;6335.049742538564;6637.966810165918;6650.401463868178;6652.301508341651;6657.23441804189;6661.200655921223;6277.2153480814895;6278.591891527036;6310.305866354697;6313.494920406357;6320.146780184617;5616.382197958222;5677.14842773579;5716.657000579979;5780.104083867007;5794.855128621818;6831.146106736757;6900.206476255295;6905.274946130584;6907.758228461979;6926.341997510229;6610.933890661032;6649.501287403367;6671.566348187353;6685;6686.83282917931;6504.317046710027;6538.215414150332;6829.6585170742255;6863.073485079451;6925.757598484029;6356.968215158895;6378.9362106380195;6395.456386207225;6396.168498095218;6405.615663060231;5618.6628802272;6533.640649764308;6622.304658010839;6627.906395444697;6661.267260601427;6396.29640739509;6450.9354906450335;6465.127207826883;6477.060826180272;6479.481641468766;6223.190985171898;6431.903521447089;6437.967810160919;6438;6446.226452825691;6274.46667033289;6320.051992201206;6342.112104305309;6363.427291543783;6373.3945275198785;6283.654399008098;6328.873422531616;6341.207349081365;6347.71435285404;6406.135171751754;6380.489560835029;6393.456556192589;6397.4562162216735;6406.519511036598;6409.166808314889 14:29:50 INFO - PROCESS | 1667 | |1;ext.html;819.6352623082729;832.7668252889191;895.4895709445615;906.6962567539874;907.4419232172212;40070.59929400709;40771.59228407719;43035.569644303585;43066.569334306645;43096.35355469662;41812;42001.57998420015;42011.94970125741;42055.57944420555;42109.15781684372;7904.920950790476;9643.228541716664;9793.90206097937;9794.657186998456;9797.167240784542;7994.48035877669;8065.072516660571;8081.838363232732;8089;11626.651200463999;11760.23558468701;11797.351145686984;11834.822477662841;11839.171258011942;11848.466818993165;11752.41237938104;11772.35252061132;11778.234414763014;11785.528578856836;11793.23343982647;11463.94268028663;11503.59737409195;11514.021308188814;11542.538298468051;11543.307401555849;39832.40251396231;39935.60064399348;39997.80001100005;40016.79949601516;40140.79929600333;4017.0961533654986;4057.5333836608875;4100.34394496879;4104.363823607346;4110.527289361702;28680.856595717098;28889.133326000254;29716.5141742912;30226.84886575553;31071.689283107105;3244.610646722385;3256.853441595134;3281.6390197078304;3395.7792743471596;3405.0125463615523;352438;356440;357463;357596.4240357589;357944;35204.99999999949;36044.81977590148;51019.744901275255;51096.48903510992;51228.74385628048;37702.24595508075;37835.432468513;37852;37874.43188352177;37878.43182352267;14890.734287585676;15434.845651543565;15737.718030885457;15754.76367854483;15777.842221577866;13315.001374896921;13335.533256336175;13361.599152025456;13364;13368.598942031755;11903.107266955012;11936.104792140624;11983.760324793455;12028.819567706492;12029.578964736193;4822.831200907952;5305.549028332635;5397.919031214535;5821.621594596338;5929.902967950943;1094.7372630568766;1149.3968143872873;1153.5501154549731;1160.7504386556932;1188.3523479703583;22313.99587018588;26908;27317.590236146472;27513.021612883706;27672.723272767416;1095.4741723972538;1281.1992504684572;1292.7802273613509;1295.7343744532348;1349.7502961951875;14019.41302734662;14177.07848989833;14226.430942762174;14475.92762036183;14490.565283041315;427038;427294;427512;427931;428333;57757;57866.817325046686;57872;58188.70905645445;58246.12630810456;1485.3464475630904;1504.7818066380094;1511;1529.3347393883696;1535.6391248056698;23112.768872311735;26858.731412686404;27411.725882741714;27873.860630696716;27889.44221115607;37580.06049848776;37752.81123594474;37828.43257351087;37877;37996.2400751989;356939;418103;419306.7103993504;419505;421997;24460.165487588147;24839.62740558857;28783.5682464759;29079;29200.26999324949;37313.44029839609;38675;38745.837624871296;40062.79968600138;41418.964525887095;28284.292892677848;28728.712712872602;29920;29999.100026999226;30113.698863011967;28571.42857142887;28678.56982145311;28795.5680664786;28910;29757.95847145426;33666.82166124272;34460.31079378448;34731.4790278141;34775.78284760021;34866.47700284447;28366;28984.710152899046;29069.418611627225;29225;30022.3995520084;22069.448263792892;23086.076556937533;23532.764672353056;23537.175538935437;23613.881930590236 14:29:50 INFO - PROCESS | 1667 | |2;jquery.html;409.1489701421045;417.6512611969006;424.4545758700071;428.63137701576636;463.619831737975;17343.913280433597;20948.847813370277;23021.309360719162;23074.077036918545;23100.88449557752;22571.210007649737;23097.76902230977;23480.76519234807;23661.053557857664;23888.28335149948;7012.8597428051535;7212.278772122772;7266.2733726627175;7288.59912704801;7484.3638290745075;7739.419543534257;7874.055113386373;7903.48627339224;7912.327452166573;7916.40626952978;7592.962035189817;7838.764837054869;7902.288794008538;7916.445848790587;7935.841283174333;7611.847763044763;7812.101608315032;7833;7869.803254918645;7905.96047019767;7513.060867391576;7550.433717471156;7657.195994420617;7680.231976802331;7681.270279323456;19985.100670469863;25165.62251566228;25558.488830223476;25610.871945640338;25655.1020714276;2896.681365049843;2980.657224419176;3019.8490075496356;3020.5771192033135;3057.3732384861273;13011.763882431249;16460.67078658432;16557.92373495731;16749;17398;1922.6731455652573;2041.3161590867078;2074.0770357191054;2118.5656940327194;2142.3572928121503;130829;135301.97047044302;176890;177517;181833.18166818295;19404.708929366072;20559.430071241095;20695.689564656543;20759.68860467094;20813.58372832535;29171.85414072916;29252.707472924998;32748;32784.3443131136;32911.3417731644;10445.529951152217;10520.894791052144;10702.46487675613;10719.678409647722;10827.025567698945;7498.625068746541;8754.781130471789;8880.8667869982;8911.50986695725;9078.54607269634;9290.860637090449;9338.673146439842;9485.810283794286;9507.667231646998;9508.714738557854;3215.244417561871;3414.9487757683655;4100.630943215066;4145.523264824584;4178.979105104455;992.1170158558888;1048.8059708953715;1058.4125810175274;1059.142094903131;1119.2724728926264;19699.507512312306;20360;21476.355709328745;22325.665115023286;22941.311760647208;1085.7719878825535;1096.6655170173015;1097.8847221041835;1103.1395511501041;1113.7549739057395;10613.840792387966;10820.72948176286;11557.826632600518;11567.537298508134;11589.362585057903;725420;750664;768495;780872;787467;171069.14465427594;171300;172712;172970;177517;1199.91600587958;1234.7283597608512;1258.2513404524293;1260.5462033667873;1262.0912942681255;19244.807551924303;19333.13000914934;19661.72198807073;19716.915569643807;19749.506262343555;43270;45010.32484512669;54786.45213547973;57804.71097644485;59892.70053649704;76405.61797190979;83617.58191209006;84303;85179.57410212909;85208.57395712982;11577.768444630892;11748.706282342668;11754.941225293818;11786.882131178922;12082.275063496218;13074.150180238634;13246.536371226961;13279.86720132825;13309.534166304133;13589.32053397346;11645.47595358194;11654.53381864716;11793.70515737079;11859.762804744028;11967.546652936302;10309.329893557195;10333.689989300032;10566.682999510027;10602.151827853908;10751.354918704903;11603;11630;11801.35092569917;12053.939730301292;12054.517819287481;11669.88330116722;11697.707557311136;11776.116791240862;11781.705457363634;12014.939925300318;10772.353658780497;10893.949694085668;10894.291871028357;10905.34567925927;10947.660963406237 14:29:50 INFO - PROCESS | 1667 | |3;mootools.html;1392.7493051250772;1562.0705680120332;1583.6990971715372;1585.4213212177551;1595.9122248276344;8010.799730006745;9609.135177833994;11240.887591124087;11285.661430157088;11681.240719353236;11336.773264534724;11398.943005284982;11410.600628977987;11411.48648310826;11421.942890285558;2447.804175665947;2495.363682261021;2496.2885577610386;2498.6127150291645;2499.3626625210545;2115.122224276923;2190.2553131935138;2429.8906549205326;2497.5878979968284;2516.6099254615565;2441.7802397784194;2447.4737931344757;2467.9136230231948;2467.938301542458;2473.950520989579;2489.21589699246;2490.8007359411204;2492.8130390220626;2493.488834788864;2498.0132847525124;2209.2046863129262;2428.2836563213896;2449.4366295751897;2456.336789066942;2460.4463995601027;11439.256448330914;11484.196106272564;11534.59628912984;11537.653870383901;11540.134489913291;5994.970025149846;6181.165542651729;6193.566450348478;6194.81415557534;6211.192544969125;3384.932301353984;3671.724620653435;3822.7515211511163;3880.980595097035;3885.494885664874;1248.4070066718327;1272.4464857786893;1280.5454063807308;1295.1128476993194;1303.6610481274936;15831.129287889162;16017.359305627877;16023.278952447168;16030.5992350191;16054;4850.393700787402;5097.974510127426;5148.459411761711;5152.768125434364;5212.322398088224;13341.93329033368;13351.399187036606;13360.933195334155;13390.799138012937;13420.396082176325;6192.566520343623;6203.410675985774;6207.193064901534;6211.596246243979;6212.285587157535;4728.38530990969;5452.645578037414;5464.562834973192;5496.697681627469;5582.358028826737;3586.605473397924;3776.546814382292;3862.208247309295;4175.561566035583;4234.597713217239;1003.6386900715737;1143.5711608146944;1165.597868735285;1165.889240522149;1181.7163880668577;989.747614358334;993.3741742702051;1010.9991108802233;1024.0834453164375;1032.256775121911;6756.527043106936;6800.489963252677;6847.623380714009;6871.931280687229;6910.965445172742;1089.5478376473834;1107.7729065541544;1112.9721756956142;1129.1249281806665;1157.8089615213396;4261.722988005769;4267.722598031118;4310.685241001524;4471.463424389029;4585.312203169551;11793.233439826385;13800.964927630468;13896.235707036009;13898.166110033228;14217.786733199011;13801.792973105412;14081.436742530388;14122.646933826736;14159.78760318596;14186.787198192036;8963.417377870417;10018.29871908974;10451.216158788122;10489.947550262352;10519.421431821323;6993.580385176906;7051.906954422073;7312.378447831994;7323.304286092813;7328.303811137934;12375.814362784386;12825.486980520674;12948.676283092622;12952.41714122848;12984.545540906023;12921.935390322988;12942.67643308887;12949.223046617233;13006.219626822043;13172.868271317164;9458.810823783624;9462.810743785223;9658.179054780423;9681.37071090377;9690.98244684298;9277.48973806447;9546.284028697737;9663.323567350219;9666.323357364918;10490.52792624349;8024.157463466252;8904.465732056098;9050.864237036581;9226.861597075915;9230.630774769203;8791.5164665944;8919.509426981318;8981.506017169118;8988.146126118008;9039.68361107358;8146.796330091795;8155.714549990722;8267.131951145044;8279.37904657141;8285.130061343472;5999.9100013498955;6010.368911264429;6032.33644299118;6236.251649802053;6274.090256912813;6066.969665151646;6067.666278354556;6230.221222347207;6280.466160376419;6314.179156709598 14:29:50 INFO - PROCESS | 1667 | |4;prototype.html;316.0518444666002;388.4154347706702;393.3981009056145;395.3239959668964;399.1259142477973;4553.704009239397;4697.828965448326;4949.777260023298;5161.148410512265;5314.734263286839;4201.411802347674;4339;4339.9783001085025;5106.872328191797;5220.634555581111;3737.682297004758;3932.4101384792366;4035.656969157625;4144.12973275611;4242.872713818575;4284.464441944757;4293.957060429402;4294.7852607369505;4324.956750432502;4338.765535749092;3614.3855544557487;3890.7355109589357;4105.651019663333;4237;4283.229018776619;3760.304343696425;3798.2593394288124;4238.724482908601;4250.277452832995;4297.935530967038;3156.6685498022607;3549.09498077991;3577.284543091392;3911.902202444933;3931.6658084062888;4061.79691015451;5015.266679659594;5045.520675535855;5101.51535604117;5119.360079990001;4567.954320456786;4654.441467023945;4892.633052521075;4933.914538801458;4965.503449655005;4695.192350944911;4995.625328100407;5350.625456218067;5517.613767036309;5524.8342549723575;4299.065420560729;4379.44529691958;4395.450568678915;4403.405540252057;4446.621547320308;5110.8466745997675;5474.166154338302;5594.944050559483;5761.452661997104;5792.565557583198;3969.622885825842;4180.372944058416;4306.834476659653;4321;4407.735535867858;3960.6435420812263;4077.6330130288416;4556.658250631216;4562.703424277412;4597.977010114928;4665.906681866344;4697.839650522887;4704.529547045337;4918.745719841418;4927.581155601814;4560.566746159109;5256.710880901587;5438.536945714429;5491.423400542885;5568.693721845338;1533.700928318967;1536.8473644766425;1537.9769303460457;1538.9538313850603;1546.6520032992712;1030.4744580263969;1065.2170654568886;1074.6614816332985;1076.9876316262687;1149.8677652069953;4363;4658.9251094277615;5033.245013247969;5111.003354345867;5150.982233857597;4710.8351207707565;5377.569794416438;5679.716014199274;5690.658560486384;5730.885382292331;4928.018548777938;5116.309298244763;5146.433892271847;5158.92261616076;5252.79185787271;2602.3624212067784;2880.8991685290916;2954.2762023304426;2961.6890226526334;2967.2730181105767;5478.439014640516;5598.496135347838;5729.8567535811935;5856.824295271149;5871.4128587141795;5560.942451292966;5755.740991655385;5768.798092066758;5789.507891829157;5811.157382179645;4809.687370320918;4884.658073934862;5644.6330988485615;5771.538276937835;5794.623349482355;4973.676711013773;5241.371035475615;5312.681239125664;5344.679319240858;5650.915236271541;5004.874878128076;5291.497307755757;5503.532774352133;5529.778808847762;5541.778328866962;4466.665000125068;5073.771680274471;5138.97430512845;5193.298904647975;5755.510781583613;3873.2059927714186;4151.667866570728;4153.688473364449;4423.712458690175;4454.661302816047;5313.307251460198;5327.680339179662;5672.432756724294;5704.743286552032;5721.141828725725;5082.0434132859855;5463.972680136574;5515.420880807618;5518.806841760519;5531.778728850801;5281.7024594300065;5386.676799392049;5497.340319161726;5508.697021663847;5519.917201242065;4645.512221216723;4729.36153619257;5208.921866172086;5329.214713071009;5360.892782144413;4596.4024676791805;4865.878353041202;4938.43208031081;5517.503424691637;5518.2826232589505;4788.808447662054;5002.899942001067;5169.810943482945;5273.419923808455;5360.596021526281 14:29:50 INFO - PROCESS | 1667 | |5;yui.html;781.4529829119617;813.1299509524811;848.5375470368648;888.8311220868035;894.2086253665506;16090;17790.733139002925;17817.109144542785;17825.197866096023;17949.551261218476;16249;16334.34662613494;16347.673046539063;16443.2600532976;16540.421085261987;982.4645568165367;989.529973262698;990.5938565188238;991.7371896447447;991.8859331176899;984.6061575369838;985.3644399362407;986.013986013986;1005.4369553050278;1033.8914413986536;1067.1249575348218;1069.3476979042778;1070.3203465799234;1071.212658695858;1072.4530489450397;1054.425338190684;1057.3285963413211;1057.4765491081887;1058.7088550648557;1060.2737125069352;791.3748138970207;791.9722809701633;792.1919641965221;792.579932635704;792.9524228546248;16408.589785255346;16592.917035414746;16819.91590042042;17743.201555930013;17789.377371792056;14641.48754793577;14941.551753447415;15059.548213553611;15115.773263401057;15295.541133766004;12019.399030048462;12213;12245.32650704211;12344.75310493785;12834.422450989634;3918.1771827916173;3937.5668676445566;4062.329715596923;4083.7549747015273;4099.323611604082;123226;124327.75672243252;127575.08637370447;127796;129071.77320566967;11290.54837806495;11436.542538298374;11477.827832582518;11568.710782230342;12097.092718046182;23427.414314642272;23797.524049518914;23978.52042959131;24106.51786964286;24137;7995.440319177718;8033.799155021171;8065.072516660542;8148.144444833326;8264.338852891755;4194.182134483746;4566.543345665407;4601.33280674307;4638.582527572535;4734.19518681825;3364.411228035084;3497.178163131662;3516.367053930317;3518.138056176253;3518.437050071976;529.3462573721451;530.4006472685841;592.3839207224438;606.9119977603223;607.5625549604277;679.9354061364163;710.6801939127309;715.7637979466867;716.8673795347773;745.5899255409503;9959.402435853726;10208.591656333812;10752.838707419394;11446.427678616035;11937.940310298392;568.8236646639555;572.3446653581709;632.4845251120322;675.3449154320301;719.1485758965727;5276.947230527722;5412.188171774186;5413.431589683105;5415.972920135374;5435.510804027656;79849;92745.5362723182;98413;102395.97604024013;104455.95544044614;50360;56522;74191.1452213699;79464.60267698625;90975.54512227396;76452;78364;78999.60500197462;80626.59686701764;81423;11105.444727763741;11188.496517656888;11297.77529924889;11407.657770266906;11549.133814963743;36031.63968360283;48220;49869.75065124651;51311.743441284045;51770.48229517657;67676.6616166916;69226.96159557509;71122.64438677774;72019.27980720125;73919.63040184765;13162.078654494093;13602.319884005958;13795;13928.303584820516;13955.511557095453;14909.85090149128;15135.545933622008;15938.442154524537;16138.112403817902;16298.59253518624;13882.861171388156;14100.506482273071;14763.188024658746;15485.148316842682;15816.841831581996;14254.572362829133;14557.636059098608;14693.118412895261;14718.926405367905;15058.849411505746;13279.800802988157;14351.784723229368;14398.640033999234;14399.496017639332;14484.782728259295;10593.629222977159;10641;10750.51622676997;10953.726156846142;11008.724781880517;10995.835062473909;11509.568950098319;11782.764344713229;11806;11825.46785394642 14:29:50 INFO - PROCESS | 1667 | __end_tp_report 14:29:50 INFO - PROCESS | 1667 | __start_cc_report 14:29:50 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,2706 14:29:50 INFO - PROCESS | 1667 | __end_cc_report 14:29:50 INFO - PROCESS | 1667 | __startTimestamp1492637390658__endTimestamp 14:29:50 INFO - PROCESS | 1667 | 14:29:50 INFO - PROCESS | 1667 | ------- Summary: start ------- 14:29:50 INFO - PROCESS | 1667 | Number of tests: 6 14:29:50 INFO - PROCESS | 1667 | 14:29:50 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:6108.43 Median:6342.11 stddev:693.85 (10.9%) stddev-sans-first:650.97 14:29:50 INFO - PROCESS | 1667 | Values: 2974.6 3566.5 3568.1 3590.7 3605.8 6202.8 6244.8 6251.0 6295.2 6301.0 6171.4 6231.6 6243.4 6258.3 6274.2 5516.2 5538.7 5558.0 5575.5 5637.9 5419.6 5428.4 5428.6 5616.6 5645.9 5532.4 5536.6 5539.5 5546.6 5549.7 5497.8 5523.6 5525.9 5537.4 5539.6 5367.7 5448.0 5465.3 5465.9 5481.2 6181.5 6183.3 6197.0 6203.0 6204.4 6355.3 6422.6 6453.8 6534.2 6537.7 6636.9 6648.1 6648.7 6651.8 6654.7 6294.7 6327.6 6336.4 6372.0 6393.5 6428.5 6487.0 6494.9 6662.9 6685.1 6233.5 6457.2 6480.1 6484.7 6504.8 6632.2 6642.1 6645.9 6653.4 6657.3 6323.5 6368.4 6418.9 6503.7 6541.3 6474.6 6528.2 6545.1 6545.3 6589.5 4840.3 5230.9 5278.6 5288.3 5293.9 4616.3 4666.4 4672.2 4714.2 4719.4 6155.7 6203.5 6252.0 6306.3 6335.0 6638.0 6650.4 6652.3 6657.2 6661.2 6277.2 6278.6 6310.3 6313.5 6320.1 5616.4 5677.1 5716.7 5780.1 5794.9 6831.1 6900.2 6905.3 6907.8 6926.3 6610.9 6649.5 6671.6 6685.0 6686.8 6504.3 6538.2 6829.7 6863.1 6925.8 6357.0 6378.9 6395.5 6396.2 6405.6 5618.7 6533.6 6622.3 6627.9 6661.3 6396.3 6450.9 6465.1 6477.1 6479.5 6223.2 6431.9 6438.0 6438.0 6446.2 6274.5 6320.1 6342.1 6363.4 6373.4 6283.7 6328.9 6341.2 6347.7 6406.1 6380.5 6393.5 6397.5 6406.5 6409.2 14:29:50 INFO - PROCESS | 1667 | 14:29:50 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:53169.29 Median:17158.15 stddev:105467.56 (614.7%) stddev-sans-first:105690.19 14:29:50 INFO - PROCESS | 1667 | Values: 819.6 832.8 895.5 906.7 907.4 40070.6 40771.6 43035.6 43066.6 43096.4 41812.0 42001.6 42011.9 42055.6 42109.2 7904.9 9643.2 9793.9 9794.7 9797.2 7994.5 8065.1 8081.8 8089.0 11626.7 11760.2 11797.4 11834.8 11839.2 11848.5 11752.4 11772.4 11778.2 11785.5 11793.2 11463.9 11503.6 11514.0 11542.5 11543.3 39832.4 39935.6 39997.8 40016.8 40140.8 4017.1 4057.5 4100.3 4104.4 4110.5 28680.9 28889.1 29716.5 30226.8 31071.7 3244.6 3256.9 3281.6 3395.8 3405.0 352438.0 356440.0 357463.0 357596.4 357944.0 35205.0 36044.8 51019.7 51096.5 51228.7 37702.2 37835.4 37852.0 37874.4 37878.4 14890.7 15434.8 15737.7 15754.8 15777.8 13315.0 13335.5 13361.6 13364.0 13368.6 11903.1 11936.1 11983.8 12028.8 12029.6 4822.8 5305.5 5397.9 5821.6 5929.9 1094.7 1149.4 1153.6 1160.8 1188.4 22314.0 26908.0 27317.6 27513.0 27672.7 1095.5 1281.2 1292.8 1295.7 1349.8 14019.4 14177.1 14226.4 14475.9 14490.6 427038.0 427294.0 427512.0 427931.0 428333.0 57757.0 57866.8 57872.0 58188.7 58246.1 1485.3 1504.8 1511.0 1529.3 1535.6 23112.8 26858.7 27411.7 27873.9 27889.4 37580.1 37752.8 37828.4 37877.0 37996.2 356939.0 418103.0 419306.7 419505.0 421997.0 24460.2 24839.6 28783.6 29079.0 29200.3 37313.4 38675.0 38745.8 40062.8 41419.0 28284.3 28728.7 29920.0 29999.1 30113.7 28571.4 28678.6 28795.6 28910.0 29758.0 33666.8 34460.3 34731.5 34775.8 34866.5 28366.0 28984.7 29069.4 29225.0 30022.4 22069.4 23086.1 23532.8 23537.2 23613.9 14:29:50 INFO - PROCESS | 1667 | 14:29:50 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:43948.41 Median:20881.22 stddev:127743.74 (611.8%) stddev-sans-first:128060.26 14:29:50 INFO - PROCESS | 1667 | Values: 409.1 417.7 424.5 428.6 463.6 17343.9 20948.8 23021.3 23074.1 23100.9 22571.2 23097.8 23480.8 23661.1 23888.3 7012.9 7212.3 7266.3 7288.6 7484.4 7739.4 7874.1 7903.5 7912.3 7916.4 7593.0 7838.8 7902.3 7916.4 7935.8 7611.8 7812.1 7833.0 7869.8 7906.0 7513.1 7550.4 7657.2 7680.2 7681.3 19985.1 25165.6 25558.5 25610.9 25655.1 2896.7 2980.7 3019.8 3020.6 3057.4 13011.8 16460.7 16557.9 16749.0 17398.0 1922.7 2041.3 2074.1 2118.6 2142.4 130829.0 135302.0 176890.0 177517.0 181833.2 19404.7 20559.4 20695.7 20759.7 20813.6 29171.9 29252.7 32748.0 32784.3 32911.3 10445.5 10520.9 10702.5 10719.7 10827.0 7498.6 8754.8 8880.9 8911.5 9078.5 9290.9 9338.7 9485.8 9507.7 9508.7 3215.2 3414.9 4100.6 4145.5 4179.0 992.1 1048.8 1058.4 1059.1 1119.3 19699.5 20360.0 21476.4 22325.7 22941.3 1085.8 1096.7 1097.9 1103.1 1113.8 10613.8 10820.7 11557.8 11567.5 11589.4 725420.0 750664.0 768495.0 780872.0 787467.0 171069.1 171300.0 172712.0 172970.0 177517.0 1199.9 1234.7 1258.3 1260.5 1262.1 19244.8 19333.1 19661.7 19716.9 19749.5 43270.0 45010.3 54786.5 57804.7 59892.7 76405.6 83617.6 84303.0 85179.6 85208.6 11577.8 11748.7 11754.9 11786.9 12082.3 13074.2 13246.5 13279.9 13309.5 13589.3 11645.5 11654.5 11793.7 11859.8 11967.5 10309.3 10333.7 10566.7 10602.2 10751.4 11603.0 11630.0 11801.4 12053.9 12054.5 11669.9 11697.7 11776.1 11781.7 12014.9 10772.4 10893.9 10894.3 10905.3 10947.7 14:29:50 INFO - PROCESS | 1667 | 14:29:50 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:6971.07 Median:2496.94 stddev:4354.37 (174.4%) stddev-sans-first:4346.40 14:29:50 INFO - PROCESS | 1667 | Values: 1392.7 1562.1 1583.7 1585.4 1595.9 8010.8 9609.1 11240.9 11285.7 11681.2 11336.8 11398.9 11410.6 11411.5 11421.9 2447.8 2495.4 2496.3 2498.6 2499.4 2115.1 2190.3 2429.9 2497.6 2516.6 2441.8 2447.5 2467.9 2467.9 2474.0 2489.2 2490.8 2492.8 2493.5 2498.0 2209.2 2428.3 2449.4 2456.3 2460.4 11439.3 11484.2 11534.6 11537.7 11540.1 5995.0 6181.2 6193.6 6194.8 6211.2 3384.9 3671.7 3822.8 3881.0 3885.5 1248.4 1272.4 1280.5 1295.1 1303.7 15831.1 16017.4 16023.3 16030.6 16054.0 4850.4 5098.0 5148.5 5152.8 5212.3 13341.9 13351.4 13360.9 13390.8 13420.4 6192.6 6203.4 6207.2 6211.6 6212.3 4728.4 5452.6 5464.6 5496.7 5582.4 3586.6 3776.5 3862.2 4175.6 4234.6 1003.6 1143.6 1165.6 1165.9 1181.7 989.7 993.4 1011.0 1024.1 1032.3 6756.5 6800.5 6847.6 6871.9 6911.0 1089.5 1107.8 1113.0 1129.1 1157.8 4261.7 4267.7 4310.7 4471.5 4585.3 11793.2 13801.0 13896.2 13898.2 14217.8 13801.8 14081.4 14122.6 14159.8 14186.8 8963.4 10018.3 10451.2 10489.9 10519.4 6993.6 7051.9 7312.4 7323.3 7328.3 12375.8 12825.5 12948.7 12952.4 12984.5 12921.9 12942.7 12949.2 13006.2 13172.9 9458.8 9462.8 9658.2 9681.4 9691.0 9277.5 9546.3 9663.3 9666.3 10490.5 8024.2 8904.5 9050.9 9226.9 9230.6 8791.5 8919.5 8981.5 8988.1 9039.7 8146.8 8155.7 8267.1 8279.4 8285.1 5999.9 6010.4 6032.3 6236.3 6274.1 6067.0 6067.7 6230.2 6280.5 6314.2 14:29:50 INFO - PROCESS | 1667 | 14:29:50 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:4524.48 Median:4923.16 stddev:1267.28 (25.7%) stddev-sans-first:1230.83 14:29:50 INFO - PROCESS | 1667 | Values: 316.1 388.4 393.4 395.3 399.1 4553.7 4697.8 4949.8 5161.1 5314.7 4201.4 4339.0 4340.0 5106.9 5220.6 3737.7 3932.4 4035.7 4144.1 4242.9 4284.5 4294.0 4294.8 4325.0 4338.8 3614.4 3890.7 4105.7 4237.0 4283.2 3760.3 3798.3 4238.7 4250.3 4297.9 3156.7 3549.1 3577.3 3911.9 3931.7 4061.8 5015.3 5045.5 5101.5 5119.4 4568.0 4654.4 4892.6 4933.9 4965.5 4695.2 4995.6 5350.6 5517.6 5524.8 4299.1 4379.4 4395.5 4403.4 4446.6 5110.8 5474.2 5594.9 5761.5 5792.6 3969.6 4180.4 4306.8 4321.0 4407.7 3960.6 4077.6 4556.7 4562.7 4598.0 4665.9 4697.8 4704.5 4918.7 4927.6 4560.6 5256.7 5438.5 5491.4 5568.7 1533.7 1536.8 1538.0 1539.0 1546.7 1030.5 1065.2 1074.7 1077.0 1149.9 4363.0 4658.9 5033.2 5111.0 5151.0 4710.8 5377.6 5679.7 5690.7 5730.9 4928.0 5116.3 5146.4 5158.9 5252.8 2602.4 2880.9 2954.3 2961.7 2967.3 5478.4 5598.5 5729.9 5856.8 5871.4 5560.9 5755.7 5768.8 5789.5 5811.2 4809.7 4884.7 5644.6 5771.5 5794.6 4973.7 5241.4 5312.7 5344.7 5650.9 5004.9 5291.5 5503.5 5529.8 5541.8 4466.7 5073.8 5139.0 5193.3 5755.5 3873.2 4151.7 4153.7 4423.7 4454.7 5313.3 5327.7 5672.4 5704.7 5721.1 5082.0 5464.0 5515.4 5518.8 5531.8 5281.7 5386.7 5497.3 5508.7 5519.9 4645.5 4729.4 5208.9 5329.2 5360.9 4596.4 4865.9 4938.4 5517.5 5518.3 4788.8 5002.9 5169.8 5273.4 5360.6 14:29:50 INFO - PROCESS | 1667 | 14:29:50 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:20950.48 Median:17821.15 stddev:29802.28 (167.2%) stddev-sans-first:29847.41 14:29:50 INFO - PROCESS | 1667 | Values: 781.5 813.1 848.5 888.8 894.2 16090.0 17790.7 17817.1 17825.2 17949.6 16249.0 16334.3 16347.7 16443.3 16540.4 982.5 989.5 990.6 991.7 991.9 984.6 985.4 986.0 1005.4 1033.9 1067.1 1069.3 1070.3 1071.2 1072.5 1054.4 1057.3 1057.5 1058.7 1060.3 791.4 792.0 792.2 792.6 793.0 16408.6 16592.9 16819.9 17743.2 17789.4 14641.5 14941.6 15059.5 15115.8 15295.5 12019.4 12213.0 12245.3 12344.8 12834.4 3918.2 3937.6 4062.3 4083.8 4099.3 123226.0 124327.8 127575.1 127796.0 129071.8 11290.5 11436.5 11477.8 11568.7 12097.1 23427.4 23797.5 23978.5 24106.5 24137.0 7995.4 8033.8 8065.1 8148.1 8264.3 4194.2 4566.5 4601.3 4638.6 4734.2 3364.4 3497.2 3516.4 3518.1 3518.4 529.3 530.4 592.4 606.9 607.6 679.9 710.7 715.8 716.9 745.6 9959.4 10208.6 10752.8 11446.4 11937.9 568.8 572.3 632.5 675.3 719.1 5276.9 5412.2 5413.4 5416.0 5435.5 79849.0 92745.5 98413.0 102396.0 104456.0 50360.0 56522.0 74191.1 79464.6 90975.5 76452.0 78364.0 78999.6 80626.6 81423.0 11105.4 11188.5 11297.8 11407.7 11549.1 36031.6 48220.0 49869.8 51311.7 51770.5 67676.7 69227.0 71122.6 72019.3 73919.6 13162.1 13602.3 13795.0 13928.3 13955.5 14909.9 15135.5 15938.4 16138.1 16298.6 13882.9 14100.5 14763.2 15485.1 15816.8 14254.6 14557.6 14693.1 14718.9 15058.8 13279.8 14351.8 14398.6 14399.5 14484.8 10593.6 10641.0 10750.5 10953.7 11008.7 10995.8 11509.6 11782.8 11806.0 11825.5 14:29:50 INFO - PROCESS | 1667 | -------- Summary: end -------- 14:29:50 INFO - PROCESS | 1667 | 14:29:51 INFO - TEST-INFO | 1667: exit 0 14:29:51 INFO - TEST-OK | dromaeo_css | took 1119876ms 14:29:51 INFO - TEST-START | kraken 14:29:51 INFO - operating with platform_type : mac_ 14:29:51 INFO - Initialising browser for kraken test... 14:29:51 INFO - TEST-INFO | started process 1788 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpwgQMdT/profile http://localhost:49238/getInfo.html) 14:29:53 INFO - PROCESS | 1788 | __metrics Screen width/height:1600/1200 14:29:53 INFO - PROCESS | 1788 | colorDepth:24 14:29:53 INFO - PROCESS | 1788 | Browser inner width/height: 1024/689 14:29:53 INFO - PROCESS | 1788 | __metrics 14:29:53 INFO - PROCESS | 1788 | 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:29:53 INFO - PROCESS | 1788 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:29:54 INFO - TEST-INFO | 1788: exit 0 14:29:54 INFO - Browser initialized. 14:29:54 INFO - Running cycle 1/1 for kraken test... 14:29:54 INFO - TEST-INFO | started process 1791 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpwgQMdT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:30:06 INFO - PROCESS | 1791 | RSS: Main: 169025536 14:30:06 INFO - PROCESS | 1791 | 14:30:09 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection) 14:30:09 INFO - PROCESS | 1791 | RSS: Main: 219262976 14:30:09 INFO - PROCESS | 1791 | 14:30:12 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-dft) 14:30:13 INFO - PROCESS | 1791 | RSS: Main: 228872192 14:30:13 INFO - PROCESS | 1791 | 14:30:16 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-fft) 14:30:16 INFO - PROCESS | 1791 | RSS: Main: 327122944 14:30:16 INFO - PROCESS | 1791 | 14:30:18 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator) 14:30:19 INFO - PROCESS | 1791 | RSS: Main: 228892672 14:30:19 INFO - PROCESS | 1791 | 14:30:21 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:30:22 INFO - PROCESS | 1791 | RSS: Main: 230174720 14:30:22 INFO - PROCESS | 1791 | 14:30:24 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom) 14:30:25 INFO - PROCESS | 1791 | RSS: Main: 269881344 14:30:25 INFO - PROCESS | 1791 | 14:30:28 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate) 14:30:29 INFO - PROCESS | 1791 | RSS: Main: 272158720 14:30:29 INFO - PROCESS | 1791 | 14:30:32 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial) 14:30:32 INFO - PROCESS | 1791 | RSS: Main: 269160448 14:30:32 INFO - PROCESS | 1791 | 14:30:34 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:30:35 INFO - PROCESS | 1791 | RSS: Main: 248213504 14:30:35 INFO - PROCESS | 1791 | 14:30:36 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:30:37 INFO - PROCESS | 1791 | RSS: Main: 254865408 14:30:37 INFO - PROCESS | 1791 | 14:30:39 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:30:40 INFO - PROCESS | 1791 | RSS: Main: 256466944 14:30:40 INFO - PROCESS | 1791 | 14:30:43 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:30:44 INFO - PROCESS | 1791 | RSS: Main: 271400960 14:30:44 INFO - PROCESS | 1791 | 14:30:46 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:30:47 INFO - PROCESS | 1791 | RSS: Main: 264458240 14:30:47 INFO - PROCESS | 1791 | 14:30:49 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49238/tests/kraken/driver.html?testName=ai-astar) 14:30:49 INFO - PROCESS | 1791 | RSS: Main: 309252096 14:30:49 INFO - PROCESS | 1791 | 14:30:49 INFO - PROCESS | 1791 | __start_tp_report 14:30:49 INFO - PROCESS | 1791 | _x_x_mozilla_page_load 14:30:49 INFO - PROCESS | 1791 | _x_x_mozilla_page_load_details 14:30:49 INFO - PROCESS | 1791 | |i|pagename|runs| 14:30:49 INFO - PROCESS | 1791 | |0;ai-astar;125;175;149;117;114;116;117;116;116;116 14:30:49 INFO - PROCESS | 1791 | |1;audio-beat-detection;136;106;107;140;107;107;108;106;126;107 14:30:49 INFO - PROCESS | 1791 | |2;audio-dft;180;184;186;183;186;184;183;184;185;187 14:30:49 INFO - PROCESS | 1791 | |3;audio-fft;82;64;68;113;87;72;59;58;76;49 14:30:49 INFO - PROCESS | 1791 | |4;audio-oscillator;85;69;86;70;69;67;81;68;67;80 14:30:49 INFO - PROCESS | 1791 | |5;imaging-gaussian-blur;89;89;89;89;90;89;89;88;90;89 14:30:49 INFO - PROCESS | 1791 | |6;imaging-darkroom;95;100;97;138;149;103;95;94;96;95 14:30:49 INFO - PROCESS | 1791 | |7;imaging-desaturate;85;82;84;86;83;84;85;86;91;115 14:30:49 INFO - PROCESS | 1791 | |8;json-parse-financial;61;61;61;64;63;62;62;59;61;62 14:30:49 INFO - PROCESS | 1791 | |9;json-stringify-tinderbox;55;56;66;71;64;63;57;58;59;59 14:30:49 INFO - PROCESS | 1791 | |10;stanford-crypto-aes;82;83;83;81;95;95;96;81;81;82 14:30:49 INFO - PROCESS | 1791 | |11;stanford-crypto-ccm;138;137;148;122;134;137;151;148;176;123 14:30:49 INFO - PROCESS | 1791 | |12;stanford-crypto-pbkdf2;160;158;160;162;160;159;162;163;160;160 14:30:49 INFO - PROCESS | 1791 | |13;stanford-crypto-sha256-iterative;64;65;64;64;62;66;67;75;56;71 14:30:49 INFO - PROCESS | 1791 | __end_tp_report 14:30:49 INFO - PROCESS | 1791 | __start_cc_report 14:30:49 INFO - PROCESS | 1791 | _x_x_mozilla_cycle_collect,2167 14:30:49 INFO - PROCESS | 1791 | __end_cc_report 14:30:49 INFO - PROCESS | 1791 | __startTimestamp1492637449363__endTimestamp 14:30:49 INFO - PROCESS | 1791 | 14:30:49 INFO - PROCESS | 1791 | ------- Summary: start ------- 14:30:49 INFO - PROCESS | 1791 | Number of tests: 14 14:30:49 INFO - PROCESS | 1791 | 14:30:49 INFO - PROCESS | 1791 | [#0] ai-astar Cycles:10 Average:126.10 Median:117.00 stddev:20.10 (17.2%) stddev-sans-first:21.32 14:30:49 INFO - PROCESS | 1791 | Values: 125.0 175.0 149.0 117.0 114.0 116.0 117.0 116.0 116.0 116.0 14:30:49 INFO - PROCESS | 1791 | 14:30:49 INFO - PROCESS | 1791 | [#1] audio-beat-detection Cycles:10 Average:115.00 Median:107.50 stddev:13.56 (12.6%) stddev-sans-first:12.06 14:30:49 INFO - PROCESS | 1791 | Values: 136.0 106.0 107.0 140.0 107.0 107.0 108.0 106.0 126.0 107.0 14:30:49 INFO - PROCESS | 1791 | 14:30:49 INFO - PROCESS | 1791 | [#2] audio-dft Cycles:10 Average:184.20 Median:184.50 stddev:1.99 (1.1%) stddev-sans-first:1.41 14:30:49 INFO - PROCESS | 1791 | Values: 180.0 184.0 186.0 183.0 186.0 184.0 183.0 184.0 185.0 187.0 14:30:49 INFO - PROCESS | 1791 | 14:30:49 INFO - PROCESS | 1791 | [#3] audio-fft Cycles:10 Average:72.80 Median:70.00 stddev:18.23 (26.0%) stddev-sans-first:19.02 14:30:49 INFO - PROCESS | 1791 | Values: 82.0 64.0 68.0 113.0 87.0 72.0 59.0 58.0 76.0 49.0 14:30:49 INFO - PROCESS | 1791 | 14:30:49 INFO - PROCESS | 1791 | [#4] audio-oscillator Cycles:10 Average:74.20 Median:75.00 stddev:7.81 (10.4%) stddev-sans-first:7.25 14:30:49 INFO - PROCESS | 1791 | Values: 85.0 69.0 86.0 70.0 69.0 67.0 81.0 68.0 67.0 80.0 14:30:49 INFO - PROCESS | 1791 | 14:30:49 INFO - PROCESS | 1791 | [#5] imaging-gaussian-blur Cycles:10 Average:89.10 Median:89.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 14:30:49 INFO - PROCESS | 1791 | Values: 89.0 89.0 89.0 89.0 90.0 89.0 89.0 88.0 90.0 89.0 14:30:49 INFO - PROCESS | 1791 | 14:30:49 INFO - PROCESS | 1791 | [#6] imaging-darkroom Cycles:10 Average:106.20 Median:95.00 stddev:20.02 (21.1%) stddev-sans-first:20.82 14:30:49 INFO - PROCESS | 1791 | Values: 95.0 100.0 97.0 138.0 149.0 103.0 95.0 94.0 96.0 95.0 14:30:49 INFO - PROCESS | 1791 | 14:30:49 INFO - PROCESS | 1791 | [#7] imaging-desaturate Cycles:10 Average:88.10 Median:85.00 stddev:9.76 (11.5%) stddev-sans-first:10.28 14:30:49 INFO - PROCESS | 1791 | Values: 85.0 82.0 84.0 86.0 83.0 84.0 85.0 86.0 91.0 115.0 14:30:49 INFO - PROCESS | 1791 | 14:30:49 INFO - PROCESS | 1791 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:62.00 stddev:1.35 (2.2%) stddev-sans-first:1.41 14:30:49 INFO - PROCESS | 1791 | Values: 61.0 61.0 61.0 64.0 63.0 62.0 62.0 59.0 61.0 62.0 14:30:49 INFO - PROCESS | 1791 | 14:30:49 INFO - PROCESS | 1791 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:5.07 (8.3%) stddev-sans-first:4.93 14:30:49 INFO - PROCESS | 1791 | Values: 55.0 56.0 66.0 71.0 64.0 63.0 57.0 58.0 59.0 59.0 14:30:49 INFO - PROCESS | 1791 | 14:30:49 INFO - PROCESS | 1791 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:83.00 stddev:6.56 (7.9%) stddev-sans-first:6.80 14:30:49 INFO - PROCESS | 1791 | Values: 82.0 83.0 83.0 81.0 95.0 95.0 96.0 81.0 81.0 82.0 14:30:49 INFO - PROCESS | 1791 | 14:30:49 INFO - PROCESS | 1791 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:143.00 stddev:15.62 (10.9%) stddev-sans-first:16.52 14:30:49 INFO - PROCESS | 1791 | Values: 138.0 137.0 148.0 122.0 134.0 137.0 151.0 148.0 176.0 123.0 14:30:49 INFO - PROCESS | 1791 | 14:30:49 INFO - PROCESS | 1791 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:160.00 stddev:1.51 (0.9%) stddev-sans-first:1.59 14:30:49 INFO - PROCESS | 1791 | Values: 160.0 158.0 160.0 162.0 160.0 159.0 162.0 163.0 160.0 160.0 14:30:49 INFO - PROCESS | 1791 | 14:30:49 INFO - PROCESS | 1791 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.50 stddev:5.08 (7.8%) stddev-sans-first:5.36 14:30:49 INFO - PROCESS | 1791 | Values: 64.0 65.0 64.0 64.0 62.0 66.0 67.0 75.0 56.0 71.0 14:30:49 INFO - PROCESS | 1791 | -------- Summary: end -------- 14:30:49 INFO - PROCESS | 1791 | 14:30:50 INFO - TEST-INFO | 1791: exit 0 14:30:50 INFO - TEST-OK | kraken | took 59053ms 14:30:50 INFO - SUITE-END | took 1178s 14:30:50 INFO - Completed test suite (00:19:39) 14:30:50 INFO - javascript benchmark 14:30:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7870.357893448036, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2974.628171478565, 3566.536350274462, 3568.0901370150614, 3590.712742980562, 3605.7836529808214, 6202.813915582534, 6244.843878903019, 6250.968745156268, 6295.244570651523, 6300.968495157524, 6171.4445699887, 6231.634309848493, 6243.375662433755, 6258.311585725578, 6274.152989346437, 5516.227728118067, 5538.667679939206, 5557.972210138943, 5575.498205161534, 5637.859053523674, 5419.59353048521, 5428.4300148484435, 5428.61999660024, 5616.550675945915, 5645.943540564604, 5532.446755324456, 5536.640118392292, 5539.473749993744, 5546.556275497971, 5549.667019978794, 5497.752601132958, 5523.558115350803, 5525.944740552583, 5537.446255374451, 5539.612227144102, 5367.677939323653, 5448.0, 5465.344158700942, 5465.945340546584, 5481.150421684645, 6181.505479561624, 6183.258009038944, 6196.969015154896, 6202.968985155046, 6204.441600255998, 6355.3009168991375, 6422.550421470499, 6453.806385808433, 6534.24856141545, 6537.705803238818, 6636.900446493307, 6648.069270302161, 6648.66756662165, 6651.76718814844, 6654.733810647568, 6294.685265736694, 6327.620342779448, 6336.429721325103, 6372.012338087604, 6393.456556192683, 6428.517861160338, 6487.0, 6494.870102597922, 6662.900056499157, 6685.130932978682, 6233.470155036782, 6457.192850893638, 6480.060391243338, 6484.708188131451, 6504.837379065561, 6632.237292711304, 6642.070110184578, 6645.900311495331, 6653.434458071021, 6657.334266573401, 6323.52573556985, 6368.363163683594, 6418.903716444257, 6503.739850405931, 6541.34586541342, 6474.5791523550815, 6528.151340325728, 6545.083688283644, 6545.280019197884, 6589.472842172615, 4840.298156767249, 5230.947690523122, 5278.630495865253, 5288.286081379041, 5293.894122117613, 4616.307553866947, 4666.416697912761, 4672.182368085571, 4714.151452738472, 4719.362886010414, 6155.661438620829, 6203.503719702503, 6251.9687401562705, 6306.306306306395, 6335.049742538564, 6637.966810165918, 6650.401463868178, 6652.301508341651, 6657.23441804189, 6661.200655921223, 6277.2153480814895, 6278.591891527036, 6310.305866354697, 6313.494920406357, 6320.146780184617, 5616.382197958222, 5677.14842773579, 5716.657000579979, 5780.104083867007, 5794.855128621818, 6831.146106736757, 6900.206476255295, 6905.274946130584, 6907.758228461979, 6926.341997510229, 6610.933890661032, 6649.501287403367, 6671.566348187353, 6685.0, 6686.83282917931, 6504.317046710027, 6538.215414150332, 6829.6585170742255, 6863.073485079451, 6925.757598484029, 6356.968215158895, 6378.9362106380195, 6395.456386207225, 6396.168498095218, 6405.615663060231, 5618.6628802272, 6533.640649764308, 6622.304658010839, 6627.906395444697, 6661.267260601427, 6396.29640739509, 6450.9354906450335, 6465.127207826883, 6477.060826180272, 6479.481641468766, 6223.190985171898, 6431.903521447089, 6437.967810160919, 6438.0, 6446.226452825691, 6274.46667033289, 6320.051992201206, 6342.112104305309, 6363.427291543783, 6373.3945275198785, 6283.654399008098, 6328.873422531616, 6341.207349081365, 6347.71435285404, 6406.135171751754, 6380.489560835029, 6393.456556192589, 6397.4562162216735, 6406.519511036598, 6409.166808314889], "value": 6061.722526380456, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.6352623082729, 832.7668252889191, 895.4895709445615, 906.6962567539874, 907.4419232172212, 40070.59929400709, 40771.59228407719, 43035.569644303585, 43066.569334306645, 43096.35355469662, 41812.0, 42001.57998420015, 42011.94970125741, 42055.57944420555, 42109.15781684372, 7904.920950790476, 9643.228541716664, 9793.90206097937, 9794.657186998456, 9797.167240784542, 7994.48035877669, 8065.072516660571, 8081.838363232732, 8089.0, 11626.651200463999, 11760.23558468701, 11797.351145686984, 11834.822477662841, 11839.171258011942, 11848.466818993165, 11752.41237938104, 11772.35252061132, 11778.234414763014, 11785.528578856836, 11793.23343982647, 11463.94268028663, 11503.59737409195, 11514.021308188814, 11542.538298468051, 11543.307401555849, 39832.40251396231, 39935.60064399348, 39997.80001100005, 40016.79949601516, 40140.79929600333, 4017.0961533654986, 4057.5333836608875, 4100.34394496879, 4104.363823607346, 4110.527289361702, 28680.856595717098, 28889.133326000254, 29716.5141742912, 30226.84886575553, 31071.689283107105, 3244.610646722385, 3256.853441595134, 3281.6390197078304, 3395.7792743471596, 3405.0125463615523, 352438.0, 356440.0, 357463.0, 357596.4240357589, 357944.0, 35204.99999999949, 36044.81977590148, 51019.744901275255, 51096.48903510992, 51228.74385628048, 37702.24595508075, 37835.432468513, 37852.0, 37874.43188352177, 37878.43182352267, 14890.734287585676, 15434.845651543565, 15737.718030885457, 15754.76367854483, 15777.842221577866, 13315.001374896921, 13335.533256336175, 13361.599152025456, 13364.0, 13368.598942031755, 11903.107266955012, 11936.104792140624, 11983.760324793455, 12028.819567706492, 12029.578964736193, 4822.831200907952, 5305.549028332635, 5397.919031214535, 5821.621594596338, 5929.902967950943, 1094.7372630568766, 1149.3968143872873, 1153.5501154549731, 1160.7504386556932, 1188.3523479703583, 22313.99587018588, 26908.0, 27317.590236146472, 27513.021612883706, 27672.723272767416, 1095.4741723972538, 1281.1992504684572, 1292.7802273613509, 1295.7343744532348, 1349.7502961951875, 14019.41302734662, 14177.07848989833, 14226.430942762174, 14475.92762036183, 14490.565283041315, 427038.0, 427294.0, 427512.0, 427931.0, 428333.0, 57757.0, 57866.817325046686, 57872.0, 58188.70905645445, 58246.12630810456, 1485.3464475630904, 1504.7818066380094, 1511.0, 1529.3347393883696, 1535.6391248056698, 23112.768872311735, 26858.731412686404, 27411.725882741714, 27873.860630696716, 27889.44221115607, 37580.06049848776, 37752.81123594474, 37828.43257351087, 37877.0, 37996.2400751989, 356939.0, 418103.0, 419306.7103993504, 419505.0, 421997.0, 24460.165487588147, 24839.62740558857, 28783.5682464759, 29079.0, 29200.26999324949, 37313.44029839609, 38675.0, 38745.837624871296, 40062.79968600138, 41418.964525887095, 28284.292892677848, 28728.712712872602, 29920.0, 29999.100026999226, 30113.698863011967, 28571.42857142887, 28678.56982145311, 28795.5680664786, 28910.0, 29757.95847145426, 33666.82166124272, 34460.31079378448, 34731.4790278141, 34775.78284760021, 34866.47700284447, 28366.0, 28984.710152899046, 29069.418611627225, 29225.0, 30022.3995520084, 22069.448263792892, 23086.076556937533, 23532.764672353056, 23537.175538935437, 23613.881930590236], "value": 18572.83178355251, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.1489701421045, 417.6512611969006, 424.4545758700071, 428.63137701576636, 463.619831737975, 17343.913280433597, 20948.847813370277, 23021.309360719162, 23074.077036918545, 23100.88449557752, 22571.210007649737, 23097.76902230977, 23480.76519234807, 23661.053557857664, 23888.28335149948, 7012.8597428051535, 7212.278772122772, 7266.2733726627175, 7288.59912704801, 7484.3638290745075, 7739.419543534257, 7874.055113386373, 7903.48627339224, 7912.327452166573, 7916.40626952978, 7592.962035189817, 7838.764837054869, 7902.288794008538, 7916.445848790587, 7935.841283174333, 7611.847763044763, 7812.101608315032, 7833.0, 7869.803254918645, 7905.96047019767, 7513.060867391576, 7550.433717471156, 7657.195994420617, 7680.231976802331, 7681.270279323456, 19985.100670469863, 25165.62251566228, 25558.488830223476, 25610.871945640338, 25655.1020714276, 2896.681365049843, 2980.657224419176, 3019.8490075496356, 3020.5771192033135, 3057.3732384861273, 13011.763882431249, 16460.67078658432, 16557.92373495731, 16749.0, 17398.0, 1922.6731455652573, 2041.3161590867078, 2074.0770357191054, 2118.5656940327194, 2142.3572928121503, 130829.0, 135301.97047044302, 176890.0, 177517.0, 181833.18166818295, 19404.708929366072, 20559.430071241095, 20695.689564656543, 20759.68860467094, 20813.58372832535, 29171.85414072916, 29252.707472924998, 32748.0, 32784.3443131136, 32911.3417731644, 10445.529951152217, 10520.894791052144, 10702.46487675613, 10719.678409647722, 10827.025567698945, 7498.625068746541, 8754.781130471789, 8880.8667869982, 8911.50986695725, 9078.54607269634, 9290.860637090449, 9338.673146439842, 9485.810283794286, 9507.667231646998, 9508.714738557854, 3215.244417561871, 3414.9487757683655, 4100.630943215066, 4145.523264824584, 4178.979105104455, 992.1170158558888, 1048.8059708953715, 1058.4125810175274, 1059.142094903131, 1119.2724728926264, 19699.507512312306, 20360.0, 21476.355709328745, 22325.665115023286, 22941.311760647208, 1085.7719878825535, 1096.6655170173015, 1097.8847221041835, 1103.1395511501041, 1113.7549739057395, 10613.840792387966, 10820.72948176286, 11557.826632600518, 11567.537298508134, 11589.362585057903, 725420.0, 750664.0, 768495.0, 780872.0, 787467.0, 171069.14465427594, 171300.0, 172712.0, 172970.0, 177517.0, 1199.91600587958, 1234.7283597608512, 1258.2513404524293, 1260.5462033667873, 1262.0912942681255, 19244.807551924303, 19333.13000914934, 19661.72198807073, 19716.915569643807, 19749.506262343555, 43270.0, 45010.32484512669, 54786.45213547973, 57804.71097644485, 59892.70053649704, 76405.61797190979, 83617.58191209006, 84303.0, 85179.57410212909, 85208.57395712982, 11577.768444630892, 11748.706282342668, 11754.941225293818, 11786.882131178922, 12082.275063496218, 13074.150180238634, 13246.536371226961, 13279.86720132825, 13309.534166304133, 13589.32053397346, 11645.47595358194, 11654.53381864716, 11793.70515737079, 11859.762804744028, 11967.546652936302, 10309.329893557195, 10333.689989300032, 10566.682999510027, 10602.151827853908, 10751.354918704903, 11603.0, 11630.0, 11801.35092569917, 12053.939730301292, 12054.517819287481, 11669.88330116722, 11697.707557311136, 11776.116791240862, 11781.705457363634, 12014.939925300318, 10772.353658780497, 10893.949694085668, 10894.291871028357, 10905.34567925927, 10947.660963406237], "value": 11907.36155619133, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1392.7493051250772, 1562.0705680120332, 1583.6990971715372, 1585.4213212177551, 1595.9122248276344, 8010.799730006745, 9609.135177833994, 11240.887591124087, 11285.661430157088, 11681.240719353236, 11336.773264534724, 11398.943005284982, 11410.600628977987, 11411.48648310826, 11421.942890285558, 2447.804175665947, 2495.363682261021, 2496.2885577610386, 2498.6127150291645, 2499.3626625210545, 2115.122224276923, 2190.2553131935138, 2429.8906549205326, 2497.5878979968284, 2516.6099254615565, 2441.7802397784194, 2447.4737931344757, 2467.9136230231948, 2467.938301542458, 2473.950520989579, 2489.21589699246, 2490.8007359411204, 2492.8130390220626, 2493.488834788864, 2498.0132847525124, 2209.2046863129262, 2428.2836563213896, 2449.4366295751897, 2456.336789066942, 2460.4463995601027, 11439.256448330914, 11484.196106272564, 11534.59628912984, 11537.653870383901, 11540.134489913291, 5994.970025149846, 6181.165542651729, 6193.566450348478, 6194.81415557534, 6211.192544969125, 3384.932301353984, 3671.724620653435, 3822.7515211511163, 3880.980595097035, 3885.494885664874, 1248.4070066718327, 1272.4464857786893, 1280.5454063807308, 1295.1128476993194, 1303.6610481274936, 15831.129287889162, 16017.359305627877, 16023.278952447168, 16030.5992350191, 16054.0, 4850.393700787402, 5097.974510127426, 5148.459411761711, 5152.768125434364, 5212.322398088224, 13341.93329033368, 13351.399187036606, 13360.933195334155, 13390.799138012937, 13420.396082176325, 6192.566520343623, 6203.410675985774, 6207.193064901534, 6211.596246243979, 6212.285587157535, 4728.38530990969, 5452.645578037414, 5464.562834973192, 5496.697681627469, 5582.358028826737, 3586.605473397924, 3776.546814382292, 3862.208247309295, 4175.561566035583, 4234.597713217239, 1003.6386900715737, 1143.5711608146944, 1165.597868735285, 1165.889240522149, 1181.7163880668577, 989.747614358334, 993.3741742702051, 1010.9991108802233, 1024.0834453164375, 1032.256775121911, 6756.527043106936, 6800.489963252677, 6847.623380714009, 6871.931280687229, 6910.965445172742, 1089.5478376473834, 1107.7729065541544, 1112.9721756956142, 1129.1249281806665, 1157.8089615213396, 4261.722988005769, 4267.722598031118, 4310.685241001524, 4471.463424389029, 4585.312203169551, 11793.233439826385, 13800.964927630468, 13896.235707036009, 13898.166110033228, 14217.786733199011, 13801.792973105412, 14081.436742530388, 14122.646933826736, 14159.78760318596, 14186.787198192036, 8963.417377870417, 10018.29871908974, 10451.216158788122, 10489.947550262352, 10519.421431821323, 6993.580385176906, 7051.906954422073, 7312.378447831994, 7323.304286092813, 7328.303811137934, 12375.814362784386, 12825.486980520674, 12948.676283092622, 12952.41714122848, 12984.545540906023, 12921.935390322988, 12942.67643308887, 12949.223046617233, 13006.219626822043, 13172.868271317164, 9458.810823783624, 9462.810743785223, 9658.179054780423, 9681.37071090377, 9690.98244684298, 9277.48973806447, 9546.284028697737, 9663.323567350219, 9666.323357364918, 10490.52792624349, 8024.157463466252, 8904.465732056098, 9050.864237036581, 9226.861597075915, 9230.630774769203, 8791.5164665944, 8919.509426981318, 8981.506017169118, 8988.146126118008, 9039.68361107358, 8146.796330091795, 8155.714549990722, 8267.131951145044, 8279.37904657141, 8285.130061343472, 5999.9100013498955, 6010.368911264429, 6032.33644299118, 6236.251649802053, 6274.090256912813, 6066.969665151646, 6067.666278354556, 6230.221222347207, 6280.466160376419, 6314.179156709598], "value": 5338.490487530886, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.0518444666002, 388.4154347706702, 393.3981009056145, 395.3239959668964, 399.1259142477973, 4553.704009239397, 4697.828965448326, 4949.777260023298, 5161.148410512265, 5314.734263286839, 4201.411802347674, 4339.0, 4339.9783001085025, 5106.872328191797, 5220.634555581111, 3737.682297004758, 3932.4101384792366, 4035.656969157625, 4144.12973275611, 4242.872713818575, 4284.464441944757, 4293.957060429402, 4294.7852607369505, 4324.956750432502, 4338.765535749092, 3614.3855544557487, 3890.7355109589357, 4105.651019663333, 4237.0, 4283.229018776619, 3760.304343696425, 3798.2593394288124, 4238.724482908601, 4250.277452832995, 4297.935530967038, 3156.6685498022607, 3549.09498077991, 3577.284543091392, 3911.902202444933, 3931.6658084062888, 4061.79691015451, 5015.266679659594, 5045.520675535855, 5101.51535604117, 5119.360079990001, 4567.954320456786, 4654.441467023945, 4892.633052521075, 4933.914538801458, 4965.503449655005, 4695.192350944911, 4995.625328100407, 5350.625456218067, 5517.613767036309, 5524.8342549723575, 4299.065420560729, 4379.44529691958, 4395.450568678915, 4403.405540252057, 4446.621547320308, 5110.8466745997675, 5474.166154338302, 5594.944050559483, 5761.452661997104, 5792.565557583198, 3969.622885825842, 4180.372944058416, 4306.834476659653, 4321.0, 4407.735535867858, 3960.6435420812263, 4077.6330130288416, 4556.658250631216, 4562.703424277412, 4597.977010114928, 4665.906681866344, 4697.839650522887, 4704.529547045337, 4918.745719841418, 4927.581155601814, 4560.566746159109, 5256.710880901587, 5438.536945714429, 5491.423400542885, 5568.693721845338, 1533.700928318967, 1536.8473644766425, 1537.9769303460457, 1538.9538313850603, 1546.6520032992712, 1030.4744580263969, 1065.2170654568886, 1074.6614816332985, 1076.9876316262687, 1149.8677652069953, 4363.0, 4658.9251094277615, 5033.245013247969, 5111.003354345867, 5150.982233857597, 4710.8351207707565, 5377.569794416438, 5679.716014199274, 5690.658560486384, 5730.885382292331, 4928.018548777938, 5116.309298244763, 5146.433892271847, 5158.92261616076, 5252.79185787271, 2602.3624212067784, 2880.8991685290916, 2954.2762023304426, 2961.6890226526334, 2967.2730181105767, 5478.439014640516, 5598.496135347838, 5729.8567535811935, 5856.824295271149, 5871.4128587141795, 5560.942451292966, 5755.740991655385, 5768.798092066758, 5789.507891829157, 5811.157382179645, 4809.687370320918, 4884.658073934862, 5644.6330988485615, 5771.538276937835, 5794.623349482355, 4973.676711013773, 5241.371035475615, 5312.681239125664, 5344.679319240858, 5650.915236271541, 5004.874878128076, 5291.497307755757, 5503.532774352133, 5529.778808847762, 5541.778328866962, 4466.665000125068, 5073.771680274471, 5138.97430512845, 5193.298904647975, 5755.510781583613, 3873.2059927714186, 4151.667866570728, 4153.688473364449, 4423.712458690175, 4454.661302816047, 5313.307251460198, 5327.680339179662, 5672.432756724294, 5704.743286552032, 5721.141828725725, 5082.0434132859855, 5463.972680136574, 5515.420880807618, 5518.806841760519, 5531.778728850801, 5281.7024594300065, 5386.676799392049, 5497.340319161726, 5508.697021663847, 5519.917201242065, 4645.512221216723, 4729.36153619257, 5208.921866172086, 5329.214713071009, 5360.892782144413, 4596.4024676791805, 4865.878353041202, 4938.43208031081, 5517.503424691637, 5518.2826232589505, 4788.808447662054, 5002.899942001067, 5169.810943482945, 5273.419923808455, 5360.596021526281], "value": 4155.077477736449, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [781.4529829119617, 813.1299509524811, 848.5375470368648, 888.8311220868035, 894.2086253665506, 16090.0, 17790.733139002925, 17817.109144542785, 17825.197866096023, 17949.551261218476, 16249.0, 16334.34662613494, 16347.673046539063, 16443.2600532976, 16540.421085261987, 982.4645568165367, 989.529973262698, 990.5938565188238, 991.7371896447447, 991.8859331176899, 984.6061575369838, 985.3644399362407, 986.013986013986, 1005.4369553050278, 1033.8914413986536, 1067.1249575348218, 1069.3476979042778, 1070.3203465799234, 1071.212658695858, 1072.4530489450397, 1054.425338190684, 1057.3285963413211, 1057.4765491081887, 1058.7088550648557, 1060.2737125069352, 791.3748138970207, 791.9722809701633, 792.1919641965221, 792.579932635704, 792.9524228546248, 16408.589785255346, 16592.917035414746, 16819.91590042042, 17743.201555930013, 17789.377371792056, 14641.48754793577, 14941.551753447415, 15059.548213553611, 15115.773263401057, 15295.541133766004, 12019.399030048462, 12213.0, 12245.32650704211, 12344.75310493785, 12834.422450989634, 3918.1771827916173, 3937.5668676445566, 4062.329715596923, 4083.7549747015273, 4099.323611604082, 123226.0, 124327.75672243252, 127575.08637370447, 127796.0, 129071.77320566967, 11290.54837806495, 11436.542538298374, 11477.827832582518, 11568.710782230342, 12097.092718046182, 23427.414314642272, 23797.524049518914, 23978.52042959131, 24106.51786964286, 24137.0, 7995.440319177718, 8033.799155021171, 8065.072516660542, 8148.144444833326, 8264.338852891755, 4194.182134483746, 4566.543345665407, 4601.33280674307, 4638.582527572535, 4734.19518681825, 3364.411228035084, 3497.178163131662, 3516.367053930317, 3518.138056176253, 3518.437050071976, 529.3462573721451, 530.4006472685841, 592.3839207224438, 606.9119977603223, 607.5625549604277, 679.9354061364163, 710.6801939127309, 715.7637979466867, 716.8673795347773, 745.5899255409503, 9959.402435853726, 10208.591656333812, 10752.838707419394, 11446.427678616035, 11937.940310298392, 568.8236646639555, 572.3446653581709, 632.4845251120322, 675.3449154320301, 719.1485758965727, 5276.947230527722, 5412.188171774186, 5413.431589683105, 5415.972920135374, 5435.510804027656, 79849.0, 92745.5362723182, 98413.0, 102395.97604024013, 104455.95544044614, 50360.0, 56522.0, 74191.1452213699, 79464.60267698625, 90975.54512227396, 76452.0, 78364.0, 78999.60500197462, 80626.59686701764, 81423.0, 11105.444727763741, 11188.496517656888, 11297.77529924889, 11407.657770266906, 11549.133814963743, 36031.63968360283, 48220.0, 49869.75065124651, 51311.743441284045, 51770.48229517657, 67676.6616166916, 69226.96159557509, 71122.64438677774, 72019.27980720125, 73919.63040184765, 13162.078654494093, 13602.319884005958, 13795.0, 13928.303584820516, 13955.511557095453, 14909.85090149128, 15135.545933622008, 15938.442154524537, 16138.112403817902, 16298.59253518624, 13882.861171388156, 14100.506482273071, 14763.188024658746, 15485.148316842682, 15816.841831581996, 14254.572362829133, 14557.636059098608, 14693.118412895261, 14718.926405367905, 15058.849411505746, 13279.800802988157, 14351.784723229368, 14398.640033999234, 14399.496017639332, 14484.782728259295, 10593.629222977159, 10641.0, 10750.51622676997, 10953.726156846142, 11008.724781880517, 10995.835062473909, 11509.568950098319, 11782.764344713229, 11806.0, 11825.46785394642], "value": 7991.695927957857, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1431.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 175.0, 149.0, 117.0, 114.0, 116.0, 117.0, 116.0, 116.0, 116.0], "value": 126.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 106.0, 107.0, 140.0, 107.0, 107.0, 108.0, 106.0, 126.0, 107.0], "value": 115.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 184.0, 186.0, 183.0, 186.0, 184.0, 183.0, 184.0, 185.0, 187.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 64.0, 68.0, 113.0, 87.0, 72.0, 59.0, 58.0, 76.0, 49.0], "value": 72.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 69.0, 86.0, 70.0, 69.0, 67.0, 81.0, 68.0, 67.0, 80.0], "value": 74.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 89.0, 89.0, 90.0, 89.0, 89.0, 88.0, 90.0, 89.0], "value": 89.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 100.0, 97.0, 138.0, 149.0, 103.0, 95.0, 94.0, 96.0, 95.0], "value": 106.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 84.0, 86.0, 83.0, 84.0, 85.0, 86.0, 91.0, 115.0], "value": 88.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 64.0, 63.0, 62.0, 62.0, 59.0, 61.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 66.0, 71.0, 64.0, 63.0, 57.0, 58.0, 59.0, 59.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 81.0, 95.0, 95.0, 96.0, 81.0, 81.0, 82.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 148.0, 122.0, 134.0, 137.0, 151.0, 148.0, 176.0, 123.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 160.0, 162.0, 160.0, 159.0, 162.0, 163.0, 160.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 62.0, 66.0, 67.0, 75.0, 56.0, 71.0], "value": 65.4, "unit": "score"}]}]} 14:30:50 INFO - Return code: 0 14:30:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:30:50 INFO - # TBPL SUCCESS # 14:30:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:30:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:30:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:30:50 INFO - 2017-04-19 14:30:50.669 screenresolution[1801:9898] starting screenresolution argv=screenresolution get 14:30:50 INFO - 2017-04-19 14:30:50.672 screenresolution[1801:9898] Display 0: 1600x1200x32@60 14:30:50 INFO - 2017-04-19 14:30:50.678 screenresolution[1802:9901] starting screenresolution argv=screenresolution list 14:30:50 INFO - Available Modes on Display 0 14:30:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:30:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:30:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:30:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:30:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:30:50 INFO - Intel Iris: 14:30:50 INFO - Chipset Model: Intel Iris 14:30:50 INFO - Type: GPU 14:30:50 INFO - Bus: Built-In 14:30:50 INFO - VRAM (Dynamic, Max): 1536 MB 14:30:50 INFO - Vendor: Intel (0x8086) 14:30:50 INFO - Device ID: 0x0a2e 14:30:50 INFO - Revision ID: 0x0009 14:30:50 INFO - Displays: 14:30:50 INFO - Display: 14:30:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:30:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:30:50 INFO - Display Serial Number: 1600x1200 60 14:30:50 INFO - Main Display: Yes 14:30:50 INFO - Mirror: Off 14:30:50 INFO - Online: Yes 14:30:50 INFO - Rotation: Supported 14:30:50 INFO - Return code: 0 14:30:50 INFO - Running post-action listener: _resource_record_post_action 14:30:50 INFO - [mozharness: 2017-04-19 21:30:50.923694Z] Finished run-tests step (success) 14:30:50 INFO - Running post-run listener: _resource_record_post_run 14:30:50 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 49513472; Write bytes: 423758336; Read time: 566; Write time: 1439 14:30:50 INFO - TinderboxPrint: CPU usage
53.8% 14:30:50 INFO - TinderboxPrint: I/O read bytes / time
49,513,472 / 566 14:30:50 INFO - TinderboxPrint: I/O write bytes / time
423,758,336 / 1,439 14:30:50 INFO - TinderboxPrint: CPU idle
2,208.4 (46.2%) 14:30:50 INFO - TinderboxPrint: CPU system
953.3 (20.0%) 14:30:50 INFO - TinderboxPrint: CPU user
1,615.9 (33.8%) 14:30:50 INFO - TinderboxPrint: Swap in / out
161,316,864 / 0 14:30:50 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 121342464; Write bytes: 113582080; Read time: 11093; Write time: 214 14:30:51 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 44344320; Write bytes: 299964928; Read time: 531; Write time: 1190 14:30:51 INFO - Running post-run listener: _upload_blobber_files 14:30:51 INFO - Blob upload gear active. 14:30:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:30:51 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:30:51 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:30:51 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:30:51 INFO - (blobuploader) - INFO - Open directory for files ... 14:30:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:30:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:30:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:52 INFO - (blobuploader) - INFO - Done attempting. 14:30:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:30:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:30:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:54 INFO - (blobuploader) - INFO - Done attempting. 14:30:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:30:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:30:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:55 INFO - (blobuploader) - INFO - Done attempting. 14:30:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:30:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:30:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:57 INFO - (blobuploader) - INFO - Done attempting. 14:30:57 INFO - (blobuploader) - INFO - Iteration through files over. 14:30:57 INFO - Return code: 0 14:30:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:30:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:30:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1118d8a4bf77c62e341877c708dfdeff7d7e7fb278905ccbd28e0b1d68297338ac0ade88e25a9813f11c53da143eaf81968c63180adcddb0b37a92b310d8dab4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f81a5b904353e8f62b5cba3800db038605d94b64217de00a08207347b21ed8fe13846d361126e88e780666cd98b868bf935d2a182c73d92226be9f43f5a6b31c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4afcd4c31758a1e7f7f785601c15a4dced16c84a1ec0373ba38fa52211d28fee6d31ed1d7d1030de4dea26c78a6dc7c68db9aabaace4e1657b8aab2e3afb739c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a9158cb8e9d9ab568fe6f1faf6dec5268cfa066a3ad1199acd85f40aac4059546320238788cf8a834c6c6ebff574b3272fb65332336c50010a3060ef1837619"} 14:30:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:30:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:30:57 INFO - Contents: 14:30:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1118d8a4bf77c62e341877c708dfdeff7d7e7fb278905ccbd28e0b1d68297338ac0ade88e25a9813f11c53da143eaf81968c63180adcddb0b37a92b310d8dab4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f81a5b904353e8f62b5cba3800db038605d94b64217de00a08207347b21ed8fe13846d361126e88e780666cd98b868bf935d2a182c73d92226be9f43f5a6b31c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4afcd4c31758a1e7f7f785601c15a4dced16c84a1ec0373ba38fa52211d28fee6d31ed1d7d1030de4dea26c78a6dc7c68db9aabaace4e1657b8aab2e3afb739c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a9158cb8e9d9ab568fe6f1faf6dec5268cfa066a3ad1199acd85f40aac4059546320238788cf8a834c6c6ebff574b3272fb65332336c50010a3060ef1837619"} 14:30:57 INFO - Running post-run listener: copy_logs_to_upload_dir 14:30:57 INFO - Copying logs to upload dir... 14:30:57 INFO - mkdir: /builds/slave/test/build/upload/logs 14:30:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.801161 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-19 14:30:57.628368) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-19 14:30:57.632303) ========= 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.1gELGd2uox/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.eVmepHBRN9/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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/1118d8a4bf77c62e341877c708dfdeff7d7e7fb278905ccbd28e0b1d68297338ac0ade88e25a9813f11c53da143eaf81968c63180adcddb0b37a92b310d8dab4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f81a5b904353e8f62b5cba3800db038605d94b64217de00a08207347b21ed8fe13846d361126e88e780666cd98b868bf935d2a182c73d92226be9f43f5a6b31c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4afcd4c31758a1e7f7f785601c15a4dced16c84a1ec0373ba38fa52211d28fee6d31ed1d7d1030de4dea26c78a6dc7c68db9aabaace4e1657b8aab2e3afb739c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a9158cb8e9d9ab568fe6f1faf6dec5268cfa066a3ad1199acd85f40aac4059546320238788cf8a834c6c6ebff574b3272fb65332336c50010a3060ef1837619"} build_url:https://queue.taskcluster.net/v1/task/MHFkCzUVTp-DT-SXzYzY-Q/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009977 build_url: 'https://queue.taskcluster.net/v1/task/MHFkCzUVTp-DT-SXzYzY-Q/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/1118d8a4bf77c62e341877c708dfdeff7d7e7fb278905ccbd28e0b1d68297338ac0ade88e25a9813f11c53da143eaf81968c63180adcddb0b37a92b310d8dab4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f81a5b904353e8f62b5cba3800db038605d94b64217de00a08207347b21ed8fe13846d361126e88e780666cd98b868bf935d2a182c73d92226be9f43f5a6b31c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4afcd4c31758a1e7f7f785601c15a4dced16c84a1ec0373ba38fa52211d28fee6d31ed1d7d1030de4dea26c78a6dc7c68db9aabaace4e1657b8aab2e3afb739c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a9158cb8e9d9ab568fe6f1faf6dec5268cfa066a3ad1199acd85f40aac4059546320238788cf8a834c6c6ebff574b3272fb65332336c50010a3060ef1837619"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-19 14:30:57.663782) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 14:30:57.664146) ========= 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.1gELGd2uox/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.eVmepHBRN9/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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.004816 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 14:30:57.712878) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-19 14:30:57.713223) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-19 14:30:57.713581) ========= ========= Total master_lag: 4.19 =========