builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0124 starttime: 1470761799.83 results: success (0) buildid: 20160809064921 builduid: f0943623292a464f9eae2dd0e2c94b79 revision: 613fec9a571e48c64918ebd0a8153096300ff992 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 09:56:39.827239) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 09:56:39.827683) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 09:56:39.827956) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 09:56:39.850741) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 09:56:39.851096) ========= 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.4ayrFe1NVH/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.GgyZeOuu6a/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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-08-09 09:56:39-- 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% 14.5M=0.001s 2016-08-09 09:56:39 (14.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132673 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 09:56:40.005419) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 09:56:40.005742) ========= 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.4ayrFe1NVH/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.GgyZeOuu6a/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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.020206 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 09:56:40.055718) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 09:56:40.056095) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 613fec9a571e48c64918ebd0a8153096300ff992 --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 613fec9a571e48c64918ebd0a8153096300ff992 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4ayrFe1NVH/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.GgyZeOuu6a/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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-08-09 09:56:40,130 truncating revision to first 12 chars 2016-08-09 09:56:40,130 Setting DEBUG logging. 2016-08-09 09:56:40,130 attempt 1/10 2016-08-09 09:56:40,130 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/613fec9a571e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 09:56:41,259 unpacking tar archive at: fx-team-613fec9a571e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.377324 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 09:56:41.455124) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 09:56:41.455477) ========= script_repo_revision: 613fec9a571e48c64918ebd0a8153096300ff992 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 09:56:41.455873) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 09:56:41.456138) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 09:56:41.474430) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-08-09 09:56:41.474711) ========= /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.4ayrFe1NVH/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.GgyZeOuu6a/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 09:56:41 INFO - MultiFileLogger online at 20160809 09:56:41 in /builds/slave/test 09:56:41 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 09:56:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:56:41 INFO - {'append_to_log': False, 09:56:41 INFO - 'base_work_dir': '/builds/slave/test', 09:56:41 INFO - 'blob_upload_branch': 'Fx-Team', 09:56:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:56:41 INFO - 'branch': 'Fx-Team', 09:56:41 INFO - 'buildbot_json_path': 'buildprops.json', 09:56:41 INFO - 'config_files': ('talos/mac_config.py',), 09:56:41 INFO - 'default_actions': ('clobber', 09:56:41 INFO - 'read-buildbot-config', 09:56:41 INFO - 'download-and-extract', 09:56:41 INFO - 'populate-webroot', 09:56:41 INFO - 'create-virtualenv', 09:56:41 INFO - 'install', 09:56:41 INFO - 'run-tests'), 09:56:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:56:41 INFO - 'download_minidump_stackwalk': True, 09:56:41 INFO - 'download_symbols': 'ondemand', 09:56:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:56:41 INFO - 'tooltool.py': '/tools/tooltool.py', 09:56:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:56:41 INFO - '/tools/misc-python/virtualenv.py')}, 09:56:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:56:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:56:41 INFO - 'installer_path': 'installer.exe', 09:56:41 INFO - 'log_level': 'info', 09:56:41 INFO - 'log_name': 'talos', 09:56:41 INFO - 'log_to_console': True, 09:56:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:56:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:56:41 INFO - 'opt_config_files': (), 09:56:41 INFO - 'pip_index': False, 09:56:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:56:41 INFO - 'cmd': ('bash', 09:56:41 INFO - '-c', 09:56:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:56:41 INFO - 'enabled': True, 09:56:41 INFO - 'halt_on_failure': False, 09:56:41 INFO - 'name': 'check_screen_resolution'},), 09:56:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:56:41 INFO - 'cmd': ('bash', 09:56:41 INFO - '-c', 09:56:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:56:41 INFO - 'enabled': True, 09:56:41 INFO - 'halt_on_failure': False, 09:56:41 INFO - 'name': 'check_screen_resolution'},), 09:56:41 INFO - 'run_cmd_checks_enabled': True, 09:56:41 INFO - 'sps_profile': False, 09:56:41 INFO - 'sps_profile_interval': 0, 09:56:41 INFO - 'suite': 'dromaeojs-e10s', 09:56:41 INFO - 'system_bits': '32', 09:56:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:56:41 INFO - 'title': 't-yosemite-r7-0124', 09:56:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:56:41 INFO - 'use_talos_json': True, 09:56:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:56:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:56:41 INFO - 'work_dir': 'build'} 09:56:41 INFO - [mozharness: 2016-08-09 16:56:41.663109Z] Running clobber step. 09:56:41 INFO - Running pre-action listener: _resource_record_pre_action 09:56:41 INFO - Running main action method: clobber 09:56:41 INFO - rmtree: /builds/slave/test/build 09:56:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:56:41 INFO - Running post-action listener: _resource_record_post_action 09:56:41 INFO - [mozharness: 2016-08-09 16:56:41.849082Z] Finished clobber step (success) 09:56:41 INFO - [mozharness: 2016-08-09 16:56:41.849307Z] Running read-buildbot-config step. 09:56:41 INFO - Running pre-action listener: _resource_record_pre_action 09:56:41 INFO - Running main action method: read_buildbot_config 09:56:41 INFO - Using buildbot properties: 09:56:41 INFO - { 09:56:41 INFO - "project": "", 09:56:41 INFO - "product": "firefox", 09:56:41 INFO - "script_repo_revision": "production", 09:56:41 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 09:56:41 INFO - "repository": "", 09:56:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 09:56:41 INFO - "buildid": "20160809064921", 09:56:41 INFO - "pgo_build": "False", 09:56:41 INFO - "basedir": "/builds/slave/test", 09:56:41 INFO - "buildnumber": 85, 09:56:41 INFO - "slavename": "t-yosemite-r7-0124", 09:56:41 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 09:56:41 INFO - "platform": "yosemite_r7", 09:56:41 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 09:56:41 INFO - "branch": "fx-team", 09:56:41 INFO - "repo_path": "integration/fx-team", 09:56:41 INFO - "revision": "613fec9a571e48c64918ebd0a8153096300ff992", 09:56:41 INFO - "stage_platform": "macosx64", 09:56:41 INFO - "builduid": "f0943623292a464f9eae2dd0e2c94b79", 09:56:41 INFO - "slavebuilddir": "test" 09:56:41 INFO - } 09:56:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/edunnUfhT6qYUYbtSQuLzg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 09:56:41 INFO - Running post-action listener: _resource_record_post_action 09:56:41 INFO - [mozharness: 2016-08-09 16:56:41.855104Z] Finished read-buildbot-config step (success) 09:56:41 INFO - [mozharness: 2016-08-09 16:56:41.855324Z] Running download-and-extract step. 09:56:41 INFO - Running pre-action listener: _resource_record_pre_action 09:56:41 INFO - Running main action method: download_and_extract 09:56:41 INFO - mkdir: /builds/slave/test/build/tests 09:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:41 INFO - trying https://queue.taskcluster.net/v1/task/edunnUfhT6qYUYbtSQuLzg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 09:56:41 INFO - Downloading https://queue.taskcluster.net/v1/task/edunnUfhT6qYUYbtSQuLzg/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 09:56:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/edunnUfhT6qYUYbtSQuLzg/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 09:56:42 INFO - Downloaded 1199 bytes. 09:56:42 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 09:56:42 INFO - Using the following test package requirements: 09:56:42 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 09:56:42 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:56:42 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 09:56:42 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:56:42 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 09:56:42 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:56:42 INFO - u'jsshell-mac.zip'], 09:56:42 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:56:42 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 09:56:42 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 09:56:42 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:56:42 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 09:56:42 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:56:42 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 09:56:42 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:56:42 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 09:56:42 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:56:42 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 09:56:42 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:56: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')]} 09:56:42 INFO - trying https://queue.taskcluster.net/v1/task/edunnUfhT6qYUYbtSQuLzg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 09:56:42 INFO - Downloading https://queue.taskcluster.net/v1/task/edunnUfhT6qYUYbtSQuLzg/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 09:56:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/edunnUfhT6qYUYbtSQuLzg/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 09:56:43 INFO - Downloaded 16325990 bytes. 09:56:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:56:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:56:46 INFO - Return code: 0 09:56:46 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 09:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:46 INFO - trying https://queue.taskcluster.net/v1/task/edunnUfhT6qYUYbtSQuLzg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 09:56:46 INFO - Downloading https://queue.taskcluster.net/v1/task/edunnUfhT6qYUYbtSQuLzg/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 09:56:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/edunnUfhT6qYUYbtSQuLzg/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 09:56:47 INFO - Downloaded 16325990 bytes. 09:56:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:56:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:56:51 INFO - Return code: 0 09:56: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')]} 09:56:51 INFO - trying https://queue.taskcluster.net/v1/task/edunnUfhT6qYUYbtSQuLzg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 09:56:51 INFO - Downloading https://queue.taskcluster.net/v1/task/edunnUfhT6qYUYbtSQuLzg/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 09:56:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/edunnUfhT6qYUYbtSQuLzg/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 09:56:52 INFO - Downloaded 14413723 bytes. 09:56:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:56:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:56:52 INFO - Return code: 0 09:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:52 INFO - trying https://queue.taskcluster.net/v1/task/edunnUfhT6qYUYbtSQuLzg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:56:52 INFO - Downloading https://queue.taskcluster.net/v1/task/edunnUfhT6qYUYbtSQuLzg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 09:56:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/edunnUfhT6qYUYbtSQuLzg/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 09:56:55 INFO - Downloaded 110881767 bytes. 09:56:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/edunnUfhT6qYUYbtSQuLzg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:56:55 INFO - mkdir: /builds/slave/test/properties 09:56:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:56:55 INFO - Writing to file /builds/slave/test/properties/build_url 09:56:55 INFO - Contents: 09:56:55 INFO - build_url:https://queue.taskcluster.net/v1/task/edunnUfhT6qYUYbtSQuLzg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:56:55 INFO - Running post-action listener: _resource_record_post_action 09:56:55 INFO - Running post-action listener: set_extra_try_arguments 09:56:55 INFO - [mozharness: 2016-08-09 16:56:55.911483Z] Finished download-and-extract step (success) 09:56:55 INFO - [mozharness: 2016-08-09 16:56:55.911633Z] Running populate-webroot step. 09:56:55 INFO - Running pre-action listener: _resource_record_pre_action 09:56:55 INFO - Running main action method: populate_webroot 09:56:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:56:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:56:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:56:55 INFO - '--tppagecycles', 09:56:55 INFO - '7'], 09:56:55 INFO - 'tests': ['tsvgm']}}, 09:56:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:56:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:56:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:56:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:56:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:56:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:56:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:55 INFO - 'talos_options': ['--disable-e10s'], 09:56:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:55 INFO - 'talos_options': ['--disable-e10s'], 09:56:55 INFO - 'tests': ['damp', 'tps']}, 09:56:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:55 INFO - 'tests': ['damp', 'tps']}, 09:56:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:56:55 INFO - 'tests': ['dromaeo_dom']}, 09:56:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:56:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:56:55 INFO - 'tests': ['basic_compositor_video']}, 09:56:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:56:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:56:55 INFO - 'tests': ['a11yr', 09:56:55 INFO - 'ts_paint', 09:56:55 INFO - 'tpaint', 09:56:55 INFO - 'sessionrestore', 09:56:55 INFO - 'sessionrestore_no_auto_restore', 09:56:55 INFO - 'tabpaint']}, 09:56:55 INFO - 'other-e10s': {'tests': ['a11yr', 09:56:55 INFO - 'ts_paint', 09:56:55 INFO - 'tpaint', 09:56:55 INFO - 'sessionrestore', 09:56:55 INFO - 'sessionrestore_no_auto_restore', 09:56:55 INFO - 'tabpaint']}, 09:56:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:56:55 INFO - 'ts_paint', 09:56:55 INFO - 'tpaint', 09:56:55 INFO - 'sessionrestore', 09:56:55 INFO - 'sessionrestore_no_auto_restore', 09:56:55 INFO - 'tabpaint']}, 09:56:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:56:55 INFO - 'ts_paint', 09:56:55 INFO - 'tpaint', 09:56:55 INFO - 'sessionrestore', 09:56:55 INFO - 'sessionrestore_no_auto_restore', 09:56:55 INFO - 'tabpaint']}, 09:56:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:56:55 INFO - 'tests': ['a11yr', 09:56:55 INFO - 'ts_paint', 09:56:55 INFO - 'tpaint', 09:56:55 INFO - 'sessionrestore', 09:56:55 INFO - 'sessionrestore_no_auto_restore', 09:56:55 INFO - 'tabpaint']}, 09:56:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:56:55 INFO - 'tests': ['a11yr', 09:56:55 INFO - 'ts_paint', 09:56:55 INFO - 'tpaint', 09:56:55 INFO - 'sessionrestore', 09:56:55 INFO - 'sessionrestore_no_auto_restore', 09:56:55 INFO - 'tabpaint']}, 09:56:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:56:55 INFO - 'tests': ['tsvgx', 09:56:55 INFO - 'tsvgr_opacity', 09:56:55 INFO - 'tart', 09:56:55 INFO - 'tscrollx', 09:56:55 INFO - 'cart']}, 09:56:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:56:55 INFO - 'tsvgr_opacity', 09:56:55 INFO - 'tart', 09:56:55 INFO - 'tscrollx', 09:56:55 INFO - 'cart']}, 09:56:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:55 INFO - 'talos_options': ['--disable-e10s'], 09:56:55 INFO - 'tests': ['tp5o']}, 09:56:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:55 INFO - 'tests': ['tp5o']}, 09:56:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:55 INFO - 'talos_options': ['--disable-e10s', 09:56:55 INFO - '--xperf_path', 09:56:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:55 INFO - 'tests': ['tp5n']}, 09:56:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:55 INFO - 'talos_options': ['--xperf_path', 09:56:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:55 INFO - 'tests': ['tp5n']}}, 09:56:55 INFO - 'talos.zip': {'path': '', 09:56:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:56:55 INFO - Running post-action listener: _resource_record_post_action 09:56:55 INFO - [mozharness: 2016-08-09 16:56:55.930551Z] Finished populate-webroot step (success) 09:56:55 INFO - [mozharness: 2016-08-09 16:56:55.930664Z] Running create-virtualenv step. 09:56:55 INFO - Running pre-action listener: _resource_record_pre_action 09:56:55 INFO - Running main action method: create_virtualenv 09:56:55 INFO - Creating virtualenv /builds/slave/test/build/venv 09:56:55 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 09:56:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:56:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:56:56 INFO - Using real prefix '/tools/python27' 09:56:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:56:56 INFO - Installing distribute.............................................................................................................................................................................................done. 09:56:59 INFO - Installing pip.................done. 09:56:59 INFO - Return code: 0 09:56:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:56:59 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')]} 09:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:59 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')]} 09:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:59 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 0x10e8c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e95b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6bb586d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e82ad30>, '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 0x10e58fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e822b20>, '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.4ayrFe1NVH/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.GgyZeOuu6a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 09:56:59 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 09:56:59 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 09:56:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ayrFe1NVH/Render', 09:56:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:59 INFO - 'HOME': '/Users/cltbld', 09:56:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:59 INFO - 'LOGNAME': 'cltbld', 09:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:59 INFO - 'MOZ_NO_REMOTE': '1', 09:56:59 INFO - 'NO_EM_RESTART': '1', 09:56:59 INFO - 'PAGER': '/bin/cat', 09:56:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:59 INFO - 'PWD': '/builds/slave/test', 09:56:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:59 INFO - 'SHELL': '/bin/bash', 09:56:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgyZeOuu6a/Listeners', 09:56:59 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 09:56:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:59 INFO - 'USER': 'cltbld', 09:56:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:59 INFO - 'XPC_FLAGS': '0x0', 09:56:59 INFO - 'XPC_SERVICE_NAME': '0', 09:56:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:00 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 09:57:00 INFO - Cleaning up... 09:57:00 INFO - Return code: 0 09:57:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:00 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 0x10e8c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e95b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6bb586d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e82ad30>, '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 0x10e58fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e822b20>, '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.4ayrFe1NVH/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.GgyZeOuu6a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 09:57:00 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 09:57:00 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 09:57:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ayrFe1NVH/Render', 09:57:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:00 INFO - 'HOME': '/Users/cltbld', 09:57:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:00 INFO - 'LOGNAME': 'cltbld', 09:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:00 INFO - 'MOZ_NO_REMOTE': '1', 09:57:00 INFO - 'NO_EM_RESTART': '1', 09:57:00 INFO - 'PAGER': '/bin/cat', 09:57:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:00 INFO - 'PWD': '/builds/slave/test', 09:57:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:00 INFO - 'SHELL': '/bin/bash', 09:57:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgyZeOuu6a/Listeners', 09:57:00 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 09:57:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:00 INFO - 'USER': 'cltbld', 09:57:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:00 INFO - 'XPC_FLAGS': '0x0', 09:57:00 INFO - 'XPC_SERVICE_NAME': '0', 09:57:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:00 INFO - Downloading/unpacking psutil>=3.1.1 09:57:00 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 09:57:00 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 09:57:00 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 09:57:00 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 09:57:00 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 09:57:00 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 09:57:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:57:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:03 INFO - Installing collected packages: psutil 09:57:03 INFO - Running setup.py install for psutil 09:57:03 INFO - building 'psutil._psutil_osx' extension 09:57:03 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 09:57:04 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 09:57:04 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 09:57:04 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 09:57:04 INFO - building 'psutil._psutil_posix' extension 09:57:04 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 09:57:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:57:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:57:04 INFO - ^ 09:57:04 INFO - 1 warning generated. 09:57:04 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 09:57:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:04 INFO - Successfully installed psutil 09:57:04 INFO - Cleaning up... 09:57:04 INFO - Return code: 0 09:57:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:57:04 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')]} 09:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:04 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')]} 09:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:04 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 0x10e8c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e95b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6bb586d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e82ad30>, '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 0x10e58fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e822b20>, '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.4ayrFe1NVH/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.GgyZeOuu6a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 09:57:04 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 09:57:04 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 09:57:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ayrFe1NVH/Render', 09:57:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:04 INFO - 'HOME': '/Users/cltbld', 09:57:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:04 INFO - 'LOGNAME': 'cltbld', 09:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:04 INFO - 'MOZ_NO_REMOTE': '1', 09:57:04 INFO - 'NO_EM_RESTART': '1', 09:57:04 INFO - 'PAGER': '/bin/cat', 09:57:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:04 INFO - 'PWD': '/builds/slave/test', 09:57:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:04 INFO - 'SHELL': '/bin/bash', 09:57:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgyZeOuu6a/Listeners', 09:57:04 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 09:57:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:04 INFO - 'USER': 'cltbld', 09:57:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:04 INFO - 'XPC_FLAGS': '0x0', 09:57:04 INFO - 'XPC_SERVICE_NAME': '0', 09:57:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:57:04 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 09:57:04 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 09:57:04 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 09:57:04 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 09:57:04 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 09:57:04 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 09:57:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:57:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:57:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:57:07 INFO - Installing collected packages: mozsystemmonitor 09:57:07 INFO - Running setup.py install for mozsystemmonitor 09:57:07 INFO - Successfully installed mozsystemmonitor 09:57:07 INFO - Cleaning up... 09:57:07 INFO - Return code: 0 09:57:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e8c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e95b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6bb586d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e82ad30>, '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 0x10e58fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e822b20>, '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.4ayrFe1NVH/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.GgyZeOuu6a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 09:57:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:57:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ayrFe1NVH/Render', 09:57:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:07 INFO - 'HOME': '/Users/cltbld', 09:57:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:07 INFO - 'LOGNAME': 'cltbld', 09:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:07 INFO - 'MOZ_NO_REMOTE': '1', 09:57:07 INFO - 'NO_EM_RESTART': '1', 09:57:07 INFO - 'PAGER': '/bin/cat', 09:57:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:07 INFO - 'PWD': '/builds/slave/test', 09:57:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:07 INFO - 'SHELL': '/bin/bash', 09:57:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgyZeOuu6a/Listeners', 09:57:07 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 09:57:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:07 INFO - 'USER': 'cltbld', 09:57:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:07 INFO - 'XPC_FLAGS': '0x0', 09:57:07 INFO - 'XPC_SERVICE_NAME': '0', 09:57:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:07 INFO - Downloading/unpacking jsonschema==2.5.1 09:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:57:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:57:10 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 09:57:10 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 09:57:10 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 09:57:10 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 09:57:10 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 09:57:10 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 09:57:10 INFO - Downloading functools32-3.2.3-2.tar.gz 09:57:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:57:10 INFO - warning: no files found matching '*.txt' 09:57:10 INFO - no previously-included directories found matching 'build' 09:57:10 INFO - no previously-included directories found matching 'dist' 09:57:10 INFO - no previously-included directories found matching '.git*' 09:57:10 INFO - Installing collected packages: jsonschema, functools32 09:57:10 INFO - Running setup.py install for functools32 09:57:10 INFO - warning: no files found matching '*.txt' 09:57:10 INFO - no previously-included directories found matching 'build' 09:57:10 INFO - no previously-included directories found matching 'dist' 09:57:10 INFO - no previously-included directories found matching '.git*' 09:57:10 INFO - Successfully installed jsonschema functools32 09:57:10 INFO - Cleaning up... 09:57:10 INFO - Return code: 0 09:57:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:57:10 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')]} 09:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:10 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')]} 09:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:10 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 0x10e8c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e95b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6bb586d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e82ad30>, '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 0x10e58fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e822b20>, '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.4ayrFe1NVH/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.GgyZeOuu6a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 09:57:10 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 09:57:10 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 09:57:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ayrFe1NVH/Render', 09:57:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:10 INFO - 'HOME': '/Users/cltbld', 09:57:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:10 INFO - 'LOGNAME': 'cltbld', 09:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:10 INFO - 'MOZ_NO_REMOTE': '1', 09:57:10 INFO - 'NO_EM_RESTART': '1', 09:57:10 INFO - 'PAGER': '/bin/cat', 09:57:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:10 INFO - 'PWD': '/builds/slave/test', 09:57:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:10 INFO - 'SHELL': '/bin/bash', 09:57:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgyZeOuu6a/Listeners', 09:57:10 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 09:57:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:10 INFO - 'USER': 'cltbld', 09:57:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:10 INFO - 'XPC_FLAGS': '0x0', 09:57:10 INFO - 'XPC_SERVICE_NAME': '0', 09:57:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:57:11 INFO - Cleaning up... 09:57:11 INFO - Return code: 0 09:57:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e8c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e95b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6bb586d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e82ad30>, '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 0x10e58fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e822b20>, '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.4ayrFe1NVH/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.GgyZeOuu6a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 09:57:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:57:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:57:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ayrFe1NVH/Render', 09:57:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:11 INFO - 'HOME': '/Users/cltbld', 09:57:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:11 INFO - 'LOGNAME': 'cltbld', 09:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:11 INFO - 'MOZ_NO_REMOTE': '1', 09:57:11 INFO - 'NO_EM_RESTART': '1', 09:57:11 INFO - 'PAGER': '/bin/cat', 09:57:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:11 INFO - 'PWD': '/builds/slave/test', 09:57:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:11 INFO - 'SHELL': '/bin/bash', 09:57:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgyZeOuu6a/Listeners', 09:57:11 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 09:57:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:11 INFO - 'USER': 'cltbld', 09:57:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:11 INFO - 'XPC_FLAGS': '0x0', 09:57:11 INFO - 'XPC_SERVICE_NAME': '0', 09:57:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:11 INFO - Downloading/unpacking blobuploader==1.2.4 09:57:11 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 09:57:11 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 09:57:11 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 09:57:11 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 09:57:11 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 09:57:11 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 09:57:14 INFO - Downloading blobuploader-1.2.4.tar.gz 09:57:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:57:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:57:14 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 09:57:14 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 09:57:14 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 09:57:14 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 09:57:14 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 09:57:14 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 09:57:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:57:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:16 INFO - Downloading docopt-0.6.1.tar.gz 09:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:57:16 INFO - Installing collected packages: blobuploader, requests, docopt 09:57:16 INFO - Running setup.py install for blobuploader 09:57:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:57:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:57:16 INFO - Running setup.py install for requests 09:57:16 INFO - Running setup.py install for docopt 09:57:16 INFO - Successfully installed blobuploader requests docopt 09:57:16 INFO - Cleaning up... 09:57:17 INFO - Return code: 0 09:57:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:17 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 0x10e8c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e95b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6bb586d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e82ad30>, '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 0x10e58fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e822b20>, '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.4ayrFe1NVH/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.GgyZeOuu6a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 09:57:17 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 09:57:17 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 09:57:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ayrFe1NVH/Render', 09:57:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:17 INFO - 'HOME': '/Users/cltbld', 09:57:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:17 INFO - 'LOGNAME': 'cltbld', 09:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:17 INFO - 'MOZ_NO_REMOTE': '1', 09:57:17 INFO - 'NO_EM_RESTART': '1', 09:57:17 INFO - 'PAGER': '/bin/cat', 09:57:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:17 INFO - 'PWD': '/builds/slave/test', 09:57:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:17 INFO - 'SHELL': '/bin/bash', 09:57:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgyZeOuu6a/Listeners', 09:57:17 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 09:57:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:17 INFO - 'USER': 'cltbld', 09:57:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:17 INFO - 'XPC_FLAGS': '0x0', 09:57:17 INFO - 'XPC_SERVICE_NAME': '0', 09:57:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:17 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-JeWmFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:17 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-ytunN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:17 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-NIhYKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:17 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-z6XQ5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:17 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-cX0BkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:17 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-WL1A5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:57:17 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-td7bnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:57:18 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-cCUwRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:57:18 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-2iXJol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:57:18 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-ShPckc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:57:18 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-yprOfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:57:18 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-tsRNbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:57:18 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-IceX2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:57:18 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-muW72x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:18 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-s8NjCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:57:18 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-JkeMM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:18 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-tvXcuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:57:19 INFO - Running setup.py install for manifestparser 09:57:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:57:19 INFO - Running setup.py install for mozcrash 09:57:19 INFO - Running setup.py install for mozdebug 09:57:19 INFO - Running setup.py install for mozdevice 09:57:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:57:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:57:19 INFO - Running setup.py install for mozfile 09:57:19 INFO - Running setup.py install for mozhttpd 09:57:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:57:19 INFO - Running setup.py install for mozinfo 09:57:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:57:20 INFO - Running setup.py install for mozInstall 09:57:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:57:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:57:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:57:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:57:20 INFO - Running setup.py install for mozleak 09:57:20 INFO - Running setup.py install for mozlog 09:57:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:57:20 INFO - Running setup.py install for moznetwork 09:57:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:57:20 INFO - Running setup.py install for mozprocess 09:57:20 INFO - Running setup.py install for mozprofile 09:57:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:57:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:57:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:57:21 INFO - Running setup.py install for mozrunner 09:57:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:57:21 INFO - Running setup.py install for mozscreenshot 09:57:21 INFO - Running setup.py install for moztest 09:57:21 INFO - Running setup.py install for mozversion 09:57:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:57:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:57:21 INFO - Cleaning up... 09:57:21 INFO - Return code: 0 09:57:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:21 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 0x10e8c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e95b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6bb586d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e82ad30>, '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 0x10e58fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e822b20>, '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.4ayrFe1NVH/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.GgyZeOuu6a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 09:57:21 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 09:57:21 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 09:57:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ayrFe1NVH/Render', 09:57:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:21 INFO - 'HOME': '/Users/cltbld', 09:57:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:21 INFO - 'LOGNAME': 'cltbld', 09:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:21 INFO - 'MOZ_NO_REMOTE': '1', 09:57:21 INFO - 'NO_EM_RESTART': '1', 09:57:21 INFO - 'PAGER': '/bin/cat', 09:57:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:21 INFO - 'PWD': '/builds/slave/test', 09:57:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:21 INFO - 'SHELL': '/bin/bash', 09:57:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgyZeOuu6a/Listeners', 09:57:21 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 09:57:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:21 INFO - 'USER': 'cltbld', 09:57:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:21 INFO - 'XPC_FLAGS': '0x0', 09:57:21 INFO - 'XPC_SERVICE_NAME': '0', 09:57:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:21 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-XJpppU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:22 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)) 09:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:22 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-E7J8tg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:22 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)) 09:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:22 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-N7FE3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57:22 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)) 09:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:22 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-sEP7aX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57:22 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)) 09:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:22 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-obu34k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57:22 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)) 09:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:22 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-CvggVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:57:22 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)) 09:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:57:22 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-z9nFyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:57:22 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)) 09:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:57:22 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-pMrTdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:57:22 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)) 09:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:57:22 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-aTIjOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:57:22 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)) 09:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:57:22 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-BA3hTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:57:22 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)) 09:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:57:22 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-qQRMzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:57:23 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)) 09:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:57:23 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-9qyELn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:57:23 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)) 09:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:57:23 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-UiUAOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:57:23 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)) 09:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:57:23 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-Go_95K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:57:23 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)) 09:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:23 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-qLUCcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:23 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)) 09:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:57:23 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-UDn2c7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:57:23 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)) 09:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:23 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-WbMS9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57:23 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)) 09:57:23 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)) 09:57:23 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)) 09:57:23 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)) 09:57:23 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)) 09:57:23 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)) 09:57:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:57:23 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 09:57:23 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 09:57:23 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 09:57:23 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 09:57:23 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 09:57:23 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 09:57:26 INFO - Downloading blessings-1.6.tar.gz 09:57:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:57:26 INFO - Installing collected packages: blessings 09:57:26 INFO - Running setup.py install for blessings 09:57:26 INFO - Successfully installed blessings 09:57:26 INFO - Cleaning up... 09:57:26 INFO - Return code: 0 09:57:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:57:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:57:26 INFO - Reading from file tmpfile_stdout 09:57:26 INFO - Current package versions: 09:57:26 INFO - blessings == 1.6 09:57:26 INFO - blobuploader == 1.2.4 09:57:26 INFO - docopt == 0.6.1 09:57:26 INFO - functools32 == 3.2.3-2 09:57:26 INFO - jsonschema == 2.5.1 09:57:26 INFO - manifestparser == 1.1 09:57:26 INFO - mozInstall == 1.12 09:57:26 INFO - mozcrash == 0.17 09:57:26 INFO - mozdebug == 0.1 09:57:26 INFO - mozdevice == 0.48 09:57:26 INFO - mozfile == 1.2 09:57:26 INFO - mozhttpd == 0.7 09:57:26 INFO - mozinfo == 0.9 09:57:26 INFO - mozleak == 0.1 09:57:26 INFO - mozlog == 3.3 09:57:26 INFO - moznetwork == 0.27 09:57:26 INFO - mozprocess == 0.23 09:57:26 INFO - mozprofile == 0.28 09:57:26 INFO - mozrunner == 6.12 09:57:26 INFO - mozscreenshot == 0.1 09:57:26 INFO - mozsystemmonitor == 0.3 09:57:26 INFO - moztest == 0.7 09:57:26 INFO - mozversion == 1.4 09:57:26 INFO - psutil == 3.1.1 09:57:26 INFO - requests == 1.2.3 09:57:26 INFO - wsgiref == 0.1.2 09:57:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:26 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 0x10e8c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e95b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6bb586d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e82ad30>, '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 0x10e58fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e822b20>, '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.4ayrFe1NVH/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.GgyZeOuu6a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 09:57:26 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 09:57:26 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 09:57:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ayrFe1NVH/Render', 09:57:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:26 INFO - 'HOME': '/Users/cltbld', 09:57:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:26 INFO - 'LOGNAME': 'cltbld', 09:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:26 INFO - 'MOZ_NO_REMOTE': '1', 09:57:26 INFO - 'NO_EM_RESTART': '1', 09:57:26 INFO - 'PAGER': '/bin/cat', 09:57:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:26 INFO - 'PWD': '/builds/slave/test', 09:57:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:26 INFO - 'SHELL': '/bin/bash', 09:57:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgyZeOuu6a/Listeners', 09:57:26 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 09:57:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:26 INFO - 'USER': 'cltbld', 09:57:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:26 INFO - 'XPC_FLAGS': '0x0', 09:57:26 INFO - 'XPC_SERVICE_NAME': '0', 09:57:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:27 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)) 09:57:27 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)) 09:57:27 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)) 09:57:27 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)) 09:57:27 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)) 09:57:27 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)) 09:57:27 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)) 09:57:27 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)) 09:57:27 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)) 09:57:27 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)) 09:57:27 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)) 09:57:27 INFO - Cleaning up... 09:57:27 INFO - Return code: 0 09:57:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e8c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e95b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6bb586d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e82ad30>, '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 0x10e58fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e822b20>, '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.4ayrFe1NVH/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.GgyZeOuu6a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 09:57:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:57:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:57:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ayrFe1NVH/Render', 09:57:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:27 INFO - 'HOME': '/Users/cltbld', 09:57:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:27 INFO - 'LOGNAME': 'cltbld', 09:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:27 INFO - 'MOZ_NO_REMOTE': '1', 09:57:27 INFO - 'NO_EM_RESTART': '1', 09:57:27 INFO - 'PAGER': '/bin/cat', 09:57:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:27 INFO - 'PWD': '/builds/slave/test', 09:57:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:27 INFO - 'SHELL': '/bin/bash', 09:57:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgyZeOuu6a/Listeners', 09:57:27 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 09:57:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:27 INFO - 'USER': 'cltbld', 09:57:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:27 INFO - 'XPC_FLAGS': '0x0', 09:57:27 INFO - 'XPC_SERVICE_NAME': '0', 09:57:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:57:27 INFO - Cleaning up... 09:57:27 INFO - Return code: 0 09:57:27 INFO - Running post-action listener: _resource_record_post_action 09:57:27 INFO - Running post-action listener: _start_resource_monitoring 09:57:27 INFO - Starting resource monitoring. 09:57:27 INFO - [mozharness: 2016-08-09 16:57:27.354392Z] Finished create-virtualenv step (success) 09:57:27 INFO - [mozharness: 2016-08-09 16:57:27.355341Z] Running install step. 09:57:27 INFO - Running pre-action listener: _resource_record_pre_action 09:57:27 INFO - Running main action method: install 09:57:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:57:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:57:27 INFO - Reading from file tmpfile_stdout 09:57:27 INFO - Detecting whether we're running mozinstall >=1.0... 09:57:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:57:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:57:27 INFO - Reading from file tmpfile_stdout 09:57:27 INFO - Output received: 09:57:27 INFO - Usage: mozinstall [options] installer 09:57:27 INFO - Options: 09:57:27 INFO - -h, --help show this help message and exit 09:57:27 INFO - -d DEST, --destination=DEST 09:57:27 INFO - Directory to install application into. [default: 09:57:27 INFO - "/builds/slave/test"] 09:57:27 INFO - --app=APP Application being installed. [default: firefox] 09:57:27 INFO - mkdir: /builds/slave/test/build/application 09:57:27 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'] 09:57:27 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 09:58:01 INFO - Reading from file tmpfile_stdout 09:58:01 INFO - Output received: 09:58:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:58:01 INFO - Running post-action listener: _resource_record_post_action 09:58:01 INFO - [mozharness: 2016-08-09 16:58:01.474188Z] Finished install step (success) 09:58:01 INFO - [mozharness: 2016-08-09 16:58:01.474346Z] Running run-tests step. 09:58:01 INFO - Running pre-action listener: _resource_record_pre_action 09:58:01 INFO - Running main action method: run_tests 09:58:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:58:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:58:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:58:01 INFO - 2016-08-09 09:58:01.489 screenresolution[1995:277311] starting screenresolution argv=screenresolution get 09:58:01 INFO - 2016-08-09 09:58:01.491 screenresolution[1995:277311] Display 0: 1600x1200x32@60 09:58:01 INFO - 2016-08-09 09:58:01.498 screenresolution[1996:277313] starting screenresolution argv=screenresolution list 09:58:01 INFO - Available Modes on Display 0 09:58:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:58:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:58:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:58:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:58:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:58:01 INFO - Intel Iris: 09:58:01 INFO - Chipset Model: Intel Iris 09:58:01 INFO - Type: GPU 09:58:01 INFO - Bus: Built-In 09:58:01 INFO - VRAM (Dynamic, Max): 1536 MB 09:58:01 INFO - Vendor: Intel (0x8086) 09:58:01 INFO - Device ID: 0x0a2e 09:58:01 INFO - Revision ID: 0x0009 09:58:01 INFO - Displays: 09:58:01 INFO - Display: 09:58:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:58:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:58:01 INFO - Display Serial Number: 1600x1200 60 09:58:01 INFO - Main Display: Yes 09:58:01 INFO - Mirror: Off 09:58:01 INFO - Online: Yes 09:58:01 INFO - Rotation: Supported 09:58:01 INFO - Return code: 0 09:58:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:58:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:58:01 INFO - Python 2.7.3 09:58:01 INFO - Return code: 0 09:58:01 INFO - grabbing minidump binary from tooltool 09:58: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')]} 09:58:01 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 0x10e82ad30>, '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 0x10e58fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e822b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:58:01 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 09:58:01 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 09:58:01 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 09:58:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:58:01 INFO - Return code: 0 09:58:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:58:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:58:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:58:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:58:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:58:01 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/edunnUfhT6qYUYbtSQuLzg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0124', '--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 09:58:01 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/edunnUfhT6qYUYbtSQuLzg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0124 --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 09:58:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ayrFe1NVH/Render', 09:58:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:01 INFO - 'HOME': '/Users/cltbld', 09:58:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:01 INFO - 'LOGNAME': 'cltbld', 09:58:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:58:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:01 INFO - 'MOZ_NO_REMOTE': '1', 09:58:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:58:01 INFO - 'NO_EM_RESTART': '1', 09:58:01 INFO - 'PAGER': '/bin/cat', 09:58:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:01 INFO - 'PWD': '/builds/slave/test', 09:58:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:58:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:01 INFO - 'SHELL': '/bin/bash', 09:58:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgyZeOuu6a/Listeners', 09:58:01 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 09:58:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:01 INFO - 'USER': 'cltbld', 09:58:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:01 INFO - 'XPC_FLAGS': '0x0', 09:58:01 INFO - 'XPC_SERVICE_NAME': '0', 09:58:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:01 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/edunnUfhT6qYUYbtSQuLzg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0124', '--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 09:58:02 INFO - mozversion application_buildid: 20160809064921 09:58:02 INFO - mozversion application_changeset: 613fec9a571e48c64918ebd0a8153096300ff992 09:58:02 INFO - mozversion application_display_name: Nightly 09:58:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:58:02 INFO - mozversion application_name: Firefox 09:58:02 INFO - mozversion application_remotingname: firefox 09:58:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:58:02 INFO - mozversion application_vendor: Mozilla 09:58:02 INFO - mozversion application_version: 51.0a1 09:58:02 INFO - mozversion platform_buildid: 20160809064921 09:58:02 INFO - mozversion platform_changeset: 613fec9a571e48c64918ebd0a8153096300ff992 09:58:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:58:02 INFO - mozversion platform_version: 51.0a1 09:58:02 INFO - using testdate: 1470761882 09:58:02 INFO - actual date: 1470761882 09:58:02 INFO - starting webserver on 'localhost:49374' 09:58:02 INFO - SUITE-START | Running 2 tests 09:58:02 INFO - TEST-START | dromaeo_css 09:58:02 INFO - operating with platform_type : mac_ 09:58:02 INFO - Initialising browser for dromaeo_css test... 09:58:02 INFO - TEST-INFO | started process 2006 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpCIZAFh/profile http://localhost:49374/getInfo.html) 09:58:05 INFO - PROCESS | 2006 | __metrics Screen width/height:1600/1200 09:58:05 INFO - PROCESS | 2006 | colorDepth:24 09:58:05 INFO - PROCESS | 2006 | Browser inner width/height: 1024/689 09:58:05 INFO - PROCESS | 2006 | __metrics 09:58:05 ERROR - PROCESS | 2006 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 09:58:05 INFO - TEST-INFO | 2006: exit 0 09:58:05 INFO - Browser initialized. 09:58:05 INFO - Running cycle 1/1 for dromaeo_css test... 09:58:05 INFO - TEST-INFO | started process 2011 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpCIZAFh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:17 INFO - PROCESS | 2011 | RSS: Main: 254742528 09:58:17 INFO - PROCESS | 2011 | 09:59:07 INFO - PROCESS | 2011 | 1470761947481 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:01:19 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49374/tests/dromaeo/cssquery-ext.html) 10:01:20 INFO - PROCESS | 2011 | RSS: Main: 267792384 10:01:20 INFO - PROCESS | 2011 | 10:04:23 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-ext.html (next: http://localhost:49374/tests/dromaeo/cssquery-jquery.html) 10:04:23 INFO - PROCESS | 2011 | RSS: Main: 280051712 10:04:23 INFO - PROCESS | 2011 | 10:07:25 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49374/tests/dromaeo/cssquery-mootools.html) 10:07:26 INFO - PROCESS | 2011 | RSS: Main: 291721216 10:07:26 INFO - PROCESS | 2011 | 10:10:28 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49374/tests/dromaeo/cssquery-prototype.html) 10:10:28 INFO - PROCESS | 2011 | RSS: Main: 290078720 10:10:28 INFO - PROCESS | 2011 | 10:13:31 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49374/tests/dromaeo/cssquery-yui.html) 10:13:32 INFO - PROCESS | 2011 | RSS: Main: 294277120 10:13:32 INFO - PROCESS | 2011 | 10:16:34 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-yui.html (next: http://localhost:49374/tests/dromaeo/cssquery-dojo.html) 10:16:34 INFO - PROCESS | 2011 | RSS: Main: 295264256 10:16:34 INFO - PROCESS | 2011 | 10:16:34 INFO - PROCESS | 2011 | __start_tp_report 10:16:34 INFO - PROCESS | 2011 | _x_x_mozilla_page_load 10:16:34 INFO - PROCESS | 2011 | _x_x_mozilla_page_load_details 10:16:34 INFO - PROCESS | 2011 | |i|pagename|runs| 10:16:34 INFO - PROCESS | 2011 | |0;dojo.html;3245.918852028699;3316.1875340541555;3350.664933506649;3358.1772465745894;3376.5272861799353;5508.504234618884;5526.58550608705;5540;5576.86057848554;5863.237779088723;5833.649981001143;5855.941440585593;5876.147958546008;5900.380460051697;5925.5555833312455;5238.0571497130595;5310.309659744228;5322.547583455411;5359.437259087798;5377.8117765878205;4754.453237877637;4993.776524751423;5201.0378080055125;5281.947180528203;5290.92063619046;5248.947510524884;5271.762770675329;5300.708461034642;5300.708461034642;5336.43967383423;5238.214267859814;5250.553702935217;5251.816186433456;5276.234945932857;5350.785968561292;3837.712171587142;4997.800087996512;5183.896322073538;5227.111391063529;5274.762635681365;5711.885762284731;5796.188533605298;5837.474627283565;5839.7664093436215;5853.473187413153;6165.1368808366415;6234.283057448406;6236.095766113934;6248.9062664060075;6249.500039996789;6137.806028951355;6147.754089836401;6250.531210159211;6255.530835187379;6281.842953926142;5876.559258055663;5917.289925208916;5951.1073338999495;5991.191189189447;6044.184035155242;6272.717727702173;6272.717727702265;6294.8111556653375;6307.96846015767;6350.7459701611415;6083.239595050619;6115.571909966348;6222.782202622977;6245;6297.842553936188;6187;6245.843853903598;6253.499720022387;6281.842953926189;6282.089097080898;6203.286622038433;6214.689265536705;6258.123862659231;6270.592411493239;6285.779997700059;6133.610107582658;6138.294096178907;6202.317745048041;6205.5345849061505;6239.220097487814;4325.502567204811;4982.526659967298;4987.975060124676;5007.69953802773;5016.44819069902;4226.5139508956245;4450.688451808407;4480.820767169277;4492.573205545534;4496.955030449719;5374.731263436891;5725.997950358671;5789.334226563915;5865.88268234633;5927.940720592739;5487.725613719298;6130.917941862977;6179.3820617937845;6218.626882387071;6266.905996409966;5917.733701983421;5929.822105336847;5938.257717785277;5958.731857066442;5978.252718410199;5500.669959802424;5539.806106786243;5544.63959842609;5558.055130627803;5561.054620714488;6222.160008398899;6349.206349206349;6381.074744162071;6388.520860935541;6453.09656648079;6287.46556542699;6289.27673317556;6291.937080629135;6308.33762454954;6311.179546658905;6386.457151142019;6457.321981191907;6465.353464653497;6483.059956306215;6500;6111.804454079419;6114.753609057623;6134.78528251509;6142.938570614237;6217.782377616762;6204.038374052029;6211.9068213977735;6223.533235007302;6230.06549017651;6255.499560035278;4703.670743047954;6112.663803490851;6128.050152226412;6133.579501509479;6174.722137503733;6128.19758601264;6219.222597175353;6237.095621134819;6238.781642642486;6241.375862413904;5684.431556844283;6004.219451471281;6021.367756385516;6061.181740464981;6074.7360275580095;6005.7297421617;6006.729697163725;6115.6967227387295;6259.029850373199;6264.5301602379095;5503.174523821459;5768.653880767168;6052.636841789506;6102.389761023862;6119.816405507842 10:16:34 INFO - PROCESS | 2011 | |1;ext.html;489.15620554543415;507.8121095194779;514.1490832671929;531.7341329335333;532.7203218310389;33754.83122584387;39911.800440997824;39929.40105898407;40005.59994400052;40808.77573672791;40634.59365406345;41246.175076498526;41252.17495650093;41320.173596528126;41407.378889316686;9431.528423578828;9621.711348659552;9682.75793105171;9693.612255509772;9706.708798736014;9548.474833884133;9581.568829402693;9611.66359177429;9620.855687164698;9633.614655413776;9619.519024048805;9640.662576809813;9643.035696430336;9665.4200747955;9692.176165025981;9600.711978640651;9621;9650.08324209206;9651.179649729711;9680.95159524205;9514.28642851789;9601.519924003773;9617.038296170396;9644.517774111337;9649.855252171223;39046.82859514219;39248.607513924784;39355.60644393548;39367.40948885769;39453.21093578141;3397.643247459006;3471.3230919970615;3841.327767640652;3878;4119.752814831089;31237.37525249482;31733.682663173302;31959.680403195904;32050.679493205003;32613.673863261538;3227.144806626246;3246.724028457584;3271.2966712156763;3330.017644794767;3392.8133952632597;498372;501232;502821;504211;504662.4766876179;31936.680633193835;32870.506942395885;56981;57302.7134864323;57483.71258143683;33869.98390048303;34161.82919085389;34315.48526772101;34332;34449.31101378008;14577.250729912266;14657.56027319182;14667.633309167357;14732.779008314883;14752.55742327732;12457.563985260653;12504.437300321508;12529.749405012031;12531.93734031324;12551.93724031374;7587.658555365022;7599.544027358376;7611.733589324347;7681.001469808889;7716.189800070912;3147.5848704155787;3201.326892045122;3202.9199270018435;3204.0548038328748;3228.0638614801915;719.7912605344496;917.3440989692268;935.5836652689624;969.743018100204;996.9681379771902;24289.757102429103;28085.859570702014;29866.552001719992;30278.243043924078;30515.69484305173;991.610219371326;1075.6181555547823;1095.1950316517352;1101.9008289254007;1204.9397530123458;15215.771763423558;15539.912206145462;15704.371825127095;15798.36806527726;16082;661491;662101;663206;665065;667060;53091.87632494657;54774.9999999992;57602.4239757597;58459.70770146122;58561.70719146377;1354.3905242640851;1361.6187467509114;1376.511338474847;1384.0934188106805;1393.8675825796533;29622.111336659935;30264.940727074445;30283.545746814256;30446.1318236073;30556.236094097825;49854.50145498499;50073.49926500688;50098.99802003866;50137.247941280184;50149;592040;595395;600369;601067;602691;26178.607320890584;26212.8689356552;26472.7352726478;26597;26757.598636020084;47106.29340559963;48047.75976120097;48526;49083.01833963229;49123;39433.60566394414;39652.20695586014;39792.801035994635;39934;40890.79554602208;32752;33602;35672.64327356693;38435.23129537338;39149.60850391573;38352.42471362987;38784;39366.80316598398;39582.81251562458;41154.58845411507;27570.724292756815;32250.032499025066;34394.82802585971;35430.29139417249;35716;25927.83324750353;25953.610695839954;26267;26274.60588091142;26418.73581264163 10:16:34 INFO - PROCESS | 2011 | |2;jquery.html;354.9574051113865;382.5753413710781;387.1656580069949;393.4059570049228;403.2117210852783;19550.608987820237;20317.59364812703;20811;21337.466563335925;21487.140514379425;11847.111466640015;12014;15257.923710381461;19049.333273335436;20423.897880510613;5168.560672342846;5344.545713614348;5389.838304850841;5390.353157621091;5404.6486978346475;5808.709564521757;5884.588078834483;5900.557458190631;5970.2835659720895;5973.581849270531;4590;5947.137665038566;5951.88096238075;5966.403359664042;5976.252968378953;4988.02733466974;5694.402087780785;5741.626794258402;5860.296764388258;5870.853228669296;4632.2125238709505;5598.356189038272;5625.6905870177125;5691.402402747734;5692.0608099663505;11201.495932683049;13438.86561134386;13477.460901563925;13579.845713114397;25256.621150682753;2190.211523851412;2190.9671354929687;2208.768079351661;2282.7374851892077;2397.2568503763887;9674.613015479443;10166.4916754162;10208.387496750218;10277.023682750127;10461.79076418475;1825.0600940515644;1843.64970655575;1938.060040880172;1948.4349538633778;1973.447434718281;98411.50794246055;106770;109064;131210.03184952235;132961;9911.900880991241;10906.90930906903;11412;11430.14273929442;11644.2431241969;14499.347529361205;14519.419223231163;14528.564143075724;14597.92701036488;14611.342489587994;8364.289035431935;8504;8529;8530.573471326408;8695.695650652324;8492.31196693587;8506.404551681322;8537.317014638815;8677.52273624944;8738.475691458532;3929.958560981342;4352.825886964486;4534.478534968521;4552.2488789350045;4577.5880170784785;1941.4272789527124;1997.1711739628183;1997.8201961823506;2016.374923773635;2021.5956808638332;741.5143081281769;848.5757121439281;865.9781457879636;962.9229661627053;1000.9940010289612;15655.530334089995;20199.39401817948;21160.682589761167;21229.363119106452;21559.46101347479;902.2105657549644;953.3945944325403;974.1086905481405;991.9950400247952;998.8501724741346;6616.966915165393;9157.862632060524;11125.388103654377;11201.663950081347;11214.271072380268;573507;581284;583726;594089;595384;74150.51698966099;74274.62862685652;110879.44560277148;126783;130759;1017.5014243020867;1019.1133713669155;1022.3610243597751;1023.0843395161289;1078.320657985464;18527.907360463112;18736.15687294048;18929.48564114895;18964.905175474036;19077.61844763125;38029.61970380371;45403.545964541256;56529.71735141298;58164;58828.70585647044;79328.60335698516;85022.14977850142;85610;85832;86954;6908.723651054102;7243.927560724536;7350.191478937206;7448.70205191808;7472.439567032603;9945.453000085065;11801.17391782567;12203.267803931793;12842.678933026375;13314.40085196149;11078.889211107786;11124.332540047622;11397.715057123638;11416.0021996152;11465.713357166138;9703.466309353053;11211.159163062966;11357.0914326852;11438.885611143782;11515.251508652245;10808.622103137297;11367.488463019019;11532.827007594726;11686.824697629712;11725.706857328634;7214.098237720285;7387.852242955003;7468.2158373372185;7544.358729507834;7569.091708994956;10491.265611407129;10602;10780.460976951277;11134.832977505506;11336.94331528337 10:16:34 INFO - PROCESS | 2011 | |3;mootools.html;1474.4765608209088;1525.3059857764717;1710.9486715398543;1857.5541869951207;1875.596746699461;7074.64626768662;7850.8037299067555;8301.086880443154;8408.789780255496;8823.338249631272;8533.871991920127;8610.483370997745;8671.089535598767;8684.91315086849;8698.826023479527;1963.9509012274737;2278.7835155660227;2327.592671282527;2331.2423462374713;2336.123953517431;2255.2670382125793;2289.164454973939;2292.3123063081093;2299.7700229976954;2312.1329501436962;2315.9768402316013;2317.8261630377788;2334.089705015037;2335.1593426366494;2335.532893421314;2291.209532711212;2302.5049614332997;2306.7577904320055;2317.8725170115636;2319.1651005637955;2271.3867255840833;2274.7725227477285;2277.4761804784825;2282.988585057081;2285.2801367569164;7854.253845884632;8304.377171712145;8585.785355366166;8747.737567872973;8795.34034947375;4614.630829533629;5125.897482050375;5203.063448579254;5281.973590132063;5317.175837745117;3443.9827800860835;3509.4209455439823;3582.0507565495163;3597.9100522486888;3623.873164439232;1075.8224892892663;1082.5345101606306;1085.0505807418508;1102.2725001499052;1103.2608152537819;11238.775224495546;11351.716207094805;11375.829362559569;11462.369569673665;11510.42447877611;4498.415206023262;4523.547645235516;4714.316424118552;4725.503822098699;4726.952730472652;9672.032796720272;9744;9754;9770.974047725029;9776.853347199798;5196.948030519722;5215.608829337815;5251.317328747315;5284.497972692588;5293.311869457023;4384.386185933972;4707.199776038082;4815.759212039454;4858.95141048585;4869.123557759637;3831.7892515911894;3863.61363863617;3934.822932967966;3945.763254204757;3988.5213774346685;1267.4359909840032;1275.647813317886;1276.3426835179705;1281.557862537423;1281.8654041325713;891.572045418203;910.981780364389;912.2792993535165;957.3920560444168;959.8704174936295;5711.942880571224;5857.121431785266;5880.764769409261;5920.164748927846;5922.526197904157;410.96301332879585;432.38169417732314;436.6528609755189;436.8078045659963;437.6958014180114;3985.362342025262;4014.8394064237687;4029.119179786408;4053.1893621275863;4060.127072679388;9970.052844979715;10345;10541.209409294333;10677.77205621348;10684.252102352915;10237.23220758446;10406.947965260277;10595.417252051211;10614.522346494427;10616.946915265375;7880;7945.205479452008;7959.283664470341;8029;8191.426600138052;5853.473187413153;5853.9462896677305;5981.252343457068;6018.428249316308;6059.727312271047;9802.705918822161;9842;9949.204063675033;9987.450690212108;10128.240381971234;9677.564509597225;9978.850317245393;10042.598296068076;10057.497125143567;10232.897671023493;6891.483138764713;7300.926990730237;7447.441441891771;7510.39916806665;7627.5042122261875;8313.043999940084;8388.993320801543;8395.83208335842;8397.160283971554;8428.241458268785;7347.33873951347;7483.962580187064;7542.170361260147;7593.8860917085185;7617.5048621839405;7175.641217938978;7238.348548630648;7290.380317672845;7380.261973802577;7395.408367330709;6524.67376631176;6533.836654083686;6943.930560694328;6958.860822783415;7044.401225895856;4153.252414565407;4480.551944805624;4794.448638406628;4910.803567857246;4995.425526064549;4881.9023619528125;4954.900901982012;4976.925346119739;5001.274815151855;5010.849674509771 10:16:34 INFO - PROCESS | 2011 | |4;prototype.html;284.27935184307756;297.82952994730704;300.9037108125398;312.37524950099794;318.6717680788788;5032.5470707636305;5444.183372494128;5628.465295796897;5636.210930469732;5672.347680016799;5069.518395752407;5195.934398704763;5424.670955615869;5494.532964698005;5565.053940830058;4304.956950430503;4305.3091817613995;4305.569443055685;4306.117245964578;4316.870493885189;4149.792510374485;4259.87220383389;4276.957230427687;4296.720713153651;4333.57319900855;4197.559256278093;4212.304969680014;4213.462086338495;4216.427978932848;4232.8306867725405;4236.512801027875;4242.5999420191265;4257.723247988871;4264.424302719124;4269.402283680256;3048.801827881203;3455.87904423344;3617.385044542434;3664.78011319319;3683.8710645127294;4616.906672529413;4637.304404339342;5326.973365133188;5344.438833922421;5382.0129827945475;4137.834486620532;4711.646626502992;4732.290156476522;4732.290156476522;4744.93239021221;4513.796879140446;5808.477237048686;5828.591998560102;5896.498797602209;5910.202122713422;3279.6392396836327;3856.980715096435;3893.357595996657;3925.8407875668554;3932.7836968966694;4972.453030166715;5130.897382052375;5132.923006154911;5784.13238014297;6057.3639767824625;3537.911552211215;3972.503437070366;3981.462502562117;4007.979960100181;4046.3121269384274;3290.391277613649;3291.818949957775;3495.178633021238;3634.636536346344;4060.939085913714;3969.253528447474;4632.258838585877;4661.370714953506;4665.626749860003;4681.531846815359;5006.774695138727;5463.972680136574;5851.531877449794;5873.236479257669;5891.584450375325;1205.246366536687;1292.4571679894466;1329.6875234319928;1367.8373382624688;1367.9603501338854;884.8716936044237;893.4773157702687;911.4303560274828;911.5077857956629;921.8064206516707;4174.436451079066;5076.822311219164;5350.384705758887;5350.8127215547265;5448.91826622601;5296.788128474895;5967.8209653710455;5992.43071908168;5996.880062398727;6021.578489505692;5006.274090256892;5193.5585475234275;5325.8934821303355;5424.538914192338;5427.592930530147;2481.9203646413866;2630.3161178093833;2665.0012490632025;2690.8116431849585;2698.7571118599026;4862.197737373293;4907.263910413395;5230.3262955854525;5247.711375874287;5271.472852714698;4099.938500922489;4647.117047760915;4877.6585639004925;5041.823536176216;5169.198774190007;4462.795045337741;4731.9589690268085;4902.877428064256;5092.134337162617;5200.049981257029;4376.934345984749;4429.402030725811;5072.442031376472;5085.415177254515;5137.51193636604;4263.360495925636;4299.505556860876;4577.656675749266;4848.878778030577;4905.607551395951;4283.914321713611;4663.556962088596;4990.500949905126;5209.4009188943755;5297.231901374202;3435.0210190095704;3469.8612055518506;3484.2160513884173;3488.8604455821483;3547.5565554305713;4728.243481043017;4791.664583479123;4816.639846475272;5143.379835351852;5490.917636235539;4723.598494128038;5409.513143817076;5440.6605159781675;5966.671833049224;5974.970125149521;5403.702796346239;5902.321233058254;5938.990371636745;5955.749292648592;5995.370486099071;5389.973050134724;5760.164776107525;5801.8549536261935;5807.109236811262;5832.912506312494;4918.950810491992;5942.465178133989;5978.521718262442;5982.653902871819;5987.6108052976415;5519.613627046228;5680.245081135563;5793.971030144822;5838.883222335615;5877.089945767557 10:16:34 INFO - PROCESS | 2011 | |5;yui.html;776.6000509737486;776.8368642585059;777.3625626985867;778.4084096086968;795.8010497375657;14149.929250353747;15673.373065077412;16073.437429689933;16151.919240403782;16226.91886540567;11763.529458821637;12251.754964900696;13547.593572192825;14522.927385363086;14587.708245835078;845.2561745663838;860.1699360117485;882.4264228251656;896.7713233125577;902.5036230073466;870.0733718589681;876.4653561327585;882.1222883231194;884.5798245833242;885.6944354197824;802.2218448105328;925.6066171876959;931.2456909902967;932.4451951089125;934.9902105725834;897.2373482539854;915.8351496730586;921.8018126102886;922.4880191493718;924.9594206517668;612.8478460494287;645.3256347117274;672.6905623413236;688.277308825731;695.8817001109824;15136.167510786903;15437.768433473508;15642.843571564366;15644.296006679613;15650.45223417175;14104.435822567188;14140.646483837883;14360.281985900767;14371.06588071772;14477.71044579113;11883.989860861837;11988.400579971054;11995.64013079609;12081.93959030208;12316.5073397064;3809.4285857121376;3833.386658134713;3844.807759612036;3852.5184351956004;3988.660963818079;124242.37878810639;124938;128080;128563;129927.3926077917;10954.561817527368;11051.392173430539;11052;11146.609868654721;11538.596149134908;22370.888145559493;22567.88716056442;22611.43471413228;22668.773312266996;22669.88665056664;7782.49413788102;7936.484128531627;7946.165652606509;8110.107888132301;8181.877271840927;4528.162289976365;4566.977165114153;4590.908181836345;4610.170169369546;4766.4995175506765;3458.6541345865717;3577.874774382884;3594.406922857699;3596.946045809315;3621.94567081494;654.4012228810585;663.4393937123124;670.0953712488102;671.3454381977533;672.237010992527;473.85784264720445;497.6541303793829;577.763117121978;604.7067172421372;605.2102006881063;8179.263866252066;8223.712170074019;8469.40714150016;8711.869321960176;8904.643814247358;536.7021303176774;549.9065158922992;592.2537602620642;600.1028462448667;602.6594973839855;3372.3929692655556;3934.6458818706456;4199.97900010498;4272.4445822042935;4373.737575745466;91741;94765;95044;126588.36705816597;166384;113638.43180784043;124645.37677311555;124769;125202.24393268216;132015;84200.94794312361;112488.43755781169;116052;116103.19484025765;116877;8074;8122.83754324922;9941.552630131517;9989.900100998897;10110.69667909964;43193.7840310809;59158.704206478695;61900.69049654723;62403.375966241576;64841.35158648542;58659;62405;74692.62653686914;86765;91397;11280.210385272952;11343.943280283545;13235.867641323464;13606.523771667944;13821.861781382058;13298.534551290659;14393.920455965635;15224.543263702106;15384;15901.045937243802;13925;14074.507392241223;14225.359858806172;14227.217503037433;14631.26843657834;14134;14255;14505;14726.926365368105;14892.180930048951;11154.609588664358;11727.296362218294;11919.3444360561;13048.41282142287;13328.533501327407;9383.765405864908;11152.721181970515;11429.59996400122;11455.828162577402;11529.423528823358;8867.91132088671;9472.47901365404;10390.116840068678;11258.059679112244;11393.373364465035 10:16:34 INFO - PROCESS | 2011 | __end_tp_report 10:16:34 INFO - PROCESS | 2011 | __start_cc_report 10:16:34 INFO - PROCESS | 2011 | _x_x_mozilla_cycle_collect,414 10:16:34 INFO - PROCESS | 2011 | __end_cc_report 10:16:34 INFO - PROCESS | 2011 | __startTimestamp1470762994982__endTimestamp 10:16:34 INFO - PROCESS | 2011 | 10:16:34 INFO - PROCESS | 2011 | ------- Summary: start ------- 10:16:34 INFO - PROCESS | 2011 | Number of tests: 6 10:16:34 INFO - PROCESS | 2011 | 10:16:34 INFO - PROCESS | 2011 | [#0] dojo.html Cycles:165 Average:5764.06 Median:6021.37 stddev:677.03 (11.2%) stddev-sans-first:649.65 10:16:34 INFO - PROCESS | 2011 | Values: 3245.9 3316.2 3350.7 3358.2 3376.5 5508.5 5526.6 5540.0 5576.9 5863.2 5833.6 5855.9 5876.1 5900.4 5925.6 5238.1 5310.3 5322.5 5359.4 5377.8 4754.5 4993.8 5201.0 5281.9 5290.9 5248.9 5271.8 5300.7 5300.7 5336.4 5238.2 5250.6 5251.8 5276.2 5350.8 3837.7 4997.8 5183.9 5227.1 5274.8 5711.9 5796.2 5837.5 5839.8 5853.5 6165.1 6234.3 6236.1 6248.9 6249.5 6137.8 6147.8 6250.5 6255.5 6281.8 5876.6 5917.3 5951.1 5991.2 6044.2 6272.7 6272.7 6294.8 6308.0 6350.7 6083.2 6115.6 6222.8 6245.0 6297.8 6187.0 6245.8 6253.5 6281.8 6282.1 6203.3 6214.7 6258.1 6270.6 6285.8 6133.6 6138.3 6202.3 6205.5 6239.2 4325.5 4982.5 4988.0 5007.7 5016.4 4226.5 4450.7 4480.8 4492.6 4497.0 5374.7 5726.0 5789.3 5865.9 5927.9 5487.7 6130.9 6179.4 6218.6 6266.9 5917.7 5929.8 5938.3 5958.7 5978.3 5500.7 5539.8 5544.6 5558.1 5561.1 6222.2 6349.2 6381.1 6388.5 6453.1 6287.5 6289.3 6291.9 6308.3 6311.2 6386.5 6457.3 6465.4 6483.1 6500.0 6111.8 6114.8 6134.8 6142.9 6217.8 6204.0 6211.9 6223.5 6230.1 6255.5 4703.7 6112.7 6128.1 6133.6 6174.7 6128.2 6219.2 6237.1 6238.8 6241.4 5684.4 6004.2 6021.4 6061.2 6074.7 6005.7 6006.7 6115.7 6259.0 6264.5 5503.2 5768.7 6052.6 6102.4 6119.8 10:16:34 INFO - PROCESS | 2011 | 10:16:34 INFO - PROCESS | 2011 | [#1] ext.html Cycles:180 Average:70130.23 Median:39617.51 stddev:158647.65 (400.4%) stddev-sans-first:159006.54 10:16:35 INFO - PROCESS | 2011 | Values: 489.2 507.8 514.1 531.7 532.7 33754.8 39911.8 39929.4 40005.6 40808.8 40634.6 41246.2 41252.2 41320.2 41407.4 9431.5 9621.7 9682.8 9693.6 9706.7 9548.5 9581.6 9611.7 9620.9 9633.6 9619.5 9640.7 9643.0 9665.4 9692.2 9600.7 9621.0 9650.1 9651.2 9681.0 9514.3 9601.5 9617.0 9644.5 9649.9 39046.8 39248.6 39355.6 39367.4 39453.2 3397.6 3471.3 3841.3 3878.0 4119.8 31237.4 31733.7 31959.7 32050.7 32613.7 3227.1 3246.7 3271.3 3330.0 3392.8 498372.0 501232.0 502821.0 504211.0 504662.5 31936.7 32870.5 56981.0 57302.7 57483.7 33870.0 34161.8 34315.5 34332.0 34449.3 14577.3 14657.6 14667.6 14732.8 14752.6 12457.6 12504.4 12529.7 12531.9 12551.9 7587.7 7599.5 7611.7 7681.0 7716.2 3147.6 3201.3 3202.9 3204.1 3228.1 719.8 917.3 935.6 969.7 997.0 24289.8 28085.9 29866.6 30278.2 30515.7 991.6 1075.6 1095.2 1101.9 1204.9 15215.8 15539.9 15704.4 15798.4 16082.0 661491.0 662101.0 663206.0 665065.0 667060.0 53091.9 54775.0 57602.4 58459.7 58561.7 1354.4 1361.6 1376.5 1384.1 1393.9 29622.1 30264.9 30283.5 30446.1 30556.2 49854.5 50073.5 50099.0 50137.2 50149.0 592040.0 595395.0 600369.0 601067.0 602691.0 26178.6 26212.9 26472.7 26597.0 26757.6 47106.3 48047.8 48526.0 49083.0 49123.0 39433.6 39652.2 39792.8 39934.0 40890.8 32752.0 33602.0 35672.6 38435.2 39149.6 38352.4 38784.0 39366.8 39582.8 41154.6 27570.7 32250.0 34394.8 35430.3 35716.0 25927.8 25953.6 26267.0 26274.6 26418.7 10:16:35 INFO - PROCESS | 2011 | 10:16:35 INFO - PROCESS | 2011 | [#2] jquery.html Cycles:180 Average:33532.13 Median:13826.94 stddev:97538.10 (705.4%) stddev-sans-first:97779.91 10:16:35 INFO - PROCESS | 2011 | Values: 355.0 382.6 387.2 393.4 403.2 19550.6 20317.6 20811.0 21337.5 21487.1 11847.1 12014.0 15257.9 19049.3 20423.9 5168.6 5344.5 5389.8 5390.4 5404.6 5808.7 5884.6 5900.6 5970.3 5973.6 4590.0 5947.1 5951.9 5966.4 5976.3 4988.0 5694.4 5741.6 5860.3 5870.9 4632.2 5598.4 5625.7 5691.4 5692.1 11201.5 13438.9 13477.5 13579.8 25256.6 2190.2 2191.0 2208.8 2282.7 2397.3 9674.6 10166.5 10208.4 10277.0 10461.8 1825.1 1843.6 1938.1 1948.4 1973.4 98411.5 106770.0 109064.0 131210.0 132961.0 9911.9 10906.9 11412.0 11430.1 11644.2 14499.3 14519.4 14528.6 14597.9 14611.3 8364.3 8504.0 8529.0 8530.6 8695.7 8492.3 8506.4 8537.3 8677.5 8738.5 3930.0 4352.8 4534.5 4552.2 4577.6 1941.4 1997.2 1997.8 2016.4 2021.6 741.5 848.6 866.0 962.9 1001.0 15655.5 20199.4 21160.7 21229.4 21559.5 902.2 953.4 974.1 992.0 998.9 6617.0 9157.9 11125.4 11201.7 11214.3 573507.0 581284.0 583726.0 594089.0 595384.0 74150.5 74274.6 110879.4 126783.0 130759.0 1017.5 1019.1 1022.4 1023.1 1078.3 18527.9 18736.2 18929.5 18964.9 19077.6 38029.6 45403.5 56529.7 58164.0 58828.7 79328.6 85022.1 85610.0 85832.0 86954.0 6908.7 7243.9 7350.2 7448.7 7472.4 9945.5 11801.2 12203.3 12842.7 13314.4 11078.9 11124.3 11397.7 11416.0 11465.7 9703.5 11211.2 11357.1 11438.9 11515.3 10808.6 11367.5 11532.8 11686.8 11725.7 7214.1 7387.9 7468.2 7544.4 7569.1 10491.3 10602.0 10780.5 11134.8 11336.9 10:16:35 INFO - PROCESS | 2011 | 10:16:35 INFO - PROCESS | 2011 | [#3] mootools.html Cycles:180 Average:5613.20 Median:4864.04 stddev:3154.47 (64.9%) stddev-sans-first:3147.99 10:16:35 INFO - PROCESS | 2011 | Values: 1474.5 1525.3 1710.9 1857.6 1875.6 7074.6 7850.8 8301.1 8408.8 8823.3 8533.9 8610.5 8671.1 8684.9 8698.8 1964.0 2278.8 2327.6 2331.2 2336.1 2255.3 2289.2 2292.3 2299.8 2312.1 2316.0 2317.8 2334.1 2335.2 2335.5 2291.2 2302.5 2306.8 2317.9 2319.2 2271.4 2274.8 2277.5 2283.0 2285.3 7854.3 8304.4 8585.8 8747.7 8795.3 4614.6 5125.9 5203.1 5282.0 5317.2 3444.0 3509.4 3582.1 3597.9 3623.9 1075.8 1082.5 1085.1 1102.3 1103.3 11238.8 11351.7 11375.8 11462.4 11510.4 4498.4 4523.5 4714.3 4725.5 4727.0 9672.0 9744.0 9754.0 9771.0 9776.9 5196.9 5215.6 5251.3 5284.5 5293.3 4384.4 4707.2 4815.8 4859.0 4869.1 3831.8 3863.6 3934.8 3945.8 3988.5 1267.4 1275.6 1276.3 1281.6 1281.9 891.6 911.0 912.3 957.4 959.9 5711.9 5857.1 5880.8 5920.2 5922.5 411.0 432.4 436.7 436.8 437.7 3985.4 4014.8 4029.1 4053.2 4060.1 9970.1 10345.0 10541.2 10677.8 10684.3 10237.2 10406.9 10595.4 10614.5 10616.9 7880.0 7945.2 7959.3 8029.0 8191.4 5853.5 5853.9 5981.3 6018.4 6059.7 9802.7 9842.0 9949.2 9987.5 10128.2 9677.6 9978.9 10042.6 10057.5 10232.9 6891.5 7300.9 7447.4 7510.4 7627.5 8313.0 8389.0 8395.8 8397.2 8428.2 7347.3 7484.0 7542.2 7593.9 7617.5 7175.6 7238.3 7290.4 7380.3 7395.4 6524.7 6533.8 6943.9 6958.9 7044.4 4153.3 4480.6 4794.4 4910.8 4995.4 4881.9 4954.9 4976.9 5001.3 5010.8 10:16:35 INFO - PROCESS | 2011 | 10:16:35 INFO - PROCESS | 2011 | [#4] prototype.html Cycles:180 Average:4468.71 Median:4869.93 stddev:1372.28 (28.2%) stddev-sans-first:1339.70 10:16:35 INFO - PROCESS | 2011 | Values: 284.3 297.8 300.9 312.4 318.7 5032.5 5444.2 5628.5 5636.2 5672.3 5069.5 5195.9 5424.7 5494.5 5565.1 4305.0 4305.3 4305.6 4306.1 4316.9 4149.8 4259.9 4277.0 4296.7 4333.6 4197.6 4212.3 4213.5 4216.4 4232.8 4236.5 4242.6 4257.7 4264.4 4269.4 3048.8 3455.9 3617.4 3664.8 3683.9 4616.9 4637.3 5327.0 5344.4 5382.0 4137.8 4711.6 4732.3 4732.3 4744.9 4513.8 5808.5 5828.6 5896.5 5910.2 3279.6 3857.0 3893.4 3925.8 3932.8 4972.5 5130.9 5132.9 5784.1 6057.4 3537.9 3972.5 3981.5 4008.0 4046.3 3290.4 3291.8 3495.2 3634.6 4060.9 3969.3 4632.3 4661.4 4665.6 4681.5 5006.8 5464.0 5851.5 5873.2 5891.6 1205.2 1292.5 1329.7 1367.8 1368.0 884.9 893.5 911.4 911.5 921.8 4174.4 5076.8 5350.4 5350.8 5448.9 5296.8 5967.8 5992.4 5996.9 6021.6 5006.3 5193.6 5325.9 5424.5 5427.6 2481.9 2630.3 2665.0 2690.8 2698.8 4862.2 4907.3 5230.3 5247.7 5271.5 4099.9 4647.1 4877.7 5041.8 5169.2 4462.8 4732.0 4902.9 5092.1 5200.0 4376.9 4429.4 5072.4 5085.4 5137.5 4263.4 4299.5 4577.7 4848.9 4905.6 4283.9 4663.6 4990.5 5209.4 5297.2 3435.0 3469.9 3484.2 3488.9 3547.6 4728.2 4791.7 4816.6 5143.4 5490.9 4723.6 5409.5 5440.7 5966.7 5975.0 5403.7 5902.3 5939.0 5955.7 5995.4 5390.0 5760.2 5801.9 5807.1 5832.9 4919.0 5942.5 5978.5 5982.7 5987.6 5519.6 5680.2 5794.0 5838.9 5877.1 10:16:35 INFO - PROCESS | 2011 | 10:16:35 INFO - PROCESS | 2011 | [#5] yui.html Cycles:180 Average:23645.89 Median:3821.41 stddev:37334.18 (977.0%) stddev-sans-first:37399.43 10:16:35 INFO - PROCESS | 2011 | Values: 776.6 776.8 777.4 778.4 795.8 14149.9 15673.4 16073.4 16151.9 16226.9 11763.5 12251.8 13547.6 14522.9 14587.7 845.3 860.2 882.4 896.8 902.5 870.1 876.5 882.1 884.6 885.7 802.2 925.6 931.2 932.4 935.0 897.2 915.8 921.8 922.5 925.0 612.8 645.3 672.7 688.3 695.9 15136.2 15437.8 15642.8 15644.3 15650.5 14104.4 14140.6 14360.3 14371.1 14477.7 11884.0 11988.4 11995.6 12081.9 12316.5 3809.4 3833.4 3844.8 3852.5 3988.7 124242.4 124938.0 128080.0 128563.0 129927.4 10954.6 11051.4 11052.0 11146.6 11538.6 22370.9 22567.9 22611.4 22668.8 22669.9 7782.5 7936.5 7946.2 8110.1 8181.9 4528.2 4567.0 4590.9 4610.2 4766.5 3458.7 3577.9 3594.4 3596.9 3621.9 654.4 663.4 670.1 671.3 672.2 473.9 497.7 577.8 604.7 605.2 8179.3 8223.7 8469.4 8711.9 8904.6 536.7 549.9 592.3 600.1 602.7 3372.4 3934.6 4200.0 4272.4 4373.7 91741.0 94765.0 95044.0 126588.4 166384.0 113638.4 124645.4 124769.0 125202.2 132015.0 84200.9 112488.4 116052.0 116103.2 116877.0 8074.0 8122.8 9941.6 9989.9 10110.7 43193.8 59158.7 61900.7 62403.4 64841.4 58659.0 62405.0 74692.6 86765.0 91397.0 11280.2 11343.9 13235.9 13606.5 13821.9 13298.5 14393.9 15224.5 15384.0 15901.0 13925.0 14074.5 14225.4 14227.2 14631.3 14134.0 14255.0 14505.0 14726.9 14892.2 11154.6 11727.3 11919.3 13048.4 13328.5 9383.8 11152.7 11429.6 11455.8 11529.4 8867.9 9472.5 10390.1 11258.1 11393.4 10:16:35 INFO - PROCESS | 2011 | -------- Summary: end -------- 10:16:35 INFO - PROCESS | 2011 | 10:16:35 INFO - TEST-INFO | 2011: exit 0 10:16:35 INFO - TEST-OK | dromaeo_css | took 1113505ms 10:16:35 INFO - TEST-START | kraken 10:16:35 INFO - operating with platform_type : mac_ 10:16:35 INFO - Initialising browser for kraken test... 10:16:35 INFO - TEST-INFO | started process 2017 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmppf0e23/profile http://localhost:49374/getInfo.html) 10:16:38 INFO - PROCESS | 2017 | __metrics Screen width/height:1600/1200 10:16:38 INFO - PROCESS | 2017 | colorDepth:24 10:16:38 INFO - PROCESS | 2017 | Browser inner width/height: 1024/689 10:16:38 INFO - PROCESS | 2017 | __metrics 10:16:38 ERROR - PROCESS | 2017 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 10:16:39 INFO - TEST-INFO | 2017: exit 0 10:16:39 INFO - Browser initialized. 10:16:39 INFO - Running cycle 1/1 for kraken test... 10:16:39 INFO - TEST-INFO | started process 2019 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmppf0e23/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:51 INFO - PROCESS | 2019 | RSS: Main: 254615552 10:16:51 INFO - PROCESS | 2019 | 10:16:54 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-beat-detection) 10:16:54 INFO - PROCESS | 2019 | RSS: Main: 267997184 10:16:54 INFO - PROCESS | 2019 | 10:16:57 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-dft) 10:16:58 INFO - PROCESS | 2019 | RSS: Main: 276062208 10:16:58 INFO - PROCESS | 2019 | 10:17:01 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-fft) 10:17:02 INFO - PROCESS | 2019 | RSS: Main: 279101440 10:17:02 INFO - PROCESS | 2019 | 10:17:04 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-oscillator) 10:17:04 INFO - PROCESS | 2019 | RSS: Main: 281473024 10:17:04 INFO - PROCESS | 2019 | 10:17:06 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49374/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:17:07 INFO - PROCESS | 2019 | RSS: Main: 282103808 10:17:07 INFO - PROCESS | 2019 | 10:17:10 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49374/tests/kraken/driver.html?testName=imaging-darkroom) 10:17:11 INFO - PROCESS | 2019 | RSS: Main: 282181632 10:17:11 INFO - PROCESS | 2019 | 10:17:14 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49374/tests/kraken/driver.html?testName=imaging-desaturate) 10:17:14 INFO - PROCESS | 2019 | RSS: Main: 282382336 10:17:14 INFO - PROCESS | 2019 | 10:17:18 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49374/tests/kraken/driver.html?testName=json-parse-financial) 10:17:18 INFO - PROCESS | 2019 | RSS: Main: 282546176 10:17:18 INFO - PROCESS | 2019 | 10:17:20 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49374/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:17:21 INFO - PROCESS | 2019 | RSS: Main: 282308608 10:17:21 INFO - PROCESS | 2019 | 10:17:22 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:17:23 INFO - PROCESS | 2019 | RSS: Main: 282406912 10:17:23 INFO - PROCESS | 2019 | 10:17:25 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:17:26 INFO - PROCESS | 2019 | RSS: Main: 282750976 10:17:26 INFO - PROCESS | 2019 | 10:17:29 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:17:30 INFO - PROCESS | 2019 | RSS: Main: 283115520 10:17:30 INFO - PROCESS | 2019 | 10:17:32 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:17:33 INFO - PROCESS | 2019 | RSS: Main: 282775552 10:17:33 INFO - PROCESS | 2019 | 10:17:35 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49374/tests/kraken/driver.html?testName=ai-astar) 10:17:35 INFO - PROCESS | 2019 | RSS: Main: 283832320 10:17:35 INFO - PROCESS | 2019 | 10:17:35 INFO - PROCESS | 2019 | __start_tp_report 10:17:35 INFO - PROCESS | 2019 | _x_x_mozilla_page_load 10:17:35 INFO - PROCESS | 2019 | _x_x_mozilla_page_load_details 10:17:35 INFO - PROCESS | 2019 | |i|pagename|runs| 10:17:35 INFO - PROCESS | 2019 | |0;ai-astar;104;117;107;118;117;118;117;117;117;117 10:17:35 INFO - PROCESS | 2019 | |1;audio-beat-detection;173;136;134;158;110;131;129;113;160;110 10:17:35 INFO - PROCESS | 2019 | |2;audio-dft;197;210;231;206;198;198;197;215;204;197 10:17:35 INFO - PROCESS | 2019 | |3;audio-fft;70;82;77;146;52;75;83;86;122;74 10:17:35 INFO - PROCESS | 2019 | |4;audio-oscillator;70;74;126;72;72;93;117;69;82;107 10:17:35 INFO - PROCESS | 2019 | |5;imaging-gaussian-blur;88;85;89;103;79;131;136;119;91;85 10:17:35 INFO - PROCESS | 2019 | |6;imaging-darkroom;152;121;94;96;95;94;102;134;151;153 10:17:35 INFO - PROCESS | 2019 | |7;imaging-desaturate;118;95;144;142;95;144;144;89;146;76 10:17:35 INFO - PROCESS | 2019 | |8;json-parse-financial;55;56;57;57;56;57;57;54;68;50 10:17:35 INFO - PROCESS | 2019 | |9;json-stringify-tinderbox;65;70;70;74;74;74;72;69;69;71 10:17:35 INFO - PROCESS | 2019 | |10;stanford-crypto-aes;85;82;93;92;76;106;81;98;105;103 10:17:35 INFO - PROCESS | 2019 | |11;stanford-crypto-ccm;161;161;155;169;161;157;135;137;152;139 10:17:35 INFO - PROCESS | 2019 | |12;stanford-crypto-pbkdf2;170;173;172;171;170;172;174;173;173;169 10:17:35 INFO - PROCESS | 2019 | |13;stanford-crypto-sha256-iterative;71;68;68;72;101;91;88;93;83;68 10:17:35 INFO - PROCESS | 2019 | __end_tp_report 10:17:35 INFO - PROCESS | 2019 | __start_cc_report 10:17:35 INFO - PROCESS | 2019 | _x_x_mozilla_cycle_collect,1035 10:17:35 INFO - PROCESS | 2019 | __end_cc_report 10:17:35 INFO - PROCESS | 2019 | __startTimestamp1470763055638__endTimestamp 10:17:35 INFO - PROCESS | 2019 | 10:17:35 INFO - PROCESS | 2019 | ------- Summary: start ------- 10:17:35 INFO - PROCESS | 2019 | Number of tests: 14 10:17:35 INFO - PROCESS | 2019 | 10:17:35 INFO - PROCESS | 2019 | [#0] ai-astar Cycles:10 Average:114.90 Median:117.00 stddev:5.02 (4.3%) stddev-sans-first:3.44 10:17:35 INFO - PROCESS | 2019 | Values: 104.0 117.0 107.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 10:17:35 INFO - PROCESS | 2019 | 10:17:35 INFO - PROCESS | 2019 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:135.00 stddev:22.07 (16.3%) stddev-sans-first:18.75 10:17:35 INFO - PROCESS | 2019 | Values: 173.0 136.0 134.0 158.0 110.0 131.0 129.0 113.0 160.0 110.0 10:17:35 INFO - PROCESS | 2019 | 10:17:35 INFO - PROCESS | 2019 | [#2] audio-dft Cycles:10 Average:205.30 Median:205.00 stddev:11.02 (5.4%) stddev-sans-first:11.27 10:17:35 INFO - PROCESS | 2019 | Values: 197.0 210.0 231.0 206.0 198.0 198.0 197.0 215.0 204.0 197.0 10:17:35 INFO - PROCESS | 2019 | 10:17:35 INFO - PROCESS | 2019 | [#3] audio-fft Cycles:10 Average:86.70 Median:76.00 stddev:27.23 (35.8%) stddev-sans-first:28.21 10:17:35 INFO - PROCESS | 2019 | Values: 70.0 82.0 77.0 146.0 52.0 75.0 83.0 86.0 122.0 74.0 10:17:35 INFO - PROCESS | 2019 | 10:17:35 INFO - PROCESS | 2019 | [#4] audio-oscillator Cycles:10 Average:88.20 Median:72.00 stddev:21.34 (29.6%) stddev-sans-first:21.60 10:17:35 INFO - PROCESS | 2019 | Values: 70.0 74.0 126.0 72.0 72.0 93.0 117.0 69.0 82.0 107.0 10:17:35 INFO - PROCESS | 2019 | 10:17:35 INFO - PROCESS | 2019 | [#5] imaging-gaussian-blur Cycles:10 Average:100.60 Median:85.00 stddev:20.71 (24.4%) stddev-sans-first:21.46 10:17:35 INFO - PROCESS | 2019 | Values: 88.0 85.0 89.0 103.0 79.0 131.0 136.0 119.0 91.0 85.0 10:17:35 INFO - PROCESS | 2019 | 10:17:35 INFO - PROCESS | 2019 | [#6] imaging-darkroom Cycles:10 Average:119.20 Median:123.50 stddev:26.12 (21.2%) stddev-sans-first:24.87 10:17:35 INFO - PROCESS | 2019 | Values: 152.0 121.0 94.0 96.0 95.0 94.0 102.0 134.0 151.0 153.0 10:17:35 INFO - PROCESS | 2019 | 10:17:35 INFO - PROCESS | 2019 | [#7] imaging-desaturate Cycles:10 Average:119.30 Median:111.00 stddev:27.96 (25.2%) stddev-sans-first:29.65 10:17:35 INFO - PROCESS | 2019 | Values: 118.0 95.0 144.0 142.0 95.0 144.0 144.0 89.0 146.0 76.0 10:17:35 INFO - PROCESS | 2019 | 10:17:35 INFO - PROCESS | 2019 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:4.52 (7.9%) stddev-sans-first:4.76 10:17:35 INFO - PROCESS | 2019 | Values: 55.0 56.0 57.0 57.0 56.0 57.0 57.0 54.0 68.0 50.0 10:17:35 INFO - PROCESS | 2019 | 10:17:35 INFO - PROCESS | 2019 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:71.50 stddev:2.86 (4.0%) stddev-sans-first:2.13 10:17:35 INFO - PROCESS | 2019 | Values: 65.0 70.0 70.0 74.0 74.0 74.0 72.0 69.0 69.0 71.0 10:17:35 INFO - PROCESS | 2019 | 10:17:35 INFO - PROCESS | 2019 | [#10] stanford-crypto-aes Cycles:10 Average:92.10 Median:83.50 stddev:10.80 (12.9%) stddev-sans-first:11.14 10:17:35 INFO - PROCESS | 2019 | Values: 85.0 82.0 93.0 92.0 76.0 106.0 81.0 98.0 105.0 103.0 10:17:35 INFO - PROCESS | 2019 | 10:17:35 INFO - PROCESS | 2019 | [#11] stanford-crypto-ccm Cycles:10 Average:152.70 Median:159.00 stddev:11.76 (7.4%) stddev-sans-first:12.08 10:17:35 INFO - PROCESS | 2019 | Values: 161.0 161.0 155.0 169.0 161.0 157.0 135.0 137.0 152.0 139.0 10:17:35 INFO - PROCESS | 2019 | 10:17:35 INFO - PROCESS | 2019 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:172.50 stddev:1.64 (0.9%) stddev-sans-first:1.62 10:17:35 INFO - PROCESS | 2019 | Values: 170.0 173.0 172.0 171.0 170.0 172.0 174.0 173.0 173.0 169.0 10:17:35 INFO - PROCESS | 2019 | 10:17:35 INFO - PROCESS | 2019 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.30 Median:77.50 stddev:12.38 (16.0%) stddev-sans-first:12.67 10:17:35 INFO - PROCESS | 2019 | Values: 71.0 68.0 68.0 72.0 101.0 91.0 88.0 93.0 83.0 68.0 10:17:35 INFO - PROCESS | 2019 | -------- Summary: end -------- 10:17:35 INFO - PROCESS | 2019 | 10:17:36 INFO - TEST-INFO | 2019: exit 0 10:17:36 INFO - TEST-OK | kraken | took 60905ms 10:17:36 INFO - SUITE-END | took 1174s 10:17:36 INFO - Completed test suite (00:19:34) 10:17:36 INFO - javascript benchmark 10:17:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7158.770108623938, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3245.918852028699, 3316.1875340541555, 3350.664933506649, 3358.1772465745894, 3376.5272861799353, 5508.504234618884, 5526.58550608705, 5540.0, 5576.86057848554, 5863.237779088723, 5833.649981001143, 5855.941440585593, 5876.147958546008, 5900.380460051697, 5925.5555833312455, 5238.0571497130595, 5310.309659744228, 5322.547583455411, 5359.437259087798, 5377.8117765878205, 4754.453237877637, 4993.776524751423, 5201.0378080055125, 5281.947180528203, 5290.92063619046, 5248.947510524884, 5271.762770675329, 5300.708461034642, 5300.708461034642, 5336.43967383423, 5238.214267859814, 5250.553702935217, 5251.816186433456, 5276.234945932857, 5350.785968561292, 3837.712171587142, 4997.800087996512, 5183.896322073538, 5227.111391063529, 5274.762635681365, 5711.885762284731, 5796.188533605298, 5837.474627283565, 5839.7664093436215, 5853.473187413153, 6165.1368808366415, 6234.283057448406, 6236.095766113934, 6248.9062664060075, 6249.500039996789, 6137.806028951355, 6147.754089836401, 6250.531210159211, 6255.530835187379, 6281.842953926142, 5876.559258055663, 5917.289925208916, 5951.1073338999495, 5991.191189189447, 6044.184035155242, 6272.717727702173, 6272.717727702265, 6294.8111556653375, 6307.96846015767, 6350.7459701611415, 6083.239595050619, 6115.571909966348, 6222.782202622977, 6245.0, 6297.842553936188, 6187.0, 6245.843853903598, 6253.499720022387, 6281.842953926189, 6282.089097080898, 6203.286622038433, 6214.689265536705, 6258.123862659231, 6270.592411493239, 6285.779997700059, 6133.610107582658, 6138.294096178907, 6202.317745048041, 6205.5345849061505, 6239.220097487814, 4325.502567204811, 4982.526659967298, 4987.975060124676, 5007.69953802773, 5016.44819069902, 4226.5139508956245, 4450.688451808407, 4480.820767169277, 4492.573205545534, 4496.955030449719, 5374.731263436891, 5725.997950358671, 5789.334226563915, 5865.88268234633, 5927.940720592739, 5487.725613719298, 6130.917941862977, 6179.3820617937845, 6218.626882387071, 6266.905996409966, 5917.733701983421, 5929.822105336847, 5938.257717785277, 5958.731857066442, 5978.252718410199, 5500.669959802424, 5539.806106786243, 5544.63959842609, 5558.055130627803, 5561.054620714488, 6222.160008398899, 6349.206349206349, 6381.074744162071, 6388.520860935541, 6453.09656648079, 6287.46556542699, 6289.27673317556, 6291.937080629135, 6308.33762454954, 6311.179546658905, 6386.457151142019, 6457.321981191907, 6465.353464653497, 6483.059956306215, 6500.0, 6111.804454079419, 6114.753609057623, 6134.78528251509, 6142.938570614237, 6217.782377616762, 6204.038374052029, 6211.9068213977735, 6223.533235007302, 6230.06549017651, 6255.499560035278, 4703.670743047954, 6112.663803490851, 6128.050152226412, 6133.579501509479, 6174.722137503733, 6128.19758601264, 6219.222597175353, 6237.095621134819, 6238.781642642486, 6241.375862413904, 5684.431556844283, 6004.219451471281, 6021.367756385516, 6061.181740464981, 6074.7360275580095, 6005.7297421617, 6006.729697163725, 6115.6967227387295, 6259.029850373199, 6264.5301602379095, 5503.174523821459, 5768.653880767168, 6052.636841789506, 6102.389761023862, 6119.816405507842], "value": 5719.842271061935, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.15620554543415, 507.8121095194779, 514.1490832671929, 531.7341329335333, 532.7203218310389, 33754.83122584387, 39911.800440997824, 39929.40105898407, 40005.59994400052, 40808.77573672791, 40634.59365406345, 41246.175076498526, 41252.17495650093, 41320.173596528126, 41407.378889316686, 9431.528423578828, 9621.711348659552, 9682.75793105171, 9693.612255509772, 9706.708798736014, 9548.474833884133, 9581.568829402693, 9611.66359177429, 9620.855687164698, 9633.614655413776, 9619.519024048805, 9640.662576809813, 9643.035696430336, 9665.4200747955, 9692.176165025981, 9600.711978640651, 9621.0, 9650.08324209206, 9651.179649729711, 9680.95159524205, 9514.28642851789, 9601.519924003773, 9617.038296170396, 9644.517774111337, 9649.855252171223, 39046.82859514219, 39248.607513924784, 39355.60644393548, 39367.40948885769, 39453.21093578141, 3397.643247459006, 3471.3230919970615, 3841.327767640652, 3878.0, 4119.752814831089, 31237.37525249482, 31733.682663173302, 31959.680403195904, 32050.679493205003, 32613.673863261538, 3227.144806626246, 3246.724028457584, 3271.2966712156763, 3330.017644794767, 3392.8133952632597, 498372.0, 501232.0, 502821.0, 504211.0, 504662.4766876179, 31936.680633193835, 32870.506942395885, 56981.0, 57302.7134864323, 57483.71258143683, 33869.98390048303, 34161.82919085389, 34315.48526772101, 34332.0, 34449.31101378008, 14577.250729912266, 14657.56027319182, 14667.633309167357, 14732.779008314883, 14752.55742327732, 12457.563985260653, 12504.437300321508, 12529.749405012031, 12531.93734031324, 12551.93724031374, 7587.658555365022, 7599.544027358376, 7611.733589324347, 7681.001469808889, 7716.189800070912, 3147.5848704155787, 3201.326892045122, 3202.9199270018435, 3204.0548038328748, 3228.0638614801915, 719.7912605344496, 917.3440989692268, 935.5836652689624, 969.743018100204, 996.9681379771902, 24289.757102429103, 28085.859570702014, 29866.552001719992, 30278.243043924078, 30515.69484305173, 991.610219371326, 1075.6181555547823, 1095.1950316517352, 1101.9008289254007, 1204.9397530123458, 15215.771763423558, 15539.912206145462, 15704.371825127095, 15798.36806527726, 16082.0, 661491.0, 662101.0, 663206.0, 665065.0, 667060.0, 53091.87632494657, 54774.9999999992, 57602.4239757597, 58459.70770146122, 58561.70719146377, 1354.3905242640851, 1361.6187467509114, 1376.511338474847, 1384.0934188106805, 1393.8675825796533, 29622.111336659935, 30264.940727074445, 30283.545746814256, 30446.1318236073, 30556.236094097825, 49854.50145498499, 50073.49926500688, 50098.99802003866, 50137.247941280184, 50149.0, 592040.0, 595395.0, 600369.0, 601067.0, 602691.0, 26178.607320890584, 26212.8689356552, 26472.7352726478, 26597.0, 26757.598636020084, 47106.29340559963, 48047.75976120097, 48526.0, 49083.01833963229, 49123.0, 39433.60566394414, 39652.20695586014, 39792.801035994635, 39934.0, 40890.79554602208, 32752.0, 33602.0, 35672.64327356693, 38435.23129537338, 39149.60850391573, 38352.42471362987, 38784.0, 39366.80316598398, 39582.81251562458, 41154.58845411507, 27570.724292756815, 32250.032499025066, 34394.82802585971, 35430.29139417249, 35716.0, 25927.83324750353, 25953.610695839954, 26267.0, 26274.60588091142, 26418.73581264163], "value": 18598.451959738704, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.9574051113865, 382.5753413710781, 387.1656580069949, 393.4059570049228, 403.2117210852783, 19550.608987820237, 20317.59364812703, 20811.0, 21337.466563335925, 21487.140514379425, 11847.111466640015, 12014.0, 15257.923710381461, 19049.333273335436, 20423.897880510613, 5168.560672342846, 5344.545713614348, 5389.838304850841, 5390.353157621091, 5404.6486978346475, 5808.709564521757, 5884.588078834483, 5900.557458190631, 5970.2835659720895, 5973.581849270531, 4590.0, 5947.137665038566, 5951.88096238075, 5966.403359664042, 5976.252968378953, 4988.02733466974, 5694.402087780785, 5741.626794258402, 5860.296764388258, 5870.853228669296, 4632.2125238709505, 5598.356189038272, 5625.6905870177125, 5691.402402747734, 5692.0608099663505, 11201.495932683049, 13438.86561134386, 13477.460901563925, 13579.845713114397, 25256.621150682753, 2190.211523851412, 2190.9671354929687, 2208.768079351661, 2282.7374851892077, 2397.2568503763887, 9674.613015479443, 10166.4916754162, 10208.387496750218, 10277.023682750127, 10461.79076418475, 1825.0600940515644, 1843.64970655575, 1938.060040880172, 1948.4349538633778, 1973.447434718281, 98411.50794246055, 106770.0, 109064.0, 131210.03184952235, 132961.0, 9911.900880991241, 10906.90930906903, 11412.0, 11430.14273929442, 11644.2431241969, 14499.347529361205, 14519.419223231163, 14528.564143075724, 14597.92701036488, 14611.342489587994, 8364.289035431935, 8504.0, 8529.0, 8530.573471326408, 8695.695650652324, 8492.31196693587, 8506.404551681322, 8537.317014638815, 8677.52273624944, 8738.475691458532, 3929.958560981342, 4352.825886964486, 4534.478534968521, 4552.2488789350045, 4577.5880170784785, 1941.4272789527124, 1997.1711739628183, 1997.8201961823506, 2016.374923773635, 2021.5956808638332, 741.5143081281769, 848.5757121439281, 865.9781457879636, 962.9229661627053, 1000.9940010289612, 15655.530334089995, 20199.39401817948, 21160.682589761167, 21229.363119106452, 21559.46101347479, 902.2105657549644, 953.3945944325403, 974.1086905481405, 991.9950400247952, 998.8501724741346, 6616.966915165393, 9157.862632060524, 11125.388103654377, 11201.663950081347, 11214.271072380268, 573507.0, 581284.0, 583726.0, 594089.0, 595384.0, 74150.51698966099, 74274.62862685652, 110879.44560277148, 126783.0, 130759.0, 1017.5014243020867, 1019.1133713669155, 1022.3610243597751, 1023.0843395161289, 1078.320657985464, 18527.907360463112, 18736.15687294048, 18929.48564114895, 18964.905175474036, 19077.61844763125, 38029.61970380371, 45403.545964541256, 56529.71735141298, 58164.0, 58828.70585647044, 79328.60335698516, 85022.14977850142, 85610.0, 85832.0, 86954.0, 6908.723651054102, 7243.927560724536, 7350.191478937206, 7448.70205191808, 7472.439567032603, 9945.453000085065, 11801.17391782567, 12203.267803931793, 12842.678933026375, 13314.40085196149, 11078.889211107786, 11124.332540047622, 11397.715057123638, 11416.0021996152, 11465.713357166138, 9703.466309353053, 11211.159163062966, 11357.0914326852, 11438.885611143782, 11515.251508652245, 10808.622103137297, 11367.488463019019, 11532.827007594726, 11686.824697629712, 11725.706857328634, 7214.098237720285, 7387.852242955003, 7468.2158373372185, 7544.358729507834, 7569.091708994956, 10491.265611407129, 10602.0, 10780.460976951277, 11134.832977505506, 11336.94331528337], "value": 9191.491233206581, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1474.4765608209088, 1525.3059857764717, 1710.9486715398543, 1857.5541869951207, 1875.596746699461, 7074.64626768662, 7850.8037299067555, 8301.086880443154, 8408.789780255496, 8823.338249631272, 8533.871991920127, 8610.483370997745, 8671.089535598767, 8684.91315086849, 8698.826023479527, 1963.9509012274737, 2278.7835155660227, 2327.592671282527, 2331.2423462374713, 2336.123953517431, 2255.2670382125793, 2289.164454973939, 2292.3123063081093, 2299.7700229976954, 2312.1329501436962, 2315.9768402316013, 2317.8261630377788, 2334.089705015037, 2335.1593426366494, 2335.532893421314, 2291.209532711212, 2302.5049614332997, 2306.7577904320055, 2317.8725170115636, 2319.1651005637955, 2271.3867255840833, 2274.7725227477285, 2277.4761804784825, 2282.988585057081, 2285.2801367569164, 7854.253845884632, 8304.377171712145, 8585.785355366166, 8747.737567872973, 8795.34034947375, 4614.630829533629, 5125.897482050375, 5203.063448579254, 5281.973590132063, 5317.175837745117, 3443.9827800860835, 3509.4209455439823, 3582.0507565495163, 3597.9100522486888, 3623.873164439232, 1075.8224892892663, 1082.5345101606306, 1085.0505807418508, 1102.2725001499052, 1103.2608152537819, 11238.775224495546, 11351.716207094805, 11375.829362559569, 11462.369569673665, 11510.42447877611, 4498.415206023262, 4523.547645235516, 4714.316424118552, 4725.503822098699, 4726.952730472652, 9672.032796720272, 9744.0, 9754.0, 9770.974047725029, 9776.853347199798, 5196.948030519722, 5215.608829337815, 5251.317328747315, 5284.497972692588, 5293.311869457023, 4384.386185933972, 4707.199776038082, 4815.759212039454, 4858.95141048585, 4869.123557759637, 3831.7892515911894, 3863.61363863617, 3934.822932967966, 3945.763254204757, 3988.5213774346685, 1267.4359909840032, 1275.647813317886, 1276.3426835179705, 1281.557862537423, 1281.8654041325713, 891.572045418203, 910.981780364389, 912.2792993535165, 957.3920560444168, 959.8704174936295, 5711.942880571224, 5857.121431785266, 5880.764769409261, 5920.164748927846, 5922.526197904157, 410.96301332879585, 432.38169417732314, 436.6528609755189, 436.8078045659963, 437.6958014180114, 3985.362342025262, 4014.8394064237687, 4029.119179786408, 4053.1893621275863, 4060.127072679388, 9970.052844979715, 10345.0, 10541.209409294333, 10677.77205621348, 10684.252102352915, 10237.23220758446, 10406.947965260277, 10595.417252051211, 10614.522346494427, 10616.946915265375, 7880.0, 7945.205479452008, 7959.283664470341, 8029.0, 8191.426600138052, 5853.473187413153, 5853.9462896677305, 5981.252343457068, 6018.428249316308, 6059.727312271047, 9802.705918822161, 9842.0, 9949.204063675033, 9987.450690212108, 10128.240381971234, 9677.564509597225, 9978.850317245393, 10042.598296068076, 10057.497125143567, 10232.897671023493, 6891.483138764713, 7300.926990730237, 7447.441441891771, 7510.39916806665, 7627.5042122261875, 8313.043999940084, 8388.993320801543, 8395.83208335842, 8397.160283971554, 8428.241458268785, 7347.33873951347, 7483.962580187064, 7542.170361260147, 7593.8860917085185, 7617.5048621839405, 7175.641217938978, 7238.348548630648, 7290.380317672845, 7380.261973802577, 7395.408367330709, 6524.67376631176, 6533.836654083686, 6943.930560694328, 6958.860822783415, 7044.401225895856, 4153.252414565407, 4480.551944805624, 4794.448638406628, 4910.803567857246, 4995.425526064549, 4881.9023619528125, 4954.900901982012, 4976.925346119739, 5001.274815151855, 5010.849674509771], "value": 4443.149675979786, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.27935184307756, 297.82952994730704, 300.9037108125398, 312.37524950099794, 318.6717680788788, 5032.5470707636305, 5444.183372494128, 5628.465295796897, 5636.210930469732, 5672.347680016799, 5069.518395752407, 5195.934398704763, 5424.670955615869, 5494.532964698005, 5565.053940830058, 4304.956950430503, 4305.3091817613995, 4305.569443055685, 4306.117245964578, 4316.870493885189, 4149.792510374485, 4259.87220383389, 4276.957230427687, 4296.720713153651, 4333.57319900855, 4197.559256278093, 4212.304969680014, 4213.462086338495, 4216.427978932848, 4232.8306867725405, 4236.512801027875, 4242.5999420191265, 4257.723247988871, 4264.424302719124, 4269.402283680256, 3048.801827881203, 3455.87904423344, 3617.385044542434, 3664.78011319319, 3683.8710645127294, 4616.906672529413, 4637.304404339342, 5326.973365133188, 5344.438833922421, 5382.0129827945475, 4137.834486620532, 4711.646626502992, 4732.290156476522, 4732.290156476522, 4744.93239021221, 4513.796879140446, 5808.477237048686, 5828.591998560102, 5896.498797602209, 5910.202122713422, 3279.6392396836327, 3856.980715096435, 3893.357595996657, 3925.8407875668554, 3932.7836968966694, 4972.453030166715, 5130.897382052375, 5132.923006154911, 5784.13238014297, 6057.3639767824625, 3537.911552211215, 3972.503437070366, 3981.462502562117, 4007.979960100181, 4046.3121269384274, 3290.391277613649, 3291.818949957775, 3495.178633021238, 3634.636536346344, 4060.939085913714, 3969.253528447474, 4632.258838585877, 4661.370714953506, 4665.626749860003, 4681.531846815359, 5006.774695138727, 5463.972680136574, 5851.531877449794, 5873.236479257669, 5891.584450375325, 1205.246366536687, 1292.4571679894466, 1329.6875234319928, 1367.8373382624688, 1367.9603501338854, 884.8716936044237, 893.4773157702687, 911.4303560274828, 911.5077857956629, 921.8064206516707, 4174.436451079066, 5076.822311219164, 5350.384705758887, 5350.8127215547265, 5448.91826622601, 5296.788128474895, 5967.8209653710455, 5992.43071908168, 5996.880062398727, 6021.578489505692, 5006.274090256892, 5193.5585475234275, 5325.8934821303355, 5424.538914192338, 5427.592930530147, 2481.9203646413866, 2630.3161178093833, 2665.0012490632025, 2690.8116431849585, 2698.7571118599026, 4862.197737373293, 4907.263910413395, 5230.3262955854525, 5247.711375874287, 5271.472852714698, 4099.938500922489, 4647.117047760915, 4877.6585639004925, 5041.823536176216, 5169.198774190007, 4462.795045337741, 4731.9589690268085, 4902.877428064256, 5092.134337162617, 5200.049981257029, 4376.934345984749, 4429.402030725811, 5072.442031376472, 5085.415177254515, 5137.51193636604, 4263.360495925636, 4299.505556860876, 4577.656675749266, 4848.878778030577, 4905.607551395951, 4283.914321713611, 4663.556962088596, 4990.500949905126, 5209.4009188943755, 5297.231901374202, 3435.0210190095704, 3469.8612055518506, 3484.2160513884173, 3488.8604455821483, 3547.5565554305713, 4728.243481043017, 4791.664583479123, 4816.639846475272, 5143.379835351852, 5490.917636235539, 4723.598494128038, 5409.513143817076, 5440.6605159781675, 5966.671833049224, 5974.970125149521, 5403.702796346239, 5902.321233058254, 5938.990371636745, 5955.749292648592, 5995.370486099071, 5389.973050134724, 5760.164776107525, 5801.8549536261935, 5807.109236811262, 5832.912506312494, 4918.950810491992, 5942.465178133989, 5978.521718262442, 5982.653902871819, 5987.6108052976415, 5519.613627046228, 5680.245081135563, 5793.971030144822, 5838.883222335615, 5877.089945767557], "value": 4034.3896819805796, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.6000509737486, 776.8368642585059, 777.3625626985867, 778.4084096086968, 795.8010497375657, 14149.929250353747, 15673.373065077412, 16073.437429689933, 16151.919240403782, 16226.91886540567, 11763.529458821637, 12251.754964900696, 13547.593572192825, 14522.927385363086, 14587.708245835078, 845.2561745663838, 860.1699360117485, 882.4264228251656, 896.7713233125577, 902.5036230073466, 870.0733718589681, 876.4653561327585, 882.1222883231194, 884.5798245833242, 885.6944354197824, 802.2218448105328, 925.6066171876959, 931.2456909902967, 932.4451951089125, 934.9902105725834, 897.2373482539854, 915.8351496730586, 921.8018126102886, 922.4880191493718, 924.9594206517668, 612.8478460494287, 645.3256347117274, 672.6905623413236, 688.277308825731, 695.8817001109824, 15136.167510786903, 15437.768433473508, 15642.843571564366, 15644.296006679613, 15650.45223417175, 14104.435822567188, 14140.646483837883, 14360.281985900767, 14371.06588071772, 14477.71044579113, 11883.989860861837, 11988.400579971054, 11995.64013079609, 12081.93959030208, 12316.5073397064, 3809.4285857121376, 3833.386658134713, 3844.807759612036, 3852.5184351956004, 3988.660963818079, 124242.37878810639, 124938.0, 128080.0, 128563.0, 129927.3926077917, 10954.561817527368, 11051.392173430539, 11052.0, 11146.609868654721, 11538.596149134908, 22370.888145559493, 22567.88716056442, 22611.43471413228, 22668.773312266996, 22669.88665056664, 7782.49413788102, 7936.484128531627, 7946.165652606509, 8110.107888132301, 8181.877271840927, 4528.162289976365, 4566.977165114153, 4590.908181836345, 4610.170169369546, 4766.4995175506765, 3458.6541345865717, 3577.874774382884, 3594.406922857699, 3596.946045809315, 3621.94567081494, 654.4012228810585, 663.4393937123124, 670.0953712488102, 671.3454381977533, 672.237010992527, 473.85784264720445, 497.6541303793829, 577.763117121978, 604.7067172421372, 605.2102006881063, 8179.263866252066, 8223.712170074019, 8469.40714150016, 8711.869321960176, 8904.643814247358, 536.7021303176774, 549.9065158922992, 592.2537602620642, 600.1028462448667, 602.6594973839855, 3372.3929692655556, 3934.6458818706456, 4199.97900010498, 4272.4445822042935, 4373.737575745466, 91741.0, 94765.0, 95044.0, 126588.36705816597, 166384.0, 113638.43180784043, 124645.37677311555, 124769.0, 125202.24393268216, 132015.0, 84200.94794312361, 112488.43755781169, 116052.0, 116103.19484025765, 116877.0, 8074.0, 8122.83754324922, 9941.552630131517, 9989.900100998897, 10110.69667909964, 43193.7840310809, 59158.704206478695, 61900.69049654723, 62403.375966241576, 64841.35158648542, 58659.0, 62405.0, 74692.62653686914, 86765.0, 91397.0, 11280.210385272952, 11343.943280283545, 13235.867641323464, 13606.523771667944, 13821.861781382058, 13298.534551290659, 14393.920455965635, 15224.543263702106, 15384.0, 15901.045937243802, 13925.0, 14074.507392241223, 14225.359858806172, 14227.217503037433, 14631.26843657834, 14134.0, 14255.0, 14505.0, 14726.926365368105, 14892.180930048951, 11154.609588664358, 11727.296362218294, 11919.3444360561, 13048.41282142287, 13328.533501327407, 9383.765405864908, 11152.721181970515, 11429.59996400122, 11455.828162577402, 11529.423528823358, 8867.91132088671, 9472.47901365404, 10390.116840068678, 11258.059679112244, 11393.373364465035], "value": 7678.394256140609, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1593.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 117.0, 107.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 136.0, 134.0, 158.0, 110.0, 131.0, 129.0, 113.0, 160.0, 110.0], "value": 135.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 210.0, 231.0, 206.0, 198.0, 198.0, 197.0, 215.0, 204.0, 197.0], "value": 205.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 82.0, 77.0, 146.0, 52.0, 75.0, 83.0, 86.0, 122.0, 74.0], "value": 86.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 126.0, 72.0, 72.0, 93.0, 117.0, 69.0, 82.0, 107.0], "value": 88.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 89.0, 103.0, 79.0, 131.0, 136.0, 119.0, 91.0, 85.0], "value": 100.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 121.0, 94.0, 96.0, 95.0, 94.0, 102.0, 134.0, 151.0, 153.0], "value": 119.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 95.0, 144.0, 142.0, 95.0, 144.0, 144.0, 89.0, 146.0, 76.0], "value": 119.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 57.0, 57.0, 56.0, 57.0, 57.0, 54.0, 68.0, 50.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 70.0, 74.0, 74.0, 74.0, 72.0, 69.0, 69.0, 71.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 93.0, 92.0, 76.0, 106.0, 81.0, 98.0, 105.0, 103.0], "value": 92.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 155.0, 169.0, 161.0, 157.0, 135.0, 137.0, 152.0, 139.0], "value": 152.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 173.0, 172.0, 171.0, 170.0, 172.0, 174.0, 173.0, 173.0, 169.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 68.0, 72.0, 101.0, 91.0, 88.0, 93.0, 83.0, 68.0], "value": 80.3, "unit": "score"}]}]} 10:17:36 INFO - Return code: 0 10:17:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:17:36 ERROR - # TBPL SUCCESS # 10:17:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:17:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:17:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:17:36 INFO - 2016-08-09 10:17:36.967 screenresolution[2024:279965] starting screenresolution argv=screenresolution get 10:17:36 INFO - 2016-08-09 10:17:36.970 screenresolution[2024:279965] Display 0: 1600x1200x32@60 10:17:36 INFO - 2016-08-09 10:17:36.976 screenresolution[2025:279968] starting screenresolution argv=screenresolution list 10:17:36 INFO - Available Modes on Display 0 10:17:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:17:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:17:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:17:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:17:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:17:37 INFO - Intel Iris: 10:17:37 INFO - Chipset Model: Intel Iris 10:17:37 INFO - Type: GPU 10:17:37 INFO - Bus: Built-In 10:17:37 INFO - VRAM (Dynamic, Max): 1536 MB 10:17:37 INFO - Vendor: Intel (0x8086) 10:17:37 INFO - Device ID: 0x0a2e 10:17:37 INFO - Revision ID: 0x0009 10:17:37 INFO - Displays: 10:17:37 INFO - Display: 10:17:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:17:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:17:37 INFO - Display Serial Number: 1600x1200 60 10:17:37 INFO - Main Display: Yes 10:17:37 INFO - Mirror: Off 10:17:37 INFO - Online: Yes 10:17:37 INFO - Rotation: Supported 10:17:37 INFO - Return code: 0 10:17:37 INFO - Running post-action listener: _resource_record_post_action 10:17:37 INFO - [mozharness: 2016-08-09 17:17:37.216716Z] Finished run-tests step (success) 10:17:37 INFO - Running post-run listener: _resource_record_post_run 10:17:37 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 8011264; Write bytes: 706708480; Read time: 77; Write time: 2025 10:17:37 INFO - TinderboxPrint: CPU usage
54.6% 10:17:37 INFO - TinderboxPrint: I/O read bytes / time
8,011,264 / 77 10:17:37 INFO - TinderboxPrint: I/O write bytes / time
706,708,480 / 2,025 10:17:37 INFO - TinderboxPrint: CPU idle
2,197.0 (45.4%) 10:17:37 INFO - TinderboxPrint: CPU system
983.9 (20.3%) 10:17:37 INFO - TinderboxPrint: CPU user
1,656.8 (34.2%) 10:17:37 INFO - TinderboxPrint: Swap in / out
420,638,720 / 0 10:17:37 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404087296; Write bytes: 406881792; Read time: 29759; Write time: 828 10:17:37 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 7896576; Write bytes: 298319360; Read time: 75; Write time: 1191 10:17:37 INFO - Running post-run listener: _upload_blobber_files 10:17:37 INFO - Blob upload gear active. 10:17:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:17:37 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 10:17:37 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'] 10:17:37 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 10:17:38 INFO - (blobuploader) - INFO - Open directory for files ... 10:17:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:17:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:17:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:38 INFO - (blobuploader) - INFO - Done attempting. 10:17:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:17:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:17:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:39 INFO - (blobuploader) - INFO - Done attempting. 10:17:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:17:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:17:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:42 INFO - (blobuploader) - INFO - Done attempting. 10:17:42 INFO - (blobuploader) - INFO - Iteration through files over. 10:17:42 INFO - Return code: 0 10:17:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:17:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:17:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3dbfaf722ccd931addccf210ff993b8dbda2a95680ac473fe7e68fd9e474107d6529f952a493369aa798bd1807a95777b95606058424ab7462bb0cf3fb443987", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b95c0e8887c2192b24abe2def94d206a2a919e0a04fcded2b4a1167c0c8edc703cf79782840e44ba2dbfe51b1c0cde456f8dea4d04e4179f7338ef9c2c2983ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e69a01182b4e84b4e132df6e90c729b5f77f2d6e1d6439cad9a6008da04d6357454b2e4179064cafe3024b15ef978997fa64cafd98e880e10f74a666bd66d54"} 10:17:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:17:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:17:42 INFO - Contents: 10:17:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3dbfaf722ccd931addccf210ff993b8dbda2a95680ac473fe7e68fd9e474107d6529f952a493369aa798bd1807a95777b95606058424ab7462bb0cf3fb443987", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b95c0e8887c2192b24abe2def94d206a2a919e0a04fcded2b4a1167c0c8edc703cf79782840e44ba2dbfe51b1c0cde456f8dea4d04e4179f7338ef9c2c2983ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e69a01182b4e84b4e132df6e90c729b5f77f2d6e1d6439cad9a6008da04d6357454b2e4179064cafe3024b15ef978997fa64cafd98e880e10f74a666bd66d54"} 10:17:42 INFO - Running post-run listener: copy_logs_to_upload_dir 10:17:42 INFO - Copying logs to upload dir... 10:17:42 INFO - mkdir: /builds/slave/test/build/upload/logs 10:17:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.981917 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-08-09 10:17:42.496311) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 10:17:42.499993) ========= 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.4ayrFe1NVH/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.GgyZeOuu6a/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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/3dbfaf722ccd931addccf210ff993b8dbda2a95680ac473fe7e68fd9e474107d6529f952a493369aa798bd1807a95777b95606058424ab7462bb0cf3fb443987", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b95c0e8887c2192b24abe2def94d206a2a919e0a04fcded2b4a1167c0c8edc703cf79782840e44ba2dbfe51b1c0cde456f8dea4d04e4179f7338ef9c2c2983ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e69a01182b4e84b4e132df6e90c729b5f77f2d6e1d6439cad9a6008da04d6357454b2e4179064cafe3024b15ef978997fa64cafd98e880e10f74a666bd66d54"} build_url:https://queue.taskcluster.net/v1/task/edunnUfhT6qYUYbtSQuLzg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011355 build_url: 'https://queue.taskcluster.net/v1/task/edunnUfhT6qYUYbtSQuLzg/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/3dbfaf722ccd931addccf210ff993b8dbda2a95680ac473fe7e68fd9e474107d6529f952a493369aa798bd1807a95777b95606058424ab7462bb0cf3fb443987", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b95c0e8887c2192b24abe2def94d206a2a919e0a04fcded2b4a1167c0c8edc703cf79782840e44ba2dbfe51b1c0cde456f8dea4d04e4179f7338ef9c2c2983ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e69a01182b4e84b4e132df6e90c729b5f77f2d6e1d6439cad9a6008da04d6357454b2e4179064cafe3024b15ef978997fa64cafd98e880e10f74a666bd66d54"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 10:17:42.533951) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 10:17:42.534317) ========= 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.4ayrFe1NVH/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.GgyZeOuu6a/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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.005062 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 10:17:42.583906) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 10:17:42.584222) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 10:17:42.584592) ========= ========= Total master_lag: 0.18 =========