builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0037 starttime: 1472801447.69 results: success (0) buildid: 20160901215642 builduid: ad10029f6041452ebb85c5573b0fc16b revision: 4c4ce191fc9b444f1f47272293e001707538c105 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 00:30:47.690344) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 00:30:47.690857) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 00:30:47.691182) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 00:30:47.717157) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 00:30:47.717549) ========= 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.7qxgP4AvJV/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.ifKWcFtJh2/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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-02 00:30:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 40.5M=0s 2016-09-02 00:30:47 (40.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102553 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 00:30:47.843390) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 00:30:47.843727) ========= 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.7qxgP4AvJV/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.ifKWcFtJh2/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.028125 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 00:30:47.892532) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 00:30:47.892900) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4c4ce191fc9b444f1f47272293e001707538c105 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4c4ce191fc9b444f1f47272293e001707538c105 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7qxgP4AvJV/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.ifKWcFtJh2/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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-02 00:30:47,966 truncating revision to first 12 chars 2016-09-02 00:30:47,966 Setting DEBUG logging. 2016-09-02 00:30:47,966 attempt 1/10 2016-09-02 00:30:47,966 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4c4ce191fc9b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-02 00:30:48,628 unpacking tar archive at: fx-team-4c4ce191fc9b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.923826 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 00:30:48.838768) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 00:30:48.839094) ========= script_repo_revision: 4c4ce191fc9b444f1f47272293e001707538c105 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 00:30:48.839478) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 00:30:48.839764) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 00:30:48.858386) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-02 00:30:48.858872) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7qxgP4AvJV/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.ifKWcFtJh2/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 00:30:49 INFO - MultiFileLogger online at 20160902 00:30:49 in /builds/slave/test 00:30:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 00:30:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:30:49 INFO - {'append_to_log': False, 00:30:49 INFO - 'base_work_dir': '/builds/slave/test', 00:30:49 INFO - 'blob_upload_branch': 'Fx-Team', 00:30:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:30:49 INFO - 'branch': 'Fx-Team', 00:30:49 INFO - 'buildbot_json_path': 'buildprops.json', 00:30:49 INFO - 'config_files': ('talos/mac_config.py',), 00:30:49 INFO - 'default_actions': ('clobber', 00:30:49 INFO - 'read-buildbot-config', 00:30:49 INFO - 'download-and-extract', 00:30:49 INFO - 'populate-webroot', 00:30:49 INFO - 'create-virtualenv', 00:30:49 INFO - 'install', 00:30:49 INFO - 'run-tests'), 00:30:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:30:49 INFO - 'download_minidump_stackwalk': True, 00:30:49 INFO - 'download_symbols': 'ondemand', 00:30:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:30:49 INFO - 'tooltool.py': '/tools/tooltool.py', 00:30:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:30:49 INFO - '/tools/misc-python/virtualenv.py')}, 00:30:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:30:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:30:49 INFO - 'installer_path': 'installer.exe', 00:30:49 INFO - 'log_level': 'info', 00:30:49 INFO - 'log_name': 'talos', 00:30:49 INFO - 'log_to_console': True, 00:30:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:30:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:30:49 INFO - 'opt_config_files': (), 00:30:49 INFO - 'pip_index': False, 00:30:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:30:49 INFO - 'cmd': ('bash', 00:30:49 INFO - '-c', 00:30:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:30:49 INFO - 'enabled': True, 00:30:49 INFO - 'halt_on_failure': False, 00:30:49 INFO - 'name': 'check_screen_resolution'},), 00:30:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:30:49 INFO - 'cmd': ('bash', 00:30:49 INFO - '-c', 00:30:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:30:49 INFO - 'enabled': True, 00:30:49 INFO - 'halt_on_failure': False, 00:30:49 INFO - 'name': 'check_screen_resolution'},), 00:30:49 INFO - 'run_cmd_checks_enabled': True, 00:30:49 INFO - 'sps_profile': False, 00:30:49 INFO - 'sps_profile_interval': 0, 00:30:49 INFO - 'suite': 'dromaeojs-e10s', 00:30:49 INFO - 'system_bits': '32', 00:30:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:30:49 INFO - 'title': 't-yosemite-r7-0037', 00:30:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:30:49 INFO - 'use_talos_json': True, 00:30:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:30:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:30:49 INFO - 'work_dir': 'build'} 00:30:49 INFO - [mozharness: 2016-09-02 07:30:49.050906Z] Running clobber step. 00:30:49 INFO - Running pre-action listener: _resource_record_pre_action 00:30:49 INFO - Running main action method: clobber 00:30:49 INFO - rmtree: /builds/slave/test/build 00:30:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:30:51 INFO - Running post-action listener: _resource_record_post_action 00:30:51 INFO - [mozharness: 2016-09-02 07:30:51.241590Z] Finished clobber step (success) 00:30:51 INFO - [mozharness: 2016-09-02 07:30:51.241825Z] Running read-buildbot-config step. 00:30:51 INFO - Running pre-action listener: _resource_record_pre_action 00:30:51 INFO - Running main action method: read_buildbot_config 00:30:51 INFO - Using buildbot properties: 00:30:51 INFO - { 00:30:51 INFO - "project": "", 00:30:51 INFO - "product": "firefox", 00:30:51 INFO - "script_repo_revision": "production", 00:30:51 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 00:30:51 INFO - "repository": "", 00:30:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 00:30:51 INFO - "buildid": "20160901215642", 00:30:51 INFO - "pgo_build": "False", 00:30:51 INFO - "basedir": "/builds/slave/test", 00:30:51 INFO - "buildnumber": 108, 00:30:51 INFO - "slavename": "t-yosemite-r7-0037", 00:30:51 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 00:30:51 INFO - "platform": "yosemite_r7", 00:30:51 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 00:30:51 INFO - "branch": "fx-team", 00:30:51 INFO - "repo_path": "integration/fx-team", 00:30:51 INFO - "revision": "4c4ce191fc9b444f1f47272293e001707538c105", 00:30:51 INFO - "stage_platform": "macosx64", 00:30:51 INFO - "builduid": "ad10029f6041452ebb85c5573b0fc16b", 00:30:51 INFO - "slavebuilddir": "test" 00:30:51 INFO - } 00:30:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/VYSpcX1PRzuPiuYgiap7iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 00:30:51 INFO - Running post-action listener: _resource_record_post_action 00:30:51 INFO - [mozharness: 2016-09-02 07:30:51.247558Z] Finished read-buildbot-config step (success) 00:30:51 INFO - [mozharness: 2016-09-02 07:30:51.247738Z] Running download-and-extract step. 00:30:51 INFO - Running pre-action listener: _resource_record_pre_action 00:30:51 INFO - Running main action method: download_and_extract 00:30:51 INFO - mkdir: /builds/slave/test/build/tests 00:30:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:30:51 INFO - trying https://queue.taskcluster.net/v1/task/VYSpcX1PRzuPiuYgiap7iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 00:30:51 INFO - Downloading https://queue.taskcluster.net/v1/task/VYSpcX1PRzuPiuYgiap7iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 00:30:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VYSpcX1PRzuPiuYgiap7iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 00:30:52 INFO - Downloaded 1199 bytes. 00:30:52 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 00:30:52 INFO - Using the following test package requirements: 00:30:52 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 00:30:52 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:30:52 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 00:30:52 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:30:52 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 00:30:52 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:30:52 INFO - u'jsshell-mac.zip'], 00:30:52 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:30:52 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 00:30:52 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 00:30:52 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:30:52 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 00:30:52 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:30:52 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 00:30:52 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:30:52 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 00:30:52 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:30:52 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 00:30:52 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:30:52 INFO - trying https://queue.taskcluster.net/v1/task/VYSpcX1PRzuPiuYgiap7iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 00:30:52 INFO - Downloading https://queue.taskcluster.net/v1/task/VYSpcX1PRzuPiuYgiap7iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 00:30:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VYSpcX1PRzuPiuYgiap7iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:30:53 INFO - Downloaded 16399190 bytes. 00:30:53 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 00:31:00 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 00:31:00 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')]} 00:31:00 INFO - trying https://queue.taskcluster.net/v1/task/VYSpcX1PRzuPiuYgiap7iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 00:31:00 INFO - Downloading https://queue.taskcluster.net/v1/task/VYSpcX1PRzuPiuYgiap7iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 00:31:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VYSpcX1PRzuPiuYgiap7iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:31:01 INFO - Downloaded 16399190 bytes. 00:31:01 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 00:31: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')]} 00:31:07 INFO - trying https://queue.taskcluster.net/v1/task/VYSpcX1PRzuPiuYgiap7iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 00:31:07 INFO - Downloading https://queue.taskcluster.net/v1/task/VYSpcX1PRzuPiuYgiap7iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 00:31:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VYSpcX1PRzuPiuYgiap7iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 00:31:09 INFO - Downloaded 14413998 bytes. 00:31:09 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 00:31:09 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')]} 00:31:09 INFO - trying https://queue.taskcluster.net/v1/task/VYSpcX1PRzuPiuYgiap7iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 00:31:09 INFO - Downloading https://queue.taskcluster.net/v1/task/VYSpcX1PRzuPiuYgiap7iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 00:31:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VYSpcX1PRzuPiuYgiap7iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 00:31:12 INFO - Downloaded 111591868 bytes. 00:31:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VYSpcX1PRzuPiuYgiap7iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 00:31:12 INFO - mkdir: /builds/slave/test/properties 00:31:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:31:12 INFO - Writing to file /builds/slave/test/properties/build_url 00:31:12 INFO - Contents: 00:31:12 INFO - build_url:https://queue.taskcluster.net/v1/task/VYSpcX1PRzuPiuYgiap7iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 00:31:13 INFO - Running post-action listener: _resource_record_post_action 00:31:13 INFO - Running post-action listener: set_extra_try_arguments 00:31:13 INFO - [mozharness: 2016-09-02 07:31:13.004906Z] Finished download-and-extract step (success) 00:31:13 INFO - [mozharness: 2016-09-02 07:31:13.005002Z] Running populate-webroot step. 00:31:13 INFO - Running pre-action listener: _resource_record_pre_action 00:31:13 INFO - Running main action method: populate_webroot 00:31:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:31:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:31:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:31:13 INFO - '--tppagecycles', 00:31:13 INFO - '7'], 00:31:13 INFO - 'tests': ['tsvgm']}}, 00:31:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:31:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:31:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:31:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:31:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:31:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:31:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:31:13 INFO - 'talos_options': ['--disable-e10s'], 00:31:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:31:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:31:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:31:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:31:13 INFO - 'talos_options': ['--disable-e10s'], 00:31:13 INFO - 'tests': ['damp', 'tps']}, 00:31:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:31:13 INFO - 'tests': ['damp', 'tps']}, 00:31:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:31:13 INFO - 'tests': ['dromaeo_dom']}, 00:31:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:31:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:31:13 INFO - 'tests': ['basic_compositor_video']}, 00:31:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:31:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:31:13 INFO - 'tests': ['a11yr', 00:31:13 INFO - 'ts_paint', 00:31:13 INFO - 'tpaint', 00:31:13 INFO - 'sessionrestore', 00:31:13 INFO - 'sessionrestore_no_auto_restore', 00:31:13 INFO - 'tabpaint']}, 00:31:13 INFO - 'other-e10s': {'tests': ['a11yr', 00:31:13 INFO - 'ts_paint', 00:31:13 INFO - 'tpaint', 00:31:13 INFO - 'sessionrestore', 00:31:13 INFO - 'sessionrestore_no_auto_restore', 00:31:13 INFO - 'tabpaint']}, 00:31:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:31:13 INFO - 'ts_paint', 00:31:13 INFO - 'tpaint', 00:31:13 INFO - 'sessionrestore', 00:31:13 INFO - 'sessionrestore_no_auto_restore', 00:31:13 INFO - 'tabpaint']}, 00:31:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:31:13 INFO - 'ts_paint', 00:31:13 INFO - 'tpaint', 00:31:13 INFO - 'sessionrestore', 00:31:13 INFO - 'sessionrestore_no_auto_restore', 00:31:13 INFO - 'tabpaint']}, 00:31:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:31:13 INFO - 'tests': ['a11yr', 00:31:13 INFO - 'ts_paint', 00:31:13 INFO - 'tpaint', 00:31:13 INFO - 'sessionrestore', 00:31:13 INFO - 'sessionrestore_no_auto_restore', 00:31:13 INFO - 'tabpaint']}, 00:31:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:31:13 INFO - 'tests': ['a11yr', 00:31:13 INFO - 'ts_paint', 00:31:13 INFO - 'tpaint', 00:31:13 INFO - 'sessionrestore', 00:31:13 INFO - 'sessionrestore_no_auto_restore', 00:31:13 INFO - 'tabpaint']}, 00:31:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:31:13 INFO - 'tests': ['tsvgx', 00:31:13 INFO - 'tsvgr_opacity', 00:31:13 INFO - 'tart', 00:31:13 INFO - 'tscrollx', 00:31:13 INFO - 'cart']}, 00:31:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:31:13 INFO - 'tsvgr_opacity', 00:31:13 INFO - 'tart', 00:31:13 INFO - 'tscrollx', 00:31:13 INFO - 'cart']}, 00:31:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:31:13 INFO - 'talos_options': ['--disable-e10s'], 00:31:13 INFO - 'tests': ['tp5o']}, 00:31:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:31:13 INFO - 'tests': ['tp5o']}, 00:31:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:31:13 INFO - 'talos_options': ['--disable-e10s', 00:31:13 INFO - '--xperf_path', 00:31:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:31:13 INFO - 'tests': ['tp5n']}, 00:31:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:31:13 INFO - 'talos_options': ['--xperf_path', 00:31:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:31:13 INFO - 'tests': ['tp5n']}}, 00:31:13 INFO - 'talos.zip': {'path': '', 00:31:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:31:13 INFO - Running post-action listener: _resource_record_post_action 00:31:13 INFO - [mozharness: 2016-09-02 07:31:13.023605Z] Finished populate-webroot step (success) 00:31:13 INFO - [mozharness: 2016-09-02 07:31:13.023736Z] Running create-virtualenv step. 00:31:13 INFO - Running pre-action listener: _resource_record_pre_action 00:31:13 INFO - Running main action method: create_virtualenv 00:31:13 INFO - Creating virtualenv /builds/slave/test/build/venv 00:31:13 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 00:31:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:31:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:31:13 INFO - Using real prefix '/tools/python27' 00:31:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:31:13 INFO - Installing distribute.............................................................................................................................................................................................done. 00:31:16 INFO - Installing pip.................done. 00:31:16 INFO - Return code: 0 00:31:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:31:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:31:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:31:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:31:16 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 0x10b7b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b84a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d7acabe60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b719d30>, '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 0x10b47edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b711b20>, '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.7qxgP4AvJV/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.ifKWcFtJh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 00:31:16 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 00:31:16 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 00:31:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7qxgP4AvJV/Render', 00:31:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:31:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:31:16 INFO - 'HOME': '/Users/cltbld', 00:31:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:31:16 INFO - 'LOGNAME': 'cltbld', 00:31:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:31:16 INFO - 'MOZ_NO_REMOTE': '1', 00:31:16 INFO - 'NO_EM_RESTART': '1', 00:31:16 INFO - 'PAGER': '/bin/cat', 00:31:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:31:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:31:16 INFO - 'PWD': '/builds/slave/test', 00:31:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:31:16 INFO - 'SHELL': '/bin/bash', 00:31:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifKWcFtJh2/Listeners', 00:31:16 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 00:31:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:31:16 INFO - 'USER': 'cltbld', 00:31:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:31:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:31:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:31:16 INFO - 'XPC_FLAGS': '0x0', 00:31:16 INFO - 'XPC_SERVICE_NAME': '0', 00:31:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:31:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:31:17 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 00:31:17 INFO - Cleaning up... 00:31:17 INFO - Return code: 0 00:31:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:31:17 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')]} 00:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:31:17 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')]} 00:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:31:17 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 0x10b7b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b84a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d7acabe60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b719d30>, '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 0x10b47edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b711b20>, '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.7qxgP4AvJV/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.ifKWcFtJh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 00:31:17 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 00:31:17 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 00:31:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7qxgP4AvJV/Render', 00:31:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:31:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:31:17 INFO - 'HOME': '/Users/cltbld', 00:31:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:31:17 INFO - 'LOGNAME': 'cltbld', 00:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:31:17 INFO - 'MOZ_NO_REMOTE': '1', 00:31:17 INFO - 'NO_EM_RESTART': '1', 00:31:17 INFO - 'PAGER': '/bin/cat', 00:31:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:31:17 INFO - 'PWD': '/builds/slave/test', 00:31:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:31:17 INFO - 'SHELL': '/bin/bash', 00:31:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifKWcFtJh2/Listeners', 00:31:17 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 00:31:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:31:17 INFO - 'USER': 'cltbld', 00:31:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:31:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:31:17 INFO - 'XPC_FLAGS': '0x0', 00:31:17 INFO - 'XPC_SERVICE_NAME': '0', 00:31:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:31:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:31:17 INFO - Downloading/unpacking psutil>=3.1.1 00:31: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 00:31: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 00:31: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 00:31: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 00:31: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 00:31: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 00:31:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:31:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:31:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:31:20 INFO - Installing collected packages: psutil 00:31:20 INFO - Running setup.py install for psutil 00:31:20 INFO - building 'psutil._psutil_osx' extension 00:31:20 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 00:31:20 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 00:31:21 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 00:31:21 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 00:31:21 INFO - building 'psutil._psutil_posix' extension 00:31:21 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 00:31:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:31:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:31:21 INFO - ^ 00:31:21 INFO - 1 warning generated. 00:31:21 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 00:31:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:31:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:31:21 INFO - Successfully installed psutil 00:31:21 INFO - Cleaning up... 00:31:21 INFO - Return code: 0 00:31:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:31:21 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')]} 00:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:31:21 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')]} 00:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:31:21 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 0x10b7b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b84a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d7acabe60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b719d30>, '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 0x10b47edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b711b20>, '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.7qxgP4AvJV/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.ifKWcFtJh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 00:31:21 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 00:31:21 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 00:31:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7qxgP4AvJV/Render', 00:31:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:31:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:31:21 INFO - 'HOME': '/Users/cltbld', 00:31:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:31:21 INFO - 'LOGNAME': 'cltbld', 00:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:31:21 INFO - 'MOZ_NO_REMOTE': '1', 00:31:21 INFO - 'NO_EM_RESTART': '1', 00:31:21 INFO - 'PAGER': '/bin/cat', 00:31:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:31:21 INFO - 'PWD': '/builds/slave/test', 00:31:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:31:21 INFO - 'SHELL': '/bin/bash', 00:31:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifKWcFtJh2/Listeners', 00:31:21 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 00:31:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:31:21 INFO - 'USER': 'cltbld', 00:31:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:31:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:31:21 INFO - 'XPC_FLAGS': '0x0', 00:31:21 INFO - 'XPC_SERVICE_NAME': '0', 00:31:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:31:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:31: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 00:31: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 00:31: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 00:31: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 00:31: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 00:31: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 00:31:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:31:24 INFO - Installing collected packages: mozsystemmonitor 00:31:24 INFO - Running setup.py install for mozsystemmonitor 00:31:24 INFO - Successfully installed mozsystemmonitor 00:31:24 INFO - Cleaning up... 00:31:24 INFO - Return code: 0 00:31:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:31:24 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')]} 00:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:31:24 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')]} 00:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:31:24 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 0x10b7b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b84a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d7acabe60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b719d30>, '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 0x10b47edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b711b20>, '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.7qxgP4AvJV/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.ifKWcFtJh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 00:31:24 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 00:31:24 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 00:31:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7qxgP4AvJV/Render', 00:31:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:31:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:31:24 INFO - 'HOME': '/Users/cltbld', 00:31:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:31:24 INFO - 'LOGNAME': 'cltbld', 00:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:31:24 INFO - 'MOZ_NO_REMOTE': '1', 00:31:24 INFO - 'NO_EM_RESTART': '1', 00:31:24 INFO - 'PAGER': '/bin/cat', 00:31:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:31:24 INFO - 'PWD': '/builds/slave/test', 00:31:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:31:24 INFO - 'SHELL': '/bin/bash', 00:31:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifKWcFtJh2/Listeners', 00:31:24 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 00:31:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:31:24 INFO - 'USER': 'cltbld', 00:31:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:31:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:31:24 INFO - 'XPC_FLAGS': '0x0', 00:31:24 INFO - 'XPC_SERVICE_NAME': '0', 00:31:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:31:24 INFO - Downloading/unpacking jsonschema==2.5.1 00:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:31:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:31:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:31:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:31:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:31:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:31:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:31:27 INFO - Downloading functools32-3.2.3-2.tar.gz 00:31:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:31:27 INFO - warning: no files found matching '*.txt' 00:31:27 INFO - no previously-included directories found matching 'build' 00:31:27 INFO - no previously-included directories found matching 'dist' 00:31:27 INFO - no previously-included directories found matching '.git*' 00:31:27 INFO - Installing collected packages: jsonschema, functools32 00:31:27 INFO - Running setup.py install for functools32 00:31:27 INFO - warning: no files found matching '*.txt' 00:31:27 INFO - no previously-included directories found matching 'build' 00:31:27 INFO - no previously-included directories found matching 'dist' 00:31:27 INFO - no previously-included directories found matching '.git*' 00:31:27 INFO - Successfully installed jsonschema functools32 00:31:27 INFO - Cleaning up... 00:31:28 INFO - Return code: 0 00:31:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:31: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')]} 00:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:31:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:31: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')]} 00:31:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:31:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:31:28 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 0x10b7b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b84a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d7acabe60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b719d30>, '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 0x10b47edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b711b20>, '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.7qxgP4AvJV/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.ifKWcFtJh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 00:31:28 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 00:31:28 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 00:31:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7qxgP4AvJV/Render', 00:31:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:31:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:31:28 INFO - 'HOME': '/Users/cltbld', 00:31:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:31:28 INFO - 'LOGNAME': 'cltbld', 00:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:31:28 INFO - 'MOZ_NO_REMOTE': '1', 00:31:28 INFO - 'NO_EM_RESTART': '1', 00:31:28 INFO - 'PAGER': '/bin/cat', 00:31:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:31:28 INFO - 'PWD': '/builds/slave/test', 00:31:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:31:28 INFO - 'SHELL': '/bin/bash', 00:31:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifKWcFtJh2/Listeners', 00:31:28 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 00:31:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:31:28 INFO - 'USER': 'cltbld', 00:31:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:31:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:31:28 INFO - 'XPC_FLAGS': '0x0', 00:31:28 INFO - 'XPC_SERVICE_NAME': '0', 00:31:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:31:28 INFO - Cleaning up... 00:31:28 INFO - Return code: 0 00:31:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:31: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')]} 00:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:31:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:31: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')]} 00:31:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:31:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:31:28 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 0x10b7b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b84a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d7acabe60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b719d30>, '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 0x10b47edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b711b20>, '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.7qxgP4AvJV/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.ifKWcFtJh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 00:31:28 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 00:31:28 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 00:31:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7qxgP4AvJV/Render', 00:31:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:31:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:31:28 INFO - 'HOME': '/Users/cltbld', 00:31:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:31:28 INFO - 'LOGNAME': 'cltbld', 00:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:31:28 INFO - 'MOZ_NO_REMOTE': '1', 00:31:28 INFO - 'NO_EM_RESTART': '1', 00:31:28 INFO - 'PAGER': '/bin/cat', 00:31:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:31:28 INFO - 'PWD': '/builds/slave/test', 00:31:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:31:28 INFO - 'SHELL': '/bin/bash', 00:31:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifKWcFtJh2/Listeners', 00:31:28 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 00:31:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:31:28 INFO - 'USER': 'cltbld', 00:31:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:31:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:31:28 INFO - 'XPC_FLAGS': '0x0', 00:31:28 INFO - 'XPC_SERVICE_NAME': '0', 00:31:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:31:28 INFO - Downloading/unpacking blobuploader==1.2.4 00:31:28 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 00:31:28 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 00:31:28 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 00:31:28 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 00:31:28 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 00:31:28 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 00:31:31 INFO - Downloading blobuploader-1.2.4.tar.gz 00:31:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:31:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:31:31 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 00:31:31 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 00:31:31 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 00:31:31 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 00:31:31 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 00:31:31 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 00:31:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:31:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:31:31 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 00:31:31 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 00:31:31 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 00:31:31 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 00:31:31 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 00:31:31 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 00:31:32 INFO - Downloading docopt-0.6.1.tar.gz 00:31:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:31:32 INFO - Installing collected packages: blobuploader, requests, docopt 00:31:32 INFO - Running setup.py install for blobuploader 00:31:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:31:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:31:32 INFO - Running setup.py install for requests 00:31:33 INFO - Running setup.py install for docopt 00:31:33 INFO - Successfully installed blobuploader requests docopt 00:31:33 INFO - Cleaning up... 00:31:33 INFO - Return code: 0 00:31:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:31: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')]} 00:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:31: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')]} 00:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:31:33 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 0x10b7b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b84a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d7acabe60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b719d30>, '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 0x10b47edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b711b20>, '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.7qxgP4AvJV/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.ifKWcFtJh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 00:31:33 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 00:31:33 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 00:31:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7qxgP4AvJV/Render', 00:31:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:31:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:31:33 INFO - 'HOME': '/Users/cltbld', 00:31:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:31:33 INFO - 'LOGNAME': 'cltbld', 00:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:31:33 INFO - 'MOZ_NO_REMOTE': '1', 00:31:33 INFO - 'NO_EM_RESTART': '1', 00:31:33 INFO - 'PAGER': '/bin/cat', 00:31:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:31:33 INFO - 'PWD': '/builds/slave/test', 00:31:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:31:33 INFO - 'SHELL': '/bin/bash', 00:31:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifKWcFtJh2/Listeners', 00:31:33 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 00:31:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:31:33 INFO - 'USER': 'cltbld', 00:31:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:31:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:31:33 INFO - 'XPC_FLAGS': '0x0', 00:31:33 INFO - 'XPC_SERVICE_NAME': '0', 00:31:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:31:33 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-rnd_WO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:31:33 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-wFfs6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:31:33 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-41yEq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:31:33 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-rFLY_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:31:33 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-TbkiSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:31:34 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-NlEwZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:31:34 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-5Zq0SD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:31:34 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-VDzhu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:31:34 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-AC8SRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:31:34 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-PBsIp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:31:34 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-kVD6Xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:31:34 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-w8zYro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:31:34 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-ewHWMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:31:34 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-pjUlGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:31:34 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-DnUdaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:31:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-oMT_vG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:31:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-NDmoof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:31:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:31:35 INFO - Running setup.py install for manifestparser 00:31:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:31:35 INFO - Running setup.py install for mozcrash 00:31:35 INFO - Running setup.py install for mozdebug 00:31:35 INFO - Running setup.py install for mozdevice 00:31:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:31:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:31:35 INFO - Running setup.py install for mozfile 00:31:36 INFO - Running setup.py install for mozhttpd 00:31:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:31:36 INFO - Running setup.py install for mozinfo 00:31:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:31:36 INFO - Running setup.py install for mozInstall 00:31:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:31:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:31:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:31:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:31:36 INFO - Running setup.py install for mozleak 00:31:36 INFO - Running setup.py install for mozlog 00:31:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:31:36 INFO - Running setup.py install for moznetwork 00:31:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:31:36 INFO - Running setup.py install for mozprocess 00:31:37 INFO - Running setup.py install for mozprofile 00:31:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:31:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:31:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:31:37 INFO - Running setup.py install for mozrunner 00:31:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:31:37 INFO - Running setup.py install for mozscreenshot 00:31:37 INFO - Running setup.py install for moztest 00:31:37 INFO - Running setup.py install for mozversion 00:31:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:31:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:31:37 INFO - Cleaning up... 00:31:37 INFO - Return code: 0 00:31:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:31:37 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')]} 00:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:31:37 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')]} 00:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:31:37 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 0x10b7b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b84a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d7acabe60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b719d30>, '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 0x10b47edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b711b20>, '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.7qxgP4AvJV/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.ifKWcFtJh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 00:31:37 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 00:31:37 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 00:31:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7qxgP4AvJV/Render', 00:31:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:31:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:31:37 INFO - 'HOME': '/Users/cltbld', 00:31:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:31:37 INFO - 'LOGNAME': 'cltbld', 00:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:31:37 INFO - 'MOZ_NO_REMOTE': '1', 00:31:37 INFO - 'NO_EM_RESTART': '1', 00:31:37 INFO - 'PAGER': '/bin/cat', 00:31:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:31:37 INFO - 'PWD': '/builds/slave/test', 00:31:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:31:37 INFO - 'SHELL': '/bin/bash', 00:31:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifKWcFtJh2/Listeners', 00:31:37 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 00:31:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:31:37 INFO - 'USER': 'cltbld', 00:31:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:31:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:31:37 INFO - 'XPC_FLAGS': '0x0', 00:31:37 INFO - 'XPC_SERVICE_NAME': '0', 00:31:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:31:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-wEzBb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:31:38 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)) 00:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:31:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-XPeSek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:31:38 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)) 00:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:31:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-WD9BFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:31:38 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)) 00:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:31:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-aP5J6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:31:38 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)) 00:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:31:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-z82NkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:31:38 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)) 00:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:31:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-5IFObg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:31:38 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)) 00:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:31:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-BEpber-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:31:38 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)) 00:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:31:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-pg3dbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:31:38 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)) 00:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:31:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-R2pXot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:31:39 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)) 00:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:31:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-fngEo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 00:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:31:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-B7K3nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:31:39 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)) 00:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:31:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-evidzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:31:39 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)) 00:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:31:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-ZyZWrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:31:39 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)) 00:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:31:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-gjcfzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:31:39 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)) 00:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:31:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Vy6x_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:31:39 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)) 00:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:31:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-ZPOPt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:31:39 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)) 00:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:31:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-kVNNl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:31:39 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)) 00:31:39 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)) 00:31:39 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)) 00:31:39 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)) 00:31:39 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)) 00:31:39 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)) 00:31:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:31:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:31:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:31:42 INFO - Downloading blessings-1.6.tar.gz 00:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:31:42 INFO - Installing collected packages: blessings 00:31:42 INFO - Running setup.py install for blessings 00:31:42 INFO - Successfully installed blessings 00:31:42 INFO - Cleaning up... 00:31:42 INFO - Return code: 0 00:31:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:31:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:31:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:31:43 INFO - Reading from file tmpfile_stdout 00:31:43 INFO - Current package versions: 00:31:43 INFO - blessings == 1.6 00:31:43 INFO - blobuploader == 1.2.4 00:31:43 INFO - docopt == 0.6.1 00:31:43 INFO - functools32 == 3.2.3-2 00:31:43 INFO - jsonschema == 2.5.1 00:31:43 INFO - manifestparser == 1.1 00:31:43 INFO - mozInstall == 1.12 00:31:43 INFO - mozcrash == 0.17 00:31:43 INFO - mozdebug == 0.1 00:31:43 INFO - mozdevice == 0.48 00:31:43 INFO - mozfile == 1.2 00:31:43 INFO - mozhttpd == 0.7 00:31:43 INFO - mozinfo == 0.9 00:31:43 INFO - mozleak == 0.1 00:31:43 INFO - mozlog == 3.3 00:31:43 INFO - moznetwork == 0.27 00:31:43 INFO - mozprocess == 0.23 00:31:43 INFO - mozprofile == 0.28 00:31:43 INFO - mozrunner == 6.12 00:31:43 INFO - mozscreenshot == 0.1 00:31:43 INFO - mozsystemmonitor == 0.3 00:31:43 INFO - moztest == 0.7 00:31:43 INFO - mozversion == 1.4 00:31:43 INFO - psutil == 3.1.1 00:31:43 INFO - requests == 1.2.3 00:31:43 INFO - wsgiref == 0.1.2 00:31:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:31:43 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')]} 00:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:31:43 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')]} 00:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:31:43 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 0x10b7b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b84a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d7acabe60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b719d30>, '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 0x10b47edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b711b20>, '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.7qxgP4AvJV/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.ifKWcFtJh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 00:31:43 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 00:31:43 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 00:31:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7qxgP4AvJV/Render', 00:31:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:31:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:31:43 INFO - 'HOME': '/Users/cltbld', 00:31:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:31:43 INFO - 'LOGNAME': 'cltbld', 00:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:31:43 INFO - 'MOZ_NO_REMOTE': '1', 00:31:43 INFO - 'NO_EM_RESTART': '1', 00:31:43 INFO - 'PAGER': '/bin/cat', 00:31:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:31:43 INFO - 'PWD': '/builds/slave/test', 00:31:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:31:43 INFO - 'SHELL': '/bin/bash', 00:31:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifKWcFtJh2/Listeners', 00:31:43 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 00:31:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:31:43 INFO - 'USER': 'cltbld', 00:31:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:31:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:31:43 INFO - 'XPC_FLAGS': '0x0', 00:31:43 INFO - 'XPC_SERVICE_NAME': '0', 00:31:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:31:43 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)) 00:31:43 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)) 00:31:43 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)) 00:31:43 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)) 00:31:43 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)) 00:31:43 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)) 00:31:43 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)) 00:31:43 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)) 00:31:43 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)) 00:31:43 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)) 00:31:43 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)) 00:31:43 INFO - Cleaning up... 00:31:43 INFO - Return code: 0 00:31:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:31:43 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')]} 00:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:31:43 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')]} 00:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:31:43 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 0x10b7b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b84a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d7acabe60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b719d30>, '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 0x10b47edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b711b20>, '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.7qxgP4AvJV/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.ifKWcFtJh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 00:31:43 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 00:31:43 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 00:31:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7qxgP4AvJV/Render', 00:31:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:31:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:31:43 INFO - 'HOME': '/Users/cltbld', 00:31:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:31:43 INFO - 'LOGNAME': 'cltbld', 00:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:31:43 INFO - 'MOZ_NO_REMOTE': '1', 00:31:43 INFO - 'NO_EM_RESTART': '1', 00:31:43 INFO - 'PAGER': '/bin/cat', 00:31:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:31:43 INFO - 'PWD': '/builds/slave/test', 00:31:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:31:43 INFO - 'SHELL': '/bin/bash', 00:31:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifKWcFtJh2/Listeners', 00:31:43 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 00:31:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:31:43 INFO - 'USER': 'cltbld', 00:31:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:31:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:31:43 INFO - 'XPC_FLAGS': '0x0', 00:31:43 INFO - 'XPC_SERVICE_NAME': '0', 00:31:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:31:43 INFO - Cleaning up... 00:31:43 INFO - Return code: 0 00:31:43 INFO - Running post-action listener: _resource_record_post_action 00:31:43 INFO - Running post-action listener: _start_resource_monitoring 00:31:43 INFO - Starting resource monitoring. 00:31:43 INFO - [mozharness: 2016-09-02 07:31:43.635347Z] Finished create-virtualenv step (success) 00:31:43 INFO - [mozharness: 2016-09-02 07:31:43.636344Z] Running install step. 00:31:43 INFO - Running pre-action listener: _resource_record_pre_action 00:31:43 INFO - Running main action method: install 00:31:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:31:43 INFO - Reading from file tmpfile_stdout 00:31:43 INFO - Detecting whether we're running mozinstall >=1.0... 00:31:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:31:44 INFO - Reading from file tmpfile_stdout 00:31:44 INFO - Output received: 00:31:44 INFO - Usage: mozinstall [options] installer 00:31:44 INFO - Options: 00:31:44 INFO - -h, --help show this help message and exit 00:31:44 INFO - -d DEST, --destination=DEST 00:31:44 INFO - Directory to install application into. [default: 00:31:44 INFO - "/builds/slave/test"] 00:31:44 INFO - --app=APP Application being installed. [default: firefox] 00:31:44 INFO - mkdir: /builds/slave/test/build/application 00:31:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 00:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 00:32:17 INFO - Reading from file tmpfile_stdout 00:32:17 INFO - Output received: 00:32:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:32:17 INFO - Running post-action listener: _resource_record_post_action 00:32:17 INFO - [mozharness: 2016-09-02 07:32:17.989463Z] Finished install step (success) 00:32:17 INFO - [mozharness: 2016-09-02 07:32:17.989591Z] Running run-tests step. 00:32:17 INFO - Running pre-action listener: _resource_record_pre_action 00:32:17 INFO - Running main action method: run_tests 00:32:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:32:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:32:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:32:18 INFO - 2016-09-02 00:32:18.004 screenresolution[1644:7601] starting screenresolution argv=screenresolution get 00:32:18 INFO - 2016-09-02 00:32:18.006 screenresolution[1644:7601] Display 0: 1600x1200x32@60 00:32:18 INFO - 2016-09-02 00:32:18.012 screenresolution[1645:7603] starting screenresolution argv=screenresolution list 00:32:18 INFO - Available Modes on Display 0 00:32:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:32:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:32:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:32:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:32:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:32:18 INFO - Intel Iris: 00:32:18 INFO - Chipset Model: Intel Iris 00:32:18 INFO - Type: GPU 00:32:18 INFO - Bus: Built-In 00:32:18 INFO - VRAM (Dynamic, Max): 1536 MB 00:32:18 INFO - Vendor: Intel (0x8086) 00:32:18 INFO - Device ID: 0x0a2e 00:32:18 INFO - Revision ID: 0x0009 00:32:18 INFO - Displays: 00:32:18 INFO - Display: 00:32:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:32:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:32:18 INFO - Display Serial Number: 1600x1200 60 00:32:18 INFO - Main Display: Yes 00:32:18 INFO - Mirror: Off 00:32:18 INFO - Online: Yes 00:32:18 INFO - Rotation: Supported 00:32:18 INFO - Return code: 0 00:32:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:32:18 INFO - Python 2.7.3 00:32:18 INFO - Return code: 0 00:32:18 INFO - grabbing minidump binary from tooltool 00:32: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')]} 00:32:18 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 0x10b719d30>, '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 0x10b47edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b711b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:32:18 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 00:32:18 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 00:32:18 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 00:32:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:32:18 INFO - Return code: 0 00:32:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:32:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:32:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:32:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:32:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:32:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VYSpcX1PRzuPiuYgiap7iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 00:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VYSpcX1PRzuPiuYgiap7iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 00:32:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7qxgP4AvJV/Render', 00:32:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:32:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:32:18 INFO - 'HOME': '/Users/cltbld', 00:32:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:32:18 INFO - 'LOGNAME': 'cltbld', 00:32:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:32:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:32:18 INFO - 'MOZ_NO_REMOTE': '1', 00:32:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:32:18 INFO - 'NO_EM_RESTART': '1', 00:32:18 INFO - 'PAGER': '/bin/cat', 00:32:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:32:18 INFO - 'PWD': '/builds/slave/test', 00:32:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:32:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:32:18 INFO - 'SHELL': '/bin/bash', 00:32:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifKWcFtJh2/Listeners', 00:32:18 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 00:32:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:32:18 INFO - 'USER': 'cltbld', 00:32:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:32:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:32:18 INFO - 'XPC_FLAGS': '0x0', 00:32:18 INFO - 'XPC_SERVICE_NAME': '0', 00:32:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:32:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VYSpcX1PRzuPiuYgiap7iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 00:32:18 INFO - mozversion application_buildid: 20160901215642 00:32:18 INFO - mozversion application_changeset: 4c4ce191fc9b444f1f47272293e001707538c105 00:32:18 INFO - mozversion application_display_name: Nightly 00:32:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:32:18 INFO - mozversion application_name: Firefox 00:32:18 INFO - mozversion application_remotingname: firefox 00:32:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:32:18 INFO - mozversion application_vendor: Mozilla 00:32:18 INFO - mozversion application_version: 51.0a1 00:32:18 INFO - mozversion platform_buildid: 20160901215642 00:32:18 INFO - mozversion platform_changeset: 4c4ce191fc9b444f1f47272293e001707538c105 00:32:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:32:18 INFO - mozversion platform_version: 51.0a1 00:32:18 INFO - using testdate: 1472801538 00:32:18 INFO - actual date: 1472801538 00:32:18 INFO - starting webserver on 'localhost:49267' 00:32:18 INFO - SUITE-START | Running 2 tests 00:32:18 INFO - TEST-START | dromaeo_css 00:32:18 INFO - operating with platform_type : mac_ 00:32:18 INFO - Initialising browser for dromaeo_css test... 00:32:18 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpnDfSSX/profile http://localhost:49267/getInfo.html) 00:32:21 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 00:32:21 INFO - PROCESS | 1655 | colorDepth:24 00:32:21 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 00:32:21 INFO - PROCESS | 1655 | __metrics 00:32:21 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 00:32:22 INFO - TEST-INFO | 1655: exit 0 00:32:22 INFO - Browser initialized. 00:32:22 INFO - Running cycle 1/1 for dromaeo_css test... 00:32:22 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpnDfSSX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:32:34 INFO - PROCESS | 1658 | RSS: Main: 245227520 00:32:34 INFO - PROCESS | 1658 | 00:33:24 INFO - PROCESS | 1658 | 1472801604066 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] 00:35:35 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 00:35:37 INFO - PROCESS | 1658 | RSS: Main: 269713408 00:35:37 INFO - PROCESS | 1658 | 00:38:40 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 00:38:40 INFO - PROCESS | 1658 | RSS: Main: 276361216 00:38:40 INFO - PROCESS | 1658 | 00:41:42 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 00:41:43 INFO - PROCESS | 1658 | RSS: Main: 276684800 00:41:43 INFO - PROCESS | 1658 | 00:44:45 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 00:44:45 INFO - PROCESS | 1658 | RSS: Main: 271257600 00:44:45 INFO - PROCESS | 1658 | 00:47:48 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 00:47:49 INFO - PROCESS | 1658 | RSS: Main: 277671936 00:47:49 INFO - PROCESS | 1658 | 00:50:52 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 00:50:52 INFO - PROCESS | 1658 | RSS: Main: 280494080 00:50:52 INFO - PROCESS | 1658 | 00:50:52 INFO - PROCESS | 1658 | __start_tp_report 00:50:52 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 00:50:52 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 00:50:52 INFO - PROCESS | 1658 | |i|pagename|runs| 00:50:52 INFO - PROCESS | 1658 | |0;dojo.html;2824.3645179834534;3056.617922759655;3366.107981384932;3375.2574433624595;3395.8811441599532;4574.153781550412;5683.516901063409;5684.4315568443135;5748.712564371785;5765.827025189251;5551.2228288039605;5683.54531637468;5702.230198923144;5720.6567605943565;5726.885462290762;5198.934218485201;5204.219367094928;5283.524482796547;5301.045811753902;5353.250544923714;5221.164613661815;5343.1985202219785;5391.24522566839;5434.212039254306;5434.3207099112615;5122.641415100945;5176.7575781812475;5211.817586384458;5227.817026404057;5241.528262456378;5209.635325527214;5235.476452354734;5245.763940622681;5256.579473642099;5279.894402111975;5127.051495473312;5222.4255331913455;5222.686638801646;5237.554807841338;5262.710550919736;4118.91762164755;5637.126245431965;5710.77156913723;5722.799702010451;5726.284214473191;5158.896822063538;6167.537434692371;6201.9689901550655;6206.6586337751405;6250.031245157008;6223.315435302113;6232;6232.501399888043;6249.5625306228585;6261.405166509175;5708.743106560215;5777.19119323295;5835.503982161521;5842.883142337215;5848.795292164754;6254.781082662085;6257.09272155544;6262.812115636538;6265.27949285838;6268.968655156695;6092.969535152296;6103.572749907464;6126.050462178369;6130.938690613126;6136.754529818846;6098.115773212948;6134.386561343919;6145.354737752472;6152.107944348045;6155.322914479404;6162.568620196633;6194.225721784777;6217.067439884054;6225.190725205694;6228.719707613168;6198.845028874314;6215.192025036807;6229.875402491924;6236.095766113979;6237.313895471494;4134.193832202752;4593.19619066662;4928.556429921253;4962.5533701967;5069.087564238473;4412.139632771643;4480.910381792346;4481.775911204427;4490.887727806766;4516.954830451719;5653.491185793298;5703.971480142655;5791.0734282514595;5810.854728631818;5840.269966254218;6066.545009124334;6131.896637733196;6159.353267906895;6165.290991535941;6201.720922558406;5823.126531020381;5827.009408400582;5839.9124013139835;5851.473367396955;5867.471927526458;4908.509149085063;5308.973455132699;5472.972635136878;5480.945190548123;5484.341878974469;6164.6917654117115;6190.907136393048;6224.439800417984;6226.3151053385;6341.8097457076365;5081.593472522263;5204.583633309402;5232.790688372423;6220.253569571681;6254.343293954069;5323.707196104251;5425.810096646598;6282.246130464374;6285.905711414241;6332.145160403286;6088.452039316483;6107.492261292593;6118.60229085108;6142.416470435302;6174.660393678211;5449.2371068049715;5685.431456854281;6139.785107521216;6185.8144255672405;6189.96905015472;6120.326764056039;6140.877182456236;6147.262328520606;6158.076288556752;6178.9382106180165;5997.520198384206;6076.210092688099;6103.267607887082;6142.78500252489;6286.245650521967;4139.461869956886;5878.647281163144;5925.585209035326;6015.338312785502;6037.516998640186;6098.692995388594;6113.871604717183;6118.20463339763;6132.63204207749;6139.676133582418;6037;6045.576809623284;6060.303065147565;6064.3026052002815;6104.38956104386 00:50:52 INFO - PROCESS | 1658 | |1;ext.html;487.72443569383273;488.98777530561756;502.49750249750247;525.0994544356428;541.2125357604685;33463.498047529276;36694.63305366946;38928.80535597325;38947.41578876312;38998.22003559927;26684;40645.39031914516;40656.39015414764;40767.388489172685;40799.592004079954;8837;9224.815503689939;9939.055789699967;9939.254555908336;9967.906739584696;9714.465704386255;9770.413775173476;9796.559154838014;9820.803583928317;9832.705018849447;9749.756256093584;9842.163416109603;9850.064243896819;9862.161716254128;9864.90135098647;9787.706368808947;9788.804223915517;9800.31397802154;9821.116099551075;9823.410595364301;9736;9837.409755414626;9858.65494707689;9877;9888.110070093726;38950.415743763864;39169;39230;39271.60728392737;39332;3410.4202285611505;3552.7335449841366;3592.9820350898076;3955.1694144229746;4186.016286172747;30036.399272014438;30107.849460752557;30261.848690756626;30740.924067657525;30778;3189.3142974260413;3271.656476070026;3319.3029463812386;3366.7138293245102;3377.7128944039787;441398;441847;445613.99999999674;446628;452919;54974.90050198974;55820.92984885789;56168.15747763787;56376;56427.71786141125;58353;58398.708006459696;58430;58701.41298587045;59381.70309148427;15880.60298492547;16069.196540172945;16069.35722571084;16084.839151608568;16115.871888967895;12522.874771252353;12565.93717031409;12586.81119783204;12670;12677.049221308254;14672.853271467362;15137.772933406008;15255.466058687893;15266.236688165547;15358.385664573516;6403.871922561522;6482.643454610042;6524.217093948661;6563.934360656428;6602.86794264112;814.2630919018297;829.0176141272611;831.3806214370212;958.7603099225194;1019.5106348952544;25114.372140696265;25135.371615709755;29935.70064299373;29967.850160749058;30167.547486787716;960.9615615375446;993.2103977338033;1052.2686732720838;1091.5360971587202;1131.2533727739817;12364;14861.92569037148;15526.378944842305;15541.766873496907;15832.28754706041;499824;605513;609516;610093;612456;55631.16553251704;55669;55816.44183558112;56044;56411;1331.9667008324675;1360.816289800884;1375.3535838156051;1381.7720076187315;1386.2029333133287;28790.42419151647;29388.85305573544;29521.409571808013;30180.69819301779;30203.244918876324;47667.76166119147;47905.52094479011;47910.76044619754;48085.5191448081;48237.758811207124;417772;419161;420478;424669;490116;25517.87241063783;25827.870860645577;25869.353266168495;25878.741212588386;26003.349916252246;45757.54242457666;46647.30029049635;46845.828854278916;46931.53068469271;47008.764956175;37601;38160.427593586675;38318.97650746743;38824;38987;32490.375481225372;35128.47307290444;37541.43687844739;37870.62129378671;39029.41455878107;33689.15777105592;37461.43807842939;38398.77613462461;38478.80760596179;39518.01204969899;30448;34059.65940340565;34070.318593628486;34132;34143.31713365669;22179.89100544934;23187.6521852169;24629;24782.876085619457;25257.242282731546 00:50:52 INFO - PROCESS | 1658 | |2;jquery.html;359.90822340303225;379.3001911473332;380.12760714161;386.777602878345;402.2799189450883;15696.529104126867;19601.901990490045;19922;21157.471063223427;21392.89303553484;19668.704969425435;19881.304154354566;20436.89781551094;20676.172953081896;20678.689819652678;5151.665141765792;5430.104032834597;5492.862678433051;5512.125877201751;5551.028570000254;5378.327709036371;5465.426130256325;5504.889902201953;5512.724363781815;6014.1580178775;6033;6080.209572755535;6084.604500707462;6086.695665216722;6096.939030609681;5426.810061647863;5496.395396506381;5563.388027316992;5956.910646340309;6074.240719910012;5252.553532949704;5278.234655974862;5317.601179911522;5336.733163341856;5342.946570534284;13128;13262;13377.26425046622;13581.388837502336;13610.183388996593;2144.0673307111456;2165.8700477971215;2314.7338056123426;2324.4886125052462;2327.4065113395977;9922.80154396908;9974.351667141686;10090.646827361006;10469.424181670005;10495.42275174865;1865.4050786577552;1908.9522761930923;1926.0754837677853;1927.778305494872;1943.3004118517322;93001.53499232528;98508.50745746297;109440;120016.99830017016;123313;6862.1129189473295;9736.95131524352;10023.448710321003;10048.598056077675;10132.189424845994;12288.569900053455;12373.381330933418;12375.876241237653;12894.968402527775;13563.932180339036;8383.28742056932;8441.788955276168;8553.74338769838;8631.741047768577;8679.6528138875;8503.064662887078;8518.787030324167;8555.786105347415;8606.139386061344;8659.78350541229;4463.330500424962;4476.395686582335;4494.483134439516;4498.797554110073;4499.955000449953;1915.5785727140008;1965.508622844289;1971.891545964957;1985.8312043476178;2003.3288848236004;754.294734423316;829.9792505187419;849.4775712936499;875;920.5949382271779;19749.506262343268;20825.37523874286;20846.895765521076;20903.79096209049;20933.37199884006;925.3799954030816;927.0868194828089;938.2775263047415;954.7326748510428;973.7955029443896;10745.731356715989;10954.890451095387;10956.726081848017;10982.176336774774;11016.008559229707;552899;562235;566278.6744265174;568009;572642;127455.3627231858;132872;132940.3352983229;134302.32848835693;136116;907.8606349032054;923.8337099322187;954.2556805691572;983.2871168402851;1018.4754851251612;15879.841201588299;18416.723749144043;18501;19173.137208825356;19387;41573.96065098276;55866.72066639641;56425;56963;57767.1334929968;78178.82731759142;79221.05842061753;80941;82220;84180;7086.39765619928;7118.572885626879;7317.26827317264;7403.703851845866;7700.8459830804195;10766.354018758899;12989.870101299244;13356.532521361705;13607.115537490032;13607.251601162032;9504.857427138737;11120.110391168526;11288.379139147426;11548.653540393465;11563.074954003492;9998.850017249602;11258.080556936848;11291.604793832505;11596.188266821242;11707.473163707824;10883.727906802393;11424.086073114297;11759.000484958875;11793.938545530944;11864.703382415508;7366.484346095722;7395.223501532261;7438.6652600632015;7490.812729681802;7494.063242094739;8331.375146864131;9626.566804493954;10537.947310263706;11146.665600032013;11352.423986444244 00:50:52 INFO - PROCESS | 1658 | |3;mootools.html;1510.7733839924006;1515.704437634661;1542.8380020097889;1670.9081000544973;1878.2674756844842;8137.633806478708;8576.571171441426;8661.740147795561;9168.86246706299;9199.954000229998;7203.711851525933;7554.88667669984;8902.2433093187;8906.198442140207;9009.144131307532;1977.396893947349;2248.4716091718433;2382.737898831127;2387.606045002581;2388.4625959159225;1984.4840341511167;2381.8570885746826;2388;2398.9760102399014;2403.0868270057354;1983.4446355020546;2076.7539476314164;2324.837261391703;2373.774491423312;2396.065534441569;2354.128972280267;2363.917262895799;2367.124164059292;2371.336025912747;2378.9762102378927;2367.360812580611;2374.691290132289;2380.4643955110137;2380.51199504103;2380.571497130516;8995.235404990584;9154.130357616015;9186.448813071238;9188.356815022951;9199.356045076847;5286.312779338661;5442.782288708447;5449.3188351456065;5468.398476167618;5478.972605136949;3520.9119772005647;3591.1740299730945;3668.3396988542054;3714.182879766447;3723.2367364690444;1049.8582691336649;1089.5750657243682;1091.6070214722772;1105.6130354375985;1114.6210288501948;11696.766064678659;11836.704082397922;11914.404279785977;11928.761424771543;11952.163348565604;4336.804843782037;4603.217453032992;4700.412448443944;4765.11845308619;4870.269459581091;10004.799904001879;10089.09198172168;10097.990200979842;10099.091081802673;10108.545115469822;5401.5948803839865;5421.024215641222;5431;5446.346438427414;5457.426970168075;4429.402030725875;4731.219348807477;4884.096442158212;4954.950450495449;4991.950080499221;3947.2697550953167;3952.071263253133;4038.51537815464;4068;4068.349064149722;1027.5716753712345;1305.7127431964952;1320.5642138094406;1332.5735764555443;1359.3746876436949;798.2855344466669;892.8839250897472;910.4673765847053;930.1024511346583;953.713885834247;5117.795288188505;5791.189233507313;6019.909701354483;6108.725107370179;6200.131981522591;415.48687371096673;419.1972372905851;427.83100675233106;430.07962959267195;431.20873197681976;3918.9169032502055;3960.089179488734;4050.2911990401562;4065.5527891931865;4106.548279689232;10618.044376006197;10914.508847101899;11031.393273369882;11037.613683521038;11041.282316649393;10783.083437907866;10816.67549973502;10974.780504389868;10977.06694930924;11042.116630669689;8225.95887020561;8336.166383361615;8371.665133394717;8378.748637540884;8397.076321604618;5875.41245875409;5977.252843394575;5988.970055149696;5991.850203744942;6014.72933717975;9710.223182145553;10044.397336159855;10062.245331600305;10202.132818710492;10302.124319432933;10166.694999150037;10188.949055254676;10317.845232321672;10319.226058045826;10398.428086455318;6892.138482689664;7361.337479626859;7467.589282589292;7555.697772089275;7601.3918886490055;8502.979642442946;8580;8592.140785921358;8597.785055373666;8612.569371531523;7558.622068896423;7705.383569314554;7723.150453450004;7732.613369331399;7813.765587032398;7412.073490813648;7507.924920750941;7515;7585.506942048749;7624.27569380908;6088.786892458743;6201.255849298113;6680.498962577729;6958.826029349307;7091.503594748318;4687.67186296956;4839.830605928775;5174.63777535584;5235.005348983681;5248.6588371755715;4456.598906098337;4538.773061346986;5050.419201791694;5137.6660517066275;5211.348581427322 00:50:52 INFO - PROCESS | 1658 | |4;prototype.html;251.60874839624387;266.3288512947374;304.40944567538975;311.7334678849584;313.73332667232853;4633.721976681401;5581.246531718227;5660.405657405975;5722.6852523111265;5745.891687443472;5523.337199536061;5589.7082196299525;5592.636478628886;5674.177244299574;5689.8577535561635;4302.2901221298525;4315.158544083905;4323.2218200723855;4347.934780978288;4351.847685331014;3557.7509574329806;4143.70994030418;4277.780832462749;4295.410698041729;4380.802863871133;3908.7492002559193;4071.857484988026;4226.830926762926;4240.537014729914;4251.914961700764;3803.3724435468393;4021.0751527148627;4245.448091748069;4263.765492897889;4291.463567054118;3228.8869889553753;3502.702270307027;3715.9442608360896;3733.0028434787528;3734.7198960078103;4548.158590660738;4618.515055919113;5060.190369540893;5238.476152384769;5498.882930071911;4893.678706749158;4901.191303434929;4906.264060390934;4933.605311575066;4941.504540207173;5671.886562268773;5968.850778730523;5980.372060933583;6000.46988018057;6052.667103309316;4039.9192016159514;4046.433499310099;4060.776657283848;4068.816903239361;4081.8775436736946;5255.737213139366;6050.273967123973;6247.312795592481;6261.248650161964;6287;3601.657842504958;4130.814113364846;4143.943294459894;4146.4402305688345;4152.667786577066;3582.390993531106;3813.656770890633;4041.6362527372676;4048.554658987509;4065.4918135233097;4075.59244075596;4077.9193513718888;4378.934315985262;4778.713277203379;4818.132736107465;5535.391106978229;5601.467860553241;5835.066389377679;6063.696815159225;6084.239470066242;1217.829503869459;1246.2896149195053;1302.2902518127644;1313.40240190713;1397.7204559088223;673.2089794491453;710.5061981922618;827.8096037911314;853.9069990412282;857.0229937870832;4020.1507306639273;4287.614114729689;4724.574788269004;4767.475577686451;4770.7339013968085;4304.655627549789;4657.4876763555985;5015.874603134951;5104.41299250591;5252.921206181911;3990.481237439172;4161.708680392343;4175.181752317174;4487.596116349544;4742.715437073786;2154.6210425327804;2328.650702394654;2446.907893750853;2594.571895637199;2637.3933995181214;4940.382452193476;4973.875653108629;4982.427020892571;5375.543078838265;5395.892082158335;4753.928691069636;5024.849254522297;5258.737902903275;5359.678419294854;5361.150403110921;4443.422355093881;4587.3348364486965;5305.363356397257;5306.442823503631;5337.599680023936;4280.229558679468;4547.067851090585;4848.418189817104;5199.584033277253;5260.658057226268;4230.767307798101;4720.881977950441;4836.5490352893285;5140.922886156785;5153.711572106973;4523.5250298719475;5290.920636190537;5296.193017700625;5357.973210133924;5369.912300427191;3534.6642069003406;3535.8408871600327;3537.823108844496;3558.733095017832;3565.28694261154;4581.297034749514;4817.78319975609;4927.704337739747;4948.851534453972;5153.974230128975;4949.6287778416045;5152.510511501401;5808.099744539603;5912.172295878667;5920.615160014585;5189.495046436491;5889.791328251906;5929.555283353852;5985.491233245223;6029.849253768691;5590.692511911884;5739.053056245672;5817.2146760188525;5842.474177324061;5872.765089396547;4526.049529598689;5287.576993840406;5848.4151584841175;5905.763769449174;5981.581289309881;5607.467290607386;5843.444872737083;5858.51013319329;5865.677387743715;5895.351511333835 00:50:52 INFO - PROCESS | 1658 | |5;yui.html;644.842013706642;689.4691087862343;700.3871612339207;729.58049121755;784.3293983643985;15313.540593782176;16399.344026238938;16410.015399076063;16413.343466261365;16424.917875410636;14647;14804.777928331083;14809.555713328591;14842.406303747865;14854.554363369089;663.3797399431522;770.7649167004062;832.309183377798;857.215647682373;878.6924576398274;761.9923800762004;830.5971603772166;865.0873328638285;872.8472517309445;875.2385424680537;915.995420022899;922.5202894494893;923.4966943016072;923.6582464488149;925.4493576322111;897.3539051882634;910.7905181808155;912.2382810353363;912.8676341930416;913.6619450803246;684.5276759036299;684.5824047331124;685.0101603183402;686.2691233835999;687.5874475314821;15224.314905829153;15272.083674979425;15290.311935962909;15297.847021529753;15303.311350989232;14719.92640036793;14733.410663573444;14763.483278085323;14813.629659258497;14990.400383984628;11907.761844763143;12050.638480845588;12253;12273.38633068343;12529.310887901162;3707.9629203707887;3786.9621303786885;3966.3058964681354;4019.41718450823;4019.4573732546023;114831;115281.4235928815;116341;118687;126807.36596317052;11277.887221127849;11328.376939268255;11376.772464550662;11486.540538378371;11776.646700598996;24132.87933560321;24165.516689666107;24195.032198712208;24245.39386515316;24272.393190170387;7388.113426388868;7691.077070751546;7711.151773304932;7780.249443875196;7864.842703145905;4357;4433.4119399280125;4442.800073996678;4473.821047158077;4547.954520454753;3360.7311415086733;3447.5345828312857;3503.2818272254126;3507.438809790421;3510.420780571177;545.5090418623191;592.9021711417654;636.4939872801134;657.5660064357501;661.9304972977865;547.2146772925747;607.4077774170149;614.7633161232958;618.9164462797464;625.777848863656;8882.718956840852;8891.19979201875;8964.282857371394;9051.502167380726;9138.99471058183;546.4890327543759;569.834747923106;605.1739375752155;619.6715740657459;620.6989610039127;3780.962190378061;4159.750414975111;4218.451601291874;4358.694891357638;4452.287633978548;101807;112647.43676281566;148522;151960.200994976;161372;83652.16347836565;84004.15995839963;107379;136584.43908926478;140000;66008.66995664992;98882;105703.12929659548;107769;111097.44451277853;9528.467131429303;9818.0291992686;10062.446565438679;10113.949430252802;10194.337368071052;61229.38770612237;61722.38277617166;62674.686626566574;64212.53620623485;64826.35173648392;91862;93901.5304923471;95472.0452795491;95808.52095739476;97673.51163244138;13743.587692369245;14357.353919073457;14541.781873271697;14567.125972441687;14712.264386780404;13514.851237644518;14913.552593422215;15439.150846703089;15476;16097.275622597246;13522.79715804244;13723.519676811264;13747.312634368442;13789.51736689211;13814.328760606155;14192.290385480892;14433.20617366013;14503.419863205354;14514.564563063124;15058.397664093753;13034.674133146747;13099.738005240033;13144.079914406282;13194.472221111431;13467.326633668474;11031.282966607145;11582;11697.12271579652;11740.471678774646;11883.465244064211;11630.244034137753;11762.411879406167;11834.349110798988;11834.467448964646;11852.111091667986 00:50:52 INFO - PROCESS | 1658 | __end_tp_report 00:50:52 INFO - PROCESS | 1658 | __start_cc_report 00:50:52 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,382 00:50:52 INFO - PROCESS | 1658 | __end_cc_report 00:50:52 INFO - PROCESS | 1658 | __startTimestamp1472802652488__endTimestamp 00:50:52 INFO - PROCESS | 1658 | 00:50:52 INFO - PROCESS | 1658 | ------- Summary: start ------- 00:50:52 INFO - PROCESS | 1658 | Number of tests: 6 00:50:52 INFO - PROCESS | 1658 | 00:50:52 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5672.38 Median:5851.47 stddev:680.00 (11.6%) stddev-sans-first:644.34 00:50:52 INFO - PROCESS | 1658 | Values: 2824.4 3056.6 3366.1 3375.3 3395.9 4574.2 5683.5 5684.4 5748.7 5765.8 5551.2 5683.5 5702.2 5720.7 5726.9 5198.9 5204.2 5283.5 5301.0 5353.3 5221.2 5343.2 5391.2 5434.2 5434.3 5122.6 5176.8 5211.8 5227.8 5241.5 5209.6 5235.5 5245.8 5256.6 5279.9 5127.1 5222.4 5222.7 5237.6 5262.7 4118.9 5637.1 5710.8 5722.8 5726.3 5158.9 6167.5 6202.0 6206.7 6250.0 6223.3 6232.0 6232.5 6249.6 6261.4 5708.7 5777.2 5835.5 5842.9 5848.8 6254.8 6257.1 6262.8 6265.3 6269.0 6093.0 6103.6 6126.1 6130.9 6136.8 6098.1 6134.4 6145.4 6152.1 6155.3 6162.6 6194.2 6217.1 6225.2 6228.7 6198.8 6215.2 6229.9 6236.1 6237.3 4134.2 4593.2 4928.6 4962.6 5069.1 4412.1 4480.9 4481.8 4490.9 4517.0 5653.5 5704.0 5791.1 5810.9 5840.3 6066.5 6131.9 6159.4 6165.3 6201.7 5823.1 5827.0 5839.9 5851.5 5867.5 4908.5 5309.0 5473.0 5480.9 5484.3 6164.7 6190.9 6224.4 6226.3 6341.8 5081.6 5204.6 5232.8 6220.3 6254.3 5323.7 5425.8 6282.2 6285.9 6332.1 6088.5 6107.5 6118.6 6142.4 6174.7 5449.2 5685.4 6139.8 6185.8 6190.0 6120.3 6140.9 6147.3 6158.1 6178.9 5997.5 6076.2 6103.3 6142.8 6286.2 4139.5 5878.6 5925.6 6015.3 6037.5 6098.7 6113.9 6118.2 6132.6 6139.7 6037.0 6045.6 6060.3 6064.3 6104.4 00:50:52 INFO - PROCESS | 1658 | 00:50:52 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:62656.19 Median:39301.80 stddev:131924.38 (335.7%) stddev-sans-first:132211.89 00:50:52 INFO - PROCESS | 1658 | Values: 487.7 489.0 502.5 525.1 541.2 33463.5 36694.6 38928.8 38947.4 38998.2 26684.0 40645.4 40656.4 40767.4 40799.6 8837.0 9224.8 9939.1 9939.3 9967.9 9714.5 9770.4 9796.6 9820.8 9832.7 9749.8 9842.2 9850.1 9862.2 9864.9 9787.7 9788.8 9800.3 9821.1 9823.4 9736.0 9837.4 9858.7 9877.0 9888.1 38950.4 39169.0 39230.0 39271.6 39332.0 3410.4 3552.7 3593.0 3955.2 4186.0 30036.4 30107.8 30261.8 30740.9 30778.0 3189.3 3271.7 3319.3 3366.7 3377.7 441398.0 441847.0 445614.0 446628.0 452919.0 54974.9 55820.9 56168.2 56376.0 56427.7 58353.0 58398.7 58430.0 58701.4 59381.7 15880.6 16069.2 16069.4 16084.8 16115.9 12522.9 12565.9 12586.8 12670.0 12677.0 14672.9 15137.8 15255.5 15266.2 15358.4 6403.9 6482.6 6524.2 6563.9 6602.9 814.3 829.0 831.4 958.8 1019.5 25114.4 25135.4 29935.7 29967.9 30167.5 961.0 993.2 1052.3 1091.5 1131.3 12364.0 14861.9 15526.4 15541.8 15832.3 499824.0 605513.0 609516.0 610093.0 612456.0 55631.2 55669.0 55816.4 56044.0 56411.0 1332.0 1360.8 1375.4 1381.8 1386.2 28790.4 29388.9 29521.4 30180.7 30203.2 47667.8 47905.5 47910.8 48085.5 48237.8 417772.0 419161.0 420478.0 424669.0 490116.0 25517.9 25827.9 25869.4 25878.7 26003.3 45757.5 46647.3 46845.8 46931.5 47008.8 37601.0 38160.4 38319.0 38824.0 38987.0 32490.4 35128.5 37541.4 37870.6 39029.4 33689.2 37461.4 38398.8 38478.8 39518.0 30448.0 34059.7 34070.3 34132.0 34143.3 22179.9 23187.7 24629.0 24782.9 25257.2 00:50:52 INFO - PROCESS | 1658 | 00:50:52 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:33513.57 Median:20988.12 stddev:94629.91 (450.9%) stddev-sans-first:94862.62 00:50:52 INFO - PROCESS | 1658 | Values: 359.9 379.3 380.1 386.8 402.3 15696.5 19601.9 19922.0 21157.5 21392.9 19668.7 19881.3 20436.9 20676.2 20678.7 5151.7 5430.1 5492.9 5512.1 5551.0 5378.3 5465.4 5504.9 5512.7 6014.2 6033.0 6080.2 6084.6 6086.7 6096.9 5426.8 5496.4 5563.4 5956.9 6074.2 5252.6 5278.2 5317.6 5336.7 5342.9 13128.0 13262.0 13377.3 13581.4 13610.2 2144.1 2165.9 2314.7 2324.5 2327.4 9922.8 9974.4 10090.6 10469.4 10495.4 1865.4 1909.0 1926.1 1927.8 1943.3 93001.5 98508.5 109440.0 120017.0 123313.0 6862.1 9737.0 10023.4 10048.6 10132.2 12288.6 12373.4 12375.9 12895.0 13563.9 8383.3 8441.8 8553.7 8631.7 8679.7 8503.1 8518.8 8555.8 8606.1 8659.8 4463.3 4476.4 4494.5 4498.8 4500.0 1915.6 1965.5 1971.9 1985.8 2003.3 754.3 830.0 849.5 875.0 920.6 19749.5 20825.4 20846.9 20903.8 20933.4 925.4 927.1 938.3 954.7 973.8 10745.7 10954.9 10956.7 10982.2 11016.0 552899.0 562235.0 566278.7 568009.0 572642.0 127455.4 132872.0 132940.3 134302.3 136116.0 907.9 923.8 954.3 983.3 1018.5 15879.8 18416.7 18501.0 19173.1 19387.0 41574.0 55866.7 56425.0 56963.0 57767.1 78178.8 79221.1 80941.0 82220.0 84180.0 7086.4 7118.6 7317.3 7403.7 7700.8 10766.4 12989.9 13356.5 13607.1 13607.3 9504.9 11120.1 11288.4 11548.7 11563.1 9998.9 11258.1 11291.6 11596.2 11707.5 10883.7 11424.1 11759.0 11793.9 11864.7 7366.5 7395.2 7438.7 7490.8 7494.1 8331.4 9626.6 10537.9 11146.7 11352.4 00:50:52 INFO - PROCESS | 1658 | 00:50:52 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5751.91 Median:4443.00 stddev:3285.69 (74.0%) stddev-sans-first:3279.45 00:50:52 INFO - PROCESS | 1658 | Values: 1510.8 1515.7 1542.8 1670.9 1878.3 8137.6 8576.6 8661.7 9168.9 9200.0 7203.7 7554.9 8902.2 8906.2 9009.1 1977.4 2248.5 2382.7 2387.6 2388.5 1984.5 2381.9 2388.0 2399.0 2403.1 1983.4 2076.8 2324.8 2373.8 2396.1 2354.1 2363.9 2367.1 2371.3 2379.0 2367.4 2374.7 2380.5 2380.5 2380.6 8995.2 9154.1 9186.4 9188.4 9199.4 5286.3 5442.8 5449.3 5468.4 5479.0 3520.9 3591.2 3668.3 3714.2 3723.2 1049.9 1089.6 1091.6 1105.6 1114.6 11696.8 11836.7 11914.4 11928.8 11952.2 4336.8 4603.2 4700.4 4765.1 4870.3 10004.8 10089.1 10098.0 10099.1 10108.5 5401.6 5421.0 5431.0 5446.3 5457.4 4429.4 4731.2 4884.1 4955.0 4992.0 3947.3 3952.1 4038.5 4068.0 4068.3 1027.6 1305.7 1320.6 1332.6 1359.4 798.3 892.9 910.5 930.1 953.7 5117.8 5791.2 6019.9 6108.7 6200.1 415.5 419.2 427.8 430.1 431.2 3918.9 3960.1 4050.3 4065.6 4106.5 10618.0 10914.5 11031.4 11037.6 11041.3 10783.1 10816.7 10974.8 10977.1 11042.1 8226.0 8336.2 8371.7 8378.7 8397.1 5875.4 5977.3 5989.0 5991.9 6014.7 9710.2 10044.4 10062.2 10202.1 10302.1 10166.7 10188.9 10317.8 10319.2 10398.4 6892.1 7361.3 7467.6 7555.7 7601.4 8503.0 8580.0 8592.1 8597.8 8612.6 7558.6 7705.4 7723.2 7732.6 7813.8 7412.1 7507.9 7515.0 7585.5 7624.3 6088.8 6201.3 6680.5 6958.8 7091.5 4687.7 4839.8 5174.6 5235.0 5248.7 4456.6 4538.8 5050.4 5137.7 5211.3 00:50:52 INFO - PROCESS | 1658 | 00:50:52 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4471.61 Median:4827.34 stddev:1392.28 (28.8%) stddev-sans-first:1359.68 00:50:52 INFO - PROCESS | 1658 | Values: 251.6 266.3 304.4 311.7 313.7 4633.7 5581.2 5660.4 5722.7 5745.9 5523.3 5589.7 5592.6 5674.2 5689.9 4302.3 4315.2 4323.2 4347.9 4351.8 3557.8 4143.7 4277.8 4295.4 4380.8 3908.7 4071.9 4226.8 4240.5 4251.9 3803.4 4021.1 4245.4 4263.8 4291.5 3228.9 3502.7 3715.9 3733.0 3734.7 4548.2 4618.5 5060.2 5238.5 5498.9 4893.7 4901.2 4906.3 4933.6 4941.5 5671.9 5968.9 5980.4 6000.5 6052.7 4039.9 4046.4 4060.8 4068.8 4081.9 5255.7 6050.3 6247.3 6261.2 6287.0 3601.7 4130.8 4143.9 4146.4 4152.7 3582.4 3813.7 4041.6 4048.6 4065.5 4075.6 4077.9 4378.9 4778.7 4818.1 5535.4 5601.5 5835.1 6063.7 6084.2 1217.8 1246.3 1302.3 1313.4 1397.7 673.2 710.5 827.8 853.9 857.0 4020.2 4287.6 4724.6 4767.5 4770.7 4304.7 4657.5 5015.9 5104.4 5252.9 3990.5 4161.7 4175.2 4487.6 4742.7 2154.6 2328.7 2446.9 2594.6 2637.4 4940.4 4973.9 4982.4 5375.5 5395.9 4753.9 5024.8 5258.7 5359.7 5361.2 4443.4 4587.3 5305.4 5306.4 5337.6 4280.2 4547.1 4848.4 5199.6 5260.7 4230.8 4720.9 4836.5 5140.9 5153.7 4523.5 5290.9 5296.2 5358.0 5369.9 3534.7 3535.8 3537.8 3558.7 3565.3 4581.3 4817.8 4927.7 4948.9 5154.0 4949.6 5152.5 5808.1 5912.2 5920.6 5189.5 5889.8 5929.6 5985.5 6029.8 5590.7 5739.1 5817.2 5842.5 5872.8 4526.0 5287.6 5848.4 5905.8 5981.6 5607.5 5843.4 5858.5 5865.7 5895.4 00:50:52 INFO - PROCESS | 1658 | 00:50:52 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:24229.55 Median:3475.41 stddev:37648.10 (1083.3%) stddev-sans-first:37712.07 00:50:52 INFO - PROCESS | 1658 | Values: 644.8 689.5 700.4 729.6 784.3 15313.5 16399.3 16410.0 16413.3 16424.9 14647.0 14804.8 14809.6 14842.4 14854.6 663.4 770.8 832.3 857.2 878.7 762.0 830.6 865.1 872.8 875.2 916.0 922.5 923.5 923.7 925.4 897.4 910.8 912.2 912.9 913.7 684.5 684.6 685.0 686.3 687.6 15224.3 15272.1 15290.3 15297.8 15303.3 14719.9 14733.4 14763.5 14813.6 14990.4 11907.8 12050.6 12253.0 12273.4 12529.3 3708.0 3787.0 3966.3 4019.4 4019.5 114831.0 115281.4 116341.0 118687.0 126807.4 11277.9 11328.4 11376.8 11486.5 11776.6 24132.9 24165.5 24195.0 24245.4 24272.4 7388.1 7691.1 7711.2 7780.2 7864.8 4357.0 4433.4 4442.8 4473.8 4548.0 3360.7 3447.5 3503.3 3507.4 3510.4 545.5 592.9 636.5 657.6 661.9 547.2 607.4 614.8 618.9 625.8 8882.7 8891.2 8964.3 9051.5 9139.0 546.5 569.8 605.2 619.7 620.7 3781.0 4159.8 4218.5 4358.7 4452.3 101807.0 112647.4 148522.0 151960.2 161372.0 83652.2 84004.2 107379.0 136584.4 140000.0 66008.7 98882.0 105703.1 107769.0 111097.4 9528.5 9818.0 10062.4 10113.9 10194.3 61229.4 61722.4 62674.7 64212.5 64826.4 91862.0 93901.5 95472.0 95808.5 97673.5 13743.6 14357.4 14541.8 14567.1 14712.3 13514.9 14913.6 15439.2 15476.0 16097.3 13522.8 13723.5 13747.3 13789.5 13814.3 14192.3 14433.2 14503.4 14514.6 15058.4 13034.7 13099.7 13144.1 13194.5 13467.3 11031.3 11582.0 11697.1 11740.5 11883.5 11630.2 11762.4 11834.3 11834.5 11852.1 00:50:52 INFO - PROCESS | 1658 | -------- Summary: end -------- 00:50:52 INFO - PROCESS | 1658 | 00:50:53 INFO - TEST-INFO | 1658: exit 0 00:50:53 INFO - TEST-OK | dromaeo_css | took 1114472ms 00:50:53 INFO - TEST-START | kraken 00:50:53 INFO - operating with platform_type : mac_ 00:50:53 INFO - Initialising browser for kraken test... 00:50:53 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmph5RxCM/profile http://localhost:49267/getInfo.html) 00:50:55 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 00:50:55 INFO - PROCESS | 1669 | colorDepth:24 00:50:55 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 00:50:55 INFO - PROCESS | 1669 | __metrics 00:50:55 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 00:50:56 INFO - TEST-INFO | 1669: exit 0 00:50:56 INFO - Browser initialized. 00:50:56 INFO - Running cycle 1/1 for kraken test... 00:50:56 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmph5RxCM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:51:08 INFO - PROCESS | 1671 | RSS: Main: 245272576 00:51:08 INFO - PROCESS | 1671 | 00:51:11 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 00:51:12 INFO - PROCESS | 1671 | RSS: Main: 258191360 00:51:12 INFO - PROCESS | 1671 | 00:51:14 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 00:51:15 INFO - PROCESS | 1671 | RSS: Main: 266997760 00:51:15 INFO - PROCESS | 1671 | 00:51:18 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 00:51:19 INFO - PROCESS | 1671 | RSS: Main: 266448896 00:51:19 INFO - PROCESS | 1671 | 00:51:21 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 00:51:21 INFO - PROCESS | 1671 | RSS: Main: 268853248 00:51:21 INFO - PROCESS | 1671 | 00:51:24 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:51:24 INFO - PROCESS | 1671 | RSS: Main: 269438976 00:51:24 INFO - PROCESS | 1671 | 00:51:27 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 00:51:28 INFO - PROCESS | 1671 | RSS: Main: 269991936 00:51:28 INFO - PROCESS | 1671 | 00:51:31 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 00:51:31 INFO - PROCESS | 1671 | RSS: Main: 270241792 00:51:31 INFO - PROCESS | 1671 | 00:51:34 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 00:51:35 INFO - PROCESS | 1671 | RSS: Main: 270622720 00:51:35 INFO - PROCESS | 1671 | 00:51:36 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:51:37 INFO - PROCESS | 1671 | RSS: Main: 269705216 00:51:37 INFO - PROCESS | 1671 | 00:51:39 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:51:40 INFO - PROCESS | 1671 | RSS: Main: 269754368 00:51:40 INFO - PROCESS | 1671 | 00:51:42 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:51:43 INFO - PROCESS | 1671 | RSS: Main: 270016512 00:51:43 INFO - PROCESS | 1671 | 00:51:46 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:51:46 INFO - PROCESS | 1671 | RSS: Main: 270442496 00:51:46 INFO - PROCESS | 1671 | 00:51:49 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:51:50 INFO - PROCESS | 1671 | RSS: Main: 270282752 00:51:50 INFO - PROCESS | 1671 | 00:51:52 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 00:51:52 INFO - PROCESS | 1671 | RSS: Main: 272048128 00:51:52 INFO - PROCESS | 1671 | 00:51:52 INFO - PROCESS | 1671 | __start_tp_report 00:51:52 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 00:51:52 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 00:51:52 INFO - PROCESS | 1671 | |i|pagename|runs| 00:51:52 INFO - PROCESS | 1671 | |0;ai-astar;110;116;117;114;118;119;117;118;124;132 00:51:52 INFO - PROCESS | 1671 | |1;audio-beat-detection;133;94;122;198;95;139;118;136;160;144 00:51:52 INFO - PROCESS | 1671 | |2;audio-dft;196;206;206;242;278;198;189;196;197;190 00:51:52 INFO - PROCESS | 1671 | |3;audio-fft;71;80;77;143;58;59;55;60;136;57 00:51:52 INFO - PROCESS | 1671 | |4;audio-oscillator;71;70;104;103;102;108;115;69;85;115 00:51:52 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;88;88;76;130;135;86;89;87;80;128 00:51:52 INFO - PROCESS | 1671 | |6;imaging-darkroom;99;98;98;101;100;99;117;130;99;100 00:51:52 INFO - PROCESS | 1671 | |7;imaging-desaturate;76;153;150;94;91;91;117;90;91;90 00:51:52 INFO - PROCESS | 1671 | |8;json-parse-financial;57;57;56;59;59;59;59;59;58;57 00:51:52 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;66;71;61;94;112;109;102;74;71;72 00:51:52 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;92;91;93;89;87;87;85;86;91;86 00:51:52 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;157;165;133;181;168;154;155;153;196;162 00:51:52 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;174;174;200;241;238;179;170;173;174;176 00:51:52 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;68;69;84;79;68;58;86;89;81;68 00:51:52 INFO - PROCESS | 1671 | __end_tp_report 00:51:52 INFO - PROCESS | 1671 | __start_cc_report 00:51:52 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,954 00:51:52 INFO - PROCESS | 1671 | __end_cc_report 00:51:52 INFO - PROCESS | 1671 | __startTimestamp1472802712585__endTimestamp 00:51:52 INFO - PROCESS | 1671 | 00:51:52 INFO - PROCESS | 1671 | ------- Summary: start ------- 00:51:52 INFO - PROCESS | 1671 | Number of tests: 14 00:51:52 INFO - PROCESS | 1671 | 00:51:52 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:118.50 Median:118.00 stddev:5.93 (5.0%) stddev-sans-first:5.43 00:51:52 INFO - PROCESS | 1671 | Values: 110.0 116.0 117.0 114.0 118.0 119.0 117.0 118.0 124.0 132.0 00:51:52 INFO - PROCESS | 1671 | 00:51:52 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:152.00 stddev:30.59 (20.1%) stddev-sans-first:32.45 00:51:52 INFO - PROCESS | 1671 | Values: 133.0 94.0 122.0 198.0 95.0 139.0 118.0 136.0 160.0 144.0 00:51:52 INFO - PROCESS | 1671 | 00:51:52 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:209.80 Median:202.00 stddev:28.33 (14.0%) stddev-sans-first:29.61 00:51:52 INFO - PROCESS | 1671 | Values: 196.0 206.0 206.0 242.0 278.0 198.0 189.0 196.0 197.0 190.0 00:51:52 INFO - PROCESS | 1671 | 00:51:52 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:79.60 Median:59.50 stddev:32.78 (55.1%) stddev-sans-first:34.62 00:51:52 INFO - PROCESS | 1671 | Values: 71.0 80.0 77.0 143.0 58.0 59.0 55.0 60.0 136.0 57.0 00:51:52 INFO - PROCESS | 1671 | 00:51:52 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:92.00 stddev:18.66 (20.3%) stddev-sans-first:17.80 00:51:52 INFO - PROCESS | 1671 | Values: 71.0 70.0 104.0 103.0 102.0 108.0 115.0 69.0 85.0 115.0 00:51:52 INFO - PROCESS | 1671 | 00:51:52 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:98.70 Median:86.50 stddev:22.71 (26.3%) stddev-sans-first:23.76 00:51:52 INFO - PROCESS | 1671 | Values: 88.0 88.0 76.0 130.0 135.0 86.0 89.0 87.0 80.0 128.0 00:51:52 INFO - PROCESS | 1671 | 00:51:52 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:104.10 Median:98.00 stddev:10.71 (10.9%) stddev-sans-first:11.20 00:51:52 INFO - PROCESS | 1671 | Values: 99.0 98.0 98.0 101.0 100.0 99.0 117.0 130.0 99.0 100.0 00:51:52 INFO - PROCESS | 1671 | 00:51:52 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:104.30 Median:90.50 stddev:26.81 (29.6%) stddev-sans-first:26.41 00:51:52 INFO - PROCESS | 1671 | Values: 76.0 153.0 150.0 94.0 91.0 91.0 117.0 90.0 91.0 90.0 00:51:52 INFO - PROCESS | 1671 | 00:51:52 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:59.00 stddev:1.15 (2.0%) stddev-sans-first:1.17 00:51:52 INFO - PROCESS | 1671 | Values: 57.0 57.0 56.0 59.0 59.0 59.0 59.0 59.0 58.0 57.0 00:51:52 INFO - PROCESS | 1671 | 00:51:52 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:83.20 Median:71.00 stddev:19.04 (26.8%) stddev-sans-first:19.15 00:51:52 INFO - PROCESS | 1671 | Values: 66.0 71.0 61.0 94.0 112.0 109.0 102.0 74.0 71.0 72.0 00:51:52 INFO - PROCESS | 1671 | 00:51:52 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:90.00 stddev:2.87 (3.2%) stddev-sans-first:2.78 00:51:52 INFO - PROCESS | 1671 | Values: 92.0 91.0 93.0 89.0 87.0 87.0 85.0 86.0 91.0 86.0 00:51:52 INFO - PROCESS | 1671 | 00:51:52 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:162.40 Median:163.50 stddev:17.06 (10.4%) stddev-sans-first:17.99 00:51:52 INFO - PROCESS | 1671 | Values: 157.0 165.0 133.0 181.0 168.0 154.0 155.0 153.0 196.0 162.0 00:51:52 INFO - PROCESS | 1671 | 00:51:52 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.90 Median:177.50 stddev:27.44 (15.5%) stddev-sans-first:28.50 00:51:52 INFO - PROCESS | 1671 | Values: 174.0 174.0 200.0 241.0 238.0 179.0 170.0 173.0 174.0 176.0 00:51:52 INFO - PROCESS | 1671 | 00:51:52 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.00 Median:80.00 stddev:10.12 (12.7%) stddev-sans-first:10.41 00:51:52 INFO - PROCESS | 1671 | Values: 68.0 69.0 84.0 79.0 68.0 58.0 86.0 89.0 81.0 68.0 00:51:52 INFO - PROCESS | 1671 | -------- Summary: end -------- 00:51:52 INFO - PROCESS | 1671 | 00:51:53 INFO - TEST-INFO | 1671: exit 0 00:51:53 INFO - TEST-OK | kraken | took 60364ms 00:51:53 INFO - SUITE-END | took 1174s 00:51:53 INFO - Completed test suite (00:19:35) 00:51:53 INFO - javascript benchmark 00:51:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7211.938260811564, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2824.3645179834534, 3056.617922759655, 3366.107981384932, 3375.2574433624595, 3395.8811441599532, 4574.153781550412, 5683.516901063409, 5684.4315568443135, 5748.712564371785, 5765.827025189251, 5551.2228288039605, 5683.54531637468, 5702.230198923144, 5720.6567605943565, 5726.885462290762, 5198.934218485201, 5204.219367094928, 5283.524482796547, 5301.045811753902, 5353.250544923714, 5221.164613661815, 5343.1985202219785, 5391.24522566839, 5434.212039254306, 5434.3207099112615, 5122.641415100945, 5176.7575781812475, 5211.817586384458, 5227.817026404057, 5241.528262456378, 5209.635325527214, 5235.476452354734, 5245.763940622681, 5256.579473642099, 5279.894402111975, 5127.051495473312, 5222.4255331913455, 5222.686638801646, 5237.554807841338, 5262.710550919736, 4118.91762164755, 5637.126245431965, 5710.77156913723, 5722.799702010451, 5726.284214473191, 5158.896822063538, 6167.537434692371, 6201.9689901550655, 6206.6586337751405, 6250.031245157008, 6223.315435302113, 6232.0, 6232.501399888043, 6249.5625306228585, 6261.405166509175, 5708.743106560215, 5777.19119323295, 5835.503982161521, 5842.883142337215, 5848.795292164754, 6254.781082662085, 6257.09272155544, 6262.812115636538, 6265.27949285838, 6268.968655156695, 6092.969535152296, 6103.572749907464, 6126.050462178369, 6130.938690613126, 6136.754529818846, 6098.115773212948, 6134.386561343919, 6145.354737752472, 6152.107944348045, 6155.322914479404, 6162.568620196633, 6194.225721784777, 6217.067439884054, 6225.190725205694, 6228.719707613168, 6198.845028874314, 6215.192025036807, 6229.875402491924, 6236.095766113979, 6237.313895471494, 4134.193832202752, 4593.19619066662, 4928.556429921253, 4962.5533701967, 5069.087564238473, 4412.139632771643, 4480.910381792346, 4481.775911204427, 4490.887727806766, 4516.954830451719, 5653.491185793298, 5703.971480142655, 5791.0734282514595, 5810.854728631818, 5840.269966254218, 6066.545009124334, 6131.896637733196, 6159.353267906895, 6165.290991535941, 6201.720922558406, 5823.126531020381, 5827.009408400582, 5839.9124013139835, 5851.473367396955, 5867.471927526458, 4908.509149085063, 5308.973455132699, 5472.972635136878, 5480.945190548123, 5484.341878974469, 6164.6917654117115, 6190.907136393048, 6224.439800417984, 6226.3151053385, 6341.8097457076365, 5081.593472522263, 5204.583633309402, 5232.790688372423, 6220.253569571681, 6254.343293954069, 5323.707196104251, 5425.810096646598, 6282.246130464374, 6285.905711414241, 6332.145160403286, 6088.452039316483, 6107.492261292593, 6118.60229085108, 6142.416470435302, 6174.660393678211, 5449.2371068049715, 5685.431456854281, 6139.785107521216, 6185.8144255672405, 6189.96905015472, 6120.326764056039, 6140.877182456236, 6147.262328520606, 6158.076288556752, 6178.9382106180165, 5997.520198384206, 6076.210092688099, 6103.267607887082, 6142.78500252489, 6286.245650521967, 4139.461869956886, 5878.647281163144, 5925.585209035326, 6015.338312785502, 6037.516998640186, 6098.692995388594, 6113.871604717183, 6118.20463339763, 6132.63204207749, 6139.676133582418, 6037.0, 6045.576809623284, 6060.303065147565, 6064.3026052002815, 6104.38956104386], "value": 5630.116936364013, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.72443569383273, 488.98777530561756, 502.49750249750247, 525.0994544356428, 541.2125357604685, 33463.498047529276, 36694.63305366946, 38928.80535597325, 38947.41578876312, 38998.22003559927, 26684.0, 40645.39031914516, 40656.39015414764, 40767.388489172685, 40799.592004079954, 8837.0, 9224.815503689939, 9939.055789699967, 9939.254555908336, 9967.906739584696, 9714.465704386255, 9770.413775173476, 9796.559154838014, 9820.803583928317, 9832.705018849447, 9749.756256093584, 9842.163416109603, 9850.064243896819, 9862.161716254128, 9864.90135098647, 9787.706368808947, 9788.804223915517, 9800.31397802154, 9821.116099551075, 9823.410595364301, 9736.0, 9837.409755414626, 9858.65494707689, 9877.0, 9888.110070093726, 38950.415743763864, 39169.0, 39230.0, 39271.60728392737, 39332.0, 3410.4202285611505, 3552.7335449841366, 3592.9820350898076, 3955.1694144229746, 4186.016286172747, 30036.399272014438, 30107.849460752557, 30261.848690756626, 30740.924067657525, 30778.0, 3189.3142974260413, 3271.656476070026, 3319.3029463812386, 3366.7138293245102, 3377.7128944039787, 441398.0, 441847.0, 445613.99999999674, 446628.0, 452919.0, 54974.90050198974, 55820.92984885789, 56168.15747763787, 56376.0, 56427.71786141125, 58353.0, 58398.708006459696, 58430.0, 58701.41298587045, 59381.70309148427, 15880.60298492547, 16069.196540172945, 16069.35722571084, 16084.839151608568, 16115.871888967895, 12522.874771252353, 12565.93717031409, 12586.81119783204, 12670.0, 12677.049221308254, 14672.853271467362, 15137.772933406008, 15255.466058687893, 15266.236688165547, 15358.385664573516, 6403.871922561522, 6482.643454610042, 6524.217093948661, 6563.934360656428, 6602.86794264112, 814.2630919018297, 829.0176141272611, 831.3806214370212, 958.7603099225194, 1019.5106348952544, 25114.372140696265, 25135.371615709755, 29935.70064299373, 29967.850160749058, 30167.547486787716, 960.9615615375446, 993.2103977338033, 1052.2686732720838, 1091.5360971587202, 1131.2533727739817, 12364.0, 14861.92569037148, 15526.378944842305, 15541.766873496907, 15832.28754706041, 499824.0, 605513.0, 609516.0, 610093.0, 612456.0, 55631.16553251704, 55669.0, 55816.44183558112, 56044.0, 56411.0, 1331.9667008324675, 1360.816289800884, 1375.3535838156051, 1381.7720076187315, 1386.2029333133287, 28790.42419151647, 29388.85305573544, 29521.409571808013, 30180.69819301779, 30203.244918876324, 47667.76166119147, 47905.52094479011, 47910.76044619754, 48085.5191448081, 48237.758811207124, 417772.0, 419161.0, 420478.0, 424669.0, 490116.0, 25517.87241063783, 25827.870860645577, 25869.353266168495, 25878.741212588386, 26003.349916252246, 45757.54242457666, 46647.30029049635, 46845.828854278916, 46931.53068469271, 47008.764956175, 37601.0, 38160.427593586675, 38318.97650746743, 38824.0, 38987.0, 32490.375481225372, 35128.47307290444, 37541.43687844739, 37870.62129378671, 39029.41455878107, 33689.15777105592, 37461.43807842939, 38398.77613462461, 38478.80760596179, 39518.01204969899, 30448.0, 34059.65940340565, 34070.318593628486, 34132.0, 34143.31713365669, 22179.89100544934, 23187.6521852169, 24629.0, 24782.876085619457, 25257.242282731546], "value": 19173.836233865233, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.90822340303225, 379.3001911473332, 380.12760714161, 386.777602878345, 402.2799189450883, 15696.529104126867, 19601.901990490045, 19922.0, 21157.471063223427, 21392.89303553484, 19668.704969425435, 19881.304154354566, 20436.89781551094, 20676.172953081896, 20678.689819652678, 5151.665141765792, 5430.104032834597, 5492.862678433051, 5512.125877201751, 5551.028570000254, 5378.327709036371, 5465.426130256325, 5504.889902201953, 5512.724363781815, 6014.1580178775, 6033.0, 6080.209572755535, 6084.604500707462, 6086.695665216722, 6096.939030609681, 5426.810061647863, 5496.395396506381, 5563.388027316992, 5956.910646340309, 6074.240719910012, 5252.553532949704, 5278.234655974862, 5317.601179911522, 5336.733163341856, 5342.946570534284, 13128.0, 13262.0, 13377.26425046622, 13581.388837502336, 13610.183388996593, 2144.0673307111456, 2165.8700477971215, 2314.7338056123426, 2324.4886125052462, 2327.4065113395977, 9922.80154396908, 9974.351667141686, 10090.646827361006, 10469.424181670005, 10495.42275174865, 1865.4050786577552, 1908.9522761930923, 1926.0754837677853, 1927.778305494872, 1943.3004118517322, 93001.53499232528, 98508.50745746297, 109440.0, 120016.99830017016, 123313.0, 6862.1129189473295, 9736.95131524352, 10023.448710321003, 10048.598056077675, 10132.189424845994, 12288.569900053455, 12373.381330933418, 12375.876241237653, 12894.968402527775, 13563.932180339036, 8383.28742056932, 8441.788955276168, 8553.74338769838, 8631.741047768577, 8679.6528138875, 8503.064662887078, 8518.787030324167, 8555.786105347415, 8606.139386061344, 8659.78350541229, 4463.330500424962, 4476.395686582335, 4494.483134439516, 4498.797554110073, 4499.955000449953, 1915.5785727140008, 1965.508622844289, 1971.891545964957, 1985.8312043476178, 2003.3288848236004, 754.294734423316, 829.9792505187419, 849.4775712936499, 875.0, 920.5949382271779, 19749.506262343268, 20825.37523874286, 20846.895765521076, 20903.79096209049, 20933.37199884006, 925.3799954030816, 927.0868194828089, 938.2775263047415, 954.7326748510428, 973.7955029443896, 10745.731356715989, 10954.890451095387, 10956.726081848017, 10982.176336774774, 11016.008559229707, 552899.0, 562235.0, 566278.6744265174, 568009.0, 572642.0, 127455.3627231858, 132872.0, 132940.3352983229, 134302.32848835693, 136116.0, 907.8606349032054, 923.8337099322187, 954.2556805691572, 983.2871168402851, 1018.4754851251612, 15879.841201588299, 18416.723749144043, 18501.0, 19173.137208825356, 19387.0, 41573.96065098276, 55866.72066639641, 56425.0, 56963.0, 57767.1334929968, 78178.82731759142, 79221.05842061753, 80941.0, 82220.0, 84180.0, 7086.39765619928, 7118.572885626879, 7317.26827317264, 7403.703851845866, 7700.8459830804195, 10766.354018758899, 12989.870101299244, 13356.532521361705, 13607.115537490032, 13607.251601162032, 9504.857427138737, 11120.110391168526, 11288.379139147426, 11548.653540393465, 11563.074954003492, 9998.850017249602, 11258.080556936848, 11291.604793832505, 11596.188266821242, 11707.473163707824, 10883.727906802393, 11424.086073114297, 11759.000484958875, 11793.938545530944, 11864.703382415508, 7366.484346095722, 7395.223501532261, 7438.6652600632015, 7490.812729681802, 7494.063242094739, 8331.375146864131, 9626.566804493954, 10537.947310263706, 11146.665600032013, 11352.423986444244], "value": 9165.89223989667, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1510.7733839924006, 1515.704437634661, 1542.8380020097889, 1670.9081000544973, 1878.2674756844842, 8137.633806478708, 8576.571171441426, 8661.740147795561, 9168.86246706299, 9199.954000229998, 7203.711851525933, 7554.88667669984, 8902.2433093187, 8906.198442140207, 9009.144131307532, 1977.396893947349, 2248.4716091718433, 2382.737898831127, 2387.606045002581, 2388.4625959159225, 1984.4840341511167, 2381.8570885746826, 2388.0, 2398.9760102399014, 2403.0868270057354, 1983.4446355020546, 2076.7539476314164, 2324.837261391703, 2373.774491423312, 2396.065534441569, 2354.128972280267, 2363.917262895799, 2367.124164059292, 2371.336025912747, 2378.9762102378927, 2367.360812580611, 2374.691290132289, 2380.4643955110137, 2380.51199504103, 2380.571497130516, 8995.235404990584, 9154.130357616015, 9186.448813071238, 9188.356815022951, 9199.356045076847, 5286.312779338661, 5442.782288708447, 5449.3188351456065, 5468.398476167618, 5478.972605136949, 3520.9119772005647, 3591.1740299730945, 3668.3396988542054, 3714.182879766447, 3723.2367364690444, 1049.8582691336649, 1089.5750657243682, 1091.6070214722772, 1105.6130354375985, 1114.6210288501948, 11696.766064678659, 11836.704082397922, 11914.404279785977, 11928.761424771543, 11952.163348565604, 4336.804843782037, 4603.217453032992, 4700.412448443944, 4765.11845308619, 4870.269459581091, 10004.799904001879, 10089.09198172168, 10097.990200979842, 10099.091081802673, 10108.545115469822, 5401.5948803839865, 5421.024215641222, 5431.0, 5446.346438427414, 5457.426970168075, 4429.402030725875, 4731.219348807477, 4884.096442158212, 4954.950450495449, 4991.950080499221, 3947.2697550953167, 3952.071263253133, 4038.51537815464, 4068.0, 4068.349064149722, 1027.5716753712345, 1305.7127431964952, 1320.5642138094406, 1332.5735764555443, 1359.3746876436949, 798.2855344466669, 892.8839250897472, 910.4673765847053, 930.1024511346583, 953.713885834247, 5117.795288188505, 5791.189233507313, 6019.909701354483, 6108.725107370179, 6200.131981522591, 415.48687371096673, 419.1972372905851, 427.83100675233106, 430.07962959267195, 431.20873197681976, 3918.9169032502055, 3960.089179488734, 4050.2911990401562, 4065.5527891931865, 4106.548279689232, 10618.044376006197, 10914.508847101899, 11031.393273369882, 11037.613683521038, 11041.282316649393, 10783.083437907866, 10816.67549973502, 10974.780504389868, 10977.06694930924, 11042.116630669689, 8225.95887020561, 8336.166383361615, 8371.665133394717, 8378.748637540884, 8397.076321604618, 5875.41245875409, 5977.252843394575, 5988.970055149696, 5991.850203744942, 6014.72933717975, 9710.223182145553, 10044.397336159855, 10062.245331600305, 10202.132818710492, 10302.124319432933, 10166.694999150037, 10188.949055254676, 10317.845232321672, 10319.226058045826, 10398.428086455318, 6892.138482689664, 7361.337479626859, 7467.589282589292, 7555.697772089275, 7601.3918886490055, 8502.979642442946, 8580.0, 8592.140785921358, 8597.785055373666, 8612.569371531523, 7558.622068896423, 7705.383569314554, 7723.150453450004, 7732.613369331399, 7813.765587032398, 7412.073490813648, 7507.924920750941, 7515.0, 7585.506942048749, 7624.27569380908, 6088.786892458743, 6201.255849298113, 6680.498962577729, 6958.826029349307, 7091.503594748318, 4687.67186296956, 4839.830605928775, 5174.63777535584, 5235.005348983681, 5248.6588371755715, 4456.598906098337, 4538.773061346986, 5050.419201791694, 5137.6660517066275, 5211.348581427322], "value": 4516.654245904887, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [251.60874839624387, 266.3288512947374, 304.40944567538975, 311.7334678849584, 313.73332667232853, 4633.721976681401, 5581.246531718227, 5660.405657405975, 5722.6852523111265, 5745.891687443472, 5523.337199536061, 5589.7082196299525, 5592.636478628886, 5674.177244299574, 5689.8577535561635, 4302.2901221298525, 4315.158544083905, 4323.2218200723855, 4347.934780978288, 4351.847685331014, 3557.7509574329806, 4143.70994030418, 4277.780832462749, 4295.410698041729, 4380.802863871133, 3908.7492002559193, 4071.857484988026, 4226.830926762926, 4240.537014729914, 4251.914961700764, 3803.3724435468393, 4021.0751527148627, 4245.448091748069, 4263.765492897889, 4291.463567054118, 3228.8869889553753, 3502.702270307027, 3715.9442608360896, 3733.0028434787528, 3734.7198960078103, 4548.158590660738, 4618.515055919113, 5060.190369540893, 5238.476152384769, 5498.882930071911, 4893.678706749158, 4901.191303434929, 4906.264060390934, 4933.605311575066, 4941.504540207173, 5671.886562268773, 5968.850778730523, 5980.372060933583, 6000.46988018057, 6052.667103309316, 4039.9192016159514, 4046.433499310099, 4060.776657283848, 4068.816903239361, 4081.8775436736946, 5255.737213139366, 6050.273967123973, 6247.312795592481, 6261.248650161964, 6287.0, 3601.657842504958, 4130.814113364846, 4143.943294459894, 4146.4402305688345, 4152.667786577066, 3582.390993531106, 3813.656770890633, 4041.6362527372676, 4048.554658987509, 4065.4918135233097, 4075.59244075596, 4077.9193513718888, 4378.934315985262, 4778.713277203379, 4818.132736107465, 5535.391106978229, 5601.467860553241, 5835.066389377679, 6063.696815159225, 6084.239470066242, 1217.829503869459, 1246.2896149195053, 1302.2902518127644, 1313.40240190713, 1397.7204559088223, 673.2089794491453, 710.5061981922618, 827.8096037911314, 853.9069990412282, 857.0229937870832, 4020.1507306639273, 4287.614114729689, 4724.574788269004, 4767.475577686451, 4770.7339013968085, 4304.655627549789, 4657.4876763555985, 5015.874603134951, 5104.41299250591, 5252.921206181911, 3990.481237439172, 4161.708680392343, 4175.181752317174, 4487.596116349544, 4742.715437073786, 2154.6210425327804, 2328.650702394654, 2446.907893750853, 2594.571895637199, 2637.3933995181214, 4940.382452193476, 4973.875653108629, 4982.427020892571, 5375.543078838265, 5395.892082158335, 4753.928691069636, 5024.849254522297, 5258.737902903275, 5359.678419294854, 5361.150403110921, 4443.422355093881, 4587.3348364486965, 5305.363356397257, 5306.442823503631, 5337.599680023936, 4280.229558679468, 4547.067851090585, 4848.418189817104, 5199.584033277253, 5260.658057226268, 4230.767307798101, 4720.881977950441, 4836.5490352893285, 5140.922886156785, 5153.711572106973, 4523.5250298719475, 5290.920636190537, 5296.193017700625, 5357.973210133924, 5369.912300427191, 3534.6642069003406, 3535.8408871600327, 3537.823108844496, 3558.733095017832, 3565.28694261154, 4581.297034749514, 4817.78319975609, 4927.704337739747, 4948.851534453972, 5153.974230128975, 4949.6287778416045, 5152.510511501401, 5808.099744539603, 5912.172295878667, 5920.615160014585, 5189.495046436491, 5889.791328251906, 5929.555283353852, 5985.491233245223, 6029.849253768691, 5590.692511911884, 5739.053056245672, 5817.2146760188525, 5842.474177324061, 5872.765089396547, 4526.049529598689, 5287.576993840406, 5848.4151584841175, 5905.763769449174, 5981.581289309881, 5607.467290607386, 5843.444872737083, 5858.51013319329, 5865.677387743715, 5895.351511333835], "value": 4015.3848665215405, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.842013706642, 689.4691087862343, 700.3871612339207, 729.58049121755, 784.3293983643985, 15313.540593782176, 16399.344026238938, 16410.015399076063, 16413.343466261365, 16424.917875410636, 14647.0, 14804.777928331083, 14809.555713328591, 14842.406303747865, 14854.554363369089, 663.3797399431522, 770.7649167004062, 832.309183377798, 857.215647682373, 878.6924576398274, 761.9923800762004, 830.5971603772166, 865.0873328638285, 872.8472517309445, 875.2385424680537, 915.995420022899, 922.5202894494893, 923.4966943016072, 923.6582464488149, 925.4493576322111, 897.3539051882634, 910.7905181808155, 912.2382810353363, 912.8676341930416, 913.6619450803246, 684.5276759036299, 684.5824047331124, 685.0101603183402, 686.2691233835999, 687.5874475314821, 15224.314905829153, 15272.083674979425, 15290.311935962909, 15297.847021529753, 15303.311350989232, 14719.92640036793, 14733.410663573444, 14763.483278085323, 14813.629659258497, 14990.400383984628, 11907.761844763143, 12050.638480845588, 12253.0, 12273.38633068343, 12529.310887901162, 3707.9629203707887, 3786.9621303786885, 3966.3058964681354, 4019.41718450823, 4019.4573732546023, 114831.0, 115281.4235928815, 116341.0, 118687.0, 126807.36596317052, 11277.887221127849, 11328.376939268255, 11376.772464550662, 11486.540538378371, 11776.646700598996, 24132.87933560321, 24165.516689666107, 24195.032198712208, 24245.39386515316, 24272.393190170387, 7388.113426388868, 7691.077070751546, 7711.151773304932, 7780.249443875196, 7864.842703145905, 4357.0, 4433.4119399280125, 4442.800073996678, 4473.821047158077, 4547.954520454753, 3360.7311415086733, 3447.5345828312857, 3503.2818272254126, 3507.438809790421, 3510.420780571177, 545.5090418623191, 592.9021711417654, 636.4939872801134, 657.5660064357501, 661.9304972977865, 547.2146772925747, 607.4077774170149, 614.7633161232958, 618.9164462797464, 625.777848863656, 8882.718956840852, 8891.19979201875, 8964.282857371394, 9051.502167380726, 9138.99471058183, 546.4890327543759, 569.834747923106, 605.1739375752155, 619.6715740657459, 620.6989610039127, 3780.962190378061, 4159.750414975111, 4218.451601291874, 4358.694891357638, 4452.287633978548, 101807.0, 112647.43676281566, 148522.0, 151960.200994976, 161372.0, 83652.16347836565, 84004.15995839963, 107379.0, 136584.43908926478, 140000.0, 66008.66995664992, 98882.0, 105703.12929659548, 107769.0, 111097.44451277853, 9528.467131429303, 9818.0291992686, 10062.446565438679, 10113.949430252802, 10194.337368071052, 61229.38770612237, 61722.38277617166, 62674.686626566574, 64212.53620623485, 64826.35173648392, 91862.0, 93901.5304923471, 95472.0452795491, 95808.52095739476, 97673.51163244138, 13743.587692369245, 14357.353919073457, 14541.781873271697, 14567.125972441687, 14712.264386780404, 13514.851237644518, 14913.552593422215, 15439.150846703089, 15476.0, 16097.275622597246, 13522.79715804244, 13723.519676811264, 13747.312634368442, 13789.51736689211, 13814.328760606155, 14192.290385480892, 14433.20617366013, 14503.419863205354, 14514.564563063124, 15058.397664093753, 13034.674133146747, 13099.738005240033, 13144.079914406282, 13194.472221111431, 13467.326633668474, 11031.282966607145, 11582.0, 11697.12271579652, 11740.471678774646, 11883.465244064211, 11630.244034137753, 11762.411879406167, 11834.349110798988, 11834.467448964646, 11852.111091667986], "value": 7840.093669846466, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1600.3000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 116.0, 117.0, 114.0, 118.0, 119.0, 117.0, 118.0, 124.0, 132.0], "value": 118.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 94.0, 122.0, 198.0, 95.0, 139.0, 118.0, 136.0, 160.0, 144.0], "value": 133.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 206.0, 206.0, 242.0, 278.0, 198.0, 189.0, 196.0, 197.0, 190.0], "value": 209.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 80.0, 77.0, 143.0, 58.0, 59.0, 55.0, 60.0, 136.0, 57.0], "value": 79.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 104.0, 103.0, 102.0, 108.0, 115.0, 69.0, 85.0, 115.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 76.0, 130.0, 135.0, 86.0, 89.0, 87.0, 80.0, 128.0], "value": 98.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 98.0, 98.0, 101.0, 100.0, 99.0, 117.0, 130.0, 99.0, 100.0], "value": 104.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 153.0, 150.0, 94.0, 91.0, 91.0, 117.0, 90.0, 91.0, 90.0], "value": 104.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 57.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 71.0, 61.0, 94.0, 112.0, 109.0, 102.0, 74.0, 71.0, 72.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 93.0, 89.0, 87.0, 87.0, 85.0, 86.0, 91.0, 86.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 165.0, 133.0, 181.0, 168.0, 154.0, 155.0, 153.0, 196.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 200.0, 241.0, 238.0, 179.0, 170.0, 173.0, 174.0, 176.0], "value": 189.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 84.0, 79.0, 68.0, 58.0, 86.0, 89.0, 81.0, 68.0], "value": 75.0, "unit": "score"}]}]} 00:51:53 INFO - Return code: 0 00:51:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:51:53 ERROR - # TBPL SUCCESS # 00:51:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:51:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:51:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:51:53 INFO - 2016-09-02 00:51:53.895 screenresolution[1676:10511] starting screenresolution argv=screenresolution get 00:51:53 INFO - 2016-09-02 00:51:53.898 screenresolution[1676:10511] Display 0: 1600x1200x32@60 00:51:53 INFO - 2016-09-02 00:51:53.904 screenresolution[1677:10514] starting screenresolution argv=screenresolution list 00:51:53 INFO - Available Modes on Display 0 00:51:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:51:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:51:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:51:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:51:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:51:54 INFO - Intel Iris: 00:51:54 INFO - Chipset Model: Intel Iris 00:51:54 INFO - Type: GPU 00:51:54 INFO - Bus: Built-In 00:51:54 INFO - VRAM (Dynamic, Max): 1536 MB 00:51:54 INFO - Vendor: Intel (0x8086) 00:51:54 INFO - Device ID: 0x0a2e 00:51:54 INFO - Revision ID: 0x0009 00:51:54 INFO - Displays: 00:51:54 INFO - Display: 00:51:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:51:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:51:54 INFO - Display Serial Number: 1600x1200 60 00:51:54 INFO - Main Display: Yes 00:51:54 INFO - Mirror: Off 00:51:54 INFO - Online: Yes 00:51:54 INFO - Rotation: Supported 00:51:54 INFO - Return code: 0 00:51:54 INFO - Running post-action listener: _resource_record_post_action 00:51:54 INFO - [mozharness: 2016-09-02 07:51:54.143839Z] Finished run-tests step (success) 00:51:54 INFO - Running post-run listener: _resource_record_post_run 00:51:54 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 38654976; Write bytes: 708372480; Read time: 377; Write time: 1982 00:51:54 INFO - TinderboxPrint: CPU usage
54.7% 00:51:54 INFO - TinderboxPrint: I/O read bytes / time
38,654,976 / 377 00:51:54 INFO - TinderboxPrint: I/O write bytes / time
708,372,480 / 1,982 00:51:54 INFO - TinderboxPrint: CPU idle
2,194.1 (45.3%) 00:51:54 INFO - TinderboxPrint: CPU system
980.0 (20.2%) 00:51:54 INFO - TinderboxPrint: CPU user
1,667.6 (34.4%) 00:51:54 INFO - TinderboxPrint: Swap in / out
444,547,072 / 0 00:51:54 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 400984576; Write bytes: 395683840; Read time: 29744; Write time: 764 00:51:54 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 36541440; Write bytes: 297873408; Read time: 352; Write time: 1180 00:51:54 INFO - Running post-run listener: _upload_blobber_files 00:51:54 INFO - Blob upload gear active. 00:51:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:51:54 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 00:51:54 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:51:54 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:51:55 INFO - (blobuploader) - INFO - Open directory for files ... 00:51:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:51:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:51:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:51:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:51:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:51:56 INFO - (blobuploader) - INFO - Done attempting. 00:51:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:51:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:51:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:51:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:51:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:51:57 INFO - (blobuploader) - INFO - Done attempting. 00:51:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:51:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:51:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:51:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:51:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:51:59 INFO - (blobuploader) - INFO - Done attempting. 00:51:59 INFO - (blobuploader) - INFO - Iteration through files over. 00:51:59 INFO - Return code: 0 00:51:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:51:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:51:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2cc27affd90b3710782176fa16246b47a163b20355714f5a605d8c137d332cc255428ac51b6b027de4765752276a7cdeeda6619345b0c5eddf6809e0957b97e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/362c65cb10265b17b00f84d6f2173d7c0272de0158e0e6bf2eeeba6d0b2a4be4052ac4681069208c9c0a3ed90c10d022a8526dd8ccb5958a2c9c98096c876f34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e044e76fa0534cf5ac9f253cfb5fb1d8864fb0b332accc101b718a9cb26cfc4b958fac2bccd6ed5d9a09fd5587cf6797beefea8c5383b7ee5729031254a702c"} 00:51:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:51:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:51:59 INFO - Contents: 00:51:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2cc27affd90b3710782176fa16246b47a163b20355714f5a605d8c137d332cc255428ac51b6b027de4765752276a7cdeeda6619345b0c5eddf6809e0957b97e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/362c65cb10265b17b00f84d6f2173d7c0272de0158e0e6bf2eeeba6d0b2a4be4052ac4681069208c9c0a3ed90c10d022a8526dd8ccb5958a2c9c98096c876f34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e044e76fa0534cf5ac9f253cfb5fb1d8864fb0b332accc101b718a9cb26cfc4b958fac2bccd6ed5d9a09fd5587cf6797beefea8c5383b7ee5729031254a702c"} 00:51:59 INFO - Running post-run listener: copy_logs_to_upload_dir 00:51:59 INFO - Copying logs to upload dir... 00:51:59 INFO - mkdir: /builds/slave/test/build/upload/logs 00:51:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.133175 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-02 00:52:00.032258) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 00:52:00.036118) ========= 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.7qxgP4AvJV/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.ifKWcFtJh2/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2cc27affd90b3710782176fa16246b47a163b20355714f5a605d8c137d332cc255428ac51b6b027de4765752276a7cdeeda6619345b0c5eddf6809e0957b97e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/362c65cb10265b17b00f84d6f2173d7c0272de0158e0e6bf2eeeba6d0b2a4be4052ac4681069208c9c0a3ed90c10d022a8526dd8ccb5958a2c9c98096c876f34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e044e76fa0534cf5ac9f253cfb5fb1d8864fb0b332accc101b718a9cb26cfc4b958fac2bccd6ed5d9a09fd5587cf6797beefea8c5383b7ee5729031254a702c"} build_url:https://queue.taskcluster.net/v1/task/VYSpcX1PRzuPiuYgiap7iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010991 build_url: 'https://queue.taskcluster.net/v1/task/VYSpcX1PRzuPiuYgiap7iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2cc27affd90b3710782176fa16246b47a163b20355714f5a605d8c137d332cc255428ac51b6b027de4765752276a7cdeeda6619345b0c5eddf6809e0957b97e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/362c65cb10265b17b00f84d6f2173d7c0272de0158e0e6bf2eeeba6d0b2a4be4052ac4681069208c9c0a3ed90c10d022a8526dd8ccb5958a2c9c98096c876f34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e044e76fa0534cf5ac9f253cfb5fb1d8864fb0b332accc101b718a9cb26cfc4b958fac2bccd6ed5d9a09fd5587cf6797beefea8c5383b7ee5729031254a702c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 00:52:00.069574) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 00:52:00.069961) ========= 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.7qxgP4AvJV/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.ifKWcFtJh2/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.004890 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 00:52:00.118892) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 00:52:00.119247) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 00:52:00.119630) ========= ========= Total master_lag: 0.17 =========