builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0234 starttime: 1475027976.5 results: success (0) buildid: 20160927170020 builduid: 33cdea3b12494133b1946c906ea71d1d revision: 4ab108caec1eb612793f17f657fc08dc9a694719 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 18:59:36.502941) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 18:59:36.503698) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 18:59:36.503980) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 18:59:36.572807) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 18:59:36.573113) ========= 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.fBIYrpO0l6/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.HQiIloG0EV/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-27 18:59:36-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 38.9M=0s 2016-09-27 18:59:37 (38.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.494328 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 18:59:37.089609) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 18:59:37.089944) ========= 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.fBIYrpO0l6/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.HQiIloG0EV/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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.025571 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 18:59:37.140412) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 18:59:37.140776) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 4ab108caec1eb612793f17f657fc08dc9a694719 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 4ab108caec1eb612793f17f657fc08dc9a694719 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fBIYrpO0l6/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.HQiIloG0EV/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-27 18:59:37,230 truncating revision to first 12 chars 2016-09-27 18:59:37,230 Setting DEBUG logging. 2016-09-27 18:59:37,230 attempt 1/10 2016-09-27 18:59:37,230 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/4ab108caec1e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 18:59:38,687 unpacking tar archive at: autoland-4ab108caec1e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.721771 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 18:59:38.883945) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 18:59:38.884270) ========= script_repo_revision: 4ab108caec1eb612793f17f657fc08dc9a694719 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 18:59:38.884681) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 18:59:38.884967) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 18:59:38.910443) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-09-27 18:59:38.910771) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fBIYrpO0l6/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.HQiIloG0EV/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 18:59:39 INFO - MultiFileLogger online at 20160927 18:59:39 in /builds/slave/test 18:59:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 18:59:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:59:39 INFO - {'append_to_log': False, 18:59:39 INFO - 'base_work_dir': '/builds/slave/test', 18:59:39 INFO - 'blob_upload_branch': 'Autoland', 18:59:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:59:39 INFO - 'branch': 'Autoland', 18:59:39 INFO - 'buildbot_json_path': 'buildprops.json', 18:59:39 INFO - 'config_files': ('talos/mac_config.py',), 18:59:39 INFO - 'default_actions': ('clobber', 18:59:39 INFO - 'read-buildbot-config', 18:59:39 INFO - 'download-and-extract', 18:59:39 INFO - 'populate-webroot', 18:59:39 INFO - 'create-virtualenv', 18:59:39 INFO - 'install', 18:59:39 INFO - 'run-tests'), 18:59:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:59:39 INFO - 'download_minidump_stackwalk': True, 18:59:39 INFO - 'download_symbols': 'ondemand', 18:59:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:59:39 INFO - 'tooltool.py': '/tools/tooltool.py', 18:59:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:59:39 INFO - '/tools/misc-python/virtualenv.py')}, 18:59:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:59:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:59:39 INFO - 'installer_path': 'installer.exe', 18:59:39 INFO - 'log_level': 'info', 18:59:39 INFO - 'log_name': 'talos', 18:59:39 INFO - 'log_to_console': True, 18:59:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:59:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:59:39 INFO - 'opt_config_files': (), 18:59:39 INFO - 'pip_index': False, 18:59:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:59:39 INFO - 'cmd': ('bash', 18:59:39 INFO - '-c', 18:59:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:59:39 INFO - 'enabled': True, 18:59:39 INFO - 'halt_on_failure': False, 18:59:39 INFO - 'name': 'check_screen_resolution'},), 18:59:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:59:39 INFO - 'cmd': ('bash', 18:59:39 INFO - '-c', 18:59:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:59:39 INFO - 'enabled': True, 18:59:39 INFO - 'halt_on_failure': False, 18:59:39 INFO - 'name': 'check_screen_resolution'},), 18:59:39 INFO - 'run_cmd_checks_enabled': True, 18:59:39 INFO - 'sps_profile': False, 18:59:39 INFO - 'sps_profile_interval': 0, 18:59:39 INFO - 'suite': 'dromaeojs', 18:59:39 INFO - 'system_bits': '32', 18:59:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:59:39 INFO - 'title': 't-yosemite-r7-0234', 18:59:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:59:39 INFO - 'use_talos_json': True, 18:59:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:59:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:59:39 INFO - 'work_dir': 'build'} 18:59:39 INFO - [mozharness: 2016-09-28 01:59:39.132797Z] Running clobber step. 18:59:39 INFO - Running pre-action listener: _resource_record_pre_action 18:59:39 INFO - Running main action method: clobber 18:59:39 INFO - rmtree: /builds/slave/test/build 18:59:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:59:41 INFO - Running post-action listener: _resource_record_post_action 18:59:41 INFO - [mozharness: 2016-09-28 01:59:41.195401Z] Finished clobber step (success) 18:59:41 INFO - [mozharness: 2016-09-28 01:59:41.195537Z] Running read-buildbot-config step. 18:59:41 INFO - Running pre-action listener: _resource_record_pre_action 18:59:41 INFO - Running main action method: read_buildbot_config 18:59:41 INFO - Using buildbot properties: 18:59:41 INFO - { 18:59:41 INFO - "project": "", 18:59:41 INFO - "product": "firefox", 18:59:41 INFO - "script_repo_revision": "production", 18:59:41 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 18:59:41 INFO - "repository": "", 18:59:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 18:59:41 INFO - "buildid": "20160927170020", 18:59:41 INFO - "pgo_build": "False", 18:59:41 INFO - "basedir": "/builds/slave/test", 18:59:41 INFO - "buildnumber": 301, 18:59:41 INFO - "slavename": "t-yosemite-r7-0234", 18:59:41 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 18:59:41 INFO - "platform": "yosemite_r7", 18:59:41 INFO - "scheduler": "tests-autoland-macosx64-talos", 18:59:41 INFO - "branch": "autoland", 18:59:41 INFO - "repo_path": "integration/autoland", 18:59:41 INFO - "revision": "4ab108caec1eb612793f17f657fc08dc9a694719", 18:59:41 INFO - "stage_platform": "macosx64", 18:59:41 INFO - "builduid": "33cdea3b12494133b1946c906ea71d1d", 18:59:41 INFO - "slavebuilddir": "test" 18:59:41 INFO - } 18:59:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/JkQAqoMfTuiDhnNvfL69PA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 18:59:41 INFO - Running post-action listener: _resource_record_post_action 18:59:41 INFO - [mozharness: 2016-09-28 01:59:41.198640Z] Finished read-buildbot-config step (success) 18:59:41 INFO - [mozharness: 2016-09-28 01:59:41.198784Z] Running download-and-extract step. 18:59:41 INFO - Running pre-action listener: _resource_record_pre_action 18:59:41 INFO - Running main action method: download_and_extract 18:59:41 INFO - mkdir: /builds/slave/test/build/tests 18:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:41 INFO - trying https://queue.taskcluster.net/v1/task/JkQAqoMfTuiDhnNvfL69PA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 18:59:41 INFO - Downloading https://queue.taskcluster.net/v1/task/JkQAqoMfTuiDhnNvfL69PA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 18:59:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JkQAqoMfTuiDhnNvfL69PA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 18:59:42 INFO - Downloaded 1057 bytes. 18:59:42 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 18:59:42 INFO - Using the following test package requirements: 18:59:42 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 18:59:42 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:59:42 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 18:59:42 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:59:42 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 18:59:42 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:59:42 INFO - u'jsshell-mac.zip'], 18:59:42 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:59:42 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 18:59:42 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 18:59:42 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:59:42 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 18:59:42 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:59:42 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 18:59:42 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:59:42 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 18:59:42 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:59:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JkQAqoMfTuiDhnNvfL69PA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 18:59:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JkQAqoMfTuiDhnNvfL69PA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:59:42 INFO - Fetch https://queue.taskcluster.net/v1/task/JkQAqoMfTuiDhnNvfL69PA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 18:59:43 INFO - Expected file size: 16470784 18:59:43 INFO - Content-Encoding None 18:59:43 INFO - Content-Type application/zip 18:59:43 INFO - Http code 200 18:59:50 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:59:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JkQAqoMfTuiDhnNvfL69PA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 18:59:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JkQAqoMfTuiDhnNvfL69PA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:59:50 INFO - Fetch https://queue.taskcluster.net/v1/task/JkQAqoMfTuiDhnNvfL69PA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 18:59:50 INFO - Expected file size: 16470784 18:59:50 INFO - Content-Encoding None 18:59:50 INFO - Content-Type application/zip 18:59:50 INFO - Http code 200 18:59:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JkQAqoMfTuiDhnNvfL69PA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 18:59:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JkQAqoMfTuiDhnNvfL69PA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:59:57 INFO - Fetch https://queue.taskcluster.net/v1/task/JkQAqoMfTuiDhnNvfL69PA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 18:59:58 INFO - Expected file size: 14414057 18:59:58 INFO - Content-Encoding None 18:59:58 INFO - Content-Type application/zip 18:59:58 INFO - Http code 200 18:59:58 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')]} 18:59:58 INFO - trying https://queue.taskcluster.net/v1/task/JkQAqoMfTuiDhnNvfL69PA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 18:59:58 INFO - Downloading https://queue.taskcluster.net/v1/task/JkQAqoMfTuiDhnNvfL69PA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 18:59:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JkQAqoMfTuiDhnNvfL69PA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 19:00:01 INFO - Downloaded 111656390 bytes. 19:00:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JkQAqoMfTuiDhnNvfL69PA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 19:00:01 INFO - mkdir: /builds/slave/test/properties 19:00:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:00:01 INFO - Writing to file /builds/slave/test/properties/build_url 19:00:01 INFO - Contents: 19:00:01 INFO - build_url:https://queue.taskcluster.net/v1/task/JkQAqoMfTuiDhnNvfL69PA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 19:00:02 INFO - Running post-action listener: _resource_record_post_action 19:00:02 INFO - Running post-action listener: set_extra_try_arguments 19:00:02 INFO - [mozharness: 2016-09-28 02:00:02.936416Z] Finished download-and-extract step (success) 19:00:02 INFO - [mozharness: 2016-09-28 02:00:02.936555Z] Running populate-webroot step. 19:00:02 INFO - Running pre-action listener: _resource_record_pre_action 19:00:02 INFO - Running main action method: populate_webroot 19:00:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:00:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:00:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:00:02 INFO - '--tppagecycles', 19:00:02 INFO - '7'], 19:00:02 INFO - 'tests': ['tsvgm']}}, 19:00:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:00:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:00:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:00:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:00:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:00:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:00:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:02 INFO - 'talos_options': ['--disable-e10s'], 19:00:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:02 INFO - 'talos_options': ['--disable-e10s'], 19:00:02 INFO - 'tests': ['damp', 'tps']}, 19:00:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:02 INFO - 'tests': ['damp', 'tps']}, 19:00:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:00:02 INFO - 'tests': ['dromaeo_dom']}, 19:00:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:00:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:00:02 INFO - 'tests': ['basic_compositor_video']}, 19:00:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:00:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:00:02 INFO - 'tests': ['a11yr', 19:00:02 INFO - 'ts_paint', 19:00:02 INFO - 'tpaint', 19:00:02 INFO - 'sessionrestore', 19:00:02 INFO - 'sessionrestore_no_auto_restore', 19:00:02 INFO - 'tabpaint']}, 19:00:02 INFO - 'other-e10s': {'tests': ['a11yr', 19:00:02 INFO - 'ts_paint', 19:00:02 INFO - 'tpaint', 19:00:02 INFO - 'sessionrestore', 19:00:02 INFO - 'sessionrestore_no_auto_restore', 19:00:02 INFO - 'tabpaint']}, 19:00:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:00:02 INFO - 'ts_paint', 19:00:02 INFO - 'tpaint', 19:00:02 INFO - 'sessionrestore', 19:00:02 INFO - 'sessionrestore_no_auto_restore', 19:00:02 INFO - 'tabpaint']}, 19:00:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:00:02 INFO - 'ts_paint', 19:00:02 INFO - 'tpaint', 19:00:02 INFO - 'sessionrestore', 19:00:02 INFO - 'sessionrestore_no_auto_restore', 19:00:02 INFO - 'tabpaint']}, 19:00:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:00:02 INFO - 'tests': ['a11yr', 19:00:02 INFO - 'ts_paint', 19:00:02 INFO - 'tpaint', 19:00:02 INFO - 'sessionrestore', 19:00:02 INFO - 'sessionrestore_no_auto_restore', 19:00:02 INFO - 'tabpaint']}, 19:00:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:00:02 INFO - 'tests': ['a11yr', 19:00:02 INFO - 'ts_paint', 19:00:02 INFO - 'tpaint', 19:00:02 INFO - 'sessionrestore', 19:00:02 INFO - 'sessionrestore_no_auto_restore', 19:00:02 INFO - 'tabpaint']}, 19:00:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:00:02 INFO - 'tests': ['tsvgx', 19:00:02 INFO - 'tsvgr_opacity', 19:00:02 INFO - 'tart', 19:00:02 INFO - 'tscrollx', 19:00:02 INFO - 'cart']}, 19:00:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:00:02 INFO - 'tsvgr_opacity', 19:00:02 INFO - 'tart', 19:00:02 INFO - 'tscrollx', 19:00:02 INFO - 'cart']}, 19:00:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:02 INFO - 'talos_options': ['--disable-e10s'], 19:00:02 INFO - 'tests': ['tp5o']}, 19:00:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:02 INFO - 'tests': ['tp5o']}, 19:00:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:02 INFO - 'talos_options': ['--disable-e10s', 19:00:02 INFO - '--xperf_path', 19:00:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:02 INFO - 'tests': ['tp5n']}, 19:00:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:02 INFO - 'talos_options': ['--xperf_path', 19:00:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:02 INFO - 'tests': ['tp5n']}}, 19:00:02 INFO - 'talos.zip': {'path': '', 19:00:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:00:02 INFO - Running post-action listener: _resource_record_post_action 19:00:02 INFO - [mozharness: 2016-09-28 02:00:02.955055Z] Finished populate-webroot step (success) 19:00:02 INFO - [mozharness: 2016-09-28 02:00:02.955174Z] Running create-virtualenv step. 19:00:02 INFO - Running pre-action listener: _resource_record_pre_action 19:00:02 INFO - Running main action method: create_virtualenv 19:00:02 INFO - Creating virtualenv /builds/slave/test/build/venv 19:00:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:00:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:00:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:00:03 INFO - Using real prefix '/tools/python27' 19:00:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:00:03 INFO - Installing distribute.............................................................................................................................................................................................done. 19:00:06 INFO - Installing pip.................done. 19:00:06 INFO - Return code: 0 19:00:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:00:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:00:06 INFO - Reading from file tmpfile_stdout 19:00:06 INFO - Output received: 19:00:06 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) 19:00:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107275570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9adac9a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107113d30>, '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 0x106f39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10710bb20>, '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.fBIYrpO0l6/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.HQiIloG0EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:00:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:00:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:00:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fBIYrpO0l6/Render', 19:00:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:06 INFO - 'HOME': '/Users/cltbld', 19:00:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:06 INFO - 'LOGNAME': 'cltbld', 19:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:06 INFO - 'MOZ_NO_REMOTE': '1', 19:00:06 INFO - 'NO_EM_RESTART': '1', 19:00:06 INFO - 'PAGER': '/bin/cat', 19:00:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:06 INFO - 'PWD': '/builds/slave/test', 19:00:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:06 INFO - 'SHELL': '/bin/bash', 19:00:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HQiIloG0EV/Listeners', 19:00:06 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 19:00:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:06 INFO - 'USER': 'cltbld', 19:00:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:06 INFO - 'XPC_FLAGS': '0x0', 19:00:06 INFO - 'XPC_SERVICE_NAME': '0', 19:00:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:00:07 INFO - Cleaning up... 19:00:07 INFO - Return code: 0 19:00:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107275570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9adac9a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107113d30>, '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 0x106f39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10710bb20>, '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.fBIYrpO0l6/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.HQiIloG0EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:00:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:00:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fBIYrpO0l6/Render', 19:00:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:07 INFO - 'HOME': '/Users/cltbld', 19:00:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:07 INFO - 'LOGNAME': 'cltbld', 19:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:07 INFO - 'MOZ_NO_REMOTE': '1', 19:00:07 INFO - 'NO_EM_RESTART': '1', 19:00:07 INFO - 'PAGER': '/bin/cat', 19:00:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:07 INFO - 'PWD': '/builds/slave/test', 19:00:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:07 INFO - 'SHELL': '/bin/bash', 19:00:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HQiIloG0EV/Listeners', 19:00:07 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 19:00:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:07 INFO - 'USER': 'cltbld', 19:00:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:07 INFO - 'XPC_FLAGS': '0x0', 19:00:07 INFO - 'XPC_SERVICE_NAME': '0', 19:00:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:07 INFO - Downloading/unpacking psutil>=3.1.1 19:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:00:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:10 INFO - Installing collected packages: psutil 19:00:10 INFO - Running setup.py install for psutil 19:00:10 INFO - building 'psutil._psutil_osx' extension 19:00:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 19:00:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 19:00:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 19:00:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 19:00:11 INFO - building 'psutil._psutil_posix' extension 19:00:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 19:00:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:00:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:00:11 INFO - ^ 19:00:11 INFO - 1 warning generated. 19:00:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 19:00:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:11 INFO - Successfully installed psutil 19:00:11 INFO - Cleaning up... 19:00:11 INFO - Return code: 0 19:00:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:00: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')]} 19:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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')]} 19:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107275570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9adac9a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107113d30>, '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 0x106f39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10710bb20>, '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.fBIYrpO0l6/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.HQiIloG0EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:00:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:00:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fBIYrpO0l6/Render', 19:00:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:11 INFO - 'HOME': '/Users/cltbld', 19:00:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:11 INFO - 'LOGNAME': 'cltbld', 19:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:11 INFO - 'MOZ_NO_REMOTE': '1', 19:00:11 INFO - 'NO_EM_RESTART': '1', 19:00:11 INFO - 'PAGER': '/bin/cat', 19:00:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:11 INFO - 'PWD': '/builds/slave/test', 19:00:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:11 INFO - 'SHELL': '/bin/bash', 19:00:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HQiIloG0EV/Listeners', 19:00:11 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 19:00:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:11 INFO - 'USER': 'cltbld', 19:00:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:11 INFO - 'XPC_FLAGS': '0x0', 19:00:11 INFO - 'XPC_SERVICE_NAME': '0', 19:00:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:00:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:00:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:00:14 INFO - Installing collected packages: mozsystemmonitor 19:00:14 INFO - Running setup.py install for mozsystemmonitor 19:00:14 INFO - Successfully installed mozsystemmonitor 19:00:14 INFO - Cleaning up... 19:00:14 INFO - Return code: 0 19:00:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107275570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9adac9a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107113d30>, '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 0x106f39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10710bb20>, '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.fBIYrpO0l6/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.HQiIloG0EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:00:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:00:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:00:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fBIYrpO0l6/Render', 19:00:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:14 INFO - 'HOME': '/Users/cltbld', 19:00:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:14 INFO - 'LOGNAME': 'cltbld', 19:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:14 INFO - 'MOZ_NO_REMOTE': '1', 19:00:14 INFO - 'NO_EM_RESTART': '1', 19:00:14 INFO - 'PAGER': '/bin/cat', 19:00:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:14 INFO - 'PWD': '/builds/slave/test', 19:00:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:14 INFO - 'SHELL': '/bin/bash', 19:00:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HQiIloG0EV/Listeners', 19:00:14 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 19:00:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:14 INFO - 'USER': 'cltbld', 19:00:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:14 INFO - 'XPC_FLAGS': '0x0', 19:00:14 INFO - 'XPC_SERVICE_NAME': '0', 19:00:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:15 INFO - Downloading/unpacking jsonschema==2.5.1 19:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:00:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:18 INFO - Downloading functools32-3.2.3-2.tar.gz 19:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:00:18 INFO - warning: no files found matching '*.txt' 19:00:18 INFO - no previously-included directories found matching 'build' 19:00:18 INFO - no previously-included directories found matching 'dist' 19:00:18 INFO - no previously-included directories found matching '.git*' 19:00:18 INFO - Installing collected packages: jsonschema, functools32 19:00:18 INFO - Running setup.py install for functools32 19:00:18 INFO - warning: no files found matching '*.txt' 19:00:18 INFO - no previously-included directories found matching 'build' 19:00:18 INFO - no previously-included directories found matching 'dist' 19:00:18 INFO - no previously-included directories found matching '.git*' 19:00:18 INFO - Successfully installed jsonschema functools32 19:00:18 INFO - Cleaning up... 19:00:18 INFO - Return code: 0 19:00:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107275570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9adac9a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107113d30>, '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 0x106f39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10710bb20>, '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.fBIYrpO0l6/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.HQiIloG0EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:00:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:00:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:00:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fBIYrpO0l6/Render', 19:00:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:18 INFO - 'HOME': '/Users/cltbld', 19:00:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:18 INFO - 'LOGNAME': 'cltbld', 19:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:18 INFO - 'MOZ_NO_REMOTE': '1', 19:00:18 INFO - 'NO_EM_RESTART': '1', 19:00:18 INFO - 'PAGER': '/bin/cat', 19:00:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:18 INFO - 'PWD': '/builds/slave/test', 19:00:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:18 INFO - 'SHELL': '/bin/bash', 19:00:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HQiIloG0EV/Listeners', 19:00:18 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 19:00:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:18 INFO - 'USER': 'cltbld', 19:00:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:18 INFO - 'XPC_FLAGS': '0x0', 19:00:18 INFO - 'XPC_SERVICE_NAME': '0', 19:00:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:00:18 INFO - Cleaning up... 19:00:18 INFO - Return code: 0 19:00:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107275570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9adac9a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107113d30>, '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 0x106f39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10710bb20>, '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.fBIYrpO0l6/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.HQiIloG0EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:00:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:00:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:00:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fBIYrpO0l6/Render', 19:00:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:18 INFO - 'HOME': '/Users/cltbld', 19:00:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:18 INFO - 'LOGNAME': 'cltbld', 19:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:18 INFO - 'MOZ_NO_REMOTE': '1', 19:00:18 INFO - 'NO_EM_RESTART': '1', 19:00:18 INFO - 'PAGER': '/bin/cat', 19:00:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:18 INFO - 'PWD': '/builds/slave/test', 19:00:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:18 INFO - 'SHELL': '/bin/bash', 19:00:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HQiIloG0EV/Listeners', 19:00:18 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 19:00:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:18 INFO - 'USER': 'cltbld', 19:00:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:18 INFO - 'XPC_FLAGS': '0x0', 19:00:18 INFO - 'XPC_SERVICE_NAME': '0', 19:00:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:18 INFO - Downloading/unpacking blobuploader==1.2.4 19:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:21 INFO - Downloading blobuploader-1.2.4.tar.gz 19:00:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:00:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:00:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:22 INFO - Downloading docopt-0.6.1.tar.gz 19:00:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:00:22 INFO - Installing collected packages: blobuploader, requests, docopt 19:00:22 INFO - Running setup.py install for blobuploader 19:00:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:00:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:00:22 INFO - Running setup.py install for requests 19:00:23 INFO - Running setup.py install for docopt 19:00:23 INFO - Successfully installed blobuploader requests docopt 19:00:23 INFO - Cleaning up... 19:00:23 INFO - Return code: 0 19:00:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107275570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9adac9a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107113d30>, '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 0x106f39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10710bb20>, '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.fBIYrpO0l6/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.HQiIloG0EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:00:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:00:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fBIYrpO0l6/Render', 19:00:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:23 INFO - 'HOME': '/Users/cltbld', 19:00:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:23 INFO - 'LOGNAME': 'cltbld', 19:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:23 INFO - 'MOZ_NO_REMOTE': '1', 19:00:23 INFO - 'NO_EM_RESTART': '1', 19:00:23 INFO - 'PAGER': '/bin/cat', 19:00:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:23 INFO - 'PWD': '/builds/slave/test', 19:00:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:23 INFO - 'SHELL': '/bin/bash', 19:00:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HQiIloG0EV/Listeners', 19:00:23 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 19:00:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:23 INFO - 'USER': 'cltbld', 19:00:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:23 INFO - 'XPC_FLAGS': '0x0', 19:00:23 INFO - 'XPC_SERVICE_NAME': '0', 19:00:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:00:23 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-7eADsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:00:23 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-5YCmaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:00:24 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-332nYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:00:24 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-Kzg42g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:00:24 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-5Jlha9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:00:24 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-K8umC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:00:24 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-x1GRyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:00:24 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-nKsUhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:00:24 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-Jvlnhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:00:24 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-u7Vcds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:00:24 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-_8EQXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:00:24 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-MNeYx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:00:25 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-SM196T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:00:25 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-zXe60Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:25 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-0zcwa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:00:25 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-XSlvXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:00:25 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-GdspL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:00:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:00:25 INFO - Running setup.py install for manifestparser 19:00:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:00:25 INFO - Running setup.py install for mozcrash 19:00:25 INFO - Running setup.py install for mozdebug 19:00:26 INFO - Running setup.py install for mozdevice 19:00:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:00:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:00:26 INFO - Running setup.py install for mozfile 19:00:26 INFO - Running setup.py install for mozhttpd 19:00:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:00:26 INFO - Running setup.py install for mozinfo 19:00:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:00:26 INFO - Running setup.py install for mozInstall 19:00:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:00:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:00:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:00:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:00:26 INFO - Running setup.py install for mozleak 19:00:26 INFO - Running setup.py install for mozlog 19:00:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:00:27 INFO - Running setup.py install for moznetwork 19:00:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:00:27 INFO - Running setup.py install for mozprocess 19:00:27 INFO - Running setup.py install for mozprofile 19:00:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:00:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:00:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:00:27 INFO - Running setup.py install for mozrunner 19:00:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:00:27 INFO - Running setup.py install for mozscreenshot 19:00:27 INFO - Running setup.py install for moztest 19:00:28 INFO - Running setup.py install for mozversion 19:00:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:00:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:00:28 INFO - Cleaning up... 19:00:28 INFO - Return code: 0 19:00:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107275570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9adac9a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107113d30>, '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 0x106f39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10710bb20>, '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.fBIYrpO0l6/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.HQiIloG0EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:00:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:00:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fBIYrpO0l6/Render', 19:00:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:28 INFO - 'HOME': '/Users/cltbld', 19:00:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:28 INFO - 'LOGNAME': 'cltbld', 19:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:28 INFO - 'MOZ_NO_REMOTE': '1', 19:00:28 INFO - 'NO_EM_RESTART': '1', 19:00:28 INFO - 'PAGER': '/bin/cat', 19:00:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:28 INFO - 'PWD': '/builds/slave/test', 19:00:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:28 INFO - 'SHELL': '/bin/bash', 19:00:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HQiIloG0EV/Listeners', 19:00:28 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 19:00:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:28 INFO - 'USER': 'cltbld', 19:00:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:28 INFO - 'XPC_FLAGS': '0x0', 19:00:28 INFO - 'XPC_SERVICE_NAME': '0', 19:00:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:00:28 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-OxQNtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:00:28 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-xlYNZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:00:28 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-qcUgII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:00:28 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-wYxg2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:00:28 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-wiL_Ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:00:29 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-Dd054G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:00:29 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-mUTycl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:00:29 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-y0O50V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:00:29 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-680WZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:00:29 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-AaJddu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:00:29 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-dIEHKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:00:29 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-vXCtAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:00:29 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-8co7u2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:00:29 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-VUWl9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:29 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-DMF7sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:00:30 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-a5MJRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:00:30 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-yYBUiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:00:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:32 INFO - Downloading blessings-1.6.tar.gz 19:00:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:00:32 INFO - Installing collected packages: blessings 19:00:32 INFO - Running setup.py install for blessings 19:00:33 INFO - Successfully installed blessings 19:00:33 INFO - Cleaning up... 19:00:33 INFO - Return code: 0 19:00:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:00:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:00:33 INFO - Reading from file tmpfile_stdout 19:00:33 INFO - Current package versions: 19:00:33 INFO - blessings == 1.6 19:00:33 INFO - blobuploader == 1.2.4 19:00:33 INFO - docopt == 0.6.1 19:00:33 INFO - functools32 == 3.2.3-2 19:00:33 INFO - jsonschema == 2.5.1 19:00:33 INFO - manifestparser == 1.1 19:00:33 INFO - mozInstall == 1.12 19:00:33 INFO - mozcrash == 0.17 19:00:33 INFO - mozdebug == 0.1 19:00:33 INFO - mozdevice == 0.48 19:00:33 INFO - mozfile == 1.2 19:00:33 INFO - mozhttpd == 0.7 19:00:33 INFO - mozinfo == 0.9 19:00:33 INFO - mozleak == 0.1 19:00:33 INFO - mozlog == 3.4 19:00:33 INFO - moznetwork == 0.27 19:00:33 INFO - mozprocess == 0.23 19:00:33 INFO - mozprofile == 0.28 19:00:33 INFO - mozrunner == 6.12 19:00:33 INFO - mozscreenshot == 0.1 19:00:33 INFO - mozsystemmonitor == 0.3 19:00:33 INFO - moztest == 0.7 19:00:33 INFO - mozversion == 1.4 19:00:33 INFO - psutil == 3.1.1 19:00:33 INFO - requests == 1.2.3 19:00:33 INFO - wsgiref == 0.1.2 19:00:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107275570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9adac9a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107113d30>, '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 0x106f39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10710bb20>, '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.fBIYrpO0l6/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.HQiIloG0EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:00:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:00:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fBIYrpO0l6/Render', 19:00:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:33 INFO - 'HOME': '/Users/cltbld', 19:00:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:33 INFO - 'LOGNAME': 'cltbld', 19:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:33 INFO - 'MOZ_NO_REMOTE': '1', 19:00:33 INFO - 'NO_EM_RESTART': '1', 19:00:33 INFO - 'PAGER': '/bin/cat', 19:00:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:33 INFO - 'PWD': '/builds/slave/test', 19:00:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:33 INFO - 'SHELL': '/bin/bash', 19:00:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HQiIloG0EV/Listeners', 19:00:33 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 19:00:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:33 INFO - 'USER': 'cltbld', 19:00:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:33 INFO - 'XPC_FLAGS': '0x0', 19:00:33 INFO - 'XPC_SERVICE_NAME': '0', 19:00:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:00:33 INFO - Cleaning up... 19:00:33 INFO - Return code: 0 19:00:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072ff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107275570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9adac9a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107113d30>, '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 0x106f39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10710bb20>, '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.fBIYrpO0l6/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.HQiIloG0EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:00:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:00:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fBIYrpO0l6/Render', 19:00:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:33 INFO - 'HOME': '/Users/cltbld', 19:00:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:33 INFO - 'LOGNAME': 'cltbld', 19:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:33 INFO - 'MOZ_NO_REMOTE': '1', 19:00:33 INFO - 'NO_EM_RESTART': '1', 19:00:33 INFO - 'PAGER': '/bin/cat', 19:00:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:33 INFO - 'PWD': '/builds/slave/test', 19:00:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:33 INFO - 'SHELL': '/bin/bash', 19:00:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HQiIloG0EV/Listeners', 19:00:33 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 19:00:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:33 INFO - 'USER': 'cltbld', 19:00:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:33 INFO - 'XPC_FLAGS': '0x0', 19:00:33 INFO - 'XPC_SERVICE_NAME': '0', 19:00:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:00:33 INFO - Cleaning up... 19:00:33 INFO - Return code: 0 19:00:33 INFO - Running post-action listener: _resource_record_post_action 19:00:33 INFO - Running post-action listener: _start_resource_monitoring 19:00:33 INFO - Starting resource monitoring. 19:00:33 INFO - [mozharness: 2016-09-28 02:00:33.980763Z] Finished create-virtualenv step (success) 19:00:33 INFO - [mozharness: 2016-09-28 02:00:33.981741Z] Running install step. 19:00:33 INFO - Running pre-action listener: _resource_record_pre_action 19:00:33 INFO - Running main action method: install 19:00:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:00:34 INFO - Reading from file tmpfile_stdout 19:00:34 INFO - Detecting whether we're running mozinstall >=1.0... 19:00:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:00:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:00:34 INFO - Reading from file tmpfile_stdout 19:00:34 INFO - Output received: 19:00:34 INFO - Usage: mozinstall [options] installer 19:00:34 INFO - Options: 19:00:34 INFO - -h, --help show this help message and exit 19:00:34 INFO - -d DEST, --destination=DEST 19:00:34 INFO - Directory to install application into. [default: 19:00:34 INFO - "/builds/slave/test"] 19:00:34 INFO - --app=APP Application being installed. [default: firefox] 19:00:34 INFO - mkdir: /builds/slave/test/build/application 19:00:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:00:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:01:08 INFO - Reading from file tmpfile_stdout 19:01:08 INFO - Output received: 19:01:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:01:08 INFO - Running post-action listener: _resource_record_post_action 19:01:08 INFO - [mozharness: 2016-09-28 02:01:08.650458Z] Finished install step (success) 19:01:08 INFO - [mozharness: 2016-09-28 02:01:08.650587Z] Running run-tests step. 19:01:08 INFO - Running pre-action listener: _resource_record_pre_action 19:01:08 INFO - Running main action method: run_tests 19:01:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:01:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:01:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:01:08 INFO - 2016-09-27 19:01:08.663 screenresolution[1648:8831] starting screenresolution argv=screenresolution get 19:01:08 INFO - 2016-09-27 19:01:08.666 screenresolution[1648:8831] Display 0: 1600x1200x32@60 19:01:08 INFO - 2016-09-27 19:01:08.671 screenresolution[1649:8833] starting screenresolution argv=screenresolution list 19:01:08 INFO - Available Modes on Display 0 19:01:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:01:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:01:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:01:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:01:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:01:08 INFO - Intel Iris: 19:01:08 INFO - Chipset Model: Intel Iris 19:01:08 INFO - Type: GPU 19:01:08 INFO - Bus: Built-In 19:01:08 INFO - VRAM (Dynamic, Max): 1536 MB 19:01:08 INFO - Vendor: Intel (0x8086) 19:01:08 INFO - Device ID: 0x0a2e 19:01:08 INFO - Revision ID: 0x0009 19:01:08 INFO - Displays: 19:01:08 INFO - Display: 19:01:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:01:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:01:08 INFO - Display Serial Number: 1600x1200 60 19:01:08 INFO - Main Display: Yes 19:01:08 INFO - Mirror: Off 19:01:08 INFO - Online: Yes 19:01:08 INFO - Rotation: Supported 19:01:08 INFO - Return code: 0 19:01:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:01:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:01:08 INFO - Python 2.7.3 19:01:08 INFO - Return code: 0 19:01:08 INFO - grabbing minidump binary from tooltool 19:01:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:08 INFO - 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 0x107113d30>, '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 0x106f39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10710bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:01:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:01:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 19:01:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:01:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:01:09 INFO - Return code: 0 19:01:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:01:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:01:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:01:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:01:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:01:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JkQAqoMfTuiDhnNvfL69PA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0234', '--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 19:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JkQAqoMfTuiDhnNvfL69PA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0234 --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 19:01:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fBIYrpO0l6/Render', 19:01:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:01:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:01:09 INFO - 'HOME': '/Users/cltbld', 19:01:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:01:09 INFO - 'LOGNAME': 'cltbld', 19:01:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:01:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:09 INFO - 'MOZ_NO_REMOTE': '1', 19:01:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:01:09 INFO - 'NO_EM_RESTART': '1', 19:01:09 INFO - 'PAGER': '/bin/cat', 19:01:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:09 INFO - 'PWD': '/builds/slave/test', 19:01:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:01:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:01:09 INFO - 'SHELL': '/bin/bash', 19:01:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HQiIloG0EV/Listeners', 19:01:09 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 19:01:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:01:09 INFO - 'USER': 'cltbld', 19:01:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:01:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:09 INFO - 'XPC_FLAGS': '0x0', 19:01:09 INFO - 'XPC_SERVICE_NAME': '0', 19:01:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:01:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JkQAqoMfTuiDhnNvfL69PA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0234', '--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 19:01:09 INFO - mozversion application_buildid: 20160927170020 19:01:09 INFO - mozversion application_changeset: 4ab108caec1eb612793f17f657fc08dc9a694719 19:01:09 INFO - mozversion application_display_name: Nightly 19:01:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:01:09 INFO - mozversion application_name: Firefox 19:01:09 INFO - mozversion application_remotingname: firefox 19:01:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 19:01:09 INFO - mozversion application_vendor: Mozilla 19:01:09 INFO - mozversion application_version: 52.0a1 19:01:09 INFO - mozversion platform_buildid: 20160927170020 19:01:09 INFO - mozversion platform_changeset: 4ab108caec1eb612793f17f657fc08dc9a694719 19:01:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 19:01:09 INFO - mozversion platform_version: 52.0a1 19:01:09 INFO - using testdate: 1475028069 19:01:09 INFO - actual date: 1475028069 19:01:09 INFO - starting webserver on 'localhost:49279' 19:01:09 INFO - SUITE-START | Running 2 tests 19:01:09 INFO - TEST-START | dromaeo_css 19:01:09 INFO - operating with platform_type : mac_ 19:01:09 INFO - Initialising browser for dromaeo_css test... 19:01:09 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmp0VbLjo/profile http://localhost:49279/getInfo.html) 19:01:11 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 19:01:11 INFO - PROCESS | 1659 | colorDepth:24 19:01:11 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 19:01:11 INFO - PROCESS | 1659 | __metrics 19:01:11 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:01:11 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:01:12 INFO - TEST-INFO | 1659: exit 0 19:01:12 INFO - Browser initialized. 19:01:12 INFO - Running cycle 1/1 for dromaeo_css test... 19:01:12 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmp0VbLjo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:01:24 INFO - PROCESS | 1662 | RSS: Main: 235528192 19:01:24 INFO - PROCESS | 1662 | 19:02:15 INFO - PROCESS | 1662 | 1475028135537 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:04:27 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 19:04:29 INFO - PROCESS | 1662 | RSS: Main: 417939456 19:04:29 INFO - PROCESS | 1662 | 19:07:32 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 19:07:32 INFO - PROCESS | 1662 | RSS: Main: 372527104 19:07:32 INFO - PROCESS | 1662 | 19:10:35 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 19:10:36 INFO - PROCESS | 1662 | RSS: Main: 329637888 19:10:36 INFO - PROCESS | 1662 | 19:13:38 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 19:13:39 INFO - PROCESS | 1662 | RSS: Main: 340357120 19:13:39 INFO - PROCESS | 1662 | 19:16:42 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 19:16:42 INFO - PROCESS | 1662 | RSS: Main: 330199040 19:16:42 INFO - PROCESS | 1662 | 19:19:46 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 19:19:46 INFO - PROCESS | 1662 | RSS: Main: 472264704 19:19:46 INFO - PROCESS | 1662 | 19:19:46 INFO - PROCESS | 1662 | __start_tp_report 19:19:46 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 19:19:46 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 19:19:46 INFO - PROCESS | 1662 | |i|pagename|runs| 19:19:46 INFO - PROCESS | 1662 | |0;dojo.html;3276.6231883333417;3287.0631869917065;3296.505524171374;3333.100062982996;3355.697987181153;5504.504594586487;5605.271314729084;5621.550275977922;5640.0693885508945;5651.2653355063885;5589.776408943638;5635.971820140904;5698.059820129673;5780.959427303083;5838.620489668179;5077.543021128116;5107.412647545524;5164.974175129119;5206.817761378353;5216.00895829793;5152.639315247934;5256.474352564751;5261.079311120558;5261.763220655061;5331.760070796823;5209.192575150858;5223.477652234784;5241.161414173733;5264.263003179539;5292.5765938725;5091;5106.106431374495;5130.127878260705;5146.6911985281;5154.278401023859;5099.464556221617;5122.257272695476;5142.100132476801;5183.688978661293;5190.766415511311;5583.4974852263085;5656.8020119295625;5663.178839068312;5666.065099258617;5668.093105103205;5983.52131829457;6130.356312587203;6139;6165.198524191826;6257.124002639634;5939.554533410012;5947;5968.940310596882;6027.9095813562835;6126.111713801474;5506.256655351476;5511.448855114497;5512.283403157604;5522.66863988162;5532;6123.142760013601;6131.908021379593;6138.754449821957;6142.539309551801;6142.723577439026;5983.491403230687;6049.727762250621;6051.939480605226;6063.939360606426;6130.233720784902;6115.510759139258;6152.230971128609;6180.598261113103;6184.752609895644;6184.969075154595;6117.908231376533;6140.723667434976;6163.3528479509005;6166.753329866845;6183.288921773964;6064.605800623033;6136.048912418582;6142.416470435302;6162.26052873658;6193.628382297076;4900.142475066849;4901.142300097468;4909.410870695539;4914.262860570871;4927.507249275115;4322.8703138905885;4397.604215620546;4442.53353397895;4442.844500442469;4446.2663660495655;5619.241402410622;5675.233843431084;5706.80026199081;5722.2561067061015;5788.131780232999;6156.168917196122;6165.506759459233;6166.537509686791;6172.321044685081;6182.196314479089;5086.898262034739;5745.310562732415;5760.3951585083805;5766.481016708516;5768.596198266081;5229.294045303835;5280.339957505312;5298.6290959633225;5344.251804747339;5356.91964620531;6174.783882564088;6183.2270966128335;6189.473894718999;6194.473469754941;6204.441600255998;6112.1995365628145;6121.418465245794;6135.263289243823;6155.384461553809;6160.476359509492;6318.147050148171;6332.398422149889;6333.524985626189;6348.333424990309;6348.492120630246;6132.78535251264;6140;6150.2927163375;6152.384761523812;6157.138000679998;6057.878842423215;6122.510199183966;6135.754569817157;6139.109829074849;6142.78500252489;5778.797742079175;5978.671173085348;6077.20996270482;6106.2061931948565;6107.175531303395;5902.586818922634;6077.604955677867;6081.604695694766;6086.056661217518;6106.419890110433;5755.769769209185;5784.2769653793275;5952.285725712942;5970.641761494324;5972.134040564007;4936.333594964777;5921.7631294747725;5989.101634754822;5998.850028749316;6038.215032045806;6002.819915402545;6018;6022.518198544193;6043.909341359795;6053.213082299273 19:19:46 INFO - PROCESS | 1662 | |1;ext.html;444.65317052698884;460.95363524798705;543.141835899279;548.2461615278991;552.5579536370907;29761.553576696366;40235.59764402355;41437;41510.58489415105;43712.3443148353;41928.37107443383;42249.36625950613;42355.36466952998;42387.576124238745;42392.576074239245;9771.609135634566;9948.502574871263;9953.900460995406;9954.502274886263;9961;9724.562394692255;9819.705408837746;9822.459764712938;9841.015898410138;9841.90158098417;9725.0761177688;9780.657676981307;9785.657501987433;9787.119159275664;9788;9769.511524423786;9837;9844.310898237127;9853.852192217122;9861.408315501092;9826.213902887823;9896.356736812084;9902.752431189207;9912.504374781232;9932.553035113366;40464;40736;40812.795936020426;40844.79577602123;40909.97725056868;3290.7367410607094;3361.764676472648;3463.965360346415;3523.8766643167623;3644.2893635741043;30599.38801223963;30634.23414414635;31824.84087579547;31909.202269943205;32224;3045.162580290416;3076.8307743074124;3114.9688503114903;3180.681931806801;3184.792988455743;398425;403406;403703;406541;409161.95419022714;50637.74681126571;51578.48421515737;56764.71617641886;58828;59119.70440147772;59456.405435945955;62074.37925620686;62896.68551657212;62900.68549657314;62904.685476572326;14980.925095374454;15057.322420491104;15065.17141557225;15090.773638395432;15119.848801512064;12184.81722774159;12293.69265768345;12294.938525307316;12296.692582685504;12320.383980800923;14277.214753188675;17552.56118597045;17577.736333955;17598.560035999202;17664.470065898044;7069.646517674096;7106.786796396116;7150.5352152109945;7213.495055346076;7217;882.7131182365629;887.600579739107;925.5372313843078;980.1472718734747;1046.2519298701466;28796.568051479244;29624.555631665542;29747.553786693217;30494;30643.540346894813;837.380338549469;966.5795379010153;999.9800004000025;1035.4563853976722;1149.5344385523877;14621.78067328991;15230.725394040335;15261.542153735405;15408.506084662713;15523.922380388025;514528;514685;518001;519143;519615;56812.57968550819;57106.428935710945;57245;57272.71363643238;57350.426495735344;1241.360699239874;1293;1370.979435308491;1399.111564156788;1408.5351833894995;30541.389172215986;30824.537631935986;31040.68959310378;31525.92651582247;31924.68075319217;49715.75142124266;50442;50535.74732126316;50640.49359506358;50697;422073;422167;424532;425013;427145;26048.73951260539;26279.60580591331;26775.062872799357;26945.461090778466;27185.72814271832;46059.76970115128;46573.767131164124;46639;46887;46928.765356174365;38353.6576219831;38387.232255355295;38986.68613167799;39300.606993929694;40788.1842363157;38539.6146038536;38544.42183367308;38788.030299242746;40007.79996100001;40481.59518404896;37576.87269381923;37772.43341349937;38374.80812595919;38384;39886.2022759549;30130.945416910305;34002.65997339995;34201.486977694854;34214.486782698776;34324.656753432144;24694.25917222486;25189.370265743502;25338.617612603095;25445.491090178464;25641.358966026 19:19:46 INFO - PROCESS | 1662 | |2;jquery.html;352.02313579816024;371.867986864663;375.98872033838995;385.1392138570296;405.7991294309317;14765.630859228524;15140.242987850605;15947.441839535619;19968.400947971582;20590.794092059074;16121;20034.899825500852;20188.091535880885;20230.797692023076;20434.69347959782;5766.826995190151;6032.034874420094;6065.332813390523;6069.666168360738;6070.484008859252;4169.583041695836;4394.6703997200175;4562.406887104672;5974.22335096439;6045;4395.450568678915;6202.7518899244205;6323.766865461237;6360.427561519462;6683.398494135527;6449.129367535393;6575.868482630321;6636.469082473439;6656.301088385747;6726.125603671516;4894.486078961693;5712.6286791358425;5746.655200687972;5752.9712351437975;5753.280839895013;24617;25198.748012520005;25396.984120635152;25546.87226563874;25574.87212563944;2235.508188198594;2271.8864056797092;2297.150054479853;2554.616807478893;2854.957940351757;15382.769258461132;15414;16010.519684409486;16101.91949040259;16220;1707.1720215695502;1763.6560870630233;1832.6426346862368;1880.5956719305277;1894.232835701543;104873;105472.47263763708;105612.47193763981;106321;106937;9415.105564971316;9515.096065873731;9521.952390238004;9653.806923861483;10714.946425267979;13355.666108347368;13355.666108347368;13386.19682819034;13395.330233488286;13417.865821341857;8334.083250842403;8441.57792110392;8481.703140390056;8583.484990900566;8625.482471051757;8527.10465401124;8550.444221125606;8552.700655477029;8743.387962842668;8744.169303916118;5415.8104466344275;6417.1657684500715;6530.640814755234;6534.346565343522;6564.442022428051;1646.1769115442278;1782.4741701198177;1791.892486450791;1825.9087045647664;1827.6070644811164;660.7017211180055;987.7975015122026;992.5483904823288;994.8806143262855;1024.1755386913605;19534.12096455663;21842.344729658136;21887.452813679785;21945.67081493779;22004.33986980393;404.8036702199431;425.95740425957155;941.2940294778916;963.9518024098767;969.3117886300664;5595.104783234663;5941.435563621536;6077.817665469955;6110.938890611126;6119.847003824851;481871;486199.5690021598;494428;495875;497519;121006;129837;130222.34888825496;130649;130887;425.8275398463689;452.6243218128945;455.95440455954804;460.5601650423904;460.69594067915017;10311.535980880728;11469.311841289216;11518.424078795859;11551.0181634562;17621;50279;51277;51490.74254628703;51946;51954.960900781014;60848;65699;66062;71865.28134718795;72838.63580682063;8042.798930026796;8136.796580085545;8358.749237522885;8509.787255318666;8713.215810577078;9365.531723413938;12853.678658033625;12985.610431687064;13442.865571344553;13582.388792504558;7456.7762967111075;10015.899841001497;11221.214514983873;11710.4730287139;11778.823317650413;6182.845428864314;11283.887161128283;11388;11841.526338946345;11847.526098955945;11337.829932551183;11591.88408115908;11833.70415739579;11957.76084478323;12010.75978480443;8261.463004904663;8382.16178382157;8489.617967191614;8511.914880851113;8682.305415566612;9454.480003599869;10732.570697172026;10874.782504350027;11269.66191014271;11787.882121178678 19:19:46 INFO - PROCESS | 1662 | |3;mootools.html;1540.5455390659752;1547.4583895636526;1789.7404876292937;1889.6031833315003;1938.5347516596012;8498.277646400056;8997.59510822013;9008.819823603524;9024.864627030584;9064.229540489057;7799.5710235937;8113.310368618674;8130.593470326489;8519.488830670149;8743.95628021859;2365.82256330775;2401.903923843044;2408;2408.614621660535;2411.0837881604966;2362.3267368799898;2377.3699969508007;2395.73646898841;2396.604560247557;2397.880105994693;2027.675571908495;2372.8457650252676;2384.856908585482;2399.7720216579482;2400.6519054737055;2349.189529612298;2358.79950204232;2370;2372.466195106105;2383.4398916254668;2343.238447504551;2359.4927090675587;2368;2368.265837590335;2373.2049763329305;8752.256058235058;8942;8947.284217262604;8948.328875334377;8958.55207239642;4590.60979816716;5208.218767184915;5374.140137578008;5375.462453754593;5381.865453363658;3553.378158822196;3562.1985053363046;3611.9097022574383;3633.7274704397278;3634.6547078027547;1038.553422028535;1042.1142029275131;1045.393671670437;1047.2250534604414;1056.5456853552969;11610.013148882355;11736.706582335424;11738.530458781725;11741.88258117425;11749.882501174965;4542.68201225911;4656.231721765938;4765.0946320199055;4770.689905156154;4808.783604737725;10034.397936123856;10046.346987445793;10055.547500362502;10056.044675755791;10089.192864570818;5373;5381.919271210935;5385.865353366197;5390.622656414013;5401.378841433286;3797.3164830330807;4401.735895846259;4561.657875659339;4863.076015557032;4928.753562321869;3792.488014118114;3840.6735427488416;3914.080191155076;3937.3700207967163;3966.801659916993;1236.3879879459726;1241.975160496785;1249.7375551134182;1255.315852860175;1262.8863402293655;863.8747381629754;873.0701802580231;903.2683526343683;906.2930913887178;917.4770380882833;5487.341519017744;5682.573806964494;5974.402559744078;5989.961959011288;6005.129256257906;432.234944148861;439.83726021372297;450.85572616762977;452.558755213664;456.22441848856414;3777.471154038437;3825.1967086911504;3865.246276976019;3935.409688546741;3994.4407782910416;10279.177665786869;10796.892031079746;10801.027907488207;10821.350718956888;10837.620683276047;10762.300450470695;10765;10768.300060496043;10771.730706732395;10811.027007569357;6752.9403531923235;7609.086909570776;8123.715669951642;8186.877196842052;8191.508509489449;5651.6043876928225;5763.94236057634;5770.307563092456;5983.521318294613;6053.303870054824;9977.351472154287;10116;10140.340877842917;10149.594016239267;10184.134348580454;9629.855552166864;10050.447225402673;10053.994600539887;10156.492175391053;10186.796264074528;6936.132983377078;7111.644417779194;7146;7453.552786832807;7622.961885190539;8054.3556515479795;8209.548474833942;8343.499390036617;8428.241458268785;8431.36764742659;7372.778816635509;7497.212792656693;7549.9622501889335;7559.017327747358;7633.122190948112;7349.338559529668;7405.296496832792;7458.328750412489;7531.397488201041;7612.276833700789;6877.105976223059;7020.333068358498;7025.367716905503;7026.437884969088;7026.8945965809535;4910.410750709938;4991.700497970133;5071.315372424676;5089;5106.923396149135;4376.321670141133;4977.925331120108;5056.443791182894;5184.714840683799;5256.816011439581 19:19:46 INFO - PROCESS | 1662 | |4;prototype.html;297.3265553521276;300.9097270818755;310.605530975661;313.83680486147205;314.6978900255754;4937.679050861696;5343.839684809457;5367.516923476886;5447.972760136204;5463.153211252262;4595.494495605481;5091.338126043618;5181.35233095863;5287.814926477565;5305.549028332596;3961;4103.789382132278;4124.298869192229;4131.58684131586;4139.8965025874295;3267.836608169594;3983.9203215935663;4086.4483294755123;4151.460310159675;4175.185838761443;3363.882264120756;3767.792771397572;3966.761994280338;4045.656119229869;4081.7142800004012;3288.917777055569;3542.256126213498;3769.4157405602177;4048.9190216195807;4060.573639767826;2818.7322204390757;3422.5037369581273;3444.328355970587;3444.844981975817;3445.5176275321473;4209.810558524874;4215.398148703473;4871.878203044952;5158.638895277332;5160.200168973815;4053.6622914438167;4513.323001549761;4574.359589657451;4576.26779715244;4580.824108548446;4842.7723247306285;4866.221404575251;5567.582431317627;5577.52591029763;5614.719264036782;3756.1548651553453;3791.829367678461;3802.4676545283683;3844.596722196406;3852.114013776847;5009.348784658007;5673.744681489343;5925.674087925119;5932.614380065325;5979.372165922559;3442.0226504073794;3767.604401537854;3889.755278310913;3891.0466935600957;3910;3451.620321764604;3689.4650275709873;3935.4490371348033;3992.9800350998057;4011.919761604752;4382.627476664456;4618.722876627413;4635.188841952645;4658.95341046592;4675.906481870344;5258.553022993088;5656.43435656431;5679.075276232744;5685.204071430003;5749.913751293734;1272.7518133963788;1303.4134639412302;1335.1988806715892;1352.6888815572277;1354.5665387076042;838.5388036579857;872.1975782280317;892.054422312351;895.167494230372;900.3247564326755;4767.951050768826;5263.26314315996;5267.813857249199;5280.102382594968;5288.418273989858;5499.835004949778;5599.412061733541;5713.74288157034;5735.655860648374;5777.971110144423;4757.381540399726;5162.3030890830005;5172.801559337267;5194.896102077937;5211.869703257449;2622.659054322964;2915.825050496977;2987.4323878463024;2987.970120298769;3012.638483382008;4938.950610493849;5576.609637325349;5901.439363260483;5914.292707537247;5946.780909913457;4712.64367816092;5653.088659340443;5850.268716410364;5859.472647461749;5869.530437564985;4443.200223959654;4562.5665561771575;5786.132080187837;5877.794277200277;5880.500472379601;4756.667033307635;4856.757162141949;5353.8142562375215;5654.3497497788285;5727.8568035799435;5174.7153906535505;5398.1902714593125;5589.832305030855;5657.575681823962;5666.923284575917;5726.2535174917775;5809;5893.941060589339;5895.58281104745;5934.732937017931;3368.2253081791814;3601.081724160322;3810.618938106167;3824.9235015300096;3828.4640150378414;5253.684778913277;5592.161175823659;5605.943940560543;5611.971940140274;5625;4582.587567118975;5355.697050268422;5568.331800184003;5586.631275337406;5594.524465420485;5474.753636086465;5528.7235638218735;5534.225208470898;5552.222688823649;5557.833265002057;4782.952170478251;5387.003404370204;5392.438591669083;5399.649022813504;5473.397926228191;4542.886427839198;5310.8141215057285;5526.751296191762;5623.963059947582;5688.288963879515;5526.696031718294;5532.28080349552;5542.69515176653;5568.303962004749;5568.331800184003 19:19:46 INFO - PROCESS | 1662 | |5;yui.html;675.8040168351181;709.7480394459967;743.9739609113682;745.455817253405;817.3175398542219;15642.374305027799;15967.920160399182;15994.960327578729;16004;16009.19954002301;14201.502947396843;14313.355898984544;14327.922451244563;14330.570082897504;14681.559553213394;600.5705920267009;663.1246754284334;694.4132208283992;844.5903736687701;864.4726716702806;837.8575642140851;851.7189327521903;853.8463076646201;854;859.2181115185183;933.4119504712022;934.654177954158;935.4387367579432;935.822193783179;938.5354249646434;712.8538649576876;729.3763831923682;917.4632839788732;928.3919033033408;928.6285485805664;687.2028447001454;692.9133858267717;698.2075344484048;698.4447364345358;703.103542982696;15201.847981520154;15338;15342.386304547916;15348.309326080242;15348.616284592974;14493.420263189566;14609.269536523238;14645.267736613127;14667.193304368255;14678.119312841263;11668.416579171093;11935.164538482222;12061.155719099666;12101.818472722916;12104.939475302566;3385.5091011803397;3732.9226489144853;3735.196932659464;3784.6783023442763;3787.696984241254;104698.47650761697;105019;105484;107102.46448767785;109904;9379.390339628038;11134;11241.269317494336;11265.71835704114;11271.830922536168;21244.89377553133;23014.53970920572;23233.535329293318;23269.767302327098;23274.65088023681;8333.499990000499;8360.205780450848;8391.916080839235;8398.916010839936;8673.04596494385;4523.140603285366;4553.590176884097;4583.472900616405;4625.098105869391;4748.169070412664;3618.5476815398074;3759.755615884959;3767.8492860285282;3773.2453509298252;3776.6978641708597;675.0987431778533;684.226823689228;687.5702685821361;700.3801635552572;701.2216439751871;583.6818933681154;661.2032500836576;672.4284358295507;682.617734068913;690.8411065454974;7071.0031246740655;9250.398724082914;9297.256219502424;9361;9576.808463830825;576.5214871656599;591.1398914579363;609.3845216331537;670.778643047793;682.2256738601723;4107.363358679409;4509.616682582017;4515.074409745994;4595.058013107305;4641.535846415331;89368.10631893598;112208;113252.43373783078;125921;135732;104751;108299.45850270856;108760.45619771851;109810;110877;62449.68775156095;83227.58386208152;85236.57381713051;86784;98083;9379.437233765995;9514.286428518028;9562.235021198427;9630.855537167088;9663.661771837951;54036;55615.44384556103;55836;56647.716761415926;57634.7118264406;84349;84988;86373.56813215894;88304.23391532004;88934;12385.504579816707;12444.315562644142;12610.369481525704;12930.288834113837;13126.343682816012;13904;14361.569152925429;14506.419743210154;15392.461263855712;15590.9220453897;12941.029422793517;13798.517051903134;13838.515651952133;14039.227842468763;14184.936129790101;12688.492460301853;13302.733945321233;13645.181289122684;13867.445302188204;14129.152250864981;13185.472581096648;13540;13642.795358069437;14173.362198700877;14216.928915355356;10187.286889917634;10247.795044099226;10808.135349172204;11043.723906902393;11571.884281157081;9321.20769734553;10568.365898045835;10659.087402127487;10720.19598530129;10981.066609338295 19:19:46 INFO - PROCESS | 1662 | __end_tp_report 19:19:46 INFO - PROCESS | 1662 | __start_cc_report 19:19:46 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1633 19:19:46 INFO - PROCESS | 1662 | __end_cc_report 19:19:46 INFO - PROCESS | 1662 | __startTimestamp1475029186664__endTimestamp 19:19:46 INFO - PROCESS | 1662 | 19:19:46 INFO - PROCESS | 1662 | ------- Summary: start ------- 19:19:46 INFO - PROCESS | 1662 | Number of tests: 6 19:19:46 INFO - PROCESS | 1662 | 19:19:46 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5675.78 Median:5947.00 stddev:626.35 (10.5%) stddev-sans-first:599.33 19:19:46 INFO - PROCESS | 1662 | Values: 3276.6 3287.1 3296.5 3333.1 3355.7 5504.5 5605.3 5621.6 5640.1 5651.3 5589.8 5636.0 5698.1 5781.0 5838.6 5077.5 5107.4 5165.0 5206.8 5216.0 5152.6 5256.5 5261.1 5261.8 5331.8 5209.2 5223.5 5241.2 5264.3 5292.6 5091.0 5106.1 5130.1 5146.7 5154.3 5099.5 5122.3 5142.1 5183.7 5190.8 5583.5 5656.8 5663.2 5666.1 5668.1 5983.5 6130.4 6139.0 6165.2 6257.1 5939.6 5947.0 5968.9 6027.9 6126.1 5506.3 5511.4 5512.3 5522.7 5532.0 6123.1 6131.9 6138.8 6142.5 6142.7 5983.5 6049.7 6051.9 6063.9 6130.2 6115.5 6152.2 6180.6 6184.8 6185.0 6117.9 6140.7 6163.4 6166.8 6183.3 6064.6 6136.0 6142.4 6162.3 6193.6 4900.1 4901.1 4909.4 4914.3 4927.5 4322.9 4397.6 4442.5 4442.8 4446.3 5619.2 5675.2 5706.8 5722.3 5788.1 6156.2 6165.5 6166.5 6172.3 6182.2 5086.9 5745.3 5760.4 5766.5 5768.6 5229.3 5280.3 5298.6 5344.3 5356.9 6174.8 6183.2 6189.5 6194.5 6204.4 6112.2 6121.4 6135.3 6155.4 6160.5 6318.1 6332.4 6333.5 6348.3 6348.5 6132.8 6140.0 6150.3 6152.4 6157.1 6057.9 6122.5 6135.8 6139.1 6142.8 5778.8 5978.7 6077.2 6106.2 6107.2 5902.6 6077.6 6081.6 6086.1 6106.4 5755.8 5784.3 5952.3 5970.6 5972.1 4936.3 5921.8 5989.1 5998.9 6038.2 6002.8 6018.0 6022.5 6043.9 6053.2 19:19:46 INFO - PROCESS | 1662 | 19:19:46 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:60011.51 Median:40800.49 stddev:119644.77 (293.2%) stddev-sans-first:119896.82 19:19:46 INFO - PROCESS | 1662 | Values: 444.7 461.0 543.1 548.2 552.6 29761.6 40235.6 41437.0 41510.6 43712.3 41928.4 42249.4 42355.4 42387.6 42392.6 9771.6 9948.5 9953.9 9954.5 9961.0 9724.6 9819.7 9822.5 9841.0 9841.9 9725.1 9780.7 9785.7 9787.1 9788.0 9769.5 9837.0 9844.3 9853.9 9861.4 9826.2 9896.4 9902.8 9912.5 9932.6 40464.0 40736.0 40812.8 40844.8 40910.0 3290.7 3361.8 3464.0 3523.9 3644.3 30599.4 30634.2 31824.8 31909.2 32224.0 3045.2 3076.8 3115.0 3180.7 3184.8 398425.0 403406.0 403703.0 406541.0 409162.0 50637.7 51578.5 56764.7 58828.0 59119.7 59456.4 62074.4 62896.7 62900.7 62904.7 14980.9 15057.3 15065.2 15090.8 15119.8 12184.8 12293.7 12294.9 12296.7 12320.4 14277.2 17552.6 17577.7 17598.6 17664.5 7069.6 7106.8 7150.5 7213.5 7217.0 882.7 887.6 925.5 980.1 1046.3 28796.6 29624.6 29747.6 30494.0 30643.5 837.4 966.6 1000.0 1035.5 1149.5 14621.8 15230.7 15261.5 15408.5 15523.9 514528.0 514685.0 518001.0 519143.0 519615.0 56812.6 57106.4 57245.0 57272.7 57350.4 1241.4 1293.0 1371.0 1399.1 1408.5 30541.4 30824.5 31040.7 31525.9 31924.7 49715.8 50442.0 50535.7 50640.5 50697.0 422073.0 422167.0 424532.0 425013.0 427145.0 26048.7 26279.6 26775.1 26945.5 27185.7 46059.8 46573.8 46639.0 46887.0 46928.8 38353.7 38387.2 38986.7 39300.6 40788.2 38539.6 38544.4 38788.0 40007.8 40481.6 37576.9 37772.4 38374.8 38384.0 39886.2 30130.9 34002.7 34201.5 34214.5 34324.7 24694.3 25189.4 25338.6 25445.5 25641.4 19:19:46 INFO - PROCESS | 1662 | 19:19:46 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:31087.56 Median:425.89 stddev:82744.61 (19428.5%) stddev-sans-first:82944.55 19:19:46 INFO - PROCESS | 1662 | Values: 352.0 371.9 376.0 385.1 405.8 14765.6 15140.2 15947.4 19968.4 20590.8 16121.0 20034.9 20188.1 20230.8 20434.7 5766.8 6032.0 6065.3 6069.7 6070.5 4169.6 4394.7 4562.4 5974.2 6045.0 4395.5 6202.8 6323.8 6360.4 6683.4 6449.1 6575.9 6636.5 6656.3 6726.1 4894.5 5712.6 5746.7 5753.0 5753.3 24617.0 25198.7 25397.0 25546.9 25574.9 2235.5 2271.9 2297.2 2554.6 2855.0 15382.8 15414.0 16010.5 16101.9 16220.0 1707.2 1763.7 1832.6 1880.6 1894.2 104873.0 105472.5 105612.5 106321.0 106937.0 9415.1 9515.1 9522.0 9653.8 10714.9 13355.7 13355.7 13386.2 13395.3 13417.9 8334.1 8441.6 8481.7 8583.5 8625.5 8527.1 8550.4 8552.7 8743.4 8744.2 5415.8 6417.2 6530.6 6534.3 6564.4 1646.2 1782.5 1791.9 1825.9 1827.6 660.7 987.8 992.5 994.9 1024.2 19534.1 21842.3 21887.5 21945.7 22004.3 404.8 426.0 941.3 964.0 969.3 5595.1 5941.4 6077.8 6110.9 6119.8 481871.0 486199.6 494428.0 495875.0 497519.0 121006.0 129837.0 130222.3 130649.0 130887.0 425.8 452.6 456.0 460.6 460.7 10311.5 11469.3 11518.4 11551.0 17621.0 50279.0 51277.0 51490.7 51946.0 51955.0 60848.0 65699.0 66062.0 71865.3 72838.6 8042.8 8136.8 8358.7 8509.8 8713.2 9365.5 12853.7 12985.6 13442.9 13582.4 7456.8 10015.9 11221.2 11710.5 11778.8 6182.8 11283.9 11388.0 11841.5 11847.5 11337.8 11591.9 11833.7 11957.8 12010.8 8261.5 8382.2 8489.6 8511.9 8682.3 9454.5 10732.6 10874.8 11269.7 11787.9 19:19:46 INFO - PROCESS | 1662 | 19:19:46 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5689.65 Median:2499.45 stddev:3224.62 (129.0%) stddev-sans-first:3218.59 19:19:46 INFO - PROCESS | 1662 | Values: 1540.5 1547.5 1789.7 1889.6 1938.5 8498.3 8997.6 9008.8 9024.9 9064.2 7799.6 8113.3 8130.6 8519.5 8744.0 2365.8 2401.9 2408.0 2408.6 2411.1 2362.3 2377.4 2395.7 2396.6 2397.9 2027.7 2372.8 2384.9 2399.8 2400.7 2349.2 2358.8 2370.0 2372.5 2383.4 2343.2 2359.5 2368.0 2368.3 2373.2 8752.3 8942.0 8947.3 8948.3 8958.6 4590.6 5208.2 5374.1 5375.5 5381.9 3553.4 3562.2 3611.9 3633.7 3634.7 1038.6 1042.1 1045.4 1047.2 1056.5 11610.0 11736.7 11738.5 11741.9 11749.9 4542.7 4656.2 4765.1 4770.7 4808.8 10034.4 10046.3 10055.5 10056.0 10089.2 5373.0 5381.9 5385.9 5390.6 5401.4 3797.3 4401.7 4561.7 4863.1 4928.8 3792.5 3840.7 3914.1 3937.4 3966.8 1236.4 1242.0 1249.7 1255.3 1262.9 863.9 873.1 903.3 906.3 917.5 5487.3 5682.6 5974.4 5990.0 6005.1 432.2 439.8 450.9 452.6 456.2 3777.5 3825.2 3865.2 3935.4 3994.4 10279.2 10796.9 10801.0 10821.4 10837.6 10762.3 10765.0 10768.3 10771.7 10811.0 6752.9 7609.1 8123.7 8186.9 8191.5 5651.6 5763.9 5770.3 5983.5 6053.3 9977.4 10116.0 10140.3 10149.6 10184.1 9629.9 10050.4 10054.0 10156.5 10186.8 6936.1 7111.6 7146.0 7453.6 7623.0 8054.4 8209.5 8343.5 8428.2 8431.4 7372.8 7497.2 7550.0 7559.0 7633.1 7349.3 7405.3 7458.3 7531.4 7612.3 6877.1 7020.3 7025.4 7026.4 7026.9 4910.4 4991.7 5071.3 5089.0 5106.9 4376.3 4977.9 5056.4 5184.7 5256.8 19:19:46 INFO - PROCESS | 1662 | 19:19:46 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4497.56 Median:5159.42 stddev:1391.46 (27.0%) stddev-sans-first:1359.18 19:19:46 INFO - PROCESS | 1662 | Values: 297.3 300.9 310.6 313.8 314.7 4937.7 5343.8 5367.5 5448.0 5463.2 4595.5 5091.3 5181.4 5287.8 5305.5 3961.0 4103.8 4124.3 4131.6 4139.9 3267.8 3983.9 4086.4 4151.5 4175.2 3363.9 3767.8 3966.8 4045.7 4081.7 3288.9 3542.3 3769.4 4048.9 4060.6 2818.7 3422.5 3444.3 3444.8 3445.5 4209.8 4215.4 4871.9 5158.6 5160.2 4053.7 4513.3 4574.4 4576.3 4580.8 4842.8 4866.2 5567.6 5577.5 5614.7 3756.2 3791.8 3802.5 3844.6 3852.1 5009.3 5673.7 5925.7 5932.6 5979.4 3442.0 3767.6 3889.8 3891.0 3910.0 3451.6 3689.5 3935.4 3993.0 4011.9 4382.6 4618.7 4635.2 4659.0 4675.9 5258.6 5656.4 5679.1 5685.2 5749.9 1272.8 1303.4 1335.2 1352.7 1354.6 838.5 872.2 892.1 895.2 900.3 4768.0 5263.3 5267.8 5280.1 5288.4 5499.8 5599.4 5713.7 5735.7 5778.0 4757.4 5162.3 5172.8 5194.9 5211.9 2622.7 2915.8 2987.4 2988.0 3012.6 4939.0 5576.6 5901.4 5914.3 5946.8 4712.6 5653.1 5850.3 5859.5 5869.5 4443.2 4562.6 5786.1 5877.8 5880.5 4756.7 4856.8 5353.8 5654.3 5727.9 5174.7 5398.2 5589.8 5657.6 5666.9 5726.3 5809.0 5893.9 5895.6 5934.7 3368.2 3601.1 3810.6 3824.9 3828.5 5253.7 5592.2 5605.9 5612.0 5625.0 4582.6 5355.7 5568.3 5586.6 5594.5 5474.8 5528.7 5534.2 5552.2 5557.8 4783.0 5387.0 5392.4 5399.6 5473.4 4542.9 5310.8 5526.8 5624.0 5688.3 5526.7 5532.3 5542.7 5568.3 5568.3 19:19:46 INFO - PROCESS | 1662 | 19:19:46 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:22269.10 Median:3786.19 stddev:33280.02 (879.0%) stddev-sans-first:33333.88 19:19:46 INFO - PROCESS | 1662 | Values: 675.8 709.7 744.0 745.5 817.3 15642.4 15967.9 15995.0 16004.0 16009.2 14201.5 14313.4 14327.9 14330.6 14681.6 600.6 663.1 694.4 844.6 864.5 837.9 851.7 853.8 854.0 859.2 933.4 934.7 935.4 935.8 938.5 712.9 729.4 917.5 928.4 928.6 687.2 692.9 698.2 698.4 703.1 15201.8 15338.0 15342.4 15348.3 15348.6 14493.4 14609.3 14645.3 14667.2 14678.1 11668.4 11935.2 12061.2 12101.8 12104.9 3385.5 3732.9 3735.2 3784.7 3787.7 104698.5 105019.0 105484.0 107102.5 109904.0 9379.4 11134.0 11241.3 11265.7 11271.8 21244.9 23014.5 23233.5 23269.8 23274.7 8333.5 8360.2 8391.9 8398.9 8673.0 4523.1 4553.6 4583.5 4625.1 4748.2 3618.5 3759.8 3767.8 3773.2 3776.7 675.1 684.2 687.6 700.4 701.2 583.7 661.2 672.4 682.6 690.8 7071.0 9250.4 9297.3 9361.0 9576.8 576.5 591.1 609.4 670.8 682.2 4107.4 4509.6 4515.1 4595.1 4641.5 89368.1 112208.0 113252.4 125921.0 135732.0 104751.0 108299.5 108760.5 109810.0 110877.0 62449.7 83227.6 85236.6 86784.0 98083.0 9379.4 9514.3 9562.2 9630.9 9663.7 54036.0 55615.4 55836.0 56647.7 57634.7 84349.0 84988.0 86373.6 88304.2 88934.0 12385.5 12444.3 12610.4 12930.3 13126.3 13904.0 14361.6 14506.4 15392.5 15590.9 12941.0 13798.5 13838.5 14039.2 14184.9 12688.5 13302.7 13645.2 13867.4 14129.2 13185.5 13540.0 13642.8 14173.4 14216.9 10187.3 10247.8 10808.1 11043.7 11571.9 9321.2 10568.4 10659.1 10720.2 10981.1 19:19:46 INFO - PROCESS | 1662 | -------- Summary: end -------- 19:19:46 INFO - PROCESS | 1662 | 19:19:47 INFO - TEST-INFO | 1662: exit 0 19:19:47 INFO - TEST-OK | dromaeo_css | took 1118029ms 19:19:47 INFO - TEST-START | kraken 19:19:47 INFO - operating with platform_type : mac_ 19:19:47 INFO - Initialising browser for kraken test... 19:19:47 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmpAZdb7b/profile http://localhost:49279/getInfo.html) 19:19:49 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 19:19:49 INFO - PROCESS | 1668 | colorDepth:24 19:19:49 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 19:19:49 INFO - PROCESS | 1668 | __metrics 19:19:49 INFO - PROCESS | 1668 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:19:49 INFO - PROCESS | 1668 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:19:50 INFO - TEST-INFO | 1668: exit 0 19:19:50 INFO - Browser initialized. 19:19:50 INFO - Running cycle 1/1 for kraken test... 19:19:50 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmpAZdb7b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:20:02 INFO - PROCESS | 1669 | RSS: Main: 236253184 19:20:02 INFO - PROCESS | 1669 | 19:20:05 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 19:20:06 INFO - PROCESS | 1669 | RSS: Main: 294957056 19:20:06 INFO - PROCESS | 1669 | 19:20:08 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 19:20:09 INFO - PROCESS | 1669 | RSS: Main: 293707776 19:20:09 INFO - PROCESS | 1669 | 19:20:12 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 19:20:13 INFO - PROCESS | 1669 | RSS: Main: 385097728 19:20:13 INFO - PROCESS | 1669 | 19:20:15 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 19:20:16 INFO - PROCESS | 1669 | RSS: Main: 287670272 19:20:16 INFO - PROCESS | 1669 | 19:20:18 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:20:18 INFO - PROCESS | 1669 | RSS: Main: 289710080 19:20:18 INFO - PROCESS | 1669 | 19:20:21 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 19:20:22 INFO - PROCESS | 1669 | RSS: Main: 328589312 19:20:22 INFO - PROCESS | 1669 | 19:20:24 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 19:20:25 INFO - PROCESS | 1669 | RSS: Main: 327356416 19:20:25 INFO - PROCESS | 1669 | 19:20:28 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 19:20:28 INFO - PROCESS | 1669 | RSS: Main: 326336512 19:20:28 INFO - PROCESS | 1669 | 19:20:30 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:20:31 INFO - PROCESS | 1669 | RSS: Main: 305197056 19:20:31 INFO - PROCESS | 1669 | 19:20:33 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:20:33 INFO - PROCESS | 1669 | RSS: Main: 305639424 19:20:33 INFO - PROCESS | 1669 | 19:20:35 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:20:36 INFO - PROCESS | 1669 | RSS: Main: 306921472 19:20:36 INFO - PROCESS | 1669 | 19:20:39 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:20:40 INFO - PROCESS | 1669 | RSS: Main: 316231680 19:20:40 INFO - PROCESS | 1669 | 19:20:43 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:20:43 INFO - PROCESS | 1669 | RSS: Main: 318672896 19:20:43 INFO - PROCESS | 1669 | 19:20:45 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 19:20:45 INFO - PROCESS | 1669 | RSS: Main: 362610688 19:20:45 INFO - PROCESS | 1669 | 19:20:45 INFO - PROCESS | 1669 | __start_tp_report 19:20:45 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 19:20:45 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 19:20:45 INFO - PROCESS | 1669 | |i|pagename|runs| 19:20:45 INFO - PROCESS | 1669 | |0;ai-astar;115;91;124;166;164;111;113;110;117;165 19:20:45 INFO - PROCESS | 1669 | |1;audio-beat-detection;144;108;110;143;109;113;109;106;139;107 19:20:45 INFO - PROCESS | 1669 | |2;audio-dft;182;183;183;183;184;182;183;183;180;179 19:20:45 INFO - PROCESS | 1669 | |3;audio-fft;78;59;58;92;89;83;83;66;83;58 19:20:45 INFO - PROCESS | 1669 | |4;audio-oscillator;87;73;102;100;98;92;90;68;69;88 19:20:45 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;89;85;88;86;87;85;89;123;88;84 19:20:45 INFO - PROCESS | 1669 | |6;imaging-darkroom;93;93;93;92;93;94;92;93;93;93 19:20:45 INFO - PROCESS | 1669 | |7;imaging-desaturate;87;84;83;84;83;87;84;83;86;84 19:20:45 INFO - PROCESS | 1669 | |8;json-parse-financial;53;54;53;53;52;54;56;52;55;76 19:20:45 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;63;72;69;74;99;99;81;69;70;69 19:20:45 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;86;89;86;93;105;86;85;84;89;86 19:20:45 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;139;138;141;136;144;145;139;141;194;151 19:20:45 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;169;168;186;229;199;168;169;169;167;167 19:20:45 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;66;69;68;67;66;68;67;66;67;66 19:20:45 INFO - PROCESS | 1669 | __end_tp_report 19:20:45 INFO - PROCESS | 1669 | __start_cc_report 19:20:45 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1932 19:20:45 INFO - PROCESS | 1669 | __end_cc_report 19:20:45 INFO - PROCESS | 1669 | __startTimestamp1475029245800__endTimestamp 19:20:45 INFO - PROCESS | 1669 | 19:20:45 INFO - PROCESS | 1669 | ------- Summary: start ------- 19:20:45 INFO - PROCESS | 1669 | Number of tests: 14 19:20:45 INFO - PROCESS | 1669 | 19:20:45 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:127.60 Median:144.00 stddev:27.12 (18.8%) stddev-sans-first:28.38 19:20:45 INFO - PROCESS | 1669 | Values: 115.0 91.0 124.0 166.0 164.0 111.0 113.0 110.0 117.0 165.0 19:20:45 INFO - PROCESS | 1669 | 19:20:45 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:118.80 Median:111.50 stddev:16.16 (14.5%) stddev-sans-first:14.34 19:20:45 INFO - PROCESS | 1669 | Values: 144.0 108.0 110.0 143.0 109.0 113.0 109.0 106.0 139.0 107.0 19:20:45 INFO - PROCESS | 1669 | 19:20:45 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:182.20 Median:183.00 stddev:1.55 (0.8%) stddev-sans-first:1.64 19:20:45 INFO - PROCESS | 1669 | Values: 182.0 183.0 183.0 183.0 184.0 182.0 183.0 183.0 180.0 179.0 19:20:45 INFO - PROCESS | 1669 | 19:20:45 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:74.90 Median:83.00 stddev:13.34 (16.1%) stddev-sans-first:14.10 19:20:45 INFO - PROCESS | 1669 | Values: 78.0 59.0 58.0 92.0 89.0 83.0 83.0 66.0 83.0 58.0 19:20:45 INFO - PROCESS | 1669 | 19:20:45 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:86.70 Median:87.50 stddev:12.61 (14.4%) stddev-sans-first:13.37 19:20:45 INFO - PROCESS | 1669 | Values: 87.0 73.0 102.0 100.0 98.0 92.0 90.0 68.0 69.0 88.0 19:20:45 INFO - PROCESS | 1669 | 19:20:45 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:90.40 Median:87.50 stddev:11.59 (13.2%) stddev-sans-first:12.28 19:20:45 INFO - PROCESS | 1669 | Values: 89.0 85.0 88.0 86.0 87.0 85.0 89.0 123.0 88.0 84.0 19:20:45 INFO - PROCESS | 1669 | 19:20:45 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:93.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 19:20:45 INFO - PROCESS | 1669 | Values: 93.0 93.0 93.0 92.0 93.0 94.0 92.0 93.0 93.0 93.0 19:20:45 INFO - PROCESS | 1669 | 19:20:45 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:84.00 stddev:1.58 (1.9%) stddev-sans-first:1.39 19:20:45 INFO - PROCESS | 1669 | Values: 87.0 84.0 83.0 84.0 83.0 87.0 84.0 83.0 86.0 84.0 19:20:45 INFO - PROCESS | 1669 | 19:20:45 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:54.00 stddev:7.21 (13.3%) stddev-sans-first:7.57 19:20:45 INFO - PROCESS | 1669 | Values: 53.0 54.0 53.0 53.0 52.0 54.0 56.0 52.0 55.0 76.0 19:20:45 INFO - PROCESS | 1669 | 19:20:45 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:76.50 Median:73.00 stddev:12.70 (17.4%) stddev-sans-first:12.50 19:20:45 INFO - PROCESS | 1669 | Values: 63.0 72.0 69.0 74.0 99.0 99.0 81.0 69.0 70.0 69.0 19:20:45 INFO - PROCESS | 1669 | 19:20:45 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:86.00 stddev:6.23 (7.2%) stddev-sans-first:6.51 19:20:45 INFO - PROCESS | 1669 | Values: 86.0 89.0 86.0 93.0 105.0 86.0 85.0 84.0 89.0 86.0 19:20:45 INFO - PROCESS | 1669 | 19:20:45 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:142.50 stddev:17.13 (12.0%) stddev-sans-first:17.93 19:20:45 INFO - PROCESS | 1669 | Values: 139.0 138.0 141.0 136.0 144.0 145.0 139.0 141.0 194.0 151.0 19:20:45 INFO - PROCESS | 1669 | 19:20:45 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.10 Median:169.00 stddev:20.49 (12.1%) stddev-sans-first:21.41 19:20:45 INFO - PROCESS | 1669 | Values: 169.0 168.0 186.0 229.0 199.0 168.0 169.0 169.0 167.0 167.0 19:20:45 INFO - PROCESS | 1669 | 19:20:45 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.05 (1.6%) stddev-sans-first:1.05 19:20:45 INFO - PROCESS | 1669 | Values: 66.0 69.0 68.0 67.0 66.0 68.0 67.0 66.0 67.0 66.0 19:20:45 INFO - PROCESS | 1669 | -------- Summary: end -------- 19:20:45 INFO - PROCESS | 1669 | 19:20:46 INFO - TEST-INFO | 1669: exit 0 19:20:46 INFO - TEST-OK | kraken | took 59365ms 19:20:46 INFO - SUITE-END | took 1177s 19:20:46 INFO - Completed test suite (00:19:37) 19:20:46 INFO - javascript benchmark 19:20:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3276.6231883333417, 3287.0631869917065, 3296.505524171374, 3333.100062982996, 3355.697987181153, 5504.504594586487, 5605.271314729084, 5621.550275977922, 5640.0693885508945, 5651.2653355063885, 5589.776408943638, 5635.971820140904, 5698.059820129673, 5780.959427303083, 5838.620489668179, 5077.543021128116, 5107.412647545524, 5164.974175129119, 5206.817761378353, 5216.00895829793, 5152.639315247934, 5256.474352564751, 5261.079311120558, 5261.763220655061, 5331.760070796823, 5209.192575150858, 5223.477652234784, 5241.161414173733, 5264.263003179539, 5292.5765938725, 5091.0, 5106.106431374495, 5130.127878260705, 5146.6911985281, 5154.278401023859, 5099.464556221617, 5122.257272695476, 5142.100132476801, 5183.688978661293, 5190.766415511311, 5583.4974852263085, 5656.8020119295625, 5663.178839068312, 5666.065099258617, 5668.093105103205, 5983.52131829457, 6130.356312587203, 6139.0, 6165.198524191826, 6257.124002639634, 5939.554533410012, 5947.0, 5968.940310596882, 6027.9095813562835, 6126.111713801474, 5506.256655351476, 5511.448855114497, 5512.283403157604, 5522.66863988162, 5532.0, 6123.142760013601, 6131.908021379593, 6138.754449821957, 6142.539309551801, 6142.723577439026, 5983.491403230687, 6049.727762250621, 6051.939480605226, 6063.939360606426, 6130.233720784902, 6115.510759139258, 6152.230971128609, 6180.598261113103, 6184.752609895644, 6184.969075154595, 6117.908231376533, 6140.723667434976, 6163.3528479509005, 6166.753329866845, 6183.288921773964, 6064.605800623033, 6136.048912418582, 6142.416470435302, 6162.26052873658, 6193.628382297076, 4900.142475066849, 4901.142300097468, 4909.410870695539, 4914.262860570871, 4927.507249275115, 4322.8703138905885, 4397.604215620546, 4442.53353397895, 4442.844500442469, 4446.2663660495655, 5619.241402410622, 5675.233843431084, 5706.80026199081, 5722.2561067061015, 5788.131780232999, 6156.168917196122, 6165.506759459233, 6166.537509686791, 6172.321044685081, 6182.196314479089, 5086.898262034739, 5745.310562732415, 5760.3951585083805, 5766.481016708516, 5768.596198266081, 5229.294045303835, 5280.339957505312, 5298.6290959633225, 5344.251804747339, 5356.91964620531, 6174.783882564088, 6183.2270966128335, 6189.473894718999, 6194.473469754941, 6204.441600255998, 6112.1995365628145, 6121.418465245794, 6135.263289243823, 6155.384461553809, 6160.476359509492, 6318.147050148171, 6332.398422149889, 6333.524985626189, 6348.333424990309, 6348.492120630246, 6132.78535251264, 6140.0, 6150.2927163375, 6152.384761523812, 6157.138000679998, 6057.878842423215, 6122.510199183966, 6135.754569817157, 6139.109829074849, 6142.78500252489, 5778.797742079175, 5978.671173085348, 6077.20996270482, 6106.2061931948565, 6107.175531303395, 5902.586818922634, 6077.604955677867, 6081.604695694766, 6086.056661217518, 6106.419890110433, 5755.769769209185, 5784.2769653793275, 5952.285725712942, 5970.641761494324, 5972.134040564007, 4936.333594964777, 5921.7631294747725, 5989.101634754822, 5998.850028749316, 6038.215032045806, 6002.819915402545, 6018.0, 6022.518198544193, 6043.909341359795, 6053.213082299273], "value": 5635.667397274393, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [444.65317052698884, 460.95363524798705, 543.141835899279, 548.2461615278991, 552.5579536370907, 29761.553576696366, 40235.59764402355, 41437.0, 41510.58489415105, 43712.3443148353, 41928.37107443383, 42249.36625950613, 42355.36466952998, 42387.576124238745, 42392.576074239245, 9771.609135634566, 9948.502574871263, 9953.900460995406, 9954.502274886263, 9961.0, 9724.562394692255, 9819.705408837746, 9822.459764712938, 9841.015898410138, 9841.90158098417, 9725.0761177688, 9780.657676981307, 9785.657501987433, 9787.119159275664, 9788.0, 9769.511524423786, 9837.0, 9844.310898237127, 9853.852192217122, 9861.408315501092, 9826.213902887823, 9896.356736812084, 9902.752431189207, 9912.504374781232, 9932.553035113366, 40464.0, 40736.0, 40812.795936020426, 40844.79577602123, 40909.97725056868, 3290.7367410607094, 3361.764676472648, 3463.965360346415, 3523.8766643167623, 3644.2893635741043, 30599.38801223963, 30634.23414414635, 31824.84087579547, 31909.202269943205, 32224.0, 3045.162580290416, 3076.8307743074124, 3114.9688503114903, 3180.681931806801, 3184.792988455743, 398425.0, 403406.0, 403703.0, 406541.0, 409161.95419022714, 50637.74681126571, 51578.48421515737, 56764.71617641886, 58828.0, 59119.70440147772, 59456.405435945955, 62074.37925620686, 62896.68551657212, 62900.68549657314, 62904.685476572326, 14980.925095374454, 15057.322420491104, 15065.17141557225, 15090.773638395432, 15119.848801512064, 12184.81722774159, 12293.69265768345, 12294.938525307316, 12296.692582685504, 12320.383980800923, 14277.214753188675, 17552.56118597045, 17577.736333955, 17598.560035999202, 17664.470065898044, 7069.646517674096, 7106.786796396116, 7150.5352152109945, 7213.495055346076, 7217.0, 882.7131182365629, 887.600579739107, 925.5372313843078, 980.1472718734747, 1046.2519298701466, 28796.568051479244, 29624.555631665542, 29747.553786693217, 30494.0, 30643.540346894813, 837.380338549469, 966.5795379010153, 999.9800004000025, 1035.4563853976722, 1149.5344385523877, 14621.78067328991, 15230.725394040335, 15261.542153735405, 15408.506084662713, 15523.922380388025, 514528.0, 514685.0, 518001.0, 519143.0, 519615.0, 56812.57968550819, 57106.428935710945, 57245.0, 57272.71363643238, 57350.426495735344, 1241.360699239874, 1293.0, 1370.979435308491, 1399.111564156788, 1408.5351833894995, 30541.389172215986, 30824.537631935986, 31040.68959310378, 31525.92651582247, 31924.68075319217, 49715.75142124266, 50442.0, 50535.74732126316, 50640.49359506358, 50697.0, 422073.0, 422167.0, 424532.0, 425013.0, 427145.0, 26048.73951260539, 26279.60580591331, 26775.062872799357, 26945.461090778466, 27185.72814271832, 46059.76970115128, 46573.767131164124, 46639.0, 46887.0, 46928.765356174365, 38353.6576219831, 38387.232255355295, 38986.68613167799, 39300.606993929694, 40788.1842363157, 38539.6146038536, 38544.42183367308, 38788.030299242746, 40007.79996100001, 40481.59518404896, 37576.87269381923, 37772.43341349937, 38374.80812595919, 38384.0, 39886.2022759549, 30130.945416910305, 34002.65997339995, 34201.486977694854, 34214.486782698776, 34324.656753432144, 24694.25917222486, 25189.370265743502, 25338.617612603095, 25445.491090178464, 25641.358966026], "value": 19417.896065972338, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.02313579816024, 371.867986864663, 375.98872033838995, 385.1392138570296, 405.7991294309317, 14765.630859228524, 15140.242987850605, 15947.441839535619, 19968.400947971582, 20590.794092059074, 16121.0, 20034.899825500852, 20188.091535880885, 20230.797692023076, 20434.69347959782, 5766.826995190151, 6032.034874420094, 6065.332813390523, 6069.666168360738, 6070.484008859252, 4169.583041695836, 4394.6703997200175, 4562.406887104672, 5974.22335096439, 6045.0, 4395.450568678915, 6202.7518899244205, 6323.766865461237, 6360.427561519462, 6683.398494135527, 6449.129367535393, 6575.868482630321, 6636.469082473439, 6656.301088385747, 6726.125603671516, 4894.486078961693, 5712.6286791358425, 5746.655200687972, 5752.9712351437975, 5753.280839895013, 24617.0, 25198.748012520005, 25396.984120635152, 25546.87226563874, 25574.87212563944, 2235.508188198594, 2271.8864056797092, 2297.150054479853, 2554.616807478893, 2854.957940351757, 15382.769258461132, 15414.0, 16010.519684409486, 16101.91949040259, 16220.0, 1707.1720215695502, 1763.6560870630233, 1832.6426346862368, 1880.5956719305277, 1894.232835701543, 104873.0, 105472.47263763708, 105612.47193763981, 106321.0, 106937.0, 9415.105564971316, 9515.096065873731, 9521.952390238004, 9653.806923861483, 10714.946425267979, 13355.666108347368, 13355.666108347368, 13386.19682819034, 13395.330233488286, 13417.865821341857, 8334.083250842403, 8441.57792110392, 8481.703140390056, 8583.484990900566, 8625.482471051757, 8527.10465401124, 8550.444221125606, 8552.700655477029, 8743.387962842668, 8744.169303916118, 5415.8104466344275, 6417.1657684500715, 6530.640814755234, 6534.346565343522, 6564.442022428051, 1646.1769115442278, 1782.4741701198177, 1791.892486450791, 1825.9087045647664, 1827.6070644811164, 660.7017211180055, 987.7975015122026, 992.5483904823288, 994.8806143262855, 1024.1755386913605, 19534.12096455663, 21842.344729658136, 21887.452813679785, 21945.67081493779, 22004.33986980393, 404.8036702199431, 425.95740425957155, 941.2940294778916, 963.9518024098767, 969.3117886300664, 5595.104783234663, 5941.435563621536, 6077.817665469955, 6110.938890611126, 6119.847003824851, 481871.0, 486199.5690021598, 494428.0, 495875.0, 497519.0, 121006.0, 129837.0, 130222.34888825496, 130649.0, 130887.0, 425.8275398463689, 452.6243218128945, 455.95440455954804, 460.5601650423904, 460.69594067915017, 10311.535980880728, 11469.311841289216, 11518.424078795859, 11551.0181634562, 17621.0, 50279.0, 51277.0, 51490.74254628703, 51946.0, 51954.960900781014, 60848.0, 65699.0, 66062.0, 71865.28134718795, 72838.63580682063, 8042.798930026796, 8136.796580085545, 8358.749237522885, 8509.787255318666, 8713.215810577078, 9365.531723413938, 12853.678658033625, 12985.610431687064, 13442.865571344553, 13582.388792504558, 7456.7762967111075, 10015.899841001497, 11221.214514983873, 11710.4730287139, 11778.823317650413, 6182.845428864314, 11283.887161128283, 11388.0, 11841.526338946345, 11847.526098955945, 11337.829932551183, 11591.88408115908, 11833.70415739579, 11957.76084478323, 12010.75978480443, 8261.463004904663, 8382.16178382157, 8489.617967191614, 8511.914880851113, 8682.305415566612, 9454.480003599869, 10732.570697172026, 10874.782504350027, 11269.66191014271, 11787.882121178678], "value": 9003.494411793541, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1540.5455390659752, 1547.4583895636526, 1789.7404876292937, 1889.6031833315003, 1938.5347516596012, 8498.277646400056, 8997.59510822013, 9008.819823603524, 9024.864627030584, 9064.229540489057, 7799.5710235937, 8113.310368618674, 8130.593470326489, 8519.488830670149, 8743.95628021859, 2365.82256330775, 2401.903923843044, 2408.0, 2408.614621660535, 2411.0837881604966, 2362.3267368799898, 2377.3699969508007, 2395.73646898841, 2396.604560247557, 2397.880105994693, 2027.675571908495, 2372.8457650252676, 2384.856908585482, 2399.7720216579482, 2400.6519054737055, 2349.189529612298, 2358.79950204232, 2370.0, 2372.466195106105, 2383.4398916254668, 2343.238447504551, 2359.4927090675587, 2368.0, 2368.265837590335, 2373.2049763329305, 8752.256058235058, 8942.0, 8947.284217262604, 8948.328875334377, 8958.55207239642, 4590.60979816716, 5208.218767184915, 5374.140137578008, 5375.462453754593, 5381.865453363658, 3553.378158822196, 3562.1985053363046, 3611.9097022574383, 3633.7274704397278, 3634.6547078027547, 1038.553422028535, 1042.1142029275131, 1045.393671670437, 1047.2250534604414, 1056.5456853552969, 11610.013148882355, 11736.706582335424, 11738.530458781725, 11741.88258117425, 11749.882501174965, 4542.68201225911, 4656.231721765938, 4765.0946320199055, 4770.689905156154, 4808.783604737725, 10034.397936123856, 10046.346987445793, 10055.547500362502, 10056.044675755791, 10089.192864570818, 5373.0, 5381.919271210935, 5385.865353366197, 5390.622656414013, 5401.378841433286, 3797.3164830330807, 4401.735895846259, 4561.657875659339, 4863.076015557032, 4928.753562321869, 3792.488014118114, 3840.6735427488416, 3914.080191155076, 3937.3700207967163, 3966.801659916993, 1236.3879879459726, 1241.975160496785, 1249.7375551134182, 1255.315852860175, 1262.8863402293655, 863.8747381629754, 873.0701802580231, 903.2683526343683, 906.2930913887178, 917.4770380882833, 5487.341519017744, 5682.573806964494, 5974.402559744078, 5989.961959011288, 6005.129256257906, 432.234944148861, 439.83726021372297, 450.85572616762977, 452.558755213664, 456.22441848856414, 3777.471154038437, 3825.1967086911504, 3865.246276976019, 3935.409688546741, 3994.4407782910416, 10279.177665786869, 10796.892031079746, 10801.027907488207, 10821.350718956888, 10837.620683276047, 10762.300450470695, 10765.0, 10768.300060496043, 10771.730706732395, 10811.027007569357, 6752.9403531923235, 7609.086909570776, 8123.715669951642, 8186.877196842052, 8191.508509489449, 5651.6043876928225, 5763.94236057634, 5770.307563092456, 5983.521318294613, 6053.303870054824, 9977.351472154287, 10116.0, 10140.340877842917, 10149.594016239267, 10184.134348580454, 9629.855552166864, 10050.447225402673, 10053.994600539887, 10156.492175391053, 10186.796264074528, 6936.132983377078, 7111.644417779194, 7146.0, 7453.552786832807, 7622.961885190539, 8054.3556515479795, 8209.548474833942, 8343.499390036617, 8428.241458268785, 8431.36764742659, 7372.778816635509, 7497.212792656693, 7549.9622501889335, 7559.017327747358, 7633.122190948112, 7349.338559529668, 7405.296496832792, 7458.328750412489, 7531.397488201041, 7612.276833700789, 6877.105976223059, 7020.333068358498, 7025.367716905503, 7026.437884969088, 7026.8945965809535, 4910.410750709938, 4991.700497970133, 5071.315372424676, 5089.0, 5106.923396149135, 4376.321670141133, 4977.925331120108, 5056.443791182894, 5184.714840683799, 5256.816011439581], "value": 4492.235616947364, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.3265553521276, 300.9097270818755, 310.605530975661, 313.83680486147205, 314.6978900255754, 4937.679050861696, 5343.839684809457, 5367.516923476886, 5447.972760136204, 5463.153211252262, 4595.494495605481, 5091.338126043618, 5181.35233095863, 5287.814926477565, 5305.549028332596, 3961.0, 4103.789382132278, 4124.298869192229, 4131.58684131586, 4139.8965025874295, 3267.836608169594, 3983.9203215935663, 4086.4483294755123, 4151.460310159675, 4175.185838761443, 3363.882264120756, 3767.792771397572, 3966.761994280338, 4045.656119229869, 4081.7142800004012, 3288.917777055569, 3542.256126213498, 3769.4157405602177, 4048.9190216195807, 4060.573639767826, 2818.7322204390757, 3422.5037369581273, 3444.328355970587, 3444.844981975817, 3445.5176275321473, 4209.810558524874, 4215.398148703473, 4871.878203044952, 5158.638895277332, 5160.200168973815, 4053.6622914438167, 4513.323001549761, 4574.359589657451, 4576.26779715244, 4580.824108548446, 4842.7723247306285, 4866.221404575251, 5567.582431317627, 5577.52591029763, 5614.719264036782, 3756.1548651553453, 3791.829367678461, 3802.4676545283683, 3844.596722196406, 3852.114013776847, 5009.348784658007, 5673.744681489343, 5925.674087925119, 5932.614380065325, 5979.372165922559, 3442.0226504073794, 3767.604401537854, 3889.755278310913, 3891.0466935600957, 3910.0, 3451.620321764604, 3689.4650275709873, 3935.4490371348033, 3992.9800350998057, 4011.919761604752, 4382.627476664456, 4618.722876627413, 4635.188841952645, 4658.95341046592, 4675.906481870344, 5258.553022993088, 5656.43435656431, 5679.075276232744, 5685.204071430003, 5749.913751293734, 1272.7518133963788, 1303.4134639412302, 1335.1988806715892, 1352.6888815572277, 1354.5665387076042, 838.5388036579857, 872.1975782280317, 892.054422312351, 895.167494230372, 900.3247564326755, 4767.951050768826, 5263.26314315996, 5267.813857249199, 5280.102382594968, 5288.418273989858, 5499.835004949778, 5599.412061733541, 5713.74288157034, 5735.655860648374, 5777.971110144423, 4757.381540399726, 5162.3030890830005, 5172.801559337267, 5194.896102077937, 5211.869703257449, 2622.659054322964, 2915.825050496977, 2987.4323878463024, 2987.970120298769, 3012.638483382008, 4938.950610493849, 5576.609637325349, 5901.439363260483, 5914.292707537247, 5946.780909913457, 4712.64367816092, 5653.088659340443, 5850.268716410364, 5859.472647461749, 5869.530437564985, 4443.200223959654, 4562.5665561771575, 5786.132080187837, 5877.794277200277, 5880.500472379601, 4756.667033307635, 4856.757162141949, 5353.8142562375215, 5654.3497497788285, 5727.8568035799435, 5174.7153906535505, 5398.1902714593125, 5589.832305030855, 5657.575681823962, 5666.923284575917, 5726.2535174917775, 5809.0, 5893.941060589339, 5895.58281104745, 5934.732937017931, 3368.2253081791814, 3601.081724160322, 3810.618938106167, 3824.9235015300096, 3828.4640150378414, 5253.684778913277, 5592.161175823659, 5605.943940560543, 5611.971940140274, 5625.0, 4582.587567118975, 5355.697050268422, 5568.331800184003, 5586.631275337406, 5594.524465420485, 5474.753636086465, 5528.7235638218735, 5534.225208470898, 5552.222688823649, 5557.833265002057, 4782.952170478251, 5387.003404370204, 5392.438591669083, 5399.649022813504, 5473.397926228191, 4542.886427839198, 5310.8141215057285, 5526.751296191762, 5623.963059947582, 5688.288963879515, 5526.696031718294, 5532.28080349552, 5542.69515176653, 5568.303962004749, 5568.331800184003], "value": 4056.5836613499487, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.8040168351181, 709.7480394459967, 743.9739609113682, 745.455817253405, 817.3175398542219, 15642.374305027799, 15967.920160399182, 15994.960327578729, 16004.0, 16009.19954002301, 14201.502947396843, 14313.355898984544, 14327.922451244563, 14330.570082897504, 14681.559553213394, 600.5705920267009, 663.1246754284334, 694.4132208283992, 844.5903736687701, 864.4726716702806, 837.8575642140851, 851.7189327521903, 853.8463076646201, 854.0, 859.2181115185183, 933.4119504712022, 934.654177954158, 935.4387367579432, 935.822193783179, 938.5354249646434, 712.8538649576876, 729.3763831923682, 917.4632839788732, 928.3919033033408, 928.6285485805664, 687.2028447001454, 692.9133858267717, 698.2075344484048, 698.4447364345358, 703.103542982696, 15201.847981520154, 15338.0, 15342.386304547916, 15348.309326080242, 15348.616284592974, 14493.420263189566, 14609.269536523238, 14645.267736613127, 14667.193304368255, 14678.119312841263, 11668.416579171093, 11935.164538482222, 12061.155719099666, 12101.818472722916, 12104.939475302566, 3385.5091011803397, 3732.9226489144853, 3735.196932659464, 3784.6783023442763, 3787.696984241254, 104698.47650761697, 105019.0, 105484.0, 107102.46448767785, 109904.0, 9379.390339628038, 11134.0, 11241.269317494336, 11265.71835704114, 11271.830922536168, 21244.89377553133, 23014.53970920572, 23233.535329293318, 23269.767302327098, 23274.65088023681, 8333.499990000499, 8360.205780450848, 8391.916080839235, 8398.916010839936, 8673.04596494385, 4523.140603285366, 4553.590176884097, 4583.472900616405, 4625.098105869391, 4748.169070412664, 3618.5476815398074, 3759.755615884959, 3767.8492860285282, 3773.2453509298252, 3776.6978641708597, 675.0987431778533, 684.226823689228, 687.5702685821361, 700.3801635552572, 701.2216439751871, 583.6818933681154, 661.2032500836576, 672.4284358295507, 682.617734068913, 690.8411065454974, 7071.0031246740655, 9250.398724082914, 9297.256219502424, 9361.0, 9576.808463830825, 576.5214871656599, 591.1398914579363, 609.3845216331537, 670.778643047793, 682.2256738601723, 4107.363358679409, 4509.616682582017, 4515.074409745994, 4595.058013107305, 4641.535846415331, 89368.10631893598, 112208.0, 113252.43373783078, 125921.0, 135732.0, 104751.0, 108299.45850270856, 108760.45619771851, 109810.0, 110877.0, 62449.68775156095, 83227.58386208152, 85236.57381713051, 86784.0, 98083.0, 9379.437233765995, 9514.286428518028, 9562.235021198427, 9630.855537167088, 9663.661771837951, 54036.0, 55615.44384556103, 55836.0, 56647.716761415926, 57634.7118264406, 84349.0, 84988.0, 86373.56813215894, 88304.23391532004, 88934.0, 12385.504579816707, 12444.315562644142, 12610.369481525704, 12930.288834113837, 13126.343682816012, 13904.0, 14361.569152925429, 14506.419743210154, 15392.461263855712, 15590.9220453897, 12941.029422793517, 13798.517051903134, 13838.515651952133, 14039.227842468763, 14184.936129790101, 12688.492460301853, 13302.733945321233, 13645.181289122684, 13867.445302188204, 14129.152250864981, 13185.472581096648, 13540.0, 13642.795358069437, 14173.362198700877, 14216.928915355356, 10187.286889917634, 10247.795044099226, 10808.135349172204, 11043.723906902393, 11571.884281157081, 9321.20769734553, 10568.365898045835, 10659.087402127487, 10720.19598530129, 10981.066609338295], "value": 7651.00852290113, "unit": "score"}], "name": "dromaeo_css", "value": 7183.304535981813, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 91.0, 124.0, 166.0, 164.0, 111.0, 113.0, 110.0, 117.0, 165.0], "value": 127.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 108.0, 110.0, 143.0, 109.0, 113.0, 109.0, 106.0, 139.0, 107.0], "value": 118.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 183.0, 183.0, 184.0, 182.0, 183.0, 183.0, 180.0, 179.0], "value": 182.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 59.0, 58.0, 92.0, 89.0, 83.0, 83.0, 66.0, 83.0, 58.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 73.0, 102.0, 100.0, 98.0, 92.0, 90.0, 68.0, 69.0, 88.0], "value": 86.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 88.0, 86.0, 87.0, 85.0, 89.0, 123.0, 88.0, 84.0], "value": 90.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 92.0, 93.0, 94.0, 92.0, 93.0, 93.0, 93.0], "value": 92.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 83.0, 84.0, 83.0, 87.0, 84.0, 83.0, 86.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 53.0, 52.0, 54.0, 56.0, 52.0, 55.0, 76.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 72.0, 69.0, 74.0, 99.0, 99.0, 81.0, 69.0, 70.0, 69.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 89.0, 86.0, 93.0, 105.0, 86.0, 85.0, 84.0, 89.0, 86.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 141.0, 136.0, 144.0, 145.0, 139.0, 141.0, 194.0, 151.0], "value": 146.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 186.0, 229.0, 199.0, 168.0, 169.0, 169.0, 167.0, 167.0], "value": 179.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 68.0, 67.0, 66.0, 68.0, 67.0, 66.0, 67.0, 66.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1472.1, "alertThreshold": 2.0}]} 19:20:47 INFO - Return code: 0 19:20:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:20:47 INFO - # TBPL SUCCESS # 19:20:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:20:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:20:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:20:47 INFO - 2016-09-27 19:20:47.106 screenresolution[1673:11073] starting screenresolution argv=screenresolution get 19:20:47 INFO - 2016-09-27 19:20:47.109 screenresolution[1673:11073] Display 0: 1600x1200x32@60 19:20:47 INFO - 2016-09-27 19:20:47.115 screenresolution[1674:11076] starting screenresolution argv=screenresolution list 19:20:47 INFO - Available Modes on Display 0 19:20:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:20:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:20:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:20:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:20:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:20:47 INFO - Intel Iris: 19:20:47 INFO - Chipset Model: Intel Iris 19:20:47 INFO - Type: GPU 19:20:47 INFO - Bus: Built-In 19:20:47 INFO - VRAM (Dynamic, Max): 1536 MB 19:20:47 INFO - Vendor: Intel (0x8086) 19:20:47 INFO - Device ID: 0x0a2e 19:20:47 INFO - Revision ID: 0x0009 19:20:47 INFO - Displays: 19:20:47 INFO - Display: 19:20:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:20:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:20:47 INFO - Display Serial Number: 1600x1200 60 19:20:47 INFO - Main Display: Yes 19:20:47 INFO - Mirror: Off 19:20:47 INFO - Online: Yes 19:20:47 INFO - Rotation: Supported 19:20:47 INFO - Return code: 0 19:20:47 INFO - Running post-action listener: _resource_record_post_action 19:20:47 INFO - [mozharness: 2016-09-28 02:20:47.351129Z] Finished run-tests step (success) 19:20:47 INFO - Running post-run listener: _resource_record_post_run 19:20:47 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 31988736; Write bytes: 705601024; Read time: 197; Write time: 1980 19:20:47 INFO - TinderboxPrint: CPU usage
53.5% 19:20:47 INFO - TinderboxPrint: I/O read bytes / time
31,988,736 / 197 19:20:47 INFO - TinderboxPrint: I/O write bytes / time
705,601,024 / 1,980 19:20:47 INFO - TinderboxPrint: CPU idle
2,255.1 (46.5%) 19:20:47 INFO - TinderboxPrint: CPU system
966.8 (19.9%) 19:20:47 INFO - TinderboxPrint: CPU user
1,627.7 (33.6%) 19:20:47 INFO - TinderboxPrint: Swap in / out
435,404,800 / 0 19:20:47 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 393226752; Write bytes: 391719936; Read time: 29163; Write time: 847 19:20:47 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 30239744; Write bytes: 294044160; Read time: 183; Write time: 1089 19:20:47 INFO - Running post-run listener: _upload_blobber_files 19:20:47 INFO - Blob upload gear active. 19:20:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:20:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:20:47 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:20:47 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:20:48 INFO - (blobuploader) - INFO - Open directory for files ... 19:20:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:20:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:20:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:50 INFO - (blobuploader) - INFO - Done attempting. 19:20:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:20:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:20:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:52 INFO - (blobuploader) - INFO - Done attempting. 19:20:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:20:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:20:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:54 INFO - (blobuploader) - INFO - Done attempting. 19:20:54 INFO - (blobuploader) - INFO - Iteration through files over. 19:20:54 INFO - Return code: 0 19:20:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:20:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:20:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f040e44b52e0cd2ded387b024bbf96a0816af12f055fb265860df997431d03974a6dd22d9e9be6e92430fd1da9fd3715268a5a22ea7cc109e991a468d8ef5635", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/add56f73ce771ff10ce9c7574205ad4e0db3225309ca10f94273ad29830be0594ae9835d0ba71061d2af51b63480c2282edce2d683dddcc61af576480fe4611b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/75f0ffb704e346d5fca49b4a83e729356d80fd8cd4c52c74e3b31d0f672e0b789738621ab67b98882e6bb3b9f12d11b0cac452dfbe49defb326879f5e0ec813f"} 19:20:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:20:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:20:54 INFO - Contents: 19:20:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f040e44b52e0cd2ded387b024bbf96a0816af12f055fb265860df997431d03974a6dd22d9e9be6e92430fd1da9fd3715268a5a22ea7cc109e991a468d8ef5635", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/add56f73ce771ff10ce9c7574205ad4e0db3225309ca10f94273ad29830be0594ae9835d0ba71061d2af51b63480c2282edce2d683dddcc61af576480fe4611b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/75f0ffb704e346d5fca49b4a83e729356d80fd8cd4c52c74e3b31d0f672e0b789738621ab67b98882e6bb3b9f12d11b0cac452dfbe49defb326879f5e0ec813f"} 19:20:54 INFO - Running post-run listener: copy_logs_to_upload_dir 19:20:54 INFO - Copying logs to upload dir... 19:20:54 INFO - mkdir: /builds/slave/test/build/upload/logs 19:20:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.046120 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-09-27 19:20:54.993877) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 19:20:54.997649) ========= 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.fBIYrpO0l6/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.HQiIloG0EV/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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/Autoland/sha512/f040e44b52e0cd2ded387b024bbf96a0816af12f055fb265860df997431d03974a6dd22d9e9be6e92430fd1da9fd3715268a5a22ea7cc109e991a468d8ef5635", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/add56f73ce771ff10ce9c7574205ad4e0db3225309ca10f94273ad29830be0594ae9835d0ba71061d2af51b63480c2282edce2d683dddcc61af576480fe4611b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/75f0ffb704e346d5fca49b4a83e729356d80fd8cd4c52c74e3b31d0f672e0b789738621ab67b98882e6bb3b9f12d11b0cac452dfbe49defb326879f5e0ec813f"} build_url:https://queue.taskcluster.net/v1/task/JkQAqoMfTuiDhnNvfL69PA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010934 build_url: 'https://queue.taskcluster.net/v1/task/JkQAqoMfTuiDhnNvfL69PA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f040e44b52e0cd2ded387b024bbf96a0816af12f055fb265860df997431d03974a6dd22d9e9be6e92430fd1da9fd3715268a5a22ea7cc109e991a468d8ef5635", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/add56f73ce771ff10ce9c7574205ad4e0db3225309ca10f94273ad29830be0594ae9835d0ba71061d2af51b63480c2282edce2d683dddcc61af576480fe4611b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/75f0ffb704e346d5fca49b4a83e729356d80fd8cd4c52c74e3b31d0f672e0b789738621ab67b98882e6bb3b9f12d11b0cac452dfbe49defb326879f5e0ec813f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 19:20:55.029398) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 19:20:55.029716) ========= 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.fBIYrpO0l6/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.HQiIloG0EV/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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.004997 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 19:20:55.078044) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 19:20:55.078392) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 19:20:55.078718) ========= ========= Total master_lag: 0.17 =========