builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0186 starttime: 1471034534.69 results: success (0) buildid: 20160812113215 builduid: 42b01d329e6a4893ad04aee9e8c213ae revision: ef0801fdc7abe018a8b026c00e8bdebcc690001c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 13:42:14.685766) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 13:42:14.686249) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 13:42:14.687297) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 13:42:14.836264) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 13:42:14.836668) ========= 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.84SBteCqMa/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.4QUhpt1JJ2/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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-12 13:42:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-08-12 13:42:15 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.485985 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 13:42:15.350584) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 13:42:15.350924) ========= 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.84SBteCqMa/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.4QUhpt1JJ2/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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.029931 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 13:42:15.418104) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-12 13:42:15.418559) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ef0801fdc7abe018a8b026c00e8bdebcc690001c --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 ef0801fdc7abe018a8b026c00e8bdebcc690001c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.84SBteCqMa/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.4QUhpt1JJ2/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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-12 13:42:15,496 truncating revision to first 12 chars 2016-08-12 13:42:15,496 Setting DEBUG logging. 2016-08-12 13:42:15,496 attempt 1/10 2016-08-12 13:42:15,496 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ef0801fdc7ab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-12 13:42:16,240 unpacking tar archive at: fx-team-ef0801fdc7ab/testing/mozharness/ program finished with exit code 0 elapsedTime=1.020722 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-12 13:42:16.468761) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 13:42:16.469077) ========= script_repo_revision: ef0801fdc7abe018a8b026c00e8bdebcc690001c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 13:42:16.469572) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 13:42:16.469887) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 13:42:16.514755) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-12 13:42:16.515114) ========= /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.84SBteCqMa/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.4QUhpt1JJ2/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 13:42:16 INFO - MultiFileLogger online at 20160812 13:42:16 in /builds/slave/test 13:42:16 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 13:42:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:42:16 INFO - {'append_to_log': False, 13:42:16 INFO - 'base_work_dir': '/builds/slave/test', 13:42:16 INFO - 'blob_upload_branch': 'Fx-Team', 13:42:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:42:16 INFO - 'branch': 'Fx-Team', 13:42:16 INFO - 'buildbot_json_path': 'buildprops.json', 13:42:16 INFO - 'config_files': ('talos/mac_config.py',), 13:42:16 INFO - 'default_actions': ('clobber', 13:42:16 INFO - 'read-buildbot-config', 13:42:16 INFO - 'download-and-extract', 13:42:16 INFO - 'populate-webroot', 13:42:16 INFO - 'create-virtualenv', 13:42:16 INFO - 'install', 13:42:16 INFO - 'run-tests'), 13:42:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:42:16 INFO - 'download_minidump_stackwalk': True, 13:42:16 INFO - 'download_symbols': 'ondemand', 13:42:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:42:16 INFO - 'tooltool.py': '/tools/tooltool.py', 13:42:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:42:16 INFO - '/tools/misc-python/virtualenv.py')}, 13:42:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:42:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:42:16 INFO - 'installer_path': 'installer.exe', 13:42:16 INFO - 'log_level': 'info', 13:42:16 INFO - 'log_name': 'talos', 13:42:16 INFO - 'log_to_console': True, 13:42:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:42:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:42:16 INFO - 'opt_config_files': (), 13:42:16 INFO - 'pip_index': False, 13:42:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:42:16 INFO - 'cmd': ('bash', 13:42:16 INFO - '-c', 13:42:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:42:16 INFO - 'enabled': True, 13:42:16 INFO - 'halt_on_failure': False, 13:42:16 INFO - 'name': 'check_screen_resolution'},), 13:42:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:42:16 INFO - 'cmd': ('bash', 13:42:16 INFO - '-c', 13:42:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:42:16 INFO - 'enabled': True, 13:42:16 INFO - 'halt_on_failure': False, 13:42:16 INFO - 'name': 'check_screen_resolution'},), 13:42:16 INFO - 'run_cmd_checks_enabled': True, 13:42:16 INFO - 'sps_profile': False, 13:42:16 INFO - 'sps_profile_interval': 0, 13:42:16 INFO - 'suite': 'dromaeojs-e10s', 13:42:16 INFO - 'system_bits': '32', 13:42:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:42:16 INFO - 'title': 't-yosemite-r7-0186', 13:42:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:42:16 INFO - 'use_talos_json': True, 13:42:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:42:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:42:16 INFO - 'work_dir': 'build'} 13:42:16 INFO - [mozharness: 2016-08-12 20:42:16.716556Z] Running clobber step. 13:42:16 INFO - Running pre-action listener: _resource_record_pre_action 13:42:16 INFO - Running main action method: clobber 13:42:16 INFO - rmtree: /builds/slave/test/build 13:42:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:42:18 INFO - Running post-action listener: _resource_record_post_action 13:42:18 INFO - [mozharness: 2016-08-12 20:42:18.878555Z] Finished clobber step (success) 13:42:18 INFO - [mozharness: 2016-08-12 20:42:18.878679Z] Running read-buildbot-config step. 13:42:18 INFO - Running pre-action listener: _resource_record_pre_action 13:42:18 INFO - Running main action method: read_buildbot_config 13:42:18 INFO - Using buildbot properties: 13:42:18 INFO - { 13:42:18 INFO - "project": "", 13:42:18 INFO - "product": "firefox", 13:42:18 INFO - "script_repo_revision": "production", 13:42:18 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 13:42:18 INFO - "repository": "", 13:42:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 13:42:18 INFO - "buildid": "20160812113215", 13:42:18 INFO - "pgo_build": "False", 13:42:18 INFO - "basedir": "/builds/slave/test", 13:42:18 INFO - "buildnumber": 80, 13:42:18 INFO - "slavename": "t-yosemite-r7-0186", 13:42:18 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 13:42:18 INFO - "platform": "yosemite_r7", 13:42:18 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 13:42:18 INFO - "branch": "fx-team", 13:42:18 INFO - "repo_path": "integration/fx-team", 13:42:18 INFO - "revision": "ef0801fdc7abe018a8b026c00e8bdebcc690001c", 13:42:18 INFO - "stage_platform": "macosx64", 13:42:18 INFO - "builduid": "42b01d329e6a4893ad04aee9e8c213ae", 13:42:18 INFO - "slavebuilddir": "test" 13:42:18 INFO - } 13:42:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q4ORzEAdRiSfbu8d2WjiLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 13:42:18 INFO - Running post-action listener: _resource_record_post_action 13:42:18 INFO - [mozharness: 2016-08-12 20:42:18.882044Z] Finished read-buildbot-config step (success) 13:42:18 INFO - [mozharness: 2016-08-12 20:42:18.882153Z] Running download-and-extract step. 13:42:18 INFO - Running pre-action listener: _resource_record_pre_action 13:42:18 INFO - Running main action method: download_and_extract 13:42:18 INFO - mkdir: /builds/slave/test/build/tests 13:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:18 INFO - trying https://queue.taskcluster.net/v1/task/Q4ORzEAdRiSfbu8d2WjiLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 13:42:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Q4ORzEAdRiSfbu8d2WjiLQ/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 13:42:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q4ORzEAdRiSfbu8d2WjiLQ/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 13:42:19 INFO - Downloaded 1199 bytes. 13:42:19 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 13:42:19 INFO - Using the following test package requirements: 13:42:19 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 13:42:19 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:42:19 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 13:42:19 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:42:19 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 13:42:19 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:42:19 INFO - u'jsshell-mac.zip'], 13:42:19 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:42:19 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 13:42:19 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 13:42:19 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:42:19 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 13:42:19 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:42:19 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 13:42:19 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:42:19 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 13:42:19 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:42:19 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 13:42:19 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:19 INFO - trying https://queue.taskcluster.net/v1/task/Q4ORzEAdRiSfbu8d2WjiLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:42:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Q4ORzEAdRiSfbu8d2WjiLQ/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 13:42:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q4ORzEAdRiSfbu8d2WjiLQ/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 13:42:20 INFO - Downloaded 16328284 bytes. 13:42:20 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'] 13:42:20 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 13:42:23 INFO - Return code: 0 13:42:23 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:23 INFO - trying https://queue.taskcluster.net/v1/task/Q4ORzEAdRiSfbu8d2WjiLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:42:23 INFO - Downloading https://queue.taskcluster.net/v1/task/Q4ORzEAdRiSfbu8d2WjiLQ/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 13:42:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q4ORzEAdRiSfbu8d2WjiLQ/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 13:42:25 INFO - Downloaded 16328284 bytes. 13:42:25 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'] 13:42:25 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 13:42:29 INFO - Return code: 0 13:42:29 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')]} 13:42:29 INFO - trying https://queue.taskcluster.net/v1/task/Q4ORzEAdRiSfbu8d2WjiLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 13:42:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Q4ORzEAdRiSfbu8d2WjiLQ/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 13:42:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q4ORzEAdRiSfbu8d2WjiLQ/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 13:42:31 INFO - Downloaded 14413719 bytes. 13:42:31 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'] 13:42:31 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 13:42:31 INFO - Return code: 0 13:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:31 INFO - trying https://queue.taskcluster.net/v1/task/Q4ORzEAdRiSfbu8d2WjiLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:42:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Q4ORzEAdRiSfbu8d2WjiLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 13:42:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q4ORzEAdRiSfbu8d2WjiLQ/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 13:42:35 INFO - Downloaded 110898549 bytes. 13:42:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q4ORzEAdRiSfbu8d2WjiLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:42:35 INFO - mkdir: /builds/slave/test/properties 13:42:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:42:35 INFO - Writing to file /builds/slave/test/properties/build_url 13:42:35 INFO - Contents: 13:42:35 INFO - build_url:https://queue.taskcluster.net/v1/task/Q4ORzEAdRiSfbu8d2WjiLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:42:36 INFO - Running post-action listener: _resource_record_post_action 13:42:36 INFO - Running post-action listener: set_extra_try_arguments 13:42:36 INFO - [mozharness: 2016-08-12 20:42:36.280266Z] Finished download-and-extract step (success) 13:42:36 INFO - [mozharness: 2016-08-12 20:42:36.280417Z] Running populate-webroot step. 13:42:36 INFO - Running pre-action listener: _resource_record_pre_action 13:42:36 INFO - Running main action method: populate_webroot 13:42:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:42:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:42:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:42:36 INFO - '--tppagecycles', 13:42:36 INFO - '7'], 13:42:36 INFO - 'tests': ['tsvgm']}}, 13:42:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:42:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:42:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:42:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:42:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:42:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:42:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:36 INFO - 'talos_options': ['--disable-e10s'], 13:42:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:42:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:42:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:36 INFO - 'talos_options': ['--disable-e10s'], 13:42:36 INFO - 'tests': ['damp', 'tps']}, 13:42:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:36 INFO - 'tests': ['damp', 'tps']}, 13:42:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:42:36 INFO - 'tests': ['dromaeo_dom']}, 13:42:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:42:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:42:36 INFO - 'tests': ['basic_compositor_video']}, 13:42:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:42:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:42:36 INFO - 'tests': ['a11yr', 13:42:36 INFO - 'ts_paint', 13:42:36 INFO - 'tpaint', 13:42:36 INFO - 'sessionrestore', 13:42:36 INFO - 'sessionrestore_no_auto_restore', 13:42:36 INFO - 'tabpaint']}, 13:42:36 INFO - 'other-e10s': {'tests': ['a11yr', 13:42:36 INFO - 'ts_paint', 13:42:36 INFO - 'tpaint', 13:42:36 INFO - 'sessionrestore', 13:42:36 INFO - 'sessionrestore_no_auto_restore', 13:42:36 INFO - 'tabpaint']}, 13:42:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:42:36 INFO - 'ts_paint', 13:42:36 INFO - 'tpaint', 13:42:36 INFO - 'sessionrestore', 13:42:36 INFO - 'sessionrestore_no_auto_restore', 13:42:36 INFO - 'tabpaint']}, 13:42:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:42:36 INFO - 'ts_paint', 13:42:36 INFO - 'tpaint', 13:42:36 INFO - 'sessionrestore', 13:42:36 INFO - 'sessionrestore_no_auto_restore', 13:42:36 INFO - 'tabpaint']}, 13:42:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:42:36 INFO - 'tests': ['a11yr', 13:42:36 INFO - 'ts_paint', 13:42:36 INFO - 'tpaint', 13:42:36 INFO - 'sessionrestore', 13:42:36 INFO - 'sessionrestore_no_auto_restore', 13:42:36 INFO - 'tabpaint']}, 13:42:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:42:36 INFO - 'tests': ['a11yr', 13:42:36 INFO - 'ts_paint', 13:42:36 INFO - 'tpaint', 13:42:36 INFO - 'sessionrestore', 13:42:36 INFO - 'sessionrestore_no_auto_restore', 13:42:36 INFO - 'tabpaint']}, 13:42:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:42:36 INFO - 'tests': ['tsvgx', 13:42:36 INFO - 'tsvgr_opacity', 13:42:36 INFO - 'tart', 13:42:36 INFO - 'tscrollx', 13:42:36 INFO - 'cart']}, 13:42:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:42:36 INFO - 'tsvgr_opacity', 13:42:36 INFO - 'tart', 13:42:36 INFO - 'tscrollx', 13:42:36 INFO - 'cart']}, 13:42:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:36 INFO - 'talos_options': ['--disable-e10s'], 13:42:36 INFO - 'tests': ['tp5o']}, 13:42:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:36 INFO - 'tests': ['tp5o']}, 13:42:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:36 INFO - 'talos_options': ['--disable-e10s', 13:42:36 INFO - '--xperf_path', 13:42:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:42:36 INFO - 'tests': ['tp5n']}, 13:42:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:36 INFO - 'talos_options': ['--xperf_path', 13:42:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:42:36 INFO - 'tests': ['tp5n']}}, 13:42:36 INFO - 'talos.zip': {'path': '', 13:42:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:42:36 INFO - Running post-action listener: _resource_record_post_action 13:42:36 INFO - [mozharness: 2016-08-12 20:42:36.299272Z] Finished populate-webroot step (success) 13:42:36 INFO - [mozharness: 2016-08-12 20:42:36.299403Z] Running create-virtualenv step. 13:42:36 INFO - Running pre-action listener: _resource_record_pre_action 13:42:36 INFO - Running main action method: create_virtualenv 13:42:36 INFO - Creating virtualenv /builds/slave/test/build/venv 13:42:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:42:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:42:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:42:36 INFO - Using real prefix '/tools/python27' 13:42:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:42:37 INFO - Installing distribute.............................................................................................................................................................................................done. 13:42:39 INFO - Installing pip.................done. 13:42:39 INFO - Return code: 0 13:42:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f0ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fa0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf63cbe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6fd30>, '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 0x109bd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e67b20>, '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.84SBteCqMa/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.4QUhpt1JJ2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 13:42:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:42:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:42:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.84SBteCqMa/Render', 13:42:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:42:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:42:39 INFO - 'HOME': '/Users/cltbld', 13:42:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:42:39 INFO - 'LOGNAME': 'cltbld', 13:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:39 INFO - 'MOZ_NO_REMOTE': '1', 13:42:39 INFO - 'NO_EM_RESTART': '1', 13:42:39 INFO - 'PAGER': '/bin/cat', 13:42:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:39 INFO - 'PWD': '/builds/slave/test', 13:42:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:42:39 INFO - 'SHELL': '/bin/bash', 13:42:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4QUhpt1JJ2/Listeners', 13:42:39 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 13:42:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:42:39 INFO - 'USER': 'cltbld', 13:42:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:42:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:39 INFO - 'XPC_FLAGS': '0x0', 13:42:39 INFO - 'XPC_SERVICE_NAME': '0', 13:42:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:42:40 INFO - Cleaning up... 13:42:40 INFO - Return code: 0 13:42:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f0ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fa0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf63cbe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6fd30>, '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 0x109bd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e67b20>, '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.84SBteCqMa/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.4QUhpt1JJ2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 13:42:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:42:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:42:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.84SBteCqMa/Render', 13:42:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:42:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:42:40 INFO - 'HOME': '/Users/cltbld', 13:42:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:42:40 INFO - 'LOGNAME': 'cltbld', 13:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:40 INFO - 'MOZ_NO_REMOTE': '1', 13:42:40 INFO - 'NO_EM_RESTART': '1', 13:42:40 INFO - 'PAGER': '/bin/cat', 13:42:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:40 INFO - 'PWD': '/builds/slave/test', 13:42:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:42:40 INFO - 'SHELL': '/bin/bash', 13:42:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4QUhpt1JJ2/Listeners', 13:42:40 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 13:42:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:42:40 INFO - 'USER': 'cltbld', 13:42:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:42:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:40 INFO - 'XPC_FLAGS': '0x0', 13:42:40 INFO - 'XPC_SERVICE_NAME': '0', 13:42:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:40 INFO - Downloading/unpacking psutil>=3.1.1 13:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:42:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:42:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:42:43 INFO - Installing collected packages: psutil 13:42:43 INFO - Running setup.py install for psutil 13:42:43 INFO - building 'psutil._psutil_osx' extension 13:42:43 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 13:42:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 13:42:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 13:42:44 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 13:42:44 INFO - building 'psutil._psutil_posix' extension 13:42:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 13:42:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:42:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:42:44 INFO - ^ 13:42:44 INFO - 1 warning generated. 13:42:44 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 13:42:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:42:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:42:45 INFO - Successfully installed psutil 13:42:45 INFO - Cleaning up... 13:42:45 INFO - Return code: 0 13:42:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f0ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fa0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf63cbe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6fd30>, '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 0x109bd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e67b20>, '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.84SBteCqMa/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.4QUhpt1JJ2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 13:42:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:42:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:42:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.84SBteCqMa/Render', 13:42:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:42:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:42:45 INFO - 'HOME': '/Users/cltbld', 13:42:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:42:45 INFO - 'LOGNAME': 'cltbld', 13:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:45 INFO - 'MOZ_NO_REMOTE': '1', 13:42:45 INFO - 'NO_EM_RESTART': '1', 13:42:45 INFO - 'PAGER': '/bin/cat', 13:42:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:45 INFO - 'PWD': '/builds/slave/test', 13:42:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:42:45 INFO - 'SHELL': '/bin/bash', 13:42:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4QUhpt1JJ2/Listeners', 13:42:45 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 13:42:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:42:45 INFO - 'USER': 'cltbld', 13:42:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:42:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:45 INFO - 'XPC_FLAGS': '0x0', 13:42:45 INFO - 'XPC_SERVICE_NAME': '0', 13:42:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:42:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:42:47 INFO - Installing collected packages: mozsystemmonitor 13:42:47 INFO - Running setup.py install for mozsystemmonitor 13:42:48 INFO - Successfully installed mozsystemmonitor 13:42:48 INFO - Cleaning up... 13:42:48 INFO - Return code: 0 13:42:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:42:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f0ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fa0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf63cbe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6fd30>, '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 0x109bd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e67b20>, '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.84SBteCqMa/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.4QUhpt1JJ2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 13:42:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:42:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:42:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.84SBteCqMa/Render', 13:42:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:42:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:42:48 INFO - 'HOME': '/Users/cltbld', 13:42:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:42:48 INFO - 'LOGNAME': 'cltbld', 13:42:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:48 INFO - 'MOZ_NO_REMOTE': '1', 13:42:48 INFO - 'NO_EM_RESTART': '1', 13:42:48 INFO - 'PAGER': '/bin/cat', 13:42:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:42:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:48 INFO - 'PWD': '/builds/slave/test', 13:42:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:42:48 INFO - 'SHELL': '/bin/bash', 13:42:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4QUhpt1JJ2/Listeners', 13:42:48 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 13:42:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:42:48 INFO - 'USER': 'cltbld', 13:42:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:42:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:42:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:48 INFO - 'XPC_FLAGS': '0x0', 13:42:48 INFO - 'XPC_SERVICE_NAME': '0', 13:42:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:42:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:48 INFO - Downloading/unpacking jsonschema==2.5.1 13:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:42:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:51 INFO - Downloading functools32-3.2.3-2.tar.gz 13:42:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:42:51 INFO - warning: no files found matching '*.txt' 13:42:51 INFO - no previously-included directories found matching 'build' 13:42:51 INFO - no previously-included directories found matching 'dist' 13:42:51 INFO - no previously-included directories found matching '.git*' 13:42:51 INFO - Installing collected packages: jsonschema, functools32 13:42:51 INFO - Running setup.py install for functools32 13:42:51 INFO - warning: no files found matching '*.txt' 13:42:51 INFO - no previously-included directories found matching 'build' 13:42:51 INFO - no previously-included directories found matching 'dist' 13:42:51 INFO - no previously-included directories found matching '.git*' 13:42:51 INFO - Successfully installed jsonschema functools32 13:42:51 INFO - Cleaning up... 13:42:51 INFO - Return code: 0 13:42:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:42: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')]} 13:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42: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')]} 13:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f0ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fa0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf63cbe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6fd30>, '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 0x109bd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e67b20>, '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.84SBteCqMa/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.4QUhpt1JJ2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 13:42:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:42:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.84SBteCqMa/Render', 13:42:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:42:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:42:51 INFO - 'HOME': '/Users/cltbld', 13:42:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:42:51 INFO - 'LOGNAME': 'cltbld', 13:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:51 INFO - 'MOZ_NO_REMOTE': '1', 13:42:51 INFO - 'NO_EM_RESTART': '1', 13:42:51 INFO - 'PAGER': '/bin/cat', 13:42:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:51 INFO - 'PWD': '/builds/slave/test', 13:42:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:42:51 INFO - 'SHELL': '/bin/bash', 13:42:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4QUhpt1JJ2/Listeners', 13:42:51 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 13:42:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:42:51 INFO - 'USER': 'cltbld', 13:42:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:42:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:51 INFO - 'XPC_FLAGS': '0x0', 13:42:51 INFO - 'XPC_SERVICE_NAME': '0', 13:42:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:42:51 INFO - Cleaning up... 13:42:51 INFO - Return code: 0 13:42:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:42: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')]} 13:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42: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')]} 13:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f0ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fa0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf63cbe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6fd30>, '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 0x109bd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e67b20>, '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.84SBteCqMa/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.4QUhpt1JJ2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 13:42:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:42:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.84SBteCqMa/Render', 13:42:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:42:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:42:51 INFO - 'HOME': '/Users/cltbld', 13:42:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:42:51 INFO - 'LOGNAME': 'cltbld', 13:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:51 INFO - 'MOZ_NO_REMOTE': '1', 13:42:51 INFO - 'NO_EM_RESTART': '1', 13:42:51 INFO - 'PAGER': '/bin/cat', 13:42:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:51 INFO - 'PWD': '/builds/slave/test', 13:42:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:42:51 INFO - 'SHELL': '/bin/bash', 13:42:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4QUhpt1JJ2/Listeners', 13:42:51 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 13:42:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:42:51 INFO - 'USER': 'cltbld', 13:42:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:42:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:51 INFO - 'XPC_FLAGS': '0x0', 13:42:51 INFO - 'XPC_SERVICE_NAME': '0', 13:42:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:52 INFO - Downloading/unpacking blobuploader==1.2.4 13:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:54 INFO - Downloading blobuploader-1.2.4.tar.gz 13:42:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:42:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:42:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:55 INFO - Downloading docopt-0.6.1.tar.gz 13:42:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:42:55 INFO - Installing collected packages: blobuploader, requests, docopt 13:42:55 INFO - Running setup.py install for blobuploader 13:42:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:42:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:42:55 INFO - Running setup.py install for requests 13:42:56 INFO - Running setup.py install for docopt 13:42:56 INFO - Successfully installed blobuploader requests docopt 13:42:56 INFO - Cleaning up... 13:42:56 INFO - Return code: 0 13:42:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f0ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fa0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf63cbe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6fd30>, '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 0x109bd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e67b20>, '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.84SBteCqMa/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.4QUhpt1JJ2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 13:42:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:42:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:42:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.84SBteCqMa/Render', 13:42:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:42:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:42:56 INFO - 'HOME': '/Users/cltbld', 13:42:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:42:56 INFO - 'LOGNAME': 'cltbld', 13:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:56 INFO - 'MOZ_NO_REMOTE': '1', 13:42:56 INFO - 'NO_EM_RESTART': '1', 13:42:56 INFO - 'PAGER': '/bin/cat', 13:42:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:56 INFO - 'PWD': '/builds/slave/test', 13:42:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:42:56 INFO - 'SHELL': '/bin/bash', 13:42:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4QUhpt1JJ2/Listeners', 13:42:56 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 13:42:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:42:56 INFO - 'USER': 'cltbld', 13:42:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:42:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:56 INFO - 'XPC_FLAGS': '0x0', 13:42:56 INFO - 'XPC_SERVICE_NAME': '0', 13:42:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:42:56 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-fvGb7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:42:56 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-Ulgypk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:42:57 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-B_NJyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:42:57 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-l2SEIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:42:57 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-q7XlKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:42:57 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-5J3ITX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:42:57 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-De4r3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:42:57 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-cmZPSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:42:57 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-c3RYWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:42:57 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-6fjCi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:42:57 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-SSLimM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:42:58 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-9oFhYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:42:58 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-AFgA1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:42:58 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-TbHRi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:42:58 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-RECzri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:42:58 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-RsEmC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:42:58 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-K5Bu7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:42:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:42:58 INFO - Running setup.py install for manifestparser 13:42:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:42:58 INFO - Running setup.py install for mozcrash 13:42:58 INFO - Running setup.py install for mozdebug 13:42:59 INFO - Running setup.py install for mozdevice 13:42:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:42:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:42:59 INFO - Running setup.py install for mozfile 13:42:59 INFO - Running setup.py install for mozhttpd 13:42:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:42:59 INFO - Running setup.py install for mozinfo 13:42:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:42:59 INFO - Running setup.py install for mozInstall 13:42:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:42:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:42:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:42:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:42:59 INFO - Running setup.py install for mozleak 13:42:59 INFO - Running setup.py install for mozlog 13:43:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:43:00 INFO - Running setup.py install for moznetwork 13:43:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:43:00 INFO - Running setup.py install for mozprocess 13:43:00 INFO - Running setup.py install for mozprofile 13:43:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:43:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:43:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:43:00 INFO - Running setup.py install for mozrunner 13:43:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:43:00 INFO - Running setup.py install for mozscreenshot 13:43:00 INFO - Running setup.py install for moztest 13:43:01 INFO - Running setup.py install for mozversion 13:43:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:43:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:43:01 INFO - Cleaning up... 13:43:01 INFO - Return code: 0 13:43:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:43: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')]} 13:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43: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')]} 13:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f0ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fa0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf63cbe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6fd30>, '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 0x109bd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e67b20>, '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.84SBteCqMa/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.4QUhpt1JJ2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 13:43:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:43:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.84SBteCqMa/Render', 13:43:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:43:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:43:01 INFO - 'HOME': '/Users/cltbld', 13:43:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:43:01 INFO - 'LOGNAME': 'cltbld', 13:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:01 INFO - 'MOZ_NO_REMOTE': '1', 13:43:01 INFO - 'NO_EM_RESTART': '1', 13:43:01 INFO - 'PAGER': '/bin/cat', 13:43:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:01 INFO - 'PWD': '/builds/slave/test', 13:43:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:43:01 INFO - 'SHELL': '/bin/bash', 13:43:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4QUhpt1JJ2/Listeners', 13:43:01 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 13:43:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:43:01 INFO - 'USER': 'cltbld', 13:43:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:43:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:01 INFO - 'XPC_FLAGS': '0x0', 13:43:01 INFO - 'XPC_SERVICE_NAME': '0', 13:43:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:43:01 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-Qld9b1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:43:01 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-CmLw9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:43:01 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-SRhJCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:43:01 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)) 13:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:43:01 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-RBFOx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:43:01 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)) 13:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:43:02 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-I9V7fL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:43:02 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-Y9wfaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:43:02 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-JIW6L_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:43:02 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-4thoWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:43:02 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-89PBGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:43:02 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-kJbT8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:43:02 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-mSk2ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:43:02 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-v62uz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:43:02 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-Hjsq4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:43:02 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)) 13:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:43:02 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-NPU8n_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:43:03 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-Doe5VO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:43:03 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-fa2c5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:43:03 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-4hwQjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:43:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:05 INFO - Downloading blessings-1.6.tar.gz 13:43:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:43:05 INFO - Installing collected packages: blessings 13:43:05 INFO - Running setup.py install for blessings 13:43:06 INFO - Successfully installed blessings 13:43:06 INFO - Cleaning up... 13:43:06 INFO - Return code: 0 13:43:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:43:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:43:06 INFO - Reading from file tmpfile_stdout 13:43:06 INFO - Current package versions: 13:43:06 INFO - blessings == 1.6 13:43:06 INFO - blobuploader == 1.2.4 13:43:06 INFO - docopt == 0.6.1 13:43:06 INFO - functools32 == 3.2.3-2 13:43:06 INFO - jsonschema == 2.5.1 13:43:06 INFO - manifestparser == 1.1 13:43:06 INFO - mozInstall == 1.12 13:43:06 INFO - mozcrash == 0.17 13:43:06 INFO - mozdebug == 0.1 13:43:06 INFO - mozdevice == 0.48 13:43:06 INFO - mozfile == 1.2 13:43:06 INFO - mozhttpd == 0.7 13:43:06 INFO - mozinfo == 0.9 13:43:06 INFO - mozleak == 0.1 13:43:06 INFO - mozlog == 3.3 13:43:06 INFO - moznetwork == 0.27 13:43:06 INFO - mozprocess == 0.23 13:43:06 INFO - mozprofile == 0.28 13:43:06 INFO - mozrunner == 6.12 13:43:06 INFO - mozscreenshot == 0.1 13:43:06 INFO - mozsystemmonitor == 0.3 13:43:06 INFO - moztest == 0.7 13:43:06 INFO - mozversion == 1.4 13:43:06 INFO - psutil == 3.1.1 13:43:06 INFO - requests == 1.2.3 13:43:06 INFO - wsgiref == 0.1.2 13:43:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f0ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fa0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf63cbe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6fd30>, '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 0x109bd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e67b20>, '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.84SBteCqMa/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.4QUhpt1JJ2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 13:43:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:43:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.84SBteCqMa/Render', 13:43:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:43:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:43:06 INFO - 'HOME': '/Users/cltbld', 13:43:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:43:06 INFO - 'LOGNAME': 'cltbld', 13:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:06 INFO - 'MOZ_NO_REMOTE': '1', 13:43:06 INFO - 'NO_EM_RESTART': '1', 13:43:06 INFO - 'PAGER': '/bin/cat', 13:43:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:06 INFO - 'PWD': '/builds/slave/test', 13:43:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:43:06 INFO - 'SHELL': '/bin/bash', 13:43:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4QUhpt1JJ2/Listeners', 13:43:06 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 13:43:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:43:06 INFO - 'USER': 'cltbld', 13:43:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:43:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:06 INFO - 'XPC_FLAGS': '0x0', 13:43:06 INFO - 'XPC_SERVICE_NAME': '0', 13:43:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:43:06 INFO - Cleaning up... 13:43:06 INFO - Return code: 0 13:43:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f0ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fa0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf63cbe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6fd30>, '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 0x109bd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e67b20>, '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.84SBteCqMa/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.4QUhpt1JJ2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 13:43:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:43:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.84SBteCqMa/Render', 13:43:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:43:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:43:06 INFO - 'HOME': '/Users/cltbld', 13:43:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:43:06 INFO - 'LOGNAME': 'cltbld', 13:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:06 INFO - 'MOZ_NO_REMOTE': '1', 13:43:06 INFO - 'NO_EM_RESTART': '1', 13:43:06 INFO - 'PAGER': '/bin/cat', 13:43:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:06 INFO - 'PWD': '/builds/slave/test', 13:43:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:43:06 INFO - 'SHELL': '/bin/bash', 13:43:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4QUhpt1JJ2/Listeners', 13:43:06 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 13:43:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:43:06 INFO - 'USER': 'cltbld', 13:43:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:43:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:06 INFO - 'XPC_FLAGS': '0x0', 13:43:06 INFO - 'XPC_SERVICE_NAME': '0', 13:43:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:43:07 INFO - Cleaning up... 13:43:07 INFO - Return code: 0 13:43:07 INFO - Running post-action listener: _resource_record_post_action 13:43:07 INFO - Running post-action listener: _start_resource_monitoring 13:43:07 INFO - Starting resource monitoring. 13:43:07 INFO - [mozharness: 2016-08-12 20:43:07.108671Z] Finished create-virtualenv step (success) 13:43:07 INFO - [mozharness: 2016-08-12 20:43:07.109670Z] Running install step. 13:43:07 INFO - Running pre-action listener: _resource_record_pre_action 13:43:07 INFO - Running main action method: install 13:43:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:43:07 INFO - Reading from file tmpfile_stdout 13:43:07 INFO - Detecting whether we're running mozinstall >=1.0... 13:43:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:43:07 INFO - Reading from file tmpfile_stdout 13:43:07 INFO - Output received: 13:43:07 INFO - Usage: mozinstall [options] installer 13:43:07 INFO - Options: 13:43:07 INFO - -h, --help show this help message and exit 13:43:07 INFO - -d DEST, --destination=DEST 13:43:07 INFO - Directory to install application into. [default: 13:43:07 INFO - "/builds/slave/test"] 13:43:07 INFO - --app=APP Application being installed. [default: firefox] 13:43:07 INFO - mkdir: /builds/slave/test/build/application 13:43:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:43:41 INFO - Reading from file tmpfile_stdout 13:43:41 INFO - Output received: 13:43:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:43:41 INFO - Running post-action listener: _resource_record_post_action 13:43:41 INFO - [mozharness: 2016-08-12 20:43:41.497542Z] Finished install step (success) 13:43:41 INFO - [mozharness: 2016-08-12 20:43:41.497714Z] Running run-tests step. 13:43:41 INFO - Running pre-action listener: _resource_record_pre_action 13:43:41 INFO - Running main action method: run_tests 13:43:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:43:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:43:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:43:41 INFO - 2016-08-12 13:43:41.512 screenresolution[1642:9837] starting screenresolution argv=screenresolution get 13:43:41 INFO - 2016-08-12 13:43:41.514 screenresolution[1642:9837] Display 0: 1600x1200x32@60 13:43:41 INFO - 2016-08-12 13:43:41.520 screenresolution[1643:9839] starting screenresolution argv=screenresolution list 13:43:41 INFO - Available Modes on Display 0 13:43:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:43:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:43:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:43:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:43:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:43:41 INFO - Intel Iris: 13:43:41 INFO - Chipset Model: Intel Iris 13:43:41 INFO - Type: GPU 13:43:41 INFO - Bus: Built-In 13:43:41 INFO - VRAM (Dynamic, Max): 1536 MB 13:43:41 INFO - Vendor: Intel (0x8086) 13:43:41 INFO - Device ID: 0x0a2e 13:43:41 INFO - Revision ID: 0x0009 13:43:41 INFO - Displays: 13:43:41 INFO - Display: 13:43:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:43:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:43:41 INFO - Display Serial Number: 1600x1200 60 13:43:41 INFO - Main Display: Yes 13:43:41 INFO - Mirror: Off 13:43:41 INFO - Online: Yes 13:43:41 INFO - Rotation: Supported 13:43:41 INFO - Return code: 0 13:43:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:43:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:43:41 INFO - Python 2.7.3 13:43:41 INFO - Return code: 0 13:43:41 INFO - grabbing minidump binary from tooltool 13:43: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')]} 13:43:41 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 0x109e6fd30>, '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 0x109bd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e67b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:43:41 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 13:43:41 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 13:43:41 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 13:43:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:43:41 INFO - Return code: 0 13:43:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:43:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:43:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:43:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:43:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:43:41 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/Q4ORzEAdRiSfbu8d2WjiLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0186', '--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 13:43:41 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/Q4ORzEAdRiSfbu8d2WjiLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0186 --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 13:43:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.84SBteCqMa/Render', 13:43:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:43:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:43:41 INFO - 'HOME': '/Users/cltbld', 13:43:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:43:41 INFO - 'LOGNAME': 'cltbld', 13:43:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:43:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:43:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:41 INFO - 'MOZ_NO_REMOTE': '1', 13:43:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:43:41 INFO - 'NO_EM_RESTART': '1', 13:43:41 INFO - 'PAGER': '/bin/cat', 13:43:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:43:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:41 INFO - 'PWD': '/builds/slave/test', 13:43:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:43:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:43:41 INFO - 'SHELL': '/bin/bash', 13:43:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4QUhpt1JJ2/Listeners', 13:43:41 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 13:43:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:43:41 INFO - 'USER': 'cltbld', 13:43:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:43:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:43:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:41 INFO - 'XPC_FLAGS': '0x0', 13:43:41 INFO - 'XPC_SERVICE_NAME': '0', 13:43:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:43:41 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/Q4ORzEAdRiSfbu8d2WjiLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0186', '--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 13:43:42 INFO - mozversion application_buildid: 20160812113215 13:43:42 INFO - mozversion application_changeset: ef0801fdc7abe018a8b026c00e8bdebcc690001c 13:43:42 INFO - mozversion application_display_name: Nightly 13:43:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:43:42 INFO - mozversion application_name: Firefox 13:43:42 INFO - mozversion application_remotingname: firefox 13:43:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:43:42 INFO - mozversion application_vendor: Mozilla 13:43:42 INFO - mozversion application_version: 51.0a1 13:43:42 INFO - mozversion platform_buildid: 20160812113215 13:43:42 INFO - mozversion platform_changeset: ef0801fdc7abe018a8b026c00e8bdebcc690001c 13:43:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:43:42 INFO - mozversion platform_version: 51.0a1 13:43:42 INFO - using testdate: 1471034622 13:43:42 INFO - actual date: 1471034622 13:43:42 INFO - starting webserver on 'localhost:49262' 13:43:42 INFO - SUITE-START | Running 2 tests 13:43:42 INFO - TEST-START | dromaeo_css 13:43:42 INFO - operating with platform_type : mac_ 13:43:42 INFO - Initialising browser for dromaeo_css test... 13:43:42 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmpQNHhz2/profile http://localhost:49262/getInfo.html) 13:43:45 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 13:43:45 INFO - PROCESS | 1653 | colorDepth:24 13:43:45 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 13:43:45 INFO - PROCESS | 1653 | __metrics 13:43:45 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 13:43:45 INFO - TEST-INFO | 1653: exit 0 13:43:45 INFO - Browser initialized. 13:43:45 INFO - Running cycle 1/1 for dromaeo_css test... 13:43:45 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmpQNHhz2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:43:57 INFO - PROCESS | 1657 | RSS: Main: 254746624 13:43:57 INFO - PROCESS | 1657 | 13:44:47 INFO - PROCESS | 1657 | 1471034687592 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] 13:46:58 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49262/tests/dromaeo/cssquery-ext.html) 13:47:00 INFO - PROCESS | 1657 | RSS: Main: 269463552 13:47:00 INFO - PROCESS | 1657 | 13:50:02 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-ext.html (next: http://localhost:49262/tests/dromaeo/cssquery-jquery.html) 13:50:03 INFO - PROCESS | 1657 | RSS: Main: 277532672 13:50:03 INFO - PROCESS | 1657 | 13:53:05 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49262/tests/dromaeo/cssquery-mootools.html) 13:53:05 INFO - PROCESS | 1657 | RSS: Main: 282312704 13:53:05 INFO - PROCESS | 1657 | 13:56:07 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49262/tests/dromaeo/cssquery-prototype.html) 13:56:08 INFO - PROCESS | 1657 | RSS: Main: 280498176 13:56:08 INFO - PROCESS | 1657 | 13:59:11 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49262/tests/dromaeo/cssquery-yui.html) 13:59:11 INFO - PROCESS | 1657 | RSS: Main: 284913664 13:59:11 INFO - PROCESS | 1657 | 14:02:14 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-yui.html (next: http://localhost:49262/tests/dromaeo/cssquery-dojo.html) 14:02:14 INFO - PROCESS | 1657 | RSS: Main: 286789632 14:02:14 INFO - PROCESS | 1657 | 14:02:14 INFO - PROCESS | 1657 | __start_tp_report 14:02:14 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 14:02:14 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 14:02:14 INFO - PROCESS | 1657 | |i|pagename|runs| 14:02:14 INFO - PROCESS | 1657 | |0;dojo.html;2810.6908240093585;3447.2416068464927;3447.741419393545;3454.136465883529;3459.394605943959;4613.884652883676;4979.875503112424;5708.628939118959;5756.913646295309;5768.625039372449;5633.8591535211535;5719.828405147842;5733.971330143354;5750;5808.651480911149;4178.937315940256;5259.631825772198;5327.813526526573;5330.520253177213;5392.2181283714035;5109;5152.793888244466;5265.3681558212875;5278.788848446057;5283.181106928432;5202.661826981234;5227.3465816772905;5251.579873610102;5256.8685782855355;5290.285811415487;5221.008008478377;5233.241180028913;5242.18746094356;5254.579633629339;5273.499017593323;5078.847634570969;5186.7147306898105;5217.060929032773;5250.18622113573;5258.579313654936;4625.838095666635;5386.622936394454;5776.104703770922;5779.104238842986;5847.941520584783;6194.628322300677;6227.09707092469;6235.469985051231;6256.280527739277;6288.968555157241;6123.83172914054;6195.876082478325;6234.438900498977;6253.656048917308;6269.3730626937395;5794.246747922785;5828.562857785683;5862.443067908627;5867.3839246879315;5900.321463031763;6205.844853878599;6206.100115483229;6267.467265282411;6267.9373206267355;6301.306856245809;6031.185789918392;6113.23584551931;6171.321154672983;6186.257649082139;6200.3799620037635;6166.352532983972;6244.344343843831;6245.281792593819;6265.248170219512;6306.747730090837;6168.136460895478;6178.165947597106;6193.256809182927;6234.127222188898;6256.562040657202;6121.5139442231075;6180.81457556274;6217.347178546278;6245.718942647592;6252.280987686383;4976.278439626306;5030.84907452777;5032.84901452957;5045.5459008689395;5095.745212739348;4423.668224883147;4435.733855968588;4444.066745983315;4462.040661257845;4511.300748384006;5495.203195536625;5643.01247281724;5687.232223649837;5838;5851.882962340729;6208.534359923024;6217.564770466114;6224.221972253468;6225.937740622627;6237.625742455467;5700.942990570041;5709.942900571024;5721.914171287434;5733.226014488074;5753.88492230153;5359.705216213146;5441.700706461183;5468.48049435303;5480.150576660624;5584.692841893653;5383.515483606494;6337.746490140343;6380.361963803675;6395.232572091379;6398.520110991694;6194.039923811816;6239.7504099837315;6244.968775156095;6256.687165641791;6297.685115744286;6143.84640383994;6238.968805155945;6239.407256310643;6375.521835862236;6383.840403989938;5927.940720592739;6183.258009038944;6206.689665516616;6213.65824879636;6236.532260080603;6223.693024464913;6231.937680623136;6244.313125556276;6246.063090536456;6254.499640028877;4717.042427392594;5847.473727364558;6125.908111378422;6141.416565426277;6154.876902462015;6143.082036032849;6188.504919606331;6189.04069869171;6191.071339299141;6201.069839524108;5797.739101740347;5906.573621079193;5975.9103613446705;6018.8796224074395;6037.547183961308;6018.187544681412;6106.755729770759;6121.879793613328;6159.353267906985;6162.414570615784;5983.521318294613;5997.190379298739;6042.425969532887;6043.697815109315;6075.27096748393 14:02:14 INFO - PROCESS | 1657 | |1;ext.html;485.61636307317224;485.76683192067804;529.2405398253505;538.8733647592812;558.3606770248064;30283;41014;41133;41136;41225.79387103068;41561.37657935133;41801.58198418015;42027.57972420275;42133.94665133373;42152.57847421525;9447.055294470549;9597.23222142227;9625.326227164102;9642.662506812263;9645.03549645037;9499.287553433485;9523.619055237783;9628.903710962906;9640.614375424975;9645;9604.759881002961;9666.90333096667;9670;9696.563654635558;9713.854292185622;9659.985701501346;9675.70972870815;9679.274054445945;9691.370060946087;9693.3699309545;9540.570674319672;9565.90434095664;9585;9604.759881002961;9606.567704453317;35614.821925890465;36044.81977590122;36117.09707257313;36173.638263617555;36458.270834583425;3363.01383537304;3448.0690213642174;3480.930381392358;3481.89554313371;3522.6829585337186;31576.684233157834;32153.874614388616;32236.355272894645;32506.024819255224;32996.17509562256;3139.560461535387;3146.9055928322186;3150.763692723032;3165.5251712243116;3248.4640034394297;467086;474835.99999999657;475113;479746;481975;61057;61585;61601.69199153975;61625.383746162865;61642.76714465686;34818.129546761535;35055.64944350524;35569.46645800315;36426;36479.27041459156;14691.85308146905;16419.522242997948;16717.58206044834;16882.240299186567;16888;12834.486620535074;12978.35108244584;12998;13000.739985200244;13014.674633134247;16632.835701501022;19404.611907761766;19603.431725461927;19662.21351145938;19838.40484785459;6719.328067193242;7374.483786135026;7456.664450099758;7832.490888092256;7897.565633890191;926.379325851681;996.9501524923725;1009.545704433008;1104.9337039777638;1131.6137731279118;29786;30158.246043849078;30445.086647400614;30466.54300185499;30915.381692366027;1007.7128018514835;1084.902358787697;1089.1395797320188;1093.8195197792274;1114.2367478277406;15902.7614585779;15986.414824524882;16077.196140193177;16120.919395402949;16316.918415407847;509925;595106;609363;616226;617717.9114104401;41273;41459;41763.7911810439;42012.789936050125;42149.94625134335;1330.767115754739;1370.7532644124153;1395.567374114048;1407.8099456573436;1428.407211007441;29356.412871742872;29849.70150298556;30281.78803344081;30481.54277685792;30563;51816.70458238574;51887.74056129695;52009.47990520046;52108.21837672362;52265;475167;550273.4972650222;555096;555395;556010;26693.7330626699;26898.731012690405;27077.593836092867;27128.864355678095;27411;47594.762026191034;47635.761821190674;48664.513354866;49090.50909490859;49592.256116157565;40069.59930400659;40094.799526002185;40644.79677601593;41335.1732965333;41728.95677608084;35491.29017419689;36672.81663591665;39673.80978570648;40289;40603;33479.33041339208;38009.23981520409;38357.6164238354;38529.84410467691;38951;33847.49228761521;34602.13494662654;35009.12477188091;35139;35503;25626.487470250864;25999.870000649877;26104.608430873934;26228.475430491664;26813 14:02:14 INFO - PROCESS | 1657 | |2;jquery.html;363.13573694606833;376.91330993871406;387.25260247721894;389.4722650808153;406.9226846899089;14899.925500372483;19290.807091929077;22194.66707999377;22242;22501.762403067823;18742.71885921709;20120.295789647327;21539.56920861582;21703.565928681415;21996.560068798655;5780.583756979546;5903.970480147594;6092.390760923917;6120.785772497963;6162.352952939944;6073.089036644495;6082.574219804594;6127.264728232618;6132.264128304588;6135.32511423743;5717.714114294289;5965.731542080617;6038.305594856603;6046.365131661179;6126.479249263818;5815.47660710536;5829.5919285650025;5951.464368206861;5954.91067633988;5994.190784244115;5908.911366329508;5978.581499295051;5982.700864956735;6011.789587364465;6024.909626355608;24949.126780562594;25276.873615631986;25381.49237015268;26032.609510857164;26123.085692000688;2158.4064382294837;2715.6198132261497;2992.595999540056;2995;3100;8149.592520374017;9746.31775775696;9978.101970822589;10311.329763565343;10454.372737635766;1598.768178614106;1792.8924264544169;1853.629274145163;1872.7471791308135;1873.241337258399;120578;123817.38091309575;125377;126223.368883155;126843.99999999908;10948.781024379627;11380.601678941362;11401.48693308803;11433.085353171726;11601.187916845909;14279.357428915724;14346.354414051393;14440.350184241734;14441.205733684537;14504.34730437133;8361.372897032747;8577.828443431097;8608.440451370641;8742.650293988296;8809.69166079197;8479.364047696448;8558.144185581392;8607.526586037828;8719.91280087191;8762.036176020632;4462.687611867138;4494.662900282492;4563.54364563541;4627.329037289574;4635.443746750344;1896.838768704648;1947.3476385410763;1958.9510262243557;1963.6956271777897;1995.3914056212996;890.283321925856;905.3752910491739;919.3334832246701;989.2926557511414;1000.3797645459716;20897.79102208989;22113.44716382071;22188.778112218995;22195.556088878133;22211.555768884857;973.9220862330997;983.955721992512;1000.0449570660003;1035.5443604813859;1050.99474502627;11114.499847506882;11557.595484158182;11616.303021818718;11760.705982350339;11789.587364442203;460860.6956965261;473667.52664947195;503861;505265;599931;98180;128320;130564;133181;133893;948.2177203807025;958.4728399380313;984.7045886234101;991.7371896447303;991.9057689519484;17129.400470983455;19238.711419329;19994.60010799805;20080.39758807238;20424.543351679196;22609.773902261426;40103.59896400999;45272;54160.187597186865;54376.91246175134;71641.56716865738;74762.62618686871;78005.2199477998;84306;86257.56871215603;8125.106238313662;8303.335733141455;8382.413231073766;8392;8513.19124683154;10442.947785261025;12624.11631185845;13110;13150.736985260433;13260.80108798388;9694.224462043161;9758.756031098996;10411.895881041093;11264;11521.769564608494;9403.717888463358;10619.460178273952;10708.518116684612;10744.946275268887;11633.418329083343;11499;11501.654950351503;11806.291622502677;11844.466998984894;11950.760984780429;8066.798330041561;8107.142148005405;8380.497170169809;8394.24451799341;8419.62111704987;9135.451872887648;10447.94776026115;11605.883941160819;11647.30116193031;11746.236494627821 14:02:14 INFO - PROCESS | 1657 | |3;mootools.html;1413.3216056292981;1536.4084827341474;1592.7770112184296;1766.302310587318;1903.9333623323168;6639.834004149899;7145.892386680073;8444.831103377928;8959.865602015974;8994.055624159459;7549.018627578421;8530.317574594033;8788.25299849512;8799.560021998906;8808.647654093844;2097.5595125023765;2287.6797248385237;2297.8621282723007;2323.6514522821544;2329.359426157812;2264.162259963816;2305.688732021181;2328.9650655240184;2334.428065124047;2342.1802369170823;2301.4476525633895;2315.49059206975;2318.3045086474076;2336.6027775278244;2339.4619237575366;2248.1457046322375;2291.633338665814;2296.28815067328;2298.643710224918;2298.8620682759006;2262.5248697773486;2297.873616951067;2311.248844125666;2312.5374925014894;2317.3395582258977;8645.913540864574;8749.168828961303;8807.2513836324;8891.4665120093;8906.376553641248;5135.563477104451;5305.469453054702;5312.07038768214;5312.2297266896085;5328;3451.2234747181683;3478.9478157827652;3583.5699716033982;3648.452732090181;3648.6351364863567;1041.1930753665895;1074.736689511067;1078.757279612081;1091.1161958813386;1098.747288123736;11507;11634.069274458023;11724.355160466172;11750.823737643943;11757.941785239369;4519.322101684774;4650.325702773079;4757.429108507002;4771.33201351811;4773.212419950739;9842.261830362751;10007.799844003079;10012.299139060196;10035.749106272255;10038.74903127413;5278.076336641149;5299.231611416323;5309.362876454773;5313.681179129265;5322.2548843161985;4343.630791382768;4625.7455839929125;4772.308015337757;4862.82980095702;4880.41435027799;3863.1114843586133;3897.8830635080994;3948.3287841067086;3971.7616942983514;4014.578469260744;1271.7965125579863;1280.7118398360294;1282.608804314693;1289.864564220762;1294.7151626642124;847.9406441549156;869.9951555952885;906.2930913887178;913.9131782480654;960.1838437328215;5684.459976302244;5787.5080618147085;5953.868764934648;6003;6117.296510901303;427.47847625896355;436.79034063649624;439.50994640975085;1010.1867996263079;1039.9896001040045;3859.7684138951754;3929.7247003448133;4010.596291298081;4042.595740425934;4050.1899620075515;10329.586816527255;10540.841887371696;10633.255672103034;10647.787044259227;10658.73353166177;9448.91337496183;10613;10618.787624247472;10621.362718236776;10622.946885265525;7518.097828260535;7937.444378893538;7962.203779621991;8217.630206640715;8230.506169629842;4511.977440112779;5706.144078388275;5739.2252045973255;5840.123981402823;5947.821565353046;9083.727488175366;9876.012398760355;9880.950595246977;9919.603215871284;9988.550515226687;9929.106380425796;10037.598496060367;10109.19126469866;10151.187904967732;10251;6579.934200657932;6928.1339832520935;7048.718051277891;7063.540869843444;7165.3909417698;8459.915400845914;8500.404971651926;8500.404971651926;8515.02077261123;8532.957335213285;6866.828329291808;7391.9651248826285;7560.886586701314;7625.199354067743;7627.466077374753;5591.720413979366;7230.89153662706;7296.635168241461;7304.890426643498;7318.085239345082;6864.7940561783225;7047.436205103477;7049.541779784297;7086.114235720535;7101.467389945671;4932.506749325039;4985.850424487271;4994.225894986283;5027.7737501813235;5086.796528138833;4919.680220785637;4943.678660887031;4996.325496057985;5048.293238946477;5196.688198707939 14:02:14 INFO - PROCESS | 1657 | |4;prototype.html;296.22537065573516;308.0619513581145;314.8743242906608;317.75691595929135;318.6415282806842;4735.621150307976;4991.70049797012;5542.39033706292;5607.57943154263;5642.15367694846;4461.505395692447;4901.627544287596;5598.748056337465;5630.634008789426;5669.489745922866;4321.805518751648;4337.848175313865;4348.4999225089205;4355;4383.649308055364;3595.8921232363073;3838.7715930902123;4205.03284244624;4267.335739061768;4296.957030429702;3700.777953322796;4018.4976877890263;4283.293256612656;4323.983863792007;4372.89067773305;3709.017110465729;4194.266003449415;4322.438083049199;4331.8483853065145;4350.521442641307;3766.6045065268027;3779.433085037266;3782.7541209821275;3797.2785170817456;3815.179736356669;5176.50823171798;5531.3915469298345;5556.305461817273;5569.022996836105;5598.86002849932;4188.560201178893;4585.111379830685;4999.575036121934;5024.271480635324;5043.696378871845;5765.798197063083;6008.459238668497;6013.6993150342305;6027.849303767397;6064.423879731418;3259.885903993349;3464.3071385722956;4136.400221967798;4147.585241475858;4194.454720886296;4926.5073492650445;5656.264685590888;5779.826605201851;6359.236891572995;6421.357864213542;3108.9844550777552;4134.958650413518;4163.7293575918075;4219.409282700424;4243.681723870722;3557.573091229069;3967.682585393162;4289.914201715948;4308.67684923632;4333.8699839004885;4169.770662613525;4268;4581.450225972904;5024.447310795809;5032.421271553745;4968.385274785709;5973.37279585646;6055.152278680988;6080.7871724490315;6088.381995741874;1354.9160671462791;1393.4426229508279;1461.2766680493012;1465.7980456026169;1470.6102882736084;774.7714424244862;780.7813812132612;883.8188171424971;905.4069584422082;907.9921287371013;3625.9637403625625;4598.26427771555;4661.294271054519;4732.692374995614;4778.617710583215;5271.78912843482;5281.524662780368;5281.630285880028;5285.515807570436;5287.894242115213;4323.919020244939;4330.501992270866;4595.908861468024;4774.498677638798;4790.688605240648;2437.526524702292;2517.7734003939368;2736.3867506531215;2744.7804175665897;2760.7653349465522;4511.70673906195;4878.804847806119;5039.656559699757;5248.317718696545;5473.66106674928;4755.785989630475;4873.149207713456;4938.7281850349245;5358.38309141328;5360.597955153379;4812.470628230892;4859.7402207972755;4942.220800511813;5077.796888124433;5405.945940540544;4641.419822522184;5004.674696144739;5031.433968675929;5249.580033597379;5307.41618421981;4436.48980367249;4870.975645121752;4935.8025678972435;5158;5227.738613069255;4933.753312334297;5239.659422137549;6188.2363526394765;6525.771597994048;6568.996456080941;3437.8998720410227;3861.4014827701753;3915.1973845361063;4083.8774836754947;4094.2630326541507;5265.420803711512;6090.665013424305;6238.344973777869;6249.1563638908165;6257.4994000480765;4976.751162441791;5572.192032155233;5726.541876649775;5840.328362238227;5992.584226990573;5351.474829673524;5933.821985340447;5966.254218222723;5988.760449581968;6066.848328791815;5319.25530425733;5328.733563321741;5723.084306510938;5892.232330300807;5940.584159108821;4745.1221524018165;5018.616157325241;5438.8640283991635;5860.501857342174;5974.56462534036;5084.669496482717;5880.000399932107;5884.911726324194;5904.61619994699;5973.880522389615 14:02:14 INFO - PROCESS | 1657 | |5;yui.html;599.8500374906273;734.5849594978838;787.4409169489659;795.6340083561565;808.7654580171751;15205.391784328627;15581.610459738484;16038.358465661375;16063.357465701372;16317.102559359231;14586.343614537345;14625.414983400678;14842.183679897602;14867;15114.546563603082;684.8801459744525;834.7120243516008;856.9271611912994;858.3862538285156;860.2515811244226;832.9083800781909;834.9666013359458;851.6891334662835;856.8543347630887;862.762740246431;879.7009016934242;910.540177210511;912.9041450647686;914.4239129348501;917.729269865388;864.6498168241872;906.768773962642;906.9410488318272;907.6687009241646;909.1590278991972;642.2613993906998;671.9496037797136;673.1383828699272;673.8685956238536;678.4911316512615;12817.487300507968;15217.467388641455;15279.694406111927;15488.612784680361;15504.922475387664;14706.55880323592;14751.704965900622;14824.777628335583;14875.70248595022;15112.39550417982;11841.108023361247;11941.223820451643;12234.81647775284;12521;12537;3664.3564356435645;3804.9619503804884;3818.732688711791;3862;3995.300822356105;77307;109790.45104774505;111573.99999999919;112441.43779281132;112668.30997535044;10643;10885.945570272099;10955.671329860117;10971.83542246867;11034;20903.05936232873;21015.94920253981;21016.94915254231;21060.578788424147;21071;7867.488613240121;7949.443538952218;8032.638531266107;8056.9928758905135;8121.675132994614;4450.1989641864775;4468.709533880287;4526.343680166357;4588.2888152336445;4595.517470665599;3595.496630471736;3741.6258374162912;3745.606711295329;3747.9437808432895;3748.4939533162674;598.5959477352769;625.6715224507079;637.5091179791534;688.2532452289322;696.474162007681;620.5780069552658;629.7323637454064;638.8466767975746;665.6205962601271;692.1753444762369;9029.683961061332;9531.857022144673;9593.520323983774;9658.661946831828;9938.45338506389;540.3704684043124;569.137756299207;630.8391360203119;668.2348710726192;673.2997682410337;4680.3915490985955;4723.45680246776;4726.1020406122725;4739.668223224341;4744.1934871072;90828.54585727029;127817;152649;156410;160750;91357.54321228352;130802.69197308096;142770.2861485686;149836;150854;69072.85562866244;74078;107838.46080769703;111258;116661;8026.598670066356;8892.555372231232;10033.648822291185;10186.643467478603;10214.489275536342;38278;46532.06935861196;59426.70286648539;64131.67934160299;67429.66285168543;96875.0312496866;97471.51264243634;98728;100331.49834250782;100659.99340006507;13025.609231723063;13212;13243.933780331037;13296.202227866359;13520.323983800967;14777.778333324793;15157.848421515644;15166.696666066837;15223.771643425136;15618.21908904573;11746;14062.367193476113;14091.718165636836;14273;14300.499482518062;13650;13696.93151534236;13867.583972480841;13882.583522494342;13992.300384980914;13534.93232533831;13667.453301867814;13941.93029034889;14225.857741422868;14340.426382944983;9220.400673956172;11307.717307067389;11437.485313160762;11444.427778611203;11872.287662740264;9598.904010960081;11017.559297628006;11448.828267575826;11574.363410012531;11797.88202117968 14:02:14 INFO - PROCESS | 1657 | __end_tp_report 14:02:14 INFO - PROCESS | 1657 | __start_cc_report 14:02:14 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,415 14:02:14 INFO - PROCESS | 1657 | __end_cc_report 14:02:14 INFO - PROCESS | 1657 | __startTimestamp1471035734640__endTimestamp 14:02:14 INFO - PROCESS | 1657 | 14:02:14 INFO - PROCESS | 1657 | ------- Summary: start ------- 14:02:14 INFO - PROCESS | 1657 | Number of tests: 6 14:02:14 INFO - PROCESS | 1657 | 14:02:14 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5728.24 Median:5983.52 stddev:663.82 (11.1%) stddev-sans-first:625.16 14:02:14 INFO - PROCESS | 1657 | Values: 2810.7 3447.2 3447.7 3454.1 3459.4 4613.9 4979.9 5708.6 5756.9 5768.6 5633.9 5719.8 5734.0 5750.0 5808.7 4178.9 5259.6 5327.8 5330.5 5392.2 5109.0 5152.8 5265.4 5278.8 5283.2 5202.7 5227.3 5251.6 5256.9 5290.3 5221.0 5233.2 5242.2 5254.6 5273.5 5078.8 5186.7 5217.1 5250.2 5258.6 4625.8 5386.6 5776.1 5779.1 5847.9 6194.6 6227.1 6235.5 6256.3 6289.0 6123.8 6195.9 6234.4 6253.7 6269.4 5794.2 5828.6 5862.4 5867.4 5900.3 6205.8 6206.1 6267.5 6267.9 6301.3 6031.2 6113.2 6171.3 6186.3 6200.4 6166.4 6244.3 6245.3 6265.2 6306.7 6168.1 6178.2 6193.3 6234.1 6256.6 6121.5 6180.8 6217.3 6245.7 6252.3 4976.3 5030.8 5032.8 5045.5 5095.7 4423.7 4435.7 4444.1 4462.0 4511.3 5495.2 5643.0 5687.2 5838.0 5851.9 6208.5 6217.6 6224.2 6225.9 6237.6 5700.9 5709.9 5721.9 5733.2 5753.9 5359.7 5441.7 5468.5 5480.2 5584.7 5383.5 6337.7 6380.4 6395.2 6398.5 6194.0 6239.8 6245.0 6256.7 6297.7 6143.8 6239.0 6239.4 6375.5 6383.8 5927.9 6183.3 6206.7 6213.7 6236.5 6223.7 6231.9 6244.3 6246.1 6254.5 4717.0 5847.5 6125.9 6141.4 6154.9 6143.1 6188.5 6189.0 6191.1 6201.1 5797.7 5906.6 5975.9 6018.9 6037.5 6018.2 6106.8 6121.9 6159.4 6162.4 5983.5 5997.2 6042.4 6043.7 6075.3 14:02:14 INFO - PROCESS | 1657 | 14:02:14 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:66344.01 Median:39312.40 stddev:143407.70 (364.8%) stddev-sans-first:143724.75 14:02:14 INFO - PROCESS | 1657 | Values: 485.6 485.8 529.2 538.9 558.4 30283.0 41014.0 41133.0 41136.0 41225.8 41561.4 41801.6 42027.6 42133.9 42152.6 9447.1 9597.2 9625.3 9642.7 9645.0 9499.3 9523.6 9628.9 9640.6 9645.0 9604.8 9666.9 9670.0 9696.6 9713.9 9660.0 9675.7 9679.3 9691.4 9693.4 9540.6 9565.9 9585.0 9604.8 9606.6 35614.8 36044.8 36117.1 36173.6 36458.3 3363.0 3448.1 3480.9 3481.9 3522.7 31576.7 32153.9 32236.4 32506.0 32996.2 3139.6 3146.9 3150.8 3165.5 3248.5 467086.0 474836.0 475113.0 479746.0 481975.0 61057.0 61585.0 61601.7 61625.4 61642.8 34818.1 35055.6 35569.5 36426.0 36479.3 14691.9 16419.5 16717.6 16882.2 16888.0 12834.5 12978.4 12998.0 13000.7 13014.7 16632.8 19404.6 19603.4 19662.2 19838.4 6719.3 7374.5 7456.7 7832.5 7897.6 926.4 997.0 1009.5 1104.9 1131.6 29786.0 30158.2 30445.1 30466.5 30915.4 1007.7 1084.9 1089.1 1093.8 1114.2 15902.8 15986.4 16077.2 16120.9 16316.9 509925.0 595106.0 609363.0 616226.0 617717.9 41273.0 41459.0 41763.8 42012.8 42149.9 1330.8 1370.8 1395.6 1407.8 1428.4 29356.4 29849.7 30281.8 30481.5 30563.0 51816.7 51887.7 52009.5 52108.2 52265.0 475167.0 550273.5 555096.0 555395.0 556010.0 26693.7 26898.7 27077.6 27128.9 27411.0 47594.8 47635.8 48664.5 49090.5 49592.3 40069.6 40094.8 40644.8 41335.2 41729.0 35491.3 36672.8 39673.8 40289.0 40603.0 33479.3 38009.2 38357.6 38529.8 38951.0 33847.5 34602.1 35009.1 35139.0 35503.0 25626.5 25999.9 26104.6 26228.5 26813.0 14:02:14 INFO - PROCESS | 1657 | 14:02:14 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:32497.96 Median:3047.50 stddev:86326.41 (2832.7%) stddev-sans-first:86534.86 14:02:14 INFO - PROCESS | 1657 | Values: 363.1 376.9 387.3 389.5 406.9 14899.9 19290.8 22194.7 22242.0 22501.8 18742.7 20120.3 21539.6 21703.6 21996.6 5780.6 5904.0 6092.4 6120.8 6162.4 6073.1 6082.6 6127.3 6132.3 6135.3 5717.7 5965.7 6038.3 6046.4 6126.5 5815.5 5829.6 5951.5 5954.9 5994.2 5908.9 5978.6 5982.7 6011.8 6024.9 24949.1 25276.9 25381.5 26032.6 26123.1 2158.4 2715.6 2992.6 2995.0 3100.0 8149.6 9746.3 9978.1 10311.3 10454.4 1598.8 1792.9 1853.6 1872.7 1873.2 120578.0 123817.4 125377.0 126223.4 126844.0 10948.8 11380.6 11401.5 11433.1 11601.2 14279.4 14346.4 14440.4 14441.2 14504.3 8361.4 8577.8 8608.4 8742.7 8809.7 8479.4 8558.1 8607.5 8719.9 8762.0 4462.7 4494.7 4563.5 4627.3 4635.4 1896.8 1947.3 1959.0 1963.7 1995.4 890.3 905.4 919.3 989.3 1000.4 20897.8 22113.4 22188.8 22195.6 22211.6 973.9 984.0 1000.0 1035.5 1051.0 11114.5 11557.6 11616.3 11760.7 11789.6 460860.7 473667.5 503861.0 505265.0 599931.0 98180.0 128320.0 130564.0 133181.0 133893.0 948.2 958.5 984.7 991.7 991.9 17129.4 19238.7 19994.6 20080.4 20424.5 22609.8 40103.6 45272.0 54160.2 54376.9 71641.6 74762.6 78005.2 84306.0 86257.6 8125.1 8303.3 8382.4 8392.0 8513.2 10442.9 12624.1 13110.0 13150.7 13260.8 9694.2 9758.8 10411.9 11264.0 11521.8 9403.7 10619.5 10708.5 10744.9 11633.4 11499.0 11501.7 11806.3 11844.5 11950.8 8066.8 8107.1 8380.5 8394.2 8419.6 9135.5 10447.9 11605.9 11647.3 11746.2 14:02:14 INFO - PROCESS | 1657 | 14:02:14 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5628.22 Median:4818.02 stddev:3167.58 (65.7%) stddev-sans-first:3160.63 14:02:14 INFO - PROCESS | 1657 | Values: 1413.3 1536.4 1592.8 1766.3 1903.9 6639.8 7145.9 8444.8 8959.9 8994.1 7549.0 8530.3 8788.3 8799.6 8808.6 2097.6 2287.7 2297.9 2323.7 2329.4 2264.2 2305.7 2329.0 2334.4 2342.2 2301.4 2315.5 2318.3 2336.6 2339.5 2248.1 2291.6 2296.3 2298.6 2298.9 2262.5 2297.9 2311.2 2312.5 2317.3 8645.9 8749.2 8807.3 8891.5 8906.4 5135.6 5305.5 5312.1 5312.2 5328.0 3451.2 3478.9 3583.6 3648.5 3648.6 1041.2 1074.7 1078.8 1091.1 1098.7 11507.0 11634.1 11724.4 11750.8 11757.9 4519.3 4650.3 4757.4 4771.3 4773.2 9842.3 10007.8 10012.3 10035.7 10038.7 5278.1 5299.2 5309.4 5313.7 5322.3 4343.6 4625.7 4772.3 4862.8 4880.4 3863.1 3897.9 3948.3 3971.8 4014.6 1271.8 1280.7 1282.6 1289.9 1294.7 847.9 870.0 906.3 913.9 960.2 5684.5 5787.5 5953.9 6003.0 6117.3 427.5 436.8 439.5 1010.2 1040.0 3859.8 3929.7 4010.6 4042.6 4050.2 10329.6 10540.8 10633.3 10647.8 10658.7 9448.9 10613.0 10618.8 10621.4 10622.9 7518.1 7937.4 7962.2 8217.6 8230.5 4512.0 5706.1 5739.2 5840.1 5947.8 9083.7 9876.0 9881.0 9919.6 9988.6 9929.1 10037.6 10109.2 10151.2 10251.0 6579.9 6928.1 7048.7 7063.5 7165.4 8459.9 8500.4 8500.4 8515.0 8533.0 6866.8 7392.0 7560.9 7625.2 7627.5 5591.7 7230.9 7296.6 7304.9 7318.1 6864.8 7047.4 7049.5 7086.1 7101.5 4932.5 4985.9 4994.2 5027.8 5086.8 4919.7 4943.7 4996.3 5048.3 5196.7 14:02:14 INFO - PROCESS | 1657 | 14:02:14 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4560.33 Median:4937.27 stddev:1403.09 (28.4%) stddev-sans-first:1370.04 14:02:14 INFO - PROCESS | 1657 | Values: 296.2 308.1 314.9 317.8 318.6 4735.6 4991.7 5542.4 5607.6 5642.2 4461.5 4901.6 5598.7 5630.6 5669.5 4321.8 4337.8 4348.5 4355.0 4383.6 3595.9 3838.8 4205.0 4267.3 4297.0 3700.8 4018.5 4283.3 4324.0 4372.9 3709.0 4194.3 4322.4 4331.8 4350.5 3766.6 3779.4 3782.8 3797.3 3815.2 5176.5 5531.4 5556.3 5569.0 5598.9 4188.6 4585.1 4999.6 5024.3 5043.7 5765.8 6008.5 6013.7 6027.8 6064.4 3259.9 3464.3 4136.4 4147.6 4194.5 4926.5 5656.3 5779.8 6359.2 6421.4 3109.0 4135.0 4163.7 4219.4 4243.7 3557.6 3967.7 4289.9 4308.7 4333.9 4169.8 4268.0 4581.5 5024.4 5032.4 4968.4 5973.4 6055.2 6080.8 6088.4 1354.9 1393.4 1461.3 1465.8 1470.6 774.8 780.8 883.8 905.4 908.0 3626.0 4598.3 4661.3 4732.7 4778.6 5271.8 5281.5 5281.6 5285.5 5287.9 4323.9 4330.5 4595.9 4774.5 4790.7 2437.5 2517.8 2736.4 2744.8 2760.8 4511.7 4878.8 5039.7 5248.3 5473.7 4755.8 4873.1 4938.7 5358.4 5360.6 4812.5 4859.7 4942.2 5077.8 5405.9 4641.4 5004.7 5031.4 5249.6 5307.4 4436.5 4871.0 4935.8 5158.0 5227.7 4933.8 5239.7 6188.2 6525.8 6569.0 3437.9 3861.4 3915.2 4083.9 4094.3 5265.4 6090.7 6238.3 6249.2 6257.5 4976.8 5572.2 5726.5 5840.3 5992.6 5351.5 5933.8 5966.3 5988.8 6066.8 5319.3 5328.7 5723.1 5892.2 5940.6 4745.1 5018.6 5438.9 5860.5 5974.6 5084.7 5880.0 5884.9 5904.6 5973.9 14:02:14 INFO - PROCESS | 1657 | 14:02:14 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:24235.70 Median:3743.62 stddev:38673.54 (1033.1%) stddev-sans-first:38741.31 14:02:14 INFO - PROCESS | 1657 | Values: 599.9 734.6 787.4 795.6 808.8 15205.4 15581.6 16038.4 16063.4 16317.1 14586.3 14625.4 14842.2 14867.0 15114.5 684.9 834.7 856.9 858.4 860.3 832.9 835.0 851.7 856.9 862.8 879.7 910.5 912.9 914.4 917.7 864.6 906.8 906.9 907.7 909.2 642.3 671.9 673.1 673.9 678.5 12817.5 15217.5 15279.7 15488.6 15504.9 14706.6 14751.7 14824.8 14875.7 15112.4 11841.1 11941.2 12234.8 12521.0 12537.0 3664.4 3805.0 3818.7 3862.0 3995.3 77307.0 109790.5 111574.0 112441.4 112668.3 10643.0 10885.9 10955.7 10971.8 11034.0 20903.1 21015.9 21016.9 21060.6 21071.0 7867.5 7949.4 8032.6 8057.0 8121.7 4450.2 4468.7 4526.3 4588.3 4595.5 3595.5 3741.6 3745.6 3747.9 3748.5 598.6 625.7 637.5 688.3 696.5 620.6 629.7 638.8 665.6 692.2 9029.7 9531.9 9593.5 9658.7 9938.5 540.4 569.1 630.8 668.2 673.3 4680.4 4723.5 4726.1 4739.7 4744.2 90828.5 127817.0 152649.0 156410.0 160750.0 91357.5 130802.7 142770.3 149836.0 150854.0 69072.9 74078.0 107838.5 111258.0 116661.0 8026.6 8892.6 10033.6 10186.6 10214.5 38278.0 46532.1 59426.7 64131.7 67429.7 96875.0 97471.5 98728.0 100331.5 100660.0 13025.6 13212.0 13243.9 13296.2 13520.3 14777.8 15157.8 15166.7 15223.8 15618.2 11746.0 14062.4 14091.7 14273.0 14300.5 13650.0 13696.9 13867.6 13882.6 13992.3 13534.9 13667.5 13941.9 14225.9 14340.4 9220.4 11307.7 11437.5 11444.4 11872.3 9598.9 11017.6 11448.8 11574.4 11797.9 14:02:14 INFO - PROCESS | 1657 | -------- Summary: end -------- 14:02:14 INFO - PROCESS | 1657 | 14:02:15 INFO - TEST-INFO | 1657: exit 0 14:02:15 INFO - TEST-OK | dromaeo_css | took 1113197ms 14:02:15 INFO - TEST-START | kraken 14:02:15 INFO - operating with platform_type : mac_ 14:02:15 INFO - Initialising browser for kraken test... 14:02:15 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmpBAgGVw/profile http://localhost:49262/getInfo.html) 14:02:18 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 14:02:18 INFO - PROCESS | 1665 | colorDepth:24 14:02:18 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 14:02:18 INFO - PROCESS | 1665 | __metrics 14:02:18 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 14:02:18 INFO - TEST-INFO | 1665: exit 0 14:02:18 INFO - Browser initialized. 14:02:18 INFO - Running cycle 1/1 for kraken test... 14:02:18 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmpBAgGVw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:02:30 INFO - PROCESS | 1667 | RSS: Main: 254885888 14:02:30 INFO - PROCESS | 1667 | 14:02:33 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection) 14:02:34 INFO - PROCESS | 1667 | RSS: Main: 267649024 14:02:34 INFO - PROCESS | 1667 | 14:02:37 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-dft) 14:02:37 INFO - PROCESS | 1667 | RSS: Main: 276410368 14:02:37 INFO - PROCESS | 1667 | 14:02:41 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-fft) 14:02:41 INFO - PROCESS | 1667 | RSS: Main: 279187456 14:02:41 INFO - PROCESS | 1667 | 14:02:43 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator) 14:02:44 INFO - PROCESS | 1667 | RSS: Main: 280457216 14:02:44 INFO - PROCESS | 1667 | 14:02:46 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:02:46 INFO - PROCESS | 1667 | RSS: Main: 281067520 14:02:46 INFO - PROCESS | 1667 | 14:02:49 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom) 14:02:50 INFO - PROCESS | 1667 | RSS: Main: 281219072 14:02:50 INFO - PROCESS | 1667 | 14:02:53 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate) 14:02:54 INFO - PROCESS | 1667 | RSS: Main: 280715264 14:02:54 INFO - PROCESS | 1667 | 14:02:57 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial) 14:02:58 INFO - PROCESS | 1667 | RSS: Main: 282710016 14:02:58 INFO - PROCESS | 1667 | 14:02:59 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:03:00 INFO - PROCESS | 1667 | RSS: Main: 282333184 14:03:00 INFO - PROCESS | 1667 | 14:03:02 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:03:02 INFO - PROCESS | 1667 | RSS: Main: 282460160 14:03:02 INFO - PROCESS | 1667 | 14:03:04 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:03:05 INFO - PROCESS | 1667 | RSS: Main: 282718208 14:03:05 INFO - PROCESS | 1667 | 14:03:08 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:03:09 INFO - PROCESS | 1667 | RSS: Main: 282554368 14:03:09 INFO - PROCESS | 1667 | 14:03:12 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:03:12 INFO - PROCESS | 1667 | RSS: Main: 283111424 14:03:12 INFO - PROCESS | 1667 | 14:03:14 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49262/tests/kraken/driver.html?testName=ai-astar) 14:03:14 INFO - PROCESS | 1667 | RSS: Main: 284114944 14:03:14 INFO - PROCESS | 1667 | 14:03:14 INFO - PROCESS | 1667 | __start_tp_report 14:03:14 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 14:03:14 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 14:03:14 INFO - PROCESS | 1667 | |i|pagename|runs| 14:03:14 INFO - PROCESS | 1667 | |0;ai-astar;104;116;108;119;117;119;114;117;119;117 14:03:14 INFO - PROCESS | 1667 | |1;audio-beat-detection;145;112;135;170;115;133;128;110;156;107 14:03:14 INFO - PROCESS | 1667 | |2;audio-dft;195;203;201;227;201;197;196;210;190;280 14:03:14 INFO - PROCESS | 1667 | |3;audio-fft;68;84;75;136;59;61;60;66;134;60 14:03:14 INFO - PROCESS | 1667 | |4;audio-oscillator;70;72;114;73;71;82;98;101;94;116 14:03:14 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;134;86;89;86;88;86;94;85;89;86 14:03:14 INFO - PROCESS | 1667 | |6;imaging-darkroom;135;148;103;110;154;152;96;95;96;119 14:03:14 INFO - PROCESS | 1667 | |7;imaging-desaturate;93;133;145;125;92;146;145;92;117;101 14:03:14 INFO - PROCESS | 1667 | |8;json-parse-financial;56;56;57;55;56;55;57;57;54;56 14:03:14 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;67;73;71;109;73;85;80;73;75;73 14:03:14 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;88;83;83;86;82;87;83;81;79;85 14:03:14 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;139;137;130;152;153;135;152;157;168;153 14:03:14 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;169;167;166;169;167;167;167;170;165;168 14:03:14 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;68;67;70;68;68;67;68;68;66;66 14:03:14 INFO - PROCESS | 1667 | __end_tp_report 14:03:14 INFO - PROCESS | 1667 | __start_cc_report 14:03:14 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1071 14:03:14 INFO - PROCESS | 1667 | __end_cc_report 14:03:14 INFO - PROCESS | 1667 | __startTimestamp1471035794592__endTimestamp 14:03:14 INFO - PROCESS | 1667 | 14:03:14 INFO - PROCESS | 1667 | ------- Summary: start ------- 14:03:14 INFO - PROCESS | 1667 | Number of tests: 14 14:03:14 INFO - PROCESS | 1667 | 14:03:14 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:115.00 Median:117.00 stddev:5.08 (4.3%) stddev-sans-first:3.49 14:03:14 INFO - PROCESS | 1667 | Values: 104.0 116.0 108.0 119.0 117.0 119.0 114.0 117.0 119.0 117.0 14:03:14 INFO - PROCESS | 1667 | 14:03:14 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:131.10 Median:134.00 stddev:21.09 (15.7%) stddev-sans-first:21.77 14:03:14 INFO - PROCESS | 1667 | Values: 145.0 112.0 135.0 170.0 115.0 133.0 128.0 110.0 156.0 107.0 14:03:14 INFO - PROCESS | 1667 | 14:03:14 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:210.00 Median:202.00 stddev:26.65 (13.2%) stddev-sans-first:27.70 14:03:14 INFO - PROCESS | 1667 | Values: 195.0 203.0 201.0 227.0 201.0 197.0 196.0 210.0 190.0 280.0 14:03:14 INFO - PROCESS | 1667 | 14:03:14 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:80.30 Median:63.50 stddev:29.88 (47.1%) stddev-sans-first:31.36 14:03:14 INFO - PROCESS | 1667 | Values: 68.0 84.0 75.0 136.0 59.0 61.0 60.0 66.0 134.0 60.0 14:03:14 INFO - PROCESS | 1667 | 14:03:14 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:72.50 stddev:17.90 (24.7%) stddev-sans-first:17.60 14:03:14 INFO - PROCESS | 1667 | Values: 70.0 72.0 114.0 73.0 71.0 82.0 98.0 101.0 94.0 116.0 14:03:14 INFO - PROCESS | 1667 | 14:03:14 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:92.30 Median:87.00 stddev:14.89 (17.1%) stddev-sans-first:2.78 14:03:14 INFO - PROCESS | 1667 | Values: 134.0 86.0 89.0 86.0 88.0 86.0 94.0 85.0 89.0 86.0 14:03:14 INFO - PROCESS | 1667 | 14:03:14 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:120.80 Median:153.00 stddev:24.38 (15.9%) stddev-sans-first:25.31 14:03:14 INFO - PROCESS | 1667 | Values: 135.0 148.0 103.0 110.0 154.0 152.0 96.0 95.0 96.0 119.0 14:03:14 INFO - PROCESS | 1667 | 14:03:14 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:118.90 Median:145.50 stddev:23.03 (15.8%) stddev-sans-first:22.44 14:03:14 INFO - PROCESS | 1667 | Values: 93.0 133.0 145.0 125.0 92.0 146.0 145.0 92.0 117.0 101.0 14:03:14 INFO - PROCESS | 1667 | 14:03:14 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:0.99 (1.8%) stddev-sans-first:1.05 14:03:14 INFO - PROCESS | 1667 | Values: 56.0 56.0 57.0 55.0 56.0 55.0 57.0 57.0 54.0 56.0 14:03:14 INFO - PROCESS | 1667 | 14:03:14 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:77.90 Median:73.00 stddev:11.99 (16.4%) stddev-sans-first:12.05 14:03:14 INFO - PROCESS | 1667 | Values: 67.0 73.0 71.0 109.0 73.0 85.0 80.0 73.0 75.0 73.0 14:03:14 INFO - PROCESS | 1667 | 14:03:14 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:2.79 (3.3%) stddev-sans-first:2.49 14:03:14 INFO - PROCESS | 1667 | Values: 88.0 83.0 83.0 86.0 82.0 87.0 83.0 81.0 79.0 85.0 14:03:14 INFO - PROCESS | 1667 | 14:03:14 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:147.60 Median:152.50 stddev:11.82 (7.7%) stddev-sans-first:12.12 14:03:14 INFO - PROCESS | 1667 | Values: 139.0 137.0 130.0 152.0 153.0 135.0 152.0 157.0 168.0 153.0 14:03:14 INFO - PROCESS | 1667 | 14:03:14 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:167.50 stddev:1.51 (0.9%) stddev-sans-first:1.50 14:03:14 INFO - PROCESS | 1667 | Values: 169.0 167.0 166.0 169.0 167.0 167.0 167.0 170.0 165.0 168.0 14:03:14 INFO - PROCESS | 1667 | 14:03:14 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.17 (1.7%) stddev-sans-first:1.24 14:03:14 INFO - PROCESS | 1667 | Values: 68.0 67.0 70.0 68.0 68.0 67.0 68.0 68.0 66.0 66.0 14:03:14 INFO - PROCESS | 1667 | -------- Summary: end -------- 14:03:14 INFO - PROCESS | 1667 | 14:03:15 INFO - TEST-INFO | 1667: exit 0 14:03:15 INFO - TEST-OK | kraken | took 60134ms 14:03:15 INFO - SUITE-END | took 1173s 14:03:15 INFO - Completed test suite (00:19:33) 14:03:15 INFO - javascript benchmark 14:03:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7333.534961280362, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2810.6908240093585, 3447.2416068464927, 3447.741419393545, 3454.136465883529, 3459.394605943959, 4613.884652883676, 4979.875503112424, 5708.628939118959, 5756.913646295309, 5768.625039372449, 5633.8591535211535, 5719.828405147842, 5733.971330143354, 5750.0, 5808.651480911149, 4178.937315940256, 5259.631825772198, 5327.813526526573, 5330.520253177213, 5392.2181283714035, 5109.0, 5152.793888244466, 5265.3681558212875, 5278.788848446057, 5283.181106928432, 5202.661826981234, 5227.3465816772905, 5251.579873610102, 5256.8685782855355, 5290.285811415487, 5221.008008478377, 5233.241180028913, 5242.18746094356, 5254.579633629339, 5273.499017593323, 5078.847634570969, 5186.7147306898105, 5217.060929032773, 5250.18622113573, 5258.579313654936, 4625.838095666635, 5386.622936394454, 5776.104703770922, 5779.104238842986, 5847.941520584783, 6194.628322300677, 6227.09707092469, 6235.469985051231, 6256.280527739277, 6288.968555157241, 6123.83172914054, 6195.876082478325, 6234.438900498977, 6253.656048917308, 6269.3730626937395, 5794.246747922785, 5828.562857785683, 5862.443067908627, 5867.3839246879315, 5900.321463031763, 6205.844853878599, 6206.100115483229, 6267.467265282411, 6267.9373206267355, 6301.306856245809, 6031.185789918392, 6113.23584551931, 6171.321154672983, 6186.257649082139, 6200.3799620037635, 6166.352532983972, 6244.344343843831, 6245.281792593819, 6265.248170219512, 6306.747730090837, 6168.136460895478, 6178.165947597106, 6193.256809182927, 6234.127222188898, 6256.562040657202, 6121.5139442231075, 6180.81457556274, 6217.347178546278, 6245.718942647592, 6252.280987686383, 4976.278439626306, 5030.84907452777, 5032.84901452957, 5045.5459008689395, 5095.745212739348, 4423.668224883147, 4435.733855968588, 4444.066745983315, 4462.040661257845, 4511.300748384006, 5495.203195536625, 5643.01247281724, 5687.232223649837, 5838.0, 5851.882962340729, 6208.534359923024, 6217.564770466114, 6224.221972253468, 6225.937740622627, 6237.625742455467, 5700.942990570041, 5709.942900571024, 5721.914171287434, 5733.226014488074, 5753.88492230153, 5359.705216213146, 5441.700706461183, 5468.48049435303, 5480.150576660624, 5584.692841893653, 5383.515483606494, 6337.746490140343, 6380.361963803675, 6395.232572091379, 6398.520110991694, 6194.039923811816, 6239.7504099837315, 6244.968775156095, 6256.687165641791, 6297.685115744286, 6143.84640383994, 6238.968805155945, 6239.407256310643, 6375.521835862236, 6383.840403989938, 5927.940720592739, 6183.258009038944, 6206.689665516616, 6213.65824879636, 6236.532260080603, 6223.693024464913, 6231.937680623136, 6244.313125556276, 6246.063090536456, 6254.499640028877, 4717.042427392594, 5847.473727364558, 6125.908111378422, 6141.416565426277, 6154.876902462015, 6143.082036032849, 6188.504919606331, 6189.04069869171, 6191.071339299141, 6201.069839524108, 5797.739101740347, 5906.573621079193, 5975.9103613446705, 6018.8796224074395, 6037.547183961308, 6018.187544681412, 6106.755729770759, 6121.879793613328, 6159.353267906985, 6162.414570615784, 5983.521318294613, 5997.190379298739, 6042.425969532887, 6043.697815109315, 6075.27096748393], "value": 5686.5519652944695, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [485.61636307317224, 485.76683192067804, 529.2405398253505, 538.8733647592812, 558.3606770248064, 30283.0, 41014.0, 41133.0, 41136.0, 41225.79387103068, 41561.37657935133, 41801.58198418015, 42027.57972420275, 42133.94665133373, 42152.57847421525, 9447.055294470549, 9597.23222142227, 9625.326227164102, 9642.662506812263, 9645.03549645037, 9499.287553433485, 9523.619055237783, 9628.903710962906, 9640.614375424975, 9645.0, 9604.759881002961, 9666.90333096667, 9670.0, 9696.563654635558, 9713.854292185622, 9659.985701501346, 9675.70972870815, 9679.274054445945, 9691.370060946087, 9693.3699309545, 9540.570674319672, 9565.90434095664, 9585.0, 9604.759881002961, 9606.567704453317, 35614.821925890465, 36044.81977590122, 36117.09707257313, 36173.638263617555, 36458.270834583425, 3363.01383537304, 3448.0690213642174, 3480.930381392358, 3481.89554313371, 3522.6829585337186, 31576.684233157834, 32153.874614388616, 32236.355272894645, 32506.024819255224, 32996.17509562256, 3139.560461535387, 3146.9055928322186, 3150.763692723032, 3165.5251712243116, 3248.4640034394297, 467086.0, 474835.99999999657, 475113.0, 479746.0, 481975.0, 61057.0, 61585.0, 61601.69199153975, 61625.383746162865, 61642.76714465686, 34818.129546761535, 35055.64944350524, 35569.46645800315, 36426.0, 36479.27041459156, 14691.85308146905, 16419.522242997948, 16717.58206044834, 16882.240299186567, 16888.0, 12834.486620535074, 12978.35108244584, 12998.0, 13000.739985200244, 13014.674633134247, 16632.835701501022, 19404.611907761766, 19603.431725461927, 19662.21351145938, 19838.40484785459, 6719.328067193242, 7374.483786135026, 7456.664450099758, 7832.490888092256, 7897.565633890191, 926.379325851681, 996.9501524923725, 1009.545704433008, 1104.9337039777638, 1131.6137731279118, 29786.0, 30158.246043849078, 30445.086647400614, 30466.54300185499, 30915.381692366027, 1007.7128018514835, 1084.902358787697, 1089.1395797320188, 1093.8195197792274, 1114.2367478277406, 15902.7614585779, 15986.414824524882, 16077.196140193177, 16120.919395402949, 16316.918415407847, 509925.0, 595106.0, 609363.0, 616226.0, 617717.9114104401, 41273.0, 41459.0, 41763.7911810439, 42012.789936050125, 42149.94625134335, 1330.767115754739, 1370.7532644124153, 1395.567374114048, 1407.8099456573436, 1428.407211007441, 29356.412871742872, 29849.70150298556, 30281.78803344081, 30481.54277685792, 30563.0, 51816.70458238574, 51887.74056129695, 52009.47990520046, 52108.21837672362, 52265.0, 475167.0, 550273.4972650222, 555096.0, 555395.0, 556010.0, 26693.7330626699, 26898.731012690405, 27077.593836092867, 27128.864355678095, 27411.0, 47594.762026191034, 47635.761821190674, 48664.513354866, 49090.50909490859, 49592.256116157565, 40069.59930400659, 40094.799526002185, 40644.79677601593, 41335.1732965333, 41728.95677608084, 35491.29017419689, 36672.81663591665, 39673.80978570648, 40289.0, 40603.0, 33479.33041339208, 38009.23981520409, 38357.6164238354, 38529.84410467691, 38951.0, 33847.49228761521, 34602.13494662654, 35009.12477188091, 35139.0, 35503.0, 25626.487470250864, 25999.870000649877, 26104.608430873934, 26228.475430491664, 26813.0], "value": 19562.74886009183, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.13573694606833, 376.91330993871406, 387.25260247721894, 389.4722650808153, 406.9226846899089, 14899.925500372483, 19290.807091929077, 22194.66707999377, 22242.0, 22501.762403067823, 18742.71885921709, 20120.295789647327, 21539.56920861582, 21703.565928681415, 21996.560068798655, 5780.583756979546, 5903.970480147594, 6092.390760923917, 6120.785772497963, 6162.352952939944, 6073.089036644495, 6082.574219804594, 6127.264728232618, 6132.264128304588, 6135.32511423743, 5717.714114294289, 5965.731542080617, 6038.305594856603, 6046.365131661179, 6126.479249263818, 5815.47660710536, 5829.5919285650025, 5951.464368206861, 5954.91067633988, 5994.190784244115, 5908.911366329508, 5978.581499295051, 5982.700864956735, 6011.789587364465, 6024.909626355608, 24949.126780562594, 25276.873615631986, 25381.49237015268, 26032.609510857164, 26123.085692000688, 2158.4064382294837, 2715.6198132261497, 2992.595999540056, 2995.0, 3100.0, 8149.592520374017, 9746.31775775696, 9978.101970822589, 10311.329763565343, 10454.372737635766, 1598.768178614106, 1792.8924264544169, 1853.629274145163, 1872.7471791308135, 1873.241337258399, 120578.0, 123817.38091309575, 125377.0, 126223.368883155, 126843.99999999908, 10948.781024379627, 11380.601678941362, 11401.48693308803, 11433.085353171726, 11601.187916845909, 14279.357428915724, 14346.354414051393, 14440.350184241734, 14441.205733684537, 14504.34730437133, 8361.372897032747, 8577.828443431097, 8608.440451370641, 8742.650293988296, 8809.69166079197, 8479.364047696448, 8558.144185581392, 8607.526586037828, 8719.91280087191, 8762.036176020632, 4462.687611867138, 4494.662900282492, 4563.54364563541, 4627.329037289574, 4635.443746750344, 1896.838768704648, 1947.3476385410763, 1958.9510262243557, 1963.6956271777897, 1995.3914056212996, 890.283321925856, 905.3752910491739, 919.3334832246701, 989.2926557511414, 1000.3797645459716, 20897.79102208989, 22113.44716382071, 22188.778112218995, 22195.556088878133, 22211.555768884857, 973.9220862330997, 983.955721992512, 1000.0449570660003, 1035.5443604813859, 1050.99474502627, 11114.499847506882, 11557.595484158182, 11616.303021818718, 11760.705982350339, 11789.587364442203, 460860.6956965261, 473667.52664947195, 503861.0, 505265.0, 599931.0, 98180.0, 128320.0, 130564.0, 133181.0, 133893.0, 948.2177203807025, 958.4728399380313, 984.7045886234101, 991.7371896447303, 991.9057689519484, 17129.400470983455, 19238.711419329, 19994.60010799805, 20080.39758807238, 20424.543351679196, 22609.773902261426, 40103.59896400999, 45272.0, 54160.187597186865, 54376.91246175134, 71641.56716865738, 74762.62618686871, 78005.2199477998, 84306.0, 86257.56871215603, 8125.106238313662, 8303.335733141455, 8382.413231073766, 8392.0, 8513.19124683154, 10442.947785261025, 12624.11631185845, 13110.0, 13150.736985260433, 13260.80108798388, 9694.224462043161, 9758.756031098996, 10411.895881041093, 11264.0, 11521.769564608494, 9403.717888463358, 10619.460178273952, 10708.518116684612, 10744.946275268887, 11633.418329083343, 11499.0, 11501.654950351503, 11806.291622502677, 11844.466998984894, 11950.760984780429, 8066.798330041561, 8107.142148005405, 8380.497170169809, 8394.24451799341, 8419.62111704987, 9135.451872887648, 10447.94776026115, 11605.883941160819, 11647.30116193031, 11746.236494627821], "value": 9632.618839989178, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1413.3216056292981, 1536.4084827341474, 1592.7770112184296, 1766.302310587318, 1903.9333623323168, 6639.834004149899, 7145.892386680073, 8444.831103377928, 8959.865602015974, 8994.055624159459, 7549.018627578421, 8530.317574594033, 8788.25299849512, 8799.560021998906, 8808.647654093844, 2097.5595125023765, 2287.6797248385237, 2297.8621282723007, 2323.6514522821544, 2329.359426157812, 2264.162259963816, 2305.688732021181, 2328.9650655240184, 2334.428065124047, 2342.1802369170823, 2301.4476525633895, 2315.49059206975, 2318.3045086474076, 2336.6027775278244, 2339.4619237575366, 2248.1457046322375, 2291.633338665814, 2296.28815067328, 2298.643710224918, 2298.8620682759006, 2262.5248697773486, 2297.873616951067, 2311.248844125666, 2312.5374925014894, 2317.3395582258977, 8645.913540864574, 8749.168828961303, 8807.2513836324, 8891.4665120093, 8906.376553641248, 5135.563477104451, 5305.469453054702, 5312.07038768214, 5312.2297266896085, 5328.0, 3451.2234747181683, 3478.9478157827652, 3583.5699716033982, 3648.452732090181, 3648.6351364863567, 1041.1930753665895, 1074.736689511067, 1078.757279612081, 1091.1161958813386, 1098.747288123736, 11507.0, 11634.069274458023, 11724.355160466172, 11750.823737643943, 11757.941785239369, 4519.322101684774, 4650.325702773079, 4757.429108507002, 4771.33201351811, 4773.212419950739, 9842.261830362751, 10007.799844003079, 10012.299139060196, 10035.749106272255, 10038.74903127413, 5278.076336641149, 5299.231611416323, 5309.362876454773, 5313.681179129265, 5322.2548843161985, 4343.630791382768, 4625.7455839929125, 4772.308015337757, 4862.82980095702, 4880.41435027799, 3863.1114843586133, 3897.8830635080994, 3948.3287841067086, 3971.7616942983514, 4014.578469260744, 1271.7965125579863, 1280.7118398360294, 1282.608804314693, 1289.864564220762, 1294.7151626642124, 847.9406441549156, 869.9951555952885, 906.2930913887178, 913.9131782480654, 960.1838437328215, 5684.459976302244, 5787.5080618147085, 5953.868764934648, 6003.0, 6117.296510901303, 427.47847625896355, 436.79034063649624, 439.50994640975085, 1010.1867996263079, 1039.9896001040045, 3859.7684138951754, 3929.7247003448133, 4010.596291298081, 4042.595740425934, 4050.1899620075515, 10329.586816527255, 10540.841887371696, 10633.255672103034, 10647.787044259227, 10658.73353166177, 9448.91337496183, 10613.0, 10618.787624247472, 10621.362718236776, 10622.946885265525, 7518.097828260535, 7937.444378893538, 7962.203779621991, 8217.630206640715, 8230.506169629842, 4511.977440112779, 5706.144078388275, 5739.2252045973255, 5840.123981402823, 5947.821565353046, 9083.727488175366, 9876.012398760355, 9880.950595246977, 9919.603215871284, 9988.550515226687, 9929.106380425796, 10037.598496060367, 10109.19126469866, 10151.187904967732, 10251.0, 6579.934200657932, 6928.1339832520935, 7048.718051277891, 7063.540869843444, 7165.3909417698, 8459.915400845914, 8500.404971651926, 8500.404971651926, 8515.02077261123, 8532.957335213285, 6866.828329291808, 7391.9651248826285, 7560.886586701314, 7625.199354067743, 7627.466077374753, 5591.720413979366, 7230.89153662706, 7296.635168241461, 7304.890426643498, 7318.085239345082, 6864.7940561783225, 7047.436205103477, 7049.541779784297, 7086.114235720535, 7101.467389945671, 4932.506749325039, 4985.850424487271, 4994.225894986283, 5027.7737501813235, 5086.796528138833, 4919.680220785637, 4943.678660887031, 4996.325496057985, 5048.293238946477, 5196.688198707939], "value": 4498.3308386464, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.22537065573516, 308.0619513581145, 314.8743242906608, 317.75691595929135, 318.6415282806842, 4735.621150307976, 4991.70049797012, 5542.39033706292, 5607.57943154263, 5642.15367694846, 4461.505395692447, 4901.627544287596, 5598.748056337465, 5630.634008789426, 5669.489745922866, 4321.805518751648, 4337.848175313865, 4348.4999225089205, 4355.0, 4383.649308055364, 3595.8921232363073, 3838.7715930902123, 4205.03284244624, 4267.335739061768, 4296.957030429702, 3700.777953322796, 4018.4976877890263, 4283.293256612656, 4323.983863792007, 4372.89067773305, 3709.017110465729, 4194.266003449415, 4322.438083049199, 4331.8483853065145, 4350.521442641307, 3766.6045065268027, 3779.433085037266, 3782.7541209821275, 3797.2785170817456, 3815.179736356669, 5176.50823171798, 5531.3915469298345, 5556.305461817273, 5569.022996836105, 5598.86002849932, 4188.560201178893, 4585.111379830685, 4999.575036121934, 5024.271480635324, 5043.696378871845, 5765.798197063083, 6008.459238668497, 6013.6993150342305, 6027.849303767397, 6064.423879731418, 3259.885903993349, 3464.3071385722956, 4136.400221967798, 4147.585241475858, 4194.454720886296, 4926.5073492650445, 5656.264685590888, 5779.826605201851, 6359.236891572995, 6421.357864213542, 3108.9844550777552, 4134.958650413518, 4163.7293575918075, 4219.409282700424, 4243.681723870722, 3557.573091229069, 3967.682585393162, 4289.914201715948, 4308.67684923632, 4333.8699839004885, 4169.770662613525, 4268.0, 4581.450225972904, 5024.447310795809, 5032.421271553745, 4968.385274785709, 5973.37279585646, 6055.152278680988, 6080.7871724490315, 6088.381995741874, 1354.9160671462791, 1393.4426229508279, 1461.2766680493012, 1465.7980456026169, 1470.6102882736084, 774.7714424244862, 780.7813812132612, 883.8188171424971, 905.4069584422082, 907.9921287371013, 3625.9637403625625, 4598.26427771555, 4661.294271054519, 4732.692374995614, 4778.617710583215, 5271.78912843482, 5281.524662780368, 5281.630285880028, 5285.515807570436, 5287.894242115213, 4323.919020244939, 4330.501992270866, 4595.908861468024, 4774.498677638798, 4790.688605240648, 2437.526524702292, 2517.7734003939368, 2736.3867506531215, 2744.7804175665897, 2760.7653349465522, 4511.70673906195, 4878.804847806119, 5039.656559699757, 5248.317718696545, 5473.66106674928, 4755.785989630475, 4873.149207713456, 4938.7281850349245, 5358.38309141328, 5360.597955153379, 4812.470628230892, 4859.7402207972755, 4942.220800511813, 5077.796888124433, 5405.945940540544, 4641.419822522184, 5004.674696144739, 5031.433968675929, 5249.580033597379, 5307.41618421981, 4436.48980367249, 4870.975645121752, 4935.8025678972435, 5158.0, 5227.738613069255, 4933.753312334297, 5239.659422137549, 6188.2363526394765, 6525.771597994048, 6568.996456080941, 3437.8998720410227, 3861.4014827701753, 3915.1973845361063, 4083.8774836754947, 4094.2630326541507, 5265.420803711512, 6090.665013424305, 6238.344973777869, 6249.1563638908165, 6257.4994000480765, 4976.751162441791, 5572.192032155233, 5726.541876649775, 5840.328362238227, 5992.584226990573, 5351.474829673524, 5933.821985340447, 5966.254218222723, 5988.760449581968, 6066.848328791815, 5319.25530425733, 5328.733563321741, 5723.084306510938, 5892.232330300807, 5940.584159108821, 4745.1221524018165, 5018.616157325241, 5438.8640283991635, 5860.501857342174, 5974.56462534036, 5084.669496482717, 5880.000399932107, 5884.911726324194, 5904.61619994699, 5973.880522389615], "value": 4117.684849812501, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.8500374906273, 734.5849594978838, 787.4409169489659, 795.6340083561565, 808.7654580171751, 15205.391784328627, 15581.610459738484, 16038.358465661375, 16063.357465701372, 16317.102559359231, 14586.343614537345, 14625.414983400678, 14842.183679897602, 14867.0, 15114.546563603082, 684.8801459744525, 834.7120243516008, 856.9271611912994, 858.3862538285156, 860.2515811244226, 832.9083800781909, 834.9666013359458, 851.6891334662835, 856.8543347630887, 862.762740246431, 879.7009016934242, 910.540177210511, 912.9041450647686, 914.4239129348501, 917.729269865388, 864.6498168241872, 906.768773962642, 906.9410488318272, 907.6687009241646, 909.1590278991972, 642.2613993906998, 671.9496037797136, 673.1383828699272, 673.8685956238536, 678.4911316512615, 12817.487300507968, 15217.467388641455, 15279.694406111927, 15488.612784680361, 15504.922475387664, 14706.55880323592, 14751.704965900622, 14824.777628335583, 14875.70248595022, 15112.39550417982, 11841.108023361247, 11941.223820451643, 12234.81647775284, 12521.0, 12537.0, 3664.3564356435645, 3804.9619503804884, 3818.732688711791, 3862.0, 3995.300822356105, 77307.0, 109790.45104774505, 111573.99999999919, 112441.43779281132, 112668.30997535044, 10643.0, 10885.945570272099, 10955.671329860117, 10971.83542246867, 11034.0, 20903.05936232873, 21015.94920253981, 21016.94915254231, 21060.578788424147, 21071.0, 7867.488613240121, 7949.443538952218, 8032.638531266107, 8056.9928758905135, 8121.675132994614, 4450.1989641864775, 4468.709533880287, 4526.343680166357, 4588.2888152336445, 4595.517470665599, 3595.496630471736, 3741.6258374162912, 3745.606711295329, 3747.9437808432895, 3748.4939533162674, 598.5959477352769, 625.6715224507079, 637.5091179791534, 688.2532452289322, 696.474162007681, 620.5780069552658, 629.7323637454064, 638.8466767975746, 665.6205962601271, 692.1753444762369, 9029.683961061332, 9531.857022144673, 9593.520323983774, 9658.661946831828, 9938.45338506389, 540.3704684043124, 569.137756299207, 630.8391360203119, 668.2348710726192, 673.2997682410337, 4680.3915490985955, 4723.45680246776, 4726.1020406122725, 4739.668223224341, 4744.1934871072, 90828.54585727029, 127817.0, 152649.0, 156410.0, 160750.0, 91357.54321228352, 130802.69197308096, 142770.2861485686, 149836.0, 150854.0, 69072.85562866244, 74078.0, 107838.46080769703, 111258.0, 116661.0, 8026.598670066356, 8892.555372231232, 10033.648822291185, 10186.643467478603, 10214.489275536342, 38278.0, 46532.06935861196, 59426.70286648539, 64131.67934160299, 67429.66285168543, 96875.0312496866, 97471.51264243634, 98728.0, 100331.49834250782, 100659.99340006507, 13025.609231723063, 13212.0, 13243.933780331037, 13296.202227866359, 13520.323983800967, 14777.778333324793, 15157.848421515644, 15166.696666066837, 15223.771643425136, 15618.21908904573, 11746.0, 14062.367193476113, 14091.718165636836, 14273.0, 14300.499482518062, 13650.0, 13696.93151534236, 13867.583972480841, 13882.583522494342, 13992.300384980914, 13534.93232533831, 13667.453301867814, 13941.93029034889, 14225.857741422868, 14340.426382944983, 9220.400673956172, 11307.717307067389, 11437.485313160762, 11444.427778611203, 11872.287662740264, 9598.904010960081, 11017.559297628006, 11448.828267575826, 11574.363410012531, 11797.88202117968], "value": 7836.220968538481, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 108.0, 119.0, 117.0, 119.0, 114.0, 117.0, 119.0, 117.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 112.0, 135.0, 170.0, 115.0, 133.0, 128.0, 110.0, 156.0, 107.0], "value": 131.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 203.0, 201.0, 227.0, 201.0, 197.0, 196.0, 210.0, 190.0, 280.0], "value": 210.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 84.0, 75.0, 136.0, 59.0, 61.0, 60.0, 66.0, 134.0, 60.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 114.0, 73.0, 71.0, 82.0, 98.0, 101.0, 94.0, 116.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 86.0, 89.0, 86.0, 88.0, 86.0, 94.0, 85.0, 89.0, 86.0], "value": 92.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 148.0, 103.0, 110.0, 154.0, 152.0, 96.0, 95.0, 96.0, 119.0], "value": 120.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 133.0, 145.0, 125.0, 92.0, 146.0, 145.0, 92.0, 117.0, 101.0], "value": 118.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 55.0, 56.0, 55.0, 57.0, 57.0, 54.0, 56.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 73.0, 71.0, 109.0, 73.0, 85.0, 80.0, 73.0, 75.0, 73.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 83.0, 83.0, 86.0, 82.0, 87.0, 83.0, 81.0, 79.0, 85.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 130.0, 152.0, 153.0, 135.0, 152.0, 157.0, 168.0, 153.0], "value": 147.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 166.0, 169.0, 167.0, 167.0, 167.0, 170.0, 165.0, 168.0], "value": 167.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 70.0, 68.0, 68.0, 67.0, 68.0, 68.0, 66.0, 66.0], "value": 67.6, "unit": "score"}]}]} 14:03:15 INFO - Return code: 0 14:03:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:03:15 ERROR - # TBPL SUCCESS # 14:03:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:03:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:03:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:03:15 INFO - 2016-08-12 14:03:15.903 screenresolution[1672:12587] starting screenresolution argv=screenresolution get 14:03:15 INFO - 2016-08-12 14:03:15.905 screenresolution[1672:12587] Display 0: 1600x1200x32@60 14:03:15 INFO - 2016-08-12 14:03:15.911 screenresolution[1673:12591] starting screenresolution argv=screenresolution list 14:03:15 INFO - Available Modes on Display 0 14:03:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:03:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:03:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:03:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:03:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:03:16 INFO - Intel Iris: 14:03:16 INFO - Chipset Model: Intel Iris 14:03:16 INFO - Type: GPU 14:03:16 INFO - Bus: Built-In 14:03:16 INFO - VRAM (Dynamic, Max): 1536 MB 14:03:16 INFO - Vendor: Intel (0x8086) 14:03:16 INFO - Device ID: 0x0a2e 14:03:16 INFO - Revision ID: 0x0009 14:03:16 INFO - Displays: 14:03:16 INFO - Display: 14:03:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:03:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:03:16 INFO - Display Serial Number: 1600x1200 60 14:03:16 INFO - Main Display: Yes 14:03:16 INFO - Mirror: Off 14:03:16 INFO - Online: Yes 14:03:16 INFO - Rotation: Supported 14:03:16 INFO - Return code: 0 14:03:16 INFO - Running post-action listener: _resource_record_post_action 14:03:16 INFO - [mozharness: 2016-08-12 21:03:16.147257Z] Finished run-tests step (success) 14:03:16 INFO - Running post-run listener: _resource_record_post_run 14:03:16 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 32230400; Write bytes: 705409024; Read time: 408; Write time: 1835 14:03:16 INFO - TinderboxPrint: CPU usage
54.4% 14:03:16 INFO - TinderboxPrint: I/O read bytes / time
32,230,400 / 408 14:03:16 INFO - TinderboxPrint: I/O write bytes / time
705,409,024 / 1,835 14:03:16 INFO - TinderboxPrint: CPU idle
2,205.0 (45.6%) 14:03:16 INFO - TinderboxPrint: CPU system
975.2 (20.2%) 14:03:16 INFO - TinderboxPrint: CPU user
1,653.4 (34.2%) 14:03:16 INFO - TinderboxPrint: Swap in / out
432,492,544 / 0 14:03:16 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 397496832; Write bytes: 391981056; Read time: 29474; Write time: 687 14:03:16 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 30145536; Write bytes: 297392128; Read time: 331; Write time: 1112 14:03:16 INFO - Running post-run listener: _upload_blobber_files 14:03:16 INFO - Blob upload gear active. 14:03:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:03:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:03:16 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'] 14:03:16 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 14:03:17 INFO - (blobuploader) - INFO - Open directory for files ... 14:03:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:03:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:03:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:03:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:03:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:03:17 INFO - (blobuploader) - INFO - Done attempting. 14:03:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:03:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:03:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:03:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:03:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:03:18 INFO - (blobuploader) - INFO - Done attempting. 14:03:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:03:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:03:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:03:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:03:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:03:21 INFO - (blobuploader) - INFO - Done attempting. 14:03:21 INFO - (blobuploader) - INFO - Iteration through files over. 14:03:21 INFO - Return code: 0 14:03:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:03:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:03:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f6546bdd8a675560f2bede976d952265c7e9229d12bb6a5c371c57a2575f2281354a55b89dfd328f476cb6480ad3182d1e87d4e8601325e341297b69ca2beac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bdef326119e6dc3d7f9e9cd2e9b64d9baae9412899c44f2135e32f8e1b10e2a338990461768572cfe8989c50b70cff24491fd3891ba95ab333dd6d0d80220060", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70db52bf451c9c72b0499209566a6ea8f5f24c2db5e4c0a37e759d528f03e6371971ada4938188c619a1633e671bf52352623a730c8bb1c541f81835e9d38b45"} 14:03:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:03:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:03:21 INFO - Contents: 14:03:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f6546bdd8a675560f2bede976d952265c7e9229d12bb6a5c371c57a2575f2281354a55b89dfd328f476cb6480ad3182d1e87d4e8601325e341297b69ca2beac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bdef326119e6dc3d7f9e9cd2e9b64d9baae9412899c44f2135e32f8e1b10e2a338990461768572cfe8989c50b70cff24491fd3891ba95ab333dd6d0d80220060", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70db52bf451c9c72b0499209566a6ea8f5f24c2db5e4c0a37e759d528f03e6371971ada4938188c619a1633e671bf52352623a730c8bb1c541f81835e9d38b45"} 14:03:21 INFO - Running post-run listener: copy_logs_to_upload_dir 14:03:21 INFO - Copying logs to upload dir... 14:03:21 INFO - mkdir: /builds/slave/test/build/upload/logs 14:03:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.678175 ========= master_lag: 11.41 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-12 14:03:32.607689) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 14:03:32.610896) ========= 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.84SBteCqMa/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.4QUhpt1JJ2/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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/9f6546bdd8a675560f2bede976d952265c7e9229d12bb6a5c371c57a2575f2281354a55b89dfd328f476cb6480ad3182d1e87d4e8601325e341297b69ca2beac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bdef326119e6dc3d7f9e9cd2e9b64d9baae9412899c44f2135e32f8e1b10e2a338990461768572cfe8989c50b70cff24491fd3891ba95ab333dd6d0d80220060", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70db52bf451c9c72b0499209566a6ea8f5f24c2db5e4c0a37e759d528f03e6371971ada4938188c619a1633e671bf52352623a730c8bb1c541f81835e9d38b45"} build_url:https://queue.taskcluster.net/v1/task/Q4ORzEAdRiSfbu8d2WjiLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011325 build_url: 'https://queue.taskcluster.net/v1/task/Q4ORzEAdRiSfbu8d2WjiLQ/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/9f6546bdd8a675560f2bede976d952265c7e9229d12bb6a5c371c57a2575f2281354a55b89dfd328f476cb6480ad3182d1e87d4e8601325e341297b69ca2beac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bdef326119e6dc3d7f9e9cd2e9b64d9baae9412899c44f2135e32f8e1b10e2a338990461768572cfe8989c50b70cff24491fd3891ba95ab333dd6d0d80220060", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70db52bf451c9c72b0499209566a6ea8f5f24c2db5e4c0a37e759d528f03e6371971ada4938188c619a1633e671bf52352623a730c8bb1c541f81835e9d38b45"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 14:03:32.661048) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 14:03:32.661413) ========= 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.84SBteCqMa/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.4QUhpt1JJ2/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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.005203 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 14:03:32.710245) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 14:03:32.710588) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 14:03:32.710912) ========= ========= Total master_lag: 11.59 =========