builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0259 starttime: 1472924350.13 results: success (0) buildid: 20160903071749 builduid: 63f212c225e14be9917090e32f177c6e revision: bcab45259b4fe5787d0d6fea16067e763f2a11ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-03 10:39:10.129303) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-03 10:39:10.129700) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-03 10:39:10.130048) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-03 10:39:10.154997) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 10:39:10.155281) ========= 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.vvT5GSRe3N/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.zl0fbZdoCa/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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-03 10:39:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 29.9M=0s 2016-09-03 10:39:10 (29.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.579692 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 10:39:10.800997) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 10:39:10.801309) ========= 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.vvT5GSRe3N/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.zl0fbZdoCa/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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.025194 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 10:39:10.852789) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-03 10:39:10.853123) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bcab45259b4fe5787d0d6fea16067e763f2a11ea --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 bcab45259b4fe5787d0d6fea16067e763f2a11ea --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vvT5GSRe3N/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.zl0fbZdoCa/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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-03 10:39:10,945 truncating revision to first 12 chars 2016-09-03 10:39:10,945 Setting DEBUG logging. 2016-09-03 10:39:10,945 attempt 1/10 2016-09-03 10:39:10,945 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bcab45259b4f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-03 10:39:11,923 unpacking tar archive at: fx-team-bcab45259b4f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.248474 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-03 10:39:12.123911) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-03 10:39:12.124233) ========= script_repo_revision: bcab45259b4fe5787d0d6fea16067e763f2a11ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-03 10:39:12.124641) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-03 10:39:12.124916) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-03 10:39:12.143616) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-03 10:39:12.143882) ========= /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.vvT5GSRe3N/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.zl0fbZdoCa/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 10:39:12 INFO - MultiFileLogger online at 20160903 10:39:12 in /builds/slave/test 10:39:12 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 10:39:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:39:12 INFO - {'append_to_log': False, 10:39:12 INFO - 'base_work_dir': '/builds/slave/test', 10:39:12 INFO - 'blob_upload_branch': 'Fx-Team', 10:39:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:39:12 INFO - 'branch': 'Fx-Team', 10:39:12 INFO - 'buildbot_json_path': 'buildprops.json', 10:39:12 INFO - 'config_files': ('talos/mac_config.py',), 10:39:12 INFO - 'default_actions': ('clobber', 10:39:12 INFO - 'read-buildbot-config', 10:39:12 INFO - 'download-and-extract', 10:39:12 INFO - 'populate-webroot', 10:39:12 INFO - 'create-virtualenv', 10:39:12 INFO - 'install', 10:39:12 INFO - 'run-tests'), 10:39:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:39:12 INFO - 'download_minidump_stackwalk': True, 10:39:12 INFO - 'download_symbols': 'ondemand', 10:39:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:39:12 INFO - 'tooltool.py': '/tools/tooltool.py', 10:39:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:39:12 INFO - '/tools/misc-python/virtualenv.py')}, 10:39:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:39:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:39:12 INFO - 'installer_path': 'installer.exe', 10:39:12 INFO - 'log_level': 'info', 10:39:12 INFO - 'log_name': 'talos', 10:39:12 INFO - 'log_to_console': True, 10:39:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:39:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:39:12 INFO - 'opt_config_files': (), 10:39:12 INFO - 'pip_index': False, 10:39:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:39:12 INFO - 'cmd': ('bash', 10:39:12 INFO - '-c', 10:39:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:39:12 INFO - 'enabled': True, 10:39:12 INFO - 'halt_on_failure': False, 10:39:12 INFO - 'name': 'check_screen_resolution'},), 10:39:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:39:12 INFO - 'cmd': ('bash', 10:39:12 INFO - '-c', 10:39:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:39:12 INFO - 'enabled': True, 10:39:12 INFO - 'halt_on_failure': False, 10:39:12 INFO - 'name': 'check_screen_resolution'},), 10:39:12 INFO - 'run_cmd_checks_enabled': True, 10:39:12 INFO - 'sps_profile': False, 10:39:12 INFO - 'sps_profile_interval': 0, 10:39:12 INFO - 'suite': 'dromaeojs-e10s', 10:39:12 INFO - 'system_bits': '32', 10:39:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:39:12 INFO - 'title': 't-yosemite-r7-0259', 10:39:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:39:12 INFO - 'use_talos_json': True, 10:39:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:39:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:39:12 INFO - 'work_dir': 'build'} 10:39:12 INFO - [mozharness: 2016-09-03 17:39:12.348290Z] Running clobber step. 10:39:12 INFO - Running pre-action listener: _resource_record_pre_action 10:39:12 INFO - Running main action method: clobber 10:39:12 INFO - rmtree: /builds/slave/test/build 10:39:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:39:14 INFO - Running post-action listener: _resource_record_post_action 10:39:14 INFO - [mozharness: 2016-09-03 17:39:14.567354Z] Finished clobber step (success) 10:39:14 INFO - [mozharness: 2016-09-03 17:39:14.567612Z] Running read-buildbot-config step. 10:39:14 INFO - Running pre-action listener: _resource_record_pre_action 10:39:14 INFO - Running main action method: read_buildbot_config 10:39:14 INFO - Using buildbot properties: 10:39:14 INFO - { 10:39:14 INFO - "project": "", 10:39:14 INFO - "product": "firefox", 10:39:14 INFO - "script_repo_revision": "production", 10:39:14 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 10:39:14 INFO - "repository": "", 10:39:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 10:39:14 INFO - "buildid": "20160903071749", 10:39:14 INFO - "pgo_build": "False", 10:39:14 INFO - "basedir": "/builds/slave/test", 10:39:14 INFO - "buildnumber": 106, 10:39:14 INFO - "slavename": "t-yosemite-r7-0259", 10:39:14 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:39:14 INFO - "platform": "yosemite_r7", 10:39:14 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 10:39:14 INFO - "branch": "fx-team", 10:39:14 INFO - "repo_path": "integration/fx-team", 10:39:14 INFO - "revision": "bcab45259b4fe5787d0d6fea16067e763f2a11ea", 10:39:14 INFO - "stage_platform": "macosx64", 10:39:14 INFO - "builduid": "63f212c225e14be9917090e32f177c6e", 10:39:14 INFO - "slavebuilddir": "test" 10:39:14 INFO - } 10:39:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/PGFUous9SA6YVGtP76ma4A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 10:39:14 INFO - Running post-action listener: _resource_record_post_action 10:39:14 INFO - [mozharness: 2016-09-03 17:39:14.573432Z] Finished read-buildbot-config step (success) 10:39:14 INFO - [mozharness: 2016-09-03 17:39:14.573683Z] Running download-and-extract step. 10:39:14 INFO - Running pre-action listener: _resource_record_pre_action 10:39:14 INFO - Running main action method: download_and_extract 10:39:14 INFO - mkdir: /builds/slave/test/build/tests 10:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:14 INFO - trying https://queue.taskcluster.net/v1/task/PGFUous9SA6YVGtP76ma4A/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 10:39:14 INFO - Downloading https://queue.taskcluster.net/v1/task/PGFUous9SA6YVGtP76ma4A/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 10:39:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PGFUous9SA6YVGtP76ma4A/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 10:39:15 INFO - Downloaded 1199 bytes. 10:39:15 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 10:39:15 INFO - Using the following test package requirements: 10:39:15 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:39:15 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:39:15 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 10:39:15 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:39:15 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 10:39:15 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:39:15 INFO - u'jsshell-mac.zip'], 10:39:15 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:39:15 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 10:39:15 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:39:15 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:39:15 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 10:39:15 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:39:15 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 10:39:15 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:39:15 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 10:39:15 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:39:15 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 10:39:15 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:39:15 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')]} 10:39:15 INFO - trying https://queue.taskcluster.net/v1/task/PGFUous9SA6YVGtP76ma4A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:39:15 INFO - Downloading https://queue.taskcluster.net/v1/task/PGFUous9SA6YVGtP76ma4A/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 10:39:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PGFUous9SA6YVGtP76ma4A/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 10:39:16 INFO - Downloaded 16399977 bytes. 10:39:16 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 10:39:23 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 10:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:23 INFO - trying https://queue.taskcluster.net/v1/task/PGFUous9SA6YVGtP76ma4A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:39:23 INFO - Downloading https://queue.taskcluster.net/v1/task/PGFUous9SA6YVGtP76ma4A/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 10:39:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PGFUous9SA6YVGtP76ma4A/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 10:39:24 INFO - Downloaded 16399977 bytes. 10:39:24 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 10:39:31 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')]} 10:39:31 INFO - trying https://queue.taskcluster.net/v1/task/PGFUous9SA6YVGtP76ma4A/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 10:39:31 INFO - Downloading https://queue.taskcluster.net/v1/task/PGFUous9SA6YVGtP76ma4A/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 10:39:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PGFUous9SA6YVGtP76ma4A/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 10:39:32 INFO - Downloaded 14413998 bytes. 10:39:32 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 10:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:32 INFO - trying https://queue.taskcluster.net/v1/task/PGFUous9SA6YVGtP76ma4A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:39:32 INFO - Downloading https://queue.taskcluster.net/v1/task/PGFUous9SA6YVGtP76ma4A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 10:39:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PGFUous9SA6YVGtP76ma4A/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 10:39:35 INFO - Downloaded 111491114 bytes. 10:39:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PGFUous9SA6YVGtP76ma4A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:39:35 INFO - mkdir: /builds/slave/test/properties 10:39:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:39:35 INFO - Writing to file /builds/slave/test/properties/build_url 10:39:35 INFO - Contents: 10:39:35 INFO - build_url:https://queue.taskcluster.net/v1/task/PGFUous9SA6YVGtP76ma4A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:39:36 INFO - Running post-action listener: _resource_record_post_action 10:39:36 INFO - Running post-action listener: set_extra_try_arguments 10:39:36 INFO - [mozharness: 2016-09-03 17:39:36.045508Z] Finished download-and-extract step (success) 10:39:36 INFO - [mozharness: 2016-09-03 17:39:36.045627Z] Running populate-webroot step. 10:39:36 INFO - Running pre-action listener: _resource_record_pre_action 10:39:36 INFO - Running main action method: populate_webroot 10:39:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:39:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:39:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:39:36 INFO - '--tppagecycles', 10:39:36 INFO - '7'], 10:39:36 INFO - 'tests': ['tsvgm']}}, 10:39:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:39:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:39:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:39:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:39:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:39:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:39:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:36 INFO - 'talos_options': ['--disable-e10s'], 10:39:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:39:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:39:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:36 INFO - 'talos_options': ['--disable-e10s'], 10:39:36 INFO - 'tests': ['damp', 'tps']}, 10:39:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:36 INFO - 'tests': ['damp', 'tps']}, 10:39:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:39:36 INFO - 'tests': ['dromaeo_dom']}, 10:39:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:39:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:39:36 INFO - 'tests': ['basic_compositor_video']}, 10:39:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:39:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:39:36 INFO - 'tests': ['a11yr', 10:39:36 INFO - 'ts_paint', 10:39:36 INFO - 'tpaint', 10:39:36 INFO - 'sessionrestore', 10:39:36 INFO - 'sessionrestore_no_auto_restore', 10:39:36 INFO - 'tabpaint']}, 10:39:36 INFO - 'other-e10s': {'tests': ['a11yr', 10:39:36 INFO - 'ts_paint', 10:39:36 INFO - 'tpaint', 10:39:36 INFO - 'sessionrestore', 10:39:36 INFO - 'sessionrestore_no_auto_restore', 10:39:36 INFO - 'tabpaint']}, 10:39:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:39:36 INFO - 'ts_paint', 10:39:36 INFO - 'tpaint', 10:39:36 INFO - 'sessionrestore', 10:39:36 INFO - 'sessionrestore_no_auto_restore', 10:39:36 INFO - 'tabpaint']}, 10:39:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:39:36 INFO - 'ts_paint', 10:39:36 INFO - 'tpaint', 10:39:36 INFO - 'sessionrestore', 10:39:36 INFO - 'sessionrestore_no_auto_restore', 10:39:36 INFO - 'tabpaint']}, 10:39:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:39:36 INFO - 'tests': ['a11yr', 10:39:36 INFO - 'ts_paint', 10:39:36 INFO - 'tpaint', 10:39:36 INFO - 'sessionrestore', 10:39:36 INFO - 'sessionrestore_no_auto_restore', 10:39:36 INFO - 'tabpaint']}, 10:39:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:39:36 INFO - 'tests': ['a11yr', 10:39:36 INFO - 'ts_paint', 10:39:36 INFO - 'tpaint', 10:39:36 INFO - 'sessionrestore', 10:39:36 INFO - 'sessionrestore_no_auto_restore', 10:39:36 INFO - 'tabpaint']}, 10:39:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:39:36 INFO - 'tests': ['tsvgx', 10:39:36 INFO - 'tsvgr_opacity', 10:39:36 INFO - 'tart', 10:39:36 INFO - 'tscrollx', 10:39:36 INFO - 'cart']}, 10:39:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:39:36 INFO - 'tsvgr_opacity', 10:39:36 INFO - 'tart', 10:39:36 INFO - 'tscrollx', 10:39:36 INFO - 'cart']}, 10:39:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:36 INFO - 'talos_options': ['--disable-e10s'], 10:39:36 INFO - 'tests': ['tp5o']}, 10:39:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:36 INFO - 'tests': ['tp5o']}, 10:39:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:36 INFO - 'talos_options': ['--disable-e10s', 10:39:36 INFO - '--xperf_path', 10:39:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:39:36 INFO - 'tests': ['tp5n']}, 10:39:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:36 INFO - 'talos_options': ['--xperf_path', 10:39:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:39:36 INFO - 'tests': ['tp5n']}}, 10:39:36 INFO - 'talos.zip': {'path': '', 10:39:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:39:36 INFO - Running post-action listener: _resource_record_post_action 10:39:36 INFO - [mozharness: 2016-09-03 17:39:36.064868Z] Finished populate-webroot step (success) 10:39:36 INFO - [mozharness: 2016-09-03 17:39:36.064983Z] Running create-virtualenv step. 10:39:36 INFO - Running pre-action listener: _resource_record_pre_action 10:39:36 INFO - Running main action method: create_virtualenv 10:39:36 INFO - Creating virtualenv /builds/slave/test/build/venv 10:39:36 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 10:39:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:39:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:39:36 INFO - Using real prefix '/tools/python27' 10:39:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:39:36 INFO - Installing distribute.............................................................................................................................................................................................done. 10:39:39 INFO - Installing pip.................done. 10:39:39 INFO - Return code: 0 10:39:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11052ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe73ad9abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048fd30>, '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 0x1101f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110487b20>, '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.vvT5GSRe3N/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.zl0fbZdoCa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 10:39:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:39:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:39:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vvT5GSRe3N/Render', 10:39:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:39 INFO - 'HOME': '/Users/cltbld', 10:39:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:39 INFO - 'LOGNAME': 'cltbld', 10:39:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:39 INFO - 'MOZ_NO_REMOTE': '1', 10:39:39 INFO - 'NO_EM_RESTART': '1', 10:39:39 INFO - 'PAGER': '/bin/cat', 10:39:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:39 INFO - 'PWD': '/builds/slave/test', 10:39:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:39 INFO - 'SHELL': '/bin/bash', 10:39:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zl0fbZdoCa/Listeners', 10:39:39 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 10:39:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:39 INFO - 'USER': 'cltbld', 10:39:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:39 INFO - 'XPC_FLAGS': '0x0', 10:39:39 INFO - 'XPC_SERVICE_NAME': '0', 10:39:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:40 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 10:39:40 INFO - Cleaning up... 10:39:40 INFO - Return code: 0 10:39:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:39:40 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')]} 10:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:40 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')]} 10:39:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:40 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 0x11052ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe73ad9abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048fd30>, '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 0x1101f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110487b20>, '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.vvT5GSRe3N/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.zl0fbZdoCa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 10:39:40 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 10:39:40 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 10:39:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vvT5GSRe3N/Render', 10:39:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:40 INFO - 'HOME': '/Users/cltbld', 10:39:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:40 INFO - 'LOGNAME': 'cltbld', 10:39:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:40 INFO - 'MOZ_NO_REMOTE': '1', 10:39:40 INFO - 'NO_EM_RESTART': '1', 10:39:40 INFO - 'PAGER': '/bin/cat', 10:39:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:40 INFO - 'PWD': '/builds/slave/test', 10:39:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:40 INFO - 'SHELL': '/bin/bash', 10:39:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zl0fbZdoCa/Listeners', 10:39:40 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 10:39:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:40 INFO - 'USER': 'cltbld', 10:39:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:40 INFO - 'XPC_FLAGS': '0x0', 10:39:40 INFO - 'XPC_SERVICE_NAME': '0', 10:39:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:40 INFO - Downloading/unpacking psutil>=3.1.1 10:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:39:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:39:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:39:43 INFO - Installing collected packages: psutil 10:39:43 INFO - Running setup.py install for psutil 10:39:44 INFO - building 'psutil._psutil_osx' extension 10:39:44 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 10:39:44 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 10:39:44 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 10:39:44 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 10:39:44 INFO - building 'psutil._psutil_posix' extension 10:39:44 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 10:39:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:39:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:39:44 INFO - ^ 10:39:44 INFO - 1 warning generated. 10:39:44 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 10:39:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:39:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:39:45 INFO - Successfully installed psutil 10:39:45 INFO - Cleaning up... 10:39:45 INFO - Return code: 0 10:39:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:45 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 0x11052ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe73ad9abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048fd30>, '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 0x1101f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110487b20>, '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.vvT5GSRe3N/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.zl0fbZdoCa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 10:39:45 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 10:39:45 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 10:39:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vvT5GSRe3N/Render', 10:39:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:45 INFO - 'HOME': '/Users/cltbld', 10:39:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:45 INFO - 'LOGNAME': 'cltbld', 10:39:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:45 INFO - 'MOZ_NO_REMOTE': '1', 10:39:45 INFO - 'NO_EM_RESTART': '1', 10:39:45 INFO - 'PAGER': '/bin/cat', 10:39:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:45 INFO - 'PWD': '/builds/slave/test', 10:39:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:45 INFO - 'SHELL': '/bin/bash', 10:39:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zl0fbZdoCa/Listeners', 10:39:45 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 10:39:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:45 INFO - 'USER': 'cltbld', 10:39:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:45 INFO - 'XPC_FLAGS': '0x0', 10:39:45 INFO - 'XPC_SERVICE_NAME': '0', 10:39:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:39:45 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 10:39:45 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 10:39:45 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 10:39:45 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 10:39:45 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 10:39:45 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 10:39:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:39:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:39:47 INFO - Installing collected packages: mozsystemmonitor 10:39:47 INFO - Running setup.py install for mozsystemmonitor 10:39:48 INFO - Successfully installed mozsystemmonitor 10:39:48 INFO - Cleaning up... 10:39:48 INFO - Return code: 0 10:39:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:39:48 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')]} 10:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:48 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')]} 10:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:48 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 0x11052ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe73ad9abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048fd30>, '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 0x1101f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110487b20>, '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.vvT5GSRe3N/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.zl0fbZdoCa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 10:39:48 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 10:39:48 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 10:39:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vvT5GSRe3N/Render', 10:39:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:48 INFO - 'HOME': '/Users/cltbld', 10:39:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:48 INFO - 'LOGNAME': 'cltbld', 10:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:48 INFO - 'MOZ_NO_REMOTE': '1', 10:39:48 INFO - 'NO_EM_RESTART': '1', 10:39:48 INFO - 'PAGER': '/bin/cat', 10:39:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:48 INFO - 'PWD': '/builds/slave/test', 10:39:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:48 INFO - 'SHELL': '/bin/bash', 10:39:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zl0fbZdoCa/Listeners', 10:39:48 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 10:39:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:48 INFO - 'USER': 'cltbld', 10:39:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:48 INFO - 'XPC_FLAGS': '0x0', 10:39:48 INFO - 'XPC_SERVICE_NAME': '0', 10:39:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:48 INFO - Downloading/unpacking jsonschema==2.5.1 10:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:39:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:39:50 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 10:39:50 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 10:39:50 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 10:39:50 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 10:39:50 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 10:39:50 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 10:39:51 INFO - Downloading functools32-3.2.3-2.tar.gz 10:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:39:51 INFO - warning: no files found matching '*.txt' 10:39:51 INFO - no previously-included directories found matching 'build' 10:39:51 INFO - no previously-included directories found matching 'dist' 10:39:51 INFO - no previously-included directories found matching '.git*' 10:39:51 INFO - Installing collected packages: jsonschema, functools32 10:39:51 INFO - Running setup.py install for functools32 10:39:51 INFO - warning: no files found matching '*.txt' 10:39:51 INFO - no previously-included directories found matching 'build' 10:39:51 INFO - no previously-included directories found matching 'dist' 10:39:51 INFO - no previously-included directories found matching '.git*' 10:39:51 INFO - Successfully installed jsonschema functools32 10:39:51 INFO - Cleaning up... 10:39:51 INFO - Return code: 0 10:39:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:39: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')]} 10:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39: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')]} 10:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11052ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe73ad9abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048fd30>, '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 0x1101f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110487b20>, '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.vvT5GSRe3N/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.zl0fbZdoCa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 10:39:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:39:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vvT5GSRe3N/Render', 10:39:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:51 INFO - 'HOME': '/Users/cltbld', 10:39:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:51 INFO - 'LOGNAME': 'cltbld', 10:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:51 INFO - 'MOZ_NO_REMOTE': '1', 10:39:51 INFO - 'NO_EM_RESTART': '1', 10:39:51 INFO - 'PAGER': '/bin/cat', 10:39:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:51 INFO - 'PWD': '/builds/slave/test', 10:39:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:51 INFO - 'SHELL': '/bin/bash', 10:39:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zl0fbZdoCa/Listeners', 10:39:51 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 10:39:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:51 INFO - 'USER': 'cltbld', 10:39:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:51 INFO - 'XPC_FLAGS': '0x0', 10:39:51 INFO - 'XPC_SERVICE_NAME': '0', 10:39:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:39:51 INFO - Cleaning up... 10:39:51 INFO - Return code: 0 10:39:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:39: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')]} 10:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39: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')]} 10:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11052ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe73ad9abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048fd30>, '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 0x1101f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110487b20>, '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.vvT5GSRe3N/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.zl0fbZdoCa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 10:39:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:39:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vvT5GSRe3N/Render', 10:39:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:51 INFO - 'HOME': '/Users/cltbld', 10:39:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:51 INFO - 'LOGNAME': 'cltbld', 10:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:51 INFO - 'MOZ_NO_REMOTE': '1', 10:39:51 INFO - 'NO_EM_RESTART': '1', 10:39:51 INFO - 'PAGER': '/bin/cat', 10:39:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:51 INFO - 'PWD': '/builds/slave/test', 10:39:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:51 INFO - 'SHELL': '/bin/bash', 10:39:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zl0fbZdoCa/Listeners', 10:39:51 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 10:39:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:51 INFO - 'USER': 'cltbld', 10:39:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:51 INFO - 'XPC_FLAGS': '0x0', 10:39:51 INFO - 'XPC_SERVICE_NAME': '0', 10:39:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:52 INFO - Downloading/unpacking blobuploader==1.2.4 10:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:54 INFO - Downloading blobuploader-1.2.4.tar.gz 10:39:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:39:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:39:54 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 10:39:54 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 10:39:54 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 10:39:54 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 10:39:54 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 10:39:54 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 10:39:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:39:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:39:55 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 10:39:55 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 10:39:55 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 10:39:55 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 10:39:55 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 10:39:55 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 10:39:55 INFO - Downloading docopt-0.6.1.tar.gz 10:39:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:39:55 INFO - Installing collected packages: blobuploader, requests, docopt 10:39:55 INFO - Running setup.py install for blobuploader 10:39:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:39:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:39:56 INFO - Running setup.py install for requests 10:39:56 INFO - Running setup.py install for docopt 10:39:56 INFO - Successfully installed blobuploader requests docopt 10:39:56 INFO - Cleaning up... 10:39:56 INFO - Return code: 0 10:39:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:56 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 0x11052ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe73ad9abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048fd30>, '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 0x1101f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110487b20>, '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.vvT5GSRe3N/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.zl0fbZdoCa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 10:39:56 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 10:39:56 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 10:39:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vvT5GSRe3N/Render', 10:39:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:56 INFO - 'HOME': '/Users/cltbld', 10:39:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:56 INFO - 'LOGNAME': 'cltbld', 10:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:56 INFO - 'MOZ_NO_REMOTE': '1', 10:39:56 INFO - 'NO_EM_RESTART': '1', 10:39:56 INFO - 'PAGER': '/bin/cat', 10:39:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:56 INFO - 'PWD': '/builds/slave/test', 10:39:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:56 INFO - 'SHELL': '/bin/bash', 10:39:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zl0fbZdoCa/Listeners', 10:39:56 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 10:39:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:56 INFO - 'USER': 'cltbld', 10:39:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:56 INFO - 'XPC_FLAGS': '0x0', 10:39:56 INFO - 'XPC_SERVICE_NAME': '0', 10:39:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:39:57 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-ZyJ8WN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:39:57 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-yJrXQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:39:57 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-CUy4Io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:39:57 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-mTsKx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:39:57 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-qQurQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:39:57 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-KbIDpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:39:57 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-glzQja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:39:57 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-4oXdGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:39:57 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-CF2SSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:39:58 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-8RNY1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:39:58 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-XrbPsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:39:58 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-F9oO41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:39:58 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-DC0LBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:39:58 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-pX8yHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:58 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-jZkn5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:39:58 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-3BVOVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:39:58 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-ONpsVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:39:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:39:58 INFO - Running setup.py install for manifestparser 10:39:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:39:59 INFO - Running setup.py install for mozcrash 10:39:59 INFO - Running setup.py install for mozdebug 10:39:59 INFO - Running setup.py install for mozdevice 10:39:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:39:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:39:59 INFO - Running setup.py install for mozfile 10:39:59 INFO - Running setup.py install for mozhttpd 10:39:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:39:59 INFO - Running setup.py install for mozinfo 10:39:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:39:59 INFO - Running setup.py install for mozInstall 10:39:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:39:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:39:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:39:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:40:00 INFO - Running setup.py install for mozleak 10:40:00 INFO - Running setup.py install for mozlog 10:40:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:40:00 INFO - Running setup.py install for moznetwork 10:40:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:40:00 INFO - Running setup.py install for mozprocess 10:40:00 INFO - Running setup.py install for mozprofile 10:40:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:40:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:40:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:40:00 INFO - Running setup.py install for mozrunner 10:40:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:40:00 INFO - Running setup.py install for mozscreenshot 10:40:01 INFO - Running setup.py install for moztest 10:40:01 INFO - Running setup.py install for mozversion 10:40:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:40:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:40:01 INFO - Cleaning up... 10:40:01 INFO - Return code: 0 10:40:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:40:01 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')]} 10:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:01 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')]} 10:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:01 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 0x11052ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe73ad9abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048fd30>, '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 0x1101f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110487b20>, '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.vvT5GSRe3N/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.zl0fbZdoCa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 10:40:01 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 10:40:01 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 10:40:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vvT5GSRe3N/Render', 10:40:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:40:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:40:01 INFO - 'HOME': '/Users/cltbld', 10:40:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:40:01 INFO - 'LOGNAME': 'cltbld', 10:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:01 INFO - 'MOZ_NO_REMOTE': '1', 10:40:01 INFO - 'NO_EM_RESTART': '1', 10:40:01 INFO - 'PAGER': '/bin/cat', 10:40:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:01 INFO - 'PWD': '/builds/slave/test', 10:40:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:40:01 INFO - 'SHELL': '/bin/bash', 10:40:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zl0fbZdoCa/Listeners', 10:40:01 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 10:40:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:40:01 INFO - 'USER': 'cltbld', 10:40:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:40:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:01 INFO - 'XPC_FLAGS': '0x0', 10:40:01 INFO - 'XPC_SERVICE_NAME': '0', 10:40:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:40:01 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-eaSeYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:40:01 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)) 10:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:40:01 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-grWR0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:40:01 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)) 10:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:40:01 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-5Y_16N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:40:02 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)) 10:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:40:02 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-p2a8P0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:40:02 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)) 10:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:40:02 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-h3rg0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:40:02 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)) 10:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:40:02 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-z70Odz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:40:02 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)) 10:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:40:02 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-m_qozY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:40:02 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)) 10:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:40:02 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-V2T7ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:40:02 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)) 10:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:40:02 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-s2Vrf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:40:02 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)) 10:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:40:02 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-rSO3US-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:40:02 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)) 10:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:40:02 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-PwzAKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:40:02 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)) 10:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:40:02 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-y4DgI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:40:02 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)) 10:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:40:02 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-fNnxCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:40:03 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)) 10:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:40:03 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-JtZVeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:40:03 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)) 10:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:40:03 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-H0E4yA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:40:03 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)) 10:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:40:03 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-mw5HOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:40:03 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)) 10:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:40:03 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-9tHW6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:40:03 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)) 10:40:03 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)) 10:40:03 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)) 10:40:03 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)) 10:40:03 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)) 10:40:03 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)) 10:40:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:05 INFO - Downloading blessings-1.6.tar.gz 10:40:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:40:06 INFO - Installing collected packages: blessings 10:40:06 INFO - Running setup.py install for blessings 10:40:06 INFO - Successfully installed blessings 10:40:06 INFO - Cleaning up... 10:40:06 INFO - Return code: 0 10:40:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:40:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:40:06 INFO - Reading from file tmpfile_stdout 10:40:06 INFO - Current package versions: 10:40:06 INFO - blessings == 1.6 10:40:06 INFO - blobuploader == 1.2.4 10:40:06 INFO - docopt == 0.6.1 10:40:06 INFO - functools32 == 3.2.3-2 10:40:06 INFO - jsonschema == 2.5.1 10:40:06 INFO - manifestparser == 1.1 10:40:06 INFO - mozInstall == 1.12 10:40:06 INFO - mozcrash == 0.17 10:40:06 INFO - mozdebug == 0.1 10:40:06 INFO - mozdevice == 0.48 10:40:06 INFO - mozfile == 1.2 10:40:06 INFO - mozhttpd == 0.7 10:40:06 INFO - mozinfo == 0.9 10:40:06 INFO - mozleak == 0.1 10:40:06 INFO - mozlog == 3.3 10:40:06 INFO - moznetwork == 0.27 10:40:06 INFO - mozprocess == 0.23 10:40:06 INFO - mozprofile == 0.28 10:40:06 INFO - mozrunner == 6.12 10:40:06 INFO - mozscreenshot == 0.1 10:40:06 INFO - mozsystemmonitor == 0.3 10:40:06 INFO - moztest == 0.7 10:40:06 INFO - mozversion == 1.4 10:40:06 INFO - psutil == 3.1.1 10:40:06 INFO - requests == 1.2.3 10:40:06 INFO - wsgiref == 0.1.2 10:40:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:06 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 0x11052ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe73ad9abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048fd30>, '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 0x1101f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110487b20>, '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.vvT5GSRe3N/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.zl0fbZdoCa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 10:40:06 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 10:40:06 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 10:40:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vvT5GSRe3N/Render', 10:40:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:40:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:40:06 INFO - 'HOME': '/Users/cltbld', 10:40:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:40:06 INFO - 'LOGNAME': 'cltbld', 10:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:06 INFO - 'MOZ_NO_REMOTE': '1', 10:40:06 INFO - 'NO_EM_RESTART': '1', 10:40:06 INFO - 'PAGER': '/bin/cat', 10:40:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:06 INFO - 'PWD': '/builds/slave/test', 10:40:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:40:06 INFO - 'SHELL': '/bin/bash', 10:40:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zl0fbZdoCa/Listeners', 10:40:06 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 10:40:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:40:06 INFO - 'USER': 'cltbld', 10:40:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:40:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:06 INFO - 'XPC_FLAGS': '0x0', 10:40:06 INFO - 'XPC_SERVICE_NAME': '0', 10:40:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:06 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)) 10:40:06 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)) 10:40:06 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)) 10:40:06 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)) 10:40:06 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)) 10:40:06 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)) 10:40:06 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)) 10:40:06 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)) 10:40:06 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)) 10:40:06 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)) 10:40:06 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)) 10:40:06 INFO - Cleaning up... 10:40:06 INFO - Return code: 0 10:40:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11052ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe73ad9abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048fd30>, '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 0x1101f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110487b20>, '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.vvT5GSRe3N/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.zl0fbZdoCa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 10:40:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:40:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vvT5GSRe3N/Render', 10:40:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:40:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:40:06 INFO - 'HOME': '/Users/cltbld', 10:40:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:40:06 INFO - 'LOGNAME': 'cltbld', 10:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:06 INFO - 'MOZ_NO_REMOTE': '1', 10:40:06 INFO - 'NO_EM_RESTART': '1', 10:40:06 INFO - 'PAGER': '/bin/cat', 10:40:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:06 INFO - 'PWD': '/builds/slave/test', 10:40:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:40:06 INFO - 'SHELL': '/bin/bash', 10:40:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zl0fbZdoCa/Listeners', 10:40:06 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 10:40:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:40:06 INFO - 'USER': 'cltbld', 10:40:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:40:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:06 INFO - 'XPC_FLAGS': '0x0', 10:40:06 INFO - 'XPC_SERVICE_NAME': '0', 10:40:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:40:07 INFO - Cleaning up... 10:40:07 INFO - Return code: 0 10:40:07 INFO - Running post-action listener: _resource_record_post_action 10:40:07 INFO - Running post-action listener: _start_resource_monitoring 10:40:07 INFO - Starting resource monitoring. 10:40:07 INFO - [mozharness: 2016-09-03 17:40:07.175892Z] Finished create-virtualenv step (success) 10:40:07 INFO - [mozharness: 2016-09-03 17:40:07.176882Z] Running install step. 10:40:07 INFO - Running pre-action listener: _resource_record_pre_action 10:40:07 INFO - Running main action method: install 10:40:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:40:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:40:07 INFO - Reading from file tmpfile_stdout 10:40:07 INFO - Detecting whether we're running mozinstall >=1.0... 10:40:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:40:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:40:07 INFO - Reading from file tmpfile_stdout 10:40:07 INFO - Output received: 10:40:07 INFO - Usage: mozinstall [options] installer 10:40:07 INFO - Options: 10:40:07 INFO - -h, --help show this help message and exit 10:40:07 INFO - -d DEST, --destination=DEST 10:40:07 INFO - Directory to install application into. [default: 10:40:07 INFO - "/builds/slave/test"] 10:40:07 INFO - --app=APP Application being installed. [default: firefox] 10:40:07 INFO - mkdir: /builds/slave/test/build/application 10:40:07 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'] 10:40:07 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 10:40:41 INFO - Reading from file tmpfile_stdout 10:40:41 INFO - Output received: 10:40:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:40:41 INFO - Running post-action listener: _resource_record_post_action 10:40:41 INFO - [mozharness: 2016-09-03 17:40:41.879245Z] Finished install step (success) 10:40:41 INFO - [mozharness: 2016-09-03 17:40:41.879376Z] Running run-tests step. 10:40:41 INFO - Running pre-action listener: _resource_record_pre_action 10:40:41 INFO - Running main action method: run_tests 10:40:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:40:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:40:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:40:41 INFO - 2016-09-03 10:40:41.891 screenresolution[1647:8913] starting screenresolution argv=screenresolution get 10:40:41 INFO - 2016-09-03 10:40:41.894 screenresolution[1647:8913] Display 0: 1600x1200x32@60 10:40:41 INFO - 2016-09-03 10:40:41.899 screenresolution[1648:8916] starting screenresolution argv=screenresolution list 10:40:41 INFO - Available Modes on Display 0 10:40:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:40:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:40:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:40:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:40:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:40:42 INFO - Intel Iris: 10:40:42 INFO - Chipset Model: Intel Iris 10:40:42 INFO - Type: GPU 10:40:42 INFO - Bus: Built-In 10:40:42 INFO - VRAM (Dynamic, Max): 1536 MB 10:40:42 INFO - Vendor: Intel (0x8086) 10:40:42 INFO - Device ID: 0x0a2e 10:40:42 INFO - Revision ID: 0x0009 10:40:42 INFO - Displays: 10:40:42 INFO - Display: 10:40:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:40:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:40:42 INFO - Display Serial Number: 1600x1200 60 10:40:42 INFO - Main Display: Yes 10:40:42 INFO - Mirror: Off 10:40:42 INFO - Online: Yes 10:40:42 INFO - Rotation: Supported 10:40:42 INFO - Return code: 0 10:40:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:40:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:40:42 INFO - Python 2.7.3 10:40:42 INFO - Return code: 0 10:40:42 INFO - grabbing minidump binary from tooltool 10:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:42 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 0x11048fd30>, '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 0x1101f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110487b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:40:42 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 10:40:42 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 10:40:42 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 10:40:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:40:42 INFO - Return code: 0 10:40:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:40:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:40:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:40:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:40:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:40:42 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/PGFUous9SA6YVGtP76ma4A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0259', '--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 10:40:42 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/PGFUous9SA6YVGtP76ma4A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0259 --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 10:40:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vvT5GSRe3N/Render', 10:40:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:40:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:40:42 INFO - 'HOME': '/Users/cltbld', 10:40:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:40:42 INFO - 'LOGNAME': 'cltbld', 10:40:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:40:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:40:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:42 INFO - 'MOZ_NO_REMOTE': '1', 10:40:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:40:42 INFO - 'NO_EM_RESTART': '1', 10:40:42 INFO - 'PAGER': '/bin/cat', 10:40:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:40:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:42 INFO - 'PWD': '/builds/slave/test', 10:40:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:40:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:40:42 INFO - 'SHELL': '/bin/bash', 10:40:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zl0fbZdoCa/Listeners', 10:40:42 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 10:40:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:40:42 INFO - 'USER': 'cltbld', 10:40:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:40:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:40:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:42 INFO - 'XPC_FLAGS': '0x0', 10:40:42 INFO - 'XPC_SERVICE_NAME': '0', 10:40:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:40:42 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/PGFUous9SA6YVGtP76ma4A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0259', '--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 10:40:42 INFO - mozversion application_buildid: 20160903071749 10:40:42 INFO - mozversion application_changeset: bcab45259b4fe5787d0d6fea16067e763f2a11ea 10:40:42 INFO - mozversion application_display_name: Nightly 10:40:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:40:42 INFO - mozversion application_name: Firefox 10:40:42 INFO - mozversion application_remotingname: firefox 10:40:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:40:42 INFO - mozversion application_vendor: Mozilla 10:40:42 INFO - mozversion application_version: 51.0a1 10:40:42 INFO - mozversion platform_buildid: 20160903071749 10:40:42 INFO - mozversion platform_changeset: bcab45259b4fe5787d0d6fea16067e763f2a11ea 10:40:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:40:42 INFO - mozversion platform_version: 51.0a1 10:40:42 INFO - using testdate: 1472924442 10:40:42 INFO - actual date: 1472924442 10:40:42 INFO - starting webserver on 'localhost:49266' 10:40:42 INFO - SUITE-START | Running 2 tests 10:40:42 INFO - TEST-START | dromaeo_css 10:40:42 INFO - operating with platform_type : mac_ 10:40:42 INFO - Initialising browser for dromaeo_css test... 10:40:42 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpB3rT01/profile http://localhost:49266/getInfo.html) 10:40:45 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 10:40:45 INFO - PROCESS | 1658 | colorDepth:24 10:40:45 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 10:40:45 INFO - PROCESS | 1658 | __metrics 10:40:45 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 10:40:46 INFO - TEST-INFO | 1658: exit 0 10:40:46 INFO - Browser initialized. 10:40:46 INFO - Running cycle 1/1 for dromaeo_css test... 10:40:46 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpB3rT01/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:40:58 INFO - PROCESS | 1663 | RSS: Main: 245039104 10:40:58 INFO - PROCESS | 1663 | 10:41:47 INFO - PROCESS | 1663 | 1472924507844 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] 10:43:59 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 10:44:01 INFO - PROCESS | 1663 | RSS: Main: 264175616 10:44:01 INFO - PROCESS | 1663 | 10:47:03 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 10:47:04 INFO - PROCESS | 1663 | RSS: Main: 270389248 10:47:04 INFO - PROCESS | 1663 | 10:50:05 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 10:50:06 INFO - PROCESS | 1663 | RSS: Main: 275197952 10:50:06 INFO - PROCESS | 1663 | 10:53:08 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 10:53:09 INFO - PROCESS | 1663 | RSS: Main: 270262272 10:53:09 INFO - PROCESS | 1663 | 10:56:11 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 10:56:12 INFO - PROCESS | 1663 | RSS: Main: 275755008 10:56:12 INFO - PROCESS | 1663 | 10:59:15 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 10:59:15 INFO - PROCESS | 1663 | RSS: Main: 278630400 10:59:15 INFO - PROCESS | 1663 | 10:59:15 INFO - PROCESS | 1663 | __start_tp_report 10:59:15 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 10:59:15 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 10:59:15 INFO - PROCESS | 1663 | |i|pagename|runs| 10:59:15 INFO - PROCESS | 1663 | |0;dojo.html;2862.570614407837;3373.7807042542217;3398.524206611074;3418.965810341896;3420.127867393814;5594.916076258849;5640.605157638967;5654.886902261952;5678.375378708339;5754.251947246862;5681.914771278434;5720.084786434161;5762.452567006138;5765.827025189241;5810.3027636683555;4386.912261754779;5126.897462050757;5249.950009997997;5272.762725677335;5347.144456886899;5323.840284791462;5338.145896656536;5362.383325917511;5372.462753724635;5384.0847056000575;5154.149565321717;5177.974110129463;5252.816151434719;5312.362516498007;5316.282301889253;5247.842564723064;5259.63182577216;5263.842084737464;5290.994711004897;5301.681899086028;5168.896622067575;5219.947800521984;5220.138677118271;5257.763400646942;5320.813771517978;4668.393108895856;5620.887582248373;5622;5690.174924635905;5722.084466485342;6223.719932603044;6235.6258624482225;6261.906071408933;6269.059641053833;6298.716557754866;6288.528360372945;6290.716917738713;6292.874142517124;6301.968490157566;6302.55882088254;5673.744681489343;5719.685417302088;5726.685032323179;5835.474807267324;5855.502282305966;6273.749050038039;6293.653849038255;6298.307186209513;6311.368863113744;6312.52656050798;6015.969920150371;6087.4521293083835;6092.025275955826;6092.634441933498;6112.847178820476;6134.957077261001;6138.07928810673;6139.662318572521;6163.660998645028;6246.625202487865;6163.907541386883;6171.753129874754;6181.505479561624;6198.845028874224;6220.409061139185;6213.099100630383;6219.595726277777;6227.875442491216;6229.906551401733;6245.500359971192;4829.5653391194965;4865.245886887538;4886.438059623118;4893.877653058702;4918.2376731606655;3468.5317482140094;3636.2363903580017;3713.721470889694;3735.6824669903363;4451.087527056946;4925.335079764186;5642.689652069175;5788.247527821356;5797.36229014808;5832.9708351457975;6111.57218994675;6172.382761723881;6191.97832357665;6270.122182894398;6287.49700023997;5369.973150134224;5448.536874365724;5757.568182386338;5802.21670074543;5806.88386232273;4865.221564549655;5069.8732531687;5372.1941708744;5398.64908780928;5440.020796256712;6211.09939058843;6217.937820621826;6220.0047992322825;6325.082862984841;6420.550561460653;5223.817166399158;6282.246130464374;6287.119803227461;6294.402031806971;6296.370362963667;5257.2639830423;6289.465395441439;6313.305536391085;6313.65274909866;6318.684065796784;6000.21997140369;6130.581587308013;6159.01455767093;6179.721912514037;6193.566450348432;6141.385861413823;6243.937560624336;6257.186565746424;6305.085762564494;6309.49524038085;5024.799008039638;5149.948500515096;6163.3528479509005;6183.598066125687;6184.350643182581;5931.4068593142065;6019.72911219005;6064.454199121924;6146.631202127886;6165.136880836776;4971.328870602567;5859.736311865891;5922.318933322723;5932.436418540232;5983;5657.6138845983;6068.120122582289;6100.847478813065;6128.080787881853;6133.202683651097;5801.129830525455;5878.3239927408895;5891.558133139946;5896;5983.611065280743 10:59:15 INFO - PROCESS | 1663 | |1;ext.html;450.8624869414829;535.0582973965819;541.9268398766168;547.8164814787046;560.8513743857876;37049.81475092624;39408;39439.60560394395;39447;39462.80268598653;40138.39792403116;40592;40603.593964060354;40629.79685101578;40844;9548.904510954872;9679.467629280387;9764.072413120743;9765.414075155479;9787.608495660164;9716.125548700615;9769;9806.264530160232;9816.460094694788;9838.655647052354;9769.071938165864;9783.755406114833;9788.804223915517;9823.852642210373;9859.507024648774;9753.95123024384;9808.65669701557;9811.852822207708;9820.705378838646;9834.360766550151;9607;9647.372920760128;9691.612335506572;9718.902810971942;9726.076022777896;38640.22719545593;38943.61056389457;38971.61028389737;39069.41395879064;39182.216355672725;3093.7215650591556;3304.950425743592;3376.64545222753;3421;4054.1283624020975;24033.759662403503;24668.5066298673;26980.460390792075;27480.58779118315;30195.698043019507;2698.5142674318613;3205.6313523944814;3235.110344655239;3328.650491698361;3359.2273777031173;347400;348864.99999999744;350134;351507;355565;55036.44963550393;55187.724061379435;55217;55240.723796380764;55353.723231383585;31793.84103079516;32054.878079267113;32942.50586241209;33382.49926251108;57751.422485775445;16138.031718096952;16278.86047976654;16293.859429840035;16294.940828846087;16331.91834040846;11528.558930133733;11659.242149260272;11955.043596512432;12171.60026596935;12498.25010499373;15448.304826282843;15533.533993980198;17570.82429175692;18106.91358518493;18251.17869695867;7303.561786292733;7357.227491113463;7928.643211055516;7947.245011723877;7967.163447838009;691.4468425259772;862.8101817600118;895.3732387328765;956.7416797464646;999.81003609314;28964.565531517044;29209.85395073011;29281.56077658837;29750.702492975226;29837.95567155139;1020.1787561013456;1021.667957913681;1076.5370890516997;1084.3439718970067;1161.1175506614863;14822.332995015251;15247.08517488932;15355.078695278318;15398.846011539741;15642.530724078295;548970;627931;628682;630761;635069.8246508738;48446.757766211646;54696;55228;55364;55431.44568554343;1184.3722826901756;1315.2371624457792;1332.6468485851258;1362.7206422683325;1366.1598117157876;25817.870910645328;29006.77877981899;29059.982900598377;29077.854610726812;29717.554236686035;47733.76133119451;47792;47907.76046119747;47910.80222994453;47961.800954975006;561454;561606;563248;563705;563812;24977.87511062433;25131.87434062818;25491.107811226517;25581;26056;44712.10575788401;45624.8593785158;46865;47080.52919470761;47846;37121;38320.80839595896;38412;39846.800765995984;39880.60119398769;33265.83367083149;34509.827450862584;37517.24965500729;37718.51410409261;38368.42447363347;36412.98694866227;36644.08389790277;37627.62372376351;37723.24553508969;37906.620933790306;32719.18202044968;33804;34151.85266651927;34314.48528272028;34556.13609659779;20773.89613051925;24744.876275618506;24793.504129917663;24906.750932490442;24924.37689057788 10:59:15 INFO - PROCESS | 1663 | |2;jquery.html;367.23431645020133;375.2101825656992;380.7525108679359;381.2965079428454;395.0164091412384;16024.83975160248;18391.804532705366;18664.346747863827;19913.203471861125;20233.39299821006;17649.82350176498;20163.899180504115;20269.695954560695;20513;20544.178232870705;5681.602287839853;5702.344230413493;5891.263592050994;5914.704264786744;5991.2510936132985;4085;5738.0532212184935;6220.688965551704;6540.313267106957;6547.181602299713;6288.811335659914;6521.673916304189;6556.672166391685;6575.079488871562;6653.534252602296;6410.1666783318105;6467.482601391877;6541.738330466776;6557;6565.638889861056;5545.889082218333;5577.442255774431;5584.91622625661;5627.6904770237625;5648.406917273668;24537.63193552098;24716.011359545595;24738.25785226446;24764.761761912014;25162.24513264605;2268.9319320420414;2362.1968530699473;2373.5134297468976;2385.2844146755906;2925.195571217932;14288.642783930381;14739;15036.849631503654;15217.391304347813;15456.922715386463;1840.484664294;1844.9262029518936;1894.8673592848506;1902.6765449873556;1930.9710354344695;109101;114337.42831285874;129917.40165196643;130075.69924300825;130565.34717326352;11137.888621113847;11220.831687524693;11522.36626985507;11703.765924681458;11707.882921170849;14291.499797507038;14342.85657143436;14344;14351.928240358731;14376.993610447378;6967.756128535579;8154.469959452616;8336.208060234268;8438.324934005264;8520.233179013918;8339.374546909006;8351.29014033814;8362.498250105013;8500.064992850781;8523.48859068458;3668.7615305005625;4393.934090988638;4439.378487011821;4458.242098843204;4524.886877828015;1691.4925522343249;1744.6946784312695;1769.9292028318723;1887.594167254047;1909.6371689378973;333.25849983785884;374.0555098376621;382.1077783375793;416.473161450765;828.9017052405587;11009.339439633648;11363.659090227306;11701.765964680659;11734.41327933617;11976.940115299542;356.55786824337633;413.83860294485174;414.22953306849234;426.5989969428727;435.16014092800566;5741.3971532988435;6039.16814880315;6073.817785466443;6210.72051757672;6219.595726277868;545918;553470;561734;562793;567476;124884;131033;131610;133165.3341733285;135655;441.2917267785223;443.989922925341;445.52106485528185;445.5277405949704;449.10403744529873;11009.83485247738;11039.448027598748;11093.278936869077;11228.4385780709;11332.546698131982;56525;57004.71497642485;57229.713851430475;57750;58886.705566471894;74669;75812.24187758051;76236;79545.60227198827;84924;7937.015107188072;8008.959955200186;8087.514749115072;8160.387970902088;8298.170182981654;9237.491937943209;12905.18386578361;13358;13531.820022294949;13566.59300220995;11230;11588.594399195988;11607.245529040585;11632.709182270173;11682.007029402255;11034.227604067639;11139.108871290115;11367.147463940073;11560.248583842023;11624.651260461862;11247.437628118725;11620.186586938833;11747.177697561088;11797.988683847532;11899.940500297444;6389.712462939272;6663.966680166568;7118.074650295428;7397.482176247611;8206.548639824867;8958.731238062868;10633.946830265799;10875.184361172785;11403.429828508375;11590.42047897585 10:59:15 INFO - PROCESS | 1663 | |3;mootools.html;1464.6558058856167;1509.2378348933787;1683.3098429643842;1781.8752687311894;1831.9816801831978;7745.3029227369525;8291.668333266669;8414.158584141584;8754.168354006375;8828.29373650108;8513.191246831557;8513.616887240074;8589.87115193271;8616.569171541429;8663.39356245063;1887.5092475956283;2324.476992676647;2367.4081479630095;2368.7157541095094;2375.5367703297866;2028.310374472679;2287.2223444029028;2334.708161479815;2339.7192336919593;2364.373441038126;2341.976580234193;2345.659879317498;2354.0701422937927;2354.1289722802585;2360.327306717586;2322.2104484475276;2324.360800779782;2341.3678306857223;2342.508073304608;2342.9925132193234;2338.251759436981;2338.7895089441863;2341.4263505441277;2343.847649902751;2345.542619189259;8648.35137364694;8673.219410253045;8714.172153645393;8734.737957861274;8766.386352955296;5191.169412893919;5330.067238233293;5330.253764472938;5338.386085600167;5355.7857685692525;3325.900222993314;3480.8955731327846;3542.557180352456;3604.819759012039;3608.4226523756333;1040.54216144896;1070.2080460459204;1071.6356438810765;1091.81439155343;1097.8956999085074;11184.993350598405;11201;11263.21157518974;11391.031762300214;11391.316521008766;4541.636669066466;4619.122366750306;4748.928766068511;4767;4804.855854324376;9552;9688.757781055388;9701.70894873155;9713.805723885484;9748.756281092888;5275.63070585063;5286.894262114736;5290.497402746733;5298.523132918056;5304.549113325334;4323;4677.18149323867;4778.402699662543;4853.369062021915;4871.34236878017;3832.7125465590193;3852.5569559500454;3953;3954.5368213761094;3959.5050618672667;1284.4476874943864;1286.1511402474323;1292.6057552446407;1293.0173068468032;1310.960671179847;779.7777633374461;869.4739682492128;889.2796834564024;916.7983043730369;946.2382781860531;5477.643953143033;5648.49163575272;5761.5102716269585;5790.305163380422;5975.163477113208;409.72957847820294;432.99977053007655;440.8148577597417;446.5980617444326;450.6237291861267;3828.3874580067054;3868.3037053330672;3953.7430067046125;3969.622885825842;4012.1574469361763;10158.238132140119;10341.327813692085;10435.739106522398;10480.790384192274;10513.737156571147;8793.824123517621;10380.688579342632;10441.738956526147;10468.842967355497;10472;6630.569013014235;7840.372770178372;7900.288973992253;7921.683132674629;7946.602669866484;5657.2079908811975;5659.915101273402;5708.942910570841;5731.828045158652;5814.76740930358;9499.667511637059;9643.08390702882;9654.56554455037;9684.322097453392;9729.318947673595;8485.787855303666;9646.131848133702;9734.637150799035;9845.556949937127;9926.15627671627;6698.799036028927;7135.892961605477;7278.708851646086;7317.817054573678;7323.048003759477;8187.426880118334;8261.669533218845;8268.297194738274;8273.379496537904;8295.460795048302;5877.735501902339;7291.671874765754;7384.446166537424;7466.141393739572;7524.097108347033;6696.129503164558;6909.930900690929;7211.459140564583;7214.134303883568;7309.671064801991;5827.446392592697;6643.069970204078;6749.662516874038;6818.386345228755;6819.897701534382;4032.495938007749;4357.692692192393;4940.8764780880765;4955.925661115159;5059.089363914531;4930.383702037246;5031;5042.495750424928;5100.821471248489;5119.897602048012 10:59:15 INFO - PROCESS | 1663 | |4;prototype.html;277.42849729557105;300.8931829200632;316.3009748455912;319.243393158215;326.2089433124672;4638.373819534362;5402;5588.636738611987;5683.971580142099;5715.142728590714;5562.888742225153;5597.888042239153;5600.747966341514;5601.719914004304;5607.57943154264;3547.8935631931085;4016.417619445186;4150;4167.937480937789;4255.851045213418;3306.933861322772;4030.6775457963295;4201.873943781676;4203.369494575808;4245.426867372896;4161.210679407854;4216.030313028005;4231.597998190183;4238.173556156551;4271.487421509423;4120.979395103005;4137.758672398269;4209.705320627558;4233;4259.510156332015;2900.7824413169096;3094.3501864608234;3140.9214769630944;3553.893383198508;3654.196076863086;4492.393526873863;4997.600191984632;5437.32033495813;5461.8803145355105;5500.4224556421395;4404.537523560012;4614.462045874756;4817.445993710733;4843.782029808667;4850.102730994742;4596.724196548184;5279.5450115696;5297.549708274802;5683;5881.911771323434;4028.7784171870535;4034.7780872052026;4038.818253178614;4055.9391609125887;4057.3711074783455;5697.31632204134;5738.311402631711;6117.235345581757;6168.013117901114;6193.659348735863;3942.940855887164;3961.8217180226957;3964.32606456903;3974.9801250994137;3985.20295940813;3234.433974054578;3814.370628846265;4026.838926442968;4042.292598795199;4057.776822274744;4353.82584696615;4564.7032942858605;4737.644676649265;4753.310769938409;4812.422509298906;4529.890176906613;5841.766329346863;5848.181254624356;5858.53131749459;5864.824055278348;1355.9050866439254;1377.869102435267;1377.9311034448438;1381.7927310903244;1387.6392138044182;790.7351037402419;808.7816289601775;837.7863644770545;849.1678155407735;852.7441767469859;5251.474852514718;5486.149646804752;5503.229547863302;5509.641873278224;5530.364008139035;4878.707277563358;5461.726913654302;5470.097433923438;5601.691906945076;6085.726142323606;4502.617277531446;5099.847004589868;5239.345081864767;5400.243965844785;5559.082751346064;2526.8610226437722;2926.107537201174;3155.0377134974055;3158.589383380192;3163.2566346908457;4989.561378097818;5272.286506885201;5737.85655358611;6235.532335074888;6246.500279977591;4939.777710003059;5078;5155.448053213609;5473.850491396772;5487.972560137174;5938.970305148533;6303.747850086037;6305.96847015762;6308.873822523616;6318.241810982619;5733.483986441241;5974.312954010171;6056.63856559596;6078.756849725962;6086.239220097488;4969.701817890938;5825.3592104867585;5932;5973.940260597338;5993.190919226023;6251.749930002749;6266.717997690023;6267.592606480564;6325.715342809676;6358.300586935341;3704.592494825621;3966.8809935701975;3978.661813745748;3993.8003099845473;3998.5801490844206;5373.382061063028;5379.058664733734;5526.585506086979;5544.7782088716;6099.11562823397;4523.954760452485;5377.574942640282;5879.441453061952;5891.734871930859;5931.228940237742;4597.609203217764;5712.914306285492;5801.419858014165;5824.388439213822;5853.560982926212;5258.447862974333;5749.367569567428;5759.827205183851;5830.067189249699;5835.854103647443;4853.6359773017875;5608.242887210337;5663.546916246608;5777.971110144423;5862.970685146547;4978;5726.885462290814;5751.252337196305;5760.395158508296;5848.64908105515 10:59:15 INFO - PROCESS | 1663 | |5;yui.html;658.5390226841209;673.3973094080798;706.8550947055854;741.9912255802725;785.5129819511901;14870.702585948287;16009.599760005976;16034.75947860783;16060.11669358185;16101.114438705867;13969.16185028899;14537.636559086028;14716;14742;14797.260136993134;854.7692123126736;879.6217626420637;882.9779255518631;884.7213127864734;885.663447889801;699.0562740300604;861.4357595774777;869.5999840073574;887.0641473245723;891.6076926152505;900.2392977933636;924.3021518753366;930.0327659234422;931.65063101337;931.8695382646434;910.2172131966504;918.4351623751378;921.4149015375218;924.4638109896244;928.1924725488834;684.4968947823346;689.8482333886537;690.9412699920513;691.9965400172966;693.3447891742305;14747.631309217248;14824.555263342118;14997.325120369609;15047.699046019128;15068.246587670572;14337.35481903317;14398.712025759427;14442.566722998326;14496.71006579873;14719;11794.233374830608;11945.104117191246;11992.580259690869;11994.528426223605;12050.517979280818;3777.225668737902;3833.8083095845095;3853.6339047790416;3864.3237433449317;3959.3467077932105;115879.84120158775;117864.41067794691;118243.817561825;119574;119668;10986.285891417032;11026.724331891766;11231.10151187903;11247;11440.542378304941;18310.267589296545;21996.780032199793;23374.415639608807;23391.649125263135;23393.181238656907;7821.608919554;7930.325922296669;8091;8119.9188008120345;8131.674733010732;3658.6707196352454;4428.955710442919;4515.074409745994;4619.514950930104;4620.260758278727;3390;3495.143689796016;3496.6328535503408;3502.124468882779;3505.7545971782242;583.6060659055206;588.8928813829972;601.7743346245159;611.3000614296606;615.8583525789004;583.0758248176687;585.2158108135119;595.6508508228778;645.4868379638199;681.7954613615896;8886.155815197546;9056.864147037799;9122.31582631292;9543.665971690958;9551.808963820684;625;646.741303478603;659.6075335175562;663.7212370804274;672.4586707700348;4518.164139634178;4718.805446462386;4720.527947205252;4744.833930812405;4794.993051459163;136544;160565;161153;162084;162593.37406626018;103137.71760541588;122752.77247227592;139033.6096639041;144827;145552;121239;122153.38923305327;122928.38535807085;123660;124618.37690811488;8281.95859020701;8911.55442227873;9008.909910900808;9121.270298376247;9317.534123293673;66241.66879165573;66690;66842.33157668555;67720.6613966927;69325.2269909198;57261.71369143128;62711.6864415675;67685.66157169183;80421.39157216939;94998.52500737729;11578.421078946187;13007.349632518526;13304.534341298007;13448.865511344762;13507.189568625521;13946.464116301297;14568.34442450071;14880.479183228535;14884.330205141012;15308.540743777705;13512.25682587467;13609.795853062014;13779.379927903468;13844.723105538034;13991.650208744863;13791.931040344734;13798.241096739775;13853;14078.929605351908;14132.434702612192;10971.451427428756;13385.263810490516;13531.248451206742;13693.178409295475;13876.028677992848;11109.388983605979;11483.885161148282;11490.425478726198;11619.244749091282;11670.533178672758;9443.433393996382;10139.188864890939;10245.641402550875;11115.44422778874;11644.184907056424 10:59:15 INFO - PROCESS | 1663 | __end_tp_report 10:59:15 INFO - PROCESS | 1663 | __start_cc_report 10:59:15 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,384 10:59:15 INFO - PROCESS | 1663 | __end_cc_report 10:59:15 INFO - PROCESS | 1663 | __startTimestamp1472925555682__endTimestamp 10:59:15 INFO - PROCESS | 1663 | 10:59:15 INFO - PROCESS | 1663 | ------- Summary: start ------- 10:59:15 INFO - PROCESS | 1663 | Number of tests: 6 10:59:15 INFO - PROCESS | 1663 | 10:59:15 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5674.76 Median:5859.74 stddev:710.09 (12.1%) stddev-sans-first:677.13 10:59:15 INFO - PROCESS | 1663 | Values: 2862.6 3373.8 3398.5 3419.0 3420.1 5594.9 5640.6 5654.9 5678.4 5754.3 5681.9 5720.1 5762.5 5765.8 5810.3 4386.9 5126.9 5250.0 5272.8 5347.1 5323.8 5338.1 5362.4 5372.5 5384.1 5154.1 5178.0 5252.8 5312.4 5316.3 5247.8 5259.6 5263.8 5291.0 5301.7 5168.9 5219.9 5220.1 5257.8 5320.8 4668.4 5620.9 5622.0 5690.2 5722.1 6223.7 6235.6 6261.9 6269.1 6298.7 6288.5 6290.7 6292.9 6302.0 6302.6 5673.7 5719.7 5726.7 5835.5 5855.5 6273.7 6293.7 6298.3 6311.4 6312.5 6016.0 6087.5 6092.0 6092.6 6112.8 6135.0 6138.1 6139.7 6163.7 6246.6 6163.9 6171.8 6181.5 6198.8 6220.4 6213.1 6219.6 6227.9 6229.9 6245.5 4829.6 4865.2 4886.4 4893.9 4918.2 3468.5 3636.2 3713.7 3735.7 4451.1 4925.3 5642.7 5788.2 5797.4 5833.0 6111.6 6172.4 6192.0 6270.1 6287.5 5370.0 5448.5 5757.6 5802.2 5806.9 4865.2 5069.9 5372.2 5398.6 5440.0 6211.1 6217.9 6220.0 6325.1 6420.6 5223.8 6282.2 6287.1 6294.4 6296.4 5257.3 6289.5 6313.3 6313.7 6318.7 6000.2 6130.6 6159.0 6179.7 6193.6 6141.4 6243.9 6257.2 6305.1 6309.5 5024.8 5149.9 6163.4 6183.6 6184.4 5931.4 6019.7 6064.5 6146.6 6165.1 4971.3 5859.7 5922.3 5932.4 5983.0 5657.6 6068.1 6100.8 6128.1 6133.2 5801.1 5878.3 5891.6 5896.0 5983.6 10:59:15 INFO - PROCESS | 1663 | 10:59:15 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:63744.41 Median:38390.21 stddev:139723.38 (364.0%) stddev-sans-first:140034.53 10:59:15 INFO - PROCESS | 1663 | Values: 450.9 535.1 541.9 547.8 560.9 37049.8 39408.0 39439.6 39447.0 39462.8 40138.4 40592.0 40603.6 40629.8 40844.0 9548.9 9679.5 9764.1 9765.4 9787.6 9716.1 9769.0 9806.3 9816.5 9838.7 9769.1 9783.8 9788.8 9823.9 9859.5 9754.0 9808.7 9811.9 9820.7 9834.4 9607.0 9647.4 9691.6 9718.9 9726.1 38640.2 38943.6 38971.6 39069.4 39182.2 3093.7 3305.0 3376.6 3421.0 4054.1 24033.8 24668.5 26980.5 27480.6 30195.7 2698.5 3205.6 3235.1 3328.7 3359.2 347400.0 348865.0 350134.0 351507.0 355565.0 55036.4 55187.7 55217.0 55240.7 55353.7 31793.8 32054.9 32942.5 33382.5 57751.4 16138.0 16278.9 16293.9 16294.9 16331.9 11528.6 11659.2 11955.0 12171.6 12498.3 15448.3 15533.5 17570.8 18106.9 18251.2 7303.6 7357.2 7928.6 7947.2 7967.2 691.4 862.8 895.4 956.7 999.8 28964.6 29209.9 29281.6 29750.7 29838.0 1020.2 1021.7 1076.5 1084.3 1161.1 14822.3 15247.1 15355.1 15398.8 15642.5 548970.0 627931.0 628682.0 630761.0 635069.8 48446.8 54696.0 55228.0 55364.0 55431.4 1184.4 1315.2 1332.6 1362.7 1366.2 25817.9 29006.8 29060.0 29077.9 29717.6 47733.8 47792.0 47907.8 47910.8 47961.8 561454.0 561606.0 563248.0 563705.0 563812.0 24977.9 25131.9 25491.1 25581.0 26056.0 44712.1 45624.9 46865.0 47080.5 47846.0 37121.0 38320.8 38412.0 39846.8 39880.6 33265.8 34509.8 37517.2 37718.5 38368.4 36413.0 36644.1 37627.6 37723.2 37906.6 32719.2 33804.0 34151.9 34314.5 34556.1 20773.9 24744.9 24793.5 24906.8 24924.4 10:59:15 INFO - PROCESS | 1663 | 10:59:15 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:33688.21 Median:2018.00 stddev:93963.41 (4656.3%) stddev-sans-first:94193.70 10:59:15 INFO - PROCESS | 1663 | Values: 367.2 375.2 380.8 381.3 395.0 16024.8 18391.8 18664.3 19913.2 20233.4 17649.8 20163.9 20269.7 20513.0 20544.2 5681.6 5702.3 5891.3 5914.7 5991.3 4085.0 5738.1 6220.7 6540.3 6547.2 6288.8 6521.7 6556.7 6575.1 6653.5 6410.2 6467.5 6541.7 6557.0 6565.6 5545.9 5577.4 5584.9 5627.7 5648.4 24537.6 24716.0 24738.3 24764.8 25162.2 2268.9 2362.2 2373.5 2385.3 2925.2 14288.6 14739.0 15036.8 15217.4 15456.9 1840.5 1844.9 1894.9 1902.7 1931.0 109101.0 114337.4 129917.4 130075.7 130565.3 11137.9 11220.8 11522.4 11703.8 11707.9 14291.5 14342.9 14344.0 14351.9 14377.0 6967.8 8154.5 8336.2 8438.3 8520.2 8339.4 8351.3 8362.5 8500.1 8523.5 3668.8 4393.9 4439.4 4458.2 4524.9 1691.5 1744.7 1769.9 1887.6 1909.6 333.3 374.1 382.1 416.5 828.9 11009.3 11363.7 11701.8 11734.4 11976.9 356.6 413.8 414.2 426.6 435.2 5741.4 6039.2 6073.8 6210.7 6219.6 545918.0 553470.0 561734.0 562793.0 567476.0 124884.0 131033.0 131610.0 133165.3 135655.0 441.3 444.0 445.5 445.5 449.1 11009.8 11039.4 11093.3 11228.4 11332.5 56525.0 57004.7 57229.7 57750.0 58886.7 74669.0 75812.2 76236.0 79545.6 84924.0 7937.0 8009.0 8087.5 8160.4 8298.2 9237.5 12905.2 13358.0 13531.8 13566.6 11230.0 11588.6 11607.2 11632.7 11682.0 11034.2 11139.1 11367.1 11560.2 11624.7 11247.4 11620.2 11747.2 11798.0 11899.9 6389.7 6664.0 7118.1 7397.5 8206.5 8958.7 10633.9 10875.2 11403.4 11590.4 10:59:15 INFO - PROCESS | 1663 | 10:59:15 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5542.79 Median:5050.79 stddev:3091.22 (61.2%) stddev-sans-first:3084.70 10:59:15 INFO - PROCESS | 1663 | Values: 1464.7 1509.2 1683.3 1781.9 1832.0 7745.3 8291.7 8414.2 8754.2 8828.3 8513.2 8513.6 8589.9 8616.6 8663.4 1887.5 2324.5 2367.4 2368.7 2375.5 2028.3 2287.2 2334.7 2339.7 2364.4 2342.0 2345.7 2354.1 2354.1 2360.3 2322.2 2324.4 2341.4 2342.5 2343.0 2338.3 2338.8 2341.4 2343.8 2345.5 8648.4 8673.2 8714.2 8734.7 8766.4 5191.2 5330.1 5330.3 5338.4 5355.8 3325.9 3480.9 3542.6 3604.8 3608.4 1040.5 1070.2 1071.6 1091.8 1097.9 11185.0 11201.0 11263.2 11391.0 11391.3 4541.6 4619.1 4748.9 4767.0 4804.9 9552.0 9688.8 9701.7 9713.8 9748.8 5275.6 5286.9 5290.5 5298.5 5304.5 4323.0 4677.2 4778.4 4853.4 4871.3 3832.7 3852.6 3953.0 3954.5 3959.5 1284.4 1286.2 1292.6 1293.0 1311.0 779.8 869.5 889.3 916.8 946.2 5477.6 5648.5 5761.5 5790.3 5975.2 409.7 433.0 440.8 446.6 450.6 3828.4 3868.3 3953.7 3969.6 4012.2 10158.2 10341.3 10435.7 10480.8 10513.7 8793.8 10380.7 10441.7 10468.8 10472.0 6630.6 7840.4 7900.3 7921.7 7946.6 5657.2 5659.9 5708.9 5731.8 5814.8 9499.7 9643.1 9654.6 9684.3 9729.3 8485.8 9646.1 9734.6 9845.6 9926.2 6698.8 7135.9 7278.7 7317.8 7323.0 8187.4 8261.7 8268.3 8273.4 8295.5 5877.7 7291.7 7384.4 7466.1 7524.1 6696.1 6909.9 7211.5 7214.1 7309.7 5827.4 6643.1 6749.7 6818.4 6819.9 4032.5 4357.7 4940.9 4955.9 5059.1 4930.4 5031.0 5042.5 5100.8 5119.9 10:59:15 INFO - PROCESS | 1663 | 10:59:15 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:4673.27 Median:5275.92 stddev:1461.49 (27.7%) stddev-sans-first:1427.87 10:59:15 INFO - PROCESS | 1663 | Values: 277.4 300.9 316.3 319.2 326.2 4638.4 5402.0 5588.6 5684.0 5715.1 5562.9 5597.9 5600.7 5601.7 5607.6 3547.9 4016.4 4150.0 4167.9 4255.9 3306.9 4030.7 4201.9 4203.4 4245.4 4161.2 4216.0 4231.6 4238.2 4271.5 4121.0 4137.8 4209.7 4233.0 4259.5 2900.8 3094.4 3140.9 3553.9 3654.2 4492.4 4997.6 5437.3 5461.9 5500.4 4404.5 4614.5 4817.4 4843.8 4850.1 4596.7 5279.5 5297.5 5683.0 5881.9 4028.8 4034.8 4038.8 4055.9 4057.4 5697.3 5738.3 6117.2 6168.0 6193.7 3942.9 3961.8 3964.3 3975.0 3985.2 3234.4 3814.4 4026.8 4042.3 4057.8 4353.8 4564.7 4737.6 4753.3 4812.4 4529.9 5841.8 5848.2 5858.5 5864.8 1355.9 1377.9 1377.9 1381.8 1387.6 790.7 808.8 837.8 849.2 852.7 5251.5 5486.1 5503.2 5509.6 5530.4 4878.7 5461.7 5470.1 5601.7 6085.7 4502.6 5099.8 5239.3 5400.2 5559.1 2526.9 2926.1 3155.0 3158.6 3163.3 4989.6 5272.3 5737.9 6235.5 6246.5 4939.8 5078.0 5155.4 5473.9 5488.0 5939.0 6303.7 6306.0 6308.9 6318.2 5733.5 5974.3 6056.6 6078.8 6086.2 4969.7 5825.4 5932.0 5973.9 5993.2 6251.7 6266.7 6267.6 6325.7 6358.3 3704.6 3966.9 3978.7 3993.8 3998.6 5373.4 5379.1 5526.6 5544.8 6099.1 4524.0 5377.6 5879.4 5891.7 5931.2 4597.6 5712.9 5801.4 5824.4 5853.6 5258.4 5749.4 5759.8 5830.1 5835.9 4853.6 5608.2 5663.5 5778.0 5863.0 4978.0 5726.9 5751.3 5760.4 5848.6 10:59:15 INFO - PROCESS | 1663 | 10:59:15 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:25380.10 Median:3495.89 stddev:41313.52 (1181.8%) stddev-sans-first:41387.72 10:59:15 INFO - PROCESS | 1663 | Values: 658.5 673.4 706.9 742.0 785.5 14870.7 16009.6 16034.8 16060.1 16101.1 13969.2 14537.6 14716.0 14742.0 14797.3 854.8 879.6 883.0 884.7 885.7 699.1 861.4 869.6 887.1 891.6 900.2 924.3 930.0 931.7 931.9 910.2 918.4 921.4 924.5 928.2 684.5 689.8 690.9 692.0 693.3 14747.6 14824.6 14997.3 15047.7 15068.2 14337.4 14398.7 14442.6 14496.7 14719.0 11794.2 11945.1 11992.6 11994.5 12050.5 3777.2 3833.8 3853.6 3864.3 3959.3 115879.8 117864.4 118243.8 119574.0 119668.0 10986.3 11026.7 11231.1 11247.0 11440.5 18310.3 21996.8 23374.4 23391.6 23393.2 7821.6 7930.3 8091.0 8119.9 8131.7 3658.7 4429.0 4515.1 4619.5 4620.3 3390.0 3495.1 3496.6 3502.1 3505.8 583.6 588.9 601.8 611.3 615.9 583.1 585.2 595.7 645.5 681.8 8886.2 9056.9 9122.3 9543.7 9551.8 625.0 646.7 659.6 663.7 672.5 4518.2 4718.8 4720.5 4744.8 4795.0 136544.0 160565.0 161153.0 162084.0 162593.4 103137.7 122752.8 139033.6 144827.0 145552.0 121239.0 122153.4 122928.4 123660.0 124618.4 8282.0 8911.6 9008.9 9121.3 9317.5 66241.7 66690.0 66842.3 67720.7 69325.2 57261.7 62711.7 67685.7 80421.4 94998.5 11578.4 13007.3 13304.5 13448.9 13507.2 13946.5 14568.3 14880.5 14884.3 15308.5 13512.3 13609.8 13779.4 13844.7 13991.7 13791.9 13798.2 13853.0 14078.9 14132.4 10971.5 13385.3 13531.2 13693.2 13876.0 11109.4 11483.9 11490.4 11619.2 11670.5 9443.4 10139.2 10245.6 11115.4 11644.2 10:59:15 INFO - PROCESS | 1663 | -------- Summary: end -------- 10:59:15 INFO - PROCESS | 1663 | 10:59:16 INFO - TEST-INFO | 1663: exit 0 10:59:16 INFO - TEST-OK | dromaeo_css | took 1113785ms 10:59:16 INFO - TEST-START | kraken 10:59:16 INFO - operating with platform_type : mac_ 10:59:16 INFO - Initialising browser for kraken test... 10:59:16 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmppmE2uJ/profile http://localhost:49266/getInfo.html) 10:59:18 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 10:59:18 INFO - PROCESS | 1671 | colorDepth:24 10:59:18 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 10:59:18 INFO - PROCESS | 1671 | __metrics 10:59:19 ERROR - PROCESS | 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 10:59:19 INFO - TEST-INFO | 1671: exit 0 10:59:19 INFO - Browser initialized. 10:59:19 INFO - Running cycle 1/1 for kraken test... 10:59:19 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmppmE2uJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:59:31 INFO - PROCESS | 1673 | RSS: Main: 245108736 10:59:31 INFO - PROCESS | 1673 | 10:59:34 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 10:59:35 INFO - PROCESS | 1673 | RSS: Main: 258195456 10:59:35 INFO - PROCESS | 1673 | 10:59:38 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 10:59:38 INFO - PROCESS | 1673 | RSS: Main: 266821632 10:59:38 INFO - PROCESS | 1673 | 10:59:42 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 10:59:43 INFO - PROCESS | 1673 | RSS: Main: 265261056 10:59:43 INFO - PROCESS | 1673 | 10:59:45 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 10:59:45 INFO - PROCESS | 1673 | RSS: Main: 267583488 10:59:45 INFO - PROCESS | 1673 | 10:59:48 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:59:48 INFO - PROCESS | 1673 | RSS: Main: 268050432 10:59:48 INFO - PROCESS | 1673 | 10:59:51 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 10:59:52 INFO - PROCESS | 1673 | RSS: Main: 268795904 10:59:52 INFO - PROCESS | 1673 | 10:59:55 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 10:59:55 INFO - PROCESS | 1673 | RSS: Main: 269041664 10:59:55 INFO - PROCESS | 1673 | 10:59:58 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 10:59:59 INFO - PROCESS | 1673 | RSS: Main: 269242368 10:59:59 INFO - PROCESS | 1673 | 11:00:01 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:00:01 INFO - PROCESS | 1673 | RSS: Main: 269168640 11:00:01 INFO - PROCESS | 1673 | 11:00:03 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:00:04 INFO - PROCESS | 1673 | RSS: Main: 268898304 11:00:04 INFO - PROCESS | 1673 | 11:00:06 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:00:07 INFO - PROCESS | 1673 | RSS: Main: 269176832 11:00:07 INFO - PROCESS | 1673 | 11:00:10 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:00:10 INFO - PROCESS | 1673 | RSS: Main: 269185024 11:00:10 INFO - PROCESS | 1673 | 11:00:13 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:00:14 INFO - PROCESS | 1673 | RSS: Main: 269209600 11:00:14 INFO - PROCESS | 1673 | 11:00:16 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 11:00:16 INFO - PROCESS | 1673 | RSS: Main: 271114240 11:00:16 INFO - PROCESS | 1673 | 11:00:16 INFO - PROCESS | 1673 | __start_tp_report 11:00:16 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 11:00:16 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 11:00:16 INFO - PROCESS | 1673 | |i|pagename|runs| 11:00:16 INFO - PROCESS | 1673 | |0;ai-astar;158;173;131;115;118;119;118;117;117;135 11:00:16 INFO - PROCESS | 1673 | |1;audio-beat-detection;146;111;138;155;115;133;158;146;158;111 11:00:16 INFO - PROCESS | 1673 | |2;audio-dft;208;240;258;278;201;203;168;260;256;212 11:00:16 INFO - PROCESS | 1673 | |3;audio-fft;69;78;76;143;59;62;59;61;133;59 11:00:16 INFO - PROCESS | 1673 | |4;audio-oscillator;68;73;111;72;71;93;116;100;103;145 11:00:16 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;98;84;136;76;130;130;91;86;79;133 11:00:16 INFO - PROCESS | 1673 | |6;imaging-darkroom;95;95;95;96;96;95;95;123;132;108 11:00:16 INFO - PROCESS | 1673 | |7;imaging-desaturate;110;121;91;119;148;148;91;90;93;108 11:00:16 INFO - PROCESS | 1673 | |8;json-parse-financial;57;58;58;58;57;57;57;59;58;57 11:00:16 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;66;70;68;77;73;76;74;71;68;70 11:00:16 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;93;87;91;79;98;110;112;83;91;85 11:00:16 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;154;146;140;140;135;145;159;165;221;153 11:00:16 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;176;180;178;179;178;175;189;242;176;179 11:00:16 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;71;69;69;70;73;72;69;67;72;82 11:00:16 INFO - PROCESS | 1673 | __end_tp_report 11:00:16 INFO - PROCESS | 1673 | __start_cc_report 11:00:16 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,967 11:00:16 INFO - PROCESS | 1673 | __end_cc_report 11:00:16 INFO - PROCESS | 1673 | __startTimestamp1472925616462__endTimestamp 11:00:16 INFO - PROCESS | 1673 | 11:00:16 INFO - PROCESS | 1673 | ------- Summary: start ------- 11:00:16 INFO - PROCESS | 1673 | Number of tests: 14 11:00:16 INFO - PROCESS | 1673 | 11:00:16 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:130.10 Median:125.00 stddev:20.09 (16.1%) stddev-sans-first:18.59 11:00:16 INFO - PROCESS | 1673 | Values: 158.0 173.0 131.0 115.0 118.0 119.0 118.0 117.0 117.0 135.0 11:00:16 INFO - PROCESS | 1673 | 11:00:16 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:146.00 stddev:18.92 (13.0%) stddev-sans-first:19.79 11:00:16 INFO - PROCESS | 1673 | Values: 146.0 111.0 138.0 155.0 115.0 133.0 158.0 146.0 158.0 111.0 11:00:16 INFO - PROCESS | 1673 | 11:00:16 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:228.40 Median:248.00 stddev:34.90 (14.1%) stddev-sans-first:36.22 11:00:16 INFO - PROCESS | 1673 | Values: 208.0 240.0 258.0 278.0 201.0 203.0 168.0 260.0 256.0 212.0 11:00:16 INFO - PROCESS | 1673 | 11:00:16 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:79.90 Median:61.50 stddev:31.49 (51.2%) stddev-sans-first:33.16 11:00:16 INFO - PROCESS | 1673 | Values: 69.0 78.0 76.0 143.0 59.0 62.0 59.0 61.0 133.0 59.0 11:00:16 INFO - PROCESS | 1673 | 11:00:16 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:69.50 stddev:24.96 (35.9%) stddev-sans-first:24.46 11:00:16 INFO - PROCESS | 1673 | Values: 68.0 73.0 111.0 72.0 71.0 93.0 116.0 100.0 103.0 145.0 11:00:16 INFO - PROCESS | 1673 | 11:00:16 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:104.30 Median:81.50 stddev:24.84 (30.5%) stddev-sans-first:26.24 11:00:16 INFO - PROCESS | 1673 | Values: 98.0 84.0 136.0 76.0 130.0 130.0 91.0 86.0 79.0 133.0 11:00:16 INFO - PROCESS | 1673 | 11:00:16 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:103.00 Median:95.00 stddev:13.68 (14.4%) stddev-sans-first:14.20 11:00:16 INFO - PROCESS | 1673 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 95.0 123.0 132.0 108.0 11:00:16 INFO - PROCESS | 1673 | 11:00:16 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:111.90 Median:119.00 stddev:22.28 (18.7%) stddev-sans-first:23.62 11:00:16 INFO - PROCESS | 1673 | Values: 110.0 121.0 91.0 119.0 148.0 148.0 91.0 90.0 93.0 108.0 11:00:16 INFO - PROCESS | 1673 | 11:00:16 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 11:00:16 INFO - PROCESS | 1673 | Values: 57.0 58.0 58.0 58.0 57.0 57.0 57.0 59.0 58.0 57.0 11:00:16 INFO - PROCESS | 1673 | 11:00:16 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:72.00 stddev:3.62 (5.0%) stddev-sans-first:3.30 11:00:16 INFO - PROCESS | 1673 | Values: 66.0 70.0 68.0 77.0 73.0 76.0 74.0 71.0 68.0 70.0 11:00:16 INFO - PROCESS | 1673 | 11:00:16 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:92.90 Median:89.00 stddev:10.95 (12.3%) stddev-sans-first:11.61 11:00:16 INFO - PROCESS | 1673 | Values: 93.0 87.0 91.0 79.0 98.0 110.0 112.0 83.0 91.0 85.0 11:00:16 INFO - PROCESS | 1673 | 11:00:16 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:155.80 Median:153.50 stddev:24.72 (16.1%) stddev-sans-first:26.22 11:00:16 INFO - PROCESS | 1673 | Values: 154.0 146.0 140.0 140.0 135.0 145.0 159.0 165.0 221.0 153.0 11:00:16 INFO - PROCESS | 1673 | 11:00:16 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.20 Median:179.00 stddev:20.33 (11.4%) stddev-sans-first:21.29 11:00:16 INFO - PROCESS | 1673 | Values: 176.0 180.0 178.0 179.0 178.0 175.0 189.0 242.0 176.0 179.0 11:00:16 INFO - PROCESS | 1673 | 11:00:16 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.50 stddev:4.14 (5.8%) stddev-sans-first:4.39 11:00:16 INFO - PROCESS | 1673 | Values: 71.0 69.0 69.0 70.0 73.0 72.0 69.0 67.0 72.0 82.0 11:00:16 INFO - PROCESS | 1673 | -------- Summary: end -------- 11:00:16 INFO - PROCESS | 1673 | 11:00:17 INFO - TEST-INFO | 1673: exit 0 11:00:17 INFO - TEST-OK | kraken | took 61063ms 11:00:17 INFO - SUITE-END | took 1174s 11:00:17 INFO - Completed test suite (00:19:35) 11:00:17 INFO - javascript benchmark 11:00:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7157.772557997605, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2862.570614407837, 3373.7807042542217, 3398.524206611074, 3418.965810341896, 3420.127867393814, 5594.916076258849, 5640.605157638967, 5654.886902261952, 5678.375378708339, 5754.251947246862, 5681.914771278434, 5720.084786434161, 5762.452567006138, 5765.827025189241, 5810.3027636683555, 4386.912261754779, 5126.897462050757, 5249.950009997997, 5272.762725677335, 5347.144456886899, 5323.840284791462, 5338.145896656536, 5362.383325917511, 5372.462753724635, 5384.0847056000575, 5154.149565321717, 5177.974110129463, 5252.816151434719, 5312.362516498007, 5316.282301889253, 5247.842564723064, 5259.63182577216, 5263.842084737464, 5290.994711004897, 5301.681899086028, 5168.896622067575, 5219.947800521984, 5220.138677118271, 5257.763400646942, 5320.813771517978, 4668.393108895856, 5620.887582248373, 5622.0, 5690.174924635905, 5722.084466485342, 6223.719932603044, 6235.6258624482225, 6261.906071408933, 6269.059641053833, 6298.716557754866, 6288.528360372945, 6290.716917738713, 6292.874142517124, 6301.968490157566, 6302.55882088254, 5673.744681489343, 5719.685417302088, 5726.685032323179, 5835.474807267324, 5855.502282305966, 6273.749050038039, 6293.653849038255, 6298.307186209513, 6311.368863113744, 6312.52656050798, 6015.969920150371, 6087.4521293083835, 6092.025275955826, 6092.634441933498, 6112.847178820476, 6134.957077261001, 6138.07928810673, 6139.662318572521, 6163.660998645028, 6246.625202487865, 6163.907541386883, 6171.753129874754, 6181.505479561624, 6198.845028874224, 6220.409061139185, 6213.099100630383, 6219.595726277777, 6227.875442491216, 6229.906551401733, 6245.500359971192, 4829.5653391194965, 4865.245886887538, 4886.438059623118, 4893.877653058702, 4918.2376731606655, 3468.5317482140094, 3636.2363903580017, 3713.721470889694, 3735.6824669903363, 4451.087527056946, 4925.335079764186, 5642.689652069175, 5788.247527821356, 5797.36229014808, 5832.9708351457975, 6111.57218994675, 6172.382761723881, 6191.97832357665, 6270.122182894398, 6287.49700023997, 5369.973150134224, 5448.536874365724, 5757.568182386338, 5802.21670074543, 5806.88386232273, 4865.221564549655, 5069.8732531687, 5372.1941708744, 5398.64908780928, 5440.020796256712, 6211.09939058843, 6217.937820621826, 6220.0047992322825, 6325.082862984841, 6420.550561460653, 5223.817166399158, 6282.246130464374, 6287.119803227461, 6294.402031806971, 6296.370362963667, 5257.2639830423, 6289.465395441439, 6313.305536391085, 6313.65274909866, 6318.684065796784, 6000.21997140369, 6130.581587308013, 6159.01455767093, 6179.721912514037, 6193.566450348432, 6141.385861413823, 6243.937560624336, 6257.186565746424, 6305.085762564494, 6309.49524038085, 5024.799008039638, 5149.948500515096, 6163.3528479509005, 6183.598066125687, 6184.350643182581, 5931.4068593142065, 6019.72911219005, 6064.454199121924, 6146.631202127886, 6165.136880836776, 4971.328870602567, 5859.736311865891, 5922.318933322723, 5932.436418540232, 5983.0, 5657.6138845983, 6068.120122582289, 6100.847478813065, 6128.080787881853, 6133.202683651097, 5801.129830525455, 5878.3239927408895, 5891.558133139946, 5896.0, 5983.611065280743], "value": 5626.1269150424105, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.8624869414829, 535.0582973965819, 541.9268398766168, 547.8164814787046, 560.8513743857876, 37049.81475092624, 39408.0, 39439.60560394395, 39447.0, 39462.80268598653, 40138.39792403116, 40592.0, 40603.593964060354, 40629.79685101578, 40844.0, 9548.904510954872, 9679.467629280387, 9764.072413120743, 9765.414075155479, 9787.608495660164, 9716.125548700615, 9769.0, 9806.264530160232, 9816.460094694788, 9838.655647052354, 9769.071938165864, 9783.755406114833, 9788.804223915517, 9823.852642210373, 9859.507024648774, 9753.95123024384, 9808.65669701557, 9811.852822207708, 9820.705378838646, 9834.360766550151, 9607.0, 9647.372920760128, 9691.612335506572, 9718.902810971942, 9726.076022777896, 38640.22719545593, 38943.61056389457, 38971.61028389737, 39069.41395879064, 39182.216355672725, 3093.7215650591556, 3304.950425743592, 3376.64545222753, 3421.0, 4054.1283624020975, 24033.759662403503, 24668.5066298673, 26980.460390792075, 27480.58779118315, 30195.698043019507, 2698.5142674318613, 3205.6313523944814, 3235.110344655239, 3328.650491698361, 3359.2273777031173, 347400.0, 348864.99999999744, 350134.0, 351507.0, 355565.0, 55036.44963550393, 55187.724061379435, 55217.0, 55240.723796380764, 55353.723231383585, 31793.84103079516, 32054.878079267113, 32942.50586241209, 33382.49926251108, 57751.422485775445, 16138.031718096952, 16278.86047976654, 16293.859429840035, 16294.940828846087, 16331.91834040846, 11528.558930133733, 11659.242149260272, 11955.043596512432, 12171.60026596935, 12498.25010499373, 15448.304826282843, 15533.533993980198, 17570.82429175692, 18106.91358518493, 18251.17869695867, 7303.561786292733, 7357.227491113463, 7928.643211055516, 7947.245011723877, 7967.163447838009, 691.4468425259772, 862.8101817600118, 895.3732387328765, 956.7416797464646, 999.81003609314, 28964.565531517044, 29209.85395073011, 29281.56077658837, 29750.702492975226, 29837.95567155139, 1020.1787561013456, 1021.667957913681, 1076.5370890516997, 1084.3439718970067, 1161.1175506614863, 14822.332995015251, 15247.08517488932, 15355.078695278318, 15398.846011539741, 15642.530724078295, 548970.0, 627931.0, 628682.0, 630761.0, 635069.8246508738, 48446.757766211646, 54696.0, 55228.0, 55364.0, 55431.44568554343, 1184.3722826901756, 1315.2371624457792, 1332.6468485851258, 1362.7206422683325, 1366.1598117157876, 25817.870910645328, 29006.77877981899, 29059.982900598377, 29077.854610726812, 29717.554236686035, 47733.76133119451, 47792.0, 47907.76046119747, 47910.80222994453, 47961.800954975006, 561454.0, 561606.0, 563248.0, 563705.0, 563812.0, 24977.87511062433, 25131.87434062818, 25491.107811226517, 25581.0, 26056.0, 44712.10575788401, 45624.8593785158, 46865.0, 47080.52919470761, 47846.0, 37121.0, 38320.80839595896, 38412.0, 39846.800765995984, 39880.60119398769, 33265.83367083149, 34509.827450862584, 37517.24965500729, 37718.51410409261, 38368.42447363347, 36412.98694866227, 36644.08389790277, 37627.62372376351, 37723.24553508969, 37906.620933790306, 32719.18202044968, 33804.0, 34151.85266651927, 34314.48528272028, 34556.13609659779, 20773.89613051925, 24744.876275618506, 24793.504129917663, 24906.750932490442, 24924.37689057788], "value": 19013.307081687395, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.23431645020133, 375.2101825656992, 380.7525108679359, 381.2965079428454, 395.0164091412384, 16024.83975160248, 18391.804532705366, 18664.346747863827, 19913.203471861125, 20233.39299821006, 17649.82350176498, 20163.899180504115, 20269.695954560695, 20513.0, 20544.178232870705, 5681.602287839853, 5702.344230413493, 5891.263592050994, 5914.704264786744, 5991.2510936132985, 4085.0, 5738.0532212184935, 6220.688965551704, 6540.313267106957, 6547.181602299713, 6288.811335659914, 6521.673916304189, 6556.672166391685, 6575.079488871562, 6653.534252602296, 6410.1666783318105, 6467.482601391877, 6541.738330466776, 6557.0, 6565.638889861056, 5545.889082218333, 5577.442255774431, 5584.91622625661, 5627.6904770237625, 5648.406917273668, 24537.63193552098, 24716.011359545595, 24738.25785226446, 24764.761761912014, 25162.24513264605, 2268.9319320420414, 2362.1968530699473, 2373.5134297468976, 2385.2844146755906, 2925.195571217932, 14288.642783930381, 14739.0, 15036.849631503654, 15217.391304347813, 15456.922715386463, 1840.484664294, 1844.9262029518936, 1894.8673592848506, 1902.6765449873556, 1930.9710354344695, 109101.0, 114337.42831285874, 129917.40165196643, 130075.69924300825, 130565.34717326352, 11137.888621113847, 11220.831687524693, 11522.36626985507, 11703.765924681458, 11707.882921170849, 14291.499797507038, 14342.85657143436, 14344.0, 14351.928240358731, 14376.993610447378, 6967.756128535579, 8154.469959452616, 8336.208060234268, 8438.324934005264, 8520.233179013918, 8339.374546909006, 8351.29014033814, 8362.498250105013, 8500.064992850781, 8523.48859068458, 3668.7615305005625, 4393.934090988638, 4439.378487011821, 4458.242098843204, 4524.886877828015, 1691.4925522343249, 1744.6946784312695, 1769.9292028318723, 1887.594167254047, 1909.6371689378973, 333.25849983785884, 374.0555098376621, 382.1077783375793, 416.473161450765, 828.9017052405587, 11009.339439633648, 11363.659090227306, 11701.765964680659, 11734.41327933617, 11976.940115299542, 356.55786824337633, 413.83860294485174, 414.22953306849234, 426.5989969428727, 435.16014092800566, 5741.3971532988435, 6039.16814880315, 6073.817785466443, 6210.72051757672, 6219.595726277868, 545918.0, 553470.0, 561734.0, 562793.0, 567476.0, 124884.0, 131033.0, 131610.0, 133165.3341733285, 135655.0, 441.2917267785223, 443.989922925341, 445.52106485528185, 445.5277405949704, 449.10403744529873, 11009.83485247738, 11039.448027598748, 11093.278936869077, 11228.4385780709, 11332.546698131982, 56525.0, 57004.71497642485, 57229.713851430475, 57750.0, 58886.705566471894, 74669.0, 75812.24187758051, 76236.0, 79545.60227198827, 84924.0, 7937.015107188072, 8008.959955200186, 8087.514749115072, 8160.387970902088, 8298.170182981654, 9237.491937943209, 12905.18386578361, 13358.0, 13531.820022294949, 13566.59300220995, 11230.0, 11588.594399195988, 11607.245529040585, 11632.709182270173, 11682.007029402255, 11034.227604067639, 11139.108871290115, 11367.147463940073, 11560.248583842023, 11624.651260461862, 11247.437628118725, 11620.186586938833, 11747.177697561088, 11797.988683847532, 11899.940500297444, 6389.712462939272, 6663.966680166568, 7118.074650295428, 7397.482176247611, 8206.548639824867, 8958.731238062868, 10633.946830265799, 10875.184361172785, 11403.429828508375, 11590.42047897585], "value": 8650.513173124808, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.6558058856167, 1509.2378348933787, 1683.3098429643842, 1781.8752687311894, 1831.9816801831978, 7745.3029227369525, 8291.668333266669, 8414.158584141584, 8754.168354006375, 8828.29373650108, 8513.191246831557, 8513.616887240074, 8589.87115193271, 8616.569171541429, 8663.39356245063, 1887.5092475956283, 2324.476992676647, 2367.4081479630095, 2368.7157541095094, 2375.5367703297866, 2028.310374472679, 2287.2223444029028, 2334.708161479815, 2339.7192336919593, 2364.373441038126, 2341.976580234193, 2345.659879317498, 2354.0701422937927, 2354.1289722802585, 2360.327306717586, 2322.2104484475276, 2324.360800779782, 2341.3678306857223, 2342.508073304608, 2342.9925132193234, 2338.251759436981, 2338.7895089441863, 2341.4263505441277, 2343.847649902751, 2345.542619189259, 8648.35137364694, 8673.219410253045, 8714.172153645393, 8734.737957861274, 8766.386352955296, 5191.169412893919, 5330.067238233293, 5330.253764472938, 5338.386085600167, 5355.7857685692525, 3325.900222993314, 3480.8955731327846, 3542.557180352456, 3604.819759012039, 3608.4226523756333, 1040.54216144896, 1070.2080460459204, 1071.6356438810765, 1091.81439155343, 1097.8956999085074, 11184.993350598405, 11201.0, 11263.21157518974, 11391.031762300214, 11391.316521008766, 4541.636669066466, 4619.122366750306, 4748.928766068511, 4767.0, 4804.855854324376, 9552.0, 9688.757781055388, 9701.70894873155, 9713.805723885484, 9748.756281092888, 5275.63070585063, 5286.894262114736, 5290.497402746733, 5298.523132918056, 5304.549113325334, 4323.0, 4677.18149323867, 4778.402699662543, 4853.369062021915, 4871.34236878017, 3832.7125465590193, 3852.5569559500454, 3953.0, 3954.5368213761094, 3959.5050618672667, 1284.4476874943864, 1286.1511402474323, 1292.6057552446407, 1293.0173068468032, 1310.960671179847, 779.7777633374461, 869.4739682492128, 889.2796834564024, 916.7983043730369, 946.2382781860531, 5477.643953143033, 5648.49163575272, 5761.5102716269585, 5790.305163380422, 5975.163477113208, 409.72957847820294, 432.99977053007655, 440.8148577597417, 446.5980617444326, 450.6237291861267, 3828.3874580067054, 3868.3037053330672, 3953.7430067046125, 3969.622885825842, 4012.1574469361763, 10158.238132140119, 10341.327813692085, 10435.739106522398, 10480.790384192274, 10513.737156571147, 8793.824123517621, 10380.688579342632, 10441.738956526147, 10468.842967355497, 10472.0, 6630.569013014235, 7840.372770178372, 7900.288973992253, 7921.683132674629, 7946.602669866484, 5657.2079908811975, 5659.915101273402, 5708.942910570841, 5731.828045158652, 5814.76740930358, 9499.667511637059, 9643.08390702882, 9654.56554455037, 9684.322097453392, 9729.318947673595, 8485.787855303666, 9646.131848133702, 9734.637150799035, 9845.556949937127, 9926.15627671627, 6698.799036028927, 7135.892961605477, 7278.708851646086, 7317.817054573678, 7323.048003759477, 8187.426880118334, 8261.669533218845, 8268.297194738274, 8273.379496537904, 8295.460795048302, 5877.735501902339, 7291.671874765754, 7384.446166537424, 7466.141393739572, 7524.097108347033, 6696.129503164558, 6909.930900690929, 7211.459140564583, 7214.134303883568, 7309.671064801991, 5827.446392592697, 6643.069970204078, 6749.662516874038, 6818.386345228755, 6819.897701534382, 4032.495938007749, 4357.692692192393, 4940.8764780880765, 4955.925661115159, 5059.089363914531, 4930.383702037246, 5031.0, 5042.495750424928, 5100.821471248489, 5119.897602048012], "value": 4402.648217413443, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.42849729557105, 300.8931829200632, 316.3009748455912, 319.243393158215, 326.2089433124672, 4638.373819534362, 5402.0, 5588.636738611987, 5683.971580142099, 5715.142728590714, 5562.888742225153, 5597.888042239153, 5600.747966341514, 5601.719914004304, 5607.57943154264, 3547.8935631931085, 4016.417619445186, 4150.0, 4167.937480937789, 4255.851045213418, 3306.933861322772, 4030.6775457963295, 4201.873943781676, 4203.369494575808, 4245.426867372896, 4161.210679407854, 4216.030313028005, 4231.597998190183, 4238.173556156551, 4271.487421509423, 4120.979395103005, 4137.758672398269, 4209.705320627558, 4233.0, 4259.510156332015, 2900.7824413169096, 3094.3501864608234, 3140.9214769630944, 3553.893383198508, 3654.196076863086, 4492.393526873863, 4997.600191984632, 5437.32033495813, 5461.8803145355105, 5500.4224556421395, 4404.537523560012, 4614.462045874756, 4817.445993710733, 4843.782029808667, 4850.102730994742, 4596.724196548184, 5279.5450115696, 5297.549708274802, 5683.0, 5881.911771323434, 4028.7784171870535, 4034.7780872052026, 4038.818253178614, 4055.9391609125887, 4057.3711074783455, 5697.31632204134, 5738.311402631711, 6117.235345581757, 6168.013117901114, 6193.659348735863, 3942.940855887164, 3961.8217180226957, 3964.32606456903, 3974.9801250994137, 3985.20295940813, 3234.433974054578, 3814.370628846265, 4026.838926442968, 4042.292598795199, 4057.776822274744, 4353.82584696615, 4564.7032942858605, 4737.644676649265, 4753.310769938409, 4812.422509298906, 4529.890176906613, 5841.766329346863, 5848.181254624356, 5858.53131749459, 5864.824055278348, 1355.9050866439254, 1377.869102435267, 1377.9311034448438, 1381.7927310903244, 1387.6392138044182, 790.7351037402419, 808.7816289601775, 837.7863644770545, 849.1678155407735, 852.7441767469859, 5251.474852514718, 5486.149646804752, 5503.229547863302, 5509.641873278224, 5530.364008139035, 4878.707277563358, 5461.726913654302, 5470.097433923438, 5601.691906945076, 6085.726142323606, 4502.617277531446, 5099.847004589868, 5239.345081864767, 5400.243965844785, 5559.082751346064, 2526.8610226437722, 2926.107537201174, 3155.0377134974055, 3158.589383380192, 3163.2566346908457, 4989.561378097818, 5272.286506885201, 5737.85655358611, 6235.532335074888, 6246.500279977591, 4939.777710003059, 5078.0, 5155.448053213609, 5473.850491396772, 5487.972560137174, 5938.970305148533, 6303.747850086037, 6305.96847015762, 6308.873822523616, 6318.241810982619, 5733.483986441241, 5974.312954010171, 6056.63856559596, 6078.756849725962, 6086.239220097488, 4969.701817890938, 5825.3592104867585, 5932.0, 5973.940260597338, 5993.190919226023, 6251.749930002749, 6266.717997690023, 6267.592606480564, 6325.715342809676, 6358.300586935341, 3704.592494825621, 3966.8809935701975, 3978.661813745748, 3993.8003099845473, 3998.5801490844206, 5373.382061063028, 5379.058664733734, 5526.585506086979, 5544.7782088716, 6099.11562823397, 4523.954760452485, 5377.574942640282, 5879.441453061952, 5891.734871930859, 5931.228940237742, 4597.609203217764, 5712.914306285492, 5801.419858014165, 5824.388439213822, 5853.560982926212, 5258.447862974333, 5749.367569567428, 5759.827205183851, 5830.067189249699, 5835.854103647443, 4853.6359773017875, 5608.242887210337, 5663.546916246608, 5777.971110144423, 5862.970685146547, 4978.0, 5726.885462290814, 5751.252337196305, 5760.395158508296, 5848.64908105515], "value": 4199.983940843141, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.5390226841209, 673.3973094080798, 706.8550947055854, 741.9912255802725, 785.5129819511901, 14870.702585948287, 16009.599760005976, 16034.75947860783, 16060.11669358185, 16101.114438705867, 13969.16185028899, 14537.636559086028, 14716.0, 14742.0, 14797.260136993134, 854.7692123126736, 879.6217626420637, 882.9779255518631, 884.7213127864734, 885.663447889801, 699.0562740300604, 861.4357595774777, 869.5999840073574, 887.0641473245723, 891.6076926152505, 900.2392977933636, 924.3021518753366, 930.0327659234422, 931.65063101337, 931.8695382646434, 910.2172131966504, 918.4351623751378, 921.4149015375218, 924.4638109896244, 928.1924725488834, 684.4968947823346, 689.8482333886537, 690.9412699920513, 691.9965400172966, 693.3447891742305, 14747.631309217248, 14824.555263342118, 14997.325120369609, 15047.699046019128, 15068.246587670572, 14337.35481903317, 14398.712025759427, 14442.566722998326, 14496.71006579873, 14719.0, 11794.233374830608, 11945.104117191246, 11992.580259690869, 11994.528426223605, 12050.517979280818, 3777.225668737902, 3833.8083095845095, 3853.6339047790416, 3864.3237433449317, 3959.3467077932105, 115879.84120158775, 117864.41067794691, 118243.817561825, 119574.0, 119668.0, 10986.285891417032, 11026.724331891766, 11231.10151187903, 11247.0, 11440.542378304941, 18310.267589296545, 21996.780032199793, 23374.415639608807, 23391.649125263135, 23393.181238656907, 7821.608919554, 7930.325922296669, 8091.0, 8119.9188008120345, 8131.674733010732, 3658.6707196352454, 4428.955710442919, 4515.074409745994, 4619.514950930104, 4620.260758278727, 3390.0, 3495.143689796016, 3496.6328535503408, 3502.124468882779, 3505.7545971782242, 583.6060659055206, 588.8928813829972, 601.7743346245159, 611.3000614296606, 615.8583525789004, 583.0758248176687, 585.2158108135119, 595.6508508228778, 645.4868379638199, 681.7954613615896, 8886.155815197546, 9056.864147037799, 9122.31582631292, 9543.665971690958, 9551.808963820684, 625.0, 646.741303478603, 659.6075335175562, 663.7212370804274, 672.4586707700348, 4518.164139634178, 4718.805446462386, 4720.527947205252, 4744.833930812405, 4794.993051459163, 136544.0, 160565.0, 161153.0, 162084.0, 162593.37406626018, 103137.71760541588, 122752.77247227592, 139033.6096639041, 144827.0, 145552.0, 121239.0, 122153.38923305327, 122928.38535807085, 123660.0, 124618.37690811488, 8281.95859020701, 8911.55442227873, 9008.909910900808, 9121.270298376247, 9317.534123293673, 66241.66879165573, 66690.0, 66842.33157668555, 67720.6613966927, 69325.2269909198, 57261.71369143128, 62711.6864415675, 67685.66157169183, 80421.39157216939, 94998.52500737729, 11578.421078946187, 13007.349632518526, 13304.534341298007, 13448.865511344762, 13507.189568625521, 13946.464116301297, 14568.34442450071, 14880.479183228535, 14884.330205141012, 15308.540743777705, 13512.25682587467, 13609.795853062014, 13779.379927903468, 13844.723105538034, 13991.650208744863, 13791.931040344734, 13798.241096739775, 13853.0, 14078.929605351908, 14132.434702612192, 10971.451427428756, 13385.263810490516, 13531.248451206742, 13693.178409295475, 13876.028677992848, 11109.388983605979, 11483.885161148282, 11490.425478726198, 11619.244749091282, 11670.533178672758, 9443.433393996382, 10139.188864890939, 10245.641402550875, 11115.44422778874, 11644.184907056424], "value": 7858.745084288641, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1624.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 173.0, 131.0, 115.0, 118.0, 119.0, 118.0, 117.0, 117.0, 135.0], "value": 130.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 111.0, 138.0, 155.0, 115.0, 133.0, 158.0, 146.0, 158.0, 111.0], "value": 137.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [208.0, 240.0, 258.0, 278.0, 201.0, 203.0, 168.0, 260.0, 256.0, 212.0], "value": 228.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 78.0, 76.0, 143.0, 59.0, 62.0, 59.0, 61.0, 133.0, 59.0], "value": 79.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 111.0, 72.0, 71.0, 93.0, 116.0, 100.0, 103.0, 145.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 84.0, 136.0, 76.0, 130.0, 130.0, 91.0, 86.0, 79.0, 133.0], "value": 104.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 123.0, 132.0, 108.0], "value": 103.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 121.0, 91.0, 119.0, 148.0, 148.0, 91.0, 90.0, 93.0, 108.0], "value": 111.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 57.0, 57.0, 57.0, 59.0, 58.0, 57.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 68.0, 77.0, 73.0, 76.0, 74.0, 71.0, 68.0, 70.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 87.0, 91.0, 79.0, 98.0, 110.0, 112.0, 83.0, 91.0, 85.0], "value": 92.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 146.0, 140.0, 140.0, 135.0, 145.0, 159.0, 165.0, 221.0, 153.0], "value": 155.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 180.0, 178.0, 179.0, 178.0, 175.0, 189.0, 242.0, 176.0, 179.0], "value": 185.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 69.0, 70.0, 73.0, 72.0, 69.0, 67.0, 72.0, 82.0], "value": 71.4, "unit": "score"}]}]} 11:00:17 INFO - Return code: 0 11:00:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:00:17 ERROR - # TBPL SUCCESS # 11:00:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:00:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:00:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:00:17 INFO - 2016-09-03 11:00:17.768 screenresolution[1679:11876] starting screenresolution argv=screenresolution get 11:00:17 INFO - 2016-09-03 11:00:17.771 screenresolution[1679:11876] Display 0: 1600x1200x32@60 11:00:17 INFO - 2016-09-03 11:00:17.776 screenresolution[1680:11878] starting screenresolution argv=screenresolution list 11:00:17 INFO - Available Modes on Display 0 11:00:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:00:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:00:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:00:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:00:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:00:18 INFO - Intel Iris: 11:00:18 INFO - Chipset Model: Intel Iris 11:00:18 INFO - Type: GPU 11:00:18 INFO - Bus: Built-In 11:00:18 INFO - VRAM (Dynamic, Max): 1536 MB 11:00:18 INFO - Vendor: Intel (0x8086) 11:00:18 INFO - Device ID: 0x0a2e 11:00:18 INFO - Revision ID: 0x0009 11:00:18 INFO - Displays: 11:00:18 INFO - Display: 11:00:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:00:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:00:18 INFO - Display Serial Number: 1600x1200 60 11:00:18 INFO - Main Display: Yes 11:00:18 INFO - Mirror: Off 11:00:18 INFO - Online: Yes 11:00:18 INFO - Rotation: Supported 11:00:18 INFO - Return code: 0 11:00:18 INFO - Running post-action listener: _resource_record_post_action 11:00:18 INFO - [mozharness: 2016-09-03 18:00:18.010641Z] Finished run-tests step (success) 11:00:18 INFO - Running post-run listener: _resource_record_post_run 11:00:18 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 32283648; Write bytes: 709563392; Read time: 205; Write time: 2050 11:00:18 INFO - TinderboxPrint: CPU usage
54.6% 11:00:18 INFO - TinderboxPrint: I/O read bytes / time
32,283,648 / 205 11:00:18 INFO - TinderboxPrint: I/O write bytes / time
709,563,392 / 2,050 11:00:18 INFO - TinderboxPrint: CPU idle
2,199.3 (45.4%) 11:00:18 INFO - TinderboxPrint: CPU system
983.1 (20.3%) 11:00:18 INFO - TinderboxPrint: CPU user
1,659.3 (34.3%) 11:00:18 INFO - TinderboxPrint: Swap in / out
448,040,960 / 0 11:00:18 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 391875072; Write bytes: 385811968; Read time: 29620; Write time: 833 11:00:18 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 31357952; Write bytes: 301698560; Read time: 194; Write time: 1159 11:00:18 INFO - Running post-run listener: _upload_blobber_files 11:00:18 INFO - Blob upload gear active. 11:00:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:00:18 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 11:00:18 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'] 11:00:18 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 11:00:18 INFO - (blobuploader) - INFO - Open directory for files ... 11:00:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:00:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:00:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:00:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:00:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:00:20 INFO - (blobuploader) - INFO - Done attempting. 11:00:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:00:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:00:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:00:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:00:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:00:21 INFO - (blobuploader) - INFO - Done attempting. 11:00:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:00:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:00:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:00:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:00:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:00:23 INFO - (blobuploader) - INFO - Done attempting. 11:00:23 INFO - (blobuploader) - INFO - Iteration through files over. 11:00:23 INFO - Return code: 0 11:00:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:00:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:00:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64a239c23658a7ff992c3ab8063b5879523e63585198bf2dc4120137d4a26bb74944840f26ec9cb2c04ea1039b1f4cce0e15416cf3cd62232d18e34c5f20595d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3127b3224ea9bfd811592c74a32c4e34fc9eb3c58b5bc60eba8ee15fd1c6ad368306bae2f04c842a12d4239d4b878184711f19dae0106413be158ba3467f5994", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fffabb7dc5ae6963cc93afe56046697528d5410963a7c72d0a64a36a599b844db3f7ea9cb09f28f3eb329a6c90a533b23f8f3a4f88800e5ff04fbe1a422028ea"} 11:00:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:00:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:00:23 INFO - Contents: 11:00:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64a239c23658a7ff992c3ab8063b5879523e63585198bf2dc4120137d4a26bb74944840f26ec9cb2c04ea1039b1f4cce0e15416cf3cd62232d18e34c5f20595d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3127b3224ea9bfd811592c74a32c4e34fc9eb3c58b5bc60eba8ee15fd1c6ad368306bae2f04c842a12d4239d4b878184711f19dae0106413be158ba3467f5994", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fffabb7dc5ae6963cc93afe56046697528d5410963a7c72d0a64a36a599b844db3f7ea9cb09f28f3eb329a6c90a533b23f8f3a4f88800e5ff04fbe1a422028ea"} 11:00:23 INFO - Running post-run listener: copy_logs_to_upload_dir 11:00:23 INFO - Copying logs to upload dir... 11:00:23 INFO - mkdir: /builds/slave/test/build/upload/logs 11:00:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.301495 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-03 11:00:23.480656) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-03 11:00:23.483744) ========= 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.vvT5GSRe3N/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.zl0fbZdoCa/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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/64a239c23658a7ff992c3ab8063b5879523e63585198bf2dc4120137d4a26bb74944840f26ec9cb2c04ea1039b1f4cce0e15416cf3cd62232d18e34c5f20595d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3127b3224ea9bfd811592c74a32c4e34fc9eb3c58b5bc60eba8ee15fd1c6ad368306bae2f04c842a12d4239d4b878184711f19dae0106413be158ba3467f5994", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fffabb7dc5ae6963cc93afe56046697528d5410963a7c72d0a64a36a599b844db3f7ea9cb09f28f3eb329a6c90a533b23f8f3a4f88800e5ff04fbe1a422028ea"} build_url:https://queue.taskcluster.net/v1/task/PGFUous9SA6YVGtP76ma4A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011120 build_url: 'https://queue.taskcluster.net/v1/task/PGFUous9SA6YVGtP76ma4A/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/64a239c23658a7ff992c3ab8063b5879523e63585198bf2dc4120137d4a26bb74944840f26ec9cb2c04ea1039b1f4cce0e15416cf3cd62232d18e34c5f20595d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3127b3224ea9bfd811592c74a32c4e34fc9eb3c58b5bc60eba8ee15fd1c6ad368306bae2f04c842a12d4239d4b878184711f19dae0106413be158ba3467f5994", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fffabb7dc5ae6963cc93afe56046697528d5410963a7c72d0a64a36a599b844db3f7ea9cb09f28f3eb329a6c90a533b23f8f3a4f88800e5ff04fbe1a422028ea"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-03 11:00:23.516816) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 11:00:23.517135) ========= 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.vvT5GSRe3N/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.zl0fbZdoCa/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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.005096 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 11:00:23.564804) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-03 11:00:23.565082) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-03 11:00:23.565381) ========= ========= Total master_lag: 0.21 =========